[58.602524] Initializing watchdogs
[58.602570]   /dev/watchdog0
[58.617207] [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.622004] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.624422] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.627813] [001/131] (960s left) gem_exec_await (wide-contexts)
[58.872588] Starting subtest: wide-contexts
[81.823034] Subtest wide-contexts: SUCCESS (22.951s)
[82.021878] [FACT gem_exec_await (wide-contexts)] new: kernel.kmod_is_loaded.vgem: true
[82.026539] [002/131] (937s left) kms_flip (2x-flip-vs-modeset)
[82.172084] Starting subtest: 2x-flip-vs-modeset
[82.181681] Subtest 2x-flip-vs-modeset: SKIP (0.011s)
[82.276899] [003/131] (936s left) syncobj_wait (single-wait-all-submitted)
[82.341858] Starting subtest: single-wait-all-submitted
[82.449045] Subtest single-wait-all-submitted: SUCCESS (0.105s)
[82.537220] [004/131] (936s left) gem_exec_balancer (full-late)
[82.595151] Starting subtest: full-late
[86.828705] Subtest full-late: SUCCESS (4.223s)
[87.141194] [005/131] (932s left) kms_plane (plane-position-covered)
[87.240093] Starting subtest: plane-position-covered
[87.802888] Starting dynamic subtest: pipe-A-plane-1
[89.148893] Dynamic subtest pipe-A-plane-1: SUCCESS (1.346s)
[89.160941] Starting dynamic subtest: pipe-A-plane-2
[90.437044] Dynamic subtest pipe-A-plane-2: SUCCESS (1.285s)
[90.446603] Starting dynamic subtest: pipe-A-plane-3
[91.697350] Dynamic subtest pipe-A-plane-3: SUCCESS (1.261s)
[91.705903] Starting dynamic subtest: pipe-A-plane-4
[93.015428] Dynamic subtest pipe-A-plane-4: SUCCESS (1.318s)
[93.025354] Starting dynamic subtest: pipe-A-plane-5
[93.044387] Dynamic subtest pipe-A-plane-5: SUCCESS (0.028s)
[94.197050] Starting dynamic subtest: pipe-B-plane-1
[95.509447] Dynamic subtest pipe-B-plane-1: SUCCESS (1.320s)
[95.519436] Starting dynamic subtest: pipe-B-plane-2
[96.834636] Dynamic subtest pipe-B-plane-2: SUCCESS (1.326s)
[96.844783] Starting dynamic subtest: pipe-B-plane-3
[98.171056] Dynamic subtest pipe-B-plane-3: SUCCESS (1.334s)
[98.180871] Starting dynamic subtest: pipe-B-plane-4
[99.511751] Dynamic subtest pipe-B-plane-4: SUCCESS (1.340s)
[99.521464] Starting dynamic subtest: pipe-B-plane-5
[99.535804] Dynamic subtest pipe-B-plane-5: SUCCESS (0.023s)
[99.538149] Subtest plane-position-covered: SUCCESS (12.296s)
[100.379392] [006/131] (918s left) gem_readwrite (new-obj)
[100.444134] Subtest new-obj: SKIP (0.000s)
[100.498844] [007/131] (918s left) gem_exercise_blt (fast-copy-emit)
[100.559593] Starting subtest: fast-copy-emit
[100.561945] Starting dynamic subtest: linear-smem-smem-emit
[100.582270] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.022s)
[100.590469] Starting dynamic subtest: xmajor-smem-smem-emit
[100.599071] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.017s)
[100.607115] Starting dynamic subtest: tile4-smem-smem-emit
[100.615856] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.017s)
[100.623689] Starting dynamic subtest: tile64-smem-smem-emit
[100.632734] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.017s)
[100.635106] Subtest fast-copy-emit: SUCCESS (0.073s)
[100.736416] [008/131] (918s left) i915_drm_fdinfo (busy)
[100.785126] Starting subtest: busy
[100.786982] Starting dynamic subtest: rcs0
[100.808792] Dynamic subtest rcs0: SKIP (0.023s)
[100.818219] Starting dynamic subtest: bcs0
[100.822202] Dynamic subtest bcs0: SKIP (0.000s)
[100.830150] Starting dynamic subtest: vcs0
[100.834388] Dynamic subtest vcs0: SKIP (0.001s)
[100.844615] Starting dynamic subtest: vcs1
[100.848683] Dynamic subtest vcs1: SKIP (0.001s)
[100.856209] Starting dynamic subtest: vecs0
[100.860275] Dynamic subtest vecs0: SKIP (0.001s)
[100.867807] Starting dynamic subtest: ccs0
[100.871975] Dynamic subtest ccs0: SKIP (0.000s)
[100.876136] Subtest busy: SKIP (0.030s)
[100.912470] [009/131] (918s left) perf (polling-parameterized)
[101.068439] Starting subtest: polling-parameterized
[121.090908] Subtest polling-parameterized: SUCCESS (20.021s)
[121.139349] [010/131] (898s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[123.092900] Starting subtest: modeset-non-lpsp-stress-no-wait
[123.140936] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.050s)
[123.471422] [011/131] (896s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[123.569793] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[130.270905] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.704s)
[130.425787] [012/131] (889s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[130.525497] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[130.529937] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[130.631292] [013/131] (888s left) dmabuf_sync_file (import-basic)
[130.683363] Starting subtest: import-basic
[130.685671] Subtest import-basic: SUCCESS (0.003s)
[130.756333] [014/131] (888s left) kms_invalid_mode (zero-hdisplay)
[130.852727] Starting subtest: zero-hdisplay
[130.855010] Starting dynamic subtest: pipe-A-eDP-1
[131.140034] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s)
[131.148624] Starting dynamic subtest: pipe-B-eDP-1
[131.150588] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[131.161233] Starting dynamic subtest: pipe-C-eDP-1
[131.163602] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[131.176999] Starting dynamic subtest: pipe-D-eDP-1
[131.179388] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[131.181835] Subtest zero-hdisplay: SUCCESS (0.293s)
[131.922910] [015/131] (887s left) kms_big_fb (linear-32bpp-rotate-90)
[132.039667] Starting subtest: linear-32bpp-rotate-90
[132.058644] Subtest linear-32bpp-rotate-90: SKIP (0.019s)
[132.175273] [016/131] (887s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite)
[132.271648] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite
[137.538872] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.270s)
[138.735486] [017/131] (881s left) gem_mmap_wc (write-gtt-read-wc)
[138.796561] Subtest write-gtt-read-wc: SKIP (0.000s)
[138.855337] [018/131] (880s left) kms_properties (crtc-properties-atomic)
[138.958230] Starting subtest: crtc-properties-atomic
[138.960586] Starting dynamic subtest: pipe-A-eDP-1
[139.394416] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.435s)
[139.404898] Starting dynamic subtest: pipe-B-eDP-1
[140.577585] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.184s)
[140.587542] Starting dynamic subtest: pipe-C-eDP-1
[141.711370] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.130s)
[141.721400] Starting dynamic subtest: pipe-D-eDP-1
[142.844698] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.134s)
[142.846649] Subtest crtc-properties-atomic: SUCCESS (3.887s)
[143.668495] [019/131] (876s left) prime_mmap (test_dup)
[143.726055] Starting subtest: test_dup
[143.728210] Starting dynamic subtest: test_dup-smem
[143.755365] Dynamic subtest test_dup-smem: SUCCESS (0.031s)
[143.757748] Subtest test_dup: SUCCESS (0.032s)
[143.832797] [020/131] (876s left) kms_cursor_crc (cursor-random-128x42)
[144.046787] Starting subtest: cursor-random-128x42
[144.094699] Subtest cursor-random-128x42: SKIP (0.042s)
[144.302500] [021/131] (875s left) gem_eio (reset-stress)
[144.545311] Starting subtest: reset-stress
[144.547611] Starting dynamic subtest: render
[149.474572] Dynamic subtest render: SUCCESS (4.928s)
[149.490564] Starting dynamic subtest: bsd1
[167.487038] Dynamic subtest bsd1: SUCCESS (18.008s)
[167.503402] Starting dynamic subtest: bsd2
[185.438918] Dynamic subtest bsd2: SUCCESS (17.950s)
[185.454793] Starting dynamic subtest: blt
[185.458824] Dynamic subtest blt: SKIP (0.000s)
[185.467298] Starting dynamic subtest: vebox
[203.434039] Dynamic subtest vebox: SUCCESS (17.993s)
[203.436671] Subtest reset-stress: SUCCESS (58.883s)
[204.924803] [022/131] (815s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[205.041449] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[205.045640] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[205.146058] [023/131] (814s left) gem_pxp (verify-pxp-stale-buf-execution)
[205.262943] Starting subtest: verify-pxp-stale-buf-execution
[206.325553] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.064s)
[206.436823] [024/131] (813s left) syncobj_timeline (wait-all-for-submit-snapshot)
[206.486793] Starting subtest: wait-all-for-submit-snapshot
[206.568573] Subtest wait-all-for-submit-snapshot: SUCCESS (0.083s)
[206.657681] [025/131] (813s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[206.747557] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[214.084140] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.340s)
[214.211276] [026/131] (805s left) perf_pmu (render-node-busy)
[214.275616] Starting subtest: render-node-busy
[214.277860] Starting dynamic subtest: rcs0
[214.835263] Dynamic subtest rcs0: SUCCESS (0.559s)
[214.846829] Starting dynamic subtest: bcs0
[215.396422] Dynamic subtest bcs0: SUCCESS (0.560s)
[215.408524] Starting dynamic subtest: vcs0
[216.916895] Dynamic subtest vcs0: SUCCESS (1.518s)
[216.928872] Starting dynamic subtest: vcs1
[218.900993] Dynamic subtest vcs1: SUCCESS (1.982s)
[218.913028] Starting dynamic subtest: vecs0
[220.884768] Dynamic subtest vecs0: SUCCESS (1.982s)
[220.897207] Starting dynamic subtest: ccs0
[221.448322] Dynamic subtest ccs0: SUCCESS (0.563s)
[221.451065] Subtest render-node-busy: SUCCESS (7.173s)
[221.527998] [027/131] (798s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[221.658443] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[222.618357] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.958s)
[223.425870] [028/131] (796s left) perf (blocking)
[223.525736] Starting subtest: blocking
[223.528160] Starting dynamic subtest: 0-rcs0
[233.534598] Dynamic subtest 0-rcs0: SUCCESS (10.007s)
[233.547340] Starting dynamic subtest: 1-vecs0
[243.557424] Dynamic subtest 1-vecs0: SUCCESS (10.022s)
[243.559787] Subtest blocking: SUCCESS (20.031s)
[243.606482] [029/131] (776s left) kms_properties (colorop-properties-atomic)
[243.697050] Starting subtest: colorop-properties-atomic
[243.699423] Starting dynamic subtest: pipe-A-eDP-1
[244.031918] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.334s)
[244.042180] Starting dynamic subtest: pipe-B-eDP-1
[245.094184] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.060s)
[245.111613] Starting dynamic subtest: pipe-C-eDP-1
[246.131773] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.037s)
[246.141214] Starting dynamic subtest: pipe-D-eDP-1
[247.157692] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.026s)
[247.160042] Subtest colorop-properties-atomic: SUCCESS (3.462s)
[247.956967] [030/131] (772s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc)
[248.052366] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc
[252.335184] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.287s)
[253.483932] [031/131] (766s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[253.585229] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[253.587529] Starting dynamic subtest: pipe-A-eDP-1
[253.611374] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[253.622846] Starting dynamic subtest: pipe-B-eDP-1
[253.644748] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[253.653996] Starting dynamic subtest: pipe-C-eDP-1
[253.676027] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[253.685131] Starting dynamic subtest: pipe-D-eDP-1
[253.707811] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[253.711910] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[255.740711] [032/131] (764s left) kms_cursor_crc (cursor-suspend)
[255.867721] Starting subtest: cursor-suspend
[255.870037] Starting dynamic subtest: pipe-A-eDP-1
[289.941963] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.114s)
[289.952321] Starting dynamic subtest: pipe-D-eDP-1
[324.909681] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.548s)
[324.912041] Subtest cursor-suspend: SUCCESS (8.665s)
[331.770396] [033/131] (694s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[332.175228] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[332.973088] [034/131] (693s left) syncobj_wait (invalid-reset-bad-pad)
[333.027403] Starting subtest: invalid-reset-bad-pad
[333.029764] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[333.111188] [035/131] (693s left) kms_psr (psr2-sprite-plane-onoff)
[333.200556] Starting subtest: psr2-sprite-plane-onoff
[333.202875] Starting dynamic subtest: eDP-1
[334.888146] Dynamic subtest eDP-1: SUCCESS (1.683s)
[334.890101] Subtest psr2-sprite-plane-onoff: SUCCESS (1.684s)
[335.753478] [036/131] (690s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf)
[335.851599] Starting subtest: psr2-overlay-plane-update-continuous-sf
[335.853840] Starting dynamic subtest: pipe-A-eDP-1
[336.986419] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.134s)
[336.998318] Starting dynamic subtest: pipe-B-eDP-1
[338.701317] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.712s)
[338.703500] Subtest psr2-overlay-plane-update-continuous-sf: SUCCESS (2.848s)
[339.554671] [037/131] (687s left) gem_exec_fence (syncobj-signal)
[340.009219] Starting subtest: syncobj-signal
[340.015418] Subtest syncobj-signal: SUCCESS (0.005s)
[341.373071] [038/131] (685s left) kms_scaling_modes (scaling-mode-none)
[341.480527] Starting subtest: scaling-mode-none
[341.482784] Starting dynamic subtest: pipe-A-eDP-1
[341.574945] Dynamic subtest pipe-A-eDP-1: SKIP (0.094s)
[341.587281] Starting dynamic subtest: pipe-B-eDP-1
[341.610310] Dynamic subtest pipe-B-eDP-1: SKIP (0.032s)
[341.620340] Starting dynamic subtest: pipe-C-eDP-1
[341.642504] Dynamic subtest pipe-C-eDP-1: SKIP (0.032s)
[341.652356] Starting dynamic subtest: pipe-D-eDP-1
[341.677917] Dynamic subtest pipe-D-eDP-1: SKIP (0.034s)
[341.682397] Subtest scaling-mode-none: SKIP (0.198s)
[341.795300] [039/131] (684s left) drm_read (fault-buffer)
[341.937820] Starting subtest: fault-buffer
[341.940319] Subtest fault-buffer: SUCCESS (0.001s)
[342.066699] [040/131] (684s left) gem_create (create-valid-nonaligned)
[342.113517] Starting subtest: create-valid-nonaligned
[342.115757] Subtest create-valid-nonaligned: SUCCESS (0.000s)
[342.313164] [041/131] (684s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[342.367629] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[342.425381] [042/131] (684s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[342.472356] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[342.474688] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[342.585916] [043/131] (684s left) kms_psr (fbc-pr-sprite-mmap-cpu)
[342.672599] Starting subtest: fbc-pr-sprite-mmap-cpu
[342.677037] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s)
[342.748135] [044/131] (684s left) api_intel_bb (delta-check)
[342.809770] Starting subtest: delta-check
[342.813452] Subtest delta-check: SUCCESS (0.006s)
[342.928824] [045/131] (684s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[342.993022] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[343.055124] [046/131] (684s left) gem_request_retire (retire-vma-not-inactive)
[343.111780] Starting subtest: retire-vma-not-inactive
[343.169915] Subtest retire-vma-not-inactive: SUCCESS (0.057s)
[343.293606] [047/131] (683s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[343.341497] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[343.449463] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.106s)
[343.526970] [048/131] (683s left) kms_psr (pr-sprite-render)
[343.617275] Starting subtest: pr-sprite-render
[343.621768] Subtest pr-sprite-render: SKIP (0.000s)
[343.698047] [049/131] (683s left) kms_flip (plain-flip-fb-recreate-interruptible)
[343.795408] Starting subtest: plain-flip-fb-recreate-interruptible
[343.797575] Starting dynamic subtest: A-eDP1
[352.615396] Dynamic subtest A-eDP1: SUCCESS (8.815s)
[352.628723] Starting dynamic subtest: B-eDP1
[361.441200] Dynamic subtest B-eDP1: SUCCESS (8.822s)
[361.458708] Starting dynamic subtest: C-eDP1
[370.271290] Dynamic subtest C-eDP1: SUCCESS (8.824s)
[370.284432] Starting dynamic subtest: D-eDP1
[379.103144] Dynamic subtest D-eDP1: SUCCESS (8.826s)
[379.107716] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.300s)
[380.287539] [050/131] (646s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[380.392301] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[380.396560] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[380.488624] [051/131] (646s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[380.541702] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[380.649317] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.107s)
[380.738943] [052/131] (646s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[380.844621] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[380.849278] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[380.922606] [053/131] (646s left) kms_cdclk (plane-scaling)
[381.013287] Starting subtest: plane-scaling
[381.015516] Starting dynamic subtest: pipe-A-eDP-1
[381.304464] Dynamic subtest pipe-A-eDP-1: SKIP (0.289s)
[381.315201] Starting dynamic subtest: pipe-B-eDP-1
[381.319948] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[381.329865] Starting dynamic subtest: pipe-C-eDP-1
[381.334569] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[381.344405] Starting dynamic subtest: pipe-D-eDP-1
[381.348519] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[381.352649] Subtest plane-scaling: SKIP (0.297s)
[382.108354] [054/131] (645s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[382.215322] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[382.219516] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[382.308449] [055/131] (645s left) perf (buffer-fill)
[382.391853] Starting subtest: buffer-fill
[382.394293] Starting dynamic subtest: 0-rcs0
[384.661643] Dynamic subtest 0-rcs0: SUCCESS (2.267s)
[384.672693] Starting dynamic subtest: 1-vcs0
[389.102398] Dynamic subtest 1-vcs0: SUCCESS (4.439s)
[389.105628] Subtest buffer-fill: SUCCESS (6.709s)
[389.155049] [056/131] (638s left) sysfs_defaults (readonly)
[389.219994] Starting subtest: readonly
[389.222829] Starting dynamic subtest: vecs0
[389.225307] Dynamic subtest vecs0: SUCCESS (0.000s)
[389.237171] Starting dynamic subtest: ccs0
[389.239101] Dynamic subtest ccs0: SUCCESS (0.000s)
[389.250176] Starting dynamic subtest: vcs0
[389.252167] Dynamic subtest vcs0: SUCCESS (0.000s)
[389.262082] Starting dynamic subtest: bcs0
[389.264275] Dynamic subtest bcs0: SUCCESS (0.000s)
[389.273852] Starting dynamic subtest: rcs0
[389.275777] Dynamic subtest rcs0: SUCCESS (0.000s)
[389.285689] Starting dynamic subtest: vcs1
[389.287872] Dynamic subtest vcs1: SUCCESS (0.000s)
[389.290057] Subtest readonly: SUCCESS (0.006s)
[389.330669] [057/131] (638s left) kms_rotation_crc (exhaust-fences)
[389.427192] Starting subtest: exhaust-fences
[389.431402] Subtest exhaust-fences: SKIP (0.000s)
[389.516696] [058/131] (638s left) gem_mmap_gtt (isolation)
[389.573472] Subtest isolation: SKIP (0.000s)
[389.638178] [059/131] (637s left) gem_exec_schedule (lateslice)
[389.716538] Starting subtest: lateslice
[389.718395] Starting dynamic subtest: rcs0
[389.727101] Dynamic subtest rcs0: SUCCESS (0.021s)
[389.737208] Starting dynamic subtest: bcs0
[389.745838] Dynamic subtest bcs0: SUCCESS (0.018s)
[389.756654] Starting dynamic subtest: vcs0
[389.764881] Dynamic subtest vcs0: SUCCESS (0.018s)
[389.775494] Starting dynamic subtest: vcs1
[389.785056] Dynamic subtest vcs1: SUCCESS (0.020s)
[389.798007] Starting dynamic subtest: vecs0
[389.803061] Dynamic subtest vecs0: SUCCESS (0.018s)
[389.812874] Starting dynamic subtest: ccs0
[389.821031] Dynamic subtest ccs0: SUCCESS (0.017s)
[389.823288] Subtest lateslice: SUCCESS (0.116s)
[391.349382] [060/131] (636s left) gem_userptr_blits (map-fixed-invalidate-busy)
[391.426657] Starting subtest: map-fixed-invalidate-busy
[391.430956] Subtest map-fixed-invalidate-busy: SKIP (0.000s)
[391.559868] [061/131] (636s left) gem_mmap_wc (write-prefaulted)
[391.619348] Subtest write-prefaulted: SKIP (0.000s)
[391.678879] [062/131] (636s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[391.731267] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[391.832130] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.101s)
[391.908213] [063/131] (635s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[392.004941] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[392.007268] Starting dynamic subtest: pipe-A-eDP-1
[392.028567] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[392.039848] Starting dynamic subtest: pipe-B-eDP-1
[392.060412] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[392.069941] Starting dynamic subtest: pipe-C-eDP-1
[392.090913] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[392.100853] Starting dynamic subtest: pipe-D-eDP-1
[392.121833] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[392.125972] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[394.273067] [064/131] (633s left) kms_dirtyfb (fbc-dirtyfb-ioctl)
[394.369647] Starting subtest: fbc-dirtyfb-ioctl
[394.371862] Starting dynamic subtest: A-eDP-1
[396.959852] Dynamic subtest A-eDP-1: SUCCESS (2.589s)
[396.961974] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.590s)
[397.763153] [065/131] (630s left) gem_ctx_isolation (preservation-s3)
[397.830490] Starting subtest: preservation-S3
[397.832721] Starting dynamic subtest: rcs0
[414.503399] Dynamic subtest rcs0: SUCCESS (1.695s)
[414.514709] Starting dynamic subtest: bcs0
[431.515542] Dynamic subtest bcs0: SUCCESS (1.708s)
[431.527528] Starting dynamic subtest: vcs0
[448.521882] Dynamic subtest vcs0: SUCCESS (3.481s)
[448.532331] Starting dynamic subtest: vcs1
[466.507641] Dynamic subtest vcs1: SUCCESS (5.053s)
[466.518937] Starting dynamic subtest: vecs0
[484.502756] Dynamic subtest vecs0: SUCCESS (4.992s)
[484.514787] Starting dynamic subtest: ccs0
[502.502157] Dynamic subtest ccs0: SUCCESS (3.125s)
[502.504621] Subtest preservation-S3: SUCCESS (20.060s)
[509.749106] [066/131] (525s left) kms_content_protection (suspend-resume)
[509.895938] Starting subtest: suspend-resume
[509.900505] Subtest suspend-resume: SKIP (0.000s)
[510.017256] [067/131] (524s left) kms_psr (fbc-psr-cursor-mmap-cpu)
[510.112317] Starting subtest: fbc-psr-cursor-mmap-cpu
[510.114516] Starting dynamic subtest: eDP-1
[510.118568] Dynamic subtest eDP-1: SKIP (0.000s)
[510.122607] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.001s)
[510.194518] [068/131] (524s left) gen7_exec_parse (basic-allowed)
[510.246656] Subtest basic-allowed: SKIP (0.000s)
[510.317118] [069/131] (524s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[510.411433] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[514.000459] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.587s)
[515.165623] [070/131] (519s left) kms_draw_crc (draw-method-mmap-gtt)
[515.260568] Starting subtest: draw-method-mmap-gtt
[515.264959] Subtest draw-method-mmap-gtt: SKIP (0.000s)
[515.361823] [071/131] (519s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[515.461741] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[516.499510] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.035s)
[516.613190] [072/131] (518s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu)
[516.704707] Starting subtest: psr-rgb565-draw-mmap-cpu
[523.499591] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.790s)
[523.624624] [073/131] (511s left) gem_softpin (allocator-basic-reserve)
[523.684028] Starting subtest: allocator-basic-reserve
[523.756489] Subtest allocator-basic-reserve: SUCCESS (0.072s)
[523.882547] [074/131] (511s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[523.944654] Starting subtest: y-tiled-to-vebox-yf-tiled
[523.948706] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[524.132472] [075/131] (511s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[524.226441] Starting subtest: compare-crc-sanitycheck-nv12
[524.228576] Starting dynamic subtest: pipe-A-eDP-1
[524.946042] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.716s)
[524.956211] Starting dynamic subtest: pipe-B-eDP-1
[526.228053] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.282s)
[526.239259] Starting dynamic subtest: pipe-C-eDP-1
[527.469795] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.239s)
[527.481262] Starting dynamic subtest: pipe-D-eDP-1
[528.685706] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.213s)
[528.688057] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.456s)
[529.532196] [076/131] (505s left) gen7_exec_parse (batch-without-end)
[529.595226] Subtest batch-without-end: SKIP (0.000s)
[529.660649] [077/131] (505s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[529.758679] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[529.763149] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[529.860762] [078/131] (505s left) kms_addfb_basic (basic)
[529.919055] Starting subtest: basic
[529.921133] Subtest basic: SUCCESS (0.000s)
[530.056451] [079/131] (505s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[530.147035] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt
[530.151065] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[530.250430] [080/131] (505s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[530.366839] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[530.371485] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[530.480823] [081/131] (505s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[530.569732] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[530.582904] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.011s)
[530.666506] [082/131] (504s left) kms_psr (psr-sprite-plane-move)
[530.751757] Starting subtest: psr-sprite-plane-move
[530.753503] Starting dynamic subtest: eDP-1
[532.568191] Dynamic subtest eDP-1: SUCCESS (1.815s)
[532.570683] Subtest psr-sprite-plane-move: SUCCESS (1.816s)
[533.390707] [083/131] (502s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[533.653113] Starting subtest: parallel-dmabuf-import-out-fence
[535.004678] Subtest parallel-dmabuf-import-out-fence: SUCCESS (1.351s)
[535.111551] [084/131] (500s left) i915_pm_rpm (system-suspend)
[537.047979] Starting subtest: system-suspend
[555.258738] Subtest system-suspend: SUCCESS (3.265s)
[560.662117] [085/131] (480s left) gem_exec_reloc (basic-wc-read-active)
[560.744734] Subtest basic-wc-read-active: SKIP (0.000s)
[560.814026] [086/131] (480s left) i915_suspend (basic-s3-without-i915)
[560.852776] Starting subtest: basic-s3-without-i915
[564.122690] Subtest basic-s3-without-i915: SKIP (3.258s)
[565.772532] [087/131] (475s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs)
[565.871364] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs
[565.873615] Starting dynamic subtest: pipe-A-eDP-1
[568.050655] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.176s)
[568.060527] Starting dynamic subtest: pipe-B-eDP-1
[570.442352] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.391s)
[570.451208] Starting dynamic subtest: pipe-C-eDP-1
[572.549461] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.103s)
[572.558728] Starting dynamic subtest: pipe-D-eDP-1
[574.837830] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.286s)
[574.839716] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (8.961s)
[576.064545] [088/131] (464s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt)
[576.173492] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt
[576.178188] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[576.257390] [089/131] (464s left) syncobj_wait (invalid-reset-one-illegal-handle)
[576.321533] Starting subtest: invalid-reset-one-illegal-handle
[576.323812] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[576.411835] [090/131] (464s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[576.518190] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[576.520476] Starting dynamic subtest: pipe-A-eDP-1
[576.545873] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[576.556300] Starting dynamic subtest: pipe-B-eDP-1
[576.580514] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[576.589766] Starting dynamic subtest: pipe-C-eDP-1
[576.613815] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[576.622959] Starting dynamic subtest: pipe-D-eDP-1
[576.647553] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[576.651708] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[578.817846] [091/131] (462s left) kms_pm_dc (dc9-dpms)
[579.917299] Starting subtest: dc9-dpms
[581.353245] Subtest dc9-dpms: SUCCESS (1.436s)
[581.424064] [092/131] (459s left) kms_plane_multiple (tiling-4)
[581.509216] Starting subtest: tiling-4
[581.511116] Starting dynamic subtest: pipe-A-eDP-1
[585.259523] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.747s)
[585.269221] Starting dynamic subtest: pipe-B-eDP-1
[589.683326] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.421s)
[589.694004] Starting dynamic subtest: pipe-C-eDP-1
[594.118417] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.430s)
[594.133695] Starting dynamic subtest: pipe-D-eDP-1
[598.493575] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.377s)
[598.495751] Subtest tiling-4: SUCCESS (16.981s)
[599.310401] [093/131] (441s left) gem_exec_fence (syncobj-timeline-unused-fence)
[599.878002] Starting subtest: syncobj-timeline-unused-fence
[599.883833] Subtest syncobj-timeline-unused-fence: SUCCESS (0.006s)
[600.924908] [094/131] (440s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-upscaling)
[601.014512] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-upscaling
[601.018551] Subtest flip-64bpp-ytile-to-16bpp-ytile-upscaling: SKIP (0.000s)
[601.108782] [095/131] (440s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[601.164108] Starting subtest: wait-all-for-submit-delayed-submit
[601.265037] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.102s)
[601.347665] [096/131] (439s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[601.434952] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[601.439239] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[601.529730] [097/131] (439s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[601.653669] Starting subtest: cursor-vs-flip-varying-size
[632.922450] Subtest cursor-vs-flip-varying-size: SUCCESS (31.259s)
[633.731853] [098/131] (407s left) gem_exec_schedule (reorder-wide)
[633.923813] Subtest reorder-wide: SKIP (0.000s)
[634.115747] [099/131] (407s left) syncobj_timeline (invalid-transfer-bad-pad)
[634.173178] Starting subtest: invalid-transfer-bad-pad
[634.175209] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[634.258284] [100/131] (407s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu)
[634.370333] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu
[641.153691] Subtest fbcpsr-rgb565-draw-mmap-cpu: SUCCESS (6.783s)
[641.279624] [101/131] (400s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier)
[641.376137] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier
[641.380449] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier: SKIP (0.000s)
[641.449432] [102/131] (400s left) perf_pmu (busy)
[641.497053] Starting subtest: busy
[641.499405] Starting dynamic subtest: rcs0
[642.079723] Dynamic subtest rcs0: SUCCESS (0.585s)
[642.092024] Starting dynamic subtest: bcs0
[642.647921] Dynamic subtest bcs0: SUCCESS (0.565s)
[642.660033] Starting dynamic subtest: vcs0
[643.853597] Dynamic subtest vcs0: SUCCESS (1.202s)
[643.864397] Starting dynamic subtest: vcs1
[645.837804] Dynamic subtest vcs1: SUCCESS (1.980s)
[645.850010] Starting dynamic subtest: vecs0
[647.823637] Dynamic subtest vecs0: SUCCESS (1.982s)
[647.836009] Starting dynamic subtest: ccs0
[648.397772] Dynamic subtest ccs0: SUCCESS (0.572s)
[648.400433] Subtest busy: SUCCESS (6.902s)
[648.549181] [103/131] (393s left) kms_vblank (ts-continuation-dpms-suspend)
[648.651217] Starting subtest: ts-continuation-dpms-suspend
[648.653458] Starting dynamic subtest: pipe-A-eDP-1
[666.031592] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.244s)
[666.046444] Starting dynamic subtest: pipe-D-eDP-1
[684.014829] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.888s)
[684.017156] Subtest ts-continuation-dpms-suspend: SUCCESS (5.137s)
[690.834297] [104/131] (356s left) gem_exec_capture (userptr)
[690.916988] Starting subtest: userptr
[691.753479] Subtest userptr: SUCCESS (0.828s)
[691.868351] [105/131] (355s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[691.969249] Starting subtest: pr-overlay-primary-update-sf-dmg-area
[691.973365] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[692.045220] [106/131] (355s left) kms_frontbuffer_tracking (fbcpsr-1p-rte)
[692.143903] Starting subtest: fbcpsr-1p-rte
[699.139064] Subtest fbcpsr-1p-rte: SUCCESS (6.985s)
[699.301067] [107/131] (348s left) api_intel_allocator (simple-allocator)
[699.359931] Starting subtest: simple-allocator
[699.362307] Starting dynamic subtest: basic
[699.364644] Dynamic subtest basic: SUCCESS (0.003s)
[699.376917] Starting dynamic subtest: parallel-one
[699.551540] Dynamic subtest parallel-one: SUCCESS (0.187s)
[699.561636] Starting dynamic subtest: print
[699.564659] Dynamic subtest print: SUCCESS (0.000s)
[699.585485] Starting dynamic subtest: reuse
[699.588128] Dynamic subtest reuse: SUCCESS (0.000s)
[699.604515] Starting dynamic subtest: reserve
[699.606883] Dynamic subtest reserve: SUCCESS (0.000s)
[699.616274] Starting dynamic subtest: fork-reopen-allocator
[699.618644] Dynamic subtest fork-reopen-allocator: SUCCESS (0.012s)
[699.620951] Subtest simple-allocator: SUCCESS (0.210s)
[699.693673] [108/131] (348s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[699.794102] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[700.885790] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.090s)
[701.000217] [109/131] (346s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[701.088649] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[701.092048] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[701.187513] [110/131] (346s left) gem_ctx_engines (execute-allforone)
[701.243275] Starting subtest: execute-allforone
[701.265146] Subtest execute-allforone: SUCCESS (0.022s)
[703.150406] [111/131] (344s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled)
[703.205103] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[703.207403] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[703.297472] [112/131] (344s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[703.383083] Starting subtest: fbc-modesetfrombusy
[707.120076] Subtest fbc-modesetfrombusy: SUCCESS (3.737s)
[708.355382] [113/131] (339s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-upscaling)
[708.458718] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-upscaling
[708.463186] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-upscaling: SKIP (0.000s)
[708.535745] [114/131] (339s left) kms_async_flips (crc)
[708.627789] Starting subtest: crc
[709.003092] Starting dynamic subtest: pipe-A-eDP-1
[711.896538] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.892s)
[712.273402] Starting dynamic subtest: pipe-B-eDP-1
[715.147692] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.880s)
[715.533978] Starting dynamic subtest: pipe-C-eDP-1
[718.465256] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.940s)
[718.828602] Starting dynamic subtest: pipe-D-eDP-1
[721.691306] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.870s)
[721.693594] Subtest crc: SUCCESS (13.058s)
[722.873838] [115/131] (325s left) gem_flink_basic (bad-open)
[722.932026] Starting subtest: bad-open
[722.934243] Subtest bad-open: SUCCESS (0.000s)
[723.015056] [116/131] (325s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[723.118643] Starting subtest: y-tiled-64bpp-rotate-180
[723.122795] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[723.201318] [117/131] (325s left) perf (non-system-wide-paranoid)
[723.330269] Starting subtest: non-system-wide-paranoid
[723.356224] Subtest non-system-wide-paranoid: SUCCESS (0.028s)
[723.417085] [118/131] (324s left) gem_ccs (ctrl-surf-copy)
[723.480338] Starting subtest: ctrl-surf-copy
[723.485039] Subtest ctrl-surf-copy: SKIP (0.000s)
[723.588861] [119/131] (324s left) kms_atomic_transition (modeset-transition)
[723.681185] Starting subtest: modeset-transition
[723.683512] Starting dynamic subtest: 1x-outputs
[734.522323] Dynamic subtest 1x-outputs: SUCCESS (10.837s)
[734.524972] Subtest modeset-transition: SUCCESS (10.838s)
[735.380524] [120/131] (312s left) i915_getparams_basic (basic-subslice-total)
[735.432948] Starting subtest: basic-subslice-total
[735.437003] Subtest basic-subslice-total: SUCCESS (0.000s)
[735.515547] [121/131] (312s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[735.613837] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[735.616107] Starting dynamic subtest: pipe-A
[735.678400] Dynamic subtest pipe-A: SUCCESS (0.067s)
[735.689254] Starting dynamic subtest: pipe-B
[736.798985] Dynamic subtest pipe-B: SUCCESS (1.119s)
[736.810632] Starting dynamic subtest: pipe-C
[737.914972] Dynamic subtest pipe-C: SUCCESS (1.114s)
[737.925614] Starting dynamic subtest: pipe-D
[739.056779] Dynamic subtest pipe-D: SUCCESS (1.140s)
[739.059116] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.444s)
[740.212836] [122/131] (308s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[740.315450] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[747.266369] Subtest psr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.949s)
[747.429623] [123/131] (301s left) kms_chamelium_frames (dp-crc-multiple)
[747.808445] Subtest dp-crc-multiple: SKIP (0.000s)
[748.661478] [124/131] (299s left) gem_eio (wait-immediate)
[748.879866] Starting subtest: wait-immediate
[749.242209] Subtest wait-immediate: SUCCESS (0.365s)
[749.371004] [125/131] (299s left) kms_color (ctm-max)
[749.475692] Starting subtest: ctm-max
[749.477808] Starting dynamic subtest: pipe-A-eDP-1
[750.208183] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.731s)
[750.218303] Starting dynamic subtest: pipe-B-eDP-1
[751.621950] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.413s)
[751.634505] Starting dynamic subtest: pipe-C-eDP-1
[752.987945] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.365s)
[752.998303] Starting dynamic subtest: pipe-D-eDP-1
[754.324286] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.334s)
[754.326205] Subtest ctm-max: SUCCESS (4.847s)
[755.126360] [126/131] (293s left) kms_cursor_crc (cursor-offscreen-256x85)
[755.391067] Starting subtest: cursor-offscreen-256x85
[755.438791] Subtest cursor-offscreen-256x85: SKIP (0.044s)
[755.599358] [127/131] (293s left) kms_lease (cursor-implicit-plane)
[755.693669] Starting subtest: cursor-implicit-plane
[755.696196] Starting dynamic subtest: pipe-A-eDP-1
[756.150384] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.458s)
[756.164569] Starting dynamic subtest: pipe-B-eDP-1
[757.262342] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.107s)
[757.273018] Starting dynamic subtest: pipe-C-eDP-1
[758.369843] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.105s)
[758.380902] Starting dynamic subtest: pipe-D-eDP-1
[759.501713] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.129s)
[759.503503] Subtest cursor-implicit-plane: SUCCESS (3.806s)
[760.362263] [128/131] (288s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[760.466711] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[760.471148] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[760.564088] [129/131] (288s left) gem_ctx_persistence (hang)
[760.645644] Starting subtest: hang
[760.650180] Subtest hang: SKIP (0.000s)
[760.761008] [130/131] (288s left) gem_exec_whisper (basic-fds-priority)
[760.824485] Starting subtest: basic-fds-priority
[784.480378] Subtest basic-fds-priority: SUCCESS (23.642s)
[784.670286] [131/131] (264s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[784.790951] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[785.793880] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.002s)
[785.918397] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_await
results: parsing output: 1/ for test: kms_flip
results: parsing output: 2/ for test: syncobj_wait
results: parsing output: 3/ for test: gem_exec_balancer
results: parsing output: 4/ for test: kms_plane
results: parsing output: 5/ for test: gem_readwrite
results: parsing output: 6/ for test: gem_exercise_blt
results: parsing output: 7/ for test: i915_drm_fdinfo
results: parsing output: 8/ for test: perf
results: parsing output: 9/ for test: kms_pm_rpm
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: dmabuf_sync_file
results: parsing output: 13/ for test: kms_invalid_mode
results: parsing output: 14/ for test: kms_big_fb
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: gem_mmap_wc
results: parsing output: 17/ for test: kms_properties
results: parsing output: 18/ for test: prime_mmap
results: parsing output: 19/ for test: kms_cursor_crc
results: parsing output: 20/ for test: gem_eio
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: gem_pxp
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: perf_pmu
results: parsing output: 26/ for test: kms_cursor_legacy
results: parsing output: 27/ for test: perf
results: parsing output: 28/ for test: kms_properties
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_ccs
results: parsing output: 31/ for test: kms_cursor_crc
results: parsing output: 32/ for test: kms_chamelium_hpd
results: parsing output: 33/ for test: syncobj_wait
results: parsing output: 34/ for test: kms_psr
results: parsing output: 35/ for test: kms_psr2_sf
results: parsing output: 36/ for test: gem_exec_fence
results: parsing output: 37/ for test: kms_scaling_modes
results: parsing output: 38/ for test: drm_read
results: parsing output: 39/ for test: gem_create
results: parsing output: 40/ for test: gem_mmap_gtt
results: parsing output: 41/ for test: syncobj_timeline
results: parsing output: 42/ for test: kms_psr
results: parsing output: 43/ for test: api_intel_bb
results: parsing output: 44/ for test: kms_pipe_b_c_ivb
results: parsing output: 45/ for test: gem_request_retire
results: parsing output: 46/ for test: syncobj_wait
results: parsing output: 47/ for test: kms_psr
results: parsing output: 48/ for test: kms_flip
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: syncobj_timeline
results: parsing output: 51/ for test: kms_flip_scaled_crc
results: parsing output: 52/ for test: kms_cdclk
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: perf
results: parsing output: 55/ for test: sysfs_defaults
results: parsing output: 56/ for test: kms_rotation_crc
results: parsing output: 57/ for test: gem_mmap_gtt
results: parsing output: 58/ for test: gem_exec_schedule
results: parsing output: 59/ for test: gem_userptr_blits
results: parsing output: 60/ for test: gem_mmap_wc
results: parsing output: 61/ for test: syncobj_timeline
results: parsing output: 62/ for test: kms_ccs
results: parsing output: 63/ for test: kms_dirtyfb
results: parsing output: 64/ for test: gem_ctx_isolation
results: parsing output: 65/ for test: kms_content_protection
results: parsing output: 66/ for test: kms_psr
results: parsing output: 67/ for test: gen7_exec_parse
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_draw_crc
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: gem_softpin
results: parsing output: 73/ for test: gem_render_copy
results: parsing output: 74/ for test: kms_pipe_crc_basic
results: parsing output: 75/ for test: gen7_exec_parse
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_addfb_basic
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_flip
results: parsing output: 81/ for test: kms_psr
results: parsing output: 82/ for test: gem_exec_balancer
results: parsing output: 83/ for test: i915_pm_rpm
results: parsing output: 84/ for test: gem_exec_reloc
results: parsing output: 85/ for test: i915_suspend
results: parsing output: 86/ for test: kms_ccs
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: syncobj_wait
results: parsing output: 89/ for test: kms_ccs
results: parsing output: 90/ for test: kms_pm_dc
results: parsing output: 91/ for test: kms_plane_multiple
results: parsing output: 92/ for test: gem_exec_fence
results: parsing output: 93/ for test: kms_flip_scaled_crc
results: parsing output: 94/ for test: syncobj_wait
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_cursor_legacy
results: parsing output: 97/ for test: gem_exec_schedule
results: parsing output: 98/ for test: syncobj_timeline
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_plane
results: parsing output: 101/ for test: perf_pmu
results: parsing output: 102/ for test: kms_vblank
results: parsing output: 103/ for test: gem_exec_capture
results: parsing output: 104/ for test: kms_psr2_sf
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: api_intel_allocator
results: parsing output: 107/ for test: kms_big_fb
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: gem_ctx_engines
results: parsing output: 110/ for test: syncobj_wait
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_flip_scaled_crc
results: parsing output: 113/ for test: kms_async_flips
results: parsing output: 114/ for test: gem_flink_basic
results: parsing output: 115/ for test: kms_big_fb
results: parsing output: 116/ for test: perf
results: parsing output: 117/ for test: gem_ccs
results: parsing output: 118/ for test: kms_atomic_transition
results: parsing output: 119/ for test: i915_getparams_basic
results: parsing output: 120/ for test: kms_plane_scaling
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_chamelium_frames
results: parsing output: 123/ for test: gem_eio
results: parsing output: 124/ for test: kms_color
results: parsing output: 125/ for test: kms_cursor_crc
results: parsing output: 126/ for test: kms_lease
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: gem_ctx_persistence
results: parsing output: 129/ for test: gem_exec_whisper
results: parsing output: 130/ for test: kms_big_fb
Done.