[54.709794] Initializing watchdogs
[54.709846]   /dev/watchdog0
[54.724038] [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]
[54.728512] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[54.730758] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[54.734029] [001/130] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[54.849637] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[54.854033] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[54.945857] [002/130] (960s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[55.048568] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[55.060244] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.011s)
[55.127894] [003/130] (960s left) kms_cursor_edge_walk (128x128-top-edge)
[55.213603] Starting subtest: 128x128-top-edge
[55.215701] Starting dynamic subtest: pipe-A-eDP-1
[58.628910] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.479s)
[58.636795] Starting dynamic subtest: pipe-D-eDP-1
[61.686360] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.112s)
[61.688584] Subtest 128x128-top-edge: SUCCESS (6.593s)
[62.477079] [004/130] (952s left) kms_content_protection (dp-mst-lic-type-0)
[62.652589] Starting subtest: dp-mst-lic-type-0
[62.657251] Subtest dp-mst-lic-type-0: SKIP (0.000s)
[62.782985] [005/130] (952s left) kms_joiner (basic-max-non-joiner)
[62.884838] Starting subtest: basic-max-non-joiner
[62.889419] Subtest basic-max-non-joiner: SKIP (0.000s)
[62.942523] [006/130] (952s left) gem_ctx_isolation (preservation-reset)
[63.108794] Starting subtest: preservation-reset
[63.111335] Starting dynamic subtest: rcs0
[63.315977] Dynamic subtest rcs0: SUCCESS (0.209s)
[63.326264] Starting dynamic subtest: bcs0
[63.572039] Dynamic subtest bcs0: SUCCESS (0.260s)
[63.581169] Starting dynamic subtest: vcs0
[63.834034] Dynamic subtest vcs0: SUCCESS (0.265s)
[63.843840] Starting dynamic subtest: vcs1
[65.127791] Dynamic subtest vcs1: SUCCESS (1.306s)
[65.137912] Starting dynamic subtest: vecs0
[67.142720] Dynamic subtest vecs0: SUCCESS (2.031s)
[67.149961] Starting dynamic subtest: ccs0
[69.150259] Dynamic subtest ccs0: SUCCESS (2.019s)
[69.152901] Subtest preservation-reset: SUCCESS (6.093s)
[69.297596] [007/130] (946s left) prime_mmap (test_dup)
[69.347855] Starting subtest: test_dup
[69.349871] Starting dynamic subtest: test_dup-smem
[69.381251] Dynamic subtest test_dup-smem: SUCCESS (0.035s)
[69.383599] Subtest test_dup: SUCCESS (0.035s)
[69.454255] [008/130] (946s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[69.506197] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[69.508433] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[69.624773] [009/130] (945s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[69.720021] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[69.722710] Starting dynamic subtest: pipe-A
[70.081122] Dynamic subtest pipe-A: SUCCESS (0.363s)
[70.089284] Starting dynamic subtest: pipe-B
[71.535910] Dynamic subtest pipe-B: SUCCESS (1.459s)
[71.545442] Starting dynamic subtest: pipe-C
[72.934366] Dynamic subtest pipe-C: SUCCESS (1.404s)
[72.943162] Starting dynamic subtest: pipe-D
[74.342575] Dynamic subtest pipe-D: SUCCESS (1.412s)
[74.344881] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.639s)
[75.503461] [010/130] (940s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[75.602245] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[75.606606] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[75.714558] [011/130] (939s left) kms_joiner (invalid-modeset-ultra-joiner)
[75.818961] Starting subtest: invalid-modeset-ultra-joiner
[75.822992] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[75.882433] [012/130] (939s left) i915_pm_rc6_residency (media-rc6-accuracy)
[75.948276] Starting subtest: media-rc6-accuracy
[75.952864] Subtest media-rc6-accuracy: SKIP (0.000s)
[76.048129] [013/130] (939s left) kms_pm_rpm (pm-caching)
[78.070993] Starting subtest: pm-caching
[78.077076] Subtest pm-caching: SKIP (0.000s)
[78.444477] [014/130] (937s left) kms_addfb_basic (too-high)
[78.536186] Starting subtest: too-high
[78.538540] Subtest too-high: SUCCESS (0.001s)
[78.636716] [015/130] (937s left) gem_eio (context-create)
[78.791268] Starting subtest: context-create
[78.974861] Subtest context-create: SUCCESS (0.182s)
[79.089127] [016/130] (936s left) gem_exec_suspend (basic-s4-devices)
[79.156457] Starting subtest: basic-S4-devices
[79.158786] Starting dynamic subtest: smem
[90.899769] Dynamic subtest smem: SUCCESS (11.749s)
[90.902857] Subtest basic-S4-devices: SUCCESS (11.750s)
[98.090483] [017/130] (924s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[98.235218] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[98.239206] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[98.352653] [018/130] (924s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[98.479356] Starting subtest: cursorB-vs-flipB-atomic
[98.484076] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[98.625566] [019/130] (924s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[103.689432] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area
[103.693996] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.003s)
[104.517014] [020/130] (918s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-gtt)
[104.624470] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-gtt
[104.628572] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[104.709022] [021/130] (918s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[104.824549] Starting subtest: y-tiled-16bpp-rotate-180
[104.828791] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s)
[104.935533] [022/130] (918s left) sw_sync (sync_busy_fork_unixsocket)
[104.969382] Starting subtest: sync_busy_fork_unixsocket
[104.974282] Subtest sync_busy_fork_unixsocket: SUCCESS (0.006s)
[105.025530] [023/130] (918s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[105.087134] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[105.089490] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[105.192682] [024/130] (917s left) gem_exec_params (invalid-bsd-ring)
[105.255225] Starting subtest: invalid-bsd-ring
[105.257662] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[105.347456] [025/130] (917s left) syncobj_timeline (invalid-wait-illegal-handle)
[105.405077] Starting subtest: invalid-wait-illegal-handle
[105.407074] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[105.508872] [026/130] (917s left) kms_psr (psr2-cursor-plane-onoff)
[105.606837] Starting subtest: psr2-cursor-plane-onoff
[105.609617] Starting dynamic subtest: eDP-1
[107.292406] Dynamic subtest eDP-1: SUCCESS (1.683s)
[107.294361] Subtest psr2-cursor-plane-onoff: SUCCESS (1.683s)
[108.076373] [027/130] (915s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[108.135333] Starting subtest: y-tiled-ccs-to-y-tiled
[108.139869] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[108.324353] [028/130] (914s left) gen9_exec_parse (allowed-all)
[108.388916] Subtest allowed-all: SKIP (0.000s)
[108.461344] [029/130] (914s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[108.565946] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[109.223312] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.659s)
[109.396125] [030/130] (913s left) gem_userptr_blits (stress-purge)
[109.470723] Starting subtest: stress-purge
[114.865234] Subtest stress-purge: SUCCESS (5.396s)
[115.007155] [031/130] (908s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[115.105077] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[115.109069] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[115.288513] [032/130] (908s left) core_setmaster (master-drop-set-root)
[115.361906] Starting subtest: master-drop-set-root
[115.366634] Subtest master-drop-set-root: SUCCESS (0.005s)
[115.413243] [033/130] (908s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[115.528642] Starting subtest: psr-farfromfence-mmap-gtt
[115.532730] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[115.635180] [034/130] (907s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[115.728093] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[115.732309] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[115.826386] [035/130] (907s left) kms_psr (psr-primary-mmap-gtt)
[115.923084] Starting subtest: psr-primary-mmap-gtt
[115.925244] Starting dynamic subtest: eDP-1
[117.371698] Dynamic subtest eDP-1: SKIP (1.444s)
[117.376413] Subtest psr-primary-mmap-gtt: SKIP (1.445s)
[117.537233] [036/130] (906s left) api_intel_allocator (reopen)
[117.596206] Starting subtest: reopen
[117.600756] Subtest reopen: SUCCESS (0.005s)
[117.730480] [037/130] (905s left) gem_ctx_persistence (idempotent)
[117.782751] Starting subtest: idempotent
[117.784998] Subtest idempotent: SUCCESS (0.000s)
[117.886604] [038/130] (905s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[117.957449] Starting subtest: multi-wait-for-submit-unsubmitted
[118.063086] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.103s)
[118.138601] [039/130] (905s left) gem_mmap_gtt (medium-copy-odd)
[118.203914] Subtest medium-copy-odd: SKIP (0.000s)
[118.267570] [040/130] (905s left) kms_psr (fbc-psr-sprite-blt)
[118.372347] Starting subtest: fbc-psr-sprite-blt
[118.374710] Starting dynamic subtest: eDP-1
[118.379126] Dynamic subtest eDP-1: SKIP (0.000s)
[118.383554] Subtest fbc-psr-sprite-blt: SKIP (0.000s)
[118.447390] [041/130] (905s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[118.546704] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[118.550911] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[118.658935] [042/130] (905s left) perf (create-destroy-userspace-config)
[118.792325] Starting subtest: create-destroy-userspace-config
[118.811773] Subtest create-destroy-userspace-config: SUCCESS (0.020s)
[118.855913] [043/130] (904s left) gem_exec_reloc (basic-gtt-wc)
[118.933132] Subtest basic-gtt-wc: SKIP (0.000s)
[119.026479] [044/130] (904s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[119.129061] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[125.549809] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.422s)
[125.711947] [045/130] (898s left) gem_mmap (basic)
[125.763095] Subtest basic: SKIP (0.000s)
[125.818991] [046/130] (898s left) gem_bad_reloc (negative-reloc-bltcopy)
[125.886604] Subtest negative-reloc-bltcopy: SKIP (0.000s)
[125.978550] [047/130] (898s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[126.095730] Starting subtest: sprite-rotation-90-pos-100-0
[126.100197] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[126.167552] [048/130] (897s left) perf (sysctl-defaults)
[126.227056] Starting subtest: sysctl-defaults
[126.229548] Subtest sysctl-defaults: SUCCESS (0.000s)
[126.293449] [049/130] (897s left) gem_ctx_persistence (legacy-engines-queued)
[126.345145] Starting subtest: legacy-engines-queued
[126.347512] Starting dynamic subtest: render
[126.442037] Dynamic subtest render: SUCCESS (0.096s)
[126.454076] Starting dynamic subtest: bsd1
[127.858288] Dynamic subtest bsd1: SUCCESS (1.413s)
[127.870764] Starting dynamic subtest: bsd2
[129.840340] Dynamic subtest bsd2: SUCCESS (1.979s)
[129.851526] Starting dynamic subtest: blt
[129.927954] Dynamic subtest blt: SUCCESS (0.087s)
[129.940437] Starting dynamic subtest: vebox
[131.888093] Dynamic subtest vebox: SUCCESS (1.957s)
[131.890657] Subtest legacy-engines-queued: SUCCESS (5.541s)
[131.965044] [050/130] (892s left) kms_psr (fbc-pr-sprite-render)
[132.069254] Starting subtest: fbc-pr-sprite-render
[132.073847] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[132.140513] [051/130] (892s left) gem_exercise_blt (fast-copy)
[132.210276] Starting subtest: fast-copy
[132.212538] Starting dynamic subtest: linear-smem-smem
[132.235474] Dynamic subtest linear-smem-smem: SUCCESS (0.025s)
[132.245723] Starting dynamic subtest: xmajor-smem-smem
[132.254426] Dynamic subtest xmajor-smem-smem: SUCCESS (0.019s)
[132.263395] Starting dynamic subtest: tile4-smem-smem
[132.274735] Dynamic subtest tile4-smem-smem: SUCCESS (0.020s)
[132.283708] Starting dynamic subtest: tile64-smem-smem
[132.294945] Dynamic subtest tile64-smem-smem: SUCCESS (0.020s)
[132.297223] Subtest fast-copy: SUCCESS (0.085s)
[132.424502] [052/130] (891s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[132.525892] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[139.164721] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (6.641s)
[139.285688] [053/130] (884s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[139.375042] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs
[139.377391] Starting dynamic subtest: pipe-A-eDP-1
[139.400326] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[139.410119] Starting dynamic subtest: pipe-B-eDP-1
[139.431093] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[139.440425] Starting dynamic subtest: pipe-C-eDP-1
[139.460985] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[139.470073] Starting dynamic subtest: pipe-D-eDP-1
[139.492131] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[139.496260] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.003s)
[141.537674] [054/130] (882s left) gem_mmap_gtt (cpuset-big-copy-xy)
[141.598271] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[141.661880] [055/130] (882s left) gem_exec_schedule (fifo)
[141.732036] Starting subtest: fifo
[141.734331] Starting dynamic subtest: rcs0
[141.819889] Dynamic subtest rcs0: SUCCESS (0.098s)
[141.832676] Starting dynamic subtest: vcs0
[141.896227] Dynamic subtest vcs0: SUCCESS (0.076s)
[141.909591] Starting dynamic subtest: vcs1
[141.973055] Dynamic subtest vcs1: SUCCESS (0.076s)
[141.984583] Starting dynamic subtest: vecs0
[142.049450] Dynamic subtest vecs0: SUCCESS (0.076s)
[142.061266] Starting dynamic subtest: ccs0
[142.125917] Dynamic subtest ccs0: SUCCESS (0.077s)
[142.128409] Subtest fifo: SUCCESS (0.405s)
[143.052436] [056/130] (881s left) gem_create (create-ext-cpu-access-big)
[143.229584] Starting subtest: create-ext-cpu-access-big
[143.234205] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[143.302016] [057/130] (881s left) kms_plane_multiple (2x-tiling-y)
[143.399038] Starting subtest: 2x-tiling-y
[143.403384] Subtest 2x-tiling-y: SKIP (0.000s)
[143.470564] [058/130] (880s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[143.580206] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[150.879560] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.303s)
[151.019304] [059/130] (873s left) kms_scaling_modes (scaling-mode-none)
[151.116652] Starting subtest: scaling-mode-none
[151.118929] Starting dynamic subtest: pipe-A-eDP-1
[151.213815] Dynamic subtest pipe-A-eDP-1: SKIP (0.094s)
[151.224400] Starting dynamic subtest: pipe-B-eDP-1
[151.245798] Dynamic subtest pipe-B-eDP-1: SKIP (0.031s)
[151.256760] Starting dynamic subtest: pipe-C-eDP-1
[151.277732] Dynamic subtest pipe-C-eDP-1: SKIP (0.032s)
[151.287546] Starting dynamic subtest: pipe-D-eDP-1
[151.310528] Dynamic subtest pipe-D-eDP-1: SKIP (0.031s)
[151.314798] Subtest scaling-mode-none: SKIP (0.191s)
[151.461824] [060/130] (873s left) gem_pxp (create-protected-buffer)
[151.578780] Starting subtest: create-protected-buffer
[151.581606] Subtest create-protected-buffer: SUCCESS (0.000s)
[151.683787] [061/130] (872s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[151.771107] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[151.773457] Starting dynamic subtest: pipe-A-eDP-1
[151.797147] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[151.808936] Starting dynamic subtest: pipe-B-eDP-1
[151.829515] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[151.838472] Starting dynamic subtest: pipe-C-eDP-1
[151.855762] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[151.864515] Starting dynamic subtest: pipe-D-eDP-1
[151.882730] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[151.886058] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[153.890817] [062/130] (870s left) perf_pmu (busy-start)
[153.934793] Starting subtest: busy-start
[153.937200] Starting dynamic subtest: rcs0
[156.483775] Dynamic subtest rcs0: SUCCESS (2.549s)
[156.496598] Starting dynamic subtest: bcs0
[159.032216] Dynamic subtest bcs0: SUCCESS (2.547s)
[159.045667] Starting dynamic subtest: vcs0
[162.898361] Dynamic subtest vcs0: SUCCESS (3.863s)
[162.909662] Starting dynamic subtest: vcs1
[166.930053] Dynamic subtest vcs1: SUCCESS (4.031s)
[166.943577] Starting dynamic subtest: vecs0
[170.898405] Dynamic subtest vecs0: SUCCESS (3.966s)
[170.911584] Starting dynamic subtest: ccs0
[173.447255] Dynamic subtest ccs0: SUCCESS (2.549s)
[173.449731] Subtest busy-start: SUCCESS (19.512s)
[173.571822] [063/130] (851s left) kms_color (legacy-gamma)
[173.672182] Starting subtest: legacy-gamma
[173.674564] Starting dynamic subtest: pipe-A-eDP-1
[174.368720] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.695s)
[174.380670] Starting dynamic subtest: pipe-B-eDP-1
[175.765622] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.395s)
[175.775514] Starting dynamic subtest: pipe-C-eDP-1
[177.131386] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.365s)
[177.141043] Starting dynamic subtest: pipe-D-eDP-1
[178.463799] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.332s)
[178.465677] Subtest legacy-gamma: SUCCESS (4.789s)
[179.281582] [064/130] (845s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[179.376701] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[185.825497] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.451s)
[185.948536] [065/130] (838s left) kms_dp_link_training (uhbr-mst)
[186.038397] Starting subtest: uhbr-mst
[186.047503] Subtest uhbr-mst: SKIP (0.000s)
[186.110794] [066/130] (838s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[191.118793] Starting subtest: psr2-plane-move-sf-dmg-area
[191.120725] Starting dynamic subtest: pipe-A-eDP-1
[196.406677] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.288s)
[196.417017] Starting dynamic subtest: pipe-B-eDP-1
[201.700165] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.289s)
[201.702466] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (10.581s)
[202.564361] [067/130] (822s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[202.616848] Starting subtest: y-tiled-to-vebox-y-tiled
[202.621068] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[202.799795] [068/130] (822s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[202.903626] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[207.160343] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.260s)
[208.352091] [069/130] (816s left) i915_drm_fdinfo (busy-hang)
[208.390450] Starting subtest: busy-hang
[208.392712] Starting dynamic subtest: rcs0
[208.431693] Dynamic subtest rcs0: SKIP (0.040s)
[208.443068] Starting dynamic subtest: bcs0
[208.447329] Dynamic subtest bcs0: SKIP (0.001s)
[208.456803] Starting dynamic subtest: vcs0
[208.461070] Dynamic subtest vcs0: SKIP (0.000s)
[208.469844] Starting dynamic subtest: vcs1
[208.474013] Dynamic subtest vcs1: SKIP (0.000s)
[208.482759] Starting dynamic subtest: vecs0
[208.486761] Dynamic subtest vecs0: SKIP (0.000s)
[208.495763] Starting dynamic subtest: ccs0
[208.499750] Dynamic subtest ccs0: SKIP (0.000s)
[208.503742] Subtest busy-hang: SKIP (0.046s)
[208.538186] [070/130] (816s left) kms_flip (2x-flip-vs-wf_vblank)
[208.635156] Starting subtest: 2x-flip-vs-wf_vblank
[208.646777] Subtest 2x-flip-vs-wf_vblank: SKIP (0.011s)
[208.722216] [071/130] (816s left) gem_lmem_swapping (basic)
[208.762562] Subtest basic: SKIP (0.000s)
[208.807437] [072/130] (816s left) kms_atomic_transition (plane-all-transition-nonblocking)
[208.902149] Starting subtest: plane-all-transition-nonblocking
[208.904393] Starting dynamic subtest: pipe-A-eDP-1
[211.403373] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.503s)
[211.722081] Starting dynamic subtest: pipe-B-eDP-1
[214.976404] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.265s)
[215.273306] Subtest plane-all-transition-nonblocking: SUCCESS (6.373s)
[216.092848] [073/130] (808s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[216.213829] Starting subtest: cursorA-vs-flipA-atomic
[227.386459] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.171s)
[228.211877] [074/130] (796s left) syncobj_timeline (single-wait-all-available-submitted)
[228.265082] Starting subtest: single-wait-all-available-submitted
[228.267252] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[228.372544] [075/130] (796s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[228.464601] Starting subtest: psr-rgb565-draw-blt
[235.348363] Subtest psr-rgb565-draw-blt: SUCCESS (6.886s)
[235.492523] [076/130] (789s left) kms_vblank (wait-forked-busy)
[235.605271] Starting subtest: wait-forked-busy
[235.607426] Starting dynamic subtest: pipe-A-eDP-1
[237.504587] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.898s)
[237.520950] Starting dynamic subtest: pipe-D-eDP-1
[240.074057] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.567s)
[240.076455] Subtest wait-forked-busy: SUCCESS (4.468s)
[240.872480] [077/130] (784s left) kms_properties (crtc-properties-atomic)
[240.961171] Starting subtest: crtc-properties-atomic
[240.963426] Starting dynamic subtest: pipe-A-eDP-1
[241.402940] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.439s)
[241.414892] Starting dynamic subtest: pipe-B-eDP-1
[242.528973] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.125s)
[242.539299] Starting dynamic subtest: pipe-C-eDP-1
[243.634305] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.105s)
[243.646612] Starting dynamic subtest: pipe-D-eDP-1
[244.767731] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.133s)
[244.769914] Subtest crtc-properties-atomic: SUCCESS (3.807s)
[245.571084] [078/130] (779s left) kms_big_fb (y-tiled-addfb-size-overflow)
[245.679536] Starting subtest: y-tiled-addfb-size-overflow
[245.683689] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s)
[245.787395] [079/130] (779s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[245.846144] Starting subtest: invalid-multi-wait-unsubmitted
[245.848473] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[245.959898] [080/130] (779s left) kms_addfb_basic (master-rmfb)
[246.023822] Starting subtest: master-rmfb
[246.026590] Subtest master-rmfb: SUCCESS (0.001s)
[246.182218] [081/130] (779s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[246.285747] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[246.290246] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[246.380176] [082/130] (778s left) gem_exec_store (pages)
[246.447999] Starting subtest: pages
[246.450261] Starting dynamic subtest: rcs0
[246.554598] Dynamic subtest rcs0: SUCCESS (0.109s)
[246.566730] Starting dynamic subtest: bcs0
[246.636042] Dynamic subtest bcs0: SUCCESS (0.080s)
[246.645075] Starting dynamic subtest: vcs0
[246.709478] Dynamic subtest vcs0: SUCCESS (0.073s)
[246.718356] Starting dynamic subtest: vcs1
[246.802735] Dynamic subtest vcs1: SUCCESS (0.092s)
[246.812753] Starting dynamic subtest: vecs0
[246.880577] Dynamic subtest vecs0: SUCCESS (0.076s)
[246.889527] Starting dynamic subtest: ccs0
[246.971817] Dynamic subtest ccs0: SUCCESS (0.090s)
[246.973919] Subtest pages: SUCCESS (0.528s)
[247.154439] [083/130] (778s left) kms_plane_alpha_blend (constant-alpha-mid)
[247.249462] Starting subtest: constant-alpha-mid
[247.539047] Starting dynamic subtest: pipe-A-eDP-1
[248.326599] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.787s)
[248.337265] Starting dynamic subtest: pipe-D-eDP-1
[249.817987] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.488s)
[249.820402] Subtest constant-alpha-mid: SUCCESS (2.566s)
[250.609274] [084/130] (774s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[250.706666] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[250.711063] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[250.830276] [085/130] (774s left) kms_pm_dc (dc5-dpms-negative)
[251.929216] Starting subtest: dc5-dpms-negative
[251.933221] Subtest dc5-dpms-negative: SKIP (0.000s)
[252.000631] [086/130] (773s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[252.107654] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[252.112109] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[252.223025] [087/130] (773s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[252.312157] Starting subtest: modeset-transition-nonblocking-fencing
[252.314049] Starting dynamic subtest: 1x-outputs
[263.341800] Dynamic subtest 1x-outputs: SUCCESS (11.031s)
[263.648928] Subtest modeset-transition-nonblocking-fencing: SUCCESS (11.336s)
[264.458191] [088/130] (761s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[264.551195] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[264.553381] Starting dynamic subtest: pipe-A-eDP-1
[264.562159] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[264.571912] Starting dynamic subtest: pipe-B-eDP-1
[264.581496] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[264.593908] Starting dynamic subtest: pipe-C-eDP-1
[264.602232] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[264.611506] Starting dynamic subtest: pipe-D-eDP-1
[264.619700] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[264.623656] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.004s)
[266.797292] [089/130] (758s left) kms_busy (extended-pageflip-hang-oldfb)
[266.905173] Starting subtest: extended-pageflip-hang-oldfb
[266.907500] Starting dynamic subtest: pipe-A
[267.300149] Dynamic subtest pipe-A: SUCCESS (0.392s)
[267.311337] Starting dynamic subtest: pipe-D
[268.400799] Dynamic subtest pipe-D: SUCCESS (1.099s)
[268.403224] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.496s)
[269.250824] [090/130] (756s left) kms_chamelium_color (ctm-blue-to-red)
[269.349218] Subtest ctm-blue-to-red: SKIP (0.000s)
[269.396116] [091/130] (756s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[269.507585] Starting subtest: yf-tiled-64bpp-rotate-90
[269.511973] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[269.614501] [092/130] (756s left) gem_readwrite (read-write)
[269.690980] Subtest read-write: SKIP (0.000s)
[269.758397] [093/130] (756s left) gem_exec_create (legacy)
[269.825529] Starting subtest: legacy
[269.827434] Starting dynamic subtest: smem
[273.876581] Dynamic subtest smem: SUCCESS (4.051s)
[273.879221] Subtest legacy: SUCCESS (4.052s)
[274.066624] [094/130] (751s left) kms_async_flips (invalid-async-flip-atomic)
[274.179772] Starting subtest: invalid-async-flip-atomic
[274.183934] Subtest invalid-async-flip-atomic: SKIP (0.000s)
[275.374840] [095/130] (750s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[275.495310] Starting subtest: flip-vs-cursor-crc-legacy
[276.151990] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.659s)
[277.004276] [096/130] (748s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[277.107030] Starting subtest: x-tiled-32bpp-rotate-90
[277.129212] Subtest x-tiled-32bpp-rotate-90: SKIP (0.019s)
[277.237864] [097/130] (748s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[277.342784] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[277.347228] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[277.422202] [098/130] (748s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[277.531896] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[277.536237] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[277.647027] [099/130] (748s left) prime_busy (before)
[277.706501] Starting subtest: before
[277.711304] Starting dynamic subtest: rcs0
[277.746469] Dynamic subtest rcs0: SUCCESS (0.037s)
[277.758345] Starting dynamic subtest: bcs0
[277.807661] Dynamic subtest bcs0: SUCCESS (0.060s)
[277.819143] Starting dynamic subtest: vcs0
[277.848551] Dynamic subtest vcs0: SUCCESS (0.040s)
[277.860487] Starting dynamic subtest: vcs1
[277.888973] Dynamic subtest vcs1: SUCCESS (0.039s)
[277.898453] Starting dynamic subtest: vecs0
[277.928440] Dynamic subtest vecs0: SUCCESS (0.039s)
[277.937405] Starting dynamic subtest: ccs0
[277.968430] Dynamic subtest ccs0: SUCCESS (0.040s)
[278.077615] Subtest before: SUCCESS (0.369s)
[278.150852] [100/130] (747s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[278.259044] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[285.497393] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.240s)
[285.641307] [101/130] (740s left) gem_mmap_offset (partial-remap)
[285.697362] Starting subtest: partial-remap
[285.699309] Starting dynamic subtest: smem0
[285.708075] Dynamic subtest smem0: SUCCESS (0.004s)
[285.710331] Subtest partial-remap: SUCCESS (0.004s)
[285.794489] [102/130] (740s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[285.892891] Starting subtest: plane-use-after-nonblocking-unbind
[285.895214] Starting dynamic subtest: pipe-A-eDP-1
[285.960617] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.070s)
[286.258133] Starting dynamic subtest: pipe-B-eDP-1
[287.001331] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.755s)
[287.287931] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.394s)
[288.149450] [103/130] (738s left) syncobj_basic (bad-flags-handle-to-fd)
[288.216079] Starting subtest: bad-flags-handle-to-fd
[288.218399] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[288.328422] [104/130] (737s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[288.423393] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[288.425693] Starting dynamic subtest: pipe-A-default-mode
[289.609152] Dynamic subtest pipe-A-default-mode: SKIP (1.183s)
[289.615814] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.184s)
[289.774128] [105/130] (736s left) dmabuf_sync_file (import-basic)
[289.892563] Starting subtest: import-basic
[289.894722] Subtest import-basic: SUCCESS (0.001s)
[289.947096] [FACT dmabuf_sync_file (import-basic)] new: kernel.kmod_is_loaded.vgem: true
[289.951180] [106/130] (736s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[290.329750] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[291.174128] [107/130] (735s left) gem_render_copy_redux (flink)
[291.239310] Starting subtest: flink
[291.940775] Subtest flink: SUCCESS (0.701s)
[292.113025] [108/130] (734s left) gem_exec_schedule (preempt-contexts)
[292.187572] Starting subtest: preempt-contexts
[292.189733] Starting dynamic subtest: rcs0
[292.236715] Dynamic subtest rcs0: SUCCESS (0.058s)
[292.247205] Starting dynamic subtest: bcs0
[292.289490] Dynamic subtest bcs0: SUCCESS (0.052s)
[292.299841] Starting dynamic subtest: vcs0
[292.337436] Dynamic subtest vcs0: SUCCESS (0.047s)
[292.347445] Starting dynamic subtest: vcs1
[292.385915] Dynamic subtest vcs1: SUCCESS (0.047s)
[292.396207] Starting dynamic subtest: vecs0
[292.426707] Dynamic subtest vecs0: SUCCESS (0.041s)
[292.436687] Starting dynamic subtest: ccs0
[292.476314] Dynamic subtest ccs0: SUCCESS (0.049s)
[292.478131] Subtest preempt-contexts: SUCCESS (0.298s)
[294.026972] [109/130] (732s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[294.129881] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[294.141526] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.011s)
[294.269250] [110/130] (732s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[294.368190] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[294.370419] Starting dynamic subtest: pipe-A-default-mode
[297.138954] Dynamic subtest pipe-A-default-mode: SUCCESS (2.766s)
[297.140897] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.768s)
[297.963140] [111/130] (728s left) gem_exec_balancer (persistence)
[298.224546] Starting subtest: persistence
[299.108807] Subtest persistence: SUCCESS (0.884s)
[299.247086] [112/130] (727s left) i915_pm_rps (thresholds-idle)
[299.309410] Starting subtest: thresholds-idle
[299.314227] Subtest thresholds-idle: SKIP (0.001s)
[299.398405] [113/130] (727s left) gem_exec_params (sol-reset-not-gen7)
[299.460726] Starting subtest: sol-reset-not-gen7
[299.465852] Subtest sol-reset-not-gen7: SUCCESS (0.003s)
[299.582302] [114/130] (727s left) kms_big_fb (linear-16bpp-rotate-180)
[299.680062] Starting subtest: linear-16bpp-rotate-180
[300.937993] Subtest linear-16bpp-rotate-180: SUCCESS (1.257s)
[301.061776] [115/130] (725s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[301.171210] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[301.174736] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[301.280694] [116/130] (725s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[301.374025] Starting subtest: fbc-psr2-sprite-mmap-cpu
[301.375994] Starting dynamic subtest: eDP-1
[301.379382] Dynamic subtest eDP-1: SKIP (0.000s)
[301.382838] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[301.447924] [117/130] (725s left) kms_cursor_crc (cursor-random-256x256)
[301.697692] Starting subtest: cursor-random-256x256
[301.702279] Starting dynamic subtest: pipe-A-eDP-1
[305.035544] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.332s)
[305.062726] Starting dynamic subtest: pipe-D-eDP-1
[309.055102] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.999s)
[309.057393] Subtest cursor-random-256x256: SUCCESS (7.355s)
[309.913573] [118/130] (716s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[310.020092] Starting subtest: plane-upscale-20x20-with-pixel-format
[310.022382] Starting dynamic subtest: pipe-A
[311.069879] Dynamic subtest pipe-A: SUCCESS (1.050s)
[311.081946] Starting dynamic subtest: pipe-B
[313.210116] Dynamic subtest pipe-B: SUCCESS (2.138s)
[313.220424] Starting dynamic subtest: pipe-C
[314.403145] Dynamic subtest pipe-C: SUCCESS (1.192s)
[314.414264] Starting dynamic subtest: pipe-D
[315.530063] Dynamic subtest pipe-D: SUCCESS (1.125s)
[315.532376] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.510s)
[316.708217] [119/130] (710s left) perf (global-sseu-config)
[316.782794] Starting subtest: global-sseu-config
[316.787579] Subtest global-sseu-config: SKIP (0.000s)
[316.834729] [120/130] (710s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[316.889172] Starting subtest: etime-multi-wait-all-for-submit-submitted
[316.988836] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.101s)
[317.065371] [121/130] (709s left) kms_flip (nonexisting-fb-interruptible)
[317.169360] Starting subtest: nonexisting-fb-interruptible
[317.171657] Starting dynamic subtest: A-eDP1
[318.300727] Dynamic subtest A-eDP1: SUCCESS (1.131s)
[318.311709] Starting dynamic subtest: B-eDP1
[319.422966] Dynamic subtest B-eDP1: SUCCESS (1.121s)
[319.433598] Starting dynamic subtest: C-eDP1
[320.547196] Dynamic subtest C-eDP1: SUCCESS (1.123s)
[320.558110] Starting dynamic subtest: D-eDP1
[321.667216] Dynamic subtest D-eDP1: SUCCESS (1.119s)
[321.669501] Subtest nonexisting-fb-interruptible: SUCCESS (4.501s)
[322.827693] [122/130] (704s left) i915_drm_fdinfo (isolation)
[322.865076] Starting subtest: isolation
[322.866893] Starting dynamic subtest: rcs0
[322.904843] Dynamic subtest rcs0: SKIP (0.040s)
[322.916289] Starting dynamic subtest: bcs0
[322.920143] Dynamic subtest bcs0: SKIP (0.001s)
[322.932626] Starting dynamic subtest: vcs0
[322.936815] Dynamic subtest vcs0: SKIP (0.000s)
[322.946315] Starting dynamic subtest: vcs1
[322.950374] Dynamic subtest vcs1: SKIP (0.000s)
[322.959607] Starting dynamic subtest: vecs0
[322.963702] Dynamic subtest vecs0: SKIP (0.000s)
[322.972734] Starting dynamic subtest: ccs0
[322.976679] Dynamic subtest ccs0: SKIP (0.000s)
[322.980576] Subtest isolation: SKIP (0.046s)
[323.017078] [123/130] (703s left) gem_exec_await (wide-contexts)
[323.219203] Starting subtest: wide-contexts
[346.671578] Subtest wide-contexts: SUCCESS (23.453s)
[346.861844] [124/130] (680s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[347.006860] Starting subtest: random-ccs-data-y-tiled-ccs
[347.009187] Starting dynamic subtest: pipe-A-eDP-1
[347.034658] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[347.046543] Starting dynamic subtest: pipe-B-eDP-1
[347.070294] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[347.080156] Starting dynamic subtest: pipe-C-eDP-1
[347.104302] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[347.115947] Starting dynamic subtest: pipe-D-eDP-1
[347.139619] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[347.143676] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.005s)
[349.276887] [125/130] (677s left) gem_exec_params (invalid-fence-in-submit)
[349.346594] Starting subtest: invalid-fence-in-submit
[349.351681] Subtest invalid-fence-in-submit: SUCCESS (0.003s)
[349.489181] [126/130] (677s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[349.582279] Starting subtest: primary-yf-tiled-reflect-x-90
[349.586787] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s)
[349.663560] [127/130] (677s left) kms_sequence (get-idle)
[349.763661] Starting subtest: get-idle
[349.765685] Starting dynamic subtest: pipe-A-eDP-1
[351.585514] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.822s)
[351.597318] Starting dynamic subtest: pipe-B-eDP-1
[354.041038] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.454s)
[354.052586] Starting dynamic subtest: pipe-C-eDP-1
[356.460907] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.417s)
[356.477368] Starting dynamic subtest: pipe-D-eDP-1
[358.886291] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.426s)
[358.888552] Subtest get-idle: SUCCESS (9.124s)
[359.688484] [128/130] (667s left) kms_properties (invalid-properties-atomic)
[359.782289] Starting subtest: invalid-properties-atomic
[360.053588] Subtest invalid-properties-atomic: SUCCESS (0.269s)
[360.130072] [129/130] (667s left) kms_cursor_crc (cursor-sliding-max-size)
[360.412824] Starting subtest: cursor-sliding-max-size
[360.419495] Subtest cursor-sliding-max-size: SKIP (0.000s)
[360.549204] [130/130] (666s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[360.657022] Starting subtest: basic-flip-after-cursor-varying-size
[361.604747] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.947s)
[362.410520] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_flip
results: parsing output: 2/ for test: kms_cursor_edge_walk
results: parsing output: 3/ for test: kms_content_protection
results: parsing output: 4/ for test: kms_joiner
results: parsing output: 5/ for test: gem_ctx_isolation
results: parsing output: 6/ for test: prime_mmap
results: parsing output: 7/ for test: syncobj_wait
results: parsing output: 8/ for test: kms_plane_scaling
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_joiner
results: parsing output: 11/ for test: i915_pm_rc6_residency
results: parsing output: 12/ for test: kms_pm_rpm
results: parsing output: 13/ for test: kms_addfb_basic
results: parsing output: 14/ for test: gem_eio
results: parsing output: 15/ for test: gem_exec_suspend
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_cursor_legacy
results: parsing output: 18/ for test: kms_psr2_sf
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: sw_sync
results: parsing output: 22/ for test: syncobj_timeline
results: parsing output: 23/ for test: gem_exec_params
results: parsing output: 24/ for test: syncobj_timeline
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: gem_render_copy
results: parsing output: 27/ for test: gen9_exec_parse
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: gem_userptr_blits
results: parsing output: 30/ for test: gem_render_copy
results: parsing output: 31/ for test: core_setmaster
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_psr
results: parsing output: 35/ for test: api_intel_allocator
results: parsing output: 36/ for test: gem_ctx_persistence
results: parsing output: 37/ for test: syncobj_wait
results: parsing output: 38/ for test: gem_mmap_gtt
results: parsing output: 39/ for test: kms_psr
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: perf
results: parsing output: 42/ for test: gem_exec_reloc
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: gem_mmap
results: parsing output: 45/ for test: gem_bad_reloc
results: parsing output: 46/ for test: kms_rotation_crc
results: parsing output: 47/ for test: perf
results: parsing output: 48/ for test: gem_ctx_persistence
results: parsing output: 49/ for test: kms_psr
results: parsing output: 50/ for test: gem_exercise_blt
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_ccs
results: parsing output: 53/ for test: gem_mmap_gtt
results: parsing output: 54/ for test: gem_exec_schedule
results: parsing output: 55/ for test: gem_create
results: parsing output: 56/ for test: kms_plane_multiple
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_scaling_modes
results: parsing output: 59/ for test: gem_pxp
results: parsing output: 60/ for test: kms_ccs
results: parsing output: 61/ for test: perf_pmu
results: parsing output: 62/ for test: kms_color
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_dp_link_training
results: parsing output: 65/ for test: kms_psr2_sf
results: parsing output: 66/ for test: gem_render_copy
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: i915_drm_fdinfo
results: parsing output: 69/ for test: kms_flip
results: parsing output: 70/ for test: gem_lmem_swapping
results: parsing output: 71/ for test: kms_atomic_transition
results: parsing output: 72/ for test: kms_cursor_legacy
results: parsing output: 73/ for test: syncobj_timeline
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_vblank
results: parsing output: 76/ for test: kms_properties
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: syncobj_timeline
results: parsing output: 79/ for test: kms_addfb_basic
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: gem_exec_store
results: parsing output: 82/ for test: kms_plane_alpha_blend
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_pm_dc
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_atomic_transition
results: parsing output: 87/ for test: kms_ccs
results: parsing output: 88/ for test: kms_busy
results: parsing output: 89/ for test: kms_chamelium_color
results: parsing output: 90/ for test: kms_big_fb
results: parsing output: 91/ for test: gem_readwrite
results: parsing output: 92/ for test: gem_exec_create
results: parsing output: 93/ for test: kms_async_flips
results: parsing output: 94/ for test: kms_cursor_legacy
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: prime_busy
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: gem_mmap_offset
results: parsing output: 101/ for test: kms_atomic_transition
results: parsing output: 102/ for test: syncobj_basic
results: parsing output: 103/ for test: kms_flip_scaled_crc
results: parsing output: 104/ for test: dmabuf_sync_file
results: parsing output: 105/ for test: kms_chamelium_frames
results: parsing output: 106/ for test: gem_render_copy_redux
results: parsing output: 107/ for test: gem_exec_schedule
results: parsing output: 108/ for test: kms_flip
results: parsing output: 109/ for test: kms_flip_scaled_crc
results: parsing output: 110/ for test: gem_exec_balancer
results: parsing output: 111/ for test: i915_pm_rps
results: parsing output: 112/ for test: gem_exec_params
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_psr
results: parsing output: 116/ for test: kms_cursor_crc
results: parsing output: 117/ for test: kms_plane_scaling
results: parsing output: 118/ for test: perf
results: parsing output: 119/ for test: syncobj_timeline
results: parsing output: 120/ for test: kms_flip
results: parsing output: 121/ for test: i915_drm_fdinfo
results: parsing output: 122/ for test: gem_exec_await
results: parsing output: 123/ for test: kms_ccs
results: parsing output: 124/ for test: gem_exec_params
results: parsing output: 125/ for test: kms_rotation_crc
results: parsing output: 126/ for test: kms_sequence
results: parsing output: 127/ for test: kms_properties
results: parsing output: 128/ for test: kms_cursor_crc
results: parsing output: 129/ for test: kms_cursor_legacy
Done.