2011-02-24

青い画面で時間がかかり Mac がなかなか起動しない

Mac (1.83GHz Mac mini (MB138J/A)) の起動に時間がかかるようになった.起動音,中央に Apple マークの灰色の画面のあと,青い画面の中央にスピナが出るのだが,このスピナが回ったまま数分待たされる.

/var/log/system.log を見たところ,次のように Found a transaction past the completion deadline on bus 0xfd, timing out! (Addr: 5, EP: 3) で時間がかかっていた.

Feb 24 22:41:17 hostname configd[37]: setting hostname to "hostname"
Feb 24 22:41:21 hostname kernel[0]: USBF:     24.325  AppleUSBEHCI[0x2bfb800]::Found a transaction past the completion deadline on bus 0xfd, timing out! (Addr: 5, EP: 3)
Feb 24 22:41:21 hostname configd[37]: AppleTalk startup complete
Feb 24 22:41:33 hostname kernel[0]: USBF:     35.325  AppleUSBEHCI[0x2bfb800]::Found a transaction past the completion deadline on bus 0xfd, timing out! (Addr: 5, EP: 3)
Feb 24 22:41:42 hostname kextd[10]: IOKitWaitQuiet() timed out waiting to write kernel symbols
Feb 24 22:41:44 hostname kernel[0]: USBF:     46.325  AppleUSBEHCI[0x2bfb800]::Found a transaction past the completion deadline on bus 0xfd, timing out! (Addr: 5, EP: 3)
Feb 24 22:41:52 hostname kextd[10]: writing kernel link data to /var/run/mach.sym
Feb 24 22:41:55 hostname kernel[0]: USBF:     57.326  AppleUSBEHCI[0x2bfb800]::Found a transaction past the completion deadline on bus 0xfd, timing out! (Addr: 5, EP: 3)
Feb 24 22:42:06 hostname kernel[0]: USBF:     68.326  AppleUSBEHCI[0x2bfb800]::Found a transaction past the completion deadline on bus 0xfd, timing out! (Addr: 5, EP: 3)
Feb 24 22:42:10 hostname configd[37]: InterfaceNamer: timed out waiting for IOKit to quiesce
Feb 24 22:42:10 hostname configd[37]: InterfaceNamer: Busy services :
Feb 24 22:42:10 hostname configd[37]: InterfaceNamer:   Macmini2,1 [1]
Feb 24 22:42:10 hostname configd[37]: InterfaceNamer:   Macmini2,1/AppleACPIPlatformExpert [1]
Feb 24 22:42:10 hostname configd[37]: InterfaceNamer:   Macmini2,1/AppleACPIPlatformExpert/PCI0@0 [1]
Feb 24 22:42:10 hostname configd[37]: InterfaceNamer:   Macmini2,1/AppleACPIPlatformExpert/PCI0@0/AppleACPIPCI [1]
Feb 24 22:42:10 hostname configd[37]: InterfaceNamer:   Macmini2,1/AppleACPIPlatformExpert/PCI0@0/AppleACPIPCI/USB7@1D,7 [1]
Feb 24 22:42:10 hostname configd[37]: InterfaceNamer:   Macmini2,1/AppleACPIPlatformExpert/PCI0@0/AppleACPIPCI/USB7@1D,7/AppleUSBEHCI [1]
Feb 24 22:42:10 hostname configd[37]: InterfaceNamer:   Macmini2,1/AppleACPIPlatformExpert/PCI0@0/AppleACPIPCI/USB7@1D,7/AppleUSBEHCI/iPod@fd630000 [2]
Feb 24 22:42:10 hostname configd[37]: InterfaceNamer:   Macmini2,1/AppleACPIPlatformExpert/PCI0@0/AppleACPIPCI/USB7@1D,7/AppleUSBEHCI/iPod@fd630000/IOUSBInterface@0 [1]
Feb 24 22:42:10 hostname configd[37]: InterfaceNamer:   Macmini2,1/AppleACPIPlatformExpert/PCI0@0/AppleACPIPCI/USB7@1D,7/AppleUSBEHCI/iPod@fd630000/IOUSBInterface@0/IOUSBMassStorageClass [1]
Feb 24 22:42:14 hostname kernel[0]: display: Not usable
Feb 24 22:42:17 hostname kernel[0]: USBF:     79.327  AppleUSBEHCI[0x2bfb800]::Found a transaction past the completion deadline on bus 0xfd, timing out! (Addr: 5, EP: 3)
Feb 24 22:42:29 hostname kernel[0]: USBF:     91.327  AppleUSBEHCI[0x2bfb800]::Found a transaction past the completion deadline on bus 0xfd, timing out! (Addr: 5, EP: 3)
Feb 24 22:42:40 hostname kernel[0]: USBF:     102.328 AppleUSBEHCI[0x2bfb800]::Found a transaction past the completion deadline on bus 0xfd, timing out! (Addr: 5, EP: 3)
Feb 24 22:42:52 hostname kernel[0]: USBF:     114.328 AppleUSBEHCI[0x2bfb800]::Found a transaction past the completion deadline on bus 0xfd, timing out! (Addr: 5, EP: 3)
Feb 24 22:43:03 hostname kernel[0]: USBF:     125.328 AppleUSBEHCI[0x2bfb800]::Found a transaction past the completion deadline on bus 0xfd, timing out! (Addr: 5, EP: 3)
Feb 24 22:43:15 hostname kernel[0]: USBF:     137.329 AppleUSBEHCI[0x2bfb800]::Found a transaction past the completion deadline on bus 0xfd, timing out! (Addr: 5, EP: 3)
Feb 24 22:43:26 hostname kernel[0]: USBF:     148.329 AppleUSBEHCI[0x2bfb800]::Found a transaction past the completion deadline on bus 0xfd, timing out! (Addr: 5, EP: 3)
Feb 24 22:43:38 hostname kernel[0]: USBF:     160.330 AppleUSBEHCI[0x2bfb800]::Found a transaction past the completion deadline on bus 0xfd, timing out! (Addr: 5, EP: 3)
Feb 24 22:43:49 hostname kernel[0]: USBF:     171.330 AppleUSBEHCI[0x2bfb800]::Found a transaction past the completion deadline on bus 0xfd, timing out! (Addr: 5, EP: 3)
Feb 24 22:44:01 hostname kernel[0]: USBF:     183.331 AppleUSBEHCI[0x2bfb800]::Found a transaction past the completion deadline on bus 0xfd, timing out! (Addr: 5, EP: 3)
Feb 24 22:44:12 hostname kernel[0]: USBF:     194.331 AppleUSBEHCI[0x2bfb800]::Found a transaction past the completion deadline on bus 0xfd, timing out! (Addr: 5, EP: 3)
Feb 24 22:44:24 hostname kernel[0]: USBF:     206.331 AppleUSBEHCI[0x2bfb800]::Found a transaction past the completion deadline on bus 0xfd, timing out! (Addr: 5, EP: 3)
Feb 24 22:44:35 hostname kernel[0]: USBF:     217.332 AppleUSBEHCI[0x2bfb800]::Found a transaction past the completion deadline on bus 0xfd, timing out! (Addr: 5, EP: 3)
Feb 24 22:44:47 hostname kernel[0]: USBF:     229.332 AppleUSBEHCI[0x2bfb800]::Found a transaction past the completion deadline on bus 0xfd, timing out! (Addr: 5, EP: 3)
Feb 24 22:44:58 hostname kernel[0]: USBF:     240.333 AppleUSBEHCI[0x2bfb800]::Found a transaction past the completion deadline on bus 0xfd, timing out! (Addr: 5, EP: 3)
Feb 24 22:45:10 hostname kernel[0]: USBF:     252.333 AppleUSBEHCI[0x2bfb800]::Found a transaction past the completion deadline on bus 0xfd, timing out! (Addr: 5, EP: 3)
Feb 24 22:45:21 hostname kernel[0]: USBF:     263.333 AppleUSBEHCI[0x2bfb800]::Found a transaction past the completion deadline on bus 0xfd, timing out! (Addr: 5, EP: 3)
Feb 24 22:45:32 hostname kernel[0]: USBF:     274.334 AppleUSBEHCI[0x2bfb800]::Found a transaction past the completion deadline on bus 0xfd, timing out! (Addr: 5, EP: 3)
Feb 24 22:45:43 hostname kernel[0]: USBF:     285.334 AppleUSBEHCI[0x2bfb800]::Found a transaction past the completion deadline on bus 0xfd, timing out! (Addr: 5, EP: 3)
Feb 24 22:45:54 hostname kernel[0]: USBF:     296.335 AppleUSBEHCI[0x2bfb800]::Found a transaction past the completion deadline on bus 0xfd, timing out! (Addr: 5, EP: 3)
Feb 24 22:46:05 hostname kernel[0]: USBF:     307.335 AppleUSBEHCI[0x2bfb800]::Found a transaction past the completion deadline on bus 0xfd, timing out! (Addr: 5, EP: 3)
Feb 24 22:46:14 hostname /usr/libexec/hidd[28]: Timeout waiting for IOKit to be quiet 
Feb 24 22:46:14 hostname /usr/libexec/hidd[28]: IOHIDEventQueueCreate: Unable to allocate queue memory from IOHIDSystem. (0x10000003)

System Profiler で見たところ,本体の USB ポートのうち 1 つが Bus Number: 0xfd だった.これが上のログで言われている bus だろう.このポートには USB ハブをもつディスプレイを接続している.ディスプレイには iPod と携帯電話を接続していた.ログメッセージ中にある Addr: 5, EP: 3 がデバイスを示しているとも思えるが,不明.上のログにあるように iPod には Busy services とのメッセージが出ている.携帯電話には Mac 用のドライバなどが提供されていないため,ただ充電するために接続している.

とりあえず,iPod と携帯電話をディスプレイから外して起動するようにして,様子を見ることにした.もし解決したら次は片方ずつ接続して原因を突き止めようと思う.もし解決しなかったらディスプレイから本体への USB は外し,ディスプレイの USB ハブは諦める.

つづく.