[62.528172] Initializing watchdogs
[62.528218]   /dev/watchdog0
[62.542176] [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]
[62.546517] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[62.548617] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.551977] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[62.679147] Starting subtest: fbcpsr-rgb101010-draw-blt
[69.826006] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (7.171s)
[69.946791] [002/133] (953s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[70.060779] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[70.065101] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[70.148742] [003/133] (952s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[70.547775] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[71.308924] [004/133] (951s left) gem_workarounds (basic-read-context)
[71.381845] Starting subtest: basic-read-context
[71.394858] Subtest basic-read-context: SUCCESS (0.012s)
[71.524583] [005/133] (951s left) gem_mmap (basic-small-bo)
[71.584180] Subtest basic-small-bo: SKIP (0.000s)
[71.639093] [006/133] (951s left) api_intel_allocator (default-alignment)
[71.689062] Starting subtest: default-alignment
[71.693932] Subtest default-alignment: SUCCESS (0.006s)
[71.820771] [007/133] (951s left) kms_psr (fbc-pr-sprite-plane-move)
[71.922628] Starting subtest: fbc-pr-sprite-plane-move
[71.927087] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[71.997536] [008/133] (951s left) kms_atomic_transition (plane-all-transition-nonblocking)
[72.081422] Starting subtest: plane-all-transition-nonblocking
[72.083750] Starting dynamic subtest: pipe-A-eDP-1
[74.574322] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[74.892258] Starting dynamic subtest: pipe-B-eDP-1
[78.163635] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.281s)
[78.469274] Subtest plane-all-transition-nonblocking: SUCCESS (6.392s)
[79.287751] [009/133] (944s left) syncobj_timeline (invalid-query-zero-handles)
[79.350362] Starting subtest: invalid-query-zero-handles
[79.352687] Subtest invalid-query-zero-handles: SUCCESS (0.000s)
[79.462812] [010/133] (943s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[79.577885] Starting subtest: fbc-tiling-linear
[83.301617] Subtest fbc-tiling-linear: SUCCESS (3.728s)
[84.499303] [011/133] (938s left) gem_basic (create-close)
[84.556243] Starting subtest: create-close
[84.560809] Subtest create-close: SUCCESS (0.000s)
[84.653937] [012/133] (938s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[84.749817] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[84.754157] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[84.847831] [013/133] (938s left) gem_exec_flush (basic-uc-ro-default)
[84.912798] Starting subtest: basic-uc-ro-default
[90.394957] Subtest basic-uc-ro-default: SUCCESS (5.456s)
[90.562445] [014/133] (932s left) gem_gpgpu_fill (offset-16x16)
[90.625060] Starting subtest: offset-16x16
[90.635359] Subtest offset-16x16: SUCCESS (0.011s)
[90.760466] [015/133] (932s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[90.879216] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[90.883784] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[91.021148] [016/133] (932s left) kms_invalid_mode (uint-max-clock)
[91.120162] Starting subtest: uint-max-clock
[91.122520] Starting dynamic subtest: pipe-A-eDP-1
[91.408384] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s)
[91.416973] Starting dynamic subtest: pipe-B-eDP-1
[91.418850] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[91.425360] Starting dynamic subtest: pipe-C-eDP-1
[91.427733] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[91.434511] Starting dynamic subtest: pipe-D-eDP-1
[91.436753] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[91.438877] Subtest uint-max-clock: SUCCESS (0.293s)
[92.221713] [017/133] (931s left) dmabuf_sync_file (export-wait-after-attach)
[92.284697] Starting subtest: export-wait-after-attach
[92.286588] Subtest export-wait-after-attach: SUCCESS (0.001s)
[92.348167] [FACT dmabuf_sync_file (export-wait-after-attach)] new: kernel.kmod_is_loaded.vgem: true
[92.351249] [018/133] (931s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[92.451642] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[93.495953] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.044s)
[93.616604] [019/133] (930s left) syncobj_timeline (wait-for-submit-delayed-submit)
[93.664718] Starting subtest: wait-for-submit-delayed-submit
[93.769295] Subtest wait-for-submit-delayed-submit: SUCCESS (0.104s)
[93.858775] [020/133] (929s left) gem_ctx_isolation (preservation)
[93.913208] Starting subtest: preservation
[93.915740] Starting dynamic subtest: rcs0
[94.039370] Dynamic subtest rcs0: SUCCESS (0.125s)
[94.050076] Starting dynamic subtest: bcs0
[94.182904] Dynamic subtest bcs0: SUCCESS (0.144s)
[94.193082] Starting dynamic subtest: vcs0
[94.326521] Dynamic subtest vcs0: SUCCESS (0.143s)
[94.337569] Starting dynamic subtest: vcs1
[95.997072] Dynamic subtest vcs1: SUCCESS (1.669s)
[96.007148] Starting dynamic subtest: vecs0
[97.987844] Dynamic subtest vecs0: SUCCESS (1.991s)
[97.998802] Starting dynamic subtest: ccs0
[100.057288] Dynamic subtest ccs0: SUCCESS (2.068s)
[100.059630] Subtest preservation: SUCCESS (6.143s)
[100.299465] [021/133] (923s left) gem_exec_schedule (submit-late-slice)
[100.374079] Starting subtest: submit-late-slice
[100.377063] Starting dynamic subtest: rcs0
[100.430059] Dynamic subtest rcs0: SUCCESS (0.062s)
[100.440205] Starting dynamic subtest: bcs0
[100.475324] Dynamic subtest bcs0: SUCCESS (0.045s)
[100.483692] Starting dynamic subtest: vcs0
[100.527707] Dynamic subtest vcs0: SUCCESS (0.051s)
[100.538683] Starting dynamic subtest: vcs1
[100.576084] Dynamic subtest vcs1: SUCCESS (0.049s)
[100.586720] Starting dynamic subtest: vecs0
[100.623064] Dynamic subtest vecs0: SUCCESS (0.045s)
[100.635889] Starting dynamic subtest: ccs0
[100.669376] Dynamic subtest ccs0: SUCCESS (0.047s)
[100.672039] Subtest submit-late-slice: SUCCESS (0.302s)
[101.989959] [022/133] (921s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[102.099318] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[106.670929] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.575s)
[107.799525] [023/133] (916s left) kms_frontbuffer_tracking (fbc-stridechange)
[107.907142] Starting subtest: fbc-stridechange
[111.167037] Subtest fbc-stridechange: SUCCESS (3.265s)
[112.302250] [024/133] (911s left) gem_exec_balancer (invalid-bonds)
[112.362423] Starting subtest: invalid-bonds
[112.367131] Subtest invalid-bonds: SKIP (0.000s)
[112.653506] [025/133] (911s left) kms_flip (basic-flip-vs-modeset)
[112.742296] Starting subtest: basic-flip-vs-modeset
[112.744727] Starting dynamic subtest: A-eDP1
[115.300481] Dynamic subtest A-eDP1: SUCCESS (2.558s)
[115.311288] Starting dynamic subtest: B-eDP1
[117.476668] Dynamic subtest B-eDP1: SUCCESS (2.175s)
[117.485968] Starting dynamic subtest: C-eDP1
[119.634455] Dynamic subtest C-eDP1: SUCCESS (2.157s)
[119.646681] Starting dynamic subtest: D-eDP1
[121.789080] Dynamic subtest D-eDP1: SUCCESS (2.153s)
[121.791441] Subtest basic-flip-vs-modeset: SUCCESS (9.050s)
[122.588217] [026/133] (901s left) kms_color (legacy-gamma)
[122.674266] Starting subtest: legacy-gamma
[122.676597] Starting dynamic subtest: pipe-A-eDP-1
[123.387527] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.710s)
[123.395972] Starting dynamic subtest: pipe-B-eDP-1
[124.803066] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.417s)
[124.812455] Starting dynamic subtest: pipe-C-eDP-1
[126.215312] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.410s)
[126.224324] Starting dynamic subtest: pipe-D-eDP-1
[127.546952] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.330s)
[127.548992] Subtest legacy-gamma: SUCCESS (4.870s)
[128.351475] [027/133] (895s left) gem_pwrite (basic-self)
[128.418921] Subtest basic-self: SKIP (0.000s)
[128.478345] [028/133] (895s left) gem_ctx_bad_destroy (invalid-ctx)
[128.538734] Starting subtest: invalid-ctx
[128.541149] Subtest invalid-ctx: SUCCESS (0.000s)
[128.616369] [029/133] (895s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[128.710444] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[128.714721] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[128.815181] [030/133] (895s left) gem_exec_flush (basic-uc-rw-default)
[128.883760] Starting subtest: basic-uc-rw-default
[134.367659] Subtest basic-uc-rw-default: SUCCESS (5.454s)
[134.533042] [031/133] (889s left) i915_pm_sseu (full-enable)
[134.590984] Subtest full-enable: SKIP (0.000s)
[134.689163] [032/133] (889s left) kms_busy (basic-hang)
[134.803016] Starting subtest: basic-hang
[134.805337] Starting dynamic subtest: flip-pipe-A
[135.411582] Dynamic subtest flip-pipe-A: SUCCESS (0.606s)
[135.419060] Starting dynamic subtest: modeset-pipe-A
[138.854075] Dynamic subtest modeset-pipe-A: SUCCESS (3.443s)
[138.861520] Starting dynamic subtest: flip-pipe-D
[140.044339] Dynamic subtest flip-pipe-D: SUCCESS (1.188s)
[140.052061] Starting dynamic subtest: modeset-pipe-D
[143.475221] Dynamic subtest modeset-pipe-D: SUCCESS (3.430s)
[143.477537] Subtest basic-hang: SUCCESS (8.673s)
[144.266800] [033/133] (879s left) syncobj_wait (wait-any-snapshot)
[144.325841] Starting subtest: wait-any-snapshot
[144.408431] Subtest wait-any-snapshot: SUCCESS (0.083s)
[144.509405] [034/133] (879s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[144.572055] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[144.574229] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.001s)
[144.657363] [035/133] (879s left) kms_frontbuffer_tracking (psr-slowdraw)
[144.759658] Starting subtest: psr-slowdraw
[169.913169] Subtest psr-slowdraw: SUCCESS (25.155s)
[170.025383] [036/133] (854s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[170.151484] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[171.107040] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.956s)
[171.928667] [037/133] (852s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[172.028428] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[179.316784] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.289s)
[179.462380] [038/133] (845s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[179.551710] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[179.553975] Starting dynamic subtest: pipe-A-eDP-1
[179.577099] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[179.586199] Starting dynamic subtest: pipe-B-eDP-1
[179.613385] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[179.621610] Starting dynamic subtest: pipe-C-eDP-1
[179.644453] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[179.651384] Starting dynamic subtest: pipe-D-eDP-1
[179.673163] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[179.677562] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[181.798286] [039/133] (842s left) gem_eio (in-flight-contexts-immediate)
[182.022608] Starting subtest: in-flight-contexts-immediate
[193.969492] Subtest in-flight-contexts-immediate: SUCCESS (11.945s)
[194.118237] [040/133] (830s left) kms_psr (psr2-cursor-plane-onoff)
[194.224757] Starting subtest: psr2-cursor-plane-onoff
[194.226905] Starting dynamic subtest: eDP-1
[195.886928] Dynamic subtest eDP-1: SUCCESS (1.661s)
[195.889212] Subtest psr2-cursor-plane-onoff: SUCCESS (1.662s)
[196.683798] [041/133] (827s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[196.785939] Starting subtest: plane-primary-toggle-with-vblank-wait
[196.788186] Starting dynamic subtest: pipe-A-eDP-1
[196.958066] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.174s)
[197.263994] Starting dynamic subtest: pipe-B-eDP-1
[198.191623] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.935s)
[198.489519] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.703s)
[199.348966] [042/133] (825s left) kms_big_fb (linear-16bpp-rotate-180)
[199.446442] Starting subtest: linear-16bpp-rotate-180
[200.780532] Subtest linear-16bpp-rotate-180: SUCCESS (1.334s)
[200.915633] [043/133] (823s left) prime_vgem (busy)
[200.991224] Starting subtest: busy
[200.993374] Starting dynamic subtest: rcs0
[201.050048] Dynamic subtest rcs0: SUCCESS (0.059s)
[201.059090] Starting dynamic subtest: bcs0
[201.106943] Dynamic subtest bcs0: SUCCESS (0.056s)
[201.114608] Starting dynamic subtest: vcs0
[201.152517] Dynamic subtest vcs0: SUCCESS (0.044s)
[201.160229] Starting dynamic subtest: vcs1
[201.195610] Dynamic subtest vcs1: SUCCESS (0.042s)
[201.204042] Starting dynamic subtest: vecs0
[201.242983] Dynamic subtest vecs0: SUCCESS (0.046s)
[201.250485] Starting dynamic subtest: ccs0
[201.290539] Dynamic subtest ccs0: SUCCESS (0.047s)
[201.292134] Subtest busy: SUCCESS (0.300s)
[201.419391] [044/133] (823s left) kms_addfb_basic (bo-too-small)
[201.511345] Starting subtest: bo-too-small
[201.513296] Subtest bo-too-small: SUCCESS (0.000s)
[201.595678] [045/133] (823s left) gem_exec_fence (basic-busy-all)
[201.661798] Starting subtest: basic-busy-all
[201.743366] Subtest basic-busy-all: SUCCESS (0.084s)
[204.021477] [046/133] (820s left) kms_pm_rpm (package-g7)
[206.064806] Starting subtest: package-g7
[206.069679] Subtest package-g7: SKIP (0.000s)
[206.436598] [047/133] (818s left) gem_wait (write-wait)
[206.497040] Starting subtest: write-wait
[206.499530] Starting dynamic subtest: all-engines
[207.588642] Dynamic subtest all-engines: SUCCESS (1.091s)
[207.604044] Starting dynamic subtest: rcs0
[208.643862] Dynamic subtest rcs0: SUCCESS (1.053s)
[208.659660] Starting dynamic subtest: bcs0
[209.699886] Dynamic subtest bcs0: SUCCESS (1.054s)
[209.716774] Starting dynamic subtest: vcs0
[210.754560] Dynamic subtest vcs0: SUCCESS (1.052s)
[210.769099] Starting dynamic subtest: vcs1
[211.807933] Dynamic subtest vcs1: SUCCESS (1.051s)
[211.823061] Starting dynamic subtest: vecs0
[212.861544] Dynamic subtest vecs0: SUCCESS (1.052s)
[212.876552] Starting dynamic subtest: ccs0
[213.917753] Dynamic subtest ccs0: SUCCESS (1.054s)
[213.920391] Subtest write-wait: SUCCESS (7.422s)
[214.115673] [048/133] (810s left) kms_atomic (plane-immutable-zpos)
[214.210322] Starting subtest: plane-immutable-zpos
[214.212659] Starting dynamic subtest: pipe-A-eDP-1
[214.865861] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.656s)
[214.868181] Subtest plane-immutable-zpos: SUCCESS (0.657s)
[215.655313] [049/133] (809s left) gem_exec_schedule (noreorder-corked)
[215.828880] Starting subtest: noreorder-corked
[215.831411] Starting dynamic subtest: rcs0
[216.959744] Dynamic subtest rcs0: SUCCESS (1.133s)
[216.970265] Starting dynamic subtest: vcs0
[218.908288] Dynamic subtest vcs0: SUCCESS (1.945s)
[218.923197] Starting dynamic subtest: vcs1
[220.875575] Dynamic subtest vcs1: SUCCESS (1.965s)
[220.889041] Starting dynamic subtest: vecs0
[222.923690] Dynamic subtest vecs0: SUCCESS (2.045s)
[222.932747] Starting dynamic subtest: ccs0
[224.076998] Dynamic subtest ccs0: SUCCESS (1.152s)
[224.079645] Subtest noreorder-corked: SUCCESS (8.251s)
[224.274502] [050/133] (800s left) kms_vblank (accuracy-idle)
[224.379762] Starting subtest: accuracy-idle
[224.381667] Starting dynamic subtest: pipe-A-eDP-1
[226.155064] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.774s)
[226.168243] Starting dynamic subtest: pipe-D-eDP-1
[228.611219] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.453s)
[228.613467] Subtest accuracy-idle: SUCCESS (4.231s)
[229.425353] [051/133] (795s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[229.516882] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[229.519297] Starting dynamic subtest: pipe-A
[229.855755] Dynamic subtest pipe-A: SUCCESS (0.340s)
[229.864644] Starting dynamic subtest: pipe-B
[231.257947] Dynamic subtest pipe-B: SUCCESS (1.402s)
[231.266686] Starting dynamic subtest: pipe-C
[232.659072] Dynamic subtest pipe-C: SUCCESS (1.399s)
[232.669965] Starting dynamic subtest: pipe-D
[234.128467] Dynamic subtest pipe-D: SUCCESS (1.468s)
[234.130810] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.614s)
[235.261036] [052/133] (789s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[235.362659] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[242.343881] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.984s)
[242.467743] [053/133] (782s left) kms_plane_scaling (planes-upscale-20x20)
[242.567772] Starting subtest: planes-upscale-20x20
[242.570085] Starting dynamic subtest: pipe-A
[242.628453] Dynamic subtest pipe-A: SUCCESS (0.063s)
[242.637904] Starting dynamic subtest: pipe-B
[243.799523] Dynamic subtest pipe-B: SUCCESS (1.169s)
[243.809813] Starting dynamic subtest: pipe-C
[244.923743] Dynamic subtest pipe-C: SUCCESS (1.123s)
[244.932545] Starting dynamic subtest: pipe-D
[246.057860] Dynamic subtest pipe-D: SUCCESS (1.133s)
[246.060717] Subtest planes-upscale-20x20: SUCCESS (3.492s)
[247.207242] [054/133] (777s left) gem_spin_batch (spin-all-new)
[247.266404] Starting subtest: spin-all-new
[247.279810] Subtest spin-all-new: SUCCESS (0.013s)
[248.968859] [055/133] (776s left) gem_mmap_gtt (flink-race)
[249.017390] Subtest flink-race: SKIP (0.000s)
[249.072577] [056/133] (776s left) gen9_exec_parse (bb-secure)
[249.129207] Subtest bb-secure: SKIP (0.000s)
[249.194164] [057/133] (776s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[249.292531] Starting subtest: yf-tiled-16bpp-rotate-90
[249.297068] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[249.393491] [058/133] (775s left) kms_plane_multiple (2x-tiling-none)
[249.491993] Starting subtest: 2x-tiling-none
[249.495998] Subtest 2x-tiling-none: SKIP (0.000s)
[249.561548] [059/133] (775s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[249.659298] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[249.663147] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[249.767239] [060/133] (775s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[249.884636] Starting subtest: basic-flip-before-cursor-atomic
[250.800402] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.917s)
[251.653665] [061/133] (773s left) kms_psr (fbc-psr-cursor-blt)
[251.742134] Starting subtest: fbc-psr-cursor-blt
[251.744406] Starting dynamic subtest: eDP-1
[251.748578] Dynamic subtest eDP-1: SKIP (0.000s)
[251.752715] Subtest fbc-psr-cursor-blt: SKIP (0.001s)
[251.812783] [062/133] (773s left) gem_mmap_gtt (cpuset-big-copy)
[251.869259] Subtest cpuset-big-copy: SKIP (0.000s)
[251.927476] [063/133] (773s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[252.012593] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[252.038746] Starting dynamic subtest: pipe-A-plane-0
[252.460964] Dynamic subtest pipe-A-plane-0: SUCCESS (0.422s)
[252.469353] Starting dynamic subtest: pipe-A-plane-3
[252.726961] Dynamic subtest pipe-A-plane-3: SUCCESS (0.266s)
[252.734701] Starting dynamic subtest: pipe-A-plane-5
[252.738377] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[253.823790] Starting dynamic subtest: pipe-B-plane-0
[254.267261] Dynamic subtest pipe-B-plane-0: SUCCESS (0.455s)
[254.278311] Starting dynamic subtest: pipe-B-plane-3
[254.567875] Dynamic subtest pipe-B-plane-3: SUCCESS (0.298s)
[254.579103] Starting dynamic subtest: pipe-B-plane-5
[254.583490] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[254.885247] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.874s)
[256.182785] [064/133] (769s left) kms_flip (bo-too-big-interruptible)
[256.267892] Starting subtest: bo-too-big-interruptible
[256.270430] Starting dynamic subtest: A-eDP1
[257.532580] Dynamic subtest A-eDP1: SUCCESS (1.264s)
[257.542055] Starting dynamic subtest: B-eDP1
[258.763622] Dynamic subtest B-eDP1: SUCCESS (1.229s)
[258.774634] Starting dynamic subtest: C-eDP1
[260.016086] Dynamic subtest C-eDP1: SUCCESS (1.251s)
[260.029253] Starting dynamic subtest: D-eDP1
[261.341113] Dynamic subtest D-eDP1: SUCCESS (1.323s)
[261.343478] Subtest bo-too-big-interruptible: SUCCESS (5.077s)
[262.551404] [065/133] (763s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[262.650062] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[262.654387] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.000s)
[262.722973] [066/133] (762s left) gem_softpin (noreloc)
[262.800844] Starting subtest: noreloc
[268.248382] Subtest noreloc: SUCCESS (5.394s)
[268.316449] [067/133] (757s left) kms_content_protection (mei-interface)
[268.450560] Starting subtest: mei-interface
[268.455155] Subtest mei-interface: SKIP (0.001s)
[268.573033] [068/133] (757s left) kms_addfb_basic (master-rmfb)
[268.622054] Starting subtest: master-rmfb
[268.624276] Subtest master-rmfb: SUCCESS (0.002s)
[268.761957] [069/133] (756s left) kms_cursor_edge_walk (64x64-right-edge)
[268.858718] Starting subtest: 64x64-right-edge
[268.860853] Starting dynamic subtest: pipe-A-eDP-1
[272.325727] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.466s)
[272.333998] Starting dynamic subtest: pipe-D-eDP-1
[275.456215] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.130s)
[275.458431] Subtest 64x64-right-edge: SUCCESS (6.598s)
[276.267482] [070/133] (749s left) gem_ctx_persistence (userptr)
[276.319985] Starting subtest: userptr
[276.499580] Subtest userptr: SUCCESS (0.180s)
[276.577325] [071/133] (749s left) gem_exec_reloc (basic-wc-cpu)
[276.633417] Subtest basic-wc-cpu: SKIP (0.000s)
[276.700336] [072/133] (749s left) api_intel_bb (simple-bb)
[276.756527] Starting subtest: simple-bb
[276.761799] Subtest simple-bb: SUCCESS (0.007s)
[276.880969] [073/133] (749s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[276.981320] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[276.985576] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[277.076672] [074/133] (748s left) i915_hangman (engine-error-state-capture)
[277.138763] Starting subtest: engine-error-state-capture
[277.140962] Starting dynamic subtest: rcs0
[280.882849] Dynamic subtest rcs0: SUCCESS (3.744s)
[280.894679] Starting dynamic subtest: bcs0
[286.898419] Dynamic subtest bcs0: SUCCESS (6.013s)
[286.909477] Starting dynamic subtest: vcs0
[292.851597] Dynamic subtest vcs0: SUCCESS (5.950s)
[292.862654] Starting dynamic subtest: vcs1
[298.868622] Dynamic subtest vcs1: SUCCESS (6.013s)
[298.879915] Starting dynamic subtest: vecs0
[304.883397] Dynamic subtest vecs0: SUCCESS (6.012s)
[304.894779] Starting dynamic subtest: ccs0
[310.836123] Dynamic subtest ccs0: SUCCESS (5.949s)
[310.839034] Subtest engine-error-state-capture: SUCCESS (33.698s)
[310.956674] [075/133] (715s left) prime_mmap (test_forked_cpu_write)
[311.007946] Starting subtest: test_forked_cpu_write
[311.010184] Starting dynamic subtest: test_forked_cpu_write-smem
[311.017245] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.009s)
[311.019581] Subtest test_forked_cpu_write: SUCCESS (0.010s)
[311.134107] [076/133] (714s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[311.218790] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[311.221424] Starting dynamic subtest: pipe-A-eDP-1
[311.684348] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.437s)
[311.694330] Starting dynamic subtest: pipe-B-eDP-1
[313.142262] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.456s)
[313.151438] Starting dynamic subtest: pipe-C-eDP-1
[314.540035] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.398s)
[314.548292] Starting dynamic subtest: pipe-D-eDP-1
[315.943723] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.403s)
[315.945625] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.700s)
[317.099387] [077/133] (708s left) kms_scaling_modes (scaling-mode-full-aspect)
[317.198822] Starting subtest: scaling-mode-full-aspect
[317.201118] Starting dynamic subtest: pipe-A-eDP-1
[317.291333] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.094s)
[317.303307] Starting dynamic subtest: pipe-B-eDP-1
[318.432042] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.137s)
[318.444148] Starting dynamic subtest: pipe-C-eDP-1
[319.554938] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.119s)
[319.566660] Starting dynamic subtest: pipe-D-eDP-1
[320.676556] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.119s)
[320.678767] Subtest scaling-mode-full-aspect: SUCCESS (3.481s)
[321.845712] [078/133] (704s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[321.947616] Starting subtest: pr-cursor-plane-update-sf
[321.951875] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[322.015054] [079/133] (704s left) kms_lease (lease-revoke)
[322.106456] Starting subtest: lease-revoke
[322.108630] Starting dynamic subtest: pipe-A-eDP-1
[322.137213] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.029s)
[322.145806] Starting dynamic subtest: pipe-B-eDP-1
[322.162050] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.026s)
[322.170762] Starting dynamic subtest: pipe-C-eDP-1
[322.189766] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.026s)
[322.198439] Starting dynamic subtest: pipe-D-eDP-1
[322.219076] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.028s)
[322.221419] Subtest lease-revoke: SUCCESS (0.115s)
[322.353924] [080/133] (703s left) gem_exec_store (cachelines)
[322.415056] Starting subtest: cachelines
[322.417257] Starting dynamic subtest: rcs0
[322.492881] Dynamic subtest rcs0: SUCCESS (0.078s)
[322.503709] Starting dynamic subtest: bcs0
[322.555236] Dynamic subtest bcs0: SUCCESS (0.061s)
[322.565226] Starting dynamic subtest: vcs0
[322.612349] Dynamic subtest vcs0: SUCCESS (0.055s)
[322.622394] Starting dynamic subtest: vcs1
[322.664461] Dynamic subtest vcs1: SUCCESS (0.049s)
[322.674717] Starting dynamic subtest: vecs0
[322.713296] Dynamic subtest vecs0: SUCCESS (0.047s)
[322.723162] Starting dynamic subtest: ccs0
[322.765264] Dynamic subtest ccs0: SUCCESS (0.050s)
[322.767571] Subtest cachelines: SUCCESS (0.352s)
[322.949757] [081/133] (703s left) gem_blits (basic)
[323.006321] Starting subtest: basic
[324.475717] Subtest basic: SUCCESS (1.471s)
[324.591253] [082/133] (701s left) gem_unref_active_buffers
[324.795160] [083/133] (701s left) i915_pm_rpm (gem-mmap-type)
[327.132237] Starting subtest: gem-mmap-type
[327.134931] Starting dynamic subtest: wb-smem0
[330.616728] Dynamic subtest wb-smem0: SUCCESS (3.482s)
[330.625482] Starting dynamic subtest: wc-smem0
[334.086315] Dynamic subtest wc-smem0: SUCCESS (3.469s)
[334.094921] Starting dynamic subtest: uc-smem0
[337.276222] Dynamic subtest uc-smem0: SUCCESS (3.188s)
[337.278436] Subtest gem-mmap-type: SUCCESS (10.144s)
[337.362328] [084/133] (689s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[337.466116] Starting subtest: read-crc-frame-sequence
[337.468486] Starting dynamic subtest: pipe-A-eDP-1
[338.168410] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.703s)
[338.178354] Starting dynamic subtest: pipe-B-eDP-1
[339.505094] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.334s)
[339.514248] Starting dynamic subtest: pipe-C-eDP-1
[340.791752] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.287s)
[340.801614] Starting dynamic subtest: pipe-D-eDP-1
[342.139489] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.346s)
[342.141854] Subtest read-crc-frame-sequence: SUCCESS (4.676s)
[342.970344] [085/133] (683s left) kms_cursor_crc (cursor-onscreen-256x85)
[343.239088] Starting subtest: cursor-onscreen-256x85
[343.288731] Subtest cursor-onscreen-256x85: SKIP (0.044s)
[343.464453] [086/133] (682s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[343.560303] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[343.564690] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[343.626608] [087/133] (682s left) gem_softpin (32b-excludes-last-page)
[343.675322] Starting subtest: 32b-excludes-last-page
[343.680548] Subtest 32b-excludes-last-page: SUCCESS (0.003s)
[343.805598] [088/133] (682s left) gem_exec_fence (syncobj-repeat)
[344.254456] Starting subtest: syncobj-repeat
[344.431525] Subtest syncobj-repeat: SUCCESS (0.176s)
[345.955353] [089/133] (680s left) kms_vrr (max-min)
[346.047197] Starting subtest: max-min
[346.053882] Subtest max-min: SKIP (0.000s)
[346.118533] [090/133] (680s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[346.208564] Starting subtest: random-ccs-data-y-tiled-ccs
[346.210882] Starting dynamic subtest: pipe-A-eDP-1
[346.237594] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[346.249806] Starting dynamic subtest: pipe-B-eDP-1
[346.273553] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[346.281611] Starting dynamic subtest: pipe-C-eDP-1
[346.305673] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[346.313279] Starting dynamic subtest: pipe-D-eDP-1
[346.337431] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[346.341843] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.004s)
[348.448148] [091/133] (678s left) kms_chamelium_frames (hdmi-crc-multiple)
[348.825233] Subtest hdmi-crc-multiple: SKIP (0.000s)
[349.660525] [092/133] (677s left) perf_pmu (busy-idle-no-semaphores)
[349.700601] Starting subtest: busy-idle-no-semaphores
[349.703071] Starting dynamic subtest: rcs0
[350.369473] Dynamic subtest rcs0: SUCCESS (0.669s)
[350.380270] Starting dynamic subtest: bcs0
[351.021105] Dynamic subtest bcs0: SUCCESS (0.649s)
[351.032530] Starting dynamic subtest: vcs0
[351.673588] Dynamic subtest vcs0: SUCCESS (0.650s)
[351.684655] Starting dynamic subtest: vcs1
[353.534569] Dynamic subtest vcs1: SUCCESS (1.858s)
[353.545211] Starting dynamic subtest: vecs0
[355.517963] Dynamic subtest vecs0: SUCCESS (1.981s)
[355.530071] Starting dynamic subtest: ccs0
[357.502408] Dynamic subtest ccs0: SUCCESS (1.982s)
[357.505065] Subtest busy-idle-no-semaphores: SUCCESS (7.805s)
[357.616735] [093/133] (669s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[357.688651] Starting subtest: invalid-bsd2-flag-on-blt
[357.690937] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[357.793192] [094/133] (668s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[357.907360] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu
[361.849485] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (3.945s)
[362.978188] [095/133] (663s left) kms_setmode (basic)
[363.028919] Starting subtest: basic
[363.362804] Starting dynamic subtest: pipe-A-eDP-1
[365.485671] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.118s)
[365.824938] Starting dynamic subtest: pipe-B-eDP-1
[367.919921] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.098s)
[368.228212] Subtest basic: SUCCESS (5.197s)
[369.064402] [096/133] (657s left) kms_ccs (bad-aux-stride-yf-tiled-ccs)
[369.157603] Starting subtest: bad-aux-stride-yf-tiled-ccs
[369.159688] Starting dynamic subtest: pipe-A-eDP-1
[369.181235] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[369.190539] Starting dynamic subtest: pipe-B-eDP-1
[369.211425] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[369.219174] Starting dynamic subtest: pipe-C-eDP-1
[369.239433] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[369.247072] Starting dynamic subtest: pipe-D-eDP-1
[369.269716] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[369.274107] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.005s)
[371.426308] [097/133] (655s left) gem_ctx_sseu (invalid-args)
[371.491939] Subtest invalid-args: SKIP (0.000s)
[371.577804] [098/133] (655s left) syncobj_timeline (etime-multi-wait-all-submitted)
[371.649051] Starting subtest: etime-multi-wait-all-submitted
[371.753221] Subtest etime-multi-wait-all-submitted: SUCCESS (0.104s)
[371.829793] [099/133] (655s left) kms_pm_rpm (dpms-non-lpsp)
[374.075050] Starting subtest: dpms-non-lpsp
[374.080140] Subtest dpms-non-lpsp: SKIP (0.001s)
[374.448195] [100/133] (652s left) kms_vblank (query-forked)
[374.537134] Starting subtest: query-forked
[374.539457] Starting dynamic subtest: pipe-A-eDP-1
[376.368098] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.830s)
[376.382677] Starting dynamic subtest: pipe-D-eDP-1
[378.846136] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.474s)
[378.848029] Subtest query-forked: SUCCESS (4.309s)
[379.699697] [101/133] (647s left) gem_exec_params (cliprects_ptr-dirt)
[379.766828] Starting subtest: cliprects_ptr-dirt
[379.769343] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[379.866592] [102/133] (647s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[379.991554] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[379.995610] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[380.089359] [103/133] (647s left) kms_feature_discovery (dp-mst)
[380.179759] Starting subtest: dp-mst
[380.184069] Subtest dp-mst: SKIP (0.000s)
[380.276255] [104/133] (646s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[380.336835] Starting subtest: etime-multi-wait-all-for-submit-submitted
[380.440853] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.104s)
[380.515605] [105/133] (646s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[380.620467] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[380.624725] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[380.711435] [106/133] (646s left) gem_exec_reloc (basic-concurrent0)
[380.764693] Subtest basic-concurrent0: SKIP (0.000s)
[380.828673] [107/133] (646s left) gem_ctx_param (set-priority-range)
[380.876998] Starting subtest: set-priority-range
[380.892152] Subtest set-priority-range: SUCCESS (0.015s)
[381.012432] [108/133] (646s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[381.114123] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[381.118306] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[381.222260] [109/133] (646s left) kms_getfb (getfb2-handle-protection)
[381.312688] Starting subtest: getfb2-handle-protection
[381.332714] Subtest getfb2-handle-protection: SUCCESS (0.021s)
[381.461114] [110/133] (645s left) kms_cursor_legacy (forked-move)
[381.584218] Starting subtest: forked-move
[381.586100] Starting dynamic subtest: pipe-A
[387.107711] Dynamic subtest pipe-A: SUCCESS (5.465s)
[387.116954] Starting dynamic subtest: pipe-B
[392.573962] Dynamic subtest pipe-B: SUCCESS (5.466s)
[392.584122] Starting dynamic subtest: pipe-C
[398.039418] Dynamic subtest pipe-C: SUCCESS (5.462s)
[398.049329] Starting dynamic subtest: pipe-D
[403.504404] Dynamic subtest pipe-D: SUCCESS (5.462s)
[403.517586] Starting dynamic subtest: all-pipes
[408.991806] Dynamic subtest all-pipes: SUCCESS (5.486s)
[408.994236] Subtest forked-move: SUCCESS (27.353s)
[409.088442] [111/133] (618s left) syncobj_basic (bad-flags-fd-to-handle)
[409.148994] Starting subtest: bad-flags-fd-to-handle
[409.151328] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[409.252418] [112/133] (618s left) gem_render_copy (yf-tiled)
[409.309071] Starting subtest: yf-tiled
[409.313328] Subtest yf-tiled: SKIP (0.000s)
[409.494333] [113/133] (618s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[409.585987] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[409.590362] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[409.692882] [114/133] (617s left) syncobj_wait (reset-unsignaled)
[409.740301] Starting subtest: reset-unsignaled
[409.742231] Subtest reset-unsignaled: SUCCESS (0.000s)
[409.846553] [115/133] (617s left) gem_exec_nop (basic-sequential)
[409.924871] Starting subtest: basic-sequential
[424.419903] Subtest basic-sequential: SUCCESS (14.479s)
[424.625889] [116/133] (603s left) kms_psr (pr-sprite-plane-move)
[424.728099] Starting subtest: pr-sprite-plane-move
[424.732525] Subtest pr-sprite-plane-move: SKIP (0.000s)
[424.800091] [117/133] (602s left) gem_mmap_gtt (coherency)
[424.860504] Subtest coherency: SKIP (0.000s)
[424.923721] [118/133] (602s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[425.020967] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[425.023270] Starting dynamic subtest: pipe-A-default-mode
[426.157435] Dynamic subtest pipe-A-default-mode: SKIP (1.134s)
[426.161292] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.135s)
[426.291142] [119/133] (601s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[426.386390] Starting subtest: psr-indfb-scaledprimary
[432.086883] Subtest psr-indfb-scaledprimary: SUCCESS (5.706s)
[432.211143] [120/133] (595s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[432.309279] Starting subtest: 4-tiled-16bpp-rotate-270
[432.329310] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.020s)
[432.442860] [121/133] (595s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[432.548110] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[432.552081] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[432.647102] [122/133] (595s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[432.751364] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[432.753603] Starting dynamic subtest: pipe-A-eDP-1
[438.639925] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.891s)
[438.649442] Starting dynamic subtest: pipe-B-eDP-1
[445.304957] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.662s)
[445.307347] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.556s)
[446.164681] [123/133] (581s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[446.263968] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[446.266305] Starting dynamic subtest: pipe-A-eDP-1
[446.288354] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[446.299618] Starting dynamic subtest: pipe-B-eDP-1
[446.321117] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[446.329388] Starting dynamic subtest: pipe-C-eDP-1
[446.351339] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[446.360362] Starting dynamic subtest: pipe-D-eDP-1
[446.382655] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[446.387079] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.010s)
[448.448036] [124/133] (579s left) i915_drm_fdinfo (busy-idle-check-all)
[448.499842] Starting subtest: busy-idle-check-all
[448.502218] Starting dynamic subtest: rcs0
[448.506595] Dynamic subtest rcs0: SKIP (0.004s)
[448.517661] Starting dynamic subtest: bcs0
[448.521975] Dynamic subtest bcs0: SKIP (0.000s)
[448.532433] Starting dynamic subtest: vcs0
[448.536695] Dynamic subtest vcs0: SKIP (0.000s)
[448.544679] Starting dynamic subtest: vcs1
[448.548863] Dynamic subtest vcs1: SKIP (0.000s)
[448.556973] Starting dynamic subtest: vecs0
[448.561080] Dynamic subtest vecs0: SKIP (0.000s)
[448.569384] Starting dynamic subtest: ccs0
[448.573699] Dynamic subtest ccs0: SKIP (0.000s)
[448.577908] Subtest busy-idle-check-all: SKIP (0.009s)
[448.614500] [125/133] (579s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[448.708051] Starting subtest: single-wait-all-for-submit-available-signaled
[448.710504] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[448.803702] [126/133] (579s left) perf (non-sampling-read-error)
[448.922187] Starting subtest: non-sampling-read-error
[448.931873] Subtest non-sampling-read-error: SUCCESS (0.010s)
[448.976484] [127/133] (579s left) gem_mmap_gtt (big-copy-xy)
[449.036976] Subtest big-copy-XY: SKIP (0.000s)
[449.092492] [128/133] (579s left) gem_exec_fence (basic-wait)
[449.266196] Starting subtest: basic-wait
[449.268555] Starting dynamic subtest: rcs0
[449.349088] Dynamic subtest rcs0: SUCCESS (0.083s)
[449.360125] Starting dynamic subtest: bcs0
[449.407192] Dynamic subtest bcs0: SUCCESS (0.056s)
[449.417857] Starting dynamic subtest: vcs0
[449.465253] Dynamic subtest vcs0: SUCCESS (0.055s)
[449.475654] Starting dynamic subtest: vcs1
[449.523260] Dynamic subtest vcs1: SUCCESS (0.056s)
[449.534548] Starting dynamic subtest: vecs0
[449.586072] Dynamic subtest vecs0: SUCCESS (0.061s)
[449.595928] Starting dynamic subtest: ccs0
[449.640655] Dynamic subtest ccs0: SUCCESS (0.052s)
[449.643203] Subtest basic-wait: SUCCESS (0.376s)
[450.968765] [129/133] (577s left) gem_create (create-ext-placement-each)
[451.164517] Starting subtest: create-ext-placement-each
[451.166664] Subtest create-ext-placement-each: SUCCESS (0.000s)
[451.266224] [130/133] (576s left) kms_flip (plain-flip-ts-check-interruptible)
[451.367663] Starting subtest: plain-flip-ts-check-interruptible
[451.369913] Starting dynamic subtest: A-eDP1
[460.260820] Dynamic subtest A-eDP1: SUCCESS (8.859s)
[460.272957] Starting dynamic subtest: B-eDP1
[469.088414] Dynamic subtest B-eDP1: SUCCESS (8.826s)
[469.098644] Starting dynamic subtest: C-eDP1
[477.915427] Dynamic subtest C-eDP1: SUCCESS (8.813s)
[477.928158] Starting dynamic subtest: D-eDP1
[486.705770] Dynamic subtest D-eDP1: SUCCESS (8.831s)
[486.711881] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.343s)
[487.882877] [131/133] (540s left) gem_basic (bad-close)
[487.944493] Starting subtest: bad-close
[487.949036] Subtest bad-close: SUCCESS (0.000s)
[488.060865] [132/133] (540s left) gem_mmap_gtt (basic-short)
[488.127593] Subtest basic-short: SKIP (0.000s)
[488.188922] [133/133] (540s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[488.341608] Starting subtest: cursor-rapid-movement-32x32
[488.384907] Subtest cursor-rapid-movement-32x32: SKIP (0.040s)
[488.709319] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_big_fb
results: parsing output: 2/ for test: kms_chamelium_hpd
results: parsing output: 3/ for test: gem_workarounds
results: parsing output: 4/ for test: gem_mmap
results: parsing output: 5/ for test: api_intel_allocator
results: parsing output: 6/ for test: kms_psr
results: parsing output: 7/ for test: kms_atomic_transition
results: parsing output: 8/ for test: syncobj_timeline
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: gem_basic
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: gem_exec_flush
results: parsing output: 13/ for test: gem_gpgpu_fill
results: parsing output: 14/ for test: kms_cursor_legacy
results: parsing output: 15/ for test: kms_invalid_mode
results: parsing output: 16/ for test: dmabuf_sync_file
results: parsing output: 17/ for test: kms_big_fb
results: parsing output: 18/ for test: syncobj_timeline
results: parsing output: 19/ for test: gem_ctx_isolation
results: parsing output: 20/ for test: gem_exec_schedule
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: gem_exec_balancer
results: parsing output: 24/ for test: kms_flip
results: parsing output: 25/ for test: kms_color
results: parsing output: 26/ for test: gem_pwrite
results: parsing output: 27/ for test: gem_ctx_bad_destroy
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: gem_exec_flush
results: parsing output: 30/ for test: i915_pm_sseu
results: parsing output: 31/ for test: kms_busy
results: parsing output: 32/ for test: syncobj_wait
results: parsing output: 33/ for test: syncobj_timeline
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_cursor_legacy
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_ccs
results: parsing output: 38/ for test: gem_eio
results: parsing output: 39/ for test: kms_psr
results: parsing output: 40/ for test: kms_atomic_transition
results: parsing output: 41/ for test: kms_big_fb
results: parsing output: 42/ for test: prime_vgem
results: parsing output: 43/ for test: kms_addfb_basic
results: parsing output: 44/ for test: gem_exec_fence
results: parsing output: 45/ for test: kms_pm_rpm
results: parsing output: 46/ for test: gem_wait
results: parsing output: 47/ for test: kms_atomic
results: parsing output: 48/ for test: gem_exec_schedule
results: parsing output: 49/ for test: kms_vblank
results: parsing output: 50/ for test: kms_plane_scaling
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_plane_scaling
results: parsing output: 53/ for test: gem_spin_batch
results: parsing output: 54/ for test: gem_mmap_gtt
results: parsing output: 55/ for test: gen9_exec_parse
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: kms_plane_multiple
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_cursor_legacy
results: parsing output: 60/ for test: kms_psr
results: parsing output: 61/ for test: gem_mmap_gtt
results: parsing output: 62/ for test: kms_plane
results: parsing output: 63/ for test: kms_flip
results: parsing output: 64/ for test: kms_flip_scaled_crc
results: parsing output: 65/ for test: gem_softpin
results: parsing output: 66/ for test: kms_content_protection
results: parsing output: 67/ for test: kms_addfb_basic
results: parsing output: 68/ for test: kms_cursor_edge_walk
results: parsing output: 69/ for test: gem_ctx_persistence
results: parsing output: 70/ for test: gem_exec_reloc
results: parsing output: 71/ for test: api_intel_bb
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: i915_hangman
results: parsing output: 74/ for test: prime_mmap
results: parsing output: 75/ for test: kms_ccs
results: parsing output: 76/ for test: kms_scaling_modes
results: parsing output: 77/ for test: kms_psr2_sf
results: parsing output: 78/ for test: kms_lease
results: parsing output: 79/ for test: gem_exec_store
results: parsing output: 80/ for test: gem_blits
results: parsing output: 81/ for test: gem_unref_active_buffers
results: parsing output: 82/ for test: i915_pm_rpm
results: parsing output: 83/ for test: kms_pipe_crc_basic
results: parsing output: 84/ for test: kms_cursor_crc
results: parsing output: 85/ for test: kms_psr2_sf
results: parsing output: 86/ for test: gem_softpin
results: parsing output: 87/ for test: gem_exec_fence
results: parsing output: 88/ for test: kms_vrr
results: parsing output: 89/ for test: kms_ccs
results: parsing output: 90/ for test: kms_chamelium_frames
results: parsing output: 91/ for test: perf_pmu
results: parsing output: 92/ for test: gem_exec_params
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_setmode
results: parsing output: 95/ for test: kms_ccs
results: parsing output: 96/ for test: gem_ctx_sseu
results: parsing output: 97/ for test: syncobj_timeline
results: parsing output: 98/ for test: kms_pm_rpm
results: parsing output: 99/ for test: kms_vblank
results: parsing output: 100/ for test: gem_exec_params
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_feature_discovery
results: parsing output: 103/ for test: syncobj_timeline
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: gem_exec_reloc
results: parsing output: 106/ for test: gem_ctx_param
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_getfb
results: parsing output: 109/ for test: kms_cursor_legacy
results: parsing output: 110/ for test: syncobj_basic
results: parsing output: 111/ for test: gem_render_copy
results: parsing output: 112/ for test: kms_big_fb
results: parsing output: 113/ for test: syncobj_wait
results: parsing output: 114/ for test: gem_exec_nop
results: parsing output: 115/ for test: kms_psr
results: parsing output: 116/ for test: gem_mmap_gtt
results: parsing output: 117/ for test: kms_flip_scaled_crc
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_big_fb
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_psr2_sf
results: parsing output: 122/ for test: kms_ccs
results: parsing output: 123/ for test: i915_drm_fdinfo
results: parsing output: 124/ for test: syncobj_timeline
results: parsing output: 125/ for test: perf
results: parsing output: 126/ for test: gem_mmap_gtt
results: parsing output: 127/ for test: gem_exec_fence
results: parsing output: 128/ for test: gem_create
results: parsing output: 129/ for test: kms_flip
results: parsing output: 130/ for test: gem_basic
results: parsing output: 131/ for test: gem_mmap_gtt
results: parsing output: 132/ for test: kms_cursor_crc
Done.