[39.609579] Initializing watchdogs [39.609689] /dev/watchdog0 [39.625220] [001/133] (960s left) gem_eio (in-flight-external) [39.784483] Starting subtest: in-flight-external [41.517469] Subtest in-flight-external: SUCCESS (1.736s) [41.656271] [002/133] (958s left) api_intel_allocator (standalone) [41.724912] Starting subtest: standalone [41.758847] Subtest standalone: SUCCESS (0.035s) [41.872971] [003/133] (958s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs) [41.972766] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs [41.975282] Starting dynamic subtest: pipe-A-eDP-1 [43.854822] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.880s) [43.863367] Starting dynamic subtest: pipe-B-eDP-1 [46.891222] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.038s) [46.901452] Starting dynamic subtest: pipe-C-eDP-1 [49.708172] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.816s) [49.718640] Starting dynamic subtest: pipe-D-eDP-1 [52.545882] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.837s) [52.548213] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SUCCESS (10.573s) [53.802093] [004/133] (946s left) vc4/vc4_create_bo (create-bo-0) [53.886859] Subtest create-bo-0: SKIP (0.000s) [53.929151] [005/133] (946s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu) [54.049452] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu [56.624082] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (2.578s) [56.761468] [006/133] (943s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling) [56.889509] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling [56.891524] Starting dynamic subtest: pipe-A-default-mode [57.198222] Dynamic subtest pipe-A-default-mode: SKIP (0.305s) [57.203717] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.307s) [58.050425] [007/133] (942s left) gem_exec_reloc (basic-write-read-active) [58.119804] Subtest basic-write-read-active: SKIP (0.000s) [58.157857] [008/133] (942s left) syncobj_basic (bad-flags-handle-to-fd) [58.232307] Starting subtest: bad-flags-handle-to-fd [58.234768] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s) [58.313267] [009/133] (941s left) gem_mmap_gtt (medium-copy-xy) [58.393534] Subtest medium-copy-XY: SKIP (0.000s) [58.441285] [010/133] (941s left) i915_pipe_stress (stress-xrgb8888-untiled) [58.537153] Starting subtest: stress-xrgb8888-untiled [64.439598] Subtest stress-xrgb8888-untiled: SUCCESS (5.903s) [64.473446] [011/133] (935s left) kms_chamelium_hpd (vga-hpd-without-ddc) [64.899988] Subtest vga-hpd-without-ddc: SKIP (0.000s) [65.741042] [012/133] (934s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu) [65.878859] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu [65.883573] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [65.960104] [013/133] (934s left) perf_pmu (invalid-init) [66.011995] Starting subtest: invalid-init [66.014659] Subtest invalid-init: SUCCESS (0.000s) [66.126765] [014/133] (934s left) gem_flink_race (flink_close) [66.168890] Starting subtest: flink_close [71.281810] Subtest flink_close: SUCCESS (5.077s) [71.352365] [015/133] (929s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs) [71.476976] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs [71.479692] Starting dynamic subtest: pipe-A-eDP-1 [71.485929] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [71.495873] Starting dynamic subtest: pipe-B-eDP-1 [71.501429] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [71.515874] Starting dynamic subtest: pipe-C-eDP-1 [71.521088] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [71.534163] Starting dynamic subtest: pipe-D-eDP-1 [71.539460] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [71.544513] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.003s) [71.565393] [016/133] (928s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [71.693060] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [71.697826] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [71.792304] [017/133] (928s left) kms_big_fb (yf-tiled-8bpp-rotate-0) [71.907362] Starting subtest: yf-tiled-8bpp-rotate-0 [71.911698] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s) [72.011636] [018/133] (928s left) kms_psr (psr-cursor-mmap-gtt) [72.136072] Starting subtest: psr-cursor-mmap-gtt [72.138474] Starting dynamic subtest: eDP-1 [73.935364] Dynamic subtest eDP-1: SUCCESS (1.798s) [73.938411] Subtest psr-cursor-mmap-gtt: SUCCESS (1.799s) [74.810805] [019/133] (925s left) kms_flip (flip-vs-wf_vblank-interruptible) [74.936198] Starting subtest: flip-vs-wf_vblank-interruptible [74.938600] Starting dynamic subtest: A-eDP1 [76.929355] Dynamic subtest A-eDP1: SUCCESS (1.992s) [76.942920] Starting dynamic subtest: B-eDP1 [78.913222] Dynamic subtest B-eDP1: SUCCESS (1.983s) [78.927081] Starting dynamic subtest: C-eDP1 [80.884866] Dynamic subtest C-eDP1: SUCCESS (1.970s) [80.896212] Starting dynamic subtest: D-eDP1 [82.869279] Dynamic subtest D-eDP1: SUCCESS (1.983s) [82.877164] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.943s) [84.139250] [020/133] (916s left) kms_cursor_crc (cursor-size-change) [84.268062] Starting subtest: cursor-size-change [84.270555] Starting dynamic subtest: pipe-A-eDP-1 [85.088891] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.816s) [85.097652] Starting dynamic subtest: pipe-D-eDP-1 [86.655397] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.564s) [86.657641] Subtest cursor-size-change: SUCCESS (2.386s) [87.535447] [021/133] (913s left) kms_content_protection (lic-type-0) [87.700798] Starting subtest: lic-type-0 [91.208906] Subtest lic-type-0: SKIP (3.503s) [92.457764] [022/133] (908s left) kms_psr (fbc-psr-cursor-plane-onoff) [92.579102] Starting subtest: fbc-psr-cursor-plane-onoff [92.582498] Starting dynamic subtest: eDP-1 [92.589053] Dynamic subtest eDP-1: SKIP (0.000s) [92.594631] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.001s) [92.640550] [023/133] (908s left) gem_exec_schedule (promotion) [92.735786] Starting subtest: promotion [92.738166] Starting dynamic subtest: rcs0 [92.825143] Dynamic subtest rcs0: SUCCESS (0.094s) [92.839176] Starting dynamic subtest: vcs0 [92.905471] Dynamic subtest vcs0: SUCCESS (0.079s) [92.918782] Starting dynamic subtest: vcs1 [92.983782] Dynamic subtest vcs1: SUCCESS (0.077s) [92.997490] Starting dynamic subtest: vecs0 [93.060205] Dynamic subtest vecs0: SUCCESS (0.076s) [93.073665] Starting dynamic subtest: ccs0 [93.144845] Dynamic subtest ccs0: SUCCESS (0.084s) [93.148130] Subtest promotion: SUCCESS (0.414s) [94.549932] [024/133] (906s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy) [94.622959] Starting subtest: map-fixed-invalidate-overlap-busy [94.630664] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s) [94.751966] [025/133] (905s left) kms_addfb_basic (invalid-set-prop) [94.819341] Starting subtest: invalid-set-prop [94.821953] Subtest invalid-set-prop: SUCCESS (0.000s) [94.963052] [026/133] (905s left) kms_psr (fbc-pr-cursor-render) [95.071926] Starting subtest: fbc-pr-cursor-render [95.076420] Subtest fbc-pr-cursor-render: SKIP (0.000s) [95.133424] [027/133] (905s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu) [95.263600] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu [100.164946] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.907s) [100.255300] [028/133] (900s left) kms_rmfb (close-fd) [100.358970] Starting subtest: close-fd [100.361667] Starting dynamic subtest: pipe-A-eDP-1 [100.473981] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.111s) [100.487292] Starting dynamic subtest: pipe-B-eDP-1 [101.732825] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.258s) [101.741436] Starting dynamic subtest: pipe-C-eDP-1 [103.017755] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.283s) [103.032580] Starting dynamic subtest: pipe-D-eDP-1 [104.280164] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.260s) [104.283525] Subtest close-fd: SUCCESS (3.917s) [105.512809] [029/133] (895s left) gem_mmap (bad-size) [105.584429] Subtest bad-size: SKIP (0.000s) [105.638552] [030/133] (895s left) gem_ctx_shared (exec-single-timeline) [105.718945] Starting subtest: exec-single-timeline [105.722284] Starting dynamic subtest: rcs0 [106.768943] Dynamic subtest rcs0: SUCCESS (1.050s) [106.783496] Starting dynamic subtest: bcs0 [107.856192] Dynamic subtest bcs0: SUCCESS (1.086s) [107.870116] Starting dynamic subtest: vcs0 [108.948777] Dynamic subtest vcs0: SUCCESS (1.092s) [108.962497] Starting dynamic subtest: vcs1 [110.033313] Dynamic subtest vcs1: SUCCESS (1.083s) [110.047581] Starting dynamic subtest: vecs0 [111.122149] Dynamic subtest vecs0: SUCCESS (1.086s) [111.136494] Starting dynamic subtest: ccs0 [112.209810] Dynamic subtest ccs0: SUCCESS (1.086s) [112.212516] Subtest exec-single-timeline: SUCCESS (6.492s) [112.387815] [031/133] (888s left) kms_cursor_edge_walk (256x256-top-edge) [112.496811] Starting subtest: 256x256-top-edge [112.499348] Starting dynamic subtest: pipe-A-eDP-1 [116.059886] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.561s) [116.070255] Starting dynamic subtest: pipe-D-eDP-1 [119.274139] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.212s) [119.276630] Subtest 256x256-top-edge: SUCCESS (6.778s) [120.171894] [032/133] (880s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa [120.246963] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled [120.352038] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.104s) [120.414639] [033/133] (880s left) kms_cursor_crc (cursor-rapid-movement-32x32) [120.555871] Starting subtest: cursor-rapid-movement-32x32 [120.590892] Subtest cursor-rapid-movement-32x32: SKIP (0.028s) [120.846645] [034/133] (880s left) gem_userptr_blits (process-exit-busy) [120.903988] Starting subtest: process-exit-busy [120.912734] Subtest process-exit-busy: SUCCESS (0.011s) [121.026392] [035/133] (879s left) kms_psr (fbc-pr-sprite-mmap-gtt) [121.138347] Starting subtest: fbc-pr-sprite-mmap-gtt [121.143628] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s) [121.200391] [036/133] (879s left) gem_exec_fence (syncobj-wait) [121.677907] Starting subtest: syncobj-wait [123.468234] Subtest syncobj-wait: SUCCESS (1.789s) [123.823948] [037/133] (877s left) kms_prop_blob (invalid-get-prop-any) [123.895026] Starting subtest: invalid-get-prop-any [123.897430] Subtest invalid-get-prop-any: SUCCESS (0.000s) [123.976953] [038/133] (877s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180) [124.109375] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180 [125.138349] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.027s) [125.248579] [039/133] (875s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-pwrite) [125.366635] Starting subtest: psr-1p-offscren-pri-shrfb-draw-pwrite [131.783338] Subtest psr-1p-offscren-pri-shrfb-draw-pwrite: SUCCESS (6.419s) [131.890636] [040/133] (869s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite) [132.025237] Starting subtest: psr-rgb101010-draw-pwrite [137.297676] Subtest psr-rgb101010-draw-pwrite: SUCCESS (5.275s) [137.411519] [041/133] (863s left) kms_cursor_legacy (cursorb-vs-flipb-atomic) [137.550696] Starting subtest: cursorB-vs-flipB-atomic [137.555928] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s) [137.686788] [042/133] (863s left) gem_lmem_evict (dontneed-evict-race) [137.750762] Subtest dontneed-evict-race: SKIP (0.000s) [137.779272] [043/133] (863s left) drm_fdinfo (busy-hang) [137.840530] Starting subtest: busy-hang [137.843737] Starting dynamic subtest: rcs0 [137.849511] Dynamic subtest rcs0: SKIP (0.002s) [137.863238] Starting dynamic subtest: bcs0 [137.868335] Dynamic subtest bcs0: SKIP (0.000s) [137.880106] Starting dynamic subtest: vcs0 [137.884963] Dynamic subtest vcs0: SKIP (0.000s) [137.893859] Starting dynamic subtest: vcs1 [137.898785] Dynamic subtest vcs1: SKIP (0.000s) [137.906519] Starting dynamic subtest: vecs0 [137.911495] Dynamic subtest vecs0: SKIP (0.000s) [137.918756] Starting dynamic subtest: ccs0 [137.923706] Dynamic subtest ccs0: SKIP (0.000s) [137.928778] Subtest busy-hang: SKIP (0.007s) [137.946616] [044/133] (863s left) kms_cursor_legacy (short-flip-after-cursor-toggle) [138.069608] Starting subtest: short-flip-after-cursor-toggle [139.020800] Subtest short-flip-after-cursor-toggle: SUCCESS (0.951s) [139.946422] [045/133] (861s left) kms_vblank (accuracy-idle) [140.074036] Starting subtest: accuracy-idle [140.076656] Starting dynamic subtest: pipe-A-eDP-1 [141.833660] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.757s) [141.851861] Starting dynamic subtest: pipe-D-eDP-1 [144.390725] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.550s) [144.393337] Subtest accuracy-idle: SUCCESS (4.314s) [145.325975] [046/133] (855s left) syncobj_timeline (signal-point-0) [145.394414] Starting subtest: signal-point-0 [145.397064] Subtest signal-point-0: SUCCESS (0.000s) [145.480532] [047/133] (855s left) kms_prime (basic-crc-vgem) [146.097821] Starting subtest: basic-crc-vgem [146.100231] Starting dynamic subtest: second-to-first [147.156219] Dynamic subtest second-to-first: SUCCESS (1.062s) [147.158639] Subtest basic-crc-vgem: SUCCESS (1.063s) [147.229703] [048/133] (854s left) kms_plane (plane-position-covered) [147.376125] Starting subtest: plane-position-covered [147.378311] Starting dynamic subtest: pipe-A [153.573116] Dynamic subtest pipe-A: SUCCESS (6.196s) [153.580107] Starting dynamic subtest: pipe-B [160.475974] Dynamic subtest pipe-B: SUCCESS (6.902s) [160.478797] Subtest plane-position-covered: SUCCESS (13.100s) [161.331919] [049/133] (839s left) kms_vblank (wait-idle-hang) [161.459672] Starting subtest: wait-idle-hang [161.462321] Starting dynamic subtest: pipe-A-eDP-1 [188.211821] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.749s) [188.226875] Starting dynamic subtest: pipe-D-eDP-1 [213.260068] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.047s) [213.263184] Subtest wait-idle-hang: SUCCESS (51.804s) [214.186374] [050/133] (787s left) i915_suspend (basic-s2idle-without-i915) [214.228300] Starting subtest: basic-s2idle-without-i915 [233.075954] Subtest basic-s2idle-without-i915: SUCCESS (3.730s) [233.187120] [051/133] (783s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt) [233.302299] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt [233.306909] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [233.381785] [052/133] (783s left) i915_pm_rc6_residency (rc6-idle) [233.440570] Starting subtest: rc6-idle [233.473311] Starting dynamic subtest: gt0-rcs0 [245.753941] Dynamic subtest gt0-rcs0: SUCCESS (12.238s) [245.769537] Starting dynamic subtest: gt0-bcs0 [258.030215] Dynamic subtest gt0-bcs0: SUCCESS (12.275s) [258.045556] Starting dynamic subtest: gt0-ccs0 [270.262940] Dynamic subtest gt0-ccs0: SUCCESS (12.274s) [270.279872] Starting dynamic subtest: gt1-vcs0 [282.550317] Dynamic subtest gt1-vcs0: SUCCESS (12.242s) [282.565150] Starting dynamic subtest: gt1-vecs0 [295.750169] Dynamic subtest gt1-vecs0: SUCCESS (13.241s) [295.753387] Subtest rc6-idle: SUCCESS (62.311s) [296.610053] [053/133] (719s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite) [296.747944] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite [296.752153] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [296.831004] [054/133] (719s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt) [296.969771] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt [296.974327] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [297.053079] [055/133] (719s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu) [297.193012] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu [301.755177] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (4.566s) [301.871541] [056/133] (714s left) gen3_render_tiledx_blits [302.005939] [057/133] (714s left) gem_softpin (overlap) [302.072062] Starting subtest: overlap [302.857871] Subtest overlap: SUCCESS (0.784s) [302.979801] [058/133] (713s left) gem_exec_params (rel-constants-invalid) [303.050587] Starting subtest: rel-constants-invalid [303.053071] Subtest rel-constants-invalid: SUCCESS (0.000s) [303.155380] [059/133] (713s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs) [303.263798] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs [303.266229] Starting dynamic subtest: pipe-A-eDP-1 [303.271023] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [303.285195] Starting dynamic subtest: pipe-B-eDP-1 [303.289861] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [303.303498] Starting dynamic subtest: pipe-C-eDP-1 [303.308942] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [303.322018] Starting dynamic subtest: pipe-D-eDP-1 [303.327229] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [303.331848] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.004s) [303.353945] [060/133] (713s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled) [303.438536] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled [303.443199] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s) [303.617773] [061/133] (713s left) gem_exec_reloc (basic-cpu-gtt) [303.700408] Subtest basic-cpu-gtt: SKIP (0.000s) [303.747698] [062/133] (712s left) v3d/v3d_mmap (mmap-bad-handle) [303.830380] Subtest mmap-bad-handle: SKIP (0.000s) [303.876227] [063/133] (712s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move) [303.991595] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move [303.995888] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [304.067793] [064/133] (712s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move) [304.193164] Starting subtest: fbc-1p-primscrn-cur-indfb-move [307.234816] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (3.042s) [307.376464] [065/133] (709s left) gen9_exec_parse (basic-rejected-ctx-param) [307.459625] Subtest basic-rejected-ctx-param: SKIP (0.000s) [307.499058] [066/133] (709s left) gem_pxp (display-protected-crc) [310.144351] Subtest display-protected-crc: SKIP (0.000s) [310.168670] [067/133] (706s left) perf (polling-parameterized) [310.312852] Starting subtest: polling-parameterized [330.337959] Subtest polling-parameterized: SUCCESS (20.025s) [330.372604] [068/133] (686s left) kms_addfb_basic (invalid-smem-bo-on-discrete) [330.428405] Starting subtest: invalid-smem-bo-on-discrete [330.433866] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s) [330.576540] [069/133] (686s left) gem_spin_batch (resubmit-all) [330.665637] Starting subtest: resubmit-all [330.668679] Starting dynamic subtest: rcs0 [330.677727] Dynamic subtest rcs0: SUCCESS (0.011s) [330.692727] Starting dynamic subtest: bcs0 [330.695596] Dynamic subtest bcs0: SUCCESS (0.004s) [330.704655] Starting dynamic subtest: vcs0 [330.707484] Dynamic subtest vcs0: SUCCESS (0.003s) [330.719684] Starting dynamic subtest: vcs1 [330.722532] Dynamic subtest vcs1: SUCCESS (0.003s) [330.732071] Starting dynamic subtest: vecs0 [330.734649] Dynamic subtest vecs0: SUCCESS (0.003s) [330.742306] Starting dynamic subtest: ccs0 [330.745133] Dynamic subtest ccs0: SUCCESS (0.002s) [330.747950] Subtest resubmit-all: SUCCESS (0.031s) [332.574444] [070/133] (684s left) kms_plane_alpha_blend (constant-alpha-min) [332.695592] Starting subtest: constant-alpha-min [332.945806] Starting dynamic subtest: pipe-A-eDP-1 [333.761314] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.813s) [333.777106] Starting dynamic subtest: pipe-D-eDP-1 [335.363071] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.599s) [335.366056] Subtest constant-alpha-min: SUCCESS (2.664s) [336.248759] [071/133] (680s left) gem_pxp (reject-modify-context-protection-off-1) [338.907567] Subtest reject-modify-context-protection-off-1: SKIP (0.000s) [338.946451] [072/133] (678s left) kms_atomic (plane-cursor-legacy) [339.094133] Starting subtest: plane-cursor-legacy [339.096631] Starting dynamic subtest: pipe-A-eDP-1 [339.489048] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.391s) [339.491625] Subtest plane-cursor-legacy: SUCCESS (0.394s) [340.399497] [073/133] (676s left) kms_psr (psr-sprite-plane-onoff) [340.508305] Starting subtest: psr-sprite-plane-onoff [340.510737] Starting dynamic subtest: eDP-1 [342.350187] Dynamic subtest eDP-1: SUCCESS (1.843s) [342.352762] Subtest psr-sprite-plane-onoff: SUCCESS (1.845s) [343.287548] [074/133] (673s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions) [343.424939] Starting subtest: cursor-vs-flip-atomic-transitions [373.312227] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (29.885s) [374.204160] [075/133] (642s left) gem_close_race (basic-threads) [374.288390] Starting subtest: basic-threads [375.524012] Subtest basic-threads: SUCCESS (1.236s) [375.705177] [076/133] (641s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [375.852133] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [376.464442] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.615s) [376.627767] [077/133] (640s left) syncobj_basic (bad-pad-fd-to-handle) [376.714087] Starting subtest: bad-pad-fd-to-handle [376.716816] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s) [376.790045] [078/133] (640s left) kms_writeback (writeback-pixel-formats) [376.921893] Subtest writeback-pixel-formats: SKIP (0.000s) [376.944272] [079/133] (640s left) gem_exec_fence (syncobj-backward-timeline-chain-engines) [377.512774] Starting subtest: syncobj-backward-timeline-chain-engines [377.592319] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.081s) [378.662278] [080/133] (638s left) syncobj_wait (multi-wait-for-submit-submitted-signaled) [378.731745] Starting subtest: multi-wait-for-submit-submitted-signaled [378.734279] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s) [378.804154] [081/133] (638s left) gem_ctx_param (basic) [378.879139] Starting subtest: basic [378.882095] Subtest basic: SUCCESS (0.001s) [378.967880] [082/133] (638s left) gem_ctx_sseu (invalid-args) [379.039646] Subtest invalid-args: SKIP (0.000s) [379.087609] [083/133] (638s left) fbdev (eof) [379.149091] Starting subtest: eof [379.152156] Subtest eof: SUCCESS (0.000s) [379.210838] [084/133] (638s left) syncobj_timeline (invalid-query-one-illegal-handle) [379.288793] Starting subtest: invalid-query-one-illegal-handle [379.291677] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s) [379.370141] [085/133] (637s left) syncobj_wait (invalid-reset-illegal-handle) [379.424454] Starting subtest: invalid-reset-illegal-handle [379.426723] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s) [379.503590] [086/133] (637s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt) [379.652590] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt [379.656424] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [379.735523] [087/133] (637s left) gem_compute (compute-square) [379.800424] Starting subtest: compute-square [379.805525] Subtest compute-square: SKIP (0.000s) [379.878327] [088/133] (637s left) vc4/vc4_wait_bo (bad-pad) [379.967990] Subtest bad-pad: SKIP (0.000s) [380.014945] [089/133] (637s left) perf_pmu (most-busy-check-all) [380.065974] Starting subtest: most-busy-check-all [380.068351] Starting dynamic subtest: rcs0 [381.567564] Dynamic subtest rcs0: SUCCESS (1.499s) [381.583491] Starting dynamic subtest: bcs0 [383.551611] Dynamic subtest bcs0: SUCCESS (1.982s) [383.567954] Starting dynamic subtest: vcs0 [385.599790] Dynamic subtest vcs0: SUCCESS (2.046s) [385.617623] Starting dynamic subtest: vcs1 [387.583611] Dynamic subtest vcs1: SUCCESS (1.982s) [387.600652] Starting dynamic subtest: vecs0 [389.568761] Dynamic subtest vecs0: SUCCESS (1.983s) [389.585675] Starting dynamic subtest: ccs0 [391.552006] Dynamic subtest ccs0: SUCCESS (1.981s) [391.555025] Subtest most-busy-check-all: SUCCESS (11.485s) [391.637801] [090/133] (625s left) kms_psr (pr-sprite-mmap-gtt) [391.763736] Starting subtest: pr-sprite-mmap-gtt [391.767936] Subtest pr-sprite-mmap-gtt: SKIP (0.000s) [391.824580] [091/133] (625s left) syncobj_eventfd (timeline-wait) [391.884212] Starting subtest: timeline-wait [391.894020] Subtest timeline-wait: SUCCESS (0.011s) [391.964491] [092/133] (625s left) api_intel_bb (offset-control) [392.038100] Starting subtest: offset-control [392.044739] Subtest offset-control: SUCCESS (0.009s) [392.159890] [093/133] (625s left) kms_rotation_crc (primary-rotation-270) [392.259073] Starting subtest: primary-rotation-270 [392.264015] Subtest primary-rotation-270: SKIP (0.001s) [392.319895] [094/133] (625s left) kms_cursor_crc (cursor-offscreen-32x10) [392.465016] Starting subtest: cursor-offscreen-32x10 [392.503101] Subtest cursor-offscreen-32x10: SKIP (0.031s) [392.733172] [095/133] (624s left) gem_mmap_gtt (basic-write-read-distinct) [392.786670] Subtest basic-write-read-distinct: SKIP (0.000s) [392.837887] [096/133] (624s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite) [392.953165] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite [392.956846] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [393.035823] [097/133] (624s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt) [393.169633] Starting subtest: fbc-farfromfence-mmap-gtt [393.173540] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s) [393.246228] [098/133] (624s left) v3d/v3d_submit_cl (bad-multisync-extension) [393.328282] Subtest bad-multisync-extension: SKIP (0.000s) [393.376572] [099/133] (624s left) gem_exec_fair (basic-none-vip) [393.460947] Subtest basic-none-vip: SKIP (0.000s) [393.490459] [100/133] (624s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75) [393.584386] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75 [393.586912] Starting dynamic subtest: pipe-A-eDP-1 [393.599061] Dynamic subtest pipe-A-eDP-1: SKIP (0.010s) [393.612047] Starting dynamic subtest: pipe-B-eDP-1 [393.619648] Dynamic subtest pipe-B-eDP-1: SKIP (0.019s) [393.631448] Starting dynamic subtest: pipe-C-eDP-1 [393.640682] Dynamic subtest pipe-C-eDP-1: SKIP (0.020s) [393.648289] Starting dynamic subtest: pipe-D-eDP-1 [393.662691] Dynamic subtest pipe-D-eDP-1: SKIP (0.020s) [393.665909] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SKIP (0.075s) [393.733577] [101/133] (623s left) kms_chamelium_audio (dp-audio-edid) [394.109374] Subtest dp-audio-edid: SKIP (0.000s) [394.974962] [102/133] (622s left) gem_mmap_gtt (cpuset-medium-copy) [395.034645] Subtest cpuset-medium-copy: SKIP (0.000s) [395.077963] [103/133] (622s left) vc4/vc4_perfmon (destroy-invalid-perfmon) [395.140818] Subtest destroy-invalid-perfmon: SKIP (0.000s) [395.187157] [104/133] (622s left) kms_dp_aux_dev [395.566692] [105/133] (622s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format) [395.690558] Starting subtest: plane-upscale-factor-0-25-with-pixel-format [395.693437] Starting dynamic subtest: pipe-A-eDP-1 [397.517211] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.827s) [397.527603] Starting dynamic subtest: pipe-B-eDP-1 [400.325402] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.806s) [400.334194] Starting dynamic subtest: pipe-C-eDP-1 [401.595424] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.268s) [401.610518] Starting dynamic subtest: pipe-D-eDP-1 [402.935237] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.338s) [402.938025] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (7.247s) [404.216093] [106/133] (613s left) gem_create (create-ext-cpu-access-big) [404.401637] Starting subtest: create-ext-cpu-access-big [404.407666] Subtest create-ext-cpu-access-big: SKIP (0.001s) [404.455998] [107/133] (613s left) kms_flip (2x-flip-vs-fences) [404.572980] Starting subtest: 2x-flip-vs-fences [404.579350] Subtest 2x-flip-vs-fences: SKIP (0.000s) [404.668158] [108/133] (613s left) gem_ctx_persistence (engines-hostile) [404.747683] Starting subtest: engines-hostile [404.750496] Starting dynamic subtest: rcs0 [404.843727] Dynamic subtest rcs0: SUCCESS (0.096s) [404.861229] Starting dynamic subtest: bcs0 [404.872443] Dynamic subtest bcs0: SUCCESS (0.028s) [404.885736] Starting dynamic subtest: vcs0 [404.999748] Dynamic subtest vcs0: SUCCESS (0.126s) [405.016369] Starting dynamic subtest: vcs1 [405.106917] Dynamic subtest vcs1: SUCCESS (0.106s) [405.123279] Starting dynamic subtest: vecs0 [405.129627] Dynamic subtest vecs0: SUCCESS (0.021s) [405.140274] Starting dynamic subtest: ccs0 [405.218812] Dynamic subtest ccs0: SUCCESS (0.089s) [405.221526] Subtest engines-hostile: SUCCESS (0.471s) [405.290302] [109/133] (612s left) gem_vm_create (execbuf) [405.342664] Starting subtest: execbuf [405.350379] Subtest execbuf: SUCCESS (0.008s) [405.462358] [110/133] (612s left) kms_chamelium_frames (hdmi-cmp-planar-formats) [405.860372] Subtest hdmi-cmp-planar-formats: SKIP (0.000s) [406.745880] [111/133] (611s left) kms_big_fb (linear-addfb) [406.869825] Starting subtest: linear-addfb [406.872082] Subtest linear-addfb: SUCCESS (0.000s) [406.965644] [112/133] (611s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt) [407.081206] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt [410.433903] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (3.356s) [410.574026] [113/133] (607s left) gem_exec_schedule (u-semaphore-codependency) [410.662106] Starting subtest: u-semaphore-codependency [410.672243] Subtest u-semaphore-codependency: SUCCESS (0.011s) [411.022637] [114/133] (607s left) kms_lease (lease-uevent) [411.139527] Starting subtest: lease-uevent [412.158397] Subtest lease-uevent: SUCCESS (1.017s) [412.225158] [115/133] (605s left) sysfs_timeslice_duration (invalid) [412.289255] Starting subtest: invalid [412.291902] Starting dynamic subtest: vecs0 [412.294602] Dynamic subtest vecs0: SUCCESS (0.000s) [412.310580] Starting dynamic subtest: ccs0 [412.312800] Dynamic subtest ccs0: SUCCESS (0.000s) [412.322209] Starting dynamic subtest: vcs0 [412.324405] Dynamic subtest vcs0: SUCCESS (0.000s) [412.331438] Starting dynamic subtest: bcs0 [412.333654] Dynamic subtest bcs0: SUCCESS (0.000s) [412.339991] Starting dynamic subtest: rcs0 [412.342584] Dynamic subtest rcs0: SUCCESS (0.000s) [412.354283] Starting dynamic subtest: vcs1 [412.356792] Dynamic subtest vcs1: SUCCESS (0.000s) [412.359212] Subtest invalid: SUCCESS (0.005s) [412.376035] [116/133] (605s left) kms_flip (2x-flip-vs-modeset-vs-hang) [412.482599] Starting subtest: 2x-flip-vs-modeset-vs-hang [412.498136] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.015s) [412.565775] [117/133] (605s left) kms_feature_discovery (display-4x) [412.688677] Starting subtest: display-4x [412.693363] Subtest display-4x: SKIP (0.000s) [412.749879] [118/133] (605s left) gem_exec_flush (basic-wb-set-default) [412.831132] Starting subtest: basic-wb-set-default [418.305552] Subtest basic-wb-set-default: SUCCESS (5.444s) [418.461548] [119/133] (599s left) syncobj_timeline (multi-wait-all-available-submitted) [418.535268] Starting subtest: multi-wait-all-available-submitted [418.538195] Subtest multi-wait-all-available-submitted: SUCCESS (0.001s) [418.618322] [120/133] (599s left) kms_big_fb (y-tiled-8bpp-rotate-90) [418.732259] Starting subtest: y-tiled-8bpp-rotate-90 [418.736848] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s) [418.813533] [121/133] (599s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs) [418.942537] Starting subtest: missing-ccs-buffer-yf-tiled-ccs [418.945626] Starting dynamic subtest: pipe-A-eDP-1 [418.950978] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [418.961395] Starting dynamic subtest: pipe-B-eDP-1 [418.965844] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [418.972714] Starting dynamic subtest: pipe-C-eDP-1 [418.976879] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [418.983225] Starting dynamic subtest: pipe-D-eDP-1 [418.987509] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [418.991721] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.003s) [419.017404] [122/133] (599s left) perf (oa-exponents) [419.125095] Starting subtest: oa-exponents [419.127572] Starting dynamic subtest: 0-rcs0 [420.875511] Dynamic subtest 0-rcs0: SUCCESS (1.749s) [420.883512] Starting dynamic subtest: 1-vcs0 [422.707697] Dynamic subtest 1-vcs0: SUCCESS (1.831s) [422.710191] Subtest oa-exponents: SUCCESS (3.582s) [422.755017] [123/133] (595s left) gem_partial_pwrite_pread (write-snoop) [422.826388] Subtest write-snoop: SKIP (0.000s) [422.886790] [124/133] (595s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size) [423.034555] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size [453.519747] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (30.486s) [454.462971] [125/133] (563s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling) [454.572513] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling [454.574949] Starting dynamic subtest: pipe-A-default-mode [454.864763] Dynamic subtest pipe-A-default-mode: SKIP (0.287s) [454.869574] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.288s) [455.744216] [126/133] (562s left) prime_vgem (fence-flip-hang) [455.845835] Subtest fence-flip-hang: SKIP (0.000s) [455.926094] [127/133] (562s left) kms_lease (atomic-implicit-crtc) [456.051149] Starting subtest: atomic-implicit-crtc [456.054088] Starting dynamic subtest: pipe-A-eDP-1 [456.056508] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [456.071165] Starting dynamic subtest: pipe-B-eDP-1 [456.073745] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.005s) [456.082024] Starting dynamic subtest: pipe-C-eDP-1 [456.084174] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.005s) [456.090824] Starting dynamic subtest: pipe-D-eDP-1 [456.092897] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.005s) [456.094837] Subtest atomic-implicit-crtc: SUCCESS (0.020s) [456.158178] [128/133] (562s left) gem_exec_schedule (noreorder-priority) [456.364419] Starting subtest: noreorder-priority [456.367641] Starting dynamic subtest: rcs0 [457.522026] Dynamic subtest rcs0: SUCCESS (1.157s) [457.539212] Starting dynamic subtest: vcs0 [459.599098] Dynamic subtest vcs0: SUCCESS (2.074s) [459.617068] Starting dynamic subtest: vcs1 [461.539527] Dynamic subtest vcs1: SUCCESS (1.939s) [461.557310] Starting dynamic subtest: vecs0 [463.561828] Dynamic subtest vecs0: SUCCESS (2.021s) [463.577531] Starting dynamic subtest: ccs0 [464.726148] Dynamic subtest ccs0: SUCCESS (1.163s) [464.729438] Subtest noreorder-priority: SUCCESS (8.362s) [464.912512] [129/133] (553s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt) [465.031599] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt [470.197858] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (5.171s) [470.315678] [130/133] (548s left) kms_big_fb (y-tiled-16bpp-rotate-270) [470.423108] Starting subtest: y-tiled-16bpp-rotate-270 [470.427388] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s) [470.500779] [131/133] (547s left) kms_properties (invalid-properties-legacy) [470.611455] Starting subtest: invalid-properties-legacy [470.768052] Subtest invalid-properties-legacy: SUCCESS (0.153s) [470.826808] [132/133] (547s left) gem_flink_basic (double-flink) [470.912789] Starting subtest: double-flink [470.915820] Subtest double-flink: SUCCESS (0.000s) [471.008001] [133/133] (547s left) gem_exec_balancer (hang) [471.296084] Starting subtest: hang [472.637442] Subtest hang: SUCCESS (1.346s) [472.742269] Closing watchdogs Done.