[60.259074] Initializing watchdogs
[60.259140]   /dev/watchdog0
[60.279989] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[60.291823] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[60.295454] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.297613] [001/133] (960s left) gem_create (create-ext-placement-all)
[60.487886] Starting subtest: create-ext-placement-all
[60.489607] Subtest create-ext-placement-all: SUCCESS (0.000s)
[60.666625] [002/133] (960s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[60.756222] Starting subtest: map-fixed-invalidate-overlap
[60.758011] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[60.927851] [003/133] (959s left) gem_pipe_control_store_loop (fresh-buffer)
[61.009582] Starting subtest: fresh-buffer
[63.190378] Subtest fresh-buffer: SUCCESS (2.180s)
[63.408836] [004/133] (957s left) gem_mmap_offset (mmap-boundaries)
[63.478968] Starting subtest: mmap-boundaries
[63.479908] Starting dynamic subtest: lmem0
[63.605502] Dynamic subtest lmem0: SUCCESS (0.126s)
[63.613463] Starting dynamic subtest: smem0
[64.966358] Dynamic subtest smem0: SUCCESS (1.361s)
[64.967253] Subtest mmap-boundaries: SUCCESS (1.488s)
[65.271606] [005/133] (955s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[65.452385] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[65.454052] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[65.672758] [006/133] (955s left) kms_atomic (atomic-plane-damage)
[65.851178] Starting subtest: atomic-plane-damage
[66.300958] Starting dynamic subtest: pipe-A-DP-3
[67.405485] Dynamic subtest pipe-A-DP-3: SUCCESS (1.105s)
[67.406527] Subtest atomic-plane-damage: SUCCESS (1.554s)
[67.810693] [007/133] (953s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[68.056833] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[68.057647] Starting dynamic subtest: pipe-A-DP-3
[68.066008] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[68.073983] Starting dynamic subtest: pipe-B-DP-3
[68.082207] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[68.090116] Starting dynamic subtest: pipe-C-DP-3
[68.097990] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[68.105751] Starting dynamic subtest: pipe-D-DP-3
[68.115124] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[68.116938] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SKIP (0.004s)
[68.557065] [008/133] (952s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[68.740573] Starting subtest: psr-rgb101010-draw-mmap-wc
[68.742266] Subtest psr-rgb101010-draw-mmap-wc: SKIP (0.000s)
[68.919744] [009/133] (952s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[68.994476] Starting subtest: yf-tiled-to-vebox-x-tiled
[68.996655] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[69.287396] [010/133] (952s left) syncobj_timeline (wait-all-complex)
[69.357178] Starting subtest: wait-all-complex
[69.574072] Subtest wait-all-complex: SUCCESS (0.216s)
[69.719897] [011/133] (951s left) gem_pxp (create-valid-protected-context)
[72.314235] Starting subtest: create-valid-protected-context
[72.316311] Subtest create-valid-protected-context: SKIP (0.000s)
[72.453112] [012/133] (949s left) gem_exec_flush (basic-wb-rw-default)
[72.532488] Subtest basic-wb-rw-default: SKIP (0.000s)
[72.621466] [013/133] (948s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[72.806972] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[72.807953] Starting dynamic subtest: pipe-A-DP-3
[72.816443] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[72.824515] Starting dynamic subtest: pipe-B-DP-3
[72.832912] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[72.840751] Starting dynamic subtest: pipe-C-DP-3
[72.848920] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[72.856734] Starting dynamic subtest: pipe-D-DP-3
[72.866503] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[72.868528] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SKIP (0.004s)
[73.265113] [014/133] (948s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[73.447573] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[75.707346] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (2.261s)
[75.970048] [015/133] (945s left) kms_cursor_edge_walk (256x256-top-bottom)
[76.149107] Starting subtest: 256x256-top-bottom
[76.149970] Starting dynamic subtest: pipe-A-DP-3
[79.606181] Dynamic subtest pipe-A-DP-3: SUCCESS (3.456s)
[79.616276] Starting dynamic subtest: pipe-D-DP-3
[82.913444] Dynamic subtest pipe-D-DP-3: SUCCESS (3.306s)
[82.914382] Subtest 256x256-top-bottom: SUCCESS (6.765s)
[83.202154] [016/133] (938s left) kms_force_connector_basic (force-load-detect)
[83.299826] Starting subtest: force-load-detect
[83.301633] Subtest force-load-detect: SKIP (0.000s)
[83.578066] [017/133] (938s left) syncobj_wait (invalid-signal-zero-handles)
[83.645962] Starting subtest: invalid-signal-zero-handles
[83.646797] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[83.835087] [018/133] (938s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[84.025744] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (0.000s)
[84.109450] [019/133] (937s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[84.294724] Starting subtest: fbcpsr-rgb565-draw-render
[84.296434] Subtest fbcpsr-rgb565-draw-render: SKIP (0.000s)
[84.485067] [020/133] (937s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[84.670166] Starting subtest: primary-4-tiled-reflect-x-0
[95.042305] Subtest primary-4-tiled-reflect-x-0: SUCCESS (10.371s)
[95.463603] [021/133] (926s left) kms_setmode (clone-exclusive-crtc)
[95.531689] Starting subtest: clone-exclusive-crtc
[95.534786] Subtest clone-exclusive-crtc: SKIP (0.000s)
[95.678259] [022/133] (926s left) kms_addfb_basic (too-high)
[95.852771] Starting subtest: too-high
[95.853636] Subtest too-high: SUCCESS (0.001s)
[96.044953] [023/133] (926s left) perf_pmu (busy-accuracy-2)
[96.107591] Starting subtest: busy-accuracy-2
[96.108476] Starting dynamic subtest: rcs0
[99.175469] Dynamic subtest rcs0: SUCCESS (3.067s)
[99.185071] Starting dynamic subtest: bcs0
[102.247048] Dynamic subtest bcs0: SUCCESS (3.071s)
[102.256802] Starting dynamic subtest: vcs0
[105.317299] Dynamic subtest vcs0: SUCCESS (3.069s)
[105.338238] Starting dynamic subtest: vcs1
[108.398454] Dynamic subtest vcs1: SUCCESS (3.081s)
[108.408181] Starting dynamic subtest: vecs0
[111.462280] Dynamic subtest vecs0: SUCCESS (3.063s)
[111.472218] Starting dynamic subtest: vecs1
[114.525504] Dynamic subtest vecs1: SUCCESS (3.063s)
[114.535357] Starting dynamic subtest: ccs0
[117.591149] Dynamic subtest ccs0: SUCCESS (3.065s)
[117.592013] Subtest busy-accuracy-2: SUCCESS (21.483s)
[117.777926] [024/133] (904s left) kms_psr (pr-primary-mmap-gtt)
[117.954504] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[118.005670] [025/133] (904s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[118.185415] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[118.187037] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[118.380966] [026/133] (904s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[118.569381] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[118.571031] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[118.766043] [027/133] (903s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[118.948435] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling
[118.949287] Starting dynamic subtest: pipe-A-valid-mode
[120.731105] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.780s)
[120.732572] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (1.782s)
[121.049474] [028/133] (901s left) i915_drm_fdinfo (idle)
[121.112746] Starting subtest: idle
[121.113552] Starting dynamic subtest: rcs0
[121.727175] Dynamic subtest rcs0: SUCCESS (0.614s)
[121.739653] Starting dynamic subtest: bcs0
[122.235204] Dynamic subtest bcs0: SUCCESS (0.504s)
[122.244631] Starting dynamic subtest: vcs0
[122.739218] Dynamic subtest vcs0: SUCCESS (0.504s)
[122.749616] Starting dynamic subtest: vcs1
[123.245170] Dynamic subtest vcs1: SUCCESS (0.504s)
[123.254975] Starting dynamic subtest: vecs0
[123.751880] Dynamic subtest vecs0: SUCCESS (0.504s)
[123.761491] Starting dynamic subtest: vecs1
[124.255974] Dynamic subtest vecs1: SUCCESS (0.504s)
[124.266800] Starting dynamic subtest: ccs0
[124.762328] Dynamic subtest ccs0: SUCCESS (0.505s)
[124.763944] Subtest idle: SUCCESS (3.649s)
[124.912343] [029/133] (897s left) core_setmaster (master-drop-set-shared-fd)
[125.050945] Starting subtest: master-drop-set-shared-fd
[125.084040] Subtest master-drop-set-shared-fd: SUCCESS (0.033s)
[125.126436] [030/133] (897s left) kms_chamelium_color (ctm-negative)
[125.307174] Subtest ctm-negative: SKIP (0.000s)
[125.356913] [031/133] (897s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[125.428193] Starting subtest: multi-wait-for-submit-available-submitted
[125.429153] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.001s)
[125.614455] [032/133] (897s left) syncobj_timeline (invalid-signal-illegal-point)
[125.684967] Starting subtest: invalid-signal-illegal-point
[125.685942] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[125.833899] [033/133] (897s left) gem_mmap (bad-offset)
[125.903177] Subtest bad-offset: SKIP (0.000s)
[125.985653] [034/133] (896s left) i915_hangman (gt-error-state-capture)
[126.078949] Starting subtest: gt-error-state-capture
[126.079875] Starting dynamic subtest: rcs0
[136.086026] Dynamic subtest rcs0: SUCCESS (10.008s)
[136.096164] Starting dynamic subtest: bcs0
[145.072915] Dynamic subtest bcs0: SUCCESS (8.987s)
[145.082852] Starting dynamic subtest: vcs0
[155.076604] Dynamic subtest vcs0: SUCCESS (10.003s)
[155.088721] Starting dynamic subtest: vcs1
[165.033321] Dynamic subtest vcs1: SUCCESS (9.956s)
[165.043571] Starting dynamic subtest: vecs0
[175.109670] Dynamic subtest vecs0: SUCCESS (10.076s)
[175.121266] Starting dynamic subtest: vecs1
[185.099713] Dynamic subtest vecs1: SUCCESS (9.990s)
[185.112328] Starting dynamic subtest: ccs0
[195.064249] Dynamic subtest ccs0: SUCCESS (9.964s)
[195.065163] Subtest gt-error-state-capture: SUCCESS (68.987s)
[195.285764] [035/133] (827s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[195.468755] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[195.469608] Starting dynamic subtest: pipe-A-DP-3
[195.473055] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[195.482960] Starting dynamic subtest: pipe-B-DP-3
[195.486429] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[195.496193] Starting dynamic subtest: pipe-C-DP-3
[195.499688] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[195.509373] Starting dynamic subtest: pipe-D-DP-3
[195.512858] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[195.514498] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[195.951116] [036/133] (827s left) gem_exec_whisper (basic-fds)
[196.030812] Starting subtest: basic-fds
[206.468944] Subtest basic-fds: SUCCESS (10.437s)
[206.707407] [037/133] (816s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[206.904526] Starting subtest: psr-1p-primscrn-cur-indfb-move
[206.906223] Subtest psr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[207.104440] [038/133] (816s left) gem_exec_schedule (preempt-user)
[207.186186] Starting subtest: preempt-user
[207.187163] Starting dynamic subtest: rcs0
[207.255149] Dynamic subtest rcs0: SUCCESS (0.069s)
[207.265519] Starting dynamic subtest: bcs0
[207.295250] Dynamic subtest bcs0: SUCCESS (0.040s)
[207.305547] Starting dynamic subtest: vcs0
[207.330277] Dynamic subtest vcs0: SUCCESS (0.035s)
[207.340549] Starting dynamic subtest: vcs1
[207.367421] Dynamic subtest vcs1: SUCCESS (0.037s)
[207.378299] Starting dynamic subtest: vecs0
[207.404767] Dynamic subtest vecs0: SUCCESS (0.037s)
[207.415418] Starting dynamic subtest: vecs1
[207.439335] Dynamic subtest vecs1: SUCCESS (0.034s)
[207.450293] Starting dynamic subtest: ccs0
[207.475469] Dynamic subtest ccs0: SUCCESS (0.035s)
[207.476386] Subtest preempt-user: SUCCESS (0.290s)
[207.917320] [039/133] (815s left) kms_psr (psr2-primary-mmap-cpu)
[208.098567] Subtest psr2-primary-mmap-cpu: SKIP (0.000s)
[208.149177] [040/133] (815s left) gem_ctx_param (invalid-size-set)
[208.220467] Starting subtest: invalid-size-set
[208.222341] Subtest invalid-size-set: SUCCESS (0.001s)
[208.370128] [041/133] (815s left) kms_ccs (bad-aux-stride-y-tiled-ccs)
[208.546579] Starting subtest: bad-aux-stride-y-tiled-ccs
[208.547466] Starting dynamic subtest: pipe-A-DP-3
[208.555744] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[208.566054] Starting dynamic subtest: pipe-B-DP-3
[208.574317] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[208.584479] Starting dynamic subtest: pipe-C-DP-3
[208.592776] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[208.602995] Starting dynamic subtest: pipe-D-DP-3
[208.613352] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[208.615528] Subtest bad-aux-stride-y-tiled-ccs: SKIP (0.004s)
[209.048065] [042/133] (814s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[209.226768] Starting subtest: blocking-absolute-wf_vblank-interruptible
[209.231257] Starting dynamic subtest: A-DP3
[217.036436] Dynamic subtest A-DP3: SUCCESS (7.805s)
[217.049212] Starting dynamic subtest: B-DP3
[224.780196] Dynamic subtest B-DP3: SUCCESS (7.743s)
[224.791267] Starting dynamic subtest: C-DP3
[232.528085] Dynamic subtest C-DP3: SUCCESS (7.746s)
[232.541594] Starting dynamic subtest: D-DP3
[240.267415] Dynamic subtest D-DP3: SUCCESS (7.737s)
[240.269405] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (31.042s)
[240.610712] [043/133] (782s left) kms_psr2_su (page_flip-nv12)
[240.681006] Subtest page_flip-NV12: SKIP (0.000s)
[240.757970] [044/133] (782s left) gem_exec_balancer (sliced)
[240.840522] Starting subtest: sliced
[240.842602] Subtest sliced: SKIP (0.000s)
[241.275600] [045/133] (782s left) kms_plane_lowres (tiling-x)
[241.452007] Starting subtest: tiling-x
[241.452940] Starting dynamic subtest: pipe-A-DP-3
[251.991935] Dynamic subtest pipe-A-DP-3: SUCCESS (10.539s)
[252.093024] Starting dynamic subtest: pipe-B-DP-3
[262.435117] Dynamic subtest pipe-B-DP-3: SUCCESS (10.352s)
[262.551064] Starting dynamic subtest: pipe-C-DP-3
[273.229109] Dynamic subtest pipe-C-DP-3: SUCCESS (10.687s)
[273.345508] Starting dynamic subtest: pipe-D-DP-3
[283.550103] Dynamic subtest pipe-D-DP-3: SUCCESS (10.214s)
[283.656157] Subtest tiling-x: SUCCESS (42.204s)
[283.965035] [046/133] (739s left) kms_vblank (query-busy-hang)
[284.145247] Starting subtest: query-busy-hang
[284.146173] Starting dynamic subtest: pipe-A-DP-3
[310.595947] Dynamic subtest pipe-A-DP-3: SUCCESS (26.450s)
[310.609569] Starting dynamic subtest: pipe-D-DP-3
[335.534948] Dynamic subtest pipe-D-DP-3: SUCCESS (24.935s)
[335.535873] Subtest query-busy-hang: SUCCESS (51.392s)
[335.794644] [047/133] (688s left) gem_exec_balancer (hang)
[336.139587] Starting subtest: hang
[339.698202] Subtest hang: SUCCESS (3.560s)
[339.875446] [048/133] (684s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[340.058177] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[340.059971] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[340.259933] [049/133] (683s left) kms_flip (bo-too-big)
[340.437620] Starting subtest: bo-too-big
[340.442374] Starting dynamic subtest: A-DP3
[340.776109] Dynamic subtest A-DP3: SUCCESS (0.333s)
[340.817216] Starting dynamic subtest: B-DP3
[341.037582] Dynamic subtest B-DP3: SUCCESS (0.257s)
[341.064620] Starting dynamic subtest: C-DP3
[341.280897] Dynamic subtest C-DP3: SUCCESS (0.240s)
[341.318221] Starting dynamic subtest: D-DP3
[341.537729] Dynamic subtest D-DP3: SUCCESS (0.254s)
[341.542956] Subtest bo-too-big: SUCCESS (1.105s)
[341.951468] [050/133] (682s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[342.025581] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[342.027589] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[342.270363] [051/133] (681s left) kms_cursor_legacy (single-bo)
[342.451294] Starting subtest: single-bo
[342.452205] Starting dynamic subtest: pipe-A
[347.831189] Dynamic subtest pipe-A: SUCCESS (5.379s)
[347.841960] Starting dynamic subtest: pipe-B
[353.211640] Dynamic subtest pipe-B: SUCCESS (5.379s)
[353.222055] Starting dynamic subtest: pipe-C
[358.591436] Dynamic subtest pipe-C: SUCCESS (5.379s)
[358.601778] Starting dynamic subtest: pipe-D
[363.971040] Dynamic subtest pipe-D: SUCCESS (5.378s)
[363.981363] Starting dynamic subtest: all-pipes
[369.351184] Dynamic subtest all-pipes: SUCCESS (5.379s)
[369.352107] Subtest single-bo: SUCCESS (26.900s)
[369.483367] [052/133] (654s left) kms_pm_rpm (basic-pci-d3-state)
[370.980373] Starting subtest: basic-pci-d3-state
[371.628228] Subtest basic-pci-d3-state: SUCCESS (0.648s)
[371.892255] [053/133] (652s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[372.074902] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[374.793407] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (2.719s)
[375.041616] [054/133] (649s left) kms_pm_rpm (legacy-planes)
[377.059253] Starting subtest: legacy-planes
[377.061246] Starting dynamic subtest: plane-63
[379.753805] Dynamic subtest plane-63: SUCCESS (2.696s)
[379.797877] Starting dynamic subtest: plane-93
[382.659828] Dynamic subtest plane-93: SUCCESS (2.901s)
[382.703806] Starting dynamic subtest: plane-123
[385.360650] Dynamic subtest plane-123: SUCCESS (2.696s)
[385.405555] Starting dynamic subtest: plane-133
[388.157456] Dynamic subtest plane-133: SUCCESS (2.791s)
[388.163326] Subtest legacy-planes: SUCCESS (11.105s)
[388.606906] [055/133] (635s left) prime_self_import (basic-with_one_bo)
[388.651432] Starting subtest: basic-with_one_bo
[388.696586] Subtest basic-with_one_bo: SUCCESS (0.046s)
[388.900505] [056/133] (635s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[389.081147] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[389.082807] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[389.284103] [057/133] (635s left) kms_flip (modeset-vs-vblank-race)
[389.462955] Starting subtest: modeset-vs-vblank-race
[389.467594] Starting dynamic subtest: A-DP3
[392.793118] Dynamic subtest A-DP3: SUCCESS (3.325s)
[392.839491] Starting dynamic subtest: B-DP3
[396.051614] Dynamic subtest B-DP3: SUCCESS (3.253s)
[396.094381] Starting dynamic subtest: C-DP3
[399.321376] Dynamic subtest C-DP3: SUCCESS (3.265s)
[399.363269] Starting dynamic subtest: D-DP3
[402.594157] Dynamic subtest D-DP3: SUCCESS (3.267s)
[402.602569] Subtest modeset-vs-vblank-race: SUCCESS (13.139s)
[403.008151] [058/133] (621s left) gem_lmem_swapping (heavy-verify-random-ccs)
[405.707200] Starting subtest: heavy-verify-random-ccs
[405.707937] Starting dynamic subtest: lmem0
[420.927138] Dynamic subtest lmem0: SUCCESS (15.220s)
[420.928118] Subtest heavy-verify-random-ccs: SUCCESS (15.222s)
[422.656874] [FACT gem_lmem_swapping (heavy-verify-random-ccs)] deleted: kernel.kmod_is_loaded.i915: true
[422.659244] [059/133] (602s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[424.358177] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[424.359964] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[424.578944] [FACT kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)] new: kernel.kmod_is_loaded.i915: true
[424.582016] [060/133] (600s left) kms_chamelium_color (gamma)
[424.758396] Subtest gamma: SKIP (0.000s)
[424.835027] [061/133] (600s left) kms_cursor_legacy (cursorb-vs-flipa-varying-size)
[425.014291] Starting subtest: cursorB-vs-flipA-varying-size
[425.017281] Subtest cursorB-vs-flipA-varying-size: SKIP (0.002s)
[425.172959] [062/133] (599s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render)
[425.356167] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render
[428.156731] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (2.801s)
[428.419889] [063/133] (596s left) dumb_buffer (map-valid)
[428.493686] Starting subtest: map-valid
[428.494606] Subtest map-valid: SUCCESS (0.000s)
[428.688271] [064/133] (596s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[428.869268] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[428.870129] Starting dynamic subtest: pipe-A-valid-mode
[429.003539] Dynamic subtest pipe-A-valid-mode: SKIP (0.133s)
[429.005271] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.135s)
[429.308911] [065/133] (595s left) perf (i915-ref-count)
[429.442500] Starting subtest: i915-ref-count
[429.712313] Subtest i915-ref-count: SUCCESS (0.269s)
[429.892275] [066/133] (595s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[430.069300] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[430.070990] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[430.262996] [067/133] (595s left) gem_softpin (noreloc-interruptible)
[430.346892] Starting subtest: noreloc-interruptible
[435.765901] Subtest noreloc-interruptible: SUCCESS (5.419s)
[435.939342] [068/133] (589s left) kms_psr (fbc-psr2-primary-render)
[436.130473] Subtest fbc-psr2-primary-render: SKIP (0.000s)
[436.210314] [069/133] (589s left) kms_lease (atomic-implicit-crtc)
[436.389277] Starting subtest: atomic-implicit-crtc
[436.390181] Starting dynamic subtest: pipe-A-DP-3
[436.394406] Dynamic subtest pipe-A-DP-3: SUCCESS (0.002s)
[436.405025] Starting dynamic subtest: pipe-B-DP-3
[436.409256] Dynamic subtest pipe-B-DP-3: SUCCESS (0.010s)
[436.419505] Starting dynamic subtest: pipe-C-DP-3
[436.423713] Dynamic subtest pipe-C-DP-3: SUCCESS (0.010s)
[436.433944] Starting dynamic subtest: pipe-D-DP-3
[436.439364] Dynamic subtest pipe-D-DP-3: SUCCESS (0.009s)
[436.440342] Subtest atomic-implicit-crtc: SUCCESS (0.039s)
[436.622323] [070/133] (588s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[436.800951] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[437.028535] Starting dynamic subtest: pipe-A-DP-3
[439.295848] Dynamic subtest pipe-A-DP-3: SUCCESS (2.266s)
[439.539537] Starting dynamic subtest: pipe-B-DP-3
[441.623560] Dynamic subtest pipe-B-DP-3: SUCCESS (2.091s)
[441.826273] Starting dynamic subtest: pipe-C-DP-3
[443.907218] Dynamic subtest pipe-C-DP-3: SUCCESS (2.091s)
[444.128663] Starting dynamic subtest: pipe-D-DP-3
[446.209266] Dynamic subtest pipe-D-DP-3: SUCCESS (2.089s)
[446.210773] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (9.409s)
[446.709083] [071/133] (578s left) gem_exec_reloc (basic-wc-read-active)
[446.784406] Subtest basic-wc-read-active: SKIP (0.000s)
[446.849676] [072/133] (578s left) gem_readwrite (new-obj)
[446.931161] Subtest new-obj: SKIP (0.000s)
[447.033362] [073/133] (578s left) gem_mmap_gtt (basic-short)
[447.103218] Subtest basic-short: SKIP (0.000s)
[447.167454] [074/133] (578s left) kms_plane_multiple (tiling-yf)
[447.345454] Starting subtest: tiling-yf
[447.347264] Subtest tiling-yf: SKIP (0.000s)
[447.516702] [075/133] (578s left) kms_content_protection (dp-mst-type-0-hdcp14)
[447.763228] Starting subtest: dp-mst-type-0-hdcp14
[447.764956] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s)
[447.994485] [076/133] (577s left) gem_ctx_shared (q-in-order)
[448.076941] Starting subtest: Q-in-order
[448.077882] Starting dynamic subtest: rcs0
[448.409886] Dynamic subtest rcs0: SUCCESS (0.323s)
[448.434512] Starting dynamic subtest: bcs0
[448.589116] Dynamic subtest bcs0: SUCCESS (0.180s)
[448.600257] Starting dynamic subtest: vcs0
[448.778362] Dynamic subtest vcs0: SUCCESS (0.187s)
[448.788923] Starting dynamic subtest: vcs1
[448.956556] Dynamic subtest vcs1: SUCCESS (0.186s)
[448.967347] Starting dynamic subtest: vecs0
[449.144118] Dynamic subtest vecs0: SUCCESS (0.186s)
[449.155669] Starting dynamic subtest: vecs1
[449.333226] Dynamic subtest vecs1: SUCCESS (0.188s)
[449.344257] Starting dynamic subtest: ccs0
[449.525509] Dynamic subtest ccs0: SUCCESS (0.191s)
[449.526374] Subtest Q-in-order: SUCCESS (1.449s)
[449.923044] [FACT gem_ctx_shared (q-in-order)] new: kernel.kmod_is_loaded.vgem: true
[449.925278] [077/133] (576s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted)
[450.009432] Starting subtest: etime-single-wait-all-for-submit-unsubmitted
[450.116719] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.106s)
[450.288550] [078/133] (575s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc)
[450.485312] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc
[450.487153] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[450.693518] [079/133] (575s left) kms_big_fb (linear-8bpp-rotate-270)
[450.898335] Starting subtest: linear-8bpp-rotate-270
[450.960252] Subtest linear-8bpp-rotate-270: SKIP (0.061s)
[451.177326] [080/133] (575s left) api_intel_allocator (standalone)
[451.258534] Starting subtest: standalone
[451.302238] Subtest standalone: SUCCESS (0.045s)
[451.527657] [081/133] (574s left) core_auth (getclient-master-drop)
[451.575052] Starting subtest: getclient-master-drop
[451.621475] Subtest getclient-master-drop: SUCCESS (0.048s)
[451.844459] [082/133] (574s left) kms_psr (fbc-psr2-basic)
[452.031872] Subtest fbc-psr2-basic: SKIP (0.000s)
[452.086422] [083/133] (574s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[452.374106] Starting subtest: cursor-rapid-movement-32x32
[452.420262] Subtest cursor-rapid-movement-32x32: SKIP (0.044s)
[452.868611] [084/133] (573s left) gem_exec_schedule (noreorder-priority)
[453.077384] Starting subtest: noreorder-priority
[453.078358] Starting dynamic subtest: rcs0
[454.248280] Dynamic subtest rcs0: SUCCESS (1.170s)
[454.261236] Starting dynamic subtest: bcs0
[455.393420] Dynamic subtest bcs0: SUCCESS (1.144s)
[455.407540] Starting dynamic subtest: vcs0
[456.524452] Dynamic subtest vcs0: SUCCESS (1.130s)
[456.536623] Starting dynamic subtest: vcs1
[457.669011] Dynamic subtest vcs1: SUCCESS (1.143s)
[457.683470] Starting dynamic subtest: vecs0
[458.795199] Dynamic subtest vecs0: SUCCESS (1.125s)
[458.807237] Starting dynamic subtest: vecs1
[459.921389] Dynamic subtest vecs1: SUCCESS (1.125s)
[459.933432] Starting dynamic subtest: ccs0
[461.059437] Dynamic subtest ccs0: SUCCESS (1.137s)
[461.060502] Subtest noreorder-priority: SUCCESS (7.983s)
[461.380594] [085/133] (565s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[461.570538] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[461.572826] Starting dynamic subtest: pipe-A-DP-3
[461.581975] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[461.592435] Starting dynamic subtest: pipe-B-DP-3
[461.601795] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[461.612114] Starting dynamic subtest: pipe-C-DP-3
[461.621109] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[461.631549] Starting dynamic subtest: pipe-D-DP-3
[461.642187] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[461.644479] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.007s)
[462.038206] [086/133] (564s left) core_auth (many-magics)
[462.116521] Starting subtest: many-magics
[463.768403] Subtest many-magics: SUCCESS (1.653s)
[464.281635] [087/133] (562s left) i915_suspend (fence-restore-tiled2untiled)
[464.376703] Starting subtest: fence-restore-tiled2untiled
[464.378572] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[464.567436] [088/133] (562s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[464.750498] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[464.751387] Starting dynamic subtest: pipe-A
[464.854264] Dynamic subtest pipe-A: SUCCESS (0.103s)
[464.877498] Starting dynamic subtest: pipe-B
[465.066068] Dynamic subtest pipe-B: SUCCESS (0.210s)
[465.084589] Starting dynamic subtest: pipe-C
[465.260550] Dynamic subtest pipe-C: SUCCESS (0.193s)
[465.272713] Starting dynamic subtest: pipe-D
[465.456789] Dynamic subtest pipe-D: SUCCESS (0.195s)
[465.457851] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SUCCESS (0.707s)
[465.820348] [089/133] (561s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[466.019176] Starting subtest: y-tiled-64bpp-rotate-0
[466.020963] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[466.190689] [090/133] (560s left) gem_ctx_persistence (saturated-hostile)
[466.284642] Starting subtest: saturated-hostile
[466.285527] Starting dynamic subtest: rcs0
[467.152425] Dynamic subtest rcs0: SUCCESS (0.867s)
[467.167060] Starting dynamic subtest: bcs0
[467.941114] Dynamic subtest bcs0: SUCCESS (0.786s)
[467.954534] Starting dynamic subtest: vcs0
[468.738604] Dynamic subtest vcs0: SUCCESS (0.795s)
[468.751075] Starting dynamic subtest: vcs1
[469.531201] Dynamic subtest vcs1: SUCCESS (0.791s)
[469.544383] Starting dynamic subtest: vecs0
[470.322682] Dynamic subtest vecs0: SUCCESS (0.788s)
[470.335815] Starting dynamic subtest: vecs1
[471.110035] Dynamic subtest vecs1: SUCCESS (0.785s)
[471.122599] Starting dynamic subtest: ccs0
[471.928947] Dynamic subtest ccs0: SUCCESS (0.818s)
[471.930093] Subtest saturated-hostile: SUCCESS (5.645s)
[472.114213] [091/133] (554s left) kms_prop_blob (invalid-get-prop)
[472.193516] Starting subtest: invalid-get-prop
[472.194399] Subtest invalid-get-prop: SUCCESS (0.000s)
[472.396216] [092/133] (554s left) gem_mmap_gtt (basic-write)
[472.472149] Subtest basic-write: SKIP (0.000s)
[472.553414] [093/133] (554s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[472.738292] Starting subtest: cursorA-vs-flipA-varying-size
[483.713154] Subtest cursorA-vs-flipA-varying-size: SUCCESS (10.974s)
[484.009772] [094/133] (543s left) gem_linear_blits (interruptible)
[484.527124] Starting subtest: interruptible
[492.420682] Subtest interruptible: SUCCESS (7.893s)
[492.592266] [095/133] (534s left) gem_exec_params (sol-reset-invalid)
[492.714144] Starting subtest: sol-reset-invalid
[492.718443] Subtest sol-reset-invalid: SUCCESS (0.003s)
[492.931039] [096/133] (534s left) kms_color_pipeline (plane-lut1d)
[493.126288] Starting subtest: plane-lut1d
[493.156501] Starting dynamic subtest: pipe-A-DP-3
[493.556023] Dynamic subtest pipe-A-DP-3: SUCCESS (0.399s)
[493.736596] Starting dynamic subtest: pipe-B-DP-3
[494.072869] Dynamic subtest pipe-B-DP-3: SUCCESS (0.348s)
[494.272572] Starting dynamic subtest: pipe-C-DP-3
[494.606794] Dynamic subtest pipe-C-DP-3: SUCCESS (0.348s)
[494.784799] Starting dynamic subtest: pipe-D-DP-3
[495.123900] Dynamic subtest pipe-D-DP-3: SUCCESS (0.349s)
[495.230201] Subtest plane-lut1d: SUCCESS (2.104s)
[495.519398] [097/133] (532s left) gem_wait (busy)
[495.613444] Starting subtest: busy
[495.614422] Starting dynamic subtest: all-engines
[496.201291] Dynamic subtest all-engines: SUCCESS (0.589s)
[496.215253] Starting dynamic subtest: rcs0
[496.740956] Dynamic subtest rcs0: SUCCESS (0.538s)
[496.759451] Starting dynamic subtest: bcs0
[497.282224] Dynamic subtest bcs0: SUCCESS (0.540s)
[497.294751] Starting dynamic subtest: vcs0
[497.822151] Dynamic subtest vcs0: SUCCESS (0.539s)
[497.833448] Starting dynamic subtest: vcs1
[498.362211] Dynamic subtest vcs1: SUCCESS (0.539s)
[498.374647] Starting dynamic subtest: vecs0
[498.901328] Dynamic subtest vecs0: SUCCESS (0.538s)
[498.914214] Starting dynamic subtest: vecs1
[499.440072] Dynamic subtest vecs1: SUCCESS (0.538s)
[499.452542] Starting dynamic subtest: ccs0
[499.979036] Dynamic subtest ccs0: SUCCESS (0.538s)
[499.979990] Subtest busy: SUCCESS (4.368s)
[500.269604] [098/133] (527s left) sriov_basic (enable-vfs-autoprobe-on)
[500.354142] Subtest enable-vfs-autoprobe-on: SKIP (0.000s)
[500.442692] [099/133] (527s left) kms_chamelium_frames (vga-frame-dump)
[500.712898] Subtest vga-frame-dump: SKIP (0.000s)
[500.863117] [100/133] (526s left) gem_eio (throttle)
[501.118495] Starting subtest: throttle
[501.565288] Subtest throttle: SUCCESS (0.447s)
[501.850995] [101/133] (525s left) kms_frontbuffer_tracking (psr-abgr161616f-draw-mmap-wc)
[502.052093] Starting subtest: psr-abgr161616f-draw-mmap-wc
[502.053814] Subtest psr-abgr161616f-draw-mmap-wc: SKIP (0.000s)
[502.244435] [102/133] (525s left) gem_softpin (allocator-nopin)
[502.326828] Starting subtest: allocator-nopin
[502.573294] Subtest allocator-nopin: SUCCESS (0.246s)
[502.764122] [103/133] (525s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[502.962086] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[503.673708] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.712s)
[503.941825] [104/133] (524s left) kms_flip (busy-flip)
[504.128244] Starting subtest: busy-flip
[504.133022] Starting dynamic subtest: A-DP3
[504.961197] Dynamic subtest A-DP3: SUCCESS (0.828s)
[504.975405] Starting dynamic subtest: B-DP3
[505.731185] Dynamic subtest B-DP3: SUCCESS (0.768s)
[505.745398] Starting dynamic subtest: C-DP3
[506.498147] Dynamic subtest C-DP3: SUCCESS (0.766s)
[506.511803] Starting dynamic subtest: D-DP3
[507.253306] Dynamic subtest D-DP3: SUCCESS (0.753s)
[507.261988] Subtest busy-flip: SUCCESS (3.133s)
[507.677398] [105/133] (520s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[507.873195] Starting subtest: x-tiled-16bpp-rotate-270
[507.939243] Subtest x-tiled-16bpp-rotate-270: SKIP (0.065s)
[508.173048] [106/133] (520s left) kms_frontbuffer_tracking (fbcpsr-abgr161616f-draw-render)
[508.367065] Starting subtest: fbcpsr-abgr161616f-draw-render
[508.368761] Subtest fbcpsr-abgr161616f-draw-render: SKIP (0.000s)
[508.572479] [107/133] (519s left) kms_getfb (getfb2-accept-nv12)
[508.758423] Starting subtest: getfb2-accept-nv12
[508.760598] Subtest getfb2-accept-nv12: SUCCESS (0.002s)
[508.976436] [108/133] (519s left) gem_ctx_exec (basic-nohangcheck)
[509.059244] Starting subtest: basic-nohangcheck
[509.376946] Subtest basic-nohangcheck: SUCCESS (0.317s)
[509.554570] [109/133] (518s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions)
[509.741429] Starting subtest: short-flip-before-cursor-atomic-transitions
[510.795074] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (1.053s)
[511.129555] [110/133] (517s left) kms_cursor_crc (cursor-offscreen-256x256)
[511.547594] Starting subtest: cursor-offscreen-256x256
[511.552965] Starting dynamic subtest: pipe-A-DP-3
[514.119928] Dynamic subtest pipe-A-DP-3: SUCCESS (2.564s)
[514.173038] Starting dynamic subtest: pipe-D-DP-3
[516.646131] Dynamic subtest pipe-D-DP-3: SUCCESS (2.485s)
[516.647011] Subtest cursor-offscreen-256x256: SUCCESS (5.098s)
[517.049139] [111/133] (511s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[517.251432] Starting subtest: 4-tiled-8bpp-rotate-0
[518.762553] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.510s)
[518.961931] [112/133] (509s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[519.047994] Subtest writes-after-reads: SKIP (0.000s)
[519.106387] [113/133] (509s left) kms_frontbuffer_tracking (psr-slowdraw)
[519.296907] Starting subtest: psr-slowdraw
[519.298556] Subtest psr-slowdraw: SKIP (0.000s)
[519.500459] [114/133] (509s left) i915_pm_rc6_residency (rc6-idle)
[519.586935] Starting subtest: rc6-idle
[519.617822] Starting dynamic subtest: gt0-rcs0
[543.908142] Dynamic subtest gt0-rcs0: SUCCESS (24.289s)
[543.921754] Starting dynamic subtest: gt0-bcs0
[568.139262] Dynamic subtest gt0-bcs0: SUCCESS (24.228s)
[568.152923] Starting dynamic subtest: gt0-vcs0
[592.368449] Dynamic subtest gt0-vcs0: SUCCESS (24.226s)
[592.384211] Starting dynamic subtest: gt0-vecs0
[616.744110] Dynamic subtest gt0-vecs0: SUCCESS (24.370s)
[616.759666] Starting dynamic subtest: gt0-ccs0
[641.039270] Dynamic subtest gt0-ccs0: SUCCESS (24.291s)
[641.041495] Subtest rc6-idle: SUCCESS (121.449s)
[641.274610] [115/133] (387s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[641.466175] Starting subtest: fbc-modesetfrombusy
[642.829569] Subtest fbc-modesetfrombusy: SUCCESS (1.365s)
[643.041830] [116/133] (385s left) kms_psr (psr-cursor-render)
[643.228354] Subtest psr-cursor-render: SKIP (0.000s)
[643.293154] [117/133] (385s left) gem_exec_parallel (engines)
[643.382572] Starting subtest: engines
[643.383480] Starting dynamic subtest: basic
[644.969194] Dynamic subtest basic: SUCCESS (1.586s)
[644.984539] Starting dynamic subtest: contexts
[649.248882] Dynamic subtest contexts: SUCCESS (4.278s)
[649.262627] Starting dynamic subtest: fds
[654.022045] Dynamic subtest fds: SUCCESS (4.772s)
[654.034753] Starting dynamic subtest: userptr
[655.493148] Dynamic subtest userptr: SUCCESS (1.470s)
[655.494258] Subtest engines: SUCCESS (12.111s)
[655.859103] [118/133] (373s left) prime_busy (after)
[655.947131] Starting subtest: after
[655.952213] Starting dynamic subtest: rcs0
[656.008239] Dynamic subtest rcs0: SUCCESS (0.056s)
[656.022135] Starting dynamic subtest: bcs0
[656.059988] Dynamic subtest bcs0: SUCCESS (0.051s)
[656.074629] Starting dynamic subtest: vcs0
[656.099993] Dynamic subtest vcs0: SUCCESS (0.039s)
[656.119775] Starting dynamic subtest: vcs1
[656.139548] Dynamic subtest vcs1: SUCCESS (0.038s)
[656.159275] Starting dynamic subtest: vecs0
[656.180237] Dynamic subtest vecs0: SUCCESS (0.039s)
[656.200059] Starting dynamic subtest: vecs1
[656.221482] Dynamic subtest vecs1: SUCCESS (0.040s)
[656.241374] Starting dynamic subtest: ccs0
[656.263543] Dynamic subtest ccs0: SUCCESS (0.041s)
[656.371975] Subtest after: SUCCESS (0.425s)
[656.579494] [119/133] (372s left) gem_partial_pwrite_pread (write-display)
[656.663196] Subtest write-display: SKIP (0.000s)
[656.747310] [120/133] (372s left) gem_tiled_blits (basic)
[656.836443] Subtest basic: SKIP (0.000s)
[656.911626] [121/133] (372s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[657.099210] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[657.100916] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[657.300454] [122/133] (372s left) sysfs_defaults (readonly)
[657.388270] Starting subtest: readonly
[657.390479] Starting dynamic subtest: vecs0
[657.391344] Dynamic subtest vecs0: SUCCESS (0.000s)
[657.404178] Starting dynamic subtest: ccs0
[657.405204] Dynamic subtest ccs0: SUCCESS (0.000s)
[657.417129] Starting dynamic subtest: vcs0
[657.418116] Dynamic subtest vcs0: SUCCESS (0.000s)
[657.429860] Starting dynamic subtest: bcs0
[657.430762] Dynamic subtest bcs0: SUCCESS (0.000s)
[657.443121] Starting dynamic subtest: vecs1
[657.444340] Dynamic subtest vecs1: SUCCESS (0.000s)
[657.456224] Starting dynamic subtest: rcs0
[657.457496] Dynamic subtest rcs0: SUCCESS (0.000s)
[657.469161] Starting dynamic subtest: vcs1
[657.470120] Dynamic subtest vcs1: SUCCESS (0.000s)
[657.471327] Subtest readonly: SUCCESS (0.011s)
[657.550566] [123/133] (371s left) kms_dsc (dsc-with-formats)
[657.746436] Starting subtest: dsc-with-formats
[657.761945] Subtest dsc-with-formats: SKIP (0.002s)
[657.921771] [124/133] (371s left) prime_mmap (test_reprime)
[658.001719] Starting subtest: test_reprime
[658.002590] Starting dynamic subtest: test_reprime-smem
[658.048985] Dynamic subtest test_reprime-smem: SUCCESS (0.047s)
[658.061012] Starting dynamic subtest: test_reprime-lmem0
[658.237162] Dynamic subtest test_reprime-lmem0: SUCCESS (0.187s)
[658.238130] Subtest test_reprime: SUCCESS (0.236s)
[658.410339] [125/133] (371s left) gem_exec_params (rsvd2-dirt)
[658.493516] Starting subtest: rsvd2-dirt
[658.495238] Subtest rsvd2-dirt: SKIP (0.000s)
[658.716570] [126/133] (370s left) kms_lease (lessee-list)
[658.903827] Starting subtest: lessee-list
[658.906165] Starting dynamic subtest: pipe-A-DP-3
[658.906975] Dynamic subtest pipe-A-DP-3: SUCCESS (0.002s)
[658.921011] Starting dynamic subtest: pipe-B-DP-3
[658.921949] Dynamic subtest pipe-B-DP-3: SUCCESS (0.002s)
[658.934563] Starting dynamic subtest: pipe-C-DP-3
[658.935654] Dynamic subtest pipe-C-DP-3: SUCCESS (0.002s)
[658.947639] Starting dynamic subtest: pipe-D-DP-3
[658.948708] Dynamic subtest pipe-D-DP-3: SUCCESS (0.002s)
[658.949580] Subtest lessee-list: SUCCESS (0.014s)
[659.134943] [127/133] (370s left) kms_vrr (flip-dpms)
[659.319759] Starting subtest: flip-dpms
[659.322290] Subtest flip-dpms: SKIP (0.000s)
[659.486239] [128/133] (370s left) kms_frontbuffer_tracking (fbc-1p-rte)
[659.678068] Starting subtest: fbc-1p-rte
[663.185548] Subtest fbc-1p-rte: SUCCESS (3.509s)
[663.471012] [129/133] (366s left) gen9_exec_parse (batch-zero-length)
[663.557287] Subtest batch-zero-length: SKIP (0.000s)
[663.657885] [130/133] (366s left) prime_mmap (test_aperture_limit)
[663.735731] Starting subtest: test_aperture_limit
[663.736596] Starting dynamic subtest: test_aperture_limit-smem
[663.748187] Dynamic subtest test_aperture_limit-smem: SKIP (0.011s)
[663.750179] Subtest test_aperture_limit: SKIP (0.012s)
[663.917088] [131/133] (366s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[664.116570] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[664.118424] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[664.321953] [132/133] (365s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[664.516038] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[664.517773] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[664.721361] [133/133] (365s left) gem_exec_fence (long-history)
[665.329696] Starting subtest: long-history
[671.975246] Subtest long-history: SUCCESS (6.648s)
[673.261525] Closing watchdogs
results: parsing output: 0/ for test: gem_create
results: parsing output: 1/ for test: gem_userptr_blits
results: parsing output: 2/ for test: gem_pipe_control_store_loop
results: parsing output: 3/ for test: gem_mmap_offset
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_atomic
results: parsing output: 6/ for test: kms_ccs
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: gem_render_copy
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: gem_pxp
results: parsing output: 11/ for test: gem_exec_flush
results: parsing output: 12/ for test: kms_ccs
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_cursor_edge_walk
results: parsing output: 15/ for test: kms_force_connector_basic
results: parsing output: 16/ for test: syncobj_wait
results: parsing output: 17/ for test: kms_psr2_sf
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_rotation_crc
results: parsing output: 20/ for test: kms_setmode
results: parsing output: 21/ for test: kms_addfb_basic
results: parsing output: 22/ for test: perf_pmu
results: parsing output: 23/ for test: kms_psr
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_flip_scaled_crc
results: parsing output: 27/ for test: i915_drm_fdinfo
results: parsing output: 28/ for test: core_setmaster
results: parsing output: 29/ for test: kms_chamelium_color
results: parsing output: 30/ for test: syncobj_timeline
results: parsing output: 31/ for test: syncobj_timeline
results: parsing output: 32/ for test: gem_mmap
results: parsing output: 33/ for test: i915_hangman
results: parsing output: 34/ for test: kms_ccs
results: parsing output: 35/ for test: gem_exec_whisper
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_psr
results: parsing output: 39/ for test: gem_ctx_param
results: parsing output: 40/ for test: kms_ccs
results: parsing output: 41/ for test: kms_flip
results: parsing output: 42/ for test: kms_psr2_su
results: parsing output: 43/ for test: gem_exec_balancer
results: parsing output: 44/ for test: kms_plane_lowres
results: parsing output: 45/ for test: kms_vblank
results: parsing output: 46/ for test: gem_exec_balancer
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_flip
results: parsing output: 49/ for test: gem_render_copy
results: parsing output: 50/ for test: kms_cursor_legacy
results: parsing output: 51/ for test: kms_pm_rpm
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_pm_rpm
results: parsing output: 54/ for test: prime_self_import
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_flip
results: parsing output: 57/ for test: gem_lmem_swapping
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_chamelium_color
results: parsing output: 60/ for test: kms_cursor_legacy
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: dumb_buffer
results: parsing output: 63/ for test: kms_flip_scaled_crc
results: parsing output: 64/ for test: perf
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: gem_softpin
results: parsing output: 67/ for test: kms_psr
results: parsing output: 68/ for test: kms_lease
results: parsing output: 69/ for test: kms_async_flips
results: parsing output: 70/ for test: gem_exec_reloc
results: parsing output: 71/ for test: gem_readwrite
results: parsing output: 72/ for test: gem_mmap_gtt
results: parsing output: 73/ for test: kms_plane_multiple
results: parsing output: 74/ for test: kms_content_protection
results: parsing output: 75/ for test: gem_ctx_shared
results: parsing output: 76/ for test: syncobj_timeline
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: api_intel_allocator
results: parsing output: 80/ for test: core_auth
results: parsing output: 81/ for test: kms_psr
results: parsing output: 82/ for test: kms_cursor_crc
results: parsing output: 83/ for test: gem_exec_schedule
results: parsing output: 84/ for test: kms_ccs
results: parsing output: 85/ for test: core_auth
results: parsing output: 86/ for test: i915_suspend
results: parsing output: 87/ for test: kms_plane_scaling
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: gem_ctx_persistence
results: parsing output: 90/ for test: kms_prop_blob
results: parsing output: 91/ for test: gem_mmap_gtt
results: parsing output: 92/ for test: kms_cursor_legacy
results: parsing output: 93/ for test: gem_linear_blits
results: parsing output: 94/ for test: gem_exec_params
results: parsing output: 95/ for test: kms_color_pipeline
results: parsing output: 96/ for test: gem_wait
results: parsing output: 97/ for test: sriov_basic
results: parsing output: 98/ for test: kms_chamelium_frames
results: parsing output: 99/ for test: gem_eio
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: gem_softpin
results: parsing output: 102/ for test: kms_big_fb
results: parsing output: 103/ for test: kms_flip
results: parsing output: 104/ for test: kms_big_fb
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: kms_getfb
results: parsing output: 107/ for test: gem_ctx_exec
results: parsing output: 108/ for test: kms_cursor_legacy
results: parsing output: 109/ for test: kms_cursor_crc
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: i915_pm_rc6_residency
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_psr
results: parsing output: 116/ for test: gem_exec_parallel
results: parsing output: 117/ for test: prime_busy
results: parsing output: 118/ for test: gem_partial_pwrite_pread
results: parsing output: 119/ for test: gem_tiled_blits
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: sysfs_defaults
results: parsing output: 122/ for test: kms_dsc
results: parsing output: 123/ for test: prime_mmap
results: parsing output: 124/ for test: gem_exec_params
results: parsing output: 125/ for test: kms_lease
results: parsing output: 126/ for test: kms_vrr
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: gen9_exec_parse
results: parsing output: 129/ for test: prime_mmap
results: parsing output: 130/ for test: kms_big_fb
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: gem_exec_fence
Done.