Warning: Permanently added '10.128.0.116' (ED25519) to the list of known hosts. 2023/09/30 15:20:43 ignoring optional flag "sandboxArg"="0" 2023/09/30 15:20:43 parsed 1 programs 2023/09/30 15:20:45 executed programs: 0 [ 81.540923][ T5377] Adding 124996k swap on ./swap-file. Priority:0 extents:1 across:124996k [ 81.596008][ T5035] Bluetooth: hci0: unexpected cc 0x0c03 length: 249 > 1 [ 81.604565][ T5035] Bluetooth: hci0: unexpected cc 0x1003 length: 249 > 9 [ 81.612393][ T5035] Bluetooth: hci0: unexpected cc 0x1001 length: 249 > 9 [ 81.620811][ T5035] Bluetooth: hci0: unexpected cc 0x0c23 length: 249 > 4 [ 81.630018][ T5035] Bluetooth: hci0: unexpected cc 0x0c25 length: 249 > 3 [ 81.637848][ T5035] Bluetooth: hci0: unexpected cc 0x0c38 length: 249 > 2 [ 81.752368][ T5384] chnl_net:caif_netlink_parms(): no params data found [ 81.803988][ T5384] bridge0: port 1(bridge_slave_0) entered blocking state [ 81.811640][ T5384] bridge0: port 1(bridge_slave_0) entered disabled state [ 81.819172][ T5384] bridge_slave_0: entered allmulticast mode [ 81.826242][ T5384] bridge_slave_0: entered promiscuous mode [ 81.834413][ T5384] bridge0: port 2(bridge_slave_1) entered blocking state [ 81.841773][ T5384] bridge0: port 2(bridge_slave_1) entered disabled state [ 81.849248][ T5384] bridge_slave_1: entered allmulticast mode [ 81.856327][ T5384] bridge_slave_1: entered promiscuous mode [ 81.880999][ T5384] bond0: (slave bond_slave_0): Enslaving as an active interface with an up link [ 81.892288][ T778] cfg80211: failed to load regulatory.db [ 81.895943][ T5384] bond0: (slave bond_slave_1): Enslaving as an active interface with an up link [ 81.935305][ T5384] team0: Port device team_slave_0 added [ 81.944059][ T5384] team0: Port device team_slave_1 added [ 81.967069][ T5384] batman_adv: batadv0: Adding interface: batadv_slave_0 [ 81.974182][ T5384] batman_adv: batadv0: The MTU of interface batadv_slave_0 is too small (1500) to handle the transport of batman-adv packets. Packets going over this interface will be fragmented on layer2 which could impact the performance. Setting the MTU to 1560 would solve the problem. [ 82.000863][ T5384] batman_adv: batadv0: Not using interface batadv_slave_0 (retrying later): interface not active [ 82.014137][ T5384] batman_adv: batadv0: Adding interface: batadv_slave_1 [ 82.021317][ T5384] batman_adv: batadv0: The MTU of interface batadv_slave_1 is too small (1500) to handle the transport of batman-adv packets. Packets going over this interface will be fragmented on layer2 which could impact the performance. Setting the MTU to 1560 would solve the problem. [ 82.047965][ T5384] batman_adv: batadv0: Not using interface batadv_slave_1 (retrying later): interface not active [ 82.083249][ T5384] hsr_slave_0: entered promiscuous mode [ 82.089814][ T5384] hsr_slave_1: entered promiscuous mode [ 82.835756][ T5384] netdevsim netdevsim0 netdevsim0: renamed from eth0 [ 82.854194][ T5384] netdevsim netdevsim0 netdevsim1: renamed from eth1 [ 82.865792][ T5384] netdevsim netdevsim0 netdevsim2: renamed from eth2 [ 82.879102][ T5384] netdevsim netdevsim0 netdevsim3: renamed from eth3 [ 82.975707][ T5384] 8021q: adding VLAN 0 to HW filter on device bond0 [ 83.001711][ T5384] 8021q: adding VLAN 0 to HW filter on device team0 [ 83.016661][ T5044] bridge0: port 1(bridge_slave_0) entered blocking state [ 83.023920][ T5044] bridge0: port 1(bridge_slave_0) entered forwarding state [ 83.044643][ T5044] bridge0: port 2(bridge_slave_1) entered blocking state [ 83.051978][ T5044] bridge0: port 2(bridge_slave_1) entered forwarding state [ 83.265933][ T5384] 8021q: adding VLAN 0 to HW filter on device batadv0 [ 83.326679][ T5384] veth0_vlan: entered promiscuous mode [ 83.342966][ T5384] veth1_vlan: entered promiscuous mode [ 83.386589][ T5384] veth0_macvtap: entered promiscuous mode [ 83.402368][ T5384] veth1_macvtap: entered promiscuous mode [ 83.427026][ T5384] batman_adv: batadv0: Interface activated: batadv_slave_0 [ 83.446632][ T5384] batman_adv: batadv0: Interface activated: batadv_slave_1 [ 83.462415][ T5384] netdevsim netdevsim0 netdevsim0: set [1, 0] type 2 family 0 port 6081 - 0 [ 83.472346][ T5384] netdevsim netdevsim0 netdevsim1: set [1, 0] type 2 family 0 port 6081 - 0 [ 83.483544][ T5384] netdevsim netdevsim0 netdevsim2: set [1, 0] type 2 family 0 port 6081 - 0 [ 83.492794][ T5384] netdevsim netdevsim0 netdevsim3: set [1, 0] type 2 family 0 port 6081 - 0 [ 83.562264][ T23] wlan0: Created IBSS using preconfigured BSSID 50:50:50:50:50:50 [ 83.581377][ T23] wlan0: Creating new IBSS network, BSSID 50:50:50:50:50:50 [ 83.613464][ T4816] wlan1: Created IBSS using preconfigured BSSID 50:50:50:50:50:50 [ 83.622205][ T4816] wlan1: Creating new IBSS network, BSSID 50:50:50:50:50:50 [ 83.719047][ T5035] Bluetooth: hci0: command 0x0409 tx timeout [ 84.115936][ T5450] loop0: detected capacity change from 0 to 32768 [ 84.146616][ T5450] gfs2: fsid=„½%b­i’~N-SS“: Trying to join cluster "lock_nolock", "„½%b­i’~N-SS“" [ 84.158082][ T5450] gfs2: fsid=„½%b­i’~N-SS“: Now mounting FS (format 1801)... [ 84.182050][ T5450] gfs2: fsid=„½%b­i’~N-SS“.0: journal 0 mapped with 18 extents in 0ms [ 84.194341][ T4816] gfs2: fsid=„½%b­i’~N-SS“.0: jid=0, already locked for use [ 84.204180][ T4816] gfs2: fsid=„½%b­i’~N-SS“.0: jid=0: Looking at journal... [ 84.280911][ T4816] gfs2: fsid=„½%b­i’~N-SS“.0: jid=0: Journal head lookup took 76ms [ 84.292860][ T4816] gfs2: fsid=„½%b­i’~N-SS“.0: jid=0: Done [ 84.301995][ T5450] gfs2: fsid=„½%b­i’~N-SS“.0: first mount done, others may mount [ 84.944770][ T5482] loop0: detected capacity change from 0 to 32768 [ 84.959602][ T5482] gfs2: fsid=„½%b­i’~N-SS“: Trying to join cluster "lock_nolock", "„½%b­i’~N-SS“" [ 84.969511][ T5482] gfs2: fsid=„½%b­i’~N-SS“: Now mounting FS (format 1801)... [ 84.982860][ T5482] gfs2: fsid=„½%b­i’~N-SS“.0: journal 0 mapped with 18 extents in 0ms [ 84.994732][ T4816] gfs2: fsid=„½%b­i’~N-SS“.0: jid=0, already locked for use [ 85.002988][ T4816] gfs2: fsid=„½%b­i’~N-SS“.0: jid=0: Looking at journal... [ 85.078591][ T4816] gfs2: fsid=„½%b­i’~N-SS“.0: jid=0: Journal head lookup took 75ms [ 85.087180][ T4816] gfs2: fsid=„½%b­i’~N-SS“.0: jid=0: Done [ 85.094541][ T5482] gfs2: fsid=„½%b­i’~N-SS“.0: first mount done, others may mount [ 85.724508][ T5507] loop0: detected capacity change from 0 to 32768 [ 85.741429][ T5507] gfs2: fsid=„½%b­i’~N-SS“: Trying to join cluster "lock_nolock", "„½%b­i’~N-SS“" [ 85.755020][ T5507] gfs2: fsid=„½%b­i’~N-SS“: Now mounting FS (format 1801)... [ 85.768581][ T5507] gfs2: fsid=„½%b­i’~N-SS“.0: journal 0 mapped with 18 extents in 0ms [ 85.780337][ T5045] gfs2: fsid=„½%b­i’~N-SS“.0: jid=0, already locked for use [ 85.788359][ T5045] gfs2: fsid=„½%b­i’~N-SS“.0: jid=0: Looking at journal... [ 85.807609][ T5035] Bluetooth: hci0: command 0x041b tx timeout [ 85.865870][ T5045] gfs2: fsid=„½%b­i’~N-SS“.0: jid=0: Journal head lookup took 77ms [ 85.878126][ T5045] gfs2: fsid=„½%b­i’~N-SS“.0: jid=0: Done [ 85.884192][ T5507] gfs2: fsid=„½%b­i’~N-SS“.0: first mount done, others may mount [ 86.510759][ T5540] loop0: detected capacity change from 0 to 32768 [ 86.521846][ T5540] gfs2: fsid=„½%b­i’~N-SS“: Trying to join cluster "lock_nolock", "„½%b­i’~N-SS“" [ 86.533531][ T5540] gfs2: fsid=„½%b­i’~N-SS“: Now mounting FS (format 1801)... [ 86.546648][ T5540] gfs2: fsid=„½%b­i’~N-SS“.0: journal 0 mapped with 18 extents in 0ms [ 86.558638][ T8] gfs2: fsid=„½%b­i’~N-SS“.0: jid=0, already locked for use [ 86.566289][ T8] gfs2: fsid=„½%b­i’~N-SS“.0: jid=0: Looking at journal... 2023/09/30 15:20:50 executed programs: 4 [ 86.649350][ T8] gfs2: fsid=„½%b­i’~N-SS“.0: jid=0: Journal head lookup took 83ms [ 86.659045][ T8] gfs2: fsid=„½%b­i’~N-SS“.0: jid=0: Done [ 86.665288][ T5540] gfs2: fsid=„½%b­i’~N-SS“.0: first mount done, others may mount [ 87.323039][ T5568] loop0: detected capacity change from 0 to 32768 [ 87.339712][ T5568] gfs2: fsid=„½%b­i’~N-SS“: Trying to join cluster "lock_nolock", "„½%b­i’~N-SS“" [ 87.350755][ T5568] gfs2: fsid=„½%b­i’~N-SS“: Now mounting FS (format 1801)... [ 87.366163][ T5568] gfs2: fsid=„½%b­i’~N-SS“.0: journal 0 mapped with 18 extents in 0ms [ 87.378212][ T4816] gfs2: fsid=„½%b­i’~N-SS“.0: jid=0, already locked for use [ 87.385928][ T4816] gfs2: fsid=„½%b­i’~N-SS“.0: jid=0: Looking at journal... [ 87.457310][ T4816] gfs2: fsid=„½%b­i’~N-SS“.0: jid=0: Journal head lookup took 71ms [ 87.465742][ T4816] gfs2: fsid=„½%b­i’~N-SS“.0: jid=0: Done [ 87.475567][ T5568] gfs2: fsid=„½%b­i’~N-SS“.0: first mount done, others may mount [ 87.878851][ T5035] Bluetooth: hci0: command 0x040f tx timeout [ 88.144472][ T5601] loop0: detected capacity change from 0 to 32768 [ 88.156380][ T5601] gfs2: fsid=„½%b­i’~N-SS“: Trying to join cluster "lock_nolock", "„½%b­i’~N-SS“" [ 88.166392][ T5601] gfs2: fsid=„½%b­i’~N-SS“: Now mounting FS (format 1801)... [ 88.180547][ T5601] gfs2: fsid=„½%b­i’~N-SS“.0: journal 0 mapped with 18 extents in 0ms [ 88.193033][ T5045] gfs2: fsid=„½%b­i’~N-SS“.0: jid=0, already locked for use [ 88.201246][ T5045] gfs2: fsid=„½%b­i’~N-SS“.0: jid=0: Looking at journal... [ 88.264623][ T5045] gfs2: fsid=„½%b­i’~N-SS“.0: jid=0: Journal head lookup took 63ms [ 88.274263][ T5045] gfs2: fsid=„½%b­i’~N-SS“.0: jid=0: Done [ 88.282925][ T5601] gfs2: fsid=„½%b­i’~N-SS“.0: first mount done, others may mount [ 88.969136][ T5633] loop0: detected capacity change from 0 to 32768 [ 88.980147][ T5633] gfs2: fsid=„½%b­i’~N-SS“: Trying to join cluster "lock_nolock", "„½%b­i’~N-SS“" [ 88.990912][ T5633] gfs2: fsid=„½%b­i’~N-SS“: Now mounting FS (format 1801)... [ 89.003462][ T5633] gfs2: fsid=„½%b­i’~N-SS“.0: journal 0 mapped with 18 extents in 0ms [ 89.014640][ T5045] gfs2: fsid=„½%b­i’~N-SS“.0: jid=0, already locked for use [ 89.023294][ T5045] gfs2: fsid=„½%b­i’~N-SS“.0: jid=0: Looking at journal... [ 89.095248][ T5045] gfs2: fsid=„½%b­i’~N-SS“.0: jid=0: Journal head lookup took 71ms [ 89.103653][ T5045] gfs2: fsid=„½%b­i’~N-SS“.0: jid=0: Done [ 89.110955][ T5633] gfs2: fsid=„½%b­i’~N-SS“.0: first mount done, others may mount [ 89.733134][ T5662] loop0: detected capacity change from 0 to 32768 [ 89.746834][ T5662] gfs2: fsid=„½%b­i’~N-SS“: Trying to join cluster "lock_nolock", "„½%b­i’~N-SS“" [ 89.760171][ T5662] gfs2: fsid=„½%b­i’~N-SS“: Now mounting FS (format 1801)... [ 89.772973][ T5662] gfs2: fsid=„½%b­i’~N-SS“.0: journal 0 mapped with 18 extents in 0ms [ 89.784917][ T23] gfs2: fsid=„½%b­i’~N-SS“.0: jid=0, already locked for use [ 89.792787][ T23] gfs2: fsid=„½%b­i’~N-SS“.0: jid=0: Looking at journal... [ 89.858522][ T23] gfs2: fsid=„½%b­i’~N-SS“.0: jid=0: Journal head lookup took 65ms [ 89.871179][ T23] gfs2: fsid=„½%b­i’~N-SS“.0: jid=0: Done [ 89.877417][ T5662] gfs2: fsid=„½%b­i’~N-SS“.0: first mount done, others may mount [ 89.967631][ T5035] Bluetooth: hci0: command 0x0419 tx timeout [ 90.573988][ T5693] loop0: detected capacity change from 0 to 32768 [ 90.586997][ T5693] gfs2: fsid=„½%b­i’~N-SS“: Trying to join cluster "lock_nolock", "„½%b­i’~N-SS“" [ 90.599251][ T5693] gfs2: fsid=„½%b­i’~N-SS“: Now mounting FS (format 1801)... [ 90.611974][ T5693] gfs2: fsid=„½%b­i’~N-SS“.0: journal 0 mapped with 18 extents in 0ms [ 90.624206][ T5045] gfs2: fsid=„½%b­i’~N-SS“.0: jid=0, already locked for use [ 90.632718][ T5045] gfs2: fsid=„½%b­i’~N-SS“.0: jid=0: Looking at journal... [ 90.701422][ T5045] gfs2: fsid=„½%b­i’~N-SS“.0: jid=0: Journal head lookup took 68ms [ 90.711018][ T5045] gfs2: fsid=„½%b­i’~N-SS“.0: jid=0: Done [ 90.717078][ T5693] gfs2: fsid=„½%b­i’~N-SS“.0: first mount done, others may mount [ 91.222497][ T5721] loop0: detected capacity change from 0 to 32768 [ 91.236318][ T5721] gfs2: fsid=„½%b­i’~N-SS“: Trying to join cluster "lock_nolock", "„½%b­i’~N-SS“" [ 91.246288][ T5721] gfs2: fsid=„½%b­i’~N-SS“: Now mounting FS (format 1801)... [ 91.259187][ T5721] gfs2: fsid=„½%b­i’~N-SS“.0: journal 0 mapped with 18 extents in 0ms [ 91.270327][ T23] gfs2: fsid=„½%b­i’~N-SS“.0: jid=0, already locked for use [ 91.280202][ T23] gfs2: fsid=„½%b­i’~N-SS“.0: jid=0: Looking at journal... [ 91.345659][ T23] gfs2: fsid=„½%b­i’~N-SS“.0: jid=0: Journal head lookup took 65ms [ 91.356627][ T23] gfs2: fsid=„½%b­i’~N-SS“.0: jid=0: Done [ 91.364045][ T5721] gfs2: fsid=„½%b­i’~N-SS“.0: first mount done, others may mount [ 92.056199][ T5740] loop0: detected capacity change from 0 to 32768 [ 92.070366][ T5740] gfs2: fsid=„½%b­i’~N-SS“: Trying to join cluster "lock_nolock", "„½%b­i’~N-SS“" [ 92.080894][ T5740] gfs2: fsid=„½%b­i’~N-SS“: Now mounting FS (format 1801)... [ 92.093634][ T5740] gfs2: fsid=„½%b­i’~N-SS“.0: journal 0 mapped with 18 extents in 0ms [ 92.103973][ T23] gfs2: fsid=„½%b­i’~N-SS“.0: jid=0, already locked for use [ 92.111603][ T23] gfs2: fsid=„½%b­i’~N-SS“.0: jid=0: Looking at journal... 2023/09/30 15:20:55 executed programs: 11 [ 92.178637][ T23] gfs2: fsid=„½%b­i’~N-SS“.0: jid=0: Journal head lookup took 67ms [ 92.189948][ T23] gfs2: fsid=„½%b­i’~N-SS“.0: jid=0: Done [ 92.196480][ T5740] gfs2: fsid=„½%b­i’~N-SS“.0: first mount done, others may mount [ 92.799891][ T5771] loop0: detected capacity change from 0 to 32768 [ 92.809814][ T5771] gfs2: fsid=„½%b­i’~N-SS“: Trying to join cluster "lock_nolock", "„½%b­i’~N-SS“" [ 92.820110][ T5771] gfs2: fsid=„½%b­i’~N-SS“: Now mounting FS (format 1801)... [ 92.832608][ T5771] gfs2: fsid=„½%b­i’~N-SS“.0: journal 0 mapped with 18 extents in 0ms [ 92.842573][ T23] gfs2: fsid=„½%b­i’~N-SS“.0: jid=0, already locked for use [ 92.850799][ T23] gfs2: fsid=„½%b­i’~N-SS“.0: jid=0: Looking at journal... [ 92.889011][ T23] gfs2: fsid=„½%b­i’~N-SS“.0: jid=0: Journal head lookup took 38ms [ 92.897460][ T23] gfs2: fsid=„½%b­i’~N-SS“.0: jid=0: Done [ 92.903403][ T5771] gfs2: fsid=„½%b­i’~N-SS“.0: first mount done, others may mount [ 93.279867][ T5787] loop0: detected capacity change from 0 to 32768 [ 93.289807][ T5787] gfs2: fsid=„½%b­i’~N-SS“: Trying to join cluster "lock_nolock", "„½%b­i’~N-SS“" [ 93.299431][ T5787] gfs2: fsid=„½%b­i’~N-SS“: Now mounting FS (format 1801)... [ 93.311348][ T5787] gfs2: fsid=„½%b­i’~N-SS“.0: journal 0 mapped with 18 extents in 0ms [ 93.320863][ T4816] gfs2: fsid=„½%b­i’~N-SS“.0: jid=0, already locked for use [ 93.329460][ T4816] gfs2: fsid=„½%b­i’~N-SS“.0: jid=0: Looking at journal... [ 93.368589][ T4816] gfs2: fsid=„½%b­i’~N-SS“.0: jid=0: Journal head lookup took 39ms [ 93.379098][ T4816] gfs2: fsid=„½%b­i’~N-SS“.0: jid=0: Done [ 93.385097][ T5787] gfs2: fsid=„½%b­i’~N-SS“.0: first mount done, others may mount [ 93.768120][ T5791] loop0: detected capacity change from 0 to 32768 [ 93.779091][ T5791] gfs2: fsid=„½%b­i’~N-SS“: Trying to join cluster "lock_nolock", "„½%b­i’~N-SS“" [ 93.790634][ T5791] gfs2: fsid=„½%b­i’~N-SS“: Now mounting FS (format 1801)... [ 93.803159][ T5791] gfs2: fsid=„½%b­i’~N-SS“.0: journal 0 mapped with 18 extents in 0ms [ 93.813870][ T5045] gfs2: fsid=„½%b­i’~N-SS“.0: jid=0, already locked for use [ 93.822071][ T5045] gfs2: fsid=„½%b­i’~N-SS“.0: jid=0: Looking at journal... [ 93.861922][ T5045] gfs2: fsid=„½%b­i’~N-SS“.0: jid=0: Journal head lookup took 39ms [ 93.870482][ T5045] gfs2: fsid=„½%b­i’~N-SS“.0: jid=0: Done [ 93.877589][ T5791] gfs2: fsid=„½%b­i’~N-SS“.0: first mount done, others may mount [ 94.251422][ T5795] loop0: detected capacity change from 0 to 32768 [ 94.260751][ T5795] gfs2: fsid=„½%b­i’~N-SS“: Trying to join cluster "lock_nolock", "„½%b­i’~N-SS“" [ 94.272228][ T5795] gfs2: fsid=„½%b­i’~N-SS“: Now mounting FS (format 1801)... [ 94.288635][ T5795] gfs2: fsid=„½%b­i’~N-SS“.0: journal 0 mapped with 18 extents in 0ms [ 94.298748][ T23] gfs2: fsid=„½%b­i’~N-SS“.0: jid=0, already locked for use [ 94.306501][ T23] gfs2: fsid=„½%b­i’~N-SS“.0: jid=0: Looking at journal... [ 94.344341][ T23] gfs2: fsid=„½%b­i’~N-SS“.0: jid=0: Journal head lookup took 37ms [ 94.353569][ T23] gfs2: fsid=„½%b­i’~N-SS“.0: jid=0: Done [ 94.359756][ T5795] gfs2: fsid=„½%b­i’~N-SS“.0: first mount done, others may mount [ 94.740278][ T5799] loop0: detected capacity change from 0 to 32768 [ 94.749707][ T5799] gfs2: fsid=„½%b­i’~N-SS“: Trying to join cluster "lock_nolock", "„½%b­i’~N-SS“" [ 94.760879][ T5799] gfs2: fsid=„½%b­i’~N-SS“: Now mounting FS (format 1801)... [ 94.773443][ T5799] gfs2: fsid=„½%b­i’~N-SS“.0: journal 0 mapped with 18 extents in 0ms [ 94.783360][ T5045] gfs2: fsid=„½%b­i’~N-SS“.0: jid=0, already locked for use [ 94.791098][ T5045] gfs2: fsid=„½%b­i’~N-SS“.0: jid=0: Looking at journal... [ 94.831510][ T5045] gfs2: fsid=„½%b­i’~N-SS“.0: jid=0: Journal head lookup took 40ms [ 94.839768][ T5045] gfs2: fsid=„½%b­i’~N-SS“.0: jid=0: Done [ 94.848743][ T5799] gfs2: fsid=„½%b­i’~N-SS“.0: first mount done, others may mount [ 95.242014][ T5803] loop0: detected capacity change from 0 to 32768 [ 95.251337][ T5803] gfs2: fsid=„½%b­i’~N-SS“: Trying to join cluster "lock_nolock", "„½%b­i’~N-SS“" [ 95.263331][ T5803] gfs2: fsid=„½%b­i’~N-SS“: Now mounting FS (format 1801)... [ 95.275870][ T5803] gfs2: fsid=„½%b­i’~N-SS“.0: journal 0 mapped with 18 extents in 0ms [ 95.286328][ T23] gfs2: fsid=„½%b­i’~N-SS“.0: jid=0, already locked for use [ 95.294117][ T23] gfs2: fsid=„½%b­i’~N-SS“.0: jid=0: Looking at journal... [ 95.336185][ T23] gfs2: fsid=„½%b­i’~N-SS“.0: jid=0: Journal head lookup took 42ms [ 95.345566][ T23] gfs2: fsid=„½%b­i’~N-SS“.0: jid=0: Done [ 95.351624][ T5803] gfs2: fsid=„½%b­i’~N-SS“.0: first mount done, others may mount [ 95.417553][ C1] ================================================================== [ 95.425926][ C1] BUG: KASAN: slab-use-after-free in gfs2_qd_dealloc+0x85/0xf0 [ 95.433680][ C1] Read of size 4 at addr ffff88807bdc8a78 by task ksoftirqd/1/22 [ 95.441505][ C1] [ 95.443847][ C1] CPU: 1 PID: 22 Comm: ksoftirqd/1 Not tainted 6.6.0-rc3-syzkaller-dirty #0 [ 95.452709][ C1] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 09/06/2023 [ 95.462865][ C1] Call Trace: [ 95.466246][ C1] [ 95.469183][ C1] dump_stack_lvl+0x1e7/0x2d0 [ 95.473952][ C1] ? nf_tcp_handle_invalid+0x650/0x650 [ 95.479499][ C1] ? panic+0x770/0x770 [ 95.483739][ C1] ? _printk+0xd5/0x120 [ 95.487893][ C1] print_report+0x163/0x540 [ 95.492403][ C1] ? lockdep_hardirqs_on_prepare+0x43c/0x7a0 [ 95.498377][ C1] ? __virt_addr_valid+0x22f/0x2e0 [ 95.503511][ C1] ? __phys_addr+0xba/0x170 [ 95.508009][ C1] ? gfs2_qd_dealloc+0x85/0xf0 [ 95.512858][ C1] kasan_report+0x175/0x1b0 [ 95.517455][ C1] ? gfs2_qd_dealloc+0x85/0xf0 [ 95.522219][ C1] kasan_check_range+0x27e/0x290 [ 95.527330][ C1] gfs2_qd_dealloc+0x85/0xf0 [ 95.531921][ C1] ? gfs2_qd_dispose+0x600/0x600 [ 95.536873][ C1] ? rcu_core+0xa61/0x1790 [ 95.541278][ C1] rcu_core+0xacf/0x1790 [ 95.545517][ C1] ? rcu_cpu_kthread_park+0x90/0x90 [ 95.550707][ C1] ? kvm_sched_clock_read+0x11/0x20 [ 95.555899][ C1] ? sched_clock+0x4a/0x60 [ 95.560828][ C1] ? sched_clock_cpu+0x76/0x490 [ 95.565691][ C1] ? lockdep_hardirqs_on_prepare+0x43c/0x7a0 [ 95.571833][ C1] ? print_irqtrace_events+0x220/0x220 [ 95.577398][ C1] __do_softirq+0x2ab/0x908 [ 95.581928][ C1] ? run_ksoftirqd+0xc5/0x120 [ 95.586608][ C1] ? __lock_text_end+0xc/0xc [ 95.591208][ C1] run_ksoftirqd+0xc5/0x120 [ 95.595899][ C1] ? ksoftirqd_should_run+0x20/0x20 [ 95.601101][ C1] ? ksoftirqd_should_run+0x20/0x20 [ 95.606304][ C1] smpboot_thread_fn+0x530/0x9f0 [ 95.611242][ C1] ? smpboot_thread_fn+0x4e/0x9f0 [ 95.616273][ C1] kthread+0x2d3/0x370 [ 95.620417][ C1] ? smpboot_unregister_percpu_thread+0x130/0x130 [ 95.626922][ C1] ? kthread_blkcg+0xd0/0xd0 [ 95.631859][ C1] ret_from_fork+0x48/0x80 [ 95.636324][ C1] ? kthread_blkcg+0xd0/0xd0 [ 95.640917][ C1] ret_from_fork_asm+0x11/0x20 [ 95.645704][ C1] [ 95.648715][ C1] [ 95.651034][ C1] Allocated by task 5803: [ 95.655532][ C1] kasan_set_track+0x4f/0x70 [ 95.660217][ C1] __kasan_kmalloc+0x98/0xb0 [ 95.664799][ C1] gfs2_fill_super+0x136/0x26c0 [ 95.669641][ C1] get_tree_bdev+0x416/0x5b0 [ 95.674229][ C1] gfs2_get_tree+0x54/0x210 [ 95.678758][ C1] vfs_get_tree+0x8c/0x280 [ 95.683167][ C1] do_new_mount+0x28f/0xae0 [ 95.687701][ C1] __se_sys_mount+0x2d9/0x3c0 [ 95.692369][ C1] do_syscall_64+0x41/0xc0 [ 95.696779][ C1] entry_SYSCALL_64_after_hwframe+0x63/0xcd [ 95.702749][ C1] [ 95.705057][ C1] Freed by task 5384: [ 95.709021][ C1] kasan_set_track+0x4f/0x70 [ 95.713605][ C1] kasan_save_free_info+0x28/0x40 [ 95.718649][ C1] ____kasan_slab_free+0xd6/0x120 [ 95.723704][ C1] __kmem_cache_free+0x25f/0x3b0 [ 95.728673][ C1] generic_shutdown_super+0x13a/0x2c0 [ 95.734124][ C1] kill_block_super+0x41/0x70 [ 95.738798][ C1] deactivate_locked_super+0xa4/0x110 [ 95.744161][ C1] cleanup_mnt+0x426/0x4c0 [ 95.748572][ C1] task_work_run+0x24a/0x300 [ 95.753157][ C1] exit_to_user_mode_loop+0xde/0x100 [ 95.758528][ C1] exit_to_user_mode_prepare+0xb1/0x140 [ 95.764080][ C1] syscall_exit_to_user_mode+0x64/0x280 [ 95.769635][ C1] do_syscall_64+0x4d/0xc0 [ 95.774129][ C1] entry_SYSCALL_64_after_hwframe+0x63/0xcd [ 95.780015][ C1] [ 95.782417][ C1] The buggy address belongs to the object at ffff88807bdc8000 [ 95.782417][ C1] which belongs to the cache kmalloc-8k of size 8192 [ 95.796985][ C1] The buggy address is located 2680 bytes inside of [ 95.796985][ C1] freed 8192-byte region [ffff88807bdc8000, ffff88807bdca000) [ 95.811142][ C1] [ 95.813461][ C1] The buggy address belongs to the physical page: [ 95.820227][ C1] page:ffffea0001ef7200 refcount:1 mapcount:0 mapping:0000000000000000 index:0x0 pfn:0x7bdc8 [ 95.830543][ C1] head:ffffea0001ef7200 order:3 entire_mapcount:0 nr_pages_mapped:0 pincount:0 [ 95.839563][ C1] ksm flags: 0xfff00000000840(slab|head|node=0|zone=1|lastcpupid=0x7ff) [ 95.848142][ C1] page_type: 0xffffffff() [ 95.852574][ C1] raw: 00fff00000000840 ffff888012842280 ffffea000061c600 dead000000000003 [ 95.861275][ C1] raw: 0000000000000000 0000000080020002 00000001ffffffff 0000000000000000 [ 95.870127][ C1] page dumped because: kasan: bad access detected [ 95.876535][ C1] page_owner tracks the page as allocated [ 95.882330][ C1] page last allocated via order 3, migratetype Unmovable, gfp_mask 0xd2040(__GFP_IO|__GFP_NOWARN|__GFP_NORETRY|__GFP_COMP|__GFP_NOMEMALLOC), pid 4864, tgid 4864 (dhcpcd-run-hook), ts 41488886773, free_ts 41477582693 [ 95.903634][ C1] post_alloc_hook+0x1e6/0x210 [ 95.908593][ C1] get_page_from_freelist+0x31db/0x3360 [ 95.914508][ C1] __alloc_pages+0x255/0x670 [ 95.919394][ C1] alloc_slab_page+0x6a/0x160 [ 95.924116][ C1] new_slab+0x84/0x2f0 [ 95.928530][ C1] ___slab_alloc+0xc85/0x1310 [ 95.933223][ C1] __kmem_cache_alloc_node+0x1af/0x270 [ 95.938963][ C1] kmalloc_trace+0x2a/0xe0 [ 95.943476][ C1] tomoyo_init_log+0x11cd/0x2040 [ 95.948415][ C1] tomoyo_supervisor+0x386/0x11f0 [ 95.953432][ C1] tomoyo_env_perm+0x178/0x210 [ 95.958312][ C1] tomoyo_find_next_domain+0x1383/0x1cf0 [ 95.964310][ C1] tomoyo_bprm_check_security+0x114/0x170 [ 95.970408][ C1] security_bprm_check+0x63/0xa0 [ 95.975951][ C1] bprm_execve+0x8c7/0x17c0 [ 95.980478][ C1] do_execveat_common+0x580/0x720 [ 95.985665][ C1] page last free stack trace: [ 95.990322][ C1] free_unref_page_prepare+0x8c3/0x9f0 [ 95.996034][ C1] free_unref_page+0x37/0x3f0 [ 96.000709][ C1] __unfreeze_partials+0x1dc/0x220 [ 96.005927][ C1] put_cpu_partial+0x17b/0x250 [ 96.010854][ C1] __slab_free+0x2b6/0x390 [ 96.015265][ C1] qlist_free_all+0x75/0xe0 [ 96.020017][ C1] kasan_quarantine_reduce+0x14b/0x160 [ 96.025677][ C1] __kasan_slab_alloc+0x23/0x70 [ 96.030520][ C1] slab_post_alloc_hook+0x67/0x3d0 [ 96.035619][ C1] __kmem_cache_alloc_node+0x141/0x270 [ 96.041158][ C1] __kmalloc+0xa8/0x230 [ 96.045309][ C1] tomoyo_realpath_from_path+0xcf/0x5e0 [ 96.050851][ C1] tomoyo_path_perm+0x2b7/0x730 [ 96.055782][ C1] security_inode_getattr+0xd3/0x120 [ 96.061149][ C1] vfs_getattr+0x2a/0x3a0 [ 96.065498][ C1] vfs_fstatat+0xd6/0x190 [ 96.069936][ C1] [ 96.072244][ C1] Memory state around the buggy address: [ 96.078120][ C1] ffff88807bdc8900: fb fb fb fb fb fb fb fb fb fb fb fb fb fb fb fb [ 96.086290][ C1] ffff88807bdc8980: fb fb fb fb fb fb fb fb fb fb fb fb fb fb fb fb [ 96.094429][ C1] >ffff88807bdc8a00: fb fb fb fb fb fb fb fb fb fb fb fb fb fb fb fb [ 96.103287][ C1] ^ [ 96.111338][ C1] ffff88807bdc8a80: fb fb fb fb fb fb fb fb fb fb fb fb fb fb fb fb [ 96.119701][ C1] ffff88807bdc8b00: fb fb fb fb fb fb fb fb fb fb fb fb fb fb fb fb [ 96.127945][ C1] ================================================================== [ 96.136160][ C1] Kernel panic - not syncing: KASAN: panic_on_warn set ... [ 96.144068][ C1] CPU: 1 PID: 22 Comm: ksoftirqd/1 Not tainted 6.6.0-rc3-syzkaller-dirty #0 [ 96.152940][ C1] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 09/06/2023 [ 96.163016][ C1] Call Trace: [ 96.166308][ C1] [ 96.169261][ C1] dump_stack_lvl+0x1e7/0x2d0 [ 96.174058][ C1] ? nf_tcp_handle_invalid+0x650/0x650 [ 96.179730][ C1] ? panic+0x770/0x770 [ 96.183840][ C1] ? vscnprintf+0x5d/0x80 [ 96.188214][ C1] panic+0x30f/0x770 [ 96.192147][ C1] ? check_panic_on_warn+0x21/0xa0 [ 96.197303][ C1] ? __memcpy_flushcache+0x2b0/0x2b0 [ 96.203159][ C1] ? _raw_spin_unlock_irqrestore+0xd8/0x140 [ 96.209098][ C1] ? _raw_spin_unlock_irqrestore+0xdd/0x140 [ 96.215094][ C1] ? _raw_spin_unlock+0x40/0x40 [ 96.220016][ C1] ? print_report+0x4fb/0x540 [ 96.224831][ C1] check_panic_on_warn+0x82/0xa0 [ 96.230672][ C1] ? gfs2_qd_dealloc+0x85/0xf0 [ 96.235493][ C1] end_report+0x6e/0x130 [ 96.239776][ C1] kasan_report+0x186/0x1b0 [ 96.244291][ C1] ? gfs2_qd_dealloc+0x85/0xf0 [ 96.249150][ C1] kasan_check_range+0x27e/0x290 [ 96.254092][ C1] gfs2_qd_dealloc+0x85/0xf0 [ 96.258858][ C1] ? gfs2_qd_dispose+0x600/0x600 [ 96.263882][ C1] ? rcu_core+0xa61/0x1790 [ 96.268471][ C1] rcu_core+0xacf/0x1790 [ 96.272726][ C1] ? rcu_cpu_kthread_park+0x90/0x90 [ 96.278270][ C1] ? kvm_sched_clock_read+0x11/0x20 [ 96.283464][ C1] ? sched_clock+0x4a/0x60 [ 96.287964][ C1] ? sched_clock_cpu+0x76/0x490 [ 96.292843][ C1] ? lockdep_hardirqs_on_prepare+0x43c/0x7a0 [ 96.299097][ C1] ? print_irqtrace_events+0x220/0x220 [ 96.304571][ C1] __do_softirq+0x2ab/0x908 [ 96.309095][ C1] ? run_ksoftirqd+0xc5/0x120 [ 96.313776][ C1] ? __lock_text_end+0xc/0xc [ 96.318389][ C1] run_ksoftirqd+0xc5/0x120 [ 96.322907][ C1] ? ksoftirqd_should_run+0x20/0x20 [ 96.328109][ C1] ? ksoftirqd_should_run+0x20/0x20 [ 96.333304][ C1] smpboot_thread_fn+0x530/0x9f0 [ 96.338331][ C1] ? smpboot_thread_fn+0x4e/0x9f0 [ 96.343444][ C1] kthread+0x2d3/0x370 [ 96.347505][ C1] ? smpboot_unregister_percpu_thread+0x130/0x130 [ 96.354022][ C1] ? kthread_blkcg+0xd0/0xd0 [ 96.358630][ C1] ret_from_fork+0x48/0x80 [ 96.363045][ C1] ? kthread_blkcg+0xd0/0xd0 [ 96.367720][ C1] ret_from_fork_asm+0x11/0x20 [ 96.372488][ C1] [ 96.375820][ C1] Kernel Offset: disabled [ 96.380144][ C1] Rebooting in 86400 seconds..