[51.188760] Initializing watchdogs
[51.188820]   /dev/watchdog0
[51.205248] [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]
[51.210933] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[51.213854] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[51.215924] [001/155] (960s left) gem_mmap_gtt (coherency)
[51.253566] Starting subtest: coherency
[51.255008] Subtest coherency: SKIP (0.000s)
[51.320807] [002/155] (960s left) syncobj_eventfd (timeline-wait-before-signal)
[51.355883] Starting subtest: timeline-wait-before-signal
[51.387863] Subtest timeline-wait-before-signal: SUCCESS (0.032s)
[51.480637] [003/155] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[51.576900] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[51.578327] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[51.691696] [004/155] (960s left) kms_feature_discovery (chamelium)
[51.781237] Starting subtest: chamelium
[51.782638] Subtest chamelium: SKIP (0.000s)
[51.833517] [005/155] (960s left) gem_ctx_persistence (heartbeat-hang)
[51.874149] Starting subtest: heartbeat-hang
[53.394541] Subtest heartbeat-hang: SUCCESS (1.517s)
[53.477745] [006/155] (958s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[53.571037] Subtest psr2-cursor-plane-update-sf: SKIP (0.000s)
[53.607478] [007/155] (958s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[53.701416] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[53.702781] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[53.799975] [008/155] (958s left) gem_ccs (block-copy-uncompressed)
[53.838567] Starting subtest: block-copy-uncompressed
[53.839365] Starting dynamic subtest: linear-uncompressed-compfmt0-smem-smem
[53.861514] Dynamic subtest linear-uncompressed-compfmt0-smem-smem: SUCCESS (0.022s)
[53.867394] Starting dynamic subtest: ymajor-uncompressed-compfmt0-smem-smem
[53.879070] Dynamic subtest ymajor-uncompressed-compfmt0-smem-smem: SUCCESS (0.017s)
[53.879799] Subtest block-copy-uncompressed: SUCCESS (0.041s)
[53.992893] [009/155] (958s left) syncobj_basic (bad-pad-handle-to-fd)
[54.026010] Starting subtest: bad-pad-handle-to-fd
[54.026754] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[54.081302] [010/155] (957s left) kms_flip (flip-vs-fences-interruptible)
[54.174083] Starting subtest: flip-vs-fences-interruptible
[54.176725] Starting dynamic subtest: A-HDMI-A1
[61.895793] Dynamic subtest A-HDMI-A1: SUCCESS (7.686s)
[61.904049] Starting dynamic subtest: B-HDMI-A1
[69.506317] Dynamic subtest B-HDMI-A1: SUCCESS (7.622s)
[69.513725] Starting dynamic subtest: C-HDMI-A1
[77.185136] Dynamic subtest C-HDMI-A1: SUCCESS (7.649s)
[77.191610] Starting dynamic subtest: D-HDMI-A1
[84.815492] Dynamic subtest D-HDMI-A1: SUCCESS (7.658s)
[84.816277] Subtest flip-vs-fences-interruptible: SUCCESS (30.621s)
[84.999707] [011/155] (927s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf)
[85.096657] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (0.000s)
[85.133735] [012/155] (926s left) gem_exercise_blt (fast-copy)
[85.170234] Starting subtest: fast-copy
[85.171061] Starting dynamic subtest: linear-smem-smem
[85.190760] Dynamic subtest linear-smem-smem: SUCCESS (0.020s)
[85.197155] Starting dynamic subtest: ymajor-smem-smem
[85.208050] Dynamic subtest ymajor-smem-smem: SUCCESS (0.017s)
[85.214345] Starting dynamic subtest: tile4-smem-smem
[85.224497] Dynamic subtest tile4-smem-smem: SUCCESS (0.016s)
[85.230652] Starting dynamic subtest: tile64-smem-smem
[85.240972] Dynamic subtest tile64-smem-smem: SUCCESS (0.016s)
[85.241706] Subtest fast-copy: SUCCESS (0.071s)
[85.352458] [013/155] (926s left) prime_busy (hang)
[85.388281] Starting subtest: hang
[85.389011] Starting dynamic subtest: rcs0
[99.452013] Dynamic subtest rcs0: SUCCESS (14.026s)
[99.457967] Starting dynamic subtest: bcs0
[106.555733] Dynamic subtest bcs0: SUCCESS (7.103s)
[106.563168] Starting dynamic subtest: vcs0
[113.595296] Dynamic subtest vcs0: SUCCESS (7.039s)
[113.601761] Starting dynamic subtest: vcs1
[120.572305] Dynamic subtest vcs1: SUCCESS (6.975s)
[120.579818] Starting dynamic subtest: vecs0
[127.585686] Dynamic subtest vecs0: SUCCESS (7.039s)
[127.586418] Subtest hang: SUCCESS (42.186s)
[127.674464] [014/155] (884s left) gem_sync (basic-all)
[127.717349] Starting subtest: basic-all
[130.013382] Subtest basic-all: SUCCESS (2.296s)
[130.198091] [015/155] (882s left) sysfs_preempt_timeout (timeout)
[130.235224] Starting subtest: timeout
[130.235951] Starting dynamic subtest: vecs0
[131.114469] Dynamic subtest vecs0: SUCCESS (0.878s)
[131.124175] Starting dynamic subtest: vcs0
[131.997496] Dynamic subtest vcs0: SUCCESS (0.882s)
[132.006598] Starting dynamic subtest: bcs0
[132.866702] Dynamic subtest bcs0: SUCCESS (0.868s)
[132.875636] Starting dynamic subtest: rcs0
[133.752573] Dynamic subtest rcs0: SUCCESS (0.885s)
[133.761468] Starting dynamic subtest: vcs1
[134.636610] Dynamic subtest vcs1: SUCCESS (0.883s)
[134.637690] Subtest timeout: SUCCESS (4.401s)
[134.704488] [016/155] (877s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[134.793470] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[134.794924] Starting dynamic subtest: pipe-A-valid-mode
[135.813051] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.018s)
[135.813760] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (1.019s)
[135.950283] [017/155] (876s left) gem_pipe_control_store_loop (reused-buffer)
[135.993782] Starting subtest: reused-buffer
[138.153610] Subtest reused-buffer: SUCCESS (2.151s)
[138.257393] [018/155] (874s left) api_intel_allocator (reopen-fork)
[138.290432] Starting subtest: reopen-fork
[141.730214] Subtest reopen-fork: SUCCESS (3.405s)
[141.766206] [019/155] (870s left) gem_exec_balancer (bonded-true-hang)
[141.924339] Starting subtest: bonded-true-hang
[143.228787] Subtest bonded-true-hang: SUCCESS (1.302s)
[143.284372] [020/155] (869s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[143.378208] Starting subtest: stress-xrgb8888-ytiled
[150.764385] Subtest stress-xrgb8888-ytiled: SUCCESS (7.386s)
[150.907763] [021/155] (861s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[151.000577] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[151.001302] Starting dynamic subtest: pipe-A-HDMI-A-1
[151.008113] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[151.014824] Starting dynamic subtest: pipe-B-HDMI-A-1
[151.021511] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[151.028091] Starting dynamic subtest: pipe-C-HDMI-A-1
[151.034794] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[151.041246] Starting dynamic subtest: pipe-D-HDMI-A-1
[151.048035] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[151.049371] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[151.255210] [022/155] (861s left) kms_flip (2x-flip-vs-fences)
[151.343622] Starting subtest: 2x-flip-vs-fences
[151.352827] Subtest 2x-flip-vs-fences: SKIP (0.009s)
[151.425414] [023/155] (861s left) gem_eio (in-flight-contexts-immediate)
[151.468179] Starting subtest: in-flight-contexts-immediate
[164.843132] Subtest in-flight-contexts-immediate: SUCCESS (13.374s)
[164.975670] [024/155] (847s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[165.069162] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[165.070539] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[165.169588] [025/155] (847s left) gem_userptr_blits (unsync-unmap-after-close)
[165.209129] Subtest unsync-unmap-after-close: SKIP (0.000s)
[165.328367] [026/155] (847s left) kms_vblank (ts-continuation-modeset-rpm)
[165.416885] Starting subtest: ts-continuation-modeset-rpm
[165.417674] Starting dynamic subtest: pipe-A-HDMI-A-1
[167.018405] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.601s)
[167.028871] Starting dynamic subtest: pipe-D-HDMI-A-1
[168.277690] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.256s)
[168.278399] Subtest ts-continuation-modeset-rpm: SUCCESS (2.861s)
[168.426157] [027/155] (844s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[168.525495] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[168.526901] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[168.620424] [028/155] (844s left) gem_mmap_gtt (basic-write)
[168.654141] Starting subtest: basic-write
[168.784551] Subtest basic-write: SUCCESS (0.122s)
[168.879013] [029/155] (843s left) kms_cursor_crc (cursor-sliding-256x256)
[168.972072] Starting subtest: cursor-sliding-256x256
[168.977585] Starting dynamic subtest: pipe-A-HDMI-A-1
[170.811538] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.834s)
[170.848979] Starting dynamic subtest: pipe-D-HDMI-A-1
[172.659474] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.819s)
[172.660211] Subtest cursor-sliding-256x256: SUCCESS (3.687s)
[172.821633] [030/155] (839s left) kms_properties (get_properties-sanity-atomic)
[172.917684] Starting subtest: get_properties-sanity-atomic
[172.921475] Subtest get_properties-sanity-atomic: SUCCESS (0.004s)
[172.976625] [031/155] (839s left) kms_frontbuffer_tracking (hdr-rgb565-draw-pwrite)
[173.068351] Starting subtest: hdr-rgb565-draw-pwrite
[173.069755] Subtest hdr-rgb565-draw-pwrite: SKIP (0.000s)
[173.162492] [032/155] (839s left) i915_drm_fdinfo (virtual-idle)
[173.199355] Starting subtest: virtual-idle
[175.727841] Subtest virtual-idle: SUCCESS (2.519s)
[175.797235] [033/155] (837s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[175.903156] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[176.594942] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (0.691s)
[176.726706] [034/155] (836s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-pwrite)
[176.820148] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-pwrite
[176.821508] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[176.923652] [035/155] (836s left) perf_pmu (faulting-read)
[176.959991] Starting subtest: faulting-read
[176.960772] Starting dynamic subtest: gtt
[176.961575] Dynamic subtest gtt: SUCCESS (0.001s)
[176.969766] Starting dynamic subtest: wb
[176.970472] Dynamic subtest wb: SUCCESS (0.001s)
[176.977861] Starting dynamic subtest: wc
[176.978566] Dynamic subtest wc: SUCCESS (0.000s)
[176.985533] Starting dynamic subtest: uc
[176.986224] Dynamic subtest uc: SUCCESS (0.000s)
[176.986901] Subtest faulting-read: SUCCESS (0.004s)
[177.052551] [036/155] (835s left) prime_mmap (test_invalid_sync_flags)
[177.086594] Starting subtest: test_invalid_sync_flags
[177.087309] Starting dynamic subtest: test_invalid_sync_flags-smem
[177.088041] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s)
[177.088721] Subtest test_invalid_sync_flags: SUCCESS (0.000s)
[177.181455] [037/155] (835s left) kms_psr (pr-sprite-plane-onoff)
[177.271596] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[177.315297] [038/155] (835s left) kms_getfb (getfb2-handle-not-fb)
[177.403747] Starting subtest: getfb2-handle-not-fb
[177.404432] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[177.519095] [039/155] (835s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[177.607736] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[177.608478] Starting dynamic subtest: pipe-A-HDMI-A-1
[177.615584] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[177.623423] Starting dynamic subtest: pipe-B-HDMI-A-1
[177.630529] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[177.638133] Starting dynamic subtest: pipe-C-HDMI-A-1
[177.645244] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[177.652899] Starting dynamic subtest: pipe-D-HDMI-A-1
[177.659731] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[177.661117] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[177.853918] [040/155] (835s left) gem_close (many-handles-one-vma)
[177.896100] Starting subtest: many-handles-one-vma
[177.920987] Subtest many-handles-one-vma: SUCCESS (0.025s)
[178.022370] [041/155] (835s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-blt)
[178.113532] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-blt
[178.114913] Subtest hdr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[178.195762] [042/155] (835s left) core_getversion (all-cards)
[178.230345] Starting subtest: all-cards
[178.241747] Subtest all-cards: SUCCESS (0.012s)
[178.276957] [043/155] (835s left) syncobj_timeline (multi-wait-all-available-signaled)
[178.312538] Starting subtest: multi-wait-all-available-signaled
[178.313263] Subtest multi-wait-all-available-signaled: SUCCESS (0.001s)
[178.372701] [044/155] (834s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render)
[178.465693] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render
[179.554404] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (1.090s)
[179.692829] [045/155] (833s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[179.728924] Starting subtest: single-wait-for-submit-available-submitted
[179.729662] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s)
[179.789047] [046/155] (833s left) kms_big_fb (yf-tiled-32bpp-rotate-0)
[179.887342] Starting subtest: yf-tiled-32bpp-rotate-0
[179.888831] Subtest yf-tiled-32bpp-rotate-0: SKIP (0.000s)
[179.956780] [047/155] (833s left) gem_exec_fence (syncobj-repeat)
[180.318604] Starting subtest: syncobj-repeat
[180.612758] Subtest syncobj-repeat: SUCCESS (0.285s)
[180.905950] [FACT gem_exec_fence (syncobj-repeat)] new: kernel.kmod_is_loaded.vgem: true
[180.908416] [048/155] (832s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[180.999753] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[181.000479] Starting dynamic subtest: pipe-A-HDMI-A-1
[181.003318] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[181.011221] Starting dynamic subtest: pipe-B-HDMI-A-1
[181.014925] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[181.022530] Starting dynamic subtest: pipe-C-HDMI-A-1
[181.025344] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[181.032910] Starting dynamic subtest: pipe-D-HDMI-A-1
[181.035690] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[181.037103] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[181.259057] [049/155] (832s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[181.297009] Starting subtest: multi-wait-for-submit-available-signaled
[181.297765] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.001s)
[181.360456] [050/155] (832s left) kms_atomic (plane-overlay-legacy)
[181.448773] Starting subtest: plane-overlay-legacy
[181.457193] Starting dynamic subtest: pipe-A-HDMI-A-1
[181.599235] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.150s)
[181.599957] Subtest plane-overlay-legacy: SUCCESS (0.151s)
[181.744706] [051/155] (831s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[181.839314] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[181.840718] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[181.944014] [052/155] (831s left) gem_madvise (dontneed-before-pwrite)
[181.980428] Starting subtest: dontneed-before-pwrite
[181.981990] Subtest dontneed-before-pwrite: SUCCESS (0.002s)
[182.063722] [053/155] (831s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[182.156617] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[182.158080] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[182.249836] [054/155] (831s left) kms_cursor_crc (cursor-offscreen-64x21)
[182.341163] Starting subtest: cursor-offscreen-64x21
[182.345805] Starting dynamic subtest: pipe-A-HDMI-A-1
[183.604607] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.259s)
[183.651294] Starting dynamic subtest: pipe-D-HDMI-A-1
[184.869421] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.226s)
[184.870143] Subtest cursor-offscreen-64x21: SUCCESS (2.528s)
[185.037974] [055/155] (828s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[185.137588] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-mmap-wc
[185.138991] Subtest hdr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[185.227124] [056/155] (828s left) perf_pmu (busy-hang)
[185.264898] Starting subtest: busy-hang
[185.265606] Starting dynamic subtest: rcs0
[186.319813] Dynamic subtest rcs0: SUCCESS (1.053s)
[186.329552] Starting dynamic subtest: bcs0
[187.360898] Dynamic subtest bcs0: SUCCESS (1.039s)
[187.371748] Starting dynamic subtest: vcs0
[188.418099] Dynamic subtest vcs0: SUCCESS (1.055s)
[188.426428] Starting dynamic subtest: vcs1
[189.458765] Dynamic subtest vcs1: SUCCESS (1.040s)
[189.467995] Starting dynamic subtest: vecs0
[190.494903] Dynamic subtest vecs0: SUCCESS (1.035s)
[190.496145] Subtest busy-hang: SUCCESS (5.230s)
[190.569638] [057/155] (823s left) kms_joiner (invalid-modeset-force-big-joiner)
[190.661805] Starting subtest: invalid-modeset-force-big-joiner
[190.663185] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s)
[190.720480] [058/155] (823s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[190.755093] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[190.755837] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[190.824454] [059/155] (823s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[190.917110] Starting subtest: fbc-rgb565-draw-mmap-wc
[192.175246] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (1.258s)
[192.298527] [060/155] (821s left) gem_exec_params (larger-than-life-batch)
[192.336426] Starting subtest: larger-than-life-batch
[194.436994] Subtest larger-than-life-batch: SUCCESS (2.100s)
[194.559603] [061/155] (819s left) gem_exec_params (no-bsd)
[194.641656] Starting subtest: no-bsd
[194.642403] Subtest no-bsd: SUCCESS (0.001s)
[194.759518] [062/155] (819s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[194.858350] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-mmap-cpu
[194.859790] Subtest fbchdr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[194.963945] [063/155] (819s left) gem_pread (bench)
[194.998717] Starting subtest: bench
[195.828893] Subtest bench: SUCCESS (0.821s)
[195.912233] [064/155] (818s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[196.015408] Starting subtest: 4-tiled-64bpp-rotate-270
[196.016901] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.000s)
[196.103654] [065/155] (818s left) gem_softpin (32b-excludes-last-page)
[196.142039] Starting subtest: 32b-excludes-last-page
[196.143831] Subtest 32b-excludes-last-page: SUCCESS (0.002s)
[196.257798] [066/155] (817s left) kms_atomic_interruptible (atomic-setmode)
[196.354870] Starting subtest: atomic-setmode
[196.356609] Starting dynamic subtest: pipe-A-HDMI-A-1
[202.563260] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.206s)
[202.564059] Subtest atomic-setmode: SUCCESS (6.208s)
[202.730046] [067/155] (811s left) i915_pm_rpm (system-suspend-devices)
[204.162275] Starting subtest: system-suspend-devices
[212.112364] Subtest system-suspend-devices: SUCCESS (7.950s)
[219.319625] [068/155] (802s left) kms_content_protection (dp-mst-type-0)
[219.421206] Starting subtest: dp-mst-type-0
[219.422603] Subtest dp-mst-type-0: SKIP (0.000s)
[219.520938] [069/155] (801s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[219.613531] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-mmap-cpu
[219.615018] Subtest fbchdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[219.717706] [070/155] (801s left) kms_psr (fbc-pr-primary-render)
[219.807659] Subtest fbc-pr-primary-render: SKIP (0.000s)
[219.851844] [071/155] (801s left) kms_plane (pixel-format-4-tiled-modifier)
[219.940871] Starting subtest: pixel-format-4-tiled-modifier
[219.942240] Subtest pixel-format-4-tiled-modifier: SKIP (0.000s)
[220.004150] [072/155] (801s left) kms_flip (nonblocking-read)
[220.094617] Starting subtest: nonblocking-read
[220.095383] Subtest nonblocking-read: SUCCESS (0.000s)
[220.209629] [073/155] (801s left) gem_sync (basic-store-each)
[220.253867] Starting subtest: basic-store-each
[222.356633] Subtest basic-store-each: SUCCESS (2.103s)
[222.565561] [074/155] (799s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-indfb-msflip-blt)
[222.662528] Starting subtest: fbcpsrhdr-1p-primscrn-indfb-msflip-blt
[222.663988] Subtest fbcpsrhdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[222.749391] [075/155] (798s left) gem_mmap_wc (write-gtt-read-wc)
[222.783786] Starting subtest: write-gtt-read-wc
[223.098765] Subtest write-gtt-read-wc: SUCCESS (0.306s)
[223.178178] [076/155] (798s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier)
[223.266346] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier
[223.267830] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SKIP (0.000s)
[223.341924] [077/155] (798s left) kms_frontbuffer_tracking (fbchdr-2p-indfb-fliptrack-mmap-gtt)
[223.436468] Starting subtest: fbchdr-2p-indfb-fliptrack-mmap-gtt
[223.437923] Subtest fbchdr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[223.552037] [078/155] (798s left) kms_psr (fbc-psr-cursor-plane-onoff)
[223.640446] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.000s)
[223.685527] [079/155] (798s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[223.776056] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[223.776986] Starting dynamic subtest: pipe-A
[224.236496] Dynamic subtest pipe-A: SUCCESS (0.461s)
[224.258509] Starting dynamic subtest: pipe-B
[224.697221] Dynamic subtest pipe-B: SUCCESS (0.460s)
[224.707201] Starting dynamic subtest: pipe-C
[225.149064] Dynamic subtest pipe-C: SUCCESS (0.451s)
[225.162777] Starting dynamic subtest: pipe-D
[225.591406] Dynamic subtest pipe-D: SUCCESS (0.442s)
[225.592495] Subtest plane-downscale-factor-0-5-with-modifiers: SUCCESS (1.816s)
[225.788918] [080/155] (796s left) kms_big_fb (linear-8bpp-rotate-180)
[225.893658] Starting subtest: linear-8bpp-rotate-180
[226.950373] Subtest linear-8bpp-rotate-180: SUCCESS (1.056s)
[227.068905] [081/155] (794s left) gem_mmap (bad-size)
[227.104048] Starting subtest: bad-size
[227.104781] Subtest bad-size: SUCCESS (0.001s)
[227.196533] [082/155] (794s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[227.293597] Starting subtest: psr-rgb565-draw-render
[227.295062] Subtest psr-rgb565-draw-render: SKIP (0.000s)
[227.389061] [083/155] (794s left) gem_close_race (multigpu-basic-process)
[227.438245] Starting subtest: multigpu-basic-process
[227.440188] Subtest multigpu-basic-process: SKIP (0.000s)
[227.629202] [084/155] (794s left) gem_ctx_persistence (engines-mixed)
[227.668796] Starting subtest: engines-mixed
[227.669477] Starting dynamic subtest: rcs0
[227.713710] Dynamic subtest rcs0: SUCCESS (0.045s)
[227.735024] Starting dynamic subtest: bcs0
[227.768615] Dynamic subtest bcs0: SUCCESS (0.053s)
[227.788719] Starting dynamic subtest: vcs0
[227.819729] Dynamic subtest vcs0: SUCCESS (0.049s)
[227.839910] Starting dynamic subtest: vcs1
[227.877838] Dynamic subtest vcs1: SUCCESS (0.056s)
[227.899250] Starting dynamic subtest: vecs0
[227.940745] Dynamic subtest vecs0: SUCCESS (0.060s)
[227.941941] Subtest engines-mixed: SUCCESS (0.273s)
[228.028589] [085/155] (794s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[228.124575] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[228.126063] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[228.223350] [086/155] (793s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-pwrite)
[228.318917] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-pwrite
[228.320389] Subtest hdr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[228.426754] [087/155] (793s left) kms_cursor_legacy (torture-bo)
[228.516050] Starting subtest: torture-bo
[228.516780] Starting dynamic subtest: pipe-A
[234.021114] Dynamic subtest pipe-A: SUCCESS (5.470s)
[234.033947] Starting dynamic subtest: pipe-B
[239.484817] Dynamic subtest pipe-B: SUCCESS (5.462s)
[239.498889] Starting dynamic subtest: pipe-C
[244.954811] Dynamic subtest pipe-C: SUCCESS (5.469s)
[244.965213] Starting dynamic subtest: pipe-D
[250.437754] Dynamic subtest pipe-D: SUCCESS (5.482s)
[250.449151] Starting dynamic subtest: all-pipes
[255.928667] Dynamic subtest all-pipes: SUCCESS (5.488s)
[255.929614] Subtest torture-bo: SUCCESS (27.376s)
[255.997052] [088/155] (766s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[256.103449] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[256.104864] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[256.193676] [089/155] (766s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render)
[256.287394] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render
[256.288785] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[256.386184] [090/155] (765s left) gem_exec_flush (basic-batch-kernel-default-uc)
[256.430416] Starting subtest: basic-batch-kernel-default-uc
[262.008619] Subtest basic-batch-kernel-default-uc: SUCCESS (5.578s)
[262.224433] [091/155] (760s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-blt)
[262.321443] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-blt
[262.322868] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[262.441411] [092/155] (759s left) perf (invalid-oa-metric-set-id)
[262.534694] Starting subtest: invalid-oa-metric-set-id
[262.544936] Subtest invalid-oa-metric-set-id: SUCCESS (0.010s)
[262.584415] [093/155] (759s left) gem_softpin (reverse)
[262.623906] Starting subtest: reverse
[262.628592] Subtest reverse: SUCCESS (0.005s)
[262.741332] [094/155] (759s left) gem_tiled_fence_blits (basic)
[262.866366] Starting subtest: basic
[262.888209] Subtest basic: SUCCESS (0.022s)
[263.025784] [095/155] (759s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-render)
[263.171068] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-render
[263.172828] Subtest fbchdr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[263.274193] [096/155] (759s left) kms_cursor_crc (cursor-sliding-512x512)
[263.373060] Starting subtest: cursor-sliding-512x512
[263.374482] Subtest cursor-sliding-512x512: SKIP (0.001s)
[263.470898] [097/155] (759s left) gem_exec_whisper (basic-contexts-forked-all)
[263.516119] Starting subtest: basic-contexts-forked-all
[267.020871] Subtest basic-contexts-forked-all: SUCCESS (3.495s)
[267.196499] [098/155] (755s left) gem_exec_capture (capture)
[267.234668] Starting subtest: capture
[267.235448] Starting dynamic subtest: rcs0-smem
[268.514877] Dynamic subtest rcs0-smem: SUCCESS (1.278s)
[268.524422] Starting dynamic subtest: bcs0-smem
[269.794630] Dynamic subtest bcs0-smem: SUCCESS (1.273s)
[269.803363] Starting dynamic subtest: vcs0-smem
[271.066842] Dynamic subtest vcs0-smem: SUCCESS (1.271s)
[271.075708] Starting dynamic subtest: vcs1-smem
[272.338602] Dynamic subtest vcs1-smem: SUCCESS (1.271s)
[272.347811] Starting dynamic subtest: vecs0-smem
[273.610831] Dynamic subtest vecs0-smem: SUCCESS (1.274s)
[273.611544] Subtest capture: SUCCESS (6.371s)
[273.711677] [099/155] (749s left) syncobj_basic (create-signaled)
[273.746915] Starting subtest: create-signaled
[273.747608] Subtest create-signaled: SUCCESS (0.000s)
[273.804812] [100/155] (748s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[273.908372] Starting subtest: y-tiled-8bpp-rotate-180
[274.808959] Subtest y-tiled-8bpp-rotate-180: SUCCESS (0.900s)
[274.945941] [101/155] (747s left) gem_userptr_blits (sd-probe)
[274.985837] Starting subtest: sd-probe
[274.986543] Subtest sd-probe: SUCCESS (0.000s)
[275.107508] [102/155] (747s left) i915_suspend (forcewake)
[275.142133] Starting subtest: forcewake
[307.381167] Subtest forcewake: SUCCESS (2.455s)
[317.475237] [103/155] (715s left) gem_userptr_blits (sync-unmap-after-close)
[317.523343] Starting subtest: sync-unmap-after-close
[317.539656] Subtest sync-unmap-after-close: SUCCESS (0.016s)
[317.646556] [104/155] (715s left) drm_mm (drm_mm)
[317.688272] Starting subtest: drm_mm
[317.707563] Starting dynamic subtest: drm_test_mm_init
[317.781652] Dynamic subtest drm_test_mm_init: SUCCESS (0.072s)
[317.804236] Starting dynamic subtest: drm_test_mm_debug
[317.859518] Dynamic subtest drm_test_mm_debug: SUCCESS (0.073s)
[317.881116] Starting dynamic subtest: drm_test_mm_align32
[317.929222] Dynamic subtest drm_test_mm_align32: SUCCESS (0.066s)
[317.950481] Starting dynamic subtest: drm_test_mm_align64
[318.012382] Dynamic subtest drm_test_mm_align64: SUCCESS (0.077s)
[318.032860] Starting dynamic subtest: drm_test_mm_lowest
[318.076377] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.063s)
[318.099105] Starting dynamic subtest: drm_test_mm_highest
[318.158437] Dynamic subtest drm_test_mm_highest: SUCCESS (0.079s)
[318.162012] Subtest drm_mm: SUCCESS (0.469s)
[318.298504] [105/155] (714s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-indfb-pgflip-blt)
[318.395751] Starting subtest: psrhdr-1p-primscrn-indfb-pgflip-blt
[318.397163] Subtest psrhdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[318.511940] [106/155] (714s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[318.606070] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[318.607512] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[318.728570] [107/155] (714s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[318.822782] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[318.824215] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[318.936016] [108/155] (714s left) gem_exec_params (invalid-bsd2-flag-on-render)
[318.975356] Starting subtest: invalid-bsd2-flag-on-render
[318.976090] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[319.064844] [109/155] (714s left) gem_partial_pwrite_pread (reads-snoop)
[319.102883] Starting subtest: reads-snoop
[321.002628] Subtest reads-snoop: SUCCESS (1.891s)
[321.109063] [110/155] (712s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[321.201219] Starting subtest: basic-busy-flip-before-cursor-legacy
[321.202627] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[321.282322] [111/155] (712s left) kms_frontbuffer_tracking (fbcpsrhdr-farfromfence-mmap-gtt)
[321.374556] Starting subtest: fbcpsrhdr-farfromfence-mmap-gtt
[321.376007] Subtest fbcpsrhdr-farfromfence-mmap-gtt: SKIP (0.000s)
[321.455149] [112/155] (711s left) kms_flip (2x-flip-vs-modeset)
[321.547490] Starting subtest: 2x-flip-vs-modeset
[321.556156] Subtest 2x-flip-vs-modeset: SKIP (0.009s)
[321.629554] [113/155] (711s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[321.727618] Starting subtest: x-tiled-16bpp-rotate-180
[322.834742] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.103s)
[322.975369] [114/155] (710s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-move)
[323.069436] Starting subtest: hdr-1p-primscrn-spr-indfb-move
[323.070820] Subtest hdr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[323.157005] [115/155] (710s left) kms_vblank (query-forked-hang)
[323.247329] Starting subtest: query-forked-hang
[323.249100] Starting dynamic subtest: pipe-A-HDMI-A-1
[337.637408] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (14.364s)
[337.649439] Starting dynamic subtest: pipe-D-HDMI-A-1
[351.456099] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (13.806s)
[351.456914] Subtest query-forked-hang: SUCCESS (28.176s)
[351.636205] [116/155] (681s left) kms_lease (lease-revoke)
[351.732302] Starting subtest: lease-revoke
[351.734145] Starting dynamic subtest: pipe-A-HDMI-A-1
[351.768285] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.034s)
[351.800453] Starting dynamic subtest: pipe-B-HDMI-A-1
[351.805627] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.035s)
[351.838766] Starting dynamic subtest: pipe-C-HDMI-A-1
[351.842212] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.033s)
[351.854608] Starting dynamic subtest: pipe-D-HDMI-A-1
[351.877524] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.034s)
[351.878333] Subtest lease-revoke: SUCCESS (0.145s)
[351.973309] [117/155] (681s left) i915_drm_fdinfo (busy-idle-check-all)
[352.011482] Starting subtest: busy-idle-check-all
[352.012201] Starting dynamic subtest: rcs0
[352.638614] Dynamic subtest rcs0: SUCCESS (0.626s)
[352.651825] Starting dynamic subtest: bcs0
[353.261275] Dynamic subtest bcs0: SUCCESS (0.619s)
[353.274389] Starting dynamic subtest: vcs0
[353.883145] Dynamic subtest vcs0: SUCCESS (0.619s)
[353.896264] Starting dynamic subtest: vcs1
[354.507540] Dynamic subtest vcs1: SUCCESS (0.620s)
[354.521424] Starting dynamic subtest: vecs0
[355.132740] Dynamic subtest vecs0: SUCCESS (0.624s)
[355.133799] Subtest busy-idle-check-all: SUCCESS (3.120s)
[355.210917] [118/155] (678s left) gem_exec_schedule (submit-early-slice)
[355.259367] Starting subtest: submit-early-slice
[355.260090] Starting dynamic subtest: rcs0
[355.289325] Dynamic subtest rcs0: SUCCESS (0.029s)
[355.300160] Starting dynamic subtest: bcs0
[355.317968] Dynamic subtest bcs0: SUCCESS (0.027s)
[355.329254] Starting dynamic subtest: vcs0
[355.346019] Dynamic subtest vcs0: SUCCESS (0.027s)
[355.357570] Starting dynamic subtest: vcs1
[355.378141] Dynamic subtest vcs1: SUCCESS (0.031s)
[355.389540] Starting dynamic subtest: vecs0
[355.406377] Dynamic subtest vecs0: SUCCESS (0.027s)
[355.407114] Subtest submit-early-slice: SUCCESS (0.148s)
[355.728011] [119/155] (677s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[355.822335] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[355.823829] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (0.000s)
[355.885720] [120/155] (677s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-pwrite)
[355.979124] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-pwrite
[355.980518] Subtest psrhdr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[356.072846] [121/155] (677s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-pwrite)
[356.165676] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-pwrite
[356.167066] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s)
[356.265005] [122/155] (677s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-shrfb-fliptrack-mmap-gtt)
[356.357090] Starting subtest: fbcpsrhdr-1p-shrfb-fliptrack-mmap-gtt
[356.358427] Subtest fbcpsrhdr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[356.453229] [123/155] (677s left) gen9_exec_parse (secure-batches)
[356.491972] Subtest secure-batches: SKIP (0.000s)
[356.540455] [124/155] (677s left) kms_plane_scaling (planes-upscale-factor-0-25)
[356.629935] Starting subtest: planes-upscale-factor-0-25
[356.630699] Starting dynamic subtest: pipe-A
[356.690089] Dynamic subtest pipe-A: SUCCESS (0.061s)
[356.701169] Starting dynamic subtest: pipe-B
[356.824093] Dynamic subtest pipe-B: SUCCESS (0.133s)
[356.837991] Starting dynamic subtest: pipe-C
[356.984574] Dynamic subtest pipe-C: SUCCESS (0.159s)
[356.998784] Starting dynamic subtest: pipe-D
[357.118776] Dynamic subtest pipe-D: SUCCESS (0.133s)
[357.119474] Subtest planes-upscale-factor-0-25: SUCCESS (0.490s)
[357.319845] [125/155] (676s left) gem_eio (in-flight-internal-10ms)
[357.366506] Starting subtest: in-flight-internal-10ms
[357.632878] Subtest in-flight-internal-10ms: SUCCESS (0.266s)
[357.753276] [126/155] (676s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[357.853671] Starting subtest: yf-tiled-64bpp-rotate-0
[357.855167] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[357.931150] [127/155] (676s left) kms_chamelium_hpd (vga-hpd-without-ddc)
[358.075393] Subtest vga-hpd-without-ddc: SKIP (0.000s)
[358.176845] [128/155] (675s left) kms_psr (fbc-pr-sprite-render)
[358.272204] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[358.321556] [129/155] (675s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[358.415796] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[358.417208] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[358.509436] [130/155] (675s left) kms_chamelium_color (degamma)
[358.599375] Subtest degamma: SKIP (0.000s)
[358.648287] [131/155] (675s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[358.690152] Starting subtest: yf-tiled-ccs-to-x-tiled
[358.690829] Starting dynamic subtest: smem
[358.789213] Dynamic subtest smem: SUCCESS (0.099s)
[358.789950] Subtest yf-tiled-ccs-to-x-tiled: SUCCESS (0.101s)
[358.972196] [132/155] (675s left) kms_frontbuffer_tracking (fbc-suspend)
[359.064142] Starting subtest: fbc-suspend
[394.607539] Subtest fbc-suspend: SUCCESS (5.191s)
[400.786379] [133/155] (639s left) gem_exec_schedule (pi-userfault)
[400.962482] Starting subtest: pi-userfault
[400.963350] Starting dynamic subtest: rcs0
[400.970728] Dynamic subtest rcs0: SUCCESS (0.009s)
[400.991582] Starting dynamic subtest: bcs0
[400.992361] Dynamic subtest bcs0: SUCCESS (0.007s)
[401.003531] Starting dynamic subtest: vcs0
[401.004284] Dynamic subtest vcs0: SUCCESS (0.005s)
[401.014165] Starting dynamic subtest: vcs1
[401.014877] Dynamic subtest vcs1: SUCCESS (0.004s)
[401.024425] Starting dynamic subtest: vecs0
[401.025114] Dynamic subtest vecs0: SUCCESS (0.003s)
[401.025767] Subtest pi-userfault: SUCCESS (0.039s)
[401.181029] [134/155] (639s left) gem_mmap_gtt (big-bo-tiledy)
[401.216672] Starting subtest: big-bo-tiledY
[401.367181] Subtest big-bo-tiledY: SUCCESS (0.150s)
[401.484653] [135/155] (638s left) kms_psr (psr-no-drrs)
[401.625982] Subtest psr-no-drrs: SKIP (0.000s)
[401.669187] [136/155] (638s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[401.762137] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[401.763584] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[401.868071] [137/155] (638s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[401.960860] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[401.962299] Subtest hdr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[402.073482] [138/155] (638s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-render)
[402.166115] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-render
[402.167597] Subtest psrhdr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[402.272103] [139/155] (638s left) gem_mmap_offset (close-race)
[402.308546] Starting subtest: close-race
[422.398489] Subtest close-race: SUCCESS (20.017s)
[422.482860] [140/155] (618s left) syncobj_basic (bad-create-flags)
[422.517592] Starting subtest: bad-create-flags
[422.518502] Subtest bad-create-flags: SUCCESS (0.000s)
[422.581203] [141/155] (618s left) gem_ctx_shared (q-smoketest)
[422.626115] Starting subtest: Q-smoketest
[422.626921] Starting dynamic subtest: rcs0
[428.090036] Dynamic subtest rcs0: SUCCESS (5.416s)
[428.101714] Starting dynamic subtest: bcs0
[433.506641] Dynamic subtest bcs0: SUCCESS (5.419s)
[433.518425] Starting dynamic subtest: vcs0
[438.926652] Dynamic subtest vcs0: SUCCESS (5.419s)
[438.939195] Starting dynamic subtest: vcs1
[444.350547] Dynamic subtest vcs1: SUCCESS (5.422s)
[444.362766] Starting dynamic subtest: vecs0
[449.774181] Dynamic subtest vecs0: SUCCESS (5.421s)
[449.775154] Subtest Q-smoketest: SUCCESS (27.105s)
[449.917252] [142/155] (590s left) syncobj_wait (multi-wait-for-submit-submitted)
[449.960082] Starting subtest: multi-wait-for-submit-submitted
[450.068974] Subtest multi-wait-for-submit-submitted: SUCCESS (0.108s)
[450.145344] [143/155] (590s left) gem_userptr_blits (map-fixed-invalidate-busy)
[450.190989] Starting subtest: map-fixed-invalidate-busy
[450.191707] Starting dynamic subtest: gtt
[451.785418] Dynamic subtest gtt: SUCCESS (1.585s)
[451.795623] Starting dynamic subtest: wb
[453.331050] Dynamic subtest wb: SUCCESS (1.544s)
[453.340981] Starting dynamic subtest: wc
[454.892435] Dynamic subtest wc: SUCCESS (1.560s)
[454.906330] Starting dynamic subtest: uc
[456.451303] Dynamic subtest uc: SUCCESS (1.557s)
[456.452046] Subtest map-fixed-invalidate-busy: SUCCESS (6.251s)
[456.559723] [144/155] (584s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[456.653736] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[456.655146] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[456.755316] [145/155] (584s left) kms_pm_dc (dc6-dpms)
[457.852694] Starting subtest: dc6-dpms
[461.194742] Subtest dc6-dpms: FAIL (3.327s)
[461.301597] [146/155] (579s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[461.398773] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt
[461.400197] Subtest psrhdr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[461.493165] [147/155] (579s left) kms_color (ctm-signed)
[461.581434] Starting subtest: ctm-signed
[461.582138] Starting dynamic subtest: pipe-A-HDMI-A-1
[462.140030] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.558s)
[462.151438] Starting dynamic subtest: pipe-B-HDMI-A-1
[462.677452] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.536s)
[462.690979] Starting dynamic subtest: pipe-C-HDMI-A-1
[463.251923] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.573s)
[463.263480] Starting dynamic subtest: pipe-D-HDMI-A-1
[463.825219] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.572s)
[463.826010] Subtest ctm-signed: SUCCESS (2.243s)
[463.973204] [148/155] (576s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-render)
[464.069550] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-render
[464.070953] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[464.169222] [149/155] (576s left) gem_exec_await (wide-contexts)
[464.253918] Starting subtest: wide-contexts
[485.969135] Subtest wide-contexts: SUCCESS (21.708s)
[486.186330] [150/155] (554s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[486.326377] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[486.327086] Starting dynamic subtest: pipe-A-HDMI-A-1
[486.344690] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.002s)
[486.355086] Starting dynamic subtest: pipe-B-HDMI-A-1
[486.373019] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.002s)
[486.383171] Starting dynamic subtest: pipe-C-HDMI-A-1
[486.401583] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s)
[486.412242] Starting dynamic subtest: pipe-D-HDMI-A-1
[486.430289] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.002s)
[486.431714] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SKIP (0.014s)
[486.604277] [151/155] (554s left) kms_chamelium_color (ctm-0-25)
[486.697389] Subtest ctm-0-25: SKIP (0.000s)
[486.746994] [152/155] (554s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[486.840462] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc
[486.841876] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[486.928401] [153/155] (554s left) kms_3d (basic)
[486.963354] Starting subtest: basic
[488.802712] Subtest basic: SUCCESS (1.838s)
[489.037554] [154/155] (552s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[489.132647] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[489.134029] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[489.228740] [155/155] (552s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[489.319657] Subtest invalidate-primary-flip-overlay: SKIP (0.000s)
[489.362785] Closing watchdogs
results: parsing output: 0/ for test: gem_mmap_gtt
results: parsing output: 1/ for test: syncobj_eventfd
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_feature_discovery
results: parsing output: 4/ for test: gem_ctx_persistence
results: parsing output: 5/ for test: kms_psr2_sf
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: gem_ccs
results: parsing output: 8/ for test: syncobj_basic
results: parsing output: 9/ for test: kms_flip
results: parsing output: 10/ for test: kms_psr2_sf
results: parsing output: 11/ for test: gem_exercise_blt
results: parsing output: 12/ for test: prime_busy
results: parsing output: 13/ for test: gem_sync
results: parsing output: 14/ for test: sysfs_preempt_timeout
results: parsing output: 15/ for test: kms_flip_scaled_crc
results: parsing output: 16/ for test: gem_pipe_control_store_loop
results: parsing output: 17/ for test: api_intel_allocator
results: parsing output: 18/ for test: gem_exec_balancer
results: parsing output: 19/ for test: kms_pipe_stress
results: parsing output: 20/ for test: kms_ccs
results: parsing output: 21/ for test: kms_flip
results: parsing output: 22/ for test: gem_eio
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: gem_userptr_blits
results: parsing output: 25/ for test: kms_vblank
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: gem_mmap_gtt
results: parsing output: 28/ for test: kms_cursor_crc
results: parsing output: 29/ for test: kms_properties
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: i915_drm_fdinfo
results: parsing output: 32/ for test: kms_big_fb
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: perf_pmu
results: parsing output: 35/ for test: prime_mmap
results: parsing output: 36/ for test: kms_psr
results: parsing output: 37/ for test: kms_getfb
results: parsing output: 38/ for test: kms_ccs
results: parsing output: 39/ for test: gem_close
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: core_getversion
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: syncobj_timeline
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: gem_exec_fence
results: parsing output: 47/ for test: kms_ccs
results: parsing output: 48/ for test: syncobj_timeline
results: parsing output: 49/ for test: kms_atomic
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_madvise
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_cursor_crc
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: perf_pmu
results: parsing output: 56/ for test: kms_joiner
results: parsing output: 57/ for test: syncobj_timeline
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_exec_params
results: parsing output: 60/ for test: gem_exec_params
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: gem_pread
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: gem_softpin
results: parsing output: 65/ for test: kms_atomic_interruptible
results: parsing output: 66/ for test: i915_pm_rpm
results: parsing output: 67/ for test: kms_content_protection
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_psr
results: parsing output: 70/ for test: kms_plane
results: parsing output: 71/ for test: kms_flip
results: parsing output: 72/ for test: gem_sync
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: gem_mmap_wc
results: parsing output: 75/ for test: kms_plane
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_psr
results: parsing output: 78/ for test: kms_plane_scaling
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: gem_mmap
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: gem_close_race
results: parsing output: 83/ for test: gem_ctx_persistence
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_cursor_legacy
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: gem_exec_flush
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: perf
results: parsing output: 92/ for test: gem_softpin
results: parsing output: 93/ for test: gem_tiled_fence_blits
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_cursor_crc
results: parsing output: 96/ for test: gem_exec_whisper
results: parsing output: 97/ for test: gem_exec_capture
results: parsing output: 98/ for test: syncobj_basic
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: gem_userptr_blits
results: parsing output: 101/ for test: i915_suspend
results: parsing output: 102/ for test: gem_userptr_blits
results: parsing output: 103/ for test: drm_mm
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_exec_params
results: parsing output: 108/ for test: gem_partial_pwrite_pread
results: parsing output: 109/ for test: kms_cursor_legacy
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_flip
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_vblank
results: parsing output: 115/ for test: kms_lease
results: parsing output: 116/ for test: i915_drm_fdinfo
results: parsing output: 117/ for test: gem_exec_schedule
results: parsing output: 118/ for test: kms_flip_scaled_crc
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: gen9_exec_parse
results: parsing output: 123/ for test: kms_plane_scaling
results: parsing output: 124/ for test: gem_eio
results: parsing output: 125/ for test: kms_big_fb
results: parsing output: 126/ for test: kms_chamelium_hpd
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_chamelium_color
results: parsing output: 130/ for test: gem_render_copy
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: gem_exec_schedule
results: parsing output: 133/ for test: gem_mmap_gtt
results: parsing output: 134/ for test: kms_psr
results: parsing output: 135/ for test: kms_frontbuffer_tracking
results: parsing output: 136/ for test: kms_frontbuffer_tracking
results: parsing output: 137/ for test: kms_frontbuffer_tracking
results: parsing output: 138/ for test: gem_mmap_offset
results: parsing output: 139/ for test: syncobj_basic
results: parsing output: 140/ for test: gem_ctx_shared
results: parsing output: 141/ for test: syncobj_wait
results: parsing output: 142/ for test: gem_userptr_blits
results: parsing output: 143/ for test: kms_frontbuffer_tracking
results: parsing output: 144/ for test: kms_pm_dc
results: parsing output: 145/ for test: kms_frontbuffer_tracking
results: parsing output: 146/ for test: kms_color
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: gem_exec_await
results: parsing output: 149/ for test: kms_ccs
results: parsing output: 150/ for test: kms_chamelium_color
results: parsing output: 151/ for test: kms_frontbuffer_tracking
results: parsing output: 152/ for test: kms_3d
results: parsing output: 153/ for test: kms_frontbuffer_tracking
results: parsing output: 154/ for test: kms_psr_stress_test
Done.