[51.647165] Initializing watchdogs [51.647222] /dev/watchdog0 [51.661406] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics] [51.666512] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [51.668954] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [51.670833] [001/131] (960s left) gem_exec_params (invalid-bsd2-flag-on-render) [51.786964] Starting subtest: invalid-bsd2-flag-on-render [51.787690] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s) [51.861772] [002/131] (960s left) gem_caching (read-writes) [51.901684] Starting subtest: read-writes [62.680167] Subtest read-writes: SUCCESS (10.778s) [62.772281] [003/131] (949s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf) [62.866276] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s) [62.903034] [004/131] (949s left) kms_pm_rpm (modeset-non-lpsp-stress) [64.340033] Starting subtest: modeset-non-lpsp-stress [65.540861] Subtest modeset-non-lpsp-stress: SKIP (1.200s) [65.703012] [005/131] (946s left) kms_chamelium_frames (vga-frame-dump) [65.840479] Subtest vga-frame-dump: SKIP (0.000s) [65.918449] [006/131] (946s left) perf (i915-ref-count) [65.984708] Starting subtest: i915-ref-count [66.018697] Subtest i915-ref-count: SUCCESS (0.034s) [66.062681] [007/131] (946s left) drm_fdinfo (memory-info-resident) [66.101910] Starting subtest: memory-info-resident [66.102623] Starting dynamic subtest: smem0 [68.887854] Dynamic subtest smem0: SUCCESS (2.777s) [68.888639] Subtest memory-info-resident: SUCCESS (2.777s) [68.934600] [008/131] (943s left) kms_setmode (clone-exclusive-crtc) [68.970649] Starting subtest: clone-exclusive-crtc [68.972718] Subtest clone-exclusive-crtc: SKIP (0.001s) [69.023762] [009/131] (943s left) kms_psr (psr-cursor-plane-move) [69.115666] Subtest psr-cursor-plane-move: SKIP (0.000s) [69.149958] [010/131] (943s left) perf (short-reads) [69.216206] Starting subtest: short-reads [69.236540] Subtest short-reads: SUCCESS (0.020s) [69.270405] [011/131] (943s left) syncobj_timeline (multi-wait-submitted-signaled) [69.306453] Starting subtest: multi-wait-submitted-signaled [69.307186] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s) [69.363119] [012/131] (943s left) gem_flink_race (flink_name) [69.399076] Starting subtest: flink_name [74.808542] Subtest flink_name: SUCCESS (5.371s) [74.895585] [013/131] (937s left) gem_exec_reloc (basic-range-active) [74.945159] Starting subtest: basic-range-active [74.977698] Subtest basic-range-active: SUCCESS (0.032s) [75.080576] [014/131] (937s left) gem_mmap_offset (clear-via-pagefault) [75.116585] Starting subtest: clear-via-pagefault [75.117317] Starting dynamic subtest: smem0 [100.566786] Dynamic subtest smem0: SUCCESS (25.450s) [100.567529] Subtest clear-via-pagefault: SUCCESS (25.450s) [101.335911] [015/131] (911s left) gem_mmap_gtt (cpuset-medium-copy-odd) [101.371856] Starting subtest: cpuset-medium-copy-odd [108.947296] Subtest cpuset-medium-copy-odd: SUCCESS (7.575s) [109.046149] [016/131] (903s left) gem_exec_endless (dispatch) [109.134644] Starting subtest: dispatch [109.135407] Starting dynamic subtest: rcs0 [109.137987] Dynamic subtest rcs0: SUCCESS (0.003s) [109.143967] Starting dynamic subtest: bcs0 [109.145374] Dynamic subtest bcs0: SUCCESS (0.002s) [109.151708] Starting dynamic subtest: vcs0 [109.153063] Dynamic subtest vcs0: SUCCESS (0.002s) [109.158141] Starting dynamic subtest: vcs1 [109.159488] Dynamic subtest vcs1: SUCCESS (0.002s) [109.164564] Starting dynamic subtest: vecs0 [109.165907] Dynamic subtest vecs0: SUCCESS (0.002s) [109.166598] Subtest dispatch: SUCCESS (0.013s) [109.264577] [017/131] (903s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted) [109.309110] Starting subtest: etime-single-wait-all-for-submit-submitted [109.417591] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.106s) [109.474464] [018/131] (903s left) kms_fbc_dirty_rect (fbc-dirty-rectangle-dirtyfb-tests) [109.800355] Subtest fbc-dirty-rectangle-dirtyfb-tests: SKIP (0.000s) [109.843526] [FACT kms_fbc_dirty_rect (fbc-dirty-rectangle-dirtyfb-tests)] new: kernel.kmod_is_loaded.xe: true [109.845131] [019/131] (902s left) device_reset (cold-reset-bound) [109.894452] Starting subtest: cold-reset-bound [109.895900] Subtest cold-reset-bound: SKIP (0.000s) [109.946439] [020/131] (902s left) gem_basic (create-close) [109.982631] Starting subtest: create-close [109.984085] Subtest create-close: SUCCESS (0.000s) [110.070773] [021/131] (902s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt) [110.166609] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt [110.168055] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [110.247062] [022/131] (902s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes) [110.284071] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s) [110.322450] [023/131] (902s left) fbdev (unaligned-write) [110.366808] Starting subtest: unaligned-write [110.488365] Subtest unaligned-write: SUCCESS (0.117s) [110.527927] [024/131] (902s left) kms_psr (fbc-psr2-cursor-blt) [110.617202] Subtest fbc-psr2-cursor-blt: SKIP (0.000s) [110.655881] [025/131] (902s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt) [110.747740] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt [110.749128] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [110.846269] [026/131] (902s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render) [110.936485] Starting subtest: psr-rgb101010-draw-render [110.937873] Subtest psr-rgb101010-draw-render: SKIP (0.000s) [111.023581] [027/131] (901s left) gem_eio (suspend) [111.069058] Starting subtest: suspend [121.818482] Subtest suspend: SUCCESS (10.746s) [129.952449] [028/131] (891s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats) [130.045690] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats [130.046377] Starting dynamic subtest: pipe-A [131.660081] Dynamic subtest pipe-A: SUCCESS (1.615s) [131.668492] Starting dynamic subtest: pipe-B [133.327803] Dynamic subtest pipe-B: SUCCESS (1.667s) [133.335292] Starting dynamic subtest: pipe-C [133.536695] Dynamic subtest pipe-C: SUCCESS (0.208s) [133.547102] Starting dynamic subtest: pipe-D [133.753350] Dynamic subtest pipe-D: SUCCESS (0.216s) [133.754272] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.708s) [133.934910] [029/131] (887s left) kms_psr (fbc-psr-cursor-mmap-gtt) [134.035433] Subtest fbc-psr-cursor-mmap-gtt: SKIP (0.000s) [134.069761] [030/131] (887s left) kms_vblank (query-forked-busy) [134.157896] Starting subtest: query-forked-busy [134.158677] Starting dynamic subtest: pipe-A-HDMI-A-1 [135.444919] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.286s) [135.457746] Starting dynamic subtest: pipe-D-HDMI-A-1 [136.746468] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.294s) [136.747232] Subtest query-forked-busy: SUCCESS (2.589s) [136.898219] [031/131] (884s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc) [136.991951] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc [136.992688] Starting dynamic subtest: pipe-A-HDMI-A-1 [136.998814] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s) [137.005412] Starting dynamic subtest: pipe-B-HDMI-A-1 [137.011511] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s) [137.017704] Starting dynamic subtest: pipe-C-HDMI-A-1 [137.023772] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s) [137.029949] Starting dynamic subtest: pipe-D-HDMI-A-1 [137.035964] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s) [137.036665] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SUCCESS (0.009s) [137.227223] [032/131] (883s left) sw_sync (sync_merge_same) [137.263900] Starting subtest: sync_merge_same [137.264654] Subtest sync_merge_same: SUCCESS (0.000s) [137.306142] [033/131] (883s left) gen9_exec_parse (basic-rejected) [137.345778] Subtest basic-rejected: SKIP (0.000s) [137.385802] [034/131] (883s left) gem_exec_schedule (preempt-queue) [137.434662] Starting subtest: preempt-queue [137.435412] Starting dynamic subtest: rcs0 [137.529729] Dynamic subtest rcs0: SUCCESS (0.094s) [137.537042] Starting dynamic subtest: bcs0 [137.619940] Dynamic subtest bcs0: SUCCESS (0.090s) [137.627915] Starting dynamic subtest: vcs0 [137.714693] Dynamic subtest vcs0: SUCCESS (0.094s) [137.722256] Starting dynamic subtest: vcs1 [137.807424] Dynamic subtest vcs1: SUCCESS (0.092s) [137.814687] Starting dynamic subtest: vecs0 [137.904218] Dynamic subtest vecs0: SUCCESS (0.096s) [137.904946] Subtest preempt-queue: SUCCESS (0.469s) [138.201851] [035/131] (883s left) kms_vrr (seamless-rr-switch-vrr) [138.292079] Starting subtest: seamless-rr-switch-vrr [138.294083] Subtest seamless-rr-switch-vrr: SKIP (0.000s) [138.349334] [036/131] (882s left) kms_dirtyfb (drrs-dirtyfb-ioctl) [138.437736] Starting subtest: drrs-dirtyfb-ioctl [138.441847] Subtest drrs-dirtyfb-ioctl: SKIP (0.001s) [138.533494] [037/131] (882s left) gem_exec_params (sol-reset-not-gen7) [138.572492] Starting subtest: sol-reset-not-gen7 [138.574146] Subtest sol-reset-not-gen7: SUCCESS (0.001s) [138.685121] [038/131] (882s left) kms_busy (extended-modeset-hang-newfb) [138.777857] Starting subtest: extended-modeset-hang-newfb [138.778648] Starting dynamic subtest: pipe-A [163.043130] Dynamic subtest pipe-A: SUCCESS (24.264s) [163.051151] Starting dynamic subtest: pipe-D [187.092858] Dynamic subtest pipe-D: SUCCESS (24.047s) [187.093596] Subtest extended-modeset-hang-newfb: SUCCESS (48.316s) [187.249169] [039/131] (834s left) sysfs_heartbeat_interval (precise) [187.292563] Starting subtest: precise [187.293347] Starting dynamic subtest: vecs0 [188.898740] Dynamic subtest vecs0: SUCCESS (1.605s) [188.907272] Starting dynamic subtest: vcs0 [190.432409] Dynamic subtest vcs0: SUCCESS (1.532s) [190.441622] Starting dynamic subtest: bcs0 [191.967154] Dynamic subtest bcs0: SUCCESS (1.534s) [191.977200] Starting dynamic subtest: rcs0 [193.474982] Dynamic subtest rcs0: SUCCESS (1.506s) [193.490372] Starting dynamic subtest: vcs1 [195.033850] Dynamic subtest vcs1: SUCCESS (1.557s) [195.035128] Subtest precise: SUCCESS (7.741s) [195.096129] [040/131] (826s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render) [195.189664] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render [195.191035] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [195.284957] [041/131] (826s left) kms_flip (2x-flip-vs-expired-vblank) [195.372330] Starting subtest: 2x-flip-vs-expired-vblank [195.381049] Subtest 2x-flip-vs-expired-vblank: SKIP (0.009s) [195.442601] [042/131] (826s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip) [195.540427] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip [195.541828] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s) [195.635245] [043/131] (825s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs) [195.724933] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs [195.725720] Starting dynamic subtest: pipe-A-HDMI-A-1 [195.732753] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s) [195.741978] Starting dynamic subtest: pipe-B-HDMI-A-1 [195.748983] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s) [195.757354] Starting dynamic subtest: pipe-C-HDMI-A-1 [195.764120] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s) [195.771015] Starting dynamic subtest: pipe-D-HDMI-A-1 [195.778008] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s) [195.779366] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.008s) [195.958072] [044/131] (825s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling) [196.047768] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling [196.048488] Starting dynamic subtest: pipe-A-valid-mode [197.196420] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.148s) [197.197196] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SUCCESS (1.149s) [197.322884] [045/131] (824s left) prime_vgem (basic-fence-flip) [197.418809] Starting subtest: basic-fence-flip [197.698827] Subtest basic-fence-flip: SUCCESS (0.280s) [197.806932] [FACT prime_vgem (basic-fence-flip)] new: kernel.kmod_is_loaded.vgem: true [197.810869] [046/131] (823s left) syncobj_wait (invalid-reset-bad-pad) [197.848584] Starting subtest: invalid-reset-bad-pad [197.849357] Subtest invalid-reset-bad-pad: SUCCESS (0.000s) [197.914332] [047/131] (823s left) gem_lmem_swapping (heavy-verify-multi-ccs) [197.956648] Subtest heavy-verify-multi-ccs: SKIP (0.000s) [197.993898] [048/131] (823s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs) [198.082708] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs [198.083413] Starting dynamic subtest: pipe-A-HDMI-A-1 [198.090175] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s) [198.096597] Starting dynamic subtest: pipe-B-HDMI-A-1 [198.103316] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s) [198.109846] Starting dynamic subtest: pipe-C-HDMI-A-1 [198.116490] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s) [198.122816] Starting dynamic subtest: pipe-D-HDMI-A-1 [198.129695] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s) [198.131058] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SKIP (0.005s) [198.319277] [049/131] (823s left) gem_eio (in-flight-immediate) [198.361246] Starting subtest: in-flight-immediate [200.562076] Subtest in-flight-immediate: SUCCESS (2.200s) [200.680748] [050/131] (821s left) kms_color (degamma) [200.770705] Starting subtest: degamma [200.771393] Starting dynamic subtest: pipe-A-HDMI-A-1 [201.101390] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.330s) [201.108636] Starting dynamic subtest: pipe-B-HDMI-A-1 [201.392481] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.290s) [201.401377] Starting dynamic subtest: pipe-C-HDMI-A-1 [201.691893] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.299s) [201.698867] Starting dynamic subtest: pipe-D-HDMI-A-1 [201.980373] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.288s) [201.981194] Subtest degamma: SUCCESS (1.210s) [202.100488] [051/131] (819s left) kms_lease (implicit-plane-lease) [202.193206] Starting subtest: implicit-plane-lease [202.193931] Subtest implicit-plane-lease: SUCCESS (0.002s) [202.248841] [052/131] (819s left) gem_ctx_engines (execute-one) [202.294096] Starting subtest: execute-one [203.353349] Subtest execute-one: SUCCESS (1.059s) [203.526956] [053/131] (818s left) kms_dp_linktrain_fallback (dp-fallback) [203.618869] Starting subtest: dp-fallback [203.621054] Subtest dp-fallback: SKIP (0.000s) [203.675322] [054/131] (818s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt) [203.766924] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt [203.768359] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [203.861314] [055/131] (818s left) gem_exec_balancer (full-late) [203.908776] Starting subtest: full-late [205.307417] Subtest full-late: SUCCESS (1.399s) [205.492739] [056/131] (816s left) kms_psr2_sf (psr2-cursor-plane-update-sf) [205.587843] Subtest psr2-cursor-plane-update-sf: SKIP (0.000s) [205.627578] [057/131] (816s left) kms_big_fb (yf-tiled-8bpp-rotate-90) [205.722229] Starting subtest: yf-tiled-8bpp-rotate-90 [205.723608] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s) [205.817135] [058/131] (816s left) kms_big_fb (y-tiled-8bpp-rotate-180) [205.912265] Starting subtest: y-tiled-8bpp-rotate-180 [206.949944] Subtest y-tiled-8bpp-rotate-180: SUCCESS (1.037s) [207.094982] [059/131] (815s left) i915_module_load (reload-with-fault-injection) [207.130273] Starting subtest: reload-with-fault-injection [211.779225] Subtest reload-with-fault-injection: SUCCESS (4.641s) [211.803579] [FACT i915_module_load (reload-with-fault-injection)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [211.804465] [FACT i915_module_load (reload-with-fault-injection)] deleted: kernel.kmod_is_loaded.i915: true [211.806883] [060/131] (810s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt) [212.798693] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt [212.800178] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [212.883513] [FACT kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [212.886125] [FACT kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)] new: kernel.kmod_is_loaded.i915: true [212.888436] [061/131] (809s left) gem_userptr_blits (sd-probe) [212.936488] Starting subtest: sd-probe [212.937208] Subtest sd-probe: SUCCESS (0.000s) [213.068956] [062/131] (809s left) syncobj_wait (invalid-wait-bad-flags) [213.106741] Starting subtest: invalid-wait-bad-flags [213.107437] Subtest invalid-wait-bad-flags: SUCCESS (0.000s) [213.167627] [063/131] (809s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff) [213.261328] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff [214.716246] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (1.454s) [214.850784] [064/131] (807s left) api_intel_bb (intel-bb-blit-x) [214.889740] Starting subtest: intel-bb-blit-x [218.096750] Subtest intel-bb-blit-x: SUCCESS (3.173s) [218.193728] [065/131] (804s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc) [218.293193] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc [218.294605] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [218.399113] [066/131] (804s left) kms_joiner (invalid-modeset-big-joiner) [218.491837] Starting subtest: invalid-modeset-big-joiner [218.493231] Subtest invalid-modeset-big-joiner: SKIP (0.000s) [218.551431] [067/131] (803s left) kms_cursor_crc (cursor-sliding-128x128) [218.645942] Starting subtest: cursor-sliding-128x128 [218.651068] Starting dynamic subtest: pipe-A-HDMI-A-1 [220.518647] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.868s) [220.563098] Starting dynamic subtest: pipe-D-HDMI-A-1 [222.395574] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.839s) [222.396353] Subtest cursor-sliding-128x128: SUCCESS (3.750s) [222.544120] [068/131] (799s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt) [222.649092] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt [222.650436] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [222.754337] [069/131] (799s left) kms_pipe_crc_basic (read-crc) [222.845440] Starting subtest: read-crc [222.847493] Starting dynamic subtest: pipe-A-HDMI-A-1 [223.183793] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.336s) [223.191810] Starting dynamic subtest: pipe-B-HDMI-A-1 [223.465612] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.280s) [223.473403] Starting dynamic subtest: pipe-C-HDMI-A-1 [223.758523] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.291s) [223.766672] Starting dynamic subtest: pipe-D-HDMI-A-1 [224.041040] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.280s) [224.041807] Subtest read-crc: SUCCESS (1.196s) [224.141163] [070/131] (798s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-sf) [224.236068] Subtest fbc-pr-overlay-plane-move-continuous-sf: SKIP (0.000s) [224.276710] [071/131] (798s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic) [224.366981] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic [224.369628] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.003s) [224.424807] [072/131] (798s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt) [224.519358] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt [224.520746] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [224.618372] [073/131] (798s left) kms_cdclk (mode-transition) [224.657086] Subtest mode-transition: SKIP (0.000s) [224.695412] [074/131] (798s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation) [224.785920] Starting subtest: plane-upscale-factor-0-25-with-rotation [224.786653] Starting dynamic subtest: pipe-A [225.799708] Dynamic subtest pipe-A: SKIP (1.012s) [225.806467] Starting dynamic subtest: pipe-B [226.874851] Dynamic subtest pipe-B: SKIP (1.074s) [226.881933] Starting dynamic subtest: pipe-C [227.978237] Dynamic subtest pipe-C: SKIP (1.104s) [227.985206] Starting dynamic subtest: pipe-D [229.080969] Dynamic subtest pipe-D: SKIP (1.101s) [229.082438] Subtest plane-upscale-factor-0-25-with-rotation: SKIP (4.293s) [229.272711] [075/131] (793s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc) [229.384726] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc [229.386190] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [229.471720] [076/131] (793s left) gem_ctx_shared (q-out-order) [229.519760] Starting subtest: Q-out-order [229.520489] Starting dynamic subtest: rcs0 [229.567549] Dynamic subtest rcs0: SUCCESS (0.047s) [229.577460] Starting dynamic subtest: bcs0 [229.613516] Dynamic subtest bcs0: SUCCESS (0.045s) [229.624201] Starting dynamic subtest: vcs0 [229.656710] Dynamic subtest vcs0: SUCCESS (0.042s) [229.666010] Starting dynamic subtest: vcs1 [229.699998] Dynamic subtest vcs1: SUCCESS (0.042s) [229.710905] Starting dynamic subtest: vecs0 [229.742731] Dynamic subtest vecs0: SUCCESS (0.042s) [229.743507] Subtest Q-out-order: SUCCESS (0.223s) [229.914406] [077/131] (792s left) gem_exec_schedule (u-submit-early-slice) [229.965336] Starting subtest: u-submit-early-slice [229.966079] Starting dynamic subtest: rcs0 [229.992822] Dynamic subtest rcs0: SUCCESS (0.027s) [230.000293] Starting dynamic subtest: bcs0 [230.017729] Dynamic subtest bcs0: SUCCESS (0.024s) [230.025552] Starting dynamic subtest: vcs0 [230.042725] Dynamic subtest vcs0: SUCCESS (0.024s) [230.049932] Starting dynamic subtest: vcs1 [230.067709] Dynamic subtest vcs1: SUCCESS (0.024s) [230.075274] Starting dynamic subtest: vecs0 [230.093080] Dynamic subtest vecs0: SUCCESS (0.024s) [230.093831] Subtest u-submit-early-slice: SUCCESS (0.128s) [230.362716] [078/131] (792s left) kms_frontbuffer_tracking (fbc-stridechange) [230.462834] Starting subtest: fbc-stridechange [231.420272] Subtest fbc-stridechange: SUCCESS (0.958s) [231.553715] [079/131] (791s left) i915_selftest (live) [232.641808] Starting subtest: live [232.642664] Starting dynamic subtest: sanitycheck [233.904677] Dynamic subtest sanitycheck: SUCCESS (1.265s) [233.914122] Starting dynamic subtest: uncore [235.219728] Dynamic subtest uncore: SUCCESS (1.313s) [235.233368] Starting dynamic subtest: workarounds [236.853697] Dynamic subtest workarounds: SUCCESS (1.632s) [236.862166] Starting dynamic subtest: gt_engines [238.720886] Dynamic subtest gt_engines: SUCCESS (1.865s) [238.729311] Starting dynamic subtest: gt_timelines [246.377996] Dynamic subtest gt_timelines: SUCCESS (7.655s) [246.391804] Starting dynamic subtest: gt_contexts [247.848782] Dynamic subtest gt_contexts: SUCCESS (1.469s) [247.857231] Starting dynamic subtest: gt_lrc [252.073074] Dynamic subtest gt_lrc: SUCCESS (4.222s) [252.082024] Starting dynamic subtest: gt_mocs [253.504679] Dynamic subtest gt_mocs: SUCCESS (1.430s) [253.510435] Starting dynamic subtest: gt_pm [275.025711] Dynamic subtest gt_pm: SUCCESS (21.519s) [275.034351] Starting dynamic subtest: gt_heartbeat [276.330720] Dynamic subtest gt_heartbeat: SUCCESS (1.303s) [276.340280] Starting dynamic subtest: gt_tlb [279.902709] Dynamic subtest gt_tlb: SUCCESS (3.570s) [279.913111] Starting dynamic subtest: requests [288.537134] Dynamic subtest requests: SUCCESS (8.632s) [288.545650] Starting dynamic subtest: migrate [293.027489] Dynamic subtest migrate: SUCCESS (4.496s) [293.040281] Starting dynamic subtest: active [294.325638] Dynamic subtest active: SUCCESS (1.288s) [294.334541] Starting dynamic subtest: objects [296.071743] Dynamic subtest objects: SUCCESS (1.744s) [296.080798] Starting dynamic subtest: mman [300.938581] Dynamic subtest mman: SUCCESS (4.865s) [300.947127] Starting dynamic subtest: dmabuf [302.283721] Dynamic subtest dmabuf: SUCCESS (1.343s) [302.292739] Starting dynamic subtest: vma [303.582746] Dynamic subtest vma: SUCCESS (1.297s) [303.596679] Starting dynamic subtest: coherency [307.436678] Dynamic subtest coherency: SUCCESS (3.852s) [307.444155] Starting dynamic subtest: gtt [316.035607] Dynamic subtest gtt: SUCCESS (8.597s) [316.049789] Starting dynamic subtest: gem [318.272536] Dynamic subtest gem: SUCCESS (2.235s) [318.278295] Starting dynamic subtest: evict [320.453084] Dynamic subtest evict: SUCCESS (2.179s) [320.461418] Starting dynamic subtest: hugepages [328.296504] Dynamic subtest hugepages: SUCCESS (7.841s) [328.304998] Starting dynamic subtest: gem_contexts [343.413383] Dynamic subtest gem_contexts: SUCCESS (15.115s) [343.421682] Starting dynamic subtest: client [344.772246] Dynamic subtest client: SUCCESS (1.356s) [344.785736] Starting dynamic subtest: gem_migrate [346.139161] Dynamic subtest gem_migrate: SUCCESS (1.365s) [346.153444] Starting dynamic subtest: reset [351.159861] Dynamic subtest reset: SUCCESS (5.019s) [351.169221] Starting dynamic subtest: memory_region [352.441765] Dynamic subtest memory_region: SUCCESS (1.280s) [352.455061] Starting dynamic subtest: hangcheck [382.613899] Dynamic subtest hangcheck: SUCCESS (30.178s) [382.627061] Starting dynamic subtest: execlists [396.612222] Dynamic subtest execlists: SUCCESS (13.988s) [396.624327] Starting dynamic subtest: ring_submission [397.921710] Dynamic subtest ring_submission: SUCCESS (1.307s) [397.930428] Starting dynamic subtest: perf [399.291606] Dynamic subtest perf: SUCCESS (1.368s) [399.299946] Starting dynamic subtest: slpc [400.538781] Dynamic subtest slpc: SUCCESS (1.245s) [400.546935] Starting dynamic subtest: guc [401.851757] Dynamic subtest guc: SUCCESS (1.311s) [401.860612] Starting dynamic subtest: guc_multi_lrc [403.142865] Dynamic subtest guc_multi_lrc: SUCCESS (1.289s) [403.151734] Starting dynamic subtest: guc_hang [404.457738] Dynamic subtest guc_hang: SUCCESS (1.313s) [404.466658] Starting dynamic subtest: late_gt_pm [405.833821] Dynamic subtest late_gt_pm: SUCCESS (1.374s) [405.834976] Subtest live: SUCCESS (173.196s) [405.865454] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [405.866398] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true [405.870290] [080/131] (617s left) kms_big_fb (4-tiled-64bpp-rotate-90) [406.854498] Starting subtest: 4-tiled-64bpp-rotate-90 [406.855876] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.000s) [406.936150] [FACT kms_big_fb (4-tiled-64bpp-rotate-90)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [406.938276] [FACT kms_big_fb (4-tiled-64bpp-rotate-90)] new: kernel.kmod_is_loaded.i915: true [406.940562] [081/131] (616s left) kms_flip (plain-flip-interruptible) [407.034235] Starting subtest: plain-flip-interruptible [407.037048] Starting dynamic subtest: A-HDMI-A1 [407.687219] Dynamic subtest A-HDMI-A1: SUCCESS (0.650s) [407.702717] Starting dynamic subtest: B-HDMI-A1 [408.325804] Dynamic subtest B-HDMI-A1: SUCCESS (0.632s) [408.337143] Starting dynamic subtest: C-HDMI-A1 [408.966955] Dynamic subtest C-HDMI-A1: SUCCESS (0.637s) [408.973408] Starting dynamic subtest: D-HDMI-A1 [409.608332] Dynamic subtest D-HDMI-A1: SUCCESS (0.643s) [409.609321] Subtest plain-flip-interruptible: SUCCESS (2.572s) [409.785082] [082/131] (613s left) syncobj_timeline (invalid-signal-one-illegal-handle) [409.828925] Starting subtest: invalid-signal-one-illegal-handle [409.829671] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s) [409.895851] [083/131] (613s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu) [409.992413] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu [409.993864] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [410.077884] [084/131] (613s left) gem_render_copy (y-tiled-to-vebox-y-tiled) [410.123906] Starting subtest: y-tiled-to-vebox-y-tiled [410.124638] Starting dynamic subtest: smem [410.229045] Dynamic subtest smem: SUCCESS (0.105s) [410.229829] Subtest y-tiled-to-vebox-y-tiled: SUCCESS (0.105s) [410.404653] [085/131] (612s left) syncobj_basic (bad-destroy) [410.440800] Starting subtest: bad-destroy [410.441504] Subtest bad-destroy: SUCCESS (0.000s) [410.496657] [086/131] (612s left) gem_pipe_control_store_loop (fresh-buffer) [410.540061] Starting subtest: fresh-buffer [412.698991] Subtest fresh-buffer: SUCCESS (2.150s) [412.798657] [087/131] (610s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-render) [412.897427] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-render [412.898845] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-render: SKIP (0.000s) [412.997895] [088/131] (610s left) kms_cursor_crc (cursor-onscreen-max-size) [413.094910] Starting subtest: cursor-onscreen-max-size [413.096949] Subtest cursor-onscreen-max-size: SKIP (0.000s) [413.203083] [089/131] (610s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc) [413.295875] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc [413.297761] Starting dynamic subtest: pipe-A-HDMI-A-1 [413.304704] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s) [413.311572] Starting dynamic subtest: pipe-B-HDMI-A-1 [413.318244] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s) [413.324881] Starting dynamic subtest: pipe-C-HDMI-A-1 [413.331536] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s) [413.338116] Starting dynamic subtest: pipe-D-HDMI-A-1 [413.344886] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s) [413.353138] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SKIP (0.006s) [413.530753] [090/131] (609s left) i915_pm_rpm (system-suspend) [424.979492] Starting subtest: system-suspend [443.766686] Subtest system-suspend: SUCCESS (3.473s) [452.010407] [091/131] (594s left) kms_psr (psr2-primary-render) [452.104192] Subtest psr2-primary-render: SKIP (0.000s) [452.142755] [092/131] (594s left) gem_exec_reloc (basic-wc-active) [452.184550] Starting subtest: basic-wc-active [452.312788] Subtest basic-wc-active: SUCCESS (0.119s) [452.423601] [093/131] (594s left) kms_selftest (drm_plane_helper) [452.464482] Starting subtest: drm_plane_helper [452.470974] Starting dynamic subtest: drm_test_check_plane_state [452.561048] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.089s) [452.572967] Starting dynamic subtest: drm_test_check_invalid_plane_state [452.668221] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.103s) [452.669312] Subtest drm_plane_helper: SUCCESS (0.202s) [452.829262] [094/131] (593s left) gem_softpin (softpin) [452.873677] Starting subtest: softpin [485.263545] Subtest softpin: SUCCESS (32.370s) [485.377473] [095/131] (561s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc) [485.473252] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc [485.474732] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [485.567106] [096/131] (561s left) gem_pxp (verify-pxp-stale-buf-execution) [485.672097] Starting subtest: verify-pxp-stale-buf-execution [496.778994] Subtest verify-pxp-stale-buf-execution: SUCCESS (11.108s) [496.891781] [097/131] (550s left) kms_flip (2x-flip-vs-wf_vblank) [496.983261] Starting subtest: 2x-flip-vs-wf_vblank [496.991829] Subtest 2x-flip-vs-wf_vblank: SKIP (0.009s) [497.067269] [098/131] (549s left) gem_exec_reloc (basic-concurrent0) [497.108086] Starting subtest: basic-concurrent0 [502.548175] Subtest basic-concurrent0: SUCCESS (5.412s) [502.634763] [099/131] (544s left) syncobj_eventfd (binary-wait-signaled) [502.674312] Starting subtest: binary-wait-signaled [502.675025] Subtest binary-wait-signaled: SUCCESS (0.000s) [502.737154] [100/131] (544s left) gem_ctx_persistence (engines-mixed-process) [502.778525] Starting subtest: engines-mixed-process [502.779298] Starting dynamic subtest: rcs0 [503.176479] Dynamic subtest rcs0: SUCCESS (0.397s) [503.194117] Starting dynamic subtest: bcs0 [503.566185] Dynamic subtest bcs0: SUCCESS (0.387s) [503.576241] Starting dynamic subtest: vcs0 [503.925461] Dynamic subtest vcs0: SUCCESS (0.357s) [503.941914] Starting dynamic subtest: vcs1 [504.312586] Dynamic subtest vcs1: SUCCESS (0.385s) [504.330736] Starting dynamic subtest: vecs0 [504.676432] Dynamic subtest vecs0: SUCCESS (0.362s) [504.677810] Subtest engines-mixed-process: SUCCESS (1.898s) [504.753142] [101/131] (542s left) gem_exec_whisper (basic-sync) [504.801843] Starting subtest: basic-sync [507.704474] Subtest basic-sync: SUCCESS (2.901s) [507.890170] [102/131] (539s left) perf_pmu (semaphore-wait-idle) [507.928726] Starting subtest: semaphore-wait-idle [507.929502] Starting dynamic subtest: rcs0 [508.446400] Dynamic subtest rcs0: SUCCESS (0.508s) [508.456706] Starting dynamic subtest: bcs0 [508.958480] Dynamic subtest bcs0: SUCCESS (0.510s) [508.969079] Starting dynamic subtest: vcs0 [509.469784] Dynamic subtest vcs0: SUCCESS (0.509s) [509.480475] Starting dynamic subtest: vcs1 [509.981216] Dynamic subtest vcs1: SUCCESS (0.509s) [509.991478] Starting dynamic subtest: vecs0 [510.493116] Dynamic subtest vecs0: SUCCESS (0.510s) [510.494168] Subtest semaphore-wait-idle: SUCCESS (2.556s) [510.588818] [103/131] (536s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt) [510.685339] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt [512.045512] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (1.359s) [512.172543] [104/131] (535s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [512.273441] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [512.670428] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.396s) [512.833008] [105/131] (534s left) gem_vm_create (invalid-create) [512.872846] Starting subtest: invalid-create [512.873633] Subtest invalid-create: SUCCESS (0.001s) [512.967371] [106/131] (534s left) kms_addfb_basic (unused-offsets) [513.006230] Starting subtest: unused-offsets [513.006980] Subtest unused-offsets: SUCCESS (0.000s) [513.130701] [107/131] (534s left) perf (per-context-mode-unprivileged) [513.225928] Starting subtest: per-context-mode-unprivileged [513.227320] Subtest per-context-mode-unprivileged: SKIP (0.000s) [513.270859] [108/131] (534s left) kms_hdr (static-toggle-suspend) [513.362443] Starting subtest: static-toggle-suspend [513.364560] Subtest static-toggle-suspend: SKIP (0.000s) [513.420009] [109/131] (533s left) kms_psr (pr-primary-mmap-gtt) [513.509063] Subtest pr-primary-mmap-gtt: SKIP (0.000s) [513.548067] [110/131] (533s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled) [513.585662] Starting subtest: etime-multi-wait-all-submitted-signaled [513.690482] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.105s) [513.771604] [111/131] (533s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite) [513.865397] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite [513.866806] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [513.966964] [112/131] (533s left) kms_plane (plane-panning-bottom-right) [514.056656] Starting subtest: plane-panning-bottom-right [514.057561] Starting dynamic subtest: pipe-A [514.448861] Dynamic subtest pipe-A: SUCCESS (0.390s) [514.460366] Starting dynamic subtest: pipe-B [514.808836] Dynamic subtest pipe-B: SUCCESS (0.359s) [514.809546] Subtest plane-panning-bottom-right: SUCCESS (0.753s) [514.967057] [113/131] (532s left) kms_addfb_basic (basic-y-tiled-legacy) [515.005465] Starting subtest: basic-y-tiled-legacy [515.006242] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [515.168183] [114/131] (532s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt) [515.261904] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt [515.263365] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [515.366368] [115/131] (532s left) gem_exec_reloc (basic-write-gtt) [515.407514] Starting subtest: basic-write-gtt [515.412792] Subtest basic-write-gtt: SUCCESS (0.005s) [515.529775] [116/131] (532s left) gem_tiling_max_stride [515.678829] [117/131] (532s left) kms_content_protection (mei-interface) [515.778829] Starting subtest: mei-interface [516.087898] Subtest mei-interface: SKIP (0.307s) [516.258404] [118/131] (531s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render) [516.351927] Starting subtest: fbcpsr-rgb101010-draw-render [516.353354] Subtest fbcpsr-rgb101010-draw-render: SKIP (0.000s) [516.450567] [119/131] (531s left) kms_chamelium_color (ctm-red-to-blue) [516.542078] Subtest ctm-red-to-blue: SKIP (0.000s) [516.594700] [120/131] (531s left) dmabuf_sync_file (import-basic) [516.641267] Starting subtest: import-basic [516.642336] Subtest import-basic: SUCCESS (0.002s) [516.696320] [121/131] (531s left) gen3_mixed_blits [516.777127] [122/131] (531s left) gem_mmap_gtt (medium-copy-odd) [516.815467] Starting subtest: medium-copy-odd [520.642598] Subtest medium-copy-odd: SUCCESS (3.827s) [520.710003] [123/131] (527s left) kms_cursor_legacy (cursorb-vs-flipb-toggle) [520.845459] Starting subtest: cursorB-vs-flipB-toggle [520.847893] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s) [520.910134] [124/131] (527s left) syncobj_timeline (wait-all-for-submit-complex) [520.957510] Starting subtest: wait-all-for-submit-complex [521.182909] Subtest wait-all-for-submit-complex: SUCCESS (0.216s) [521.245074] [125/131] (526s left) kms_flip (2x-flip-vs-blocking-wf-vblank) [521.335221] Starting subtest: 2x-flip-vs-blocking-wf-vblank [521.343903] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.009s) [521.410388] [126/131] (526s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes) [521.872894] Starting subtest: syncobj-timeline-multiple-ext-nodes [521.873955] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.003s) [522.052126] [127/131] (526s left) gem_pxp (regular-baseline-src-copy-readible) [522.093382] Starting subtest: regular-baseline-src-copy-readible [522.133654] Subtest regular-baseline-src-copy-readible: SUCCESS (0.040s) [522.245290] [128/131] (525s left) kms_big_fb (x-tiled-64bpp-rotate-180) [522.344677] Starting subtest: x-tiled-64bpp-rotate-180 [524.567291] Subtest x-tiled-64bpp-rotate-180: SUCCESS (2.222s) [524.818440] [129/131] (523s left) gem_tiled_partial_pwrite_pread (writes) [524.857892] Starting subtest: writes [525.413223] Subtest writes: SUCCESS (0.555s) [525.543024] [130/131] (522s left) gem_exec_balancer (bonded-chain) [525.591119] Starting subtest: bonded-chain [532.701608] Subtest bonded-chain: SUCCESS (7.101s) [532.873844] [131/131] (515s left) perf_pmu (busy-double-start) [532.915695] Starting subtest: busy-double-start [532.916474] Starting dynamic subtest: rcs0 [536.476291] Dynamic subtest rcs0: SUCCESS (3.559s) [536.488893] Starting dynamic subtest: bcs0 [540.040312] Dynamic subtest bcs0: SUCCESS (3.561s) [540.051645] Starting dynamic subtest: vcs0 [543.589323] Dynamic subtest vcs0: SUCCESS (3.546s) [543.601140] Starting dynamic subtest: vcs1 [547.154369] Dynamic subtest vcs1: SUCCESS (3.562s) [547.165673] Starting dynamic subtest: vecs0 [550.718186] Dynamic subtest vecs0: SUCCESS (3.562s) [550.719335] Subtest busy-double-start: SUCCESS (17.802s) [550.789318] Closing watchdogs results: parsing output: 0/ for test: gem_exec_params results: parsing output: 1/ for test: gem_caching results: parsing output: 2/ for test: kms_psr2_sf results: parsing output: 3/ for test: kms_pm_rpm results: parsing output: 4/ for test: kms_chamelium_frames results: parsing output: 5/ for test: perf results: parsing output: 6/ for test: drm_fdinfo results: parsing output: 7/ for test: kms_setmode results: parsing output: 8/ for test: kms_psr results: parsing output: 9/ for test: perf results: parsing output: 10/ for test: syncobj_timeline results: parsing output: 11/ for test: gem_flink_race results: parsing output: 12/ for test: gem_exec_reloc results: parsing output: 13/ for test: gem_mmap_offset results: parsing output: 14/ for test: gem_mmap_gtt results: parsing output: 15/ for test: gem_exec_endless results: parsing output: 16/ for test: syncobj_timeline results: parsing output: 17/ for test: kms_fbc_dirty_rect results: parsing output: 18/ for test: device_reset results: parsing output: 19/ for test: gem_basic results: parsing output: 20/ for test: kms_frontbuffer_tracking results: parsing output: 21/ for test: kms_pipe_b_c_ivb results: parsing output: 22/ for test: fbdev results: parsing output: 23/ for test: kms_psr results: parsing output: 24/ for test: kms_frontbuffer_tracking results: parsing output: 25/ for test: kms_frontbuffer_tracking results: parsing output: 26/ for test: gem_eio results: parsing output: 27/ for test: kms_plane_scaling results: parsing output: 28/ for test: kms_psr results: parsing output: 29/ for test: kms_vblank results: parsing output: 30/ for test: kms_ccs results: parsing output: 31/ for test: sw_sync results: parsing output: 32/ for test: gen9_exec_parse results: parsing output: 33/ for test: gem_exec_schedule results: parsing output: 34/ for test: kms_vrr results: parsing output: 35/ for test: kms_dirtyfb results: parsing output: 36/ for test: gem_exec_params results: parsing output: 37/ for test: kms_busy results: parsing output: 38/ for test: sysfs_heartbeat_interval results: parsing output: 39/ for test: kms_frontbuffer_tracking results: parsing output: 40/ for test: kms_flip results: parsing output: 41/ for test: kms_big_fb results: parsing output: 42/ for test: kms_ccs results: parsing output: 43/ for test: kms_flip_scaled_crc results: parsing output: 44/ for test: prime_vgem results: parsing output: 45/ for test: syncobj_wait results: parsing output: 46/ for test: gem_lmem_swapping results: parsing output: 47/ for test: kms_ccs results: parsing output: 48/ for test: gem_eio results: parsing output: 49/ for test: kms_color results: parsing output: 50/ for test: kms_lease results: parsing output: 51/ for test: gem_ctx_engines results: parsing output: 52/ for test: kms_dp_linktrain_fallback results: parsing output: 53/ for test: kms_frontbuffer_tracking results: parsing output: 54/ for test: gem_exec_balancer results: parsing output: 55/ for test: kms_psr2_sf results: parsing output: 56/ for test: kms_big_fb results: parsing output: 57/ for test: kms_big_fb results: parsing output: 58/ for test: i915_module_load results: parsing output: 59/ for test: kms_frontbuffer_tracking results: parsing output: 60/ for test: gem_userptr_blits results: parsing output: 61/ for test: syncobj_wait results: parsing output: 62/ for test: kms_frontbuffer_tracking results: parsing output: 63/ for test: api_intel_bb results: parsing output: 64/ for test: kms_frontbuffer_tracking results: parsing output: 65/ for test: kms_joiner results: parsing output: 66/ for test: kms_cursor_crc results: parsing output: 67/ for test: kms_frontbuffer_tracking results: parsing output: 68/ for test: kms_pipe_crc_basic results: parsing output: 69/ for test: kms_psr2_sf results: parsing output: 70/ for test: kms_cursor_legacy results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: kms_cdclk results: parsing output: 73/ for test: kms_plane_scaling results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: gem_ctx_shared results: parsing output: 76/ for test: gem_exec_schedule results: parsing output: 77/ for test: kms_frontbuffer_tracking results: parsing output: 78/ for test: i915_selftest results: parsing output: 79/ for test: kms_big_fb results: parsing output: 80/ for test: kms_flip results: parsing output: 81/ for test: syncobj_timeline results: parsing output: 82/ for test: kms_frontbuffer_tracking results: parsing output: 83/ for test: gem_render_copy results: parsing output: 84/ for test: syncobj_basic results: parsing output: 85/ for test: gem_pipe_control_store_loop results: parsing output: 86/ for test: kms_frontbuffer_tracking results: parsing output: 87/ for test: kms_cursor_crc results: parsing output: 88/ for test: kms_ccs results: parsing output: 89/ for test: i915_pm_rpm results: parsing output: 90/ for test: kms_psr results: parsing output: 91/ for test: gem_exec_reloc results: parsing output: 92/ for test: kms_selftest results: parsing output: 93/ for test: gem_softpin results: parsing output: 94/ for test: kms_frontbuffer_tracking results: parsing output: 95/ for test: gem_pxp results: parsing output: 96/ for test: kms_flip results: parsing output: 97/ for test: gem_exec_reloc results: parsing output: 98/ for test: syncobj_eventfd results: parsing output: 99/ for test: gem_ctx_persistence results: parsing output: 100/ for test: gem_exec_whisper results: parsing output: 101/ for test: perf_pmu results: parsing output: 102/ for test: kms_frontbuffer_tracking results: parsing output: 103/ for test: kms_big_fb results: parsing output: 104/ for test: gem_vm_create results: parsing output: 105/ for test: kms_addfb_basic results: parsing output: 106/ for test: perf results: parsing output: 107/ for test: kms_hdr results: parsing output: 108/ for test: kms_psr results: parsing output: 109/ for test: syncobj_timeline results: parsing output: 110/ for test: kms_frontbuffer_tracking results: parsing output: 111/ for test: kms_plane results: parsing output: 112/ for test: kms_addfb_basic results: parsing output: 113/ for test: kms_frontbuffer_tracking results: parsing output: 114/ for test: gem_exec_reloc results: parsing output: 115/ for test: gem_tiling_max_stride results: parsing output: 116/ for test: kms_content_protection results: parsing output: 117/ for test: kms_frontbuffer_tracking results: parsing output: 118/ for test: kms_chamelium_color results: parsing output: 119/ for test: dmabuf_sync_file results: parsing output: 120/ for test: gen3_mixed_blits results: parsing output: 121/ for test: gem_mmap_gtt results: parsing output: 122/ for test: kms_cursor_legacy results: parsing output: 123/ for test: syncobj_timeline results: parsing output: 124/ for test: kms_flip results: parsing output: 125/ for test: gem_exec_fence results: parsing output: 126/ for test: gem_pxp results: parsing output: 127/ for test: kms_big_fb results: parsing output: 128/ for test: gem_tiled_partial_pwrite_pread results: parsing output: 129/ for test: gem_exec_balancer results: parsing output: 130/ for test: perf_pmu Done.