[54.468076] Initializing watchdogs [54.468358] /dev/watchdog0 [54.484085] [001/139] (960s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0) [55.002734] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0 [56.754987] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.752s) [56.894669] [002/139] (958s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt) [57.146306] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt [57.148939] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [57.236694] [003/139] (957s left) kms_psr (cursor_plane_onoff) [57.379219] Subtest cursor_plane_onoff: SKIP (0.000s) [57.420207] [004/139] (957s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle) [57.657080] Starting subtest: short-busy-flip-before-cursor-toggle [57.659617] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s) [57.737187] [005/139] (957s left) gem_mmap_wc (write-cpu-read-wc) [57.878243] Starting subtest: write-cpu-read-wc [58.168858] Subtest write-cpu-read-wc: SUCCESS (0.290s) [58.235967] [006/139] (956s left) gem_exec_fair (basic-sync) [58.420365] Starting subtest: basic-sync [58.421860] Starting dynamic subtest: rcs0 [63.278414] Dynamic subtest rcs0: SUCCESS (4.858s) [63.280461] Subtest basic-sync: SUCCESS (4.859s) [63.508434] [007/139] (951s left) i915_pm_rpm (system-suspend) [65.412421] Starting subtest: system-suspend [82.910852] Subtest system-suspend: SUCCESS (1.251s) [87.471712] [008/139] (947s left) vgem_slow (nohang) [87.710150] Starting subtest: nohang [97.815986] Subtest nohang: SUCCESS (10.102s) [97.877615] [009/139] (937s left) syncobj_timeline (device-signal-unordered) [98.025824] Starting subtest: device-signal-unordered [98.028903] Subtest device-signal-unordered: SUCCESS (0.003s) [98.113234] [010/139] (937s left) kms_chamelium_hpd (vga-hpd-after-suspend) [98.458062] Subtest vga-hpd-after-suspend: SKIP (0.000s) [98.745714] [011/139] (936s left) gem_media_vme [98.942123] [012/139] (936s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt) [99.187592] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt [99.191446] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [99.279747] [013/139] (936s left) gem_ctx_param (invalid-get-engines) [99.423372] Starting subtest: invalid-get-engines [99.424785] Subtest invalid-get-engines: SUCCESS (0.001s) [99.510656] [014/139] (935s left) i915_selftest (live) [100.964797] Starting subtest: live [100.966201] Starting dynamic subtest: sanitycheck [102.257428] Dynamic subtest sanitycheck: SUCCESS (1.292s) [102.271469] Starting dynamic subtest: uncore [103.561646] Dynamic subtest uncore: SUCCESS (1.303s) [103.579283] Starting dynamic subtest: workarounds [105.165185] Dynamic subtest workarounds: SUCCESS (1.603s) [105.181774] Starting dynamic subtest: gt_engines [107.063636] Dynamic subtest gt_engines: SUCCESS (1.897s) [107.077802] Starting dynamic subtest: gt_timelines [123.541862] Dynamic subtest gt_timelines: SUCCESS (16.477s) [123.556126] Starting dynamic subtest: gt_contexts [124.927058] Dynamic subtest gt_contexts: SUCCESS (1.385s) [124.941259] Starting dynamic subtest: gt_lrc [128.877410] Dynamic subtest gt_lrc: SUCCESS (3.949s) [128.896201] Starting dynamic subtest: gt_mocs [130.311917] Dynamic subtest gt_mocs: SUCCESS (1.434s) [130.326546] Starting dynamic subtest: gt_pm [136.961816] Dynamic subtest gt_pm: SUCCESS (6.649s) [136.980472] Starting dynamic subtest: gt_heartbeat [138.266154] Dynamic subtest gt_heartbeat: SUCCESS (1.304s) [138.280399] Starting dynamic subtest: gt_tlb [140.341152] Dynamic subtest gt_tlb: SUCCESS (2.074s) [140.359651] Starting dynamic subtest: requests [147.943920] Dynamic subtest requests: SUCCESS (7.601s) [147.958156] Starting dynamic subtest: migrate [152.319033] Dynamic subtest migrate: SUCCESS (4.375s) [152.333356] Starting dynamic subtest: active [153.744229] Dynamic subtest active: SUCCESS (1.421s) [153.765569] Starting dynamic subtest: objects [157.687509] Dynamic subtest objects: SUCCESS (3.945s) [157.701662] Starting dynamic subtest: mman [166.419634] Dynamic subtest mman: SUCCESS (8.733s) [166.434139] Starting dynamic subtest: dmabuf [167.676295] Dynamic subtest dmabuf: SUCCESS (1.254s) [167.690561] Starting dynamic subtest: vma [168.982373] Dynamic subtest vma: SUCCESS (1.305s) [168.996663] Starting dynamic subtest: coherency [175.095243] Dynamic subtest coherency: SUCCESS (6.112s) [175.113859] Starting dynamic subtest: gtt [183.761821] Dynamic subtest gtt: SUCCESS (8.666s) [183.776405] Starting dynamic subtest: gem [185.145889] Dynamic subtest gem: SUCCESS (1.383s) [185.160086] Starting dynamic subtest: evict [189.422755] Dynamic subtest evict: SUCCESS (4.275s) [189.441571] Starting dynamic subtest: hugepages [196.670744] Dynamic subtest hugepages: SUCCESS (7.247s) [196.685167] Starting dynamic subtest: gem_contexts [216.562365] Dynamic subtest gem_contexts: SUCCESS (19.887s) [216.576967] Starting dynamic subtest: client [217.988486] Dynamic subtest client: SUCCESS (1.428s) [218.007966] Starting dynamic subtest: gem_migrate [219.343986] Dynamic subtest gem_migrate: SUCCESS (1.354s) [219.358774] Starting dynamic subtest: reset [226.062361] Dynamic subtest reset: SUCCESS (6.716s) [226.078801] Starting dynamic subtest: memory_region [227.265483] Dynamic subtest memory_region: SUCCESS (1.203s) [227.279917] Starting dynamic subtest: hangcheck [251.596681] Dynamic subtest hangcheck: SUCCESS (24.330s) [251.611705] Starting dynamic subtest: execlists [262.250173] Dynamic subtest execlists: SUCCESS (10.652s) [262.264671] Starting dynamic subtest: ring_submission [263.454206] Dynamic subtest ring_submission: SUCCESS (1.203s) [263.468693] Starting dynamic subtest: perf [264.898839] Dynamic subtest perf: SUCCESS (1.443s) [264.913410] Starting dynamic subtest: slpc [266.142186] Dynamic subtest slpc: SUCCESS (1.242s) [266.156711] Starting dynamic subtest: guc [267.319294] Dynamic subtest guc: SUCCESS (1.174s) [267.337325] Starting dynamic subtest: guc_multi_lrc [268.668770] Dynamic subtest guc_multi_lrc: SUCCESS (1.349s) [268.683298] Starting dynamic subtest: guc_hang [270.050881] Dynamic subtest guc_hang: SUCCESS (1.380s) [270.068790] Starting dynamic subtest: late_gt_pm [271.292083] Dynamic subtest late_gt_pm: SUCCESS (1.239s) [271.293396] Subtest live: SUCCESS (170.328s) [271.330248] [015/139] (764s left) syncobj_timeline (wait-delayed-signal) [274.500804] Starting subtest: wait-delayed-signal [274.603207] Subtest wait-delayed-signal: SUCCESS (0.104s) [274.669825] [016/139] (760s left) vc4/vc4_perfmon (create-perfmon-exceed) [274.908488] Subtest create-perfmon-exceed: SKIP (0.000s) [274.977367] [017/139] (760s left) gem_eio (in-flight-suspend) [275.163509] Starting subtest: in-flight-suspend [313.332108] Subtest in-flight-suspend: SUCCESS (8.066s) [318.561554] [018/139] (752s left) gem_madvise (dontneed-before-exec) [318.698992] Starting subtest: dontneed-before-exec [318.712951] Subtest dontneed-before-exec: SUCCESS (0.008s) [318.816955] [019/139] (751s left) kms_ccs (pipe-c-bad-pixel-format-4-tiled-dg2-rc-ccs) [319.244759] Starting subtest: pipe-C-bad-pixel-format-4-tiled-dg2-rc-ccs [319.247479] Subtest pipe-C-bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.000s) [319.608144] [020/139] (751s left) gem_exec_flush (basic-uc-ro-default) [319.775765] Starting subtest: basic-uc-ro-default [325.244455] Subtest basic-uc-ro-default: SUCCESS (5.469s) [325.445369] [021/139] (745s left) gem_exec_fence (submit-chain) [325.748767] Starting subtest: submit-chain [325.775900] Subtest submit-chain: SUCCESS (0.029s) [326.459739] [022/139] (744s left) gem_bad_reloc (negative-reloc-lut) [326.612186] Starting subtest: negative-reloc-lut [326.618639] Subtest negative-reloc-lut: SUCCESS (0.002s) [326.724596] [023/139] (744s left) gem_ccs (ctrl-surf-copy) [326.874596] Subtest ctrl-surf-copy: SKIP (0.000s) [326.925433] [024/139] (744s left) syncobj_wait (invalid-single-wait-all-unsubmitted) [327.068023] Starting subtest: invalid-single-wait-all-unsubmitted [327.070090] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s) [327.158510] [025/139] (743s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc) [327.404317] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc [327.407249] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [327.508717] [026/139] (743s left) gen9_exec_parse (bb-oversize) [327.676624] Starting subtest: bb-oversize [329.758448] Subtest bb-oversize: SKIP (2.070s) [330.010240] [027/139] (741s left) kms_rotation_crc (sprite-rotation-270) [330.374727] Starting subtest: sprite-rotation-270 [336.630232] Subtest sprite-rotation-270: SUCCESS (6.255s) [337.074895] [028/139] (734s left) kms_big_fb (4-tiled-8bpp-rotate-0) [337.344017] Starting subtest: 4-tiled-8bpp-rotate-0 [337.347174] Subtest 4-tiled-8bpp-rotate-0: SKIP (0.000s) [337.456584] [029/139] (733s left) gem_exec_reloc (basic-cpu-gtt) [337.616174] Starting subtest: basic-cpu-gtt [337.645894] Subtest basic-cpu-gtt: SUCCESS (0.030s) [337.840467] [030/139] (733s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu) [338.087307] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu [338.089882] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [338.189357] [031/139] (733s left) kms_frontbuffer_tracking (fbcpsr-2p-rte) [338.440597] Starting subtest: fbcpsr-2p-rte [338.443271] Subtest fbcpsr-2p-rte: SKIP (0.000s) [338.540249] [032/139] (732s left) kms_big_fb (x-tiled-16bpp-rotate-270) [338.800221] Starting subtest: x-tiled-16bpp-rotate-270 [338.896436] Subtest x-tiled-16bpp-rotate-270: SKIP (0.094s) [339.005748] [033/139] (732s left) kms_psr (psr2_sprite_render) [339.152316] Subtest psr2_sprite_render: SKIP (0.000s) [339.207244] [034/139] (732s left) syncobj_wait (single-wait-for-submit-unsubmitted) [339.371407] Starting subtest: single-wait-for-submit-unsubmitted [339.482067] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.107s) [339.571633] [035/139] (731s left) kms_ccs (pipe-b-bad-rotation-90-4-tiled-dg2-rc-ccs) [339.947344] Starting subtest: pipe-B-bad-rotation-90-4-tiled-dg2-rc-ccs [339.950121] Subtest pipe-B-bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.000s) [340.371247] [036/139] (731s left) gem_ctx_param (invalid-ctx-set) [340.518673] Starting subtest: invalid-ctx-set [340.520278] Subtest invalid-ctx-set: SUCCESS (0.001s) [340.604716] [037/139] (730s left) api_intel_allocator (reloc-allocator) [340.750968] Starting subtest: reloc-allocator [340.752552] Starting dynamic subtest: basic [340.757290] Dynamic subtest basic: SUCCESS (0.006s) [340.785057] Starting dynamic subtest: parallel-one [340.786446] Dynamic subtest parallel-one: SUCCESS (0.013s) [340.809034] Starting dynamic subtest: print [340.810303] Dynamic subtest print: SUCCESS (0.000s) [340.833953] Starting dynamic subtest: reuse [340.835299] Dynamic subtest reuse: SUCCESS (0.000s) [340.858018] Starting dynamic subtest: fork-reopen-allocator [340.859349] Dynamic subtest fork-reopen-allocator: SUCCESS (0.045s) [340.860763] Subtest reloc-allocator: SUCCESS (0.074s) [340.919589] [038/139] (730s left) kms_big_fb (linear-16bpp-rotate-180) [341.197698] Starting subtest: linear-16bpp-rotate-180 [346.011336] Subtest linear-16bpp-rotate-180: SUCCESS (4.812s) [346.354403] [039/139] (725s left) syncobj_timeline (invalid-signal-illegal-point) [346.500000] Starting subtest: invalid-signal-illegal-point [346.501724] Subtest invalid-signal-illegal-point: SUCCESS (0.000s) [346.586353] [040/139] (725s left) prime_vgem (basic-read) [346.769695] Starting subtest: basic-read [346.826985] Subtest basic-read: SUCCESS (0.055s) [346.935677] [041/139] (724s left) syncobj_timeline (signal-point-0) [347.081389] Starting subtest: signal-point-0 [347.083355] Subtest signal-point-0: SUCCESS (0.000s) [347.170640] [042/139] (724s left) kms_flip (2x-modeset-vs-vblank-race-interruptible) [347.406272] Starting subtest: 2x-modeset-vs-vblank-race-interruptible [347.408771] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.003s) [347.502544] [043/139] (724s left) kms_frontbuffer_tracking (fbcpsr-slowdraw) [347.749226] Starting subtest: fbcpsr-slowdraw [347.751785] Subtest fbcpsr-slowdraw: SKIP (0.000s) [347.852766] [044/139] (724s left) kms_writeback (writeback-check-output-xrgb2101010) [348.189961] Subtest writeback-check-output-XRGB2101010: SKIP (0.000s) [348.236997] [045/139] (723s left) kms_big_fb (yf-tiled-32bpp-rotate-90) [348.499685] Starting subtest: yf-tiled-32bpp-rotate-90 [353.444445] Subtest yf-tiled-32bpp-rotate-90: SUCCESS (4.944s) [353.971403] [046/139] (717s left) kms_ccs (pipe-b-random-ccs-data-4-tiled-mtl-rc-ccs-cc) [354.380879] Starting subtest: pipe-B-random-ccs-data-4-tiled-mtl-rc-ccs-cc [354.384699] Subtest pipe-B-random-ccs-data-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s) [354.767037] [047/139] (717s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling) [355.008206] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling [355.009673] Starting dynamic subtest: pipe-A-valid-mode [355.711341] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.699s) [355.713529] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SUCCESS (0.703s) [356.045169] [048/139] (715s left) kms_psr2_sf (overlay-plane-move-continuous-sf) [356.192442] Subtest overlay-plane-move-continuous-sf: SKIP (0.000s) [356.246517] [049/139] (715s left) kms_flip (flip-vs-expired-vblank-interruptible) [356.482567] Starting subtest: flip-vs-expired-vblank-interruptible [356.487256] Starting dynamic subtest: A-DP1 [366.986515] Dynamic subtest A-DP1: SUCCESS (10.499s) [367.012712] Starting dynamic subtest: B-DP1 [377.426754] Dynamic subtest B-DP1: SUCCESS (10.436s) [377.451359] Starting dynamic subtest: C-DP1 [387.878062] Dynamic subtest C-DP1: SUCCESS (10.451s) [387.882308] Subtest flip-vs-expired-vblank-interruptible: SUCCESS (31.398s) [388.311709] [050/139] (683s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling) [388.564598] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling [388.566111] Starting dynamic subtest: pipe-A-valid-mode [388.684579] Dynamic subtest pipe-A-valid-mode: SKIP (0.117s) [388.687923] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.121s) [389.021952] [051/139] (683s left) gem_render_copy (yf-tiled-ccs-to-linear) [389.187878] Starting subtest: yf-tiled-ccs-to-linear [389.189410] Starting dynamic subtest: smem [389.481243] Dynamic subtest smem: SUCCESS (0.291s) [389.483251] Subtest yf-tiled-ccs-to-linear: SUCCESS (0.293s) [389.689759] [052/139] (682s left) gen7_exec_parse (chained-batch) [389.841288] Subtest chained-batch: SKIP (0.000s) [389.907539] [053/139] (682s left) kms_ccs (pipe-c-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc) [390.388133] Starting subtest: pipe-C-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc [390.393257] Subtest pipe-C-crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s) [390.723920] [054/139] (681s left) kms_fbcon_fbt (fbc) [390.874583] Starting subtest: fbc [394.767063] Subtest fbc: SUCCESS (3.890s) [394.824502] [055/139] (677s left) kms_ccs (pipe-b-bad-pixel-format-4-tiled-dg2-rc-ccs-cc) [395.211180] Starting subtest: pipe-B-bad-pixel-format-4-tiled-dg2-rc-ccs-cc [395.213930] Subtest pipe-B-bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s) [395.635910] [056/139] (676s left) i915_pm_rpm (gem-evict-pwrite) [397.366221] Starting subtest: gem-evict-pwrite [398.482560] Subtest gem-evict-pwrite: SUCCESS (1.116s) [398.943640] [057/139] (673s left) kms_invalid_mode (bad-hsync-end) [399.189896] Starting subtest: bad-hsync-end [399.191754] Starting dynamic subtest: pipe-A-DP-1 [399.277451] Dynamic subtest pipe-A-DP-1: SUCCESS (0.086s) [399.313951] Starting dynamic subtest: pipe-B-DP-1 [399.316005] Dynamic subtest pipe-B-DP-1: SUCCESS (0.002s) [399.353742] Starting dynamic subtest: pipe-C-DP-1 [399.355722] Dynamic subtest pipe-C-DP-1: SUCCESS (0.003s) [399.357823] Subtest bad-hsync-end: SUCCESS (0.103s) [399.613235] [058/139] (672s left) debugfs_test (basic-hwmon) [399.763181] Starting subtest: basic-hwmon [399.766075] Subtest basic-hwmon: SKIP (0.000s) [399.962793] [059/139] (672s left) gem_exec_schedule (fairslice) [400.136782] Starting subtest: fairslice [400.138348] Starting dynamic subtest: rcs0 [402.171399] Dynamic subtest rcs0: SUCCESS (2.029s) [402.195426] Starting dynamic subtest: bcs0 [404.211132] Dynamic subtest bcs0: SUCCESS (2.037s) [404.234677] Starting dynamic subtest: vcs0 [406.242544] Dynamic subtest vcs0: SUCCESS (2.026s) [406.265974] Starting dynamic subtest: vecs0 [408.272257] Dynamic subtest vecs0: SUCCESS (2.028s) [408.273810] Subtest fairslice: SUCCESS (8.133s) [408.614241] [060/139] (663s left) sysfs_timeslice_duration (timeout) [408.764020] Starting subtest: timeout [408.768443] Starting dynamic subtest: vecs0 [409.661919] Dynamic subtest vecs0: SUCCESS (0.893s) [409.691789] Starting dynamic subtest: vcs0 [410.559080] Dynamic subtest vcs0: SUCCESS (0.896s) [410.586672] Starting dynamic subtest: bcs0 [411.468653] Dynamic subtest bcs0: SUCCESS (0.904s) [411.493010] Starting dynamic subtest: rcs0 [412.382333] Dynamic subtest rcs0: SUCCESS (0.911s) [412.384516] Subtest timeout: SUCCESS (3.617s) [412.481309] [061/139] (660s left) syncobj_timeline (etime-multi-wait-all-submitted) [412.628239] Starting subtest: etime-multi-wait-all-submitted [412.736686] Subtest etime-multi-wait-all-submitted: SUCCESS (0.107s) [412.829469] [062/139] (659s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled) [412.975544] Starting subtest: multi-wait-all-for-submit-available-signaled [412.977062] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.002s) [413.062811] [063/139] (659s left) kms_cdclk (mode-transition) [413.206293] Subtest mode-transition: SKIP (0.000s) [413.266295] [064/139] (659s left) kms_pm_rpm (drm-resources-equal) [415.008934] Starting subtest: drm-resources-equal [416.627211] Subtest drm-resources-equal: SUCCESS (1.620s) [416.813024] [065/139] (655s left) vc4/vc4_purgeable_bo (mark-willneed) [417.016206] Subtest mark-willneed: SKIP (0.000s) [417.092611] [066/139] (655s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render) [417.343110] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render [417.345684] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [417.458586] [067/139] (655s left) kms_mmap_write_crc (main) [417.713463] Starting subtest: main [417.717481] Starting dynamic subtest: pipe-A-DP-1 [421.130999] Dynamic subtest pipe-A-DP-1: SUCCESS (3.411s) [421.133622] Subtest main: SUCCESS (3.416s) [421.521162] [068/139] (651s left) core_getstats [421.748141] [069/139] (651s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt) [421.991767] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt [424.072867] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SUCCESS (2.082s) [424.215493] [070/139] (648s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers) [424.455928] Starting subtest: plane-scaler-with-clipping-clamping-modifiers [424.469877] Starting dynamic subtest: pipe-A-DP-1 [425.487545] Dynamic subtest pipe-A-DP-1: SUCCESS (1.019s) [425.525384] Starting dynamic subtest: pipe-B-DP-1 [426.793531] Dynamic subtest pipe-B-DP-1: SUCCESS (1.295s) [426.830059] Starting dynamic subtest: pipe-C-DP-1 [427.765017] Dynamic subtest pipe-C-DP-1: SUCCESS (0.961s) [427.766507] Subtest plane-scaler-with-clipping-clamping-modifiers: SUCCESS (3.312s) [428.195866] [071/139] (644s left) kms_ccs (pipe-a-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc) [428.556139] Starting subtest: pipe-A-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc [428.563037] Subtest pipe-A-crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SKIP (0.005s) [428.994031] [072/139] (644s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move) [429.252184] Starting subtest: fbc-2p-scndscrn-cur-indfb-move [429.255513] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [429.361157] [073/139] (643s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move) [429.605518] Starting subtest: psr-2p-scndscrn-cur-indfb-move [429.608113] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [429.710919] [074/139] (643s left) vgem_basic (bad-pad) [429.869687] Starting subtest: bad-pad [429.871396] Subtest bad-pad: SUCCESS (0.000s) [429.945527] [075/139] (643s left) syncobj_wait (multi-wait-for-submit-submitted-signaled) [430.094485] Starting subtest: multi-wait-for-submit-submitted-signaled [430.096081] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s) [430.179403] [076/139] (643s left) gem_ctx_persistence (engines-mixed) [430.333013] Starting subtest: engines-mixed [430.334962] Starting dynamic subtest: rcs0 [430.394146] Dynamic subtest rcs0: SUCCESS (0.058s) [430.432732] Starting dynamic subtest: bcs0 [430.450549] Dynamic subtest bcs0: SUCCESS (0.054s) [430.478811] Starting dynamic subtest: vcs0 [430.500642] Dynamic subtest vcs0: SUCCESS (0.046s) [430.529440] Starting dynamic subtest: vecs0 [430.552510] Dynamic subtest vecs0: SUCCESS (0.047s) [430.554863] Subtest engines-mixed: SUCCESS (0.221s) [430.646973] [077/139] (642s left) kms_feature_discovery (psr2) [430.893669] Starting subtest: psr2 [430.896812] Subtest psr2: SKIP (0.000s) [430.994370] [078/139] (642s left) gem_exec_params (rel-constants-invalid) [431.144994] Starting subtest: rel-constants-invalid [431.146483] Subtest rel-constants-invalid: SUCCESS (0.001s) [431.260565] [079/139] (642s left) kms_chamelium_frames (vga-frame-dump) [431.600482] Subtest vga-frame-dump: SKIP (0.000s) [431.895625] [080/139] (641s left) kms_invalid_mode (zero-hdisplay) [432.131494] Starting subtest: zero-hdisplay [432.133064] Starting dynamic subtest: pipe-A-DP-1 [432.226358] Dynamic subtest pipe-A-DP-1: SUCCESS (0.093s) [432.253868] Starting dynamic subtest: pipe-B-DP-1 [432.255698] Dynamic subtest pipe-B-DP-1: SUCCESS (0.002s) [432.293359] Starting dynamic subtest: pipe-C-DP-1 [432.295417] Dynamic subtest pipe-C-DP-1: SUCCESS (0.002s) [432.297241] Subtest zero-hdisplay: SUCCESS (0.110s) [432.573575] [081/139] (640s left) gem_exec_schedule (pi-distinct-iova) [432.885978] Starting subtest: pi-distinct-iova [432.887537] Starting dynamic subtest: rcs0 [432.967385] Dynamic subtest rcs0: SUCCESS (0.081s) [432.993456] Starting dynamic subtest: bcs0 [433.038501] Dynamic subtest bcs0: SUCCESS (0.070s) [433.066063] Starting dynamic subtest: vcs0 [433.096382] Dynamic subtest vcs0: SUCCESS (0.054s) [433.125224] Starting dynamic subtest: vecs0 [433.159040] Dynamic subtest vecs0: SUCCESS (0.057s) [433.160666] Subtest pi-distinct-iova: SUCCESS (0.275s) [433.403100] [082/139] (640s left) gem_exec_balancer (bonded-sync) [433.578519] Starting subtest: bonded-sync [437.430553] Subtest bonded-sync: SUCCESS (3.853s) [441.403357] [083/139] (632s left) perf_pmu (module-unload) [441.574619] Starting subtest: module-unload [480.453979] Subtest module-unload: SUCCESS (38.876s) [480.494524] [084/139] (593s left) vgem_basic (dmabuf-export) [480.639328] Starting subtest: dmabuf-export [481.909510] Subtest dmabuf-export: SUCCESS (1.269s) [482.008078] [085/139] (591s left) gem_mmap_wc (write-wc-read-gtt) [482.194882] Starting subtest: write-wc-read-gtt [482.765199] Subtest write-wc-read-gtt: SUCCESS (0.570s) [482.881185] [086/139] (590s left) kms_busy (basic-hang) [483.152237] Starting subtest: basic-hang [483.156442] Starting dynamic subtest: flip-pipe-A [483.822460] Dynamic subtest flip-pipe-A: SUCCESS (0.665s) [483.845084] Starting dynamic subtest: modeset-pipe-A [485.317461] Dynamic subtest modeset-pipe-A: SUCCESS (1.493s) [485.344271] Starting dynamic subtest: flip-pipe-C [486.067601] Dynamic subtest flip-pipe-C: SUCCESS (0.741s) [486.091176] Starting dynamic subtest: modeset-pipe-C [487.505656] Dynamic subtest modeset-pipe-C: SUCCESS (1.434s) [487.507428] Subtest basic-hang: SUCCESS (4.352s) [487.876047] [087/139] (585s left) gem_softpin (full) [488.032736] Starting subtest: full [488.054266] Subtest full: SUCCESS (0.021s) [488.172460] [088/139] (585s left) v3d/v3d_submit_cl (bad-multisync-in-sync) [488.367025] Subtest bad-multisync-in-sync: SKIP (0.000s) [488.439146] [089/139] (585s left) kms_plane_multiple (tiling-yf) [488.675301] Starting subtest: tiling-yf [488.679467] Starting dynamic subtest: pipe-A-DP-1 [490.551962] Dynamic subtest pipe-A-DP-1: SUCCESS (1.871s) [490.577510] Starting dynamic subtest: pipe-B-DP-1 [492.709901] Dynamic subtest pipe-B-DP-1: SUCCESS (2.149s) [492.738747] Starting dynamic subtest: pipe-C-DP-1 [494.821511] Dynamic subtest pipe-C-DP-1: SUCCESS (2.115s) [494.822770] Subtest tiling-yf: SUCCESS (6.149s) [495.206918] [090/139] (578s left) kms_big_fb (y-tiled-addfb-size-offset-overflow) [495.474055] Starting subtest: y-tiled-addfb-size-offset-overflow [495.476654] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s) [495.570575] [091/139] (578s left) gem_exec_balancer (sliced) [495.737373] Starting subtest: sliced [499.578621] Subtest sliced: SUCCESS (3.839s) [503.555055] [092/139] (570s left) kms_content_protection (atomic-dpms) [503.829437] Starting subtest: atomic-dpms [503.864798] Starting dynamic subtest: pipe-A-DP-1 [624.718524] Per-test timeout exceeded. Killing the current test with SIGQUIT. [625.245039] Closing watchdogs [625.250439] Initializing watchdogs [625.250612] /dev/watchdog0 [625.277531] [093/139] (448s left) drm_read (invalid-buffer) [625.668638] Starting subtest: invalid-buffer [625.671245] Subtest invalid-buffer: SUCCESS (0.000s) [625.790094] [094/139] (448s left) gem_pxp (create-regular-buffer) [628.451592] Subtest create-regular-buffer: SKIP (0.000s) [628.541113] [095/139] (445s left) vgem_basic (create) [628.697581] Starting subtest: create [628.699038] Subtest create: SUCCESS (0.001s) [628.771267] [096/139] (445s left) kms_flip (bo-too-big) [628.991911] Starting subtest: bo-too-big [628.995847] Starting dynamic subtest: A-DP1 [632.147537] Dynamic subtest A-DP1: SUCCESS (3.153s) [632.173012] Starting dynamic subtest: B-DP1 [635.215537] Dynamic subtest B-DP1: SUCCESS (3.066s) [635.241593] Starting dynamic subtest: C-DP1 [638.273297] Dynamic subtest C-DP1: SUCCESS (3.054s) [638.277642] Subtest bo-too-big: SUCCESS (9.286s) [638.925319] [097/139] (435s left) kms_ccs (pipe-d-random-ccs-data-4-tiled-dg2-rc-ccs-cc) [639.408944] Subtest pipe-D-random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s) [639.733140] [098/139] (434s left) gem_flink_basic (bad-flink) [639.877367] Starting subtest: bad-flink [639.878991] Subtest bad-flink: SUCCESS (0.000s) [639.965000] [099/139] (434s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc) [640.218222] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc [642.456904] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (2.242s) [642.599353] [100/139] (431s left) kms_ccs (pipe-a-bad-rotation-90-4-tiled-mtl-mc-ccs) [642.938945] Starting subtest: pipe-A-bad-rotation-90-4-tiled-mtl-mc-ccs [642.941523] Subtest pipe-A-bad-rotation-90-4-tiled-mtl-mc-ccs: SKIP (0.000s) [643.416681] [101/139] (431s left) kms_ccs (pipe-c-crc-primary-basic-4-tiled-mtl-rc-ccs) [643.861666] Starting subtest: pipe-C-crc-primary-basic-4-tiled-mtl-rc-ccs [643.864453] Subtest pipe-C-crc-primary-basic-4-tiled-mtl-rc-ccs: SKIP (0.001s) [644.226280] [102/139] (430s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt) [644.479994] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt [644.483490] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [644.590971] [103/139] (429s left) v3d/v3d_submit_cl (valid-submission) [644.800253] Subtest valid-submission: SKIP (0.000s) [644.874546] [104/139] (429s left) kms_cursor_crc (cursor-onscreen-256x256) [645.126279] Starting subtest: cursor-onscreen-256x256 [645.139550] Starting dynamic subtest: pipe-A-DP-1 [647.476199] Dynamic subtest pipe-A-DP-1: SUCCESS (2.338s) [647.577509] Starting dynamic subtest: pipe-C-DP-1 [650.000557] Dynamic subtest pipe-C-DP-1: SUCCESS (2.452s) [650.002011] Subtest cursor-onscreen-256x256: SUCCESS (4.874s) [650.369945] [105/139] (424s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary) [650.617818] Starting subtest: psr-indfb-scaledprimary [650.620597] Subtest psr-indfb-scaledprimary: SKIP (0.000s) [650.715108] [106/139] (423s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-blt) [650.964666] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-blt [650.967315] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-blt: SKIP (0.000s) [651.082223] [107/139] (423s left) kms_ccs (pipe-d-bad-aux-stride-y-tiled-ccs) [651.569239] Subtest pipe-D-bad-aux-stride-y-tiled-ccs: SKIP (0.000s) [651.898277] [108/139] (422s left) gem_wait (invalid-buf) [652.050788] Starting subtest: invalid-buf [652.052312] Subtest invalid-buf: SUCCESS (0.000s) [652.332218] [109/139] (422s left) gem_userptr_blits (stress-purge) [652.520456] Starting subtest: stress-purge [657.983384] Subtest stress-purge: SUCCESS (5.463s) [658.161384] [110/139] (416s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu) [658.547270] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu [658.550006] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SKIP (0.000s) [658.644705] [111/139] (416s left) kms_ccs (pipe-b-crc-primary-rotation-180-y-tiled-gen12-mc-ccs) [659.045611] Starting subtest: pipe-B-crc-primary-rotation-180-y-tiled-gen12-mc-ccs [659.048325] Subtest pipe-B-crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.001s) [659.453104] [112/139] (415s left) dmabuf (all-tests) [659.620934] Starting subtest: all-tests [659.622310] Starting dynamic subtest: sanitycheck [659.699018] Dynamic subtest sanitycheck: SUCCESS (0.082s) [659.728273] Starting dynamic subtest: dma_fence [659.898371] Dynamic subtest dma_fence: SUCCESS (0.194s) [659.923337] Starting dynamic subtest: dma_fence_chain [683.470213] Dynamic subtest dma_fence_chain: SUCCESS (23.568s) [683.498785] Starting dynamic subtest: dma_fence_unwrap [683.538301] Dynamic subtest dma_fence_unwrap: SUCCESS (0.066s) [683.571716] Starting dynamic subtest: dma_resv [683.616044] Dynamic subtest dma_resv: SUCCESS (0.074s) [683.618184] Subtest all-tests: SUCCESS (24.003s) [683.686653] [113/139] (391s left) kms_cursor_crc (cursor-random-64x64) [683.937616] Starting subtest: cursor-random-64x64 [683.950970] Starting dynamic subtest: pipe-A-DP-1 [687.955677] Dynamic subtest pipe-A-DP-1: SUCCESS (4.006s) [688.046788] Starting dynamic subtest: pipe-C-DP-1 [691.930741] Dynamic subtest pipe-C-DP-1: SUCCESS (3.907s) [691.932218] Subtest cursor-random-64x64: SUCCESS (7.993s) [692.286676] [114/139] (382s left) kms_ccs (pipe-a-crc-primary-basic-4-tiled-dg2-mc-ccs) [692.628278] Starting subtest: pipe-A-crc-primary-basic-4-tiled-dg2-mc-ccs [692.630817] Subtest pipe-A-crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.001s) [693.090184] [115/139] (381s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-wc) [693.335466] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-wc [693.338067] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [693.440976] [116/139] (381s left) gem_ctx_bad_destroy (double-destroy) [693.582886] Starting subtest: double-destroy [693.584174] Subtest double-destroy: SUCCESS (0.000s) [693.673185] [117/139] (381s left) kms_pm_rpm (legacy-planes) [695.406054] Starting subtest: legacy-planes [695.408583] Starting dynamic subtest: plane-39 [697.510185] Dynamic subtest plane-39: SUCCESS (2.103s) [697.540108] Starting dynamic subtest: plane-47 [699.580408] Dynamic subtest plane-47: SUCCESS (2.065s) [699.583085] Subtest legacy-planes: SUCCESS (4.175s) [700.043439] [118/139] (375s left) gem_partial_pwrite_pread (write) [700.201899] Starting subtest: write [714.311532] Subtest write: SUCCESS (14.112s) [714.442656] [119/139] (360s left) gem_exec_whisper (basic-contexts-priority-all) [714.615200] Starting subtest: basic-contexts-priority-all [738.683016] Subtest basic-contexts-priority-all: SUCCESS (24.067s) [738.891940] [120/139] (336s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic) [739.128531] Starting subtest: flip-vs-cursor-crc-atomic [739.742875] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.615s) [740.082220] [121/139] (335s left) kms_atomic (plane-cursor-legacy) [740.320765] Starting subtest: plane-cursor-legacy [740.322243] Starting dynamic subtest: pipe-A-DP-1 [740.616661] Dynamic subtest pipe-A-DP-1: SUCCESS (0.295s) [740.618247] Subtest plane-cursor-legacy: SUCCESS (0.301s) [740.948649] [122/139] (334s left) kms_ccs (pipe-d-crc-primary-rotation-180-4-tiled-mtl-rc-ccs) [741.441890] Subtest pipe-D-crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SKIP (0.000s) [741.769234] [123/139] (333s left) kms_ccs (pipe-d-bad-pixel-format-4-tiled-dg2-mc-ccs) [742.245881] Subtest pipe-D-bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.000s) [742.560226] [124/139] (332s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20) [742.803247] Starting subtest: planes-downscale-factor-0-75-upscale-20x20 [742.813035] Starting dynamic subtest: pipe-A-DP-1 [742.896493] Dynamic subtest pipe-A-DP-1: SUCCESS (0.084s) [742.932982] Starting dynamic subtest: pipe-B-DP-1 [743.286990] Dynamic subtest pipe-B-DP-1: SUCCESS (0.379s) [743.297281] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (0.498s) [743.721088] [125/139] (331s left) gem_fenced_exec_thrash (no-spare-fences-busy-interruptible) [743.869989] Starting subtest: no-spare-fences-busy-interruptible [746.052079] Subtest no-spare-fences-busy-interruptible: SUCCESS (2.182s) [746.222080] [126/139] (329s left) gem_exec_schedule (smoketest) [746.530033] Starting subtest: smoketest [746.531320] Starting dynamic subtest: rcs0 [752.006192] Dynamic subtest rcs0: SUCCESS (5.468s) [752.033172] Starting dynamic subtest: bcs0 [757.470981] Dynamic subtest bcs0: SUCCESS (5.462s) [757.496089] Starting dynamic subtest: vcs0 [762.931653] Dynamic subtest vcs0: SUCCESS (5.458s) [762.960480] Starting dynamic subtest: vecs0 [768.399621] Dynamic subtest vecs0: SUCCESS (5.466s) [768.401027] Subtest smoketest: SUCCESS (21.866s) [768.607452] [127/139] (307s left) gem_mmap_gtt (fault-concurrent) [768.749247] Starting subtest: fault-concurrent [772.213523] Subtest fault-concurrent: SUCCESS (3.460s) [772.640260] [128/139] (303s left) gem_tiled_blits (interruptible) [773.114954] Starting subtest: interruptible [826.205692] Subtest interruptible: SUCCESS (53.089s) [826.328046] [129/139] (249s left) kms_universal_plane (universal-plane-functional) [826.697668] Starting subtest: universal-plane-functional [826.700493] Starting dynamic subtest: pipe-A-DP-1 [829.095228] Dynamic subtest pipe-A-DP-1: SUCCESS (2.393s) [829.125989] Starting dynamic subtest: pipe-B-DP-1 [831.708744] Dynamic subtest pipe-B-DP-1: SUCCESS (2.609s) [831.737568] Starting dynamic subtest: pipe-C-DP-1 [834.324690] Dynamic subtest pipe-C-DP-1: SUCCESS (2.609s) [834.326051] Subtest universal-plane-functional: SUCCESS (7.628s) [834.650627] [130/139] (241s left) kms_cursor_edge_walk (64x64-right-edge) [834.891518] Starting subtest: 64x64-right-edge [834.893593] Starting dynamic subtest: pipe-A-DP-1 [838.748268] Dynamic subtest pipe-A-DP-1: SUCCESS (3.854s) [838.779524] Starting dynamic subtest: pipe-C-DP-1 [842.219861] Dynamic subtest pipe-C-DP-1: SUCCESS (3.464s) [842.221189] Subtest 64x64-right-edge: SUCCESS (7.329s) [842.550702] [131/139] (233s left) kms_vrr (flip-basic) [842.788986] Starting subtest: flip-basic [842.791644] Subtest flip-basic: SKIP (0.000s) [842.881140] [132/139] (232s left) gem_lmem_swapping (massive) [843.050985] Subtest massive: SKIP (0.000s) [843.116214] [133/139] (232s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt) [843.374409] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt [843.377511] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [843.481362] [134/139] (232s left) gem_eio (create) [843.657062] Starting subtest: create [843.704143] Subtest create: SUCCESS (0.047s) [843.914530] [135/139] (232s left) gem_ctx_create (basic) [844.082566] Starting subtest: basic [844.084024] Subtest basic: SUCCESS (0.000s) [844.298224] [136/139] (231s left) sw_sync (timeline_closed) [844.441110] Starting subtest: timeline_closed [844.442673] Subtest timeline_closed: SUCCESS (0.000s) [844.515001] [137/139] (231s left) gem_exec_flush (basic-wb-pro-default) [844.683942] Starting subtest: basic-wb-pro-default [850.153931] Subtest basic-wb-pro-default: SUCCESS (5.472s) [850.369424] [138/139] (225s left) api_intel_allocator (default-alignment) [850.510504] Starting subtest: default-alignment [850.515946] Subtest default-alignment: SUCCESS (0.004s) [850.615942] [139/139] (225s left) gem_bad_reloc (negative-reloc-bltcopy) [850.768295] Starting subtest: negative-reloc-bltcopy [854.060756] Subtest negative-reloc-bltcopy: SUCCESS (3.289s) [854.463480] Closing watchdogs Done.