[79.796826] Initializing watchdogs
[79.796881]   /dev/watchdog0
[79.803278] [001/130] (960s left) i915_pm_rps (thresholds)
[79.901331] Starting subtest: thresholds
[79.903753] Subtest thresholds: SKIP (0.001s)
[79.950937] [002/130] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[80.013876] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[80.015945] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[80.090143] [003/130] (960s left) gem_exec_fence (submit-chain)
[80.249812] Starting subtest: submit-chain
[80.266509] Subtest submit-chain: SUCCESS (0.017s)
[80.772389] [004/130] (959s left) gem_softpin (evict-single-offset)
[80.808761] Starting subtest: evict-single-offset
[107.557679] Subtest evict-single-offset: SUCCESS (26.767s)
[107.604106] [005/130] (932s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-move)
[107.696146] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-move
[113.414730] Subtest fbcpsr-1p-primscrn-cur-indfb-move: SKIP (5.717s)
[113.495968] [006/130] (926s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[113.583851] Starting subtest: basic-flip-before-cursor-atomic
[114.348615] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.764s)
[115.243340] [007/130] (925s left) i915_suspend (basic-s3-without-i915)
[115.272833] Starting subtest: basic-s3-without-i915
[135.009387] Subtest basic-s3-without-i915: SUCCESS (4.140s)
[135.089617] [008/130] (920s left) gem_exec_suspend (basic-s3-devices)
[135.182303] Starting subtest: basic-S3-devices
[135.186189] Starting dynamic subtest: smem
[143.196934] Dynamic subtest smem: SUCCESS (8.012s)
[143.198550] Subtest basic-S3-devices: SUCCESS (8.014s)
[143.361324] [009/130] (912s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[143.421013] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[143.422774] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[143.487399] [010/130] (912s left) vgem_basic (bad-flag)
[143.523544] Starting subtest: bad-flag
[143.524279] Subtest bad-flag: SUCCESS (0.000s)
[143.564973] [011/130] (912s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[143.600101] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[143.600876] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[143.644325] [012/130] (912s left) gem_pxp (fail-invalid-protected-context)
[146.210610] Subtest fail-invalid-protected-context: SKIP (0.000s)
[146.255919] [013/130] (909s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[146.312855] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc
[146.313588] Starting dynamic subtest: pipe-A-eDP-1
[146.320472] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[146.328812] Starting dynamic subtest: pipe-B-eDP-1
[146.336637] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[146.346145] Starting dynamic subtest: pipe-C-eDP-1
[146.353392] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[146.354808] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.002s)
[146.366346] [014/130] (909s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[146.430319] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[147.420703] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (0.990s)
[147.566445] [015/130] (908s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[147.634495] Starting subtest: y-tiled-32bpp-rotate-270
[147.652069] Subtest y-tiled-32bpp-rotate-270: SKIP (0.018s)
[147.759705] [016/130] (908s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[147.790258] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[147.810807] [017/130] (908s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[147.864317] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[147.865773] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[147.945591] [018/130] (908s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[148.004453] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[148.006074] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[148.077249] [019/130] (908s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[148.135598] Starting subtest: cursor-rapid-movement-512x512
[148.137048] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[148.202317] [020/130] (908s left) gem_flink_race (flink_close)
[148.237885] Starting subtest: flink_close
[153.259284] Subtest flink_close: SUCCESS (5.020s)
[153.321694] [021/130] (902s left) kms_plane_cursor (overlay)
[153.415999] Starting subtest: overlay
[153.418270] Starting dynamic subtest: pipe-A-eDP-1-size-64
[155.624432] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.206s)
[155.680048] Starting dynamic subtest: pipe-A-eDP-1-size-128
[157.832318] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.169s)
[157.890170] Starting dynamic subtest: pipe-A-eDP-1-size-256
[160.125254] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.253s)
[160.498084] Starting dynamic subtest: pipe-B-eDP-1-size-64
[163.771795] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.290s)
[163.830275] Starting dynamic subtest: pipe-B-eDP-1-size-128
[166.074253] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.262s)
[166.132050] Starting dynamic subtest: pipe-B-eDP-1-size-256
[168.390754] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.278s)
[168.764529] Starting dynamic subtest: pipe-C-eDP-1-size-64
[171.682637] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.939s)
[171.719370] Starting dynamic subtest: pipe-C-eDP-1-size-128
[173.782184] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.076s)
[173.820661] Starting dynamic subtest: pipe-C-eDP-1-size-256
[175.949499] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.142s)
[176.270810] Subtest overlay: SUCCESS (22.855s)
[177.175229] [022/130] (879s left) kms_color (deep-color)
[177.240376] Starting subtest: deep-color
[177.247236] Subtest deep-color: SKIP (0.003s)
[177.299254] [023/130] (878s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[177.330873] Starting subtest: etime-single-wait-for-submit-submitted
[177.447621] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.107s)
[177.495923] [024/130] (878s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[177.549279] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[177.550199] Starting dynamic subtest: pipe-A-eDP-1
[178.681215] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.127s)
[178.696386] Starting dynamic subtest: pipe-B-eDP-1
[180.993740] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.310s)
[181.007381] Starting dynamic subtest: pipe-C-eDP-1
[183.193084] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.195s)
[183.193875] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SUCCESS (5.638s)
[184.414526] [025/130] (871s left) kms_chamelium_color (ctm-green-to-red)
[184.478656] Subtest ctm-green-to-red: SKIP (0.000s)
[184.507682] [026/130] (871s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-cpu)
[184.567835] Starting subtest: fbcpsr-rgb565-draw-mmap-cpu
[190.343499] Subtest fbcpsr-rgb565-draw-mmap-cpu: SKIP (5.774s)
[190.442005] [027/130] (865s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[190.502102] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[197.136184] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.632s)
[197.234566] [028/130] (859s left) prime_vgem (sync)
[197.272855] Starting subtest: sync
[197.273655] Starting dynamic subtest: rcs0
[197.296454] Dynamic subtest rcs0: SUCCESS (0.023s)
[197.312147] Starting dynamic subtest: bcs0
[197.339200] Dynamic subtest bcs0: SUCCESS (0.042s)
[197.354429] Starting dynamic subtest: vcs0
[197.377946] Dynamic subtest vcs0: SUCCESS (0.038s)
[197.393288] Starting dynamic subtest: vecs0
[197.417507] Dynamic subtest vecs0: SUCCESS (0.038s)
[197.418934] Subtest sync: SUCCESS (0.145s)
[197.521746] [029/130] (858s left) kms_cursor_crc (cursor-onscreen-256x256)
[197.586421] Starting subtest: cursor-onscreen-256x256
[197.593232] Starting dynamic subtest: pipe-A-eDP-1
[199.024845] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.433s)
[199.085666] Starting dynamic subtest: pipe-C-eDP-1
[201.256780] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.179s)
[201.258049] Subtest cursor-onscreen-256x256: SUCCESS (3.669s)
[202.146439] [030/130] (854s left) kms_joiner (basic-ultra-joiner)
[202.210507] Starting subtest: basic-ultra-joiner
[202.212288] Subtest basic-ultra-joiner: SKIP (0.000s)
[202.263883] [031/130] (854s left) gem_mmap_offset (bad-flags)
[202.304644] Starting subtest: bad-flags
[202.305700] Subtest bad-flags: SUCCESS (0.000s)
[202.385250] [032/130] (854s left) gem_exec_suspend (basic-s4-devices)
[202.421310] Starting subtest: basic-S4-devices
[202.422314] Starting dynamic subtest: smem
[211.321563] Dynamic subtest smem: SUCCESS (8.898s)
[211.323288] Subtest basic-S4-devices: SUCCESS (8.900s)
[222.515047] [033/130] (845s left) gem_exec_reloc (basic-cpu)
[222.558773] Subtest basic-cpu: SKIP (0.000s)
[222.604168] [034/130] (844s left) kms_vblank (wait-forked-busy)
[222.672822] Starting subtest: wait-forked-busy
[222.675695] Starting dynamic subtest: pipe-A-eDP-1
[224.164699] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.488s)
[224.183930] Starting dynamic subtest: pipe-C-eDP-1
[226.450462] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.282s)
[226.452053] Subtest wait-forked-busy: SUCCESS (3.778s)
[227.359377] [035/130] (840s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[227.419922] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[227.421404] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[227.488012] [036/130] (840s left) gem_eio (create)
[227.653474] Starting subtest: create
[227.903329] Subtest create: SUCCESS (0.250s)
[227.984269] [037/130] (839s left) api_intel_bb (reset-flags)
[228.016480] Starting subtest: reset-flags
[228.021392] Subtest reset-flags: SUCCESS (0.006s)
[228.117204] [038/130] (839s left) kms_psr (psr2-primary-mmap-gtt)
[228.173617] Starting subtest: psr2-primary-mmap-gtt
[228.174743] Starting dynamic subtest: eDP-1
[229.915450] Dynamic subtest eDP-1: SUCCESS (1.742s)
[229.916690] Subtest psr2-primary-mmap-gtt: SUCCESS (1.744s)
[230.820709] [039/130] (836s left) prime_mmap (test_reprime)
[230.852793] Starting subtest: test_reprime
[230.853566] Starting dynamic subtest: test_reprime-smem
[230.893530] Dynamic subtest test_reprime-smem: SUCCESS (0.042s)
[230.894434] Subtest test_reprime: SUCCESS (0.043s)
[230.953459] [040/130] (836s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[231.040654] Starting subtest: cursorA-vs-flipA-atomic-transitions
[242.147940] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.103s)
[243.187686] [041/130] (824s left) gem_mmap_gtt (big-copy-xy)
[243.222787] Starting subtest: big-copy-XY
[252.283492] Subtest big-copy-XY: SUCCESS (9.060s)
[252.342415] [042/130] (815s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[252.436086] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[258.228442] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SKIP (5.791s)
[258.319960] [043/130] (809s left) gem_exec_schedule (semaphore-noskip)
[258.367907] Starting subtest: semaphore-noskip
[258.590420] Subtest semaphore-noskip: SUCCESS (0.213s)
[258.892803] [044/130] (808s left) sw_sync (sync_merge)
[258.925608] Starting subtest: sync_merge
[258.926369] Subtest sync_merge: SUCCESS (0.000s)
[258.968691] [045/130] (808s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[259.002299] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[259.119532] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.108s)
[259.170047] [046/130] (808s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[259.224588] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[259.225497] Starting dynamic subtest: pipe-A-default-mode
[262.141354] Dynamic subtest pipe-A-default-mode: SUCCESS (2.915s)
[262.142278] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SUCCESS (2.917s)
[263.075287] [047/130] (804s left) kms_hdr (static-swap)
[263.132989] Starting subtest: static-swap
[263.135377] Subtest static-swap: SKIP (0.001s)
[263.189680] [048/130] (804s left) device_reset (unbind-reset-rebind)
[263.232622] Starting subtest: unbind-reset-rebind
[267.086886] Subtest unbind-reset-rebind: SUCCESS (3.845s)
[267.105460] [049/130] (800s left) kms_addfb_basic (unused-modifier)
[267.140409] Starting subtest: unused-modifier
[267.141213] Subtest unused-modifier: SUCCESS (0.000s)
[267.249070] [050/130] (800s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[267.316327] Starting subtest: 4-tiled-addfb-size-offset-overflow
[267.318249] Subtest 4-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[267.383472] [051/130] (800s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[267.414230] Starting subtest: write-cpu-read-wc-unflushed
[267.604057] Subtest write-cpu-read-wc-unflushed: SUCCESS (0.182s)
[267.668813] [052/130] (800s left) kms_flip (2x-flip-vs-suspend)
[267.727270] Starting subtest: 2x-flip-vs-suspend
[267.731929] Subtest 2x-flip-vs-suspend: SKIP (0.004s)
[267.794431] [053/130] (800s left) kms_chamelium_frames (hdmi-crc-fast)
[268.144328] Subtest hdmi-crc-fast: SKIP (0.000s)
[269.065738] [054/130] (798s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[269.096550] Starting subtest: cpuset-basic-small-copy-XY
[273.545499] Subtest cpuset-basic-small-copy-XY: SUCCESS (4.449s)
[273.602402] [055/130] (794s left) kms_cursor_crc (cursor-alpha-transparent)
[273.694347] Starting subtest: cursor-alpha-transparent
[273.695152] Starting dynamic subtest: pipe-A-eDP-1
[274.255904] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.560s)
[274.276610] Starting dynamic subtest: pipe-C-eDP-1
[275.589578] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.332s)
[275.590550] Subtest cursor-alpha-transparent: SUCCESS (1.895s)
[276.514434] [056/130] (791s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[276.576508] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[276.579208] Starting dynamic subtest: pipe-A-eDP-1
[276.586894] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[276.597255] Starting dynamic subtest: pipe-B-eDP-1
[276.604560] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[276.614813] Starting dynamic subtest: pipe-C-eDP-1
[276.621733] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[276.623067] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[276.635292] [057/130] (791s left) kms_psr (fbc-psr2-primary-blt)
[276.688678] Starting subtest: fbc-psr2-primary-blt
[276.689591] Starting dynamic subtest: eDP-1
[276.691171] Dynamic subtest eDP-1: SKIP (0.000s)
[276.692601] Subtest fbc-psr2-primary-blt: SKIP (0.001s)
[276.742156] [058/130] (791s left) gem_ctx_isolation (preservation-s3)
[276.776019] Starting subtest: preservation-S3
[276.776978] Starting dynamic subtest: rcs0
[293.436470] Dynamic subtest rcs0: SUCCESS (1.146s)
[293.447167] Starting dynamic subtest: bcs0
[309.384822] Dynamic subtest bcs0: SUCCESS (1.067s)
[309.396608] Starting dynamic subtest: vcs0
[325.393061] Dynamic subtest vcs0: SUCCESS (1.076s)
[325.403326] Starting dynamic subtest: vecs0
[341.421106] Dynamic subtest vecs0: SUCCESS (1.088s)
[341.421859] Subtest preservation-S3: SUCCESS (4.379s)
[341.622035] [059/130] (786s left) gem_exec_schedule (implicit-read-write)
[341.667917] Starting subtest: implicit-read-write
[341.668782] Starting dynamic subtest: rcs0
[341.731327] Dynamic subtest rcs0: SUCCESS (0.063s)
[341.749599] Starting dynamic subtest: bcs0
[341.790239] Dynamic subtest bcs0: SUCCESS (0.057s)
[341.811766] Starting dynamic subtest: vcs0
[341.865625] Dynamic subtest vcs0: SUCCESS (0.074s)
[341.891768] Starting dynamic subtest: vecs0
[341.935305] Dynamic subtest vecs0: SUCCESS (0.069s)
[341.937395] Subtest implicit-read-write: SUCCESS (0.269s)
[342.259789] [060/130] (786s left) gem_wait (busy)
[342.300071] Starting subtest: busy
[342.300968] Starting dynamic subtest: all-engines
[342.843766] Dynamic subtest all-engines: SUCCESS (0.553s)
[342.860008] Starting dynamic subtest: rcs0
[343.395257] Dynamic subtest rcs0: SUCCESS (0.558s)
[343.408586] Starting dynamic subtest: bcs0
[343.936873] Dynamic subtest bcs0: SUCCESS (0.548s)
[343.948861] Starting dynamic subtest: vcs0
[344.480869] Dynamic subtest vcs0: SUCCESS (0.550s)
[344.493794] Starting dynamic subtest: vecs0
[345.023804] Dynamic subtest vecs0: SUCCESS (0.548s)
[345.025493] Subtest busy: SUCCESS (2.767s)
[345.211314] [061/130] (783s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[345.284216] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[345.285867] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[345.373171] [062/130] (783s left) vgem_basic (second-client)
[345.413108] Starting subtest: second-client
[345.430285] Subtest second-client: SUCCESS (0.017s)
[345.473090] [063/130] (782s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[345.503359] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[345.504353] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[345.557870] [064/130] (782s left) kms_prop_blob (invalid-set-prop-any)
[345.588565] Starting subtest: invalid-set-prop-any
[345.589346] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[345.638983] [065/130] (782s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[345.706631] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[345.730820] [066/130] (782s left) kms_getfb (getfb-reject-ccs)
[345.760798] Starting subtest: getfb-reject-ccs
[345.761652] Subtest getfb-reject-ccs: SUCCESS (0.000s)
[345.826117] [067/130] (782s left) kms_psr (pr-sprite-mmap-gtt)
[345.878342] Starting subtest: pr-sprite-mmap-gtt
[345.879857] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[345.931462] [068/130] (782s left) gem_mmap_wc (bad-offset)
[345.959368] Starting subtest: bad-offset
[345.960737] Subtest bad-offset: SUCCESS (0.000s)
[346.028396] [069/130] (782s left) kms_psr (fbc-psr-cursor-render)
[346.083682] Starting subtest: fbc-psr-cursor-render
[346.084684] Starting dynamic subtest: eDP-1
[346.086439] Dynamic subtest eDP-1: SKIP (0.000s)
[346.087905] Subtest fbc-psr-cursor-render: SKIP (0.001s)
[346.139457] [070/130] (782s left) kms_atomic_transition (plane-all-transition)
[346.191998] Starting subtest: plane-all-transition
[346.193020] Starting dynamic subtest: pipe-A-eDP-1
[348.051542] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.868s)
[348.347905] Starting dynamic subtest: pipe-B-eDP-1
[351.043619] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.727s)
[351.306234] Subtest plane-all-transition: SUCCESS (5.157s)
[352.202724] [071/130] (776s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[352.263939] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[352.266148] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[352.342746] [072/130] (776s left) kms_big_fb (y-tiled-addfb-size-overflow)
[352.407649] Starting subtest: y-tiled-addfb-size-overflow
[352.408693] Subtest y-tiled-addfb-size-overflow: SUCCESS (0.000s)
[352.488395] [073/130] (776s left) kms_prop_blob (blob-multiple)
[352.521077] Starting subtest: blob-multiple
[352.522094] Subtest blob-multiple: SUCCESS (0.001s)
[352.576090] [074/130] (775s left) prime_mmap (test_aperture_limit)
[352.605290] Starting subtest: test_aperture_limit
[352.606189] Starting dynamic subtest: test_aperture_limit-smem
[352.613876] Dynamic subtest test_aperture_limit-smem: SUCCESS (0.008s)
[352.614808] Subtest test_aperture_limit: SUCCESS (0.009s)
[352.681284] [075/130] (775s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-wc)
[352.741292] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-wc
[356.264695] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-wc: SUCCESS (3.538s)
[357.530360] [076/130] (771s left) perf_pmu (semaphore-wait)
[357.566530] Starting subtest: semaphore-wait
[357.567354] Starting dynamic subtest: rcs0
[358.085902] Dynamic subtest rcs0: SUCCESS (0.512s)
[358.102721] Starting dynamic subtest: bcs0
[358.596974] Dynamic subtest bcs0: SUCCESS (0.510s)
[358.610340] Starting dynamic subtest: vcs0
[359.108348] Dynamic subtest vcs0: SUCCESS (0.511s)
[359.121942] Starting dynamic subtest: vecs0
[359.619547] Dynamic subtest vecs0: SUCCESS (0.510s)
[359.621370] Subtest semaphore-wait: SUCCESS (2.051s)
[359.710984] [077/130] (768s left) gem_blits (basic)
[359.747336] Starting subtest: basic
[365.235951] Subtest basic: SUCCESS (5.465s)
[365.306094] [078/130] (763s left) gem_exec_fence (syncobj-timeline-repeat)
[365.742891] Starting subtest: syncobj-timeline-repeat
[365.949823] Subtest syncobj-timeline-repeat: SUCCESS (0.204s)
[366.145546] [079/130] (762s left) kms_big_fb (linear-8bpp-rotate-0)
[366.215682] Starting subtest: linear-8bpp-rotate-0
[367.600788] Subtest linear-8bpp-rotate-0: SUCCESS (1.387s)
[367.707921] [080/130] (760s left) api_intel_bb (intel-bb-blit-none)
[367.738154] Starting subtest: intel-bb-blit-none
[371.765781] Subtest intel-bb-blit-none: SUCCESS (4.024s)
[371.844597] [081/130] (756s left) gem_exec_whisper (basic-forked-all)
[371.887743] Starting subtest: basic-forked-all
[379.647243] Subtest basic-forked-all: SUCCESS (7.756s)
[379.815992] [082/130] (748s left) gem_flink_basic (bad-flink)
[379.845239] Starting subtest: bad-flink
[379.846116] Subtest bad-flink: SUCCESS (0.000s)
[379.892593] [083/130] (748s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[379.955043] Starting subtest: psr-rgb565-draw-render
[386.873102] Subtest psr-rgb565-draw-render: SUCCESS (6.918s)
[386.979319] [084/130] (741s left) gem_exec_reloc (basic-cpu-gtt-active)
[387.011968] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[387.061644] [085/130] (741s left) gem_fence_thrash (bo-copy)
[387.088511] Starting subtest: bo-copy
[388.366436] Subtest bo-copy: SUCCESS (1.270s)
[388.440292] [086/130] (740s left) kms_psr (fbc-pr-primary-mmap-gtt)
[388.498975] Starting subtest: fbc-pr-primary-mmap-gtt
[388.500745] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[388.550970] [087/130] (740s left) prime_mmap (test_correct)
[388.580922] Starting subtest: test_correct
[388.581747] Starting dynamic subtest: test_correct-smem
[388.623181] Dynamic subtest test_correct-smem: SUCCESS (0.042s)
[388.624022] Subtest test_correct: SUCCESS (0.043s)
[388.683175] [088/130] (740s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[389.024221] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[389.933877] [089/130] (738s left) gem_mmap_gtt (basic-small-copy)
[389.963815] Starting subtest: basic-small-copy
[391.358172] Subtest basic-small-copy: SUCCESS (1.395s)
[391.417682] [090/130] (737s left) dumb_buffer (create-valid-dumb)
[391.478742] Starting subtest: create-valid-dumb
[391.479592] Subtest create-valid-dumb: SUCCESS (0.000s)
[391.540379] [091/130] (737s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[391.572055] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[391.572979] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[391.626897] [092/130] (737s left) gem_exec_schedule (u-semaphore-user)
[391.667086] Starting subtest: u-semaphore-user
[391.674568] Subtest u-semaphore-user: SUCCESS (0.007s)
[391.984564] [093/130] (736s left) gem_render_copy (y-tiled-ccs-to-y-tiled-mc-ccs)
[392.016397] Starting subtest: y-tiled-ccs-to-y-tiled-mc-ccs
[392.017189] Starting dynamic subtest: smem
[392.126051] Dynamic subtest smem: SUCCESS (0.109s)
[392.126957] Subtest y-tiled-ccs-to-y-tiled-mc-ccs: SUCCESS (0.110s)
[392.300817] [094/130] (736s left) prime_self_import (basic-llseek-size)
[392.328299] Starting subtest: basic-llseek-size
[392.331721] Subtest basic-llseek-size: SUCCESS (0.002s)
[392.418567] [095/130] (736s left) gem_tiled_partial_pwrite_pread (reads)
[392.452041] Subtest reads: SKIP (0.000s)
[392.506381] [096/130] (736s left) gem_readwrite (write-bad-handle)
[392.538798] Subtest write-bad-handle: SKIP (0.000s)
[392.596172] [097/130] (736s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[392.661396] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[392.663186] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[392.735269] [098/130] (736s left) kms_atomic_transition (modeset-transition-nonblocking)
[392.788859] Starting subtest: modeset-transition-nonblocking
[392.789970] Starting dynamic subtest: 1x-outputs
[403.971947] Dynamic subtest 1x-outputs: SUCCESS (11.178s)
[404.238926] Subtest modeset-transition-nonblocking: SUCCESS (11.454s)
[405.137645] [099/130] (723s left) gen9_exec_parse (basic-rejected-ctx-param)
[405.173213] Subtest basic-rejected-ctx-param: SKIP (0.000s)
[405.208156] [100/130] (723s left) i915_hangman (detector)
[405.248499] Starting subtest: detector
[405.249415] Starting dynamic subtest: rcs0
[415.142180] Dynamic subtest rcs0: SUCCESS (9.897s)
[415.163448] Starting dynamic subtest: bcs0
[425.069839] Dynamic subtest bcs0: SUCCESS (9.930s)
[425.088644] Starting dynamic subtest: vcs0
[435.131990] Dynamic subtest vcs0: SUCCESS (10.064s)
[435.152761] Starting dynamic subtest: vecs0
[445.102055] Dynamic subtest vecs0: SUCCESS (9.963s)
[445.103976] Subtest detector: SUCCESS (39.862s)
[445.216295] [101/130] (683s left) gem_softpin (evict-active-interruptible)
[445.254008] Starting subtest: evict-active-interruptible
[445.267723] Subtest evict-active-interruptible: SUCCESS (0.014s)
[445.333397] [102/130] (683s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[445.391865] Starting subtest: crc-primary-basic-yf-tiled-ccs
[445.392855] Starting dynamic subtest: pipe-A-eDP-1
[445.400430] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[445.411973] Starting dynamic subtest: pipe-B-eDP-1
[445.419879] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[445.432243] Starting dynamic subtest: pipe-C-eDP-1
[445.439328] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[445.440742] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.005s)
[445.460453] [103/130] (683s left) kms_flip (2x-flip-vs-panning-interruptible)
[445.516507] Starting subtest: 2x-flip-vs-panning-interruptible
[445.520473] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.003s)
[445.576530] [104/130] (683s left) gem_exec_capture (capture-recoverable)
[445.610776] Starting subtest: capture-recoverable
[445.612461] Subtest capture-recoverable: SKIP (0.000s)
[445.686242] [105/130] (683s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[445.745788] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[452.739263] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (6.990s)
[452.828920] [106/130] (676s left) gem_partial_pwrite_pread (write)
[452.862688] Subtest write: SKIP (0.000s)
[452.916107] [107/130] (676s left) kms_pm_dc (dc3co-vpb-simulation)
[453.979898] Starting subtest: dc3co-vpb-simulation
[463.088137] Subtest dc3co-vpb-simulation: SKIP (9.103s)
[463.273526] [108/130] (665s left) kms_rotation_crc (multiplane-rotation)
[463.331068] Starting subtest: multiplane-rotation
[469.746879] Subtest multiplane-rotation: SUCCESS (6.415s)
[469.833638] [109/130] (659s left) kms_dsc (dsc-with-output-formats)
[469.891151] Starting subtest: dsc-with-output-formats
[469.893434] Subtest dsc-with-output-formats: SKIP (0.001s)
[469.948128] [110/130] (659s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled)
[469.978506] Starting subtest: multi-wait-all-for-submit-available-signaled
[469.979391] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[470.034693] [111/130] (659s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[473.505530] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[473.512350] Starting dynamic subtest: pipe-A-eDP-1
[480.416075] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.906s)
[480.441115] Starting dynamic subtest: pipe-B-eDP-1
[487.328250] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.911s)
[487.329168] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (13.823s)
[488.265989] [112/130] (641s left) i915_pm_rpm (system-suspend-execbuf)
[489.742565] Starting subtest: system-suspend-execbuf
[547.786657] Subtest system-suspend-execbuf: SUCCESS (42.464s)
[548.236241] [113/130] (596s left) kms_frontbuffer_tracking (fbc-tiling-4)
[548.295766] Starting subtest: fbc-tiling-4
[548.297409] Subtest fbc-tiling-4: SKIP (0.000s)
[548.395571] [114/130] (596s left) gem_softpin (evict-active)
[548.430530] Starting subtest: evict-active
[548.442067] Subtest evict-active: SUCCESS (0.011s)
[548.517714] [115/130] (596s left) gem_mmap_wc (copy)
[548.550462] Starting subtest: copy
[548.812760] Subtest copy: SUCCESS (0.255s)
[548.857465] [116/130] (596s left) gem_ctx_bad_destroy (double-destroy)
[548.888408] Starting subtest: double-destroy
[548.889263] Subtest double-destroy: SUCCESS (0.000s)
[548.942266] [117/130] (596s left) gem_create (create-ext-cpu-access-sanity-check)
[549.089395] Starting subtest: create-ext-cpu-access-sanity-check
[549.091903] Subtest create-ext-cpu-access-sanity-check: SKIP (0.000s)
[549.140506] [118/130] (595s left) kms_plane_scaling (planes-downscale-factor-0-25)
[549.193965] Starting subtest: planes-downscale-factor-0-25
[549.194813] Starting dynamic subtest: pipe-A
[549.211838] Dynamic subtest pipe-A: SKIP (0.016s)
[549.224580] Starting dynamic subtest: pipe-B
[549.244022] Dynamic subtest pipe-B: SKIP (0.032s)
[549.257099] Starting dynamic subtest: pipe-C
[549.276802] Dynamic subtest pipe-C: SKIP (0.032s)
[549.278308] Subtest planes-downscale-factor-0-25: SKIP (0.082s)
[549.346522] [119/130] (595s left) gem_exec_balancer (parallel-ordering)
[550.382223] Subtest parallel-ordering: SKIP (0.000s)
[550.426663] [120/130] (594s left) perf (gen12-group-concurrent-oa-buffer-read)
[550.520851] Starting subtest: gen12-group-concurrent-oa-buffer-read
[560.583531] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.028s)
[560.607938] [121/130] (584s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[560.673925] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[560.675402] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[560.750967] [122/130] (584s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[560.804144] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[560.805094] Starting dynamic subtest: pipe-A
[561.070087] Dynamic subtest pipe-A: SUCCESS (0.266s)
[561.090650] Starting dynamic subtest: pipe-B
[562.738333] Dynamic subtest pipe-B: SUCCESS (1.667s)
[562.762382] Starting dynamic subtest: pipe-C
[564.401736] Dynamic subtest pipe-C: SUCCESS (1.662s)
[564.403063] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (3.598s)
[565.699913] [123/130] (579s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[565.770482] Starting subtest: x-tiled-8bpp-rotate-90
[565.787625] Subtest x-tiled-8bpp-rotate-90: SKIP (0.017s)
[565.883703] [124/130] (579s left) syncobj_timeline (single-wait-all-for-submit-available-submitted)
[565.915854] Starting subtest: single-wait-all-for-submit-available-submitted
[565.916691] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s)
[565.966675] [125/130] (579s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[566.025347] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[566.027410] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[566.120894] [126/130] (579s left) gem_ctx_shared (detached-shared-gtt)
[566.155842] Starting subtest: detached-shared-gtt
[568.314093] Subtest detached-shared-gtt: SUCCESS (2.149s)
[568.673530] [127/130] (576s left) gem_eio (in-flight-external)
[568.848804] Starting subtest: in-flight-external
[570.643563] Subtest in-flight-external: SUCCESS (1.796s)
[570.740685] [128/130] (574s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[570.802983] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[574.190384] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.388s)
[575.445244] [129/130] (569s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[575.508966] Starting subtest: nonblocking-crc-frame-sequence
[575.509901] Starting dynamic subtest: pipe-A-eDP-1
[576.196178] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.687s)
[576.222665] Starting dynamic subtest: pipe-B-eDP-1
[577.669186] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.472s)
[577.689149] Starting dynamic subtest: pipe-C-eDP-1
[579.088397] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.417s)
[579.089781] Subtest nonblocking-crc-frame-sequence: SUCCESS (3.581s)
[579.974032] [130/130] (565s left) kms_cursor_edge_walk (256x256-right-edge)
[580.034020] Starting subtest: 256x256-right-edge
[580.035103] Starting dynamic subtest: pipe-A-eDP-1
[583.098794] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.063s)
[583.116641] Starting dynamic subtest: pipe-C-eDP-1
[585.834215] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.734s)
[585.835571] Subtest 256x256-right-edge: SUCCESS (5.803s)
[586.744492] Closing watchdogs
Done.