[60.731514] Initializing watchdogs
[60.731559]   /dev/watchdog0
[60.745289] [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]
[60.749549] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.751959] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.755483] [001/132] (960s left) perf_pmu (busy-accuracy-2)
[60.818821] Starting subtest: busy-accuracy-2
[60.821116] Starting dynamic subtest: rcs0
[63.866675] Dynamic subtest rcs0: SUCCESS (3.061s)
[63.876282] Starting dynamic subtest: bcs0
[66.917099] Dynamic subtest bcs0: SUCCESS (3.060s)
[66.926824] Starting dynamic subtest: vcs0
[69.972020] Dynamic subtest vcs0: SUCCESS (3.060s)
[69.981730] Starting dynamic subtest: vcs1
[73.014745] Dynamic subtest vcs1: SUCCESS (3.048s)
[73.023637] Starting dynamic subtest: vecs0
[76.057574] Dynamic subtest vecs0: SUCCESS (3.045s)
[76.064767] Starting dynamic subtest: ccs0
[79.113104] Dynamic subtest ccs0: SUCCESS (3.056s)
[79.115819] Subtest busy-accuracy-2: SUCCESS (18.336s)
[79.248799] [002/132] (942s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[79.356728] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[79.358926] Starting dynamic subtest: pipe-A-eDP-1
[79.382272] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[79.391481] Starting dynamic subtest: pipe-B-eDP-1
[79.412205] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[79.419044] Starting dynamic subtest: pipe-C-eDP-1
[79.439744] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[79.446756] Starting dynamic subtest: pipe-D-eDP-1
[79.467751] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[79.471566] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.003s)
[81.564906] [003/132] (939s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[81.670810] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[81.675317] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[81.804211] [004/132] (939s left) gem_userptr_blits (process-exit-busy)
[81.874161] Starting subtest: process-exit-busy
[81.887479] Subtest process-exit-busy: SUCCESS (0.016s)
[82.054996] [005/132] (939s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[82.158034] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[82.168836] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.010s)
[82.304277] [006/132] (939s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc)
[82.413797] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc
[82.418166] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[82.544209] [007/132] (938s left) gem_close_race (multigpu-basic-threads)
[82.620177] Starting subtest: multigpu-basic-threads
[82.623652] Subtest multigpu-basic-threads: SKIP (0.000s)
[82.881670] [008/132] (938s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[82.937026] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[83.043395] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.106s)
[83.142285] [009/132] (938s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[83.239214] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[83.241911] Starting dynamic subtest: pipe-A-eDP-1
[83.263326] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[83.274931] Starting dynamic subtest: pipe-B-eDP-1
[83.295852] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[83.304819] Starting dynamic subtest: pipe-C-eDP-1
[83.324419] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[83.331902] Starting dynamic subtest: pipe-D-eDP-1
[83.351282] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[83.353306] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[85.442640] [010/132] (936s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[85.537312] Starting subtest: plane-primary-overlay-mutable-zpos
[88.965476] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.427s)
[90.170313] [011/132] (931s left) gem_userptr_blits (forbidden-operations)
[90.248250] Starting subtest: forbidden-operations
[90.252409] Subtest forbidden-operations: SKIP (0.000s)
[90.395677] [012/132] (931s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[90.497706] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[90.502076] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[90.626167] [013/132] (931s left) kms_flip (flip-vs-expired-vblank-interruptible)
[90.723698] Starting subtest: flip-vs-expired-vblank-interruptible
[90.726206] Starting dynamic subtest: A-eDP1
[99.353449] Dynamic subtest A-eDP1: SUCCESS (8.629s)
[99.363289] Starting dynamic subtest: B-eDP1
[107.983805] Dynamic subtest B-eDP1: SUCCESS (8.629s)
[107.993875] Starting dynamic subtest: C-eDP1
[116.596972] Dynamic subtest C-eDP1: SUCCESS (8.613s)
[116.605728] Starting dynamic subtest: D-eDP1
[125.221772] Dynamic subtest D-eDP1: SUCCESS (8.624s)
[125.226336] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.504s)
[126.503497] [014/132] (895s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[126.603324] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[126.607736] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[126.713041] [015/132] (895s left) gem_eio (unwedge-stress)
[126.896208] Starting subtest: unwedge-stress
[126.898635] Starting dynamic subtest: render
[131.179064] Dynamic subtest render: SUCCESS (4.280s)
[131.192430] Starting dynamic subtest: bsd1
[149.323979] Dynamic subtest bsd1: SUCCESS (18.142s)
[149.338588] Starting dynamic subtest: bsd2
[167.362499] Dynamic subtest bsd2: SUCCESS (18.035s)
[167.377398] Starting dynamic subtest: blt
[167.381686] Dynamic subtest blt: SKIP (0.000s)
[167.389076] Starting dynamic subtest: vebox
[185.304470] Dynamic subtest vebox: SUCCESS (17.938s)
[185.306709] Subtest unwedge-stress: SUCCESS (58.397s)
[186.896426] [FACT gem_eio (unwedge-stress)] new: kernel.kmod_is_loaded.vgem: true
[186.899645] [016/132] (834s left) dumb_buffer (map-invalid-size)
[186.968628] Starting subtest: map-invalid-size
[186.970636] Subtest map-invalid-size: SUCCESS (0.000s)
[187.111014] [017/132] (834s left) perf (missing-sample-flags)
[187.248701] Starting subtest: missing-sample-flags
[187.250943] Subtest missing-sample-flags: SUCCESS (0.000s)
[187.294740] [018/132] (834s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[187.396875] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[187.399178] Starting dynamic subtest: pipe-A
[187.793075] Dynamic subtest pipe-A: SUCCESS (0.397s)
[187.802380] Starting dynamic subtest: pipe-B
[189.189455] Dynamic subtest pipe-B: SUCCESS (1.396s)
[189.199757] Starting dynamic subtest: pipe-C
[190.667532] Dynamic subtest pipe-C: SUCCESS (1.478s)
[190.675528] Starting dynamic subtest: pipe-D
[192.091324] Dynamic subtest pipe-D: SUCCESS (1.423s)
[192.093658] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.695s)
[193.353045] [019/132] (828s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[193.453200] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[193.455422] Starting dynamic subtest: pipe-A-eDP-1
[193.479995] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[193.492787] Starting dynamic subtest: pipe-B-eDP-1
[193.516407] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[193.525885] Starting dynamic subtest: pipe-C-eDP-1
[193.549038] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[193.557487] Starting dynamic subtest: pipe-D-eDP-1
[193.582824] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[193.587334] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.003s)
[195.631331] [020/132] (826s left) kms_dsc (dsc-with-formats)
[195.733701] Starting subtest: dsc-with-formats
[195.773227] Subtest dsc-with-formats: SKIP (0.001s)
[195.830085] [021/132] (826s left) syncobj_timeline (invalid-signal-illegal-point)
[195.899046] Starting subtest: invalid-signal-illegal-point
[195.901496] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[196.042175] [022/132] (826s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[196.094749] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[196.097063] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[196.229281] [023/132] (825s left) kms_addfb_basic (unused-offsets)
[196.287883] Starting subtest: unused-offsets
[196.289827] Subtest unused-offsets: SUCCESS (0.000s)
[196.459719] [024/132] (825s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[196.568440] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[203.463379] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SUCCESS (6.895s)
[203.634130] [025/132] (818s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[203.748053] Starting subtest: 4-tiled-64bpp-rotate-0
[205.364699] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.616s)
[205.765323] [026/132] (816s left) gem_exec_balancer (parallel-contexts)
[206.026487] Starting subtest: parallel-contexts
[208.974509] Subtest parallel-contexts: SUCCESS (2.950s)
[210.021258] [027/132] (812s left) gem_softpin (reverse)
[210.091410] Starting subtest: reverse
[210.099837] Subtest reverse: SUCCESS (0.008s)
[210.259044] [028/132] (812s left) perf_pmu (init-wait)
[210.300574] Starting subtest: init-wait
[210.302888] Starting dynamic subtest: rcs0
[210.305784] Dynamic subtest rcs0: SUCCESS (0.002s)
[210.313226] Starting dynamic subtest: bcs0
[210.315093] Dynamic subtest bcs0: SUCCESS (0.000s)
[210.322282] Starting dynamic subtest: vcs0
[210.324110] Dynamic subtest vcs0: SUCCESS (0.000s)
[210.331152] Starting dynamic subtest: vcs1
[210.333240] Dynamic subtest vcs1: SUCCESS (0.000s)
[210.340402] Starting dynamic subtest: vecs0
[210.342292] Dynamic subtest vecs0: SUCCESS (0.000s)
[210.349456] Starting dynamic subtest: ccs0
[210.351865] Dynamic subtest ccs0: SUCCESS (0.000s)
[210.354156] Subtest init-wait: SUCCESS (0.006s)
[210.445119] [029/132] (811s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[210.560170] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[210.564335] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[210.676497] [030/132] (811s left) kms_color (ctm-0-75)
[210.780128] Starting subtest: ctm-0-75
[210.782326] Starting dynamic subtest: pipe-A-eDP-1
[215.556251] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.775s)
[215.566262] Starting dynamic subtest: pipe-B-eDP-1
[221.072383] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.517s)
[221.082581] Starting dynamic subtest: pipe-C-eDP-1
[226.362562] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.289s)
[226.372057] Starting dynamic subtest: pipe-D-eDP-1
[231.717551] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.354s)
[231.719956] Subtest ctm-0-75: SUCCESS (20.939s)
[232.552731] [031/132] (789s left) sysfs_heartbeat_interval (idempotent)
[232.622697] Starting subtest: idempotent
[232.625082] Starting dynamic subtest: vecs0
[232.627381] Dynamic subtest vecs0: SUCCESS (0.001s)
[232.636877] Starting dynamic subtest: ccs0
[232.639090] Dynamic subtest ccs0: SUCCESS (0.001s)
[232.646503] Starting dynamic subtest: vcs0
[232.648719] Dynamic subtest vcs0: SUCCESS (0.000s)
[232.656238] Starting dynamic subtest: bcs0
[232.658408] Dynamic subtest bcs0: SUCCESS (0.001s)
[232.665825] Starting dynamic subtest: rcs0
[232.668099] Dynamic subtest rcs0: SUCCESS (0.000s)
[232.675714] Starting dynamic subtest: vcs1
[232.677980] Dynamic subtest vcs1: SUCCESS (0.000s)
[232.680245] Subtest idempotent: SUCCESS (0.006s)
[232.783160] [032/132] (789s left) gem_ctx_shared (q-in-order)
[232.842442] Starting subtest: Q-in-order
[232.844777] Starting dynamic subtest: rcs0
[232.956491] Dynamic subtest rcs0: SUCCESS (0.111s)
[232.971860] Starting dynamic subtest: vcs0
[233.047371] Dynamic subtest vcs0: SUCCESS (0.092s)
[233.063354] Starting dynamic subtest: vcs1
[233.125823] Dynamic subtest vcs1: SUCCESS (0.077s)
[233.141731] Starting dynamic subtest: vecs0
[233.203283] Dynamic subtest vecs0: SUCCESS (0.077s)
[233.219130] Starting dynamic subtest: ccs0
[233.294418] Dynamic subtest ccs0: SUCCESS (0.090s)
[233.297032] Subtest Q-in-order: SUCCESS (0.451s)
[235.014052] [033/132] (787s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[235.121619] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[236.099827] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (0.978s)
[236.259522] [034/132] (786s left) gen9_exec_parse (batch-invalid-length)
[236.323274] Subtest batch-invalid-length: SKIP (0.000s)
[236.409005] [035/132] (786s left) gem_workarounds (suspend-resume-fd)
[236.477765] Starting subtest: suspend-resume-fd
[252.873676] Subtest suspend-resume-fd: SUCCESS (5.620s)
[253.055823] [036/132] (769s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[253.179363] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[253.183816] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[253.297425] [037/132] (769s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[253.405026] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[253.991048] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.614s)
[254.210475] [038/132] (768s left) gem_lmem_swapping (parallel-multi)
[254.257393] Subtest parallel-multi: SKIP (0.000s)
[254.300652] [039/132] (768s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[254.386894] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[254.389072] Starting dynamic subtest: pipe-A-eDP-1
[254.397932] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[254.407711] Starting dynamic subtest: pipe-B-eDP-1
[254.416443] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[254.424808] Starting dynamic subtest: pipe-C-eDP-1
[254.433265] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[254.441931] Starting dynamic subtest: pipe-D-eDP-1
[254.450324] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[254.454505] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[256.590943] [040/132] (766s left) gem_eio (wait-1us)
[256.812856] Starting subtest: wait-1us
[257.160472] Subtest wait-1us: SUCCESS (0.357s)
[257.343057] [041/132] (765s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[257.469233] Starting subtest: cursorA-vs-flipB-atomic
[257.472980] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[257.635062] [042/132] (765s left) gem_userptr_blits (access-control)
[257.705931] Starting subtest: access-control
[257.709552] Subtest access-control: SKIP (0.000s)
[257.860420] [043/132] (765s left) prime_vgem (basic-fence-blt)
[257.945366] Starting subtest: basic-fence-blt
[258.021055] Subtest basic-fence-blt: SUCCESS (0.078s)
[258.186019] [044/132] (764s left) gem_exec_fence (submit-chain)
[258.356706] Starting subtest: submit-chain
[258.374317] Subtest submit-chain: SUCCESS (0.018s)
[259.797895] [045/132] (763s left) kms_pm_dc (dc6-psr)
[260.909309] Starting subtest: dc6-psr
[263.773866] Subtest dc6-psr: SUCCESS (2.907s)
[264.590443] [046/132] (758s left) i915_suspend (debugfs-reader)
[264.654755] Starting subtest: debugfs-reader
[282.870303] Subtest debugfs-reader: SUCCESS (3.237s)
[282.915721] [047/132] (740s left) gem_ctx_persistence (legacy-engines-cleanup)
[282.982124] Starting subtest: legacy-engines-cleanup
[282.984645] Starting dynamic subtest: render
[283.069666] Dynamic subtest render: SUCCESS (0.091s)
[283.079646] Starting dynamic subtest: bsd1
[283.141227] Dynamic subtest bsd1: SUCCESS (0.072s)
[283.154340] Starting dynamic subtest: bsd2
[283.209635] Dynamic subtest bsd2: SUCCESS (0.067s)
[283.219390] Starting dynamic subtest: blt
[283.238017] Dynamic subtest blt: SUCCESS (0.028s)
[283.246217] Starting dynamic subtest: vebox
[283.354172] Dynamic subtest vebox: SUCCESS (0.120s)
[283.356938] Subtest legacy-engines-cleanup: SUCCESS (0.390s)
[283.455631] [048/132] (739s left) core_getclient (basic)
[283.503541] Starting subtest: basic
[283.505557] Subtest basic: SUCCESS (0.000s)
[283.638065] [049/132] (739s left) gem_exec_whisper (basic-fds-priority-all)
[283.707831] Starting subtest: basic-fds-priority-all
[307.526702] Subtest basic-fds-priority-all: SUCCESS (24.103s)
[307.736115] [050/132] (715s left) gem_exec_schedule (preempt-queue-chain)
[307.826143] Subtest preempt-queue-chain: SKIP (0.000s)
[308.141838] [051/132] (715s left) kms_invalid_mode (zero-vdisplay)
[308.233517] Starting subtest: zero-vdisplay
[308.235976] Starting dynamic subtest: pipe-A-eDP-1
[308.514487] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.282s)
[308.525396] Starting dynamic subtest: pipe-B-eDP-1
[308.528282] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[308.537912] Starting dynamic subtest: pipe-C-eDP-1
[308.540511] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[308.549740] Starting dynamic subtest: pipe-D-eDP-1
[308.552282] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[308.554965] Subtest zero-vdisplay: SUCCESS (0.287s)
[309.336631] [052/132] (713s left) gem_ctx_param (invalid-get-ringsize)
[309.399019] Starting subtest: invalid-get-ringsize
[309.401846] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[309.534782] [053/132] (713s left) kms_cursor_crc (cursor-onscreen-128x42)
[309.741495] Starting subtest: cursor-onscreen-128x42
[309.785857] Subtest cursor-onscreen-128x42: SKIP (0.039s)
[309.995226] [054/132] (713s left) gem_exec_async (forked-writes)
[310.065138] Starting subtest: forked-writes
[310.068175] Starting dynamic subtest: rcs0
[310.093671] Dynamic subtest rcs0: SUCCESS (0.028s)
[310.105093] Starting dynamic subtest: bcs0
[310.117384] Dynamic subtest bcs0: SUCCESS (0.023s)
[310.127538] Starting dynamic subtest: vcs0
[310.140088] Dynamic subtest vcs0: SUCCESS (0.022s)
[310.153309] Starting dynamic subtest: vcs1
[310.162953] Dynamic subtest vcs1: SUCCESS (0.022s)
[310.174155] Starting dynamic subtest: vecs0
[310.185141] Dynamic subtest vecs0: SUCCESS (0.020s)
[310.195479] Starting dynamic subtest: ccs0
[310.205404] Dynamic subtest ccs0: SUCCESS (0.020s)
[310.208266] Subtest forked-writes: SUCCESS (0.141s)
[310.470373] [055/132] (712s left) kms_pm_rpm (universal-planes)
[311.990384] Starting subtest: universal-planes
[311.993311] Starting dynamic subtest: plane-33
[320.707530] Dynamic subtest plane-33: SUCCESS (8.718s)
[320.720383] Starting dynamic subtest: plane-63
[328.997857] Dynamic subtest plane-63: SUCCESS (8.285s)
[329.009060] Starting dynamic subtest: plane-93
[337.602067] Dynamic subtest plane-93: SUCCESS (8.600s)
[337.614476] Starting dynamic subtest: plane-123
[345.989718] Dynamic subtest plane-123: SUCCESS (8.384s)
[346.002412] Starting dynamic subtest: plane-133
[354.373411] Dynamic subtest plane-133: SUCCESS (8.382s)
[354.386407] Starting dynamic subtest: plane-143
[362.779379] Dynamic subtest plane-143: SUCCESS (8.407s)
[362.782362] Subtest universal-planes: SUCCESS (50.792s)
[363.174619] [056/132] (660s left) kms_lease (lease-unleased-crtc)
[363.291386] Starting subtest: lease-unleased-crtc
[363.293966] Starting dynamic subtest: pipe-A-eDP-1
[363.588604] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.299s)
[363.605068] Starting dynamic subtest: pipe-B-eDP-1
[364.305591] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.714s)
[364.318270] Starting dynamic subtest: pipe-C-eDP-1
[364.321468] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.006s)
[364.330749] Starting dynamic subtest: pipe-D-eDP-1
[364.333023] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.005s)
[364.336129] Subtest lease-unleased-crtc: SUCCESS (1.030s)
[364.703442] [057/132] (658s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[364.819256] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[365.656419] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.839s)
[365.841135] [058/132] (657s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[365.917301] Starting subtest: wait-all-for-submit-delayed-submit
[366.017558] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.102s)
[366.121248] [059/132] (657s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[371.170086] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[371.172470] Starting dynamic subtest: pipe-A-eDP-1
[371.957434] Dynamic subtest pipe-A-eDP-1: SKIP (0.783s)
[371.966955] Starting dynamic subtest: pipe-B-eDP-1
[373.090584] Dynamic subtest pipe-B-eDP-1: SKIP (1.133s)
[373.095996] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.920s)
[374.301721] [060/132] (649s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[374.420391] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[374.426335] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[374.548703] [061/132] (649s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[374.665114] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[374.669922] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[374.770849] [062/132] (648s left) gem_mmap (bad-offset)
[374.835211] Subtest bad-offset: SKIP (0.000s)
[374.937643] [063/132] (648s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[375.033417] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[375.038902] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[375.170011] [064/132] (648s left) kms_chamelium_color (ctm-0-25)
[375.267085] Subtest ctm-0-25: SKIP (0.000s)
[375.314721] [065/132] (648s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[375.416776] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[375.421135] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[375.551642] [066/132] (648s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[375.653483] Starting subtest: psr-2p-primscrn-cur-indfb-move
[375.657811] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[375.772350] [067/132] (648s left) gem_softpin (noreloc-s3)
[375.842920] Starting subtest: noreloc-S3
[396.795706] Subtest noreloc-S3: SUCCESS (5.413s)
[397.009735] [068/132] (626s left) gem_exec_schedule (thriceslice)
[397.096915] Starting subtest: thriceslice
[397.098846] Starting dynamic subtest: rcs0
[397.120505] Dynamic subtest rcs0: SUCCESS (0.034s)
[397.132891] Starting dynamic subtest: bcs0
[397.154903] Dynamic subtest bcs0: SUCCESS (0.035s)
[397.163642] Starting dynamic subtest: vcs0
[397.211412] Dynamic subtest vcs0: SUCCESS (0.056s)
[397.223008] Starting dynamic subtest: vcs1
[397.264504] Dynamic subtest vcs1: SUCCESS (0.053s)
[397.277097] Starting dynamic subtest: vecs0
[397.319171] Dynamic subtest vecs0: SUCCESS (0.054s)
[397.330720] Starting dynamic subtest: ccs0
[397.353206] Dynamic subtest ccs0: SUCCESS (0.034s)
[397.355541] Subtest thriceslice: SUCCESS (0.274s)
[397.675544] [069/132] (626s left) sriov_basic (enable-vfs-autoprobe-on)
[397.734344] Starting subtest: enable-vfs-autoprobe-on
[397.736625] Starting dynamic subtest: numvfs-1
[397.810831] Dynamic subtest numvfs-1: FAIL (0.013s)
[397.821405] Starting dynamic subtest: numvfs-2
[397.892337] Dynamic subtest numvfs-2: FAIL (0.004s)
[397.903058] Starting dynamic subtest: numvfs-3
[397.974084] Dynamic subtest numvfs-3: FAIL (0.004s)
[397.983757] Starting dynamic subtest: numvfs-4
[398.054334] Dynamic subtest numvfs-4: FAIL (0.003s)
[398.065019] Starting dynamic subtest: numvfs-5
[398.134927] Dynamic subtest numvfs-5: FAIL (0.004s)
[398.144993] Starting dynamic subtest: numvfs-6
[398.215640] Dynamic subtest numvfs-6: FAIL (0.004s)
[398.226190] Starting dynamic subtest: numvfs-7
[398.297673] Dynamic subtest numvfs-7: FAIL (0.003s)
[398.307827] Starting dynamic subtest: numvfs-random
[398.378058] Dynamic subtest numvfs-random: FAIL (0.004s)
[398.388654] Starting dynamic subtest: numvfs-all
[398.461183] Dynamic subtest numvfs-all: FAIL (0.513s)
[398.463223] Subtest enable-vfs-autoprobe-on: FAIL (0.558s)
[398.500845] [070/132] (625s left) api_intel_bb (blit-noreloc-purge-cache)
[398.543434] Starting subtest: blit-noreloc-purge-cache
[398.550018] Subtest blit-noreloc-purge-cache: SUCCESS (0.009s)
[398.701058] [071/132] (625s left) kms_hdr (bpc-switch-dpms)
[398.805816] Starting subtest: bpc-switch-dpms
[399.838634] Starting dynamic subtest: pipe-A-eDP-1
[404.208321] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.439s)
[404.210475] Subtest bpc-switch-dpms: SUCCESS (5.494s)
[404.383774] [072/132] (619s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[404.502523] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[404.506769] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[404.639146] [073/132] (619s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[404.696054] Subtest basic-wc-gtt-noreloc: SKIP (0.000s)
[404.763054] [074/132] (619s left) perf_pmu (rc6)
[404.803858] Starting subtest: rc6
[404.806002] Starting dynamic subtest: gt0
[411.173445] Dynamic subtest gt0: SUCCESS (6.416s)
[411.185504] Starting dynamic subtest: runtime-pm-gt0
[418.896783] Dynamic subtest runtime-pm-gt0: SUCCESS (7.745s)
[418.917683] Starting dynamic subtest: runtime-pm-long-gt0
[431.327665] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.432s)
[431.340312] Starting dynamic subtest: other-idle-gt0
[437.673151] Dynamic subtest other-idle-gt0: SUCCESS (6.340s)
[437.685283] Starting dynamic subtest: gt1
[444.014250] Dynamic subtest gt1: SUCCESS (6.339s)
[444.026508] Starting dynamic subtest: runtime-pm-gt1
[451.449802] Dynamic subtest runtime-pm-gt1: SUCCESS (7.434s)
[451.462181] Starting dynamic subtest: runtime-pm-long-gt1
[463.886226] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.436s)
[463.898865] Starting dynamic subtest: other-idle-gt1
[470.229520] Dynamic subtest other-idle-gt1: SUCCESS (6.343s)
[470.232942] Subtest rc6: SUCCESS (65.504s)
[471.357731] [075/132] (552s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling)
[471.471036] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling
[471.473312] Starting dynamic subtest: pipe-A-default-mode
[471.762818] Dynamic subtest pipe-A-default-mode: SKIP (0.288s)
[471.767438] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.290s)
[472.590641] [076/132] (551s left) intel_hwmon (hwmon-read)
[472.654792] Subtest hwmon-read: SKIP (0.000s)
[472.721603] [077/132] (551s left) gem_sync (basic-many-each)
[472.795535] Starting subtest: basic-many-each
[475.080576] Subtest basic-many-each: SUCCESS (2.296s)
[475.244330] [078/132] (549s left) gen9_exec_parse (unaligned-access)
[475.313551] Subtest unaligned-access: SKIP (0.000s)
[475.400201] [079/132] (549s left) kms_flip (bo-too-big-interruptible)
[475.501783] Starting subtest: bo-too-big-interruptible
[475.504111] Starting dynamic subtest: A-eDP1
[476.780421] Dynamic subtest A-eDP1: SUCCESS (1.279s)
[476.794792] Starting dynamic subtest: B-eDP1
[478.015510] Dynamic subtest B-eDP1: SUCCESS (1.234s)
[478.030767] Starting dynamic subtest: C-eDP1
[479.248980] Dynamic subtest C-eDP1: SUCCESS (1.231s)
[479.260460] Starting dynamic subtest: D-eDP1
[480.476480] Dynamic subtest D-eDP1: SUCCESS (1.227s)
[480.478801] Subtest bo-too-big-interruptible: SUCCESS (4.980s)
[481.670443] [080/132] (542s left) kms_pipe_stress (stress-xrgb8888-yftiled)
[481.761966] Starting subtest: stress-xrgb8888-yftiled
[481.766302] Subtest stress-xrgb8888-yftiled: SKIP (0.000s)
[481.854484] [081/132] (542s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[481.924632] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[482.028619] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.103s)
[482.080579] [082/132] (542s left) syncobj_wait (wait-for-submit-delayed-submit)
[482.141354] Starting subtest: wait-for-submit-delayed-submit
[482.245489] Subtest wait-for-submit-delayed-submit: SUCCESS (0.104s)
[482.300378] [083/132] (542s left) i915_pm_rc6_residency (rc6-accuracy)
[482.350574] Starting subtest: rc6-accuracy
[482.352695] Starting dynamic subtest: gt0
[485.522701] Dynamic subtest gt0: SUCCESS (3.170s)
[485.534900] Starting dynamic subtest: gt1
[488.693477] Dynamic subtest gt1: SUCCESS (3.169s)
[488.695981] Subtest rc6-accuracy: SUCCESS (6.344s)
[488.741928] [084/132] (535s left) kms_properties (connector-properties-legacy)
[488.841535] Starting subtest: connector-properties-legacy
[488.843747] Starting dynamic subtest: pipe-A-eDP-1
[496.596046] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.749s)
[496.606130] Starting dynamic subtest: pipe-None-DP-1
[496.610284] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[496.619199] Starting dynamic subtest: pipe-None-HDMI-A-1
[496.623331] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[496.632466] Starting dynamic subtest: pipe-None-DP-2
[496.636835] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[496.646157] Starting dynamic subtest: pipe-None-HDMI-A-2
[496.650896] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[496.664265] Starting dynamic subtest: pipe-None-DP-3
[496.669244] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[496.680714] Starting dynamic subtest: pipe-None-DP-4
[496.685263] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[496.687244] Subtest connector-properties-legacy: SUCCESS (7.761s)
[497.445483] [085/132] (527s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[497.566139] Starting subtest: cursorB-vs-flipB-toggle
[497.570693] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s)
[497.686841] [086/132] (526s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[502.634042] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[502.638290] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.003s)
[503.483431] [087/132] (521s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[508.566325] Starting subtest: pr-primary-plane-update-sf-dmg-area-big-fb
[508.571681] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.003s)
[509.395260] [088/132] (515s left) gem_mmap_gtt (basic-small-bo-tiledx)
[509.457750] Subtest basic-small-bo-tiledX: SKIP (0.000s)
[509.534944] [089/132] (515s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[509.636409] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[509.640397] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[509.736633] [090/132] (515s left) i915_hangman (gt-error-state-capture)
[509.799138] Starting subtest: gt-error-state-capture
[509.801372] Starting dynamic subtest: rcs0
[521.341052] Dynamic subtest rcs0: SUCCESS (11.541s)
[521.358835] Starting dynamic subtest: bcs0
[533.373492] Dynamic subtest bcs0: SUCCESS (12.029s)
[533.387024] Starting dynamic subtest: vcs0
[544.381672] Dynamic subtest vcs0: SUCCESS (11.007s)
[544.394206] Starting dynamic subtest: vcs1
[558.332613] Dynamic subtest vcs1: SUCCESS (13.949s)
[558.344620] Starting dynamic subtest: vecs0
[568.381132] Dynamic subtest vecs0: SUCCESS (10.048s)
[568.392069] Starting dynamic subtest: ccs0
[580.350418] Dynamic subtest ccs0: SUCCESS (11.969s)
[580.353568] Subtest gt-error-state-capture: SUCCESS (70.557s)
[580.409445] [091/132] (444s left) kms_psr (psr2-sprite-mmap-cpu)
[580.519341] Starting subtest: psr2-sprite-mmap-cpu
[580.521480] Starting dynamic subtest: eDP-1
[582.200523] Dynamic subtest eDP-1: SUCCESS (1.682s)
[582.202701] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.683s)
[583.058499] [092/132] (441s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[583.442692] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[584.281530] [093/132] (440s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[584.390340] Starting subtest: fbcpsr-slowdraw
[609.574943] Subtest fbcpsr-slowdraw: SUCCESS (25.192s)
[609.704552] [094/132] (415s left) kms_cursor_crc (cursor-sliding-128x128)
[609.945710] Starting subtest: cursor-sliding-128x128
[609.951809] Starting dynamic subtest: pipe-A-eDP-1
[613.268978] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.318s)
[613.299105] Starting dynamic subtest: pipe-D-eDP-1
[617.280895] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.991s)
[617.283041] Subtest cursor-sliding-128x128: SUCCESS (7.335s)
[618.067652] [095/132] (407s left) kms_content_protection (legacy)
[618.240882] Starting subtest: legacy
[618.245186] Subtest legacy: SKIP (0.000s)
[618.370169] [096/132] (406s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[618.474837] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[618.479055] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[618.572175] [097/132] (406s left) kms_universal_plane (universal-plane-pageflip-windowed)
[618.677039] Starting subtest: universal-plane-pageflip-windowed
[618.679066] Starting dynamic subtest: pipe-A-eDP-1
[619.299917] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.624s)
[619.311973] Starting dynamic subtest: pipe-B-eDP-1
[620.524642] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.222s)
[620.536301] Starting dynamic subtest: pipe-C-eDP-1
[621.741133] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.216s)
[621.752640] Starting dynamic subtest: pipe-D-eDP-1
[622.981305] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.236s)
[622.983500] Subtest universal-plane-pageflip-windowed: SUCCESS (4.303s)
[623.813137] [098/132] (401s left) kms_psr (fbc-psr-primary-mmap-cpu)
[623.912834] Starting subtest: fbc-psr-primary-mmap-cpu
[623.915166] Starting dynamic subtest: eDP-1
[623.919684] Dynamic subtest eDP-1: SKIP (0.000s)
[623.924062] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s)
[623.962643] [099/132] (401s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[624.062895] Starting subtest: fbc-pr-sprite-mmap-gtt
[624.066913] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[624.113642] [100/132] (401s left) gem_mmap (basic)
[624.185895] Subtest basic: SKIP (0.000s)
[624.276362] [101/132] (401s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[624.345086] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s)
[624.445381] [102/132] (400s left) syncobj_wait (signal)
[624.510011] Starting subtest: signal
[624.511819] Subtest signal: SUCCESS (0.000s)
[624.599252] [103/132] (400s left) vgem_basic (bad-flag)
[624.638928] Starting subtest: bad-flag
[624.640921] Subtest bad-flag: SUCCESS (0.000s)
[624.682197] [104/132] (400s left) kms_plane (plane-position-hole)
[624.775860] Starting subtest: plane-position-hole
[625.279655] Starting dynamic subtest: pipe-A-plane-1
[626.610315] Dynamic subtest pipe-A-plane-1: SUCCESS (1.330s)
[626.626604] Starting dynamic subtest: pipe-A-plane-2
[627.926319] Dynamic subtest pipe-A-plane-2: SUCCESS (1.316s)
[627.937211] Starting dynamic subtest: pipe-A-plane-3
[629.129414] Dynamic subtest pipe-A-plane-3: SUCCESS (1.202s)
[629.140800] Starting dynamic subtest: pipe-A-plane-4
[630.361571] Dynamic subtest pipe-A-plane-4: SUCCESS (1.231s)
[630.372866] Starting dynamic subtest: pipe-A-plane-5
[630.386309] Dynamic subtest pipe-A-plane-5: SUCCESS (0.022s)
[631.514160] Starting dynamic subtest: pipe-B-plane-1
[632.784442] Dynamic subtest pipe-B-plane-1: SUCCESS (1.279s)
[632.794891] Starting dynamic subtest: pipe-B-plane-2
[634.091920] Dynamic subtest pipe-B-plane-2: SUCCESS (1.307s)
[634.102383] Starting dynamic subtest: pipe-B-plane-3
[635.396007] Dynamic subtest pipe-B-plane-3: SUCCESS (1.305s)
[635.407354] Starting dynamic subtest: pipe-B-plane-4
[636.625679] Dynamic subtest pipe-B-plane-4: SUCCESS (1.228s)
[636.636391] Starting dynamic subtest: pipe-B-plane-5
[636.652238] Dynamic subtest pipe-B-plane-5: SUCCESS (0.025s)
[636.654448] Subtest plane-position-hole: SUCCESS (11.873s)
[637.417133] [105/132] (388s left) kms_fbcon_fbt (psr)
[637.478076] Starting subtest: psr
[644.755973] Subtest psr: SUCCESS (7.274s)
[644.837736] [106/132] (380s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[644.947508] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[644.949443] Starting dynamic subtest: A-eDP1
[653.821604] Dynamic subtest A-eDP1: SUCCESS (8.871s)
[653.841395] Starting dynamic subtest: B-eDP1
[662.744293] Dynamic subtest B-eDP1: SUCCESS (8.919s)
[662.755684] Starting dynamic subtest: C-eDP1
[671.660504] Dynamic subtest C-eDP1: SUCCESS (8.914s)
[671.675237] Starting dynamic subtest: D-eDP1
[680.583826] Dynamic subtest D-eDP1: SUCCESS (8.921s)
[680.589269] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.637s)
[681.801589] [107/132] (343s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[681.925066] Starting subtest: fbcpsr-1p-rte
[688.967994] Subtest fbcpsr-1p-rte: SUCCESS (7.047s)
[689.114158] [108/132] (336s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[689.245493] Starting subtest: protected-encrypted-src-copy-not-readible
[689.364381] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.118s)
[689.505456] [109/132] (336s left) kms_psr (fbc-psr-suspend)
[689.619897] Starting subtest: fbc-psr-suspend
[689.622209] Starting dynamic subtest: eDP-1
[689.626615] Dynamic subtest eDP-1: SKIP (0.000s)
[689.630655] Subtest fbc-psr-suspend: SKIP (0.002s)
[689.691334] [110/132] (336s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[689.802302] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[696.631053] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.832s)
[696.781463] [111/132] (329s left) kms_flip (basic-flip-vs-dpms)
[696.891880] Starting subtest: basic-flip-vs-dpms
[696.894233] Starting dynamic subtest: A-eDP1
[699.468597] Dynamic subtest A-eDP1: SUCCESS (2.574s)
[699.479490] Starting dynamic subtest: B-eDP1
[701.712875] Dynamic subtest B-eDP1: SUCCESS (2.245s)
[701.722815] Starting dynamic subtest: C-eDP1
[703.817193] Dynamic subtest C-eDP1: SUCCESS (2.101s)
[703.827764] Starting dynamic subtest: D-eDP1
[705.974388] Dynamic subtest D-eDP1: SUCCESS (2.154s)
[705.976443] Subtest basic-flip-vs-dpms: SUCCESS (9.082s)
[706.751935] [112/132] (319s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[706.871508] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[706.875944] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[706.995078] [113/132] (318s left) perf (oa-formats)
[707.061732] Starting subtest: oa-formats
[707.064081] Starting dynamic subtest: 0-rcs0
[707.076716] Dynamic subtest 0-rcs0: SUCCESS (0.015s)
[707.087030] Starting dynamic subtest: 1-vcs1
[707.100687] Dynamic subtest 1-vcs1: SUCCESS (0.023s)
[707.103084] Subtest oa-formats: SUCCESS (0.040s)
[707.149385] [114/132] (318s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[707.251965] Starting subtest: plane-lut1d-ctm3x4
[707.264868] Starting dynamic subtest: pipe-A-eDP-1
[707.919020] Dynamic subtest pipe-A-eDP-1: FAIL (0.293s)
[708.645278] Starting dynamic subtest: pipe-B-eDP-1
[709.460320] Dynamic subtest pipe-B-eDP-1: FAIL (0.291s)
[709.976777] Starting dynamic subtest: pipe-C-eDP-1
[710.809392] Dynamic subtest pipe-C-eDP-1: FAIL (0.257s)
[711.305409] Starting dynamic subtest: pipe-D-eDP-1
[712.138839] Dynamic subtest pipe-D-eDP-1: FAIL (0.235s)
[712.141055] Subtest plane-lut1d-ctm3x4: FAIL (4.572s)
[712.666827] [115/132] (313s left) kms_psr (psr-cursor-mmap-gtt)
[712.771673] Starting subtest: psr-cursor-mmap-gtt
[712.773959] Starting dynamic subtest: eDP-1
[714.469071] Dynamic subtest eDP-1: SUCCESS (1.697s)
[714.471396] Subtest psr-cursor-mmap-gtt: SUCCESS (1.698s)
[715.322975] [116/132] (310s left) gem_ctx_param (invalid-size-set)
[715.385618] Starting subtest: invalid-size-set
[715.388030] Subtest invalid-size-set: SUCCESS (0.001s)
[715.474067] [117/132] (310s left) gem_mmap_offset (close-race)
[715.523244] Starting subtest: close-race
[735.694799] Subtest close-race: SUCCESS (20.173s)
[735.824491] [118/132] (290s left) kms_dirtyfb (default-dirtyfb-ioctl)
[735.953865] Starting subtest: default-dirtyfb-ioctl
[735.956185] Starting dynamic subtest: A-eDP-1
[737.545346] Dynamic subtest A-eDP-1: SUCCESS (1.589s)
[737.547848] Subtest default-dirtyfb-ioctl: SUCCESS (1.591s)
[738.387261] [119/132] (287s left) gem_wait (write-wait)
[738.491954] Starting subtest: write-wait
[738.494486] Starting dynamic subtest: all-engines
[739.651311] Dynamic subtest all-engines: SUCCESS (1.159s)
[739.664288] Starting dynamic subtest: rcs0
[740.716375] Dynamic subtest rcs0: SUCCESS (1.063s)
[740.734120] Starting dynamic subtest: bcs0
[741.778893] Dynamic subtest bcs0: SUCCESS (1.060s)
[741.798789] Starting dynamic subtest: vcs0
[742.834926] Dynamic subtest vcs0: SUCCESS (1.053s)
[742.854421] Starting dynamic subtest: vcs1
[743.890689] Dynamic subtest vcs1: SUCCESS (1.053s)
[743.907296] Starting dynamic subtest: vecs0
[744.943603] Dynamic subtest vecs0: SUCCESS (1.051s)
[744.961414] Starting dynamic subtest: ccs0
[746.001636] Dynamic subtest ccs0: SUCCESS (1.056s)
[746.004057] Subtest write-wait: SUCCESS (7.512s)
[746.175907] [120/132] (280s left) i915_query (query-topology-matches-eu-total)
[746.229219] Starting subtest: query-topology-matches-eu-total
[746.231226] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[746.317035] [121/132] (279s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[746.415786] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[746.418069] Starting dynamic subtest: pipe-A-default-mode
[746.716285] Dynamic subtest pipe-A-default-mode: SKIP (0.296s)
[746.721289] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.298s)
[747.574930] [122/132] (278s left) gem_exec_params (invalid-bsd-ring)
[747.638527] Starting subtest: invalid-bsd-ring
[747.640928] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[747.731980] [123/132] (278s left) kms_frontbuffer_tracking (psr-slowdraw)
[747.832954] Starting subtest: psr-slowdraw
[772.897085] Subtest psr-slowdraw: SUCCESS (25.069s)
[773.033223] [124/132] (253s left) gem_caching (reads)
[773.111192] Subtest reads: SKIP (0.000s)
[773.210619] [125/132] (253s left) gem_userptr_blits (invalid-null-pointer)
[773.284204] Starting subtest: invalid-null-pointer
[773.286161] Subtest invalid-null-pointer: SUCCESS (0.001s)
[773.418420] [126/132] (253s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[773.525869] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[777.779361] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.258s)
[778.896379] [127/132] (247s left) gem_render_copy (yf-tiled-to-vebox-linear)
[778.957279] Starting subtest: yf-tiled-to-vebox-linear
[778.961975] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s)
[779.119849] [128/132] (247s left) gem_exec_reloc (basic-scanout)
[779.180083] Subtest basic-scanout: SKIP (0.000s)
[779.259571] [129/132] (247s left) kms_vblank (ts-continuation-idle-hang)
[779.348216] Starting subtest: ts-continuation-idle-hang
[779.350364] Starting dynamic subtest: pipe-A-eDP-1
[807.128572] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.785s)
[807.149675] Starting dynamic subtest: pipe-D-eDP-1
[832.150637] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.021s)
[832.152620] Subtest ts-continuation-idle-hang: SUCCESS (52.811s)
[832.958351] [130/132] (193s left) syncobj_wait (invalid-wait-bad-flags)
[833.024290] Starting subtest: invalid-wait-bad-flags
[833.026305] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[833.091716] [131/132] (193s left) dmabuf_sync_file (export-basic)
[833.141461] Starting subtest: export-basic
[833.143703] Subtest export-basic: SUCCESS (0.001s)
[833.182124] [132/132] (193s left) gem_pread (bench)
[833.247398] Subtest bench: SKIP (0.000s)
[833.309352] Closing watchdogs
results: parsing output: 0/ for test: perf_pmu
results: parsing output: 1/ for test: kms_ccs
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: gem_userptr_blits
results: parsing output: 4/ for test: kms_flip
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: gem_close_race
results: parsing output: 7/ for test: syncobj_timeline
results: parsing output: 8/ for test: kms_ccs
results: parsing output: 9/ for test: kms_atomic
results: parsing output: 10/ for test: gem_userptr_blits
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_flip
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: gem_eio
results: parsing output: 15/ for test: dumb_buffer
results: parsing output: 16/ for test: perf
results: parsing output: 17/ for test: kms_plane_scaling
results: parsing output: 18/ for test: kms_ccs
results: parsing output: 19/ for test: kms_dsc
results: parsing output: 20/ for test: syncobj_timeline
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: kms_addfb_basic
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_big_fb
results: parsing output: 25/ for test: gem_exec_balancer
results: parsing output: 26/ for test: gem_softpin
results: parsing output: 27/ for test: perf_pmu
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: kms_color
results: parsing output: 30/ for test: sysfs_heartbeat_interval
results: parsing output: 31/ for test: gem_ctx_shared
results: parsing output: 32/ for test: kms_big_fb
results: parsing output: 33/ for test: gen9_exec_parse
results: parsing output: 34/ for test: gem_workarounds
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: gem_lmem_swapping
results: parsing output: 38/ for test: kms_ccs
results: parsing output: 39/ for test: gem_eio
results: parsing output: 40/ for test: kms_cursor_legacy
results: parsing output: 41/ for test: gem_userptr_blits
results: parsing output: 42/ for test: prime_vgem
results: parsing output: 43/ for test: gem_exec_fence
results: parsing output: 44/ for test: kms_pm_dc
results: parsing output: 45/ for test: i915_suspend
results: parsing output: 46/ for test: gem_ctx_persistence
results: parsing output: 47/ for test: core_getclient
results: parsing output: 48/ for test: gem_exec_whisper
results: parsing output: 49/ for test: gem_exec_schedule
results: parsing output: 50/ for test: kms_invalid_mode
results: parsing output: 51/ for test: gem_ctx_param
results: parsing output: 52/ for test: kms_cursor_crc
results: parsing output: 53/ for test: gem_exec_async
results: parsing output: 54/ for test: kms_pm_rpm
results: parsing output: 55/ for test: kms_lease
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: syncobj_timeline
results: parsing output: 58/ for test: kms_psr2_sf
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: gem_mmap
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_chamelium_color
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_softpin
results: parsing output: 67/ for test: gem_exec_schedule
results: parsing output: 68/ for test: sriov_basic
results: parsing output: 69/ for test: api_intel_bb
results: parsing output: 70/ for test: kms_hdr
results: parsing output: 71/ for test: kms_big_fb
results: parsing output: 72/ for test: gem_exec_reloc
results: parsing output: 73/ for test: perf_pmu
results: parsing output: 74/ for test: kms_flip_scaled_crc
results: parsing output: 75/ for test: intel_hwmon
results: parsing output: 76/ for test: gem_sync
results: parsing output: 77/ for test: gen9_exec_parse
results: parsing output: 78/ for test: kms_flip
results: parsing output: 79/ for test: kms_pipe_stress
results: parsing output: 80/ for test: syncobj_wait
results: parsing output: 81/ for test: syncobj_wait
results: parsing output: 82/ for test: i915_pm_rc6_residency
results: parsing output: 83/ for test: kms_properties
results: parsing output: 84/ for test: kms_cursor_legacy
results: parsing output: 85/ for test: kms_psr2_sf
results: parsing output: 86/ for test: kms_psr2_sf
results: parsing output: 87/ for test: gem_mmap_gtt
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: i915_hangman
results: parsing output: 90/ for test: kms_psr
results: parsing output: 91/ for test: kms_chamelium_edid
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_cursor_crc
results: parsing output: 94/ for test: kms_content_protection
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_universal_plane
results: parsing output: 97/ for test: kms_psr
results: parsing output: 98/ for test: kms_psr
results: parsing output: 99/ for test: gem_mmap
results: parsing output: 100/ for test: gem_exec_reloc
results: parsing output: 101/ for test: syncobj_wait
results: parsing output: 102/ for test: vgem_basic
results: parsing output: 103/ for test: kms_plane
results: parsing output: 104/ for test: kms_fbcon_fbt
results: parsing output: 105/ for test: kms_flip
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_pxp
results: parsing output: 108/ for test: kms_psr
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_flip
results: parsing output: 111/ for test: kms_cursor_legacy
results: parsing output: 112/ for test: perf
results: parsing output: 113/ for test: kms_color_pipeline
results: parsing output: 114/ for test: kms_psr
results: parsing output: 115/ for test: gem_ctx_param
results: parsing output: 116/ for test: gem_mmap_offset
results: parsing output: 117/ for test: kms_dirtyfb
results: parsing output: 118/ for test: gem_wait
results: parsing output: 119/ for test: i915_query
results: parsing output: 120/ for test: kms_flip_scaled_crc
results: parsing output: 121/ for test: gem_exec_params
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: gem_caching
results: parsing output: 124/ for test: gem_userptr_blits
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gem_render_copy
results: parsing output: 127/ for test: gem_exec_reloc
results: parsing output: 128/ for test: kms_vblank
results: parsing output: 129/ for test: syncobj_wait
results: parsing output: 130/ for test: dmabuf_sync_file
results: parsing output: 131/ for test: gem_pread
Done.