[jim_julian_MW]

The problem started back in May. My PowerBook (1.67Ghz) running 10.3.9 was hanging up on start. As usual, I got some good comments from the forum but we did not really solve the issue.
Now the problem is very frequent. Frequently when I start or restart the system hangs, usually at the grey screen spinning wheel. (This is guarenteed if I have repared permissions with Cocktail, see below)
There are two solutions to get started:
1. Start in single user mode, mount the disk from ther, then use reboot command. (This only works sometimes)
2. Boot from 10.3 install disk, repair permissions with disk utility, reboot. (This always works ... so far)
Also I find that running the most current Cocktail for 10.3 in repair permissions does not fix the problem, in fact it guarentees a hang. Only repairing permissions with Disk Utility does the trick.
Even when startup is OK there is a consistent permissions problem. Here are the Disk Utility repair permissions results from three consecutive successful restarts:
Repairing permissions for Computer
Determining correct file permissions.
We are using special permissions for the file or directory ./Library/ColorSync/Profiles/Displays. New permissions are 16893
We are using special permissions for the file or directory ./Library/ColorSync/Profiles. New permissions are 16893
We are using special permissions for the file or directory ./System/Library/Filesystems/cd9660.fs/cd9660.util. New permissions are 33261
We are using a special uid for the file or directory ./private/var/at/jobs. New uid is 1
User differs on ./private/var/at/jobs, should be 1, owner is 0
Owner and group corrected on ./private/var/at/jobs
Permissions corrected on ./private/var/at/jobs
We are using a special uid for the file or directory ./private/var/at/spool. New uid is 1
User differs on ./private/var/at/spool, should be 1, owner is 0
Owner and group corrected on ./private/var/at/spool
Permissions corrected on ./private/var/at/spool
Permissions differ on ./private/var/log/install.log, should be -rw-r--r-- , they are -rw-r-----
Owner and group corrected on ./private/var/log/install.log
Permissions corrected on ./private/var/log/install.log
The privileges have been verified or repaired on the selected volume
Permissions repair complete
----Restart (3 minutes)------
Repairing permissions for Computer
Determining correct file permissions.
We are using special permissions for the file or directory ./Library/ColorSync/Profiles/Displays. New permissions are 16893
We are using special permissions for the file or directory ./Library/ColorSync/Profiles. New permissions are 16893
We are using special permissions for the file or directory ./System/Library/Filesystems/cd9660.fs/cd9660.util. New permissions are 33261
We are using a special uid for the file or directory ./private/var/at/jobs. New uid is 1
We are using a special uid for the file or directory ./private/var/at/spool. New uid is 1
The privileges have been verified or repaired on the selected volume
Permissions repair complete
-----Shut Down & Start (5 minutes)------
Repairing permissions for Computer
Determining correct file permissions.
We are using special permissions for the file or directory ./Library/ColorSync/Profiles/Displays. New permissions are 16893
We are using special permissions for the file or directory ./Library/ColorSync/Profiles. New permissions are 16893
We are using special permissions for the file or directory ./System/Library/Filesystems/cd9660.fs/cd9660.util. New permissions are 33261
We are using a special uid for the file or directory ./private/var/at/jobs. New uid is 1
We are using a special uid for the file or directory ./private/var/at/spool. New uid is 1
The privileges have been verified or repaired on the selected volume
Permissions repair complete
---------------------
As can be seen, there seems to be a consistent problem with the following files:
./Library/ColorSync/Profiles/Displays
./System/Library/Filesystems/cd9660.fs/cd9660.util
./private/var/at/jobs
./private/var/at/spool
Also note the excessive startup times (3-5 minutes)
Any suggestions on how to attack this problem?

[macworldguy]

Perhaps it's a fuzzed directory.
Get yourself DiskWarrior from Alsoft before you get to a point where you won't be able to launch that drive.
DiskWarrior is worth every penny.
It saves me all the time especially after a horrendous crash. Just this morning I had one of drives "disappear". Apple'sDiskUtility "saw" the drive but could not do anything. DiskWarrior "saw" the drive and repaired/replaced the directory and brought it back to the desktop.
Incidently in the problem I had TechToolPro 4.04 was useless. I't could not even "see" the drive.
Cocktail is just doing what Apple'sDiskUtility's repair permissions.
Well that's my suggestion to you jim.

[d00d]

I don't think that's a permissions issue. Those messages are all normal for Panther as I remember it (most of them were special permissions that were added in to address some security issues).

