[72.349750] Initializing watchdogs
[72.349846]   /dev/watchdog0
[72.369548] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:0102 Intel Sandybridge (Gen6) 2nd Generation Core Processor Family Integrated Graphics Controller (XPS 8300)
[72.377271] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[72.380998] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[72.384093] [001/131] (960s left) gen9_exec_parse (bb-chained)
[72.473380] Subtest bb-chained: SKIP (0.000s)
[72.524094] [002/131] (960s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[72.585871] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.000s)
[72.638296] [003/131] (960s left) kms_properties (crtc-properties-atomic)
[72.937066] Starting subtest: crtc-properties-atomic
[72.937850] Starting dynamic subtest: pipe-A-HDMI-A-1
[73.404799] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.467s)
[73.414042] Starting dynamic subtest: pipe-B-HDMI-A-1
[73.710977] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.305s)
[73.711797] Subtest crtc-properties-atomic: SUCCESS (0.774s)
[74.226743] [004/131] (958s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[74.527307] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[74.528998] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[74.925082] [005/131] (958s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[74.980325] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.000s)
[75.034793] [006/131] (958s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[75.341211] Starting subtest: psr-1p-primscrn-cur-indfb-move
[75.342908] Subtest psr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[75.738600] [007/131] (957s left) kms_psr (psr2-primary-mmap-cpu)
[76.042174] Subtest psr2-primary-mmap-cpu: SKIP (0.000s)
[76.233642] [008/131] (956s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[76.537664] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[76.539459] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[76.935012] [009/131] (956s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[77.238386] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[77.241301] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[77.637375] [010/131] (955s left) kms_big_fb (4-tiled-addfb-size-offset-overflow)
[77.943461] Starting subtest: 4-tiled-addfb-size-offset-overflow
[77.944978] Subtest 4-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[78.349389] [011/131] (954s left) gem_eio (wait-immediate)
[78.421937] Starting subtest: wait-immediate
[78.454478] Subtest wait-immediate: SUCCESS (0.032s)
[79.095744] [012/131] (954s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[79.393160] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[79.575469] [013/131] (953s left) gem_exec_alignment (many)
[79.634802] Starting subtest: many
[114.475890] Subtest many: SUCCESS (34.840s)
[116.889077] [014/131] (916s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-cpu)
[117.309671] Starting subtest: fbc-rgb101010-draw-mmap-cpu
[119.892501] Subtest fbc-rgb101010-draw-mmap-cpu: SUCCESS (2.581s)
[120.333398] [015/131] (913s left) kms_psr (fbc-psr-cursor-blt)
[120.642482] Subtest fbc-psr-cursor-blt: SKIP (0.000s)
[120.825700] [016/131] (912s left) gem_fence_thrash (bo-write-verify-threaded-y)
[120.882105] Starting subtest: bo-write-verify-threaded-y
[122.766461] Subtest bo-write-verify-threaded-y: SUCCESS (1.884s)
[122.881103] [017/131] (910s left) fbdev (unaligned-read)
[122.936224] Starting subtest: unaligned-read
[122.947747] Subtest unaligned-read: SUCCESS (0.011s)
[123.063553] [018/131] (910s left) kms_lease (lease-unleased-crtc)
[123.358936] Starting subtest: lease-unleased-crtc
[123.359970] Starting dynamic subtest: pipe-A-HDMI-A-1
[123.469829] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.110s)
[123.479901] Starting dynamic subtest: pipe-B-HDMI-A-1
[123.500113] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.030s)
[123.500992] Subtest lease-unleased-crtc: SUCCESS (0.143s)
[124.010133] [019/131] (909s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[124.315594] Starting subtest: x-tiled-16bpp-rotate-0
[125.647793] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.331s)
[126.072863] [020/131] (907s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[126.379124] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[126.565239] [021/131] (907s left) gem_exec_balancer (bonded-false-hang)
[126.628089] Subtest bonded-false-hang: SKIP (0.000s)
[126.756018] [022/131] (907s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[127.058048] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[127.059671] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[127.472086] [023/131] (906s left) gem_exec_params (mmapped)
[127.530396] Starting subtest: mmapped
[127.531935] Subtest mmapped: SUCCESS (0.001s)
[127.672305] [024/131] (906s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-pwrite)
[127.966731] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-pwrite
[129.774073] Subtest fbc-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (1.808s)
[130.215196] [025/131] (903s left) gem_mmap_gtt (cpuset-big-copy)
[130.271619] Starting subtest: cpuset-big-copy
[133.131075] Subtest cpuset-big-copy: SUCCESS (2.860s)
[133.396933] [026/131] (900s left) kms_psr (fbc-psr2-sprite-blt)
[133.814491] Subtest fbc-psr2-sprite-blt: SKIP (0.000s)
[134.030624] [027/131] (900s left) kms_psr_stress_test (flip-primary-invalidate-overlay)
[134.088538] Subtest flip-primary-invalidate-overlay: SKIP (0.000s)
[134.151670] [028/131] (899s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[134.451120] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[134.452462] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[134.857382] [029/131] (899s left) kms_getfb (getfb-handle-protection)
[135.161273] Starting subtest: getfb-handle-protection
[135.179850] Subtest getfb-handle-protection: SUCCESS (0.019s)
[135.608346] [030/131] (898s left) syncobj_wait (multi-wait-all-for-submit-submitted)
[135.681218] Starting subtest: multi-wait-all-for-submit-submitted
[135.785148] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.103s)
[135.901400] [031/131] (898s left) kms_flip (2x-plain-flip-ts-check)
[136.204171] Starting subtest: 2x-plain-flip-ts-check
[136.205165] Starting dynamic subtest: AB-VGA1-HDMI-A1
[166.919873] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (30.716s)
[166.921906] Subtest 2x-plain-flip-ts-check: SUCCESS (30.720s)
[167.552282] [032/131] (866s left) gem_pxp (reject-modify-context-protection-on)
[170.130321] Starting subtest: reject-modify-context-protection-on
[170.132213] Subtest reject-modify-context-protection-on: SKIP (0.000s)
[170.245654] [033/131] (864s left) kms_chamelium_audio (dp-audio-edid)
[170.617283] Subtest dp-audio-edid: SKIP (0.000s)
[170.916908] [034/131] (863s left) sysfs_timeslice_duration (timeout)
[170.978825] Starting subtest: timeout
[170.980716] Starting dynamic subtest: vcs0
[170.982324] Dynamic subtest vcs0: SKIP (0.000s)
[170.992940] Starting dynamic subtest: bcs0
[170.996125] Dynamic subtest bcs0: SKIP (0.000s)
[171.013324] Starting dynamic subtest: rcs0
[171.015948] Dynamic subtest rcs0: SKIP (0.000s)
[171.018031] Subtest timeout: SKIP (0.005s)
[171.108113] [035/131] (863s left) gem_exec_params (invalid-bsd2-flag-on-vebox)
[171.171413] Starting subtest: invalid-bsd2-flag-on-vebox
[171.173785] Subtest invalid-bsd2-flag-on-vebox: SKIP (0.000s)
[171.309251] [036/131] (863s left) gem_exercise_blt (fast-copy-emit)
[171.367293] Subtest fast-copy-emit: SKIP (0.000s)
[171.414887] [037/131] (863s left) kms_plane_multiple (2x-tiling-4)
[171.712811] Starting subtest: 2x-tiling-4
[171.714340] Subtest 2x-tiling-4: SKIP (0.000s)
[172.119883] [038/131] (862s left) dmabuf_sync_file (export-before-signal)
[172.228618] Starting subtest: export-before-signal
[172.229465] Subtest export-before-signal: SUCCESS (0.003s)
[172.338819] [FACT dmabuf_sync_file (export-before-signal)] new: kernel.kmod_is_loaded.vgem: true
[172.341441] [039/131] (862s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[172.398197] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[172.452368] [040/131] (862s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[172.760483] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[172.762265] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[173.173435] [041/131] (861s left) i915_pm_rpm (gem-pread)
[184.681619] Subtest gem-pread: SKIP (0.000s)
[184.882708] [042/131] (849s left) prime_vgem (fence-wait)
[184.958176] Starting subtest: fence-wait
[184.958925] Starting dynamic subtest: rcs0
[185.991354] Dynamic subtest rcs0: SUCCESS (1.032s)
[186.010655] Starting dynamic subtest: bcs0
[187.018395] Dynamic subtest bcs0: SUCCESS (1.025s)
[187.019620] Subtest fence-wait: SUCCESS (2.060s)
[187.183321] [043/131] (847s left) syncobj_timeline (invalid-wait-bad-flags)
[187.243149] Starting subtest: invalid-wait-bad-flags
[187.244051] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[187.377767] [044/131] (847s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[187.683360] Starting subtest: fbcpsr-rgb565-draw-render
[187.684887] Subtest fbcpsr-rgb565-draw-render: SKIP (0.000s)
[188.091921] [045/131] (846s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[188.148853] Starting subtest: wait-all-for-submit-delayed-submit
[188.252510] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.102s)
[188.383833] [046/131] (846s left) gem_exec_flush (basic-wb-rw-default)
[188.446477] Starting subtest: basic-wb-rw-default
[193.891771] Subtest basic-wb-rw-default: SUCCESS (5.445s)
[194.118233] [047/131] (840s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[194.427058] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[194.428475] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[194.832178] [048/131] (840s left) kms_pipe_crc_basic (suspend-read-crc)
[195.135261] Starting subtest: suspend-read-crc
[195.136248] Starting dynamic subtest: pipe-A-HDMI-A-1
[214.677226] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.548s)
[214.690283] Starting dynamic subtest: pipe-B-HDMI-A-1
[232.719302] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.581s)
[232.720131] Subtest suspend-read-crc: SUCCESS (5.134s)
[240.234921] [049/131] (801s left) gem_exec_reloc (basic-gtt-wc)
[240.308898] Starting subtest: basic-gtt-wc
[240.313129] Subtest basic-gtt-wc: SUCCESS (0.004s)
[240.972294] [050/131] (801s left) gem_watchdog (default-physical)
[241.040217] Starting subtest: default-physical
[241.042746] Subtest default-physical: SKIP (0.002s)
[241.139072] [051/131] (801s left) gem_fence_thrash (bo-write-verify-threaded-x)
[241.190774] Starting subtest: bo-write-verify-threaded-x
[243.072771] Subtest bo-write-verify-threaded-x: SUCCESS (1.816s)
[243.230027] [052/131] (799s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[243.534431] Starting subtest: fbc-rgb565-draw-blt
[245.462266] Subtest fbc-rgb565-draw-blt: SUCCESS (1.878s)
[245.905512] [053/131] (796s left) kms_universal_plane (disable-primary-vs-flip)
[246.215885] Starting subtest: disable-primary-vs-flip
[246.216773] Starting dynamic subtest: pipe-A-HDMI-A-1
[246.601417] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.378s)
[246.615847] Starting dynamic subtest: pipe-B-HDMI-A-1
[247.048732] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.432s)
[247.049796] Subtest disable-primary-vs-flip: SUCCESS (0.814s)
[247.576869] [054/131] (794s left) kms_cursor_edge_walk (128x128-top-edge)
[247.895413] Starting subtest: 128x128-top-edge
[247.916996] Starting dynamic subtest: pipe-A-HDMI-A-1
[251.383995] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.443s)
[251.404097] Starting dynamic subtest: pipe-B-HDMI-A-1
[254.763799] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.349s)
[254.764603] Subtest 128x128-top-edge: SUCCESS (6.797s)
[255.289719] [055/131] (787s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-legacy)
[255.596344] Starting subtest: flip-vs-cursor-busy-crc-legacy
[256.155506] Subtest flip-vs-cursor-busy-crc-legacy: SUCCESS (0.557s)
[256.682058] [056/131] (785s left) kms_flip (modeset-vs-vblank-race-interruptible)
[256.992459] Starting subtest: modeset-vs-vblank-race-interruptible
[256.993273] Starting dynamic subtest: A-VGA1
[260.005281] Dynamic subtest A-VGA1: SUCCESS (2.999s)
[260.019812] Starting dynamic subtest: B-VGA1
[263.080316] Dynamic subtest B-VGA1: SUCCESS (3.063s)
[263.095932] Starting dynamic subtest: A-HDMI-A1
[266.224978] Dynamic subtest A-HDMI-A1: SUCCESS (3.135s)
[266.240413] Starting dynamic subtest: B-HDMI-A1
[269.390568] Dynamic subtest B-HDMI-A1: SUCCESS (3.159s)
[269.391588] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (12.368s)
[269.995598] [057/131] (772s left) perf_pmu (busy-start)
[270.103897] Starting subtest: busy-start
[270.104623] Starting dynamic subtest: rcs0
[272.632955] Dynamic subtest rcs0: SUCCESS (2.526s)
[272.651048] Starting dynamic subtest: bcs0
[275.155023] Dynamic subtest bcs0: SUCCESS (2.517s)
[275.172324] Starting dynamic subtest: vcs0
[278.180958] Dynamic subtest vcs0: SUCCESS (3.021s)
[278.184766] Subtest busy-start: SUCCESS (8.074s)
[278.320408] [058/131] (764s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[278.621394] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[278.622782] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[279.034265] [059/131] (763s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[279.094219] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s)
[279.161961] [060/131] (763s left) kms_flip (2x-flip-vs-expired-vblank)
[279.456555] Starting subtest: 2x-flip-vs-expired-vblank
[279.458066] Starting dynamic subtest: AB-VGA1-HDMI-A1
[309.817050] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (30.342s)
[309.819834] Subtest 2x-flip-vs-expired-vblank: SUCCESS (30.347s)
[310.479756] [061/131] (732s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[310.784585] Starting subtest: basic-flip-before-cursor-atomic
[311.757254] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.972s)
[312.261321] [062/131] (730s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[312.564291] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[312.565561] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[312.960627] [063/131] (729s left) gem_ctx_param (basic)
[313.020420] Starting subtest: basic
[313.021260] Subtest basic: SUCCESS (0.000s)
[313.159131] [064/131] (729s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[313.214705] Subtest flip-32bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[313.272327] [065/131] (729s left) gem_create (create-ext-placement-each)
[313.439418] Starting subtest: create-ext-placement-each
[313.440581] Subtest create-ext-placement-each: SUCCESS (0.000s)
[313.595300] [066/131] (729s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[313.973411] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[314.281471] [067/131] (728s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[314.579366] Starting subtest: extended-pageflip-modeset-hang-oldfb
[314.580685] Starting dynamic subtest: pipe-A
[320.391874] Dynamic subtest pipe-A: SUCCESS (5.807s)
[320.410555] Starting dynamic subtest: pipe-B
[326.394517] Dynamic subtest pipe-B: SUCCESS (5.997s)
[326.397219] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (11.812s)
[326.924803] [068/131] (716s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled)
[326.984286] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled
[326.985142] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[327.114280] [069/131] (716s left) api_intel_bb (add-remove-objects)
[327.173344] Starting subtest: add-remove-objects
[327.176726] Subtest add-remove-objects: SUCCESS (0.004s)
[327.347432] [070/131] (715s left) gem_exec_fence (keep-in-fence)
[327.522621] Subtest keep-in-fence: SKIP (0.000s)
[327.926942] [071/131] (715s left) api_intel_bb (destroy-bb)
[327.981466] Starting subtest: destroy-bb
[327.987215] Subtest destroy-bb: SUCCESS (0.007s)
[328.161121] [072/131] (715s left) kms_psr (fbc-pr-cursor-render)
[328.450092] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[328.655718] [073/131] (714s left) gem_softpin (safe-alignment)
[328.716670] Starting subtest: safe-alignment
[328.725721] Subtest safe-alignment: SUCCESS (0.009s)
[328.895106] [074/131] (714s left) i915_hangman (gt-engine-error)
[328.959326] Starting subtest: gt-engine-error
[328.960904] Subtest gt-engine-error: SKIP (0.000s)
[329.035657] [075/131] (714s left) kms_cursor_crc (cursor-onscreen-512x512)
[329.342940] Starting subtest: cursor-onscreen-512x512
[329.346499] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[329.775864] [076/131] (713s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[330.074047] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[330.075096] Starting dynamic subtest: pipe-A
[330.077364] Dynamic subtest pipe-A: SKIP (0.001s)
[330.094188] Starting dynamic subtest: pipe-B
[330.096123] Dynamic subtest pipe-B: SKIP (0.001s)
[330.097450] Subtest planes-unity-scaling-downscale-factor-0-75: SKIP (0.006s)
[330.487521] [077/131] (713s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[330.791497] Starting subtest: flip-vs-cursor-busy-crc-atomic
[331.351213] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.561s)
[331.899353] [078/131] (711s left) kms_dp_link_training (uhbr-sst)
[332.195391] Starting subtest: uhbr-sst
[332.196929] Subtest uhbr-sst: SKIP (0.000s)
[332.458339] [079/131] (711s left) perf (blocking-parameterized)
[332.664629] Subtest blocking-parameterized: SKIP (0.000s)
[332.743081] [080/131] (711s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[333.044942] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[333.046414] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[333.444158] [081/131] (710s left) vgem_basic (sysfs)
[333.504386] Starting subtest: sysfs
[333.505137] Subtest sysfs: SUCCESS (0.001s)
[333.629095] [082/131] (710s left) gem_ctx_persistence (engines-hostile)
[333.692086] Subtest engines-hostile: SKIP (0.000s)
[333.750997] [083/131] (710s left) i915_suspend (fence-restore-untiled)
[333.815168] Starting subtest: fence-restore-untiled
[351.302661] Subtest fence-restore-untiled: SUCCESS (1.695s)
[358.434237] [084/131] (692s left) syncobj_wait (invalid-reset-illegal-handle)
[358.499017] Starting subtest: invalid-reset-illegal-handle
[358.499664] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[358.630867] [085/131] (692s left) gem_readwrite (write-bad-handle)
[358.692101] Starting subtest: write-bad-handle
[358.693723] Subtest write-bad-handle: SUCCESS (0.000s)
[358.837173] [086/131] (692s left) gem_fenced_exec_thrash (no-spare-fences-busy)
[358.899729] Starting subtest: no-spare-fences-busy
[361.119844] Subtest no-spare-fences-busy: SUCCESS (2.160s)
[361.269994] [087/131] (690s left) gem_ctx_persistence (heartbeat-close)
[361.331024] Subtest heartbeat-close: SKIP (0.000s)
[361.398519] [088/131] (689s left) kms_cursor_crc (cursor-onscreen-256x256)
[361.706659] Starting subtest: cursor-onscreen-256x256
[361.709147] Starting dynamic subtest: pipe-A-HDMI-A-1
[363.958811] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.205s)
[364.001401] Starting dynamic subtest: pipe-B-HDMI-A-1
[366.250778] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.225s)
[366.251768] Subtest cursor-onscreen-256x256: SUCCESS (4.465s)
[366.789256] [089/131] (684s left) gem_ringfill (engines-basic)
[366.959141] Starting subtest: engines-basic
[366.960215] Starting dynamic subtest: rcs0
[366.979811] Dynamic subtest rcs0: SUCCESS (0.019s)
[367.004241] Starting dynamic subtest: bcs0
[367.005329] Dynamic subtest bcs0: SUCCESS (0.016s)
[367.006679] Subtest engines-basic: SUCCESS (0.040s)
[367.143844] [090/131] (684s left) kms_pm_rpm (cursor)
[378.657378] Subtest cursor: SKIP (0.000s)
[378.868437] [091/131] (672s left) gem_pread (bench)
[378.931144] Starting subtest: bench
[380.212549] Subtest bench: SUCCESS (1.278s)
[380.401038] [092/131] (671s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[380.705458] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[382.583893] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (1.874s)
[383.042979] [093/131] (668s left) gem_exec_schedule (submit-golden-slice)
[383.114567] Subtest submit-golden-slice: SKIP (0.000s)
[383.353782] [094/131] (668s left) gem_exec_schedule (preempt-contexts)
[383.423008] Subtest preempt-contexts: SKIP (0.000s)
[383.655102] [095/131] (668s left) kms_frontbuffer_tracking (psr-suspend)
[383.958036] Starting subtest: psr-suspend
[383.959559] Subtest psr-suspend: SKIP (0.000s)
[384.369837] [096/131] (667s left) gem_exec_capture (capture-invisible)
[384.430160] Subtest capture-invisible: SKIP (0.000s)
[384.521033] [097/131] (667s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs)
[384.581025] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SKIP (0.000s)
[384.653949] [098/131] (667s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0)
[384.960794] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0
[386.048265] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.086s)
[386.507917] [099/131] (665s left) kms_big_fb (linear-64bpp-rotate-90)
[386.807499] Starting subtest: linear-64bpp-rotate-90
[386.814881] Subtest linear-64bpp-rotate-90: SKIP (0.006s)
[387.216698] [100/131] (664s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[387.516117] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[387.517597] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[387.937815] [101/131] (664s left) kms_content_protection (dp-mst-suspend-resume)
[388.253394] Starting subtest: dp-mst-suspend-resume
[388.254787] Subtest dp-mst-suspend-resume: SKIP (0.000s)
[388.684750] [102/131] (663s left) kms_atomic (plane-primary-legacy)
[388.987472] Starting subtest: plane-primary-legacy
[388.989798] Starting dynamic subtest: pipe-A-HDMI-A-1
[389.246237] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.257s)
[389.246970] Subtest plane-primary-legacy: SUCCESS (0.260s)
[389.775404] [103/131] (662s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted)
[389.839679] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[389.840393] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.001s)
[389.966937] [104/131] (662s left) gem_userptr_blits (unsync-unmap-after-close)
[390.028074] Subtest unsync-unmap-after-close: SKIP (0.000s)
[390.210605] [105/131] (662s left) drm_read (empty-nonblock)
[390.568420] Starting subtest: empty-nonblock
[390.569741] Subtest empty-nonblock: SUCCESS (0.000s)
[391.035058] [106/131] (661s left) gem_eio (suspend)
[391.100852] Starting subtest: suspend
[402.073683] Subtest suspend: SUCCESS (10.845s)
[409.695112] [107/131] (649s left) kms_psr (pr-primary-render)
[410.012658] Subtest pr-primary-render: SKIP (0.000s)
[410.220832] [108/131] (649s left) kms_vblank (ts-continuation-suspend)
[410.526119] Starting subtest: ts-continuation-suspend
[410.527373] Starting dynamic subtest: pipe-A-HDMI-A-1
[427.409829] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.825s)
[427.424730] Starting dynamic subtest: pipe-B-HDMI-A-1
[444.382900] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.887s)
[444.383697] Subtest ts-continuation-suspend: SUCCESS (1.718s)
[451.941725] [109/131] (614s left) kms_flip (2x-nonexisting-fb-interruptible)
[452.261487] Starting subtest: 2x-nonexisting-fb-interruptible
[452.263736] Starting dynamic subtest: AB-VGA1-HDMI-A1
[452.592484] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (0.328s)
[452.596035] Subtest 2x-nonexisting-fb-interruptible: SUCCESS (0.333s)
[453.203091] [110/131] (613s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[453.511307] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[453.512591] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[453.922676] [111/131] (612s left) kms_invalid_mode (uint-max-clock)
[454.217224] Starting subtest: uint-max-clock
[454.218025] Starting dynamic subtest: pipe-A-HDMI-A-1
[454.303619] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.084s)
[454.321647] Starting dynamic subtest: pipe-B-HDMI-A-1
[454.322496] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s)
[454.323214] Subtest uint-max-clock: SUCCESS (0.089s)
[454.700964] [112/131] (612s left) kms_properties (get_properties-sanity-non-atomic)
[455.007705] Starting subtest: get_properties-sanity-non-atomic
[455.008490] Subtest get_properties-sanity-non-atomic: SUCCESS (0.001s)
[455.421730] [113/131] (611s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[466.920731] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.000s)
[467.124403] [114/131] (599s left) kms_flip (flip-vs-absolute-wf_vblank)
[467.442238] Starting subtest: flip-vs-absolute-wf_vblank
[467.443096] Starting dynamic subtest: A-VGA1
[486.564443] Dynamic subtest A-VGA1: SUCCESS (18.999s)
[486.582412] Starting dynamic subtest: B-VGA1
[494.583939] Dynamic subtest B-VGA1: SUCCESS (8.002s)
[494.598281] Starting dynamic subtest: A-HDMI-A1
[502.755958] Dynamic subtest A-HDMI-A1: SUCCESS (8.170s)
[502.772531] Starting dynamic subtest: B-HDMI-A1
[510.960072] Dynamic subtest B-HDMI-A1: SUCCESS (8.199s)
[510.963396] Subtest flip-vs-absolute-wf_vblank: SUCCESS (43.386s)
[511.598958] [115/131] (555s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[511.668113] Starting subtest: basic-batch-kernel-default-cmd
[511.669789] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[511.918388] [116/131] (555s left) gem_exec_whisper (basic-fds-all)
[511.988242] Starting subtest: basic-fds-all
[513.926372] Subtest basic-fds-all: SUCCESS (1.936s)
[514.165084] [117/131] (552s left) kms_properties (invalid-properties-atomic)
[514.463333] Starting subtest: invalid-properties-atomic
[514.500180] Subtest invalid-properties-atomic: SUCCESS (0.039s)
[514.894122] [118/131] (552s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation)
[515.196000] Starting subtest: plane-scaler-unity-scaling-with-rotation
[515.197037] Starting dynamic subtest: pipe-A
[515.199242] Dynamic subtest pipe-A: SKIP (0.001s)
[515.214029] Starting dynamic subtest: pipe-B
[515.215899] Dynamic subtest pipe-B: SKIP (0.001s)
[515.217181] Subtest plane-scaler-unity-scaling-with-rotation: SKIP (0.005s)
[515.611224] [119/131] (551s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[515.671261] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[515.778504] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.107s)
[515.906522] [120/131] (551s left) syncobj_basic (bad-pad-handle-to-fd)
[515.962780] Starting subtest: bad-pad-handle-to-fd
[515.963815] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s)
[516.090759] [121/131] (551s left) kms_chamelium_hpd (dp-hpd)
[516.472157] Subtest dp-hpd: SKIP (0.000s)
[516.807739] [122/131] (550s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic)
[517.104041] Starting subtest: async-flip-with-page-flip-events-tiled-atomic
[517.241674] Starting dynamic subtest: pipe-A-HDMI-A-1-x
[519.387161] Dynamic subtest pipe-A-HDMI-A-1-x: SUCCESS (2.143s)
[519.552326] Starting dynamic subtest: pipe-B-HDMI-A-1-x
[521.646598] Dynamic subtest pipe-B-HDMI-A-1-x: SUCCESS (2.111s)
[521.647433] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (4.543s)
[522.315585] [123/131] (545s left) i915_drm_fdinfo (most-busy-check-all)
[522.376686] Subtest most-busy-check-all: SKIP (0.000s)
[522.460997] [124/131] (545s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[522.760405] Starting subtest: fb-8bpc-vs-panel-6bpc
[522.762671] Starting dynamic subtest: pipe-A-HDMI-A-1
[522.844849] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.081s)
[522.846344] Subtest fb-8bpc-vs-panel-6bpc: SKIP (0.085s)
[523.400121] [125/131] (544s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[523.699750] Starting subtest: cursorB-vs-flipA-atomic-transitions
[523.701337] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.002s)
[524.125753] [126/131] (543s left) gem_set_tiling_vs_pwrite
[524.332747] [127/131] (543s left) gem_mmap (bad-object)
[524.389878] Starting subtest: bad-object
[524.390522] Subtest bad-object: SUCCESS (0.000s)
[524.534102] [128/131] (543s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[524.829084] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[524.830582] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[525.251330] [129/131] (542s left) syncobj_wait (multi-wait-for-submit-submitted)
[525.308649] Starting subtest: multi-wait-for-submit-submitted
[525.410519] Subtest multi-wait-for-submit-submitted: SUCCESS (0.101s)
[525.554064] [130/131] (542s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[525.851637] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[525.852895] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[526.259110] [131/131] (541s left) gem_mmap_offset (isolation)
[526.315930] Starting subtest: isolation
[526.327239] Subtest isolation: SUCCESS (0.010s)
[526.461597] Closing watchdogs
results: parsing output: 0/ for test: gen9_exec_parse
results: parsing output: 1/ for test: kms_ccs
results: parsing output: 2/ for test: kms_properties
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_flip_scaled_crc
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_psr
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_big_fb
results: parsing output: 10/ for test: gem_eio
results: parsing output: 11/ for test: kms_psr2_sf
results: parsing output: 12/ for test: gem_exec_alignment
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: gem_fence_thrash
results: parsing output: 16/ for test: fbdev
results: parsing output: 17/ for test: kms_lease
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: kms_psr2_sf
results: parsing output: 20/ for test: gem_exec_balancer
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_exec_params
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: gem_mmap_gtt
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: kms_psr_stress_test
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_getfb
results: parsing output: 29/ for test: syncobj_wait
results: parsing output: 30/ for test: kms_flip
results: parsing output: 31/ for test: gem_pxp
results: parsing output: 32/ for test: kms_chamelium_audio
results: parsing output: 33/ for test: sysfs_timeslice_duration
results: parsing output: 34/ for test: gem_exec_params
results: parsing output: 35/ for test: gem_exercise_blt
results: parsing output: 36/ for test: kms_plane_multiple
results: parsing output: 37/ for test: dmabuf_sync_file
results: parsing output: 38/ for test: kms_ccs
results: parsing output: 39/ for test: kms_big_fb
results: parsing output: 40/ for test: i915_pm_rpm
results: parsing output: 41/ for test: prime_vgem
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: syncobj_timeline
results: parsing output: 45/ for test: gem_exec_flush
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_pipe_crc_basic
results: parsing output: 48/ for test: gem_exec_reloc
results: parsing output: 49/ for test: gem_watchdog
results: parsing output: 50/ for test: gem_fence_thrash
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_universal_plane
results: parsing output: 53/ for test: kms_cursor_edge_walk
results: parsing output: 54/ for test: kms_cursor_legacy
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: perf_pmu
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_ccs
results: parsing output: 59/ for test: kms_flip
results: parsing output: 60/ for test: kms_cursor_legacy
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: gem_ctx_param
results: parsing output: 63/ for test: kms_flip_scaled_crc
results: parsing output: 64/ for test: gem_create
results: parsing output: 65/ for test: kms_chamelium_hpd
results: parsing output: 66/ for test: kms_busy
results: parsing output: 67/ for test: syncobj_timeline
results: parsing output: 68/ for test: api_intel_bb
results: parsing output: 69/ for test: gem_exec_fence
results: parsing output: 70/ for test: api_intel_bb
results: parsing output: 71/ for test: kms_psr
results: parsing output: 72/ for test: gem_softpin
results: parsing output: 73/ for test: i915_hangman
results: parsing output: 74/ for test: kms_cursor_crc
results: parsing output: 75/ for test: kms_plane_scaling
results: parsing output: 76/ for test: kms_cursor_legacy
results: parsing output: 77/ for test: kms_dp_link_training
results: parsing output: 78/ for test: perf
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: vgem_basic
results: parsing output: 81/ for test: gem_ctx_persistence
results: parsing output: 82/ for test: i915_suspend
results: parsing output: 83/ for test: syncobj_wait
results: parsing output: 84/ for test: gem_readwrite
results: parsing output: 85/ for test: gem_fenced_exec_thrash
results: parsing output: 86/ for test: gem_ctx_persistence
results: parsing output: 87/ for test: kms_cursor_crc
results: parsing output: 88/ for test: gem_ringfill
results: parsing output: 89/ for test: kms_pm_rpm
results: parsing output: 90/ for test: gem_pread
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: gem_exec_schedule
results: parsing output: 93/ for test: gem_exec_schedule
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: gem_exec_capture
results: parsing output: 96/ for test: kms_ccs
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_content_protection
results: parsing output: 101/ for test: kms_atomic
results: parsing output: 102/ for test: syncobj_timeline
results: parsing output: 103/ for test: gem_userptr_blits
results: parsing output: 104/ for test: drm_read
results: parsing output: 105/ for test: gem_eio
results: parsing output: 106/ for test: kms_psr
results: parsing output: 107/ for test: kms_vblank
results: parsing output: 108/ for test: kms_flip
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_invalid_mode
results: parsing output: 111/ for test: kms_properties
results: parsing output: 112/ for test: kms_pm_rpm
results: parsing output: 113/ for test: kms_flip
results: parsing output: 114/ for test: gem_exec_flush
results: parsing output: 115/ for test: gem_exec_whisper
results: parsing output: 116/ for test: kms_properties
results: parsing output: 117/ for test: kms_plane_scaling
results: parsing output: 118/ for test: syncobj_timeline
results: parsing output: 119/ for test: syncobj_basic
results: parsing output: 120/ for test: kms_chamelium_hpd
results: parsing output: 121/ for test: kms_async_flips
results: parsing output: 122/ for test: i915_drm_fdinfo
results: parsing output: 123/ for test: kms_dither
results: parsing output: 124/ for test: kms_cursor_legacy
results: parsing output: 125/ for test: gem_set_tiling_vs_pwrite
results: parsing output: 126/ for test: gem_mmap
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: syncobj_wait
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: gem_mmap_offset
Done.