[59.614244] Initializing watchdogs
[59.614289]   /dev/watchdog0
[59.627568] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[59.631644] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.634331] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.637945] [001/132] (960s left) kms_flip (flip-vs-expired-vblank)
[59.754084] Starting subtest: flip-vs-expired-vblank
[59.756284] Starting dynamic subtest: A-eDP1
[68.462579] Dynamic subtest A-eDP1: SUCCESS (8.701s)
[68.474752] Starting dynamic subtest: B-eDP1
[77.360569] Dynamic subtest B-eDP1: SUCCESS (8.894s)
[77.369592] Starting dynamic subtest: C-eDP1
[85.988350] Dynamic subtest C-eDP1: SUCCESS (8.625s)
[85.997451] Starting dynamic subtest: D-eDP1
[94.617564] Dynamic subtest D-eDP1: SUCCESS (8.628s)
[94.620021] Subtest flip-vs-expired-vblank: SUCCESS (34.855s)
[96.032944] [002/132] (924s left) gem_exec_whisper (basic-contexts-forked)
[96.102734] Starting subtest: basic-contexts-forked
[119.500293] Subtest basic-contexts-forked: SUCCESS (23.391s)
[119.729090] [003/132] (900s left) kms_big_fb (4-tiled-16bpp-rotate-0)
[119.841766] Starting subtest: 4-tiled-16bpp-rotate-0
[121.044365] Subtest 4-tiled-16bpp-rotate-0: SUCCESS (1.202s)
[121.194878] [004/132] (899s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[121.305340] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[122.410021] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.104s)
[122.550556] [005/132] (897s left) syncobj_timeline (etime-multi-wait-for-submit-submitted)
[122.620190] Starting subtest: etime-multi-wait-for-submit-submitted
[122.730571] Subtest etime-multi-wait-for-submit-submitted: SUCCESS (0.108s)
[122.825632] [006/132] (897s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[122.920360] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[122.924449] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[123.050733] [007/132] (897s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[123.113706] Starting subtest: multi-wait-all-for-submit-signaled
[123.116083] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s)
[123.240505] [008/132] (897s left) core_setmaster (master-drop-set-user)
[123.340937] Starting subtest: master-drop-set-user
[123.351458] Subtest master-drop-set-user: SUCCESS (0.013s)
[123.390928] [009/132] (897s left) kms_pm_rpm (system-suspend-idle)
[125.009200] Starting subtest: system-suspend-idle
[144.224877] Subtest system-suspend-idle: SUCCESS (7.988s)
[144.621708] [010/132] (875s left) gem_exec_schedule (pi-ringfull)
[144.826887] Starting subtest: pi-ringfull
[144.829028] Starting dynamic subtest: rcs0
[144.919372] Dynamic subtest rcs0: SUCCESS (0.095s)
[144.933744] Starting dynamic subtest: bcs0
[144.946880] Dynamic subtest bcs0: SUCCESS (0.027s)
[144.959969] Starting dynamic subtest: vcs0
[144.975246] Dynamic subtest vcs0: SUCCESS (0.028s)
[144.987284] Starting dynamic subtest: vcs1
[145.003471] Dynamic subtest vcs1: SUCCESS (0.028s)
[145.015266] Starting dynamic subtest: vecs0
[145.032572] Dynamic subtest vecs0: SUCCESS (0.028s)
[145.045375] Starting dynamic subtest: ccs0
[145.059202] Dynamic subtest ccs0: SUCCESS (0.026s)
[145.061522] Subtest pi-ringfull: SUCCESS (0.234s)
[145.308888] [FACT gem_exec_schedule (pi-ringfull)] new: kernel.kmod_is_loaded.vgem: true
[145.312099] [011/132] (875s left) kms_flip (bo-too-big-interruptible)
[145.412503] Starting subtest: bo-too-big-interruptible
[145.414930] Starting dynamic subtest: A-eDP1
[146.758191] Dynamic subtest A-eDP1: SUCCESS (1.333s)
[146.769269] Starting dynamic subtest: B-eDP1
[147.974176] Dynamic subtest B-eDP1: SUCCESS (1.207s)
[147.984534] Starting dynamic subtest: C-eDP1
[149.223279] Dynamic subtest C-eDP1: SUCCESS (1.241s)
[149.234449] Starting dynamic subtest: D-eDP1
[150.465664] Dynamic subtest D-eDP1: SUCCESS (1.235s)
[150.470658] Subtest bo-too-big-interruptible: SUCCESS (5.023s)
[151.698257] [012/132] (868s left) gem_pread (exhaustion)
[151.759012] Subtest exhaustion: SKIP (0.000s)
[151.825748] [013/132] (868s left) kms_plane_scaling (2x-scaler-multi-pipe)
[151.921821] Starting subtest: 2x-scaler-multi-pipe
[151.926220] Subtest 2x-scaler-multi-pipe: SKIP (0.001s)
[152.048415] [014/132] (868s left) api_intel_bb (blit-reloc-purge-cache)
[152.116375] Starting subtest: blit-reloc-purge-cache
[152.120977] Subtest blit-reloc-purge-cache: SKIP (0.001s)
[152.282070] [015/132] (868s left) syncobj_timeline (single-wait-all-available-submitted)
[152.337963] Starting subtest: single-wait-all-available-submitted
[152.340264] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[152.473918] [016/132] (868s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[157.467631] Starting subtest: psr2-cursor-plane-move-continuous-sf
[157.470024] Starting dynamic subtest: pipe-A-eDP-1
[168.572804] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.088s)
[168.582991] Starting dynamic subtest: pipe-B-eDP-1
[179.680408] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.106s)
[179.682748] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (22.198s)
[180.510729] [017/132] (840s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[180.636710] Starting subtest: 2x-long-flip-vs-cursor-atomic
[180.641293] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s)
[180.807432] [018/132] (840s left) kms_flip (2x-plain-flip-ts-check-interruptible)
[180.910848] Starting subtest: 2x-plain-flip-ts-check-interruptible
[180.922655] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.010s)
[181.070873] [019/132] (839s left) gem_exec_nop (basic-sequential)
[181.158675] Starting subtest: basic-sequential
[197.182893] Subtest basic-sequential: SUCCESS (16.036s)
[197.451480] [020/132] (823s left) gem_fence_thrash (bo-write-verify-threaded-none)
[197.480711] Starting subtest: bo-write-verify-threaded-none
[197.504275] Subtest bo-write-verify-threaded-none: SKIP (0.023s)
[197.569687] [021/132] (823s left) prime_mmap_kms (buffer-sharing)
[197.665523] Starting subtest: buffer-sharing
[198.106203] Subtest buffer-sharing: SUCCESS (0.440s)
[198.927699] [022/132] (822s left) gem_userptr_blits (stress-mm)
[199.012037] Starting subtest: stress-mm
[204.379187] Subtest stress-mm: SUCCESS (5.369s)
[204.546432] [023/132] (816s left) kms_pm_backlight (fade)
[204.646758] Starting subtest: fade
[204.699632] Starting dynamic subtest: eDP-1
[207.373052] Dynamic subtest eDP-1: SUCCESS (2.673s)
[207.375451] Subtest fade: SUCCESS (2.725s)
[208.261640] [024/132] (812s left) gem_exec_params (rs-invalid)
[208.335572] Starting subtest: rs-invalid
[208.338010] Subtest rs-invalid: SUCCESS (0.003s)
[208.511504] [025/132] (812s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[208.619720] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[208.624051] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[208.751302] [026/132] (812s left) gem_fence_thrash (bo-write-verify-none)
[208.786651] Starting subtest: bo-write-verify-none
[208.812421] Subtest bo-write-verify-none: SKIP (0.023s)
[208.884208] [027/132] (812s left) gem_workarounds (suspend-resume-context)
[208.960128] Starting subtest: suspend-resume-context
[224.993181] Subtest suspend-resume-context: SUCCESS (1.202s)
[226.167427] [028/132] (796s left) syncobj_wait (wait-all-delayed-signal)
[226.232908] Starting subtest: wait-all-delayed-signal
[226.335773] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[226.434955] [029/132] (795s left) gem_softpin (evict-active-interruptible)
[226.507337] Starting subtest: evict-active-interruptible
[226.514812] Subtest evict-active-interruptible: SUCCESS (0.008s)
[226.680606] [030/132] (795s left) i915_query (query-regions-garbage-items)
[226.740511] Starting subtest: query-regions-garbage-items
[226.743131] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[226.851360] [031/132] (795s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[226.943096] Starting subtest: compare-crc-sanitycheck-xr24
[226.946054] Starting dynamic subtest: pipe-A-eDP-1
[227.596872] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.641s)
[227.607021] Starting dynamic subtest: pipe-B-eDP-1
[228.810779] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.207s)
[228.821513] Starting dynamic subtest: pipe-C-eDP-1
[230.038198] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.213s)
[230.048199] Starting dynamic subtest: pipe-D-eDP-1
[231.244271] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.196s)
[231.247014] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.261s)
[232.136046] [032/132] (790s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[232.239985] Starting subtest: fbc-psr2-primary-mmap-gtt
[232.242416] Starting dynamic subtest: eDP-1
[232.247324] Dynamic subtest eDP-1: SKIP (0.000s)
[232.252324] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s)
[232.341383] [033/132] (790s left) gem_ctx_exec (basic-nohangcheck)
[232.399478] Starting subtest: basic-nohangcheck
[232.671733] Subtest basic-nohangcheck: SUCCESS (0.272s)
[232.827166] [034/132] (789s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[232.894218] Starting subtest: x-tiled-to-vebox-yf-tiled
[232.900338] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[233.100159] [035/132] (789s left) i915_drm_fdinfo (virtual-busy)
[233.141255] Starting subtest: virtual-busy
[233.146511] Subtest virtual-busy: SKIP (0.000s)
[233.236908] [036/132] (789s left) prime_vgem (busy)
[233.310877] Starting subtest: busy
[233.313228] Starting dynamic subtest: rcs0
[233.369596] Dynamic subtest rcs0: SUCCESS (0.059s)
[233.378304] Starting dynamic subtest: bcs0
[233.453218] Dynamic subtest bcs0: SUCCESS (0.083s)
[233.462272] Starting dynamic subtest: vcs0
[233.501850] Dynamic subtest vcs0: SUCCESS (0.048s)
[233.511119] Starting dynamic subtest: vcs1
[233.548069] Dynamic subtest vcs1: SUCCESS (0.045s)
[233.557375] Starting dynamic subtest: vecs0
[233.594103] Dynamic subtest vecs0: SUCCESS (0.046s)
[233.602652] Starting dynamic subtest: ccs0
[233.640753] Dynamic subtest ccs0: SUCCESS (0.046s)
[233.642755] Subtest busy: SUCCESS (0.330s)
[233.798687] [037/132] (788s left) kms_big_fb (linear-16bpp-rotate-180)
[233.909051] Starting subtest: linear-16bpp-rotate-180
[235.262348] Subtest linear-16bpp-rotate-180: SUCCESS (1.345s)
[235.419107] [038/132] (787s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling)
[235.514375] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling
[235.516785] Starting dynamic subtest: pipe-A-default-mode
[235.809349] Dynamic subtest pipe-A-default-mode: SKIP (0.288s)
[235.815323] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.289s)
[236.687423] [039/132] (786s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[236.785317] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[236.787697] Starting dynamic subtest: pipe-A-eDP-1
[236.935313] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.139s)
[236.946469] Starting dynamic subtest: pipe-B-eDP-1
[236.969467] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[236.977932] Starting dynamic subtest: pipe-C-eDP-1
[236.999942] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[237.008271] Starting dynamic subtest: pipe-D-eDP-1
[237.031950] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s)
[237.034187] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.173s)
[239.257695] [040/132] (783s left) gem_softpin (evict-prime)
[239.323130] Starting subtest: evict-prime
[239.325845] Starting dynamic subtest: rcs0
[240.512912] Dynamic subtest rcs0: SUCCESS (1.186s)
[240.525058] Starting dynamic subtest: bcs0
[241.668486] Dynamic subtest bcs0: SUCCESS (1.150s)
[241.680512] Starting dynamic subtest: vcs0
[242.906472] Dynamic subtest vcs0: SUCCESS (1.233s)
[242.918470] Starting dynamic subtest: vcs1
[244.959194] Dynamic subtest vcs1: SUCCESS (2.048s)
[244.970290] Starting dynamic subtest: vecs0
[246.934105] Dynamic subtest vecs0: SUCCESS (1.970s)
[246.946018] Starting dynamic subtest: ccs0
[248.088902] Dynamic subtest ccs0: SUCCESS (1.153s)
[248.101523] Starting dynamic subtest: all
[249.961805] Dynamic subtest all: SUCCESS (1.868s)
[249.964768] Subtest evict-prime: SUCCESS (10.619s)
[250.066059] [041/132] (772s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[250.170293] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[256.713420] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.541s)
[256.886925] [042/132] (765s left) kms_plane_alpha_blend (alpha-opaque-fb)
[256.980468] Starting subtest: alpha-opaque-fb
[257.263579] Starting dynamic subtest: pipe-A-eDP-1
[257.931270] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.665s)
[257.942302] Starting dynamic subtest: pipe-D-eDP-1
[259.331225] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.401s)
[259.334132] Subtest alpha-opaque-fb: SUCCESS (2.352s)
[260.150786] [043/132] (762s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[260.244527] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[260.249376] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[260.371372] [044/132] (762s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[260.464187] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[260.466777] Starting dynamic subtest: pipe-A-eDP-1
[260.496061] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[260.511623] Starting dynamic subtest: pipe-B-eDP-1
[260.540359] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[260.555271] Starting dynamic subtest: pipe-C-eDP-1
[260.586240] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[260.596049] Starting dynamic subtest: pipe-D-eDP-1
[260.626609] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[260.631472] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[262.724758] [045/132] (760s left) perf_pmu (busy-accuracy-2)
[262.767030] Starting subtest: busy-accuracy-2
[262.769868] Starting dynamic subtest: rcs0
[265.811472] Dynamic subtest rcs0: SUCCESS (3.046s)
[265.827637] Starting dynamic subtest: bcs0
[268.873987] Dynamic subtest bcs0: SUCCESS (3.061s)
[268.884807] Starting dynamic subtest: vcs0
[271.918236] Dynamic subtest vcs0: SUCCESS (3.042s)
[271.929511] Starting dynamic subtest: vcs1
[274.965047] Dynamic subtest vcs1: SUCCESS (3.045s)
[274.976480] Starting dynamic subtest: vecs0
[278.012299] Dynamic subtest vecs0: SUCCESS (3.046s)
[278.021990] Starting dynamic subtest: ccs0
[281.073160] Dynamic subtest ccs0: SUCCESS (3.058s)
[281.076002] Subtest busy-accuracy-2: SUCCESS (18.311s)
[281.236908] [046/132] (741s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[281.295984] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[281.298497] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[281.425787] [047/132] (741s left) kms_content_protection (srm)
[281.568827] Starting subtest: srm
[281.574356] Subtest srm: SKIP (0.003s)
[281.738397] [048/132] (741s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[281.829353] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[281.832249] Starting dynamic subtest: pipe-A-eDP-1
[281.858120] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[281.872478] Starting dynamic subtest: pipe-B-eDP-1
[281.898371] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[281.906514] Starting dynamic subtest: pipe-C-eDP-1
[281.930972] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[281.939276] Starting dynamic subtest: pipe-D-eDP-1
[281.965742] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[281.971231] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[284.011501] [049/132] (739s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[284.109162] Starting subtest: psr-rgb565-draw-mmap-gtt
[284.114156] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[284.251764] [050/132] (738s left) kms_cursor_crc (cursor-onscreen-32x10)
[284.418798] Starting subtest: cursor-onscreen-32x10
[284.494916] Subtest cursor-onscreen-32x10: SKIP (0.072s)
[284.808427] [051/132] (738s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[284.898919] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[291.880794] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.984s)
[292.042700] [052/132] (731s left) gem_ctx_bad_destroy (double-destroy)
[292.105976] Starting subtest: double-destroy
[292.108817] Subtest double-destroy: SUCCESS (0.000s)
[292.203798] [053/132] (731s left) gem_lmem_swapping (basic)
[292.250096] Subtest basic: SKIP (0.000s)
[292.291672] [054/132] (731s left) gen9_exec_parse (bb-start-cmd)
[292.361427] Subtest bb-start-cmd: SKIP (0.000s)
[292.453622] [055/132] (730s left) sw_sync (sync_multi_timeline_wait)
[292.485656] Starting subtest: sync_multi_timeline_wait
[292.488298] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[292.565771] [056/132] (730s left) i915_pm_rc6_residency (rc6-accuracy)
[292.621123] Starting subtest: rc6-accuracy
[292.623878] Starting dynamic subtest: gt0
[295.792107] Dynamic subtest gt0: SUCCESS (3.169s)
[295.804381] Starting dynamic subtest: gt1
[298.962719] Dynamic subtest gt1: SUCCESS (3.169s)
[298.965777] Subtest rc6-accuracy: SUCCESS (6.344s)
[299.064222] [057/132] (724s left) api_intel_bb (simple-bb-ctx)
[299.132730] Starting subtest: simple-bb-ctx
[299.148194] Subtest simple-bb-ctx: SUCCESS (0.018s)
[299.268345] [058/132] (724s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[299.378799] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[299.383250] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[299.508779] [059/132] (724s left) kms_vblank (crtc-id)
[299.596243] Starting subtest: crtc-id
[299.598402] Starting dynamic subtest: pipe-A-eDP-1
[300.035526] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.438s)
[300.051465] Starting dynamic subtest: pipe-D-eDP-1
[301.126274] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.090s)
[301.129053] Subtest crtc-id: SUCCESS (1.531s)
[301.993333] [060/132] (721s left) gem_basic (bad-close)
[302.049496] Starting subtest: bad-close
[302.055222] Subtest bad-close: SUCCESS (0.000s)
[302.185693] [061/132] (721s left) kms_flip (dpms-vs-vblank-race-interruptible)
[302.281150] Starting subtest: dpms-vs-vblank-race-interruptible
[302.283500] Starting dynamic subtest: A-eDP1
[307.271737] Dynamic subtest A-eDP1: SUCCESS (4.990s)
[307.282353] Starting dynamic subtest: B-eDP1
[311.880977] Dynamic subtest B-eDP1: SUCCESS (4.605s)
[311.890803] Starting dynamic subtest: C-eDP1
[316.485657] Dynamic subtest C-eDP1: SUCCESS (4.605s)
[316.494855] Starting dynamic subtest: D-eDP1
[321.046736] Dynamic subtest D-eDP1: SUCCESS (4.557s)
[321.049082] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (18.765s)
[321.937526] [062/132] (701s left) kms_vblank (wait-forked-busy)
[322.039368] Starting subtest: wait-forked-busy
[322.041750] Starting dynamic subtest: pipe-A-eDP-1
[323.912906] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.874s)
[323.936430] Starting dynamic subtest: pipe-D-eDP-1
[326.489359] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.573s)
[326.492144] Subtest wait-forked-busy: SUCCESS (4.452s)
[327.305982] [063/132] (696s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[327.407330] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[327.412330] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[327.514423] [064/132] (696s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[327.625240] Starting subtest: 4-tiled-64bpp-rotate-180
[329.183242] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.556s)
[329.362848] [065/132] (694s left) kms_flip (absolute-wf_vblank-interruptible)
[329.458497] Starting subtest: absolute-wf_vblank-interruptible
[329.461004] Starting dynamic subtest: A-eDP1
[338.146311] Dynamic subtest A-eDP1: SUCCESS (8.686s)
[338.156061] Starting dynamic subtest: B-eDP1
[346.877248] Dynamic subtest B-eDP1: SUCCESS (8.728s)
[346.892200] Starting dynamic subtest: C-eDP1
[355.599397] Dynamic subtest C-eDP1: SUCCESS (8.717s)
[355.609764] Starting dynamic subtest: D-eDP1
[364.325647] Dynamic subtest D-eDP1: SUCCESS (8.722s)
[364.328504] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.863s)
[365.557411] [066/132] (658s left) gem_exec_flush (basic-uc-prw-default)
[365.627432] Starting subtest: basic-uc-prw-default
[371.087511] Subtest basic-uc-prw-default: SUCCESS (5.459s)
[371.302649] [067/132] (652s left) vgem_basic (busy-fence)
[371.353500] Starting subtest: busy-fence
[371.356293] Subtest busy-fence: SUCCESS (0.000s)
[371.432815] [068/132] (652s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[371.539908] Starting subtest: psr-rgb565-draw-render
[378.682123] Subtest psr-rgb565-draw-render: SUCCESS (7.141s)
[378.832771] [069/132] (645s left) kms_dp_link_training (uhbr-sst)
[378.924303] Starting subtest: uhbr-sst
[378.934902] Subtest uhbr-sst: SKIP (0.000s)
[379.022567] [070/132] (645s left) kms_universal_plane (disable-primary-vs-flip)
[379.124482] Starting subtest: disable-primary-vs-flip
[379.127139] Starting dynamic subtest: pipe-A-eDP-1
[380.619789] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.494s)
[380.629306] Starting dynamic subtest: pipe-B-eDP-1
[382.785643] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.164s)
[382.794534] Starting dynamic subtest: pipe-C-eDP-1
[384.967501] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.181s)
[384.977130] Starting dynamic subtest: pipe-D-eDP-1
[387.141478] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.171s)
[387.144371] Subtest disable-primary-vs-flip: SUCCESS (8.016s)
[387.975758] [071/132] (636s left) gem_exec_balancer (invalid-balancer)
[388.036044] Starting subtest: invalid-balancer
[388.880912] Subtest invalid-balancer: SUCCESS (0.843s)
[389.205713] [072/132] (634s left) gem_mmap_offset (bad-extensions)
[389.279502] Starting subtest: bad-extensions
[389.282467] Subtest bad-extensions: SUCCESS (0.000s)
[389.399174] [073/132] (634s left) kms_atomic_transition (plane-all-transition)
[389.507141] Starting subtest: plane-all-transition
[389.509749] Starting dynamic subtest: pipe-A-eDP-1
[391.999926] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.494s)
[392.310794] Starting dynamic subtest: pipe-B-eDP-1
[395.574922] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.272s)
[395.872096] Subtest plane-all-transition: SUCCESS (6.365s)
[396.725362] [074/132] (627s left) kms_rotation_crc (multiplane-rotation)
[396.830734] Starting subtest: multiplane-rotation
[414.375326] Subtest multiplane-rotation: SUCCESS (17.541s)
[414.522651] [075/132] (609s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[414.632015] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[414.636207] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[414.766645] [076/132] (609s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[419.781768] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[419.784373] Starting dynamic subtest: pipe-A-eDP-1
[420.581121] Dynamic subtest pipe-A-eDP-1: SKIP (0.795s)
[420.590675] Starting dynamic subtest: pipe-B-eDP-1
[421.709333] Dynamic subtest pipe-B-eDP-1: SKIP (1.126s)
[421.714389] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.926s)
[422.913947] [077/132] (601s left) kms_psr (pr-sprite-blt)
[423.011491] Starting subtest: pr-sprite-blt
[423.015820] Subtest pr-sprite-blt: SKIP (0.000s)
[423.105696] [078/132] (601s left) kms_psr (pr-cursor-render)
[423.201008] Starting subtest: pr-cursor-render
[423.205773] Subtest pr-cursor-render: SKIP (0.000s)
[423.339997] [079/132] (601s left) syncobj_wait (single-wait-all-signaled)
[423.402295] Starting subtest: single-wait-all-signaled
[423.405004] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[423.538147] [080/132] (600s left) kms_chamelium_hpd (dp-hpd-storm)
[423.924253] Subtest dp-hpd-storm: SKIP (0.000s)
[424.698961] [081/132] (599s left) gem_mmap_gtt (basic-write-gtt)
[424.761226] Subtest basic-write-gtt: SKIP (0.000s)
[424.830856] [082/132] (599s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[424.931264] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[424.934062] Starting dynamic subtest: pipe-A
[425.291962] Dynamic subtest pipe-A: SUCCESS (0.363s)
[425.301247] Starting dynamic subtest: pipe-B
[426.740003] Dynamic subtest pipe-B: SUCCESS (1.446s)
[426.755305] Starting dynamic subtest: pipe-C
[428.176751] Dynamic subtest pipe-C: SUCCESS (1.435s)
[428.187848] Starting dynamic subtest: pipe-D
[429.641911] Dynamic subtest pipe-D: SUCCESS (1.464s)
[429.644380] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.715s)
[430.845393] [083/132] (593s left) gem_exec_schedule (thriceslice)
[430.925508] Starting subtest: thriceslice
[430.928313] Starting dynamic subtest: rcs0
[430.942015] Dynamic subtest rcs0: SUCCESS (0.030s)
[430.952733] Starting dynamic subtest: bcs0
[430.973507] Dynamic subtest bcs0: SUCCESS (0.030s)
[430.982739] Starting dynamic subtest: vcs0
[431.024491] Dynamic subtest vcs0: SUCCESS (0.050s)
[431.035406] Starting dynamic subtest: vcs1
[431.056249] Dynamic subtest vcs1: SUCCESS (0.029s)
[431.065276] Starting dynamic subtest: vecs0
[431.084547] Dynamic subtest vecs0: SUCCESS (0.027s)
[431.093837] Starting dynamic subtest: ccs0
[431.115101] Dynamic subtest ccs0: SUCCESS (0.029s)
[431.117624] Subtest thriceslice: SUCCESS (0.204s)
[433.023963] [084/132] (591s left) gem_exec_fence (nb-await)
[433.213391] Starting subtest: nb-await
[433.215852] Starting dynamic subtest: rcs0
[433.280734] Dynamic subtest rcs0: SUCCESS (0.070s)
[433.292729] Starting dynamic subtest: bcs0
[433.339263] Dynamic subtest bcs0: SUCCESS (0.058s)
[433.350571] Starting dynamic subtest: vcs0
[433.401837] Dynamic subtest vcs0: SUCCESS (0.061s)
[433.413537] Starting dynamic subtest: vcs1
[433.462775] Dynamic subtest vcs1: SUCCESS (0.059s)
[433.474477] Starting dynamic subtest: vecs0
[433.522315] Dynamic subtest vecs0: SUCCESS (0.058s)
[433.534672] Starting dynamic subtest: ccs0
[433.583001] Dynamic subtest ccs0: SUCCESS (0.059s)
[433.585750] Subtest nb-await: SUCCESS (0.374s)
[435.071696] [085/132] (589s left) gem_userptr_blits (set-cache-level)
[435.133504] Starting subtest: set-cache-level
[435.138136] Subtest set-cache-level: SKIP (0.000s)
[435.291739] [086/132] (589s left) gem_ctx_persistence (hang)
[435.365263] Starting subtest: hang
[435.370512] Subtest hang: SKIP (0.000s)
[435.501856] [087/132] (589s left) kms_psr (psr-cursor-mmap-gtt)
[435.601230] Starting subtest: psr-cursor-mmap-gtt
[435.603717] Starting dynamic subtest: eDP-1
[437.310379] Dynamic subtest eDP-1: SUCCESS (1.709s)
[437.313296] Subtest psr-cursor-mmap-gtt: SUCCESS (1.710s)
[438.197029] [088/132] (586s left) gem_eio (in-flight-contexts-immediate)
[438.420547] Starting subtest: in-flight-contexts-immediate
[451.997735] Subtest in-flight-contexts-immediate: SUCCESS (13.577s)
[452.197718] [089/132] (572s left) kms_async_flips (basic-modeset-with-all-modifiers-formats)
[452.300833] Starting subtest: basic-modeset-with-all-modifiers-formats
[452.662505] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888
[453.445031] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.785s)
[453.454425] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010
[453.466803] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.021s)
[453.475847] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F
[453.489397] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.022s)
[453.498400] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565
[453.644782] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.155s)
[453.653985] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888
[453.667391] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.021s)
[453.676396] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010
[453.688918] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.022s)
[453.697985] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F
[453.711475] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.022s)
[453.720597] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV
[453.733648] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.021s)
[453.742422] Starting dynamic subtest: pipe-A-eDP-1-4-Y210
[453.756014] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.021s)
[453.764945] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888
[453.778306] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.021s)
[453.791486] Starting dynamic subtest: pipe-A-eDP-1-4-XV30
[453.801003] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.022s)
[453.812328] Starting dynamic subtest: pipe-A-eDP-1-4-XV36
[453.822717] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.022s)
[453.832675] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565
[453.978465] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.155s)
[453.994735] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888
[454.000623] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.021s)
[454.009689] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010
[454.022463] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.021s)
[454.031512] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F
[454.045432] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.022s)
[454.054375] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV
[454.067181] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.020s)
[454.076386] Starting dynamic subtest: pipe-A-eDP-1-x-Y210
[454.089520] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.022s)
[454.099049] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888
[454.112022] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.022s)
[454.122364] Starting dynamic subtest: pipe-A-eDP-1-x-XV30
[454.134003] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.021s)
[454.143629] Starting dynamic subtest: pipe-A-eDP-1-x-XV36
[454.156240] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.022s)
[454.165335] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565
[454.323140] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.167s)
[454.332325] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888
[454.345209] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.021s)
[454.354528] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010
[454.367426] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.022s)
[454.376114] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F
[454.389646] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.021s)
[454.398310] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV
[454.411753] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.022s)
[454.420307] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210
[454.434023] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.021s)
[454.442763] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888
[454.456096] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.022s)
[454.464934] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30
[454.478154] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.022s)
[454.487126] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36
[454.500740] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.022s)
[454.885623] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.587s)
[455.745942] [090/132] (569s left) kms_color (ctm-max)
[455.842143] Starting subtest: ctm-max
[455.844242] Starting dynamic subtest: pipe-A-eDP-1
[456.529911] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.690s)
[456.539100] Starting dynamic subtest: pipe-B-eDP-1
[457.939212] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.406s)
[457.948979] Starting dynamic subtest: pipe-C-eDP-1
[459.306844] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.367s)
[459.316003] Starting dynamic subtest: pipe-D-eDP-1
[460.632018] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.327s)
[460.634755] Subtest ctm-max: SUCCESS (4.792s)
[461.458636] [091/132] (563s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[461.567321] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[465.784675] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.221s)
[466.956928] [092/132] (558s left) gem_render_copy (linear)
[467.021354] Starting subtest: linear
[467.024326] Starting dynamic subtest: smem
[467.060424] Dynamic subtest smem: SUCCESS (0.039s)
[467.063480] Subtest linear: SUCCESS (0.040s)
[467.320082] [093/132] (557s left) gem_userptr_blits (access-control)
[467.391085] Starting subtest: access-control
[467.396382] Subtest access-control: SKIP (0.000s)
[467.546964] [094/132] (557s left) kms_flip (2x-nonexisting-fb)
[467.658750] Starting subtest: 2x-nonexisting-fb
[467.681846] Subtest 2x-nonexisting-fb: SKIP (0.021s)
[467.788323] [095/132] (557s left) gem_ccs (block-copy-compressed)
[467.859299] Starting subtest: block-copy-compressed
[467.864398] Subtest block-copy-compressed: SKIP (0.000s)
[468.004988] [096/132] (557s left) prime_mmap (test_invalid_sync_flags)
[468.064965] Starting subtest: test_invalid_sync_flags
[468.067468] Starting dynamic subtest: test_invalid_sync_flags-smem
[468.070551] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[468.073384] Subtest test_invalid_sync_flags: SUCCESS (0.002s)
[468.189835] [097/132] (557s left) gem_exec_params (invalid-bsd-ring)
[468.258110] Starting subtest: invalid-bsd-ring
[468.260779] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[468.405223] [098/132] (556s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[468.499983] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[475.312128] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.821s)
[475.504308] [099/132] (549s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[475.608190] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[475.612476] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[475.741495] [100/132] (549s left) kms_plane (planar-pixel-format-settings)
[475.842196] Starting subtest: planar-pixel-format-settings
[475.880258] Subtest planar-pixel-format-settings: SUCCESS (0.039s)
[475.992996] [101/132] (549s left) syncobj_timeline (wait-for-submit-delayed-submit)
[476.050290] Starting subtest: wait-for-submit-delayed-submit
[476.150614] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[476.270578] [102/132] (549s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[476.587695] Starting subtest: cursor-rapid-movement-max-size
[476.594525] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[476.757795] [103/132] (548s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[476.896042] Starting subtest: modeset-atomic-cursor-hotspot
[476.900316] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[477.067103] [104/132] (548s left) gem_exec_balancer (parallel-keep-submit-fence)
[477.328709] Starting subtest: parallel-keep-submit-fence
[478.695741] Subtest parallel-keep-submit-fence: SUCCESS (1.366s)
[478.833836] [105/132] (546s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[479.233474] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[480.081730] [106/132] (545s left) kms_getfb (getfb-addfb-different-handles)
[480.183287] Starting subtest: getfb-addfb-different-handles
[480.186123] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[480.314637] [107/132] (545s left) gem_ctx_sseu (invalid-args)
[480.378254] Subtest invalid-args: SKIP (0.000s)
[480.443103] [108/132] (545s left) gem_lmem_swapping (parallel-random-verify)
[480.489122] Subtest parallel-random-verify: SKIP (0.000s)
[480.534624] [109/132] (545s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[480.627424] Starting subtest: psr-2p-primscrn-spr-indfb-move
[480.633327] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[480.751239] [110/132] (545s left) gem_exec_reloc (basic-write-cpu-noreloc)
[480.821484] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[480.896711] [111/132] (544s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[480.951871] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[480.954361] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[481.081859] [112/132] (544s left) i915_hangman (gt-engine-hang)
[481.139301] Starting subtest: gt-engine-hang
[481.141746] Starting dynamic subtest: rcs0
[482.911850] Dynamic subtest rcs0: SUCCESS (1.772s)
[482.925302] Starting dynamic subtest: bcs0
[484.895055] Dynamic subtest bcs0: SUCCESS (1.980s)
[484.908176] Starting dynamic subtest: vcs0
[486.879011] Dynamic subtest vcs0: SUCCESS (1.981s)
[486.891305] Starting dynamic subtest: vcs1
[488.926793] Dynamic subtest vcs1: SUCCESS (2.045s)
[488.939348] Starting dynamic subtest: vecs0
[490.910519] Dynamic subtest vecs0: SUCCESS (1.981s)
[490.922466] Starting dynamic subtest: ccs0
[492.893781] Dynamic subtest ccs0: SUCCESS (1.980s)
[492.896774] Subtest gt-engine-hang: SUCCESS (11.755s)
[493.066903] [113/132] (532s left) gem_mmap (bad-object)
[493.133364] Subtest bad-object: SKIP (0.000s)
[493.200928] [114/132] (532s left) kms_feature_discovery (psr1)
[493.306825] Starting subtest: psr1
[493.309341] Subtest psr1: SUCCESS (0.000s)
[493.404998] [115/132] (532s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[493.505097] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[500.384081] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.880s)
[500.547753] [116/132] (525s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[500.651768] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[500.656368] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[500.782211] [117/132] (525s left) gem_mmap_gtt (fault-concurrent)
[500.842328] Subtest fault-concurrent: SKIP (0.000s)
[500.912772] [118/132] (525s left) kms_pm_rpm (legacy-planes-dpms)
[503.041327] Starting subtest: legacy-planes-dpms
[503.044231] Starting dynamic subtest: plane-63
[511.610867] Dynamic subtest plane-63: SUCCESS (8.571s)
[511.622478] Starting dynamic subtest: plane-93
[520.328112] Dynamic subtest plane-93: SUCCESS (8.714s)
[520.340627] Starting dynamic subtest: plane-123
[528.948206] Dynamic subtest plane-123: SUCCESS (8.616s)
[528.963736] Starting dynamic subtest: plane-133
[537.275777] Dynamic subtest plane-133: SUCCESS (8.321s)
[537.278645] Subtest legacy-planes-dpms: SUCCESS (34.234s)
[537.659807] [119/132] (488s left) kms_chamelium_color (ctm-negative)
[537.762382] Subtest ctm-negative: SKIP (0.000s)
[537.816576] [120/132] (488s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[537.918860] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[537.921154] Starting dynamic subtest: pipe-A-default-mode
[538.212476] Dynamic subtest pipe-A-default-mode: SKIP (0.290s)
[538.218117] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.291s)
[539.082839] [121/132] (487s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[539.192125] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[540.281523] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.089s)
[540.423304] [122/132] (485s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs-cc)
[540.525295] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs-cc
[540.527494] Starting dynamic subtest: pipe-A-eDP-1
[540.535424] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[540.544183] Starting dynamic subtest: pipe-B-eDP-1
[540.552161] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[540.560834] Starting dynamic subtest: pipe-C-eDP-1
[540.569810] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[540.578340] Starting dynamic subtest: pipe-D-eDP-1
[540.587146] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[540.591534] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[542.764264] [123/132] (483s left) kms_invalid_mode (overflow-vrefresh)
[542.860767] Starting subtest: overflow-vrefresh
[542.863006] Starting dynamic subtest: pipe-A-eDP-1
[543.142465] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[543.153527] Starting dynamic subtest: pipe-B-eDP-1
[543.156318] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[543.165462] Starting dynamic subtest: pipe-C-eDP-1
[543.167994] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[543.177131] Starting dynamic subtest: pipe-D-eDP-1
[543.179472] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[543.182146] Subtest overflow-vrefresh: SUCCESS (0.290s)
[543.990618] [124/132] (482s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[544.106119] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[544.110643] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[544.239972] [125/132] (482s left) kms_psr (fbc-pr-cursor-plane-move)
[544.332487] Starting subtest: fbc-pr-cursor-plane-move
[544.337767] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s)
[544.430736] [126/132] (482s left) prime_busy (before)
[544.488096] Starting subtest: before
[544.493214] Starting dynamic subtest: rcs0
[544.540929] Dynamic subtest rcs0: SUCCESS (0.048s)
[544.551128] Starting dynamic subtest: bcs0
[544.622329] Dynamic subtest bcs0: SUCCESS (0.080s)
[544.639487] Starting dynamic subtest: vcs0
[544.664783] Dynamic subtest vcs0: SUCCESS (0.040s)
[544.676182] Starting dynamic subtest: vcs1
[544.706368] Dynamic subtest vcs1: SUCCESS (0.040s)
[544.716160] Starting dynamic subtest: vecs0
[544.748910] Dynamic subtest vecs0: SUCCESS (0.042s)
[544.759232] Starting dynamic subtest: ccs0
[544.791302] Dynamic subtest ccs0: SUCCESS (0.042s)
[544.900562] Subtest before: SUCCESS (0.411s)
[544.999283] [127/132] (481s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[545.106238] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[545.111348] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[545.212722] [128/132] (481s left) kms_hdr (invalid-metadata-sizes)
[545.307990] Starting subtest: invalid-metadata-sizes
[545.316017] Subtest invalid-metadata-sizes: SKIP (0.000s)
[545.401733] [129/132] (481s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[545.471417] Starting subtest: y-tiled-ccs-to-yf-tiled
[545.476505] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[545.678050] [130/132] (480s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[545.767101] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[552.725215] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (6.959s)
[552.864749] [131/132] (473s left) gem_userptr_blits (unsync-unmap)
[552.927247] Subtest unsync-unmap: SKIP (0.000s)
[553.064465] [132/132] (473s left) gem_ccs (suspend-resume)
[553.109342] Starting subtest: suspend-resume
[553.115254] Subtest suspend-resume: SKIP (0.000s)
[553.219905] Closing watchdogs
results: parsing output: 0/ for test: kms_flip
results: parsing output: 1/ for test: gem_exec_whisper
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: syncobj_timeline
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: core_setmaster
results: parsing output: 8/ for test: kms_pm_rpm
results: parsing output: 9/ for test: gem_exec_schedule
results: parsing output: 10/ for test: kms_flip
results: parsing output: 11/ for test: gem_pread
results: parsing output: 12/ for test: kms_plane_scaling
results: parsing output: 13/ for test: api_intel_bb
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: kms_psr2_sf
results: parsing output: 16/ for test: kms_cursor_legacy
results: parsing output: 17/ for test: kms_flip
results: parsing output: 18/ for test: gem_exec_nop
results: parsing output: 19/ for test: gem_fence_thrash
results: parsing output: 20/ for test: prime_mmap_kms
results: parsing output: 21/ for test: gem_userptr_blits
results: parsing output: 22/ for test: kms_pm_backlight
results: parsing output: 23/ for test: gem_exec_params
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: gem_fence_thrash
results: parsing output: 26/ for test: gem_workarounds
results: parsing output: 27/ for test: syncobj_wait
results: parsing output: 28/ for test: gem_softpin
results: parsing output: 29/ for test: i915_query
results: parsing output: 30/ for test: kms_pipe_crc_basic
results: parsing output: 31/ for test: kms_psr
results: parsing output: 32/ for test: gem_ctx_exec
results: parsing output: 33/ for test: gem_render_copy
results: parsing output: 34/ for test: i915_drm_fdinfo
results: parsing output: 35/ for test: prime_vgem
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: kms_flip_scaled_crc
results: parsing output: 38/ for test: kms_ccs
results: parsing output: 39/ for test: gem_softpin
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_plane_alpha_blend
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_ccs
results: parsing output: 44/ for test: perf_pmu
results: parsing output: 45/ for test: syncobj_wait
results: parsing output: 46/ for test: kms_content_protection
results: parsing output: 47/ for test: kms_ccs
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_cursor_crc
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_ctx_bad_destroy
results: parsing output: 52/ for test: gem_lmem_swapping
results: parsing output: 53/ for test: gen9_exec_parse
results: parsing output: 54/ for test: sw_sync
results: parsing output: 55/ for test: i915_pm_rc6_residency
results: parsing output: 56/ for test: api_intel_bb
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_vblank
results: parsing output: 59/ for test: gem_basic
results: parsing output: 60/ for test: kms_flip
results: parsing output: 61/ for test: kms_vblank
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: kms_flip
results: parsing output: 65/ for test: gem_exec_flush
results: parsing output: 66/ for test: vgem_basic
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_dp_link_training
results: parsing output: 69/ for test: kms_universal_plane
results: parsing output: 70/ for test: gem_exec_balancer
results: parsing output: 71/ for test: gem_mmap_offset
results: parsing output: 72/ for test: kms_atomic_transition
results: parsing output: 73/ for test: kms_rotation_crc
results: parsing output: 74/ for test: kms_big_fb
results: parsing output: 75/ for test: kms_psr2_sf
results: parsing output: 76/ for test: kms_psr
results: parsing output: 77/ for test: kms_psr
results: parsing output: 78/ for test: syncobj_wait
results: parsing output: 79/ for test: kms_chamelium_hpd
results: parsing output: 80/ for test: gem_mmap_gtt
results: parsing output: 81/ for test: kms_plane_scaling
results: parsing output: 82/ for test: gem_exec_schedule
results: parsing output: 83/ for test: gem_exec_fence
results: parsing output: 84/ for test: gem_userptr_blits
results: parsing output: 85/ for test: gem_ctx_persistence
results: parsing output: 86/ for test: kms_psr
results: parsing output: 87/ for test: gem_eio
results: parsing output: 88/ for test: kms_async_flips
results: parsing output: 89/ for test: kms_color
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gem_render_copy
results: parsing output: 92/ for test: gem_userptr_blits
results: parsing output: 93/ for test: kms_flip
results: parsing output: 94/ for test: gem_ccs
results: parsing output: 95/ for test: prime_mmap
results: parsing output: 96/ for test: gem_exec_params
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_plane
results: parsing output: 100/ for test: syncobj_timeline
results: parsing output: 101/ for test: kms_cursor_crc
results: parsing output: 102/ for test: kms_cursor_legacy
results: parsing output: 103/ for test: gem_exec_balancer
results: parsing output: 104/ for test: kms_chamelium_frames
results: parsing output: 105/ for test: kms_getfb
results: parsing output: 106/ for test: gem_ctx_sseu
results: parsing output: 107/ for test: gem_lmem_swapping
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: gem_exec_reloc
results: parsing output: 110/ for test: syncobj_timeline
results: parsing output: 111/ for test: i915_hangman
results: parsing output: 112/ for test: gem_mmap
results: parsing output: 113/ for test: kms_feature_discovery
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: gem_mmap_gtt
results: parsing output: 117/ for test: kms_pm_rpm
results: parsing output: 118/ for test: kms_chamelium_color
results: parsing output: 119/ for test: kms_flip_scaled_crc
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: kms_ccs
results: parsing output: 122/ for test: kms_invalid_mode
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: kms_psr
results: parsing output: 125/ for test: prime_busy
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: kms_hdr
results: parsing output: 128/ for test: gem_render_copy
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: gem_userptr_blits
results: parsing output: 131/ for test: gem_ccs
Done.