[58.104919] Initializing watchdogs
[58.104967]   /dev/watchdog0
[58.119649] [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]
[58.125654] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.127890] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.131194] [001/133] (960s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[58.251327] Starting subtest: fbc-psr2-cursor-mmap-gtt
[58.253530] Starting dynamic subtest: eDP-1
[58.257540] Dynamic subtest eDP-1: SKIP (0.000s)
[58.261534] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.000s)
[58.324014] [002/133] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[58.421634] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[58.425790] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[58.526511] [003/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[58.625232] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[58.629335] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[58.720832] [004/133] (960s left) kms_psr (psr2-primary-blt)
[58.810962] Starting subtest: psr2-primary-blt
[58.813334] Starting dynamic subtest: eDP-1
[60.517581] Dynamic subtest eDP-1: SUCCESS (1.711s)
[60.519841] Subtest psr2-primary-blt: SUCCESS (1.711s)
[61.379698] [005/133] (957s left) gem_exec_fence (nb-await)
[61.556651] Starting subtest: nb-await
[61.559040] Starting dynamic subtest: rcs0
[61.624674] Dynamic subtest rcs0: SUCCESS (0.068s)
[61.635068] Starting dynamic subtest: bcs0
[61.687192] Dynamic subtest bcs0: SUCCESS (0.061s)
[61.697146] Starting dynamic subtest: vcs0
[61.747187] Dynamic subtest vcs0: SUCCESS (0.059s)
[61.756914] Starting dynamic subtest: vcs1
[61.806417] Dynamic subtest vcs1: SUCCESS (0.058s)
[61.816545] Starting dynamic subtest: vecs0
[61.865303] Dynamic subtest vecs0: SUCCESS (0.058s)
[61.875143] Starting dynamic subtest: ccs0
[61.923303] Dynamic subtest ccs0: SUCCESS (0.058s)
[61.925984] Subtest nb-await: SUCCESS (0.368s)
[63.953317] [FACT gem_exec_fence (nb-await)] new: kernel.kmod_is_loaded.vgem: true
[63.956511] [006/133] (954s left) kms_plane_scaling (invalid-parameters)
[64.055307] Starting subtest: invalid-parameters
[64.057608] Starting dynamic subtest: less-than-1-height-src
[64.069662] Dynamic subtest less-than-1-height-src: SUCCESS (0.014s)
[64.077346] Starting dynamic subtest: less-than-1-width-src
[64.082399] Dynamic subtest less-than-1-width-src: SUCCESS (0.013s)
[64.084598] Subtest invalid-parameters: SUCCESS (0.027s)
[64.184523] [007/133] (954s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[64.274218] Starting subtest: psr2-cursor-plane-update-sf
[64.276512] Starting dynamic subtest: pipe-A-eDP-1
[64.854728] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.585s)
[64.861803] Starting dynamic subtest: pipe-B-eDP-1
[66.169943] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.318s)
[66.172277] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.905s)
[67.112315] [008/133] (951s left) kms_psr (pr-primary-mmap-gtt)
[67.380505] Starting subtest: pr-primary-mmap-gtt
[67.384887] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[67.844917] [009/133] (951s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[67.958494] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu
[67.962631] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[68.173559] [010/133] (950s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[68.266801] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[68.372070] [011/133] (950s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[68.470046] Starting subtest: yf-tiled-8bpp-rotate-270
[68.474105] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[68.578952] [012/133] (950s left) kms_atomic (atomic-invalid-params)
[68.686615] Starting subtest: atomic-invalid-params
[68.688847] Starting dynamic subtest: pipe-A-eDP-1
[69.116838] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.430s)
[69.119189] Subtest atomic-invalid-params: SUCCESS (0.431s)
[69.978316] [013/133] (949s left) kms_psr (psr-dpms)
[70.066543] Starting subtest: psr-dpms
[70.068842] Starting dynamic subtest: eDP-1
[73.006576] Dynamic subtest eDP-1: SUCCESS (2.942s)
[73.008962] Subtest psr-dpms: SUCCESS (2.943s)
[73.870436] [014/133] (945s left) kms_getfb (getfb-repeated-different-handles)
[73.964446] Starting subtest: getfb-repeated-different-handles
[73.966847] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[74.067553] [015/133] (945s left) gem_vm_create (invalid-create)
[74.121837] Starting subtest: invalid-create
[74.124247] Subtest invalid-create: SUCCESS (0.002s)
[74.246915] [016/133] (945s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[74.375576] Starting subtest: cursorA-vs-flipA-varying-size
[85.513488] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.138s)
[86.324247] [017/133] (933s left) gem_workarounds (suspend-resume)
[86.400465] Starting subtest: suspend-resume
[102.716866] Subtest suspend-resume: SUCCESS (1.686s)
[108.836824] [018/133] (916s left) syncobj_timeline (invalid-query-one-illegal-handle)
[108.907549] Starting subtest: invalid-query-one-illegal-handle
[108.909966] Subtest invalid-query-one-illegal-handle: SUCCESS (0.001s)
[109.006979] [019/133] (916s left) kms_vblank (ts-continuation-dpms-suspend)
[109.098450] Starting subtest: ts-continuation-dpms-suspend
[109.100968] Starting dynamic subtest: pipe-A-eDP-1
[126.273132] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.292s)
[126.288606] Starting dynamic subtest: pipe-D-eDP-1
[144.265557] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.924s)
[144.267763] Subtest ts-continuation-dpms-suspend: SUCCESS (5.219s)
[155.074920] [020/133] (880s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[155.208485] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[156.260079] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.058s)
[156.398122] [021/133] (879s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[156.532183] Starting subtest: flip-vs-cursor-toggle
[165.266928] Subtest flip-vs-cursor-toggle: SUCCESS (8.759s)
[166.114757] [022/133] (869s left) syncobj_eventfd (invalid-bad-flags)
[166.170284] Starting subtest: invalid-bad-flags
[166.172509] Subtest invalid-bad-flags: SUCCESS (0.000s)
[166.256102] [023/133] (869s left) gem_exec_reloc (basic-softpin)
[166.320108] Subtest basic-softpin: SKIP (0.000s)
[166.397229] [024/133] (869s left) i915_pm_rpm (system-suspend)
[168.724646] Starting subtest: system-suspend
[187.507585] Subtest system-suspend: SUCCESS (3.266s)
[193.898351] [025/133] (847s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[193.996805] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[193.998888] Starting dynamic subtest: pipe-A-eDP-1
[227.972553] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.729s)
[227.981102] Starting dynamic subtest: pipe-B-eDP-1
[262.904564] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.488s)
[262.913420] Starting dynamic subtest: pipe-C-eDP-1
[297.880032] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.512s)
[297.889458] Starting dynamic subtest: pipe-D-eDP-1
[332.887919] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.442s)
[332.890309] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (17.177s)
[342.125257] [026/133] (707s left) gem_lmem_swapping (parallel-random-verify-ccs)
[342.189856] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[342.242089] [027/133] (707s left) kms_atomic_transition (plane-all-transition-fencing)
[342.337122] Starting subtest: plane-all-transition-fencing
[342.339457] Starting dynamic subtest: pipe-A-eDP-1
[344.827520] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[345.139809] Starting dynamic subtest: pipe-B-eDP-1
[348.328620] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.207s)
[348.624440] Subtest plane-all-transition-fencing: SUCCESS (6.296s)
[349.456478] [028/133] (700s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier)
[349.549857] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier
[349.553807] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s)
[349.623679] [029/133] (700s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[349.684967] Subtest writes-after-reads-snoop: SKIP (0.000s)
[349.758030] [030/133] (700s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[349.812817] Starting subtest: wait-all-for-submit-delayed-submit
[349.917349] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[350.006007] [031/133] (699s left) gem_busy (extended)
[350.190319] Starting subtest: extended
[350.192687] Starting dynamic subtest: rcs0
[350.268712] Dynamic subtest rcs0: SUCCESS (0.078s)
[350.279870] Starting dynamic subtest: bcs0
[350.310146] Dynamic subtest bcs0: SUCCESS (0.039s)
[350.320225] Starting dynamic subtest: vcs0
[351.892374] Dynamic subtest vcs0: SUCCESS (1.580s)
[351.903766] Starting dynamic subtest: vcs1
[353.941099] Dynamic subtest vcs1: SUCCESS (2.058s)
[353.955138] Starting dynamic subtest: vecs0
[355.926607] Dynamic subtest vecs0: SUCCESS (1.999s)
[355.938848] Starting dynamic subtest: ccs0
[355.971965] Dynamic subtest ccs0: SUCCESS (0.044s)
[355.974606] Subtest extended: SUCCESS (5.814s)
[356.218084] [032/133] (693s left) kms_big_fb (linear-64bpp-rotate-270)
[356.319928] Starting subtest: linear-64bpp-rotate-270
[356.338030] Subtest linear-64bpp-rotate-270: SKIP (0.018s)
[356.439153] [033/133] (693s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[356.816249] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[357.624374] [034/133] (692s left) gem_render_copy (yf-tiled-to-vebox-linear)
[357.680424] Starting subtest: yf-tiled-to-vebox-linear
[357.685123] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[357.864395] [035/133] (692s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[357.946621] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[357.948707] Starting dynamic subtest: pipe-A-eDP-1
[358.259153] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[358.269998] Starting dynamic subtest: pipe-B-eDP-1
[359.516587] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.262s)
[359.526523] Starting dynamic subtest: pipe-C-eDP-1
[360.753737] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.241s)
[360.764720] Starting dynamic subtest: pipe-D-eDP-1
[361.956512] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.206s)
[361.958460] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (3.998s)
[363.085056] [036/133] (687s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[363.158082] Starting subtest: basic-batch-kernel-default-cmd
[363.162638] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[363.347878] [037/133] (686s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[363.394488] Starting subtest: invalid-multi-wait-unsubmitted
[363.396438] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[363.490452] [038/133] (686s left) gem_ctx_persistence (engines-hostile-preempt)
[363.552831] Starting subtest: engines-hostile-preempt
[363.555130] Starting dynamic subtest: rcs0
[363.630747] Dynamic subtest rcs0: SUCCESS (0.078s)
[363.642313] Starting dynamic subtest: bcs0
[363.677619] Dynamic subtest bcs0: SUCCESS (0.045s)
[363.687302] Starting dynamic subtest: vcs0
[364.882350] Dynamic subtest vcs0: SUCCESS (1.204s)
[364.893974] Starting dynamic subtest: vcs1
[366.932072] Dynamic subtest vcs1: SUCCESS (2.052s)
[366.945484] Starting dynamic subtest: vecs0
[368.890446] Dynamic subtest vecs0: SUCCESS (1.960s)
[368.905888] Starting dynamic subtest: ccs0
[368.971712] Dynamic subtest ccs0: SUCCESS (0.080s)
[368.974582] Subtest engines-hostile-preempt: SUCCESS (5.432s)
[369.059366] [039/133] (681s left) kms_cursor_edge_walk (64x64-right-edge)
[369.165792] Starting subtest: 64x64-right-edge
[369.168113] Starting dynamic subtest: pipe-A-eDP-1
[372.664510] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.501s)
[372.673631] Starting dynamic subtest: pipe-D-eDP-1
[375.839612] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.177s)
[375.841586] Subtest 64x64-right-edge: SUCCESS (6.681s)
[376.639957] [040/133] (673s left) core_auth (getclient-simple)
[376.681299] Starting subtest: getclient-simple
[376.699591] Subtest getclient-simple: SUCCESS (0.018s)
[376.809985] [041/133] (673s left) gem_exec_reloc (basic-write-read-noreloc)
[376.863492] Subtest basic-write-read-noreloc: SKIP (0.000s)
[376.947066] [042/133] (673s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[377.052721] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[377.057055] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[377.160536] [043/133] (673s left) kms_color_pipeline (plane-lut1d)
[377.260561] Starting subtest: plane-lut1d
[377.405810] Starting dynamic subtest: pipe-A-plane-0
[377.719068] Dynamic subtest pipe-A-plane-0: FAIL (0.187s)
[377.729059] Starting dynamic subtest: pipe-A-plane-1
[377.928677] Dynamic subtest pipe-A-plane-1: FAIL (0.164s)
[377.942918] Starting dynamic subtest: pipe-A-plane-2
[378.147860] Dynamic subtest pipe-A-plane-2: FAIL (0.166s)
[379.151801] Starting dynamic subtest: pipe-B-plane-0
[379.578631] Dynamic subtest pipe-B-plane-0: FAIL (0.174s)
[379.589272] Starting dynamic subtest: pipe-B-plane-1
[379.888974] Dynamic subtest pipe-B-plane-1: FAIL (0.170s)
[379.899663] Starting dynamic subtest: pipe-B-plane-2
[380.190781] Dynamic subtest pipe-B-plane-2: FAIL (0.184s)
[380.856616] Starting dynamic subtest: pipe-C-plane-0
[381.354450] Dynamic subtest pipe-C-plane-0: FAIL (0.162s)
[381.364486] Starting dynamic subtest: pipe-C-plane-1
[381.746766] Dynamic subtest pipe-C-plane-1: FAIL (0.144s)
[381.757083] Starting dynamic subtest: pipe-C-plane-2
[382.108189] Dynamic subtest pipe-C-plane-2: FAIL (0.624s)
[382.993163] Starting dynamic subtest: pipe-D-plane-0
[383.548799] Dynamic subtest pipe-D-plane-0: FAIL (0.141s)
[383.558068] Starting dynamic subtest: pipe-D-plane-1
[383.992319] Dynamic subtest pipe-D-plane-1: FAIL (0.595s)
[384.000516] Starting dynamic subtest: pipe-D-plane-2
[384.417310] Dynamic subtest pipe-D-plane-2: FAIL (0.564s)
[384.605145] Subtest plane-lut1d: FAIL (7.351s)
[385.470487] [044/133] (665s left) kms_universal_plane (universal-plane-pageflip-windowed)
[385.563189] Starting subtest: universal-plane-pageflip-windowed
[385.565501] Starting dynamic subtest: pipe-A-eDP-1
[386.169092] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.603s)
[386.178448] Starting dynamic subtest: pipe-B-eDP-1
[387.409551] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.240s)
[387.419604] Starting dynamic subtest: pipe-C-eDP-1
[388.620626] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.209s)
[388.632465] Starting dynamic subtest: pipe-D-eDP-1
[389.843238] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.221s)
[389.845653] Subtest universal-plane-pageflip-windowed: SUCCESS (4.279s)
[390.692134] [045/133] (659s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[390.780283] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[390.782602] Starting dynamic subtest: A-eDP1
[394.426653] Dynamic subtest A-eDP1: SUCCESS (3.641s)
[394.438388] Starting dynamic subtest: B-eDP1
[397.624865] Dynamic subtest B-eDP1: SUCCESS (3.196s)
[397.633928] Starting dynamic subtest: C-eDP1
[400.807990] Dynamic subtest C-eDP1: SUCCESS (3.182s)
[400.817841] Starting dynamic subtest: D-eDP1
[403.985675] Dynamic subtest D-eDP1: SUCCESS (3.177s)
[403.988043] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.204s)
[404.793399] [046/133] (645s left) i915_hangman (gt-error-state-capture)
[404.864044] Starting subtest: gt-error-state-capture
[404.865964] Starting dynamic subtest: rcs0
[416.883219] Dynamic subtest rcs0: SUCCESS (12.020s)
[416.895171] Starting dynamic subtest: bcs0
[427.889992] Dynamic subtest bcs0: SUCCESS (11.007s)
[427.899904] Starting dynamic subtest: vcs0
[439.859070] Dynamic subtest vcs0: SUCCESS (11.970s)
[439.871640] Starting dynamic subtest: vcs1
[450.868037] Dynamic subtest vcs1: SUCCESS (11.008s)
[450.880066] Starting dynamic subtest: vecs0
[460.915607] Dynamic subtest vecs0: SUCCESS (10.040s)
[460.927545] Starting dynamic subtest: ccs0
[471.859797] Dynamic subtest ccs0: SUCCESS (10.939s)
[471.862578] Subtest gt-error-state-capture: SUCCESS (67.000s)
[471.974598] [047/133] (578s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[472.073995] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs
[472.076267] Starting dynamic subtest: pipe-A-eDP-1
[472.099146] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[472.110114] Starting dynamic subtest: pipe-B-eDP-1
[472.131186] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[472.140090] Starting dynamic subtest: pipe-C-eDP-1
[472.161380] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[472.170141] Starting dynamic subtest: pipe-D-eDP-1
[472.191920] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[472.195983] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[474.338888] [048/133] (576s left) perf_pmu (init-busy)
[474.383700] Starting subtest: init-busy
[474.385974] Starting dynamic subtest: rcs0
[474.388165] Dynamic subtest rcs0: SUCCESS (0.001s)
[474.397295] Starting dynamic subtest: bcs0
[474.399487] Dynamic subtest bcs0: SUCCESS (0.000s)
[474.408140] Starting dynamic subtest: vcs0
[474.410310] Dynamic subtest vcs0: SUCCESS (0.001s)
[474.420619] Starting dynamic subtest: vcs1
[474.422743] Dynamic subtest vcs1: SUCCESS (0.001s)
[474.431517] Starting dynamic subtest: vecs0
[474.433620] Dynamic subtest vecs0: SUCCESS (0.001s)
[474.441814] Starting dynamic subtest: ccs0
[474.443645] Dynamic subtest ccs0: SUCCESS (0.000s)
[474.445470] Subtest init-busy: SUCCESS (0.007s)
[474.493337] [049/133] (576s left) gem_workarounds (basic-read)
[474.562395] Starting subtest: basic-read
[474.573591] Subtest basic-read: SUCCESS (0.011s)
[474.690839] [050/133] (576s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[474.795050] Starting subtest: y-tiled-32bpp-rotate-90
[474.799465] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[474.887619] [051/133] (575s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[474.983352] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[474.987613] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[475.084405] [052/133] (575s left) kms_mmap_write_crc (main)
[475.181320] Starting subtest: main
[475.183606] Starting dynamic subtest: pipe-A-eDP-1
[478.753243] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.568s)
[478.755677] Subtest main: SUCCESS (3.569s)
[479.570324] [053/133] (571s left) api_intel_allocator (fork-simple-stress)
[479.640816] Starting subtest: fork-simple-stress
[485.059670] Subtest fork-simple-stress: SUCCESS (5.417s)
[485.183245] [054/133] (565s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[485.299198] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[486.368827] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (1.070s)
[486.504887] [055/133] (564s left) kms_joiner (basic-max-non-joiner)
[486.601443] Starting subtest: basic-max-non-joiner
[486.605042] Subtest basic-max-non-joiner: SKIP (0.000s)
[486.671736] [056/133] (564s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[486.772839] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[486.776343] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[486.846840] [057/133] (564s left) kms_content_protection (lic-type-0-hdcp14)
[487.000536] Starting subtest: lic-type-0-hdcp14
[487.004427] Subtest lic-type-0-hdcp14: SKIP (0.000s)
[487.120312] [058/133] (563s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[487.183941] Subtest untiled-to-tiled: SKIP (0.000s)
[487.259267] [059/133] (563s left) core_getversion (all-cards)
[487.297507] Starting subtest: all-cards
[487.303533] Subtest all-cards: SUCCESS (0.012s)
[487.349497] [060/133] (563s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite)
[487.448485] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite
[487.451877] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[487.563207] [061/133] (563s left) gem_userptr_blits (map-fixed-invalidate)
[487.637273] Starting subtest: map-fixed-invalidate
[487.641339] Subtest map-fixed-invalidate: SKIP (0.000s)
[487.759734] [062/133] (563s left) gen9_exec_parse (basic-rejected)
[487.825812] Subtest basic-rejected: SKIP (0.000s)
[487.916059] [063/133] (563s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[488.027401] Starting subtest: fbcpsr-suspend
[529.355325] Subtest fbcpsr-suspend: SUCCESS (11.539s)
[537.498559] [064/133] (521s left) gem_sync (basic-store-each)
[537.599975] Starting subtest: basic-store-each
[540.028592] Subtest basic-store-each: SUCCESS (2.462s)
[540.222471] [065/133] (519s left) gem_exec_balancer (full)
[540.288652] Starting subtest: full
[544.530809] Subtest full: SUCCESS (4.276s)
[544.847679] [066/133] (514s left) syncobj_wait (wait-any-interrupted)
[544.898189] Starting subtest: wait-any-interrupted
[544.999621] Subtest wait-any-interrupted: SUCCESS (0.102s)
[545.078166] [067/133] (514s left) kms_setmode (invalid-clone-exclusive-crtc)
[545.127181] Starting subtest: invalid-clone-exclusive-crtc
[545.133929] Subtest invalid-clone-exclusive-crtc: SKIP (0.001s)
[545.233741] [068/133] (514s left) kms_vrr (negative-basic)
[545.324389] Starting subtest: negative-basic
[545.330981] Starting dynamic subtest: pipe-A-eDP-1
[550.744594] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.434s)
[551.018953] Subtest negative-basic: SUCCESS (5.719s)
[551.850930] [069/133] (507s left) gem_userptr_blits (stress-mm)
[551.923774] Starting subtest: stress-mm
[557.283035] Subtest stress-mm: SUCCESS (5.369s)
[557.409964] [070/133] (502s left) gem_exec_big (single)
[557.464757] Starting subtest: single
[562.287361] Subtest single: SUCCESS (4.823s)
[562.539627] [071/133] (497s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[562.684634] Starting subtest: psr-modesetfrombusy
[568.825194] Subtest psr-modesetfrombusy: SUCCESS (6.143s)
[568.961552] [072/133] (490s left) kms_chamelium_color (ctm-green-to-red)
[569.065346] Subtest ctm-green-to-red: SKIP (0.000s)
[569.124304] [073/133] (490s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[569.217399] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[569.219121] Starting dynamic subtest: pipe-A-eDP-1
[569.304514] Dynamic subtest pipe-A-eDP-1: SKIP (0.089s)
[569.315019] Starting dynamic subtest: pipe-B-eDP-1
[570.489533] Dynamic subtest pipe-B-eDP-1: SKIP (1.183s)
[570.493988] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.274s)
[571.683265] [074/133] (488s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[571.808394] Starting subtest: 2x-flip-vs-cursor-atomic
[571.812648] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s)
[571.967716] [075/133] (487s left) sysfs_timeslice_duration (timeout)
[572.035695] Starting subtest: timeout
[572.038137] Starting dynamic subtest: vecs0
[581.744773] Dynamic subtest vecs0: SUCCESS (9.707s)
[581.755332] Starting dynamic subtest: ccs0
[583.076214] Dynamic subtest ccs0: SUCCESS (1.332s)
[583.088462] Starting dynamic subtest: vcs0
[592.694804] Dynamic subtest vcs0: SUCCESS (9.616s)
[592.707578] Starting dynamic subtest: bcs0
[593.294233] Dynamic subtest bcs0: SUCCESS (0.598s)
[593.305897] Starting dynamic subtest: rcs0
[594.528106] Dynamic subtest rcs0: SUCCESS (1.235s)
[594.540121] Starting dynamic subtest: vcs1
[603.693347] Dynamic subtest vcs1: SUCCESS (9.163s)
[603.696207] Subtest timeout: SUCCESS (31.665s)
[603.773962] [076/133] (456s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[603.878386] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[610.621849] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.747s)
[610.747101] [077/133] (449s left) kms_cursor_crc (cursor-offscreen-512x512)
[611.081058] Starting subtest: cursor-offscreen-512x512
[611.085990] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[611.244292] [078/133] (448s left) kms_pm_rpm (pm-tiling)
[612.905539] Starting subtest: pm-tiling
[612.910324] Subtest pm-tiling: SKIP (0.000s)
[613.527364] [079/133] (446s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[613.636244] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[613.640380] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[613.739849] [080/133] (446s left) gem_spin_batch (legacy-resubmit)
[613.802900] Starting subtest: legacy-resubmit
[613.805335] Starting dynamic subtest: default
[613.810467] Dynamic subtest default: SUCCESS (0.005s)
[613.821110] Starting dynamic subtest: render
[613.823417] Dynamic subtest render: SUCCESS (0.001s)
[613.833729] Starting dynamic subtest: bsd
[613.835531] Dynamic subtest bsd: SUCCESS (0.002s)
[613.844618] Starting dynamic subtest: bsd1
[613.846462] Dynamic subtest bsd1: SUCCESS (0.001s)
[613.855575] Starting dynamic subtest: bsd2
[613.857376] Dynamic subtest bsd2: SUCCESS (0.003s)
[613.866476] Starting dynamic subtest: blt
[613.868326] Dynamic subtest blt: SUCCESS (0.003s)
[613.877439] Starting dynamic subtest: vebox
[613.879285] Dynamic subtest vebox: SUCCESS (0.002s)
[613.881061] Subtest legacy-resubmit: SUCCESS (0.022s)
[614.068022] [081/133] (446s left) gem_eio (wait-wedge-10ms)
[614.289882] Starting subtest: wait-wedge-10ms
[615.798538] Subtest wait-wedge-10ms: SUCCESS (1.508s)
[615.911725] [082/133] (444s left) gem_exec_params (sol-reset-not-gen7)
[615.963604] Starting subtest: sol-reset-not-gen7
[615.968495] Subtest sol-reset-not-gen7: SUCCESS (0.002s)
[616.075687] [083/133] (444s left) gem_ctx_shared (exec-single-timeline)
[616.136194] Starting subtest: exec-single-timeline
[616.138977] Starting dynamic subtest: rcs0
[617.170111] Dynamic subtest rcs0: SUCCESS (1.032s)
[617.187449] Starting dynamic subtest: bcs0
[618.259322] Dynamic subtest bcs0: SUCCESS (1.087s)
[618.273136] Starting dynamic subtest: vcs0
[619.346557] Dynamic subtest vcs0: SUCCESS (1.085s)
[619.360656] Starting dynamic subtest: vcs1
[620.434299] Dynamic subtest vcs1: SUCCESS (1.085s)
[620.446869] Starting dynamic subtest: vecs0
[621.522731] Dynamic subtest vecs0: SUCCESS (1.086s)
[621.536356] Starting dynamic subtest: ccs0
[622.609863] Dynamic subtest ccs0: SUCCESS (1.085s)
[622.612935] Subtest exec-single-timeline: SUCCESS (6.477s)
[622.804223] [084/133] (437s left) gem_exec_params (mmapped)
[622.865851] Starting subtest: mmapped
[622.872136] Subtest mmapped: SUCCESS (0.006s)
[622.992157] [085/133] (437s left) syncobj_timeline (host-signal-ordered)
[623.068357] Starting subtest: host-signal-ordered
[623.070717] Subtest host-signal-ordered: SUCCESS (0.000s)
[623.158259] [086/133] (437s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[623.210059] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[623.212359] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.001s)
[623.291642] [087/133] (437s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[623.376982] Starting subtest: primary-x-tiled-reflect-x-180
[630.365307] Subtest primary-x-tiled-reflect-x-180: SUCCESS (6.983s)
[631.575963] [088/133] (428s left) gem_mmap_offset (partial-unmap)
[631.631935] Starting subtest: partial-unmap
[631.634356] Starting dynamic subtest: smem0
[632.120965] Dynamic subtest smem0: SUCCESS (0.490s)
[632.123452] Subtest partial-unmap: SUCCESS (0.491s)
[632.235153] [089/133] (428s left) tools_test (tools_test)
[632.290370] Starting subtest: tools_test
[632.349932] Subtest tools_test: SUCCESS (0.075s)
[632.411985] [090/133] (428s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[632.502732] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[632.506768] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[632.599192] [091/133] (427s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping)
[632.696956] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping
[632.724247] Starting dynamic subtest: pipe-A-plane-0
[633.145081] Dynamic subtest pipe-A-plane-0: SUCCESS (0.421s)
[633.155072] Starting dynamic subtest: pipe-A-plane-3
[633.401456] Dynamic subtest pipe-A-plane-3: SUCCESS (0.255s)
[634.474936] Starting dynamic subtest: pipe-B-plane-0
[634.944908] Dynamic subtest pipe-B-plane-0: SUCCESS (0.478s)
[634.957480] Starting dynamic subtest: pipe-B-plane-3
[635.211066] Dynamic subtest pipe-B-plane-3: SUCCESS (0.265s)
[635.532643] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier-source-clamping: SUCCESS (2.836s)
[636.367958] [092/133] (424s left) kms_pm_backlight (basic-brightness)
[636.461166] Starting subtest: basic-brightness
[636.513460] Starting dynamic subtest: eDP-1
[636.819523] Dynamic subtest eDP-1: SUCCESS (0.306s)
[636.821694] Subtest basic-brightness: SUCCESS (0.358s)
[637.691917] [093/133] (422s left) i915_pm_rps (thresholds-idle-park)
[637.760522] Starting subtest: thresholds-idle-park
[637.764839] Subtest thresholds-idle-park: SKIP (0.001s)
[637.857613] [094/133] (422s left) gem_exec_whisper (basic-contexts-all)
[637.928374] Starting subtest: basic-contexts-all
[649.687224] Subtest basic-contexts-all: SUCCESS (11.752s)
[649.873490] [095/133] (410s left) gem_mmap_gtt (basic-copy)
[649.927548] Subtest basic-copy: SKIP (0.000s)
[649.984402] [096/133] (410s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[650.375403] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[651.220615] [097/133] (409s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[651.292751] Starting subtest: legacy-engines-hostile-preempt
[651.295185] Starting dynamic subtest: render
[651.363017] Dynamic subtest render: SUCCESS (0.069s)
[651.381376] Starting dynamic subtest: bsd1
[652.701257] Dynamic subtest bsd1: SUCCESS (1.333s)
[652.711906] Starting dynamic subtest: bsd2
[654.682869] Dynamic subtest bsd2: SUCCESS (1.978s)
[654.694106] Starting dynamic subtest: blt
[654.760037] Dynamic subtest blt: SUCCESS (0.076s)
[654.772896] Starting dynamic subtest: vebox
[656.667013] Dynamic subtest vebox: SUCCESS (1.902s)
[656.670082] Subtest legacy-engines-hostile-preempt: SUCCESS (5.373s)
[656.790541] [098/133] (404s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[656.928465] Starting subtest: cursor-vs-flip-varying-size
[687.822706] Subtest cursor-vs-flip-varying-size: SUCCESS (30.892s)
[688.663335] [099/133] (372s left) gem_render_copy (linear-to-vebox-yf-tiled)
[688.722396] Starting subtest: linear-to-vebox-yf-tiled
[688.726705] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[688.918555] [100/133] (372s left) perf (gen8-unprivileged-single-ctx-counters)
[689.063513] Starting subtest: gen8-unprivileged-single-ctx-counters
[689.067608] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[689.106335] [101/133] (371s left) kms_cursor_crc (cursor-random-max-size)
[689.431145] Starting subtest: cursor-random-max-size
[689.437533] Subtest cursor-random-max-size: SKIP (0.000s)
[689.541476] [102/133] (371s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[689.633167] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[689.635410] Starting dynamic subtest: pipe-A-eDP-1
[689.774522] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.132s)
[689.787061] Starting dynamic subtest: pipe-B-eDP-1
[689.807091] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[689.817121] Starting dynamic subtest: pipe-C-eDP-1
[689.836146] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[689.846989] Starting dynamic subtest: pipe-D-eDP-1
[689.863755] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[689.865879] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.142s)
[692.028432] [103/133] (369s left) kms_psr (fbc-psr-no-drrs)
[692.123856] Starting subtest: fbc-psr-no-drrs
[692.126016] Starting dynamic subtest: eDP-1
[692.129993] Dynamic subtest eDP-1: SKIP (0.000s)
[692.133997] Subtest fbc-psr-no-drrs: SKIP (0.001s)
[692.202482] [104/133] (368s left) gem_mmap_wc (bad-size)
[692.256804] Subtest bad-size: SKIP (0.000s)
[692.312103] [105/133] (368s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[692.408091] Starting subtest: fbc-shrfb-scaledprimary
[695.419428] Subtest fbc-shrfb-scaledprimary: SUCCESS (3.015s)
[696.637409] [106/133] (364s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[696.741756] Starting subtest: fbc-farfromfence-mmap-gtt
[696.746210] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[696.843732] [107/133] (364s left) prime_vgem (fence-wait)
[696.915332] Starting subtest: fence-wait
[696.917974] Starting dynamic subtest: rcs0
[697.965603] Dynamic subtest rcs0: SUCCESS (1.049s)
[697.978312] Starting dynamic subtest: bcs0
[699.019311] Dynamic subtest bcs0: SUCCESS (1.051s)
[699.032816] Starting dynamic subtest: vcs0
[700.069059] Dynamic subtest vcs0: SUCCESS (1.047s)
[700.081373] Starting dynamic subtest: vcs1
[701.109623] Dynamic subtest vcs1: SUCCESS (1.039s)
[701.121899] Starting dynamic subtest: vecs0
[702.157715] Dynamic subtest vecs0: SUCCESS (1.046s)
[702.169016] Starting dynamic subtest: ccs0
[703.198299] Dynamic subtest ccs0: SUCCESS (1.038s)
[703.201243] Subtest fence-wait: SUCCESS (6.285s)
[703.336176] [108/133] (357s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[703.443960] Starting subtest: 4-tiled-32bpp-rotate-90
[703.463971] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.019s)
[703.569423] [109/133] (357s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[703.663664] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[703.667963] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[703.750465] [110/133] (357s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[703.807482] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[703.890024] [111/133] (357s left) kms_fbcon_fbt (psr)
[703.945583] Starting subtest: psr
[711.261151] Subtest psr: SUCCESS (7.312s)
[711.338838] [112/133] (350s left) gem_huc_copy (huc-copy)
[711.395704] Starting subtest: huc-copy
[711.400996] Subtest huc-copy: SUCCESS (0.003s)
[711.527768] [113/133] (349s left) gem_exec_reloc (basic-cpu-gtt)
[711.582576] Subtest basic-cpu-gtt: SKIP (0.000s)
[711.661478] [114/133] (349s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[711.760295] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[711.764308] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[711.846734] [115/133] (349s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[711.946484] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[711.950442] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[712.046445] [116/133] (349s left) kms_flip_event_leak (basic)
[712.140247] Starting subtest: basic
[712.142401] Starting dynamic subtest: pipe-A-eDP-1
[712.560496] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.418s)
[712.571021] Starting dynamic subtest: pipe-B-eDP-1
[713.691651] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.131s)
[713.702408] Starting dynamic subtest: pipe-C-eDP-1
[714.797207] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.105s)
[714.807250] Starting dynamic subtest: pipe-D-eDP-1
[715.919086] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.121s)
[715.921517] Subtest basic: SUCCESS (3.781s)
[716.827313] [117/133] (344s left) gem_close_race (multigpu-basic-process)
[716.892678] Starting subtest: multigpu-basic-process
[716.897015] Subtest multigpu-basic-process: SKIP (0.000s)
[717.120589] [118/133] (344s left) perf (i915-ref-count)
[717.186500] Starting subtest: i915-ref-count
[717.237037] Subtest i915-ref-count: SUCCESS (0.047s)
[717.294355] [119/133] (344s left) gem_eio (in-flight-suspend)
[717.543615] Starting subtest: in-flight-suspend
[761.029295] Subtest in-flight-suspend: SUCCESS (13.592s)
[768.192989] [120/133] (300s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[768.326237] Starting subtest: modeset-atomic-cursor-hotspot
[768.330799] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[768.473933] [121/133] (300s left) kms_draw_crc (draw-method-pwrite)
[768.564039] Starting subtest: draw-method-pwrite
[768.565959] Starting dynamic subtest: xrgb8888-untiled
[769.162976] Dynamic subtest xrgb8888-untiled: SUCCESS (0.600s)
[769.173663] Starting dynamic subtest: rgb565-untiled
[769.606798] Dynamic subtest rgb565-untiled: SUCCESS (0.443s)
[769.620356] Starting dynamic subtest: xrgb2101010-untiled
[770.162742] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.555s)
[770.177372] Starting dynamic subtest: xbgr16161616f-untiled
[770.940882] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.777s)
[770.951613] Starting dynamic subtest: xrgb8888-xtiled
[772.730909] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.787s)
[772.741658] Starting dynamic subtest: rgb565-xtiled
[773.839754] Dynamic subtest rgb565-xtiled: SUCCESS (1.108s)
[773.850420] Starting dynamic subtest: xrgb2101010-xtiled
[775.628225] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.787s)
[775.639135] Starting dynamic subtest: xbgr16161616f-xtiled
[778.972166] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.342s)
[778.983034] Starting dynamic subtest: xrgb8888-4tiled
[780.083010] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.110s)
[780.093650] Starting dynamic subtest: rgb565-4tiled
[780.649420] Dynamic subtest rgb565-4tiled: SUCCESS (0.566s)
[780.663946] Starting dynamic subtest: xrgb2101010-4tiled
[781.782900] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.132s)
[781.797611] Starting dynamic subtest: xbgr16161616f-4tiled
[784.860827] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (3.076s)
[784.863044] Subtest draw-method-pwrite: SUCCESS (16.302s)
[784.984317] [122/133] (283s left) kms_busy (extended-pageflip-hang-oldfb)
[785.094683] Starting subtest: extended-pageflip-hang-oldfb
[785.097158] Starting dynamic subtest: pipe-A
[785.498457] Dynamic subtest pipe-A: SUCCESS (0.403s)
[785.508994] Starting dynamic subtest: pipe-D
[786.604797] Dynamic subtest pipe-D: SUCCESS (1.105s)
[786.607269] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.514s)
[787.455455] [123/133] (281s left) gem_exec_schedule (preempt-queue-contexts)
[787.524801] Subtest preempt-queue-contexts: SKIP (0.000s)
[787.820155] [124/133] (281s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[787.907465] Starting subtest: psr-1p-primscrn-spr-indfb-move
[795.509015] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (7.606s)
[795.638297] [125/133] (273s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[795.730297] Starting subtest: plane-upscale-20x20-with-pixel-format
[795.732464] Starting dynamic subtest: pipe-A
[796.778111] Dynamic subtest pipe-A: SUCCESS (1.050s)
[796.790224] Starting dynamic subtest: pipe-B
[798.859485] Dynamic subtest pipe-B: SUCCESS (2.079s)
[798.871579] Starting dynamic subtest: pipe-C
[800.062144] Dynamic subtest pipe-C: SUCCESS (1.201s)
[800.079409] Starting dynamic subtest: pipe-D
[801.214107] Dynamic subtest pipe-D: SUCCESS (1.151s)
[801.216418] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.487s)
[802.411398] [126/133] (266s left) gem_exec_schedule (promotion)
[802.491749] Starting subtest: promotion
[802.494065] Starting dynamic subtest: rcs0
[802.595891] Dynamic subtest rcs0: SUCCESS (0.112s)
[802.609396] Starting dynamic subtest: vcs0
[802.684452] Dynamic subtest vcs0: SUCCESS (0.088s)
[802.694870] Starting dynamic subtest: vcs1
[802.773700] Dynamic subtest vcs1: SUCCESS (0.088s)
[802.786018] Starting dynamic subtest: vecs0
[802.868230] Dynamic subtest vecs0: SUCCESS (0.093s)
[802.881771] Starting dynamic subtest: ccs0
[802.968572] Dynamic subtest ccs0: SUCCESS (0.100s)
[802.970931] Subtest promotion: SUCCESS (0.486s)
[804.701609] [127/133] (264s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[804.800171] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[804.804535] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[804.907727] [128/133] (264s left) kms_lease (empty-lease)
[804.997083] Starting subtest: empty-lease
[804.999352] Starting dynamic subtest: pipe-A-eDP-1
[805.001598] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[805.012730] Starting dynamic subtest: pipe-B-eDP-1
[805.014986] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[805.025178] Starting dynamic subtest: pipe-C-eDP-1
[805.027078] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[805.036596] Starting dynamic subtest: pipe-D-eDP-1
[805.038498] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[805.040402] Subtest empty-lease: SUCCESS (0.018s)
[805.136974] [129/133] (264s left) i915_drm_fdinfo (memory-info-purgeable)
[805.180478] Starting subtest: memory-info-purgeable
[805.182787] Starting dynamic subtest: smem0
[808.200036] Dynamic subtest smem0: SUCCESS (3.024s)
[808.202266] Subtest memory-info-purgeable: SUCCESS (3.025s)
[808.276565] [130/133] (261s left) i915_query (query-topology-known-pci-ids)
[808.330193] Starting subtest: query-topology-known-pci-ids
[808.333922] Subtest query-topology-known-pci-ids: SKIP (0.000s)
[808.425895] [131/133] (260s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[808.539744] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[808.543321] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[808.634001] [132/133] (260s left) template (b)
[808.700163] Starting subtest: B
[808.702115] Subtest B: SUCCESS (0.000s)
[808.812618] [133/133] (260s left) kms_flip (2x-plain-flip-fb-recreate)
[808.913236] Starting subtest: 2x-plain-flip-fb-recreate
[808.925244] Subtest 2x-plain-flip-fb-recreate: SKIP (0.011s)
[809.002523] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_psr
results: parsing output: 4/ for test: gem_exec_fence
results: parsing output: 5/ for test: kms_plane_scaling
results: parsing output: 6/ for test: kms_psr2_sf
results: parsing output: 7/ for test: kms_psr
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_addfb_basic
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: kms_atomic
results: parsing output: 12/ for test: kms_psr
results: parsing output: 13/ for test: kms_getfb
results: parsing output: 14/ for test: gem_vm_create
results: parsing output: 15/ for test: kms_cursor_legacy
results: parsing output: 16/ for test: gem_workarounds
results: parsing output: 17/ for test: syncobj_timeline
results: parsing output: 18/ for test: kms_vblank
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: kms_cursor_legacy
results: parsing output: 21/ for test: syncobj_eventfd
results: parsing output: 22/ for test: gem_exec_reloc
results: parsing output: 23/ for test: i915_pm_rpm
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: gem_lmem_swapping
results: parsing output: 26/ for test: kms_atomic_transition
results: parsing output: 27/ for test: kms_plane
results: parsing output: 28/ for test: gem_partial_pwrite_pread
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: gem_busy
results: parsing output: 31/ for test: kms_big_fb
results: parsing output: 32/ for test: kms_chamelium_hpd
results: parsing output: 33/ for test: gem_render_copy
results: parsing output: 34/ for test: kms_ccs
results: parsing output: 35/ for test: gem_exec_flush
results: parsing output: 36/ for test: syncobj_wait
results: parsing output: 37/ for test: gem_ctx_persistence
results: parsing output: 38/ for test: kms_cursor_edge_walk
results: parsing output: 39/ for test: core_auth
results: parsing output: 40/ for test: gem_exec_reloc
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_color_pipeline
results: parsing output: 43/ for test: kms_universal_plane
results: parsing output: 44/ for test: kms_flip
results: parsing output: 45/ for test: i915_hangman
results: parsing output: 46/ for test: kms_ccs
results: parsing output: 47/ for test: perf_pmu
results: parsing output: 48/ for test: gem_workarounds
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_mmap_write_crc
results: parsing output: 52/ for test: api_intel_allocator
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: kms_joiner
results: parsing output: 55/ for test: kms_psr2_sf
results: parsing output: 56/ for test: kms_content_protection
results: parsing output: 57/ for test: gem_set_tiling_vs_blt
results: parsing output: 58/ for test: core_getversion
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: gem_userptr_blits
results: parsing output: 61/ for test: gen9_exec_parse
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_sync
results: parsing output: 64/ for test: gem_exec_balancer
results: parsing output: 65/ for test: syncobj_wait
results: parsing output: 66/ for test: kms_setmode
results: parsing output: 67/ for test: kms_vrr
results: parsing output: 68/ for test: gem_userptr_blits
results: parsing output: 69/ for test: gem_exec_big
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_chamelium_color
results: parsing output: 72/ for test: kms_psr2_sf
results: parsing output: 73/ for test: kms_cursor_legacy
results: parsing output: 74/ for test: sysfs_timeslice_duration
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_cursor_crc
results: parsing output: 77/ for test: kms_pm_rpm
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: gem_spin_batch
results: parsing output: 80/ for test: gem_eio
results: parsing output: 81/ for test: gem_exec_params
results: parsing output: 82/ for test: gem_ctx_shared
results: parsing output: 83/ for test: gem_exec_params
results: parsing output: 84/ for test: syncobj_timeline
results: parsing output: 85/ for test: syncobj_timeline
results: parsing output: 86/ for test: kms_rotation_crc
results: parsing output: 87/ for test: gem_mmap_offset
results: parsing output: 88/ for test: tools_test
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_plane
results: parsing output: 91/ for test: kms_pm_backlight
results: parsing output: 92/ for test: i915_pm_rps
results: parsing output: 93/ for test: gem_exec_whisper
results: parsing output: 94/ for test: gem_mmap_gtt
results: parsing output: 95/ for test: kms_chamelium_edid
results: parsing output: 96/ for test: gem_ctx_persistence
results: parsing output: 97/ for test: kms_cursor_legacy
results: parsing output: 98/ for test: gem_render_copy
results: parsing output: 99/ for test: perf
results: parsing output: 100/ for test: kms_cursor_crc
results: parsing output: 101/ for test: kms_ccs
results: parsing output: 102/ for test: kms_psr
results: parsing output: 103/ for test: gem_mmap_wc
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: prime_vgem
results: parsing output: 107/ for test: kms_big_fb
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: gem_fenced_exec_thrash
results: parsing output: 110/ for test: kms_fbcon_fbt
results: parsing output: 111/ for test: gem_huc_copy
results: parsing output: 112/ for test: gem_exec_reloc
results: parsing output: 113/ for test: kms_flip_scaled_crc
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_flip_event_leak
results: parsing output: 116/ for test: gem_close_race
results: parsing output: 117/ for test: perf
results: parsing output: 118/ for test: gem_eio
results: parsing output: 119/ for test: kms_cursor_legacy
results: parsing output: 120/ for test: kms_draw_crc
results: parsing output: 121/ for test: kms_busy
results: parsing output: 122/ for test: gem_exec_schedule
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_plane_scaling
results: parsing output: 125/ for test: gem_exec_schedule
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_lease
results: parsing output: 128/ for test: i915_drm_fdinfo
results: parsing output: 129/ for test: i915_query
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: template
results: parsing output: 132/ for test: kms_flip
Done.