[mr.steevo]

Hi,
I have the same list of permission repairs with no start up lag.
I am curious, what happens if you restart your system holding down the Shift key?
Also, are you using a wireless conection?
s.

[jim_julian_MW]

Any thoughts on what the issue might be d00d?

[jim_julian_MW]

Steve
When I hold down the S key it starts in Safe Boot. I haven't tried that in response to a hang ... but I will.
I'm connected to a large LAN at work and wireless with Airport Extreme at home. The behavior seems to be independent of the connection.

[jim_julian_MW]

Macworldguy .... I hate to shell out $80 if it's not a directory problem.
Does anyone else see this as a directory problem?
And related, if it's not a permissions problem then why does repairing permissions with Disk Utility always provide at least a temporary fix?
A point to ponder ... if Cocktail just executes Apple's repair permissions then why does repairing permissions with Cocktail result in a hang on the next boot and repairing with Disk Utility does not?

[d00d]

I'd take a look in the system and console logs. You can look at it using Console (in Utilities). See if there are any unusual error messages.

[jim_julian_MW]

d00d ... OK, Console log looked OK, only issue was mapping flash player plugin to Firefox.
The system log is full of info to include the:
localhost kernel: CSRHIDTransitionDriver::start after command - e00002ed
issue we saw in May.
Here is the log for one start cycle:
Jul 8 05:43:27 localhost syslogd: restart
Jul 8 05:43:27 localhost syslogd: kernel boot file is /machkernel
Jul 8 05:43:27 localhost kernel: standard timeslicing quantum is 10000 us
Jul 8 05:43:27 localhost kernel: vmpagebootstrap: 508857 free pages
Jul 8 05:43:27 localhost kernel: migtablemaxdispl = 68
Jul 8 05:43:27 localhost kernel: IOKit Component Version 7.9:
Jul 8 05:43:27 localhost kernel: Wed Mar 30 20:07:52 PST 2005; root(rcbuilder):RELEASEPPC/iokit/RELEASE
Jul 8 05:43:27 localhost kernel: 101 prelinked modules
Jul 8 05:43:27 localhost kernel: Copyright © 1982, 1986, 1989, 1991, 1993
Jul 8 05:43:27 localhost kernel: The Regents of the University of California. All rights reserved.
Jul 8 05:43:27 localhost kernel:
Jul 8 05:43:27 localhost kernel: using 5242 buffer headers and 4096 cluster IO buffer headers
Jul 8 05:43:27 localhost kernel: IOPCCard info: Mac OS X PCMCIA Card Services 3.1.22
Jul 8 05:43:27 localhost kernel: IOPCCard info: options: [pci] [cardbus] [pnp]
Jul 8 05:43:27 localhost kernel: IOPCCard info: Intel PCIC probe:
Jul 8 05:43:27 localhost kernel: IOPCCard info: TI 1510 rev 00 PCI-to-CardBus phys mem 0xa0004000 virt mem 0x2f0e0000
Jul 8 05:43:27 localhost kernel: IOPCCard info: host opts [0]: [pci only] [pci irq 255] [lat 16/32] [bus 1/1]
Jul 8 05:43:27 localhost kernel: IOPCCard info: PCI card interrupts, PCI status changes
Jul 8 05:43:27 localhost kernel: Local FireWire GUID = 0x1124ff:0xfe3622f0
Jul 8 05:43:27 localhost kernel: CSRHIDTransitionDriver::probe
Jul 8 05:43:27 localhost kernel: CSRHIDTransitionDriver::start before command
Jul 8 05:43:27 localhost kernel: CSRHIDTransitionDriver::start kIOUSBPipeStalled = e000404f
Jul 8 05:43:27 localhost kernel: Security auditing service present
Jul 8 05:43:27 localhost kernel: BSM auditing present
Jul 8 05:43:27 localhost kernel: From path: "/pci@f4000000/ata-6@D/@0:3,machkernel", Waiting on <dict ID="0"><key>IOPathMatch</key><string ID="1">IODeviceTree:/pci@f4000000/ata-6@D/@0:3</string></dict>
Jul 8 05:43:27 localhost kernel: Got boot device = IOService:/MacRISC2PE/pci@f4000000/AppleMacRiscPCI/ata-6@D/AppleKauaiATA/ATADeviceNub@0/IOATABlockStorageDriver/IOATABlockStorageDevice/IOBlockStorageDriver/ST9100823A Media/IOApplePartitionScheme/Untitled@3
Jul 8 05:43:27 localhost kernel: BSD root: disk0s3, major 14, minor 2
Jul 8 05:43:27 localhost kernel: CSRHIDTransitionDriver::start after command - e00002ed
Jul 8 05:43:27 localhost last message repeated 5 times
Jul 8 05:43:28 localhost kernel: Jettisoning kernel linker.
Jul 8 05:43:28 localhost kernel: Resetting IOCatalogue.
Jul 8 05:43:28 localhost kextd[84]: registering service "com.apple.KernelExtensionServer"
Jul 8 05:43:32 localhost kernel: Matching service count = 0
Jul 8 05:43:34 localhost kernel: [HCIController][start]
Jul 8 05:43:34 localhost kernel: AppleRS232Serial: 0 0 AppleRS232Serial::start - returning false early, Connector or machine incorrect
Jul 8 05:43:35 localhost kernel: AirPort: allocated 64 clusters
Jul 8 05:43:35 localhost kernel: [AppleUSBHCIController][StopIsochPipeRead] - mInt1IsochInPipe = 0 - numReadsPending = 0
Jul 8 05:43:35 localhost kernel: [HCIController][configurePM] ignore = 1
Jul 8 05:43:35 localhost kernel: [HCIController][setPowerState] 1 (ignore=1)
Jul 8 05:43:35 localhost kernel: [HCIController][configurePM] changePowerStateTo(0)
Jul 8 05:43:35 localhost kernel: [HCIController][setPowerState] 0 (ignore=1)
Jul 8 05:43:37 localhost kernel: [HCIController][configurePM] ignore = 0
Jul 8 05:43:37 localhost kernel: [CSRHCIController][start] 1
Jul 8 05:43:41 localhost lookupd[93]: lookupd (version 324.13) starting - Fri Jul 8 05:43:41 2005
Jul 8 05:43:41 localhost kernel: UniNEnet: Ethernet address 00:11:24:36:22:f0
Jul 8 05:43:42 localhost kernel: AirPortPCI: Ethernet address 00:11:24:8d:98:a7
Jul 8 05:43:42 localhost kernel: IOFireWireIP: FireWire address 00:11:24:ff:fe:36:22:f0
Jul 8 05:44:51 localhost diskarbitrationd[87]: disk0s3 hfs 652EEEFD-384F-38EB-91E6-B4A7A9D5CC82 Computer /
Jul 8 05:44:52 localhost SystemStarter: Welcome to Macintosh.
Jul 8 05:44:57 localhost ConsoleMessage: Loading Little Snitch
Jul 8 05:44:57 localhost ConsoleMessage: Starting SecurityServer
Jul 8 05:44:57 localhost ConsoleMessage: Starting Apple Multicast DNS Responder
Jul 8 05:44:57 localhost ConsoleMessage: Starting kernel event agent
Jul 8 05:44:57 localhost ConsoleMessage: Starting timed execution services
Jul 8 05:44:58 localhost SystemStarter: Loading Little Snitch
Jul 8 05:44:58 localhost SystemStarter: Starting SecurityServer
Jul 8 05:44:58 localhost ConsoleMessage: Initializing network
Jul 8 05:44:58 localhost SystemStarter: Starting Apple Multicast DNS Responder
Jul 8 05:44:58 localhost SystemStarter: Starting kernel event agent
Jul 8 05:44:58 localhost SystemStarter: Starting timed execution services
Jul 8 05:44:59 localhost SystemStarter: Initializing network
Jul 8 05:44:59 localhost mDNSResponder[163]: mDNSResponder-58.8.1 (Jan 31 2005 21:11:41) starting
Jul 8 05:44:59 localhost mDNSResponder[163]: SetupAddr invalid safamily 0
Jul 8 05:45:00 localhost mDNSResponder[163]: mDNSPlatformSendUDP sendto failed to send packet on InterfaceID 01806200 lo0/4 to 224.0.0.251:5353 skt 4 error -1 errno 65 (No route to host)
Jul 8 05:45:00 localhost mDNSResponder[163]: mDNSPlatformSendUDP sendto failed to send packet on InterfaceID 01806200 lo0/4 to 224.0.0.251:5353 skt 4 error -1 errno 65 (No route to host)
Jul 8 05:45:00 localhost mDNSResponder[163]: mDNSPlatformSendUDP sendto failed to send packet on InterfaceID 01806200 lo0/4 to 224.0.0.251:5353 skt 4 error -1 errno 65 (No route to host)
Jul 8 05:45:00 localhost mDNSResponder[163]: mDNSPlatformSendUDP sendto failed to send packet on InterfaceID 01806200 lo0/4 to 224.0.0.251:5353 skt 4 error -1 errno 65 (No route to host)
Jul 8 05:45:01 localhost mDNSResponder[163]: mDNSPlatformSendUDP sendto failed to send packet on InterfaceID 01806200 lo0/4 to 224.0.0.251:5353 skt 4 error -1 errno 65 (No route to host)
Jul 8 05:45:03 localhost mDNSResponder[163]: mDNSPlatformSendUDP sendto failed to send packet on InterfaceID 01806200 lo0/4 to 224.0.0.251:5353 skt 4 error -1 errno 65 (No route to host)
Jul 8 05:45:07 localhost mDNSResponder[163]: mDNSPlatformSendUDP sendto failed to send packet on InterfaceID 01806200 lo0/4 to 224.0.0.251:5353 skt 4 error -1 errno 65 (No route to host)
Jul 8 05:45:11 localhost mDNSResponder[163]: mDNSPlatformSendUDP sendto failed to send packet on InterfaceID 01806200 lo0/4 to 224.0.0.251:5353 skt 4 error -1 errno 65 (No route to host)
Jul 8 05:45:12 localhost mDNSResponder[163]: mDNSPlatformSendUDP sendto failed to send packet on InterfaceID 01806200 lo0/4 to 224.0.0.251:5353 skt 4 error -1 errno 65 (No route to host)
Jul 8 05:45:12 localhost mDNSResponder[163]: mDNSPlatformSendUDP sendto failed to send packet on InterfaceID 01806200 lo0/4 to 224.0.0.251:5353 skt 4 error -1 errno 65 (No route to host)
Jul 8 05:45:12 localhost mDNSResponder[163]: mDNSPlatformSendUDP sendto failed to send packet on InterfaceID 01806200 lo0/4 to 224.0.0.251:5353 skt 4 error -1 errno 65 (No route to host)
Jul 8 05:45:13 localhost mDNSResponder[163]: mDNSPlatformSendUDP sendto failed to send packet on InterfaceID 01806200 lo0/4 to 224.0.0.251:5353 skt 4 error -1 errno 65 (No route to host)
Jul 8 05:45:15 localhost mDNSResponder[163]: mDNSPlatformSendUDP sendto failed to send packet on InterfaceID 01806200 lo0/4 to 224.0.0.251:5353 skt 4 error -1 errno 65 (No route to host)
Jul 8 05:45:27 localhost configd[86]: executing /System/Library/SystemConfiguration/Kicker.bundle/Contents/Resources/set-hostname
Jul 8 05:45:29 localhost set-hostname[186]: setting hostname to Prime-II.local
Jul 8 05:45:40 localhost kernel: ATY,JasperA: vram [b8000000:08000000]
Jul 8 05:45:40 localhost kernel: ATY,JasperB: vram [b8000000:08000000]
Jul 8 05:45:51 localhost SystemStarter: (ipc/rcv) timed out : Cannot connect to Window Server; log out or reboot needed
Jul 8 05:46:15 localhost SystemStarter: The "HasShadow" window property is obsolete. Use CGSSetWindowShadowAndRimParameters(cid, wid, 0.0,0.0, 0,0, CGSNoShadowStyle) to turn off the window shadow instead. Set a break-point on CGSLogMessage to find out where this property is set.
Jul 8 05:46:54 localhost ConsoleMessage: Checking disks
Jul 8 05:46:54 localhost ConsoleMessage: Loading Shared IP extension
Jul 8 05:46:55 localhost ConsoleMessage: Starting Apple File Service
Jul 8 05:46:55 localhost ConsoleMessage: Starting printing services
Jul 8 05:46:55 localhost syslogd: /dev/console: Input/output error
Jul 8 05:46:55 localhost init: kernel security level changed from 0 to 1
Jul 8 05:46:55 localhost ConsoleMessage: Loading IP Firewall extension
Jul 8 05:46:57 localhost kernel: IP packet filtering initialized, divert enabled, rule-based forwarding enabled, default to accept, logging disabled
Jul 8 05:46:57 localhost kernel: IPv6 packet filtering initialized, default to accept, logging disabled
Jul 8 05:46:57 localhost kernel: IP firewall loaded
Jul 8 05:46:57 localhost ConsoleMessage: Starting internet services
Jul 8 05:46:57 localhost /usr/sbin/AppleFileServer: Sent launch request message to DirectoryService machinit port
Jul 8 05:47:00 localhost DirectoryService[246]: Launched version 1.8.3 (v258)
Jul 8 05:47:03 localhost kernel: [HCIController][RequestPowerStateChange] 0->1
Jul 8 05:47:03 localhost kernel: [HCIController][RequestPowerStateChange] sleep is available
Jul 8 05:47:03 localhost kernel: [HCIController][RequestPowerStateChange] sleep is not enabled
Jul 8 05:47:03 localhost kernel: [HCIController][RequestPowerStateChange] Calling changePowerStateTo(1)
Jul 8 05:47:03 localhost kernel: [HCIController][setPowerState] 1 (ignore=0)
Jul 8 05:47:03 localhost kernel: [HCIController][setPowerStateWL] 1
Jul 8 05:47:03 localhost kernel: [HCIController][RequestPowerStateChange] changePowerStateTo() returned 0x0
Jul 8 05:47:03 localhost kernel: [HCIController][RequestPowerStateChange] changePowerStateTo(1) returned 0x0
Jul 8 05:47:03 localhost kernel: [HCIController][PerformPowerStateChange] 0->1
Jul 8 05:47:03 localhost kernel: [HCIController][CompletePowerStateChange]
Jul 8 05:47:03 localhost kernel: [HCIController][setupHardware] AFH Is Supported
Jul 8 05:47:03 localhost /usr/sbin/AppleFileServer: Error with bootstraplookup on server port after 10 tries: APIFramework/CClientEndPoint.cpp at: 247: Msg (1102) = unknown error code
Jul 8 05:47:04 localhost /usr/sbin/AppleFileServer: Sent launch request message to DirectoryService mach_init port
Jul 8 05:47:05 localhost xinetd[247]: xinetd Version 2.3.11 started with libwrap options compiled in.
Jul 8 05:47:05 localhost xinetd[247]: Started working: 2 available services
Jul 8 05:47:51 localhost SystemStarter: Waiting for Printing Services
Jul 8 05:47:54 localhost SystemStarter: Waiting for Printing Services
Jul 8 05:47:55 localhost SystemStarter: Startup complete.
Is this:
Jul 8 05:45:51 localhost SystemStarter: (ipc/rcv) timed out : Cannot connect to Window Server; log out or reboot needed
Jul 8 05:46:15 localhost SystemStarter: The "HasShadow" window property is obsolete. Use CGSSetWindowShadowAndRimParameters(cid, wid, 0.0,0.0, 0,0, CGSNoShadowStyle) to turn off the window shadow instead. Set a break-point on CGSLogMessage to find out where this property is set.
a big problem??

