[104.052540] Initializing watchdogs
[104.052597]   /dev/watchdog0
[104.069543] [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]
[104.073979] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[104.076753] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[104.080106] [001/133] (960s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[104.223970] Starting subtest: flip-vs-cursor-atomic
[112.087342] Subtest flip-vs-cursor-atomic: SUCCESS (7.860s)
[112.494850] [002/133] (952s left) gem_pwrite (basic-self)
[112.556933] Subtest basic-self: SKIP (0.000s)
[112.621037] [003/133] (952s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[112.712778] Starting subtest: fbc-pr-sprite-mmap-gtt
[112.716691] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[112.808843] [004/133] (951s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[112.910700] Starting subtest: psr-rgb101010-draw-render
[120.159759] Subtest psr-rgb101010-draw-render: SUCCESS (7.253s)
[120.326933] [005/133] (944s left) i915_pm_rc6_residency (rc6-accuracy)
[120.380770] Starting subtest: rc6-accuracy
[120.382643] Starting dynamic subtest: gt0
[123.552868] Dynamic subtest gt0: SUCCESS (3.168s)
[123.560214] Starting dynamic subtest: gt1
[126.723287] Dynamic subtest gt1: SUCCESS (3.169s)
[126.725888] Subtest rc6-accuracy: SUCCESS (6.340s)
[126.807244] [006/133] (937s left) gem_userptr_blits (forbidden-operations)
[126.878742] Starting subtest: forbidden-operations
[126.883165] Subtest forbidden-operations: SKIP (0.000s)
[127.023184] [007/133] (937s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[127.126713] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[127.130828] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[127.241921] [008/133] (937s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[127.340358] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[131.594498] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.257s)
[132.720190] [009/133] (932s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[132.792940] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[132.897741] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.103s)
[132.984639] [010/133] (931s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[133.110080] Starting subtest: cursorA-vs-flipA-atomic
[144.234687] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.125s)
[145.027777] [011/133] (919s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[145.122730] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[145.125077] Starting dynamic subtest: pipe-A-eDP-1
[145.150854] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[145.160257] Starting dynamic subtest: pipe-B-eDP-1
[145.183042] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[145.190127] Starting dynamic subtest: pipe-C-eDP-1
[145.214205] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[145.221133] Starting dynamic subtest: pipe-D-eDP-1
[145.245295] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[145.249694] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[147.406017] [012/133] (917s left) kms_flip (2x-flip-vs-wf_vblank)
[147.514929] Starting subtest: 2x-flip-vs-wf_vblank
[147.524678] Subtest 2x-flip-vs-wf_vblank: SKIP (0.010s)
[147.657481] [013/133] (917s left) kms_addfb_basic (small-bo)
[147.759246] Starting subtest: small-bo
[147.761533] Subtest small-bo: SUCCESS (0.000s)
[147.889171] [014/133] (917s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[147.979187] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[147.981556] Starting dynamic subtest: pipe-A-default-mode
[150.733846] Dynamic subtest pipe-A-default-mode: SUCCESS (2.754s)
[150.736228] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.756s)
[151.604732] [015/133] (913s left) gem_madvise (dontneed-before-mmap)
[151.639373] Starting subtest: dontneed-before-mmap
[151.666754] Subtest dontneed-before-mmap: SUCCESS (0.028s)
[151.786654] [016/133] (913s left) kms_atomic (plane-primary-legacy)
[151.885504] Starting subtest: plane-primary-legacy
[151.887720] Starting dynamic subtest: pipe-A-eDP-1
[152.366580] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.481s)
[152.368925] Subtest plane-primary-legacy: SUCCESS (0.483s)
[153.258137] [017/133] (911s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[153.358223] Starting subtest: blocking-absolute-wf_vblank-interruptible
[153.360666] Starting dynamic subtest: A-eDP1
[162.088663] Dynamic subtest A-eDP1: SUCCESS (8.730s)
[162.099161] Starting dynamic subtest: B-eDP1
[170.819084] Dynamic subtest B-eDP1: SUCCESS (8.728s)
[170.827168] Starting dynamic subtest: C-eDP1
[179.540947] Dynamic subtest C-eDP1: SUCCESS (8.720s)
[179.550298] Starting dynamic subtest: D-eDP1
[188.267769] Dynamic subtest D-eDP1: SUCCESS (8.725s)
[188.272913] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.912s)
[189.507475] [018/133] (875s left) kms_cursor_edge_walk (64x64-top-bottom)
[189.607187] Starting subtest: 64x64-top-bottom
[189.609598] Starting dynamic subtest: pipe-A-eDP-1
[193.060897] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.454s)
[193.069502] Starting dynamic subtest: pipe-D-eDP-1
[196.183955] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.122s)
[196.186379] Subtest 64x64-top-bottom: SUCCESS (6.579s)
[197.018264] [019/133] (868s left) kms_addfb_basic (invalid-get-prop-any)
[197.080195] Starting subtest: invalid-get-prop-any
[197.082170] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[197.216141] [020/133] (868s left) gem_mmap_gtt (fault-concurrent-y)
[197.271083] Subtest fault-concurrent-Y: SKIP (0.000s)
[197.345461] [021/133] (868s left) gem_busy (semaphore)
[197.536816] Subtest semaphore: SKIP (0.000s)
[197.790666] [022/133] (867s left) kms_vblank (query-forked-busy-hang)
[197.894999] Starting subtest: query-forked-busy-hang
[197.897356] Starting dynamic subtest: pipe-A-eDP-1
[224.724813] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.827s)
[224.737177] Starting dynamic subtest: pipe-D-eDP-1
[239.707802] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.979s)
[239.710192] Subtest query-forked-busy-hang: SUCCESS (41.810s)
[240.566958] [023/133] (824s left) kms_prop_blob (invalid-set-prop)
[240.629170] Starting subtest: invalid-set-prop
[240.631145] Subtest invalid-set-prop: SUCCESS (0.000s)
[240.754859] [024/133] (824s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[240.844061] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[240.856667] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[240.925485] [025/133] (824s left) kms_lease (multimaster-lease)
[241.023166] Starting subtest: multimaster-lease
[241.025494] Subtest multimaster-lease: SUCCESS (0.003s)
[241.142801] [026/133] (824s left) kms_addfb_basic (invalid-smem-bo-on-discrete)
[241.198043] Starting subtest: invalid-smem-bo-on-discrete
[241.203127] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s)
[241.355127] [027/133] (824s left) gem_userptr_blits (dmabuf-unsync)
[241.426683] Subtest dmabuf-unsync: SKIP (0.000s)
[241.589539] [028/133] (824s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[241.696025] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[242.664315] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (0.970s)
[242.833224] [029/133] (822s left) gem_ringfill (legacy-basic)
[248.921642] Starting subtest: legacy-basic
[248.924165] Starting dynamic subtest: default
[248.980682] Dynamic subtest default: SUCCESS (0.060s)
[248.991078] Starting dynamic subtest: render
[249.021895] Dynamic subtest render: SUCCESS (0.040s)
[249.030304] Starting dynamic subtest: bsd
[249.064509] Dynamic subtest bsd: SUCCESS (0.040s)
[249.075604] Starting dynamic subtest: bsd1
[249.107199] Dynamic subtest bsd1: SUCCESS (0.041s)
[249.116453] Starting dynamic subtest: bsd2
[249.150925] Dynamic subtest bsd2: SUCCESS (0.041s)
[249.167261] Starting dynamic subtest: blt
[249.201298] Dynamic subtest blt: SUCCESS (0.048s)
[249.219022] Starting dynamic subtest: vebox
[249.247589] Dynamic subtest vebox: SUCCESS (0.043s)
[249.250073] Subtest legacy-basic: SUCCESS (0.328s)
[249.336872] [FACT gem_ringfill (legacy-basic)] new: kernel.kmod_is_loaded.vgem: true
[249.339872] [030/133] (816s left) gem_vm_create (invalid-create)
[249.407831] Starting subtest: invalid-create
[249.412803] Subtest invalid-create: SUCCESS (0.002s)
[249.550497] [031/133] (816s left) gen9_exec_parse (batch-invalid-length)
[249.607365] Subtest batch-invalid-length: SKIP (0.000s)
[249.691526] [032/133] (816s left) gem_exec_schedule (submit-early-slice)
[249.761991] Starting subtest: submit-early-slice
[249.764119] Starting dynamic subtest: rcs0
[249.832623] Dynamic subtest rcs0: SUCCESS (0.078s)
[249.845694] Starting dynamic subtest: bcs0
[249.883512] Dynamic subtest bcs0: SUCCESS (0.051s)
[249.894025] Starting dynamic subtest: vcs0
[249.941036] Dynamic subtest vcs0: SUCCESS (0.057s)
[249.950716] Starting dynamic subtest: vcs1
[249.995203] Dynamic subtest vcs1: SUCCESS (0.054s)
[250.004355] Starting dynamic subtest: vecs0
[250.041740] Dynamic subtest vecs0: SUCCESS (0.046s)
[250.050741] Starting dynamic subtest: ccs0
[250.094393] Dynamic subtest ccs0: SUCCESS (0.052s)
[250.096616] Subtest submit-early-slice: SUCCESS (0.341s)
[251.992340] [033/133] (813s left) gem_lmem_swapping (massive-random)
[252.035164] Subtest massive-random: SKIP (0.000s)
[252.074834] [034/133] (813s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[252.176591] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[252.181033] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[252.275755] [035/133] (813s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[252.374868] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[253.465745] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.090s)
[253.620552] [036/133] (812s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[253.732023] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[253.733912] Starting dynamic subtest: pipe-A
[254.071980] Dynamic subtest pipe-A: SUCCESS (0.341s)
[254.079913] Starting dynamic subtest: pipe-B
[255.463594] Dynamic subtest pipe-B: SUCCESS (1.390s)
[255.475326] Starting dynamic subtest: pipe-C
[256.897178] Dynamic subtest pipe-C: SUCCESS (1.432s)
[256.911300] Starting dynamic subtest: pipe-D
[258.322988] Dynamic subtest pipe-D: SUCCESS (1.424s)
[258.325422] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.593s)
[259.591289] [037/133] (806s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[259.679521] Starting subtest: saturated-hostile-nopreempt
[259.681638] Starting dynamic subtest: rcs0
[259.788733] Dynamic subtest rcs0: SKIP (0.109s)
[259.798970] Starting dynamic subtest: bcs0
[259.816693] Dynamic subtest bcs0: SKIP (0.027s)
[259.824730] Starting dynamic subtest: vcs0
[259.839622] Dynamic subtest vcs0: SKIP (0.022s)
[259.847464] Starting dynamic subtest: vcs1
[259.865203] Dynamic subtest vcs1: SKIP (0.024s)
[259.878747] Starting dynamic subtest: vecs0
[259.887905] Dynamic subtest vecs0: SKIP (0.021s)
[259.896112] Starting dynamic subtest: ccs0
[259.911659] Dynamic subtest ccs0: SKIP (0.022s)
[259.916137] Subtest saturated-hostile-nopreempt: SKIP (0.234s)
[260.002318] [038/133] (806s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[260.121145] Starting subtest: sprite-rotation-90-pos-100-0
[260.125473] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[260.211775] [039/133] (805s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[260.321909] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[260.326230] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[260.426262] [040/133] (805s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[260.521359] Starting subtest: compare-crc-sanitycheck-xr24
[260.523031] Starting dynamic subtest: pipe-A-eDP-1
[261.128098] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.604s)
[261.136904] Starting dynamic subtest: pipe-B-eDP-1
[262.423573] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.296s)
[262.431646] Starting dynamic subtest: pipe-C-eDP-1
[263.646894] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.221s)
[263.655662] Starting dynamic subtest: pipe-D-eDP-1
[264.896154] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.248s)
[264.898410] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.374s)
[265.748358] [041/133] (800s left) kms_tv_load_detect (load-detect)
[265.809149] Subtest load-detect: SKIP (0.000s)
[265.872731] [042/133] (800s left) gem_softpin (safe-alignment)
[265.934335] Starting subtest: safe-alignment
[265.956410] Subtest safe-alignment: SUCCESS (0.022s)
[267.987386] [043/133] (798s left) gem_ctx_sseu (invalid-args)
[268.049102] Subtest invalid-args: SKIP (0.000s)
[268.141896] [044/133] (798s left) gem_exec_reloc (basic-wc-noreloc)
[268.208722] Subtest basic-wc-noreloc: SKIP (0.000s)
[268.289890] [045/133] (798s left) gem_exec_balancer (individual)
[268.356283] Starting subtest: individual
[269.914487] Subtest individual: SUCCESS (1.559s)
[270.260530] [046/133] (796s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[270.365056] Starting subtest: fb-8bpc-vs-panel-8bpc
[270.367323] Starting dynamic subtest: pipe-A-eDP-1
[271.811357] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.445s)
[271.813688] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.446s)
[272.712072] [047/133] (793s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[272.786818] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[272.888436] [048/133] (793s left) kms_fence_pin_leak
[273.093652] [049/133] (793s left) i915_pm_rps (thresholds-idle)
[273.160091] Starting subtest: thresholds-idle
[273.164724] Subtest thresholds-idle: SKIP (0.001s)
[273.317767] [050/133] (793s left) core_setmaster (master-drop-set-root)
[273.412838] Starting subtest: master-drop-set-root
[273.421917] Subtest master-drop-set-root: SUCCESS (0.012s)
[273.472642] [051/133] (793s left) gem_exec_store (pages)
[273.547820] Starting subtest: pages
[273.550124] Starting dynamic subtest: rcs0
[273.676931] Dynamic subtest rcs0: SUCCESS (0.129s)
[273.688414] Starting dynamic subtest: bcs0
[273.754728] Dynamic subtest bcs0: SUCCESS (0.077s)
[273.765041] Starting dynamic subtest: vcs0
[273.855034] Dynamic subtest vcs0: SUCCESS (0.099s)
[273.865948] Starting dynamic subtest: vcs1
[273.936378] Dynamic subtest vcs1: SUCCESS (0.080s)
[273.946881] Starting dynamic subtest: vecs0
[274.006878] Dynamic subtest vecs0: SUCCESS (0.069s)
[274.016916] Starting dynamic subtest: ccs0
[274.086338] Dynamic subtest ccs0: SUCCESS (0.078s)
[274.088375] Subtest pages: SUCCESS (0.540s)
[274.284809] [052/133] (792s left) kms_flip (2x-plain-flip)
[274.390189] Starting subtest: 2x-plain-flip
[274.399322] Subtest 2x-plain-flip: SKIP (0.011s)
[274.492776] [053/133] (792s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[274.593654] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[274.597670] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[274.731447] [054/133] (791s left) syncobj_timeline (invalid-query-illegal-handle)
[274.783044] Starting subtest: invalid-query-illegal-handle
[274.785285] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[274.906138] [055/133] (791s left) kms_psr (pr-primary-page-flip)
[275.006628] Starting subtest: pr-primary-page-flip
[275.011040] Subtest pr-primary-page-flip: SKIP (0.000s)
[275.105421] [056/133] (791s left) kms_fb_coherency (memset-crc)
[275.205039] Starting subtest: memset-crc
[275.206858] Starting dynamic subtest: mmap-offset-wc
[275.579129] Dynamic subtest mmap-offset-wc: SUCCESS (0.376s)
[275.870264] Starting dynamic subtest: mmap-offset-uc
[281.985829] Dynamic subtest mmap-offset-uc: SUCCESS (6.123s)
[282.266985] Subtest memset-crc: SUCCESS (7.061s)
[283.165534] [057/133] (783s left) api_intel_bb (reset-flags)
[283.235285] Starting subtest: reset-flags
[283.241057] Subtest reset-flags: SUCCESS (0.007s)
[283.418273] [058/133] (783s left) gem_ctx_isolation (preservation-reset)
[283.590794] Starting subtest: preservation-reset
[283.593668] Starting dynamic subtest: rcs0
[283.881110] Dynamic subtest rcs0: SUCCESS (0.291s)
[283.892663] Starting dynamic subtest: bcs0
[284.220072] Dynamic subtest bcs0: SUCCESS (0.338s)
[284.229561] Starting dynamic subtest: vcs0
[284.524932] Dynamic subtest vcs0: SUCCESS (0.303s)
[284.534198] Starting dynamic subtest: vcs1
[286.268982] Dynamic subtest vcs1: SUCCESS (1.744s)
[286.279265] Starting dynamic subtest: vecs0
[288.233432] Dynamic subtest vecs0: SUCCESS (1.963s)
[288.243828] Starting dynamic subtest: ccs0
[290.224762] Dynamic subtest ccs0: SUCCESS (1.991s)
[290.227550] Subtest preservation-reset: SUCCESS (6.636s)
[290.395851] [059/133] (776s left) sw_sync (timeline_closed)
[290.434240] Starting subtest: timeline_closed
[290.436343] Subtest timeline_closed: SUCCESS (0.000s)
[290.500743] [060/133] (776s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[290.638149] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[290.642489] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[290.807298] [061/133] (776s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[290.909611] Starting subtest: fbcpsr-rgb565-draw-pwrite
[297.962509] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (7.054s)
[298.120682] [062/133] (768s left) gem_mmap_gtt (basic-small-copy-xy)
[298.180210] Subtest basic-small-copy-XY: SKIP (0.000s)
[298.244213] [063/133] (768s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[298.351720] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[298.353834] Starting dynamic subtest: pipe-A-eDP-1
[298.407847] Dynamic subtest pipe-A-eDP-1: SKIP (0.003s)
[298.416233] Starting dynamic subtest: pipe-B-eDP-1
[298.469597] Dynamic subtest pipe-B-eDP-1: SKIP (0.002s)
[298.479242] Starting dynamic subtest: pipe-C-eDP-1
[298.532673] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[298.541528] Starting dynamic subtest: pipe-D-eDP-1
[298.595799] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[298.600228] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.013s)
[300.567587] [064/133] (766s left) kms_psr (psr-cursor-mmap-gtt)
[300.668214] Starting subtest: psr-cursor-mmap-gtt
[300.670516] Starting dynamic subtest: eDP-1
[302.359521] Dynamic subtest eDP-1: SUCCESS (1.692s)
[302.361822] Subtest psr-cursor-mmap-gtt: SUCCESS (1.693s)
[303.234230] [065/133] (763s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[303.335312] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[303.339347] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[303.454082] [066/133] (763s left) gem_exec_schedule (preempt-queue-chain)
[303.519608] Subtest preempt-queue-chain: SKIP (0.000s)
[303.818219] [067/133] (763s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[303.861206] Starting subtest: invalid-bsd2-flag-on-blt
[303.863499] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[303.969254] [068/133] (763s left) gem_lmem_swapping (random)
[304.003631] Subtest random: SKIP (0.000s)
[304.045565] [069/133] (763s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[304.148970] Starting subtest: y-tiled-64bpp-rotate-90
[304.153439] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[304.259882] [070/133] (763s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[304.364297] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[311.357227] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (6.995s)
[311.463166] [071/133] (755s left) gem_tiled_blits (normal)
[311.534266] Subtest normal: SKIP (0.000s)
[311.618230] [072/133] (755s left) vgem_basic (create)
[311.658704] Starting subtest: create
[311.660782] Subtest create: SUCCESS (0.000s)
[311.727668] [073/133] (755s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[311.851968] Starting subtest: 4-tiled-64bpp-rotate-0
[313.579486] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.728s)
[313.778667] [074/133] (753s left) sysfs_preempt_timeout (invalid)
[313.846061] Starting subtest: invalid
[313.848441] Starting dynamic subtest: vecs0
[313.850752] Dynamic subtest vecs0: SUCCESS (0.000s)
[313.859497] Starting dynamic subtest: ccs0
[313.861673] Dynamic subtest ccs0: SUCCESS (0.000s)
[313.872516] Starting dynamic subtest: vcs0
[313.874786] Dynamic subtest vcs0: SUCCESS (0.000s)
[313.883206] Starting dynamic subtest: bcs0
[313.885301] Dynamic subtest bcs0: SUCCESS (0.000s)
[313.893929] Starting dynamic subtest: rcs0
[313.895829] Dynamic subtest rcs0: SUCCESS (0.000s)
[313.904433] Starting dynamic subtest: vcs1
[313.906629] Dynamic subtest vcs1: SUCCESS (0.000s)
[313.908814] Subtest invalid: SUCCESS (0.006s)
[313.959801] [075/133] (753s left) kms_scaling_modes (scaling-mode-full-aspect)
[314.073878] Starting subtest: scaling-mode-full-aspect
[314.076168] Starting dynamic subtest: pipe-A-eDP-1
[314.166471] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.094s)
[314.176439] Starting dynamic subtest: pipe-B-eDP-1
[315.369721] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.201s)
[315.382081] Starting dynamic subtest: pipe-C-eDP-1
[316.571305] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.199s)
[316.583244] Starting dynamic subtest: pipe-D-eDP-1
[317.701333] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.127s)
[317.703771] Subtest scaling-mode-full-aspect: SUCCESS (3.630s)
[318.895428] [076/133] (748s left) gem_create (create-ext-cpu-access-sanity-check)
[319.078825] Starting subtest: create-ext-cpu-access-sanity-check
[319.084045] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[319.167616] [077/133] (748s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[319.263021] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[319.267500] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[319.380650] [078/133] (748s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[319.467721] Starting subtest: bad-pixel-format-yf-tiled-ccs
[319.469983] Starting dynamic subtest: pipe-A-eDP-1
[319.492758] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[319.503989] Starting dynamic subtest: pipe-B-eDP-1
[319.526406] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[319.535294] Starting dynamic subtest: pipe-C-eDP-1
[319.556908] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[319.565501] Starting dynamic subtest: pipe-D-eDP-1
[319.587456] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[319.591484] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.005s)
[321.666094] [079/133] (746s left) gem_exec_parallel (userptr)
[321.733264] Starting subtest: userptr
[321.735651] Starting dynamic subtest: rcs0
[323.187114] Dynamic subtest rcs0: SUCCESS (1.453s)
[323.202282] Starting dynamic subtest: bcs0
[324.678733] Dynamic subtest bcs0: SUCCESS (1.489s)
[324.690647] Starting dynamic subtest: vcs0
[327.893210] Dynamic subtest vcs0: SUCCESS (3.211s)
[327.904245] Starting dynamic subtest: vcs1
[329.878441] Dynamic subtest vcs1: SUCCESS (1.982s)
[329.889933] Starting dynamic subtest: vecs0
[331.926417] Dynamic subtest vecs0: SUCCESS (2.046s)
[331.937798] Starting dynamic subtest: ccs0
[333.435040] Dynamic subtest ccs0: SUCCESS (1.507s)
[333.437553] Subtest userptr: SUCCESS (11.702s)
[333.635776] [080/133] (734s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[333.759103] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[333.761340] Starting dynamic subtest: pipe-A-eDP-1
[333.855644] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[333.866170] Starting dynamic subtest: pipe-B-eDP-1
[335.028904] Dynamic subtest pipe-B-eDP-1: SKIP (1.171s)
[335.033617] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.273s)
[336.245454] [081/133] (731s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[336.361762] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[336.363961] Starting dynamic subtest: pipe-A
[336.425473] Dynamic subtest pipe-A: SUCCESS (0.065s)
[336.436629] Starting dynamic subtest: pipe-B
[337.557910] Dynamic subtest pipe-B: SUCCESS (1.132s)
[337.569297] Starting dynamic subtest: pipe-C
[338.662415] Dynamic subtest pipe-C: SUCCESS (1.103s)
[338.671956] Starting dynamic subtest: pipe-D
[339.786740] Dynamic subtest pipe-D: SUCCESS (1.123s)
[339.789269] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.428s)
[340.977978] [082/133] (726s left) kms_chamelium_frames (hdmi-crc-single)
[341.372882] Subtest hdmi-crc-single: SKIP (0.000s)
[342.168654] [083/133] (725s left) gem_exec_fence (syncobj-channel)
[342.626766] Starting subtest: syncobj-channel
[343.648090] Subtest syncobj-channel: SUCCESS (1.017s)
[344.027413] [084/133] (723s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[344.126677] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[344.131194] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[345.235148] [085/133] (722s left) syncobj_timeline (multi-wait-available-submitted)
[345.298352] Starting subtest: multi-wait-available-submitted
[345.300239] Subtest multi-wait-available-submitted: SUCCESS (0.000s)
[345.418783] [086/133] (722s left) gem_exec_flush (basic-wb-rw-before-default)
[345.488532] Starting subtest: basic-wb-rw-before-default
[350.945679] Subtest basic-wb-rw-before-default: SUCCESS (5.458s)
[351.155341] [087/133] (716s left) i915_drm_fdinfo (most-busy-idle-check-all)
[351.197098] Starting subtest: most-busy-idle-check-all
[351.199331] Starting dynamic subtest: rcs0
[351.203804] Dynamic subtest rcs0: SKIP (0.004s)
[351.214889] Starting dynamic subtest: bcs0
[351.219322] Dynamic subtest bcs0: SKIP (0.000s)
[351.227977] Starting dynamic subtest: vcs0
[351.232177] Dynamic subtest vcs0: SKIP (0.000s)
[351.240689] Starting dynamic subtest: vcs1
[351.245060] Dynamic subtest vcs1: SKIP (0.000s)
[351.253309] Starting dynamic subtest: vecs0
[351.257663] Dynamic subtest vecs0: SKIP (0.000s)
[351.266071] Starting dynamic subtest: ccs0
[351.270196] Dynamic subtest ccs0: SKIP (0.000s)
[351.274464] Subtest most-busy-idle-check-all: SKIP (0.009s)
[351.311451] [088/133] (716s left) kms_pm_rpm (system-suspend-modeset)
[353.052227] Starting subtest: system-suspend-modeset
[373.238689] Subtest system-suspend-modeset: SUCCESS (5.145s)
[377.647459] [089/133] (694s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[377.737318] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[377.742385] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[377.954759] [090/133] (694s left) kms_sequence (get-busy)
[378.044105] Starting subtest: get-busy
[378.046329] Starting dynamic subtest: pipe-A-eDP-1
[379.926002] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.936s)
[379.938679] Starting dynamic subtest: pipe-B-eDP-1
[382.474550] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.602s)
[382.485085] Starting dynamic subtest: pipe-C-eDP-1
[385.067328] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.632s)
[385.078548] Starting dynamic subtest: pipe-D-eDP-1
[387.656092] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.616s)
[387.657928] Subtest get-busy: SUCCESS (9.791s)
[388.462372] [091/133] (683s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[388.552389] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[388.556639] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[388.684711] [092/133] (683s left) kms_psr (fbc-psr-cursor-mmap-cpu)
[388.776209] Starting subtest: fbc-psr-cursor-mmap-cpu
[388.778479] Starting dynamic subtest: eDP-1
[388.782585] Dynamic subtest eDP-1: SKIP (0.000s)
[388.786650] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.001s)
[388.875204] [093/133] (683s left) kms_rotation_crc (exhaust-fences)
[388.962490] Starting subtest: exhaust-fences
[388.966789] Subtest exhaust-fences: SKIP (0.000s)
[389.053110] [094/133] (683s left) kms_flip (absolute-wf_vblank)
[389.151142] Starting subtest: absolute-wf_vblank
[389.153385] Starting dynamic subtest: A-eDP1
[397.862671] Dynamic subtest A-eDP1: SUCCESS (8.755s)
[397.876182] Starting dynamic subtest: B-eDP1
[406.581835] Dynamic subtest B-eDP1: SUCCESS (8.734s)
[406.597084] Starting dynamic subtest: C-eDP1
[415.295809] Dynamic subtest C-eDP1: SUCCESS (8.712s)
[415.308534] Starting dynamic subtest: D-eDP1
[424.026059] Dynamic subtest D-eDP1: SUCCESS (8.731s)
[424.028346] Subtest absolute-wf_vblank: SUCCESS (34.941s)
[425.252053] [095/133] (647s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[425.365638] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[432.760988] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.400s)
[432.956573] [096/133] (639s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[433.283380] Starting subtest: cursor-rapid-movement-max-size
[433.289944] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[433.457407] [097/133] (639s left) kms_properties (crtc-properties-atomic)
[433.552431] Starting subtest: crtc-properties-atomic
[433.554691] Starting dynamic subtest: pipe-A-eDP-1
[433.994207] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.441s)
[434.005019] Starting dynamic subtest: pipe-B-eDP-1
[435.121422] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.127s)
[435.133753] Starting dynamic subtest: pipe-C-eDP-1
[436.237289] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.115s)
[436.250114] Starting dynamic subtest: pipe-D-eDP-1
[437.363205] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.126s)
[437.365410] Subtest crtc-properties-atomic: SUCCESS (3.814s)
[438.185728] [098/133] (634s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[438.287604] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[438.289892] Starting dynamic subtest: pipe-A-default-mode
[439.431927] Dynamic subtest pipe-A-default-mode: SKIP (1.144s)
[439.436142] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.146s)
[439.622527] [099/133] (632s left) api_intel_allocator (simple-allocator)
[439.688734] Starting subtest: simple-allocator
[439.690918] Starting dynamic subtest: basic
[439.693169] Dynamic subtest basic: SUCCESS (0.005s)
[439.705950] Starting dynamic subtest: parallel-one
[439.872708] Dynamic subtest parallel-one: SUCCESS (0.179s)
[439.886442] Starting dynamic subtest: print
[439.888613] Dynamic subtest print: SUCCESS (0.000s)
[439.902019] Starting dynamic subtest: reuse
[439.903883] Dynamic subtest reuse: SUCCESS (0.000s)
[439.912883] Starting dynamic subtest: reserve
[439.914766] Dynamic subtest reserve: SUCCESS (0.000s)
[439.923780] Starting dynamic subtest: fork-reopen-allocator
[439.925668] Dynamic subtest fork-reopen-allocator: SUCCESS (0.014s)
[439.927516] Subtest simple-allocator: SUCCESS (0.206s)
[440.039649] [100/133] (632s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier)
[440.144426] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier
[440.156912] Subtest pixel-format-4-tiled-bmg-ccs-modifier: SKIP (0.000s)
[440.243984] [101/133] (632s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[440.343857] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[440.347999] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[440.474804] [102/133] (632s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[440.571584] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[440.575767] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[440.707611] [103/133] (632s left) drm_read (empty-block)
[440.856444] Starting subtest: empty-block
[441.855410] Subtest empty-block: SUCCESS (1.000s)
[442.016332] [104/133] (630s left) gem_mmap_gtt (basic-write-read-distinct)
[442.074114] Subtest basic-write-read-distinct: SKIP (0.000s)
[442.142304] [105/133] (630s left) kms_setmode (invalid-clone-single-crtc)
[442.195006] Starting subtest: invalid-clone-single-crtc
[442.201337] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[442.323276] [106/133] (630s left) gem_exec_capture (capture-invisible)
[442.392407] Starting subtest: capture-invisible
[442.394707] Starting dynamic subtest: smem0
[442.398841] Dynamic subtest smem0: SKIP (0.000s)
[442.402921] Subtest capture-invisible: SKIP (0.002s)
[442.526114] [107/133] (630s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[442.594101] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[442.596344] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[442.724689] [108/133] (630s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[442.834738] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[443.802419] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.968s)
[443.984028] [109/133] (629s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[444.085768] Starting subtest: fbc-rgb565-draw-mmap-cpu
[448.124998] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (4.045s)
[449.316948] [110/133] (623s left) i915_pm_freq_api (freq-suspend)
[449.375020] Starting subtest: freq-suspend
[449.377464] Starting dynamic subtest: gt0
[466.679250] Dynamic subtest gt0: SUCCESS (2.361s)
[466.695906] Starting dynamic subtest: gt1
[483.690418] Dynamic subtest gt1: SUCCESS (1.624s)
[483.694374] Subtest freq-suspend: SUCCESS (3.987s)
[490.778145] [111/133] (589s left) kms_cursor_crc (cursor-offscreen-64x64)
[490.970118] Starting subtest: cursor-offscreen-64x64
[490.975227] Starting dynamic subtest: pipe-A-eDP-1
[492.877972] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.957s)
[492.905968] Starting dynamic subtest: pipe-D-eDP-1
[495.438505] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.596s)
[495.440797] Subtest cursor-offscreen-64x64: SUCCESS (4.581s)
[496.270173] [112/133] (583s left) kms_color (ctm-0-25)
[496.378965] Starting subtest: ctm-0-25
[496.381160] Starting dynamic subtest: pipe-A-eDP-1
[499.892116] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.558s)
[499.902271] Starting dynamic subtest: pipe-B-eDP-1
[504.129695] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.269s)
[504.139401] Starting dynamic subtest: pipe-C-eDP-1
[508.132495] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.024s)
[508.143198] Starting dynamic subtest: pipe-D-eDP-1
[512.109895] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.988s)
[512.112326] Subtest ctm-0-25: SUCCESS (15.844s)
[512.943646] [113/133] (567s left) drm_read (fault-buffer)
[513.092208] Starting subtest: fault-buffer
[513.094689] Subtest fault-buffer: SUCCESS (0.001s)
[513.253567] [114/133] (566s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[513.356207] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[513.358502] Starting dynamic subtest: pipe-A-eDP-1
[513.381362] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[513.393188] Starting dynamic subtest: pipe-B-eDP-1
[513.414806] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[513.424461] Starting dynamic subtest: pipe-C-eDP-1
[513.445940] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[513.455088] Starting dynamic subtest: pipe-D-eDP-1
[513.477301] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[513.481320] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.005s)
[515.603353] [115/133] (564s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[515.720932] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[522.576764] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.868s)
[522.744695] [116/133] (557s left) kms_chamelium_hpd (common-hpd-after-suspend)
[523.126549] Subtest common-hpd-after-suspend: SKIP (0.000s)
[523.915466] [117/133] (556s left) kms_content_protection (uevent)
[524.060596] Starting subtest: uevent
[524.065110] Subtest uevent: SKIP (0.000s)
[524.192889] [118/133] (556s left) kms_pm_lpsp (kms-lpsp)
[525.291501] Starting subtest: kms-lpsp
[525.293704] Starting dynamic subtest: pipe-A-eDP-1
[525.439272] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.148s)
[525.743048] Subtest kms-lpsp: SUCCESS (0.452s)
[526.575145] [119/133] (553s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[526.685590] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[526.689728] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[526.808093] [120/133] (553s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[526.934576] Starting subtest: flip-vs-cursor-varying-size
[535.574726] Subtest flip-vs-cursor-varying-size: SUCCESS (8.637s)
[536.414382] [121/133] (544s left) perf_pmu (busy-accuracy-50)
[536.457350] Starting subtest: busy-accuracy-50
[536.459257] Starting dynamic subtest: rcs0
[537.993039] Dynamic subtest rcs0: SUCCESS (1.535s)
[538.005050] Starting dynamic subtest: bcs0
[539.535710] Dynamic subtest bcs0: SUCCESS (1.540s)
[539.547742] Starting dynamic subtest: vcs0
[541.076429] Dynamic subtest vcs0: SUCCESS (1.539s)
[541.088464] Starting dynamic subtest: vcs1
[542.614292] Dynamic subtest vcs1: SUCCESS (1.535s)
[542.625818] Starting dynamic subtest: vecs0
[544.154982] Dynamic subtest vecs0: SUCCESS (1.539s)
[544.166533] Starting dynamic subtest: ccs0
[545.704720] Dynamic subtest ccs0: SUCCESS (1.547s)
[545.706941] Subtest busy-accuracy-50: SUCCESS (9.249s)
[545.846141] [122/133] (534s left) prime_vgem (wait)
[545.927675] Starting subtest: wait
[545.929595] Starting dynamic subtest: rcs0
[546.009370] Dynamic subtest rcs0: SUCCESS (0.082s)
[546.020303] Starting dynamic subtest: bcs0
[546.047449] Dynamic subtest bcs0: SUCCESS (0.037s)
[546.060008] Starting dynamic subtest: vcs0
[546.100291] Dynamic subtest vcs0: SUCCESS (0.050s)
[546.110204] Starting dynamic subtest: vcs1
[546.142245] Dynamic subtest vcs1: SUCCESS (0.041s)
[546.152063] Starting dynamic subtest: vecs0
[546.190002] Dynamic subtest vecs0: SUCCESS (0.047s)
[546.199906] Starting dynamic subtest: ccs0
[546.240024] Dynamic subtest ccs0: SUCCESS (0.049s)
[546.242280] Subtest wait: SUCCESS (0.314s)
[546.411658] [123/133] (534s left) kms_psr (fbc-pr-basic)
[546.506950] Starting subtest: fbc-pr-basic
[546.510887] Subtest fbc-pr-basic: SKIP (0.000s)
[546.591369] [124/133] (534s left) gem_userptr_blits (sync-overlap)
[546.661947] Starting subtest: sync-overlap
[546.664304] Subtest sync-overlap: SUCCESS (0.000s)
[546.815959] [125/133] (533s left) perf (oa-exponents)
[546.943016] Starting subtest: oa-exponents
[546.944807] Starting dynamic subtest: 0-rcs0
[548.726777] Dynamic subtest 0-rcs0: SUCCESS (1.782s)
[548.737632] Starting dynamic subtest: 1-vcs1
[550.528809] Dynamic subtest 1-vcs1: SUCCESS (1.802s)
[550.531007] Subtest oa-exponents: SUCCESS (3.586s)
[550.579744] [126/133] (530s left) vgem_basic (dmabuf-export)
[550.621903] Starting subtest: dmabuf-export
[550.655366] Subtest dmabuf-export: SUCCESS (0.035s)
[550.778055] [127/133] (529s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[550.880771] Starting subtest: yf-tiled-64bpp-rotate-90
[550.884884] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[551.015611] [128/133] (529s left) kms_hdr (invalid-metadata-sizes)
[551.108046] Starting subtest: invalid-metadata-sizes
[551.114012] Subtest invalid-metadata-sizes: SKIP (0.000s)
[551.192207] [129/133] (529s left) kms_joiner (invalid-modeset-ultra-joiner)
[551.284911] Starting subtest: invalid-modeset-ultra-joiner
[551.288865] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[551.365860] [130/133] (529s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[551.422639] Starting subtest: rel-constants-invalid-rel-gen5
[551.424896] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[551.529593] [131/133] (529s left) perf_pmu (busy-start)
[551.566792] Starting subtest: busy-start
[551.568821] Starting dynamic subtest: rcs0
[554.116412] Dynamic subtest rcs0: SUCCESS (2.550s)
[554.128944] Starting dynamic subtest: bcs0
[556.665273] Dynamic subtest bcs0: SUCCESS (2.547s)
[556.677276] Starting dynamic subtest: vcs0
[560.256510] Dynamic subtest vcs0: SUCCESS (3.589s)
[560.267912] Starting dynamic subtest: vcs1
[564.288051] Dynamic subtest vcs1: SUCCESS (4.029s)
[564.300551] Starting dynamic subtest: vecs0
[568.256076] Dynamic subtest vecs0: SUCCESS (3.967s)
[568.268253] Starting dynamic subtest: ccs0
[570.805624] Dynamic subtest ccs0: SUCCESS (2.549s)
[570.808174] Subtest busy-start: SUCCESS (19.246s)
[570.938827] [132/133] (510s left) syncobj_timeline (wait-all-delayed-signal)
[570.992291] Starting subtest: wait-all-delayed-signal
[571.094267] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[571.184379] [133/133] (509s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[571.296125] Starting subtest: psr-2p-primscrn-cur-indfb-move
[571.300453] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[571.417751] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_legacy
results: parsing output: 1/ for test: gem_pwrite
results: parsing output: 2/ for test: kms_psr
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: i915_pm_rc6_residency
results: parsing output: 5/ for test: gem_userptr_blits
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: syncobj_timeline
results: parsing output: 9/ for test: kms_cursor_legacy
results: parsing output: 10/ for test: kms_ccs
results: parsing output: 11/ for test: kms_flip
results: parsing output: 12/ for test: kms_addfb_basic
results: parsing output: 13/ for test: kms_flip_scaled_crc
results: parsing output: 14/ for test: gem_madvise
results: parsing output: 15/ for test: kms_atomic
results: parsing output: 16/ for test: kms_flip
results: parsing output: 17/ for test: kms_cursor_edge_walk
results: parsing output: 18/ for test: kms_addfb_basic
results: parsing output: 19/ for test: gem_mmap_gtt
results: parsing output: 20/ for test: gem_busy
results: parsing output: 21/ for test: kms_vblank
results: parsing output: 22/ for test: kms_prop_blob
results: parsing output: 23/ for test: kms_plane
results: parsing output: 24/ for test: kms_lease
results: parsing output: 25/ for test: kms_addfb_basic
results: parsing output: 26/ for test: gem_userptr_blits
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: gem_ringfill
results: parsing output: 29/ for test: gem_vm_create
results: parsing output: 30/ for test: gen9_exec_parse
results: parsing output: 31/ for test: gem_exec_schedule
results: parsing output: 32/ for test: gem_lmem_swapping
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: kms_plane_scaling
results: parsing output: 36/ for test: gem_ctx_persistence
results: parsing output: 37/ for test: kms_rotation_crc
results: parsing output: 38/ for test: kms_big_fb
results: parsing output: 39/ for test: kms_pipe_crc_basic
results: parsing output: 40/ for test: kms_tv_load_detect
results: parsing output: 41/ for test: gem_softpin
results: parsing output: 42/ for test: gem_ctx_sseu
results: parsing output: 43/ for test: gem_exec_reloc
results: parsing output: 44/ for test: gem_exec_balancer
results: parsing output: 45/ for test: kms_dither
results: parsing output: 46/ for test: gem_exec_reloc
results: parsing output: 47/ for test: kms_fence_pin_leak
results: parsing output: 48/ for test: i915_pm_rps
results: parsing output: 49/ for test: core_setmaster
results: parsing output: 50/ for test: gem_exec_store
results: parsing output: 51/ for test: kms_flip
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: syncobj_timeline
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: kms_fb_coherency
results: parsing output: 56/ for test: api_intel_bb
results: parsing output: 57/ for test: gem_ctx_isolation
results: parsing output: 58/ for test: sw_sync
results: parsing output: 59/ for test: kms_cursor_legacy
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: gem_mmap_gtt
results: parsing output: 62/ for test: kms_ccs
results: parsing output: 63/ for test: kms_psr
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: gem_exec_schedule
results: parsing output: 66/ for test: gem_exec_params
results: parsing output: 67/ for test: gem_lmem_swapping
results: parsing output: 68/ for test: kms_big_fb
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_tiled_blits
results: parsing output: 71/ for test: vgem_basic
results: parsing output: 72/ for test: kms_big_fb
results: parsing output: 73/ for test: sysfs_preempt_timeout
results: parsing output: 74/ for test: kms_scaling_modes
results: parsing output: 75/ for test: gem_create
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_ccs
results: parsing output: 78/ for test: gem_exec_parallel
results: parsing output: 79/ for test: kms_psr2_sf
results: parsing output: 80/ for test: kms_plane_scaling
results: parsing output: 81/ for test: kms_chamelium_frames
results: parsing output: 82/ for test: gem_exec_fence
results: parsing output: 83/ for test: kms_ccs
results: parsing output: 84/ for test: syncobj_timeline
results: parsing output: 85/ for test: gem_exec_flush
results: parsing output: 86/ for test: i915_drm_fdinfo
results: parsing output: 87/ for test: kms_pm_rpm
results: parsing output: 88/ for test: gem_render_copy
results: parsing output: 89/ for test: kms_sequence
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_psr
results: parsing output: 92/ for test: kms_rotation_crc
results: parsing output: 93/ for test: kms_flip
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_cursor_crc
results: parsing output: 96/ for test: kms_properties
results: parsing output: 97/ for test: kms_flip_scaled_crc
results: parsing output: 98/ for test: api_intel_allocator
results: parsing output: 99/ for test: kms_plane
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: drm_read
results: parsing output: 103/ for test: gem_mmap_gtt
results: parsing output: 104/ for test: kms_setmode
results: parsing output: 105/ for test: gem_exec_capture
results: parsing output: 106/ for test: syncobj_timeline
results: parsing output: 107/ for test: kms_big_fb
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: i915_pm_freq_api
results: parsing output: 110/ for test: kms_cursor_crc
results: parsing output: 111/ for test: kms_color
results: parsing output: 112/ for test: drm_read
results: parsing output: 113/ for test: kms_ccs
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_chamelium_hpd
results: parsing output: 116/ for test: kms_content_protection
results: parsing output: 117/ for test: kms_pm_lpsp
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_cursor_legacy
results: parsing output: 120/ for test: perf_pmu
results: parsing output: 121/ for test: prime_vgem
results: parsing output: 122/ for test: kms_psr
results: parsing output: 123/ for test: gem_userptr_blits
results: parsing output: 124/ for test: perf
results: parsing output: 125/ for test: vgem_basic
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: kms_hdr
results: parsing output: 128/ for test: kms_joiner
results: parsing output: 129/ for test: gem_exec_params
results: parsing output: 130/ for test: perf_pmu
results: parsing output: 131/ for test: syncobj_timeline
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.