[52.088550] Initializing watchdogs
[52.088595]   /dev/watchdog0
[52.104221] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[52.108474] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[52.110774] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[52.114118] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu)
[52.244534] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu
[59.010438] Subtest fbcpsr-rgb565-draw-mmap-cpu: SUCCESS (6.746s)
[59.155896] [002/133] (953s left) gem_mmap_offset (mmap-unmap)
[59.220299] Starting subtest: mmap-unmap
[59.222490] Starting dynamic subtest: smem0
[82.517775] Dynamic subtest smem0: SUCCESS (23.284s)
[82.520701] Subtest mmap-unmap: SUCCESS (23.284s)
[82.660088] [003/133] (930s left) fbdev (pan)
[82.695083] Starting subtest: pan
[82.722513] Subtest pan: SUCCESS (0.030s)
[82.804740] [004/133] (929s left) kms_addfb_basic (unused-pitches)
[82.856831] Starting subtest: unused-pitches
[82.859053] Subtest unused-pitches: SUCCESS (0.000s)
[83.002698] [005/133] (929s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier)
[83.101238] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier
[83.114432] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier: SKIP (0.000s)
[83.209934] [006/133] (929s left) kms_cursor_crc (cursor-random-64x21)
[83.404325] Starting subtest: cursor-random-64x21
[83.453387] Subtest cursor-random-64x21: SKIP (0.045s)
[83.714335] [007/133] (929s left) kms_feature_discovery (display-2x)
[83.803992] Starting subtest: display-2x
[83.807461] Subtest display-2x: SKIP (0.000s)
[83.898668] [008/133] (929s left) i915_pm_rpm (gem-idle)
[86.047743] Starting subtest: gem-idle
[92.242142] Subtest gem-idle: SUCCESS (6.191s)
[92.576966] [009/133] (920s left) kms_psr (psr2-sprite-render)
[93.854950] Starting subtest: psr2-sprite-render
[93.857489] Starting dynamic subtest: eDP-1
[95.573770] Dynamic subtest eDP-1: SUCCESS (1.719s)
[95.576183] Subtest psr2-sprite-render: SUCCESS (1.720s)
[96.443033] [010/133] (916s left) gem_lmem_swapping (parallel-random-verify-ccs)
[96.485819] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[96.528861] [011/133] (916s left) kms_addfb_basic (basic-x-tiled-legacy)
[96.592082] Starting subtest: basic-x-tiled-legacy
[96.596420] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[96.739913] [012/133] (916s left) gem_eio (in-flight-suspend)
[96.921711] Starting subtest: in-flight-suspend
[140.249298] Subtest in-flight-suspend: SUCCESS (13.869s)
[140.420453] [FACT gem_eio (in-flight-suspend)] new: kernel.kmod_is_loaded.vgem: true
[140.423969] [013/133] (872s left) gem_wait (write-wait)
[140.496244] Starting subtest: write-wait
[140.498581] Starting dynamic subtest: all-engines
[141.603039] Dynamic subtest all-engines: SUCCESS (1.096s)
[141.619031] Starting dynamic subtest: rcs0
[142.659026] Dynamic subtest rcs0: SUCCESS (1.044s)
[142.674490] Starting dynamic subtest: bcs0
[143.715954] Dynamic subtest bcs0: SUCCESS (1.046s)
[143.731505] Starting dynamic subtest: vcs0
[144.767612] Dynamic subtest vcs0: SUCCESS (1.043s)
[144.783589] Starting dynamic subtest: vcs1
[145.821890] Dynamic subtest vcs1: SUCCESS (1.046s)
[145.837557] Starting dynamic subtest: vecs0
[146.874837] Dynamic subtest vecs0: SUCCESS (1.045s)
[146.891646] Starting dynamic subtest: ccs0
[147.933641] Dynamic subtest ccs0: SUCCESS (1.051s)
[147.936180] Subtest write-wait: SUCCESS (7.377s)
[148.155065] [014/133] (864s left) kms_plane_scaling (planes-upscale-factor-0-25)
[148.255022] Starting subtest: planes-upscale-factor-0-25
[148.257418] Starting dynamic subtest: pipe-A
[148.329426] Dynamic subtest pipe-A: SUCCESS (0.074s)
[148.340215] Starting dynamic subtest: pipe-B
[149.510777] Dynamic subtest pipe-B: SUCCESS (1.175s)
[149.521589] Starting dynamic subtest: pipe-C
[150.629565] Dynamic subtest pipe-C: SUCCESS (1.114s)
[150.639933] Starting dynamic subtest: pipe-D
[151.756768] Dynamic subtest pipe-D: SUCCESS (1.123s)
[151.759065] Subtest planes-upscale-factor-0-25: SUCCESS (3.488s)
[152.942293] [015/133] (860s left) kms_psr (pr-cursor-render)
[153.052577] Starting subtest: pr-cursor-render
[153.057041] Subtest pr-cursor-render: SKIP (0.000s)
[153.137856] [016/133] (860s left) gem_exec_schedule (fairslice)
[153.204665] Starting subtest: fairslice
[153.206553] Starting dynamic subtest: rcs0
[155.221169] Dynamic subtest rcs0: SUCCESS (2.019s)
[155.239671] Starting dynamic subtest: bcs0
[157.244172] Dynamic subtest bcs0: SUCCESS (2.018s)
[157.262234] Starting dynamic subtest: vcs0
[159.266408] Dynamic subtest vcs0: SUCCESS (2.017s)
[159.276734] Starting dynamic subtest: vcs1
[161.285765] Dynamic subtest vcs1: SUCCESS (2.016s)
[161.296763] Starting dynamic subtest: vecs0
[163.302658] Dynamic subtest vecs0: SUCCESS (2.015s)
[163.312744] Starting dynamic subtest: ccs0
[165.327549] Dynamic subtest ccs0: SUCCESS (2.023s)
[165.329886] Subtest fairslice: SUCCESS (12.110s)
[165.641863] [017/133] (847s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[165.756039] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[165.758747] Starting dynamic subtest: A-eDP1
[169.369236] Dynamic subtest A-eDP1: SUCCESS (3.611s)
[169.378492] Starting dynamic subtest: B-eDP1
[172.577067] Dynamic subtest B-eDP1: SUCCESS (3.207s)
[172.586129] Starting dynamic subtest: C-eDP1
[175.779217] Dynamic subtest C-eDP1: SUCCESS (3.200s)
[175.788985] Starting dynamic subtest: D-eDP1
[178.898677] Dynamic subtest D-eDP1: SUCCESS (3.119s)
[178.901014] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.144s)
[179.717662] [018/133] (833s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[179.817440] Starting subtest: stress-xrgb8888-xtiled
[185.671261] Subtest stress-xrgb8888-xtiled: SUCCESS (5.853s)
[185.727738] [019/133] (827s left) gem_sync (basic-many-each)
[185.801257] Starting subtest: basic-many-each
[188.085187] Subtest basic-many-each: SUCCESS (2.290s)
[188.276346] [020/133] (825s left) syncobj_basic (create-signaled)
[188.333167] Starting subtest: create-signaled
[188.335373] Subtest create-signaled: SUCCESS (0.000s)
[188.450689] [021/133] (824s left) perf_pmu (busy-start)
[188.487107] Starting subtest: busy-start
[188.489330] Starting dynamic subtest: rcs0
[191.036602] Dynamic subtest rcs0: SUCCESS (2.550s)
[191.049663] Starting dynamic subtest: bcs0
[193.586708] Dynamic subtest bcs0: SUCCESS (2.548s)
[193.597908] Starting dynamic subtest: vcs0
[197.347648] Dynamic subtest vcs0: SUCCESS (3.756s)
[197.359905] Starting dynamic subtest: vcs1
[201.380440] Dynamic subtest vcs1: SUCCESS (4.029s)
[201.398538] Starting dynamic subtest: vecs0
[205.283425] Dynamic subtest vecs0: SUCCESS (3.900s)
[205.296343] Starting dynamic subtest: ccs0
[207.831861] Dynamic subtest ccs0: SUCCESS (2.547s)
[207.834241] Subtest busy-start: SUCCESS (19.341s)
[207.965740] [022/133] (805s left) gem_userptr_blits (sync-overlap)
[208.031535] Starting subtest: sync-overlap
[208.034126] Subtest sync-overlap: SUCCESS (0.000s)
[208.169796] [023/133] (805s left) kms_big_fb (linear-64bpp-rotate-180)
[208.283500] Starting subtest: linear-64bpp-rotate-180
[209.979064] Subtest linear-64bpp-rotate-180: SUCCESS (1.695s)
[210.167873] [024/133] (803s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[210.284711] Starting subtest: 2x-cursor-vs-flip-legacy
[210.288912] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.002s)
[210.451376] [025/133] (803s left) perf_pmu (busy)
[210.486375] Starting subtest: busy
[210.488745] Starting dynamic subtest: rcs0
[211.088304] Dynamic subtest rcs0: SUCCESS (0.602s)
[211.098760] Starting dynamic subtest: bcs0
[211.662102] Dynamic subtest bcs0: SUCCESS (0.570s)
[211.673608] Starting dynamic subtest: vcs0
[213.347966] Dynamic subtest vcs0: SUCCESS (1.684s)
[213.359906] Starting dynamic subtest: vcs1
[215.395663] Dynamic subtest vcs1: SUCCESS (2.045s)
[215.407072] Starting dynamic subtest: vecs0
[217.380060] Dynamic subtest vecs0: SUCCESS (1.980s)
[217.392834] Starting dynamic subtest: ccs0
[217.946781] Dynamic subtest ccs0: SUCCESS (0.566s)
[217.949772] Subtest busy: SUCCESS (7.459s)
[218.101899] [026/133] (795s left) kms_addfb_basic (no-handle)
[218.164926] Starting subtest: no-handle
[218.166805] Subtest no-handle: SUCCESS (0.000s)
[218.331191] [027/133] (795s left) dumb_buffer (map-invalid-size)
[218.389768] Starting subtest: map-invalid-size
[218.391800] Subtest map-invalid-size: SUCCESS (0.000s)
[218.507862] [028/133] (795s left) gem_exec_reloc (basic-gtt-cpu)
[218.569177] Subtest basic-gtt-cpu: SKIP (0.000s)
[218.656973] [029/133] (795s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[218.763562] Starting subtest: primary-x-tiled-reflect-x-180
[225.834303] Subtest primary-x-tiled-reflect-x-180: SUCCESS (7.070s)
[227.100500] [030/133] (786s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[227.217060] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[227.221244] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[227.292668] [031/133] (786s left) gem_exec_schedule (preempt-hang)
[227.480245] Starting subtest: preempt-hang
[227.482214] Starting dynamic subtest: rcs0
[227.727932] Dynamic subtest rcs0: SUCCESS (0.248s)
[227.737146] Starting dynamic subtest: bcs0
[227.962430] Dynamic subtest bcs0: SUCCESS (0.234s)
[227.971683] Starting dynamic subtest: vcs0
[228.188879] Dynamic subtest vcs0: SUCCESS (0.225s)
[228.198812] Starting dynamic subtest: vcs1
[228.419406] Dynamic subtest vcs1: SUCCESS (0.229s)
[228.429108] Starting dynamic subtest: vecs0
[228.648761] Dynamic subtest vecs0: SUCCESS (0.228s)
[228.660446] Starting dynamic subtest: ccs0
[228.879022] Dynamic subtest ccs0: SUCCESS (0.230s)
[228.881067] Subtest preempt-hang: SUCCESS (1.400s)
[229.451668] [032/133] (784s left) gem_ctx_persistence (heartbeat-close)
[229.517688] Starting subtest: heartbeat-close
[229.522407] Subtest heartbeat-close: SKIP (0.000s)
[229.640011] [033/133] (784s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[229.730797] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[237.365893] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.636s)
[237.523240] [034/133] (776s left) gen9_exec_parse (bb-chained)
[237.589870] Subtest bb-chained: SKIP (0.000s)
[237.665309] [035/133] (776s left) sysfs_heartbeat_interval (mixed)
[237.720865] Starting subtest: mixed
[237.723141] Starting dynamic subtest: vecs0
[242.974895] Dynamic subtest vecs0: SUCCESS (5.254s)
[242.986631] Starting dynamic subtest: ccs0
[248.224686] Dynamic subtest ccs0: SUCCESS (5.249s)
[248.236848] Starting dynamic subtest: vcs0
[253.471364] Dynamic subtest vcs0: SUCCESS (5.245s)
[253.482988] Starting dynamic subtest: bcs0
[258.685040] Dynamic subtest bcs0: SUCCESS (5.212s)
[258.696722] Starting dynamic subtest: rcs0
[263.915402] Dynamic subtest rcs0: SUCCESS (5.230s)
[263.926540] Starting dynamic subtest: vcs1
[269.177651] Dynamic subtest vcs1: SUCCESS (5.260s)
[269.180454] Subtest mixed: SUCCESS (31.462s)
[269.266303] [036/133] (744s left) kms_content_protection (dp-mst-type-1)
[269.412104] Starting subtest: dp-mst-type-1
[269.416584] Subtest dp-mst-type-1: SKIP (0.000s)
[269.569225] [037/133] (744s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[269.671740] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[269.675966] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[269.791494] [038/133] (744s left) kms_vblank (ts-continuation-dpms-rpm)
[269.882726] Starting subtest: ts-continuation-dpms-rpm
[269.884966] Starting dynamic subtest: pipe-A-eDP-1
[272.406215] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.522s)
[272.421488] Starting dynamic subtest: pipe-D-eDP-1
[274.663666] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.252s)
[274.666003] Subtest ts-continuation-dpms-rpm: SUCCESS (4.778s)
[275.479169] [039/133] (738s left) gem_render_copy (linear-to-vebox-yf-tiled)
[275.552059] Starting subtest: linear-to-vebox-yf-tiled
[275.556556] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[275.747396] [040/133] (738s left) vgem_basic (dmabuf-fence)
[275.802145] Starting subtest: dmabuf-fence
[275.804403] Subtest dmabuf-fence: SUCCESS (0.001s)
[275.869319] [041/133] (738s left) kms_psr (psr-primary-mmap-gtt)
[275.955258] Starting subtest: psr-primary-mmap-gtt
[275.957494] Starting dynamic subtest: eDP-1
[277.363485] Dynamic subtest eDP-1: SKIP (1.406s)
[277.368614] Subtest psr-primary-mmap-gtt: SKIP (1.408s)
[277.547346] [042/133] (736s left) kms_chamelium_color (ctm-green-to-red)
[277.652786] Subtest ctm-green-to-red: SKIP (0.000s)
[277.696963] [043/133] (736s left) kms_color_pipeline (plane-lut1d-lut1d)
[277.792801] Starting subtest: plane-lut1d-lut1d
[277.805160] Starting dynamic subtest: pipe-A-eDP-1
[278.484142] Dynamic subtest pipe-A-eDP-1: FAIL (0.313s)
[279.176504] Starting dynamic subtest: pipe-B-eDP-1
[279.982828] Dynamic subtest pipe-B-eDP-1: FAIL (0.279s)
[280.512066] Starting dynamic subtest: pipe-C-eDP-1
[281.336277] Dynamic subtest pipe-C-eDP-1: FAIL (0.235s)
[281.840182] Starting dynamic subtest: pipe-D-eDP-1
[282.702730] Dynamic subtest pipe-D-eDP-1: FAIL (0.269s)
[282.704718] Subtest plane-lut1d-lut1d: FAIL (4.602s)
[283.239511] [044/133] (731s left) gem_eio (create-ext)
[283.460927] Starting subtest: create-ext
[283.788301] Subtest create-ext: SUCCESS (0.326s)
[283.931708] [045/133] (730s left) prime_busy (hang)
[283.997163] Starting subtest: hang
[283.999012] Starting dynamic subtest: rcs0
[309.888250] Dynamic subtest rcs0: SUCCESS (25.883s)
[309.898993] Starting dynamic subtest: bcs0
[317.042347] Dynamic subtest bcs0: SUCCESS (7.152s)
[317.051215] Starting dynamic subtest: vcs0
[324.017856] Dynamic subtest vcs0: SUCCESS (6.975s)
[324.027226] Starting dynamic subtest: vcs1
[330.992108] Dynamic subtest vcs1: SUCCESS (6.969s)
[331.000683] Starting dynamic subtest: vecs0
[338.029952] Dynamic subtest vecs0: SUCCESS (7.037s)
[338.039063] Starting dynamic subtest: ccs0
[351.873224] Dynamic subtest ccs0: SUCCESS (13.835s)
[351.875124] Subtest hang: SUCCESS (67.859s)
[352.015449] [046/133] (662s left) gem_eio (unwedge-stress)
[352.222196] Starting subtest: unwedge-stress
[352.224547] Starting dynamic subtest: render
[356.583399] Dynamic subtest render: SUCCESS (4.357s)
[356.598039] Starting dynamic subtest: bsd1
[374.828925] Dynamic subtest bsd1: SUCCESS (18.246s)
[374.845927] Starting dynamic subtest: bsd2
[392.757054] Dynamic subtest bsd2: SUCCESS (17.930s)
[392.773835] Starting dynamic subtest: blt
[392.777741] Dynamic subtest blt: SKIP (0.000s)
[392.786704] Starting dynamic subtest: vebox
[410.814717] Dynamic subtest vebox: SUCCESS (18.057s)
[410.817209] Subtest unwedge-stress: SUCCESS (58.595s)
[412.440408] [047/133] (602s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[412.547757] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[412.552064] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[412.683171] [048/133] (601s left) drm_read (fault-buffer)
[412.837981] Starting subtest: fault-buffer
[412.840285] Subtest fault-buffer: SUCCESS (0.001s)
[412.996691] [049/133] (601s left) gem_exec_balancer (bonded-true-hang)
[413.265239] Starting subtest: bonded-true-hang
[413.270289] Subtest bonded-true-hang: SKIP (0.000s)
[413.394688] [050/133] (601s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[413.477520] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs
[413.479885] Starting dynamic subtest: pipe-A-eDP-1
[413.503259] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[413.514750] Starting dynamic subtest: pipe-B-eDP-1
[413.536151] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[413.545121] Starting dynamic subtest: pipe-C-eDP-1
[413.566530] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[413.575055] Starting dynamic subtest: pipe-D-eDP-1
[413.596543] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[413.600729] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[415.786631] [051/133] (598s left) kms_pm_rpm (modeset-pc8-residency-stress)
[417.515147] Starting subtest: modeset-pc8-residency-stress
[417.520183] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[418.041689] [052/133] (596s left) sw_sync (sync_busy_fork_unixsocket)
[418.086694] Starting subtest: sync_busy_fork_unixsocket
[418.091785] Subtest sync_busy_fork_unixsocket: SUCCESS (0.009s)
[418.178771] [053/133] (596s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[418.292283] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[418.296654] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[418.426996] [054/133] (596s left) gem_exec_schedule (semaphore-noskip)
[418.506375] Starting subtest: semaphore-noskip
[418.928623] Subtest semaphore-noskip: SUCCESS (0.425s)
[419.284619] [055/133] (595s left) gem_mmap_wc (bad-size)
[419.347251] Subtest bad-size: SKIP (0.000s)
[419.417797] [056/133] (595s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[419.521224] Starting subtest: fbcpsr-stridechange
[425.747891] Subtest fbcpsr-stridechange: SUCCESS (6.230s)
[425.944451] [057/133] (588s left) kms_chamelium_frames (hdmi-crc-single)
[426.338153] Subtest hdmi-crc-single: SKIP (0.000s)
[427.136331] [058/133] (587s left) syncobj_timeline (multi-wait-for-submit-signaled)
[427.186470] Starting subtest: multi-wait-for-submit-signaled
[427.188804] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[427.292813] [059/133] (587s left) gem_exec_fence (syncobj-invalid-wait)
[427.721198] Starting subtest: syncobj-invalid-wait
[427.723739] Subtest syncobj-invalid-wait: SUCCESS (0.001s)
[429.484401] [060/133] (585s left) gem_softpin (allocator-fork)
[429.546877] Starting subtest: allocator-fork
[431.762989] Subtest allocator-fork: SUCCESS (2.214s)
[431.919597] [061/133] (583s left) i915_query (test-query-geometry-subslices)
[431.976070] Starting subtest: test-query-geometry-subslices
[431.978061] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[432.103890] [062/133] (583s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[432.211624] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[432.216021] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[432.290817] [063/133] (582s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[432.393796] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[432.398137] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[432.500101] [064/133] (582s left) i915_drm_fdinfo (memory-info-shared)
[432.539457] Starting subtest: memory-info-shared
[432.541680] Starting dynamic subtest: smem0
[432.616687] Dynamic subtest smem0: SUCCESS (0.078s)
[432.619429] Subtest memory-info-shared: SUCCESS (0.079s)
[432.701927] [065/133] (582s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[432.765589] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[432.769974] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[432.960463] [066/133] (582s left) kms_chamelium_hpd (common-hpd-after-suspend)
[433.349700] Subtest common-hpd-after-suspend: SKIP (0.000s)
[434.167856] [067/133] (581s left) gem_exec_fence (basic-wait)
[434.349883] Starting subtest: basic-wait
[434.352375] Starting dynamic subtest: rcs0
[434.438986] Dynamic subtest rcs0: SUCCESS (0.092s)
[434.450895] Starting dynamic subtest: bcs0
[434.506348] Dynamic subtest bcs0: SUCCESS (0.066s)
[434.518619] Starting dynamic subtest: vcs0
[434.575529] Dynamic subtest vcs0: SUCCESS (0.067s)
[434.586889] Starting dynamic subtest: vcs1
[434.641275] Dynamic subtest vcs1: SUCCESS (0.064s)
[434.653403] Starting dynamic subtest: vecs0
[434.706688] Dynamic subtest vecs0: SUCCESS (0.063s)
[434.719366] Starting dynamic subtest: ccs0
[434.767719] Dynamic subtest ccs0: SUCCESS (0.058s)
[434.770325] Subtest basic-wait: SUCCESS (0.423s)
[436.526866] [068/133] (578s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[436.628246] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[436.632284] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[436.760754] [069/133] (578s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[436.828659] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[436.890430] [070/133] (578s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-pwrite)
[436.990759] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-pwrite
[444.264005] Subtest fbc-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (7.277s)
[445.397916] [071/133] (570s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[445.505645] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[445.510269] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[446.625429] [072/133] (568s left) template (a)
[446.686324] Starting subtest: A
[446.688184] Subtest A: SUCCESS (0.000s)
[446.806610] [073/133] (568s left) kms_psr (fbc-psr-sprite-plane-onoff)
[446.900255] Starting subtest: fbc-psr-sprite-plane-onoff
[446.902452] Starting dynamic subtest: eDP-1
[446.906326] Dynamic subtest eDP-1: SKIP (0.000s)
[446.910191] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.001s)
[446.986951] [074/133] (568s left) i915_query (query-topology-matches-eu-total)
[447.046104] Starting subtest: query-topology-matches-eu-total
[447.048001] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[447.167626] [075/133] (568s left) kms_psr (fbc-psr2-primary-blt)
[447.261635] Starting subtest: fbc-psr2-primary-blt
[447.263851] Starting dynamic subtest: eDP-1
[447.267877] Dynamic subtest eDP-1: SKIP (0.000s)
[447.271904] Subtest fbc-psr2-primary-blt: SKIP (0.001s)
[447.347985] [076/133] (568s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[447.456837] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[447.460869] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[447.574286] [077/133] (568s left) kms_frontbuffer_tracking (basic)
[447.675189] Starting subtest: basic
[450.880232] Subtest basic: SUCCESS (3.207s)
[451.031570] [078/133] (564s left) kms_cursor_crc (cursor-onscreen-128x42)
[451.265418] Starting subtest: cursor-onscreen-128x42
[451.311888] Subtest cursor-onscreen-128x42: SKIP (0.041s)
[451.555287] [079/133] (564s left) kms_universal_plane (universal-plane-functional)
[451.667077] Starting subtest: universal-plane-functional
[451.669191] Starting dynamic subtest: pipe-A-eDP-1
[455.563205] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.893s)
[455.573568] Starting dynamic subtest: pipe-B-eDP-1
[460.040190] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.475s)
[460.050215] Starting dynamic subtest: pipe-C-eDP-1
[464.416002] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.374s)
[464.425722] Starting dynamic subtest: pipe-D-eDP-1
[468.822231] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.404s)
[468.824540] Subtest universal-plane-functional: SUCCESS (17.153s)
[469.695647] [080/133] (546s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[469.798663] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[469.802900] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[469.921887] [081/133] (546s left) gem_lmem_swapping (massive-random)
[469.965705] Subtest massive-random: SKIP (0.000s)
[470.007050] [082/133] (545s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[470.113652] Starting subtest: psr2-plane-move-sf-dmg-area
[470.115926] Starting dynamic subtest: pipe-A-eDP-1
[474.619853] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.511s)
[474.630128] Starting dynamic subtest: pipe-B-eDP-1
[479.949422] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.325s)
[479.951753] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (9.839s)
[480.830900] [083/133] (535s left) gem_ctx_persistence (engines-mixed-process)
[480.907726] Starting subtest: engines-mixed-process
[480.910065] Starting dynamic subtest: rcs0
[482.375610] Dynamic subtest rcs0: SUCCESS (1.466s)
[482.388168] Starting dynamic subtest: bcs0
[484.401417] Dynamic subtest bcs0: SUCCESS (2.024s)
[484.413027] Starting dynamic subtest: vcs0
[486.382260] Dynamic subtest vcs0: SUCCESS (1.978s)
[486.394595] Starting dynamic subtest: vcs1
[488.358375] Dynamic subtest vcs1: SUCCESS (1.974s)
[488.370402] Starting dynamic subtest: vecs0
[490.362471] Dynamic subtest vecs0: SUCCESS (2.002s)
[490.373039] Starting dynamic subtest: ccs0
[492.343026] Dynamic subtest ccs0: SUCCESS (1.975s)
[492.344954] Subtest engines-mixed-process: SUCCESS (11.432s)
[492.447285] [084/133] (523s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[492.504493] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[492.608446] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.103s)
[492.702235] [085/133] (523s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[492.828166] Starting subtest: flip-vs-cursor-busy-crc-atomic
[493.632608] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.803s)
[494.463155] [086/133] (521s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[494.565778] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[494.570249] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[494.705342] [087/133] (521s left) kms_lease (multimaster-lease)
[494.804560] Starting subtest: multimaster-lease
[494.806847] Subtest multimaster-lease: SUCCESS (0.004s)
[494.932688] [088/133] (521s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[495.031549] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[495.033843] Starting dynamic subtest: pipe-A-eDP-1
[495.043011] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[495.053525] Starting dynamic subtest: pipe-B-eDP-1
[495.062634] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[495.073462] Starting dynamic subtest: pipe-C-eDP-1
[495.081695] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[495.090528] Starting dynamic subtest: pipe-D-eDP-1
[495.098540] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[495.102422] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[497.321523] [089/133] (518s left) kms_async_flips (crc-atomic)
[497.424572] Starting subtest: crc-atomic
[497.801450] Starting dynamic subtest: pipe-A-eDP-1
[500.714529] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.912s)
[501.092316] Starting dynamic subtest: pipe-B-eDP-1
[503.948456] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.865s)
[504.327016] Starting dynamic subtest: pipe-C-eDP-1
[507.260235] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.944s)
[507.622003] Starting dynamic subtest: pipe-D-eDP-1
[510.511555] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.898s)
[510.514022] Subtest crc-atomic: SUCCESS (13.088s)
[511.774276] [090/133] (504s left) i915_hangman (detector)
[511.853259] Starting subtest: detector
[511.855183] Starting dynamic subtest: rcs0
[523.330696] Dynamic subtest rcs0: SUCCESS (11.475s)
[523.343460] Starting dynamic subtest: bcs0
[535.299734] Dynamic subtest bcs0: SUCCESS (11.964s)
[535.312096] Starting dynamic subtest: vcs0
[546.306979] Dynamic subtest vcs0: SUCCESS (11.002s)
[546.319221] Starting dynamic subtest: vcs1
[558.274958] Dynamic subtest vcs1: SUCCESS (11.962s)
[558.287180] Starting dynamic subtest: vecs0
[568.258628] Dynamic subtest vecs0: SUCCESS (9.978s)
[568.271469] Starting dynamic subtest: ccs0
[578.306272] Dynamic subtest ccs0: SUCCESS (10.043s)
[578.309376] Subtest detector: SUCCESS (66.440s)
[578.463712] [091/133] (437s left) kms_plane (pixel-format-4-tiled-modifier)
[578.576548] Starting subtest: pixel-format-4-tiled-modifier
[578.602093] Starting dynamic subtest: pipe-A-plane-0
[579.291276] Dynamic subtest pipe-A-plane-0: SUCCESS (0.689s)
[579.301164] Starting dynamic subtest: pipe-A-plane-3
[579.735097] Dynamic subtest pipe-A-plane-3: SUCCESS (0.444s)
[579.744761] Starting dynamic subtest: pipe-A-plane-5
[579.748460] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[580.834309] Starting dynamic subtest: pipe-B-plane-0
[581.548748] Dynamic subtest pipe-B-plane-0: SUCCESS (0.722s)
[581.560045] Starting dynamic subtest: pipe-B-plane-3
[581.959239] Dynamic subtest pipe-B-plane-3: SUCCESS (0.410s)
[581.968429] Starting dynamic subtest: pipe-B-plane-5
[581.972018] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[582.275550] Subtest pixel-format-4-tiled-modifier: SUCCESS (3.698s)
[583.122481] [092/133] (433s left) syncobj_timeline (etime-single-wait-submitted)
[583.183708] Starting subtest: etime-single-wait-submitted
[583.289159] Subtest etime-single-wait-submitted: SUCCESS (0.105s)
[583.376978] [093/133] (433s left) gem_cs_tlb (engines)
[583.445470] Starting subtest: engines
[583.447737] Starting dynamic subtest: rcs0
[585.600678] Dynamic subtest rcs0: SUCCESS (2.151s)
[585.609813] Starting dynamic subtest: bcs0
[587.755044] Dynamic subtest bcs0: SUCCESS (2.152s)
[587.766825] Starting dynamic subtest: vcs0
[589.909255] Dynamic subtest vcs0: SUCCESS (2.152s)
[589.919117] Starting dynamic subtest: vcs1
[592.063729] Dynamic subtest vcs1: SUCCESS (2.152s)
[592.074823] Starting dynamic subtest: vecs0
[594.216974] Dynamic subtest vecs0: SUCCESS (2.153s)
[594.226779] Starting dynamic subtest: ccs0
[596.371264] Dynamic subtest ccs0: SUCCESS (2.153s)
[596.373537] Subtest engines: SUCCESS (12.921s)
[596.524931] [094/133] (419s left) syncobj_timeline (invalid-transfer-illegal-handle)
[596.586197] Starting subtest: invalid-transfer-illegal-handle
[596.588552] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[596.720542] [095/133] (419s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[596.831733] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[603.688358] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.858s)
[603.839865] [096/133] (412s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[603.949914] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[603.954351] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[604.055277] [097/133] (412s left) kms_flip (2x-flip-vs-modeset-vs-hang)
[604.156245] Starting subtest: 2x-flip-vs-modeset-vs-hang
[604.167698] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.011s)
[604.262588] [098/133] (412s left) syncobj_timeline (single-wait-for-submit-signaled)
[604.313582] Starting subtest: single-wait-for-submit-signaled
[604.315945] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[604.439768] [099/133] (412s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[604.546478] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[605.626185] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.080s)
[605.799172] [100/133] (410s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[605.911069] Starting subtest: fbc-rgb565-draw-blt
[610.126922] Subtest fbc-rgb565-draw-blt: SUCCESS (4.217s)
[611.341063] [101/133] (405s left) gem_mmap_wc (close)
[611.410546] Subtest close: SKIP (0.000s)
[611.483598] [102/133] (405s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[611.582919] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[611.587329] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[611.707864] [103/133] (405s left) gem_exec_store (pages)
[611.771710] Starting subtest: pages
[611.773694] Starting dynamic subtest: rcs0
[611.892098] Dynamic subtest rcs0: SUCCESS (0.121s)
[611.904449] Starting dynamic subtest: bcs0
[611.965083] Dynamic subtest bcs0: SUCCESS (0.073s)
[611.976176] Starting dynamic subtest: vcs0
[612.039218] Dynamic subtest vcs0: SUCCESS (0.073s)
[612.051988] Starting dynamic subtest: vcs1
[612.104446] Dynamic subtest vcs1: SUCCESS (0.064s)
[612.115900] Starting dynamic subtest: vecs0
[612.197376] Dynamic subtest vecs0: SUCCESS (0.092s)
[612.209770] Starting dynamic subtest: ccs0
[612.278118] Dynamic subtest ccs0: SUCCESS (0.079s)
[612.280107] Subtest pages: SUCCESS (0.510s)
[612.475226] [104/133] (404s left) kms_pm_dc (dc6-psr)
[613.582160] Starting subtest: dc6-psr
[616.467055] Subtest dc6-psr: SUCCESS (2.883s)
[617.281377] [105/133] (399s left) gem_fence_thrash (bo-write-verify-none)
[617.320435] Starting subtest: bo-write-verify-none
[617.349476] Subtest bo-write-verify-none: SKIP (0.025s)
[617.409632] [106/133] (399s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[617.537095] Starting subtest: basic-flip-after-cursor-atomic
[618.451732] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.912s)
[619.304567] [107/133] (397s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[619.418024] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[620.412097] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (0.995s)
[621.236593] [108/133] (395s left) kms_dp_linktrain_fallback (dsc-fallback)
[621.328520] Starting subtest: dsc-fallback
[621.335029] Subtest dsc-fallback: SKIP (0.000s)
[621.412748] [109/133] (395s left) api_intel_bb (blit-reloc-keep-cache)
[621.471365] Starting subtest: blit-reloc-keep-cache
[621.475893] Subtest blit-reloc-keep-cache: SKIP (0.001s)
[621.623127] [110/133] (395s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[621.728544] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[621.730742] Starting dynamic subtest: pipe-A-default-mode
[622.892004] Dynamic subtest pipe-A-default-mode: SKIP (1.162s)
[622.896142] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.163s)
[623.087867] [111/133] (394s left) gen3_render_tiledx_blits
[623.220494] [112/133] (394s left) gem_softpin (overlap)
[623.275401] Starting subtest: overlap
[624.220494] Subtest overlap: SUCCESS (0.946s)
[624.388291] [113/133] (392s left) syncobj_wait (multi-wait-signaled)
[624.444035] Starting subtest: multi-wait-signaled
[624.446453] Subtest multi-wait-signaled: SUCCESS (0.000s)
[624.578282] [114/133] (392s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[624.678423] Starting subtest: plane-primary-toggle-with-vblank-wait
[624.680650] Starting dynamic subtest: pipe-A-eDP-1
[624.851023] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.174s)
[625.157227] Starting dynamic subtest: pipe-B-eDP-1
[626.061425] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.914s)
[626.371209] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.695s)
[627.240439] [115/133] (390s left) template (b)
[627.303581] Starting subtest: B
[627.305817] Subtest B: SUCCESS (0.000s)
[627.446584] [116/133] (389s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[627.553582] Starting subtest: psr-rgb565-draw-mmap-gtt
[627.557529] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[627.690344] [117/133] (389s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[627.798975] Starting subtest: yf-tiled-32bpp-rotate-270
[627.803457] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[627.916577] [118/133] (389s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[628.060582] Starting subtest: flip-vs-cursor-toggle
[636.648832] Subtest flip-vs-cursor-toggle: SUCCESS (8.595s)
[637.462681] [119/133] (380s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[637.563332] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[637.567643] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[637.674854] [120/133] (379s left) gem_userptr_blits (map-fixed-invalidate)
[637.746968] Starting subtest: map-fixed-invalidate
[637.751490] Subtest map-fixed-invalidate: SKIP (0.000s)
[637.912600] [121/133] (379s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[638.011645] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[638.013844] Starting dynamic subtest: pipe-A-eDP-1
[638.033627] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.021s)
[638.044979] Starting dynamic subtest: pipe-B-eDP-1
[638.064166] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.020s)
[638.073849] Starting dynamic subtest: pipe-C-eDP-1
[638.093933] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.020s)
[638.103421] Starting dynamic subtest: pipe-D-eDP-1
[638.123130] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.020s)
[638.125318] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.087s)
[640.350040] [122/133] (377s left) gem_mmap_gtt (basic-small-copy-xy)
[640.410144] Subtest basic-small-copy-XY: SKIP (0.000s)
[640.479806] [123/133] (377s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[640.580337] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[640.582527] Starting dynamic subtest: pipe-A
[640.602573] Dynamic subtest pipe-A: SKIP (0.016s)
[640.612368] Starting dynamic subtest: pipe-B
[640.632484] Dynamic subtest pipe-B: SKIP (0.030s)
[640.642368] Starting dynamic subtest: pipe-C
[640.665576] Dynamic subtest pipe-C: SKIP (0.030s)
[640.675041] Starting dynamic subtest: pipe-D
[640.695540] Dynamic subtest pipe-D: SKIP (0.030s)
[640.699916] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.110s)
[640.815674] [124/133] (376s left) gem_caching (writes)
[640.873340] Subtest writes: SKIP (0.000s)
[640.944783] [125/133] (376s left) kms_invalid_mode (bad-hsync-start)
[641.032177] Starting subtest: bad-hsync-start
[641.034473] Starting dynamic subtest: pipe-A-eDP-1
[641.320383] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.292s)
[641.330940] Starting dynamic subtest: pipe-B-eDP-1
[641.333138] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[641.342243] Starting dynamic subtest: pipe-C-eDP-1
[641.344731] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[641.353402] Starting dynamic subtest: pipe-D-eDP-1
[641.355360] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[641.357287] Subtest bad-hsync-start: SUCCESS (0.297s)
[642.184633] [126/133] (375s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[642.284054] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[642.288195] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[642.408330] [127/133] (375s left) kms_busy (extended-modeset-hang-newfb)
[642.516397] Starting subtest: extended-modeset-hang-newfb
[642.518644] Starting dynamic subtest: pipe-A
[677.274617] Dynamic subtest pipe-A: SUCCESS (34.764s)
[677.284882] Starting dynamic subtest: pipe-D
[700.264025] Dynamic subtest pipe-D: SUCCESS (22.991s)
[700.266425] Subtest extended-modeset-hang-newfb: SUCCESS (57.760s)
[701.067981] [128/133] (316s left) gem_userptr_blits (unsync-unmap)
[701.143551] Subtest unsync-unmap: SKIP (0.000s)
[701.287229] [129/133] (316s left) kms_cursor_crc (cursor-sliding-256x85)
[701.579440] Starting subtest: cursor-sliding-256x85
[701.624774] Subtest cursor-sliding-256x85: SKIP (0.043s)
[701.838425] [130/133] (316s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[701.945685] Starting subtest: flip-vs-dpms-on-nop-interruptible
[701.947987] Starting dynamic subtest: A-eDP1
[703.772770] Dynamic subtest A-eDP1: SUCCESS (1.827s)
[703.783604] Starting dynamic subtest: B-eDP1
[705.595940] Dynamic subtest B-eDP1: SUCCESS (1.822s)
[705.607930] Starting dynamic subtest: C-eDP1
[707.431754] Dynamic subtest C-eDP1: SUCCESS (1.834s)
[707.441067] Starting dynamic subtest: D-eDP1
[709.256818] Dynamic subtest D-eDP1: SUCCESS (1.823s)
[709.259476] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.316s)
[710.469304] [131/133] (307s left) api_intel_bb (intel-bb-blit-x)
[710.533025] Starting subtest: intel-bb-blit-x
[714.184946] Subtest intel-bb-blit-x: SUCCESS (3.652s)
[714.325835] [132/133] (303s left) kms_flip (flip-vs-expired-vblank-interruptible)
[714.427082] Starting subtest: flip-vs-expired-vblank-interruptible
[714.429345] Starting dynamic subtest: A-eDP1
[723.056324] Dynamic subtest A-eDP1: SUCCESS (8.628s)
[723.070446] Starting dynamic subtest: B-eDP1
[731.681299] Dynamic subtest B-eDP1: SUCCESS (8.622s)
[731.693011] Starting dynamic subtest: C-eDP1
[740.306215] Dynamic subtest C-eDP1: SUCCESS (8.623s)
[740.317382] Starting dynamic subtest: D-eDP1
[748.932255] Dynamic subtest D-eDP1: SUCCESS (8.623s)
[748.938339] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (34.509s)
[750.122764] [133/133] (268s left) kms_flip (2x-flip-vs-rmfb)
[750.214662] Starting subtest: 2x-flip-vs-rmfb
[750.226170] Subtest 2x-flip-vs-rmfb: SKIP (0.011s)
[750.314854] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_mmap_offset
results: parsing output: 2/ for test: fbdev
results: parsing output: 3/ for test: kms_addfb_basic
results: parsing output: 4/ for test: kms_plane
results: parsing output: 5/ for test: kms_cursor_crc
results: parsing output: 6/ for test: kms_feature_discovery
results: parsing output: 7/ for test: i915_pm_rpm
results: parsing output: 8/ for test: kms_psr
results: parsing output: 9/ for test: gem_lmem_swapping
results: parsing output: 10/ for test: kms_addfb_basic
results: parsing output: 11/ for test: gem_eio
results: parsing output: 12/ for test: gem_wait
results: parsing output: 13/ for test: kms_plane_scaling
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: gem_exec_schedule
results: parsing output: 16/ for test: kms_flip
results: parsing output: 17/ for test: kms_pipe_stress
results: parsing output: 18/ for test: gem_sync
results: parsing output: 19/ for test: syncobj_basic
results: parsing output: 20/ for test: perf_pmu
results: parsing output: 21/ for test: gem_userptr_blits
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: kms_cursor_legacy
results: parsing output: 24/ for test: perf_pmu
results: parsing output: 25/ for test: kms_addfb_basic
results: parsing output: 26/ for test: dumb_buffer
results: parsing output: 27/ for test: gem_exec_reloc
results: parsing output: 28/ for test: kms_rotation_crc
results: parsing output: 29/ for test: kms_psr2_sf
results: parsing output: 30/ for test: gem_exec_schedule
results: parsing output: 31/ for test: gem_ctx_persistence
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: gen9_exec_parse
results: parsing output: 34/ for test: sysfs_heartbeat_interval
results: parsing output: 35/ for test: kms_content_protection
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: kms_vblank
results: parsing output: 38/ for test: gem_render_copy
results: parsing output: 39/ for test: vgem_basic
results: parsing output: 40/ for test: kms_psr
results: parsing output: 41/ for test: kms_chamelium_color
results: parsing output: 42/ for test: kms_color_pipeline
results: parsing output: 43/ for test: gem_eio
results: parsing output: 44/ for test: prime_busy
results: parsing output: 45/ for test: gem_eio
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: drm_read
results: parsing output: 48/ for test: gem_exec_balancer
results: parsing output: 49/ for test: kms_ccs
results: parsing output: 50/ for test: kms_pm_rpm
results: parsing output: 51/ for test: sw_sync
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: gem_exec_schedule
results: parsing output: 54/ for test: gem_mmap_wc
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_chamelium_frames
results: parsing output: 57/ for test: syncobj_timeline
results: parsing output: 58/ for test: gem_exec_fence
results: parsing output: 59/ for test: gem_softpin
results: parsing output: 60/ for test: i915_query
results: parsing output: 61/ for test: kms_psr2_sf
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: i915_drm_fdinfo
results: parsing output: 64/ for test: gem_render_copy
results: parsing output: 65/ for test: kms_chamelium_hpd
results: parsing output: 66/ for test: gem_exec_fence
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: gem_mmap_wc
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_ccs
results: parsing output: 71/ for test: template
results: parsing output: 72/ for test: kms_psr
results: parsing output: 73/ for test: i915_query
results: parsing output: 74/ for test: kms_psr
results: parsing output: 75/ for test: kms_big_fb
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_cursor_crc
results: parsing output: 78/ for test: kms_universal_plane
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: gem_lmem_swapping
results: parsing output: 81/ for test: kms_psr2_sf
results: parsing output: 82/ for test: gem_ctx_persistence
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: kms_cursor_legacy
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_lease
results: parsing output: 87/ for test: kms_ccs
results: parsing output: 88/ for test: kms_async_flips
results: parsing output: 89/ for test: i915_hangman
results: parsing output: 90/ for test: kms_plane
results: parsing output: 91/ for test: syncobj_timeline
results: parsing output: 92/ for test: gem_cs_tlb
results: parsing output: 93/ for test: syncobj_timeline
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_flip
results: parsing output: 97/ for test: syncobj_timeline
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: gem_mmap_wc
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gem_exec_store
results: parsing output: 103/ for test: kms_pm_dc
results: parsing output: 104/ for test: gem_fence_thrash
results: parsing output: 105/ for test: kms_cursor_legacy
results: parsing output: 106/ for test: kms_cursor_legacy
results: parsing output: 107/ for test: kms_dp_linktrain_fallback
results: parsing output: 108/ for test: api_intel_bb
results: parsing output: 109/ for test: kms_flip_scaled_crc
results: parsing output: 110/ for test: gen3_render_tiledx_blits
results: parsing output: 111/ for test: gem_softpin
results: parsing output: 112/ for test: syncobj_wait
results: parsing output: 113/ for test: kms_atomic_transition
results: parsing output: 114/ for test: template
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: kms_cursor_legacy
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: gem_userptr_blits
results: parsing output: 120/ for test: kms_ccs
results: parsing output: 121/ for test: gem_mmap_gtt
results: parsing output: 122/ for test: kms_plane_scaling
results: parsing output: 123/ for test: gem_caching
results: parsing output: 124/ for test: kms_invalid_mode
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_busy
results: parsing output: 127/ for test: gem_userptr_blits
results: parsing output: 128/ for test: kms_cursor_crc
results: parsing output: 129/ for test: kms_flip
results: parsing output: 130/ for test: api_intel_bb
results: parsing output: 131/ for test: kms_flip
results: parsing output: 132/ for test: kms_flip
Done.