[56.518989] Initializing watchdogs
[56.519044]   /dev/watchdog0
[56.533124] [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]
[56.537307] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.539406] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.542834] [001/133] (960s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[56.687921] Starting subtest: flip-vs-cursor-atomic
[63.662824] Subtest flip-vs-cursor-atomic: SUCCESS (7.011s)
[64.500207] [002/133] (952s left) gem_pwrite (basic-self)
[64.568622] Subtest basic-self: SKIP (0.000s)
[64.633346] [003/133] (952s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[64.728014] Starting subtest: fbc-pr-sprite-mmap-gtt
[64.732202] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[64.805994] [004/133] (952s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[64.894255] Starting subtest: psr-rgb101010-draw-render
[72.340856] Subtest psr-rgb101010-draw-render: SUCCESS (7.463s)
[72.484943] [005/133] (944s left) i915_pm_rc6_residency (rc6-accuracy)
[72.542767] Starting subtest: rc6-accuracy
[72.544686] Starting dynamic subtest: gt0
[75.715082] Dynamic subtest gt0: SUCCESS (3.171s)
[75.723633] Starting dynamic subtest: gt1
[78.886575] Dynamic subtest gt1: SUCCESS (3.170s)
[78.889052] Subtest rc6-accuracy: SUCCESS (6.346s)
[78.969154] [006/133] (938s left) gem_userptr_blits (forbidden-operations)
[79.039709] Starting subtest: forbidden-operations
[79.044118] Subtest forbidden-operations: SKIP (0.000s)
[79.191653] [007/133] (938s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[79.310877] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[79.315104] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[79.427205] [008/133] (937s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[79.527385] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[83.766562] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.244s)
[84.899386] [009/133] (932s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[84.961189] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[85.066655] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.103s)
[85.148344] [010/133] (932s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[85.276530] Starting subtest: cursorA-vs-flipA-atomic
[96.398157] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.124s)
[97.220820] [011/133] (920s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[97.317382] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[97.319670] Starting dynamic subtest: pipe-A-eDP-1
[97.346794] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[97.356476] Starting dynamic subtest: pipe-B-eDP-1
[97.380675] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[97.387073] Starting dynamic subtest: pipe-C-eDP-1
[97.410724] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[97.417521] Starting dynamic subtest: pipe-D-eDP-1
[97.446131] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[97.450321] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[99.514620] [012/133] (917s left) kms_flip (2x-flip-vs-wf_vblank)
[99.612638] Starting subtest: 2x-flip-vs-wf_vblank
[99.621136] Subtest 2x-flip-vs-wf_vblank: SKIP (0.010s)
[99.772047] [013/133] (917s left) kms_addfb_basic (small-bo)
[99.870795] Starting subtest: small-bo
[99.872681] Subtest small-bo: SUCCESS (0.000s)
[99.998069] [014/133] (917s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[100.091972] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[100.094261] Starting dynamic subtest: pipe-A-default-mode
[102.836634] Dynamic subtest pipe-A-default-mode: SUCCESS (2.744s)
[102.838934] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.745s)
[103.702235] [015/133] (913s left) gem_madvise (dontneed-before-mmap)
[103.736619] Starting subtest: dontneed-before-mmap
[103.764585] Subtest dontneed-before-mmap: SUCCESS (0.027s)
[103.892499] [016/133] (913s left) kms_atomic (plane-primary-legacy)
[103.983041] Starting subtest: plane-primary-legacy
[103.985238] Starting dynamic subtest: pipe-A-eDP-1
[104.438643] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.455s)
[104.441085] Subtest plane-primary-legacy: SUCCESS (0.456s)
[105.245767] [017/133] (912s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[105.347751] Starting subtest: blocking-absolute-wf_vblank-interruptible
[105.351890] Starting dynamic subtest: A-eDP1
[114.087703] Dynamic subtest A-eDP1: SUCCESS (8.738s)
[114.097970] Starting dynamic subtest: B-eDP1
[122.814911] Dynamic subtest B-eDP1: SUCCESS (8.727s)
[122.824652] Starting dynamic subtest: C-eDP1
[131.529402] Dynamic subtest C-eDP1: SUCCESS (8.714s)
[131.537755] Starting dynamic subtest: D-eDP1
[140.261658] Dynamic subtest D-eDP1: SUCCESS (8.732s)
[140.263990] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.918s)
[141.487265] [018/133] (876s left) kms_cursor_edge_walk (64x64-top-bottom)
[141.581184] Starting subtest: 64x64-top-bottom
[141.583510] Starting dynamic subtest: pipe-A-eDP-1
[145.040580] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.458s)
[145.049171] Starting dynamic subtest: pipe-D-eDP-1
[148.157620] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.115s)
[148.159729] Subtest 64x64-top-bottom: SUCCESS (6.575s)
[148.974107] [019/133] (868s left) kms_addfb_basic (invalid-get-prop-any)
[149.036797] Starting subtest: invalid-get-prop-any
[149.038730] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[149.176464] [020/133] (868s left) gem_mmap_gtt (fault-concurrent-y)
[149.237140] Subtest fault-concurrent-Y: SKIP (0.000s)
[149.298018] [021/133] (868s left) gem_busy (semaphore)
[149.495762] Subtest semaphore: SKIP (0.000s)
[149.749723] [022/133] (868s left) kms_vblank (query-forked-busy-hang)
[149.846053] Starting subtest: query-forked-busy-hang
[149.848050] Starting dynamic subtest: pipe-A-eDP-1
[176.661440] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.809s)
[176.675419] Starting dynamic subtest: pipe-D-eDP-1
[191.648424] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.983s)
[191.650482] Subtest query-forked-busy-hang: SUCCESS (41.797s)
[192.539618] [023/133] (825s left) kms_prop_blob (invalid-set-prop)
[192.599088] Starting subtest: invalid-set-prop
[192.601432] Subtest invalid-set-prop: SUCCESS (0.000s)
[192.718221] [024/133] (825s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[192.808248] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[192.821338] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[192.901625] [025/133] (825s left) kms_lease (multimaster-lease)
[192.990733] Starting subtest: multimaster-lease
[192.992670] Subtest multimaster-lease: SUCCESS (0.004s)
[193.126670] [026/133] (824s left) kms_addfb_basic (invalid-smem-bo-on-discrete)
[193.198086] Starting subtest: invalid-smem-bo-on-discrete
[193.202421] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s)
[193.348782] [027/133] (824s left) gem_userptr_blits (dmabuf-unsync)
[193.420930] Subtest dmabuf-unsync: SKIP (0.000s)
[193.569370] [028/133] (824s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[193.682381] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[194.650504] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (0.968s)
[194.794435] [029/133] (823s left) gem_ringfill (legacy-basic)
[200.922179] Starting subtest: legacy-basic
[200.924693] Starting dynamic subtest: default
[200.990947] Dynamic subtest default: SUCCESS (0.070s)
[201.001786] Starting dynamic subtest: render
[201.034092] Dynamic subtest render: SUCCESS (0.042s)
[201.044528] Starting dynamic subtest: bsd
[201.077248] Dynamic subtest bsd: SUCCESS (0.042s)
[201.086421] Starting dynamic subtest: bsd1
[201.120075] Dynamic subtest bsd1: SUCCESS (0.041s)
[201.129698] Starting dynamic subtest: bsd2
[201.160078] Dynamic subtest bsd2: SUCCESS (0.038s)
[201.169066] Starting dynamic subtest: blt
[201.204829] Dynamic subtest blt: SUCCESS (0.043s)
[201.214273] Starting dynamic subtest: vebox
[201.247128] Dynamic subtest vebox: SUCCESS (0.041s)
[201.249593] Subtest legacy-basic: SUCCESS (0.328s)
[201.331765] [FACT gem_ringfill (legacy-basic)] new: kernel.kmod_is_loaded.vgem: true
[201.334769] [030/133] (816s left) gem_vm_create (invalid-create)
[201.399416] Starting subtest: invalid-create
[201.401759] Subtest invalid-create: SUCCESS (0.002s)
[201.534077] [031/133] (816s left) gen9_exec_parse (batch-invalid-length)
[201.607396] Subtest batch-invalid-length: SKIP (0.000s)
[201.696957] [032/133] (816s left) gem_exec_schedule (submit-early-slice)
[201.774356] Starting subtest: submit-early-slice
[201.776703] Starting dynamic subtest: rcs0
[201.833309] Dynamic subtest rcs0: SUCCESS (0.066s)
[201.841712] Starting dynamic subtest: bcs0
[201.882901] Dynamic subtest bcs0: SUCCESS (0.049s)
[201.892749] Starting dynamic subtest: vcs0
[201.947708] Dynamic subtest vcs0: SUCCESS (0.065s)
[201.958964] Starting dynamic subtest: vcs1
[202.000665] Dynamic subtest vcs1: SUCCESS (0.053s)
[202.011052] Starting dynamic subtest: vecs0
[202.045384] Dynamic subtest vecs0: SUCCESS (0.045s)
[202.054320] Starting dynamic subtest: ccs0
[202.097305] Dynamic subtest ccs0: SUCCESS (0.052s)
[202.099453] Subtest submit-early-slice: SUCCESS (0.331s)
[203.037300] [033/133] (815s left) gem_lmem_swapping (massive-random)
[203.085485] Subtest massive-random: SKIP (0.000s)
[203.127986] [034/133] (815s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[203.233513] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[203.237605] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[203.360083] [035/133] (814s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[203.466075] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip
[204.466207] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.000s)
[204.597692] [036/133] (813s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[204.701289] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[204.703340] Starting dynamic subtest: pipe-A
[205.049171] Dynamic subtest pipe-A: SUCCESS (0.351s)
[205.056967] Starting dynamic subtest: pipe-B
[206.402227] Dynamic subtest pipe-B: SUCCESS (1.352s)
[206.410862] Starting dynamic subtest: pipe-C
[207.873296] Dynamic subtest pipe-C: SUCCESS (1.470s)
[207.883364] Starting dynamic subtest: pipe-D
[209.259572] Dynamic subtest pipe-D: SUCCESS (1.386s)
[209.261889] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.561s)
[210.447220] [037/133] (807s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[210.513072] Starting subtest: saturated-hostile-nopreempt
[210.515371] Starting dynamic subtest: rcs0
[210.609685] Dynamic subtest rcs0: SKIP (0.094s)
[210.620226] Starting dynamic subtest: bcs0
[210.636409] Dynamic subtest bcs0: SKIP (0.024s)
[210.645721] Starting dynamic subtest: vcs0
[210.656694] Dynamic subtest vcs0: SKIP (0.020s)
[210.664615] Starting dynamic subtest: vcs1
[210.678485] Dynamic subtest vcs1: SKIP (0.021s)
[210.685519] Starting dynamic subtest: vecs0
[210.699294] Dynamic subtest vecs0: SKIP (0.020s)
[210.706155] Starting dynamic subtest: ccs0
[210.714276] Dynamic subtest ccs0: SKIP (0.014s)
[210.718605] Subtest saturated-hostile-nopreempt: SKIP (0.200s)
[210.798283] [038/133] (807s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[210.899522] Starting subtest: sprite-rotation-90-pos-100-0
[210.903796] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[210.980748] [039/133] (807s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[211.086016] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[211.090476] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[211.207596] [040/133] (807s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[211.308314] Starting subtest: compare-crc-sanitycheck-xr24
[211.310632] Starting dynamic subtest: pipe-A-eDP-1
[211.935847] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.624s)
[211.945185] Starting dynamic subtest: pipe-B-eDP-1
[213.190346] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.253s)
[213.199152] Starting dynamic subtest: pipe-C-eDP-1
[214.369719] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.181s)
[214.380806] Starting dynamic subtest: pipe-D-eDP-1
[215.615336] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.242s)
[215.617669] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.304s)
[216.467811] [041/133] (802s left) kms_tv_load_detect (load-detect)
[216.530066] Subtest load-detect: SKIP (0.000s)
[216.591898] [042/133] (802s left) gem_softpin (safe-alignment)
[216.658769] Starting subtest: safe-alignment
[216.692893] Subtest safe-alignment: SUCCESS (0.034s)
[217.992541] [043/133] (800s left) gem_ctx_sseu (invalid-args)
[218.054910] Subtest invalid-args: SKIP (0.000s)
[218.134124] [044/133] (800s left) gem_exec_reloc (basic-wc-noreloc)
[218.193069] Subtest basic-wc-noreloc: SKIP (0.000s)
[218.274967] [045/133] (800s left) gem_exec_balancer (individual)
[218.341575] Starting subtest: individual
[219.909556] Subtest individual: SUCCESS (1.566s)
[220.258326] [046/133] (798s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[220.352990] Starting subtest: fb-8bpc-vs-panel-8bpc
[220.355317] Starting dynamic subtest: pipe-A-eDP-1
[221.750043] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.396s)
[221.752183] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.397s)
[222.630742] [047/133] (796s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[222.692290] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[222.765690] [048/133] (796s left) kms_fence_pin_leak
[222.927871] [049/133] (795s left) i915_pm_rps (thresholds-idle)
[222.988734] Starting subtest: thresholds-idle
[222.993319] Subtest thresholds-idle: SKIP (0.001s)
[223.113628] [050/133] (795s left) core_setmaster (master-drop-set-root)
[223.193325] Starting subtest: master-drop-set-root
[223.209480] Subtest master-drop-set-root: SUCCESS (0.013s)
[223.256655] [051/133] (795s left) gem_exec_store (pages)
[223.312921] Starting subtest: pages
[223.315154] Starting dynamic subtest: rcs0
[223.422853] Dynamic subtest rcs0: SUCCESS (0.112s)
[223.432214] Starting dynamic subtest: bcs0
[223.502463] Dynamic subtest bcs0: SUCCESS (0.078s)
[223.511628] Starting dynamic subtest: vcs0
[223.587558] Dynamic subtest vcs0: SUCCESS (0.084s)
[223.596852] Starting dynamic subtest: vcs1
[223.654430] Dynamic subtest vcs1: SUCCESS (0.066s)
[223.664614] Starting dynamic subtest: vecs0
[223.724784] Dynamic subtest vecs0: SUCCESS (0.069s)
[223.733971] Starting dynamic subtest: ccs0
[223.796124] Dynamic subtest ccs0: SUCCESS (0.070s)
[223.798117] Subtest pages: SUCCESS (0.486s)
[224.036724] [052/133] (795s left) kms_flip (2x-plain-flip)
[224.154138] Starting subtest: 2x-plain-flip
[224.163522] Subtest 2x-plain-flip: SKIP (0.011s)
[224.306867] [053/133] (794s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[224.427370] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[224.431230] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[224.548577] [054/133] (794s left) syncobj_timeline (invalid-query-illegal-handle)
[224.619446] Starting subtest: invalid-query-illegal-handle
[224.621314] Subtest invalid-query-illegal-handle: SUCCESS (0.000s)
[224.754181] [055/133] (794s left) kms_psr (pr-primary-page-flip)
[224.864862] Starting subtest: pr-primary-page-flip
[224.868685] Subtest pr-primary-page-flip: SKIP (0.000s)
[224.962757] [056/133] (794s left) kms_fb_coherency (memset-crc)
[225.066698] Starting subtest: memset-crc
[225.068897] Starting dynamic subtest: mmap-offset-wc
[225.423090] Dynamic subtest mmap-offset-wc: SUCCESS (0.356s)
[225.731098] Starting dynamic subtest: mmap-offset-uc
[231.813737] Dynamic subtest mmap-offset-uc: SUCCESS (6.090s)
[232.104656] Subtest memset-crc: SUCCESS (7.036s)
[232.991975] [057/133] (786s left) api_intel_bb (reset-flags)
[233.061393] Starting subtest: reset-flags
[233.072665] Subtest reset-flags: SUCCESS (0.012s)
[233.236343] [058/133] (786s left) gem_ctx_isolation (preservation-reset)
[233.420695] Starting subtest: preservation-reset
[233.423126] Starting dynamic subtest: rcs0
[233.695976] Dynamic subtest rcs0: SUCCESS (0.279s)
[233.707557] Starting dynamic subtest: bcs0
[234.040315] Dynamic subtest bcs0: SUCCESS (0.343s)
[234.050786] Starting dynamic subtest: vcs0
[234.369108] Dynamic subtest vcs0: SUCCESS (0.328s)
[234.379692] Starting dynamic subtest: vcs1
[236.238225] Dynamic subtest vcs1: SUCCESS (1.868s)
[236.249018] Starting dynamic subtest: vecs0
[238.269037] Dynamic subtest vecs0: SUCCESS (2.030s)
[238.279226] Starting dynamic subtest: ccs0
[240.231669] Dynamic subtest ccs0: SUCCESS (1.962s)
[240.234279] Subtest preservation-reset: SUCCESS (6.816s)
[240.404725] [059/133] (778s left) sw_sync (timeline_closed)
[240.439065] Starting subtest: timeline_closed
[240.441417] Subtest timeline_closed: SUCCESS (0.000s)
[240.510933] [060/133] (778s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[240.639103] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[240.643275] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[240.795183] [061/133] (778s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-pwrite)
[240.905107] Starting subtest: fbcpsr-rgb565-draw-pwrite
[247.805432] Subtest fbcpsr-rgb565-draw-pwrite: SUCCESS (6.903s)
[247.960244] [062/133] (771s left) gem_mmap_gtt (basic-small-copy-xy)
[248.028099] Subtest basic-small-copy-XY: SKIP (0.000s)
[248.095196] [063/133] (771s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[248.198702] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[248.200963] Starting dynamic subtest: pipe-A-eDP-1
[248.257648] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[248.267726] Starting dynamic subtest: pipe-B-eDP-1
[248.326270] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[248.335331] Starting dynamic subtest: pipe-C-eDP-1
[248.392303] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[248.401814] Starting dynamic subtest: pipe-D-eDP-1
[248.459084] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[248.463284] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.008s)
[250.374474] [064/133] (769s left) kms_psr (psr-cursor-mmap-gtt)
[250.476345] Starting subtest: psr-cursor-mmap-gtt
[250.478716] Starting dynamic subtest: eDP-1
[252.167667] Dynamic subtest eDP-1: SUCCESS (1.691s)
[252.169976] Subtest psr-cursor-mmap-gtt: SUCCESS (1.692s)
[253.041178] [065/133] (766s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[253.146394] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[253.150669] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[253.266405] [066/133] (766s left) gem_exec_schedule (preempt-queue-chain)
[253.341078] Subtest preempt-queue-chain: SKIP (0.000s)
[253.633143] [067/133] (766s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[253.703962] Starting subtest: invalid-bsd2-flag-on-blt
[253.706515] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[253.822909] [068/133] (765s left) gem_lmem_swapping (random)
[253.866542] Subtest random: SKIP (0.000s)
[253.912510] [069/133] (765s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[254.014238] Starting subtest: y-tiled-64bpp-rotate-90
[254.018163] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[254.140252] [070/133] (765s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[254.248087] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[261.322994] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.078s)
[261.447438] [071/133] (758s left) gem_tiled_blits (normal)
[261.517187] Subtest normal: SKIP (0.000s)
[261.604374] [072/133] (758s left) vgem_basic (create)
[261.650178] Starting subtest: create
[261.652412] Subtest create: SUCCESS (0.000s)
[261.717057] [073/133] (758s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[261.827555] Starting subtest: 4-tiled-64bpp-rotate-0
[263.438121] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.612s)
[263.632656] [074/133] (756s left) sysfs_preempt_timeout (invalid)
[263.687925] Starting subtest: invalid
[263.690168] Starting dynamic subtest: vecs0
[263.692427] Dynamic subtest vecs0: SUCCESS (0.000s)
[263.700973] Starting dynamic subtest: ccs0
[263.702900] Dynamic subtest ccs0: SUCCESS (0.000s)
[263.710853] Starting dynamic subtest: vcs0
[263.713060] Dynamic subtest vcs0: SUCCESS (0.000s)
[263.720702] Starting dynamic subtest: bcs0
[263.722593] Dynamic subtest bcs0: SUCCESS (0.000s)
[263.729883] Starting dynamic subtest: rcs0
[263.731808] Dynamic subtest rcs0: SUCCESS (0.000s)
[263.739084] Starting dynamic subtest: vcs1
[263.740920] Dynamic subtest vcs1: SUCCESS (0.000s)
[263.742829] Subtest invalid: SUCCESS (0.005s)
[263.787082] [075/133] (756s left) kms_scaling_modes (scaling-mode-full-aspect)
[263.885262] Starting subtest: scaling-mode-full-aspect
[263.887224] Starting dynamic subtest: pipe-A-eDP-1
[263.999325] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.116s)
[264.013097] Starting dynamic subtest: pipe-B-eDP-1
[265.205598] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.205s)
[265.217065] Starting dynamic subtest: pipe-C-eDP-1
[266.324035] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.115s)
[266.337115] Starting dynamic subtest: pipe-D-eDP-1
[267.462345] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.136s)
[267.464694] Subtest scaling-mode-full-aspect: SUCCESS (3.580s)
[268.643760] [076/133] (751s left) gem_create (create-ext-cpu-access-sanity-check)
[268.825444] Starting subtest: create-ext-cpu-access-sanity-check
[268.830524] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[268.929581] [077/133] (751s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc)
[269.027341] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc
[269.031315] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[269.148045] [078/133] (750s left) kms_ccs (bad-pixel-format-yf-tiled-ccs)
[269.237075] Starting subtest: bad-pixel-format-yf-tiled-ccs
[269.239207] Starting dynamic subtest: pipe-A-eDP-1
[269.261277] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[269.272239] Starting dynamic subtest: pipe-B-eDP-1
[269.292874] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[269.300322] Starting dynamic subtest: pipe-C-eDP-1
[269.321508] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[269.328908] Starting dynamic subtest: pipe-D-eDP-1
[269.353012] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[269.357574] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.009s)
[271.443788] [079/133] (748s left) gem_exec_parallel (userptr)
[271.510396] Starting subtest: userptr
[271.512726] Starting dynamic subtest: rcs0
[272.940729] Dynamic subtest rcs0: SUCCESS (1.430s)
[272.948926] Starting dynamic subtest: bcs0
[274.411923] Dynamic subtest bcs0: SUCCESS (1.469s)
[274.422933] Starting dynamic subtest: vcs0
[275.967054] Dynamic subtest vcs0: SUCCESS (1.551s)
[275.981160] Starting dynamic subtest: vcs1
[277.860718] Dynamic subtest vcs1: SUCCESS (1.891s)
[277.872071] Starting dynamic subtest: vecs0
[279.896621] Dynamic subtest vecs0: SUCCESS (2.033s)
[279.907829] Starting dynamic subtest: ccs0
[281.413753] Dynamic subtest ccs0: SUCCESS (1.516s)
[281.416576] Subtest userptr: SUCCESS (9.904s)
[281.625473] [080/133] (738s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[281.728830] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[281.731172] Starting dynamic subtest: pipe-A-eDP-1
[281.812660] Dynamic subtest pipe-A-eDP-1: SKIP (0.087s)
[281.821470] Starting dynamic subtest: pipe-B-eDP-1
[282.997526] Dynamic subtest pipe-B-eDP-1: SKIP (1.182s)
[283.002080] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.273s)
[284.213630] [081/133] (736s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[284.320306] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[284.322634] Starting dynamic subtest: pipe-A
[284.382871] Dynamic subtest pipe-A: SUCCESS (0.065s)
[284.395115] Starting dynamic subtest: pipe-B
[285.520760] Dynamic subtest pipe-B: SUCCESS (1.137s)
[285.529710] Starting dynamic subtest: pipe-C
[286.648081] Dynamic subtest pipe-C: SUCCESS (1.125s)
[286.659187] Starting dynamic subtest: pipe-D
[287.768551] Dynamic subtest pipe-D: SUCCESS (1.118s)
[287.770916] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.451s)
[288.942722] [082/133] (731s left) kms_chamelium_frames (hdmi-crc-single)
[289.347766] Subtest hdmi-crc-single: SKIP (0.000s)
[290.140603] [083/133] (730s left) gem_exec_fence (syncobj-channel)
[290.588400] Starting subtest: syncobj-channel
[291.605841] Subtest syncobj-channel: SUCCESS (1.014s)
[291.977109] [084/133] (728s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[292.063184] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[292.067554] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[293.201216] [085/133] (727s left) syncobj_timeline (multi-wait-available-submitted)
[293.266370] Starting subtest: multi-wait-available-submitted
[293.268599] Subtest multi-wait-available-submitted: SUCCESS (0.001s)
[293.389427] [086/133] (727s left) gem_exec_flush (basic-wb-rw-before-default)
[293.451530] Starting subtest: basic-wb-rw-before-default
[298.902248] Subtest basic-wb-rw-before-default: SUCCESS (5.451s)
[299.108135] [087/133] (721s left) i915_drm_fdinfo (most-busy-idle-check-all)
[299.154590] Starting subtest: most-busy-idle-check-all
[299.156488] Starting dynamic subtest: rcs0
[299.161145] Dynamic subtest rcs0: SKIP (0.006s)
[299.170970] Starting dynamic subtest: bcs0
[299.175629] Dynamic subtest bcs0: SKIP (0.000s)
[299.185956] Starting dynamic subtest: vcs0
[299.190371] Dynamic subtest vcs0: SKIP (0.000s)
[299.197875] Starting dynamic subtest: vcs1
[299.201884] Dynamic subtest vcs1: SKIP (0.000s)
[299.209184] Starting dynamic subtest: vecs0
[299.213195] Dynamic subtest vecs0: SKIP (0.000s)
[299.220422] Starting dynamic subtest: ccs0
[299.224595] Dynamic subtest ccs0: SKIP (0.000s)
[299.228892] Subtest most-busy-idle-check-all: SKIP (0.011s)
[299.264828] [088/133] (721s left) kms_pm_rpm (system-suspend-modeset)
[300.999448] Starting subtest: system-suspend-modeset
[320.788581] Subtest system-suspend-modeset: SUCCESS (4.758s)
[321.162726] [089/133] (699s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[321.236399] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[321.240490] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[321.433434] [090/133] (699s left) kms_sequence (get-busy)
[321.509603] Starting subtest: get-busy
[321.511874] Starting dynamic subtest: pipe-A-eDP-1
[323.407553] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.930s)
[323.417906] Starting dynamic subtest: pipe-B-eDP-1
[325.965148] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.592s)
[325.975002] Starting dynamic subtest: pipe-C-eDP-1
[328.560071] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.619s)
[328.570711] Starting dynamic subtest: pipe-D-eDP-1
[331.167697] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.622s)
[331.169797] Subtest get-busy: SUCCESS (9.767s)
[331.973402] [091/133] (688s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render)
[332.075729] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render
[332.079597] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[332.195252] [092/133] (688s left) kms_psr (fbc-psr-cursor-mmap-cpu)
[332.292898] Starting subtest: fbc-psr-cursor-mmap-cpu
[332.295081] Starting dynamic subtest: eDP-1
[332.299128] Dynamic subtest eDP-1: SKIP (0.000s)
[332.303247] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.001s)
[332.376486] [093/133] (688s left) kms_rotation_crc (exhaust-fences)
[332.464417] Starting subtest: exhaust-fences
[332.468496] Subtest exhaust-fences: SKIP (0.000s)
[332.546763] [094/133] (688s left) kms_flip (absolute-wf_vblank)
[332.634873] Starting subtest: absolute-wf_vblank
[332.636982] Starting dynamic subtest: A-eDP1
[341.387671] Dynamic subtest A-eDP1: SUCCESS (8.781s)
[341.399287] Starting dynamic subtest: B-eDP1
[350.102773] Dynamic subtest B-eDP1: SUCCESS (8.724s)
[350.114053] Starting dynamic subtest: C-eDP1
[358.815726] Dynamic subtest C-eDP1: SUCCESS (8.713s)
[358.824918] Starting dynamic subtest: D-eDP1
[367.531108] Dynamic subtest D-eDP1: SUCCESS (8.717s)
[367.533447] Subtest absolute-wf_vblank: SUCCESS (34.944s)
[368.757773] [095/133] (652s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[368.863162] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[376.201743] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SUCCESS (7.344s)
[376.413842] [096/133] (644s left) kms_cursor_crc (cursor-rapid-movement-max-size)
[376.760536] Starting subtest: cursor-rapid-movement-max-size
[376.766682] Subtest cursor-rapid-movement-max-size: SKIP (0.000s)
[376.927846] [097/133] (643s left) kms_properties (crtc-properties-atomic)
[377.025201] Starting subtest: crtc-properties-atomic
[377.027379] Starting dynamic subtest: pipe-A-eDP-1
[377.520638] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.495s)
[377.530121] Starting dynamic subtest: pipe-B-eDP-1
[378.720192] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.200s)
[378.729245] Starting dynamic subtest: pipe-C-eDP-1
[379.838100] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.117s)
[379.848349] Starting dynamic subtest: pipe-D-eDP-1
[380.987916] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.148s)
[380.990171] Subtest crtc-properties-atomic: SUCCESS (3.965s)
[381.814125] [098/133] (639s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[381.913287] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[381.915585] Starting dynamic subtest: pipe-A-default-mode
[383.090582] Dynamic subtest pipe-A-default-mode: SKIP (1.175s)
[383.094650] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.177s)
[383.289817] [099/133] (637s left) api_intel_allocator (simple-allocator)
[383.344062] Starting subtest: simple-allocator
[383.346197] Starting dynamic subtest: basic
[383.350945] Dynamic subtest basic: SUCCESS (0.004s)
[383.359382] Starting dynamic subtest: parallel-one
[383.532564] Dynamic subtest parallel-one: SUCCESS (0.182s)
[383.541239] Starting dynamic subtest: print
[383.543546] Dynamic subtest print: SUCCESS (0.000s)
[383.552130] Starting dynamic subtest: reuse
[383.554490] Dynamic subtest reuse: SUCCESS (0.000s)
[383.562375] Starting dynamic subtest: reserve
[383.564251] Dynamic subtest reserve: SUCCESS (0.000s)
[383.572199] Starting dynamic subtest: fork-reopen-allocator
[383.574128] Dynamic subtest fork-reopen-allocator: SUCCESS (0.015s)
[383.576053] Subtest simple-allocator: SUCCESS (0.207s)
[383.692724] [100/133] (637s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier)
[383.778357] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier
[383.790995] Subtest pixel-format-4-tiled-bmg-ccs-modifier: SKIP (0.000s)
[383.857359] [101/133] (637s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[383.974652] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[383.978498] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[384.098008] [102/133] (636s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[384.198556] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[384.202790] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[384.330265] [103/133] (636s left) drm_read (empty-block)
[384.473824] Starting subtest: empty-block
[385.475677] Subtest empty-block: SUCCESS (1.001s)
[385.641510] [104/133] (635s left) gem_mmap_gtt (basic-write-read-distinct)
[385.705774] Subtest basic-write-read-distinct: SKIP (0.000s)
[385.773991] [105/133] (635s left) kms_setmode (invalid-clone-single-crtc)
[385.825356] Starting subtest: invalid-clone-single-crtc
[385.831648] Subtest invalid-clone-single-crtc: SKIP (0.000s)
[385.935138] [106/133] (635s left) gem_exec_capture (capture-invisible)
[385.996727] Starting subtest: capture-invisible
[385.999097] Starting dynamic subtest: smem0
[386.003538] Dynamic subtest smem0: SKIP (0.000s)
[386.007991] Subtest capture-invisible: SKIP (0.001s)
[386.132916] [107/133] (635s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[386.200973] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[386.203393] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[386.317811] [108/133] (634s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[386.411674] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[387.502016] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.090s)
[387.677593] [109/133] (633s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[387.775942] Starting subtest: fbc-rgb565-draw-mmap-cpu
[391.796889] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (4.025s)
[392.938763] [110/133] (628s left) i915_pm_freq_api (freq-suspend)
[392.995611] Starting subtest: freq-suspend
[392.997897] Starting dynamic subtest: gt0
[409.276178] Dynamic subtest gt0: SUCCESS (1.981s)
[409.288285] Starting dynamic subtest: gt1
[425.296308] Dynamic subtest gt1: SUCCESS (1.262s)
[425.298464] Subtest freq-suspend: SUCCESS (3.245s)
[425.354295] [111/133] (596s left) kms_cursor_crc (cursor-offscreen-64x64)
[425.547230] Starting subtest: cursor-offscreen-64x64
[425.552217] Starting dynamic subtest: pipe-A-eDP-1
[427.506647] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.955s)
[427.535864] Starting dynamic subtest: pipe-D-eDP-1
[430.067273] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.538s)
[430.070013] Subtest cursor-offscreen-64x64: SUCCESS (4.521s)
[430.954273] [112/133] (590s left) kms_color (ctm-0-25)
[431.051125] Starting subtest: ctm-0-25
[431.052974] Starting dynamic subtest: pipe-A-eDP-1
[434.469601] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.419s)
[434.479894] Starting dynamic subtest: pipe-B-eDP-1
[438.725177] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.257s)
[438.735259] Starting dynamic subtest: pipe-C-eDP-1
[442.773009] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.050s)
[442.782735] Starting dynamic subtest: pipe-D-eDP-1
[446.774180] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.000s)
[446.776452] Subtest ctm-0-25: SUCCESS (15.731s)
[447.582703] [113/133] (573s left) drm_read (fault-buffer)
[447.729922] Starting subtest: fault-buffer
[447.732368] Subtest fault-buffer: SUCCESS (0.001s)
[447.893064] [114/133] (573s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[447.991004] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[447.993184] Starting dynamic subtest: pipe-A-eDP-1
[448.015625] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[448.024840] Starting dynamic subtest: pipe-B-eDP-1
[448.046305] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[448.055018] Starting dynamic subtest: pipe-C-eDP-1
[448.076723] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[448.085577] Starting dynamic subtest: pipe-D-eDP-1
[448.107737] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[448.111800] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.004s)
[450.245584] [115/133] (571s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[450.362602] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[457.197816] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.877s)
[457.343248] [116/133] (564s left) kms_chamelium_hpd (common-hpd-after-suspend)
[457.724243] Subtest common-hpd-after-suspend: SKIP (0.000s)
[458.521313] [117/133] (563s left) kms_content_protection (uevent)
[458.673770] Starting subtest: uevent
[458.678387] Subtest uevent: SKIP (0.000s)
[458.841188] [118/133] (562s left) kms_pm_lpsp (kms-lpsp)
[459.947081] Starting subtest: kms-lpsp
[459.949249] Starting dynamic subtest: pipe-A-eDP-1
[460.080076] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.138s)
[460.385036] Subtest kms-lpsp: SUCCESS (0.447s)
[461.250619] [119/133] (560s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[461.363114] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[461.367124] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[461.470464] [120/133] (560s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[461.594682] Starting subtest: flip-vs-cursor-varying-size
[469.988594] Subtest flip-vs-cursor-varying-size: SUCCESS (8.457s)
[470.790997] [121/133] (551s left) perf_pmu (busy-accuracy-50)
[470.834664] Starting subtest: busy-accuracy-50
[470.837203] Starting dynamic subtest: rcs0
[472.361158] Dynamic subtest rcs0: SUCCESS (1.532s)
[472.371561] Starting dynamic subtest: bcs0
[473.901326] Dynamic subtest bcs0: SUCCESS (1.542s)
[473.913220] Starting dynamic subtest: vcs0
[475.443339] Dynamic subtest vcs0: SUCCESS (1.544s)
[475.454193] Starting dynamic subtest: vcs1
[476.980141] Dynamic subtest vcs1: SUCCESS (1.538s)
[476.989279] Starting dynamic subtest: vecs0
[478.521302] Dynamic subtest vecs0: SUCCESS (1.542s)
[478.530262] Starting dynamic subtest: ccs0
[480.065788] Dynamic subtest ccs0: SUCCESS (1.545s)
[480.068032] Subtest busy-accuracy-50: SUCCESS (9.257s)
[480.208431] [122/133] (541s left) prime_vgem (wait)
[480.305992] Starting subtest: wait
[480.308363] Starting dynamic subtest: rcs0
[480.366925] Dynamic subtest rcs0: SUCCESS (0.061s)
[480.375786] Starting dynamic subtest: bcs0
[480.468057] Dynamic subtest bcs0: SUCCESS (0.100s)
[480.477401] Starting dynamic subtest: vcs0
[480.507105] Dynamic subtest vcs0: SUCCESS (0.038s)
[480.515725] Starting dynamic subtest: vcs1
[480.551263] Dynamic subtest vcs1: SUCCESS (0.043s)
[480.560073] Starting dynamic subtest: vecs0
[480.599005] Dynamic subtest vecs0: SUCCESS (0.047s)
[480.608083] Starting dynamic subtest: ccs0
[480.646603] Dynamic subtest ccs0: SUCCESS (0.047s)
[480.648786] Subtest wait: SUCCESS (0.342s)
[480.803051] [123/133] (541s left) kms_psr (fbc-pr-basic)
[480.913596] Starting subtest: fbc-pr-basic
[480.917697] Subtest fbc-pr-basic: SKIP (0.000s)
[480.996171] [124/133] (541s left) gem_userptr_blits (sync-overlap)
[481.088670] Starting subtest: sync-overlap
[481.090767] Subtest sync-overlap: SUCCESS (0.000s)
[481.246431] [125/133] (540s left) perf (oa-exponents)
[481.377899] Starting subtest: oa-exponents
[481.379715] Starting dynamic subtest: 0-rcs0
[483.147045] Dynamic subtest 0-rcs0: SUCCESS (1.771s)
[483.157690] Starting dynamic subtest: 1-vecs0
[484.974550] Dynamic subtest 1-vecs0: SUCCESS (1.828s)
[484.977356] Subtest oa-exponents: SUCCESS (3.601s)
[485.033926] [126/133] (537s left) vgem_basic (dmabuf-export)
[485.079445] Starting subtest: dmabuf-export
[485.101369] Subtest dmabuf-export: SUCCESS (0.023s)
[485.223325] [127/133] (536s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[485.329699] Starting subtest: yf-tiled-64bpp-rotate-90
[485.334128] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[485.435662] [128/133] (536s left) kms_hdr (invalid-metadata-sizes)
[485.531050] Starting subtest: invalid-metadata-sizes
[485.537648] Subtest invalid-metadata-sizes: SKIP (0.000s)
[485.615305] [129/133] (536s left) kms_joiner (invalid-modeset-ultra-joiner)
[485.726810] Starting subtest: invalid-modeset-ultra-joiner
[485.731219] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[485.803668] [130/133] (536s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[485.862120] Starting subtest: rel-constants-invalid-rel-gen5
[485.864259] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[486.005882] [131/133] (536s left) perf_pmu (busy-start)
[486.047534] Starting subtest: busy-start
[486.049413] Starting dynamic subtest: rcs0
[488.596605] Dynamic subtest rcs0: SUCCESS (2.551s)
[488.608215] Starting dynamic subtest: bcs0
[491.147324] Dynamic subtest bcs0: SUCCESS (2.547s)
[491.159807] Starting dynamic subtest: vcs0
[495.027031] Dynamic subtest vcs0: SUCCESS (3.874s)
[495.039007] Starting dynamic subtest: vcs1
[499.058871] Dynamic subtest vcs1: SUCCESS (4.028s)
[499.070910] Starting dynamic subtest: vecs0
[503.027020] Dynamic subtest vecs0: SUCCESS (3.965s)
[503.039064] Starting dynamic subtest: ccs0
[505.576018] Dynamic subtest ccs0: SUCCESS (2.548s)
[505.578498] Subtest busy-start: SUCCESS (19.528s)
[505.715880] [132/133] (516s left) syncobj_timeline (wait-all-delayed-signal)
[505.782344] Starting subtest: wait-all-delayed-signal
[505.884138] Subtest wait-all-delayed-signal: SUCCESS (0.103s)
[505.974474] [133/133] (516s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[506.082683] Starting subtest: psr-2p-primscrn-cur-indfb-move
[506.087178] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[506.200032] 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.