[56.383506] Initializing watchdogs
[56.383553]   /dev/watchdog0
[56.397928] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[56.401744] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.403861] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.407145] [001/133] (960s left) gem_exec_schedule (pi-common)
[56.606067] Starting subtest: pi-common
[56.608299] Starting dynamic subtest: rcs0
[56.649729] Dynamic subtest rcs0: SUCCESS (0.048s)
[56.658616] Starting dynamic subtest: bcs0
[56.682091] Dynamic subtest bcs0: SUCCESS (0.033s)
[56.689297] Starting dynamic subtest: vcs0
[56.713226] Dynamic subtest vcs0: SUCCESS (0.031s)
[56.721173] Starting dynamic subtest: vcs1
[56.744200] Dynamic subtest vcs1: SUCCESS (0.032s)
[56.751441] Starting dynamic subtest: vecs0
[56.774413] Dynamic subtest vecs0: SUCCESS (0.030s)
[56.781646] Starting dynamic subtest: ccs0
[56.805411] Dynamic subtest ccs0: SUCCESS (0.031s)
[56.807672] Subtest pi-common: SUCCESS (0.207s)
[57.036926] [FACT gem_exec_schedule (pi-common)] new: kernel.kmod_is_loaded.vgem: true
[57.043015] [002/133] (959s left) kms_fbcon_fbt (fbc-suspend)
[57.102216] Starting subtest: fbc-suspend
[106.514054] Subtest fbc-suspend: SUCCESS (19.305s)
[107.847477] [003/133] (909s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[107.909083] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[107.967603] [004/133] (909s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[108.038013] Starting subtest: async-flip-with-page-flip-events-tiled
[108.405842] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[111.144981] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.775s)
[111.156617] Starting dynamic subtest: pipe-A-eDP-1-4
[113.345899] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.222s)
[113.354313] Starting dynamic subtest: pipe-A-eDP-1-4
[115.359254] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.027s)
[115.371329] Starting dynamic subtest: pipe-A-eDP-1-x
[117.532419] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.186s)
[117.919061] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[120.700464] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.801s)
[120.709686] Starting dynamic subtest: pipe-B-eDP-1-4
[122.878290] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.184s)
[122.889779] Starting dynamic subtest: pipe-B-eDP-1-4
[124.892949] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.019s)
[124.902024] Starting dynamic subtest: pipe-B-eDP-1-x
[127.078497] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[127.439561] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[130.203084] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.775s)
[130.215436] Starting dynamic subtest: pipe-C-eDP-1-4
[132.374977] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s)
[132.386161] Starting dynamic subtest: pipe-C-eDP-1-4
[134.382443] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[134.393870] Starting dynamic subtest: pipe-C-eDP-1-x
[136.581853] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.201s)
[136.956243] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[139.719295] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.770s)
[139.731238] Starting dynamic subtest: pipe-D-eDP-1-4
[141.883596] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.162s)
[141.893283] Starting dynamic subtest: pipe-D-eDP-1-4
[143.893709] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[143.902376] Starting dynamic subtest: pipe-D-eDP-1-x
[146.073975] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.179s)
[146.076484] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.165s)
[147.223689] [005/133] (869s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[147.291469] Starting subtest: fbc-psr-sprite-mmap-gtt
[147.293820] Starting dynamic subtest: eDP-1
[147.298202] Dynamic subtest eDP-1: SKIP (0.000s)
[147.302619] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.000s)
[147.370715] [006/133] (869s left) gem_ctx_persistence (engines-cleanup)
[147.444279] Starting subtest: engines-cleanup
[147.446663] Starting dynamic subtest: rcs0
[147.485998] Dynamic subtest rcs0: SUCCESS (0.044s)
[147.496688] Starting dynamic subtest: bcs0
[147.553764] Dynamic subtest bcs0: SUCCESS (0.067s)
[147.565039] Starting dynamic subtest: vcs0
[147.574665] Dynamic subtest vcs0: SUCCESS (0.020s)
[147.582571] Starting dynamic subtest: vcs1
[147.633672] Dynamic subtest vcs1: SUCCESS (0.059s)
[147.645500] Starting dynamic subtest: vecs0
[147.668755] Dynamic subtest vecs0: SUCCESS (0.034s)
[147.678541] Starting dynamic subtest: ccs0
[147.711192] Dynamic subtest ccs0: SUCCESS (0.041s)
[147.713935] Subtest engines-cleanup: SUCCESS (0.270s)
[147.788524] [007/133] (869s left) kms_flip (2x-modeset-vs-vblank-race)
[147.861981] Starting subtest: 2x-modeset-vs-vblank-race
[147.869682] Subtest 2x-modeset-vs-vblank-race: SKIP (0.007s)
[147.948738] [008/133] (869s left) kms_psr (fbc-pr-no-drrs)
[148.013103] Starting subtest: fbc-pr-no-drrs
[148.017146] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[148.085868] [009/133] (869s left) syncobj_eventfd (binary-wait-signaled)
[148.144213] Starting subtest: binary-wait-signaled
[148.146589] Subtest binary-wait-signaled: SUCCESS (0.000s)
[148.232112] [010/133] (869s left) gem_userptr_blits (create-destroy-sync)
[148.287870] Starting subtest: create-destroy-sync
[153.305187] Subtest create-destroy-sync: SUCCESS (5.015s)
[153.440000] [011/133] (863s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[153.536390] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[153.540834] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[153.681379] [012/133] (863s left) gem_exec_async (concurrent-writes)
[153.744072] Starting subtest: concurrent-writes
[153.746565] Starting dynamic subtest: rcs0
[153.760068] Dynamic subtest rcs0: SUCCESS (0.016s)
[153.770173] Starting dynamic subtest: bcs0
[153.772959] Dynamic subtest bcs0: SUCCESS (0.007s)
[153.782124] Starting dynamic subtest: vcs0
[153.784343] Dynamic subtest vcs0: SUCCESS (0.005s)
[153.793186] Starting dynamic subtest: vcs1
[153.795015] Dynamic subtest vcs1: SUCCESS (0.007s)
[153.803961] Starting dynamic subtest: vecs0
[153.805869] Dynamic subtest vecs0: SUCCESS (0.005s)
[153.814227] Starting dynamic subtest: ccs0
[153.816147] Dynamic subtest ccs0: SUCCESS (0.005s)
[153.818063] Subtest concurrent-writes: SUCCESS (0.046s)
[154.023180] [013/133] (863s left) gem_wait (write-busy)
[154.084770] Starting subtest: write-busy
[154.087166] Starting dynamic subtest: all-engines
[154.668383] Dynamic subtest all-engines: SUCCESS (0.583s)
[154.685291] Starting dynamic subtest: rcs0
[155.219327] Dynamic subtest rcs0: SUCCESS (0.551s)
[155.235483] Starting dynamic subtest: bcs0
[155.767586] Dynamic subtest bcs0: SUCCESS (0.548s)
[155.784426] Starting dynamic subtest: vcs0
[157.606952] Dynamic subtest vcs0: SUCCESS (1.838s)
[157.622967] Starting dynamic subtest: vcs1
[159.590158] Dynamic subtest vcs1: SUCCESS (1.983s)
[159.605719] Starting dynamic subtest: vecs0
[161.574500] Dynamic subtest vecs0: SUCCESS (1.983s)
[161.590181] Starting dynamic subtest: ccs0
[162.123943] Dynamic subtest ccs0: SUCCESS (0.550s)
[162.126388] Subtest write-busy: SUCCESS (8.039s)
[162.321039] [014/133] (855s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[162.410381] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[162.414457] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[162.495684] [015/133] (854s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[162.578473] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[166.675730] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (4.103s)
[167.842357] [016/133] (849s left) gem_workarounds (suspend-resume-context)
[167.909602] Starting subtest: suspend-resume-context
[184.437627] Subtest suspend-resume-context: SUCCESS (1.202s)
[184.568531] [017/133] (833s left) gem_exec_parallel (userptr)
[184.637447] Starting subtest: userptr
[184.639913] Starting dynamic subtest: rcs0
[186.029605] Dynamic subtest rcs0: SUCCESS (1.423s)
[186.040860] Starting dynamic subtest: bcs0
[187.453790] Dynamic subtest bcs0: SUCCESS (1.456s)
[187.465701] Starting dynamic subtest: vcs0
[188.950553] Dynamic subtest vcs0: SUCCESS (1.522s)
[188.962145] Starting dynamic subtest: vcs1
[190.915175] Dynamic subtest vcs1: SUCCESS (1.993s)
[190.927848] Starting dynamic subtest: vecs0
[192.899040] Dynamic subtest vecs0: SUCCESS (2.006s)
[192.908039] Starting dynamic subtest: ccs0
[194.360131] Dynamic subtest ccs0: SUCCESS (1.474s)
[194.362695] Subtest userptr: SUCCESS (9.879s)
[194.562465] [018/133] (823s left) gem_exec_capture (capture-invisible)
[194.626454] Starting subtest: capture-invisible
[194.628907] Starting dynamic subtest: smem0
[194.633374] Dynamic subtest smem0: SKIP (0.000s)
[194.638039] Subtest capture-invisible: SKIP (0.000s)
[194.725803] [019/133] (822s left) kms_big_fb (linear-64bpp-rotate-90)
[194.812557] Starting subtest: linear-64bpp-rotate-90
[194.831460] Subtest linear-64bpp-rotate-90: SKIP (0.018s)
[194.940582] [020/133] (822s left) i915_hangman (engine-engine-error)
[195.000120] Starting subtest: engine-engine-error
[195.002481] Starting dynamic subtest: rcs0
[196.898468] Dynamic subtest rcs0: SUCCESS (1.910s)
[196.909359] Starting dynamic subtest: bcs0
[198.881484] Dynamic subtest bcs0: SUCCESS (1.993s)
[198.891829] Starting dynamic subtest: vcs0
[200.929956] Dynamic subtest vcs0: SUCCESS (2.056s)
[200.942649] Starting dynamic subtest: vcs1
[202.913827] Dynamic subtest vcs1: SUCCESS (1.988s)
[202.926511] Starting dynamic subtest: vecs0
[204.897506] Dynamic subtest vecs0: SUCCESS (1.988s)
[204.910160] Starting dynamic subtest: ccs0
[206.881817] Dynamic subtest ccs0: SUCCESS (1.987s)
[206.884823] Subtest engine-engine-error: SUCCESS (11.930s)
[206.960363] [021/133] (810s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[207.042859] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[207.045264] Starting dynamic subtest: pipe-A-eDP-1
[207.103168] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s)
[207.414686] Starting dynamic subtest: pipe-B-eDP-1
[208.190119] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.785s)
[208.484950] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.444s)
[209.358528] [022/133] (808s left) gem_exec_whisper (basic-fds-forked-all)
[209.419854] Starting subtest: basic-fds-forked-all
[229.234940] Subtest basic-fds-forked-all: SUCCESS (19.812s)
[229.415806] [023/133] (788s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[229.511357] Starting subtest: 4-tiled-64bpp-rotate-270
[229.530029] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.018s)
[229.629426] [024/133] (788s left) gem_lmem_swapping (parallel-random-engines)
[229.670479] Subtest parallel-random-engines: SKIP (0.000s)
[229.708467] [025/133] (788s left) kms_cursor_crc (cursor-onscreen-max-size)
[229.988605] Starting subtest: cursor-onscreen-max-size
[229.994959] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[230.125650] [026/133] (787s left) syncobj_timeline (reset-signaled)
[230.171793] Starting subtest: reset-signaled
[230.174090] Subtest reset-signaled: SUCCESS (0.000s)
[230.252185] [027/133] (787s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[230.333090] Starting subtest: fbc-shrfb-scaledprimary
[233.309671] Subtest fbc-shrfb-scaledprimary: SUCCESS (2.980s)
[234.424575] [028/133] (783s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt)
[234.497957] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt
[234.502087] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[234.591627] [029/133] (783s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs)
[234.660096] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs
[234.661866] Starting dynamic subtest: pipe-A-eDP-1
[267.671676] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.935s)
[267.681968] Starting dynamic subtest: pipe-B-eDP-1
[300.570370] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.756s)
[300.580200] Starting dynamic subtest: pipe-C-eDP-1
[333.584434] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.705s)
[333.594856] Starting dynamic subtest: pipe-D-eDP-1
[366.587727] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.710s)
[366.590103] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (14.110s)
[367.738207] [030/133] (650s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[367.823010] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu
[371.997271] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.252s)
[373.166432] [031/133] (645s left) perf_pmu (faulting-read)
[373.227734] Starting subtest: faulting-read
[373.230318] Starting dynamic subtest: wb
[373.232630] Dynamic subtest wb: SUCCESS (0.001s)
[373.243445] Starting dynamic subtest: wc
[373.245294] Dynamic subtest wc: SUCCESS (0.000s)
[373.254519] Starting dynamic subtest: uc
[373.256407] Dynamic subtest uc: SUCCESS (0.000s)
[373.258278] Subtest faulting-read: SUCCESS (0.003s)
[373.345879] [032/133] (644s left) gem_eio (wait-wedge-1us)
[373.553828] Starting subtest: wait-wedge-1us
[375.073263] Subtest wait-wedge-1us: SUCCESS (1.535s)
[375.194938] [033/133] (643s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[375.560750] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[376.409483] [034/133] (641s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[376.488505] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[377.318096] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.837s)
[377.470471] [035/133] (640s left) kms_color (degamma)
[377.538022] Starting subtest: degamma
[377.540270] Starting dynamic subtest: pipe-A-eDP-1
[378.281299] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.748s)
[378.291928] Starting dynamic subtest: pipe-B-eDP-1
[379.733259] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.458s)
[379.746452] Starting dynamic subtest: pipe-C-eDP-1
[381.114203] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.388s)
[381.125275] Starting dynamic subtest: pipe-D-eDP-1
[382.456029] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.345s)
[382.458389] Subtest degamma: SUCCESS (4.942s)
[383.261932] [036/133] (635s left) kms_prop_blob (basic)
[383.330825] Starting subtest: basic
[383.332855] Subtest basic: SUCCESS (0.000s)
[383.414158] [037/133] (635s left) prime_vgem (basic-read)
[383.480810] Starting subtest: basic-read
[383.517639] Subtest basic-read: SKIP (0.034s)
[383.644144] [038/133] (634s left) kms_vblank (wait-idle-hang)
[383.715107] Starting subtest: wait-idle-hang
[383.717383] Starting dynamic subtest: pipe-A-eDP-1
[409.817782] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.135s)
[409.832803] Starting dynamic subtest: pipe-D-eDP-1
[434.839735] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.030s)
[434.842187] Subtest wait-idle-hang: SUCCESS (51.170s)
[435.663904] [039/133] (582s left) syncobj_wait (wait-zero-handles)
[435.726539] Starting subtest: wait-zero-handles
[435.728469] Subtest wait-zero-handles: SUCCESS (0.000s)
[435.829458] [040/133] (582s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping)
[435.915611] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping
[435.919680] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[436.006402] [041/133] (582s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[436.096519] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[436.103021] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.008s)
[436.180321] [042/133] (582s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[436.258112] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[436.262144] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[436.350805] [043/133] (582s left) gem_create (busy-create)
[436.404990] Starting subtest: busy-create
[436.407354] Starting dynamic subtest: smem0
[470.038318] Dynamic subtest smem0: SUCCESS (33.620s)
[470.041130] Subtest busy-create: SUCCESS (33.621s)
[470.228580] [044/133] (548s left) gem_exec_fence (syncobj-repeat)
[470.696714] Starting subtest: syncobj-repeat
[470.883883] Subtest syncobj-repeat: SUCCESS (0.185s)
[472.087012] [045/133] (546s left) gem_exec_balancer (fairslice)
[472.153370] Starting subtest: fairslice
[475.061895] Subtest fairslice: SUCCESS (2.901s)
[475.375198] [046/133] (543s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[475.458504] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[479.205293] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.747s)
[480.387173] [047/133] (538s left) perf (short-reads)
[480.513966] Starting subtest: short-reads
[480.528022] Subtest short-reads: SUCCESS (0.015s)
[480.573410] [048/133] (538s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[480.626064] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[480.732456] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.106s)
[480.807835] [049/133] (538s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[480.899057] Starting subtest: pr-overlay-plane-move-continuous-sf
[480.903114] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[480.980361] [050/133] (537s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[481.063933] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-cpu
[487.740663] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.674s)
[487.876135] [051/133] (531s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[487.969764] Starting subtest: x-tiled-8bpp-rotate-180
[489.195470] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.225s)
[489.351774] [052/133] (529s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[489.434181] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[489.438155] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[489.532695] [053/133] (529s left) kms_psr (psr2-cursor-plane-move)
[489.615668] Starting subtest: psr2-cursor-plane-move
[489.617658] Starting dynamic subtest: eDP-1
[491.282691] Dynamic subtest eDP-1: SUCCESS (1.665s)
[491.284852] Subtest psr2-cursor-plane-move: SUCCESS (1.666s)
[492.072106] [054/133] (527s left) kms_pm_dc (dc5-retention-flops)
[493.153270] Starting subtest: dc5-retention-flops
[493.157593] Subtest dc5-retention-flops: SKIP (0.000s)
[493.234113] [055/133] (525s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[493.598187] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[494.390708] [056/133] (524s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[494.437647] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[494.540852] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.102s)
[494.619263] [057/133] (524s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[494.717534] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[494.721807] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[494.827518] [058/133] (524s left) kms_getfb (getfb-addfb-different-handles)
[494.901694] Starting subtest: getfb-addfb-different-handles
[494.904038] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[495.019615] [059/133] (524s left) gem_exec_schedule (submit-golden-slice)
[495.090698] Starting subtest: submit-golden-slice
[495.092620] Starting dynamic subtest: rcs0
[495.117680] Dynamic subtest rcs0: SUCCESS (0.034s)
[495.128748] Starting dynamic subtest: bcs0
[495.156109] Dynamic subtest bcs0: SUCCESS (0.038s)
[495.167299] Starting dynamic subtest: vcs0
[495.194284] Dynamic subtest vcs0: SUCCESS (0.037s)
[495.204856] Starting dynamic subtest: vcs1
[495.232562] Dynamic subtest vcs1: SUCCESS (0.038s)
[495.242524] Starting dynamic subtest: vecs0
[495.267308] Dynamic subtest vecs0: SUCCESS (0.034s)
[495.277452] Starting dynamic subtest: ccs0
[495.311382] Dynamic subtest ccs0: SUCCESS (0.043s)
[495.313620] Subtest submit-golden-slice: SUCCESS (0.229s)
[497.149727] [060/133] (522s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[497.223466] Starting subtest: compare-crc-sanitycheck-xr24
[497.225354] Starting dynamic subtest: pipe-A-eDP-1
[497.854110] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.631s)
[497.865509] Starting dynamic subtest: pipe-B-eDP-1
[499.068167] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.213s)
[499.079453] Starting dynamic subtest: pipe-C-eDP-1
[500.248351] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.175s)
[500.260085] Starting dynamic subtest: pipe-D-eDP-1
[501.489373] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.241s)
[501.491728] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.266s)
[502.342418] [061/133] (517s left) sw_sync (sync_multi_producer_single_consumer)
[502.381922] Starting subtest: sync_multi_producer_single_consumer
[503.455776] Subtest sync_multi_producer_single_consumer: SUCCESS (1.075s)
[503.519888] [062/133] (515s left) gem_mmap_wc (close)
[503.570401] Subtest close: SKIP (0.000s)
[503.631902] [063/133] (515s left) gem_exec_params (invalid-fence-in)
[503.680425] Starting subtest: invalid-fence-in
[503.682784] Subtest invalid-fence-in: SUCCESS (0.000s)
[503.789084] [064/133] (515s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs)
[503.856688] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs
[503.858994] Starting dynamic subtest: pipe-A-eDP-1
[503.878617] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[503.891534] Starting dynamic subtest: pipe-B-eDP-1
[503.910304] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[503.920073] Starting dynamic subtest: pipe-C-eDP-1
[503.938737] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[503.948279] Starting dynamic subtest: pipe-D-eDP-1
[503.966734] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[503.968861] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.006s)
[506.105593] [065/133] (513s left) kms_busy (extended-pageflip-hang-oldfb)
[506.175405] Starting subtest: extended-pageflip-hang-oldfb
[506.177783] Starting dynamic subtest: pipe-A
[506.567804] Dynamic subtest pipe-A: SUCCESS (0.391s)
[506.578615] Starting dynamic subtest: pipe-D
[507.721132] Dynamic subtest pipe-D: SUCCESS (1.150s)
[507.723275] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.546s)
[508.547448] [066/133] (511s left) gen9_exec_parse (batch-invalid-length)
[508.617662] Subtest batch-invalid-length: SKIP (0.000s)
[508.690191] [067/133] (511s left) gem_render_copy (y-tiled-to-vebox-linear)
[508.744513] Starting subtest: y-tiled-to-vebox-linear
[508.749091] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[508.942318] [068/133] (510s left) syncobj_timeline (single-wait-available-signaled)
[508.983775] Starting subtest: single-wait-available-signaled
[508.985936] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[509.073501] [069/133] (510s left) gem_exec_reloc (basic-gtt-read)
[509.126934] Subtest basic-gtt-read: SKIP (0.000s)
[509.238586] [070/133] (510s left) gem_exec_reloc (basic-wc-gtt)
[509.295159] Subtest basic-wc-gtt: SKIP (0.000s)
[509.364146] [071/133] (510s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[509.429270] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[509.431063] Starting dynamic subtest: pipe-A-eDP-1
[510.130025] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.696s)
[510.139619] Starting dynamic subtest: pipe-B-eDP-1
[511.847326] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.714s)
[511.859050] Starting dynamic subtest: pipe-C-eDP-1
[513.590120] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.743s)
[513.602349] Starting dynamic subtest: pipe-D-eDP-1
[515.321306] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.730s)
[515.323304] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.887s)
[516.461688] [072/133] (503s left) kms_prop_blob (invalid-get-prop)
[516.533121] Starting subtest: invalid-get-prop
[516.535434] Subtest invalid-get-prop: SUCCESS (0.000s)
[516.623934] [073/133] (503s left) i915_drm_fdinfo (all-busy-check-all)
[516.667498] Starting subtest: all-busy-check-all
[516.671593] Subtest all-busy-check-all: SKIP (0.004s)
[516.741151] [074/133] (503s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[516.827674] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[521.261719] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.437s)
[522.483616] [075/133] (497s left) gem_basic (multigpu-create-close)
[522.539030] Starting subtest: multigpu-create-close
[522.543446] Subtest multigpu-create-close: SKIP (0.000s)
[522.642708] [076/133] (497s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[522.723234] Starting subtest: flip-primary-invalidate-overlay
[534.350597] Subtest flip-primary-invalidate-overlay: SUCCESS (11.628s)
[534.500836] [077/133] (485s left) vgem_basic (unload)
[534.540133] Starting subtest: unload
[563.646827] Subtest unload: SUCCESS (29.103s)
[563.759973] [078/133] (456s left) gem_mmap_gtt (cpuset-big-copy-odd)
[563.813752] Subtest cpuset-big-copy-odd: SKIP (0.000s)
[563.879604] [079/133] (456s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[563.971636] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[570.974244] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.006s)
[571.088796] [080/133] (449s left) i915_pm_rps (reset)
[571.157517] Starting subtest: reset
[579.608504] Subtest reset: SUCCESS (8.448s)
[579.721346] [081/133] (440s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping)
[579.794777] Starting subtest: pixel-format-y-tiled-modifier-source-clamping
[579.799194] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s)
[579.868596] [082/133] (440s left) i915_query (query-regions-sanity-check)
[579.923188] Starting subtest: query-regions-sanity-check
[579.931448] Subtest query-regions-sanity-check: SUCCESS (0.012s)
[580.022631] [083/133] (440s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[580.067674] Starting subtest: invalid-multi-wait-unsubmitted
[580.069927] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[580.166201] [084/133] (440s left) kms_flip (2x-flip-vs-rmfb)
[580.246151] Starting subtest: 2x-flip-vs-rmfb
[580.252654] Subtest 2x-flip-vs-rmfb: SKIP (0.008s)
[580.332596] [085/133] (440s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[580.408351] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[587.286509] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.881s)
[587.406252] [086/133] (433s left) gem_spin_batch (spin-all)
[587.471799] Starting subtest: spin-all
[587.486549] Subtest spin-all: SUCCESS (0.013s)
[589.057528] [087/133] (431s left) kms_dp_link_training (uhbr-mst)
[589.124255] Starting subtest: uhbr-mst
[589.133049] Subtest uhbr-mst: SKIP (0.000s)
[589.201307] [088/133] (431s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[589.284295] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[589.288552] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[589.370948] [089/133] (431s left) gem_exec_reloc (basic-gtt)
[589.433722] Subtest basic-gtt: SKIP (0.000s)
[589.510645] [090/133] (431s left) api_intel_bb (blit-noreloc-keep-cache)
[589.572616] Starting subtest: blit-noreloc-keep-cache
[589.578787] Subtest blit-noreloc-keep-cache: SUCCESS (0.010s)
[589.685266] [091/133] (431s left) kms_getfb (getfb-handle-protection)
[589.767708] Starting subtest: getfb-handle-protection
[589.786561] Subtest getfb-handle-protection: SUCCESS (0.019s)
[589.911375] [092/133] (430s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[590.011560] Starting subtest: cursorB-vs-flipB-atomic
[590.015170] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[590.158082] [093/133] (430s left) syncobj_wait (single-wait-for-submit-submitted)
[590.205365] Starting subtest: single-wait-for-submit-submitted
[590.309323] Subtest single-wait-for-submit-submitted: SUCCESS (0.102s)
[590.384389] [094/133] (430s left) kms_atomic (plane-invalid-params-fence)
[590.458529] Starting subtest: plane-invalid-params-fence
[590.460870] Starting dynamic subtest: pipe-A-eDP-1
[590.819929] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.359s)
[590.821966] Subtest plane-invalid-params-fence: SUCCESS (0.360s)
[591.618884] [095/133] (429s left) kms_cursor_edge_walk (256x256-top-edge)
[591.696157] Starting subtest: 256x256-top-edge
[591.698692] Starting dynamic subtest: pipe-A-eDP-1
[595.185859] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.489s)
[595.197191] Starting dynamic subtest: pipe-D-eDP-1
[598.322895] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.135s)
[598.325283] Subtest 256x256-top-edge: SUCCESS (6.627s)
[599.118143] [096/133] (421s left) kms_plane_multiple (2x-tiling-4)
[599.199423] Starting subtest: 2x-tiling-4
[599.203795] Subtest 2x-tiling-4: SKIP (0.000s)
[599.276650] [097/133] (421s left) gem_exec_reloc (basic-write-wc)
[599.325274] Subtest basic-write-wc: SKIP (0.000s)
[599.401892] [098/133] (421s left) kms_fb_coherency (memset-crc)
[599.477194] Starting subtest: memset-crc
[599.479599] Starting dynamic subtest: mmap-offset-wc
[599.911780] Dynamic subtest mmap-offset-wc: SUCCESS (0.433s)
[600.216726] Starting dynamic subtest: mmap-offset-uc
[606.327477] Dynamic subtest mmap-offset-uc: SUCCESS (6.126s)
[606.618796] Subtest memset-crc: SUCCESS (7.142s)
[607.480768] [099/133] (413s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[607.561354] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[611.171943] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.614s)
[612.303522] [100/133] (408s left) kms_addfb_basic (invalid-get-prop)
[612.377954] Starting subtest: invalid-get-prop
[612.380327] Subtest invalid-get-prop: SUCCESS (0.000s)
[612.513127] [101/133] (408s left) gem_ctx_persistence (saturated-hostile)
[612.575770] Starting subtest: saturated-hostile
[612.577975] Starting dynamic subtest: rcs0
[613.363861] Dynamic subtest rcs0: SUCCESS (0.787s)
[613.377516] Starting dynamic subtest: bcs0
[614.157336] Dynamic subtest bcs0: SUCCESS (0.791s)
[614.170987] Starting dynamic subtest: vcs0
[614.954518] Dynamic subtest vcs0: SUCCESS (0.796s)
[614.968933] Starting dynamic subtest: vcs1
[615.752509] Dynamic subtest vcs1: SUCCESS (0.796s)
[615.765762] Starting dynamic subtest: vecs0
[616.556265] Dynamic subtest vecs0: SUCCESS (0.799s)
[616.567512] Starting dynamic subtest: ccs0
[617.383486] Dynamic subtest ccs0: SUCCESS (0.829s)
[617.386016] Subtest saturated-hostile: SUCCESS (4.809s)
[617.467004] [102/133] (403s left) gem_exec_params (no-vebox)
[617.532155] Starting subtest: no-vebox
[617.534478] Subtest no-vebox: SUCCESS (0.003s)
[619.125024] [103/133] (402s left) kms_content_protection (lic-type-1)
[619.242023] Starting subtest: lic-type-1
[619.246566] Subtest lic-type-1: SKIP (0.000s)
[619.369198] [104/133] (401s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move)
[619.449394] Starting subtest: fbc-1p-primscrn-cur-indfb-move
[623.575278] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.129s)
[624.789002] [105/133] (396s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[625.014350] Starting subtest: cursor-rapid-movement-256x85
[625.059421] Subtest cursor-rapid-movement-256x85: SKIP (0.039s)
[625.215688] [106/133] (396s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[625.285430] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[625.287719] Starting dynamic subtest: pipe-A
[625.307634] Dynamic subtest pipe-A: SKIP (0.017s)
[625.319038] Starting dynamic subtest: pipe-B
[625.336265] Dynamic subtest pipe-B: SKIP (0.029s)
[625.347279] Starting dynamic subtest: pipe-C
[625.364631] Dynamic subtest pipe-C: SKIP (0.028s)
[625.375060] Starting dynamic subtest: pipe-D
[625.394379] Dynamic subtest pipe-D: SKIP (0.028s)
[625.398373] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.105s)
[625.479176] [107/133] (395s left) gem_pxp (reject-modify-context-protection-off-2)
[625.618595] Starting subtest: reject-modify-context-protection-off-2
[625.621049] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s)
[625.742937] [108/133] (395s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[625.811090] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[625.814765] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[625.907592] [109/133] (395s left) kms_invalid_mode (bad-vtotal)
[625.986480] Starting subtest: bad-vtotal
[625.988411] Starting dynamic subtest: pipe-A-eDP-1
[626.271696] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[626.286801] Starting dynamic subtest: pipe-B-eDP-1
[626.288720] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[626.299012] Starting dynamic subtest: pipe-C-eDP-1
[626.301286] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[626.311270] Starting dynamic subtest: pipe-D-eDP-1
[626.313927] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[626.316590] Subtest bad-vtotal: SUCCESS (0.293s)
[627.115057] [110/133] (394s left) gem_mmap (basic-small-bo)
[627.181496] Subtest basic-small-bo: SKIP (0.000s)
[627.246778] [111/133] (394s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[627.337407] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu
[627.341663] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[627.448580] [112/133] (394s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[627.541074] Starting subtest: cursorA-vs-flipA-atomic
[638.677875] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.139s)
[639.531904] [113/133] (382s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[639.602272] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[639.604418] Starting dynamic subtest: pipe-A-eDP-1
[639.625849] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[639.638342] Starting dynamic subtest: pipe-B-eDP-1
[639.659132] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[639.669419] Starting dynamic subtest: pipe-C-eDP-1
[639.689895] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[639.699693] Starting dynamic subtest: pipe-D-eDP-1
[639.720236] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[639.724372] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[641.898554] [114/133] (379s left) vgem_basic (mmap)
[641.938163] Starting subtest: mmap
[641.966373] Subtest mmap: SUCCESS (0.030s)
[642.018799] [115/133] (379s left) gem_mmap_gtt (isolation)
[642.067233] Subtest isolation: SKIP (0.000s)
[642.133045] [116/133] (379s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[642.206748] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[642.209038] Starting dynamic subtest: pipe-A-eDP-1
[642.231417] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[642.244506] Starting dynamic subtest: pipe-B-eDP-1
[642.264994] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[642.274460] Starting dynamic subtest: pipe-C-eDP-1
[642.295545] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[642.304985] Starting dynamic subtest: pipe-D-eDP-1
[642.326468] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[642.330641] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.008s)
[644.483487] [117/133] (377s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[644.569608] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[644.574154] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[644.654230] [118/133] (377s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[644.728289] Starting subtest: plane-all-transition-nonblocking-fencing
[644.730511] Starting dynamic subtest: pipe-A-eDP-1
[647.222628] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[647.536604] Starting dynamic subtest: pipe-B-eDP-1
[650.726780] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.205s)
[651.029277] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.300s)
[651.854594] [119/133] (370s left) api_intel_bb (render)
[651.911912] Starting subtest: render
[651.913791] Starting dynamic subtest: render-none-512
[652.008921] Dynamic subtest render-none-512: SUCCESS (0.098s)
[652.021278] Starting dynamic subtest: render-none-1024
[652.375597] Dynamic subtest render-none-1024: SUCCESS (0.363s)
[652.387047] Starting dynamic subtest: render-x-512
[652.487552] Dynamic subtest render-x-512: SUCCESS (0.111s)
[652.500440] Starting dynamic subtest: render-x-1024
[652.821836] Dynamic subtest render-x-1024: SUCCESS (0.333s)
[652.834897] Starting dynamic subtest: render-y-512
[652.906159] Dynamic subtest render-y-512: SUCCESS (0.084s)
[652.919273] Starting dynamic subtest: render-y-1024
[653.251716] Dynamic subtest render-y-1024: SUCCESS (0.344s)
[653.254278] Subtest render: SUCCESS (1.341s)
[653.370346] [120/133] (368s left) kms_sequence (queue-busy)
[653.453193] Starting subtest: queue-busy
[653.455596] Starting dynamic subtest: pipe-A-eDP-1
[655.391744] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.940s)
[655.403773] Starting dynamic subtest: pipe-B-eDP-1
[657.972344] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.578s)
[657.983773] Starting dynamic subtest: pipe-C-eDP-1
[660.567829] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.593s)
[660.579402] Starting dynamic subtest: pipe-D-eDP-1
[663.126730] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.558s)
[663.129058] Subtest queue-busy: SUCCESS (9.674s)
[663.990090] [121/133] (358s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[664.082465] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip
[664.087050] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[664.184637] [122/133] (357s left) kms_flip (flip-vs-fences-interruptible)
[664.269036] Starting subtest: flip-vs-fences-interruptible
[664.273565] Subtest flip-vs-fences-interruptible: SKIP (0.000s)
[664.366287] [123/133] (357s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[664.420183] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted
[664.548917] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SUCCESS (0.131s)
[664.656998] [124/133] (357s left) gem_exec_flush (basic-uc-ro-default)
[664.716417] Starting subtest: basic-uc-ro-default
[670.175540] Subtest basic-uc-ro-default: SUCCESS (5.459s)
[670.367825] [125/133] (351s left) perf_pmu (semaphore-busy)
[670.401873] Starting subtest: semaphore-busy
[670.404546] Starting dynamic subtest: rcs0
[672.055506] Dynamic subtest rcs0: SUCCESS (1.650s)
[672.068775] Starting dynamic subtest: bcs0
[673.692162] Dynamic subtest bcs0: SUCCESS (1.633s)
[673.704020] Starting dynamic subtest: vcs0
[677.522429] Dynamic subtest vcs0: SUCCESS (3.828s)
[677.533302] Starting dynamic subtest: vcs1
[683.538979] Dynamic subtest vcs1: SUCCESS (6.013s)
[683.549924] Starting dynamic subtest: vecs0
[689.555674] Dynamic subtest vecs0: SUCCESS (6.015s)
[689.569084] Starting dynamic subtest: ccs0
[692.629771] Dynamic subtest ccs0: SUCCESS (3.069s)
[692.632453] Subtest semaphore-busy: SUCCESS (22.224s)
[692.746044] [126/133] (329s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[692.824727] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[692.829499] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.000s)
[692.897117] [127/133] (329s left) kms_psr (fbc-psr2-no-drrs)
[692.970413] Starting subtest: fbc-psr2-no-drrs
[692.972683] Starting dynamic subtest: eDP-1
[692.976796] Dynamic subtest eDP-1: SKIP (0.000s)
[692.980869] Subtest fbc-psr2-no-drrs: SKIP (0.001s)
[693.061060] [128/133] (329s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[693.129234] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[693.131476] Starting dynamic subtest: pipe-A-default-mode
[695.824696] Dynamic subtest pipe-A-default-mode: SUCCESS (2.696s)
[695.827126] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.697s)
[696.669777] [129/133] (325s left) kms_psr (fbc-psr-suspend)
[696.759920] Starting subtest: fbc-psr-suspend
[696.762195] Starting dynamic subtest: eDP-1
[696.766514] Dynamic subtest eDP-1: SKIP (0.000s)
[696.770433] Subtest fbc-psr-suspend: SKIP (0.002s)
[696.834285] [130/133] (325s left) gem_readwrite (write-bad-handle)
[696.894843] Subtest write-bad-handle: SKIP (0.000s)
[696.958517] [131/133] (325s left) dmabuf_sync_file (import-multiple-read-only)
[697.000987] Starting subtest: import-multiple-read-only
[697.003358] Subtest import-multiple-read-only: SUCCESS (0.003s)
[697.058848] [132/133] (325s left) perf_pmu (busy-accuracy-2)
[697.098703] Starting subtest: busy-accuracy-2
[697.100906] Starting dynamic subtest: rcs0
[700.139931] Dynamic subtest rcs0: SUCCESS (3.039s)
[700.153160] Starting dynamic subtest: bcs0
[703.196556] Dynamic subtest bcs0: SUCCESS (3.054s)
[703.209052] Starting dynamic subtest: vcs0
[706.237089] Dynamic subtest vcs0: SUCCESS (3.038s)
[706.250024] Starting dynamic subtest: vcs1
[709.286011] Dynamic subtest vcs1: SUCCESS (3.046s)
[709.299269] Starting dynamic subtest: vecs0
[712.333921] Dynamic subtest vecs0: SUCCESS (3.045s)
[712.348459] Starting dynamic subtest: ccs0
[715.393426] Dynamic subtest ccs0: SUCCESS (3.057s)
[715.396497] Subtest busy-accuracy-2: SUCCESS (18.294s)
[715.510201] [133/133] (307s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[715.590811] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[715.595171] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[715.685459] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_schedule
results: parsing output: 1/ for test: kms_fbcon_fbt
results: parsing output: 2/ for test: kms_pipe_b_c_ivb
results: parsing output: 3/ for test: kms_async_flips
results: parsing output: 4/ for test: kms_psr
results: parsing output: 5/ for test: gem_ctx_persistence
results: parsing output: 6/ for test: kms_flip
results: parsing output: 7/ for test: kms_psr
results: parsing output: 8/ for test: syncobj_eventfd
results: parsing output: 9/ for test: gem_userptr_blits
results: parsing output: 10/ for test: kms_cursor_legacy
results: parsing output: 11/ for test: gem_exec_async
results: parsing output: 12/ for test: gem_wait
results: parsing output: 13/ for test: kms_joiner
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: gem_workarounds
results: parsing output: 16/ for test: gem_exec_parallel
results: parsing output: 17/ for test: gem_exec_capture
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: i915_hangman
results: parsing output: 20/ for test: kms_atomic_transition
results: parsing output: 21/ for test: gem_exec_whisper
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: gem_lmem_swapping
results: parsing output: 24/ for test: kms_cursor_crc
results: parsing output: 25/ for test: syncobj_timeline
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_ccs
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: perf_pmu
results: parsing output: 31/ for test: gem_eio
results: parsing output: 32/ for test: kms_chamelium_hpd
results: parsing output: 33/ for test: kms_big_fb
results: parsing output: 34/ for test: kms_color
results: parsing output: 35/ for test: kms_prop_blob
results: parsing output: 36/ for test: prime_vgem
results: parsing output: 37/ for test: kms_vblank
results: parsing output: 38/ for test: syncobj_wait
results: parsing output: 39/ for test: kms_plane
results: parsing output: 40/ for test: kms_flip
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: gem_create
results: parsing output: 43/ for test: gem_exec_fence
results: parsing output: 44/ for test: gem_exec_balancer
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: perf
results: parsing output: 47/ for test: syncobj_timeline
results: parsing output: 48/ for test: kms_psr2_sf
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_psr
results: parsing output: 53/ for test: kms_pm_dc
results: parsing output: 54/ for test: kms_chamelium_edid
results: parsing output: 55/ for test: syncobj_wait
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: kms_getfb
results: parsing output: 58/ for test: gem_exec_schedule
results: parsing output: 59/ for test: kms_pipe_crc_basic
results: parsing output: 60/ for test: sw_sync
results: parsing output: 61/ for test: gem_mmap_wc
results: parsing output: 62/ for test: gem_exec_params
results: parsing output: 63/ for test: kms_ccs
results: parsing output: 64/ for test: kms_busy
results: parsing output: 65/ for test: gen9_exec_parse
results: parsing output: 66/ for test: gem_render_copy
results: parsing output: 67/ for test: syncobj_timeline
results: parsing output: 68/ for test: gem_exec_reloc
results: parsing output: 69/ for test: gem_exec_reloc
results: parsing output: 70/ for test: kms_ccs
results: parsing output: 71/ for test: kms_prop_blob
results: parsing output: 72/ for test: i915_drm_fdinfo
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: gem_basic
results: parsing output: 75/ for test: kms_psr_stress_test
results: parsing output: 76/ for test: vgem_basic
results: parsing output: 77/ for test: gem_mmap_gtt
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: i915_pm_rps
results: parsing output: 80/ for test: kms_plane
results: parsing output: 81/ for test: i915_query
results: parsing output: 82/ for test: syncobj_timeline
results: parsing output: 83/ for test: kms_flip
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: gem_spin_batch
results: parsing output: 86/ for test: kms_dp_link_training
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_exec_reloc
results: parsing output: 89/ for test: api_intel_bb
results: parsing output: 90/ for test: kms_getfb
results: parsing output: 91/ for test: kms_cursor_legacy
results: parsing output: 92/ for test: syncobj_wait
results: parsing output: 93/ for test: kms_atomic
results: parsing output: 94/ for test: kms_cursor_edge_walk
results: parsing output: 95/ for test: kms_plane_multiple
results: parsing output: 96/ for test: gem_exec_reloc
results: parsing output: 97/ for test: kms_fb_coherency
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_addfb_basic
results: parsing output: 100/ for test: gem_ctx_persistence
results: parsing output: 101/ for test: gem_exec_params
results: parsing output: 102/ for test: kms_content_protection
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_cursor_crc
results: parsing output: 105/ for test: kms_plane_scaling
results: parsing output: 106/ for test: gem_pxp
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_invalid_mode
results: parsing output: 109/ for test: gem_mmap
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_cursor_legacy
results: parsing output: 112/ for test: kms_ccs
results: parsing output: 113/ for test: vgem_basic
results: parsing output: 114/ for test: gem_mmap_gtt
results: parsing output: 115/ for test: kms_ccs
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_atomic_transition
results: parsing output: 118/ for test: api_intel_bb
results: parsing output: 119/ for test: kms_sequence
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: kms_flip
results: parsing output: 122/ for test: gem_pxp
results: parsing output: 123/ for test: gem_exec_flush
results: parsing output: 124/ for test: perf_pmu
results: parsing output: 125/ for test: kms_flip_scaled_crc
results: parsing output: 126/ for test: kms_psr
results: parsing output: 127/ for test: kms_flip_scaled_crc
results: parsing output: 128/ for test: kms_psr
results: parsing output: 129/ for test: gem_readwrite
results: parsing output: 130/ for test: dmabuf_sync_file
results: parsing output: 131/ for test: perf_pmu
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.