[42.465641] Initializing watchdogs [42.465782] /dev/watchdog0 [42.478521] [001/143] (960s left) kms_ccs (pipe-b-crc-primary-basic-4-tiled-mtl-rc-ccs) [42.896672] Starting subtest: pipe-B-crc-primary-basic-4-tiled-mtl-rc-ccs [43.906173] Subtest pipe-B-crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (1.011s) [45.107779] [002/143] (957s left) kms_invalid_mode (bad-vsync-start) [45.164111] Starting subtest: bad-vsync-start [45.165400] Starting dynamic subtest: pipe-A-eDP-1 [45.449047] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s) [45.453943] Starting dynamic subtest: pipe-B-eDP-1 [45.455017] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [45.462282] Starting dynamic subtest: pipe-C-eDP-1 [45.463277] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [45.467192] Starting dynamic subtest: pipe-D-eDP-1 [45.468216] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [45.469183] Subtest bad-vsync-start: SUCCESS (0.295s) [46.326195] [003/143] (956s left) api_intel_bb (blit-reloc-keep-cache) [46.395590] Starting subtest: blit-reloc-keep-cache [46.398498] Subtest blit-reloc-keep-cache: SKIP (0.002s) [46.491499] [004/143] (956s left) gem_ctx_param (vm) [46.540239] Starting subtest: vm [46.586401] Subtest vm: SUCCESS (0.047s) [46.690362] [005/143] (956s left) kms_psr2_sf (fbc-cursor-plane-update-sf) [51.904804] Starting subtest: fbc-cursor-plane-update-sf [51.907274] Starting dynamic subtest: pipe-A-eDP-1 [52.741045] Dynamic subtest pipe-A-eDP-1: SKIP (0.833s) [52.751661] Starting dynamic subtest: pipe-B-eDP-1 [53.958468] Dynamic subtest pipe-B-eDP-1: SKIP (1.215s) [53.961061] Subtest fbc-cursor-plane-update-sf: SKIP (2.053s) [55.219762] [006/143] (947s left) kms_plane_scaling (plane-upscale-20x20-with-rotation) [55.287546] Starting subtest: plane-upscale-20x20-with-rotation [55.288878] Starting dynamic subtest: pipe-A-eDP-1 [55.624229] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.336s) [55.631315] Starting dynamic subtest: pipe-B-eDP-1 [57.065477] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.440s) [57.071834] Starting dynamic subtest: pipe-C-eDP-1 [58.560107] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.494s) [58.572305] Starting dynamic subtest: pipe-D-eDP-1 [60.066132] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.504s) [60.067443] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.779s) [61.367640] [007/143] (941s left) prime_busy (before) [61.426661] Starting subtest: before [61.429185] Starting dynamic subtest: rcs0 [61.461035] Dynamic subtest rcs0: SUCCESS (0.033s) [61.468500] Starting dynamic subtest: bcs0 [61.512426] Dynamic subtest bcs0: SUCCESS (0.051s) [61.523734] Starting dynamic subtest: vcs0 [61.554319] Dynamic subtest vcs0: SUCCESS (0.041s) [61.565667] Starting dynamic subtest: vcs1 [61.596212] Dynamic subtest vcs1: SUCCESS (0.042s) [61.607774] Starting dynamic subtest: vecs0 [61.639243] Dynamic subtest vecs0: SUCCESS (0.043s) [61.650506] Starting dynamic subtest: ccs0 [61.681379] Dynamic subtest ccs0: SUCCESS (0.042s) [61.794534] Subtest before: SUCCESS (0.367s) [61.859705] [008/143] (941s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes) [61.928265] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s) [61.945670] [009/143] (941s left) gem_tiled_blits (normal) [61.980321] Subtest normal: SKIP (0.000s) [62.006369] [010/143] (941s left) syncobj_timeline (etime-multi-wait-available-unsubmitted) [62.045457] Starting subtest: etime-multi-wait-available-unsubmitted [62.153541] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.107s) [62.215655] [011/143] (940s left) gem_exec_reloc (basic-concurrent16) [62.261113] Subtest basic-concurrent16: SKIP (0.000s) [62.316606] [012/143] (940s left) kms_ccs (pipe-c-bad-pixel-format-y-tiled-gen12-rc-ccs-cc) [62.706052] Starting subtest: pipe-C-bad-pixel-format-y-tiled-gen12-rc-ccs-cc [62.708825] Subtest pipe-C-bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s) [63.601458] [013/143] (939s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt) [63.671322] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt [63.673566] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [63.743156] [014/143] (939s left) kms_cursor_crc (cursor-random-32x32) [63.839879] Starting subtest: cursor-random-32x32 [63.872205] Subtest cursor-random-32x32: SKIP (0.028s) [64.150432] [015/143] (939s left) kms_cursor_legacy (cursora-vs-flipa-atomic) [64.228944] Starting subtest: cursorA-vs-flipA-atomic [75.424966] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.195s) [76.295023] [016/143] (927s left) kms_cursor_edge_walk (256x256-top-edge) [76.376324] Starting subtest: 256x256-top-edge [76.377757] Starting dynamic subtest: pipe-A-eDP-1 [79.926406] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.549s) [79.938336] Starting dynamic subtest: pipe-D-eDP-1 [83.190621] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.262s) [83.191870] Subtest 256x256-top-edge: SUCCESS (6.815s) [84.082937] [017/143] (919s left) syncobj_timeline (multi-wait-all-for-submit-signaled) [84.122204] Starting subtest: multi-wait-all-for-submit-signaled [84.123458] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s) [84.179044] [018/143] (919s left) gem_ctx_isolation (dirty-create) [84.236873] Starting subtest: dirty-create [84.238191] Starting dynamic subtest: rcs0 [84.371526] Dynamic subtest rcs0: SUCCESS (0.134s) [84.383636] Starting dynamic subtest: bcs0 [84.588240] Dynamic subtest bcs0: SUCCESS (0.216s) [84.595922] Starting dynamic subtest: vcs0 [84.786127] Dynamic subtest vcs0: SUCCESS (0.199s) [84.790590] Starting dynamic subtest: vcs1 [86.640215] Dynamic subtest vcs1: SUCCESS (1.853s) [86.652358] Starting dynamic subtest: vecs0 [88.632044] Dynamic subtest vecs0: SUCCESS (1.992s) [88.643932] Starting dynamic subtest: ccs0 [90.754525] Dynamic subtest ccs0: SUCCESS (2.122s) [90.755954] Subtest dirty-create: SUCCESS (6.518s) [90.993130] [019/143] (912s left) gem_pxp (create-regular-context-1) [93.597034] Subtest create-regular-context-1: SKIP (0.000s) [93.665831] [020/143] (909s left) kms_psr (fbc-psr2-suspend) [93.732840] Starting subtest: fbc-psr2-suspend [93.734168] Starting dynamic subtest: eDP-1 [93.736433] Dynamic subtest eDP-1: SKIP (0.000s) [93.738640] Subtest fbc-psr2-suspend: SKIP (0.001s) [93.853022] [021/143] (909s left) kms_psr (pr-primary-mmap-cpu) [93.944952] Starting subtest: pr-primary-mmap-cpu [93.947433] Subtest pr-primary-mmap-cpu: SKIP (0.000s) [94.042355] [022/143] (909s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-onoff) [94.115167] Starting subtest: fbc-1p-primscrn-spr-indfb-onoff [97.138290] Subtest fbc-1p-primscrn-spr-indfb-onoff: SUCCESS (3.024s) [97.278478] [023/143] (906s left) kms_busy (extended-modeset-hang-newfb) [97.364148] Starting subtest: extended-modeset-hang-newfb [97.365534] Starting dynamic subtest: pipe-A [119.638195] Dynamic subtest pipe-A: SUCCESS (22.272s) [119.653219] Starting dynamic subtest: pipe-D [142.591489] Dynamic subtest pipe-D: SUCCESS (22.946s) [142.593675] Subtest extended-modeset-hang-newfb: SUCCESS (45.229s) [143.475561] [024/143] (860s left) kms_lease (lease-uevent) [143.536543] Starting subtest: lease-uevent [144.553290] Subtest lease-uevent: SUCCESS (1.015s) [144.644772] [025/143] (858s left) kms_pm_rpm (i2c) [146.607741] Starting subtest: i2c [155.876310] Subtest i2c: SUCCESS (9.271s) [155.957212] [026/143] (847s left) kms_ccs (pipe-d-crc-primary-rotation-180-y-tiled-gen12-rc-ccs) [156.379218] Starting subtest: pipe-D-crc-primary-rotation-180-y-tiled-gen12-rc-ccs [156.382363] Subtest pipe-D-crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.000s) [157.236464] [027/143] (846s left) kms_lease (setcrtc-implicit-plane) [157.314176] Starting subtest: setcrtc-implicit-plane [157.315424] Starting dynamic subtest: pipe-A-eDP-1 [157.777835] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.462s) [157.790751] Starting dynamic subtest: pipe-B-eDP-1 [158.981504] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.198s) [158.995621] Starting dynamic subtest: pipe-C-eDP-1 [160.177660] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.196s) [160.190545] Starting dynamic subtest: pipe-D-eDP-1 [161.379211] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.199s) [161.380591] Subtest setcrtc-implicit-plane: SUCCESS (4.065s) [162.292534] [028/143] (841s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-pwrite) [162.364776] Starting subtest: fbc-1p-offscren-pri-indfb-draw-pwrite [165.716901] Subtest fbc-1p-offscren-pri-indfb-draw-pwrite: SUCCESS (3.354s) [165.831872] [029/143] (837s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render) [165.884796] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render [165.886838] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [165.958254] [030/143] (837s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt) [166.044771] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt [166.047079] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s) [166.117805] [031/143] (837s left) gem_ccs (suspend-resume) [166.163812] Starting subtest: suspend-resume [166.168514] Subtest suspend-resume: SKIP (0.000s) [166.225025] [032/143] (837s left) drm_read (fault-buffer) [166.334655] Starting subtest: fault-buffer [166.336469] Subtest fault-buffer: SUCCESS (0.000s) [166.441513] [033/143] (837s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt) [166.522166] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt [166.524414] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [166.614235] [034/143] (837s left) kms_vblank (query-forked) [166.706550] Starting subtest: query-forked [166.707638] Starting dynamic subtest: pipe-A-eDP-1 [168.541202] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.835s) [168.558027] Starting dynamic subtest: pipe-D-eDP-1 [171.140090] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.591s) [171.141340] Subtest query-forked: SUCCESS (4.434s) [172.019826] [035/143] (831s left) kms_ccs (pipe-a-crc-sprite-planes-basic-4-tiled-mtl-mc-ccs) [172.403696] Starting subtest: pipe-A-crc-sprite-planes-basic-4-tiled-mtl-mc-ccs [178.318605] Subtest pipe-A-crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (5.915s) [179.510609] [036/143] (824s left) gem_mmap_wc (write-cpu-read-wc-unflushed) [179.560633] Subtest write-cpu-read-wc-unflushed: SKIP (0.000s) [179.585071] [037/143] (824s left) kms_ccs (pipe-c-random-ccs-data-y-tiled-gen12-mc-ccs) [179.975836] Starting subtest: pipe-C-random-ccs-data-y-tiled-gen12-mc-ccs [179.979875] Subtest pipe-C-random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.000s) [180.852648] [038/143] (823s left) v3d/v3d_job_submission (array-job-submission) [180.927686] Subtest array-job-submission: SKIP (0.000s) [180.972414] [039/143] (822s left) kms_dirtyfb (psr-dirtyfb-ioctl) [181.033808] Starting subtest: psr-dirtyfb-ioctl [181.035086] Starting dynamic subtest: A-eDP-1 [182.722499] Dynamic subtest A-eDP-1: SUCCESS (1.688s) [182.723731] Subtest psr-dirtyfb-ioctl: SUCCESS (1.690s) [183.604822] [040/143] (820s left) kms_big_fb (x-tiled-addfb) [183.675831] Starting subtest: x-tiled-addfb [183.677112] Subtest x-tiled-addfb: SUCCESS (0.000s) [183.759998] [041/143] (820s left) kms_chamelium_hpd (dp-hpd-for-each-pipe) [184.140715] Subtest dp-hpd-for-each-pipe: SKIP (0.000s) [184.978578] [042/143] (818s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0) [185.088687] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0 [186.098696] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.011s) [186.188239] [043/143] (817s left) kms_atomic_transition (modeset-transition-nonblocking-fencing) [186.267299] Starting subtest: modeset-transition-nonblocking-fencing [186.268833] Starting dynamic subtest: 1x-outputs [198.351618] Dynamic subtest 1x-outputs: SUCCESS (12.083s) [198.641138] Subtest modeset-transition-nonblocking-fencing: SUCCESS (12.374s) [199.541245] [044/143] (804s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic) [199.646820] Starting subtest: flip-vs-cursor-crc-atomic [200.381352] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.734s) [201.254763] [045/143] (802s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move) [201.319307] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move [201.321536] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [201.406647] [046/143] (802s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled) [201.450844] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled [201.452252] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s) [201.500721] [047/143] (802s left) kms_psr (fbc-psr-primary-page-flip) [201.554469] Starting subtest: fbc-psr-primary-page-flip [201.555721] Starting dynamic subtest: eDP-1 [201.558092] Dynamic subtest eDP-1: SKIP (0.000s) [201.560580] Subtest fbc-psr-primary-page-flip: SKIP (0.001s) [201.652403] [048/143] (802s left) gem_exec_schedule (submit-late-slice) [201.713084] Starting subtest: submit-late-slice [201.714454] Starting dynamic subtest: rcs0 [201.778794] Dynamic subtest rcs0: SUCCESS (0.065s) [201.792258] Starting dynamic subtest: bcs0 [201.865681] Dynamic subtest bcs0: SUCCESS (0.085s) [201.878780] Starting dynamic subtest: vcs0 [201.928520] Dynamic subtest vcs0: SUCCESS (0.062s) [201.942427] Starting dynamic subtest: vcs1 [201.970415] Dynamic subtest vcs1: SUCCESS (0.040s) [201.984351] Starting dynamic subtest: vecs0 [202.001174] Dynamic subtest vecs0: SUCCESS (0.030s) [202.013889] Starting dynamic subtest: ccs0 [202.044440] Dynamic subtest ccs0: SUCCESS (0.043s) [202.045662] Subtest submit-late-slice: SUCCESS (0.332s) [203.525905] [049/143] (800s left) syncobj_wait (invalid-reset-zero-handles) [203.593990] Starting subtest: invalid-reset-zero-handles [203.595654] Subtest invalid-reset-zero-handles: SUCCESS (0.000s) [203.664177] [050/143] (800s left) kms_ccs (pipe-c-crc-sprite-planes-basic-y-tiled-gen12-rc-ccs) [204.080670] Starting subtest: pipe-C-crc-sprite-planes-basic-y-tiled-gen12-rc-ccs [204.083325] Subtest pipe-C-crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.001s) [204.916861] [051/143] (799s left) vc4/vc4_purgeable_bo (mark-purgeable) [204.989477] Subtest mark-purgeable: SKIP (0.000s) [205.028390] [052/143] (799s left) gem_mmap_gtt (cpuset-medium-copy-xy) [205.086811] Subtest cpuset-medium-copy-XY: SKIP (0.000s) [205.128324] [053/143] (799s left) gen3_mixed_blits [205.194315] [054/143] (799s left) kms_ccs (pipe-b-crc-sprite-planes-basic-4-tiled-mtl-mc-ccs) [205.588209] Starting subtest: pipe-B-crc-sprite-planes-basic-4-tiled-mtl-mc-ccs [211.444283] Subtest pipe-B-crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (5.857s) [212.666799] [055/143] (791s left) kms_cursor_crc (cursor-rapid-movement-32x32) [212.785469] Starting subtest: cursor-rapid-movement-32x32 [212.816101] Subtest cursor-rapid-movement-32x32: SKIP (0.027s) [213.059796] [056/143] (791s left) kms_3d [215.509835] [057/143] (788s left) gem_exec_schedule (u-semaphore-user) [215.580258] Starting subtest: u-semaphore-user [215.616879] Subtest u-semaphore-user: SUCCESS (0.036s) [217.504597] [058/143] (786s left) drm_fdinfo (most-busy-check-all) [217.566229] Starting subtest: most-busy-check-all [217.567383] Starting dynamic subtest: rcs0 [217.574277] Dynamic subtest rcs0: SKIP (0.006s) [217.589784] Starting dynamic subtest: bcs0 [217.592101] Dynamic subtest bcs0: SKIP (0.001s) [217.602993] Starting dynamic subtest: vcs0 [217.605098] Dynamic subtest vcs0: SKIP (0.001s) [217.611567] Starting dynamic subtest: vcs1 [217.613672] Dynamic subtest vcs1: SKIP (0.001s) [217.618753] Starting dynamic subtest: vecs0 [217.620574] Dynamic subtest vecs0: SKIP (0.000s) [217.624746] Starting dynamic subtest: ccs0 [217.626406] Dynamic subtest ccs0: SKIP (0.000s) [217.628053] Subtest most-busy-check-all: SKIP (0.015s) [217.636602] [059/143] (786s left) api_intel_bb (misplaced-blitter) [217.699790] Starting subtest: misplaced-blitter [217.706769] Subtest misplaced-blitter: SUCCESS (0.010s) [217.812190] [060/143] (786s left) gem_exec_reloc (basic-write-read-active) [217.869225] Subtest basic-write-read-active: SKIP (0.000s) [217.932757] [061/143] (786s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt) [218.005487] Starting subtest: psr-1p-primscrn-indfb-plflip-blt [223.477042] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (5.472s) [223.585262] [062/143] (780s left) gem_userptr_blits (huge-split) [223.682892] Starting subtest: huge-split [223.693948] Subtest huge-split: SUCCESS (0.013s) [223.806669] [063/143] (780s left) kms_big_fb (y-tiled-32bpp-rotate-90) [223.887322] Starting subtest: y-tiled-32bpp-rotate-90 [223.889558] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s) [223.959613] [064/143] (780s left) i915_pm_sseu (full-enable) [224.010175] Subtest full-enable: SKIP (0.000s) [224.059302] [065/143] (780s left) kms_content_protection (dp-mst-lic-type-1) [224.162184] Starting subtest: dp-mst-lic-type-1 [224.164933] Subtest dp-mst-lic-type-1: SKIP (0.000s) [224.258331] [066/143] (780s left) gem_eio (in-flight-external) [224.486624] Starting subtest: in-flight-external [225.576683] Subtest in-flight-external: SUCCESS (1.090s) [225.690377] [067/143] (778s left) kms_flip (2x-modeset-vs-vblank-race) [225.776103] Starting subtest: 2x-modeset-vs-vblank-race [225.789046] Subtest 2x-modeset-vs-vblank-race: SKIP (0.014s) [225.860137] [068/143] (778s left) kms_ccs (pipe-c-bad-aux-stride-y-tiled-gen12-rc-ccs-cc) [226.263739] Starting subtest: pipe-C-bad-aux-stride-y-tiled-gen12-rc-ccs-cc [226.266819] Subtest pipe-C-bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s) [227.121950] [069/143] (777s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [227.202202] Starting subtest: basic-flip-after-cursor-legacy [228.167602] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.964s) [229.037134] [070/143] (775s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling) [229.099454] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling [229.100717] Starting dynamic subtest: pipe-A-default-mode [229.391531] Dynamic subtest pipe-A-default-mode: SKIP (0.289s) [229.394263] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.291s) [230.326853] [071/143] (774s left) kms_big_fb (yf-tiled-16bpp-rotate-0) [230.431592] Starting subtest: yf-tiled-16bpp-rotate-0 [230.433922] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s) [230.522444] [072/143] (774s left) template (a) [230.595484] Starting subtest: A [230.596736] Subtest A: SUCCESS (0.000s) [230.657165] [073/143] (774s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy) [230.738896] Starting subtest: flip-vs-cursor-busy-crc-legacy [231.630897] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.891s) [232.571306] [074/143] (772s left) syncobj_timeline (wait-all-for-submit-snapshot) [232.644184] Starting subtest: wait-all-for-submit-snapshot [232.727506] Subtest wait-all-for-submit-snapshot: SUCCESS (0.083s) [232.806431] [075/143] (771s left) kms_cursor_legacy (flip-vs-cursor-varying-size) [232.873416] Starting subtest: flip-vs-cursor-varying-size [239.234486] Subtest flip-vs-cursor-varying-size: SUCCESS (6.366s) [240.137560] [076/143] (764s left) prime_mmap (test_correct) [240.204820] Starting subtest: test_correct [240.205891] Starting dynamic subtest: test_correct-smem [240.242139] Dynamic subtest test_correct-smem: SUCCESS (0.041s) [240.243993] Subtest test_correct: SUCCESS (0.042s) [240.342627] [077/143] (764s left) kms_ccs (pipe-b-bad-pixel-format-4-tiled-dg2-rc-ccs-cc) [240.755461] Starting subtest: pipe-B-bad-pixel-format-4-tiled-dg2-rc-ccs-cc [240.758107] Subtest pipe-B-bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s) [241.656541] [078/143] (763s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt) [241.727440] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt [241.729864] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [241.823474] [079/143] (763s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw) [241.887966] Starting subtest: fbc-2p-pri-indfb-multidraw [241.889946] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s) [241.972921] [080/143] (762s left) kms_chamelium_color (gamma) [242.105515] Subtest gamma: SKIP (0.000s) [242.138579] [081/143] (762s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt) [242.223706] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt [242.225944] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [242.297492] [082/143] (762s left) perf (invalid-open-flags) [242.423589] Starting subtest: invalid-open-flags [242.424463] Subtest invalid-open-flags: SUCCESS (0.000s) [242.452620] [083/143] (762s left) gem_eio (reset-stress) [242.680656] Starting subtest: reset-stress [287.002938] Subtest reset-stress: SUCCESS (44.324s) [288.479324] [084/143] (716s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move) [288.566541] Starting subtest: psr-2p-primscrn-cur-indfb-move [288.568855] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [288.677179] [085/143] (716s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-wc) [288.779223] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-wc [293.355629] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-wc: SUCCESS (4.577s) [293.467313] [086/143] (711s left) gem_softpin (evict-prime-sanity-check) [293.525279] Starting subtest: evict-prime-sanity-check [293.526699] Starting dynamic subtest: rcs0 [294.637610] Dynamic subtest rcs0: SUCCESS (1.114s) [294.654548] Starting dynamic subtest: bcs0 [295.742694] Dynamic subtest bcs0: SUCCESS (1.103s) [295.753333] Starting dynamic subtest: vcs0 [297.450249] Dynamic subtest vcs0: SUCCESS (1.703s) [297.467188] Starting dynamic subtest: vcs1 [299.431171] Dynamic subtest vcs1: SUCCESS (1.977s) [299.446807] Starting dynamic subtest: vecs0 [301.413117] Dynamic subtest vecs0: SUCCESS (1.983s) [301.429486] Starting dynamic subtest: ccs0 [302.550560] Dynamic subtest ccs0: SUCCESS (1.138s) [302.568586] Starting dynamic subtest: all [303.659843] Dynamic subtest all: SUCCESS (1.107s) [303.661686] Subtest evict-prime-sanity-check: SUCCESS (10.138s) [303.737307] [087/143] (701s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render) [303.826923] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render [307.091160] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (3.267s) [307.212190] [088/143] (697s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc) [307.295850] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc [307.298109] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [307.380314] [089/143] (697s left) kms_color (ctm-negative) [307.458281] Starting subtest: ctm-negative [307.459643] Starting dynamic subtest: pipe-A [308.237815] Dynamic subtest pipe-A: SUCCESS (0.779s) [308.253176] Starting dynamic subtest: pipe-B [309.787149] Dynamic subtest pipe-B: SUCCESS (1.549s) [309.800583] Starting dynamic subtest: pipe-C [311.257271] Dynamic subtest pipe-C: SUCCESS (1.467s) [311.274325] Starting dynamic subtest: pipe-D [312.727517] Dynamic subtest pipe-D: SUCCESS (1.469s) [312.729105] Subtest ctm-negative: SUCCESS (5.269s) [313.655330] [090/143] (691s left) gem_mmap_gtt (cpuset-basic-small-copy-xy) [313.713667] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s) [313.740938] [091/143] (691s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc) [313.815450] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc [316.318748] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (2.506s) [316.442801] [092/143] (688s left) kms_chamelium_audio (dp-audio-edid) [316.812523] Subtest dp-audio-edid: SKIP (0.000s) [317.649626] [093/143] (687s left) perf_pmu (init-busy) [317.711906] Starting subtest: init-busy [317.714036] Starting dynamic subtest: rcs0 [317.716189] Dynamic subtest rcs0: SUCCESS (0.002s) [317.732782] Starting dynamic subtest: bcs0 [317.734802] Dynamic subtest bcs0: SUCCESS (0.001s) [317.750631] Starting dynamic subtest: vcs0 [317.752187] Dynamic subtest vcs0: SUCCESS (0.001s) [317.767300] Starting dynamic subtest: vcs1 [317.768708] Dynamic subtest vcs1: SUCCESS (0.001s) [317.777969] Starting dynamic subtest: vecs0 [317.779148] Dynamic subtest vecs0: SUCCESS (0.001s) [317.785095] Starting dynamic subtest: ccs0 [317.786214] Dynamic subtest ccs0: SUCCESS (0.001s) [317.787348] Subtest init-busy: SUCCESS (0.012s) [317.798913] [094/143] (687s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [317.848563] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip [317.851079] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s) [317.926564] [095/143] (687s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic) [318.034249] Starting subtest: nonblocking-modeset-vs-cursor-atomic [319.549440] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.514s) [320.440146] [096/143] (684s left) gem_exec_fence (submit3) [320.628207] Starting subtest: submit3 [320.630502] Subtest submit3: SKIP (0.000s) [322.483740] [097/143] (682s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format) [322.544107] Starting subtest: plane-scaler-unity-scaling-with-pixel-format [322.545403] Starting dynamic subtest: pipe-A-eDP-1 [327.546201] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.002s) [327.563537] Starting dynamic subtest: pipe-B-eDP-1 [333.613470] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.065s) [333.623981] Starting dynamic subtest: pipe-C-eDP-1 [334.984453] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.366s) [334.997611] Starting dynamic subtest: pipe-D-eDP-1 [336.412564] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.425s) [336.413798] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (13.870s) [337.671521] [098/143] (667s left) kms_pm_rpm (modeset-pc8-residency-stress) [339.601817] Starting subtest: modeset-pc8-residency-stress [339.604987] Subtest modeset-pc8-residency-stress: SKIP (0.000s) [339.981665] [099/143] (665s left) gen9_exec_parse (batch-invalid-length) [340.042912] Subtest batch-invalid-length: SKIP (0.000s) [340.067927] [100/143] (665s left) v3d/v3d_submit_cl (simple-flush-cache) [340.141155] Subtest simple-flush-cache: SKIP (0.000s) [340.193701] [101/143] (665s left) v3d/v3d_perfmon (destroy-invalid-perfmon) [340.241447] Subtest destroy-invalid-perfmon: SKIP (0.000s) [340.291069] [102/143] (665s left) syncobj_timeline (single-wait-all-available-signaled) [340.326481] Starting subtest: single-wait-all-available-signaled [340.327759] Subtest single-wait-all-available-signaled: SUCCESS (0.000s) [340.397615] [103/143] (665s left) gem_tiled_fence_blits (basic) [340.443257] Subtest basic: SKIP (0.000s) [340.464769] [104/143] (665s left) gem_partial_pwrite_pread (writes-after-reads) [340.522005] Subtest writes-after-reads: SKIP (0.000s) [340.584342] [105/143] (664s left) dmabuf_sync_file (export-multiwait) [340.645512] Starting subtest: export-multiwait [340.646854] Subtest export-multiwait: SUCCESS (0.000s) [340.694457] [106/143] (664s left) kms_big_fb (linear-8bpp-rotate-90) [340.743949] Starting subtest: linear-8bpp-rotate-90 [340.764776] Subtest linear-8bpp-rotate-90: SKIP (0.019s) [340.863880] [107/143] (664s left) gem_exec_balancer (individual) [340.934908] Starting subtest: individual [342.436856] Subtest individual: SUCCESS (1.500s) [342.673827] [108/143] (662s left) gem_ctx_persistence (legacy-engines-hostile-preempt) [342.741225] Starting subtest: legacy-engines-hostile-preempt [342.744490] Starting dynamic subtest: render [342.820942] Dynamic subtest render: SUCCESS (0.077s) [342.836170] Starting dynamic subtest: bsd1 [344.417422] Dynamic subtest bsd1: SUCCESS (1.592s) [344.433973] Starting dynamic subtest: bsd2 [346.403981] Dynamic subtest bsd2: SUCCESS (1.985s) [346.420622] Starting dynamic subtest: blt [346.612073] Dynamic subtest blt: SUCCESS (0.208s) [346.628387] Starting dynamic subtest: vebox [348.451380] Dynamic subtest vebox: SUCCESS (1.836s) [348.452944] Subtest legacy-engines-hostile-preempt: SUCCESS (5.708s) [348.558851] [109/143] (657s left) gem_exec_balancer (bonded-pair) [348.632404] Starting subtest: bonded-pair [348.635025] Subtest bonded-pair: SKIP (0.000s) [348.886203] [110/143] (656s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render) [348.980423] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render [348.982761] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [349.052156] [111/143] (656s left) i915_getparams_basic (basic-eu-total) [349.113428] Starting subtest: basic-eu-total [349.116761] Subtest basic-eu-total: SUCCESS (0.000s) [349.181909] [112/143] (656s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling) [349.235143] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling [349.236496] Starting dynamic subtest: pipe-A-default-mode [352.125221] Dynamic subtest pipe-A-default-mode: SUCCESS (2.889s) [352.126417] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.891s) [353.005359] [113/143] (652s left) gem_exec_fence (syncobj-timeline-repeat) [353.568949] Starting subtest: syncobj-timeline-repeat [353.715320] Subtest syncobj-timeline-repeat: SUCCESS (0.148s) [354.563765] [114/143] (651s left) kms_ccs (pipe-d-bad-rotation-90-4-tiled-dg2-rc-ccs) [354.991128] Starting subtest: pipe-D-bad-rotation-90-4-tiled-dg2-rc-ccs [354.994423] Subtest pipe-D-bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.000s) [355.831258] [115/143] (649s left) gem_close (basic) [355.892888] Starting subtest: basic [355.894032] Subtest basic: SUCCESS (0.000s) [355.980845] [116/143] (649s left) kms_addfb_basic (bad-pitch-999) [356.026404] Starting subtest: bad-pitch-999 [356.027311] Subtest bad-pitch-999: SUCCESS (0.000s) [356.155213] [117/143] (649s left) gem_partial_pwrite_pread (write-display) [356.210891] Subtest write-display: SKIP (0.000s) [356.275996] [118/143] (649s left) gem_render_copy (y-tiled-ccs-to-yf-tiled) [356.332298] Starting subtest: y-tiled-ccs-to-yf-tiled [356.334575] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s) [356.517265] [119/143] (649s left) gem_reg_read (timestamp-monotonic) [356.555641] Starting subtest: timestamp-monotonic [360.952863] Subtest timestamp-monotonic: SUCCESS (4.396s) [361.017714] [120/143] (644s left) gem_readwrite (read-bad-handle) [361.058064] Subtest read-bad-handle: SKIP (0.000s) [361.104585] [121/143] (644s left) gem_softpin (overlap) [361.172081] Starting subtest: overlap [361.903594] Subtest overlap: SUCCESS (0.729s) [362.003258] [122/143] (643s left) gem_tiled_swapping (non-threaded) [362.041149] Subtest non-threaded: SKIP (0.000s) [362.059096] [123/143] (643s left) i915_pm_rpm (sysfs-read) [363.659711] Starting subtest: sysfs-read [367.383049] Subtest sysfs-read: SUCCESS (3.722s) [368.225951] [124/143] (637s left) perf (non-zero-reason) [368.303760] Starting subtest: non-zero-reason [368.305053] Starting dynamic subtest: 0-rcs0 [374.635140] Dynamic subtest 0-rcs0: SUCCESS (6.329s) [374.653881] Starting dynamic subtest: 1-vcs0 [378.959658] Dynamic subtest 1-vcs0: SUCCESS (4.323s) [378.961679] Subtest non-zero-reason: SUCCESS (10.653s) [378.989089] [125/143] (627s left) syncobj_wait (single-wait-all-signaled) [379.035284] Starting subtest: single-wait-all-signaled [379.036751] Subtest single-wait-all-signaled: SUCCESS (0.000s) [379.091295] [126/143] (626s left) prime_mmap (test_map_unmap) [379.146710] Starting subtest: test_map_unmap [379.147957] Starting dynamic subtest: test_map_unmap-smem [379.190804] Dynamic subtest test_map_unmap-smem: SUCCESS (0.044s) [379.192277] Subtest test_map_unmap: SUCCESS (0.045s) [379.272965] [127/143] (626s left) kms_psr (fbc-pr-cursor-mmap-gtt) [379.328851] Starting subtest: fbc-pr-cursor-mmap-gtt [379.331431] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s) [379.430523] [128/143] (626s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render) [379.526888] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render [379.529178] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [379.594349] [129/143] (626s left) kms_plane_scaling (plane-downscale-factor-0-25-with-modifiers) [379.682259] Starting subtest: plane-downscale-factor-0-25-with-modifiers [379.685375] Starting dynamic subtest: pipe-A-eDP-1 [379.725997] Dynamic subtest pipe-A-eDP-1: SKIP (0.039s) [379.740423] Starting dynamic subtest: pipe-B-eDP-1 [379.777581] Dynamic subtest pipe-B-eDP-1: SKIP (0.051s) [379.790417] Starting dynamic subtest: pipe-C-eDP-1 [379.818788] Dynamic subtest pipe-C-eDP-1: SKIP (0.039s) [379.830317] Starting dynamic subtest: pipe-D-eDP-1 [379.860296] Dynamic subtest pipe-D-eDP-1: SKIP (0.040s) [379.862263] Subtest plane-downscale-factor-0-25-with-modifiers: SKIP (0.176s) [379.947253] [130/143] (626s left) kms_ccs (pipe-c-crc-primary-basic-4-tiled-mtl-mc-ccs) [380.326516] Starting subtest: pipe-C-crc-primary-basic-4-tiled-mtl-mc-ccs [382.782763] Subtest pipe-C-crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (2.457s) [383.956283] [131/143] (622s left) gem_pxp (reject-modify-context-protection-on) [386.545857] Subtest reject-modify-context-protection-on: SKIP (0.000s) [386.617500] [132/143] (619s left) syncobj_wait (multi-wait-all-signaled) [386.667651] Starting subtest: multi-wait-all-signaled [386.668932] Subtest multi-wait-all-signaled: SUCCESS (0.000s) [386.734520] [133/143] (619s left) kms_psr (psr2-sprite-mmap-cpu) [386.804950] Starting subtest: psr2-sprite-mmap-cpu [386.806304] Starting dynamic subtest: eDP-1 [388.655760] Dynamic subtest eDP-1: SUCCESS (1.851s) [388.657090] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.852s) [389.561094] [134/143] (616s left) kms_ccs (pipe-a-bad-rotation-90-4-tiled-dg2-rc-ccs) [389.940459] Starting subtest: pipe-A-bad-rotation-90-4-tiled-dg2-rc-ccs [389.943146] Subtest pipe-A-bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.000s) [390.843441] [135/143] (615s left) kms_vblank (wait-busy-hang) [390.897666] Starting subtest: wait-busy-hang [390.898967] Starting dynamic subtest: pipe-A-eDP-1 [405.305296] Dynamic subtest pipe-A-eDP-1: SUCCESS (14.406s) [405.323731] Starting dynamic subtest: pipe-D-eDP-1 [430.364347] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.052s) [430.365561] Subtest wait-busy-hang: SUCCESS (39.467s) [431.290790] [136/143] (575s left) vc4/vc4_lookup_fail (bad-color-write) [431.391289] Subtest bad-color-write: SKIP (0.000s) [431.444711] [137/143] (574s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu) [431.497476] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu [431.499618] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [431.586683] [138/143] (574s left) intel_hwmon (hwmon-read) [431.635484] Subtest hwmon-read: SKIP (0.000s) [431.670983] [139/143] (574s left) kms_psr_stress_test (flip-primary-invalidate-overlay) [431.737137] Starting subtest: flip-primary-invalidate-overlay [443.443737] Subtest flip-primary-invalidate-overlay: SUCCESS (11.709s) [443.574040] [140/143] (562s left) gem_exec_capture (many-4k-zero) [443.635680] Starting subtest: many-4K-zero [444.079522] Subtest many-4K-zero: FAIL (0.415s) [444.162324] [141/143] (562s left) gem_lmem_evict (dontneed-evict-race) [444.278993] Subtest dontneed-evict-race: SKIP (0.000s) [444.295081] [142/143] (562s left) kms_ccs (pipe-a-missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc) [444.694829] Starting subtest: pipe-A-missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc [444.696165] Subtest pipe-A-missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.000s) [445.542017] [143/143] (560s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-wc) [445.606697] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-wc [450.159947] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-wc: SUCCESS (4.553s) [450.293428] Closing watchdogs Done.