[65.244653] Initializing watchdogs
[65.244715]   /dev/watchdog0
[65.258747] [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]
[65.263451] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[65.266150] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[65.268135] [001/130] (960s left) kms_vblank (wait-busy-hang)
[65.441719] Starting subtest: wait-busy-hang
[65.442416] Starting dynamic subtest: pipe-A-HDMI-A-1
[79.557620] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (14.105s)
[79.564166] Starting dynamic subtest: pipe-D-HDMI-A-1
[93.873549] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (14.313s)
[93.874272] Subtest wait-busy-hang: SUCCESS (28.423s)
[94.030650] [002/130] (931s left) gem_render_linear_blits (basic)
[94.075381] Starting subtest: basic
[94.105558] Subtest basic: SUCCESS (0.030s)
[94.165991] [003/130] (931s left) gem_exec_flush (basic-wb-rw-before-default)
[94.212608] Starting subtest: basic-wb-rw-before-default
[99.649975] Subtest basic-wb-rw-before-default: SUCCESS (5.437s)
[99.852456] [004/130] (926s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[99.958959] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[99.960332] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[100.049282] [005/130] (925s left) kms_color (invalid-ctm-matrix-sizes)
[100.139717] Starting subtest: invalid-ctm-matrix-sizes
[100.140468] Starting dynamic subtest: pipe-A
[100.143119] Dynamic subtest pipe-A: SUCCESS (0.004s)
[100.149334] Starting dynamic subtest: pipe-B
[100.151224] Dynamic subtest pipe-B: SUCCESS (0.008s)
[100.157323] Starting dynamic subtest: pipe-C
[100.159469] Dynamic subtest pipe-C: SUCCESS (0.008s)
[100.165292] Starting dynamic subtest: pipe-D
[100.168314] Dynamic subtest pipe-D: SUCCESS (0.009s)
[100.169080] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.029s)
[100.218325] [006/130] (925s left) gen7_exec_parse (basic-rejected)
[100.258265] Subtest basic-rejected: SKIP (0.000s)
[100.296253] [007/130] (925s left) gem_exec_fence (syncobj-channel)
[100.652900] Starting subtest: syncobj-channel
[101.686100] Subtest syncobj-channel: SUCCESS (1.024s)
[101.989959] [FACT gem_exec_fence (syncobj-channel)] new: kernel.kmod_is_loaded.vgem: true
[101.993118] [008/130] (924s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[102.088826] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[102.090261] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[102.177544] [009/130] (923s left) kms_ccs (crc-sprite-planes-basic-4-tiled-lnl-ccs)
[102.263714] Starting subtest: crc-sprite-planes-basic-4-tiled-lnl-ccs
[102.265153] Subtest crc-sprite-planes-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[102.417246] [010/130] (923s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[102.506650] Starting subtest: modeset-transition-nonblocking-fencing
[102.507412] Starting dynamic subtest: 1x-outputs
[103.710639] Dynamic subtest 1x-outputs: SUCCESS (1.204s)
[103.737599] Subtest modeset-transition-nonblocking-fencing: SUCCESS (1.231s)
[103.871588] [011/130] (922s left) gem_pxp (reject-modify-context-protection-off-3)
[103.975951] Starting subtest: reject-modify-context-protection-off-3
[103.977294] Subtest reject-modify-context-protection-off-3: SUCCESS (0.001s)
[104.046826] [012/130] (922s left) kms_chamelium_hpd (hdmi-hpd-storm-disable)
[104.187982] Subtest hdmi-hpd-storm-disable: SKIP (0.000s)
[104.266968] [013/130] (921s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[104.362763] Starting subtest: cursor-rapid-movement-256x256
[104.366755] Starting dynamic subtest: pipe-A-HDMI-A-1
[104.621614] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.254s)
[104.651787] Starting dynamic subtest: pipe-D-HDMI-A-1
[104.850910] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.205s)
[104.851650] Subtest cursor-rapid-movement-256x256: SUCCESS (0.488s)
[104.977534] [014/130] (921s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[105.069604] Starting subtest: primary-x-tiled-reflect-x-180
[108.691095] Subtest primary-x-tiled-reflect-x-180: SUCCESS (3.621s)
[108.890578] [015/130] (917s left) gem_workarounds (reset)
[108.939722] Starting subtest: reset
[108.948043] Subtest reset: SUCCESS (0.008s)
[109.068619] [016/130] (917s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[109.167049] Starting subtest: x-tiled-64bpp-rotate-90
[109.213350] Subtest x-tiled-64bpp-rotate-90: SKIP (0.046s)
[109.343777] [017/130] (916s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[109.435576] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[109.436930] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[109.525593] [018/130] (916s left) gem_fenced_exec_thrash (too-many-fences)
[109.562579] Starting subtest: too-many-fences
[111.717720] Subtest too-many-fences: SUCCESS (2.152s)
[111.854677] [019/130] (914s left) drm_mm (drm_mm)
[111.891461] Starting subtest: drm_mm
[111.898465] Starting dynamic subtest: drm_test_mm_init
[111.999660] Dynamic subtest drm_test_mm_init: SUCCESS (0.101s)
[112.005364] Starting dynamic subtest: drm_test_mm_debug
[112.112385] Dynamic subtest drm_test_mm_debug: SUCCESS (0.112s)
[112.126273] Starting dynamic subtest: drm_test_mm_align32
[112.185666] Dynamic subtest drm_test_mm_align32: SUCCESS (0.072s)
[112.199603] Starting dynamic subtest: drm_test_mm_align64
[112.273782] Dynamic subtest drm_test_mm_align64: SUCCESS (0.088s)
[112.287453] Starting dynamic subtest: drm_test_mm_lowest
[112.382446] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.108s)
[112.396048] Starting dynamic subtest: drm_test_mm_highest
[112.500433] Dynamic subtest drm_test_mm_highest: SUCCESS (0.117s)
[112.501644] Subtest drm_mm: SUCCESS (0.608s)
[112.663334] [020/130] (913s left) drm_buddy (drm_buddy)
[112.699051] Starting subtest: drm_buddy
[112.701737] Starting dynamic subtest: drm_test_buddy_alloc_limit
[112.805667] Dynamic subtest drm_test_buddy_alloc_limit: SUCCESS (0.102s)
[112.814738] Starting dynamic subtest: drm_test_buddy_alloc_optimistic
[112.882513] Dynamic subtest drm_test_buddy_alloc_optimistic: SUCCESS (0.077s)
[112.897863] Starting dynamic subtest: drm_test_buddy_alloc_pessimistic
[112.996359] Dynamic subtest drm_test_buddy_alloc_pessimistic: SUCCESS (0.113s)
[113.011874] Starting dynamic subtest: drm_test_buddy_alloc_pathological
[113.095350] Dynamic subtest drm_test_buddy_alloc_pathological: SUCCESS (0.098s)
[113.109854] Starting dynamic subtest: drm_test_buddy_alloc_contiguous
[113.186869] Dynamic subtest drm_test_buddy_alloc_contiguous: SUCCESS (0.090s)
[113.202064] Starting dynamic subtest: drm_test_buddy_alloc_clear
[113.338576] Dynamic subtest drm_test_buddy_alloc_clear: SUCCESS (0.152s)
[113.344099] Starting dynamic subtest: drm_test_buddy_alloc_range_bias
[113.450977] Dynamic subtest drm_test_buddy_alloc_range_bias: SUCCESS (0.112s)
[113.451806] Subtest drm_buddy: SUCCESS (0.752s)
[113.616755] [021/130] (912s left) kms_getfb (getfb-handle-zero)
[113.653456] Starting subtest: getfb-handle-zero
[113.654213] Subtest getfb-handle-zero: SUCCESS (0.000s)
[113.740897] [022/130] (912s left) kms_psr (fbc-psr2-basic)
[113.830529] Subtest fbc-psr2-basic: SKIP (0.000s)
[113.866563] [023/130] (912s left) api_intel_bb (intel-bb-blit-none)
[113.904385] Starting subtest: intel-bb-blit-none
[117.367914] Subtest intel-bb-blit-none: SUCCESS (3.429s)
[117.451587] [024/130] (909s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[117.547005] Starting subtest: x-tiled-16bpp-rotate-90
[117.621518] Subtest x-tiled-16bpp-rotate-90: SKIP (0.074s)
[117.745766] [025/130] (908s left) gem_exec_whisper (basic-sync-all)
[117.793519] Starting subtest: basic-sync-all
[119.153894] Subtest basic-sync-all: SUCCESS (1.360s)
[119.338367] [026/130] (907s left) kms_atomic (crtc-invalid-params-fence)
[119.428049] Starting subtest: crtc-invalid-params-fence
[119.428817] Starting dynamic subtest: pipe-A-HDMI-A-1
[119.607056] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.179s)
[119.607819] Subtest crtc-invalid-params-fence: SUCCESS (0.180s)
[119.740819] [027/130] (906s left) kms_dp_link_training (uhbr-mst)
[119.830698] Starting subtest: uhbr-mst
[119.832156] Subtest uhbr-mst: SKIP (0.000s)
[119.880709] [028/130] (906s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-25)
[119.967614] Starting subtest: planes-unity-scaling-downscale-factor-0-25
[119.968345] Starting dynamic subtest: pipe-A
[121.522330] Dynamic subtest pipe-A: SKIP (1.552s)
[121.528900] Starting dynamic subtest: pipe-B
[123.838605] Dynamic subtest pipe-B: SKIP (2.316s)
[123.844138] Starting dynamic subtest: pipe-C
[126.161921] Dynamic subtest pipe-C: SKIP (2.323s)
[126.167808] Starting dynamic subtest: pipe-D
[128.520497] Dynamic subtest pipe-D: SKIP (2.359s)
[128.521918] Subtest planes-unity-scaling-downscale-factor-0-25: SKIP (8.552s)
[128.600399] [029/130] (898s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt)
[128.719755] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt
[128.721224] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[128.800321] [030/130] (898s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[128.898207] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[128.906911] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.009s)
[128.967416] [031/130] (897s left) kms_flip (dpms-off-confusion)
[129.057532] Starting subtest: dpms-off-confusion
[129.059476] Starting dynamic subtest: A-HDMI-A1
[136.736554] Dynamic subtest A-HDMI-A1: SUCCESS (7.677s)
[136.750505] Starting dynamic subtest: B-HDMI-A1
[144.392826] Dynamic subtest B-HDMI-A1: SUCCESS (7.649s)
[144.401507] Starting dynamic subtest: C-HDMI-A1
[152.049053] Dynamic subtest C-HDMI-A1: SUCCESS (7.655s)
[152.058970] Starting dynamic subtest: D-HDMI-A1
[159.720710] Dynamic subtest D-HDMI-A1: SUCCESS (7.669s)
[159.721738] Subtest dpms-off-confusion: SUCCESS (30.660s)
[159.878733] [032/130] (867s left) kms_getfb (getfb-addfb-different-handles)
[159.917108] Starting subtest: getfb-addfb-different-handles
[159.917829] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[160.021807] [033/130] (866s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[160.059204] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[160.059953] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[160.127113] [034/130] (866s left) gem_exec_fence (basic-await)
[160.302608] Starting subtest: basic-await
[160.303562] Starting dynamic subtest: rcs0
[160.388866] Dynamic subtest rcs0: SUCCESS (0.085s)
[160.403085] Starting dynamic subtest: bcs0
[160.481178] Dynamic subtest bcs0: SUCCESS (0.090s)
[160.495212] Starting dynamic subtest: vcs0
[160.572153] Dynamic subtest vcs0: SUCCESS (0.088s)
[160.587925] Starting dynamic subtest: vcs1
[160.665886] Dynamic subtest vcs1: SUCCESS (0.091s)
[160.681171] Starting dynamic subtest: vecs0
[160.758580] Dynamic subtest vecs0: SUCCESS (0.089s)
[160.759667] Subtest basic-await: SUCCESS (0.456s)
[161.235009] [035/130] (865s left) kms_prop_blob (blob-prop-validate)
[161.272270] Starting subtest: blob-prop-validate
[161.273078] Subtest blob-prop-validate: SUCCESS (0.000s)
[161.330882] [036/130] (865s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[161.373993] Starting subtest: y-tiled-ccs-to-x-tiled
[161.375235] Starting dynamic subtest: smem
[161.481556] Dynamic subtest smem: SUCCESS (0.107s)
[161.482353] Subtest y-tiled-ccs-to-x-tiled: SUCCESS (0.108s)
[161.659194] [037/130] (865s left) gem_exec_schedule (u-semaphore-user)
[161.709290] Starting subtest: u-semaphore-user
[161.715787] Subtest u-semaphore-user: SUCCESS (0.006s)
[162.020913] [038/130] (865s left) kms_big_fb (yf-tiled-addfb-size-overflow)
[162.117300] Starting subtest: yf-tiled-addfb-size-overflow
[162.118748] Subtest yf-tiled-addfb-size-overflow: SKIP (0.000s)
[162.223396] [039/130] (864s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[162.316920] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[162.318367] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[162.404688] [040/130] (864s left) gem_softpin (allocator-evict)
[162.444809] Starting subtest: allocator-evict
[162.445533] Starting dynamic subtest: rcs0
[188.207769] Dynamic subtest rcs0: SUCCESS (25.753s)
[188.213975] Starting dynamic subtest: bcs0
[213.735829] Dynamic subtest bcs0: SUCCESS (25.526s)
[213.744094] Starting dynamic subtest: vcs0
[239.206070] Dynamic subtest vcs0: SUCCESS (25.469s)
[239.212276] Starting dynamic subtest: vcs1
[264.703737] Dynamic subtest vcs1: SUCCESS (25.496s)
[264.710129] Starting dynamic subtest: vecs0
[290.118896] Dynamic subtest vecs0: SUCCESS (25.414s)
[290.119662] Subtest allocator-evict: SUCCESS (127.663s)
[290.176723] [041/130] (737s left) gem_exec_parallel (basic)
[290.267262] Starting subtest: basic
[290.268016] Starting dynamic subtest: rcs0
[291.807383] Dynamic subtest rcs0: SUCCESS (1.539s)
[291.813529] Starting dynamic subtest: bcs0
[293.317237] Dynamic subtest bcs0: SUCCESS (1.509s)
[293.328131] Starting dynamic subtest: vcs0
[294.821842] Dynamic subtest vcs0: SUCCESS (1.503s)
[294.828244] Starting dynamic subtest: vcs1
[296.301997] Dynamic subtest vcs1: SUCCESS (1.479s)
[296.309706] Starting dynamic subtest: vecs0
[297.782550] Dynamic subtest vecs0: SUCCESS (1.480s)
[297.783418] Subtest basic: SUCCESS (7.516s)
[297.969718] [042/130] (729s left) gem_userptr_blits (sync-overlap)
[298.019551] Starting subtest: sync-overlap
[298.020312] Subtest sync-overlap: SUCCESS (0.000s)
[298.145194] [043/130] (729s left) kms_flip (bo-too-big-interruptible)
[298.250728] Starting subtest: bo-too-big-interruptible
[298.253929] Starting dynamic subtest: A-HDMI-A1
[299.117493] Dynamic subtest A-HDMI-A1: SUCCESS (0.863s)
[299.127137] Starting dynamic subtest: B-HDMI-A1
[299.949863] Dynamic subtest B-HDMI-A1: SUCCESS (0.826s)
[299.956694] Starting dynamic subtest: C-HDMI-A1
[300.761356] Dynamic subtest C-HDMI-A1: SUCCESS (0.812s)
[300.767741] Starting dynamic subtest: D-HDMI-A1
[301.576993] Dynamic subtest D-HDMI-A1: SUCCESS (0.813s)
[301.577762] Subtest bo-too-big-interruptible: SUCCESS (3.326s)
[301.794427] [044/130] (725s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[301.898986] Starting subtest: fbcpsr-rgb565-draw-pwrite
[301.900385] Subtest fbcpsr-rgb565-draw-pwrite: SKIP (0.000s)
[302.009909] [045/130] (725s left) gem_pipe_control_store_loop (reused-buffer)
[302.048879] Starting subtest: reused-buffer
[304.207612] Subtest reused-buffer: SUCCESS (2.150s)
[304.322387] [046/130] (723s left) perf (low-oa-exponent-permissions)
[304.422804] Starting subtest: low-oa-exponent-permissions
[304.474100] Subtest low-oa-exponent-permissions: SUCCESS (0.052s)
[304.508936] [047/130] (722s left) kms_fbcon_fbt (psr)
[304.549494] Starting subtest: psr
[304.550934] Subtest psr: SKIP (0.000s)
[304.656904] [048/130] (722s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k)
[304.802283] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s)
[304.901195] [049/130] (722s left) gem_huc_copy (huc-copy)
[304.944268] Starting subtest: huc-copy
[304.945808] Subtest huc-copy: SKIP (0.000s)
[305.067449] [050/130] (722s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[305.158857] Starting subtest: fbc-rgb565-draw-blt
[306.422142] Subtest fbc-rgb565-draw-blt: SUCCESS (1.263s)
[306.548053] [051/130] (721s left) syncobj_wait (wait-any-snapshot)
[306.588015] Starting subtest: wait-any-snapshot
[306.670742] Subtest wait-any-snapshot: SUCCESS (0.082s)
[306.732584] [052/130] (720s left) gem_exec_balancer (full-late-pulse)
[306.780208] Starting subtest: full-late-pulse
[308.180265] Subtest full-late-pulse: SUCCESS (1.401s)
[308.364689] [053/130] (719s left) i915_query (engine-info-invalid)
[308.400965] Starting subtest: engine-info-invalid
[308.401753] Subtest engine-info-invalid: SUCCESS (0.000s)
[308.461750] [054/130] (719s left) gem_pread (snoop)
[308.500125] Starting subtest: snoop
[309.268963] Subtest snoop: SUCCESS (0.760s)
[309.338313] [055/130] (718s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[309.434366] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[309.435904] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[309.523193] [056/130] (718s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[309.618106] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[309.619493] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[309.690936] [057/130] (718s left) i915_getparams_basic (basic-eu-total)
[309.729122] Starting subtest: basic-eu-total
[309.731034] Subtest basic-eu-total: SUCCESS (0.000s)
[309.803887] [058/130] (718s left) vgem_basic (mmap)
[309.847273] Starting subtest: mmap
[309.865957] Subtest mmap: SUCCESS (0.019s)
[309.921325] [059/130] (717s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[310.015717] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[310.017176] Subtest fbcpsr-1p-pri-indfb-multidraw: SKIP (0.000s)
[310.126821] [060/130] (717s left) gem_eio (in-flight-contexts-immediate)
[310.174639] Starting subtest: in-flight-contexts-immediate
[323.917879] Subtest in-flight-contexts-immediate: SUCCESS (13.743s)
[324.033304] [061/130] (703s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[324.126903] Starting subtest: psr-rgb101010-draw-render
[324.128381] Subtest psr-rgb101010-draw-render: SKIP (0.000s)
[324.215863] [062/130] (703s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt)
[324.310698] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt
[324.312177] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[324.398606] [063/130] (703s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[324.491396] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[324.492890] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[324.548235] [064/130] (703s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt)
[324.641368] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt
[324.642741] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[324.743506] [065/130] (703s left) prime_busy (hang)
[324.782399] Starting subtest: hang
[324.783128] Starting dynamic subtest: rcs0
[338.588687] Dynamic subtest rcs0: SUCCESS (13.770s)
[338.594811] Starting dynamic subtest: bcs0
[345.628878] Dynamic subtest bcs0: SUCCESS (7.039s)
[345.635164] Starting dynamic subtest: vcs0
[352.604613] Dynamic subtest vcs0: SUCCESS (6.975s)
[352.610806] Starting dynamic subtest: vcs1
[359.644981] Dynamic subtest vcs1: SUCCESS (7.039s)
[359.651133] Starting dynamic subtest: vecs0
[366.621582] Dynamic subtest vecs0: SUCCESS (6.975s)
[366.622645] Subtest hang: SUCCESS (41.804s)
[366.705808] [066/130] (661s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[366.804919] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[366.840962] [067/130] (661s left) perf (stress-open-close)
[366.915260] Starting subtest: stress-open-close
[366.916012] Starting dynamic subtest: 0-rcs0
[369.102888] Dynamic subtest 0-rcs0: SUCCESS (2.187s)
[369.103725] Subtest stress-open-close: SUCCESS (2.188s)
[369.138600] [068/130] (659s left) sysfs_heartbeat_interval (idempotent)
[369.180294] Starting subtest: idempotent
[369.181073] Starting dynamic subtest: vecs0
[369.181766] Dynamic subtest vecs0: SUCCESS (0.001s)
[369.188588] Starting dynamic subtest: vcs0
[369.189393] Dynamic subtest vcs0: SUCCESS (0.001s)
[369.196684] Starting dynamic subtest: bcs0
[369.197400] Dynamic subtest bcs0: SUCCESS (0.001s)
[369.204383] Starting dynamic subtest: rcs0
[369.205125] Dynamic subtest rcs0: SUCCESS (0.001s)
[369.211642] Starting dynamic subtest: vcs1
[369.212349] Dynamic subtest vcs1: SUCCESS (0.001s)
[369.213055] Subtest idempotent: SUCCESS (0.009s)
[369.249634] [069/130] (659s left) gem_exec_reloc (basic-write-cpu)
[369.291114] Starting subtest: basic-write-cpu
[369.295109] Subtest basic-write-cpu: SUCCESS (0.004s)
[369.406732] [070/130] (658s left) gem_reg_read (timestamp-moving)
[369.444760] Starting subtest: timestamp-moving
[370.445381] Subtest timestamp-moving: SUCCESS (1.001s)
[370.515067] [071/130] (657s left) kms_pm_dc (dc3co-vpb-simulation)
[371.611641] Starting subtest: dc3co-vpb-simulation
[371.612993] Subtest dc3co-vpb-simulation: SKIP (0.000s)
[371.672938] [072/130] (656s left) kms_pm_rpm (cursor)
[373.093312] Starting subtest: cursor
[385.305488] Subtest cursor: SUCCESS (12.212s)
[385.489265] [073/130] (642s left) kms_plane_alpha_blend (constant-alpha-min)
[385.580946] Starting subtest: constant-alpha-min
[385.677870] Starting dynamic subtest: pipe-A-HDMI-A-1
[386.054462] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.377s)
[386.063529] Starting dynamic subtest: pipe-D-HDMI-A-1
[386.461033] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.403s)
[386.461776] Subtest constant-alpha-min: SUCCESS (0.880s)
[386.590618] [074/130] (641s left) gem_exec_reloc (basic-concurrent16)
[386.637444] Starting subtest: basic-concurrent16
[392.082138] Subtest basic-concurrent16: SUCCESS (5.414s)
[392.166172] [075/130] (636s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[392.256807] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[392.258263] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[392.369505] [076/130] (636s left) kms_psr (fbc-psr-cursor-plane-onoff)
[392.460662] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.000s)
[392.501274] [077/130] (636s left) kms_vblank (ts-continuation-suspend)
[392.592947] Starting subtest: ts-continuation-suspend
[392.594794] Starting dynamic subtest: pipe-A-HDMI-A-1
[408.660460] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.486s)
[408.670905] Starting dynamic subtest: pipe-D-HDMI-A-1
[424.645620] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.307s)
[424.646384] Subtest ts-continuation-suspend: SUCCESS (2.798s)
[432.846577] [078/130] (633s left) gem_exec_schedule (preempt-contexts)
[432.913112] Starting subtest: preempt-contexts
[432.913870] Starting dynamic subtest: rcs0
[432.946751] Dynamic subtest rcs0: SUCCESS (0.032s)
[432.960599] Starting dynamic subtest: bcs0
[432.986056] Dynamic subtest bcs0: SUCCESS (0.037s)
[432.994671] Starting dynamic subtest: vcs0
[433.022018] Dynamic subtest vcs0: SUCCESS (0.034s)
[433.030470] Starting dynamic subtest: vcs1
[433.057706] Dynamic subtest vcs1: SUCCESS (0.034s)
[433.066680] Starting dynamic subtest: vecs0
[433.097894] Dynamic subtest vecs0: SUCCESS (0.038s)
[433.098757] Subtest preempt-contexts: SUCCESS (0.182s)
[433.419928] [079/130] (632s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs)
[433.513556] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs
[433.514327] Starting dynamic subtest: pipe-A-HDMI-A-1
[434.292376] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.761s)
[434.303783] Starting dynamic subtest: pipe-B-HDMI-A-1
[434.686282] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.383s)
[434.703390] Starting dynamic subtest: pipe-C-HDMI-A-1
[435.085717] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.389s)
[435.101150] Starting dynamic subtest: pipe-D-HDMI-A-1
[435.499862] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.404s)
[435.500934] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SUCCESS (1.953s)
[435.709356] [080/130] (630s left) kms_cursor_crc (cursor-onscreen-32x10)
[435.806894] Starting subtest: cursor-onscreen-32x10
[435.858259] Subtest cursor-onscreen-32x10: SKIP (0.050s)
[435.948462] [081/130] (630s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[435.986101] Starting subtest: etime-multi-wait-all-submitted-signaled
[436.089350] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.101s)
[436.167967] [082/130] (629s left) gem_partial_pwrite_pread (write)
[436.207800] Starting subtest: write
[445.991688] Subtest write: SUCCESS (9.712s)
[446.111121] [083/130] (620s left) gem_mmap_wc (pf-nonblock)
[446.147624] Starting subtest: pf-nonblock
[446.149487] Subtest pf-nonblock: SUCCESS (0.001s)
[446.244658] [084/130] (619s left) gem_barrier_race (remote-request)
[446.287799] Starting subtest: remote-request
[446.288491] Starting dynamic subtest: rcs0
[451.396808] Dynamic subtest rcs0: SUCCESS (5.093s)
[451.397755] Subtest remote-request: SUCCESS (5.094s)
[451.552399] [085/130] (614s left) kms_big_fb (y-tiled-64bpp-rotate-270)
[451.661125] Starting subtest: y-tiled-64bpp-rotate-270
[451.701703] Subtest y-tiled-64bpp-rotate-270: SKIP (0.039s)
[451.819476] [086/130] (614s left) tools_test (sysfs_l3_parity)
[451.860770] Starting subtest: sysfs_l3_parity
[451.915184] Subtest sysfs_l3_parity: SKIP (0.056s)
[451.973869] [087/130] (614s left) kms_flip (2x-busy-flip)
[452.063821] Starting subtest: 2x-busy-flip
[452.072082] Subtest 2x-busy-flip: SKIP (0.008s)
[452.141700] [088/130] (614s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-blt)
[452.233968] Starting subtest: fbc-1p-offscren-pri-indfb-draw-blt
[453.317710] Subtest fbc-1p-offscren-pri-indfb-draw-blt: SUCCESS (1.082s)
[453.459149] [089/130] (613s left) kms_tiled_display (basic-test-pattern)
[453.587967] Subtest basic-test-pattern: SKIP (0.000s)
[453.627763] [090/130] (612s left) kms_busy (basic-hang)
[453.720906] Starting subtest: basic-hang
[453.721882] Starting dynamic subtest: flip-pipe-A
[454.089376] Dynamic subtest flip-pipe-A: SUCCESS (0.366s)
[454.097074] Starting dynamic subtest: modeset-pipe-A
[454.604956] Dynamic subtest modeset-pipe-A: SUCCESS (0.513s)
[454.617523] Starting dynamic subtest: flip-pipe-D
[454.862396] Dynamic subtest flip-pipe-D: SUCCESS (0.253s)
[454.871222] Starting dynamic subtest: modeset-pipe-D
[455.337563] Dynamic subtest modeset-pipe-D: SUCCESS (0.473s)
[455.338349] Subtest basic-hang: SUCCESS (1.615s)
[455.460645] [091/130] (611s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[455.557836] Subtest psr2-cursor-plane-update-sf: SKIP (0.000s)
[455.597645] [092/130] (611s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[455.691994] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[455.693365] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[455.758886] [093/130] (610s left) gem_ctx_persistence (engines-hostile)
[455.797497] Starting subtest: engines-hostile
[455.798225] Starting dynamic subtest: rcs0
[455.831684] Dynamic subtest rcs0: SUCCESS (0.033s)
[455.850455] Starting dynamic subtest: bcs0
[455.926533] Dynamic subtest bcs0: SUCCESS (0.093s)
[455.945556] Starting dynamic subtest: vcs0
[456.038653] Dynamic subtest vcs0: SUCCESS (0.110s)
[456.058776] Starting dynamic subtest: vcs1
[456.150856] Dynamic subtest vcs1: SUCCESS (0.110s)
[456.171314] Starting dynamic subtest: vecs0
[456.254862] Dynamic subtest vecs0: SUCCESS (0.101s)
[456.256250] Subtest engines-hostile: SUCCESS (0.457s)
[456.327864] [094/130] (610s left) gem_ctx_sseu (mmap-args)
[456.369760] Subtest mmap-args: SKIP (0.000s)
[456.415744] [095/130] (610s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[456.505343] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[456.506100] Starting dynamic subtest: pipe-A-HDMI-A-1
[456.513862] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[456.524137] Starting dynamic subtest: pipe-B-HDMI-A-1
[456.531853] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[456.541343] Starting dynamic subtest: pipe-C-HDMI-A-1
[456.548843] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[456.557944] Starting dynamic subtest: pipe-D-HDMI-A-1
[456.566138] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[456.567551] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SKIP (0.006s)
[456.746120] [096/130] (609s left) i915_query (query-topology-known-pci-ids)
[456.783298] Starting subtest: query-topology-known-pci-ids
[456.784791] Subtest query-topology-known-pci-ids: SKIP (0.000s)
[456.840749] [097/130] (609s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[456.931835] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc
[456.933209] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[457.031967] [098/130] (609s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[457.121035] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[457.122898] Starting dynamic subtest: pipe-A-valid-mode
[457.172507] Dynamic subtest pipe-A-valid-mode: SKIP (0.049s)
[457.174106] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.051s)
[457.275416] [099/130] (609s left) core_getversion (basic)
[457.314416] Starting subtest: basic
[457.315851] Subtest basic: SUCCESS (0.000s)
[457.385695] [100/130] (609s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[457.478853] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[457.480270] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[457.578761] [101/130] (609s left) gem_exec_flush (basic-uc-pro-default)
[457.623390] Starting subtest: basic-uc-pro-default
[463.076451] Subtest basic-uc-pro-default: SUCCESS (5.448s)
[463.279573] [102/130] (603s left) kms_psr (psr2-sprite-plane-onoff)
[463.368652] Subtest psr2-sprite-plane-onoff: SKIP (0.000s)
[463.408596] [103/130] (603s left) perf_pmu (busy-idle-no-semaphores)
[463.449629] Starting subtest: busy-idle-no-semaphores
[463.450368] Starting dynamic subtest: rcs0
[464.110742] Dynamic subtest rcs0: SUCCESS (0.652s)
[464.121200] Starting dynamic subtest: bcs0
[464.742076] Dynamic subtest bcs0: SUCCESS (0.629s)
[464.752767] Starting dynamic subtest: vcs0
[465.376401] Dynamic subtest vcs0: SUCCESS (0.633s)
[465.386494] Starting dynamic subtest: vcs1
[466.008212] Dynamic subtest vcs1: SUCCESS (0.630s)
[466.018999] Starting dynamic subtest: vecs0
[466.643944] Dynamic subtest vecs0: SUCCESS (0.634s)
[466.645004] Subtest busy-idle-no-semaphores: SUCCESS (3.187s)
[466.727336] [104/130] (600s left) kms_content_protection (dp-mst-lic-type-0)
[466.831502] Starting subtest: dp-mst-lic-type-0
[466.832958] Subtest dp-mst-lic-type-0: SKIP (0.000s)
[466.913668] [105/130] (600s left) gem_ctx_isolation (dirty-create)
[466.960327] Starting subtest: dirty-create
[466.961163] Starting dynamic subtest: rcs0
[467.427894] Dynamic subtest rcs0: SUCCESS (0.458s)
[467.435480] Starting dynamic subtest: bcs0
[467.895832] Dynamic subtest bcs0: SUCCESS (0.476s)
[467.905267] Starting dynamic subtest: vcs0
[468.405890] Dynamic subtest vcs0: SUCCESS (0.500s)
[468.413478] Starting dynamic subtest: vcs1
[468.904702] Dynamic subtest vcs1: SUCCESS (0.498s)
[468.912341] Starting dynamic subtest: vecs0
[469.369805] Dynamic subtest vecs0: SUCCESS (0.464s)
[469.370623] Subtest dirty-create: SUCCESS (2.401s)
[469.537940] [106/130] (597s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[469.631082] Starting subtest: pipe-fbc-rte
[469.635193] Subtest pipe-fbc-rte: SKIP (0.000s)
[469.734875] [107/130] (597s left) gem_create (create-valid-nonaligned)
[469.773991] Starting subtest: create-valid-nonaligned
[469.774713] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[469.963363] [108/130] (597s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[470.053420] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[470.054899] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[470.210501] [109/130] (597s left) vgem_basic (second-client)
[470.249633] Starting subtest: second-client
[470.266577] Subtest second-client: SUCCESS (0.017s)
[470.319191] [110/130] (596s left) kms_lease (lease-invalid-crtc)
[470.411393] Starting subtest: lease-invalid-crtc
[470.412148] Starting dynamic subtest: pipe-A-HDMI-A-1
[470.412912] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.000s)
[470.424232] Starting dynamic subtest: pipe-B-HDMI-A-1
[470.424966] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s)
[470.432411] Starting dynamic subtest: pipe-C-HDMI-A-1
[470.433136] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.000s)
[470.440429] Starting dynamic subtest: pipe-D-HDMI-A-1
[470.441168] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.000s)
[470.441890] Subtest lease-invalid-crtc: SUCCESS (0.009s)
[470.474578] [111/130] (596s left) kms_psr (fbc-psr-sprite-render)
[470.562097] Subtest fbc-psr-sprite-render: SKIP (0.000s)
[470.610925] [112/130] (596s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[470.723636] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[470.725082] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[470.778555] [113/130] (596s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[470.868341] Starting subtest: addfb25-y-tiled-small-legacy
[470.869082] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s)
[470.969668] [114/130] (596s left) gem_ctx_persistence (legacy-engines-persistence)
[471.016992] Starting subtest: legacy-engines-persistence
[471.017761] Starting dynamic subtest: render
[471.795849] Dynamic subtest render: SUCCESS (0.778s)
[471.806744] Starting dynamic subtest: bsd1
[472.561832] Dynamic subtest bsd1: SUCCESS (0.762s)
[472.572766] Starting dynamic subtest: bsd2
[473.318663] Dynamic subtest bsd2: SUCCESS (0.753s)
[473.328838] Starting dynamic subtest: blt
[474.097697] Dynamic subtest blt: SUCCESS (0.776s)
[474.109180] Starting dynamic subtest: vebox
[474.855645] Dynamic subtest vebox: SUCCESS (0.754s)
[474.856766] Subtest legacy-engines-persistence: SUCCESS (3.839s)
[474.923529] [115/130] (592s left) gem_render_copy (linear-to-vebox-y-tiled)
[474.969299] Starting subtest: linear-to-vebox-y-tiled
[474.970032] Starting dynamic subtest: smem
[475.067693] Dynamic subtest smem: SUCCESS (0.098s)
[475.068487] Subtest linear-to-vebox-y-tiled: SUCCESS (0.099s)
[475.245856] [116/130] (592s left) gem_mmap_gtt (zero-extend)
[475.282476] Starting subtest: zero-extend
[475.283202] Subtest zero-extend: SUCCESS (0.000s)
[475.372380] [117/130] (592s left) kms_rotation_crc (sprite-rotation-180)
[475.463112] Starting subtest: sprite-rotation-180
[477.880011] Subtest sprite-rotation-180: SUCCESS (2.417s)
[478.060974] [118/130] (589s left) gem_basic (bad-close)
[478.101060] Starting subtest: bad-close
[478.102442] Subtest bad-close: SUCCESS (0.000s)
[478.164004] [119/130] (589s left) kms_feature_discovery (display-1x)
[478.255413] Starting subtest: display-1x
[478.256158] Subtest display-1x: SUCCESS (0.000s)
[478.311504] [120/130] (589s left) kms_plane (pixel-format)
[478.398876] Starting subtest: pixel-format
[478.418578] Starting dynamic subtest: pipe-A-plane-0
[481.752673] Dynamic subtest pipe-A-plane-0: SUCCESS (3.333s)
[481.769285] Starting dynamic subtest: pipe-A-plane-3
[484.629379] Dynamic subtest pipe-A-plane-3: SUCCESS (2.875s)
[484.647075] Starting dynamic subtest: pipe-A-plane-5
[486.296544] Dynamic subtest pipe-A-plane-5: SUCCESS (1.665s)
[486.312200] Starting dynamic subtest: pipe-A-plane-7
[486.405305] Dynamic subtest pipe-A-plane-7: SUCCESS (0.106s)
[486.555774] Starting dynamic subtest: pipe-B-plane-0
[489.808833] Dynamic subtest pipe-B-plane-0: SUCCESS (3.259s)
[489.827294] Starting dynamic subtest: pipe-B-plane-3
[492.701597] Dynamic subtest pipe-B-plane-3: SUCCESS (2.890s)
[492.717937] Starting dynamic subtest: pipe-B-plane-5
[494.368825] Dynamic subtest pipe-B-plane-5: SUCCESS (1.666s)
[494.386985] Starting dynamic subtest: pipe-B-plane-7
[494.477772] Dynamic subtest pipe-B-plane-7: SUCCESS (0.107s)
[494.533652] Subtest pixel-format: SUCCESS (16.131s)
[494.669394] [121/130] (573s left) gem_spin_batch (resubmit-new)
[494.717566] Starting subtest: resubmit-new
[494.718325] Starting dynamic subtest: rcs0
[494.721105] Dynamic subtest rcs0: SUCCESS (0.003s)
[494.733358] Starting dynamic subtest: bcs0
[494.734169] Dynamic subtest bcs0: SUCCESS (0.003s)
[494.743952] Starting dynamic subtest: vcs0
[494.744680] Dynamic subtest vcs0: SUCCESS (0.003s)
[494.752057] Starting dynamic subtest: vcs1
[494.753109] Dynamic subtest vcs1: SUCCESS (0.003s)
[494.760249] Starting dynamic subtest: vecs0
[494.760950] Dynamic subtest vecs0: SUCCESS (0.003s)
[494.761800] Subtest resubmit-new: SUCCESS (0.023s)
[494.922954] [122/130] (572s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[495.015073] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[495.015784] Starting dynamic subtest: pipe-A-HDMI-A-1
[495.022590] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[495.030301] Starting dynamic subtest: pipe-B-HDMI-A-1
[495.037061] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[495.044694] Starting dynamic subtest: pipe-C-HDMI-A-1
[495.051433] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[495.058788] Starting dynamic subtest: pipe-D-HDMI-A-1
[495.065557] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[495.066965] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SKIP (0.006s)
[495.251284] [123/130] (572s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[495.344881] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[495.346355] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[495.455408] [124/130] (572s left) sysfs_heartbeat_interval (precise)
[495.494136] Starting subtest: precise
[495.494872] Starting dynamic subtest: vecs0
[497.034969] Dynamic subtest vecs0: SUCCESS (1.539s)
[497.046022] Starting dynamic subtest: vcs0
[498.576009] Dynamic subtest vcs0: SUCCESS (1.538s)
[498.589192] Starting dynamic subtest: bcs0
[500.170279] Dynamic subtest bcs0: SUCCESS (1.590s)
[500.180302] Starting dynamic subtest: rcs0
[501.704805] Dynamic subtest rcs0: SUCCESS (1.531s)
[501.714549] Starting dynamic subtest: vcs1
[503.259895] Dynamic subtest vcs1: SUCCESS (1.552s)
[503.261299] Subtest precise: SUCCESS (7.764s)
[503.332629] [125/130] (564s left) kms_psr (psr2-sprite-mmap-cpu)
[503.425903] Subtest psr2-sprite-mmap-cpu: SKIP (0.000s)
[503.466529] [126/130] (564s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[503.504784] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[503.505475] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[503.565899] [127/130] (564s left) syncobj_timeline (invalid-transfer-non-existent-point)
[503.602091] Starting subtest: invalid-transfer-non-existent-point
[503.602841] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[503.676703] [128/130] (564s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[503.715269] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[503.716000] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[503.781591] [129/130] (564s left) kms_invalid_mode (int-max-clock)
[503.870735] Starting subtest: int-max-clock
[503.871475] Starting dynamic subtest: pipe-A-HDMI-A-1
[503.919517] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.048s)
[503.928461] Starting dynamic subtest: pipe-B-HDMI-A-1
[503.936504] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[503.943872] Starting dynamic subtest: pipe-C-HDMI-A-1
[503.944586] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[503.952093] Starting dynamic subtest: pipe-D-HDMI-A-1
[503.952805] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[503.953503] Subtest int-max-clock: SUCCESS (0.057s)
[504.059190] [130/130] (564s left) i915_pm_rpm (debugfs-forcewake-user)
[505.468497] Starting subtest: debugfs-forcewake-user
[516.900298] Subtest debugfs-forcewake-user: SUCCESS (11.427s)
[517.071467] Closing watchdogs
Done.