[59.238198] Initializing watchdogs
[59.238283]   /dev/watchdog0
[59.253612] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7dd5 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Graphics]
[59.257597] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[59.259872] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[59.263331] [001/155] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[59.369300] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[66.443928] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.136s)
[66.573836] [002/155] (953s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[66.658106] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[71.162982] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.526s)
[72.444504] [003/155] (947s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[72.593814] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[72.601929] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.008s)
[72.693693] [004/155] (947s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[72.847816] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt
[72.852659] Subtest psrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[73.036150] [005/155] (946s left) kms_frontbuffer_tracking (fbchdr-1p-rte)
[73.256448] Starting subtest: fbchdr-1p-rte
[73.260418] Subtest fbchdr-1p-rte: SKIP (0.000s)
[73.487234] [006/155] (946s left) kms_addfb_basic (basic)
[73.543814] Starting subtest: basic
[73.545784] Subtest basic: SUCCESS (0.000s)
[73.667408] [007/155] (946s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-render)
[73.749611] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-render
[73.753973] Subtest fbchdr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s)
[73.842207] [008/155] (946s left) kms_addfb_basic (small-bo)
[73.916604] Starting subtest: small-bo
[73.918837] Subtest small-bo: SUCCESS (0.000s)
[74.028773] [009/155] (946s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[74.103220] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[78.072607] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (3.980s)
[79.256210] [010/155] (940s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[79.336710] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[79.341201] Subtest hdr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[79.428898] [011/155] (940s left) kms_flip (2x-flip-vs-dpms)
[79.502932] Starting subtest: 2x-flip-vs-dpms
[79.510188] Subtest 2x-flip-vs-dpms: SKIP (0.007s)
[79.584949] [012/155] (940s left) kms_cursor_crc (cursor-offscreen-128x128)
[79.766805] Starting subtest: cursor-offscreen-128x128
[79.771499] Starting dynamic subtest: pipe-A-eDP-1
[81.718798] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.948s)
[81.752361] Starting dynamic subtest: pipe-D-eDP-1
[84.333332] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.588s)
[84.335716] Subtest cursor-offscreen-128x128: SUCCESS (4.567s)
[85.193972] [013/155] (935s left) kms_atomic_transition (modeset-transition-fencing)
[85.269049] Starting subtest: modeset-transition-fencing
[85.271504] Starting dynamic subtest: 1x-outputs
[96.291574] Dynamic subtest 1x-outputs: SUCCESS (11.024s)
[96.293908] Subtest modeset-transition-fencing: SUCCESS (11.025s)
[97.165469] [014/155] (923s left) gem_reg_read (timestamp-moving)
[97.223089] Starting subtest: timestamp-moving
[98.225055] Subtest timestamp-moving: SUCCESS (1.001s)
[98.309932] [015/155] (922s left) kms_lease (lease-revoke)
[98.388800] Starting subtest: lease-revoke
[98.391115] Starting dynamic subtest: pipe-A-eDP-1
[98.419829] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.031s)
[98.427958] Starting dynamic subtest: pipe-B-eDP-1
[98.444941] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.026s)
[98.456272] Starting dynamic subtest: pipe-C-eDP-1
[98.470043] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.024s)
[98.478777] Starting dynamic subtest: pipe-D-eDP-1
[98.499102] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.028s)
[98.501979] Subtest lease-revoke: SUCCESS (0.112s)
[98.624984] [016/155] (921s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-move)
[98.696641] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-move
[98.700765] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[98.789085] [017/155] (921s left) syncobj_timeline (wait-all-for-submit-complex)
[98.835788] Starting subtest: wait-all-for-submit-complex
[99.051315] Subtest wait-all-for-submit-complex: SUCCESS (0.214s)
[99.124716] [018/155] (921s left) kms_plane_scaling (plane-upscale-20x20-with-rotation)
[99.200997] Starting subtest: plane-upscale-20x20-with-rotation
[99.203459] Starting dynamic subtest: pipe-A
[99.426248] Dynamic subtest pipe-A: SUCCESS (0.227s)
[99.436410] Starting dynamic subtest: pipe-B
[100.729509] Dynamic subtest pipe-B: SUCCESS (1.303s)
[100.739194] Starting dynamic subtest: pipe-C
[102.065158] Dynamic subtest pipe-C: SUCCESS (1.335s)
[102.074946] Starting dynamic subtest: pipe-D
[103.396319] Dynamic subtest pipe-D: SUCCESS (1.331s)
[103.398622] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.198s)
[104.576932] [019/155] (915s left) i915_pm_freq_mult (media-freq)
[104.637430] Starting subtest: media-freq
[104.639797] Starting dynamic subtest: gt0
[104.644454] Dynamic subtest gt0: SKIP (0.000s)
[104.653654] Starting dynamic subtest: gt1
[104.658138] Dynamic subtest gt1: SKIP (0.000s)
[104.662616] Subtest media-freq: SKIP (0.001s)
[104.746725] [020/155] (915s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt)
[104.836800] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt
[112.282543] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.452s)
[112.405630] [021/155] (908s left) kms_atomic_transition (plane-all-transition-fencing)
[112.482782] Starting subtest: plane-all-transition-fencing
[112.485108] Starting dynamic subtest: pipe-A-eDP-1
[114.976855] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[115.281315] Starting dynamic subtest: pipe-B-eDP-1
[118.525703] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.252s)
[118.825432] Subtest plane-all-transition-fencing: SUCCESS (6.344s)
[119.661751] [022/155] (900s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc)
[119.744500] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc
[119.746818] Starting dynamic subtest: pipe-A-eDP-1
[120.248428] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.474s)
[120.257831] Starting dynamic subtest: pipe-B-eDP-1
[121.729408] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.480s)
[121.739153] Starting dynamic subtest: pipe-C-eDP-1
[123.183386] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.455s)
[123.194048] Starting dynamic subtest: pipe-D-eDP-1
[124.620490] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.436s)
[124.622507] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.849s)
[125.789252] [023/155] (894s left) kms_async_flips (alternate-sync-async-flip)
[125.864686] Starting subtest: alternate-sync-async-flip
[126.239854] Starting dynamic subtest: pipe-A-eDP-1
[129.065400] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.828s)
[129.448469] Starting dynamic subtest: pipe-B-eDP-1
[132.189576] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.751s)
[132.578070] Starting dynamic subtest: pipe-C-eDP-1
[135.340158] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.768s)
[135.709384] Starting dynamic subtest: pipe-D-eDP-1
[138.470206] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.767s)
[138.472406] Subtest alternate-sync-async-flip: SUCCESS (12.610s)
[139.639178] [024/155] (881s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite)
[139.722586] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite
[146.634477] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.920s)
[146.759231] [025/155] (874s left) gem_ctx_shared (q-out-order)
[146.822266] Starting subtest: Q-out-order
[146.829369] Starting dynamic subtest: rcs0
[146.959574] Dynamic subtest rcs0: SUCCESS (0.136s)
[146.975354] Starting dynamic subtest: vcs0
[147.036460] Dynamic subtest vcs0: SUCCESS (0.076s)
[147.051280] Starting dynamic subtest: vcs1
[147.112477] Dynamic subtest vcs1: SUCCESS (0.075s)
[147.129114] Starting dynamic subtest: vecs0
[147.192038] Dynamic subtest vecs0: SUCCESS (0.077s)
[147.208320] Starting dynamic subtest: ccs0
[147.270734] Dynamic subtest ccs0: SUCCESS (0.077s)
[147.273143] Subtest Q-out-order: SUCCESS (0.450s)
[148.297982] [FACT gem_ctx_shared (q-out-order)] new: kernel.kmod_is_loaded.vgem: true
[148.301520] [026/155] (872s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-render)
[148.384813] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-render
[148.389115] Subtest hdr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[148.484569] [027/155] (872s left) kms_psr (psr2-sprite-mmap-cpu)
[148.564240] Starting subtest: psr2-sprite-mmap-cpu
[148.566455] Starting dynamic subtest: eDP-1
[150.277283] Dynamic subtest eDP-1: SUCCESS (1.712s)
[150.279480] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.713s)
[151.157245] [028/155] (869s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-blt)
[151.236903] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-blt
[151.241173] Subtest psrhdr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[151.355074] [029/155] (869s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[151.435268] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[151.439257] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[151.522855] [030/155] (869s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[151.587911] Starting subtest: multi-wait-all-for-submit-signaled
[151.590346] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s)
[151.694253] [031/155] (869s left) kms_frontbuffer_tracking (fbc-tiling-4)
[151.782414] Starting subtest: fbc-tiling-4
[155.967272] Subtest fbc-tiling-4: SUCCESS (4.190s)
[157.165337] [032/155] (863s left) gem_readwrite (new-obj)
[157.225307] Subtest new-obj: SKIP (0.000s)
[157.279370] [033/155] (863s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-blt)
[157.363259] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-blt
[157.367531] Subtest hdr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[157.469354] [034/155] (863s left) kms_chamelium_hpd (common-hpd-after-suspend)
[157.846731] Subtest common-hpd-after-suspend: SKIP (0.000s)
[158.656126] [035/155] (862s left) perf_pmu (busy-idle-no-semaphores)
[158.694527] Starting subtest: busy-idle-no-semaphores
[158.697417] Starting dynamic subtest: rcs0
[159.337460] Dynamic subtest rcs0: SUCCESS (0.641s)
[159.349204] Starting dynamic subtest: bcs0
[159.987737] Dynamic subtest bcs0: SUCCESS (0.647s)
[159.999342] Starting dynamic subtest: vcs0
[160.639537] Dynamic subtest vcs0: SUCCESS (0.649s)
[160.651480] Starting dynamic subtest: vcs1
[161.856032] Dynamic subtest vcs1: SUCCESS (1.186s)
[161.865165] Starting dynamic subtest: vecs0
[163.877115] Dynamic subtest vecs0: SUCCESS (2.047s)
[163.888847] Starting dynamic subtest: ccs0
[165.864477] Dynamic subtest ccs0: SUCCESS (1.983s)
[165.867503] Subtest busy-idle-no-semaphores: SUCCESS (7.169s)
[165.982468] [036/155] (855s left) gem_exec_schedule (u-fairslice-all)
[166.046127] Starting subtest: u-fairslice-all
[168.116172] Subtest u-fairslice-all: SUCCESS (2.073s)
[169.255209] [037/155] (852s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[169.338112] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[169.345312] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.008s)
[169.425008] [038/155] (851s left) gem_exec_reloc (basic-cpu-read-active)
[169.479742] Subtest basic-cpu-read-active: SKIP (0.000s)
[169.556280] [039/155] (851s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[169.641732] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[169.643843] Starting dynamic subtest: pipe-A-eDP-1
[169.717621] Dynamic subtest pipe-A-eDP-1: SKIP (0.078s)
[169.728192] Starting dynamic subtest: pipe-B-eDP-1
[170.860392] Dynamic subtest pipe-B-eDP-1: SKIP (1.141s)
[170.865063] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.221s)
[172.063398] [040/155] (849s left) i915_pm_rps (thresholds-park)
[172.128708] Starting subtest: thresholds-park
[172.133405] Subtest thresholds-park: SKIP (0.000s)
[172.234835] [041/155] (849s left) kms_invalid_mode (bad-vtotal)
[172.305531] Starting subtest: bad-vtotal
[172.307900] Starting dynamic subtest: pipe-A-eDP-1
[172.598165] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.294s)
[172.607823] Starting dynamic subtest: pipe-B-eDP-1
[172.609782] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[172.618659] Starting dynamic subtest: pipe-C-eDP-1
[172.620608] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[172.629320] Starting dynamic subtest: pipe-D-eDP-1
[172.631585] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[172.633865] Subtest bad-vtotal: SUCCESS (0.301s)
[173.502689] [042/155] (847s left) gen9_exec_parse (secure-batches)
[173.555316] Subtest secure-batches: SKIP (0.000s)
[173.621916] [043/155] (847s left) kms_big_fb (linear-32bpp-rotate-180)
[173.708083] Starting subtest: linear-32bpp-rotate-180
[175.155226] Subtest linear-32bpp-rotate-180: SUCCESS (1.447s)
[175.288966] [044/155] (846s left) kms_cursor_crc (cursor-suspend)
[175.386289] Starting subtest: cursor-suspend
[175.388128] Starting dynamic subtest: pipe-A-eDP-1
[208.561249] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.144s)
[208.571502] Starting dynamic subtest: pipe-D-eDP-1
[242.582374] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.844s)
[242.585087] Subtest cursor-suspend: SUCCESS (7.991s)
[243.382813] [045/155] (778s left) gem_render_copy (linear)
[243.439034] Starting subtest: linear
[243.441431] Starting dynamic subtest: smem
[243.478733] Dynamic subtest smem: SUCCESS (0.040s)
[243.481114] Subtest linear: SUCCESS (0.041s)
[243.700989] [046/155] (777s left) kms_pipe_stress (stress-xrgb8888-ytiled)
[243.784139] Starting subtest: stress-xrgb8888-ytiled
[243.788463] Subtest stress-xrgb8888-ytiled: SKIP (0.000s)
[243.859924] [047/155] (777s left) kms_chamelium_color (ctm-limited-range)
[243.937232] Subtest ctm-limited-range: SKIP (0.000s)
[243.981869] [048/155] (777s left) gen7_exec_parse (basic-allocation)
[244.035168] Subtest basic-allocation: SKIP (0.000s)
[244.108837] [049/155] (777s left) kms_big_fb (yf-tiled-16bpp-rotate-90)
[244.190256] Starting subtest: yf-tiled-16bpp-rotate-90
[244.194651] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s)
[244.293139] [050/155] (777s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[244.377239] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[244.379488] Starting dynamic subtest: pipe-A-eDP-1
[244.529507] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.145s)
[244.539388] Starting dynamic subtest: pipe-B-eDP-1
[244.558512] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.011s)
[244.567965] Starting dynamic subtest: pipe-C-eDP-1
[244.587501] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[244.596183] Starting dynamic subtest: pipe-D-eDP-1
[244.617277] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[244.619110] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.181s)
[246.822609] [051/155] (775s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-mmap-wc)
[246.912267] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-mmap-wc
[246.916509] Subtest fbchdr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[247.029320] [052/155] (774s left) gem_exec_fence (syncobj-timeline-repeat)
[247.578687] Starting subtest: syncobj-timeline-repeat
[247.814963] Subtest syncobj-timeline-repeat: SUCCESS (0.238s)
[248.583538] [053/155] (773s left) gem_mmap_gtt (big-copy)
[248.638139] Subtest big-copy: SKIP (0.000s)
[248.703791] [054/155] (773s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[248.780339] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[248.784725] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.000s)
[248.852262] [055/155] (773s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[248.931758] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[248.935823] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[249.060925] [056/155] (772s left) kms_big_fb (yf-tiled-64bpp-rotate-270)
[249.137870] Starting subtest: yf-tiled-64bpp-rotate-270
[249.142399] Subtest yf-tiled-64bpp-rotate-270: SKIP (0.000s)
[249.235394] [057/155] (772s left) kms_vblank (wait-forked-busy)
[249.305252] Starting subtest: wait-forked-busy
[249.307606] Starting dynamic subtest: pipe-A-eDP-1
[251.178803] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.881s)
[251.196261] Starting dynamic subtest: pipe-D-eDP-1
[253.733050] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.562s)
[253.735253] Subtest wait-forked-busy: SUCCESS (4.447s)
[254.545924] [058/155] (767s left) kms_getfb (getfb-handle-protection)
[254.624484] Starting subtest: getfb-handle-protection
[254.639453] Subtest getfb-handle-protection: SUCCESS (0.015s)
[254.750826] [059/155] (767s left) perf (polling)
[254.866139] Starting subtest: polling
[254.868411] Starting dynamic subtest: 0-rcs0
[264.891462] Dynamic subtest 0-rcs0: SUCCESS (10.046s)
[264.902289] Starting dynamic subtest: 1-vcs1
[274.907026] Dynamic subtest 1-vcs1: SUCCESS (10.020s)
[274.909628] Subtest polling: SUCCESS (20.069s)
[274.957942] [060/155] (747s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[275.038120] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[275.042589] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[275.136145] [061/155] (747s left) kms_draw_crc (draw-method-mmap-cpu)
[275.207732] Starting subtest: draw-method-mmap-cpu
[275.210034] Starting dynamic subtest: xrgb8888-untiled
[275.449685] Dynamic subtest xrgb8888-untiled: SUCCESS (0.244s)
[275.459935] Starting dynamic subtest: rgb565-untiled
[275.661171] Dynamic subtest rgb565-untiled: SUCCESS (0.210s)
[275.673088] Starting dynamic subtest: xrgb2101010-untiled
[275.883134] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s)
[275.894566] Starting dynamic subtest: xbgr16161616f-untiled
[276.116199] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.233s)
[276.126430] Starting dynamic subtest: xrgb8888-xtiled
[276.250240] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.133s)
[276.260231] Starting dynamic subtest: rgb565-xtiled
[276.382882] Dynamic subtest rgb565-xtiled: SUCCESS (0.132s)
[276.392769] Starting dynamic subtest: xrgb2101010-xtiled
[276.505395] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s)
[276.516645] Starting dynamic subtest: xbgr16161616f-xtiled
[276.638894] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.132s)
[276.648290] Starting dynamic subtest: xrgb8888-4tiled
[276.783152] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s)
[276.792538] Starting dynamic subtest: rgb565-4tiled
[276.928422] Dynamic subtest rgb565-4tiled: SUCCESS (0.143s)
[276.938434] Starting dynamic subtest: xrgb2101010-4tiled
[277.061221] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.133s)
[277.073983] Starting dynamic subtest: xbgr16161616f-4tiled
[277.205554] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.144s)
[277.207502] Subtest draw-method-mmap-cpu: SUCCESS (2.000s)
[277.299609] [062/155] (744s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[277.392640] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[277.396122] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[277.485144] [063/155] (744s left) perf_pmu (init-sema)
[277.523639] Starting subtest: init-sema
[277.525660] Starting dynamic subtest: rcs0
[277.527537] Dynamic subtest rcs0: SUCCESS (0.001s)
[277.537221] Starting dynamic subtest: bcs0
[277.539110] Dynamic subtest bcs0: SUCCESS (0.000s)
[277.548120] Starting dynamic subtest: vcs0
[277.549647] Dynamic subtest vcs0: SUCCESS (0.001s)
[277.558491] Starting dynamic subtest: vcs1
[277.560016] Dynamic subtest vcs1: SUCCESS (0.000s)
[277.569408] Starting dynamic subtest: vecs0
[277.571206] Dynamic subtest vecs0: SUCCESS (0.001s)
[277.580444] Starting dynamic subtest: ccs0
[277.582177] Dynamic subtest ccs0: SUCCESS (0.000s)
[277.583939] Subtest init-sema: SUCCESS (0.007s)
[277.627563] [064/155] (744s left) prime_mmap (test_dup)
[277.673106] Starting subtest: test_dup
[277.675395] Starting dynamic subtest: test_dup-smem
[277.703564] Dynamic subtest test_dup-smem: SUCCESS (0.032s)
[277.705731] Subtest test_dup: SUCCESS (0.033s)
[277.785532] [065/155] (744s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[277.836128] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[277.945902] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.108s)
[278.019702] [066/155] (744s left) kms_rotation_crc (bad-pixel-format)
[278.088730] Starting subtest: bad-pixel-format
[278.093052] Subtest bad-pixel-format: SKIP (0.001s)
[278.160288] [067/155] (744s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling)
[278.240816] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling
[278.244923] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SKIP (0.000s)
[278.314774] [068/155] (744s left) api_intel_bb (lot-of-buffers)
[278.373532] Starting subtest: lot-of-buffers
[279.389024] Subtest lot-of-buffers: SUCCESS (1.017s)
[279.640604] [069/155] (742s left) perf (buffer-fill)
[279.743562] Starting subtest: buffer-fill
[279.746147] Starting dynamic subtest: 0-rcs0
[282.008992] Dynamic subtest 0-rcs0: SUCCESS (2.264s)
[282.020881] Starting dynamic subtest: 1-vcs1
[286.411813] Dynamic subtest 1-vcs1: SUCCESS (4.402s)
[286.414438] Subtest buffer-fill: SUCCESS (6.669s)
[286.456746] [070/155] (736s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[286.823028] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[287.621649] [071/155] (735s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[287.705438] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[287.709614] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[287.810719] [072/155] (734s left) kms_rotation_crc (sprite-rotation-90)
[287.882944] Starting subtest: sprite-rotation-90
[287.886933] Subtest sprite-rotation-90: SKIP (0.001s)
[287.956283] [073/155] (734s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-shrfb-draw-pwrite)
[288.034936] Starting subtest: hdr-2p-scndscrn-pri-shrfb-draw-pwrite
[288.039087] Subtest hdr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[288.145169] [074/155] (734s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[288.356282] Starting subtest: cursor-rapid-movement-256x256
[288.361407] Starting dynamic subtest: pipe-A-eDP-1
[288.897546] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.536s)
[288.929418] Starting dynamic subtest: pipe-D-eDP-1
[290.158549] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.236s)
[290.160788] Subtest cursor-rapid-movement-256x256: SUCCESS (1.802s)
[290.999486] [075/155] (731s left) i915_query (query-topology-coherent-slice-mask)
[291.056441] Starting subtest: query-topology-coherent-slice-mask
[291.060640] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[291.171691] [076/155] (731s left) kms_big_fb (y-tiled-64bpp-rotate-90)
[291.244940] Starting subtest: y-tiled-64bpp-rotate-90
[291.249425] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s)
[291.329938] [077/155] (731s left) sysfs_heartbeat_interval (precise)
[291.382902] Starting subtest: precise
[291.385192] Starting dynamic subtest: vecs0
[298.489064] Dynamic subtest vecs0: SUCCESS (7.103s)
[298.502438] Starting dynamic subtest: ccs0
[299.615810] Dynamic subtest ccs0: SUCCESS (1.126s)
[299.625411] Starting dynamic subtest: vcs0
[307.505925] Dynamic subtest vcs0: SUCCESS (7.888s)
[307.519985] Starting dynamic subtest: bcs0
[308.593752] Dynamic subtest bcs0: SUCCESS (1.089s)
[308.605731] Starting dynamic subtest: rcs0
[309.673782] Dynamic subtest rcs0: SUCCESS (1.078s)
[309.683648] Starting dynamic subtest: vcs1
[317.492111] Dynamic subtest vcs1: SUCCESS (7.816s)
[317.494533] Subtest precise: SUCCESS (26.113s)
[317.572342] [078/155] (705s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-shrfb-plflip-blt)
[317.664990] Starting subtest: psrhdr-2p-scndscrn-shrfb-plflip-blt
[317.669512] Subtest psrhdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[317.757643] [079/155] (705s left) gem_exec_params (no-bsd)
[317.810955] Starting subtest: no-bsd
[317.813385] Subtest no-bsd: SUCCESS (0.002s)
[319.547862] [080/155] (703s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[319.646775] Starting subtest: 2x-long-cursor-vs-flip-atomic
[319.651251] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[319.795784] [081/155] (703s left) api_intel_allocator (execbuf-with-allocator)
[319.844728] Starting subtest: execbuf-with-allocator
[319.849158] Subtest execbuf-with-allocator: SUCCESS (0.005s)
[319.970844] [082/155] (703s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-mmap-gtt)
[320.047433] Starting subtest: fbcpsrhdr-rgb101010-draw-mmap-gtt
[320.051316] Subtest fbcpsrhdr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[320.142529] [083/155] (703s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[320.220675] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[320.224719] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[320.314038] [084/155] (702s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-rte)
[320.403514] Starting subtest: fbcpsrhdr-2p-rte
[320.408087] Subtest fbcpsrhdr-2p-rte: SKIP (0.000s)
[320.512222] [085/155] (702s left) kms_prop_blob (invalid-get-prop-any)
[320.565124] Starting subtest: invalid-get-prop-any
[320.567212] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[320.673115] [086/155] (702s left) dumb_buffer (create-clear)
[320.729209] Starting subtest: create-clear
[354.570052] Subtest create-clear: SUCCESS (33.838s)
[354.675925] [087/155] (668s left) gem_render_copy (yf-tiled-ccs-to-y-tiled)
[354.736934] Starting subtest: yf-tiled-ccs-to-y-tiled
[354.741703] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s)
[354.920447] [088/155] (668s left) gem_userptr_blits (relocations)
[354.988067] Starting subtest: relocations
[354.993605] Subtest relocations: SKIP (0.001s)
[355.121224] [089/155] (668s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[355.207948] Starting subtest: fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[355.211960] Subtest fbchdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[355.315656] [090/155] (668s left) gem_madvise (dontneed-before-exec)
[355.351412] Starting subtest: dontneed-before-exec
[355.364844] Subtest dontneed-before-exec: SKIP (0.013s)
[355.431771] [091/155] (668s left) kms_psr (psr-suspend)
[355.506657] Starting subtest: psr-suspend
[355.508994] Starting dynamic subtest: eDP-1
[373.548065] Dynamic subtest eDP-1: SUCCESS (2.968s)
[373.550992] Subtest psr-suspend: SUCCESS (2.969s)
[374.398545] [092/155] (649s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[374.481797] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt
[374.486588] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[374.576690] [093/155] (648s left) kms_plane (plane-panning-bottom-right-suspend)
[374.640501] Starting subtest: plane-panning-bottom-right-suspend
[374.642836] Starting dynamic subtest: pipe-A
[392.505245] Dynamic subtest pipe-A: SUCCESS (2.903s)
[392.517209] Starting dynamic subtest: pipe-B
[411.493513] Dynamic subtest pipe-B: SUCCESS (3.537s)
[411.495860] Subtest plane-panning-bottom-right-suspend: SUCCESS (6.443s)
[412.296376] [094/155] (611s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-yf-tiled)
[412.363626] Starting subtest: yf-tiled-mc-ccs-to-vebox-yf-tiled
[412.368502] Subtest yf-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[412.550253] [095/155] (611s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[412.629119] Starting subtest: 4-tiled-8bpp-rotate-180
[413.817931] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.203s)
[413.983548] [096/155] (609s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[414.063424] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[414.068789] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[414.157029] [097/155] (609s left) fbdev (info)
[414.192877] Starting subtest: info
[414.194421] Subtest info: SUCCESS (0.000s)
[414.260691] [098/155] (609s left) gem_lmem_swapping (parallel-random-verify-ccs)
[414.298918] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[414.350000] [099/155] (609s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[414.421340] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[418.687019] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.306s)
[419.841698] [100/155] (604s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[419.933143] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt
[419.937688] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[420.028098] [101/155] (603s left) gem_exec_balancer (hang)
[420.284855] Starting subtest: hang
[422.060736] Subtest hang: SUCCESS (1.787s)
[422.185633] [102/155] (601s left) kms_psr (fbc-pr-no-drrs)
[422.252992] Starting subtest: fbc-pr-no-drrs
[422.257860] Subtest fbc-pr-no-drrs: SKIP (0.000s)
[422.325570] [103/155] (601s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[422.414131] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu
[422.419095] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[422.510777] [104/155] (601s left) gem_ctx_persistence (hostile)
[422.565128] Starting subtest: hostile
[432.035209] Subtest hostile: SUCCESS (9.489s)
[432.149885] [105/155] (591s left) gem_exec_flush (basic-wb-set-default)
[432.212863] Starting subtest: basic-wb-set-default
[437.682207] Subtest basic-wb-set-default: SUCCESS (5.472s)
[437.865632] [106/155] (586s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[437.951368] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[437.960314] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.008s)
[438.036066] [107/155] (586s left) gem_eio (wait-1us)
[438.235502] Starting subtest: wait-1us
[438.544287] Subtest wait-1us: SUCCESS (0.310s)
[438.673615] [108/155] (585s left) prime_mmap (test_correct)
[438.725706] Starting subtest: test_correct
[438.727612] Starting dynamic subtest: test_correct-smem
[438.755313] Dynamic subtest test_correct-smem: SUCCESS (0.031s)
[438.758345] Subtest test_correct: SUCCESS (0.032s)
[438.865102] [109/155] (585s left) gem_exec_schedule (preempt-queue-chain)
[438.933890] Subtest preempt-queue-chain: SKIP (0.000s)
[439.216763] [110/155] (585s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[439.306969] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[446.089079] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.791s)
[446.202437] [111/155] (578s left) perf (mi-rpc)
[446.299809] Starting subtest: mi-rpc
[446.304996] Subtest mi-rpc: SKIP (0.000s)
[446.345731] [112/155] (578s left) gem_exec_whisper (basic-fds-forked-all)
[446.406033] Starting subtest: basic-fds-forked-all
[470.410297] Subtest basic-fds-forked-all: SUCCESS (24.002s)
[470.600300] [113/155] (553s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[470.694805] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[470.697361] Starting dynamic subtest: pipe-A-eDP-1
[470.722358] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[470.733883] Starting dynamic subtest: pipe-B-eDP-1
[470.759217] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[470.769936] Starting dynamic subtest: pipe-C-eDP-1
[470.795728] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[470.806119] Starting dynamic subtest: pipe-D-eDP-1
[470.832327] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[470.837126] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s)
[472.970024] [114/155] (551s left) gem_mmap_wc (bad-object)
[473.021575] Subtest bad-object: SKIP (0.000s)
[473.077498] [115/155] (551s left) syncobj_eventfd (invalid-bad-flags)
[473.135344] Starting subtest: invalid-bad-flags
[473.138105] Subtest invalid-bad-flags: SUCCESS (0.000s)
[473.231540] [116/155] (551s left) gem_exec_params (rel-constants-invalid)
[473.288165] Starting subtest: rel-constants-invalid
[473.290568] Subtest rel-constants-invalid: SUCCESS (0.000s)
[473.387178] [117/155] (551s left) kms_cursor_legacy (single-move)
[473.492250] Starting subtest: single-move
[473.494587] Starting dynamic subtest: pipe-A
[478.873339] Dynamic subtest pipe-A: SUCCESS (5.380s)
[478.889233] Starting dynamic subtest: pipe-B
[484.258653] Dynamic subtest pipe-B: SUCCESS (5.384s)
[484.277528] Starting dynamic subtest: pipe-C
[489.638668] Dynamic subtest pipe-C: SUCCESS (5.381s)
[489.651011] Starting dynamic subtest: pipe-D
[495.019359] Dynamic subtest pipe-D: SUCCESS (5.379s)
[495.032310] Starting dynamic subtest: all-pipes
[500.408349] Dynamic subtest all-pipes: SUCCESS (5.389s)
[500.411204] Subtest single-move: SUCCESS (26.926s)
[500.566402] [118/155] (524s left) kms_psr (fbc-psr-cursor-plane-move)
[500.644302] Starting subtest: fbc-psr-cursor-plane-move
[500.647078] Starting dynamic subtest: eDP-1
[500.652170] Dynamic subtest eDP-1: SKIP (0.000s)
[500.657443] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[500.716908] [119/155] (523s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[500.798326] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[500.803151] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[500.888830] [120/155] (523s left) kms_psr (psr2-cursor-mmap-cpu)
[500.964362] Starting subtest: psr2-cursor-mmap-cpu
[500.966537] Starting dynamic subtest: eDP-1
[502.658832] Dynamic subtest eDP-1: SUCCESS (1.695s)
[502.661351] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.696s)
[503.545656] [121/155] (521s left) syncobj_wait (signal)
[503.598160] Starting subtest: signal
[503.600434] Subtest signal: SUCCESS (0.000s)
[503.697660] [122/155] (521s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0)
[503.790569] Starting subtest: linear-max-hw-stride-64bpp-rotate-0
[504.925136] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.134s)
[505.047876] [123/155] (519s left) gem_exec_balancer (semaphore)
[505.115204] Starting subtest: semaphore
[507.039502] Subtest semaphore: SUCCESS (1.922s)
[507.357221] [124/155] (517s left) gem_ctx_persistence (engines-mixed)
[507.411608] Starting subtest: engines-mixed
[507.414056] Starting dynamic subtest: rcs0
[507.486209] Dynamic subtest rcs0: SUCCESS (0.078s)
[507.497900] Starting dynamic subtest: bcs0
[507.535671] Dynamic subtest bcs0: SUCCESS (0.048s)
[507.546174] Starting dynamic subtest: vcs0
[507.583756] Dynamic subtest vcs0: SUCCESS (0.047s)
[507.597226] Starting dynamic subtest: vcs1
[507.634032] Dynamic subtest vcs1: SUCCESS (0.049s)
[507.645806] Starting dynamic subtest: vecs0
[507.684295] Dynamic subtest vecs0: SUCCESS (0.049s)
[507.695903] Starting dynamic subtest: ccs0
[507.737564] Dynamic subtest ccs0: SUCCESS (0.051s)
[507.740187] Subtest engines-mixed: SUCCESS (0.330s)
[507.834324] [125/155] (517s left) kms_rotation_crc (primary-y-tiled-reflect-x-0)
[507.913882] Starting subtest: primary-y-tiled-reflect-x-0
[507.975049] Subtest primary-y-tiled-reflect-x-0: SKIP (0.059s)
[508.079960] [126/155] (516s left) kms_psr (fbc-psr2-suspend)
[508.152228] Starting subtest: fbc-psr2-suspend
[508.155103] Starting dynamic subtest: eDP-1
[508.160143] Dynamic subtest eDP-1: SKIP (0.000s)
[508.165361] Subtest fbc-psr2-suspend: SKIP (0.001s)
[508.228778] [127/155] (516s left) kms_frontbuffer_tracking (hdr-2p-rte)
[508.312020] Starting subtest: hdr-2p-rte
[508.316163] Subtest hdr-2p-rte: SKIP (0.000s)
[508.405963] [128/155] (516s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-pwrite)
[508.488758] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-pwrite
[508.492176] Subtest psrhdr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[508.574081] [129/155] (516s left) perf (blocking)
[508.649104] Starting subtest: blocking
[508.651444] Starting dynamic subtest: 0-rcs0
[518.676806] Dynamic subtest 0-rcs0: SUCCESS (10.020s)
[518.689416] Starting dynamic subtest: 1-vcs0
[528.702724] Dynamic subtest 1-vcs0: SUCCESS (10.020s)
[528.705424] Subtest blocking: SUCCESS (20.044s)
[528.755544] [130/155] (496s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-blt)
[528.850199] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-blt
[528.855983] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[528.932326] [131/155] (496s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[529.007499] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area
[529.009821] Starting dynamic subtest: pipe-A-eDP-1
[529.126452] Dynamic subtest pipe-A-eDP-1: SKIP (0.122s)
[529.137785] Starting dynamic subtest: pipe-B-eDP-1
[530.326047] Dynamic subtest pipe-B-eDP-1: SKIP (1.196s)
[530.331224] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.321s)
[531.509786] [132/155] (493s left) gem_spin_batch (resubmit-all)
[531.562302] Starting subtest: resubmit-all
[531.564880] Starting dynamic subtest: rcs0
[531.574240] Dynamic subtest rcs0: SUCCESS (0.012s)
[531.586656] Starting dynamic subtest: bcs0
[531.589347] Dynamic subtest bcs0: SUCCESS (0.002s)
[531.601887] Starting dynamic subtest: vcs0
[531.604128] Dynamic subtest vcs0: SUCCESS (0.002s)
[531.614113] Starting dynamic subtest: vcs1
[531.616310] Dynamic subtest vcs1: SUCCESS (0.002s)
[531.626332] Starting dynamic subtest: vecs0
[531.628922] Dynamic subtest vecs0: SUCCESS (0.002s)
[531.640966] Starting dynamic subtest: ccs0
[531.643225] Dynamic subtest ccs0: SUCCESS (0.002s)
[531.645496] Subtest resubmit-all: SUCCESS (0.027s)
[533.072784] [133/155] (492s left) kms_vblank (query-forked-hang)
[533.147047] Starting subtest: query-forked-hang
[533.149552] Starting dynamic subtest: pipe-A-eDP-1
[559.851341] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.706s)
[559.873987] Starting dynamic subtest: pipe-D-eDP-1
[584.868218] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.015s)
[584.870805] Subtest query-forked-hang: SUCCESS (51.725s)
[585.687519] [134/155] (439s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted)
[585.740225] Starting subtest: invalid-multi-wait-all-unsubmitted
[585.742646] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[585.825561] [135/155] (439s left) i915_drm_fdinfo (basics)
[585.869113] Starting subtest: basics
[585.872151] Subtest basics: SUCCESS (0.000s)
[585.933168] [136/155] (439s left) kms_content_protection (dp-mst-type-1)
[586.060208] Starting subtest: dp-mst-type-1
[586.065993] Subtest dp-mst-type-1: SKIP (0.000s)
[586.186690] [137/155] (439s left) gem_exec_whisper (basic-queues-priority)
[586.251455] Starting subtest: basic-queues-priority
[608.979225] Subtest basic-queues-priority: SUCCESS (22.729s)
[609.162674] [138/155] (416s left) kms_color (ctm-green-to-red)
[609.236473] Starting subtest: ctm-green-to-red
[609.239303] Starting dynamic subtest: pipe-A-eDP-1
[609.948900] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.712s)
[609.961188] Starting dynamic subtest: pipe-B-eDP-1
[611.403174] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.457s)
[611.414911] Starting dynamic subtest: pipe-C-eDP-1
[612.763098] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.356s)
[612.774184] Starting dynamic subtest: pipe-D-eDP-1
[614.096739] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.335s)
[614.099476] Subtest ctm-green-to-red: SUCCESS (4.862s)
[614.903466] [139/155] (410s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[614.976338] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[614.981384] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[616.132108] [140/155] (409s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[616.216066] Starting subtest: fbc-rgb565-draw-mmap-cpu
[620.246105] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (4.038s)
[621.447114] [141/155] (404s left) gem_mmap_offset (clear-via-pagefault)
[621.495638] Starting subtest: clear-via-pagefault
[621.497912] Starting dynamic subtest: smem0
[648.635232] Dynamic subtest smem0: SUCCESS (27.133s)
[648.638038] Subtest clear-via-pagefault: SUCCESS (27.135s)
[648.726326] [142/155] (376s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-blt)
[648.805969] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-blt
[648.811101] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[648.894912] [143/155] (376s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[648.972068] Starting subtest: psr-2p-primscrn-spr-indfb-move
[648.977094] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[649.073052] [144/155] (376s left) i915_pm_rpm (gem-execbuf)
[651.195080] Starting subtest: gem-execbuf
[651.197855] Starting dynamic subtest: smem0
[653.256139] Dynamic subtest smem0: SUCCESS (2.063s)
[653.259001] Subtest gem-execbuf: SUCCESS (2.064s)
[653.343650] [145/155] (372s left) kms_plane_multiple (2x-tiling-none)
[653.426337] Starting subtest: 2x-tiling-none
[653.431853] Subtest 2x-tiling-none: SKIP (0.000s)
[653.507676] [146/155] (372s left) kms_plane (pixel-format-x-tiled-modifier)
[653.583326] Starting subtest: pixel-format-x-tiled-modifier
[653.610693] Starting dynamic subtest: pipe-A-plane-0
[654.033009] Dynamic subtest pipe-A-plane-0: SUCCESS (0.422s)
[654.044546] Starting dynamic subtest: pipe-A-plane-3
[654.354760] Dynamic subtest pipe-A-plane-3: SUCCESS (0.322s)
[654.365542] Starting dynamic subtest: pipe-A-plane-5
[654.369317] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[655.498162] Starting dynamic subtest: pipe-B-plane-0
[655.902767] Dynamic subtest pipe-B-plane-0: SUCCESS (0.411s)
[655.916350] Starting dynamic subtest: pipe-B-plane-3
[656.233056] Dynamic subtest pipe-B-plane-3: SUCCESS (0.333s)
[656.247607] Starting dynamic subtest: pipe-B-plane-5
[656.253172] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[656.544629] Subtest pixel-format-x-tiled-modifier: SUCCESS (2.958s)
[657.381087] [147/155] (368s left) gem_ctx_engines (execute-allforone)
[657.440945] Starting subtest: execute-allforone
[657.455347] Subtest execute-allforone: SUCCESS (0.015s)
[659.097640] [148/155] (366s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[659.177167] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[659.182967] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[659.277547] [149/155] (366s left) gem_exec_gttfill (multigpu-basic)
[659.448213] Starting subtest: multigpu-basic
[671.498391] Subtest multigpu-basic: SUCCESS (12.050s)
[671.573801] [150/155] (354s left) kms_addfb_basic (bad-pitch-32)
[671.670993] Starting subtest: bad-pitch-32
[671.673181] Subtest bad-pitch-32: SUCCESS (0.000s)
[671.802522] [151/155] (354s left) syncobj_wait (reset-during-wait-for-submit)
[671.871916] Starting subtest: reset-during-wait-for-submit
[671.970737] Subtest reset-during-wait-for-submit: SUCCESS (0.102s)
[672.048095] [152/155] (354s left) gem_exec_reloc (basic-gtt-active)
[672.106176] Subtest basic-gtt-active: SKIP (0.000s)
[672.162694] [153/155] (353s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[672.256147] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[672.261321] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[672.387238] [154/155] (353s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[672.466855] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[672.471863] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[672.554932] [155/155] (353s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[672.609507] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[672.611338] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[672.703524] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_flip
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: kms_addfb_basic
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_addfb_basic
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_flip
results: parsing output: 11/ for test: kms_cursor_crc
results: parsing output: 12/ for test: kms_atomic_transition
results: parsing output: 13/ for test: gem_reg_read
results: parsing output: 14/ for test: kms_lease
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: syncobj_timeline
results: parsing output: 17/ for test: kms_plane_scaling
results: parsing output: 18/ for test: i915_pm_freq_mult
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_atomic_transition
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: kms_async_flips
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: gem_ctx_shared
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_psr
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: gem_readwrite
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_chamelium_hpd
results: parsing output: 34/ for test: perf_pmu
results: parsing output: 35/ for test: gem_exec_schedule
results: parsing output: 36/ for test: kms_flip
results: parsing output: 37/ for test: gem_exec_reloc
results: parsing output: 38/ for test: kms_psr2_sf
results: parsing output: 39/ for test: i915_pm_rps
results: parsing output: 40/ for test: kms_invalid_mode
results: parsing output: 41/ for test: gen9_exec_parse
results: parsing output: 42/ for test: kms_big_fb
results: parsing output: 43/ for test: kms_cursor_crc
results: parsing output: 44/ for test: gem_render_copy
results: parsing output: 45/ for test: kms_pipe_stress
results: parsing output: 46/ for test: kms_chamelium_color
results: parsing output: 47/ for test: gen7_exec_parse
results: parsing output: 48/ for test: kms_big_fb
results: parsing output: 49/ for test: kms_ccs
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_exec_fence
results: parsing output: 52/ for test: gem_mmap_gtt
results: parsing output: 53/ for test: kms_flip_scaled_crc
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: kms_vblank
results: parsing output: 57/ for test: kms_getfb
results: parsing output: 58/ for test: perf
results: parsing output: 59/ for test: kms_big_fb
results: parsing output: 60/ for test: kms_draw_crc
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: perf_pmu
results: parsing output: 63/ for test: prime_mmap
results: parsing output: 64/ for test: syncobj_timeline
results: parsing output: 65/ for test: kms_rotation_crc
results: parsing output: 66/ for test: kms_flip_scaled_crc
results: parsing output: 67/ for test: api_intel_bb
results: parsing output: 68/ for test: perf
results: parsing output: 69/ for test: kms_chamelium_edid
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_rotation_crc
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_cursor_crc
results: parsing output: 74/ for test: i915_query
results: parsing output: 75/ for test: kms_big_fb
results: parsing output: 76/ for test: sysfs_heartbeat_interval
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: gem_exec_params
results: parsing output: 79/ for test: kms_cursor_legacy
results: parsing output: 80/ for test: api_intel_allocator
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_prop_blob
results: parsing output: 85/ for test: dumb_buffer
results: parsing output: 86/ for test: gem_render_copy
results: parsing output: 87/ for test: gem_userptr_blits
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: gem_madvise
results: parsing output: 90/ for test: kms_psr
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_plane
results: parsing output: 93/ for test: gem_render_copy
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: fbdev
results: parsing output: 97/ for test: gem_lmem_swapping
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: gem_exec_balancer
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_ctx_persistence
results: parsing output: 104/ for test: gem_exec_flush
results: parsing output: 105/ for test: kms_flip
results: parsing output: 106/ for test: gem_eio
results: parsing output: 107/ for test: prime_mmap
results: parsing output: 108/ for test: gem_exec_schedule
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: perf
results: parsing output: 111/ for test: gem_exec_whisper
results: parsing output: 112/ for test: kms_ccs
results: parsing output: 113/ for test: gem_mmap_wc
results: parsing output: 114/ for test: syncobj_eventfd
results: parsing output: 115/ for test: gem_exec_params
results: parsing output: 116/ for test: kms_cursor_legacy
results: parsing output: 117/ for test: kms_psr
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: syncobj_wait
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: gem_exec_balancer
results: parsing output: 123/ for test: gem_ctx_persistence
results: parsing output: 124/ for test: kms_rotation_crc
results: parsing output: 125/ for test: kms_psr
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: perf
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_psr2_sf
results: parsing output: 131/ for test: gem_spin_batch
results: parsing output: 132/ for test: kms_vblank
results: parsing output: 133/ for test: syncobj_timeline
results: parsing output: 134/ for test: i915_drm_fdinfo
results: parsing output: 135/ for test: kms_content_protection
results: parsing output: 136/ for test: gem_exec_whisper
results: parsing output: 137/ for test: kms_color
results: parsing output: 138/ for test: kms_ccs
results: parsing output: 139/ for test: kms_frontbuffer_tracking
results: parsing output: 140/ for test: gem_mmap_offset
results: parsing output: 141/ for test: kms_frontbuffer_tracking
results: parsing output: 142/ for test: kms_frontbuffer_tracking
results: parsing output: 143/ for test: i915_pm_rpm
results: parsing output: 144/ for test: kms_plane_multiple
results: parsing output: 145/ for test: kms_plane
results: parsing output: 146/ for test: gem_ctx_engines
results: parsing output: 147/ for test: kms_frontbuffer_tracking
results: parsing output: 148/ for test: gem_exec_gttfill
results: parsing output: 149/ for test: kms_addfb_basic
results: parsing output: 150/ for test: syncobj_wait
results: parsing output: 151/ for test: gem_exec_reloc
results: parsing output: 152/ for test: kms_frontbuffer_tracking
results: parsing output: 153/ for test: kms_frontbuffer_tracking
results: parsing output: 154/ for test: syncobj_timeline
Done.