[bug report] blktests nvme/014 flush operation failed with "Interrupted system call"

Yi Zhang yi.zhang at redhat.com
Fri Dec 3 19:02:58 PST 2021


Hello

I found blktests nvme/014 failed on the latest 5.16.0-rc3, and it also
exists on the previous 5.13 kernel, pls help check it, thanks.

# nvme_trtype=rdma ./check nvme/014
nvme/014 (flush a NVMeOF block device-backed ns)             [failed]
    runtime  97.035s  ...  83.405s
    --- tests/nvme/014.out 2021-12-03 00:46:30.921272359 -0500
    +++ /root/blktests/results/nodev/nvme/014.out.bad 2021-12-03
20:39:24.005327680 -0500
    @@ -1,6 +1,6 @@
     Running nvme/014
     91fdba0d-f87b-4c25-b80f-db7be1418b9e
     uuid.91fdba0d-f87b-4c25-b80f-db7be1418b9e
    -NVMe Flush: success
    +flush: Interrupted system call
     NQN:blktests-subsystem-1 disconnected 1 controller(s)
     Test complete
# use_siw=1 nvme_trtype=rdma ./check nvme/014
nvme/014 (flush a NVMeOF block device-backed ns)             [failed]
    runtime  83.405s  ...  120.337s
    --- tests/nvme/014.out 2021-12-03 00:46:30.921272359 -0500
    +++ /root/blktests/results/nodev/nvme/014.out.bad 2021-12-03
20:41:37.716947252 -0500
    @@ -1,6 +1,6 @@
     Running nvme/014
     91fdba0d-f87b-4c25-b80f-db7be1418b9e
     uuid.91fdba0d-f87b-4c25-b80f-db7be1418b9e
    -NVMe Flush: success
    +flush: Interrupted system call
     NQN:blktests-subsystem-1 disconnected 1 controller(s)
     Test complete

