[35.358074] Initializing watchdogs
[35.358139]   /dev/watchdog0
[35.364800] [001/130] (960s left) gem_exec_flush (basic-wb-set-default)
[35.462072] Starting subtest: basic-wb-set-default
[40.892329] Subtest basic-wb-set-default: SUCCESS (5.426s)
[41.048851] [002/130] (954s left) gem_exec_reloc (basic-gtt-noreloc)
[41.104455] Subtest basic-gtt-noreloc: SKIP (0.000s)
[41.157482] [003/130] (954s left) gem_ctx_exec (basic)
[41.207685] Starting subtest: basic
[41.214843] Subtest basic: SUCCESS (0.008s)
[41.317307] [004/130] (954s left) drm_fdinfo (memory-info-purgeable)
[41.345264] Starting subtest: memory-info-purgeable
[41.347635] Starting dynamic subtest: smem0
[44.175923] Dynamic subtest smem0: SUCCESS (2.832s)
[44.178314] Subtest memory-info-purgeable: SUCCESS (2.832s)
[44.223199] [005/130] (951s left) gen9_exec_parse (allowed-single)
[44.266934] Subtest allowed-single: SKIP (0.000s)
[44.310235] [006/130] (951s left) gem_exec_reloc (basic-range-active)
[44.361983] Subtest basic-range-active: SKIP (0.000s)
[44.420673] [007/130] (951s left) kms_cursor_crc (cursor-rapid-movement-128x128)
[44.589539] Starting subtest: cursor-rapid-movement-128x128
[44.600476] Starting dynamic subtest: pipe-A-eDP-1
[45.146267] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.543s)
[45.164678] Starting dynamic subtest: pipe-D-eDP-1
[46.408145] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.245s)
[46.410785] Subtest cursor-rapid-movement-128x128: SUCCESS (1.815s)
[47.274819] [008/130] (948s left) gem_ctx_create (basic-files)
[47.340212] Starting subtest: basic-files
[49.345703] Subtest basic-files: SUCCESS (1.958s)
[49.711011] [009/130] (946s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[49.810128] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[49.814289] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[49.872068] [010/130] (946s left) dmabuf_sync_file (export-before-signal)
[49.961969] Starting subtest: export-before-signal
[49.964493] Subtest export-before-signal: SUCCESS (0.000s)
[49.991956] [011/130] (946s left) gem_wait (invalid-flags)
[50.044486] Starting subtest: invalid-flags
[50.047459] Subtest invalid-flags: SUCCESS (0.000s)
[50.251671] [012/130] (945s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[50.302063] Starting subtest: multi-wait-available-unsubmitted-signaled
[50.304587] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.000s)
[50.372110] [013/130] (945s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[50.430622] Starting subtest: map-fixed-invalidate-overlap-busy
[50.435094] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s)
[50.534244] [014/130] (945s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[50.580315] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[50.582624] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[50.634960] [015/130] (945s left) kms_cursor_crc (cursor-onscreen-256x85)
[50.832684] Starting subtest: cursor-onscreen-256x85
[50.866873] Subtest cursor-onscreen-256x85: SKIP (0.030s)
[51.009612] [016/130] (945s left) kms_psr (fbc-psr2-no-drrs)
[51.090942] Starting subtest: fbc-psr2-no-drrs
[51.093386] Starting dynamic subtest: eDP-1
[51.097715] Dynamic subtest eDP-1: SKIP (0.000s)
[51.102020] Subtest fbc-psr2-no-drrs: SKIP (0.000s)
[51.141667] [017/130] (945s left) gem_create (create-invalid-size)
[51.180712] Starting subtest: create-invalid-size
[51.182606] Subtest create-invalid-size: SUCCESS (0.000s)
[51.344289] [018/130] (944s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled)
[51.398642] Starting subtest: multi-wait-for-submit-submitted-signaled
[51.401263] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s)
[51.461250] [019/130] (944s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[51.559034] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[51.563344] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[51.649546] [020/130] (944s left) gem_mmap (short-mmap)
[51.696279] Subtest short-mmap: SKIP (0.000s)
[51.732070] [021/130] (944s left) kms_pm_dc (dc6-dpms)
[51.816341] Starting subtest: dc6-dpms
[51.821184] Subtest dc6-dpms: SKIP (0.000s)
[51.865362] [022/130] (944s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[51.955092] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[52.520301] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.558s)
[52.667780] [023/130] (943s left) kms_pm_rpm (pc8-residency)
[54.501236] Starting subtest: pc8-residency
[54.507232] Subtest pc8-residency: SKIP (0.000s)
[54.834635] [024/130] (941s left) kms_psr (psr-basic)
[54.925813] Starting subtest: psr-basic
[54.928096] Starting dynamic subtest: eDP-1
[56.579590] Dynamic subtest eDP-1: SUCCESS (1.637s)
[56.581495] Subtest psr-basic: SUCCESS (1.637s)
[57.482908] [025/130] (938s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[57.577494] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[57.581750] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[57.647082] [026/130] (938s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[57.699154] Starting subtest: etime-multi-wait-all-for-submit-submitted
[57.804113] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.103s)
[57.856416] [027/130] (938s left) kms_big_fb (linear-32bpp-rotate-180)
[57.944033] Starting subtest: linear-32bpp-rotate-180
[59.308737] Subtest linear-32bpp-rotate-180: SUCCESS (1.357s)
[59.430530] [028/130] (936s left) gem_exec_schedule (fairslice-all)
[59.486051] Starting subtest: fairslice-all
[61.532618] Subtest fairslice-all: SUCCESS (2.039s)
[63.399586] [029/130] (933s left) perf_pmu (multi-client)
[63.426940] Starting subtest: multi-client
[63.429730] Starting dynamic subtest: rcs0
[64.494845] Dynamic subtest rcs0: SUCCESS (1.064s)
[64.504831] Starting dynamic subtest: bcs0
[65.546530] Dynamic subtest bcs0: SUCCESS (1.049s)
[65.556297] Starting dynamic subtest: vcs0
[66.599187] Dynamic subtest vcs0: SUCCESS (1.050s)
[66.608449] Starting dynamic subtest: vcs1
[68.383770] Dynamic subtest vcs1: SUCCESS (1.781s)
[68.392415] Starting dynamic subtest: vecs0
[70.365540] Dynamic subtest vecs0: SUCCESS (1.978s)
[70.374488] Starting dynamic subtest: ccs0
[72.416265] Dynamic subtest ccs0: SUCCESS (2.047s)
[72.419116] Subtest multi-client: SUCCESS (8.972s)
[72.508718] [030/130] (923s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[72.591533] Starting subtest: fbc-rgb101010-draw-pwrite
[76.734471] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (4.143s)
[76.822857] [031/130] (919s left) kms_selftest (drm_plane_helper)
[76.872114] Starting subtest: drm_plane_helper
[76.879292] Starting dynamic subtest: drm_test_check_plane_state
[76.942763] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.062s)
[76.950491] Starting dynamic subtest: drm_test_check_invalid_plane_state
[77.056487] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.114s)
[77.058846] Subtest drm_plane_helper: SUCCESS (0.183s)
[77.177804] [032/130] (919s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[77.660388] Starting subtest: syncobj-timeline-invalid-wait
[77.663358] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.003s)
[79.445078] [033/130] (917s left) api_intel_bb (add-remove-objects)
[79.486861] Starting subtest: add-remove-objects
[79.494266] Subtest add-remove-objects: SUCCESS (0.009s)
[79.593756] [034/130] (916s left) kms_flip (2x-modeset-vs-vblank-race-interruptible)
[79.681166] Starting subtest: 2x-modeset-vs-vblank-race-interruptible
[79.696568] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.014s)
[79.744880] [035/130] (916s left) gem_exec_reloc (basic-wc-cpu-active)
[79.797034] Subtest basic-wc-cpu-active: SKIP (0.000s)
[79.834571] [036/130] (916s left) syncobj_wait (wait-all-delayed-signal)
[79.884061] Starting subtest: wait-all-delayed-signal
[79.984047] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[80.035069] [037/130] (916s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[80.122705] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[80.124955] Starting dynamic subtest: pipe-A-eDP-1
[80.147662] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[80.155078] Starting dynamic subtest: pipe-B-eDP-1
[80.175668] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[80.181800] Starting dynamic subtest: pipe-C-eDP-1
[80.203072] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[80.208985] Starting dynamic subtest: pipe-D-eDP-1
[80.231047] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[80.235498] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.003s)
[82.443670] [038/130] (914s left) gem_spin_batch (spin-all-new)
[82.499423] Starting subtest: spin-all-new
[82.510076] Subtest spin-all-new: SUCCESS (0.011s)
[84.406811] [039/130] (912s left) gem_mmap_offset (pf-nonblock)
[84.455067] Starting subtest: pf-nonblock
[84.461807] Subtest pf-nonblock: SUCCESS (0.006s)
[84.549653] [040/130] (912s left) i915_pm_rps (thresholds)
[84.594550] Starting subtest: thresholds
[84.599465] Subtest thresholds: SKIP (0.000s)
[84.646601] [041/130] (911s left) kms_chamelium_frames (hdmi-crc-single)
[85.027579] Subtest hdmi-crc-single: SKIP (0.000s)
[85.882118] [042/130] (910s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff)
[85.971654] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff
[88.919351] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (2.950s)
[89.042429] [043/130] (907s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary)
[89.126262] Starting subtest: psr-indfb-scaledprimary
[92.877728] Subtest psr-indfb-scaledprimary: SUCCESS (3.753s)
[92.976937] [044/130] (903s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[93.080653] Starting subtest: 4-tiled-8bpp-rotate-0
[94.102125] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.023s)
[94.188622] [045/130] (902s left) perf (oa-exponents)
[94.310073] Starting subtest: oa-exponents
[94.312394] Starting dynamic subtest: 0-rcs0
[96.082930] Dynamic subtest 0-rcs0: SUCCESS (1.771s)
[96.090059] Starting dynamic subtest: 1-vcs0
[97.884047] Dynamic subtest 1-vcs0: SUCCESS (1.801s)
[97.886350] Subtest oa-exponents: SUCCESS (3.572s)
[97.905709] [046/130] (898s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[98.001483] Starting subtest: fbc-farfromfence-mmap-gtt
[98.006043] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[98.071257] [047/130] (898s left) gem_tiled_pread_pwrite
[98.155121] [048/130] (898s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow)
[98.250874] Starting subtest: yf-tiled-addfb-size-offset-overflow
[98.254988] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[98.315269] [049/130] (898s left) kms_async_flips (test-cursor)
[98.398558] Starting subtest: test-cursor
[98.403072] Subtest test-cursor: SKIP (0.000s)
[99.661839] [050/130] (897s left) prime_mmap (test_forked_cpu_write)
[99.723019] Starting subtest: test_forked_cpu_write
[99.725951] Starting dynamic subtest: test_forked_cpu_write-smem
[99.731950] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.008s)
[99.734638] Subtest test_forked_cpu_write: SUCCESS (0.008s)
[99.798765] [051/130] (896s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[99.893105] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[99.895428] Starting dynamic subtest: pipe-A-default-mode
[101.106082] Dynamic subtest pipe-A-default-mode: SKIP (1.205s)
[101.111341] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.206s)
[101.224119] [052/130] (895s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[101.319207] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[101.323576] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[101.384135] [053/130] (895s left) kms_cursor_edge_walk (128x128-left-edge)
[101.477782] Starting subtest: 128x128-left-edge
[101.480042] Starting dynamic subtest: pipe-A-eDP-1
[105.028979] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.548s)
[105.035569] Starting dynamic subtest: pipe-D-eDP-1
[108.259210] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.227s)
[108.261375] Subtest 128x128-left-edge: SUCCESS (6.777s)
[109.131509] [054/130] (887s left) gem_exec_whisper (basic-contexts-priority-all)
[109.182477] Starting subtest: basic-contexts-priority-all
[131.121845] Subtest basic-contexts-priority-all: SUCCESS (21.936s)
[131.280175] [055/130] (865s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[131.358900] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[131.361306] Starting dynamic subtest: pipe-A-eDP-1
[131.381654] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[131.389115] Starting dynamic subtest: pipe-B-eDP-1
[131.408321] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[131.416643] Starting dynamic subtest: pipe-C-eDP-1
[131.439401] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[131.449384] Starting dynamic subtest: pipe-D-eDP-1
[131.470888] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[131.472963] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.005s)
[133.709080] [056/130] (863s left) kms_writeback (writeback-fb-id)
[133.802248] Subtest writeback-fb-id: SKIP (0.000s)
[133.823157] [057/130] (863s left) gem_userptr_blits (map-fixed-invalidate-busy)
[133.887443] Starting subtest: map-fixed-invalidate-busy
[133.891991] Subtest map-fixed-invalidate-busy: SKIP (0.000s)
[133.985134] [058/130] (862s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[134.099971] Starting subtest: basic-flip-before-cursor-atomic
[135.013203] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.913s)
[135.882144] [059/130] (861s left) gem_ctx_param (invalid-get-no-zeromap)
[135.924574] Starting subtest: invalid-get-no-zeromap
[135.926985] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[135.984114] [060/130] (860s left) gem_mmap_wc (copy)
[136.034242] Subtest copy: SKIP (0.000s)
[136.067901] [061/130] (860s left) kms_plane (plane-panning-bottom-right-suspend)
[136.151781] Starting subtest: plane-panning-bottom-right-suspend
[136.154127] Starting dynamic subtest: pipe-A
[153.205448] Dynamic subtest pipe-A: SUCCESS (2.780s)
[153.220381] Starting dynamic subtest: pipe-B
[172.148648] Dynamic subtest pipe-B: SUCCESS (3.406s)
[172.151227] Subtest plane-panning-bottom-right-suspend: SUCCESS (6.189s)
[173.034208] [062/130] (853s left) kms_flip (2x-flip-vs-panning-interruptible)
[173.123719] Starting subtest: 2x-flip-vs-panning-interruptible
[173.141295] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.015s)
[173.192250] [063/130] (853s left) kms_psr (pr-primary-mmap-cpu)
[173.278544] Starting subtest: pr-primary-mmap-cpu
[173.282888] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[173.331834] [064/130] (853s left) kms_vblank (ts-continuation-modeset-rpm)
[173.422620] Starting subtest: ts-continuation-modeset-rpm
[173.424590] Starting dynamic subtest: pipe-A-eDP-1
[175.982220] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.505s)
[175.996565] Starting dynamic subtest: pipe-D-eDP-1
[178.283521] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.263s)
[178.286167] Subtest ts-continuation-modeset-rpm: SUCCESS (4.770s)
[179.176288] [065/130] (847s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[179.272626] Starting subtest: plane-primary-overlay-mutable-zpos
[182.919811] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.609s)
[184.166237] [066/130] (842s left) gem_spin_batch (resubmit)
[184.214620] Starting subtest: resubmit
[184.217043] Starting dynamic subtest: rcs0
[184.221996] Dynamic subtest rcs0: SUCCESS (0.006s)
[184.229814] Starting dynamic subtest: bcs0
[184.232134] Dynamic subtest bcs0: SUCCESS (0.001s)
[184.238887] Starting dynamic subtest: vcs0
[184.241163] Dynamic subtest vcs0: SUCCESS (0.002s)
[184.247736] Starting dynamic subtest: vcs1
[184.249972] Dynamic subtest vcs1: SUCCESS (0.002s)
[184.256695] Starting dynamic subtest: vecs0
[184.258936] Dynamic subtest vecs0: SUCCESS (0.004s)
[184.265621] Starting dynamic subtest: ccs0
[184.267902] Dynamic subtest ccs0: SUCCESS (0.005s)
[184.270191] Subtest resubmit: SUCCESS (0.020s)
[184.421714] [067/130] (842s left) kms_psr (fbc-pr-suspend)
[184.502355] Starting subtest: fbc-pr-suspend
[184.506732] Subtest fbc-pr-suspend: SKIP (0.000s)
[184.555741] [068/130] (842s left) perf_pmu (busy-double-start)
[184.584312] Starting subtest: busy-double-start
[184.586621] Starting dynamic subtest: rcs0
[188.222559] Dynamic subtest rcs0: FAIL (3.551s)
[188.231379] Starting dynamic subtest: bcs0
[191.747259] Dynamic subtest bcs0: SUCCESS (3.583s)
[191.756860] Starting dynamic subtest: vcs0
[195.614801] Dynamic subtest vcs0: SUCCESS (3.858s)
[195.623674] Starting dynamic subtest: vcs1
[199.621781] Dynamic subtest vcs1: SUCCESS (4.000s)
[199.630400] Starting dynamic subtest: vecs0
[203.603673] Dynamic subtest vecs0: SUCCESS (3.977s)
[203.613237] Starting dynamic subtest: ccs0
[207.239895] Dynamic subtest ccs0: FAIL (3.565s)
[207.242006] Subtest busy-double-start: FAIL (22.537s)
[207.260190] [069/130] (819s left) kms_psr (psr2-sprite-blt)
[207.353441] Starting subtest: psr2-sprite-blt
[207.355798] Starting dynamic subtest: eDP-1
[209.159912] Dynamic subtest eDP-1: SUCCESS (1.805s)
[209.162701] Subtest psr2-sprite-blt: SUCCESS (1.806s)
[210.019233] [070/130] (817s left) gem_lmem_swapping (parallel-multi)
[210.051608] Subtest parallel-multi: SKIP (0.000s)
[210.072363] [071/130] (817s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-5)
[210.163144] Starting subtest: planes-upscale-20x20-downscale-factor-0-5
[210.165505] Starting dynamic subtest: pipe-A
[210.174752] Dynamic subtest pipe-A: SKIP (0.005s)
[210.187551] Starting dynamic subtest: pipe-B
[210.197613] Dynamic subtest pipe-B: SKIP (0.015s)
[210.208149] Starting dynamic subtest: pipe-C
[210.217974] Dynamic subtest pipe-C: SKIP (0.015s)
[210.224748] Starting dynamic subtest: pipe-D
[210.234340] Dynamic subtest pipe-D: SKIP (0.015s)
[210.239045] Subtest planes-upscale-20x20-downscale-factor-0-5: SKIP (0.050s)
[210.299648] [072/130] (816s left) gem_exec_alignment (pi-isolated)
[210.353472] Starting subtest: pi-isolated
[331.098667] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[368.663192] Closing watchdogs
[368.664913] Initializing watchdogs
[368.664935]   /dev/watchdog0
[368.674038] [073/130] (658s left) gem_ctx_isolation (dirty-switch)
[368.749135] Starting subtest: dirty-switch
[368.751435] Starting dynamic subtest: rcs0
[368.962946] Dynamic subtest rcs0: SUCCESS (0.213s)
[368.971691] Starting dynamic subtest: bcs0
[369.191160] Dynamic subtest bcs0: SUCCESS (0.229s)
[369.198615] Starting dynamic subtest: vcs0
[369.423680] Dynamic subtest vcs0: SUCCESS (0.232s)
[369.433409] Starting dynamic subtest: vcs1
[371.251057] Dynamic subtest vcs1: SUCCESS (1.826s)
[371.260691] Starting dynamic subtest: vecs0
[373.305155] Dynamic subtest vecs0: SUCCESS (2.054s)
[373.314599] Starting dynamic subtest: ccs0
[375.304253] Dynamic subtest ccs0: SUCCESS (1.998s)
[375.306857] Subtest dirty-switch: SUCCESS (6.553s)
[375.522319] [074/130] (651s left) gem_wait (invalid-buf)
[375.576649] Starting subtest: invalid-buf
[375.578836] Subtest invalid-buf: SUCCESS (0.000s)
[375.769323] [075/130] (651s left) kms_lease (lease-revoke)
[375.859063] Starting subtest: lease-revoke
[375.861532] Starting dynamic subtest: pipe-A-eDP-1
[375.895581] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.036s)
[375.907960] Starting dynamic subtest: pipe-B-eDP-1
[375.922867] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.024s)
[375.930326] Starting dynamic subtest: pipe-C-eDP-1
[375.949294] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.026s)
[375.958395] Starting dynamic subtest: pipe-D-eDP-1
[375.976288] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.027s)
[375.978621] Subtest lease-revoke: SUCCESS (0.117s)
[376.067653] [076/130] (651s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move)
[376.162015] Starting subtest: psr-1p-primscrn-spr-indfb-move
[381.388313] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (5.231s)
[381.491292] [077/130] (645s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-pwrite)
[381.579631] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-pwrite
[385.969766] Subtest fbcpsr-1p-offscren-pri-indfb-draw-pwrite: SUCCESS (4.392s)
[386.094821] [078/130] (641s left) gem_partial_pwrite_pread (write-uncached)
[386.149582] Subtest write-uncached: SKIP (0.000s)
[386.190338] [079/130] (641s left) kms_prime (basic-crc-vgem)
[386.918220] Starting subtest: basic-crc-vgem
[386.920557] Starting dynamic subtest: second-to-first
[387.778002] Dynamic subtest second-to-first: SUCCESS (0.865s)
[387.780078] Subtest basic-crc-vgem: SUCCESS (0.866s)
[387.840231] [080/130] (639s left) kms_plane_alpha_blend (constant-alpha-max)
[387.934981] Starting subtest: constant-alpha-max
[388.229376] Starting dynamic subtest: pipe-A-eDP-1
[389.161365] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.930s)
[389.170804] Starting dynamic subtest: pipe-D-eDP-1
[390.846254] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.683s)
[390.848322] Subtest constant-alpha-max: SUCCESS (2.908s)
[391.720180] [081/130] (635s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[391.825888] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[394.982196] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (3.159s)
[395.083948] [082/130] (632s left) kms_flip (flip-vs-absolute-wf_vblank)
[395.164709] Starting subtest: flip-vs-absolute-wf_vblank
[395.166328] Starting dynamic subtest: A-eDP1
[404.188301] Dynamic subtest A-eDP1: SUCCESS (9.025s)
[404.196967] Starting dynamic subtest: B-eDP1
[413.150224] Dynamic subtest B-eDP1: SUCCESS (8.962s)
[413.157701] Starting dynamic subtest: C-eDP1
[422.104929] Dynamic subtest C-eDP1: SUCCESS (8.954s)
[422.114658] Starting dynamic subtest: D-eDP1
[431.060985] Dynamic subtest D-eDP1: SUCCESS (8.956s)
[431.067526] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.911s)
[432.292717] [083/130] (595s left) gem_exec_nop (basic-series)
[432.380636] Starting subtest: basic-series
[446.559893] Subtest basic-series: SUCCESS (14.190s)
[446.733270] [084/130] (580s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu)
[446.835698] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu
[446.840031] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[446.903176] [085/130] (580s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[446.999540] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[447.003656] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[447.087134] [086/130] (580s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[447.454671] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[448.336844] [087/130] (579s left) syncobj_wait (wait-delayed-signal)
[448.395423] Starting subtest: wait-delayed-signal
[448.495392] Subtest wait-delayed-signal: SUCCESS (0.101s)
[448.553512] [088/130] (578s left) gem_exec_schedule (submit-early-slice)
[448.620443] Starting subtest: submit-early-slice
[448.622724] Starting dynamic subtest: rcs0
[448.644852] Dynamic subtest rcs0: SUCCESS (0.035s)
[448.653346] Starting dynamic subtest: bcs0
[448.669606] Dynamic subtest bcs0: SUCCESS (0.025s)
[448.676913] Starting dynamic subtest: vcs0
[448.701758] Dynamic subtest vcs0: SUCCESS (0.032s)
[448.709268] Starting dynamic subtest: vcs1
[448.735106] Dynamic subtest vcs1: SUCCESS (0.033s)
[448.744586] Starting dynamic subtest: vecs0
[448.769521] Dynamic subtest vecs0: SUCCESS (0.034s)
[448.780236] Starting dynamic subtest: ccs0
[448.794579] Dynamic subtest ccs0: SUCCESS (0.025s)
[448.796905] Subtest submit-early-slice: SUCCESS (0.185s)
[450.186556] [089/130] (577s left) gem_ctx_param (set-priority-not-supported)
[450.229127] Starting subtest: set-priority-not-supported
[450.233534] Subtest set-priority-not-supported: SKIP (0.000s)
[450.271130] [090/130] (577s left) kms_joiner (basic-force-ultra-joiner)
[450.370850] Starting subtest: basic-force-ultra-joiner
[450.375140] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[450.415324] [091/130] (577s left) gem_exec_fair (basic-throttle)
[450.474402] Subtest basic-throttle: SKIP (0.000s)
[450.502345] [092/130] (576s left) gem_exec_whisper (basic-queues-all)
[450.548044] Starting subtest: basic-queues-all
[460.091235] Subtest basic-queues-all: SUCCESS (9.543s)
[460.248666] [093/130] (567s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[460.336621] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[460.338948] Starting dynamic subtest: pipe-A-eDP-1
[460.347792] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[460.356004] Starting dynamic subtest: pipe-B-eDP-1
[460.364095] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[460.370770] Starting dynamic subtest: pipe-C-eDP-1
[460.378791] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[460.385269] Starting dynamic subtest: pipe-D-eDP-1
[460.393370] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[460.397266] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.003s)
[462.691739] [094/130] (564s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[462.787322] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[462.789662] Starting dynamic subtest: pipe-A-eDP-1
[464.040399] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.252s)
[464.047566] Starting dynamic subtest: pipe-B-eDP-1
[466.396456] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.355s)
[466.405477] Starting dynamic subtest: pipe-C-eDP-1
[468.768100] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.370s)
[468.776942] Starting dynamic subtest: pipe-D-eDP-1
[471.145583] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.377s)
[471.148008] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SUCCESS (8.358s)
[472.357444] [095/130] (555s left) gem_fence_thrash (bo-copy)
[472.386651] Starting subtest: bo-copy
[472.412890] Subtest bo-copy: SKIP (0.024s)
[472.449601] [096/130] (555s left) kms_psr (fbc-pr-cursor-mmap-cpu)
[472.538503] Starting subtest: fbc-pr-cursor-mmap-cpu
[472.543132] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s)
[472.590524] [097/130] (554s left) api_intel_bb (simple-bb-ctx)
[472.640175] Starting subtest: simple-bb-ctx
[472.648728] Subtest simple-bb-ctx: SUCCESS (0.008s)
[472.750909] [098/130] (554s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-ccs)
[472.796025] Starting subtest: y-tiled-ccs-to-yf-tiled-ccs
[472.801024] Subtest y-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[472.952012] [099/130] (554s left) gem_exec_balancer (busy)
[472.997680] Starting subtest: busy
[475.046545] Subtest busy: SUCCESS (2.047s)
[475.311923] [100/130] (552s left) syncobj_wait (invalid-wait-illegal-handle)
[475.347949] Starting subtest: invalid-wait-illegal-handle
[475.350116] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[475.395957] [101/130] (552s left) syncobj_eventfd (timeline-wait-signaled)
[475.450391] Starting subtest: timeline-wait-signaled
[475.452541] Subtest timeline-wait-signaled: SUCCESS (0.000s)
[475.525344] [102/130] (552s left) syncobj_wait (wait-any-interrupted)
[475.576585] Starting subtest: wait-any-interrupted
[475.678363] Subtest wait-any-interrupted: SUCCESS (0.102s)
[475.737444] [103/130] (551s left) kms_feature_discovery (display)
[475.828331] Starting subtest: display
[475.830646] Subtest display: SUCCESS (0.000s)
[475.879103] [104/130] (551s left) gem_exec_fair (basic-none-rrul)
[475.944839] Subtest basic-none-rrul: SKIP (0.000s)
[475.973277] [105/130] (551s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-cpu)
[476.064786] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-cpu
[480.422793] Subtest psr-1p-offscren-pri-indfb-draw-mmap-cpu: SUCCESS (4.361s)
[480.522617] [106/130] (547s left) sysfs_heartbeat_interval (nopreempt)
[480.573221] Starting subtest: nopreempt
[480.575462] Starting dynamic subtest: vecs0
[489.088154] Dynamic subtest vecs0: SUCCESS (8.513s)
[489.098968] Starting dynamic subtest: ccs0
[493.048185] Dynamic subtest ccs0: SUCCESS (3.957s)
[493.059410] Starting dynamic subtest: vcs0
[503.104245] Dynamic subtest vcs0: SUCCESS (10.052s)
[503.115049] Starting dynamic subtest: bcs0
[506.921829] Dynamic subtest bcs0: SUCCESS (3.819s)
[506.931875] Starting dynamic subtest: rcs0
[510.813204] Dynamic subtest rcs0: SUCCESS (3.890s)
[510.824248] Starting dynamic subtest: vcs1
[520.138877] Dynamic subtest vcs1: SUCCESS (9.320s)
[520.141674] Subtest nopreempt: SUCCESS (39.557s)
[520.191856] [107/130] (507s left) gem_bad_reloc (negative-reloc)
[520.251736] Subtest negative-reloc: SKIP (0.000s)
[520.290811] [108/130] (507s left) gem_mmap_offset (mmap-unmap)
[520.346011] Starting subtest: mmap-unmap
[520.348625] Starting dynamic subtest: smem0
[535.391900] Dynamic subtest smem0: SUCCESS (15.045s)
[535.394350] Subtest mmap-unmap: SUCCESS (15.046s)
[535.476657] [109/130] (492s left) gem_ctx_shared (detached-shared-gtt)
[535.539320] Starting subtest: detached-shared-gtt
[537.694686] Subtest detached-shared-gtt: SUCCESS (2.154s)
[537.944447] [110/130] (489s left) kms_content_protection (atomic-dpms)
[538.086397] Starting subtest: atomic-dpms
[541.581078] Subtest atomic-dpms: SKIP (3.492s)
[542.825443] [111/130] (484s left) kms_addfb_basic (bad-pitch-32)
[542.878280] Starting subtest: bad-pitch-32
[542.880902] Subtest bad-pitch-32: SUCCESS (0.000s)
[542.977927] [112/130] (484s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[543.076567] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[543.765967] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.692s)
[543.891266] [113/130] (483s left) gem_pxp (verify-pxp-stale-buf-execution)
[546.470638] Subtest verify-pxp-stale-buf-execution: SKIP (0.000s)
[546.514255] [114/130] (481s left) gem_exec_params (rel-constants-invalid)
[546.569050] Starting subtest: rel-constants-invalid
[546.571450] Subtest rel-constants-invalid: SUCCESS (0.000s)
[546.654520] [115/130] (481s left) kms_chamelium_color (ctm-max)
[546.742666] Subtest ctm-max: SKIP (0.000s)
[546.767016] [116/130] (481s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[546.863127] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[551.557868] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.696s)
[551.648045] [117/130] (476s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[551.741354] Starting subtest: primary-y-tiled-reflect-x-270
[551.745893] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[551.790648] [118/130] (476s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt)
[551.886387] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt
[555.054027] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (3.171s)
[555.166848] [119/130] (472s left) i915_fb_tiling
[555.254542] [120/130] (472s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[555.342968] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[555.344995] Starting dynamic subtest: pipe-A-eDP-1
[555.364516] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[555.373581] Starting dynamic subtest: pipe-B-eDP-1
[555.391695] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[555.399390] Starting dynamic subtest: pipe-C-eDP-1
[555.417678] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[555.426336] Starting dynamic subtest: pipe-D-eDP-1
[555.444718] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[555.448078] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s)
[557.667839] [121/130] (470s left) kms_flip (flip-vs-panning-interruptible)
[557.751394] Starting subtest: flip-vs-panning-interruptible
[557.754055] Starting dynamic subtest: A-eDP1
[566.520528] Dynamic subtest A-eDP1: SUCCESS (8.765s)
[566.530133] Starting dynamic subtest: B-eDP1
[575.287543] Dynamic subtest B-eDP1: SUCCESS (8.765s)
[575.296775] Starting dynamic subtest: C-eDP1
[584.047082] Dynamic subtest C-eDP1: SUCCESS (8.757s)
[584.055413] Starting dynamic subtest: D-eDP1
[592.813858] Dynamic subtest D-eDP1: SUCCESS (8.764s)
[592.816522] Subtest flip-vs-panning-interruptible: SUCCESS (35.058s)
[594.084715] [122/130] (433s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[594.199807] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[595.691530] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.490s)
[596.584982] [123/130] (431s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf)
[601.731931] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf
[601.737931] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.002s)
[602.611528] [124/130] (425s left) gem_tiled_partial_pwrite_pread (writes)
[602.664276] Subtest writes: SKIP (0.000s)
[602.707352] [125/130] (425s left) kms_hdr (invalid-metadata-sizes)
[602.795350] Starting subtest: invalid-metadata-sizes
[602.802163] Subtest invalid-metadata-sizes: SKIP (0.000s)
[602.848086] [126/130] (425s left) i915_pm_rpm (system-suspend-execbuf)
[604.362163] Starting subtest: system-suspend-execbuf
[641.111066] Abort requested by /sbin/init [1] via Terminated, terminating children
[641.111148] 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 [1368] via Terminated, terminating children
[641.111413] Abort requested by /sbin/init [1] via Hangup, terminating children
[641.111429] Exiting gracefully, currently running test will have a 'notrun' result
[641.380089] Closing watchdogs
Done.