Hello,
I have a couple of USB mounted external drives. I am trying to backup
one to the other via rsync. The problem is that, every once in a
while, my machine will crash during this copy (hang with no output on
the monitor and is unresponsive to keyboard). Both drives are using
ext2. Additionally, I have found that the system crashes more
consistently if I am performing the rsync and also playing media (off
of the drive that I am backing up) over NFS at the same time.
I was *finally* able to get into ddb over a serial connection during
the latest crash. Attached is a file called 'DDB.txt' which contains
a trace of my ddb session after the crash. I have also attached the
relevant portion of my /var/log/messages file.
By the way:
$ uname -a
OpenBSD leela.local 4.7 GENERIC#558 i386
Please feel free to contact me if you require any more information.
The bug is a bit sporadic and not easy to reproduce but I will do my
best to get you any information that you may need.
Best,
Ethan
ddb>
ddb>
ddb> show panic
the kernel did not panic
ddb> help
machine print examine x search set
write w delete d break dwatch
watch step s continue c until
next match trace call ps callout
show boot help hangman dmesg
ddb> help x
Symbol not found
ddb> trace
bcopy(d10c2300,d10c7a00,0,d78b2000,0) at bcopy+0x1a
usb_transfer_complete(d10c2300,d10c236c,d7570ef0,d7570ef4) at usb_transfer_comp
lete+0x18e
uhci_softintr(d10a7000,2,1,d08fe46c) at uhci_softintr+0x25
softintr_dispatch(1) at softintr_dispatch+0x6d
Xsoftnet() at Xsoftnet+0x8f
--- interrupt ---
cpu_idle_cycle(d098dee0) at cpu_idle_cycle+0xf
Bad frame pointer: 0xd0a3ee78
ddb> continue
kernel: page fault trap, code=0
Stopped at bcopy+0x1a: repe movsl (%esi),%es:(%edi)
ddb> trace
bcopy(d10c2300,d10c7a00,0,d78b2000,0) at bcopy+0x1a
usb_transfer_complete(d10c2300,d10c236c,d7570ef0,d7570ef4) at usb_transfer_comp
lete+0x18e
uhci_softintr(d10a7000,2,1,d08fe46c) at uhci_softintr+0x25
softintr_dispatch(1) at softintr_dispatch+0x6d
Xsoftnet() at Xsoftnet+0x8f
--- interrupt ---
cpu_idle_cycle(d098dee0) at cpu_idle_cycle+0xf
Bad frame pointer: 0xd0a3ee78
ddb> ps
PID PPID PGRP UID S FLAGS WAIT COMMAND
26769 14457 15189 0 3 0x82 select rsync
14457 15189 15189 0 3 0x82 select rsync
15189 19281 15189 0 3 0x400a getblk rsync
19861 5744 19861 1000 3 0x4082 pause screen
5744 8521 5744 1000 3 0x4082 pause ksh
8521 2967 2967 1000 3 0x180 select sshd
2967 16118 2967 0 3 0x4180 netio sshd
7434 1 7434 1000 3 0x80 poll synergys
19281 27482 19281 1000 3 0x4082 pause ksh
726 20574 726 1000 3 0x4082 pause screen
20574 20257 20574 1000 3 0x4082 pause ksh
20257 4488 13856 1000 3 0x44180 select xterm
4488 17534 13856 1000 3 0x4080 pause sh
31860 3182 31860 1000 3 0x408a poll irssi
3182 27482 3182 1000 3 0x4082 pause ksh
27482 17482 27482 1000 3 0x80 select screen
17482 7490 17482 1000 3 0x4082 pause screen
7490 29728 7490 1000 3 0x4082 pause ksh
12298 27579 13856 1000 3 0x4080 poll xclock
6573 18234 13856 1000 3 0x4080 poll xload
18234 17534 13856 1000 3 0x4080 pause sh
27579 17534 13856 1000 3 0x4080 pause sh
11889 17534 13856 1000 3 0x4080 select FvwmPager
17534 13856 13856 1000 3 0x4080 select fvwm
ddb> trace
bcopy(d10c2300,d10c7a00,0,d78b2000,0) at bcopy+0x1a
usb_transfer_complete(d10c2300,d10c236c,d7570ef0,d7570ef4) at usb_transfer_comp
lete+0x18e
uhci_softintr(d10a7000,2,1,d08fe46c) at uhci_softintr+0x25
softintr_dispatch(1) at softintr_dispatch+0x6d
Xsoftnet() at Xsoftnet+0x8f
--- interrupt ---
cpu_idle_cycle(d098dee0) at cpu_idle_cycle+0xf
Bad frame pointer: 0xd0a3ee78
ddb> show panice
No such command
ddb> show panic
the kernel did not panic
ddb> boot dump
panic: cpu_switch1 0xd53132b8
Stopped at Debugger+0x4: leave
RUN AT LEAST 'trace' AND 'ps' AND INCLUDE OUTPUT WHEN REPORTING THIS PANIC!
DO NOT EVEN BOTHER REPORTING THIS WITHOUT INCLUDING THAT INFORMATION!
ddb> trace
Debugger(d7665ea0,d0377ceb,d7665e88,c0,0) at Debugger+0x4
panic(d02008a7,d53132b8,d52f6090,d766437c,c0) at panic+0x55
switch_error1(d50f5838,80000000,d52f6050,0,d50bec84) at switch_error1+0xb
exit1(d50f5838,ff00,1,0,d086cb0c) at exit1+0x2d7
sys_exit(d50f5838,d7665f68,d7665f58,0,a4) at sys_exit+0x19
syscall() at syscall+0x24e
--- syscall (number 1) ---
0xcc63b63:
ddb> ps
PID PPID PGRP UID S FLAGS WAIT COMMAND
26769 14457 15189 0 3 0x82 select rsync
14457 15189 15189 0 3 0x82 select rsync
15189 19281 15189 0 3 0x400a getblk rsync
19861 5744 19861 1000 3 0x4082 pause screen
5744 1 5744 1000 3 0x4082 pause ksh
2967 16118 2967 0 2 0x4180 sshd
7434 1 7434 1000 3 0x80 poll synergys
19281 27482 19281 1000 3 0x4082 pause ksh
726 20574 726 1000 3 0x4082 pause screen
20574 20257 20574 1000 3 0x4082 pause ksh
20257 4488 13856 1000 3 0x44180 select xterm
4488 17534 13856 1000 3 0x4080 pause sh
31860 3182 31860 1000 3 0x408a poll irssi
3182 27482 3182 1000 3 0x4082 pause ksh
27482 17482 27482 1000 3 0x80 select screen
17482 7490 17482 1000 3 0x4082 pause screen
7490 29728 7490 1000 3 0x4082 pause ksh
12298 27579 13856 1000 3 0x4080 poll xclock
6573 18234 13856 1000 3 0x4080 poll xload
18234 17534 13856 1000 3 0x4080 pause sh
27579 17534 13856 1000 3 0x4080 pause sh
11889 17534 13856 1000 3 0x4080 select FvwmPager
17534 13856 13856 1000 3 0x4080 select fvwm
29728 13856 13856 1000 3 0x44180 select xterm
23325 1 23325 1000 3 0x40180 select ssh-agent
13856 25099 13856 1000 3 0x4080 pause sh
18281 1 18630 35 3 0x180 poll xconsole
1849 1 18630 0 3 0x80 netio xconsole
25099 32195 25099 0 3 0x80 wait xdm
29726 11057 11057 0 3 0x40180 netio Xorg
11057 32195 11057 35 2 0x44100 Xorg
28949 1 28949 0 3 0x4082 ttyin getty
30535 1 30535 0 3 0x4082 ttyin getty
12610 1 12610 0 3 0x4082 ttyin getty
6023 1 6023 0 3 0x4082 ttyin getty
13963 1 13963 0 3 0x4082 ttyin getty
28047 1 28047 0 3 0x4082 ttyin getty
17276 1 17276 0 3 0x4080 ttyin getty
32195 1 32195 0 3 0x80 pause xdm
21955 1 21955 0 3 0x40180 select sendmail
18185 1 18185 0 3 0x80 select cron
3586 1 3586 0 3 0x180 select inetd
16118 1 16118 0 3 0x80 select sshd
29187 4598 7063 83 3 0x180 poll ntpd
4598 7063 7063 83 3 0x180 poll ntpd
7063 1 7063 0 3 0x80 poll ntpd
31818 11011 11011 0 3 0x80 nfsd nfsd
3859 11011 11011 0 3 0x80 nfsd nfsd
3966 11011 11011 0 3 0x80 nfsd nfsd
14942 11011 11011 0 3 0x80 nfsd nfsd
11011 1 11011 0 3 0x80 netcon nfsd
7488 1 7488 0 3 0x80 select mountd
4403 1 4403 28 3 0x180 poll portmap
17677 7985 7985 74 3 0x180 bpf pflogd
7985 1 7985 0 3 0x80 netio pflogd
15418 5062 5062 73 3 0x100 biowait syslogd
5062 1 5062 0 3 0x88 netio syslogd
14 0 0 0 3 0x100200 bored crypto
13 0 0 0 3 0x100200 aiodoned aiodoned
12 0 0 0 3 0x100200 syncer update
11 0 0 0 3 0x100200 cleaner cleaner
10 0 0 0 3 0x100200 reaper reaper
9 0 0 0 3 0x100200 pgdaemon pagedaemon
8 0 0 0 3 0x100200 pftm pfpurge
7 0 0 0 3 0x100200 usbtsk usbtask
6 0 0 0 3 0x100200 usbevt usb0
5 0 0 0 3 0x100200 acpi_idle acpi0
4 0 0 0 3 0x100200 bored syswq
3 0 0 0 2 0x40100200 biowait idle0
2 0 0 0 3 0x100200 kmalloc kmthread
1 0 1 0 2 0x4080 init
0 -1 0 0 3 0x80200 scheduler swapper
* 8521 2967 2967 1000 6 0x2100 sshd
ddb>
PID PPID PGRP UID S FLAGS WAIT COMMAND
26769 14457 15189 0 3 0x82 select rsync
14457 15189 15189 0 3 0x82 select rsync
15189 19281 15189 0 3 0x400a getblk rsync
19861 5744 19861 1000 3 0x4082 pause screen
5744 1 5744 1000 3 0x4082 pause ksh
2967 16118 2967 0 2 0x4180 sshd
7434 1 7434 1000 3 0x80 poll synergys
19281 27482 19281 1000 3 0x4082 pause ksh
726 20574 726 1000 3 0x4082 pause screen
20574 20257 20574 1000 3 0x4082 pause ksh
20257 4488 13856 1000 3 0x44180 select xterm
4488 17534 13856 1000 3 0x4080 pause sh
31860 3182 31860 1000 3 0x408a poll irssi
3182 27482 3182 1000 3 0x4082 pause ksh
27482 17482 27482 1000 3 0x80 select screen
17482 7490 17482 1000 3 0x4082 pause screen
7490 29728 7490 1000 3 0x4082 pause ksh
12298 27579 13856 1000 3 0x4080 poll xclock
6573 18234 13856 1000 3 0x4080 poll xload
18234 17534 13856 1000 3 0x4080 pause sh
27579 17534 13856 1000 3 0x4080 pause sh
11889 17534 13856 1000 3 0x4080 select FvwmPager
17534 13856 13856 1000 3 0x4080 select fvwm
29728 13856 13856 1000 3 0x44180 select xterm
23325 1 23325 1000 3 0x40180 select ssh-agent
13856 25099 13856 1000 3 0x4080 pause sh
18281 1 18630 35 3 0x180 poll xconsole
1849 1 18630 0 3 0x80 netio xconsole
25099 32195 25099 0 3 0x80 wait xdm
29726 11057 11057 0 3 0x40180 netio Xorg
11057 32195 11057 35 2 0x44100 Xorg
28949 1 28949 0 3 0x4082 ttyin getty
30535 1 30535 0 3 0x4082 ttyin getty
12610 1 12610 0 3 0x4082 ttyin getty
6023 1 6023 0 3 0x4082 ttyin getty
13963 1 13963 0 3 0x4082 ttyin getty
28047 1 28047 0 3 0x4082 ttyin getty
17276 1 17276 0 3 0x4080 ttyin getty
32195 1 32195 0 3 0x80 pause xdm
21955 1 21955 0 3 0x40180 select sendmail
18185 1 18185 0 3 0x80 select cron
3586 1 3586 0 3 0x180 select inetd
16118 1 16118 0 3 0x80 select sshd
29187 4598 7063 83 3 0x180 poll ntpd
4598 7063 7063 83 3 0x180 poll ntpd
7063 1 7063 0 3 0x80 poll ntpd
31818 11011 11011 0 3 0x80 nfsd nfsd
3859 11011 11011 0 3 0x80 nfsd nfsd
3966 11011 11011 0 3 0x80 nfsd nfsd
14942 11011 11011 0 3 0x80 nfsd nfsd
11011 1 11011 0 3 0x80 netcon nfsd
7488 1 7488 0 3 0x80 select mountd
4403 1 4403 28 3 0x180 poll portmap
17677 7985 7985 74 3 0x180 bpf pflogd
7985 1 7985 0 3 0x80 netio pflogd
15418 5062 5062 73 3 0x100 biowait syslogd
5062 1 5062 0 3 0x88 netio syslogd
14 0 0 0 3 0x100200 bored crypto
13 0 0 0 3 0x100200 aiodoned aiodoned
12 0 0 0 3 0x100200 syncer update
11 0 0 0 3 0x100200 cleaner cleaner
10 0 0 0 3 0x100200 reaper reaper
9 0 0 0 3 0x100200 pgdaemon pagedaemon
8 0 0 0 3 0x100200 pftm pfpurge
7 0 0 0 3 0x100200 usbtsk usbtask
6 0 0 0 3 0x100200 usbevt usb0
5 0 0 0 3 0x100200 acpi_idle acpi0
4 0 0 0 3 0x100200 bored syswq
3 0 0 0 2 0x40100200 biowait idle0
2 0 0 0 3 0x100200 kmalloc kmthread
1 0 1 0 2 0x4080 init
0 -1 0 0 3 0x80200 scheduler swapper
* 8521 2967 2967 1000 6 0x2100 sshd
ddb> show panic
cpu_switch1 0xd53132b8
ddb> boot dump
dumping to dev 1, offset 520559
dump panic: wddump: polled command has been queued
Stopped at Debugger+0x4: leave
RUN AT LEAST 'trace' AND 'ps' AND INCLUDE OUTPUT WHEN REPORTING THIS PANIC!
DO NOT EVEN BOTHER REPORTING THIS WITHOUT INCLUDING THAT INFORMATION!
ddb> boot sync
panic: wdc_exec_command: polled command not done
Stopped at Debugger+0x4: leave
RUN AT LEAST 'trace' AND 'ps' AND INCLUDE OUTPUT WHEN REPORTING THIS PANIC!
DO NOT EVEN BOTHER REPORTING THIS WITHOUT INCLUDING THAT INFORMATION!
ddb> boot reboot
rebooting...
[demime 1.01d removed an attachment of type application/octet-stream which had
a name of messages]
