[60.658331] Initializing watchdogs
[60.658375]   /dev/watchdog0
[60.673162] [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]
[60.677492] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.679715] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.681549] [001/133] (960s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[60.811879] Starting subtest: flip-vs-cursor-atomic
[67.979559] Subtest flip-vs-cursor-atomic: SUCCESS (7.168s)
[68.788885] [002/133] (952s left) gem_pwrite (basic-self)
[68.850298] Subtest basic-self: SKIP (0.000s)
[68.911085] [003/133] (952s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[69.010038] Starting subtest: fbc-pr-sprite-mmap-gtt
[69.011858] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[69.100198] [004/133] (952s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[69.201128] Starting subtest: psr-rgb101010-draw-render
[76.557245] Subtest psr-rgb101010-draw-render: SUCCESS (7.357s)
[76.714335] [005/133] (944s left) i915_pm_rc6_residency (rc6-accuracy)
[76.765054] Starting subtest: rc6-accuracy
[76.766052] Starting dynamic subtest: gt0
[79.945715] Dynamic subtest gt0: SUCCESS (3.169s)
[79.954079] Starting dynamic subtest: gt1
[83.152027] Dynamic subtest gt1: SUCCESS (3.169s)
[83.153332] Subtest rc6-accuracy: SUCCESS (6.341s)
[83.198322] [006/133] (938s left) gem_userptr_blits (forbidden-operations)
[83.256772] Starting subtest: forbidden-operations
[83.259637] Subtest forbidden-operations: SKIP (0.000s)
[83.414793] [007/133] (937s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[83.507287] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[83.509032] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[83.643216] [008/133] (937s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[83.738901] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[88.016184] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.278s)
[89.203628] [009/133] (932s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[89.259936] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[89.369717] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.109s)
[89.450919] [010/133] (932s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[89.574351] Starting subtest: cursorA-vs-flipA-atomic
[100.702900] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.127s)
[101.526962] [011/133] (919s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[101.615472] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[101.616507] Starting dynamic subtest: pipe-A-eDP-1
[101.626267] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[101.633451] Starting dynamic subtest: pipe-B-eDP-1
[101.643026] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[101.648863] Starting dynamic subtest: pipe-C-eDP-1
[101.657668] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[101.662974] Starting dynamic subtest: pipe-D-eDP-1
[101.672168] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[101.673750] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[103.779248] [012/133] (917s left) kms_flip (2x-flip-vs-wf_vblank)
[103.879050] Starting subtest: 2x-flip-vs-wf_vblank
[103.889613] Subtest 2x-flip-vs-wf_vblank: SKIP (0.011s)
[104.006166] [013/133] (917s left) kms_addfb_basic (small-bo)
[104.110238] Starting subtest: small-bo
[104.111077] Subtest small-bo: SUCCESS (0.000s)
[104.209164] [014/133] (917s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[104.295981] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[104.297103] Starting dynamic subtest: pipe-A-default-mode
[107.047062] Dynamic subtest pipe-A-default-mode: SUCCESS (2.749s)
[107.048405] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.751s)
[107.881673] [015/133] (913s left) gem_madvise (dontneed-before-mmap)
[107.910602] Starting subtest: dontneed-before-mmap
[107.944353] Subtest dontneed-before-mmap: SUCCESS (0.034s)
[108.063385] [016/133] (913s left) kms_atomic (plane-primary-legacy)
[108.154739] Starting subtest: plane-primary-legacy
[108.155782] Starting dynamic subtest: pipe-A-eDP-1
[108.604951] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.449s)
[108.605881] Subtest plane-primary-legacy: SUCCESS (0.450s)
[109.409384] [017/133] (912s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[109.504909] Starting subtest: blocking-absolute-wf_vblank-interruptible
[109.507671] Starting dynamic subtest: A-eDP1
[118.276034] Dynamic subtest A-eDP1: SUCCESS (8.744s)
[118.284258] Starting dynamic subtest: B-eDP1
[126.999277] Dynamic subtest B-eDP1: SUCCESS (8.722s)
[127.008045] Starting dynamic subtest: C-eDP1
[135.733323] Dynamic subtest C-eDP1: SUCCESS (8.722s)
[135.742052] Starting dynamic subtest: D-eDP1
[144.463122] Dynamic subtest D-eDP1: SUCCESS (8.728s)
[144.464145] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.924s)
[145.638408] [018/133] (876s left) kms_cursor_edge_walk (64x64-top-bottom)
[145.731436] Starting subtest: 64x64-top-bottom
[145.732437] Starting dynamic subtest: pipe-A-eDP-1
[149.186995] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.455s)
[149.193309] Starting dynamic subtest: pipe-D-eDP-1
[152.311153] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.123s)
[152.312069] Subtest 64x64-top-bottom: SUCCESS (6.580s)
[153.131722] [019/133] (868s left) kms_addfb_basic (invalid-get-prop-any)
[153.196858] Starting subtest: invalid-get-prop-any
[153.197734] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[153.342115] [020/133] (868s left) gem_mmap_gtt (fault-concurrent-y)
[153.399420] Subtest fault-concurrent-Y: SKIP (0.000s)
[153.459266] [021/133] (868s left) gem_busy (semaphore)
[153.656985] Subtest semaphore: SKIP (0.000s)
[153.906669] [022/133] (867s left) kms_vblank (query-forked-busy-hang)
[153.990913] Starting subtest: query-forked-busy-hang
[153.991785] Starting dynamic subtest: pipe-A-eDP-1
[180.691726] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.699s)
[180.699641] Starting dynamic subtest: pipe-D-eDP-1
[195.733719] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.040s)
[195.734611] Subtest query-forked-busy-hang: SUCCESS (41.742s)
[196.585266] [023/133] (825s left) kms_prop_blob (invalid-set-prop)
[196.638638] Starting subtest: invalid-set-prop
[196.639810] Subtest invalid-set-prop: SUCCESS (0.000s)
[196.733221] [024/133] (825s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[196.823629] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[196.829073] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[196.911198] [025/133] (825s left) kms_lease (multimaster-lease)
[197.010198] Starting subtest: multimaster-lease
[197.012404] Subtest multimaster-lease: SUCCESS (0.003s)
[197.135879] [026/133] (824s left) kms_addfb_basic (invalid-smem-bo-on-discrete)
[197.179984] Starting subtest: invalid-smem-bo-on-discrete
[197.181799] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s)
[197.332953] [027/133] (824s left) gem_userptr_blits (dmabuf-unsync)
[197.386596] Subtest dmabuf-unsync: SKIP (0.000s)
[197.533635] [028/133] (824s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[197.636889] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[198.648476] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.012s)
[198.811442] [029/133] (823s left) gem_ringfill (legacy-basic)
[204.898454] Starting subtest: legacy-basic
[204.899527] Starting dynamic subtest: default
[204.981888] Dynamic subtest default: SUCCESS (0.091s)
[204.990974] Starting dynamic subtest: render
[205.023601] Dynamic subtest render: SUCCESS (0.041s)
[205.032073] Starting dynamic subtest: bsd
[205.066791] Dynamic subtest bsd: SUCCESS (0.041s)
[205.076684] Starting dynamic subtest: bsd1
[205.109852] Dynamic subtest bsd1: SUCCESS (0.041s)
[205.119602] Starting dynamic subtest: bsd2
[205.153724] Dynamic subtest bsd2: SUCCESS (0.042s)
[205.162737] Starting dynamic subtest: blt
[205.198515] Dynamic subtest blt: SUCCESS (0.043s)
[205.206698] Starting dynamic subtest: vebox
[205.240827] Dynamic subtest vebox: SUCCESS (0.040s)
[205.241966] Subtest legacy-basic: SUCCESS (0.352s)
[205.334130] [FACT gem_ringfill (legacy-basic)] new: kernel.kmod_is_loaded.vgem: true
[205.336260] [030/133] (816s left) gem_vm_create (invalid-create)
[205.389841] Starting subtest: invalid-create
[205.391032] Subtest invalid-create: SUCCESS (0.002s)
[205.501252] [031/133] (816s left) gen9_exec_parse (batch-invalid-length)
[205.555567] Subtest batch-invalid-length: SKIP (0.000s)
[205.625980] [032/133] (816s left) gem_exec_schedule (submit-early-slice)
[205.701418] Starting subtest: submit-early-slice
[205.702399] Starting dynamic subtest: rcs0
[205.765343] Dynamic subtest rcs0: SUCCESS (0.063s)
[205.774613] Starting dynamic subtest: bcs0
[205.810213] Dynamic subtest bcs0: SUCCESS (0.044s)
[205.825853] Starting dynamic subtest: vcs0
[205.860603] Dynamic subtest vcs0: SUCCESS (0.050s)
[205.870099] Starting dynamic subtest: vcs1
[205.912442] Dynamic subtest vcs1: SUCCESS (0.052s)
[205.921055] Starting dynamic subtest: vecs0
[205.961353] Dynamic subtest vecs0: SUCCESS (0.048s)
[205.970284] Starting dynamic subtest: ccs0
[206.016712] Dynamic subtest ccs0: SUCCESS (0.055s)
[206.018280] Subtest submit-early-slice: SUCCESS (0.315s)
[207.065619] [033/133] (815s left) gem_lmem_swapping (massive-random)
[207.102632] Subtest massive-random: SKIP (0.000s)
[207.137231] [034/133] (815s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[207.243731] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[207.246367] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[207.358802] [035/133] (814s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[207.444658] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[208.402308] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (0.958s)
[208.565236] [036/133] (813s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[208.665052] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[208.665903] Starting dynamic subtest: pipe-A
[209.004940] Dynamic subtest pipe-A: SUCCESS (0.340s)
[209.012078] Starting dynamic subtest: pipe-B
[210.413890] Dynamic subtest pipe-B: SUCCESS (1.408s)
[210.420954] Starting dynamic subtest: pipe-C
[211.891777] Dynamic subtest pipe-C: SUCCESS (1.477s)
[211.900170] Starting dynamic subtest: pipe-D
[213.269389] Dynamic subtest pipe-D: SUCCESS (1.377s)
[213.270333] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.605s)
[214.443020] [037/133] (807s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[214.507471] Starting subtest: saturated-hostile-nopreempt
[214.508519] Starting dynamic subtest: rcs0
[214.593877] Dynamic subtest rcs0: SKIP (0.086s)
[214.603089] Starting dynamic subtest: bcs0
[214.608878] Dynamic subtest bcs0: SKIP (0.015s)
[214.614842] Starting dynamic subtest: vcs0
[214.632994] Dynamic subtest vcs0: SKIP (0.023s)
[214.639166] Starting dynamic subtest: vcs1
[214.657611] Dynamic subtest vcs1: SKIP (0.023s)
[214.663674] Starting dynamic subtest: vecs0
[214.672177] Dynamic subtest vecs0: SKIP (0.014s)
[214.680585] Starting dynamic subtest: ccs0
[214.697919] Dynamic subtest ccs0: SKIP (0.025s)
[214.699822] Subtest saturated-hostile-nopreempt: SKIP (0.192s)
[214.780274] [038/133] (807s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[214.876925] Starting subtest: sprite-rotation-90-pos-100-0
[214.878882] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[214.975406] [039/133] (807s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[215.068976] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[215.070647] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[215.187617] [040/133] (807s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[215.267869] Starting subtest: compare-crc-sanitycheck-xr24
[215.268941] Starting dynamic subtest: pipe-A-eDP-1
[215.913496] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.646s)
[215.921503] Starting dynamic subtest: pipe-B-eDP-1
[217.180217] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.265s)
[217.186597] Starting dynamic subtest: pipe-C-eDP-1
[218.381726] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.201s)
[218.389112] Starting dynamic subtest: pipe-D-eDP-1
[219.638362] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.255s)
[219.639163] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.371s)
[220.466794] [041/133] (801s left) kms_tv_load_detect (load-detect)
[220.516946] Subtest load-detect: SKIP (0.000s)
[220.574377] [042/133] (801s left) gem_softpin (safe-alignment)
[220.630441] Starting subtest: safe-alignment
[220.650899] Subtest safe-alignment: SUCCESS (0.022s)
[221.982363] [043/133] (800s left) gem_ctx_sseu (invalid-args)
[222.050943] Subtest invalid-args: SKIP (0.000s)
[222.118131] [044/133] (800s left) gem_exec_reloc (basic-wc-noreloc)
[222.173100] Subtest basic-wc-noreloc: SKIP (0.000s)
[222.257153] [045/133] (800s left) gem_exec_balancer (individual)
[222.313107] Starting subtest: individual
[223.904126] Subtest individual: SUCCESS (1.582s)
[224.257902] [046/133] (798s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[224.351895] Starting subtest: fb-8bpc-vs-panel-8bpc
[224.352854] Starting dynamic subtest: pipe-A-eDP-1
[225.721817] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.368s)
[225.722759] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.369s)
[226.514886] [047/133] (796s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[226.578678] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[226.642794] [048/133] (796s left) kms_fence_pin_leak
[226.820507] [049/133] (795s left) i915_pm_rps (thresholds-idle)
[226.884700] Starting subtest: thresholds-idle
[226.886480] Subtest thresholds-idle: SKIP (0.001s)
[227.010846] [050/133] (795s left) core_setmaster (master-drop-set-root)
[227.079070] Starting subtest: master-drop-set-root
[227.092146] Subtest master-drop-set-root: SUCCESS (0.013s)
[227.131804] [051/133] (795s left) gem_exec_store (pages)
[227.202392] Starting subtest: pages
[227.203412] Starting dynamic subtest: rcs0
[227.329241] Dynamic subtest rcs0: SUCCESS (0.126s)
[227.339384] Starting dynamic subtest: bcs0
[227.412395] Dynamic subtest bcs0: SUCCESS (0.082s)
[227.421304] Starting dynamic subtest: vcs0
[227.512046] Dynamic subtest vcs0: SUCCESS (0.098s)
[227.522165] Starting dynamic subtest: vcs1
[227.599963] Dynamic subtest vcs1: SUCCESS (0.087s)
[227.608853] Starting dynamic subtest: vecs0
[227.673946] Dynamic subtest vecs0: SUCCESS (0.073s)
[227.682998] Starting dynamic subtest: ccs0
[227.750445] Dynamic subtest ccs0: SUCCESS (0.076s)
[227.751381] Subtest pages: SUCCESS (0.548s)
[227.940324] [052/133] (794s left) kms_flip (2x-plain-flip)
[228.038052] Starting subtest: 2x-plain-flip
[228.047262] Subtest 2x-plain-flip: SKIP (0.010s)
[228.164639] [053/133] (794s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[228.256493] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[228.258327] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[228.376328] [054/133] (794s left) syncobj_timeline (invalid-query-illegal-handle)
[228.437407] Starting subtest: invalid-query-illegal-handle
[228.438325] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[228.555179] [055/133] (794s left) kms_psr (pr-primary-page-flip)
[228.653173] Starting subtest: pr-primary-page-flip
[228.654807] Subtest pr-primary-page-flip: SKIP (0.000s)
[228.733414] [056/133] (794s left) kms_fb_coherency (memset-crc)
[228.820731] Starting subtest: memset-crc
[228.821584] Starting dynamic subtest: mmap-offset-wc
[229.185736] Dynamic subtest mmap-offset-wc: SUCCESS (0.365s)
[229.472843] Starting dynamic subtest: mmap-offset-uc
[235.691014] Dynamic subtest mmap-offset-uc: SUCCESS (6.226s)
[235.972362] Subtest memset-crc: SUCCESS (7.151s)
[236.769015] [057/133] (786s left) api_intel_bb (reset-flags)
[236.820486] Starting subtest: reset-flags
[236.827035] Subtest reset-flags: SUCCESS (0.007s)
[236.951192] [058/133] (786s left) gem_ctx_isolation (preservation-reset)
[237.127766] Starting subtest: preservation-reset
[237.129254] Starting dynamic subtest: rcs0
[237.409910] Dynamic subtest rcs0: SUCCESS (0.292s)
[237.419908] Starting dynamic subtest: bcs0
[237.755221] Dynamic subtest bcs0: SUCCESS (0.345s)
[237.764970] Starting dynamic subtest: vcs0
[238.062929] Dynamic subtest vcs0: SUCCESS (0.307s)
[238.072673] Starting dynamic subtest: vcs1
[239.250298] Dynamic subtest vcs1: SUCCESS (1.186s)
[239.260477] Starting dynamic subtest: vecs0
[241.249978] Dynamic subtest vecs0: SUCCESS (1.998s)
[241.257580] Starting dynamic subtest: ccs0
[243.247347] Dynamic subtest ccs0: SUCCESS (1.997s)
[243.248923] Subtest preservation-reset: SUCCESS (6.132s)
[243.417945] [059/133] (779s left) sw_sync (timeline_closed)
[243.450155] Starting subtest: timeline_closed
[243.451259] Subtest timeline_closed: SUCCESS (0.000s)
[243.533922] [060/133] (779s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[243.650708] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[243.653565] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[243.801271] [061/133] (779s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[243.883262] Starting subtest: fbcpsr-rgb565-draw-pwrite
[250.863281] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (6.980s)
[251.011915] [062/133] (772s left) gem_mmap_gtt (basic-small-copy-xy)
[251.065122] Subtest basic-small-copy-XY: SKIP (0.000s)
[251.117676] [063/133] (772s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[251.205253] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[251.206928] Starting dynamic subtest: pipe-A-eDP-1
[251.229083] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[251.236755] Starting dynamic subtest: pipe-B-eDP-1
[251.257994] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[251.265229] Starting dynamic subtest: pipe-C-eDP-1
[251.286140] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[251.292669] Starting dynamic subtest: pipe-D-eDP-1
[251.322176] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[251.323766] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.009s)
[253.441915] [064/133] (769s left) kms_psr (psr-cursor-mmap-gtt)
[253.541260] Starting subtest: psr-cursor-mmap-gtt
[253.542178] Starting dynamic subtest: eDP-1
[255.225054] Dynamic subtest eDP-1: SUCCESS (1.682s)
[255.225894] Subtest psr-cursor-mmap-gtt: SUCCESS (1.683s)
[256.119464] [065/133] (767s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[256.226073] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[256.228313] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[256.341352] [066/133] (766s left) gem_exec_schedule (preempt-queue-chain)
[256.406411] Subtest preempt-queue-chain: SKIP (0.000s)
[256.705691] [067/133] (766s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[256.757873] Starting subtest: invalid-bsd2-flag-on-blt
[256.758841] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[256.873133] [068/133] (766s left) gem_lmem_swapping (random)
[256.905345] Subtest random: SKIP (0.000s)
[256.948135] [069/133] (766s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[257.035094] Starting subtest: y-tiled-64bpp-rotate-90
[257.036871] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[257.153413] [070/133] (766s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[257.236248] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[264.271499] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.036s)
[264.414437] [071/133] (759s left) gem_tiled_blits (normal)
[264.476575] Subtest normal: SKIP (0.000s)
[264.560558] [072/133] (758s left) vgem_basic (create)
[264.605043] Starting subtest: create
[264.606082] Subtest create: SUCCESS (0.000s)
[264.673291] [073/133] (758s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[264.767339] Starting subtest: 4-tiled-64bpp-rotate-0
[266.390951] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.624s)
[266.575163] [074/133] (757s left) sysfs_preempt_timeout (invalid)
[266.630172] Starting subtest: invalid
[266.631054] Starting dynamic subtest: vecs0
[266.631961] Dynamic subtest vecs0: SUCCESS (0.000s)
[266.639362] Starting dynamic subtest: ccs0
[266.640198] Dynamic subtest ccs0: SUCCESS (0.000s)
[266.646950] Starting dynamic subtest: vcs0
[266.647853] Dynamic subtest vcs0: SUCCESS (0.000s)
[266.654781] Starting dynamic subtest: bcs0
[266.655692] Dynamic subtest bcs0: SUCCESS (0.000s)
[266.662576] Starting dynamic subtest: rcs0
[266.663415] Dynamic subtest rcs0: SUCCESS (0.000s)
[266.671220] Starting dynamic subtest: vcs1
[266.672050] Dynamic subtest vcs1: SUCCESS (0.000s)
[266.672885] Subtest invalid: SUCCESS (0.006s)
[266.778730] [075/133] (756s left) kms_scaling_modes (scaling-mode-full-aspect)
[266.873121] Starting subtest: scaling-mode-full-aspect
[266.873891] Starting dynamic subtest: pipe-A-eDP-1
[266.967024] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.094s)
[266.975335] Starting dynamic subtest: pipe-B-eDP-1
[268.139563] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.170s)
[268.152863] Starting dynamic subtest: pipe-C-eDP-1
[269.257125] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.117s)
[269.266680] Starting dynamic subtest: pipe-D-eDP-1
[270.394855] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.134s)
[270.395987] Subtest scaling-mode-full-aspect: SUCCESS (3.523s)
[271.663394] [076/133] (752s left) gem_create (create-ext-cpu-access-sanity-check)
[271.844538] Starting subtest: create-ext-cpu-access-sanity-check
[271.846993] Subtest create-ext-cpu-access-sanity-check: SKIP (0.000s)
[271.917409] [077/133] (751s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[272.003038] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[272.004903] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[272.105313] [078/133] (751s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[272.191116] Starting subtest: bad-pixel-format-yf-tiled-ccs
[272.191981] Starting dynamic subtest: pipe-A-eDP-1
[272.200872] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[272.208534] Starting dynamic subtest: pipe-B-eDP-1
[272.217033] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[272.224281] Starting dynamic subtest: pipe-C-eDP-1
[272.232219] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[272.238882] Starting dynamic subtest: pipe-D-eDP-1
[272.247417] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[272.248954] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.004s)
[274.441350] [079/133] (749s left) gem_exec_parallel (userptr)
[274.523028] Starting subtest: userptr
[274.524101] Starting dynamic subtest: rcs0
[275.984404] Dynamic subtest rcs0: SUCCESS (1.461s)
[275.993376] Starting dynamic subtest: bcs0
[277.434791] Dynamic subtest bcs0: SUCCESS (1.448s)
[277.444711] Starting dynamic subtest: vcs0
[278.969529] Dynamic subtest vcs0: SUCCESS (1.523s)
[278.979312] Starting dynamic subtest: vcs1
[280.926411] Dynamic subtest vcs1: SUCCESS (1.954s)
[280.934596] Starting dynamic subtest: vecs0
[282.935218] Dynamic subtest vecs0: SUCCESS (2.006s)
[282.943189] Starting dynamic subtest: ccs0
[284.409443] Dynamic subtest ccs0: SUCCESS (1.481s)
[284.410778] Subtest userptr: SUCCESS (9.886s)
[284.603032] [080/133] (739s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[284.699389] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[284.700281] Starting dynamic subtest: pipe-A-eDP-1
[284.789160] Dynamic subtest pipe-A-eDP-1: SKIP (0.089s)
[284.797152] Starting dynamic subtest: pipe-B-eDP-1
[285.911500] Dynamic subtest pipe-B-eDP-1: SKIP (1.121s)
[285.913160] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.212s)
[287.104703] [081/133] (736s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[287.201263] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[287.202125] Starting dynamic subtest: pipe-A
[287.265966] Dynamic subtest pipe-A: SUCCESS (0.065s)
[287.274995] Starting dynamic subtest: pipe-B
[288.428458] Dynamic subtest pipe-B: SUCCESS (1.161s)
[288.438042] Starting dynamic subtest: pipe-C
[289.539813] Dynamic subtest pipe-C: SUCCESS (1.109s)
[289.547062] Starting dynamic subtest: pipe-D
[290.667307] Dynamic subtest pipe-D: SUCCESS (1.127s)
[290.668232] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.467s)
[291.843211] [082/133] (732s left) kms_chamelium_frames (hdmi-crc-single)
[292.217832] Subtest hdmi-crc-single: SKIP (0.000s)
[293.033807] [083/133] (730s left) gem_exec_fence (syncobj-channel)
[293.503809] Starting subtest: syncobj-channel
[294.532357] Subtest syncobj-channel: SUCCESS (1.019s)
[295.027675] [084/133] (728s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[295.114387] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[295.116099] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[296.206123] [085/133] (727s left) syncobj_timeline (multi-wait-available-submitted)
[296.251886] Starting subtest: multi-wait-available-submitted
[296.252853] Subtest multi-wait-available-submitted: SUCCESS (0.000s)
[296.361552] [086/133] (727s left) gem_exec_flush (basic-wb-rw-before-default)
[296.429446] Starting subtest: basic-wb-rw-before-default
[301.882237] Subtest basic-wb-rw-before-default: SUCCESS (5.452s)
[302.072374] [087/133] (721s left) i915_drm_fdinfo (most-busy-idle-check-all)
[302.103288] Starting subtest: most-busy-idle-check-all
[302.104326] Starting dynamic subtest: rcs0
[302.108686] Dynamic subtest rcs0: SKIP (0.004s)
[302.117960] Starting dynamic subtest: bcs0
[302.119752] Dynamic subtest bcs0: SKIP (0.000s)
[302.128844] Starting dynamic subtest: vcs0
[302.131359] Dynamic subtest vcs0: SKIP (0.000s)
[302.143145] Starting dynamic subtest: vcs1
[302.145032] Dynamic subtest vcs1: SKIP (0.000s)
[302.156078] Starting dynamic subtest: vecs0
[302.157887] Dynamic subtest vecs0: SKIP (0.000s)
[302.165142] Starting dynamic subtest: ccs0
[302.166925] Dynamic subtest ccs0: SKIP (0.000s)
[302.168785] Subtest most-busy-idle-check-all: SKIP (0.010s)
[302.199700] [088/133] (721s left) kms_pm_rpm (system-suspend-modeset)
[304.019555] Starting subtest: system-suspend-modeset
[324.623844] Subtest system-suspend-modeset: SUCCESS (5.158s)
[330.055711] [089/133] (699s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[330.111533] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[330.113423] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[330.304293] [090/133] (698s left) kms_sequence (get-busy)
[330.385274] Starting subtest: get-busy
[330.386282] Starting dynamic subtest: pipe-A-eDP-1
[332.323309] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.935s)
[332.333056] Starting dynamic subtest: pipe-B-eDP-1
[334.893514] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.566s)
[334.901591] Starting dynamic subtest: pipe-C-eDP-1
[337.491391] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.595s)
[337.500723] Starting dynamic subtest: pipe-D-eDP-1
[340.020131] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.525s)
[340.021031] Subtest get-busy: SUCCESS (9.627s)
[340.839116] [091/133] (688s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[340.941050] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[340.942986] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[341.050199] [092/133] (688s left) kms_psr (fbc-psr-cursor-mmap-cpu)
[341.139028] Starting subtest: fbc-psr-cursor-mmap-cpu
[341.139889] Starting dynamic subtest: eDP-1
[341.141727] Dynamic subtest eDP-1: SKIP (0.000s)
[341.143513] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.001s)
[341.220840] [093/133] (688s left) kms_rotation_crc (exhaust-fences)
[341.313384] Starting subtest: exhaust-fences
[341.315138] Subtest exhaust-fences: SKIP (0.000s)
[341.405912] [094/133] (687s left) kms_flip (absolute-wf_vblank)
[341.500955] Starting subtest: absolute-wf_vblank
[341.503204] Starting dynamic subtest: A-eDP1
[350.225356] Dynamic subtest A-eDP1: SUCCESS (8.693s)
[350.233359] Starting dynamic subtest: B-eDP1
[358.963755] Dynamic subtest B-eDP1: SUCCESS (8.734s)
[358.974446] Starting dynamic subtest: C-eDP1
[367.697744] Dynamic subtest C-eDP1: SUCCESS (8.720s)
[367.708276] Starting dynamic subtest: D-eDP1
[376.421881] Dynamic subtest D-eDP1: SUCCESS (8.723s)
[376.422977] Subtest absolute-wf_vblank: SUCCESS (34.878s)
[377.604981] [095/133] (651s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[377.709156] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[385.100340] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.390s)
[385.290042] [096/133] (644s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[385.593064] Starting subtest: cursor-rapid-movement-max-size
[385.596459] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[385.734410] [097/133] (643s left) kms_properties (crtc-properties-atomic)
[385.832141] Starting subtest: crtc-properties-atomic
[385.833123] Starting dynamic subtest: pipe-A-eDP-1
[386.274008] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.442s)
[386.285625] Starting dynamic subtest: pipe-B-eDP-1
[387.476022] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.200s)
[387.484037] Starting dynamic subtest: pipe-C-eDP-1
[388.599264] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.122s)
[388.608770] Starting dynamic subtest: pipe-D-eDP-1
[389.731972] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.131s)
[389.732757] Subtest crtc-properties-atomic: SUCCESS (3.902s)
[390.540902] [098/133] (638s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[390.646377] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[390.647288] Starting dynamic subtest: pipe-A-default-mode
[391.788344] Dynamic subtest pipe-A-default-mode: SKIP (1.140s)
[391.790333] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.141s)
[392.005851] [099/133] (637s left) api_intel_allocator (simple-allocator)
[392.071606] Starting subtest: simple-allocator
[392.072621] Starting dynamic subtest: basic
[392.075266] Dynamic subtest basic: SUCCESS (0.003s)
[392.086246] Starting dynamic subtest: parallel-one
[392.264800] Dynamic subtest parallel-one: SUCCESS (0.181s)
[392.273388] Starting dynamic subtest: print
[392.274547] Dynamic subtest print: SUCCESS (0.000s)
[392.282155] Starting dynamic subtest: reuse
[392.282960] Dynamic subtest reuse: SUCCESS (0.000s)
[392.290473] Starting dynamic subtest: reserve
[392.291353] Dynamic subtest reserve: SUCCESS (0.000s)
[392.298825] Starting dynamic subtest: fork-reopen-allocator
[392.299712] Dynamic subtest fork-reopen-allocator: SUCCESS (0.013s)
[392.300577] Subtest simple-allocator: SUCCESS (0.202s)
[392.410701] [100/133] (637s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier)
[392.515989] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier
[392.529008] Subtest pixel-format-4-tiled-bmg-ccs-modifier: SKIP (0.000s)
[392.608341] [101/133] (636s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[392.710169] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[392.711728] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[392.834361] [102/133] (636s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[392.933206] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[392.934790] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[393.068853] [103/133] (636s left) drm_read (empty-block)
[393.207423] Starting subtest: empty-block
[394.208137] Subtest empty-block: SUCCESS (1.000s)
[394.359959] [104/133] (635s left) gem_mmap_gtt (basic-write-read-distinct)
[394.416894] Subtest basic-write-read-distinct: SKIP (0.000s)
[394.466367] [105/133] (635s left) kms_setmode (invalid-clone-single-crtc)
[394.527958] Starting subtest: invalid-clone-single-crtc
[394.530745] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[394.646096] [106/133] (635s left) gem_exec_capture (capture-invisible)
[394.707848] Starting subtest: capture-invisible
[394.708823] Starting dynamic subtest: smem0
[394.710600] Dynamic subtest smem0: SKIP (0.000s)
[394.712373] Subtest capture-invisible: SKIP (0.001s)
[394.827065] [107/133] (634s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[394.876738] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[394.877729] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[395.019555] [108/133] (634s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[395.119696] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[396.076717] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.957s)
[396.227441] [109/133] (633s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[396.330088] Starting subtest: fbc-rgb565-draw-mmap-cpu
[400.416863] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (4.086s)
[401.561963] [110/133] (628s left) i915_pm_freq_api (freq-suspend)
[401.628614] Starting subtest: freq-suspend
[401.629606] Starting dynamic subtest: gt0
[418.100397] Dynamic subtest gt0: SUCCESS (2.345s)
[418.117444] Starting dynamic subtest: gt1
[435.078647] Dynamic subtest gt1: SUCCESS (1.594s)
[435.079570] Subtest freq-suspend: SUCCESS (3.943s)
[443.235558] [111/133] (594s left) kms_cursor_crc (cursor-offscreen-64x64)
[443.423983] Starting subtest: cursor-offscreen-64x64
[443.427233] Starting dynamic subtest: pipe-A-eDP-1
[445.364115] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.934s)
[445.393329] Starting dynamic subtest: pipe-D-eDP-1
[447.957614] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.568s)
[447.958503] Subtest cursor-offscreen-64x64: SUCCESS (4.528s)
[448.824194] [112/133] (589s left) kms_color (ctm-0-25)
[448.928408] Starting subtest: ctm-0-25
[448.929322] Starting dynamic subtest: pipe-A-eDP-1
[452.439542] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.508s)
[452.447549] Starting dynamic subtest: pipe-B-eDP-1
[456.543465] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.096s)
[456.553233] Starting dynamic subtest: pipe-C-eDP-1
[460.498241] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.957s)
[460.506533] Starting dynamic subtest: pipe-D-eDP-1
[464.504417] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.003s)
[464.505316] Subtest ctm-0-25: SUCCESS (15.567s)
[465.332395] [113/133] (572s left) drm_read (fault-buffer)
[465.480776] Starting subtest: fault-buffer
[465.481803] Subtest fault-buffer: SUCCESS (0.001s)
[465.624706] [114/133] (572s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[465.726379] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[465.727414] Starting dynamic subtest: pipe-A-eDP-1
[465.735860] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[465.744588] Starting dynamic subtest: pipe-B-eDP-1
[465.753127] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[465.761540] Starting dynamic subtest: pipe-C-eDP-1
[465.769773] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[465.777546] Starting dynamic subtest: pipe-D-eDP-1
[465.786003] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[465.787715] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.004s)
[467.981655] [115/133] (570s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[468.088442] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[474.960206] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.870s)
[475.115639] [116/133] (563s left) kms_chamelium_hpd (common-hpd-after-suspend)
[475.494293] Subtest common-hpd-after-suspend: SKIP (0.000s)
[476.291598] [117/133] (561s left) kms_content_protection (uevent)
[476.438241] Starting subtest: uevent
[476.439942] Subtest uevent: SKIP (0.000s)
[476.566150] [118/133] (561s left) kms_pm_lpsp (kms-lpsp)
[477.665145] Starting subtest: kms-lpsp
[477.666038] Starting dynamic subtest: pipe-A-eDP-1
[477.815308] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.150s)
[478.110998] Subtest kms-lpsp: SUCCESS (0.446s)
[478.955462] [119/133] (559s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[479.049669] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[479.051414] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[479.169852] [120/133] (559s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[479.284453] Starting subtest: flip-vs-cursor-varying-size
[487.983862] Subtest flip-vs-cursor-varying-size: SUCCESS (8.698s)
[488.807399] [121/133] (549s left) perf_pmu (busy-accuracy-50)
[488.842963] Starting subtest: busy-accuracy-50
[488.843949] Starting dynamic subtest: rcs0
[490.380577] Dynamic subtest rcs0: SUCCESS (1.532s)
[490.391471] Starting dynamic subtest: bcs0
[491.926013] Dynamic subtest bcs0: SUCCESS (1.542s)
[491.933992] Starting dynamic subtest: vcs0
[493.470125] Dynamic subtest vcs0: SUCCESS (1.541s)
[493.479897] Starting dynamic subtest: vcs1
[495.009366] Dynamic subtest vcs1: SUCCESS (1.537s)
[495.019454] Starting dynamic subtest: vecs0
[496.547447] Dynamic subtest vecs0: SUCCESS (1.536s)
[496.558123] Starting dynamic subtest: ccs0
[498.097152] Dynamic subtest ccs0: SUCCESS (1.546s)
[498.098287] Subtest busy-accuracy-50: SUCCESS (9.248s)
[498.231575] [122/133] (540s left) prime_vgem (wait)
[498.306234] Starting subtest: wait
[498.307218] Starting dynamic subtest: rcs0
[498.384116] Dynamic subtest rcs0: SUCCESS (0.078s)
[498.392491] Starting dynamic subtest: bcs0
[498.483365] Dynamic subtest bcs0: SUCCESS (0.098s)
[498.491766] Starting dynamic subtest: vcs0
[498.529541] Dynamic subtest vcs0: SUCCESS (0.045s)
[498.538856] Starting dynamic subtest: vcs1
[498.576667] Dynamic subtest vcs1: SUCCESS (0.045s)
[498.585104] Starting dynamic subtest: vecs0
[498.622970] Dynamic subtest vecs0: SUCCESS (0.045s)
[498.631159] Starting dynamic subtest: ccs0
[498.673288] Dynamic subtest ccs0: SUCCESS (0.049s)
[498.674033] Subtest wait: SUCCESS (0.367s)
[498.820462] [123/133] (539s left) kms_psr (fbc-pr-basic)
[498.921033] Starting subtest: fbc-pr-basic
[498.922710] Subtest fbc-pr-basic: SKIP (0.000s)
[498.999668] [124/133] (539s left) gem_userptr_blits (sync-overlap)
[499.067182] Starting subtest: sync-overlap
[499.068262] Subtest sync-overlap: SUCCESS (0.000s)
[499.213508] [125/133] (539s left) perf (oa-exponents)
[499.351328] Starting subtest: oa-exponents
[499.352102] Starting dynamic subtest: 0-rcs0
[501.130586] Dynamic subtest 0-rcs0: SUCCESS (1.769s)
[501.139494] Starting dynamic subtest: 1-vecs0
[502.960405] Dynamic subtest 1-vecs0: SUCCESS (1.828s)
[502.961550] Subtest oa-exponents: SUCCESS (3.599s)
[502.994736] [126/133] (535s left) vgem_basic (dmabuf-export)
[503.043256] Starting subtest: dmabuf-export
[503.086813] Subtest dmabuf-export: SUCCESS (0.044s)
[503.209983] [127/133] (535s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[503.317172] Starting subtest: yf-tiled-64bpp-rotate-90
[503.318934] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[503.430078] [128/133] (535s left) kms_hdr (invalid-metadata-sizes)
[503.515289] Starting subtest: invalid-metadata-sizes
[503.517931] Subtest invalid-metadata-sizes: SKIP (0.000s)
[503.595562] [129/133] (535s left) kms_joiner (invalid-modeset-ultra-joiner)
[503.686963] Starting subtest: invalid-modeset-ultra-joiner
[503.688934] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[503.764064] [130/133] (534s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[503.816499] Starting subtest: rel-constants-invalid-rel-gen5
[503.817526] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[503.940863] [131/133] (534s left) perf_pmu (busy-start)
[503.976434] Starting subtest: busy-start
[503.977405] Starting dynamic subtest: rcs0
[506.529501] Dynamic subtest rcs0: SUCCESS (2.551s)
[506.542499] Starting dynamic subtest: bcs0
[509.092944] Dynamic subtest bcs0: SUCCESS (2.547s)
[509.103829] Starting dynamic subtest: vcs0
[512.882280] Dynamic subtest vcs0: SUCCESS (3.790s)
[512.893087] Starting dynamic subtest: vcs1
[516.850497] Dynamic subtest vcs1: SUCCESS (3.965s)
[516.861517] Starting dynamic subtest: vecs0
[520.882404] Dynamic subtest vecs0: SUCCESS (4.029s)
[520.893310] Starting dynamic subtest: ccs0
[523.436388] Dynamic subtest ccs0: SUCCESS (2.548s)
[523.437646] Subtest busy-start: SUCCESS (19.443s)
[523.540450] [132/133] (515s left) syncobj_timeline (wait-all-delayed-signal)
[523.602043] Starting subtest: wait-all-delayed-signal
[523.705084] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[523.792444] [133/133] (514s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[523.887874] Starting subtest: psr-2p-primscrn-cur-indfb-move
[523.889629] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[524.011004] 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.