[106.227398] Initializing watchdogs [106.227603] /dev/watchdog0 [106.265870] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600] [106.279947] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [106.287013] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [106.292269] [001/131] (960s left) gem_exec_gttfill (engines) [106.440107] Starting subtest: engines [106.440911] Starting dynamic subtest: rcs0 [134.444383] Dynamic subtest rcs0: SUCCESS (28.002s) [134.462572] Starting dynamic subtest: bcs0 [164.673034] Dynamic subtest bcs0: SUCCESS (30.227s) [164.693415] Starting dynamic subtest: vcs0 [192.063275] Dynamic subtest vcs0: SUCCESS (27.387s) [192.083312] Starting dynamic subtest: vecs0 [219.545661] Dynamic subtest vecs0: SUCCESS (27.479s) [219.547872] Subtest engines: SUCCESS (113.100s) [219.834522] [002/131] (847s left) syncobj_timeline (multi-wait-for-submit-available-submitted) [220.048925] Starting subtest: multi-wait-for-submit-available-submitted [220.050467] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.003s) [220.222692] [003/131] (846s left) syncobj_wait (single-wait-all-for-submit-unsubmitted) [220.322759] Starting subtest: single-wait-all-for-submit-unsubmitted [220.432509] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.108s) [220.593255] [004/131] (846s left) gem_mmap_gtt (hang) [220.687981] Starting subtest: hang [226.131079] Subtest hang: SUCCESS (5.444s) [226.294917] [005/131] (840s left) kms_ccs (random-ccs-data-4-tiled-lnl-ccs) [226.538077] Starting subtest: random-ccs-data-4-tiled-lnl-ccs [226.539581] Subtest random-ccs-data-4-tiled-lnl-ccs: SKIP (0.000s) [227.496515] [006/131] (839s left) gem_basic (create-close) [227.693781] Starting subtest: create-close [227.697983] Subtest create-close: SUCCESS (0.000s) [227.908644] [007/131] (839s left) dumb_buffer (create-clear) [228.023393] Starting subtest: create-clear [262.375486] Subtest create-clear: SUCCESS (34.356s) [262.544319] [008/131] (804s left) kms_chamelium_hpd (dp-hpd-fast) [263.104083] Subtest dp-hpd-fast: SKIP (0.000s) [263.347851] [009/131] (804s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs) [263.530590] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs [263.531458] Starting dynamic subtest: pipe-A-HDMI-A-1 [263.540450] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s) [263.639461] Starting dynamic subtest: pipe-A-HDMI-A-2 [263.676762] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s) [263.694500] Starting dynamic subtest: pipe-B-HDMI-A-1 [263.701718] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s) [263.719000] Starting dynamic subtest: pipe-B-HDMI-A-2 [263.727826] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s) [263.745492] Starting dynamic subtest: pipe-C-HDMI-A-1 [263.754762] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s) [263.772326] Starting dynamic subtest: pipe-C-HDMI-A-2 [263.781335] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s) [263.783276] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SKIP (0.040s) [264.493561] [010/131] (803s left) gem_exec_flush (basic-uc-prw-default) [264.620518] Starting subtest: basic-uc-prw-default [270.040171] Subtest basic-uc-prw-default: SUCCESS (5.417s) [270.331520] [011/131] (797s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0) [270.533834] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0 [270.536851] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.003s) [270.694240] [012/131] (797s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0) [270.895146] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0 [272.588475] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.691s) [272.861125] [013/131] (794s left) gen3_mixed_blits [273.056195] [014/131] (794s left) gem_exec_params (sol-reset-invalid) [273.167829] Starting subtest: sol-reset-invalid [273.170962] Subtest sol-reset-invalid: SUCCESS (0.003s) [273.336306] [015/131] (794s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs) [273.504763] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs [273.511631] Starting dynamic subtest: pipe-A-HDMI-A-1 [273.520228] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.002s) [273.555129] Starting dynamic subtest: pipe-A-HDMI-A-2 [273.563942] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.002s) [273.598289] Starting dynamic subtest: pipe-B-HDMI-A-1 [273.607608] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.002s) [273.640297] Starting dynamic subtest: pipe-B-HDMI-A-2 [273.649385] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.002s) [273.666797] Starting dynamic subtest: pipe-C-HDMI-A-1 [273.674325] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s) [273.692612] Starting dynamic subtest: pipe-C-HDMI-A-2 [273.699733] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.002s) [273.701185] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.028s) [274.452283] [016/131] (793s left) kms_cursor_edge_walk (256x256-right-edge) [274.637430] Starting subtest: 256x256-right-edge [274.642068] Starting dynamic subtest: pipe-A-HDMI-A-1 [278.559731] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.916s) [278.580870] Starting dynamic subtest: pipe-C-HDMI-A-1 [281.988197] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.423s) [281.989331] Subtest 256x256-right-edge: SUCCESS (7.350s) [282.297406] [017/131] (785s left) gem_exec_reloc (basic-write-read-active) [282.410635] Starting subtest: basic-write-read-active [282.548989] Subtest basic-write-read-active: SUCCESS (0.137s) [282.779706] [018/131] (785s left) kms_mmap_write_crc (main) [282.961985] Starting subtest: main [282.965835] Starting dynamic subtest: pipe-A-HDMI-A-1 [286.422814] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.452s) [286.424507] Subtest main: SUCCESS (3.457s) [286.751953] [019/131] (781s left) i915_pm_rps (min-max-config-idle) [286.870928] Starting subtest: min-max-config-idle [287.249444] Subtest min-max-config-idle: SUCCESS (0.381s) [287.402256] [020/131] (780s left) gem_partial_pwrite_pread (writes-after-reads) [287.508666] Starting subtest: writes-after-reads [307.590064] Subtest writes-after-reads: SUCCESS (20.084s) [307.774328] [021/131] (760s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf) [307.966921] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.000s) [308.058803] [022/131] (760s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt) [308.263690] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt [308.265994] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [308.429537] [023/131] (760s left) gem_exec_fence (syncobj-export) [309.063045] Starting subtest: syncobj-export [309.070161] Subtest syncobj-export: SUCCESS (0.008s) [309.496400] [FACT gem_exec_fence (syncobj-export)] new: kernel.kmod_is_loaded.vgem: true [309.500476] [024/131] (759s left) gem_exec_balancer (full-late) [309.620655] Starting subtest: full-late [314.091722] Subtest full-late: SUCCESS (4.469s) [314.394442] [025/131] (754s left) gem_exec_params (invalid-bsd2-flag-on-blt) [314.501768] Starting subtest: invalid-bsd2-flag-on-blt [314.503740] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.001s) [314.679498] [026/131] (754s left) gem_blits (basic) [314.781087] Starting subtest: basic [325.315398] Subtest basic: SUCCESS (10.534s) [325.510097] [027/131] (743s left) perf (invalid-oa-exponent) [325.786578] Starting subtest: invalid-oa-exponent [325.820550] Subtest invalid-oa-exponent: SUCCESS (0.035s) [325.925574] [028/131] (743s left) kms_chamelium_color (ctm-red-to-blue) [326.106592] Subtest ctm-red-to-blue: SKIP (0.000s) [326.203104] [029/131] (742s left) gen9_exec_parse (secure-batches) [326.327519] Starting subtest: secure-batches [326.328640] Subtest secure-batches: SUCCESS (0.000s) [326.636523] [030/131] (742s left) kms_draw_crc (draw-method-mmap-wc) [326.815647] Starting subtest: draw-method-mmap-wc [326.816512] Starting dynamic subtest: xrgb8888-untiled [327.288765] Dynamic subtest xrgb8888-untiled: SUCCESS (0.474s) [327.308872] Starting dynamic subtest: rgb565-untiled [327.521986] Dynamic subtest rgb565-untiled: SUCCESS (0.230s) [327.544354] Starting dynamic subtest: xrgb2101010-untiled [327.770212] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.249s) [327.793354] Starting dynamic subtest: xbgr16161616f-untiled [328.037429] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.265s) [328.057941] Starting dynamic subtest: xrgb8888-xtiled [328.221955] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.183s) [328.242408] Starting dynamic subtest: rgb565-xtiled [328.406770] Dynamic subtest rgb565-xtiled: SUCCESS (0.180s) [328.427288] Starting dynamic subtest: xrgb2101010-xtiled [328.570346] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.164s) [328.592688] Starting dynamic subtest: xbgr16161616f-xtiled [328.737523] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.164s) [328.758052] Starting dynamic subtest: xrgb8888-ytiled [328.921062] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.182s) [328.943544] Starting dynamic subtest: rgb565-ytiled [329.108923] Dynamic subtest rgb565-ytiled: SUCCESS (0.179s) [329.129171] Starting dynamic subtest: xrgb2101010-ytiled [329.270901] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.164s) [329.292089] Starting dynamic subtest: xbgr16161616f-ytiled [329.436935] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.165s) [329.437888] Subtest draw-method-mmap-wc: SUCCESS (2.626s) [329.705432] [031/131] (739s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation) [329.891623] Starting subtest: plane-downscale-factor-0-75-with-rotation [329.892508] Starting dynamic subtest: pipe-A [334.172803] Dynamic subtest pipe-A: SKIP (4.278s) [334.193775] Starting dynamic subtest: pipe-B [338.440363] Dynamic subtest pipe-B: SKIP (4.266s) [338.481261] Starting dynamic subtest: pipe-C [342.732458] Dynamic subtest pipe-C: SKIP (4.286s) [342.734460] Subtest plane-downscale-factor-0-75-with-rotation: SKIP (12.839s) [343.263121] [032/131] (726s left) kms_cursor_legacy (flip-vs-cursor-varying-size) [343.517164] Starting subtest: flip-vs-cursor-varying-size [367.346287] Subtest flip-vs-cursor-varying-size: SUCCESS (23.825s) [367.670770] [033/131] (701s left) kms_async_flips (crc) [367.856648] Starting subtest: crc [368.461198] Starting dynamic subtest: pipe-A-HDMI-A-1 [370.734940] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.273s) [371.102385] Starting dynamic subtest: pipe-A-HDMI-A-2 [373.344219] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.258s) [373.717245] Starting dynamic subtest: pipe-B-HDMI-A-1 [375.952175] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.255s) [376.298556] Starting dynamic subtest: pipe-B-HDMI-A-2 [378.527989] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.253s) [378.877422] Starting dynamic subtest: pipe-C-HDMI-A-1 [381.090538] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.235s) [381.445052] Starting dynamic subtest: pipe-C-HDMI-A-2 [383.679536] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.260s) [383.685778] Subtest crc: SUCCESS (15.829s) [384.345350] [034/131] (685s left) kms_concurrent (multi-plane-atomic-lowres) [384.532535] Starting subtest: multi-plane-atomic-lowres [384.533369] Starting dynamic subtest: pipe-A-HDMI-A-1 [385.613337] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.078s) [385.645295] Starting dynamic subtest: pipe-A-HDMI-A-2 [386.339685] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.718s) [386.340777] Subtest multi-plane-atomic-lowres: SUCCESS (1.809s) [386.669551] [035/131] (683s left) i915_suspend (basic-s3-without-i915) [386.771984] Starting subtest: basic-s3-without-i915 [408.197372] Subtest basic-s3-without-i915: SUCCESS (6.410s) [413.392403] [036/131] (661s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [413.610153] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [413.617085] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.003s) [413.789136] [037/131] (661s left) kms_cursor_legacy (cursora-vs-flipa-varying-size) [413.997851] Starting subtest: cursorA-vs-flipA-varying-size [425.467916] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.321s) [425.807809] [038/131] (649s left) syncobj_timeline (invalid-signal-zero-handles) [425.918919] Starting subtest: invalid-signal-zero-handles [425.920067] Subtest invalid-signal-zero-handles: SUCCESS (0.000s) [426.108790] [039/131] (649s left) syncobj_wait (multi-wait-for-submit-submitted) [426.216154] Starting subtest: multi-wait-for-submit-submitted [426.320952] Subtest multi-wait-for-submit-submitted: SUCCESS (0.103s) [426.499679] [040/131] (648s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling) [426.675729] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling [426.676544] Starting dynamic subtest: pipe-A-valid-mode [427.678785] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.994s) [427.680384] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (1.000s) [428.030337] [041/131] (647s left) sriov_basic (bind-unbind-vf) [428.133673] Subtest bind-unbind-vf: SKIP (0.000s) [428.245609] [042/131] (647s left) i915_drm_fdinfo (memory-info-active) [428.365494] Starting subtest: memory-info-active [428.372474] Starting dynamic subtest: smem0 [429.558840] Dynamic subtest smem0: SUCCESS (1.187s) [429.565446] Subtest memory-info-active: SUCCESS (1.191s) [429.743549] [043/131] (645s left) perf_pmu (render-node-busy) [429.863375] Starting subtest: render-node-busy [429.864285] Starting dynamic subtest: rcs0 [430.395270] Dynamic subtest rcs0: SUCCESS (0.529s) [430.422194] Starting dynamic subtest: bcs0 [430.930776] Dynamic subtest bcs0: SUCCESS (0.530s) [430.954973] Starting dynamic subtest: vcs0 [431.468102] Dynamic subtest vcs0: SUCCESS (0.531s) [431.493123] Starting dynamic subtest: vecs0 [432.007090] Dynamic subtest vecs0: SUCCESS (0.533s) [432.010996] Subtest render-node-busy: SUCCESS (2.140s) [432.176951] [044/131] (643s left) kms_pm_dc (dc3co-vpb-simulation) [433.370399] Starting subtest: dc3co-vpb-simulation [433.372519] Subtest dc3co-vpb-simulation: SKIP (0.000s) [433.546725] [045/131] (642s left) gem_render_copy_redux (normal) [433.661189] Starting subtest: normal [434.993312] Subtest normal: SUCCESS (1.328s) [435.193190] [046/131] (640s left) kms_rotation_crc (sprite-rotation-180) [435.366703] Starting subtest: sprite-rotation-180 [446.543512] Subtest sprite-rotation-180: SUCCESS (11.170s) [446.837071] [047/131] (629s left) gem_eio (in-flight-1us) [446.978461] Starting subtest: in-flight-1us [448.009789] Subtest in-flight-1us: SUCCESS (1.029s) [448.286399] [048/131] (627s left) gem_exec_schedule (implicit-boths) [448.418880] Starting subtest: implicit-boths [448.423732] Starting dynamic subtest: rcs0 [448.546358] Dynamic subtest rcs0: SUCCESS (0.123s) [448.579643] Starting dynamic subtest: bcs0 [448.684585] Dynamic subtest bcs0: SUCCESS (0.131s) [448.716036] Starting dynamic subtest: vcs0 [448.815244] Dynamic subtest vcs0: SUCCESS (0.125s) [448.848253] Starting dynamic subtest: vecs0 [448.949885] Dynamic subtest vecs0: SUCCESS (0.127s) [448.956665] Subtest implicit-boths: SUCCESS (0.531s) [449.393828] [049/131] (626s left) sysfs_heartbeat_interval (invalid) [449.502490] Starting subtest: invalid [449.507028] Starting dynamic subtest: vecs0 [449.507901] Dynamic subtest vecs0: SUCCESS (0.001s) [449.539794] Starting dynamic subtest: vcs0 [449.540963] Dynamic subtest vcs0: SUCCESS (0.001s) [449.570105] Starting dynamic subtest: bcs0 [449.571403] Dynamic subtest bcs0: SUCCESS (0.001s) [449.606170] Starting dynamic subtest: rcs0 [449.607499] Dynamic subtest rcs0: SUCCESS (0.001s) [449.608506] Subtest invalid: SUCCESS (0.024s) [449.707987] [050/131] (626s left) gem_spin_batch (legacy) [449.831349] Starting subtest: legacy [449.832286] Starting dynamic subtest: default [453.159549] Dynamic subtest default: SUCCESS (3.327s) [453.185758] Starting dynamic subtest: render [456.497255] Dynamic subtest render: SUCCESS (3.328s) [456.520218] Starting dynamic subtest: bsd [459.730997] Dynamic subtest bsd: SUCCESS (3.229s) [459.754104] Starting dynamic subtest: bsd1 [463.063233] Dynamic subtest bsd1: SUCCESS (3.327s) [463.086654] Starting dynamic subtest: blt [466.295542] Dynamic subtest blt: SUCCESS (3.227s) [466.319540] Starting dynamic subtest: vebox [469.527488] Dynamic subtest vebox: SUCCESS (3.227s) [469.528546] Subtest legacy: SUCCESS (19.691s) [469.837646] [051/131] (606s left) gem_ctx_create (basic-files) [469.966880] Starting subtest: basic-files [471.997470] Subtest basic-files: SUCCESS (2.030s) [472.319446] [052/131] (604s left) kms_rotation_crc (primary-x-tiled-reflect-x-180) [472.499279] Starting subtest: primary-x-tiled-reflect-x-180 [472.508774] Subtest primary-x-tiled-reflect-x-180: SKIP (0.003s) [472.679730] [053/131] (603s left) gem_reg_read (bad-register) [472.786159] Starting subtest: bad-register [472.788809] Subtest bad-register: SUCCESS (0.000s) [472.964697] [054/131] (603s left) kms_psr (fbc-pr-no-drrs) [473.146709] Subtest fbc-pr-no-drrs: SKIP (0.000s) [473.258678] [055/131] (603s left) gem_pxp (create-regular-context-2) [475.908618] Starting subtest: create-regular-context-2 [475.911760] Subtest create-regular-context-2: SKIP (0.000s) [476.081961] [056/131] (600s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled) [476.200864] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled [476.203098] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s) [476.481740] [057/131] (600s left) gem_render_copy (linear-to-vebox-yf-tiled) [476.597612] Starting subtest: linear-to-vebox-yf-tiled [476.599478] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s) [476.883911] [058/131] (600s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move) [477.101004] Starting subtest: psr-2p-scndscrn-spr-indfb-move [477.103506] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [477.298163] [059/131] (599s left) gem_ctx_param (set-priority-invalid-size) [477.404412] Starting subtest: set-priority-invalid-size [477.407041] Subtest set-priority-invalid-size: SUCCESS (0.000s) [477.597360] [060/131] (599s left) kms_rotation_crc (primary-rotation-270) [477.773345] Starting subtest: primary-rotation-270 [493.376910] Subtest primary-rotation-270: SUCCESS (15.604s) [493.672539] [061/131] (583s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw) [493.876783] Starting subtest: fbcpsr-1p-pri-indfb-multidraw [493.878670] Subtest fbcpsr-1p-pri-indfb-multidraw: SKIP (0.000s) [494.070644] [062/131] (583s left) kms_big_fb (x-tiled-64bpp-rotate-90) [494.267849] Starting subtest: x-tiled-64bpp-rotate-90 [494.580347] Subtest x-tiled-64bpp-rotate-90: SKIP (0.312s) [494.856136] [063/131] (582s left) api_intel_bb (bb-with-allocator) [494.967275] Starting subtest: bb-with-allocator [494.980681] Subtest bb-with-allocator: SUCCESS (0.012s) [495.171554] [064/131] (582s left) gem_wait (wait) [495.302639] Starting subtest: wait [495.304009] Starting dynamic subtest: all-engines [496.337427] Dynamic subtest all-engines: SUCCESS (1.032s) [496.364589] Starting dynamic subtest: rcs0 [497.372667] Dynamic subtest rcs0: SUCCESS (1.031s) [497.399121] Starting dynamic subtest: bcs0 [498.408692] Dynamic subtest bcs0: SUCCESS (1.031s) [498.436092] Starting dynamic subtest: vcs0 [499.447558] Dynamic subtest vcs0: SUCCESS (1.034s) [499.473644] Starting dynamic subtest: vecs0 [500.477999] Dynamic subtest vecs0: SUCCESS (1.025s) [500.480806] Subtest wait: SUCCESS (5.174s) [500.811338] [065/131] (576s left) kms_pm_rpm (pm-caching) [502.695058] Starting subtest: pm-caching [504.155063] Subtest pm-caching: SUCCESS (1.459s) [504.585433] [066/131] (573s left) kms_plane_scaling (invalid-parameters) [504.797728] Starting subtest: invalid-parameters [504.799514] Starting dynamic subtest: less-than-1-height-src [504.849563] Dynamic subtest less-than-1-height-src: SUCCESS (0.050s) [504.894803] Starting dynamic subtest: less-than-1-width-src [504.904824] Dynamic subtest less-than-1-width-src: SUCCESS (0.051s) [504.905770] Subtest invalid-parameters: SUCCESS (0.107s) [505.084764] [067/131] (572s left) gem_mmap_gtt (pf-nonblock) [505.191183] Starting subtest: pf-nonblock [505.198893] Subtest pf-nonblock: SUCCESS (0.008s) [505.384678] [068/131] (572s left) gem_exec_schedule (submit-golden-slice) [505.524883] Starting subtest: submit-golden-slice [505.531376] Starting dynamic subtest: rcs0 [505.574445] Dynamic subtest rcs0: SUCCESS (0.047s) [505.604884] Starting dynamic subtest: bcs0 [505.624150] Dynamic subtest bcs0: SUCCESS (0.045s) [505.656756] Starting dynamic subtest: vcs0 [505.674523] Dynamic subtest vcs0: SUCCESS (0.045s) [505.706787] Starting dynamic subtest: vecs0 [505.729077] Dynamic subtest vecs0: SUCCESS (0.046s) [505.732553] Subtest submit-golden-slice: SUCCESS (0.207s) [506.175491] [069/131] (571s left) gem_ctx_exec (basic-nohangcheck) [506.279284] Starting subtest: basic-nohangcheck [506.541012] Subtest basic-nohangcheck: SUCCESS (0.265s) [506.736625] [070/131] (571s left) kms_vrr (flip-basic-fastset) [506.913503] Starting subtest: flip-basic-fastset [506.916634] Subtest flip-basic-fastset: SKIP (0.000s) [507.083436] [071/131] (571s left) gem_exec_balancer (parallel-out-fence) [507.318020] Subtest parallel-out-fence: SKIP (0.000s) [507.508074] [072/131] (570s left) kms_cursor_crc (cursor-rapid-movement-32x32) [507.688763] Starting subtest: cursor-rapid-movement-32x32 [507.853005] Subtest cursor-rapid-movement-32x32: SKIP (0.163s) [508.050455] [073/131] (570s left) kms_async_flips (test-time-stamp-atomic) [508.239113] Starting subtest: test-time-stamp-atomic [508.851547] Starting dynamic subtest: pipe-A-HDMI-A-1 [509.054271] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.202s) [509.426248] Starting dynamic subtest: pipe-A-HDMI-A-2 [509.592366] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.191s) [509.961556] Starting dynamic subtest: pipe-B-HDMI-A-1 [510.152588] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.214s) [510.486016] Starting dynamic subtest: pipe-B-HDMI-A-2 [510.677398] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.212s) [511.012863] Starting dynamic subtest: pipe-C-HDMI-A-1 [511.204385] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.214s) [511.541664] Starting dynamic subtest: pipe-C-HDMI-A-2 [511.738271] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.218s) [511.741534] Subtest test-time-stamp-atomic: SUCCESS (3.500s) [512.403903] [074/131] (566s left) kms_plane_cursor (primary) [512.590443] Starting subtest: primary [512.594749] Starting dynamic subtest: pipe-A-HDMI-A-1-size-64 [515.194615] Dynamic subtest pipe-A-HDMI-A-1-size-64: SUCCESS (2.605s) [515.270246] Starting dynamic subtest: pipe-A-HDMI-A-1-size-128 [517.677165] Dynamic subtest pipe-A-HDMI-A-1-size-128: SUCCESS (2.431s) [517.753657] Starting dynamic subtest: pipe-A-HDMI-A-1-size-256 [520.162443] Dynamic subtest pipe-A-HDMI-A-1-size-256: SUCCESS (2.431s) [520.478757] Starting dynamic subtest: pipe-B-HDMI-A-2-size-64 [522.924276] Dynamic subtest pipe-B-HDMI-A-2-size-64: SUCCESS (2.507s) [522.983765] Starting dynamic subtest: pipe-B-HDMI-A-2-size-128 [525.390972] Dynamic subtest pipe-B-HDMI-A-2-size-128: SUCCESS (2.432s) [525.449062] Starting dynamic subtest: pipe-B-HDMI-A-2-size-256 [527.857390] Dynamic subtest pipe-B-HDMI-A-2-size-256: SUCCESS (2.432s) [528.153642] Starting dynamic subtest: pipe-C-HDMI-A-1-size-64 [530.616187] Dynamic subtest pipe-C-HDMI-A-1-size-64: SUCCESS (2.518s) [530.675045] Starting dynamic subtest: pipe-C-HDMI-A-1-size-128 [533.081893] Dynamic subtest pipe-C-HDMI-A-1-size-128: SUCCESS (2.430s) [533.142368] Starting dynamic subtest: pipe-C-HDMI-A-1-size-256 [535.532316] Dynamic subtest pipe-C-HDMI-A-1-size-256: SUCCESS (2.414s) [535.771585] Subtest primary: SUCCESS (23.188s) [536.086307] [075/131] (542s left) gem_softpin (noreloc) [536.206431] Starting subtest: noreloc [541.718645] Subtest noreloc: SUCCESS (5.500s) [541.906058] [076/131] (536s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt) [542.125887] Starting subtest: fbcpsr-farfromfence-mmap-gtt [542.131603] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s) [542.319791] [077/131] (536s left) gem_lmem_evict (dontneed-evict-race) [542.437507] Subtest dontneed-evict-race: SKIP (0.000s) [542.554729] [078/131] (536s left) gem_userptr_blits (dmabuf-unsync) [542.667066] Subtest dmabuf-unsync: SKIP (0.000s) [542.889349] [079/131] (536s left) i915_hangman (gt-engine-hang) [543.019376] Starting subtest: gt-engine-hang [543.020810] Starting dynamic subtest: rcs0 [543.602413] Dynamic subtest rcs0: SUCCESS (0.585s) [543.631492] Starting dynamic subtest: bcs0 [544.190174] Dynamic subtest bcs0: SUCCESS (0.583s) [544.219485] Starting dynamic subtest: vcs0 [544.770292] Dynamic subtest vcs0: SUCCESS (0.576s) [544.799186] Starting dynamic subtest: vecs0 [545.350859] Dynamic subtest vecs0: SUCCESS (0.576s) [545.355173] Subtest gt-engine-hang: SUCCESS (2.339s) [545.555630] [080/131] (533s left) kms_psr (psr2-primary-render) [545.730931] Subtest psr2-primary-render: SKIP (0.000s) [545.850034] [081/131] (533s left) gem_shrink (reclaim) [545.966838] Starting subtest: reclaim [548.181956] Subtest reclaim: SUCCESS (2.217s) [548.380020] [082/131] (530s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling) [548.563769] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-upscaling [548.564621] Starting dynamic subtest: pipe-A-valid-mode [548.956768] Dynamic subtest pipe-A-valid-mode: SKIP (0.390s) [548.958345] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.396s) [549.292693] [083/131] (530s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen) [549.486413] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen [551.521406] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (2.031s) [551.827306] [084/131] (527s left) gem_exec_suspend (basic-s3) [551.950354] Starting subtest: basic-S3 [551.954440] Starting dynamic subtest: smem