[45.656786] Initializing watchdogs [45.657053] /dev/watchdog0 [45.693866] [001/137] (960s left) i915_pm_backlight (fade-with-dpms) [46.108424] Subtest fade-with-dpms: SKIP (0.000s) [46.212941] [002/137] (960s left) gem_softpin (evict-prime-sanity-check) [46.511150] Starting subtest: evict-prime-sanity-check [46.540386] Starting dynamic subtest: rcs0 [47.635785] Dynamic subtest rcs0: SUCCESS (1.133s) [47.670496] Starting dynamic subtest: bcs0 [48.742272] Dynamic subtest bcs0: SUCCESS (1.110s) [48.773490] Starting dynamic subtest: vcs0 [49.852316] Dynamic subtest vcs0: SUCCESS (1.106s) [49.884488] Starting dynamic subtest: vecs0 [50.961120] Dynamic subtest vecs0: SUCCESS (1.113s) [50.992976] Starting dynamic subtest: all [52.070677] Dynamic subtest all: SUCCESS (1.108s) [52.089401] Subtest evict-prime-sanity-check: SUCCESS (5.571s) [52.168660] [003/137] (954s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted) [52.433172] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted [52.452071] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.002s) [52.536131] [004/137] (953s left) gem_exec_schedule (pi-shared-iova) [52.947639] Starting subtest: pi-shared-iova [52.966681] Starting dynamic subtest: rcs0 [53.010161] Dynamic subtest rcs0: SUCCESS (0.079s) [53.043308] Starting dynamic subtest: bcs0 [53.085204] Dynamic subtest bcs0: SUCCESS (0.071s) [53.116396] Starting dynamic subtest: vcs0 [53.135468] Dynamic subtest vcs0: SUCCESS (0.051s) [53.165901] Starting dynamic subtest: vecs0 [53.186038] Dynamic subtest vecs0: SUCCESS (0.052s) [53.207478] Subtest pi-shared-iova: SUCCESS (0.254s) [53.417336] [005/137] (953s left) kms_universal_plane (universal-plane-pageflip-windowed-pipe-a) [53.787089] Starting subtest: universal-plane-pageflip-windowed-pipe-A [54.259574] Subtest universal-plane-pageflip-windowed-pipe-A: SUCCESS (0.480s) [54.594720] [006/137] (951s left) kms_flip (blocking-absolute-wf_vblank) [54.962134] Starting subtest: blocking-absolute-wf_vblank [54.983852] Starting dynamic subtest: A-DP1 [66.060143] Dynamic subtest A-DP1: SUCCESS (10.956s) [66.112850] Starting dynamic subtest: B-DP1 [76.341099] Dynamic subtest B-DP1: SUCCESS (10.453s) [76.374172] Starting dynamic subtest: C-DP1 [86.805807] Dynamic subtest C-DP1: SUCCESS (10.462s) [86.828896] Subtest blocking-absolute-wf_vblank: SUCCESS (31.877s) [87.239054] [007/137] (919s left) kms_cursor_crc (cursor-sliding-128x128) [87.605587] Starting subtest: cursor-sliding-128x128 [87.624579] Starting dynamic subtest: pipe-A-DP-1 [91.285582] Dynamic subtest pipe-A-DP-1: SUCCESS (3.669s) [91.344541] Starting dynamic subtest: pipe-C-DP-1 [95.301489] Dynamic subtest pipe-C-DP-1: SUCCESS (3.958s) [95.320717] Subtest cursor-sliding-128x128: SUCCESS (7.696s) [95.701854] [008/137] (911s left) gem_ctx_param (invalid-param-set) [95.964692] Starting subtest: invalid-param-set [95.985726] Subtest invalid-param-set: SUCCESS (0.000s) [96.085069] [009/137] (910s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt) [96.515064] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt [98.607125] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (2.168s) [98.767914] [010/137] (908s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [99.186753] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [99.229143] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [99.329301] [011/137] (907s left) kms_ccs (pipe-b-random-ccs-data-y_tiled_gen12_rc_ccs) [99.871677] Starting subtest: pipe-B-random-ccs-data-y_tiled_gen12_rc_ccs [99.935204] Subtest pipe-B-random-ccs-data-y_tiled_gen12_rc_ccs: SKIP (0.000s) [100.357621] [012/137] (906s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt) [100.745949] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt [100.784282] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [100.916649] [013/137] (906s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite) [101.356178] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite [101.405668] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [101.529737] [014/137] (905s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt) [101.977825] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt [102.026709] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [102.159145] [015/137] (905s left) kms_cursor_crc (cursor-onscreen-512x170) [102.549401] Starting subtest: cursor-onscreen-512x170 [102.596867] Subtest cursor-onscreen-512x170: SKIP (0.002s) [102.725956] [016/137] (904s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt) [103.173100] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt [103.227124] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s) [103.356044] [017/137] (904s left) kms_addfb_basic (invalid-get-prop) [103.626657] Starting subtest: invalid-get-prop [103.651864] Subtest invalid-get-prop: SUCCESS (0.000s) [103.840771] [018/137] (903s left) kms_flip (2x-plain-flip-fb-recreate) [104.194836] Starting subtest: 2x-plain-flip-fb-recreate [104.232482] Subtest 2x-plain-flip-fb-recreate: SKIP (0.003s) [104.339127] [019/137] (903s left) drm_fdinfo (virtual-busy-all) [104.586326] Starting subtest: virtual-busy-all [104.605310] Subtest virtual-busy-all: SUCCESS (0.001s) [104.712534] [020/137] (903s left) gem_exec_whisper (basic-fds-priority-all) [105.013206] Starting subtest: basic-fds-priority-all [128.714454] Subtest basic-fds-priority-all: SUCCESS (23.716s) [128.905143] [021/137] (879s left) syncobj_wait (single-wait-all-for-submit-signaled) [129.167271] Starting subtest: single-wait-all-for-submit-signaled [129.186157] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.001s) [129.272386] [022/137] (878s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render) [129.682741] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render [129.723306] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [129.828329] [023/137] (878s left) kms_ccs (pipe-a-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc) [130.271588] Starting subtest: pipe-A-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc [130.311242] Subtest pipe-A-crc-primary-rotation-180-4_tiled_dg2_rc_ccs_cc: SKIP (0.001s) [130.842879] [024/137] (877s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy) [131.210920] Starting subtest: 2x-long-cursor-vs-flip-legacy [131.248143] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.003s) [131.354892] [025/137] (877s left) api_intel_allocator (execbuf-with-allocator) [131.603421] Starting subtest: execbuf-with-allocator [131.625404] Subtest execbuf-with-allocator: SUCCESS (0.009s) [131.739739] [026/137] (876s left) kms_writeback (writeback-fb-id) [132.189435] Subtest writeback-fb-id: SKIP (0.000s) [132.294188] [027/137] (876s left) kms_ccs (pipe-c-crc-primary-basic-4_tiled_dg2_mc_ccs) [132.899619] Starting subtest: pipe-C-crc-primary-basic-4_tiled_dg2_mc_ccs [132.939251] Subtest pipe-C-crc-primary-basic-4_tiled_dg2_mc_ccs: SKIP (0.001s) [133.312355] [028/137] (875s left) prime_vgem (coherency-blt) [133.704331] Starting subtest: coherency-blt [137.268812] Subtest coherency-blt: SUCCESS (3.400s) [137.375062] [029/137] (871s left) kms_chamelium_frames (hdmi-crc-multiple) [137.852905] Subtest hdmi-crc-multiple: SKIP (0.000s) [138.147365] [030/137] (870s left) syncobj_basic (bad-destroy) [138.401244] Starting subtest: bad-destroy [138.420306] Subtest bad-destroy: SUCCESS (0.000s) [138.524754] [031/137] (870s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc) [138.937109] Starting subtest: fbc-rgb101010-draw-mmap-wc [141.622986] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (2.647s) [141.704352] [032/137] (867s left) kms_ccs (pipe-b-crc-sprite-planes-basic-y_tiled_ccs) [142.285975] Starting subtest: pipe-B-crc-sprite-planes-basic-y_tiled_ccs [142.806416] Subtest pipe-B-crc-sprite-planes-basic-y_tiled_ccs: SUCCESS (0.524s) [143.309984] [033/137] (865s left) kms_cursor_crc (cursor-offscreen-512x170) [143.672824] Starting subtest: cursor-offscreen-512x170 [143.720205] Subtest cursor-offscreen-512x170: SKIP (0.002s) [143.854888] [034/137] (865s left) gem_exec_reloc (basic-gtt-wc) [144.144741] Starting subtest: basic-gtt-wc [144.170347] Subtest basic-gtt-wc: SUCCESS (0.019s) [144.378965] [035/137] (865s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu) [144.771198] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu [144.812713] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [144.922185] [036/137] (864s left) dumb_buffer (map-invalid-size) [145.184818] Starting subtest: map-invalid-size [145.205751] Subtest map-invalid-size: SUCCESS (0.000s) [145.306175] [037/137] (864s left) gem_spin_batch (engines) [145.589485] Starting subtest: engines [145.608513] Starting dynamic subtest: rcs0 [149.094617] Dynamic subtest rcs0: SUCCESS (3.323s) [149.129484] Starting dynamic subtest: bcs0 [152.412567] Dynamic subtest bcs0: SUCCESS (3.321s) [152.445460] Starting dynamic subtest: vcs0 [155.745061] Dynamic subtest vcs0: SUCCESS (3.320s) [155.777785] Starting dynamic subtest: vecs0 [159.054167] Dynamic subtest vecs0: SUCCESS (3.319s) [159.075513] Subtest engines: SUCCESS (13.285s) [159.163163] [038/137] (850s left) i915_pm_rps (waitboost) [159.417684] Starting subtest: waitboost [162.157810] Subtest waitboost: SUCCESS (2.565s) [162.241096] [039/137] (847s left) kms_universal_plane (disable-primary-vs-flip-pipe-b) [162.572647] Starting subtest: disable-primary-vs-flip-pipe-B [163.596276] Subtest disable-primary-vs-flip-pipe-B: SUCCESS (1.003s) [163.935981] [040/137] (845s left) gem_lmem_swapping (verify-ccs) [164.211361] Subtest verify-ccs: SKIP (0.000s) [164.321406] [041/137] (845s left) kms_ccs (pipe-b-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc) [164.869646] Starting subtest: pipe-B-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc [164.909958] Subtest pipe-B-ccs-on-another-bo-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s) [165.335673] [042/137] (844s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs) [166.021078] Starting subtest: pipe-C-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs [166.061205] Subtest pipe-C-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs: SKIP (0.004s) [166.359343] [043/137] (843s left) kms_vblank (crtc-id) [166.701740] Starting subtest: crtc-id [166.999199] Subtest crtc-id: SUCCESS (0.291s) [167.374560] [044/137] (842s left) kms_ccs (pipe-a-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc) [167.869733] Starting subtest: pipe-A-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc [167.909350] Subtest pipe-A-crc-sprite-planes-basic-4_tiled_dg2_rc_ccs_cc: SKIP (0.006s) [168.427104] [045/137] (841s left) kms_rotation_crc (exhaust-fences) [168.762279] Starting subtest: exhaust-fences [170.457521] Subtest exhaust-fences: SUCCESS (1.686s) [170.656331] [046/137] (839s left) i915_pm_rpm (system-suspend) [172.528524] Starting subtest: system-suspend [189.461782] Subtest system-suspend: SUCCESS (1.946s) [196.164337] [047/137] (835s left) v3d/v3d_mmap (mmap-bad-flags) [196.501637] Subtest mmap-bad-flags: SKIP (0.000s) [196.608467] [048/137] (835s left) gem_exec_flush (basic-batch-kernel-default-cmd) [196.908905] Starting subtest: basic-batch-kernel-default-cmd [202.789622] Subtest basic-batch-kernel-default-cmd: SUCCESS (5.788s) [202.921989] [049/137] (828s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size) [203.293338] Starting subtest: cursorB-vs-flipB-varying-size [203.343137] Subtest cursorB-vs-flipB-varying-size: SKIP (0.002s) [203.471709] [050/137] (828s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0) [203.886064] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0 [205.279244] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.439s) [205.496981] [051/137] (826s left) v3d/v3d_submit_csd (job-perfmon) [205.846776] Subtest job-perfmon: SKIP (0.000s) [205.941328] [052/137] (826s left) gem_sync (basic-all) [206.358062] Starting subtest: basic-all [209.190106] Subtest basic-all: SUCCESS (2.819s) [209.278969] [053/137] (822s left) gem_exec_balancer (bonded-pair) [209.559642] Starting subtest: bonded-pair [213.452529] Subtest bonded-pair: SUCCESS (3.726s) [217.295163] [054/137] (814s left) kms_frontbuffer_tracking (fbc-modesetfrombusy) [217.698540] Starting subtest: fbc-modesetfrombusy [218.816555] Subtest fbc-modesetfrombusy: SUCCESS (1.188s) [218.953857] [055/137] (813s left) i915_getparams_basic (basic-eu-total) [219.205818] Starting subtest: basic-eu-total [219.243462] Subtest basic-eu-total: SUCCESS (0.000s) [219.358118] [056/137] (813s left) kms_ccs (pipe-d-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc) [220.064689] Subtest pipe-D-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s) [220.383730] [057/137] (812s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling) [220.743747] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling [220.762706] Starting dynamic subtest: pipe-A-valid-mode [220.848081] Dynamic subtest pipe-A-valid-mode: SKIP (0.084s) [220.890669] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.086s) [221.170340] [058/137] (811s left) gem_pxp (create-regular-buffer) [224.123554] Subtest create-regular-buffer: SKIP (0.000s) [224.275325] [059/137] (808s left) kms_fbcon_fbt (fbc) [224.532426] Starting subtest: fbc [228.466034] Subtest fbc: SUCCESS (3.903s) [228.557310] [060/137] (804s left) kms_psr2_sf (cursor-plane-move-continuous-exceed-fully-sf) [228.839764] Subtest cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s) [228.926768] [061/137] (804s left) syncobj_timeline (single-wait-all-for-submit-available-submitted) [229.177695] Starting subtest: single-wait-all-for-submit-available-submitted [229.198310] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.001s) [229.284675] [062/137] (803s left) kms_mmap_write_crc (main) [229.657512] Starting subtest: main [229.678592] Starting dynamic subtest: pipe-A-DP-1 [232.976219] Dynamic subtest pipe-A-DP-1: SUCCESS (3.318s) [232.997226] Subtest main: SUCCESS (3.321s) [233.327297] [063/137] (799s left) syncobj_timeline (multi-wait-all-signaled) [233.579244] Starting subtest: multi-wait-all-signaled [233.598098] Subtest multi-wait-all-signaled: SUCCESS (0.002s) [233.707545] [064/137] (799s left) gem_mmap_gtt (isolation) [233.941258] Starting subtest: isolation [233.998559] Subtest isolation: SUCCESS (0.003s) [234.092179] [065/137] (799s left) api_intel_allocator (reserve-simple) [234.335549] Starting subtest: reserve-simple [234.357814] Subtest reserve-simple: SUCCESS (0.003s) [234.469476] [066/137] (798s left) gem_ctx_persistence (engines-queued) [234.728508] Starting subtest: engines-queued [234.749391] Starting dynamic subtest: rcs0 [234.789784] Dynamic subtest rcs0: SUCCESS (0.061s) [234.829694] Starting dynamic subtest: bcs0 [234.934756] Dynamic subtest bcs0: SUCCESS (0.148s) [234.977514] Starting dynamic subtest: vcs0 [234.998790] Dynamic subtest vcs0: SUCCESS (0.060s) [235.040173] Starting dynamic subtest: vecs0 [235.059141] Dynamic subtest vecs0: SUCCESS (0.062s) [235.078145] Subtest engines-queued: SUCCESS (0.336s) [235.169461] [067/137] (798s left) gem_exec_balancer (individual) [235.433831] Starting subtest: individual [239.363652] Subtest individual: SUCCESS (3.765s) [243.054726] [068/137] (790s left) kms_chamelium_frames (vga-frame-dump) [243.507070] Subtest vga-frame-dump: SKIP (0.000s) [243.816126] [069/137] (789s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary) [244.236831] Starting subtest: fbcpsr-shrfb-scaledprimary [244.287345] Subtest fbcpsr-shrfb-scaledprimary: SKIP (0.000s) [244.425455] [070/137] (789s left) kms_big_fb (y-tiled-64bpp-rotate-0) [244.867788] Starting subtest: y-tiled-64bpp-rotate-0 [252.456198] Subtest y-tiled-64bpp-rotate-0: SUCCESS (7.658s) [253.406709] [071/137] (780s left) gem_exec_schedule (u-fairslice) [253.873431] Starting subtest: u-fairslice [253.897569] Starting dynamic subtest: rcs0 [255.727830] Dynamic subtest rcs0: SUCCESS (2.027s) [255.774490] Starting dynamic subtest: bcs0 [257.761191] Dynamic subtest bcs0: SUCCESS (2.028s) [257.803097] Starting dynamic subtest: vcs0 [259.781773] Dynamic subtest vcs0: SUCCESS (2.025s) [259.830462] Starting dynamic subtest: vecs0 [261.811763] Dynamic subtest vecs0: SUCCESS (2.025s) [261.836442] Subtest u-fairslice: SUCCESS (8.107s) [262.149270] [072/137] (771s left) kms_big_fb (4-tiled-32bpp-rotate-90) [262.566137] Starting subtest: 4-tiled-32bpp-rotate-90 [262.614954] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.000s) [262.758802] [073/137] (771s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt) [263.175127] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt [263.214760] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s) [263.329463] [074/137] (770s left) v3d/v3d_submit_csd (multiple-job-submission) [263.626825] Subtest multiple-job-submission: SKIP (0.000s) [263.718723] [075/137] (770s left) kms_psr (psr2_sprite_plane_move) [264.000612] Subtest psr2_sprite_plane_move: SKIP (0.000s) [264.090292] [076/137] (770s left) gem_ctx_freq (sysfs) [264.339560] Starting subtest: sysfs [269.304336] Subtest sysfs: SUCCESS (4.968s) [269.395975] [077/137] (765s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-gtt) [269.810425] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-mmap-gtt [269.848995] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [269.961866] [078/137] (764s left) core_setmaster (master-drop-set-user) [271.859428] Starting subtest: master-drop-set-user [271.900984] Subtest master-drop-set-user: SUCCESS (0.040s) [271.987522] [079/137] (762s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc) [272.409681] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc [272.447008] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [272.558814] [080/137] (762s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff) [272.980213] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff [273.021423] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s) [273.132539] [081/137] (761s left) gem_exec_params (invalid-fence-in) [273.378065] Starting subtest: invalid-fence-in [273.399391] Subtest invalid-fence-in: SUCCESS (0.001s) [273.497021] [082/137] (761s left) kms_dsc (dsc-with-formats) [273.867757] Subtest dsc-with-formats: SKIP (0.000s) [273.984313] [083/137] (761s left) syncobj_wait (multi-wait-for-submit-submitted-signaled) [274.233016] Starting subtest: multi-wait-for-submit-submitted-signaled [274.254832] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s) [274.347333] [084/137] (760s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc) [274.742816] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc [274.785904] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [274.898839] [085/137] (760s left) vgem_basic (bad-handle) [275.163675] Starting subtest: bad-handle [275.183327] Subtest bad-handle: SUCCESS (0.000s) [275.269843] [086/137] (760s left) gem_ctx_persistence (saturated-hostile-nopreempt) [275.520142] Starting subtest: saturated-hostile-nopreempt [275.539148] Starting dynamic subtest: rcs0 [275.639942] Dynamic subtest rcs0: SUCCESS (0.114s) [275.683541] Starting dynamic subtest: bcs0 [275.746548] Dynamic subtest bcs0: SUCCESS (0.114s) [275.786606] Starting dynamic subtest: vcs0 [275.881803] Dynamic subtest vcs0: SUCCESS (0.120s) [275.925001] Starting dynamic subtest: vecs0 [275.988244] Dynamic subtest vecs0: SUCCESS (0.120s) [276.006956] Subtest saturated-hostile-nopreempt: SUCCESS (0.473s) [276.138049] [087/137] (759s left) kms_ccs (pipe-a-bad-aux-stride-yf_tiled_ccs) [276.611191] Starting subtest: pipe-A-bad-aux-stride-yf_tiled_ccs [276.632438] Subtest pipe-A-bad-aux-stride-yf_tiled_ccs: SUCCESS (0.001s) [277.163277] [088/137] (758s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [277.540645] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [277.578276] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [277.693894] [089/137] (757s left) gem_userptr_blits (readonly-pwrite-unsync) [278.023525] Subtest readonly-pwrite-unsync: SKIP (0.000s) [278.139877] [090/137] (757s left) perf (polling-small-buf) [278.542258] Starting subtest: polling-small-buf [278.694943] Subtest polling-small-buf: SUCCESS (0.137s) [278.842303] [091/137] (756s left) v3d/v3d_get_bo_offset (create-get-offsets) [279.168147] Subtest create-get-offsets: SKIP (0.000s) [279.263043] [092/137] (756s left) gem_exec_suspend (basic) [279.543914] Starting subtest: basic [279.565658] Starting dynamic subtest: smem [280.818770] Dynamic subtest smem: SUCCESS (1.289s) [280.837575] Subtest basic: SUCCESS (1.291s) [281.042717] [093/137] (754s left) kms_prime (basic-crc-hybrid) [281.435446] Subtest basic-crc-hybrid: SKIP (0.000s) [281.564752] [094/137] (754s left) gen9_exec_parse (allowed-all) [281.842302] Starting subtest: allowed-all [281.863874] Subtest allowed-all: SUCCESS (0.003s) [282.073863] [095/137] (754s left) kms_atomic (crtc-invalid-params-fence) [282.563763] Starting subtest: crtc-invalid-params-fence [282.708779] Subtest crtc-invalid-params-fence: SUCCESS (0.171s) [283.169435] [096/137] (753s left) gem_exec_fence (basic-await) [283.586534] Starting subtest: basic-await [283.612006] Starting dynamic subtest: rcs0 [283.693328] Dynamic subtest rcs0: SUCCESS (0.107s) [283.743404] Starting dynamic subtest: bcs0 [283.800517] Dynamic subtest bcs0: SUCCESS (0.105s) [283.849997] Starting dynamic subtest: vcs0 [283.905066] Dynamic subtest vcs0: SUCCESS (0.108s) [283.950291] Starting dynamic subtest: vecs0 [284.017521] Dynamic subtest vecs0: SUCCESS (0.111s) [284.037582] Subtest basic-await: SUCCESS (0.436s) [284.687170] [097/137] (751s left) gem_lmem_swapping (massive) [284.956731] Subtest massive: SKIP (0.000s) [285.051877] [098/137] (751s left) gem_mmap_wc (coherency) [285.299184] Starting subtest: coherency [285.436952] Subtest coherency: SUCCESS (0.146s) [285.548741] [099/137] (750s left) syncobj_wait (multi-wait-all-for-submit-submitted-signaled) [285.803082] Starting subtest: multi-wait-all-for-submit-submitted-signaled [285.895614] Subtest multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.106s) [286.007563] [100/137] (750s left) gem_render_copy (linear-to-vebox-y-tiled) [286.276352] Starting subtest: linear-to-vebox-y-tiled [286.317493] Subtest linear-to-vebox-y-tiled: SKIP (0.000s) [286.483335] [101/137] (750s left) kms_plane (plane-panning-top-left) [286.830414] Starting subtest: plane-panning-top-left [286.850779] Starting dynamic subtest: pipe-A-planes [287.621128] Dynamic subtest pipe-A-planes: SUCCESS (0.773s) [287.671902] Starting dynamic subtest: pipe-B-planes [288.665873] Dynamic subtest pipe-B-planes: SUCCESS (1.048s) [288.687682] Subtest plane-panning-top-left: SUCCESS (1.828s) [289.038482] [102/137] (747s left) kms_addfb_basic (bad-pitch-999) [289.286228] Starting subtest: bad-pitch-999 [289.305323] Subtest bad-pitch-999: SUCCESS (0.000s) [289.516522] [103/137] (747s left) kms_flip (basic-flip-vs-dpms) [289.851452] Starting subtest: basic-flip-vs-dpms [289.873069] Starting dynamic subtest: A-DP1 [291.072994] Dynamic subtest A-DP1: SUCCESS (1.217s) [291.111499] Starting dynamic subtest: B-DP1 [292.128326] Dynamic subtest B-DP1: SUCCESS (1.060s) [292.169261] Starting dynamic subtest: C-DP1 [293.255473] Dynamic subtest C-DP1: SUCCESS (1.122s) [293.274565] Subtest basic-flip-vs-dpms: SUCCESS (3.408s) [293.641551] [104/137] (743s left) syncobj_timeline (invalid-query-bad-pad) [293.897458] Starting subtest: invalid-query-bad-pad [293.916496] Subtest invalid-query-bad-pad: SUCCESS (0.000s) [294.025762] [105/137] (743s left) gem_exec_reloc (basic-concurrent16) [294.294880] Starting subtest: basic-concurrent16 [299.826987] Subtest basic-concurrent16: SUCCESS (5.493s) [300.024177] [106/137] (737s left) kms_psr (cursor_mmap_gtt) [300.294139] Subtest cursor_mmap_gtt: SKIP (0.000s) [300.404800] [107/137] (736s left) gem_exec_create (basic) [300.686100] Starting subtest: basic [300.705799] Starting dynamic subtest: smem [302.747857] Dynamic subtest smem: SUCCESS (2.066s) [302.769621] Subtest basic: SUCCESS (2.068s) [302.949262] [108/137] (734s left) syncobj_wait (wait-any-interrupted) [303.201105] Starting subtest: wait-any-interrupted [303.295697] Subtest wait-any-interrupted: SUCCESS (0.108s) [303.407619] [109/137] (734s left) kms_frontbuffer_tracking (psr-2p-rte) [303.828873] Starting subtest: psr-2p-rte [303.865717] Subtest psr-2p-rte: SKIP (0.000s) [303.981574] [110/137] (733s left) gem_linear_blits (normal) [306.067220] Starting subtest: normal [321.143268] Subtest normal: SUCCESS (15.079s) [321.386193] [111/137] (716s left) kms_big_fb (y-tiled-8bpp-rotate-180) [321.946513] Starting subtest: y-tiled-8bpp-rotate-180 [325.152654] Subtest y-tiled-8bpp-rotate-180: SUCCESS (3.230s) [325.437342] [112/137] (712s left) kms_draw_crc (draw-method-mmap-gtt) [325.812465] Starting subtest: draw-method-mmap-gtt [325.831302] Starting dynamic subtest: xrgb8888-untiled [326.073424] Dynamic subtest xrgb8888-untiled: SUCCESS (0.276s) [326.114178] Starting dynamic subtest: xrgb8888-xtiled [326.225688] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.149s) [326.273609] Starting dynamic subtest: xrgb8888-ytiled [326.371745] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.148s) [326.410837] Starting dynamic subtest: rgb565-untiled [326.645145] Dynamic subtest rgb565-untiled: SUCCESS (0.265s) [326.690460] Starting dynamic subtest: rgb565-xtiled [326.779761] Dynamic subtest rgb565-xtiled: SUCCESS (0.132s) [326.823246] Starting dynamic subtest: rgb565-ytiled [326.921175] Dynamic subtest rgb565-ytiled: SUCCESS (0.132s) [326.965251] Starting dynamic subtest: xrgb2101010-untiled [327.171505] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.265s) [327.213727] Starting dynamic subtest: xrgb2101010-xtiled [327.309947] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.132s) [327.353084] Starting dynamic subtest: xrgb2101010-ytiled [327.438336] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.132s) [327.457258] Subtest draw-method-mmap-gtt: SUCCESS (1.644s) [327.595815] [113/137] (710s left) kms_plane_cursor (viewport) [327.961693] Starting subtest: viewport [328.000441] Starting dynamic subtest: pipe-A-DP-1-size-64 [330.367865] Dynamic subtest pipe-A-DP-1-size-64: SUCCESS (2.423s) [330.457454] Starting dynamic subtest: pipe-A-DP-1-size-128 [332.851281] Dynamic subtest pipe-A-DP-1-size-128: SUCCESS (2.432s) [332.932158] Starting dynamic subtest: pipe-A-DP-1-size-256 [335.353598] Dynamic subtest pipe-A-DP-1-size-256: SUCCESS (2.449s) [335.559254] Starting dynamic subtest: pipe-B-DP-1-size-64 [338.124952] Dynamic subtest pipe-B-DP-1-size-64: SUCCESS (2.639s) [338.209733] Starting dynamic subtest: pipe-B-DP-1-size-128 [340.607582] Dynamic subtest pipe-B-DP-1-size-128: SUCCESS (2.432s) [340.696586] Starting dynamic subtest: pipe-B-DP-1-size-256 [343.093315] Dynamic subtest pipe-B-DP-1-size-256: SUCCESS (2.432s) [343.288728] Starting dynamic subtest: pipe-C-DP-1-size-64 [345.897447] Dynamic subtest pipe-C-DP-1-size-64: SUCCESS (2.649s) [345.988688] Starting dynamic subtest: pipe-C-DP-1-size-128 [348.359874] Dynamic subtest pipe-C-DP-1-size-128: SUCCESS (2.415s) [348.457298] Starting dynamic subtest: pipe-C-DP-1-size-256 [350.840854] Dynamic subtest pipe-C-DP-1-size-256: SUCCESS (2.415s) [350.989261] Subtest viewport: SUCCESS (23.015s) [351.336457] [114/137] (686s left) gem_mmap_gtt (medium-copy-xy) [351.630497] Starting subtest: medium-copy-XY [359.191842] Subtest medium-copy-XY: SUCCESS (7.578s) [359.318630] [115/137] (678s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions-varying-size) [359.812961] Starting subtest: cursorB-vs-flipA-atomic-transitions-varying-size [359.855464] Subtest cursorB-vs-flipA-atomic-transitions-varying-size: SKIP (0.003s) [359.967846] [116/137] (678s left) syncobj_wait (reset-signaled) [360.257527] Starting subtest: reset-signaled [360.276569] Subtest reset-signaled: SUCCESS (0.001s) [360.383862] [117/137] (677s left) vc4/vc4_perfmon (get-values-invalid-pointer) [360.710666] Subtest get-values-invalid-pointer: SKIP (0.000s) [360.805924] [118/137] (677s left) kms_color (ctm-0-25) [361.156528] Starting subtest: ctm-0-25 [361.175404] Starting dynamic subtest: pipe-A-DP-1 [362.319822] Dynamic subtest pipe-A-DP-1: SUCCESS (1.157s) [362.384463] Starting dynamic subtest: pipe-B-DP-1 [363.765905] Dynamic subtest pipe-B-DP-1: SUCCESS (1.433s) [363.815688] Starting dynamic subtest: pipe-C-DP-1 [365.307905] Dynamic subtest pipe-C-DP-1: SUCCESS (1.536s) [365.326819] Subtest ctm-0-25: SUCCESS (4.139s) [365.675029] [119/137] (672s left) gem_exec_reloc (basic-gtt-read) [365.951999] Starting subtest: basic-gtt-read [365.973533] Subtest basic-gtt-read: SUCCESS (0.020s) [366.207926] [120/137] (672s left) i915_pm_rc6_residency (rc6-idle) [366.458396] Starting subtest: rc6-idle [366.479829] Starting dynamic subtest: rcs0 [378.887517] Dynamic subtest rcs0: SUCCESS (12.250s) [378.926830] Starting dynamic subtest: bcs0 [391.137052] Dynamic subtest bcs0: SUCCESS (12.247s) [391.176294] Starting dynamic subtest: vcs0 [403.385821] Dynamic subtest vcs0: SUCCESS (12.248s) [403.425397] Starting dynamic subtest: vecs0 [415.633324] Dynamic subtest vecs0: SUCCESS (12.248s) [415.652193] Subtest rc6-idle: SUCCESS (49.008s) [415.770903] [121/137] (622s left) kms_vblank (pipe-c-wait-idle-hang) [416.093021] Starting subtest: pipe-C-wait-idle-hang [423.626678] Subtest pipe-C-wait-idle-hang: SUCCESS (7.416s) [423.902023] [122/137] (614s left) gem_exec_fence (syncobj-timeline-chain-engines) [424.715734] Starting subtest: syncobj-timeline-chain-engines [424.831279] Subtest syncobj-timeline-chain-engines: SUCCESS (0.121s) [425.107316] [123/137] (613s left) kms_ccs (pipe-d-bad-pixel-format-y_tiled_gen12_rc_ccs) [425.852064] Subtest pipe-D-bad-pixel-format-y_tiled_gen12_rc_ccs: SKIP (0.000s) [426.189837] [124/137] (612s left) kms_hdr (invalid-hdr) [426.541683] Starting subtest: invalid-hdr [428.742751] Starting dynamic subtest: pipe-A-DP-1 [437.260305] Dynamic subtest pipe-A-DP-1: FAIL (7.290s) [437.279243] Subtest invalid-hdr: FAIL (9.479s) [437.381074] [125/137] (601s left) gem_exec_reloc (basic-gtt-active) [437.630664] Starting subtest: basic-gtt-active [437.771349] Subtest basic-gtt-active: SUCCESS (0.140s) [437.999988] [126/137] (601s left) gem_create (create-ext-placement-sanity-check) [438.360973] Starting subtest: create-ext-placement-sanity-check [438.381503] Subtest create-ext-placement-sanity-check: SUCCESS (0.007s) [438.501251] [127/137] (600s left) gem_eio (in-flight-1us) [438.802328] Starting subtest: in-flight-1us [439.701260] Subtest in-flight-1us: SUCCESS (0.915s) [439.934311] [128/137] (599s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt) [440.339223] Starting subtest: psr-1p-primscrn-indfb-plflip-blt [440.381638] Subtest psr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s) [440.497920] [129/137] (598s left) kms_big_fb (x-tiled-16bpp-rotate-180) [440.912987] Starting subtest: x-tiled-16bpp-rotate-180 [444.616640] Subtest x-tiled-16bpp-rotate-180: SUCCESS (3.746s) [444.968674] [130/137] (594s left) gem_ctx_param (invalid-size-get) [445.228874] Starting subtest: invalid-size-get [445.247802] Subtest invalid-size-get: SUCCESS (0.000s) [445.338981] [131/137] (594s left) kms_ccs (pipe-d-crc-primary-basic-y_tiled_gen12_mc_ccs) [446.055045] Subtest pipe-D-crc-primary-basic-y_tiled_gen12_mc_ccs: SKIP (0.000s) [446.382426] [132/137] (593s left) kms_vblank (pipe-b-wait-busy) [446.721278] Starting subtest: pipe-B-wait-busy [449.565392] Subtest pipe-B-wait-busy: SUCCESS (2.835s) [449.934768] [133/137] (589s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt) [450.354941] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt [450.392097] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [450.512156] [134/137] (589s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt) [450.902400] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt [453.873100] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SUCCESS (3.014s) [454.058261] [135/137] (585s left) kms_big_fb (yf-tiled-8bpp-rotate-270) [454.436097] Starting subtest: yf-tiled-8bpp-rotate-270 [454.490634] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s) [454.632770] [136/137] (585s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-25) [454.985893] Starting subtest: planes-upscale-20x20-downscale-factor-0-25 [455.017439] Starting dynamic subtest: pipe-A-DP-1 [455.068539] Dynamic subtest pipe-A-DP-1: SKIP (0.027s) [455.129949] Starting dynamic subtest: pipe-B-DP-1 [455.185198] Dynamic subtest pipe-B-DP-1: SKIP (0.073s) [455.235833] Starting dynamic subtest: pipe-C-DP-1 [455.285686] Dynamic subtest pipe-C-DP-1: SKIP (0.077s) [455.339749] Subtest planes-upscale-20x20-downscale-factor-0-25: SKIP (0.188s) [455.507861] [137/137] (584s left) perf_pmu (busy-no-semaphores) [455.763311] Starting subtest: busy-no-semaphores [455.785022] Starting dynamic subtest: rcs0 [456.276593] Dynamic subtest rcs0: SUCCESS (0.520s) [456.318011] Starting dynamic subtest: bcs0 [456.795824] Dynamic subtest bcs0: SUCCESS (0.516s) [456.839788] Starting dynamic subtest: vcs0 [457.313582] Dynamic subtest vcs0: SUCCESS (0.516s) [457.355081] Starting dynamic subtest: vecs0 [457.829830] Dynamic subtest vecs0: SUCCESS (0.516s) [457.848752] Subtest busy-no-semaphores: SUCCESS (2.074s) [457.946113] Closing watchdogs Done.