[57.110921] Initializing watchdogs [57.110967] /dev/watchdog0 [57.124985] [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] [57.129337] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.131542] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.134597] [001/134] (960s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [57.262694] Starting subtest: addfb25-y-tiled-small-legacy [57.267263] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [57.396157] [002/134] (960s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers) [57.493766] Starting subtest: plane-downscale-factor-0-75-with-modifiers [57.496053] Starting dynamic subtest: pipe-A [57.867617] Dynamic subtest pipe-A: SUCCESS (0.376s) [57.877791] Starting dynamic subtest: pipe-B [59.357807] Dynamic subtest pipe-B: SUCCESS (1.489s) [59.366592] Starting dynamic subtest: pipe-C [60.749054] Dynamic subtest pipe-C: SUCCESS (1.390s) [60.757735] Starting dynamic subtest: pipe-D [62.194612] Dynamic subtest pipe-D: SUCCESS (1.445s) [62.196872] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.703s) [63.371210] [003/134] (954s left) i915_drm_fdinfo (virtual-idle) [63.411760] Starting subtest: virtual-idle [66.495804] Subtest virtual-idle: SUCCESS (3.082s) [66.592340] [004/134] (951s left) gem_userptr_blits (huge-split) [66.671692] Starting subtest: huge-split [66.688039] Subtest huge-split: SUCCESS (0.016s) [66.945312] [005/134] (950s left) kms_psr (fbc-pr-no-drrs) [67.157218] Starting subtest: fbc-pr-no-drrs [67.162132] Subtest fbc-pr-no-drrs: SKIP (0.000s) [67.461901] [006/134] (950s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu) [67.591581] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu [74.538822] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (6.951s) [74.697149] [007/134] (943s left) kms_cursor_legacy (cursora-vs-flipa-legacy) [74.817073] Starting subtest: cursorA-vs-flipA-legacy [85.973364] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.154s) [86.853889] [008/134] (931s left) kms_psr (psr2-primary-page-flip) [86.946200] Starting subtest: psr2-primary-page-flip [86.948439] Starting dynamic subtest: eDP-1 [88.716504] Dynamic subtest eDP-1: SUCCESS (1.770s) [88.718887] Subtest psr2-primary-page-flip: SUCCESS (1.770s) [89.611420] [009/134] (928s left) i915_pm_rc6_residency (rc6-accuracy) [89.676245] Starting subtest: rc6-accuracy [89.678562] Starting dynamic subtest: gt0 [92.848708] Dynamic subtest gt0: SUCCESS (3.169s) [92.858650] Starting dynamic subtest: gt1 [96.070890] Dynamic subtest gt1: SUCCESS (3.170s) [96.073514] Subtest rc6-accuracy: SUCCESS (6.342s) [96.115095] [010/134] (921s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt) [96.219058] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt [103.545058] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.330s) [103.714499] [011/134] (914s left) kms_feature_discovery (psr2) [103.812906] Starting subtest: psr2 [103.814910] Subtest psr2: SUCCESS (0.000s) [103.905452] [012/134] (914s left) syncobj_wait (single-wait-all-for-submit-submitted) [103.964119] Starting subtest: single-wait-all-for-submit-submitted [104.073455] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.108s) [104.168317] [013/134] (913s left) kms_flip (2x-wf_vblank-ts-check-interruptible) [104.254535] Starting subtest: 2x-wf_vblank-ts-check-interruptible [104.266133] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.011s) [104.383127] [014/134] (913s left) kms_psr_stress_test (flip-primary-invalidate-overlay) [104.468771] Starting subtest: flip-primary-invalidate-overlay [116.062996] Subtest flip-primary-invalidate-overlay: SUCCESS (11.596s) [116.246369] [015/134] (901s left) i915_drm_fdinfo (busy-idle) [116.290500] Starting subtest: busy-idle [116.292066] Starting dynamic subtest: rcs0 [116.308109] Dynamic subtest rcs0: SKIP (0.017s) [116.315426] Starting dynamic subtest: bcs0 [116.320793] Dynamic subtest bcs0: SKIP (0.011s) [116.327950] Starting dynamic subtest: vcs0 [116.331410] Dynamic subtest vcs0: SKIP (0.000s) [116.338393] Starting dynamic subtest: vcs1 [116.341577] Dynamic subtest vcs1: SKIP (0.000s) [116.348494] Starting dynamic subtest: vecs0 [116.351977] Dynamic subtest vecs0: SKIP (0.000s) [116.358795] Starting dynamic subtest: ccs0 [116.362187] Dynamic subtest ccs0: SKIP (0.000s) [116.365630] Subtest busy-idle: SKIP (0.031s) [116.417272] [016/134] (901s left) gem_exec_params (invalid-bsd2-flag-on-vebox) [116.481892] Starting subtest: invalid-bsd2-flag-on-vebox [116.484079] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s) [116.617695] [017/134] (901s left) syncobj_wait (single-wait-all-for-submit-signaled) [116.686274] Starting subtest: single-wait-all-for-submit-signaled [116.688320] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s) [116.815088] [018/134] (901s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt) [116.925483] Starting subtest: fbcpsr-rgb101010-draw-blt [123.667053] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (6.744s) [123.832076] [019/134] (894s left) kms_pm_rpm (modeset-lpsp) [126.064640] Starting subtest: modeset-lpsp [127.525229] Subtest modeset-lpsp: SUCCESS (1.464s) [127.638949] [020/134] (890s left) i915_suspend (sysfs-reader) [127.698936] Starting subtest: sysfs-reader [145.377388] Subtest sysfs-reader: SUCCESS (3.209s) [145.442326] [021/134] (873s left) prime_vgem (sync) [145.581585] Starting subtest: sync [145.583692] Starting dynamic subtest: rcs0 [145.641453] Dynamic subtest rcs0: SUCCESS (0.060s) [145.649879] Starting dynamic subtest: bcs0 [145.723741] Dynamic subtest bcs0: SUCCESS (0.082s) [145.732122] Starting dynamic subtest: vcs0 [145.771146] Dynamic subtest vcs0: SUCCESS (0.047s) [145.779391] Starting dynamic subtest: vcs1 [145.815830] Dynamic subtest vcs1: SUCCESS (0.044s) [145.824402] Starting dynamic subtest: vecs0 [145.861734] Dynamic subtest vecs0: SUCCESS (0.045s) [145.870318] Starting dynamic subtest: ccs0 [145.907631] Dynamic subtest ccs0: SUCCESS (0.046s) [145.909739] Subtest sync: SUCCESS (0.327s) [146.094415] [FACT prime_vgem (sync)] new: kernel.kmod_is_loaded.vgem: true [146.097254] [022/134] (872s left) api_intel_allocator (two-level-inception) [146.157300] Starting subtest: two-level-inception [151.610415] Subtest two-level-inception: SUCCESS (5.401s) [151.722320] [023/134] (866s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move) [151.841689] Starting subtest: psr-2p-primscrn-cur-indfb-move [151.845966] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [151.987853] [024/134] (866s left) sriov_basic (bind-unbind-vf) [152.048945] Starting subtest: bind-unbind-vf [152.051327] Starting dynamic subtest: vf-1 [152.129731] Dynamic subtest vf-1: FAIL (0.032s) [152.138358] Starting dynamic subtest: vf-2 [152.208068] Dynamic subtest vf-2: FAIL (0.004s) [152.218261] Starting dynamic subtest: vf-3 [152.287503] Dynamic subtest vf-3: FAIL (0.004s) [152.295877] Starting dynamic subtest: vf-4 [152.368418] Dynamic subtest vf-4: FAIL (0.005s) [152.378754] Starting dynamic subtest: vf-5 [152.451094] Dynamic subtest vf-5: FAIL (0.004s) [152.460956] Starting dynamic subtest: vf-6 [152.534165] Dynamic subtest vf-6: FAIL (0.004s) [152.544981] Starting dynamic subtest: vf-7 [152.610773] Dynamic subtest vf-7: FAIL (0.004s) [152.618711] Starting dynamic subtest: vf-random [152.675885] Dynamic subtest vf-random: FAIL (0.004s) [152.683607] Starting dynamic subtest: vf-last [152.742535] Dynamic subtest vf-last: FAIL (0.004s) [152.744508] Subtest bind-unbind-vf: FAIL (0.560s) [152.783423] [025/134] (865s left) gem_eio (hibernate) [153.031596] Starting subtest: hibernate [168.365074] Subtest hibernate: SUCCESS (15.332s) [176.545733] [026/134] (850s left) kms_vrr (seamless-rr-switch-virtual) [176.672902] Starting subtest: seamless-rr-switch-virtual [176.679364] Subtest seamless-rr-switch-virtual: SKIP (0.000s) [176.768536] [027/134] (850s left) api_intel_bb (render) [176.843978] Starting subtest: render [176.845930] Starting dynamic subtest: render-none-512 [176.960885] Dynamic subtest render-none-512: SUCCESS (0.118s) [176.971832] Starting dynamic subtest: render-none-1024 [177.612878] Dynamic subtest render-none-1024: SUCCESS (0.650s) [177.624032] Starting dynamic subtest: render-x-512 [177.699127] Dynamic subtest render-x-512: SUCCESS (0.086s) [177.711066] Starting dynamic subtest: render-x-1024 [178.036140] Dynamic subtest render-x-1024: SUCCESS (0.336s) [178.048480] Starting dynamic subtest: render-y-512 [178.120426] Dynamic subtest render-y-512: SUCCESS (0.085s) [178.132447] Starting dynamic subtest: render-y-1024 [178.458886] Dynamic subtest render-y-1024: SUCCESS (0.337s) [178.461724] Subtest render: SUCCESS (1.616s) [178.569962] [028/134] (848s left) kms_cursor_legacy (torture-bo) [178.698275] Starting subtest: torture-bo [178.700522] Starting dynamic subtest: pipe-A [184.670560] Dynamic subtest pipe-A: SUCCESS (5.970s) [184.682310] Starting dynamic subtest: pipe-B [191.471570] Dynamic subtest pipe-B: SUCCESS (6.799s) [191.484275] Starting dynamic subtest: pipe-C [198.781883] Dynamic subtest pipe-C: SUCCESS (7.309s) [198.793602] Starting dynamic subtest: pipe-D [205.459670] Dynamic subtest pipe-D: SUCCESS (6.678s) [205.471640] Starting dynamic subtest: all-pipes [211.578480] Dynamic subtest all-pipes: SUCCESS (6.118s) [211.581185] Subtest torture-bo: SUCCESS (32.880s) [211.759576] [029/134] (815s left) kms_rotation_crc (sprite-rotation-270) [211.871024] Starting subtest: sprite-rotation-270 [211.875524] Subtest sprite-rotation-270: SKIP (0.001s) [211.964500] [030/134] (814s left) kms_prime (basic-modeset-hybrid) [212.047592] Subtest basic-modeset-hybrid: SKIP (0.000s) [212.163443] [031/134] (814s left) gem_ctx_persistence (many-contexts) [212.227147] Starting subtest: many-contexts [249.958601] Subtest many-contexts: SUCCESS (37.731s) [250.064670] [032/134] (776s left) gem_create (busy-create) [250.130779] Starting subtest: busy-create [250.133212] Starting dynamic subtest: smem0 [283.368732] Dynamic subtest smem0: SUCCESS (33.237s) [283.371259] Subtest busy-create: SUCCESS (33.238s) [283.583045] [033/134] (743s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [283.695144] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [283.699484] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [283.825824] [034/134] (743s left) kms_psr (fbc-psr-cursor-blt) [283.932837] Starting subtest: fbc-psr-cursor-blt [283.935003] Starting dynamic subtest: eDP-1 [283.938971] Dynamic subtest eDP-1: SKIP (0.000s) [283.942954] Subtest fbc-psr-cursor-blt: SKIP (0.001s) [284.029335] [035/134] (743s left) gem_sync (basic-store-each) [284.117385] Starting subtest: basic-store-each [286.498475] Subtest basic-store-each: SUCCESS (2.392s) [286.710634] [036/134] (740s left) prime_mmap (test_userptr) [286.769731] Starting subtest: test_userptr [286.772194] Starting dynamic subtest: test_userptr-smem [286.774254] Dynamic subtest test_userptr-smem: SUCCESS (0.000s) [286.776284] Subtest test_userptr: SUCCESS (0.001s) [286.912583] [037/134] (740s left) kms_pipe_crc_basic (nonblocking-crc) [287.020311] Starting subtest: nonblocking-crc [287.022747] Starting dynamic subtest: pipe-A-eDP-1 [287.784046] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.761s) [287.794997] Starting dynamic subtest: pipe-B-eDP-1 [289.219612] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.435s) [289.230627] Starting dynamic subtest: pipe-C-eDP-1 [290.601864] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.380s) [290.612973] Starting dynamic subtest: pipe-D-eDP-1 [291.945296] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.342s) [291.947484] Subtest nonblocking-crc: SUCCESS (4.924s) [292.773199] [038/134] (734s left) perf (unprivileged-single-ctx-counters) [292.914914] Starting subtest: unprivileged-single-ctx-counters [292.919376] Subtest unprivileged-single-ctx-counters: SKIP (0.000s) [292.970747] [039/134] (734s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area) [298.043738] Starting subtest: psr2-overlay-primary-update-sf-dmg-area [298.048898] Starting dynamic subtest: pipe-A-eDP-1 [304.648600] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.600s) [304.659350] Starting dynamic subtest: pipe-B-eDP-1 [311.314495] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.664s) [311.316820] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (13.270s) [312.208518] [040/134] (715s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf) [317.186572] Starting subtest: pr-overlay-plane-move-continuous-sf [317.191009] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.002s) [318.035517] [041/134] (709s left) kms_psr (fbc-psr-sprite-blt) [318.134878] Starting subtest: fbc-psr-sprite-blt [318.137160] Starting dynamic subtest: eDP-1 [318.143363] Dynamic subtest eDP-1: SKIP (0.000s) [318.147587] Subtest fbc-psr-sprite-blt: SKIP (0.001s) [318.231731] [042/134] (709s left) sysfs_timeslice_duration (invalid) [318.305570] Starting subtest: invalid [318.307971] Starting dynamic subtest: vecs0 [318.310228] Dynamic subtest vecs0: SUCCESS (0.000s) [318.320954] Starting dynamic subtest: ccs0 [318.323054] Dynamic subtest ccs0: SUCCESS (0.000s) [318.332478] Starting dynamic subtest: vcs0 [318.334584] Dynamic subtest vcs0: SUCCESS (0.000s) [318.343993] Starting dynamic subtest: bcs0 [318.346069] Dynamic subtest bcs0: SUCCESS (0.000s) [318.355870] Starting dynamic subtest: rcs0 [318.358107] Dynamic subtest rcs0: SUCCESS (0.000s) [318.367425] Starting dynamic subtest: vcs1 [318.369336] Dynamic subtest vcs1: SUCCESS (0.000s) [318.371234] Subtest invalid: SUCCESS (0.005s) [318.449299] [043/134] (709s left) gem_barrier_race (remote-request) [318.511762] Starting subtest: remote-request [318.514426] Starting dynamic subtest: rcs0 [323.676045] Dynamic subtest rcs0: SUCCESS (5.164s) [323.677982] Subtest remote-request: SUCCESS (5.166s) [323.859736] [044/134] (703s left) kms_big_fb (yf-tiled-addfb-size-overflow) [323.974108] Starting subtest: yf-tiled-addfb-size-overflow [323.977616] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s) [324.091142] [045/134] (703s left) vgem_basic (busy-fence) [324.141376] Starting subtest: busy-fence [324.143288] Subtest busy-fence: SUCCESS (0.000s) [324.222221] [046/134] (703s left) gem_mmap (bad-object) [324.283662] Subtest bad-object: SKIP (0.000s) [324.353601] [047/134] (703s left) kms_big_fb (x-tiled-64bpp-rotate-180) [324.450266] Starting subtest: x-tiled-64bpp-rotate-180 [326.130413] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.679s) [326.356346] [048/134] (701s left) syncobj_timeline (etime-multi-wait-submitted) [326.424872] Starting subtest: etime-multi-wait-submitted [326.536022] Subtest etime-multi-wait-submitted: SUCCESS (0.110s) [326.635975] [049/134] (701s left) gem_readwrite (read-write) [326.705595] Subtest read-write: SKIP (0.000s) [326.772468] [050/134] (700s left) kms_content_protection (mei-interface) [326.913148] Starting subtest: mei-interface [326.917774] Subtest mei-interface: SKIP (0.001s) [327.074704] [051/134] (700s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [327.189372] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [327.869514] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.681s) [328.096925] [052/134] (699s left) gem_mmap_gtt (isolation) [328.158754] Subtest isolation: SKIP (0.000s) [328.227300] [053/134] (699s left) kms_cursor_edge_walk (64x64-top-edge) [328.338650] Starting subtest: 64x64-top-edge [328.340891] Starting dynamic subtest: pipe-A-eDP-1 [331.771148] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.432s) [331.781619] Starting dynamic subtest: pipe-D-eDP-1 [334.887002] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.114s) [334.889290] Subtest 64x64-top-edge: SUCCESS (6.549s) [335.725725] [054/134] (692s left) syncobj_wait (wait-all-snapshot) [335.794108] Starting subtest: wait-all-snapshot [335.873515] Subtest wait-all-snapshot: SUCCESS (0.082s) [335.975071] [055/134] (691s left) kms_frontbuffer_tracking (fbcpsr-argb161616f-draw-mmap-cpu) [336.075439] Starting subtest: fbcpsr-argb161616f-draw-mmap-cpu [336.079875] Subtest fbcpsr-argb161616f-draw-mmap-cpu: SKIP (0.000s) [336.206694] [056/134] (691s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [336.312192] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt [336.316522] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [336.424264] [057/134] (691s left) gem_create (create-invalid-size) [336.499540] Starting subtest: create-invalid-size [336.501891] Subtest create-invalid-size: SUCCESS (0.000s) [336.717065] [058/134] (691s left) gem_render_copy (y-tiled-ccs-to-yf-tiled) [336.777592] Starting subtest: y-tiled-ccs-to-yf-tiled [336.781957] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s) [336.988355] [059/134] (691s left) kms_frontbuffer_tracking (psr-argb161616f-draw-mmap-wc) [337.089444] Starting subtest: psr-argb161616f-draw-mmap-wc [337.093450] Subtest psr-argb161616f-draw-mmap-wc: SKIP (0.000s) [337.222242] [060/134] (690s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu) [337.333197] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu [337.337218] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [337.471553] [061/134] (690s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner) [337.575625] Starting subtest: switch-modeset-ultra-joiner-big-joiner [337.579745] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s) [337.670775] [062/134] (690s left) sw_sync (sync_merge_same) [337.708916] Starting subtest: sync_merge_same [337.711231] Subtest sync_merge_same: SUCCESS (0.000s) [337.784704] [063/134] (690s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling) [337.878111] Starting subtest: planes-downscale-factor-0-75-unity-scaling [337.880400] Starting dynamic subtest: pipe-A [337.942963] Dynamic subtest pipe-A: SUCCESS (0.067s) [337.954884] Starting dynamic subtest: pipe-B [339.129346] Dynamic subtest pipe-B: SUCCESS (1.185s) [339.139603] Starting dynamic subtest: pipe-C [340.236123] Dynamic subtest pipe-C: SUCCESS (1.105s) [340.246521] Starting dynamic subtest: pipe-D [341.366805] Dynamic subtest pipe-D: SUCCESS (1.130s) [341.369249] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.492s) [342.552718] [064/134] (685s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa [342.611897] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled [342.614330] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.001s) [342.737355] [065/134] (685s left) gem_render_copy (linear-to-vebox-yf-tiled) [342.805754] Starting subtest: linear-to-vebox-yf-tiled [342.810000] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s) [343.015716] [066/134] (685s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible) [343.120388] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible [343.122738] Starting dynamic subtest: A-eDP1 [346.747575] Dynamic subtest A-eDP1: SUCCESS (3.624s) [346.757779] Starting dynamic subtest: B-eDP1 [349.947930] Dynamic subtest B-eDP1: SUCCESS (3.199s) [349.958574] Starting dynamic subtest: C-eDP1 [353.139134] Dynamic subtest C-eDP1: SUCCESS (3.189s) [353.149591] Starting dynamic subtest: D-eDP1 [356.233277] Dynamic subtest D-eDP1: SUCCESS (3.094s) [356.235715] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.116s) [357.061094] [067/134] (671s left) kms_chamelium_color (ctm-limited-range) [357.166106] Subtest ctm-limited-range: SKIP (0.000s) [357.214469] [068/134] (671s left) gem_mmap_wc (write) [357.272327] Subtest write: SKIP (0.000s) [357.342978] [069/134] (671s left) prime_mmap (test_correct) [357.402365] Starting subtest: test_correct [357.404684] Starting dynamic subtest: test_correct-smem [357.431557] Dynamic subtest test_correct-smem: SUCCESS (0.031s) [357.433868] Subtest test_correct: SUCCESS (0.032s) [357.558964] [070/134] (671s left) device_reset (cold-reset-bound) [357.611409] Starting subtest: cold-reset-bound [357.615660] Subtest cold-reset-bound: SKIP (0.000s) [357.707455] [071/134] (670s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt) [357.803661] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt [364.766899] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.965s) [364.955264] [072/134] (663s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu) [365.064018] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu [369.319832] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.259s) [370.483217] [073/134] (658s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs) [370.570092] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs [370.572382] Starting dynamic subtest: pipe-A-eDP-1 [370.595768] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [370.608288] Starting dynamic subtest: pipe-B-eDP-1 [370.629065] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [370.638352] Starting dynamic subtest: pipe-C-eDP-1 [370.659100] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [370.668127] Starting dynamic subtest: pipe-D-eDP-1 [370.689794] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [370.694131] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.006s) [372.864251] [074/134] (655s left) gem_exec_fence (syncobj-channel) [373.313425] Starting subtest: syncobj-channel [374.331501] Subtest syncobj-channel: SUCCESS (1.018s) [374.677096] [075/134] (654s left) gem_exec_reloc (basic-gtt-noreloc) [374.737758] Subtest basic-gtt-noreloc: SKIP (0.000s) [374.812563] [076/134] (654s left) kms_flip (dpms-off-confusion-interruptible) [374.905891] Starting subtest: dpms-off-confusion-interruptible [374.908313] Starting dynamic subtest: A-eDP1 [383.585326] Dynamic subtest A-eDP1: SUCCESS (8.645s) [383.597380] Starting dynamic subtest: B-eDP1 [392.213530] Dynamic subtest B-eDP1: SUCCESS (8.627s) [392.224470] Starting dynamic subtest: C-eDP1 [400.844429] Dynamic subtest C-eDP1: SUCCESS (8.621s) [400.854351] Starting dynamic subtest: D-eDP1 [409.475575] Dynamic subtest D-eDP1: SUCCESS (8.624s) [409.477996] Subtest dpms-off-confusion-interruptible: SUCCESS (34.528s) [410.628698] [077/134] (618s left) kms_vblank (wait-forked-busy) [410.735849] Starting subtest: wait-forked-busy [410.737730] Starting dynamic subtest: pipe-A-eDP-1 [412.637646] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.900s) [412.658489] Starting dynamic subtest: pipe-D-eDP-1 [415.165564] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.526s) [415.167861] Subtest wait-forked-busy: SUCCESS (4.430s) [415.987238] [078/134] (612s left) kms_chamelium_frames (dp-frame-dump) [416.383887] Subtest dp-frame-dump: SKIP (0.000s) [417.181261] [079/134] (611s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs) [417.281322] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs [417.283606] Starting dynamic subtest: pipe-A-eDP-1 [417.343593] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [417.355579] Starting dynamic subtest: pipe-B-eDP-1 [417.412119] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [417.421915] Starting dynamic subtest: pipe-C-eDP-1 [417.475649] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [417.486743] Starting dynamic subtest: pipe-D-eDP-1 [417.542618] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [417.546978] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.009s) [419.581933] [080/134] (609s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt) [419.682047] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt [419.685962] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [419.818851] [081/134] (609s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180) [419.907077] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180 [419.911258] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s) [420.037786] [082/134] (609s left) gen7_exec_parse (cmd-crossing-page) [420.103587] Subtest cmd-crossing-page: SKIP (0.000s) [420.184982] [083/134] (608s left) kms_atomic_transition (modeset-transition-nonblocking) [420.279671] Starting subtest: modeset-transition-nonblocking [420.281547] Starting dynamic subtest: 1x-outputs [431.336712] Dynamic subtest 1x-outputs: SUCCESS (11.056s) [431.339260] Subtest modeset-transition-nonblocking: SUCCESS (11.057s) [432.220849] [084/134] (596s left) kms_draw_crc (draw-method-mmap-cpu) [432.317172] Starting subtest: draw-method-mmap-cpu [432.319068] Starting dynamic subtest: xrgb8888-untiled [432.582658] Dynamic subtest xrgb8888-untiled: SUCCESS (0.267s) [432.592911] Starting dynamic subtest: rgb565-untiled [432.795538] Dynamic subtest rgb565-untiled: SUCCESS (0.210s) [432.805836] Starting dynamic subtest: xrgb2101010-untiled [433.016392] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s) [433.026685] Starting dynamic subtest: xbgr16161616f-untiled [433.249315] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.233s) [433.259012] Starting dynamic subtest: xrgb8888-xtiled [433.382749] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.133s) [433.393364] Starting dynamic subtest: rgb565-xtiled [433.515803] Dynamic subtest rgb565-xtiled: SUCCESS (0.132s) [433.528806] Starting dynamic subtest: xrgb2101010-xtiled [433.649339] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.133s) [433.660700] Starting dynamic subtest: xbgr16161616f-xtiled [433.782621] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.132s) [433.792478] Starting dynamic subtest: xrgb8888-4tiled [433.927541] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s) [433.939887] Starting dynamic subtest: rgb565-4tiled [434.071580] Dynamic subtest rgb565-4tiled: SUCCESS (0.144s) [434.081463] Starting dynamic subtest: xrgb2101010-4tiled [434.204872] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.133s) [434.214604] Starting dynamic subtest: xbgr16161616f-4tiled [434.349776] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.144s) [434.352002] Subtest draw-method-mmap-cpu: SUCCESS (2.035s) [434.493596] [085/134] (594s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc) [434.590174] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc [434.591866] Starting dynamic subtest: pipe-A-eDP-1 [434.740451] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.143s) [434.750942] Starting dynamic subtest: pipe-B-eDP-1 [434.766798] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s) [434.776473] Starting dynamic subtest: pipe-C-eDP-1 [434.793620] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s) [434.803153] Starting dynamic subtest: pipe-D-eDP-1 [434.819131] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.012s) [434.820989] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.179s) [437.072283] [086/134] (592s left) gem_exec_schedule (u-semaphore-user) [437.149176] Starting subtest: u-semaphore-user [437.199876] Subtest u-semaphore-user: SUCCESS (0.057s) [438.429196] [087/134] (590s left) gem_exec_fence (basic-await) [438.613429] Starting subtest: basic-await [438.615957] Starting dynamic subtest: rcs0 [438.691057] Dynamic subtest rcs0: SUCCESS (0.078s) [438.705530] Starting dynamic subtest: bcs0 [438.766531] Dynamic subtest bcs0: SUCCESS (0.074s) [438.779092] Starting dynamic subtest: vcs0 [438.838940] Dynamic subtest vcs0: SUCCESS (0.071s) [438.851874] Starting dynamic subtest: vcs1 [438.912398] Dynamic subtest vcs1: SUCCESS (0.072s) [438.924862] Starting dynamic subtest: vecs0 [438.986355] Dynamic subtest vecs0: SUCCESS (0.072s) [438.999504] Starting dynamic subtest: ccs0 [439.060101] Dynamic subtest ccs0: SUCCESS (0.072s) [439.062724] Subtest basic-await: SUCCESS (0.448s) [440.507079] [088/134] (588s left) kms_rotation_crc (cursor-rotation-180) [440.614056] Starting subtest: cursor-rotation-180 [442.116258] Subtest cursor-rotation-180: SUCCESS (1.500s) [443.318356] [089/134] (586s left) kms_cursor_crc (cursor-onscreen-512x170) [443.612980] Starting subtest: cursor-onscreen-512x170 [443.617420] Subtest cursor-onscreen-512x170: SKIP (0.001s) [443.797904] [090/134] (585s left) kms_big_fb (linear-addfb) [443.914000] Starting subtest: linear-addfb [443.916187] Subtest linear-addfb: SUCCESS (0.000s) [444.044593] [091/134] (585s left) gem_exec_whisper (basic-queues) [444.115631] Starting subtest: basic-queues [450.616776] Subtest basic-queues: SUCCESS (6.500s) [450.827714] [092/134] (578s left) gem_exec_reloc (basic-scanout) [450.905558] Subtest basic-scanout: SKIP (0.000s) [450.999749] [093/134] (578s left) kms_plane_lowres (tiling-4) [451.101489] Starting subtest: tiling-4 [451.103645] Starting dynamic subtest: pipe-A-eDP-1 [451.108062] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [451.400706] Starting dynamic subtest: pipe-B-eDP-1 [451.405298] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [451.415473] Starting dynamic subtest: pipe-C-eDP-1 [451.420044] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [451.430467] Starting dynamic subtest: pipe-D-eDP-1 [451.434656] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [451.438479] Subtest tiling-4: SKIP (0.296s) [452.266243] [094/134] (577s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff) [452.367945] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff [459.415110] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.050s) [459.608547] [095/134] (570s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu) [459.708082] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu [463.404638] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.700s) [464.590333] [096/134] (565s left) gem_ctx_create (basic) [464.661102] Starting subtest: basic [464.663440] Subtest basic: SUCCESS (0.000s) [464.868391] [097/134] (564s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling) [464.968977] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling [464.971099] Starting dynamic subtest: pipe-A-default-mode [466.118500] Dynamic subtest pipe-A-default-mode: SKIP (1.147s) [466.122509] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.148s) [466.286855] [098/134] (563s left) gem_pwrite (basic-exhaustion) [466.350193] Subtest basic-exhaustion: SKIP (0.000s) [466.409744] [099/134] (563s left) kms_atomic_transition (plane-all-transition-nonblocking) [466.508697] Starting subtest: plane-all-transition-nonblocking [466.510900] Starting dynamic subtest: pipe-A-eDP-1 [469.001806] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.494s) [469.316897] Starting dynamic subtest: pipe-B-eDP-1 [472.534127] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.228s) [472.831303] Subtest plane-all-transition-nonblocking: SUCCESS (6.324s) [473.681272] [100/134] (556s left) kms_color_pipeline (plane-lut1d-lut1d) [473.798604] Starting subtest: plane-lut1d-lut1d [473.812474] Starting dynamic subtest: pipe-A-eDP-1 [474.543860] Dynamic subtest pipe-A-eDP-1: FAIL (0.317s) [475.227146] Starting dynamic subtest: pipe-B-eDP-1 [476.087595] Dynamic subtest pipe-B-eDP-1: FAIL (0.335s) [476.655011] Starting dynamic subtest: pipe-C-eDP-1 [477.511564] Dynamic subtest pipe-C-eDP-1: FAIL (0.279s) [477.986016] Starting dynamic subtest: pipe-D-eDP-1 [478.813246] Dynamic subtest pipe-D-eDP-1: FAIL (0.246s) [478.815310] Subtest plane-lut1d-lut1d: FAIL (4.703s) [479.388915] [101/134] (550s left) gem_lmem_swapping (verify-random) [479.432128] Subtest verify-random: SKIP (0.000s) [479.478795] [102/134] (550s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc) [479.580878] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc [479.584695] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [479.721785] [103/134] (550s left) sw_sync (sync_random_merge) [479.762172] Starting subtest: sync_random_merge [479.797932] Subtest sync_random_merge: SUCCESS (0.039s) [479.888874] [104/134] (550s left) syncobj_timeline (invalid-signal-bad-pad) [479.951396] Starting subtest: invalid-signal-bad-pad [479.953493] Subtest invalid-signal-bad-pad: SUCCESS (0.000s) [480.074460] [105/134] (550s left) gem_mmap_gtt (basic) [480.137866] Subtest basic: SKIP (0.000s) [480.204864] [106/134] (549s left) gem_exec_balancer (invalid-balancer) [480.264405] Starting subtest: invalid-balancer [481.148641] Subtest invalid-balancer: SUCCESS (0.882s) [481.477133] [107/134] (548s left) kms_big_fb (y-tiled-8bpp-rotate-90) [481.591476] Starting subtest: y-tiled-8bpp-rotate-90 [481.595888] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s) [481.727229] [108/134] (548s left) gem_render_linear_blits (basic) [481.784192] Starting subtest: basic [481.807059] Subtest basic: SUCCESS (0.023s) [481.911221] [109/134] (548s left) gem_ctx_shared (q-promotion) [481.984696] Starting subtest: Q-promotion [481.987037] Starting dynamic subtest: rcs0 [482.088713] Dynamic subtest rcs0: SUCCESS (0.103s) [482.104666] Starting dynamic subtest: vcs0 [482.178708] Dynamic subtest vcs0: SUCCESS (0.088s) [482.194871] Starting dynamic subtest: vcs1 [482.258730] Dynamic subtest vcs1: SUCCESS (0.079s) [482.276576] Starting dynamic subtest: vecs0 [482.335431] Dynamic subtest vecs0: SUCCESS (0.076s) [482.352776] Starting dynamic subtest: ccs0 [482.421077] Dynamic subtest ccs0: SUCCESS (0.085s) [482.423362] Subtest Q-promotion: SUCCESS (0.437s) [483.512344] [110/134] (546s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite) [483.608011] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite [483.611970] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [483.746206] [111/134] (546s left) syncobj_timeline (single-wait-for-submit-available-submitted) [483.808727] Starting subtest: single-wait-for-submit-available-submitted [483.811033] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s) [483.924086] [112/134] (546s left) gem_flink_basic (bad-open) [483.994384] Starting subtest: bad-open [483.996622] Subtest bad-open: SUCCESS (0.000s) [484.120701] [113/134] (546s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc) [484.216778] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc [484.218917] Starting dynamic subtest: pipe-A-eDP-1 [485.075300] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.851s) [485.085560] Starting dynamic subtest: pipe-B-eDP-1 [486.691056] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.612s) [486.702641] Starting dynamic subtest: pipe-C-eDP-1 [488.258661] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.565s) [488.269646] Starting dynamic subtest: pipe-D-eDP-1 [489.717488] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.459s) [489.719752] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.493s) [490.933431] [114/134] (539s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc) [491.031640] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc [491.035932] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [491.157796] [115/134] (539s left) kms_hdr (bpc-switch-dpms) [491.265777] Starting subtest: bpc-switch-dpms [492.378090] Starting dynamic subtest: pipe-A-eDP-1 [496.888910] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.511s) [496.891342] Subtest bpc-switch-dpms: SUCCESS (5.626s) [497.050237] [116/134] (533s left) kms_chamelium_hpd (hdmi-hpd) [497.451026] Subtest hdmi-hpd: SKIP (0.000s) [498.260920] [117/134] (532s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270) [498.366869] Starting subtest: primary-yf-tiled-reflect-x-270 [498.371115] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s) [498.463525] [118/134] (532s left) prime_vgem (basic-write) [498.548207] Starting subtest: basic-write [498.556293] Subtest basic-write: SKIP (0.006s) [498.704722] [119/134] (532s left) gem_ctx_freq (sysfs) [498.776045] Starting subtest: sysfs [498.778508] Starting dynamic subtest: gt0 [504.256512] Dynamic subtest gt0: SUCCESS (5.480s) [504.269664] Starting dynamic subtest: gt1 [546.393590] Dynamic subtest gt1: SUCCESS (42.134s) [546.396831] Subtest sysfs: SUCCESS (47.618s) [546.574759] [120/134] (484s left) kms_cursor_crc (cursor-onscreen-max-size) [546.883697] Starting subtest: cursor-onscreen-max-size [546.890411] Subtest cursor-onscreen-max-size: SKIP (0.000s) [547.051906] [121/134] (483s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt) [547.154095] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt [547.157963] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [547.294436] [122/134] (483s left) perf (per-context-mode-unprivileged) [547.411885] Starting subtest: per-context-mode-unprivileged [547.415556] Subtest per-context-mode-unprivileged: SKIP (0.000s) [547.484056] [123/134] (483s left) kms_setmode (basic) [547.543234] Starting subtest: basic [547.864514] Starting dynamic subtest: pipe-A-eDP-1 [549.989745] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.121s) [550.343482] Starting dynamic subtest: pipe-B-eDP-1 [552.427007] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.088s) [552.737580] Subtest basic: SUCCESS (5.193s) [553.596709] [124/134] (477s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [553.710977] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [554.390726] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.681s) [554.601475] [125/134] (476s left) kms_atomic_transition (plane-use-after-nonblocking-unbind) [554.709063] Starting subtest: plane-use-after-nonblocking-unbind [554.711300] Starting dynamic subtest: pipe-A-eDP-1 [554.770056] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s) [555.078257] Starting dynamic subtest: pipe-B-eDP-1 [555.881213] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.815s) [556.179880] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.470s) [557.072693] [126/134] (473s left) kms_atomic_interruptible (universal-setplane-primary) [557.188630] Starting subtest: universal-setplane-primary [557.190873] Starting dynamic subtest: pipe-A-eDP-1 [564.581219] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.393s) [564.583602] Subtest universal-setplane-primary: SUCCESS (7.396s) [565.442734] [127/134] (465s left) kms_pm_backlight (fade-with-dpms) [565.559081] Starting subtest: fade-with-dpms [567.847520] Starting dynamic subtest: eDP-1 [570.559160] Dynamic subtest eDP-1: SUCCESS (2.712s) [570.561615] Subtest fade-with-dpms: SUCCESS (5.001s) [571.389343] [128/134] (459s left) perf_pmu (event-wait) [571.432350] Starting subtest: event-wait [571.434581] Starting dynamic subtest: rcs0 [571.438554] Dynamic subtest rcs0: SKIP (0.000s) [571.442502] Subtest event-wait: SKIP (0.001s) [571.578162] [129/134] (459s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt) [571.679034] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt [571.682960] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [571.819729] [130/134] (459s left) gem_exec_whisper (basic-contexts-all) [571.880729] Starting subtest: basic-contexts-all [581.371107] Subtest basic-contexts-all: SUCCESS (9.486s) [581.578283] [131/134] (449s left) gem_spin_batch (spin-each) [581.641935] Starting subtest: spin-each [585.010939] Subtest spin-each: SUCCESS (3.363s) [585.433981] [132/134] (445s left) kms_universal_plane (disable-primary-vs-flip) [585.538844] Starting subtest: disable-primary-vs-flip [585.540824] Starting dynamic subtest: pipe-A-eDP-1 [587.084889] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.546s) [587.098090] Starting dynamic subtest: pipe-B-eDP-1 [589.336508] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.247s) [589.348061] Starting dynamic subtest: pipe-C-eDP-1 [591.584061] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.246s) [591.595682] Starting dynamic subtest: pipe-D-eDP-1 [593.754552] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.166s) [593.756454] Subtest disable-primary-vs-flip: SUCCESS (8.216s) [594.571445] [133/134] (436s left) gem_exec_schedule (preemptive-hang) [594.757840] Starting subtest: preemptive-hang [594.760640] Starting dynamic subtest: rcs0 [603.531065] Dynamic subtest rcs0: SUCCESS (8.772s) [603.543860] Starting dynamic subtest: bcs0 [612.487443] Dynamic subtest bcs0: SUCCESS (8.953s) [612.500474] Starting dynamic subtest: vcs0 [621.511399] Dynamic subtest vcs0: SUCCESS (9.018s) [621.527589] Starting dynamic subtest: vcs1 [630.473848] Dynamic subtest vcs1: SUCCESS (8.961s) [630.484704] Starting dynamic subtest: vecs0 [639.551651] Dynamic subtest vecs0: SUCCESS (9.084s) [639.562297] Starting dynamic subtest: ccs0 [648.520236] Dynamic subtest ccs0: SUCCESS (8.962s) [648.522689] Subtest preemptive-hang: SUCCESS (53.760s) [648.803588] [134/134] (382s left) syncobj_wait (invalid-signal-bad-pad) [648.863488] Starting subtest: invalid-signal-bad-pad [648.865892] Subtest invalid-signal-bad-pad: SUCCESS (0.000s) [649.003534] Closing watchdogs results: parsing output: 0/ for test: kms_addfb_basic results: parsing output: 1/ for test: kms_plane_scaling results: parsing output: 2/ for test: i915_drm_fdinfo results: parsing output: 3/ for test: gem_userptr_blits results: parsing output: 4/ for test: kms_psr results: parsing output: 5/ for test: kms_frontbuffer_tracking results: parsing output: 6/ for test: kms_cursor_legacy results: parsing output: 7/ for test: kms_psr results: parsing output: 8/ for test: i915_pm_rc6_residency results: parsing output: 9/ for test: kms_frontbuffer_tracking results: parsing output: 10/ for test: kms_feature_discovery results: parsing output: 11/ for test: syncobj_wait results: parsing output: 12/ for test: kms_flip results: parsing output: 13/ for test: kms_psr_stress_test results: parsing output: 14/ for test: i915_drm_fdinfo results: parsing output: 15/ for test: gem_exec_params results: parsing output: 16/ for test: syncobj_wait results: parsing output: 17/ for test: kms_frontbuffer_tracking results: parsing output: 18/ for test: kms_pm_rpm results: parsing output: 19/ for test: i915_suspend results: parsing output: 20/ for test: prime_vgem results: parsing output: 21/ for test: api_intel_allocator results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: sriov_basic results: parsing output: 24/ for test: gem_eio results: parsing output: 25/ for test: kms_vrr results: parsing output: 26/ for test: api_intel_bb results: parsing output: 27/ for test: kms_cursor_legacy results: parsing output: 28/ for test: kms_rotation_crc results: parsing output: 29/ for test: kms_prime results: parsing output: 30/ for test: gem_ctx_persistence results: parsing output: 31/ for test: gem_create results: parsing output: 32/ for test: kms_frontbuffer_tracking results: parsing output: 33/ for test: kms_psr results: parsing output: 34/ for test: gem_sync results: parsing output: 35/ for test: prime_mmap results: parsing output: 36/ for test: kms_pipe_crc_basic results: parsing output: 37/ for test: perf results: parsing output: 38/ for test: kms_psr2_sf results: parsing output: 39/ for test: kms_psr2_sf results: parsing output: 40/ for test: kms_psr results: parsing output: 41/ for test: sysfs_timeslice_duration results: parsing output: 42/ for test: gem_barrier_race results: parsing output: 43/ for test: kms_big_fb results: parsing output: 44/ for test: vgem_basic results: parsing output: 45/ for test: gem_mmap results: parsing output: 46/ for test: kms_big_fb results: parsing output: 47/ for test: syncobj_timeline results: parsing output: 48/ for test: gem_readwrite results: parsing output: 49/ for test: kms_content_protection results: parsing output: 50/ for test: kms_big_fb results: parsing output: 51/ for test: gem_mmap_gtt results: parsing output: 52/ for test: kms_cursor_edge_walk results: parsing output: 53/ for test: syncobj_wait results: parsing output: 54/ for test: kms_frontbuffer_tracking results: parsing output: 55/ for test: kms_frontbuffer_tracking results: parsing output: 56/ for test: gem_create results: parsing output: 57/ for test: gem_render_copy results: parsing output: 58/ for test: kms_frontbuffer_tracking results: parsing output: 59/ for test: kms_frontbuffer_tracking results: parsing output: 60/ for test: kms_joiner results: parsing output: 61/ for test: sw_sync results: parsing output: 62/ for test: kms_plane_scaling results: parsing output: 63/ for test: syncobj_timeline results: parsing output: 64/ for test: gem_render_copy results: parsing output: 65/ for test: kms_flip results: parsing output: 66/ for test: kms_chamelium_color results: parsing output: 67/ for test: gem_mmap_wc results: parsing output: 68/ for test: prime_mmap results: parsing output: 69/ for test: device_reset results: parsing output: 70/ for test: kms_frontbuffer_tracking results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: kms_ccs results: parsing output: 73/ for test: gem_exec_fence results: parsing output: 74/ for test: gem_exec_reloc results: parsing output: 75/ for test: kms_flip results: parsing output: 76/ for test: kms_vblank results: parsing output: 77/ for test: kms_chamelium_frames results: parsing output: 78/ for test: kms_ccs results: parsing output: 79/ for test: kms_frontbuffer_tracking results: parsing output: 80/ for test: kms_big_fb results: parsing output: 81/ for test: gen7_exec_parse results: parsing output: 82/ for test: kms_atomic_transition results: parsing output: 83/ for test: kms_draw_crc results: parsing output: 84/ for test: kms_ccs results: parsing output: 85/ for test: gem_exec_schedule results: parsing output: 86/ for test: gem_exec_fence results: parsing output: 87/ for test: kms_rotation_crc results: parsing output: 88/ for test: kms_cursor_crc results: parsing output: 89/ for test: kms_big_fb results: parsing output: 90/ for test: gem_exec_whisper results: parsing output: 91/ for test: gem_exec_reloc results: parsing output: 92/ for test: kms_plane_lowres results: parsing output: 93/ for test: kms_frontbuffer_tracking results: parsing output: 94/ for test: kms_frontbuffer_tracking results: parsing output: 95/ for test: gem_ctx_create results: parsing output: 96/ for test: kms_flip_scaled_crc results: parsing output: 97/ for test: gem_pwrite results: parsing output: 98/ for test: kms_atomic_transition results: parsing output: 99/ for test: kms_color_pipeline results: parsing output: 100/ for test: gem_lmem_swapping results: parsing output: 101/ for test: kms_frontbuffer_tracking results: parsing output: 102/ for test: sw_sync results: parsing output: 103/ for test: syncobj_timeline results: parsing output: 104/ for test: gem_mmap_gtt results: parsing output: 105/ for test: gem_exec_balancer results: parsing output: 106/ for test: kms_big_fb results: parsing output: 107/ for test: gem_render_linear_blits results: parsing output: 108/ for test: gem_ctx_shared results: parsing output: 109/ for test: kms_frontbuffer_tracking results: parsing output: 110/ for test: syncobj_timeline results: parsing output: 111/ for test: gem_flink_basic results: parsing output: 112/ for test: kms_ccs results: parsing output: 113/ for test: kms_frontbuffer_tracking results: parsing output: 114/ for test: kms_hdr results: parsing output: 115/ for test: kms_chamelium_hpd results: parsing output: 116/ for test: kms_rotation_crc results: parsing output: 117/ for test: prime_vgem results: parsing output: 118/ for test: gem_ctx_freq results: parsing output: 119/ for test: kms_cursor_crc results: parsing output: 120/ for test: kms_frontbuffer_tracking results: parsing output: 121/ for test: perf results: parsing output: 122/ for test: kms_setmode results: parsing output: 123/ for test: kms_big_fb results: parsing output: 124/ for test: kms_atomic_transition results: parsing output: 125/ for test: kms_atomic_interruptible results: parsing output: 126/ for test: kms_pm_backlight results: parsing output: 127/ for test: perf_pmu results: parsing output: 128/ for test: kms_frontbuffer_tracking results: parsing output: 129/ for test: gem_exec_whisper results: parsing output: 130/ for test: gem_spin_batch results: parsing output: 131/ for test: kms_universal_plane results: parsing output: 132/ for test: gem_exec_schedule results: parsing output: 133/ for test: syncobj_wait Done.