[41.625382] Initializing watchdogs
[41.625429]   /dev/watchdog0
[41.632287] [001/130] (960s left) gem_vm_create (invalid-create)
[41.694722] Starting subtest: invalid-create
[41.696835] Subtest invalid-create: SUCCESS (0.002s)
[41.761768] [002/130] (960s left) gem_tiled_fence_blits (basic)
[41.815367] Subtest basic: SKIP (0.000s)
[41.876504] [003/130] (960s left) gem_bad_reloc (negative-reloc-bltcopy)
[41.942576] Subtest negative-reloc-bltcopy: SKIP (0.000s)
[41.999237] [004/130] (960s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[42.061593] Starting subtest: x-tiled-to-vebox-y-tiled
[42.066221] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[42.220848] [005/130] (959s left) api_intel_bb (destroy-bb)
[42.283068] Starting subtest: destroy-bb
[42.295108] Subtest destroy-bb: SUCCESS (0.013s)
[42.398522] [006/130] (959s left) kms_chamelium_color (ctm-max)
[42.520214] Subtest ctm-max: SKIP (0.000s)
[42.540967] [007/130] (959s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render)
[42.648391] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render
[42.654627] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[42.747179] [008/130] (959s left) kms_pm_dc (dc3co-vpb-simulation)
[42.852235] Starting subtest: dc3co-vpb-simulation
[52.031213] Subtest dc3co-vpb-simulation: SKIP (9.156s)
[52.141232] [009/130] (950s left) gem_exec_fence (syncobj-timeline-chain-engines)
[52.704083] Starting subtest: syncobj-timeline-chain-engines
[52.782970] Subtest syncobj-timeline-chain-engines: SUCCESS (0.079s)
[53.951506] [010/130] (948s left) i915_hangman (error-state-basic)
[54.012641] Starting subtest: error-state-basic
[54.107919] Subtest error-state-basic: SUCCESS (0.096s)
[54.161117] [011/130] (948s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[54.289927] Starting subtest: flip-vs-cursor-busy-crc-atomic
[55.168861] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.869s)
[56.062593] [012/130] (946s left) gem_softpin (evict-prime-sanity-check)
[56.121907] Starting subtest: evict-prime-sanity-check
[56.124271] Starting dynamic subtest: rcs0
[57.322277] Dynamic subtest rcs0: SUCCESS (1.190s)
[57.331566] Starting dynamic subtest: bcs0
[58.463054] Dynamic subtest bcs0: SUCCESS (1.132s)
[58.473338] Starting dynamic subtest: vcs0
[59.947451] Dynamic subtest vcs0: SUCCESS (1.474s)
[59.955669] Starting dynamic subtest: vcs1
[61.886261] Dynamic subtest vcs1: SUCCESS (1.929s)
[61.894701] Starting dynamic subtest: vecs0
[63.874554] Dynamic subtest vecs0: SUCCESS (1.981s)
[63.881558] Starting dynamic subtest: ccs0
[65.039146] Dynamic subtest ccs0: SUCCESS (1.162s)
[65.048514] Starting dynamic subtest: all
[66.170830] Dynamic subtest all: SUCCESS (1.129s)
[66.173335] Subtest evict-prime-sanity-check: SUCCESS (9.998s)
[66.234920] [013/130] (936s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff)
[66.335584] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff
[69.146413] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (2.810s)
[69.273076] [014/130] (933s left) kms_vblank (ts-continuation-idle-hang)
[69.378524] Starting subtest: ts-continuation-idle-hang
[69.380530] Starting dynamic subtest: pipe-A-eDP-1
[95.629095] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.234s)
[95.643248] Starting dynamic subtest: pipe-D-eDP-1
[120.653868] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.017s)
[120.656290] Subtest ts-continuation-idle-hang: SUCCESS (51.255s)
[121.532711] [015/130] (880s left) gem_ctx_shared (q-smoketest)
[121.594309] Starting subtest: Q-smoketest
[121.596783] Starting dynamic subtest: rcs0
[127.173070] Dynamic subtest rcs0: SUCCESS (5.531s)
[127.180113] Starting dynamic subtest: bcs0
[132.685758] Dynamic subtest bcs0: SUCCESS (5.509s)
[132.697719] Starting dynamic subtest: vcs0
[138.199491] Dynamic subtest vcs0: SUCCESS (5.512s)
[138.208720] Starting dynamic subtest: vcs1
[143.702789] Dynamic subtest vcs1: SUCCESS (5.508s)
[143.709518] Starting dynamic subtest: vecs0
[149.205629] Dynamic subtest vecs0: SUCCESS (5.503s)
[149.213745] Starting dynamic subtest: ccs0
[154.729869] Dynamic subtest ccs0: SUCCESS (5.520s)
[154.732413] Subtest Q-smoketest: SUCCESS (33.085s)
[154.853437] [016/130] (847s left) kms_psr (psr-primary-render)
[154.950661] Starting subtest: psr-primary-render
[154.952979] Starting dynamic subtest: eDP-1
[156.707479] Dynamic subtest eDP-1: SUCCESS (1.755s)
[156.709574] Subtest psr-primary-render: SUCCESS (1.755s)
[157.629685] [017/130] (844s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[157.737183] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[157.741266] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[157.819418] [018/130] (844s left) perf (polling-small-buf)
[158.032509] Starting subtest: polling-small-buf
[158.124129] Subtest polling-small-buf: SUCCESS (0.091s)
[158.143664] [019/130] (844s left) gem_exec_flush (basic-wb-rw-default)
[158.209524] Starting subtest: basic-wb-rw-default
[163.684399] Subtest basic-wb-rw-default: SUCCESS (5.475s)
[163.846865] [020/130] (838s left) kms_psr (pr-sprite-plane-move)
[163.943099] Starting subtest: pr-sprite-plane-move
[163.947778] Subtest pr-sprite-plane-move: SKIP (0.000s)
[163.993895] [021/130] (838s left) vgem_basic (dmabuf-export)
[164.037944] Starting subtest: dmabuf-export
[164.064149] Subtest dmabuf-export: SUCCESS (0.029s)
[164.150379] [022/130] (838s left) dumb_buffer (map-valid)
[164.214882] Starting subtest: map-valid
[164.217112] Subtest map-valid: SUCCESS (0.000s)
[164.294187] [023/130] (838s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted)
[164.353109] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted
[164.355432] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.000s)
[164.436815] [024/130] (838s left) gem_exec_reloc (basic-range)
[164.501920] Subtest basic-range: SKIP (0.000s)
[164.571570] [025/130] (838s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format)
[164.677898] Starting subtest: plane-upscale-factor-0-25-with-pixel-format
[164.680306] Starting dynamic subtest: pipe-A
[165.772440] Dynamic subtest pipe-A: SUCCESS (1.095s)
[165.780416] Starting dynamic subtest: pipe-B
[168.009480] Dynamic subtest pipe-B: SUCCESS (2.237s)
[168.016196] Starting dynamic subtest: pipe-C
[169.275062] Dynamic subtest pipe-C: SUCCESS (1.265s)
[169.283816] Starting dynamic subtest: pipe-D
[170.554421] Dynamic subtest pipe-D: SUCCESS (1.279s)
[170.556706] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.876s)
[171.775657] [026/130] (830s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[171.829131] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[171.831115] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[171.895530] [027/130] (830s left) kms_invalid_mode (bad-vsync-end)
[171.992020] Starting subtest: bad-vsync-end
[171.994375] Starting dynamic subtest: pipe-A-eDP-1
[172.272793] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.281s)
[172.279845] Starting dynamic subtest: pipe-B-eDP-1
[172.282148] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[172.288736] Starting dynamic subtest: pipe-C-eDP-1
[172.291096] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[172.297787] Starting dynamic subtest: pipe-D-eDP-1
[172.299736] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[172.301694] Subtest bad-vsync-end: SUCCESS (0.287s)
[173.182264] [028/130] (829s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[173.280058] Starting subtest: fbc-pr-cursor-mmap-gtt
[173.284654] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[173.330994] [029/130] (829s left) kms_big_fb (yf-tiled-addfb)
[173.432484] Starting subtest: yf-tiled-addfb
[173.436686] Subtest yf-tiled-addfb: SKIP (0.000s)
[173.521955] [030/130] (829s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[173.619364] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[173.621747] Starting dynamic subtest: pipe-A-eDP-1
[173.642562] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[173.649951] Starting dynamic subtest: pipe-B-eDP-1
[173.669371] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[173.676143] Starting dynamic subtest: pipe-C-eDP-1
[173.695619] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[173.702195] Starting dynamic subtest: pipe-D-eDP-1
[173.721719] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[173.723892] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.006s)
[175.936684] [031/130] (826s left) api_intel_bb (reset-bb)
[175.988961] Starting subtest: reset-bb
[175.993872] Subtest reset-bb: SUCCESS (0.005s)
[176.096168] [032/130] (826s left) kms_atomic_transition (plane-all-modeset-transition)
[176.192187] Starting subtest: plane-all-modeset-transition
[176.196657] Subtest plane-all-modeset-transition: SKIP (0.000s)
[176.245359] [033/130] (826s left) gem_userptr_blits (forbidden-operations)
[176.308810] Starting subtest: forbidden-operations
[176.313197] Subtest forbidden-operations: SKIP (0.000s)
[176.424534] [034/130] (826s left) gem_ctx_persistence (legacy-engines-queued)
[176.483774] Starting subtest: legacy-engines-queued
[176.486142] Starting dynamic subtest: render
[176.569830] Dynamic subtest render: SUCCESS (0.085s)
[176.580178] Starting dynamic subtest: bsd1
[177.843135] Dynamic subtest bsd1: SUCCESS (1.272s)
[177.852935] Starting dynamic subtest: bsd2
[179.829968] Dynamic subtest bsd2: SUCCESS (1.984s)
[179.838882] Starting dynamic subtest: blt
[179.902629] Dynamic subtest blt: SUCCESS (0.072s)
[179.911961] Starting dynamic subtest: vebox
[181.876839] Dynamic subtest vebox: SUCCESS (1.972s)
[181.879717] Subtest legacy-engines-queued: SUCCESS (5.393s)
[181.938483] [035/130] (820s left) kms_lease (lease-unleased-connector)
[182.043096] Starting subtest: lease-unleased-connector
[182.045496] Starting dynamic subtest: pipe-A-eDP-1
[182.055816] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.011s)
[182.063966] Starting dynamic subtest: pipe-B-eDP-1
[182.066355] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s)
[182.074516] Starting dynamic subtest: pipe-C-eDP-1
[182.080237] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s)
[182.088194] Starting dynamic subtest: pipe-D-eDP-1
[182.090461] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.011s)
[182.092695] Subtest lease-unleased-connector: SUCCESS (0.046s)
[182.171619] [036/130] (820s left) gem_partial_pwrite_pread (reads-snoop)
[182.246674] Subtest reads-snoop: SKIP (0.000s)
[182.304540] [037/130] (820s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[182.361066] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[182.363136] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[182.448701] [038/130] (820s left) kms_vblank (crtc-id)
[182.544846] Starting subtest: crtc-id
[182.547175] Starting dynamic subtest: pipe-A-eDP-1
[182.967170] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.420s)
[182.980592] Starting dynamic subtest: pipe-D-eDP-1
[184.181836] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.211s)
[184.184077] Subtest crtc-id: SUCCESS (1.634s)
[185.086843] [039/130] (817s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[185.190479] Starting subtest: fbc-rgb565-draw-mmap-cpu
[188.066411] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (2.880s)
[188.159226] [040/130] (814s left) gen9_exec_parse (unaligned-jump)
[188.212967] Subtest unaligned-jump: SKIP (0.000s)
[188.252724] [041/130] (814s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[193.359072] Starting subtest: fbc-psr2-overlay-plane-update-continuous-sf
[193.361537] Starting dynamic subtest: pipe-A-eDP-1
[194.204269] Dynamic subtest pipe-A-eDP-1: SKIP (0.842s)
[194.213762] Starting dynamic subtest: pipe-B-eDP-1
[195.423857] Dynamic subtest pipe-B-eDP-1: SKIP (1.219s)
[195.428155] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (2.064s)
[196.670132] [042/130] (806s left) kms_psr (fbc-psr-cursor-plane-move)
[196.773135] Starting subtest: fbc-psr-cursor-plane-move
[196.775960] Starting dynamic subtest: eDP-1
[196.780357] Dynamic subtest eDP-1: SKIP (0.000s)
[196.784461] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[196.828226] [043/130] (806s left) gem_mmap_wc (write-cpu-read-wc)
[196.883141] Subtest write-cpu-read-wc: SKIP (0.000s)
[196.917254] [044/130] (806s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[197.030108] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[197.034288] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[197.118781] [045/130] (805s left) gem_exec_flush (basic-uc-pro-default)
[197.181653] Starting subtest: basic-uc-pro-default
[202.658025] Subtest basic-uc-pro-default: SUCCESS (5.479s)
[202.824038] [046/130] (800s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[203.204876] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[204.071917] [047/130] (799s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[204.175030] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[204.177361] Starting dynamic subtest: pipe-A-eDP-1
[204.186441] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[204.194648] Starting dynamic subtest: pipe-B-eDP-1
[204.202787] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[204.209801] Starting dynamic subtest: pipe-C-eDP-1
[204.218246] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[204.224729] Starting dynamic subtest: pipe-D-eDP-1
[204.233191] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[204.237221] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.003s)
[206.526142] [048/130] (796s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[206.644320] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[206.648190] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[206.736656] [049/130] (796s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling)
[206.833055] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling
[206.835396] Starting dynamic subtest: pipe-A-default-mode
[207.120404] Dynamic subtest pipe-A-default-mode: SKIP (0.281s)
[207.125235] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.282s)
[207.998568] [050/130] (795s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size)
[208.118881] Starting subtest: basic-busy-flip-before-cursor-varying-size
[208.123647] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s)
[208.196032] [051/130] (794s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[208.308297] Starting subtest: cursorA-vs-flipB-toggle
[208.312769] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s)
[208.408357] [052/130] (794s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[208.521655] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[214.878816] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.358s)
[214.981440] [053/130] (788s left) kms_dsc (dsc-with-output-formats)
[215.071141] Starting subtest: dsc-with-output-formats
[215.075318] Subtest dsc-with-output-formats: SKIP (0.000s)
[215.123057] [054/130] (788s left) syncobj_wait (wait-all-complex)
[215.185614] Starting subtest: wait-all-complex
[215.397379] Subtest wait-all-complex: SUCCESS (0.212s)
[215.449892] [055/130] (787s left) kms_big_fb (linear-8bpp-rotate-270)
[215.559345] Starting subtest: linear-8bpp-rotate-270
[215.580050] Subtest linear-8bpp-rotate-270: SKIP (0.020s)
[215.697647] [056/130] (787s left) kms_frontbuffer_tracking (fbcpsr-stridechange)
[215.804872] Starting subtest: fbcpsr-stridechange
[219.997557] Subtest fbcpsr-stridechange: SUCCESS (4.195s)
[220.134347] [057/130] (783s left) gem_lmem_swapping (verify-ccs)
[220.177357] Subtest verify-ccs: SKIP (0.000s)
[220.196259] [058/130] (783s left) sw_sync (alloc_timeline)
[220.233852] Starting subtest: alloc_timeline
[220.236090] Subtest alloc_timeline: SUCCESS (0.000s)
[220.265520] [059/130] (783s left) syncobj_wait (multi-wait-submitted-signaled)
[220.320910] Starting subtest: multi-wait-submitted-signaled
[220.323352] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[220.407488] [060/130] (782s left) kms_cursor_crc (cursor-offscreen-64x64)
[220.563958] Starting subtest: cursor-offscreen-64x64
[220.568757] Starting dynamic subtest: pipe-A-eDP-1
[222.473097] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.906s)
[222.494687] Starting dynamic subtest: pipe-D-eDP-1
[225.134389] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.644s)
[225.136760] Subtest cursor-offscreen-64x64: SUCCESS (4.569s)
[226.000514] [061/130] (777s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[226.098029] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[226.102171] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[226.170400] [062/130] (777s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[226.278576] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[229.678597] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (3.404s)
[229.782261] [063/130] (773s left) i915_selftest (live)
[233.969552] Starting subtest: live
[233.972089] Starting dynamic subtest: sanitycheck
[238.780076] Dynamic subtest sanitycheck: SUCCESS (4.810s)
[238.788241] Starting dynamic subtest: uncore
[241.672054] Dynamic subtest uncore: SUCCESS (2.890s)
[241.680561] Starting dynamic subtest: workarounds
[245.006089] Dynamic subtest workarounds: SUCCESS (3.332s)
[245.014519] Starting dynamic subtest: gt_engines
[249.975896] Dynamic subtest gt_engines: SUCCESS (4.968s)
[249.984640] Starting dynamic subtest: gt_timelines
[263.997145] Dynamic subtest gt_timelines: SUCCESS (14.019s)
[264.003996] Starting dynamic subtest: gt_contexts
[268.923507] Dynamic subtest gt_contexts: SUCCESS (4.924s)
[268.931260] Starting dynamic subtest: gt_lrc
[275.004482] Dynamic subtest gt_lrc: SUCCESS (6.079s)
[275.013394] Starting dynamic subtest: gt_mocs
[279.875556] Dynamic subtest gt_mocs: SUCCESS (4.870s)
[279.883607] Starting dynamic subtest: gt_pm
[285.753930] Dynamic subtest gt_pm: SUCCESS (5.876s)
[285.762223] Starting dynamic subtest: gt_heartbeat
[290.492201] Dynamic subtest gt_heartbeat: SUCCESS (4.737s)
[290.500585] Starting dynamic subtest: gt_tlb
[298.728196] Dynamic subtest gt_tlb: SUCCESS (8.233s)
[298.736175] Starting dynamic subtest: requests
[312.238095] Dynamic subtest requests: SUCCESS (13.507s)
[312.246604] Starting dynamic subtest: migrate
[318.071863] Dynamic subtest migrate: SUCCESS (5.832s)
[318.078071] Starting dynamic subtest: active
[322.827588] Dynamic subtest active: SUCCESS (4.755s)
[322.836069] Starting dynamic subtest: objects
[326.107991] Dynamic subtest objects: SUCCESS (3.277s)
[326.117448] Starting dynamic subtest: mman
[329.596993] Dynamic subtest mman: SUCCESS (3.487s)
[329.605046] Starting dynamic subtest: dmabuf
[334.372920] Dynamic subtest dmabuf: SUCCESS (4.774s)
[334.381087] Starting dynamic subtest: vma
[339.155669] Dynamic subtest vma: SUCCESS (4.782s)
[339.164972] Starting dynamic subtest: coherency
[344.044993] Dynamic subtest coherency: SUCCESS (4.887s)
[344.053199] Starting dynamic subtest: gtt
[353.628045] Dynamic subtest gtt: SUCCESS (9.581s)
[353.635958] Starting dynamic subtest: gem
[361.833943] Dynamic subtest gem: SUCCESS (8.205s)
[361.842287] Starting dynamic subtest: evict
[365.646463] Dynamic subtest evict: SUCCESS (3.811s)
[365.654924] Starting dynamic subtest: hugepages
[376.621553] Dynamic subtest hugepages: SUCCESS (10.973s)
[376.629029] Starting dynamic subtest: gem_contexts
[403.714047] Dynamic subtest gem_contexts: SUCCESS (27.090s)
[403.722054] Starting dynamic subtest: client
[408.606649] Dynamic subtest client: SUCCESS (4.892s)
[408.614517] Starting dynamic subtest: gem_migrate
[411.408091] Dynamic subtest gem_migrate: SUCCESS (2.799s)
[411.416135] Starting dynamic subtest: reset
[414.206916] Dynamic subtest reset: SUCCESS (2.797s)
[414.215284] Starting dynamic subtest: memory_region
[418.969855] Dynamic subtest memory_region: SUCCESS (4.762s)
[418.978142] Starting dynamic subtest: hangcheck
[431.775322] Dynamic subtest hangcheck: SUCCESS (12.802s)
[431.783727] Starting dynamic subtest: execlists
[436.625974] Dynamic subtest execlists: SUCCESS (4.849s)
[436.633085] Starting dynamic subtest: ring_submission
[441.446833] Dynamic subtest ring_submission: SUCCESS (4.819s)
[441.454725] Starting dynamic subtest: perf
[446.359229] Dynamic subtest perf: SUCCESS (4.910s)
[446.366521] Starting dynamic subtest: slpc
[460.410844] Dynamic subtest slpc: SUCCESS (14.051s)
[460.419300] Starting dynamic subtest: guc
[464.254045] Dynamic subtest guc: SUCCESS (3.840s)
[464.262584] Starting dynamic subtest: guc_multi_lrc
[469.040807] Dynamic subtest guc_multi_lrc: SUCCESS (4.785s)
[469.049365] Starting dynamic subtest: guc_hang
[473.925782] Dynamic subtest guc_hang: SUCCESS (4.883s)
[473.935692] Starting dynamic subtest: late_gt_pm
[478.814494] Dynamic subtest late_gt_pm: SUCCESS (4.886s)
[478.817439] Subtest live: SUCCESS (244.836s)
[479.123655] [064/130] (524s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs)
[480.672100] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs
[480.674455] Starting dynamic subtest: pipe-A-eDP-1
[480.696947] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[480.703634] Starting dynamic subtest: pipe-B-eDP-1
[480.724743] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[480.730809] Starting dynamic subtest: pipe-C-eDP-1
[480.752202] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[480.758387] Starting dynamic subtest: pipe-D-eDP-1
[480.780679] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[480.784920] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[483.016013] [065/130] (520s left) gem_exec_balancer (nop)
[483.086045] Starting subtest: nop
[529.670969] Subtest nop: SUCCESS (46.583s)
[529.953233] [066/130] (473s left) sw_sync (timeline_closed)
[529.984856] Starting subtest: timeline_closed
[529.987340] Subtest timeline_closed: SUCCESS (0.000s)
[530.020197] [067/130] (473s left) i915_pm_rpm (gem-idle)
[532.059309] Starting subtest: gem-idle
[538.255375] Subtest gem-idle: SUCCESS (6.197s)
[538.553178] [068/130] (464s left) gem_ctx_persistence (engines-hang)
[539.902090] Starting subtest: engines-hang
[539.904598] Starting dynamic subtest: rcs0
[540.076283] Dynamic subtest rcs0: SUCCESS (0.173s)
[540.085620] Starting dynamic subtest: bcs0
[540.151531] Dynamic subtest bcs0: SUCCESS (0.074s)
[540.158793] Starting dynamic subtest: vcs0
[540.324342] Dynamic subtest vcs0: SUCCESS (0.170s)
[540.333334] Starting dynamic subtest: vcs1
[540.432945] Dynamic subtest vcs1: SUCCESS (0.107s)
[540.442721] Starting dynamic subtest: vecs0
[540.544946] Dynamic subtest vecs0: SUCCESS (0.110s)
[540.555277] Starting dynamic subtest: ccs0
[540.664218] Dynamic subtest ccs0: SUCCESS (0.118s)
[540.666636] Subtest engines-hang: SUCCESS (0.763s)
[540.721690] [069/130] (462s left) perf (blocking-parameterized)
[540.846311] Starting subtest: blocking-parameterized
[560.867037] Subtest blocking-parameterized: SUCCESS (20.018s)
[560.894169] [070/130] (442s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[561.004612] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[566.158633] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (5.156s)
[566.270602] [071/130] (437s left) gem_exec_flush (basic-batch-kernel-default-uc)
[566.328384] Starting subtest: basic-batch-kernel-default-uc
[573.837863] Subtest basic-batch-kernel-default-uc: SUCCESS (7.509s)
[574.010206] [072/130] (429s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[574.067249] Starting subtest: multi-wait-all-for-submit-signaled
[574.069591] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[574.166437] [073/130] (429s left) kms_plane_multiple (tiling-x)
[574.262060] Starting subtest: tiling-x
[574.264341] Starting dynamic subtest: pipe-A-eDP-1
[578.188956] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.925s)
[578.197546] Starting dynamic subtest: pipe-B-eDP-1
[583.001198] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.809s)
[583.008513] Starting dynamic subtest: pipe-C-eDP-1
[587.713657] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.713s)
[587.722105] Starting dynamic subtest: pipe-D-eDP-1
[592.447293] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.733s)
[592.449627] Subtest tiling-x: SUCCESS (18.184s)
[593.341272] [074/130] (410s left) syncobj_wait (wait-delayed-signal)
[593.400611] Starting subtest: wait-delayed-signal
[593.502052] Subtest wait-delayed-signal: SUCCESS (0.103s)
[593.556120] [075/130] (410s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[593.656566] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[593.660905] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[593.734866] [076/130] (409s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[593.860373] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted
[593.988471] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SUCCESS (0.133s)
[595.134034] [077/130] (408s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[595.224254] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs
[595.226882] Starting dynamic subtest: pipe-A-eDP-1
[595.248665] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[595.257692] Starting dynamic subtest: pipe-B-eDP-1
[595.277215] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[595.284390] Starting dynamic subtest: pipe-C-eDP-1
[595.303998] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[595.311041] Starting dynamic subtest: pipe-D-eDP-1
[595.331530] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[595.333876] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.007s)
[597.563800] [078/130] (406s left) gem_exec_schedule (timeslicing)
[597.645067] Starting subtest: timeslicing
[597.647491] Starting dynamic subtest: rcs0
[597.653426] Dynamic subtest rcs0: SUCCESS (0.019s)
[597.663239] Starting dynamic subtest: bcs0
[597.673241] Dynamic subtest bcs0: SUCCESS (0.019s)
[597.682119] Starting dynamic subtest: vcs0
[597.692608] Dynamic subtest vcs0: SUCCESS (0.019s)
[597.699265] Starting dynamic subtest: vcs1
[597.713519] Dynamic subtest vcs1: SUCCESS (0.020s)
[597.720217] Starting dynamic subtest: vecs0
[597.734579] Dynamic subtest vecs0: SUCCESS (0.020s)
[597.741591] Starting dynamic subtest: ccs0
[597.755255] Dynamic subtest ccs0: SUCCESS (0.020s)
[597.757641] Subtest timeslicing: SUCCESS (0.122s)
[598.952473] [079/130] (404s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[599.058182] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[599.060548] Starting dynamic subtest: pipe-A-default-mode
[599.343852] Dynamic subtest pipe-A-default-mode: SKIP (0.281s)
[599.348990] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.283s)
[600.253352] [080/130] (403s left) kms_atomic (plane-overlay-legacy)
[600.356123] Starting subtest: plane-overlay-legacy
[600.358533] Starting dynamic subtest: pipe-A-eDP-1
[600.764056] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.406s)
[600.766487] Subtest plane-overlay-legacy: SUCCESS (0.407s)
[601.665095] [081/130] (402s left) gem_exec_params (invalid-fence-in-submit)
[601.728681] Starting subtest: invalid-fence-in-submit
[601.734457] Subtest invalid-fence-in-submit: SUCCESS (0.003s)
[601.818207] [082/130] (401s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[601.865404] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[601.972051] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.106s)
[602.026620] [083/130] (401s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[602.125726] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[602.130300] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[602.213856] [084/130] (401s left) kms_flip (2x-flip-vs-fences-interruptible)
[602.315765] Starting subtest: 2x-flip-vs-fences-interruptible
[602.320416] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s)
[602.403670] [085/130] (401s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[602.507739] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[602.511796] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[602.589673] [086/130] (401s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[602.648746] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[602.651025] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.001s)
[602.732257] [087/130] (401s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[607.842097] Starting subtest: pr-primary-plane-update-sf-dmg-area-big-fb
[607.846951] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.002s)
[608.765587] [088/130] (395s left) gem_mmap_offset (perf)
[608.820328] Starting subtest: perf
[608.822304] Starting dynamic subtest: smem0
[609.180511] Dynamic subtest smem0: SUCCESS (0.359s)
[609.182975] Subtest perf: SUCCESS (0.360s)
[609.267777] [089/130] (394s left) syncobj_wait (single-wait-all-for-submit-submitted)
[609.331151] Starting subtest: single-wait-all-for-submit-submitted
[609.435802] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.103s)
[609.493192] [090/130] (394s left) drm_fdinfo (isolation)
[609.536194] Starting subtest: isolation
[609.538428] Starting dynamic subtest: rcs0
[609.556020] Dynamic subtest rcs0: SKIP (0.021s)
[609.563281] Starting dynamic subtest: bcs0
[609.573985] Dynamic subtest bcs0: SKIP (0.017s)
[609.582853] Starting dynamic subtest: vcs0
[609.586771] Dynamic subtest vcs0: SKIP (0.000s)
[609.594143] Starting dynamic subtest: vcs1
[609.598379] Dynamic subtest vcs1: SKIP (0.000s)
[609.604748] Starting dynamic subtest: vecs0
[609.608776] Dynamic subtest vecs0: SKIP (0.000s)
[609.614986] Starting dynamic subtest: ccs0
[609.619130] Dynamic subtest ccs0: SKIP (0.000s)
[609.623143] Subtest isolation: SKIP (0.043s)
[609.637299] [091/130] (394s left) syncobj_timeline (single-wait-all-available-signaled)
[609.685792] Starting subtest: single-wait-all-available-signaled
[609.687938] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[609.766423] [092/130] (394s left) gem_exec_whisper (basic-queues-priority)
[609.836122] Starting subtest: basic-queues-priority
[632.972389] Subtest basic-queues-priority: SUCCESS (23.132s)
[633.136043] [093/130] (370s left) gem_lmem_swapping (heavy-multi)
[633.181568] Subtest heavy-multi: SKIP (0.000s)
[633.199150] [094/130] (370s left) kms_cursor_crc (cursor-onscreen-64x21)
[633.377589] Starting subtest: cursor-onscreen-64x21
[633.416792] Subtest cursor-onscreen-64x21: SKIP (0.032s)
[633.606986] [095/130] (370s left) kms_flip (basic-plain-flip)
[633.694925] Starting subtest: basic-plain-flip
[633.697443] Starting dynamic subtest: A-eDP1
[635.436471] Dynamic subtest A-eDP1: SUCCESS (1.740s)
[635.450673] Starting dynamic subtest: B-eDP1
[637.164355] Dynamic subtest B-eDP1: SUCCESS (1.725s)
[637.177826] Starting dynamic subtest: C-eDP1
[638.879863] Dynamic subtest C-eDP1: SUCCESS (1.713s)
[638.890681] Starting dynamic subtest: D-eDP1
[640.610627] Dynamic subtest D-eDP1: SUCCESS (1.730s)
[640.613081] Subtest basic-plain-flip: SUCCESS (6.919s)
[641.852202] [096/130] (362s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt)
[641.950594] Starting subtest: psr-2p-primscrn-indfb-msflip-blt
[641.954692] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[642.027459] [097/130] (362s left) kms_lease (multimaster-lease)
[642.122076] Starting subtest: multimaster-lease
[642.127328] Subtest multimaster-lease: SUCCESS (0.003s)
[642.207095] [098/130] (361s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[642.305024] Starting subtest: y-tiled-32bpp-rotate-270
[642.309436] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s)
[642.384257] [099/130] (361s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite)
[642.480811] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite
[646.989583] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (4.511s)
[647.091599] [100/130] (356s left) kms_pm_rpm (modeset-stress-extra-wait)
[647.197056] Abort requested by /sbin/init [1] via Terminated, terminating children
[647.197213] Abort requested by sudo LD_LIBRARY_PATH=/opt/igt/lib:/opt/igt/lib/x86_64-linux-gnu IGT_PING_HOSTNAME=10.211.124.1 IGT_CI_META_TEST=yes IGT [1429] via Terminated, terminating children
[647.197753] Abort requested by sudo LD_LIBRARY_PATH=/opt/igt/lib:/opt/igt/lib/x86_64-linux-gnu IGT_PING_HOSTNAME=10.211.124.1 IGT_CI_META_TEST=yes IGT [1429] via Hangup, terminating children
[647.197782] Exiting gracefully, currently running test will have a 'notrun' result
[647.222879] Closing watchdogs
Warning: No results set for igt@kms_pm_rpm
Done.