[67.201974] Initializing watchdogs
[67.202076]   /dev/watchdog0
[67.247368] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[67.267716] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[67.272115] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[67.274579] [001/131] (960s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[68.893098] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.000s)
[68.946936] [002/131] (958s left) vgem_basic (create)
[69.060625] Starting subtest: create
[69.061901] Subtest create: SUCCESS (0.000s)
[69.214880] [FACT vgem_basic (create)] new: kernel.kmod_is_loaded.vgem: true
[69.216543] [003/131] (958s left) gem_exec_alignment (many)
[69.307140] Starting subtest: many
[97.354473] Subtest many: SUCCESS (28.047s)
[98.083249] [004/131] (929s left) gem_userptr_blits (create-destroy-sync)
[98.222866] Starting subtest: create-destroy-sync
[103.239172] Subtest create-destroy-sync: SUCCESS (5.016s)
[103.425681] [005/131] (924s left) perf_pmu (busy-double-start)
[103.498034] Starting subtest: busy-double-start
[103.498958] Starting dynamic subtest: rcs0
[107.142422] Dynamic subtest rcs0: SUCCESS (3.644s)
[107.152786] Starting dynamic subtest: bcs0
[110.740481] Dynamic subtest bcs0: SUCCESS (3.597s)
[110.750649] Starting dynamic subtest: vcs0
[114.349683] Dynamic subtest vcs0: FAIL (3.581s)
[114.359590] Starting dynamic subtest: vcs1
[117.912761] Dynamic subtest vcs1: FAIL (3.566s)
[117.922834] Starting dynamic subtest: vecs0
[121.478432] Dynamic subtest vecs0: FAIL (3.566s)
[121.488356] Starting dynamic subtest: vecs1
[125.042733] Dynamic subtest vecs1: FAIL (3.564s)
[125.052740] Starting dynamic subtest: ccs0
[128.609103] Dynamic subtest ccs0: SUCCESS (3.589s)
[128.610837] Subtest busy-double-start: FAIL (25.111s)
[128.791322] [006/131] (899s left) prime_mmap (test_aperture_limit)
[128.870801] Starting subtest: test_aperture_limit
[128.871659] Starting dynamic subtest: test_aperture_limit-smem
[128.886984] Dynamic subtest test_aperture_limit-smem: SKIP (0.015s)
[128.888983] Subtest test_aperture_limit: SKIP (0.016s)
[129.016606] [007/131] (899s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[130.539045] Starting subtest: psr-farfromfence-mmap-gtt
[130.540814] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[130.772949] [008/131] (897s left) kms_joiner (invalid-modeset-force-ultra-joiner)
[132.290582] Starting subtest: invalid-modeset-force-ultra-joiner
[132.292239] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s)
[132.446944] [009/131] (895s left) gem_exec_schedule (pi-distinct-iova)
[132.715620] Starting subtest: pi-distinct-iova
[132.717105] Starting dynamic subtest: rcs0
[132.986218] Dynamic subtest rcs0: SUCCESS (0.271s)
[132.994533] Starting dynamic subtest: bcs0
[133.161524] Dynamic subtest bcs0: SUCCESS (0.175s)
[133.169979] Starting dynamic subtest: vcs0
[133.349226] Dynamic subtest vcs0: SUCCESS (0.187s)
[133.357611] Starting dynamic subtest: vcs1
[133.541130] Dynamic subtest vcs1: SUCCESS (0.192s)
[133.549833] Starting dynamic subtest: vecs0
[133.730188] Dynamic subtest vecs0: SUCCESS (0.189s)
[133.738483] Starting dynamic subtest: vecs1
[133.969997] Dynamic subtest vecs1: SUCCESS (0.239s)
[133.978568] Starting dynamic subtest: ccs0
[134.163260] Dynamic subtest ccs0: SUCCESS (0.193s)
[134.164212] Subtest pi-distinct-iova: SUCCESS (1.449s)
[134.519828] [010/131] (893s left) gem_exec_whisper (basic-fds-forked)
[134.611422] Starting subtest: basic-fds-forked
[157.044163] Subtest basic-fds-forked: SUCCESS (22.431s)
[157.312881] [011/131] (871s left) gem_lmem_swapping (parallel-random)
[161.964844] Starting subtest: parallel-random
[161.965747] Starting dynamic subtest: lmem0
[203.548597] Dynamic subtest lmem0: SUCCESS (41.583s)
[203.549862] Subtest parallel-random: SUCCESS (41.584s)
[204.526765] [FACT gem_lmem_swapping (parallel-random)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[204.527757] [FACT gem_lmem_swapping (parallel-random)] deleted: kernel.kmod_is_loaded.i915: true
[204.529769] [012/131] (824s left) kms_content_protection (atomic-dpms-hdcp14)
[209.591162] Starting subtest: atomic-dpms-hdcp14
[209.598797] Subtest atomic-dpms-hdcp14: SKIP (0.006s)
[209.735729] [FACT kms_content_protection (atomic-dpms-hdcp14)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[209.738946] [FACT kms_content_protection (atomic-dpms-hdcp14)] new: kernel.kmod_is_loaded.i915: true
[209.741472] [013/131] (818s left) gem_exec_schedule (fifo)
[209.836960] Starting subtest: fifo
[209.837920] Starting dynamic subtest: rcs0
[210.118724] Dynamic subtest rcs0: SUCCESS (0.281s)
[210.127493] Starting dynamic subtest: bcs0
[210.317662] Dynamic subtest bcs0: SUCCESS (0.199s)
[210.326777] Starting dynamic subtest: vcs0
[210.528211] Dynamic subtest vcs0: SUCCESS (0.210s)
[210.536992] Starting dynamic subtest: vcs1
[210.743136] Dynamic subtest vcs1: SUCCESS (0.215s)
[210.751938] Starting dynamic subtest: vecs0
[210.952011] Dynamic subtest vecs0: SUCCESS (0.209s)
[210.960768] Starting dynamic subtest: vecs1
[211.161785] Dynamic subtest vecs1: SUCCESS (0.209s)
[211.170665] Starting dynamic subtest: ccs0
[211.368263] Dynamic subtest ccs0: SUCCESS (0.206s)
[211.369245] Subtest fifo: SUCCESS (1.531s)
[211.898027] [014/131] (816s left) kms_chamelium_color (ctm-0-25)
[213.411943] Subtest ctm-0-25: SKIP (0.000s)
[213.531606] [015/131] (815s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[215.069473] Starting subtest: x-tiled-32bpp-rotate-180
[216.868786] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.800s)
[217.070316] [016/131] (811s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[218.596916] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[219.702179] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (1.106s)
[219.984392] [017/131] (808s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[220.063211] Starting subtest: invalid-signal-one-illegal-handle
[220.064196] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[220.229245] [018/131] (808s left) gem_linear_blits (interruptible)
[220.428323] Starting subtest: interruptible
[227.745052] Subtest interruptible: SUCCESS (7.317s)
[228.018840] [019/131] (801s left) gem_workarounds (reset-context)
[228.153789] Starting subtest: reset-context
[228.375946] Subtest reset-context: SUCCESS (0.222s)
[228.590940] [020/131] (800s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc)
[230.104169] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc
[230.105053] Starting dynamic subtest: pipe-A-HDMI-A-3
[230.113309] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[230.122968] Starting dynamic subtest: pipe-B-HDMI-A-3
[230.131411] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[230.141255] Starting dynamic subtest: pipe-C-HDMI-A-3
[230.149258] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[230.158935] Starting dynamic subtest: pipe-D-HDMI-A-3
[230.169380] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[230.171135] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[230.433223] [021/131] (798s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs)
[231.946381] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs
[231.947266] Starting dynamic subtest: pipe-A-HDMI-A-3
[231.955690] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[231.965524] Starting dynamic subtest: pipe-B-HDMI-A-3
[231.973991] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[231.983486] Starting dynamic subtest: pipe-C-HDMI-A-3
[231.991816] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[232.001524] Starting dynamic subtest: pipe-D-HDMI-A-3
[232.010387] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[232.012111] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SKIP (0.004s)
[232.263939] [022/131] (797s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[233.777395] Starting subtest: short-flip-after-cursor-toggle
[234.826988] Subtest short-flip-after-cursor-toggle: SUCCESS (1.050s)
[235.075150] [023/131] (794s left) kms_psr (fbc-psr2-primary-render)
[236.589670] Subtest fbc-psr2-primary-render: SKIP (0.000s)
[236.649439] [024/131] (792s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[238.164261] Starting subtest: plane-primary-toggle-with-vblank-wait
[238.165176] Starting dynamic subtest: pipe-A-HDMI-A-3
[238.390040] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.225s)
[238.523415] Starting dynamic subtest: pipe-B-HDMI-A-3
[238.757038] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.248s)
[238.814335] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (0.650s)
[239.029968] [025/131] (790s left) gem_exec_fence (submit-chain)
[239.235037] Starting subtest: submit-chain
[239.286479] Subtest submit-chain: SUCCESS (0.057s)
[240.086541] [026/131] (789s left) gem_render_copy (y-tiled-to-vebox-linear)
[240.171454] Starting subtest: y-tiled-to-vebox-linear
[240.173464] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[240.420634] [027/131] (789s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[241.939992] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[241.941763] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[242.156931] [028/131] (787s left) syncobj_timeline (single-wait-available-submitted)
[242.244106] Starting subtest: single-wait-available-submitted
[242.245061] Subtest single-wait-available-submitted: SUCCESS (0.000s)
[242.446658] [029/131] (787s left) sysfs_heartbeat_interval (nopreempt)
[242.533660] Starting subtest: nopreempt
[242.534535] Starting dynamic subtest: vecs0
[246.868224] Dynamic subtest vecs0: SUCCESS (4.333s)
[246.878532] Starting dynamic subtest: ccs0
[251.145077] Dynamic subtest ccs0: SUCCESS (4.276s)
[251.154946] Starting dynamic subtest: vcs0
[255.395072] Dynamic subtest vcs0: SUCCESS (4.250s)
[255.405574] Starting dynamic subtest: bcs0
[259.585210] Dynamic subtest bcs0: SUCCESS (4.189s)
[259.595566] Starting dynamic subtest: vecs1
[263.804277] Dynamic subtest vecs1: SUCCESS (4.218s)
[263.814608] Starting dynamic subtest: rcs0
[268.202222] Dynamic subtest rcs0: SUCCESS (4.397s)
[268.212263] Starting dynamic subtest: vcs1
[272.439312] Dynamic subtest vcs1: SUCCESS (4.237s)
[272.440312] Subtest nopreempt: SUCCESS (29.904s)
[272.608691] [030/131] (757s left) sw_sync (sync_busy_fork)
[272.658192] Starting subtest: sync_busy_fork
[273.680735] Subtest sync_busy_fork: SUCCESS (1.021s)
[273.802019] [031/131] (756s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[275.319547] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[275.321208] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[275.530433] [032/131] (754s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[277.049185] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[277.051633] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[277.276684] [033/131] (752s left) kms_prime (basic-modeset-hybrid)
[278.794970] Subtest basic-modeset-hybrid: SKIP (0.000s)
[279.008500] [034/131] (751s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[280.523164] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[280.524012] Starting dynamic subtest: pipe-A-HDMI-A-3
[280.532290] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.001s)
[280.542433] Starting dynamic subtest: pipe-B-HDMI-A-3
[280.550988] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.001s)
[280.561173] Starting dynamic subtest: pipe-C-HDMI-A-3
[280.569562] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.001s)
[280.579649] Starting dynamic subtest: pipe-D-HDMI-A-3
[280.590179] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.001s)
[280.592078] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.008s)
[280.853482] [035/131] (749s left) kms_feature_discovery (display)
[282.369479] Starting subtest: display
[282.370377] Subtest display: SUCCESS (0.000s)
[282.524260] [036/131] (747s left) gem_create (create-ext-placement-all)
[282.743148] Starting subtest: create-ext-placement-all
[282.744624] Subtest create-ext-placement-all: SUCCESS (0.000s)
[282.936854] [037/131] (747s left) prime_mmap (test_reprime)
[283.015488] Starting subtest: test_reprime
[283.016417] Starting dynamic subtest: test_reprime-smem
[283.062519] Dynamic subtest test_reprime-smem: SUCCESS (0.047s)
[283.072425] Starting dynamic subtest: test_reprime-lmem0
[283.255889] Dynamic subtest test_reprime-lmem0: SUCCESS (0.193s)
[283.256807] Subtest test_reprime: SUCCESS (0.240s)
[283.419856] [038/131] (747s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[284.936625] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[284.938403] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[285.164886] [039/131] (745s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[286.680109] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[286.681053] Starting dynamic subtest: pipe-A-valid-mode
[286.778325] Dynamic subtest pipe-A-valid-mode: SKIP (0.097s)
[286.780462] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.098s)
[287.048838] [040/131] (743s left) gem_softpin (full)
[287.133956] Starting subtest: full
[287.150248] Subtest full: SUCCESS (0.016s)
[287.361736] [041/131] (743s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[288.879279] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[288.880975] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[289.115712] [042/131] (741s left) kms_psr (psr2-sprite-blt)
[290.633430] Subtest psr2-sprite-blt: SKIP (0.000s)
[290.699544] [043/131] (740s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[292.236758] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[295.206906] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (2.971s)
[295.420360] [044/131] (735s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[296.936177] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[296.937896] Subtest psr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[297.168757] [045/131] (734s left) kms_setmode (invalid-clone-single-crtc-stealing)
[297.250203] Starting subtest: invalid-clone-single-crtc-stealing
[297.253060] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[297.444123] [046/131] (733s left) api_intel_bb (crc32)
[297.523375] Starting subtest: crc32
[297.524274] Starting dynamic subtest: rcs0-lmem0
[297.777701] Dynamic subtest rcs0-lmem0: SUCCESS (0.253s)
[297.792107] Starting dynamic subtest: rcs0-smem0
[298.095489] Dynamic subtest rcs0-smem0: SUCCESS (0.316s)
[298.109219] Starting dynamic subtest: bcs0-lmem0
[298.332501] Dynamic subtest bcs0-lmem0: SUCCESS (0.234s)
[298.347014] Starting dynamic subtest: bcs0-smem0
[298.663779] Dynamic subtest bcs0-smem0: SUCCESS (0.329s)
[298.681811] Starting dynamic subtest: vcs0-lmem0
[299.087207] Dynamic subtest vcs0-lmem0: SUCCESS (0.421s)
[299.099992] Starting dynamic subtest: vcs0-smem0
[299.639123] Dynamic subtest vcs0-smem0: SUCCESS (0.549s)
[299.651812] Starting dynamic subtest: vcs1-lmem0
[300.065791] Dynamic subtest vcs1-lmem0: SUCCESS (0.424s)
[300.080556] Starting dynamic subtest: vcs1-smem0
[300.618266] Dynamic subtest vcs1-smem0: SUCCESS (0.550s)
[300.631625] Starting dynamic subtest: vecs0-lmem0
[301.038297] Dynamic subtest vecs0-lmem0: SUCCESS (0.418s)
[301.053082] Starting dynamic subtest: vecs0-smem0
[301.591496] Dynamic subtest vecs0-smem0: SUCCESS (0.551s)
[301.605431] Starting dynamic subtest: vecs1-lmem0
[302.023272] Dynamic subtest vecs1-lmem0: SUCCESS (0.429s)
[302.038229] Starting dynamic subtest: vecs1-smem0
[302.578044] Dynamic subtest vecs1-smem0: SUCCESS (0.552s)
[302.590754] Starting dynamic subtest: ccs0-lmem0
[302.827190] Dynamic subtest ccs0-lmem0: SUCCESS (0.247s)
[302.842287] Starting dynamic subtest: ccs0-smem0
[303.168871] Dynamic subtest ccs0-smem0: SUCCESS (0.339s)
[303.170769] Subtest crc32: SUCCESS (5.646s)
[303.353196] [047/131] (728s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[304.872255] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[304.885956] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.013s)
[305.090587] [048/131] (726s left) kms_frontbuffer_tracking (basic)
[306.611289] Starting subtest: basic
[309.341084] Subtest basic: SUCCESS (2.730s)
[309.571204] [049/131] (721s left) gem_partial_pwrite_pread (write)
[309.659308] Subtest write: SKIP (0.000s)
[309.742872] [050/131] (721s left) gem_exec_schedule (u-fairslice)
[309.834859] Starting subtest: u-fairslice
[309.835764] Starting dynamic subtest: rcs0
[311.882497] Dynamic subtest rcs0: SUCCESS (2.046s)
[311.893174] Starting dynamic subtest: bcs0
[313.903540] Dynamic subtest bcs0: SUCCESS (2.020s)
[313.913939] Starting dynamic subtest: vcs0
[315.923107] Dynamic subtest vcs0: SUCCESS (2.019s)
[315.933409] Starting dynamic subtest: vcs1
[317.944539] Dynamic subtest vcs1: SUCCESS (2.021s)
[317.954929] Starting dynamic subtest: vecs0
[319.964540] Dynamic subtest vecs0: SUCCESS (2.019s)
[319.974969] Starting dynamic subtest: vecs1
[321.986112] Dynamic subtest vecs1: SUCCESS (2.021s)
[321.996621] Starting dynamic subtest: ccs0
[324.005870] Dynamic subtest ccs0: SUCCESS (2.019s)
[324.006858] Subtest u-fairslice: SUCCESS (14.170s)
[324.441840] [051/131] (707s left) i915_hangman (gt-error-state-capture)
[324.538298] Starting subtest: gt-error-state-capture
[324.539210] Starting dynamic subtest: rcs0
[334.143728] Dynamic subtest rcs0: SUCCESS (9.605s)
[334.166031] Starting dynamic subtest: bcs0
[344.048158] Dynamic subtest bcs0: SUCCESS (9.903s)
[344.058529] Starting dynamic subtest: vcs0
[354.036757] Dynamic subtest vcs0: SUCCESS (9.988s)
[354.047303] Starting dynamic subtest: vcs1
[364.090178] Dynamic subtest vcs1: SUCCESS (10.053s)
[364.100774] Starting dynamic subtest: vecs0
[374.072918] Dynamic subtest vecs0: SUCCESS (9.982s)
[374.083201] Starting dynamic subtest: vecs1
[384.062771] Dynamic subtest vecs1: SUCCESS (9.989s)
[384.073366] Starting dynamic subtest: ccs0
[394.143728] Dynamic subtest ccs0: SUCCESS (10.080s)
[394.144779] Subtest gt-error-state-capture: SUCCESS (69.605s)
[394.377708] [052/131] (637s left) gem_exec_fence (basic-wait)
[394.583588] Starting subtest: basic-wait
[394.584515] Starting dynamic subtest: rcs0
[394.703331] Dynamic subtest rcs0: SUCCESS (0.119s)
[394.718468] Starting dynamic subtest: bcs0
[394.757508] Dynamic subtest bcs0: SUCCESS (0.053s)
[394.776547] Starting dynamic subtest: vcs0
[394.812847] Dynamic subtest vcs0: SUCCESS (0.054s)
[394.853347] Starting dynamic subtest: vcs1
[394.877716] Dynamic subtest vcs1: SUCCESS (0.063s)
[394.894800] Starting dynamic subtest: vecs0
[394.930409] Dynamic subtest vecs0: SUCCESS (0.052s)
[394.952823] Starting dynamic subtest: vecs1
[394.985953] Dynamic subtest vecs1: SUCCESS (0.054s)
[395.024403] Starting dynamic subtest: ccs0
[395.043339] Dynamic subtest ccs0: SUCCESS (0.056s)
[395.044471] Subtest basic-wait: SUCCESS (0.460s)
[395.792273] [053/131] (636s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[397.306976] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[397.308744] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[397.538469] [054/131] (634s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[399.056511] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[399.058290] Subtest fbcpsr-rgb565-draw-mmap-wc: SKIP (0.000s)
[399.286944] [055/131] (632s left) i915_drm_fdinfo (idle)
[399.359530] Starting subtest: idle
[399.360435] Starting dynamic subtest: rcs0
[399.969551] Dynamic subtest rcs0: SUCCESS (0.609s)
[399.983094] Starting dynamic subtest: bcs0
[400.475329] Dynamic subtest bcs0: SUCCESS (0.504s)
[400.487900] Starting dynamic subtest: vcs0
[400.983243] Dynamic subtest vcs0: SUCCESS (0.503s)
[400.993582] Starting dynamic subtest: vcs1
[401.487722] Dynamic subtest vcs1: SUCCESS (0.504s)
[401.500100] Starting dynamic subtest: vecs0
[401.994075] Dynamic subtest vecs0: SUCCESS (0.504s)
[402.006658] Starting dynamic subtest: vecs1
[402.500414] Dynamic subtest vecs1: SUCCESS (0.504s)
[402.512973] Starting dynamic subtest: ccs0
[403.006938] Dynamic subtest ccs0: SUCCESS (0.504s)
[403.008532] Subtest idle: SUCCESS (3.648s)
[403.144869] [056/131] (629s left) prime_vgem (coherency-blt)
[403.252768] Starting subtest: coherency-blt
[405.548391] Subtest coherency-blt: SUCCESS (2.295s)
[405.754358] [057/131] (626s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[407.268365] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[407.270176] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[407.477262] [058/131] (624s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[408.996374] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[408.997270] Starting dynamic subtest: pipe-A-valid-mode
[409.276301] Dynamic subtest pipe-A-valid-mode: SKIP (0.278s)
[409.278583] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.280s)
[409.570402] [059/131] (622s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[411.099922] Starting subtest: y-tiled-8bpp-rotate-90
[411.101651] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[411.324186] [060/131] (621s left) i915_pm_rps (reset)
[411.414596] Starting subtest: reset
[416.217188] Subtest reset: SUCCESS (4.801s)
[416.435380] [061/131] (616s left) kms_chamelium_hpd (hdmi-hpd-storm)
[417.994725] Subtest hdmi-hpd-storm: SKIP (0.000s)
[418.105216] [062/131] (614s left) kms_dp_link_training (uhbr-mst)
[419.630132] Starting subtest: uhbr-mst
[419.631871] Subtest uhbr-mst: SKIP (0.000s)
[419.775696] [063/131] (613s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move)
[421.317261] Starting subtest: fbc-1p-primscrn-spr-indfb-move
[425.783929] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (4.466s)
[426.022342] [064/131] (606s left) kms_psr (psr-sprite-plane-onoff)
[427.537473] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[427.594511] [065/131] (605s left) gem_ctx_isolation (preservation-s3)
[427.690118] Starting subtest: preservation-S3
[427.691035] Starting dynamic subtest: rcs0
[446.761583] Dynamic subtest rcs0: SUCCESS (4.090s)
[446.774208] Starting dynamic subtest: bcs0
[466.778066] Dynamic subtest bcs0: SUCCESS (3.782s)
[466.790563] Starting dynamic subtest: vcs0
[486.786906] Dynamic subtest vcs0: SUCCESS (3.831s)
[486.798986] Starting dynamic subtest: vcs1
[506.724751] Dynamic subtest vcs1: SUCCESS (3.707s)
[506.736791] Starting dynamic subtest: vecs0
[526.740797] Dynamic subtest vecs0: SUCCESS (3.720s)
[526.753323] Starting dynamic subtest: vecs1
[546.780741] Dynamic subtest vecs1: SUCCESS (3.763s)
[546.792900] Starting dynamic subtest: ccs0
[566.752509] Dynamic subtest ccs0: SUCCESS (3.848s)
[566.753488] Subtest preservation-S3: SUCCESS (26.747s)
[577.132971] [066/131] (465s left) gem_ctx_persistence (engines-queued)
[577.226354] Starting subtest: engines-queued
[577.227256] Starting dynamic subtest: rcs0
[577.339321] Dynamic subtest rcs0: SUCCESS (0.109s)
[577.357172] Starting dynamic subtest: bcs0
[577.369071] Dynamic subtest bcs0: SUCCESS (0.028s)
[577.387006] Starting dynamic subtest: vcs0
[577.459567] Dynamic subtest vcs0: SUCCESS (0.086s)
[577.500824] Starting dynamic subtest: vcs1
[577.532184] Dynamic subtest vcs1: SUCCESS (0.068s)
[577.545488] Starting dynamic subtest: vecs0
[577.577971] Dynamic subtest vecs0: SUCCESS (0.043s)
[577.594073] Starting dynamic subtest: vecs1
[577.605129] Dynamic subtest vecs1: SUCCESS (0.025s)
[577.621562] Starting dynamic subtest: ccs0
[577.782982] Dynamic subtest ccs0: SUCCESS (0.171s)
[577.784165] Subtest engines-queued: SUCCESS (0.539s)
[577.962848] [067/131] (465s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[579.528257] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[579.530050] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[579.757841] [068/131] (463s left) perf (create-destroy-userspace-config)
[580.226863] Starting subtest: create-destroy-userspace-config
[580.255006] Subtest create-destroy-userspace-config: SUCCESS (0.028s)
[580.310708] [069/131] (462s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[581.871200] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[581.873186] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[582.075291] [070/131] (461s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[582.168029] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[582.248650] [071/131] (461s left) gem_mmap_gtt (big-copy-odd)
[582.337045] Subtest big-copy-odd: SKIP (0.000s)
[582.440533] [072/131] (461s left) kms_vblank (query-idle)
[583.982804] Starting subtest: query-idle
[583.983718] Starting dynamic subtest: pipe-A-HDMI-A-3
[586.299655] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.287s)
[586.313786] Starting dynamic subtest: pipe-D-HDMI-A-3
[588.492150] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.169s)
[588.493119] Subtest query-idle: SUCCESS (4.461s)
[588.722032] [073/131] (454s left) kms_cursor_edge_walk (256x256-top-edge)
[590.250875] Starting subtest: 256x256-top-edge
[590.251698] Starting dynamic subtest: pipe-A-HDMI-A-3
[593.589412] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (3.320s)
[593.603495] Starting dynamic subtest: pipe-D-HDMI-A-3
[596.821537] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (3.217s)
[596.822477] Subtest 256x256-top-edge: SUCCESS (6.541s)
[597.099288] [074/131] (446s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[597.182100] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[597.183023] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[597.330776] [075/131] (446s left) dumb_buffer (create-valid-dumb)
[597.411173] Starting subtest: create-valid-dumb
[597.412157] Subtest create-valid-dumb: SUCCESS (0.000s)
[597.614580] [076/131] (446s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[599.135576] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[599.137148] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[599.361036] [077/131] (444s left) kms_pm_dc (dc5-dpms)
[601.890018] Starting subtest: dc5-dpms
[603.118804] Subtest dc5-dpms: SUCCESS (1.226s)
[603.253232] [078/131] (440s left) perf (per-context-mode-unprivileged)
[603.492787] Starting subtest: per-context-mode-unprivileged
[603.494694] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[603.546868] [079/131] (440s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[603.630369] Starting subtest: invalid-bsd2-flag-on-vebox
[603.631256] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[603.829118] [080/131] (440s left) syncobj_timeline (invalid-transfer-illegal-handle)
[603.917251] Starting subtest: invalid-transfer-illegal-handle
[603.918152] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[604.129941] [081/131] (440s left) kms_flip (2x-flip-vs-fences-interruptible)
[605.649284] Starting subtest: 2x-flip-vs-fences-interruptible
[605.651048] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[605.874594] [082/131] (438s left) kms_atomic (plane-overlay-legacy)
[607.396690] Starting subtest: plane-overlay-legacy
[607.397651] Starting dynamic subtest: pipe-A-HDMI-A-3
[608.042315] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.644s)
[608.043220] Subtest plane-overlay-legacy: SUCCESS (0.646s)
[608.307616] [083/131] (436s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[609.828258] Starting subtest: 4-tiled-8bpp-rotate-90
[609.884511] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.055s)
[610.127480] [084/131] (434s left) gem_lmem_swapping (verify-random)
[614.804147] Starting subtest: verify-random
[614.804934] Starting dynamic subtest: lmem0
[622.673001] Dynamic subtest lmem0: SUCCESS (7.864s)
[622.673947] Subtest verify-random: SUCCESS (7.865s)
[623.647049] [FACT gem_lmem_swapping (verify-random)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[623.648055] [FACT gem_lmem_swapping (verify-random)] deleted: kernel.kmod_is_loaded.i915: true
[623.650066] [085/131] (420s left) gem_mmap_offset (mmap-unmap)
[627.179639] Starting subtest: mmap-unmap
[627.181101] Starting dynamic subtest: lmem0
[628.146138] Dynamic subtest lmem0: SUCCESS (0.966s)
[628.157529] Starting dynamic subtest: smem0
[629.537093] Dynamic subtest smem0: SUCCESS (1.389s)
[629.538050] Subtest mmap-unmap: SUCCESS (2.357s)
[629.667489] [FACT gem_mmap_offset (mmap-unmap)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[629.669860] [FACT gem_mmap_offset (mmap-unmap)] new: kernel.kmod_is_loaded.i915: true
[629.672430] [086/131] (414s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[629.784227] Subtest flip-primary-invalidate-overlay: SKIP (0.000s)
[629.854065] [087/131] (414s left) kms_plane_multiple (tiling-x)
[631.385867] Starting subtest: tiling-x
[631.386889] Starting dynamic subtest: pipe-A-HDMI-A-3
[632.249258] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.862s)
[632.261838] Starting dynamic subtest: pipe-B-HDMI-A-3
[632.991759] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.741s)
[633.004266] Starting dynamic subtest: pipe-C-HDMI-A-3
[633.742285] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.748s)
[633.755023] Starting dynamic subtest: pipe-D-HDMI-A-3
[634.482182] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.737s)
[634.483116] Subtest tiling-x: SUCCESS (3.096s)
[634.779274] [088/131] (410s left) gem_exec_flush (basic-batch-kernel-default-uc)
[634.869918] Subtest basic-batch-kernel-default-uc: SKIP (0.000s)
[634.980913] [089/131] (409s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[636.500676] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[636.502304] Subtest psr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[636.737188] [090/131] (408s left) kms_vblank (wait-forked)
[638.249920] Starting subtest: wait-forked
[638.250843] Starting dynamic subtest: pipe-A-HDMI-A-3
[640.595321] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.343s)
[640.611706] Starting dynamic subtest: pipe-D-HDMI-A-3
[642.823894] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.222s)
[642.824794] Subtest wait-forked: SUCCESS (4.572s)
[643.053818] [091/131] (402s left) kms_color (ctm-signed)
[644.568879] Starting subtest: ctm-signed
[644.569762] Starting dynamic subtest: pipe-A-HDMI-A-3
[645.736530] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (1.167s)
[645.748917] Starting dynamic subtest: pipe-B-HDMI-A-3
[646.672860] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (0.934s)
[646.684097] Starting dynamic subtest: pipe-C-HDMI-A-3
[647.633752] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (0.959s)
[647.645251] Starting dynamic subtest: pipe-D-HDMI-A-3
[648.595484] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.962s)
[648.596292] Subtest ctm-signed: SUCCESS (4.026s)
[648.842034] [092/131] (396s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[650.365224] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[650.415758] [093/131] (394s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[651.933962] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[651.935708] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[652.196393] [094/131] (393s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[653.734119] Starting subtest: fbc-rgb101010-draw-mmap-wc
[653.735893] Subtest fbc-rgb101010-draw-mmap-wc: SKIP (0.000s)
[653.966261] [095/131] (391s left) kms_cursor_crc (cursor-random-128x42)
[655.697880] Starting subtest: cursor-random-128x42
[655.702967] Starting dynamic subtest: pipe-A-HDMI-A-3
[660.101671] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (4.396s)
[660.143082] Starting dynamic subtest: pipe-D-HDMI-A-3
[664.520624] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (4.385s)
[664.521493] Subtest cursor-random-128x42: SUCCESS (8.818s)
[664.918714] [096/131] (380s left) gem_basic (create-fd-close)
[664.996172] Starting subtest: create-fd-close
[664.998010] Subtest create-fd-close: SUCCESS (0.000s)
[665.200390] [097/131] (380s left) gem_bad_reloc (negative-reloc)
[665.287802] Subtest negative-reloc: SKIP (0.000s)
[665.363026] [098/131] (380s left) gem_exec_reloc (basic-write-gtt-noreloc)
[665.449601] Subtest basic-write-gtt-noreloc: SKIP (0.000s)
[665.566813] [099/131] (380s left) vgem_basic (dmabuf-mmap)
[665.634093] Starting subtest: dmabuf-mmap
[665.666000] Subtest dmabuf-mmap: SUCCESS (0.032s)
[665.783475] [100/131] (380s left) perf (unprivileged-single-ctx-counters)
[666.234185] Starting subtest: unprivileged-single-ctx-counters
[666.236002] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[666.299701] [101/131] (379s left) gem_mmap_gtt (basic-small-copy)
[666.382914] Subtest basic-small-copy: SKIP (0.000s)
[666.474690] [102/131] (379s left) kms_async_flips (async-flip-suspend-resume)
[667.993917] Starting subtest: async-flip-suspend-resume
[668.231536] Starting dynamic subtest: pipe-A-HDMI-A-3
[688.628459] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (4.933s)
[688.793695] Starting dynamic subtest: pipe-B-HDMI-A-3
[708.636229] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (4.438s)
[708.783590] Starting dynamic subtest: pipe-C-HDMI-A-3
[728.648664] Dynamic subtest pipe-C-HDMI-A-3: SUCCESS (4.487s)
[728.792879] Starting dynamic subtest: pipe-D-HDMI-A-3
[749.618894] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (4.459s)
[749.619749] Subtest async-flip-suspend-resume: SUCCESS (18.984s)
[755.014779] [103/131] (296s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[756.581969] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[756.681730] [104/131] (294s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[758.598525] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[758.600313] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[758.846714] [105/131] (292s left) i915_query (engine-info-invalid)
[758.926118] Starting subtest: engine-info-invalid
[758.927000] Subtest engine-info-invalid: SUCCESS (0.000s)
[759.111967] [106/131] (292s left) perf (polling-parameterized)
[759.392249] Starting subtest: polling-parameterized
[779.427031] Subtest polling-parameterized: SUCCESS (20.025s)
[779.495018] [107/131] (271s left) api_intel_allocator (fork-simple-once)
[779.576289] Starting subtest: fork-simple-once
[779.613826] Subtest fork-simple-once: SUCCESS (0.039s)
[779.848922] [108/131] (271s left) kms_cursor_crc (cursor-sliding-32x32)
[781.471823] Starting subtest: cursor-sliding-32x32
[781.525528] Subtest cursor-sliding-32x32: SKIP (0.052s)
[781.988860] [109/131] (269s left) gem_mmap_wc (read)
[782.067728] Subtest read: SKIP (0.000s)
[782.147601] [110/131] (269s left) kms_psr (fbc-pr-sprite-render)
[783.670784] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[783.728874] [111/131] (267s left) gem_vm_create (execbuf)
[783.815032] Starting subtest: execbuf
[783.824579] Subtest execbuf: SUCCESS (0.009s)
[784.027506] [112/131] (267s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[785.559093] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[786.665939] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (1.107s)
[786.927447] [113/131] (264s left) gem_render_copy (linear-to-vebox-y-tiled)
[787.013312] Starting subtest: linear-to-vebox-y-tiled
[787.015260] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[787.296671] [114/131] (264s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[788.816492] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[788.879372] [115/131] (263s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[790.401588] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[790.402518] Starting dynamic subtest: pipe-A-HDMI-A-3
[790.405956] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s)
[790.417800] Starting dynamic subtest: pipe-B-HDMI-A-3
[790.421408] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s)
[790.433063] Starting dynamic subtest: pipe-C-HDMI-A-3
[790.436692] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s)
[790.448099] Starting dynamic subtest: pipe-D-HDMI-A-3
[790.451606] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s)
[790.453768] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SKIP (0.008s)
[790.729883] [116/131] (261s left) kms_plane_alpha_blend (constant-alpha-max)
[792.242694] Starting subtest: constant-alpha-max
[792.488788] Starting dynamic subtest: pipe-A-HDMI-A-3
[793.372480] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (0.884s)
[793.385837] Starting dynamic subtest: pipe-D-HDMI-A-3
[794.247288] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (0.872s)
[794.248069] Subtest constant-alpha-max: SUCCESS (2.006s)
[794.493986] [117/131] (257s left) gem_flink_basic (double-flink)
[794.573360] Starting subtest: double-flink
[794.574379] Subtest double-flink: SUCCESS (0.000s)
[794.764554] [118/131] (257s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25)
[796.289709] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25
[796.290681] Starting dynamic subtest: pipe-A
[796.382060] Dynamic subtest pipe-A: SUCCESS (0.093s)
[796.403432] Starting dynamic subtest: pipe-B
[796.564897] Dynamic subtest pipe-B: SUCCESS (0.181s)
[796.583385] Starting dynamic subtest: pipe-C
[796.707131] Dynamic subtest pipe-C: SUCCESS (0.141s)
[796.721018] Starting dynamic subtest: pipe-D
[796.833677] Dynamic subtest pipe-D: SUCCESS (0.125s)
[796.834655] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SUCCESS (0.546s)
[797.103565] [119/131] (255s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[797.184697] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[797.253778] [120/131] (255s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[798.772742] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[798.774499] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[798.923446] [121/131] (253s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[800.437709] Starting subtest: cursorA-vs-flipA-atomic-transitions
[811.368976] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (10.927s)
[811.624825] [122/131] (240s left) gem_pread (self)
[811.705776] Subtest self: SKIP (0.000s)
[811.777292] [123/131] (240s left) gem_exec_reloc (basic-cpu-wc)
[811.865427] Subtest basic-cpu-wc: SKIP (0.000s)
[811.974850] [124/131] (240s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[812.055040] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[812.162891] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.107s)
[812.298786] [125/131] (240s left) kms_lease (master-vs-lease)
[813.812824] Starting subtest: master-vs-lease
[813.815042] Subtest master-vs-lease: SUCCESS (0.003s)
[814.066966] [126/131] (238s left) gem_exec_balancer (busy)
[814.174298] Starting subtest: busy
[815.086782] Subtest busy: SUCCESS (0.912s)
[815.529627] [127/131] (237s left) gen9_exec_parse (bb-start-param)
[815.615326] Subtest bb-start-param: SKIP (0.000s)
[815.713246] [128/131] (237s left) kms_pm_rpm (i2c)
[819.967022] Starting subtest: i2c
[823.657302] Subtest i2c: SUCCESS (3.686s)
[824.581900] [129/131] (228s left) kms_flip (plain-flip-ts-check)
[826.123911] Starting subtest: plain-flip-ts-check
[826.129898] Starting dynamic subtest: A-HDMI-A3
[834.176109] Dynamic subtest A-HDMI-A3: SUCCESS (8.042s)
[834.193109] Starting dynamic subtest: B-HDMI-A3
[842.150603] Dynamic subtest B-HDMI-A3: SUCCESS (7.965s)
[842.167159] Starting dynamic subtest: C-HDMI-A3
[850.125186] Dynamic subtest C-HDMI-A3: SUCCESS (7.966s)
[850.141896] Starting dynamic subtest: D-HDMI-A3
[858.109449] Dynamic subtest D-HDMI-A3: SUCCESS (7.982s)
[858.116511] Subtest plain-flip-ts-check: SUCCESS (31.979s)
[858.407684] [130/131] (194s left) gem_exec_params (invalid-ring2)
[858.492738] Starting subtest: invalid-ring2
[858.493776] Subtest invalid-ring2: SUCCESS (0.000s)
[858.704701] [131/131] (194s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite)
[860.223816] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite
[860.225718] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[860.463660] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: vgem_basic
results: parsing output: 2/ for test: gem_exec_alignment
results: parsing output: 3/ for test: gem_userptr_blits
results: parsing output: 4/ for test: perf_pmu
results: parsing output: 5/ for test: prime_mmap
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_joiner
results: parsing output: 8/ for test: gem_exec_schedule
results: parsing output: 9/ for test: gem_exec_whisper
results: parsing output: 10/ for test: gem_lmem_swapping
results: parsing output: 11/ for test: kms_content_protection
results: parsing output: 12/ for test: gem_exec_schedule
results: parsing output: 13/ for test: kms_chamelium_color
results: parsing output: 14/ for test: kms_big_fb
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: syncobj_timeline
results: parsing output: 17/ for test: gem_linear_blits
results: parsing output: 18/ for test: gem_workarounds
results: parsing output: 19/ for test: kms_ccs
results: parsing output: 20/ for test: kms_ccs
results: parsing output: 21/ for test: kms_cursor_legacy
results: parsing output: 22/ for test: kms_psr
results: parsing output: 23/ for test: kms_atomic_transition
results: parsing output: 24/ for test: gem_exec_fence
results: parsing output: 25/ for test: gem_render_copy
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: syncobj_timeline
results: parsing output: 28/ for test: sysfs_heartbeat_interval
results: parsing output: 29/ for test: sw_sync
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_prime
results: parsing output: 33/ for test: kms_ccs
results: parsing output: 34/ for test: kms_feature_discovery
results: parsing output: 35/ for test: gem_create
results: parsing output: 36/ for test: prime_mmap
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_flip_scaled_crc
results: parsing output: 39/ for test: gem_softpin
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_psr
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_setmode
results: parsing output: 45/ for test: api_intel_bb
results: parsing output: 46/ for test: kms_flip
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: gem_partial_pwrite_pread
results: parsing output: 49/ for test: gem_exec_schedule
results: parsing output: 50/ for test: i915_hangman
results: parsing output: 51/ for test: gem_exec_fence
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: i915_drm_fdinfo
results: parsing output: 55/ for test: prime_vgem
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_flip_scaled_crc
results: parsing output: 58/ for test: kms_big_fb
results: parsing output: 59/ for test: i915_pm_rps
results: parsing output: 60/ for test: kms_chamelium_hpd
results: parsing output: 61/ for test: kms_dp_link_training
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_psr
results: parsing output: 64/ for test: gem_ctx_isolation
results: parsing output: 65/ for test: gem_ctx_persistence
results: parsing output: 66/ for test: kms_big_fb
results: parsing output: 67/ for test: perf
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: gem_fenced_exec_thrash
results: parsing output: 70/ for test: gem_mmap_gtt
results: parsing output: 71/ for test: kms_vblank
results: parsing output: 72/ for test: kms_cursor_edge_walk
results: parsing output: 73/ for test: syncobj_wait
results: parsing output: 74/ for test: dumb_buffer
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_pm_dc
results: parsing output: 77/ for test: perf
results: parsing output: 78/ for test: gem_exec_params
results: parsing output: 79/ for test: syncobj_timeline
results: parsing output: 80/ for test: kms_flip
results: parsing output: 81/ for test: kms_atomic
results: parsing output: 82/ for test: kms_big_fb
results: parsing output: 83/ for test: gem_lmem_swapping
results: parsing output: 84/ for test: gem_mmap_offset
results: parsing output: 85/ for test: kms_psr_stress_test
results: parsing output: 86/ for test: kms_plane_multiple
results: parsing output: 87/ for test: gem_exec_flush
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_vblank
results: parsing output: 90/ for test: kms_color
results: parsing output: 91/ for test: kms_psr2_sf
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_cursor_crc
results: parsing output: 95/ for test: gem_basic
results: parsing output: 96/ for test: gem_bad_reloc
results: parsing output: 97/ for test: gem_exec_reloc
results: parsing output: 98/ for test: vgem_basic
results: parsing output: 99/ for test: perf
results: parsing output: 100/ for test: gem_mmap_gtt
results: parsing output: 101/ for test: kms_async_flips
results: parsing output: 102/ for test: kms_chamelium_edid
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: i915_query
results: parsing output: 105/ for test: perf
results: parsing output: 106/ for test: api_intel_allocator
results: parsing output: 107/ for test: kms_cursor_crc
results: parsing output: 108/ for test: gem_mmap_wc
results: parsing output: 109/ for test: kms_psr
results: parsing output: 110/ for test: gem_vm_create
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: gem_render_copy
results: parsing output: 113/ for test: kms_psr2_sf
results: parsing output: 114/ for test: kms_ccs
results: parsing output: 115/ for test: kms_plane_alpha_blend
results: parsing output: 116/ for test: gem_flink_basic
results: parsing output: 117/ for test: kms_plane_scaling
results: parsing output: 118/ for test: kms_pipe_b_c_ivb
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_cursor_legacy
results: parsing output: 121/ for test: gem_pread
results: parsing output: 122/ for test: gem_exec_reloc
results: parsing output: 123/ for test: syncobj_timeline
results: parsing output: 124/ for test: kms_lease
results: parsing output: 125/ for test: gem_exec_balancer
results: parsing output: 126/ for test: gen9_exec_parse
results: parsing output: 127/ for test: kms_pm_rpm
results: parsing output: 128/ for test: kms_flip
results: parsing output: 129/ for test: gem_exec_params
results: parsing output: 130/ for test: kms_frontbuffer_tracking
Done.