[54.940877] Initializing watchdogs
[54.940926]   /dev/watchdog0
[54.954352] [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.958724] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[54.960992] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[54.964307] [001/130] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[55.090264] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[55.094230] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[55.172809] [002/130] (960s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[55.272885] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[55.283644] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.010s)
[55.377389] [003/130] (960s left) kms_cursor_edge_walk (128x128-top-edge)
[55.464480] Starting subtest: 128x128-top-edge
[55.466285] Starting dynamic subtest: pipe-A-eDP-1
[58.925465] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.455s)
[58.933425] Starting dynamic subtest: pipe-D-eDP-1
[62.024980] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.098s)
[62.027397] Subtest 128x128-top-edge: SUCCESS (6.554s)
[62.836976] [004/130] (952s left) kms_content_protection (dp-mst-lic-type-0)
[63.015163] Starting subtest: dp-mst-lic-type-0
[63.019898] Subtest dp-mst-lic-type-0: SKIP (0.000s)
[63.167741] [005/130] (952s left) kms_joiner (basic-max-non-joiner)
[63.269024] Starting subtest: basic-max-non-joiner
[63.273447] Subtest basic-max-non-joiner: SKIP (0.000s)
[63.326702] [006/130] (952s left) gem_ctx_isolation (preservation-reset)
[63.501217] Starting subtest: preservation-reset
[63.503417] Starting dynamic subtest: rcs0
[63.831121] Dynamic subtest rcs0: SUCCESS (0.330s)
[63.840769] Starting dynamic subtest: bcs0
[64.245598] Dynamic subtest bcs0: SUCCESS (0.414s)
[64.255288] Starting dynamic subtest: vcs0
[64.645148] Dynamic subtest vcs0: SUCCESS (0.400s)
[64.655054] Starting dynamic subtest: vcs1
[66.285657] Dynamic subtest vcs1: SUCCESS (1.640s)
[66.294537] Starting dynamic subtest: vecs0
[68.302839] Dynamic subtest vecs0: SUCCESS (2.016s)
[68.312839] Starting dynamic subtest: ccs0
[70.291537] Dynamic subtest ccs0: SUCCESS (1.987s)
[70.294936] Subtest preservation-reset: SUCCESS (6.789s)
[70.492146] [007/130] (945s left) prime_mmap (test_dup)
[70.546929] Starting subtest: test_dup
[70.549261] Starting dynamic subtest: test_dup-smem
[70.576817] Dynamic subtest test_dup-smem: SUCCESS (0.031s)
[70.579300] Subtest test_dup: SUCCESS (0.031s)
[70.646117] [008/130] (945s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[70.709738] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[70.712163] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[70.812407] [009/130] (944s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[70.919809] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[70.922062] Starting dynamic subtest: pipe-A
[71.470539] Dynamic subtest pipe-A: SUCCESS (0.550s)
[71.479112] Starting dynamic subtest: pipe-B
[73.092226] Dynamic subtest pipe-B: SUCCESS (1.620s)
[73.101143] Starting dynamic subtest: pipe-C
[74.727844] Dynamic subtest pipe-C: SUCCESS (1.635s)
[74.737043] Starting dynamic subtest: pipe-D
[76.335999] Dynamic subtest pipe-D: SUCCESS (1.607s)
[76.338933] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (5.414s)
[77.556279] [010/130] (938s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[77.652476] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[77.656677] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[77.764754] [011/130] (938s left) kms_joiner (invalid-modeset-ultra-joiner)
[77.862159] Starting subtest: invalid-modeset-ultra-joiner
[77.866541] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[77.923614] [012/130] (937s left) i915_pm_rc6_residency (media-rc6-accuracy)
[77.979988] Starting subtest: media-rc6-accuracy
[77.984490] Subtest media-rc6-accuracy: SKIP (0.000s)
[78.077763] [013/130] (937s left) kms_pm_rpm (pm-caching)
[80.014085] Starting subtest: pm-caching
[80.019103] Subtest pm-caching: SKIP (0.000s)
[80.375208] [014/130] (935s left) kms_addfb_basic (too-high)
[80.486132] Starting subtest: too-high
[80.488680] Subtest too-high: SUCCESS (0.000s)
[80.578466] [015/130] (935s left) gem_eio (context-create)
[80.737157] Starting subtest: context-create
[80.919887] Subtest context-create: SUCCESS (0.181s)
[81.070102] [016/130] (934s left) gem_exec_suspend (basic-s4-devices)
[81.132563] Starting subtest: basic-S4-devices
[81.134903] Starting dynamic subtest: smem
[92.884872] Dynamic subtest smem: SUCCESS (11.748s)
[92.887602] Subtest basic-S4-devices: SUCCESS (11.749s)
[99.080121] [017/130] (923s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[99.203806] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[99.207749] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[99.296113] [018/130] (922s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[99.417610] Starting subtest: cursorB-vs-flipB-atomic
[99.422307] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[99.583116] [019/130] (922s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[104.677278] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area
[104.682050] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.002s)
[105.510390] [020/130] (916s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-gtt)
[105.620062] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-gtt
[105.624215] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[105.735191] [021/130] (916s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[105.839452] Starting subtest: y-tiled-16bpp-rotate-180
[105.844099] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s)
[105.938099] [022/130] (916s left) sw_sync (sync_busy_fork_unixsocket)
[105.972678] Starting subtest: sync_busy_fork_unixsocket
[105.979772] Subtest sync_busy_fork_unixsocket: SUCCESS (0.008s)
[106.035223] [023/130] (916s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[106.086670] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[106.088805] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[106.163432] [024/130] (916s left) gem_exec_params (invalid-bsd-ring)
[106.221743] Starting subtest: invalid-bsd-ring
[106.223771] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[106.320757] [025/130] (916s left) syncobj_timeline (invalid-wait-illegal-handle)
[106.380060] Starting subtest: invalid-wait-illegal-handle
[106.382366] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[106.467299] [026/130] (915s left) kms_psr (psr2-cursor-plane-onoff)
[106.562758] Starting subtest: psr2-cursor-plane-onoff
[106.564643] Starting dynamic subtest: eDP-1
[108.280839] Dynamic subtest eDP-1: SUCCESS (1.715s)
[108.282819] Subtest psr2-cursor-plane-onoff: SUCCESS (1.715s)
[109.064123] [027/130] (913s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[109.126465] Starting subtest: y-tiled-ccs-to-y-tiled
[109.130586] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.000s)
[109.306160] [028/130] (913s left) gen9_exec_parse (allowed-all)
[109.369232] Subtest allowed-all: SKIP (0.000s)
[109.432257] [029/130] (913s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[109.541405] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[110.410392] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.870s)
[110.580049] [030/130] (911s left) gem_userptr_blits (stress-purge)
[110.645975] Starting subtest: stress-purge
[116.042502] Subtest stress-purge: SUCCESS (5.399s)
[116.179937] [031/130] (906s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[116.274164] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[116.277914] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[116.456728] [032/130] (906s left) core_setmaster (master-drop-set-root)
[116.534728] Starting subtest: master-drop-set-root
[116.539670] Subtest master-drop-set-root: SUCCESS (0.003s)
[116.582741] [033/130] (906s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[116.704680] Starting subtest: psr-farfromfence-mmap-gtt
[116.708806] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[116.818562] [034/130] (905s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[116.923314] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[116.927587] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[117.035474] [035/130] (905s left) kms_psr (psr-primary-mmap-gtt)
[117.129824] Starting subtest: psr-primary-mmap-gtt
[117.132124] Starting dynamic subtest: eDP-1
[118.556343] Dynamic subtest eDP-1: SKIP (1.421s)
[118.561201] Subtest psr-primary-mmap-gtt: SKIP (1.421s)
[118.734211] [036/130] (904s left) api_intel_allocator (reopen)
[118.793441] Starting subtest: reopen
[118.795895] Subtest reopen: SUCCESS (0.004s)
[118.922875] [037/130] (903s left) gem_ctx_persistence (idempotent)
[118.983851] Starting subtest: idempotent
[118.986271] Subtest idempotent: SUCCESS (0.000s)
[119.080907] [038/130] (903s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[119.129695] Starting subtest: multi-wait-for-submit-unsubmitted
[119.239849] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.108s)
[119.314843] [039/130] (903s left) gem_mmap_gtt (medium-copy-odd)
[119.361427] Subtest medium-copy-odd: SKIP (0.000s)
[119.424580] [040/130] (903s left) kms_psr (fbc-psr-sprite-blt)
[119.520696] Starting subtest: fbc-psr-sprite-blt
[119.523044] Starting dynamic subtest: eDP-1
[119.527219] Dynamic subtest eDP-1: SKIP (0.000s)
[119.531497] Subtest fbc-psr-sprite-blt: SKIP (0.001s)
[119.589547] [041/130] (903s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[119.686204] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[119.690466] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[119.788598] [042/130] (903s left) perf (create-destroy-userspace-config)
[119.920056] Starting subtest: create-destroy-userspace-config
[119.947760] Subtest create-destroy-userspace-config: SUCCESS (0.025s)
[119.990744] [043/130] (903s left) gem_exec_reloc (basic-gtt-wc)
[120.056688] Subtest basic-gtt-wc: SKIP (0.000s)
[120.142782] [044/130] (902s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[120.250990] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[126.601819] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.354s)
[126.744421] [045/130] (896s left) gem_mmap (basic)
[126.803908] Subtest basic: SKIP (0.000s)
[126.871593] [046/130] (896s left) gem_bad_reloc (negative-reloc-bltcopy)
[126.944746] Subtest negative-reloc-bltcopy: SKIP (0.000s)
[127.009131] [047/130] (896s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[127.098273] Starting subtest: sprite-rotation-90-pos-100-0
[127.102984] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[127.166791] [048/130] (896s left) perf (sysctl-defaults)
[127.228217] Starting subtest: sysctl-defaults
[127.230733] Subtest sysctl-defaults: SUCCESS (0.000s)
[127.292235] [049/130] (895s left) gem_ctx_persistence (legacy-engines-queued)
[127.354066] Starting subtest: legacy-engines-queued
[127.356538] Starting dynamic subtest: render
[127.450515] Dynamic subtest render: SUCCESS (0.096s)
[127.462601] Starting dynamic subtest: bsd1
[128.884472] Dynamic subtest bsd1: SUCCESS (1.430s)
[128.896470] Starting dynamic subtest: bsd2
[130.865809] Dynamic subtest bsd2: SUCCESS (1.980s)
[130.875618] Starting dynamic subtest: blt
[130.929404] Dynamic subtest blt: SUCCESS (0.064s)
[130.938709] Starting dynamic subtest: vebox
[132.850742] Dynamic subtest vebox: SUCCESS (1.918s)
[132.853337] Subtest legacy-engines-queued: SUCCESS (5.495s)
[132.926249] [050/130] (890s left) kms_psr (fbc-pr-sprite-render)
[133.021292] Starting subtest: fbc-pr-sprite-render
[133.025850] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[133.095289] [051/130] (890s left) gem_exercise_blt (fast-copy)
[133.156845] Starting subtest: fast-copy
[133.159101] Starting dynamic subtest: linear-smem-smem
[133.183427] Dynamic subtest linear-smem-smem: SUCCESS (0.026s)
[133.194385] Starting dynamic subtest: xmajor-smem-smem
[133.204487] Dynamic subtest xmajor-smem-smem: SUCCESS (0.021s)
[133.212829] Starting dynamic subtest: tile4-smem-smem
[133.225782] Dynamic subtest tile4-smem-smem: SUCCESS (0.021s)
[133.233979] Starting dynamic subtest: tile64-smem-smem
[133.246460] Dynamic subtest tile64-smem-smem: SUCCESS (0.020s)
[133.248813] Subtest fast-copy: SUCCESS (0.089s)
[133.366088] [052/130] (890s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[133.465180] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[140.151436] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SUCCESS (6.690s)
[140.251940] [053/130] (883s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[140.341026] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs
[140.343348] Starting dynamic subtest: pipe-A-eDP-1
[140.366561] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[140.376773] Starting dynamic subtest: pipe-B-eDP-1
[140.398707] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[140.407867] Starting dynamic subtest: pipe-C-eDP-1
[140.430133] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[140.440115] Starting dynamic subtest: pipe-D-eDP-1
[140.462190] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[140.466233] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.003s)
[142.524802] [054/130] (880s left) gem_mmap_gtt (cpuset-big-copy-xy)
[142.578538] Subtest cpuset-big-copy-XY: SKIP (0.000s)
[142.634819] [055/130] (880s left) gem_exec_schedule (fifo)
[142.702014] Starting subtest: fifo
[142.704317] Starting dynamic subtest: rcs0
[142.789540] Dynamic subtest rcs0: SUCCESS (0.099s)
[142.801838] Starting dynamic subtest: vcs0
[142.868787] Dynamic subtest vcs0: SUCCESS (0.079s)
[142.881268] Starting dynamic subtest: vcs1
[142.942944] Dynamic subtest vcs1: SUCCESS (0.074s)
[142.954177] Starting dynamic subtest: vecs0
[143.015413] Dynamic subtest vecs0: SUCCESS (0.072s)
[143.027039] Starting dynamic subtest: ccs0
[143.093095] Dynamic subtest ccs0: SUCCESS (0.077s)
[143.095788] Subtest fifo: SUCCESS (0.403s)
[144.003708] [056/130] (879s left) gem_create (create-ext-cpu-access-big)
[144.172487] Starting subtest: create-ext-cpu-access-big
[144.177380] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[144.242151] [057/130] (879s left) kms_plane_multiple (2x-tiling-y)
[144.347148] Starting subtest: 2x-tiling-y
[144.351763] Subtest 2x-tiling-y: SKIP (0.000s)
[144.419164] [058/130] (879s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[144.518868] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[151.795494] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.280s)
[151.938778] [059/130] (871s left) kms_scaling_modes (scaling-mode-none)
[152.029992] Starting subtest: scaling-mode-none
[152.032316] Starting dynamic subtest: pipe-A-eDP-1
[152.143658] Dynamic subtest pipe-A-eDP-1: SKIP (0.110s)
[152.159469] Starting dynamic subtest: pipe-B-eDP-1
[152.201402] Dynamic subtest pipe-B-eDP-1: SKIP (0.056s)
[152.210711] Starting dynamic subtest: pipe-C-eDP-1
[152.254071] Dynamic subtest pipe-C-eDP-1: SKIP (0.052s)
[152.263638] Starting dynamic subtest: pipe-D-eDP-1
[152.302904] Dynamic subtest pipe-D-eDP-1: SKIP (0.048s)
[152.307446] Subtest scaling-mode-none: SKIP (0.271s)
[152.421063] [060/130] (871s left) gem_pxp (create-protected-buffer)
[152.545519] Starting subtest: create-protected-buffer
[152.547403] Subtest create-protected-buffer: SUCCESS (0.000s)
[152.699597] [061/130] (871s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[152.797643] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[152.799622] Starting dynamic subtest: pipe-A-eDP-1
[152.818275] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[152.828695] Starting dynamic subtest: pipe-B-eDP-1
[152.846483] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[152.856546] Starting dynamic subtest: pipe-C-eDP-1
[152.873875] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[152.882362] Starting dynamic subtest: pipe-D-eDP-1
[152.901155] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[152.904750] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[154.982328] [062/130] (868s left) perf_pmu (busy-start)
[155.028667] Starting subtest: busy-start
[155.030926] Starting dynamic subtest: rcs0
[157.577167] Dynamic subtest rcs0: SUCCESS (2.551s)
[157.586995] Starting dynamic subtest: bcs0
[160.147050] Dynamic subtest bcs0: SUCCESS (2.548s)
[160.158746] Starting dynamic subtest: vcs0
[163.923514] Dynamic subtest vcs0: SUCCESS (3.795s)
[163.935025] Starting dynamic subtest: vcs1
[167.890907] Dynamic subtest vcs1: SUCCESS (3.966s)
[167.901191] Starting dynamic subtest: vecs0
[171.923160] Dynamic subtest vecs0: SUCCESS (4.030s)
[171.934914] Starting dynamic subtest: ccs0
[174.492608] Dynamic subtest ccs0: SUCCESS (2.548s)
[174.494574] Subtest busy-start: SUCCESS (19.445s)
[174.559749] [063/130] (849s left) kms_color (legacy-gamma)
[174.657060] Starting subtest: legacy-gamma
[174.659449] Starting dynamic subtest: pipe-A-eDP-1
[175.377982] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.720s)
[175.386916] Starting dynamic subtest: pipe-B-eDP-1
[176.758689] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.379s)
[176.769307] Starting dynamic subtest: pipe-C-eDP-1
[178.184083] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.427s)
[178.193240] Starting dynamic subtest: pipe-D-eDP-1
[179.577312] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.393s)
[179.579747] Subtest legacy-gamma: SUCCESS (4.920s)
[180.375062] [064/130] (843s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[180.465504] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[186.860428] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (6.398s)
[186.975224] [065/130] (836s left) kms_dp_link_training (uhbr-mst)
[187.068133] Starting subtest: uhbr-mst
[187.077112] Subtest uhbr-mst: SKIP (0.000s)
[187.139429] [066/130] (836s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[192.118632] Starting subtest: psr2-plane-move-sf-dmg-area
[192.120938] Starting dynamic subtest: pipe-A-eDP-1
[197.410769] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.292s)
[197.421368] Starting dynamic subtest: pipe-B-eDP-1
[202.609826] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.198s)
[202.612181] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (10.493s)
[203.477778] [067/130] (820s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[203.533020] Starting subtest: y-tiled-to-vebox-y-tiled
[203.537483] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[203.714040] [068/130] (820s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[203.821187] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[208.128514] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.313s)
[209.267090] [069/130] (814s left) i915_drm_fdinfo (busy-hang)
[209.305810] Starting subtest: busy-hang
[209.308169] Starting dynamic subtest: rcs0
[209.341696] Dynamic subtest rcs0: SKIP (0.034s)
[209.352499] Starting dynamic subtest: bcs0
[209.357059] Dynamic subtest bcs0: SKIP (0.001s)
[209.366129] Starting dynamic subtest: vcs0
[209.370429] Dynamic subtest vcs0: SKIP (0.000s)
[209.379416] Starting dynamic subtest: vcs1
[209.383991] Dynamic subtest vcs1: SKIP (0.000s)
[209.393060] Starting dynamic subtest: vecs0
[209.397578] Dynamic subtest vecs0: SKIP (0.000s)
[209.406470] Starting dynamic subtest: ccs0
[209.411045] Dynamic subtest ccs0: SKIP (0.000s)
[209.415571] Subtest busy-hang: SKIP (0.040s)
[209.450700] [070/130] (814s left) kms_flip (2x-flip-vs-wf_vblank)
[209.558887] Starting subtest: 2x-flip-vs-wf_vblank
[209.569275] Subtest 2x-flip-vs-wf_vblank: SKIP (0.010s)
[209.672676] [071/130] (814s left) gem_lmem_swapping (basic)
[209.713147] Subtest basic: SKIP (0.000s)
[209.748878] [072/130] (814s left) kms_atomic_transition (plane-all-transition-nonblocking)
[209.861106] Starting subtest: plane-all-transition-nonblocking
[209.863442] Starting dynamic subtest: pipe-A-eDP-1
[212.370655] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.512s)
[212.681802] Starting dynamic subtest: pipe-B-eDP-1
[215.886386] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.221s)
[216.186597] Subtest plane-all-transition-nonblocking: SUCCESS (6.325s)
[216.996876] [073/130] (807s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[217.130768] Starting subtest: cursorA-vs-flipA-atomic
[228.330988] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.201s)
[229.117558] [074/130] (795s left) syncobj_timeline (single-wait-all-available-submitted)
[229.168375] Starting subtest: single-wait-all-available-submitted
[229.170761] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[229.268063] [075/130] (795s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[229.367278] Starting subtest: psr-rgb565-draw-blt
[236.249088] Subtest psr-rgb565-draw-blt: SUCCESS (6.884s)
[236.389735] [076/130] (787s left) kms_vblank (wait-forked-busy)
[236.492367] Starting subtest: wait-forked-busy
[236.494680] Starting dynamic subtest: pipe-A-eDP-1
[238.378649] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.885s)
[238.395174] Starting dynamic subtest: pipe-D-eDP-1
[240.975733] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.593s)
[240.978209] Subtest wait-forked-busy: SUCCESS (4.482s)
[241.761368] [077/130] (782s left) kms_properties (crtc-properties-atomic)
[241.857288] Starting subtest: crtc-properties-atomic
[241.859704] Starting dynamic subtest: pipe-A-eDP-1
[242.306262] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.446s)
[242.315828] Starting dynamic subtest: pipe-B-eDP-1
[243.409193] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.103s)
[243.419202] Starting dynamic subtest: pipe-C-eDP-1
[244.522750] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.109s)
[244.532789] Starting dynamic subtest: pipe-D-eDP-1
[245.637579] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.116s)
[245.639754] Subtest crtc-properties-atomic: SUCCESS (3.780s)
[246.443344] [078/130] (777s left) kms_big_fb (y-tiled-addfb-size-overflow)
[246.557275] Starting subtest: y-tiled-addfb-size-overflow
[246.561155] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s)
[246.648812] [079/130] (777s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[246.705597] Starting subtest: invalid-multi-wait-unsubmitted
[246.707796] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[246.817926] [080/130] (777s left) kms_addfb_basic (master-rmfb)
[246.875185] Starting subtest: master-rmfb
[246.877107] Subtest master-rmfb: SUCCESS (0.001s)
[247.032437] [081/130] (777s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[247.137323] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[247.141641] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[247.251986] [082/130] (777s left) gem_exec_store (pages)
[247.317040] Starting subtest: pages
[247.319687] Starting dynamic subtest: rcs0
[247.434624] Dynamic subtest rcs0: SUCCESS (0.120s)
[247.446135] Starting dynamic subtest: bcs0
[247.540698] Dynamic subtest bcs0: SUCCESS (0.104s)
[247.552725] Starting dynamic subtest: vcs0
[247.619651] Dynamic subtest vcs0: SUCCESS (0.078s)
[247.631725] Starting dynamic subtest: vcs1
[247.684166] Dynamic subtest vcs1: SUCCESS (0.064s)
[247.695588] Starting dynamic subtest: vecs0
[247.743851] Dynamic subtest vecs0: SUCCESS (0.059s)
[247.754916] Starting dynamic subtest: ccs0
[247.819114] Dynamic subtest ccs0: SUCCESS (0.074s)
[247.821223] Subtest pages: SUCCESS (0.506s)
[248.003882] [083/130] (776s left) kms_plane_alpha_blend (constant-alpha-mid)
[248.111319] Starting subtest: constant-alpha-mid
[248.549848] Starting dynamic subtest: pipe-A-eDP-1
[249.337805] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.786s)
[249.347639] Starting dynamic subtest: pipe-D-eDP-1
[250.824526] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.486s)
[250.826663] Subtest constant-alpha-mid: SUCCESS (2.713s)
[251.698188] [084/130] (772s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[251.803635] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[251.808109] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[251.922606] [085/130] (772s left) kms_pm_dc (dc5-dpms-negative)
[253.034328] Starting subtest: dc5-dpms-negative
[253.038503] Subtest dc5-dpms-negative: SKIP (0.000s)
[253.105286] [086/130] (771s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[253.204991] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[253.209249] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[253.312114] [087/130] (771s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[253.403331] Starting subtest: modeset-transition-nonblocking-fencing
[253.405708] Starting dynamic subtest: 1x-outputs
[264.330056] Dynamic subtest 1x-outputs: SUCCESS (10.924s)
[264.636543] Subtest modeset-transition-nonblocking-fencing: SUCCESS (11.230s)
[265.445362] [088/130] (759s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[265.545230] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[265.547737] Starting dynamic subtest: pipe-A-eDP-1
[265.557210] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[265.567787] Starting dynamic subtest: pipe-B-eDP-1
[265.576848] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[265.587422] Starting dynamic subtest: pipe-C-eDP-1
[265.595635] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[265.604247] Starting dynamic subtest: pipe-D-eDP-1
[265.612401] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[265.616443] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.004s)
[267.699472] [089/130] (757s left) kms_busy (extended-pageflip-hang-oldfb)
[267.800127] Starting subtest: extended-pageflip-hang-oldfb
[267.802440] Starting dynamic subtest: pipe-A
[268.238106] Dynamic subtest pipe-A: SUCCESS (0.434s)
[268.247858] Starting dynamic subtest: pipe-D
[269.327279] Dynamic subtest pipe-D: SUCCESS (1.089s)
[269.329654] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.526s)
[270.147786] [090/130] (754s left) kms_chamelium_color (ctm-blue-to-red)
[270.258938] Subtest ctm-blue-to-red: SKIP (0.000s)
[270.301278] [091/130] (754s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[270.395517] Starting subtest: yf-tiled-64bpp-rotate-90
[270.400264] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[270.474475] [092/130] (754s left) gem_readwrite (read-write)
[270.540068] Subtest read-write: SKIP (0.000s)
[270.608509] [093/130] (754s left) gem_exec_create (legacy)
[270.663913] Starting subtest: legacy
[270.666268] Starting dynamic subtest: smem
[272.772969] Dynamic subtest smem: SUCCESS (2.108s)
[272.775475] Subtest legacy: SUCCESS (2.109s)
[272.956287] [094/130] (752s left) kms_async_flips (invalid-async-flip-atomic)
[273.065827] Starting subtest: invalid-async-flip-atomic
[273.070102] Subtest invalid-async-flip-atomic: SKIP (0.000s)
[274.266476] [095/130] (750s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[274.393459] Starting subtest: flip-vs-cursor-crc-legacy
[275.028795] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.635s)
[275.892474] [096/130] (749s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[275.996292] Starting subtest: x-tiled-32bpp-rotate-90
[276.016454] Subtest x-tiled-32bpp-rotate-90: SKIP (0.020s)
[276.139378] [097/130] (748s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[276.235781] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[276.240196] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[276.341892] [098/130] (748s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[276.442572] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[276.446861] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[276.551554] [099/130] (748s left) prime_busy (before)
[276.618666] Starting subtest: before
[276.623886] Starting dynamic subtest: rcs0
[276.653600] Dynamic subtest rcs0: SUCCESS (0.030s)
[276.664074] Starting dynamic subtest: bcs0
[276.728106] Dynamic subtest bcs0: SUCCESS (0.074s)
[276.738814] Starting dynamic subtest: vcs0
[276.767837] Dynamic subtest vcs0: SUCCESS (0.039s)
[276.776936] Starting dynamic subtest: vcs1
[276.810045] Dynamic subtest vcs1: SUCCESS (0.041s)
[276.819430] Starting dynamic subtest: vecs0
[276.851386] Dynamic subtest vecs0: SUCCESS (0.042s)
[276.860413] Starting dynamic subtest: ccs0
[276.892091] Dynamic subtest ccs0: SUCCESS (0.040s)
[276.999094] Subtest before: SUCCESS (0.380s)
[277.073072] [100/130] (748s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[277.171767] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[284.454766] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.285s)
[284.589455] [101/130] (740s left) gem_mmap_offset (partial-remap)
[284.653836] Starting subtest: partial-remap
[284.656142] Starting dynamic subtest: smem0
[284.665124] Dynamic subtest smem0: SUCCESS (0.004s)
[284.667081] Subtest partial-remap: SUCCESS (0.005s)
[284.749410] [102/130] (740s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[284.847606] Starting subtest: plane-use-after-nonblocking-unbind
[284.849861] Starting dynamic subtest: pipe-A-eDP-1
[284.928114] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.081s)
[285.239264] Starting dynamic subtest: pipe-B-eDP-1
[285.988872] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.760s)
[286.281603] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.433s)
[287.138711] [103/130] (738s left) syncobj_basic (bad-flags-handle-to-fd)
[287.201241] Starting subtest: bad-flags-handle-to-fd
[287.203602] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[287.312113] [104/130] (738s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[287.419555] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[287.421702] Starting dynamic subtest: pipe-A-default-mode
[288.583705] Dynamic subtest pipe-A-default-mode: SKIP (1.161s)
[288.588023] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.162s)
[288.737835] [105/130] (736s left) dmabuf_sync_file (import-basic)
[288.845658] Starting subtest: import-basic
[288.847857] Subtest import-basic: SUCCESS (0.001s)
[288.901896] [FACT dmabuf_sync_file (import-basic)] new: kernel.kmod_is_loaded.vgem: true
[288.905544] [106/130] (736s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[289.281679] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[290.063840] [107/130] (735s left) gem_render_copy_redux (flink)
[290.124661] Starting subtest: flink
[291.064410] Subtest flink: SUCCESS (0.941s)
[291.216912] [108/130] (734s left) gem_exec_schedule (preempt-contexts)
[291.289690] Starting subtest: preempt-contexts
[291.291737] Starting dynamic subtest: rcs0
[291.339757] Dynamic subtest rcs0: SUCCESS (0.057s)
[291.349563] Starting dynamic subtest: bcs0
[291.394927] Dynamic subtest bcs0: SUCCESS (0.054s)
[291.404287] Starting dynamic subtest: vcs0
[291.449024] Dynamic subtest vcs0: SUCCESS (0.053s)
[291.459210] Starting dynamic subtest: vcs1
[291.492458] Dynamic subtest vcs1: SUCCESS (0.043s)
[291.502199] Starting dynamic subtest: vecs0
[291.537270] Dynamic subtest vecs0: SUCCESS (0.044s)
[291.546213] Starting dynamic subtest: ccs0
[291.581354] Dynamic subtest ccs0: SUCCESS (0.044s)
[291.583262] Subtest preempt-contexts: SUCCESS (0.299s)
[293.004122] [109/130] (732s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[293.096054] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[293.106693] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.010s)
[293.179105] [110/130] (732s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[293.272191] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[293.274396] Starting dynamic subtest: pipe-A-default-mode
[296.043434] Dynamic subtest pipe-A-default-mode: SUCCESS (2.769s)
[296.045869] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.770s)
[296.872423] [111/130] (728s left) gem_exec_balancer (persistence)
[297.155357] Starting subtest: persistence
[298.006885] Subtest persistence: SUCCESS (0.850s)
[298.128505] [112/130] (727s left) i915_pm_rps (thresholds-idle)
[298.183154] Starting subtest: thresholds-idle
[298.187548] Subtest thresholds-idle: SKIP (0.001s)
[298.263356] [113/130] (727s left) gem_exec_params (sol-reset-not-gen7)
[298.315320] Starting subtest: sol-reset-not-gen7
[298.320882] Subtest sol-reset-not-gen7: SUCCESS (0.003s)
[298.453774] [114/130] (727s left) kms_big_fb (linear-16bpp-rotate-180)
[298.547021] Starting subtest: linear-16bpp-rotate-180
[300.103526] Subtest linear-16bpp-rotate-180: SUCCESS (1.556s)
[300.257491] [115/130] (725s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[300.349665] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[300.353177] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[300.464836] [116/130] (725s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[300.560311] Starting subtest: fbc-psr2-sprite-mmap-cpu
[300.561975] Starting dynamic subtest: eDP-1
[300.565433] Dynamic subtest eDP-1: SKIP (0.000s)
[300.568830] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.001s)
[300.631030] [117/130] (725s left) kms_cursor_crc (cursor-random-256x256)
[300.873055] Starting subtest: cursor-random-256x256
[300.877141] Starting dynamic subtest: pipe-A-eDP-1
[304.586896] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.709s)
[304.614982] Starting dynamic subtest: pipe-D-eDP-1
[308.926037] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.318s)
[308.928502] Subtest cursor-random-256x256: SUCCESS (8.052s)
[309.726270] [118/130] (716s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[309.828104] Starting subtest: plane-upscale-20x20-with-pixel-format
[309.830345] Starting dynamic subtest: pipe-A
[310.878053] Dynamic subtest pipe-A: SUCCESS (1.050s)
[310.887577] Starting dynamic subtest: pipe-B
[313.025202] Dynamic subtest pipe-B: SUCCESS (2.146s)
[313.034799] Starting dynamic subtest: pipe-C
[314.213445] Dynamic subtest pipe-C: SUCCESS (1.187s)
[314.223156] Starting dynamic subtest: pipe-D
[315.349048] Dynamic subtest pipe-D: SUCCESS (1.135s)
[315.351355] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.521s)
[316.540492] [119/130] (709s left) perf (global-sseu-config)
[316.612878] Starting subtest: global-sseu-config
[316.617197] Subtest global-sseu-config: SKIP (0.000s)
[316.660466] [120/130] (709s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[316.719255] Starting subtest: etime-multi-wait-all-for-submit-submitted
[316.823825] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.102s)
[316.901893] [121/130] (709s left) kms_flip (nonexisting-fb-interruptible)
[316.993866] Starting subtest: nonexisting-fb-interruptible
[316.996688] Starting dynamic subtest: A-eDP1
[318.126817] Dynamic subtest A-eDP1: SUCCESS (1.133s)
[318.136121] Starting dynamic subtest: B-eDP1
[319.248248] Dynamic subtest B-eDP1: SUCCESS (1.120s)
[319.260449] Starting dynamic subtest: C-eDP1
[320.373878] Dynamic subtest C-eDP1: SUCCESS (1.124s)
[320.384345] Starting dynamic subtest: D-eDP1
[321.496424] Dynamic subtest D-eDP1: SUCCESS (1.122s)
[321.498802] Subtest nonexisting-fb-interruptible: SUCCESS (4.507s)
[322.654167] [122/130] (703s left) i915_drm_fdinfo (isolation)
[322.692467] Starting subtest: isolation
[322.694753] Starting dynamic subtest: rcs0
[322.725084] Dynamic subtest rcs0: SKIP (0.033s)
[322.736452] Starting dynamic subtest: bcs0
[322.740882] Dynamic subtest bcs0: SKIP (0.000s)
[322.750083] Starting dynamic subtest: vcs0
[322.754609] Dynamic subtest vcs0: SKIP (0.000s)
[322.763707] Starting dynamic subtest: vcs1
[322.768177] Dynamic subtest vcs1: SKIP (0.000s)
[322.776833] Starting dynamic subtest: vecs0
[322.781265] Dynamic subtest vecs0: SKIP (0.000s)
[322.790108] Starting dynamic subtest: ccs0
[322.794445] Dynamic subtest ccs0: SKIP (0.000s)
[322.798857] Subtest isolation: SKIP (0.038s)
[322.835151] [123/130] (703s left) gem_exec_await (wide-contexts)
[323.021029] Starting subtest: wide-contexts
[346.688528] Subtest wide-contexts: SUCCESS (23.668s)
[346.881157] [124/130] (679s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[347.013174] Starting subtest: random-ccs-data-y-tiled-ccs
[347.015492] Starting dynamic subtest: pipe-A-eDP-1
[347.040671] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[347.053425] Starting dynamic subtest: pipe-B-eDP-1
[347.077439] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[347.086616] Starting dynamic subtest: pipe-C-eDP-1
[347.110392] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[347.119501] Starting dynamic subtest: pipe-D-eDP-1
[347.144196] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[347.148568] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.004s)
[349.207580] [125/130] (677s left) gem_exec_params (invalid-fence-in-submit)
[349.268319] Starting subtest: invalid-fence-in-submit
[349.273310] Subtest invalid-fence-in-submit: SUCCESS (0.003s)
[349.377068] [126/130] (676s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[349.461046] Starting subtest: primary-yf-tiled-reflect-x-90
[349.465275] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s)
[349.536961] [127/130] (676s left) kms_sequence (get-idle)
[349.631144] Starting subtest: get-idle
[349.633444] Starting dynamic subtest: pipe-A-eDP-1
[351.448083] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.814s)
[351.458824] Starting dynamic subtest: pipe-B-eDP-1
[353.861050] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.413s)
[353.876203] Starting dynamic subtest: pipe-C-eDP-1
[356.270058] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.406s)
[356.280611] Starting dynamic subtest: pipe-D-eDP-1
[358.697828] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.428s)
[358.700204] Subtest get-idle: SUCCESS (9.065s)
[359.496117] [128/130] (666s left) kms_properties (invalid-properties-atomic)
[359.608128] Starting subtest: invalid-properties-atomic
[359.862715] Subtest invalid-properties-atomic: SUCCESS (0.252s)
[359.935655] [129/130] (666s left) kms_cursor_crc (cursor-sliding-max-size)
[360.244807] Starting subtest: cursor-sliding-max-size
[360.251346] Subtest cursor-sliding-max-size: SKIP (0.000s)
[360.385726] [130/130] (666s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[360.506694] Starting subtest: basic-flip-after-cursor-varying-size
[361.481129] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.974s)
[362.322383] 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.