[36.368837] Initializing watchdogs [36.368955] /dev/watchdog0 [36.411660] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [36.420357] [001/162] (960s left) i915_module_load (load) [36.514645] Starting subtest: load [39.801783] Subtest load: SUCCESS (3.278s) [39.852692] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [39.854605] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true [39.862046] [002/162] (957s left) core_auth (basic-auth) [40.833108] Starting subtest: basic-auth [40.842216] Subtest basic-auth: SUCCESS (0.002s) [41.007440] [003/162] (956s left) core_debugfs (read-all-entries) [41.118681] Starting subtest: read-all-entries [41.231592] Subtest read-all-entries: SUCCESS (0.120s) [41.352166] [004/162] (955s left) core_sysfs (read-all-entries) [41.462464] Starting subtest: read-all-entries [41.474009] Subtest read-all-entries: SUCCESS (0.010s) [41.653052] [005/162] (955s left) fbdev (eof) [41.726562] Starting subtest: eof [41.734405] Subtest eof: SUCCESS (0.000s) [41.865545] [006/162] (955s left) fbdev (info) [41.933950] Starting subtest: info [41.939552] Subtest info: SUCCESS (0.000s) [42.044348] [007/162] (955s left) fbdev (nullptr) [42.125815] Starting subtest: nullptr [42.131611] Subtest nullptr: SUCCESS (0.000s) [42.222433] [008/162] (955s left) fbdev (read) [42.294014] Starting subtest: read [43.258089] Subtest read: SUCCESS (0.961s) [43.366635] [009/162] (954s left) fbdev (write) [43.445477] Starting subtest: write [44.218134] Subtest write: SUCCESS (0.770s) [44.360430] [010/162] (953s left) gem_basic (bad-close) [44.463751] Starting subtest: bad-close [44.474850] Subtest bad-close: SUCCESS (0.000s) [44.631372] [011/162] (952s left) gem_basic (create-close) [44.719234] Starting subtest: create-close [44.730444] Subtest create-close: SUCCESS (0.000s) [44.929307] [012/162] (952s left) gem_basic (create-fd-close) [45.021224] Starting subtest: create-fd-close [45.032539] Subtest create-fd-close: SUCCESS (0.000s) [45.193621] [013/162] (952s left) gem_busy (busy@all-engines) [45.308158] Starting subtest: busy [45.316419] Starting dynamic subtest: all-engines [45.485635] Dynamic subtest all-engines: SUCCESS (0.176s) [45.494461] Subtest busy: SUCCESS (0.177s) [46.957555] [014/162] (950s left) gem_close_race (basic-process) [47.095363] Starting subtest: basic-process [47.167501] Subtest basic-process: SUCCESS (0.074s) [47.403734] [015/162] (950s left) gem_close_race (basic-threads) [47.541548] Starting subtest: basic-threads [50.176587] Subtest basic-threads: SUCCESS (2.635s) [50.415897] [016/162] (947s left) gem_ctx_create (basic) [50.512292] Starting subtest: basic [50.518087] Subtest basic: SUCCESS (0.000s) [50.748189] [017/162] (947s left) gem_ctx_create (basic-files) [50.839051] Starting subtest: basic-files [52.892258] Subtest basic-files: SUCCESS (2.054s) [53.386389] [018/162] (944s left) gem_ctx_exec (basic) [53.495994] Starting subtest: basic [53.518592] Subtest basic: SUCCESS (0.026s) [53.736959] [019/162] (944s left) gem_exec_basic (basic) [53.850616] Starting subtest: basic [53.859303] Starting dynamic subtest: rcs0-smem [53.864920] Dynamic subtest rcs0-smem: SUCCESS (0.007s) [53.889104] Starting dynamic subtest: bcs0-smem [53.896875] Dynamic subtest bcs0-smem: SUCCESS (0.005s) [53.917420] Starting dynamic subtest: vcs0-smem [53.922965] Dynamic subtest vcs0-smem: SUCCESS (0.004s) [53.937527] Starting dynamic subtest: vcs1-smem [53.946098] Dynamic subtest vcs1-smem: SUCCESS (0.005s) [53.962029] Starting dynamic subtest: vecs0-smem [53.967518] Dynamic subtest vecs0-smem: SUCCESS (0.005s) [53.986274] Starting dynamic subtest: ccs0-smem [53.992037] Dynamic subtest ccs0-smem: SUCCESS (0.018s) [53.997908] Subtest basic: SUCCESS (0.047s) [55.974602] [020/162] (942s left) gem_exec_create (basic) [56.072136] Starting subtest: basic [56.081052] Starting dynamic subtest: smem [59.857688] Dynamic subtest smem: SUCCESS (3.777s) [59.866922] Subtest basic: SUCCESS (3.778s) [60.089103] [021/162] (938s left) gem_exec_fence (basic-busy) [60.319896] Starting subtest: basic-busy [60.325795] Starting dynamic subtest: rcs0 [60.429012] Dynamic subtest rcs0: SUCCESS (0.118s) [60.446611] Starting dynamic subtest: bcs0 [60.499076] Dynamic subtest bcs0: SUCCESS (0.067s) [60.518684] Starting dynamic subtest: vcs0 [60.563976] Dynamic subtest vcs0: SUCCESS (0.064s) [60.581241] Starting dynamic subtest: vcs1 [60.645883] Dynamic subtest vcs1: SUCCESS (0.076s) [60.661956] Starting dynamic subtest: vecs0 [60.703902] Dynamic subtest vecs0: SUCCESS (0.063s) [60.719930] Starting dynamic subtest: ccs0 [60.771896] Dynamic subtest ccs0: SUCCESS (0.067s) [60.777700] Subtest basic-busy: SUCCESS (0.462s) [63.026896] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true [63.033981] [022/162] (935s left) gem_exec_fence (basic-wait) [63.284841] Starting subtest: basic-wait [63.290525] Starting dynamic subtest: rcs0 [63.374677] Dynamic subtest rcs0: SUCCESS (0.095s) [63.396042] Starting dynamic subtest: bcs0 [63.445835] Dynamic subtest bcs0: SUCCESS (0.071s) [63.461970] Starting dynamic subtest: vcs0 [63.522196] Dynamic subtest vcs0: SUCCESS (0.075s) [63.539967] Starting dynamic subtest: vcs1 [63.590705] Dynamic subtest vcs1: SUCCESS (0.068s) [63.607285] Starting dynamic subtest: vecs0 [63.659221] Dynamic subtest vecs0: SUCCESS (0.067s) [63.675618] Starting dynamic subtest: ccs0 [63.726831] Dynamic subtest ccs0: SUCCESS (0.067s) [63.732634] Subtest basic-wait: SUCCESS (0.449s) [66.087342] [023/162] (932s left) gem_exec_fence (basic-await) [66.304131] Starting subtest: basic-await [66.309922] Starting dynamic subtest: rcs0 [66.424961] Dynamic subtest rcs0: SUCCESS (0.127s) [66.448734] Starting dynamic subtest: bcs0 [66.547607] Dynamic subtest bcs0: SUCCESS (0.121s) [66.565801] Starting dynamic subtest: vcs0 [66.660404] Dynamic subtest vcs0: SUCCESS (0.112s) [66.678918] Starting dynamic subtest: vcs1 [66.755770] Dynamic subtest vcs1: SUCCESS (0.095s) [66.812993] Starting dynamic subtest: vecs0 [66.916520] Dynamic subtest vecs0: SUCCESS (0.160s) [66.943328] Starting dynamic subtest: ccs0 [67.031564] Dynamic subtest ccs0: SUCCESS (0.112s) [67.038818] Subtest basic-await: SUCCESS (0.737s) [69.033735] [024/162] (929s left) gem_exec_fence (nb-await) [69.290235] Starting subtest: nb-await [69.296012] Starting dynamic subtest: rcs0 [69.372688] Dynamic subtest rcs0: SUCCESS (0.090s) [69.391561] Starting dynamic subtest: bcs0 [69.442695] Dynamic subtest bcs0: SUCCESS (0.066s) [69.463835] Starting dynamic subtest: vcs0 [69.513879] Dynamic subtest vcs0: SUCCESS (0.070s) [69.531605] Starting dynamic subtest: vcs1 [69.577519] Dynamic subtest vcs1: SUCCESS (0.066s) [69.598839] Starting dynamic subtest: vecs0 [69.647112] Dynamic subtest vecs0: SUCCESS (0.068s) [69.669758] Starting dynamic subtest: ccs0 [69.718897] Dynamic subtest ccs0: SUCCESS (0.071s) [69.724584] Subtest nb-await: SUCCESS (0.438s) [72.034578] [025/162] (926s left) gem_exec_gttfill (basic) [72.152913] Starting subtest: basic [80.226419] Subtest basic: SUCCESS (8.070s) [80.470814] [026/162] (918s left) gem_exec_parallel (engines) [80.598921] Starting subtest: engines [80.604853] Starting dynamic subtest: basic [82.962551] Dynamic subtest basic: SUCCESS (2.356s) [82.982820] Starting dynamic subtest: contexts [89.541194] Dynamic subtest contexts: SUCCESS (6.576s) [89.566103] Starting dynamic subtest: fds [96.963623] Dynamic subtest fds: SUCCESS (7.419s) [96.982486] Starting dynamic subtest: userptr [98.990182] Dynamic subtest userptr: SUCCESS (2.026s) [98.996190] Subtest engines: SUCCESS (18.380s) [99.233785] [027/162] (899s left) gem_exec_store (basic) [99.350088] Starting subtest: basic [99.492739] Subtest basic: SUCCESS (0.153s) [99.730714] [028/162] (898s left) gem_flink_basic (bad-flink) [99.819514] Starting subtest: bad-flink [99.826131] Subtest bad-flink: SUCCESS (0.000s) [99.981550] [029/162] (898s left) gem_flink_basic (bad-open) [100.084788] Starting subtest: bad-open [100.090562] Subtest bad-open: SUCCESS (0.000s) [100.254939] [030/162] (898s left) gem_flink_basic (basic) [100.346091] Starting subtest: basic [100.351816] Subtest basic: SUCCESS (0.000s) [100.521397] [031/162] (898s left) gem_flink_basic (double-flink) [100.605965] Starting subtest: double-flink [100.611923] Subtest double-flink: SUCCESS (0.000s) [100.785096] [032/162] (898s left) gem_flink_basic (flink-lifetime) [100.879872] Starting subtest: flink-lifetime [100.886580] Subtest flink-lifetime: SUCCESS (0.002s) [101.046391] [033/162] (897s left) gem_huc_copy (huc-copy) [101.160995] Starting subtest: huc-copy [101.167091] Subtest huc-copy: SUCCESS (0.006s) [101.380120] [034/162] (897s left) gem_linear_blits (basic) [101.723053] Starting subtest: basic [101.749089] Subtest basic: SUCCESS (0.027s) [101.966563] [035/162] (897s left) gem_mmap (basic) [102.105793] Subtest basic: SKIP (0.000s) [102.194260] [036/162] (897s left) gem_mmap_gtt (basic) [102.290589] Subtest basic: SKIP (0.000s) [102.391410] [037/162] (896s left) gem_render_linear_blits (basic) [102.499531] Starting subtest: basic [102.558522] Subtest basic: SUCCESS (0.053s) [102.684326] [038/162] (896s left) gem_render_tiled_blits (basic) [102.829841] Subtest basic: SKIP (0.000s) [102.946028] [039/162] (896s left) gem_ringfill (basic-all) [108.891105] Starting subtest: basic-all [110.096574] Subtest basic-all: SUCCESS (1.171s) [110.314780] [040/162] (889s left) gem_softpin (allocator-basic) [110.443087] Starting subtest: allocator-basic [110.576077] Subtest allocator-basic: SUCCESS (0.129s) [110.779654] [041/162] (888s left) gem_softpin (allocator-basic-reserve) [110.893781] Starting subtest: allocator-basic-reserve [111.011437] Subtest allocator-basic-reserve: SUCCESS (0.119s) [111.229391] [042/162] (888s left) gem_softpin (safe-alignment) [111.318581] Starting subtest: safe-alignment [111.371664] Subtest safe-alignment: SUCCESS (0.052s) [112.946396] [043/162] (886s left) gem_sync (basic-all) [113.099093] Starting subtest: basic-all [116.880717] Subtest basic-all: SUCCESS (3.821s) [117.123136] [044/162] (882s left) gem_sync (basic-each) [117.268997] Starting subtest: basic-each [120.122503] Subtest basic-each: SUCCESS (2.885s) [120.372889] [045/162] (879s left) gem_tiled_blits (basic) [120.480091] Subtest basic: SKIP (0.000s) [120.592292] [046/162] (879s left) gem_tiled_fence_blits (basic) [120.692326] Subtest basic: SKIP (0.000s) [120.799072] [047/162] (879s left) gem_tiled_pread_basic [121.034410] [048/162] (879s left) gem_wait (busy@all-engines) [121.151544] Starting subtest: busy [121.159531] Starting dynamic subtest: all-engines [122.894996] Dynamic subtest all-engines: SUCCESS (1.735s) [122.904616] Subtest busy: SUCCESS (1.736s) [123.143177] [049/162] (876s left) gem_wait (wait@all-engines) [123.258518] Starting subtest: wait [123.264710] Starting dynamic subtest: all-engines [124.880918] Dynamic subtest all-engines: SUCCESS (1.617s) [124.889847] Subtest wait: SUCCESS (1.618s) [125.136053] [050/162] (875s left) i915_getparams_basic (basic-eu-total) [125.219591] Starting subtest: basic-eu-total [125.234115] Subtest basic-eu-total: SUCCESS (0.000s) [125.385719] [051/162] (874s left) i915_getparams_basic (basic-subslice-total) [125.464066] Starting subtest: basic-subslice-total [125.481064] Subtest basic-subslice-total: SUCCESS (0.000s) [125.621700] [052/162] (874s left) i915_hangman (error-state-basic) [125.742752] Starting subtest: error-state-basic [125.933749] Subtest error-state-basic: SUCCESS (0.190s) [126.071587] [053/162] (874s left) i915_pciid [126.329523] [054/162] (874s left) intel_hwmon (hwmon-read) [126.417555] Subtest hwmon-read: SKIP (0.000s) [126.516389] [055/162] (874s left) intel_hwmon (hwmon-write) [126.616029] Subtest hwmon-write: SKIP (0.000s) [126.713610] [056/162] (873s left) kms_addfb_basic (addfb25-4-tiled) [126.883523] Starting subtest: addfb25-4-tiled [126.889107] Subtest addfb25-4-tiled: SUCCESS (0.001s) [127.052093] [057/162] (873s left) kms_addfb_basic (addfb25-bad-modifier) [127.181944] Starting subtest: addfb25-bad-modifier [127.187807] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [127.361697] [058/162] (873s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [127.481481] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s) [127.644222] [059/162] (873s left) kms_addfb_basic (addfb25-modifier-no-flag) [127.779967] Starting subtest: addfb25-modifier-no-flag [127.788335] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [127.948073] [060/162] (872s left) kms_addfb_basic (addfb25-x-tiled-legacy) [128.071462] Subtest addfb25-x-tiled-legacy: SKIP (0.000s) [128.230803] [061/162] (872s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [128.363672] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s) [128.534215] [062/162] (872s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [128.661772] Starting subtest: addfb25-yf-tiled-legacy [128.669294] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [128.825837] [063/162] (872s left) kms_addfb_basic (addfb25-y-tiled-legacy) [128.978979] Starting subtest: addfb25-y-tiled-legacy [128.987380] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [129.150740] [064/162] (871s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [129.275859] Starting subtest: addfb25-y-tiled-small-legacy [129.290960] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [129.443456] [065/162] (871s left) kms_addfb_basic (bad-pitch-0) [129.554671] Starting subtest: bad-pitch-0 [129.560547] Subtest bad-pitch-0: SUCCESS (0.000s) [129.761695] [066/162] (871s left) kms_addfb_basic (bad-pitch-1024) [129.844062] Starting subtest: bad-pitch-1024 [129.853082] Subtest bad-pitch-1024: SUCCESS (0.000s) [130.033069] [067/162] (871s left) kms_addfb_basic (bad-pitch-128) [130.142233] Starting subtest: bad-pitch-128 [130.151518] Subtest bad-pitch-128: SUCCESS (0.000s) [130.349685] [068/162] (871s left) kms_addfb_basic (bad-pitch-256) [130.459258] Starting subtest: bad-pitch-256 [130.465303] Subtest bad-pitch-256: SUCCESS (0.000s) [130.646098] [069/162] (870s left) kms_addfb_basic (bad-pitch-32) [130.746313] Starting subtest: bad-pitch-32 [130.753978] Subtest bad-pitch-32: SUCCESS (0.000s) [130.946561] [070/162] (870s left) kms_addfb_basic (bad-pitch-63) [131.045676] Starting subtest: bad-pitch-63 [131.052071] Subtest bad-pitch-63: SUCCESS (0.000s) [131.260684] [071/162] (870s left) kms_addfb_basic (bad-pitch-65536) [131.357725] Starting subtest: bad-pitch-65536 [131.363936] Subtest bad-pitch-65536: SUCCESS (0.000s) [131.572183] [072/162] (870s left) kms_addfb_basic (bad-pitch-999) [131.677932] Starting subtest: bad-pitch-999 [131.684105] Subtest bad-pitch-999: SUCCESS (0.000s) [131.892028] [073/162] (869s left) kms_addfb_basic (basic) [131.986238] Starting subtest: basic [131.992066] Subtest basic: SUCCESS (0.000s) [132.185375] [074/162] (869s left) kms_addfb_basic (basic-x-tiled-legacy) [132.287978] Starting subtest: basic-x-tiled-legacy [132.303328] Subtest basic-x-tiled-legacy: SKIP (0.000s) [132.481676] [075/162] (869s left) kms_addfb_basic (basic-y-tiled-legacy) [132.590828] Starting subtest: basic-y-tiled-legacy [132.602548] Subtest basic-y-tiled-legacy: SKIP (0.000s) [132.830619] [076/162] (869s left) kms_addfb_basic (bo-too-small) [132.963428] Starting subtest: bo-too-small [132.969109] Subtest bo-too-small: SUCCESS (0.000s) [133.147318] [077/162] (868s left) kms_addfb_basic (bo-too-small-due-to-tiling) [133.256504] Starting subtest: bo-too-small-due-to-tiling [133.268018] Subtest bo-too-small-due-to-tiling: SKIP (0.000s) [133.439063] [078/162] (868s left) kms_addfb_basic (clobberred-modifier) [133.532827] Starting subtest: clobberred-modifier [133.544657] Subtest clobberred-modifier: SKIP (0.000s) [133.739096] [079/162] (868s left) kms_addfb_basic (framebuffer-vs-set-tiling) [133.857094] Starting subtest: framebuffer-vs-set-tiling [133.870491] Subtest framebuffer-vs-set-tiling: SKIP (0.000s) [134.059481] [080/162] (868s left) kms_addfb_basic (invalid-get-prop) [134.174678] Starting subtest: invalid-get-prop [134.180386] Subtest invalid-get-prop: SUCCESS (0.000s) [134.419223] [081/162] (867s left) kms_addfb_basic (invalid-get-prop-any) [134.513592] Starting subtest: invalid-get-prop-any [134.519540] Subtest invalid-get-prop-any: SUCCESS (0.000s) [134.722370] [082/162] (867s left) kms_addfb_basic (invalid-set-prop) [134.815999] Starting subtest: invalid-set-prop [134.821778] Subtest invalid-set-prop: SUCCESS (0.000s) [135.022366] [083/162] (867s left) kms_addfb_basic (invalid-set-prop-any) [135.136940] Starting subtest: invalid-set-prop-any [135.142888] Subtest invalid-set-prop-any: SUCCESS (0.000s) [135.335443] [084/162] (867s left) kms_addfb_basic (no-handle) [135.444030] Starting subtest: no-handle [135.449881] Subtest no-handle: SUCCESS (0.000s) [135.648441] [085/162] (866s left) kms_addfb_basic (size-max) [135.785334] Starting subtest: size-max [135.790946] Subtest size-max: SUCCESS (0.000s) [135.956352] [086/162] (866s left) kms_addfb_basic (small-bo) [136.080325] Starting subtest: small-bo [136.085920] Subtest small-bo: SUCCESS (0.000s) [136.245096] [087/162] (866s left) kms_addfb_basic (tile-pitch-mismatch) [136.335823] Starting subtest: tile-pitch-mismatch [136.350071] Subtest tile-pitch-mismatch: SKIP (0.000s) [136.544715] [088/162] (866s left) kms_addfb_basic (too-high) [136.668899] Starting subtest: too-high [136.676560] Subtest too-high: SUCCESS (0.001s) [136.833220] [089/162] (865s left) kms_addfb_basic (too-wide) [136.957242] Starting subtest: too-wide [136.965010] Subtest too-wide: SUCCESS (0.000s) [137.139167] [090/162] (865s left) kms_addfb_basic (unused-handle) [137.230669] Starting subtest: unused-handle [137.239964] Subtest unused-handle: SUCCESS (0.000s) [137.437839] [091/162] (865s left) kms_addfb_basic (unused-modifier) [137.534785] Starting subtest: unused-modifier [137.540352] Subtest unused-modifier: SUCCESS (0.000s) [137.731826] [092/162] (865s left) kms_addfb_basic (unused-offsets) [137.818319] Starting subtest: unused-offsets [137.824070] Subtest unused-offsets: SUCCESS (0.000s) [138.029195] [093/162] (865s left) kms_addfb_basic (unused-pitches) [138.140581] Starting subtest: unused-pitches [138.146191] Subtest unused-pitches: SUCCESS (0.000s) [138.364509] [094/162] (864s left) kms_busy (basic) [138.508041] Starting subtest: basic [138.513624] Starting dynamic subtest: flip [139.474307] Dynamic subtest flip: SUCCESS (0.968s) [139.498699] Starting dynamic subtest: modeset [143.007283] Dynamic subtest modeset: SUCCESS (3.533s) [143.013391] Subtest basic: SUCCESS (4.504s) [143.867988] [095/162] (859s left) kms_prop_blob (basic) [143.960518] Starting subtest: basic [143.966073] Subtest basic: SUCCESS (0.000s) [144.133191] [096/162] (859s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [144.317881] Starting subtest: basic-busy-flip-before-cursor-atomic [144.329196] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [144.509582] [097/162] (858s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [144.676505] Starting subtest: basic-busy-flip-before-cursor-legacy [144.691601] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [144.896258] [098/162] (858s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [145.070959] Starting subtest: basic-flip-after-cursor-atomic [146.426197] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.356s) [147.301322] [099/162] (856s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [147.443305] Starting subtest: basic-flip-after-cursor-legacy [148.769969] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.323s) [149.659667] [100/162] (853s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [149.823902] Starting subtest: basic-flip-after-cursor-varying-size [151.150312] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.323s) [152.080761] [101/162] (851s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [152.255844] Starting subtest: basic-flip-before-cursor-atomic [153.571467] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.319s) [154.426464] [102/162] (849s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [154.588258] Starting subtest: basic-flip-before-cursor-legacy [155.912842] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.324s) [156.767831] [103/162] (846s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [156.931636] Starting subtest: basic-flip-before-cursor-varying-size [158.262849] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.328s) [159.107996] [104/162] (844s left) kms_dsc (dsc-basic) [159.218211] Starting subtest: dsc-basic [159.255302] Subtest dsc-basic: SKIP (0.001s) [159.340605] [105/162] (844s left) kms_flip (basic-flip-vs-dpms) [159.465042] Starting subtest: basic-flip-vs-dpms [159.470744] Starting dynamic subtest: A-eDP1 [162.290640] Dynamic subtest A-eDP1: SUCCESS (2.828s) [162.308103] Starting dynamic subtest: B-eDP1 [164.481128] Dynamic subtest B-eDP1: SUCCESS (2.190s) [164.500664] Starting dynamic subtest: C-eDP1 [166.679117] Dynamic subtest C-eDP1: SUCCESS (2.197s) [166.703974] Starting dynamic subtest: D-eDP1 [169.681103] Dynamic subtest D-eDP1: SUCCESS (2.993s) [169.687237] Subtest basic-flip-vs-dpms: SUCCESS (10.220s) [170.152810] [106/162] (833s left) kms_flip (basic-flip-vs-modeset) [170.267830] Starting subtest: basic-flip-vs-modeset [170.273849] Starting dynamic subtest: A-eDP1 [173.031075] Dynamic subtest A-eDP1: SUCCESS (2.762s) [173.051953] Starting dynamic subtest: B-eDP1 [175.212799] Dynamic subtest B-eDP1: SUCCESS (2.180s) [175.239736] Starting dynamic subtest: C-eDP1 [177.400779] Dynamic subtest C-eDP1: SUCCESS (2.181s) [177.419949] Starting dynamic subtest: D-eDP1 [179.586690] Dynamic subtest D-eDP1: SUCCESS (2.188s) [179.592279] Subtest basic-flip-vs-modeset: SUCCESS (9.323s) [180.445218] [107/162] (823s left) kms_flip (basic-flip-vs-wf_vblank) [180.584846] Starting subtest: basic-flip-vs-wf_vblank [180.590544] Starting dynamic subtest: A-eDP1 [182.726813] Dynamic subtest A-eDP1: SUCCESS (2.142s) [182.745845] Starting dynamic subtest: B-eDP1 [184.879220] Dynamic subtest B-eDP1: SUCCESS (2.149s) [184.905162] Starting dynamic subtest: C-eDP1 [187.196090] Dynamic subtest C-eDP1: SUCCESS (2.311s) [187.219065] Starting dynamic subtest: D-eDP1 [189.455965] Dynamic subtest D-eDP1: SUCCESS (2.251s) [189.462290] Subtest basic-flip-vs-wf_vblank: SUCCESS (8.871s) [190.771256] [108/162] (813s left) kms_flip (basic-plain-flip) [190.932841] Starting subtest: basic-plain-flip [190.938521] Starting dynamic subtest: A-eDP1 [192.834475] Dynamic subtest A-eDP1: SUCCESS (1.904s) [192.862951] Starting dynamic subtest: B-eDP1 [194.760385] Dynamic subtest B-eDP1: SUCCESS (1.923s) [194.778632] Starting dynamic subtest: C-eDP1 [196.600219] Dynamic subtest C-eDP1: SUCCESS (1.827s) [196.623893] Starting dynamic subtest: D-eDP1 [198.440904] Dynamic subtest D-eDP1: SUCCESS (1.844s) [198.446489] Subtest basic-plain-flip: SUCCESS (7.516s) [199.752015] [109/162] (804s left) kms_force_connector_basic (force-connector-state) [199.867866] Starting subtest: force-connector-state [200.496668] Subtest force-connector-state: SUCCESS (0.631s) [201.540867] [110/162] (802s left) kms_force_connector_basic (force-edid) [201.640668] Starting subtest: force-edid [201.940954] Subtest force-edid: SUCCESS (0.299s) [202.140956] [111/162] (802s left) kms_force_connector_basic (force-load-detect) [202.250105] Starting subtest: force-load-detect [202.261199] Subtest force-load-detect: SKIP (0.000s) [202.463563] [112/162] (801s left) kms_force_connector_basic (prune-stale-modes) [202.578010] Starting subtest: prune-stale-modes [202.933766] Subtest prune-stale-modes: SUCCESS (0.357s) [203.173734] [113/162] (801s left) kms_frontbuffer_tracking (basic) [203.354170] Starting subtest: basic [208.635160] Subtest basic: SUCCESS (5.305s) [208.808680] [114/162] (795s left) kms_hdmi_inject (inject-audio) [209.203485] Starting subtest: inject-audio [209.493076] Subtest inject-audio: SUCCESS (0.287s) [210.109192] [115/162] (794s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [210.224670] Starting subtest: compare-crc-sanitycheck-xr24 [210.230361] Starting dynamic subtest: pipe-A-eDP-1 [211.147914] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.920s) [211.166208] Starting dynamic subtest: pipe-B-eDP-1 [212.441144] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.294s) [212.459504] Starting dynamic subtest: pipe-C-eDP-1 [213.750151] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.304s) [213.775189] Starting dynamic subtest: pipe-D-eDP-1 [215.097335] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.346s) [215.103122] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.872s) [215.978281] [116/162] (788s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [216.104325] Starting subtest: compare-crc-sanitycheck-nv12 [216.109931] Starting dynamic subtest: pipe-A-eDP-1 [217.087923] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.981s) [217.105902] Starting dynamic subtest: pipe-B-eDP-1 [218.407756] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.314s) [218.432032] Starting dynamic subtest: pipe-C-eDP-1 [219.699845] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.293s) [219.720544] Starting dynamic subtest: pipe-D-eDP-1 [221.050212] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.345s) [221.055815] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.943s) [222.005396] [117/162] (782s left) kms_pipe_crc_basic (hang-read-crc) [222.130235] Starting subtest: hang-read-crc [222.136707] Starting dynamic subtest: pipe-A-eDP-1 [224.647029] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.513s) [224.670629] Starting dynamic subtest: pipe-B-eDP-1 [227.626403] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.978s) [227.645208] Starting dynamic subtest: pipe-C-eDP-1 [230.581892] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.950s) [230.606657] Starting dynamic subtest: pipe-D-eDP-1 [233.579092] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.997s) [233.584723] Subtest hang-read-crc: SUCCESS (11.446s) [234.478603] [118/162] (770s left) kms_pipe_crc_basic (nonblocking-crc) [234.629125] Starting subtest: nonblocking-crc [234.636922] Starting dynamic subtest: pipe-A-eDP-1 [235.681197] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.054s) [235.705195] Starting dynamic subtest: pipe-B-eDP-1 [237.272251] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.589s) [237.292973] Starting dynamic subtest: pipe-C-eDP-1 [238.875536] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.602s) [238.893050] Starting dynamic subtest: pipe-D-eDP-1 [240.464112] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.585s) [240.469816] Subtest nonblocking-crc: SUCCESS (5.838s) [241.376127] [119/162] (763s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [241.521076] Starting subtest: nonblocking-crc-frame-sequence [241.526758] Starting dynamic subtest: pipe-A-eDP-1 [242.724518] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.198s) [242.742127] Starting dynamic subtest: pipe-B-eDP-1 [244.325044] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.593s) [244.352902] Starting dynamic subtest: pipe-C-eDP-1 [245.836364] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.509s) [245.862827] Starting dynamic subtest: pipe-D-eDP-1 [247.391304] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.555s) [247.396836] Subtest nonblocking-crc-frame-sequence: SUCCESS (5.869s) [248.275171] [120/162] (756s left) kms_pipe_crc_basic (read-crc) [248.398082] Starting subtest: read-crc [248.403714] Starting dynamic subtest: pipe-A-eDP-1 [249.384643] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.984s) [249.406066] Starting dynamic subtest: pipe-B-eDP-1 [250.895029] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.512s) [250.916261] Starting dynamic subtest: pipe-C-eDP-1 [252.385329] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.483s) [252.403138] Starting dynamic subtest: pipe-D-eDP-1 [253.883597] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.493s) [253.889945] Subtest read-crc: SUCCESS (5.480s) [254.773332] [121/162] (750s left) kms_pipe_crc_basic (read-crc-frame-sequence) [254.909701] Starting subtest: read-crc-frame-sequence [254.915600] Starting dynamic subtest: pipe-A-eDP-1 [255.906326] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.996s) [255.929546] Starting dynamic subtest: pipe-B-eDP-1 [257.399284] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.487s) [257.423617] Starting dynamic subtest: pipe-C-eDP-1 [258.904834] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.508s) [258.929863] Starting dynamic subtest: pipe-D-eDP-1 [260.387650] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.479s) [260.393703] Subtest read-crc-frame-sequence: SUCCESS (5.479s) [261.274375] [122/162] (743s left) kms_pm_backlight (basic-brightness) [261.390862] Starting subtest: basic-brightness [261.527598] Starting dynamic subtest: eDP-1 [261.835048] Dynamic subtest eDP-1: SUCCESS (0.303s) [261.840778] Subtest basic-brightness: SUCCESS (0.440s) [262.673150] [123/162] (742s left) kms_pm_rpm (basic-pci-d3-state) [265.004320] Starting subtest: basic-pci-d3-state [266.524687] Subtest basic-pci-d3-state: SUCCESS (1.527s) [266.661064] [124/162] (738s left) kms_pm_rpm (basic-rte) [266.723384] Starting subtest: basic-rte [269.762754] Subtest basic-rte: SUCCESS (3.043s) [271.650272] [125/162] (733s left) kms_psr (psr-primary-page-flip) [271.767981] Starting subtest: psr-primary-page-flip [271.773586] Starting dynamic subtest: eDP-1 [273.847148] Dynamic subtest eDP-1: SUCCESS (2.077s) [273.853083] Subtest psr-primary-page-flip: SUCCESS (2.079s) [274.771913] [126/162] (730s left) kms_psr (psr-cursor-plane-move) [274.906400] Starting subtest: psr-cursor-plane-move [274.913987] Starting dynamic subtest: eDP-1 [276.939598] Dynamic subtest eDP-1: SUCCESS (2.032s) [276.945374] Subtest psr-cursor-plane-move: SUCCESS (2.034s) [277.792447] [127/162] (727s left) kms_psr (psr-sprite-plane-onoff) [277.934353] Starting subtest: psr-sprite-plane-onoff [277.946751] Starting dynamic subtest: eDP-1 [280.104230] Dynamic subtest eDP-1: SUCCESS (2.171s) [280.110316] Subtest psr-sprite-plane-onoff: SUCCESS (2.173s) [280.974195] [128/162] (724s left) kms_psr (psr-primary-mmap-gtt) [281.081741] Starting subtest: psr-primary-mmap-gtt [281.091885] Starting dynamic subtest: eDP-1 [282.833017] Dynamic subtest eDP-1: SKIP (1.742s) [282.844695] Subtest psr-primary-mmap-gtt: SKIP (1.745s) [283.049861] [129/162] (722s left) kms_setmode (basic-clone-single-crtc) [283.138099] Starting subtest: basic-clone-single-crtc [283.156980] Subtest basic-clone-single-crtc: SKIP (0.000s) [283.310924] [130/162] (722s left) i915_pm_rps (basic-api) [283.418863] Starting subtest: basic-api [283.430552] Subtest basic-api: SKIP (0.003s) [283.548612] [131/162] (722s left) prime_self_import (basic-llseek-bad) [283.618908] Starting subtest: basic-llseek-bad [283.642734] Subtest basic-llseek-bad: SUCCESS (0.029s) [283.812588] [132/162] (721s left) prime_self_import (basic-llseek-size) [283.878865] Starting subtest: basic-llseek-size [283.907057] Subtest basic-llseek-size: SUCCESS (0.028s) [284.065222] [133/162] (721s left) prime_self_import (basic-with_fd_dup) [284.142388] Starting subtest: basic-with_fd_dup [284.165789] Subtest basic-with_fd_dup: SUCCESS (0.030s) [284.370238] [134/162] (721s left) prime_self_import (basic-with_one_bo) [284.451807] Starting subtest: basic-with_one_bo [284.477825] Subtest basic-with_one_bo: SUCCESS (0.034s) [284.666924] [135/162] (721s left) prime_self_import (basic-with_one_bo_two_files) [284.743631] Starting subtest: basic-with_one_bo_two_files [284.761927] Subtest basic-with_one_bo_two_files: SUCCESS (0.028s) [284.952976] [136/162] (720s left) prime_self_import (basic-with_two_bos) [285.046169] Starting subtest: basic-with_two_bos [285.074509] Subtest basic-with_two_bos: SUCCESS (0.030s) [285.241662] [137/162] (720s left) prime_vgem (basic-fence-flip) [285.380335] Starting subtest: basic-fence-flip [285.904414] Subtest basic-fence-flip: SUCCESS (0.528s) [286.081526] [138/162] (719s left) prime_vgem (basic-fence-mmap) [286.217796] Starting subtest: basic-fence-mmap [286.235077] Subtest basic-fence-mmap: SKIP (0.000s) [286.386055] [139/162] (719s left) prime_vgem (basic-fence-read) [286.533079] Starting subtest: basic-fence-read [286.548511] Subtest basic-fence-read: SKIP (0.011s) [286.710801] [140/162] (719s left) prime_vgem (basic-gtt) [286.826058] Starting subtest: basic-gtt [286.837916] Subtest basic-gtt: SKIP (0.000s) [286.984555] [141/162] (719s left) prime_vgem (basic-read) [287.109249] Starting subtest: basic-read [287.121747] Subtest basic-read: SKIP (0.008s) [287.286727] [142/162] (719s left) prime_vgem (basic-write) [287.403445] Starting subtest: basic-write [287.424239] Subtest basic-write: SKIP (0.010s) [287.569927] [143/162] (718s left) vgem_basic (setversion) [287.640420] Starting subtest: setversion [287.651718] Subtest setversion: SUCCESS (0.000s) [287.739584] [144/162] (718s left) vgem_basic (create) [287.819665] Starting subtest: create [287.825650] Subtest create: SUCCESS (0.000s) [287.921167] [145/162] (718s left) vgem_basic (debugfs) [288.002080] Starting subtest: debugfs [288.007967] Subtest debugfs: SUCCESS (0.000s) [288.108618] [146/162] (718s left) vgem_basic (dmabuf-export) [288.193218] Starting subtest: dmabuf-export [288.220010] Subtest dmabuf-export: SUCCESS (0.037s) [288.364642] [147/162] (718s left) vgem_basic (dmabuf-fence) [288.451443] Starting subtest: dmabuf-fence [288.457333] Subtest dmabuf-fence: SUCCESS (0.001s) [288.558806] [148/162] (718s left) vgem_basic (dmabuf-fence-before) [288.634744] Starting subtest: dmabuf-fence-before [288.640551] Subtest dmabuf-fence-before: SUCCESS (0.000s) [288.737931] [149/162] (718s left) vgem_basic (dmabuf-mmap) [288.816457] Starting subtest: dmabuf-mmap [288.828971] Subtest dmabuf-mmap: SUCCESS (0.016s) [288.931281] [150/162] (717s left) vgem_basic (mmap) [289.018633] Starting subtest: mmap [289.024243] Subtest mmap: SUCCESS (0.010s) [289.129384] [151/162] (717s left) vgem_basic (second-client) [289.231208] Starting subtest: second-client [289.258817] Subtest second-client: SUCCESS (0.033s) [289.363676] [152/162] (717s left) vgem_basic (sysfs) [289.442632] Starting subtest: sysfs [289.448538] Subtest sysfs: SUCCESS (0.000s) [289.542144] [153/162] (717s left) core_hotunplug (unbind-rebind) [289.724067] Starting subtest: unbind-rebind [296.112575] Subtest unbind-rebind: SUCCESS (6.388s) [296.180393] [154/162] (710s left) vgem_basic (unload) [296.254621] Starting subtest: unload [325.562850] Subtest unload: SUCCESS (29.312s) [325.728527] [155/162] (681s left) i915_module_load (reload) [325.797924] Starting subtest: reload [331.065057] Subtest reload: SUCCESS (5.273s) [331.132009] [156/162] (676s left) gem_lmem_swapping (basic) [331.224692] Subtest basic: SKIP (0.000s) [331.288469] [157/162] (676s left) gem_lmem_swapping (parallel-random-engines) [331.360841] Subtest parallel-random-engines: SKIP (0.000s) [331.421702] [158/162] (675s left) gem_lmem_swapping (random-engines) [331.514537] Subtest random-engines: SKIP (0.000s) [331.585667] [159/162] (675s left) gem_lmem_swapping (verify-random) [331.669098] Subtest verify-random: SKIP (0.000s) [331.744595] [160/162] (675s left) i915_pm_rpm (module-reload) [334.105904] Starting subtest: module-reload [352.792865] Subtest module-reload: SUCCESS (18.678s) [352.833499] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [352.834385] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true [352.841132] [161/162] (654s left) i915_selftest (live) [352.917769] Starting subtest: live [352.923388] Starting dynamic subtest: sanitycheck [358.051107] Dynamic subtest sanitycheck: SUCCESS (5.016s) [358.174142] Starting dynamic subtest: uncore [361.917411] Dynamic subtest uncore: SUCCESS (3.907s) [361.932411] Starting dynamic subtest: workarounds [366.531527] Dynamic subtest workarounds: SUCCESS (4.582s) [366.549436] Starting dynamic subtest: gt_engines [370.954033] Dynamic subtest gt_engines: SUCCESS (4.407s) [370.968625] Starting dynamic subtest: gt_timelines [391.829308] Dynamic subtest gt_timelines: SUCCESS (20.854s) [391.849359] Starting dynamic subtest: gt_contexts [396.106642] Dynamic subtest gt_contexts: SUCCESS (4.253s) [396.121143] Starting dynamic subtest: gt_lrc [401.892077] Dynamic subtest gt_lrc: SUCCESS (5.745s) [401.909926] Starting dynamic subtest: gt_mocs [406.064672] Dynamic subtest gt_mocs: SUCCESS (4.194s) [406.075440] Aborting: Lockdep not active /proc/lockdep_stats contents: lock-classes: 2774 [max: 8192] dynamic-keys: 814 direct dependencies: 38426 [max: 524288] indirect dependencies: 210042 all direct dependencies: 123654 dependency chains: 203820 [max: 524288] dependency chain hlocks used: 1003795 [max: 2621440] dependency chain hlocks lost: 0 in-hardirq chains: 16 in-softirq chains: 0 in-process chains: 515 stack-trace entries: 524288 [max: 524288] number of stack traces: 22184 number of stack hash chains: 12127 combined max dependencies: 8772 hardirq-safe locks: 26 hardirq-unsafe locks: 1639 softirq-safe locks: 0 softirq-unsafe locks: 1526 irq-safe locks: 26 irq-unsafe locks: 1639 hardirq-read-safe locks: 2 hardirq-read-unsafe locks: 467 softirq-read-safe locks: 0 softirq-read-unsafe locks: 464 irq-read-safe locks: 2 irq-read-unsafe locks: 467 uncategorized locks: 753 unused locks: 1 max locking depth: 22 max bfs queue depth: 1329 max lock class index: 2948 debug_locks: 0 zapped classes: 1668 zapped lock chains: 63943 large chain blocks: 271 [406.089280] Starting dynamic subtest: gt_pm [411.113873] Dynamic subtest gt_pm: SUCCESS (5.053s) [411.122092] Starting dynamic subtest: gt_heartbeat [413.971598] Dynamic subtest gt_heartbeat: SUCCESS (2.857s) [413.979626] Starting dynamic subtest: gt_tlb [423.490203] Dynamic subtest gt_tlb: SUCCESS (9.506s) [423.498544] Starting dynamic subtest: requests