[42.400315] Initializing watchdogs
[42.400356]   /dev/watchdog0
[42.406436] [001/130] (960s left) gem_exec_balancer (nop)
[42.472023] Starting subtest: nop
[91.147343] Subtest nop: SUCCESS (48.657s)
[91.415738] [002/130] (911s left) gem_exec_store (dword)
[91.489664] Starting subtest: dword
[91.490498] Starting dynamic subtest: rcs0
[91.572392] Dynamic subtest rcs0: SUCCESS (0.083s)
[91.580563] Starting dynamic subtest: bcs0
[91.613552] Dynamic subtest bcs0: SUCCESS (0.040s)
[91.633655] Starting dynamic subtest: vcs0
[91.659542] Dynamic subtest vcs0: SUCCESS (0.045s)
[91.679532] Starting dynamic subtest: vcs1
[91.705213] Dynamic subtest vcs1: SUCCESS (0.045s)
[91.725284] Starting dynamic subtest: vecs0
[91.751220] Dynamic subtest vecs0: SUCCESS (0.046s)
[91.772795] Starting dynamic subtest: vecs1
[91.798055] Dynamic subtest vecs1: SUCCESS (0.047s)
[91.818437] Starting dynamic subtest: ccs0
[91.844095] Dynamic subtest ccs0: SUCCESS (0.046s)
[91.846075] Subtest dword: SUCCESS (0.354s)
[92.110479] [003/130] (910s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[92.297948] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[92.315430] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.017s)
[92.385084] [004/130] (910s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[92.594105] Starting subtest: 2x-cursor-vs-flip-legacy
[92.596662] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.002s)
[92.646340] [005/130] (910s left) i915_pm_freq_api (freq-reset-multiple)
[92.724991] Starting subtest: freq-reset-multiple
[92.726570] Starting dynamic subtest: gt0
[111.868862] Dynamic subtest gt0: SUCCESS (19.143s)
[111.869676] Subtest freq-reset-multiple: SUCCESS (19.143s)
[111.935570] [006/130] (891s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[112.117358] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[112.119013] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[112.210762] [007/130] (890s left) i915_module_load (reload-with-fault-injection)
[112.285123] Starting subtest: reload-with-fault-injection
[124.985387] Subtest reload-with-fault-injection: SUCCESS (12.699s)
[125.009216] [008/130] (878s left) gem_exec_balancer (sequential)
[125.901736] Starting subtest: sequential
[131.060346] Subtest sequential: SUCCESS (5.158s)
[131.292667] [009/130] (871s left) kms_psr (psr-primary-page-flip)
[131.474513] Subtest psr-primary-page-flip: SKIP (0.000s)
[131.490034] [010/130] (871s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[131.676149] Starting subtest: fb-8bpc-vs-panel-8bpc
[131.678068] Starting dynamic subtest: pipe-A-DP-3
[132.067607] Dynamic subtest pipe-A-DP-3: SUCCESS (0.389s)
[132.069396] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (0.391s)
[132.265167] [011/130] (870s left) kms_setmode (invalid-clone-exclusive-crtc)
[132.353911] Starting subtest: invalid-clone-exclusive-crtc
[132.356547] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[132.446604] [012/130] (870s left) kms_scaling_modes (scaling-mode-center)
[132.646050] Starting subtest: scaling-mode-center
[132.648552] Subtest scaling-mode-center: SKIP (0.001s)
[132.695417] [013/130] (870s left) syncobj_timeline (wait-any-complex)
[132.758562] Starting subtest: wait-any-complex
[132.820563] Subtest wait-any-complex: SUCCESS (0.062s)
[132.915200] [014/130] (870s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[133.132174] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[133.133695] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[133.227319] [015/130] (869s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[133.528234] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[133.673947] [016/130] (869s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[133.891384] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[133.893031] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[133.973094] [017/130] (869s left) gem_workarounds (reset)
[134.061676] Starting subtest: reset
[134.287420] Subtest reset: SUCCESS (0.226s)
[134.418573] [018/130] (868s left) gem_mmap_wc (read)
[134.505273] Subtest read: SKIP (0.000s)
[134.543951] [019/130] (868s left) kms_cursor_crc (cursor-onscreen-256x85)
[134.884121] Starting subtest: cursor-onscreen-256x85
[134.887689] Starting dynamic subtest: pipe-A-DP-3
[137.551354] Dynamic subtest pipe-A-DP-3: SUCCESS (2.662s)
[137.595546] Starting dynamic subtest: pipe-D-DP-3
[140.233694] Dynamic subtest pipe-D-DP-3: SUCCESS (2.644s)
[140.234857] Subtest cursor-onscreen-256x85: SUCCESS (5.349s)
[140.530716] [020/130] (862s left) gem_exec_reloc (basic-cpu-read)
[140.626800] Subtest basic-cpu-read: SKIP (0.000s)
[140.662818] [021/130] (862s left) gem_partial_pwrite_pread (writes-after-reads-display)
[140.738038] Subtest writes-after-reads-display: SKIP (0.000s)
[140.806263] [022/130] (862s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[140.890009] Starting subtest: multi-wait-all-for-submit-available-signaled
[140.890919] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[140.974289] [023/130] (862s left) kms_chamelium_edid (hdmi-edid-stress-resolution-non-4k)
[141.247125] Subtest hdmi-edid-stress-resolution-non-4k: SKIP (0.000s)
[141.393300] [024/130] (862s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[141.603593] Starting subtest: fbc-rgb101010-draw-pwrite
[144.421712] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (2.819s)
[144.528259] [025/130] (858s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[144.720705] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[144.747161] [026/130] (858s left) gem_mmap_gtt (basic-small-copy-odd)
[144.795275] Subtest basic-small-copy-odd: SKIP (0.000s)
[144.830105] [027/130] (858s left) kms_plane (plane-panning-top-left)
[145.025070] Starting subtest: plane-panning-top-left
[145.026960] Starting dynamic subtest: pipe-A
[145.766030] Dynamic subtest pipe-A: SUCCESS (0.740s)
[145.775284] Starting dynamic subtest: pipe-B
[146.412407] Dynamic subtest pipe-B: SUCCESS (0.645s)
[146.413351] Subtest plane-panning-top-left: SUCCESS (1.387s)
[146.610261] [028/130] (856s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[146.802089] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[146.803041] Starting dynamic subtest: pipe-A-DP-3
[149.243611] Dynamic subtest pipe-A-DP-3: SUCCESS (2.441s)
[149.249915] Starting dynamic subtest: pipe-B-DP-3
[149.257310] Dynamic subtest pipe-B-DP-3: SUCCESS (0.004s)
[149.263415] Starting dynamic subtest: pipe-C-DP-3
[149.270848] Dynamic subtest pipe-C-DP-3: SUCCESS (0.005s)
[149.277124] Starting dynamic subtest: pipe-D-DP-3
[149.284809] Dynamic subtest pipe-D-DP-3: SUCCESS (0.006s)
[149.285596] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SUCCESS (2.459s)
[149.708585] [029/130] (853s left) kms_joiner (invalid-modeset-force-big-joiner)
[149.918106] Starting subtest: invalid-modeset-force-big-joiner
[149.918819] Starting dynamic subtest: big_joiner_on_last_pipe
[150.150017] Dynamic subtest big_joiner_on_last_pipe: SUCCESS (0.233s)
[150.151227] Subtest invalid-modeset-force-big-joiner: SUCCESS (0.233s)
[150.352420] [030/130] (853s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[150.564217] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[150.565944] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[150.649654] [031/130] (852s left) gem_exec_schedule (preempt-queue-contexts)
[150.754523] Subtest preempt-queue-contexts: SKIP (0.000s)
[151.068822] [032/130] (852s left) gem_exec_reloc (basic-concurrent0)
[151.119281] Subtest basic-concurrent0: SKIP (0.000s)
[151.152090] [033/130] (852s left) i915_selftest (perf)
[153.207648] Starting subtest: perf
[153.209422] Starting dynamic subtest: engine_cs
[154.657823] Dynamic subtest engine_cs: SUCCESS (1.450s)
[154.666207] Starting dynamic subtest: request
[159.155981] Dynamic subtest request: SUCCESS (4.498s)
[159.160954] Starting dynamic subtest: migrate
[160.572999] Dynamic subtest migrate: SUCCESS (1.417s)
[160.577534] Starting dynamic subtest: region
[188.423999] Dynamic subtest region: SUCCESS (27.850s)
[188.424898] Subtest perf: SUCCESS (35.217s)
[188.436019] [034/130] (815s left) perf_pmu (busy-check-all)
[189.299119] Starting subtest: busy-check-all
[189.299886] Starting dynamic subtest: rcs0
[189.903542] Dynamic subtest rcs0: SUCCESS (0.603s)
[189.925563] Starting dynamic subtest: bcs0
[190.472568] Dynamic subtest bcs0: SUCCESS (0.568s)
[190.480652] Starting dynamic subtest: vcs0
[191.022750] Dynamic subtest vcs0: SUCCESS (0.549s)
[191.031517] Starting dynamic subtest: vcs1
[191.573784] Dynamic subtest vcs1: SUCCESS (0.550s)
[191.582643] Starting dynamic subtest: vecs0
[192.127083] Dynamic subtest vecs0: SUCCESS (0.552s)
[192.135716] Starting dynamic subtest: vecs1
[192.678146] Dynamic subtest vecs1: SUCCESS (0.550s)
[192.686559] Starting dynamic subtest: ccs0
[193.227053] Dynamic subtest ccs0: SUCCESS (0.548s)
[193.228933] Subtest busy-check-all: SUCCESS (3.927s)
[193.280054] [035/130] (810s left) kms_getfb (getfb-handle-zero)
[193.339075] Starting subtest: getfb-handle-zero
[193.340089] Subtest getfb-handle-zero: SUCCESS (0.000s)
[193.412460] [036/130] (810s left) kms_plane_alpha_blend (alpha-basic)
[193.588099] Starting subtest: alpha-basic
[193.791988] Starting dynamic subtest: pipe-A-DP-3
[196.335705] Dynamic subtest pipe-A-DP-3: SUCCESS (2.543s)
[196.357854] Starting dynamic subtest: pipe-D-DP-3
[199.012093] Dynamic subtest pipe-D-DP-3: SUCCESS (2.658s)
[199.013121] Subtest alpha-basic: SUCCESS (5.423s)
[199.269899] [037/130] (804s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-pwrite)
[199.464503] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-pwrite
[202.017715] Subtest fbc-1p-offscren-pri-shrfb-draw-pwrite: SUCCESS (2.555s)
[202.155432] [038/130] (801s left) kms_chamelium_color (ctm-blue-to-red)
[202.335089] Subtest ctm-blue-to-red: SKIP (0.000s)
[202.358728] [039/130] (801s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[202.550277] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[202.551807] Subtest psr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[202.617987] [040/130] (801s left) gem_workarounds (reset-context)
[202.701932] Starting subtest: reset-context
[202.899185] Subtest reset-context: SUCCESS (0.197s)
[203.017304] [041/130] (800s left) gem_fence_thrash (bo-copy)
[203.056390] Starting subtest: bo-copy
[203.072846] Subtest bo-copy: SKIP (0.015s)
[203.109078] [042/130] (800s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[203.305364] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[203.307218] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[203.390515] [043/130] (800s left) sysfs_timeslice_duration (timeout)
[203.469360] Starting subtest: timeout
[203.470167] Starting dynamic subtest: vecs0
[205.229226] Dynamic subtest vecs0: SUCCESS (1.759s)
[205.236389] Starting dynamic subtest: ccs0
[206.875616] Dynamic subtest ccs0: SUCCESS (1.645s)
[206.885973] Starting dynamic subtest: vcs0
[208.515067] Dynamic subtest vcs0: SUCCESS (1.638s)
[208.521879] Starting dynamic subtest: bcs0
[209.547232] Dynamic subtest bcs0: SUCCESS (1.032s)
[209.553762] Starting dynamic subtest: vecs1
[211.181231] Dynamic subtest vecs1: SUCCESS (1.634s)
[211.187920] Starting dynamic subtest: rcs0
[212.821437] Dynamic subtest rcs0: SUCCESS (1.640s)
[212.828385] Starting dynamic subtest: vcs1
[214.439203] Dynamic subtest vcs1: SUCCESS (1.617s)
[214.440352] Subtest timeout: SUCCESS (10.969s)
[214.532171] [044/130] (789s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[214.587035] Subtest tiled-to-untiled: SKIP (0.000s)
[214.628822] [045/130] (789s left) gem_exec_params (no-bsd)
[214.687400] Starting subtest: no-bsd
[214.689522] Subtest no-bsd: SUCCESS (0.001s)
[214.819782] [046/130] (789s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[215.039459] Starting subtest: x-tiled-8bpp-rotate-270
[215.085159] Subtest x-tiled-8bpp-rotate-270: SKIP (0.045s)
[215.253118] [047/130] (788s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[215.475436] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[215.477208] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[215.558435] [048/130] (788s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[216.132118] Starting subtest: syncobj-backward-timeline-chain-engines
[216.258961] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.127s)
[216.534409] [049/130] (787s left) perf (per-context-mode-unprivileged)
[216.832437] Starting subtest: per-context-mode-unprivileged
[216.834130] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[216.862591] [050/130] (787s left) gem_mmap_offset (bad-extensions)
[216.957903] Starting subtest: bad-extensions
[216.958736] Subtest bad-extensions: SUCCESS (0.000s)
[217.038523] [051/130] (786s left) gem_mmap_gtt (bad-object)
[217.129858] Subtest bad-object: SKIP (0.000s)
[217.180381] [052/130] (786s left) gem_wait (write-busy)
[217.315425] Starting subtest: write-busy
[217.316351] Starting dynamic subtest: all-engines
[217.914383] Dynamic subtest all-engines: SUCCESS (0.599s)
[217.922806] Starting dynamic subtest: rcs0
[218.456276] Dynamic subtest rcs0: SUCCESS (0.541s)
[218.463515] Starting dynamic subtest: bcs0
[218.997203] Dynamic subtest bcs0: SUCCESS (0.541s)
[219.004505] Starting dynamic subtest: vcs0
[219.538248] Dynamic subtest vcs0: SUCCESS (0.541s)
[219.545442] Starting dynamic subtest: vcs1
[220.078257] Dynamic subtest vcs1: SUCCESS (0.540s)
[220.085737] Starting dynamic subtest: vecs0
[220.618198] Dynamic subtest vecs0: SUCCESS (0.540s)
[220.625498] Starting dynamic subtest: vecs1
[221.158252] Dynamic subtest vecs1: SUCCESS (0.540s)
[221.165425] Starting dynamic subtest: ccs0
[221.698256] Dynamic subtest ccs0: SUCCESS (0.540s)
[221.699217] Subtest write-busy: SUCCESS (4.383s)
[221.918080] [053/130] (782s left) gem_fence_thrash (bo-write-verify-threaded-y)
[221.989269] Starting subtest: bo-write-verify-threaded-y
[221.998924] Subtest bo-write-verify-threaded-y: SKIP (0.008s)
[222.045442] [054/130] (782s left) kms_psr (fbc-psr2-primary-blt)
[222.258968] Subtest fbc-psr2-primary-blt: SKIP (0.000s)
[222.276395] [055/130] (781s left) kms_vblank (ts-continuation-dpms-suspend)
[222.484189] Starting subtest: ts-continuation-dpms-suspend
[222.486220] Starting dynamic subtest: pipe-A-DP-3
[241.673230] Dynamic subtest pipe-A-DP-3: SUCCESS (4.030s)
[241.683838] Starting dynamic subtest: pipe-D-DP-3
[261.676329] Dynamic subtest pipe-D-DP-3: SUCCESS (3.685s)
[261.677238] Subtest ts-continuation-dpms-suspend: SUCCESS (7.719s)
[264.880142] [056/130] (773s left) kms_psr (pr-cursor-render)
[265.146830] Subtest pr-cursor-render: SKIP (0.000s)
[265.193702] [057/130] (773s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[265.447016] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[266.017232] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.570s)
[266.195490] [058/130] (772s left) perf_pmu (semaphore-wait)
[266.276692] Starting subtest: semaphore-wait
[266.277483] Starting dynamic subtest: rcs0
[266.804485] Dynamic subtest rcs0: SUCCESS (0.527s)
[266.813753] Starting dynamic subtest: bcs0
[267.313764] Dynamic subtest bcs0: SUCCESS (0.508s)
[267.324120] Starting dynamic subtest: vcs0
[267.825685] Dynamic subtest vcs0: SUCCESS (0.510s)
[267.836117] Starting dynamic subtest: vcs1
[268.338296] Dynamic subtest vcs1: SUCCESS (0.511s)
[268.349188] Starting dynamic subtest: vecs0
[268.851068] Dynamic subtest vecs0: SUCCESS (0.511s)
[268.862238] Starting dynamic subtest: vecs1
[269.364760] Dynamic subtest vecs1: SUCCESS (0.512s)
[269.375518] Starting dynamic subtest: ccs0
[269.877936] Dynamic subtest ccs0: SUCCESS (0.511s)
[269.880010] Subtest semaphore-wait: SUCCESS (3.601s)
[270.002167] [059/130] (768s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[270.225148] Starting subtest: modeset-transition-nonblocking-fencing
[270.226048] Starting dynamic subtest: 1x-outputs
[272.894885] Dynamic subtest 1x-outputs: SUCCESS (2.668s)
[272.946590] Subtest modeset-transition-nonblocking-fencing: SUCCESS (2.721s)
[273.175565] [060/130] (765s left) drm_fdinfo (busy-idle)
[273.273250] Starting subtest: busy-idle
[273.274430] Starting dynamic subtest: rcs0
[273.286431] Dynamic subtest rcs0: SKIP (0.012s)
[273.294878] Starting dynamic subtest: bcs0
[273.297949] Dynamic subtest bcs0: SKIP (0.010s)
[273.306165] Starting dynamic subtest: vcs0
[273.307739] Dynamic subtest vcs0: SKIP (0.000s)
[273.315606] Starting dynamic subtest: vcs1
[273.317365] Dynamic subtest vcs1: SKIP (0.000s)
[273.325473] Starting dynamic subtest: vecs0
[273.327587] Dynamic subtest vecs0: SKIP (0.000s)
[273.336012] Starting dynamic subtest: vecs1
[273.337870] Dynamic subtest vecs1: SKIP (0.000s)
[273.345925] Starting dynamic subtest: ccs0
[273.348039] Dynamic subtest ccs0: SKIP (0.000s)
[273.349989] Subtest busy-idle: SKIP (0.026s)
[273.372734] [061/130] (765s left) kms_getfb (getfb-handle-valid)
[273.464969] Starting subtest: getfb-handle-valid
[273.465817] Subtest getfb-handle-valid: SUCCESS (0.000s)
[273.586780] [062/130] (765s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[273.813079] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[273.814054] Starting dynamic subtest: pipe-A-valid-mode
[273.890334] Dynamic subtest pipe-A-valid-mode: SKIP (0.075s)
[273.892205] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.076s)
[274.067753] [063/130] (764s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[274.179729] Starting subtest: etime-multi-wait-for-submit-submitted
[274.281345] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.101s)
[274.380527] [064/130] (764s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[274.614255] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[274.615862] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[274.692799] [065/130] (764s left) syncobj_eventfd (invalid-illegal-handle)
[274.798949] Starting subtest: invalid-illegal-handle
[274.799908] Subtest invalid-illegal-handle: SUCCESS (0.000s)
[274.877006] [066/130] (764s left) kms_cursor_legacy (cursorb-vs-flipb-legacy)
[275.116153] Starting subtest: cursorB-vs-flipB-legacy
[275.118876] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s)
[275.190991] [067/130] (763s left) gem_exec_params (invalid-bsd1-flag-on-blt)
[275.310311] Starting subtest: invalid-bsd1-flag-on-blt
[275.311299] Subtest invalid-bsd1-flag-on-blt: SUCCESS (0.000s)
[275.396696] [068/130] (763s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[275.615337] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[275.617114] Subtest psr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[275.714250] [069/130] (763s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[275.965999] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[275.967167] Starting dynamic subtest: pipe-A-DP-3
[276.229169] Dynamic subtest pipe-A-DP-3: SUCCESS (0.247s)
[276.251294] Starting dynamic subtest: pipe-B-DP-3
[276.623450] Dynamic subtest pipe-B-DP-3: SUCCESS (0.389s)
[276.644771] Starting dynamic subtest: pipe-C-DP-3
[276.998814] Dynamic subtest pipe-C-DP-3: SUCCESS (0.370s)
[277.021575] Starting dynamic subtest: pipe-D-DP-3
[277.377052] Dynamic subtest pipe-D-DP-3: SUCCESS (0.373s)
[277.377907] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SUCCESS (1.398s)
[277.692964] [070/130] (761s left) prime_mmap (test_errors)
[277.794980] Starting subtest: test_errors
[277.795925] Starting dynamic subtest: test_errors-smem
[277.894199] Dynamic subtest test_errors-smem: SUCCESS (0.099s)
[277.902541] Starting dynamic subtest: test_errors-lmem0
[278.316687] Dynamic subtest test_errors-lmem0: SUCCESS (0.422s)
[278.317614] Subtest test_errors: SUCCESS (0.522s)
[278.401293] [071/130] (760s left) gem_exec_await (wide-all)
[278.638185] Starting subtest: wide-all
[300.977677] Subtest wide-all: SUCCESS (22.074s)
[301.185497] [072/130] (738s left) sw_sync (alloc_merge_fence)
[301.311094] Starting subtest: alloc_merge_fence
[301.312380] Subtest alloc_merge_fence: SUCCESS (0.000s)
[301.351916] [073/130] (738s left) gem_pxp (hw-rejects-pxp-buffer)
[303.973016] Starting subtest: hw-rejects-pxp-buffer
[303.974738] Subtest hw-rejects-pxp-buffer: SUCCESS (0.000s)
[304.084553] [074/130] (735s left) gem_close_race (basic-threads)
[304.222544] Starting subtest: basic-threads
[305.382867] Subtest basic-threads: SUCCESS (1.157s)
[305.620310] [075/130] (733s left) sw_sync (sync_multi_consumer_producer)
[305.738961] Starting subtest: sync_multi_consumer_producer
[305.907261] Subtest sync_multi_consumer_producer: SUCCESS (0.169s)
[305.977653] [076/130] (733s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[306.211208] Starting subtest: x-tiled-16bpp-rotate-180
[307.797892] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.584s)
[307.916926] [077/130] (731s left) gem_compute (compute-square)
[308.001885] Starting subtest: compute-square
[308.009864] Subtest compute-square: SUCCESS (0.009s)
[308.094070] [078/130] (731s left) gem_exec_schedule (fifo)
[308.219336] Starting subtest: fifo
[308.220178] Starting dynamic subtest: rcs0
[308.473330] Dynamic subtest rcs0: SUCCESS (0.253s)
[308.482536] Starting dynamic subtest: bcs0
[308.655487] Dynamic subtest bcs0: SUCCESS (0.181s)
[308.664452] Starting dynamic subtest: vcs0
[308.845356] Dynamic subtest vcs0: SUCCESS (0.189s)
[308.854365] Starting dynamic subtest: vcs1
[309.036413] Dynamic subtest vcs1: SUCCESS (0.190s)
[309.045698] Starting dynamic subtest: vecs0
[309.226005] Dynamic subtest vecs0: SUCCESS (0.189s)
[309.235015] Starting dynamic subtest: vecs1
[309.416436] Dynamic subtest vecs1: SUCCESS (0.190s)
[309.425669] Starting dynamic subtest: ccs0
[309.602672] Dynamic subtest ccs0: SUCCESS (0.185s)
[309.603481] Subtest fifo: SUCCESS (1.381s)
[309.937428] [079/130] (729s left) perf_pmu (invalid-init)
[310.014724] Starting subtest: invalid-init
[310.015633] Subtest invalid-init: SUCCESS (0.000s)
[310.088445] [080/130] (729s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[310.186531] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[310.232183] [081/130] (729s left) api_intel_bb (lot-of-buffers)
[310.330877] Starting subtest: lot-of-buffers
[312.434797] Subtest lot-of-buffers: SUCCESS (2.102s)
[312.560650] [082/130] (727s left) kms_psr (fbc-psr-sprite-render)
[312.789994] Subtest fbc-psr-sprite-render: SKIP (0.000s)
[312.816835] [083/130] (726s left) kms_prop_blob (blob-multiple)
[312.910013] Starting subtest: blob-multiple
[312.912038] Subtest blob-multiple: SUCCESS (0.002s)
[313.045330] [084/130] (726s left) kms_cursor_crc (cursor-sliding-128x42)
[313.407800] Starting subtest: cursor-sliding-128x42
[313.412002] Starting dynamic subtest: pipe-A-DP-3
[317.653013] Dynamic subtest pipe-A-DP-3: SUCCESS (4.239s)
[317.682460] Starting dynamic subtest: pipe-D-DP-3
[321.882108] Dynamic subtest pipe-D-DP-3: SUCCESS (4.206s)
[321.883139] Subtest cursor-sliding-128x42: SUCCESS (8.471s)
[322.237291] [085/130] (717s left) kms_addfb_basic (addfb25-bad-modifier)
[322.342213] Starting subtest: addfb25-bad-modifier
[322.343149] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[322.550775] [086/130] (717s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[322.791236] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[322.792887] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[322.868573] [087/130] (716s left) kms_pm_dc (dc5-dpms)
[324.107423] Starting subtest: dc5-dpms
[325.482619] Subtest dc5-dpms: SUCCESS (1.373s)
[325.604696] [088/130] (714s left) kms_hdr (bpc-switch-dpms)
[325.832209] Starting subtest: bpc-switch-dpms
[329.276627] Starting dynamic subtest: pipe-A-DP-3
[330.550679] Dynamic subtest pipe-A-DP-3: SUCCESS (1.274s)
[330.552007] Subtest bpc-switch-dpms: SUCCESS (4.718s)
[330.852928] [089/130] (709s left) kms_cursor_legacy (single-move)
[331.084142] Starting subtest: single-move
[331.085080] Starting dynamic subtest: pipe-A
[336.464173] Dynamic subtest pipe-A: SUCCESS (5.377s)
[336.473052] Starting dynamic subtest: pipe-B
[341.842873] Dynamic subtest pipe-B: SUCCESS (5.376s)
[341.851871] Starting dynamic subtest: pipe-C
[347.221991] Dynamic subtest pipe-C: SUCCESS (5.376s)
[347.230764] Starting dynamic subtest: pipe-D
[352.601347] Dynamic subtest pipe-D: SUCCESS (5.377s)
[352.610007] Starting dynamic subtest: all-pipes
[357.981269] Dynamic subtest all-pipes: SUCCESS (5.377s)
[357.982218] Subtest single-move: SUCCESS (26.886s)
[358.048709] [090/130] (681s left) gem_mmap_wc (bad-offset)
[358.144317] Subtest bad-offset: SKIP (0.000s)
[358.177756] [091/130] (681s left) kms_big_fb (yf-tiled-8bpp-rotate-180)
[358.413018] Starting subtest: yf-tiled-8bpp-rotate-180
[358.414590] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s)
[358.488460] [092/130] (681s left) prime_vgem (basic-blt)
[358.608321] Starting subtest: basic-blt
[358.659118] Subtest basic-blt: SUCCESS (0.051s)
[358.787092] [093/130] (681s left) drm_fdinfo (virtual-busy-idle)
[358.883016] Starting subtest: virtual-busy-idle
[358.885020] Subtest virtual-busy-idle: SKIP (0.000s)
[358.956700] [094/130] (681s left) gem_ctx_param (basic-default)
[359.048266] Starting subtest: basic-default
[359.049197] Subtest basic-default: SUCCESS (0.000s)
[359.122508] [095/130] (680s left) kms_chamelium_hpd (vga-hpd-for-each-pipe)
[359.425770] Subtest vga-hpd-for-each-pipe: SKIP (0.000s)
[359.541750] [096/130] (680s left) gem_set_tiling_vs_gtt
[359.684964] [097/130] (680s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[359.903536] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[362.408966] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (2.505s)
[362.542329] [098/130] (677s left) perf (gen8-unprivileged-single-ctx-counters)
[362.748964] Starting subtest: gen8-unprivileged-single-ctx-counters
[362.750953] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[362.772628] [099/130] (677s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[362.988406] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[362.990130] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[363.103716] [100/130] (677s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[363.336064] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[363.337005] Starting dynamic subtest: pipe-A
[363.442354] Dynamic subtest pipe-A: SUCCESS (0.106s)
[363.460014] Starting dynamic subtest: pipe-B
[363.667782] Dynamic subtest pipe-B: SUCCESS (0.224s)
[363.690530] Starting dynamic subtest: pipe-C
[363.893290] Dynamic subtest pipe-C: SUCCESS (0.224s)
[363.908572] Starting dynamic subtest: pipe-D
[364.119645] Dynamic subtest pipe-D: SUCCESS (0.225s)
[364.120585] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (0.784s)
[364.404707] [101/130] (675s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[364.642997] Starting subtest: crc-primary-basic-yf-tiled-ccs
[364.645005] Starting dynamic subtest: pipe-A-DP-3
[364.653654] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[364.662672] Starting dynamic subtest: pipe-B-DP-3
[364.670985] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[364.680110] Starting dynamic subtest: pipe-C-DP-3
[364.688868] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[364.697998] Starting dynamic subtest: pipe-D-DP-3
[364.709023] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[364.710931] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.006s)
[365.061294] [102/130] (675s left) gem_ctx_isolation (dirty-switch)
[365.175939] Starting subtest: dirty-switch
[365.177025] Starting dynamic subtest: rcs0
[365.598164] Dynamic subtest rcs0: SUCCESS (0.422s)
[365.607484] Starting dynamic subtest: bcs0
[366.054892] Dynamic subtest bcs0: SUCCESS (0.456s)
[366.064199] Starting dynamic subtest: vcs0
[366.511797] Dynamic subtest vcs0: SUCCESS (0.456s)
[366.521055] Starting dynamic subtest: vcs1
[366.951286] Dynamic subtest vcs1: SUCCESS (0.439s)
[366.960790] Starting dynamic subtest: vecs0
[367.387632] Dynamic subtest vecs0: SUCCESS (0.436s)
[367.396886] Starting dynamic subtest: vecs1
[367.829023] Dynamic subtest vecs1: SUCCESS (0.441s)
[367.838090] Starting dynamic subtest: ccs0
[368.283007] Dynamic subtest ccs0: SUCCESS (0.453s)
[368.283802] Subtest dirty-switch: SUCCESS (3.106s)
[368.554316] [103/130] (671s left) gem_exec_reloc (basic-wc-read)
[368.637778] Subtest basic-wc-read: SKIP (0.000s)
[368.680063] [104/130] (671s left) kms_big_fb (y-tiled-addfb-size-overflow)
[368.909327] Starting subtest: y-tiled-addfb-size-overflow
[368.910951] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s)
[368.994768] [105/130] (671s left) gem_mmap_wc (set-cache-level)
[369.111456] Subtest set-cache-level: SKIP (0.000s)
[369.150350] [106/130] (671s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs)
[369.263322] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs
[369.265437] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s)
[369.451233] [107/130] (670s left) kms_psr (fbc-pr-sprite-plane-move)
[369.675012] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[369.697137] [108/130] (670s left) gem_sync (basic-each)
[369.794530] Starting subtest: basic-each
[372.044328] Subtest basic-each: SUCCESS (2.251s)
[372.236449] [109/130] (668s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[372.457070] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[372.458874] Starting dynamic subtest: pipe-A-valid-mode
[374.648243] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.186s)
[374.649931] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.188s)
[374.892354] [110/130] (665s left) i915_suspend (forcewake)
[375.024871] Starting subtest: forcewake
[412.526813] Subtest forcewake: SUCCESS (6.692s)
[415.585468] [111/130] (658s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[415.800039] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[415.800856] Starting dynamic subtest: pipe-A
[417.830034] Dynamic subtest pipe-A: SUCCESS (2.029s)
[417.841670] Starting dynamic subtest: pipe-B
[419.939547] Dynamic subtest pipe-B: SUCCESS (2.107s)
[419.954210] Starting dynamic subtest: pipe-C
[420.248939] Dynamic subtest pipe-C: SUCCESS (0.308s)
[420.273910] Starting dynamic subtest: pipe-D
[420.574614] Dynamic subtest pipe-D: SUCCESS (0.324s)
[420.575852] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (4.773s)
[420.887460] [112/130] (653s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[421.124729] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[421.126408] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[421.207989] [113/130] (653s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[421.463161] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[421.464764] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[421.569354] [114/130] (652s left) gem_ctx_persistence (userptr)
[421.698459] Starting subtest: userptr
[421.896267] Subtest userptr: SUCCESS (0.197s)
[422.014119] [115/130] (652s left) kms_vrr (seamless-rr-switch-vrr)
[422.232037] Starting subtest: seamless-rr-switch-vrr
[422.234634] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[422.301174] [116/130] (652s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[422.529702] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[422.531400] Subtest fbcpsr-rgb101010-draw-pwrite: SKIP (0.000s)
[422.637135] [117/130] (651s left) kms_flip (2x-flip-vs-fences-interruptible)
[422.870745] Starting subtest: 2x-flip-vs-fences-interruptible
[422.872593] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[422.963877] [118/130] (651s left) gem_spin_batch (legacy-resubmit)
[423.091655] Starting subtest: legacy-resubmit
[423.092472] Starting dynamic subtest: default
[423.112856] Dynamic subtest default: SUCCESS (0.020s)
[423.122679] Starting dynamic subtest: render
[423.123470] Dynamic subtest render: SUCCESS (0.001s)
[423.132556] Starting dynamic subtest: bsd
[423.133600] Dynamic subtest bsd: SUCCESS (0.003s)
[423.142691] Starting dynamic subtest: bsd1
[423.143731] Dynamic subtest bsd1: SUCCESS (0.001s)
[423.152587] Starting dynamic subtest: bsd2
[423.153405] Dynamic subtest bsd2: SUCCESS (0.001s)
[423.162270] Starting dynamic subtest: blt
[423.163377] Dynamic subtest blt: SUCCESS (0.001s)
[423.172173] Starting dynamic subtest: vebox
[423.173086] Dynamic subtest vebox: SUCCESS (0.002s)
[423.174316] Subtest legacy-resubmit: SUCCESS (0.035s)
[423.379196] [119/130] (651s left) api_intel_allocator (simple-allocator)
[423.472841] Starting subtest: simple-allocator
[423.473644] Starting dynamic subtest: basic
[423.490103] Dynamic subtest basic: SUCCESS (0.018s)
[423.499996] Starting dynamic subtest: parallel-one
[423.678277] Dynamic subtest parallel-one: SUCCESS (0.179s)
[423.687889] Starting dynamic subtest: print
[423.688691] Dynamic subtest print: SUCCESS (0.000s)
[423.697836] Starting dynamic subtest: reuse
[423.698661] Dynamic subtest reuse: SUCCESS (0.000s)
[423.707586] Starting dynamic subtest: reserve
[423.708422] Dynamic subtest reserve: SUCCESS (0.000s)
[423.717168] Starting dynamic subtest: fork-reopen-allocator
[423.718062] Dynamic subtest fork-reopen-allocator: SUCCESS (0.011s)
[423.719180] Subtest simple-allocator: SUCCESS (0.211s)
[423.793295] [120/130] (650s left) gen9_exec_parse (batch-invalid-length)
[423.903637] Subtest batch-invalid-length: SKIP (0.000s)
[423.943524] [121/130] (650s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[424.170433] Starting subtest: psr-rgb101010-draw-pwrite
[424.172084] Subtest psr-rgb101010-draw-pwrite: SKIP (0.000s)
[424.263494] [122/130] (650s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf)
[424.516217] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s)
[424.544667] [123/130] (650s left) kms_cursor_crc (cursor-offscreen-max-size)
[424.954367] Starting subtest: cursor-offscreen-max-size
[424.957848] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[425.144650] [124/130] (649s left) gem_ctx_persistence (engines-mixed)
[425.265202] Starting subtest: engines-mixed
[425.266111] Starting dynamic subtest: rcs0
[425.360329] Dynamic subtest rcs0: SUCCESS (0.095s)
[425.381276] Starting dynamic subtest: bcs0
[425.425924] Dynamic subtest bcs0: SUCCESS (0.064s)
[425.465770] Starting dynamic subtest: vcs0
[425.483360] Dynamic subtest vcs0: SUCCESS (0.056s)
[425.499049] Starting dynamic subtest: vcs1
[425.545331] Dynamic subtest vcs1: SUCCESS (0.061s)
[425.569578] Starting dynamic subtest: vecs0
[425.601076] Dynamic subtest vecs0: SUCCESS (0.054s)
[425.638442] Starting dynamic subtest: vecs1
[425.675298] Dynamic subtest vecs1: SUCCESS (0.072s)
[425.699349] Starting dynamic subtest: ccs0
[425.721477] Dynamic subtest ccs0: SUCCESS (0.045s)
[425.722885] Subtest engines-mixed: SUCCESS (0.456s)
[425.882486] [125/130] (648s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[425.983732] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[426.031490] [126/130] (648s left) gem_ctx_sseu (invalid-args)
[426.135561] Subtest invalid-args: SKIP (0.000s)
[426.178407] [127/130] (648s left) gem_exec_whisper (basic-queues-all)
[426.281245] Starting subtest: basic-queues-all
[448.267867] Subtest basic-queues-all: SUCCESS (21.740s)
[448.460061] [128/130] (626s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[448.687251] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[448.688941] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[448.771573] [129/130] (626s left) syncobj_timeline (signal-array)
[448.893118] Starting subtest: signal-array
[448.893986] Subtest signal-array: SUCCESS (0.000s)
[448.979001] [130/130] (626s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[449.222205] Starting subtest: basic-busy-flip-before-cursor-atomic
[449.223939] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[449.285456] Closing watchdogs
Done.