[38.696130] Initializing watchdogs [38.696183] /dev/watchdog0 [38.701691] [001/143] (960s left) kms_ccs (pipe-b-random-ccs-data-y-tiled-ccs) [38.968300] Starting subtest: pipe-B-random-ccs-data-y-tiled-ccs [38.970579] Subtest pipe-B-random-ccs-data-y-tiled-ccs: SKIP (0.000s) [39.175770] [002/143] (960s left) kms_psr (fbc-psr-cursor-mmap-cpu) [39.337162] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.000s) [39.362966] [003/143] (959s left) syncobj_wait (multi-wait-all-submitted-signaled) [39.406402] Starting subtest: multi-wait-all-submitted-signaled [39.513640] Subtest multi-wait-all-submitted-signaled: SUCCESS (0.106s) [39.602931] [004/143] (959s left) kms_ccs (pipe-d-crc-primary-rotation-180-4-tiled-mtl-mc-ccs) [39.893274] Starting subtest: pipe-D-crc-primary-rotation-180-4-tiled-mtl-mc-ccs [39.895045] Subtest pipe-D-crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SKIP (0.000s) [40.056887] [005/143] (959s left) gem_ctx_param (invalid-size-get) [40.135363] Starting subtest: invalid-size-get [40.136349] Subtest invalid-size-get: SUCCESS (0.001s) [40.193875] [006/143] (959s left) gem_pxp (protected-raw-src-copy-not-readible) [42.778304] Subtest protected-raw-src-copy-not-readible: SKIP (0.000s) [42.835122] [007/143] (956s left) vc4/vc4_purgeable_bo (access-purgeable-bo-mem) [42.914936] Subtest access-purgeable-bo-mem: SKIP (0.000s) [42.970382] [008/143] (956s left) prime_vgem (basic-fence-blt) [43.093374] Starting subtest: basic-fence-blt [43.215669] Subtest basic-fence-blt: SUCCESS (0.121s) [43.333617] [009/143] (956s left) kms_psr (fbc-pr-sprite-blt) [43.453873] Subtest fbc-pr-sprite-blt: SKIP (0.000s) [43.469728] [010/143] (955s left) kms_flip (2x-flip-vs-rmfb) [43.585849] Starting subtest: 2x-flip-vs-rmfb [43.600482] Subtest 2x-flip-vs-rmfb: SKIP (0.015s) [43.662719] [011/143] (955s left) kms_content_protection (content-type-change) [43.849206] Starting subtest: content-type-change [44.443891] Subtest content-type-change: SKIP (0.589s) [44.754225] [012/143] (954s left) gem_exec_reloc (basic-gtt-read-active) [44.859791] Subtest basic-gtt-read-active: SKIP (0.000s) [44.926673] [013/143] (954s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt) [45.058660] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt [45.060329] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [45.146658] [014/143] (954s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite) [45.280025] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite [45.281666] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [45.340981] [015/143] (954s left) i915_pm_rpm (debugfs-forcewake-user) [47.531174] Starting subtest: debugfs-forcewake-user [58.199863] Subtest debugfs-forcewake-user: SUCCESS (10.668s) [58.500813] [016/143] (940s left) gem_close_race (basic-threads) [58.593472] Starting subtest: basic-threads [59.781692] Subtest basic-threads: SUCCESS (1.188s) [60.009314] [017/143] (939s left) perf (gen12-unprivileged-single-ctx-counters) [60.426046] Starting subtest: gen12-unprivileged-single-ctx-counters [60.426998] Starting dynamic subtest: rcs0 [60.504577] Dynamic subtest rcs0: SUCCESS (0.079s) [60.505424] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.079s) [60.520803] [018/143] (939s left) kms_flip (plain-flip-ts-check-interruptible) [60.640140] Starting subtest: plain-flip-ts-check-interruptible [60.646088] Starting dynamic subtest: A-DP4 [68.735521] Dynamic subtest A-DP4: SUCCESS (8.089s) [68.742409] Starting dynamic subtest: B-DP4 [76.755195] Dynamic subtest B-DP4: SUCCESS (8.019s) [76.760853] Starting dynamic subtest: C-DP4 [84.777330] Dynamic subtest C-DP4: SUCCESS (8.022s) [84.782626] Starting dynamic subtest: D-DP4 [92.795570] Dynamic subtest D-DP4: SUCCESS (8.018s) [92.796497] Subtest plain-flip-ts-check-interruptible: SUCCESS (32.156s) [93.089597] [019/143] (906s left) gem_exec_reloc (basic-cpu-gtt-noreloc) [93.179648] Subtest basic-cpu-gtt-noreloc: SKIP (0.000s) [93.225390] [020/143] (906s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu) [93.351289] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu [95.586514] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (2.235s) [95.706835] [021/143] (903s left) gem_ctx_persistence (legacy-engines-hostile) [95.754999] Starting subtest: legacy-engines-hostile [95.755951] Starting dynamic subtest: render [95.822474] Dynamic subtest render: SUCCESS (0.067s) [95.831299] Starting dynamic subtest: bsd1 [95.896440] Dynamic subtest bsd1: SUCCESS (0.073s) [95.918904] Starting dynamic subtest: bsd2 [95.936534] Dynamic subtest bsd2: SUCCESS (0.039s) [95.958966] Starting dynamic subtest: blt [95.998320] Dynamic subtest blt: SUCCESS (0.061s) [96.020718] Starting dynamic subtest: vebox [96.031367] Dynamic subtest vebox: SUCCESS (0.032s) [96.033361] Subtest legacy-engines-hostile: SUCCESS (0.276s) [96.169429] [022/143] (903s left) kms_ccs (pipe-d-bad-pixel-format-4-tiled-mtl-rc-ccs-cc) [96.499175] Starting subtest: pipe-D-bad-pixel-format-4-tiled-mtl-rc-ccs-cc [96.500959] Subtest pipe-D-bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s) [96.665739] [023/143] (903s left) gen3_render_tiledy_blits [96.764479] [024/143] (902s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling) [96.879348] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling [96.880182] Starting dynamic subtest: pipe-A-valid-mode [98.474623] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.592s) [98.476595] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SUCCESS (1.593s) [98.680306] [025/143] (901s left) kms_psr (fbc-psr-dpms) [98.830918] Subtest fbc-psr-dpms: SKIP (0.000s) [98.858337] [026/143] (900s left) gem_exec_schedule (preempt-engines) [98.913260] Starting subtest: preempt-engines [98.914281] Starting dynamic subtest: rcs0 [101.102170] Dynamic subtest rcs0: SUCCESS (2.188s) [101.108483] Starting dynamic subtest: bcs0 [103.272052] Dynamic subtest bcs0: SUCCESS (2.169s) [103.278361] Starting dynamic subtest: vcs0 [105.521333] Dynamic subtest vcs0: SUCCESS (2.248s) [105.530535] Starting dynamic subtest: vcs1 [107.775513] Dynamic subtest vcs1: SUCCESS (2.253s) [107.781447] Starting dynamic subtest: vecs0 [110.026476] Dynamic subtest vecs0: SUCCESS (2.250s) [110.032569] Starting dynamic subtest: vecs1 [112.275910] Dynamic subtest vecs1: SUCCESS (2.249s) [112.282266] Starting dynamic subtest: ccs0 [114.475952] Dynamic subtest ccs0: SUCCESS (2.199s) [114.482471] Starting dynamic subtest: ccs1 [116.671538] Dynamic subtest ccs1: SUCCESS (2.195s) [116.678417] Starting dynamic subtest: ccs2 [118.923894] Dynamic subtest ccs2: SUCCESS (2.252s) [118.933611] Starting dynamic subtest: ccs3 [121.121558] Dynamic subtest ccs3: SUCCESS (2.197s) [121.123460] Subtest preempt-engines: SUCCESS (22.207s) [121.433661] [027/143] (878s left) vc4/vc4_label_bo (set-bad-handle) [121.503319] Subtest set-bad-handle: SKIP (0.000s) [121.560505] [028/143] (878s left) gem_pread (display) [121.612311] Subtest display: SKIP (0.000s) [121.642296] [029/143] (878s left) gem_exec_await (wide-all) [122.115648] Starting subtest: wide-all [144.293708] Subtest wide-all: SUCCESS (22.178s) [144.507080] [030/143] (855s left) gem_exec_balancer (semaphore) [144.625133] Starting subtest: semaphore [145.536156] Subtest semaphore: SUCCESS (0.911s) [145.803176] [031/143] (854s left) dmabuf_sync_file (export-basic) [145.853576] Starting subtest: export-basic [145.854841] Subtest export-basic: SUCCESS (0.001s) [145.904159] [032/143] (853s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [145.975932] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s) [146.140398] [033/143] (853s left) gem_pwrite (basic-random) [146.219595] Subtest basic-random: SKIP (0.000s) [146.244180] [034/143] (853s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu) [146.369027] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu [146.370808] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [146.457768] [035/143] (853s left) gem_softpin (allocator-fork) [146.522644] Starting subtest: allocator-fork [148.778930] Subtest allocator-fork: SUCCESS (2.256s) [148.907869] [036/143] (851s left) gem_fenced_exec_thrash (too-many-fences) [148.999224] Subtest too-many-fences: SKIP (0.000s) [149.027331] [037/143] (850s left) gem_exec_balancer (bonded-chain) [149.083379] Starting subtest: bonded-chain [168.315520] Subtest bonded-chain: SUCCESS (19.232s) [168.609229] [038/143] (831s left) syncobj_wait (invalid-multi-wait-unsubmitted) [168.658475] Starting subtest: invalid-multi-wait-unsubmitted [168.659384] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s) [168.720371] [039/143] (831s left) kms_ccs (pipe-c-crc-primary-basic-4-tiled-dg2-rc-ccs) [168.968628] Starting subtest: pipe-C-crc-primary-basic-4-tiled-dg2-rc-ccs [169.449178] Subtest pipe-C-crc-primary-basic-4-tiled-dg2-rc-ccs: SUCCESS (0.479s) [169.803902] [040/143] (830s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw) [169.938282] Starting subtest: fbc-1p-pri-indfb-multidraw [177.958987] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (8.020s) [178.077668] [041/143] (821s left) kms_plane_alpha_blend (alpha-opaque-fb) [178.192225] Starting subtest: alpha-opaque-fb [178.392142] Starting dynamic subtest: pipe-A-DP-4 [178.899144] Dynamic subtest pipe-A-DP-4: SUCCESS (0.506s) [178.906399] Starting dynamic subtest: pipe-D-DP-4 [179.481157] Dynamic subtest pipe-D-DP-4: SUCCESS (0.581s) [179.481951] Subtest alpha-opaque-fb: SUCCESS (1.288s) [179.687820] [042/143] (820s left) syncobj_timeline (single-wait-all-for-submit-available-submitted) [179.755423] Starting subtest: single-wait-all-for-submit-available-submitted [179.756336] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s) [179.826077] [043/143] (820s left) debugfs_test (read_all_entries_display_on) [179.950999] Starting subtest: read_all_entries_display_on [180.422131] Subtest read_all_entries_display_on: SUCCESS (0.472s) [180.561379] [044/143] (819s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait) [180.676451] Starting subtest: plane-primary-toggle-with-vblank-wait [180.677317] Starting dynamic subtest: pipe-A-DP-4 [180.888605] Dynamic subtest pipe-A-DP-4: SUCCESS (0.211s) [181.018987] Starting dynamic subtest: pipe-B-DP-4 [181.295487] Dynamic subtest pipe-B-DP-4: SUCCESS (0.282s) [181.401460] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (0.725s) [181.581170] [045/143] (818s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers) [181.731667] Starting subtest: plane-upscale-20x20-with-modifiers [181.744404] Starting dynamic subtest: pipe-A-DP-4 [182.567724] Dynamic subtest pipe-A-DP-4: SUCCESS (0.823s) [182.593365] Starting dynamic subtest: pipe-B-DP-4 [183.410199] Dynamic subtest pipe-B-DP-4: SUCCESS (0.829s) [183.427308] Starting dynamic subtest: pipe-C-DP-4 [184.249600] Dynamic subtest pipe-C-DP-4: SUCCESS (0.827s) [184.275128] Starting dynamic subtest: pipe-D-DP-4 [185.089785] Dynamic subtest pipe-D-DP-4: SUCCESS (0.826s) [185.090699] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (3.358s) [185.411860] [046/143] (814s left) gem_partial_pwrite_pread (reads-uncached) [185.475320] Subtest reads-uncached: SKIP (0.000s) [185.520677] [047/143] (814s left) kms_ccs (pipe-b-crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc) [185.755227] Starting subtest: pipe-B-crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc [185.758160] Subtest pipe-B-crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.002s) [185.947377] [048/143] (814s left) gem_ctx_persistence (heartbeat-many) [186.031431] Starting subtest: heartbeat-many [186.033234] Subtest heartbeat-many: SKIP (0.000s) [186.086470] [049/143] (814s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20) [186.201662] Starting subtest: planes-downscale-factor-0-5-upscale-20x20 [186.213122] Starting dynamic subtest: pipe-A-DP-4 [186.303506] Dynamic subtest pipe-A-DP-4: SUCCESS (0.090s) [186.321038] Starting dynamic subtest: pipe-B-DP-4 [186.511083] Dynamic subtest pipe-B-DP-4: SUCCESS (0.195s) [186.536305] Starting dynamic subtest: pipe-C-DP-4 [186.751377] Dynamic subtest pipe-C-DP-4: SUCCESS (0.226s) [186.770696] Starting dynamic subtest: pipe-D-DP-4 [186.988409] Dynamic subtest pipe-D-DP-4: SUCCESS (0.224s) [186.989429] Subtest planes-downscale-factor-0-5-upscale-20x20: SUCCESS (0.787s) [187.234448] [050/143] (813s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render) [187.392772] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render [187.394452] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [187.463316] [051/143] (812s left) api_intel_bb (add-remove-objects) [187.520570] Starting subtest: add-remove-objects [187.550325] Subtest add-remove-objects: SUCCESS (0.028s) [187.664730] [052/143] (812s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [187.826010] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt [187.827921] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [187.916254] [053/143] (812s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions) [188.053550] Starting subtest: short-flip-before-cursor-atomic-transitions [189.086128] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (1.032s) [189.310504] [054/143] (811s left) kms_ccs (pipe-b-bad-pixel-format-y-tiled-gen12-mc-ccs) [189.520154] Starting subtest: pipe-B-bad-pixel-format-y-tiled-gen12-mc-ccs [189.522091] Subtest pipe-B-bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.000s) [189.744638] [055/143] (810s left) kms_cursor_crc (cursor-sliding-32x32) [189.944374] Starting subtest: cursor-sliding-32x32 [189.986042] Subtest cursor-sliding-32x32: SKIP (0.040s) [190.275907] [056/143] (810s left) kms_dsc (dsc-with-output-formats-with-bpc) [190.392992] Subtest dsc-with-output-formats-with-bpc: SKIP (0.000s) [190.424475] [057/143] (809s left) sysfs_heartbeat_interval (mixed) [190.472488] Starting subtest: mixed [190.473448] Starting dynamic subtest: ccs2 [195.701167] Dynamic subtest ccs2: SUCCESS (5.228s) [195.709175] Starting dynamic subtest: vecs0 [200.931679] Dynamic subtest vecs0: SUCCESS (5.230s) [200.939593] Starting dynamic subtest: ccs0 [206.171120] Dynamic subtest ccs0: SUCCESS (5.238s) [206.178776] Starting dynamic subtest: vcs0 [211.401411] Dynamic subtest vcs0: SUCCESS (5.229s) [211.409381] Starting dynamic subtest: bcs0 [216.646190] Dynamic subtest bcs0: SUCCESS (5.243s) [216.654904] Starting dynamic subtest: ccs3 [221.863491] Dynamic subtest ccs3: SUCCESS (5.215s) [221.873219] Starting dynamic subtest: vecs1 [227.101850] Dynamic subtest vecs1: SUCCESS (5.237s) [227.108759] Starting dynamic subtest: ccs1 [232.345482] Dynamic subtest ccs1: SUCCESS (5.243s) [232.355507] Starting dynamic subtest: rcs0 [237.604020] Dynamic subtest rcs0: SUCCESS (5.257s) [237.611585] Starting dynamic subtest: vcs1 [242.833989] Dynamic subtest vcs1: SUCCESS (5.229s) [242.835142] Subtest mixed: SUCCESS (52.362s) [242.918234] [058/143] (757s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu) [243.041066] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu [243.042616] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [243.121451] [059/143] (757s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt) [243.276297] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt [243.277880] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [243.354803] [060/143] (757s left) gen9_exec_parse (batch-without-end) [243.423517] Subtest batch-without-end: SKIP (0.000s) [243.442821] [061/143] (757s left) kms_ccs (pipe-a-ccs-on-another-bo-yf-tiled-ccs) [243.657258] Starting subtest: pipe-A-ccs-on-another-bo-yf-tiled-ccs [243.659265] Subtest pipe-A-ccs-on-another-bo-yf-tiled-ccs: SKIP (0.000s) [243.877309] [062/143] (756s left) kms_cursor_legacy (torture-move) [244.000783] Starting subtest: torture-move [244.001647] Starting dynamic subtest: pipe-A [249.437577] Dynamic subtest pipe-A: SUCCESS (5.432s) [249.443734] Starting dynamic subtest: pipe-B [254.871952] Dynamic subtest pipe-B: SUCCESS (5.437s) [254.877976] Starting dynamic subtest: pipe-C [260.311944] Dynamic subtest pipe-C: SUCCESS (5.439s) [260.320338] Starting dynamic subtest: pipe-D [265.755787] Dynamic subtest pipe-D: SUCCESS (5.443s) [265.761711] Starting dynamic subtest: all-pipes [271.189300] Dynamic subtest all-pipes: SUCCESS (5.433s) [271.190126] Subtest torture-move: SUCCESS (27.188s) [271.246343] [063/143] (729s left) gem_userptr_blits (map-fixed-invalidate) [271.343361] Starting subtest: map-fixed-invalidate [271.346091] Subtest map-fixed-invalidate: SKIP (0.000s) [271.484197] [064/143] (729s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-pwrite) [271.641962] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-pwrite [271.643698] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-pwrite: SKIP (0.000s) [271.714915] [065/143] (728s left) kms_sequence (get-forked) [271.848701] Starting subtest: get-forked [271.856819] Starting dynamic subtest: pipe-A-DP-4 [274.253409] Dynamic subtest pipe-A-DP-4: SUCCESS (2.404s) [274.262128] Starting dynamic subtest: pipe-B-DP-4 [276.631434] Dynamic subtest pipe-B-DP-4: SUCCESS (2.376s) [276.637593] Starting dynamic subtest: pipe-C-DP-4 [279.000032] Dynamic subtest pipe-C-DP-4: SUCCESS (2.368s) [279.006276] Starting dynamic subtest: pipe-D-DP-4 [281.345610] Dynamic subtest pipe-D-DP-4: SUCCESS (2.343s) [281.346719] Subtest get-forked: SUCCESS (9.496s) [281.564465] [066/143] (719s left) syncobj_timeline (wait-any-snapshot) [281.654841] Starting subtest: wait-any-snapshot [281.736169] Subtest wait-any-snapshot: SUCCESS (0.082s) [281.829846] [067/143] (718s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180) [281.982393] Starting subtest: linear-max-hw-stride-64bpp-rotate-180 [283.202762] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.220s) [283.346928] [068/143] (717s left) gem_exec_whisper (basic-fds-forked) [283.405302] Starting subtest: basic-fds-forked [306.280012] Subtest basic-fds-forked: SUCCESS (22.873s) [306.474425] [069/143] (694s left) kms_ccs (pipe-c-missing-ccs-buffer-4-tiled-mtl-mc-ccs) [306.758565] Starting subtest: pipe-C-missing-ccs-buffer-4-tiled-mtl-mc-ccs [306.760375] Subtest pipe-C-missing-ccs-buffer-4-tiled-mtl-mc-ccs: SKIP (0.000s) [306.943371] [070/143] (693s left) gem_workarounds (basic-read) [307.056710] Starting subtest: basic-read [307.087385] Subtest basic-read: SUCCESS (0.031s) [307.189488] [071/143] (693s left) kms_vblank (query-forked-hang) [307.312911] Starting subtest: query-forked-hang [307.315117] Starting dynamic subtest: pipe-A-DP-4 [321.052908] Dynamic subtest pipe-A-DP-4: SUCCESS (13.738s) [321.060377] Starting dynamic subtest: pipe-D-DP-4 [346.061638] Dynamic subtest pipe-D-DP-4: SUCCESS (25.006s) [346.062585] Subtest query-forked-hang: SUCCESS (38.749s) [346.262731] [072/143] (654s left) kms_flip (dpms-off-confusion-interruptible) [346.425086] Starting subtest: dpms-off-confusion-interruptible [346.431329] Starting dynamic subtest: A-DP4 [354.231488] Dynamic subtest A-DP4: SUCCESS (7.800s) [354.240454] Starting dynamic subtest: B-DP4 [361.964473] Dynamic subtest B-DP4: SUCCESS (7.732s) [361.971553] Starting dynamic subtest: C-DP4 [369.694669] Dynamic subtest C-DP4: SUCCESS (7.729s) [369.701495] Starting dynamic subtest: D-DP4 [377.428929] Dynamic subtest D-DP4: SUCCESS (7.733s) [377.429978] Subtest dpms-off-confusion-interruptible: SUCCESS (31.005s) [377.706832] [073/143] (623s left) kms_big_fb (y-tiled-16bpp-rotate-180) [377.868916] Starting subtest: y-tiled-16bpp-rotate-180 [377.870666] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s) [377.959455] [074/143] (622s left) gem_exec_schedule (preempt-other-chain) [378.057549] Starting subtest: preempt-other-chain [378.058598] Starting dynamic subtest: rcs0 [379.402252] Dynamic subtest rcs0: SUCCESS (1.344s) [379.408514] Starting dynamic subtest: bcs0 [380.711457] Dynamic subtest bcs0: SUCCESS (1.309s) [380.717828] Starting dynamic subtest: vcs0 [382.801430] Dynamic subtest vcs0: SUCCESS (2.089s) [382.808363] Starting dynamic subtest: vcs1 [384.125674] Dynamic subtest vcs1: SUCCESS (1.324s) [384.131784] Starting dynamic subtest: vecs0 [386.672989] Dynamic subtest vecs0: SUCCESS (2.547s) [386.679663] Starting dynamic subtest: vecs1 [388.736439] Dynamic subtest vecs1: SUCCESS (2.063s) [388.742942] Starting dynamic subtest: ccs0 [390.066316] Dynamic subtest ccs0: SUCCESS (1.329s) [390.072638] Starting dynamic subtest: ccs1 [392.545253] Dynamic subtest ccs1: SUCCESS (2.478s) [392.552170] Starting dynamic subtest: ccs2 [394.424859] Dynamic subtest ccs2: SUCCESS (1.879s) [394.431457] Starting dynamic subtest: ccs3 [395.749456] Dynamic subtest ccs3: SUCCESS (1.324s) [395.750306] Subtest preempt-other-chain: SUCCESS (17.692s) [396.097491] [075/143] (604s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted) [396.149843] Starting subtest: etime-multi-wait-for-submit-unsubmitted [396.257545] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.107s) [396.326435] [076/143] (604s left) gem_exec_whisper (basic-normal) [396.383351] Starting subtest: basic-normal [399.543984] Subtest basic-normal: SUCCESS (3.159s) [399.720764] [077/143] (601s left) kms_pm_rpm (legacy-planes-dpms) [401.536558] Starting subtest: legacy-planes-dpms [401.538788] Starting dynamic subtest: plane-40 [404.055714] Dynamic subtest plane-40: SUCCESS (2.518s) [404.087224] Starting dynamic subtest: plane-49 [406.725131] Dynamic subtest plane-49: SUCCESS (2.667s) [406.757507] Starting dynamic subtest: plane-58 [409.350667] Dynamic subtest plane-58: SUCCESS (2.623s) [409.381562] Starting dynamic subtest: plane-67 [412.091123] Dynamic subtest plane-67: SUCCESS (2.737s) [412.093152] Subtest legacy-planes-dpms: SUCCESS (10.556s) [412.492935] [078/143] (588s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c) [412.570521] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s) [412.601549] [079/143] (588s left) v3d/v3d_submit_csd (bad-flag) [412.677940] Subtest bad-flag: SKIP (0.000s) [412.727614] [080/143] (588s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0) [412.852513] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0 [414.061523] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.208s) [414.183314] [081/143] (586s left) v3d/v3d_submit_cl (bad-multisync-out-sync) [414.244422] Subtest bad-multisync-out-sync: SKIP (0.000s) [414.298192] [082/143] (586s left) kms_ccs (pipe-a-random-ccs-data-y-tiled-gen12-mc-ccs) [414.529190] Starting subtest: pipe-A-random-ccs-data-y-tiled-gen12-mc-ccs [414.531792] Subtest pipe-A-random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.000s) [414.747701] [083/143] (586s left) kms_plane_cursor (primary) [414.883801] Starting subtest: primary [414.885698] Starting dynamic subtest: pipe-A-DP-4-size-64 [418.123817] Dynamic subtest pipe-A-DP-4-size-64: SUCCESS (3.238s) [418.181008] Starting dynamic subtest: pipe-A-DP-4-size-128 [421.406284] Dynamic subtest pipe-A-DP-4-size-128: SUCCESS (3.233s) [421.462989] Starting dynamic subtest: pipe-A-DP-4-size-256 [424.672991] Dynamic subtest pipe-A-DP-4-size-256: SUCCESS (3.216s) [424.836071] Starting dynamic subtest: pipe-B-DP-4-size-64 [428.149906] Dynamic subtest pipe-B-DP-4-size-64: SUCCESS (3.329s) [428.193730] Starting dynamic subtest: pipe-B-DP-4-size-128 [431.349872] Dynamic subtest pipe-B-DP-4-size-128: SUCCESS (3.165s) [431.389868] Starting dynamic subtest: pipe-B-DP-4-size-256 [434.633441] Dynamic subtest pipe-B-DP-4-size-256: SUCCESS (3.250s) [434.737591] Starting dynamic subtest: pipe-C-DP-4-size-64 [438.018433] Dynamic subtest pipe-C-DP-4-size-64: SUCCESS (3.290s) [438.057971] Starting dynamic subtest: pipe-C-DP-4-size-128 [441.268536] Dynamic subtest pipe-C-DP-4-size-128: SUCCESS (3.216s) [441.308142] Starting dynamic subtest: pipe-C-DP-4-size-256 [444.502193] Dynamic subtest pipe-C-DP-4-size-256: SUCCESS (3.200s) [444.604687] Starting dynamic subtest: pipe-D-DP-4-size-64 [447.935732] Dynamic subtest pipe-D-DP-4-size-64: SUCCESS (3.340s) [447.975279] Starting dynamic subtest: pipe-D-DP-4-size-128 [451.169134] Dynamic subtest pipe-D-DP-4-size-128: SUCCESS (3.200s) [451.213616] Starting dynamic subtest: pipe-D-DP-4-size-256 [454.419295] Dynamic subtest pipe-D-DP-4-size-256: SUCCESS (3.215s) [454.510432] Subtest primary: SUCCESS (39.626s) [454.709373] [084/143] (546s left) kms_big_fb (yf-tiled-8bpp-rotate-90) [454.873530] Starting subtest: yf-tiled-8bpp-rotate-90 [454.875532] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s) [454.957977] [085/143] (546s left) kms_chamelium_hpd (vga-hpd-fast) [455.195728] Subtest vga-hpd-fast: SKIP (0.000s) [455.312756] [086/143] (545s left) gem_pipe_control_store_loop (reused-buffer) [455.388117] Starting subtest: reused-buffer [457.563978] Subtest reused-buffer: SUCCESS (2.176s) [457.683289] [087/143] (543s left) kms_big_fb (4-tiled-32bpp-rotate-0) [457.804533] Starting subtest: 4-tiled-32bpp-rotate-0 [459.349112] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.544s) [459.476907] [088/143] (541s left) fbdev (eof) [459.531985] Starting subtest: eof [459.532925] Subtest eof: SUCCESS (0.000s) [459.582938] [089/143] (541s left) i915_power (sanity) [459.629502] Starting subtest: sanity [463.668873] Subtest sanity: SUCCESS (4.039s) [463.766166] [090/143] (537s left) gem_close_race (multigpu-basic-process) [463.838594] Starting subtest: multigpu-basic-process [463.840631] Subtest multigpu-basic-process: SKIP (0.000s) [464.092514] [091/143] (537s left) kms_psr2_sf (fbc-primary-plane-update-continuous-sf-dmg-area) [464.180796] Subtest fbc-primary-plane-update-continuous-sf-dmg-area: SKIP (0.000s) [464.207023] [092/143] (537s left) gem_exec_reloc (basic-active) [464.256377] Subtest basic-active: SKIP (0.000s) [464.290325] [093/143] (536s left) gem_exec_fence (basic-busy) [464.485222] Starting subtest: basic-busy [464.487039] Starting dynamic subtest: rcs0 [464.596744] Dynamic subtest rcs0: SUCCESS (0.111s) [464.606253] Starting dynamic subtest: bcs0 [464.650774] Dynamic subtest bcs0: SUCCESS (0.053s) [464.664625] Starting dynamic subtest: vcs0 [464.708887] Dynamic subtest vcs0: SUCCESS (0.056s) [464.740128] Starting dynamic subtest: vcs1 [464.770120] Dynamic subtest vcs1: SUCCESS (0.058s) [464.800097] Starting dynamic subtest: vecs0 [464.826937] Dynamic subtest vecs0: SUCCESS (0.054s) [464.843945] Starting dynamic subtest: vecs1 [464.881772] Dynamic subtest vecs1: SUCCESS (0.053s) [464.911412] Starting dynamic subtest: ccs0 [464.939513] Dynamic subtest ccs0: SUCCESS (0.055s) [464.966939] Starting dynamic subtest: ccs1 [465.003099] Dynamic subtest ccs1: SUCCESS (0.061s) [465.033041] Starting dynamic subtest: ccs2 [465.067418] Dynamic subtest ccs2: SUCCESS (0.062s) [465.093784] Starting dynamic subtest: ccs3 [465.121946] Dynamic subtest ccs3: SUCCESS (0.052s) [465.123728] Subtest basic-busy: SUCCESS (0.639s) [466.015664] [094/143] (535s left) kms_lease (lease-invalid-crtc) [466.131524] Starting subtest: lease-invalid-crtc [466.132554] Starting dynamic subtest: pipe-A-DP-4 [466.133469] Dynamic subtest pipe-A-DP-4: SUCCESS (0.000s) [466.139671] Starting dynamic subtest: pipe-B-DP-4 [466.140576] Dynamic subtest pipe-B-DP-4: SUCCESS (0.000s) [466.146512] Starting dynamic subtest: pipe-C-DP-4 [466.147473] Dynamic subtest pipe-C-DP-4: SUCCESS (0.000s) [466.153603] Starting dynamic subtest: pipe-D-DP-4 [466.154693] Dynamic subtest pipe-D-DP-4: SUCCESS (0.000s) [466.155977] Subtest lease-invalid-crtc: SUCCESS (0.005s) [466.198347] [095/143] (535s left) gem_media_fill (media-fill) [466.247069] Subtest media-fill: SKIP (0.000s) [466.307721] [096/143] (535s left) gem_ctx_exec (basic) [466.363664] Starting subtest: basic [466.365407] Subtest basic: SUCCESS (0.003s) [466.455297] [097/143] (534s left) kms_writeback (writeback-check-output) [466.647486] Subtest writeback-check-output: SKIP (0.000s) [466.673924] [098/143] (534s left) kms_prime (d3hot) [467.517322] Subtest D3hot: SKIP (0.000s) [467.601811] [099/143] (533s left) kms_chamelium_hpd (dp-hpd-fast) [467.790770] Subtest dp-hpd-fast: SKIP (0.000s) [467.903202] [100/143] (533s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu) [468.043943] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu [468.045637] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [468.125488] [101/143] (533s left) gem_sync (basic-many-each) [468.198252] Starting subtest: basic-many-each [470.586555] Subtest basic-many-each: SUCCESS (2.389s) [470.799935] [102/143] (530s left) kms_ccs (pipe-b-crc-primary-basic-y-tiled-gen12-mc-ccs) [471.056242] Starting subtest: pipe-B-crc-primary-basic-y-tiled-gen12-mc-ccs [471.058121] Subtest pipe-B-crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.000s) [471.264707] [103/143] (530s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff) [471.421443] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff [471.423235] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [471.508305] [104/143] (530s left) gem_render_copy_redux (flink) [471.599571] Starting subtest: flink [472.895966] Subtest flink: SUCCESS (1.296s) [473.091802] [105/143] (528s left) gen9_exec_parse (valid-registers) [473.140848] Subtest valid-registers: SKIP (0.000s) [473.159289] [106/143] (528s left) kms_psr (psr-primary-page-flip) [473.276502] Subtest psr-primary-page-flip: SKIP (0.000s) [473.310230] [107/143] (528s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render) [473.431199] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render [475.935755] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (2.505s) [476.074416] [108/143] (525s left) syncobj_timeline (invalid-wait-illegal-handle) [476.119305] Starting subtest: invalid-wait-illegal-handle [476.120159] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s) [476.192435] [109/143] (525s left) kms_invalid_mode (bad-hsync-end) [476.317846] Starting subtest: bad-hsync-end [476.318759] Starting dynamic subtest: pipe-A-DP-4 [476.391519] Dynamic subtest pipe-A-DP-4: SUCCESS (0.073s) [476.399337] Starting dynamic subtest: pipe-B-DP-4 [476.400196] Dynamic subtest pipe-B-DP-4: SUCCESS (0.001s) [476.406556] Starting dynamic subtest: pipe-C-DP-4 [476.407376] Dynamic subtest pipe-C-DP-4: SUCCESS (0.001s) [476.413729] Starting dynamic subtest: pipe-D-DP-4 [476.415207] Dynamic subtest pipe-D-DP-4: SUCCESS (0.001s) [476.416005] Subtest bad-hsync-end: SUCCESS (0.080s) [476.585201] [110/143] (525s left) gem_mmap_wc (copy) [476.670174] Subtest copy: SKIP (0.000s) [476.694082] [111/143] (524s left) kms_big_fb (y-tiled-8bpp-rotate-180) [476.815074] Starting subtest: y-tiled-8bpp-rotate-180 [476.816964] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s) [476.886586] [112/143] (524s left) gem_mmap_gtt (fault-concurrent-y) [476.939553] Subtest fault-concurrent-Y: SKIP (0.000s) [476.960863] [113/143] (524s left) gem_ctx_exec (basic-close-race) [477.008427] Starting subtest: basic-close-race [482.592241] Subtest basic-close-race: SUCCESS (5.582s) [482.729626] [114/143] (518s left) prime_self_import (basic-with_two_bos) [482.806373] Starting subtest: basic-with_two_bos [482.808263] Subtest basic-with_two_bos: SUCCESS (0.003s) [482.890223] [115/143] (518s left) gem_exec_reloc (basic-gtt-wc-noreloc) [482.943814] Subtest basic-gtt-wc-noreloc: SKIP (0.000s) [482.996677] [116/143] (518s left) kms_addfb_basic (tile-pitch-mismatch) [483.063667] Starting subtest: tile-pitch-mismatch [483.065498] Subtest tile-pitch-mismatch: SKIP (0.000s) [483.204055] [117/143] (518s left) gem_exec_params (invalid-fence-in) [483.264031] Starting subtest: invalid-fence-in [483.265224] Subtest invalid-fence-in: SUCCESS (0.000s) [483.346193] [118/143] (518s left) sw_sync (sync_merge_invalid) [483.423770] Starting subtest: sync_merge_invalid [483.425589] Subtest sync_merge_invalid: SUCCESS (0.003s) [483.444626] [119/143] (518s left) kms_psr (psr2-cursor-render) [483.562131] Subtest psr2-cursor-render: SKIP (0.000s) [483.594492] [120/143] (518s left) syncobj_basic (bad-create-flags) [483.639044] Starting subtest: bad-create-flags [483.639917] Subtest bad-create-flags: SUCCESS (0.000s) [483.706881] [121/143] (518s left) sw_sync (alloc_merge_fence) [483.774363] Starting subtest: alloc_merge_fence [483.775348] Subtest alloc_merge_fence: SUCCESS (0.000s) [483.826913] [122/143] (518s left) kms_chamelium_color (ctm-red-to-blue) [483.954237] Subtest ctm-red-to-blue: SKIP (0.000s) [483.977013] [123/143] (517s left) gem_render_copy (yf-tiled-to-vebox-y-tiled) [484.025544] Starting subtest: yf-tiled-to-vebox-y-tiled [484.027244] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s) [484.245593] [124/143] (517s left) i915_query (query-garbage) [484.302384] Starting subtest: query-garbage [484.303234] Subtest query-garbage: SUCCESS (0.000s) [484.368820] [125/143] (517s left) kms_ccs (pipe-d-crc-primary-basic-4-tiled-mtl-mc-ccs) [484.619513] Starting subtest: pipe-D-crc-primary-basic-4-tiled-mtl-mc-ccs [484.621423] Subtest pipe-D-crc-primary-basic-4-tiled-mtl-mc-ccs: SKIP (0.000s) [484.796203] [126/143] (517s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render) [484.951087] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render [484.952721] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [485.033997] [127/143] (516s left) kms_ccs (pipe-d-random-ccs-data-4-tiled-dg2-rc-ccs) [485.299736] Starting subtest: pipe-D-random-ccs-data-4-tiled-dg2-rc-ccs [485.472200] Subtest pipe-D-random-ccs-data-4-tiled-dg2-rc-ccs: SUCCESS (0.170s) [485.748697] [128/143] (516s left) vgem_basic (sysfs) [485.826628] Starting subtest: sysfs [485.827642] Subtest sysfs: SUCCESS (0.000s) [485.878657] [129/143] (516s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling) [485.995920] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling [485.996904] Starting dynamic subtest: pipe-A-valid-mode [486.067669] Dynamic subtest pipe-A-valid-mode: SKIP (0.069s) [486.069462] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.070s) [486.230315] [130/143] (515s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt) [486.393894] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt [486.395506] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s) [486.479219] [131/143] (515s left) kms_rotation_crc (sprite-rotation-90-pos-100-0) [486.620972] Starting subtest: sprite-rotation-90-pos-100-0 [486.622990] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s) [486.674236] [132/143] (515s left) kms_big_fb (x-tiled-addfb-size-offset-overflow) [486.795971] Starting subtest: x-tiled-addfb-size-offset-overflow [486.796847] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.001s) [486.879352] [133/143] (515s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move) [487.028494] Starting subtest: fbc-2p-scndscrn-spr-indfb-move [487.030365] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [487.112990] [134/143] (515s left) kms_busy (extended-modeset-hang-oldfb-with-reset) [487.254323] Starting subtest: extended-modeset-hang-oldfb-with-reset [487.255916] Starting dynamic subtest: pipe-A [489.023359] Dynamic subtest pipe-A: SUCCESS (1.767s) [489.035516] Starting dynamic subtest: pipe-D [490.757547] Dynamic subtest pipe-D: SUCCESS (1.729s) [490.758867] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (3.503s) [490.994620] [135/143] (511s left) syncobj_timeline (etime-single-wait-available-unsubmitted) [491.081052] Starting subtest: etime-single-wait-available-unsubmitted [491.184825] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.104s) [491.273581] [136/143] (510s left) gem_wait (busy) [491.327369] Starting subtest: busy [491.328261] Starting dynamic subtest: all-engines [491.896253] Dynamic subtest all-engines: SUCCESS (0.569s) [491.903217] Starting dynamic subtest: rcs0 [492.435493] Dynamic subtest rcs0: SUCCESS (0.538s) [492.442584] Starting dynamic subtest: bcs0 [492.974694] Dynamic subtest bcs0: SUCCESS (0.538s) [492.981861] Starting dynamic subtest: vcs0 [493.513230] Dynamic subtest vcs0: SUCCESS (0.538s) [493.520331] Starting dynamic subtest: vcs1 [494.051504] Dynamic subtest vcs1: SUCCESS (0.538s) [494.058662] Starting dynamic subtest: vecs0 [494.590319] Dynamic subtest vecs0: SUCCESS (0.538s) [494.597451] Starting dynamic subtest: vecs1 [495.129233] Dynamic subtest vecs1: SUCCESS (0.538s) [495.136360] Starting dynamic subtest: ccs0 [495.669389] Dynamic subtest ccs0: SUCCESS (0.539s) [495.676439] Starting dynamic subtest: ccs1 [496.209386] Dynamic subtest ccs1: SUCCESS (0.539s) [496.216475] Starting dynamic subtest: ccs2 [496.747483] Dynamic subtest ccs2: SUCCESS (0.537s) [496.754539] Starting dynamic subtest: ccs3 [497.285472] Dynamic subtest ccs3: SUCCESS (0.537s) [497.286405] Subtest busy: SUCCESS (5.958s) [497.520084] [137/143] (504s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt) [497.639976] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt [497.641503] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [497.725248] [138/143] (504s left) gem_exec_balancer (full-late) [497.796888] Starting subtest: full-late [498.981211] Subtest full-late: SUCCESS (1.184s) [499.269928] [139/143] (502s left) kms_cursor_crc (cursor-offscreen-32x32) [499.432760] Starting subtest: cursor-offscreen-32x32 [499.473707] Subtest cursor-offscreen-32x32: SKIP (0.039s) [499.777358] [140/143] (502s left) kms_ccs (pipe-a-crc-primary-rotation-180-4-tiled-mtl-rc-ccs) [499.983494] Starting subtest: pipe-A-crc-primary-rotation-180-4-tiled-mtl-rc-ccs [499.985247] Subtest pipe-A-crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SKIP (0.000s) [500.235784] [141/143] (502s left) kms_ccs (pipe-c-bad-pixel-format-y-tiled-gen12-rc-ccs-cc) [500.513803] Starting subtest: pipe-C-bad-pixel-format-y-tiled-gen12-rc-ccs-cc [500.515474] Subtest pipe-C-bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s) [500.721655] [142/143] (501s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt) [500.878051] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt [500.880025] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [500.949024] [143/143] (501s left) perf_pmu (init-busy) [501.005097] Starting subtest: init-busy [501.005995] Starting dynamic subtest: rcs0 [501.006946] Dynamic subtest rcs0: SUCCESS (0.001s) [501.014854] Starting dynamic subtest: bcs0 [501.015767] Dynamic subtest bcs0: SUCCESS (0.000s) [501.023137] Starting dynamic subtest: vcs0 [501.024231] Dynamic subtest vcs0: SUCCESS (0.001s) [501.031809] Starting dynamic subtest: vcs1 [501.032735] Dynamic subtest vcs1: SUCCESS (0.000s) [501.040071] Starting dynamic subtest: vecs0 [501.040869] Dynamic subtest vecs0: SUCCESS (0.000s) [501.048659] Starting dynamic subtest: vecs1 [501.049937] Dynamic subtest vecs1: SUCCESS (0.000s) [501.057579] Starting dynamic subtest: ccs0 [501.058919] Dynamic subtest ccs0: SUCCESS (0.000s) [501.066430] Starting dynamic subtest: ccs1 [501.067232] Dynamic subtest ccs1: SUCCESS (0.000s) [501.074847] Starting dynamic subtest: ccs2 [501.076121] Dynamic subtest ccs2: SUCCESS (0.000s) [501.086877] Starting dynamic subtest: ccs3 [501.087924] Dynamic subtest ccs3: SUCCESS (0.000s) [501.088727] Subtest init-busy: SUCCESS (0.010s) [501.099864] Closing watchdogs Done.