[62.130989] Initializing watchdogs
[62.131101]   /dev/watchdog0
[62.150939] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[62.161703] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[62.165410] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[62.167725] [001/133] (960s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu)
[62.354365] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu
[62.356128] Subtest fbcpsr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[62.539910] [002/133] (960s left) gem_mmap_offset (mmap-unmap)
[62.608179] Starting subtest: mmap-unmap
[62.609148] Starting dynamic subtest: lmem0
[63.558062] Dynamic subtest lmem0: SUCCESS (0.945s)
[63.566538] Starting dynamic subtest: smem0
[64.896530] Dynamic subtest smem0: SUCCESS (1.332s)
[64.897398] Subtest mmap-unmap: SUCCESS (2.279s)
[65.099136] [003/133] (957s left) fbdev (pan)
[65.140284] Starting subtest: pan
[65.192030] Subtest pan: SUCCESS (0.052s)
[65.319612] [004/133] (957s left) kms_addfb_basic (unused-pitches)
[65.389905] Starting subtest: unused-pitches
[65.390799] Subtest unused-pitches: SUCCESS (0.000s)
[65.681931] [005/133] (957s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier)
[65.857232] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier
[65.862224] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier: SKIP (0.000s)
[66.026709] [006/133] (956s left) kms_cursor_crc (cursor-random-64x21)
[66.373606] Starting subtest: cursor-random-64x21
[66.388897] Starting dynamic subtest: pipe-A-DP-3
[71.023553] Dynamic subtest pipe-A-DP-3: SUCCESS (4.624s)
[71.071137] Starting dynamic subtest: pipe-D-DP-3
[75.495176] Dynamic subtest pipe-D-DP-3: SUCCESS (4.425s)
[75.496192] Subtest cursor-random-64x21: SUCCESS (9.106s)
[76.044113] [007/133] (947s left) kms_feature_discovery (display-2x)
[76.224267] Starting subtest: display-2x
[76.225982] Subtest display-2x: SKIP (0.000s)
[76.352398] [008/133] (946s left) i915_pm_rpm (gem-idle)
[78.070248] Starting subtest: gem-idle
[83.602511] Subtest gem-idle: SUCCESS (5.529s)
[83.887572] [009/133] (939s left) kms_psr (psr2-sprite-render)
[84.112489] Subtest psr2-sprite-render: SKIP (0.000s)
[84.167792] [010/133] (939s left) gem_lmem_swapping (parallel-random-verify-ccs)
[86.898050] Starting subtest: parallel-random-verify-ccs
[86.898918] Starting dynamic subtest: lmem0
[152.763768] Dynamic subtest lmem0: SUCCESS (65.850s)
[152.764642] Subtest parallel-random-verify-ccs: SUCCESS (65.851s)
[153.774222] [FACT gem_lmem_swapping (parallel-random-verify-ccs)] deleted: kernel.kmod_is_loaded.i915: true
[153.776181] [011/133] (869s left) kms_addfb_basic (basic-x-tiled-legacy)
[155.356667] Starting subtest: basic-x-tiled-legacy
[155.358923] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[155.555263] [FACT kms_addfb_basic (basic-x-tiled-legacy)] new: kernel.kmod_is_loaded.i915: true
[155.557664] [012/133] (867s left) gem_eio (in-flight-suspend)
[155.788964] Starting subtest: in-flight-suspend
[196.852536] Subtest in-flight-suspend: SUCCESS (11.980s)
[197.090692] [FACT gem_eio (in-flight-suspend)] new: kernel.kmod_is_loaded.vgem: true
[197.092497] [013/133] (826s left) gem_wait (write-wait)
[197.186926] Starting subtest: write-wait
[197.187842] Starting dynamic subtest: all-engines
[198.303381] Dynamic subtest all-engines: SUCCESS (1.116s)
[198.341489] Starting dynamic subtest: rcs0
[199.373342] Dynamic subtest rcs0: SUCCESS (1.069s)
[199.388241] Starting dynamic subtest: bcs0
[200.435294] Dynamic subtest bcs0: SUCCESS (1.061s)
[200.476431] Starting dynamic subtest: vcs0
[201.507349] Dynamic subtest vcs0: SUCCESS (1.071s)
[201.522876] Starting dynamic subtest: vcs1
[202.564261] Dynamic subtest vcs1: SUCCESS (1.056s)
[202.606945] Starting dynamic subtest: vecs0
[203.635033] Dynamic subtest vecs0: SUCCESS (1.070s)
[203.651227] Starting dynamic subtest: vecs1
[204.696303] Dynamic subtest vecs1: SUCCESS (1.060s)
[204.711014] Starting dynamic subtest: ccs0
[205.754578] Dynamic subtest ccs0: SUCCESS (1.057s)
[205.756363] Subtest write-wait: SUCCESS (8.567s)
[206.101207] [014/133] (817s left) kms_plane_scaling (planes-upscale-factor-0-25)
[206.286215] Starting subtest: planes-upscale-factor-0-25
[206.287049] Starting dynamic subtest: pipe-A
[206.403687] Dynamic subtest pipe-A: SUCCESS (0.117s)
[206.416255] Starting dynamic subtest: pipe-B
[206.622333] Dynamic subtest pipe-B: SUCCESS (0.218s)
[206.636416] Starting dynamic subtest: pipe-C
[206.818602] Dynamic subtest pipe-C: SUCCESS (0.196s)
[206.837955] Starting dynamic subtest: pipe-D
[207.031889] Dynamic subtest pipe-D: SUCCESS (0.213s)
[207.032808] Subtest planes-upscale-factor-0-25: SUCCESS (0.746s)
[207.402284] [015/133] (816s left) kms_psr (pr-cursor-render)
[207.585050] Subtest pr-cursor-render: SKIP (0.000s)
[207.638015] [016/133] (816s left) gem_exec_schedule (fairslice)
[207.726936] Starting subtest: fairslice
[207.727813] Starting dynamic subtest: rcs0
[209.798691] Dynamic subtest rcs0: SUCCESS (2.070s)
[209.813928] Starting dynamic subtest: bcs0
[211.822547] Dynamic subtest bcs0: SUCCESS (2.023s)
[211.834466] Starting dynamic subtest: vcs0
[213.842002] Dynamic subtest vcs0: SUCCESS (2.019s)
[213.853692] Starting dynamic subtest: vcs1
[215.863531] Dynamic subtest vcs1: SUCCESS (2.021s)
[215.875969] Starting dynamic subtest: vecs0
[217.883623] Dynamic subtest vecs0: SUCCESS (2.019s)
[217.895254] Starting dynamic subtest: vecs1
[219.905682] Dynamic subtest vecs1: SUCCESS (2.022s)
[219.917282] Starting dynamic subtest: ccs0
[221.925206] Dynamic subtest ccs0: SUCCESS (2.019s)
[221.926018] Subtest fairslice: SUCCESS (14.196s)
[222.379752] [017/133] (801s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[222.566688] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[222.569673] Starting dynamic subtest: A-DP3
[223.398084] Dynamic subtest A-DP3: SUCCESS (0.826s)
[223.422669] Starting dynamic subtest: B-DP3
[224.187834] Dynamic subtest B-DP3: SUCCESS (0.789s)
[224.208964] Starting dynamic subtest: C-DP3
[224.991236] Dynamic subtest C-DP3: SUCCESS (0.802s)
[225.003251] Starting dynamic subtest: D-DP3
[225.788900] Dynamic subtest D-DP3: SUCCESS (0.795s)
[225.792524] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (3.226s)
[226.126349] [018/133] (797s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[226.318389] Starting subtest: stress-xrgb8888-xtiled
[234.125747] Subtest stress-xrgb8888-xtiled: SUCCESS (7.806s)
[234.390277] [019/133] (789s left) gem_sync (basic-many-each)
[234.479841] Starting subtest: basic-many-each
[236.891312] Subtest basic-many-each: SUCCESS (2.411s)
[237.172667] [020/133] (786s left) syncobj_basic (create-signaled)
[237.247043] Starting subtest: create-signaled
[237.247909] Subtest create-signaled: SUCCESS (0.000s)
[237.444401] [021/133] (786s left) perf_pmu (busy-start)
[237.514317] Starting subtest: busy-start
[237.515172] Starting dynamic subtest: rcs0
[240.090262] Dynamic subtest rcs0: SUCCESS (2.574s)
[240.107322] Starting dynamic subtest: bcs0
[242.639008] Dynamic subtest bcs0: SUCCESS (2.546s)
[242.656540] Starting dynamic subtest: vcs0
[245.188285] Dynamic subtest vcs0: SUCCESS (2.547s)
[245.205407] Starting dynamic subtest: vcs1
[247.738281] Dynamic subtest vcs1: SUCCESS (2.547s)
[247.755437] Starting dynamic subtest: vecs0
[250.288227] Dynamic subtest vecs0: SUCCESS (2.547s)
[250.305194] Starting dynamic subtest: vecs1
[252.838209] Dynamic subtest vecs1: SUCCESS (2.547s)
[252.855770] Starting dynamic subtest: ccs0
[255.388212] Dynamic subtest ccs0: SUCCESS (2.547s)
[255.389961] Subtest busy-start: SUCCESS (17.872s)
[255.532798] [022/133] (768s left) gem_userptr_blits (sync-overlap)
[255.625948] Starting subtest: sync-overlap
[255.626917] Subtest sync-overlap: SUCCESS (0.000s)
[255.794527] [023/133] (768s left) kms_big_fb (linear-64bpp-rotate-180)
[255.990021] Starting subtest: linear-64bpp-rotate-180
[257.953089] Subtest linear-64bpp-rotate-180: SUCCESS (1.953s)
[258.143208] [024/133] (766s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[258.325673] Starting subtest: 2x-cursor-vs-flip-legacy
[258.328809] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.002s)
[258.469862] [025/133] (765s left) perf_pmu (busy)
[258.539823] Starting subtest: busy
[258.540852] Starting dynamic subtest: rcs0
[259.172335] Dynamic subtest rcs0: SUCCESS (0.631s)
[259.188530] Starting dynamic subtest: bcs0
[259.734229] Dynamic subtest bcs0: SUCCESS (0.559s)
[259.751159] Starting dynamic subtest: vcs0
[260.298362] Dynamic subtest vcs0: SUCCESS (0.562s)
[260.315119] Starting dynamic subtest: vcs1
[260.863174] Dynamic subtest vcs1: SUCCESS (0.562s)
[260.878751] Starting dynamic subtest: vecs0
[261.426180] Dynamic subtest vecs0: SUCCESS (0.561s)
[261.441979] Starting dynamic subtest: vecs1
[261.989186] Dynamic subtest vecs1: SUCCESS (0.561s)
[262.023217] Starting dynamic subtest: ccs0
[262.561184] Dynamic subtest ccs0: SUCCESS (0.570s)
[262.562984] Subtest busy: SUCCESS (4.022s)
[262.728096] [026/133] (761s left) kms_addfb_basic (no-handle)
[262.807968] Starting subtest: no-handle
[262.808900] Subtest no-handle: SUCCESS (0.000s)
[263.107939] [027/133] (761s left) dumb_buffer (map-invalid-size)
[263.184103] Starting subtest: map-invalid-size
[263.185019] Subtest map-invalid-size: SUCCESS (0.000s)
[263.355287] [028/133] (761s left) gem_exec_reloc (basic-gtt-cpu)
[263.438187] Subtest basic-gtt-cpu: SKIP (0.000s)
[263.504999] [029/133] (761s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[263.689694] Starting subtest: primary-x-tiled-reflect-x-180
[274.031872] Subtest primary-x-tiled-reflect-x-180: SUCCESS (10.340s)
[274.409490] [030/133] (750s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[274.595887] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[274.654362] [031/133] (750s left) gem_exec_schedule (preempt-hang)
[274.868470] Starting subtest: preempt-hang
[274.870246] Starting dynamic subtest: rcs0
[275.267028] Dynamic subtest rcs0: SUCCESS (0.400s)
[275.279757] Starting dynamic subtest: bcs0
[275.609128] Dynamic subtest bcs0: SUCCESS (0.341s)
[275.622299] Starting dynamic subtest: vcs0
[275.959934] Dynamic subtest vcs0: SUCCESS (0.350s)
[275.972960] Starting dynamic subtest: vcs1
[276.309911] Dynamic subtest vcs1: SUCCESS (0.350s)
[276.323202] Starting dynamic subtest: vecs0
[276.641920] Dynamic subtest vecs0: SUCCESS (0.331s)
[276.655241] Starting dynamic subtest: vecs1
[277.013615] Dynamic subtest vecs1: SUCCESS (0.363s)
[277.026310] Starting dynamic subtest: ccs0
[277.364427] Dynamic subtest ccs0: SUCCESS (0.359s)
[277.365286] Subtest preempt-hang: SUCCESS (2.499s)
[277.777565] [032/133] (747s left) gem_ctx_persistence (heartbeat-close)
[277.860641] Starting subtest: heartbeat-close
[277.862526] Subtest heartbeat-close: SKIP (0.000s)
[278.059595] [033/133] (746s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite)
[278.247482] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite
[278.249095] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[278.442607] [034/133] (746s left) gen9_exec_parse (bb-chained)
[278.527784] Subtest bb-chained: SKIP (0.000s)
[278.604863] [035/133] (746s left) sysfs_heartbeat_interval (mixed)
[278.693325] Starting subtest: mixed
[278.694216] Starting dynamic subtest: vecs0
[283.934031] Dynamic subtest vecs0: SUCCESS (5.239s)
[283.949923] Starting dynamic subtest: ccs0
[289.134588] Dynamic subtest ccs0: SUCCESS (5.198s)
[289.170209] Starting dynamic subtest: vcs0
[294.393849] Dynamic subtest vcs0: SUCCESS (5.256s)
[294.414144] Starting dynamic subtest: bcs0
[299.637026] Dynamic subtest bcs0: SUCCESS (5.241s)
[299.653365] Starting dynamic subtest: vecs1
[304.862131] Dynamic subtest vecs1: SUCCESS (5.222s)
[304.878135] Starting dynamic subtest: rcs0
[310.090913] Dynamic subtest rcs0: SUCCESS (5.226s)
[310.106948] Starting dynamic subtest: vcs1
[315.334222] Dynamic subtest vcs1: SUCCESS (5.242s)
[315.335562] Subtest mixed: SUCCESS (36.641s)
[315.563179] [036/133] (709s left) kms_content_protection (dp-mst-type-1)
[315.820945] Starting subtest: dp-mst-type-1
[315.823693] Subtest dp-mst-type-1: SKIP (0.000s)
[316.041639] [037/133] (709s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[316.237307] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[316.239031] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[316.429757] [038/133] (708s left) kms_vblank (ts-continuation-dpms-rpm)
[316.618119] Starting subtest: ts-continuation-dpms-rpm
[316.620027] Starting dynamic subtest: pipe-A-DP-3
[318.569738] Dynamic subtest pipe-A-DP-3: SUCCESS (1.949s)
[318.593243] Starting dynamic subtest: pipe-D-DP-3
[319.399988] Dynamic subtest pipe-D-DP-3: SUCCESS (0.826s)
[319.400894] Subtest ts-continuation-dpms-rpm: SUCCESS (2.782s)
[319.692484] [039/133] (705s left) gem_render_copy (linear-to-vebox-yf-tiled)
[319.776265] Starting subtest: linear-to-vebox-yf-tiled
[319.778143] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s)
[320.057163] [040/133] (705s left) vgem_basic (dmabuf-fence)
[320.125703] Starting subtest: dmabuf-fence
[320.126701] Subtest dmabuf-fence: SUCCESS (0.000s)
[320.250980] [041/133] (705s left) kms_psr (psr-primary-mmap-gtt)
[320.436271] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[320.504907] [042/133] (705s left) kms_chamelium_color (ctm-green-to-red)
[320.687751] Subtest ctm-green-to-red: SKIP (0.000s)
[320.755089] [043/133] (704s left) kms_color_pipeline (plane-lut1d-lut1d)
[320.944701] Starting subtest: plane-lut1d-lut1d
[320.975239] Starting dynamic subtest: pipe-A-DP-3
[321.374723] Dynamic subtest pipe-A-DP-3: SUCCESS (0.399s)
[321.578720] Starting dynamic subtest: pipe-B-DP-3
[321.915076] Dynamic subtest pipe-B-DP-3: SUCCESS (0.348s)
[322.120210] Starting dynamic subtest: pipe-C-DP-3
[322.456641] Dynamic subtest pipe-C-DP-3: SUCCESS (0.349s)
[322.664410] Starting dynamic subtest: pipe-D-DP-3
[323.000670] Dynamic subtest pipe-D-DP-3: SUCCESS (0.348s)
[323.110022] Subtest plane-lut1d-lut1d: SUCCESS (2.165s)
[323.418158] [044/133] (702s left) gem_eio (create-ext)
[323.752081] Starting subtest: create-ext
[324.197139] Subtest create-ext: SUCCESS (0.446s)
[324.476030] [045/133] (701s left) prime_busy (hang)
[324.556912] Starting subtest: hang
[324.559008] Starting dynamic subtest: rcs0
[350.604264] Dynamic subtest rcs0: SUCCESS (26.044s)
[350.617183] Starting dynamic subtest: bcs0
[357.695982] Dynamic subtest bcs0: SUCCESS (7.091s)
[357.709180] Starting dynamic subtest: vcs0
[364.743637] Dynamic subtest vcs0: SUCCESS (7.046s)
[364.756571] Starting dynamic subtest: vcs1
[371.711486] Dynamic subtest vcs1: SUCCESS (6.967s)
[371.725017] Starting dynamic subtest: vecs0
[378.686709] Dynamic subtest vecs0: SUCCESS (6.974s)
[378.700172] Starting dynamic subtest: vecs1
[385.734423] Dynamic subtest vecs1: SUCCESS (7.046s)
[385.747581] Starting dynamic subtest: ccs0
[399.569022] Dynamic subtest ccs0: SUCCESS (13.832s)
[399.569914] Subtest hang: SUCCESS (75.007s)
[399.763713] [046/133] (626s left) gem_eio (unwedge-stress)
[400.012185] Starting subtest: unwedge-stress
[400.013144] Starting dynamic subtest: render
[418.002797] Dynamic subtest render: SUCCESS (17.987s)
[418.024031] Starting dynamic subtest: bsd1
[436.045266] Dynamic subtest bsd1: SUCCESS (18.062s)
[436.074642] Starting dynamic subtest: bsd2
[454.029605] Dynamic subtest bsd2: SUCCESS (17.998s)
[454.043786] Starting dynamic subtest: blt
[470.034720] Dynamic subtest blt: SUCCESS (16.013s)
[470.048284] Starting dynamic subtest: vebox
[486.016246] Dynamic subtest vebox: SUCCESS (15.986s)
[486.017296] Subtest unwedge-stress: SUCCESS (86.055s)
[486.381614] [047/133] (539s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[486.572296] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[486.573976] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[486.769429] [048/133] (539s left) drm_read (fault-buffer)
[487.031049] Starting subtest: fault-buffer
[487.031963] Subtest fault-buffer: SUCCESS (0.001s)
[487.283220] [049/133] (538s left) gem_exec_balancer (bonded-true-hang)
[487.621306] Starting subtest: bonded-true-hang
[487.623108] Subtest bonded-true-hang: SKIP (0.000s)
[487.793695] [050/133] (538s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[487.973522] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs
[487.975745] Starting dynamic subtest: pipe-A-DP-3
[487.983880] Dynamic subtest pipe-A-DP-3: SKIP (0.001s)
[487.996871] Starting dynamic subtest: pipe-B-DP-3
[488.004988] Dynamic subtest pipe-B-DP-3: SKIP (0.001s)
[488.017782] Starting dynamic subtest: pipe-C-DP-3
[488.025813] Dynamic subtest pipe-C-DP-3: SKIP (0.001s)
[488.038638] Starting dynamic subtest: pipe-D-DP-3
[488.048874] Dynamic subtest pipe-D-DP-3: SKIP (0.001s)
[488.050789] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.008s)
[488.474401] [051/133] (537s left) kms_pm_rpm (modeset-pc8-residency-stress)
[490.186876] Starting subtest: modeset-pc8-residency-stress
[490.190377] Subtest modeset-pc8-residency-stress: SKIP (0.000s)
[490.637213] [052/133] (535s left) sw_sync (sync_busy_fork_unixsocket)
[490.684911] Starting subtest: sync_busy_fork_unixsocket
[490.693450] Subtest sync_busy_fork_unixsocket: SUCCESS (0.009s)
[490.832308] [053/133] (535s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[491.021648] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[491.023281] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[491.161232] [054/133] (535s left) gem_exec_schedule (semaphore-noskip)
[491.253962] Starting subtest: semaphore-noskip
[492.004551] Subtest semaphore-noskip: SUCCESS (0.750s)
[492.373701] [055/133] (534s left) gem_mmap_wc (bad-size)
[492.451774] Subtest bad-size: SKIP (0.000s)
[492.548734] [056/133] (534s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[492.741882] Starting subtest: fbcpsr-stridechange
[492.743454] Subtest fbcpsr-stridechange: SKIP (0.000s)
[492.937428] [057/133] (533s left) kms_chamelium_frames (hdmi-crc-single)
[493.196656] Subtest hdmi-crc-single: SKIP (0.000s)
[493.354623] [058/133] (533s left) syncobj_timeline (multi-wait-for-submit-signaled)
[493.433107] Starting subtest: multi-wait-for-submit-signaled
[493.434002] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[493.627736] [059/133] (533s left) gem_exec_fence (syncobj-invalid-wait)
[494.178991] Starting subtest: syncobj-invalid-wait
[494.179922] Subtest syncobj-invalid-wait: SUCCESS (0.001s)
[494.575003] [060/133] (532s left) gem_softpin (allocator-fork)
[494.659012] Starting subtest: allocator-fork
[496.966415] Subtest allocator-fork: SUCCESS (2.308s)
[497.155611] [061/133] (529s left) i915_query (test-query-geometry-subslices)
[497.232974] Starting subtest: test-query-geometry-subslices
[497.233894] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[497.413396] [062/133] (529s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[497.596629] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s)
[497.651077] [063/133] (529s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[497.843638] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[497.845244] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[498.041602] [064/133] (529s left) i915_drm_fdinfo (memory-info-shared)
[498.111039] Starting subtest: memory-info-shared
[498.111960] Starting dynamic subtest: lmem0
[498.186037] Dynamic subtest lmem0: SUCCESS (0.076s)
[498.200242] Starting dynamic subtest: smem0
[498.246993] Dynamic subtest smem0: SUCCESS (0.060s)
[498.248062] Subtest memory-info-shared: SUCCESS (0.138s)
[498.373356] [065/133] (528s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[498.458339] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[498.460060] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[498.759690] [066/133] (528s left) kms_chamelium_hpd (common-hpd-after-suspend)
[499.035376] Subtest common-hpd-after-suspend: SKIP (0.000s)
[499.190042] [067/133] (528s left) gem_exec_fence (basic-wait)
[499.391474] Starting subtest: basic-wait
[499.392363] Starting dynamic subtest: rcs0
[499.500738] Dynamic subtest rcs0: SUCCESS (0.108s)
[499.518747] Starting dynamic subtest: bcs0
[499.551333] Dynamic subtest bcs0: SUCCESS (0.049s)
[499.576865] Starting dynamic subtest: vcs0
[499.605263] Dynamic subtest vcs0: SUCCESS (0.052s)
[499.636942] Starting dynamic subtest: vcs1
[499.664318] Dynamic subtest vcs1: SUCCESS (0.058s)
[499.685529] Starting dynamic subtest: vecs0
[499.718472] Dynamic subtest vecs0: SUCCESS (0.053s)
[499.748262] Starting dynamic subtest: vecs1
[499.781512] Dynamic subtest vecs1: SUCCESS (0.061s)
[499.813689] Starting dynamic subtest: ccs0
[499.839401] Dynamic subtest ccs0: SUCCESS (0.056s)
[499.840290] Subtest basic-wait: SUCCESS (0.449s)
[500.600748] [068/133] (527s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[500.788723] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[500.790422] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[500.952155] [069/133] (526s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[501.034768] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s)
[501.120650] [070/133] (526s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-pwrite)
[501.314829] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-pwrite
[504.334118] Subtest fbc-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (3.020s)
[504.531603] [071/133] (523s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[504.715965] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[504.717752] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[505.049360] [072/133] (522s left) template (a)
[505.126255] Starting subtest: A
[505.127256] Subtest A: SUCCESS (0.000s)
[505.314874] [073/133] (522s left) kms_psr (fbc-psr-sprite-plane-onoff)
[505.500179] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.000s)
[505.558376] [074/133] (522s left) i915_query (query-topology-matches-eu-total)
[505.636178] Starting subtest: query-topology-matches-eu-total
[505.637053] Subtest query-topology-matches-eu-total: SUCCESS (0.000s)
[505.830581] [075/133] (522s left) kms_psr (fbc-psr2-primary-blt)
[506.028668] Subtest fbc-psr2-primary-blt: SKIP (0.000s)
[506.091628] [076/133] (522s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[506.285925] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[506.287696] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[506.499599] [077/133] (521s left) kms_frontbuffer_tracking (basic)
[506.689600] Starting subtest: basic
[509.412358] Subtest basic: SUCCESS (2.724s)
[509.664210] [078/133] (518s left) kms_cursor_crc (cursor-onscreen-128x42)
[510.055627] Starting subtest: cursor-onscreen-128x42
[510.060346] Starting dynamic subtest: pipe-A-DP-3
[512.796400] Dynamic subtest pipe-A-DP-3: SUCCESS (2.736s)
[512.838309] Starting dynamic subtest: pipe-D-DP-3
[515.548222] Dynamic subtest pipe-D-DP-3: SUCCESS (2.723s)
[515.549190] Subtest cursor-onscreen-128x42: SUCCESS (5.493s)
[515.993434] [079/133] (512s left) kms_universal_plane (universal-plane-functional)
[516.180010] Starting subtest: universal-plane-functional
[516.180947] Starting dynamic subtest: pipe-A-DP-3
[518.554168] Dynamic subtest pipe-A-DP-3: SUCCESS (2.373s)
[518.573780] Starting dynamic subtest: pipe-B-DP-3
[520.778924] Dynamic subtest pipe-B-DP-3: SUCCESS (2.223s)
[520.792941] Starting dynamic subtest: pipe-C-DP-3
[522.953707] Dynamic subtest pipe-C-DP-3: SUCCESS (2.173s)
[522.968319] Starting dynamic subtest: pipe-D-DP-3
[525.123069] Dynamic subtest pipe-D-DP-3: SUCCESS (2.168s)
[525.123986] Subtest universal-plane-functional: SUCCESS (8.945s)
[525.432370] [080/133] (503s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[525.636135] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[525.637894] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[525.831892] [081/133] (502s left) gem_lmem_swapping (massive-random)
[528.560807] Starting subtest: massive-random
[528.563647] Starting dynamic subtest: lmem0
[528.826857] Dynamic subtest lmem0: SUCCESS (0.265s)
[528.827910] Subtest massive-random: SUCCESS (0.267s)
[532.563169] [FACT gem_lmem_swapping (massive-random)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[532.564577] [FACT gem_lmem_swapping (massive-random)] deleted: kernel.kmod_is_loaded.i915: true
[532.566638] [082/133] (496s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[534.297775] Subtest psr2-plane-move-sf-dmg-area: SKIP (0.000s)
[534.389912] [FACT kms_psr2_sf (psr2-plane-move-sf-dmg-area)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[534.392237] [FACT kms_psr2_sf (psr2-plane-move-sf-dmg-area)] new: kernel.kmod_is_loaded.i915: true
[534.395361] [083/133] (494s left) gem_ctx_persistence (engines-mixed-process)
[534.497243] Starting subtest: engines-mixed-process
[534.498163] Starting dynamic subtest: rcs0
[535.971189] Dynamic subtest rcs0: SUCCESS (1.473s)
[535.995582] Starting dynamic subtest: bcs0
[537.971467] Dynamic subtest bcs0: SUCCESS (1.998s)
[537.985749] Starting dynamic subtest: vcs0
[539.982406] Dynamic subtest vcs0: SUCCESS (2.009s)
[539.996462] Starting dynamic subtest: vcs1
[541.975377] Dynamic subtest vcs1: SUCCESS (1.992s)
[541.989445] Starting dynamic subtest: vecs0
[543.963038] Dynamic subtest vecs0: SUCCESS (1.987s)
[543.980925] Starting dynamic subtest: vecs1
[545.945546] Dynamic subtest vecs1: SUCCESS (1.981s)
[545.959983] Starting dynamic subtest: ccs0
[548.003663] Dynamic subtest ccs0: SUCCESS (2.057s)
[548.007425] Subtest engines-mixed-process: SUCCESS (13.510s)
[548.161209] [084/133] (480s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[548.237296] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[548.346056] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.108s)
[548.514302] [085/133] (480s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[548.698484] Starting subtest: flip-vs-cursor-busy-crc-atomic
[549.489082] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.791s)
[549.801976] [086/133] (479s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[549.993910] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[549.995664] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[550.202277] [087/133] (478s left) kms_lease (multimaster-lease)
[550.385342] Starting subtest: multimaster-lease
[550.405397] Subtest multimaster-lease: SUCCESS (0.020s)
[550.599637] [088/133] (478s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[550.789028] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[550.789956] Starting dynamic subtest: pipe-A-DP-3
[550.793387] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[550.805511] Starting dynamic subtest: pipe-B-DP-3
[550.808923] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[550.821019] Starting dynamic subtest: pipe-C-DP-3
[550.824947] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[550.836770] Starting dynamic subtest: pipe-D-DP-3
[550.840062] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[550.841766] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.007s)
[551.277428] [089/133] (477s left) kms_async_flips (crc-atomic)
[551.463178] Starting subtest: crc-atomic
[551.693359] Starting dynamic subtest: pipe-A-DP-3
[554.101568] Dynamic subtest pipe-A-DP-3: SUCCESS (2.407s)
[554.310815] Starting dynamic subtest: pipe-B-DP-3
[556.533292] Dynamic subtest pipe-B-DP-3: SUCCESS (2.233s)
[556.752057] Starting dynamic subtest: pipe-C-DP-3
[558.949982] Dynamic subtest pipe-C-DP-3: SUCCESS (2.211s)
[559.128680] Starting dynamic subtest: pipe-D-DP-3
[561.333566] Dynamic subtest pipe-D-DP-3: SUCCESS (2.216s)
[561.334434] Subtest crc-atomic: SUCCESS (9.870s)
[561.810368] [090/133] (467s left) i915_hangman (detector)
[561.908895] Starting subtest: detector
[561.909767] Starting dynamic subtest: rcs0
[572.313114] Dynamic subtest rcs0: SUCCESS (10.404s)
[572.327283] Starting dynamic subtest: bcs0
[582.316575] Dynamic subtest bcs0: SUCCESS (10.001s)
[582.334331] Starting dynamic subtest: vcs0
[592.335195] Dynamic subtest vcs0: SUCCESS (10.016s)
[592.351485] Starting dynamic subtest: vcs1
[602.342550] Dynamic subtest vcs1: SUCCESS (10.005s)
[602.359984] Starting dynamic subtest: vecs0
[612.292079] Dynamic subtest vecs0: SUCCESS (9.947s)
[612.306175] Starting dynamic subtest: vecs1
[622.290137] Dynamic subtest vecs1: SUCCESS (9.997s)
[622.307517] Starting dynamic subtest: ccs0
[632.254151] Dynamic subtest ccs0: SUCCESS (9.963s)
[632.255116] Subtest detector: SUCCESS (70.343s)
[632.486438] [091/133] (396s left) kms_plane (pixel-format-4-tiled-modifier)
[632.671419] Starting subtest: pixel-format-4-tiled-modifier
[632.702122] Starting dynamic subtest: pipe-A-plane-0
[633.818921] Dynamic subtest pipe-A-plane-0: SUCCESS (1.116s)
[633.837671] Starting dynamic subtest: pipe-A-plane-3
[634.468346] Dynamic subtest pipe-A-plane-3: SUCCESS (0.647s)
[634.482946] Starting dynamic subtest: pipe-A-plane-5
[634.484877] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[634.689928] Starting dynamic subtest: pipe-B-plane-0
[635.616320] Dynamic subtest pipe-B-plane-0: SUCCESS (0.950s)
[635.663211] Starting dynamic subtest: pipe-B-plane-3
[636.283251] Dynamic subtest pipe-B-plane-3: SUCCESS (0.662s)
[636.299488] Starting dynamic subtest: pipe-B-plane-5
[636.301223] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[636.374163] Subtest pixel-format-4-tiled-modifier: SUCCESS (3.701s)
[636.734963] [092/133] (392s left) syncobj_timeline (etime-single-wait-submitted)
[636.816382] Starting subtest: etime-single-wait-submitted
[636.921639] Subtest etime-single-wait-submitted: SUCCESS (0.104s)
[637.099201] [093/133] (392s left) gem_cs_tlb (engines)
[637.183330] Starting subtest: engines
[637.184203] Starting dynamic subtest: rcs0
[639.338723] Dynamic subtest rcs0: SUCCESS (2.154s)
[639.351895] Starting dynamic subtest: bcs0
[641.493932] Dynamic subtest bcs0: SUCCESS (2.154s)
[641.507495] Starting dynamic subtest: vcs0
[643.646736] Dynamic subtest vcs0: SUCCESS (2.152s)
[643.659510] Starting dynamic subtest: vcs1
[645.802426] Dynamic subtest vcs1: SUCCESS (2.155s)
[645.815197] Starting dynamic subtest: vecs0
[647.955114] Dynamic subtest vecs0: SUCCESS (2.151s)
[647.968118] Starting dynamic subtest: vecs1
[650.108811] Dynamic subtest vecs1: SUCCESS (2.152s)
[650.121557] Starting dynamic subtest: ccs0
[652.261951] Dynamic subtest ccs0: SUCCESS (2.152s)
[652.262909] Subtest engines: SUCCESS (15.078s)
[652.431624] [094/133] (377s left) syncobj_timeline (invalid-transfer-illegal-handle)
[652.509116] Starting subtest: invalid-transfer-illegal-handle
[652.510033] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[652.674932] [095/133] (377s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[652.864931] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[652.866687] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[653.062731] [096/133] (376s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[653.252805] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[653.254520] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[653.425705] [097/133] (376s left) kms_flip (2x-flip-vs-modeset-vs-hang)
[653.605745] Starting subtest: 2x-flip-vs-modeset-vs-hang
[653.621177] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.015s)
[653.791314] [098/133] (376s left) syncobj_timeline (single-wait-for-submit-signaled)
[653.872101] Starting subtest: single-wait-for-submit-signaled
[653.873111] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[654.066823] [099/133] (375s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180)
[654.261526] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180
[655.534874] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.272s)
[655.767676] [100/133] (374s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[655.971623] Starting subtest: fbc-rgb565-draw-blt
[658.634863] Subtest fbc-rgb565-draw-blt: SUCCESS (2.664s)
[658.893866] [101/133] (371s left) gem_mmap_wc (close)
[658.980091] Subtest close: SKIP (0.000s)
[659.089910] [102/133] (371s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt)
[659.283714] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt
[659.285443] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[659.465067] [103/133] (370s left) gem_exec_store (pages)
[659.553933] Starting subtest: pages
[659.554955] Starting dynamic subtest: rcs0
[659.707165] Dynamic subtest rcs0: SUCCESS (0.153s)
[659.725989] Starting dynamic subtest: bcs0
[659.820432] Dynamic subtest bcs0: SUCCESS (0.112s)
[659.835509] Starting dynamic subtest: vcs0
[659.925177] Dynamic subtest vcs0: SUCCESS (0.104s)
[659.939280] Starting dynamic subtest: vcs1
[660.023430] Dynamic subtest vcs1: SUCCESS (0.097s)
[660.038492] Starting dynamic subtest: vecs0
[660.130405] Dynamic subtest vecs0: SUCCESS (0.106s)
[660.143405] Starting dynamic subtest: vecs1
[660.232577] Dynamic subtest vecs1: SUCCESS (0.101s)
[660.248350] Starting dynamic subtest: ccs0
[660.341129] Dynamic subtest ccs0: SUCCESS (0.107s)
[660.342326] Subtest pages: SUCCESS (0.788s)
[660.671424] [104/133] (369s left) kms_pm_dc (dc6-psr)
[661.864102] Starting subtest: dc6-psr
[661.865886] Subtest dc6-psr: SKIP (0.000s)
[662.048410] [105/133] (368s left) gem_fence_thrash (bo-write-verify-none)
[662.094915] Starting subtest: bo-write-verify-none
[662.124944] Subtest bo-write-verify-none: SKIP (0.029s)
[662.195288] [106/133] (368s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[662.379044] Starting subtest: basic-flip-after-cursor-atomic
[663.426150] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.048s)
[663.761383] [107/133] (366s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[663.947067] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[665.018956] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (1.072s)
[665.312209] [108/133] (365s left) kms_dp_linktrain_fallback (dsc-fallback)
[665.497057] Starting subtest: dsc-fallback
[665.499681] Subtest dsc-fallback: SKIP (0.001s)
[665.640349] [109/133] (365s left) api_intel_bb (blit-reloc-keep-cache)
[665.715295] Starting subtest: blit-reloc-keep-cache
[665.717053] Subtest blit-reloc-keep-cache: SKIP (0.001s)
[665.926447] [110/133] (365s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[666.109717] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[666.111974] Starting dynamic subtest: pipe-A-valid-mode
[668.875951] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.763s)
[668.877278] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SUCCESS (2.766s)
[669.166609] [111/133] (361s left) gen3_render_tiledx_blits
[669.379042] [112/133] (361s left) gem_softpin (overlap)
[669.463356] Starting subtest: overlap
[672.498304] Subtest overlap: SUCCESS (3.035s)
[672.688786] [113/133] (358s left) syncobj_wait (multi-wait-signaled)
[672.768046] Starting subtest: multi-wait-signaled
[672.769085] Subtest multi-wait-signaled: SUCCESS (0.000s)
[672.943254] [114/133] (358s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[673.127706] Starting subtest: plane-primary-toggle-with-vblank-wait
[673.130088] Starting dynamic subtest: pipe-A-DP-3
[673.344833] Dynamic subtest pipe-A-DP-3: SUCCESS (0.215s)
[673.474963] Starting dynamic subtest: pipe-B-DP-3
[673.755805] Dynamic subtest pipe-B-DP-3: SUCCESS (0.299s)
[673.863721] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (0.735s)
[674.131219] [115/133] (357s left) template (b)
[674.213336] Starting subtest: B
[674.214286] Subtest B: SUCCESS (0.000s)
[674.370915] [116/133] (357s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt)
[674.558766] Starting subtest: psr-rgb565-draw-mmap-gtt
[674.560385] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[674.761066] [117/133] (356s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[674.964336] Starting subtest: yf-tiled-32bpp-rotate-270
[674.966080] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[675.186696] [118/133] (356s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[675.375016] Starting subtest: flip-vs-cursor-toggle
[687.396208] Subtest flip-vs-cursor-toggle: SUCCESS (12.021s)
[687.716718] [119/133] (344s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-pgflip-blt)
[687.916887] Starting subtest: psr-2p-primscrn-indfb-pgflip-blt
[687.918647] Subtest psr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[688.113306] [120/133] (343s left) gem_userptr_blits (map-fixed-invalidate)
[688.207176] Starting subtest: map-fixed-invalidate
[688.208939] Subtest map-fixed-invalidate: SKIP (0.000s)
[688.361381] [121/133] (343s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[688.550042] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs
[688.550943] Starting dynamic subtest: pipe-A-DP-3
[688.559173] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[688.571874] Starting dynamic subtest: pipe-B-DP-3
[688.580214] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[688.592830] Starting dynamic subtest: pipe-C-DP-3
[688.601021] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[688.613703] Starting dynamic subtest: pipe-D-DP-3
[688.623789] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[688.625892] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SKIP (0.007s)
[689.051004] [122/133] (342s left) gem_mmap_gtt (basic-small-copy-xy)
[689.126025] Subtest basic-small-copy-XY: SKIP (0.000s)
[689.214452] [123/133] (342s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[689.401110] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[689.401962] Starting dynamic subtest: pipe-A
[689.961122] Dynamic subtest pipe-A: SUCCESS (0.560s)
[689.980942] Starting dynamic subtest: pipe-B
[690.591028] Dynamic subtest pipe-B: SUCCESS (0.628s)
[690.615531] Starting dynamic subtest: pipe-C
[691.238598] Dynamic subtest pipe-C: SUCCESS (0.645s)
[691.271912] Starting dynamic subtest: pipe-D
[691.884062] Dynamic subtest pipe-D: SUCCESS (0.642s)
[691.885175] Subtest plane-downscale-factor-0-5-with-modifiers: SUCCESS (2.485s)
[692.213377] [124/133] (339s left) gem_caching (writes)
[692.295042] Starting subtest: writes
[696.475020] Subtest writes: SUCCESS (4.180s)
[696.678726] [125/133] (335s left) kms_invalid_mode (bad-hsync-start)
[696.864478] Starting subtest: bad-hsync-start
[696.865333] Starting dynamic subtest: pipe-A-DP-3
[696.938216] Dynamic subtest pipe-A-DP-3: SUCCESS (0.073s)
[696.955256] Starting dynamic subtest: pipe-B-DP-3
[696.956436] Dynamic subtest pipe-B-DP-3: SUCCESS (0.001s)
[696.971367] Starting dynamic subtest: pipe-C-DP-3
[696.972504] Dynamic subtest pipe-C-DP-3: SUCCESS (0.001s)
[696.985330] Starting dynamic subtest: pipe-D-DP-3
[696.986231] Dynamic subtest pipe-D-DP-3: SUCCESS (0.001s)
[696.987156] Subtest bad-hsync-start: SUCCESS (0.083s)
[697.217963] [126/133] (335s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[697.412916] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[697.414655] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[697.596369] [127/133] (334s left) kms_busy (extended-modeset-hang-newfb)
[697.787728] Starting subtest: extended-modeset-hang-newfb
[697.790046] Starting dynamic subtest: pipe-A
[713.542296] Dynamic subtest pipe-A: SUCCESS (15.752s)
[713.565812] Starting dynamic subtest: pipe-D
[729.292837] Dynamic subtest pipe-D: SUCCESS (15.745s)
[729.294122] Subtest extended-modeset-hang-newfb: SUCCESS (31.508s)
[729.629105] [128/133] (302s left) gem_userptr_blits (unsync-unmap)
[729.712352] Subtest unsync-unmap: SKIP (0.000s)
[729.914572] [129/133] (302s left) kms_cursor_crc (cursor-sliding-256x85)
[730.346728] Starting subtest: cursor-sliding-256x85
[730.351221] Starting dynamic subtest: pipe-A-DP-3
[734.672185] Dynamic subtest pipe-A-DP-3: SUCCESS (4.320s)
[734.719919] Starting dynamic subtest: pipe-D-DP-3
[738.949001] Dynamic subtest pipe-D-DP-3: SUCCESS (4.241s)
[738.949996] Subtest cursor-sliding-256x85: SUCCESS (8.602s)
[739.372244] [130/133] (293s left) kms_flip (flip-vs-dpms-on-nop-interruptible)
[739.564204] Starting subtest: flip-vs-dpms-on-nop-interruptible
[739.569017] Starting dynamic subtest: A-DP3
[740.675880] Dynamic subtest A-DP3: SUCCESS (1.107s)
[740.700924] Starting dynamic subtest: B-DP3
[741.705164] Dynamic subtest B-DP3: SUCCESS (1.027s)
[741.750420] Starting dynamic subtest: C-DP3
[742.782866] Dynamic subtest C-DP3: SUCCESS (1.073s)
[742.799131] Starting dynamic subtest: D-DP3
[743.817213] Dynamic subtest D-DP3: SUCCESS (1.033s)
[743.819657] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (4.255s)
[744.184767] [131/133] (288s left) api_intel_bb (intel-bb-blit-x)
[744.265308] Starting subtest: intel-bb-blit-x
[744.941444] Subtest intel-bb-blit-x: SUCCESS (0.677s)
[745.101286] [132/133] (287s left) kms_flip (flip-vs-expired-vblank-interruptible)
[745.285080] Starting subtest: flip-vs-expired-vblank-interruptible
[745.289821] Starting dynamic subtest: A-DP3
[753.117229] Dynamic subtest A-DP3: SUCCESS (7.827s)
[753.139764] Starting dynamic subtest: B-DP3
[760.877210] Dynamic subtest B-DP3: SUCCESS (7.754s)
[760.923834] Starting dynamic subtest: C-DP3
[768.675303] Dynamic subtest C-DP3: SUCCESS (7.793s)
[768.691131] Starting dynamic subtest: D-DP3
[776.442094] Dynamic subtest D-DP3: SUCCESS (7.765s)
[776.450856] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (31.167s)
[776.825092] [133/133] (256s left) kms_flip (2x-flip-vs-rmfb)
[777.007820] Starting subtest: 2x-flip-vs-rmfb
[777.023178] Subtest 2x-flip-vs-rmfb: SKIP (0.015s)
[777.157545] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_mmap_offset
results: parsing output: 2/ for test: fbdev
results: parsing output: 3/ for test: kms_addfb_basic
results: parsing output: 4/ for test: kms_plane
results: parsing output: 5/ for test: kms_cursor_crc
results: parsing output: 6/ for test: kms_feature_discovery
results: parsing output: 7/ for test: i915_pm_rpm
results: parsing output: 8/ for test: kms_psr
results: parsing output: 9/ for test: gem_lmem_swapping
results: parsing output: 10/ for test: kms_addfb_basic
results: parsing output: 11/ for test: gem_eio
results: parsing output: 12/ for test: gem_wait
results: parsing output: 13/ for test: kms_plane_scaling
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: gem_exec_schedule
results: parsing output: 16/ for test: kms_flip
results: parsing output: 17/ for test: kms_pipe_stress
results: parsing output: 18/ for test: gem_sync
results: parsing output: 19/ for test: syncobj_basic
results: parsing output: 20/ for test: perf_pmu
results: parsing output: 21/ for test: gem_userptr_blits
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: kms_cursor_legacy
results: parsing output: 24/ for test: perf_pmu
results: parsing output: 25/ for test: kms_addfb_basic
results: parsing output: 26/ for test: dumb_buffer
results: parsing output: 27/ for test: gem_exec_reloc
results: parsing output: 28/ for test: kms_rotation_crc
results: parsing output: 29/ for test: kms_psr2_sf
results: parsing output: 30/ for test: gem_exec_schedule
results: parsing output: 31/ for test: gem_ctx_persistence
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: gen9_exec_parse
results: parsing output: 34/ for test: sysfs_heartbeat_interval
results: parsing output: 35/ for test: kms_content_protection
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: kms_vblank
results: parsing output: 38/ for test: gem_render_copy
results: parsing output: 39/ for test: vgem_basic
results: parsing output: 40/ for test: kms_psr
results: parsing output: 41/ for test: kms_chamelium_color
results: parsing output: 42/ for test: kms_color_pipeline
results: parsing output: 43/ for test: gem_eio
results: parsing output: 44/ for test: prime_busy
results: parsing output: 45/ for test: gem_eio
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: drm_read
results: parsing output: 48/ for test: gem_exec_balancer
results: parsing output: 49/ for test: kms_ccs
results: parsing output: 50/ for test: kms_pm_rpm
results: parsing output: 51/ for test: sw_sync
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: gem_exec_schedule
results: parsing output: 54/ for test: gem_mmap_wc
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_chamelium_frames
results: parsing output: 57/ for test: syncobj_timeline
results: parsing output: 58/ for test: gem_exec_fence
results: parsing output: 59/ for test: gem_softpin
results: parsing output: 60/ for test: i915_query
results: parsing output: 61/ for test: kms_psr2_sf
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: i915_drm_fdinfo
results: parsing output: 64/ for test: gem_render_copy
results: parsing output: 65/ for test: kms_chamelium_hpd
results: parsing output: 66/ for test: gem_exec_fence
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: gem_mmap_wc
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_ccs
results: parsing output: 71/ for test: template
results: parsing output: 72/ for test: kms_psr
results: parsing output: 73/ for test: i915_query
results: parsing output: 74/ for test: kms_psr
results: parsing output: 75/ for test: kms_big_fb
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_cursor_crc
results: parsing output: 78/ for test: kms_universal_plane
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: gem_lmem_swapping
results: parsing output: 81/ for test: kms_psr2_sf
results: parsing output: 82/ for test: gem_ctx_persistence
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: kms_cursor_legacy
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_lease
results: parsing output: 87/ for test: kms_ccs
results: parsing output: 88/ for test: kms_async_flips
results: parsing output: 89/ for test: i915_hangman
results: parsing output: 90/ for test: kms_plane
results: parsing output: 91/ for test: syncobj_timeline
results: parsing output: 92/ for test: gem_cs_tlb
results: parsing output: 93/ for test: syncobj_timeline
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_flip
results: parsing output: 97/ for test: syncobj_timeline
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: gem_mmap_wc
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gem_exec_store
results: parsing output: 103/ for test: kms_pm_dc
results: parsing output: 104/ for test: gem_fence_thrash
results: parsing output: 105/ for test: kms_cursor_legacy
results: parsing output: 106/ for test: kms_cursor_legacy
results: parsing output: 107/ for test: kms_dp_linktrain_fallback
results: parsing output: 108/ for test: api_intel_bb
results: parsing output: 109/ for test: kms_flip_scaled_crc
results: parsing output: 110/ for test: gen3_render_tiledx_blits
results: parsing output: 111/ for test: gem_softpin
results: parsing output: 112/ for test: syncobj_wait
results: parsing output: 113/ for test: kms_atomic_transition
results: parsing output: 114/ for test: template
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: kms_cursor_legacy
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: gem_userptr_blits
results: parsing output: 120/ for test: kms_ccs
results: parsing output: 121/ for test: gem_mmap_gtt
results: parsing output: 122/ for test: kms_plane_scaling
results: parsing output: 123/ for test: gem_caching
results: parsing output: 124/ for test: kms_invalid_mode
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_busy
results: parsing output: 127/ for test: gem_userptr_blits
results: parsing output: 128/ for test: kms_cursor_crc
results: parsing output: 129/ for test: kms_flip
results: parsing output: 130/ for test: api_intel_bb
results: parsing output: 131/ for test: kms_flip
results: parsing output: 132/ for test: kms_flip
Done.