[macworldguy]

True!

Reading some of the other posts here have you set up CockTail to flush out everything.
Sorry I'm not at my mac computer now and just flying by what this old brain can remember:
I use the "Pilot" in Cocktail and tick everything that's available to me and set CockTail's auto"PILOT" to do a restart and hit RUN. On my 8600 it takes a loooong time and on my QuickSilver it goes in less then 5 minuets.
I would try that since you already have Cocktail.

[macworldguy]

Just a thought:
After you do the Apple'sDiskUtility repair do you do a restart?
I read somewhere in cyberspace that it's the thing to do.
When I do the "repair" from within my boot volume I run it twice in a row and then do a restart.
I've yet to figure out "how come" that second one comes up with more repairs. It's as if all was not fixed or something is really wonkey. When that happens I give up and boot into DiskWarrior and sure enough there were problems beyond what Apple could fix.

[jim_julian_MW]

MacWorldGuy
Yes I used to use Cocktail much as you describe. I have now deselected repair permissions under Pilot because every time I use Cocktail (as opposed to Disk Utility) to repair permissions the machine will hang on the next start.
No I've not repaired permissions twice in a row. I'll try that to see if there are problems the second time.
Sometimes I've rebooted right after repair and sometimes not, no differences subsequently noticed.

[d00d]

Now, when you say hang, does it eventually boot, or does all movement stop, or does the swirly thing keep going?

[jim_julian_MW]

Derik
In the "hang" state it remains on the grey screen with the wheel going round ... apparently forever. Thanks for your continued interest in driving this one to conclusion.