[32.000820] Initializing watchdogs
[32.000950]   /dev/watchdog0
[32.011552] [001/133] (960s left) gem_exec_balancer (bonded-dual)
[32.093489] Starting subtest: bonded-dual
[32.096784] Subtest bonded-dual: SKIP (0.000s)
[32.371535] [002/133] (960s left) gem_exec_params (invalid-ring)
[32.436571] Starting subtest: invalid-ring
[32.438141] Subtest invalid-ring: SUCCESS (0.000s)
[32.529661] [003/133] (960s left) gem_ctx_bad_destroy (invalid-default-ctx)
[32.588738] Starting subtest: invalid-default-ctx
[32.590338] Subtest invalid-default-ctx: SUCCESS (0.000s)
[32.651539] [004/133] (959s left) gem_tiled_partial_pwrite_pread (writes)
[32.718782] Subtest writes: SKIP (0.000s)
[32.761732] [005/133] (959s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[32.869743] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[32.870988] Starting dynamic subtest: pipe-A-default-mode
[33.162657] Dynamic subtest pipe-A-default-mode: SKIP (0.291s)
[33.165146] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.292s)
[34.038400] [006/133] (958s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[34.180103] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[34.182221] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[34.257596] [007/133] (958s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[34.394152] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[39.174820] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (4.781s)
[39.282506] [008/133] (953s left) kms_pm_rpm (universal-planes-dpms)
[40.905415] Starting subtest: universal-planes-dpms
[40.907503] Starting dynamic subtest: plane-31
[65.281154] Dynamic subtest plane-31: SUCCESS (24.376s)
[65.292542] Starting dynamic subtest: plane-40
[90.204311] Dynamic subtest plane-40: SUCCESS (24.921s)
[90.215264] Starting dynamic subtest: plane-49
[114.685163] Dynamic subtest plane-49: SUCCESS (24.483s)
[114.695505] Starting dynamic subtest: plane-58
[139.335153] Dynamic subtest plane-58: SUCCESS (24.649s)
[139.346455] Starting dynamic subtest: plane-67
[163.844180] Dynamic subtest plane-67: SUCCESS (24.509s)
[163.855546] Starting dynamic subtest: plane-76
[188.828819] Dynamic subtest plane-76: SUCCESS (24.982s)
[188.830592] Subtest universal-planes-dpms: SUCCESS (147.923s)
[189.856258] [009/133] (802s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[189.917586] Starting subtest: single-wait-all-for-submit-available-submitted
[189.919057] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[190.001179] [010/133] (802s left) sw_sync (timeline_closed)
[190.048898] Starting subtest: timeline_closed
[190.050245] Subtest timeline_closed: SUCCESS (0.000s)
[190.082893] [011/133] (802s left) gem_close_race (basic-process)
[190.152481] Starting subtest: basic-process
[190.213640] Subtest basic-process: SUCCESS (0.061s)
[190.385240] [012/133] (802s left) gem_exec_reloc (basic-wc-active)
[190.455721] Subtest basic-wc-active: SKIP (0.000s)
[190.502643] [013/133] (802s left) kms_lease (master-vs-lease)
[190.623604] Starting subtest: master-vs-lease
[190.627550] Subtest master-vs-lease: SUCCESS (0.001s)
[190.718706] [014/133] (802s left) kms_vblank (wait-idle)
[190.825508] Starting subtest: wait-idle
[190.826734] Starting dynamic subtest: pipe-A-eDP-1
[192.586577] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.757s)
[192.599868] Starting dynamic subtest: pipe-D-eDP-1
[195.116179] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.526s)
[195.117553] Subtest wait-idle: SUCCESS (4.290s)
[196.038267] [015/133] (796s left) kms_psr (pr-cursor-blt)
[196.174190] Starting subtest: pr-cursor-blt
[196.177359] Subtest pr-cursor-blt: SKIP (0.000s)
[196.238824] [016/133] (796s left) i915_hangman (engine-error-state-capture)
[196.311871] Starting subtest: engine-error-state-capture
[196.313092] Starting dynamic subtest: rcs0
[199.469947] Dynamic subtest rcs0: SUCCESS (3.155s)
[199.482930] Starting dynamic subtest: bcs0
[205.423916] Dynamic subtest bcs0: SUCCESS (5.953s)
[205.436964] Starting dynamic subtest: vcs0
[211.373501] Dynamic subtest vcs0: SUCCESS (5.949s)
[211.385197] Starting dynamic subtest: vcs1
[216.365674] Dynamic subtest vcs1: SUCCESS (4.992s)
[216.377073] Starting dynamic subtest: vecs0
[221.422107] Dynamic subtest vecs0: SUCCESS (5.056s)
[221.433857] Starting dynamic subtest: ccs0
[227.438076] Dynamic subtest ccs0: SUCCESS (6.015s)
[227.439935] Subtest engine-error-state-capture: SUCCESS (31.124s)
[227.509654] [017/133] (765s left) syncobj_timeline (wait-for-submit-delayed-submit)
[227.574582] Starting subtest: wait-for-submit-delayed-submit
[227.676901] Subtest wait-for-submit-delayed-submit: SUCCESS (0.102s)
[227.743068] [018/133] (765s left) gem_pwrite_snooped
[227.854872] [019/133] (765s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[227.954749] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[227.956941] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[228.050449] [020/133] (764s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[228.161853] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[228.179946] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.017s)
[228.244264] [021/133] (764s left) kms_psr2_sf (fbc-overlay-plane-update-sf-dmg-area)
[233.462136] Starting subtest: fbc-overlay-plane-update-sf-dmg-area
[233.463691] Starting dynamic subtest: psr2-pipe-A-eDP-1
[234.298212] Dynamic subtest psr2-pipe-A-eDP-1: SKIP (0.834s)
[234.309069] Starting dynamic subtest: psr2-pipe-B-eDP-1
[235.544032] Dynamic subtest psr2-pipe-B-eDP-1: SKIP (1.244s)
[235.546433] Subtest fbc-overlay-plane-update-sf-dmg-area: SKIP (2.082s)
[236.802732] [022/133] (756s left) kms_flip (flip-vs-fences)
[236.932821] Starting subtest: flip-vs-fences
[236.938428] Subtest flip-vs-fences: SKIP (0.000s)
[237.003723] [023/133] (755s left) v3d/v3d_submit_cl (job-perfmon)
[237.069283] Subtest job-perfmon: SKIP (0.000s)
[237.111342] [024/133] (755s left) gem_exec_schedule (semaphore-power)
[237.307429] Subtest semaphore-power: SKIP (0.000s)
[237.477413] [025/133] (755s left) prime_busy (hang)
[237.550360] Starting subtest: hang
[237.551873] Starting dynamic subtest: rcs0
[263.982529] Dynamic subtest rcs0: SUCCESS (26.429s)
[263.987045] Starting dynamic subtest: bcs0
[271.136069] Dynamic subtest bcs0: SUCCESS (7.153s)
[271.147923] Starting dynamic subtest: vcs0
[278.111717] Dynamic subtest vcs0: SUCCESS (6.976s)
[278.123030] Starting dynamic subtest: vcs1
[285.158453] Dynamic subtest vcs1: SUCCESS (7.046s)
[285.169949] Starting dynamic subtest: vecs0
[292.126931] Dynamic subtest vecs0: SUCCESS (6.970s)
[292.139478] Starting dynamic subtest: ccs0
[306.025334] Dynamic subtest ccs0: SUCCESS (13.897s)
[306.026967] Subtest hang: SUCCESS (68.473s)
[306.137479] [026/133] (686s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[306.256156] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[306.258277] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[306.333548] [027/133] (686s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[306.467413] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[306.469506] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[306.554576] [028/133] (686s left) perf (create-destroy-userspace-config)
[306.666795] Starting subtest: create-destroy-userspace-config
[306.687881] Subtest create-destroy-userspace-config: SUCCESS (0.022s)
[306.710423] [029/133] (686s left) gem_mmap_wc (write-wc-read-gtt)
[306.764219] Subtest write-wc-read-gtt: SKIP (0.000s)
[306.799263] [030/133] (686s left) gem_request_retire (retire-vma-not-inactive)
[306.857099] Starting subtest: retire-vma-not-inactive
[306.879863] Subtest retire-vma-not-inactive: SUCCESS (0.022s)
[306.978913] [031/133] (686s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0)
[307.090630] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0
[308.079254] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (0.989s)
[308.223783] [032/133] (684s left) gem_exec_fence (keep-in-fence)
[308.411772] Starting subtest: keep-in-fence
[308.413856] Starting dynamic subtest: rcs0
[308.479201] Dynamic subtest rcs0: SUCCESS (0.067s)
[308.491699] Starting dynamic subtest: bcs0
[308.535051] Dynamic subtest bcs0: SUCCESS (0.055s)
[308.546673] Starting dynamic subtest: vcs0
[310.481499] Dynamic subtest vcs0: SUCCESS (1.943s)
[310.493143] Starting dynamic subtest: vcs1
[312.464667] Dynamic subtest vcs1: SUCCESS (1.983s)
[312.476537] Starting dynamic subtest: vecs0
[314.512747] Dynamic subtest vecs0: SUCCESS (2.047s)
[314.524366] Starting dynamic subtest: ccs0
[314.736803] Dynamic subtest ccs0: SUCCESS (0.225s)
[314.738800] Subtest keep-in-fence: SUCCESS (6.325s)
[316.511967] [033/133] (676s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[316.622475] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[316.624607] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[316.726310] [034/133] (676s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[316.830726] Starting subtest: psr-dirtyfb-ioctl
[316.831941] Starting dynamic subtest: A-eDP-1
[318.520675] Dynamic subtest A-eDP-1: SUCCESS (1.688s)
[318.522234] Subtest psr-dirtyfb-ioctl: SUCCESS (1.689s)
[319.426918] [035/133] (673s left) gem_spin_batch (resubmit-new-all)
[319.492276] Starting subtest: resubmit-new-all
[319.494057] Starting dynamic subtest: rcs0
[319.503845] Dynamic subtest rcs0: SUCCESS (0.012s)
[319.516310] Starting dynamic subtest: bcs0
[319.517649] Dynamic subtest bcs0: SUCCESS (0.009s)
[319.527492] Starting dynamic subtest: vcs0
[319.528902] Dynamic subtest vcs0: SUCCESS (0.008s)
[319.541766] Starting dynamic subtest: vcs1
[319.542924] Dynamic subtest vcs1: SUCCESS (0.007s)
[319.554526] Starting dynamic subtest: vecs0
[319.555808] Dynamic subtest vecs0: SUCCESS (0.012s)
[319.562235] Starting dynamic subtest: ccs0
[319.563340] Dynamic subtest ccs0: SUCCESS (0.011s)
[319.564484] Subtest resubmit-new-all: SUCCESS (0.060s)
[321.512422] [036/133] (671s left) syncobj_basic (bad-destroy)
[321.582949] Starting subtest: bad-destroy
[321.584375] Subtest bad-destroy: SUCCESS (0.000s)
[321.684547] [037/133] (671s left) api_intel_bb (blit-reloc-keep-cache)
[321.766758] Starting subtest: blit-reloc-keep-cache
[321.770358] Subtest blit-reloc-keep-cache: SKIP (0.001s)
[321.863957] [038/133] (671s left) i915_power (sanity)
[321.923071] Starting subtest: sanity
[325.970806] Subtest sanity: SUCCESS (4.042s)
[327.529354] [039/133] (665s left) gem_exec_balancer (full-late)
[327.608649] Starting subtest: full-late
[332.108825] Subtest full-late: SUCCESS (4.500s)
[332.389759] [040/133] (660s left) gem_softpin (softpin)
[332.465707] Starting subtest: softpin
[364.683466] Subtest softpin: SUCCESS (32.214s)
[364.803454] [041/133] (628s left) perf_pmu (interrupts-sync)
[364.851365] Starting subtest: interrupts-sync
[365.967467] Subtest interrupts-sync: SUCCESS (1.115s)
[366.077875] [042/133] (627s left) gen9_exec_parse (basic-rejected)
[366.153411] Subtest basic-rejected: SKIP (0.000s)
[366.208326] [043/133] (627s left) kms_frontbuffer_tracking (plane-fbc-rte)
[366.312298] Starting subtest: plane-fbc-rte
[366.314119] Subtest plane-fbc-rte: SKIP (0.000s)
[366.411868] [044/133] (626s left) gem_exec_balancer (waits)
[366.478522] Starting subtest: waits
[372.701739] Subtest waits: SUCCESS (6.221s)
[372.962653] [045/133] (620s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[373.077828] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[376.391637] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (3.314s)
[376.529521] [046/133] (616s left) gem_workarounds (reset-context)
[376.601857] Starting subtest: reset-context
[376.775269] Subtest reset-context: SUCCESS (0.174s)
[376.902646] [047/133] (616s left) kms_busy (extended-modeset-hang-newfb)
[377.017613] Starting subtest: extended-modeset-hang-newfb
[377.018819] Starting dynamic subtest: pipe-A
[412.393963] Dynamic subtest pipe-A: SUCCESS (35.373s)
[412.405245] Starting dynamic subtest: pipe-D
[435.416366] Dynamic subtest pipe-D: SUCCESS (23.019s)
[435.417739] Subtest extended-modeset-hang-newfb: SUCCESS (58.399s)
[436.291315] [048/133] (557s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite)
[436.439708] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite
[441.015059] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (4.576s)
[441.105395] [049/133] (552s left) perf_pmu (busy-accuracy-98)
[441.148254] Starting subtest: busy-accuracy-98
[441.149485] Starting dynamic subtest: rcs0
[444.200899] Dynamic subtest rcs0: SUCCESS (3.051s)
[444.211818] Starting dynamic subtest: bcs0
[447.272223] Dynamic subtest bcs0: SUCCESS (3.071s)
[447.287482] Starting dynamic subtest: vcs0
[450.321395] Dynamic subtest vcs0: SUCCESS (3.047s)
[450.335466] Starting dynamic subtest: vcs1
[453.375451] Dynamic subtest vcs1: SUCCESS (3.054s)
[453.386468] Starting dynamic subtest: vecs0
[456.431684] Dynamic subtest vecs0: SUCCESS (3.056s)
[456.450530] Starting dynamic subtest: ccs0
[459.507630] Dynamic subtest ccs0: SUCCESS (3.075s)
[459.509342] Subtest busy-accuracy-98: SUCCESS (18.359s)
[459.616798] [050/133] (533s left) gem_busy (busy)
[459.700429] Starting subtest: busy
[459.702062] Starting dynamic subtest: all-engines
[459.751251] Dynamic subtest all-engines: SUCCESS (0.054s)
[459.759561] Starting dynamic subtest: rcs0
[461.467497] Dynamic subtest rcs0: SUCCESS (1.711s)
[461.480549] Starting dynamic subtest: bcs0
[461.527705] Dynamic subtest bcs0: SUCCESS (0.063s)
[461.540682] Starting dynamic subtest: vcs0
[461.569771] Dynamic subtest vcs0: SUCCESS (0.040s)
[461.584277] Starting dynamic subtest: vcs1
[463.507306] Dynamic subtest vcs1: SUCCESS (1.936s)
[463.521783] Starting dynamic subtest: vecs0
[465.492785] Dynamic subtest vecs0: SUCCESS (1.984s)
[465.506453] Starting dynamic subtest: ccs0
[467.475323] Dynamic subtest ccs0: SUCCESS (1.984s)
[467.476930] Subtest busy: SUCCESS (7.776s)
[467.804221] [051/133] (525s left) kms_content_protection (atomic-dpms)
[467.968525] Starting subtest: atomic-dpms
[471.582067] Subtest atomic-dpms: SKIP (3.615s)
[472.834570] [052/133] (520s left) syncobj_wait (single-wait-all-for-submit-submitted)
[472.883786] Starting subtest: single-wait-all-for-submit-submitted
[472.986288] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.103s)
[473.052741] [053/133] (520s left) kms_sequence (get-forked-busy)
[473.175668] Starting subtest: get-forked-busy
[473.176885] Starting dynamic subtest: pipe-A-eDP-1
[475.101195] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.924s)
[475.117365] Starting dynamic subtest: pipe-B-eDP-1
[477.829094] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.725s)
[477.840051] Starting dynamic subtest: pipe-C-eDP-1
[480.512934] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.679s)
[480.527164] Starting dynamic subtest: pipe-D-eDP-1
[483.195801] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.683s)
[483.197298] Subtest get-forked-busy: SUCCESS (10.020s)
[484.103324] [054/133] (509s left) syncobj_timeline (multi-wait-for-submit-signaled)
[484.161620] Starting subtest: multi-wait-for-submit-signaled
[484.162932] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[484.247954] [055/133] (509s left) syncobj_eventfd (timeline-wait-signaled)
[484.315642] Starting subtest: timeline-wait-signaled
[484.316992] Subtest timeline-wait-signaled: SUCCESS (0.000s)
[484.402322] [056/133] (509s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[484.490784] Starting subtest: fbc-psr-sprite-mmap-gtt
[484.491972] Starting dynamic subtest: eDP-1
[484.494030] Dynamic subtest eDP-1: SKIP (0.000s)
[484.495882] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s)
[484.552785] [057/133] (509s left) vc4/vc4_perfmon (get-values-invalid-perfmon)
[484.616475] Subtest get-values-invalid-perfmon: SKIP (0.000s)
[484.668055] [058/133] (509s left) vc4/vc4_wait_seqno (bad-seqno-1ns)
[484.740563] Subtest bad-seqno-1ns: SKIP (0.000s)
[484.784908] [059/133] (508s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[484.899518] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[484.919929] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.015s)
[484.977273] [060/133] (508s left) gem_ctx_shared (create-shared-gtt)
[485.060565] Starting subtest: create-shared-gtt
[487.215439] Subtest create-shared-gtt: SUCCESS (2.153s)
[487.548423] [061/133] (506s left) kms_cursor_crc (cursor-suspend)
[487.669832] Starting subtest: cursor-suspend
[487.670925] Starting dynamic subtest: pipe-A-eDP-1
[524.101902] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.522s)
[524.114869] Starting dynamic subtest: pipe-D-eDP-1
[561.092285] Dynamic subtest pipe-D-eDP-1: SUCCESS (6.979s)
[561.093728] Subtest cursor-suspend: SUCCESS (14.505s)
[565.981980] [062/133] (490s left) prime_mmap (test_forked_cpu_write)
[566.043395] Starting subtest: test_forked_cpu_write
[566.044507] Starting dynamic subtest: test_forked_cpu_write-smem
[566.056731] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.014s)
[566.058266] Subtest test_forked_cpu_write: SUCCESS (0.015s)
[566.144983] [063/133] (490s left) kms_invalid_mode (clock-too-high)
[566.273979] Starting subtest: clock-too-high
[566.274976] Starting dynamic subtest: pipe-A-eDP-1
[566.276833] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[566.282704] Starting dynamic subtest: pipe-B-eDP-1
[566.284619] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[566.290000] Starting dynamic subtest: pipe-C-eDP-1
[566.291934] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[566.297467] Starting dynamic subtest: pipe-D-eDP-1
[566.299438] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[566.301462] Subtest clock-too-high: SKIP (0.004s)
[566.333267] [064/133] (490s left) kms_psr (fbc-pr-primary-page-flip)
[566.421054] Starting subtest: fbc-pr-primary-page-flip
[566.423302] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[566.485742] [065/133] (490s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[566.603152] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[566.604354] Starting dynamic subtest: pipe-A-eDP-1
[567.045970] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.442s)
[567.062258] Starting dynamic subtest: pipe-B-eDP-1
[568.589985] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.542s)
[568.604670] Starting dynamic subtest: pipe-C-eDP-1
[570.113750] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.523s)
[570.120627] Starting dynamic subtest: pipe-D-eDP-1
[571.665202] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.550s)
[571.666643] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (5.062s)
[572.908488] [066/133] (483s left) perf (gen12-mi-rpc)
[573.008248] Starting subtest: gen12-mi-rpc
[573.010602] Starting dynamic subtest: rcs0
[573.023452] Dynamic subtest rcs0: SUCCESS (0.014s)
[573.024861] Subtest gen12-mi-rpc: SUCCESS (0.014s)
[573.053296] [067/133] (483s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[573.194101] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[574.273502] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: FAIL (1.002s)
[574.306603] [068/133] (482s left) kms_chamelium_edid (hdmi-mode-timings)
[574.711509] Subtest hdmi-mode-timings: SKIP (0.000s)
[575.568800] [069/133] (481s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[575.696497] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[575.698624] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[575.794462] [070/133] (481s left) kms_feature_discovery (display)
[575.882118] Starting subtest: display
[575.883361] Subtest display: SUCCESS (0.000s)
[575.947861] [071/133] (480s left) kms_plane_cursor (primary)
[576.058426] Starting subtest: primary
[576.060629] Starting dynamic subtest: pipe-A-eDP-1-size-64
[578.999551] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.941s)
[579.030070] Starting dynamic subtest: pipe-A-eDP-1-size-128
[581.968591] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.951s)
[581.999579] Starting dynamic subtest: pipe-A-eDP-1-size-256
[584.935646] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.949s)
[585.262564] Starting dynamic subtest: pipe-B-eDP-1-size-64
[589.042447] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.789s)
[589.076589] Starting dynamic subtest: pipe-B-eDP-1-size-128
[592.032435] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.972s)
[592.063473] Starting dynamic subtest: pipe-B-eDP-1-size-256
[594.977877] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.928s)
[595.306978] Starting dynamic subtest: pipe-C-eDP-1-size-64
[598.643672] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (3.346s)
[598.675193] Starting dynamic subtest: pipe-C-eDP-1-size-128
[601.144517] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.481s)
[601.174347] Starting dynamic subtest: pipe-C-eDP-1-size-256
[603.633704] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.469s)
[603.964127] Starting dynamic subtest: pipe-D-eDP-1-size-64
[607.281855] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (3.334s)
[607.313744] Starting dynamic subtest: pipe-D-eDP-1-size-128
[609.837502] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.536s)
[609.868745] Starting dynamic subtest: pipe-D-eDP-1-size-256
[612.315956] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.458s)
[612.639022] Subtest primary: SUCCESS (36.578s)
[613.547773] [072/133] (443s left) vgem_basic (unload)
[613.594824] Starting subtest: unload
[642.661686] Subtest unload: SUCCESS (29.064s)
[642.764332] [073/133] (414s left) dumb_buffer (create-valid-dumb)
[642.827237] Starting subtest: create-valid-dumb
[642.828726] Subtest create-valid-dumb: SUCCESS (0.000s)
[642.905534] [074/133] (414s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[643.089424] Starting subtest: cursor-rapid-movement-64x64
[643.096819] Starting dynamic subtest: pipe-A-eDP-1
[643.637635] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.544s)
[643.668579] Starting dynamic subtest: pipe-D-eDP-1
[644.914593] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.258s)
[644.915975] Subtest cursor-rapid-movement-64x64: SUCCESS (1.823s)
[645.799002] [075/133] (411s left) gem_exec_flush (basic-wb-rw-default)
[645.882858] Starting subtest: basic-wb-rw-default
[651.324031] Subtest basic-wb-rw-default: SUCCESS (5.441s)
[651.505704] [076/133] (405s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[651.609290] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[651.610682] Starting dynamic subtest: pipe-A-eDP-1
[652.292963] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.682s)
[652.308588] Starting dynamic subtest: pipe-B-eDP-1
[654.161311] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.866s)
[654.175051] Starting dynamic subtest: pipe-C-eDP-1
[656.040597] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.877s)
[656.059174] Starting dynamic subtest: pipe-D-eDP-1
[657.829333] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.786s)
[657.830580] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (6.220s)
[659.108977] [077/133] (397s left) gem_mmap_gtt (cpuset-big-copy)
[659.167392] Subtest cpuset-big-copy: SKIP (0.000s)
[659.211813] [078/133] (397s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[659.330251] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[659.332512] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[659.402788] [079/133] (397s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[659.517151] Starting subtest: primary-y-tiled-reflect-x-0
[659.578570] Subtest primary-y-tiled-reflect-x-0: SKIP (0.059s)
[659.664891] [080/133] (397s left) kms_psr (psr-sprite-mmap-gtt)
[659.770388] Starting subtest: psr-sprite-mmap-gtt
[659.771697] Starting dynamic subtest: eDP-1
[661.310884] Dynamic subtest eDP-1: SKIP (1.536s)
[661.313893] Subtest psr-sprite-mmap-gtt: SKIP (1.537s)
[661.460836] [081/133] (395s left) kms_psr2_su (page_flip-p010)
[661.511369] Subtest page_flip-P010: SKIP (0.000s)
[661.556213] [082/133] (395s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[661.668510] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[667.484802] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (5.818s)
[667.600577] [083/133] (389s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[667.712776] Starting subtest: plane-upscale-20x20-with-pixel-format
[667.714152] Starting dynamic subtest: pipe-A-eDP-1
[669.237322] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.524s)
[669.253333] Starting dynamic subtest: pipe-B-eDP-1
[671.901707] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.662s)
[671.913856] Starting dynamic subtest: pipe-C-eDP-1
[673.236504] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.332s)
[673.253216] Starting dynamic subtest: pipe-D-eDP-1
[674.578491] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.338s)
[674.579693] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (6.867s)
[675.839824] [084/133] (381s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[675.905493] Subtest tiled-to-untiled: SKIP (0.000s)
[675.967620] [085/133] (381s left) gem_tiled_fence_blits (basic)
[676.031971] Subtest basic: SKIP (0.000s)
[676.084876] [086/133] (381s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[676.191591] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[676.193560] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[676.302111] [087/133] (380s left) kms_chamelium_audio (hdmi-audio)
[676.702304] Subtest hdmi-audio: SKIP (0.000s)
[677.585618] [088/133] (379s left) gem_wait (wait)
[677.666524] Starting subtest: wait
[677.667607] Starting dynamic subtest: all-engines
[679.412235] Dynamic subtest all-engines: SUCCESS (1.742s)
[679.428260] Starting dynamic subtest: rcs0
[680.455265] Dynamic subtest rcs0: SUCCESS (1.044s)
[680.470864] Starting dynamic subtest: bcs0
[681.503882] Dynamic subtest bcs0: SUCCESS (1.047s)
[681.520105] Starting dynamic subtest: vcs0
[682.547040] Dynamic subtest vcs0: SUCCESS (1.042s)
[682.563175] Starting dynamic subtest: vcs1
[683.591883] Dynamic subtest vcs1: SUCCESS (1.044s)
[683.608029] Starting dynamic subtest: vecs0
[684.636771] Dynamic subtest vecs0: SUCCESS (1.043s)
[684.653338] Starting dynamic subtest: ccs0
[685.684446] Dynamic subtest ccs0: SUCCESS (1.046s)
[685.685951] Subtest wait: SUCCESS (8.018s)
[685.885795] [089/133] (371s left) api_intel_bb (purge-bb)
[685.953152] Starting subtest: purge-bb
[685.960385] Subtest purge-bb: SUCCESS (0.008s)
[686.077057] [090/133] (371s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[686.137106] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[686.238642] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.101s)
[686.311230] [091/133] (371s left) kms_chamelium_hpd (hdmi-hpd-fast)
[686.710494] Subtest hdmi-hpd-fast: SKIP (0.000s)
[687.565036] [092/133] (369s left) v3d/v3d_create_bo (create-bo-invalid-flags)
[687.656437] Subtest create-bo-invalid-flags: SKIP (0.000s)
[687.704656] [093/133] (369s left) kms_rotation_crc (primary-rotation-180)
[687.812925] Starting subtest: primary-rotation-180
[695.888511] Subtest primary-rotation-180: SUCCESS (8.076s)
[697.130303] [094/133] (360s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[697.196676] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[697.199745] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[697.374677] [095/133] (360s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[697.527203] Starting subtest: 2x-flip-vs-cursor-atomic
[697.531707] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.003s)
[697.664971] [096/133] (359s left) gem_render_copy (linear-to-vebox-y-tiled)
[697.735933] Starting subtest: linear-to-vebox-y-tiled
[697.738381] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[697.916751] [097/133] (359s left) kms_properties (connector-properties-legacy)
[698.032110] Starting subtest: connector-properties-legacy
[706.578846] Subtest connector-properties-legacy: SUCCESS (8.547s)
[707.432187] [098/133] (350s left) kms_flip (basic-plain-flip)
[707.545187] Starting subtest: basic-plain-flip
[707.548264] Starting dynamic subtest: A-eDP1
[709.328069] Dynamic subtest A-eDP1: SUCCESS (1.777s)
[709.344394] Starting dynamic subtest: B-eDP1
[711.054446] Dynamic subtest B-eDP1: SUCCESS (1.728s)
[711.070568] Starting dynamic subtest: C-eDP1
[712.771429] Dynamic subtest C-eDP1: SUCCESS (1.715s)
[712.787922] Starting dynamic subtest: D-eDP1
[714.560810] Dynamic subtest D-eDP1: SUCCESS (1.788s)
[714.568676] Subtest basic-plain-flip: SUCCESS (7.024s)
[715.832765] [099/133] (341s left) kms_cursor_crc (cursor-onscreen-256x256)
[716.047783] Starting subtest: cursor-onscreen-256x256
[716.051293] Starting dynamic subtest: pipe-A-eDP-1
[718.309055] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.257s)
[718.344018] Starting dynamic subtest: pipe-D-eDP-1
[721.158118] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.829s)
[721.159473] Subtest cursor-onscreen-256x256: SUCCESS (5.109s)
[722.024635] [100/133] (335s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[722.143722] Starting subtest: x-tiled-32bpp-rotate-0
[723.589141] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.446s)
[723.729141] [101/133] (333s left) kms_async_flips (invalid-async-flip)
[723.855455] Starting subtest: invalid-async-flip
[723.857905] Subtest invalid-async-flip: SKIP (0.000s)
[725.088685] [102/133] (332s left) gem_softpin (evict-snoop-interruptible)
[725.150280] Starting subtest: evict-snoop-interruptible
[725.152747] Subtest evict-snoop-interruptible: SKIP (0.000s)
[725.263347] [103/133] (332s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[725.379238] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[728.074708] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (2.695s)
[728.213384] [104/133] (329s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[728.319538] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[728.321688] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[728.405994] [105/133] (329s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[728.535174] Starting subtest: 4-tiled-16bpp-rotate-270
[728.553839] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.018s)
[728.672472] [106/133] (329s left) v3d/v3d_submit_csd (single-out-sync)
[728.754566] Subtest single-out-sync: SKIP (0.000s)
[728.792505] [107/133] (328s left) gem_exec_parallel (userptr)
[728.866424] Starting subtest: userptr
[728.868160] Starting dynamic subtest: rcs0
[730.356201] Dynamic subtest rcs0: SUCCESS (1.489s)
[730.370077] Starting dynamic subtest: bcs0
[731.772729] Dynamic subtest bcs0: SUCCESS (1.415s)
[731.781109] Starting dynamic subtest: vcs0
[733.464010] Dynamic subtest vcs0: SUCCESS (1.688s)
[733.480552] Starting dynamic subtest: vcs1
[735.412526] Dynamic subtest vcs1: SUCCESS (1.947s)
[735.428494] Starting dynamic subtest: vecs0
[737.423061] Dynamic subtest vecs0: SUCCESS (2.006s)
[737.441082] Starting dynamic subtest: ccs0
[739.083245] Dynamic subtest ccs0: SUCCESS (1.663s)
[739.089057] Subtest userptr: SUCCESS (10.218s)
[739.269066] [108/133] (318s left) kms_flip (flip-vs-rmfb-interruptible)
[739.383581] Starting subtest: flip-vs-rmfb-interruptible
[739.386628] Starting dynamic subtest: A-eDP1
[748.119448] Dynamic subtest A-eDP1: SUCCESS (8.733s)
[748.135606] Starting dynamic subtest: B-eDP1
[756.827241] Dynamic subtest B-eDP1: SUCCESS (8.703s)
[756.845042] Starting dynamic subtest: C-eDP1
[765.579976] Dynamic subtest C-eDP1: SUCCESS (8.754s)
[765.598788] Starting dynamic subtest: D-eDP1
[774.286286] Dynamic subtest D-eDP1: SUCCESS (8.704s)
[774.293894] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.910s)
[775.531738] [109/133] (282s left) gem_exec_whisper (basic-contexts-priority-all)
[775.606434] Starting subtest: basic-contexts-priority-all
[796.468634] Subtest basic-contexts-priority-all: SUCCESS (20.860s)
[796.649956] [110/133] (261s left) kms_plane_scaling (planes-downscale-factor-0-25-upscale-factor-0-25)
[796.756095] Starting subtest: planes-downscale-factor-0-25-upscale-factor-0-25
[796.757288] Starting dynamic subtest: pipe-A-eDP-1
[796.768970] Dynamic subtest pipe-A-eDP-1: SKIP (0.008s)
[796.781579] Starting dynamic subtest: pipe-B-eDP-1
[796.785534] Dynamic subtest pipe-B-eDP-1: SKIP (0.016s)
[796.792281] Starting dynamic subtest: pipe-C-eDP-1
[796.801712] Dynamic subtest pipe-C-eDP-1: SKIP (0.016s)
[796.817116] Starting dynamic subtest: pipe-D-eDP-1
[796.819340] Dynamic subtest pipe-D-eDP-1: SKIP (0.017s)
[796.821453] Subtest planes-downscale-factor-0-25-upscale-factor-0-25: SKIP (0.062s)
[796.885189] [111/133] (260s left) gem_exec_reloc (basic-write-cpu-noreloc)
[796.929181] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[796.975021] [112/133] (260s left) kms_flip (modeset-vs-vblank-race-interruptible)
[797.081019] Starting subtest: modeset-vs-vblank-race-interruptible
[797.083912] Starting dynamic subtest: A-eDP1
[802.030572] Dynamic subtest A-eDP1: SUCCESS (4.946s)
[802.046562] Starting dynamic subtest: B-eDP1
[806.956878] Dynamic subtest B-eDP1: SUCCESS (4.924s)
[806.974872] Starting dynamic subtest: C-eDP1
[811.864021] Dynamic subtest C-eDP1: SUCCESS (4.906s)
[811.875829] Starting dynamic subtest: D-eDP1
[816.792825] Dynamic subtest D-eDP1: SUCCESS (4.927s)
[816.800044] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (19.719s)
[818.090543] [113/133] (239s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[818.206120] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[818.207248] Starting dynamic subtest: pipe-A-eDP-1
[818.209322] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[818.215644] Starting dynamic subtest: pipe-B-eDP-1
[818.217487] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[818.224986] Starting dynamic subtest: pipe-C-eDP-1
[818.227144] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[818.241772] Starting dynamic subtest: pipe-D-eDP-1
[818.244050] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[818.246080] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[818.261106] [114/133] (239s left) gem_exec_parallel (fds)
[818.330841] Starting subtest: fds
[818.332429] Starting dynamic subtest: rcs0
[821.020402] Dynamic subtest rcs0: SUCCESS (2.687s)
[821.038721] Starting dynamic subtest: bcs0
[824.537847] Dynamic subtest bcs0: SUCCESS (3.517s)
[824.553557] Starting dynamic subtest: vcs0
[828.657820] Dynamic subtest vcs0: SUCCESS (4.118s)
[828.665692] Starting dynamic subtest: vcs1
[832.677331] Dynamic subtest vcs1: SUCCESS (4.018s)
[832.694644] Starting dynamic subtest: vecs0
[836.682623] Dynamic subtest vecs0: SUCCESS (4.004s)
[836.689064] Starting dynamic subtest: ccs0
[840.126957] Dynamic subtest ccs0: SUCCESS (3.443s)
[840.128836] Subtest fds: SUCCESS (21.795s)
[840.303971] [115/133] (217s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[840.424707] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[840.426882] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[840.518992] [116/133] (217s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[840.646304] Starting subtest: yf-tiled-addfb-size-overflow
[840.648442] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[840.755373] [117/133] (217s left) syncobj_timeline (invalid-transfer-non-existent-point)
[840.828718] Starting subtest: invalid-transfer-non-existent-point
[840.829938] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[840.919581] [118/133] (217s left) i915_pm_rpm (debugfs-forcewake-user)
[842.574454] Starting subtest: debugfs-forcewake-user
[856.567726] Subtest debugfs-forcewake-user: SUCCESS (13.992s)
[856.904266] [119/133] (201s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[857.030685] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[861.768173] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (4.738s)
[861.872595] [120/133] (196s left) kms_flip (2x-nonexisting-fb-interruptible)
[861.974115] Starting subtest: 2x-nonexisting-fb-interruptible
[861.993857] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.015s)
[862.063929] [121/133] (195s left) gem_mmap_gtt (cpuset-medium-copy-odd)
[862.135846] Subtest cpuset-medium-copy-odd: SKIP (0.000s)
[862.199714] [122/133] (195s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[862.313531] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[862.315659] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[862.394815] [123/133] (195s left) gem_exec_whisper (basic-fds-priority)
[862.463970] Starting subtest: basic-fds-priority
[888.684729] Subtest basic-fds-priority: SUCCESS (26.217s)
[888.867067] [124/133] (169s left) kms_psr (psr2-cursor-mmap-gtt)
[889.001130] Starting subtest: psr2-cursor-mmap-gtt
[889.002274] Starting dynamic subtest: eDP-1
[890.811542] Dynamic subtest eDP-1: SUCCESS (1.809s)
[890.812919] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.810s)
[891.690958] [125/133] (166s left) gem_exec_schedule (preempt-contexts)
[891.778975] Starting subtest: preempt-contexts
[891.780384] Starting dynamic subtest: rcs0
[891.850796] Dynamic subtest rcs0: SUCCESS (0.072s)
[891.862943] Starting dynamic subtest: bcs0
[891.901257] Dynamic subtest bcs0: SUCCESS (0.050s)
[891.908808] Starting dynamic subtest: vcs0
[891.944141] Dynamic subtest vcs0: SUCCESS (0.042s)
[891.958122] Starting dynamic subtest: vcs1
[891.994519] Dynamic subtest vcs1: SUCCESS (0.051s)
[892.006990] Starting dynamic subtest: vecs0
[892.054945] Dynamic subtest vecs0: SUCCESS (0.060s)
[892.071959] Starting dynamic subtest: ccs0
[892.095631] Dynamic subtest ccs0: SUCCESS (0.040s)
[892.096887] Subtest preempt-contexts: SUCCESS (0.317s)
[893.520328] [126/133] (164s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[893.633395] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[893.634767] Starting dynamic subtest: pipe-A-default-mode
[893.924261] Dynamic subtest pipe-A-default-mode: SKIP (0.287s)
[893.926572] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.288s)
[894.829097] [127/133] (163s left) gem_ctx_persistence (engines-queued)
[894.892653] Starting subtest: engines-queued
[894.894422] Starting dynamic subtest: rcs0
[894.934099] Dynamic subtest rcs0: SUCCESS (0.042s)
[894.950352] Starting dynamic subtest: bcs0
[895.026349] Dynamic subtest bcs0: SUCCESS (0.091s)
[895.042100] Starting dynamic subtest: vcs0
[896.341811] Dynamic subtest vcs0: SUCCESS (1.312s)
[896.359092] Starting dynamic subtest: vcs1
[898.386035] Dynamic subtest vcs1: SUCCESS (2.043s)
[898.401509] Starting dynamic subtest: vecs0
[900.368068] Dynamic subtest vecs0: SUCCESS (1.982s)
[900.385841] Starting dynamic subtest: ccs0
[900.556344] Dynamic subtest ccs0: SUCCESS (0.187s)
[900.558058] Subtest engines-queued: SUCCESS (5.664s)
[900.685921] [128/133] (157s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size)
[900.825204] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size
[900.827616] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.001s)
[900.941567] [129/133] (157s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[901.067684] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[904.371057] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (3.304s)
[904.512380] [130/133] (153s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[904.609122] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[904.610463] Starting dynamic subtest: pipe-A-eDP-1
[906.484858] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.875s)
[906.500494] Starting dynamic subtest: pipe-B-eDP-1
[909.457934] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.972s)
[909.473512] Starting dynamic subtest: pipe-C-eDP-1
[912.365574] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.906s)
[912.379449] Starting dynamic subtest: pipe-D-eDP-1
[915.271383] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.904s)
[915.272721] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (10.662s)
[916.523066] [131/133] (141s left) vgem_basic (create)
[916.571633] Starting subtest: create
[916.573172] Subtest create: SUCCESS (0.000s)
[916.612167] [132/133] (141s left) dmabuf_sync_file (import-basic)
[916.648367] Starting subtest: import-basic
[916.649604] Subtest import-basic: SUCCESS (0.001s)
[916.685103] [133/133] (141s left) gem_create (create-ext-placement-sanity-check)
[916.862004] Starting subtest: create-ext-placement-sanity-check
[916.865888] Subtest create-ext-placement-sanity-check: SUCCESS (0.004s)
[916.951121] Closing watchdogs
Done.