[59.286728] Initializing watchdogs
[59.286777]   /dev/watchdog0
[59.302472] [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]
[59.306960] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.309343] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.312204] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt)
[59.431432] Starting subtest: fbcpsr-rgb101010-draw-blt
[66.244220] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (6.823s)
[66.345511] [002/133] (953s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[66.442561] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[66.444582] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[66.538788] [003/133] (953s left) kms_chamelium_hpd (hdmi-hpd-for-each-pipe)
[66.911789] Subtest hdmi-hpd-for-each-pipe: SKIP (0.000s)
[67.701613] [004/133] (952s left) gem_workarounds (basic-read-context)
[67.842468] Starting subtest: basic-read-context
[67.864701] Subtest basic-read-context: SUCCESS (0.022s)
[68.199197] [005/133] (951s left) gem_mmap (basic-small-bo)
[68.252965] Subtest basic-small-bo: SKIP (0.000s)
[68.309746] [006/133] (951s left) api_intel_allocator (default-alignment)
[68.367687] Starting subtest: default-alignment
[68.370394] Subtest default-alignment: SUCCESS (0.003s)
[68.466793] [007/133] (951s left) kms_psr (fbc-pr-sprite-plane-move)
[68.545896] Starting subtest: fbc-pr-sprite-plane-move
[68.548474] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[68.607593] [008/133] (951s left) kms_atomic_transition (plane-all-transition-nonblocking)
[68.689971] Starting subtest: plane-all-transition-nonblocking
[68.690947] Starting dynamic subtest: pipe-A-eDP-1
[71.184951] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.496s)
[71.491749] Starting dynamic subtest: pipe-B-eDP-1
[74.766320] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.281s)
[75.074711] Subtest plane-all-transition-nonblocking: SUCCESS (6.387s)
[75.872548] [009/133] (944s left) syncobj_timeline (invalid-query-zero-handles)
[75.930481] Starting subtest: invalid-query-zero-handles
[75.931551] Subtest invalid-query-zero-handles: SUCCESS (0.000s)
[76.039958] [010/133] (944s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[76.144238] Starting subtest: fbc-tiling-linear
[79.881637] Subtest fbc-tiling-linear: SUCCESS (3.738s)
[81.065755] [011/133] (939s left) gem_basic (create-close)
[81.112055] Starting subtest: create-close
[81.113824] Subtest create-close: SUCCESS (0.000s)
[81.210915] [012/133] (938s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[81.297846] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[81.299729] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[81.392533] [013/133] (938s left) gem_exec_flush (basic-uc-ro-default)
[81.446670] Starting subtest: basic-uc-ro-default
[86.914570] Subtest basic-uc-ro-default: SUCCESS (5.467s)
[87.093997] [014/133] (933s left) gem_gpgpu_fill (offset-16x16)
[87.140947] Starting subtest: offset-16x16
[87.149951] Subtest offset-16x16: SUCCESS (0.009s)
[87.283951] [015/133] (932s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[87.408379] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[87.409993] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[87.545172] [016/133] (932s left) kms_invalid_mode (uint-max-clock)
[87.622899] Starting subtest: uint-max-clock
[87.623758] Starting dynamic subtest: pipe-A-eDP-1
[87.907500] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[87.913770] Starting dynamic subtest: pipe-B-eDP-1
[87.914643] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[87.920123] Starting dynamic subtest: pipe-C-eDP-1
[87.920922] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[87.926356] Starting dynamic subtest: pipe-D-eDP-1
[87.927147] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[87.927933] Subtest uint-max-clock: SUCCESS (0.289s)
[88.698238] [017/133] (931s left) dmabuf_sync_file (export-wait-after-attach)
[88.782564] Starting subtest: export-wait-after-attach
[88.783514] Subtest export-wait-after-attach: SUCCESS (0.001s)
[88.831653] [FACT dmabuf_sync_file (export-wait-after-attach)] new: kernel.kmod_is_loaded.vgem: true
[88.833775] [018/133] (931s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[88.926410] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[89.971543] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.045s)
[90.100879] [019/133] (930s left) syncobj_timeline (wait-for-submit-delayed-submit)
[90.155210] Starting subtest: wait-for-submit-delayed-submit
[90.259352] Subtest wait-for-submit-delayed-submit: SUCCESS (0.104s)
[90.343540] [020/133] (930s left) gem_ctx_isolation (preservation)
[90.399123] Starting subtest: preservation
[90.399966] Starting dynamic subtest: rcs0
[90.542694] Dynamic subtest rcs0: SUCCESS (0.142s)
[90.551561] Starting dynamic subtest: bcs0
[90.706890] Dynamic subtest bcs0: SUCCESS (0.164s)
[90.713649] Starting dynamic subtest: vcs0
[90.857718] Dynamic subtest vcs0: SUCCESS (0.150s)
[90.864583] Starting dynamic subtest: vcs1
[92.032944] Dynamic subtest vcs1: SUCCESS (1.175s)
[92.042086] Starting dynamic subtest: vecs0
[94.028524] Dynamic subtest vecs0: SUCCESS (1.995s)
[94.034565] Starting dynamic subtest: ccs0
[96.058823] Dynamic subtest ccs0: SUCCESS (2.029s)
[96.060595] Subtest preservation: SUCCESS (5.660s)
[96.298847] [021/133] (924s left) gem_exec_schedule (submit-late-slice)
[96.362840] Starting subtest: submit-late-slice
[96.363959] Starting dynamic subtest: rcs0
[96.418196] Dynamic subtest rcs0: SUCCESS (0.055s)
[96.427570] Starting dynamic subtest: bcs0
[96.464885] Dynamic subtest bcs0: SUCCESS (0.046s)
[96.471234] Starting dynamic subtest: vcs0
[96.506822] Dynamic subtest vcs0: SUCCESS (0.041s)
[96.516892] Starting dynamic subtest: vcs1
[96.555568] Dynamic subtest vcs1: SUCCESS (0.048s)
[96.562222] Starting dynamic subtest: vecs0
[96.601968] Dynamic subtest vecs0: SUCCESS (0.046s)
[96.614066] Starting dynamic subtest: ccs0
[96.661487] Dynamic subtest ccs0: SUCCESS (0.058s)
[96.663060] Subtest submit-late-slice: SUCCESS (0.298s)
[97.972400] [022/133] (922s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[98.086383] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[102.663454] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.577s)
[103.796613] [023/133] (916s left) kms_frontbuffer_tracking (fbc-stridechange)
[103.884128] Starting subtest: fbc-stridechange
[107.172289] Subtest fbc-stridechange: SUCCESS (3.289s)
[108.314982] [024/133] (912s left) gem_exec_balancer (invalid-bonds)
[108.371223] Starting subtest: invalid-bonds
[108.372927] Subtest invalid-bonds: SKIP (0.000s)
[108.676758] [025/133] (911s left) kms_flip (basic-flip-vs-modeset)
[108.765730] Starting subtest: basic-flip-vs-modeset
[108.767540] Starting dynamic subtest: A-eDP1
[111.379756] Dynamic subtest A-eDP1: SUCCESS (2.612s)
[111.387244] Starting dynamic subtest: B-eDP1
[113.551533] Dynamic subtest B-eDP1: SUCCESS (2.171s)
[113.558415] Starting dynamic subtest: C-eDP1
[115.715721] Dynamic subtest C-eDP1: SUCCESS (2.164s)
[115.722768] Starting dynamic subtest: D-eDP1
[117.893406] Dynamic subtest D-eDP1: SUCCESS (2.177s)
[117.895251] Subtest basic-flip-vs-modeset: SUCCESS (9.130s)
[118.686803] [026/133] (901s left) kms_color (legacy-gamma)
[118.774869] Starting subtest: legacy-gamma
[118.776033] Starting dynamic subtest: pipe-A-eDP-1
[119.506500] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.732s)
[119.512851] Starting dynamic subtest: pipe-B-eDP-1
[120.909111] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.403s)
[120.915499] Starting dynamic subtest: pipe-C-eDP-1
[122.253183] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.344s)
[122.259605] Starting dynamic subtest: pipe-D-eDP-1
[123.597774] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.344s)
[123.598813] Subtest legacy-gamma: SUCCESS (4.825s)
[124.408614] [027/133] (896s left) gem_pwrite (basic-self)
[124.464623] Subtest basic-self: SKIP (0.000s)
[124.526704] [028/133] (896s left) gem_ctx_bad_destroy (invalid-ctx)
[124.585517] Starting subtest: invalid-ctx
[124.586757] Subtest invalid-ctx: SUCCESS (0.000s)
[124.652660] [029/133] (896s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[124.742790] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[124.744679] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[124.833508] [030/133] (895s left) gem_exec_flush (basic-uc-rw-default)
[124.892593] Starting subtest: basic-uc-rw-default
[130.348737] Subtest basic-uc-rw-default: SUCCESS (5.456s)
[130.537412] [031/133] (890s left) i915_pm_sseu (full-enable)
[130.592775] Subtest full-enable: SKIP (0.000s)
[130.694333] [032/133] (890s left) kms_busy (basic-hang)
[130.780541] Starting subtest: basic-hang
[130.781447] Starting dynamic subtest: flip-pipe-A
[131.372527] Dynamic subtest flip-pipe-A: SUCCESS (0.591s)
[131.379680] Starting dynamic subtest: modeset-pipe-A
[134.824836] Dynamic subtest modeset-pipe-A: SUCCESS (3.452s)
[134.832090] Starting dynamic subtest: flip-pipe-D
[136.007699] Dynamic subtest flip-pipe-D: SUCCESS (1.181s)
[136.014727] Starting dynamic subtest: modeset-pipe-D
[139.428958] Dynamic subtest modeset-pipe-D: SUCCESS (3.420s)
[139.429827] Subtest basic-hang: SUCCESS (8.649s)
[140.219673] [033/133] (880s left) syncobj_wait (wait-any-snapshot)
[140.274640] Starting subtest: wait-any-snapshot
[140.356453] Subtest wait-any-snapshot: SUCCESS (0.081s)
[140.427973] [034/133] (880s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[140.469123] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[140.470136] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[140.558882] [035/133] (880s left) kms_frontbuffer_tracking (psr-slowdraw)
[140.650675] Starting subtest: psr-slowdraw
[165.861388] Subtest psr-slowdraw: SUCCESS (25.210s)
[165.980880] [036/133] (854s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[166.098123] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[167.045421] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.947s)
[167.877101] [037/133] (853s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[167.962921] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[175.424673] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.462s)
[175.546072] [038/133] (845s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[175.640250] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[175.641096] Starting dynamic subtest: pipe-A-eDP-1
[175.649782] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[175.656637] Starting dynamic subtest: pipe-B-eDP-1
[175.664839] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[175.671124] Starting dynamic subtest: pipe-C-eDP-1
[175.679164] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[175.685127] Starting dynamic subtest: pipe-D-eDP-1
[175.693369] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[175.695069] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[177.806487] [039/133] (843s left) gem_eio (in-flight-contexts-immediate)
[178.047535] Starting subtest: in-flight-contexts-immediate
[189.921490] Subtest in-flight-contexts-immediate: SUCCESS (11.873s)
[190.031519] [040/133] (831s left) kms_psr (psr2-cursor-plane-onoff)
[190.114400] Starting subtest: psr2-cursor-plane-onoff
[190.115300] Starting dynamic subtest: eDP-1
[191.796351] Dynamic subtest eDP-1: SUCCESS (1.681s)
[191.797219] Subtest psr2-cursor-plane-onoff: SUCCESS (1.682s)
[192.679167] [041/133] (828s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[192.777525] Starting subtest: plane-primary-toggle-with-vblank-wait
[192.778409] Starting dynamic subtest: pipe-A-eDP-1
[192.952067] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.174s)
[193.275147] Starting dynamic subtest: pipe-B-eDP-1
[194.183504] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.914s)
[194.491575] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.714s)
[195.348508] [042/133] (825s left) kms_big_fb (linear-16bpp-rotate-180)
[195.452431] Starting subtest: linear-16bpp-rotate-180
[196.875514] Subtest linear-16bpp-rotate-180: SUCCESS (1.423s)
[196.995411] [043/133] (824s left) prime_vgem (busy)
[197.054840] Starting subtest: busy
[197.055781] Starting dynamic subtest: rcs0
[197.120083] Dynamic subtest rcs0: SUCCESS (0.065s)
[197.129795] Starting dynamic subtest: bcs0
[197.179656] Dynamic subtest bcs0: SUCCESS (0.058s)
[197.186176] Starting dynamic subtest: vcs0
[197.226071] Dynamic subtest vcs0: SUCCESS (0.046s)
[197.233547] Starting dynamic subtest: vcs1
[197.269967] Dynamic subtest vcs1: SUCCESS (0.042s)
[197.276500] Starting dynamic subtest: vecs0
[197.316446] Dynamic subtest vecs0: SUCCESS (0.046s)
[197.324188] Starting dynamic subtest: ccs0
[197.362963] Dynamic subtest ccs0: SUCCESS (0.045s)
[197.363867] Subtest busy: SUCCESS (0.309s)
[197.475178] [044/133] (823s left) kms_addfb_basic (bo-too-small)
[197.565223] Starting subtest: bo-too-small
[197.566077] Subtest bo-too-small: SUCCESS (0.000s)
[197.647522] [045/133] (823s left) gem_exec_fence (basic-busy-all)
[197.725303] Starting subtest: basic-busy-all
[197.810686] Subtest basic-busy-all: SUCCESS (0.085s)
[199.938668] [046/133] (821s left) kms_pm_rpm (package-g7)
[202.065997] Starting subtest: package-g7
[202.067894] Subtest package-g7: SKIP (0.000s)
[202.442412] [047/133] (818s left) gem_wait (write-wait)
[202.506611] Starting subtest: write-wait
[202.507598] Starting dynamic subtest: all-engines
[203.603894] Dynamic subtest all-engines: SUCCESS (1.098s)
[203.619644] Starting dynamic subtest: rcs0
[204.660808] Dynamic subtest rcs0: SUCCESS (1.054s)
[204.676410] Starting dynamic subtest: bcs0
[205.717163] Dynamic subtest bcs0: SUCCESS (1.054s)
[205.732244] Starting dynamic subtest: vcs0
[206.770753] Dynamic subtest vcs0: SUCCESS (1.051s)
[206.785784] Starting dynamic subtest: vcs1
[207.824207] Dynamic subtest vcs1: SUCCESS (1.051s)
[207.839884] Starting dynamic subtest: vecs0
[208.878241] Dynamic subtest vecs0: SUCCESS (1.052s)
[208.904198] Starting dynamic subtest: ccs0
[209.936240] Dynamic subtest ccs0: SUCCESS (1.055s)
[209.937455] Subtest write-wait: SUCCESS (7.432s)
[210.132343] [048/133] (811s left) kms_atomic (plane-immutable-zpos)
[210.221452] Starting subtest: plane-immutable-zpos
[210.222403] Starting dynamic subtest: pipe-A-eDP-1
[210.865508] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.643s)
[210.866483] Subtest plane-immutable-zpos: SUCCESS (0.644s)
[211.683597] [049/133] (809s left) gem_exec_schedule (noreorder-corked)
[211.862958] Starting subtest: noreorder-corked
[211.864060] Starting dynamic subtest: rcs0
[212.986455] Dynamic subtest rcs0: SUCCESS (1.130s)
[212.997080] Starting dynamic subtest: vcs0
[214.938602] Dynamic subtest vcs0: SUCCESS (1.941s)
[214.948347] Starting dynamic subtest: vcs1
[216.920770] Dynamic subtest vcs1: SUCCESS (1.979s)
[216.929673] Starting dynamic subtest: vecs0
[218.885312] Dynamic subtest vecs0: SUCCESS (1.962s)
[218.893992] Starting dynamic subtest: ccs0
[220.024817] Dynamic subtest ccs0: SUCCESS (1.146s)
[220.026296] Subtest noreorder-corked: SUCCESS (8.170s)
[220.202584] [050/133] (801s left) kms_vblank (accuracy-idle)
[220.287064] Starting subtest: accuracy-idle
[220.287925] Starting dynamic subtest: pipe-A-eDP-1
[222.051403] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.764s)
[222.059626] Starting dynamic subtest: pipe-D-eDP-1
[224.527734] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.474s)
[224.528584] Subtest accuracy-idle: SUCCESS (4.242s)
[225.365597] [051/133] (796s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[225.466372] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[225.467272] Starting dynamic subtest: pipe-A
[225.817386] Dynamic subtest pipe-A: SUCCESS (0.352s)
[225.824525] Starting dynamic subtest: pipe-B
[227.268596] Dynamic subtest pipe-B: SUCCESS (1.450s)
[227.276820] Starting dynamic subtest: pipe-C
[228.691612] Dynamic subtest pipe-C: SUCCESS (1.421s)
[228.700999] Starting dynamic subtest: pipe-D
[230.171529] Dynamic subtest pipe-D: SUCCESS (1.478s)
[230.172638] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.706s)
[231.306009] [052/133] (790s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[231.396445] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[238.481887] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.087s)
[238.614689] [053/133] (782s left) kms_plane_scaling (planes-upscale-20x20)
[238.711324] Starting subtest: planes-upscale-20x20
[238.712212] Starting dynamic subtest: pipe-A
[238.773112] Dynamic subtest pipe-A: SUCCESS (0.062s)
[238.781432] Starting dynamic subtest: pipe-B
[239.966809] Dynamic subtest pipe-B: SUCCESS (1.192s)
[239.976926] Starting dynamic subtest: pipe-C
[241.084048] Dynamic subtest pipe-C: SUCCESS (1.116s)
[241.091039] Starting dynamic subtest: pipe-D
[242.214055] Dynamic subtest pipe-D: SUCCESS (1.129s)
[242.214947] Subtest planes-upscale-20x20: SUCCESS (3.504s)
[243.356170] [054/133] (778s left) gem_spin_batch (spin-all-new)
[243.408219] Starting subtest: spin-all-new
[243.422159] Subtest spin-all-new: SUCCESS (0.014s)
[244.917414] [055/133] (776s left) gem_mmap_gtt (flink-race)
[244.976188] Subtest flink-race: SKIP (0.000s)
[245.034773] [056/133] (776s left) gen9_exec_parse (bb-secure)
[245.086181] Subtest bb-secure: SKIP (0.000s)
[245.149778] [057/133] (776s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[245.246901] Starting subtest: yf-tiled-16bpp-rotate-90
[245.248923] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[245.336929] [058/133] (776s left) kms_plane_multiple (2x-tiling-none)
[245.439416] Starting subtest: 2x-tiling-none
[245.441033] Subtest 2x-tiling-none: SKIP (0.000s)
[245.505621] [059/133] (776s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[245.600909] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[245.603224] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[245.698081] [060/133] (776s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[245.816721] Starting subtest: basic-flip-before-cursor-atomic
[246.731820] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.913s)
[247.587435] [061/133] (774s left) kms_psr (fbc-psr-cursor-blt)
[247.686326] Starting subtest: fbc-psr-cursor-blt
[247.687177] Starting dynamic subtest: eDP-1
[247.689029] Dynamic subtest eDP-1: SKIP (0.000s)
[247.690729] Subtest fbc-psr-cursor-blt: SKIP (0.001s)
[247.754983] [062/133] (774s left) gem_mmap_gtt (cpuset-big-copy)
[247.802683] Subtest cpuset-big-copy: SKIP (0.000s)
[247.860991] [063/133] (773s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[247.948409] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[247.975264] Starting dynamic subtest: pipe-A-plane-0
[248.419532] Dynamic subtest pipe-A-plane-0: SUCCESS (0.444s)
[248.426344] Starting dynamic subtest: pipe-A-plane-3
[248.686076] Dynamic subtest pipe-A-plane-3: SUCCESS (0.266s)
[248.694115] Starting dynamic subtest: pipe-A-plane-5
[248.695859] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[249.780760] Starting dynamic subtest: pipe-B-plane-0
[250.207203] Dynamic subtest pipe-B-plane-0: SUCCESS (0.433s)
[250.213964] Starting dynamic subtest: pipe-B-plane-3
[250.496243] Dynamic subtest pipe-B-plane-3: SUCCESS (0.288s)
[250.505273] Starting dynamic subtest: pipe-B-plane-5
[250.506891] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[250.807021] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.858s)
[252.210120] [064/133] (769s left) kms_flip (bo-too-big-interruptible)
[252.314315] Starting subtest: bo-too-big-interruptible
[252.315481] Starting dynamic subtest: A-eDP1
[253.556215] Dynamic subtest A-eDP1: SUCCESS (1.240s)
[253.570722] Starting dynamic subtest: B-eDP1
[254.798873] Dynamic subtest B-eDP1: SUCCESS (1.238s)
[254.808240] Starting dynamic subtest: C-eDP1
[256.053955] Dynamic subtest C-eDP1: SUCCESS (1.252s)
[256.071271] Starting dynamic subtest: D-eDP1
[257.375094] Dynamic subtest D-eDP1: SUCCESS (1.322s)
[257.377142] Subtest bo-too-big-interruptible: SUCCESS (5.064s)
[258.583224] [065/133] (763s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[258.673821] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[258.676032] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.000s)
[258.741684] [066/133] (763s left) gem_softpin (noreloc)
[258.806837] Starting subtest: noreloc
[264.231517] Subtest noreloc: SUCCESS (5.380s)
[264.291822] [067/133] (757s left) kms_content_protection (mei-interface)
[264.436825] Starting subtest: mei-interface
[264.440284] Subtest mei-interface: SKIP (0.001s)
[264.556640] [068/133] (757s left) kms_addfb_basic (master-rmfb)
[264.614209] Starting subtest: master-rmfb
[264.615206] Subtest master-rmfb: SUCCESS (0.001s)
[264.740872] [069/133] (757s left) kms_cursor_edge_walk (64x64-right-edge)
[264.825114] Starting subtest: 64x64-right-edge
[264.825894] Starting dynamic subtest: pipe-A-eDP-1
[268.262431] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.436s)
[268.269341] Starting dynamic subtest: pipe-D-eDP-1
[271.398334] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.135s)
[271.399164] Subtest 64x64-right-edge: SUCCESS (6.574s)
[272.193691] [070/133] (749s left) gem_ctx_persistence (userptr)
[272.247395] Starting subtest: userptr
[272.420871] Subtest userptr: SUCCESS (0.173s)
[272.511724] [071/133] (749s left) gem_exec_reloc (basic-wc-cpu)
[272.565061] Subtest basic-wc-cpu: SKIP (0.000s)
[272.634819] [072/133] (749s left) api_intel_bb (simple-bb)
[272.680906] Starting subtest: simple-bb
[272.686384] Subtest simple-bb: SUCCESS (0.006s)
[272.765900] [073/133] (749s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[272.868336] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[272.869956] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[272.959396] [074/133] (749s left) i915_hangman (engine-error-state-capture)
[273.014476] Starting subtest: engine-error-state-capture
[273.015359] Starting dynamic subtest: rcs0
[276.859065] Dynamic subtest rcs0: SUCCESS (3.835s)
[276.872570] Starting dynamic subtest: bcs0
[282.875104] Dynamic subtest bcs0: SUCCESS (6.013s)
[282.884641] Starting dynamic subtest: vcs0
[288.891427] Dynamic subtest vcs0: SUCCESS (6.013s)
[288.901352] Starting dynamic subtest: vcs1
[294.843578] Dynamic subtest vcs1: SUCCESS (5.949s)
[294.853232] Starting dynamic subtest: vecs0
[299.834994] Dynamic subtest vecs0: SUCCESS (4.988s)
[299.844807] Starting dynamic subtest: ccs0
[305.851570] Dynamic subtest ccs0: SUCCESS (6.013s)
[305.852864] Subtest engine-error-state-capture: SUCCESS (32.827s)
[305.919908] [075/133] (716s left) prime_mmap (test_forked_cpu_write)
[305.970840] Starting subtest: test_forked_cpu_write
[305.971788] Starting dynamic subtest: test_forked_cpu_write-smem
[305.977796] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.008s)
[305.979177] Subtest test_forked_cpu_write: SUCCESS (0.009s)
[306.069598] [076/133] (716s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs)
[306.163279] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs
[306.164370] Starting dynamic subtest: pipe-A-eDP-1
[306.660932] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.485s)
[306.669418] Starting dynamic subtest: pipe-B-eDP-1
[308.175339] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.512s)
[308.186136] Starting dynamic subtest: pipe-C-eDP-1
[309.609568] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.433s)
[309.617913] Starting dynamic subtest: pipe-D-eDP-1
[311.033526] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.423s)
[311.034382] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.860s)
[312.237672] [077/133] (710s left) kms_scaling_modes (scaling-mode-full-aspect)
[312.332211] Starting subtest: scaling-mode-full-aspect
[312.332959] Starting dynamic subtest: pipe-A-eDP-1
[312.445532] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.114s)
[312.453796] Starting dynamic subtest: pipe-B-eDP-1
[313.662858] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.216s)
[313.672222] Starting dynamic subtest: pipe-C-eDP-1
[314.776702] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.112s)
[314.784802] Starting dynamic subtest: pipe-D-eDP-1
[315.922543] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.144s)
[315.924750] Subtest scaling-mode-full-aspect: SUCCESS (3.593s)
[317.064965] [078/133] (705s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[317.154980] Starting subtest: pr-cursor-plane-update-sf
[317.156698] Subtest pr-cursor-plane-update-sf: SKIP (0.000s)
[317.221092] [079/133] (705s left) kms_lease (lease-revoke)
[317.303353] Starting subtest: lease-revoke
[317.304249] Starting dynamic subtest: pipe-A-eDP-1
[317.332807] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.030s)
[317.344285] Starting dynamic subtest: pipe-B-eDP-1
[317.362458] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.027s)
[317.371353] Starting dynamic subtest: pipe-C-eDP-1
[317.391551] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.029s)
[317.400543] Starting dynamic subtest: pipe-D-eDP-1
[317.422789] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.029s)
[317.424052] Subtest lease-revoke: SUCCESS (0.120s)
[317.541017] [080/133] (704s left) gem_exec_store (cachelines)
[317.592305] Starting subtest: cachelines
[317.593366] Starting dynamic subtest: rcs0
[317.669592] Dynamic subtest rcs0: SUCCESS (0.078s)
[317.679646] Starting dynamic subtest: bcs0
[317.734348] Dynamic subtest bcs0: SUCCESS (0.063s)
[317.743525] Starting dynamic subtest: vcs0
[317.796376] Dynamic subtest vcs0: SUCCESS (0.060s)
[317.805551] Starting dynamic subtest: vcs1
[317.853102] Dynamic subtest vcs1: SUCCESS (0.055s)
[317.864072] Starting dynamic subtest: vecs0
[317.918069] Dynamic subtest vecs0: SUCCESS (0.063s)
[317.928550] Starting dynamic subtest: ccs0
[317.973155] Dynamic subtest ccs0: SUCCESS (0.053s)
[317.974320] Subtest cachelines: SUCCESS (0.383s)
[318.159512] [081/133] (704s left) gem_blits (basic)
[318.218085] Starting subtest: basic
[319.708301] Subtest basic: SUCCESS (1.480s)
[319.818082] [082/133] (702s left) gem_unref_active_buffers
[320.010774] [083/133] (702s left) i915_pm_rpm (gem-mmap-type)
[322.136762] Starting subtest: gem-mmap-type
[322.138399] Starting dynamic subtest: wb-smem0
[325.919193] Dynamic subtest wb-smem0: SUCCESS (3.781s)
[325.927605] Starting dynamic subtest: wc-smem0
[329.102291] Dynamic subtest wc-smem0: SUCCESS (3.181s)
[329.110415] Starting dynamic subtest: uc-smem0
[331.952169] Dynamic subtest uc-smem0: SUCCESS (2.848s)
[331.954301] Subtest gem-mmap-type: SUCCESS (9.817s)
[332.046452] [084/133] (690s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[332.143302] Starting subtest: read-crc-frame-sequence
[332.144210] Starting dynamic subtest: pipe-A-eDP-1
[332.859670] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.713s)
[332.873759] Starting dynamic subtest: pipe-B-eDP-1
[334.288625] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.429s)
[334.295603] Starting dynamic subtest: pipe-C-eDP-1
[335.586039] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.296s)
[335.593254] Starting dynamic subtest: pipe-D-eDP-1
[336.914081] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.327s)
[336.915072] Subtest read-crc-frame-sequence: SUCCESS (4.771s)
[337.735227] [085/133] (684s left) kms_cursor_crc (cursor-onscreen-256x85)
[337.998836] Starting subtest: cursor-onscreen-256x85
[338.042820] Subtest cursor-onscreen-256x85: SKIP (0.043s)
[338.196926] [086/133] (684s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[338.298697] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[338.300372] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[338.370178] [087/133] (684s left) gem_softpin (32b-excludes-last-page)
[338.418801] Starting subtest: 32b-excludes-last-page
[338.422834] Subtest 32b-excludes-last-page: SUCCESS (0.004s)
[338.537789] [088/133] (684s left) gem_exec_fence (syncobj-repeat)
[338.993041] Starting subtest: syncobj-repeat
[339.204361] Subtest syncobj-repeat: SUCCESS (0.201s)
[340.981748] [089/133] (681s left) kms_vrr (max-min)
[341.084390] Starting subtest: max-min
[341.087961] Subtest max-min: SKIP (0.000s)
[341.153657] [090/133] (681s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[341.246367] Starting subtest: random-ccs-data-y-tiled-ccs
[341.247265] Starting dynamic subtest: pipe-A-eDP-1
[341.256720] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[341.264237] Starting dynamic subtest: pipe-B-eDP-1
[341.273315] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[341.280446] Starting dynamic subtest: pipe-C-eDP-1
[341.289164] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[341.295703] Starting dynamic subtest: pipe-D-eDP-1
[341.304868] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[341.306440] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.005s)
[343.526589] [091/133] (679s left) kms_chamelium_frames (hdmi-crc-multiple)
[343.917880] Subtest hdmi-crc-multiple: SKIP (0.000s)
[344.733445] [092/133] (678s left) perf_pmu (busy-idle-no-semaphores)
[344.775271] Starting subtest: busy-idle-no-semaphores
[344.776501] Starting dynamic subtest: rcs0
[345.436291] Dynamic subtest rcs0: SUCCESS (0.650s)
[345.444556] Starting dynamic subtest: bcs0
[346.088182] Dynamic subtest bcs0: SUCCESS (0.650s)
[346.096713] Starting dynamic subtest: vcs0
[346.741930] Dynamic subtest vcs0: SUCCESS (0.651s)
[346.750070] Starting dynamic subtest: vcs1
[348.551436] Dynamic subtest vcs1: SUCCESS (1.807s)
[348.559554] Starting dynamic subtest: vecs0
[350.535692] Dynamic subtest vecs0: SUCCESS (1.982s)
[350.546568] Starting dynamic subtest: ccs0
[352.520308] Dynamic subtest ccs0: SUCCESS (1.981s)
[352.521496] Subtest busy-idle-no-semaphores: SUCCESS (7.736s)
[352.621474] [093/133] (670s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[352.673977] Starting subtest: invalid-bsd2-flag-on-blt
[352.674982] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[352.766816] [094/133] (670s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[352.864607] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu
[356.923139] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (4.060s)
[358.080887] [095/133] (664s left) kms_setmode (basic)
[358.122366] Starting subtest: basic
[358.450362] Starting dynamic subtest: pipe-A-eDP-1
[360.504359] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.044s)
[360.840047] Starting dynamic subtest: pipe-B-eDP-1
[362.928789] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.087s)
[363.236053] Subtest basic: SUCCESS (5.113s)
[364.063904] [096/133] (658s left) kms_ccs (bad-aux-stride-yf-tiled-ccs)
[364.151775] Starting subtest: bad-aux-stride-yf-tiled-ccs
[364.152788] Starting dynamic subtest: pipe-A-eDP-1
[364.162450] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[364.170439] Starting dynamic subtest: pipe-B-eDP-1
[364.178930] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[364.188760] Starting dynamic subtest: pipe-C-eDP-1
[364.196760] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[364.203547] Starting dynamic subtest: pipe-D-eDP-1
[364.212339] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[364.214133] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.005s)
[366.415653] [097/133] (656s left) gem_ctx_sseu (invalid-args)
[366.459505] Subtest invalid-args: SKIP (0.000s)
[366.528844] [098/133] (656s left) syncobj_timeline (etime-multi-wait-all-submitted)
[366.574154] Starting subtest: etime-multi-wait-all-submitted
[366.680907] Subtest etime-multi-wait-all-submitted: SUCCESS (0.105s)
[366.753168] [099/133] (656s left) kms_pm_rpm (dpms-non-lpsp)
[369.078566] Starting subtest: dpms-non-lpsp
[369.080874] Subtest dpms-non-lpsp: SKIP (0.001s)
[369.454348] [100/133] (653s left) kms_vblank (query-forked)
[369.540532] Starting subtest: query-forked
[369.541439] Starting dynamic subtest: pipe-A-eDP-1
[371.358567] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.817s)
[371.367386] Starting dynamic subtest: pipe-D-eDP-1
[373.861988] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.502s)
[373.862877] Subtest query-forked: SUCCESS (4.322s)
[374.719271] [101/133] (648s left) gem_exec_params (cliprects_ptr-dirt)
[374.771254] Starting subtest: cliprects_ptr-dirt
[374.772452] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[374.866533] [102/133] (648s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[374.950995] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[374.952688] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[375.042439] [103/133] (648s left) kms_feature_discovery (dp-mst)
[375.129144] Starting subtest: dp-mst
[375.130708] Subtest dp-mst: SKIP (0.000s)
[375.197218] [104/133] (648s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[375.242183] Starting subtest: etime-multi-wait-all-for-submit-submitted
[375.344686] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.103s)
[375.417024] [105/133] (647s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[375.501039] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[375.502744] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[375.610702] [106/133] (647s left) gem_exec_reloc (basic-concurrent0)
[375.675211] Subtest basic-concurrent0: SKIP (0.000s)
[375.729948] [107/133] (647s left) gem_ctx_param (set-priority-range)
[375.793874] Starting subtest: set-priority-range
[375.809016] Subtest set-priority-range: SUCCESS (0.017s)
[375.905072] [108/133] (647s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[375.998598] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[376.000328] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[376.087825] [109/133] (647s left) kms_getfb (getfb2-handle-protection)
[376.171483] Starting subtest: getfb2-handle-protection
[376.184801] Subtest getfb2-handle-protection: SUCCESS (0.014s)
[376.290581] [110/133] (647s left) kms_cursor_legacy (forked-move)
[376.403847] Starting subtest: forked-move
[376.404884] Starting dynamic subtest: pipe-A
[381.912479] Dynamic subtest pipe-A: SUCCESS (5.461s)
[381.922215] Starting dynamic subtest: pipe-B
[387.386770] Dynamic subtest pipe-B: SUCCESS (5.472s)
[387.395761] Starting dynamic subtest: pipe-C
[392.861043] Dynamic subtest pipe-C: SUCCESS (5.471s)
[392.870528] Starting dynamic subtest: pipe-D
[398.329866] Dynamic subtest pipe-D: SUCCESS (5.467s)
[398.342133] Starting dynamic subtest: all-pipes
[403.829031] Dynamic subtest all-pipes: SUCCESS (5.497s)
[403.830250] Subtest forked-move: SUCCESS (27.378s)
[403.927503] [111/133] (619s left) syncobj_basic (bad-flags-fd-to-handle)
[403.969304] Starting subtest: bad-flags-fd-to-handle
[403.970274] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[404.068535] [112/133] (619s left) gem_render_copy (yf-tiled)
[404.120268] Starting subtest: yf-tiled
[404.122089] Subtest yf-tiled: SKIP (0.000s)
[404.300110] [113/133] (619s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[404.387549] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip
[404.389561] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[404.475506] [114/133] (619s left) syncobj_wait (reset-unsignaled)
[404.527961] Starting subtest: reset-unsignaled
[404.529207] Subtest reset-unsignaled: SUCCESS (0.000s)
[404.616926] [115/133] (619s left) gem_exec_nop (basic-sequential)
[404.686430] Starting subtest: basic-sequential
[419.397644] Subtest basic-sequential: SUCCESS (14.712s)
[419.628708] [116/133] (604s left) kms_psr (pr-sprite-plane-move)
[419.731058] Starting subtest: pr-sprite-plane-move
[419.732835] Subtest pr-sprite-plane-move: SKIP (0.000s)
[419.797761] [117/133] (603s left) gem_mmap_gtt (coherency)
[419.847252] Subtest coherency: SKIP (0.000s)
[419.911863] [118/133] (603s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[419.997135] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[419.997898] Starting dynamic subtest: pipe-A-default-mode
[421.167841] Dynamic subtest pipe-A-default-mode: SKIP (1.169s)
[421.169581] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.171s)
[421.320078] [119/133] (602s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[421.420430] Starting subtest: psr-indfb-scaledprimary
[427.208435] Subtest psr-indfb-scaledprimary: SUCCESS (5.788s)
[427.340419] [120/133] (596s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[427.447375] Starting subtest: 4-tiled-16bpp-rotate-270
[427.467366] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.019s)
[427.564286] [121/133] (596s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[427.667832] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[427.669589] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[427.763911] [122/133] (596s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[427.854876] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[427.855881] Starting dynamic subtest: pipe-A-eDP-1
[433.740059] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.884s)
[433.747484] Starting dynamic subtest: pipe-B-eDP-1
[440.405622] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.664s)
[440.406771] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.551s)
[441.269645] [123/133] (582s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[441.359549] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[441.360458] Starting dynamic subtest: pipe-A-eDP-1
[441.369173] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[441.377164] Starting dynamic subtest: pipe-B-eDP-1
[441.385610] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[441.392675] Starting dynamic subtest: pipe-C-eDP-1
[441.401070] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[441.408196] Starting dynamic subtest: pipe-D-eDP-1
[441.416678] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[441.418459] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s)
[443.646032] [124/133] (580s left) i915_drm_fdinfo (busy-idle-check-all)
[443.681239] Starting subtest: busy-idle-check-all
[443.682091] Starting dynamic subtest: rcs0
[443.686108] Dynamic subtest rcs0: SKIP (0.004s)
[443.695071] Starting dynamic subtest: bcs0
[443.696810] Dynamic subtest bcs0: SKIP (0.000s)
[443.704106] Starting dynamic subtest: vcs0
[443.705713] Dynamic subtest vcs0: SKIP (0.000s)
[443.712624] Starting dynamic subtest: vcs1
[443.714323] Dynamic subtest vcs1: SKIP (0.000s)
[443.721170] Starting dynamic subtest: vecs0
[443.723021] Dynamic subtest vecs0: SKIP (0.000s)
[443.729959] Starting dynamic subtest: ccs0
[443.731666] Dynamic subtest ccs0: SKIP (0.000s)
[443.733398] Subtest busy-idle-check-all: SKIP (0.009s)
[443.795684] [125/133] (580s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[443.846717] Starting subtest: single-wait-all-for-submit-available-signaled
[443.847679] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[443.947144] [126/133] (580s left) perf (non-sampling-read-error)
[444.057104] Starting subtest: non-sampling-read-error
[444.068168] Subtest non-sampling-read-error: SUCCESS (0.010s)
[444.106686] [127/133] (579s left) gem_mmap_gtt (big-copy-xy)
[444.157618] Subtest big-copy-XY: SKIP (0.000s)
[444.208167] [128/133] (579s left) gem_exec_fence (basic-wait)
[444.389270] Starting subtest: basic-wait
[444.390461] Starting dynamic subtest: rcs0
[444.471710] Dynamic subtest rcs0: SUCCESS (0.087s)
[444.483575] Starting dynamic subtest: bcs0
[444.543439] Dynamic subtest bcs0: SUCCESS (0.069s)
[444.555203] Starting dynamic subtest: vcs0
[444.610031] Dynamic subtest vcs0: SUCCESS (0.065s)
[444.621569] Starting dynamic subtest: vcs1
[444.665686] Dynamic subtest vcs1: SUCCESS (0.052s)
[444.677864] Starting dynamic subtest: vecs0
[444.729479] Dynamic subtest vecs0: SUCCESS (0.062s)
[444.741282] Starting dynamic subtest: ccs0
[444.794475] Dynamic subtest ccs0: SUCCESS (0.063s)
[444.795740] Subtest basic-wait: SUCCESS (0.412s)
[447.024842] [129/133] (577s left) gem_create (create-ext-placement-each)
[447.203993] Starting subtest: create-ext-placement-each
[447.206881] Subtest create-ext-placement-each: SUCCESS (0.000s)
[447.299244] [130/133] (576s left) kms_flip (plain-flip-ts-check-interruptible)
[447.400736] Starting subtest: plain-flip-ts-check-interruptible
[447.402968] Starting dynamic subtest: A-eDP1
[456.252733] Dynamic subtest A-eDP1: SUCCESS (8.824s)
[456.262416] Starting dynamic subtest: B-eDP1
[465.097796] Dynamic subtest B-eDP1: SUCCESS (8.841s)
[465.107273] Starting dynamic subtest: C-eDP1
[473.925244] Dynamic subtest C-eDP1: SUCCESS (8.815s)
[473.935753] Starting dynamic subtest: D-eDP1
[482.743251] Dynamic subtest D-eDP1: SUCCESS (8.816s)
[482.744206] Subtest plain-flip-ts-check-interruptible: SUCCESS (35.312s)
[483.882582] [131/133] (540s left) gem_basic (bad-close)
[483.940499] Starting subtest: bad-close
[483.942218] Subtest bad-close: SUCCESS (0.000s)
[484.044237] [132/133] (540s left) gem_mmap_gtt (basic-short)
[484.102119] Subtest basic-short: SKIP (0.000s)
[484.152237] [133/133] (540s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[484.288487] Starting subtest: cursor-rapid-movement-32x32
[484.335933] Subtest cursor-rapid-movement-32x32: SKIP (0.045s)
[484.652844] 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.