[42.269411] Initializing watchdogs [42.269470] /dev/watchdog0 [42.276076] [001/133] (960s left) gem_eio (in-flight-external) [42.566704] Starting subtest: in-flight-external [44.413215] Subtest in-flight-external: SUCCESS (1.849s) [44.613847] [002/133] (958s left) api_intel_allocator (standalone) [44.678211] Starting subtest: standalone [44.715117] Subtest standalone: SUCCESS (0.038s) [44.857630] [003/133] (957s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs) [45.047741] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs [45.048673] Starting dynamic subtest: pipe-A-DP-4 [45.050413] Dynamic subtest pipe-A-DP-4: SKIP (0.000s) [45.055761] Starting dynamic subtest: pipe-B-DP-4 [45.057531] Dynamic subtest pipe-B-DP-4: SKIP (0.000s) [45.062657] Starting dynamic subtest: pipe-C-DP-4 [45.064647] Dynamic subtest pipe-C-DP-4: SKIP (0.000s) [45.070093] Starting dynamic subtest: pipe-D-DP-4 [45.072237] Dynamic subtest pipe-D-DP-4: SKIP (0.000s) [45.074400] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SKIP (0.004s) [45.118735] [004/133] (957s left) vc4/vc4_create_bo (create-bo-0) [45.188572] Subtest create-bo-0: SKIP (0.000s) [45.265101] [005/133] (957s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu) [45.503360] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu [51.235954] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: FAIL (5.664s) [51.309471] [006/133] (951s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling) [51.522098] Starting subtest: flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling [51.523102] Starting dynamic subtest: pipe-A-valid-mode [53.221858] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.699s) [53.223372] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SUCCESS (1.700s) [53.445174] [007/133] (949s left) gem_exec_reloc (basic-write-read-active) [53.554891] Subtest basic-write-read-active: SKIP (0.000s) [53.589349] [008/133] (949s left) syncobj_basic (bad-flags-handle-to-fd) [53.666993] Starting subtest: bad-flags-handle-to-fd [53.668230] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s) [53.734444] [009/133] (949s left) gem_mmap_gtt (medium-copy-xy) [53.823218] Subtest medium-copy-XY: SKIP (0.000s) [53.853739] [010/133] (949s left) i915_pipe_stress (stress-xrgb8888-untiled) [54.046842] Starting subtest: stress-xrgb8888-untiled [62.059892] Subtest stress-xrgb8888-untiled: SUCCESS (8.013s) [62.305155] [011/133] (940s left) kms_chamelium_hpd (vga-hpd-without-ddc) [62.618319] Subtest vga-hpd-without-ddc: SKIP (0.000s) [62.733660] [012/133] (940s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-cpu) [62.947536] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-cpu [62.949195] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [63.025293] [013/133] (940s left) perf_pmu (invalid-init) [63.103109] Starting subtest: invalid-init [63.104169] Subtest invalid-init: SUCCESS (0.000s) [63.202268] [014/133] (939s left) gem_flink_race (flink_close) [63.274199] Starting subtest: flink_close [68.318134] Subtest flink_close: SUCCESS (5.044s) [68.373072] [015/133] (934s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs) [68.621142] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs [68.621989] Starting dynamic subtest: pipe-A-DP-4 [70.239681] Dynamic subtest pipe-A-DP-4: SUCCESS (1.617s) [70.245670] Starting dynamic subtest: pipe-B-DP-4 [71.852549] Dynamic subtest pipe-B-DP-4: SUCCESS (1.612s) [71.858516] Starting dynamic subtest: pipe-C-DP-4 [73.630252] Dynamic subtest pipe-C-DP-4: SUCCESS (1.777s) [73.636085] Starting dynamic subtest: pipe-D-DP-4 [75.437763] Dynamic subtest pipe-D-DP-4: SUCCESS (1.807s) [75.438605] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SUCCESS (6.816s) [75.682619] [016/133] (927s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [75.881312] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [75.883071] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [75.946794] [017/133] (927s left) kms_big_fb (yf-tiled-8bpp-rotate-0) [76.153803] Starting subtest: yf-tiled-8bpp-rotate-0 [76.155623] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s) [76.234554] [018/133] (926s left) kms_psr (psr-cursor-mmap-gtt) [76.442102] Subtest psr-cursor-mmap-gtt: SKIP (0.000s) [76.470247] [019/133] (926s left) kms_flip (flip-vs-wf_vblank-interruptible) [76.657678] Starting subtest: flip-vs-wf_vblank-interruptible [76.664445] Starting dynamic subtest: A-DP4 [77.782170] Dynamic subtest A-DP4: SUCCESS (1.117s) [77.789631] Starting dynamic subtest: B-DP4 [78.832315] Dynamic subtest B-DP4: SUCCESS (1.050s) [78.839113] Starting dynamic subtest: C-DP4 [79.851277] Dynamic subtest C-DP4: SUCCESS (1.019s) [79.858016] Starting dynamic subtest: D-DP4 [80.872230] Dynamic subtest D-DP4: SUCCESS (1.021s) [80.873173] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (4.215s) [81.184314] [020/133] (922s left) kms_cursor_crc (cursor-size-change) [81.405396] Starting subtest: cursor-size-change [81.406354] Starting dynamic subtest: pipe-A-DP-4 [82.264068] Dynamic subtest pipe-A-DP-4: SUCCESS (0.856s) [82.275041] Starting dynamic subtest: pipe-D-DP-4 [83.032100] Dynamic subtest pipe-D-DP-4: SUCCESS (0.766s) [83.033044] Subtest cursor-size-change: SUCCESS (1.627s) [83.559149] [021/133] (919s left) kms_content_protection (lic-type-0) [83.841724] Starting subtest: lic-type-0 [83.867810] Starting dynamic subtest: pipe-A-DP-4 [204.082390] Per-test timeout exceeded. Killing the current test with SIGQUIT. [204.351367] Closing watchdogs [204.353165] Initializing watchdogs [204.353204] /dev/watchdog0 [204.361103] [022/133] (798s left) kms_psr (fbc-psr-cursor-plane-onoff) [204.549827] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.000s) [204.578573] [023/133] (798s left) gem_exec_schedule (promotion) [204.640196] Starting subtest: promotion [204.641040] Starting dynamic subtest: rcs0 [204.910427] Dynamic subtest rcs0: SUCCESS (0.270s) [204.916486] Starting dynamic subtest: bcs0 [205.104214] Dynamic subtest bcs0: SUCCESS (0.194s) [205.110174] Starting dynamic subtest: vcs0 [205.304904] Dynamic subtest vcs0: SUCCESS (0.200s) [205.310936] Starting dynamic subtest: vcs1 [205.506652] Dynamic subtest vcs1: SUCCESS (0.202s) [205.512733] Starting dynamic subtest: vecs0 [205.709658] Dynamic subtest vecs0: SUCCESS (0.203s) [205.715815] Starting dynamic subtest: vecs1 [205.910963] Dynamic subtest vecs1: SUCCESS (0.201s) [205.917147] Starting dynamic subtest: ccs0 [206.119571] Dynamic subtest ccs0: SUCCESS (0.208s) [206.120530] Subtest promotion: SUCCESS (1.479s) [206.558341] [024/133] (796s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy) [206.630123] Starting subtest: map-fixed-invalidate-overlap-busy [206.631692] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s) [206.736912] [025/133] (796s left) kms_addfb_basic (invalid-set-prop) [206.798849] Starting subtest: invalid-set-prop [206.799623] Subtest invalid-set-prop: SUCCESS (0.000s) [207.007240] [026/133] (796s left) kms_psr (fbc-pr-cursor-render) [207.210758] Subtest fbc-pr-cursor-render: SKIP (0.000s) [207.228246] [027/133] (796s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu) [207.415686] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu [207.417353] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [207.488867] [028/133] (795s left) kms_rmfb (close-fd) [207.700033] Starting subtest: close-fd [207.700901] Starting dynamic subtest: pipe-A-DP-4 [207.856777] Dynamic subtest pipe-A-DP-4: SUCCESS (0.157s) [207.867845] Starting dynamic subtest: pipe-B-DP-4 [208.132013] Dynamic subtest pipe-B-DP-4: SUCCESS (0.274s) [208.140243] Starting dynamic subtest: pipe-C-DP-4 [208.430097] Dynamic subtest pipe-C-DP-4: SUCCESS (0.297s) [208.438057] Starting dynamic subtest: pipe-D-DP-4 [208.708054] Dynamic subtest pipe-D-DP-4: SUCCESS (0.277s) [208.709175] Subtest close-fd: SUCCESS (1.009s) [208.954821] [029/133] (794s left) gem_mmap (bad-size) [209.026219] Subtest bad-size: SKIP (0.000s) [209.058880] [030/133] (794s left) gem_ctx_shared (exec-single-timeline) [209.133423] Starting subtest: exec-single-timeline [209.134280] Starting dynamic subtest: rcs0 [210.192970] Dynamic subtest rcs0: SUCCESS (1.058s) [210.200694] Starting dynamic subtest: bcs0 [211.216087] Dynamic subtest bcs0: SUCCESS (1.022s) [211.224512] Starting dynamic subtest: vcs0 [212.240209] Dynamic subtest vcs0: SUCCESS (1.022s) [212.248318] Starting dynamic subtest: vcs1 [213.263953] Dynamic subtest vcs1: SUCCESS (1.022s) [213.272799] Starting dynamic subtest: vecs0 [214.288283] Dynamic subtest vecs0: SUCCESS (1.023s) [214.296341] Starting dynamic subtest: vecs1 [215.312399] Dynamic subtest vecs1: SUCCESS (1.022s) [215.320843] Starting dynamic subtest: ccs0 [216.336500] Dynamic subtest ccs0: SUCCESS (1.023s) [216.338480] Subtest exec-single-timeline: SUCCESS (7.202s) [216.571812] [031/133] (786s left) kms_cursor_edge_walk (256x256-top-edge) [216.765818] Starting subtest: 256x256-top-edge [216.767991] Starting dynamic subtest: pipe-A-DP-4 [220.204500] Dynamic subtest pipe-A-DP-4: SUCCESS (3.437s) [220.213536] Starting dynamic subtest: pipe-D-DP-4 [223.535839] Dynamic subtest pipe-D-DP-4: SUCCESS (3.329s) [223.537021] Subtest 256x256-top-edge: SUCCESS (6.769s) [223.737782] [032/133] (779s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa [223.804414] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled [223.911467] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.106s) [224.010130] [033/133] (779s left) kms_cursor_crc (cursor-rapid-movement-32x32) [224.262671] Starting subtest: cursor-rapid-movement-32x32 [224.308528] Subtest cursor-rapid-movement-32x32: SKIP (0.043s) [224.591540] [034/133] (778s left) gem_userptr_blits (process-exit-busy) [224.659535] Starting subtest: process-exit-busy [224.674504] Subtest process-exit-busy: SUCCESS (0.015s) [224.798758] [035/133] (778s left) kms_psr (fbc-pr-sprite-mmap-gtt) [225.026577] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s) [225.051375] [036/133] (778s left) gem_exec_fence (syncobj-wait) [225.592124] Starting subtest: syncobj-wait [225.701762] Subtest syncobj-wait: SUCCESS (0.110s) [226.087661] [037/133] (777s left) kms_prop_blob (invalid-get-prop-any) [226.165233] Starting subtest: invalid-get-prop-any [226.166202] Subtest invalid-get-prop-any: SUCCESS (0.000s) [226.258443] [038/133] (777s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180) [226.490831] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180 [227.727967] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.237s) [227.891223] [039/133] (775s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-pwrite) [228.086441] Starting subtest: psr-1p-offscren-pri-shrfb-draw-pwrite [228.088078] Subtest psr-1p-offscren-pri-shrfb-draw-pwrite: SKIP (0.000s) [228.162859] [040/133] (775s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite) [228.377386] Starting subtest: psr-rgb101010-draw-pwrite [228.379073] Subtest psr-rgb101010-draw-pwrite: SKIP (0.000s) [228.445273] [041/133] (775s left) kms_cursor_legacy (cursorb-vs-flipb-atomic) [228.644672] Starting subtest: cursorB-vs-flipB-atomic [228.646433] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s) [228.710267] [042/133] (774s left) gem_lmem_evict (dontneed-evict-race) [232.090036] Starting subtest: dontneed-evict-race [234.183956] Subtest dontneed-evict-race: SUCCESS (2.094s) [235.296428] [043/133] (768s left) drm_fdinfo (busy-hang) [236.726841] Starting subtest: busy-hang [236.727713] Starting dynamic subtest: rcs0 [236.732303] Dynamic subtest rcs0: SKIP (0.004s) [236.740098] Starting dynamic subtest: bcs0 [236.741886] Dynamic subtest bcs0: SKIP (0.000s) [236.751629] Starting dynamic subtest: vcs0 [236.753462] Dynamic subtest vcs0: SKIP (0.000s) [236.764344] Starting dynamic subtest: vcs1 [236.765982] Dynamic subtest vcs1: SKIP (0.000s) [236.772436] Starting dynamic subtest: vecs0 [236.774337] Dynamic subtest vecs0: SKIP (0.000s) [236.780909] Starting dynamic subtest: vecs1 [236.782589] Dynamic subtest vecs1: SKIP (0.000s) [236.788943] Starting dynamic subtest: ccs0 [236.790609] Dynamic subtest ccs0: SKIP (0.000s) [236.792342] Subtest busy-hang: SKIP (0.009s) [236.803044] [044/133] (766s left) kms_cursor_legacy (short-flip-after-cursor-toggle) [236.999888] Starting subtest: short-flip-after-cursor-toggle [238.041269] Subtest short-flip-after-cursor-toggle: SUCCESS (1.040s) [238.290035] [045/133] (765s left) kms_vblank (accuracy-idle) [238.537926] Starting subtest: accuracy-idle [238.539989] Starting dynamic subtest: pipe-A-DP-4 [240.814683] Dynamic subtest pipe-A-DP-4: SUCCESS (2.274s) [240.828829] Starting dynamic subtest: pipe-D-DP-4 [243.070513] Dynamic subtest pipe-D-DP-4: SUCCESS (2.249s) [243.071522] Subtest accuracy-idle: SUCCESS (4.532s) [243.299448] [046/133] (760s left) syncobj_timeline (signal-point-0) [243.374268] Starting subtest: signal-point-0 [243.375274] Subtest signal-point-0: SUCCESS (0.000s) [243.462238] [047/133] (760s left) kms_prime (basic-crc-vgem) [244.321673] Subtest basic-crc-vgem: SKIP (0.000s) [244.402722] [048/133] (759s left) kms_plane (plane-position-covered) [244.587864] Starting subtest: plane-position-covered [244.588771] Starting dynamic subtest: pipe-A [246.850559] Dynamic subtest pipe-A: SUCCESS (2.262s) [246.859186] Starting dynamic subtest: pipe-B [248.949190] Dynamic subtest pipe-B: SUCCESS (2.096s) [248.950163] Subtest plane-position-covered: SUCCESS (4.362s) [249.151905] [049/133] (754s left) kms_vblank (wait-idle-hang) [249.376726] Starting subtest: wait-idle-hang [249.377527] Starting dynamic subtest: pipe-A-DP-4 [276.074586] Dynamic subtest pipe-A-DP-4: SUCCESS (26.696s) [276.082299] Starting dynamic subtest: pipe-D-DP-4 [301.022827] Dynamic subtest pipe-D-DP-4: SUCCESS (24.945s) [301.024446] Subtest wait-idle-hang: SUCCESS (51.647s) [301.206339] [050/133] (702s left) i915_suspend (basic-s2idle-without-i915) [301.291300] Starting subtest: basic-s2idle-without-i915 [320.432299] Subtest basic-s2idle-without-i915: SUCCESS (4.313s) [320.560372] [051/133] (698s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt) [320.797595] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt [320.799423] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [320.888224] [052/133] (697s left) i915_pm_rc6_residency (rc6-idle) [320.963223] Starting subtest: rc6-idle [320.985059] Starting dynamic subtest: gt0-rcs0 [333.201577] Dynamic subtest gt0-rcs0: SUCCESS (12.217s) [333.209456] Starting dynamic subtest: gt0-bcs0 [345.452412] Dynamic subtest gt0-bcs0: SUCCESS (12.250s) [345.460021] Starting dynamic subtest: gt0-vcs0 [357.703242] Dynamic subtest gt0-vcs0: SUCCESS (12.250s) [357.710894] Starting dynamic subtest: gt0-vecs0 [369.953471] Dynamic subtest gt0-vecs0: SUCCESS (12.250s) [369.961080] Starting dynamic subtest: gt0-ccs0 [382.204927] Dynamic subtest gt0-ccs0: SUCCESS (12.251s) [382.205986] Subtest rc6-idle: SUCCESS (61.243s) [382.341830] [053/133] (636s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite) [382.534232] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite [382.536017] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [382.626156] [054/133] (636s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt) [382.853730] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt [382.855283] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [382.938429] [055/133] (635s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu) [383.152816] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu [383.154590] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [383.219777] [056/133] (635s left) gen3_render_tiledx_blits [383.331392] [057/133] (635s left) gem_softpin (overlap) [383.418973] Starting subtest: overlap [385.763795] Subtest overlap: SUCCESS (2.345s) [385.859124] [058/133] (633s left) gem_exec_params (rel-constants-invalid) [385.919977] Starting subtest: rel-constants-invalid [385.921092] Subtest rel-constants-invalid: SUCCESS (0.000s) [386.012021] [059/133] (632s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs) [386.197045] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs [386.198023] Starting dynamic subtest: pipe-A-DP-4 [386.199788] Dynamic subtest pipe-A-DP-4: SKIP (0.000s) [386.206829] Starting dynamic subtest: pipe-B-DP-4 [386.208439] Dynamic subtest pipe-B-DP-4: SKIP (0.000s) [386.215312] Starting dynamic subtest: pipe-C-DP-4 [386.216892] Dynamic subtest pipe-C-DP-4: SKIP (0.000s) [386.223534] Starting dynamic subtest: pipe-D-DP-4 [386.225370] Dynamic subtest pipe-D-DP-4: SKIP (0.000s) [386.226984] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.005s) [386.270200] [060/133] (632s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled) [386.341512] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled [386.343450] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s) [386.556937] [061/133] (632s left) gem_exec_reloc (basic-cpu-gtt) [386.657707] Subtest basic-cpu-gtt: SKIP (0.000s) [386.746992] [062/133] (632s left) v3d/v3d_mmap (mmap-bad-handle) [386.852358] Subtest mmap-bad-handle: SKIP (0.000s) [386.911077] [063/133] (632s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move) [387.120182] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move [387.121964] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [387.210701] [064/133] (631s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move) [387.427634] Starting subtest: fbc-1p-primscrn-cur-indfb-move [390.303494] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (2.875s) [390.461481] [065/133] (628s left) gen9_exec_parse (basic-rejected-ctx-param) [390.519906] Subtest basic-rejected-ctx-param: SKIP (0.000s) [390.563211] [066/133] (628s left) gem_pxp (display-protected-crc) [393.160107] Subtest display-protected-crc: SKIP (0.000s) [393.228372] [067/133] (625s left) perf (polling-parameterized) [393.564853] Starting subtest: polling-parameterized [413.593849] Subtest polling-parameterized: SUCCESS (20.029s) [413.617513] [068/133] (605s left) kms_addfb_basic (invalid-smem-bo-on-discrete) [413.676242] Starting subtest: invalid-smem-bo-on-discrete [413.677172] Subtest invalid-smem-bo-on-discrete: SUCCESS (0.000s) [413.892610] [069/133] (605s left) gem_spin_batch (resubmit-all) [413.988992] Starting subtest: resubmit-all [413.990110] Starting dynamic subtest: rcs0 [414.026085] Dynamic subtest rcs0: SUCCESS (0.037s) [414.033611] Starting dynamic subtest: bcs0 [414.034540] Dynamic subtest bcs0: SUCCESS (0.003s) [414.042154] Starting dynamic subtest: vcs0 [414.043085] Dynamic subtest vcs0: SUCCESS (0.002s) [414.050212] Starting dynamic subtest: vcs1 [414.051091] Dynamic subtest vcs1: SUCCESS (0.002s) [414.058149] Starting dynamic subtest: vecs0 [414.058993] Dynamic subtest vecs0: SUCCESS (0.003s) [414.066523] Starting dynamic subtest: vecs1 [414.067484] Dynamic subtest vecs1: SUCCESS (0.002s) [414.075065] Starting dynamic subtest: ccs0 [414.075964] Dynamic subtest ccs0: SUCCESS (0.002s) [414.076853] Subtest resubmit-all: SUCCESS (0.055s) [414.287499] [070/133] (604s left) kms_plane_alpha_blend (constant-alpha-min) [414.504441] Starting subtest: constant-alpha-min [414.723301] Starting dynamic subtest: pipe-A-DP-4 [415.419298] Dynamic subtest pipe-A-DP-4: SUCCESS (0.695s) [415.426642] Starting dynamic subtest: pipe-D-DP-4 [416.170146] Dynamic subtest pipe-D-DP-4: SUCCESS (0.750s) [416.171083] Subtest constant-alpha-min: SUCCESS (1.666s) [416.424910] [071/133] (602s left) gem_pxp (reject-modify-context-protection-off-1) [419.016136] Subtest reject-modify-context-protection-off-1: SKIP (0.000s) [419.086821] [072/133] (600s left) kms_atomic (plane-cursor-legacy) [419.279562] Starting subtest: plane-cursor-legacy [419.281829] Starting dynamic subtest: pipe-A-DP-4 [419.821106] Dynamic subtest pipe-A-DP-4: SUCCESS (0.540s) [419.825201] Subtest plane-cursor-legacy: SUCCESS (0.541s) [420.081027] [073/133] (599s left) kms_psr (psr-sprite-plane-onoff) [420.314796] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [420.342140] [074/133] (598s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions) [420.527947] Starting subtest: cursor-vs-flip-atomic-transitions [450.610161] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (30.082s) [450.821463] [075/133] (568s left) gem_close_race (basic-threads) [450.915902] Starting subtest: basic-threads [452.101397] Subtest basic-threads: SUCCESS (1.185s) [452.340510] [076/133] (567s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [452.581363] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [453.187774] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.606s) [453.389149] [077/133] (566s left) syncobj_basic (bad-pad-fd-to-handle) [453.461124] Starting subtest: bad-pad-fd-to-handle [453.461983] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s) [453.555037] [078/133] (565s left) kms_writeback (writeback-pixel-formats) [453.756016] Subtest writeback-pixel-formats: SKIP (0.000s) [453.779594] [079/133] (565s left) gem_exec_fence (syncobj-backward-timeline-chain-engines) [454.420734] Starting subtest: syncobj-backward-timeline-chain-engines [454.550329] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.130s) [454.822780] [080/133] (564s left) syncobj_wait (multi-wait-for-submit-submitted-signaled) [454.879309] Starting subtest: multi-wait-for-submit-submitted-signaled [454.880302] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s) [455.001369] [081/133] (564s left) gem_ctx_param (basic) [455.080563] Starting subtest: basic [455.082719] Subtest basic: SUCCESS (0.001s) [455.172693] [082/133] (564s left) gem_ctx_sseu (invalid-args) [455.258753] Subtest invalid-args: SKIP (0.000s) [455.297671] [083/133] (564s left) fbdev (eof) [455.354980] Starting subtest: eof [455.355910] Subtest eof: SUCCESS (0.000s) [455.406706] [084/133] (564s left) syncobj_timeline (invalid-query-one-illegal-handle) [455.464636] Starting subtest: invalid-query-one-illegal-handle [455.465496] Subtest invalid-query-one-illegal-handle: SUCCESS (0.000s) [455.586578] [085/133] (564s left) syncobj_wait (invalid-reset-illegal-handle) [455.666571] Starting subtest: invalid-reset-illegal-handle [455.667528] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s) [455.803206] [086/133] (563s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt) [456.012574] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt [456.014312] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [456.093712] [087/133] (563s left) gem_compute (compute-square) [456.168453] Starting subtest: compute-square [456.179771] Subtest compute-square: SUCCESS (0.011s) [456.281518] [088/133] (563s left) vc4/vc4_wait_bo (bad-pad) [456.388048] Subtest bad-pad: SKIP (0.000s) [456.445584] [089/133] (563s left) perf_pmu (most-busy-check-all) [456.496034] Starting subtest: most-busy-check-all [456.497018] Starting dynamic subtest: rcs0 [457.082682] Dynamic subtest rcs0: SUCCESS (0.586s) [457.097158] Starting dynamic subtest: bcs0 [457.638903] Dynamic subtest bcs0: SUCCESS (0.554s) [457.650656] Starting dynamic subtest: vcs0 [458.195275] Dynamic subtest vcs0: SUCCESS (0.554s) [458.203547] Starting dynamic subtest: vcs1 [458.745613] Dynamic subtest vcs1: SUCCESS (0.549s) [458.753876] Starting dynamic subtest: vecs0 [459.295362] Dynamic subtest vecs0: SUCCESS (0.549s) [459.303785] Starting dynamic subtest: vecs1 [459.846991] Dynamic subtest vecs1: SUCCESS (0.551s) [459.855321] Starting dynamic subtest: ccs0 [460.396981] Dynamic subtest ccs0: SUCCESS (0.548s) [460.399004] Subtest most-busy-check-all: SUCCESS (3.901s) [460.485460] [090/133] (559s left) kms_psr (pr-sprite-mmap-gtt) [460.675041] Subtest pr-sprite-mmap-gtt: SKIP (0.000s) [460.696901] [091/133] (559s left) syncobj_eventfd (timeline-wait) [460.749338] Starting subtest: timeline-wait [460.759941] Subtest timeline-wait: SUCCESS (0.011s) [460.841677] [092/133] (558s left) api_intel_bb (offset-control) [460.939233] Starting subtest: offset-control [460.966495] Subtest offset-control: SUCCESS (0.028s) [461.116179] [093/133] (558s left) kms_rotation_crc (primary-rotation-270) [461.327511] Starting subtest: primary-rotation-270 [461.331493] Subtest primary-rotation-270: SKIP (0.001s) [461.389079] [094/133] (558s left) kms_cursor_crc (cursor-offscreen-32x10) [461.659212] Starting subtest: cursor-offscreen-32x10 [461.704603] Subtest cursor-offscreen-32x10: SKIP (0.043s) [462.008901] [095/133] (557s left) gem_mmap_gtt (basic-write-read-distinct) [462.101319] Subtest basic-write-read-distinct: SKIP (0.000s) [462.147468] [096/133] (557s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite) [462.340757] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite [462.342300] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [462.428665] [097/133] (557s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt) [462.671994] Starting subtest: fbc-farfromfence-mmap-gtt [462.673759] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s) [462.741442] [098/133] (557s left) v3d/v3d_submit_cl (bad-multisync-extension) [462.821261] Subtest bad-multisync-extension: SKIP (0.000s) [462.878347] [099/133] (557s left) gem_exec_fair (basic-none-vip) [462.965069] Subtest basic-none-vip: SKIP (0.000s) [462.997899] [100/133] (557s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-75) [463.192903] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-75 [463.207086] Starting dynamic subtest: pipe-A-DP-4 [463.287283] Dynamic subtest pipe-A-DP-4: SUCCESS (0.080s) [463.310149] Starting dynamic subtest: pipe-B-DP-4 [463.496380] Dynamic subtest pipe-B-DP-4: SUCCESS (0.195s) [463.526971] Starting dynamic subtest: pipe-C-DP-4 [463.723704] Dynamic subtest pipe-C-DP-4: SUCCESS (0.210s) [463.752530] Starting dynamic subtest: pipe-D-DP-4 [463.985412] Dynamic subtest pipe-D-DP-4: SUCCESS (0.245s) [463.986339] Subtest planes-upscale-factor-0-25-downscale-factor-0-75: SUCCESS (0.793s) [464.250895] [101/133] (555s left) kms_chamelium_audio (dp-audio-edid) [464.556015] Subtest dp-audio-edid: SKIP (0.000s) [464.675612] [102/133] (555s left) gem_mmap_gtt (cpuset-medium-copy) [464.749312] Subtest cpuset-medium-copy: SKIP (0.000s) [464.789635] [103/133] (555s left) vc4/vc4_perfmon (destroy-invalid-perfmon) [464.876755] Subtest destroy-invalid-perfmon: SKIP (0.000s) [464.930582] [104/133] (555s left) kms_dp_aux_dev [465.535861] [105/133] (554s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format) [465.715879] Starting subtest: plane-upscale-factor-0-25-with-pixel-format [465.728983] Starting dynamic subtest: pipe-A-DP-4 [468.910202] Dynamic subtest pipe-A-DP-4: SUCCESS (3.180s) [468.931106] Starting dynamic subtest: pipe-B-DP-4 [472.436647] Dynamic subtest pipe-B-DP-4: SUCCESS (3.512s) [472.457549] Starting dynamic subtest: pipe-C-DP-4 [472.812708] Dynamic subtest pipe-C-DP-4: SUCCESS (0.362s) [472.845138] Starting dynamic subtest: pipe-D-DP-4 [473.205610] Dynamic subtest pipe-D-DP-4: SUCCESS (0.373s) [473.206824] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (7.491s) [473.544285] [106/133] (546s left) gem_create (create-ext-cpu-access-big)