[59.420522] Initializing watchdogs
[59.420595]   /dev/watchdog0
[59.435526] [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.439948] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.442333] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.444043] [001/133] (960s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[59.546830] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[59.547678] Starting dynamic subtest: pipe-A-eDP-1
[59.550955] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[59.556068] Starting dynamic subtest: pipe-B-eDP-1
[59.559500] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[59.564761] Starting dynamic subtest: pipe-C-eDP-1
[59.568373] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[59.573520] Starting dynamic subtest: pipe-D-eDP-1
[59.577045] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[59.578775] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.003s)
[61.750854] [002/133] (958s left) i915_query (query-topology-known-pci-ids)
[61.805459] Starting subtest: query-topology-known-pci-ids
[61.807528] Subtest query-topology-known-pci-ids: SKIP (0.000s)
[61.921285] [003/133] (958s left) gem_spin_batch (resubmit-new)
[61.973313] Starting subtest: resubmit-new
[61.974318] Starting dynamic subtest: rcs0
[61.982367] Dynamic subtest rcs0: SUCCESS (0.008s)
[61.989281] Starting dynamic subtest: bcs0
[61.990090] Dynamic subtest bcs0: SUCCESS (0.003s)
[61.995440] Starting dynamic subtest: vcs0
[61.996320] Dynamic subtest vcs0: SUCCESS (0.004s)
[62.002045] Starting dynamic subtest: vcs1
[62.002926] Dynamic subtest vcs1: SUCCESS (0.005s)
[62.008775] Starting dynamic subtest: vecs0
[62.009668] Dynamic subtest vecs0: SUCCESS (0.004s)
[62.014802] Starting dynamic subtest: ccs0
[62.015832] Dynamic subtest ccs0: SUCCESS (0.004s)
[62.016742] Subtest resubmit-new: SUCCESS (0.031s)
[63.937375] [004/133] (956s left) kms_draw_crc (draw-method-render)
[64.027469] Starting subtest: draw-method-render
[64.028356] Starting dynamic subtest: xrgb8888-untiled
[64.294171] Dynamic subtest xrgb8888-untiled: SUCCESS (0.267s)
[64.301562] Starting dynamic subtest: rgb565-untiled
[64.527980] Dynamic subtest rgb565-untiled: SUCCESS (0.233s)
[64.534919] Starting dynamic subtest: xrgb2101010-untiled
[64.739235] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.210s)
[64.745380] Starting dynamic subtest: xbgr16161616f-untiled
[64.973041] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.233s)
[64.978798] Starting dynamic subtest: xrgb8888-xtiled
[65.095743] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s)
[65.102549] Starting dynamic subtest: rgb565-xtiled
[65.206769] Dynamic subtest rgb565-xtiled: SUCCESS (0.111s)
[65.212785] Starting dynamic subtest: xrgb2101010-xtiled
[65.306971] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.100s)
[65.313918] Starting dynamic subtest: xbgr16161616f-xtiled
[65.440965] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[65.449211] Starting dynamic subtest: xrgb8888-4tiled
[65.563238] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.122s)
[65.571505] Starting dynamic subtest: rgb565-4tiled
[65.685472] Dynamic subtest rgb565-4tiled: SUCCESS (0.122s)
[65.692929] Starting dynamic subtest: xrgb2101010-4tiled
[65.808119] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.122s)
[65.814774] Starting dynamic subtest: xbgr16161616f-4tiled
[65.952785] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.144s)
[65.953876] Subtest draw-method-render: SUCCESS (1.923s)
[66.083929] [005/133] (953s left) gem_exec_schedule (noreorder)
[66.265270] Starting subtest: noreorder
[66.266454] Starting dynamic subtest: rcs0
[66.299521] Dynamic subtest rcs0: SUCCESS (0.040s)
[66.307857] Starting dynamic subtest: vcs0
[67.987454] Dynamic subtest vcs0: SUCCESS (1.677s)
[67.994919] Starting dynamic subtest: vcs1
[69.943254] Dynamic subtest vcs1: SUCCESS (1.953s)
[69.954622] Starting dynamic subtest: vecs0
[71.897234] Dynamic subtest vecs0: SUCCESS (1.951s)
[71.905037] Starting dynamic subtest: ccs0
[71.983457] Dynamic subtest ccs0: SUCCESS (0.094s)
[71.984701] Subtest noreorder: SUCCESS (5.718s)
[72.171093] [006/133] (947s left) gem_ctx_shared (disjoint-timelines)
[72.231342] Starting subtest: disjoint-timelines
[72.278569] Subtest disjoint-timelines: SUCCESS (0.047s)
[72.537062] [FACT gem_ctx_shared (disjoint-timelines)] new: kernel.kmod_is_loaded.vgem: true
[72.538615] [007/133] (947s left) gem_tiled_wb
[72.661806] [008/133] (947s left) gem_partial_pwrite_pread (write-snoop)
[72.726338] Subtest write-snoop: SKIP (0.000s)
[72.798339] [009/133] (947s left) api_intel_allocator (fork-simple-stress-signal)
[72.851848] Starting subtest: fork-simple-stress-signal
[78.273682] Subtest fork-simple-stress-signal: SUCCESS (5.410s)
[78.404966] [010/133] (941s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[78.466979] Starting subtest: invalid-multi-wait-unsubmitted
[78.467947] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[78.597961] [011/133] (941s left) gem_exec_gttfill (multigpu-basic)
[78.770670] Starting subtest: multigpu-basic
[93.006916] Subtest multigpu-basic: SUCCESS (14.229s)
[93.050540] [012/133] (927s left) gem_fence_thrash (bo-write-verify-threaded-y)
[93.121719] Starting subtest: bo-write-verify-threaded-y
[93.151039] Subtest bo-write-verify-threaded-y: SKIP (0.028s)
[93.220734] [013/133] (927s left) kms_pm_dc (dc3co-vpb-simulation)
[94.348772] Starting subtest: dc3co-vpb-simulation
[103.093120] Subtest dc3co-vpb-simulation: SKIP (8.731s)
[103.199545] [014/133] (917s left) i915_drm_fdinfo (busy-idle-check-all)
[103.234899] Starting subtest: busy-idle-check-all
[103.235807] Starting dynamic subtest: rcs0
[103.240100] Dynamic subtest rcs0: SKIP (0.005s)
[103.247138] Starting dynamic subtest: bcs0
[103.248697] Dynamic subtest bcs0: SKIP (0.000s)
[103.258556] Starting dynamic subtest: vcs0
[103.260458] Dynamic subtest vcs0: SKIP (0.000s)
[103.268107] Starting dynamic subtest: vcs1
[103.269646] Dynamic subtest vcs1: SKIP (0.000s)
[103.278384] Starting dynamic subtest: vecs0
[103.279939] Dynamic subtest vecs0: SKIP (0.000s)
[103.285857] Starting dynamic subtest: ccs0
[103.287794] Dynamic subtest ccs0: SKIP (0.000s)
[103.289525] Subtest busy-idle-check-all: SKIP (0.008s)
[103.319227] [015/133] (917s left) kms_psr (pr-cursor-plane-move)
[103.451090] Starting subtest: pr-cursor-plane-move
[103.452719] Subtest pr-cursor-plane-move: SKIP (0.000s)
[103.525029] [016/133] (916s left) perf_pmu (idle-no-semaphores)
[103.561816] Starting subtest: idle-no-semaphores
[103.562700] Starting dynamic subtest: rcs0
[104.128728] Dynamic subtest rcs0: SUCCESS (0.557s)
[104.137995] Starting dynamic subtest: bcs0
[104.646956] Dynamic subtest bcs0: SUCCESS (0.517s)
[104.656503] Starting dynamic subtest: vcs0
[105.164988] Dynamic subtest vcs0: SUCCESS (0.516s)
[105.174623] Starting dynamic subtest: vcs1
[105.681893] Dynamic subtest vcs1: SUCCESS (0.516s)
[105.691152] Starting dynamic subtest: vecs0
[106.199956] Dynamic subtest vecs0: SUCCESS (0.517s)
[106.209216] Starting dynamic subtest: ccs0
[106.718428] Dynamic subtest ccs0: SUCCESS (0.517s)
[106.719513] Subtest idle-no-semaphores: SUCCESS (3.148s)
[106.835517] [017/133] (913s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[106.977996] Starting subtest: basic-busy-flip-before-cursor-varying-size
[106.980009] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[107.147198] [018/133] (913s left) syncobj_timeline (invalid-signal-zero-handles)
[107.202455] Starting subtest: invalid-signal-zero-handles
[107.203508] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[107.321235] [019/133] (913s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[107.424122] Starting subtest: fb-8bpc-vs-panel-8bpc
[107.425295] Starting dynamic subtest: pipe-A-eDP-1
[108.834984] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.410s)
[108.835930] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.411s)
[109.636402] [020/133] (910s left) gem_mmap_offset (basic-uaf)
[109.688327] Starting subtest: basic-uaf
[109.689359] Subtest basic-uaf: SUCCESS (0.001s)
[109.815182] [021/133] (910s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[109.909888] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[109.911678] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[110.028240] [022/133] (910s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[110.083070] Starting subtest: multi-wait-all-for-submit-signaled
[110.084015] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[110.198738] [023/133] (910s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[110.244903] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[110.352957] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.107s)
[110.433095] [024/133] (910s left) gem_eio (in-flight-internal-10ms)
[110.664730] Starting subtest: in-flight-internal-10ms
[111.969304] Subtest in-flight-internal-10ms: SUCCESS (1.305s)
[112.121481] [025/133] (908s left) gem_userptr_blits (map-fixed-invalidate-busy)
[112.188528] Starting subtest: map-fixed-invalidate-busy
[112.190396] Subtest map-fixed-invalidate-busy: SKIP (0.000s)
[112.329031] [026/133] (908s left) perf_pmu (busy)
[112.357673] Starting subtest: busy
[112.358639] Starting dynamic subtest: rcs0
[112.975606] Dynamic subtest rcs0: SUCCESS (0.617s)
[112.985598] Starting dynamic subtest: bcs0
[113.547526] Dynamic subtest bcs0: SUCCESS (0.571s)
[113.557043] Starting dynamic subtest: vcs0
[114.910924] Dynamic subtest vcs0: SUCCESS (1.351s)
[114.921043] Starting dynamic subtest: vcs1
[116.894711] Dynamic subtest vcs1: SUCCESS (1.983s)
[116.904559] Starting dynamic subtest: vecs0
[118.943219] Dynamic subtest vecs0: SUCCESS (2.046s)
[118.953490] Starting dynamic subtest: ccs0
[119.504839] Dynamic subtest ccs0: SUCCESS (0.571s)
[119.505901] Subtest busy: SUCCESS (7.146s)
[119.621349] [027/133] (901s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[119.719891] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[119.741731] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.022s)
[119.837317] [028/133] (900s left) gem_exec_fence (expired-history)
[120.261848] Starting subtest: expired-history
[127.622804] Subtest expired-history: SUCCESS (7.351s)
[128.205426] [029/133] (892s left) gem_exec_params (batch-first)
[128.265721] Starting subtest: batch-first
[128.274561] Subtest batch-first: SUCCESS (0.009s)
[128.421699] [030/133] (892s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[128.528834] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[128.539669] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.011s)
[128.662792] [031/133] (892s left) gem_exec_balancer (hang)
[128.934176] Starting subtest: hang
[130.936669] Subtest hang: SUCCESS (2.002s)
[131.070519] [032/133] (889s left) kms_cursor_crc (cursor-onscreen-256x256)
[131.309246] Starting subtest: cursor-onscreen-256x256
[131.313140] Starting dynamic subtest: pipe-A-eDP-1
[133.440318] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.127s)
[133.468976] Starting dynamic subtest: pipe-D-eDP-1
[136.202190] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.739s)
[136.203076] Subtest cursor-onscreen-256x256: SUCCESS (4.892s)
[137.018878] [033/133] (883s left) gem_userptr_blits (vma-merge)
[137.084446] Starting subtest: vma-merge
[137.123153] Subtest vma-merge: SUCCESS (0.039s)
[137.268687] [034/133] (883s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[137.360046] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[145.051299] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.692s)
[145.212465] [035/133] (875s left) gem_ctx_isolation (nonpriv)
[145.279329] Starting subtest: nonpriv
[145.280290] Starting dynamic subtest: rcs0
[145.529302] Dynamic subtest rcs0: SUCCESS (0.251s)
[145.537298] Starting dynamic subtest: bcs0
[145.821058] Dynamic subtest bcs0: SUCCESS (0.291s)
[145.837460] Starting dynamic subtest: vcs0
[146.107979] Dynamic subtest vcs0: SUCCESS (0.287s)
[146.115548] Starting dynamic subtest: vcs1
[148.118344] Dynamic subtest vcs1: SUCCESS (2.010s)
[148.127168] Starting dynamic subtest: vecs0
[150.182133] Dynamic subtest vecs0: SUCCESS (2.064s)
[150.191649] Starting dynamic subtest: ccs0
[152.188962] Dynamic subtest ccs0: SUCCESS (2.007s)
[152.189997] Subtest nonpriv: SUCCESS (6.913s)
[152.451958] [036/133] (868s left) gem_mmap_gtt (cpuset-medium-copy)
[152.512246] Subtest cpuset-medium-copy: SKIP (0.000s)
[152.575450] [037/133] (868s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[152.677861] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[152.679601] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[152.814815] [038/133] (868s left) gem_exec_schedule (preempt-user)
[152.879525] Starting subtest: preempt-user
[152.880482] Starting dynamic subtest: rcs0
[152.902171] Dynamic subtest rcs0: SUCCESS (0.022s)
[152.911756] Starting dynamic subtest: bcs0
[152.920124] Dynamic subtest bcs0: SUCCESS (0.018s)
[152.927209] Starting dynamic subtest: vcs0
[152.938998] Dynamic subtest vcs0: SUCCESS (0.018s)
[152.946580] Starting dynamic subtest: vcs1
[152.962798] Dynamic subtest vcs1: SUCCESS (0.023s)
[152.970425] Starting dynamic subtest: vecs0
[152.982467] Dynamic subtest vecs0: SUCCESS (0.019s)
[152.989464] Starting dynamic subtest: ccs0
[153.004453] Dynamic subtest ccs0: SUCCESS (0.022s)
[153.005283] Subtest preempt-user: SUCCESS (0.125s)
[155.022089] [039/133] (866s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[155.109539] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[155.111232] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[155.245451] [040/133] (865s left) kms_invalid_mode (bad-vsync-end)
[155.330830] Starting subtest: bad-vsync-end
[155.331767] Starting dynamic subtest: pipe-A-eDP-1
[155.617144] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[155.625047] Starting dynamic subtest: pipe-B-eDP-1
[155.625950] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[155.633100] Starting dynamic subtest: pipe-C-eDP-1
[155.633956] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[155.641306] Starting dynamic subtest: pipe-D-eDP-1
[155.642350] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[155.643358] Subtest bad-vsync-end: SUCCESS (0.291s)
[156.464973] [041/133] (864s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[156.555253] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[156.557023] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.000s)
[156.633425] [042/133] (864s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[156.693249] Starting subtest: multi-wait-all-for-submit-submitted
[156.800313] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.106s)
[156.881843] [043/133] (864s left) core_getversion (all-cards)
[156.916545] Starting subtest: all-cards
[156.926041] Subtest all-cards: SUCCESS (0.011s)
[156.970241] [044/133] (864s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[157.058460] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb
[157.059353] Starting dynamic subtest: pipe-A-eDP-1
[163.984704] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.927s)
[163.992602] Starting dynamic subtest: pipe-B-eDP-1
[171.099272] Dynamic subtest pipe-B-eDP-1: SUCCESS (7.115s)
[171.100153] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (14.044s)
[171.967646] [045/133] (849s left) kms_vblank (invalid)
[172.068503] Starting subtest: invalid
[172.069404] Starting dynamic subtest: pipe-A-eDP-1
[172.464298] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.396s)
[172.465194] Subtest invalid: SUCCESS (0.397s)
[173.295914] [046/133] (848s left) gem_exec_schedule (u-submit-golden-slice)
[173.357673] Starting subtest: u-submit-golden-slice
[173.358603] Starting dynamic subtest: rcs0
[173.391215] Dynamic subtest rcs0: SUCCESS (0.033s)
[173.401066] Starting dynamic subtest: bcs0
[173.425050] Dynamic subtest bcs0: SUCCESS (0.034s)
[173.433454] Starting dynamic subtest: vcs0
[173.454055] Dynamic subtest vcs0: SUCCESS (0.029s)
[173.461858] Starting dynamic subtest: vcs1
[173.484162] Dynamic subtest vcs1: SUCCESS (0.029s)
[173.491678] Starting dynamic subtest: vecs0
[173.518559] Dynamic subtest vecs0: SUCCESS (0.034s)
[173.525708] Starting dynamic subtest: ccs0
[173.556821] Dynamic subtest ccs0: SUCCESS (0.037s)
[173.557829] Subtest u-submit-golden-slice: SUCCESS (0.199s)
[175.053219] [047/133] (846s left) i915_suspend (fence-restore-untiled)
[175.117965] Starting subtest: fence-restore-untiled
[175.119805] Subtest fence-restore-untiled: SKIP (0.000s)
[175.241161] [048/133] (846s left) kms_flip (modeset-vs-vblank-race)
[175.329266] Starting subtest: modeset-vs-vblank-race
[175.330119] Starting dynamic subtest: A-eDP1
[180.029525] Dynamic subtest A-eDP1: SUCCESS (4.699s)
[180.041050] Starting dynamic subtest: B-eDP1
[184.775758] Dynamic subtest B-eDP1: SUCCESS (4.745s)
[184.786291] Starting dynamic subtest: C-eDP1
[189.393381] Dynamic subtest C-eDP1: SUCCESS (4.616s)
[189.404461] Starting dynamic subtest: D-eDP1
[194.040185] Dynamic subtest D-eDP1: SUCCESS (4.645s)
[194.043730] Subtest modeset-vs-vblank-race: SUCCESS (18.716s)
[195.209740] [049/133] (826s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[195.316630] Starting subtest: yf-tiled-64bpp-rotate-180
[195.318451] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[195.414360] [050/133] (826s left) fbdev (pan)
[195.448767] Starting subtest: pan
[195.481220] Subtest pan: SUCCESS (0.033s)
[195.573058] [051/133] (825s left) gem_eio (in-flight-contexts-immediate)
[195.801952] Starting subtest: in-flight-contexts-immediate
[209.887492] Subtest in-flight-contexts-immediate: SUCCESS (14.088s)
[210.066744] [052/133] (811s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[210.156356] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[216.887864] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.733s)
[217.067202] [053/133] (804s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[217.167189] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[217.168025] Starting dynamic subtest: pipe-A
[217.516547] Dynamic subtest pipe-A: SUCCESS (0.350s)
[217.524592] Starting dynamic subtest: pipe-B
[218.954522] Dynamic subtest pipe-B: SUCCESS (1.437s)
[218.968187] Starting dynamic subtest: pipe-C
[220.380796] Dynamic subtest pipe-C: SUCCESS (1.424s)
[220.388664] Starting dynamic subtest: pipe-D
[221.822152] Dynamic subtest pipe-D: SUCCESS (1.441s)
[221.823027] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.656s)
[222.999936] [054/133] (798s left) prime_mmap_coherency (write)
[223.067028] Starting subtest: write
[228.487991] Subtest write: SUCCESS (5.375s)
[228.623345] [055/133] (793s left) gem_exec_reloc (basic-write-read-noreloc)
[228.692535] Subtest basic-write-read-noreloc: SKIP (0.000s)
[228.780167] [056/133] (792s left) kms_psr (fbc-psr-no-drrs)
[228.888199] Starting subtest: fbc-psr-no-drrs
[228.889054] Starting dynamic subtest: eDP-1
[228.890596] Dynamic subtest eDP-1: SKIP (0.000s)
[228.892215] Subtest fbc-psr-no-drrs: SKIP (0.001s)
[228.976810] [057/133] (792s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[229.101809] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[230.099137] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.998s)
[230.231856] [058/133] (791s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[230.336605] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf
[230.338411] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[230.447429] [059/133] (791s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[230.509966] Subtest writes-after-reads-uncached: SKIP (0.000s)
[230.583631] [060/133] (791s left) kms_lease (possible-crtcs-filtering)
[230.684744] Starting subtest: possible-crtcs-filtering
[230.689180] Subtest possible-crtcs-filtering: SUCCESS (0.005s)
[230.813605] [061/133] (791s left) gem_exec_reloc (basic-wc-noreloc)
[230.868729] Subtest basic-wc-noreloc: SKIP (0.000s)
[230.943969] [062/133] (791s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[231.033605] Starting subtest: plane-upscale-factor-0-25-with-rotation
[231.034475] Starting dynamic subtest: pipe-A
[231.270609] Dynamic subtest pipe-A: SUCCESS (0.238s)
[231.279664] Starting dynamic subtest: pipe-B
[232.563806] Dynamic subtest pipe-B: SUCCESS (1.291s)
[232.571846] Starting dynamic subtest: pipe-C
[233.892828] Dynamic subtest pipe-C: SUCCESS (1.328s)
[233.904556] Starting dynamic subtest: pipe-D
[235.225788] Dynamic subtest pipe-D: SUCCESS (1.332s)
[235.226659] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.194s)
[236.422597] [063/133] (785s left) gem_exec_fence (submit-chain)
[236.622103] Starting subtest: submit-chain
[236.637809] Subtest submit-chain: SUCCESS (0.018s)
[238.028099] [064/133] (784s left) i915_pm_rps (engine-order)
[238.085958] Starting subtest: engine-order
[244.459715] Subtest engine-order: SUCCESS (6.367s)
[244.611324] [065/133] (777s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[244.713344] Starting subtest: basic-max-pipe-crc-check
[244.714946] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[244.754782] [066/133] (777s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[244.807300] Starting subtest: single-wait-all-for-submit-available-signaled
[244.808223] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[244.926022] [067/133] (777s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[245.022383] Starting subtest: bad-aux-stride-y-tiled-ccs
[245.023284] Starting dynamic subtest: pipe-A-eDP-1
[245.031522] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[245.039544] Starting dynamic subtest: pipe-B-eDP-1
[245.047799] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[245.055354] Starting dynamic subtest: pipe-C-eDP-1
[245.063036] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[245.070352] Starting dynamic subtest: pipe-D-eDP-1
[245.078222] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[245.079927] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.005s)
[247.308720] [068/133] (774s left) prime_vgem (basic-fence-flip)
[247.393144] Starting subtest: basic-fence-flip
[247.684541] Subtest basic-fence-flip: SUCCESS (0.291s)
[247.807343] [069/133] (774s left) gen7_exec_parse (oacontrol-tracking)
[247.862168] Subtest oacontrol-tracking: SKIP (0.000s)
[247.937459] [070/133] (774s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[248.028584] Starting subtest: crc-primary-basic-y-tiled-ccs
[248.029465] Starting dynamic subtest: pipe-A-eDP-1
[248.037897] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[248.045685] Starting dynamic subtest: pipe-B-eDP-1
[248.054705] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[248.064082] Starting dynamic subtest: pipe-C-eDP-1
[248.072220] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[248.079455] Starting dynamic subtest: pipe-D-eDP-1
[248.087677] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[248.089325] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.006s)
[250.362738] [071/133] (771s left) kms_psr (psr2-cursor-mmap-gtt)
[250.449575] Starting subtest: psr2-cursor-mmap-gtt
[250.450535] Starting dynamic subtest: eDP-1
[252.125251] Dynamic subtest eDP-1: SUCCESS (1.674s)
[252.126156] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.675s)
[252.941945] [072/133] (769s left) api_intel_bb (lot-of-buffers)
[252.997478] Starting subtest: lot-of-buffers
[254.140700] Subtest lot-of-buffers: SUCCESS (1.134s)
[254.644733] [073/133] (767s left) kms_chamelium_hpd (common-hpd-after-suspend)
[255.033255] Subtest common-hpd-after-suspend: SKIP (0.000s)
[255.832915] [074/133] (766s left) syncobj_eventfd (binary-wait)
[255.886822] Starting subtest: binary-wait
[255.896502] Subtest binary-wait: SUCCESS (0.010s)
[255.998778] [075/133] (766s left) kms_psr (psr-primary-blt)
[256.085635] Starting subtest: psr-primary-blt
[256.086748] Starting dynamic subtest: eDP-1
[257.859558] Dynamic subtest eDP-1: SUCCESS (1.775s)
[257.860431] Subtest psr-primary-blt: SUCCESS (1.776s)
[258.722605] [076/133] (763s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[258.817714] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[258.819555] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[258.947013] [077/133] (763s left) gem_ctx_persistence (legacy-engines-hang)
[259.013115] Starting subtest: legacy-engines-hang
[259.013954] Starting dynamic subtest: render
[259.120673] Dynamic subtest render: SUCCESS (0.106s)
[259.133263] Starting dynamic subtest: bsd1
[259.198187] Dynamic subtest bsd1: SUCCESS (0.075s)
[259.208561] Starting dynamic subtest: bsd2
[259.363770] Dynamic subtest bsd2: SUCCESS (0.162s)
[259.375734] Starting dynamic subtest: blt
[259.493726] Dynamic subtest blt: SUCCESS (0.127s)
[259.505326] Starting dynamic subtest: vebox
[259.614559] Dynamic subtest vebox: SUCCESS (0.117s)
[259.616021] Subtest legacy-engines-hang: SUCCESS (0.602s)
[259.702133] [078/133] (762s left) kms_atomic (atomic-plane-damage)
[259.801385] Starting subtest: atomic-plane-damage
[259.850888] Starting dynamic subtest: pipe-A-eDP-1
[260.412879] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.564s)
[260.413824] Subtest atomic-plane-damage: SUCCESS (0.612s)
[261.265647] [079/133] (761s left) sysfs_timeslice_duration (idempotent)
[261.322660] Starting subtest: idempotent
[261.323666] Starting dynamic subtest: vecs0
[261.324614] Dynamic subtest vecs0: SUCCESS (0.001s)
[261.333972] Starting dynamic subtest: ccs0
[261.334955] Dynamic subtest ccs0: SUCCESS (0.000s)
[261.344104] Starting dynamic subtest: vcs0
[261.344852] Dynamic subtest vcs0: SUCCESS (0.001s)
[261.352058] Starting dynamic subtest: bcs0
[261.352819] Dynamic subtest bcs0: SUCCESS (0.000s)
[261.360040] Starting dynamic subtest: rcs0
[261.360855] Dynamic subtest rcs0: SUCCESS (0.000s)
[261.367904] Starting dynamic subtest: vcs1
[261.368742] Dynamic subtest vcs1: SUCCESS (0.000s)
[261.369625] Subtest idempotent: SUCCESS (0.010s)
[261.477641] [080/133] (761s left) kms_fence_pin_leak
[261.670056] [081/133] (760s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[261.768261] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[265.496032] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.728s)
[266.661483] [082/133] (755s left) gem_exec_params (rel-constants-invalid-ring)
[266.727222] Starting subtest: rel-constants-invalid-ring
[266.728114] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[266.859806] [083/133] (755s left) kms_color (ctm-0-75)
[266.949468] Starting subtest: ctm-0-75
[266.950378] Starting dynamic subtest: pipe-A-eDP-1
[271.791361] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.841s)
[271.799194] Starting dynamic subtest: pipe-B-eDP-1
[277.444509] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.652s)
[277.452389] Starting dynamic subtest: pipe-C-eDP-1
[282.826182] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.380s)
[282.833992] Starting dynamic subtest: pipe-D-eDP-1
[288.132303] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.303s)
[288.133370] Subtest ctm-0-75: SUCCESS (21.181s)
[288.956223] [084/133] (733s left) i915_query (query-topology-unsupported)
[289.017200] Starting subtest: query-topology-unsupported
[289.018976] Subtest query-topology-unsupported: SKIP (0.000s)
[289.151215] [085/133] (733s left) i915_hangman (engine-error-state-capture)
[289.209907] Starting subtest: engine-error-state-capture
[289.210858] Starting dynamic subtest: rcs0
[292.859611] Dynamic subtest rcs0: SUCCESS (3.639s)
[292.870035] Starting dynamic subtest: bcs0
[298.874617] Dynamic subtest bcs0: SUCCESS (6.012s)
[298.884819] Starting dynamic subtest: vcs0
[304.827423] Dynamic subtest vcs0: SUCCESS (5.950s)
[304.837325] Starting dynamic subtest: vcs1
[309.883560] Dynamic subtest vcs1: SUCCESS (5.053s)
[309.892938] Starting dynamic subtest: vecs0
[315.835372] Dynamic subtest vecs0: SUCCESS (5.948s)
[315.845991] Starting dynamic subtest: ccs0
[320.892206] Dynamic subtest ccs0: SUCCESS (5.053s)
[320.893736] Subtest engine-error-state-capture: SUCCESS (31.671s)
[321.040621] [086/133] (701s left) gem_pread (self)
[321.101799] Subtest self: SKIP (0.000s)
[321.153406] [087/133] (701s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[321.246613] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[321.247621] Starting dynamic subtest: pipe-A-eDP-1
[321.335220] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s)
[321.344087] Starting dynamic subtest: pipe-B-eDP-1
[322.521748] Dynamic subtest pipe-B-eDP-1: SKIP (1.185s)
[322.523533] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.276s)
[323.825228] [088/133] (699s left) syncobj_wait (invalid-wait-illegal-handle)
[323.880996] Starting subtest: invalid-wait-illegal-handle
[323.882042] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[323.994340] [089/133] (698s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[324.092900] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[324.094687] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[324.233986] [090/133] (698s left) gem_userptr_blits (create-destroy-sync)
[324.283759] Starting subtest: create-destroy-sync
[329.339772] Subtest create-destroy-sync: SUCCESS (5.010s)
[329.441918] [091/133] (693s left) kms_addfb_basic (unused-modifier)
[329.495968] Starting subtest: unused-modifier
[329.496922] Subtest unused-modifier: SUCCESS (0.000s)
[329.646082] [092/133] (693s left) kms_properties (connector-properties-atomic)
[329.746072] Starting subtest: connector-properties-atomic
[329.748234] Starting dynamic subtest: pipe-A-eDP-1
[337.584399] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.835s)
[337.592035] Starting dynamic subtest: pipe-None-DP-1
[337.593887] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[337.601197] Starting dynamic subtest: pipe-None-HDMI-A-1
[337.602899] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[337.610033] Starting dynamic subtest: pipe-None-DP-2
[337.611969] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[337.619231] Starting dynamic subtest: pipe-None-HDMI-A-2
[337.621035] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[337.628247] Starting dynamic subtest: pipe-None-DP-3
[337.629882] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[337.637065] Starting dynamic subtest: pipe-None-DP-4
[337.638915] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[337.639820] Subtest connector-properties-atomic: SUCCESS (7.847s)
[338.463380] [093/133] (684s left) kms_vblank (wait-forked)
[338.562398] Starting subtest: wait-forked
[338.563302] Starting dynamic subtest: pipe-A-eDP-1
[340.370827] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.807s)
[340.380044] Starting dynamic subtest: pipe-D-eDP-1
[342.852449] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.479s)
[342.853308] Subtest wait-forked: SUCCESS (4.291s)
[343.722405] [094/133] (679s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[343.814087] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[343.815635] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[343.931863] [095/133] (679s left) kms_content_protection (dp-mst-type-1)
[344.076226] Starting subtest: dp-mst-type-1
[344.077918] Subtest dp-mst-type-1: SKIP (0.000s)
[344.217304] [096/133] (678s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[344.323193] Starting subtest: primary-x-tiled-reflect-x-0
[351.511341] Subtest primary-x-tiled-reflect-x-0: SUCCESS (7.188s)
[352.783156] [097/133] (670s left) kms_big_fb (linear-32bpp-rotate-180)
[352.883849] Starting subtest: linear-32bpp-rotate-180
[354.452244] Subtest linear-32bpp-rotate-180: SUCCESS (1.567s)
[354.614431] [098/133] (668s left) gem_exercise_blt (fast-copy-emit)
[354.684205] Starting subtest: fast-copy-emit
[354.685117] Starting dynamic subtest: linear-smem-smem-emit
[354.710501] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.026s)
[354.721623] Starting dynamic subtest: xmajor-smem-smem-emit
[354.728448] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.016s)
[354.735783] Starting dynamic subtest: tile4-smem-smem-emit
[354.745671] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.017s)
[354.752857] Starting dynamic subtest: tile64-smem-smem-emit
[354.763709] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.017s)
[354.764783] Subtest fast-copy-emit: SUCCESS (0.080s)
[354.915828] [099/133] (668s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[355.009298] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[355.011087] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[355.119509] [100/133] (668s left) kms_plane (pixel-format-yf-tiled-ccs-modifier)
[355.214159] Starting subtest: pixel-format-yf-tiled-ccs-modifier
[355.219239] Subtest pixel-format-yf-tiled-ccs-modifier: SKIP (0.000s)
[355.308678] [101/133] (667s left) kms_psr (fbc-psr2-dpms)
[355.400276] Starting subtest: fbc-psr2-dpms
[355.401119] Starting dynamic subtest: eDP-1
[355.402677] Dynamic subtest eDP-1: SKIP (0.000s)
[355.404300] Subtest fbc-psr2-dpms: SKIP (0.001s)
[355.483041] [102/133] (667s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[355.576519] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[355.577435] Starting dynamic subtest: pipe-A-eDP-1
[355.838184] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.250s)
[355.846153] Starting dynamic subtest: pipe-B-eDP-1
[357.134755] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.295s)
[357.142894] Starting dynamic subtest: pipe-C-eDP-1
[358.355928] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.221s)
[358.363964] Starting dynamic subtest: pipe-D-eDP-1
[359.579768] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.222s)
[359.580603] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (3.993s)
[360.808918] [103/133] (662s left) perf (i915-ref-count)
[360.898020] Starting subtest: i915-ref-count
[360.955372] Subtest i915-ref-count: SUCCESS (0.059s)
[361.009794] [104/133] (662s left) gem_exec_reloc (basic-wc-cpu-active)
[361.072400] Subtest basic-wc-cpu-active: SKIP (0.000s)
[361.158503] [105/133] (662s left) kms_hdr (invalid-metadata-sizes)
[361.252859] Starting subtest: invalid-metadata-sizes
[361.255397] Subtest invalid-metadata-sizes: SKIP (0.000s)
[361.346844] [106/133] (662s left) vgem_basic (mmap)
[361.388439] Starting subtest: mmap
[361.417216] Subtest mmap: SUCCESS (0.029s)
[361.478885] [107/133] (662s left) kms_busy (extended-modeset-hang-oldfb)
[361.576760] Starting subtest: extended-modeset-hang-oldfb
[361.577778] Starting dynamic subtest: pipe-A
[373.442808] Dynamic subtest pipe-A: SUCCESS (11.864s)
[373.453185] Starting dynamic subtest: pipe-D
[386.017503] Dynamic subtest pipe-D: SUCCESS (12.571s)
[386.018447] Subtest extended-modeset-hang-oldfb: SUCCESS (24.439s)
[386.825337] [108/133] (636s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[386.929347] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[386.930894] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[387.086464] [109/133] (636s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[387.187496] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[387.189111] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[387.275812] [110/133] (636s left) gem_exec_reloc (basic-gtt-active)
[387.342457] Subtest basic-gtt-active: SKIP (0.000s)
[387.424064] [111/133] (636s left) gem_mmap (short-mmap)
[387.483058] Subtest short-mmap: SKIP (0.000s)
[387.553820] [112/133] (636s left) kms_plane_cursor (primary)
[387.651574] Starting subtest: primary
[387.653351] Starting dynamic subtest: pipe-A-eDP-1-size-64
[390.225057] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.574s)
[390.251455] Starting dynamic subtest: pipe-A-eDP-1-size-128
[392.793328] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.550s)
[392.820187] Starting dynamic subtest: pipe-A-eDP-1-size-256
[395.383474] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.571s)
[395.717594] Starting dynamic subtest: pipe-B-eDP-1-size-64
[399.016663] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.312s)
[399.042098] Starting dynamic subtest: pipe-B-eDP-1-size-128
[401.586467] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.551s)
[401.610807] Starting dynamic subtest: pipe-B-eDP-1-size-256
[404.129953] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.527s)
[404.443749] Starting dynamic subtest: pipe-C-eDP-1-size-64
[407.367719] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.929s)
[407.401489] Starting dynamic subtest: pipe-C-eDP-1-size-128
[409.565855] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.180s)
[409.592715] Starting dynamic subtest: pipe-C-eDP-1-size-256
[411.788416] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.203s)
[412.108205] Starting dynamic subtest: pipe-D-eDP-1-size-64
[414.996581] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.895s)
[415.024085] Starting dynamic subtest: pipe-D-eDP-1-size-128
[417.230258] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.214s)
[417.258130] Starting dynamic subtest: pipe-D-eDP-1-size-256
[419.431222] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.181s)
[419.737416] Subtest primary: SUCCESS (32.083s)
[420.567592] [113/133] (603s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[420.666407] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[420.678241] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.011s)
[420.762644] [114/133] (603s left) syncobj_timeline (reset-during-wait-for-submit)
[420.825548] Starting subtest: reset-during-wait-for-submit
[420.928386] Subtest reset-during-wait-for-submit: SUCCESS (0.104s)
[421.036922] [115/133] (602s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[421.134157] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[428.331679] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.197s)
[428.487595] [116/133] (595s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[428.593913] Starting subtest: x-tiled-32bpp-rotate-270
[428.613706] Subtest x-tiled-32bpp-rotate-270: SKIP (0.019s)
[428.755317] [117/133] (595s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[428.814855] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[428.898026] [118/133] (595s left) kms_cursor_crc (cursor-random-64x64)
[429.067113] Starting subtest: cursor-random-64x64
[429.070517] Starting dynamic subtest: pipe-A-eDP-1
[432.400367] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.330s)
[432.430528] Starting dynamic subtest: pipe-D-eDP-1
[436.391682] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.969s)
[436.392457] Subtest cursor-random-64x64: SUCCESS (7.324s)
[437.256691] [119/133] (586s left) gem_create (create-ext-cpu-access-big)
[437.433448] Starting subtest: create-ext-cpu-access-big
[437.435480] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[437.504801] [120/133] (586s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[437.900955] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[438.675988] [121/133] (585s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[438.771226] Starting subtest: random-ccs-data-y-tiled-ccs
[438.772080] Starting dynamic subtest: pipe-A-eDP-1
[438.781534] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[438.789543] Starting dynamic subtest: pipe-B-eDP-1
[438.799036] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[438.806920] Starting dynamic subtest: pipe-C-eDP-1
[438.815730] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[438.823112] Starting dynamic subtest: pipe-D-eDP-1
[438.832342] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[438.833894] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.005s)
[441.074121] [122/133] (582s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[441.175073] Starting subtest: 4-tiled-32bpp-rotate-180
[442.520250] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.345s)
[442.684451] [123/133] (581s left) kms_addfb_basic (addfb25-4-tiled)
[442.772026] Starting subtest: addfb25-4-tiled
[442.772913] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[442.887093] [124/133] (581s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[442.974584] Starting subtest: fbcpsr-indfb-scaledprimary
[448.755851] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (5.780s)
[448.910224] [125/133] (575s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[449.036066] Starting subtest: cursorB-vs-flipA-varying-size
[449.037686] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s)
[449.204379] [126/133] (574s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[449.298365] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[453.942711] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.644s)
[455.101115] [127/133] (569s left) kms_pm_rpm (package-g7)
[457.039121] Starting subtest: package-g7
[457.040980] Subtest package-g7: SKIP (0.000s)
[457.422539] [128/133] (566s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[457.517335] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[464.072325] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.555s)
[464.200568] [129/133] (560s left) kms_flip (flip-vs-expired-vblank)
[464.300383] Starting subtest: flip-vs-expired-vblank
[464.302605] Starting dynamic subtest: A-eDP1
[473.058282] Dynamic subtest A-eDP1: SUCCESS (8.727s)
[473.068236] Starting dynamic subtest: B-eDP1
[481.688150] Dynamic subtest B-eDP1: SUCCESS (8.628s)
[481.698647] Starting dynamic subtest: C-eDP1
[490.316362] Dynamic subtest C-eDP1: SUCCESS (8.616s)
[490.324196] Starting dynamic subtest: D-eDP1
[498.910928] Dynamic subtest D-eDP1: SUCCESS (8.628s)
[498.912043] Subtest flip-vs-expired-vblank: SUCCESS (34.608s)
[500.086699] [130/133] (524s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[500.188945] Starting subtest: y-tiled-64bpp-rotate-0
[500.190840] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[500.306959] [131/133] (524s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[500.407162] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[506.822560] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.415s)
[508.000515] [132/133] (516s left) gem_ringfill (legacy-basic)
[513.886431] Starting subtest: legacy-basic
[513.887514] Starting dynamic subtest: default
[513.951471] Dynamic subtest default: SUCCESS (0.071s)
[513.962670] Starting dynamic subtest: render
[513.993414] Dynamic subtest render: SUCCESS (0.040s)
[514.004398] Starting dynamic subtest: bsd
[514.035445] Dynamic subtest bsd: SUCCESS (0.039s)
[514.045439] Starting dynamic subtest: bsd1
[514.077047] Dynamic subtest bsd1: SUCCESS (0.039s)
[514.088580] Starting dynamic subtest: bsd2
[514.119653] Dynamic subtest bsd2: SUCCESS (0.040s)
[514.129446] Starting dynamic subtest: blt
[514.165321] Dynamic subtest blt: SUCCESS (0.043s)
[514.175755] Starting dynamic subtest: vebox
[514.207373] Dynamic subtest vebox: SUCCESS (0.040s)
[514.209977] Subtest legacy-basic: SUCCESS (0.329s)
[514.297488] [133/133] (510s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[514.355878] Starting subtest: x-tiled-to-vebox-y-tiled
[514.357936] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[514.549830] Closing watchdogs
results: parsing output: 0/ for test: kms_ccs
results: parsing output: 1/ for test: i915_query
results: parsing output: 2/ for test: gem_spin_batch
results: parsing output: 3/ for test: kms_draw_crc
results: parsing output: 4/ for test: gem_exec_schedule
results: parsing output: 5/ for test: gem_ctx_shared
results: parsing output: 6/ for test: gem_tiled_wb
results: parsing output: 7/ for test: gem_partial_pwrite_pread
results: parsing output: 8/ for test: api_intel_allocator
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: gem_exec_gttfill
results: parsing output: 11/ for test: gem_fence_thrash
results: parsing output: 12/ for test: kms_pm_dc
results: parsing output: 13/ for test: i915_drm_fdinfo
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: perf_pmu
results: parsing output: 16/ for test: kms_cursor_legacy
results: parsing output: 17/ for test: syncobj_timeline
results: parsing output: 18/ for test: kms_dither
results: parsing output: 19/ for test: gem_mmap_offset
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: syncobj_wait
results: parsing output: 22/ for test: syncobj_timeline
results: parsing output: 23/ for test: gem_eio
results: parsing output: 24/ for test: gem_userptr_blits
results: parsing output: 25/ for test: perf_pmu
results: parsing output: 26/ for test: kms_flip
results: parsing output: 27/ for test: gem_exec_fence
results: parsing output: 28/ for test: gem_exec_params
results: parsing output: 29/ for test: kms_flip
results: parsing output: 30/ for test: gem_exec_balancer
results: parsing output: 31/ for test: kms_cursor_crc
results: parsing output: 32/ for test: gem_userptr_blits
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gem_ctx_isolation
results: parsing output: 35/ for test: gem_mmap_gtt
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_exec_schedule
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_invalid_mode
results: parsing output: 40/ for test: kms_flip_scaled_crc
results: parsing output: 41/ for test: syncobj_wait
results: parsing output: 42/ for test: core_getversion
results: parsing output: 43/ for test: kms_psr2_sf
results: parsing output: 44/ for test: kms_vblank
results: parsing output: 45/ for test: gem_exec_schedule
results: parsing output: 46/ for test: i915_suspend
results: parsing output: 47/ for test: kms_flip
results: parsing output: 48/ for test: kms_big_fb
results: parsing output: 49/ for test: fbdev
results: parsing output: 50/ for test: gem_eio
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_plane_scaling
results: parsing output: 53/ for test: prime_mmap_coherency
results: parsing output: 54/ for test: gem_exec_reloc
results: parsing output: 55/ for test: kms_psr
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: kms_psr2_sf
results: parsing output: 58/ for test: gem_partial_pwrite_pread
results: parsing output: 59/ for test: kms_lease
results: parsing output: 60/ for test: gem_exec_reloc
results: parsing output: 61/ for test: kms_plane_scaling
results: parsing output: 62/ for test: gem_exec_fence
results: parsing output: 63/ for test: i915_pm_rps
results: parsing output: 64/ for test: kms_multipipe_modeset
results: parsing output: 65/ for test: syncobj_timeline
results: parsing output: 66/ for test: kms_ccs
results: parsing output: 67/ for test: prime_vgem
results: parsing output: 68/ for test: gen7_exec_parse
results: parsing output: 69/ for test: kms_ccs
results: parsing output: 70/ for test: kms_psr
results: parsing output: 71/ for test: api_intel_bb
results: parsing output: 72/ for test: kms_chamelium_hpd
results: parsing output: 73/ for test: syncobj_eventfd
results: parsing output: 74/ for test: kms_psr
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: gem_ctx_persistence
results: parsing output: 77/ for test: kms_atomic
results: parsing output: 78/ for test: sysfs_timeslice_duration
results: parsing output: 79/ for test: kms_fence_pin_leak
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: gem_exec_params
results: parsing output: 82/ for test: kms_color
results: parsing output: 83/ for test: i915_query
results: parsing output: 84/ for test: i915_hangman
results: parsing output: 85/ for test: gem_pread
results: parsing output: 86/ for test: kms_psr2_sf
results: parsing output: 87/ for test: syncobj_wait
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: gem_userptr_blits
results: parsing output: 90/ for test: kms_addfb_basic
results: parsing output: 91/ for test: kms_properties
results: parsing output: 92/ for test: kms_vblank
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_content_protection
results: parsing output: 95/ for test: kms_rotation_crc
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: gem_exercise_blt
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_plane
results: parsing output: 100/ for test: kms_psr
results: parsing output: 101/ for test: kms_ccs
results: parsing output: 102/ for test: perf
results: parsing output: 103/ for test: gem_exec_reloc
results: parsing output: 104/ for test: kms_hdr
results: parsing output: 105/ for test: vgem_basic
results: parsing output: 106/ for test: kms_busy
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_flip_scaled_crc
results: parsing output: 109/ for test: gem_exec_reloc
results: parsing output: 110/ for test: gem_mmap
results: parsing output: 111/ for test: kms_plane_cursor
results: parsing output: 112/ for test: kms_flip
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_big_fb
results: parsing output: 116/ for test: gem_fenced_exec_thrash
results: parsing output: 117/ for test: kms_cursor_crc
results: parsing output: 118/ for test: gem_create
results: parsing output: 119/ for test: kms_chamelium_edid
results: parsing output: 120/ for test: kms_ccs
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: kms_addfb_basic
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_cursor_legacy
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_pm_rpm
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_flip
results: parsing output: 129/ for test: kms_big_fb
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: gem_ringfill
results: parsing output: 132/ for test: gem_render_copy
Done.