[37.637096] Initializing watchdogs [37.637136] /dev/watchdog0 [37.643314] [001/138] (960s left) syncobj_timeline (invalid-single-wait-all-available-unsubmitted) [37.715571] Starting subtest: invalid-single-wait-all-available-unsubmitted [37.718305] Subtest invalid-single-wait-all-available-unsubmitted: SUCCESS (0.000s) [37.767753] [002/138] (960s left) kms_cursor_crc (cursor-rapid-movement-256x85) [37.937625] Starting subtest: cursor-rapid-movement-256x85 [37.948372] Starting dynamic subtest: pipe-A-eDP-1 [38.643338] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.696s) [38.671114] Starting dynamic subtest: pipe-D-eDP-1 [39.939616] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.272s) [39.942674] Subtest cursor-rapid-movement-256x85: SUCCESS (1.999s) [40.837451] [003/138] (957s left) perf (disabled-read-error) [40.980385] Starting subtest: disabled-read-error [40.992912] Subtest disabled-read-error: SUCCESS (0.012s) [41.014463] [004/138] (957s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt) [41.092799] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt [41.097451] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [41.172739] [005/138] (957s left) kms_ccs (pipe-b-crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc) [41.561232] Starting subtest: pipe-B-crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc [41.567052] Subtest pipe-B-crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s) [42.419558] [006/138] (955s left) gem_ctx_bad_destroy (invalid-ctx) [42.471646] Starting subtest: invalid-ctx [42.474668] Subtest invalid-ctx: SUCCESS (0.000s) [42.520358] [007/138] (955s left) gem_exec_reloc (basic-write-cpu-active) [42.578401] Subtest basic-write-cpu-active: SKIP (0.000s) [42.640725] [008/138] (955s left) gem_close_race (basic-process) [42.712689] Starting subtest: basic-process [42.762684] Subtest basic-process: SUCCESS (0.050s) [42.936918] [009/138] (955s left) kms_draw_crc (draw-method-pwrite) [43.029923] Starting subtest: draw-method-pwrite [43.032441] Starting dynamic subtest: xrgb8888-untiled [43.575603] Dynamic subtest xrgb8888-untiled: SUCCESS (0.546s) [43.583345] Starting dynamic subtest: rgb565-untiled [44.008052] Dynamic subtest rgb565-untiled: SUCCESS (0.433s) [44.014554] Starting dynamic subtest: xrgb2101010-untiled [44.496920] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.489s) [44.506696] Starting dynamic subtest: xrgb8888-xtiled [45.953160] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.456s) [45.964347] Starting dynamic subtest: rgb565-xtiled [46.842336] Dynamic subtest rgb565-xtiled: SUCCESS (0.889s) [46.852773] Starting dynamic subtest: xrgb2101010-xtiled [48.221048] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.378s) [48.231649] Starting dynamic subtest: xrgb8888-4tiled [49.108265] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.888s) [49.119422] Starting dynamic subtest: rgb565-4tiled [49.619825] Dynamic subtest rgb565-4tiled: SUCCESS (0.511s) [49.630334] Starting dynamic subtest: xrgb2101010-4tiled [50.486428] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.866s) [50.488871] Subtest draw-method-pwrite: SUCCESS (7.457s) [50.569884] [010/138] (947s left) kms_color (gamma) [50.634563] Starting subtest: gamma [50.636841] Starting dynamic subtest: pipe-A [51.322432] Dynamic subtest pipe-A: SUCCESS (0.687s) [51.332471] Starting dynamic subtest: pipe-B [52.807841] Dynamic subtest pipe-B: SUCCESS (1.486s) [52.818600] Starting dynamic subtest: pipe-C [54.217259] Dynamic subtest pipe-C: SUCCESS (1.407s) [54.227479] Starting dynamic subtest: pipe-D [55.622064] Dynamic subtest pipe-D: SUCCESS (1.407s) [55.624563] Subtest gamma: SUCCESS (4.987s) [56.502191] [011/138] (941s left) kms_ccs (pipe-a-ccs-on-another-bo-y-tiled-ccs) [56.874695] Starting subtest: pipe-A-ccs-on-another-bo-y-tiled-ccs [56.879590] Subtest pipe-A-ccs-on-another-bo-y-tiled-ccs: SKIP (0.000s) [57.796504] [012/138] (940s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary) [57.888431] Starting subtest: psr-indfb-scaledprimary [61.712614] Subtest psr-indfb-scaledprimary: SUCCESS (3.828s) [61.823242] [013/138] (936s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible) [61.889560] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible [61.917216] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.024s) [61.979493] [014/138] (936s left) gem_mmap_gtt (basic-copy) [62.047952] Subtest basic-copy: SKIP (0.000s) [62.078990] [015/138] (936s left) kms_vblank (wait-busy) [62.144459] Starting subtest: wait-busy [62.146392] Starting dynamic subtest: pipe-A-eDP-1 [64.035056] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.888s) [64.045703] Starting dynamic subtest: pipe-D-eDP-1 [66.708996] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.670s) [66.711579] Subtest wait-busy: SUCCESS (4.565s) [67.649336] [016/138] (930s left) vc4/vc4_perfmon (create-perfmon-exceed) [67.729936] Subtest create-perfmon-exceed: SKIP (0.000s) [67.773559] [017/138] (930s left) api_intel_bb (purge-bb) [67.824716] Starting subtest: purge-bb [67.827044] Subtest purge-bb: SUCCESS (0.002s) [67.917944] [018/138] (930s left) kms_psr (psr2_cursor_plane_onoff) [67.992373] Starting subtest: psr2_cursor_plane_onoff [69.764275] Subtest psr2_cursor_plane_onoff: SUCCESS (1.774s) [70.648952] [019/138] (927s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [70.717436] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [70.721996] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [70.790456] [020/138] (927s left) kms_chamelium_color (ctm-red-to-blue) [70.859587] Subtest ctm-red-to-blue: SKIP (0.000s) [70.876110] [021/138] (927s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-blt) [70.945450] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-blt [70.950075] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [71.027378] [022/138] (927s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic) [71.103778] Starting subtest: nonblocking-modeset-vs-cursor-atomic [72.640119] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.536s) [73.542369] [023/138] (925s left) gem_exec_fence (syncobj-timeline-invalid-flags) [74.125867] Starting subtest: syncobj-timeline-invalid-flags [74.129189] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.001s) [75.500836] [024/138] (923s left) kms_cursor_legacy (cursorb-vs-flipb-toggle) [75.603906] Starting subtest: cursorB-vs-flipB-toggle [75.608367] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s) [75.687424] [025/138] (923s left) gem_exec_whisper (basic-normal) [75.764730] Starting subtest: basic-normal [78.594101] Subtest basic-normal: SUCCESS (2.828s) [78.767792] [026/138] (919s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt) [78.860453] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt [78.865113] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [78.941411] [027/138] (919s left) api_intel_allocator (two-level-inception) [78.994131] Starting subtest: two-level-inception [84.403785] Subtest two-level-inception: SUCCESS (5.412s) [84.505160] [028/138] (914s left) kms_rotation_crc (sprite-rotation-90-pos-100-0) [84.584217] Starting subtest: sprite-rotation-90-pos-100-0 [84.588962] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s) [84.646121] [029/138] (914s left) gem_exec_schedule (preempt-queue-contexts) [84.709172] Subtest preempt-queue-contexts: SKIP (0.000s) [84.982442] [030/138] (913s left) kms_pm_rpm (drm-resources-equal) [86.577766] Starting subtest: drm-resources-equal [92.226043] Subtest drm-resources-equal: SUCCESS (5.648s) [92.316293] [031/138] (906s left) gem_mmap_offset (bad-flags) [92.374175] Starting subtest: bad-flags [92.376602] Subtest bad-flags: SUCCESS (0.000s) [92.457945] [032/138] (906s left) gem_ctx_persistence (heartbeat-hostile) [92.506408] Starting subtest: heartbeat-hostile [92.511215] Subtest heartbeat-hostile: SKIP (0.000s) [92.554979] [033/138] (906s left) kms_ccs (pipe-b-crc-sprite-planes-basic-y-tiled-gen12-mc-ccs) [92.924140] Starting subtest: pipe-B-crc-sprite-planes-basic-y-tiled-gen12-mc-ccs [92.929578] Subtest pipe-B-crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.001s) [93.812925] [034/138] (905s left) kms_cursor_legacy (cursorb-vs-flipa-atomic) [93.884932] Starting subtest: cursorB-vs-flipA-atomic [93.889695] Subtest cursorB-vs-flipA-atomic: SKIP (0.001s) [93.986375] [035/138] (904s left) syncobj_timeline (wait-all-for-submit-delayed-submit) [94.038440] Starting subtest: wait-all-for-submit-delayed-submit [94.139042] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s) [94.207122] [036/138] (904s left) gem_lmem_swapping (verify-random-ccs) [94.260728] Subtest verify-random-ccs: SKIP (0.000s) [94.281405] [037/138] (904s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling) [94.346574] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling [94.349038] Starting dynamic subtest: pipe-A-default-mode [95.558357] Dynamic subtest pipe-A-default-mode: SKIP (1.208s) [95.562291] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.209s) [95.708316] [038/138] (903s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled) [95.776890] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled [95.878299] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.103s) [95.942858] [039/138] (903s left) gem_ctx_param (basic) [95.981934] Starting subtest: basic [95.984560] Subtest basic: SUCCESS (0.000s) [96.042216] [040/138] (903s left) gen9_exec_parse (batch-invalid-length) [96.102923] Subtest batch-invalid-length: SKIP (0.000s) [96.127475] [041/138] (902s left) kms_ccs (pipe-d-crc-primary-rotation-180-4-tiled-mtl-mc-ccs) [96.547972] Starting subtest: pipe-D-crc-primary-rotation-180-4-tiled-mtl-mc-ccs [98.956653] Subtest pipe-D-crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (2.410s) [100.153382] [042/138] (898s left) kms_chamelium_edid (dp-edid-stress-resolution-4k) [100.514919] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s) [101.405253] [043/138] (897s left) gen3_render_tiledy_blits [101.507287] [044/138] (897s left) kms_invalid_mode (bad-hsync-start) [101.582476] Starting subtest: bad-hsync-start [101.585014] Starting dynamic subtest: pipe-A-eDP-1 [101.863332] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.282s) [101.875816] Starting dynamic subtest: pipe-B-eDP-1 [101.877898] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [101.888752] Starting dynamic subtest: pipe-C-eDP-1 [101.891101] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [101.900064] Starting dynamic subtest: pipe-D-eDP-1 [101.902444] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [101.904817] Subtest bad-hsync-start: SUCCESS (0.291s) [102.768734] [045/138] (896s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render) [102.846940] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render [102.851391] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [102.936942] [046/138] (896s left) gem_ctx_param (invalid-set-no-zeromap) [102.982619] Starting subtest: invalid-set-no-zeromap [102.984995] Subtest invalid-set-no-zeromap: SUCCESS (0.000s) [103.031576] [047/138] (896s left) drm_read (short-buffer-nonblock) [103.168042] Starting subtest: short-buffer-nonblock [103.170724] Subtest short-buffer-nonblock: SUCCESS (0.000s) [103.275263] [048/138] (895s left) kms_ccs (pipe-a-missing-ccs-buffer-y-tiled-gen12-rc-ccs) [103.650717] Starting subtest: pipe-A-missing-ccs-buffer-y-tiled-gen12-rc-ccs [103.656506] Subtest pipe-A-missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.000s) [104.523933] [049/138] (894s left) i915_pm_rpm (debugfs-read) [106.628186] Starting subtest: debugfs-read [227.270059] Per-test timeout exceeded. Killing the current test with SIGQUIT. [228.295723] Closing watchdogs [228.299249] Initializing watchdogs [228.299326] /dev/watchdog0 [228.310372] [050/138] (770s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [228.410545] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [228.413638] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [228.494130] [051/138] (770s left) gem_userptr_blits (invalid-mmap-offset-unsync) [228.552232] Subtest invalid-mmap-offset-unsync: SKIP (0.000s) [228.654732] [052/138] (770s left) gem_exec_parallel (fds) [228.703446] Starting subtest: fds [228.705443] Starting dynamic subtest: rcs0 [230.814315] Dynamic subtest rcs0: SUCCESS (2.109s) [230.826860] Starting dynamic subtest: bcs0 [232.971531] Dynamic subtest bcs0: SUCCESS (2.156s) [232.982514] Starting dynamic subtest: vcs0 [236.482454] Dynamic subtest vcs0: SUCCESS (3.510s) [236.495127] Starting dynamic subtest: vcs1 [238.522730] Dynamic subtest vcs1: SUCCESS (2.039s) [238.528273] Starting dynamic subtest: vecs0 [240.647632] Dynamic subtest vecs0: SUCCESS (2.123s) [240.661069] Starting dynamic subtest: ccs0 [242.891331] Dynamic subtest ccs0: SUCCESS (2.243s) [242.894705] Subtest fds: SUCCESS (14.186s) [243.082559] [053/138] (756s left) kms_rmfb (rmfb-ioctl) [243.164566] Starting subtest: rmfb-ioctl [243.166990] Starting dynamic subtest: pipe-A-eDP-1 [243.270755] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.107s) [243.283179] Starting dynamic subtest: pipe-B-eDP-1 [244.520302] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.248s) [244.532300] Starting dynamic subtest: pipe-C-eDP-1 [245.844837] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.322s) [245.856957] Starting dynamic subtest: pipe-D-eDP-1 [247.133803] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.286s) [247.136272] Subtest rmfb-ioctl: SUCCESS (3.971s) [248.388588] [054/138] (751s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-blt) [248.465259] Starting subtest: psr-1p-offscren-pri-shrfb-draw-blt [253.316544] Subtest psr-1p-offscren-pri-shrfb-draw-blt: SUCCESS (4.857s) [253.434043] [055/138] (746s left) gem_exec_balancer (smoke) [253.505346] Starting subtest: smoke [275.775198] Subtest smoke: SUCCESS (22.268s) [277.542303] [056/138] (721s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted) [277.595929] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted [277.598242] Subtest multi-wait-for-submit-available-unsubmitted-submitted: SUCCESS (0.001s) [277.661658] [057/138] (721s left) kms_psr (cursor_plane_move) [277.742325] Starting subtest: cursor_plane_move [279.505680] Subtest cursor_plane_move: SUCCESS (1.763s) [280.452508] [058/138] (719s left) kms_ccs (pipe-c-bad-pixel-format-y-tiled-gen12-mc-ccs) [280.847922] Starting subtest: pipe-C-bad-pixel-format-y-tiled-gen12-mc-ccs [280.853294] Subtest pipe-C-bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.000s) [281.721195] [059/138] (717s left) gem_eio (in-flight-internal-1us) [281.996647] Starting subtest: in-flight-internal-1us [283.549880] Subtest in-flight-internal-1us: SUCCESS (1.554s) [285.473383] [060/138] (714s left) gem_exec_parallel (userptr) [285.534022] Starting subtest: userptr [285.535884] Starting dynamic subtest: rcs0 [287.060872] Dynamic subtest rcs0: SUCCESS (1.528s) [287.075137] Starting dynamic subtest: bcs0 [288.947531] Dynamic subtest bcs0: SUCCESS (1.885s) [288.961362] Starting dynamic subtest: vcs0 [290.398609] Dynamic subtest vcs0: SUCCESS (1.448s) [290.413240] Starting dynamic subtest: vcs1 [292.456838] Dynamic subtest vcs1: SUCCESS (2.057s) [292.471408] Starting dynamic subtest: vecs0 [294.442100] Dynamic subtest vecs0: SUCCESS (1.984s) [294.457068] Starting dynamic subtest: ccs0 [296.446473] Dynamic subtest ccs0: SUCCESS (2.004s) [296.449430] Subtest userptr: SUCCESS (10.915s) [296.626472] [061/138] (702s left) kms_ccs (pipe-c-crc-primary-rotation-180-4-tiled-dg2-mc-ccs) [297.029344] Starting subtest: pipe-C-crc-primary-rotation-180-4-tiled-dg2-mc-ccs [297.035734] Subtest pipe-C-crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.000s) [297.913208] [062/138] (701s left) kms_ccs (pipe-b-ccs-on-another-bo-y-tiled-gen12-mc-ccs) [298.312605] Starting subtest: pipe-B-ccs-on-another-bo-y-tiled-gen12-mc-ccs [298.317803] Subtest pipe-B-ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.000s) [299.205943] [063/138] (700s left) gem_exec_reloc (basic-gtt-wc-active) [299.262363] Subtest basic-gtt-wc-active: SKIP (0.000s) [299.304945] [064/138] (700s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move) [299.375243] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move [299.379892] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [299.450492] [065/138] (700s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render) [299.524749] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render [299.529228] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [299.614188] [066/138] (700s left) v3d/v3d_mmap (mmap-bo) [299.726973] Subtest mmap-bo: SKIP (0.000s) [299.778199] [067/138] (699s left) kms_cursor_crc (cursor-onscreen-256x256) [299.903024] Starting subtest: cursor-onscreen-256x256 [299.905453] Starting dynamic subtest: pipe-A-eDP-1 [302.061956] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.156s) [302.101871] Starting dynamic subtest: pipe-D-eDP-1 [304.938558] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.850s) [304.941267] Subtest cursor-onscreen-256x256: SUCCESS (5.037s) [305.834182] [068/138] (693s left) gem_exec_fair (basic-throttle) [305.914108] Subtest basic-throttle: SKIP (0.000s) [305.937588] [069/138] (693s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size) [306.010987] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size [312.794608] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (6.783s) [313.723357] [070/138] (686s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt) [313.820248] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt [317.214228] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (3.399s) [317.345448] [071/138] (682s left) kms_pm_rpm (modeset-lpsp-stress) [319.681269] Starting subtest: modeset-lpsp-stress [369.198955] Subtest modeset-lpsp-stress: SUCCESS (49.516s) [369.304571] [072/138] (630s left) gem_softpin (evict-prime) [369.376069] Starting subtest: evict-prime [369.380708] Starting dynamic subtest: rcs0 [370.494934] Dynamic subtest rcs0: SUCCESS (1.118s) [370.511667] Starting dynamic subtest: bcs0 [371.604920] Dynamic subtest bcs0: SUCCESS (1.108s) [371.621666] Starting dynamic subtest: vcs0 [373.417066] Dynamic subtest vcs0: SUCCESS (1.809s) [373.432483] Starting dynamic subtest: vcs1 [375.402390] Dynamic subtest vcs1: SUCCESS (1.985s) [375.417123] Starting dynamic subtest: vecs0 [377.468760] Dynamic subtest vecs0: SUCCESS (2.064s) [377.484083] Starting dynamic subtest: ccs0 [378.580769] Dynamic subtest ccs0: SUCCESS (1.111s) [378.594169] Starting dynamic subtest: all [380.457926] Dynamic subtest all: SUCCESS (1.875s) [380.460925] Subtest evict-prime: SUCCESS (11.081s) [380.558417] [073/138] (619s left) i915_hangman (engine-engine-hang) [380.622351] Starting subtest: engine-engine-hang [380.624737] Starting dynamic subtest: rcs0 [382.433827] Dynamic subtest rcs0: SUCCESS (1.809s) [382.452210] Starting dynamic subtest: bcs0 [384.416364] Dynamic subtest bcs0: SUCCESS (1.981s) [384.431967] Starting dynamic subtest: vcs0 [394.652608] Dynamic subtest vcs0: FAIL (10.158s) [394.666270] Starting dynamic subtest: vcs1 [396.448112] Dynamic subtest vcs1: SUCCESS (1.870s) [396.463110] Starting dynamic subtest: vecs0 [398.431862] Dynamic subtest vecs0: SUCCESS (1.983s) [398.448541] Starting dynamic subtest: ccs0 [400.415395] Dynamic subtest ccs0: SUCCESS (1.981s) [400.418160] Subtest engine-engine-hang: FAIL (19.793s) [400.494336] [074/138] (599s left) kms_async_flips (alternate-sync-async-flip) [400.570428] Starting subtest: alternate-sync-async-flip [400.950089] Starting dynamic subtest: pipe-A-eDP-1 [403.775553] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.825s) [404.155080] Starting dynamic subtest: pipe-B-eDP-1 [407.017710] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.874s) [407.393274] Starting dynamic subtest: pipe-C-eDP-1 [410.217511] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.832s) [410.599780] Starting dynamic subtest: pipe-D-eDP-1 [413.484534] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.889s) [413.487038] Subtest alternate-sync-async-flip: SUCCESS (12.912s) [414.731565] [075/138] (585s left) i915_pm_rpm (system-suspend) [416.555778] Starting subtest: system-suspend [439.511191] Subtest system-suspend: SUCCESS (7.957s) [440.319751] [076/138] (574s left) i915_query (query-regions-garbage-items) [440.376334] Starting subtest: query-regions-garbage-items [440.378761] Subtest query-regions-garbage-items: SUCCESS (0.000s) [440.441060] [077/138] (574s left) gem_exec_schedule (u-submit-golden-slice) [440.512833] Starting subtest: u-submit-golden-slice [440.515182] Starting dynamic subtest: rcs0 [440.520790] Dynamic subtest rcs0: SUCCESS (0.020s) [440.536102] Starting dynamic subtest: bcs0 [440.544553] Dynamic subtest bcs0: SUCCESS (0.023s) [440.555941] Starting dynamic subtest: vcs0 [440.570946] Dynamic subtest vcs0: SUCCESS (0.026s) [440.581140] Starting dynamic subtest: vcs1 [440.590426] Dynamic subtest vcs1: SUCCESS (0.019s) [440.608546] Starting dynamic subtest: vecs0 [440.622179] Dynamic subtest vecs0: SUCCESS (0.031s) [440.636163] Starting dynamic subtest: ccs0 [440.642289] Dynamic subtest ccs0: SUCCESS (0.019s) [440.644722] Subtest u-submit-golden-slice: SUCCESS (0.143s) [442.525134] [078/138] (572s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render) [442.597286] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render [445.382018] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (2.791s) [445.524861] [079/138] (569s left) v3d/v3d_perfmon (get-values-valid-perfmon) [445.619437] Subtest get-values-valid-perfmon: SKIP (0.000s) [445.670524] [080/138] (569s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt) [445.761512] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt [449.036309] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (3.278s) [449.164424] [081/138] (565s left) gem_partial_pwrite_pread (writes-after-reads-uncached) [449.230887] Subtest writes-after-reads-uncached: SKIP (0.000s) [449.285192] [082/138] (565s left) gem_exec_balancer (individual) [449.324939] Starting subtest: individual [451.455588] Subtest individual: SUCCESS (2.128s) [451.701057] [083/138] (563s left) prime_vgem (fence-wait) [451.758353] Starting subtest: fence-wait [451.760241] Starting dynamic subtest: rcs0 [452.788486] Dynamic subtest rcs0: SUCCESS (1.030s) [452.804843] Starting dynamic subtest: bcs0 [453.838036] Dynamic subtest bcs0: SUCCESS (1.048s) [453.854307] Starting dynamic subtest: vcs0 [454.885729] Dynamic subtest vcs0: SUCCESS (1.045s) [454.902997] Starting dynamic subtest: vcs1 [456.426372] Dynamic subtest vcs1: SUCCESS (1.538s) [456.442925] Starting dynamic subtest: vecs0 [458.410551] Dynamic subtest vecs0: SUCCESS (1.982s) [458.426934] Starting dynamic subtest: ccs0 [460.395548] Dynamic subtest ccs0: SUCCESS (1.982s) [460.398862] Subtest fence-wait: SUCCESS (8.638s) [460.505777] [084/138] (554s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-render) [460.592642] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-render [465.467849] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-render: SUCCESS (4.879s) [465.612953] [085/138] (549s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu) [465.689434] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu [470.683132] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.998s) [470.809263] [086/138] (544s left) kms_psr2_sf (overlay-plane-move-continuous-sf) [475.953437] Starting subtest: overlay-plane-move-continuous-sf [475.956258] Starting dynamic subtest: pipe-A-eDP-1 [482.759668] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.803s) [482.775219] Starting dynamic subtest: pipe-B-eDP-1 [489.551876] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.789s) [489.554461] Subtest overlay-plane-move-continuous-sf: SUCCESS (13.599s) [490.462755] [087/138] (524s left) kms_big_fb (linear-32bpp-rotate-90) [490.554125] Starting subtest: linear-32bpp-rotate-90 [490.576350] Subtest linear-32bpp-rotate-90: SKIP (0.023s) [490.672762] [088/138] (524s left) kms_hdr (static-toggle) [490.741011] Starting subtest: static-toggle [490.746557] Subtest static-toggle: SKIP (0.000s) [490.806024] [089/138] (524s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic) [490.881541] Starting subtest: 2x-flip-vs-cursor-atomic [490.886295] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.001s) [490.972414] [090/138] (524s left) gem_ccs (block-copy-compressed) [491.018602] Starting subtest: block-copy-compressed [491.023420] Subtest block-copy-compressed: SKIP (0.000s) [491.076814] [091/138] (524s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled) [491.146618] Starting subtest: yf-tiled-ccs-to-yf-tiled [491.151056] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s) [491.329384] [092/138] (524s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180) [491.444891] Starting subtest: linear-max-hw-stride-64bpp-rotate-180 [492.514524] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.068s) [492.639567] [093/138] (522s left) kms_big_fb (4-tiled-addfb) [492.718874] Starting subtest: 4-tiled-addfb [492.721129] Subtest 4-tiled-addfb: SUCCESS (0.000s) [492.801045] [094/138] (522s left) kms_ccs (pipe-a-bad-rotation-90-4-tiled-dg2-rc-ccs-cc) [493.142597] Starting subtest: pipe-A-bad-rotation-90-4-tiled-dg2-rc-ccs-cc [493.148021] Subtest pipe-A-bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s) [494.031490] [095/138] (521s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0) [494.142237] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0 [495.153235] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.012s) [495.286581] [096/138] (520s left) gem_mmap_gtt (basic-read-write) [495.350150] Subtest basic-read-write: SKIP (0.000s) [495.380165] [097/138] (520s left) vc4/vc4_tiling (get-bad-flags) [495.451810] Subtest get-bad-flags: SKIP (0.000s) [495.501647] [098/138] (520s left) prime_vgem (fence-write-hang) [495.587984] Subtest fence-write-hang: SKIP (0.000s) [495.672445] [099/138] (519s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt) [495.741454] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt [495.745125] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [495.829129] [100/138] (519s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt) [495.899201] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt [495.902477] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [495.973837] [101/138] (519s left) gem_workarounds (basic-read-context) [496.030685] Starting subtest: basic-read-context [496.041134] Subtest basic-read-context: SUCCESS (0.010s) [496.145952] [102/138] (519s left) drm_fdinfo (virtual-busy) [496.199328] Starting subtest: virtual-busy [496.202993] Subtest virtual-busy: SKIP (0.000s) [496.255828] [103/138] (519s left) v3d/v3d_submit_csd (bad-extension) [496.313272] Subtest bad-extension: SKIP (0.000s) [496.359594] [104/138] (519s left) kms_tiled_display (basic-test-pattern) [496.422142] Subtest basic-test-pattern: SKIP (0.000s) [496.438771] [105/138] (519s left) kms_ccs (pipe-c-bad-rotation-90-yf-tiled-ccs) [496.841265] Starting subtest: pipe-C-bad-rotation-90-yf-tiled-ccs [496.847085] Subtest pipe-C-bad-rotation-90-yf-tiled-ccs: SKIP (0.000s) [497.682866] [106/138] (518s left) kms_ccs (pipe-d-random-ccs-data-4-tiled-dg2-rc-ccs) [498.105210] Starting subtest: pipe-D-random-ccs-data-4-tiled-dg2-rc-ccs [498.114494] Subtest pipe-D-random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.000s) [498.962445] [107/138] (516s left) perf_pmu (busy-check-all) [499.009786] Starting subtest: busy-check-all [499.012323] Starting dynamic subtest: rcs0 [499.556169] Dynamic subtest rcs0: SUCCESS (0.548s) [499.573122] Starting dynamic subtest: bcs0 [500.107262] Dynamic subtest bcs0: SUCCESS (0.549s) [500.124359] Starting dynamic subtest: vcs0 [501.429356] Dynamic subtest vcs0: SUCCESS (1.319s) [501.446314] Starting dynamic subtest: vcs1 [503.413266] Dynamic subtest vcs1: SUCCESS (1.982s) [503.430251] Starting dynamic subtest: vecs0 [505.461944] Dynamic subtest vecs0: SUCCESS (2.046s) [505.478571] Starting dynamic subtest: ccs0 [506.013387] Dynamic subtest ccs0: SUCCESS (0.551s) [506.016517] Subtest busy-check-all: SUCCESS (7.005s) [506.088003] [108/138] (509s left) kms_ccs (pipe-a-crc-sprite-planes-basic-y-tiled-gen12-mc-ccs) [506.478819] Starting subtest: pipe-A-crc-sprite-planes-basic-y-tiled-gen12-mc-ccs [506.483726] Subtest pipe-A-crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.001s) [507.360746] [109/138] (508s left) kms_plane_scaling (planes-downscale-factor-0-25-upscale-20x20) [507.449579] Starting subtest: planes-downscale-factor-0-25-upscale-20x20 [507.452034] Starting dynamic subtest: pipe-A-eDP-1 [507.460550] Dynamic subtest pipe-A-eDP-1: SKIP (0.008s) [507.471362] Starting dynamic subtest: pipe-B-eDP-1 [507.484748] Dynamic subtest pipe-B-eDP-1: SKIP (0.024s) [507.494706] Starting dynamic subtest: pipe-C-eDP-1 [507.499998] Dynamic subtest pipe-C-eDP-1: SKIP (0.015s) [507.515999] Starting dynamic subtest: pipe-D-eDP-1 [507.520760] Dynamic subtest pipe-D-eDP-1: SKIP (0.015s) [507.525317] Subtest planes-downscale-factor-0-25-upscale-20x20: SKIP (0.066s) [507.602874] [110/138] (508s left) gem_mmap_gtt (basic) [507.649513] Subtest basic: SKIP (0.000s) [507.668524] [111/138] (508s left) gem_ctx_persistence (many-contexts) [507.721661] Starting subtest: many-contexts [541.580919] Subtest many-contexts: SUCCESS (33.859s) [541.655916] [112/138] (474s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode) [542.051848] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s) [542.910116] [113/138] (473s left) gem_pxp (hw-rejects-pxp-context) [545.506343] Starting subtest: hw-rejects-pxp-context [545.509202] Subtest hw-rejects-pxp-context: SUCCESS (0.001s) [545.578256] [114/138] (470s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [545.673697] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip [545.677751] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s) [545.763485] [115/138] (470s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite) [545.823040] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite [545.827725] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [545.894809] [116/138] (470s left) gem_basic (multigpu-create-close) [545.952642] Starting subtest: multigpu-create-close [545.957498] Subtest multigpu-create-close: SKIP (0.000s) [546.022202] [117/138] (470s left) kms_addfb_basic (bad-pitch-1024) [546.079748] Starting subtest: bad-pitch-1024 [546.082139] Subtest bad-pitch-1024: SUCCESS (0.000s) [546.185592] [118/138] (469s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt) [546.253225] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt [546.257858] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [546.342201] [119/138] (469s left) syncobj_timeline (invalid-multi-wait-available-unsubmitted) [546.394305] Starting subtest: invalid-multi-wait-available-unsubmitted [546.396583] Subtest invalid-multi-wait-available-unsubmitted: SUCCESS (0.000s) [546.452746] [120/138] (469s left) kms_cursor_legacy (flip-vs-cursor-toggle) [546.546618] Starting subtest: flip-vs-cursor-toggle [552.830539] Subtest flip-vs-cursor-toggle: SUCCESS (6.282s) [553.759930] [121/138] (462s left) kms_plane_multiple (tiling-yf) [553.841976] Starting subtest: tiling-yf [553.846464] Subtest tiling-yf: SKIP (0.000s) [553.901352] [122/138] (462s left) kms_ccs (pipe-d-bad-pixel-format-y-tiled-ccs) [554.307250] Starting subtest: pipe-D-bad-pixel-format-y-tiled-ccs [554.312223] Subtest pipe-D-bad-pixel-format-y-tiled-ccs: SKIP (0.000s) [555.122148] [123/138] (461s left) kms_big_fb (y-tiled-8bpp-rotate-180) [555.176016] Starting subtest: y-tiled-8bpp-rotate-180 [555.179855] Subtest y-tiled-8bpp-rotate-180: SKIP (0.000s) [555.251167] [124/138] (461s left) prime_mmap_coherency (read) [555.318731] Starting subtest: read [560.693743] Subtest read: SUCCESS (5.374s) [560.788366] [125/138] (455s left) kms_cursor_crc (cursor-rapid-movement-64x64) [560.922538] Starting subtest: cursor-rapid-movement-64x64 [560.924893] Starting dynamic subtest: pipe-A-eDP-1 [561.484881] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.557s) [561.517685] Starting dynamic subtest: pipe-D-eDP-1 [562.795465] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.291s) [562.797962] Subtest cursor-rapid-movement-64x64: SUCCESS (1.874s) [563.676541] [126/138] (452s left) kms_ccs (pipe-c-missing-ccs-buffer-4-tiled-mtl-rc-ccs) [564.087816] Starting subtest: pipe-C-missing-ccs-buffer-4-tiled-mtl-rc-ccs [564.090996] Subtest pipe-C-missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.000s) [564.946301] [127/138] (451s left) gem_eio (throttle) [565.159193] Starting subtest: throttle [566.486901] Subtest throttle: SUCCESS (1.328s) [568.506608] [128/138] (447s left) prime_vgem (basic-read) [568.604497] Starting subtest: basic-read [568.617605] Subtest basic-read: SKIP (0.011s) [568.704913] [129/138] (447s left) kms_flip (flip-vs-absolute-wf_vblank) [568.774438] Starting subtest: flip-vs-absolute-wf_vblank [568.778864] Starting dynamic subtest: A-eDP1 [577.788331] Dynamic subtest A-eDP1: SUCCESS (9.009s) [577.804290] Starting dynamic subtest: B-eDP1 [586.812387] Dynamic subtest B-eDP1: SUCCESS (9.023s) [586.829499] Starting dynamic subtest: C-eDP1 [595.825293] Dynamic subtest C-eDP1: SUCCESS (9.011s) [595.842566] Starting dynamic subtest: D-eDP1 [604.786572] Dynamic subtest D-eDP1: SUCCESS (8.959s) [604.793853] Subtest flip-vs-absolute-wf_vblank: SUCCESS (36.022s) [606.047914] [130/138] (410s left) gem_lmem_swapping (basic) [606.103094] Subtest basic: SKIP (0.000s) [606.120493] [131/138] (410s left) gem_eio (wait-1us) [606.344833] Starting subtest: wait-1us [606.739363] Subtest wait-1us: SUCCESS (0.394s) [607.482731] [132/138] (409s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers) [607.563582] Starting subtest: plane-upscale-factor-0-25-with-modifiers [607.566001] Starting dynamic subtest: pipe-A-eDP-1 [607.994606] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.431s) [608.004916] Starting dynamic subtest: pipe-B-eDP-1 [609.576990] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.581s) [609.589913] Starting dynamic subtest: pipe-C-eDP-1 [611.170118] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.590s) [611.182771] Starting dynamic subtest: pipe-D-eDP-1 [612.837134] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.664s) [612.839639] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (5.275s) [614.111772] [133/138] (402s left) gem_exec_reloc (basic-gtt-wc-noreloc) [614.176999] Subtest basic-gtt-wc-noreloc: SKIP (0.000s) [614.237301] [134/138] (402s left) kms_atomic_transition (plane-all-modeset-transition) [614.315305] Starting subtest: plane-all-modeset-transition [614.319474] Subtest plane-all-modeset-transition: SKIP (0.000s) [614.381443] [135/138] (402s left) kms_feature_discovery (dp-mst) [614.434809] Starting subtest: dp-mst [614.439791] Subtest dp-mst: SKIP (0.000s) [614.488832] [136/138] (402s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu) [614.570689] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu [614.575216] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [614.650647] [137/138] (401s left) perf_pmu (busy-accuracy-50) [614.717986] Starting subtest: busy-accuracy-50 [614.720294] Starting dynamic subtest: rcs0 [616.256397] Dynamic subtest rcs0: SUCCESS (1.536s) [616.273839] Starting dynamic subtest: bcs0 [617.798460] Dynamic subtest bcs0: SUCCESS (1.541s) [617.816137] Starting dynamic subtest: vcs0 [619.341784] Dynamic subtest vcs0: SUCCESS (1.542s) [619.359349] Starting dynamic subtest: vcs1 [620.882058] Dynamic subtest vcs1: SUCCESS (1.539s) [620.899779] Starting dynamic subtest: vecs0 [622.424148] Dynamic subtest vecs0: SUCCESS (1.541s) [622.441370] Starting dynamic subtest: ccs0 [623.970333] Dynamic subtest ccs0: SUCCESS (1.544s) [623.973397] Subtest busy-accuracy-50: SUCCESS (9.251s) [624.079760] [138/138] (392s left) kms_pipe_crc_basic (read-crc-frame-sequence) [624.165296] Starting subtest: read-crc-frame-sequence [624.167801] Starting dynamic subtest: pipe-A-eDP-1 [624.901855] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.736s) [624.916447] Starting dynamic subtest: pipe-B-eDP-1 [626.375227] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.470s) [626.389832] Starting dynamic subtest: pipe-C-eDP-1 [627.793696] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.415s) [627.809211] Starting dynamic subtest: pipe-D-eDP-1 [629.188641] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.392s) [629.191144] Subtest read-crc-frame-sequence: SUCCESS (5.024s) [630.094438] Closing watchdogs Done.