[57.037757] Initializing watchdogs
[57.037826]   /dev/watchdog0
[57.052827] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics]
[57.058860] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.061356] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.063217] [001/133] (960s left) api_intel_bb (destroy-bb)
[57.099696] Starting subtest: destroy-bb
[57.107187] Subtest destroy-bb: SUCCESS (0.008s)
[57.262675] [002/133] (960s left) gem_exec_reloc (basic-cpu-wc)
[57.302237] Starting subtest: basic-cpu-wc
[57.309387] Subtest basic-cpu-wc: SUCCESS (0.007s)
[57.465519] [003/133] (960s left) perf (gen12-oa-tlb-invalidate)
[57.585716] Starting subtest: gen12-oa-tlb-invalidate
[57.586370] Starting dynamic subtest: 0-rcs0
[67.651805] Dynamic subtest 0-rcs0: SUCCESS (10.060s)
[67.652617] Subtest gen12-oa-tlb-invalidate: SUCCESS (10.060s)
[67.691694] [004/133] (949s left) gem_mmap_gtt (big-bo)
[67.880485] Starting subtest: big-bo
[68.273474] Subtest big-bo: SUCCESS (0.401s)
[68.496373] [005/133] (949s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[68.632439] Starting subtest: fbcpsr-slowdraw
[68.633799] Subtest fbcpsr-slowdraw: SKIP (0.000s)
[68.747358] [006/133] (949s left) i915_pm_rpm (debugfs-forcewake-user)
[70.169300] Starting subtest: debugfs-forcewake-user
[81.605644] Subtest debugfs-forcewake-user: SUCCESS (11.442s)
[81.804327] [007/133] (936s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[81.845030] Starting subtest: mixed-tiled-to-y-tiled-ccs
[81.845784] Starting dynamic subtest: smem
[81.954993] Dynamic subtest smem: SUCCESS (0.109s)
[81.955711] Subtest mixed-tiled-to-y-tiled-ccs: SUCCESS (0.110s)
[82.166541] [008/133] (935s left) gen9_exec_parse (valid-registers)
[82.205465] Subtest valid-registers: SKIP (0.000s)
[82.240806] [009/133] (935s left) kms_psr (fbc-pr-cursor-plane-onoff)
[82.326714] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s)
[82.374168] [010/133] (935s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[82.415535] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[82.416948] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[82.504422] [011/133] (935s left) gen7_exec_parse (batch-without-end)
[82.541280] Subtest batch-without-end: SKIP (0.000s)
[82.585256] [012/133] (935s left) kms_flip (2x-plain-flip-interruptible)
[82.674026] Starting subtest: 2x-plain-flip-interruptible
[82.683415] Subtest 2x-plain-flip-interruptible: SKIP (0.009s)
[82.769800] [013/133] (935s left) gem_busy (busy)
[82.813620] Starting subtest: busy
[82.814405] Starting dynamic subtest: all-engines
[82.842087] Dynamic subtest all-engines: SUCCESS (0.028s)
[82.848198] Starting dynamic subtest: rcs0
[82.853023] Dynamic subtest rcs0: SUCCESS (0.011s)
[82.860035] Starting dynamic subtest: bcs0
[82.867869] Dynamic subtest bcs0: SUCCESS (0.014s)
[82.874352] Starting dynamic subtest: vcs0
[82.886166] Dynamic subtest vcs0: SUCCESS (0.018s)
[82.898213] Starting dynamic subtest: vcs1
[82.909090] Dynamic subtest vcs1: SUCCESS (0.022s)
[82.919884] Starting dynamic subtest: vecs0
[82.922105] Dynamic subtest vecs0: SUCCESS (0.013s)
[82.922870] Subtest busy: SUCCESS (0.109s)
[83.288392] [014/133] (934s left) kms_prop_blob (basic)
[83.321587] Starting subtest: basic
[83.322281] Subtest basic: SUCCESS (0.000s)
[83.444099] [015/133] (934s left) gem_create (create-ext-placement-sanity-check)
[83.587151] Starting subtest: create-ext-placement-sanity-check
[83.591582] Subtest create-ext-placement-sanity-check: SUCCESS (0.004s)
[83.702463] [016/133] (934s left) gem_exec_flush (basic-wb-prw-default)
[83.744558] Starting subtest: basic-wb-prw-default
[89.175550] Subtest basic-wb-prw-default: SUCCESS (5.432s)
[89.410453] [017/133] (928s left) kms_rotation_crc (primary-rotation-90)
[89.497530] Starting subtest: primary-rotation-90
[98.106745] Subtest primary-rotation-90: SUCCESS (8.609s)
[98.307271] [018/133] (919s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[98.395485] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[98.396828] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[98.567202] [019/133] (919s left) gem_ctx_isolation (preservation-s3)
[98.608701] Starting subtest: preservation-S3
[98.609459] Starting dynamic subtest: rcs0
[115.504178] Dynamic subtest rcs0: SUCCESS (1.679s)
[115.511714] Starting dynamic subtest: bcs0
[132.504286] Dynamic subtest bcs0: SUCCESS (1.371s)
[132.511306] Starting dynamic subtest: vcs0
[149.495341] Dynamic subtest vcs0: SUCCESS (1.338s)
[149.504801] Starting dynamic subtest: vcs1
[166.467092] Dynamic subtest vcs1: SUCCESS (1.322s)
[166.474258] Starting dynamic subtest: vecs0
[182.469235] Dynamic subtest vecs0: SUCCESS (1.319s)
[182.470090] Subtest preservation-S3: SUCCESS (7.029s)
[191.761113] [020/133] (835s left) gem_eio (hibernate)
[191.813526] Starting subtest: hibernate
[204.677663] Subtest hibernate: SUCCESS (12.975s)
[213.832239] [021/133] (822s left) kms_tv_load_detect (load-detect)
[213.869030] Subtest load-detect: SKIP (0.000s)
[213.913970] [022/133] (822s left) kms_psr (fbc-psr-primary-mmap-gtt)
[213.999744] Subtest fbc-psr-primary-mmap-gtt: SKIP (0.000s)
[214.044454] [023/133] (822s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[214.131995] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[214.133400] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[214.245995] [024/133] (822s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[214.341798] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[214.343212] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[214.461211] [025/133] (822s left) kms_chamelium_frames (dp-crc-multiple)
[214.593325] Subtest dp-crc-multiple: SKIP (0.000s)
[214.670776] [026/133] (821s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic)
[214.755265] Starting subtest: 2x-long-flip-vs-cursor-atomic
[214.758081] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.002s)
[214.858312] [027/133] (821s left) kms_addfb_basic (no-handle)
[214.891147] Starting subtest: no-handle
[214.891838] Subtest no-handle: SUCCESS (0.000s)
[215.062342] [028/133] (821s left) kms_fb_coherency (memset-crc)
[215.146851] Starting subtest: memset-crc
[215.147586] Starting dynamic subtest: mmap-gtt
[215.609766] Dynamic subtest mmap-gtt: SUCCESS (0.463s)
[215.663440] Starting dynamic subtest: mmap-offset-wc
[216.025324] Dynamic subtest mmap-offset-wc: SUCCESS (0.369s)
[216.101832] Starting dynamic subtest: mmap-offset-uc
[216.823281] Dynamic subtest mmap-offset-uc: SUCCESS (0.730s)
[216.876649] Starting dynamic subtest: mmap-legacy-wc
[217.237353] Dynamic subtest mmap-legacy-wc: SUCCESS (0.368s)
[217.305524] Subtest memset-crc: SUCCESS (2.159s)
[217.458183] [029/133] (819s left) gem_eio (in-flight-1us)
[217.500032] Starting subtest: in-flight-1us
[219.705922] Subtest in-flight-1us: SUCCESS (2.206s)
[219.869825] [FACT gem_eio (in-flight-1us)] new: kernel.kmod_is_loaded.vgem: true
[219.871496] [030/133] (816s left) sysfs_heartbeat_interval (nopreempt)
[219.907481] Starting subtest: nopreempt
[219.908188] Starting dynamic subtest: vecs0
[223.503809] Dynamic subtest vecs0: SUCCESS (3.597s)
[223.514685] Starting dynamic subtest: vcs0
[227.118789] Dynamic subtest vcs0: SUCCESS (3.616s)
[227.128540] Starting dynamic subtest: bcs0
[230.708630] Dynamic subtest bcs0: SUCCESS (3.589s)
[230.724335] Starting dynamic subtest: rcs0
[234.370837] Dynamic subtest rcs0: SUCCESS (3.664s)
[234.382312] Starting dynamic subtest: vcs1
[237.956960] Dynamic subtest vcs1: SUCCESS (3.587s)
[237.957976] Subtest nopreempt: SUCCESS (18.058s)
[238.051890] [031/133] (798s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[238.148103] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[238.149506] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[238.260326] [032/133] (798s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[238.355625] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip
[238.357050] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[238.475003] [033/133] (798s left) gem_workarounds (reset-context)
[238.522133] Starting subtest: reset-context
[238.531941] Subtest reset-context: SUCCESS (0.009s)
[238.683946] [034/133] (798s left) gem_exec_reloc (basic-wc-cpu-active)
[238.721392] Starting subtest: basic-wc-cpu-active
[238.847785] Subtest basic-wc-cpu-active: SUCCESS (0.117s)
[239.005798] [035/133] (797s left) kms_flip (flip-vs-rmfb)
[239.090721] Starting subtest: flip-vs-rmfb
[239.093404] Starting dynamic subtest: A-HDMI-A1
[246.770286] Dynamic subtest A-HDMI-A1: SUCCESS (7.680s)
[246.779705] Starting dynamic subtest: B-HDMI-A1
[254.426921] Dynamic subtest B-HDMI-A1: SUCCESS (7.658s)
[254.444202] Starting dynamic subtest: C-HDMI-A1
[262.085466] Dynamic subtest C-HDMI-A1: SUCCESS (7.660s)
[262.103267] Starting dynamic subtest: D-HDMI-A1
[269.744334] Dynamic subtest D-HDMI-A1: SUCCESS (7.660s)
[269.750245] Subtest flip-vs-rmfb: SUCCESS (30.674s)
[269.930982] [036/133] (767s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[270.029597] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[271.191393] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.162s)
[271.354987] [037/133] (765s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[271.447979] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[271.449439] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[271.562889] [038/133] (765s left) kms_cursor_crc (cursor-random-64x21)
[271.651382] Starting subtest: cursor-random-64x21
[271.656093] Starting dynamic subtest: pipe-A-HDMI-A-1
[275.868871] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (4.214s)
[275.899299] Starting dynamic subtest: pipe-D-HDMI-A-1
[279.980357] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (4.090s)
[279.981107] Subtest cursor-random-64x21: SUCCESS (8.333s)
[280.173638] [039/133] (757s left) perf (invalid-oa-exponent)
[280.324048] Starting subtest: invalid-oa-exponent
[280.336702] Subtest invalid-oa-exponent: SUCCESS (0.012s)
[280.384030] [040/133] (756s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[280.473144] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[280.474444] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.000s)
[280.567141] [041/133] (756s left) kms_prime (basic-crc-vgem)
[280.665546] Starting subtest: basic-crc-vgem
[280.666209] Starting dynamic subtest: second-to-first
[281.885344] Dynamic subtest second-to-first: SUCCESS (1.220s)
[281.886737] Subtest basic-crc-vgem: SUCCESS (1.222s)
[282.048130] [042/133] (755s left) syncobj_wait (wait-all-complex)
[282.082489] Starting subtest: wait-all-complex
[282.306230] Subtest wait-all-complex: SUCCESS (0.215s)
[282.429974] [043/133] (754s left) gem_create (create-invalid-size)
[282.463075] Starting subtest: create-invalid-size
[282.463739] Subtest create-invalid-size: SUCCESS (0.000s)
[282.677178] [044/133] (754s left) gem_spin_batch (user-each)
[282.721256] Starting subtest: user-each
[286.079515] Subtest user-each: SUCCESS (3.345s)
[286.279582] [045/133] (751s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[286.369532] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[286.411033] [046/133] (751s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[286.497521] Starting subtest: compare-crc-sanitycheck-xr24
[286.498384] Starting dynamic subtest: pipe-A-HDMI-A-1
[286.956542] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.458s)
[286.965848] Starting dynamic subtest: pipe-B-HDMI-A-1
[287.323060] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.365s)
[287.332336] Starting dynamic subtest: pipe-C-HDMI-A-1
[287.697700] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.372s)
[287.707103] Starting dynamic subtest: pipe-D-HDMI-A-1
[288.077163] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.378s)
[288.077851] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.582s)
[288.261602] [047/133] (749s left) kms_async_flips (alternate-sync-async-flip-atomic)
[288.351434] Starting subtest: alternate-sync-async-flip-atomic
[288.546902] Starting dynamic subtest: pipe-A-HDMI-A-1
[290.639396] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.084s)
[290.820046] Starting dynamic subtest: pipe-B-HDMI-A-1
[292.883072] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.062s)
[293.036854] Starting dynamic subtest: pipe-C-HDMI-A-1
[295.107918] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.072s)
[295.273678] Starting dynamic subtest: pipe-D-HDMI-A-1
[297.338945] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.065s)
[297.339645] Subtest alternate-sync-async-flip-atomic: SUCCESS (8.985s)
[297.648165] [048/133] (739s left) prime_mmap (test_invalid_sync_flags)
[297.686298] Starting subtest: test_invalid_sync_flags
[297.686982] Starting dynamic subtest: test_invalid_sync_flags-smem
[297.687674] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[297.688353] Subtest test_invalid_sync_flags: SUCCESS (0.001s)
[297.799984] [049/133] (739s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[297.897207] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[299.248856] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.353s)
[299.431569] [050/133] (738s left) api_intel_allocator (reserve-simple)
[299.465696] Starting subtest: reserve-simple
[299.467474] Subtest reserve-simple: SUCCESS (0.001s)
[299.597515] [051/133] (738s left) gem_vm_create (isolation)
[299.634669] Starting subtest: isolation
[299.638957] Subtest isolation: SUCCESS (0.004s)
[299.790045] [052/133] (737s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[299.879380] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[299.880100] Starting dynamic subtest: pipe-A-HDMI-A-1
[299.886243] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.002s)
[299.896527] Starting dynamic subtest: pipe-B-HDMI-A-1
[299.902934] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.002s)
[299.913026] Starting dynamic subtest: pipe-C-HDMI-A-1
[299.919457] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[299.929198] Starting dynamic subtest: pipe-D-HDMI-A-1
[299.935444] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[299.936160] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SUCCESS (0.013s)
[300.145155] [053/133] (737s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0-hflip)
[300.242279] Starting subtest: linear-max-hw-stride-64bpp-rotate-0-hflip
[300.243662] Subtest linear-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[300.355076] [054/133] (737s left) kms_flip (nonblocking-read)
[300.441168] Starting subtest: nonblocking-read
[300.441876] Subtest nonblocking-read: SUCCESS (0.000s)
[300.582494] [055/133] (737s left) kms_setmode (invalid-clone-single-crtc)
[300.617763] Starting subtest: invalid-clone-single-crtc
[300.619981] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[300.707831] [056/133] (737s left) kms_big_fb (linear-64bpp-rotate-180)
[300.803815] Starting subtest: linear-64bpp-rotate-180
[303.073638] Subtest linear-64bpp-rotate-180: SUCCESS (2.271s)
[303.257715] [057/133] (734s left) kms_content_protection (atomic)
[303.350534] Starting subtest: atomic
[303.355968] Subtest atomic: SKIP (0.004s)
[303.483832] [058/133] (734s left) gem_exec_fence (expired-history)
[303.791258] Starting subtest: expired-history
[309.510927] Subtest expired-history: SUCCESS (5.714s)
[310.009726] [059/133] (728s left) kms_lease (lease-unleased-crtc)
[310.104264] Starting subtest: lease-unleased-crtc
[310.105091] Starting dynamic subtest: pipe-A-HDMI-A-1
[310.193395] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.088s)
[310.205358] Starting dynamic subtest: pipe-B-HDMI-A-1
[310.227949] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.031s)
[310.236239] Starting dynamic subtest: pipe-C-HDMI-A-1
[310.261030] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.032s)
[310.270441] Starting dynamic subtest: pipe-D-HDMI-A-1
[310.297251] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.035s)
[310.298021] Subtest lease-unleased-crtc: SUCCESS (0.194s)
[310.434694] [060/133] (727s left) kms_psr (psr2-cursor-mmap-cpu)
[310.522108] Subtest psr2-cursor-mmap-cpu: SKIP (0.000s)
[310.569329] [061/133] (727s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt)
[310.660168] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt
[310.661526] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[310.794655] [062/133] (727s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[310.880793] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[310.882130] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[311.052469] [063/133] (727s left) kms_feature_discovery (psr2)
[311.140699] Starting subtest: psr2
[311.142133] Subtest psr2: SKIP (0.000s)
[311.265902] [064/133] (727s left) vgem_basic (mmap)
[311.307607] Starting subtest: mmap
[311.317567] Subtest mmap: SUCCESS (0.010s)
[311.461698] [065/133] (726s left) gem_ctx_persistence (heartbeat-hostile)
[311.501194] Starting subtest: heartbeat-hostile
[312.997018] Subtest heartbeat-hostile: SUCCESS (1.496s)
[313.122520] [066/133] (725s left) kms_flip (flip-vs-rmfb-interruptible)
[313.216477] Starting subtest: flip-vs-rmfb-interruptible
[313.219434] Starting dynamic subtest: A-HDMI-A1
[320.857975] Dynamic subtest A-HDMI-A1: SUCCESS (7.642s)
[320.878363] Starting dynamic subtest: B-HDMI-A1
[328.497791] Dynamic subtest B-HDMI-A1: SUCCESS (7.639s)
[328.516175] Starting dynamic subtest: C-HDMI-A1
[336.136809] Dynamic subtest C-HDMI-A1: SUCCESS (7.640s)
[336.155151] Starting dynamic subtest: D-HDMI-A1
[343.787034] Dynamic subtest D-HDMI-A1: SUCCESS (7.646s)
[343.791871] Subtest flip-vs-rmfb-interruptible: SUCCESS (30.585s)
[343.955206] [067/133] (694s left) kms_color (ctm-0-75)
[344.048289] Starting subtest: ctm-0-75
[344.048971] Starting dynamic subtest: pipe-A-HDMI-A-1
[345.935401] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.884s)
[345.946215] Starting dynamic subtest: pipe-B-HDMI-A-1
[347.625157] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.685s)
[347.633472] Starting dynamic subtest: pipe-C-HDMI-A-1
[349.299060] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.669s)
[349.307566] Starting dynamic subtest: pipe-D-HDMI-A-1
[351.000232] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.699s)
[351.000919] Subtest ctm-0-75: SUCCESS (6.942s)
[351.148806] [068/133] (687s left) sriov_basic (enable-vfs-bind-unbind-each)
[351.187519] Starting subtest: enable-vfs-bind-unbind-each
[351.189030] Starting dynamic subtest: numvfs-1
[351.218854] Dynamic subtest numvfs-1: FAIL (0.018s)
[351.229363] Starting dynamic subtest: numvfs-2
[351.259876] Dynamic subtest numvfs-2: FAIL (0.006s)
[351.270046] Starting dynamic subtest: numvfs-3
[351.291526] Dynamic subtest numvfs-3: FAIL (0.007s)
[351.299678] Starting dynamic subtest: numvfs-4
[351.320774] Dynamic subtest numvfs-4: FAIL (0.009s)
[351.328727] Starting dynamic subtest: numvfs-5
[351.350313] Dynamic subtest numvfs-5: FAIL (0.006s)
[351.361212] Starting dynamic subtest: numvfs-6
[351.383907] Dynamic subtest numvfs-6: FAIL (0.006s)
[351.396143] Starting dynamic subtest: numvfs-7
[351.419242] Dynamic subtest numvfs-7: FAIL (0.006s)
[351.431627] Starting dynamic subtest: numvfs-random
[351.454495] Dynamic subtest numvfs-random: FAIL (0.007s)
[351.455302] Subtest enable-vfs-bind-unbind-each: FAIL (0.076s)
[351.493269] [069/133] (687s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier-source-clamping)
[351.581354] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier-source-clamping
[351.582700] Subtest pixel-format-4-tiled-bmg-ccs-modifier-source-clamping: SKIP (0.000s)
[351.681245] [070/133] (686s left) kms_invalid_mode (bad-vsync-start)
[351.767227] Starting subtest: bad-vsync-start
[351.767916] Starting dynamic subtest: pipe-A-HDMI-A-1
[351.810248] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.043s)
[351.819588] Starting dynamic subtest: pipe-B-HDMI-A-1
[351.820286] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[351.828014] Starting dynamic subtest: pipe-C-HDMI-A-1
[351.828693] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[351.836342] Starting dynamic subtest: pipe-D-HDMI-A-1
[351.837020] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[351.837666] Subtest bad-vsync-start: SUCCESS (0.052s)
[351.993242] [071/133] (686s left) kms_selftest (drm_dp_mst_helper)
[352.030989] Starting subtest: drm_dp_mst_helper
[352.043509] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[352.115043] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.070s)
[352.129829] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[352.196203] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.079s)
[352.206511] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[352.291839] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.093s)
[352.292607] Subtest drm_dp_mst_helper: SUCCESS (0.261s)
[352.448214] [072/133] (686s left) perf_pmu (idle)
[352.484358] Starting subtest: idle
[352.485114] Starting dynamic subtest: rcs0
[353.019741] Dynamic subtest rcs0: SUCCESS (0.525s)
[353.031442] Starting dynamic subtest: bcs0
[353.548460] Dynamic subtest bcs0: SUCCESS (0.525s)
[353.560198] Starting dynamic subtest: vcs0
[354.065386] Dynamic subtest vcs0: SUCCESS (0.514s)
[354.077098] Starting dynamic subtest: vcs1
[354.582501] Dynamic subtest vcs1: SUCCESS (0.514s)
[354.594240] Starting dynamic subtest: vecs0
[355.099354] Dynamic subtest vecs0: SUCCESS (0.514s)
[355.100367] Subtest idle: SUCCESS (2.604s)
[355.200107] [073/133] (683s left) kms_plane (pixel-format-4-tiled-modifier)
[355.289418] Starting subtest: pixel-format-4-tiled-modifier
[355.290767] Subtest pixel-format-4-tiled-modifier: SKIP (0.000s)
[355.394501] [074/133] (683s left) kms_cursor_crc (cursor-onscreen-max-size)
[355.489219] Starting subtest: cursor-onscreen-max-size
[355.491216] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[355.622331] [075/133] (683s left) gem_mmap_gtt (fault-concurrent)
[355.656575] Starting subtest: fault-concurrent
[358.913896] Subtest fault-concurrent: SUCCESS (3.220s)
[359.024075] [076/133] (679s left) kms_psr (pr-sprite-mmap-cpu)
[359.113068] Subtest pr-sprite-mmap-cpu: SKIP (0.000s)
[359.166137] [077/133] (679s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[359.257192] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[359.258540] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[359.382651] [078/133] (679s left) kms_cursor_crc (cursor-sliding-512x170)
[359.474437] Starting subtest: cursor-sliding-512x170
[359.475764] Subtest cursor-sliding-512x170: SKIP (0.001s)
[359.592292] [079/133] (679s left) gem_mmap_wc (bad-size)
[359.626424] Starting subtest: bad-size
[359.627115] Subtest bad-size: SUCCESS (0.001s)
[359.780221] [080/133] (679s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[359.866422] Starting subtest: basic-flip-before-cursor-varying-size
[360.933071] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.065s)
[361.097076] [081/133] (678s left) gem_exec_flush (basic-wb-ro-before-default)
[361.139709] Starting subtest: basic-wb-ro-before-default
[366.575467] Subtest basic-wb-ro-before-default: SUCCESS (5.432s)
[366.808827] [082/133] (672s left) gem_exec_schedule (implicit-boths)
[366.851510] Starting subtest: implicit-boths
[366.852260] Starting dynamic subtest: rcs0
[366.913835] Dynamic subtest rcs0: SUCCESS (0.061s)
[366.926294] Starting dynamic subtest: bcs0
[366.975650] Dynamic subtest bcs0: SUCCESS (0.060s)
[366.989187] Starting dynamic subtest: vcs0
[367.040267] Dynamic subtest vcs0: SUCCESS (0.062s)
[367.053275] Starting dynamic subtest: vcs1
[367.104613] Dynamic subtest vcs1: SUCCESS (0.062s)
[367.118109] Starting dynamic subtest: vecs0
[367.170374] Dynamic subtest vecs0: SUCCESS (0.064s)
[367.173169] Subtest implicit-boths: SUCCESS (0.320s)
[367.498390] [083/133] (671s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[367.940775] Starting subtest: syncobj-backward-timeline-chain-engines
[368.006130] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.074s)
[368.214984] [084/133] (671s left) kms_setmode (basic-clone-single-crtc)
[368.248208] Starting subtest: basic-clone-single-crtc
[368.250188] Subtest basic-clone-single-crtc: SKIP (0.000s)
[368.348402] [085/133] (671s left) kms_flip (plain-flip-fb-recreate)
[368.436898] Starting subtest: plain-flip-fb-recreate
[368.439720] Starting dynamic subtest: A-HDMI-A1
[376.478525] Dynamic subtest A-HDMI-A1: SUCCESS (8.034s)
[376.492536] Starting dynamic subtest: B-HDMI-A1
[384.480154] Dynamic subtest B-HDMI-A1: SUCCESS (7.996s)
[384.498445] Starting dynamic subtest: C-HDMI-A1
[392.483818] Dynamic subtest C-HDMI-A1: SUCCESS (7.999s)
[392.500775] Starting dynamic subtest: D-HDMI-A1
[400.488686] Dynamic subtest D-HDMI-A1: SUCCESS (8.001s)
[400.493457] Subtest plain-flip-fb-recreate: SUCCESS (32.047s)
[400.698873] [086/133] (638s left) gem_exec_schedule (u-fairslice-all)
[400.745430] Starting subtest: u-fairslice-all
[402.783760] Subtest u-fairslice-all: SUCCESS (2.038s)
[403.108322] [087/133] (636s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[403.197446] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[403.198142] Starting dynamic subtest: pipe-A-HDMI-A-1
[403.204674] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[403.213750] Starting dynamic subtest: pipe-B-HDMI-A-1
[403.220758] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[403.229623] Starting dynamic subtest: pipe-C-HDMI-A-1
[403.236089] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[403.244549] Starting dynamic subtest: pipe-D-HDMI-A-1
[403.251153] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[403.252470] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.007s)
[403.463166] [088/133] (636s left) kms_addfb_basic (unused-handle)
[403.497734] Starting subtest: unused-handle
[403.498446] Subtest unused-handle: SUCCESS (0.000s)
[403.671614] [089/133] (635s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[403.758120] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.000s)
[403.807533] [090/133] (635s left) gem_exec_schedule (preempt-queue)
[403.854794] Starting subtest: preempt-queue
[403.855508] Starting dynamic subtest: rcs0
[403.969815] Dynamic subtest rcs0: SUCCESS (0.108s)
[403.980075] Starting dynamic subtest: bcs0
[404.075443] Dynamic subtest bcs0: SUCCESS (0.111s)
[404.086300] Starting dynamic subtest: vcs0
[404.182052] Dynamic subtest vcs0: SUCCESS (0.105s)
[404.191590] Starting dynamic subtest: vcs1
[404.289483] Dynamic subtest vcs1: SUCCESS (0.106s)
[404.299075] Starting dynamic subtest: vecs0
[404.397791] Dynamic subtest vecs0: SUCCESS (0.107s)
[404.398580] Subtest preempt-queue: SUCCESS (0.543s)
[404.735662] [091/133] (634s left) i915_fb_tiling (basic-x-tiling)
[404.769870] Starting subtest: basic-x-tiling
[404.770611] Subtest basic-x-tiling: SUCCESS (0.000s)
[404.885665] [092/133] (634s left) kms_psr (psr-sprite-plane-onoff)
[404.975149] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[405.021140] [093/133] (634s left) gem_exec_reloc (basic-cpu)
[405.060179] Starting subtest: basic-cpu
[405.064474] Subtest basic-cpu: SUCCESS (0.005s)
[405.227852] [094/133] (634s left) gem_mmap_gtt (medium-copy-odd)
[405.261195] Starting subtest: medium-copy-odd
[408.890423] Subtest medium-copy-odd: SUCCESS (3.628s)
[408.983421] [095/133] (630s left) gem_exec_whisper (basic-sync-all)
[409.075075] Starting subtest: basic-sync-all
[410.545552] Subtest basic-sync-all: SUCCESS (1.470s)
[410.770863] [096/133] (629s left) kms_frontbuffer_tracking (fbc-tiling-4)
[410.873862] Starting subtest: fbc-tiling-4
[410.875326] Subtest fbc-tiling-4: SKIP (0.000s)
[410.994231] [097/133] (628s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[411.084193] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[413.811114] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (2.727s)
[413.995013] [098/133] (625s left) gem_exec_reloc (basic-write-wc-active)
[414.036214] Starting subtest: basic-write-wc-active
[414.163585] Subtest basic-write-wc-active: SUCCESS (0.119s)
[414.319487] [099/133] (625s left) prime_vgem (fence-wait)
[414.392633] Starting subtest: fence-wait
[414.393401] Starting dynamic subtest: rcs0
[415.444240] Dynamic subtest rcs0: SUCCESS (1.042s)
[415.456339] Starting dynamic subtest: bcs0
[416.466329] Dynamic subtest bcs0: SUCCESS (1.020s)
[416.478569] Starting dynamic subtest: vcs0
[417.490587] Dynamic subtest vcs0: SUCCESS (1.022s)
[417.502907] Starting dynamic subtest: vcs1
[418.515240] Dynamic subtest vcs1: SUCCESS (1.022s)
[418.527701] Starting dynamic subtest: vecs0
[419.539153] Dynamic subtest vecs0: SUCCESS (1.021s)
[419.540160] Subtest fence-wait: SUCCESS (5.139s)
[419.664890] [100/133] (620s left) gem_exec_parallel (basic)
[419.706360] Starting subtest: basic
[419.707119] Starting dynamic subtest: rcs0
[421.462528] Dynamic subtest rcs0: SUCCESS (1.756s)
[421.474032] Starting dynamic subtest: bcs0
[423.165334] Dynamic subtest bcs0: SUCCESS (1.702s)
[423.176603] Starting dynamic subtest: vcs0
[424.937712] Dynamic subtest vcs0: SUCCESS (1.771s)
[424.948239] Starting dynamic subtest: vcs1
[426.668134] Dynamic subtest vcs1: SUCCESS (1.729s)
[426.677844] Starting dynamic subtest: vecs0
[428.409500] Dynamic subtest vecs0: SUCCESS (1.741s)
[428.410289] Subtest basic: SUCCESS (8.705s)
[428.642402] [101/133] (611s left) gem_render_copy (yf-tiled-to-vebox-linear)
[428.682371] Starting subtest: yf-tiled-to-vebox-linear
[428.683096] Starting dynamic subtest: smem
[428.748807] Dynamic subtest smem: SUCCESS (0.066s)
[428.749575] Subtest yf-tiled-to-vebox-linear: SUCCESS (0.067s)
[428.960307] [102/133] (611s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[429.054496] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[429.055953] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[429.171507] [103/133] (610s left) kms_cursor_legacy (single-bo)
[429.261042] Starting subtest: single-bo
[429.261815] Starting dynamic subtest: pipe-A
[434.650014] Dynamic subtest pipe-A: SUCCESS (5.380s)
[434.658712] Starting dynamic subtest: pipe-B
[440.054619] Dynamic subtest pipe-B: SUCCESS (5.379s)
[440.063557] Starting dynamic subtest: pipe-C
[445.435233] Dynamic subtest pipe-C: SUCCESS (5.378s)
[445.444078] Starting dynamic subtest: pipe-D
[450.811563] Dynamic subtest pipe-D: SUCCESS (5.378s)
[450.820426] Starting dynamic subtest: all-pipes
[456.190776] Dynamic subtest all-pipes: SUCCESS (5.379s)
[456.191923] Subtest single-bo: SUCCESS (26.900s)
[456.254878] [104/133] (583s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[456.298224] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[456.407340] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.107s)
[456.527702] [105/133] (583s left) syncobj_timeline (signal-array)
[456.563452] Starting subtest: signal-array
[456.564171] Subtest signal-array: SUCCESS (0.000s)
[456.658262] [106/133] (583s left) kms_chamelium_audio (hdmi-audio-edid)
[456.787748] Subtest hdmi-audio-edid: SKIP (0.000s)
[456.870048] [107/133] (583s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[456.965388] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[456.966808] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[457.114489] [108/133] (583s left) gem_userptr_blits (relocations)
[457.153497] Starting subtest: relocations
[457.155433] Subtest relocations: SUCCESS (0.002s)
[457.304236] [109/133] (583s left) gem_lmem_swapping (parallel-random-verify)
[457.341971] Subtest parallel-random-verify: SKIP (0.000s)
[457.406333] [110/133] (583s left) kms_atomic (plane-overlay-legacy)
[457.493858] Starting subtest: plane-overlay-legacy
[457.494554] Starting dynamic subtest: pipe-A-HDMI-A-1
[457.772507] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.278s)
[457.773266] Subtest plane-overlay-legacy: SUCCESS (0.280s)
[457.964049] [111/133] (582s left) sw_sync (sync_busy_fork_unixsocket)
[457.999450] Starting subtest: sync_busy_fork_unixsocket
[458.007721] Subtest sync_busy_fork_unixsocket: SUCCESS (0.009s)
[458.094182] [112/133] (582s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[458.187438] Starting subtest: fbc-rgb101010-draw-mmap-wc
[461.024130] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (2.838s)
[461.171308] [113/133] (579s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25)
[461.262425] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25
[461.263204] Starting dynamic subtest: pipe-A
[461.454315] Dynamic subtest pipe-A: SUCCESS (0.192s)
[461.472345] Starting dynamic subtest: pipe-B
[461.613118] Dynamic subtest pipe-B: SUCCESS (0.157s)
[461.632499] Starting dynamic subtest: pipe-C
[461.773308] Dynamic subtest pipe-C: SUCCESS (0.158s)
[461.792727] Starting dynamic subtest: pipe-D
[461.933520] Dynamic subtest pipe-D: SUCCESS (0.158s)
[461.934670] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SUCCESS (0.673s)
[462.143033] [114/133] (578s left) gem_mmap_offset (open-flood)
[462.178413] Starting subtest: open-flood
[483.681096] Subtest open-flood: SUCCESS (21.500s)
[483.811539] [115/133] (556s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[483.904782] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[483.906181] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[484.059120] [116/133] (556s left) i915_query (engine-info)
[484.094011] Starting subtest: engine-info
[484.095691] Subtest engine-info: SUCCESS (0.002s)
[484.192242] [117/133] (556s left) kms_busy (extended-modeset-hang-oldfb-with-reset)
[484.289219] Starting subtest: extended-modeset-hang-oldfb-with-reset
[484.291187] Starting dynamic subtest: pipe-A
[485.889456] Dynamic subtest pipe-A: SUCCESS (1.597s)
[485.900786] Starting dynamic subtest: pipe-D
[487.448558] Dynamic subtest pipe-D: SUCCESS (1.555s)
[487.449337] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (3.159s)
[487.623788] [118/133] (553s left) kms_pm_rpm (cursor-dpms)
[489.029809] Starting subtest: cursor-dpms
[501.102629] Subtest cursor-dpms: SUCCESS (12.070s)
[501.346960] [119/133] (539s left) gem_eio (kms)
[501.445104] Starting subtest: kms
[523.822728] Subtest kms: SUCCESS (22.375s)
[523.982337] [120/133] (516s left) dumb_buffer (create-valid-dumb)
[524.017620] Starting subtest: create-valid-dumb
[524.018373] Subtest create-valid-dumb: SUCCESS (0.000s)
[524.134564] [121/133] (516s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size)
[524.223518] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size
[535.095856] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (10.872s)
[535.266151] [122/133] (505s left) kms_getfb (getfb2-handle-zero)
[535.357492] Starting subtest: getfb2-handle-zero
[535.358339] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[535.487081] [123/133] (505s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt)
[535.578344] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt
[535.579829] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[535.721287] [124/133] (505s left) kms_plane (plane-position-hole-dpms)
[535.808614] Starting subtest: plane-position-hole-dpms
[536.179551] Starting dynamic subtest: pipe-A-plane-1
[536.639562] Dynamic subtest pipe-A-plane-1: SUCCESS (0.461s)
[536.648896] Starting dynamic subtest: pipe-A-plane-2
[537.103426] Dynamic subtest pipe-A-plane-2: SUCCESS (0.463s)
[537.112833] Starting dynamic subtest: pipe-A-plane-3
[537.574023] Dynamic subtest pipe-A-plane-3: SUCCESS (0.470s)
[537.585277] Starting dynamic subtest: pipe-A-plane-4
[538.040337] Dynamic subtest pipe-A-plane-4: SUCCESS (0.465s)
[538.049579] Starting dynamic subtest: pipe-A-plane-5
[538.499238] Dynamic subtest pipe-A-plane-5: SUCCESS (0.458s)
[538.508480] Starting dynamic subtest: pipe-A-plane-6
[538.960113] Dynamic subtest pipe-A-plane-6: SUCCESS (0.460s)
[538.969187] Starting dynamic subtest: pipe-A-plane-7
[538.970532] Dynamic subtest pipe-A-plane-7: SUCCESS (0.002s)
[539.221272] Starting dynamic subtest: pipe-B-plane-1
[539.656417] Dynamic subtest pipe-B-plane-1: SUCCESS (0.443s)
[539.665765] Starting dynamic subtest: pipe-B-plane-2
[540.081922] Dynamic subtest pipe-B-plane-2: SUCCESS (0.424s)
[540.093896] Starting dynamic subtest: pipe-B-plane-3
[540.541328] Dynamic subtest pipe-B-plane-3: SUCCESS (0.459s)
[540.551825] Starting dynamic subtest: pipe-B-plane-4
[540.991434] Dynamic subtest pipe-B-plane-4: SUCCESS (0.448s)
[541.001790] Starting dynamic subtest: pipe-B-plane-5
[541.442235] Dynamic subtest pipe-B-plane-5: SUCCESS (0.449s)
[541.451501] Starting dynamic subtest: pipe-B-plane-6
[541.885301] Dynamic subtest pipe-B-plane-6: SUCCESS (0.442s)
[541.894742] Starting dynamic subtest: pipe-B-plane-7
[541.896094] Dynamic subtest pipe-B-plane-7: SUCCESS (0.002s)
[541.896778] Subtest plane-position-hole-dpms: SUCCESS (6.081s)
[542.083427] [125/133] (499s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render)
[542.178507] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render
[542.179946] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[542.327831] [126/133] (498s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[542.362534] Starting subtest: invalid-multi-wait-unsubmitted
[542.363246] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[542.461579] [127/133] (498s left) kms_flip (2x-flip-vs-panning-vs-hang)
[542.550249] Starting subtest: 2x-flip-vs-panning-vs-hang
[542.553157] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.002s)
[542.670779] [128/133] (498s left) gem_exec_whisper (basic-fds-all)
[542.715262] Starting subtest: basic-fds-all
[545.217493] Subtest basic-fds-all: SUCCESS (2.502s)
[545.436795] [129/133] (495s left) gem_exec_balancer (bonded-sync)
[545.483508] Starting subtest: bonded-sync
[560.256568] Subtest bonded-sync: SUCCESS (14.766s)
[560.471124] [130/133] (480s left) kms_chamelium_hpd (hdmi-hpd-storm)
[560.619213] Subtest hdmi-hpd-storm: SKIP (0.000s)
[560.704947] [131/133] (480s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[560.745056] Starting subtest: invalid-bsd2-flag-on-vebox
[560.745910] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s)
[560.890876] [132/133] (480s left) gem_render_copy_redux (flink)
[560.929945] Starting subtest: flink
[561.717168] Subtest flink: SUCCESS (0.787s)
[561.877504] [133/133] (479s left) kms_vblank (wait-busy-hang)
[561.965537] Starting subtest: wait-busy-hang
[561.966290] Starting dynamic subtest: pipe-A-HDMI-A-1
[576.695800] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (14.730s)
[576.707760] Starting dynamic subtest: pipe-D-HDMI-A-1
[590.489219] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (13.788s)
[590.489929] Subtest wait-busy-hang: SUCCESS (28.524s)
[590.667111] Closing watchdogs
results: parsing output: 0/ for test: api_intel_bb
results: parsing output: 1/ for test: gem_exec_reloc
results: parsing output: 2/ for test: perf
results: parsing output: 3/ for test: gem_mmap_gtt
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: i915_pm_rpm
results: parsing output: 6/ for test: gem_render_copy
results: parsing output: 7/ for test: gen9_exec_parse
results: parsing output: 8/ for test: kms_psr
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: gen7_exec_parse
results: parsing output: 11/ for test: kms_flip
results: parsing output: 12/ for test: gem_busy
results: parsing output: 13/ for test: kms_prop_blob
results: parsing output: 14/ for test: gem_create
results: parsing output: 15/ for test: gem_exec_flush
results: parsing output: 16/ for test: kms_rotation_crc
results: parsing output: 17/ for test: kms_ccs
results: parsing output: 18/ for test: gem_ctx_isolation
results: parsing output: 19/ for test: gem_eio
results: parsing output: 20/ for test: kms_tv_load_detect
results: parsing output: 21/ for test: kms_psr
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: kms_chamelium_frames
results: parsing output: 25/ for test: kms_cursor_legacy
results: parsing output: 26/ for test: kms_addfb_basic
results: parsing output: 27/ for test: kms_fb_coherency
results: parsing output: 28/ for test: gem_eio
results: parsing output: 29/ for test: sysfs_heartbeat_interval
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_big_fb
results: parsing output: 32/ for test: gem_workarounds
results: parsing output: 33/ for test: gem_exec_reloc
results: parsing output: 34/ for test: kms_flip
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_cursor_crc
results: parsing output: 38/ for test: perf
results: parsing output: 39/ for test: kms_flip_scaled_crc
results: parsing output: 40/ for test: kms_prime
results: parsing output: 41/ for test: syncobj_wait
results: parsing output: 42/ for test: gem_create
results: parsing output: 43/ for test: gem_spin_batch
results: parsing output: 44/ for test: kms_psr2_sf
results: parsing output: 45/ for test: kms_pipe_crc_basic
results: parsing output: 46/ for test: kms_async_flips
results: parsing output: 47/ for test: prime_mmap
results: parsing output: 48/ for test: kms_big_fb
results: parsing output: 49/ for test: api_intel_allocator
results: parsing output: 50/ for test: gem_vm_create
results: parsing output: 51/ for test: kms_ccs
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: kms_flip
results: parsing output: 54/ for test: kms_setmode
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: kms_content_protection
results: parsing output: 57/ for test: gem_exec_fence
results: parsing output: 58/ for test: kms_lease
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: kms_feature_discovery
results: parsing output: 63/ for test: vgem_basic
results: parsing output: 64/ for test: gem_ctx_persistence
results: parsing output: 65/ for test: kms_flip
results: parsing output: 66/ for test: kms_color
results: parsing output: 67/ for test: sriov_basic
results: parsing output: 68/ for test: kms_plane
results: parsing output: 69/ for test: kms_invalid_mode
results: parsing output: 70/ for test: kms_selftest
results: parsing output: 71/ for test: perf_pmu
results: parsing output: 72/ for test: kms_plane
results: parsing output: 73/ for test: kms_cursor_crc
results: parsing output: 74/ for test: gem_mmap_gtt
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_cursor_crc
results: parsing output: 78/ for test: gem_mmap_wc
results: parsing output: 79/ for test: kms_cursor_legacy
results: parsing output: 80/ for test: gem_exec_flush
results: parsing output: 81/ for test: gem_exec_schedule
results: parsing output: 82/ for test: gem_exec_fence
results: parsing output: 83/ for test: kms_setmode
results: parsing output: 84/ for test: kms_flip
results: parsing output: 85/ for test: gem_exec_schedule
results: parsing output: 86/ for test: kms_ccs
results: parsing output: 87/ for test: kms_addfb_basic
results: parsing output: 88/ for test: kms_psr
results: parsing output: 89/ for test: gem_exec_schedule
results: parsing output: 90/ for test: i915_fb_tiling
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: gem_exec_reloc
results: parsing output: 93/ for test: gem_mmap_gtt
results: parsing output: 94/ for test: gem_exec_whisper
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: gem_exec_reloc
results: parsing output: 98/ for test: prime_vgem
results: parsing output: 99/ for test: gem_exec_parallel
results: parsing output: 100/ for test: gem_render_copy
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_cursor_legacy
results: parsing output: 103/ for test: syncobj_timeline
results: parsing output: 104/ for test: syncobj_timeline
results: parsing output: 105/ for test: kms_chamelium_audio
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_userptr_blits
results: parsing output: 108/ for test: gem_lmem_swapping
results: parsing output: 109/ for test: kms_atomic
results: parsing output: 110/ for test: sw_sync
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_plane_scaling
results: parsing output: 113/ for test: gem_mmap_offset
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: i915_query
results: parsing output: 116/ for test: kms_busy
results: parsing output: 117/ for test: kms_pm_rpm
results: parsing output: 118/ for test: gem_eio
results: parsing output: 119/ for test: dumb_buffer
results: parsing output: 120/ for test: kms_cursor_legacy
results: parsing output: 121/ for test: kms_getfb
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_plane
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: syncobj_timeline
results: parsing output: 126/ for test: kms_flip
results: parsing output: 127/ for test: gem_exec_whisper
results: parsing output: 128/ for test: gem_exec_balancer
results: parsing output: 129/ for test: kms_chamelium_hpd
results: parsing output: 130/ for test: gem_exec_params
results: parsing output: 131/ for test: gem_render_copy_redux
results: parsing output: 132/ for test: kms_vblank
Done.