[57.728459] Initializing watchdogs
[57.728507]   /dev/watchdog0
[57.746500] [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]
[57.751040] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.753280] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.756768] [001/155] (960s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[57.901353] Starting subtest: 4-tiled-8bpp-rotate-90
[57.938386] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.036s)
[58.047784] [002/155] (960s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[58.126956] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[58.132027] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[58.323207] [003/155] (960s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[58.422734] Starting subtest: yf-tiled-8bpp-rotate-90
[58.426998] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[58.501806] [004/155] (959s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-blt)
[58.604445] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-blt
[58.608487] Subtest fbchdr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[58.713046] [005/155] (959s left) kms_psr (psr2-basic)
[58.803841] Starting subtest: psr2-basic
[58.806276] Starting dynamic subtest: eDP-1
[60.461890] Dynamic subtest eDP-1: SUCCESS (1.662s)
[60.464161] Subtest psr2-basic: SUCCESS (1.662s)
[61.272210] [006/155] (957s left) dumb_buffer (invalid-bpp)
[61.349058] Starting subtest: invalid-bpp
[61.351509] Subtest invalid-bpp: SUCCESS (0.000s)
[61.448383] [007/155] (957s left) gem_mmap_wc (bad-offset)
[61.502092] Subtest bad-offset: SKIP (0.000s)
[61.556552] [008/155] (956s left) syncobj_eventfd (invalid-illegal-eventfd)
[61.609020] Starting subtest: invalid-illegal-eventfd
[61.611403] Subtest invalid-illegal-eventfd: SUCCESS (0.000s)
[61.713405] [009/155] (956s left) gem_exec_schedule (semaphore-user)
[61.788210] Starting subtest: semaphore-user
[61.838689] Subtest semaphore-user: SUCCESS (0.057s)
[63.366795] [010/155] (955s left) kms_rmfb (close-fd)
[63.459080] Starting subtest: close-fd
[63.461511] Starting dynamic subtest: pipe-A-eDP-1
[63.565905] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.108s)
[63.575482] Starting dynamic subtest: pipe-B-eDP-1
[64.740674] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.175s)
[64.750524] Starting dynamic subtest: pipe-C-eDP-1
[65.976123] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.237s)
[65.985336] Starting dynamic subtest: pipe-D-eDP-1
[67.194714] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.221s)
[67.197109] Subtest close-fd: SUCCESS (3.744s)
[68.413204] [011/155] (950s left) kms_big_fb (y-tiled-addfb-size-offset-overflow)
[68.516768] Starting subtest: y-tiled-addfb-size-offset-overflow
[68.521207] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[68.616594] [012/155] (950s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[68.715195] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[68.719206] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[68.809577] [013/155] (949s left) syncobj_timeline (host-signal-ordered)
[68.868059] Starting subtest: host-signal-ordered
[68.870488] Subtest host-signal-ordered: SUCCESS (0.001s)
[68.985857] [014/155] (949s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[69.046361] Starting subtest: y-tiled-ccs-to-y-tiled
[69.051084] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[69.254234] [015/155] (949s left) i915_query (query-regions-sanity-check)
[69.304897] Starting subtest: query-regions-sanity-check
[69.317486] Subtest query-regions-sanity-check: SUCCESS (0.014s)
[69.446391] [016/155] (949s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[69.544743] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[69.548980] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[69.640469] [017/155] (949s left) perf (gen12-unprivileged-single-ctx-counters)
[69.768891] Starting subtest: gen12-unprivileged-single-ctx-counters
[69.771118] Starting dynamic subtest: rcs0
[69.955580] Dynamic subtest rcs0: SUCCESS (0.187s)
[69.958022] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.188s)
[70.000469] [018/155] (948s left) kms_atomic (atomic-invalid-params)
[70.117860] Starting subtest: atomic-invalid-params
[70.120229] Starting dynamic subtest: pipe-A-eDP-1
[70.538398] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.420s)
[70.540847] Subtest atomic-invalid-params: SUCCESS (0.422s)
[71.359201] [019/155] (947s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-shrfb-draw-render)
[71.464810] Starting subtest: fbcpsrhdr-1p-offscreen-pri-shrfb-draw-render
[71.469015] Subtest fbcpsrhdr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[71.554745] [020/155] (947s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[71.672858] Starting subtest: cursorA-vs-flipA-atomic
[82.789733] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.120s)
[83.667856] [021/155] (935s left) gem_partial_pwrite_pread (write-display)
[83.727487] Subtest write-display: SKIP (0.000s)
[83.806830] [022/155] (935s left) perf_pmu (most-busy-idle-check-all)
[83.844307] Starting subtest: most-busy-idle-check-all
[83.846549] Starting dynamic subtest: rcs0
[85.347470] Dynamic subtest rcs0: SUCCESS (1.502s)
[85.361786] Starting dynamic subtest: bcs0
[87.331512] Dynamic subtest bcs0: SUCCESS (1.983s)
[87.343476] Starting dynamic subtest: vcs0
[89.316195] Dynamic subtest vcs0: SUCCESS (1.983s)
[89.329606] Starting dynamic subtest: vcs1
[91.299054] Dynamic subtest vcs1: SUCCESS (1.981s)
[91.310317] Starting dynamic subtest: vecs0
[93.347295] Dynamic subtest vecs0: SUCCESS (2.047s)
[93.358666] Starting dynamic subtest: ccs0
[95.331111] Dynamic subtest ccs0: SUCCESS (1.983s)
[95.334093] Subtest most-busy-idle-check-all: SUCCESS (11.486s)
[95.444988] [023/155] (923s left) kms_cursor_crc (cursor-random-32x32)
[95.591264] Starting subtest: cursor-random-32x32
[95.638598] Subtest cursor-random-32x32: SKIP (0.043s)
[95.941081] [024/155] (923s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[96.058582] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[99.668677] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.615s)
[100.891763] [025/155] (918s left) kms_flip (flip-vs-fences)
[100.985516] Starting subtest: flip-vs-fences
[100.989800] Subtest flip-vs-fences: SKIP (0.000s)
[101.090923] [026/155] (918s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[101.182384] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[101.186586] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[101.285704] [027/155] (917s left) kms_pm_rpm (dpms-lpsp)
[103.509415] Starting subtest: dpms-lpsp
[103.834721] Subtest dpms-lpsp: SUCCESS (0.326s)
[103.953197] [028/155] (915s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-pwrite)
[104.059821] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-pwrite
[104.063972] Subtest psrhdr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[104.142019] [029/155] (915s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier)
[104.228820] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier
[104.233315] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier: SKIP (0.000s)
[104.300721] [030/155] (915s left) kms_plane_alpha_blend (alpha-transparent-fb)
[104.395282] Starting subtest: alpha-transparent-fb
[104.684244] Starting dynamic subtest: pipe-A-eDP-1
[105.310274] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.626s)
[105.322348] Starting dynamic subtest: pipe-D-eDP-1
[106.666266] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.353s)
[106.668688] Subtest alpha-transparent-fb: SUCCESS (2.272s)
[107.554260] [031/155] (911s left) kms_universal_plane (cursor-fb-leak)
[107.656296] Starting subtest: cursor-fb-leak
[107.658744] Starting dynamic subtest: pipe-A-eDP-1
[107.989218] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.332s)
[108.000196] Starting dynamic subtest: pipe-B-eDP-1
[109.369733] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.378s)
[109.379908] Starting dynamic subtest: pipe-C-eDP-1
[110.689412] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.318s)
[110.703668] Starting dynamic subtest: pipe-D-eDP-1
[112.004086] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.312s)
[112.006596] Subtest cursor-fb-leak: SUCCESS (4.348s)
[113.180147] [032/155] (906s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-blt)
[113.282256] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-blt
[113.286141] Subtest psrhdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[113.379254] [033/155] (906s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-blt)
[113.474987] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-blt
[113.479220] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[113.572782] [034/155] (905s left) kms_hdr (bpc-switch-suspend)
[113.668694] Starting subtest: bpc-switch-suspend
[113.670992] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[135.219139] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SUCCESS (6.923s)
[135.230840] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[156.221170] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SUCCESS (6.056s)
[156.223746] Subtest bpc-switch-suspend: SUCCESS (12.982s)
[161.409611] [035/155] (863s left) kms_atomic_interruptible (universal-setplane-cursor)
[161.520510] Starting subtest: universal-setplane-cursor
[161.522885] Starting dynamic subtest: pipe-A-eDP-1
[168.902621] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.416s)
[168.905178] Subtest universal-setplane-cursor: SUCCESS (7.417s)
[169.715412] [036/155] (854s left) gem_readwrite (write-bad-handle)
[169.769953] Subtest write-bad-handle: SKIP (0.000s)
[169.829453] [037/155] (854s left) i915_module_load (reload)
[169.865519] Starting subtest: reload
[176.003671] Subtest reload: SUCCESS (6.153s)
[176.042379] [038/155] (848s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[177.918521] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu
[177.922963] Subtest psrhdr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[178.022956] [039/155] (846s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen)
[178.125791] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen
[184.733997] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.621s)
[184.857815] [040/155] (840s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-blt)
[184.965494] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-blt
[184.969721] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[185.057125] [041/155] (839s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-render)
[185.153576] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-render
[185.158100] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[185.255767] [042/155] (839s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[185.349909] Starting subtest: plane-use-after-nonblocking-unbind
[185.352174] Starting dynamic subtest: pipe-A-eDP-1
[185.409452] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.061s)
[185.729013] Starting dynamic subtest: pipe-B-eDP-1
[186.532932] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.814s)
[186.838504] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.488s)
[187.698006] [043/155] (837s left) gem_exec_reloc (basic-cpu-read-noreloc)
[187.760647] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[187.828586] [044/155] (837s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[187.925861] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf
[187.928126] Starting dynamic subtest: pipe-A-eDP-1
[198.916218] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.002s)
[198.930879] Starting dynamic subtest: pipe-B-eDP-1
[210.598750] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.684s)
[210.601430] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (22.691s)
[211.454375] [045/155] (813s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[211.545592] Starting subtest: fb-8bpc-vs-panel-6bpc
[211.547932] Starting dynamic subtest: pipe-A-eDP-1
[212.906471] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.361s)
[212.908743] Subtest fb-8bpc-vs-panel-6bpc: SUCCESS (1.362s)
[213.718360] [046/155] (811s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[213.821882] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[213.825965] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[213.908815] [047/155] (811s left) gem_exec_schedule (preempt-other-chain)
[213.983191] Starting subtest: preempt-other-chain
[213.985005] Starting dynamic subtest: rcs0
[214.063438] Dynamic subtest rcs0: SUCCESS (0.085s)
[214.079176] Starting dynamic subtest: bcs0
[214.145948] Dynamic subtest bcs0: SUCCESS (0.082s)
[214.160875] Starting dynamic subtest: vcs0
[214.225300] Dynamic subtest vcs0: SUCCESS (0.078s)
[214.239909] Starting dynamic subtest: vcs1
[214.310391] Dynamic subtest vcs1: SUCCESS (0.084s)
[214.321740] Starting dynamic subtest: vecs0
[214.400177] Dynamic subtest vecs0: SUCCESS (0.089s)
[214.414072] Starting dynamic subtest: ccs0
[214.490658] Dynamic subtest ccs0: SUCCESS (0.090s)
[214.493606] Subtest preempt-other-chain: SUCCESS (0.513s)
[215.992007] [048/155] (809s left) kms_cursor_edge_walk (128x128-left-edge)
[216.087509] Starting subtest: 128x128-left-edge
[216.089999] Starting dynamic subtest: pipe-A-eDP-1
[220.306942] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.221s)
[220.317017] Starting dynamic subtest: pipe-D-eDP-1
[223.014410] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.707s)
[223.016319] Subtest 128x128-left-edge: SUCCESS (6.931s)
[223.820927] [049/155] (801s left) gem_exec_reloc (basic-write-cpu)
[223.880301] Subtest basic-write-cpu: SKIP (0.000s)
[223.951369] [050/155] (801s left) gem_mmap_gtt (flink-race)
[223.999475] Subtest flink-race: SKIP (0.000s)
[224.059722] [051/155] (801s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[224.154580] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[224.156787] Starting dynamic subtest: pipe-A-default-mode
[226.872119] Dynamic subtest pipe-A-default-mode: SUCCESS (2.716s)
[226.874390] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.718s)
[227.712426] [052/155] (797s left) gem_exec_reloc (basic-wc-gtt-active)
[227.771818] Subtest basic-wc-gtt-active: SKIP (0.000s)
[227.858321] [053/155] (797s left) kms_psr (psr2-sprite-render)
[227.953563] Starting subtest: psr2-sprite-render
[227.955957] Starting dynamic subtest: eDP-1
[229.706922] Dynamic subtest eDP-1: SUCCESS (1.753s)
[229.709373] Subtest psr2-sprite-render: SUCCESS (1.754s)
[230.591074] [054/155] (794s left) gem_ctx_shared (single-timeline)
[230.658722] Starting subtest: single-timeline
[230.676717] Subtest single-timeline: SUCCESS (0.012s)
[230.904325] [055/155] (794s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[230.994625] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[231.097069] [056/155] (794s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[231.192819] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[231.195062] Starting dynamic subtest: pipe-A-default-mode
[233.921213] Dynamic subtest pipe-A-default-mode: SUCCESS (2.731s)
[233.924035] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.732s)
[234.764870] [057/155] (790s left) gem_mmap_gtt (cpuset-basic-small-copy)
[234.826383] Subtest cpuset-basic-small-copy: SKIP (0.000s)
[234.882229] [058/155] (790s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[234.980422] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-mmap-gtt
[234.984533] Subtest hdr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[235.080863] [059/155] (790s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-blt)
[235.179842] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-blt
[235.183866] Subtest fbchdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[235.267044] [060/155] (790s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[235.361398] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[241.949172] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.596s)
[242.086985] [061/155] (783s left) gem_spin_batch (user-each)
[242.138801] Starting subtest: user-each
[245.408473] Subtest user-each: SUCCESS (3.263s)
[245.913330] [062/155] (779s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-move)
[246.024537] Starting subtest: hdr-2p-scndscrn-spr-indfb-move
[246.028925] Subtest hdr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[246.103859] [063/155] (779s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-onoff)
[246.194434] Starting subtest: fbchdr-1p-primscrn-spr-indfb-onoff
[246.198430] Subtest fbchdr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[246.293469] [064/155] (779s left) kms_cursor_crc (cursor-offscreen-512x512)
[246.553840] Starting subtest: cursor-offscreen-512x512
[246.558310] Subtest cursor-offscreen-512x512: SKIP (0.001s)
[246.707066] [065/155] (779s left) kms_plane_multiple (tiling-none)
[246.790950] Starting subtest: tiling-none
[246.793254] Starting dynamic subtest: pipe-A-eDP-1
[250.638968] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.850s)
[250.650143] Starting dynamic subtest: pipe-B-eDP-1
[255.177264] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.540s)
[255.188908] Starting dynamic subtest: pipe-C-eDP-1
[259.615712] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.440s)
[259.625653] Starting dynamic subtest: pipe-D-eDP-1
[264.157885] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.543s)
[264.160278] Subtest tiling-none: SUCCESS (17.378s)
[264.972951] [066/155] (760s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs)
[265.076942] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs
[265.079245] Starting dynamic subtest: pipe-A-eDP-1
[265.103507] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[265.115057] Starting dynamic subtest: pipe-B-eDP-1
[265.136760] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[265.146156] Starting dynamic subtest: pipe-C-eDP-1
[265.167819] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[265.177237] Starting dynamic subtest: pipe-D-eDP-1
[265.199469] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[265.203849] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[267.342270] [067/155] (758s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[267.451093] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[267.455139] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[267.547192] [068/155] (758s left) gem_ctx_param (invalid-size-get)
[267.600660] Starting subtest: invalid-size-get
[267.603036] Subtest invalid-size-get: SUCCESS (0.002s)
[267.721621] [069/155] (758s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[268.103618] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[268.944845] [070/155] (757s left) gen9_exec_parse (valid-registers)
[269.012278] Subtest valid-registers: SKIP (0.000s)
[269.084060] [071/155] (757s left) gem_mmap_gtt (basic-write-read-distinct)
[269.135554] Subtest basic-write-read-distinct: SKIP (0.000s)
[269.195826] [072/155] (756s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[269.296914] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[269.299161] Starting dynamic subtest: pipe-A
[269.317985] Dynamic subtest pipe-A: SKIP (0.017s)
[269.328261] Starting dynamic subtest: pipe-B
[269.346082] Dynamic subtest pipe-B: SKIP (0.029s)
[269.356102] Starting dynamic subtest: pipe-C
[269.376323] Dynamic subtest pipe-C: SKIP (0.029s)
[269.386103] Starting dynamic subtest: pipe-D
[269.406432] Dynamic subtest pipe-D: SKIP (0.029s)
[269.410739] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.108s)
[269.517243] [073/155] (756s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-render)
[269.617563] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-render
[269.621749] Subtest hdr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[269.712001] [074/155] (756s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[269.753351] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[269.794319] [075/155] (756s left) gem_userptr_blits (map-fixed-invalidate-busy)
[269.860965] Starting subtest: map-fixed-invalidate-busy
[269.865276] Subtest map-fixed-invalidate-busy: SKIP (0.000s)
[269.970617] [076/155] (756s left) perf (polling)
[270.089303] Starting subtest: polling
[270.091127] Starting dynamic subtest: 0-rcs0
[280.166936] Dynamic subtest 0-rcs0: SUCCESS (10.027s)
[280.179252] Starting dynamic subtest: 1-vcs1
[290.180189] Dynamic subtest 1-vcs1: SUCCESS (10.019s)
[290.182762] Subtest polling: SUCCESS (20.049s)
[290.223645] [077/155] (736s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-shrfb-plflip-blt)
[290.327858] Starting subtest: fbcpsrhdr-1p-primscrn-shrfb-plflip-blt
[290.332091] Subtest fbcpsrhdr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[290.422066] [078/155] (735s left) kms_color (legacy-gamma-reset)
[290.504928] Starting subtest: legacy-gamma-reset
[290.507173] Starting dynamic subtest: pipe-A-eDP-1
[290.892087] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.386s)
[290.903311] Starting dynamic subtest: pipe-B-eDP-1
[290.908076] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.013s)
[290.917820] Starting dynamic subtest: pipe-C-eDP-1
[290.919994] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[290.930085] Starting dynamic subtest: pipe-D-eDP-1
[290.932721] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.013s)
[290.935232] Subtest legacy-gamma-reset: SUCCESS (0.427s)
[291.692894] [079/155] (734s left) gem_ctx_persistence (engines-queued)
[291.756059] Starting subtest: engines-queued
[291.758507] Starting dynamic subtest: rcs0
[291.839338] Dynamic subtest rcs0: SUCCESS (0.083s)
[291.849720] Starting dynamic subtest: bcs0
[291.876467] Dynamic subtest bcs0: SUCCESS (0.035s)
[291.886415] Starting dynamic subtest: vcs0
[293.948606] Dynamic subtest vcs0: SUCCESS (2.017s)
[293.961264] Starting dynamic subtest: vcs1
[295.876440] Dynamic subtest vcs1: SUCCESS (1.981s)
[295.886551] Starting dynamic subtest: vecs0
[297.913799] Dynamic subtest vecs0: SUCCESS (1.986s)
[297.926615] Starting dynamic subtest: ccs0
[298.027345] Dynamic subtest ccs0: SUCCESS (0.165s)
[298.029765] Subtest engines-queued: SUCCESS (6.275s)
[298.174084] [080/155] (728s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[298.283372] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[298.287345] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[298.393962] [081/155] (728s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-pwrite)
[298.501759] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-pwrite
[305.891113] Subtest fbc-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (7.399s)
[307.087560] [082/155] (719s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-render)
[307.185730] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-render
[307.189908] Subtest hdr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[307.297104] [083/155] (719s left) syncobj_wait (reset-during-wait-for-submit)
[307.353127] Starting subtest: reset-during-wait-for-submit
[307.456364] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[307.534871] [084/155] (719s left) gem_flink_basic (bad-open)
[307.588002] Starting subtest: bad-open
[307.590351] Subtest bad-open: SUCCESS (0.000s)
[307.691278] [085/155] (719s left) fbdev (unaligned-read)
[307.729715] Starting subtest: unaligned-read
[307.745917] Subtest unaligned-read: SUCCESS (0.016s)
[307.799860] [086/155] (718s left) gem_exec_reloc (basic-range-active)
[307.860057] Subtest basic-range-active: SKIP (0.000s)
[307.925694] [087/155] (718s left) gem_exec_reloc (basic-cpu-gtt)
[307.980396] Subtest basic-cpu-gtt: SKIP (0.000s)
[308.061023] [088/155] (718s left) kms_draw_crc (draw-method-pwrite)
[308.157962] Starting subtest: draw-method-pwrite
[308.160241] Starting dynamic subtest: xrgb8888-untiled
[308.747682] Dynamic subtest xrgb8888-untiled: SUCCESS (0.591s)
[308.758475] Starting dynamic subtest: rgb565-untiled
[309.212982] Dynamic subtest rgb565-untiled: SUCCESS (0.466s)
[309.223573] Starting dynamic subtest: xrgb2101010-untiled
[309.768149] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.555s)
[309.778551] Starting dynamic subtest: xbgr16161616f-untiled
[310.568181] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.799s)
[310.580424] Starting dynamic subtest: xrgb8888-xtiled
[312.467101] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.899s)
[312.477406] Starting dynamic subtest: rgb565-xtiled
[313.612113] Dynamic subtest rgb565-xtiled: SUCCESS (1.144s)
[313.622616] Starting dynamic subtest: xrgb2101010-xtiled
[315.499072] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.888s)
[315.509361] Starting dynamic subtest: xbgr16161616f-xtiled
[318.975374] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.477s)
[318.986755] Starting dynamic subtest: xrgb8888-4tiled
[320.129840] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.155s)
[320.140613] Starting dynamic subtest: rgb565-4tiled
[320.718374] Dynamic subtest rgb565-4tiled: SUCCESS (0.588s)
[320.729213] Starting dynamic subtest: xrgb2101010-4tiled
[321.884469] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.166s)
[321.894860] Starting dynamic subtest: xbgr16161616f-4tiled
[325.038475] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (3.155s)
[325.040793] Subtest draw-method-pwrite: SUCCESS (16.893s)
[325.161054] [089/155] (701s left) gem_sync (basic-all)
[325.226960] Starting subtest: basic-all
[328.872628] Subtest basic-all: SUCCESS (3.655s)
[329.055330] [090/155] (697s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-pwrite)
[329.154443] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-pwrite
[329.158939] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[329.248921] [091/155] (697s left) syncobj_wait (multi-wait-submitted)
[329.304599] Starting subtest: multi-wait-submitted
[329.411476] Subtest multi-wait-submitted: SUCCESS (0.107s)
[329.486859] [092/155] (697s left) gem_exec_whisper (basic-contexts-priority)
[329.551548] Starting subtest: basic-contexts-priority
[354.556287] Subtest basic-contexts-priority: SUCCESS (24.961s)
[354.687169] [093/155] (672s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[354.746213] Starting subtest: x-tiled-to-vebox-y-tiled
[354.750855] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[354.932748] [094/155] (672s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[355.033907] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[355.036196] Starting dynamic subtest: pipe-A-eDP-1
[355.095166] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[355.105590] Starting dynamic subtest: pipe-B-eDP-1
[355.163711] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[355.175158] Starting dynamic subtest: pipe-C-eDP-1
[355.233258] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[355.244595] Starting dynamic subtest: pipe-D-eDP-1
[355.302921] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[355.307429] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.009s)
[357.305876] [095/155] (669s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-render)
[357.411706] Starting subtest: fbcpsrhdr-rgb101010-draw-render
[357.416159] Subtest fbcpsrhdr-rgb101010-draw-render: SKIP (0.000s)
[357.512560] [096/155] (669s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[357.570367] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[357.636203] [097/155] (669s left) kms_psr (fbc-psr-sprite-plane-onoff)
[357.724524] Starting subtest: fbc-psr-sprite-plane-onoff
[357.726788] Starting dynamic subtest: eDP-1
[357.730917] Dynamic subtest eDP-1: SKIP (0.000s)
[357.735140] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.001s)
[357.810253] [098/155] (669s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[357.902802] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-mmap-wc
[357.906790] Subtest hdr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[357.998881] [099/155] (669s left) kms_big_fb (x-tiled-addfb-size-offset-overflow)
[358.099203] Starting subtest: x-tiled-addfb-size-offset-overflow
[358.101519] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s)
[358.194764] [100/155] (669s left) gem_partial_pwrite_pread (reads-display)
[358.257546] Subtest reads-display: SKIP (0.000s)
[358.330292] [101/155] (669s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[358.430169] Starting subtest: flip-primary-invalidate-overlay
[370.076400] Subtest flip-primary-invalidate-overlay: SUCCESS (11.653s)
[370.201583] [102/155] (657s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[370.292840] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[370.296528] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[370.393936] [103/155] (657s left) api_intel_bb (offset-control)
[370.440992] Starting subtest: offset-control
[370.447951] Subtest offset-control: SUCCESS (0.009s)
[370.564493] [104/155] (656s left) gem_exec_capture (capture)
[370.624507] Starting subtest: capture
[370.626283] Starting dynamic subtest: rcs0-smem
[371.463009] Dynamic subtest rcs0-smem: SUCCESS (0.840s)
[371.473993] Starting dynamic subtest: bcs0-smem
[372.790268] Dynamic subtest bcs0-smem: SUCCESS (1.326s)
[372.800224] Starting dynamic subtest: vcs0-smem
[373.615327] Dynamic subtest vcs0-smem: SUCCESS (0.826s)
[373.631075] Starting dynamic subtest: vcs1-smem
[374.941550] Dynamic subtest vcs1-smem: SUCCESS (1.324s)
[374.951309] Starting dynamic subtest: vecs0-smem
[375.825391] Dynamic subtest vecs0-smem: FAIL (0.824s)
[375.838958] Starting dynamic subtest: ccs0-smem
[377.090626] Dynamic subtest ccs0-smem: SUCCESS (1.324s)
[377.092968] Subtest capture: FAIL (6.468s)
[377.224871] [105/155] (650s left) kms_invalid_mode (bad-vtotal)
[377.319902] Starting subtest: bad-vtotal
[377.322310] Starting dynamic subtest: pipe-A-eDP-1
[377.610485] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.290s)
[377.621166] Starting dynamic subtest: pipe-B-eDP-1
[377.622997] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[377.632506] Starting dynamic subtest: pipe-C-eDP-1
[377.634748] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[377.645183] Starting dynamic subtest: pipe-D-eDP-1
[377.647640] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[377.650108] Subtest bad-vtotal: SUCCESS (0.297s)
[378.418099] [106/155] (649s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[378.480488] Starting subtest: map-fixed-invalidate-overlap-busy
[378.485277] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s)
[378.613849] [107/155] (648s left) api_intel_bb (blit-reloc-keep-cache)
[378.659448] Starting subtest: blit-reloc-keep-cache
[378.663738] Subtest blit-reloc-keep-cache: SKIP (0.001s)
[378.770793] [108/155] (648s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-mmap-wc)
[378.862192] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-mmap-wc
[378.866324] Subtest hdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[378.960872] [109/155] (648s left) syncobj_eventfd (binary-wait)
[379.020014] Starting subtest: binary-wait
[379.029103] Subtest binary-wait: SUCCESS (0.011s)
[379.143201] [110/155] (648s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[379.245608] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[379.249958] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[379.352971] [111/155] (648s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[379.438317] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[379.440217] Starting dynamic subtest: pipe-A-eDP-1
[379.466153] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[379.476969] Starting dynamic subtest: pipe-B-eDP-1
[379.493998] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[379.503268] Starting dynamic subtest: pipe-C-eDP-1
[379.520233] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[379.529277] Starting dynamic subtest: pipe-D-eDP-1
[379.547123] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[379.550688] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[381.721407] [112/155] (646s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[381.820380] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[388.390064] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.578s)
[388.490444] [113/155] (639s left) kms_addfb_basic (addfb25-bad-modifier)
[388.580630] Starting subtest: addfb25-bad-modifier
[388.582578] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[388.689140] [114/155] (639s left) kms_content_protection (atomic-hdcp14)
[388.823817] Starting subtest: atomic-hdcp14
[388.828448] Subtest atomic-hdcp14: SKIP (0.000s)
[388.954236] [115/155] (638s left) gem_userptr_blits (invalid-null-pointer)
[389.010543] Starting subtest: invalid-null-pointer
[389.012766] Subtest invalid-null-pointer: SUCCESS (0.001s)
[389.124919] [116/155] (638s left) gem_softpin (evict-snoop)
[389.187207] Starting subtest: evict-snoop
[389.191726] Subtest evict-snoop: SKIP (0.000s)
[389.310255] [117/155] (638s left) gem_close_race (multigpu-basic-threads)
[389.382344] Starting subtest: multigpu-basic-threads
[389.386260] Subtest multigpu-basic-threads: SKIP (0.000s)
[389.610031] [118/155] (638s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-render)
[389.714453] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-render
[389.718413] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[389.817754] [119/155] (638s left) syncobj_wait (invalid-signal-illegal-handle)
[389.869123] Starting subtest: invalid-signal-illegal-handle
[389.871056] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[389.971305] [120/155] (638s left) syncobj_timeline (multi-wait-submitted-signaled)
[390.023325] Starting subtest: multi-wait-submitted-signaled
[390.025468] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[390.122504] [121/155] (638s left) gem_exec_create (madvise)
[390.178249] Starting subtest: madvise
[390.180435] Starting dynamic subtest: smem
[410.345054] Dynamic subtest smem: SUCCESS (20.176s)
[410.347605] Subtest madvise: SUCCESS (20.178s)
[411.235399] [122/155] (616s left) gem_exec_suspend (basic-s3)
[411.302453] Starting subtest: basic-S3
[411.304987] Starting dynamic subtest: smem
[431.819751] Dynamic subtest smem: SUCCESS (7.619s)
[431.822621] Subtest basic-S3: SUCCESS (7.621s)
[436.096615] [123/155] (596s left) kms_chamelium_frames (hdmi-crc-multiple)
[436.487948] Subtest hdmi-crc-multiple: SKIP (0.000s)
[437.277757] [124/155] (595s left) gem_userptr_blits (userfault)
[437.349904] Starting subtest: userfault
[437.352394] Subtest userfault: SUCCESS (0.007s)
[437.475644] [125/155] (594s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[437.531410] Starting subtest: single-wait-all-for-submit-signaled
[437.533714] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[437.652984] [126/155] (594s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[437.757175] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[437.761163] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[437.839105] [127/155] (594s left) gem_exec_params (rs-invalid)
[437.894265] Starting subtest: rs-invalid
[437.896613] Subtest rs-invalid: SUCCESS (0.003s)
[438.019214] [128/155] (594s left) prime_mmap (test_refcounting)
[438.068915] Starting subtest: test_refcounting
[438.071157] Starting dynamic subtest: test_refcounting-smem
[438.099504] Dynamic subtest test_refcounting-smem: SUCCESS (0.032s)
[438.102025] Subtest test_refcounting: SUCCESS (0.033s)
[438.210206] [129/155] (594s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[438.300527] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc
[445.456080] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.182s)
[445.581413] [130/155] (587s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[445.676466] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[445.678828] Starting dynamic subtest: pipe-A-eDP-1
[445.701565] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[445.714909] Starting dynamic subtest: pipe-B-eDP-1
[445.736433] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[445.747264] Starting dynamic subtest: pipe-C-eDP-1
[445.768740] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[445.779472] Starting dynamic subtest: pipe-D-eDP-1
[445.801421] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[445.805585] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[447.977192] [131/155] (584s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[448.085295] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[449.173165] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.091s)
[449.296687] [132/155] (583s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[449.388012] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[450.488230] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.101s)
[450.624947] [133/155] (582s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-mmap-gtt)
[450.728934] Starting subtest: fbchdr-rgb101010-draw-mmap-gtt
[450.732427] Subtest fbchdr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[450.821607] [134/155] (581s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[450.905088] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[450.906908] Starting dynamic subtest: pipe-A
[450.925063] Dynamic subtest pipe-A: SKIP (0.018s)
[450.941805] Starting dynamic subtest: pipe-B
[450.957342] Dynamic subtest pipe-B: SKIP (0.032s)
[450.968328] Starting dynamic subtest: pipe-C
[450.989781] Dynamic subtest pipe-C: SKIP (0.031s)
[451.002024] Starting dynamic subtest: pipe-D
[451.020631] Dynamic subtest pipe-D: SKIP (0.031s)
[451.024100] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.114s)
[451.115072] [135/155] (581s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[451.210211] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf
[451.213614] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[451.289827] [136/155] (581s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-blt)
[451.395043] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-blt
[451.398605] Subtest psrhdr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[451.483417] [137/155] (581s left) kms_chamelium_audio (hdmi-audio-edid)
[451.857380] Subtest hdmi-audio-edid: SKIP (0.000s)
[452.680055] [138/155] (580s left) gem_exec_fence (syncobj-import)
[453.177458] Starting subtest: syncobj-import
[453.183256] Subtest syncobj-import: SUCCESS (0.005s)
[454.870530] [FACT gem_exec_fence (syncobj-import)] new: kernel.kmod_is_loaded.vgem: true
[454.874508] [139/155] (578s left) i915_pm_rpm (sysfs-read)
[456.903606] Starting subtest: sysfs-read
[458.062757] Subtest sysfs-read: SUCCESS (1.157s)
[458.447097] [140/155] (574s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[458.506563] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[458.587223] [141/155] (574s left) gem_ctx_persistence (heartbeat-close)
[458.641143] Starting subtest: heartbeat-close
[458.645820] Subtest heartbeat-close: SKIP (0.000s)
[458.752928] [142/155] (574s left) gen9_exec_parse (batch-zero-length)
[458.805327] Subtest batch-zero-length: SKIP (0.000s)
[458.878619] [143/155] (574s left) kms_psr2_su (frontbuffer-xrgb8888)
[458.938106] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[458.995223] [144/155] (574s left) gem_exec_balancer (bonded-pair)
[459.050350] Starting subtest: bonded-pair
[459.054934] Subtest bonded-pair: SKIP (0.000s)
[459.356870] [145/155] (573s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[459.449808] Starting subtest: psr-rgb101010-draw-render
[466.754844] Subtest psr-rgb101010-draw-render: SUCCESS (7.316s)
[466.883190] [146/155] (566s left) kms_vblank (wait-forked-hang)
[466.981736] Starting subtest: wait-forked-hang
[466.983593] Starting dynamic subtest: pipe-A-eDP-1
[493.580300] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.595s)
[493.596437] Starting dynamic subtest: pipe-D-eDP-1
[518.550211] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.974s)
[518.552617] Subtest wait-forked-hang: SUCCESS (51.573s)
[519.431977] [147/155] (513s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-shrfb-plflip-blt)
[519.530949] Starting subtest: fbchdr-2p-primscrn-shrfb-plflip-blt
[519.534897] Subtest fbchdr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[519.650650] [148/155] (513s left) perf_pmu (interrupts)
[519.693367] Starting subtest: interrupts
[520.781226] Subtest interrupts: SUCCESS (1.086s)
[520.897676] [149/155] (512s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[520.997283] Starting subtest: fbcpsr-rgb565-draw-render
[528.144817] Subtest fbcpsr-rgb565-draw-render: SUCCESS (7.154s)
[528.282894] [150/155] (505s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[528.400765] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[528.404885] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[528.493214] [151/155] (505s left) sysfs_timeslice_duration (duration)
[528.542333] Starting subtest: duration
[528.544783] Starting dynamic subtest: vecs0
[542.697620] Dynamic subtest vecs0: SUCCESS (14.149s)
[542.710619] Starting dynamic subtest: ccs0
[555.855762] Dynamic subtest ccs0: SUCCESS (13.133s)
[555.868432] Starting dynamic subtest: vcs0
[570.729386] Dynamic subtest vcs0: SUCCESS (14.889s)
[570.742419] Starting dynamic subtest: bcs0
[583.885701] Dynamic subtest bcs0: SUCCESS (13.143s)
[583.898208] Starting dynamic subtest: rcs0
[597.008320] Dynamic subtest rcs0: SUCCESS (13.133s)
[597.023785] Starting dynamic subtest: vcs1
[611.689381] Dynamic subtest vcs1: SUCCESS (14.680s)
[611.692436] Subtest duration: SUCCESS (83.145s)
[611.768180] [152/155] (421s left) kms_psr (fbc-psr2-primary-render)
[611.878737] Starting subtest: fbc-psr2-primary-render
[611.880912] Starting dynamic subtest: eDP-1
[611.884714] Dynamic subtest eDP-1: SKIP (0.000s)
[611.888625] Subtest fbc-psr2-primary-render: SKIP (0.001s)
[611.955039] [153/155] (421s left) kms_pipe_crc_basic (disable-crc-after-crtc)
[612.053652] Starting subtest: disable-crc-after-crtc
[612.055933] Starting dynamic subtest: pipe-A-eDP-1
[613.693950] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.638s)
[613.705600] Starting dynamic subtest: pipe-B-eDP-1
[616.054637] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.361s)
[616.066488] Starting dynamic subtest: pipe-C-eDP-1
[618.296263] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.242s)
[618.308238] Starting dynamic subtest: pipe-D-eDP-1
[620.580291] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.279s)
[620.582326] Subtest disable-crc-after-crtc: SUCCESS (8.526s)
[621.410358] [154/155] (412s left) syncobj_timeline (invalid-transfer-non-existent-point)
[621.472599] Starting subtest: invalid-transfer-non-existent-point
[621.474988] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[621.594137] [155/155] (412s left) kms_flip (2x-plain-flip-ts-check)
[621.685694] Starting subtest: 2x-plain-flip-ts-check
[621.697107] Subtest 2x-plain-flip-ts-check: SKIP (0.011s)
[621.774490] Closing watchdogs
results: parsing output: 0/ for test: kms_big_fb
results: parsing output: 1/ for test: gem_render_copy
results: parsing output: 2/ for test: kms_big_fb
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_psr
results: parsing output: 5/ for test: dumb_buffer
results: parsing output: 6/ for test: gem_mmap_wc
results: parsing output: 7/ for test: syncobj_eventfd
results: parsing output: 8/ for test: gem_exec_schedule
results: parsing output: 9/ for test: kms_rmfb
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: syncobj_timeline
results: parsing output: 13/ for test: gem_render_copy
results: parsing output: 14/ for test: i915_query
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: perf
results: parsing output: 17/ for test: kms_atomic
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_cursor_legacy
results: parsing output: 20/ for test: gem_partial_pwrite_pread
results: parsing output: 21/ for test: perf_pmu
results: parsing output: 22/ for test: kms_cursor_crc
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_flip
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: kms_pm_rpm
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_plane
results: parsing output: 29/ for test: kms_plane_alpha_blend
results: parsing output: 30/ for test: kms_universal_plane
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_hdr
results: parsing output: 34/ for test: kms_atomic_interruptible
results: parsing output: 35/ for test: gem_readwrite
results: parsing output: 36/ for test: i915_module_load
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_atomic_transition
results: parsing output: 42/ for test: gem_exec_reloc
results: parsing output: 43/ for test: kms_psr2_sf
results: parsing output: 44/ for test: kms_dither
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: gem_exec_schedule
results: parsing output: 47/ for test: kms_cursor_edge_walk
results: parsing output: 48/ for test: gem_exec_reloc
results: parsing output: 49/ for test: gem_mmap_gtt
results: parsing output: 50/ for test: kms_flip_scaled_crc
results: parsing output: 51/ for test: gem_exec_reloc
results: parsing output: 52/ for test: kms_psr
results: parsing output: 53/ for test: gem_ctx_shared
results: parsing output: 54/ for test: kms_addfb_basic
results: parsing output: 55/ for test: kms_flip_scaled_crc
results: parsing output: 56/ for test: gem_mmap_gtt
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: gem_spin_batch
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_cursor_crc
results: parsing output: 64/ for test: kms_plane_multiple
results: parsing output: 65/ for test: kms_ccs
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: gem_ctx_param
results: parsing output: 68/ for test: kms_chamelium_hpd
results: parsing output: 69/ for test: gen9_exec_parse
results: parsing output: 70/ for test: gem_mmap_gtt
results: parsing output: 71/ for test: kms_plane_scaling
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: gem_lmem_swapping
results: parsing output: 74/ for test: gem_userptr_blits
results: parsing output: 75/ for test: perf
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_color
results: parsing output: 78/ for test: gem_ctx_persistence
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: syncobj_wait
results: parsing output: 83/ for test: gem_flink_basic
results: parsing output: 84/ for test: fbdev
results: parsing output: 85/ for test: gem_exec_reloc
results: parsing output: 86/ for test: gem_exec_reloc
results: parsing output: 87/ for test: kms_draw_crc
results: parsing output: 88/ for test: gem_sync
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: syncobj_wait
results: parsing output: 91/ for test: gem_exec_whisper
results: parsing output: 92/ for test: gem_render_copy
results: parsing output: 93/ for test: kms_ccs
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_pipe_b_c_ivb
results: parsing output: 96/ for test: kms_psr
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: gem_partial_pwrite_pread
results: parsing output: 100/ for test: kms_psr_stress_test
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: api_intel_bb
results: parsing output: 103/ for test: gem_exec_capture
results: parsing output: 104/ for test: kms_invalid_mode
results: parsing output: 105/ for test: gem_userptr_blits
results: parsing output: 106/ for test: api_intel_bb
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: syncobj_eventfd
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_ccs
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_addfb_basic
results: parsing output: 113/ for test: kms_content_protection
results: parsing output: 114/ for test: gem_userptr_blits
results: parsing output: 115/ for test: gem_softpin
results: parsing output: 116/ for test: gem_close_race
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: syncobj_wait
results: parsing output: 119/ for test: syncobj_timeline
results: parsing output: 120/ for test: gem_exec_create
results: parsing output: 121/ for test: gem_exec_suspend
results: parsing output: 122/ for test: kms_chamelium_frames
results: parsing output: 123/ for test: gem_userptr_blits
results: parsing output: 124/ for test: syncobj_timeline
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gem_exec_params
results: parsing output: 127/ for test: prime_mmap
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_ccs
results: parsing output: 130/ for test: kms_big_fb
results: parsing output: 131/ for test: kms_big_fb
results: parsing output: 132/ for test: kms_frontbuffer_tracking
results: parsing output: 133/ for test: kms_plane_scaling
results: parsing output: 134/ for test: kms_psr2_sf
results: parsing output: 135/ for test: kms_frontbuffer_tracking
results: parsing output: 136/ for test: kms_chamelium_audio
results: parsing output: 137/ for test: gem_exec_fence
results: parsing output: 138/ for test: i915_pm_rpm
results: parsing output: 139/ for test: gem_fenced_exec_thrash
results: parsing output: 140/ for test: gem_ctx_persistence
results: parsing output: 141/ for test: gen9_exec_parse
results: parsing output: 142/ for test: kms_psr2_su
results: parsing output: 143/ for test: gem_exec_balancer
results: parsing output: 144/ for test: kms_frontbuffer_tracking
results: parsing output: 145/ for test: kms_vblank
results: parsing output: 146/ for test: kms_frontbuffer_tracking
results: parsing output: 147/ for test: perf_pmu
results: parsing output: 148/ for test: kms_frontbuffer_tracking
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: sysfs_timeslice_duration
results: parsing output: 151/ for test: kms_psr
results: parsing output: 152/ for test: kms_pipe_crc_basic
results: parsing output: 153/ for test: syncobj_timeline
results: parsing output: 154/ for test: kms_flip
Done.