[59.212091] Initializing watchdogs
[59.212237]   /dev/watchdog0
[59.228297] [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.232778] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.235160] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.238524] [001/134] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[59.361952] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[66.495941] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (7.090s)
[66.651925] [002/134] (953s left) kms_draw_crc (draw-method-render)
[66.753211] Starting subtest: draw-method-render
[66.755234] Starting dynamic subtest: xrgb8888-untiled
[66.996602] Dynamic subtest xrgb8888-untiled: SUCCESS (0.244s)
[67.003572] Starting dynamic subtest: rgb565-untiled
[67.231111] Dynamic subtest rgb565-untiled: SUCCESS (0.233s)
[67.239317] Starting dynamic subtest: xrgb2101010-untiled
[67.442505] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.211s)
[67.451499] Starting dynamic subtest: xbgr16161616f-untiled
[67.688270] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.244s)
[67.695327] Starting dynamic subtest: xrgb8888-xtiled
[67.810249] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s)
[67.818856] Starting dynamic subtest: rgb565-xtiled
[67.922349] Dynamic subtest rgb565-xtiled: SUCCESS (0.111s)
[67.933847] Starting dynamic subtest: xrgb2101010-xtiled
[68.045313] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.121s)
[68.052270] Starting dynamic subtest: xbgr16161616f-xtiled
[68.177994] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[68.185469] Starting dynamic subtest: xrgb8888-4tiled
[68.300666] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.122s)
[68.307854] Starting dynamic subtest: rgb565-4tiled
[68.423176] Dynamic subtest rgb565-4tiled: SUCCESS (0.122s)
[68.431088] Starting dynamic subtest: xrgb2101010-4tiled
[68.546056] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.122s)
[68.553666] Starting dynamic subtest: xbgr16161616f-4tiled
[68.668528] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.122s)
[68.670507] Subtest draw-method-render: SUCCESS (1.911s)
[68.806878] [003/134] (951s left) kms_rmfb (close-fd)
[68.911164] Starting subtest: close-fd
[68.912828] Starting dynamic subtest: pipe-A-eDP-1
[69.019385] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.108s)
[69.027787] Starting dynamic subtest: pipe-B-eDP-1
[70.231127] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.205s)
[70.239834] Starting dynamic subtest: pipe-C-eDP-1
[71.388062] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.155s)
[71.407617] Starting dynamic subtest: pipe-D-eDP-1
[72.602916] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.209s)
[72.605236] Subtest close-fd: SUCCESS (3.683s)
[73.819918] [004/134] (946s left) fbdev (info)
[73.854834] Starting subtest: info
[73.856957] Subtest info: SUCCESS (0.000s)
[73.946602] [005/134] (945s left) gem_exec_reloc (basic-cpu-wc-active)
[74.001684] Subtest basic-cpu-wc-active: SKIP (0.000s)
[74.077222] [006/134] (945s left) gem_pxp (display-protected-crc)
[74.193469] Starting subtest: display-protected-crc
[76.294736] Subtest display-protected-crc: SUCCESS (2.100s)
[76.430708] [007/134] (943s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[76.482983] Starting subtest: etime-single-wait-all-for-submit-submitted
[76.585236] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.102s)
[76.673873] [008/134] (943s left) gem_ctx_shared (q-smoketest-all)
[76.732412] Starting subtest: Q-smoketest-all
[109.134455] Subtest Q-smoketest-all: SUCCESS (32.341s)
[110.923613] [009/134] (909s left) gem_tiled_swapping (non-threaded)
[110.989176] Subtest non-threaded: SKIP (0.000s)
[111.052404] [010/134] (909s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[111.157249] Starting subtest: fbc-rgb565-draw-pwrite
[115.673029] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.520s)
[116.850824] [011/134] (903s left) i915_hangman (engine-engine-hang)
[116.916687] Starting subtest: engine-engine-hang
[116.918703] Starting dynamic subtest: rcs0
[118.902400] Dynamic subtest rcs0: SUCCESS (1.984s)
[118.913626] Starting dynamic subtest: bcs0
[120.884467] Dynamic subtest bcs0: SUCCESS (1.981s)
[120.895967] Starting dynamic subtest: vcs0
[122.867030] Dynamic subtest vcs0: SUCCESS (1.982s)
[122.878049] Starting dynamic subtest: vcs1
[124.853226] Dynamic subtest vcs1: SUCCESS (1.984s)
[124.864060] Starting dynamic subtest: vecs0
[126.835034] Dynamic subtest vecs0: SUCCESS (1.980s)
[126.845817] Starting dynamic subtest: ccs0
[128.881858] Dynamic subtest ccs0: SUCCESS (2.046s)
[128.884777] Subtest engine-engine-hang: SUCCESS (11.964s)
[128.985168] [012/134] (891s left) gem_mmap_offset (partial-unmap)
[129.045239] Starting subtest: partial-unmap
[129.047285] Starting dynamic subtest: smem0
[129.524755] Dynamic subtest smem0: SUCCESS (0.479s)
[129.527697] Subtest partial-unmap: SUCCESS (0.480s)
[129.680897] [013/134] (890s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[129.781053] Starting subtest: fbc-indfb-scaledprimary
[132.730904] Subtest fbc-indfb-scaledprimary: SUCCESS (2.953s)
[133.873199] [014/134] (886s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[133.983774] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[134.026385] [015/134] (886s left) kms_addfb_basic (invalid-get-prop-any)
[134.084048] Starting subtest: invalid-get-prop-any
[134.086345] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[134.259514] [016/134] (886s left) gem_ctx_isolation (preservation-reset)
[134.423894] Starting subtest: preservation-reset
[134.425873] Starting dynamic subtest: rcs0
[134.668069] Dynamic subtest rcs0: SUCCESS (0.247s)
[134.679348] Starting dynamic subtest: bcs0
[134.960760] Dynamic subtest bcs0: SUCCESS (0.292s)
[134.972062] Starting dynamic subtest: vcs0
[135.277100] Dynamic subtest vcs0: SUCCESS (0.316s)
[135.287790] Starting dynamic subtest: vcs1
[137.210680] Dynamic subtest vcs1: SUCCESS (1.933s)
[137.220102] Starting dynamic subtest: vecs0
[139.221076] Dynamic subtest vecs0: SUCCESS (2.010s)
[139.232015] Starting dynamic subtest: ccs0
[141.167801] Dynamic subtest ccs0: SUCCESS (1.946s)
[141.170341] Subtest preservation-reset: SUCCESS (6.748s)
[141.327679] [017/134] (879s left) kms_properties (plane-properties-legacy)
[141.435894] Starting subtest: plane-properties-legacy
[141.438184] Starting dynamic subtest: pipe-A-eDP-1
[142.018694] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.584s)
[142.027290] Starting dynamic subtest: pipe-B-eDP-1
[143.318743] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.297s)
[143.328486] Starting dynamic subtest: pipe-C-eDP-1
[144.556216] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.236s)
[144.567517] Starting dynamic subtest: pipe-D-eDP-1
[145.783291] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.227s)
[145.785482] Subtest plane-properties-legacy: SUCCESS (4.347s)
[146.603388] [018/134] (873s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[146.700469] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[146.702684] Starting dynamic subtest: pipe-A-eDP-1
[146.761314] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[146.769590] Starting dynamic subtest: pipe-B-eDP-1
[146.826503] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[146.836042] Starting dynamic subtest: pipe-C-eDP-1
[146.894037] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[146.903333] Starting dynamic subtest: pipe-D-eDP-1
[146.959358] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[146.963618] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.008s)
[148.963500] [019/134] (871s left) prime_vgem (basic-read)
[149.105164] Starting subtest: basic-read
[149.113947] Subtest basic-read: SKIP (0.007s)
[149.218086] [FACT prime_vgem (basic-read)] new: kernel.kmod_is_loaded.vgem: true
[149.221277] [020/134] (871s left) gem_ppgtt (blt-vs-render-ctxn)
[149.285529] Starting subtest: blt-vs-render-ctxN
[182.244523] Subtest blt-vs-render-ctxN: SUCCESS (32.956s)
[182.397859] [021/134] (838s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[182.544138] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[182.546360] Starting dynamic subtest: pipe-A-eDP-1
[182.568412] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[182.578157] Starting dynamic subtest: pipe-B-eDP-1
[182.598548] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[182.606398] Starting dynamic subtest: pipe-C-eDP-1
[182.627550] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[182.635087] Starting dynamic subtest: pipe-D-eDP-1
[182.656250] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[182.660466] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.003s)
[184.817116] [022/134] (835s left) syncobj_timeline (multi-wait-signaled)
[184.894700] Starting subtest: multi-wait-signaled
[184.897112] Subtest multi-wait-signaled: SUCCESS (0.001s)
[184.978279] [023/134] (835s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[190.003503] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[190.008266] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.002s)
[190.862276] [024/134] (829s left) gem_exec_schedule (preempt-other-chain)
[190.942865] Starting subtest: preempt-other-chain
[190.944965] Starting dynamic subtest: rcs0
[191.021323] Dynamic subtest rcs0: SUCCESS (0.083s)
[191.034406] Starting dynamic subtest: bcs0
[191.098440] Dynamic subtest bcs0: SUCCESS (0.078s)
[191.109882] Starting dynamic subtest: vcs0
[191.178987] Dynamic subtest vcs0: SUCCESS (0.080s)
[191.191268] Starting dynamic subtest: vcs1
[191.258761] Dynamic subtest vcs1: SUCCESS (0.079s)
[191.270939] Starting dynamic subtest: vecs0
[191.339088] Dynamic subtest vecs0: SUCCESS (0.079s)
[191.354331] Starting dynamic subtest: ccs0
[191.420879] Dynamic subtest ccs0: SUCCESS (0.082s)
[191.423574] Subtest preempt-other-chain: SUCCESS (0.483s)
[193.034999] [025/134] (827s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[193.147202] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[193.151297] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[193.276783] [026/134] (827s left) kms_plane_alpha_blend (constant-alpha-mid)
[193.366365] Starting subtest: constant-alpha-mid
[193.647412] Starting dynamic subtest: pipe-A-eDP-1
[194.549967] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.901s)
[194.560459] Starting dynamic subtest: pipe-D-eDP-1
[196.057678] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.508s)
[196.060112] Subtest constant-alpha-mid: SUCCESS (2.694s)
[196.925809] [027/134] (823s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[197.027635] Starting subtest: fbc-shrfb-scaledprimary
[200.049912] Subtest fbc-shrfb-scaledprimary: SUCCESS (3.025s)
[201.252631] [028/134] (819s left) kms_pm_dc (dc3co-vpb-simulation)
[202.352178] Starting subtest: dc3co-vpb-simulation
[211.665535] Subtest dc3co-vpb-simulation: SKIP (9.249s)
[211.760907] [029/134] (809s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[211.861543] Starting subtest: fbcpsr-2p-rte
[211.865879] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[211.986197] [030/134] (808s left) kms_chamelium_hpd (vga-hpd)
[212.389247] Subtest vga-hpd: SKIP (0.000s)
[213.235964] [031/134] (807s left) perf (sysctl-defaults)
[213.336713] Starting subtest: sysctl-defaults
[213.339560] Subtest sysctl-defaults: SUCCESS (0.000s)
[213.432352] [032/134] (807s left) gem_sync (basic-all)
[213.516190] Starting subtest: basic-all
[215.666779] Subtest basic-all: SUCCESS (2.143s)
[215.859990] [033/134] (805s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[215.968895] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[215.971137] Starting dynamic subtest: pipe-A-default-mode
[216.259800] Dynamic subtest pipe-A-default-mode: SKIP (0.289s)
[216.264689] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.290s)
[217.087213] [034/134] (803s left) kms_pipe_crc_basic (read-crc)
[217.184814] Starting subtest: read-crc
[217.187179] Starting dynamic subtest: pipe-A-eDP-1
[217.896921] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.713s)
[217.906809] Starting dynamic subtest: pipe-B-eDP-1
[219.268500] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.369s)
[219.277709] Starting dynamic subtest: pipe-C-eDP-1
[220.653703] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.384s)
[220.663565] Starting dynamic subtest: pipe-D-eDP-1
[221.982069] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.329s)
[221.984591] Subtest read-crc: SUCCESS (4.800s)
[222.821883] [035/134] (798s left) gem_create (create-clear)
[222.881015] Starting subtest: create-clear
[222.883116] Starting dynamic subtest: smem0
[255.695749] Dynamic subtest smem0: SUCCESS (32.810s)
[255.697768] Subtest create-clear: SUCCESS (32.811s)
[255.909131] [036/134] (765s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen)
[256.015207] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen
[259.993322] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (3.982s)
[261.144558] [037/134] (760s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[266.190780] Starting subtest: psr2-overlay-plane-move-continuous-sf
[266.193166] Starting dynamic subtest: pipe-A-eDP-1
[272.901370] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.707s)
[272.910192] Starting dynamic subtest: pipe-B-eDP-1
[279.623427] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.721s)
[279.625648] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (13.433s)
[280.440819] [038/134] (740s left) syncobj_eventfd (invalid-illegal-handle)
[280.501025] Starting subtest: invalid-illegal-handle
[280.503340] Subtest invalid-illegal-handle: SUCCESS (0.000s)
[280.605114] [039/134] (740s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[280.722397] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[280.726896] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[280.826492] [040/134] (740s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[280.944967] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[280.949353] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[281.026755] [041/134] (740s left) kms_psr (pr-primary-render)
[281.119976] Starting subtest: pr-primary-render
[281.124254] Subtest pr-primary-render: SKIP (0.000s)
[281.216915] [042/134] (740s left) gen9_exec_parse (bb-start-far)
[281.283910] Subtest bb-start-far: SKIP (0.000s)
[281.344324] [043/134] (740s left) kms_flip (2x-modeset-vs-vblank-race)
[281.444911] Starting subtest: 2x-modeset-vs-vblank-race
[281.456080] Subtest 2x-modeset-vs-vblank-race: SKIP (0.011s)
[281.562321] [044/134] (739s left) gem_exec_balancer (invalid-bonds)
[281.623209] Starting subtest: invalid-bonds
[281.627149] Subtest invalid-bonds: SKIP (0.000s)
[281.958574] [045/134] (739s left) gem_sync (basic-store-each)
[282.035748] Starting subtest: basic-store-each
[284.496067] Subtest basic-store-each: SUCCESS (2.471s)
[284.710298] [046/134] (736s left) kms_properties (connector-properties-atomic)
[284.821948] Starting subtest: connector-properties-atomic
[284.824166] Starting dynamic subtest: pipe-A-eDP-1
[292.734886] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.912s)
[292.743224] Starting dynamic subtest: pipe-None-DP-1
[292.747619] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[292.755507] Starting dynamic subtest: pipe-None-HDMI-A-1
[292.759523] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.002s)
[292.768079] Starting dynamic subtest: pipe-None-DP-2
[292.772261] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[292.780348] Starting dynamic subtest: pipe-None-HDMI-A-2
[292.784745] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[292.795345] Starting dynamic subtest: pipe-None-DP-3
[292.800073] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[292.811063] Starting dynamic subtest: pipe-None-DP-4
[292.815780] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[292.818045] Subtest connector-properties-atomic: SUCCESS (7.925s)
[293.609371] [047/134] (727s left) kms_content_protection (atomic)
[293.760624] Starting subtest: atomic
[293.764774] Subtest atomic: SKIP (0.000s)
[293.926343] [048/134] (727s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[294.031695] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[294.833431] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.804s)
[295.063035] [049/134] (726s left) gem_spin_batch (legacy-resubmit)
[295.123590] Starting subtest: legacy-resubmit
[295.125843] Starting dynamic subtest: default
[295.131320] Dynamic subtest default: SUCCESS (0.007s)
[295.141063] Starting dynamic subtest: render
[295.143277] Dynamic subtest render: SUCCESS (0.001s)
[295.151634] Starting dynamic subtest: bsd
[295.153514] Dynamic subtest bsd: SUCCESS (0.002s)
[295.161518] Starting dynamic subtest: bsd1
[295.163426] Dynamic subtest bsd1: SUCCESS (0.002s)
[295.171759] Starting dynamic subtest: bsd2
[295.173966] Dynamic subtest bsd2: SUCCESS (0.001s)
[295.184146] Starting dynamic subtest: blt
[295.186032] Dynamic subtest blt: SUCCESS (0.002s)
[295.193883] Starting dynamic subtest: vebox
[295.195794] Dynamic subtest vebox: SUCCESS (0.002s)
[295.197691] Subtest legacy-resubmit: SUCCESS (0.023s)
[295.413742] [050/134] (726s left) kms_flip (basic-flip-vs-wf_vblank)
[295.516111] Starting subtest: basic-flip-vs-wf_vblank
[295.518404] Starting dynamic subtest: A-eDP1
[297.434227] Dynamic subtest A-eDP1: SUCCESS (1.917s)
[297.444787] Starting dynamic subtest: B-eDP1
[299.364545] Dynamic subtest B-eDP1: SUCCESS (1.929s)
[299.373541] Starting dynamic subtest: C-eDP1
[301.287733] Dynamic subtest C-eDP1: SUCCESS (1.921s)
[301.296305] Starting dynamic subtest: D-eDP1
[303.224950] Dynamic subtest D-eDP1: SUCCESS (1.936s)
[303.227391] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.711s)
[304.467931] [051/134] (717s left) perf_pmu (multi-client)
[304.507267] Starting subtest: multi-client
[304.509613] Starting dynamic subtest: rcs0
[305.570371] Dynamic subtest rcs0: SUCCESS (1.063s)
[305.579818] Starting dynamic subtest: bcs0
[306.620983] Dynamic subtest bcs0: SUCCESS (1.048s)
[306.631077] Starting dynamic subtest: vcs0
[307.668396] Dynamic subtest vcs0: SUCCESS (1.044s)
[307.678069] Starting dynamic subtest: vcs1
[308.940741] Dynamic subtest vcs1: SUCCESS (1.270s)
[308.952241] Starting dynamic subtest: vecs0
[310.923599] Dynamic subtest vecs0: SUCCESS (1.982s)
[310.932540] Starting dynamic subtest: ccs0
[312.908065] Dynamic subtest ccs0: SUCCESS (1.980s)
[312.910891] Subtest multi-client: SUCCESS (8.401s)
[313.072865] [052/134] (708s left) kms_psr (fbc-psr2-sprite-plane-move)
[313.166181] Starting subtest: fbc-psr2-sprite-plane-move
[313.168505] Starting dynamic subtest: eDP-1
[313.172881] Dynamic subtest eDP-1: SKIP (0.000s)
[313.177300] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s)
[313.267389] [053/134] (708s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[313.375656] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[313.379725] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[313.510926] [054/134] (708s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[313.607386] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[313.610192] Starting dynamic subtest: pipe-A
[313.945897] Dynamic subtest pipe-A: SUCCESS (0.341s)
[313.954914] Starting dynamic subtest: pipe-B
[315.337464] Dynamic subtest pipe-B: SUCCESS (1.390s)
[315.346215] Starting dynamic subtest: pipe-C
[316.765557] Dynamic subtest pipe-C: SUCCESS (1.427s)
[316.779527] Starting dynamic subtest: pipe-D
[318.203734] Dynamic subtest pipe-D: SUCCESS (1.437s)
[318.206060] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.599s)
[319.398735] [055/134] (702s left) kms_atomic (test-only)
[319.497348] Starting subtest: test-only
[319.575702] Starting dynamic subtest: pipe-A-eDP-1
[322.098014] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.521s)
[322.100014] Subtest test-only: SUCCESS (2.600s)
[322.984825] [056/134] (698s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[323.085562] Starting subtest: psr-rgb101010-draw-mmap-gtt
[323.089977] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[323.209710] [057/134] (698s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[323.319293] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[323.323582] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[323.424553] [058/134] (698s left) gem_exercise_blt (fast-copy)
[323.478840] Starting subtest: fast-copy
[323.481204] Starting dynamic subtest: linear-smem-smem
[323.501643] Dynamic subtest linear-smem-smem: SUCCESS (0.023s)
[323.512267] Starting dynamic subtest: xmajor-smem-smem
[323.523977] Dynamic subtest xmajor-smem-smem: SUCCESS (0.021s)
[323.532831] Starting dynamic subtest: tile4-smem-smem
[323.541019] Dynamic subtest tile4-smem-smem: SUCCESS (0.016s)
[323.549636] Starting dynamic subtest: tile64-smem-smem
[323.558109] Dynamic subtest tile64-smem-smem: SUCCESS (0.016s)
[323.560505] Subtest fast-copy: SUCCESS (0.080s)
[323.700760] [059/134] (698s left) kms_cursor_crc (cursor-onscreen-128x128)
[323.898276] Starting subtest: cursor-onscreen-128x128
[323.902280] Starting dynamic subtest: pipe-A-eDP-1
[325.998410] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.096s)
[326.030473] Starting dynamic subtest: pipe-D-eDP-1
[328.779079] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.753s)
[328.781815] Subtest cursor-onscreen-128x128: SUCCESS (4.878s)
[329.674618] [060/134] (692s left) kms_addfb_basic (basic-y-tiled-legacy)
[329.729802] Starting subtest: basic-y-tiled-legacy
[329.734315] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[329.873788] [061/134] (692s left) gem_ctx_persistence (legacy-engines-hang)
[329.936443] Starting subtest: legacy-engines-hang
[329.938798] Starting dynamic subtest: render
[330.034904] Dynamic subtest render: SUCCESS (0.097s)
[330.049063] Starting dynamic subtest: bsd1
[330.150046] Dynamic subtest bsd1: SUCCESS (0.112s)
[330.164485] Starting dynamic subtest: bsd2
[330.279238] Dynamic subtest bsd2: SUCCESS (0.126s)
[330.291507] Starting dynamic subtest: blt
[330.405371] Dynamic subtest blt: SUCCESS (0.123s)
[330.417266] Starting dynamic subtest: vebox
[330.529215] Dynamic subtest vebox: SUCCESS (0.121s)
[330.531822] Subtest legacy-engines-hang: SUCCESS (0.593s)
[330.632201] [062/134] (691s left) vgem_basic (bad-fence)
[330.670939] Starting subtest: bad-fence
[330.672610] Subtest bad-fence: SUCCESS (0.000s)
[330.755993] [063/134] (691s left) kms_flip (blocking-wf_vblank)
[330.857527] Starting subtest: blocking-wf_vblank
[330.859542] Starting dynamic subtest: A-eDP1
[339.842076] Dynamic subtest A-eDP1: SUCCESS (8.951s)
[339.854481] Starting dynamic subtest: B-eDP1
[348.776096] Dynamic subtest B-eDP1: SUCCESS (8.932s)
[348.784996] Starting dynamic subtest: C-eDP1
[357.718180] Dynamic subtest C-eDP1: SUCCESS (8.929s)
[357.729620] Starting dynamic subtest: D-eDP1
[366.656033] Dynamic subtest D-eDP1: SUCCESS (8.932s)
[366.657981] Subtest blocking-wf_vblank: SUCCESS (35.757s)
[367.858678] [064/134] (654s left) gem_pxp (verify-pxp-stale-buf-execution)
[367.923477] Starting subtest: verify-pxp-stale-buf-execution
[368.987846] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.063s)
[369.125767] [065/134] (653s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[369.211410] Starting subtest: fbc-psr2-cursor-mmap-cpu
[369.213597] Starting dynamic subtest: eDP-1
[369.217505] Dynamic subtest eDP-1: SKIP (0.000s)
[369.221523] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.001s)
[369.308102] [066/134] (653s left) kms_colorop (plane-xr30-xr30-multiply_inv_125)
[369.444020] Subtest plane-XR30-XR30-multiply_inv_125: SKIP (0.000s)
[369.522630] [067/134] (652s left) kms_psr (psr2-sprite-mmap-gtt)
[369.616969] Starting subtest: psr2-sprite-mmap-gtt
[369.619097] Starting dynamic subtest: eDP-1
[371.032497] Dynamic subtest eDP-1: SKIP (1.412s)
[371.037327] Subtest psr2-sprite-mmap-gtt: SKIP (1.415s)
[371.197844] [068/134] (651s left) gem_lmem_swapping (verify-ccs)
[371.245173] Subtest verify-ccs: SKIP (0.000s)
[371.292212] [069/134] (651s left) api_intel_bb (reset-flags)
[371.348313] Starting subtest: reset-flags
[371.353078] Subtest reset-flags: SUCCESS (0.007s)
[371.506973] [070/134] (651s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[371.605305] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[371.607546] Starting dynamic subtest: pipe-A-default-mode
[372.731989] Dynamic subtest pipe-A-default-mode: SKIP (1.123s)
[372.736258] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.125s)
[372.887406] [071/134] (649s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[377.970983] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area
[377.975537] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.002s)
[378.823070] [072/134] (643s left) kms_flip (absolute-wf_vblank-interruptible)
[378.926399] Starting subtest: absolute-wf_vblank-interruptible
[378.928729] Starting dynamic subtest: A-eDP1
[387.712421] Dynamic subtest A-eDP1: SUCCESS (8.751s)
[387.723311] Starting dynamic subtest: B-eDP1
[396.436338] Dynamic subtest B-eDP1: SUCCESS (8.719s)
[396.447496] Starting dynamic subtest: C-eDP1
[405.176433] Dynamic subtest C-eDP1: SUCCESS (8.726s)
[405.186136] Starting dynamic subtest: D-eDP1
[413.911911] Dynamic subtest D-eDP1: SUCCESS (8.733s)
[413.914140] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.940s)
[415.106845] [073/134] (607s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[415.207263] Starting subtest: psr-shrfb-scaledprimary
[421.027527] Subtest psr-shrfb-scaledprimary: SUCCESS (5.822s)
[421.197266] [074/134] (601s left) kms_psr (psr-cursor-plane-move)
[421.298579] Starting subtest: psr-cursor-plane-move
[421.300802] Starting dynamic subtest: eDP-1
[423.002679] Dynamic subtest eDP-1: SUCCESS (1.706s)
[423.005072] Subtest psr-cursor-plane-move: SUCCESS (1.707s)
[423.895089] [075/134] (598s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[423.964304] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[424.036424] [076/134] (598s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[424.091744] Subtest basic-wc-gtt-noreloc: SKIP (0.000s)
[424.183423] [077/134] (598s left) kms_feature_discovery (psr1)
[424.285593] Starting subtest: psr1
[424.287853] Subtest psr1: SUCCESS (0.000s)
[424.370424] [078/134] (598s left) gem_render_copy (yf-tiled-ccs-to-y-tiled-ccs)
[424.431324] Starting subtest: yf-tiled-ccs-to-y-tiled-ccs
[424.435593] Subtest yf-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[424.623079] [079/134] (598s left) i915_pm_rps (waitboost)
[424.686879] Starting subtest: waitboost
[430.780343] Subtest waitboost: SUCCESS (6.091s)
[430.928606] [080/134] (592s left) gem_madvise (dontneed-after-mmap)
[430.961064] Starting subtest: dontneed-after-mmap
[430.986868] Subtest dontneed-after-mmap: SUCCESS (0.028s)
[431.102950] [081/134] (591s left) i915_pm_rpm (reg-read-ioctl)
[433.031714] Starting subtest: reg-read-ioctl
[435.311372] Subtest reg-read-ioctl: SUCCESS (2.281s)
[435.712941] [082/134] (587s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[435.814405] Starting subtest: x-tiled-16bpp-rotate-180
[437.180403] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.368s)
[437.331668] [083/134] (585s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[437.731764] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[438.506675] [084/134] (584s left) gem_exec_schedule (fairslice)
[438.588120] Starting subtest: fairslice
[438.590453] Starting dynamic subtest: rcs0
[440.650805] Dynamic subtest rcs0: SUCCESS (2.021s)
[440.661649] Starting dynamic subtest: bcs0
[442.621930] Dynamic subtest bcs0: SUCCESS (2.019s)
[442.632110] Starting dynamic subtest: vcs0
[444.692186] Dynamic subtest vcs0: SUCCESS (2.021s)
[444.702307] Starting dynamic subtest: vcs1
[446.713047] Dynamic subtest vcs1: SUCCESS (2.019s)
[446.723089] Starting dynamic subtest: vecs0
[448.686231] Dynamic subtest vecs0: SUCCESS (2.019s)
[448.698425] Starting dynamic subtest: ccs0
[450.759941] Dynamic subtest ccs0: SUCCESS (2.026s)
[450.762371] Subtest fairslice: SUCCESS (12.133s)
[451.021146] [085/134] (572s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[451.084154] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[451.086424] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[451.206884] [086/134] (571s left) gem_exec_whisper (basic-fds-forked-all)
[451.274639] Starting subtest: basic-fds-forked-all
[474.989521] Subtest basic-fds-forked-all: SUCCESS (23.709s)
[475.187770] [087/134] (548s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[475.293259] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[475.295520] Starting dynamic subtest: pipe-A-eDP-1
[475.317502] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[475.328879] Starting dynamic subtest: pipe-B-eDP-1
[475.349762] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[475.358631] Starting dynamic subtest: pipe-C-eDP-1
[475.380334] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[475.389186] Starting dynamic subtest: pipe-D-eDP-1
[475.411117] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[475.415221] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[477.519790] [088/134] (545s left) gem_basic (create-close)
[477.572669] Starting subtest: create-close
[477.577066] Subtest create-close: SUCCESS (0.000s)
[477.689490] [089/134] (545s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[477.788097] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc
[484.348963] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.562s)
[484.497566] [090/134] (538s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[484.596051] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[484.598081] Starting dynamic subtest: pipe-A-eDP-1
[485.348023] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.745s)
[485.359066] Starting dynamic subtest: pipe-B-eDP-1
[487.181141] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.831s)
[487.191675] Starting dynamic subtest: pipe-C-eDP-1
[489.036881] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.854s)
[489.047023] Starting dynamic subtest: pipe-D-eDP-1
[490.854215] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.816s)
[490.856047] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (6.253s)
[492.020688] [091/134] (531s left) gem_mmap_gtt (basic-small-bo-tiledx)
[492.069972] Subtest basic-small-bo-tiledX: SKIP (0.000s)
[492.129327] [092/134] (531s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[492.228598] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[493.320017] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.090s)
[493.453028] [093/134] (530s left) gem_mmap (short-mmap)
[493.514789] Subtest short-mmap: SKIP (0.000s)
[493.582399] [094/134] (529s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[493.686179] Starting subtest: y-tiled-16bpp-rotate-90
[493.689819] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[493.812753] [095/134] (529s left) gem_exec_fence (basic-busy-all)
[493.870592] Starting subtest: basic-busy-all
[493.984150] Subtest basic-busy-all: SUCCESS (0.114s)
[496.020095] [096/134] (527s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[496.120285] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[496.122556] Starting dynamic subtest: pipe-A-eDP-1
[496.132036] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[496.142651] Starting dynamic subtest: pipe-B-eDP-1
[496.151454] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[496.161168] Starting dynamic subtest: pipe-C-eDP-1
[496.169105] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[496.177765] Starting dynamic subtest: pipe-D-eDP-1
[496.185877] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[496.189792] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.005s)
[498.317024] [097/134] (525s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[498.409495] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[505.215186] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.808s)
[505.354388] [098/134] (518s left) gem_exec_fence (submit-chain)
[505.517925] Starting subtest: submit-chain
[505.535940] Subtest submit-chain: SUCCESS (0.019s)
[507.026655] [099/134] (516s left) gem_mmap_gtt (basic-small-bo-tiledy)
[507.084174] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[507.159582] [100/134] (516s left) kms_colorop (plane-xr24-xr24-srgb_eotf-srgb_inv_eotf-srgb_eotf)
[507.289465] Subtest plane-XR24-XR24-srgb_eotf-srgb_inv_eotf-srgb_eotf: SKIP (0.000s)
[507.383637] [101/134] (516s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[507.486292] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[507.490501] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[507.603095] [102/134] (516s left) gen9_exec_parse (unaligned-access)
[507.651744] Subtest unaligned-access: SKIP (0.000s)
[507.719783] [103/134] (516s left) kms_properties (get_properties-sanity-atomic)
[507.813074] Starting subtest: get_properties-sanity-atomic
[507.815282] Subtest get_properties-sanity-atomic: SUCCESS (0.002s)
[507.911664] [104/134] (516s left) i915_query (query-topology-matches-eu-total)
[507.974325] Starting subtest: query-topology-matches-eu-total
[507.975919] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[508.085136] [105/134] (515s left) gem_vm_create (isolation)
[508.135620] Starting subtest: isolation
[508.144724] Subtest isolation: SUCCESS (0.009s)
[508.268895] [106/134] (515s left) kms_vblank (wait-forked)
[508.353643] Starting subtest: wait-forked
[508.355624] Starting dynamic subtest: pipe-A-eDP-1
[510.171586] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.816s)
[510.187497] Starting dynamic subtest: pipe-D-eDP-1
[512.620304] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.448s)
[512.622705] Subtest wait-forked: SUCCESS (4.268s)
[513.515821] [107/134] (510s left) gem_mmap_gtt (fault-concurrent)
[513.582668] Subtest fault-concurrent: SKIP (0.000s)
[513.647947] [108/134] (510s left) syncobj_wait (invalid-reset-illegal-handle)
[513.705908] Starting subtest: invalid-reset-illegal-handle
[513.708413] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[513.858651] [109/134] (510s left) gem_exec_fence (basic-await)
[514.035217] Starting subtest: basic-await
[514.037302] Starting dynamic subtest: rcs0
[514.105409] Dynamic subtest rcs0: SUCCESS (0.074s)
[514.115888] Starting dynamic subtest: bcs0
[514.185878] Dynamic subtest bcs0: SUCCESS (0.078s)
[514.198071] Starting dynamic subtest: vcs0
[514.259101] Dynamic subtest vcs0: SUCCESS (0.071s)
[514.270655] Starting dynamic subtest: vcs1
[514.331401] Dynamic subtest vcs1: SUCCESS (0.071s)
[514.343193] Starting dynamic subtest: vecs0
[514.405685] Dynamic subtest vecs0: SUCCESS (0.072s)
[514.417884] Starting dynamic subtest: ccs0
[514.478952] Dynamic subtest ccs0: SUCCESS (0.071s)
[514.481700] Subtest basic-await: SUCCESS (0.448s)
[516.026305] [110/134] (508s left) gem_exec_flush (basic-wb-pro-default)
[516.092099] Starting subtest: basic-wb-pro-default
[521.575185] Subtest basic-wb-pro-default: SUCCESS (5.458s)
[521.750269] [111/134] (502s left) kms_cursor_crc (cursor-random-64x64)
[521.924947] Starting subtest: cursor-random-64x64
[521.927106] Starting dynamic subtest: pipe-A-eDP-1
[525.267767] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.341s)
[525.299855] Starting dynamic subtest: pipe-D-eDP-1
[529.302208] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.009s)
[529.304578] Subtest cursor-random-64x64: SUCCESS (7.377s)
[530.182858] [112/134] (494s left) api_intel_allocator (alloc-simple)
[530.234684] Starting subtest: alloc-simple
[530.237064] Subtest alloc-simple: SUCCESS (0.004s)
[530.384186] [113/134] (493s left) gem_exec_schedule (preempt-user)
[530.452731] Starting subtest: preempt-user
[530.454590] Starting dynamic subtest: rcs0
[530.470781] Dynamic subtest rcs0: SUCCESS (0.023s)
[530.480380] Starting dynamic subtest: bcs0
[530.497116] Dynamic subtest bcs0: SUCCESS (0.026s)
[530.506584] Starting dynamic subtest: vcs0
[530.521674] Dynamic subtest vcs0: SUCCESS (0.024s)
[530.531640] Starting dynamic subtest: vcs1
[530.543831] Dynamic subtest vcs1: SUCCESS (0.021s)
[530.553536] Starting dynamic subtest: vecs0
[530.564177] Dynamic subtest vecs0: SUCCESS (0.019s)
[530.573413] Starting dynamic subtest: ccs0
[530.584726] Dynamic subtest ccs0: SUCCESS (0.020s)
[530.586834] Subtest preempt-user: SUCCESS (0.137s)
[532.033806] [114/134] (492s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[532.137804] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[532.141786] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[532.271892] [115/134] (492s left) kms_plane (plane-panning-bottom-right)
[532.373495] Starting subtest: plane-panning-bottom-right
[532.375627] Starting dynamic subtest: pipe-A
[534.023229] Dynamic subtest pipe-A: SUCCESS (1.651s)
[534.039654] Starting dynamic subtest: pipe-B
[536.428097] Dynamic subtest pipe-B: SUCCESS (2.402s)
[536.430755] Subtest plane-panning-bottom-right: SUCCESS (4.056s)
[537.339060] [116/134] (487s left) drm_mm (drm_mm)
[537.379508] Starting subtest: drm_mm
[537.410293] Starting dynamic subtest: drm_test_mm_init
[537.556432] Dynamic subtest drm_test_mm_init: SUCCESS (0.145s)
[537.568206] Starting dynamic subtest: drm_test_mm_debug
[537.700198] Dynamic subtest drm_test_mm_debug: SUCCESS (0.139s)
[537.711376] Starting dynamic subtest: drm_test_mm_align32
[537.820053] Dynamic subtest drm_test_mm_align32: SUCCESS (0.120s)
[537.829349] Starting dynamic subtest: drm_test_mm_align64
[537.952464] Dynamic subtest drm_test_mm_align64: SUCCESS (0.131s)
[537.961586] Starting dynamic subtest: drm_test_mm_lowest
[538.100560] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.147s)
[538.109378] Starting dynamic subtest: drm_test_mm_highest
[538.232108] Dynamic subtest drm_test_mm_highest: SUCCESS (0.131s)
[538.234407] Subtest drm_mm: SUCCESS (0.854s)
[538.405272] [117/134] (486s left) gem_userptr_blits (coherency-sync)
[538.462367] Starting subtest: coherency-sync
[538.664838] Subtest coherency-sync: SKIP (0.167s)
[538.797305] [118/134] (485s left) gem_userptr_blits (access-control)
[538.909035] Starting subtest: access-control
[538.913307] Subtest access-control: SKIP (0.000s)
[539.043335] [119/134] (485s left) kms_colorop (plane-xr24-xr24-ctm_3x4_50_desat)
[539.186609] Subtest plane-XR24-XR24-ctm_3x4_50_desat: SKIP (0.000s)
[539.275997] [120/134] (485s left) kms_pm_rpm (fences)
[541.035351] Starting subtest: fences
[541.040748] Subtest fences: SKIP (0.000s)
[541.568664] [121/134] (483s left) gem_close_race (basic-process)
[541.653237] Starting subtest: basic-process
[541.684059] Subtest basic-process: SUCCESS (0.031s)
[541.880404] [122/134] (482s left) kms_vrr (flipline)
[541.976919] Starting subtest: flipline
[541.983581] Subtest flipline: SKIP (0.000s)
[542.063732] [123/134] (482s left) perf_pmu (busy)
[542.105077] Starting subtest: busy
[542.107435] Starting dynamic subtest: rcs0
[542.740653] Dynamic subtest rcs0: SUCCESS (0.636s)
[542.752666] Starting dynamic subtest: bcs0
[543.315022] Dynamic subtest bcs0: SUCCESS (0.572s)
[543.326207] Starting dynamic subtest: vcs0
[544.916911] Dynamic subtest vcs0: SUCCESS (1.598s)
[544.929078] Starting dynamic subtest: vcs1
[546.901356] Dynamic subtest vcs1: SUCCESS (1.981s)
[546.912889] Starting dynamic subtest: vecs0
[548.884382] Dynamic subtest vecs0: SUCCESS (1.980s)
[548.896314] Starting dynamic subtest: ccs0
[549.456355] Dynamic subtest ccs0: SUCCESS (0.571s)
[549.458852] Subtest busy: SUCCESS (7.353s)
[549.590066] [124/134] (475s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[549.693694] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[549.697883] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[549.791314] [125/134] (475s left) gem_render_linear_blits (basic)
[549.839734] Starting subtest: basic
[549.861440] Subtest basic: SUCCESS (0.021s)
[549.968790] [126/134] (474s left) kms_busy (extended-modeset-hang-newfb)
[550.072072] Starting subtest: extended-modeset-hang-newfb
[550.074234] Starting dynamic subtest: pipe-A
[585.644572] Dynamic subtest pipe-A: SUCCESS (35.569s)
[585.655688] Starting dynamic subtest: pipe-D
[608.794800] Dynamic subtest pipe-D: SUCCESS (23.147s)
[608.797487] Subtest extended-modeset-hang-newfb: SUCCESS (58.722s)
[609.602065] [127/134] (415s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[609.718437] Starting subtest: modeset-atomic-cursor-hotspot
[609.722895] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[609.875563] [128/134] (415s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[609.969413] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[616.730209] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (6.763s)
[616.902169] [129/134] (408s left) gem_flink_basic (basic)
[616.965482] Starting subtest: basic
[616.967897] Subtest basic: SUCCESS (0.000s)
[617.085898] [130/134] (407s left) syncobj_timeline (wait-all-snapshot)
[617.149309] Starting subtest: wait-all-snapshot
[617.231248] Subtest wait-all-snapshot: SUCCESS (0.081s)
[617.318997] [131/134] (407s left) kms_getfb (getfb2-handle-not-fb)
[617.413062] Starting subtest: getfb2-handle-not-fb
[617.415335] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[617.532072] [132/134] (407s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[617.636792] Starting subtest: 4-tiled-8bpp-rotate-0
[618.871260] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.236s)
[619.043967] [133/134] (406s left) syncobj_timeline (etime-single-wait-submitted)
[619.097485] Starting subtest: etime-single-wait-submitted
[619.200391] Subtest etime-single-wait-submitted: SUCCESS (0.102s)
[619.291392] [134/134] (405s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[619.382118] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[626.110389] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.730s)
[626.242785] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_draw_crc
results: parsing output: 2/ for test: kms_rmfb
results: parsing output: 3/ for test: fbdev
results: parsing output: 4/ for test: gem_exec_reloc
results: parsing output: 5/ for test: gem_pxp
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: gem_ctx_shared
results: parsing output: 8/ for test: gem_tiled_swapping
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: i915_hangman
results: parsing output: 11/ for test: gem_mmap_offset
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_tiled_display
results: parsing output: 14/ for test: kms_addfb_basic
results: parsing output: 15/ for test: gem_ctx_isolation
results: parsing output: 16/ for test: kms_properties
results: parsing output: 17/ for test: kms_ccs
results: parsing output: 18/ for test: prime_vgem
results: parsing output: 19/ for test: gem_ppgtt
results: parsing output: 20/ for test: kms_ccs
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: kms_psr2_sf
results: parsing output: 23/ for test: gem_exec_schedule
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_plane_alpha_blend
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_pm_dc
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_chamelium_hpd
results: parsing output: 30/ for test: perf
results: parsing output: 31/ for test: gem_sync
results: parsing output: 32/ for test: kms_flip_scaled_crc
results: parsing output: 33/ for test: kms_pipe_crc_basic
results: parsing output: 34/ for test: gem_create
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_psr2_sf
results: parsing output: 37/ for test: syncobj_eventfd
results: parsing output: 38/ for test: kms_big_fb
results: parsing output: 39/ for test: kms_joiner
results: parsing output: 40/ for test: kms_psr
results: parsing output: 41/ for test: gen9_exec_parse
results: parsing output: 42/ for test: kms_flip
results: parsing output: 43/ for test: gem_exec_balancer
results: parsing output: 44/ for test: gem_sync
results: parsing output: 45/ for test: kms_properties
results: parsing output: 46/ for test: kms_content_protection
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: gem_spin_batch
results: parsing output: 49/ for test: kms_flip
results: parsing output: 50/ for test: perf_pmu
results: parsing output: 51/ for test: kms_psr
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_plane_scaling
results: parsing output: 54/ for test: kms_atomic
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_exercise_blt
results: parsing output: 58/ for test: kms_cursor_crc
results: parsing output: 59/ for test: kms_addfb_basic
results: parsing output: 60/ for test: gem_ctx_persistence
results: parsing output: 61/ for test: vgem_basic
results: parsing output: 62/ for test: kms_flip
results: parsing output: 63/ for test: gem_pxp
results: parsing output: 64/ for test: kms_psr
results: parsing output: 65/ for test: kms_colorop
results: parsing output: 66/ for test: kms_psr
results: parsing output: 67/ for test: gem_lmem_swapping
results: parsing output: 68/ for test: api_intel_bb
results: parsing output: 69/ for test: kms_flip_scaled_crc
results: parsing output: 70/ for test: kms_psr2_sf
results: parsing output: 71/ for test: kms_flip
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: gem_exec_reloc
results: parsing output: 75/ for test: gem_exec_reloc
results: parsing output: 76/ for test: kms_feature_discovery
results: parsing output: 77/ for test: gem_render_copy
results: parsing output: 78/ for test: i915_pm_rps
results: parsing output: 79/ for test: gem_madvise
results: parsing output: 80/ for test: i915_pm_rpm
results: parsing output: 81/ for test: kms_big_fb
results: parsing output: 82/ for test: kms_chamelium_edid
results: parsing output: 83/ for test: gem_exec_schedule
results: parsing output: 84/ for test: syncobj_timeline
results: parsing output: 85/ for test: gem_exec_whisper
results: parsing output: 86/ for test: kms_ccs
results: parsing output: 87/ for test: gem_basic
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_ccs
results: parsing output: 90/ for test: gem_mmap_gtt
results: parsing output: 91/ for test: kms_big_fb
results: parsing output: 92/ for test: gem_mmap
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: gem_exec_fence
results: parsing output: 95/ for test: kms_ccs
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: gem_exec_fence
results: parsing output: 98/ for test: gem_mmap_gtt
results: parsing output: 99/ for test: kms_colorop
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: gen9_exec_parse
results: parsing output: 102/ for test: kms_properties
results: parsing output: 103/ for test: i915_query
results: parsing output: 104/ for test: gem_vm_create
results: parsing output: 105/ for test: kms_vblank
results: parsing output: 106/ for test: gem_mmap_gtt
results: parsing output: 107/ for test: syncobj_wait
results: parsing output: 108/ for test: gem_exec_fence
results: parsing output: 109/ for test: gem_exec_flush
results: parsing output: 110/ for test: kms_cursor_crc
results: parsing output: 111/ for test: api_intel_allocator
results: parsing output: 112/ for test: gem_exec_schedule
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_plane
results: parsing output: 115/ for test: drm_mm
results: parsing output: 116/ for test: gem_userptr_blits
results: parsing output: 117/ for test: gem_userptr_blits
results: parsing output: 118/ for test: kms_colorop
results: parsing output: 119/ for test: kms_pm_rpm
results: parsing output: 120/ for test: gem_close_race
results: parsing output: 121/ for test: kms_vrr
results: parsing output: 122/ for test: perf_pmu
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: gem_render_linear_blits
results: parsing output: 125/ for test: kms_busy
results: parsing output: 126/ for test: kms_cursor_legacy
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: gem_flink_basic
results: parsing output: 129/ for test: syncobj_timeline
results: parsing output: 130/ for test: kms_getfb
results: parsing output: 131/ for test: kms_big_fb
results: parsing output: 132/ for test: syncobj_timeline
results: parsing output: 133/ for test: kms_frontbuffer_tracking
Done.