[60.055156] Initializing watchdogs
[60.055206]   /dev/watchdog0
[60.068929] [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.073247] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.075507] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.079031] [001/131] (960s left) kms_cursor_legacy (cursora-vs-flipb-varying-size)
[60.218091] Starting subtest: cursorA-vs-flipB-varying-size
[60.222678] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s)
[60.358734] [002/131] (960s left) kms_vblank (query-forked-busy)
[60.445948] Starting subtest: query-forked-busy
[60.448306] Starting dynamic subtest: pipe-A-eDP-1
[62.350865] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.922s)
[62.362271] Starting dynamic subtest: pipe-D-eDP-1
[64.880848] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.548s)
[64.883207] Subtest query-forked-busy: SUCCESS (4.473s)
[65.666350] [003/131] (954s left) syncobj_timeline (transfer-timeline-point)
[65.731209] Starting subtest: transfer-timeline-point
[65.733681] Subtest transfer-timeline-point: SUCCESS (0.000s)
[65.832195] [004/131] (954s left) kms_cursor_crc (cursor-offscreen-512x170)
[66.111709] Starting subtest: cursor-offscreen-512x170
[66.116380] Subtest cursor-offscreen-512x170: SKIP (0.001s)
[66.265052] [005/131] (954s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[66.355074] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[74.255085] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.930s)
[74.375481] [006/131] (946s left) perf_pmu (busy-no-semaphores)
[74.412148] Starting subtest: busy-no-semaphores
[74.414650] Starting dynamic subtest: rcs0
[75.001609] Dynamic subtest rcs0: SUCCESS (0.588s)
[75.010907] Starting dynamic subtest: bcs0
[75.549866] Dynamic subtest bcs0: SUCCESS (0.549s)
[75.560075] Starting dynamic subtest: vcs0
[76.098379] Dynamic subtest vcs0: SUCCESS (0.548s)
[76.108761] Starting dynamic subtest: vcs1
[77.400242] Dynamic subtest vcs1: SUCCESS (1.302s)
[77.410897] Starting dynamic subtest: vecs0
[79.447858] Dynamic subtest vecs0: SUCCESS (2.050s)
[79.458774] Starting dynamic subtest: ccs0
[81.433810] Dynamic subtest ccs0: SUCCESS (1.987s)
[81.436836] Subtest busy-no-semaphores: SUCCESS (7.029s)
[81.547192] [007/131] (939s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[81.654341] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[88.125096] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.473s)
[88.271583] [008/131] (932s left) i915_module_load (resize-bar)
[88.309834] Starting subtest: resize-bar
[88.318871] Subtest resize-bar: SKIP (0.008s)
[88.361756] [009/131] (932s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[88.458903] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[88.461765] Starting dynamic subtest: pipe-A-eDP-1
[105.605451] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.519s)
[105.614800] Starting dynamic subtest: pipe-B-eDP-1
[122.487274] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.330s)
[122.497036] Starting dynamic subtest: pipe-C-eDP-1
[139.474702] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.338s)
[139.484910] Starting dynamic subtest: pipe-D-eDP-1
[156.445835] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.303s)
[156.448137] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (8.492s)
[157.609932] [010/131] (863s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[157.712352] Starting subtest: psr-rgb101010-draw-pwrite
[165.161348] Subtest psr-rgb101010-draw-pwrite: SUCCESS (7.615s)
[165.269067] [011/131] (855s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[165.370277] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[165.374374] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[165.465018] [012/131] (855s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[165.859210] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[166.658366] [013/131] (854s left) fbdev (pan)
[166.693584] Starting subtest: pan
[166.721510] Subtest pan: SUCCESS (0.031s)
[166.788156] [014/131] (854s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[171.779319] Starting subtest: pr-cursor-plane-update-sf
[171.783958] Subtest pr-cursor-plane-update-sf: SKIP (0.002s)
[172.619475] [015/131] (848s left) gem_eio (in-flight-internal-1us)
[172.822011] Starting subtest: in-flight-internal-1us
[174.679883] Subtest in-flight-internal-1us: SUCCESS (1.868s)
[174.846065] [016/131] (846s left) gem_exec_params (secure-non-root)
[174.915252] Starting subtest: secure-non-root
[174.919609] Subtest secure-non-root: SKIP (0.000s)
[175.027957] [017/131] (846s left) kms_joiner (basic-force-ultra-joiner)
[175.126661] Starting subtest: basic-force-ultra-joiner
[175.131303] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[175.187187] [018/131] (846s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[175.238865] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[175.241151] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[175.333514] [019/131] (845s left) kms_psr (fbc-pr-primary-page-flip)
[175.426931] Starting subtest: fbc-pr-primary-page-flip
[175.431384] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[175.499316] [020/131] (845s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[175.584750] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[175.587125] Starting dynamic subtest: pipe-A-eDP-1
[175.609743] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[175.620996] Starting dynamic subtest: pipe-B-eDP-1
[175.638144] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[175.646760] Starting dynamic subtest: pipe-C-eDP-1
[175.664308] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[175.672270] Starting dynamic subtest: pipe-D-eDP-1
[175.690750] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[175.694135] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.003s)
[177.768293] [021/131] (843s left) gem_mmap_gtt (fault-concurrent)
[177.839265] Subtest fault-concurrent: SKIP (0.000s)
[177.902670] [022/131] (843s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[177.970168] Starting subtest: map-fixed-invalidate-overlap-busy
[177.974787] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s)
[178.103325] [023/131] (843s left) kms_psr (fbc-psr-primary-render)
[178.206049] Starting subtest: fbc-psr-primary-render
[178.208454] Starting dynamic subtest: eDP-1
[178.212943] Dynamic subtest eDP-1: SKIP (0.000s)
[178.217491] Subtest fbc-psr-primary-render: SKIP (0.000s)
[178.277935] [024/131] (843s left) gem_eio (wait-wedge-1us)
[178.489077] Starting subtest: wait-wedge-1us
[179.663798] Subtest wait-wedge-1us: SUCCESS (1.176s)
[179.809832] [025/131] (841s left) gem_ppgtt (blt-vs-render-ctxn)
[179.875021] Starting subtest: blt-vs-render-ctxN
[212.900979] Subtest blt-vs-render-ctxN: SUCCESS (33.016s)
[213.046033] [026/131] (808s left) gem_flink_race (flink_name)
[213.114539] Starting subtest: flink_name
[218.513803] Subtest flink_name: SUCCESS (5.395s)
[218.636867] [027/131] (802s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[218.709125] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[218.815774] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.104s)
[218.891794] [028/131] (802s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[218.964433] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[219.032515] [029/131] (802s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[219.147646] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[219.151999] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[219.256579] [030/131] (802s left) gem_ctx_create (basic-files)
[219.332948] Starting subtest: basic-files
[221.340835] Subtest basic-files: SUCCESS (2.008s)
[222.666824] [031/131] (799s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[222.733745] Starting subtest: y-tiled-ccs-to-yf-tiled
[222.738466] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[222.917425] [032/131] (798s left) gem_exec_reloc (basic-range)
[222.982775] Subtest basic-range: SKIP (0.000s)
[223.073189] [033/131] (798s left) syncobj_basic (bad-create-flags)
[223.136198] Starting subtest: bad-create-flags
[223.138199] Subtest bad-create-flags: SUCCESS (0.000s)
[223.244805] [034/131] (798s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[223.357363] Starting subtest: addfb25-y-tiled-legacy
[223.359299] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[223.449815] [035/131] (798s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[223.514628] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[223.517260] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[223.628008] [036/131] (798s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[224.029441] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[224.869967] [037/131] (797s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[224.972174] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[224.976512] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[225.070599] [038/131] (796s left) gem_mmap_gtt (big-copy-xy)
[225.132972] Subtest big-copy-XY: SKIP (0.000s)
[225.190896] [039/131] (796s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[225.299022] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc
[225.301338] Starting dynamic subtest: pipe-A-eDP-1
[225.321475] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[225.332557] Starting dynamic subtest: pipe-B-eDP-1
[225.351661] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[225.360822] Starting dynamic subtest: pipe-C-eDP-1
[225.380438] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[225.389043] Starting dynamic subtest: pipe-D-eDP-1
[225.408782] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[225.410884] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[227.441787] [040/131] (794s left) gem_exec_params (no-bsd)
[227.493408] Starting subtest: no-bsd
[227.498662] Subtest no-bsd: SUCCESS (0.002s)
[228.725441] [041/131] (793s left) gem_exec_reloc (basic-gtt-noreloc)
[228.786233] Subtest basic-gtt-noreloc: SKIP (0.000s)
[228.865904] [042/131] (793s left) gem_mmap_gtt (basic-read)
[228.927137] Subtest basic-read: SKIP (0.000s)
[228.993717] [043/131] (793s left) gem_mmap_gtt (medium-copy)
[229.060305] Subtest medium-copy: SKIP (0.000s)
[229.122870] [044/131] (793s left) kms_plane_multiple (tiling-yf)
[229.213759] Starting subtest: tiling-yf
[229.218333] Subtest tiling-yf: SKIP (0.000s)
[229.283984] [045/131] (792s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[229.386757] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[229.391042] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[229.489275] [046/131] (792s left) i915_power (sanity)
[229.558217] Starting subtest: sanity
[233.603245] Subtest sanity: SUCCESS (4.039s)
[235.683305] [047/131] (786s left) sw_sync (sync_expired_merge)
[235.713394] Starting subtest: sync_expired_merge
[236.787552] Subtest sync_expired_merge: SUCCESS (1.074s)
[236.855696] [048/131] (785s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[236.939038] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[237.310018] Starting dynamic subtest: pipe-A-eDP-1
[240.105527] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.796s)
[240.468956] Starting dynamic subtest: pipe-B-eDP-1
[243.230453] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.768s)
[243.589853] Starting dynamic subtest: pipe-C-eDP-1
[246.347982] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.765s)
[246.707418] Starting dynamic subtest: pipe-D-eDP-1
[249.475669] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.776s)
[249.478424] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.539s)
[250.659661] [049/131] (771s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[250.757984] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[250.762187] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[250.875107] [050/131] (771s left) kms_scaling_modes (scaling-mode-center)
[250.976779] Starting subtest: scaling-mode-center
[250.979020] Starting dynamic subtest: pipe-A-eDP-1
[251.096297] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.119s)
[251.107322] Starting dynamic subtest: pipe-B-eDP-1
[252.275962] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.177s)
[252.288085] Starting dynamic subtest: pipe-C-eDP-1
[253.387014] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.110s)
[253.396856] Starting dynamic subtest: pipe-D-eDP-1
[254.510266] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.122s)
[254.512742] Subtest scaling-mode-center: SUCCESS (3.533s)
[255.661018] [051/131] (766s left) gem_exec_fence (keep-in-fence)
[255.842749] Starting subtest: keep-in-fence
[255.845304] Starting dynamic subtest: rcs0
[255.908396] Dynamic subtest rcs0: SUCCESS (0.066s)
[255.920546] Starting dynamic subtest: bcs0
[255.961131] Dynamic subtest bcs0: SUCCESS (0.051s)
[255.974124] Starting dynamic subtest: vcs0
[257.627778] Dynamic subtest vcs0: SUCCESS (1.663s)
[257.639590] Starting dynamic subtest: vcs1
[259.611785] Dynamic subtest vcs1: SUCCESS (1.982s)
[259.624241] Starting dynamic subtest: vecs0
[261.594486] Dynamic subtest vecs0: SUCCESS (1.981s)
[261.606967] Starting dynamic subtest: ccs0
[261.836256] Dynamic subtest ccs0: SUCCESS (0.242s)
[261.838921] Subtest keep-in-fence: SUCCESS (5.993s)
[263.710606] [FACT gem_exec_fence (keep-in-fence)] new: kernel.kmod_is_loaded.vgem: true
[263.713799] [052/131] (758s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[263.807537] Starting subtest: flip-vs-dpms-on-nop-interruptible
[263.809843] Starting dynamic subtest: A-eDP1
[265.745267] Dynamic subtest A-eDP1: SUCCESS (1.937s)
[265.756253] Starting dynamic subtest: B-eDP1
[267.679343] Dynamic subtest B-eDP1: SUCCESS (1.933s)
[267.691068] Starting dynamic subtest: C-eDP1
[269.489343] Dynamic subtest C-eDP1: SUCCESS (1.809s)
[269.500595] Starting dynamic subtest: D-eDP1
[271.319228] Dynamic subtest D-eDP1: SUCCESS (1.829s)
[271.321779] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.514s)
[272.500243] [053/131] (750s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[272.600062] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[273.524169] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.926s)
[273.705784] [054/131] (748s left) kms_chamelium_color (ctm-max)
[273.792040] Subtest ctm-max: SKIP (0.000s)
[273.839155] [055/131] (748s left) syncobj_eventfd (binary-wait)
[273.886186] Starting subtest: binary-wait
[273.896266] Subtest binary-wait: SUCCESS (0.011s)
[274.005589] [056/131] (748s left) api_intel_bb (render)
[274.063669] Starting subtest: render
[274.066080] Starting dynamic subtest: render-none-512
[274.180577] Dynamic subtest render-none-512: SUCCESS (0.117s)
[274.192891] Starting dynamic subtest: render-none-1024
[274.626555] Dynamic subtest render-none-1024: SUCCESS (0.445s)
[274.639268] Starting dynamic subtest: render-x-512
[274.727623] Dynamic subtest render-x-512: SUCCESS (0.101s)
[274.740270] Starting dynamic subtest: render-x-1024
[275.129881] Dynamic subtest render-x-1024: SUCCESS (0.401s)
[275.142534] Starting dynamic subtest: render-y-512
[275.231901] Dynamic subtest render-y-512: SUCCESS (0.102s)
[275.244507] Starting dynamic subtest: render-y-1024
[275.634540] Dynamic subtest render-y-1024: SUCCESS (0.401s)
[275.637583] Subtest render: SUCCESS (1.571s)
[275.773574] [057/131] (746s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc)
[275.862915] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc
[275.865250] Starting dynamic subtest: pipe-A-eDP-1
[275.890048] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[275.902286] Starting dynamic subtest: pipe-B-eDP-1
[275.926406] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[275.936045] Starting dynamic subtest: pipe-C-eDP-1
[275.960178] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[275.969683] Starting dynamic subtest: pipe-D-eDP-1
[275.994146] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[275.998275] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.003s)
[278.051089] [058/131] (744s left) gem_ctx_freq (sysfs)
[278.111943] Starting subtest: sysfs
[278.114124] Starting dynamic subtest: gt0
[283.645021] Dynamic subtest gt0: SUCCESS (5.532s)
[283.656377] Starting dynamic subtest: gt1
[325.658789] Dynamic subtest gt1: SUCCESS (42.016s)
[325.661760] Subtest sysfs: SUCCESS (47.550s)
[325.737853] [059/131] (697s left) gem_lmem_swapping (parallel-random-engines)
[325.787173] Subtest parallel-random-engines: SKIP (0.000s)
[325.834901] [060/131] (697s left) kms_frontbuffer_tracking (fbcpsr-suspend)
[325.952297] Starting subtest: fbcpsr-suspend
[366.604094] Subtest fbcpsr-suspend: SUCCESS (9.613s)
[366.732679] [061/131] (656s left) syncobj_timeline (single-wait-all-available-submitted)
[366.797926] Starting subtest: single-wait-all-available-submitted
[366.800179] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[366.909586] [062/131] (656s left) kms_pm_dc (dc6-dpms)
[368.017863] Starting subtest: dc6-dpms
[370.033467] Subtest dc6-dpms: SUCCESS (2.061s)
[370.110112] [063/131] (652s left) gem_eio (in-flight-contexts-1us)
[370.299843] Starting subtest: in-flight-contexts-1us
[383.798310] Subtest in-flight-contexts-1us: SUCCESS (13.617s)
[383.986644] [064/131] (639s left) kms_prop_blob (blob-prop-core)
[384.048153] Starting subtest: blob-prop-core
[384.050559] Subtest blob-prop-core: SUCCESS (0.000s)
[384.160870] [065/131] (638s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite)
[384.265529] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite
[391.064934] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.817s)
[391.188465] [066/131] (631s left) kms_rotation_crc (primary-y-tiled-reflect-x-180)
[391.286025] Starting subtest: primary-y-tiled-reflect-x-180
[391.359444] Subtest primary-y-tiled-reflect-x-180: SKIP (0.071s)
[391.463674] [067/131] (631s left) gen7_exec_parse (bitmasks)
[391.521971] Subtest bitmasks: SKIP (0.000s)
[391.597596] [068/131] (631s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[391.722213] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[400.412907] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (8.686s)
[401.273977] [069/131] (621s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[401.385555] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[401.390017] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[401.488126] [070/131] (621s left) i915_drm_fdinfo (virtual-busy-hang)
[401.526016] Starting subtest: virtual-busy-hang
[401.529981] Subtest virtual-busy-hang: SKIP (0.000s)
[401.598318] [071/131] (621s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[401.653242] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[401.658333] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SKIP (0.000s)
[401.830176] [072/131] (621s left) kms_lease (implicit-plane-lease)
[401.923591] Starting subtest: implicit-plane-lease
[401.928903] Subtest implicit-plane-lease: SUCCESS (0.003s)
[402.051486] [073/131] (621s left) kms_draw_crc (draw-method-mmap-wc)
[402.144065] Starting subtest: draw-method-mmap-wc
[402.146324] Starting dynamic subtest: xrgb8888-untiled
[402.371987] Dynamic subtest xrgb8888-untiled: SUCCESS (0.230s)
[402.382451] Starting dynamic subtest: rgb565-untiled
[402.594482] Dynamic subtest rgb565-untiled: SUCCESS (0.222s)
[402.604651] Starting dynamic subtest: xrgb2101010-untiled
[402.783893] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.188s)
[402.793845] Starting dynamic subtest: xbgr16161616f-untiled
[403.017193] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.233s)
[403.026942] Starting dynamic subtest: xrgb8888-xtiled
[403.150591] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.132s)
[403.160531] Starting dynamic subtest: rgb565-xtiled
[403.272650] Dynamic subtest rgb565-xtiled: SUCCESS (0.121s)
[403.282640] Starting dynamic subtest: xrgb2101010-xtiled
[403.384015] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.111s)
[403.393592] Starting dynamic subtest: xbgr16161616f-xtiled
[403.517543] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[403.527230] Starting dynamic subtest: xrgb8888-4tiled
[403.662170] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s)
[403.671835] Starting dynamic subtest: rgb565-4tiled
[403.806813] Dynamic subtest rgb565-4tiled: SUCCESS (0.144s)
[403.818655] Starting dynamic subtest: xrgb2101010-4tiled
[403.951256] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.144s)
[403.960936] Starting dynamic subtest: xbgr16161616f-4tiled
[404.129379] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.177s)
[404.131343] Subtest draw-method-mmap-wc: SUCCESS (1.986s)
[404.234543] [074/131] (619s left) kms_rotation_crc (sprite-rotation-180)
[404.320436] Starting subtest: sprite-rotation-180
[409.279889] Subtest sprite-rotation-180: SUCCESS (4.954s)
[410.437874] [075/131] (613s left) gem_eio (kms)
[410.716978] Starting subtest: kms
[432.969646] Subtest kms: SUCCESS (22.249s)
[433.108191] [076/131] (590s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[438.170352] Starting subtest: fbc-pr-cursor-plane-update-sf
[438.175338] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.003s)
[439.012788] [077/131] (584s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu)
[439.110429] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu
[445.894262] Subtest fbcpsr-rgb565-draw-mmap-cpu: SUCCESS (6.789s)
[446.031036] [078/131] (577s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[446.140929] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[446.143239] Starting dynamic subtest: pipe-A-default-mode
[446.428914] Dynamic subtest pipe-A-default-mode: SKIP (0.285s)
[446.433375] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.287s)
[447.226949] [079/131] (576s left) perf_pmu (render-node-busy)
[447.320015] Starting subtest: render-node-busy
[447.322668] Starting dynamic subtest: rcs0
[447.880649] Dynamic subtest rcs0: SUCCESS (0.563s)
[447.893658] Starting dynamic subtest: bcs0
[448.444732] Dynamic subtest bcs0: SUCCESS (0.562s)
[448.457911] Starting dynamic subtest: vcs0
[449.810680] Dynamic subtest vcs0: SUCCESS (1.364s)
[449.824016] Starting dynamic subtest: vcs1
[451.795479] Dynamic subtest vcs1: SUCCESS (1.981s)
[451.807827] Starting dynamic subtest: vecs0
[453.779673] Dynamic subtest vecs0: SUCCESS (1.982s)
[453.792640] Starting dynamic subtest: ccs0
[454.347006] Dynamic subtest ccs0: SUCCESS (0.566s)
[454.349778] Subtest render-node-busy: SUCCESS (7.033s)
[454.427674] [080/131] (569s left) gem_mmap (basic-small-bo)
[454.478234] Subtest basic-small-bo: SKIP (0.000s)
[454.544047] [081/131] (569s left) gem_exec_reloc (basic-cpu-noreloc)
[454.602099] Subtest basic-cpu-noreloc: SKIP (0.000s)
[454.696431] [082/131] (569s left) kms_3d
[457.057103] [083/131] (566s left) gem_userptr_blits (vma-merge)
[457.137751] Starting subtest: vma-merge
[457.177897] Subtest vma-merge: SUCCESS (0.040s)
[457.317478] [084/131] (566s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled)
[457.372186] Starting subtest: multi-wait-all-for-submit-submitted-signaled
[457.479989] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.105s)
[457.560123] [085/131] (566s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[457.652115] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[457.654447] Starting dynamic subtest: pipe-A-default-mode
[460.318507] Dynamic subtest pipe-A-default-mode: SUCCESS (2.664s)
[460.321046] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.666s)
[461.151227] [086/131] (562s left) kms_flip (nonblocking-read)
[461.251126] Starting subtest: nonblocking-read
[461.253404] Subtest nonblocking-read: SUCCESS (0.000s)
[461.371340] [087/131] (562s left) gem_create (create-ext-placement-all)
[461.538071] Starting subtest: create-ext-placement-all
[461.540962] Subtest create-ext-placement-all: SUCCESS (0.000s)
[461.651659] [088/131] (562s left) syncobj_wait (invalid-reset-one-illegal-handle)
[461.705941] Starting subtest: invalid-reset-one-illegal-handle
[461.708312] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[461.816059] [089/131] (562s left) kms_psr (fbc-psr2-suspend)
[461.903927] Starting subtest: fbc-psr2-suspend
[461.906036] Starting dynamic subtest: eDP-1
[461.909951] Dynamic subtest eDP-1: SKIP (0.000s)
[461.913833] Subtest fbc-psr2-suspend: SKIP (0.001s)
[461.976936] [090/131] (562s left) kms_cursor_edge_walk (64x64-left-edge)
[462.071364] Starting subtest: 64x64-left-edge
[462.073827] Starting dynamic subtest: pipe-A-eDP-1
[465.481262] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.405s)
[465.492360] Starting dynamic subtest: pipe-D-eDP-1
[468.667119] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.185s)
[468.669313] Subtest 64x64-left-edge: SUCCESS (6.592s)
[469.452497] [091/131] (554s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[469.558022] Starting subtest: y-tiled-32bpp-rotate-90
[469.562420] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[469.656844] [092/131] (554s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[469.746408] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[469.750446] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[469.829210] [093/131] (554s left) kms_cursor_crc (cursor-random-256x85)
[470.093425] Starting subtest: cursor-random-256x85
[470.139772] Subtest cursor-random-256x85: SKIP (0.040s)
[470.329486] [094/131] (553s left) kms_psr (psr2-primary-mmap-cpu)
[470.423876] Starting subtest: psr2-primary-mmap-cpu
[470.425793] Starting dynamic subtest: eDP-1
[472.199873] Dynamic subtest eDP-1: SUCCESS (1.778s)
[472.202147] Subtest psr2-primary-mmap-cpu: SUCCESS (1.778s)
[473.070366] [095/131] (551s left) syncobj_timeline (invalid-transfer-bad-pad)
[473.119882] Starting subtest: invalid-transfer-bad-pad
[473.122069] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[473.232173] [096/131] (551s left) gem_mmap_offset (perf)
[473.285549] Starting subtest: perf
[473.287826] Starting dynamic subtest: smem0
[473.648024] Dynamic subtest smem0: SUCCESS (0.360s)
[473.650647] Subtest perf: SUCCESS (0.361s)
[473.781735] [097/131] (550s left) gem_exercise_blt (fast-copy)
[473.845794] Starting subtest: fast-copy
[473.848313] Starting dynamic subtest: linear-smem-smem
[473.871042] Dynamic subtest linear-smem-smem: SUCCESS (0.024s)
[473.883871] Starting dynamic subtest: xmajor-smem-smem
[473.890000] Dynamic subtest xmajor-smem-smem: SUCCESS (0.019s)
[473.899888] Starting dynamic subtest: tile4-smem-smem
[473.911389] Dynamic subtest tile4-smem-smem: SUCCESS (0.021s)
[473.921003] Starting dynamic subtest: tile64-smem-smem
[473.929935] Dynamic subtest tile64-smem-smem: SUCCESS (0.018s)
[473.932196] Subtest fast-copy: SUCCESS (0.084s)
[474.072407] [098/131] (550s left) gem_basic (bad-close)
[474.128465] Starting subtest: bad-close
[474.133008] Subtest bad-close: SUCCESS (0.000s)
[474.248761] [099/131] (550s left) kms_flip (absolute-wf_vblank-interruptible)
[474.346280] Starting subtest: absolute-wf_vblank-interruptible
[474.348523] Starting dynamic subtest: A-eDP1
[483.083232] Dynamic subtest A-eDP1: SUCCESS (8.734s)
[483.095956] Starting dynamic subtest: B-eDP1
[491.785801] Dynamic subtest B-eDP1: SUCCESS (8.701s)
[491.796380] Starting dynamic subtest: C-eDP1
[500.468477] Dynamic subtest C-eDP1: SUCCESS (8.681s)
[500.483021] Starting dynamic subtest: D-eDP1
[509.169110] Dynamic subtest D-eDP1: SUCCESS (8.699s)
[509.174209] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.826s)
[510.352377] [100/131] (514s left) gem_exec_flush (basic-batch-kernel-default-uc)
[510.426166] Starting subtest: basic-batch-kernel-default-uc
[517.456281] Subtest basic-batch-kernel-default-uc: SUCCESS (7.031s)
[517.652172] [101/131] (506s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[517.756935] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[521.358630] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.607s)
[522.560948] [102/131] (502s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[522.659683] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[523.983331] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (1.326s)
[524.379589] [103/131] (500s left) gem_exec_reloc (basic-wc-active)
[524.435704] Subtest basic-wc-active: SKIP (0.000s)
[524.514899] [104/131] (500s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[524.619768] Starting subtest: extended-modeset-hang-oldfb-with-reset
[524.622098] Starting dynamic subtest: pipe-A
[536.281492] Dynamic subtest pipe-A: SUCCESS (11.659s)
[536.293371] Starting dynamic subtest: pipe-D
[548.484696] Dynamic subtest pipe-D: SUCCESS (12.203s)
[548.487585] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (23.867s)
[549.347818] [105/131] (475s left) kms_cursor_crc (cursor-suspend)
[549.492340] Starting subtest: cursor-suspend
[549.494791] Starting dynamic subtest: pipe-A-eDP-1
[582.828253] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.080s)
[582.839089] Starting dynamic subtest: pipe-D-eDP-1
[615.886515] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.704s)
[615.888604] Subtest cursor-suspend: SUCCESS (6.787s)
[616.812991] [106/131] (408s left) syncobj_wait (single-wait-all-for-submit-signaled)
[616.872320] Starting subtest: single-wait-all-for-submit-signaled
[616.874444] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[616.979892] [107/131] (407s left) syncobj_wait (multi-wait-submitted)
[617.033328] Starting subtest: multi-wait-submitted
[617.138003] Subtest multi-wait-submitted: SUCCESS (0.107s)
[617.213054] [108/131] (407s left) gem_render_copy (y-tiled)
[617.265875] Starting subtest: y-tiled
[617.270487] Subtest y-tiled: SKIP (0.000s)
[617.447233] [109/131] (407s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[617.541456] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[617.543760] Starting dynamic subtest: pipe-A-eDP-1
[617.566214] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[617.577422] Starting dynamic subtest: pipe-B-eDP-1
[617.597704] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[617.607420] Starting dynamic subtest: pipe-C-eDP-1
[617.628452] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[617.638466] Starting dynamic subtest: pipe-D-eDP-1
[617.660106] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[617.664451] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.004s)
[619.704351] [110/131] (405s left) api_intel_allocator (reloc-allocator)
[619.762042] Starting subtest: reloc-allocator
[619.764123] Starting dynamic subtest: basic
[619.766808] Dynamic subtest basic: SUCCESS (0.005s)
[619.783299] Starting dynamic subtest: parallel-one
[619.785252] Dynamic subtest parallel-one: SUCCESS (0.008s)
[619.796126] Starting dynamic subtest: print
[619.798379] Dynamic subtest print: SUCCESS (0.000s)
[619.808347] Starting dynamic subtest: reuse
[619.810491] Dynamic subtest reuse: SUCCESS (0.000s)
[619.820731] Starting dynamic subtest: fork-reopen-allocator
[619.822900] Dynamic subtest fork-reopen-allocator: SUCCESS (0.011s)
[619.824945] Subtest reloc-allocator: SUCCESS (0.028s)
[619.912402] [111/131] (405s left) kms_properties (crtc-properties-atomic)
[619.998568] Starting subtest: crtc-properties-atomic
[620.000849] Starting dynamic subtest: pipe-A-eDP-1
[620.438711] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.448s)
[620.450157] Starting dynamic subtest: pipe-B-eDP-1
[621.584805] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.166s)
[621.599015] Starting dynamic subtest: pipe-C-eDP-1
[622.682843] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.115s)
[622.693578] Starting dynamic subtest: pipe-D-eDP-1
[623.855388] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.187s)
[623.857739] Subtest crtc-properties-atomic: SUCCESS (3.921s)
[624.721009] [112/131] (400s left) gen9_exec_parse (bb-secure)
[624.783384] Subtest bb-secure: SKIP (0.000s)
[624.850145] [113/131] (400s left) gem_exec_schedule (fifo)
[624.919266] Starting subtest: fifo
[624.921625] Starting dynamic subtest: rcs0
[625.007926] Dynamic subtest rcs0: SUCCESS (0.099s)
[625.021297] Starting dynamic subtest: vcs0
[625.084024] Dynamic subtest vcs0: SUCCESS (0.076s)
[625.096239] Starting dynamic subtest: vcs1
[625.160098] Dynamic subtest vcs1: SUCCESS (0.076s)
[625.173622] Starting dynamic subtest: vecs0
[625.232695] Dynamic subtest vecs0: SUCCESS (0.073s)
[625.246312] Starting dynamic subtest: ccs0
[625.310052] Dynamic subtest ccs0: SUCCESS (0.077s)
[625.312637] Subtest fifo: SUCCESS (0.405s)
[626.623306] [114/131] (398s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[626.728301] Starting subtest: x-tiled-32bpp-rotate-180
[628.380257] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.667s)
[628.558205] [115/131] (396s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-blt)
[628.650532] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-blt
[628.654055] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[628.761621] [116/131] (396s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[629.291143] Starting subtest: syncobj-timeline-invalid-flags
[629.294361] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s)
[630.598305] [117/131] (394s left) kms_writeback (writeback-fb-id)
[630.689700] Subtest writeback-fb-id: SKIP (0.000s)
[630.738644] [118/131] (394s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[630.822370] Starting subtest: compare-crc-sanitycheck-nv12
[630.825119] Starting dynamic subtest: pipe-A-eDP-1
[631.493118] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.672s)
[631.505347] Starting dynamic subtest: pipe-B-eDP-1
[632.772865] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.284s)
[632.784136] Starting dynamic subtest: pipe-C-eDP-1
[633.937554] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.168s)
[633.953393] Starting dynamic subtest: pipe-D-eDP-1
[635.116394] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.182s)
[635.118842] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.312s)
[635.947440] [119/131] (389s left) gem_ctx_persistence (legacy-engines-mixed)
[636.006157] Starting subtest: legacy-engines-mixed
[636.008706] Starting dynamic subtest: render
[636.094140] Dynamic subtest render: SUCCESS (0.087s)
[636.106179] Starting dynamic subtest: bsd1
[636.163925] Dynamic subtest bsd1: SUCCESS (0.068s)
[636.176172] Starting dynamic subtest: bsd2
[636.221847] Dynamic subtest bsd2: SUCCESS (0.056s)
[636.235281] Starting dynamic subtest: blt
[636.276127] Dynamic subtest blt: SUCCESS (0.052s)
[636.288408] Starting dynamic subtest: vebox
[636.339367] Dynamic subtest vebox: SUCCESS (0.061s)
[636.342554] Subtest legacy-engines-mixed: SUCCESS (0.334s)
[636.422520] [120/131] (388s left) gem_exec_schedule (submit-early-slice)
[636.499362] Starting subtest: submit-early-slice
[636.501441] Starting dynamic subtest: rcs0
[636.534924] Dynamic subtest rcs0: SUCCESS (0.043s)
[636.548293] Starting dynamic subtest: bcs0
[636.572597] Dynamic subtest bcs0: SUCCESS (0.037s)
[636.583576] Starting dynamic subtest: vcs0
[636.612256] Dynamic subtest vcs0: SUCCESS (0.039s)
[636.622816] Starting dynamic subtest: vcs1
[636.650464] Dynamic subtest vcs1: SUCCESS (0.037s)
[636.661132] Starting dynamic subtest: vecs0
[636.692872] Dynamic subtest vecs0: SUCCESS (0.042s)
[636.704408] Starting dynamic subtest: ccs0
[636.731675] Dynamic subtest ccs0: SUCCESS (0.038s)
[636.733922] Subtest submit-early-slice: SUCCESS (0.241s)
[638.599724] [121/131] (386s left) kms_plane_scaling (planes-scaler-unity-scaling)
[638.719668] Starting subtest: planes-scaler-unity-scaling
[638.722106] Starting dynamic subtest: pipe-A
[638.803859] Dynamic subtest pipe-A: SUCCESS (0.084s)
[638.818161] Starting dynamic subtest: pipe-B
[639.932732] Dynamic subtest pipe-B: SUCCESS (1.131s)
[639.945001] Starting dynamic subtest: pipe-C
[641.109739] Dynamic subtest pipe-C: SUCCESS (1.178s)
[641.125685] Starting dynamic subtest: pipe-D
[642.206419] Dynamic subtest pipe-D: SUCCESS (1.097s)
[642.208844] Subtest planes-scaler-unity-scaling: SUCCESS (3.493s)
[643.338407] [122/131] (382s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[643.441086] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[651.910602] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.483s)
[652.027260] [123/131] (373s left) gem_ctx_persistence (heartbeat-hostile)
[652.083554] Starting subtest: heartbeat-hostile
[652.088308] Subtest heartbeat-hostile: SKIP (0.000s)
[652.197761] [124/131] (373s left) kms_plane (plane-position-hole)
[652.288522] Starting subtest: plane-position-hole
[652.805395] Starting dynamic subtest: pipe-A-plane-1
[654.042464] Dynamic subtest pipe-A-plane-1: SUCCESS (1.240s)
[654.054091] Starting dynamic subtest: pipe-A-plane-2
[655.342905] Dynamic subtest pipe-A-plane-2: SUCCESS (1.300s)
[655.355056] Starting dynamic subtest: pipe-A-plane-3
[656.679570] Dynamic subtest pipe-A-plane-3: SUCCESS (1.334s)
[656.691866] Starting dynamic subtest: pipe-A-plane-4
[657.964198] Dynamic subtest pipe-A-plane-4: SUCCESS (1.285s)
[657.975600] Starting dynamic subtest: pipe-A-plane-5
[658.003418] Dynamic subtest pipe-A-plane-5: SUCCESS (0.039s)
[659.181190] Starting dynamic subtest: pipe-B-plane-1
[660.493933] Dynamic subtest pipe-B-plane-1: SUCCESS (1.323s)
[660.505857] Starting dynamic subtest: pipe-B-plane-2
[661.786777] Dynamic subtest pipe-B-plane-2: SUCCESS (1.294s)
[661.797160] Starting dynamic subtest: pipe-B-plane-3
[663.046934] Dynamic subtest pipe-B-plane-3: SUCCESS (1.260s)
[663.057601] Starting dynamic subtest: pipe-B-plane-4
[664.369249] Dynamic subtest pipe-B-plane-4: SUCCESS (1.323s)
[664.381001] Starting dynamic subtest: pipe-B-plane-5
[664.410072] Dynamic subtest pipe-B-plane-5: SUCCESS (0.038s)
[664.412041] Subtest plane-position-hole: SUCCESS (12.127s)
[665.211697] [125/131] (360s left) vgem_basic (dmabuf-export)
[665.265427] Starting subtest: dmabuf-export
[665.293785] Subtest dmabuf-export: SUCCESS (0.030s)
[665.393598] [126/131] (360s left) gem_exec_balancer (sequential)
[665.455374] Starting subtest: sequential
[668.526029] Subtest sequential: SUCCESS (3.072s)
[668.872724] [127/131] (356s left) gem_pwrite (basic-exhaustion)
[668.935164] Subtest basic-exhaustion: SKIP (0.000s)
[669.001074] [128/131] (356s left) kms_psr (psr-primary-mmap-cpu)
[669.098859] Starting subtest: psr-primary-mmap-cpu
[669.101278] Starting dynamic subtest: eDP-1
[670.875829] Dynamic subtest eDP-1: SUCCESS (1.777s)
[670.878269] Subtest psr-primary-mmap-cpu: SUCCESS (1.777s)
[671.710683] [129/131] (354s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[671.806935] Starting subtest: 4-tiled-8bpp-rotate-270
[671.828255] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.021s)
[671.953655] [130/131] (353s left) gem_exec_schedule (u-semaphore-user)
[672.032676] Starting subtest: u-semaphore-user
[672.089062] Subtest u-semaphore-user: SUCCESS (0.058s)
[673.543125] [131/131] (352s left) vgem_basic (bad-handle)
[673.583996] Starting subtest: bad-handle
[673.586253] Subtest bad-handle: SUCCESS (0.000s)
[673.638239] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_legacy
results: parsing output: 1/ for test: kms_vblank
results: parsing output: 2/ for test: syncobj_timeline
results: parsing output: 3/ for test: kms_cursor_crc
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: perf_pmu
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: i915_module_load
results: parsing output: 8/ for test: kms_ccs
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_chamelium_frames
results: parsing output: 12/ for test: fbdev
results: parsing output: 13/ for test: kms_psr2_sf
results: parsing output: 14/ for test: gem_eio
results: parsing output: 15/ for test: gem_exec_params
results: parsing output: 16/ for test: kms_joiner
results: parsing output: 17/ for test: syncobj_timeline
results: parsing output: 18/ for test: kms_psr
results: parsing output: 19/ for test: kms_ccs
results: parsing output: 20/ for test: gem_mmap_gtt
results: parsing output: 21/ for test: gem_userptr_blits
results: parsing output: 22/ for test: kms_psr
results: parsing output: 23/ for test: gem_eio
results: parsing output: 24/ for test: gem_ppgtt
results: parsing output: 25/ for test: gem_flink_race
results: parsing output: 26/ for test: syncobj_timeline
results: parsing output: 27/ for test: gem_mmap_gtt
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: gem_ctx_create
results: parsing output: 30/ for test: gem_render_copy
results: parsing output: 31/ for test: gem_exec_reloc
results: parsing output: 32/ for test: syncobj_basic
results: parsing output: 33/ for test: kms_addfb_basic
results: parsing output: 34/ for test: syncobj_wait
results: parsing output: 35/ for test: kms_chamelium_hpd
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_mmap_gtt
results: parsing output: 38/ for test: kms_ccs
results: parsing output: 39/ for test: gem_exec_params
results: parsing output: 40/ for test: gem_exec_reloc
results: parsing output: 41/ for test: gem_mmap_gtt
results: parsing output: 42/ for test: gem_mmap_gtt
results: parsing output: 43/ for test: kms_plane_multiple
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: i915_power
results: parsing output: 46/ for test: sw_sync
results: parsing output: 47/ for test: kms_async_flips
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_scaling_modes
results: parsing output: 50/ for test: gem_exec_fence
results: parsing output: 51/ for test: kms_flip
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: kms_chamelium_color
results: parsing output: 54/ for test: syncobj_eventfd
results: parsing output: 55/ for test: api_intel_bb
results: parsing output: 56/ for test: kms_ccs
results: parsing output: 57/ for test: gem_ctx_freq
results: parsing output: 58/ for test: gem_lmem_swapping
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: syncobj_timeline
results: parsing output: 61/ for test: kms_pm_dc
results: parsing output: 62/ for test: gem_eio
results: parsing output: 63/ for test: kms_prop_blob
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_rotation_crc
results: parsing output: 66/ for test: gen7_exec_parse
results: parsing output: 67/ for test: kms_cursor_legacy
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: i915_drm_fdinfo
results: parsing output: 70/ for test: gem_render_copy
results: parsing output: 71/ for test: kms_lease
results: parsing output: 72/ for test: kms_draw_crc
results: parsing output: 73/ for test: kms_rotation_crc
results: parsing output: 74/ for test: gem_eio
results: parsing output: 75/ for test: kms_psr2_sf
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_flip_scaled_crc
results: parsing output: 78/ for test: perf_pmu
results: parsing output: 79/ for test: gem_mmap
results: parsing output: 80/ for test: gem_exec_reloc
results: parsing output: 81/ for test: kms_3d
results: parsing output: 82/ for test: gem_userptr_blits
results: parsing output: 83/ for test: syncobj_wait
results: parsing output: 84/ for test: kms_flip_scaled_crc
results: parsing output: 85/ for test: kms_flip
results: parsing output: 86/ for test: gem_create
results: parsing output: 87/ for test: syncobj_wait
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: kms_cursor_edge_walk
results: parsing output: 90/ for test: kms_big_fb
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_cursor_crc
results: parsing output: 93/ for test: kms_psr
results: parsing output: 94/ for test: syncobj_timeline
results: parsing output: 95/ for test: gem_mmap_offset
results: parsing output: 96/ for test: gem_exercise_blt
results: parsing output: 97/ for test: gem_basic
results: parsing output: 98/ for test: kms_flip
results: parsing output: 99/ for test: gem_exec_flush
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: gem_exec_reloc
results: parsing output: 103/ for test: kms_busy
results: parsing output: 104/ for test: kms_cursor_crc
results: parsing output: 105/ for test: syncobj_wait
results: parsing output: 106/ for test: syncobj_wait
results: parsing output: 107/ for test: gem_render_copy
results: parsing output: 108/ for test: kms_ccs
results: parsing output: 109/ for test: api_intel_allocator
results: parsing output: 110/ for test: kms_properties
results: parsing output: 111/ for test: gen9_exec_parse
results: parsing output: 112/ for test: gem_exec_schedule
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: gem_exec_fence
results: parsing output: 116/ for test: kms_writeback
results: parsing output: 117/ for test: kms_pipe_crc_basic
results: parsing output: 118/ for test: gem_ctx_persistence
results: parsing output: 119/ for test: gem_exec_schedule
results: parsing output: 120/ for test: kms_plane_scaling
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: gem_ctx_persistence
results: parsing output: 123/ for test: kms_plane
results: parsing output: 124/ for test: vgem_basic
results: parsing output: 125/ for test: gem_exec_balancer
results: parsing output: 126/ for test: gem_pwrite
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: kms_big_fb
results: parsing output: 129/ for test: gem_exec_schedule
results: parsing output: 130/ for test: vgem_basic
Done.