dmesg:
[29543.065568] run blktests nvme/014 at 2021-12-03 20:38:00
[29543.376558] rdma_rxe: loaded
[29543.384075] eno1 speed is unknown, defaulting to 1000
[29543.389149] eno1 speed is unknown, defaulting to 1000
[29543.394225] eno1 speed is unknown, defaulting to 1000
[29543.400686] infiniband eno1_rxe: set down
[29543.404714] infiniband eno1_rxe: added eno1
[29543.408903] eno1 speed is unknown, defaulting to 1000
[29543.415984] eno1 speed is unknown, defaulting to 1000
[29543.422624] eno2 speed is unknown, defaulting to 1000
[29543.427686] eno2 speed is unknown, defaulting to 1000
[29543.432760] eno2 speed is unknown, defaulting to 1000
[29543.439219] infiniband eno2_rxe: set down
[29543.443239] infiniband eno2_rxe: added eno2
[29543.447436] eno2 speed is unknown, defaulting to 1000
[29543.454519] eno1 speed is unknown, defaulting to 1000
[29543.459609] eno2 speed is unknown, defaulting to 1000
[29543.467662] infiniband eno3_rxe: set active
[29543.471866] infiniband eno3_rxe: added eno3
[29543.478492] eno1 speed is unknown, defaulting to 1000
[29543.483595] eno2 speed is unknown, defaulting to 1000
[29543.490194] eno4 speed is unknown, defaulting to 1000
[29543.495271] eno4 speed is unknown, defaulting to 1000
[29543.500340] eno4 speed is unknown, defaulting to 1000
[29543.506811] infiniband eno4_rxe: set down
[29543.510824] infiniband eno4_rxe: added eno4
[29543.515014] eno4 speed is unknown, defaulting to 1000
[29543.522209] eno1 speed is unknown, defaulting to 1000
[29543.527301] eno2 speed is unknown, defaulting to 1000
[29543.532395] eno4 speed is unknown, defaulting to 1000
[29543.549896] loop0: detected capacity change from 0 to 2097152
[29543.565549] nvmet: adding nsid 1 to subsystem blktests-subsystem-1
[29543.581003] nvmet_rdma: enabling port 0 (10.16.219.1:4420)
[29543.610378] nvmet: creating nvm controller 1 for subsystem
blktests-subsystem-1 for NQN
nqn.2014-08.org.nvmexpress:uuid:4c4c4544-0033-3110-8030-b5c04f505932.
[29543.624775] nvme nvme0: creating 48 I/O queues.
[29543.671829] nvme nvme0: mapped 48/0/0 default/read/poll queues.
[29543.682993] nvme nvme0: new ctrl: NQN "blktests-subsystem-1", addr
10.16.219.1:4420
[29548.707044] nvme nvme0: using deprecated NVME_IOCTL_IO_CMD ioctl on
the char device!
[29578.830401] nvme nvme0: I/O 94 QID 35 timeout
[29578.834769] nvme nvme0: starting error recovery
[29578.848426] nvme nvme0: Removing ctrl: NQN "blktests-subsystem-1"
[29578.883367] nvme nvme0: Property Set error: 880, offset 0x14
[29587.534052] nvmet: ctrl 1 keep-alive timer (5 seconds) expired!
[29587.539984] nvmet: ctrl 1 fatal error occurred!
[29626.587132] eno1 speed is unknown, defaulting to 1000
[29626.592232] eno2 speed is unknown, defaulting to 1000
[29626.597333] eno4 speed is unknown, defaulting to 1000
[29626.615065] rdma_rxe: rxe-ah pool destroyed with unfree'd elem
[29626.625808] rdma_rxe: unloaded
[29639.841924] run blktests nvme/014 at 2021-12-03 20:39:37
[29640.065389] SoftiWARP attached
[29640.072754] eno1 speed is unknown, defaulting to 1000
[29640.077817] eno1 speed is unknown, defaulting to 1000
[29640.082892] eno1 speed is unknown, defaulting to 1000
[29640.089949] eno1 speed is unknown, defaulting to 1000
[29640.096517] eno2 speed is unknown, defaulting to 1000
[29640.101579] eno2 speed is unknown, defaulting to 1000
[29640.106658] eno2 speed is unknown, defaulting to 1000
[29640.113763] eno1 speed is unknown, defaulting to 1000
[29640.118865] eno2 speed is unknown, defaulting to 1000
[29640.127341] eno1 speed is unknown, defaulting to 1000
[29640.132427] eno2 speed is unknown, defaulting to 1000
[29640.138937] eno4 speed is unknown, defaulting to 1000
[29640.143992] eno4 speed is unknown, defaulting to 1000
[29640.149070] eno4 speed is unknown, defaulting to 1000
[29640.156219] eno1 speed is unknown, defaulting to 1000
[29640.161330] eno2 speed is unknown, defaulting to 1000
[29640.166422] eno4 speed is unknown, defaulting to 1000
[29640.183772] loop0: detected capacity change from 0 to 2097152
[29640.204078] nvmet: adding nsid 1 to subsystem blktests-subsystem-1
[29640.221508] iwpm_register_pid: Unable to send a nlmsg (client = 2)
[29640.227720] nvmet_rdma: enabling port 0 (10.16.219.1:4420)
[29640.239086] nvmet: creating nvm controller 1 for subsystem
blktests-subsystem-1 for NQN
nqn.2014-08.org.nvmexpress:uuid:4c4c4544-0033-3110-8030-b5c04f505932.
[29640.253493] nvme nvme0: creating 48 I/O queues.
[29640.304443] nvme nvme0: mapped 48/0/0 default/read/poll queues.
[29640.315630] nvme nvme0: new ctrl: NQN "blktests-subsystem-1", addr
10.16.219.1:4420
[29645.276648] nvme nvme0: using deprecated NVME_IOCTL_IO_CMD ioctl on
the char device!
[29675.595074] nvme nvme0: I/O 83 QID 17 timeout
[29675.599446] nvme nvme0: starting error recovery
[29675.616070] nvme nvme0: Removing ctrl: NQN "blktests-subsystem-1"
[29675.669023] nvme nvme0: Property Set error: 880, offset 0x14
[29683.786764] nvmet: ctrl 1 keep-alive timer (5 seconds) expired!
[29683.792690] nvmet: ctrl 1 fatal error occurred!
[29760.282291] eno1 speed is unknown, defaulting to 1000
[29760.287387] eno2 speed is unknown, defaulting to 1000
[29760.292481] eno4 speed is unknown, defaulting to 1000
[29760.306468] SoftiWARP detached


-- 
Best Regards,
  Yi Zhang




More information about the Linux-nvme mailing list