[58.030259] Initializing watchdogs
[58.030304]   /dev/watchdog0
[58.045447] [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]
[58.049925] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.052541] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.056029] [001/133] (960s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[58.186306] Starting subtest: plane-upscale-factor-0-25-with-rotation
[58.188503] Starting dynamic subtest: pipe-A
[58.423556] Dynamic subtest pipe-A: SUCCESS (0.238s)
[58.432074] Starting dynamic subtest: pipe-B
[59.748692] Dynamic subtest pipe-B: SUCCESS (1.326s)
[59.757550] Starting dynamic subtest: pipe-C
[61.075134] Dynamic subtest pipe-C: SUCCESS (1.328s)
[61.082255] Starting dynamic subtest: pipe-D
[62.411437] Dynamic subtest pipe-D: SUCCESS (1.337s)
[62.413653] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.231s)
[63.612430] [002/133] (954s left) gem_ctx_shared (q-smoketest-all)
[63.687465] Starting subtest: Q-smoketest-all
[96.078798] Subtest Q-smoketest-all: SUCCESS (32.345s)
[97.916542] [003/133] (920s left) gem_lmem_swapping (heavy-verify-random-ccs)
[97.965227] Subtest heavy-verify-random-ccs: SKIP (0.000s)
[98.012937] [004/133] (920s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[98.130070] Starting subtest: cursorB-vs-flipB-toggle
[98.134677] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s)
[98.276976] [005/133] (920s left) gem_exec_store (basic)
[98.342591] Starting subtest: basic
[98.448315] Subtest basic: SUCCESS (0.107s)
[98.628216] [006/133] (920s left) vgem_basic (setversion)
[98.750664] Starting subtest: setversion
[98.755096] Subtest setversion: SUCCESS (0.000s)
[98.804141] [FACT vgem_basic (setversion)] new: kernel.kmod_is_loaded.vgem: true
[98.807360] [007/133] (919s left) kms_color (deep-color)
[98.900445] Starting subtest: deep-color
[99.964914] Starting dynamic subtest: pipe-A-eDP-1-gamma
[100.670766] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.704s)
[100.682717] Starting dynamic subtest: pipe-A-eDP-1-degamma
[102.159185] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.490s)
[102.168380] Starting dynamic subtest: pipe-A-eDP-1-ctm
[103.619590] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.459s)
[104.372067] Starting dynamic subtest: pipe-B-eDP-1-gamma
[105.127808] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.762s)
[105.137670] Starting dynamic subtest: pipe-B-eDP-1-degamma
[106.563926] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.437s)
[106.572066] Starting dynamic subtest: pipe-B-eDP-1-ctm
[108.068138] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.504s)
[108.873612] Starting dynamic subtest: pipe-C-eDP-1-gamma
[109.557930] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.693s)
[109.567476] Starting dynamic subtest: pipe-C-eDP-1-degamma
[110.940296] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.380s)
[110.950672] Starting dynamic subtest: pipe-C-eDP-1-ctm
[112.369563] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.430s)
[113.166082] Starting dynamic subtest: pipe-D-eDP-1-gamma
[113.862848] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.702s)
[113.871125] Starting dynamic subtest: pipe-D-eDP-1-degamma
[115.239621] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.377s)
[115.248038] Starting dynamic subtest: pipe-D-eDP-1-ctm
[116.667986] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.429s)
[116.670493] Subtest deep-color: SUCCESS (17.769s)
[117.516544] [008/133] (901s left) perf (invalid-oa-metric-set-id)
[117.654340] Starting subtest: invalid-oa-metric-set-id
[117.665887] Subtest invalid-oa-metric-set-id: SUCCESS (0.011s)
[117.715402] [009/133] (901s left) gem_exec_balancer (bonded-dual)
[117.776543] Starting subtest: bonded-dual
[117.780970] Subtest bonded-dual: SKIP (0.000s)
[118.073662] [010/133] (900s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf)
[118.185714] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf
[118.190295] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[118.251636] [011/133] (900s left) syncobj_wait (reset-unsignaled)
[118.317198] Starting subtest: reset-unsignaled
[118.319507] Subtest reset-unsignaled: SUCCESS (0.000s)
[118.418775] [012/133] (900s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[118.511696] Starting subtest: fb-8bpc-vs-panel-6bpc
[118.513961] Starting dynamic subtest: pipe-A-eDP-1
[119.896475] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.385s)
[119.898643] Subtest fb-8bpc-vs-panel-6bpc: SUCCESS (1.386s)
[120.767190] [013/133] (898s left) kms_atomic (plane-invalid-params)
[120.867778] Starting subtest: plane-invalid-params
[120.870074] Starting dynamic subtest: pipe-A-eDP-1
[121.301748] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.435s)
[121.304069] Subtest plane-invalid-params: SUCCESS (0.436s)
[122.099896] [014/133] (896s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[122.155730] Starting subtest: invalid-single-wait-all-unsubmitted
[122.158036] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[122.241580] [015/133] (896s left) gem_exec_reloc (basic-write-gtt-active)
[122.312749] Subtest basic-write-gtt-active: SKIP (0.000s)
[122.376011] [016/133] (896s left) i915_pm_rpm (gem-execbuf-stress)
[124.113747] Starting subtest: gem-execbuf-stress
[124.116141] Starting dynamic subtest: smem0
[136.993042] Dynamic subtest smem0: SUCCESS (12.881s)
[137.004088] Starting dynamic subtest: extra-wait-smem0
[198.671558] Dynamic subtest extra-wait-smem0: SUCCESS (61.676s)
[198.674448] Subtest gem-execbuf-stress: SUCCESS (74.562s)
[199.064274] [017/133] (820s left) kms_cursor_crc (cursor-offscreen-256x85)
[199.339086] Starting subtest: cursor-offscreen-256x85
[199.386889] Subtest cursor-offscreen-256x85: SKIP (0.045s)
[199.543672] [018/133] (819s left) syncobj_wait (wait-all-snapshot)
[199.600762] Starting subtest: wait-all-snapshot
[199.681525] Subtest wait-all-snapshot: SUCCESS (0.081s)
[199.776519] [019/133] (819s left) kms_pm_rpm (modeset-lpsp-stress-no-wait)
[202.121034] Starting subtest: modeset-lpsp-stress-no-wait
[212.074817] Subtest modeset-lpsp-stress-no-wait: SUCCESS (9.956s)
[212.166232] [020/133] (807s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[212.272368] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[212.276644] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[212.367299] [021/133] (806s left) sw_sync (alloc_fence)
[212.400594] Starting subtest: alloc_fence
[212.402548] Subtest alloc_fence: SUCCESS (0.000s)
[212.451171] [022/133] (806s left) prime_vgem (coherency-gtt)
[212.525092] Starting subtest: coherency-gtt
[212.529803] Subtest coherency-gtt: SKIP (0.000s)
[212.621821] [023/133] (806s left) gem_exec_schedule (preemptive-hang)
[212.812718] Starting subtest: preemptive-hang
[212.815315] Starting dynamic subtest: rcs0
[222.016220] Dynamic subtest rcs0: SUCCESS (9.207s)
[222.025797] Starting dynamic subtest: bcs0
[231.041042] Dynamic subtest bcs0: SUCCESS (9.023s)
[231.048331] Starting dynamic subtest: vcs0
[239.998238] Dynamic subtest vcs0: SUCCESS (8.957s)
[240.006142] Starting dynamic subtest: vcs1
[249.026186] Dynamic subtest vcs1: SUCCESS (9.027s)
[249.036031] Starting dynamic subtest: vecs0
[258.040965] Dynamic subtest vecs0: SUCCESS (9.014s)
[258.051716] Starting dynamic subtest: ccs0
[267.005925] Dynamic subtest ccs0: SUCCESS (8.963s)
[267.008315] Subtest preemptive-hang: SUCCESS (54.197s)
[267.242849] [024/133] (752s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[267.302965] Starting subtest: single-wait-all-for-submit-available-submitted
[267.305306] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[267.394372] [025/133] (752s left) kms_pm_rpm (fences)
[269.031138] Starting subtest: fences
[269.036037] Subtest fences: SKIP (0.000s)
[269.664023] [026/133] (749s left) kms_psr (psr-cursor-mmap-gtt)
[269.747031] Starting subtest: psr-cursor-mmap-gtt
[269.749362] Starting dynamic subtest: eDP-1
[271.462368] Dynamic subtest eDP-1: SUCCESS (1.715s)
[271.464719] Subtest psr-cursor-mmap-gtt: SUCCESS (1.716s)
[272.329507] [027/133] (747s left) gem_userptr_blits (map-fixed-invalidate-busy)
[272.401158] Starting subtest: map-fixed-invalidate-busy
[272.405535] Subtest map-fixed-invalidate-busy: SKIP (0.000s)
[272.523806] [028/133] (747s left) gem_exec_suspend (basic-s3-devices)
[272.582160] Starting subtest: basic-S3-devices
[272.584521] Starting dynamic subtest: smem
[283.861431] Dynamic subtest smem: SUCCESS (11.277s)
[283.864263] Subtest basic-S3-devices: SUCCESS (11.279s)
[284.059420] [029/133] (735s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[284.126777] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[284.233101] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.105s)
[284.308915] [030/133] (735s left) kms_cursor_edge_walk (128x128-top-edge)
[284.396123] Starting subtest: 128x128-top-edge
[284.398423] Starting dynamic subtest: pipe-A-eDP-1
[287.871478] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.475s)
[287.883095] Starting dynamic subtest: pipe-D-eDP-1
[290.994731] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.120s)
[290.997172] Subtest 128x128-top-edge: SUCCESS (6.600s)
[291.785057] [031/133] (727s left) kms_plane (plane-panning-top-left)
[291.876253] Starting subtest: plane-panning-top-left
[291.878599] Starting dynamic subtest: pipe-A
[293.585479] Dynamic subtest pipe-A: SUCCESS (1.710s)
[293.595593] Starting dynamic subtest: pipe-B
[296.048610] Dynamic subtest pipe-B: SUCCESS (2.461s)
[296.050817] Subtest plane-panning-top-left: SUCCESS (4.174s)
[296.922370] [032/133] (722s left) gem_partial_pwrite_pread (reads-uncached)
[296.986064] Subtest reads-uncached: SKIP (0.000s)
[297.068954] [033/133] (722s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[297.166454] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[297.170809] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[297.260599] [034/133] (722s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping)
[297.351955] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping
[297.378298] Starting dynamic subtest: pipe-A-plane-0
[297.666545] Dynamic subtest pipe-A-plane-0: SUCCESS (0.288s)
[297.674976] Starting dynamic subtest: pipe-A-plane-3
[297.899631] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[299.017618] Starting dynamic subtest: pipe-B-plane-0
[299.310810] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[299.320426] Starting dynamic subtest: pipe-B-plane-3
[299.542687] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[299.849595] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier-source-clamping: SUCCESS (2.499s)
[300.690541] [035/133] (719s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[300.778846] Starting subtest: nonblocking-crc-frame-sequence
[300.780706] Starting dynamic subtest: pipe-A-eDP-1
[301.528233] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.749s)
[301.537581] Starting dynamic subtest: pipe-B-eDP-1
[302.905997] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.377s)
[302.914921] Starting dynamic subtest: pipe-C-eDP-1
[304.285232] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.376s)
[304.294787] Starting dynamic subtest: pipe-D-eDP-1
[305.612452] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.325s)
[305.614388] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.833s)
[306.417080] [036/133] (713s left) i915_pm_freq_api (freq-reset)
[306.469640] Starting subtest: freq-reset
[306.471979] Starting dynamic subtest: gt0
[306.668367] Dynamic subtest gt0: SUCCESS (0.196s)
[306.677429] Starting dynamic subtest: gt1
[306.843366] Dynamic subtest gt1: SUCCESS (0.175s)
[306.846133] Subtest freq-reset: SUCCESS (0.372s)
[306.925853] [037/133] (713s left) kms_feature_discovery (display-3x)
[307.011845] Starting subtest: display-3x
[307.016252] Subtest display-3x: SKIP (0.000s)
[307.089311] [038/133] (712s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[307.180992] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[307.188208] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[307.301165] [039/133] (712s left) gem_pxp (create-protected-buffer)
[307.423189] Starting subtest: create-protected-buffer
[307.425667] Subtest create-protected-buffer: SUCCESS (0.000s)
[307.549258] [040/133] (712s left) i915_drm_fdinfo (most-busy-idle-check-all)
[307.597178] Starting subtest: most-busy-idle-check-all
[307.599513] Starting dynamic subtest: rcs0
[307.604070] Dynamic subtest rcs0: SKIP (0.004s)
[307.614835] Starting dynamic subtest: bcs0
[307.619035] Dynamic subtest bcs0: SKIP (0.000s)
[307.627830] Starting dynamic subtest: vcs0
[307.632271] Dynamic subtest vcs0: SKIP (0.000s)
[307.640491] Starting dynamic subtest: vcs1
[307.644546] Dynamic subtest vcs1: SKIP (0.000s)
[307.652897] Starting dynamic subtest: vecs0
[307.656948] Dynamic subtest vecs0: SKIP (0.000s)
[307.665056] Starting dynamic subtest: ccs0
[307.669089] Dynamic subtest ccs0: SKIP (0.000s)
[307.673063] Subtest most-busy-idle-check-all: SKIP (0.010s)
[307.710575] [041/133] (712s left) kms_lease (lease-get)
[307.825281] Starting subtest: lease-get
[307.827560] Starting dynamic subtest: pipe-A-eDP-1
[307.829721] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[307.838726] Starting dynamic subtest: pipe-B-eDP-1
[307.841112] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s)
[307.849528] Starting dynamic subtest: pipe-C-eDP-1
[307.851726] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[307.859757] Starting dynamic subtest: pipe-D-eDP-1
[307.861566] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[307.863337] Subtest lease-get: SUCCESS (0.014s)
[307.941013] [042/133] (712s left) kms_psr (fbc-psr-cursor-blt)
[308.022119] Starting subtest: fbc-psr-cursor-blt
[308.024013] Starting dynamic subtest: eDP-1
[308.027360] Dynamic subtest eDP-1: SKIP (0.000s)
[308.030721] Subtest fbc-psr-cursor-blt: SKIP (0.001s)
[308.112639] [043/133] (712s left) gem_softpin (evict-prime-sanity-check)
[308.172088] Starting subtest: evict-prime-sanity-check
[308.173649] Starting dynamic subtest: rcs0
[309.311846] Dynamic subtest rcs0: SUCCESS (1.141s)
[309.320655] Starting dynamic subtest: bcs0
[310.432361] Dynamic subtest bcs0: SUCCESS (1.119s)
[310.444055] Starting dynamic subtest: vcs0
[311.886604] Dynamic subtest vcs0: SUCCESS (1.451s)
[311.898532] Starting dynamic subtest: vcs1
[313.852202] Dynamic subtest vcs1: SUCCESS (1.963s)
[313.863755] Starting dynamic subtest: vecs0
[315.919795] Dynamic subtest vecs0: SUCCESS (2.065s)
[315.931850] Starting dynamic subtest: ccs0
[317.039301] Dynamic subtest ccs0: SUCCESS (1.118s)
[317.048637] Starting dynamic subtest: all
[318.158010] Dynamic subtest all: SUCCESS (1.117s)
[318.160545] Subtest evict-prime-sanity-check: SUCCESS (9.988s)
[318.237323] [044/133] (702s left) gem_ctx_persistence (engines-queued)
[318.318024] Starting subtest: engines-queued
[318.320502] Starting dynamic subtest: rcs0
[318.403682] Dynamic subtest rcs0: SUCCESS (0.088s)
[318.414730] Starting dynamic subtest: bcs0
[318.434385] Dynamic subtest bcs0: SUCCESS (0.030s)
[318.443425] Starting dynamic subtest: vcs0
[319.798478] Dynamic subtest vcs0: SUCCESS (1.361s)
[319.810753] Starting dynamic subtest: vcs1
[321.842611] Dynamic subtest vcs1: SUCCESS (2.041s)
[321.856240] Starting dynamic subtest: vecs0
[323.826513] Dynamic subtest vecs0: SUCCESS (1.981s)
[323.839082] Starting dynamic subtest: ccs0
[324.024367] Dynamic subtest ccs0: SUCCESS (0.196s)
[324.026882] Subtest engines-queued: SUCCESS (5.709s)
[324.148207] [045/133] (696s left) sriov_basic (enable-vfs-autoprobe-off)
[324.209148] Starting subtest: enable-vfs-autoprobe-off
[324.211459] Starting dynamic subtest: numvfs-1
[324.283963] Dynamic subtest numvfs-1: FAIL (0.015s)
[324.295187] Starting dynamic subtest: numvfs-2
[324.368555] Dynamic subtest numvfs-2: FAIL (0.004s)
[324.379285] Starting dynamic subtest: numvfs-3
[324.451717] Dynamic subtest numvfs-3: FAIL (0.004s)
[324.461387] Starting dynamic subtest: numvfs-4
[324.533874] Dynamic subtest numvfs-4: FAIL (0.003s)
[324.544510] Starting dynamic subtest: numvfs-5
[324.618316] Dynamic subtest numvfs-5: FAIL (0.004s)
[324.628692] Starting dynamic subtest: numvfs-6
[324.703585] Dynamic subtest numvfs-6: FAIL (0.004s)
[324.713838] Starting dynamic subtest: numvfs-7
[324.786934] Dynamic subtest numvfs-7: FAIL (0.004s)
[324.797259] Starting dynamic subtest: numvfs-random
[324.871638] Dynamic subtest numvfs-random: FAIL (0.004s)
[324.882635] Starting dynamic subtest: numvfs-all
[324.956057] Dynamic subtest numvfs-all: FAIL (0.515s)
[324.958372] Subtest enable-vfs-autoprobe-off: FAIL (0.562s)
[324.998664] [046/133] (695s left) kms_vrr (flip-basic)
[325.098391] Starting subtest: flip-basic
[325.103820] Subtest flip-basic: SKIP (0.000s)
[325.170452] [047/133] (695s left) gem_mmap_gtt (cpuset-medium-copy)
[325.230596] Subtest cpuset-medium-copy: SKIP (0.000s)
[325.295638] [048/133] (695s left) kms_psr (fbc-pr-sprite-plane-move)
[325.392102] Starting subtest: fbc-pr-sprite-plane-move
[325.395716] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[325.465078] [049/133] (695s left) gem_exec_fence (syncobj-export)
[325.989540] Starting subtest: syncobj-export
[325.994519] Subtest syncobj-export: SUCCESS (0.005s)
[327.014659] [050/133] (693s left) gem_mmap_gtt (basic-read-write)
[327.062346] Subtest basic-read-write: SKIP (0.000s)
[327.122857] [051/133] (693s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[327.216517] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[327.218625] Starting dynamic subtest: pipe-A-eDP-1
[327.242633] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[327.253124] Starting dynamic subtest: pipe-B-eDP-1
[327.276104] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[327.284191] Starting dynamic subtest: pipe-C-eDP-1
[327.306535] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[327.314534] Starting dynamic subtest: pipe-D-eDP-1
[327.337208] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[327.341345] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[329.465554] [052/133] (691s left) gem_exec_await (wide-all)
[329.666882] Starting subtest: wide-all
[352.855849] Subtest wide-all: SUCCESS (23.187s)
[353.068735] [053/133] (667s left) kms_plane_lowres (tiling-none)
[353.209761] Starting subtest: tiling-none
[353.211887] Starting dynamic subtest: pipe-A-eDP-1
[353.216163] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[353.509246] Starting dynamic subtest: pipe-B-eDP-1
[353.513968] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[353.523467] Starting dynamic subtest: pipe-C-eDP-1
[353.528214] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[353.537669] Starting dynamic subtest: pipe-D-eDP-1
[353.542102] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[353.546092] Subtest tiling-none: SKIP (0.301s)
[354.306945] [054/133] (666s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[354.410474] Starting subtest: y-tiled-16bpp-rotate-0
[354.415053] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s)
[354.510665] [055/133] (666s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[354.602897] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[354.605188] Starting dynamic subtest: pipe-A-eDP-1
[355.513324] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.905s)
[355.522974] Starting dynamic subtest: pipe-B-eDP-1
[357.263203] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.744s)
[357.273238] Starting dynamic subtest: pipe-C-eDP-1
[358.758107] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.494s)
[358.767642] Starting dynamic subtest: pipe-D-eDP-1
[360.296342] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.538s)
[360.298579] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.687s)
[361.455548] [056/133] (659s left) syncobj_timeline (invalid-transfer-bad-pad)
[361.523080] Starting subtest: invalid-transfer-bad-pad
[361.525057] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[361.613147] [057/133] (659s left) gem_userptr_blits (process-exit)
[361.681298] Starting subtest: process-exit
[361.687988] Subtest process-exit: SUCCESS (0.008s)
[361.806195] [058/133] (659s left) gem_eio (in-flight-contexts-10ms)
[362.032561] Starting subtest: in-flight-contexts-10ms
[375.926589] Subtest in-flight-contexts-10ms: SUCCESS (13.894s)
[376.066107] [059/133] (644s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[376.167307] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-cpu
[382.882775] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.717s)
[382.996118] [060/133] (637s left) gem_exec_gttfill (engines)
[383.073645] Starting subtest: engines
[383.076120] Starting dynamic subtest: rcs0
[405.853719] Dynamic subtest rcs0: SUCCESS (22.777s)
[405.866076] Starting dynamic subtest: bcs0
[429.187415] Dynamic subtest bcs0: SUCCESS (23.333s)
[429.200225] Starting dynamic subtest: vcs0
[452.523497] Dynamic subtest vcs0: SUCCESS (23.333s)
[452.536576] Starting dynamic subtest: vcs1
[475.886809] Dynamic subtest vcs1: SUCCESS (23.358s)
[475.898052] Starting dynamic subtest: vecs0
[499.256551] Dynamic subtest vecs0: SUCCESS (23.367s)
[499.268657] Starting dynamic subtest: ccs0
[522.616203] Dynamic subtest ccs0: SUCCESS (23.358s)
[522.618553] Subtest engines: SUCCESS (139.539s)
[522.810576] [061/133] (498s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt)
[522.966250] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt
[522.970092] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[523.061937] [062/133] (497s left) kms_cursor_crc (cursor-random-512x512)
[523.370261] Starting subtest: cursor-random-512x512
[523.374550] Subtest cursor-random-512x512: SKIP (0.001s)
[523.539217] [063/133] (497s left) gem_blits (basic)
[523.599984] Starting subtest: basic
[525.054854] Subtest basic: SUCCESS (1.457s)
[525.166018] [064/133] (495s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[525.245468] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[525.249587] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.000s)
[525.318741] [065/133] (495s left) gem_pxp (verify-pxp-stale-buf-execution)
[525.385209] Starting subtest: verify-pxp-stale-buf-execution
[526.446675] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.064s)
[526.586695] [066/133] (494s left) perf_pmu (busy-idle-check-all)
[526.634461] Starting subtest: busy-idle-check-all
[526.636674] Starting dynamic subtest: rcs0
[527.285568] Dynamic subtest rcs0: SUCCESS (0.651s)
[527.298966] Starting dynamic subtest: bcs0
[527.940260] Dynamic subtest bcs0: SUCCESS (0.653s)
[527.953060] Starting dynamic subtest: vcs0
[529.941357] Dynamic subtest vcs0: SUCCESS (1.997s)
[529.954026] Starting dynamic subtest: vcs1
[531.924935] Dynamic subtest vcs1: SUCCESS (1.981s)
[531.938359] Starting dynamic subtest: vecs0
[533.909087] Dynamic subtest vecs0: SUCCESS (1.981s)
[533.922145] Starting dynamic subtest: ccs0
[534.565391] Dynamic subtest ccs0: SUCCESS (0.655s)
[534.568049] Subtest busy-idle-check-all: SUCCESS (7.932s)
[534.682053] [067/133] (486s left) kms_psr (psr-primary-mmap-cpu)
[534.780486] Starting subtest: psr-primary-mmap-cpu
[534.782901] Starting dynamic subtest: eDP-1
[536.549999] Dynamic subtest eDP-1: SUCCESS (1.772s)
[536.552163] Subtest psr-primary-mmap-cpu: SUCCESS (1.773s)
[537.423654] [068/133] (483s left) perf_pmu (busy-accuracy-98)
[537.472945] Starting subtest: busy-accuracy-98
[537.475269] Starting dynamic subtest: rcs0
[540.510568] Dynamic subtest rcs0: SUCCESS (3.037s)
[540.522576] Starting dynamic subtest: bcs0
[543.565939] Dynamic subtest bcs0: SUCCESS (3.053s)
[543.576577] Starting dynamic subtest: vcs0
[546.611948] Dynamic subtest vcs0: SUCCESS (3.043s)
[546.623829] Starting dynamic subtest: vcs1
[549.655887] Dynamic subtest vcs1: SUCCESS (3.042s)
[549.667560] Starting dynamic subtest: vecs0
[552.700624] Dynamic subtest vecs0: SUCCESS (3.042s)
[552.712623] Starting dynamic subtest: ccs0
[555.754314] Dynamic subtest ccs0: SUCCESS (3.052s)
[555.756620] Subtest busy-accuracy-98: SUCCESS (18.281s)
[555.882411] [069/133] (465s left) i915_query (engine-info)
[555.954958] Starting subtest: engine-info
[555.957286] Subtest engine-info: SUCCESS (0.005s)
[556.071415] [070/133] (465s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[556.175064] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[556.179066] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s)
[556.261612] [071/133] (465s left) kms_flip (2x-flip-vs-suspend-interruptible)
[556.348729] Starting subtest: 2x-flip-vs-suspend-interruptible
[556.361185] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.011s)
[556.438449] [072/133] (465s left) syncobj_timeline (wait-any-snapshot)
[556.499335] Starting subtest: wait-any-snapshot
[556.581493] Subtest wait-any-snapshot: SUCCESS (0.081s)
[556.659316] [073/133] (464s left) kms_psr (pr-primary-render)
[556.748845] Starting subtest: pr-primary-render
[556.753043] Subtest pr-primary-render: SKIP (0.000s)
[556.824928] [074/133] (464s left) kms_flip (2x-flip-vs-panning-interruptible)
[556.916430] Starting subtest: 2x-flip-vs-panning-interruptible
[556.929209] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.011s)
[557.005838] [075/133] (464s left) gem_exec_schedule (u-semaphore-codependency)
[557.085676] Starting subtest: u-semaphore-codependency
[557.093071] Subtest u-semaphore-codependency: SUCCESS (0.012s)
[557.440015] [076/133] (464s left) gem_softpin (invalid)
[557.495899] Starting subtest: invalid
[557.503228] Subtest invalid: SUCCESS (0.006s)
[557.631460] [077/133] (464s left) api_intel_bb (offset-control)
[557.685102] Starting subtest: offset-control
[557.690398] Subtest offset-control: SUCCESS (0.008s)
[557.824704] [078/133] (463s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[557.931265] Starting subtest: fbc-indfb-scaledprimary
[560.897313] Subtest fbc-indfb-scaledprimary: SUCCESS (2.968s)
[562.035403] [079/133] (459s left) gem_exec_flush (basic-uc-pro-default)
[562.108057] Starting subtest: basic-uc-pro-default
[567.568092] Subtest basic-uc-pro-default: SUCCESS (5.461s)
[567.770280] [080/133] (454s left) gem_workarounds (basic-read-context)
[567.836806] Starting subtest: basic-read-context
[567.853624] Subtest basic-read-context: SUCCESS (0.017s)
[568.004543] [081/133] (453s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[568.056663] Starting subtest: multi-wait-for-submit-submitted-signaled
[568.058991] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[568.168945] [082/133] (453s left) gem_exec_reloc (basic-wc-read)
[568.230443] Subtest basic-wc-read: SKIP (0.000s)
[568.305552] [083/133] (453s left) tools_test (sysfs_l3_parity)
[568.356279] Starting subtest: sysfs_l3_parity
[568.453376] Subtest sysfs_l3_parity: SKIP (0.104s)
[568.511305] [084/133] (453s left) gem_exec_capture (capture-recoverable)
[568.579873] Starting subtest: capture-recoverable
[568.581802] Subtest capture-recoverable: SUCCESS (0.004s)
[568.693280] [085/133] (453s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[569.085289] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[569.934242] [086/133] (452s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[570.031990] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[570.036278] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[570.114605] [087/133] (452s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[570.180255] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[570.246063] [088/133] (451s left) kms_invalid_mode (bad-htotal)
[570.331023] Starting subtest: bad-htotal
[570.333277] Starting dynamic subtest: pipe-A-eDP-1
[570.615628] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s)
[570.627204] Starting dynamic subtest: pipe-B-eDP-1
[570.629170] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[570.638719] Starting dynamic subtest: pipe-C-eDP-1
[570.641072] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[570.650904] Starting dynamic subtest: pipe-D-eDP-1
[570.652833] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[570.654808] Subtest bad-htotal: SUCCESS (0.294s)
[571.484379] [089/133] (450s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[571.599310] Starting subtest: 2x-absolute-wf_vblank-interruptible
[571.612128] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.011s)
[571.689660] [090/133] (450s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy)
[571.807121] Starting subtest: 2x-long-cursor-vs-flip-legacy
[571.811583] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.001s)
[571.949662] [091/133] (450s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[572.057067] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip
[573.093422] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.037s)
[573.219222] [092/133] (449s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite)
[573.332611] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite
[577.626271] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (4.297s)
[578.813716] [093/133] (443s left) gem_exec_create (forked)
[578.878356] Starting subtest: forked
[578.880785] Starting dynamic subtest: smem
[599.074367] Dynamic subtest smem: SUCCESS (20.198s)
[599.076984] Subtest forked: SUCCESS (20.199s)
[599.288550] [094/133] (423s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[599.395391] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[599.399724] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[599.495448] [095/133] (423s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-pgflip-blt)
[599.599059] Starting subtest: fbcpsr-1p-primscrn-shrfb-pgflip-blt
[606.998453] Subtest fbcpsr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.402s)
[607.134999] [096/133] (415s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[607.238165] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[607.242381] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[607.340188] [097/133] (415s left) dmabuf (all-tests)
[607.384243] Starting subtest: all-tests
[607.386513] Starting dynamic subtest: sanitycheck
[607.513052] Dynamic subtest sanitycheck: SUCCESS (0.128s)
[607.526668] Starting dynamic subtest: dma_fence
[607.705353] Dynamic subtest dma_fence: SUCCESS (0.190s)
[607.721181] Starting dynamic subtest: dma_fence_chain
[616.979561] Dynamic subtest dma_fence_chain: SUCCESS (9.270s)
[616.992703] Starting dynamic subtest: dma_fence_unwrap
[617.070416] Dynamic subtest dma_fence_unwrap: SUCCESS (0.090s)
[617.083028] Starting dynamic subtest: dma_resv
[617.161327] Dynamic subtest dma_resv: SUCCESS (0.089s)
[617.164319] Subtest all-tests: SUCCESS (9.778s)
[617.228809] [098/133] (405s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[617.329743] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[617.334135] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[617.427514] [099/133] (405s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite)
[617.533626] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite
[617.538034] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[617.640250] [100/133] (405s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[618.017672] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[618.812718] [101/133] (403s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs)
[618.893901] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs
[618.896066] Starting dynamic subtest: pipe-A-eDP-1
[618.952991] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[618.963847] Starting dynamic subtest: pipe-B-eDP-1
[619.027230] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[619.038832] Starting dynamic subtest: pipe-C-eDP-1
[619.094212] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[619.105730] Starting dynamic subtest: pipe-D-eDP-1
[619.162416] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[619.166616] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.009s)
[621.192816] [102/133] (401s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[621.289736] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[621.293801] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[621.392545] [103/133] (401s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[621.502307] Starting subtest: x-tiled-16bpp-rotate-90
[621.521460] Subtest x-tiled-16bpp-rotate-90: SKIP (0.019s)
[621.640357] [104/133] (401s left) api_intel_allocator (two-level-inception)
[621.687572] Starting subtest: two-level-inception
[627.085677] Subtest two-level-inception: SUCCESS (5.399s)
[627.204563] [105/133] (395s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[627.304392] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[627.306608] Starting dynamic subtest: pipe-A-eDP-1
[627.330849] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[627.344050] Starting dynamic subtest: pipe-B-eDP-1
[627.365159] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[627.375459] Starting dynamic subtest: pipe-C-eDP-1
[627.396784] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[627.407228] Starting dynamic subtest: pipe-D-eDP-1
[627.428626] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[627.432593] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[629.571148] [106/133] (393s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[629.684088] Starting subtest: 4-tiled-8bpp-rotate-270
[629.708519] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.024s)
[629.857656] [107/133] (393s left) kms_sequence (get-forked)
[629.952306] Starting subtest: get-forked
[629.954176] Starting dynamic subtest: pipe-A-eDP-1
[631.837538] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.884s)
[631.848804] Starting dynamic subtest: pipe-B-eDP-1
[634.428366] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.589s)
[634.438944] Starting dynamic subtest: pipe-C-eDP-1
[636.935038] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.506s)
[636.946581] Starting dynamic subtest: pipe-D-eDP-1
[639.460743] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.525s)
[639.463076] Subtest get-forked: SUCCESS (9.510s)
[640.295642] [108/133] (382s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[640.359492] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[640.465161] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.105s)
[640.542646] [109/133] (382s left) gem_mmap_wc (fault-concurrent)
[640.590418] Subtest fault-concurrent: SKIP (0.000s)
[640.649534] [110/133] (382s left) gen7_exec_parse (basic-rejected)
[640.713695] Subtest basic-rejected: SKIP (0.000s)
[640.787406] [111/133] (382s left) gem_mmap_offset (mmap-unmap)
[640.847729] Starting subtest: mmap-unmap
[640.849678] Starting dynamic subtest: smem0
[664.478675] Dynamic subtest smem0: SUCCESS (23.631s)
[664.481560] Subtest mmap-unmap: SUCCESS (23.632s)
[664.629406] [112/133] (358s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[664.693396] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[664.698162] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[664.879690] [113/133] (358s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf)
[664.984180] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf
[664.988530] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[665.054758] [114/133] (358s left) kms_addfb_basic (unused-modifier)
[665.109189] Starting subtest: unused-modifier
[665.111397] Subtest unused-modifier: SUCCESS (0.000s)
[665.241815] [115/133] (358s left) gem_exec_reloc (basic-gtt-cpu-active)
[665.306787] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[665.383058] [116/133] (358s left) prime_mmap (test_errors)
[665.446388] Starting subtest: test_errors
[665.448543] Starting dynamic subtest: test_errors-smem
[665.549948] Dynamic subtest test_errors-smem: SUCCESS (0.105s)
[665.552255] Subtest test_errors: SUCCESS (0.106s)
[665.664837] [117/133] (357s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[665.772323] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[665.776423] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[665.873910] [118/133] (357s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[665.972558] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[672.561223] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.590s)
[672.674477] [119/133] (350s left) gem_userptr_blits (set-cache-level)
[672.742233] Starting subtest: set-cache-level
[672.746619] Subtest set-cache-level: SKIP (0.000s)
[672.866944] [120/133] (350s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[672.967466] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[672.969833] Starting dynamic subtest: pipe-A-eDP-1
[672.992968] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[673.003959] Starting dynamic subtest: pipe-B-eDP-1
[673.026901] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[673.047462] Starting dynamic subtest: pipe-C-eDP-1
[673.070334] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[673.091924] Starting dynamic subtest: pipe-D-eDP-1
[673.115600] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[673.120130] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[675.266651] [121/133] (348s left) intel_hwmon (hwmon-write)
[675.313171] Subtest hwmon-write: SKIP (0.000s)
[675.380349] [122/133] (348s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[675.478183] Starting subtest: fbcpsr-2p-rte
[675.482136] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[675.578923] [123/133] (348s left) gem_cs_tlb (engines)
[675.641513] Starting subtest: engines
[675.643921] Starting dynamic subtest: rcs0
[677.797676] Dynamic subtest rcs0: SUCCESS (2.153s)
[677.808956] Starting dynamic subtest: bcs0
[679.952176] Dynamic subtest bcs0: SUCCESS (2.152s)
[679.965042] Starting dynamic subtest: vcs0
[682.107667] Dynamic subtest vcs0: SUCCESS (2.154s)
[682.118251] Starting dynamic subtest: vcs1
[684.262503] Dynamic subtest vcs1: SUCCESS (2.153s)
[684.274156] Starting dynamic subtest: vecs0
[686.418954] Dynamic subtest vecs0: SUCCESS (2.155s)
[686.431769] Starting dynamic subtest: ccs0
[688.574094] Dynamic subtest ccs0: SUCCESS (2.154s)
[688.576641] Subtest engines: SUCCESS (12.929s)
[688.714916] [124/133] (335s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[688.832624] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[688.837055] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[688.946997] [125/133] (334s left) kms_psr2_su (page_flip-xrgb8888)
[689.002541] Subtest page_flip-XRGB8888: SKIP (0.000s)
[689.066610] [126/133] (334s left) gem_ctx_persistence (legacy-engines-mixed-process)
[689.131582] Starting subtest: legacy-engines-mixed-process
[689.133966] Starting dynamic subtest: render
[690.897974] Dynamic subtest render: SUCCESS (1.766s)
[690.910673] Starting dynamic subtest: bsd1
[692.890898] Dynamic subtest bsd1: SUCCESS (1.991s)
[692.904074] Starting dynamic subtest: bsd2
[694.874900] Dynamic subtest bsd2: SUCCESS (1.982s)
[694.887080] Starting dynamic subtest: blt
[696.915994] Dynamic subtest blt: SUCCESS (2.039s)
[696.926691] Starting dynamic subtest: vebox
[698.899807] Dynamic subtest vebox: SUCCESS (1.983s)
[698.902122] Subtest legacy-engines-mixed-process: SUCCESS (9.769s)
[698.986585] [127/133] (324s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[699.052037] Starting subtest: multi-wait-all-for-submit-signaled
[699.054022] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[699.149441] [128/133] (324s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[699.258242] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[699.262199] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[699.358638] [129/133] (324s left) kms_fbcon_fbt (psr-suspend)
[699.424507] Starting subtest: psr-suspend
[749.260216] Subtest psr-suspend: SUCCESS (19.770s)
[749.345566] [130/133] (274s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[749.491367] Starting subtest: basic-flip-before-cursor-varying-size
[750.488759] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.002s)
[751.353701] [131/133] (272s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[751.455370] Starting subtest: yf-tiled-16bpp-rotate-0
[751.459659] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[751.562757] [132/133] (272s left) kms_content_protection (legacy)
[751.702242] Starting subtest: legacy
[751.706839] Subtest legacy: SKIP (0.000s)
[751.837500] [133/133] (272s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[751.942775] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[751.947346] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[752.052336] Closing watchdogs
results: parsing output: 0/ for test: kms_plane_scaling
results: parsing output: 1/ for test: gem_ctx_shared
results: parsing output: 2/ for test: gem_lmem_swapping
results: parsing output: 3/ for test: kms_cursor_legacy
results: parsing output: 4/ for test: gem_exec_store
results: parsing output: 5/ for test: vgem_basic
results: parsing output: 6/ for test: kms_color
results: parsing output: 7/ for test: perf
results: parsing output: 8/ for test: gem_exec_balancer
results: parsing output: 9/ for test: kms_psr2_sf
results: parsing output: 10/ for test: syncobj_wait
results: parsing output: 11/ for test: kms_dither
results: parsing output: 12/ for test: kms_atomic
results: parsing output: 13/ for test: syncobj_wait
results: parsing output: 14/ for test: gem_exec_reloc
results: parsing output: 15/ for test: i915_pm_rpm
results: parsing output: 16/ for test: kms_cursor_crc
results: parsing output: 17/ for test: syncobj_wait
results: parsing output: 18/ for test: kms_pm_rpm
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: sw_sync
results: parsing output: 21/ for test: prime_vgem
results: parsing output: 22/ for test: gem_exec_schedule
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: kms_pm_rpm
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: gem_userptr_blits
results: parsing output: 27/ for test: gem_exec_suspend
results: parsing output: 28/ for test: syncobj_timeline
results: parsing output: 29/ for test: kms_cursor_edge_walk
results: parsing output: 30/ for test: kms_plane
results: parsing output: 31/ for test: gem_partial_pwrite_pread
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_plane
results: parsing output: 34/ for test: kms_pipe_crc_basic
results: parsing output: 35/ for test: i915_pm_freq_api
results: parsing output: 36/ for test: kms_feature_discovery
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_pxp
results: parsing output: 39/ for test: i915_drm_fdinfo
results: parsing output: 40/ for test: kms_lease
results: parsing output: 41/ for test: kms_psr
results: parsing output: 42/ for test: gem_softpin
results: parsing output: 43/ for test: gem_ctx_persistence
results: parsing output: 44/ for test: sriov_basic
results: parsing output: 45/ for test: kms_vrr
results: parsing output: 46/ for test: gem_mmap_gtt
results: parsing output: 47/ for test: kms_psr
results: parsing output: 48/ for test: gem_exec_fence
results: parsing output: 49/ for test: gem_mmap_gtt
results: parsing output: 50/ for test: kms_ccs
results: parsing output: 51/ for test: gem_exec_await
results: parsing output: 52/ for test: kms_plane_lowres
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: kms_ccs
results: parsing output: 55/ for test: syncobj_timeline
results: parsing output: 56/ for test: gem_userptr_blits
results: parsing output: 57/ for test: gem_eio
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_exec_gttfill
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_cursor_crc
results: parsing output: 62/ for test: gem_blits
results: parsing output: 63/ for test: kms_flip_scaled_crc
results: parsing output: 64/ for test: gem_pxp
results: parsing output: 65/ for test: perf_pmu
results: parsing output: 66/ for test: kms_psr
results: parsing output: 67/ for test: perf_pmu
results: parsing output: 68/ for test: i915_query
results: parsing output: 69/ for test: kms_flip_scaled_crc
results: parsing output: 70/ for test: kms_flip
results: parsing output: 71/ for test: syncobj_timeline
results: parsing output: 72/ for test: kms_psr
results: parsing output: 73/ for test: kms_flip
results: parsing output: 74/ for test: gem_exec_schedule
results: parsing output: 75/ for test: gem_softpin
results: parsing output: 76/ for test: api_intel_bb
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: gem_exec_flush
results: parsing output: 79/ for test: gem_workarounds
results: parsing output: 80/ for test: syncobj_timeline
results: parsing output: 81/ for test: gem_exec_reloc
results: parsing output: 82/ for test: tools_test
results: parsing output: 83/ for test: gem_exec_capture
results: parsing output: 84/ for test: kms_chamelium_frames
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_pipe_b_c_ivb
results: parsing output: 87/ for test: kms_invalid_mode
results: parsing output: 88/ for test: kms_flip
results: parsing output: 89/ for test: kms_cursor_legacy
results: parsing output: 90/ for test: kms_big_fb
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: gem_exec_create
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: dmabuf
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_chamelium_hpd
results: parsing output: 100/ for test: kms_ccs
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_big_fb
results: parsing output: 103/ for test: api_intel_allocator
results: parsing output: 104/ for test: kms_ccs
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: kms_sequence
results: parsing output: 107/ for test: syncobj_timeline
results: parsing output: 108/ for test: gem_mmap_wc
results: parsing output: 109/ for test: gen7_exec_parse
results: parsing output: 110/ for test: gem_mmap_offset
results: parsing output: 111/ for test: gem_render_copy
results: parsing output: 112/ for test: kms_psr2_sf
results: parsing output: 113/ for test: kms_addfb_basic
results: parsing output: 114/ for test: gem_exec_reloc
results: parsing output: 115/ for test: prime_mmap
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: gem_userptr_blits
results: parsing output: 119/ for test: kms_ccs
results: parsing output: 120/ for test: intel_hwmon
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: gem_cs_tlb
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_psr2_su
results: parsing output: 125/ for test: gem_ctx_persistence
results: parsing output: 126/ for test: syncobj_wait
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_fbcon_fbt
results: parsing output: 129/ for test: kms_cursor_legacy
results: parsing output: 130/ for test: kms_big_fb
results: parsing output: 131/ for test: kms_content_protection
results: parsing output: 132/ for test: kms_frontbuffer_tracking
Done.