From owner-freebsd-ppc@freebsd.org Sun Apr 18 18:44:00 2021 Return-Path: Delivered-To: freebsd-ppc@mailman.nyi.freebsd.org Received: from mx1.freebsd.org (mx1.freebsd.org [IPv6:2610:1c1:1:606c::19:1]) by mailman.nyi.freebsd.org (Postfix) with ESMTP id 2DAD45F1341 for ; Sun, 18 Apr 2021 18:44:00 +0000 (UTC) (envelope-from marklmi@yahoo.com) Received: from sonic317-20.consmr.mail.gq1.yahoo.com (sonic317-20.consmr.mail.gq1.yahoo.com [98.137.66.146]) (using TLSv1.2 with cipher ECDHE-RSA-AES128-GCM-SHA256 (128/128 bits)) (Client did not present a certificate) by mx1.freebsd.org (Postfix) with ESMTPS id 4FNf3z0QRXz3wGY for ; Sun, 18 Apr 2021 18:43:58 +0000 (UTC) (envelope-from marklmi@yahoo.com) X-SONIC-DKIM-SIGN: v=1; a=rsa-sha256; c=relaxed/relaxed; d=yahoo.com; s=s2048; t=1618771437; bh=iDB8bENWG6UOT6yT8sE4lwD9EeVeagcbdob7AMTnKkE=; h=X-Sonic-MF:From:Subject:Date:To:From:Subject; b=DczXYWj/rDlPEW/t8ZuOtb3nfKLoKMt1sF+qoyX55HVZyheTzBHoxmmpnC0PaeX2ZIb7JPZgrB1qyx+LGDYzCUhcrB9d5zsKyzAFsFiuL6DkyTL6LVeminA+Inb54dDLpPjc/8bGvrLDvDhaqmKWPEBD2aJfnhGDOsPiYjuikO7ldGVs6hHrFPAE0Y/jZ6yJN57nHwP9mpSBs54qUKs5iBz57ydpr0sIhMoNV8mZR0v0Pkay2KCWtBH1guCJO7s6nA4fUxWsRxOep2xryQOL6MFDgPoPHcv1SInjNaNQl8ZVLCT6MBLC0bJv2MyI4a8MkgM6nB6/Nwc3nqSpCTOttQ== X-YMail-OSG: q4WXFJ4VM1lehIJqSzeSWWkLrG_exa87TM_4KOuJcy2Rn4k2IEwJPYMReX1tNzc 5GDPjeEQ3P_z4wE73aVsuA5Hqwm7Lmr7mEk9Y1zUlBESVI92mN7RtLFcCHxOZrY96WHV3ghjbm.V We1KMxbRjiZ8u.DVghCAgBpurQuQskLj.jrPezBgija_GQOWA.QEIUKNa47jY98td7CBEn9crduY 9xnFPQYUv2jaVn4apcFOwY3BY6P.0B.dsk5yw7fhJv7rOesa80RVjsl4F3x65Sjs36Z42ExMM5Na f6TsWqfgiYWOmi56sBjF.kM9eFIlF3lw9f0LUq8Y71_4Lnq1_pXoTtrTUU9oRw9pDsg.X3tB0h2j Jpk_ocf_DME7ziM2MPgpJXFCp687vUBiDX9IB3GcxKQH9P6GAsna6ge6mXYlHCIWCXtSjz4aDHkr naAQCLzTxOmangga9puELfMfNRMAprVQUTWjRv0O6E5gQxVCiU7bKTE9REDc1DvjYaGNa_tWdhZP atMWWxf.e21u.zv6neV8GIovy0YoXdcYACWLvWMpiNoDiRiRuO6O0n4rVgvhVK6nf.2yHnSk5G_Y 2uApzb.rbSfKOf_pI1SQle_OXIlIwhkG7g.lQkrJTzJESfGDtKtst98qjSE1Gjzc6PiBlII8A.kG bfvDkWKpj94YUK_weTHgwQccVb0L7jSkZug.pK8E70DQgNhBVxC4FP4uyXKkbuq7bgEJB1qw6gvP lywSbelSPMVAAE7o8IYUmCIWSLmt9ABYyJtO8y658kJZm8hRdILVVaivUYwHxyEiNn1cp1wWt8Tr cHtLjfS6NvZWZZCjulJYSIyk9nAy7o6Yckj_z1YYvCSiGorsHs5.y304IOwuKbW72z20OZcgisX3 aArmisoLWanghSlSNfZ_sqNNlIVlR1FU7ECmHniIZ5MbSNVSmzHzZbrtO4DDN8KcKR_2u0hg844O rVWVg835wl_teXxB4fA0fDjc4TF5m9C8Ol0tVn0JS16RDt5ronGg3_9x5PmzKuoWyAZyvCT._CnZ pFnosuTT42_n9Au1aifMgCGd8HtU_hkuJfgSvx01bAAyxYFZ6t.Au9siaMFSge9b2AM_K2B1rDpM 7_rJwgpd44A0F.kGBPG1YXQjccmxfGO0CbpYoExtrkLkGBhxNpf7RF.tAWJ.8v3ipGnhkzzm9AN. 46sXSyIKZuhvCPlet2_lUA4rULmNAG3z1DcGi62fPbVB65TcIJwAv4ofQSj90hUsOto.4aT_ngUl W4EDKfO90bE__fzxExyNNLpKfYOEE2Xk7ibNafgUklnDL8ofovYnBH69Nwk_7356RlIoABfNY4_t wo_k9Z57aeooY9UNw2opp0Vg86HrOcS577cbXn3IjgalgN4683Dh7MySINMWZke65v9yMHCOztE2 xpPs4lUgE1K3U479lrDnbVRWBBj0XlltGthncbwZs.9OjNyaOG35DpMQCk6mEEjOc4FtCTi5Cqkt 3I0..biNcku0geMcjWIvQ_NDQUblPEqHOW13kTRs3hGaXe84Tbp8X8MbVN_iwA41Dgc.6CAUcrji C4GjbdVuwggBl_wR6grEr9uUuYZzCOESvZBwp3YeSretQknpq7wac9dfq1O9.whTUqCNolc65RHu nrI6N4EXYsc4.fJw.ICi5d1i2EvBDvHngCuSBsAU3q_wQuyg8Y4A9fief37UFPKsXdS76jSbmMyO GtWDs15R3f0pmBWX.xv7ROW5QNqnUoIi4dhBkufQFXnItpb99a1IcTcQ7xcKirFrf7w8lTpgWIP9 SE8CaYCN.PkOInOSQXSXp9SOlJyiHyqs8CG0Vzc3Sxyys52Ey2ytiYF_.tqaFxWoq_4t1DrV.2W0 fobyeIGloF8df2QcrpIJ_VVz0_q6TYJZBtpSoUnK91M1BL8NbPW_SbKoHZvk0g7KpqhVWcZu0WFn S9ZvWtiWkV5ZYfwIJm6wlJ7JYdDYsc3Cy7E_CccC3T7Fxn7NKmqavIborxFYKWoCv9b1130Xj4Ex cdo2UW0z5iw2Z0jZlDFSH9mFq3M53Rp.xlvRWx.C5IKaZPa0e0vkG19n8EquSkK4TgJVMwHaTcef LBHwl8L4kB7P2F4ADTDFEY9Ce8Kv9lY.EPwOA7IRp7TeI9lj0HPzBA.R9nPj859oUFAXJ6IJz01W W_dmfvknn6OqCDAh4L0F5grwPu12H545cmMhQ5v.c3Cn381D3R9ZlOMaiNBu1Y.i8elXSGm6T335 jz73HCbtMTHbbqQrEhgkrcVEcgHlH2W135pK0h3xIX7Zo1I_nAC3dmRExZJpRDPo74hPW3mrjtEa IMAgyKvhPGlZvOrlCPb6xniICpm_KJu2oX7Gw2.ZjruA0H4prbS6i0s8wYpfmZN01rwfDptwPn4W 2_A2BtwZIjRVfKZfTDuSh6gDBw_uAtsMELOzN.GGJaobIcdTm3DFYMa0CKIUd4w18gf8GdCz5qhn pJq71TMM4YJ_EaV1NTHPq0ugnOICtA5B1hEc.EwdjckXb7F5GxldO7tpZ.LnQK3btwiCHzQxK7DG 45cJXJIUNPifMpPTqrhxVuH8LDMaUvrQkjdJmJ6EkRNi8weU2tojlQCbpzGn8VAvpx9GITszMGlt c4UgF531Kq55UzPmxrVq.qPu0PReYXVG5lhXR_8xJrJ7OPwcNJJ3bpFyYgYZxVtR0tWOEIsoz9V9 Jl0erI_OgUtUgKoYMrTEVsWPRAg-- X-Sonic-MF: Received: from sonic.gate.mail.ne1.yahoo.com by sonic317.consmr.mail.gq1.yahoo.com with HTTP; Sun, 18 Apr 2021 18:43:57 +0000 Received: by kubenode520.mail-prod1.omega.ne1.yahoo.com (VZM Hermes SMTP Server) with ESMTPA ID 5561c5c0bf7ee04799746f5d01ed7c5c; Sun, 18 Apr 2021 18:43:52 +0000 (UTC) From: Mark Millard Content-Type: text/plain; charset=us-ascii Content-Transfer-Encoding: quoted-printable Mime-Version: 1.0 (Mac OS X Mail 14.0 \(3654.60.0.2.21\)) Subject: PowerMac G5 panic: "spin lock . . . held too long" with traceback and such [possibly iichb0 irq42 problem related] Message-Id: Date: Sun, 18 Apr 2021 11:43:50 -0700 To: FreeBSD PowerPC ML X-Mailer: Apple Mail (2.3654.60.0.2.21) References: X-Rspamd-Queue-Id: 4FNf3z0QRXz3wGY X-Spamd-Bar: --- X-Spamd-Result: default: False [-3.49 / 15.00]; RBL_SENDERSCORE_FAIL(0.00)[98.137.66.146:server fail]; FREEMAIL_FROM(0.00)[yahoo.com]; MV_CASE(0.50)[]; R_SPF_ALLOW(-0.20)[+ptr:yahoo.com]; TO_DN_ALL(0.00)[]; DKIM_TRACE(0.00)[yahoo.com:+]; RCPT_COUNT_TWO(0.00)[2]; DMARC_POLICY_ALLOW(-0.50)[yahoo.com,reject]; NEURAL_HAM_SHORT(-0.99)[-0.995]; FROM_EQ_ENVFROM(0.00)[]; RCVD_TLS_LAST(0.00)[]; MIME_TRACE(0.00)[0:+]; FREEMAIL_ENVFROM(0.00)[yahoo.com]; ASN(0.00)[asn:36647, ipnet:98.137.64.0/20, country:US]; RBL_DBL_DONT_QUERY_IPS(0.00)[98.137.66.146:from]; DWL_DNSWL_NONE(0.00)[yahoo.com:dkim]; MID_RHS_MATCH_FROM(0.00)[]; ARC_NA(0.00)[]; R_DKIM_ALLOW(-0.20)[yahoo.com:s=s2048]; NEURAL_HAM_MEDIUM(-1.00)[-1.000]; FROM_HAS_DN(0.00)[]; NEURAL_HAM_LONG(-1.00)[-1.000]; MIME_GOOD(-0.10)[text/plain]; SPAMHAUS_ZRD(0.00)[98.137.66.146:from:127.0.2.255]; TO_MATCH_ENVRCPT_SOME(0.00)[]; RCVD_IN_DNSWL_NONE(0.00)[98.137.66.146:from]; RWL_MAILSPIKE_POSSIBLE(0.00)[98.137.66.146:from]; RCVD_COUNT_TWO(0.00)[2]; MAILMAN_DEST(0.00)[freebsd-ppc] X-BeenThere: freebsd-ppc@freebsd.org X-Mailman-Version: 2.1.34 Precedence: list List-Id: Porting FreeBSD to the PowerPC List-Unsubscribe: , List-Archive: List-Post: List-Help: List-Subscribe: , X-List-Received-Date: Sun, 18 Apr 2021 18:44:00 -0000 Note: I am using a USB dongle for Ethernet, not built-in Ethernet. spin lock 0xc00000000169d808 (sleepq chain) held by 0xc00800000370c100 = (tid 100034) too long timeout stopping cpus panic: spin lock held too long cpuid =3D 0 time =3D 1618766961 KDB: stack backtrace: 0xc0080000c1ec8f70: at kdb_backtrace+0x60 0xc0080000c1ec9080: at vpanic+0x1e0 0xc0080000c1ec9130: at panic+0x40 0xc0080000c1ec9160: at _mtx_lock_indefinite_check+0xb4 0xc0080000c1ec91d0: at _mtx_lock_spin_cookie+0x10c 0xc0080000c1ec9250: at sleepq_lock+0xd8 0xc0080000c1ec9290: at _cv_wait+0x8c 0xc0080000c1ec9310: at usbd_do_request_flags+0x6f4 0xc0080000c1ec9440: at usbd_do_request_proc+0x98 0xc0080000c1ec94b0: at ure_miibus_readreg+0x18c 0xc0080000c1ec9530: at miibus_readreg+0x88 0xc0080000c1ec9570: at rgephy_linkup+0x13c 0xc0080000c1ec95b0: at rgephy_service+0x178 0xc0080000c1ec9640: at mii_tick+0x7c 0xc0080000c1ec9680: at ure_tick+0x314 0xc0080000c1ec9730: at ue_tick_task+0x40 0xc0080000c1ec9760: at usb_process+0x24c 0xc0080000c1ec9830: at fork_exit+0xd8 0xc0080000c1ec98c0: at fork_trampoline+0x18 0xc0080000c1ec98f0: at -0x4 KDB: enter: panic [ thread pid 15 tid 100117 ] Stopped at kdb_enter+0x78: ori r0, r0, 0x0 db> trace 100034 Tracing pid 12 tid 100034 td 0xc00800000370c100 saved LR(0xc00000000127c013) is invalid. db> ps . . . 12 0 0 0 RL (threaded) [intr] . . . 100034 Run CPU 1 [irq42: = iichb0] . . . 100117 Run CPU 0 [ure0] . . . db> show allchains . . . chain 73: thread 100067 (pid 15, usbus4) is blocked on lock 0xc000000005df70e0 = (sleep mutex) "USB device mutex" thread 100117 (pid 15, ure0) is running on CPU 0 chain . . . (100034 did not show up.) db> trace 100067 Tracing pid 15 tid 100067 td 0xc008000003a56b80 0xc008000078fc75d0: at mi_switch+0x144 0xc008000078fc7610: at turnstile_wait+0x414 0xc008000078fc7680: at __mtx_lock_sleep+0x188 0xc008000078fc7720: at usb_callback_proc+0x238 0xc008000078fc7760: at usb_process+0x24c 0xc008000078fc7830: at fork_exit+0xd8 0xc008000078fc78c0: at fork_trampoline+0x18 0xc008000078fc78f0: at -0x4 db> ps . . . 15 0 0 0 RL (threaded) [usb] . . . 100067 L *USB dev 0xc00000000541c240 [usbus4] . . . 100117 Run CPU 0 [ure0] . . . 100034 Run CPU 1 [irq42: = iichb0] . . . db> show intrcnt cpu0:decrementer 2695690 irq42: iichb0 5552572 irq33554488: htpic0 5552573 irq33554459: ohci0 18 irq33554460: ohci1 1 irq33554495: ohci2* 816155 irq33554471: ata0 75050 irq33554472:-wohci0 47 irq33554432:-tapci0 579751 irq33554492:-agpio0 1 irq33554458: iichb1 398 irq33554433: pcm0 1 irq33554552: IPI 5982757 cpu1:decrementer 2537712 (Is the 5552572+1=3D5552573 expected?) db> show intr=20 swi5: fast taskq (pid 12) {SOFT} swi6: task queue (pid 12) {SOFT} swi6: Giant taskq (pid 12) {SOFT} swi3: vm (pid 12) {SOFT} swi4: clock (0) (pid 12) {SOFT, NEED} swi4: clock (1) (pid 12) {SOFT} swi1: netisr 0 (pid 12) {SOFT} irq33554488: htpic0 (no thread) irq42: iichb0 (pid 12) irq33554492:-agpio0 (pid 12) irq33554493:-agpio1 (pid 12) irq33554454: scc0 (no thread) irq33554455: scc0 (no thread) swi0: uart uart (pid 12) {SOFT} irq33554458: iichb1 (pid 12) irq33554433: pcm0 (pid 12) irq33554459: ohci0 (pid 12) irq33554460: ohci1 (pid 12) irq33554495: ohci2* (pid 12) irq33554471: ata0 (pid 12) irq33554472:-wohci0 (pid 12) irq33554473: gem0 (pid 12) irq33554432:-tapci0 (pid 12) irq33554552: IPI (no thread) Note: I probably had minidump turned off. Typing dump to the db> prompt got me a huge number of "(CTRL-C to abort) ". CTRL-C did abort the dump so I guess it was working. I typed dump again. But that eventually failed with: ... ok chunk 2: 1024MB (262144 pages)KDB: reentering KDB: stack backtrace: 0xc00000000130f990: at kdb_backtrace+0x60 0xc00000000130faa0: at kdb_reenter+0x6c 0xc00000000130fb10: at trap+0x98 0xc00000000130fc70: at powerpc_interrupt+0x1b4 0xc00000000130fcc0: kernel DSI read trap @ 0x100000ff8 by memcpy+0xd0: = srr1=3D0x9000000000001032 r1=3D0xc00000000130ff70 cr=3D0x44882224 xer=3D0x20000000 = ctr=3D0x200 r2=3D0xc00000000142c000 sr=3D0x40000000 = frame=3D0xc00000000130fcf0 0xc00000000130ff70: at settime.laststep+0x34 0xc00000000130ffc0: at ata_dmaload+0x254 0xc000000001310050: at ata_begin_transaction+0x178 0xc0000000013100e0: at ataaction+0xa58 0xc000000001310180: at xpt_run_devq+0x500 0xc000000001310290: at xpt_action_default+0xa90 0xc000000001310350: at ata_action+0x174 0xc000000001310390: at xpt_action+0x40 0xc0000000013103c0: at cam_periph_runccb+0x158 0xc000000001310530: at adadump+0x1e4 0xc0000000013106f0: at dump_write+0x10c 0xc000000001310760: at _dump_append+0x184 0xc0000000013107f0: at dumpsys_cb_dumpdata+0x168 0xc0000000013108d0: at dumpsys_generic+0x548 0xc000000001310a50: at doadump+0xdc 0xc000000001310a90: at db_dump+0x60 0xc000000001310b00: at db_command+0x2f0 0xc000000001310c40: at db_command_loop+0x88 0xc000000001310cc0: at db_trap+0x178 0xc000000001310e20: at kdb_trap+0x25c 0xc000000001310f10: at db_trap_glue+0xb4 0xc000000001310f40: at dbtrap+0x144 0xc0080000c1ec9000: at kdb_enter+0x60 0xc0080000c1ec9080: at vpanic+0x224 0xc0080000c1ec9130: at panic+0x40 0xc0080000c1ec9160: at _mtx_lock_indefinite_check+0xb4 0xc0080000c1ec91d0: at _mtx_lock_spin_cookie+0x10c 0xc0080000c1ec9250: at sleepq_lock+0xd8 0xc0080000c1ec9290: at _cv_wait+0x8c 0xc0080000c1ec9310: at usbd_do_request_flags+0x6f4 0xc0080000c1ec9440: at usbd_do_request_proc+0x98 0xc0080000c1ec94b0: at ure_miibus_readreg+0x18c 0xc0080000c1ec9530: at miibus_readreg+0x88 0xc0080000c1ec9570: at rgephy_linkup+0x13c 0xc0080000c1ec95b0: at rgephy_service+0x178 0xc0080000c1ec9640: at mii_tick+0x7c 0xc0080000c1ec9680: at ure_tick+0x314 0xc0080000c1ec9730: at ue_tick_task+0x40 0xc0080000c1ec9760: at usb_process+0x24c 0xc0080000c1ec9830: at fork_exit+0xd8 0xc0080000c1ec98c0: at fork_trampoline+0x18 0xc0080000c1ec98f0: at -0x4 KDB: reentering KDB: stack backtrace: 0xc008000004e5aaa0: at kdb_backtrace+0x60 0xc008000004e5abb0: at kdb_reenter+0x6c 0xc008000004e5ac20: at trap+0x98 0xc008000004e5ad80: at powerpc_interrupt+0x1b4 0xc008000004e5add0: kernel FPU trap by trapstk+0x18e0: = srr1=3D0x9000000000001032 r1=3D0xc008000004e5b080 cr=3D0x146c000 xer=3D0x78 = ctr=3D0xc00000000024cf80 r2=3D0xc00000000127c01d = frame=3D0xc008000004e5ae00 0xc008000004e5b080: at -0x4 0xc008000000025100: at -0x4 0xc008000000025dc0: at -0x4 KDB: reentering KDB: stack backtrace: . . . =3D=3D=3D Mark Millard marklmi at yahoo.com ( dsl-only.net went away in early 2018-Mar)