[58.792325] Initializing watchdogs
[58.792387]   /dev/watchdog0
[58.810192] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[58.819972] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[58.823785] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.825912] [001/129] (960s left) i915_pm_rpm (debugfs-read)
[61.056608] Starting subtest: debugfs-read
[61.466313] Subtest debugfs-read: SUCCESS (0.410s)
[61.841917] [002/129] (957s left) gem_softpin (allocator-basic-reserve)
[61.925942] Starting subtest: allocator-basic-reserve
[62.101216] Subtest allocator-basic-reserve: SUCCESS (0.175s)
[62.279718] [003/129] (957s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[62.484840] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[63.529581] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (1.045s)
[63.827212] [004/129] (955s left) kms_pm_rpm (system-suspend-modeset)
[66.089432] Starting subtest: system-suspend-modeset
[86.738798] Subtest system-suspend-modeset: SUCCESS (5.794s)
[90.154942] [005/129] (947s left) kms_plane_alpha_blend (alpha-transparent-fb)
[90.361792] Starting subtest: alpha-transparent-fb
[90.584467] Starting dynamic subtest: pipe-A-DP-4
[91.095582] Dynamic subtest pipe-A-DP-4: SUCCESS (0.510s)
[91.104985] Starting dynamic subtest: pipe-D-DP-4
[91.672644] Dynamic subtest pipe-D-DP-4: SUCCESS (0.576s)
[91.673552] Subtest alpha-transparent-fb: SUCCESS (1.311s)
[91.987931] [006/129] (945s left) syncobj_timeline (invalid-query-bad-pad)
[92.060696] Starting subtest: invalid-query-bad-pad
[92.061664] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[92.231067] [007/129] (945s left) kms_addfb_basic (bo-too-small)
[92.435193] Starting subtest: bo-too-small
[92.436315] Subtest bo-too-small: SUCCESS (0.000s)
[92.583162] [008/129] (945s left) perf_pmu (busy-hang)
[92.647511] Starting subtest: busy-hang
[92.648402] Starting dynamic subtest: rcs0
[93.944269] Dynamic subtest rcs0: SUCCESS (1.294s)
[93.954641] Starting dynamic subtest: bcs0
[95.170534] Dynamic subtest bcs0: SUCCESS (1.225s)
[95.180962] Starting dynamic subtest: vcs0
[96.398462] Dynamic subtest vcs0: SUCCESS (1.227s)
[96.408673] Starting dynamic subtest: vcs1
[97.620409] Dynamic subtest vcs1: SUCCESS (1.221s)
[97.631131] Starting dynamic subtest: vecs0
[98.845416] Dynamic subtest vecs0: SUCCESS (1.224s)
[98.855733] Starting dynamic subtest: vecs1
[100.060365] Dynamic subtest vecs1: SUCCESS (1.214s)
[100.070775] Starting dynamic subtest: ccs0
[101.287411] Dynamic subtest ccs0: SUCCESS (1.222s)
[101.288407] Subtest busy-hang: SUCCESS (8.634s)
[101.394742] [009/129] (936s left) gem_mmap_offset (open-flood)
[101.465221] Starting subtest: open-flood
[123.087465] Subtest open-flood: SUCCESS (21.486s)
[123.227838] [010/129] (914s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[123.442540] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[123.558384] [011/129] (914s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc)
[123.764882] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc
[123.765779] Starting dynamic subtest: pipe-A-DP-4
[123.769325] Dynamic subtest pipe-A-DP-4: SKIP (0.000s)
[123.779819] Starting dynamic subtest: pipe-B-DP-4
[123.783410] Dynamic subtest pipe-B-DP-4: SKIP (0.000s)
[123.793748] Starting dynamic subtest: pipe-C-DP-4
[123.797233] Dynamic subtest pipe-C-DP-4: SKIP (0.000s)
[123.807436] Starting dynamic subtest: pipe-D-DP-4
[123.810865] Dynamic subtest pipe-D-DP-4: SKIP (0.000s)
[123.812622] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[124.207606] [012/129] (913s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy)
[124.410257] Starting subtest: 2x-long-cursor-vs-flip-legacy
[124.413301] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.002s)
[124.506535] [013/129] (913s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[124.710817] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[124.712551] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[124.841370] [014/129] (913s left) kms_cursor_edge_walk (256x256-top-edge)
[125.043998] Starting subtest: 256x256-top-edge
[125.046100] Starting dynamic subtest: pipe-A-DP-4
[128.493405] Dynamic subtest pipe-A-DP-4: SUCCESS (3.443s)
[128.511749] Starting dynamic subtest: pipe-D-DP-4
[131.824596] Dynamic subtest pipe-D-DP-4: SUCCESS (3.327s)
[131.825498] Subtest 256x256-top-edge: SUCCESS (6.774s)
[132.073760] [015/129] (906s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[132.276803] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[132.278892] Starting dynamic subtest: pipe-A-valid-mode
[134.891551] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.611s)
[134.893565] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SUCCESS (2.614s)
[135.156134] [016/129] (903s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[135.380455] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (0.000s)
[135.428509] [017/129] (902s left) gem_partial_pwrite_pread (write-uncached)
[135.506413] Subtest write-uncached: SKIP (0.000s)
[135.586126] [018/129] (902s left) kms_flip (modeset-vs-vblank-race-interruptible)
[135.795604] Starting subtest: modeset-vs-vblank-race-interruptible
[135.801197] Starting dynamic subtest: A-DP4
[138.977095] Dynamic subtest A-DP4: SUCCESS (3.175s)
[139.020929] Starting dynamic subtest: B-DP4
[142.186025] Dynamic subtest B-DP4: SUCCESS (3.203s)
[142.227692] Starting dynamic subtest: C-DP4
[145.239355] Dynamic subtest C-DP4: SUCCESS (3.047s)
[145.285384] Starting dynamic subtest: D-DP4
[148.311202] Dynamic subtest D-DP4: SUCCESS (3.065s)
[148.317974] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (12.519s)
[148.694317] [019/129] (889s left) kms_ccs (crc-primary-suspend-4-tiled-lnl-ccs)
[148.902692] Starting subtest: crc-primary-suspend-4-tiled-lnl-ccs
[148.904484] Subtest crc-primary-suspend-4-tiled-lnl-ccs: SKIP (0.000s)
[149.195254] [020/129] (889s left) i915_pm_rpm (system-suspend-devices)
[150.919813] Starting subtest: system-suspend-devices
[158.466019] Subtest system-suspend-devices: SUCCESS (7.549s)
[162.732979] [021/129] (879s left) i915_query (query-topology-matches-eu-total)
[162.804645] Starting subtest: query-topology-matches-eu-total
[162.805646] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[162.961900] [022/129] (879s left) kms_rotation_crc (sprite-rotation-180)
[163.165989] Starting subtest: sprite-rotation-180
[170.178511] Subtest sprite-rotation-180: SUCCESS (7.010s)
[170.574628] [023/129] (872s left) kms_tv_load_detect (load-detect)
[170.648534] Subtest load-detect: SKIP (0.000s)
[170.715802] [024/129] (872s left) gem_ctx_isolation (clean)
[170.798479] Starting subtest: clean
[170.799455] Starting dynamic subtest: rcs0
[170.891608] Dynamic subtest rcs0: SUCCESS (0.092s)
[170.902719] Starting dynamic subtest: bcs0
[170.975441] Dynamic subtest bcs0: SUCCESS (0.083s)
[170.987595] Starting dynamic subtest: vcs0
[171.118610] Dynamic subtest vcs0: SUCCESS (0.142s)
[171.130910] Starting dynamic subtest: vcs1
[171.212422] Dynamic subtest vcs1: SUCCESS (0.092s)
[171.223251] Starting dynamic subtest: vecs0
[171.306794] Dynamic subtest vecs0: SUCCESS (0.093s)
[171.317446] Starting dynamic subtest: vecs1
[171.408461] Dynamic subtest vecs1: SUCCESS (0.101s)
[171.419076] Starting dynamic subtest: ccs0
[171.527415] Dynamic subtest ccs0: SUCCESS (0.118s)
[171.528417] Subtest clean: SUCCESS (0.729s)
[171.825212] [025/129] (871s left) kms_busy (extended-pageflip-hang-oldfb)
[172.031806] Starting subtest: extended-pageflip-hang-oldfb
[172.032705] Starting dynamic subtest: pipe-A
[172.236764] Dynamic subtest pipe-A: SUCCESS (0.203s)
[172.255171] Starting dynamic subtest: pipe-D
[172.482378] Dynamic subtest pipe-D: SUCCESS (0.240s)
[172.483447] Subtest extended-pageflip-hang-oldfb: SUCCESS (0.451s)
[172.733093] [026/129] (870s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[172.945055] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[172.947077] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[173.083256] [027/129] (870s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[173.301658] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[174.517462] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.214s)
[174.680692] [028/129] (868s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[174.894761] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[174.896510] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[175.034988] [029/129] (868s left) kms_flip (basic-flip-vs-dpms)
[175.238985] Starting subtest: basic-flip-vs-dpms
[175.246192] Starting dynamic subtest: A-DP4
[176.100180] Dynamic subtest A-DP4: SUCCESS (0.849s)
[176.130987] Starting dynamic subtest: B-DP4
[176.927600] Dynamic subtest B-DP4: SUCCESS (0.825s)
[176.949705] Starting dynamic subtest: C-DP4
[177.741428] Dynamic subtest C-DP4: SUCCESS (0.811s)
[177.762620] Starting dynamic subtest: D-DP4
[178.554113] Dynamic subtest D-DP4: SUCCESS (0.811s)
[178.557591] Subtest basic-flip-vs-dpms: SUCCESS (3.316s)
[178.862232] [030/129] (864s left) api_intel_bb (render-ccs)
[178.936662] Starting subtest: render-ccs
[179.022364] Subtest render-ccs: SUCCESS (0.086s)
[179.222061] [031/129] (864s left) syncobj_timeline (multi-wait-for-submit-signaled)
[179.292203] Starting subtest: multi-wait-for-submit-signaled
[179.293165] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[179.435342] [032/129] (863s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-gtt)
[179.640105] Starting subtest: fbc-rgb101010-draw-mmap-gtt
[179.641843] Subtest fbc-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[179.763108] [033/129] (863s left) gem_exec_whisper (basic-contexts)
[179.854794] Starting subtest: basic-contexts
[190.543564] Subtest basic-contexts: SUCCESS (10.683s)
[190.796702] [034/129] (852s left) kms_dsc (dsc-fractional-bpp)
[190.995637] Starting subtest: dsc-fractional-bpp
[191.001135] Subtest dsc-fractional-bpp: SKIP (0.001s)
[191.083081] [035/129] (852s left) kms_vblank (wait-forked)
[191.288768] Starting subtest: wait-forked
[191.289672] Starting dynamic subtest: pipe-A-DP-4
[193.650085] Dynamic subtest pipe-A-DP-4: SUCCESS (2.359s)
[193.681939] Starting dynamic subtest: pipe-D-DP-4
[195.982746] Dynamic subtest pipe-D-DP-4: SUCCESS (2.318s)
[195.983690] Subtest wait-forked: SUCCESS (4.693s)
[196.236630] [036/129] (847s left) gem_spin_batch (legacy-resubmit)
[196.325835] Starting subtest: legacy-resubmit
[196.326756] Starting dynamic subtest: default
[196.352484] Dynamic subtest default: SUCCESS (0.026s)
[196.363681] Starting dynamic subtest: render
[196.364586] Dynamic subtest render: SUCCESS (0.001s)
[196.375963] Starting dynamic subtest: bsd
[196.377075] Dynamic subtest bsd: SUCCESS (0.002s)
[196.388211] Starting dynamic subtest: bsd1
[196.389166] Dynamic subtest bsd1: SUCCESS (0.001s)
[196.399898] Starting dynamic subtest: bsd2
[196.400818] Dynamic subtest bsd2: SUCCESS (0.002s)
[196.411587] Starting dynamic subtest: blt
[196.412716] Dynamic subtest blt: SUCCESS (0.002s)
[196.423382] Starting dynamic subtest: vebox
[196.424445] Dynamic subtest vebox: SUCCESS (0.004s)
[196.425587] Subtest legacy-resubmit: SUCCESS (0.046s)
[196.683794] [037/129] (847s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[196.756590] Starting subtest: multi-wait-all-available-submitted-signaled
[196.757759] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s)
[196.871820] [038/129] (846s left) gem_render_copy (x-tiled)
[196.951784] Starting subtest: x-tiled
[196.952698] Starting dynamic subtest: smem
[197.055844] Dynamic subtest smem: SUCCESS (0.103s)
[197.068603] Starting dynamic subtest: lmem0
[198.594697] Dynamic subtest lmem0: SUCCESS (1.537s)
[198.595786] Subtest x-tiled: SUCCESS (1.643s)
[198.852040] [039/129] (845s left) gem_exec_params (invalid-ring2)
[198.929682] Starting subtest: invalid-ring2
[198.930634] Subtest invalid-ring2: SUCCESS (0.000s)
[199.077328] [040/129] (844s left) kms_addfb_basic (basic-x-tiled-legacy)
[199.148670] Starting subtest: basic-x-tiled-legacy
[199.150486] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[199.386664] [041/129] (844s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[199.603127] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[199.605125] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[199.731139] [042/129] (844s left) kms_lease (lease-get)
[199.937393] Starting subtest: lease-get
[199.938433] Starting dynamic subtest: pipe-A-DP-4
[199.940988] Dynamic subtest pipe-A-DP-4: SUCCESS (0.002s)
[199.954799] Starting dynamic subtest: pipe-B-DP-4
[199.955692] Dynamic subtest pipe-B-DP-4: SUCCESS (0.001s)
[199.967233] Starting dynamic subtest: pipe-C-DP-4
[199.968358] Dynamic subtest pipe-C-DP-4: SUCCESS (0.001s)
[199.979388] Starting dynamic subtest: pipe-D-DP-4
[199.980534] Dynamic subtest pipe-D-DP-4: SUCCESS (0.001s)
[199.981574] Subtest lease-get: SUCCESS (0.015s)
[200.072632] [043/129] (844s left) kms_plane (plane-panning-top-left)
[200.274959] Starting subtest: plane-panning-top-left
[200.275806] Starting dynamic subtest: pipe-A
[201.032014] Dynamic subtest pipe-A: SUCCESS (0.756s)
[201.047247] Starting dynamic subtest: pipe-B
[201.714298] Dynamic subtest pipe-B: SUCCESS (0.680s)
[201.715446] Subtest plane-panning-top-left: SUCCESS (1.440s)
[202.033998] [044/129] (842s left) gem_partial_pwrite_pread (reads)
[202.109531] Subtest reads: SKIP (0.000s)
[202.174230] [045/129] (842s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[202.377270] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[202.385048] Starting dynamic subtest: A-DP4
[203.217684] Dynamic subtest A-DP4: SUCCESS (0.832s)
[203.244954] Starting dynamic subtest: B-DP4
[204.039154] Dynamic subtest B-DP4: SUCCESS (0.817s)
[204.066246] Starting dynamic subtest: C-DP4
[204.840019] Dynamic subtest C-DP4: SUCCESS (0.798s)
[204.853849] Starting dynamic subtest: D-DP4
[205.619651] Dynamic subtest D-DP4: SUCCESS (0.776s)
[205.620908] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (3.243s)
[205.930351] [046/129] (838s left) kms_chamelium_hpd (vga-hpd-after-suspend)
[206.221724] Subtest vga-hpd-after-suspend: SKIP (0.000s)
[206.401362] [047/129] (837s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[206.610303] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[206.612107] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[206.766314] [048/129] (837s left) kms_psr (fbc-pr-suspend)
[206.965452] Subtest fbc-pr-suspend: SKIP (0.000s)
[207.027596] [049/129] (837s left) kms_cursor_crc (cursor-sliding-128x42)
[207.378843] Starting subtest: cursor-sliding-128x42
[207.384300] Starting dynamic subtest: pipe-A-DP-4
[211.504504] Dynamic subtest pipe-A-DP-4: SUCCESS (4.120s)
[211.556074] Starting dynamic subtest: pipe-D-DP-4
[215.750299] Dynamic subtest pipe-D-DP-4: SUCCESS (4.206s)
[215.751373] Subtest cursor-sliding-128x42: SUCCESS (8.374s)
[216.165020] [050/129] (828s left) gem_media_fill (media-fill)
[216.239432] Subtest media-fill: SKIP (0.000s)
[216.363590] [051/129] (828s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[216.435706] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[216.514549] [052/129] (828s left) kms_atomic (plane-overlay-legacy)
[216.718102] Starting subtest: plane-overlay-legacy
[216.719039] Starting dynamic subtest: pipe-A-DP-4
[217.423556] Dynamic subtest pipe-A-DP-4: SUCCESS (0.704s)
[217.424579] Subtest plane-overlay-legacy: SUCCESS (0.706s)
[217.680595] [053/129] (827s left) gem_exec_fence (syncobj-timeline-wait)
[218.319767] Starting subtest: syncobj-timeline-wait
[218.420549] Subtest syncobj-timeline-wait: SUCCESS (0.101s)
[218.736540] [FACT gem_exec_fence (syncobj-timeline-wait)] new: kernel.kmod_is_loaded.vgem: true
[218.738898] [054/129] (826s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[218.949466] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[218.951315] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[219.107104] [055/129] (825s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[219.186479] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[219.293693] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.106s)
[219.443072] [056/129] (825s left) gem_exec_schedule (fifo)
[219.535409] Starting subtest: fifo
[219.536414] Starting dynamic subtest: rcs0
[219.807059] Dynamic subtest rcs0: SUCCESS (0.271s)
[219.818403] Starting dynamic subtest: bcs0
[220.004957] Dynamic subtest bcs0: SUCCESS (0.197s)
[220.016536] Starting dynamic subtest: vcs0
[220.212264] Dynamic subtest vcs0: SUCCESS (0.206s)
[220.223658] Starting dynamic subtest: vcs1
[220.421388] Dynamic subtest vcs1: SUCCESS (0.208s)
[220.432930] Starting dynamic subtest: vecs0
[220.629581] Dynamic subtest vecs0: SUCCESS (0.207s)
[220.641274] Starting dynamic subtest: vecs1
[220.857509] Dynamic subtest vecs1: SUCCESS (0.227s)
[220.869374] Starting dynamic subtest: ccs0
[221.069726] Dynamic subtest ccs0: SUCCESS (0.211s)
[221.070760] Subtest fifo: SUCCESS (1.535s)
[221.564220] [057/129] (823s left) kms_content_protection (legacy)
[221.827524] Starting subtest: legacy
[222.095432] Starting dynamic subtest: pipe-A-DP-4
[346.532603] Dynamic subtest pipe-A-DP-4: FAIL (124.157s)
[346.533726] Subtest legacy: FAIL (124.519s)
[346.643281] [058/129] (698s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs)
[346.853500] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs
[346.854439] Starting dynamic subtest: pipe-A-DP-4
[346.870563] Dynamic subtest pipe-A-DP-4: SKIP (0.000s)
[346.882131] Starting dynamic subtest: pipe-B-DP-4
[346.890644] Dynamic subtest pipe-B-DP-4: SKIP (0.000s)
[346.901728] Starting dynamic subtest: pipe-C-DP-4
[346.910139] Dynamic subtest pipe-C-DP-4: SKIP (0.000s)
[346.921298] Starting dynamic subtest: pipe-D-DP-4
[346.931592] Dynamic subtest pipe-D-DP-4: SKIP (0.000s)
[346.933554] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.007s)
[347.291545] [059/129] (697s left) perf_pmu (semaphore-wait)
[347.362221] Starting subtest: semaphore-wait
[347.363199] Starting dynamic subtest: rcs0
[347.896834] Dynamic subtest rcs0: SUCCESS (0.533s)
[347.914721] Starting dynamic subtest: bcs0
[348.412810] Dynamic subtest bcs0: SUCCESS (0.511s)
[348.451212] Starting dynamic subtest: vcs0
[348.932915] Dynamic subtest vcs0: SUCCESS (0.516s)
[348.950647] Starting dynamic subtest: vcs1
[349.449985] Dynamic subtest vcs1: SUCCESS (0.512s)
[349.467394] Starting dynamic subtest: vecs0
[349.966945] Dynamic subtest vecs0: SUCCESS (0.512s)
[349.984282] Starting dynamic subtest: vecs1
[350.482432] Dynamic subtest vecs1: SUCCESS (0.510s)
[350.500109] Starting dynamic subtest: ccs0
[350.998349] Dynamic subtest ccs0: SUCCESS (0.511s)
[351.000655] Subtest semaphore-wait: SUCCESS (3.638s)
[351.150267] [060/129] (694s left) gem_sync (basic-all)
[351.244650] Starting subtest: basic-all
[353.471118] Subtest basic-all: SUCCESS (2.227s)
[353.664579] [061/129] (691s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff)
[353.880263] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff
[356.733578] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (2.854s)
[356.953281] [062/129] (688s left) kms_cursor_crc (cursor-random-512x512)
[357.378840] Starting subtest: cursor-random-512x512
[357.380583] Subtest cursor-random-512x512: SKIP (0.001s)
[357.624398] [063/129] (687s left) prime_mmap (test_forked_cpu_write)
[357.706665] Starting subtest: test_forked_cpu_write
[357.707644] Starting dynamic subtest: test_forked_cpu_write-smem
[357.718258] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.011s)
[357.730306] Starting dynamic subtest: test_forked_cpu_write-lmem0
[357.731202] Dynamic subtest test_forked_cpu_write-lmem0: SUCCESS (0.012s)
[357.732188] Subtest test_forked_cpu_write: SUCCESS (0.025s)
[357.895207] [064/129] (687s left) perf (blocking)
[358.235060] Starting subtest: blocking
[358.235938] Starting dynamic subtest: 0-rcs0
[368.268423] Dynamic subtest 0-rcs0: SUCCESS (10.035s)
[368.269462] Subtest blocking: SUCCESS (10.036s)
[368.329219] [065/129] (677s left) gem_pread (display)
[368.410761] Subtest display: SKIP (0.000s)
[368.491015] [066/129] (677s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[368.709607] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[368.711431] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[368.855501] [067/129] (676s left) kms_psr (psr-cursor-mmap-cpu)
[369.065580] Subtest psr-cursor-mmap-cpu: SKIP (0.000s)
[369.123577] [068/129] (676s left) syncobj_wait (invalid-wait-illegal-handle)
[369.203179] Starting subtest: invalid-wait-illegal-handle
[369.204158] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[369.354383] [069/129] (676s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[369.571489] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[369.573386] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[369.695611] [070/129] (676s left) kms_atomic (crtc-invalid-params)
[369.900830] Starting subtest: crtc-invalid-params
[369.901708] Starting dynamic subtest: pipe-A-DP-4
[370.412770] Dynamic subtest pipe-A-DP-4: SUCCESS (0.510s)
[370.414006] Subtest crtc-invalid-params: SUCCESS (0.513s)
[370.672284] [071/129] (675s left) kms_tiled_display (basic-test-pattern)
[370.972475] Subtest basic-test-pattern: SKIP (0.000s)
[371.024937] [072/129] (675s left) gem_mmap_gtt (medium-copy-odd)
[371.105555] Subtest medium-copy-odd: SKIP (0.000s)
[371.178644] [073/129] (675s left) drm_read (invalid-buffer)
[371.450688] Starting subtest: invalid-buffer
[371.451661] Subtest invalid-buffer: SUCCESS (0.000s)
[371.682016] [074/129] (674s left) syncobj_wait (invalid-signal-bad-pad)
[371.763182] Starting subtest: invalid-signal-bad-pad
[371.764161] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[371.938622] [075/129] (674s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[372.148560] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[372.149365] Starting dynamic subtest: pipe-A
[372.532311] Dynamic subtest pipe-A: SUCCESS (0.384s)
[372.562290] Starting dynamic subtest: pipe-B
[373.017685] Dynamic subtest pipe-B: SUCCESS (0.483s)
[373.048725] Starting dynamic subtest: pipe-C
[373.503479] Dynamic subtest pipe-C: SUCCESS (0.483s)
[373.531967] Starting dynamic subtest: pipe-D
[373.988668] Dynamic subtest pipe-D: SUCCESS (0.483s)
[373.989997] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (1.842s)
[374.314570] [076/129] (672s left) kms_psr (fbc-psr-no-drrs)
[374.521514] Subtest fbc-psr-no-drrs: SKIP (0.000s)
[374.585275] [077/129] (671s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[374.812391] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[377.043777] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (2.232s)
[377.245015] [078/129] (669s left) kms_hdr (static-toggle-dpms)
[377.448769] Starting subtest: static-toggle-dpms
[380.816114] Starting dynamic subtest: pipe-A-DP-4
[382.117013] Dynamic subtest pipe-A-DP-4: SUCCESS (1.301s)
[382.118412] Subtest static-toggle-dpms: SUCCESS (4.670s)
[382.491630] [079/129] (664s left) gem_exec_basic (basic)
[382.579377] Starting subtest: basic
[382.580390] Starting dynamic subtest: rcs0-smem
[382.582707] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[382.595356] Starting dynamic subtest: bcs0-smem
[382.596321] Dynamic subtest bcs0-smem: SUCCESS (0.000s)
[382.608447] Starting dynamic subtest: vcs0-smem
[382.609664] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[382.621432] Starting dynamic subtest: vcs1-smem
[382.622631] Dynamic subtest vcs1-smem: SUCCESS (0.000s)
[382.634348] Starting dynamic subtest: vecs0-smem
[382.635478] Dynamic subtest vecs0-smem: SUCCESS (0.000s)
[382.647025] Starting dynamic subtest: vecs1-smem
[382.648146] Dynamic subtest vecs1-smem: SUCCESS (0.000s)
[382.659775] Starting dynamic subtest: ccs0-smem
[382.660818] Dynamic subtest ccs0-smem: SUCCESS (0.000s)
[382.672433] Starting dynamic subtest: rcs0-lmem0
[382.673649] Dynamic subtest rcs0-lmem0: SUCCESS (0.001s)
[382.692365] Starting dynamic subtest: bcs0-lmem0
[382.693951] Dynamic subtest bcs0-lmem0: SUCCESS (0.000s)
[382.717357] Starting dynamic subtest: vcs0-lmem0
[382.718419] Dynamic subtest vcs0-lmem0: SUCCESS (0.000s)
[382.730458] Starting dynamic subtest: vcs1-lmem0
[382.731447] Dynamic subtest vcs1-lmem0: SUCCESS (0.000s)
[382.743430] Starting dynamic subtest: vecs0-lmem0
[382.744644] Dynamic subtest vecs0-lmem0: SUCCESS (0.000s)
[382.756668] Starting dynamic subtest: vecs1-lmem0
[382.757777] Dynamic subtest vecs1-lmem0: SUCCESS (0.000s)
[382.769787] Starting dynamic subtest: ccs0-lmem0
[382.770955] Dynamic subtest ccs0-lmem0: SUCCESS (0.000s)
[382.771786] Subtest basic: SUCCESS (0.021s)
[382.817075] [080/129] (663s left) kms_pm_rpm (modeset-non-lpsp)
[384.889825] Starting subtest: modeset-non-lpsp
[385.355145] Subtest modeset-non-lpsp: SUCCESS (0.469s)
[385.623978] [081/129] (661s left) dumb_buffer (invalid-bpp)
[385.706698] Starting subtest: invalid-bpp
[385.707685] Subtest invalid-bpp: SUCCESS (0.000s)
[385.869412] [082/129] (661s left) gen9_exec_parse (bb-oversize)
[385.958405] Subtest bb-oversize: SKIP (0.000s)
[386.028962] [083/129] (660s left) gem_ppgtt (shrink-vs-evict-any)
[386.116229] Starting subtest: shrink-vs-evict-any
[393.760538] Subtest shrink-vs-evict-any: SUCCESS (7.644s)
[393.875971] [084/129] (653s left) syncobj_wait (wait-all-for-submit-snapshot)
[393.959084] Starting subtest: wait-all-for-submit-snapshot
[394.041411] Subtest wait-all-for-submit-snapshot: SUCCESS (0.083s)
[394.137671] [085/129] (652s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[394.346756] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[394.348491] Subtest psr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[394.490749] [086/129] (652s left) drm_fdinfo (busy-idle)
[394.563300] Starting subtest: busy-idle
[394.564306] Starting dynamic subtest: rcs0
[394.577497] Dynamic subtest rcs0: SKIP (0.013s)
[394.589229] Starting dynamic subtest: bcs0
[394.591043] Dynamic subtest bcs0: SKIP (0.010s)
[394.603741] Starting dynamic subtest: vcs0
[394.605745] Dynamic subtest vcs0: SKIP (0.000s)
[394.617614] Starting dynamic subtest: vcs1
[394.619702] Dynamic subtest vcs1: SKIP (0.000s)
[394.631698] Starting dynamic subtest: vecs0
[394.633767] Dynamic subtest vecs0: SKIP (0.000s)
[394.646374] Starting dynamic subtest: vecs1
[394.648597] Dynamic subtest vecs1: SKIP (0.000s)
[394.660280] Starting dynamic subtest: ccs0
[394.662347] Dynamic subtest ccs0: SKIP (0.000s)
[394.664382] Subtest busy-idle: SKIP (0.031s)
[394.708350] [087/129] (652s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[394.922171] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[394.924052] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[395.052204] [088/129] (652s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[395.345470] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[395.504037] [089/129] (651s left) gem_exec_store (basic)
[395.597379] Starting subtest: basic
[395.753988] Subtest basic: SUCCESS (0.156s)
[396.008298] [090/129] (651s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[396.220170] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[396.222033] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[396.377441] [091/129] (651s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[396.596630] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[397.848166] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.250s)
[398.059344] [092/129] (649s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[398.281882] Starting subtest: psr-rgb565-draw-mmap-gtt
[398.283849] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[398.410307] [093/129] (649s left) kms_invalid_mode (int-max-clock)
[398.624119] Starting subtest: int-max-clock
[398.625075] Starting dynamic subtest: pipe-A-DP-4
[398.703626] Dynamic subtest pipe-A-DP-4: SUCCESS (0.078s)
[398.718562] Starting dynamic subtest: pipe-B-DP-4
[398.719693] Dynamic subtest pipe-B-DP-4: SUCCESS (0.001s)
[398.732810] Starting dynamic subtest: pipe-C-DP-4
[398.733866] Dynamic subtest pipe-C-DP-4: SUCCESS (0.001s)
[398.746500] Starting dynamic subtest: pipe-D-DP-4
[398.747452] Dynamic subtest pipe-D-DP-4: SUCCESS (0.001s)
[398.748399] Subtest int-max-clock: SUCCESS (0.087s)
[398.961957] [094/129] (648s left) gem_vm_create (create-ext)
[399.047294] Starting subtest: create-ext
[399.052844] Subtest create-ext: SUCCESS (0.006s)
[399.245995] [095/129] (648s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-pwrite)
[399.457998] Starting subtest: psr-1p-offscren-pri-shrfb-draw-pwrite
[399.459725] Subtest psr-1p-offscren-pri-shrfb-draw-pwrite: SKIP (0.000s)
[399.599814] [096/129] (648s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[399.815238] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[399.817102] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[399.982307] [097/129] (647s left) syncobj_wait (wait-for-submit-delayed-submit)
[400.067178] Starting subtest: wait-for-submit-delayed-submit
[400.169094] Subtest wait-for-submit-delayed-submit: SUCCESS (0.102s)
[400.318094] [098/129] (647s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[400.529154] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[400.530097] Starting dynamic subtest: pipe-A-valid-mode
[402.754131] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.222s)
[402.756478] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.226s)
[403.021235] [099/129] (645s left) kms_flip (2x-plain-flip-ts-check)
[403.230847] Starting subtest: 2x-plain-flip-ts-check
[403.243442] Subtest 2x-plain-flip-ts-check: SKIP (0.013s)
[403.351830] [100/129] (644s left) kms_addfb_basic (tile-pitch-mismatch)
[403.434112] Starting subtest: tile-pitch-mismatch
[403.435817] Subtest tile-pitch-mismatch: SKIP (0.000s)
[403.691208] [101/129] (644s left) kms_psr (psr2-cursor-plane-onoff)
[403.904567] Subtest psr2-cursor-plane-onoff: SKIP (0.000s)
[403.958051] [102/129] (644s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[404.173162] Starting subtest: plane-upscale-20x20-with-modifiers
[404.174133] Starting dynamic subtest: pipe-A
[404.747646] Dynamic subtest pipe-A: SUCCESS (0.573s)
[404.781616] Starting dynamic subtest: pipe-B
[405.399514] Dynamic subtest pipe-B: SUCCESS (0.649s)
[405.430407] Starting dynamic subtest: pipe-C
[406.051910] Dynamic subtest pipe-C: SUCCESS (0.650s)
[406.086507] Starting dynamic subtest: pipe-D
[406.703566] Dynamic subtest pipe-D: SUCCESS (0.649s)
[406.704892] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (2.531s)
[407.047969] [103/129] (641s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-gtt)
[407.260926] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-gtt
[407.262657] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[407.383513] [104/129] (640s left) gen3_render_tiledy_blits
[407.533380] [105/129] (640s left) gem_ctx_exec (basic)
[407.617009] Starting subtest: basic
[407.622142] Subtest basic: SUCCESS (0.005s)
[407.777786] [106/129] (640s left) core_getstats
[408.001789] [107/129] (640s left) gem_exec_balancer (hog)
[408.092855] Starting subtest: hog
[408.094821] Subtest hog: SKIP (0.000s)
[408.501384] [108/129] (640s left) api_intel_bb (bb-with-allocator)
[408.585592] Starting subtest: bb-with-allocator
[408.611486] Subtest bb-with-allocator: SUCCESS (0.026s)
[408.814051] [109/129] (639s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[409.032408] Starting subtest: fbcpsr-1p-rte
[409.034202] Subtest fbcpsr-1p-rte: SKIP (0.000s)
[409.146313] [110/129] (639s left) sysfs_defaults (readonly)
[409.233412] Starting subtest: readonly
[409.234427] Starting dynamic subtest: vecs0
[409.235400] Dynamic subtest vecs0: SUCCESS (0.000s)
[409.247904] Starting dynamic subtest: ccs0
[409.249016] Dynamic subtest ccs0: SUCCESS (0.000s)
[409.261452] Starting dynamic subtest: vcs0
[409.262618] Dynamic subtest vcs0: SUCCESS (0.001s)
[409.274366] Starting dynamic subtest: bcs0
[409.275441] Dynamic subtest bcs0: SUCCESS (0.000s)
[409.287150] Starting dynamic subtest: vecs1
[409.288436] Dynamic subtest vecs1: SUCCESS (0.000s)
[409.300322] Starting dynamic subtest: rcs0
[409.301232] Dynamic subtest rcs0: SUCCESS (0.000s)
[409.312890] Starting dynamic subtest: vcs1
[409.313939] Dynamic subtest vcs1: SUCCESS (0.000s)
[409.314955] Subtest readonly: SUCCESS (0.011s)
[409.358922] [111/129] (639s left) gem_lmem_swapping (parallel-random-verify-ccs)
[412.076312] Starting subtest: parallel-random-verify-ccs
[412.077939] Starting dynamic subtest: lmem0
[477.762673] Dynamic subtest lmem0: SUCCESS (65.678s)
[477.764482] Subtest parallel-random-verify-ccs: SUCCESS (65.680s)
[479.089323] [FACT gem_lmem_swapping (parallel-random-verify-ccs)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[479.090344] [FACT gem_lmem_swapping (parallel-random-verify-ccs)] deleted: kernel.kmod_is_loaded.i915: true
[479.092187] [112/129] (569s left) gem_userptr_blits (sync-unmap)
[480.554482] Starting subtest: sync-unmap
[480.577340] Subtest sync-unmap: SUCCESS (0.028s)
[480.708119] [FACT gem_userptr_blits (sync-unmap)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[480.712276] [FACT gem_userptr_blits (sync-unmap)] new: kernel.kmod_is_loaded.i915: true
[480.715452] [113/129] (568s left) gem_pxp (verify-pxp-stale-buf-optout-execution)
[483.331502] Starting subtest: verify-pxp-stale-buf-optout-execution
[483.335532] Subtest verify-pxp-stale-buf-optout-execution: SKIP (0.000s)
[483.478785] [114/129] (565s left) kms_big_fb (linear-16bpp-rotate-0)
[483.711325] Starting subtest: linear-16bpp-rotate-0
[485.408919] Subtest linear-16bpp-rotate-0: SUCCESS (1.696s)
[485.695541] [115/129] (563s left) gem_ccs (suspend-resume)
[485.790681] Starting subtest: suspend-resume
[485.791559] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0
[503.615729] Dynamic subtest linear-compressed-compfmt0-smem-lmem0: SUCCESS (4.150s)
[503.626650] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0
[521.662274] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0: SUCCESS (3.674s)
[521.674883] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0
[539.596424] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0: SUCCESS (3.557s)
[539.607680] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0
[557.677812] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0: SUCCESS (3.714s)
[557.688858] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0
[575.573963] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0: SUCCESS (3.565s)
[575.584962] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0
[593.635188] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0: SUCCESS (3.668s)
[593.646209] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0