linux-kernel - Kernel Trace in recent 6.1.8n kernels

lists.openwall.net		lists / announce owl-users owl-dev john-users john-dev passwdqc-users yescrypt popa3d-users / oss-security kernel-hardening musl sabotage tlsify passwords / crypt-dev xvendor / Bugtraq Full-Disclosure linux-kernel linux-netdev linux-ext4 linux-hardening linux-cve-announce PHC
Open Source and information security mailing list archives

Hash Suite: Windows password security audit tool. GUI, reports in PDF.

[<prev] [next>] [thread-next>] [day] [month] [year] [list]

Message-ID: <b8dbce0c-31b4-4762-9779-6e973806433a@decentral.ch>
Date: Thu, 4 Apr 2024 00:49:40 +0200
From: Tim Tassonis <stuff@...entral.ch>
To: LKML <linux-kernel@...r.kernel.org>
Subject: Kernel Trace in recent 6.1.8n kernels

Hi all

Maybe this is the wrong list, as it probably only affects the 6.1.8n LTS 
kernel releases.


I noticed that since 6.1.80 or so, all my boxes print a trace when 
rebooting or halting, right at the end. It starts with 
drivers/scsi/scsi_lib.c

As everything seems already done by then, there is no "real" problem 
occuring, but maybe someone knows why this suddenly started to happen.


With qemu and the serial options, I managed to get the actual trace in text:

      Unmounting all other currently mounted file systems...[ 
58.632670] EXT4-fs (sda1): re-mounted. Quota mode: none.
   * 
[  OK  ]
[   58.684029] EXT4-fs (sda1): re-mounted. Quota mode: none.
   *   Bringing down the loopback interface... 
[  OK  ]
[   58.809326] ------------[ cut here ]------------
[   58.813524] WARNING: CPU: 0 PID: 2755 at drivers/scsi/scsi_lib.c:214 
scsi_execute_cmd+0x3b/0x2b0
[   58.828052] Modules linked in: cfg80211 8021q garp mrp stp ipv6 
crc_ccitt joydev hid_generic usbhid snd_seq_midi snd_seq_midi_event 
psmouse ppdev serio_raw atkbd libps2 vivaldi_fmap uhci_hcd ehci_pci 
ehci_hcd snd_ens1370 bochs drm_vram_helper snd_rawmidi usbcore 
drm_ttm_helper sr_mod usb_common snd_pcm cdrom e1000 i2c_piix4 ttm 
pcspkr gameport pata_acpi parport_pc parport i8042 qemu_fw_cfg serio 
rtc_cmos floppy snd_seq snd_seq_device snd_timer snd soundcore fuse
[   58.873677] CPU: 0 PID: 2755 Comm: halt Not tainted 6.1.84 #1
[   58.876424] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), 
BIOS rel-1.16.3-0-ga6ed6b701f0a-prebuilt.qemu.org 04/01/2014
[   58.884106] RIP: 0010:scsi_execute_cmd+0x3b/0x2b0
[   58.885558] Code: 89 cc 55 44 89 c5 53 48 83 ec 10 4c 8b 74 24 50 48 
89 0c 24 4d 85 f6 0f 84 44 02 00 00 49 83 3e 00 74 21 41 83 7e 08 60 74 
1a <0f> 0b b8 ea ff ff ff 48 83 c4 10 5b 5d 41 5c 41 5d 41 5e 41 5f c3
[   58.891998] RSP: 0018:ffffc90000153d98 EFLAGS: 00010287
[   58.893500] RAX: ffffc90000153df8 RBX: ffff888003d22000 RCX: 
0000000000000000
[   58.895480] RDX: 0000000000000022 RSI: 0000000000000022 RDI: 
ffff888003d22000
[   58.897583] RBP: 0000000000000000 R08: 0000000000000000 R09: 
0000000000002710
[   58.900276] R10: 0000000000000000 R11: 0000000000000000 R12: 
0000000000002710
[   58.902209] R13: ffff888003d22000 R14: ffffc90000153df8 R15: 
ffffc90000153e28
[   58.904084] FS:  00007f097a95b680(0000) GS:ffff88807dc00000(0000) 
knlGS:0000000000000000
[   58.906285] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[   58.907451] CR2: 00007f097a8f5431 CR3: 000000000406e000 CR4: 
00000000000006f0
[   58.908928] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 
0000000000000000
[   58.910326] DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 
0000000000000400
[   58.911770] Call Trace:
[   58.912438]  <TASK>
[   58.912977]  ? __warn+0x78/0xd0
[   58.913751]  ? scsi_execute_cmd+0x3b/0x2b0
[   58.914757]  ? report_bug+0xe6/0x170
[   58.916267]  ? handle_bug+0x3c/0x70
[   58.917020]  ? exc_invalid_op+0x13/0x60
[   58.917807]  ? asm_exc_invalid_op+0x16/0x20
[   58.918675]  ? scsi_execute_cmd+0x3b/0x2b0
[   58.919524]  ata_cmd_ioctl+0x112/0x2b0
[   58.920435]  blkdev_ioctl+0x12e/0x260
[   58.921322]  __x64_sys_ioctl+0x8b/0xc0
[   58.922115]  do_syscall_64+0x42/0x90
[   58.922953]  entry_SYSCALL_64_after_hwframe+0x64/0xce
[   58.924002] RIP: 0033:0x7f097a87616b
[   58.924748] Code: 00 48 89 44 24 18 31 c0 48 8d 44 24 60 c7 04 24 10 
00 00 00 48 89 44 24 08 48 8d 44 24 20 48 89 44 24 10 b8 10 00 00 00 0f 
05 <89> c2 3d 00 f0 ff ff 77 1c 48 8b 44 24 18 64 48 2b 04 25 28 00 00
[   58.928687] RSP: 002b:00007fff1e70b5b0 EFLAGS: 00000246 ORIG_RAX: 
0000000000000010
[   58.930465] RAX: ffffffffffffffda RBX: 0000000000000004 RCX: 
00007f097a87616b
[   58.932545] RDX: 00007fff1e70b614 RSI: 000000000000031f RDI: 
0000000000000004
[   58.933964] RBP: 0000000000000000 R08: 0000000000000073 R09: 
0000558c7857a343
[   58.935349] R10: 0000000000000000 R11: 0000000000000246 R12: 
0000000000000020
[   58.936727] R13: 0000558c77faf088 R14: 0000000000000001 R15: 
0000000000000000
[   58.938165]  </TASK>
[   58.938617] ---[ end trace 0000000000000000 ]---
[   58.940450] sd 0:0:0:0: [sda] Synchronizing SCSI cache
[   58.941662] sd 0:0:0:0: [sda] Stopping disk
[   58.971754] ACPI: PM: Preparing to enter system sleep state S5
[   58.973005] reboot: Power down


Bye
Tim