[39.565401] Initializing watchdogs [39.565451] /dev/watchdog0 [39.571117] [001/130] (960s left) gem_exec_reloc (basic-write-wc-active) [39.619744] Subtest basic-write-wc-active: SKIP (0.000s) [39.651234] [002/130] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt) [41.634894] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt [44.745081] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (3.109s) [44.884803] [003/130] (955s left) gem_exec_schedule (pi-shared-iova) [45.047844] Starting subtest: pi-shared-iova [45.048725] Starting dynamic subtest: rcs0 [45.198403] Dynamic subtest rcs0: SUCCESS (0.149s) [45.203678] Starting dynamic subtest: bcs0 [45.286098] Dynamic subtest bcs0: SUCCESS (0.091s) [45.291194] Starting dynamic subtest: vcs0 [45.389259] Dynamic subtest vcs0: SUCCESS (0.103s) [45.394255] Starting dynamic subtest: vcs1 [45.497969] Dynamic subtest vcs1: SUCCESS (0.106s) [45.503023] Starting dynamic subtest: vecs0 [45.598077] Dynamic subtest vecs0: SUCCESS (0.103s) [45.598960] Subtest pi-shared-iova: SUCCESS (0.552s) [45.864351] [004/130] (954s left) api_intel_allocator (default-alignment) [45.898917] Starting subtest: default-alignment [45.902862] Subtest default-alignment: SUCCESS (0.004s) [46.026956] [005/130] (954s left) kms_psr (pr-primary-page-flip) [48.041597] Subtest pr-primary-page-flip: SKIP (0.000s) [48.064642] [006/130] (952s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt) [50.040478] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt [50.042377] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [50.125030] [007/130] (950s left) kms_cursor_crc (cursor-random-512x512) [52.373896] Starting subtest: cursor-random-512x512 [52.376263] Subtest cursor-random-512x512: SKIP (0.001s) [52.568395] [008/130] (947s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs) [52.653564] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs [52.654439] Starting dynamic subtest: smem [52.739100] Dynamic subtest smem: SUCCESS (0.086s) [52.744497] Starting dynamic subtest: lmem0 [53.839404] Dynamic subtest lmem0: SUCCESS (1.098s) [53.840356] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SUCCESS (1.184s) [54.047191] [009/130] (946s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite) [56.035018] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite [56.036891] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [56.116135] [010/130] (944s left) gem_mmap_offset (ptrace) [56.225232] Starting subtest: ptrace [56.235105] Starting dynamic subtest: lmem0-fixed [56.353185] Dynamic subtest lmem0-fixed: SUCCESS (0.116s) [56.358384] Starting dynamic subtest: smem0-fixed [56.372901] Dynamic subtest smem0-fixed: SUCCESS (0.020s) [56.373911] Subtest ptrace: SUCCESS (0.150s) [56.479928] [011/130] (943s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render) [58.504227] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render [58.505993] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [58.578269] [012/130] (941s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area) [60.644940] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s) [60.666286] [013/130] (939s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs) [62.639052] Starting subtest: crc-primary-rotation-180-y-tiled-ccs [62.640860] Starting dynamic subtest: pipe-A-HDMI-A-3 [62.649293] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.001s) [62.654625] Starting dynamic subtest: pipe-B-HDMI-A-3 [62.664208] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.001s) [62.669571] Starting dynamic subtest: pipe-C-HDMI-A-3 [62.679818] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.001s) [62.685130] Starting dynamic subtest: pipe-D-HDMI-A-3 [62.695889] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.001s) [62.697971] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.007s) [62.707175] [014/130] (937s left) gem_mmap_gtt (basic-small-bo) [62.748863] Subtest basic-small-bo: SKIP (0.000s) [62.791610] [015/130] (937s left) kms_plane (plane-panning-top-left) [64.821180] Starting subtest: plane-panning-top-left [64.823381] Starting dynamic subtest: pipe-A [65.469697] Dynamic subtest pipe-A: SUCCESS (0.647s) [65.475876] Starting dynamic subtest: pipe-B [65.957617] Dynamic subtest pipe-B: SUCCESS (0.486s) [65.958600] Subtest plane-panning-top-left: SUCCESS (1.136s) [66.085715] [016/130] (934s left) gem_exec_flush (basic-uc-rw-default) [66.140944] Subtest basic-uc-rw-default: SKIP (0.000s) [66.178907] [017/130] (934s left) gen9_exec_parse (allowed-all) [66.216906] Subtest allowed-all: SKIP (0.000s) [66.246603] [018/130] (934s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0) [68.241212] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0 [68.242837] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s) [68.321592] [019/130] (932s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs) [68.453673] Starting subtest: mixed-tiled-to-yf-tiled-ccs [68.455165] Starting dynamic subtest: smem [68.559895] Dynamic subtest smem: SUCCESS (0.102s) [68.565160] Starting dynamic subtest: lmem0 [69.489562] Dynamic subtest lmem0: SUCCESS (0.931s) [69.490509] Subtest mixed-tiled-to-yf-tiled-ccs: SUCCESS (1.034s) [69.703032] [020/130] (930s left) gem_softpin (allocator-evict) [69.741412] Starting subtest: allocator-evict [69.742338] Starting dynamic subtest: rcs0 [95.859099] Dynamic subtest rcs0: SUCCESS (26.119s) [95.864835] Starting dynamic subtest: bcs0 [123.145216] Dynamic subtest bcs0: SUCCESS (27.287s) [123.151094] Starting dynamic subtest: vcs0 [150.261778] Dynamic subtest vcs0: SUCCESS (27.117s) [150.267593] Starting dynamic subtest: vcs1 [177.519725] Dynamic subtest vcs1: SUCCESS (27.258s) [177.525755] Starting dynamic subtest: vecs0 [204.821186] Dynamic subtest vecs0: SUCCESS (27.302s) [204.822132] Subtest allocator-evict: SUCCESS (135.083s) [204.958737] [021/130] (795s left) syncobj_wait (invalid-single-wait-unsubmitted) [205.024920] Starting subtest: invalid-single-wait-unsubmitted [205.025867] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s) [205.074230] [022/130] (795s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-render) [207.060053] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-render [207.061870] Subtest psr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [207.148210] [023/130] (793s left) gem_exec_schedule (u-fairslice) [207.279897] Starting subtest: u-fairslice [207.280845] Starting dynamic subtest: rcs0 [209.311758] Dynamic subtest rcs0: SUCCESS (2.031s) [209.317827] Starting dynamic subtest: bcs0 [211.326840] Dynamic subtest bcs0: SUCCESS (2.015s) [211.333034] Starting dynamic subtest: vcs0 [213.341772] Dynamic subtest vcs0: SUCCESS (2.015s) [213.347596] Starting dynamic subtest: vcs1 [215.356581] Dynamic subtest vcs1: SUCCESS (2.015s) [215.362697] Starting dynamic subtest: vecs0 [217.372922] Dynamic subtest vecs0: SUCCESS (2.016s) [217.373968] Subtest u-fairslice: SUCCESS (10.092s) [217.692023] [024/130] (782s left) syncobj_timeline (multi-wait-for-submit-signaled) [217.727863] Starting subtest: multi-wait-for-submit-signaled [217.728778] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s) [217.801246] [025/130] (782s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move) [219.792453] Starting subtest: fbc-2p-primscrn-cur-indfb-move [219.794323] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s) [219.861816] [026/130] (780s left) sysfs_defaults (readonly) [219.973205] Starting subtest: readonly [219.975043] Starting dynamic subtest: vecs0 [219.976850] Dynamic subtest vecs0: SUCCESS (0.001s) [219.998342] Starting dynamic subtest: vcs0 [220.000210] Dynamic subtest vcs0: SUCCESS (0.001s) [220.015791] Starting dynamic subtest: bcs0 [220.016936] Dynamic subtest bcs0: SUCCESS (0.001s) [220.026130] Starting dynamic subtest: rcs0 [220.027294] Dynamic subtest rcs0: SUCCESS (0.001s) [220.034615] Starting dynamic subtest: vcs1 [220.035778] Dynamic subtest vcs1: SUCCESS (0.001s) [220.036735] Subtest readonly: SUCCESS (0.010s) [220.055784] [027/130] (780s left) syncobj_eventfd (binary-wait-before-signal) [220.091627] Starting subtest: binary-wait-before-signal [220.121473] Subtest binary-wait-before-signal: SUCCESS (0.031s) [220.206583] [028/130] (780s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt) [222.230714] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt [222.232839] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [222.312251] [029/130] (778s left) kms_hdr (invalid-hdr) [224.378068] Starting subtest: invalid-hdr [224.380661] Subtest invalid-hdr: SKIP (0.001s) [224.464906] [030/130] (776s left) kms_chamelium_hpd (hdmi-hpd-storm) [226.584723] Subtest hdmi-hpd-storm: SKIP (0.000s) [226.638989] [031/130] (773s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling) [228.618216] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling [228.620053] Starting dynamic subtest: pipe-A-valid-mode [228.669882] Dynamic subtest pipe-A-valid-mode: SKIP (0.049s) [228.671558] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SKIP (0.050s) [228.758651] [032/130] (771s left) core_setmaster_vs_auth [228.872237] [033/130] (771s left) kms_big_fb (4-tiled-addfb) [230.898916] Starting subtest: 4-tiled-addfb [230.900548] Subtest 4-tiled-addfb: SKIP (0.000s) [230.958508] [034/130] (769s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers) [232.958120] Starting subtest: plane-downscale-factor-0-5-with-modifiers [232.959079] Starting dynamic subtest: pipe-A [233.765913] Dynamic subtest pipe-A: SUCCESS (0.808s) [233.773887] Starting dynamic subtest: pipe-B [234.504540] Dynamic subtest pipe-B: SUCCESS (0.738s) [234.514701] Starting dynamic subtest: pipe-C [235.260293] Dynamic subtest pipe-C: SUCCESS (0.755s) [235.268566] Starting dynamic subtest: pipe-D [236.015516] Dynamic subtest pipe-D: SUCCESS (0.755s) [236.016562] Subtest plane-downscale-factor-0-5-with-modifiers: SUCCESS (3.057s) [236.152603] [035/130] (764s left) gem_exec_fair (basic-none-vip) [236.197491] Subtest basic-none-vip: SKIP (0.000s) [236.230714] [036/130] (764s left) gem_ctx_create (basic-files) [236.281817] Starting subtest: basic-files [238.292049] Subtest basic-files: SUCCESS (2.010s) [238.860669] [037/130] (761s left) kms_psr (fbc-psr-sprite-render) [240.851115] Subtest fbc-psr-sprite-render: SKIP (0.000s) [240.878333] [038/130] (759s left) gem_eio (in-flight-immediate) [241.088511] Starting subtest: in-flight-immediate [245.623576] Subtest in-flight-immediate: SUCCESS (4.536s) [247.637811] [039/130] (753s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary) [249.721433] Starting subtest: fbcpsr-shrfb-scaledprimary [249.723063] Subtest fbcpsr-shrfb-scaledprimary: SKIP (0.000s) [249.807050] [040/130] (750s left) syncobj_wait (multi-wait-submitted-signaled) [249.928974] Starting subtest: multi-wait-submitted-signaled [249.930593] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s) [249.990690] [041/130] (750s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite) [251.991223] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite [251.992954] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [252.072982] [042/130] (748s left) gem_ctx_persistence (engines-hostile-preempt) [252.188280] Starting subtest: engines-hostile-preempt [252.189478] Starting dynamic subtest: rcs0 [252.251197] Dynamic subtest rcs0: SUCCESS (0.063s) [252.258294] Starting dynamic subtest: bcs0 [252.280200] Dynamic subtest bcs0: SUCCESS (0.029s) [252.290934] Starting dynamic subtest: vcs0 [252.310414] Dynamic subtest vcs0: SUCCESS (0.030s) [252.323736] Starting dynamic subtest: vcs1 [252.358755] Dynamic subtest vcs1: SUCCESS (0.048s) [252.377232] Starting dynamic subtest: vecs0 [252.447514] Dynamic subtest vecs0: SUCCESS (0.087s) [252.449630] Subtest engines-hostile-preempt: SUCCESS (0.259s) [252.570995] [043/130] (748s left) gem_exec_reloc (basic-cpu-noreloc) [252.613022] Subtest basic-cpu-noreloc: SKIP (0.000s) [252.663245] [044/130] (748s left) i915_hangman (engine-engine-hang) [252.720790] Starting subtest: engine-engine-hang [252.721639] Starting dynamic subtest: rcs0 [253.421336] Dynamic subtest rcs0: SUCCESS (0.701s) [253.429140] Starting dynamic subtest: bcs0 [254.079321] Dynamic subtest bcs0: SUCCESS (0.658s) [254.085970] Starting dynamic subtest: vcs0 [254.731286] Dynamic subtest vcs0: SUCCESS (0.652s) [254.738832] Starting dynamic subtest: vcs1 [255.405507] Dynamic subtest vcs1: SUCCESS (0.674s) [255.414717] Starting dynamic subtest: vecs0 [256.059316] Dynamic subtest vecs0: SUCCESS (0.654s) [256.060192] Subtest engine-engine-hang: SUCCESS (3.339s) [256.153664] [045/130] (744s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf) [258.143551] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (0.000s) [258.160170] [046/130] (742s left) kms_atomic_transition (plane-all-transition-nonblocking) [260.134416] Starting subtest: plane-all-transition-nonblocking [260.136348] Starting dynamic subtest: pipe-A-HDMI-A-3 [263.939174] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (3.799s) [263.989860] Starting dynamic subtest: pipe-B-HDMI-A-3 [267.803195] Dynamic subtest pipe-B-HDMI-A-3: SUCCESS (3.818s) [267.816869] Subtest plane-all-transition-nonblocking: SUCCESS (7.682s) [267.932268] [047/130] (732s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted) [267.968513] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted [268.080899] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.109s) [268.146428] [048/130] (732s left) kms_flip (2x-flip-vs-panning) [270.131238] Starting subtest: 2x-flip-vs-panning [270.153824] Subtest 2x-flip-vs-panning: SKIP (0.022s) [270.212749] [049/130] (730s left) gem_exec_reloc (basic-wc-noreloc) [270.271020] Subtest basic-wc-noreloc: SKIP (0.000s) [270.350793] [050/130] (730s left) api_intel_bb (lot-of-buffers) [270.412922] Starting subtest: lot-of-buffers [273.113938] Subtest lot-of-buffers: SUCCESS (2.698s) [273.311328] [051/130] (727s left) kms_prop_blob (blob-prop-validate) [273.345349] Starting subtest: blob-prop-validate [273.346224] Subtest blob-prop-validate: SUCCESS (0.000s) [273.430701] [052/130] (727s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff) [275.452931] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff [275.454939] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [275.534331] [053/130] (725s left) kms_frontbuffer_tracking (fbc-tiling-y) [277.602489] Starting subtest: fbc-tiling-y [280.197123] Subtest fbc-tiling-y: SUCCESS (2.593s) [280.329465] [054/130] (720s left) kms_flip (absolute-wf_vblank-interruptible) [282.313852] Starting subtest: absolute-wf_vblank-interruptible [282.321521] Starting dynamic subtest: A-HDMI-A3 [290.349682] Dynamic subtest A-HDMI-A3: SUCCESS (8.028s) [290.357433] Starting dynamic subtest: B-HDMI-A3 [298.156132] Dynamic subtest B-HDMI-A3: SUCCESS (7.806s) [298.163119] Starting dynamic subtest: C-HDMI-A3 [305.963237] Dynamic subtest C-HDMI-A3: SUCCESS (7.807s) [305.970013] Starting dynamic subtest: D-HDMI-A3 [313.769042] Dynamic subtest D-HDMI-A3: SUCCESS (7.805s) [313.770946] Subtest absolute-wf_vblank-interruptible: SUCCESS (31.456s) [313.921943] [055/130] (687s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc) [315.907529] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc [315.909309] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [315.995350] [056/130] (685s left) kms_psr (fbc-psr2-primary-mmap-cpu) [318.058705] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.000s) [318.081958] [057/130] (682s left) gem_mmap_gtt (close-race) [318.122649] Subtest close-race: SKIP (0.000s) [318.151778] [058/130] (682s left) kms_psr (fbc-pr-primary-mmap-cpu) [320.183437] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s) [320.214736] [059/130] (680s left) syncobj_timeline (single-wait-all-signaled) [320.254744] Starting subtest: single-wait-all-signaled [320.255737] Subtest single-wait-all-signaled: SUCCESS (0.000s) [320.345786] [060/130] (680s left) drm_fdinfo (virtual-busy-idle) [320.443338] Starting subtest: virtual-busy-idle [320.445475] Subtest virtual-busy-idle: SKIP (0.000s) [320.509340] [061/130] (680s left) i915_pm_rpm (gem-execbuf-stress) [325.382646] Starting subtest: gem-execbuf-stress [325.383985] Starting dynamic subtest: lmem0 [338.648762] Dynamic subtest lmem0: SUCCESS (13.265s) [338.684655] Starting dynamic subtest: extra-wait-lmem0 [402.277795] Dynamic subtest extra-wait-lmem0: SUCCESS (63.629s) [402.284705] Starting dynamic subtest: smem0 [414.451095] Dynamic subtest smem0: SUCCESS (12.171s) [414.487342] Starting dynamic subtest: extra-wait-smem0 [478.523632] Dynamic subtest extra-wait-smem0: SUCCESS (64.068s) [478.525835] Subtest gem-execbuf-stress: SUCCESS (153.137s) [479.633815] [062/130] (521s left) kms_legacy_colorkey (basic) [481.657168] Starting subtest: basic [481.658046] Starting dynamic subtest: pipe-A [481.748025] Dynamic subtest pipe-A: SUCCESS (0.091s) [481.761436] Starting dynamic subtest: pipe-B [481.762854] Dynamic subtest pipe-B: SUCCESS (0.001s) [481.781401] Starting dynamic subtest: pipe-C [481.783092] Dynamic subtest pipe-C: SUCCESS (0.001s) [481.812916] Starting dynamic subtest: pipe-D [481.815045] Dynamic subtest pipe-D: SUCCESS (0.001s) [481.817066] Subtest basic: SUCCESS (0.096s) [481.879669] [063/130] (519s left) gem_ctx_persistence (saturated-hostile-nopreempt) [481.946211] Starting subtest: saturated-hostile-nopreempt [481.947112] Starting dynamic subtest: rcs0 [482.030540] Dynamic subtest rcs0: SUCCESS (0.084s) [482.051043] Starting dynamic subtest: bcs0 [482.131230] Dynamic subtest bcs0: SUCCESS (0.099s) [482.165328] Starting dynamic subtest: vcs0 [482.235196] Dynamic subtest vcs0: SUCCESS (0.102s) [482.268114] Starting dynamic subtest: vcs1 [482.327220] Dynamic subtest vcs1: SUCCESS (0.091s) [482.353287] Starting dynamic subtest: vecs0 [482.427500] Dynamic subtest vecs0: SUCCESS (0.099s) [482.429090] Subtest saturated-hostile-nopreempt: SUCCESS (0.481s) [482.572637] [064/130] (518s left) gem_ctx_param (invalid-param-get) [482.606570] Starting subtest: invalid-param-get [482.607578] Subtest invalid-param-get: SUCCESS (0.000s) [482.673230] [065/130] (518s left) kms_plane_scaling (2x-scaler-multi-pipe) [484.684961] Starting subtest: 2x-scaler-multi-pipe [484.688566] Subtest 2x-scaler-multi-pipe: SKIP (0.003s) [484.768657] [066/130] (516s left) perf_pmu (most-busy-idle-check-all) [484.899716] Starting subtest: most-busy-idle-check-all [484.901040] Starting dynamic subtest: rcs0 [485.574359] Dynamic subtest rcs0: SUCCESS (0.674s) [485.583855] Starting dynamic subtest: bcs0 [486.225025] Dynamic subtest bcs0: SUCCESS (0.650s) [486.233858] Starting dynamic subtest: vcs0 [486.873031] Dynamic subtest vcs0: SUCCESS (0.648s) [486.881707] Starting dynamic subtest: vcs1 [487.522227] Dynamic subtest vcs1: SUCCESS (0.648s) [487.533221] Starting dynamic subtest: vecs0 [488.175349] Dynamic subtest vecs0: SUCCESS (0.651s) [488.177506] Subtest most-busy-idle-check-all: SUCCESS (3.276s) [488.247588] [067/130] (513s left) gem_flink_basic (flink-lifetime) [488.280761] Starting subtest: flink-lifetime [488.281679] Subtest flink-lifetime: SUCCESS (0.001s) [488.377244] [068/130] (512s left) gem_flink_basic (basic) [488.418245] Starting subtest: basic [488.419135] Subtest basic: SUCCESS (0.000s) [488.517311] [069/130] (512s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format) [490.525277] Starting subtest: plane-upscale-factor-0-25-with-pixel-format [490.526285] Starting dynamic subtest: pipe-A [492.880059] Dynamic subtest pipe-A: SUCCESS (2.354s) [492.889194] Starting dynamic subtest: pipe-B [495.219297] Dynamic subtest pipe-B: SUCCESS (2.339s) [495.228697] Starting dynamic subtest: pipe-C [495.491367] Dynamic subtest pipe-C: SUCCESS (0.271s) [495.505692] Starting dynamic subtest: pipe-D [495.797193] Dynamic subtest pipe-D: SUCCESS (0.305s) [495.798494] Subtest plane-upscale-factor-0-25-with-pixel-format: SUCCESS (5.272s) [495.934605] [070/130] (505s left) api_intel_allocator (reloc-allocator) [495.977386] Starting subtest: reloc-allocator [495.978404] Starting dynamic subtest: basic [495.989139] Dynamic subtest basic: SUCCESS (0.012s) [495.996707] Starting dynamic subtest: parallel-one [495.997696] Dynamic subtest parallel-one: SUCCESS (0.004s) [496.004472] Starting dynamic subtest: print [496.005465] Dynamic subtest print: SUCCESS (0.000s) [496.012395] Starting dynamic subtest: reuse [496.013341] Dynamic subtest reuse: SUCCESS (0.000s) [496.020219] Starting dynamic subtest: fork-reopen-allocator [496.021166] Dynamic subtest fork-reopen-allocator: SUCCESS (0.013s) [496.022137] Subtest reloc-allocator: SUCCESS (0.032s) [496.170559] [071/130] (505s left) gem_exec_whisper (basic-fds-all) [496.237185] Starting subtest: basic-fds-all [502.893779] Subtest basic-fds-all: SUCCESS (6.656s) [503.125696] [072/130] (498s left) sw_sync (sync_random_merge) [503.192041] Starting subtest: sync_random_merge [503.233815] Subtest sync_random_merge: SUCCESS (0.042s) [503.283703] [073/130] (498s left) gem_set_tiling_vs_blt (tiled-to-untiled) [503.325455] Subtest tiled-to-untiled: SKIP (0.000s) [503.347643] [074/130] (498s left) gem_eio (in-flight-suspend) [503.539556] Starting subtest: in-flight-suspend [550.391007] Subtest in-flight-suspend: SUCCESS (14.904s) [557.432297] [075/130] (481s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt) [559.420827] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt [559.422865] Subtest psr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [559.502465] [076/130] (479s left) gem_ctx_param (invalid-ctx-set) [559.612837] Starting subtest: invalid-ctx-set [559.614178] Subtest invalid-ctx-set: SUCCESS (0.001s) [559.686809] [077/130] (478s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip) [561.697044] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip [562.782499] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.082s) [562.920103] [078/130] (475s left) gem_fence_thrash (bo-write-verify-none) [562.951728] Starting subtest: bo-write-verify-none [562.954659] Subtest bo-write-verify-none: SKIP (0.002s) [562.988956] [079/130] (475s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling) [564.972021] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling [564.973972] Starting dynamic subtest: pipe-A-valid-mode [565.802862] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.829s) [565.803730] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SUCCESS (0.831s) [565.931635] [080/130] (472s left) kms_big_fb (linear-64bpp-rotate-270) [567.934783] Starting subtest: linear-64bpp-rotate-270 [567.997516] Subtest linear-64bpp-rotate-270: SKIP (0.062s) [568.156605] [081/130] (470s left) gem_exec_whisper (basic-queues-forked-all) [568.240548] Starting subtest: basic-queues-forked-all [583.161819] Subtest basic-queues-forked-all: SUCCESS (14.917s) [583.358330] [082/130] (455s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs) [585.368970] Starting subtest: ccs-on-another-bo-yf-tiled-ccs [585.370924] Starting dynamic subtest: pipe-A-HDMI-A-3 [585.379296] Dynamic subtest pipe-A-HDMI-A-3: SKIP (0.000s) [585.387582] Starting dynamic subtest: pipe-B-HDMI-A-3 [585.396105] Dynamic subtest pipe-B-HDMI-A-3: SKIP (0.000s) [585.404897] Starting dynamic subtest: pipe-C-HDMI-A-3 [585.414823] Dynamic subtest pipe-C-HDMI-A-3: SKIP (0.000s) [585.424881] Starting dynamic subtest: pipe-D-HDMI-A-3 [585.435355] Dynamic subtest pipe-D-HDMI-A-3: SKIP (0.000s) [585.437584] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.007s) [585.454305] [083/130] (453s left) kms_cursor_crc (cursor-offscreen-128x128) [587.566728] Starting subtest: cursor-offscreen-128x128 [587.572821] Starting dynamic subtest: pipe-A-HDMI-A-3 [590.051656] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (2.478s) [590.079920] Starting dynamic subtest: pipe-D-HDMI-A-3 [592.480499] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (2.408s) [592.481470] Subtest cursor-offscreen-128x128: SUCCESS (4.913s) [592.800591] [084/130] (445s left) kms_feature_discovery (display-1x) [594.783387] Starting subtest: display-1x [594.784276] Subtest display-1x: SUCCESS (0.000s) [594.915886] [085/130] (443s left) gem_exec_fence (syncobj-wait) [595.340939] Starting subtest: syncobj-wait [595.426626] Subtest syncobj-wait: SUCCESS (0.086s) [595.769873] [086/130] (443s left) kms_big_fb (y-tiled-8bpp-rotate-90) [597.777014] Starting subtest: y-tiled-8bpp-rotate-90 [597.859270] Subtest y-tiled-8bpp-rotate-90: SKIP (0.081s) [597.950841] [087/130] (440s left) kms_cursor_edge_walk (256x256-top-bottom) [599.947022] Starting subtest: 256x256-top-bottom [599.949012] Starting dynamic subtest: pipe-A-HDMI-A-3 [603.228951] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (3.279s) [603.238859] Starting dynamic subtest: pipe-D-HDMI-A-3 [606.432146] Dynamic subtest pipe-D-HDMI-A-3: SUCCESS (3.201s) [606.432992] Subtest 256x256-top-bottom: SUCCESS (6.484s) [606.544337] [088/130] (432s left) syncobj_timeline (invalid-signal-one-illegal-handle) [606.580561] Starting subtest: invalid-signal-one-illegal-handle [606.581445] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s) [606.649472] [089/130] (432s left) kms_cursor_crc (cursor-suspend) [608.656457] Starting subtest: cursor-suspend [608.658468] Starting dynamic subtest: pipe-A-HDMI-A-3 [660.820018] Dynamic subtest pipe-A-HDMI-A-3: SUCCESS (15.746s) [660.829943] Starting dynamic subtest: pipe-D-HDMI-A-3