[57.488731] Initializing watchdogs
[57.488787]   /dev/watchdog0
[57.502636] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.507039] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.509300] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.512774] [001/133] (960s left) kms_psr (psr-no-drrs)
[57.641988] Starting subtest: psr-no-drrs
[57.644293] Starting dynamic subtest: eDP-1
[59.238611] Dynamic subtest eDP-1: SUCCESS (1.606s)
[59.241016] Subtest psr-no-drrs: SUCCESS (1.607s)
[60.119868] [002/133] (957s left) perf (non-sampling-read-error)
[60.249168] Starting subtest: non-sampling-read-error
[60.258665] Subtest non-sampling-read-error: SUCCESS (0.009s)
[60.297114] [003/133] (957s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[60.404590] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[64.325899] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (3.941s)
[65.498147] [004/133] (952s left) kms_pm_rpm (i2c)
[67.046296] Starting subtest: i2c
[72.478627] Subtest i2c: SUCCESS (5.440s)
[72.561326] [005/133] (945s left) gem_mmap_gtt (flink-race)
[72.620098] Subtest flink-race: SKIP (0.000s)
[72.679582] [006/133] (945s left) gen7_exec_parse (load-register-reg)
[72.734534] Subtest load-register-reg: SKIP (0.000s)
[72.806211] [007/133] (945s left) kms_chamelium_color (ctm-max)
[72.892057] Subtest ctm-max: SKIP (0.000s)
[72.934908] [008/133] (945s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[72.986543] Starting subtest: wait-all-for-submit-delayed-submit
[73.090843] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.104s)
[73.162108] [009/133] (945s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[73.257962] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[73.262351] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[73.365448] [010/133] (944s left) gem_mmap_wc (set-cache-level)
[73.423163] Subtest set-cache-level: SKIP (0.000s)
[73.478856] [011/133] (944s left) kms_selftest (drm_dp_mst_helper)
[73.513584] Starting subtest: drm_dp_mst_helper
[73.522831] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[73.627074] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.104s)
[73.635991] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[73.737318] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.109s)
[73.745602] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[73.862547] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.126s)
[73.864795] Subtest drm_dp_mst_helper: SUCCESS (0.349s)
[74.035907] [012/133] (944s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[74.141649] Starting subtest: fbcpsr-tiling-y
[74.145973] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[74.227506] [013/133] (944s left) kms_atomic_interruptible (legacy-pageflip)
[74.325730] Starting subtest: legacy-pageflip
[74.327992] Starting dynamic subtest: pipe-A-eDP-1
[81.780633] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.457s)
[81.783071] Subtest legacy-pageflip: SUCCESS (7.458s)
[82.612045] [014/133] (935s left) gem_exec_schedule (pi-ringfull)
[82.791674] Starting subtest: pi-ringfull
[82.793817] Starting dynamic subtest: rcs0
[82.833922] Dynamic subtest rcs0: SUCCESS (0.045s)
[82.846288] Starting dynamic subtest: bcs0
[82.861258] Dynamic subtest bcs0: SUCCESS (0.027s)
[82.871653] Starting dynamic subtest: vcs0
[82.887800] Dynamic subtest vcs0: SUCCESS (0.026s)
[82.898576] Starting dynamic subtest: vcs1
[82.914465] Dynamic subtest vcs1: SUCCESS (0.026s)
[82.925846] Starting dynamic subtest: vecs0
[82.944196] Dynamic subtest vecs0: SUCCESS (0.029s)
[82.956563] Starting dynamic subtest: ccs0
[82.971234] Dynamic subtest ccs0: SUCCESS (0.026s)
[82.973352] Subtest pi-ringfull: SUCCESS (0.182s)
[83.194280] [FACT gem_exec_schedule (pi-ringfull)] new: kernel.kmod_is_loaded.vgem: true
[83.197647] [015/133] (935s left) dmabuf_sync_file (export-before-signal)
[83.240255] Starting subtest: export-before-signal
[83.242530] Subtest export-before-signal: SUCCESS (0.001s)
[83.298268] [016/133] (935s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[83.365599] Starting subtest: multi-wait-for-submit-submitted-signaled
[83.367566] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[83.466728] [017/133] (935s left) kms_pm_lpsp (screens-disabled)
[84.572183] Starting subtest: screens-disabled
[84.576788] Subtest screens-disabled: SKIP (0.000s)
[84.640218] [018/133] (934s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[84.701697] Starting subtest: y-tiled-ccs-to-x-tiled
[84.706266] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[84.882986] [019/133] (933s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[84.946885] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[84.951436] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[85.138253] [020/133] (933s left) kms_flip (2x-flip-vs-suspend)
[85.241842] Starting subtest: 2x-flip-vs-suspend
[85.251656] Subtest 2x-flip-vs-suspend: SKIP (0.011s)
[85.328076] [021/133] (933s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0)
[85.433179] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0
[85.437211] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[85.522207] [022/133] (933s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[85.577884] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[85.681543] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.103s)
[85.768160] [023/133] (933s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[85.850129] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs
[85.852461] Starting dynamic subtest: pipe-A-eDP-1
[86.690343] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.828s)
[86.699298] Starting dynamic subtest: pipe-B-eDP-1
[88.313039] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.624s)
[88.323916] Starting dynamic subtest: pipe-C-eDP-1
[89.878580] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.563s)
[89.888284] Starting dynamic subtest: pipe-D-eDP-1
[91.392507] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.513s)
[91.394753] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.533s)
[92.520082] [024/133] (926s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[92.635065] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[93.680254] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.046s)
[93.805022] [025/133] (925s left) kms_feature_discovery (dp-mst)
[93.907394] Starting subtest: dp-mst
[93.911106] Subtest dp-mst: SKIP (0.000s)
[93.982113] [026/133] (925s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling)
[94.079891] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling
[94.081856] Starting dynamic subtest: pipe-A-default-mode
[95.275786] Dynamic subtest pipe-A-default-mode: SKIP (1.193s)
[95.280689] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.194s)
[95.432396] [027/133] (923s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[95.526719] Starting subtest: fbc-psr2-cursor-mmap-cpu
[95.529053] Starting dynamic subtest: eDP-1
[95.533189] Dynamic subtest eDP-1: SKIP (0.000s)
[95.537245] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.001s)
[95.600132] [028/133] (923s left) gem_exec_params (cliprects_ptr-dirt)
[95.669315] Starting subtest: cliprects_ptr-dirt
[95.671692] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[95.786258] [029/133] (923s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[95.875587] Starting subtest: compare-crc-sanitycheck-xr24
[95.878010] Starting dynamic subtest: pipe-A-eDP-1
[96.539841] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.665s)
[96.548377] Starting dynamic subtest: pipe-B-eDP-1
[97.866461] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.322s)
[97.876185] Starting dynamic subtest: pipe-C-eDP-1
[99.108385] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.242s)
[99.118076] Starting dynamic subtest: pipe-D-eDP-1
[100.355603] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.244s)
[100.357561] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.481s)
[101.181385] [030/133] (917s left) i915_pm_freq_api (freq-suspend)
[101.251358] Starting subtest: freq-suspend
[101.253790] Starting dynamic subtest: gt0
[117.275233] Dynamic subtest gt0: SUCCESS (1.341s)
[117.290332] Starting dynamic subtest: gt1
[133.282369] Dynamic subtest gt1: SUCCESS (1.205s)
[133.284783] Subtest freq-suspend: SUCCESS (2.548s)
[133.364540] [031/133] (885s left) drm_read (fault-buffer)
[133.537531] Starting subtest: fault-buffer
[133.539734] Subtest fault-buffer: SUCCESS (0.000s)
[133.673323] [032/133] (885s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-pwrite)
[133.767992] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-pwrite
[140.692638] Subtest fbc-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (7.046s)
[141.821018] [033/133] (877s left) gem_exec_reloc (basic-concurrent0)
[141.895492] Subtest basic-concurrent0: SKIP (0.000s)
[141.967890] [034/133] (877s left) gem_lmem_swapping (random)
[142.013119] Subtest random: SKIP (0.000s)
[142.050693] [035/133] (877s left) gem_ctx_persistence (heartbeat-close)
[142.110492] Starting subtest: heartbeat-close
[142.114940] Subtest heartbeat-close: SKIP (0.000s)
[142.237123] [036/133] (877s left) api_intel_allocator (execbuf-with-allocator)
[142.297964] Starting subtest: execbuf-with-allocator
[142.302975] Subtest execbuf-with-allocator: SUCCESS (0.005s)
[142.436034] [037/133] (877s left) syncobj_wait (single-wait-all-submitted)
[142.496342] Starting subtest: single-wait-all-submitted
[142.602875] Subtest single-wait-all-submitted: SUCCESS (0.107s)
[142.690296] [038/133] (876s left) gem_exec_schedule (u-fairslice)
[142.770202] Starting subtest: u-fairslice
[142.772574] Starting dynamic subtest: rcs0
[144.794747] Dynamic subtest rcs0: SUCCESS (2.038s)
[144.804405] Starting dynamic subtest: bcs0
[146.820335] Dynamic subtest bcs0: SUCCESS (2.035s)
[146.832645] Starting dynamic subtest: vcs0
[148.837593] Dynamic subtest vcs0: SUCCESS (2.027s)
[148.846336] Starting dynamic subtest: vcs1
[150.856666] Dynamic subtest vcs1: SUCCESS (2.025s)
[150.866138] Starting dynamic subtest: vecs0
[152.873858] Dynamic subtest vecs0: SUCCESS (2.022s)
[152.882475] Starting dynamic subtest: ccs0
[154.895267] Dynamic subtest ccs0: SUCCESS (2.024s)
[154.897472] Subtest u-fairslice: SUCCESS (12.176s)
[155.209598] [039/133] (864s left) gem_exec_schedule (u-submit-late-slice)
[155.286805] Starting subtest: u-submit-late-slice
[155.288828] Starting dynamic subtest: rcs0
[155.342607] Dynamic subtest rcs0: SUCCESS (0.058s)
[155.354873] Starting dynamic subtest: bcs0
[155.388426] Dynamic subtest bcs0: SUCCESS (0.046s)
[155.398223] Starting dynamic subtest: vcs0
[155.434844] Dynamic subtest vcs0: SUCCESS (0.044s)
[155.444620] Starting dynamic subtest: vcs1
[155.486487] Dynamic subtest vcs1: SUCCESS (0.052s)
[155.501438] Starting dynamic subtest: vecs0
[155.528812] Dynamic subtest vecs0: SUCCESS (0.042s)
[155.541007] Starting dynamic subtest: ccs0
[155.576188] Dynamic subtest ccs0: SUCCESS (0.047s)
[155.578476] Subtest u-submit-late-slice: SUCCESS (0.293s)
[157.440908] [040/133] (862s left) perf_pmu (busy-accuracy-50)
[157.484938] Starting subtest: busy-accuracy-50
[157.487142] Starting dynamic subtest: rcs0
[159.025247] Dynamic subtest rcs0: SUCCESS (1.542s)
[159.035738] Starting dynamic subtest: bcs0
[160.570887] Dynamic subtest bcs0: SUCCESS (1.546s)
[160.582273] Starting dynamic subtest: vcs0
[162.110840] Dynamic subtest vcs0: SUCCESS (1.539s)
[162.122221] Starting dynamic subtest: vcs1
[163.654307] Dynamic subtest vcs1: SUCCESS (1.544s)
[163.664849] Starting dynamic subtest: vecs0
[165.191171] Dynamic subtest vecs0: SUCCESS (1.535s)
[165.200921] Starting dynamic subtest: ccs0
[166.741172] Dynamic subtest ccs0: SUCCESS (1.546s)
[166.743472] Subtest busy-accuracy-50: SUCCESS (9.263s)
[166.856094] [041/133] (852s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[166.970972] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[167.362931] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[170.118255] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.753s)
[170.133576] Starting dynamic subtest: pipe-A-eDP-1-4
[172.294073] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.174s)
[172.306604] Starting dynamic subtest: pipe-A-eDP-1-4
[174.303696] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.010s)
[174.316540] Starting dynamic subtest: pipe-A-eDP-1-x
[176.505145] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.200s)
[176.898646] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[179.650626] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.759s)
[179.662579] Starting dynamic subtest: pipe-B-eDP-1-4
[181.836591] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.186s)
[181.852799] Starting dynamic subtest: pipe-B-eDP-1-4
[183.846237] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[183.857275] Starting dynamic subtest: pipe-B-eDP-1-x
[186.047205] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.201s)
[186.419120] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[189.171098] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.759s)
[189.182394] Starting dynamic subtest: pipe-C-eDP-1-4
[191.357442] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.186s)
[191.368904] Starting dynamic subtest: pipe-C-eDP-1-4
[193.366062] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[193.378619] Starting dynamic subtest: pipe-C-eDP-1-x
[195.544028] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s)
[195.911912] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[198.700577] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.797s)
[198.712656] Starting dynamic subtest: pipe-D-eDP-1-4
[200.874015] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s)
[200.885608] Starting dynamic subtest: pipe-D-eDP-1-4
[202.883635] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.010s)
[202.893281] Starting dynamic subtest: pipe-D-eDP-1-x
[205.050207] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.167s)
[205.052580] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.084s)
[206.277326] [042/133] (813s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[206.397447] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[210.877352] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.487s)
[212.080098] [043/133] (807s left) kms_vblank (ts-continuation-suspend)
[212.180510] Starting subtest: ts-continuation-suspend
[212.182654] Starting dynamic subtest: pipe-A-eDP-1
[228.571457] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.531s)
[228.586290] Starting dynamic subtest: pipe-D-eDP-1
[245.598408] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.214s)
[245.600632] Subtest ts-continuation-suspend: SUCCESS (3.748s)
[246.395582] [044/133] (773s left) perf (invalid-oa-exponent)
[246.503295] Starting subtest: invalid-oa-exponent
[246.513960] Subtest invalid-oa-exponent: SUCCESS (0.011s)
[246.554417] [045/133] (773s left) gem_create (hog-create)
[246.601192] Starting subtest: hog-create
[246.603534] Starting dynamic subtest: smem0
[280.037576] Dynamic subtest smem0: SUCCESS (33.615s)
[280.040766] Subtest hog-create: SUCCESS (33.616s)
[280.239218] [046/133] (739s left) kms_cursor_crc (cursor-sliding-64x64)
[280.451315] Starting subtest: cursor-sliding-64x64
[280.461967] Starting dynamic subtest: pipe-A-eDP-1
[283.659703] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.214s)
[283.689160] Starting dynamic subtest: pipe-D-eDP-1
[287.601162] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.916s)
[287.603363] Subtest cursor-sliding-64x64: SUCCESS (7.157s)
[288.464021] [047/133] (731s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[288.562658] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[288.564573] Starting dynamic subtest: pipe-A-eDP-1
[289.487039] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.916s)
[289.496108] Starting dynamic subtest: pipe-B-eDP-1
[291.114505] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.628s)
[291.124442] Starting dynamic subtest: pipe-C-eDP-1
[292.627685] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.511s)
[292.638009] Starting dynamic subtest: pipe-D-eDP-1
[294.153059] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.524s)
[294.155179] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.583s)
[295.301387] [048/133] (724s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[295.415345] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[295.419982] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[295.519027] [049/133] (724s left) kms_psr (psr2-cursor-blt)
[295.623328] Starting subtest: psr2-cursor-blt
[295.625537] Starting dynamic subtest: eDP-1
[297.371144] Dynamic subtest eDP-1: SUCCESS (1.748s)
[297.373471] Subtest psr2-cursor-blt: SUCCESS (1.749s)
[298.244196] [050/133] (721s left) kms_psr (psr-cursor-blt)
[298.337510] Starting subtest: psr-cursor-blt
[298.339765] Starting dynamic subtest: eDP-1
[300.030566] Dynamic subtest eDP-1: SUCCESS (1.692s)
[300.032864] Subtest psr-cursor-blt: SUCCESS (1.693s)
[300.923138] [051/133] (719s left) kms_content_protection (dp-mst-lic-type-0-hdcp14)
[301.067312] Starting subtest: dp-mst-lic-type-0-hdcp14
[301.071849] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s)
[301.179545] [052/133] (718s left) kms_flip (2x-modeset-vs-vblank-race)
[301.282054] Starting subtest: 2x-modeset-vs-vblank-race
[301.292517] Subtest 2x-modeset-vs-vblank-race: SKIP (0.011s)
[301.371014] [053/133] (718s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[301.595572] Starting subtest: cursor-rapid-movement-128x42
[301.646847] Subtest cursor-rapid-movement-128x42: SKIP (0.045s)
[301.844561] [054/133] (718s left) gem_ctx_persistence (engines-persistence)
[301.894324] Starting subtest: engines-persistence
[301.896253] Starting dynamic subtest: rcs0
[302.697800] Dynamic subtest rcs0: SUCCESS (0.802s)
[302.713974] Starting dynamic subtest: bcs0
[303.458497] Dynamic subtest bcs0: SUCCESS (0.758s)
[303.471432] Starting dynamic subtest: vcs0
[304.213927] Dynamic subtest vcs0: SUCCESS (0.753s)
[304.228350] Starting dynamic subtest: vcs1
[304.986673] Dynamic subtest vcs1: SUCCESS (0.770s)
[304.998637] Starting dynamic subtest: vecs0
[305.748576] Dynamic subtest vecs0: SUCCESS (0.760s)
[305.759923] Starting dynamic subtest: ccs0
[306.540751] Dynamic subtest ccs0: SUCCESS (0.790s)
[306.543382] Subtest engines-persistence: SUCCESS (4.647s)
[306.618504] [055/133] (713s left) syncobj_wait (multi-wait-all-submitted-signaled)
[306.672451] Starting subtest: multi-wait-all-submitted-signaled
[306.780385] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.106s)
[306.859362] [056/133] (713s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[306.968937] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[306.973076] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[307.048189] [057/133] (713s left) gem_pwrite_snooped
[307.196089] [058/133] (713s left) syncobj_wait (reset-multiple-signaled)
[307.253333] Starting subtest: reset-multiple-signaled
[307.255636] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[307.350721] [059/133] (713s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[307.737220] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[308.523562] [060/133] (711s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[308.624477] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[308.629305] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[308.725486] [061/133] (711s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[308.819547] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[308.824015] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[308.914165] [062/133] (711s left) kms_flip (dpms-vs-vblank-race-interruptible)
[309.014468] Starting subtest: dpms-vs-vblank-race-interruptible
[309.016847] Starting dynamic subtest: A-eDP1
[313.926865] Dynamic subtest A-eDP1: SUCCESS (4.908s)
[313.937238] Starting dynamic subtest: B-eDP1
[317.439039] Dynamic subtest B-eDP1: SUCCESS (3.514s)
[317.448833] Starting dynamic subtest: C-eDP1
[322.058222] Dynamic subtest C-eDP1: SUCCESS (4.618s)
[322.068363] Starting dynamic subtest: D-eDP1
[326.675837] Dynamic subtest D-eDP1: SUCCESS (4.617s)
[326.678369] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (17.668s)
[327.554064] [063/133] (693s left) gen7_exec_parse (basic-allocation)
[327.618879] Subtest basic-allocation: SKIP (0.000s)
[327.697454] [064/133] (692s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc)
[327.805688] Starting subtest: psr-rgb101010-draw-mmap-wc
[334.856915] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (7.060s)
[334.973715] [065/133] (685s left) kms_properties (connector-properties-atomic)
[335.079047] Starting subtest: connector-properties-atomic
[335.081365] Starting dynamic subtest: pipe-A-eDP-1
[343.050391] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.974s)
[343.060602] Starting dynamic subtest: pipe-None-DP-1
[343.064877] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[343.073230] Starting dynamic subtest: pipe-None-HDMI-A-1
[343.077235] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[343.086081] Starting dynamic subtest: pipe-None-DP-2
[343.090348] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[343.099377] Starting dynamic subtest: pipe-None-HDMI-A-2
[343.103741] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[343.112784] Starting dynamic subtest: pipe-None-DP-3
[343.117023] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[343.127840] Starting dynamic subtest: pipe-None-DP-4
[343.132172] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[343.134378] Subtest connector-properties-atomic: SUCCESS (7.986s)
[343.919927] [066/133] (676s left) kms_psr (fbc-pr-primary-mmap-cpu)
[344.013654] Starting subtest: fbc-pr-primary-mmap-cpu
[344.018050] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s)
[344.099246] [067/133] (676s left) gem_exec_balancer (smoke)
[344.147022] Starting subtest: smoke
[366.738249] Subtest smoke: SUCCESS (22.579s)
[368.135001] [068/133] (652s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[368.235827] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[368.238089] Starting dynamic subtest: pipe-A-eDP-1
[368.297344] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[368.307934] Starting dynamic subtest: pipe-B-eDP-1
[368.367042] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[368.377542] Starting dynamic subtest: pipe-C-eDP-1
[368.435568] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[368.445322] Starting dynamic subtest: pipe-D-eDP-1
[368.503381] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[368.507490] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s)
[370.482243] [069/133] (650s left) gem_mmap_wc (coherency)
[370.543093] Subtest coherency: SKIP (0.000s)
[370.604149] [070/133] (650s left) perf_pmu (idle)
[370.644492] Starting subtest: idle
[370.646722] Starting dynamic subtest: rcs0
[371.197368] Dynamic subtest rcs0: SUCCESS (0.550s)
[371.210049] Starting dynamic subtest: bcs0
[371.713410] Dynamic subtest bcs0: SUCCESS (0.513s)
[371.725383] Starting dynamic subtest: vcs0
[372.228371] Dynamic subtest vcs0: SUCCESS (0.512s)
[372.240495] Starting dynamic subtest: vcs1
[372.751139] Dynamic subtest vcs1: SUCCESS (0.520s)
[372.761117] Starting dynamic subtest: vecs0
[373.268192] Dynamic subtest vecs0: SUCCESS (0.514s)
[373.280760] Starting dynamic subtest: ccs0
[373.784249] Dynamic subtest ccs0: SUCCESS (0.512s)
[373.787068] Subtest idle: SUCCESS (3.138s)
[373.898200] [071/133] (647s left) gem_exec_whisper (basic-queues-priority-all)
[373.961123] Starting subtest: basic-queues-priority-all
[396.309656] Subtest basic-queues-priority-all: SUCCESS (22.345s)
[396.495202] [072/133] (624s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[396.598414] Starting subtest: 4-tiled-8bpp-rotate-0
[397.778085] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.180s)
[397.894221] [073/133] (623s left) api_intel_bb (lot-of-buffers)
[397.953597] Starting subtest: lot-of-buffers
[399.032833] Subtest lot-of-buffers: SUCCESS (1.080s)
[399.233902] [074/133] (621s left) kms_flip (2x-dpms-vs-vblank-race)
[399.336156] Starting subtest: 2x-dpms-vs-vblank-race
[399.344857] Subtest 2x-dpms-vs-vblank-race: SKIP (0.011s)
[399.476033] [075/133] (621s left) vgem_basic (debugfs)
[399.525046] Starting subtest: debugfs
[399.527227] Subtest debugfs: SUCCESS (0.001s)
[399.579409] [076/133] (621s left) gem_mmap_gtt (basic-small-bo-tiledx)
[399.633416] Subtest basic-small-bo-tiledX: SKIP (0.000s)
[399.694193] [077/133] (621s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[399.785070] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[399.789423] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[399.888360] [078/133] (621s left) kms_cursor_legacy (cursor-vs-flip-toggle)
[400.014476] Starting subtest: cursor-vs-flip-toggle
[430.959146] Subtest cursor-vs-flip-toggle: SUCCESS (30.948s)
[431.819690] [079/133] (589s left) kms_addfb_basic (bad-pitch-32)
[431.872380] Starting subtest: bad-pitch-32
[431.874502] Subtest bad-pitch-32: SUCCESS (0.000s)
[432.027690] [080/133] (589s left) gem_mmap_wc (write-read-distinct)
[432.092970] Subtest write-read-distinct: SKIP (0.000s)
[432.159916] [081/133] (589s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[432.261440] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[432.265500] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[432.375574] [082/133] (589s left) gem_ctx_param (invalid-size-set)
[432.425232] Starting subtest: invalid-size-set
[432.427676] Subtest invalid-size-set: SUCCESS (0.001s)
[432.522683] [083/133] (588s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[432.626256] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[432.628490] Starting dynamic subtest: pipe-A-eDP-1
[432.773854] Dynamic subtest pipe-A-eDP-1: SKIP (0.152s)
[432.784552] Starting dynamic subtest: pipe-B-eDP-1
[433.977471] Dynamic subtest pipe-B-eDP-1: SKIP (1.198s)
[433.982219] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.352s)
[435.152825] [084/133] (586s left) gem_userptr_blits (coherency-sync)
[435.225278] Starting subtest: coherency-sync
[435.648536] Subtest coherency-sync: SKIP (0.388s)
[435.776372] [085/133] (585s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[435.936984] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[442.550974] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.615s)
[442.660649] [086/133] (578s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[442.762310] Starting subtest: y-tiled-16bpp-rotate-0
[442.766469] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s)
[442.862373] [087/133] (578s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[442.986501] Starting subtest: verify-pxp-execution-after-suspend-resume
[450.057983] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.073s)
[450.189582] [088/133] (571s left) kms_getfb (getfb-reject-nv12)
[450.283018] Starting subtest: getfb-reject-nv12
[450.285280] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[450.401760] [089/133] (571s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[450.495647] Starting subtest: yf-tiled-32bpp-rotate-180
[450.500040] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[450.599589] [090/133] (571s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[450.683914] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[450.710602] Starting dynamic subtest: pipe-A-plane-0
[450.998930] Dynamic subtest pipe-A-plane-0: SUCCESS (0.289s)
[451.009124] Starting dynamic subtest: pipe-A-plane-3
[451.231873] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[451.242699] Starting dynamic subtest: pipe-A-plane-5
[451.246569] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[452.305035] Starting dynamic subtest: pipe-B-plane-0
[452.619300] Dynamic subtest pipe-B-plane-0: SUCCESS (0.322s)
[452.629535] Starting dynamic subtest: pipe-B-plane-3
[452.852665] Dynamic subtest pipe-B-plane-3: SUCCESS (0.233s)
[452.862620] Starting dynamic subtest: pipe-B-plane-5
[452.866962] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[453.176518] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SUCCESS (2.492s)
[453.991908] [091/133] (567s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[454.106544] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[460.924793] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.820s)
[461.061413] [092/133] (560s left) kms_cursor_legacy (forked-move)
[461.189504] Starting subtest: forked-move
[461.191365] Starting dynamic subtest: pipe-A
[466.645716] Dynamic subtest pipe-A: SUCCESS (5.453s)
[466.663456] Starting dynamic subtest: pipe-B
[472.112956] Dynamic subtest pipe-B: SUCCESS (5.464s)
[472.124256] Starting dynamic subtest: pipe-C
[477.584644] Dynamic subtest pipe-C: SUCCESS (5.469s)
[477.596615] Starting dynamic subtest: pipe-D
[483.059810] Dynamic subtest pipe-D: SUCCESS (5.472s)
[483.071478] Starting dynamic subtest: all-pipes
[488.556012] Dynamic subtest all-pipes: SUCCESS (5.494s)
[488.558420] Subtest forked-move: SUCCESS (27.363s)
[488.706843] [093/133] (533s left) kms_joiner (basic-force-ultra-joiner)
[488.834880] Starting subtest: basic-force-ultra-joiner
[488.838987] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[488.912241] [094/133] (532s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing)
[489.012335] Starting subtest: plane-use-after-nonblocking-unbind-fencing
[489.014642] Starting dynamic subtest: pipe-A-eDP-1
[489.093220] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.081s)
[489.401188] Starting dynamic subtest: pipe-B-eDP-1
[490.211048] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.819s)
[490.511288] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.499s)
[491.365364] [095/133] (530s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[491.470503] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[498.737962] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.270s)
[498.897096] [096/133] (523s left) fbdev (read)
[498.946130] Starting subtest: read
[499.706978] Subtest read: SUCCESS (0.758s)
[499.770443] [097/133] (522s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[499.834665] Subtest no-spare-fences-busy: SKIP (0.000s)
[499.911275] [098/133] (522s left) kms_frontbuffer_tracking (fbc-shrfb-scaledprimary)
[500.015231] Starting subtest: fbc-shrfb-scaledprimary
[503.010880] Subtest fbc-shrfb-scaledprimary: SUCCESS (2.998s)
[504.216743] [099/133] (517s left) i915_pm_rpm (gem-execbuf-stress-pc8)
[506.274657] Starting subtest: gem-execbuf-stress-pc8
[506.311157] Subtest gem-execbuf-stress-pc8: SKIP (0.039s)
[506.667685] [100/133] (515s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[506.763133] Starting subtest: plane-lut1d-ctm3x4
[506.908606] Starting dynamic subtest: pipe-A-plane-0
[507.086272] Dynamic subtest pipe-A-plane-0: SUCCESS (0.177s)
[507.096417] Starting dynamic subtest: pipe-A-plane-1
[507.241711] Dynamic subtest pipe-A-plane-1: SUCCESS (0.155s)
[507.251982] Starting dynamic subtest: pipe-A-plane-2
[507.408465] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[508.674597] Starting dynamic subtest: pipe-B-plane-0
[508.832764] Dynamic subtest pipe-B-plane-0: SUCCESS (0.167s)
[508.842988] Starting dynamic subtest: pipe-B-plane-1
[509.021329] Dynamic subtest pipe-B-plane-1: SUCCESS (0.186s)
[509.031491] Starting dynamic subtest: pipe-B-plane-2
[509.188008] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[510.380539] Starting dynamic subtest: pipe-C-plane-0
[510.514253] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[510.524900] Starting dynamic subtest: pipe-C-plane-1
[510.659334] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[510.672677] Starting dynamic subtest: pipe-C-plane-2
[510.814220] Dynamic subtest pipe-C-plane-2: SUCCESS (0.154s)
[512.029533] Starting dynamic subtest: pipe-D-plane-0
[512.176730] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s)
[512.187005] Starting dynamic subtest: pipe-D-plane-1
[512.331872] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s)
[512.342161] Starting dynamic subtest: pipe-D-plane-2
[512.487732] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[512.781846] Subtest plane-lut1d-ctm3x4: SUCCESS (6.020s)
[513.584733] [101/133] (508s left) gem_tiled_pread_pwrite
[513.712844] [102/133] (508s left) gem_softpin (safe-alignment)
[513.772949] Starting subtest: safe-alignment
[513.792576] Subtest safe-alignment: SUCCESS (0.022s)
[515.100478] [103/133] (507s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[515.196206] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[515.198613] Starting dynamic subtest: pipe-A
[516.301295] Dynamic subtest pipe-A: SUCCESS (1.108s)
[516.310839] Starting dynamic subtest: pipe-B
[518.483992] Dynamic subtest pipe-B: SUCCESS (2.182s)
[518.493704] Starting dynamic subtest: pipe-C
[519.694827] Dynamic subtest pipe-C: SUCCESS (1.209s)
[519.705113] Starting dynamic subtest: pipe-D
[520.915185] Dynamic subtest pipe-D: SUCCESS (1.219s)
[520.917464] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.723s)
[522.104015] [104/133] (500s left) kms_cursor_crc (cursor-onscreen-512x170)
[522.402182] Starting subtest: cursor-onscreen-512x170
[522.406224] Subtest cursor-onscreen-512x170: SKIP (0.001s)
[522.575072] [105/133] (499s left) i915_suspend (fence-restore-tiled2untiled)
[522.636818] Starting subtest: fence-restore-tiled2untiled
[522.641175] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[522.736045] [106/133] (499s left) kms_plane_scaling (planes-scaler-unity-scaling)
[522.825605] Starting subtest: planes-scaler-unity-scaling
[522.827837] Starting dynamic subtest: pipe-A
[522.888987] Dynamic subtest pipe-A: SUCCESS (0.065s)
[522.899001] Starting dynamic subtest: pipe-B
[524.025640] Dynamic subtest pipe-B: SUCCESS (1.135s)
[524.037963] Starting dynamic subtest: pipe-C
[525.131780] Dynamic subtest pipe-C: SUCCESS (1.104s)
[525.142511] Starting dynamic subtest: pipe-D
[526.280826] Dynamic subtest pipe-D: SUCCESS (1.148s)
[526.283068] Subtest planes-scaler-unity-scaling: SUCCESS (3.458s)
[527.429973] [107/133] (495s left) gem_exec_balancer (individual)
[527.490391] Starting subtest: individual
[529.052284] Subtest individual: SUCCESS (1.562s)
[529.380276] [108/133] (493s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[529.477817] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[529.482204] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[529.586173] [109/133] (493s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[529.682510] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[529.686489] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[529.775625] [110/133] (492s left) gem_exec_fence (keep-in-fence)
[529.950694] Starting subtest: keep-in-fence
[529.952911] Starting dynamic subtest: rcs0
[530.005381] Dynamic subtest rcs0: SUCCESS (0.054s)
[530.016966] Starting dynamic subtest: bcs0
[530.057493] Dynamic subtest bcs0: SUCCESS (0.051s)
[530.070057] Starting dynamic subtest: vcs0
[532.062906] Dynamic subtest vcs0: SUCCESS (2.002s)
[532.075834] Starting dynamic subtest: vcs1
[534.046491] Dynamic subtest vcs1: SUCCESS (1.981s)
[534.059296] Starting dynamic subtest: vecs0
[536.032192] Dynamic subtest vecs0: SUCCESS (1.983s)
[536.044989] Starting dynamic subtest: ccs0
[536.265618] Dynamic subtest ccs0: SUCCESS (0.232s)
[536.268401] Subtest keep-in-fence: SUCCESS (6.316s)
[538.161614] [111/133] (484s left) core_auth (basic-auth)
[538.223293] Starting subtest: basic-auth
[538.225552] Subtest basic-auth: SUCCESS (0.002s)
[538.342273] [112/133] (484s left) syncobj_timeline (invalid-wait-illegal-handle)
[538.400888] Starting subtest: invalid-wait-illegal-handle
[538.403191] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[538.515544] [113/133] (484s left) prime_vgem (basic-write)
[538.598503] Starting subtest: basic-write
[538.605893] Subtest basic-write: SKIP (0.006s)
[538.718248] [114/133] (484s left) syncobj_wait (multi-wait-all-submitted)
[538.776408] Starting subtest: multi-wait-all-submitted
[538.882907] Subtest multi-wait-all-submitted: SUCCESS (0.106s)
[538.958739] [115/133] (483s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted)
[539.008112] Starting subtest: etime-single-wait-all-available-unsubmitted
[539.114592] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.106s)
[539.228119] [116/133] (483s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[539.320840] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[539.324853] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[539.408379] [117/133] (483s left) kms_big_fb (linear-8bpp-rotate-90)
[539.507744] Starting subtest: linear-8bpp-rotate-90
[539.533823] Subtest linear-8bpp-rotate-90: SKIP (0.023s)
[539.638877] [118/133] (483s left) kms_psr (fbc-psr-cursor-blt)
[539.738662] Starting subtest: fbc-psr-cursor-blt
[539.740916] Starting dynamic subtest: eDP-1
[539.745076] Dynamic subtest eDP-1: SKIP (0.000s)
[539.749364] Subtest fbc-psr-cursor-blt: SKIP (0.001s)
[539.812017] [119/133] (483s left) kms_atomic_transition (modeset-transition)
[539.913597] Starting subtest: modeset-transition
[539.915939] Starting dynamic subtest: 1x-outputs
[550.758842] Dynamic subtest 1x-outputs: SUCCESS (10.846s)
[550.761292] Subtest modeset-transition: SUCCESS (10.848s)
[551.617708] [120/133] (471s left) i915_drm_fdinfo (memory-info-shared)
[551.662398] Starting subtest: memory-info-shared
[551.664754] Starting dynamic subtest: smem0
[551.702836] Dynamic subtest smem0: SUCCESS (0.041s)
[551.705585] Subtest memory-info-shared: SUCCESS (0.041s)
[551.790945] [121/133] (471s left) sysfs_timeslice_duration (invalid)
[551.844341] Starting subtest: invalid
[551.846643] Starting dynamic subtest: vecs0
[551.849011] Dynamic subtest vecs0: SUCCESS (0.000s)
[551.859907] Starting dynamic subtest: ccs0
[551.861765] Dynamic subtest ccs0: SUCCESS (0.000s)
[551.871536] Starting dynamic subtest: vcs0
[551.873723] Dynamic subtest vcs0: SUCCESS (0.000s)
[551.883225] Starting dynamic subtest: bcs0
[551.885087] Dynamic subtest bcs0: SUCCESS (0.000s)
[551.894599] Starting dynamic subtest: rcs0
[551.896523] Dynamic subtest rcs0: SUCCESS (0.000s)
[551.905696] Starting dynamic subtest: vcs1
[551.907628] Dynamic subtest vcs1: SUCCESS (0.000s)
[551.909517] Subtest invalid: SUCCESS (0.006s)
[551.947466] [122/133] (471s left) kms_setmode (invalid-clone-single-crtc-stealing)
[552.005509] Starting subtest: invalid-clone-single-crtc-stealing
[552.012221] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[552.109932] [123/133] (471s left) gem_ctx_sseu (invalid-sseu)
[552.162115] Subtest invalid-sseu: SKIP (0.000s)
[552.222672] [124/133] (471s left) kms_flip (blocking-absolute-wf_vblank-interruptible)
[552.323152] Starting subtest: blocking-absolute-wf_vblank-interruptible
[552.325396] Starting dynamic subtest: A-eDP1
[561.072322] Dynamic subtest A-eDP1: SUCCESS (8.749s)
[561.084838] Starting dynamic subtest: B-eDP1
[569.805240] Dynamic subtest B-eDP1: SUCCESS (8.731s)
[569.817577] Starting dynamic subtest: C-eDP1
[578.521493] Dynamic subtest C-eDP1: SUCCESS (8.716s)
[578.532619] Starting dynamic subtest: D-eDP1
[587.250165] Dynamic subtest D-eDP1: SUCCESS (8.727s)
[587.252717] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.934s)
[588.463676] [125/133] (434s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode)
[588.851735] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s)
[589.671398] [126/133] (433s left) kms_tv_load_detect (load-detect)
[589.728224] Subtest load-detect: SKIP (0.000s)
[589.787645] [127/133] (433s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[589.895611] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[589.897991] Starting dynamic subtest: pipe-A-eDP-1
[589.920585] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[589.932941] Starting dynamic subtest: pipe-B-eDP-1
[589.954139] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[589.963791] Starting dynamic subtest: pipe-C-eDP-1
[589.985489] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[589.995045] Starting dynamic subtest: pipe-D-eDP-1
[590.018356] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[590.022573] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[592.166679] [128/133] (431s left) gem_mmap_wc (write-prefaulted)
[592.238160] Subtest write-prefaulted: SKIP (0.000s)
[592.305924] [129/133] (431s left) kms_plane_lowres (tiling-yf)
[592.392281] Starting subtest: tiling-yf
[592.396354] Subtest tiling-yf: SKIP (0.000s)
[592.466256] [130/133] (431s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[592.568664] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[592.579249] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.012s)
[592.662591] [131/133] (430s left) kms_lease (cursor-implicit-plane)
[592.765014] Starting subtest: cursor-implicit-plane
[592.767379] Starting dynamic subtest: pipe-A-eDP-1
[593.229755] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.464s)
[593.240152] Starting dynamic subtest: pipe-B-eDP-1
[594.381642] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.151s)
[594.391991] Starting dynamic subtest: pipe-C-eDP-1
[595.491429] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.110s)
[595.502044] Starting dynamic subtest: pipe-D-eDP-1
[596.640738] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.146s)
[596.643472] Subtest cursor-implicit-plane: SUCCESS (3.876s)
[597.494929] [132/133] (426s left) kms_prop_blob (invalid-set-prop)
[597.557694] Starting subtest: invalid-set-prop
[597.559878] Subtest invalid-set-prop: SUCCESS (0.000s)
[597.656152] [133/133] (425s left) prime_vgem (basic-blt)
[597.718933] Starting subtest: basic-blt
[597.745734] Subtest basic-blt: SUCCESS (0.026s)
[597.859078] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: perf
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_pm_rpm
results: parsing output: 4/ for test: gem_mmap_gtt
results: parsing output: 5/ for test: gen7_exec_parse
results: parsing output: 6/ for test: kms_chamelium_color
results: parsing output: 7/ for test: syncobj_timeline
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: gem_mmap_wc
results: parsing output: 10/ for test: kms_selftest
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_atomic_interruptible
results: parsing output: 13/ for test: gem_exec_schedule
results: parsing output: 14/ for test: dmabuf_sync_file
results: parsing output: 15/ for test: syncobj_timeline
results: parsing output: 16/ for test: kms_pm_lpsp
results: parsing output: 17/ for test: gem_render_copy
results: parsing output: 18/ for test: gem_render_copy
results: parsing output: 19/ for test: kms_flip
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: kms_ccs
results: parsing output: 23/ for test: kms_big_fb
results: parsing output: 24/ for test: kms_feature_discovery
results: parsing output: 25/ for test: kms_flip_scaled_crc
results: parsing output: 26/ for test: kms_psr
results: parsing output: 27/ for test: gem_exec_params
results: parsing output: 28/ for test: kms_pipe_crc_basic
results: parsing output: 29/ for test: i915_pm_freq_api
results: parsing output: 30/ for test: drm_read
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_exec_reloc
results: parsing output: 33/ for test: gem_lmem_swapping
results: parsing output: 34/ for test: gem_ctx_persistence
results: parsing output: 35/ for test: api_intel_allocator
results: parsing output: 36/ for test: syncobj_wait
results: parsing output: 37/ for test: gem_exec_schedule
results: parsing output: 38/ for test: gem_exec_schedule
results: parsing output: 39/ for test: perf_pmu
results: parsing output: 40/ for test: kms_async_flips
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_vblank
results: parsing output: 43/ for test: perf
results: parsing output: 44/ for test: gem_create
results: parsing output: 45/ for test: kms_cursor_crc
results: parsing output: 46/ for test: kms_ccs
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: kms_psr
results: parsing output: 50/ for test: kms_content_protection
results: parsing output: 51/ for test: kms_flip
results: parsing output: 52/ for test: kms_cursor_crc
results: parsing output: 53/ for test: gem_ctx_persistence
results: parsing output: 54/ for test: syncobj_wait
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: gem_pwrite_snooped
results: parsing output: 57/ for test: syncobj_wait
results: parsing output: 58/ for test: kms_chamelium_edid
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_flip
results: parsing output: 62/ for test: gen7_exec_parse
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_properties
results: parsing output: 65/ for test: kms_psr
results: parsing output: 66/ for test: gem_exec_balancer
results: parsing output: 67/ for test: kms_ccs
results: parsing output: 68/ for test: gem_mmap_wc
results: parsing output: 69/ for test: perf_pmu
results: parsing output: 70/ for test: gem_exec_whisper
results: parsing output: 71/ for test: kms_big_fb
results: parsing output: 72/ for test: api_intel_bb
results: parsing output: 73/ for test: kms_flip
results: parsing output: 74/ for test: vgem_basic
results: parsing output: 75/ for test: gem_mmap_gtt
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_cursor_legacy
results: parsing output: 78/ for test: kms_addfb_basic
results: parsing output: 79/ for test: gem_mmap_wc
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: gem_ctx_param
results: parsing output: 82/ for test: kms_psr2_sf
results: parsing output: 83/ for test: gem_userptr_blits
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: gem_pxp
results: parsing output: 87/ for test: kms_getfb
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: kms_plane
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_cursor_legacy
results: parsing output: 92/ for test: kms_joiner
results: parsing output: 93/ for test: kms_atomic_transition
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: fbdev
results: parsing output: 96/ for test: gem_fenced_exec_thrash
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: i915_pm_rpm
results: parsing output: 99/ for test: kms_color_pipeline
results: parsing output: 100/ for test: gem_tiled_pread_pwrite
results: parsing output: 101/ for test: gem_softpin
results: parsing output: 102/ for test: kms_plane_scaling
results: parsing output: 103/ for test: kms_cursor_crc
results: parsing output: 104/ for test: i915_suspend
results: parsing output: 105/ for test: kms_plane_scaling
results: parsing output: 106/ for test: gem_exec_balancer
results: parsing output: 107/ for test: kms_big_fb
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: gem_exec_fence
results: parsing output: 110/ for test: core_auth
results: parsing output: 111/ for test: syncobj_timeline
results: parsing output: 112/ for test: prime_vgem
results: parsing output: 113/ for test: syncobj_wait
results: parsing output: 114/ for test: syncobj_timeline
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_psr
results: parsing output: 118/ for test: kms_atomic_transition
results: parsing output: 119/ for test: i915_drm_fdinfo
results: parsing output: 120/ for test: sysfs_timeslice_duration
results: parsing output: 121/ for test: kms_setmode
results: parsing output: 122/ for test: gem_ctx_sseu
results: parsing output: 123/ for test: kms_flip
results: parsing output: 124/ for test: kms_chamelium_hpd
results: parsing output: 125/ for test: kms_tv_load_detect
results: parsing output: 126/ for test: kms_ccs
results: parsing output: 127/ for test: gem_mmap_wc
results: parsing output: 128/ for test: kms_plane_lowres
results: parsing output: 129/ for test: kms_flip
results: parsing output: 130/ for test: kms_lease
results: parsing output: 131/ for test: kms_prop_blob
results: parsing output: 132/ for test: prime_vgem
Done.