[43.310235] Initializing watchdogs [43.310481] /dev/watchdog0 [43.327576] [001/142] (960s left) gem_workarounds (suspend-resume) [43.609438] Starting subtest: suspend-resume [60.238189] Subtest suspend-resume: SUCCESS (1.656s) [66.371471] [002/142] (958s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu) [66.698759] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu [66.701408] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [66.793748] [003/142] (958s left) kms_vblank (pipe-b-wait-forked) [67.095523] Starting subtest: pipe-B-wait-forked [69.901725] Subtest pipe-B-wait-forked: SUCCESS (2.806s) [70.256715] [004/142] (954s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt) [70.576132] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt [72.651998] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SUCCESS (2.079s) [72.789887] [005/142] (952s left) gem_pwrite_snooped [73.139491] [006/142] (951s left) perf_pmu (init-sema) [73.353441] Starting subtest: init-sema [73.355085] Starting dynamic subtest: rcs0 [73.358400] Dynamic subtest rcs0: SUCCESS (0.005s) [73.376822] Starting dynamic subtest: bcs0 [73.378179] Dynamic subtest bcs0: SUCCESS (0.001s) [73.394784] Starting dynamic subtest: vcs0 [73.396180] Dynamic subtest vcs0: SUCCESS (0.001s) [73.414496] Starting dynamic subtest: vecs0 [73.416180] Dynamic subtest vecs0: SUCCESS (0.002s) [73.418030] Subtest init-sema: SUCCESS (0.011s) [73.474928] [007/142] (951s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy) [73.785488] Starting subtest: fbcpsr-modesetfrombusy [73.788078] Subtest fbcpsr-modesetfrombusy: SKIP (0.000s) [73.890255] [008/142] (951s left) kms_cursor_legacy (single-bo) [74.200069] Starting subtest: single-bo [74.201475] Starting dynamic subtest: pipe-A [79.605766] Dynamic subtest pipe-A: SUCCESS (5.407s) [79.622955] Starting dynamic subtest: pipe-B [85.012216] Dynamic subtest pipe-B: SUCCESS (5.406s) [85.029217] Starting dynamic subtest: pipe-C [90.419259] Dynamic subtest pipe-C: SUCCESS (5.406s) [90.437376] Starting dynamic subtest: all-pipes [95.830035] Dynamic subtest all-pipes: SUCCESS (5.410s) [95.831883] Subtest single-bo: SUCCESS (21.632s) [95.925398] [009/142] (929s left) gem_exec_flush (basic-wb-ro-default) [96.154770] Starting subtest: basic-wb-ro-default [101.625119] Subtest basic-wb-ro-default: SUCCESS (5.470s) [101.824321] [010/142] (923s left) kms_psr (primary_mmap_cpu) [102.026014] Subtest primary_mmap_cpu: SKIP (0.000s) [102.072613] [011/142] (923s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling) [102.367900] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling [102.369145] Starting dynamic subtest: pipe-A-valid-mode [102.506584] Dynamic subtest pipe-A-valid-mode: SKIP (0.136s) [102.509554] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.139s) [102.841209] [012/142] (922s left) kms_ccs (pipe-b-bad-rotation-90-y_tiled_gen12_rc_ccs_cc) [103.323258] Starting subtest: pipe-B-bad-rotation-90-y_tiled_gen12_rc_ccs_cc [103.325834] Subtest pipe-B-bad-rotation-90-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s) [103.825717] [013/142] (921s left) api_intel_allocator (execbuf-with-allocator) [104.029626] Starting subtest: execbuf-with-allocator [104.040659] Subtest execbuf-with-allocator: SUCCESS (0.011s) [104.142188] [014/142] (921s left) fbdev (unaligned-read) [104.354767] Starting subtest: unaligned-read [104.367123] Subtest unaligned-read: SUCCESS (0.012s) [104.442256] [015/142] (920s left) kms_plane (plane-position-hole-dpms) [104.744716] Starting subtest: plane-position-hole-dpms [104.746014] Starting dynamic subtest: pipe-A-planes [106.872478] Dynamic subtest pipe-A-planes: SUCCESS (2.130s) [106.891721] Starting dynamic subtest: pipe-B-planes [109.294783] Dynamic subtest pipe-B-planes: SUCCESS (2.419s) [109.296304] Subtest plane-position-hole-dpms: SUCCESS (4.555s) [109.620928] [016/142] (915s left) kms_chamelium_audio (dp-audio) [110.014372] Subtest dp-audio: SKIP (0.000s) [110.292667] [017/142] (915s left) syncobj_timeline (invalid-multi-wait-available-unsubmitted) [110.496950] Starting subtest: invalid-multi-wait-available-unsubmitted [110.498677] Subtest invalid-multi-wait-available-unsubmitted: SUCCESS (0.000s) [110.588177] [018/142] (914s left) gem_exec_fence (syncobj-timeline-unused-fence) [111.482237] Starting subtest: syncobj-timeline-unused-fence [111.489225] Subtest syncobj-timeline-unused-fence: SUCCESS (0.007s) [111.723751] [019/142] (913s left) kms_ccs (pipe-d-bad-pixel-format-y_tiled_ccs) [112.390700] Subtest pipe-D-bad-pixel-format-y_tiled_ccs: SKIP (0.000s) [112.693047] [020/142] (912s left) gem_mmap (pf-nonblock) [112.898230] Starting subtest: pf-nonblock [112.903589] Subtest pf-nonblock: SUCCESS (0.007s) [113.010247] [021/142] (912s left) gem_partial_pwrite_pread (reads-display) [113.220055] Starting subtest: reads-display [119.816068] Subtest reads-display: SUCCESS (6.596s) [119.927039] [022/142] (905s left) i915_fb_tiling [120.227073] [023/142] (905s left) kms_ccs (pipe-b-bad-pixel-format-4_tiled_mtl_mc_ccs) [120.697463] Starting subtest: pipe-B-bad-pixel-format-4_tiled_mtl_mc_ccs [120.700668] Subtest pipe-B-bad-pixel-format-4_tiled_mtl_mc_ccs: SKIP (0.000s) [121.211768] [024/142] (904s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible) [121.507846] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible [121.512385] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.003s) [121.612892] [025/142] (904s left) kms_scaling_modes (scaling-mode-full) [121.917920] Starting subtest: scaling-mode-full [121.920399] Subtest scaling-mode-full: SKIP (0.001s) [121.995591] [026/142] (903s left) kms_big_fb (4-tiled-8bpp-rotate-270) [122.325005] Starting subtest: 4-tiled-8bpp-rotate-270 [122.327844] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.000s) [122.428216] [027/142] (903s left) kms_big_fb (yf-tiled-16bpp-rotate-180) [122.749119] Starting subtest: yf-tiled-16bpp-rotate-180 [126.870983] Subtest yf-tiled-16bpp-rotate-180: SUCCESS (4.122s) [127.214493] [028/142] (898s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling) [127.514969] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling [127.516491] Starting dynamic subtest: pipe-A-valid-mode [127.909905] Dynamic subtest pipe-A-valid-mode: SKIP (0.394s) [127.912779] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SKIP (0.397s) [128.280405] [029/142] (897s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move) [128.601462] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move [128.604140] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [128.696060] [030/142] (897s left) i915_pm_dc (dc5-psr) [130.010944] Starting subtest: dc5-psr [130.015138] Subtest dc5-psr: SKIP (0.000s) [130.179465] [031/142] (895s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted) [130.382187] Starting subtest: etime-multi-wait-all-for-submit-submitted [130.486677] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.104s) [130.580520] [032/142] (895s left) kms_ccs (pipe-b-random-ccs-data-4_tiled_mtl_rc_ccs) [131.101304] Starting subtest: pipe-B-random-ccs-data-4_tiled_mtl_rc_ccs [131.105769] Subtest pipe-B-random-ccs-data-4_tiled_mtl_rc_ccs: SKIP (0.000s) [131.573044] [033/142] (894s left) kms_ccs (pipe-c-bad-pixel-format-yf_tiled_ccs) [132.139264] Starting subtest: pipe-C-bad-pixel-format-yf_tiled_ccs [132.142212] Subtest pipe-C-bad-pixel-format-yf_tiled_ccs: SKIP (0.000s) [132.561047] [034/142] (893s left) kms_cursor_crc (cursor-rapid-movement-128x128) [132.869439] Starting subtest: cursor-rapid-movement-128x128 [132.882527] Starting dynamic subtest: pipe-A-DP-1 [133.384581] Dynamic subtest pipe-A-DP-1: SUCCESS (0.503s) [133.471079] Starting dynamic subtest: pipe-C-DP-1 [134.293642] Dynamic subtest pipe-C-DP-1: SUCCESS (0.839s) [134.295047] Subtest cursor-rapid-movement-128x128: SUCCESS (1.423s) [134.645706] [035/142] (891s left) v3d/v3d_submit_csd (bad-multisync-in-sync) [134.901006] Subtest bad-multisync-in-sync: SKIP (0.000s) [134.973542] [036/142] (891s left) gem_ctx_isolation (preservation) [135.196837] Starting subtest: preservation [135.200503] Starting dynamic subtest: rcs0 [136.379978] Dynamic subtest rcs0: SUCCESS (1.179s) [136.400002] Starting dynamic subtest: bcs0 [137.845112] Dynamic subtest bcs0: SUCCESS (1.464s) [137.869265] Starting dynamic subtest: vcs0 [138.921017] Dynamic subtest vcs0: SUCCESS (1.075s) [138.940850] Starting dynamic subtest: vecs0 [139.991237] Dynamic subtest vecs0: SUCCESS (1.069s) [139.992714] Subtest preservation: SUCCESS (4.793s) [140.224194] [037/142] (885s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [140.524622] Starting subtest: nonblocking-crc-frame-sequence [140.526128] Starting dynamic subtest: pipe-A-DP-1 [141.116143] Dynamic subtest pipe-A-DP-1: SUCCESS (0.591s) [141.137646] Starting dynamic subtest: pipe-B-DP-1 [142.006636] Dynamic subtest pipe-B-DP-1: SUCCESS (0.887s) [142.030387] Starting dynamic subtest: pipe-C-DP-1 [143.023685] Dynamic subtest pipe-C-DP-1: SUCCESS (1.014s) [143.024959] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.503s) [143.345349] [038/142] (882s left) kms_flip (2x-flip-vs-panning) [143.646714] Starting subtest: 2x-flip-vs-panning [143.649993] Subtest 2x-flip-vs-panning: SKIP (0.003s) [143.764405] [039/142] (882s left) kms_big_fb (y-tiled-16bpp-rotate-180) [144.106133] Starting subtest: y-tiled-16bpp-rotate-180 [147.769769] Subtest y-tiled-16bpp-rotate-180: SUCCESS (3.664s) [148.097126] [040/142] (878s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt) [148.422464] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt [150.554290] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SUCCESS (2.135s) [150.694282] [041/142] (875s left) v3d/v3d_submit_cl (bad-extension) [150.956445] Subtest bad-extension: SKIP (0.000s) [151.028051] [042/142] (875s left) kms_ccs (pipe-a-crc-primary-basic-4_tiled_mtl_rc_ccs) [151.435016] Starting subtest: pipe-A-crc-primary-basic-4_tiled_mtl_rc_ccs [151.437721] Subtest pipe-A-crc-primary-basic-4_tiled_mtl_rc_ccs: SKIP (0.001s) [152.011535] [043/142] (874s left) gen7_exec_parse (batch-without-end) [152.224894] Subtest batch-without-end: SKIP (0.000s) [152.274153] [044/142] (874s left) kms_chamelium_hpd (dp-hpd-for-each-pipe) [152.668681] Subtest dp-hpd-for-each-pipe: SKIP (0.000s) [152.943233] [045/142] (873s left) gem_ctx_persistence (engines-queued) [153.156187] Starting subtest: engines-queued [153.157650] Starting dynamic subtest: rcs0 [153.216593] Dynamic subtest rcs0: SUCCESS (0.060s) [153.244033] Starting dynamic subtest: bcs0 [153.368697] Dynamic subtest bcs0: SUCCESS (0.151s) [153.390219] Starting dynamic subtest: vcs0 [153.423509] Dynamic subtest vcs0: SUCCESS (0.054s) [153.445262] Starting dynamic subtest: vecs0 [153.487441] Dynamic subtest vecs0: SUCCESS (0.062s) [153.488863] Subtest engines-queued: SUCCESS (0.332s) [153.588108] [046/142] (872s left) gem_mmap_gtt (cpuset-basic-small-copy-odd) [153.791253] Starting subtest: cpuset-basic-small-copy-odd [160.883138] Subtest cpuset-basic-small-copy-odd: SUCCESS (7.092s) [160.994090] [047/142] (865s left) gem_exec_fair (basic-throttle) [161.364117] Starting subtest: basic-throttle [161.365438] Starting dynamic subtest: rcs0 [166.488182] Dynamic subtest rcs0: SUCCESS (5.124s) [166.489628] Subtest basic-throttle: SUCCESS (5.126s) [166.689195] [048/142] (859s left) kms_flip (basic-flip-vs-dpms) [166.987452] Starting subtest: basic-flip-vs-dpms [166.989052] Starting dynamic subtest: A-DP1 [168.519633] Dynamic subtest A-DP1: SUCCESS (1.529s) [168.541223] Starting dynamic subtest: B-DP1 [169.682544] Dynamic subtest B-DP1: SUCCESS (1.164s) [169.706177] Starting dynamic subtest: C-DP1 [170.817978] Dynamic subtest C-DP1: SUCCESS (1.128s) [170.819273] Subtest basic-flip-vs-dpms: SUCCESS (3.832s) [171.200118] [049/142] (855s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs) [171.426075] Starting subtest: y-tiled-ccs-to-y-tiled-ccs [171.427760] Starting dynamic subtest: smem [171.742169] Dynamic subtest smem: SUCCESS (0.313s) [171.743682] Subtest y-tiled-ccs-to-y-tiled-ccs: SUCCESS (0.315s) [171.949437] [050/142] (854s left) kms_cursor_legacy (cursora-vs-flipa-toggle) [172.257196] Starting subtest: cursorA-vs-flipA-toggle [183.303579] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.048s) [183.641382] [051/142] (843s left) gem_fence_thrash (bo-write-verify-y) [183.845070] Starting subtest: bo-write-verify-y [185.089747] Subtest bo-write-verify-y: SUCCESS (1.246s) [185.187430] [052/142] (841s left) kms_ccs (pipe-d-missing-ccs-buffer-4_tiled_mtl_rc_ccs) [185.850737] Subtest pipe-D-missing-ccs-buffer-4_tiled_mtl_rc_ccs: SKIP (0.000s) [186.171559] [053/142] (840s left) i915_suspend (sysfs-reader) [186.375415] Starting subtest: sysfs-reader [206.511576] Subtest sysfs-reader: SUCCESS (3.854s) [211.194337] [054/142] (836s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing) [211.499735] Starting subtest: plane-all-transition-nonblocking-fencing [211.501118] Starting dynamic subtest: pipe-A-DP-1 [215.515763] Dynamic subtest pipe-A-DP-1: SUCCESS (4.016s) [215.638267] Starting dynamic subtest: pipe-B-DP-1 [220.069814] Dynamic subtest pipe-B-DP-1: SUCCESS (4.452s) [220.172635] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (8.674s) [220.527205] [055/142] (827s left) gem_create (create-clear) [220.736042] Starting subtest: create-clear [220.737505] Starting dynamic subtest: smem0 [254.253621] Dynamic subtest smem0: SUCCESS (33.510s) [254.255053] Subtest create-clear: SUCCESS (33.513s) [256.823790] [056/142] (791s left) gem_exec_whisper (basic-queues-priority) [257.054257] Starting subtest: basic-queues-priority [270.690334] Subtest basic-queues-priority: SUCCESS (13.635s) [270.907046] [057/142] (777s left) gem_mmap_gtt (basic-write-cpu-read-gtt) [271.111151] Starting subtest: basic-write-cpu-read-gtt [271.114334] Subtest basic-write-cpu-read-gtt: SKIP (0.000s) [271.207585] [058/142] (776s left) kms_ccs (pipe-a-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc) [271.654045] Starting subtest: pipe-A-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc [271.657326] Subtest pipe-A-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s) [272.215711] [059/142] (775s left) kms_content_protection (content_type_change) [272.562787] Starting subtest: content_type_change [273.272458] Subtest content_type_change: SKIP (0.706s) [273.696277] [060/142] (774s left) kms_color (ctm-0-25) [274.001173] Starting subtest: ctm-0-25 [274.002661] Starting dynamic subtest: pipe-A [275.882981] Dynamic subtest pipe-A: SUCCESS (1.881s) [275.914955] Starting dynamic subtest: pipe-B [278.047308] Dynamic subtest pipe-B: SUCCESS (2.152s) [278.102304] Starting dynamic subtest: pipe-C [280.302766] Dynamic subtest pipe-C: SUCCESS (2.263s) [280.305007] Subtest ctm-0-25: SUCCESS (6.304s) [280.635225] [061/142] (767s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render) [280.949552] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render [280.952230] Subtest psr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [281.067917] [062/142] (767s left) drm_fdinfo (all-busy-idle-check-all) [281.278056] Starting subtest: all-busy-idle-check-all [281.910470] Subtest all-busy-idle-check-all: SUCCESS (0.631s) [282.000339] [063/142] (766s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen) [282.318431] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen [282.321570] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [282.435917] [064/142] (765s left) perf (invalid-open-flags) [282.778888] Starting subtest: invalid-open-flags [282.780472] Subtest invalid-open-flags: SUCCESS (0.001s) [282.833612] [065/142] (765s left) perf_pmu (all-busy-check-all) [283.045108] Starting subtest: all-busy-check-all [283.575359] Subtest all-busy-check-all: SUCCESS (0.530s) [283.667701] [066/142] (764s left) perf (invalid-oa-exponent) [283.974977] Starting subtest: invalid-oa-exponent [284.052490] Subtest invalid-oa-exponent: SUCCESS (0.076s) [284.119916] [067/142] (764s left) drm_read (empty-nonblock) [284.542225] Starting subtest: empty-nonblock [284.543750] Subtest empty-nonblock: SUCCESS (0.000s) [284.669939] [068/142] (763s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu) [284.982186] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu [284.984734] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [285.084365] [069/142] (763s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [285.408146] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip [285.411224] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s) [285.517516] [070/142] (763s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions) [285.817023] Starting subtest: flip-vs-cursor-atomic-transitions [297.183261] Subtest flip-vs-cursor-atomic-transitions: FAIL (11.036s) [297.218986] [071/142] (751s left) kms_cursor_crc (cursor-offscreen-max-size) [297.548270] Starting subtest: cursor-offscreen-max-size [297.552723] Subtest cursor-offscreen-max-size: SKIP (0.000s) [297.668156] [072/142] (750s left) kms_flip (flip-vs-fences-interruptible) [297.973087] Starting subtest: flip-vs-fences-interruptible [297.978573] Starting dynamic subtest: A-DP1 [308.648255] Dynamic subtest A-DP1: SUCCESS (10.670s) [308.684574] Starting dynamic subtest: B-DP1 [319.462974] Dynamic subtest B-DP1: SUCCESS (10.799s) [319.508365] Starting dynamic subtest: C-DP1 [330.529893] Dynamic subtest C-DP1: SUCCESS (11.063s) [330.534693] Subtest flip-vs-fences-interruptible: SUCCESS (32.559s) [330.952460] [073/142] (717s left) gem_exec_schedule (implicit-read-write) [331.199639] Starting subtest: implicit-read-write [331.202271] Starting dynamic subtest: rcs0 [331.347647] Dynamic subtest rcs0: SUCCESS (0.145s) [331.376118] Starting dynamic subtest: bcs0 [331.501599] Dynamic subtest bcs0: SUCCESS (0.150s) [331.535703] Starting dynamic subtest: vcs0 [331.642266] Dynamic subtest vcs0: SUCCESS (0.136s) [331.670840] Starting dynamic subtest: vecs0 [331.778731] Dynamic subtest vecs0: SUCCESS (0.132s) [331.780618] Subtest implicit-read-write: SUCCESS (0.581s) [332.151961] [074/142] (716s left) i915_pm_rpm (pc8-residency) [333.951978] Starting subtest: pc8-residency [333.957727] Subtest pc8-residency: SKIP (0.000s) [334.461080] [075/142] (714s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs) [334.680060] Starting subtest: mixed-tiled-to-y-tiled-ccs [334.684586] Starting dynamic subtest: smem [334.985593] Dynamic subtest smem: SUCCESS (0.303s) [334.987851] Subtest mixed-tiled-to-y-tiled-ccs: SUCCESS (0.306s) [335.193209] [076/142] (713s left) syncobj_timeline (multi-wait-all-available-signaled) [335.397284] Starting subtest: multi-wait-all-available-signaled [335.401981] Subtest multi-wait-all-available-signaled: SUCCESS (0.002s) [335.491749] [077/142] (713s left) gem_exec_schedule (u-semaphore-resolve) [335.725468] Starting subtest: u-semaphore-resolve [335.782831] Subtest u-semaphore-resolve: SUCCESS (0.057s) [336.142614] [078/142] (712s left) kms_ccs (pipe-c-crc-primary-rotation-180-y_tiled_ccs) [336.753846] Starting subtest: pipe-C-crc-primary-rotation-180-y_tiled_ccs [336.756842] Subtest pipe-C-crc-primary-rotation-180-y_tiled_ccs: SKIP (0.001s) [337.152781] [079/142] (711s left) vc4/vc4_purgeable_bo (mark-purgeable) [337.406725] Subtest mark-purgeable: SKIP (0.000s) [337.485498] [080/142] (711s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted) [337.689232] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted [337.691324] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.001s) [337.786269] [081/142] (711s left) kms_tiled_display (basic-test-pattern-with-chamelium) [338.171179] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s) [338.234571] [082/142] (710s left) kms_ccs (pipe-d-bad-aux-stride-4_tiled_mtl_rc_ccs) [338.922665] Subtest pipe-D-bad-aux-stride-4_tiled_mtl_rc_ccs: SKIP (0.000s) [339.259683] [083/142] (709s left) gem_ctx_sseu (engines) [339.468859] Subtest engines: SKIP (0.000s) [339.525093] [084/142] (709s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt) [339.835624] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt [339.838629] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [339.942458] [085/142] (709s left) vc4/vc4_wait_bo (bad-bo) [340.196695] Subtest bad-bo: SKIP (0.000s) [340.275584] [086/142] (708s left) kms_busy (extended-modeset-hang-oldfb) [340.587755] Starting subtest: extended-modeset-hang-oldfb [340.589081] Starting dynamic subtest: pipe-A [347.712694] Dynamic subtest pipe-A: SUCCESS (7.123s) [347.746038] Starting dynamic subtest: pipe-C [355.665304] Dynamic subtest pipe-C: SUCCESS (7.944s) [355.667348] Subtest extended-modeset-hang-oldfb: SUCCESS (15.081s) [356.039943] [087/142] (693s left) kms_big_fb (x-tiled-32bpp-rotate-90) [356.370776] Starting subtest: x-tiled-32bpp-rotate-90 [356.467720] Subtest x-tiled-32bpp-rotate-90: SKIP (0.092s) [356.587541] [088/142] (692s left) kms_draw_crc (draw-method-mmap-wc) [356.891228] Starting subtest: draw-method-mmap-wc [356.895567] Starting dynamic subtest: xrgb8888-untiled [357.222791] Dynamic subtest xrgb8888-untiled: SUCCESS (0.328s) [357.253097] Starting dynamic subtest: rgb565-untiled [357.504303] Dynamic subtest rgb565-untiled: SUCCESS (0.279s) [357.533276] Starting dynamic subtest: xrgb2101010-untiled [357.823997] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.314s) [357.849856] Starting dynamic subtest: xrgb8888-xtiled [358.040810] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.217s) [358.068714] Starting dynamic subtest: rgb565-xtiled [358.239378] Dynamic subtest rgb565-xtiled: SUCCESS (0.196s) [358.267966] Starting dynamic subtest: xrgb2101010-xtiled [358.455104] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.213s) [358.484067] Starting dynamic subtest: xrgb8888-ytiled [358.671032] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.213s) [358.701116] Starting dynamic subtest: rgb565-ytiled [358.876927] Dynamic subtest rgb565-ytiled: SUCCESS (0.198s) [358.901692] Starting dynamic subtest: xrgb2101010-ytiled [359.087832] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.214s) [359.089720] Subtest draw-method-mmap-wc: SUCCESS (2.198s) [359.203251] [089/142] (690s left) device_reset (unbind-reset-rebind) [359.448642] Starting subtest: unbind-reset-rebind [360.359119] Subtest unbind-reset-rebind: SUCCESS (0.905s) [360.891751] [090/142] (688s left) gem_exec_reloc (basic-write-read) [361.155089] Starting subtest: basic-write-read [361.173929] Subtest basic-write-read: SUCCESS (0.020s) [361.369340] [091/142] (688s left) gem_exec_balancer (hang) [365.470380] Starting subtest: hang [369.112672] Subtest hang: SUCCESS (3.642s) [369.218717] [092/142] (680s left) gem_bad_reloc (negative-reloc-bltcopy) [369.440778] Starting subtest: negative-reloc-bltcopy [372.838856] Subtest negative-reloc-bltcopy: SUCCESS (3.399s) [373.184646] [093/142] (676s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move) [373.502220] Starting subtest: fbc-2p-primscrn-spr-indfb-move [373.505260] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s) [373.619713] [094/142] (676s left) gem_userptr_blits (set-cache-level) [373.835290] Starting subtest: set-cache-level [373.837033] Subtest set-cache-level: SUCCESS (0.001s) [374.018523] [095/142] (675s left) gem_readwrite (read-write) [374.226606] Starting subtest: read-write [374.231790] Subtest read-write: SUCCESS (0.001s) [374.334499] [096/142] (675s left) kms_addfb_basic (addfb25-modifier-no-flag) [374.548053] Starting subtest: addfb25-modifier-no-flag [374.549472] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [374.753588] [097/142] (675s left) v3d/v3d_submit_csd (multisync-out-syncs) [375.021723] Subtest multisync-out-syncs: SKIP (0.000s) [375.101091] [098/142] (674s left) sw_sync (sync_merge) [375.310207] Starting subtest: sync_merge [375.314815] Subtest sync_merge: SUCCESS (0.001s) [375.384885] [099/142] (674s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5) [375.687838] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5 [375.689156] Starting dynamic subtest: pipe-A-DP-1 [376.015792] Dynamic subtest pipe-A-DP-1: SUCCESS (0.327s) [376.045533] Starting dynamic subtest: pipe-B-DP-1 [376.402546] Dynamic subtest pipe-B-DP-1: SUCCESS (0.382s) [376.450442] Starting dynamic subtest: pipe-C-DP-1 [376.516634] Dynamic subtest pipe-C-DP-1: SKIP (0.105s) [376.518052] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SUCCESS (0.831s) [376.943231] [100/142] (673s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-pwrite) [377.250170] Starting subtest: psr-1p-primscrn-spr-indfb-draw-pwrite [377.252931] Subtest psr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [377.359764] [101/142] (672s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [377.697663] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip [379.008701] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (1.311s) [379.360550] [102/142] (670s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-render) [379.675512] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-render [381.560746] Subtest fbc-1p-offscren-pri-shrfb-draw-render: SUCCESS (1.889s) [381.709819] [103/142] (668s left) kms_plane_cursor (primary) [382.011459] Starting subtest: primary [382.014201] Starting dynamic subtest: pipe-A-DP-1-size-64 [384.425504] Dynamic subtest pipe-A-DP-1-size-64: SUCCESS (2.413s) [384.488215] Starting dynamic subtest: pipe-A-DP-1-size-128 [386.875087] Dynamic subtest pipe-A-DP-1-size-128: SUCCESS (2.415s) [386.935062] Starting dynamic subtest: pipe-A-DP-1-size-256 [389.324803] Dynamic subtest pipe-A-DP-1-size-256: SUCCESS (2.415s) [389.471243] Starting dynamic subtest: pipe-B-DP-1-size-64 [392.094179] Dynamic subtest pipe-B-DP-1-size-64: SUCCESS (2.651s) [392.160228] Starting dynamic subtest: pipe-B-DP-1-size-128 [394.544007] Dynamic subtest pipe-B-DP-1-size-128: SUCCESS (2.415s) [394.604258] Starting dynamic subtest: pipe-B-DP-1-size-256 [396.994006] Dynamic subtest pipe-B-DP-1-size-256: SUCCESS (2.415s) [397.158353] Starting dynamic subtest: pipe-C-DP-1-size-64 [399.786663] Dynamic subtest pipe-C-DP-1-size-64: SUCCESS (2.656s) [399.846365] Starting dynamic subtest: pipe-C-DP-1-size-128 [402.236619] Dynamic subtest pipe-C-DP-1-size-128: SUCCESS (2.415s) [402.300756] Starting dynamic subtest: pipe-C-DP-1-size-256 [404.703343] Dynamic subtest pipe-C-DP-1-size-256: SUCCESS (2.432s) [404.838110] Subtest primary: SUCCESS (22.828s) [405.170915] [104/142] (644s left) gem_userptr_blits (create-destroy-sync) [405.416194] Starting subtest: create-destroy-sync [410.462447] Subtest create-destroy-sync: SUCCESS (5.044s) [410.620900] [105/142] (639s left) kms_invalid_mode (int-max-clock) [410.937211] Starting subtest: int-max-clock [410.939296] Starting dynamic subtest: DP-1-pipe-A [411.026910] Dynamic subtest DP-1-pipe-A: SUCCESS (0.092s) [411.065174] Starting dynamic subtest: DP-1-pipe-B [411.067077] Dynamic subtest DP-1-pipe-B: SUCCESS (0.015s) [411.111329] Starting dynamic subtest: DP-1-pipe-C [411.113298] Dynamic subtest DP-1-pipe-C: SUCCESS (0.014s) [411.115262] Subtest int-max-clock: SUCCESS (0.135s) [411.399021] [106/142] (638s left) syncobj_wait (reset-during-wait-for-submit) [411.607279] Starting subtest: reset-during-wait-for-submit [411.713154] Subtest reset-during-wait-for-submit: SUCCESS (0.105s) [411.816659] [107/142] (638s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite) [412.129490] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite [412.132296] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [412.249281] [108/142] (638s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move) [412.570827] Starting subtest: psr-2p-scndscrn-cur-indfb-move [412.573651] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [412.682736] [109/142] (637s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled) [412.891200] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled [412.895747] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.002s) [412.998955] [110/142] (637s left) kms_vblank (pipe-d-wait-busy-hang) [413.312487] Subtest pipe-D-wait-busy-hang: SKIP (0.000s) [413.398788] [111/142] (637s left) kms_ccs (pipe-b-crc-sprite-planes-basic-yf_tiled_ccs) [413.964419] Starting subtest: pipe-B-crc-sprite-planes-basic-yf_tiled_ccs [414.496770] Subtest pipe-B-crc-sprite-planes-basic-yf_tiled_ccs: SUCCESS (0.531s) [415.068848] [112/142] (635s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset) [415.362984] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset [415.365723] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.004s) [415.486253] [113/142] (635s left) gem_pxp (reject-modify-context-protection-off-1) [418.208418] Subtest reject-modify-context-protection-off-1: SKIP (0.000s) [418.301151] [114/142] (632s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [418.613677] Starting subtest: basic-flip-before-cursor-varying-size [419.701717] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.088s) [420.049606] [115/142] (630s left) debugfs_test (read_all_entries_display_off) [420.380515] Starting subtest: read_all_entries_display_off [420.727638] Subtest read_all_entries_display_off: SUCCESS (0.351s) [421.056267] [116/142] (629s left) kms_atomic_transition (modeset-transition-nonblocking-fencing) [421.371086] Starting subtest: modeset-transition-nonblocking-fencing [421.372730] Starting dynamic subtest: 1x-outputs [426.329261] Dynamic subtest 1x-outputs: SUCCESS (4.959s) [426.452689] Subtest modeset-transition-nonblocking-fencing: SUCCESS (5.083s) [426.810862] [117/142] (623s left) gem_exec_balancer (nohangcheck) [430.905431] Starting subtest: nohangcheck [434.723037] Subtest nohangcheck: SUCCESS (3.817s) [434.826572] [118/142] (616s left) sysfs_defaults (readonly) [435.043152] Starting subtest: readonly [435.044869] Starting dynamic subtest: vecs0 [435.046595] Dynamic subtest vecs0: SUCCESS (0.001s) [435.079513] Starting dynamic subtest: vcs0 [435.080785] Dynamic subtest vcs0: SUCCESS (0.002s) [435.107722] Starting dynamic subtest: bcs0 [435.109243] Dynamic subtest bcs0: SUCCESS (0.002s) [435.134783] Starting dynamic subtest: rcs0 [435.136191] Dynamic subtest rcs0: SUCCESS (0.001s) [435.137665] Subtest readonly: SUCCESS (0.018s) [435.176559] [119/142] (615s left) kms_hdr (invalid-hdr) [435.478179] Starting subtest: invalid-hdr [437.765409] Starting dynamic subtest: pipe-A-DP-1 [444.597703] Dynamic subtest pipe-A-DP-1: SUCCESS (6.830s) [444.599100] Subtest invalid-hdr: SUCCESS (9.120s) [444.994376] [120/142] (605s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu) [445.303872] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu [445.307409] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [445.409233] [121/142] (605s left) kms_ccs (pipe-c-crc-primary-basic-4_tiled_dg2_mc_ccs) [446.009031] Starting subtest: pipe-C-crc-primary-basic-4_tiled_dg2_mc_ccs [446.011877] Subtest pipe-C-crc-primary-basic-4_tiled_dg2_mc_ccs: SKIP (0.001s) [446.404599] [122/142] (604s left) kms_psr2_sf (overlay-primary-update-sf-dmg-area) [446.612314] Subtest overlay-primary-update-sf-dmg-area: SKIP (0.000s) [446.669698] [123/142] (604s left) perf_pmu (busy-idle) [446.879244] Starting subtest: busy-idle [446.880889] Starting dynamic subtest: rcs0 [447.521215] Dynamic subtest rcs0: SUCCESS (0.641s) [447.554495] Starting dynamic subtest: bcs0 [448.157179] Dynamic subtest bcs0: SUCCESS (0.633s) [448.188976] Starting dynamic subtest: vcs0 [448.795327] Dynamic subtest vcs0: SUCCESS (0.635s) [448.826255] Starting dynamic subtest: vecs0 [449.445280] Dynamic subtest vecs0: SUCCESS (0.647s) [449.447472] Subtest busy-idle: SUCCESS (2.568s) [449.553663] [124/142] (601s left) kms_ccs (pipe-a-bad-rotation-90-4_tiled_mtl_mc_ccs) [449.956541] Starting subtest: pipe-A-bad-rotation-90-4_tiled_mtl_mc_ccs [449.959320] Subtest pipe-A-bad-rotation-90-4_tiled_mtl_mc_ccs: SKIP (0.000s) [450.555364] [125/142] (600s left) gem_close (basic) [450.771687] Starting subtest: basic [450.773204] Subtest basic: SUCCESS (0.000s) [450.870840] [126/142] (600s left) gem_mmap_wc (fault-concurrent) [451.078595] Starting subtest: fault-concurrent [452.796267] Subtest fault-concurrent: SUCCESS (1.719s) [452.887011] [127/142] (598s left) kms_properties (plane-properties-legacy) [453.199592] Starting subtest: plane-properties-legacy [454.984655] Subtest plane-properties-legacy: SUCCESS (1.785s) [455.336375] [128/142] (595s left) gem_exec_params (rel-constants-invalid) [455.555307] Starting subtest: rel-constants-invalid [455.557172] Subtest rel-constants-invalid: SUCCESS (0.001s) [455.668292] [129/142] (595s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt) [455.980669] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt [455.983495] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [456.084796] [130/142] (595s left) kms_vblank (pipe-c-ts-continuation-dpms-rpm) [456.395111] Starting subtest: pipe-C-ts-continuation-dpms-rpm [458.764305] Subtest pipe-C-ts-continuation-dpms-rpm: SUCCESS (2.369s) [459.257526] [131/142] (592s left) kms_psr2_sf (cursor-plane-move-continuous-exceed-fully-sf) [459.465767] Subtest cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s) [459.521641] [132/142] (591s left) api_intel_bb (full-batch) [459.729350] Starting subtest: full-batch [459.734622] Subtest full-batch: SUCCESS (0.008s) [459.840749] [133/142] (591s left) gem_fence_thrash (bo-copy) [460.044353] Starting subtest: bo-copy [461.587132] Subtest bo-copy: SUCCESS (1.545s) [461.706653] [134/142] (589s left) gem_lmem_swapping (heavy-verify-multi) [461.923181] Subtest heavy-verify-multi: SKIP (0.000s) [461.988187] [135/142] (589s left) syncobj_timeline (wait-all-for-submit-complex) [462.195222] Starting subtest: wait-all-for-submit-complex [462.412219] Subtest wait-all-for-submit-complex: SUCCESS (0.216s) [462.512021] [136/142] (589s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt) [462.830501] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt [462.833677] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [462.940109] [137/142] (588s left) i915_query (query-topology-coherent-slice-mask) [463.148855] Starting subtest: query-topology-coherent-slice-mask [463.150574] Subtest query-topology-coherent-slice-mask: SUCCESS (0.000s) [463.239702] [138/142] (588s left) i915_pm_rps (min-max-config-loaded) [463.458639] Starting subtest: min-max-config-loaded [463.837651] Subtest min-max-config-loaded: SUCCESS (0.381s) [463.941155] [139/142] (587s left) kms_addfb_basic (tile-pitch-mismatch) [464.150500] Starting subtest: tile-pitch-mismatch [464.152181] Subtest tile-pitch-mismatch: SUCCESS (0.001s) [464.373349] [140/142] (587s left) i915_pm_rpm (basic-pci-d3-state) [466.188350] Starting subtest: basic-pci-d3-state [466.988372] Subtest basic-pci-d3-state: SUCCESS (0.798s) [467.215266] [141/142] (584s left) kms_ccs (pipe-d-crc-primary-basic-4_tiled_dg2_rc_ccs_cc) [467.922011] Subtest pipe-D-crc-primary-basic-4_tiled_dg2_rc_ccs_cc: SKIP (0.000s) [468.252255] [142/142] (583s left) gem_exec_schedule (preempt) [468.495918] Starting subtest: preempt [468.497452] Starting dynamic subtest: rcs0 [468.566146] Dynamic subtest rcs0: SUCCESS (0.068s) [468.610790] Starting dynamic subtest: bcs0 [468.657790] Dynamic subtest bcs0: SUCCESS (0.089s) [468.695590] Starting dynamic subtest: vcs0 [468.728645] Dynamic subtest vcs0: SUCCESS (0.067s) [468.761445] Starting dynamic subtest: vecs0 [468.796665] Dynamic subtest vecs0: SUCCESS (0.065s) [468.798813] Subtest preempt: SUCCESS (0.303s) [469.163215] Closing watchdogs Done.