[41.563695] Initializing watchdogs
[41.563726]   /dev/watchdog0
[41.569249] [001/129] (960s left) api_intel_bb (intel-bb-blit-x)
[41.662675] Starting subtest: intel-bb-blit-x
[45.408365] Subtest intel-bb-blit-x: SUCCESS (3.745s)
[45.504938] [002/129] (956s left) kms_big_fb (linear-16bpp-rotate-90)
[45.599019] Starting subtest: linear-16bpp-rotate-90
[45.625329] Subtest linear-16bpp-rotate-90: SKIP (0.026s)
[45.712740] [003/129] (956s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[45.805586] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[45.810033] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[45.874569] [004/129] (956s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling)
[45.962827] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling
[45.965044] Starting dynamic subtest: pipe-A-default-mode
[46.253125] Dynamic subtest pipe-A-default-mode: SKIP (0.282s)
[46.258583] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.283s)
[47.112754] [005/129] (955s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[47.211379] Starting subtest: primary-x-tiled-reflect-x-0
[54.259702] Subtest primary-x-tiled-reflect-x-0: SUCCESS (7.053s)
[55.502335] [006/129] (946s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[55.562262] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[55.598309] [007/129] (946s left) drm_fdinfo (virtual-busy-hang-all)
[55.631270] Starting subtest: virtual-busy-hang-all
[55.635960] Subtest virtual-busy-hang-all: SKIP (0.000s)
[55.677914] [008/129] (946s left) syncobj_timeline (multi-wait-all-for-submit-signaled)
[55.724248] Starting subtest: multi-wait-all-for-submit-signaled
[55.726964] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[55.775301] [009/129] (946s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[55.946629] Starting subtest: cursor-rapid-movement-128x128
[55.949266] Starting dynamic subtest: pipe-A-eDP-1
[56.477865] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.530s)
[56.498102] Starting dynamic subtest: pipe-D-eDP-1
[57.735813] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.241s)
[57.738551] Subtest cursor-rapid-movement-128x128: SUCCESS (1.790s)
[58.599306] [010/129] (943s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt)
[58.703141] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt
[58.707505] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[58.772097] [011/129] (943s left) drm_fdinfo (all-busy-idle-check-all)
[58.802157] Starting subtest: all-busy-idle-check-all
[58.808119] Subtest all-busy-idle-check-all: SKIP (0.003s)
[58.846043] [012/129] (943s left) kms_atomic (plane-immutable-zpos)
[58.959708] Starting subtest: plane-immutable-zpos
[58.962063] Starting dynamic subtest: pipe-A-eDP-1
[59.572970] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.612s)
[59.575197] Subtest plane-immutable-zpos: SUCCESS (0.613s)
[60.449746] [013/129] (941s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[60.550740] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[60.555336] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[60.619641] [014/129] (941s left) gem_pwrite (basic-random)
[60.686481] Subtest basic-random: SKIP (0.000s)
[60.721911] [015/129] (941s left) kms_lease (lease-invalid-crtc)
[60.814015] Starting subtest: lease-invalid-crtc
[60.816435] Starting dynamic subtest: pipe-A-eDP-1
[60.819039] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[60.828983] Starting dynamic subtest: pipe-B-eDP-1
[60.834515] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[60.840436] Starting dynamic subtest: pipe-C-eDP-1
[60.843374] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[60.851193] Starting dynamic subtest: pipe-D-eDP-1
[60.853615] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[60.855896] Subtest lease-invalid-crtc: SUCCESS (0.003s)
[60.868265] [016/129] (941s left) gem_lmem_swapping (parallel-random-verify)
[60.898029] Subtest parallel-random-verify: SKIP (0.000s)
[60.918972] [017/129] (941s left) kms_color (degamma)
[61.002205] Starting subtest: degamma
[61.004793] Starting dynamic subtest: pipe-A-eDP-1
[61.677125] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.673s)
[61.685467] Starting dynamic subtest: pipe-B-eDP-1
[63.099791] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.424s)
[63.107035] Starting dynamic subtest: pipe-C-eDP-1
[64.525857] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.425s)
[64.532330] Starting dynamic subtest: pipe-D-eDP-1
[65.930526] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.405s)
[65.933333] Subtest degamma: SUCCESS (4.930s)
[66.829731] [018/129] (935s left) gem_eio (in-flight-contexts-1us)
[67.056070] Starting subtest: in-flight-contexts-1us
[75.379827] Subtest in-flight-contexts-1us: SUCCESS (8.326s)
[75.482449] [019/129] (926s left) gem_render_copy (yf-tiled-ccs-to-y-tiled-ccs)
[75.538421] Starting subtest: yf-tiled-ccs-to-y-tiled-ccs
[75.543284] Subtest yf-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[75.691913] [020/129] (926s left) gem_pread (uncached)
[75.737598] Subtest uncached: SKIP (0.000s)
[75.781273] [021/129] (926s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[75.876697] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[80.142213] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (4.269s)
[80.238987] [022/129] (922s left) gem_exec_fence (syncobj-channel)
[80.663272] Starting subtest: syncobj-channel
[81.674086] Subtest syncobj-channel: SUCCESS (1.010s)
[81.939671] [023/129] (920s left) kms_psr (psr2-basic)
[82.019815] Starting subtest: psr2-basic
[82.022172] Starting dynamic subtest: eDP-1
[83.696977] Dynamic subtest eDP-1: SUCCESS (1.673s)
[83.699131] Subtest psr2-basic: SUCCESS (1.673s)
[84.556270] [024/129] (917s left) syncobj_wait (invalid-wait-zero-handles)
[84.605488] Starting subtest: invalid-wait-zero-handles
[84.660902] Subtest invalid-wait-zero-handles: FAIL (0.009s)
[84.675943] [025/129] (917s left) kms_draw_crc (draw-method-render)
[84.757440] Starting subtest: draw-method-render
[84.760038] Starting dynamic subtest: xrgb8888-untiled
[84.963519] Dynamic subtest xrgb8888-untiled: SUCCESS (0.210s)
[84.970752] Starting dynamic subtest: rgb565-untiled
[85.152327] Dynamic subtest rgb565-untiled: SUCCESS (0.189s)
[85.159635] Starting dynamic subtest: xrgb2101010-untiled
[85.329502] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.178s)
[85.335721] Starting dynamic subtest: xrgb8888-xtiled
[85.429708] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.100s)
[85.435808] Starting dynamic subtest: rgb565-xtiled
[85.529444] Dynamic subtest rgb565-xtiled: SUCCESS (0.100s)
[85.536697] Starting dynamic subtest: xrgb2101010-xtiled
[85.619086] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.089s)
[85.624559] Starting dynamic subtest: xrgb8888-4tiled
[85.718802] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.100s)
[85.727476] Starting dynamic subtest: rgb565-4tiled
[85.818320] Dynamic subtest rgb565-4tiled: SUCCESS (0.100s)
[85.825235] Starting dynamic subtest: xrgb2101010-4tiled
[85.907552] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.089s)
[85.909757] Subtest draw-method-render: SUCCESS (1.155s)
[86.010942] [026/129] (916s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[86.102179] Starting subtest: 4-tiled-8bpp-rotate-180
[87.067938] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (0.967s)
[87.145338] [027/129] (915s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[87.230819] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[87.233419] Starting dynamic subtest: pipe-A-eDP-1
[87.257101] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[87.264932] Starting dynamic subtest: pipe-B-eDP-1
[87.288375] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[87.296740] Starting dynamic subtest: pipe-C-eDP-1
[87.318185] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[87.325481] Starting dynamic subtest: pipe-D-eDP-1
[87.347946] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[87.352293] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[87.367788] [028/129] (915s left) gem_ctx_shared (exec-shared-gtt)
[87.424293] Starting subtest: exec-shared-gtt
[87.426475] Starting dynamic subtest: rcs0
[87.433332] Dynamic subtest rcs0: SUCCESS (0.010s)
[87.439696] Starting dynamic subtest: bcs0
[87.441472] Dynamic subtest bcs0: SUCCESS (0.005s)
[87.446818] Starting dynamic subtest: vcs0
[87.448724] Dynamic subtest vcs0: SUCCESS (0.004s)
[87.454234] Starting dynamic subtest: vcs1
[87.455778] Dynamic subtest vcs1: SUCCESS (0.005s)
[87.461372] Starting dynamic subtest: vecs0
[87.463184] Dynamic subtest vecs0: SUCCESS (0.005s)
[87.468711] Starting dynamic subtest: ccs0
[87.470588] Dynamic subtest ccs0: SUCCESS (0.004s)
[87.472389] Subtest exec-shared-gtt: SUCCESS (0.033s)
[87.614717] [029/129] (914s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu)
[87.705435] Starting subtest: fbc-rgb565-draw-mmap-cpu
[90.469785] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (2.767s)
[90.571833] [030/129] (911s left) kms_frontbuffer_tracking (fbc-suspend)
[90.663495] Starting subtest: fbc-suspend
[127.147661] Subtest fbc-suspend: SUCCESS (6.993s)
[127.226936] [031/129] (904s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf)
[132.617686] Starting subtest: pr-overlay-plane-move-continuous-exceed-sf
[132.623139] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.002s)
[133.510094] [032/129] (898s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation)
[133.595348] Starting subtest: plane-downscale-factor-0-5-with-rotation
[133.597975] Starting dynamic subtest: pipe-A
[133.608144] Dynamic subtest pipe-A: SKIP (0.004s)
[133.616805] Starting dynamic subtest: pipe-B
[133.626589] Dynamic subtest pipe-B: SKIP (0.013s)
[133.633316] Starting dynamic subtest: pipe-C
[133.642785] Dynamic subtest pipe-C: SKIP (0.013s)
[133.649362] Starting dynamic subtest: pipe-D
[133.658327] Dynamic subtest pipe-D: SKIP (0.013s)
[133.662717] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (0.044s)
[133.703575] [033/129] (898s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[133.788791] Starting subtest: y-tiled-32bpp-rotate-180
[133.792779] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s)
[133.872451] [034/129] (898s left) gem_close (basic)
[133.914959] Starting subtest: basic
[133.916770] Subtest basic: SUCCESS (0.000s)
[133.984944] [035/129] (898s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[134.032085] Starting subtest: invalid-bsd2-flag-on-blt
[134.034253] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[134.110736] [036/129] (897s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[134.194260] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[134.196858] Starting dynamic subtest: pipe-A-eDP-1
[134.826142] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.623s)
[134.834260] Starting dynamic subtest: pipe-B-eDP-1
[136.586546] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.761s)
[136.594994] Starting dynamic subtest: pipe-C-eDP-1
[138.295354] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.707s)
[138.304099] Starting dynamic subtest: pipe-D-eDP-1
[140.022623] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.728s)
[140.025010] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.822s)
[141.255598] [037/129] (890s left) gem_userptr_blits (readonly-unsync)
[141.309811] Subtest readonly-unsync: SKIP (0.000s)
[141.421265] [038/129] (890s left) gem_exec_params (no-bsd)
[141.467900] Starting subtest: no-bsd
[141.470254] Subtest no-bsd: SUCCESS (0.002s)
[142.913824] [039/129] (889s left) gem_ctx_engines (none)
[142.960058] Starting subtest: none
[142.962387] Subtest none: SUCCESS (0.001s)
[143.116748] [040/129] (888s left) kms_flip (flip-vs-dpms-off-vs-modeset)
[143.210083] Starting subtest: flip-vs-dpms-off-vs-modeset
[143.212407] Starting dynamic subtest: A-eDP1
[147.015567] Dynamic subtest A-eDP1: SUCCESS (3.803s)
[147.024816] Starting dynamic subtest: B-eDP1
[150.408535] Dynamic subtest B-eDP1: SUCCESS (3.394s)
[150.418429] Starting dynamic subtest: C-eDP1
[153.797988] Dynamic subtest C-eDP1: SUCCESS (3.391s)
[153.806029] Starting dynamic subtest: D-eDP1
[157.192081] Dynamic subtest D-eDP1: SUCCESS (3.393s)
[157.194775] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (13.987s)
[158.087284] [041/129] (874s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[158.184775] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[162.579452] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (4.397s)
[162.680020] [042/129] (869s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[162.775692] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[162.780491] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[162.843635] [043/129] (869s left) gem_userptr_blits (relocations)
[162.902088] Starting subtest: relocations
[162.906613] Subtest relocations: SKIP (0.000s)
[163.005442] [044/129] (869s left) gen7_exec_parse (basic-offset)
[163.056404] Subtest basic-offset: SKIP (0.000s)
[163.091414] [045/129] (869s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[163.180362] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[163.182828] Starting dynamic subtest: pipe-A-default-mode
[163.508280] Dynamic subtest pipe-A-default-mode: SKIP (0.325s)
[163.512592] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.326s)
[164.326884] [046/129] (867s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-pwrite)
[164.426132] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-pwrite
[168.749205] Subtest fbcpsr-1p-offscren-pri-indfb-draw-pwrite: SUCCESS (4.326s)
[168.858468] [047/129] (863s left) i915_hangman (detector)
[168.902177] Starting subtest: detector
[168.904184] Starting dynamic subtest: rcs0
[180.865255] Dynamic subtest rcs0: SUCCESS (11.964s)
[180.875032] Starting dynamic subtest: bcs0
[192.832753] Dynamic subtest bcs0: SUCCESS (11.969s)
[192.842118] Starting dynamic subtest: vcs0
[204.802227] Dynamic subtest vcs0: SUCCESS (11.970s)
[204.810708] Starting dynamic subtest: vcs1
[216.770936] Dynamic subtest vcs1: SUCCESS (11.970s)
[216.780376] Starting dynamic subtest: vecs0
[226.818144] Dynamic subtest vecs0: SUCCESS (10.043s)
[226.828636] Starting dynamic subtest: ccs0
[238.850231] Dynamic subtest ccs0: SUCCESS (12.028s)
[238.852914] Subtest detector: SUCCESS (69.952s)
[238.906365] [048/129] (793s left) gem_softpin (overlap)
[238.962542] Starting subtest: overlap
[239.694793] Subtest overlap: SUCCESS (0.731s)
[239.796698] [049/129] (792s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[239.880002] Starting subtest: random-ccs-data-yf-tiled-ccs
[239.882352] Starting dynamic subtest: pipe-A-eDP-1
[239.907101] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[239.915431] Starting dynamic subtest: pipe-B-eDP-1
[239.940215] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[239.947334] Starting dynamic subtest: pipe-C-eDP-1
[239.971501] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[239.978509] Starting dynamic subtest: pipe-D-eDP-1
[240.002904] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[240.007370] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.003s)
[240.021682] [050/129] (792s left) sriov_basic (enable-vfs-autoprobe-on)
[240.070459] Subtest enable-vfs-autoprobe-on: SKIP (0.000s)
[240.103370] [051/129] (792s left) gem_ppgtt (flink-and-close-vma-leak)
[240.149231] Starting subtest: flink-and-close-vma-leak
[240.190590] Subtest flink-and-close-vma-leak: SUCCESS (0.041s)
[240.299847] [052/129] (791s left) kms_big_fb (yf-tiled-16bpp-rotate-180)
[240.395516] Starting subtest: yf-tiled-16bpp-rotate-180
[240.399816] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s)
[240.471444] [053/129] (791s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[240.579942] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[240.584616] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[240.643690] [054/129] (791s left) kms_psr (pr-cursor-plane-move)
[240.718665] Starting subtest: pr-cursor-plane-move
[240.722469] Subtest pr-cursor-plane-move: SKIP (0.000s)
[240.768437] [055/129] (791s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[240.862894] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[240.866359] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[240.928599] [056/129] (791s left) kms_vblank (query-idle)
[241.005675] Starting subtest: query-idle
[241.007699] Starting dynamic subtest: pipe-A-eDP-1
[242.739512] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.730s)
[242.754684] Starting dynamic subtest: pipe-D-eDP-1
[245.282362] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.540s)
[245.284902] Subtest query-idle: SUCCESS (4.274s)
[246.149223] [057/129] (786s left) gem_mmap_offset (mmap-unmap)
[246.182211] Starting subtest: mmap-unmap
[246.184560] Starting dynamic subtest: smem0
[259.761727] Dynamic subtest smem0: SUCCESS (13.525s)
[259.764905] Subtest mmap-unmap: SUCCESS (13.526s)
[259.807175] [058/129] (772s left) kms_getfb (getfb2-handle-zero)
[259.852211] Starting subtest: getfb2-handle-zero
[259.854552] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[259.918132] [059/129] (772s left) syncobj_wait (single-wait-all-signaled)
[259.970847] Starting subtest: single-wait-all-signaled
[259.972943] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[260.034346] [060/129] (772s left) syncobj_wait (wait-any-interrupted)
[260.082322] Starting subtest: wait-any-interrupted
[260.182204] Subtest wait-any-interrupted: SUCCESS (0.101s)
[260.235424] [061/129] (772s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted)
[260.287496] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted
[260.391244] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.104s)
[260.442838] [062/129] (771s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear)
[260.538860] Starting subtest: fbcpsr-tiling-linear
[264.892050] Subtest fbcpsr-tiling-linear: SUCCESS (4.357s)
[265.018967] [063/129] (767s left) template (b)
[265.067290] Starting subtest: B
[265.069496] Subtest B: SUCCESS (0.000s)
[265.130513] [064/129] (767s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[265.229505] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[265.233617] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[265.305969] [065/129] (767s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-gtt)
[265.401505] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-gtt
[265.405524] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[265.488568] [066/129] (766s left) kms_psr (fbc-pr-dpms)
[265.573024] Starting subtest: fbc-pr-dpms
[265.577511] Subtest fbc-pr-dpms: SKIP (0.000s)
[265.622039] [067/129] (766s left) gem_exec_schedule (noreorder)
[265.783072] Starting subtest: noreorder
[265.785511] Starting dynamic subtest: rcs0
[265.819796] Dynamic subtest rcs0: SUCCESS (0.037s)
[265.826508] Starting dynamic subtest: vcs0
[267.857237] Dynamic subtest vcs0: SUCCESS (2.035s)
[267.866950] Starting dynamic subtest: vcs1
[269.867355] Dynamic subtest vcs1: SUCCESS (2.009s)
[269.877387] Starting dynamic subtest: vecs0
[271.827789] Dynamic subtest vecs0: SUCCESS (1.959s)
[271.836795] Starting dynamic subtest: ccs0
[271.917270] Dynamic subtest ccs0: SUCCESS (0.090s)
[271.920169] Subtest noreorder: SUCCESS (6.135s)
[272.083796] [068/129] (760s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[272.137950] Starting subtest: multi-wait-available-unsubmitted-submitted
[272.140469] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[272.204354] [069/129] (760s left) gem_softpin (allocator-basic-reserve)
[272.258795] Starting subtest: allocator-basic-reserve
[272.312946] Subtest allocator-basic-reserve: SUCCESS (0.054s)
[272.401500] [070/129] (760s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible)
[272.493211] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible
[272.508366] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SKIP (0.013s)
[272.558767] [071/129] (759s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[272.648206] Starting subtest: psr-1p-primscrn-spr-indfb-move
[277.824038] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (5.179s)
[277.934613] [072/129] (754s left) i915_pm_sseu (full-enable)
[277.986469] Subtest full-enable: SKIP (0.000s)
[278.054412] [073/129] (754s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[278.147993] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt
[278.152284] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[278.211721] [074/129] (754s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-cpu)
[278.300095] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-cpu
[280.923224] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-cpu: SUCCESS (2.628s)
[281.015827] [075/129] (751s left) kms_flip (flip-vs-expired-vblank)
[281.113061] Starting subtest: flip-vs-expired-vblank
[281.115337] Starting dynamic subtest: A-eDP1
[289.915990] Dynamic subtest A-eDP1: SUCCESS (8.766s)
[289.926074] Starting dynamic subtest: B-eDP1
[298.684993] Dynamic subtest B-eDP1: SUCCESS (8.772s)
[298.694530] Starting dynamic subtest: C-eDP1
[307.404905] Dynamic subtest C-eDP1: SUCCESS (8.753s)
[307.413290] Starting dynamic subtest: D-eDP1
[316.173546] Dynamic subtest D-eDP1: SUCCESS (8.769s)
[316.178817] Subtest flip-vs-expired-vblank: SUCCESS (35.070s)
[317.382236] [076/129] (715s left) kms_pm_rpm (dpms-non-lpsp)
[318.990783] Starting subtest: dpms-non-lpsp
[318.997002] Subtest dpms-non-lpsp: SKIP (0.001s)
[319.326794] [077/129] (713s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[319.416194] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[320.402376] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (0.988s)
[320.510864] [078/129] (712s left) kms_flip (flip-vs-wf_vblank-interruptible)
[320.591645] Starting subtest: flip-vs-wf_vblank-interruptible
[320.593597] Starting dynamic subtest: A-eDP1
[322.542834] Dynamic subtest A-eDP1: SUCCESS (1.950s)
[322.552300] Starting dynamic subtest: B-eDP1
[324.520663] Dynamic subtest B-eDP1: SUCCESS (1.977s)
[324.528227] Starting dynamic subtest: C-eDP1
[326.494446] Dynamic subtest C-eDP1: SUCCESS (1.972s)
[326.503600] Starting dynamic subtest: D-eDP1
[328.479839] Dynamic subtest D-eDP1: SUCCESS (1.985s)
[328.485266] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.894s)
[329.733943] [079/129] (702s left) gem_exec_whisper (basic-sync-all)
[329.788291] Starting subtest: basic-sync-all
[336.510961] Subtest basic-sync-all: SUCCESS (6.722s)
[336.667928] [080/129] (696s left) gem_exec_schedule (timeslicing)
[336.729799] Starting subtest: timeslicing
[336.731821] Starting dynamic subtest: rcs0
[336.738882] Dynamic subtest rcs0: SUCCESS (0.022s)
[336.748456] Starting dynamic subtest: bcs0
[336.758614] Dynamic subtest bcs0: SUCCESS (0.020s)
[336.765865] Starting dynamic subtest: vcs0
[336.780130] Dynamic subtest vcs0: SUCCESS (0.021s)
[336.787216] Starting dynamic subtest: vcs1
[336.800421] Dynamic subtest vcs1: SUCCESS (0.020s)
[336.807147] Starting dynamic subtest: vecs0
[336.823764] Dynamic subtest vecs0: SUCCESS (0.023s)
[336.830454] Starting dynamic subtest: ccs0
[336.846834] Dynamic subtest ccs0: SUCCESS (0.023s)
[336.849218] Subtest timeslicing: SUCCESS (0.131s)
[337.908780] [081/129] (694s left) api_intel_allocator (fork-simple-stress-signal)
[337.953174] Starting subtest: fork-simple-stress-signal
[343.395470] Subtest fork-simple-stress-signal: SUCCESS (5.391s)
[343.442528] [082/129] (689s left) kms_prop_blob (blob-prop-core)
[343.488579] Starting subtest: blob-prop-core
[343.490956] Subtest blob-prop-core: SUCCESS (0.000s)
[343.580260] [083/129] (689s left) kms_atomic_interruptible (universal-setplane-primary)
[343.672950] Starting subtest: universal-setplane-primary
[343.675235] Starting dynamic subtest: pipe-A-eDP-1
[351.145321] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.471s)
[351.147853] Subtest universal-setplane-primary: SUCCESS (7.472s)
[352.006820] [084/129] (680s left) i915_pm_freq_api (freq-reset)
[352.069034] Starting subtest: freq-reset
[352.072172] Starting dynamic subtest: gt0
[352.256110] Dynamic subtest gt0: SUCCESS (0.184s)
[352.267992] Starting dynamic subtest: gt1
[352.429543] Dynamic subtest gt1: SUCCESS (0.174s)
[352.432482] Subtest freq-reset: SUCCESS (0.360s)
[352.479146] [085/129] (680s left) gem_ctx_param (invalid-size-get)
[352.518364] Starting subtest: invalid-size-get
[352.521197] Subtest invalid-size-get: SUCCESS (0.001s)
[352.606376] [086/129] (680s left) gem_busy (semaphore)
[352.785819] Subtest semaphore: SKIP (0.000s)
[352.992131] [087/129] (679s left) perf_pmu (render-node-busy-idle)
[353.044443] Starting subtest: render-node-busy-idle
[353.046738] Starting dynamic subtest: rcs0
[353.731033] Dynamic subtest rcs0: SUCCESS (0.685s)
[353.742051] Starting dynamic subtest: bcs0
[354.432738] Dynamic subtest bcs0: FAIL (0.634s)
[354.441334] Starting dynamic subtest: vcs0
[355.874517] Dynamic subtest vcs0: SUCCESS (1.507s)
[355.884489] Starting dynamic subtest: vcs1
[357.859206] Dynamic subtest vcs1: SUCCESS (1.982s)
[357.869536] Starting dynamic subtest: vecs0
[359.906520] Dynamic subtest vecs0: SUCCESS (2.046s)
[359.915643] Starting dynamic subtest: ccs0
[360.625509] Dynamic subtest ccs0: FAIL (0.647s)
[360.628071] Subtest render-node-busy-idle: FAIL (7.506s)
[360.644925] [088/129] (672s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions)
[360.794005] Starting subtest: short-busy-flip-before-cursor-atomic-transitions
[360.798701] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s)
[360.869888] [089/129] (671s left) kms_chamelium_frames (dp-crc-multiple)
[361.235637] Subtest dp-crc-multiple: SKIP (0.000s)
[362.099056] [090/129] (670s left) kms_addfb_basic (basic-x-tiled-legacy)
[362.147528] Starting subtest: basic-x-tiled-legacy
[362.151580] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[362.257016] [091/129] (670s left) gem_partial_pwrite_pread (write-display)
[362.310451] Subtest write-display: SKIP (0.000s)
[362.400357] [092/129] (670s left) kms_cursor_edge_walk (128x128-left-edge)
[362.489031] Starting subtest: 128x128-left-edge
[362.491417] Starting dynamic subtest: pipe-A-eDP-1
[366.001782] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.509s)
[366.012185] Starting dynamic subtest: pipe-D-eDP-1
[369.258546] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.254s)
[369.260874] Subtest 128x128-left-edge: SUCCESS (6.766s)
[370.117401] [093/129] (662s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[370.218883] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[370.223353] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[370.304493] [094/129] (662s left) gem_exec_alignment (pi-isolated)
[370.358235] Starting subtest: pi-isolated
[490.686675] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[524.534997] Closing watchdogs
[524.537212] Initializing watchdogs
[524.537233]   /dev/watchdog0
[524.546926] [095/129] (508s left) kms_psr (psr-sprite-mmap-gtt)
[524.686402] Starting subtest: psr-sprite-mmap-gtt
[524.689103] Starting dynamic subtest: eDP-1
[526.252894] Dynamic subtest eDP-1: SKIP (1.562s)
[526.257428] Subtest psr-sprite-mmap-gtt: SKIP (1.562s)
[526.393471] [096/129] (506s left) kms_properties (get_properties-sanity-atomic)
[526.497472] Starting subtest: get_properties-sanity-atomic
[526.503911] Subtest get_properties-sanity-atomic: SUCCESS (0.005s)
[526.553748] [097/129] (506s left) kms_chamelium_hpd (dp-hpd-storm)
[526.936909] Subtest dp-hpd-storm: SKIP (0.000s)
[527.792632] [098/129] (505s left) gem_exec_big (single)
[527.842768] Starting subtest: single
[529.602675] Subtest single: SUCCESS (1.759s)
[529.810162] [099/129] (503s left) perf (i915-ref-count)
[529.970851] Starting subtest: i915-ref-count
[530.039551] Subtest i915-ref-count: SUCCESS (0.066s)
[530.069936] [100/129] (502s left) gem_exec_params (rs-invalid)
[530.119997] Starting subtest: rs-invalid
[530.124930] Subtest rs-invalid: SUCCESS (0.003s)
[530.215255] [101/129] (502s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[535.342417] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[535.347382] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.002s)
[536.263113] [102/129] (496s left) gem_exec_schedule (u-semaphore-noskip)
[536.355554] Starting subtest: u-semaphore-noskip
[536.743541] Subtest u-semaphore-noskip: SUCCESS (0.397s)
[537.077654] [103/129] (496s left) perf_pmu (busy-check-all)
[537.113892] Starting subtest: busy-check-all
[537.116014] Starting dynamic subtest: rcs0
[537.674480] Dynamic subtest rcs0: SUCCESS (0.562s)
[537.684495] Starting dynamic subtest: bcs0
[538.223104] Dynamic subtest bcs0: SUCCESS (0.548s)
[538.232791] Starting dynamic subtest: vcs0
[539.875044] Dynamic subtest vcs0: SUCCESS (1.650s)
[539.884863] Starting dynamic subtest: vcs1
[541.859441] Dynamic subtest vcs1: SUCCESS (1.983s)
[541.869687] Starting dynamic subtest: vecs0
[543.843664] Dynamic subtest vecs0: SUCCESS (1.983s)
[543.852186] Starting dynamic subtest: ccs0
[544.396909] Dynamic subtest ccs0: SUCCESS (0.554s)
[544.399922] Subtest busy-check-all: SUCCESS (7.285s)
[544.474346] [104/129] (488s left) kms_pipe_crc_basic (suspend-read-crc)
[544.564994] Starting subtest: suspend-read-crc
[544.567219] Starting dynamic subtest: pipe-A-eDP-1
[561.844476] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.360s)
[561.854613] Starting dynamic subtest: pipe-B-eDP-1
[579.705459] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.952s)
[579.715174] Starting dynamic subtest: pipe-C-eDP-1
[597.654103] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.838s)
[597.664183] Starting dynamic subtest: pipe-D-eDP-1
[615.657891] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.806s)
[615.660836] Subtest suspend-read-crc: SUCCESS (10.960s)
[616.553633] [105/129] (476s left) gem_ctx_isolation (nonpriv-switch)
[616.605182] Starting subtest: nonpriv-switch
[616.607351] Starting dynamic subtest: rcs0
[616.820727] Dynamic subtest rcs0: SUCCESS (0.215s)
[616.828760] Starting dynamic subtest: bcs0
[617.070266] Dynamic subtest bcs0: SUCCESS (0.249s)
[617.080965] Starting dynamic subtest: vcs0
[617.302629] Dynamic subtest vcs0: SUCCESS (0.232s)
[617.312506] Starting dynamic subtest: vcs1
[619.233107] Dynamic subtest vcs1: SUCCESS (1.930s)
[619.242089] Starting dynamic subtest: vecs0
[621.196869] Dynamic subtest vecs0: SUCCESS (1.964s)
[621.204495] Starting dynamic subtest: ccs0
[623.184679] Dynamic subtest ccs0: SUCCESS (1.988s)
[623.187036] Subtest nonpriv-switch: SUCCESS (6.580s)
[623.403975] [106/129] (469s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[623.499894] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[628.212559] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (4.716s)
[628.292089] [107/129] (465s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[628.379065] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[628.383345] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[628.452036] [108/129] (464s left) kms_plane (plane-panning-bottom-right)
[628.526983] Starting subtest: plane-panning-bottom-right
[628.529281] Starting dynamic subtest: pipe-A
[630.206979] Dynamic subtest pipe-A: SUCCESS (1.676s)
[630.214964] Starting dynamic subtest: pipe-B
[632.673404] Dynamic subtest pipe-B: SUCCESS (2.468s)
[632.675686] Subtest plane-panning-bottom-right: SUCCESS (4.146s)
[633.578022] [109/129] (459s left) syncobj_timeline (single-wait-all-available-signaled)
[633.630951] Starting subtest: single-wait-all-available-signaled
[633.633146] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[633.704979] [110/129] (459s left) kms_flip (flip-vs-absolute-wf_vblank)
[633.804098] Starting subtest: flip-vs-absolute-wf_vblank
[633.806348] Starting dynamic subtest: A-eDP1
[642.789936] Dynamic subtest A-eDP1: SUCCESS (8.986s)
[642.798276] Starting dynamic subtest: B-eDP1
[647.066229] Abort requested by /sbin/init [1] via Terminated, terminating children
[647.066386] 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 [1342] via Terminated, terminating children
[647.067059] Abort requested by /sbin/init [1] via Hangup, terminating children
[647.067115] Exiting gracefully, currently running test will have a 'notrun' result
[648.273206] Closing watchdogs
Done.