[40.096270] Initializing watchdogs
[40.096326]   /dev/watchdog0
[40.102722] [001/133] (960s left) gem_exec_balancer (bonded-dual)
[40.177977] Starting subtest: bonded-dual
[40.180226] Subtest bonded-dual: SKIP (0.000s)
[40.459240] [002/133] (960s left) gem_exec_params (invalid-ring)
[40.520273] Starting subtest: invalid-ring
[40.521246] Subtest invalid-ring: SUCCESS (0.000s)
[40.594036] [003/133] (960s left) gem_ctx_bad_destroy (invalid-default-ctx)
[40.656199] Starting subtest: invalid-default-ctx
[40.657198] Subtest invalid-default-ctx: SUCCESS (0.000s)
[40.731393] [004/133] (959s left) gem_tiled_partial_pwrite_pread (writes)
[40.799693] Subtest writes: SKIP (0.000s)
[40.831665] [005/133] (959s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[41.024938] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[41.025772] Starting dynamic subtest: pipe-A-valid-mode
[41.129766] Dynamic subtest pipe-A-valid-mode: SKIP (0.103s)
[41.132141] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.104s)
[41.293143] [006/133] (959s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[41.514459] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[41.516227] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[41.599032] [007/133] (959s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[41.801128] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[41.802816] Subtest fbcpsr-rgb565-draw-mmap-wc: SKIP (0.000s)
[41.884865] [008/133] (958s left) kms_pm_rpm (universal-planes-dpms)
[43.681057] Starting subtest: universal-planes-dpms
[43.683275] Starting dynamic subtest: plane-31
[46.710174] Dynamic subtest plane-31: SUCCESS (3.028s)
[46.733070] Starting dynamic subtest: plane-40
[49.636802] Dynamic subtest plane-40: SUCCESS (2.925s)
[49.659930] Starting dynamic subtest: plane-49
[52.605813] Dynamic subtest plane-49: SUCCESS (2.969s)
[52.628864] Starting dynamic subtest: plane-58
[55.674398] Dynamic subtest plane-58: SUCCESS (3.068s)
[55.697591] Starting dynamic subtest: plane-67
[58.733904] Dynamic subtest plane-67: SUCCESS (3.058s)
[58.757288] Starting dynamic subtest: plane-76
[61.696947] Dynamic subtest plane-76: SUCCESS (2.963s)
[61.698945] Subtest universal-planes-dpms: SUCCESS (18.016s)
[62.061129] [009/133] (938s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[62.154789] Starting subtest: single-wait-all-for-submit-available-submitted
[62.155721] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[62.231870] [010/133] (938s left) sw_sync (timeline_closed)
[62.293629] Starting subtest: timeline_closed
[62.294729] Subtest timeline_closed: SUCCESS (0.000s)
[62.336538] [011/133] (938s left) gem_close_race (basic-process)
[62.432173] Starting subtest: basic-process
[62.484676] Subtest basic-process: SUCCESS (0.052s)
[62.706121] [012/133] (938s left) gem_exec_reloc (basic-wc-active)
[62.762217] Subtest basic-wc-active: SKIP (0.000s)
[62.795045] [013/133] (938s left) kms_lease (master-vs-lease)
[62.983784] Starting subtest: master-vs-lease
[62.985803] Subtest master-vs-lease: SUCCESS (0.002s)
[63.054582] [014/133] (937s left) kms_vblank (wait-idle)
[63.253650] Starting subtest: wait-idle
[63.255563] Starting dynamic subtest: pipe-A-DP-4
[65.551331] Dynamic subtest pipe-A-DP-4: SUCCESS (2.294s)
[65.568243] Starting dynamic subtest: pipe-D-DP-4
[67.816108] Dynamic subtest pipe-D-DP-4: SUCCESS (2.257s)
[67.817084] Subtest wait-idle: SUCCESS (4.562s)
[68.027827] [015/133] (932s left) kms_psr (pr-cursor-blt)
[68.215735] Subtest pr-cursor-blt: SKIP (0.000s)
[68.237787] [016/133] (932s left) i915_hangman (engine-error-state-capture)
[68.311875] Starting subtest: engine-error-state-capture
[68.312671] Starting dynamic subtest: rcs0
[73.030511] Dynamic subtest rcs0: SUCCESS (4.719s)
[73.036860] Starting dynamic subtest: bcs0
[77.048266] Dynamic subtest bcs0: SUCCESS (4.018s)
[77.053862] Starting dynamic subtest: vcs0
[81.013307] Dynamic subtest vcs0: SUCCESS (3.965s)
[81.018620] Starting dynamic subtest: vcs1
[85.054421] Dynamic subtest vcs1: SUCCESS (4.041s)
[85.060947] Starting dynamic subtest: vecs0
[89.035563] Dynamic subtest vecs0: SUCCESS (3.981s)
[89.042372] Starting dynamic subtest: vecs1
[93.052254] Dynamic subtest vecs1: SUCCESS (4.017s)
[93.058012] Starting dynamic subtest: ccs0
[97.018436] Dynamic subtest ccs0: SUCCESS (3.966s)
[97.019285] Subtest engine-error-state-capture: SUCCESS (28.707s)
[97.136511] [017/133] (903s left) syncobj_timeline (wait-for-submit-delayed-submit)
[97.197473] Starting subtest: wait-for-submit-delayed-submit
[97.301576] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[97.374529] [018/133] (903s left) gem_pwrite_snooped
[97.490705] [019/133] (903s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[97.693842] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[97.695545] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[97.767866] [020/133] (903s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[97.994873] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[98.013539] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.018s)
[98.083050] [021/133] (902s left) kms_psr2_sf (fbc-overlay-plane-update-sf-dmg-area)
[98.279423] Subtest fbc-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[98.306344] [022/133] (902s left) kms_flip (flip-vs-fences)
[98.494587] Starting subtest: flip-vs-fences
[98.496384] Subtest flip-vs-fences: SKIP (0.000s)
[98.566230] [023/133] (902s left) v3d/v3d_submit_cl (job-perfmon)
[98.650144] Subtest job-perfmon: SKIP (0.000s)
[98.719861] [024/133] (902s left) gem_exec_schedule (semaphore-power)
[98.954986] Subtest semaphore-power: SKIP (0.000s)
[99.138626] [025/133] (901s left) prime_busy (hang)
[99.195036] Starting subtest: hang
[99.197460] Starting dynamic subtest: rcs0
[125.017777] Dynamic subtest rcs0: SUCCESS (25.820s)
[125.023169] Starting dynamic subtest: bcs0
[132.110596] Dynamic subtest bcs0: SUCCESS (7.093s)
[132.116420] Starting dynamic subtest: vcs0
[139.156331] Dynamic subtest vcs0: SUCCESS (7.045s)
[139.162178] Starting dynamic subtest: vcs1
[146.125648] Dynamic subtest vcs1: SUCCESS (6.970s)
[146.131445] Starting dynamic subtest: vecs0
[153.107211] Dynamic subtest vecs0: SUCCESS (6.980s)
[153.113019] Starting dynamic subtest: vecs1
[160.146191] Dynamic subtest vecs1: SUCCESS (7.039s)
[160.151599] Starting dynamic subtest: ccs0
[173.979993] Dynamic subtest ccs0: SUCCESS (13.833s)
[173.981146] Subtest hang: SUCCESS (74.784s)
[174.067284] [026/133] (826s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[174.267601] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[174.269331] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[174.356274] [027/133] (826s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[174.590351] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[174.591912] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[174.670367] [028/133] (826s left) perf (create-destroy-userspace-config)
[175.038096] Starting subtest: create-destroy-userspace-config
[175.061181] Subtest create-destroy-userspace-config: SUCCESS (0.024s)
[175.080355] [029/133] (825s left) gem_mmap_wc (write-wc-read-gtt)
[175.143224] Subtest write-wc-read-gtt: SKIP (0.000s)
[175.177280] [030/133] (825s left) gem_request_retire (retire-vma-not-inactive)
[175.251365] Starting subtest: retire-vma-not-inactive
[175.328650] Subtest retire-vma-not-inactive: SUCCESS (0.077s)
[175.465702] [031/133] (825s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0)
[175.709685] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0
[176.903284] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.193s)
[177.052278] [032/133] (824s left) gem_exec_fence (keep-in-fence)
[177.258097] Starting subtest: keep-in-fence
[177.260104] Starting dynamic subtest: rcs0
[177.361374] Dynamic subtest rcs0: SUCCESS (0.103s)
[177.369641] Starting dynamic subtest: bcs0
[177.414309] Dynamic subtest bcs0: SUCCESS (0.052s)
[177.429596] Starting dynamic subtest: vcs0
[177.478102] Dynamic subtest vcs0: SUCCESS (0.063s)
[177.502308] Starting dynamic subtest: vcs1
[177.549107] Dynamic subtest vcs1: SUCCESS (0.071s)
[177.561149] Starting dynamic subtest: vecs0
[177.605067] Dynamic subtest vecs0: SUCCESS (0.055s)
[177.629923] Starting dynamic subtest: vecs1
[177.677058] Dynamic subtest vecs1: SUCCESS (0.072s)
[177.692203] Starting dynamic subtest: ccs0
[177.881549] Dynamic subtest ccs0: SUCCESS (0.204s)
[177.882672] Subtest keep-in-fence: SUCCESS (0.624s)
[178.559642] [033/133] (822s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[178.794404] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[178.796288] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[178.871629] [034/133] (822s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[179.094913] Starting subtest: psr-dirtyfb-ioctl
[179.096693] Subtest psr-dirtyfb-ioctl: SKIP (0.000s)
[179.169425] [035/133] (822s left) gem_spin_batch (resubmit-new-all)
[179.245384] Starting subtest: resubmit-new-all
[179.246299] Starting dynamic subtest: rcs0
[179.276293] Dynamic subtest rcs0: SUCCESS (0.031s)
[179.282244] Starting dynamic subtest: bcs0
[179.285121] Dynamic subtest bcs0: SUCCESS (0.009s)
[179.291121] Starting dynamic subtest: vcs0
[179.293340] Dynamic subtest vcs0: SUCCESS (0.007s)
[179.299220] Starting dynamic subtest: vcs1
[179.300099] Dynamic subtest vcs1: SUCCESS (0.006s)
[179.306455] Starting dynamic subtest: vecs0
[179.307328] Dynamic subtest vecs0: SUCCESS (0.007s)
[179.313236] Starting dynamic subtest: vecs1
[179.314143] Dynamic subtest vecs1: SUCCESS (0.006s)
[179.320121] Starting dynamic subtest: ccs0
[179.321075] Dynamic subtest ccs0: SUCCESS (0.008s)
[179.321973] Subtest resubmit-new-all: SUCCESS (0.076s)
[179.590099] [036/133] (821s left) syncobj_basic (bad-destroy)
[179.649129] Starting subtest: bad-destroy
[179.650168] Subtest bad-destroy: SUCCESS (0.000s)
[179.717590] [037/133] (821s left) api_intel_bb (blit-reloc-keep-cache)
[179.784173] Starting subtest: blit-reloc-keep-cache
[179.786150] Subtest blit-reloc-keep-cache: SKIP (0.000s)
[179.885956] [038/133] (821s left) i915_power (sanity)
[179.953984] Starting subtest: sanity
[184.013553] Subtest sanity: SUCCESS (4.058s)
[184.156794] [039/133] (817s left) gem_exec_balancer (full-late)
[184.218762] Starting subtest: full-late
[185.476370] Subtest full-late: SUCCESS (1.257s)
[185.781537] [040/133] (815s left) gem_softpin (softpin)
[185.847203] Starting subtest: softpin
[218.095864] Subtest softpin: SUCCESS (32.247s)
[218.186684] [041/133] (783s left) perf_pmu (interrupts-sync)
[218.243240] Starting subtest: interrupts-sync
[219.335605] Subtest interrupts-sync: SUCCESS (1.091s)
[219.457241] [042/133] (781s left) gen9_exec_parse (basic-rejected)
[219.523049] Subtest basic-rejected: SKIP (0.000s)
[219.560872] [043/133] (781s left) kms_frontbuffer_tracking (plane-fbc-rte)
[219.749425] Starting subtest: plane-fbc-rte
[219.751242] Subtest plane-fbc-rte: SKIP (0.000s)
[219.821946] [044/133] (781s left) gem_exec_balancer (waits)
[219.895341] Starting subtest: waits
[232.016177] Subtest waits: SUCCESS (12.120s)
[232.287039] [045/133] (769s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[232.485529] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[235.171734] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (2.686s)
[235.326713] [046/133] (766s left) gem_workarounds (reset-context)
[235.395137] Starting subtest: reset-context
[235.645538] Subtest reset-context: SUCCESS (0.250s)
[235.773066] [047/133] (765s left) kms_busy (extended-modeset-hang-newfb)
[235.989669] Starting subtest: extended-modeset-hang-newfb
[235.991677] Starting dynamic subtest: pipe-A
[251.689645] Dynamic subtest pipe-A: SUCCESS (15.697s)
[251.708616] Starting dynamic subtest: pipe-D
[267.401372] Dynamic subtest pipe-D: SUCCESS (15.706s)
[267.402813] Subtest extended-modeset-hang-newfb: SUCCESS (31.412s)
[267.634582] [048/133] (733s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite)
[267.845404] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite
[267.847200] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[267.947514] [049/133] (733s left) perf_pmu (busy-accuracy-98)
[268.023582] Starting subtest: busy-accuracy-98
[268.024550] Starting dynamic subtest: rcs0
[271.074899] Dynamic subtest rcs0: SUCCESS (3.050s)
[271.082314] Starting dynamic subtest: bcs0
[274.125910] Dynamic subtest bcs0: SUCCESS (3.051s)
[274.133150] Starting dynamic subtest: vcs0
[277.179650] Dynamic subtest vcs0: SUCCESS (3.054s)
[277.186829] Starting dynamic subtest: vcs1
[280.232540] Dynamic subtest vcs1: SUCCESS (3.053s)
[280.239774] Starting dynamic subtest: vecs0
[283.284694] Dynamic subtest vecs0: SUCCESS (3.052s)
[283.292171] Starting dynamic subtest: vecs1
[286.335050] Dynamic subtest vecs1: SUCCESS (3.050s)
[286.342528] Starting dynamic subtest: ccs0
[289.383935] Dynamic subtest ccs0: SUCCESS (3.049s)
[289.384807] Subtest busy-accuracy-98: SUCCESS (21.360s)
[289.487011] [050/133] (712s left) gem_busy (busy)
[289.554993] Starting subtest: busy
[289.555929] Starting dynamic subtest: all-engines
[289.648536] Dynamic subtest all-engines: SUCCESS (0.093s)
[289.655782] Starting dynamic subtest: rcs0
[289.736159] Dynamic subtest rcs0: SUCCESS (0.086s)
[289.743212] Starting dynamic subtest: bcs0
[289.774389] Dynamic subtest bcs0: SUCCESS (0.039s)
[289.785034] Starting dynamic subtest: vcs0
[289.814045] Dynamic subtest vcs0: SUCCESS (0.039s)
[289.838962] Starting dynamic subtest: vcs1
[289.855862] Dynamic subtest vcs1: SUCCESS (0.041s)
[289.880466] Starting dynamic subtest: vecs0
[289.895741] Dynamic subtest vecs0: SUCCESS (0.039s)
[289.910770] Starting dynamic subtest: vecs1
[289.934720] Dynamic subtest vecs1: SUCCESS (0.039s)
[289.947404] Starting dynamic subtest: ccs0
[289.975189] Dynamic subtest ccs0: SUCCESS (0.040s)
[289.976632] Subtest busy: SUCCESS (0.420s)
[290.393657] [051/133] (711s left) kms_content_protection (atomic-dpms)
[290.650017] Starting subtest: atomic-dpms
[290.671978] Starting dynamic subtest: pipe-A-DP-4
[411.656208] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[411.926112] Closing watchdogs
[411.927581] Initializing watchdogs
[411.927621]   /dev/watchdog0
[411.935987] [052/133] (589s left) syncobj_wait (single-wait-all-for-submit-submitted)
[411.992980] Starting subtest: single-wait-all-for-submit-submitted
[412.094461] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.102s)
[412.167048] [053/133] (589s left) kms_sequence (get-forked-busy)
[412.347997] Starting subtest: get-forked-busy
[412.348879] Starting dynamic subtest: pipe-A-DP-4
[414.946353] Dynamic subtest pipe-A-DP-4: SUCCESS (2.597s)
[414.965041] Starting dynamic subtest: pipe-B-DP-4
[417.516872] Dynamic subtest pipe-B-DP-4: SUCCESS (2.568s)
[417.534073] Starting dynamic subtest: pipe-C-DP-4
[420.075788] Dynamic subtest pipe-C-DP-4: SUCCESS (2.556s)
[420.098961] Starting dynamic subtest: pipe-D-DP-4
[422.659095] Dynamic subtest pipe-D-DP-4: SUCCESS (2.579s)
[422.660784] Subtest get-forked-busy: SUCCESS (10.311s)
[422.955251] [054/133] (578s left) syncobj_timeline (multi-wait-for-submit-signaled)
[423.043206] Starting subtest: multi-wait-for-submit-signaled
[423.044365] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[423.164999] [055/133] (578s left) syncobj_eventfd (timeline-wait-signaled)
[423.241145] Starting subtest: timeline-wait-signaled
[423.242140] Subtest timeline-wait-signaled: SUCCESS (0.000s)
[423.365707] [056/133] (578s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[423.558752] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.000s)
[423.591453] [057/133] (578s left) vc4/vc4_perfmon (get-values-invalid-perfmon)
[423.666627] Subtest get-values-invalid-perfmon: SKIP (0.000s)
[423.723765] [058/133] (577s left) vc4/vc4_wait_seqno (bad-seqno-1ns)
[423.833516] Subtest bad-seqno-1ns: SKIP (0.000s)
[423.888277] [059/133] (577s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[424.095570] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[424.114171] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.018s)
[424.185620] [060/133] (577s left) gem_ctx_shared (create-shared-gtt)
[424.277950] Starting subtest: create-shared-gtt
[426.429307] Subtest create-shared-gtt: SUCCESS (2.151s)
[428.484382] [061/133] (573s left) kms_cursor_crc (cursor-suspend)
[428.707933] Starting subtest: cursor-suspend
[428.709850] Starting dynamic subtest: pipe-A-DP-4
[468.166306] Dynamic subtest pipe-A-DP-4: SUCCESS (8.055s)
[468.186867] Starting dynamic subtest: pipe-D-DP-4
[508.177798] Dynamic subtest pipe-D-DP-4: SUCCESS (7.599s)
[508.179013] Subtest cursor-suspend: SUCCESS (15.661s)
[508.666253] [062/133] (556s left) prime_mmap (test_forked_cpu_write)
[508.752627] Starting subtest: test_forked_cpu_write
[508.753725] Starting dynamic subtest: test_forked_cpu_write-smem
[508.764287] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.011s)
[508.773205] Starting dynamic subtest: test_forked_cpu_write-lmem0
[508.774374] Dynamic subtest test_forked_cpu_write-lmem0: SUCCESS (0.008s)
[508.775599] Subtest test_forked_cpu_write: SUCCESS (0.021s)
[508.914402] [063/133] (556s left) kms_invalid_mode (clock-too-high)
[509.105741] Starting subtest: clock-too-high
[509.106681] Starting dynamic subtest: pipe-A-DP-4
[509.191587] Dynamic subtest pipe-A-DP-4: SUCCESS (0.085s)
[509.204536] Starting dynamic subtest: pipe-B-DP-4
[509.206624] Dynamic subtest pipe-B-DP-4: SUCCESS (0.001s)
[509.218183] Starting dynamic subtest: pipe-C-DP-4
[509.220181] Dynamic subtest pipe-C-DP-4: SUCCESS (0.001s)
[509.231578] Starting dynamic subtest: pipe-D-DP-4
[509.233273] Dynamic subtest pipe-D-DP-4: SUCCESS (0.001s)
[509.234205] Subtest clock-too-high: SUCCESS (0.094s)
[509.393205] [064/133] (556s left) kms_psr (fbc-pr-primary-page-flip)
[509.597427] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[509.628988] [065/133] (556s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[509.815648] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[509.816629] Starting dynamic subtest: pipe-A-DP-4
[509.819157] Dynamic subtest pipe-A-DP-4: SKIP (0.000s)
[509.827995] Starting dynamic subtest: pipe-B-DP-4
[509.830659] Dynamic subtest pipe-B-DP-4: SKIP (0.000s)
[509.840097] Starting dynamic subtest: pipe-C-DP-4
[509.843816] Dynamic subtest pipe-C-DP-4: SKIP (0.000s)
[509.852964] Starting dynamic subtest: pipe-D-DP-4
[509.857094] Dynamic subtest pipe-D-DP-4: SKIP (0.000s)
[509.859584] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SKIP (0.004s)
[509.886461] [066/133] (555s left) perf (gen12-mi-rpc)
[510.039007] Starting subtest: gen12-mi-rpc
[510.040086] Starting dynamic subtest: rcs0
[510.080951] Dynamic subtest rcs0: SUCCESS (0.042s)
[510.081771] Subtest gen12-mi-rpc: SUCCESS (0.042s)
[510.100529] [067/133] (555s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[510.356399] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[511.569495] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.212s)
[511.754831] [068/133] (554s left) kms_chamelium_edid (hdmi-mode-timings)
[512.043982] Subtest hdmi-mode-timings: SKIP (0.000s)
[512.166512] [069/133] (553s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[512.366461] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[512.368143] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[512.458084] [070/133] (553s left) kms_feature_discovery (display)
[512.678540] Starting subtest: display
[512.679399] Subtest display: SUCCESS (0.000s)
[512.752321] [071/133] (553s left) kms_plane_cursor (primary)
[512.948453] Starting subtest: primary
[512.950244] Starting dynamic subtest: pipe-A-DP-4-size-64
[516.414232] Dynamic subtest pipe-A-DP-4-size-64: SUCCESS (3.465s)
[516.474271] Starting dynamic subtest: pipe-A-DP-4-size-128
[519.898063] Dynamic subtest pipe-A-DP-4-size-128: SUCCESS (3.433s)
[519.960323] Starting dynamic subtest: pipe-A-DP-4-size-256
[523.264548] Dynamic subtest pipe-A-DP-4-size-256: SUCCESS (3.315s)
[523.387410] Starting dynamic subtest: pipe-B-DP-4-size-64
[526.901982] Dynamic subtest pipe-B-DP-4-size-64: SUCCESS (3.526s)
[526.944035] Starting dynamic subtest: pipe-B-DP-4-size-128
[530.401038] Dynamic subtest pipe-B-DP-4-size-128: SUCCESS (3.466s)
[530.443273] Starting dynamic subtest: pipe-B-DP-4-size-256
[533.851276] Dynamic subtest pipe-B-DP-4-size-256: SUCCESS (3.416s)
[533.983341] Starting dynamic subtest: pipe-C-DP-4-size-64
[537.481384] Dynamic subtest pipe-C-DP-4-size-64: SUCCESS (3.513s)
[537.526819] Starting dynamic subtest: pipe-C-DP-4-size-128
[540.898229] Dynamic subtest pipe-C-DP-4-size-128: SUCCESS (3.382s)
[540.940821] Starting dynamic subtest: pipe-C-DP-4-size-256
[544.282311] Dynamic subtest pipe-C-DP-4-size-256: SUCCESS (3.350s)
[544.387496] Starting dynamic subtest: pipe-D-DP-4-size-64
[547.955770] Dynamic subtest pipe-D-DP-4-size-64: SUCCESS (3.580s)
[547.998083] Starting dynamic subtest: pipe-D-DP-4-size-128
[551.489154] Dynamic subtest pipe-D-DP-4-size-128: SUCCESS (3.500s)
[551.536400] Starting dynamic subtest: pipe-D-DP-4-size-256
[554.955514] Dynamic subtest pipe-D-DP-4-size-256: SUCCESS (3.431s)
[555.051653] Subtest primary: SUCCESS (42.103s)
[555.274753] [072/133] (510s left) vgem_basic (unload)
[555.348679] Starting subtest: unload
[584.367404] Subtest unload: SUCCESS (29.019s)
[584.466509] [073/133] (481s left) dumb_buffer (create-valid-dumb)
[584.540189] Starting subtest: create-valid-dumb
[584.541132] Subtest create-valid-dumb: SUCCESS (0.000s)
[584.669188] [074/133] (481s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[584.949536] Starting subtest: cursor-rapid-movement-64x64
[584.954094] Starting dynamic subtest: pipe-A-DP-4
[585.401688] Dynamic subtest pipe-A-DP-4: SUCCESS (0.446s)
[585.447770] Starting dynamic subtest: pipe-D-DP-4
[585.855969] Dynamic subtest pipe-D-DP-4: SUCCESS (0.415s)
[585.857085] Subtest cursor-rapid-movement-64x64: SUCCESS (0.906s)
[586.270578] [075/133] (479s left) gem_exec_flush (basic-wb-rw-default)
[586.363389] Subtest basic-wb-rw-default: SKIP (0.000s)
[586.405658] [076/133] (479s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[586.593709] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[586.606308] Starting dynamic subtest: pipe-A-DP-4
[587.476898] Dynamic subtest pipe-A-DP-4: SUCCESS (0.870s)
[587.502327] Starting dynamic subtest: pipe-B-DP-4
[588.403721] Dynamic subtest pipe-B-DP-4: SUCCESS (0.912s)
[588.429154] Starting dynamic subtest: pipe-C-DP-4
[589.313715] Dynamic subtest pipe-C-DP-4: SUCCESS (0.895s)
[589.339455] Starting dynamic subtest: pipe-D-DP-4
[590.256137] Dynamic subtest pipe-D-DP-4: SUCCESS (0.927s)
[590.257069] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (3.664s)
[590.576180] [077/133] (475s left) gem_mmap_gtt (cpuset-big-copy)
[590.646270] Subtest cpuset-big-copy: SKIP (0.000s)
[590.691574] [078/133] (475s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[590.889170] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[590.891072] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[590.972423] [079/133] (475s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[591.180645] Starting subtest: primary-y-tiled-reflect-x-0
[591.281349] Subtest primary-y-tiled-reflect-x-0: SKIP (0.100s)
[591.408748] [080/133] (474s left) kms_psr (psr-sprite-mmap-gtt)
[591.603020] Subtest psr-sprite-mmap-gtt: SKIP (0.000s)
[591.624333] [081/133] (474s left) kms_psr2_su (page_flip-p010)
[591.692134] Subtest page_flip-P010: SKIP (0.000s)
[591.746421] [082/133] (474s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[591.947543] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[591.949103] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[592.040406] [083/133] (474s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[592.253671] Starting subtest: plane-upscale-20x20-with-pixel-format
[592.266079] Starting dynamic subtest: pipe-A-DP-4
[594.747596] Dynamic subtest pipe-A-DP-4: SUCCESS (2.481s)
[594.787381] Starting dynamic subtest: pipe-B-DP-4
[597.174216] Dynamic subtest pipe-B-DP-4: SUCCESS (2.406s)
[597.206929] Starting dynamic subtest: pipe-C-DP-4
[597.550695] Dynamic subtest pipe-C-DP-4: SUCCESS (0.357s)
[597.592707] Starting dynamic subtest: pipe-D-DP-4
[597.960587] Dynamic subtest pipe-D-DP-4: SUCCESS (0.388s)
[597.961830] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.708s)
[598.287257] [084/133] (467s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[598.357747] Subtest tiled-to-untiled: SKIP (0.000s)
[598.415613] [085/133] (467s left) gem_tiled_fence_blits (basic)
[598.478737] Subtest basic: SKIP (0.000s)
[598.515554] [086/133] (467s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[598.718403] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[598.720174] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[598.791354] [087/133] (467s left) kms_chamelium_audio (hdmi-audio)
[599.096921] Subtest hdmi-audio: SKIP (0.000s)
[599.249327] [088/133] (467s left) gem_wait (wait)
[599.325858] Starting subtest: wait
[599.326876] Starting dynamic subtest: all-engines
[600.413167] Dynamic subtest all-engines: SUCCESS (1.087s)
[600.424653] Starting dynamic subtest: rcs0
[601.465517] Dynamic subtest rcs0: SUCCESS (1.050s)
[601.479560] Starting dynamic subtest: bcs0
[602.522964] Dynamic subtest bcs0: SUCCESS (1.055s)
[602.532727] Starting dynamic subtest: vcs0
[603.577542] Dynamic subtest vcs0: SUCCESS (1.053s)
[603.590498] Starting dynamic subtest: vcs1
[604.634664] Dynamic subtest vcs1: SUCCESS (1.054s)
[604.648778] Starting dynamic subtest: vecs0
[605.692484] Dynamic subtest vecs0: SUCCESS (1.054s)
[605.706385] Starting dynamic subtest: vecs1
[606.749484] Dynamic subtest vecs1: SUCCESS (1.054s)
[606.763799] Starting dynamic subtest: ccs0
[607.807462] Dynamic subtest ccs0: SUCCESS (1.055s)
[607.809422] Subtest wait: SUCCESS (8.483s)
[608.058586] [089/133] (458s left) api_intel_bb (purge-bb)
[608.112985] Starting subtest: purge-bb
[608.133089] Subtest purge-bb: SUCCESS (0.021s)
[608.256514] [090/133] (458s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[608.314921] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[608.425288] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.108s)
[608.533841] [091/133] (457s left) kms_chamelium_hpd (hdmi-hpd-fast)
[608.813949] Subtest hdmi-hpd-fast: SKIP (0.000s)
[608.934189] [092/133] (457s left) v3d/v3d_create_bo (create-bo-invalid-flags)
[609.004284] Subtest create-bo-invalid-flags: SKIP (0.000s)
[609.065221] [093/133] (457s left) kms_rotation_crc (primary-rotation-180)
[609.270140] Starting subtest: primary-rotation-180
[619.404986] Subtest primary-rotation-180: SUCCESS (10.134s)
[619.753773] [094/133] (446s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[619.828601] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[619.830372] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[620.011081] [095/133] (446s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[620.238328] Starting subtest: 2x-flip-vs-cursor-atomic
[620.241147] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.003s)
[620.313158] [096/133] (446s left) gem_render_copy (linear-to-vebox-y-tiled)
[620.381719] Starting subtest: linear-to-vebox-y-tiled
[620.383619] Subtest linear-to-vebox-y-tiled: SKIP (0.000s)
[620.602080] [097/133] (446s left) kms_properties (connector-properties-legacy)
[620.801071] Starting subtest: connector-properties-legacy
[622.477903] Subtest connector-properties-legacy: SUCCESS (1.678s)
[622.695391] [098/133] (444s left) kms_flip (basic-plain-flip)
[622.893666] Starting subtest: basic-plain-flip
[622.900620] Starting dynamic subtest: A-DP4
[623.754410] Dynamic subtest A-DP4: SUCCESS (0.854s)
[623.766589] Starting dynamic subtest: B-DP4
[624.508171] Dynamic subtest B-DP4: SUCCESS (0.752s)
[624.517815] Starting dynamic subtest: C-DP4
[625.268583] Dynamic subtest C-DP4: SUCCESS (0.759s)
[625.278245] Starting dynamic subtest: D-DP4
[626.027735] Dynamic subtest D-DP4: SUCCESS (0.759s)
[626.028711] Subtest basic-plain-flip: SUCCESS (3.135s)
[626.308590] [099/133] (440s left) kms_cursor_crc (cursor-onscreen-256x256)
[626.666775] Starting subtest: cursor-onscreen-256x256
[626.671134] Starting dynamic subtest: pipe-A-DP-4
[629.436851] Dynamic subtest pipe-A-DP-4: SUCCESS (2.764s)
[629.469020] Starting dynamic subtest: pipe-D-DP-4
[632.190145] Dynamic subtest pipe-D-DP-4: SUCCESS (2.729s)
[632.191007] Subtest cursor-onscreen-256x256: SUCCESS (5.523s)
[632.522200] [100/133] (434s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[632.741268] Starting subtest: x-tiled-32bpp-rotate-0
[634.345154] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.603s)
[634.503684] [101/133] (432s left) kms_async_flips (invalid-async-flip)
[634.701737] Starting subtest: invalid-async-flip
[634.703363] Subtest invalid-async-flip: SKIP (0.000s)
[635.067154] [102/133] (431s left) gem_softpin (evict-snoop-interruptible)
[635.176664] Starting subtest: evict-snoop-interruptible
[635.178942] Subtest evict-snoop-interruptible: SKIP (0.000s)
[635.326444] [103/133] (431s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[635.542856] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[637.944839] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (2.403s)
[638.126931] [104/133] (428s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[638.325675] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[638.327377] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[638.400709] [105/133] (428s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[638.615229] Starting subtest: 4-tiled-16bpp-rotate-270
[638.661581] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.046s)
[638.810459] [106/133] (428s left) v3d/v3d_submit_csd (single-out-sync)
[638.894095] Subtest single-out-sync: SKIP (0.000s)
[638.947250] [107/133] (428s left) gem_exec_parallel (userptr)
[639.006817] Starting subtest: userptr
[639.007715] Starting dynamic subtest: rcs0
[640.464105] Dynamic subtest rcs0: SUCCESS (1.457s)
[640.473328] Starting dynamic subtest: bcs0
[641.851149] Dynamic subtest bcs0: SUCCESS (1.386s)
[641.861948] Starting dynamic subtest: vcs0
[643.269963] Dynamic subtest vcs0: SUCCESS (1.418s)
[643.280322] Starting dynamic subtest: vcs1
[644.722048] Dynamic subtest vcs1: SUCCESS (1.451s)
[644.732540] Starting dynamic subtest: vecs0
[646.133233] Dynamic subtest vecs0: SUCCESS (1.410s)
[646.142911] Starting dynamic subtest: vecs1
[647.533045] Dynamic subtest vecs1: SUCCESS (1.399s)
[647.544143] Starting dynamic subtest: ccs0
[648.938009] Dynamic subtest ccs0: SUCCESS (1.404s)
[648.939118] Subtest userptr: SUCCESS (9.932s)
[649.201019] [108/133] (417s left) kms_flip (flip-vs-rmfb-interruptible)
[649.423600] Starting subtest: flip-vs-rmfb-interruptible
[649.431657] Starting dynamic subtest: A-DP4
[657.239046] Dynamic subtest A-DP4: SUCCESS (7.807s)
[657.276562] Starting dynamic subtest: B-DP4
[664.991935] Dynamic subtest B-DP4: SUCCESS (7.749s)
[665.031799] Starting dynamic subtest: C-DP4
[672.769039] Dynamic subtest C-DP4: SUCCESS (7.773s)
[672.800106] Starting dynamic subtest: D-DP4
[680.523386] Dynamic subtest D-DP4: SUCCESS (7.751s)
[680.528952] Subtest flip-vs-rmfb-interruptible: SUCCESS (31.103s)
[680.868050] [109/133] (386s left) gem_exec_whisper (basic-contexts-priority-all)
[680.948601] Starting subtest: basic-contexts-priority-all
[703.289271] Subtest basic-contexts-priority-all: SUCCESS (22.339s)
[703.468972] [110/133] (363s left) kms_plane_scaling (planes-downscale-factor-0-25-upscale-factor-0-25)
[703.667225] Starting subtest: planes-downscale-factor-0-25-upscale-factor-0-25
[703.679846] Starting dynamic subtest: pipe-A-DP-4
[703.693484] Dynamic subtest pipe-A-DP-4: SKIP (0.013s)
[703.715057] Starting dynamic subtest: pipe-B-DP-4
[703.734803] Dynamic subtest pipe-B-DP-4: SKIP (0.026s)
[703.755731] Starting dynamic subtest: pipe-C-DP-4
[703.775291] Dynamic subtest pipe-C-DP-4: SKIP (0.027s)
[703.796299] Starting dynamic subtest: pipe-D-DP-4
[703.815571] Dynamic subtest pipe-D-DP-4: SKIP (0.026s)
[703.817037] Subtest planes-downscale-factor-0-25-upscale-factor-0-25: SKIP (0.149s)
[703.903764] [111/133] (363s left) gem_exec_reloc (basic-write-cpu-noreloc)
[703.973717] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[704.011247] [112/133] (363s left) kms_flip (modeset-vs-vblank-race-interruptible)
[704.209903] Starting subtest: modeset-vs-vblank-race-interruptible
[704.217039] Starting dynamic subtest: A-DP4
[707.356855] Dynamic subtest A-DP4: SUCCESS (3.139s)
[707.395044] Starting dynamic subtest: B-DP4
[710.560920] Dynamic subtest B-DP4: SUCCESS (3.199s)
[710.599734] Starting dynamic subtest: C-DP4
[713.767419] Dynamic subtest C-DP4: SUCCESS (3.202s)
[713.805300] Starting dynamic subtest: D-DP4
[716.993526] Dynamic subtest D-DP4: SUCCESS (3.222s)
[716.999122] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (12.787s)
[717.334311] [113/133] (349s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[717.542332] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[717.550244] Starting dynamic subtest: pipe-A-DP-4
[717.552184] Dynamic subtest pipe-A-DP-4: SKIP (0.000s)
[717.561520] Starting dynamic subtest: pipe-B-DP-4
[717.563122] Dynamic subtest pipe-B-DP-4: SKIP (0.000s)
[717.572030] Starting dynamic subtest: pipe-C-DP-4
[717.574145] Dynamic subtest pipe-C-DP-4: SKIP (0.000s)
[717.583429] Starting dynamic subtest: pipe-D-DP-4
[717.586531] Dynamic subtest pipe-D-DP-4: SKIP (0.000s)
[717.588635] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s)
[717.603441] [114/133] (349s left) gem_exec_parallel (fds)
[717.669273] Starting subtest: fds
[717.670276] Starting dynamic subtest: rcs0
[722.543274] Dynamic subtest rcs0: SUCCESS (4.873s)
[722.552677] Starting dynamic subtest: bcs0
[727.317807] Dynamic subtest bcs0: SUCCESS (4.774s)
[727.326988] Starting dynamic subtest: vcs0
[732.174503] Dynamic subtest vcs0: SUCCESS (4.856s)
[732.184826] Starting dynamic subtest: vcs1
[736.981506] Dynamic subtest vcs1: SUCCESS (4.806s)
[736.991019] Starting dynamic subtest: vecs0
[741.600458] Dynamic subtest vecs0: SUCCESS (4.618s)
[741.609525] Starting dynamic subtest: vecs1
[746.352229] Dynamic subtest vecs1: SUCCESS (4.751s)
[746.361761] Starting dynamic subtest: ccs0
[751.170852] Dynamic subtest ccs0: SUCCESS (4.817s)
[751.172187] Subtest fds: SUCCESS (33.501s)
[751.445005] [115/133] (315s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[751.650791] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[751.652480] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[751.747019] [116/133] (315s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[751.974541] Starting subtest: yf-tiled-addfb-size-overflow
[751.976187] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[752.093603] [117/133] (315s left) syncobj_timeline (invalid-transfer-non-existent-point)
[752.179292] Starting subtest: invalid-transfer-non-existent-point
[752.180404] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[752.294503] [118/133] (315s left) i915_pm_rpm (debugfs-forcewake-user)
[754.343757] Starting subtest: debugfs-forcewake-user
[765.075183] Subtest debugfs-forcewake-user: SUCCESS (10.732s)
[765.431870] [119/133] (302s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[765.676521] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[765.678336] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[765.749740] [120/133] (301s left) kms_flip (2x-nonexisting-fb-interruptible)
[765.975683] Starting subtest: 2x-nonexisting-fb-interruptible
[765.994274] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.018s)
[766.064944] [121/133] (301s left) gem_mmap_gtt (cpuset-medium-copy-odd)
[766.130073] Subtest cpuset-medium-copy-odd: SKIP (0.000s)
[766.178352] [122/133] (301s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[766.402560] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[766.404333] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[766.511338] [123/133] (301s left) gem_exec_whisper (basic-fds-priority)
[766.607714] Starting subtest: basic-fds-priority
[789.387228] Subtest basic-fds-priority: SUCCESS (22.778s)
[789.564242] [124/133] (278s left) kms_psr (psr2-cursor-mmap-gtt)
[789.758464] Subtest psr2-cursor-mmap-gtt: SKIP (0.000s)
[789.789166] [125/133] (277s left) gem_exec_schedule (preempt-contexts)
[789.859061] Starting subtest: preempt-contexts
[789.859951] Starting dynamic subtest: rcs0
[789.939079] Dynamic subtest rcs0: SUCCESS (0.080s)
[789.948477] Starting dynamic subtest: bcs0
[789.996469] Dynamic subtest bcs0: SUCCESS (0.057s)
[790.006109] Starting dynamic subtest: vcs0
[790.053377] Dynamic subtest vcs0: SUCCESS (0.056s)
[790.062773] Starting dynamic subtest: vcs1
[790.110190] Dynamic subtest vcs1: SUCCESS (0.056s)
[790.119703] Starting dynamic subtest: vecs0
[790.167091] Dynamic subtest vecs0: SUCCESS (0.056s)
[790.176471] Starting dynamic subtest: vecs1
[790.222761] Dynamic subtest vecs1: SUCCESS (0.055s)
[790.232946] Starting dynamic subtest: ccs0
[790.279630] Dynamic subtest ccs0: SUCCESS (0.056s)
[790.280470] Subtest preempt-contexts: SUCCESS (0.421s)
[790.755059] [126/133] (276s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[790.945955] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[790.946971] Starting dynamic subtest: pipe-A-valid-mode
[791.039454] Dynamic subtest pipe-A-valid-mode: SKIP (0.091s)
[791.041170] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.093s)
[791.210135] [127/133] (276s left) gem_ctx_persistence (engines-queued)
[791.315238] Starting subtest: engines-queued
[791.316262] Starting dynamic subtest: rcs0
[791.421109] Dynamic subtest rcs0: SUCCESS (0.105s)
[791.432782] Starting dynamic subtest: bcs0
[791.447812] Dynamic subtest bcs0: SUCCESS (0.026s)
[791.459794] Starting dynamic subtest: vcs0
[791.502174] Dynamic subtest vcs0: SUCCESS (0.053s)
[791.522470] Starting dynamic subtest: vcs1
[791.564380] Dynamic subtest vcs1: SUCCESS (0.061s)
[791.586117] Starting dynamic subtest: vecs0
[791.630254] Dynamic subtest vecs0: SUCCESS (0.064s)
[791.651799] Starting dynamic subtest: vecs1
[791.687201] Dynamic subtest vecs1: SUCCESS (0.056s)
[791.708947] Starting dynamic subtest: ccs0
[791.852046] Dynamic subtest ccs0: SUCCESS (0.164s)
[791.852917] Subtest engines-queued: SUCCESS (0.537s)
[791.942649] [128/133] (275s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size)
[792.131614] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size
[792.134516] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.002s)
[792.191989] [129/133] (275s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[792.379625] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[794.956496] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (2.579s)
[795.158984] [130/133] (272s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[795.351096] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[795.352116] Starting dynamic subtest: pipe-A-DP-4
[795.353963] Dynamic subtest pipe-A-DP-4: SKIP (0.000s)
[795.363843] Starting dynamic subtest: pipe-B-DP-4
[795.365713] Dynamic subtest pipe-B-DP-4: SKIP (0.000s)
[795.374477] Starting dynamic subtest: pipe-C-DP-4
[795.376030] Dynamic subtest pipe-C-DP-4: SKIP (0.000s)
[795.385138] Starting dynamic subtest: pipe-D-DP-4
[795.387059] Dynamic subtest pipe-D-DP-4: SKIP (0.000s)
[795.389244] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SKIP (0.007s)
[795.425637] [131/133] (272s left) vgem_basic (create)
[795.473661] Starting subtest: create
[795.474798] Subtest create: SUCCESS (0.000s)
[795.534634] [132/133] (272s left) dmabuf_sync_file (import-basic)
[795.624313] Starting subtest: import-basic
[795.626996] Subtest import-basic: SUCCESS (0.002s)
[795.707165] [133/133] (272s left) gem_create (create-ext-placement-sanity-check)
[795.925297] Starting subtest: create-ext-placement-sanity-check
[795.926287] Subtest create-ext-placement-sanity-check: SUCCESS (0.003s)
[796.014762] Closing watchdogs
Done.