[57.796739] Initializing watchdogs [57.796784] /dev/watchdog0 [57.810726] [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.815320] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.817535] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.820996] [001/134] (960s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [57.952687] Starting subtest: addfb25-y-tiled-small-legacy [57.957239] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [58.078840] [002/134] (960s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers) [58.176348] Starting subtest: plane-downscale-factor-0-75-with-modifiers [58.178664] Starting dynamic subtest: pipe-A [58.562960] Dynamic subtest pipe-A: SUCCESS (0.387s) [58.569933] Starting dynamic subtest: pipe-B [60.062323] Dynamic subtest pipe-B: SUCCESS (1.500s) [60.069940] Starting dynamic subtest: pipe-C [61.464846] Dynamic subtest pipe-C: SUCCESS (1.403s) [61.474717] Starting dynamic subtest: pipe-D [62.918074] Dynamic subtest pipe-D: SUCCESS (1.453s) [62.920470] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.745s) [64.073750] [003/134] (954s left) i915_drm_fdinfo (virtual-idle) [64.116512] Starting subtest: virtual-idle [67.193544] Subtest virtual-idle: SUCCESS (3.076s) [67.306844] [004/134] (951s left) gem_userptr_blits (huge-split) [67.529765] Starting subtest: huge-split [67.546232] Subtest huge-split: SUCCESS (0.017s) [67.792679] [005/134] (950s left) kms_psr (fbc-pr-no-drrs) [67.909866] Starting subtest: fbc-pr-no-drrs [67.914434] Subtest fbc-pr-no-drrs: SKIP (0.000s) [68.002322] [006/134] (950s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu) [68.114976] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu [75.234060] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.123s) [75.377684] [007/134] (943s left) kms_cursor_legacy (cursora-vs-flipa-legacy) [75.511604] Starting subtest: cursorA-vs-flipA-legacy [86.672453] Subtest cursorA-vs-flipA-legacy: SUCCESS (11.163s) [87.502150] [008/134] (931s left) kms_psr (psr2-primary-page-flip) [87.610274] Starting subtest: psr2-primary-page-flip [87.612633] Starting dynamic subtest: eDP-1 [89.369847] Dynamic subtest eDP-1: SUCCESS (1.761s) [89.372175] Subtest psr2-primary-page-flip: SUCCESS (1.762s) [90.272127] [009/134] (928s left) i915_pm_rc6_residency (rc6-accuracy) [90.339139] Starting subtest: rc6-accuracy [90.341674] Starting dynamic subtest: gt0 [93.509980] Dynamic subtest gt0: SUCCESS (3.169s) [93.518604] Starting dynamic subtest: gt1 [96.731148] Dynamic subtest gt1: SUCCESS (3.169s) [96.733120] Subtest rc6-accuracy: SUCCESS (6.340s) [96.772777] [010/134] (921s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt) [96.872445] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt [104.249039] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.380s) [104.416215] [011/134] (914s left) kms_feature_discovery (psr2) [104.522769] Starting subtest: psr2 [104.525115] Subtest psr2: SUCCESS (0.000s) [104.614649] [012/134] (914s left) syncobj_wait (single-wait-all-for-submit-submitted) [104.677138] Starting subtest: single-wait-all-for-submit-submitted [104.786208] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.108s) [104.887184] [013/134] (913s left) kms_flip (2x-wf_vblank-ts-check-interruptible) [104.979705] Starting subtest: 2x-wf_vblank-ts-check-interruptible [104.990672] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.010s) [105.131638] [014/134] (913s left) kms_psr_stress_test (flip-primary-invalidate-overlay) [105.221409] Starting subtest: flip-primary-invalidate-overlay [116.794900] Subtest flip-primary-invalidate-overlay: SUCCESS (11.576s) [116.997250] [015/134] (901s left) i915_drm_fdinfo (busy-idle) [117.045637] Starting subtest: busy-idle [117.047522] Starting dynamic subtest: rcs0 [117.066126] Dynamic subtest rcs0: SKIP (0.019s) [117.075576] Starting dynamic subtest: bcs0 [117.079368] Dynamic subtest bcs0: SKIP (0.009s) [117.088396] Starting dynamic subtest: vcs0 [117.092546] Dynamic subtest vcs0: SKIP (0.000s) [117.101709] Starting dynamic subtest: vcs1 [117.105217] Dynamic subtest vcs1: SKIP (0.000s) [117.112086] Starting dynamic subtest: vecs0 [117.115637] Dynamic subtest vecs0: SKIP (0.000s) [117.122503] Starting dynamic subtest: ccs0 [117.126159] Dynamic subtest ccs0: SKIP (0.000s) [117.130510] Subtest busy-idle: SKIP (0.031s) [117.197357] [016/134] (901s left) gem_exec_params (invalid-bsd2-flag-on-vebox) [117.272180] Starting subtest: invalid-bsd2-flag-on-vebox [117.274127] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s) [117.389520] [017/134] (901s left) syncobj_wait (single-wait-all-for-submit-signaled) [117.445066] Starting subtest: single-wait-all-for-submit-signaled [117.447060] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s) [117.578875] [018/134] (901s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt) [117.679128] Starting subtest: fbcpsr-rgb101010-draw-blt [124.457223] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (6.778s) [124.625985] [019/134] (894s left) kms_pm_rpm (modeset-lpsp) [126.166885] Starting subtest: modeset-lpsp [127.627816] Subtest modeset-lpsp: SUCCESS (1.462s) [127.747031] [020/134] (891s left) i915_suspend (sysfs-reader) [127.818193] Starting subtest: sysfs-reader [146.165640] Subtest sysfs-reader: SUCCESS (4.023s) [146.241218] [021/134] (872s left) prime_vgem (sync) [146.386151] Starting subtest: sync [146.388206] Starting dynamic subtest: rcs0 [146.455589] Dynamic subtest rcs0: SUCCESS (0.069s) [146.463939] Starting dynamic subtest: bcs0 [146.533482] Dynamic subtest bcs0: SUCCESS (0.078s) [146.542014] Starting dynamic subtest: vcs0 [146.580619] Dynamic subtest vcs0: SUCCESS (0.047s) [146.588790] Starting dynamic subtest: vcs1 [146.623341] Dynamic subtest vcs1: SUCCESS (0.042s) [146.632163] Starting dynamic subtest: vecs0 [146.670243] Dynamic subtest vecs0: SUCCESS (0.046s) [146.678632] Starting dynamic subtest: ccs0 [146.716642] Dynamic subtest ccs0: SUCCESS (0.046s) [146.718639] Subtest sync: SUCCESS (0.331s) [146.874852] [FACT prime_vgem (sync)] new: kernel.kmod_is_loaded.vgem: true [146.877515] [022/134] (872s left) api_intel_allocator (two-level-inception) [146.927368] Starting subtest: two-level-inception [152.369311] Subtest two-level-inception: SUCCESS (5.399s) [152.472800] [023/134] (866s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move) [152.589490] Starting subtest: psr-2p-primscrn-cur-indfb-move [152.594138] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [152.735779] [024/134] (866s left) sriov_basic (bind-unbind-vf) [152.795120] Starting subtest: bind-unbind-vf [152.797574] Starting dynamic subtest: vf-1 [152.879519] Dynamic subtest vf-1: FAIL (0.030s) [152.889769] Starting dynamic subtest: vf-2 [152.973518] Dynamic subtest vf-2: FAIL (0.005s) [152.983858] Starting dynamic subtest: vf-3 [153.066996] Dynamic subtest vf-3: FAIL (0.004s) [153.080609] Starting dynamic subtest: vf-4 [153.159889] Dynamic subtest vf-4: FAIL (0.004s) [153.170443] Starting dynamic subtest: vf-5 [153.253294] Dynamic subtest vf-5: FAIL (0.004s) [153.264676] Starting dynamic subtest: vf-6 [153.372931] Dynamic subtest vf-6: FAIL (0.004s) [153.383701] Starting dynamic subtest: vf-7 [153.467369] Dynamic subtest vf-7: FAIL (0.004s) [153.479999] Starting dynamic subtest: vf-random [153.560663] Dynamic subtest vf-random: FAIL (0.004s) [153.571862] Starting dynamic subtest: vf-last [153.661880] Dynamic subtest vf-last: FAIL (0.601s) [153.663603] Subtest bind-unbind-vf: FAIL (0.665s) [153.705842] [025/134] (865s left) gem_eio (hibernate) [153.999848] Starting subtest: hibernate [168.909807] Subtest hibernate: SUCCESS (14.917s) [176.105608] [026/134] (850s left) kms_vrr (seamless-rr-switch-virtual) [176.233921] Starting subtest: seamless-rr-switch-virtual [176.240603] Subtest seamless-rr-switch-virtual: SKIP (0.000s) [176.333590] [027/134] (850s left) api_intel_bb (render) [176.393601] Starting subtest: render [176.395822] Starting dynamic subtest: render-none-512 [176.495564] Dynamic subtest render-none-512: SUCCESS (0.102s) [176.508098] Starting dynamic subtest: render-none-1024 [176.875558] Dynamic subtest render-none-1024: SUCCESS (0.378s) [176.887173] Starting dynamic subtest: render-x-512 [176.960242] Dynamic subtest render-x-512: SUCCESS (0.085s) [176.972367] Starting dynamic subtest: render-x-1024 [177.299880] Dynamic subtest render-x-1024: SUCCESS (0.340s) [177.312418] Starting dynamic subtest: render-y-512 [177.390879] Dynamic subtest render-y-512: SUCCESS (0.090s) [177.402767] Starting dynamic subtest: render-y-1024 [177.733754] Dynamic subtest render-y-1024: SUCCESS (0.341s) [177.736458] Subtest render: SUCCESS (1.341s) [177.890518] [028/134] (848s left) kms_cursor_legacy (torture-bo) [178.019191] Starting subtest: torture-bo [178.021405] Starting dynamic subtest: pipe-A [183.993169] Dynamic subtest pipe-A: SUCCESS (5.921s) [184.006034] Starting dynamic subtest: pipe-B [190.570902] Dynamic subtest pipe-B: SUCCESS (6.629s) [190.583768] Starting dynamic subtest: pipe-C [198.201923] Dynamic subtest pipe-C: SUCCESS (7.632s) [198.216200] Starting dynamic subtest: pipe-D [204.868854] Dynamic subtest pipe-D: SUCCESS (6.667s) [204.881251] Starting dynamic subtest: all-pipes [211.259527] Dynamic subtest all-pipes: SUCCESS (6.380s) [211.262125] Subtest torture-bo: SUCCESS (33.237s) [211.428123] [029/134] (815s left) kms_rotation_crc (sprite-rotation-270) [211.531732] Starting subtest: sprite-rotation-270 [211.535838] Subtest sprite-rotation-270: SKIP (0.001s) [211.629034] [030/134] (814s left) kms_prime (basic-modeset-hybrid) [211.709741] Subtest basic-modeset-hybrid: SKIP (0.000s) [211.827257] [031/134] (814s left) gem_ctx_persistence (many-contexts) [211.890109] Starting subtest: many-contexts [249.619841] Subtest many-contexts: SUCCESS (37.739s) [249.723051] [032/134] (776s left) gem_create (busy-create) [249.783903] Starting subtest: busy-create [249.786323] Starting dynamic subtest: smem0 [283.195356] Dynamic subtest smem0: SUCCESS (33.418s) [283.198347] Subtest busy-create: SUCCESS (33.420s) [283.408296] [033/134] (743s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [283.514468] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [283.518654] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [283.645841] [034/134] (743s left) kms_psr (fbc-psr-cursor-blt) [283.744314] Starting subtest: fbc-psr-cursor-blt [283.746579] Starting dynamic subtest: eDP-1 [283.750638] Dynamic subtest eDP-1: SKIP (0.000s) [283.754757] Subtest fbc-psr-cursor-blt: SKIP (0.001s) [283.840870] [035/134] (742s left) gem_sync (basic-store-each) [283.912931] Starting subtest: basic-store-each [286.392874] Subtest basic-store-each: SUCCESS (2.492s) [286.606659] [036/134] (740s left) prime_mmap (test_userptr) [286.663635] Starting subtest: test_userptr [286.666030] Starting dynamic subtest: test_userptr-smem [286.667993] Dynamic subtest test_userptr-smem: SUCCESS (0.000s) [286.669984] Subtest test_userptr: SUCCESS (0.001s) [286.808680] [037/134] (740s left) kms_pipe_crc_basic (nonblocking-crc) [286.917448] Starting subtest: nonblocking-crc [286.919385] Starting dynamic subtest: pipe-A-eDP-1 [287.668344] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.751s) [287.678674] Starting dynamic subtest: pipe-B-eDP-1 [289.046907] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.378s) [289.060438] Starting dynamic subtest: pipe-C-eDP-1 [290.418080] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.369s) [290.430682] Starting dynamic subtest: pipe-D-eDP-1 [291.742182] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.322s) [291.744485] Subtest nonblocking-crc: SUCCESS (4.826s) [292.566478] [038/134] (734s left) perf (unprivileged-single-ctx-counters) [292.724915] Starting subtest: unprivileged-single-ctx-counters [292.729410] Subtest unprivileged-single-ctx-counters: SKIP (0.000s) [292.765836] [039/134] (734s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area) [297.714665] Starting subtest: psr2-overlay-primary-update-sf-dmg-area [297.717006] Starting dynamic subtest: pipe-A-eDP-1 [304.348432] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.632s) [304.359275] Starting dynamic subtest: pipe-B-eDP-1 [311.018312] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.661s) [311.021111] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (13.299s) [311.914833] [040/134] (715s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf) [316.994104] Starting subtest: pr-overlay-plane-move-continuous-sf [316.998805] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.002s) [317.850249] [041/134] (709s left) kms_psr (fbc-psr-sprite-blt) [317.949803] Starting subtest: fbc-psr-sprite-blt [317.952136] Starting dynamic subtest: eDP-1 [317.956580] Dynamic subtest eDP-1: SKIP (0.000s) [317.960944] Subtest fbc-psr-sprite-blt: SKIP (0.001s) [318.049480] [042/134] (709s left) sysfs_timeslice_duration (invalid) [318.108141] Starting subtest: invalid [318.110382] Starting dynamic subtest: vecs0 [318.112551] Dynamic subtest vecs0: SUCCESS (0.000s) [318.122493] Starting dynamic subtest: ccs0 [318.124687] Dynamic subtest ccs0: SUCCESS (0.000s) [318.134630] Starting dynamic subtest: vcs0 [318.136581] Dynamic subtest vcs0: SUCCESS (0.000s) [318.145820] Starting dynamic subtest: bcs0 [318.147693] Dynamic subtest bcs0: SUCCESS (0.000s) [318.156721] Starting dynamic subtest: rcs0 [318.158586] Dynamic subtest rcs0: SUCCESS (0.000s) [318.167961] Starting dynamic subtest: vcs1 [318.170143] Dynamic subtest vcs1: SUCCESS (0.000s) [318.172298] Subtest invalid: SUCCESS (0.005s) [318.241287] [043/134] (708s left) gem_barrier_race (remote-request) [318.301979] Starting subtest: remote-request [318.304259] Starting dynamic subtest: rcs0 [323.465745] Dynamic subtest rcs0: SUCCESS (5.161s) [323.468045] Subtest remote-request: SUCCESS (5.162s) [323.623690] [044/134] (703s left) kms_big_fb (yf-tiled-addfb-size-overflow) [323.734469] Starting subtest: yf-tiled-addfb-size-overflow [323.738141] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s) [323.855684] [045/134] (703s left) vgem_basic (busy-fence) [323.893338] Starting subtest: busy-fence [323.895115] Subtest busy-fence: SUCCESS (0.000s) [323.978737] [046/134] (703s left) gem_mmap (bad-object) [324.040050] Subtest bad-object: SKIP (0.000s) [324.108895] [047/134] (703s left) kms_big_fb (x-tiled-64bpp-rotate-180) [324.215304] Starting subtest: x-tiled-64bpp-rotate-180 [325.861464] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.645s) [326.034371] [048/134] (701s left) syncobj_timeline (etime-multi-wait-submitted) [326.098479] Starting subtest: etime-multi-wait-submitted [326.202160] Subtest etime-multi-wait-submitted: SUCCESS (0.103s) [326.306862] [049/134] (701s left) gem_readwrite (read-write) [326.372381] Subtest read-write: SKIP (0.000s) [326.441946] [050/134] (700s left) kms_content_protection (mei-interface) [326.583630] Starting subtest: mei-interface [326.588354] Subtest mei-interface: SKIP (0.001s) [326.750442] [051/134] (700s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [326.860572] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [327.529519] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.670s) [327.738815] [052/134] (699s left) gem_mmap_gtt (isolation) [327.806479] Subtest isolation: SKIP (0.000s) [327.868332] [053/134] (699s left) kms_cursor_edge_walk (64x64-top-edge) [327.969518] Starting subtest: 64x64-top-edge [327.971819] Starting dynamic subtest: pipe-A-eDP-1 [331.390043] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.417s) [331.400712] Starting dynamic subtest: pipe-D-eDP-1 [334.529448] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.138s) [334.531724] Subtest 64x64-top-edge: SUCCESS (6.558s) [335.336729] [054/134] (692s left) syncobj_wait (wait-all-snapshot) [335.397947] Starting subtest: wait-all-snapshot [335.478030] Subtest wait-all-snapshot: SUCCESS (0.081s) [335.579114] [055/134] (692s left) kms_frontbuffer_tracking (fbcpsr-argb161616f-draw-mmap-cpu) [335.687017] Starting subtest: fbcpsr-argb161616f-draw-mmap-cpu [335.691034] Subtest fbcpsr-argb161616f-draw-mmap-cpu: SKIP (0.000s) [335.829144] [056/134] (691s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [335.921439] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt [335.926383] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [336.036922] [057/134] (691s left) gem_create (create-invalid-size) [336.100050] Starting subtest: create-invalid-size [336.101997] Subtest create-invalid-size: SUCCESS (0.000s) [336.308431] [058/134] (691s left) gem_render_copy (y-tiled-ccs-to-yf-tiled) [336.383045] Starting subtest: y-tiled-ccs-to-yf-tiled [336.387287] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s) [336.591450] [059/134] (691s left) kms_frontbuffer_tracking (psr-argb161616f-draw-mmap-wc) [336.685169] Starting subtest: psr-argb161616f-draw-mmap-wc [336.689533] Subtest psr-argb161616f-draw-mmap-wc: SKIP (0.000s) [336.814675] [060/134] (690s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu) [336.919936] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu [336.923875] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [337.070997] [061/134] (690s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner) [337.180332] Starting subtest: switch-modeset-ultra-joiner-big-joiner [337.184511] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s) [337.270954] [062/134] (690s left) sw_sync (sync_merge_same) [337.309979] Starting subtest: sync_merge_same [337.312148] Subtest sync_merge_same: SUCCESS (0.000s) [337.382174] [063/134] (690s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling) [337.494694] Starting subtest: planes-downscale-factor-0-75-unity-scaling [337.496874] Starting dynamic subtest: pipe-A [337.556578] Dynamic subtest pipe-A: SUCCESS (0.065s) [337.574524] Starting dynamic subtest: pipe-B [338.737417] Dynamic subtest pipe-B: SUCCESS (1.177s) [338.748589] Starting dynamic subtest: pipe-C [339.841607] Dynamic subtest pipe-C: SUCCESS (1.102s) [339.852143] Starting dynamic subtest: pipe-D [340.991778] Dynamic subtest pipe-D: SUCCESS (1.149s) [340.993982] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.499s) [342.177087] [064/134] (685s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa [342.238673] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled [342.240612] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s) [342.344767] [065/134] (685s left) gem_render_copy (linear-to-vebox-yf-tiled) [342.409886] Starting subtest: linear-to-vebox-yf-tiled [342.414278] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s) [342.614759] [066/134] (685s left) kms_flip (flip-vs-dpms-off-vs-modeset-interruptible) [342.720339] Starting subtest: flip-vs-dpms-off-vs-modeset-interruptible [342.722655] Starting dynamic subtest: A-eDP1 [346.271313] Dynamic subtest A-eDP1: SUCCESS (3.546s) [346.281502] Starting dynamic subtest: B-eDP1 [349.467019] Dynamic subtest B-eDP1: SUCCESS (3.193s) [349.478826] Starting dynamic subtest: C-eDP1 [352.579469] Dynamic subtest C-eDP1: SUCCESS (3.110s) [352.599283] Starting dynamic subtest: D-eDP1 [355.664376] Dynamic subtest D-eDP1: SUCCESS (3.085s) [355.666781] Subtest flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (12.943s) [356.499447] [067/134] (671s left) kms_chamelium_color (ctm-limited-range) [356.611707] Subtest ctm-limited-range: SKIP (0.000s) [356.659752] [068/134] (671s left) gem_mmap_wc (write) [356.717031] Subtest write: SKIP (0.000s) [356.778960] [069/134] (671s left) prime_mmap (test_correct) [356.833839] Starting subtest: test_correct [356.835985] Starting dynamic subtest: test_correct-smem [356.863659] Dynamic subtest test_correct-smem: SUCCESS (0.032s) [356.866167] Subtest test_correct: SUCCESS (0.033s) [356.997958] [070/134] (671s left) device_reset (cold-reset-bound) [357.054918] Starting subtest: cold-reset-bound [357.059121] Subtest cold-reset-bound: SKIP (0.000s) [357.150231] [071/134] (671s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt) [357.250571] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt [364.250554] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (7.000s) [364.459504] [072/134] (663s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu) [364.573140] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu [368.895420] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.325s) [370.120376] [073/134] (658s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs) [370.226910] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs [370.229172] Starting dynamic subtest: pipe-A-eDP-1 [370.264246] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [370.275698] Starting dynamic subtest: pipe-B-eDP-1 [370.296645] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [370.306133] Starting dynamic subtest: pipe-C-eDP-1 [370.327578] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [370.336932] Starting dynamic subtest: pipe-D-eDP-1 [370.358595] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [370.362604] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.006s) [372.497943] [074/134] (655s left) gem_exec_fence (syncobj-channel) [372.961151] Starting subtest: syncobj-channel [373.984670] Subtest syncobj-channel: SUCCESS (1.020s) [374.354119] [075/134] (654s left) gem_exec_reloc (basic-gtt-noreloc) [374.426072] Subtest basic-gtt-noreloc: SKIP (0.000s) [374.513976] [076/134] (653s left) kms_flip (dpms-off-confusion-interruptible) [374.616122] Starting subtest: dpms-off-confusion-interruptible [374.618461] Starting dynamic subtest: A-eDP1 [383.319579] Dynamic subtest A-eDP1: SUCCESS (8.666s) [383.330660] Starting dynamic subtest: B-eDP1 [391.948055] Dynamic subtest B-eDP1: SUCCESS (8.628s) [391.960259] Starting dynamic subtest: C-eDP1 [400.597240] Dynamic subtest C-eDP1: SUCCESS (8.635s) [400.609705] Starting dynamic subtest: D-eDP1 [409.219736] Dynamic subtest D-eDP1: SUCCESS (8.623s) [409.222120] Subtest dpms-off-confusion-interruptible: SUCCESS (34.564s) [410.377667] [077/134] (618s left) kms_vblank (wait-forked-busy) [410.474684] Starting subtest: wait-forked-busy [410.476827] Starting dynamic subtest: pipe-A-eDP-1 [412.354810] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.881s) [412.369717] Starting dynamic subtest: pipe-D-eDP-1 [414.905739] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.548s) [414.908081] Subtest wait-forked-busy: SUCCESS (4.434s) [415.740801] [078/134] (612s left) kms_chamelium_frames (dp-frame-dump) [416.136103] Subtest dp-frame-dump: SKIP (0.000s) [416.931410] [079/134] (611s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs) [417.026813] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs [417.029001] Starting dynamic subtest: pipe-A-eDP-1 [417.086265] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [417.095990] Starting dynamic subtest: pipe-B-eDP-1 [417.152161] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [417.163427] Starting dynamic subtest: pipe-C-eDP-1 [417.220301] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [417.231103] Starting dynamic subtest: pipe-D-eDP-1 [417.288265] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [417.292594] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.009s) [419.347589] [080/134] (609s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt) [419.460367] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt [419.464822] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [419.593629] [081/134] (609s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180) [419.703838] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180 [419.707871] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s) [419.830707] [082/134] (608s left) gen7_exec_parse (cmd-crossing-page) [419.896390] Subtest cmd-crossing-page: SKIP (0.000s) [419.984575] [083/134] (608s left) kms_atomic_transition (modeset-transition-nonblocking) [420.085328] Starting subtest: modeset-transition-nonblocking [420.087557] Starting dynamic subtest: 1x-outputs [430.901439] Dynamic subtest 1x-outputs: SUCCESS (10.817s) [430.904004] Subtest modeset-transition-nonblocking: SUCCESS (10.818s) [431.774893] [084/134] (597s left) kms_draw_crc (draw-method-mmap-cpu) [431.886717] Starting subtest: draw-method-mmap-cpu [431.888593] Starting dynamic subtest: xrgb8888-untiled [432.131266] Dynamic subtest xrgb8888-untiled: SUCCESS (0.244s) [432.141895] Starting dynamic subtest: rgb565-untiled [432.351788] Dynamic subtest rgb565-untiled: SUCCESS (0.221s) [432.362063] Starting dynamic subtest: xrgb2101010-untiled [432.573968] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s) [432.584308] Starting dynamic subtest: xbgr16161616f-untiled [432.806682] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.232s) [432.816701] Starting dynamic subtest: xrgb8888-xtiled [432.929135] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s) [432.940181] Starting dynamic subtest: rgb565-xtiled [433.062143] Dynamic subtest rgb565-xtiled: SUCCESS (0.132s) [433.074446] Starting dynamic subtest: xrgb2101010-xtiled [433.184406] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.120s) [433.194659] Starting dynamic subtest: xbgr16161616f-xtiled [433.317584] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s) [433.327649] Starting dynamic subtest: xrgb8888-4tiled [433.462214] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s) [433.472210] Starting dynamic subtest: rgb565-4tiled [433.606658] Dynamic subtest rgb565-4tiled: SUCCESS (0.144s) [433.617005] Starting dynamic subtest: xrgb2101010-4tiled [433.740319] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.133s) [433.752106] Starting dynamic subtest: xbgr16161616f-4tiled [433.896162] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.153s) [433.903607] Subtest draw-method-mmap-cpu: SUCCESS (2.012s) [434.040022] [085/134] (594s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc) [434.122895] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc [434.124721] Starting dynamic subtest: pipe-A-eDP-1 [434.274968] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.143s) [434.287312] Starting dynamic subtest: pipe-B-eDP-1 [434.303110] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s) [434.312817] Starting dynamic subtest: pipe-C-eDP-1 [434.329767] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.014s) [434.339667] Starting dynamic subtest: pipe-D-eDP-1 [434.355608] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.012s) [434.357330] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.184s) [436.661781] [086/134] (592s left) gem_exec_schedule (u-semaphore-user) [436.742944] Starting subtest: u-semaphore-user [436.792631] Subtest u-semaphore-user: SUCCESS (0.058s) [438.288308] [087/134] (590s left) gem_exec_fence (basic-await) [438.475327] Starting subtest: basic-await [438.477712] Starting dynamic subtest: rcs0 [438.553855] Dynamic subtest rcs0: SUCCESS (0.077s) [438.565453] Starting dynamic subtest: bcs0 [438.630397] Dynamic subtest bcs0: SUCCESS (0.075s) [438.643001] Starting dynamic subtest: vcs0 [438.707747] Dynamic subtest vcs0: SUCCESS (0.075s) [438.720470] Starting dynamic subtest: vcs1 [438.785204] Dynamic subtest vcs1: SUCCESS (0.074s) [438.798517] Starting dynamic subtest: vecs0 [438.858566] Dynamic subtest vecs0: SUCCESS (0.072s) [438.871458] Starting dynamic subtest: ccs0 [438.931281] Dynamic subtest ccs0: SUCCESS (0.072s) [438.933868] Subtest basic-await: SUCCESS (0.457s) [440.403144] [088/134] (588s left) kms_rotation_crc (cursor-rotation-180) [440.512388] Starting subtest: cursor-rotation-180 [442.010712] Subtest cursor-rotation-180: SUCCESS (1.499s) [443.217403] [089/134] (585s left) kms_cursor_crc (cursor-onscreen-512x170) [443.510489] Starting subtest: cursor-onscreen-512x170 [443.515029] Subtest cursor-onscreen-512x170: SKIP (0.001s) [443.691619] [090/134] (585s left) kms_big_fb (linear-addfb) [443.803660] Starting subtest: linear-addfb [443.805952] Subtest linear-addfb: SUCCESS (0.000s) [443.921992] [091/134] (585s left) gem_exec_whisper (basic-queues) [443.975750] Starting subtest: basic-queues [450.576072] Subtest basic-queues: SUCCESS (6.597s) [450.785641] [092/134] (578s left) gem_exec_reloc (basic-scanout) [450.858438] Subtest basic-scanout: SKIP (0.000s) [450.951394] [093/134] (578s left) kms_plane_lowres (tiling-4) [451.064217] Starting subtest: tiling-4 [451.066312] Starting dynamic subtest: pipe-A-eDP-1 [451.070662] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [451.367612] Starting dynamic subtest: pipe-B-eDP-1 [451.371968] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [451.381723] Starting dynamic subtest: pipe-C-eDP-1 [451.386523] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [451.396763] Starting dynamic subtest: pipe-D-eDP-1 [451.401301] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [451.405678] Subtest tiling-4: SKIP (0.301s) [452.254380] [094/134] (577s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff) [452.359946] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff [459.576845] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.219s) [459.792317] [095/134] (569s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu) [459.895085] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu [463.450605] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.559s) [464.664284] [096/134] (564s left) gem_ctx_create (basic) [464.738977] Starting subtest: basic [464.741309] Subtest basic: SUCCESS (0.000s) [464.947128] [097/134] (564s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling) [465.048025] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling [465.050401] Starting dynamic subtest: pipe-A-default-mode [466.188753] Dynamic subtest pipe-A-default-mode: SKIP (1.138s) [466.192797] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.140s) [466.388725] [098/134] (563s left) gem_pwrite (basic-exhaustion) [466.447362] Subtest basic-exhaustion: SKIP (0.000s) [466.518253] [099/134] (562s left) kms_atomic_transition (plane-all-transition-nonblocking) [466.607426] Starting subtest: plane-all-transition-nonblocking [466.609530] Starting dynamic subtest: pipe-A-eDP-1 [469.100100] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.494s) [469.422184] Starting dynamic subtest: pipe-B-eDP-1 [472.691092] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.279s) [472.988856] Subtest plane-all-transition-nonblocking: SUCCESS (6.381s) [473.842724] [100/134] (555s left) kms_color_pipeline (plane-lut1d-lut1d) [473.942594] Starting subtest: plane-lut1d-lut1d [473.956412] Starting dynamic subtest: pipe-A-eDP-1 [474.669823] Dynamic subtest pipe-A-eDP-1: FAIL (0.317s) [475.305902] Starting dynamic subtest: pipe-B-eDP-1 [476.142129] Dynamic subtest pipe-B-eDP-1: FAIL (0.323s) [476.749447] Starting dynamic subtest: pipe-C-eDP-1 [477.593180] Dynamic subtest pipe-C-eDP-1: FAIL (0.267s) [478.069568] Starting dynamic subtest: pipe-D-eDP-1 [478.884036] Dynamic subtest pipe-D-eDP-1: FAIL (0.236s) [478.886364] Subtest plane-lut1d-lut1d: FAIL (4.643s) [479.477597] [101/134] (550s left) gem_lmem_swapping (verify-random) [479.524691] Subtest verify-random: SKIP (0.000s) [479.563179] [102/134] (550s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc) [479.667836] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc [479.672042] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [479.807436] [103/134] (549s left) sw_sync (sync_random_merge) [479.846048] Starting subtest: sync_random_merge [479.889899] Subtest sync_random_merge: SUCCESS (0.044s) [479.977615] [104/134] (549s left) syncobj_timeline (invalid-signal-bad-pad) [480.045964] Starting subtest: invalid-signal-bad-pad [480.048262] Subtest invalid-signal-bad-pad: SUCCESS (0.000s) [480.180512] [105/134] (549s left) gem_mmap_gtt (basic) [480.255117] Subtest basic: SKIP (0.000s) [480.324168] [106/134] (549s left) gem_exec_balancer (invalid-balancer) [480.399201] Starting subtest: invalid-balancer [481.282350] Subtest invalid-balancer: SUCCESS (0.884s) [481.611524] [107/134] (548s left) kms_big_fb (y-tiled-8bpp-rotate-90) [481.721914] Starting subtest: y-tiled-8bpp-rotate-90 [481.726135] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s) [481.854442] [108/134] (548s left) gem_render_linear_blits (basic) [481.919645] Starting subtest: basic [481.937993] Subtest basic: SUCCESS (0.021s) [482.026490] [109/134] (547s left) gem_ctx_shared (q-promotion) [482.078012] Starting subtest: Q-promotion [482.080328] Starting dynamic subtest: rcs0 [482.178817] Dynamic subtest rcs0: SUCCESS (0.104s) [482.196322] Starting dynamic subtest: vcs0 [482.271807] Dynamic subtest vcs0: SUCCESS (0.091s) [482.290218] Starting dynamic subtest: vcs1 [482.350481] Dynamic subtest vcs1: SUCCESS (0.077s) [482.369268] Starting dynamic subtest: vecs0 [482.430564] Dynamic subtest vecs0: SUCCESS (0.079s) [482.448309] Starting dynamic subtest: ccs0 [482.519469] Dynamic subtest ccs0: SUCCESS (0.088s) [482.521664] Subtest Q-promotion: SUCCESS (0.445s) [484.377960] [110/134] (545s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite) [484.487990] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite [484.492418] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [484.626791] [111/134] (545s left) syncobj_timeline (single-wait-for-submit-available-submitted) [484.691064] Starting subtest: single-wait-for-submit-available-submitted [484.693380] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s) [484.845146] [112/134] (545s left) gem_flink_basic (bad-open) [484.907114] Starting subtest: bad-open [484.909249] Subtest bad-open: SUCCESS (0.000s) [485.036709] [113/134] (545s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc) [485.138594] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc [485.140852] Starting dynamic subtest: pipe-A-eDP-1 [486.051613] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.906s) [486.061861] Starting dynamic subtest: pipe-B-eDP-1 [487.677214] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.623s) [487.689370] Starting dynamic subtest: pipe-C-eDP-1 [489.181166] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.502s) [489.192565] Starting dynamic subtest: pipe-D-eDP-1 [490.732038] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.547s) [490.734272] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.584s) [491.931796] [114/134] (538s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc) [492.042405] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc [492.046570] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [492.187981] [115/134] (537s left) kms_hdr (bpc-switch-dpms) [492.283876] Starting subtest: bpc-switch-dpms [493.372703] Starting dynamic subtest: pipe-A-eDP-1 [497.912658] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.539s) [497.915026] Subtest bpc-switch-dpms: SUCCESS (5.631s) [498.064169] [116/134] (532s left) kms_chamelium_hpd (hdmi-hpd) [498.456462] Subtest hdmi-hpd: SKIP (0.000s) [499.276811] [117/134] (530s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270) [499.377759] Starting subtest: primary-yf-tiled-reflect-x-270 [499.381854] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s) [499.482524] [118/134] (530s left) prime_vgem (basic-write) [499.575715] Starting subtest: basic-write [499.581372] Subtest basic-write: SKIP (0.006s) [499.728836] [119/134] (530s left) gem_ctx_freq (sysfs) [499.799620] Starting subtest: sysfs [499.801987] Starting dynamic subtest: gt0 [505.336305] Dynamic subtest gt0: SUCCESS (5.536s) [505.349618] Starting dynamic subtest: gt1 [547.212828] Dynamic subtest gt1: SUCCESS (41.873s) [547.215778] Subtest sysfs: SUCCESS (47.412s) [547.380917] [120/134] (483s left) kms_cursor_crc (cursor-onscreen-max-size) [547.713373] Starting subtest: cursor-onscreen-max-size [547.720343] Subtest cursor-onscreen-max-size: SKIP (0.000s) [547.882494] [121/134] (482s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt) [547.995482] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt [547.999882] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [548.148264] [122/134] (482s left) perf (per-context-mode-unprivileged) [548.245846] Starting subtest: per-context-mode-unprivileged [548.249406] Subtest per-context-mode-unprivileged: SKIP (0.000s) [548.295081] [123/134] (482s left) kms_setmode (basic) [548.367776] Starting subtest: basic [548.696180] Starting dynamic subtest: pipe-A-eDP-1 [550.802151] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.102s) [551.145628] Starting dynamic subtest: pipe-B-eDP-1 [553.242987] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.102s) [553.552233] Subtest basic: SUCCESS (5.183s) [554.409333] [124/134] (476s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [554.528717] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [555.220570] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.693s) [555.428236] [125/134] (475s left) kms_atomic_transition (plane-use-after-nonblocking-unbind) [555.533901] Starting subtest: plane-use-after-nonblocking-unbind [555.536305] Starting dynamic subtest: pipe-A-eDP-1 [555.593956] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s) [555.891594] Starting dynamic subtest: pipe-B-eDP-1 [556.688672] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.808s) [556.975514] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.443s) [557.878683] [126/134] (472s left) kms_atomic_interruptible (universal-setplane-primary) [557.986222] Starting subtest: universal-setplane-primary [557.988630] Starting dynamic subtest: pipe-A-eDP-1 [565.389835] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.402s) [565.392214] Subtest universal-setplane-primary: SUCCESS (7.404s) [566.243395] [127/134] (464s left) kms_pm_backlight (fade-with-dpms) [566.342596] Starting subtest: fade-with-dpms [568.707774] Starting dynamic subtest: eDP-1 [571.412766] Dynamic subtest eDP-1: SUCCESS (2.704s) [571.415021] Subtest fade-with-dpms: SUCCESS (5.070s) [572.236554] [128/134] (458s left) perf_pmu (event-wait) [572.282428] Starting subtest: event-wait [572.284716] Starting dynamic subtest: rcs0 [572.288689] Dynamic subtest rcs0: SKIP (0.000s) [572.292723] Subtest event-wait: SKIP (0.001s) [572.410208] [129/134] (458s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt) [572.527489] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt [572.531666] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [572.634028] [130/134] (458s left) gem_exec_whisper (basic-contexts-all) [572.703869] Starting subtest: basic-contexts-all [581.457212] Subtest basic-contexts-all: SUCCESS (8.753s) [581.664925] [131/134] (449s left) gem_spin_batch (spin-each) [581.746951] Starting subtest: spin-each [585.111185] Subtest spin-each: SUCCESS (3.363s) [585.322392] [132/134] (445s left) kms_universal_plane (disable-primary-vs-flip) [585.429309] Starting subtest: disable-primary-vs-flip [585.431196] Starting dynamic subtest: pipe-A-eDP-1 [587.007942] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.577s) [587.019094] Starting dynamic subtest: pipe-B-eDP-1 [589.223560] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.215s) [589.239160] Starting dynamic subtest: pipe-C-eDP-1 [591.407738] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.182s) [591.418755] Starting dynamic subtest: pipe-D-eDP-1 [593.653340] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.244s) [593.655553] Subtest disable-primary-vs-flip: SUCCESS (8.224s) [594.480842] [133/134] (436s left) gem_exec_schedule (preemptive-hang) [594.655776] Starting subtest: preemptive-hang [594.657788] Starting dynamic subtest: rcs0 [604.345316] Dynamic subtest rcs0: SUCCESS (9.693s) [604.357317] Starting dynamic subtest: bcs0 [613.371603] Dynamic subtest bcs0: SUCCESS (9.020s) [613.386895] Starting dynamic subtest: vcs0 [622.329373] Dynamic subtest vcs0: SUCCESS (8.962s) [622.339874] Starting dynamic subtest: vcs1 [631.353740] Dynamic subtest vcs1: SUCCESS (9.017s) [631.366936] Starting dynamic subtest: vecs0 [640.370388] Dynamic subtest vecs0: SUCCESS (9.022s) [640.380576] Starting dynamic subtest: ccs0 [649.337109] Dynamic subtest ccs0: SUCCESS (8.960s) [649.339790] Subtest preemptive-hang: SUCCESS (54.682s) [649.593782] [134/134] (381s left) syncobj_wait (invalid-signal-bad-pad) [649.653445] Starting subtest: invalid-signal-bad-pad [649.656126] Subtest invalid-signal-bad-pad: SUCCESS (0.000s) [649.781250] 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.