[51.884337] Initializing watchdogs
[51.884400]   /dev/watchdog0
[51.901205] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics]
[51.907190] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[51.909885] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[51.911859] [001/131] (960s left) syncobj_wait (single-wait-all-for-submit-submitted)
[51.947366] Starting subtest: single-wait-all-for-submit-submitted
[52.054667] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.107s)
[52.143959] [002/131] (960s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75)
[52.229531] Starting subtest: planes-upscale-20x20-downscale-factor-0-75
[52.230233] Starting dynamic subtest: pipe-A
[52.357873] Dynamic subtest pipe-A: SUCCESS (0.129s)
[52.368138] Starting dynamic subtest: pipe-B
[52.482961] Dynamic subtest pipe-B: SUCCESS (0.125s)
[52.488250] Starting dynamic subtest: pipe-C
[52.607806] Dynamic subtest pipe-C: SUCCESS (0.124s)
[52.613223] Starting dynamic subtest: pipe-D
[52.749752] Dynamic subtest pipe-D: SUCCESS (0.142s)
[52.750502] Subtest planes-upscale-20x20-downscale-factor-0-75: SUCCESS (0.521s)
[52.960593] [003/131] (959s left) kms_psr (pr-suspend)
[53.046331] Subtest pr-suspend: SKIP (0.000s)
[53.080296] [004/131] (959s left) gem_ctx_shared (q-out-order)
[53.123685] Starting subtest: Q-out-order
[53.124416] Starting dynamic subtest: rcs0
[53.196915] Dynamic subtest rcs0: SUCCESS (0.073s)
[53.206529] Starting dynamic subtest: bcs0
[53.247179] Dynamic subtest bcs0: SUCCESS (0.050s)
[53.257576] Starting dynamic subtest: vcs0
[53.297334] Dynamic subtest vcs0: SUCCESS (0.049s)
[53.310050] Starting dynamic subtest: vcs1
[53.354902] Dynamic subtest vcs1: SUCCESS (0.057s)
[53.364583] Starting dynamic subtest: vecs0
[53.406206] Dynamic subtest vecs0: SUCCESS (0.050s)
[53.407323] Subtest Q-out-order: SUCCESS (0.283s)
[53.608672] [FACT gem_ctx_shared (q-out-order)] new: kernel.kmod_is_loaded.vgem: true
[53.610248] [005/131] (958s left) api_intel_bb (reset-bb)
[53.642400] Starting subtest: reset-bb
[53.644436] Subtest reset-bb: SUCCESS (0.003s)
[53.788640] [006/131] (958s left) syncobj_basic (test-valid-cycle)
[53.820718] Starting subtest: test-valid-cycle
[53.821425] Subtest test-valid-cycle: SUCCESS (0.000s)
[53.908526] [007/131] (958s left) gem_userptr_blits (map-fixed-invalidate-busy)
[53.950705] Starting subtest: map-fixed-invalidate-busy
[53.951422] Starting dynamic subtest: gtt
[55.476717] Dynamic subtest gtt: SUCCESS (1.517s)
[55.483017] Starting dynamic subtest: wb
[56.966228] Dynamic subtest wb: SUCCESS (1.489s)
[56.972237] Starting dynamic subtest: wc
[58.450557] Dynamic subtest wc: SUCCESS (1.484s)
[58.456420] Starting dynamic subtest: uc
[59.939670] Dynamic subtest uc: SUCCESS (1.489s)
[59.940388] Subtest map-fixed-invalidate-busy: SUCCESS (5.981s)
[60.068510] [008/131] (952s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite)
[60.159480] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite
[60.160851] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[60.258750] [009/131] (952s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[60.294190] Starting subtest: writes-after-reads
[61.252744] Subtest writes-after-reads: SUCCESS (0.959s)
[61.404104] [010/131] (951s left) prime_vgem (fence-read-hang)
[61.473583] Subtest fence-read-hang: SKIP (0.000s)
[61.595450] [011/131] (951s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[61.685616] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[61.728963] [012/131] (951s left) gem_exec_params (no-bsd)
[61.765864] Starting subtest: no-bsd
[61.767394] Subtest no-bsd: SUCCESS (0.001s)
[61.904569] [013/131] (950s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[61.986771] Starting subtest: plane-scaler-unity-scaling-with-rotation
[61.987493] Starting dynamic subtest: pipe-A
[63.006742] Dynamic subtest pipe-A: SKIP (1.019s)
[63.015062] Starting dynamic subtest: pipe-B
[64.083679] Dynamic subtest pipe-B: SKIP (1.076s)
[64.089745] Starting dynamic subtest: pipe-C
[65.202605] Dynamic subtest pipe-C: SKIP (1.118s)
[65.208495] Starting dynamic subtest: pipe-D
[66.327557] Dynamic subtest pipe-D: SKIP (1.124s)
[66.328932] Subtest plane-scaler-unity-scaling-with-rotation: SKIP (4.340s)
[66.510472] [014/131] (946s left) kms_flip (modeset-vs-vblank-race)
[66.606484] Starting subtest: modeset-vs-vblank-race
[66.608757] Starting dynamic subtest: A-HDMI-A1
[69.497288] Dynamic subtest A-HDMI-A1: SUCCESS (2.888s)
[69.504726] Starting dynamic subtest: B-HDMI-A1
[72.296088] Dynamic subtest B-HDMI-A1: SUCCESS (2.797s)
[72.303741] Starting dynamic subtest: C-HDMI-A1
[75.124164] Dynamic subtest C-HDMI-A1: SUCCESS (2.827s)
[75.131391] Starting dynamic subtest: D-HDMI-A1
[77.969358] Dynamic subtest D-HDMI-A1: SUCCESS (2.844s)
[77.972197] Subtest modeset-vs-vblank-race: SUCCESS (11.366s)
[78.163150] [015/131] (934s left) kms_feature_discovery (dp-mst)
[78.258428] Starting subtest: dp-mst
[78.259742] Subtest dp-mst: SKIP (0.000s)
[78.338817] [016/131] (934s left) gen7_exec_parse (batch-without-end)
[78.372947] Subtest batch-without-end: SKIP (0.000s)
[78.417137] [017/131] (934s left) kms_psr (fbc-pr-primary-blt)
[78.500571] Subtest fbc-pr-primary-blt: SKIP (0.000s)
[78.542663] [018/131] (934s left) gem_ctx_persistence (legacy-engines-queued)
[78.578503] Starting subtest: legacy-engines-queued
[78.579246] Starting dynamic subtest: render
[78.637738] Dynamic subtest render: SUCCESS (0.058s)
[78.654633] Starting dynamic subtest: bsd1
[78.700574] Dynamic subtest bsd1: SUCCESS (0.060s)
[78.718736] Starting dynamic subtest: bsd2
[78.764586] Dynamic subtest bsd2: SUCCESS (0.061s)
[78.781410] Starting dynamic subtest: blt
[78.825715] Dynamic subtest blt: SUCCESS (0.058s)
[78.842635] Starting dynamic subtest: vebox
[78.885491] Dynamic subtest vebox: SUCCESS (0.057s)
[78.889570] Subtest legacy-engines-queued: SUCCESS (0.308s)
[78.977442] [019/131] (934s left) gem_eio (in-flight-internal-10ms)
[79.018935] Starting subtest: in-flight-internal-10ms
[79.293326] Subtest in-flight-internal-10ms: SUCCESS (0.273s)
[79.433466] [020/131] (933s left) kms_cdclk (mode-transition-all-outputs)
[79.465916] Subtest mode-transition-all-outputs: SKIP (0.000s)
[79.510507] [021/131] (933s left) syncobj_timeline (32bits-limit)
[79.543159] Starting subtest: 32bits-limit
[79.544943] Subtest 32bits-limit: SUCCESS (0.001s)
[79.634633] [022/131] (933s left) gem_exec_reloc (basic-scanout)
[79.721924] Starting subtest: basic-scanout
[79.722645] Starting dynamic subtest: rcs0
[79.879683] Dynamic subtest rcs0: SUCCESS (0.157s)
[79.892580] Starting dynamic subtest: bcs0
[80.004408] Dynamic subtest bcs0: SUCCESS (0.123s)
[80.014424] Starting dynamic subtest: vcs0
[80.121463] Dynamic subtest vcs0: SUCCESS (0.115s)
[80.131924] Starting dynamic subtest: vcs1
[80.254852] Dynamic subtest vcs1: SUCCESS (0.131s)
[80.267613] Starting dynamic subtest: vecs0
[80.379647] Dynamic subtest vecs0: SUCCESS (0.122s)
[80.380501] Subtest basic-scanout: SUCCESS (0.659s)
[80.528508] [023/131] (932s left) kms_cursor_crc (cursor-onscreen-256x256)
[80.618498] Starting subtest: cursor-onscreen-256x256
[80.623053] Starting dynamic subtest: pipe-A-HDMI-A-1
[81.805108] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.181s)
[81.843286] Starting dynamic subtest: pipe-D-HDMI-A-1
[82.967587] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.131s)
[82.968342] Subtest cursor-onscreen-256x256: SUCCESS (2.350s)
[83.120085] [024/131] (930s left) gem_eio (hibernate)
[83.161729] Starting subtest: hibernate
[96.405843] Subtest hibernate: SUCCESS (13.243s)
[105.583013] [025/131] (916s left) kms_psr (fbc-psr-primary-blt)
[105.679601] Subtest fbc-psr-primary-blt: SKIP (0.000s)
[105.724765] [026/131] (916s left) kms_vblank (query-forked)
[105.809014] Starting subtest: query-forked
[105.810796] Starting dynamic subtest: pipe-A-HDMI-A-1
[107.032733] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.222s)
[107.051969] Starting dynamic subtest: pipe-D-HDMI-A-1
[108.267776] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.224s)
[108.268475] Subtest query-forked: SUCCESS (2.459s)
[108.421963] [027/131] (914s left) gem_exec_balancer (bonded-dual)
[108.465214] Starting subtest: bonded-dual
[141.140892] Subtest bonded-dual: SUCCESS (32.668s)
[141.343732] [028/131] (881s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[141.428864] Starting subtest: cursorA-vs-flipA-atomic
[152.281301] Subtest cursorA-vs-flipA-atomic: SUCCESS (10.853s)
[152.435253] [029/131] (870s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[152.526785] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (0.000s)
[152.562139] [030/131] (870s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[152.594862] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[152.702722] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.107s)
[152.797559] [031/131] (869s left) kms_psr (psr2-sprite-plane-move)
[152.881653] Subtest psr2-sprite-plane-move: SKIP (0.000s)
[152.920735] [032/131] (869s left) i915_pciid
[153.035242] [033/131] (869s left) perf_pmu (busy-idle-check-all)
[153.069192] Starting subtest: busy-idle-check-all
[153.069892] Starting dynamic subtest: rcs0
[153.691528] Dynamic subtest rcs0: SUCCESS (0.621s)
[153.702823] Starting dynamic subtest: bcs0
[154.319170] Dynamic subtest bcs0: SUCCESS (0.626s)
[154.331018] Starting dynamic subtest: vcs0
[154.949188] Dynamic subtest vcs0: SUCCESS (0.627s)
[154.960703] Starting dynamic subtest: vcs1
[155.579123] Dynamic subtest vcs1: SUCCESS (0.628s)
[155.590724] Starting dynamic subtest: vecs0
[156.210310] Dynamic subtest vecs0: SUCCESS (0.629s)
[156.213305] Subtest busy-idle-check-all: SUCCESS (3.142s)
[156.300348] [034/131] (866s left) gem_exec_fence (syncobj-invalid-flags)
[156.639653] Starting subtest: syncobj-invalid-flags
[156.640388] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[156.965855] [035/131] (865s left) gem_pxp (create-valid-protected-context)
[157.066239] Starting subtest: create-valid-protected-context
[157.067215] Subtest create-valid-protected-context: SUCCESS (0.001s)
[157.157119] [036/131] (865s left) gem_create (create-clear)
[157.188957] Starting subtest: create-clear
[157.190662] Starting dynamic subtest: smem0
[189.802976] Dynamic subtest smem0: SUCCESS (32.613s)
[189.803764] Subtest create-clear: SUCCESS (32.614s)
[190.012887] [037/131] (832s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[190.100630] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[199.103232] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (9.003s)
[199.258866] [038/131] (823s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[199.351877] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[199.353343] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[199.477022] [039/131] (823s left) kms_big_fb (yf-tiled-16bpp-rotate-0)
[199.573247] Starting subtest: yf-tiled-16bpp-rotate-0
[199.574585] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s)
[199.685357] [040/131] (823s left) gem_mmap_gtt (medium-copy-xy)
[199.718127] Starting subtest: medium-copy-XY
[205.025955] Subtest medium-copy-XY: SUCCESS (5.308s)
[205.114665] [041/131] (817s left) gem_mmap_gtt (basic-read-write)
[205.187727] Starting subtest: basic-read-write
[205.189429] Subtest basic-read-write: SUCCESS (0.003s)
[205.302973] [042/131] (817s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[205.393444] Starting subtest: addfb25-framebuffer-vs-set-tiling
[205.394206] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[205.510481] [043/131] (817s left) kms_cursor_legacy (torture-bo)
[205.598167] Starting subtest: torture-bo
[205.598874] Starting dynamic subtest: pipe-A
[211.133065] Dynamic subtest pipe-A: SUCCESS (5.498s)
[211.155628] Starting dynamic subtest: pipe-B
[216.734308] Dynamic subtest pipe-B: SUCCESS (5.601s)
[216.753249] Starting dynamic subtest: pipe-C
[222.238341] Dynamic subtest pipe-C: SUCCESS (5.503s)
[222.248163] Starting dynamic subtest: pipe-D
[227.728126] Dynamic subtest pipe-D: SUCCESS (5.488s)
[227.739715] Starting dynamic subtest: all-pipes
[233.216956] Dynamic subtest all-pipes: SUCCESS (5.487s)
[233.217876] Subtest torture-bo: SUCCESS (27.584s)
[233.295792] [044/131] (789s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[233.394803] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[233.982058] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.587s)
[234.138026] [045/131] (789s left) gem_exec_fence (basic-await)
[234.299128] Starting subtest: basic-await
[234.300191] Starting dynamic subtest: rcs0
[234.377596] Dynamic subtest rcs0: SUCCESS (0.077s)
[234.396952] Starting dynamic subtest: bcs0
[234.461979] Dynamic subtest bcs0: SUCCESS (0.082s)
[234.480691] Starting dynamic subtest: vcs0
[234.553914] Dynamic subtest vcs0: SUCCESS (0.082s)
[234.567550] Starting dynamic subtest: vcs1
[234.630651] Dynamic subtest vcs1: SUCCESS (0.082s)
[234.649546] Starting dynamic subtest: vecs0
[234.716506] Dynamic subtest vecs0: SUCCESS (0.083s)
[234.717596] Subtest basic-await: SUCCESS (0.419s)
[235.194465] [046/131] (788s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[235.284976] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[235.286314] Subtest psr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[235.399413] [047/131] (787s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[235.489836] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[235.491211] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[235.608068] [048/131] (787s left) kms_plane_multiple (2x-tiling-y)
[235.694280] Starting subtest: 2x-tiling-y
[235.695685] Subtest 2x-tiling-y: SKIP (0.000s)
[235.773758] [049/131] (787s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[235.814034] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[235.918647] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.104s)
[236.015918] [050/131] (787s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[236.111476] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[236.112803] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[236.235202] [051/131] (787s left) i915_drm_fdinfo (memory-info-shared)
[236.269987] Starting subtest: memory-info-shared
[236.270718] Starting dynamic subtest: smem0
[236.321583] Dynamic subtest smem0: SUCCESS (0.051s)
[236.322256] Subtest memory-info-shared: SUCCESS (0.052s)
[236.415781] [052/131] (787s left) kms_content_protection (dp-mst-lic-type-1)
[236.505756] Starting subtest: dp-mst-lic-type-1
[236.507095] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[236.632326] [053/131] (786s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[236.722337] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[236.723759] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[236.840700] [054/131] (786s left) gem_exec_whisper (basic-queues-priority-all)
[236.881334] Starting subtest: basic-queues-priority-all
[239.778412] Subtest basic-queues-priority-all: SUCCESS (2.896s)
[239.984294] [055/131] (783s left) prime_mmap_coherency (read)
[240.019945] Starting subtest: read
[245.438229] Subtest read: SUCCESS (5.381s)
[245.528508] [056/131] (778s left) kms_draw_crc (fill-fb)
[245.617199] Starting subtest: fill-fb
[245.833441] Subtest fill-fb: SUCCESS (0.217s)
[245.959787] [057/131] (777s left) kms_cursor_crc (cursor-random-512x512)
[246.049724] Starting subtest: cursor-random-512x512
[246.051061] Subtest cursor-random-512x512: SKIP (0.001s)
[246.168534] [058/131] (777s left) perf_pmu (semaphore-wait-idle)
[246.204397] Starting subtest: semaphore-wait-idle
[246.205104] Starting dynamic subtest: rcs0
[246.722464] Dynamic subtest rcs0: SUCCESS (0.509s)
[246.733912] Starting dynamic subtest: bcs0
[247.234339] Dynamic subtest bcs0: SUCCESS (0.510s)
[247.247822] Starting dynamic subtest: vcs0
[247.747049] Dynamic subtest vcs0: SUCCESS (0.511s)
[247.758383] Starting dynamic subtest: vcs1
[248.259366] Dynamic subtest vcs1: SUCCESS (0.510s)
[248.270911] Starting dynamic subtest: vecs0
[248.771201] Dynamic subtest vecs0: SUCCESS (0.510s)
[248.771934] Subtest semaphore-wait-idle: SUCCESS (2.559s)
[248.882407] [059/131] (774s left) sysfs_heartbeat_interval (invalid)
[248.919822] Starting subtest: invalid
[248.921617] Starting dynamic subtest: vecs0
[248.922296] Dynamic subtest vecs0: SUCCESS (0.000s)
[248.930952] Starting dynamic subtest: vcs0
[248.931665] Dynamic subtest vcs0: SUCCESS (0.000s)
[248.940538] Starting dynamic subtest: bcs0
[248.941223] Dynamic subtest bcs0: SUCCESS (0.000s)
[248.949254] Starting dynamic subtest: rcs0
[248.949943] Dynamic subtest rcs0: SUCCESS (0.000s)
[248.957810] Starting dynamic subtest: vcs1
[248.958493] Dynamic subtest vcs1: SUCCESS (0.001s)
[248.959187] Subtest invalid: SUCCESS (0.011s)
[249.041649] [060/131] (774s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[249.128937] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[249.130715] Starting dynamic subtest: pipe-A-HDMI-A-1
[249.796968] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.663s)
[249.813478] Starting dynamic subtest: pipe-B-HDMI-A-1
[250.323862] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.522s)
[250.343439] Starting dynamic subtest: pipe-C-HDMI-A-1
[250.865400] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.536s)
[250.882191] Starting dynamic subtest: pipe-D-HDMI-A-1
[251.391702] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.521s)
[251.392888] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SUCCESS (2.260s)
[251.598811] [061/131] (772s left) kms_big_fb (x-tiled-32bpp-rotate-180)
[251.699703] Starting subtest: x-tiled-32bpp-rotate-180
[252.905039] Subtest x-tiled-32bpp-rotate-180: SUCCESS (1.205s)
[253.055624] [062/131] (770s left) syncobj_timeline (multi-wait-all-signaled)
[253.088561] Starting subtest: multi-wait-all-signaled
[253.089243] Subtest multi-wait-all-signaled: SUCCESS (0.001s)
[253.177627] [063/131] (770s left) gem_ringfill (legacy-basic)
[253.405522] Starting subtest: legacy-basic
[253.408625] Starting dynamic subtest: default
[253.435838] Dynamic subtest default: SUCCESS (0.029s)
[253.455949] Starting dynamic subtest: render
[253.460920] Dynamic subtest render: SUCCESS (0.022s)
[253.471429] Starting dynamic subtest: bsd
[253.477894] Dynamic subtest bsd: SUCCESS (0.016s)
[253.488558] Starting dynamic subtest: bsd1
[253.493911] Dynamic subtest bsd1: SUCCESS (0.015s)
[253.504528] Starting dynamic subtest: bsd2
[253.512875] Dynamic subtest bsd2: SUCCESS (0.018s)
[253.522641] Starting dynamic subtest: blt
[253.533999] Dynamic subtest blt: SUCCESS (0.020s)
[253.544965] Starting dynamic subtest: vebox
[253.554095] Dynamic subtest vebox: SUCCESS (0.018s)
[253.554833] Subtest legacy-basic: SUCCESS (0.149s)
[253.641237] [064/131] (770s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[253.738133] Starting subtest: y-tiled-8bpp-rotate-0
[254.730373] Subtest y-tiled-8bpp-rotate-0: SUCCESS (0.992s)
[254.881585] [065/131] (769s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[254.969444] Starting subtest: primary-yf-tiled-reflect-x-270
[255.022692] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.052s)
[255.130229] [066/131] (769s left) i915_pm_rps (min-max-config-loaded)
[255.170218] Starting subtest: min-max-config-loaded
[255.497601] Subtest min-max-config-loaded: SUCCESS (0.323s)
[255.631290] [067/131] (768s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[255.719453] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[255.720830] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[255.831258] [068/131] (768s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[255.915031] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[255.915724] Starting dynamic subtest: pipe-A-HDMI-A-1
[255.922122] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[255.930771] Starting dynamic subtest: pipe-B-HDMI-A-1
[255.937314] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[255.945845] Starting dynamic subtest: pipe-C-HDMI-A-1
[255.952295] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[255.960590] Starting dynamic subtest: pipe-D-HDMI-A-1
[255.967215] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[255.968515] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.009s)
[256.176972] [069/131] (768s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[256.262042] Starting subtest: cursor-vs-flip-atomic
[285.803218] Subtest cursor-vs-flip-atomic: SUCCESS (29.540s)
[285.952115] [070/131] (738s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[286.043728] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[286.045143] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[286.165537] [071/131] (738s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode)
[286.302079] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s)
[286.404129] [072/131] (738s left) kms_pm_rpm (fences)
[287.804436] Starting subtest: fences
[292.568177] Subtest fences: SUCCESS (4.756s)
[292.662533] [073/131] (731s left) syncobj_timeline (wait-all-complex)
[292.696954] Starting subtest: wait-all-complex
[292.911298] Subtest wait-all-complex: SUCCESS (0.214s)
[293.003128] [074/131] (731s left) kms_big_fb (yf-tiled-addfb)
[293.099554] Starting subtest: yf-tiled-addfb
[293.100878] Subtest yf-tiled-addfb: SKIP (0.000s)
[293.225433] [075/131] (731s left) gem_exec_schedule (preempt-contexts)
[293.270292] Starting subtest: preempt-contexts
[293.270990] Starting dynamic subtest: rcs0
[293.310197] Dynamic subtest rcs0: SUCCESS (0.039s)
[293.321597] Starting dynamic subtest: bcs0
[293.352696] Dynamic subtest bcs0: SUCCESS (0.041s)
[293.363392] Starting dynamic subtest: vcs0
[293.397186] Dynamic subtest vcs0: SUCCESS (0.042s)
[293.408313] Starting dynamic subtest: vcs1
[293.437036] Dynamic subtest vcs1: SUCCESS (0.039s)
[293.447817] Starting dynamic subtest: vecs0
[293.480697] Dynamic subtest vecs0: SUCCESS (0.042s)
[293.483093] Subtest preempt-contexts: SUCCESS (0.212s)
[293.812127] [076/131] (730s left) kms_getfb (getfb-handle-valid)
[293.897060] Starting subtest: getfb-handle-valid
[293.897766] Subtest getfb-handle-valid: SUCCESS (0.000s)
[294.017838] [077/131] (730s left) sw_sync (sync_merge)
[294.050207] Starting subtest: sync_merge
[294.050905] Subtest sync_merge: SUCCESS (0.000s)
[294.133529] [078/131] (730s left) i915_selftest (live)
[295.130760] Starting subtest: live
[295.131732] Starting dynamic subtest: sanitycheck
[296.399721] Dynamic subtest sanitycheck: SUCCESS (1.259s)
[296.411530] Starting dynamic subtest: uncore
[297.613729] Dynamic subtest uncore: SUCCESS (1.212s)
[297.630011] Starting dynamic subtest: workarounds
[299.207784] Dynamic subtest workarounds: SUCCESS (1.592s)
[299.217416] Starting dynamic subtest: gt_engines
[301.021606] Dynamic subtest gt_engines: SUCCESS (1.812s)
[301.030803] Starting dynamic subtest: gt_timelines
[309.516459] Dynamic subtest gt_timelines: SUCCESS (8.492s)
[309.531958] Starting dynamic subtest: gt_contexts
[310.878518] Dynamic subtest gt_contexts: SUCCESS (1.360s)
[310.885332] Starting dynamic subtest: gt_lrc
[315.103463] Dynamic subtest gt_lrc: SUCCESS (4.223s)
[315.110427] Starting dynamic subtest: gt_mocs
[316.483430] Dynamic subtest gt_mocs: SUCCESS (1.378s)
[316.490381] Starting dynamic subtest: gt_pm
[338.001815] Dynamic subtest gt_pm: SUCCESS (21.516s)
[338.013811] Starting dynamic subtest: gt_heartbeat
[339.275713] Dynamic subtest gt_heartbeat: SUCCESS (1.271s)
[339.285786] Starting dynamic subtest: gt_tlb
[342.792501] Dynamic subtest gt_tlb: SUCCESS (3.514s)
[342.799383] Starting dynamic subtest: requests
[351.432526] Dynamic subtest requests: SUCCESS (8.638s)
[351.442449] Starting dynamic subtest: migrate
[355.901498] Dynamic subtest migrate: SUCCESS (4.467s)
[355.910905] Starting dynamic subtest: active
[357.177665] Dynamic subtest active: SUCCESS (1.274s)
[357.187993] Starting dynamic subtest: objects
[358.886782] Dynamic subtest objects: SUCCESS (1.706s)
[358.896088] Starting dynamic subtest: mman
[363.627764] Dynamic subtest mman: SUCCESS (4.739s)
[363.637721] Starting dynamic subtest: dmabuf
[364.873572] Dynamic subtest dmabuf: SUCCESS (1.243s)
[364.884138] Starting dynamic subtest: vma
[366.105659] Dynamic subtest vma: SUCCESS (1.230s)
[366.120273] Starting dynamic subtest: coherency
[368.909667] Dynamic subtest coherency: SUCCESS (2.802s)
[368.919170] Starting dynamic subtest: gtt
[377.849630] Dynamic subtest gtt: SUCCESS (8.937s)
[377.859254] Starting dynamic subtest: gem
[380.054509] Dynamic subtest gem: SUCCESS (2.203s)
[380.064054] Starting dynamic subtest: evict
[382.275669] Dynamic subtest evict: SUCCESS (2.219s)
[382.284193] Starting dynamic subtest: hugepages
[390.189592] Dynamic subtest hugepages: SUCCESS (7.912s)
[390.199111] Starting dynamic subtest: gem_contexts
[405.680273] Dynamic subtest gem_contexts: SUCCESS (15.489s)
[405.687151] Starting dynamic subtest: client
[406.998611] Dynamic subtest client: SUCCESS (1.316s)
[407.007956] Starting dynamic subtest: gem_migrate
[408.203455] Dynamic subtest gem_migrate: SUCCESS (1.203s)
[408.213495] Starting dynamic subtest: reset
[413.159601] Dynamic subtest reset: SUCCESS (4.954s)
[413.176333] Starting dynamic subtest: memory_region
[414.406607] Dynamic subtest memory_region: SUCCESS (1.245s)
[414.416414] Starting dynamic subtest: hangcheck
[444.457420] Dynamic subtest hangcheck: SUCCESS (30.049s)
[444.464351] Starting dynamic subtest: execlists
[458.481542] Dynamic subtest execlists: SUCCESS (14.022s)
[458.490927] Starting dynamic subtest: ring_submission
[459.698618] Dynamic subtest ring_submission: SUCCESS (1.215s)
[459.707643] Starting dynamic subtest: perf
[461.043609] Dynamic subtest perf: SUCCESS (1.343s)
[461.054082] Starting dynamic subtest: slpc
[462.278660] Dynamic subtest slpc: SUCCESS (1.233s)
[462.287869] Starting dynamic subtest: guc
[463.511623] Dynamic subtest guc: SUCCESS (1.231s)
[463.523446] Starting dynamic subtest: guc_multi_lrc
[464.718663] Dynamic subtest guc_multi_lrc: SUCCESS (1.205s)
[464.728630] Starting dynamic subtest: guc_hang
[465.959750] Dynamic subtest guc_hang: SUCCESS (1.239s)
[465.969849] Starting dynamic subtest: late_gt_pm
[467.270515] Dynamic subtest late_gt_pm: SUCCESS (1.309s)
[467.271530] Subtest live: SUCCESS (172.133s)
[467.303510] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[467.304298] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[467.306629] [079/131] (557s left) prime_busy (after-wait)
[468.363298] Starting subtest: after-wait
[468.368300] Starting dynamic subtest: rcs0
[468.407151] Dynamic subtest rcs0: SUCCESS (0.039s)
[468.418061] Starting dynamic subtest: bcs0
[468.424738] Dynamic subtest bcs0: SUCCESS (0.016s)
[468.436141] Starting dynamic subtest: vcs0
[468.439972] Dynamic subtest vcs0: SUCCESS (0.014s)
[468.448915] Starting dynamic subtest: vcs1
[468.458075] Dynamic subtest vcs1: SUCCESS (0.017s)
[468.467198] Starting dynamic subtest: vecs0
[468.474090] Dynamic subtest vecs0: SUCCESS (0.015s)
[468.583492] Subtest after-wait: SUCCESS (0.219s)
[468.636834] [FACT prime_busy (after-wait)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[468.638147] [FACT prime_busy (after-wait)] new: kernel.kmod_is_loaded.i915: true
[468.640385] [080/131] (556s left) gem_exec_alignment (single)
[468.677769] Starting subtest: single
[468.680591] Subtest single: SUCCESS (0.003s)
[468.828376] [081/131] (555s left) gem_exec_schedule (semaphore-codependency)
[468.872779] Starting subtest: semaphore-codependency
[468.880446] Subtest semaphore-codependency: SUCCESS (0.009s)
[469.204282] [082/131] (555s left) gem_exec_reloc (basic-cpu-read-active)
[469.241275] Starting subtest: basic-cpu-read-active
[469.363411] Subtest basic-cpu-read-active: SUCCESS (0.122s)
[469.578416] [083/131] (555s left) kms_getfb (getfb2-accept-nv12)
[469.665283] Starting subtest: getfb2-accept-nv12
[469.666156] Subtest getfb2-accept-nv12: SUCCESS (0.002s)
[469.793892] [084/131] (555s left) prime_vgem (basic-fence-read)
[469.870576] Starting subtest: basic-fence-read
[469.912840] Subtest basic-fence-read: SUCCESS (0.042s)
[470.045434] [085/131] (554s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[470.130977] Starting subtest: modeset-transition-nonblocking-fencing
[470.131758] Starting dynamic subtest: 1x-outputs
[471.338967] Dynamic subtest 1x-outputs: SUCCESS (1.207s)
[471.340385] Subtest modeset-transition-nonblocking-fencing: SUCCESS (1.209s)
[471.503847] [086/131] (553s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-render)
[471.594139] Starting subtest: psr-2p-primscrn-spr-indfb-draw-render
[471.595551] Subtest psr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[471.704449] [087/131] (553s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[471.793356] Starting subtest: fbc-1p-pri-indfb-multidraw
[480.523702] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (8.731s)
[480.690890] [088/131] (544s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[480.783710] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[480.785061] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[480.908087] [089/131] (544s left) gem_eio (banned)
[480.950957] Starting subtest: banned
[481.358472] Subtest banned: SUCCESS (0.409s)
[481.501014] [090/131] (543s left) gem_exec_whisper (basic-fds-priority)
[481.542495] Starting subtest: basic-fds-priority
[484.904907] Subtest basic-fds-priority: SUCCESS (3.353s)
[485.104806] [091/131] (540s left) kms_lease (simple-lease)
[485.192871] Starting subtest: simple-lease
[485.193578] Starting dynamic subtest: pipe-A-HDMI-A-1
[485.413915] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.220s)
[485.425809] Starting dynamic subtest: pipe-B-HDMI-A-1
[485.604831] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.189s)
[485.638351] Starting dynamic subtest: pipe-C-HDMI-A-1
[485.797687] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.191s)
[485.814103] Starting dynamic subtest: pipe-D-HDMI-A-1
[486.000664] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.202s)
[486.001400] Subtest simple-lease: SUCCESS (0.809s)
[486.134076] [092/131] (539s left) kms_addfb_basic (basic-y-tiled-legacy)
[486.168842] Starting subtest: basic-y-tiled-legacy
[486.169609] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[486.336579] [093/131] (539s left) kms_prime (basic-crc-hybrid)
[486.432791] Subtest basic-crc-hybrid: SKIP (0.000s)
[486.535646] [094/131] (538s left) i915_query (query-topology-kernel-writes)
[486.569140] Starting subtest: query-topology-kernel-writes
[486.569826] Subtest query-topology-kernel-writes: SUCCESS (0.000s)
[486.662021] [095/131] (538s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[486.751803] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[487.870643] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (1.120s)
[488.023449] [096/131] (537s left) vgem_basic (dmabuf-fence-before)
[488.062135] Starting subtest: dmabuf-fence-before
[488.062859] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[488.144057] [097/131] (537s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[488.232679] Starting subtest: primary-4-tiled-reflect-x-0
[488.287939] Subtest primary-4-tiled-reflect-x-0: SKIP (0.055s)
[488.395518] [098/131] (537s left) dumb_buffer (map-valid)
[488.429150] Starting subtest: map-valid
[488.429840] Subtest map-valid: SUCCESS (0.000s)
[488.534803] [099/131] (537s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[488.628140] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[488.629472] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[488.747504] [100/131] (536s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[488.833121] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[488.833797] Starting dynamic subtest: pipe-A-HDMI-A-1
[488.850678] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.002s)
[488.860128] Starting dynamic subtest: pipe-B-HDMI-A-1
[488.877213] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.002s)
[488.885953] Starting dynamic subtest: pipe-C-HDMI-A-1
[488.903164] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s)
[488.912337] Starting dynamic subtest: pipe-D-HDMI-A-1
[488.929445] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.002s)
[488.930801] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.014s)
[489.096760] [101/131] (536s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[489.183761] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[489.185137] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[489.297548] [102/131] (536s left) gem_mmap_gtt (basic-small-bo-tiledx)
[489.329577] Starting subtest: basic-small-bo-tiledX
[489.517649] Subtest basic-small-bo-tiledX: SUCCESS (0.188s)
[489.645924] [103/131] (536s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[489.788033] Starting subtest: 4-tiled-64bpp-rotate-270
[489.789380] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.000s)
[489.889058] [104/131] (535s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[489.978765] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[489.980092] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[490.088685] [105/131] (535s left) kms_invalid_mode (bad-hsync-start)
[490.174668] Starting subtest: bad-hsync-start
[490.175354] Starting dynamic subtest: pipe-A-HDMI-A-1
[490.231947] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.056s)
[490.244969] Starting dynamic subtest: pipe-B-HDMI-A-1
[490.245726] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[490.254472] Starting dynamic subtest: pipe-C-HDMI-A-1
[490.255147] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[490.263605] Starting dynamic subtest: pipe-D-HDMI-A-1
[490.264275] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[490.264926] Subtest bad-hsync-start: SUCCESS (0.069s)
[490.403877] [106/131] (535s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted)
[490.444954] Starting subtest: multi-wait-for-submit-unsubmitted-submitted
[490.550853] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.105s)
[490.649981] [107/131] (535s left) dmabuf_sync_file (export-before-signal)
[490.689423] Starting subtest: export-before-signal
[490.691318] Subtest export-before-signal: SUCCESS (0.001s)
[490.765879] [108/131] (535s left) gem_set_tiling_vs_gtt
[491.234119] [109/131] (534s left) kms_flip (flip-vs-blocking-wf-vblank)
[491.322674] Starting subtest: flip-vs-blocking-wf-vblank
[491.324422] Starting dynamic subtest: A-HDMI-A1
[499.184341] Dynamic subtest A-HDMI-A1: SUCCESS (7.838s)
[499.192958] Starting dynamic subtest: B-HDMI-A1
[506.977771] Dynamic subtest B-HDMI-A1: SUCCESS (7.784s)
[506.989978] Starting dynamic subtest: C-HDMI-A1
[514.765918] Dynamic subtest C-HDMI-A1: SUCCESS (7.787s)
[514.776127] Starting dynamic subtest: D-HDMI-A1
[522.531753] Dynamic subtest D-HDMI-A1: SUCCESS (7.787s)
[522.532470] Subtest flip-vs-blocking-wf-vblank: SUCCESS (31.208s)
[522.701793] [110/131] (503s left) gem_ctx_bad_destroy (invalid-default-ctx)
[522.734979] Starting subtest: invalid-default-ctx
[522.735691] Subtest invalid-default-ctx: SUCCESS (0.000s)
[522.826770] [111/131] (503s left) gem_ctx_isolation (nonpriv-switch)
[522.868958] Starting subtest: nonpriv-switch
[522.869690] Starting dynamic subtest: rcs0
[523.136084] Dynamic subtest rcs0: SUCCESS (0.259s)
[523.145134] Starting dynamic subtest: bcs0
[523.434755] Dynamic subtest bcs0: SUCCESS (0.297s)
[523.443727] Starting dynamic subtest: vcs0
[523.727622] Dynamic subtest vcs0: SUCCESS (0.292s)
[523.736205] Starting dynamic subtest: vcs1
[524.053139] Dynamic subtest vcs1: SUCCESS (0.325s)
[524.061744] Starting dynamic subtest: vecs0
[524.362158] Dynamic subtest vecs0: SUCCESS (0.308s)
[524.362861] Subtest nonpriv-switch: SUCCESS (1.486s)
[524.555953] [112/131] (501s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[524.649716] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[525.836075] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (1.186s)
[525.978805] [113/131] (500s left) syncobj_timeline (single-wait-all-available-signaled)
[526.012887] Starting subtest: single-wait-all-available-signaled
[526.013600] Subtest single-wait-all-available-signaled: SUCCESS (0.000s)
[526.101491] [114/131] (500s left) kms_chamelium_frames (dp-frame-dump)
[526.244245] Subtest dp-frame-dump: SKIP (0.000s)
[526.330618] [115/131] (499s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[526.419110] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[526.420751] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s)
[526.539424] [116/131] (499s left) gem_lmem_swapping (parallel-random-verify-ccs)
[526.575784] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[526.622664] [117/131] (499s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[526.706886] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[526.708654] Starting dynamic subtest: pipe-A-valid-mode
[527.545783] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.837s)
[527.546501] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (0.839s)
[527.705237] [118/131] (498s left) kms_addfb_basic (bad-pitch-256)
[527.738990] Starting subtest: bad-pitch-256
[527.739692] Subtest bad-pitch-256: SUCCESS (0.000s)
[527.923345] [119/131] (498s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[528.008015] Starting subtest: 2x-long-cursor-vs-flip-atomic
[528.010038] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.002s)
[528.087623] [120/131] (498s left) gem_softpin (zero)
[528.124421] Starting subtest: zero
[528.127261] Subtest zero: SUCCESS (0.003s)
[528.265709] [121/131] (498s left) kms_flip (2x-flip-vs-panning-vs-hang)
[528.351616] Starting subtest: 2x-flip-vs-panning-vs-hang
[528.360466] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.009s)
[528.453125] [122/131] (498s left) kms_psr (fbc-psr2-dpms)
[528.538696] Subtest fbc-psr2-dpms: SKIP (0.000s)
[528.579813] [123/131] (498s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[528.668776] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[528.670076] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[528.789899] [124/131] (497s left) gem_pxp (fail-invalid-protected-context)
[528.824941] Starting subtest: fail-invalid-protected-context
[528.825619] Subtest fail-invalid-protected-context: SUCCESS (0.000s)
[528.914991] [125/131] (497s left) kms_vblank (wait-idle-hang)
[529.001178] Starting subtest: wait-idle-hang
[529.002157] Starting dynamic subtest: pipe-A-HDMI-A-1
[542.867143] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (13.864s)
[542.878638] Starting dynamic subtest: pipe-D-HDMI-A-1
[556.674021] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (13.804s)
[556.674748] Subtest wait-idle-hang: SUCCESS (27.674s)
[556.881447] [126/131] (469s left) kms_cursor_crc (cursor-sliding-32x32)
[556.970909] Starting subtest: cursor-sliding-32x32
[557.023132] Subtest cursor-sliding-32x32: SKIP (0.050s)
[557.141770] [127/131] (469s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[557.225932] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs
[557.227706] Starting dynamic subtest: pipe-A-HDMI-A-1
[557.364998] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.134s)
[557.374296] Starting dynamic subtest: pipe-B-HDMI-A-1
[557.458557] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.092s)
[557.467662] Starting dynamic subtest: pipe-C-HDMI-A-1
[557.551934] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.092s)
[557.560853] Starting dynamic subtest: pipe-D-HDMI-A-1
[557.645759] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.092s)
[557.646409] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SUCCESS (0.417s)
[557.934378] [128/131] (468s left) gem_mmap_gtt (isolation)
[557.967205] Starting subtest: isolation
[557.970433] Subtest isolation: SUCCESS (0.001s)
[558.090754] [129/131] (468s left) kms_draw_crc (draw-method-pwrite)
[558.174964] Starting subtest: draw-method-pwrite
[558.175722] Starting dynamic subtest: xrgb8888-untiled
[558.330795] Dynamic subtest xrgb8888-untiled: SUCCESS (0.155s)
[558.349204] Starting dynamic subtest: rgb565-untiled
[558.489256] Dynamic subtest rgb565-untiled: SUCCESS (0.156s)
[558.508850] Starting dynamic subtest: xrgb2101010-untiled
[558.639113] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.147s)
[558.656374] Starting dynamic subtest: xbgr16161616f-untiled
[558.780741] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.139s)
[558.798657] Starting dynamic subtest: xrgb8888-xtiled
[558.897570] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.114s)
[558.915362] Starting dynamic subtest: rgb565-xtiled
[559.022510] Dynamic subtest rgb565-xtiled: SUCCESS (0.123s)
[559.040358] Starting dynamic subtest: xrgb2101010-xtiled
[559.130753] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.106s)
[559.147388] Starting dynamic subtest: xbgr16161616f-xtiled
[559.247377] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.114s)
[559.263946] Starting dynamic subtest: xrgb8888-ytiled
[559.405955] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.156s)
[559.424960] Starting dynamic subtest: rgb565-ytiled
[559.564534] Dynamic subtest rgb565-ytiled: SUCCESS (0.156s)
[559.582114] Starting dynamic subtest: xrgb2101010-ytiled
[559.714234] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.147s)
[559.730412] Starting dynamic subtest: xbgr16161616f-ytiled
[559.872708] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.156s)
[559.875868] Subtest draw-method-pwrite: SUCCESS (1.699s)
[560.007863] [130/131] (466s left) kms_lease (lease-again)
[560.095104] Starting subtest: lease-again
[560.096976] Starting dynamic subtest: pipe-A-HDMI-A-1
[560.097697] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s)
[560.109963] Starting dynamic subtest: pipe-B-HDMI-A-1
[560.110742] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.002s)
[560.121142] Starting dynamic subtest: pipe-C-HDMI-A-1
[560.121837] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[560.131049] Starting dynamic subtest: pipe-D-HDMI-A-1
[560.131749] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[560.132443] Subtest lease-again: SUCCESS (0.014s)
[560.184230] [131/131] (466s left) gem_userptr_blits (set-cache-level)
[560.220831] Starting subtest: set-cache-level
[560.221508] Subtest set-cache-level: SUCCESS (0.000s)
[560.347642] Closing watchdogs
results: parsing output: 0/ for test: syncobj_wait
results: parsing output: 1/ for test: kms_plane_scaling
results: parsing output: 2/ for test: kms_psr
results: parsing output: 3/ for test: gem_ctx_shared
results: parsing output: 4/ for test: api_intel_bb
results: parsing output: 5/ for test: syncobj_basic
results: parsing output: 6/ for test: gem_userptr_blits
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 9/ for test: prime_vgem
results: parsing output: 10/ for test: kms_psr2_sf
results: parsing output: 11/ for test: gem_exec_params
results: parsing output: 12/ for test: kms_plane_scaling
results: parsing output: 13/ for test: kms_flip
results: parsing output: 14/ for test: kms_feature_discovery
results: parsing output: 15/ for test: gen7_exec_parse
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: gem_ctx_persistence
results: parsing output: 18/ for test: gem_eio
results: parsing output: 19/ for test: kms_cdclk
results: parsing output: 20/ for test: syncobj_timeline
results: parsing output: 21/ for test: gem_exec_reloc
results: parsing output: 22/ for test: kms_cursor_crc
results: parsing output: 23/ for test: gem_eio
results: parsing output: 24/ for test: kms_psr
results: parsing output: 25/ for test: kms_vblank
results: parsing output: 26/ for test: gem_exec_balancer
results: parsing output: 27/ for test: kms_cursor_legacy
results: parsing output: 28/ for test: kms_psr2_sf
results: parsing output: 29/ for test: syncobj_wait
results: parsing output: 30/ for test: kms_psr
results: parsing output: 31/ for test: i915_pciid
results: parsing output: 32/ for test: perf_pmu
results: parsing output: 33/ for test: gem_exec_fence
results: parsing output: 34/ for test: gem_pxp
results: parsing output: 35/ for test: gem_create
results: parsing output: 36/ for test: kms_cursor_legacy
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_big_fb
results: parsing output: 39/ for test: gem_mmap_gtt
results: parsing output: 40/ for test: gem_mmap_gtt
results: parsing output: 41/ for test: kms_addfb_basic
results: parsing output: 42/ for test: kms_cursor_legacy
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: gem_exec_fence
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_plane_multiple
results: parsing output: 48/ for test: syncobj_timeline
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: i915_drm_fdinfo
results: parsing output: 51/ for test: kms_content_protection
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: gem_exec_whisper
results: parsing output: 54/ for test: prime_mmap_coherency
results: parsing output: 55/ for test: kms_draw_crc
results: parsing output: 56/ for test: kms_cursor_crc
results: parsing output: 57/ for test: perf_pmu
results: parsing output: 58/ for test: sysfs_heartbeat_interval
results: parsing output: 59/ for test: kms_ccs
results: parsing output: 60/ for test: kms_big_fb
results: parsing output: 61/ for test: syncobj_timeline
results: parsing output: 62/ for test: gem_ringfill
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: kms_rotation_crc
results: parsing output: 65/ for test: i915_pm_rps
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_ccs
results: parsing output: 68/ for test: kms_cursor_legacy
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_chamelium_hpd
results: parsing output: 71/ for test: kms_pm_rpm
results: parsing output: 72/ for test: syncobj_timeline
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: gem_exec_schedule
results: parsing output: 75/ for test: kms_getfb
results: parsing output: 76/ for test: sw_sync
results: parsing output: 77/ for test: i915_selftest
results: parsing output: 78/ for test: prime_busy
results: parsing output: 79/ for test: gem_exec_alignment
results: parsing output: 80/ for test: gem_exec_schedule
results: parsing output: 81/ for test: gem_exec_reloc
results: parsing output: 82/ for test: kms_getfb
results: parsing output: 83/ for test: prime_vgem
results: parsing output: 84/ for test: kms_atomic_transition
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_eio
results: parsing output: 89/ for test: gem_exec_whisper
results: parsing output: 90/ for test: kms_lease
results: parsing output: 91/ for test: kms_addfb_basic
results: parsing output: 92/ for test: kms_prime
results: parsing output: 93/ for test: i915_query
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: vgem_basic
results: parsing output: 96/ for test: kms_rotation_crc
results: parsing output: 97/ for test: dumb_buffer
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: kms_ccs
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: gem_mmap_gtt
results: parsing output: 102/ for test: kms_big_fb
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_invalid_mode
results: parsing output: 105/ for test: syncobj_wait
results: parsing output: 106/ for test: dmabuf_sync_file
results: parsing output: 107/ for test: gem_set_tiling_vs_gtt
results: parsing output: 108/ for test: kms_flip
results: parsing output: 109/ for test: gem_ctx_bad_destroy
results: parsing output: 110/ for test: gem_ctx_isolation
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: syncobj_timeline
results: parsing output: 113/ for test: kms_chamelium_frames
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: gem_lmem_swapping
results: parsing output: 116/ for test: kms_flip_scaled_crc
results: parsing output: 117/ for test: kms_addfb_basic
results: parsing output: 118/ for test: kms_cursor_legacy
results: parsing output: 119/ for test: gem_softpin
results: parsing output: 120/ for test: kms_flip
results: parsing output: 121/ for test: kms_psr
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: gem_pxp
results: parsing output: 124/ for test: kms_vblank
results: parsing output: 125/ for test: kms_cursor_crc
results: parsing output: 126/ for test: kms_ccs
results: parsing output: 127/ for test: gem_mmap_gtt
results: parsing output: 128/ for test: kms_draw_crc
results: parsing output: 129/ for test: kms_lease
results: parsing output: 130/ for test: gem_userptr_blits
Done.