[58.880226] Initializing watchdogs
[58.880328]   /dev/watchdog0
[58.895601] [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]
[58.900253] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.902530] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.905917] [001/133] (960s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[59.019932] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[59.022384] Starting dynamic subtest: pipe-A-eDP-1
[59.031399] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[59.039609] Starting dynamic subtest: pipe-B-eDP-1
[59.049060] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[59.057049] Starting dynamic subtest: pipe-C-eDP-1
[59.066042] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[59.072785] Starting dynamic subtest: pipe-D-eDP-1
[59.081609] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[59.086022] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.003s)
[61.216316] [002/133] (958s left) i915_query (query-topology-known-pci-ids)
[61.281684] Starting subtest: query-topology-known-pci-ids
[61.285970] Subtest query-topology-known-pci-ids: SKIP (0.000s)
[61.399654] [003/133] (958s left) gem_spin_batch (resubmit-new)
[61.471787] Starting subtest: resubmit-new
[61.474215] Starting dynamic subtest: rcs0
[61.481099] Dynamic subtest rcs0: SUCCESS (0.009s)
[61.491764] Starting dynamic subtest: bcs0
[61.493989] Dynamic subtest bcs0: SUCCESS (0.004s)
[61.502141] Starting dynamic subtest: vcs0
[61.504066] Dynamic subtest vcs0: SUCCESS (0.004s)
[61.511089] Starting dynamic subtest: vcs1
[61.512947] Dynamic subtest vcs1: SUCCESS (0.006s)
[61.519326] Starting dynamic subtest: vecs0
[61.521146] Dynamic subtest vecs0: SUCCESS (0.004s)
[61.527452] Starting dynamic subtest: ccs0
[61.529273] Dynamic subtest ccs0: SUCCESS (0.004s)
[61.531086] Subtest resubmit-new: SUCCESS (0.033s)
[62.924146] [004/133] (956s left) kms_draw_crc (draw-method-render)
[63.033500] Starting subtest: draw-method-render
[63.035872] Starting dynamic subtest: xrgb8888-untiled
[63.316721] Dynamic subtest xrgb8888-untiled: SUCCESS (0.283s)
[63.325564] Starting dynamic subtest: rgb565-untiled
[63.539121] Dynamic subtest rgb565-untiled: SUCCESS (0.222s)
[63.546358] Starting dynamic subtest: xrgb2101010-untiled
[63.773225] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.233s)
[63.782765] Starting dynamic subtest: xbgr16161616f-untiled
[64.017614] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.244s)
[64.024535] Starting dynamic subtest: xrgb8888-xtiled
[64.140298] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.122s)
[64.148337] Starting dynamic subtest: rgb565-xtiled
[64.251632] Dynamic subtest rgb565-xtiled: SUCCESS (0.111s)
[64.258857] Starting dynamic subtest: xrgb2101010-xtiled
[64.374042] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s)
[64.382278] Starting dynamic subtest: xbgr16161616f-xtiled
[64.507848] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[64.515243] Starting dynamic subtest: xrgb8888-4tiled
[64.641235] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.133s)
[64.648394] Starting dynamic subtest: rgb565-4tiled
[64.752843] Dynamic subtest rgb565-4tiled: SUCCESS (0.111s)
[64.759830] Starting dynamic subtest: xrgb2101010-4tiled
[64.875534] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.122s)
[64.883936] Starting dynamic subtest: xbgr16161616f-4tiled
[64.997659] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.122s)
[64.999724] Subtest draw-method-render: SUCCESS (1.961s)
[65.121630] [005/133] (954s left) gem_exec_schedule (noreorder)
[65.307710] Starting subtest: noreorder
[65.310067] Starting dynamic subtest: rcs0
[65.379846] Dynamic subtest rcs0: SUCCESS (0.073s)
[65.389875] Starting dynamic subtest: vcs0
[67.071041] Dynamic subtest vcs0: SUCCESS (1.685s)
[67.080536] Starting dynamic subtest: vcs1
[68.915362] Dynamic subtest vcs1: SUCCESS (1.841s)
[68.923784] Starting dynamic subtest: vecs0
[70.970403] Dynamic subtest vecs0: SUCCESS (2.051s)
[70.979238] Starting dynamic subtest: ccs0
[71.071311] Dynamic subtest ccs0: SUCCESS (0.101s)
[71.074056] Subtest noreorder: SUCCESS (5.756s)
[71.270605] [006/133] (948s left) gem_ctx_shared (disjoint-timelines)
[71.342665] Starting subtest: disjoint-timelines
[71.395281] Subtest disjoint-timelines: SUCCESS (0.053s)
[71.668099] [FACT gem_ctx_shared (disjoint-timelines)] new: kernel.kmod_is_loaded.vgem: true
[71.671502] [007/133] (947s left) gem_tiled_wb
[71.791232] [008/133] (947s left) gem_partial_pwrite_pread (write-snoop)
[71.859575] Subtest write-snoop: SKIP (0.000s)
[71.947364] [009/133] (947s left) api_intel_allocator (fork-simple-stress-signal)
[71.999835] Starting subtest: fork-simple-stress-signal
[77.404634] Subtest fork-simple-stress-signal: SUCCESS (5.402s)
[77.562998] [010/133] (942s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[77.625337] Starting subtest: invalid-multi-wait-unsubmitted
[77.627802] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[77.778918] [011/133] (942s left) gem_exec_gttfill (multigpu-basic)
[77.968094] Starting subtest: multigpu-basic
[93.001126] Subtest multigpu-basic: SUCCESS (15.028s)
[93.041584] [012/133] (926s left) gem_fence_thrash (bo-write-verify-threaded-y)
[93.111721] Starting subtest: bo-write-verify-threaded-y
[93.139196] Subtest bo-write-verify-threaded-y: SKIP (0.026s)
[93.204429] [013/133] (926s left) kms_pm_dc (dc3co-vpb-simulation)
[94.321044] Starting subtest: dc3co-vpb-simulation
[103.714939] Subtest dc3co-vpb-simulation: SKIP (9.387s)
[103.831207] [014/133] (916s left) i915_drm_fdinfo (busy-idle-check-all)
[103.877817] Starting subtest: busy-idle-check-all
[103.879691] Starting dynamic subtest: rcs0
[103.884091] Dynamic subtest rcs0: SKIP (0.005s)
[103.891804] Starting dynamic subtest: bcs0
[103.896138] Dynamic subtest bcs0: SKIP (0.001s)
[103.903603] Starting dynamic subtest: vcs0
[103.907705] Dynamic subtest vcs0: SKIP (0.000s)
[103.915212] Starting dynamic subtest: vcs1
[103.919671] Dynamic subtest vcs1: SKIP (0.000s)
[103.927135] Starting dynamic subtest: vecs0
[103.931808] Dynamic subtest vecs0: SKIP (0.000s)
[103.941571] Starting dynamic subtest: ccs0
[103.945932] Dynamic subtest ccs0: SKIP (0.000s)
[103.950159] Subtest busy-idle-check-all: SKIP (0.008s)
[103.985965] [015/133] (915s left) kms_psr (pr-cursor-plane-move)
[104.097326] Starting subtest: pr-cursor-plane-move
[104.102169] Subtest pr-cursor-plane-move: SKIP (0.000s)
[104.184597] [016/133] (915s left) perf_pmu (idle-no-semaphores)
[104.221699] Starting subtest: idle-no-semaphores
[104.223975] Starting dynamic subtest: rcs0
[104.785309] Dynamic subtest rcs0: SUCCESS (0.562s)
[104.794564] Starting dynamic subtest: bcs0
[105.313606] Dynamic subtest bcs0: SUCCESS (0.526s)
[105.324616] Starting dynamic subtest: vcs0
[105.844561] Dynamic subtest vcs0: SUCCESS (0.529s)
[105.853762] Starting dynamic subtest: vcs1
[106.373218] Dynamic subtest vcs1: SUCCESS (0.528s)
[106.383017] Starting dynamic subtest: vecs0
[106.899991] Dynamic subtest vecs0: SUCCESS (0.525s)
[106.910560] Starting dynamic subtest: ccs0
[107.413269] Dynamic subtest ccs0: SUCCESS (0.512s)
[107.415877] Subtest idle-no-semaphores: SUCCESS (3.191s)
[107.532746] [017/133] (912s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[107.673157] Starting subtest: basic-busy-flip-before-cursor-varying-size
[107.677755] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[107.841212] [018/133] (912s left) syncobj_timeline (invalid-signal-zero-handles)
[107.902322] Starting subtest: invalid-signal-zero-handles
[107.904367] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[108.010585] [019/133] (912s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[108.105790] Starting subtest: fb-8bpc-vs-panel-8bpc
[108.108049] Starting dynamic subtest: pipe-A-eDP-1
[109.504593] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.398s)
[109.506650] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.399s)
[110.327230] [020/133] (909s left) gem_mmap_offset (basic-uaf)
[110.388176] Starting subtest: basic-uaf
[110.390225] Subtest basic-uaf: SUCCESS (0.001s)
[110.534415] [021/133] (909s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[110.636473] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[110.640649] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[110.752827] [022/133] (909s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[110.815745] Starting subtest: multi-wait-all-for-submit-signaled
[110.818049] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[110.937396] [023/133] (909s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted)
[110.990710] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted
[111.100467] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.109s)
[111.188368] [024/133] (909s left) gem_eio (in-flight-internal-10ms)
[111.416839] Starting subtest: in-flight-internal-10ms
[112.996859] Subtest in-flight-internal-10ms: SUCCESS (1.581s)
[113.162155] [025/133] (907s left) gem_userptr_blits (map-fixed-invalidate-busy)
[113.236247] Starting subtest: map-fixed-invalidate-busy
[113.240626] Subtest map-fixed-invalidate-busy: SKIP (0.000s)
[113.387112] [026/133] (907s left) perf_pmu (busy)
[113.421980] Starting subtest: busy
[113.424528] Starting dynamic subtest: rcs0
[114.039395] Dynamic subtest rcs0: SUCCESS (0.618s)
[114.049765] Starting dynamic subtest: bcs0
[114.610856] Dynamic subtest bcs0: SUCCESS (0.570s)
[114.621416] Starting dynamic subtest: vcs0
[115.928402] Dynamic subtest vcs0: SUCCESS (1.315s)
[115.938742] Starting dynamic subtest: vcs1
[117.912366] Dynamic subtest vcs1: SUCCESS (1.983s)
[117.923834] Starting dynamic subtest: vecs0
[119.896077] Dynamic subtest vecs0: SUCCESS (1.983s)
[119.907364] Starting dynamic subtest: ccs0
[120.472216] Dynamic subtest ccs0: SUCCESS (0.577s)
[120.474658] Subtest busy: SUCCESS (7.051s)
[120.605769] [027/133] (899s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[120.706238] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[120.715172] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.011s)
[120.811771] [028/133] (899s left) gem_exec_fence (expired-history)
[121.260147] Starting subtest: expired-history
[128.651606] Subtest expired-history: SUCCESS (7.392s)
[129.320425] [029/133] (891s left) gem_exec_params (batch-first)
[129.381945] Starting subtest: batch-first
[129.392187] Subtest batch-first: SUCCESS (0.011s)
[129.496511] [030/133] (891s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[129.610642] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[129.622775] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.011s)
[129.732252] [031/133] (890s left) gem_exec_balancer (hang)
[129.987845] Starting subtest: hang
[131.957353] Subtest hang: SUCCESS (1.969s)
[132.109920] [032/133] (888s left) kms_cursor_crc (cursor-onscreen-256x256)
[132.374257] Starting subtest: cursor-onscreen-256x256
[132.379519] Starting dynamic subtest: pipe-A-eDP-1
[134.564070] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.186s)
[134.599914] Starting dynamic subtest: pipe-D-eDP-1
[137.369409] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.785s)
[137.371744] Subtest cursor-onscreen-256x256: SUCCESS (4.995s)
[138.174642] [033/133] (882s left) gem_userptr_blits (vma-merge)
[138.260917] Starting subtest: vma-merge
[138.297570] Subtest vma-merge: SUCCESS (0.039s)
[138.457238] [034/133] (882s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[138.559579] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[146.034040] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.477s)
[146.183477] [035/133] (874s left) gem_ctx_isolation (nonpriv)
[146.251047] Starting subtest: nonpriv
[146.253435] Starting dynamic subtest: rcs0
[146.487901] Dynamic subtest rcs0: SUCCESS (0.237s)
[146.499691] Starting dynamic subtest: bcs0
[146.782814] Dynamic subtest bcs0: SUCCESS (0.294s)
[146.793964] Starting dynamic subtest: vcs0
[147.055918] Dynamic subtest vcs0: SUCCESS (0.273s)
[147.067117] Starting dynamic subtest: vcs1
[149.159225] Dynamic subtest vcs1: SUCCESS (2.103s)
[149.170752] Starting dynamic subtest: vecs0
[151.170653] Dynamic subtest vecs0: SUCCESS (2.011s)
[151.182252] Starting dynamic subtest: ccs0
[153.208083] Dynamic subtest ccs0: SUCCESS (2.037s)
[153.210467] Subtest nonpriv: SUCCESS (6.957s)
[153.478922] [036/133] (867s left) gem_mmap_gtt (cpuset-medium-copy)
[153.557376] Subtest cpuset-medium-copy: SKIP (0.000s)
[153.621009] [037/133] (867s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[153.738148] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[153.742365] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[153.834160] [038/133] (867s left) gem_exec_schedule (preempt-user)
[153.919199] Starting subtest: preempt-user
[153.921418] Starting dynamic subtest: rcs0
[153.934785] Dynamic subtest rcs0: SUCCESS (0.023s)
[153.943656] Starting dynamic subtest: bcs0
[153.953522] Dynamic subtest bcs0: SUCCESS (0.019s)
[153.962173] Starting dynamic subtest: vcs0
[153.973330] Dynamic subtest vcs0: SUCCESS (0.019s)
[153.981791] Starting dynamic subtest: vcs1
[153.994595] Dynamic subtest vcs1: SUCCESS (0.021s)
[154.003332] Starting dynamic subtest: vecs0
[154.018703] Dynamic subtest vecs0: SUCCESS (0.024s)
[154.027320] Starting dynamic subtest: ccs0
[154.040871] Dynamic subtest ccs0: SUCCESS (0.022s)
[154.043152] Subtest preempt-user: SUCCESS (0.130s)
[156.048126] [039/133] (864s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[156.159731] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[156.164317] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[156.298406] [040/133] (864s left) kms_invalid_mode (bad-vsync-end)
[156.402139] Starting subtest: bad-vsync-end
[156.404411] Starting dynamic subtest: pipe-A-eDP-1
[156.690805] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.290s)
[156.700605] Starting dynamic subtest: pipe-B-eDP-1
[156.702510] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[156.711249] Starting dynamic subtest: pipe-C-eDP-1
[156.713428] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[156.721886] Starting dynamic subtest: pipe-D-eDP-1
[156.724087] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[156.726230] Subtest bad-vsync-end: SUCCESS (0.294s)
[157.520623] [041/133] (863s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[157.627140] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[157.631218] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.000s)
[157.715515] [042/133] (863s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[157.777890] Starting subtest: multi-wait-all-for-submit-submitted
[157.884121] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.105s)
[157.972506] [043/133] (863s left) core_getversion (all-cards)
[158.007568] Starting subtest: all-cards
[158.015848] Subtest all-cards: SUCCESS (0.011s)
[158.059804] [044/133] (863s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb)
[158.163722] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb
[158.166030] Starting dynamic subtest: pipe-A-eDP-1
[164.940416] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.780s)
[164.950035] Starting dynamic subtest: pipe-B-eDP-1
[171.949437] Dynamic subtest pipe-B-eDP-1: SUCCESS (7.008s)
[171.951818] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.791s)
[172.812528] [045/133] (848s left) kms_vblank (invalid)
[172.904062] Starting subtest: invalid
[172.905992] Starting dynamic subtest: pipe-A-eDP-1
[173.303620] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.399s)
[173.305577] Subtest invalid: SUCCESS (0.400s)
[174.135269] [046/133] (847s left) gem_exec_schedule (u-submit-golden-slice)
[174.215407] Starting subtest: u-submit-golden-slice
[174.217760] Starting dynamic subtest: rcs0
[174.243223] Dynamic subtest rcs0: SUCCESS (0.036s)
[174.254449] Starting dynamic subtest: bcs0
[174.282963] Dynamic subtest bcs0: SUCCESS (0.039s)
[174.293233] Starting dynamic subtest: vcs0
[174.315194] Dynamic subtest vcs0: SUCCESS (0.032s)
[174.324472] Starting dynamic subtest: vcs1
[174.352614] Dynamic subtest vcs1: SUCCESS (0.037s)
[174.362405] Starting dynamic subtest: vecs0
[174.385309] Dynamic subtest vecs0: SUCCESS (0.032s)
[174.394339] Starting dynamic subtest: ccs0
[174.425397] Dynamic subtest ccs0: SUCCESS (0.040s)
[174.427687] Subtest u-submit-golden-slice: SUCCESS (0.218s)
[176.024760] [047/133] (845s left) i915_suspend (fence-restore-untiled)
[176.077203] Starting subtest: fence-restore-untiled
[176.081237] Subtest fence-restore-untiled: SKIP (0.000s)
[176.195287] [048/133] (845s left) kms_flip (modeset-vs-vblank-race)
[176.305341] Starting subtest: modeset-vs-vblank-race
[176.307356] Starting dynamic subtest: A-eDP1
[180.941297] Dynamic subtest A-eDP1: SUCCESS (4.638s)
[180.952706] Starting dynamic subtest: B-eDP1
[185.661055] Dynamic subtest B-eDP1: SUCCESS (4.718s)
[185.672819] Starting dynamic subtest: C-eDP1
[190.364929] Dynamic subtest C-eDP1: SUCCESS (4.702s)
[190.376825] Starting dynamic subtest: D-eDP1
[194.914827] Dynamic subtest D-eDP1: SUCCESS (4.548s)
[194.920160] Subtest modeset-vs-vblank-race: SUCCESS (18.616s)
[196.108487] [049/133] (825s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[196.220760] Starting subtest: yf-tiled-64bpp-rotate-180
[196.224909] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[196.325759] [050/133] (825s left) fbdev (pan)
[196.358089] Starting subtest: pan
[196.388621] Subtest pan: SUCCESS (0.031s)
[196.471613] [051/133] (824s left) gem_eio (in-flight-contexts-immediate)
[196.717616] Starting subtest: in-flight-contexts-immediate
[207.912587] Subtest in-flight-contexts-immediate: SUCCESS (11.193s)
[208.097342] [052/133] (813s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[208.213301] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[214.975431] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.764s)
[215.144524] [053/133] (806s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[215.255314] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[215.257522] Starting dynamic subtest: pipe-A
[215.603620] Dynamic subtest pipe-A: SUCCESS (0.351s)
[215.613404] Starting dynamic subtest: pipe-B
[217.033419] Dynamic subtest pipe-B: SUCCESS (1.429s)
[217.042775] Starting dynamic subtest: pipe-C
[218.438249] Dynamic subtest pipe-C: SUCCESS (1.404s)
[218.448263] Starting dynamic subtest: pipe-D
[219.871196] Dynamic subtest pipe-D: SUCCESS (1.432s)
[219.873594] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.618s)
[221.059413] [054/133] (800s left) prime_mmap_coherency (write)
[221.115912] Starting subtest: write
[226.491678] Subtest write: SUCCESS (5.374s)
[226.650602] [055/133] (794s left) gem_exec_reloc (basic-write-read-noreloc)
[226.731248] Subtest basic-write-read-noreloc: SKIP (0.000s)
[226.804085] [056/133] (794s left) kms_psr (fbc-psr-no-drrs)
[226.906949] Starting subtest: fbc-psr-no-drrs
[226.909167] Starting dynamic subtest: eDP-1
[226.913138] Dynamic subtest eDP-1: SKIP (0.000s)
[226.917186] Subtest fbc-psr-no-drrs: SKIP (0.001s)
[226.991814] [057/133] (794s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[227.085846] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[228.044785] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.959s)
[228.188666] [058/133] (793s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[228.298250] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf
[228.302508] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[228.379725] [059/133] (793s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[228.460483] Subtest writes-after-reads-uncached: SKIP (0.000s)
[228.551589] [060/133] (793s left) kms_lease (possible-crtcs-filtering)
[228.644016] Starting subtest: possible-crtcs-filtering
[228.647763] Subtest possible-crtcs-filtering: SUCCESS (0.005s)
[228.789821] [061/133] (793s left) gem_exec_reloc (basic-wc-noreloc)
[228.858574] Subtest basic-wc-noreloc: SKIP (0.000s)
[228.928033] [062/133] (792s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[229.024580] Starting subtest: plane-upscale-factor-0-25-with-rotation
[229.026615] Starting dynamic subtest: pipe-A
[229.249568] Dynamic subtest pipe-A: SUCCESS (0.227s)
[229.258675] Starting dynamic subtest: pipe-B
[230.521046] Dynamic subtest pipe-B: SUCCESS (1.270s)
[230.530751] Starting dynamic subtest: pipe-C
[231.860923] Dynamic subtest pipe-C: SUCCESS (1.339s)
[231.870059] Starting dynamic subtest: pipe-D
[233.192664] Dynamic subtest pipe-D: SUCCESS (1.331s)
[233.195067] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.170s)
[234.370224] [063/133] (787s left) gem_exec_fence (submit-chain)
[234.556600] Starting subtest: submit-chain
[234.570100] Subtest submit-chain: SUCCESS (0.017s)
[236.010174] [064/133] (785s left) i915_pm_rps (engine-order)
[236.088461] Starting subtest: engine-order
[240.958927] Subtest engine-order: SUCCESS (4.871s)
[241.121289] [065/133] (780s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[241.220042] Starting subtest: basic-max-pipe-crc-check
[241.224242] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[241.271360] [066/133] (780s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[241.333752] Starting subtest: single-wait-all-for-submit-available-signaled
[241.336043] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[241.458728] [067/133] (780s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[241.557272] Starting subtest: bad-aux-stride-y-tiled-ccs
[241.559507] Starting dynamic subtest: pipe-A-eDP-1
[241.582936] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[241.596629] Starting dynamic subtest: pipe-B-eDP-1
[241.617547] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[241.627201] Starting dynamic subtest: pipe-C-eDP-1
[241.648580] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[241.658339] Starting dynamic subtest: pipe-D-eDP-1
[241.679955] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[241.684270] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.005s)
[243.842135] [068/133] (778s left) prime_vgem (basic-fence-flip)
[243.929056] Starting subtest: basic-fence-flip
[244.217448] Subtest basic-fence-flip: SUCCESS (0.288s)
[244.357651] [069/133] (777s left) gen7_exec_parse (oacontrol-tracking)
[244.421434] Subtest oacontrol-tracking: SKIP (0.000s)
[244.510958] [070/133] (777s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[244.599694] Starting subtest: crc-primary-basic-y-tiled-ccs
[244.601931] Starting dynamic subtest: pipe-A-eDP-1
[244.623552] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[244.634439] Starting dynamic subtest: pipe-B-eDP-1
[244.654129] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[244.662675] Starting dynamic subtest: pipe-C-eDP-1
[244.683439] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[244.691843] Starting dynamic subtest: pipe-D-eDP-1
[244.713348] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[244.717881] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.006s)
[246.921075] [071/133] (775s left) kms_psr (psr2-cursor-mmap-gtt)
[247.021080] Starting subtest: psr2-cursor-mmap-gtt
[247.023345] Starting dynamic subtest: eDP-1
[248.691067] Dynamic subtest eDP-1: SUCCESS (1.671s)
[248.693313] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.672s)
[249.587129] [072/133] (772s left) api_intel_bb (lot-of-buffers)
[249.654524] Starting subtest: lot-of-buffers
[250.690702] Subtest lot-of-buffers: SUCCESS (1.037s)
[251.019844] [073/133] (771s left) kms_chamelium_hpd (common-hpd-after-suspend)
[251.407404] Subtest common-hpd-after-suspend: SKIP (0.000s)
[252.185345] [074/133] (770s left) syncobj_eventfd (binary-wait)
[252.238906] Starting subtest: binary-wait
[252.247598] Subtest binary-wait: SUCCESS (0.010s)
[252.334528] [075/133] (770s left) kms_psr (psr-primary-blt)
[252.417052] Starting subtest: psr-primary-blt
[252.419246] Starting dynamic subtest: eDP-1
[254.114447] Dynamic subtest eDP-1: SUCCESS (1.696s)
[254.116360] Subtest psr-primary-blt: SUCCESS (1.697s)
[254.993541] [076/133] (767s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[255.115283] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[255.119752] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[255.244741] [077/133] (767s left) gem_ctx_persistence (legacy-engines-hang)
[255.300727] Starting subtest: legacy-engines-hang
[255.302955] Starting dynamic subtest: render
[255.440856] Dynamic subtest render: SUCCESS (0.139s)
[255.455574] Starting dynamic subtest: bsd1
[255.560133] Dynamic subtest bsd1: SUCCESS (0.115s)
[255.571194] Starting dynamic subtest: bsd2
[255.673030] Dynamic subtest bsd2: SUCCESS (0.110s)
[255.683606] Starting dynamic subtest: blt
[255.790844] Dynamic subtest blt: SUCCESS (0.115s)
[255.805507] Starting dynamic subtest: vebox
[255.890245] Dynamic subtest vebox: SUCCESS (0.096s)
[255.892910] Subtest legacy-engines-hang: SUCCESS (0.590s)
[255.979448] [078/133] (766s left) kms_atomic (atomic-plane-damage)
[256.070702] Starting subtest: atomic-plane-damage
[256.117963] Starting dynamic subtest: pipe-A-eDP-1
[256.647720] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.529s)
[256.650189] Subtest atomic-plane-damage: SUCCESS (0.579s)
[257.528510] [079/133] (765s left) sysfs_timeslice_duration (idempotent)
[257.596027] Starting subtest: idempotent
[257.598410] Starting dynamic subtest: vecs0
[257.600737] Dynamic subtest vecs0: SUCCESS (0.000s)
[257.611614] Starting dynamic subtest: ccs0
[257.613541] Dynamic subtest ccs0: SUCCESS (0.000s)
[257.622622] Starting dynamic subtest: vcs0
[257.624815] Dynamic subtest vcs0: SUCCESS (0.000s)
[257.633490] Starting dynamic subtest: bcs0
[257.635381] Dynamic subtest bcs0: SUCCESS (0.000s)
[257.643547] Starting dynamic subtest: rcs0
[257.645426] Dynamic subtest rcs0: SUCCESS (0.000s)
[257.653682] Starting dynamic subtest: vcs1
[257.655598] Dynamic subtest vcs1: SUCCESS (0.000s)
[257.657533] Subtest idempotent: SUCCESS (0.006s)
[257.698061] [080/133] (764s left) kms_fence_pin_leak
[257.886591] [081/133] (764s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt)
[258.012593] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt
[261.753780] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.744s)
[262.948471] [082/133] (759s left) gem_exec_params (rel-constants-invalid-ring)
[263.010417] Starting subtest: rel-constants-invalid-ring
[263.012738] Subtest rel-constants-invalid-ring: SUCCESS (0.000s)
[263.140470] [083/133] (759s left) kms_color (ctm-0-75)
[263.242061] Starting subtest: ctm-0-75
[263.244277] Starting dynamic subtest: pipe-A-eDP-1
[268.104258] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.862s)
[268.113199] Starting dynamic subtest: pipe-B-eDP-1
[273.794310] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.688s)
[273.804374] Starting dynamic subtest: pipe-C-eDP-1
[279.102456] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.308s)
[279.111679] Starting dynamic subtest: pipe-D-eDP-1
[284.438155] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.334s)
[284.440435] Subtest ctm-0-75: SUCCESS (21.195s)
[285.272676] [084/133] (737s left) i915_query (query-topology-unsupported)
[285.349492] Starting subtest: query-topology-unsupported
[285.353710] Subtest query-topology-unsupported: SKIP (0.000s)
[285.469437] [085/133] (737s left) i915_hangman (engine-error-state-capture)
[285.536474] Starting subtest: engine-error-state-capture
[285.538805] Starting dynamic subtest: rcs0
[288.885635] Dynamic subtest rcs0: SUCCESS (3.349s)
[288.898252] Starting dynamic subtest: bcs0
[294.901513] Dynamic subtest bcs0: SUCCESS (6.013s)
[294.913826] Starting dynamic subtest: vcs0
[300.854884] Dynamic subtest vcs0: SUCCESS (5.950s)
[300.867153] Starting dynamic subtest: vcs1
[306.806795] Dynamic subtest vcs1: SUCCESS (5.949s)
[306.819204] Starting dynamic subtest: vecs0
[311.798090] Dynamic subtest vecs0: SUCCESS (4.989s)
[311.810296] Starting dynamic subtest: ccs0
[316.855339] Dynamic subtest ccs0: SUCCESS (5.053s)
[316.858111] Subtest engine-error-state-capture: SUCCESS (31.320s)
[316.994540] [086/133] (705s left) gem_pread (self)
[317.068479] Subtest self: SKIP (0.000s)
[317.136163] [087/133] (705s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[317.249408] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[317.251760] Starting dynamic subtest: pipe-A-eDP-1
[317.335339] Dynamic subtest pipe-A-eDP-1: SKIP (0.088s)
[317.344947] Starting dynamic subtest: pipe-B-eDP-1
[318.451444] Dynamic subtest pipe-B-eDP-1: SKIP (1.113s)
[318.455762] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (1.204s)
[319.744642] [088/133] (703s left) syncobj_wait (invalid-wait-illegal-handle)
[319.806702] Starting subtest: invalid-wait-illegal-handle
[319.808730] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[319.934183] [089/133] (703s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite)
[320.041955] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite
[320.046186] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[320.168174] [090/133] (702s left) gem_userptr_blits (create-destroy-sync)
[320.240236] Starting subtest: create-destroy-sync
[325.247206] Subtest create-destroy-sync: SUCCESS (5.010s)
[325.398200] [091/133] (697s left) kms_addfb_basic (unused-modifier)
[325.460485] Starting subtest: unused-modifier
[325.462498] Subtest unused-modifier: SUCCESS (0.000s)
[325.632242] [092/133] (697s left) kms_properties (connector-properties-atomic)
[325.730047] Starting subtest: connector-properties-atomic
[325.732269] Starting dynamic subtest: pipe-A-eDP-1
[333.532070] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.799s)
[333.541786] Starting dynamic subtest: pipe-None-DP-1
[333.546204] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[333.554378] Starting dynamic subtest: pipe-None-HDMI-A-1
[333.558635] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[333.567350] Starting dynamic subtest: pipe-None-DP-2
[333.571348] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[333.579863] Starting dynamic subtest: pipe-None-HDMI-A-2
[333.584024] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[333.595215] Starting dynamic subtest: pipe-None-DP-3
[333.600023] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[333.609055] Starting dynamic subtest: pipe-None-DP-4
[333.613771] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[333.616137] Subtest connector-properties-atomic: SUCCESS (7.812s)
[334.452853] [093/133] (688s left) kms_vblank (wait-forked)
[334.561353] Starting subtest: wait-forked
[334.563367] Starting dynamic subtest: pipe-A-eDP-1
[336.377478] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.817s)
[336.391330] Starting dynamic subtest: pipe-D-eDP-1
[338.906436] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.522s)
[338.908849] Subtest wait-forked: SUCCESS (4.347s)
[339.781903] [094/133] (683s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[339.873904] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[339.878161] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[340.003402] [095/133] (683s left) kms_content_protection (dp-mst-type-1)
[340.137681] Starting subtest: dp-mst-type-1
[340.142297] Subtest dp-mst-type-1: SKIP (0.000s)
[340.272282] [096/133] (683s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[340.367346] Starting subtest: primary-x-tiled-reflect-x-0
[347.350611] Subtest primary-x-tiled-reflect-x-0: SUCCESS (6.985s)
[348.646785] [097/133] (674s left) kms_big_fb (linear-32bpp-rotate-180)
[348.756286] Starting subtest: linear-32bpp-rotate-180
[350.245861] Subtest linear-32bpp-rotate-180: SUCCESS (1.490s)
[350.399141] [098/133] (673s left) gem_exercise_blt (fast-copy-emit)
[350.463331] Starting subtest: fast-copy-emit
[350.465376] Starting dynamic subtest: linear-smem-smem-emit
[350.485059] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.021s)
[350.494370] Starting dynamic subtest: xmajor-smem-smem-emit
[350.502071] Dynamic subtest xmajor-smem-smem-emit: SUCCESS (0.017s)
[350.510375] Starting dynamic subtest: tile4-smem-smem-emit
[350.524769] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.022s)
[350.533579] Starting dynamic subtest: tile64-smem-smem-emit
[350.543115] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.017s)
[350.545392] Subtest fast-copy-emit: SUCCESS (0.080s)
[350.708137] [099/133] (672s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[350.815342] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[350.818931] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[350.934992] [100/133] (672s left) kms_plane (pixel-format-yf-tiled-ccs-modifier)
[351.038387] Starting subtest: pixel-format-yf-tiled-ccs-modifier
[351.048891] Subtest pixel-format-yf-tiled-ccs-modifier: SKIP (0.000s)
[351.123830] [101/133] (672s left) kms_psr (fbc-psr2-dpms)
[351.225515] Starting subtest: fbc-psr2-dpms
[351.227396] Starting dynamic subtest: eDP-1
[351.230835] Dynamic subtest eDP-1: SKIP (0.000s)
[351.235077] Subtest fbc-psr2-dpms: SKIP (0.001s)
[351.311100] [102/133] (672s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs)
[351.421320] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs
[351.423246] Starting dynamic subtest: pipe-A-eDP-1
[351.698669] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.252s)
[351.714017] Starting dynamic subtest: pipe-B-eDP-1
[352.992343] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.285s)
[353.003813] Starting dynamic subtest: pipe-C-eDP-1
[354.202254] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.210s)
[354.213177] Starting dynamic subtest: pipe-D-eDP-1
[355.433410] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.231s)
[355.435414] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (3.984s)
[356.661699] [103/133] (666s left) perf (i915-ref-count)
[356.770356] Starting subtest: i915-ref-count
[356.828802] Subtest i915-ref-count: SUCCESS (0.057s)
[356.887688] [104/133] (666s left) gem_exec_reloc (basic-wc-cpu-active)
[356.943633] Subtest basic-wc-cpu-active: SKIP (0.000s)
[357.030715] [105/133] (666s left) kms_hdr (invalid-metadata-sizes)
[357.123085] Starting subtest: invalid-metadata-sizes
[357.129609] Subtest invalid-metadata-sizes: SKIP (0.000s)
[357.207224] [106/133] (666s left) vgem_basic (mmap)
[357.247965] Starting subtest: mmap
[357.268782] Subtest mmap: SUCCESS (0.022s)
[357.350318] [107/133] (666s left) kms_busy (extended-modeset-hang-oldfb)
[357.450948] Starting subtest: extended-modeset-hang-oldfb
[357.453146] Starting dynamic subtest: pipe-A
[369.133396] Dynamic subtest pipe-A: SUCCESS (11.680s)
[369.143259] Starting dynamic subtest: pipe-D
[381.412086] Dynamic subtest pipe-D: SUCCESS (12.275s)
[381.414424] Subtest extended-modeset-hang-oldfb: SUCCESS (23.960s)
[382.207093] [108/133] (641s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[382.331656] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[382.336258] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[382.467578] [109/133] (641s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[382.559073] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[382.563167] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s)
[382.639699] [110/133] (641s left) gem_exec_reloc (basic-gtt-active)
[382.698755] Subtest basic-gtt-active: SKIP (0.000s)
[382.786393] [111/133] (641s left) gem_mmap (short-mmap)
[382.836184] Subtest short-mmap: SKIP (0.000s)
[382.899250] [112/133] (641s left) kms_plane_cursor (primary)
[382.993934] Starting subtest: primary
[382.998350] Starting dynamic subtest: pipe-A-eDP-1-size-64
[385.533943] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.539s)
[385.558506] Starting dynamic subtest: pipe-A-eDP-1-size-128
[388.124171] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.571s)
[388.150810] Starting dynamic subtest: pipe-A-eDP-1-size-256
[390.692085] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.549s)
[391.008086] Starting dynamic subtest: pipe-B-eDP-1-size-64
[394.356066] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.359s)
[394.380188] Starting dynamic subtest: pipe-B-eDP-1-size-128
[396.911834] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.538s)
[396.939342] Starting dynamic subtest: pipe-B-eDP-1-size-256
[399.503053] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.570s)
[399.819592] Starting dynamic subtest: pipe-C-eDP-1-size-64
[402.742094] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.933s)
[402.770214] Starting dynamic subtest: pipe-C-eDP-1-size-128
[404.954098] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.191s)
[404.988851] Starting dynamic subtest: pipe-C-eDP-1-size-256
[407.164303] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.191s)
[407.487833] Starting dynamic subtest: pipe-D-eDP-1-size-64
[410.369085] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.894s)
[410.396605] Starting dynamic subtest: pipe-D-eDP-1-size-128
[412.569921] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.180s)
[412.597703] Starting dynamic subtest: pipe-D-eDP-1-size-256
[414.814263] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.224s)
[415.121729] Subtest primary: SUCCESS (32.127s)
[415.945582] [113/133] (608s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[416.056564] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[416.067498] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.011s)
[416.158288] [114/133] (607s left) syncobj_timeline (reset-during-wait-for-submit)
[416.212713] Starting subtest: reset-during-wait-for-submit
[416.314849] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[416.405477] [115/133] (607s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[416.512250] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[423.589977] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.081s)
[423.726441] [116/133] (600s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[423.835557] Starting subtest: x-tiled-32bpp-rotate-270
[423.855959] Subtest x-tiled-32bpp-rotate-270: SKIP (0.020s)
[424.007244] [117/133] (600s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible)
[424.081729] Subtest no-spare-fences-busy-interruptible: SKIP (0.000s)
[424.147433] [118/133] (600s left) kms_cursor_crc (cursor-random-64x64)
[424.319458] Starting subtest: cursor-random-64x64
[424.324570] Starting dynamic subtest: pipe-A-eDP-1
[427.642511] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.319s)
[427.672597] Starting dynamic subtest: pipe-D-eDP-1
[431.636296] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.970s)
[431.638632] Subtest cursor-random-64x64: SUCCESS (7.315s)
[432.527773] [119/133] (591s left) gem_create (create-ext-cpu-access-big)
[432.710233] Starting subtest: create-ext-cpu-access-big
[432.715370] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[432.812697] [120/133] (591s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[433.212640] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[434.038731] [121/133] (590s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[434.137402] Starting subtest: random-ccs-data-y-tiled-ccs
[434.139908] Starting dynamic subtest: pipe-A-eDP-1
[434.166141] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[434.177673] Starting dynamic subtest: pipe-B-eDP-1
[434.201274] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[434.210226] Starting dynamic subtest: pipe-C-eDP-1
[434.234190] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[434.245030] Starting dynamic subtest: pipe-D-eDP-1
[434.269701] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[434.273813] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.005s)
[436.413297] [122/133] (588s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[436.514311] Starting subtest: 4-tiled-32bpp-rotate-180
[437.880988] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.367s)
[438.061458] [123/133] (586s left) kms_addfb_basic (addfb25-4-tiled)
[438.158748] Starting subtest: addfb25-4-tiled
[438.160300] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[438.293059] [124/133] (586s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary)
[438.391045] Starting subtest: fbcpsr-indfb-scaledprimary
[444.188274] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (5.799s)
[444.345307] [125/133] (580s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[444.476637] Starting subtest: cursorB-vs-flipA-varying-size
[444.481232] Subtest cursorB-vs-flipA-varying-size: SKIP (0.001s)
[444.633685] [126/133] (579s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[444.740469] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[449.269396] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.533s)
[450.452091] [127/133] (574s left) kms_pm_rpm (package-g7)
[452.079854] Starting subtest: package-g7
[452.084631] Subtest package-g7: SKIP (0.000s)
[452.763277] [128/133] (571s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[452.872757] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[459.388120] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.519s)
[459.535527] [129/133] (565s left) kms_flip (flip-vs-expired-vblank)
[459.646157] Starting subtest: flip-vs-expired-vblank
[459.650821] Starting dynamic subtest: A-eDP1
[468.354979] Dynamic subtest A-eDP1: SUCCESS (8.706s)
[468.364188] Starting dynamic subtest: B-eDP1
[476.992716] Dynamic subtest B-eDP1: SUCCESS (8.636s)
[477.006523] Starting dynamic subtest: C-eDP1
[485.603148] Dynamic subtest C-eDP1: SUCCESS (8.607s)
[485.614509] Starting dynamic subtest: D-eDP1
[494.230376] Dynamic subtest D-eDP1: SUCCESS (8.625s)
[494.235756] Subtest flip-vs-expired-vblank: SUCCESS (34.588s)
[495.413674] [130/133] (529s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[495.516079] Starting subtest: y-tiled-64bpp-rotate-0
[495.520451] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[495.633349] [131/133] (529s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[495.738663] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[502.044282] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.308s)
[503.238483] [132/133] (521s left) gem_ringfill (legacy-basic)
[508.891408] Starting subtest: legacy-basic
[508.893909] Starting dynamic subtest: default
[508.954910] Dynamic subtest default: SUCCESS (0.063s)
[508.966789] Starting dynamic subtest: render
[508.996624] Dynamic subtest render: SUCCESS (0.040s)
[509.006777] Starting dynamic subtest: bsd
[509.038848] Dynamic subtest bsd: SUCCESS (0.040s)
[509.049423] Starting dynamic subtest: bsd1
[509.078856] Dynamic subtest bsd1: SUCCESS (0.038s)
[509.091834] Starting dynamic subtest: bsd2
[509.120714] Dynamic subtest bsd2: SUCCESS (0.039s)
[509.133228] Starting dynamic subtest: blt
[509.164764] Dynamic subtest blt: SUCCESS (0.041s)
[509.176283] Starting dynamic subtest: vebox
[509.207881] Dynamic subtest vebox: SUCCESS (0.041s)
[509.210378] Subtest legacy-basic: SUCCESS (0.318s)
[509.311723] [133/133] (515s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[509.376207] Starting subtest: x-tiled-to-vebox-y-tiled
[509.380589] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[509.571310] 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.