[54.448095] Initializing watchdogs
[54.448141]   /dev/watchdog0
[54.477385] [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.481614] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[54.483735] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[54.487362] [001/134] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[54.607092] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[61.288816] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.778s)
[61.419572] [002/134] (953s left) kms_draw_crc (draw-method-render)
[61.523338] Starting subtest: draw-method-render
[61.525556] Starting dynamic subtest: xrgb8888-untiled
[61.786309] Dynamic subtest xrgb8888-untiled: SUCCESS (0.266s)
[61.794758] Starting dynamic subtest: rgb565-untiled
[62.006964] Dynamic subtest rgb565-untiled: SUCCESS (0.222s)
[62.016460] Starting dynamic subtest: xrgb2101010-untiled
[62.216135] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.211s)
[62.224965] Starting dynamic subtest: xbgr16161616f-untiled
[62.438297] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s)
[62.445100] Starting dynamic subtest: xrgb8888-xtiled
[62.558193] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s)
[62.568107] Starting dynamic subtest: rgb565-xtiled
[62.679507] Dynamic subtest rgb565-xtiled: SUCCESS (0.122s)
[62.687502] Starting dynamic subtest: xrgb2101010-xtiled
[62.800968] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s)
[62.808604] Starting dynamic subtest: xbgr16161616f-xtiled
[62.933446] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[62.941985] Starting dynamic subtest: xrgb8888-4tiled
[63.065651] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.133s)
[63.076033] Starting dynamic subtest: rgb565-4tiled
[63.187076] Dynamic subtest rgb565-4tiled: SUCCESS (0.122s)
[63.195975] Starting dynamic subtest: xrgb2101010-4tiled
[63.297459] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.111s)
[63.305736] Starting dynamic subtest: xbgr16161616f-4tiled
[63.420094] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.123s)
[63.422074] Subtest draw-method-render: SUCCESS (1.912s)
[63.527120] [003/134] (951s left) kms_rmfb (close-fd)
[63.620606] Starting subtest: close-fd
[63.622395] Starting dynamic subtest: pipe-A-eDP-1
[63.727275] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.109s)
[63.735733] Starting dynamic subtest: pipe-B-eDP-1
[64.927332] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.205s)
[64.936439] Starting dynamic subtest: pipe-C-eDP-1
[66.057731] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.133s)
[66.064843] Starting dynamic subtest: pipe-D-eDP-1
[67.183621] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.131s)
[67.185817] Subtest close-fd: SUCCESS (3.582s)
[68.403335] [004/134] (946s left) fbdev (info)
[68.435626] Starting subtest: info
[68.437718] Subtest info: SUCCESS (0.000s)
[68.511044] [005/134] (946s left) gem_exec_reloc (basic-cpu-wc-active)
[68.570059] Subtest basic-cpu-wc-active: SKIP (0.000s)
[68.650380] [006/134] (946s left) gem_pxp (display-protected-crc)
[68.783027] Starting subtest: display-protected-crc
[70.883451] Subtest display-protected-crc: SUCCESS (2.110s)
[71.094408] [007/134] (944s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[71.537073] Starting subtest: etime-single-wait-all-for-submit-submitted
[71.641061] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.105s)
[71.887425] [008/134] (943s left) gem_ctx_shared (q-smoketest-all)
[72.134256] Starting subtest: Q-smoketest-all
[104.546661] Subtest Q-smoketest-all: SUCCESS (32.375s)
[105.931390] [009/134] (909s left) gem_tiled_swapping (non-threaded)
[105.995332] Subtest non-threaded: SKIP (0.000s)
[106.047246] [010/134] (909s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[106.152235] Starting subtest: fbc-rgb565-draw-pwrite
[110.735368] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.585s)
[111.866727] [011/134] (903s left) i915_hangman (engine-engine-hang)
[111.939923] Starting subtest: engine-engine-hang
[111.942066] Starting dynamic subtest: rcs0
[113.845604] Dynamic subtest rcs0: SUCCESS (1.905s)
[113.855789] Starting dynamic subtest: bcs0
[115.892052] Dynamic subtest bcs0: SUCCESS (2.045s)
[115.902060] Starting dynamic subtest: vcs0
[117.876749] Dynamic subtest vcs0: SUCCESS (1.983s)
[117.887877] Starting dynamic subtest: vcs1
[119.859703] Dynamic subtest vcs1: SUCCESS (1.981s)
[119.873984] Starting dynamic subtest: vecs0
[121.844612] Dynamic subtest vecs0: SUCCESS (1.984s)
[121.852739] Starting dynamic subtest: ccs0
[123.891494] Dynamic subtest ccs0: SUCCESS (2.045s)
[123.894161] Subtest engine-engine-hang: SUCCESS (11.951s)
[123.984610] [012/134] (891s left) gem_mmap_offset (partial-unmap)
[124.042705] Starting subtest: partial-unmap
[124.044865] Starting dynamic subtest: smem0
[124.546591] Dynamic subtest smem0: SUCCESS (0.504s)
[124.549045] Subtest partial-unmap: SUCCESS (0.505s)
[124.686750] [013/134] (890s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[124.783373] Starting subtest: fbc-indfb-scaledprimary
[127.707233] Subtest fbc-indfb-scaledprimary: SUCCESS (2.926s)
[128.859886] [014/134] (886s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[128.967303] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[129.010496] [015/134] (886s left) kms_addfb_basic (invalid-get-prop-any)
[129.064263] Starting subtest: invalid-get-prop-any
[129.066425] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[129.241631] [016/134] (886s left) gem_ctx_isolation (preservation-reset)
[129.408235] Starting subtest: preservation-reset
[129.410841] Starting dynamic subtest: rcs0
[129.647190] Dynamic subtest rcs0: SUCCESS (0.239s)
[129.655327] Starting dynamic subtest: bcs0
[129.943332] Dynamic subtest bcs0: SUCCESS (0.296s)
[129.954449] Starting dynamic subtest: vcs0
[130.261158] Dynamic subtest vcs0: SUCCESS (0.317s)
[130.271782] Starting dynamic subtest: vcs1
[132.219808] Dynamic subtest vcs1: SUCCESS (1.958s)
[132.228735] Starting dynamic subtest: vecs0
[134.214087] Dynamic subtest vecs0: SUCCESS (1.994s)
[134.225049] Starting dynamic subtest: ccs0
[136.208092] Dynamic subtest ccs0: SUCCESS (1.994s)
[136.210396] Subtest preservation-reset: SUCCESS (6.802s)
[136.366337] [017/134] (879s left) kms_properties (plane-properties-legacy)
[136.455793] Starting subtest: plane-properties-legacy
[136.457694] Starting dynamic subtest: pipe-A-eDP-1
[137.033495] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.579s)
[137.045422] Starting dynamic subtest: pipe-B-eDP-1
[138.314554] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.280s)
[138.325946] Starting dynamic subtest: pipe-C-eDP-1
[139.545717] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.230s)
[139.555779] Starting dynamic subtest: pipe-D-eDP-1
[140.779974] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.232s)
[140.782442] Subtest plane-properties-legacy: SUCCESS (4.324s)
[141.609363] [018/134] (874s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[141.705829] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[141.708094] Starting dynamic subtest: pipe-A-eDP-1
[141.765220] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[141.772591] Starting dynamic subtest: pipe-B-eDP-1
[141.830172] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[141.838700] Starting dynamic subtest: pipe-C-eDP-1
[141.898685] Dynamic subtest pipe-C-eDP-1: SKIP (0.002s)
[141.908026] Starting dynamic subtest: pipe-D-eDP-1
[141.967077] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[141.971697] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.009s)
[143.965372] [019/134] (871s left) prime_vgem (basic-read)
[144.100707] Starting subtest: basic-read
[144.108107] Subtest basic-read: SKIP (0.005s)
[144.247669] [FACT prime_vgem (basic-read)] new: kernel.kmod_is_loaded.vgem: true
[144.250695] [020/134] (871s left) gem_ppgtt (blt-vs-render-ctxn)
[144.311321] Starting subtest: blt-vs-render-ctxN
[177.320494] Subtest blt-vs-render-ctxN: SUCCESS (33.005s)
[177.504588] [021/134] (838s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[177.649084] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[177.651422] Starting dynamic subtest: pipe-A-eDP-1
[177.674913] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[177.685046] Starting dynamic subtest: pipe-B-eDP-1
[177.706470] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[177.714359] Starting dynamic subtest: pipe-C-eDP-1
[177.735964] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[177.743776] Starting dynamic subtest: pipe-D-eDP-1
[177.765791] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[177.770188] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.003s)
[179.935587] [022/134] (835s left) syncobj_timeline (multi-wait-signaled)
[179.998306] Starting subtest: multi-wait-signaled
[180.000530] Subtest multi-wait-signaled: SUCCESS (0.001s)
[180.133227] [023/134] (835s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[185.181492] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[185.186241] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.002s)
[186.069856] [024/134] (829s left) gem_exec_schedule (preempt-other-chain)
[186.159164] Starting subtest: preempt-other-chain
[186.161250] Starting dynamic subtest: rcs0
[186.239916] Dynamic subtest rcs0: SUCCESS (0.086s)
[186.252516] Starting dynamic subtest: bcs0
[186.315742] Dynamic subtest bcs0: SUCCESS (0.075s)
[186.332445] Starting dynamic subtest: vcs0
[186.393054] Dynamic subtest vcs0: SUCCESS (0.077s)
[186.411618] Starting dynamic subtest: vcs1
[186.472146] Dynamic subtest vcs1: SUCCESS (0.079s)
[186.490258] Starting dynamic subtest: vecs0
[186.550957] Dynamic subtest vecs0: SUCCESS (0.078s)
[186.561476] Starting dynamic subtest: ccs0
[186.636245] Dynamic subtest ccs0: SUCCESS (0.085s)
[186.638839] Subtest preempt-other-chain: SUCCESS (0.483s)
[188.031289] [025/134] (827s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[188.131236] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[188.135115] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[188.263328] [026/134] (827s left) kms_plane_alpha_blend (constant-alpha-mid)
[188.356251] Starting subtest: constant-alpha-mid
[188.644793] Starting dynamic subtest: pipe-A-eDP-1
[189.411975] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.767s)
[189.421814] Starting dynamic subtest: pipe-D-eDP-1
[190.928496] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.512s)
[190.930468] Subtest constant-alpha-mid: SUCCESS (2.568s)
[191.817757] [027/134] (824s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[191.925289] Starting subtest: fbc-shrfb-scaledprimary
[194.928693] Subtest fbc-shrfb-scaledprimary: SUCCESS (3.006s)
[196.103457] [028/134] (819s left) kms_pm_dc (dc3co-vpb-simulation)
[197.211778] Starting subtest: dc3co-vpb-simulation
[206.387038] Subtest dc3co-vpb-simulation: SKIP (9.171s)
[206.529641] [029/134] (809s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[206.630587] Starting subtest: fbcpsr-2p-rte
[206.635132] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[206.749601] [030/134] (809s left) kms_chamelium_hpd (vga-hpd)
[207.133966] Subtest vga-hpd: SKIP (0.000s)
[207.903801] [031/134] (808s left) perf (sysctl-defaults)
[207.983504] Starting subtest: sysctl-defaults
[207.985842] Subtest sysctl-defaults: SUCCESS (0.000s)
[208.097977] [032/134] (808s left) gem_sync (basic-all)
[208.172715] Starting subtest: basic-all
[211.926102] Subtest basic-all: SUCCESS (3.763s)
[212.118208] [033/134] (804s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[212.214789] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[212.217078] Starting dynamic subtest: pipe-A-default-mode
[212.512436] Dynamic subtest pipe-A-default-mode: SKIP (0.295s)
[212.517068] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.296s)
[213.380965] [034/134] (802s left) kms_pipe_crc_basic (read-crc)
[213.469511] Starting subtest: read-crc
[213.471889] Starting dynamic subtest: pipe-A-eDP-1
[214.183373] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.712s)
[214.191486] Starting dynamic subtest: pipe-B-eDP-1
[215.524140] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.341s)
[215.536652] Starting dynamic subtest: pipe-C-eDP-1
[216.829449] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.304s)
[216.838951] Starting dynamic subtest: pipe-D-eDP-1
[218.159124] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.328s)
[218.161415] Subtest read-crc: SUCCESS (4.692s)
[219.004841] [035/134] (797s left) gem_create (create-clear)
[219.057901] Starting subtest: create-clear
[219.059821] Starting dynamic subtest: smem0
[251.819965] Dynamic subtest smem0: SUCCESS (32.759s)
[251.822190] Subtest create-clear: SUCCESS (32.760s)
[252.019974] [036/134] (764s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen)
[252.125190] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen
[256.042052] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (3.920s)
[257.216921] [037/134] (759s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf)
[262.181977] Starting subtest: psr2-overlay-plane-move-continuous-sf
[262.184321] Starting dynamic subtest: pipe-A-eDP-1
[268.891177] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.708s)
[268.900119] Starting dynamic subtest: pipe-B-eDP-1
[275.628581] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.733s)
[275.630842] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (13.448s)
[276.524408] [038/134] (739s left) syncobj_eventfd (invalid-illegal-handle)
[276.587834] Starting subtest: invalid-illegal-handle
[276.590110] Subtest invalid-illegal-handle: SUCCESS (0.000s)
[276.719429] [039/134] (739s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[276.828064] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[276.832433] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[276.967390] [040/134] (739s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner)
[277.075069] Starting subtest: switch-modeset-ultra-joiner-big-joiner
[277.079546] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s)
[277.183826] [041/134] (739s left) kms_psr (pr-primary-render)
[277.291341] Starting subtest: pr-primary-render
[277.295487] Subtest pr-primary-render: SKIP (0.000s)
[277.390582] [042/134] (739s left) gen9_exec_parse (bb-start-far)
[277.454811] Subtest bb-start-far: SKIP (0.000s)
[277.542857] [043/134] (739s left) kms_flip (2x-modeset-vs-vblank-race)
[277.627826] Starting subtest: 2x-modeset-vs-vblank-race
[277.638682] Subtest 2x-modeset-vs-vblank-race: SKIP (0.010s)
[277.769882] [044/134] (739s left) gem_exec_balancer (invalid-bonds)
[277.831854] Starting subtest: invalid-bonds
[277.835506] Subtest invalid-bonds: SKIP (0.000s)
[278.121578] [045/134] (738s left) gem_sync (basic-store-each)
[278.195244] Starting subtest: basic-store-each
[280.680857] Subtest basic-store-each: SUCCESS (2.497s)
[280.875513] [046/134] (735s left) kms_properties (connector-properties-atomic)
[280.986808] Starting subtest: connector-properties-atomic
[280.989155] Starting dynamic subtest: pipe-A-eDP-1
[288.925311] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.938s)
[288.934849] Starting dynamic subtest: pipe-None-DP-1
[288.939190] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[288.948734] Starting dynamic subtest: pipe-None-HDMI-A-1
[288.952991] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[288.960642] Starting dynamic subtest: pipe-None-DP-2
[288.965080] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[288.972826] Starting dynamic subtest: pipe-None-HDMI-A-2
[288.977282] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[288.987153] Starting dynamic subtest: pipe-None-DP-3
[288.991270] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[288.999800] Starting dynamic subtest: pipe-None-DP-4
[289.004686] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[289.006982] Subtest connector-properties-atomic: SUCCESS (7.948s)
[289.791165] [047/134] (727s left) kms_content_protection (atomic)
[289.925753] Starting subtest: atomic
[289.930239] Subtest atomic: SKIP (0.000s)
[290.075279] [048/134] (726s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[290.174299] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[290.976297] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.803s)
[291.168540] [049/134] (725s left) gem_spin_batch (legacy-resubmit)
[291.236900] Starting subtest: legacy-resubmit
[291.239325] Starting dynamic subtest: default
[291.244174] Dynamic subtest default: SUCCESS (0.006s)
[291.254072] Starting dynamic subtest: render
[291.256388] Dynamic subtest render: SUCCESS (0.001s)
[291.266711] Starting dynamic subtest: bsd
[291.268995] Dynamic subtest bsd: SUCCESS (0.002s)
[291.277091] Starting dynamic subtest: bsd1
[291.279305] Dynamic subtest bsd1: SUCCESS (0.002s)
[291.287253] Starting dynamic subtest: bsd2
[291.289445] Dynamic subtest bsd2: SUCCESS (0.001s)
[291.297552] Starting dynamic subtest: blt
[291.299861] Dynamic subtest blt: SUCCESS (0.002s)
[291.308510] Starting dynamic subtest: vebox
[291.310731] Dynamic subtest vebox: SUCCESS (0.002s)
[291.312936] Subtest legacy-resubmit: SUCCESS (0.023s)
[291.517193] [050/134] (725s left) kms_flip (basic-flip-vs-wf_vblank)
[291.613155] Starting subtest: basic-flip-vs-wf_vblank
[291.615440] Starting dynamic subtest: A-eDP1
[293.533042] Dynamic subtest A-eDP1: SUCCESS (1.919s)
[293.544183] Starting dynamic subtest: B-eDP1
[295.467269] Dynamic subtest B-eDP1: SUCCESS (1.932s)
[295.477702] Starting dynamic subtest: C-eDP1
[297.381679] Dynamic subtest C-eDP1: SUCCESS (1.913s)
[297.393534] Starting dynamic subtest: D-eDP1
[299.318572] Dynamic subtest D-eDP1: SUCCESS (1.934s)
[299.320997] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.708s)
[300.565523] [051/134] (716s left) perf_pmu (multi-client)
[300.609850] Starting subtest: multi-client
[300.612223] Starting dynamic subtest: rcs0
[301.691365] Dynamic subtest rcs0: SUCCESS (1.079s)
[301.703265] Starting dynamic subtest: bcs0
[302.741247] Dynamic subtest bcs0: SUCCESS (1.048s)
[302.750639] Starting dynamic subtest: vcs0
[303.790732] Dynamic subtest vcs0: SUCCESS (1.046s)
[303.802636] Starting dynamic subtest: vcs1
[304.909388] Dynamic subtest vcs1: SUCCESS (1.117s)
[304.920604] Starting dynamic subtest: vecs0
[306.957806] Dynamic subtest vecs0: SUCCESS (2.044s)
[306.969676] Starting dynamic subtest: ccs0
[308.940404] Dynamic subtest ccs0: SUCCESS (1.981s)
[308.943463] Subtest multi-client: SUCCESS (8.330s)
[309.084175] [052/134] (708s left) kms_psr (fbc-psr2-sprite-plane-move)
[309.176916] Starting subtest: fbc-psr2-sprite-plane-move
[309.179187] Starting dynamic subtest: eDP-1
[309.183509] Dynamic subtest eDP-1: SKIP (0.000s)
[309.187901] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s)
[309.264321] [053/134] (707s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[309.355328] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[309.359749] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[309.498990] [054/134] (707s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[309.588025] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[309.590295] Starting dynamic subtest: pipe-A
[309.937233] Dynamic subtest pipe-A: SUCCESS (0.352s)
[309.946998] Starting dynamic subtest: pipe-B
[311.355105] Dynamic subtest pipe-B: SUCCESS (1.417s)
[311.366498] Starting dynamic subtest: pipe-C
[312.785595] Dynamic subtest pipe-C: SUCCESS (1.428s)
[312.793851] Starting dynamic subtest: pipe-D
[314.191953] Dynamic subtest pipe-D: SUCCESS (1.405s)
[314.194226] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.607s)
[315.370052] [055/134] (701s left) kms_atomic (test-only)
[315.466797] Starting subtest: test-only
[315.544615] Starting dynamic subtest: pipe-A-eDP-1
[318.107314] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.563s)
[318.109609] Subtest test-only: SUCCESS (2.641s)
[318.983845] [056/134] (698s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[319.092062] Starting subtest: psr-rgb101010-draw-mmap-gtt
[319.096876] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[319.213930] [057/134] (698s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[319.313562] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[319.317960] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[319.428418] [058/134] (697s left) gem_exercise_blt (fast-copy)
[319.502225] Starting subtest: fast-copy
[319.504386] Starting dynamic subtest: linear-smem-smem
[319.522834] Dynamic subtest linear-smem-smem: SUCCESS (0.023s)
[319.531408] Starting dynamic subtest: xmajor-smem-smem
[319.541767] Dynamic subtest xmajor-smem-smem: SUCCESS (0.018s)
[319.549950] Starting dynamic subtest: tile4-smem-smem
[319.558043] Dynamic subtest tile4-smem-smem: SUCCESS (0.016s)
[319.566150] Starting dynamic subtest: tile64-smem-smem
[319.576263] Dynamic subtest tile64-smem-smem: SUCCESS (0.018s)
[319.578550] Subtest fast-copy: SUCCESS (0.077s)
[319.715613] [059/134] (697s left) kms_cursor_crc (cursor-onscreen-128x128)
[319.904719] Starting subtest: cursor-onscreen-128x128
[319.906483] Starting dynamic subtest: pipe-A-eDP-1
[322.004618] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.098s)
[322.036441] Starting dynamic subtest: pipe-D-eDP-1
[324.759355] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.731s)
[324.761677] Subtest cursor-onscreen-128x128: SUCCESS (4.854s)
[325.651595] [060/134] (691s left) kms_addfb_basic (basic-y-tiled-legacy)
[325.728512] Starting subtest: basic-y-tiled-legacy
[325.732837] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[325.905489] [061/134] (691s left) gem_ctx_persistence (legacy-engines-hang)
[325.968835] Starting subtest: legacy-engines-hang
[325.971281] Starting dynamic subtest: render
[326.124036] Dynamic subtest render: SUCCESS (0.154s)
[326.138715] Starting dynamic subtest: bsd1
[326.249427] Dynamic subtest bsd1: SUCCESS (0.121s)
[326.264526] Starting dynamic subtest: bsd2
[326.358795] Dynamic subtest bsd2: SUCCESS (0.106s)
[326.370230] Starting dynamic subtest: blt
[326.439592] Dynamic subtest blt: SUCCESS (0.078s)
[326.452989] Starting dynamic subtest: vebox
[326.592577] Dynamic subtest vebox: SUCCESS (0.150s)
[326.594914] Subtest legacy-engines-hang: SUCCESS (0.625s)
[326.685750] [062/134] (690s left) vgem_basic (bad-fence)
[326.725545] Starting subtest: bad-fence
[326.727078] Subtest bad-fence: SUCCESS (0.000s)
[326.791950] [063/134] (690s left) kms_flip (blocking-wf_vblank)
[326.885797] Starting subtest: blocking-wf_vblank
[326.888024] Starting dynamic subtest: A-eDP1
[335.787304] Dynamic subtest A-eDP1: SUCCESS (8.899s)
[335.800618] Starting dynamic subtest: B-eDP1
[344.722918] Dynamic subtest B-eDP1: SUCCESS (8.933s)
[344.731648] Starting dynamic subtest: C-eDP1
[353.643490] Dynamic subtest C-eDP1: SUCCESS (8.919s)
[353.652323] Starting dynamic subtest: D-eDP1
[362.572764] Dynamic subtest D-eDP1: SUCCESS (8.928s)
[362.577578] Subtest blocking-wf_vblank: SUCCESS (35.690s)
[363.827471] [064/134] (653s left) gem_pxp (verify-pxp-stale-buf-execution)
[363.898127] Starting subtest: verify-pxp-stale-buf-execution
[364.959773] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.064s)
[365.118640] [065/134] (652s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[365.209996] Starting subtest: fbc-psr2-cursor-mmap-cpu
[365.212243] Starting dynamic subtest: eDP-1
[365.216437] Dynamic subtest eDP-1: SKIP (0.000s)
[365.220707] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.001s)
[365.303197] [066/134] (652s left) kms_colorop (plane-xr30-xr30-multiply_inv_125)
[365.435362] Subtest plane-XR30-XR30-multiply_inv_125: SKIP (0.000s)
[365.532455] [067/134] (652s left) kms_psr (psr2-sprite-mmap-gtt)
[365.628031] Starting subtest: psr2-sprite-mmap-gtt
[365.630205] Starting dynamic subtest: eDP-1
[367.096941] Dynamic subtest eDP-1: SKIP (1.466s)
[367.102219] Subtest psr2-sprite-mmap-gtt: SKIP (1.468s)
[367.279315] [068/134] (650s left) gem_lmem_swapping (verify-ccs)
[367.317792] Subtest verify-ccs: SKIP (0.000s)
[367.358231] [069/134] (650s left) api_intel_bb (reset-flags)
[367.409972] Starting subtest: reset-flags
[367.413986] Subtest reset-flags: SUCCESS (0.007s)
[367.569110] [070/134] (650s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[367.662108] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[367.664413] Starting dynamic subtest: pipe-A-default-mode
[368.795473] Dynamic subtest pipe-A-default-mode: SKIP (1.129s)
[368.799708] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.132s)
[368.973226] [071/134] (648s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[374.054073] Starting subtest: fbc-pr-primary-plane-update-sf-dmg-area
[374.058453] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.002s)
[374.917934] [072/134] (642s left) kms_flip (absolute-wf_vblank-interruptible)
[375.011039] Starting subtest: absolute-wf_vblank-interruptible
[375.013430] Starting dynamic subtest: A-eDP1
[383.765651] Dynamic subtest A-eDP1: SUCCESS (8.754s)
[383.777714] Starting dynamic subtest: B-eDP1
[392.491681] Dynamic subtest B-eDP1: SUCCESS (8.723s)
[392.502918] Starting dynamic subtest: C-eDP1
[401.211319] Dynamic subtest C-eDP1: SUCCESS (8.718s)
[401.223216] Starting dynamic subtest: D-eDP1
[409.938660] Dynamic subtest D-eDP1: SUCCESS (8.725s)
[409.943592] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.932s)
[411.194567] [073/134] (606s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[411.297415] Starting subtest: psr-shrfb-scaledprimary
[417.046439] Subtest psr-shrfb-scaledprimary: SUCCESS (5.754s)
[417.217966] [074/134] (600s left) kms_psr (psr-cursor-plane-move)
[417.321829] Starting subtest: psr-cursor-plane-move
[417.323978] Starting dynamic subtest: eDP-1
[419.059609] Dynamic subtest eDP-1: SUCCESS (1.737s)
[419.061549] Subtest psr-cursor-plane-move: SUCCESS (1.738s)
[419.932224] [075/134] (598s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[419.993595] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[420.087910] [076/134] (597s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[420.149553] Subtest basic-wc-gtt-noreloc: SKIP (0.000s)
[420.222374] [077/134] (597s left) kms_feature_discovery (psr1)
[420.316095] Starting subtest: psr1
[420.318395] Subtest psr1: SUCCESS (0.000s)
[420.401895] [078/134] (597s left) gem_render_copy (yf-tiled-ccs-to-y-tiled-ccs)
[420.465493] Starting subtest: yf-tiled-ccs-to-y-tiled-ccs
[420.470068] Subtest yf-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[420.660222] [079/134] (597s left) i915_pm_rps (waitboost)
[420.724022] Starting subtest: waitboost
[426.826895] Subtest waitboost: SUCCESS (6.102s)
[426.979873] [080/134] (591s left) gem_madvise (dontneed-after-mmap)
[427.015544] Starting subtest: dontneed-after-mmap
[427.044985] Subtest dontneed-after-mmap: SUCCESS (0.031s)
[427.186615] [081/134] (591s left) i915_pm_rpm (reg-read-ioctl)
[429.031974] Starting subtest: reg-read-ioctl
[431.318172] Subtest reg-read-ioctl: SUCCESS (2.290s)
[431.709066] [082/134] (586s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[431.813465] Starting subtest: x-tiled-16bpp-rotate-180
[433.167306] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.355s)
[433.291627] [083/134] (585s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[433.687712] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[434.506833] [084/134] (583s left) gem_exec_schedule (fairslice)
[434.583200] Starting subtest: fairslice
[434.585439] Starting dynamic subtest: rcs0
[436.595492] Dynamic subtest rcs0: SUCCESS (2.018s)
[436.603881] Starting dynamic subtest: bcs0
[438.615542] Dynamic subtest bcs0: SUCCESS (2.019s)
[438.624475] Starting dynamic subtest: vcs0
[440.642049] Dynamic subtest vcs0: SUCCESS (2.021s)
[440.650517] Starting dynamic subtest: vcs1
[442.657641] Dynamic subtest vcs1: SUCCESS (2.017s)
[442.665807] Starting dynamic subtest: vecs0
[444.680294] Dynamic subtest vecs0: SUCCESS (2.021s)
[444.690158] Starting dynamic subtest: ccs0
[446.705225] Dynamic subtest ccs0: SUCCESS (2.023s)
[446.707110] Subtest fairslice: SUCCESS (12.128s)
[447.015634] [085/134] (571s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[447.074617] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[447.076931] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[447.212474] [086/134] (571s left) gem_exec_whisper (basic-fds-forked-all)
[447.278745] Starting subtest: basic-fds-forked-all
[470.918869] Subtest basic-fds-forked-all: SUCCESS (23.635s)
[471.113337] [087/134] (547s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[471.206343] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[471.208672] Starting dynamic subtest: pipe-A-eDP-1
[471.231582] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[471.242144] Starting dynamic subtest: pipe-B-eDP-1
[471.263752] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[471.272618] Starting dynamic subtest: pipe-C-eDP-1
[471.294664] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[471.304422] Starting dynamic subtest: pipe-D-eDP-1
[471.327657] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[471.332270] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[473.406308] [088/134] (545s left) gem_basic (create-close)
[473.453444] Starting subtest: create-close
[473.457680] Subtest create-close: SUCCESS (0.000s)
[473.580427] [089/134] (545s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[473.687109] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc
[480.297416] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.621s)
[480.456760] [090/134] (538s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs-cc)
[480.552075] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs-cc
[480.553964] Starting dynamic subtest: pipe-A-eDP-1
[481.281368] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.722s)
[481.291418] Starting dynamic subtest: pipe-B-eDP-1
[483.058042] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.756s)
[483.067480] Starting dynamic subtest: pipe-C-eDP-1
[484.861693] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.822s)
[484.870968] Starting dynamic subtest: pipe-D-eDP-1
[486.686895] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.824s)
[486.688863] Subtest random-ccs-data-4-tiled-mtl-rc-ccs-cc: SUCCESS (6.129s)
[487.847987] [091/134] (530s left) gem_mmap_gtt (basic-small-bo-tiledx)
[487.904953] Subtest basic-small-bo-tiledX: SKIP (0.000s)
[487.970090] [092/134] (530s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[488.077248] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[489.078341] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.002s)
[489.225642] [093/134] (529s left) gem_mmap (short-mmap)
[489.284908] Subtest short-mmap: SKIP (0.000s)
[489.353076] [094/134] (529s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[489.452846] Starting subtest: y-tiled-16bpp-rotate-90
[489.456708] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[489.576580] [095/134] (529s left) gem_exec_fence (basic-busy-all)
[489.636898] Starting subtest: basic-busy-all
[489.701368] Subtest basic-busy-all: SUCCESS (0.065s)
[492.042301] [096/134] (526s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[492.137889] Starting subtest: crc-primary-suspend-yf-tiled-ccs
[492.140230] Starting dynamic subtest: pipe-A-eDP-1
[492.149238] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[492.158328] Starting dynamic subtest: pipe-B-eDP-1
[492.167107] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[492.175992] Starting dynamic subtest: pipe-C-eDP-1
[492.184169] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[492.192649] Starting dynamic subtest: pipe-D-eDP-1
[492.201061] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[492.205152] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.004s)
[494.389452] [097/134] (524s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[494.487242] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[501.258634] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.776s)
[501.380361] [098/134] (517s left) gem_exec_fence (submit-chain)
[501.546413] Starting subtest: submit-chain
[501.564789] Subtest submit-chain: SUCCESS (0.019s)
[503.042086] [099/134] (515s left) gem_mmap_gtt (basic-small-bo-tiledy)
[503.107695] Subtest basic-small-bo-tiledY: SKIP (0.000s)
[503.173739] [100/134] (515s left) kms_colorop (plane-xr24-xr24-srgb_eotf-srgb_inv_eotf-srgb_eotf)
[503.304603] Subtest plane-XR24-XR24-srgb_eotf-srgb_inv_eotf-srgb_eotf: SKIP (0.000s)
[503.400349] [101/134] (515s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[503.494500] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[503.498511] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[503.624267] [102/134] (515s left) gen9_exec_parse (unaligned-access)
[503.689770] Subtest unaligned-access: SKIP (0.000s)
[503.765421] [103/134] (515s left) kms_properties (get_properties-sanity-atomic)
[503.862638] Starting subtest: get_properties-sanity-atomic
[503.864824] Subtest get_properties-sanity-atomic: SUCCESS (0.002s)
[503.959114] [104/134] (515s left) i915_query (query-topology-matches-eu-total)
[504.019450] Starting subtest: query-topology-matches-eu-total
[504.021275] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[504.140521] [105/134] (515s left) gem_vm_create (isolation)
[504.199072] Starting subtest: isolation
[504.208137] Subtest isolation: SUCCESS (0.009s)
[504.356047] [106/134] (514s left) kms_vblank (wait-forked)
[504.444537] Starting subtest: wait-forked
[504.446484] Starting dynamic subtest: pipe-A-eDP-1
[506.243248] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.796s)
[506.263717] Starting dynamic subtest: pipe-D-eDP-1
[508.780137] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.537s)
[508.782655] Subtest wait-forked: SUCCESS (4.337s)
[509.657331] [107/134] (509s left) gem_mmap_gtt (fault-concurrent)
[509.704782] Subtest fault-concurrent: SKIP (0.000s)
[509.769845] [108/134] (509s left) syncobj_wait (invalid-reset-illegal-handle)
[509.825830] Starting subtest: invalid-reset-illegal-handle
[509.828188] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[509.952090] [109/134] (509s left) gem_exec_fence (basic-await)
[510.110117] Starting subtest: basic-await
[510.112836] Starting dynamic subtest: rcs0
[510.184105] Dynamic subtest rcs0: SUCCESS (0.074s)
[510.195832] Starting dynamic subtest: bcs0
[510.257254] Dynamic subtest bcs0: SUCCESS (0.072s)
[510.267273] Starting dynamic subtest: vcs0
[510.335242] Dynamic subtest vcs0: SUCCESS (0.076s)
[510.345889] Starting dynamic subtest: vcs1
[510.413214] Dynamic subtest vcs1: SUCCESS (0.075s)
[510.425366] Starting dynamic subtest: vecs0
[510.486522] Dynamic subtest vecs0: SUCCESS (0.071s)
[510.496924] Starting dynamic subtest: ccs0
[510.558420] Dynamic subtest ccs0: SUCCESS (0.070s)
[510.560876] Subtest basic-await: SUCCESS (0.450s)
[512.002354] [110/134] (507s left) gem_exec_flush (basic-wb-pro-default)
[512.057745] Starting subtest: basic-wb-pro-default
[517.517050] Subtest basic-wb-pro-default: SUCCESS (5.460s)
[517.713130] [111/134] (501s left) kms_cursor_crc (cursor-random-64x64)
[517.890241] Starting subtest: cursor-random-64x64
[517.894985] Starting dynamic subtest: pipe-A-eDP-1
[521.225426] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.331s)
[521.254810] Starting dynamic subtest: pipe-D-eDP-1
[525.258366] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.012s)
[525.260734] Subtest cursor-random-64x64: SUCCESS (7.368s)
[526.113036] [112/134] (493s left) api_intel_allocator (alloc-simple)
[526.170564] Starting subtest: alloc-simple
[526.172861] Subtest alloc-simple: SUCCESS (0.003s)
[526.328266] [113/134] (493s left) gem_exec_schedule (preempt-user)
[526.403979] Starting subtest: preempt-user
[526.406181] Starting dynamic subtest: rcs0
[526.423274] Dynamic subtest rcs0: SUCCESS (0.023s)
[526.432296] Starting dynamic subtest: bcs0
[526.440488] Dynamic subtest bcs0: SUCCESS (0.017s)
[526.449350] Starting dynamic subtest: vcs0
[526.462374] Dynamic subtest vcs0: SUCCESS (0.021s)
[526.471141] Starting dynamic subtest: vcs1
[526.482236] Dynamic subtest vcs1: SUCCESS (0.019s)
[526.491216] Starting dynamic subtest: vecs0
[526.504347] Dynamic subtest vecs0: SUCCESS (0.021s)
[526.516471] Starting dynamic subtest: ccs0
[526.525835] Dynamic subtest ccs0: SUCCESS (0.021s)
[526.528159] Subtest preempt-user: SUCCESS (0.127s)
[527.957217] [114/134] (491s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[528.061917] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[528.065810] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[528.184587] [115/134] (491s left) kms_plane (plane-panning-bottom-right)
[528.281734] Starting subtest: plane-panning-bottom-right
[528.284111] Starting dynamic subtest: pipe-A
[529.950729] Dynamic subtest pipe-A: SUCCESS (1.667s)
[529.961150] Starting dynamic subtest: pipe-B
[532.235322] Dynamic subtest pipe-B: SUCCESS (2.282s)
[532.237176] Subtest plane-panning-bottom-right: SUCCESS (3.952s)
[533.060060] [116/134] (486s left) drm_mm (drm_mm)
[533.093680] Starting subtest: drm_mm
[533.137401] Starting dynamic subtest: drm_test_mm_init
[533.246106] Dynamic subtest drm_test_mm_init: SUCCESS (0.110s)
[533.256159] Starting dynamic subtest: drm_test_mm_debug
[533.391065] Dynamic subtest drm_test_mm_debug: SUCCESS (0.144s)
[533.401040] Starting dynamic subtest: drm_test_mm_align32
[533.522871] Dynamic subtest drm_test_mm_align32: SUCCESS (0.130s)
[533.533894] Starting dynamic subtest: drm_test_mm_align64
[533.649247] Dynamic subtest drm_test_mm_align64: SUCCESS (0.126s)
[533.659314] Starting dynamic subtest: drm_test_mm_lowest
[533.802340] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.149s)
[533.812410] Starting dynamic subtest: drm_test_mm_highest
[533.914034] Dynamic subtest drm_test_mm_highest: SUCCESS (0.111s)
[533.916333] Subtest drm_mm: SUCCESS (0.820s)
[534.173379] [117/134] (485s left) gem_userptr_blits (coherency-sync)
[534.252056] Starting subtest: coherency-sync
[534.457649] Subtest coherency-sync: SKIP (0.170s)
[534.583970] [118/134] (485s left) gem_userptr_blits (access-control)
[534.696802] Starting subtest: access-control
[534.701531] Subtest access-control: SKIP (0.000s)
[534.844842] [119/134] (484s left) kms_colorop (plane-xr24-xr24-ctm_3x4_50_desat)
[534.986238] Subtest plane-XR24-XR24-ctm_3x4_50_desat: SKIP (0.000s)
[535.077471] [120/134] (484s left) kms_pm_rpm (fences)
[537.047780] Starting subtest: fences
[537.052621] Subtest fences: SKIP (0.000s)
[537.440916] [121/134] (482s left) gem_close_race (basic-process)
[537.504401] Starting subtest: basic-process
[537.583886] Subtest basic-process: SUCCESS (0.079s)
[537.778170] [122/134] (482s left) kms_vrr (flipline)
[537.876054] Starting subtest: flipline
[537.882681] Subtest flipline: SKIP (0.000s)
[537.966022] [123/134] (481s left) perf_pmu (busy)
[538.011956] Starting subtest: busy
[538.014226] Starting dynamic subtest: rcs0
[538.614282] Dynamic subtest rcs0: SUCCESS (0.604s)
[538.626031] Starting dynamic subtest: bcs0
[539.181707] Dynamic subtest bcs0: SUCCESS (0.565s)
[539.194016] Starting dynamic subtest: vcs0
[540.886248] Dynamic subtest vcs0: SUCCESS (1.700s)
[540.898680] Starting dynamic subtest: vcs1
[542.933574] Dynamic subtest vcs1: SUCCESS (2.044s)
[542.945855] Starting dynamic subtest: vecs0
[544.918088] Dynamic subtest vecs0: SUCCESS (1.982s)
[544.930191] Starting dynamic subtest: ccs0
[545.485576] Dynamic subtest ccs0: SUCCESS (0.565s)
[545.488082] Subtest busy: SUCCESS (7.477s)
[545.602719] [124/134] (474s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[545.706364] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[545.710628] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[545.809431] [125/134] (474s left) gem_render_linear_blits (basic)
[545.873501] Starting subtest: basic
[545.890480] Subtest basic: SUCCESS (0.020s)
[546.005404] [126/134] (474s left) kms_busy (extended-modeset-hang-newfb)
[546.092749] Starting subtest: extended-modeset-hang-newfb
[546.094824] Starting dynamic subtest: pipe-A
[581.764510] Dynamic subtest pipe-A: SUCCESS (35.671s)
[581.774283] Starting dynamic subtest: pipe-D
[604.792603] Dynamic subtest pipe-D: SUCCESS (23.025s)
[604.795038] Subtest extended-modeset-hang-newfb: SUCCESS (58.701s)
[605.603221] [127/134] (414s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[605.721404] Starting subtest: modeset-atomic-cursor-hotspot
[605.725959] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[605.880532] [128/134] (414s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[605.984490] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[612.691547] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (6.709s)
[612.841359] [129/134] (407s left) gem_flink_basic (basic)
[612.903070] Starting subtest: basic
[612.905228] Subtest basic: SUCCESS (0.000s)
[613.009733] [130/134] (407s left) syncobj_timeline (wait-all-snapshot)
[613.060645] Starting subtest: wait-all-snapshot
[613.141821] Subtest wait-all-snapshot: SUCCESS (0.081s)
[613.242693] [131/134] (406s left) kms_getfb (getfb2-handle-not-fb)
[613.328179] Starting subtest: getfb2-handle-not-fb
[613.330450] Subtest getfb2-handle-not-fb: SUCCESS (0.000s)
[613.457721] [132/134] (406s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[613.569504] Starting subtest: 4-tiled-8bpp-rotate-0
[614.816043] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.248s)
[614.976149] [133/134] (405s left) syncobj_timeline (etime-single-wait-submitted)
[615.035750] Starting subtest: etime-single-wait-submitted
[615.136320] Subtest etime-single-wait-submitted: SUCCESS (0.101s)
[615.236906] [134/134] (405s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[615.322148] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[622.155178] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.834s)
[622.314474] 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.