[73.767980] Initializing watchdogs
[73.768161]   /dev/watchdog0
[73.791670] [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)
[73.799359] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[73.802818] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[73.807756] [001/134] (960s left) prime_vgem (basic-fence-blt)
[73.925758] Starting subtest: basic-fence-blt
[74.016241] Subtest basic-fence-blt: SUCCESS (0.089s)
[74.185434] [FACT prime_vgem (basic-fence-blt)] new: kernel.kmod_is_loaded.vgem: true
[74.189548] [002/134] (960s left) kms_chamelium_hpd (dp-hpd-storm)
[74.753394] Subtest dp-hpd-storm: SKIP (0.000s)
[75.159163] [003/134] (959s left) syncobj_timeline (single-wait-all-signaled)
[75.221101] Starting subtest: single-wait-all-signaled
[75.222997] Subtest single-wait-all-signaled: SUCCESS (0.001s)
[75.351206] [004/134] (959s left) gem_render_copy (y-tiled-to-vebox-linear)
[75.419074] Starting subtest: y-tiled-to-vebox-linear
[75.423161] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[75.649961] [005/134] (958s left) api_intel_allocator (reopen-fork)
[75.712436] Starting subtest: reopen-fork
[79.355703] Subtest reopen-fork: SUCCESS (3.641s)
[79.496503] [006/134] (955s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[79.997861] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[80.001106] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[80.601615] [007/134] (954s left) gem_ctx_create (basic)
[80.670417] Starting subtest: basic
[80.672656] Subtest basic: SUCCESS (0.000s)
[80.904830] [008/134] (953s left) kms_lease (lease-get)
[81.398064] Starting subtest: lease-get
[81.401158] Starting dynamic subtest: pipe-A-HDMI-A-1
[81.402837] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s)
[81.413398] Starting dynamic subtest: pipe-B-HDMI-A-1
[81.415049] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[81.416830] Subtest lease-get: SUCCESS (0.006s)
[82.021886] [009/134] (952s left) kms_rotation_crc (primary-yf-tiled-reflect-x-0)
[82.502961] Starting subtest: primary-yf-tiled-reflect-x-0
[82.506677] Subtest primary-yf-tiled-reflect-x-0: SKIP (0.001s)
[83.117445] [010/134] (951s left) kms_draw_crc (draw-method-mmap-gtt)
[83.603060] Starting subtest: draw-method-mmap-gtt
[83.604866] Starting dynamic subtest: xrgb8888-untiled
[83.879265] Dynamic subtest xrgb8888-untiled: SUCCESS (0.276s)
[83.890396] Starting dynamic subtest: rgb565-untiled
[84.144953] Dynamic subtest rgb565-untiled: SUCCESS (0.265s)
[84.156063] Starting dynamic subtest: xrgb2101010-untiled
[84.444642] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.299s)
[84.456525] Starting dynamic subtest: xbgr16161616f-untiled
[84.760674] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.315s)
[84.772083] Starting dynamic subtest: xrgb8888-xtiled
[84.910481] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.149s)
[84.922058] Starting dynamic subtest: rgb565-xtiled
[85.043412] Dynamic subtest rgb565-xtiled: SUCCESS (0.132s)
[85.053648] Starting dynamic subtest: xrgb2101010-xtiled
[85.193180] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.149s)
[85.203885] Starting dynamic subtest: xbgr16161616f-xtiled
[85.342948] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.149s)
[85.344856] Subtest draw-method-mmap-gtt: SUCCESS (1.740s)
[85.965643] [011/134] (948s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[86.458579] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[86.462121] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[87.055877] [012/134] (947s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[87.552337] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[87.850062] [013/134] (947s left) gem_ppgtt (blt-vs-render-ctx0)
[87.910980] Starting subtest: blt-vs-render-ctx0
[120.798980] Subtest blt-vs-render-ctx0: SUCCESS (32.885s)
[120.966057] [014/134] (914s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[121.550140] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[121.556937] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.002s)
[122.158513] [015/134] (912s left) i915_drm_fdinfo (all-busy-check-all)
[122.221262] Subtest all-busy-check-all: SKIP (0.000s)
[122.283700] [016/134] (912s left) gem_mmap_gtt (flink-race)
[122.339935] Starting subtest: flink-race
[142.448268] Subtest flink-race: SUCCESS (20.104s)
[142.595554] [017/134] (892s left) gem_exec_balancer (full-late)
[142.659118] Subtest full-late: SKIP (0.000s)
[142.763441] [018/134] (892s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[143.257044] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[143.261249] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[143.869162] [019/134] (891s left) kms_frontbuffer_tracking (psr-abgr161616f-draw-render)
[144.364475] Starting subtest: psr-abgr161616f-draw-render
[144.367676] Subtest psr-abgr161616f-draw-render: SKIP (0.000s)
[144.971630] [020/134] (890s left) gem_render_copy_redux (normal)
[145.036904] Starting subtest: normal
[145.580253] Subtest normal: SUCCESS (0.542s)
[145.723307] [021/134] (889s left) gem_workarounds (basic-read)
[145.790158] Starting subtest: basic-read
[145.794186] Subtest basic-read: SUCCESS (0.004s)
[145.960578] [022/134] (889s left) gem_bad_reloc (negative-reloc-lut)
[146.021564] Starting subtest: negative-reloc-lut
[146.024987] Subtest negative-reloc-lut: SKIP (0.000s)
[146.179545] [023/134] (889s left) kms_content_protection (atomic-hdcp14)
[146.697521] Starting subtest: atomic-hdcp14
[146.700803] Subtest atomic-hdcp14: SKIP (0.000s)
[147.312718] [024/134] (888s left) drm_read (fault-buffer)
[147.885158] Starting subtest: fault-buffer
[147.887114] Subtest fault-buffer: SUCCESS (0.001s)
[148.521643] [025/134] (887s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[149.022129] Starting subtest: psr-rgb565-draw-blt
[149.025556] Subtest psr-rgb565-draw-blt: SKIP (0.000s)
[149.620728] [026/134] (886s left) perf (polling)
[149.805713] Subtest polling: SKIP (0.000s)
[149.858774] [027/134] (885s left) kms_busy (basic-hang)
[150.350290] Starting subtest: basic-hang
[150.351971] Starting dynamic subtest: flip-pipe-A
[150.759758] Dynamic subtest flip-pipe-A: SUCCESS (0.410s)
[150.772800] Starting dynamic subtest: modeset-pipe-A
[151.546268] Dynamic subtest modeset-pipe-A: SUCCESS (0.785s)
[151.558728] Starting dynamic subtest: flip-pipe-B
[151.965665] Dynamic subtest flip-pipe-B: SUCCESS (0.419s)
[151.976961] Starting dynamic subtest: modeset-pipe-B
[152.712684] Dynamic subtest modeset-pipe-B: SUCCESS (0.747s)
[152.714434] Subtest basic-hang: SUCCESS (2.366s)
[153.440722] [028/134] (882s left) gem_softpin (32b-excludes-last-page)
[153.510501] Subtest 32b-excludes-last-page: SKIP (0.000s)
[153.637916] [029/134] (882s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[153.701745] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.000s)
[153.762954] [030/134] (882s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[154.249434] Starting subtest: cursorA-vs-flipA-toggle
[165.140081] Subtest cursorA-vs-flipA-toggle: SUCCESS (10.892s)
[165.842845] [031/134] (870s left) gem_compute (compute-square)
[165.901112] Starting subtest: compute-square
[165.904790] Subtest compute-square: SKIP (0.000s)
[166.026177] [032/134] (870s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[166.112348] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SKIP (0.000s)
[166.172731] [033/134] (869s left) kms_atomic_transition (modeset-transition-fencing)
[166.663297] Starting subtest: modeset-transition-fencing
[166.664960] Starting dynamic subtest: 1x-outputs
[167.615279] Dynamic subtest 1x-outputs: SUCCESS (0.951s)
[167.616967] Subtest modeset-transition-fencing: SUCCESS (0.953s)
[168.321692] [034/134] (867s left) gem_ctx_persistence (legacy-engines-mixed)
[168.384447] Subtest legacy-engines-mixed: SKIP (0.000s)
[168.440995] [035/134] (867s left) kms_psr (psr-sprite-mmap-gtt)
[168.932470] Subtest psr-sprite-mmap-gtt: SKIP (0.000s)
[169.250102] [036/134] (867s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite)
[169.744879] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite
[169.748229] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[170.349359] [037/134] (866s left) gem_exec_whisper (basic-forked)
[170.422269] Starting subtest: basic-forked
[172.065533] Subtest basic-forked: SUCCESS (1.641s)
[172.294600] [038/134] (864s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[184.086282] Subtest dpms-mode-unset-non-lpsp: SKIP (0.000s)
[184.396500] [039/134] (852s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[184.888836] Starting subtest: 4-tiled-32bpp-rotate-90
[184.892185] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.000s)
[185.498640] [040/134] (851s left) gem_partial_pwrite_pread (writes-after-reads-display)
[185.561726] Starting subtest: writes-after-reads-display
[190.450984] Subtest writes-after-reads-display: SUCCESS (4.890s)
[190.620352] [041/134] (845s left) kms_color_pipeline (plane-lut1d)
[191.114768] Starting subtest: plane-lut1d
[191.395338] Subtest plane-lut1d: SKIP (0.281s)
[192.115877] [042/134] (844s left) gem_ctx_param (invalid-param-get)
[192.179133] Starting subtest: invalid-param-get
[192.181068] Subtest invalid-param-get: SUCCESS (0.000s)
[192.313702] [043/134] (844s left) vgem_basic (dmabuf-mmap)
[192.377605] Starting subtest: dmabuf-mmap
[192.391113] Subtest dmabuf-mmap: SUCCESS (0.017s)
[192.519193] [044/134] (844s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[193.013142] Starting subtest: cursor-rapid-movement-128x42
[193.072152] Subtest cursor-rapid-movement-128x42: SKIP (0.055s)
[193.672685] [045/134] (843s left) gem_exec_params (invalid-ring)
[193.737787] Starting subtest: invalid-ring
[193.739518] Subtest invalid-ring: SUCCESS (0.000s)
[193.892666] [046/134] (843s left) kms_fbcon_fbt (fbc)
[193.968361] Starting subtest: fbc
[197.417089] Subtest fbc: SUCCESS (3.459s)
[197.474640] [047/134] (839s left) vgem_basic (bad-fence)
[197.544811] Starting subtest: bad-fence
[197.547149] Subtest bad-fence: SUCCESS (0.000s)
[197.658642] [048/134] (839s left) kms_psr (fbc-pr-primary-mmap-cpu)
[198.145429] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s)
[198.456658] [049/134] (838s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[198.950724] Starting subtest: fbcpsr-tiling-4
[198.955693] Subtest fbcpsr-tiling-4: SKIP (0.000s)
[199.559622] [050/134] (837s left) i915_suspend (fence-restore-tiled2untiled)
[199.621939] Starting subtest: fence-restore-tiled2untiled
[217.521240] Subtest fence-restore-tiled2untiled: SUCCESS (1.772s)
[224.692598] [051/134] (819s left) gem_exec_schedule (implicit-read-write)
[224.768722] Starting subtest: implicit-read-write
[224.770462] Starting dynamic subtest: rcs0
[224.800763] Dynamic subtest rcs0: SUCCESS (0.032s)
[224.817061] Starting dynamic subtest: bcs0
[224.830418] Dynamic subtest bcs0: SUCCESS (0.029s)
[224.832188] Subtest implicit-read-write: SUCCESS (0.062s)
[225.107138] [052/134] (819s left) kms_plane_alpha_blend (constant-alpha-min)
[225.611022] Starting subtest: constant-alpha-min
[225.775028] Subtest constant-alpha-min: SKIP (0.156s)
[226.606932] [053/134] (817s left) gem_exec_balancer (parallel-keep-in-fence)
[226.672502] Subtest parallel-keep-in-fence: SKIP (0.000s)
[226.816501] [054/134] (817s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-msflip-blt)
[227.320099] Starting subtest: fbcpsr-2p-scndscrn-shrfb-msflip-blt
[227.323506] Subtest fbcpsr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s)
[227.951453] [055/134] (816s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[228.465251] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[228.468576] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[229.098491] [056/134] (815s left) kms_chamelium_frames (dp-frame-dump)
[229.681160] Subtest dp-frame-dump: SKIP (0.000s)
[230.104021] [057/134] (814s left) kms_selftest (drm_plane_helper)
[230.176204] Starting subtest: drm_plane_helper
[230.183053] Starting dynamic subtest: drm_test_check_plane_state
[230.282095] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.095s)
[230.306206] Starting dynamic subtest: drm_test_check_invalid_plane_state
[230.366986] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.083s)
[230.368978] Subtest drm_plane_helper: SUCCESS (0.186s)
[230.574267] [058/134] (814s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[231.067577] Starting subtest: cursor-vs-flip-varying-size
[265.263525] Subtest cursor-vs-flip-varying-size: SUCCESS (34.062s)
[265.998315] [059/134] (778s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[266.486597] Starting subtest: short-flip-before-cursor-toggle
[267.459750] Subtest short-flip-before-cursor-toggle: SUCCESS (0.973s)
[268.179958] [060/134] (776s left) kms_joiner (basic-force-big-joiner)
[268.669151] Starting subtest: basic-force-big-joiner
[268.672696] Subtest basic-force-big-joiner: SKIP (0.000s)
[269.294319] [061/134] (775s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf)
[269.790835] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.000s)
[270.086091] [062/134] (774s left) kms_psr (pr-sprite-plane-move)
[270.573107] Subtest pr-sprite-plane-move: SKIP (0.000s)
[270.891487] [063/134] (774s left) gem_exec_reloc (basic-cpu-gtt-active)
[270.956689] Starting subtest: basic-cpu-gtt-active
[271.068721] Subtest basic-cpu-gtt-active: SUCCESS (0.111s)
[272.107353] [064/134] (772s left) gem_pxp (verify-pxp-execution-after-suspend-resume)
[274.680829] Starting subtest: verify-pxp-execution-after-suspend-resume
[274.684953] Subtest verify-pxp-execution-after-suspend-resume: SKIP (0.000s)
[274.817462] [065/134] (770s left) gem_exec_fence (parallel)
[274.999509] Subtest parallel: SKIP (0.000s)
[275.411452] [066/134] (769s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[275.897507] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.000s)
[276.221335] [067/134] (769s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[276.716515] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[276.719812] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[277.331389] [068/134] (767s left) template (a)
[277.394181] Starting subtest: A
[277.395931] Subtest A: SUCCESS (0.000s)
[277.523238] [069/134] (767s left) gem_spin_batch (user-each)
[277.590903] Starting subtest: user-each
[280.926727] Subtest user-each: SUCCESS (3.334s)
[281.174803] [070/134] (764s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[281.667725] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[281.671374] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[282.310587] [071/134] (763s left) gem_mmap_wc (bad-object)
[282.369743] Starting subtest: bad-object
[282.371500] Subtest bad-object: SUCCESS (0.000s)
[282.508730] [072/134] (763s left) kms_psr (psr-cursor-blt)
[282.990658] Subtest psr-cursor-blt: SKIP (0.000s)
[283.313716] [073/134] (762s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[283.800299] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[283.801884] Starting dynamic subtest: pipe-A
[283.807067] Dynamic subtest pipe-A: SKIP (0.002s)
[283.823702] Starting dynamic subtest: pipe-B
[283.828329] Dynamic subtest pipe-B: SKIP (0.001s)
[283.831358] Subtest planes-downscale-factor-0-75-unity-scaling: SKIP (0.005s)
[284.421727] [074/134] (761s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[284.489583] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s)
[284.571677] [075/134] (761s left) gem_ctx_exec (basic-nohangcheck)
[284.633461] Starting subtest: basic-nohangcheck
[284.681367] Subtest basic-nohangcheck: SUCCESS (0.049s)
[284.834437] [076/134] (760s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[285.326329] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[285.329622] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[285.934457] [077/134] (759s left) kms_vrr (lobf)
[286.421864] Starting subtest: lobf
[286.425287] Subtest lobf: SKIP (0.000s)
[287.037322] [078/134] (758s left) gem_mmap (bad-size)
[287.101503] Starting subtest: bad-size
[287.103371] Subtest bad-size: SUCCESS (0.001s)
[287.266654] [079/134] (758s left) syncobj_timeline (reset-unsignaled)
[287.324749] Starting subtest: reset-unsignaled
[287.326481] Subtest reset-unsignaled: SUCCESS (0.000s)
[287.469048] [080/134] (758s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[287.953511] Starting subtest: flip-vs-cursor-crc-legacy
[288.489025] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.535s)
[289.227981] [081/134] (756s left) syncobj_timeline (invalid-transfer-illegal-handle)
[289.288904] Starting subtest: invalid-transfer-illegal-handle
[289.290578] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[289.421325] [082/134] (756s left) kms_vrr (seamless-rr-switch-drrs)
[289.910427] Starting subtest: seamless-rr-switch-drrs
[289.917484] Subtest seamless-rr-switch-drrs: SKIP (0.000s)
[290.548116] [083/134] (755s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[291.040051] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[291.043320] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[291.649705] [084/134] (754s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[292.140028] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[292.143185] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[292.757552] [085/134] (753s left) gem_exec_async (concurrent-writes)
[292.832663] Starting subtest: concurrent-writes
[292.834460] Starting dynamic subtest: rcs0
[292.836224] Dynamic subtest rcs0: SUCCESS (0.002s)
[292.853782] Starting dynamic subtest: bcs0
[292.855614] Dynamic subtest bcs0: SUCCESS (0.001s)
[292.873518] Starting dynamic subtest: vcs0
[292.875461] Dynamic subtest vcs0: SUCCESS (0.002s)
[292.877377] Subtest concurrent-writes: SUCCESS (0.010s)
[293.108545] [086/134] (753s left) kms_frontbuffer_tracking (psr-1p-rte)
[293.609088] Starting subtest: psr-1p-rte
[293.612278] Subtest psr-1p-rte: SKIP (0.000s)
[294.214303] [087/134] (752s left) gem_flink_basic (basic)
[294.278269] Starting subtest: basic
[294.280121] Subtest basic: SUCCESS (0.000s)
[294.426807] [088/134] (752s left) kms_async_flips (async-flip-suspend-resume)
[294.916742] Starting subtest: async-flip-suspend-resume
[295.038454] Starting dynamic subtest: pipe-A-HDMI-A-1
[313.568025] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.621s)
[313.746632] Starting dynamic subtest: pipe-B-HDMI-A-1
[332.564639] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.637s)
[332.566273] Subtest async-flip-suspend-resume: SUCCESS (3.737s)
[339.447558] [089/134] (713s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[339.963741] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[339.967038] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[340.582360] [090/134] (712s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[340.648315] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[340.753247] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.103s)
[340.878163] [091/134] (711s left) syncobj_timeline (etime-multi-wait-submitted)
[340.941515] Starting subtest: etime-multi-wait-submitted
[341.050999] Subtest etime-multi-wait-submitted: SUCCESS (0.106s)
[341.204562] [092/134] (711s left) kms_flip (absolute-wf_vblank)
[341.702365] Starting subtest: absolute-wf_vblank
[341.704172] Starting dynamic subtest: A-VGA1
[349.591394] Dynamic subtest A-VGA1: SUCCESS (7.763s)
[349.612668] Starting dynamic subtest: B-VGA1
[357.359360] Dynamic subtest B-VGA1: SUCCESS (7.718s)
[357.378087] Starting dynamic subtest: A-HDMI-A1
[365.120726] Dynamic subtest A-HDMI-A1: SUCCESS (7.739s)
[365.142367] Starting dynamic subtest: B-HDMI-A1
[373.045447] Dynamic subtest B-HDMI-A1: SUCCESS (7.912s)
[373.047203] Subtest absolute-wf_vblank: SUCCESS (31.147s)
[373.825904] [093/134] (679s left) gem_exec_params (larger-than-life-batch)
[373.891194] Starting subtest: larger-than-life-batch
[373.894843] Subtest larger-than-life-batch: SKIP (0.000s)
[374.054886] [094/134] (678s left) i915_pm_freq_api (freq-basic-api)
[374.115072] Subtest freq-basic-api: SKIP (0.000s)
[374.183417] [095/134] (678s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[374.670477] Starting subtest: cursorB-vs-flipA-atomic
[374.673869] Subtest cursorB-vs-flipA-atomic: SKIP (0.001s)
[375.295696] [096/134] (677s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[375.783463] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[375.827450] Starting dynamic subtest: pipe-A-plane-0
[375.830840] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[375.856053] Starting dynamic subtest: pipe-A-plane-1
[375.859584] Dynamic subtest pipe-A-plane-1: SKIP (0.000s)
[375.875148] Starting dynamic subtest: pipe-A-plane-2
[375.879135] Dynamic subtest pipe-A-plane-2: SKIP (0.000s)
[376.072177] Starting dynamic subtest: pipe-B-plane-0
[376.075816] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[376.091512] Starting dynamic subtest: pipe-B-plane-1
[376.094859] Dynamic subtest pipe-B-plane-1: SKIP (0.000s)
[376.110694] Starting dynamic subtest: pipe-B-plane-2
[376.113952] Dynamic subtest pipe-B-plane-2: SKIP (0.000s)
[376.173401] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SKIP (0.391s)
[376.899644] [097/134] (676s left) kms_big_fb (linear-16bpp-rotate-180)
[377.401113] Starting subtest: linear-16bpp-rotate-180
[378.735522] Subtest linear-16bpp-rotate-180: SUCCESS (1.333s)
[379.363096] [098/134] (673s left) gem_exec_whisper (basic-queues-priority)
[379.432436] Starting subtest: basic-queues-priority
[379.436529] Subtest basic-queues-priority: SKIP (0.001s)
[379.653400] [099/134] (673s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[380.147731] Starting subtest: fbcpsr-rgb101010-draw-render
[380.151113] Subtest fbcpsr-rgb101010-draw-render: SKIP (0.000s)
[380.756301] [100/134] (672s left) api_intel_bb (object-reloc-keep-cache)
[380.818938] Starting subtest: object-reloc-keep-cache
[380.822986] Subtest object-reloc-keep-cache: SUCCESS (0.003s)
[380.992551] [101/134] (672s left) perf_pmu (idle)
[381.051433] Starting subtest: idle
[381.053788] Starting dynamic subtest: rcs0
[381.566104] Dynamic subtest rcs0: SUCCESS (0.514s)
[381.587019] Starting dynamic subtest: bcs0
[382.087097] Dynamic subtest bcs0: SUCCESS (0.515s)
[382.113631] Starting dynamic subtest: vcs0
[382.608186] Dynamic subtest vcs0: SUCCESS (0.522s)
[382.610078] Subtest idle: SUCCESS (1.558s)
[382.758896] [102/134] (670s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[383.244454] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[383.249922] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[383.878797] [103/134] (669s left) perf (unprivileged-single-ctx-counters)
[384.035181] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[384.095196] [104/134] (669s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[384.156752] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.000s)
[384.233098] [105/134] (669s left) gem_exec_parallel (fds)
[384.308700] Starting subtest: fds
[384.310580] Starting dynamic subtest: rcs0
[386.146015] Dynamic subtest rcs0: SUCCESS (1.834s)
[386.166524] Starting dynamic subtest: bcs0
[388.017747] Dynamic subtest bcs0: SUCCESS (1.869s)
[388.020143] Subtest fds: SUCCESS (3.707s)
[388.269591] [106/134] (665s left) gem_userptr_blits (create-destroy-unsync)
[388.334362] Subtest create-destroy-unsync: SKIP (0.000s)
[388.515349] [107/134] (665s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping)
[389.002503] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping
[389.050360] Starting dynamic subtest: pipe-A-plane-0
[389.053861] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[389.075501] Starting dynamic subtest: pipe-A-plane-1
[389.078893] Dynamic subtest pipe-A-plane-1: SKIP (0.000s)
[389.096796] Starting dynamic subtest: pipe-A-plane-2
[389.099975] Dynamic subtest pipe-A-plane-2: SKIP (0.000s)
[389.289664] Starting dynamic subtest: pipe-B-plane-0
[389.293250] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[389.310139] Starting dynamic subtest: pipe-B-plane-1
[389.313426] Dynamic subtest pipe-B-plane-1: SKIP (0.000s)
[389.328632] Starting dynamic subtest: pipe-B-plane-2
[389.331957] Dynamic subtest pipe-B-plane-2: SKIP (0.000s)
[389.360314] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping: SKIP (0.358s)
[390.080580] [108/134] (663s left) gem_ctx_param (invalid-param-set)
[390.144177] Starting subtest: invalid-param-set
[390.146093] Subtest invalid-param-set: SUCCESS (0.000s)
[390.286189] [109/134] (663s left) gem_ctx_bad_destroy (invalid-default-ctx)
[390.346167] Starting subtest: invalid-default-ctx
[390.348021] Subtest invalid-default-ctx: SUCCESS (0.000s)
[390.486324] [110/134] (663s left) gem_exec_await (wide-all)
[390.591336] Starting subtest: wide-all
[412.450530] Subtest wide-all: SUCCESS (21.851s)
[412.705666] [111/134] (641s left) i915_pm_rpm (gem-execbuf-stress)
[424.618143] Subtest gem-execbuf-stress: SKIP (0.000s)
[424.940656] [112/134] (629s left) kms_cdclk (mode-transition)
[425.002570] Subtest mode-transition: SKIP (0.000s)
[425.068639] [113/134] (629s left) kms_plane_scaling (planes-downscale-factor-0-5)
[425.553867] Starting subtest: planes-downscale-factor-0-5
[425.555530] Starting dynamic subtest: pipe-A
[425.560375] Dynamic subtest pipe-A: SKIP (0.001s)
[425.578544] Starting dynamic subtest: pipe-B
[425.583267] Dynamic subtest pipe-B: SKIP (0.001s)
[425.586302] Subtest planes-downscale-factor-0-5: SKIP (0.005s)
[426.174383] [114/134] (628s left) kms_pm_rpm (system-suspend-idle)
[437.965190] Subtest system-suspend-idle: SKIP (0.000s)
[438.284556] [115/134] (616s left) kms_psr (fbc-psr-suspend)
[438.775985] Subtest fbc-psr-suspend: SKIP (0.000s)
[439.086140] [116/134] (615s left) kms_addfb_basic (addfb25-modifier-no-flag)
[439.586386] Starting subtest: addfb25-modifier-no-flag
[439.588151] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[440.209502] [117/134] (614s left) kms_big_fb (y-tiled-32bpp-rotate-180)
[440.709079] Starting subtest: y-tiled-32bpp-rotate-180
[440.712353] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s)
[441.333052] [118/134] (613s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[441.839030] Starting subtest: yf-tiled-8bpp-rotate-270
[441.842348] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[442.459132] [119/134] (612s left) gem_exec_parallel (contexts)
[442.530562] Starting subtest: contexts
[442.532404] Starting dynamic subtest: rcs0
[444.259035] Dynamic subtest rcs0: SUCCESS (1.726s)
[444.278625] Starting dynamic subtest: bcs0
[445.841779] Dynamic subtest bcs0: SUCCESS (1.580s)
[445.844012] Subtest contexts: SUCCESS (3.311s)
[446.083035] [120/134] (608s left) core_getversion (basic)
[446.142049] Starting subtest: basic
[446.146107] Subtest basic: SUCCESS (0.000s)
[446.271152] [121/134] (608s left) perf_pmu (interrupts)
[446.330170] Starting subtest: interrupts
[447.393001] Subtest interrupts: SUCCESS (1.062s)
[447.558464] [122/134] (607s left) drm_read (empty-block)
[448.094921] Starting subtest: empty-block
[449.093808] Subtest empty-block: SUCCESS (1.000s)
[449.742322] [123/134] (605s left) gem_exec_schedule (smoketest)
[449.824806] Subtest smoketest: SKIP (0.000s)
[450.022562] [124/134] (604s left) kms_cursor_crc (cursor-onscreen-32x10)
[450.509024] Starting subtest: cursor-onscreen-32x10
[450.567778] Subtest cursor-onscreen-32x10: SKIP (0.054s)
[451.184004] [125/134] (603s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[451.246385] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s)
[451.315635] [126/134] (603s left) gen7_exec_parse (chained-batch)
[451.380053] Subtest chained-batch: SKIP (0.000s)
[451.456729] [127/134] (603s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc)
[451.518081] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s)
[451.588746] [128/134] (603s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling)
[451.651260] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.000s)
[451.728997] [129/134] (603s left) kms_flip (2x-flip-vs-blocking-wf-vblank)
[452.214646] Starting subtest: 2x-flip-vs-blocking-wf-vblank
[452.216316] Starting dynamic subtest: AB-VGA1-HDMI-A1
[482.948126] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (30.719s)
[482.949959] Subtest 2x-flip-vs-blocking-wf-vblank: SUCCESS (30.724s)
[483.782378] [130/134] (571s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[484.270062] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[484.273333] Subtest plane-all-modeset-transition-fencing-internal-panels: SKIP (0.000s)
[484.890753] [131/134] (570s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[485.381291] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[485.384739] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[485.995896] [132/134] (569s left) kms_cursor_crc (cursor-tearing-position-change)
[486.490428] Starting subtest: cursor-tearing-position-change
[486.492562] Starting dynamic subtest: pipe-A-HDMI-A-1
[486.829783] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.346s)
[486.845882] Starting dynamic subtest: pipe-B-HDMI-A-1
[487.211363] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.379s)
[487.213120] Subtest cursor-tearing-position-change: SUCCESS (0.730s)
[487.923938] [133/134] (567s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[488.415969] Starting subtest: 2x-flip-vs-cursor-atomic
[488.419252] Subtest 2x-flip-vs-cursor-atomic: SKIP (0.002s)
[489.029718] [134/134] (566s left) gem_exec_reloc (basic-softpin)
[489.091910] Starting subtest: basic-softpin
[489.093599] Subtest basic-softpin: SUCCESS (0.001s)
[490.135735] Closing watchdogs
results: parsing output: 0/ for test: prime_vgem
results: parsing output: 1/ for test: kms_chamelium_hpd
results: parsing output: 2/ for test: syncobj_timeline
results: parsing output: 3/ for test: gem_render_copy
results: parsing output: 4/ for test: api_intel_allocator
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: gem_ctx_create
results: parsing output: 7/ for test: kms_lease
results: parsing output: 8/ for test: kms_rotation_crc
results: parsing output: 9/ for test: kms_draw_crc
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: kms_psr2_sf
results: parsing output: 12/ for test: gem_ppgtt
results: parsing output: 13/ for test: kms_big_fb
results: parsing output: 14/ for test: i915_drm_fdinfo
results: parsing output: 15/ for test: gem_mmap_gtt
results: parsing output: 16/ for test: gem_exec_balancer
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: gem_render_copy_redux
results: parsing output: 20/ for test: gem_workarounds
results: parsing output: 21/ for test: gem_bad_reloc
results: parsing output: 22/ for test: kms_content_protection
results: parsing output: 23/ for test: drm_read
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: perf
results: parsing output: 26/ for test: kms_busy
results: parsing output: 27/ for test: gem_softpin
results: parsing output: 28/ for test: kms_flip_scaled_crc
results: parsing output: 29/ for test: kms_cursor_legacy
results: parsing output: 30/ for test: gem_compute
results: parsing output: 31/ for test: kms_flip_scaled_crc
results: parsing output: 32/ for test: kms_atomic_transition
results: parsing output: 33/ for test: gem_ctx_persistence
results: parsing output: 34/ for test: kms_psr
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: gem_exec_whisper
results: parsing output: 37/ for test: kms_pm_rpm
results: parsing output: 38/ for test: kms_big_fb
results: parsing output: 39/ for test: gem_partial_pwrite_pread
results: parsing output: 40/ for test: kms_color_pipeline
results: parsing output: 41/ for test: gem_ctx_param
results: parsing output: 42/ for test: vgem_basic
results: parsing output: 43/ for test: kms_cursor_crc
results: parsing output: 44/ for test: gem_exec_params
results: parsing output: 45/ for test: kms_fbcon_fbt
results: parsing output: 46/ for test: vgem_basic
results: parsing output: 47/ for test: kms_psr
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: i915_suspend
results: parsing output: 50/ for test: gem_exec_schedule
results: parsing output: 51/ for test: kms_plane_alpha_blend
results: parsing output: 52/ for test: gem_exec_balancer
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_chamelium_frames
results: parsing output: 56/ for test: kms_selftest
results: parsing output: 57/ for test: kms_cursor_legacy
results: parsing output: 58/ for test: kms_cursor_legacy
results: parsing output: 59/ for test: kms_joiner
results: parsing output: 60/ for test: kms_psr2_sf
results: parsing output: 61/ for test: kms_psr
results: parsing output: 62/ for test: gem_exec_reloc
results: parsing output: 63/ for test: gem_pxp
results: parsing output: 64/ for test: gem_exec_fence
results: parsing output: 65/ for test: kms_psr
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: template
results: parsing output: 68/ for test: gem_spin_batch
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_mmap_wc
results: parsing output: 71/ for test: kms_psr
results: parsing output: 72/ for test: kms_plane_scaling
results: parsing output: 73/ for test: kms_ccs
results: parsing output: 74/ for test: gem_ctx_exec
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_vrr
results: parsing output: 77/ for test: gem_mmap
results: parsing output: 78/ for test: syncobj_timeline
results: parsing output: 79/ for test: kms_cursor_legacy
results: parsing output: 80/ for test: syncobj_timeline
results: parsing output: 81/ for test: kms_vrr
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: gem_exec_async
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: gem_flink_basic
results: parsing output: 87/ for test: kms_async_flips
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: syncobj_timeline
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: kms_flip
results: parsing output: 92/ for test: gem_exec_params
results: parsing output: 93/ for test: i915_pm_freq_api
results: parsing output: 94/ for test: kms_cursor_legacy
results: parsing output: 95/ for test: kms_plane
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: gem_exec_whisper
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: api_intel_bb
results: parsing output: 100/ for test: perf_pmu
results: parsing output: 101/ for test: kms_cursor_legacy
results: parsing output: 102/ for test: perf
results: parsing output: 103/ for test: kms_ccs
results: parsing output: 104/ for test: gem_exec_parallel
results: parsing output: 105/ for test: gem_userptr_blits
results: parsing output: 106/ for test: kms_plane
results: parsing output: 107/ for test: gem_ctx_param
results: parsing output: 108/ for test: gem_ctx_bad_destroy
results: parsing output: 109/ for test: gem_exec_await
results: parsing output: 110/ for test: i915_pm_rpm
results: parsing output: 111/ for test: kms_cdclk
results: parsing output: 112/ for test: kms_plane_scaling
results: parsing output: 113/ for test: kms_pm_rpm
results: parsing output: 114/ for test: kms_psr
results: parsing output: 115/ for test: kms_addfb_basic
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: kms_big_fb
results: parsing output: 118/ for test: gem_exec_parallel
results: parsing output: 119/ for test: core_getversion
results: parsing output: 120/ for test: perf_pmu
results: parsing output: 121/ for test: drm_read
results: parsing output: 122/ for test: gem_exec_schedule
results: parsing output: 123/ for test: kms_cursor_crc
results: parsing output: 124/ for test: kms_ccs
results: parsing output: 125/ for test: gen7_exec_parse
results: parsing output: 126/ for test: kms_ccs
results: parsing output: 127/ for test: kms_flip_scaled_crc
results: parsing output: 128/ for test: kms_flip
results: parsing output: 129/ for test: kms_atomic_transition
results: parsing output: 130/ for test: kms_big_fb
results: parsing output: 131/ for test: kms_cursor_crc
results: parsing output: 132/ for test: kms_cursor_legacy
results: parsing output: 133/ for test: gem_exec_reloc
Done.