[51.625182] Initializing watchdogs [51.625642] /dev/watchdog0 [51.658568] [001/141] (960s left) kms_prop_blob (blob-prop-lifetime) [52.058126] Starting subtest: blob-prop-lifetime [52.062071] Subtest blob-prop-lifetime: SUCCESS (0.005s) [52.226849] [002/141] (959s left) syncobj_wait (single-wait-all-for-submit-submitted) [52.602827] Starting subtest: single-wait-all-for-submit-submitted [52.712991] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.108s) [52.870793] [003/141] (959s left) kms_getfb (getfb2-handle-not-fb) [53.239127] Starting subtest: getfb2-handle-not-fb [53.360426] Subtest getfb2-handle-not-fb: SUCCESS (0.121s) [53.526426] [004/141] (958s left) gem_exec_whisper (basic-contexts-forked-all) [53.961595] Starting subtest: basic-contexts-forked-all [128.899777] Subtest basic-contexts-forked-all: SUCCESS (74.935s) [129.188766] [005/141] (883s left) kms_chamelium_color (ctm-green-to-red) [129.683723] Subtest ctm-green-to-red: SKIP (0.000s) [129.785121] [006/141] (882s left) kms_vblank (pipe-c-ts-continuation-modeset) [130.268360] Starting subtest: pipe-C-ts-continuation-modeset [133.664607] Subtest pipe-C-ts-continuation-modeset: SUCCESS (3.395s) [134.645701] [007/141] (877s left) kms_frontbuffer_tracking (fbc-1p-rte) [135.143109] Starting subtest: fbc-1p-rte [143.371875] Subtest fbc-1p-rte: SUCCESS (8.237s) [143.657214] [008/141] (868s left) syncobj_timeline (signal) [144.042194] Starting subtest: signal [144.047150] Subtest signal: SUCCESS (0.002s) [144.184326] [009/141] (868s left) kms_ccs (pipe-d-bad-rotation-90-4_tiled_mtl_mc_ccs) [145.814772] Starting subtest: pipe-D-bad-rotation-90-4_tiled_mtl_mc_ccs [149.192854] Subtest pipe-D-bad-rotation-90-4_tiled_mtl_mc_ccs: SUCCESS (3.375s) [150.623115] [010/141] (862s left) kms_psr2_sf (primary-plane-update-sf-dmg-area-big-fb) [157.776302] Starting subtest: primary-plane-update-sf-dmg-area-big-fb [157.784097] Starting dynamic subtest: pipe-A-eDP-1 [177.617506] Dynamic subtest pipe-A-eDP-1: SUCCESS (19.832s) [177.687812] Starting dynamic subtest: pipe-B-eDP-1 [199.010592] Dynamic subtest pipe-B-eDP-1: SUCCESS (21.381s) [199.014333] Subtest primary-plane-update-sf-dmg-area-big-fb: SUCCESS (41.229s) [199.995794] [011/141] (812s left) perf (whitelisted-registers-userspace-config) [200.964143] Starting subtest: whitelisted-registers-userspace-config [200.967884] Subtest whitelisted-registers-userspace-config: SUCCESS (0.005s) [201.061189] [012/141] (811s left) kms_plane_cursor (primary) [201.555367] Starting subtest: primary [201.562326] Starting dynamic subtest: pipe-A-eDP-1-size-64 [207.720168] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (6.156s) [207.792170] Starting dynamic subtest: pipe-A-eDP-1-size-128 [214.305156] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (6.540s) [214.388761] Starting dynamic subtest: pipe-A-eDP-1-size-256 [220.892808] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (6.538s) [221.365841] Starting dynamic subtest: pipe-B-eDP-1-size-64 [227.634549] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (6.301s) [227.710689] Starting dynamic subtest: pipe-B-eDP-1-size-128 [234.413494] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (6.728s) [234.488746] Starting dynamic subtest: pipe-B-eDP-1-size-256 [240.913138] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (6.448s) [241.348677] Starting dynamic subtest: pipe-C-eDP-1-size-64 [246.328523] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (5.010s) [246.399568] Starting dynamic subtest: pipe-C-eDP-1-size-128 [252.013438] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (5.652s) [252.085085] Starting dynamic subtest: pipe-C-eDP-1-size-256 [258.042050] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (5.983s) [258.448171] Starting dynamic subtest: pipe-D-eDP-1-size-64 [264.408447] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (5.990s) [264.467176] Starting dynamic subtest: pipe-D-eDP-1-size-128 [268.742584] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (4.307s) [268.808400] Starting dynamic subtest: pipe-D-eDP-1-size-256 [273.959101] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (5.184s) [274.372443] Subtest primary: SUCCESS (72.815s) [275.309769] [013/141] (737s left) gem_lmem_swapping (parallel-random-engines) [275.712182] Subtest parallel-random-engines: SKIP (0.000s) [275.823255] [014/141] (737s left) prime_vgem (basic-fence-blt) [276.372779] Starting subtest: basic-fence-blt [276.644151] Subtest basic-fence-blt: FAIL (0.266s) [276.835900] [015/141] (736s left) kms_ccs (pipe-b-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc) [278.005753] Starting subtest: pipe-B-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc [280.375296] Subtest pipe-B-crc-sprite-planes-basic-4_tiled_mtl_rc_ccs_cc: SUCCESS (2.369s) [281.660687] [016/141] (731s left) kms_ccs (pipe-b-bad-rotation-90-y_tiled_ccs) [282.773783] Starting subtest: pipe-B-bad-rotation-90-y_tiled_ccs [282.779932] Subtest pipe-B-bad-rotation-90-y_tiled_ccs: SKIP (0.000s) [284.002789] [017/141] (729s left) vc4/vc4_perfmon (create-perfmon-0) [284.477087] Subtest create-perfmon-0: SKIP (0.000s) [284.608130] [018/141] (728s left) kms_plane_scaling (plane-scaler-with-pixel-format-unity-scaling) [285.091724] Starting subtest: plane-scaler-with-pixel-format-unity-scaling [285.100545] Starting dynamic subtest: pipe-A-eDP-1 [312.082174] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.980s) [312.126463] Starting dynamic subtest: pipe-B-eDP-1 [342.890966] Dynamic subtest pipe-B-eDP-1: SUCCESS (30.800s) [342.941132] Starting dynamic subtest: pipe-C-eDP-1 [344.798588] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.897s) [344.848399] Starting dynamic subtest: pipe-D-eDP-1 [346.728896] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.919s) [346.732543] Subtest plane-scaler-with-pixel-format-unity-scaling: SUCCESS (61.641s) [348.315855] [019/141] (665s left) gem_exec_balancer (sliced) [348.753817] Starting subtest: sliced [348.760270] Subtest sliced: SKIP (0.000s) [349.739275] [020/141] (663s left) kms_ccs (pipe-c-crc-primary-rotation-180-4_tiled_dg2_rc_ccs) [351.183306] Starting subtest: pipe-C-crc-primary-rotation-180-4_tiled_dg2_rc_ccs [351.189988] Subtest pipe-C-crc-primary-rotation-180-4_tiled_dg2_rc_ccs: SKIP (0.002s) [352.150914] [021/141] (661s left) kms_ccs (pipe-a-crc-primary-basic-4_tiled_mtl_rc_ccs) [353.060992] Starting subtest: pipe-A-crc-primary-basic-4_tiled_mtl_rc_ccs [354.502998] Subtest pipe-A-crc-primary-basic-4_tiled_mtl_rc_ccs: SUCCESS (1.442s) [356.322235] [022/141] (657s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats) [357.227854] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s) [358.093756] [023/141] (655s left) vc4/vc4_label_bo (set-kernel-name) [358.567161] Subtest set-kernel-name: SKIP (0.000s) [358.699173] [024/141] (655s left) kms_cursor_crc (cursor-offscreen-32x10) [359.398600] Starting subtest: cursor-offscreen-32x10 [359.718071] Subtest cursor-offscreen-32x10: SKIP (0.309s) [360.619565] [025/141] (653s left) kms_flip (2x-plain-flip-fb-recreate-interruptible) [361.046086] Starting subtest: 2x-plain-flip-fb-recreate-interruptible [361.213666] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.164s) [361.381750] [026/141] (652s left) kms_vblank (pipe-d-query-busy) [361.861827] Starting subtest: pipe-D-query-busy [365.857891] Subtest pipe-D-query-busy: SUCCESS (3.999s) [366.806410] [027/141] (647s left) gem_exec_fence (syncobj-backward-timeline-chain-engines) [368.836467] Starting subtest: syncobj-backward-timeline-chain-engines [369.189590] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.353s) [369.766366] [028/141] (644s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt) [370.286478] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt [370.293278] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [370.452638] [029/141] (643s left) gem_exec_await (wide-all) [371.946478] Starting subtest: wide-all [400.543700] Subtest wide-all: SUCCESS (28.597s) [400.888349] [030/141] (613s left) gem_eio (kms) [402.815955] Starting subtest: kms [452.784239] Subtest kms: SUCCESS (49.967s) [454.373447] [031/141] (560s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary) [454.877342] Starting subtest: fbc-indfb-scaledprimary [460.856392] Subtest fbc-indfb-scaledprimary: SUCCESS (5.980s) [461.134964] [032/141] (553s left) api_intel_bb (crc32) [461.510501] Starting subtest: crc32 [461.514188] Starting dynamic subtest: rcs0-smem0 [462.202306] Dynamic subtest rcs0-smem0: SUCCESS (0.693s) [462.253139] Starting dynamic subtest: bcs0-smem0 [462.937397] Dynamic subtest bcs0-smem0: SUCCESS (0.730s) [462.989606] Starting dynamic subtest: vcs0-smem0 [463.664779] Dynamic subtest vcs0-smem0: SUCCESS (0.723s) [463.715270] Starting dynamic subtest: vcs1-smem0 [464.436349] Dynamic subtest vcs1-smem0: SUCCESS (0.768s) [464.482956] Starting dynamic subtest: vecs0-smem0 [465.161080] Dynamic subtest vecs0-smem0: SUCCESS (0.719s) [465.209931] Starting dynamic subtest: ccs0-smem0 [465.909737] Dynamic subtest ccs0-smem0: SUCCESS (0.745s) [465.913875] Subtest crc32: SUCCESS (4.404s) [466.125424] [033/141] (548s left) kms_properties (plane-properties-legacy) [466.608946] Starting subtest: plane-properties-legacy [471.826959] Subtest plane-properties-legacy: SUCCESS (5.213s) [472.772386] [034/141] (542s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted) [473.164851] Starting subtest: invalid-multi-wait-unsubmitted-submitted [473.168838] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.003s) [473.320323] [035/141] (541s left) kms_ccs (pipe-c-bad-aux-stride-y_tiled_gen12_mc_ccs) [474.858350] Starting subtest: pipe-C-bad-aux-stride-y_tiled_gen12_mc_ccs [474.864801] Subtest pipe-C-bad-aux-stride-y_tiled_gen12_mc_ccs: SKIP (0.000s) [475.713819] [036/141] (539s left) kms_concurrent (pipe-d) [476.072161] Starting subtest: pipe-D [476.082471] Starting dynamic subtest: eDP-1 [478.169546] Dynamic subtest eDP-1: SUCCESS (2.087s) [478.173360] Subtest pipe-D: SUCCESS (2.094s) [479.116199] [037/141] (535s left) kms_vblank (pipe-a-ts-continuation-idle) [479.594869] Starting subtest: pipe-A-ts-continuation-idle [480.199167] Subtest pipe-A-ts-continuation-idle: SUCCESS (0.601s) [481.148661] [038/141] (534s left) gem_fence_thrash (bo-copy) [481.507630] Starting subtest: bo-copy [481.523735] Subtest bo-copy: SKIP (0.009s) [481.644449] [039/141] (533s left) gem_exec_reloc (basic-wc-gtt) [482.043603] Subtest basic-wc-gtt: SKIP (0.000s) [482.184146] [040/141] (533s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [482.736058] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [488.025347] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: FAIL (4.468s) [488.145789] [041/141] (527s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render) [488.666906] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render [488.673797] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [488.849341] [042/141] (526s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt) [489.360521] Starting subtest: psr-rgb565-draw-blt [503.953724] Subtest psr-rgb565-draw-blt: SUCCESS (14.596s) [504.213247] [043/141] (511s left) perf_pmu (render-node-busy) [504.650231] Starting subtest: render-node-busy [504.653819] Starting dynamic subtest: rcs0 [505.246820] Dynamic subtest rcs0: SUCCESS (0.594s) [505.299813] Starting dynamic subtest: bcs0 [505.817585] Dynamic subtest bcs0: SUCCESS (0.567s) [505.870590] Starting dynamic subtest: vcs0 [507.528187] Dynamic subtest vcs0: SUCCESS (1.705s) [507.575886] Starting dynamic subtest: vcs1 [509.511622] Dynamic subtest vcs1: SUCCESS (1.980s) [509.557930] Starting dynamic subtest: vecs0 [511.560388] Dynamic subtest vecs0: SUCCESS (2.044s) [511.606789] Starting dynamic subtest: ccs0 [512.136346] Dynamic subtest ccs0: SUCCESS (0.573s) [512.139903] Subtest render-node-busy: SUCCESS (7.488s) [512.319650] [044/141] (503s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip) [512.877335] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip [512.884050] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s) [513.052829] [045/141] (502s left) v3d/v3d_perfmon (get-values-invalid-pointer) [513.547265] Subtest get-values-invalid-pointer: SKIP (0.000s) [513.676181] [046/141] (502s left) kms_pipe_crc_basic (hang-read-crc) [514.162381] Starting subtest: hang-read-crc [514.171945] Starting dynamic subtest: pipe-A-eDP-1 [518.263599] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.090s) [518.324266] Starting dynamic subtest: pipe-B-eDP-1 [523.423617] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.146s) [523.475373] Starting dynamic subtest: pipe-C-eDP-1 [528.595940] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.162s) [528.655902] Starting dynamic subtest: pipe-D-eDP-1 [533.401517] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.797s) [533.404980] Subtest hang-read-crc: SUCCESS (19.239s) [534.354514] [047/141] (481s left) i915_query (query-garbage) [534.741391] Starting subtest: query-garbage [534.744896] Subtest query-garbage: SUCCESS (0.000s) [534.890534] [048/141] (481s left) dmabuf_sync_file (export-wait-after-attach) [535.270127] Starting subtest: export-wait-after-attach [535.274213] Subtest export-wait-after-attach: SUCCESS (0.003s) [535.411161] [049/141] (480s left) kms_big_fb (4-tiled-8bpp-rotate-180) [535.944882] Starting subtest: 4-tiled-8bpp-rotate-180 [540.147990] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (4.201s) [540.527166] [050/141] (475s left) gem_exec_schedule (preempt-other) [540.968154] Starting subtest: preempt-other [540.971741] Starting dynamic subtest: rcs0 [541.318457] Dynamic subtest rcs0: SUCCESS (0.347s) [541.363176] Starting dynamic subtest: bcs0 [541.654732] Dynamic subtest bcs0: SUCCESS (0.331s) [541.702390] Starting dynamic subtest: vcs0 [541.991193] Dynamic subtest vcs0: SUCCESS (0.332s) [542.039226] Starting dynamic subtest: vcs1 [542.335749] Dynamic subtest vcs1: SUCCESS (0.340s) [542.380939] Starting dynamic subtest: vecs0 [542.680748] Dynamic subtest vecs0: SUCCESS (0.340s) [542.726828] Starting dynamic subtest: ccs0 [542.998995] Dynamic subtest ccs0: SUCCESS (0.314s) [543.002765] Subtest preempt-other: SUCCESS (2.032s) [544.744278] [051/141] (471s left) kms_ccs (pipe-c-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc) [546.257284] Starting subtest: pipe-C-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc [546.263506] Subtest pipe-C-missing-ccs-buffer-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s) [547.164976] [052/141] (469s left) prime_vgem (fence-flip-hang) [547.597942] Subtest fence-flip-hang: SKIP (0.000s) [547.774847] [053/141] (468s left) kms_dsc (dsc-with-formats) [548.259346] Starting subtest: dsc-with-formats [548.271139] Subtest dsc-with-formats: SKIP (0.007s) [548.415499] [054/141] (468s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt) [548.929553] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt [548.936632] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [549.101126] [055/141] (467s left) gem_sync (basic-each) [549.523242] Starting subtest: basic-each [552.139571] Subtest basic-each: SUCCESS (2.610s) [552.449643] [056/141] (464s left) gem_workarounds (basic-read-fd) [552.904186] Starting subtest: basic-read-fd [552.967209] Subtest basic-read-fd: SUCCESS (0.063s) [553.181338] [057/141] (463s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite) [553.717000] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite [553.723468] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [553.891334] [058/141] (463s left) i915_hangman (gt-engine-hang) [554.330202] Starting subtest: gt-engine-hang [554.333766] Starting dynamic subtest: rcs0 [557.514256] Dynamic subtest rcs0: SUCCESS (3.183s) [557.563299] Starting dynamic subtest: bcs0 [560.522944] Dynamic subtest bcs0: SUCCESS (3.002s) [560.571798] Starting dynamic subtest: vcs0 [562.569173] Dynamic subtest vcs0: SUCCESS (2.044s) [562.623885] Starting dynamic subtest: vcs1 [564.552880] Dynamic subtest vcs1: SUCCESS (1.979s) [564.602493] Starting dynamic subtest: vecs0 [566.537772] Dynamic subtest vecs0: SUCCESS (1.980s) [566.584283] Starting dynamic subtest: ccs0 [568.522295] Dynamic subtest ccs0: SUCCESS (1.980s) [568.525895] Subtest gt-engine-hang: SUCCESS (14.196s) [568.742630] [059/141] (448s left) kms_ccs (pipe-d-crc-primary-rotation-180-yf_tiled_ccs) [570.300862] Starting subtest: pipe-D-crc-primary-rotation-180-yf_tiled_ccs [570.307697] Subtest pipe-D-crc-primary-rotation-180-yf_tiled_ccs: SKIP (0.002s) [571.024422] [060/141] (446s left) gem_fenced_exec_thrash (2-spare-fences) [571.418868] Subtest 2-spare-fences: SKIP (0.000s) [571.540688] [061/141] (445s left) kms_ccs (pipe-d-missing-ccs-buffer-4_tiled_mtl_rc_ccs_cc) [573.276269] Starting subtest: pipe-D-missing-ccs-buffer-4_tiled_mtl_rc_ccs_cc [573.279991] Subtest pipe-D-missing-ccs-buffer-4_tiled_mtl_rc_ccs_cc: SUCCESS (0.001s) [573.944334] [062/141] (443s left) perf_pmu (busy-start) [574.329841] Starting subtest: busy-start [574.333788] Starting dynamic subtest: rcs0 [576.893717] Dynamic subtest rcs0: SUCCESS (2.561s) [576.948391] Starting dynamic subtest: bcs0 [579.448270] Dynamic subtest bcs0: SUCCESS (2.550s) [579.502083] Starting dynamic subtest: vcs0 [582.545836] Dynamic subtest vcs0: SUCCESS (3.092s) [582.594433] Starting dynamic subtest: vcs1 [586.513372] Dynamic subtest vcs1: SUCCESS (3.964s) [586.562345] Starting dynamic subtest: vecs0 [590.545883] Dynamic subtest vecs0: SUCCESS (4.028s) [590.594436] Starting dynamic subtest: ccs0 [593.099756] Dynamic subtest ccs0: SUCCESS (2.551s) [593.103522] Subtest busy-start: SUCCESS (18.772s) [593.290418] [063/141] (424s left) i915_pm_rc6_residency (media-rc6-accuracy) [594.924414] Subtest media-rc6-accuracy: SKIP (0.000s) [595.097666] [064/141] (422s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite) [595.612208] Starting subtest: fbcpsr-rgb101010-draw-pwrite [603.737440] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (8.123s) [603.997049] [065/141] (413s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [604.498262] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu [604.505773] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [604.664610] [066/141] (412s left) gem_exec_flush (basic-batch-kernel-default-wb) [605.081147] Starting subtest: basic-batch-kernel-default-wb [612.764287] Subtest basic-batch-kernel-default-wb: SUCCESS (7.677s) [613.070604] [067/141] (404s left) sysfs_timeslice_duration (idempotent) [613.477286] Starting subtest: idempotent [613.480339] Starting dynamic subtest: vecs0 [613.483576] Dynamic subtest vecs0: SUCCESS (0.002s) [613.522272] Starting dynamic subtest: ccs0 [613.525242] Dynamic subtest ccs0: SUCCESS (0.002s) [613.572469] Starting dynamic subtest: vcs0 [613.575784] Dynamic subtest vcs0: SUCCESS (0.002s) [613.620902] Starting dynamic subtest: bcs0 [613.624532] Dynamic subtest bcs0: SUCCESS (0.002s) [613.669753] Starting dynamic subtest: rcs0 [613.673224] Dynamic subtest rcs0: SUCCESS (0.002s) [613.718331] Starting dynamic subtest: vcs1 [613.721738] Dynamic subtest vcs1: SUCCESS (0.002s) [613.725160] Subtest idempotent: SUCCESS (0.037s) [613.793767] [068/141] (404s left) gem_partial_pwrite_pread (writes-after-reads-uncached) [614.181864] Subtest writes-after-reads-uncached: SKIP (0.000s) [614.332395] [069/141] (403s left) i915_pm_rpm (gem-pread) [616.765622] Starting subtest: gem-pread [622.824640] Subtest gem-pread: SUCCESS (6.059s) [623.040119] [070/141] (394s left) v3d/v3d_submit_csd (bad-extension) [623.512074] Subtest bad-extension: SKIP (0.000s) [623.646519] [071/141] (394s left) gem_basic (create-close) [624.013496] Starting subtest: create-close [624.020202] Subtest create-close: SUCCESS (0.000s) [624.186361] [072/141] (394s left) kms_flip (2x-dpms-vs-vblank-race-interruptible) [624.611225] Starting subtest: 2x-dpms-vs-vblank-race-interruptible [624.783301] Subtest 2x-dpms-vs-vblank-race-interruptible: SKIP (0.168s) [624.960504] [073/141] (393s left) perf (i915-ref-count) [625.517821] Starting subtest: i915-ref-count [625.684141] Subtest i915-ref-count: SUCCESS (0.166s) [625.892206] [074/141] (392s left) i915_pm_rps (thresholds) [626.289233] Starting subtest: thresholds [626.292788] Starting dynamic subtest: gt0 [626.310424] Dynamic subtest gt0: SKIP (0.015s) [626.361219] Starting dynamic subtest: gt1 [626.368125] Dynamic subtest gt1: SKIP (0.002s) [626.374705] Subtest thresholds: SKIP (0.027s) [626.467772] [075/141] (392s left) prime_mmap (test_map_unmap) [626.855633] Starting subtest: test_map_unmap [626.859358] Starting dynamic subtest: test_map_unmap-smem [627.375354] Dynamic subtest test_map_unmap-smem: SUCCESS (0.517s) [627.378899] Subtest test_map_unmap: SUCCESS (0.522s) [627.545936] [076/141] (391s left) kms_psr (cursor_plane_move) [628.034812] Starting subtest: cursor_plane_move [631.203314] Subtest cursor_plane_move: SUCCESS (3.170s) [632.154279] [077/141] (386s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [632.731336] Starting subtest: basic-flip-before-cursor-atomic [634.164500] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.433s) [635.123098] [078/141] (383s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt) [635.630116] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt [635.637105] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [635.804753] [079/141] (383s left) gem_mmap_gtt (flink-race) [636.186136] Subtest flink-race: SKIP (0.000s) [636.308278] [080/141] (382s left) prime_self_import (export-vs-gem_close-race) [636.662066] Starting subtest: export-vs-gem_close-race [641.732673] Subtest export-vs-gem_close-race: SUCCESS (5.068s) [641.915810] [081/141] (377s left) gem_exec_fence (long-history) [643.980720] Starting subtest: long-history [650.222400] Subtest long-history: SUCCESS (6.243s) [651.672221] [082/141] (367s left) gem_pxp (verify-pxp-stale-buf-execution) [654.580598] Subtest verify-pxp-stale-buf-execution: SKIP (0.000s) [654.763650] [083/141] (364s left) kms_ccs (pipe-b-bad-pixel-format-y_tiled_gen12_rc_ccs_cc) [655.914329] Starting subtest: pipe-B-bad-pixel-format-y_tiled_gen12_rc_ccs_cc [655.920640] Subtest pipe-B-bad-pixel-format-y_tiled_gen12_rc_ccs_cc: SKIP (0.000s) [657.176147] [084/141] (362s left) kms_vblank (pipe-d-wait-busy) [657.656607] Starting subtest: pipe-D-wait-busy [661.635206] Subtest pipe-D-wait-busy: SUCCESS (3.980s) [662.627192] [085/141] (356s left) gem_flink_basic (bad-open) [663.003069] Starting subtest: bad-open [663.006972] Subtest bad-open: SUCCESS (0.000s) [663.157542] [086/141] (356s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite) [663.670391] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite [681.472964] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (17.805s) [681.747886] [087/141] (337s left) kms_ccs (pipe-a-bad-aux-stride-y_tiled_ccs) [682.798318] Starting subtest: pipe-A-bad-aux-stride-y_tiled_ccs [682.804909] Subtest pipe-A-bad-aux-stride-y_tiled_ccs: SKIP (0.000s) [684.120592] [088/141] (335s left) kms_big_fb (linear-32bpp-rotate-180) [684.674491] Starting subtest: linear-32bpp-rotate-180 [690.121375] Subtest linear-32bpp-rotate-180: SUCCESS (5.443s) [690.605270] [089/141] (329s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-5) [691.079495] Starting subtest: planes-unity-scaling-downscale-factor-0-5 [691.088330] Starting dynamic subtest: pipe-A-eDP-1 [691.124250] Dynamic subtest pipe-A-eDP-1: SKIP (0.033s) [691.181648] Starting dynamic subtest: pipe-B-eDP-1 [691.277541] Dynamic subtest pipe-B-eDP-1: SKIP (0.145s) [691.333772] Starting dynamic subtest: pipe-C-eDP-1 [691.445975] Dynamic subtest pipe-C-eDP-1: SKIP (0.156s) [691.503131] Starting dynamic subtest: pipe-D-eDP-1 [691.615316] Dynamic subtest pipe-D-eDP-1: SKIP (0.155s) [691.622372] Subtest planes-unity-scaling-downscale-factor-0-5: SKIP (0.531s) [691.788150] [090/141] (328s left) gem_workarounds (suspend-resume) [692.246769] Starting subtest: suspend-resume [709.217166] Subtest suspend-resume: SUCCESS (16.971s) [709.442467] [091/141] (310s left) kms_big_fb (4-tiled-32bpp-rotate-0) [709.986270] Starting subtest: 4-tiled-32bpp-rotate-0 [715.197801] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (5.216s) [715.889154] [092/141] (304s left) kms_vblank (pipe-a-ts-continuation-modeset-hang) [716.372046] Starting subtest: pipe-A-ts-continuation-modeset-hang [730.886572] Subtest pipe-A-ts-continuation-modeset-hang: SUCCESS (14.514s) [731.853324] [093/141] (288s left) gem_ppgtt (shrink-vs-evict-any) [732.257379] Starting subtest: shrink-vs-evict-any [737.651365] Subtest shrink-vs-evict-any: SUCCESS (5.397s) [737.832640] [094/141] (282s left) kms_addfb_basic (small-bo) [738.337999] Starting subtest: small-bo [738.341620] Subtest small-bo: SUCCESS (0.000s) [738.522935] [095/141] (281s left) gem_ccs (suspend-resume) [738.919168] Starting subtest: suspend-resume [738.925837] Subtest suspend-resume: SKIP (0.000s) [739.079743] [096/141] (281s left) gem_exec_schedule (fairslice-all) [739.529406] Starting subtest: fairslice-all [741.767398] Subtest fairslice-all: SUCCESS (2.240s) [743.719177] [097/141] (276s left) kms_color (legacy-gamma) [744.210363] Starting subtest: legacy-gamma [744.214449] Starting dynamic subtest: pipe-A [745.406899] Dynamic subtest pipe-A: SUCCESS (1.194s) [745.470257] Starting dynamic subtest: pipe-B [747.153314] Dynamic subtest pipe-B: SUCCESS (1.742s) [747.219196] Starting dynamic subtest: pipe-C [748.647303] Dynamic subtest pipe-C: SUCCESS (1.498s) [748.707964] Starting dynamic subtest: pipe-D [750.140406] Dynamic subtest pipe-D: SUCCESS (1.481s) [750.143648] Subtest legacy-gamma: SUCCESS (5.929s) [751.063648] [098/141] (269s left) gem_exec_suspend (basic-s4-devices) [751.482349] Starting subtest: basic-S4-devices [751.485412] Starting dynamic subtest: smem [772.553154] Dynamic subtest smem: SUCCESS (21.068s) [772.556729] Subtest basic-S4-devices: SUCCESS (21.072s) [772.879880] [099/141] (247s left) gem_exec_reloc (basic-gtt) [773.289330] Subtest basic-gtt: SKIP (0.000s) [773.454241] [100/141] (247s left) gem_ctx_persistence (engines-mixed) [773.872134] Starting subtest: engines-mixed [773.875574] Starting dynamic subtest: rcs0 [773.969767] Dynamic subtest rcs0: SUCCESS (0.103s) [774.032450] Starting dynamic subtest: bcs0 [774.055745] Dynamic subtest bcs0: SUCCESS (0.082s) [774.122842] Starting dynamic subtest: vcs0 [774.134516] Dynamic subtest vcs0: SUCCESS (0.075s) [774.197493] Starting dynamic subtest: vcs1 [774.200938] Dynamic subtest vcs1: SUCCESS (0.062s) [774.257132] Starting dynamic subtest: vecs0 [774.272530] Dynamic subtest vecs0: SUCCESS (0.068s) [774.334405] Starting dynamic subtest: ccs0 [774.358591] Dynamic subtest ccs0: SUCCESS (0.082s) [774.362370] Subtest engines-mixed: SUCCESS (0.496s) [774.558679] [101/141] (246s left) gem_exec_create (forked) [774.996361] Starting subtest: forked [774.999935] Starting dynamic subtest: smem [797.514256] Dynamic subtest smem: SUCCESS (22.521s) [797.518066] Subtest forked: SUCCESS (22.525s) [797.792331] [102/141] (223s left) gem_ctx_param (set-priority-invalid-size) [798.169293] Starting subtest: set-priority-invalid-size [798.172845] Subtest set-priority-invalid-size: SUCCESS (0.000s) [798.353068] [103/141] (222s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt) [798.874504] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt [806.783436] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (7.910s) [807.039584] [104/141] (214s left) kms_cursor_legacy (short-flip-before-cursor-toggle) [807.616970] Starting subtest: short-flip-before-cursor-toggle [809.043579] Subtest short-flip-before-cursor-toggle: SUCCESS (1.423s) [809.999602] [105/141] (211s left) gem_set_tiling_vs_pwrite [810.557462] [106/141] (210s left) sw_sync (sync_merge) [810.932712] Starting subtest: sync_merge [810.936198] Subtest sync_merge: SUCCESS (0.001s) [811.070515] [107/141] (210s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180) [811.608731] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180 [814.648165] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (3.040s) [814.952868] [108/141] (206s left) kms_big_fb (y-tiled-32bpp-rotate-0) [815.483786] Starting subtest: y-tiled-32bpp-rotate-0 [815.490545] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s) [815.650462] [109/141] (206s left) gem_eio (wait-wedge-10ms) [817.676947] Starting subtest: wait-wedge-10ms [820.951334] Subtest wait-wedge-10ms: SUCCESS (3.277s) [822.693311] [110/141] (199s left) gem_exec_schedule (u-semaphore-user) [823.133450] Starting subtest: u-semaphore-user [823.185466] Subtest u-semaphore-user: SUCCESS (0.052s) [824.705214] [111/141] (197s left) kms_psr_stress_test (flip-primary-invalidate-overlay) [825.207451] Starting subtest: flip-primary-invalidate-overlay [843.147093] Subtest flip-primary-invalidate-overlay: SUCCESS (17.943s) [843.590226] [112/141] (178s left) feature_discovery (psr1) [844.070462] Starting subtest: psr1 [844.074237] Subtest psr1: SUCCESS (0.000s) [844.234681] [113/141] (177s left) kms_ccs (pipe-a-ccs-on-another-bo-4_tiled_mtl_mc_ccs) [845.198317] Starting subtest: pipe-A-ccs-on-another-bo-4_tiled_mtl_mc_ccs [845.354633] Subtest pipe-A-ccs-on-another-bo-4_tiled_mtl_mc_ccs: SUCCESS (0.156s) [846.701239] [114/141] (175s left) syncobj_timeline (invalid-multi-wait-available-unsubmitted-signaled) [847.074069] Starting subtest: invalid-multi-wait-available-unsubmitted-signaled [847.077464] Subtest invalid-multi-wait-available-unsubmitted-signaled: SUCCESS (0.003s) [847.240514] [115/141] (175s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling) [847.702774] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling [847.709312] Starting dynamic subtest: pipe-A-default-mode [848.105298] Dynamic subtest pipe-A-default-mode: SKIP (0.392s) [848.111486] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.405s) [849.067999] [116/141] (173s left) kms_invalid_mode (uint-max-clock) [849.531868] Starting subtest: uint-max-clock [849.541167] Starting dynamic subtest: eDP-1-pipe-A [849.970437] Dynamic subtest eDP-1-pipe-A: SUCCESS (0.431s) [850.030101] Starting dynamic subtest: eDP-1-pipe-B [850.033112] Dynamic subtest eDP-1-pipe-B: SUCCESS (0.037s) [850.090722] Starting dynamic subtest: eDP-1-pipe-C [850.093785] Dynamic subtest eDP-1-pipe-C: SUCCESS (0.041s) [850.150268] Starting dynamic subtest: eDP-1-pipe-D [850.153281] Dynamic subtest eDP-1-pipe-D: SUCCESS (0.039s) [850.156405] Subtest uint-max-clock: SUCCESS (0.586s) [850.898218] [117/141] (171s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render) [851.390327] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render [851.397310] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [851.575986] [118/141] (171s left) gen9_exec_parse (bb-large) [851.961072] Subtest bb-large: SKIP (0.000s) [852.090787] [119/141] (170s left) syncobj_timeline (multi-wait-submitted-signaled) [852.467974] Starting subtest: multi-wait-submitted-signaled [852.471619] Subtest multi-wait-submitted-signaled: SUCCESS (0.003s) [852.634836] [120/141] (170s left) gem_ctx_shared (disjoint-timelines) [853.053053] Starting subtest: disjoint-timelines [853.094644] Subtest disjoint-timelines: SUCCESS (0.045s) [853.417255] [121/141] (169s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render) [853.914515] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render [853.921668] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [854.088512] [122/141] (168s left) kms_chamelium_hpd (hdmi-hpd) [854.971778] Subtest hdmi-hpd: SKIP (0.000s) [855.856142] [123/141] (167s left) gem_ctx_engines (none) [856.277488] Starting subtest: none [856.287141] Subtest none: SUCCESS (0.007s) [856.548938] [124/141] (166s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt) [857.054731] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt [857.061845] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [857.249444] [125/141] (166s left) gem_softpin (evict-active-interruptible) [857.643716] Starting subtest: evict-active-interruptible [857.669749] Subtest evict-active-interruptible: SUCCESS (0.026s) [857.863408] [126/141] (165s left) kms_force_connector_basic (force-connector-state) [858.250725] Starting subtest: force-connector-state [860.588372] Subtest force-connector-state: SUCCESS (2.334s) [861.449694] [127/141] (162s left) kms_ccs (pipe-a-crc-sprite-planes-basic-y_tiled_ccs) [862.503889] Starting subtest: pipe-A-crc-sprite-planes-basic-y_tiled_ccs [862.519872] Subtest pipe-A-crc-sprite-planes-basic-y_tiled_ccs: SKIP (0.013s) [863.819969] [128/141] (159s left) kms_vblank (pipe-a-query-forked) [864.304351] Starting subtest: pipe-A-query-forked [866.656559] Subtest pipe-A-query-forked: SUCCESS (2.357s) [867.638256] [129/141] (156s left) kms_ccs (pipe-d-bad-aux-stride-4_tiled_mtl_rc_ccs) [869.377445] Starting subtest: pipe-D-bad-aux-stride-4_tiled_mtl_rc_ccs [869.381415] Subtest pipe-D-bad-aux-stride-4_tiled_mtl_rc_ccs: SUCCESS (0.004s) [870.000977] [130/141] (153s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling) [870.467114] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling [870.475325] Starting dynamic subtest: pipe-A-default-mode [870.876534] Dynamic subtest pipe-A-default-mode: SKIP (0.396s) [870.883417] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.409s) [871.830202] [131/141] (152s left) kms_addfb_basic (invalid-smem-bo-on-discrete) [872.204763] Starting subtest: invalid-smem-bo-on-discrete [872.212560] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s) [872.494402] [132/141] (151s left) gen7_exec_parse (cmd-crossing-page) [872.888792] Subtest cmd-crossing-page: SKIP (0.000s) [873.029074] [133/141] (151s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle) [873.592190] Starting subtest: short-busy-flip-before-cursor-toggle [873.599497] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s) [873.949518] [134/141] (150s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-gtt) [874.438970] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-gtt [874.446207] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [874.619331] [135/141] (149s left) syncobj_wait (reset-during-wait-for-submit) [874.995220] Starting subtest: reset-during-wait-for-submit [875.102779] Subtest reset-during-wait-for-submit: SUCCESS (0.106s) [875.271289] [136/141] (149s left) gem_render_copy (y-tiled-to-vebox-yf-tiled) [875.674534] Starting subtest: y-tiled-to-vebox-yf-tiled [875.681359] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s) [875.969323] [137/141] (148s left) gem_pxp (create-protected-buffer) [878.860568] Subtest create-protected-buffer: SKIP (0.000s) [879.006827] [138/141] (145s left) kms_cursor_crc (cursor-sliding-128x42) [879.935184] Starting subtest: cursor-sliding-128x42 [879.953996] Starting dynamic subtest: pipe-A-eDP-1 [885.271825] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.316s) [885.469184] Starting dynamic subtest: pipe-D-eDP-1 [892.384658] Dynamic subtest pipe-D-eDP-1: SUCCESS (6.961s) [892.388554] Subtest cursor-sliding-128x42: SUCCESS (12.453s) [893.335526] [139/141] (131s left) dmabuf_sync_file (import-basic) [893.701983] Starting subtest: import-basic [893.710197] Subtest import-basic: SUCCESS (0.007s) [893.854086] [140/141] (130s left) gem_spin_batch (spin-each) [894.278458] Starting subtest: spin-each [897.708169] Subtest spin-each: SUCCESS (3.429s) [899.741779] [141/141] (125s left) kms_ccs (pipe-b-missing-ccs-buffer-4_tiled_mtl_mc_ccs) [900.960896] Starting subtest: pipe-B-missing-ccs-buffer-4_tiled_mtl_mc_ccs [901.117804] Subtest pipe-B-missing-ccs-buffer-4_tiled_mtl_mc_ccs: SUCCESS (0.156s) [902.245831] Closing watchdogs Done.