[56.679855] Initializing watchdogs
[56.679900]   /dev/watchdog0
[56.694436] [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]
[56.698891] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.701153] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.704421] [001/155] (960s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-blt)
[56.834638] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-blt
[56.838681] Subtest psrhdr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[56.921667] [002/155] (960s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-render)
[57.025849] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-render
[57.030181] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[57.128359] [003/155] (960s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[57.230388] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-mmap-gtt
[57.234565] Subtest hdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[57.327574] [004/155] (959s left) kms_big_fb (y-tiled-8bpp-rotate-180)
[57.421293] Starting subtest: y-tiled-8bpp-rotate-180
[57.425518] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s)
[57.503830] [005/155] (959s left) gen9_exec_parse (unaligned-access)
[57.562205] Subtest unaligned-access: SKIP (0.000s)
[57.621274] [006/155] (959s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb565-draw-render)
[57.717494] Starting subtest: fbcpsrhdr-rgb565-draw-render
[57.721872] Subtest fbcpsrhdr-rgb565-draw-render: SKIP (0.000s)
[57.809347] [007/155] (959s left) gem_lmem_swapping (random-engines)
[57.850567] Subtest random-engines: SKIP (0.000s)
[57.897356] [008/155] (959s left) kms_pm_rpm (pm-tiling)
[59.430476] Starting subtest: pm-tiling
[59.434809] Subtest pm-tiling: SKIP (0.000s)
[60.186939] [009/155] (957s left) kms_scaling_modes (scaling-mode-center)
[60.288040] Starting subtest: scaling-mode-center
[60.290137] Starting dynamic subtest: pipe-A-eDP-1
[60.437796] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.151s)
[60.452926] Starting dynamic subtest: pipe-B-eDP-1
[61.598409] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.158s)
[61.607337] Starting dynamic subtest: pipe-C-eDP-1
[62.812586] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.213s)
[62.821955] Starting dynamic subtest: pipe-D-eDP-1
[63.946087] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.133s)
[63.948444] Subtest scaling-mode-center: SUCCESS (3.661s)
[65.119437] [010/155] (952s left) kms_properties (colorop-properties-atomic)
[65.211099] Starting subtest: colorop-properties-atomic
[65.213450] Starting dynamic subtest: pipe-A-eDP-1
[65.579481] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.369s)
[65.588344] Starting dynamic subtest: pipe-B-eDP-1
[66.682444] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.102s)
[66.690316] Starting dynamic subtest: pipe-C-eDP-1
[67.734165] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.051s)
[67.744066] Starting dynamic subtest: pipe-D-eDP-1
[68.857705] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.122s)
[68.860074] Subtest colorop-properties-atomic: SUCCESS (3.647s)
[69.661159] [011/155] (947s left) kms_chamelium_hpd (common-hpd-after-suspend)
[70.042253] Subtest common-hpd-after-suspend: SKIP (0.000s)
[70.879843] [012/155] (946s left) vgem_basic (dmabuf-mmap)
[70.942999] Starting subtest: dmabuf-mmap
[70.951758] Subtest dmabuf-mmap: SUCCESS (0.011s)
[71.005583] [FACT vgem_basic (dmabuf-mmap)] new: kernel.kmod_is_loaded.vgem: true
[71.008695] [013/155] (946s left) kms_psr (psr2-sprite-render)
[71.104136] Starting subtest: psr2-sprite-render
[71.106614] Starting dynamic subtest: eDP-1
[72.790304] Dynamic subtest eDP-1: SUCCESS (1.686s)
[72.792510] Subtest psr2-sprite-render: SUCCESS (1.687s)
[73.666036] [014/155] (944s left) kms_atomic_interruptible (universal-setplane-cursor)
[73.761130] Starting subtest: universal-setplane-cursor
[73.763476] Starting dynamic subtest: pipe-A-eDP-1
[81.179917] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.418s)
[81.182388] Subtest universal-setplane-cursor: SUCCESS (7.419s)
[82.024377] [015/155] (935s left) kms_properties (crtc-properties-legacy)
[82.117858] Starting subtest: crtc-properties-legacy
[82.120270] Starting dynamic subtest: pipe-A-eDP-1
[82.553475] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.435s)
[82.561775] Starting dynamic subtest: pipe-B-eDP-1
[83.684089] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.131s)
[83.692370] Starting dynamic subtest: pipe-C-eDP-1
[84.832274] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.147s)
[84.842357] Starting dynamic subtest: pipe-D-eDP-1
[85.971950] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.139s)
[85.974654] Subtest crtc-properties-legacy: SUCCESS (3.856s)
[86.798014] [016/155] (930s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted)
[86.852076] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted
[86.960470] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.108s)
[87.039231] [017/155] (930s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling)
[87.135712] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling
[87.140204] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s)
[87.223825] [018/155] (930s left) kms_getfb (getfb-reject-nv12)
[87.312659] Starting subtest: getfb-reject-nv12
[87.314979] Subtest getfb-reject-nv12: SUCCESS (0.001s)
[87.415570] [019/155] (930s left) gem_mmap_offset (pf-nonblock)
[87.478771] Starting subtest: pf-nonblock
[87.483385] Subtest pf-nonblock: SUCCESS (0.006s)
[87.573194] [020/155] (930s left) kms_vblank (query-forked-busy-hang)
[87.656106] Starting subtest: query-forked-busy-hang
[87.658281] Starting dynamic subtest: pipe-A-eDP-1
[114.042690] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.381s)
[114.055709] Starting dynamic subtest: pipe-D-eDP-1
[129.022727] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.977s)
[129.024745] Subtest query-forked-busy-hang: SUCCESS (41.361s)
[129.832186] [021/155] (888s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-mmap-wc)
[129.938170] Starting subtest: fbchdr-rgb565-draw-mmap-wc
[129.942777] Subtest fbchdr-rgb565-draw-mmap-wc: SKIP (0.000s)
[130.032232] [022/155] (887s left) gem_exec_schedule (fairslice)
[130.105410] Starting subtest: fairslice
[130.107225] Starting dynamic subtest: rcs0
[132.125470] Dynamic subtest rcs0: SUCCESS (2.022s)
[132.133055] Starting dynamic subtest: bcs0
[134.150963] Dynamic subtest bcs0: SUCCESS (2.025s)
[134.158498] Starting dynamic subtest: vcs0
[136.175912] Dynamic subtest vcs0: SUCCESS (2.024s)
[136.185891] Starting dynamic subtest: vcs1
[138.198708] Dynamic subtest vcs1: SUCCESS (2.022s)
[138.209619] Starting dynamic subtest: vecs0
[140.218565] Dynamic subtest vecs0: SUCCESS (2.018s)
[140.227633] Starting dynamic subtest: ccs0
[142.238087] Dynamic subtest ccs0: SUCCESS (2.022s)
[142.240104] Subtest fairslice: SUCCESS (12.137s)
[142.553497] [023/155] (875s left) gem_exec_schedule (u-semaphore-user)
[142.617391] Starting subtest: u-semaphore-user
[142.672039] Subtest u-semaphore-user: SUCCESS (0.061s)
[144.371828] [024/155] (873s left) syncobj_wait (invalid-reset-zero-handles)
[144.431035] Starting subtest: invalid-reset-zero-handles
[144.433395] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[144.527489] [025/155] (873s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[144.627814] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[144.630111] Starting dynamic subtest: pipe-A-eDP-1
[144.653709] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[144.663839] Starting dynamic subtest: pipe-B-eDP-1
[144.685808] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[144.693405] Starting dynamic subtest: pipe-C-eDP-1
[144.715360] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[144.723140] Starting dynamic subtest: pipe-D-eDP-1
[144.746388] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[144.750497] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[146.890395] [026/155] (871s left) gem_vm_create (invalid-create)
[146.947035] Starting subtest: invalid-create
[146.949168] Subtest invalid-create: SUCCESS (0.002s)
[147.054201] [027/155] (871s left) kms_psr (fbc-pr-primary-mmap-cpu)
[147.142412] Starting subtest: fbc-pr-primary-mmap-cpu
[147.147084] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s)
[147.225094] [028/155] (871s left) kms_atomic_transition (plane-all-modeset-transition)
[147.323917] Starting subtest: plane-all-modeset-transition
[147.328119] Subtest plane-all-modeset-transition: SKIP (0.000s)
[147.397878] [029/155] (870s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[147.503822] Starting subtest: fbc-rgb565-draw-blt
[151.687614] Subtest fbc-rgb565-draw-blt: SUCCESS (4.189s)
[152.908234] [030/155] (865s left) kms_cursor_crc (cursor-size-hints)
[153.036893] Starting subtest: cursor-size-hints
[153.039252] Starting dynamic subtest: pipe-A-eDP-1
[153.647405] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.610s)
[153.655528] Starting dynamic subtest: pipe-D-eDP-1
[154.942690] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.293s)
[154.945060] Subtest cursor-size-hints: SUCCESS (1.905s)
[155.768270] [031/155] (862s left) sysfs_timeslice_duration (duration)
[155.832084] Starting subtest: duration
[155.834407] Starting dynamic subtest: vecs0
[169.178659] Dynamic subtest vecs0: SUCCESS (13.343s)
[169.189952] Starting dynamic subtest: ccs0
[182.332329] Dynamic subtest ccs0: SUCCESS (13.154s)
[182.343805] Starting dynamic subtest: vcs0
[196.186194] Dynamic subtest vcs0: SUCCESS (13.851s)
[196.196941] Starting dynamic subtest: bcs0
[209.335323] Dynamic subtest bcs0: SUCCESS (13.149s)
[209.346668] Starting dynamic subtest: rcs0
[222.480603] Dynamic subtest rcs0: SUCCESS (13.143s)
[222.490567] Starting dynamic subtest: vcs1
[236.185862] Dynamic subtest vcs1: SUCCESS (13.703s)
[236.189315] Subtest duration: SUCCESS (80.353s)
[236.262156] [032/155] (782s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[236.362792] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-mmap-cpu
[236.366923] Subtest hdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[236.465515] [033/155] (781s left) gen9_exec_parse (bb-start-far)
[236.520541] Subtest bb-start-far: SKIP (0.000s)
[236.574574] [034/155] (781s left) gem_exec_params (batch-first)
[236.636447] Starting subtest: batch-first
[236.641805] Subtest batch-first: SUCCESS (0.006s)
[236.778643] [035/155] (781s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt)
[236.881204] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt
[236.885697] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[236.971678] [036/155] (781s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-move)
[237.073392] Starting subtest: hdr-2p-scndscrn-cur-indfb-move
[237.077678] Subtest hdr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[237.188236] [037/155] (781s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-pwrite)
[237.283027] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-pwrite
[237.286538] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[237.395130] [038/155] (781s left) kms_plane_alpha_blend (alpha-7efc)
[237.482298] Starting subtest: alpha-7efc
[237.767177] Starting dynamic subtest: pipe-A-eDP-1
[238.359447] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.591s)
[238.384067] Starting dynamic subtest: pipe-D-eDP-1
[239.650648] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.271s)
[239.653151] Subtest alpha-7efc: SUCCESS (2.168s)
[240.504294] [039/155] (778s left) kms_properties (plane-properties-atomic)
[240.595546] Starting subtest: plane-properties-atomic
[240.597837] Starting dynamic subtest: pipe-A-eDP-1
[241.134923] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.539s)
[241.145355] Starting dynamic subtest: pipe-B-eDP-1
[242.395747] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.259s)
[242.407570] Starting dynamic subtest: pipe-C-eDP-1
[243.710148] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.316s)
[243.720569] Starting dynamic subtest: pipe-D-eDP-1
[244.941285] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.229s)
[244.943582] Subtest plane-properties-atomic: SUCCESS (4.347s)
[245.748295] [040/155] (772s left) kms_cursor_crc (cursor-suspend)
[245.876922] Starting subtest: cursor-suspend
[245.878769] Starting dynamic subtest: pipe-A-eDP-1
[279.005390] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.007s)
[279.015259] Starting dynamic subtest: pipe-D-eDP-1
[313.016089] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.722s)
[313.019026] Subtest cursor-suspend: SUCCESS (7.732s)
[313.862078] [041/155] (704s left) gen3_render_linear_blits
[313.984330] [042/155] (704s left) kms_lease (lease-revoke)
[314.068366] Starting subtest: lease-revoke
[314.070615] Starting dynamic subtest: pipe-A-eDP-1
[314.101130] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.031s)
[314.111258] Starting dynamic subtest: pipe-B-eDP-1
[314.125866] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.026s)
[314.134874] Starting dynamic subtest: pipe-C-eDP-1
[314.154362] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.027s)
[314.163647] Starting dynamic subtest: pipe-D-eDP-1
[314.185481] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.028s)
[314.187749] Subtest lease-revoke: SUCCESS (0.118s)
[314.301955] [043/155] (704s left) perf (gen12-mi-rpc)
[314.409218] Starting subtest: gen12-mi-rpc
[314.411589] Starting dynamic subtest: rcs0
[314.428166] Dynamic subtest rcs0: SUCCESS (0.017s)
[314.430396] Subtest gen12-mi-rpc: SUCCESS (0.018s)
[314.468663] [044/155] (704s left) gem_render_copy (y-tiled-ccs-to-linear)
[314.538390] Starting subtest: y-tiled-ccs-to-linear
[314.542981] Subtest y-tiled-ccs-to-linear: SKIP (0.000s)
[314.737599] [045/155] (704s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-pwrite)
[314.845974] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-pwrite
[314.850382] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[314.923019] [046/155] (704s left) gem_exec_whisper (basic-queues-priority-all)
[314.983668] Starting subtest: basic-queues-priority-all
[337.146122] Subtest basic-queues-priority-all: SUCCESS (22.143s)
[337.328824] [047/155] (681s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[337.447672] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc
[337.451989] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[337.531900] [048/155] (681s left) gem_ctx_isolation (preservation-reset)
[337.703832] Starting subtest: preservation-reset
[337.706009] Starting dynamic subtest: rcs0
[337.982774] Dynamic subtest rcs0: SUCCESS (0.283s)
[337.993559] Starting dynamic subtest: bcs0
[338.313369] Dynamic subtest bcs0: SUCCESS (0.330s)
[338.323969] Starting dynamic subtest: vcs0
[338.666538] Dynamic subtest vcs0: SUCCESS (0.352s)
[338.679710] Starting dynamic subtest: vcs1
[339.995150] Dynamic subtest vcs1: SUCCESS (1.327s)
[340.007068] Starting dynamic subtest: vecs0
[342.007304] Dynamic subtest vecs0: SUCCESS (2.010s)
[342.017884] Starting dynamic subtest: ccs0
[343.988824] Dynamic subtest ccs0: SUCCESS (1.981s)
[343.991356] Subtest preservation-reset: SUCCESS (6.289s)
[344.141488] [049/155] (674s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-pwrite)
[344.242344] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-pwrite
[344.246576] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[344.349813] [050/155] (674s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[344.446270] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[344.829084] Starting dynamic subtest: pipe-A-eDP-1
[347.639874] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.810s)
[348.022927] Starting dynamic subtest: pipe-B-eDP-1
[350.774312] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.761s)
[351.147164] Starting dynamic subtest: pipe-C-eDP-1
[353.911339] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.772s)
[354.284885] Starting dynamic subtest: pipe-D-eDP-1
[357.037762] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.760s)
[357.040499] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.593s)
[358.222822] [051/155] (660s left) kms_vblank (ts-continuation-idle)
[358.324419] Starting subtest: ts-continuation-idle
[358.326585] Starting dynamic subtest: pipe-A-eDP-1
[358.739811] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.415s)
[358.755629] Starting dynamic subtest: pipe-D-eDP-1
[359.816748] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.074s)
[359.819088] Subtest ts-continuation-idle: SUCCESS (1.494s)
[360.688499] [052/155] (658s left) device_reset (unbind-reset-rebind)
[360.739380] Starting subtest: unbind-reset-rebind
[367.030215] Subtest unbind-reset-rebind: SUCCESS (6.287s)
[367.069862] [053/155] (652s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[367.199552] Starting subtest: flip-vs-cursor-crc-atomic
[367.850487] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.650s)
[368.705048] [054/155] (650s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[368.803516] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[368.805814] Starting dynamic subtest: pipe-A-eDP-1
[368.864899] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[368.877044] Starting dynamic subtest: pipe-B-eDP-1
[368.935016] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[368.949211] Starting dynamic subtest: pipe-C-eDP-1
[369.007165] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[369.018597] Starting dynamic subtest: pipe-D-eDP-1
[369.075556] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[369.080128] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.008s)
[371.063551] [055/155] (648s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[371.148259] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[371.150433] Starting dynamic subtest: pipe-A-eDP-1
[371.291827] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.135s)
[371.304943] Starting dynamic subtest: pipe-B-eDP-1
[371.324446] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[371.334728] Starting dynamic subtest: pipe-C-eDP-1
[371.353486] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[371.364124] Starting dynamic subtest: pipe-D-eDP-1
[371.382811] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[371.384975] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.144s)
[373.633811] [056/155] (645s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[374.161163] Starting subtest: syncobj-timeline-invalid-wait
[374.164045] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.003s)
[375.780199] [057/155] (643s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-render)
[375.886951] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-render
[375.891085] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[376.003029] [058/155] (643s left) kms_psr (pr-basic)
[376.102547] Starting subtest: pr-basic
[376.106931] Subtest pr-basic: SKIP (0.000s)
[376.174186] [059/155] (643s left) syncobj_wait (wait-for-submit-snapshot)
[376.235923] Starting subtest: wait-for-submit-snapshot
[376.318583] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[376.408622] [060/155] (643s left) kms_flip (2x-flip-vs-dpms-on-nop)
[376.497642] Starting subtest: 2x-flip-vs-dpms-on-nop
[376.509755] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.011s)
[376.584817] [061/155] (643s left) prime_busy (after)
[376.641420] Starting subtest: after
[376.646464] Starting dynamic subtest: rcs0
[376.674075] Dynamic subtest rcs0: SUCCESS (0.029s)
[376.685080] Starting dynamic subtest: bcs0
[376.727669] Dynamic subtest bcs0: SUCCESS (0.052s)
[376.739276] Starting dynamic subtest: vcs0
[376.766009] Dynamic subtest vcs0: SUCCESS (0.038s)
[376.775505] Starting dynamic subtest: vcs1
[376.805536] Dynamic subtest vcs1: SUCCESS (0.038s)
[376.814799] Starting dynamic subtest: vecs0
[376.845750] Dynamic subtest vecs0: SUCCESS (0.039s)
[376.855269] Starting dynamic subtest: ccs0
[376.886552] Dynamic subtest ccs0: SUCCESS (0.040s)
[376.994858] Subtest after: SUCCESS (0.352s)
[377.070117] [062/155] (642s left) kms_chamelium_edid (hdmi-edid-read)
[377.448389] Subtest hdmi-edid-read: SKIP (0.000s)
[378.242977] [063/155] (641s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[378.339506] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[378.343701] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[378.470931] [064/155] (641s left) gem_spin_batch (resubmit)
[378.530829] Starting subtest: resubmit
[378.533145] Starting dynamic subtest: rcs0
[378.537875] Dynamic subtest rcs0: SUCCESS (0.006s)
[378.548184] Starting dynamic subtest: bcs0
[378.550019] Dynamic subtest bcs0: SUCCESS (0.004s)
[378.563594] Starting dynamic subtest: vcs0
[378.565693] Dynamic subtest vcs0: SUCCESS (0.003s)
[378.575417] Starting dynamic subtest: vcs1
[378.577540] Dynamic subtest vcs1: SUCCESS (0.003s)
[378.587380] Starting dynamic subtest: vecs0
[378.589491] Dynamic subtest vecs0: SUCCESS (0.004s)
[378.599362] Starting dynamic subtest: ccs0
[378.601490] Dynamic subtest ccs0: SUCCESS (0.003s)
[378.603608] Subtest resubmit: SUCCESS (0.028s)
[378.789381] [065/155] (641s left) syncobj_timeline (transfer-timeline-point)
[378.852190] Starting subtest: transfer-timeline-point
[378.854541] Subtest transfer-timeline-point: SUCCESS (0.000s)
[378.963080] [066/155] (640s left) kms_invalid_mode (bad-htotal)
[379.058628] Starting subtest: bad-htotal
[379.060957] Starting dynamic subtest: pipe-A-eDP-1
[379.343576] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.283s)
[379.354819] Starting dynamic subtest: pipe-B-eDP-1
[379.356747] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[379.367416] Starting dynamic subtest: pipe-C-eDP-1
[379.369704] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[379.381536] Starting dynamic subtest: pipe-D-eDP-1
[379.384345] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[379.386697] Subtest bad-htotal: SUCCESS (0.289s)
[380.204056] [067/155] (639s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0-hflip)
[380.307942] Starting subtest: linear-max-hw-stride-64bpp-rotate-0-hflip
[380.312074] Subtest linear-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[380.402884] [068/155] (639s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt)
[380.505763] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt
[385.013068] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (4.511s)
[386.203178] [069/155] (633s left) gem_exec_whisper (basic-contexts)
[386.257130] Starting subtest: basic-contexts
[392.032054] Subtest basic-contexts: SUCCESS (5.770s)
[392.229601] [070/155] (627s left) kms_busy (basic-hang)
[392.338364] Starting subtest: basic-hang
[392.340637] Starting dynamic subtest: flip-pipe-A
[392.943667] Dynamic subtest flip-pipe-A: SUCCESS (0.602s)
[392.954995] Starting dynamic subtest: modeset-pipe-A
[396.424737] Dynamic subtest modeset-pipe-A: SUCCESS (3.480s)
[396.435417] Starting dynamic subtest: flip-pipe-D
[397.632410] Dynamic subtest flip-pipe-D: SUCCESS (1.203s)
[397.643639] Starting dynamic subtest: modeset-pipe-D
[401.065910] Dynamic subtest modeset-pipe-D: SUCCESS (3.430s)
[401.068510] Subtest basic-hang: SUCCESS (8.725s)
[401.888633] [071/155] (618s left) gem_workarounds (basic-read)
[401.951984] Starting subtest: basic-read
[401.963262] Subtest basic-read: SUCCESS (0.011s)
[402.108148] [072/155] (618s left) gem_exec_balancer (parallel)
[402.356886] Starting subtest: parallel
[403.306063] Subtest parallel: SUCCESS (0.949s)
[403.761882] [073/155] (616s left) i915_hangman (hangcheck-unterminated)
[403.825346] Starting subtest: hangcheck-unterminated
[415.653989] Subtest hangcheck-unterminated: SUCCESS (11.829s)
[415.783075] [074/155] (604s left) kms_frontbuffer_tracking (hdr-2p-rte)
[415.893827] Starting subtest: hdr-2p-rte
[415.898934] Subtest hdr-2p-rte: SKIP (0.000s)
[415.995853] [075/155] (604s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[416.087389] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[416.089648] Starting dynamic subtest: pipe-A
[416.449267] Dynamic subtest pipe-A: SUCCESS (0.363s)
[416.459799] Starting dynamic subtest: pipe-B
[417.862119] Dynamic subtest pipe-B: SUCCESS (1.412s)
[417.873782] Starting dynamic subtest: pipe-C
[419.289634] Dynamic subtest pipe-C: SUCCESS (1.427s)
[419.301027] Starting dynamic subtest: pipe-D
[420.735351] Dynamic subtest pipe-D: SUCCESS (1.445s)
[420.737617] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (4.651s)
[421.902286] [076/155] (598s left) kms_atomic (crtc-invalid-params)
[421.992268] Starting subtest: crtc-invalid-params
[421.994862] Starting dynamic subtest: pipe-A-eDP-1
[422.348181] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.356s)
[422.350577] Subtest crtc-invalid-params: SUCCESS (0.357s)
[423.233161] [077/155] (597s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[423.348862] Starting subtest: cursorA-vs-flipA-atomic-transitions
[434.524175] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.174s)
[435.386170] [078/155] (585s left) kms_dp_linktrain_fallback (dsc-fallback)
[435.487035] Starting subtest: dsc-fallback
[435.493793] Subtest dsc-fallback: SKIP (0.000s)
[435.575101] [079/155] (584s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[435.677100] Starting subtest: psr-rgb101010-draw-render
[442.983346] Subtest psr-rgb101010-draw-render: SUCCESS (7.311s)
[443.112268] [080/155] (577s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-wc)
[443.215699] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-wc
[443.219733] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[443.322305] [081/155] (577s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[443.381955] Starting subtest: x-tiled-to-vebox-y-tiled
[443.386565] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[443.578729] [082/155] (576s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[443.679755] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[443.683773] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[443.800687] [083/155] (576s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[443.897898] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[443.901945] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[443.993924] [084/155] (576s left) gem_exec_parallel (basic)
[444.057649] Starting subtest: basic
[444.059995] Starting dynamic subtest: rcs0
[445.520997] Dynamic subtest rcs0: SUCCESS (1.463s)
[445.534864] Starting dynamic subtest: bcs0
[446.995805] Dynamic subtest bcs0: SUCCESS (1.473s)
[447.009699] Starting dynamic subtest: vcs0
[448.658027] Dynamic subtest vcs0: SUCCESS (1.659s)
[448.668756] Starting dynamic subtest: vcs1
[450.693625] Dynamic subtest vcs1: SUCCESS (2.034s)
[450.704591] Starting dynamic subtest: vecs0
[452.678220] Dynamic subtest vecs0: SUCCESS (1.981s)
[452.690574] Starting dynamic subtest: ccs0
[454.186101] Dynamic subtest ccs0: SUCCESS (1.507s)
[454.188374] Subtest basic: SUCCESS (10.129s)
[454.377724] [085/155] (566s left) kms_dsc (dsc-fractional-bpp-with-bpc)
[454.486256] Starting subtest: dsc-fractional-bpp-with-bpc
[454.517733] Subtest dsc-fractional-bpp-with-bpc: SKIP (0.001s)
[454.558690] [086/155] (566s left) gem_exec_balancer (parallel-ordering)
[454.808963] Starting subtest: parallel-ordering
[455.771366] Subtest parallel-ordering: SUCCESS (0.962s)
[455.907755] [087/155] (564s left) gem_sync (basic-all)
[455.975726] Starting subtest: basic-all
[459.654816] Subtest basic-all: SUCCESS (3.687s)
[459.858408] [088/155] (560s left) gem_ppgtt (shrink-vs-evict-pinned)
[459.911815] Starting subtest: shrink-vs-evict-pinned
[465.700203] Subtest shrink-vs-evict-pinned: SUCCESS (5.785s)
[465.785635] [089/155] (555s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[465.879500] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-mmap-wc
[465.883617] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[465.977859] [090/155] (554s left) i915_pm_rps (basic-api)
[466.041147] Starting subtest: basic-api
[466.045863] Subtest basic-api: SKIP (0.001s)
[466.144430] [091/155] (554s left) prime_mmap (test_refcounting)
[466.203139] Starting subtest: test_refcounting
[466.205476] Starting dynamic subtest: test_refcounting-smem
[466.232990] Dynamic subtest test_refcounting-smem: SUCCESS (0.031s)
[466.235391] Subtest test_refcounting: SUCCESS (0.032s)
[466.349843] [092/155] (554s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-onoff)
[466.438028] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-onoff
[466.442233] Subtest fbchdr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[466.541492] [093/155] (554s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-onoff)
[466.635351] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-onoff
[466.639699] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[466.735725] [094/155] (554s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0)
[466.838033] Starting subtest: linear-max-hw-stride-32bpp-rotate-0
[467.907507] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.068s)
[468.017516] [095/155] (553s left) gem_userptr_blits (unsync-unmap-cycles)
[468.079149] Subtest unsync-unmap-cycles: SKIP (0.000s)
[468.198365] [096/155] (552s left) kms_addfb_basic (addfb25-bad-modifier)
[468.282573] Starting subtest: addfb25-bad-modifier
[468.284386] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[468.378458] [097/155] (552s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[468.477914] Starting subtest: yf-tiled-32bpp-rotate-270
[468.481770] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[468.587770] [098/155] (552s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-pwrite)
[468.691304] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-pwrite
[468.694698] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[468.798396] [099/155] (552s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[468.901081] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[469.590920] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.692s)
[469.746650] [100/155] (551s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[469.854568] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[473.921324] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (4.072s)
[475.089944] [101/155] (546s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[475.197483] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[475.199827] Starting dynamic subtest: pipe-A-eDP-1
[475.292575] Dynamic subtest pipe-A-eDP-1: SKIP (0.099s)
[475.304565] Starting dynamic subtest: pipe-B-eDP-1
[476.441434] Dynamic subtest pipe-B-eDP-1: SKIP (1.143s)
[476.445952] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.245s)
[477.734627] [102/155] (543s left) gem_exec_schedule (pi-shared-iova)
[477.911827] Starting subtest: pi-shared-iova
[477.914342] Starting dynamic subtest: rcs0
[477.992747] Dynamic subtest rcs0: SUCCESS (0.083s)
[478.005777] Starting dynamic subtest: vcs0
[478.048249] Dynamic subtest vcs0: SUCCESS (0.055s)
[478.068451] Starting dynamic subtest: vcs1
[478.102323] Dynamic subtest vcs1: SUCCESS (0.052s)
[478.115436] Starting dynamic subtest: vecs0
[478.164243] Dynamic subtest vecs0: SUCCESS (0.061s)
[478.177521] Starting dynamic subtest: ccs0
[478.220532] Dynamic subtest ccs0: SUCCESS (0.056s)
[478.222918] Subtest pi-shared-iova: SUCCESS (0.312s)
[479.792286] [103/155] (541s left) api_intel_allocator (standalone)
[479.852538] Starting subtest: standalone
[479.869258] Subtest standalone: SUCCESS (0.018s)
[479.995423] [104/155] (541s left) kms_color (ctm-blue-to-red)
[480.088320] Starting subtest: ctm-blue-to-red
[480.090509] Starting dynamic subtest: pipe-A-eDP-1
[480.777502] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.689s)
[480.790409] Starting dynamic subtest: pipe-B-eDP-1
[482.204120] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.427s)
[482.214859] Starting dynamic subtest: pipe-C-eDP-1
[483.603054] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.397s)
[483.614723] Starting dynamic subtest: pipe-D-eDP-1
[484.917242] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.312s)
[484.920061] Subtest ctm-blue-to-red: SUCCESS (4.829s)
[485.751641] [105/155] (535s left) perf_pmu (gt-awake)
[485.790052] Starting subtest: gt-awake
[494.666000] Subtest gt-awake: SUCCESS (8.871s)
[494.783916] [106/155] (526s left) gem_eio (create)
[494.967599] Starting subtest: create
[495.231860] Subtest create: SUCCESS (0.264s)
[495.385685] [107/155] (526s left) kms_content_protection (legacy)
[495.526969] Starting subtest: legacy
[495.532195] Subtest legacy: SKIP (0.000s)
[495.672801] [108/155] (526s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[495.771230] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[495.774990] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[495.861525] [109/155] (525s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[495.950675] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[495.954067] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[496.054853] [110/155] (525s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[496.106869] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[496.108877] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[496.226673] [111/155] (525s left) prime_mmap (test_reprime)
[496.289878] Starting subtest: test_reprime
[496.291815] Starting dynamic subtest: test_reprime-smem
[496.318095] Dynamic subtest test_reprime-smem: SUCCESS (0.031s)
[496.320255] Subtest test_reprime: SUCCESS (0.032s)
[496.420864] [112/155] (525s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[496.521036] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[496.524491] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[496.625994] [113/155] (525s left) kms_frontbuffer_tracking (psr-slowdraw)
[496.721892] Starting subtest: psr-slowdraw
[521.938655] Subtest psr-slowdraw: SUCCESS (25.214s)
[522.087959] [114/155] (499s left) gem_userptr_blits (stress-mm-invalidate-close)
[522.149093] Starting subtest: stress-mm-invalidate-close
[524.295411] Subtest stress-mm-invalidate-close: SUCCESS (2.148s)
[524.446304] [115/155] (497s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[524.535554] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[524.537846] Starting dynamic subtest: pipe-A-eDP-1
[524.561172] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[524.574561] Starting dynamic subtest: pipe-B-eDP-1
[524.596421] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[524.607877] Starting dynamic subtest: pipe-C-eDP-1
[524.629093] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[524.639595] Starting dynamic subtest: pipe-D-eDP-1
[524.661584] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[524.665590] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.004s)
[526.883024] [116/155] (495s left) kms_psr (fbc-psr2-sprite-plane-onoff)
[526.979491] Starting subtest: fbc-psr2-sprite-plane-onoff
[526.981828] Starting dynamic subtest: eDP-1
[526.985880] Dynamic subtest eDP-1: SKIP (0.000s)
[526.989952] Subtest fbc-psr2-sprite-plane-onoff: SKIP (0.001s)
[527.067506] [117/155] (495s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[527.150007] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[527.152509] Starting dynamic subtest: pipe-A
[527.169280] Dynamic subtest pipe-A: SKIP (0.016s)
[527.181919] Starting dynamic subtest: pipe-B
[527.201152] Dynamic subtest pipe-B: SKIP (0.031s)
[527.212617] Starting dynamic subtest: pipe-C
[527.230761] Dynamic subtest pipe-C: SKIP (0.030s)
[527.241921] Starting dynamic subtest: pipe-D
[527.262337] Dynamic subtest pipe-D: SKIP (0.030s)
[527.266874] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.110s)
[527.354694] [118/155] (494s left) api_intel_bb (simple-bb)
[527.406713] Starting subtest: simple-bb
[527.413069] Subtest simple-bb: SUCCESS (0.007s)
[527.568060] [119/155] (494s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-onoff)
[527.668376] Starting subtest: hdr-2p-scndscrn-spr-indfb-onoff
[527.672516] Subtest hdr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[527.778794] [120/155] (494s left) gem_ppgtt (flink-and-close-vma-leak)
[527.836720] Starting subtest: flink-and-close-vma-leak
[527.881213] Subtest flink-and-close-vma-leak: SUCCESS (0.044s)
[527.997469] [121/155] (494s left) gem_create (hog-create)
[528.053942] Starting subtest: hog-create
[528.055868] Starting dynamic subtest: smem0
[561.664365] Dynamic subtest smem0: SUCCESS (33.611s)
[561.667012] Subtest hog-create: SUCCESS (33.613s)
[561.854414] [122/155] (460s left) gem_exec_reloc (basic-gtt-active)
[561.922882] Subtest basic-gtt-active: SKIP (0.000s)
[562.001157] [123/155] (460s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[562.095252] Starting subtest: random-ccs-data-y-tiled-ccs
[562.097550] Starting dynamic subtest: pipe-A-eDP-1
[562.127228] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[562.139238] Starting dynamic subtest: pipe-B-eDP-1
[562.162344] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[562.172580] Starting dynamic subtest: pipe-C-eDP-1
[562.196645] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[562.207070] Starting dynamic subtest: pipe-D-eDP-1
[562.231341] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[562.235410] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.004s)
[564.423899] [124/155] (457s left) gem_exec_reloc (basic-gtt-read)
[564.474905] Subtest basic-gtt-read: SKIP (0.000s)
[564.533636] [125/155] (457s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier)
[564.623252] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier
[564.627407] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier: SKIP (0.000s)
[564.709671] [126/155] (457s left) kms_psr (psr2-cursor-plane-onoff)
[564.792515] Starting subtest: psr2-cursor-plane-onoff
[564.794806] Starting dynamic subtest: eDP-1
[566.496001] Dynamic subtest eDP-1: SUCCESS (1.704s)
[566.498236] Subtest psr2-cursor-plane-onoff: SUCCESS (1.705s)
[567.387794] [127/155] (455s left) gem_unfence_active_buffers
[567.570700] [128/155] (455s left) kms_pm_dc (dc6-dpms)
[568.676692] Starting subtest: dc6-dpms
[570.757372] Subtest dc6-dpms: SUCCESS (2.080s)
[570.835591] [129/155] (451s left) syncobj_timeline (multi-wait-all-available-signaled)
[570.896146] Starting subtest: multi-wait-all-available-signaled
[570.898626] Subtest multi-wait-all-available-signaled: SUCCESS (0.000s)
[571.019580] [130/155] (451s left) kms_flip (basic-flip-vs-modeset)
[571.113546] Starting subtest: basic-flip-vs-modeset
[571.115879] Starting dynamic subtest: A-eDP1
[573.716770] Dynamic subtest A-eDP1: SUCCESS (2.601s)
[573.728438] Starting dynamic subtest: B-eDP1
[575.891193] Dynamic subtest B-eDP1: SUCCESS (2.174s)
[575.903952] Starting dynamic subtest: C-eDP1
[578.070621] Dynamic subtest C-eDP1: SUCCESS (2.178s)
[578.082038] Starting dynamic subtest: D-eDP1
[580.237957] Dynamic subtest D-eDP1: SUCCESS (2.165s)
[580.240105] Subtest basic-flip-vs-modeset: SUCCESS (9.126s)
[581.054184] [131/155] (441s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[581.153556] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[581.157385] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[581.261839] [132/155] (441s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-render)
[581.362128] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-render
[581.366537] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[581.458230] [133/155] (441s left) syncobj_eventfd (timeline-wait-before-signal)
[581.510207] Starting subtest: timeline-wait-before-signal
[581.540145] Subtest timeline-wait-before-signal: SUCCESS (0.031s)
[581.627953] [134/155] (441s left) prime_vgem (basic-write)
[581.701897] Starting subtest: basic-write
[581.719874] Subtest basic-write: SKIP (0.018s)
[581.823140] [135/155] (441s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-onoff)
[581.921394] Starting subtest: psrhdr-2p-primscrn-cur-indfb-onoff
[581.925388] Subtest psrhdr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[582.034428] [136/155] (440s left) kms_cursor_crc (cursor-alpha-transparent)
[582.129958] Starting subtest: cursor-alpha-transparent
[582.131979] Starting dynamic subtest: pipe-A-eDP-1
[582.738157] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.608s)
[582.750630] Starting dynamic subtest: pipe-D-eDP-1
[584.018520] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.279s)
[584.020866] Subtest cursor-alpha-transparent: SUCCESS (1.890s)
[584.937280] [137/155] (438s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[585.030965] Starting subtest: psr-1p-primscrn-cur-indfb-move
[592.371573] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.346s)
[592.509240] [138/155] (430s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[592.602755] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[592.610940] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.011s)
[592.692280] [139/155] (430s left) i915_selftest (perf)
[594.508725] Starting subtest: perf
[594.511154] Starting dynamic subtest: engine_cs
[598.851512] Dynamic subtest engine_cs: SUCCESS (4.343s)
[598.860842] Starting dynamic subtest: request
[606.208568] Dynamic subtest request: SUCCESS (7.353s)
[606.226746] Starting dynamic subtest: migrate
[610.568548] Dynamic subtest migrate: SUCCESS (4.357s)
[610.582167] Starting dynamic subtest: region
[616.665243] Dynamic subtest region: SUCCESS (6.095s)
[616.668198] Subtest perf: SUCCESS (22.157s)
[616.697674] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[616.698482] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[616.702124] [140/155] (406s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[618.279026] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[618.283396] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[618.385936] [FACT kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[618.387226] [FACT kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)] new: kernel.kmod_is_loaded.i915: true
[618.390902] [141/155] (404s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[618.444606] Starting subtest: y-tiled-ccs-to-yf-tiled
[618.448986] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[618.627824] [142/155] (404s left) gem_ctx_persistence (userptr)
[618.699612] Starting subtest: userptr
[618.885596] Subtest userptr: SUCCESS (0.185s)
[618.980599] [143/155] (404s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[619.090143] Starting subtest: 2x-flip-vs-cursor-atomic
[619.094793] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s)
[619.238488] [144/155] (404s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[619.335565] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[619.339907] Subtest fbchdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[619.432358] [145/155] (403s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[619.534398] Starting subtest: fbc-indfb-scaledprimary
[622.397312] Subtest fbc-indfb-scaledprimary: SUCCESS (2.868s)
[623.606197] [146/155] (399s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping)
[623.703525] Starting subtest: pixel-format-4-tiled-modifier-source-clamping
[623.730168] Starting dynamic subtest: pipe-A-plane-0
[624.108044] Dynamic subtest pipe-A-plane-0: SUCCESS (0.378s)
[624.118920] Starting dynamic subtest: pipe-A-plane-3
[624.429867] Dynamic subtest pipe-A-plane-3: SUCCESS (0.321s)
[625.590766] Starting dynamic subtest: pipe-B-plane-0
[625.981313] Dynamic subtest pipe-B-plane-0: SUCCESS (0.400s)
[625.993815] Starting dynamic subtest: pipe-B-plane-3
[626.295497] Dynamic subtest pipe-B-plane-3: SUCCESS (0.310s)
[626.607843] Subtest pixel-format-4-tiled-modifier-source-clamping: SUCCESS (2.905s)
[627.473252] [147/155] (395s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[627.570356] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu
[627.574793] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[627.674755] [148/155] (395s left) kms_flip (dpms-vs-vblank-race)
[627.764594] Starting subtest: dpms-vs-vblank-race
[627.766901] Starting dynamic subtest: A-eDP1
[631.740037] Dynamic subtest A-eDP1: SUCCESS (3.971s)
[631.753971] Starting dynamic subtest: B-eDP1
[635.320243] Dynamic subtest B-eDP1: SUCCESS (3.578s)
[635.330511] Starting dynamic subtest: C-eDP1
[639.944931] Dynamic subtest C-eDP1: SUCCESS (4.623s)
[639.955153] Starting dynamic subtest: D-eDP1
[644.586233] Dynamic subtest D-eDP1: SUCCESS (4.640s)
[644.588627] Subtest dpms-vs-vblank-race: SUCCESS (16.822s)
[645.464204] [149/155] (378s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[645.568407] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[645.572750] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[645.665256] [150/155] (377s left) syncobj_wait (single-wait-for-submit-signaled)
[645.722644] Starting subtest: single-wait-for-submit-signaled
[645.724899] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s)
[645.829557] [151/155] (377s left) gem_ccs (block-multicopy-inplace)
[645.884378] Starting subtest: block-multicopy-inplace
[645.888620] Subtest block-multicopy-inplace: SKIP (0.000s)
[646.009929] [152/155] (377s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[646.110621] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[646.115131] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[646.208161] [153/155] (377s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[646.315774] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[646.320143] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[646.424466] [154/155] (377s left) sw_sync (sync_busy_fork_unixsocket)
[646.459520] Starting subtest: sync_busy_fork_unixsocket
[646.464336] Subtest sync_busy_fork_unixsocket: SUCCESS (0.006s)
[646.520109] [155/155] (377s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[646.603752] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[646.607243] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[646.715892] 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_frontbuffer_tracking
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: gen9_exec_parse
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: gem_lmem_swapping
results: parsing output: 7/ for test: kms_pm_rpm
results: parsing output: 8/ for test: kms_scaling_modes
results: parsing output: 9/ for test: kms_properties
results: parsing output: 10/ for test: kms_chamelium_hpd
results: parsing output: 11/ for test: vgem_basic
results: parsing output: 12/ for test: kms_psr
results: parsing output: 13/ for test: kms_atomic_interruptible
results: parsing output: 14/ for test: kms_properties
results: parsing output: 15/ for test: syncobj_timeline
results: parsing output: 16/ for test: kms_flip_scaled_crc
results: parsing output: 17/ for test: kms_getfb
results: parsing output: 18/ for test: gem_mmap_offset
results: parsing output: 19/ for test: kms_vblank
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: gem_exec_schedule
results: parsing output: 22/ for test: gem_exec_schedule
results: parsing output: 23/ for test: syncobj_wait
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: gem_vm_create
results: parsing output: 26/ for test: kms_psr
results: parsing output: 27/ for test: kms_atomic_transition
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_cursor_crc
results: parsing output: 30/ for test: sysfs_timeslice_duration
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gen9_exec_parse
results: parsing output: 33/ for test: gem_exec_params
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: kms_plane_alpha_blend
results: parsing output: 38/ for test: kms_properties
results: parsing output: 39/ for test: kms_cursor_crc
results: parsing output: 40/ for test: gen3_render_linear_blits
results: parsing output: 41/ for test: kms_lease
results: parsing output: 42/ for test: perf
results: parsing output: 43/ for test: gem_render_copy
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: gem_exec_whisper
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: gem_ctx_isolation
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_async_flips
results: parsing output: 50/ for test: kms_vblank
results: parsing output: 51/ for test: device_reset
results: parsing output: 52/ for test: kms_cursor_legacy
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: kms_ccs
results: parsing output: 55/ for test: gem_exec_fence
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_psr
results: parsing output: 58/ for test: syncobj_wait
results: parsing output: 59/ for test: kms_flip
results: parsing output: 60/ for test: prime_busy
results: parsing output: 61/ for test: kms_chamelium_edid
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_spin_batch
results: parsing output: 64/ for test: syncobj_timeline
results: parsing output: 65/ for test: kms_invalid_mode
results: parsing output: 66/ for test: kms_big_fb
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: gem_exec_whisper
results: parsing output: 69/ for test: kms_busy
results: parsing output: 70/ for test: gem_workarounds
results: parsing output: 71/ for test: gem_exec_balancer
results: parsing output: 72/ for test: i915_hangman
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_plane_scaling
results: parsing output: 75/ for test: kms_atomic
results: parsing output: 76/ for test: kms_cursor_legacy
results: parsing output: 77/ for test: kms_dp_linktrain_fallback
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: gem_render_copy
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: gem_exec_parallel
results: parsing output: 84/ for test: kms_dsc
results: parsing output: 85/ for test: gem_exec_balancer
results: parsing output: 86/ for test: gem_sync
results: parsing output: 87/ for test: gem_ppgtt
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: i915_pm_rps
results: parsing output: 90/ for test: prime_mmap
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: gem_userptr_blits
results: parsing output: 95/ for test: kms_addfb_basic
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_psr2_sf
results: parsing output: 101/ for test: gem_exec_schedule
results: parsing output: 102/ for test: api_intel_allocator
results: parsing output: 103/ for test: kms_color
results: parsing output: 104/ for test: perf_pmu
results: parsing output: 105/ for test: gem_eio
results: parsing output: 106/ for test: kms_content_protection
results: parsing output: 107/ for test: kms_big_fb
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: syncobj_timeline
results: parsing output: 110/ for test: prime_mmap
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: gem_userptr_blits
results: parsing output: 114/ for test: kms_ccs
results: parsing output: 115/ for test: kms_psr
results: parsing output: 116/ for test: kms_plane_scaling
results: parsing output: 117/ for test: api_intel_bb
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: gem_ppgtt
results: parsing output: 120/ for test: gem_create
results: parsing output: 121/ for test: gem_exec_reloc
results: parsing output: 122/ for test: kms_ccs
results: parsing output: 123/ for test: gem_exec_reloc
results: parsing output: 124/ for test: kms_plane
results: parsing output: 125/ for test: kms_psr
results: parsing output: 126/ for test: gem_unfence_active_buffers
results: parsing output: 127/ for test: kms_pm_dc
results: parsing output: 128/ for test: syncobj_timeline
results: parsing output: 129/ for test: kms_flip
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: syncobj_eventfd
results: parsing output: 133/ for test: prime_vgem
results: parsing output: 134/ for test: kms_frontbuffer_tracking
results: parsing output: 135/ for test: kms_cursor_crc
results: parsing output: 136/ for test: kms_frontbuffer_tracking
results: parsing output: 137/ for test: kms_flip
results: parsing output: 138/ for test: i915_selftest
results: parsing output: 139/ for test: kms_frontbuffer_tracking
results: parsing output: 140/ for test: gem_render_copy
results: parsing output: 141/ for test: gem_ctx_persistence
results: parsing output: 142/ for test: kms_cursor_legacy
results: parsing output: 143/ for test: kms_frontbuffer_tracking
results: parsing output: 144/ for test: kms_frontbuffer_tracking
results: parsing output: 145/ for test: kms_plane
results: parsing output: 146/ for test: kms_frontbuffer_tracking
results: parsing output: 147/ for test: kms_flip
results: parsing output: 148/ for test: kms_frontbuffer_tracking
results: parsing output: 149/ for test: syncobj_wait
results: parsing output: 150/ for test: gem_ccs
results: parsing output: 151/ for test: kms_frontbuffer_tracking
results: parsing output: 152/ for test: kms_frontbuffer_tracking
results: parsing output: 153/ for test: sw_sync
results: parsing output: 154/ for test: kms_frontbuffer_tracking
Done.