[60.153646] Initializing watchdogs
[60.153693]   /dev/watchdog0
[60.169595] [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]
[60.174643] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.176902] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.180369] [001/134] (960s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[60.333143] Starting subtest: 2x-long-cursor-vs-flip-atomic
[60.337797] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[60.504150] [002/134] (960s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[60.609596] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[60.613767] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[60.731211] [003/134] (960s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[60.831605] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[60.836157] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[60.975990] [004/134] (959s left) kms_big_fb (linear-64bpp-rotate-180)
[61.078819] Starting subtest: linear-64bpp-rotate-180
[62.670631] Subtest linear-64bpp-rotate-180: SUCCESS (1.583s)
[62.872190] [005/134] (957s left) gem_render_copy (y-tiled-to-vebox-linear)
[62.942609] Starting subtest: y-tiled-to-vebox-linear
[62.947392] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[63.149907] [006/134] (957s left) kms_atomic (atomic-plane-damage)
[63.253062] Starting subtest: atomic-plane-damage
[63.303411] Starting dynamic subtest: pipe-A-eDP-1
[63.826748] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.520s)
[63.829163] Subtest atomic-plane-damage: SUCCESS (0.573s)
[64.717217] [007/134] (956s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[65.006656] Starting subtest: cursor-rapid-movement-max-size
[65.013330] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[65.165736] [008/134] (955s left) syncobj_timeline (device-submit-unordered)
[65.220607] Starting subtest: device-submit-unordered
[65.222888] Subtest device-submit-unordered: SUCCESS (0.000s)
[65.362312] [009/134] (955s left) kms_async_flips (async-flip-dpms)
[65.454423] Starting subtest: async-flip-dpms
[65.828578] Starting dynamic subtest: pipe-A-eDP-1
[69.631313] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.793s)
[70.009061] Starting dynamic subtest: pipe-B-eDP-1
[72.798754] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.791s)
[73.185945] Starting dynamic subtest: pipe-C-eDP-1
[75.957738] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.776s)
[76.340279] Starting dynamic subtest: pipe-D-eDP-1
[79.125271] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.787s)
[79.127769] Subtest async-flip-dpms: SUCCESS (13.651s)
[80.333572] [010/134] (940s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[80.424522] Starting subtest: coverage-vs-premult-vs-constant
[80.712935] Starting dynamic subtest: pipe-A-eDP-1
[81.289607] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.575s)
[81.298655] Starting dynamic subtest: pipe-D-eDP-1
[82.617546] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.325s)
[82.619853] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.192s)
[83.501221] [011/134] (937s left) fbdev (nullptr)
[83.538975] Starting subtest: nullptr
[83.541243] Subtest nullptr: SUCCESS (0.000s)
[83.618879] [012/134] (937s left) kms_color (ctm-0-25)
[83.718872] Starting subtest: ctm-0-25
[83.721147] Starting dynamic subtest: pipe-A-eDP-1
[87.295475] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.574s)
[87.304067] Starting dynamic subtest: pipe-B-eDP-1
[91.519151] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.220s)
[91.527594] Starting dynamic subtest: pipe-C-eDP-1
[95.558390] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.038s)
[95.566200] Starting dynamic subtest: pipe-D-eDP-1
[99.548467] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.988s)
[99.550843] Subtest ctm-0-25: SUCCESS (15.821s)
[100.398402] [013/134] (920s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render)
[100.512251] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render
[104.665713] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.156s)
[105.798811] [014/134] (915s left) vgem_basic (mmap)
[105.906886] Starting subtest: mmap
[105.911824] Subtest mmap: SUCCESS (0.006s)
[105.982419] [FACT vgem_basic (mmap)] new: kernel.kmod_is_loaded.vgem: true
[105.985429] [015/134] (915s left) gem_mmap_offset (mmap-unmap)
[106.045906] Starting subtest: mmap-unmap
[106.048167] Starting dynamic subtest: smem0
[129.064089] Dynamic subtest smem0: SUCCESS (22.962s)
[129.066529] Subtest mmap-unmap: SUCCESS (22.963s)
[129.168944] [016/134] (892s left) kms_properties (invalid-properties-legacy)
[129.278777] Starting subtest: invalid-properties-legacy
[129.384852] Subtest invalid-properties-legacy: SUCCESS (0.106s)
[129.479115] [017/134] (891s left) dumb_buffer (invalid-bpp)
[129.537585] Starting subtest: invalid-bpp
[129.539607] Subtest invalid-bpp: SUCCESS (0.000s)
[129.685242] [018/134] (891s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling)
[129.793550] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling
[129.795819] Starting dynamic subtest: pipe-A-default-mode
[130.081244] Dynamic subtest pipe-A-default-mode: SKIP (0.287s)
[130.085896] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SKIP (0.288s)
[130.914473] [019/134] (890s left) kms_psr (fbc-pr-sprite-plane-move)
[131.015763] Starting subtest: fbc-pr-sprite-plane-move
[131.020285] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[131.115236] [020/134] (890s left) gem_fenced_exec_thrash (no-spare-fences)
[131.181110] Subtest no-spare-fences: SKIP (0.000s)
[131.258653] [021/134] (890s left) perf (create-destroy-userspace-config)
[131.420609] Starting subtest: create-destroy-userspace-config
[131.438797] Subtest create-destroy-userspace-config: SUCCESS (0.019s)
[131.484966] [022/134] (890s left) kms_chamelium_frames (hdmi-crc-fast)
[131.857464] Subtest hdmi-crc-fast: SKIP (0.000s)
[132.704337] [023/134] (888s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[132.813134] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[132.817635] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[132.940846] [024/134] (888s left) i915_selftest (live)
[136.362501] Starting subtest: live
[136.364598] Starting dynamic subtest: sanitycheck
[140.786286] Dynamic subtest sanitycheck: SUCCESS (4.423s)
[140.794223] Starting dynamic subtest: uncore
[143.630210] Dynamic subtest uncore: SUCCESS (2.842s)
[143.638884] Starting dynamic subtest: workarounds
[146.971438] Dynamic subtest workarounds: SUCCESS (3.340s)
[146.979632] Starting dynamic subtest: gt_engines
[151.689787] Dynamic subtest gt_engines: SUCCESS (4.718s)
[151.697422] Starting dynamic subtest: gt_timelines
[167.581717] Dynamic subtest gt_timelines: SUCCESS (15.890s)
[167.590798] Starting dynamic subtest: gt_contexts
[171.989796] Dynamic subtest gt_contexts: SUCCESS (4.406s)
[171.998492] Starting dynamic subtest: gt_lrc
[176.455428] Dynamic subtest gt_lrc: SUCCESS (4.464s)
[176.464207] Starting dynamic subtest: gt_mocs
[179.593659] Dynamic subtest gt_mocs: SUCCESS (3.136s)
[179.602811] Starting dynamic subtest: gt_pm
[186.475839] Dynamic subtest gt_pm: SUCCESS (6.880s)
[186.484441] Starting dynamic subtest: gt_heartbeat
[190.889087] Dynamic subtest gt_heartbeat: SUCCESS (4.411s)
[190.897285] Starting dynamic subtest: gt_tlb
[200.380548] Dynamic subtest gt_tlb: SUCCESS (9.488s)
[200.389526] Starting dynamic subtest: requests
[211.932480] Dynamic subtest requests: SUCCESS (11.549s)
[211.940854] Starting dynamic subtest: migrate
[220.045863] Dynamic subtest migrate: SUCCESS (8.112s)
[220.054710] Starting dynamic subtest: active
[222.890759] Dynamic subtest active: SUCCESS (2.843s)
[222.899216] Starting dynamic subtest: objects
[227.692075] Dynamic subtest objects: SUCCESS (4.799s)
[227.705798] Starting dynamic subtest: mman
[232.748058] Dynamic subtest mman: SUCCESS (5.054s)
[232.755085] Starting dynamic subtest: dmabuf
[237.278242] Dynamic subtest dmabuf: SUCCESS (4.527s)
[237.287144] Starting dynamic subtest: vma
[241.765409] Dynamic subtest vma: SUCCESS (4.484s)
[241.774060] Starting dynamic subtest: coherency
[246.816327] Dynamic subtest coherency: SUCCESS (5.048s)
[246.825583] Starting dynamic subtest: gtt
[259.055654] Dynamic subtest gtt: SUCCESS (12.236s)
[259.064829] Starting dynamic subtest: gem
[264.706929] Dynamic subtest gem: SUCCESS (5.650s)
[264.716030] Starting dynamic subtest: evict
[270.312538] Dynamic subtest evict: SUCCESS (5.586s)
[270.322398] Starting dynamic subtest: hugepages
[281.523636] Dynamic subtest hugepages: SUCCESS (11.227s)
[281.532852] Starting dynamic subtest: gem_contexts
[308.020556] Dynamic subtest gem_contexts: SUCCESS (26.492s)
[308.029246] Starting dynamic subtest: client
[312.502398] Dynamic subtest client: SUCCESS (4.483s)
[312.511516] Starting dynamic subtest: gem_migrate
[316.961477] Dynamic subtest gem_migrate: SUCCESS (4.457s)
[316.970651] Starting dynamic subtest: reset
[319.869457] Dynamic subtest reset: SUCCESS (2.906s)
[319.878753] Starting dynamic subtest: memory_region
[324.376230] Dynamic subtest memory_region: SUCCESS (4.505s)
[324.384958] Starting dynamic subtest: hangcheck
[337.664439] Dynamic subtest hangcheck: SUCCESS (13.285s)
[337.673767] Starting dynamic subtest: execlists
[342.112380] Dynamic subtest execlists: SUCCESS (4.446s)
[342.121536] Starting dynamic subtest: ring_submission
[346.597205] Dynamic subtest ring_submission: SUCCESS (4.483s)
[346.606172] Starting dynamic subtest: perf
[351.074568] Dynamic subtest perf: SUCCESS (4.475s)
[351.088381] Starting dynamic subtest: slpc
[365.239175] Dynamic subtest slpc: SUCCESS (14.162s)
[365.248809] Starting dynamic subtest: guc
[369.268697] Dynamic subtest guc: SUCCESS (4.026s)
[369.277738] Starting dynamic subtest: guc_multi_lrc
[373.753247] Dynamic subtest guc_multi_lrc: SUCCESS (4.483s)
[373.762259] Starting dynamic subtest: guc_hang
[378.775877] Dynamic subtest guc_hang: SUCCESS (5.019s)
[378.785208] Starting dynamic subtest: late_gt_pm
[383.265960] Dynamic subtest late_gt_pm: SUCCESS (4.488s)
[383.268851] Subtest live: SUCCESS (246.893s)
[383.298198] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[383.298866] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[383.301997] [025/134] (638s left) kms_pm_rpm (modeset-non-lpsp-stress)
[387.093474] Starting subtest: modeset-non-lpsp-stress
[388.241894] Subtest modeset-non-lpsp-stress: SKIP (1.146s)
[388.637704] [FACT kms_pm_rpm (modeset-non-lpsp-stress)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[388.638907] [FACT kms_pm_rpm (modeset-non-lpsp-stress)] new: kernel.kmod_is_loaded.i915: true
[388.642793] [026/134] (633s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted)
[388.717710] Starting subtest: invalid-multi-wait-all-unsubmitted
[388.720154] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[388.836127] [027/134] (632s left) gem_mmap_offset (perf)
[388.907447] Starting subtest: perf
[388.909706] Starting dynamic subtest: smem0
[389.249844] Dynamic subtest smem0: SUCCESS (0.341s)
[389.251924] Subtest perf: SUCCESS (0.342s)
[389.408940] [028/134] (632s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[389.517052] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[389.521535] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[389.656633] [029/134] (632s left) gem_exec_balancer (parallel-balancer)
[389.914566] Starting subtest: parallel-balancer
[390.805080] Subtest parallel-balancer: SUCCESS (0.891s)
[390.944066] [030/134] (630s left) kms_chamelium_hpd (hdmi-hpd)
[391.340360] Subtest hdmi-hpd: SKIP (0.000s)
[392.113027] [031/134] (629s left) gem_exec_whisper (basic-fds-priority)
[392.193239] Starting subtest: basic-fds-priority
[417.557622] Subtest basic-fds-priority: SUCCESS (25.363s)
[417.767928] [032/134] (604s left) kms_lease (cursor-implicit-plane)
[417.865984] Starting subtest: cursor-implicit-plane
[417.868224] Starting dynamic subtest: pipe-A-eDP-1
[418.317453] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.449s)
[418.325491] Starting dynamic subtest: pipe-B-eDP-1
[419.428771] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.112s)
[419.441527] Starting dynamic subtest: pipe-C-eDP-1
[420.541047] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.111s)
[420.550115] Starting dynamic subtest: pipe-D-eDP-1
[421.670263] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.125s)
[421.672562] Subtest cursor-implicit-plane: SUCCESS (3.803s)
[422.553736] [033/134] (599s left) vgem_basic (bad-handle)
[422.596254] Starting subtest: bad-handle
[422.598159] Subtest bad-handle: SUCCESS (0.000s)
[422.674596] [034/134] (599s left) gem_ctx_persistence (heartbeat-hang)
[422.728376] Starting subtest: heartbeat-hang
[422.732976] Subtest heartbeat-hang: SKIP (0.000s)
[422.862811] [035/134] (599s left) kms_lease (setcrtc-implicit-plane)
[422.957789] Starting subtest: setcrtc-implicit-plane
[422.960092] Starting dynamic subtest: pipe-A-eDP-1
[423.435595] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.477s)
[423.443335] Starting dynamic subtest: pipe-B-eDP-1
[424.554637] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.117s)
[424.563409] Starting dynamic subtest: pipe-C-eDP-1
[425.671675] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.116s)
[425.682955] Starting dynamic subtest: pipe-D-eDP-1
[426.810525] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.136s)
[426.812745] Subtest setcrtc-implicit-plane: SUCCESS (3.852s)
[427.686241] [036/134] (594s left) gem_exec_schedule (submit-early-slice)
[427.755977] Starting subtest: submit-early-slice
[427.758365] Starting dynamic subtest: rcs0
[427.798706] Dynamic subtest rcs0: SUCCESS (0.052s)
[427.809196] Starting dynamic subtest: bcs0
[427.836275] Dynamic subtest bcs0: SUCCESS (0.037s)
[427.845110] Starting dynamic subtest: vcs0
[427.877545] Dynamic subtest vcs0: SUCCESS (0.040s)
[427.886243] Starting dynamic subtest: vcs1
[427.916800] Dynamic subtest vcs1: SUCCESS (0.039s)
[427.925511] Starting dynamic subtest: vecs0
[427.954596] Dynamic subtest vecs0: SUCCESS (0.037s)
[427.963463] Starting dynamic subtest: ccs0
[427.989850] Dynamic subtest ccs0: SUCCESS (0.034s)
[427.992074] Subtest submit-early-slice: SUCCESS (0.245s)
[429.022429] [037/134] (593s left) gem_reg_read (timestamp-moving)
[429.083079] Starting subtest: timestamp-moving
[430.084971] Subtest timestamp-moving: SUCCESS (1.001s)
[430.186517] [038/134] (591s left) kms_dp_linktrain_fallback (dsc-fallback)
[430.288249] Starting subtest: dsc-fallback
[430.294770] Subtest dsc-fallback: SKIP (0.000s)
[430.385544] [039/134] (591s left) gem_tiled_blits (basic)
[430.444063] Subtest basic: SKIP (0.000s)
[430.538225] [040/134] (591s left) syncobj_timeline (wait-delayed-signal)
[430.593558] Starting subtest: wait-delayed-signal
[430.697890] Subtest wait-delayed-signal: SUCCESS (0.102s)
[430.800402] [041/134] (591s left) gem_lmem_swapping (massive)
[430.843123] Subtest massive: SKIP (0.000s)
[430.882537] [042/134] (591s left) kms_big_fb (4-tiled-addfb-size-overflow)
[430.978987] Starting subtest: 4-tiled-addfb-size-overflow
[430.981140] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[431.124582] [043/134] (591s left) kms_hdr (static-swap)
[431.221915] Starting subtest: static-swap
[431.228185] Subtest static-swap: SKIP (0.000s)
[431.319121] [044/134] (591s left) kms_flip (plain-flip-ts-check)
[431.418659] Starting subtest: plain-flip-ts-check
[431.421051] Starting dynamic subtest: A-eDP1
[440.299724] Dynamic subtest A-eDP1: SUCCESS (8.847s)
[440.310547] Starting dynamic subtest: B-eDP1
[449.134961] Dynamic subtest B-eDP1: SUCCESS (8.834s)
[449.145537] Starting dynamic subtest: C-eDP1
[457.969575] Dynamic subtest C-eDP1: SUCCESS (8.821s)
[457.980299] Starting dynamic subtest: D-eDP1
[466.764948] Dynamic subtest D-eDP1: SUCCESS (8.837s)
[466.769850] Subtest plain-flip-ts-check: SUCCESS (35.350s)
[468.073998] [045/134] (554s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[468.171659] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[468.173917] Starting dynamic subtest: pipe-A
[468.421194] Dynamic subtest pipe-A: SUCCESS (0.251s)
[468.429307] Starting dynamic subtest: pipe-B
[469.731434] Dynamic subtest pipe-B: SUCCESS (1.310s)
[469.739790] Starting dynamic subtest: pipe-C
[471.088046] Dynamic subtest pipe-C: SUCCESS (1.355s)
[471.098229] Starting dynamic subtest: pipe-D
[472.445074] Dynamic subtest pipe-D: SUCCESS (1.356s)
[472.447253] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.275s)
[473.621779] [046/134] (548s left) prime_vgem (busy)
[473.702726] Starting subtest: busy
[473.705176] Starting dynamic subtest: rcs0
[473.792254] Dynamic subtest rcs0: SUCCESS (0.090s)
[473.800813] Starting dynamic subtest: bcs0
[473.890329] Dynamic subtest bcs0: SUCCESS (0.096s)
[473.898830] Starting dynamic subtest: vcs0
[473.943304] Dynamic subtest vcs0: SUCCESS (0.052s)
[473.951267] Starting dynamic subtest: vcs1
[473.988602] Dynamic subtest vcs1: SUCCESS (0.045s)
[473.996846] Starting dynamic subtest: vecs0
[474.033571] Dynamic subtest vecs0: SUCCESS (0.044s)
[474.041586] Starting dynamic subtest: ccs0
[474.082410] Dynamic subtest ccs0: SUCCESS (0.048s)
[474.084664] Subtest busy: SUCCESS (0.381s)
[474.253516] [047/134] (548s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[474.324942] Starting subtest: mixed-tiled-to-y-tiled-ccs
[474.329134] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[474.528638] [048/134] (548s left) gem_ctx_isolation (clean)
[474.593636] Starting subtest: clean
[474.595844] Starting dynamic subtest: rcs0
[474.649917] Dynamic subtest rcs0: SUCCESS (0.056s)
[474.660016] Starting dynamic subtest: bcs0
[474.733189] Dynamic subtest bcs0: SUCCESS (0.082s)
[474.743598] Starting dynamic subtest: vcs0
[474.804940] Dynamic subtest vcs0: SUCCESS (0.071s)
[474.815233] Starting dynamic subtest: vcs1
[475.936869] Dynamic subtest vcs1: SUCCESS (1.131s)
[475.945265] Starting dynamic subtest: vecs0
[477.970713] Dynamic subtest vecs0: SUCCESS (2.032s)
[477.981200] Starting dynamic subtest: ccs0
[479.938269] Dynamic subtest ccs0: SUCCESS (1.966s)
[479.940896] Subtest clean: SUCCESS (5.344s)
[480.177809] [049/134] (542s left) kms_frontbuffer_tracking (psr-abgr161616f-draw-render)
[480.287836] Starting subtest: psr-abgr161616f-draw-render
[480.292306] Subtest psr-abgr161616f-draw-render: SKIP (0.000s)
[480.408920] [050/134] (542s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[480.513246] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[481.535401] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.022s)
[481.706126] [051/134] (540s left) gem_spin_batch (legacy)
[481.783227] Starting subtest: legacy
[481.785238] Starting dynamic subtest: default
[485.027372] Dynamic subtest default: SUCCESS (3.239s)
[485.037810] Starting dynamic subtest: render
[488.313084] Dynamic subtest render: SUCCESS (3.232s)
[488.323982] Starting dynamic subtest: bsd
[491.551861] Dynamic subtest bsd: SUCCESS (3.235s)
[491.561844] Starting dynamic subtest: bsd1
[494.788996] Dynamic subtest bsd1: SUCCESS (3.235s)
[494.800143] Starting dynamic subtest: bsd2
[498.022824] Dynamic subtest bsd2: SUCCESS (3.231s)
[498.033058] Starting dynamic subtest: blt
[501.260545] Dynamic subtest blt: SUCCESS (3.235s)
[501.271301] Starting dynamic subtest: vebox
[504.499333] Dynamic subtest vebox: SUCCESS (3.235s)
[504.501408] Subtest legacy: SUCCESS (22.661s)
[505.040394] [052/134] (517s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[510.085115] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf
[510.089640] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.002s)
[510.953315] [053/134] (511s left) perf_pmu (init-busy)
[510.996502] Starting subtest: init-busy
[510.998711] Starting dynamic subtest: rcs0
[511.001104] Dynamic subtest rcs0: SUCCESS (0.001s)
[511.013768] Starting dynamic subtest: bcs0
[511.015895] Dynamic subtest bcs0: SUCCESS (0.000s)
[511.025582] Starting dynamic subtest: vcs0
[511.027828] Dynamic subtest vcs0: SUCCESS (0.001s)
[511.036250] Starting dynamic subtest: vcs1
[511.038877] Dynamic subtest vcs1: SUCCESS (0.001s)
[511.048235] Starting dynamic subtest: vecs0
[511.050393] Dynamic subtest vecs0: SUCCESS (0.000s)
[511.059848] Starting dynamic subtest: ccs0
[511.062006] Dynamic subtest ccs0: SUCCESS (0.000s)
[511.064101] Subtest init-busy: SUCCESS (0.007s)
[511.153208] [054/134] (511s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[511.259459] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[511.263972] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[511.384714] [055/134] (511s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[511.484720] Starting subtest: primary-y-tiled-reflect-x-90
[511.488661] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s)
[511.580748] [056/134] (511s left) prime_mmap (test_correct)
[511.639838] Starting subtest: test_correct
[511.642072] Starting dynamic subtest: test_correct-smem
[511.670120] Dynamic subtest test_correct-smem: SUCCESS (0.031s)
[511.672524] Subtest test_correct: SUCCESS (0.031s)
[511.810751] [057/134] (511s left) kms_cursor_crc (cursor-sliding-max-size)
[512.116171] Starting subtest: cursor-sliding-max-size
[512.121550] Subtest cursor-sliding-max-size: SKIP (0.000s)
[512.269442] [058/134] (510s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[512.372314] Starting subtest: cursorB-vs-flipA-legacy
[512.375991] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[512.542970] [059/134] (510s left) gem_mmap_gtt (basic-wc)
[512.596923] Subtest basic-wc: SKIP (0.000s)
[512.660174] [060/134] (510s left) gem_softpin (noreloc)
[512.724551] Starting subtest: noreloc
[518.190824] Subtest noreloc: SUCCESS (5.411s)
[518.300969] [061/134] (504s left) sw_sync (alloc_timeline)
[518.343806] Starting subtest: alloc_timeline
[518.346211] Subtest alloc_timeline: SUCCESS (0.000s)
[518.434766] [062/134] (504s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[518.535610] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[518.539804] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[518.650593] [063/134] (504s left) kms_pm_backlight (bad-brightness)
[518.754601] Starting subtest: bad-brightness
[518.806057] Starting dynamic subtest: eDP-1
[519.125700] Dynamic subtest eDP-1: SUCCESS (0.317s)
[519.128375] Subtest bad-brightness: SUCCESS (0.371s)
[519.995131] [064/134] (503s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[520.571843] Starting subtest: syncobj-timeline-invalid-wait
[520.574307] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.005s)
[522.011942] [065/134] (501s left) syncobj_timeline (signal-point-0)
[522.060016] Starting subtest: signal-point-0
[522.062279] Subtest signal-point-0: SUCCESS (0.000s)
[522.195229] [066/134] (501s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0-hflip)
[522.311492] Starting subtest: linear-max-hw-stride-32bpp-rotate-0-hflip
[522.316030] Subtest linear-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[522.428103] [067/134] (500s left) kms_content_protection (atomic)
[522.577198] Starting subtest: atomic
[522.581758] Subtest atomic: SKIP (0.000s)
[522.747398] [068/134] (500s left) i915_pm_rps (reset)
[522.825753] Starting subtest: reset
[531.285742] Subtest reset: SUCCESS (8.462s)
[531.442819] [069/134] (491s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[531.551368] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[540.190314] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.641s)
[540.337806] [070/134] (483s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[540.439452] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[547.551258] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.114s)
[547.703285] [071/134] (475s left) gem_close (many-handles-one-vma)
[547.770358] Starting subtest: many-handles-one-vma
[547.796161] Subtest many-handles-one-vma: SUCCESS (0.025s)
[547.939712] [072/134] (475s left) kms_psr (fbc-psr-sprite-render)
[548.031992] Starting subtest: fbc-psr-sprite-render
[548.034302] Starting dynamic subtest: eDP-1
[548.038674] Dynamic subtest eDP-1: SKIP (0.000s)
[548.043081] Subtest fbc-psr-sprite-render: SKIP (0.001s)
[548.134876] [073/134] (475s left) kms_vblank (wait-idle-hang)
[548.231750] Starting subtest: wait-idle-hang
[548.233855] Starting dynamic subtest: pipe-A-eDP-1
[575.646529] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.413s)
[575.662116] Starting dynamic subtest: pipe-D-eDP-1
[600.672307] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.023s)
[600.674619] Subtest wait-idle-hang: SUCCESS (52.441s)
[601.573974] [074/134] (422s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[601.662433] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[601.666837] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[601.792828] [075/134] (421s left) gem_userptr_blits (create-destroy-unsync)
[601.854936] Subtest create-destroy-unsync: SKIP (0.000s)
[602.017705] [076/134] (421s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[602.074058] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[602.178214] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.103s)
[602.281386] [077/134] (421s left) kms_psr (psr2-cursor-blt)
[602.373122] Starting subtest: psr2-cursor-blt
[602.375443] Starting dynamic subtest: eDP-1
[604.136610] Dynamic subtest eDP-1: SUCCESS (1.761s)
[604.138602] Subtest psr2-cursor-blt: SUCCESS (1.762s)
[604.956390] [078/134] (418s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[605.053989] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[605.056253] Starting dynamic subtest: pipe-A-default-mode
[605.346162] Dynamic subtest pipe-A-default-mode: SKIP (0.289s)
[605.350777] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.291s)
[606.181799] [079/134] (417s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[606.281795] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[606.283668] Starting dynamic subtest: pipe-A-eDP-1
[606.303314] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.019s)
[606.312880] Starting dynamic subtest: pipe-B-eDP-1
[606.332688] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s)
[606.346210] Starting dynamic subtest: pipe-C-eDP-1
[606.365685] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.020s)
[606.377144] Starting dynamic subtest: pipe-D-eDP-1
[606.396565] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.020s)
[606.398684] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.085s)
[608.642393] [080/134] (415s left) kms_cursor_crc (cursor-onscreen-512x170)
[608.931995] Starting subtest: cursor-onscreen-512x170
[608.936341] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[609.113696] [081/134] (414s left) syncobj_wait (invalid-reset-illegal-handle)
[609.171031] Starting subtest: invalid-reset-illegal-handle
[609.173256] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[609.298410] [082/134] (414s left) gem_sync (basic-store-all)
[609.365247] Starting subtest: basic-store-all
[613.935280] Subtest basic-store-all: SUCCESS (4.558s)
[614.126019] [083/134] (409s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[614.237316] Starting subtest: y-tiled-64bpp-rotate-0
[614.241384] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[614.361576] [084/134] (409s left) gem_mmap_gtt (basic)
[614.420358] Subtest basic: SKIP (0.000s)
[614.489522] [085/134] (409s left) kms_psr (psr-dpms)
[614.587271] Starting subtest: psr-dpms
[614.589565] Starting dynamic subtest: eDP-1
[617.547515] Dynamic subtest eDP-1: SUCCESS (2.959s)
[617.549444] Subtest psr-dpms: SUCCESS (2.960s)
[618.440175] [086/134] (405s left) gem_lmem_swapping (verify-ccs)
[618.488064] Subtest verify-ccs: SKIP (0.000s)
[618.537624] [087/134] (405s left) gem_pread (snoop)
[618.608800] Subtest snoop: SKIP (0.000s)
[618.683971] [088/134] (405s left) kms_rotation_crc (exhaust-fences)
[618.775751] Starting subtest: exhaust-fences
[618.780234] Subtest exhaust-fences: SKIP (0.000s)
[618.875822] [089/134] (405s left) gem_softpin (softpin)
[618.944259] Starting subtest: softpin
[651.188097] Subtest softpin: SUCCESS (32.238s)
[651.348870] [090/134] (372s left) i915_drm_fdinfo (virtual-busy-hang-all)
[651.393196] Starting subtest: virtual-busy-hang-all
[651.397744] Subtest virtual-busy-hang-all: SKIP (0.000s)
[651.486295] [091/134] (372s left) gem_render_copy (y-tiled-ccs-to-linear)
[651.549685] Starting subtest: y-tiled-ccs-to-linear
[651.554302] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[651.766558] [092/134] (372s left) gem_watchdog (default-physical)
[651.840839] Starting subtest: default-physical
[653.606678] Subtest default-physical: SUCCESS (1.776s)
[653.726207] [093/134] (370s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[653.782660] Starting subtest: multi-wait-available-unsubmitted-submitted
[653.785022] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[653.910952] [094/134] (370s left) gem_mmap_gtt (basic-short)
[653.976065] Subtest basic-short: SKIP (0.000s)
[654.043205] [095/134] (370s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[654.151970] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[654.156424] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[654.257383] [096/134] (370s left) gem_flink_basic (bad-open)
[654.310077] Starting subtest: bad-open
[654.312185] Subtest bad-open: SUCCESS (0.000s)
[654.433725] [097/134] (370s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[654.554423] Starting subtest: cursor-vs-flip-toggle
[685.317515] Subtest cursor-vs-flip-toggle: SUCCESS (30.759s)
[686.163717] [098/134] (338s left) gem_flink_basic (double-flink)
[686.220534] Starting subtest: double-flink
[686.222925] Subtest double-flink: SUCCESS (0.000s)
[686.346028] [099/134] (338s left) gen9_exec_parse (batch-zero-length)
[686.403450] Subtest batch-zero-length: SKIP (0.000s)
[686.482122] [100/134] (338s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[686.581134] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[686.585075] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[686.726680] [101/134] (338s left) api_intel_allocator (simple-allocator)
[686.777926] Starting subtest: simple-allocator
[686.780115] Starting dynamic subtest: basic
[686.782319] Dynamic subtest basic: SUCCESS (0.005s)
[686.795511] Starting dynamic subtest: parallel-one
[686.955998] Dynamic subtest parallel-one: SUCCESS (0.174s)
[686.964973] Starting dynamic subtest: print
[686.967129] Dynamic subtest print: SUCCESS (0.000s)
[686.975826] Starting dynamic subtest: reuse
[686.977912] Dynamic subtest reuse: SUCCESS (0.000s)
[686.985951] Starting dynamic subtest: reserve
[686.988117] Dynamic subtest reserve: SUCCESS (0.000s)
[686.996286] Starting dynamic subtest: fork-reopen-allocator
[686.998443] Dynamic subtest fork-reopen-allocator: SUCCESS (0.010s)
[687.000621] Subtest simple-allocator: SUCCESS (0.196s)
[687.115720] [102/134] (337s left) gem_exec_balancer (parallel-keep-in-fence)
[687.372592] Starting subtest: parallel-keep-in-fence
[688.505572] Subtest parallel-keep-in-fence: SUCCESS (1.135s)
[688.652199] [103/134] (336s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs)
[688.739577] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs
[688.741781] Starting dynamic subtest: pipe-A-eDP-1
[688.763574] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[688.774583] Starting dynamic subtest: pipe-B-eDP-1
[688.794923] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[688.803843] Starting dynamic subtest: pipe-C-eDP-1
[688.824616] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[688.833504] Starting dynamic subtest: pipe-D-eDP-1
[688.855473] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[688.859635] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.006s)
[691.014348] [104/134] (333s left) gem_ctx_create (basic)
[691.087578] Starting subtest: basic
[691.090026] Subtest basic: SUCCESS (0.000s)
[691.295675] [105/134] (333s left) syncobj_wait (invalid-reset-zero-handles)
[691.356256] Starting subtest: invalid-reset-zero-handles
[691.358381] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[691.478449] [106/134] (333s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[691.582592] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[691.586662] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[691.709186] [107/134] (333s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[691.813783] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[699.476121] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.664s)
[699.646595] [108/134] (325s left) gem_ctx_shared (detached-shared-gtt)
[699.722032] Starting subtest: detached-shared-gtt
[701.937160] Subtest detached-shared-gtt: SUCCESS (2.151s)
[702.262601] [109/134] (322s left) kms_cdclk (mode-transition)
[702.364831] Starting subtest: mode-transition
[702.367066] Starting dynamic subtest: pipe-A-eDP-1
[702.653302] Dynamic subtest pipe-A-eDP-1: SKIP (0.287s)
[702.662776] Starting dynamic subtest: pipe-B-eDP-1
[702.667119] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[702.675362] Starting dynamic subtest: pipe-C-eDP-1
[702.679719] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[702.688465] Starting dynamic subtest: pipe-D-eDP-1
[702.692577] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[702.696639] Subtest mode-transition: SKIP (0.294s)
[703.543156] [110/134] (321s left) kms_prop_blob (invalid-set-prop)
[703.615617] Starting subtest: invalid-set-prop
[703.617986] Subtest invalid-set-prop: SUCCESS (0.000s)
[703.735174] [111/134] (321s left) gem_exec_params (rs-invalid)
[703.790326] Starting subtest: rs-invalid
[703.795394] Subtest rs-invalid: SUCCESS (0.003s)
[703.954266] [112/134] (321s left) gem_create (create-valid-nonaligned)
[704.000990] Starting subtest: create-valid-nonaligned
[704.003209] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[704.218381] [113/134] (321s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[704.318509] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[711.855949] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.540s)
[712.042451] [114/134] (313s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[712.140815] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[712.143125] Starting dynamic subtest: pipe-A-eDP-1
[712.164821] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[712.175570] Starting dynamic subtest: pipe-B-eDP-1
[712.196129] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[712.204546] Starting dynamic subtest: pipe-C-eDP-1
[712.225164] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[712.233199] Starting dynamic subtest: pipe-D-eDP-1
[712.254604] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[712.258903] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[714.432828] [115/134] (310s left) kms_feature_discovery (dp-mst)
[714.533040] Starting subtest: dp-mst
[714.537489] Subtest dp-mst: SKIP (0.000s)
[714.629570] [116/134] (310s left) kms_frontbuffer_tracking (fbc-abgr161616f-draw-mmap-cpu)
[714.727609] Starting subtest: fbc-abgr161616f-draw-mmap-cpu
[714.731576] Subtest fbc-abgr161616f-draw-mmap-cpu: SKIP (0.000s)
[714.862744] [117/134] (310s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[714.971812] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[714.976318] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[715.111139] [118/134] (310s left) kms_psr (fbc-psr-basic)
[715.197679] Starting subtest: fbc-psr-basic
[715.199884] Starting dynamic subtest: eDP-1
[715.203929] Dynamic subtest eDP-1: SKIP (0.000s)
[715.208018] Subtest fbc-psr-basic: SKIP (0.001s)
[715.295085] [119/134] (310s left) kms_universal_plane (universal-plane-functional)
[715.393068] Starting subtest: universal-plane-functional
[715.394855] Starting dynamic subtest: pipe-A-eDP-1
[719.379092] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.983s)
[719.391864] Starting dynamic subtest: pipe-B-eDP-1
[724.094560] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.716s)
[724.105781] Starting dynamic subtest: pipe-C-eDP-1
[728.443329] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.345s)
[728.453486] Starting dynamic subtest: pipe-D-eDP-1
[732.812795] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.367s)
[732.814795] Subtest universal-plane-functional: SUCCESS (17.417s)
[733.699252] [120/134] (291s left) kms_plane (planar-pixel-format-settings)
[733.800975] Starting subtest: planar-pixel-format-settings
[733.868914] Subtest planar-pixel-format-settings: SUCCESS (0.068s)
[734.021391] [121/134] (291s left) kms_flip (2x-flip-vs-panning)
[734.122443] Starting subtest: 2x-flip-vs-panning
[734.134962] Subtest 2x-flip-vs-panning: SKIP (0.012s)
[734.242269] [122/134] (291s left) gem_exec_schedule (implicit-write-read)
[734.311614] Starting subtest: implicit-write-read
[734.313918] Starting dynamic subtest: rcs0
[734.413633] Dynamic subtest rcs0: SUCCESS (0.107s)
[734.425087] Starting dynamic subtest: vcs0
[734.510469] Dynamic subtest vcs0: SUCCESS (0.097s)
[734.521484] Starting dynamic subtest: vcs1
[734.590536] Dynamic subtest vcs1: SUCCESS (0.079s)
[734.601098] Starting dynamic subtest: vecs0
[734.677855] Dynamic subtest vecs0: SUCCESS (0.087s)
[734.689344] Starting dynamic subtest: ccs0
[734.770749] Dynamic subtest ccs0: SUCCESS (0.091s)
[734.773160] Subtest implicit-write-read: SUCCESS (0.466s)
[736.014683] [123/134] (289s left) gem_render_copy (x-tiled)
[736.084280] Starting subtest: x-tiled
[736.086211] Starting dynamic subtest: smem
[736.125336] Dynamic subtest smem: SUCCESS (0.043s)
[736.127856] Subtest x-tiled: SUCCESS (0.044s)
[736.385078] [124/134] (289s left) kms_vblank (wait-forked-busy)
[736.480733] Starting subtest: wait-forked-busy
[736.483091] Starting dynamic subtest: pipe-A-eDP-1
[738.362143] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.882s)
[738.376194] Starting dynamic subtest: pipe-D-eDP-1
[740.924693] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.556s)
[740.926961] Subtest wait-forked-busy: SUCCESS (4.442s)
[741.751563] [125/134] (284s left) gem_mmap (big-bo)
[741.813101] Subtest big-bo: SKIP (0.000s)
[741.885209] [126/134] (283s left) gem_reg_read (bad-register)
[741.943882] Starting subtest: bad-register
[741.946212] Subtest bad-register: SUCCESS (0.000s)
[742.067435] [127/134] (283s left) kms_flip (nonexisting-fb)
[742.162766] Starting subtest: nonexisting-fb
[742.165288] Starting dynamic subtest: A-eDP1
[743.311474] Dynamic subtest A-eDP1: SUCCESS (1.150s)
[743.321506] Starting dynamic subtest: B-eDP1
[744.446928] Dynamic subtest B-eDP1: SUCCESS (1.135s)
[744.456661] Starting dynamic subtest: C-eDP1
[745.583756] Dynamic subtest C-eDP1: SUCCESS (1.136s)
[745.594559] Starting dynamic subtest: D-eDP1
[746.716614] Dynamic subtest D-eDP1: SUCCESS (1.131s)
[746.721685] Subtest nonexisting-fb: SUCCESS (4.560s)
[747.924415] [128/134] (277s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[748.028921] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs
[748.031237] Starting dynamic subtest: pipe-A-eDP-1
[748.053891] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[748.065589] Starting dynamic subtest: pipe-B-eDP-1
[748.086676] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[748.095139] Starting dynamic subtest: pipe-C-eDP-1
[748.116873] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[748.125072] Starting dynamic subtest: pipe-D-eDP-1
[748.146830] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[748.151209] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.007s)
[750.228046] [129/134] (275s left) i915_query (query-topology-coherent-slice-mask)
[750.284022] Starting subtest: query-topology-coherent-slice-mask
[750.288143] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[750.422294] [130/134] (275s left) gem_close_race (multigpu-basic-process)
[750.478318] Starting subtest: multigpu-basic-process
[750.482706] Subtest multigpu-basic-process: SKIP (0.000s)
[750.734307] [131/134] (275s left) i915_drm_fdinfo (memory-info-idle)
[750.782100] Starting subtest: memory-info-idle
[750.784416] Starting dynamic subtest: smem0
[750.862314] Dynamic subtest smem0: SUCCESS (0.080s)
[750.864800] Subtest memory-info-idle: SUCCESS (0.081s)
[750.960014] [132/134] (275s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[755.987854] Starting subtest: psr2-cursor-plane-update-sf
[755.989838] Starting dynamic subtest: pipe-A-eDP-1
[757.283962] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.295s)
[757.294057] Starting dynamic subtest: pipe-B-eDP-1
[758.625908] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.342s)
[758.628378] Subtest psr2-cursor-plane-update-sf: SUCCESS (2.641s)
[759.530164] [133/134] (266s left) api_intel_bb (object-reloc-purge-cache)
[759.586755] Starting subtest: object-reloc-purge-cache
[759.591257] Subtest object-reloc-purge-cache: SKIP (0.003s)
[759.736549] [134/134] (266s left) gem_workarounds (reset)
[759.816876] Starting subtest: reset
[759.999672] Subtest reset: SUCCESS (0.182s)
[760.158896] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_legacy
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: gem_render_copy
results: parsing output: 5/ for test: kms_atomic
results: parsing output: 6/ for test: kms_cursor_crc
results: parsing output: 7/ for test: syncobj_timeline
results: parsing output: 8/ for test: kms_async_flips
results: parsing output: 9/ for test: kms_plane_alpha_blend
results: parsing output: 10/ for test: fbdev
results: parsing output: 11/ for test: kms_color
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: vgem_basic
results: parsing output: 14/ for test: gem_mmap_offset
results: parsing output: 15/ for test: kms_properties
results: parsing output: 16/ for test: dumb_buffer
results: parsing output: 17/ for test: kms_flip_scaled_crc
results: parsing output: 18/ for test: kms_psr
results: parsing output: 19/ for test: gem_fenced_exec_thrash
results: parsing output: 20/ for test: perf
results: parsing output: 21/ for test: kms_chamelium_frames
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: i915_selftest
results: parsing output: 24/ for test: kms_pm_rpm
results: parsing output: 25/ for test: syncobj_timeline
results: parsing output: 26/ for test: gem_mmap_offset
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: gem_exec_balancer
results: parsing output: 29/ for test: kms_chamelium_hpd
results: parsing output: 30/ for test: gem_exec_whisper
results: parsing output: 31/ for test: kms_lease
results: parsing output: 32/ for test: vgem_basic
results: parsing output: 33/ for test: gem_ctx_persistence
results: parsing output: 34/ for test: kms_lease
results: parsing output: 35/ for test: gem_exec_schedule
results: parsing output: 36/ for test: gem_reg_read
results: parsing output: 37/ for test: kms_dp_linktrain_fallback
results: parsing output: 38/ for test: gem_tiled_blits
results: parsing output: 39/ for test: syncobj_timeline
results: parsing output: 40/ for test: gem_lmem_swapping
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: kms_hdr
results: parsing output: 43/ for test: kms_flip
results: parsing output: 44/ for test: kms_plane_scaling
results: parsing output: 45/ for test: prime_vgem
results: parsing output: 46/ for test: gem_render_copy
results: parsing output: 47/ for test: gem_ctx_isolation
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_big_fb
results: parsing output: 50/ for test: gem_spin_batch
results: parsing output: 51/ for test: kms_psr2_sf
results: parsing output: 52/ for test: perf_pmu
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_rotation_crc
results: parsing output: 55/ for test: prime_mmap
results: parsing output: 56/ for test: kms_cursor_crc
results: parsing output: 57/ for test: kms_cursor_legacy
results: parsing output: 58/ for test: gem_mmap_gtt
results: parsing output: 59/ for test: gem_softpin
results: parsing output: 60/ for test: sw_sync
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_pm_backlight
results: parsing output: 63/ for test: gem_exec_fence
results: parsing output: 64/ for test: syncobj_timeline
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: kms_content_protection
results: parsing output: 67/ for test: i915_pm_rps
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_close
results: parsing output: 71/ for test: kms_psr
results: parsing output: 72/ for test: kms_vblank
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: gem_userptr_blits
results: parsing output: 75/ for test: syncobj_timeline
results: parsing output: 76/ for test: kms_psr
results: parsing output: 77/ for test: kms_flip_scaled_crc
results: parsing output: 78/ for test: kms_ccs
results: parsing output: 79/ for test: kms_cursor_crc
results: parsing output: 80/ for test: syncobj_wait
results: parsing output: 81/ for test: gem_sync
results: parsing output: 82/ for test: kms_big_fb
results: parsing output: 83/ for test: gem_mmap_gtt
results: parsing output: 84/ for test: kms_psr
results: parsing output: 85/ for test: gem_lmem_swapping
results: parsing output: 86/ for test: gem_pread
results: parsing output: 87/ for test: kms_rotation_crc
results: parsing output: 88/ for test: gem_softpin
results: parsing output: 89/ for test: i915_drm_fdinfo
results: parsing output: 90/ for test: gem_render_copy
results: parsing output: 91/ for test: gem_watchdog
results: parsing output: 92/ for test: syncobj_timeline
results: parsing output: 93/ for test: gem_mmap_gtt
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: gem_flink_basic
results: parsing output: 96/ for test: kms_cursor_legacy
results: parsing output: 97/ for test: gem_flink_basic
results: parsing output: 98/ for test: gen9_exec_parse
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: api_intel_allocator
results: parsing output: 101/ for test: gem_exec_balancer
results: parsing output: 102/ for test: kms_ccs
results: parsing output: 103/ for test: gem_ctx_create
results: parsing output: 104/ for test: syncobj_wait
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_ctx_shared
results: parsing output: 108/ for test: kms_cdclk
results: parsing output: 109/ for test: kms_prop_blob
results: parsing output: 110/ for test: gem_exec_params
results: parsing output: 111/ for test: gem_create
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_ccs
results: parsing output: 114/ for test: kms_feature_discovery
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: kms_psr
results: parsing output: 118/ for test: kms_universal_plane
results: parsing output: 119/ for test: kms_plane
results: parsing output: 120/ for test: kms_flip
results: parsing output: 121/ for test: gem_exec_schedule
results: parsing output: 122/ for test: gem_render_copy
results: parsing output: 123/ for test: kms_vblank
results: parsing output: 124/ for test: gem_mmap
results: parsing output: 125/ for test: gem_reg_read
results: parsing output: 126/ for test: kms_flip
results: parsing output: 127/ for test: kms_ccs
results: parsing output: 128/ for test: i915_query
results: parsing output: 129/ for test: gem_close_race
results: parsing output: 130/ for test: i915_drm_fdinfo
results: parsing output: 131/ for test: kms_psr2_sf
results: parsing output: 132/ for test: api_intel_bb
results: parsing output: 133/ for test: gem_workarounds
Done.