[60.532135] Initializing watchdogs
[60.532180]   /dev/watchdog0
[60.545465] [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.549952] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.552240] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.555657] [001/133] (960s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[60.629763] Starting subtest: y-tiled-to-vebox-yf-tiled
[60.634502] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[60.827892] [002/133] (960s left) kms_flip (nonexisting-fb-interruptible)
[60.921714] Starting subtest: nonexisting-fb-interruptible
[60.924027] Starting dynamic subtest: A-eDP1
[62.323067] Dynamic subtest A-eDP1: SUCCESS (1.407s)
[62.332209] Starting dynamic subtest: B-eDP1
[63.452498] Dynamic subtest B-eDP1: SUCCESS (1.134s)
[63.459343] Starting dynamic subtest: C-eDP1
[64.581612] Dynamic subtest C-eDP1: SUCCESS (1.131s)
[64.591545] Starting dynamic subtest: D-eDP1
[65.702974] Dynamic subtest D-eDP1: SUCCESS (1.123s)
[65.705493] Subtest nonexisting-fb-interruptible: SUCCESS (4.802s)
[66.861345] [003/133] (954s left) kms_content_protection (uevent-hdcp14)
[67.230161] Starting subtest: uevent-hdcp14
[67.235122] Subtest uevent-hdcp14: SKIP (0.000s)
[67.859223] [004/133] (953s left) gem_close_race (multigpu-basic-threads)
[67.978538] Starting subtest: multigpu-basic-threads
[67.983364] Subtest multigpu-basic-threads: SKIP (0.000s)
[68.227269] [005/133] (952s left) tools_test (tools_test)
[68.277068] Starting subtest: tools_test
[68.327079] Subtest tools_test: SUCCESS (0.064s)
[68.430328] [006/133] (952s left) gem_mmap_gtt (bad-object)
[68.503430] Subtest bad-object: SKIP (0.000s)
[68.560993] [007/133] (952s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[68.611987] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[68.614435] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.001s)
[68.705241] [008/133] (952s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[68.807689] Starting subtest: fbc-indfb-scaledprimary
[71.706579] Subtest fbc-indfb-scaledprimary: SUCCESS (2.905s)
[72.880447] [009/133] (948s left) prime_mmap (test_refcounting)
[72.935826] Starting subtest: test_refcounting
[72.938133] Starting dynamic subtest: test_refcounting-smem
[72.965049] Dynamic subtest test_refcounting-smem: SUCCESS (0.031s)
[72.967358] Subtest test_refcounting: SUCCESS (0.031s)
[73.063763] [010/133] (948s left) gem_ctx_shared (q-in-order)
[73.128628] Starting subtest: Q-in-order
[73.131053] Starting dynamic subtest: rcs0
[73.256340] Dynamic subtest rcs0: SUCCESS (0.126s)
[73.270987] Starting dynamic subtest: vcs0
[73.334737] Dynamic subtest vcs0: SUCCESS (0.078s)
[73.348603] Starting dynamic subtest: vcs1
[73.410170] Dynamic subtest vcs1: SUCCESS (0.076s)
[73.425054] Starting dynamic subtest: vecs0
[73.480707] Dynamic subtest vecs0: SUCCESS (0.070s)
[73.495192] Starting dynamic subtest: ccs0
[73.569581] Dynamic subtest ccs0: SUCCESS (0.088s)
[73.572426] Subtest Q-in-order: SUCCESS (0.441s)
[74.977244] [FACT gem_ctx_shared (q-in-order)] new: kernel.kmod_is_loaded.vgem: true
[74.980438] [011/133] (946s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[75.078033] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[75.080319] Starting dynamic subtest: pipe-A-eDP-1
[75.103616] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[75.112083] Starting dynamic subtest: pipe-B-eDP-1
[75.135045] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[75.144084] Starting dynamic subtest: pipe-C-eDP-1
[75.165627] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[75.175026] Starting dynamic subtest: pipe-D-eDP-1
[75.197059] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[75.201063] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[77.234151] [012/133] (944s left) gem_exec_fence (submit-chain)
[77.416062] Starting subtest: submit-chain
[77.430311] Subtest submit-chain: SUCCESS (0.017s)
[79.027279] [013/133] (942s left) syncobj_timeline (transfer-timeline-point)
[79.089901] Starting subtest: transfer-timeline-point
[79.092291] Subtest transfer-timeline-point: SUCCESS (0.000s)
[79.202283] [014/133] (942s left) kms_psr (psr-primary-mmap-cpu)
[79.299099] Starting subtest: psr-primary-mmap-cpu
[79.301308] Starting dynamic subtest: eDP-1
[81.024185] Dynamic subtest eDP-1: SUCCESS (1.726s)
[81.026582] Subtest psr-primary-mmap-cpu: SUCCESS (1.726s)
[81.882515] [015/133] (939s left) api_intel_bb (render)
[81.931081] Starting subtest: render
[81.933164] Starting dynamic subtest: render-none-512
[82.029046] Dynamic subtest render-none-512: SUCCESS (0.100s)
[82.039246] Starting dynamic subtest: render-none-1024
[82.403820] Dynamic subtest render-none-1024: SUCCESS (0.373s)
[82.413805] Starting dynamic subtest: render-x-512
[82.488013] Dynamic subtest render-x-512: SUCCESS (0.085s)
[82.497233] Starting dynamic subtest: render-x-1024
[82.820098] Dynamic subtest render-x-1024: SUCCESS (0.331s)
[82.830294] Starting dynamic subtest: render-y-512
[82.925361] Dynamic subtest render-y-512: SUCCESS (0.106s)
[82.936244] Starting dynamic subtest: render-y-1024
[83.262889] Dynamic subtest render-y-1024: SUCCESS (0.336s)
[83.265952] Subtest render: SUCCESS (1.332s)
[83.368916] [016/133] (938s left) gem_spin_batch (legacy-resubmit-new)
[83.423879] Starting subtest: legacy-resubmit-new
[83.426171] Starting dynamic subtest: default
[83.433123] Dynamic subtest default: SUCCESS (0.009s)
[83.440744] Starting dynamic subtest: render
[83.442917] Dynamic subtest render: SUCCESS (0.002s)
[83.450215] Starting dynamic subtest: bsd
[83.452412] Dynamic subtest bsd: SUCCESS (0.004s)
[83.459318] Starting dynamic subtest: bsd1
[83.461279] Dynamic subtest bsd1: SUCCESS (0.004s)
[83.467797] Starting dynamic subtest: bsd2
[83.469662] Dynamic subtest bsd2: SUCCESS (0.004s)
[83.476336] Starting dynamic subtest: blt
[83.478219] Dynamic subtest blt: SUCCESS (0.004s)
[83.484721] Starting dynamic subtest: vebox
[83.486621] Dynamic subtest vebox: SUCCESS (0.004s)
[83.488517] Subtest legacy-resubmit-new: SUCCESS (0.033s)
[84.927322] [017/133] (936s left) vgem_basic (dmabuf-fence-before)
[84.979085] Starting subtest: dmabuf-fence-before
[84.981408] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[85.037649] [018/133] (936s left) syncobj_timeline (etime-single-wait-all-submitted)
[85.098855] Starting subtest: etime-single-wait-all-submitted
[85.202922] Subtest etime-single-wait-all-submitted: SUCCESS (0.102s)
[85.276672] [019/133] (936s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[85.390599] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[85.394713] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[85.498295] [020/133] (936s left) kms_big_fb (x-tiled-64bpp-rotate-0)
[85.597259] Starting subtest: x-tiled-64bpp-rotate-0
[87.186160] Subtest x-tiled-64bpp-rotate-0: SUCCESS (1.590s)
[87.341213] [021/133] (934s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[89.081286] Starting subtest: dpms-mode-unset-lpsp
[93.140546] Subtest dpms-mode-unset-lpsp: SUCCESS (4.061s)
[93.508424] [022/133] (928s left) kms_invalid_mode (bad-vsync-end)
[93.609367] Starting subtest: bad-vsync-end
[93.611926] Starting dynamic subtest: pipe-A-eDP-1
[93.900186] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.293s)
[93.909367] Starting dynamic subtest: pipe-B-eDP-1
[93.911370] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[93.918373] Starting dynamic subtest: pipe-C-eDP-1
[93.920346] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[93.928044] Starting dynamic subtest: pipe-D-eDP-1
[93.930361] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[93.932629] Subtest bad-vsync-end: SUCCESS (0.297s)
[94.731829] [023/133] (927s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[94.843542] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[94.848261] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[94.940915] [024/133] (927s left) kms_cursor_edge_walk (128x128-right-edge)
[95.049569] Starting subtest: 128x128-right-edge
[95.051710] Starting dynamic subtest: pipe-A-eDP-1
[98.520343] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.469s)
[98.529563] Starting dynamic subtest: pipe-D-eDP-1
[101.651306] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.129s)
[101.653288] Subtest 128x128-right-edge: SUCCESS (6.600s)
[102.440993] [025/133] (919s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[102.496790] Starting subtest: multi-wait-for-submit-unsubmitted
[102.602558] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.103s)
[102.689229] [026/133] (919s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[102.774710] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[109.480966] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (6.710s)
[109.619422] [027/133] (912s left) kms_cursor_legacy (short-flip-after-cursor-toggle)
[109.735662] Starting subtest: short-flip-after-cursor-toggle
[110.659359] Subtest short-flip-after-cursor-toggle: SUCCESS (0.924s)
[111.513247] [028/133] (910s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[111.611279] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[111.622138] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.010s)
[111.709135] [029/133] (910s left) i915_query (query-regions-unallocated)
[111.772811] Starting subtest: query-regions-unallocated
[111.775105] Subtest query-regions-unallocated: SUCCESS (0.000s)
[111.870587] [030/133] (910s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[111.982674] Starting subtest: 4-tiled-16bpp-rotate-180
[113.240550] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.259s)
[113.373268] [031/133] (908s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[113.476437] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[113.478334] Starting dynamic subtest: pipe-A-eDP-1
[113.497283] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[113.506565] Starting dynamic subtest: pipe-B-eDP-1
[113.523964] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[113.531065] Starting dynamic subtest: pipe-C-eDP-1
[113.548608] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[113.555756] Starting dynamic subtest: pipe-D-eDP-1
[113.573572] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[113.576830] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.003s)
[115.698333] [032/133] (906s left) kms_atomic_transition (plane-all-modeset-transition)
[115.791255] Starting subtest: plane-all-modeset-transition
[115.795456] Subtest plane-all-modeset-transition: SKIP (0.000s)
[115.862090] [033/133] (906s left) kms_flip (2x-nonexisting-fb-interruptible)
[115.959271] Starting subtest: 2x-nonexisting-fb-interruptible
[115.969746] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.010s)
[116.044435] [034/133] (906s left) gem_create (create-valid-nonaligned)
[116.097973] Starting subtest: create-valid-nonaligned
[116.099990] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[116.295335] [035/133] (906s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[116.377050] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[116.381769] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[116.481464] [036/133] (906s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[116.561374] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs
[116.563577] Starting dynamic subtest: pipe-A-eDP-1
[116.585805] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[116.594570] Starting dynamic subtest: pipe-B-eDP-1
[116.615604] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[116.622953] Starting dynamic subtest: pipe-C-eDP-1
[116.644035] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[116.651875] Starting dynamic subtest: pipe-D-eDP-1
[116.674418] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[116.678589] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[118.857042] [037/133] (903s left) kms_chamelium_color (ctm-0-25)
[118.956173] Subtest ctm-0-25: SKIP (0.000s)
[118.996597] [038/133] (903s left) kms_flip (basic-flip-vs-wf_vblank)
[119.093601] Starting subtest: basic-flip-vs-wf_vblank
[119.095887] Starting dynamic subtest: A-eDP1
[120.999687] Dynamic subtest A-eDP1: SUCCESS (1.909s)
[121.011028] Starting dynamic subtest: B-eDP1
[122.932843] Dynamic subtest B-eDP1: SUCCESS (1.931s)
[122.943999] Starting dynamic subtest: C-eDP1
[124.847814] Dynamic subtest C-eDP1: SUCCESS (1.913s)
[124.859644] Starting dynamic subtest: D-eDP1
[126.792709] Dynamic subtest D-eDP1: SUCCESS (1.943s)
[126.795114] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.705s)
[128.025543] [039/133] (894s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[128.116079] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[128.120450] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[128.200802] [040/133] (894s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[128.298954] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[128.301229] Starting dynamic subtest: pipe-A-eDP-1
[128.359522] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[128.369519] Starting dynamic subtest: pipe-B-eDP-1
[128.425269] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[128.434777] Starting dynamic subtest: pipe-C-eDP-1
[128.493291] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[128.502652] Starting dynamic subtest: pipe-D-eDP-1
[128.560613] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[128.564771] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.007s)
[130.492417] [041/133] (892s left) gem_softpin (evict-active-interruptible)
[130.558562] Starting subtest: evict-active-interruptible
[130.562915] Subtest evict-active-interruptible: SUCCESS (0.006s)
[130.705539] [042/133] (892s left) i915_hangman (error-state-basic)
[130.794617] Starting subtest: error-state-basic
[130.954324] Subtest error-state-basic: SUCCESS (0.159s)
[131.024533] [043/133] (891s left) kms_psr (fbc-psr2-primary-page-flip)
[131.114040] Starting subtest: fbc-psr2-primary-page-flip
[131.116243] Starting dynamic subtest: eDP-1
[131.120206] Dynamic subtest eDP-1: SKIP (0.000s)
[131.124440] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[131.195992] [044/133] (891s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[131.290262] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[131.294260] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[131.387722] [045/133] (891s left) kms_lease (master-vs-lease)
[131.484158] Starting subtest: master-vs-lease
[131.486105] Subtest master-vs-lease: SUCCESS (0.002s)
[131.577217] [046/133] (891s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf)
[131.667923] Starting subtest: fbc-psr2-overlay-plane-move-continuous-sf
[131.669933] Starting dynamic subtest: pipe-A-eDP-1
[131.754581] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s)
[131.772234] Starting dynamic subtest: pipe-B-eDP-1
[132.858055] Dynamic subtest pipe-B-eDP-1: SKIP (1.102s)
[132.862423] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (1.193s)
[134.032457] [047/133] (888s left) kms_psr (fbc-pr-cursor-plane-move)
[134.119290] Starting subtest: fbc-pr-cursor-plane-move
[134.123588] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s)
[134.216093] [048/133] (888s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[134.269706] Starting subtest: invalid-single-wait-unsubmitted
[134.272035] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[134.364300] [049/133] (888s left) gem_userptr_blits (input-checking)
[134.428403] Starting subtest: input-checking
[134.430747] Subtest input-checking: SUCCESS (0.000s)
[134.556255] [050/133] (888s left) kms_getfb (getfb2-into-addfb2)
[134.653633] Starting subtest: getfb2-into-addfb2
[134.655839] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[134.758221] [051/133] (888s left) kms_cursor_crc (cursor-offscreen-64x21)
[134.977050] Starting subtest: cursor-offscreen-64x21
[135.031491] Subtest cursor-offscreen-64x21: SKIP (0.050s)
[135.261498] [052/133] (887s left) gem_wait (write-busy)
[135.325049] Starting subtest: write-busy
[135.327085] Starting dynamic subtest: all-engines
[135.919564] Dynamic subtest all-engines: SUCCESS (0.594s)
[135.933905] Starting dynamic subtest: rcs0
[136.475030] Dynamic subtest rcs0: SUCCESS (0.554s)
[136.489091] Starting dynamic subtest: bcs0
[137.022839] Dynamic subtest bcs0: SUCCESS (0.547s)
[137.037987] Starting dynamic subtest: vcs0
[138.901861] Dynamic subtest vcs0: SUCCESS (1.877s)
[138.914375] Starting dynamic subtest: vcs1
[140.885403] Dynamic subtest vcs1: SUCCESS (1.981s)
[140.899626] Starting dynamic subtest: vecs0
[142.933948] Dynamic subtest vecs0: SUCCESS (2.046s)
[142.947812] Starting dynamic subtest: ccs0
[143.484500] Dynamic subtest ccs0: SUCCESS (0.551s)
[143.486952] Subtest write-busy: SUCCESS (8.159s)
[143.678491] [053/133] (879s left) sw_sync (sync_random_merge)
[143.721379] Starting subtest: sync_random_merge
[143.761282] Subtest sync_random_merge: SUCCESS (0.043s)
[143.823120] [054/133] (879s left) kms_async_flips (crc)
[143.915979] Starting subtest: crc
[144.289938] Starting dynamic subtest: pipe-A-eDP-1
[147.156891] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.867s)
[147.532371] Starting dynamic subtest: pipe-B-eDP-1
[150.393104] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.869s)
[150.766144] Starting dynamic subtest: pipe-C-eDP-1
[153.615244] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.858s)
[153.979064] Starting dynamic subtest: pipe-D-eDP-1
[156.841747] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.872s)
[156.844076] Subtest crc: SUCCESS (12.927s)
[158.004218] [055/133] (865s left) gem_pread (exhaustion)
[158.062446] Subtest exhaustion: SKIP (0.000s)
[158.125312] [056/133] (865s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[158.210007] Starting subtest: primary-yf-tiled-reflect-x-180
[158.270053] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.059s)
[158.374903] [057/133] (864s left) kms_plane (pixel-format-yf-tiled-ccs-modifier)
[158.455027] Starting subtest: pixel-format-yf-tiled-ccs-modifier
[158.459472] Subtest pixel-format-yf-tiled-ccs-modifier: SKIP (0.000s)
[158.540162] [058/133] (864s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[158.660497] Starting subtest: basic-flip-before-cursor-atomic
[159.601487] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.940s)
[160.439179] [059/133] (862s left) syncobj_wait (invalid-reset-one-illegal-handle)
[160.500611] Starting subtest: invalid-reset-one-illegal-handle
[160.503229] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[160.611521] [060/133] (862s left) kms_psr (psr2-primary-mmap-gtt)
[160.700863] Starting subtest: psr2-primary-mmap-gtt
[160.703022] Starting dynamic subtest: eDP-1
[162.132077] Dynamic subtest eDP-1: SKIP (1.427s)
[162.137457] Subtest psr2-primary-mmap-gtt: SKIP (1.429s)
[162.266060] [061/133] (861s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[162.364663] Starting subtest: fbcpsr-slowdraw
[187.597944] Subtest fbcpsr-slowdraw: SUCCESS (25.235s)
[187.734388] [062/133] (835s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite)
[187.839218] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite
[194.741683] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.905s)
[194.864950] [063/133] (828s left) kms_psr (pr-dpms)
[194.949856] Starting subtest: pr-dpms
[194.954076] Subtest pr-dpms: SKIP (0.000s)
[195.032089] [064/133] (828s left) kms_vblank (wait-forked-hang)
[195.132762] Starting subtest: wait-forked-hang
[195.135428] Starting dynamic subtest: pipe-A-eDP-1
[221.718220] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.584s)
[221.731311] Starting dynamic subtest: pipe-D-eDP-1
[246.683707] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.962s)
[246.685976] Subtest wait-forked-hang: SUCCESS (51.551s)
[247.550873] [065/133] (776s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions)
[247.671570] Starting subtest: cursorB-vs-flipB-atomic-transitions
[247.676066] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s)
[247.835876] [066/133] (775s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[247.937399] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[248.772393] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.837s)
[248.919602] [067/133] (774s left) gem_lmem_swapping (heavy-verify-multi)
[248.978464] Subtest heavy-verify-multi: SKIP (0.000s)
[249.027839] [068/133] (774s left) prime_vgem (wait)
[249.099702] Starting subtest: wait
[249.101976] Starting dynamic subtest: rcs0
[249.140983] Dynamic subtest rcs0: SUCCESS (0.041s)
[249.148653] Starting dynamic subtest: bcs0
[249.197031] Dynamic subtest bcs0: SUCCESS (0.055s)
[249.204678] Starting dynamic subtest: vcs0
[249.240917] Dynamic subtest vcs0: SUCCESS (0.043s)
[249.248817] Starting dynamic subtest: vcs1
[249.288979] Dynamic subtest vcs1: SUCCESS (0.047s)
[249.296776] Starting dynamic subtest: vecs0
[249.333275] Dynamic subtest vecs0: SUCCESS (0.043s)
[249.341030] Starting dynamic subtest: ccs0
[249.380848] Dynamic subtest ccs0: SUCCESS (0.047s)
[249.383144] Subtest wait: SUCCESS (0.282s)
[249.524035] [069/133] (774s left) vgem_basic (unload)
[249.565069] Starting subtest: unload
[278.555603] Subtest unload: SUCCESS (28.991s)
[278.652357] [070/133] (745s left) gem_exec_whisper (basic-fds-priority)
[278.731320] Starting subtest: basic-fds-priority
[302.512967] Subtest basic-fds-priority: SUCCESS (23.779s)
[302.699270] [071/133] (721s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[302.818174] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[302.822110] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[302.900954] [072/133] (721s left) gem_exec_schedule (noreorder)
[303.079046] Starting subtest: noreorder
[303.081425] Starting dynamic subtest: rcs0
[303.133828] Dynamic subtest rcs0: SUCCESS (0.054s)
[303.143318] Starting dynamic subtest: vcs0
[304.892413] Dynamic subtest vcs0: SUCCESS (1.755s)
[304.902450] Starting dynamic subtest: vcs1
[306.893972] Dynamic subtest vcs1: SUCCESS (1.999s)
[306.905125] Starting dynamic subtest: vecs0
[308.881324] Dynamic subtest vecs0: SUCCESS (1.985s)
[308.892914] Starting dynamic subtest: ccs0
[308.944248] Dynamic subtest ccs0: SUCCESS (0.061s)
[308.946977] Subtest noreorder: SUCCESS (5.866s)
[309.131128] [073/133] (714s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[309.225892] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[309.228287] Starting dynamic subtest: pipe-A
[309.290829] Dynamic subtest pipe-A: SUCCESS (0.067s)
[309.299264] Starting dynamic subtest: pipe-B
[310.480909] Dynamic subtest pipe-B: SUCCESS (1.189s)
[310.491294] Starting dynamic subtest: pipe-C
[311.598505] Dynamic subtest pipe-C: SUCCESS (1.116s)
[311.607177] Starting dynamic subtest: pipe-D
[312.730004] Dynamic subtest pipe-D: SUCCESS (1.131s)
[312.732369] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.507s)
[313.904601] [074/133] (710s left) gem_exec_params (invalid-bsd-ring)
[313.952615] Starting subtest: invalid-bsd-ring
[313.954968] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[314.044798] [075/133] (710s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[314.154941] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[314.159468] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[314.249865] [076/133] (709s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[314.342389] Starting subtest: fbcpsr-2p-rte
[314.346662] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[314.422820] [077/133] (709s left) gem_ctx_persistence (legacy-engines-persistence)
[314.482768] Starting subtest: legacy-engines-persistence
[314.485068] Starting dynamic subtest: render
[315.288287] Dynamic subtest render: SUCCESS (0.804s)
[315.302621] Starting dynamic subtest: bsd1
[316.046232] Dynamic subtest bsd1: SUCCESS (0.755s)
[316.057690] Starting dynamic subtest: bsd2
[316.814809] Dynamic subtest bsd2: SUCCESS (0.766s)
[316.826688] Starting dynamic subtest: blt
[317.564276] Dynamic subtest blt: SUCCESS (0.747s)
[317.575059] Starting dynamic subtest: vebox
[318.354082] Dynamic subtest vebox: SUCCESS (0.787s)
[318.356816] Subtest legacy-engines-persistence: SUCCESS (3.872s)
[318.448234] [078/133] (705s left) kms_plane_cursor (viewport)
[318.548799] Starting subtest: viewport
[318.552695] Starting dynamic subtest: pipe-A-eDP-1-size-64
[321.196105] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.648s)
[321.255898] Starting dynamic subtest: pipe-A-eDP-1-size-128
[323.741295] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.493s)
[323.800872] Starting dynamic subtest: pipe-A-eDP-1-size-256
[326.275195] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.482s)
[326.637828] Starting dynamic subtest: pipe-B-eDP-1-size-64
[329.760884] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.134s)
[329.821484] Starting dynamic subtest: pipe-B-eDP-1-size-128
[332.306487] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.494s)
[332.366768] Starting dynamic subtest: pipe-B-eDP-1-size-256
[334.842260] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.483s)
[335.187490] Starting dynamic subtest: pipe-C-eDP-1-size-64
[338.073234] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.896s)
[338.110928] Starting dynamic subtest: pipe-C-eDP-1-size-128
[340.251052] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.147s)
[340.288707] Starting dynamic subtest: pipe-C-eDP-1-size-256
[342.440204] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.158s)
[342.775126] Starting dynamic subtest: pipe-D-eDP-1-size-64
[345.650512] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.889s)
[345.687265] Starting dynamic subtest: pipe-D-eDP-1-size-128
[347.850307] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.170s)
[347.887947] Starting dynamic subtest: pipe-D-eDP-1-size-256
[349.995384] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.114s)
[350.312633] Subtest viewport: SUCCESS (31.764s)
[351.121429] [079/133] (673s left) gem_exec_fence (concurrent)
[351.322302] Starting subtest: concurrent
[351.326530] Subtest concurrent: SKIP (0.000s)
[353.014843] [080/133] (671s left) gem_mmap_gtt (medium-copy-odd)
[353.074446] Subtest medium-copy-odd: SKIP (0.000s)
[353.147914] [081/133] (671s left) gem_exec_parallel (userptr)
[353.223149] Starting subtest: userptr
[353.225464] Starting dynamic subtest: rcs0
[354.755178] Dynamic subtest rcs0: SUCCESS (1.530s)
[354.763766] Starting dynamic subtest: bcs0
[356.248445] Dynamic subtest bcs0: SUCCESS (1.491s)
[356.257263] Starting dynamic subtest: vcs0
[357.930956] Dynamic subtest vcs0: SUCCESS (1.681s)
[357.939936] Starting dynamic subtest: vcs1
[359.895769] Dynamic subtest vcs1: SUCCESS (1.963s)
[359.907193] Starting dynamic subtest: vecs0
[361.877909] Dynamic subtest vecs0: SUCCESS (1.979s)
[361.889612] Starting dynamic subtest: ccs0
[363.363268] Dynamic subtest ccs0: SUCCESS (1.484s)
[363.365762] Subtest userptr: SUCCESS (10.141s)
[363.560248] [082/133] (660s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[363.700064] Starting subtest: verify-pxp-execution-after-suspend-resume
[370.816732] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.119s)
[370.977402] [083/133] (653s left) kms_cursor_crc (cursor-random-512x512)
[371.247244] Starting subtest: cursor-random-512x512
[371.251678] Subtest cursor-random-512x512: SKIP (0.001s)
[371.400681] [084/133] (653s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[371.501154] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf
[371.505169] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[371.581483] [085/133] (652s left) gem_mmap_gtt (hang)
[371.636474] Subtest hang: SKIP (0.000s)
[371.693738] [086/133] (652s left) gem_exec_schedule (u-semaphore-noskip)
[371.755392] Starting subtest: u-semaphore-noskip
[372.142279] Subtest u-semaphore-noskip: SUCCESS (0.396s)
[372.474226] [087/133] (652s left) kms_big_fb (linear-16bpp-rotate-180)
[372.576393] Starting subtest: linear-16bpp-rotate-180
[373.887569] Subtest linear-16bpp-rotate-180: SUCCESS (1.311s)
[374.011073] [088/133] (650s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[374.125226] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[377.858396] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (3.735s)
[378.992282] [089/133] (645s left) gem_mmap_offset (isolation)
[379.058808] Starting subtest: isolation
[379.075759] Subtest isolation: SUCCESS (0.006s)
[379.186732] [090/133] (645s left) gem_fence_thrash (bo-write-verify-none)
[379.226423] Starting subtest: bo-write-verify-none
[379.249491] Subtest bo-write-verify-none: SKIP (0.020s)
[379.306732] [091/133] (645s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-cpu)
[379.411068] Starting subtest: psr-rgb101010-draw-mmap-cpu
[386.473161] Subtest psr-rgb101010-draw-mmap-cpu: SUCCESS (7.067s)
[386.576785] [092/133] (638s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[386.668761] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[392.763547] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.098s)
[393.926645] [093/133] (630s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[394.019677] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[394.023848] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[394.114375] [094/133] (630s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[394.200245] Starting subtest: coverage-vs-premult-vs-constant
[394.469650] Starting dynamic subtest: pipe-A-eDP-1
[395.037358] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.565s)
[395.046626] Starting dynamic subtest: pipe-D-eDP-1
[396.329053] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.290s)
[396.331508] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.130s)
[397.166057] [095/133] (627s left) kms_chamelium_frames (hdmi-crc-single)
[397.540448] Subtest hdmi-crc-single: SKIP (0.000s)
[398.377612] [096/133] (626s left) kms_addfb_basic (no-handle)
[398.433487] Starting subtest: no-handle
[398.435803] Subtest no-handle: SUCCESS (0.000s)
[398.566971] [097/133] (626s left) gem_wait (invalid-buf)
[398.627331] Starting subtest: invalid-buf
[398.629591] Subtest invalid-buf: SUCCESS (0.000s)
[398.828815] [098/133] (626s left) i915_drm_fdinfo (basics)
[398.870634] Starting subtest: basics
[398.872865] Subtest basics: SUCCESS (0.000s)
[398.947206] [099/133] (626s left) perf_pmu (busy-double-start)
[398.989680] Starting subtest: busy-double-start
[398.991884] Starting dynamic subtest: rcs0
[402.620691] Dynamic subtest rcs0: FAIL (3.578s)
[402.631656] Starting dynamic subtest: bcs0
[406.141825] Dynamic subtest bcs0: SUCCESS (3.576s)
[406.153433] Starting dynamic subtest: vcs0
[410.469684] Dynamic subtest vcs0: SUCCESS (4.325s)
[410.481854] Starting dynamic subtest: vcs1
[414.437936] Dynamic subtest vcs1: SUCCESS (3.966s)
[414.449965] Starting dynamic subtest: vecs0
[418.407751] Dynamic subtest vecs0: SUCCESS (3.967s)
[418.419732] Starting dynamic subtest: ccs0
[422.045600] Dynamic subtest ccs0: FAIL (3.569s)
[422.047460] Subtest busy-double-start: FAIL (22.993s)
[422.088463] [100/133] (603s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[422.189742] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[422.194193] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[422.300009] [101/133] (602s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[422.369492] Starting subtest: invalid-multi-wait-unsubmitted
[422.371418] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[422.464025] [102/133] (602s left) gem_ctx_persistence (engines-mixed)
[422.517893] Starting subtest: engines-mixed
[422.520701] Starting dynamic subtest: rcs0
[422.584390] Dynamic subtest rcs0: SUCCESS (0.067s)
[422.596995] Starting dynamic subtest: bcs0
[422.651951] Dynamic subtest bcs0: SUCCESS (0.065s)
[422.663872] Starting dynamic subtest: vcs0
[422.691457] Dynamic subtest vcs0: SUCCESS (0.039s)
[422.701284] Starting dynamic subtest: vcs1
[422.733493] Dynamic subtest vcs1: SUCCESS (0.040s)
[422.743743] Starting dynamic subtest: vecs0
[422.788817] Dynamic subtest vecs0: SUCCESS (0.053s)
[422.800594] Starting dynamic subtest: ccs0
[422.835430] Dynamic subtest ccs0: SUCCESS (0.045s)
[422.837762] Subtest engines-mixed: SUCCESS (0.319s)
[422.921569] [103/133] (602s left) gen9_exec_parse (basic-rejected)
[422.985461] Subtest basic-rejected: SKIP (0.000s)
[423.059214] [104/133] (602s left) vgem_basic (busy-fence)
[423.111999] Starting subtest: busy-fence
[423.113713] Subtest busy-fence: SUCCESS (0.000s)
[423.165610] [105/133] (602s left) kms_draw_crc (draw-method-blt)
[423.254178] Starting subtest: draw-method-blt
[423.255952] Starting dynamic subtest: xrgb8888-untiled
[423.508070] Dynamic subtest xrgb8888-untiled: SUCCESS (0.255s)
[423.518288] Starting dynamic subtest: rgb565-untiled
[423.719120] Dynamic subtest rgb565-untiled: SUCCESS (0.210s)
[423.728277] Starting dynamic subtest: xrgb2101010-untiled
[423.929742] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.210s)
[423.941037] Starting dynamic subtest: xbgr16161616f-untiled
[424.141215] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.208s)
[424.150549] Starting dynamic subtest: xrgb8888-xtiled
[424.264308] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s)
[424.286367] Starting dynamic subtest: rgb565-xtiled
[424.385973] Dynamic subtest rgb565-xtiled: SUCCESS (0.119s)
[424.400764] Starting dynamic subtest: xrgb2101010-xtiled
[424.496898] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s)
[424.508232] Starting dynamic subtest: xbgr16161616f-xtiled
[424.607977] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.109s)
[424.619795] Starting dynamic subtest: xrgb8888-4tiled
[424.719717] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.110s)
[424.729329] Starting dynamic subtest: rgb565-4tiled
[424.829901] Dynamic subtest rgb565-4tiled: SUCCESS (0.110s)
[424.838481] Starting dynamic subtest: xrgb2101010-4tiled
[424.941218] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.110s)
[424.950958] Starting dynamic subtest: xbgr16161616f-4tiled
[425.052428] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.110s)
[425.054358] Subtest draw-method-blt: SUCCESS (1.800s)
[425.157485] [106/133] (600s left) gem_exec_balancer (hog)
[425.216076] Starting subtest: hog
[425.219788] Subtest hog: SKIP (0.000s)
[425.506790] [107/133] (599s left) api_intel_allocator (alloc-simple)
[425.552100] Starting subtest: alloc-simple
[425.554501] Subtest alloc-simple: SUCCESS (0.003s)
[425.667248] [108/133] (599s left) kms_cursor_legacy (torture-bo)
[425.777689] Starting subtest: torture-bo
[425.779962] Starting dynamic subtest: pipe-A
[432.359102] Dynamic subtest pipe-A: SUCCESS (6.578s)
[432.370804] Starting dynamic subtest: pipe-B
[438.951680] Dynamic subtest pipe-B: SUCCESS (6.589s)
[438.963495] Starting dynamic subtest: pipe-C
[445.227920] Dynamic subtest pipe-C: SUCCESS (6.274s)
[445.245448] Starting dynamic subtest: pipe-D
[452.045939] Dynamic subtest pipe-D: SUCCESS (6.815s)
[452.062420] Starting dynamic subtest: all-pipes
[459.007068] Dynamic subtest all-pipes: SUCCESS (6.958s)
[459.009694] Subtest torture-bo: SUCCESS (33.226s)
[459.166071] [109/133] (566s left) gem_exec_params (cliprects-invalid)
[459.236199] Starting subtest: cliprects-invalid
[459.238813] Subtest cliprects-invalid: SUCCESS (0.000s)
[459.339572] [110/133] (566s left) prime_mmap (test_dup)
[459.402760] Starting subtest: test_dup
[459.404673] Starting dynamic subtest: test_dup-smem
[459.440671] Dynamic subtest test_dup-smem: SUCCESS (0.037s)
[459.443161] Subtest test_dup: SUCCESS (0.038s)
[459.511809] [111/133] (566s left) kms_flip (bo-too-big-interruptible)
[459.622262] Starting subtest: bo-too-big-interruptible
[459.624212] Starting dynamic subtest: A-eDP1
[460.947364] Dynamic subtest A-eDP1: SUCCESS (1.325s)
[460.956966] Starting dynamic subtest: B-eDP1
[462.174756] Dynamic subtest B-eDP1: SUCCESS (1.226s)
[462.184608] Starting dynamic subtest: C-eDP1
[463.424985] Dynamic subtest C-eDP1: SUCCESS (1.248s)
[463.436931] Starting dynamic subtest: D-eDP1
[464.748070] Dynamic subtest D-eDP1: SUCCESS (1.320s)
[464.750768] Subtest bo-too-big-interruptible: SUCCESS (5.130s)
[465.965351] [112/133] (559s left) kms_busy (extended-pageflip-hang-oldfb)
[466.064181] Starting subtest: extended-pageflip-hang-oldfb
[466.066530] Starting dynamic subtest: pipe-A
[466.455583] Dynamic subtest pipe-A: SUCCESS (0.389s)
[466.465806] Starting dynamic subtest: pipe-D
[467.589289] Dynamic subtest pipe-D: SUCCESS (1.132s)
[467.591569] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.526s)
[468.422752] [113/133] (557s left) i915_pm_rps (fence-order)
[468.477632] Starting subtest: fence-order
[471.594866] Subtest fence-order: SUCCESS (3.115s)
[471.728025] [114/133] (553s left) kms_plane (plane-position-hole-dpms)
[471.826044] Starting subtest: plane-position-hole-dpms
[472.317317] Starting dynamic subtest: pipe-A-plane-1
[474.697786] Dynamic subtest pipe-A-plane-1: SUCCESS (2.383s)
[474.708349] Starting dynamic subtest: pipe-A-plane-2
[477.075176] Dynamic subtest pipe-A-plane-2: SUCCESS (2.375s)
[477.084229] Starting dynamic subtest: pipe-A-plane-3
[479.426673] Dynamic subtest pipe-A-plane-3: SUCCESS (2.352s)
[479.436851] Starting dynamic subtest: pipe-A-plane-4
[481.788387] Dynamic subtest pipe-A-plane-4: SUCCESS (2.360s)
[481.798703] Starting dynamic subtest: pipe-A-plane-5
[481.814607] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s)
[482.981615] Starting dynamic subtest: pipe-B-plane-1
[485.384920] Dynamic subtest pipe-B-plane-1: SUCCESS (2.412s)
[485.396353] Starting dynamic subtest: pipe-B-plane-2
[487.801106] Dynamic subtest pipe-B-plane-2: SUCCESS (2.416s)
[487.810466] Starting dynamic subtest: pipe-B-plane-3
[490.222820] Dynamic subtest pipe-B-plane-3: SUCCESS (2.418s)
[490.232662] Starting dynamic subtest: pipe-B-plane-4
[492.604372] Dynamic subtest pipe-B-plane-4: SUCCESS (2.381s)
[492.614315] Starting dynamic subtest: pipe-B-plane-5
[492.628352] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[492.630625] Subtest plane-position-hole-dpms: SUCCESS (20.802s)
[493.423385] [115/133] (532s left) kms_pm_rpm (legacy-planes)
[495.060340] Starting subtest: legacy-planes
[495.062523] Starting dynamic subtest: plane-65
[503.338686] Dynamic subtest plane-65: SUCCESS (8.280s)
[503.349185] Starting dynamic subtest: plane-95
[511.752624] Dynamic subtest plane-95: SUCCESS (8.411s)
[511.764844] Starting dynamic subtest: plane-125
[520.041991] Dynamic subtest plane-125: SUCCESS (8.286s)
[520.054268] Starting dynamic subtest: plane-135
[528.460882] Dynamic subtest plane-135: SUCCESS (8.416s)
[528.463620] Subtest legacy-planes: SUCCESS (33.405s)
[528.870251] [116/133] (496s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[528.977622] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[532.899018] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (3.925s)
[534.052828] [117/133] (491s left) kms_color (deep-color)
[534.146173] Starting subtest: deep-color
[535.211773] Starting dynamic subtest: pipe-A-eDP-1-gamma
[535.923603] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.712s)
[535.933383] Starting dynamic subtest: pipe-A-eDP-1-degamma
[537.404867] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.479s)
[537.415157] Starting dynamic subtest: pipe-A-eDP-1-ctm
[538.819042] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.415s)
[539.606330] Starting dynamic subtest: pipe-B-eDP-1-gamma
[540.320645] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.722s)
[540.330029] Starting dynamic subtest: pipe-B-eDP-1-degamma
[541.808583] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.488s)
[541.820070] Starting dynamic subtest: pipe-B-eDP-1-ctm
[543.223070] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.413s)
[543.999872] Starting dynamic subtest: pipe-C-eDP-1-gamma
[544.682474] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.692s)
[544.692087] Starting dynamic subtest: pipe-C-eDP-1-degamma
[546.062259] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.378s)
[546.072707] Starting dynamic subtest: pipe-C-eDP-1-ctm
[547.473455] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.409s)
[548.291633] Starting dynamic subtest: pipe-D-eDP-1-gamma
[548.976047] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.691s)
[548.985240] Starting dynamic subtest: pipe-D-eDP-1-degamma
[550.351132] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.375s)
[550.361039] Starting dynamic subtest: pipe-D-eDP-1-ctm
[551.768434] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.417s)
[551.770683] Subtest deep-color: SUCCESS (17.624s)
[552.639506] [118/133] (473s left) syncobj_eventfd (timeline-wait)
[552.696870] Starting subtest: timeline-wait
[552.707516] Subtest timeline-wait: SUCCESS (0.011s)
[552.782988] [119/133] (473s left) kms_psr (fbc-psr2-sprite-render)
[552.866045] Starting subtest: fbc-psr2-sprite-render
[552.868297] Starting dynamic subtest: eDP-1
[552.872594] Dynamic subtest eDP-1: SKIP (0.000s)
[552.876955] Subtest fbc-psr2-sprite-render: SKIP (0.001s)
[552.947667] [120/133] (473s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[553.039909] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[553.044276] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[553.134248] [121/133] (472s left) perf_pmu (busy-idle-no-semaphores)
[553.182164] Starting subtest: busy-idle-no-semaphores
[553.184297] Starting dynamic subtest: rcs0
[553.830867] Dynamic subtest rcs0: SUCCESS (0.648s)
[553.842994] Starting dynamic subtest: bcs0
[554.483487] Dynamic subtest bcs0: SUCCESS (0.650s)
[554.495383] Starting dynamic subtest: vcs0
[555.135066] Dynamic subtest vcs0: SUCCESS (0.649s)
[555.147176] Starting dynamic subtest: vcs1
[556.542200] Dynamic subtest vcs1: SUCCESS (1.405s)
[556.551863] Starting dynamic subtest: vecs0
[558.526345] Dynamic subtest vecs0: SUCCESS (1.980s)
[558.537664] Starting dynamic subtest: ccs0
[560.511573] Dynamic subtest ccs0: SUCCESS (1.984s)
[560.514436] Subtest busy-idle-no-semaphores: SUCCESS (7.331s)
[560.634376] [122/133] (465s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[560.746470] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[567.327165] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.583s)
[567.464239] [123/133] (458s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[567.561969] Starting subtest: 4-tiled-16bpp-rotate-270
[567.581269] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.019s)
[567.695435] [124/133] (458s left) kms_flip (2x-absolute-wf_vblank)
[567.792954] Starting subtest: 2x-absolute-wf_vblank
[567.804655] Subtest 2x-absolute-wf_vblank: SKIP (0.011s)
[567.907467] [125/133] (458s left) core_setmaster (master-drop-set-root)
[567.973895] Starting subtest: master-drop-set-root
[567.987830] Subtest master-drop-set-root: SUCCESS (0.014s)
[568.034430] [126/133] (458s left) gem_ctx_param (invalid-param-set)
[568.088855] Starting subtest: invalid-param-set
[568.091104] Subtest invalid-param-set: SUCCESS (0.000s)
[568.159720] [127/133] (458s left) kms_sequence (get-idle)
[568.257076] Starting subtest: get-idle
[568.259050] Starting dynamic subtest: pipe-A-eDP-1
[570.074553] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.819s)
[570.084502] Starting dynamic subtest: pipe-B-eDP-1
[572.546951] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.471s)
[572.557530] Starting dynamic subtest: pipe-C-eDP-1
[575.054876] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.504s)
[575.064963] Starting dynamic subtest: pipe-D-eDP-1
[577.475792] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.422s)
[577.478066] Subtest get-idle: SUCCESS (9.220s)
[578.276208] [128/133] (447s left) gem_mmap_wc (invalid-flags)
[578.329763] Subtest invalid-flags: SKIP (0.000s)
[578.385543] [129/133] (447s left) kms_chamelium_frames (vga-frame-dump)
[578.769396] Subtest vga-frame-dump: SKIP (0.000s)
[579.576805] [130/133] (446s left) kms_flip (2x-flip-vs-dpms-on-nop)
[579.668358] Starting subtest: 2x-flip-vs-dpms-on-nop
[579.679403] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.010s)
[579.753701] [131/133] (446s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite)
[579.853684] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite
[579.857792] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[579.951612] [132/133] (446s left) gem_userptr_blits (unsync-unmap-cycles)
[580.022091] Subtest unsync-unmap-cycles: SKIP (0.000s)
[580.157311] [133/133] (446s left) fbdev (eof)
[580.205317] Starting subtest: eof
[580.207704] Subtest eof: SUCCESS (0.000s)
[580.273911] Closing watchdogs
results: parsing output: 0/ for test: gem_render_copy
results: parsing output: 1/ for test: kms_flip
results: parsing output: 2/ for test: kms_content_protection
results: parsing output: 3/ for test: gem_close_race
results: parsing output: 4/ for test: tools_test
results: parsing output: 5/ for test: gem_mmap_gtt
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: prime_mmap
results: parsing output: 9/ for test: gem_ctx_shared
results: parsing output: 10/ for test: kms_ccs
results: parsing output: 11/ for test: gem_exec_fence
results: parsing output: 12/ for test: syncobj_timeline
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: api_intel_bb
results: parsing output: 15/ for test: gem_spin_batch
results: parsing output: 16/ for test: vgem_basic
results: parsing output: 17/ for test: syncobj_timeline
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: kms_pm_rpm
results: parsing output: 21/ for test: kms_invalid_mode
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_cursor_edge_walk
results: parsing output: 24/ for test: syncobj_wait
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_cursor_legacy
results: parsing output: 27/ for test: kms_flip
results: parsing output: 28/ for test: i915_query
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: kms_ccs
results: parsing output: 31/ for test: kms_atomic_transition
results: parsing output: 32/ for test: kms_flip
results: parsing output: 33/ for test: gem_create
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_ccs
results: parsing output: 36/ for test: kms_chamelium_color
results: parsing output: 37/ for test: kms_flip
results: parsing output: 38/ for test: kms_flip_scaled_crc
results: parsing output: 39/ for test: kms_ccs
results: parsing output: 40/ for test: gem_softpin
results: parsing output: 41/ for test: i915_hangman
results: parsing output: 42/ for test: kms_psr
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: kms_lease
results: parsing output: 45/ for test: kms_psr2_sf
results: parsing output: 46/ for test: kms_psr
results: parsing output: 47/ for test: syncobj_timeline
results: parsing output: 48/ for test: gem_userptr_blits
results: parsing output: 49/ for test: kms_getfb
results: parsing output: 50/ for test: kms_cursor_crc
results: parsing output: 51/ for test: gem_wait
results: parsing output: 52/ for test: sw_sync
results: parsing output: 53/ for test: kms_async_flips
results: parsing output: 54/ for test: gem_pread
results: parsing output: 55/ for test: kms_rotation_crc
results: parsing output: 56/ for test: kms_plane
results: parsing output: 57/ for test: kms_cursor_legacy
results: parsing output: 58/ for test: syncobj_wait
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_psr
results: parsing output: 63/ for test: kms_vblank
results: parsing output: 64/ for test: kms_cursor_legacy
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: gem_lmem_swapping
results: parsing output: 67/ for test: prime_vgem
results: parsing output: 68/ for test: vgem_basic
results: parsing output: 69/ for test: gem_exec_whisper
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: gem_exec_schedule
results: parsing output: 72/ for test: kms_plane_scaling
results: parsing output: 73/ for test: gem_exec_params
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: gem_ctx_persistence
results: parsing output: 77/ for test: kms_plane_cursor
results: parsing output: 78/ for test: gem_exec_fence
results: parsing output: 79/ for test: gem_mmap_gtt
results: parsing output: 80/ for test: gem_exec_parallel
results: parsing output: 81/ for test: gem_pxp
results: parsing output: 82/ for test: kms_cursor_crc
results: parsing output: 83/ for test: kms_psr2_sf
results: parsing output: 84/ for test: gem_mmap_gtt
results: parsing output: 85/ for test: gem_exec_schedule
results: parsing output: 86/ for test: kms_big_fb
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_mmap_offset
results: parsing output: 89/ for test: gem_fence_thrash
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_plane_alpha_blend
results: parsing output: 94/ for test: kms_chamelium_frames
results: parsing output: 95/ for test: kms_addfb_basic
results: parsing output: 96/ for test: gem_wait
results: parsing output: 97/ for test: i915_drm_fdinfo
results: parsing output: 98/ for test: perf_pmu
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: syncobj_wait
results: parsing output: 101/ for test: gem_ctx_persistence
results: parsing output: 102/ for test: gen9_exec_parse
results: parsing output: 103/ for test: vgem_basic
results: parsing output: 104/ for test: kms_draw_crc
results: parsing output: 105/ for test: gem_exec_balancer
results: parsing output: 106/ for test: api_intel_allocator
results: parsing output: 107/ for test: kms_cursor_legacy
results: parsing output: 108/ for test: gem_exec_params
results: parsing output: 109/ for test: prime_mmap
results: parsing output: 110/ for test: kms_flip
results: parsing output: 111/ for test: kms_busy
results: parsing output: 112/ for test: i915_pm_rps
results: parsing output: 113/ for test: kms_plane
results: parsing output: 114/ for test: kms_pm_rpm
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_color
results: parsing output: 117/ for test: syncobj_eventfd
results: parsing output: 118/ for test: kms_psr
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: perf_pmu
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: kms_flip
results: parsing output: 124/ for test: core_setmaster
results: parsing output: 125/ for test: gem_ctx_param
results: parsing output: 126/ for test: kms_sequence
results: parsing output: 127/ for test: gem_mmap_wc
results: parsing output: 128/ for test: kms_chamelium_frames
results: parsing output: 129/ for test: kms_flip
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: gem_userptr_blits
results: parsing output: 132/ for test: fbdev
Done.