[38.647938] Initializing watchdogs [38.647987] /dev/watchdog0 [38.655830] [001/133] (960s left) perf (invalid-oa-exponent) [38.799747] Starting subtest: invalid-oa-exponent [38.815193] Subtest invalid-oa-exponent: SUCCESS (0.016s) [38.848279] [002/133] (960s left) kms_scaling_modes (scaling-mode-none) [38.951066] Starting subtest: scaling-mode-none [38.953430] Starting dynamic subtest: pipe-A-eDP-1 [39.054134] Dynamic subtest pipe-A-eDP-1: SKIP (0.101s) [39.063882] Starting dynamic subtest: pipe-B-eDP-1 [39.084753] Dynamic subtest pipe-B-eDP-1: SKIP (0.030s) [39.095601] Starting dynamic subtest: pipe-C-eDP-1 [39.112691] Dynamic subtest pipe-C-eDP-1: SKIP (0.027s) [39.123380] Starting dynamic subtest: pipe-D-eDP-1 [39.140314] Dynamic subtest pipe-D-eDP-1: SKIP (0.028s) [39.145524] Subtest scaling-mode-none: SKIP (0.188s) [39.235378] [003/133] (959s left) syncobj_wait (wait-all-for-submit-snapshot) [39.315710] Starting subtest: wait-all-for-submit-snapshot [39.398193] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s) [39.463827] [004/133] (959s left) api_intel_bb (add-remove-objects) [39.532633] Starting subtest: add-remove-objects [39.546809] Subtest add-remove-objects: SUCCESS (0.016s) [39.643664] [005/133] (959s left) gem_render_copy (y-tiled-to-vebox-x-tiled) [39.720961] Starting subtest: y-tiled-to-vebox-x-tiled [39.725142] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s) [39.896781] [006/133] (959s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling) [39.972322] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling [39.974846] Starting dynamic subtest: pipe-A-default-mode [41.182526] Dynamic subtest pipe-A-default-mode: SKIP (1.208s) [41.188494] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (1.209s) [41.336087] [007/133] (957s left) kms_atomic (crtc-invalid-params) [41.416566] Starting subtest: crtc-invalid-params [41.419089] Starting dynamic subtest: pipe-A-eDP-1 [41.884711] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.470s) [41.887281] Subtest crtc-invalid-params: SUCCESS (0.471s) [42.815549] [008/133] (956s left) kms_feature_discovery (display-4x) [42.900668] Starting subtest: display-4x [42.904818] Subtest display-4x: SKIP (0.000s) [42.954073] [009/133] (956s left) syncobj_eventfd (timeline-wait) [43.011495] Starting subtest: timeline-wait [43.019070] Subtest timeline-wait: SUCCESS (0.010s) [43.084199] [010/133] (956s left) prime_self_import (export-vs-gem_close-race) [43.141552] Starting subtest: export-vs-gem_close-race [48.220506] Subtest export-vs-gem_close-race: SUCCESS (5.058s) [48.269230] [011/133] (951s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions) [48.374592] Starting subtest: cursorA-vs-flipA-atomic-transitions [59.573144] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.200s) [60.478539] [012/133] (938s left) drm_fdinfo (virtual-busy) [60.544186] Starting subtest: virtual-busy [60.548237] Subtest virtual-busy: SKIP (0.000s) [60.606567] [013/133] (938s left) fbdev (read) [60.669079] Starting subtest: read [61.452848] Subtest read: SUCCESS (0.782s) [61.507924] [014/133] (937s left) kms_cursor_crc (cursor-random-max-size) [61.779658] Starting subtest: cursor-random-max-size [61.786754] Subtest cursor-random-max-size: SKIP (0.000s) [61.888647] [015/133] (937s left) kms_prop_blob (blob-prop-core) [61.955258] Starting subtest: blob-prop-core [61.957275] Subtest blob-prop-core: SUCCESS (0.000s) [62.030617] [016/133] (937s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc) [62.099308] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc [62.103547] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [62.178413] [017/133] (937s left) kms_ccs (crc-primary-basic-y-tiled-ccs) [62.255813] Starting subtest: crc-primary-basic-y-tiled-ccs [62.258358] Starting dynamic subtest: pipe-A-eDP-1 [62.263124] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [62.272153] Starting dynamic subtest: pipe-B-eDP-1 [62.276613] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [62.283340] Starting dynamic subtest: pipe-C-eDP-1 [62.287487] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [62.294248] Starting dynamic subtest: pipe-D-eDP-1 [62.298428] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [62.302628] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.003s) [62.320203] [018/133] (937s left) kms_cursor_crc (cursor-suspend) [62.406792] Starting subtest: cursor-suspend [62.409270] Starting dynamic subtest: pipe-A-eDP-1 [96.332026] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.115s) [96.346955] Starting dynamic subtest: pipe-D-eDP-1 [130.333121] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.838s) [130.335316] Subtest cursor-suspend: SUCCESS (6.957s) [131.221478] [019/133] (929s left) kms_cursor_crc (cursor-offscreen-64x21) [131.389815] Starting subtest: cursor-offscreen-64x21 [131.419730] Subtest cursor-offscreen-64x21: SKIP (0.025s) [131.621239] [020/133] (928s left) kms_psr (fbc-psr-sprite-plane-move) [131.737046] Starting subtest: fbc-psr-sprite-plane-move [131.739403] Starting dynamic subtest: eDP-1 [131.743940] Dynamic subtest eDP-1: SKIP (0.000s) [131.748654] Subtest fbc-psr-sprite-plane-move: SKIP (0.001s) [131.802231] [021/133] (928s left) gem_lmem_swapping (verify-random-ccs) [131.875900] Subtest verify-random-ccs: SKIP (0.000s) [131.900988] [022/133] (928s left) kms_pm_rpm (modeset-non-lpsp-stress) [133.519965] Starting subtest: modeset-non-lpsp-stress [137.242060] Subtest modeset-non-lpsp-stress: SKIP (3.719s) [138.068399] [023/133] (922s left) gem_exec_balancer (parallel-dmabuf-import-out-fence) [138.351768] Starting subtest: parallel-dmabuf-import-out-fence [139.247559] Subtest parallel-dmabuf-import-out-fence: SUCCESS (0.896s) [139.316431] [024/133] (921s left) gem_exec_schedule (u-semaphore-user) [139.408873] Starting subtest: u-semaphore-user [139.443921] Subtest u-semaphore-user: SUCCESS (0.039s) [141.455042] [025/133] (919s left) gem_pxp (hw-rejects-pxp-buffer) [144.098998] Starting subtest: hw-rejects-pxp-buffer [144.102352] Subtest hw-rejects-pxp-buffer: SUCCESS (0.000s) [144.138691] [026/133] (916s left) gem_userptr_blits (stress-purge) [144.222518] Starting subtest: stress-purge [149.610753] Subtest stress-purge: SUCCESS (5.388s) [149.731404] [027/133] (911s left) gem_exec_reloc (basic-wc-read) [149.849440] Subtest basic-wc-read: SKIP (0.000s) [149.891804] [028/133] (910s left) vc4/vc4_dmabuf_poll (poll-write-waits-until-write-done) [149.985368] Subtest poll-write-waits-until-write-done: SKIP (0.000s) [150.036486] [029/133] (910s left) kms_psr (psr2-sprite-mmap-cpu) [150.129695] Starting subtest: psr2-sprite-mmap-cpu [150.131777] Starting dynamic subtest: eDP-1 [152.041062] Dynamic subtest eDP-1: SUCCESS (1.909s) [152.043858] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.910s) [152.939791] [030/133] (907s left) kms_vblank (query-forked) [153.028366] Starting subtest: query-forked [153.031062] Starting dynamic subtest: pipe-A-eDP-1 [154.856533] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.824s) [154.869756] Starting dynamic subtest: pipe-D-eDP-1 [157.431918] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.569s) [157.434257] Subtest query-forked: SUCCESS (4.403s) [158.316757] [031/133] (902s left) syncobj_timeline (single-wait-all-for-submit-available-submitted) [158.383901] Starting subtest: single-wait-all-for-submit-available-submitted [158.386375] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s) [158.459384] [032/133] (902s left) perf (non-system-wide-paranoid) [158.555930] Starting subtest: non-system-wide-paranoid [158.600648] Subtest non-system-wide-paranoid: SUCCESS (0.045s) [158.638203] [033/133] (902s left) kms_force_connector_basic (force-edid) [158.699079] Starting subtest: force-edid [159.038146] Subtest force-edid: SUCCESS (0.335s) [159.152279] [034/133] (901s left) gem_exec_schedule (smoketest-all) [159.250645] Starting subtest: smoketest-all [191.683294] Subtest smoketest-all: SUCCESS (32.385s) [192.469762] [035/133] (868s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt) [192.552954] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt [196.058076] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (3.510s) [196.201859] [036/133] (864s left) kms_writeback (writeback-check-output-xrgb2101010) [196.332158] Subtest writeback-check-output-XRGB2101010: SKIP (0.000s) [196.350848] [037/133] (864s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc) [196.440134] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc [196.443876] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [196.524327] [038/133] (864s left) gem_exec_schedule (thriceslice) [196.605163] Starting subtest: thriceslice [196.607293] Starting dynamic subtest: rcs0 [196.646081] Dynamic subtest rcs0: SUCCESS (0.041s) [196.662733] Starting dynamic subtest: bcs0 [196.690175] Dynamic subtest bcs0: SUCCESS (0.043s) [196.705939] Starting dynamic subtest: vcs0 [196.727862] Dynamic subtest vcs0: SUCCESS (0.037s) [196.743207] Starting dynamic subtest: vcs1 [196.784500] Dynamic subtest vcs1: SUCCESS (0.055s) [196.800580] Starting dynamic subtest: vecs0 [196.817752] Dynamic subtest vecs0: SUCCESS (0.033s) [196.832901] Starting dynamic subtest: ccs0 [196.853297] Dynamic subtest ccs0: SUCCESS (0.035s) [196.855586] Subtest thriceslice: SUCCESS (0.250s) [198.479341] [039/133] (862s left) perf_pmu (faulting-read) [198.535632] Starting subtest: faulting-read [198.538315] Starting dynamic subtest: gtt [198.543281] Dynamic subtest gtt: SKIP (0.000s) [198.559501] Starting dynamic subtest: wb [198.561871] Dynamic subtest wb: SUCCESS (0.001s) [198.574735] Starting dynamic subtest: wc [198.576985] Dynamic subtest wc: SUCCESS (0.000s) [198.585988] Starting dynamic subtest: uc [198.588308] Dynamic subtest uc: SUCCESS (0.000s) [198.590620] Subtest faulting-read: SUCCESS (0.003s) [198.631368] [040/133] (862s left) kms_psr2_sf (plane-move-sf-dmg-area) [203.877668] Starting subtest: plane-move-sf-dmg-area [203.880351] Starting dynamic subtest: psr2-pipe-A-eDP-1 [209.342196] Dynamic subtest psr2-pipe-A-eDP-1: SUCCESS (5.458s) [209.354810] Starting dynamic subtest: psr2-pipe-B-eDP-1 [214.793232] Dynamic subtest psr2-pipe-B-eDP-1: SUCCESS (5.452s) [214.795865] Subtest plane-move-sf-dmg-area: SUCCESS (10.916s) [215.724705] [041/133] (845s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes) [215.777363] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s) [215.816792] [042/133] (845s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-move) [215.903195] Starting subtest: psr-1p-primscrn-spr-indfb-move [221.563391] Subtest psr-1p-primscrn-spr-indfb-move: SUCCESS (5.661s) [221.692326] [043/133] (839s left) kms_plane_lowres (tiling-4) [221.789177] Starting subtest: tiling-4 [221.791610] Starting dynamic subtest: pipe-A-eDP-1 [221.796401] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [222.088550] Starting dynamic subtest: pipe-B-eDP-1 [222.094845] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [222.105862] Starting dynamic subtest: pipe-C-eDP-1 [222.110916] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [222.120693] Starting dynamic subtest: pipe-D-eDP-1 [222.125416] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [222.130013] Subtest tiling-4: SKIP (0.300s) [222.955852] [044/133] (838s left) kms_getfb (getfb2-handle-closed) [223.037278] Starting subtest: getfb2-handle-closed [223.040358] Subtest getfb2-handle-closed: SUCCESS (0.000s) [223.123821] [045/133] (838s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc) [223.225117] Starting subtest: psr-rgb101010-draw-mmap-wc [228.102607] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (4.882s) [228.191647] [046/133] (833s left) sw_sync (sync_busy_fork_unixsocket) [228.244722] Starting subtest: sync_busy_fork_unixsocket [228.257271] Subtest sync_busy_fork_unixsocket: SUCCESS (0.014s) [228.316979] [047/133] (832s left) kms_legacy_colorkey (basic) [228.422067] Starting subtest: basic [228.424289] Starting dynamic subtest: pipe-A [228.466253] Dynamic subtest pipe-A: SUCCESS (0.046s) [228.483385] Starting dynamic subtest: pipe-B [228.486485] Dynamic subtest pipe-B: SUCCESS (0.001s) [228.499694] Starting dynamic subtest: pipe-C [228.502419] Dynamic subtest pipe-C: SUCCESS (0.001s) [228.512050] Starting dynamic subtest: pipe-D [228.514508] Dynamic subtest pipe-D: SUCCESS (0.001s) [228.517076] Subtest basic: SUCCESS (0.054s) [228.537219] [048/133] (832s left) gem_exec_reloc (basic-gtt-cpu) [228.622259] Subtest basic-gtt-cpu: SKIP (0.000s) [228.682715] [049/133] (832s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt) [228.788491] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt [228.792492] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [228.866356] [050/133] (832s left) kms_psr (fbc-pr-sprite-plane-onoff) [228.959310] Starting subtest: fbc-pr-sprite-plane-onoff [228.965332] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s) [229.030147] [051/133] (832s left) gem_caching (writes) [229.106481] Subtest writes: SKIP (0.000s) [229.173270] [052/133] (832s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [229.264255] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip [230.272286] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (1.009s) [230.475758] [053/133] (830s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt) [230.567284] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt [230.571896] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [230.641170] [054/133] (830s left) gem_ctx_param (non-root-set) [230.703947] Starting subtest: non-root-set [230.728650] Subtest non-root-set: SUCCESS (0.024s) [230.815975] [055/133] (830s left) kms_lease (lease-get) [230.896767] Starting subtest: lease-get [230.899360] Starting dynamic subtest: pipe-A-eDP-1 [230.901787] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [230.918224] Starting dynamic subtest: pipe-B-eDP-1 [230.920742] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [230.933103] Starting dynamic subtest: pipe-C-eDP-1 [230.935841] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [230.951807] Starting dynamic subtest: pipe-D-eDP-1 [230.954332] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [230.956871] Subtest lease-get: SUCCESS (0.005s) [231.005568] [056/133] (830s left) gem_exec_gttfill (engines) [231.074927] Starting subtest: engines [231.077729] Starting dynamic subtest: rcs0 [253.563621] Dynamic subtest rcs0: SUCCESS (22.487s) [253.580457] Starting dynamic subtest: bcs0 [276.428329] Dynamic subtest bcs0: SUCCESS (22.863s) [276.446343] Starting dynamic subtest: vcs0 [299.079461] Dynamic subtest vcs0: SUCCESS (22.649s) [299.097210] Starting dynamic subtest: vcs1 [321.667255] Dynamic subtest vcs1: SUCCESS (22.587s) [321.684049] Starting dynamic subtest: vecs0 [344.253266] Dynamic subtest vecs0: SUCCESS (22.584s) [344.272623] Starting dynamic subtest: ccs0 [366.911393] Dynamic subtest ccs0: SUCCESS (22.657s) [366.914208] Subtest engines: SUCCESS (135.837s) [367.094160] [057/133] (694s left) i915_pm_freq_mult (media-freq) [367.241597] Starting subtest: media-freq [367.244065] Starting dynamic subtest: gt0 [367.248696] Dynamic subtest gt0: SKIP (0.000s) [367.266250] Starting dynamic subtest: gt1 [367.271629] Dynamic subtest gt1: SKIP (0.000s) [367.277525] Subtest media-freq: SKIP (0.003s) [367.333697] [058/133] (694s left) gem_mmap_gtt (zero-extend) [367.394484] Subtest zero-extend: SKIP (0.000s) [367.432689] [059/133] (694s left) gem_linear_blits (basic) [367.535905] Starting subtest: basic [367.553587] Subtest basic: SUCCESS (0.018s) [367.676876] [060/133] (693s left) kms_big_fb (4-tiled-addfb-size-overflow) [367.862838] Starting subtest: 4-tiled-addfb-size-overflow [367.864773] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s) [367.936791] [061/133] (693s left) gem_exec_whisper (basic-sync-all) [368.007095] Starting subtest: basic-sync-all [377.390740] Subtest basic-sync-all: SUCCESS (9.381s) [377.573483] [062/133] (684s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc) [377.698350] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc [377.703531] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [377.781153] [063/133] (683s left) kms_plane_scaling (plane-downscale-factor-0-25-with-pixel-format) [377.855336] Starting subtest: plane-downscale-factor-0-25-with-pixel-format [377.857924] Starting dynamic subtest: pipe-A-eDP-1 [377.917182] Dynamic subtest pipe-A-eDP-1: SKIP (0.060s) [377.927180] Starting dynamic subtest: pipe-B-eDP-1 [377.967738] Dynamic subtest pipe-B-eDP-1: SKIP (0.048s) [377.982145] Starting dynamic subtest: pipe-C-eDP-1 [378.003447] Dynamic subtest pipe-C-eDP-1: SKIP (0.035s) [378.011197] Starting dynamic subtest: pipe-D-eDP-1 [378.032786] Dynamic subtest pipe-D-eDP-1: SKIP (0.030s) [378.037432] Subtest plane-downscale-factor-0-25-with-pixel-format: SKIP (0.176s) [378.124639] [064/133] (683s left) gem_exec_params (dr1-dirt) [378.200580] Starting subtest: DR1-dirt [378.203401] Subtest DR1-dirt: SUCCESS (0.000s) [378.296232] [065/133] (683s left) kms_hdmi_inject (inject-audio) [378.646106] Starting subtest: inject-audio [378.898561] Subtest inject-audio: SUCCESS (0.250s) [379.866152] [066/133] (681s left) kms_big_fb (4-tiled-8bpp-rotate-0) [379.993476] Starting subtest: 4-tiled-8bpp-rotate-0 [381.405853] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.412s) [381.533714] [067/133] (680s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-blt) [381.647931] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-blt [381.651888] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s) [381.730288] [068/133] (680s left) sysfs_heartbeat_interval (mixed) [381.809797] Starting subtest: mixed [381.812178] Starting dynamic subtest: vecs0 [387.035897] Dynamic subtest vecs0: SUCCESS (5.224s) [387.053930] Starting dynamic subtest: ccs0 [392.218560] Dynamic subtest ccs0: SUCCESS (5.182s) [392.235054] Starting dynamic subtest: vcs0 [397.482066] Dynamic subtest vcs0: SUCCESS (5.262s) [397.499828] Starting dynamic subtest: bcs0 [402.708829] Dynamic subtest bcs0: SUCCESS (5.225s) [402.726910] Starting dynamic subtest: rcs0 [407.897434] Dynamic subtest rcs0: SUCCESS (5.188s) [407.917172] Starting dynamic subtest: vcs1 [413.118894] Dynamic subtest vcs1: SUCCESS (5.220s) [413.121953] Subtest mixed: SUCCESS (31.309s) [413.187945] [069/133] (648s left) kms_busy (extended-pageflip-hang-oldfb) [413.247081] Starting subtest: extended-pageflip-hang-oldfb [413.249846] Starting dynamic subtest: pipe-A [413.688363] Dynamic subtest pipe-A: SUCCESS (0.441s) [413.704284] Starting dynamic subtest: pipe-D [414.867873] Dynamic subtest pipe-D: SUCCESS (1.168s) [414.870718] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.619s) [415.795154] [070/133] (646s left) gem_exec_endless (dispatch) [415.877977] Starting subtest: dispatch [415.880734] Starting dynamic subtest: rcs0 [415.885981] Dynamic subtest rcs0: SUCCESS (0.005s) [415.903441] Starting dynamic subtest: bcs0 [415.908090] Dynamic subtest bcs0: SUCCESS (0.006s) [415.917918] Starting dynamic subtest: vcs0 [415.922581] Dynamic subtest vcs0: SUCCESS (0.004s) [415.931659] Starting dynamic subtest: vcs1 [415.935860] Dynamic subtest vcs1: SUCCESS (0.009s) [415.943282] Starting dynamic subtest: vecs0 [415.947432] Dynamic subtest vecs0: SUCCESS (0.009s) [415.955042] Starting dynamic subtest: ccs0 [415.959237] Dynamic subtest ccs0: SUCCESS (0.008s) [415.961162] Subtest dispatch: SUCCESS (0.046s) [417.490861] [071/133] (644s left) gem_softpin (noreloc-s3) [417.566232] Starting subtest: noreloc-S3 [438.001853] Subtest noreloc-S3: SUCCESS (5.396s) [438.103348] [072/133] (638s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs) [438.181092] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs [438.183708] Starting dynamic subtest: pipe-A-eDP-1 [438.187949] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [438.197730] Starting dynamic subtest: pipe-B-eDP-1 [438.201633] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [438.208397] Starting dynamic subtest: pipe-C-eDP-1 [438.212592] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [438.219372] Starting dynamic subtest: pipe-D-eDP-1 [438.223571] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [438.227719] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.003s) [438.245222] [073/133] (638s left) kms_cursor_legacy (cursor-vs-flip-varying-size) [438.334996] Starting subtest: cursor-vs-flip-varying-size [467.698699] Subtest cursor-vs-flip-varying-size: SUCCESS (29.363s) [468.587062] [074/133] (608s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy) [468.700387] Starting subtest: flip-vs-cursor-busy-crc-legacy [469.608044] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.907s) [470.508690] [075/133] (606s left) gem_ctx_persistence (engines-cleanup) [470.590356] Starting subtest: engines-cleanup [470.592995] Starting dynamic subtest: rcs0 [470.654017] Dynamic subtest rcs0: SUCCESS (0.063s) [470.672989] Starting dynamic subtest: bcs0 [470.692163] Dynamic subtest bcs0: SUCCESS (0.037s) [470.708704] Starting dynamic subtest: vcs0 [470.734153] Dynamic subtest vcs0: SUCCESS (0.041s) [470.750723] Starting dynamic subtest: vcs1 [470.765273] Dynamic subtest vcs1: SUCCESS (0.030s) [470.780864] Starting dynamic subtest: vecs0 [470.786346] Dynamic subtest vecs0: SUCCESS (0.019s) [470.798245] Starting dynamic subtest: ccs0 [470.821910] Dynamic subtest ccs0: SUCCESS (0.036s) [470.824409] Subtest engines-cleanup: SUCCESS (0.232s) [470.924591] [076/133] (606s left) kms_getfb (getfb-handle-closed) [470.975869] Starting subtest: getfb-handle-closed [470.978340] Subtest getfb-handle-closed: SUCCESS (0.000s) [471.071398] [077/133] (606s left) kms_scaling_modes (scaling-mode-full-aspect) [471.162560] Starting subtest: scaling-mode-full-aspect [471.164969] Starting dynamic subtest: pipe-A-eDP-1 [471.293646] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.133s) [471.312519] Starting dynamic subtest: pipe-B-eDP-1 [472.555637] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.255s) [472.566412] Starting dynamic subtest: pipe-C-eDP-1 [473.810364] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.256s) [473.825251] Starting dynamic subtest: pipe-D-eDP-1 [475.027834] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.217s) [475.030628] Subtest scaling-mode-full-aspect: SUCCESS (3.868s) [476.265639] [078/133] (600s left) kms_color (ctm-blue-to-red) [476.348089] Starting subtest: ctm-blue-to-red [476.350980] Starting dynamic subtest: pipe-A [477.098425] Dynamic subtest pipe-A: SUCCESS (0.751s) [477.116171] Starting dynamic subtest: pipe-B [478.602903] Dynamic subtest pipe-B: SUCCESS (1.504s) [478.621611] Starting dynamic subtest: pipe-C [480.081249] Dynamic subtest pipe-C: SUCCESS (1.477s) [480.099426] Starting dynamic subtest: pipe-D [481.575613] Dynamic subtest pipe-D: SUCCESS (1.494s) [481.578280] Subtest ctm-blue-to-red: SUCCESS (5.232s) [482.476532] [079/133] (594s left) i915_hangman (gt-engine-hang) [482.551836] Starting subtest: gt-engine-hang [482.553903] Starting dynamic subtest: rcs0 [484.426364] Dynamic subtest rcs0: SUCCESS (1.873s) [484.443793] Starting dynamic subtest: bcs0 [486.409697] Dynamic subtest bcs0: SUCCESS (1.982s) [486.429578] Starting dynamic subtest: vcs0 [488.458207] Dynamic subtest vcs0: SUCCESS (2.046s) [488.475968] Starting dynamic subtest: vcs1 [490.442845] Dynamic subtest vcs1: SUCCESS (1.983s) [490.463674] Starting dynamic subtest: vecs0 [492.425931] Dynamic subtest vecs0: SUCCESS (1.982s) [492.444343] Starting dynamic subtest: ccs0 [494.412352] Dynamic subtest ccs0: SUCCESS (1.982s) [494.415258] Subtest gt-engine-hang: SUCCESS (11.859s) [494.529139] [080/133] (582s left) vc4/vc4_tiling (set-get) [494.665100] Subtest set-get: SKIP (0.000s) [494.709897] [081/133] (582s left) gem_exec_schedule (noreorder-priority) [494.918895] Starting subtest: noreorder-priority [494.921822] Starting dynamic subtest: rcs0 [496.068122] Dynamic subtest rcs0: SUCCESS (1.147s) [496.087839] Starting dynamic subtest: vcs0 [497.425286] Dynamic subtest vcs0: SUCCESS (1.357s) [497.431987] Starting dynamic subtest: vcs1 [499.496643] Dynamic subtest vcs1: SUCCESS (2.069s) [499.521450] Starting dynamic subtest: vecs0 [501.471704] Dynamic subtest vecs0: SUCCESS (1.973s) [501.488892] Starting dynamic subtest: ccs0 [502.626162] Dynamic subtest ccs0: SUCCESS (1.155s) [502.628903] Subtest noreorder-priority: SUCCESS (7.709s) [502.814980] [082/133] (574s left) gem_mmap_wc (set-cache-level) [502.892644] Subtest set-cache-level: SKIP (0.000s) [502.944079] [083/133] (574s left) i915_pm_sseu (full-enable) [503.019355] Subtest full-enable: SKIP (0.000s) [503.102520] [084/133] (574s left) syncobj_timeline (host-signal-ordered) [503.191699] Starting subtest: host-signal-ordered [503.195718] Subtest host-signal-ordered: SUCCESS (0.001s) [503.278937] [085/133] (574s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling) [503.379293] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling [503.382051] Starting dynamic subtest: pipe-A-default-mode [503.671685] Dynamic subtest pipe-A-default-mode: SKIP (0.288s) [503.678241] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.290s) [504.556884] [086/133] (572s left) gem_spin_batch (legacy-resubmit-new) [504.626396] Starting subtest: legacy-resubmit-new [504.629162] Starting dynamic subtest: default [504.635300] Dynamic subtest default: SUCCESS (0.009s) [504.652473] Starting dynamic subtest: render [504.655140] Dynamic subtest render: SUCCESS (0.002s) [504.665109] Starting dynamic subtest: bsd [504.667343] Dynamic subtest bsd: SUCCESS (0.006s) [504.682905] Starting dynamic subtest: bsd1 [504.685017] Dynamic subtest bsd1: SUCCESS (0.003s) [504.699966] Starting dynamic subtest: bsd2 [504.701923] Dynamic subtest bsd2: SUCCESS (0.005s) [504.711360] Starting dynamic subtest: blt [504.713209] Dynamic subtest blt: SUCCESS (0.007s) [504.720663] Starting dynamic subtest: vebox [504.722460] Dynamic subtest vebox: SUCCESS (0.004s) [504.724321] Subtest legacy-resubmit-new: SUCCESS (0.038s) [506.511212] [087/133] (570s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt) [506.619124] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt [506.624205] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [506.705620] [088/133] (570s left) vc4/vc4_purgeable_bo (mark-unpurgeable-check-retained) [506.799985] Subtest mark-unpurgeable-check-retained: SKIP (0.000s) [506.853711] [089/133] (570s left) prime_self_import (basic-llseek-size) [506.910859] Starting subtest: basic-llseek-size [506.925548] Subtest basic-llseek-size: SUCCESS (0.016s) [507.018891] [090/133] (570s left) kms_chamelium_edid (dp-edid-change-during-suspend) [507.408647] Subtest dp-edid-change-during-suspend: SKIP (0.000s) [508.297671] [091/133] (569s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary) [508.376885] Starting subtest: fbc-indfb-scaledprimary [512.483550] Subtest fbc-indfb-scaledprimary: SUCCESS (4.110s) [512.618002] [092/133] (564s left) gem_pxp (create-regular-context-1) [515.248054] Subtest create-regular-context-1: SKIP (0.000s) [515.289967] [093/133] (562s left) gem_mmap_gtt (basic-small-copy-xy) [515.363633] Subtest basic-small-copy-XY: SKIP (0.000s) [515.402624] [094/133] (562s left) v3d/v3d_submit_csd (bad-multisync-in-sync) [515.496030] Subtest bad-multisync-in-sync: SKIP (0.000s) [515.546465] [095/133] (562s left) kms_content_protection (dp-mst-lic-type-0) [515.700994] Starting subtest: dp-mst-lic-type-0 [515.706233] Subtest dp-mst-lic-type-0: SKIP (0.000s) [515.808969] [096/133] (561s left) core_auth (getclient-master-drop) [515.850670] Starting subtest: getclient-master-drop [515.863008] Subtest getclient-master-drop: SUCCESS (0.015s) [515.958115] [097/133] (561s left) v3d/v3d_get_bo_offset (create-get-offsets) [516.013437] Subtest create-get-offsets: SKIP (0.000s) [516.069305] [098/133] (561s left) kms_dirtyfb (default-dirtyfb-ioctl) [516.155079] Starting subtest: default-dirtyfb-ioctl [516.157829] Starting dynamic subtest: A-eDP-1 [517.846503] Dynamic subtest A-eDP-1: SUCCESS (1.691s) [517.849636] Subtest default-dirtyfb-ioctl: SUCCESS (1.692s) [518.761866] [099/133] (559s left) kms_flip (2x-flip-vs-wf_vblank) [518.855788] Starting subtest: 2x-flip-vs-wf_vblank [518.883017] Subtest 2x-flip-vs-wf_vblank: SKIP (0.024s) [518.957875] [100/133] (558s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-render) [519.036198] Starting subtest: psr-1p-offscren-pri-shrfb-draw-render [523.793126] Subtest psr-1p-offscren-pri-shrfb-draw-render: SUCCESS (4.759s) [523.915695] [101/133] (553s left) perf_pmu (interrupts-sync) [523.989202] Starting subtest: interrupts-sync [525.082779] Subtest interrupts-sync: SUCCESS (1.093s) [525.187277] [102/133] (552s left) kms_flip (bo-too-big) [525.283023] Starting subtest: bo-too-big [525.285145] Starting dynamic subtest: A-eDP1 [526.773042] Dynamic subtest A-eDP1: SUCCESS (1.490s) [526.785322] Starting dynamic subtest: B-eDP1 [528.279946] Dynamic subtest B-eDP1: SUCCESS (1.506s) [528.289610] Starting dynamic subtest: C-eDP1 [529.779067] Dynamic subtest C-eDP1: SUCCESS (1.497s) [529.788407] Starting dynamic subtest: D-eDP1 [531.293963] Dynamic subtest D-eDP1: SUCCESS (1.513s) [531.300203] Subtest bo-too-big: SUCCESS (6.018s) [532.587133] [103/133] (545s left) device_reset (unbind-cold-reset-rebind) [532.686467] Subtest unbind-cold-reset-rebind: SKIP (0.000s) [532.758004] [104/133] (545s left) kms_force_connector_basic (prune-stale-modes) [532.824500] Starting subtest: prune-stale-modes [533.070777] Subtest prune-stale-modes: SKIP (0.243s) [533.198255] [105/133] (544s left) gem_exec_fence (parallel) [533.369559] Starting subtest: parallel [533.372371] Starting dynamic subtest: rcs0 [535.521674] Dynamic subtest rcs0: SUCCESS (2.154s) [535.534328] Starting dynamic subtest: bcs0 [537.671723] Dynamic subtest bcs0: SUCCESS (2.149s) [537.688849] Starting dynamic subtest: vcs0 [539.824058] Dynamic subtest vcs0: SUCCESS (2.152s) [539.843003] Starting dynamic subtest: vcs1 [541.973163] Dynamic subtest vcs1: SUCCESS (2.148s) [541.990696] Starting dynamic subtest: vecs0 [544.127123] Dynamic subtest vecs0: SUCCESS (2.154s) [544.144688] Starting dynamic subtest: ccs0 [546.286709] Dynamic subtest ccs0: SUCCESS (2.160s) [546.288786] Subtest parallel: SUCCESS (12.920s) [548.528832] [106/133] (529s left) gem_userptr_blits (sync-unmap) [548.622450] Starting subtest: sync-unmap [548.651409] Subtest sync-unmap: SUCCESS (0.028s) [548.763705] [107/133] (529s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt) [548.860930] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt [553.718255] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (4.860s) [553.866534] [108/133] (524s left) kms_chamelium_hpd (dp-hpd) [554.268207] Subtest dp-hpd: SKIP (0.000s) [555.155154] [109/133] (522s left) perf_pmu (semaphore-busy) [555.212891] Starting subtest: semaphore-busy [555.215393] Starting dynamic subtest: rcs0 [556.835629] Dynamic subtest rcs0: SUCCESS (1.620s) [556.854238] Starting dynamic subtest: bcs0 [558.467922] Dynamic subtest bcs0: SUCCESS (1.630s) [558.486489] Starting dynamic subtest: vcs0 [562.983771] Dynamic subtest vcs0: SUCCESS (4.514s) [563.001753] Starting dynamic subtest: vcs1 [568.999838] Dynamic subtest vcs1: SUCCESS (6.014s) [569.017512] Starting dynamic subtest: vecs0 [575.070303] Dynamic subtest vecs0: SUCCESS (6.014s) [575.089476] Starting dynamic subtest: ccs0 [578.092780] Dynamic subtest ccs0: SUCCESS (3.075s) [578.095905] Subtest semaphore-busy: SUCCESS (22.879s) [578.205522] [110/133] (499s left) kms_pm_dc (dc6-dpms) [579.314601] Starting subtest: dc6-dpms [579.319995] Subtest dc6-dpms: SKIP (0.000s) [579.381671] [111/133] (498s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite) [579.466254] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite [582.582714] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (3.122s) [582.703967] [112/133] (495s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip) [582.824635] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip [582.828390] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s) [582.902962] [113/133] (495s left) kms_plane_scaling (planes-downscale-factor-0-5) [583.009247] Starting subtest: planes-downscale-factor-0-5 [583.013882] Starting dynamic subtest: pipe-A-eDP-1 [583.018378] Dynamic subtest pipe-A-eDP-1: SKIP (0.003s) [583.037134] Starting dynamic subtest: pipe-B-eDP-1 [583.042796] Dynamic subtest pipe-B-eDP-1: SKIP (0.013s) [583.058351] Starting dynamic subtest: pipe-C-eDP-1 [583.063596] Dynamic subtest pipe-C-eDP-1: SKIP (0.012s) [583.075440] Starting dynamic subtest: pipe-D-eDP-1 [583.080615] Dynamic subtest pipe-D-eDP-1: SKIP (0.012s) [583.085469] Subtest planes-downscale-factor-0-5: SKIP (0.045s) [583.133188] [114/133] (495s left) gem_create (create-massive) [583.194568] Starting subtest: create-massive [583.196695] Subtest create-massive: SUCCESS (0.000s) [583.377826] [115/133] (494s left) kms_atomic_interruptible (universal-setplane-primary) [583.456008] Starting subtest: universal-setplane-primary [583.458517] Starting dynamic subtest: pipe-A-eDP-1 [590.998180] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.540s) [591.000795] Subtest universal-setplane-primary: SUCCESS (7.541s) [591.917366] [116/133] (486s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-render) [592.029913] Starting subtest: psr-1p-offscren-pri-indfb-draw-render [596.760408] Subtest psr-1p-offscren-pri-indfb-draw-render: SUCCESS (4.736s) [596.895880] [117/133] (481s left) kms_cursor_crc (cursor-size-change) [596.990758] Starting subtest: cursor-size-change [596.993634] Starting dynamic subtest: pipe-A-eDP-1 [597.906076] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.910s) [597.925396] Starting dynamic subtest: pipe-D-eDP-1 [599.558256] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.652s) [599.560824] Subtest cursor-size-change: SUCCESS (2.567s) [600.448393] [118/133] (477s left) syncobj_wait (invalid-wait-zero-handles) [600.510888] Starting subtest: invalid-wait-zero-handles [600.564012] Subtest invalid-wait-zero-handles: FAIL (0.027s) [600.607550] [119/133] (477s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180) [600.704214] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180 [600.708973] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s) [600.787617] [120/133] (477s left) kms_flip (2x-flip-vs-blocking-wf-vblank) [600.893343] Starting subtest: 2x-flip-vs-blocking-wf-vblank [600.903661] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.013s) [600.979772] [121/133] (477s left) kms_big_fb (linear-32bpp-rotate-180) [601.054671] Starting subtest: linear-32bpp-rotate-180 [602.759061] Subtest linear-32bpp-rotate-180: SUCCESS (1.707s) [602.919377] [122/133] (475s left) gem_ctx_sseu (invalid-args) [602.971834] Subtest invalid-args: SKIP (0.000s) [603.028695] [123/133] (475s left) kms_psr (pr-sprite-blt) [603.094400] Starting subtest: pr-sprite-blt [603.098363] Subtest pr-sprite-blt: SKIP (0.000s) [603.151963] [124/133] (475s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs) [603.254589] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs [603.256646] Starting dynamic subtest: pipe-A-eDP-1 [603.260573] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [603.268680] Starting dynamic subtest: pipe-B-eDP-1 [603.272696] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [603.279105] Starting dynamic subtest: pipe-C-eDP-1 [603.283588] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [603.301159] Starting dynamic subtest: pipe-D-eDP-1 [603.305469] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [603.309515] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.003s) [603.332941] [125/133] (475s left) gem_render_copy (y-tiled-ccs-to-linear) [603.405116] Starting subtest: y-tiled-ccs-to-linear [603.409583] Subtest y-tiled-ccs-to-linear: SKIP (0.000s) [603.588894] [126/133] (475s left) syncobj_timeline (multi-wait-all-available-signaled) [603.664530] Starting subtest: multi-wait-all-available-signaled [603.667364] Subtest multi-wait-all-available-signaled: SUCCESS (0.001s) [603.748712] [127/133] (474s left) perf (sysctl-defaults) [603.874063] Starting subtest: sysctl-defaults [603.877042] Subtest sysctl-defaults: SUCCESS (0.000s) [603.915912] [128/133] (474s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0) [604.024152] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0 [605.177907] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.157s) [605.293381] [129/133] (473s left) gem_mmap_gtt (big-bo-tiledy) [605.357972] Subtest big-bo-tiledY: SKIP (0.000s) [605.413758] [130/133] (473s left) syncobj_timeline (multi-wait-available-submitted-signaled) [605.477696] Starting subtest: multi-wait-available-submitted-signaled [605.480019] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.001s) [605.561532] [131/133] (473s left) gen9_exec_parse (bb-chained) [605.632883] Subtest bb-chained: SKIP (0.000s) [605.674269] [132/133] (473s left) gem_ctx_persistence (legacy-engines-mixed) [605.757357] Starting subtest: legacy-engines-mixed [605.760122] Starting dynamic subtest: render [605.842904] Dynamic subtest render: SUCCESS (0.085s) [605.866110] Starting dynamic subtest: bsd1 [605.901206] Dynamic subtest bsd1: SUCCESS (0.057s) [605.921969] Starting dynamic subtest: bsd2 [605.951933] Dynamic subtest bsd2: SUCCESS (0.047s) [605.972182] Starting dynamic subtest: blt [606.007159] Dynamic subtest blt: SUCCESS (0.053s) [606.025509] Starting dynamic subtest: vebox [606.056904] Dynamic subtest vebox: SUCCESS (0.048s) [606.059346] Subtest legacy-engines-mixed: SUCCESS (0.300s) [606.133880] [133/133] (472s left) syncobj_wait (single-wait-signaled) [606.199834] Starting subtest: single-wait-signaled [606.202214] Subtest single-wait-signaled: SUCCESS (0.000s) [606.278506] Closing watchdogs Done.