[37.600637] Initializing watchdogs [37.600706] /dev/watchdog0 [37.609027] [001/139] (960s left) gem_blits (basic) [37.662675] Starting subtest: basic [39.780175] Subtest basic: SUCCESS (2.115s) [39.879508] [002/139] (958s left) gem_mmap (big-bo) [39.944338] Subtest big-bo: SKIP (0.000s) [39.962245] [003/139] (958s left) syncobj_timeline (host-signal-points) [40.039853] Starting subtest: host-signal-points [40.048043] Subtest host-signal-points: SUCCESS (0.009s) [40.113850] [004/139] (958s left) kms_prop_blob (invalid-set-prop) [40.168157] Starting subtest: invalid-set-prop [40.170430] Subtest invalid-set-prop: SUCCESS (0.000s) [40.226669] [005/139] (957s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-25) [40.309575] Starting subtest: planes-unity-scaling-downscale-factor-0-25 [40.312649] Starting dynamic subtest: pipe-A-eDP-1 [40.321420] Dynamic subtest pipe-A-eDP-1: SKIP (0.008s) [40.334171] Starting dynamic subtest: pipe-B-eDP-1 [40.339346] Dynamic subtest pipe-B-eDP-1: SKIP (0.016s) [40.351620] Starting dynamic subtest: pipe-C-eDP-1 [40.356671] Dynamic subtest pipe-C-eDP-1: SKIP (0.016s) [40.368063] Starting dynamic subtest: pipe-D-eDP-1 [40.372687] Dynamic subtest pipe-D-eDP-1: SKIP (0.016s) [40.376554] Subtest planes-unity-scaling-downscale-factor-0-25: SKIP (0.059s) [40.439607] [006/139] (957s left) vc4/vc4_wait_bo (unused-bo-0ns) [40.524737] Subtest unused-bo-0ns: SKIP (0.000s) [40.559442] [007/139] (957s left) kms_feature_discovery (display-2x) [40.619849] Starting subtest: display-2x [40.624156] Subtest display-2x: SKIP (0.000s) [40.666709] [008/139] (957s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling) [40.744257] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling [40.746891] Starting dynamic subtest: pipe-A-default-mode [41.034696] Dynamic subtest pipe-A-default-mode: SKIP (0.286s) [41.039333] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.287s) [41.955131] [009/139] (956s left) kms_getfb (getfb-handle-zero) [42.019237] Starting subtest: getfb-handle-zero [42.021690] Subtest getfb-handle-zero: SUCCESS (0.000s) [42.102861] [010/139] (956s left) gem_madvise (dontneed-after-mmap) [42.149591] Starting subtest: dontneed-after-mmap [42.153817] Subtest dontneed-after-mmap: SUCCESS (0.003s) [42.232540] [011/139] (956s left) kms_lease (lease-revoke) [42.321116] Starting subtest: lease-revoke [42.323619] Starting dynamic subtest: pipe-A-eDP-1 [42.356275] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.035s) [42.367849] Starting dynamic subtest: pipe-B-eDP-1 [42.383030] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.026s) [42.394793] Starting dynamic subtest: pipe-C-eDP-1 [42.408137] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.024s) [42.419396] Starting dynamic subtest: pipe-D-eDP-1 [42.435341] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.027s) [42.437744] Subtest lease-revoke: SUCCESS (0.116s) [42.538906] [012/139] (955s left) kms_ccs (pipe-c-bad-rotation-90-4-tiled-mtl-mc-ccs) [42.945637] Starting subtest: pipe-C-bad-rotation-90-4-tiled-mtl-mc-ccs [43.940809] Subtest pipe-C-bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.995s) [45.115130] [013/139] (953s left) gem_spin_batch (resubmit-new-all) [45.183661] Starting subtest: resubmit-new-all [45.186220] Starting dynamic subtest: rcs0 [45.208881] Dynamic subtest rcs0: SUCCESS (0.025s) [45.216777] Starting dynamic subtest: bcs0 [45.251595] Dynamic subtest bcs0: SUCCESS (0.042s) [45.261609] Starting dynamic subtest: vcs0 [45.274840] Dynamic subtest vcs0: SUCCESS (0.023s) [45.285597] Starting dynamic subtest: vcs1 [45.297602] Dynamic subtest vcs1: SUCCESS (0.023s) [45.308818] Starting dynamic subtest: vecs0 [45.321430] Dynamic subtest vecs0: SUCCESS (0.024s) [45.332452] Starting dynamic subtest: ccs0 [45.344593] Dynamic subtest ccs0: SUCCESS (0.023s) [45.347101] Subtest resubmit-new-all: SUCCESS (0.161s) [46.474455] [014/139] (951s left) kms_chamelium_edid (dp-edid-change-during-suspend) [46.845396] Subtest dp-edid-change-during-suspend: SKIP (0.000s) [47.684280] [015/139] (950s left) gem_tiled_swapping (non-threaded) [47.750171] Subtest non-threaded: SKIP (0.000s) [47.778758] [016/139] (950s left) perf_pmu (most-busy-idle-check-all) [47.834181] Starting subtest: most-busy-idle-check-all [47.837081] Starting dynamic subtest: rcs0 [49.454043] Dynamic subtest rcs0: SUCCESS (1.619s) [49.466226] Starting dynamic subtest: bcs0 [51.437557] Dynamic subtest bcs0: SUCCESS (1.984s) [51.450419] Starting dynamic subtest: vcs0 [53.485723] Dynamic subtest vcs0: SUCCESS (2.047s) [53.497809] Starting dynamic subtest: vcs1 [55.469198] Dynamic subtest vcs1: SUCCESS (1.984s) [55.480609] Starting dynamic subtest: vecs0 [57.453875] Dynamic subtest vecs0: SUCCESS (1.984s) [57.465872] Starting dynamic subtest: ccs0 [59.437844] Dynamic subtest ccs0: SUCCESS (1.984s) [59.440606] Subtest most-busy-idle-check-all: SUCCESS (11.603s) [59.505639] [017/139] (938s left) kms_cursor_crc (cursor-sliding-256x256) [59.692029] Starting subtest: cursor-sliding-256x256 [59.694777] Starting dynamic subtest: pipe-A-eDP-1 [63.205840] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.510s) [63.236262] Starting dynamic subtest: pipe-D-eDP-1 [67.414968] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.187s) [67.417726] Subtest cursor-sliding-256x256: SUCCESS (7.723s) [68.293737] [018/139] (930s left) v3d/v3d_get_param (base-params) [68.370703] Subtest base-params: SKIP (0.000s) [68.411036] [019/139] (930s left) kms_flip (flip-vs-dpms-off-vs-modeset) [68.457216] Starting subtest: flip-vs-dpms-off-vs-modeset [68.459655] Starting dynamic subtest: A-eDP1 [72.381937] Dynamic subtest A-eDP1: SUCCESS (3.926s) [72.394297] Starting dynamic subtest: B-eDP1 [75.839243] Dynamic subtest B-eDP1: SUCCESS (3.454s) [75.851720] Starting dynamic subtest: C-eDP1 [79.260816] Dynamic subtest C-eDP1: SUCCESS (3.423s) [79.273232] Starting dynamic subtest: D-eDP1 [82.712586] Dynamic subtest D-eDP1: SUCCESS (3.452s) [82.717657] Subtest flip-vs-dpms-off-vs-modeset: SUCCESS (14.266s) [83.586523] [020/139] (914s left) gem_exec_flush (basic-wb-rw-default) [83.642136] Starting subtest: basic-wb-rw-default [89.095704] Subtest basic-wb-rw-default: SUCCESS (5.457s) [89.273590] [021/139] (909s left) kms_ccs (pipe-d-crc-sprite-planes-basic-4-tiled-mtl-mc-ccs) [89.690887] Starting subtest: pipe-D-crc-sprite-planes-basic-4-tiled-mtl-mc-ccs [95.023569] Subtest pipe-D-crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (5.331s) [96.231574] [022/139] (902s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling) [96.314940] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling [96.317620] Starting dynamic subtest: pipe-A-default-mode [96.658459] Dynamic subtest pipe-A-default-mode: SKIP (0.340s) [96.663682] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.341s) [97.476128] [023/139] (901s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt) [97.586313] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt [97.590941] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [97.658206] [024/139] (900s left) kms_busy (extended-modeset-hang-oldfb) [97.736512] Starting subtest: extended-modeset-hang-oldfb [97.740780] Starting dynamic subtest: pipe-A [112.435354] Dynamic subtest pipe-A: SUCCESS (14.696s) [112.450589] Starting dynamic subtest: pipe-D [137.381780] Dynamic subtest pipe-D: SUCCESS (24.941s) [137.385256] Subtest extended-modeset-hang-oldfb: SUCCESS (39.646s) [138.264206] [025/139] (860s left) kms_vblank (wait-forked) [138.339697] Starting subtest: wait-forked [138.342052] Starting dynamic subtest: pipe-A-eDP-1 [140.163663] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.823s) [140.176874] Starting dynamic subtest: pipe-D-eDP-1 [142.789492] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.614s) [142.792197] Subtest wait-forked: SUCCESS (4.444s) [143.718856] [026/139] (854s left) i915_pm_rpm (gem-execbuf-stress-pc8) [155.304585] Starting subtest: gem-execbuf-stress-pc8 [155.347711] Subtest gem-execbuf-stress-pc8: SKIP (0.040s) [156.323278] [027/139] (842s left) gem_ctx_isolation (nonpriv-switch) [156.386836] Starting subtest: nonpriv-switch [156.389299] Starting dynamic subtest: rcs0 [156.587022] Dynamic subtest rcs0: SUCCESS (0.200s) [156.601409] Starting dynamic subtest: bcs0 [156.854773] Dynamic subtest bcs0: SUCCESS (0.267s) [156.865965] Starting dynamic subtest: vcs0 [157.081685] Dynamic subtest vcs0: SUCCESS (0.227s) [157.094731] Starting dynamic subtest: vcs1 [158.682031] Dynamic subtest vcs1: SUCCESS (1.600s) [158.687333] Starting dynamic subtest: vecs0 [160.667029] Dynamic subtest vecs0: SUCCESS (1.985s) [160.680100] Starting dynamic subtest: ccs0 [162.688552] Dynamic subtest ccs0: SUCCESS (2.021s) [162.691744] Subtest nonpriv-switch: SUCCESS (6.302s) [162.904395] [028/139] (835s left) kms_addfb_basic (bad-pitch-128) [162.954341] Starting subtest: bad-pitch-128 [162.956478] Subtest bad-pitch-128: SUCCESS (0.000s) [163.073227] [029/139] (835s left) kms_ccs (pipe-a-random-ccs-data-yf-tiled-ccs) [163.433272] Starting subtest: pipe-A-random-ccs-data-yf-tiled-ccs [163.441261] Subtest pipe-A-random-ccs-data-yf-tiled-ccs: SKIP (0.000s) [164.323585] [030/139] (834s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render) [164.394449] Starting subtest: fbcpsr-rgb101010-draw-render [169.195436] Subtest fbcpsr-rgb101010-draw-render: SUCCESS (4.805s) [169.309137] [031/139] (829s left) gem_mmap_gtt (cpuset-big-copy-odd) [169.365922] Subtest cpuset-big-copy-odd: SKIP (0.000s) [169.397236] [032/139] (829s left) kms_flip (flip-vs-rmfb) [169.456141] Starting subtest: flip-vs-rmfb [169.458594] Starting dynamic subtest: A-eDP1 [178.193120] Dynamic subtest A-eDP1: SUCCESS (8.739s) [178.206051] Starting dynamic subtest: B-eDP1 [186.961058] Dynamic subtest B-eDP1: SUCCESS (8.766s) [186.973769] Starting dynamic subtest: C-eDP1 [195.718971] Dynamic subtest C-eDP1: SUCCESS (8.756s) [195.731887] Starting dynamic subtest: D-eDP1 [204.485940] Dynamic subtest D-eDP1: SUCCESS (8.765s) [204.493373] Subtest flip-vs-rmfb: SUCCESS (35.042s) [205.743549] [033/139] (793s left) kms_cursor_crc (cursor-offscreen-128x128) [205.886925] Starting subtest: cursor-offscreen-128x128 [205.889489] Starting dynamic subtest: pipe-A-eDP-1 [207.868161] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.979s) [207.908284] Starting dynamic subtest: pipe-D-eDP-1 [210.566692] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.669s) [210.569262] Subtest cursor-offscreen-128x128: SUCCESS (4.681s) [211.446223] [034/139] (787s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt) [211.537056] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt [211.541416] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [211.621360] [035/139] (787s left) kms_chamelium_frames (hdmi-crc-single) [211.966241] Subtest hdmi-crc-single: SKIP (0.000s) [212.809954] [036/139] (786s left) syncobj_timeline (invalid-single-wait-all-available-unsubmitted) [212.860207] Starting subtest: invalid-single-wait-all-available-unsubmitted [212.907789] Subtest invalid-single-wait-all-available-unsubmitted: FAIL (0.025s) [212.950189] [037/139] (786s left) gem_exec_schedule (reorder-wide) [213.128264] Subtest reorder-wide: SKIP (0.000s) [213.301495] [038/139] (785s left) syncobj_wait (wait-any-snapshot) [213.356874] Starting subtest: wait-any-snapshot [213.435365] Subtest wait-any-snapshot: SUCCESS (0.082s) [213.503275] [039/139] (785s left) kms_frontbuffer_tracking (fbc-modesetfrombusy) [213.601608] Starting subtest: fbc-modesetfrombusy [216.495039] Subtest fbc-modesetfrombusy: SUCCESS (2.900s) [216.602582] [040/139] (782s left) kms_psr (psr2_cursor_mmap_gtt) [216.684204] Starting subtest: psr2_cursor_mmap_gtt [218.189107] Subtest psr2_cursor_mmap_gtt: SKIP (1.501s) [218.357349] [041/139] (780s left) gem_exec_params (secure-non-master) [218.418038] Starting subtest: secure-non-master [218.423340] Subtest secure-non-master: SKIP (0.000s) [218.497987] [042/139] (780s left) vc4/vc4_purgeable_bo (mark-purgeable-twice) [218.584575] Subtest mark-purgeable-twice: SKIP (0.000s) [218.627287] [043/139] (780s left) kms_sequence (queue-idle) [218.709997] Starting subtest: queue-idle [218.712780] Starting dynamic subtest: pipe-A-eDP-1 [220.509359] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.800s) [220.520847] Starting dynamic subtest: pipe-B-eDP-1 [223.069091] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.559s) [223.080850] Starting dynamic subtest: pipe-C-eDP-1 [225.627943] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.556s) [225.640923] Starting dynamic subtest: pipe-D-eDP-1 [228.166898] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.535s) [228.169642] Subtest queue-idle: SUCCESS (9.459s) [229.092746] [044/139] (770s left) dmabuf_sync_file (export-before-signal) [229.164186] Starting subtest: export-before-signal [229.166630] Subtest export-before-signal: SUCCESS (0.001s) [229.208772] [045/139] (769s left) gem_render_copy (yf-tiled) [229.275635] Starting subtest: yf-tiled [229.280208] Subtest yf-tiled: SKIP (0.000s) [229.452903] [046/139] (769s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-pwrite) [229.538649] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-pwrite [234.552329] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-pwrite: SUCCESS (5.020s) [234.682110] [047/139] (764s left) kms_ccs (pipe-c-crc-primary-rotation-180-y-tiled-gen12-mc-ccs) [235.067898] Starting subtest: pipe-C-crc-primary-rotation-180-y-tiled-gen12-mc-ccs [235.073698] Subtest pipe-C-crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.000s) [235.940951] [048/139] (763s left) sw_sync (alloc_merge_fence) [235.995158] Starting subtest: alloc_merge_fence [235.997481] Subtest alloc_merge_fence: SUCCESS (0.000s) [236.045512] [049/139] (763s left) kms_flip (2x-flip-vs-panning-vs-hang) [236.107750] Starting subtest: 2x-flip-vs-panning-vs-hang [236.119472] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.013s) [236.190093] [050/139] (763s left) syncobj_eventfd (invalid-bad-pad) [236.258629] Starting subtest: invalid-bad-pad [236.261336] Subtest invalid-bad-pad: SUCCESS (0.000s) [236.324098] [051/139] (763s left) kms_ccs (pipe-b-bad-pixel-format-4-tiled-mtl-rc-ccs-cc) [236.691398] Starting subtest: pipe-B-bad-pixel-format-4-tiled-mtl-rc-ccs-cc [236.694411] Subtest pipe-B-bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.000s) [237.597977] [052/139] (761s left) gem_softpin (32b-excludes-last-page) [237.649325] Starting subtest: 32b-excludes-last-page [237.655564] Subtest 32b-excludes-last-page: SUCCESS (0.006s) [237.754030] [053/139] (761s left) i915_suspend (debugfs-reader) [237.807251] Starting subtest: debugfs-reader [257.079926] Subtest debugfs-reader: SUCCESS (3.284s) [257.197317] [054/139] (758s left) gem_workarounds (suspend-resume-context) [257.277229] Starting subtest: suspend-resume-context [273.148625] Subtest suspend-resume-context: SUCCESS (1.296s) [273.248418] [055/139] (756s left) i915_pm_freq_api (freq-reset-multiple) [273.297864] Starting subtest: freq-reset-multiple [273.300178] Starting dynamic subtest: gt0 [283.669401] Dynamic subtest gt0: SUCCESS (10.369s) [283.685132] Starting dynamic subtest: gt1 [292.650638] Dynamic subtest gt1: SUCCESS (8.981s) [292.652982] Subtest freq-reset-multiple: SUCCESS (19.351s) [292.717759] [056/139] (737s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move) [292.797835] Starting subtest: psr-2p-primscrn-cur-indfb-move [292.802438] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [292.886728] [057/139] (737s left) debugfs_test (read_all_entries) [292.940513] Starting subtest: read_all_entries [293.176025] Subtest read_all_entries: SUCCESS (0.238s) [293.243497] [058/139] (736s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-gtt) [293.326514] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-gtt [293.331178] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [293.407989] [059/139] (736s left) kms_universal_plane (universal-plane-functional) [293.474681] Starting subtest: universal-plane-functional [293.477181] Starting dynamic subtest: pipe-A-eDP-1 [297.691702] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.213s) [297.706946] Starting dynamic subtest: pipe-B-eDP-1 [302.522837] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.829s) [302.536820] Starting dynamic subtest: pipe-C-eDP-1 [307.170585] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.645s) [307.186783] Starting dynamic subtest: pipe-D-eDP-1 [311.856207] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.681s) [311.858924] Subtest universal-plane-functional: SUCCESS (18.380s) [312.782146] [060/139] (717s left) perf (polling) [312.927352] Starting subtest: polling [312.929271] Starting dynamic subtest: 0-rcs0 [322.946775] Dynamic subtest 0-rcs0: SUCCESS (10.017s) [322.957633] Starting dynamic subtest: 1-vcs1 [332.964014] Dynamic subtest 1-vcs1: SUCCESS (10.018s) [332.966901] Subtest polling: SUCCESS (20.037s) [333.005836] [061/139] (697s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180) [333.113350] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180 [334.323444] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.211s) [334.439526] [062/139] (695s left) kms_flip (2x-flip-vs-wf_vblank) [334.486336] Starting subtest: 2x-flip-vs-wf_vblank [334.496612] Subtest 2x-flip-vs-wf_vblank: SKIP (0.013s) [334.575182] [063/139] (695s left) kms_ccs (pipe-a-crc-primary-basic-4-tiled-dg2-rc-ccs-cc) [334.934507] Starting subtest: pipe-A-crc-primary-basic-4-tiled-dg2-rc-ccs-cc [334.939329] Subtest pipe-A-crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.001s) [335.823352] [064/139] (694s left) gem_exec_balancer (parallel-keep-in-fence) [336.049955] Starting subtest: parallel-keep-in-fence [336.984069] Subtest parallel-keep-in-fence: SUCCESS (0.934s) [337.048888] [065/139] (693s left) gem_mmap_wc (read-write-distinct) [337.098262] Subtest read-write-distinct: SKIP (0.000s) [337.128470] [066/139] (693s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled) [337.180378] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled [337.182489] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s) [337.241533] [067/139] (693s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc) [337.313005] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc [341.989857] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (4.681s) [342.130910] [068/139] (688s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt) [342.203553] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt [342.207886] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [342.283493] [069/139] (688s left) kms_panel_fitting (legacy) [342.349215] Starting subtest: legacy [342.351736] Starting dynamic subtest: pipe-A-eDP-1 [342.910873] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.563s) [342.943860] Starting dynamic subtest: pipe-B-eDP-1 [344.593340] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.661s) [344.628035] Starting dynamic subtest: pipe-C-eDP-1 [346.291434] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.674s) [346.320935] Starting dynamic subtest: pipe-D-eDP-1 [347.954104] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.642s) [347.956531] Subtest legacy: SUCCESS (5.605s) [349.196674] [070/139] (681s left) gem_exec_fair (basic-pace) [349.268325] Subtest basic-pace: SKIP (0.000s) [349.294397] [071/139] (681s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render) [349.386308] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render [352.144351] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (2.766s) [352.277602] [072/139] (678s left) kms_ccs (pipe-b-crc-sprite-planes-basic-y-tiled-gen12-mc-ccs) [352.660451] Starting subtest: pipe-B-crc-sprite-planes-basic-y-tiled-gen12-mc-ccs [352.665729] Subtest pipe-B-crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.001s) [353.501824] [073/139] (677s left) syncobj_timeline (wait-all-complex) [353.580706] Starting subtest: wait-all-complex [353.798360] Subtest wait-all-complex: SUCCESS (0.219s) [353.871380] [074/139] (676s left) gem_mmap_offset (blt-coherency) [353.920557] Starting subtest: blt-coherency [353.933717] Subtest blt-coherency: SUCCESS (0.014s) [354.033037] [075/139] (676s left) gen9_exec_parse (bb-chained) [354.106888] Subtest bb-chained: SKIP (0.000s) [354.143782] [076/139] (676s left) gem_ctx_param (invalid-get-ringsize) [354.186239] Starting subtest: invalid-get-ringsize [354.188443] Subtest invalid-get-ringsize: SUCCESS (0.000s) [354.247322] [077/139] (676s left) kms_ccs (pipe-a-crc-primary-basic-y-tiled-gen12-mc-ccs) [354.596989] Starting subtest: pipe-A-crc-primary-basic-y-tiled-gen12-mc-ccs [354.601709] Subtest pipe-A-crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.001s) [355.466450] [078/139] (675s left) gem_ctx_shared (exec-single-timeline) [355.537367] Starting subtest: exec-single-timeline [355.539955] Starting dynamic subtest: rcs0 [356.654528] Dynamic subtest rcs0: SUCCESS (1.115s) [356.671720] Starting dynamic subtest: bcs0 [357.742140] Dynamic subtest bcs0: SUCCESS (1.086s) [357.760641] Starting dynamic subtest: vcs0 [358.831157] Dynamic subtest vcs0: SUCCESS (1.087s) [358.848774] Starting dynamic subtest: vcs1 [359.919303] Dynamic subtest vcs1: SUCCESS (1.086s) [359.936698] Starting dynamic subtest: vecs0 [361.005982] Dynamic subtest vecs0: SUCCESS (1.085s) [361.023289] Starting dynamic subtest: ccs0 [362.095370] Dynamic subtest ccs0: SUCCESS (1.087s) [362.097937] Subtest exec-single-timeline: SUCCESS (6.557s) [363.067174] [079/139] (667s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt) [363.159656] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt [363.163951] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [363.254756] [080/139] (667s left) syncobj_timeline (wait-for-submit-complex) [363.311187] Starting subtest: wait-for-submit-complex [363.369907] Subtest wait-for-submit-complex: SUCCESS (0.062s) [363.439847] [081/139] (667s left) v3d/v3d_submit_cl (bad-extension) [363.529191] Subtest bad-extension: SKIP (0.000s) [363.581506] [082/139] (667s left) sw_sync (alloc_fence_invalid_timeline) [363.634393] Starting subtest: alloc_fence_invalid_timeline [363.637009] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s) [363.690204] [083/139] (667s left) kms_flip (2x-flip-vs-blocking-wf-vblank) [363.758903] Starting subtest: 2x-flip-vs-blocking-wf-vblank [363.775611] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.019s) [363.850918] [084/139] (667s left) kms_cursor_crc (cursor-onscreen-512x170) [364.115464] Starting subtest: cursor-onscreen-512x170 [364.119511] Subtest cursor-onscreen-512x170: SKIP (0.001s) [364.239983] [085/139] (666s left) kms_setmode (basic) [364.292322] Starting subtest: basic [364.622338] Starting dynamic subtest: pipe-A-eDP-1 [366.744847] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.118s) [367.112720] Starting dynamic subtest: pipe-B-eDP-1 [369.232601] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.127s) [369.553006] Subtest basic: SUCCESS (5.259s) [370.446815] [086/139] (660s left) gem_workarounds (basic-read-context) [370.520373] Starting subtest: basic-read-context [370.535037] Subtest basic-read-context: SUCCESS (0.012s) [370.636654] [087/139] (660s left) api_intel_allocator (fork-simple-stress-signal) [370.690234] Starting subtest: fork-simple-stress-signal [376.085921] Subtest fork-simple-stress-signal: SUCCESS (5.397s) [376.190409] [088/139] (654s left) kms_ccs (pipe-b-crc-primary-basic-y-tiled-gen12-rc-ccs) [376.571130] Starting subtest: pipe-B-crc-primary-basic-y-tiled-gen12-rc-ccs [376.577261] Subtest pipe-B-crc-primary-basic-y-tiled-gen12-rc-ccs: SKIP (0.000s) [377.483985] [089/139] (653s left) vgem_basic (create) [377.529445] Starting subtest: create [377.532258] Subtest create: SUCCESS (0.000s) [377.568760] [090/139] (653s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt) [377.643150] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt [377.647847] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [377.750631] [091/139] (653s left) gem_exec_whisper (basic-sync) [377.815648] Starting subtest: basic-sync [386.266104] Subtest basic-sync: SUCCESS (8.451s) [386.449081] [092/139] (644s left) kms_big_fb (4-tiled-64bpp-rotate-180) [386.511430] Starting subtest: 4-tiled-64bpp-rotate-180 [388.125881] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.618s) [388.336347] [093/139] (642s left) gem_userptr_blits (unsync-unmap-after-close) [388.386704] Subtest unsync-unmap-after-close: SKIP (0.000s) [388.478512] [094/139] (642s left) kms_big_fb (yf-tiled-64bpp-rotate-90) [388.543708] Starting subtest: yf-tiled-64bpp-rotate-90 [388.547516] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s) [388.633714] [095/139] (642s left) kms_pm_rpm (dpms-mode-unset-non-lpsp) [400.220058] Starting subtest: dpms-mode-unset-non-lpsp [404.045616] Subtest dpms-mode-unset-non-lpsp: SKIP (3.823s) [404.857913] [096/139] (626s left) gem_exec_flush (basic-batch-kernel-default-cmd) [404.912819] Starting subtest: basic-batch-kernel-default-cmd [404.918207] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s) [405.096210] [097/139] (626s left) drm_fdinfo (virtual-busy) [405.145922] Starting subtest: virtual-busy [405.150609] Subtest virtual-busy: SKIP (0.000s) [405.210960] [098/139] (626s left) syncobj_basic (bad-pad-fd-to-handle) [405.249542] Starting subtest: bad-pad-fd-to-handle [405.251908] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s) [405.311781] [099/139] (626s left) syncobj_basic (bad-destroy) [405.377894] Starting subtest: bad-destroy [405.380252] Subtest bad-destroy: SUCCESS (0.000s) [405.441392] [100/139] (625s left) v3d/v3d_submit_csd (bad-multisync-in-sync) [405.491914] Subtest bad-multisync-in-sync: SKIP (0.000s) [405.541086] [101/139] (625s left) kms_atomic_transition (plane-all-modeset-transition-internal-panels) [405.628546] Starting subtest: plane-all-modeset-transition-internal-panels [405.631012] Starting dynamic subtest: pipe-A-eDP-1 [407.304885] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.677s) [407.639724] Starting dynamic subtest: pipe-B-eDP-1 [409.008580] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.380s) [409.318180] Subtest plane-all-modeset-transition-internal-panels: SUCCESS (3.690s) [410.253855] [102/139] (621s left) kms_hdr (invalid-hdr) [410.312592] Starting subtest: invalid-hdr [411.479871] Starting dynamic subtest: pipe-A-eDP-1 [414.827906] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.348s) [414.830921] Subtest invalid-hdr: SUCCESS (4.517s) [414.912118] [103/139] (616s left) core_auth (getclient-master-drop) [414.971893] Starting subtest: getclient-master-drop [414.977260] Subtest getclient-master-drop: SUCCESS (0.003s) [415.044225] [104/139] (616s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt) [415.121045] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt [415.125018] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [415.202774] [105/139] (616s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt) [415.273722] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt [415.278472] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s) [415.340691] [106/139] (616s left) kms_atomic (atomic-plane-damage) [415.390353] Starting subtest: atomic-plane-damage [416.541374] Starting dynamic subtest: pipe-A-eDP-1 [417.176609] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.635s) [417.179369] Subtest atomic-plane-damage: SUCCESS (1.788s) [418.062238] [107/139] (613s left) kms_plane (plane-panning-bottom-right) [418.131496] Starting subtest: plane-panning-bottom-right [418.133989] Starting dynamic subtest: pipe-A [419.868083] Dynamic subtest pipe-A: SUCCESS (1.735s) [419.883592] Starting dynamic subtest: pipe-B [422.404432] Dynamic subtest pipe-B: SUCCESS (2.537s) [422.407276] Subtest plane-panning-bottom-right: SUCCESS (4.277s) [423.310167] [108/139] (608s left) kms_ccs (pipe-d-random-ccs-data-y-tiled-gen12-rc-ccs-cc) [423.711946] Starting subtest: pipe-D-random-ccs-data-y-tiled-gen12-rc-ccs-cc [423.721116] Subtest pipe-D-random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s) [424.589086] [109/139] (607s left) kms_ccs (pipe-c-bad-pixel-format-4-tiled-mtl-rc-ccs-cc) [424.964447] Starting subtest: pipe-C-bad-pixel-format-4-tiled-mtl-rc-ccs-cc [424.967412] Subtest pipe-C-bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.000s) [425.872116] [110/139] (605s left) gem_exec_whisper (basic-fds-forked-all) [425.929082] Starting subtest: basic-fds-forked-all [457.255509] Subtest basic-fds-forked-all: SUCCESS (31.325s) [457.437685] [111/139] (574s left) kms_big_fb (y-tiled-16bpp-rotate-0) [457.521775] Starting subtest: y-tiled-16bpp-rotate-0 [457.526097] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s) [457.608176] [112/139] (574s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc) [457.677772] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc [457.682412] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [457.770045] [113/139] (574s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip) [457.862673] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip [458.677675] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.814s) [458.887257] [114/139] (572s left) syncobj_wait (wait-all-interrupted) [458.937936] Starting subtest: wait-all-interrupted [459.045812] Subtest wait-all-interrupted: SUCCESS (0.109s) [459.113656] [115/139] (572s left) gem_exec_fence (syncobj-timeline-export) [459.664974] Starting subtest: syncobj-timeline-export [459.672382] Subtest syncobj-timeline-export: SUCCESS (0.009s) [461.068530] [116/139] (570s left) gem_exec_fence (syncobj-timeline-unused-fence) [461.625145] Starting subtest: syncobj-timeline-unused-fence [461.633118] Subtest syncobj-timeline-unused-fence: SUCCESS (0.009s) [463.066955] [117/139] (568s left) kms_ccs (pipe-d-crc-primary-basic-4-tiled-mtl-rc-ccs) [463.468442] Starting subtest: pipe-D-crc-primary-basic-4-tiled-mtl-rc-ccs [464.456806] Subtest pipe-D-crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (0.989s) [465.678310] [118/139] (566s left) perf_pmu (busy-double-start) [465.736997] Starting subtest: busy-double-start [465.739282] Starting dynamic subtest: rcs0 [469.302086] Dynamic subtest rcs0: SUCCESS (3.566s) [469.319608] Starting dynamic subtest: bcs0 [472.923842] Dynamic subtest bcs0: FAIL (3.575s) [472.940987] Starting dynamic subtest: vcs0 [476.511190] Dynamic subtest vcs0: SUCCESS (3.632s) [476.528205] Starting dynamic subtest: vcs1 [480.547440] Dynamic subtest vcs1: SUCCESS (4.035s) [480.564505] Starting dynamic subtest: vecs0 [484.558399] Dynamic subtest vecs0: SUCCESS (4.010s) [484.575864] Starting dynamic subtest: ccs0 [488.129460] Dynamic subtest ccs0: SUCCESS (3.570s) [488.132069] Subtest busy-double-start: FAIL (22.395s) [488.226166] [119/139] (543s left) kms_hdmi_inject (inject-audio) [488.591331] Starting subtest: inject-audio [488.596433] Subtest inject-audio: SKIP (0.000s) [489.481530] [120/139] (542s left) kms_cursor_legacy (single-move) [489.546698] Starting subtest: single-move [489.549310] Starting dynamic subtest: pipe-A [494.931373] Dynamic subtest pipe-A: SUCCESS (5.378s) [494.947874] Starting dynamic subtest: pipe-B [500.308293] Dynamic subtest pipe-B: SUCCESS (5.377s) [500.325334] Starting dynamic subtest: pipe-C [505.685092] Dynamic subtest pipe-C: SUCCESS (5.377s) [505.701595] Starting dynamic subtest: pipe-D [511.062677] Dynamic subtest pipe-D: SUCCESS (5.377s) [511.079406] Starting dynamic subtest: all-pipes [516.440531] Dynamic subtest all-pipes: SUCCESS (5.378s) [516.443366] Subtest single-move: SUCCESS (26.890s) [516.566553] [121/139] (515s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render) [516.674533] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render [521.531508] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (4.860s) [521.638859] [122/139] (510s left) kms_ccs (pipe-d-bad-pixel-format-4-tiled-dg2-mc-ccs) [522.016482] Starting subtest: pipe-D-bad-pixel-format-4-tiled-dg2-mc-ccs [522.022201] Subtest pipe-D-bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.000s) [522.891479] [123/139] (509s left) kms_pm_dc (dc6-psr) [534.056978] Starting subtest: dc6-psr [541.258272] Subtest dc6-psr: FAIL (7.038s) [541.284537] [124/139] (490s left) gem_mmap_wc (pf-nonblock) [541.327810] Subtest pf-nonblock: SKIP (0.000s) [541.352153] [125/139] (490s left) gen7_exec_parse (basic-rejected) [541.409603] Subtest basic-rejected: SKIP (0.000s) [541.442786] [126/139] (490s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [541.538768] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [541.543400] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [541.620900] [127/139] (490s left) gem_exec_schedule (noreorder-corked) [541.782621] Starting subtest: noreorder-corked [541.785194] Starting dynamic subtest: rcs0 [542.924393] Dynamic subtest rcs0: SUCCESS (1.142s) [542.940782] Starting dynamic subtest: vcs0 [545.994984] Dynamic subtest vcs0: SUCCESS (3.068s) [546.012836] Starting dynamic subtest: vcs1 [547.971841] Dynamic subtest vcs1: SUCCESS (1.976s) [547.990102] Starting dynamic subtest: vecs0 [550.019734] Dynamic subtest vecs0: SUCCESS (2.047s) [550.037472] Starting dynamic subtest: ccs0 [551.176226] Dynamic subtest ccs0: SUCCESS (1.157s) [551.178663] Subtest noreorder-corked: SUCCESS (9.395s) [551.358238] [128/139] (480s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen) [551.439838] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen [551.444241] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [551.522273] [129/139] (480s left) kms_cursor_legacy (cursorb-vs-flipb-legacy) [551.610618] Starting subtest: cursorB-vs-flipB-legacy [551.615186] Subtest cursorB-vs-flipB-legacy: SKIP (0.001s) [551.697968] [130/139] (480s left) gem_ctx_sseu (mmap-args) [551.738237] Subtest mmap-args: SKIP (0.000s) [551.761656] [131/139] (480s left) kms_ccs (pipe-c-crc-sprite-planes-basic-y-tiled-gen12-rc-ccs) [552.149483] Starting subtest: pipe-C-crc-sprite-planes-basic-y-tiled-gen12-rc-ccs [552.154756] Subtest pipe-C-crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.001s) [553.037426] [132/139] (479s left) kms_color (ctm-green-to-red) [553.105769] Starting subtest: ctm-green-to-red [553.108379] Starting dynamic subtest: pipe-A [553.840430] Dynamic subtest pipe-A: SUCCESS (0.734s) [553.858373] Starting dynamic subtest: pipe-B [555.367181] Dynamic subtest pipe-B: SUCCESS (1.523s) [555.385942] Starting dynamic subtest: pipe-C [556.853451] Dynamic subtest pipe-C: SUCCESS (1.490s) [556.867529] Starting dynamic subtest: pipe-D [558.304647] Dynamic subtest pipe-D: SUCCESS (1.448s) [558.307268] Subtest ctm-green-to-red: SUCCESS (5.199s) [559.181998] [133/139] (473s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc) [559.244596] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc [562.345800] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (3.109s) [562.467470] [134/139] (469s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt) [562.534726] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt [562.538085] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [562.618662] [135/139] (469s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled) [562.671259] Starting subtest: multi-wait-for-submit-available-submitted-signaled [562.673419] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.001s) [562.741919] [136/139] (469s left) api_intel_allocator (fork-simple-stress) [562.778957] Starting subtest: fork-simple-stress [568.173705] Subtest fork-simple-stress: SUCCESS (5.395s) [568.297449] [137/139] (464s left) kms_plane_alpha_blend (alpha-basic) [568.367758] Starting subtest: alpha-basic [568.648021] Starting dynamic subtest: pipe-A-eDP-1 [570.591135] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.942s) [570.628284] Starting dynamic subtest: pipe-D-eDP-1 [573.365235] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.741s) [573.367837] Subtest alpha-basic: SUCCESS (4.994s) [574.287772] [138/139] (458s left) gem_userptr_blits (map-fixed-invalidate) [574.362616] Starting subtest: map-fixed-invalidate [574.367640] Subtest map-fixed-invalidate: SKIP (0.000s) [574.469072] [139/139] (458s left) kms_big_fb (x-tiled-32bpp-rotate-0) [574.560865] Starting subtest: x-tiled-32bpp-rotate-0 [576.168487] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.608s) [576.295009] Closing watchdogs Done.