[60.220112] Initializing watchdogs
[60.220160]   /dev/watchdog0
[60.234363] [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.238853] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.241026] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.244292] [001/134] (960s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[60.406730] Starting subtest: 2x-long-cursor-vs-flip-atomic
[60.411289] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[60.564989] [002/134] (960s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[60.658422] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[60.662490] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[60.799099] [003/134] (960s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[60.899242] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[60.903268] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[61.023994] [004/134] (959s left) kms_big_fb (linear-64bpp-rotate-180)
[61.122266] Starting subtest: linear-64bpp-rotate-180
[62.738244] Subtest linear-64bpp-rotate-180: SUCCESS (1.622s)
[62.960205] [005/134] (957s left) gem_render_copy (y-tiled-to-vebox-linear)
[63.024634] Starting subtest: y-tiled-to-vebox-linear
[63.029087] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[63.224238] [006/134] (957s left) kms_atomic (atomic-plane-damage)
[63.317592] Starting subtest: atomic-plane-damage
[63.365795] Starting dynamic subtest: pipe-A-eDP-1
[63.902044] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.539s)
[63.904391] Subtest atomic-plane-damage: SUCCESS (0.588s)
[64.753538] [007/134] (956s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[65.029557] Starting subtest: cursor-rapid-movement-max-size
[65.036311] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[65.190502] [008/134] (955s left) syncobj_timeline (device-submit-unordered)
[65.259994] Starting subtest: device-submit-unordered
[65.262273] Subtest device-submit-unordered: SUCCESS (0.000s)
[65.418806] [009/134] (955s left) kms_async_flips (async-flip-dpms)
[65.524607] Starting subtest: async-flip-dpms
[65.903982] Starting dynamic subtest: pipe-A-eDP-1
[69.751713] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.855s)
[70.144461] Starting dynamic subtest: pipe-B-eDP-1
[73.008832] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.877s)
[73.387856] Starting dynamic subtest: pipe-C-eDP-1
[76.183679] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.806s)
[76.556385] Starting dynamic subtest: pipe-D-eDP-1
[79.339829] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.791s)
[79.342098] Subtest async-flip-dpms: SUCCESS (13.830s)
[80.535323] [010/134] (940s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[80.625299] Starting subtest: coverage-vs-premult-vs-constant
[80.911539] Starting dynamic subtest: pipe-A-eDP-1
[81.532410] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.620s)
[81.541700] Starting dynamic subtest: pipe-D-eDP-1
[82.830086] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.297s)
[82.832489] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.205s)
[83.702429] [011/134] (937s left) fbdev (nullptr)
[83.743423] Starting subtest: nullptr
[83.745711] Subtest nullptr: SUCCESS (0.000s)
[83.825923] [012/134] (937s left) kms_color (ctm-0-25)
[83.907805] Starting subtest: ctm-0-25
[83.909605] Starting dynamic subtest: pipe-A-eDP-1
[87.502414] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.594s)
[87.509826] Starting dynamic subtest: pipe-B-eDP-1
[91.690033] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.187s)
[91.702805] Starting dynamic subtest: pipe-C-eDP-1
[95.739477] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.049s)
[95.748856] Starting dynamic subtest: pipe-D-eDP-1
[99.740751] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.000s)
[99.742967] Subtest ctm-0-25: SUCCESS (15.833s)
[100.581449] [013/134] (920s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render)
[100.690405] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render
[105.025092] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.337s)
[106.213785] [014/134] (915s left) vgem_basic (mmap)
[106.311200] Starting subtest: mmap
[106.315870] Subtest mmap: SUCCESS (0.005s)
[106.388184] [FACT vgem_basic (mmap)] new: kernel.kmod_is_loaded.vgem: true
[106.391210] [015/134] (914s left) gem_mmap_offset (mmap-unmap)
[106.443032] Starting subtest: mmap-unmap
[106.444977] Starting dynamic subtest: smem0
[129.892109] Dynamic subtest smem0: SUCCESS (23.449s)
[129.894760] Subtest mmap-unmap: SUCCESS (23.450s)
[130.041732] [016/134] (891s left) kms_properties (invalid-properties-legacy)
[130.146488] Starting subtest: invalid-properties-legacy
[130.254070] Subtest invalid-properties-legacy: SUCCESS (0.108s)
[130.348267] [017/134] (891s left) dumb_buffer (invalid-bpp)
[130.411183] Starting subtest: invalid-bpp
[130.413162] Subtest invalid-bpp: SUCCESS (0.000s)
[130.548587] [018/134] (890s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling)
[130.637297] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling
[130.639633] Starting dynamic subtest: pipe-A-default-mode
[130.930119] Dynamic subtest pipe-A-default-mode: SKIP (0.290s)
[130.934816] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SKIP (0.292s)
[131.830507] [019/134] (889s left) kms_psr (fbc-pr-sprite-plane-move)
[131.925935] Starting subtest: fbc-pr-sprite-plane-move
[131.930274] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[132.024402] [020/134] (889s left) gem_fenced_exec_thrash (no-spare-fences)
[132.101283] Subtest no-spare-fences: SKIP (0.000s)
[132.193120] [021/134] (889s left) perf (create-destroy-userspace-config)
[132.338079] Starting subtest: create-destroy-userspace-config
[132.355347] Subtest create-destroy-userspace-config: SUCCESS (0.017s)
[132.405296] [022/134] (889s left) kms_chamelium_frames (hdmi-crc-fast)
[132.795168] Subtest hdmi-crc-fast: SKIP (0.000s)
[133.616153] [023/134] (887s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[133.722041] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[133.726653] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[133.856046] [024/134] (887s left) i915_selftest (live)
[137.257920] Starting subtest: live
[137.260648] Starting dynamic subtest: sanitycheck
[141.723547] Dynamic subtest sanitycheck: SUCCESS (4.465s)
[141.732493] Starting dynamic subtest: uncore
[146.185386] Dynamic subtest uncore: SUCCESS (4.460s)
[146.194045] Starting dynamic subtest: workarounds
[149.503584] Dynamic subtest workarounds: SUCCESS (3.316s)
[149.512553] Starting dynamic subtest: gt_engines
[152.710090] Dynamic subtest gt_engines: SUCCESS (3.205s)
[152.719228] Starting dynamic subtest: gt_timelines
[170.497831] Dynamic subtest gt_timelines: SUCCESS (17.785s)
[170.506709] Starting dynamic subtest: gt_contexts
[175.006673] Dynamic subtest gt_contexts: SUCCESS (4.507s)
[175.015667] Starting dynamic subtest: gt_lrc
[181.252794] Dynamic subtest gt_lrc: SUCCESS (6.244s)
[181.260934] Starting dynamic subtest: gt_mocs
[184.381277] Dynamic subtest gt_mocs: SUCCESS (3.127s)
[184.389817] Starting dynamic subtest: gt_pm
[191.326765] Dynamic subtest gt_pm: SUCCESS (6.943s)
[191.336033] Starting dynamic subtest: gt_heartbeat
[195.831800] Dynamic subtest gt_heartbeat: SUCCESS (4.504s)
[195.840390] Starting dynamic subtest: gt_tlb
[205.308304] Dynamic subtest gt_tlb: SUCCESS (9.474s)
[205.316945] Starting dynamic subtest: requests
[217.203655] Dynamic subtest requests: SUCCESS (11.893s)
[217.217453] Starting dynamic subtest: migrate
[225.290442] Dynamic subtest migrate: SUCCESS (8.085s)
[225.299222] Starting dynamic subtest: active
[229.785215] Dynamic subtest active: SUCCESS (4.492s)
[229.794281] Starting dynamic subtest: objects
[234.633271] Dynamic subtest objects: SUCCESS (4.846s)
[234.642634] Starting dynamic subtest: mman
[239.518381] Dynamic subtest mman: SUCCESS (4.883s)
[239.527245] Starting dynamic subtest: dmabuf
[243.995410] Dynamic subtest dmabuf: SUCCESS (4.474s)
[244.004230] Starting dynamic subtest: vma
[248.483353] Dynamic subtest vma: SUCCESS (4.486s)
[248.492449] Starting dynamic subtest: coherency
[252.246792] Dynamic subtest coherency: SUCCESS (3.761s)
[252.255769] Starting dynamic subtest: gtt
[262.235623] Dynamic subtest gtt: SUCCESS (9.986s)
[262.244787] Starting dynamic subtest: gem
[270.786451] Dynamic subtest gem: SUCCESS (8.549s)
[270.795620] Starting dynamic subtest: evict
[276.408611] Dynamic subtest evict: SUCCESS (5.620s)
[276.417758] Starting dynamic subtest: hugepages
[285.613148] Dynamic subtest hugepages: SUCCESS (9.175s)
[285.622244] Starting dynamic subtest: gem_contexts
[314.237581] Dynamic subtest gem_contexts: SUCCESS (28.648s)
[314.246956] Starting dynamic subtest: client
[317.213397] Dynamic subtest client: SUCCESS (2.975s)
[317.228024] Starting dynamic subtest: gem_migrate
[321.795524] Dynamic subtest gem_migrate: SUCCESS (4.581s)
[321.804731] Starting dynamic subtest: reset
[326.302575] Dynamic subtest reset: SUCCESS (4.503s)
[326.313966] Starting dynamic subtest: memory_region
[330.878589] Dynamic subtest memory_region: SUCCESS (4.573s)
[330.887679] Starting dynamic subtest: hangcheck
[343.927485] Dynamic subtest hangcheck: SUCCESS (13.047s)
[343.936405] Starting dynamic subtest: execlists
[348.430891] Dynamic subtest execlists: SUCCESS (4.501s)
[348.439290] Starting dynamic subtest: ring_submission
[352.830246] Dynamic subtest ring_submission: SUCCESS (4.398s)
[352.839213] Starting dynamic subtest: perf
[357.342366] Dynamic subtest perf: SUCCESS (4.509s)
[357.350719] Starting dynamic subtest: slpc
[371.444210] Dynamic subtest slpc: SUCCESS (14.100s)
[371.453017] Starting dynamic subtest: guc
[375.524102] Dynamic subtest guc: SUCCESS (4.053s)
[375.532880] Starting dynamic subtest: guc_multi_lrc
[378.382635] Dynamic subtest guc_multi_lrc: SUCCESS (2.881s)
[378.391236] Starting dynamic subtest: guc_hang
[383.446593] Dynamic subtest guc_hang: SUCCESS (5.062s)
[383.455834] Starting dynamic subtest: late_gt_pm
[387.938063] Dynamic subtest late_gt_pm: SUCCESS (4.489s)
[387.940571] Subtest live: SUCCESS (250.673s)
[387.967236] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[387.967956] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[387.971174] [025/134] (633s left) kms_pm_rpm (modeset-non-lpsp-stress)
[394.341891] Starting subtest: modeset-non-lpsp-stress
[395.489783] Subtest modeset-non-lpsp-stress: SKIP (1.145s)
[395.927119] [FACT kms_pm_rpm (modeset-non-lpsp-stress)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[395.928325] [FACT kms_pm_rpm (modeset-non-lpsp-stress)] new: kernel.kmod_is_loaded.i915: true
[395.932391] [026/134] (625s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted)
[395.995544] Starting subtest: invalid-multi-wait-all-unsubmitted
[395.997998] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[396.131782] [027/134] (625s left) gem_mmap_offset (perf)
[396.190504] Starting subtest: perf
[396.192668] Starting dynamic subtest: smem0
[396.555508] Dynamic subtest smem0: SUCCESS (0.365s)
[396.557523] Subtest perf: SUCCESS (0.365s)
[396.687079] [028/134] (625s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[396.775272] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[396.779433] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[396.915680] [029/134] (624s left) gem_exec_balancer (parallel-balancer)
[397.184911] Starting subtest: parallel-balancer
[398.079612] Subtest parallel-balancer: SUCCESS (0.894s)
[398.218750] [030/134] (623s left) kms_chamelium_hpd (hdmi-hpd)
[398.603274] Subtest hdmi-hpd: SKIP (0.000s)
[399.381523] [031/134] (622s left) gem_exec_whisper (basic-fds-priority)
[399.459568] Starting subtest: basic-fds-priority
[423.414520] Subtest basic-fds-priority: SUCCESS (23.953s)
[423.625473] [032/134] (598s left) kms_lease (cursor-implicit-plane)
[423.733060] Starting subtest: cursor-implicit-plane
[423.735303] Starting dynamic subtest: pipe-A-eDP-1
[424.201054] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.466s)
[424.209854] Starting dynamic subtest: pipe-B-eDP-1
[425.326810] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.125s)
[425.335462] Starting dynamic subtest: pipe-C-eDP-1
[426.456704] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.128s)
[426.465377] Starting dynamic subtest: pipe-D-eDP-1
[427.577482] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.120s)
[427.579961] Subtest cursor-implicit-plane: SUCCESS (3.846s)
[428.460286] [033/134] (593s left) vgem_basic (bad-handle)
[428.509414] Starting subtest: bad-handle
[428.511254] Subtest bad-handle: SUCCESS (0.000s)
[428.590412] [034/134] (593s left) gem_ctx_persistence (heartbeat-hang)
[428.647348] Starting subtest: heartbeat-hang
[428.652244] Subtest heartbeat-hang: SKIP (0.000s)
[428.781971] [035/134] (593s left) kms_lease (setcrtc-implicit-plane)
[428.881698] Starting subtest: setcrtc-implicit-plane
[428.883981] Starting dynamic subtest: pipe-A-eDP-1
[429.374374] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.491s)
[429.389532] Starting dynamic subtest: pipe-B-eDP-1
[430.502595] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.127s)
[430.512469] Starting dynamic subtest: pipe-C-eDP-1
[431.602568] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.099s)
[431.611920] Starting dynamic subtest: pipe-D-eDP-1
[432.743355] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.139s)
[432.745618] Subtest setcrtc-implicit-plane: SUCCESS (3.863s)
[433.624914] [036/134] (588s left) gem_exec_schedule (submit-early-slice)
[433.700871] Starting subtest: submit-early-slice
[433.703293] Starting dynamic subtest: rcs0
[433.741786] Dynamic subtest rcs0: SUCCESS (0.043s)
[433.752675] Starting dynamic subtest: bcs0
[433.778648] Dynamic subtest bcs0: SUCCESS (0.036s)
[433.787720] Starting dynamic subtest: vcs0
[433.817190] Dynamic subtest vcs0: SUCCESS (0.038s)
[433.825476] Starting dynamic subtest: vcs1
[433.876864] Dynamic subtest vcs1: SUCCESS (0.059s)
[433.886962] Starting dynamic subtest: vecs0
[433.913514] Dynamic subtest vecs0: SUCCESS (0.035s)
[433.924158] Starting dynamic subtest: ccs0
[433.948372] Dynamic subtest ccs0: SUCCESS (0.035s)
[433.950734] Subtest submit-early-slice: SUCCESS (0.250s)
[435.024525] [037/134] (587s left) gem_reg_read (timestamp-moving)
[435.096582] Starting subtest: timestamp-moving
[436.096083] Subtest timestamp-moving: SUCCESS (1.001s)
[436.203714] [038/134] (586s left) kms_dp_linktrain_fallback (dsc-fallback)
[436.298750] Starting subtest: dsc-fallback
[436.305052] Subtest dsc-fallback: SKIP (0.000s)
[436.396391] [039/134] (585s left) gem_tiled_blits (basic)
[436.461035] Subtest basic: SKIP (0.000s)
[436.535485] [040/134] (585s left) syncobj_timeline (wait-delayed-signal)
[436.591185] Starting subtest: wait-delayed-signal
[436.692391] Subtest wait-delayed-signal: SUCCESS (0.102s)
[436.794098] [041/134] (585s left) gem_lmem_swapping (massive)
[436.835914] Subtest massive: SKIP (0.000s)
[436.878376] [042/134] (585s left) kms_big_fb (4-tiled-addfb-size-overflow)
[436.999072] Starting subtest: 4-tiled-addfb-size-overflow
[437.001275] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s)
[437.136870] [043/134] (585s left) kms_hdr (static-swap)
[437.229036] Starting subtest: static-swap
[437.234453] Subtest static-swap: SKIP (0.000s)
[437.327387] [044/134] (585s left) kms_flip (plain-flip-ts-check)
[437.410508] Starting subtest: plain-flip-ts-check
[437.412501] Starting dynamic subtest: A-eDP1
[446.278757] Dynamic subtest A-eDP1: SUCCESS (8.867s)
[446.287236] Starting dynamic subtest: B-eDP1
[455.122757] Dynamic subtest B-eDP1: SUCCESS (8.843s)
[455.131409] Starting dynamic subtest: C-eDP1
[463.949395] Dynamic subtest C-eDP1: SUCCESS (8.825s)
[463.958982] Starting dynamic subtest: D-eDP1
[472.785101] Dynamic subtest D-eDP1: SUCCESS (8.834s)
[472.787423] Subtest plain-flip-ts-check: SUCCESS (35.377s)
[473.984852] [045/134] (548s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[474.072064] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[474.074409] Starting dynamic subtest: pipe-A
[474.299829] Dynamic subtest pipe-A: SUCCESS (0.230s)
[474.308344] Starting dynamic subtest: pipe-B
[475.656196] Dynamic subtest pipe-B: SUCCESS (1.356s)
[475.665376] Starting dynamic subtest: pipe-C
[476.999817] Dynamic subtest pipe-C: SUCCESS (1.341s)
[477.010424] Starting dynamic subtest: pipe-D
[478.309476] Dynamic subtest pipe-D: SUCCESS (1.308s)
[478.311831] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.240s)
[479.501623] [046/134] (543s left) prime_vgem (busy)
[479.605749] Starting subtest: busy
[479.608264] Starting dynamic subtest: rcs0
[479.682123] Dynamic subtest rcs0: SUCCESS (0.076s)
[479.693241] Starting dynamic subtest: bcs0
[479.776100] Dynamic subtest bcs0: SUCCESS (0.091s)
[479.784619] Starting dynamic subtest: vcs0
[479.824198] Dynamic subtest vcs0: SUCCESS (0.046s)
[479.832302] Starting dynamic subtest: vcs1
[479.869045] Dynamic subtest vcs1: SUCCESS (0.044s)
[479.877416] Starting dynamic subtest: vecs0
[479.914268] Dynamic subtest vecs0: SUCCESS (0.044s)
[479.922489] Starting dynamic subtest: ccs0
[479.960412] Dynamic subtest ccs0: SUCCESS (0.045s)
[479.962604] Subtest busy: SUCCESS (0.355s)
[480.121948] [047/134] (542s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[480.185617] Starting subtest: mixed-tiled-to-y-tiled-ccs
[480.190162] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[480.394565] [048/134] (542s left) gem_ctx_isolation (clean)
[480.443833] Starting subtest: clean
[480.446146] Starting dynamic subtest: rcs0
[480.512258] Dynamic subtest rcs0: SUCCESS (0.068s)
[480.523457] Starting dynamic subtest: bcs0
[480.584188] Dynamic subtest bcs0: SUCCESS (0.071s)
[480.594873] Starting dynamic subtest: vcs0
[480.663812] Dynamic subtest vcs0: SUCCESS (0.079s)
[480.674819] Starting dynamic subtest: vcs1
[481.948325] Dynamic subtest vcs1: SUCCESS (1.284s)
[481.958765] Starting dynamic subtest: vecs0
[483.968593] Dynamic subtest vecs0: SUCCESS (2.018s)
[483.976795] Starting dynamic subtest: ccs0
[485.920900] Dynamic subtest ccs0: SUCCESS (1.952s)
[485.923428] Subtest clean: SUCCESS (5.477s)
[486.193091] [049/134] (536s left) kms_frontbuffer_tracking (psr-abgr161616f-draw-render)
[486.302086] Starting subtest: psr-abgr161616f-draw-render
[486.306425] Subtest psr-abgr161616f-draw-render: SKIP (0.000s)
[486.433682] [050/134] (536s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[486.546931] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[487.592618] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.045s)
[487.748828] [051/134] (534s left) gem_spin_batch (legacy)
[487.817196] Starting subtest: legacy
[487.819140] Starting dynamic subtest: default
[491.057026] Dynamic subtest default: SUCCESS (3.234s)
[491.068175] Starting dynamic subtest: render
[494.292174] Dynamic subtest render: SUCCESS (3.232s)
[494.303170] Starting dynamic subtest: bsd
[497.531338] Dynamic subtest bsd: SUCCESS (3.235s)
[497.540586] Starting dynamic subtest: bsd1
[500.764975] Dynamic subtest bsd1: SUCCESS (3.231s)
[500.775631] Starting dynamic subtest: bsd2
[504.001851] Dynamic subtest bsd2: SUCCESS (3.234s)
[504.012263] Starting dynamic subtest: blt
[507.242377] Dynamic subtest blt: SUCCESS (3.238s)
[507.251122] Starting dynamic subtest: vebox
[510.490666] Dynamic subtest vebox: SUCCESS (3.231s)
[510.494677] Subtest legacy: SUCCESS (22.655s)
[511.038958] [052/134] (511s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[516.081780] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf
[516.086472] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.003s)
[516.949768] [053/134] (505s left) perf_pmu (init-busy)
[516.995786] Starting subtest: init-busy
[516.998087] Starting dynamic subtest: rcs0
[517.000382] Dynamic subtest rcs0: SUCCESS (0.001s)
[517.010132] Starting dynamic subtest: bcs0
[517.011978] Dynamic subtest bcs0: SUCCESS (0.000s)
[517.019938] Starting dynamic subtest: vcs0
[517.021872] Dynamic subtest vcs0: SUCCESS (0.001s)
[517.029533] Starting dynamic subtest: vcs1
[517.031453] Dynamic subtest vcs1: SUCCESS (0.001s)
[517.039228] Starting dynamic subtest: vecs0
[517.041076] Dynamic subtest vecs0: SUCCESS (0.000s)
[517.048603] Starting dynamic subtest: ccs0
[517.050478] Dynamic subtest ccs0: SUCCESS (0.000s)
[517.052349] Subtest init-busy: SUCCESS (0.007s)
[517.144650] [054/134] (505s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-blt)
[517.246586] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-blt
[517.250985] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[517.383636] [055/134] (505s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[517.498221] Starting subtest: primary-y-tiled-reflect-x-90
[517.502293] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s)
[517.594916] [056/134] (505s left) prime_mmap (test_correct)
[517.654798] Starting subtest: test_correct
[517.657140] Starting dynamic subtest: test_correct-smem
[517.688120] Dynamic subtest test_correct-smem: SUCCESS (0.033s)
[517.690490] Subtest test_correct: SUCCESS (0.034s)
[517.819619] [057/134] (505s left) kms_cursor_crc (cursor-sliding-max-size)
[518.123838] Starting subtest: cursor-sliding-max-size
[518.129265] Subtest cursor-sliding-max-size: SKIP (0.000s)
[518.301234] [058/134] (504s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[518.425482] Starting subtest: cursorB-vs-flipA-legacy
[518.429242] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[518.595593] [059/134] (504s left) gem_mmap_gtt (basic-wc)
[518.641985] Subtest basic-wc: SKIP (0.000s)
[518.713527] [060/134] (504s left) gem_softpin (noreloc)
[518.777362] Starting subtest: noreloc
[524.204402] Subtest noreloc: SUCCESS (5.426s)
[524.429810] [061/134] (498s left) sw_sync (alloc_timeline)
[524.471285] Starting subtest: alloc_timeline
[524.473375] Subtest alloc_timeline: SUCCESS (0.000s)
[524.564442] [062/134] (498s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[524.669433] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[524.673463] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[524.804872] [063/134] (498s left) kms_pm_backlight (bad-brightness)
[524.899182] Starting subtest: bad-brightness
[524.952746] Starting dynamic subtest: eDP-1
[525.260841] Dynamic subtest eDP-1: SUCCESS (0.310s)
[525.263196] Subtest bad-brightness: SUCCESS (0.364s)
[526.077575] [064/134] (497s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[526.642045] Starting subtest: syncobj-timeline-invalid-wait
[526.644496] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.004s)
[528.030681] [065/134] (495s left) syncobj_timeline (signal-point-0)
[528.099645] Starting subtest: signal-point-0
[528.101977] Subtest signal-point-0: SUCCESS (0.000s)
[528.229860] [066/134] (495s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0-hflip)
[528.347513] Starting subtest: linear-max-hw-stride-32bpp-rotate-0-hflip
[528.351984] Subtest linear-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[528.472739] [067/134] (494s left) kms_content_protection (atomic)
[528.618794] Starting subtest: atomic
[528.623386] Subtest atomic: SKIP (0.000s)
[528.789157] [068/134] (494s left) i915_pm_rps (reset)
[528.858575] Starting subtest: reset
[537.323331] Subtest reset: SUCCESS (8.461s)
[537.483399] [069/134] (486s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[537.592440] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[546.247950] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.658s)
[546.396130] [070/134] (477s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[546.504529] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[553.557322] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.054s)
[553.675425] [071/134] (469s left) gem_close (many-handles-one-vma)
[553.748732] Starting subtest: many-handles-one-vma
[553.772131] Subtest many-handles-one-vma: SUCCESS (0.025s)
[553.944282] [072/134] (469s left) kms_psr (fbc-psr-sprite-render)
[554.041797] Starting subtest: fbc-psr-sprite-render
[554.044094] Starting dynamic subtest: eDP-1
[554.048240] Dynamic subtest eDP-1: SKIP (0.000s)
[554.052294] Subtest fbc-psr-sprite-render: SKIP (0.001s)
[554.141641] [073/134] (469s left) kms_vblank (wait-idle-hang)
[554.238183] Starting subtest: wait-idle-hang
[554.240049] Starting dynamic subtest: pipe-A-eDP-1
[580.710360] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.470s)
[580.723814] Starting dynamic subtest: pipe-D-eDP-1
[595.671516] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.954s)
[595.673541] Subtest wait-idle-hang: SUCCESS (41.430s)
[596.566080] [074/134] (427s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[596.666366] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[596.670351] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[596.803512] [075/134] (426s left) gem_userptr_blits (create-destroy-unsync)
[596.877238] Subtest create-destroy-unsync: SKIP (0.000s)
[597.026243] [076/134] (426s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[597.084994] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[597.186546] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.101s)
[597.288510] [077/134] (426s left) kms_psr (psr2-cursor-blt)
[597.389882] Starting subtest: psr2-cursor-blt
[597.392232] Starting dynamic subtest: eDP-1
[599.114291] Dynamic subtest eDP-1: SUCCESS (1.722s)
[599.116252] Subtest psr2-cursor-blt: SUCCESS (1.723s)
[599.935312] [078/134] (423s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[600.035839] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[600.038067] Starting dynamic subtest: pipe-A-default-mode
[600.329848] Dynamic subtest pipe-A-default-mode: SKIP (0.292s)
[600.334584] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.294s)
[601.160544] [079/134] (422s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[601.261725] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[601.263907] Starting dynamic subtest: pipe-A-eDP-1
[601.283789] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.021s)
[601.293593] Starting dynamic subtest: pipe-B-eDP-1
[601.313389] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.019s)
[601.322366] Starting dynamic subtest: pipe-C-eDP-1
[601.343598] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.019s)
[601.354483] Starting dynamic subtest: pipe-D-eDP-1
[601.374160] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.019s)
[601.376203] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.083s)
[603.617240] [080/134] (420s left) kms_cursor_crc (cursor-onscreen-512x170)
[603.921217] Starting subtest: cursor-onscreen-512x170
[603.925652] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[604.105065] [081/134] (419s left) syncobj_wait (invalid-reset-illegal-handle)
[604.166833] Starting subtest: invalid-reset-illegal-handle
[604.168796] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[604.287152] [082/134] (419s left) gem_sync (basic-store-all)
[604.357387] Starting subtest: basic-store-all
[608.786953] Subtest basic-store-all: SUCCESS (4.441s)
[608.999787] [083/134] (415s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[609.134134] Starting subtest: y-tiled-64bpp-rotate-0
[609.138620] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[609.276393] [084/134] (414s left) gem_mmap_gtt (basic)
[609.328668] Subtest basic: SKIP (0.000s)
[609.402125] [085/134] (414s left) kms_psr (psr-dpms)
[609.493834] Starting subtest: psr-dpms
[609.496103] Starting dynamic subtest: eDP-1
[612.431427] Dynamic subtest eDP-1: SUCCESS (2.935s)
[612.433682] Subtest psr-dpms: SUCCESS (2.936s)
[613.311844] [086/134] (410s left) gem_lmem_swapping (verify-ccs)
[613.357475] Subtest verify-ccs: SKIP (0.000s)
[613.401321] [087/134] (410s left) gem_pread (snoop)
[613.457688] Subtest snoop: SKIP (0.000s)
[613.525626] [088/134] (410s left) kms_rotation_crc (exhaust-fences)
[613.620524] Starting subtest: exhaust-fences
[613.624749] Subtest exhaust-fences: SKIP (0.000s)
[613.718634] [089/134] (410s left) gem_softpin (softpin)
[613.781380] Starting subtest: softpin
[646.166338] Subtest softpin: SUCCESS (32.379s)
[646.331407] [090/134] (378s left) i915_drm_fdinfo (virtual-busy-hang-all)
[646.369229] Starting subtest: virtual-busy-hang-all
[646.373286] Subtest virtual-busy-hang-all: SKIP (0.000s)
[646.465595] [091/134] (377s left) gem_render_copy (y-tiled-ccs-to-linear)
[646.520976] Starting subtest: y-tiled-ccs-to-linear
[646.525508] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[646.738477] [092/134] (377s left) gem_watchdog (default-physical)
[646.815745] Starting subtest: default-physical
[648.580161] Subtest default-physical: SUCCESS (1.775s)
[648.700655] [093/134] (375s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[648.759237] Starting subtest: multi-wait-available-unsubmitted-submitted
[648.761413] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[648.900133] [094/134] (375s left) gem_mmap_gtt (basic-short)
[648.972460] Subtest basic-short: SKIP (0.000s)
[649.046813] [095/134] (375s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[649.148299] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[649.152338] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[649.273967] [096/134] (375s left) gem_flink_basic (bad-open)
[649.345433] Starting subtest: bad-open
[649.347578] Subtest bad-open: SUCCESS (0.000s)
[649.482792] [097/134] (375s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[649.610490] Starting subtest: cursor-vs-flip-toggle
[680.505398] Subtest cursor-vs-flip-toggle: SUCCESS (30.891s)
[681.336141] [098/134] (343s left) gem_flink_basic (double-flink)
[681.408689] Starting subtest: double-flink
[681.410696] Subtest double-flink: SUCCESS (0.000s)
[681.540536] [099/134] (343s left) gen9_exec_parse (batch-zero-length)
[681.616894] Subtest batch-zero-length: SKIP (0.000s)
[681.706102] [100/134] (343s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[681.813348] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[681.817246] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[681.935129] [101/134] (342s left) api_intel_allocator (simple-allocator)
[682.001059] Starting subtest: simple-allocator
[682.003137] Starting dynamic subtest: basic
[682.005429] Dynamic subtest basic: SUCCESS (0.006s)
[682.020471] Starting dynamic subtest: parallel-one
[682.191302] Dynamic subtest parallel-one: SUCCESS (0.184s)
[682.202859] Starting dynamic subtest: print
[682.204763] Dynamic subtest print: SUCCESS (0.000s)
[682.213789] Starting dynamic subtest: reuse
[682.216040] Dynamic subtest reuse: SUCCESS (0.000s)
[682.224665] Starting dynamic subtest: reserve
[682.226914] Dynamic subtest reserve: SUCCESS (0.000s)
[682.236690] Starting dynamic subtest: fork-reopen-allocator
[682.238956] Dynamic subtest fork-reopen-allocator: SUCCESS (0.013s)
[682.241251] Subtest simple-allocator: SUCCESS (0.212s)
[682.392540] [102/134] (342s left) gem_exec_balancer (parallel-keep-in-fence)
[682.649763] Starting subtest: parallel-keep-in-fence
[683.775309] Subtest parallel-keep-in-fence: SUCCESS (1.125s)
[683.921786] [103/134] (341s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs)
[684.022366] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs
[684.024690] Starting dynamic subtest: pipe-A-eDP-1
[684.046352] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[684.058473] Starting dynamic subtest: pipe-B-eDP-1
[684.079095] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[684.088849] Starting dynamic subtest: pipe-C-eDP-1
[684.109193] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[684.117318] Starting dynamic subtest: pipe-D-eDP-1
[684.138804] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[684.143098] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.008s)
[686.287109] [104/134] (338s left) gem_ctx_create (basic)
[686.348324] Starting subtest: basic
[686.350765] Subtest basic: SUCCESS (0.000s)
[686.559428] [105/134] (338s left) syncobj_wait (invalid-reset-zero-handles)
[686.611691] Starting subtest: invalid-reset-zero-handles
[686.614045] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[686.736454] [106/134] (338s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[686.843979] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[686.848245] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[686.978201] [107/134] (338s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[687.088511] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[694.675541] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.587s)
[694.952139] [108/134] (330s left) gem_ctx_shared (detached-shared-gtt)
[695.099117] Starting subtest: detached-shared-gtt
[697.252812] Subtest detached-shared-gtt: SUCCESS (2.152s)
[697.592391] [109/134] (327s left) kms_cdclk (mode-transition)
[697.702973] Starting subtest: mode-transition
[697.705311] Starting dynamic subtest: pipe-A-eDP-1
[697.998071] Dynamic subtest pipe-A-eDP-1: SKIP (0.294s)
[698.007738] Starting dynamic subtest: pipe-B-eDP-1
[698.012355] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[698.021447] Starting dynamic subtest: pipe-C-eDP-1
[698.026089] Dynamic subtest pipe-C-eDP-1: SKIP (0.003s)
[698.034973] Starting dynamic subtest: pipe-D-eDP-1
[698.039660] Dynamic subtest pipe-D-eDP-1: SKIP (0.003s)
[698.044180] Subtest mode-transition: SKIP (0.306s)
[698.831197] [110/134] (326s left) kms_prop_blob (invalid-set-prop)
[698.894465] Starting subtest: invalid-set-prop
[698.896903] Subtest invalid-set-prop: SUCCESS (0.000s)
[699.032240] [111/134] (326s left) gem_exec_params (rs-invalid)
[699.098854] Starting subtest: rs-invalid
[699.104682] Subtest rs-invalid: SUCCESS (0.004s)
[699.289914] [112/134] (326s left) gem_create (create-valid-nonaligned)
[699.349241] Starting subtest: create-valid-nonaligned
[699.351589] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[699.558614] [113/134] (325s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[699.655127] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[707.145906] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.492s)
[707.294569] [114/134] (318s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[707.394110] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[707.396433] Starting dynamic subtest: pipe-A-eDP-1
[707.419538] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[707.431287] Starting dynamic subtest: pipe-B-eDP-1
[707.452921] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[707.462474] Starting dynamic subtest: pipe-C-eDP-1
[707.485105] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[707.495827] Starting dynamic subtest: pipe-D-eDP-1
[707.517358] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[707.521911] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[709.720723] [115/134] (315s left) kms_feature_discovery (dp-mst)
[709.838057] Starting subtest: dp-mst
[709.842629] Subtest dp-mst: SKIP (0.000s)
[709.936510] [116/134] (315s left) kms_frontbuffer_tracking (fbc-abgr161616f-draw-mmap-cpu)
[710.040395] Starting subtest: fbc-abgr161616f-draw-mmap-cpu
[710.044726] Subtest fbc-abgr161616f-draw-mmap-cpu: SKIP (0.000s)
[710.173513] [117/134] (315s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[710.288485] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[710.292589] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[710.423198] [118/134] (315s left) kms_psr (fbc-psr-basic)
[710.521881] Starting subtest: fbc-psr-basic
[710.524130] Starting dynamic subtest: eDP-1
[710.528226] Dynamic subtest eDP-1: SKIP (0.000s)
[710.532284] Subtest fbc-psr-basic: SKIP (0.001s)
[710.623170] [119/134] (315s left) kms_universal_plane (universal-plane-functional)
[710.727442] Starting subtest: universal-plane-functional
[710.729112] Starting dynamic subtest: pipe-A-eDP-1
[714.712251] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.985s)
[714.728320] Starting dynamic subtest: pipe-B-eDP-1
[719.181665] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.464s)
[719.191633] Starting dynamic subtest: pipe-C-eDP-1
[723.503799] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.321s)
[723.513218] Starting dynamic subtest: pipe-D-eDP-1
[727.907436] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.403s)
[727.909816] Subtest universal-plane-functional: SUCCESS (17.180s)
[728.812851] [120/134] (296s left) kms_plane (planar-pixel-format-settings)
[728.925424] Starting subtest: planar-pixel-format-settings
[729.000283] Subtest planar-pixel-format-settings: SUCCESS (0.076s)
[729.167042] [121/134] (296s left) kms_flip (2x-flip-vs-panning)
[729.264331] Starting subtest: 2x-flip-vs-panning
[729.275768] Subtest 2x-flip-vs-panning: SKIP (0.011s)
[729.378460] [122/134] (296s left) gem_exec_schedule (implicit-write-read)
[729.452770] Starting subtest: implicit-write-read
[729.454703] Starting dynamic subtest: rcs0
[729.552728] Dynamic subtest rcs0: SUCCESS (0.110s)
[729.567238] Starting dynamic subtest: vcs0
[729.644117] Dynamic subtest vcs0: SUCCESS (0.091s)
[729.654625] Starting dynamic subtest: vcs1
[729.726836] Dynamic subtest vcs1: SUCCESS (0.082s)
[729.736137] Starting dynamic subtest: vecs0
[729.805197] Dynamic subtest vecs0: SUCCESS (0.077s)
[729.816514] Starting dynamic subtest: ccs0
[729.896037] Dynamic subtest ccs0: SUCCESS (0.090s)
[729.898625] Subtest implicit-write-read: SUCCESS (0.454s)
[731.040162] [123/134] (294s left) gem_render_copy (x-tiled)
[731.107015] Starting subtest: x-tiled
[731.109423] Starting dynamic subtest: smem
[731.149918] Dynamic subtest smem: SUCCESS (0.042s)
[731.152731] Subtest x-tiled: SUCCESS (0.043s)
[731.407582] [124/134] (294s left) kms_vblank (wait-forked-busy)
[731.509015] Starting subtest: wait-forked-busy
[731.511105] Starting dynamic subtest: pipe-A-eDP-1
[733.381714] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.874s)
[733.397454] Starting dynamic subtest: pipe-D-eDP-1
[735.949763] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.565s)
[735.952165] Subtest wait-forked-busy: SUCCESS (4.443s)
[736.763876] [125/134] (289s left) gem_mmap (big-bo)
[736.814649] Subtest big-bo: SKIP (0.000s)
[736.887574] [126/134] (289s left) gem_reg_read (bad-register)
[736.945436] Starting subtest: bad-register
[736.947678] Subtest bad-register: SUCCESS (0.000s)
[737.075573] [127/134] (288s left) kms_flip (nonexisting-fb)
[737.172520] Starting subtest: nonexisting-fb
[737.174532] Starting dynamic subtest: A-eDP1
[738.347368] Dynamic subtest A-eDP1: SUCCESS (1.177s)
[738.357441] Starting dynamic subtest: B-eDP1
[739.471522] Dynamic subtest B-eDP1: SUCCESS (1.123s)
[739.481292] Starting dynamic subtest: C-eDP1
[740.596699] Dynamic subtest C-eDP1: SUCCESS (1.124s)
[740.607065] Starting dynamic subtest: D-eDP1
[741.726839] Dynamic subtest D-eDP1: SUCCESS (1.129s)
[741.729153] Subtest nonexisting-fb: SUCCESS (4.561s)
[743.026936] [128/134] (283s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[743.133727] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs
[743.136132] Starting dynamic subtest: pipe-A-eDP-1
[743.159728] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[743.171749] Starting dynamic subtest: pipe-B-eDP-1
[743.193168] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[743.202307] Starting dynamic subtest: pipe-C-eDP-1
[743.224493] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[743.233517] Starting dynamic subtest: pipe-D-eDP-1
[743.256359] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[743.260874] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[745.315730] [129/134] (280s left) i915_query (query-topology-coherent-slice-mask)
[745.380719] Starting subtest: query-topology-coherent-slice-mask
[745.384987] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[745.519343] [130/134] (280s left) gem_close_race (multigpu-basic-process)
[745.582113] Starting subtest: multigpu-basic-process
[745.586661] Subtest multigpu-basic-process: SKIP (0.000s)
[745.855379] [131/134] (280s left) i915_drm_fdinfo (memory-info-idle)
[745.893609] Starting subtest: memory-info-idle
[745.895593] Starting dynamic subtest: smem0
[745.978247] Dynamic subtest smem0: SUCCESS (0.086s)
[745.980669] Subtest memory-info-idle: SUCCESS (0.087s)
[746.073045] [132/134] (280s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[751.059892] Starting subtest: psr2-cursor-plane-update-sf
[751.062154] Starting dynamic subtest: pipe-A-eDP-1
[752.391257] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.329s)
[752.400724] Starting dynamic subtest: pipe-B-eDP-1
[753.720655] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.327s)
[753.722955] Subtest psr2-cursor-plane-update-sf: SUCCESS (2.660s)
[754.618926] [133/134] (271s left) api_intel_bb (object-reloc-purge-cache)
[754.678612] Starting subtest: object-reloc-purge-cache
[754.682810] Subtest object-reloc-purge-cache: SKIP (0.003s)
[754.805148] [134/134] (271s left) gem_workarounds (reset)
[754.875725] Starting subtest: reset
[755.061746] Subtest reset: SUCCESS (0.185s)
[755.221136] 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.