[72.605695] Initializing watchdogs
[72.605825]   /dev/watchdog0
[72.628091] [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.635823] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[72.639471] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[72.643968] [001/133] (960s left) gem_reg_read (bad-register)
[72.714726] Starting subtest: bad-register
[72.716304] Subtest bad-register: SUCCESS (0.000s)
[72.811414] [002/133] (960s left) kms_flip (2x-flip-vs-rmfb-interruptible)
[73.317024] Starting subtest: 2x-flip-vs-rmfb-interruptible
[73.318727] Starting dynamic subtest: AB-VGA1-HDMI-A1
[103.690842] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (30.372s)
[103.693082] Subtest 2x-flip-vs-rmfb-interruptible: SUCCESS (30.375s)
[104.481663] [003/133] (928s left) api_intel_bb (bb-with-allocator)
[104.542835] Starting subtest: bb-with-allocator
[104.546202] Subtest bb-with-allocator: SKIP (0.000s)
[104.682891] [004/133] (928s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[105.191853] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[105.199758] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.001s)
[105.790577] [005/133] (927s left) gem_exec_fence (syncobj-repeat)
[106.034796] Starting subtest: syncobj-repeat
[106.470591] Subtest syncobj-repeat: SUCCESS (0.436s)
[106.863756] [FACT gem_exec_fence (syncobj-repeat)] new: kernel.kmod_is_loaded.vgem: true
[106.867793] [006/133] (926s left) syncobj_basic (bad-destroy-pad)
[106.930483] Starting subtest: bad-destroy-pad
[106.932120] Subtest bad-destroy-pad: SUCCESS (0.000s)
[107.062411] [007/133] (926s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[107.560548] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[107.563746] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[108.177234] [008/133] (925s left) gem_exec_schedule (preemptive-hang)
[108.248105] Subtest preemptive-hang: SKIP (0.000s)
[108.477487] [009/133] (925s left) i915_hangman (error-state-basic)
[108.540483] Starting subtest: error-state-basic
[108.545896] Subtest error-state-basic: SUCCESS (0.005s)
[108.620697] [010/133] (924s left) kms_chamelium_color (gamma)
[109.111816] Subtest gamma: SKIP (0.000s)
[109.418495] [011/133] (924s left) syncobj_wait (single-wait-all-signaled)
[109.478959] Starting subtest: single-wait-all-signaled
[109.480655] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[109.589524] [012/133] (924s left) kms_psr (fbc-pr-cursor-blt)
[110.082768] Subtest fbc-pr-cursor-blt: SKIP (0.000s)
[110.382477] [013/133] (923s left) gem_exec_schedule (preempt-queue-contexts-chain)
[110.452151] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[110.693888] [014/133] (923s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen)
[111.188671] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen
[112.720266] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (1.533s)
[113.356667] [015/133] (920s left) kms_vblank (wait-forked-busy-hang)
[113.844134] Starting subtest: wait-forked-busy-hang
[113.846213] Starting dynamic subtest: pipe-A-HDMI-A-1
[119.936946] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.094s)
[119.947067] Starting dynamic subtest: pipe-B-HDMI-A-1
[125.952699] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (6.015s)
[125.957216] Subtest wait-forked-busy-hang: SUCCESS (12.112s)
[126.670850] [016/133] (907s left) perf_pmu (busy-accuracy-50)
[126.735142] Starting subtest: busy-accuracy-50
[126.736965] Starting dynamic subtest: rcs0
[126.740387] Dynamic subtest rcs0: SKIP (0.000s)
[126.756653] Starting dynamic subtest: bcs0
[126.761083] Dynamic subtest bcs0: SKIP (0.000s)
[126.777581] Starting dynamic subtest: vcs0
[126.782049] Dynamic subtest vcs0: SKIP (0.000s)
[126.786187] Subtest busy-accuracy-50: SKIP (0.001s)
[126.868655] [017/133] (907s left) gem_softpin (evict-prime-sanity-check)
[126.928728] Subtest evict-prime-sanity-check: SKIP (0.000s)
[127.034561] [018/133] (907s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[127.531733] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[128.949256] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SUCCESS (1.420s)
[129.596209] [019/133] (904s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier)
[130.085182] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier
[130.126385] Starting dynamic subtest: pipe-A-plane-0
[130.129740] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[130.147461] Starting dynamic subtest: pipe-A-plane-1
[130.151039] Dynamic subtest pipe-A-plane-1: SKIP (0.000s)
[130.161056] Starting dynamic subtest: pipe-A-plane-2
[130.164264] Dynamic subtest pipe-A-plane-2: SKIP (0.000s)
[130.365095] Starting dynamic subtest: pipe-B-plane-0
[130.368201] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[130.381765] Starting dynamic subtest: pipe-B-plane-1
[130.385166] Dynamic subtest pipe-B-plane-1: SKIP (0.000s)
[130.396978] Starting dynamic subtest: pipe-B-plane-2
[130.400281] Dynamic subtest pipe-B-plane-2: SKIP (0.000s)
[130.455531] Subtest pixel-format-4-tiled-bmg-ccs-modifier: SKIP (0.370s)
[131.168594] [020/133] (903s left) kms_chamelium_audio (hdmi-audio-edid)
[131.733539] Subtest hdmi-audio-edid: SKIP (0.000s)
[132.154051] [021/133] (902s left) gem_pread (display)
[132.212739] Starting subtest: display
[133.475778] Subtest display: SUCCESS (1.260s)
[133.619577] [022/133] (900s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[134.121843] Starting subtest: 4-tiled-32bpp-rotate-180
[134.125503] Subtest 4-tiled-32bpp-rotate-180: SKIP (0.000s)
[134.728235] [023/133] (899s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[134.788014] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s)
[134.854906] [024/133] (899s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled)
[134.913360] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled
[135.019836] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.105s)
[135.159453] [025/133] (899s left) gem_exec_whisper (basic-contexts-all)
[135.228566] Starting subtest: basic-contexts-all
[136.622507] Subtest basic-contexts-all: SUCCESS (1.392s)
[136.873131] [026/133] (897s left) kms_invalid_mode (bad-hsync-end)
[137.363320] Starting subtest: bad-hsync-end
[137.365069] Starting dynamic subtest: pipe-A-HDMI-A-1
[137.429212] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.066s)
[137.440674] Starting dynamic subtest: pipe-B-HDMI-A-1
[137.442252] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s)
[137.443936] Subtest bad-hsync-end: SUCCESS (0.069s)
[138.151898] [027/133] (896s left) i915_suspend (basic-s3-without-i915)
[138.209237] Starting subtest: basic-s3-without-i915
[157.371089] Subtest basic-s3-without-i915: SUCCESS (3.290s)
[162.464443] [028/133] (877s left) kms_addfb_basic (bad-pitch-65536)
[162.530957] Starting subtest: bad-pitch-65536
[162.532703] Subtest bad-pitch-65536: SUCCESS (0.000s)
[163.597201] [029/133] (876s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render)
[164.114678] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render
[164.118064] Subtest psr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[164.765983] [030/133] (875s left) gem_flink_basic (double-flink)
[164.827597] Starting subtest: double-flink
[164.829473] Subtest double-flink: SUCCESS (0.000s)
[165.018397] [031/133] (874s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[165.529502] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[165.532984] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[166.153691] [032/133] (873s left) kms_big_fb (linear-16bpp-rotate-90)
[166.662194] Starting subtest: linear-16bpp-rotate-90
[166.819474] Subtest linear-16bpp-rotate-90: SKIP (0.152s)
[167.453377] [033/133] (872s left) gen7_exec_parse (oacontrol-tracking)
[167.525901] Subtest oacontrol-tracking: SKIP (0.000s)
[167.604345] [034/133] (872s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[167.666643] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.000s)
[167.734776] [035/133] (872s left) prime_vgem (coherency-blt)
[167.808154] Starting subtest: coherency-blt
[168.445128] Subtest coherency-blt: SUCCESS (0.623s)
[168.636291] [036/133] (871s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[169.130094] Starting subtest: compare-crc-sanitycheck-nv12
[169.131901] Starting dynamic subtest: pipe-A-HDMI-A-1
[169.135354] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[169.148634] Starting dynamic subtest: pipe-B-HDMI-A-1
[169.151929] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[169.155181] Subtest compare-crc-sanitycheck-nv12: SKIP (0.004s)
[169.758249] [037/133] (870s left) kms_chamelium_hpd (hdmi-hpd)
[170.344174] Subtest hdmi-hpd: SKIP (0.000s)
[170.761322] [038/133] (869s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-modifier)
[171.258197] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-modifier
[171.298021] Starting dynamic subtest: pipe-A-plane-0
[171.301581] Dynamic subtest pipe-A-plane-0: SKIP (0.000s)
[171.320910] Starting dynamic subtest: pipe-A-plane-1
[171.324395] Dynamic subtest pipe-A-plane-1: SKIP (0.000s)
[171.339367] Starting dynamic subtest: pipe-A-plane-2
[171.343267] Dynamic subtest pipe-A-plane-2: SKIP (0.000s)
[171.551151] Starting dynamic subtest: pipe-B-plane-0
[171.555378] Dynamic subtest pipe-B-plane-0: SKIP (0.000s)
[171.571654] Starting dynamic subtest: pipe-B-plane-1
[171.575064] Dynamic subtest pipe-B-plane-1: SKIP (0.000s)
[171.591241] Starting dynamic subtest: pipe-B-plane-2
[171.595642] Dynamic subtest pipe-B-plane-2: SKIP (0.000s)
[171.635080] Subtest pixel-format-4-tiled-mtl-rc-ccs-modifier: SKIP (0.371s)
[172.379216] [039/133] (868s left) gem_mmap_offset (open-flood)
[172.441552] Starting subtest: open-flood
[194.098679] Subtest open-flood: SUCCESS (21.513s)
[194.334241] [040/133] (846s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[194.827664] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[194.831104] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[195.439741] [041/133] (845s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[195.501676] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[195.602414] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.101s)
[195.705968] [042/133] (845s left) vgem_basic (create)
[195.769270] Starting subtest: create
[195.771690] Subtest create: SUCCESS (0.000s)
[195.866622] [043/133] (844s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[196.360821] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[196.364178] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[196.971282] [044/133] (843s left) kms_psr (fbc-psr-cursor-plane-move)
[197.461640] Subtest fbc-psr-cursor-plane-move: SKIP (0.000s)
[197.764523] [045/133] (843s left) kms_vblank (accuracy-idle)
[198.252905] Starting subtest: accuracy-idle
[198.254976] Starting dynamic subtest: pipe-A-HDMI-A-1
[200.456126] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.203s)
[200.472313] Starting dynamic subtest: pipe-B-HDMI-A-1
[202.706542] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.248s)
[202.708283] Subtest accuracy-idle: SUCCESS (4.455s)
[203.410878] [046/133] (837s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[203.472450] Starting subtest: cpuset-medium-copy-XY
[205.716137] Subtest cpuset-medium-copy-XY: SUCCESS (2.245s)
[205.861627] [047/133] (835s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[206.433933] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.000s)
[206.760993] [048/133] (834s left) kms_flip (2x-flip-vs-suspend-interruptible)
[207.257399] Starting subtest: 2x-flip-vs-suspend-interruptible
[207.258979] Starting dynamic subtest: AB-VGA1-HDMI-A1
[394.648828] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[402.342190] Closing watchdogs
[402.348567] Initializing watchdogs
[402.348637]   /dev/watchdog0
[402.374771] [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)
[402.391340] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[402.392991] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[402.393745] [FACT before any test] new: kernel.kmod_is_loaded.vgem: true
[402.398072] [049/133] (645s left) kms_busy (extended-pageflip-hang-newfb)
[402.907466] Starting subtest: extended-pageflip-hang-newfb
[402.909256] Starting dynamic subtest: pipe-A
[408.746095] Dynamic subtest pipe-A: SUCCESS (5.704s)
[408.762420] Starting dynamic subtest: pipe-B
[414.757739] Dynamic subtest pipe-B: SUCCESS (5.941s)
[414.759555] Subtest extended-pageflip-hang-newfb: SUCCESS (11.650s)
[415.492056] [050/133] (632s left) kms_draw_crc (draw-method-render)
[415.983595] Starting subtest: draw-method-render
[415.985366] Starting dynamic subtest: xrgb8888-untiled
[416.269650] Dynamic subtest xrgb8888-untiled: SUCCESS (0.284s)
[416.291955] Starting dynamic subtest: rgb565-untiled
[416.554673] Dynamic subtest rgb565-untiled: SUCCESS (0.281s)
[416.573296] Starting dynamic subtest: xrgb2101010-untiled
[416.872664] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.313s)
[416.887742] Starting dynamic subtest: xbgr16161616f-untiled
[417.207285] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.330s)
[417.225449] Starting dynamic subtest: xrgb8888-xtiled
[417.374569] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.164s)
[417.390077] Starting dynamic subtest: rgb565-xtiled
[417.524585] Dynamic subtest rgb565-xtiled: SUCCESS (0.147s)
[417.541566] Starting dynamic subtest: xrgb2101010-xtiled
[417.692252] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.164s)
[417.707624] Starting dynamic subtest: xbgr16161616f-xtiled
[417.876101] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.181s)
[417.878192] Subtest draw-method-render: SUCCESS (1.883s)
[418.520805] [051/133] (629s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[418.587307] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s)
[418.658426] [052/133] (629s left) syncobj_wait (invalid-single-wait-unsubmitted)
[418.730132] Starting subtest: invalid-single-wait-unsubmitted
[418.732022] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[418.865456] [053/133] (629s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-factor-0-25)
[419.356752] Starting subtest: planes-downscale-factor-0-5-upscale-factor-0-25
[419.358696] Starting dynamic subtest: pipe-A
[419.365719] Dynamic subtest pipe-A: SKIP (0.001s)
[419.380567] Starting dynamic subtest: pipe-B
[419.385517] Dynamic subtest pipe-B: SKIP (0.001s)
[419.388844] Subtest planes-downscale-factor-0-5-upscale-factor-0-25: SKIP (0.006s)
[419.960759] [054/133] (628s left) gen9_exec_parse (unaligned-jump)
[420.027673] Subtest unaligned-jump: SKIP (0.000s)
[420.104215] [055/133] (628s left) gem_eio (in-flight-suspend)
[420.169163] Starting subtest: in-flight-suspend
[457.564811] Subtest in-flight-suspend: SUCCESS (6.486s)
[465.610959] [056/133] (590s left) kms_pm_rpm (universal-planes)
[477.426074] Subtest universal-planes: SKIP (0.000s)
[477.733085] [057/133] (578s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[478.245547] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[478.249356] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[478.850997] [058/133] (576s left) api_intel_bb (simple-bb)
[478.912507] Starting subtest: simple-bb
[478.914248] Subtest simple-bb: SUCCESS (0.002s)
[479.089119] [059/133] (576s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[479.587374] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[479.590684] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[480.216147] [060/133] (575s left) kms_psr (pr-cursor-mmap-cpu)
[480.711351] Subtest pr-cursor-mmap-cpu: SKIP (0.000s)
[481.023620] [061/133] (574s left) kms_cursor_crc (cursor-random-32x10)
[481.518896] Starting subtest: cursor-random-32x10
[481.575592] Subtest cursor-random-32x10: SKIP (0.054s)
[482.204681] [062/133] (573s left) gem_pwrite (basic-self)
[482.271636] Starting subtest: basic-self
[482.358985] Subtest basic-self: SUCCESS (0.087s)
[482.511298] [063/133] (573s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[482.572858] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[482.574642] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[482.709157] [064/133] (573s left) prime_mmap (test_userptr)
[482.768347] Starting subtest: test_userptr
[482.770117] Starting dynamic subtest: test_userptr-smem
[482.772104] Dynamic subtest test_userptr-smem: SUCCESS (0.000s)
[482.774203] Subtest test_userptr: SUCCESS (0.003s)
[482.930893] [065/133] (573s left) gem_create (hog-create)
[482.995641] Starting subtest: hog-create
[482.997606] Starting dynamic subtest: smem0
[515.284129] Dynamic subtest smem0: SUCCESS (32.257s)
[515.286568] Subtest hog-create: SUCCESS (32.260s)
[515.534696] [066/133] (540s left) syncobj_timeline (invalid-signal-illegal-handle)
[515.595794] Starting subtest: invalid-signal-illegal-handle
[515.597536] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[515.729115] [067/133] (540s left) gem_userptr_blits (unsync-unmap)
[515.796164] Subtest unsync-unmap: SKIP (0.000s)
[515.963203] [068/133] (540s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt)
[516.455133] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt
[516.458664] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[517.063505] [069/133] (539s left) kms_content_protection (dp-mst-type-1-suspend-resume)
[517.567223] Starting subtest: dp-mst-type-1-suspend-resume
[517.570630] Subtest dp-mst-type-1-suspend-resume: SKIP (0.000s)
[518.183033] [070/133] (538s left) syncobj_timeline (etime-multi-wait-submitted)
[518.245314] Starting subtest: etime-multi-wait-submitted
[518.353478] Subtest etime-multi-wait-submitted: SUCCESS (0.107s)
[518.504179] [071/133] (538s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[519.001874] Starting subtest: x-tiled-64bpp-rotate-90
[519.014011] Subtest x-tiled-64bpp-rotate-90: SKIP (0.011s)
[519.656508] [072/133] (537s left) gem_exec_balancer (parallel-contexts)
[519.722372] Subtest parallel-contexts: SKIP (0.000s)
[519.876757] [073/133] (536s left) kms_hdr (invalid-hdr)
[520.361651] Starting subtest: invalid-hdr
[520.366574] Subtest invalid-hdr: SKIP (0.000s)
[520.969499] [074/133] (535s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[521.456467] Starting subtest: flip-vs-cursor-atomic
[531.226335] Subtest flip-vs-cursor-atomic: SUCCESS (9.765s)
[531.934173] [075/133] (525s left) perf (whitelisted-registers-userspace-config)
[532.116601] Subtest whitelisted-registers-userspace-config: SKIP (0.000s)
[532.188225] [076/133] (524s left) gem_ccs (block-copy-compressed)
[532.248272] Subtest block-copy-compressed: SKIP (0.000s)
[532.316527] [077/133] (524s left) prime_mmap (test_aperture_limit)
[532.374598] Starting subtest: test_aperture_limit
[532.376426] Starting dynamic subtest: test_aperture_limit-smem
[532.384488] Dynamic subtest test_aperture_limit-smem: SUCCESS (0.011s)
[532.386237] Subtest test_aperture_limit: SUCCESS (0.012s)
[532.511431] [078/133] (524s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling)
[532.572382] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SKIP (0.000s)
[532.649204] [079/133] (524s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[533.140408] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[533.143845] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[533.732390] [080/133] (523s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[533.790127] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s)
[533.862737] [081/133] (523s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[534.352869] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[534.356257] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[534.946495] [082/133] (522s left) syncobj_timeline (wait-all-complex)
[535.007969] Starting subtest: wait-all-complex
[535.222463] Subtest wait-all-complex: SUCCESS (0.215s)
[535.361029] [083/133] (522s left) gem_exec_balancer (nop)
[535.424873] Subtest nop: SKIP (0.000s)
[535.570252] [084/133] (521s left) gem_ctx_param (invalid-get-ringsize)
[535.632020] Starting subtest: invalid-get-ringsize
[535.633767] Subtest invalid-get-ringsize: SUCCESS (0.000s)
[535.771092] [085/133] (521s left) kms_cursor_crc (cursor-onscreen-max-size)
[536.273429] Starting subtest: cursor-onscreen-max-size
[536.278271] Subtest cursor-onscreen-max-size: SKIP (0.000s)
[536.889667] [086/133] (520s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move)
[537.384850] Starting subtest: psr-2p-scndscrn-spr-indfb-move
[537.389377] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[537.999442] [087/133] (519s left) kms_psr (psr-dpms)
[538.498623] Subtest psr-dpms: SKIP (0.000s)
[538.796532] [088/133] (518s left) kms_pm_dc (dc9-dpms)
[549.912858] Subtest dc9-dpms: SKIP (0.000s)
[549.981508] [089/133] (507s left) i915_pm_rpm (reg-read-ioctl)
[561.772017] Subtest reg-read-ioctl: SKIP (0.000s)
[562.074314] [090/133] (495s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[562.566854] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s)
[562.879025] [091/133] (495s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt)
[563.367291] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt
[563.370610] Subtest psr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[563.978306] [092/133] (494s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[564.048306] Starting subtest: basic-batch-kernel-default-cmd
[564.052464] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[564.284058] [093/133] (493s left) gem_exec_fence (syncobj-unused-fence)
[564.494094] Starting subtest: syncobj-unused-fence
[564.495972] Subtest syncobj-unused-fence: SUCCESS (0.002s)
[564.894872] [094/133] (493s left) kms_big_fb (4-tiled-16bpp-rotate-180)
[565.393683] Starting subtest: 4-tiled-16bpp-rotate-180
[565.397112] Subtest 4-tiled-16bpp-rotate-180: SKIP (0.000s)
[566.005911] [095/133] (492s left) gem_softpin (noreloc-s3)
[566.072881] Starting subtest: noreloc-S3
[620.707615] Subtest noreloc-S3: SUCCESS (5.400s)
[628.908790] [096/133] (437s left) kms_psr (psr2-sprite-plane-move)
[629.408198] Subtest psr2-sprite-plane-move: SKIP (0.000s)
[629.721498] [097/133] (436s left) kms_color (ctm-0-25)
[630.210114] Starting subtest: ctm-0-25
[630.212361] Starting dynamic subtest: pipe-A-HDMI-A-1
[631.626617] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.418s)
[631.646027] Starting dynamic subtest: pipe-B-HDMI-A-1
[633.079970] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.452s)
[633.082933] Subtest ctm-0-25: SUCCESS (2.874s)
[633.821783] [098/133] (432s left) syncobj_wait (wait-zero-handles)
[633.888120] Starting subtest: wait-zero-handles
[633.890024] Subtest wait-zero-handles: SUCCESS (0.000s)
[634.010575] [099/133] (432s left) gem_workarounds (basic-read-context)
[634.082473] Starting subtest: basic-read-context
[634.087206] Subtest basic-read-context: SUCCESS (0.005s)
[634.250409] [100/133] (432s left) kms_flip (busy-flip)
[634.735039] Starting subtest: busy-flip
[634.736813] Starting dynamic subtest: A-VGA1
[635.483721] Dynamic subtest A-VGA1: SUCCESS (0.747s)
[635.503646] Starting dynamic subtest: B-VGA1
[636.185442] Dynamic subtest B-VGA1: SUCCESS (0.699s)
[636.204096] Starting dynamic subtest: A-HDMI-A1
[636.957829] Dynamic subtest A-HDMI-A1: SUCCESS (0.770s)
[636.976841] Starting dynamic subtest: B-HDMI-A1
[637.755904] Dynamic subtest B-HDMI-A1: SUCCESS (0.792s)
[637.758052] Subtest busy-flip: SUCCESS (3.023s)
[638.577466] [101/133] (428s left) gem_fence_thrash (bo-write-verify-none)
[638.644538] Starting subtest: bo-write-verify-none
[639.775247] Subtest bo-write-verify-none: SUCCESS (1.110s)
[639.905400] [102/133] (426s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[640.414244] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[640.417669] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[641.044643] [103/133] (425s left) syncobj_wait (wait-for-submit-snapshot)
[641.135756] Starting subtest: wait-for-submit-snapshot
[641.219531] Subtest wait-for-submit-snapshot: SUCCESS (0.080s)
[641.363954] [104/133] (425s left) kms_mmap_write_crc (main)
[641.873261] Starting subtest: main
[641.874857] Starting dynamic subtest: pipe-A-HDMI-A-1
[644.736195] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.801s)
[644.737866] Subtest main: SUCCESS (2.803s)
[645.478424] [105/133] (421s left) gem_pxp (hw-rejects-pxp-buffer)
[648.077083] Starting subtest: hw-rejects-pxp-buffer
[648.079246] Subtest hw-rejects-pxp-buffer: SUCCESS (0.000s)
[648.240876] [106/133] (418s left) syncobj_wait (wait-all-interrupted)
[648.299864] Starting subtest: wait-all-interrupted
[648.401878] Subtest wait-all-interrupted: SUCCESS (0.100s)
[648.544802] [107/133] (418s left) gem_mmap_gtt (basic-short)
[648.601831] Starting subtest: basic-short
[648.622547] Subtest basic-short: SUCCESS (0.023s)
[648.785612] [108/133] (418s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc)
[649.283590] Starting subtest: fbc-rgb565-draw-mmap-wc
[651.125028] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (1.828s)
[651.768413] [109/133] (415s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[652.273213] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[652.276620] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[652.894295] [110/133] (414s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[653.384626] Starting subtest: short-busy-flip-before-cursor-toggle
[653.390201] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[653.998914] [111/133] (413s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[654.495566] Starting subtest: fbcpsr-tiling-4
[654.500310] Subtest fbcpsr-tiling-4: SKIP (0.000s)
[655.113279] [112/133] (412s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[655.603392] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[655.605190] Starting dynamic subtest: pipe-A
[655.610048] Dynamic subtest pipe-A: SKIP (0.001s)
[655.626634] Starting dynamic subtest: pipe-B
[655.631373] Dynamic subtest pipe-B: SKIP (0.001s)
[655.634519] Subtest plane-scaler-with-clipping-clamping-modifiers: SKIP (0.004s)
[656.221746] [113/133] (411s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf)
[656.712965] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (0.000s)
[657.020932] [114/133] (410s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[657.518398] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[657.522898] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[658.140554] [115/133] (409s left) intel_hwmon (hwmon-write)
[658.205480] Subtest hwmon-write: SKIP (0.000s)
[658.270601] [116/133] (409s left) perf_pmu (gt-awake)
[658.337402] Starting subtest: gt-awake
[660.353910] Subtest gt-awake: SUCCESS (2.008s)
[660.493988] [117/133] (407s left) gem_exec_async (forked-writes)
[660.563709] Starting subtest: forked-writes
[660.565563] Starting dynamic subtest: rcs0
[660.579692] Dynamic subtest rcs0: SUCCESS (0.015s)
[660.596133] Starting dynamic subtest: bcs0
[660.598638] Dynamic subtest bcs0: SUCCESS (0.014s)
[660.616399] Starting dynamic subtest: vcs0
[660.620483] Dynamic subtest vcs0: SUCCESS (0.023s)
[660.622323] Subtest forked-writes: SUCCESS (0.057s)
[660.909048] [118/133] (406s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[661.399475] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[663.316228] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SUCCESS (1.914s)
[663.980272] [119/133] (403s left) gem_fence_thrash (bo-write-verify-threaded-none)
[664.041402] Starting subtest: bo-write-verify-threaded-none
[665.846901] Subtest bo-write-verify-threaded-none: SUCCESS (1.803s)
[666.013449] [120/133] (401s left) gem_exec_whisper (basic-queues-forked-all)
[666.081686] Starting subtest: basic-queues-forked-all
[666.088577] Subtest basic-queues-forked-all: SKIP (0.002s)
[666.329154] [121/133] (401s left) gem_mmap_wc (write-cpu-read-wc-unflushed)
[666.393003] Starting subtest: write-cpu-read-wc-unflushed
[666.512792] Subtest write-cpu-read-wc-unflushed: SUCCESS (0.120s)
[666.658702] [122/133] (401s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[666.722461] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[666.724455] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[666.846992] [123/133] (401s left) gem_wait (write-busy)
[666.923439] Starting subtest: write-busy
[666.925296] Starting dynamic subtest: all-engines
[667.445520] Dynamic subtest all-engines: SUCCESS (0.520s)
[667.467141] Starting dynamic subtest: rcs0
[667.966128] Dynamic subtest rcs0: SUCCESS (0.517s)
[667.984215] Starting dynamic subtest: bcs0
[668.487026] Dynamic subtest bcs0: SUCCESS (0.517s)
[668.505510] Starting dynamic subtest: vcs0
[669.007213] Dynamic subtest vcs0: SUCCESS (0.517s)
[669.009597] Subtest write-busy: SUCCESS (2.083s)
[669.279773] [124/133] (398s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[669.783681] Starting subtest: y-tiled-32bpp-rotate-90
[669.787167] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[670.393453] [125/133] (397s left) gem_ctx_persistence (heartbeat-many)
[670.457991] Subtest heartbeat-many: SKIP (0.000s)
[670.533233] [126/133] (397s left) dmabuf_sync_file (export-before-signal)
[670.597339] Starting subtest: export-before-signal
[670.599517] Subtest export-before-signal: SUCCESS (0.001s)
[670.716310] [127/133] (397s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt)
[671.211484] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt
[671.215169] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[671.815469] [128/133] (396s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[672.309241] Starting subtest: basic-flip-after-cursor-atomic
[673.289201] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.981s)
[674.010117] [129/133] (394s left) gem_tiled_wb
[683.477343] [130/133] (384s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[683.549206] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[683.552928] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[683.786951] [131/133] (384s left) perf_pmu (all-busy-idle-check-all)
[683.848998] Starting subtest: all-busy-idle-check-all
[684.467101] Subtest all-busy-idle-check-all: SUCCESS (0.619s)
[684.618553] [132/133] (383s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[684.682420] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[684.746928] [133/133] (383s left) kms_cursor_crc (cursor-suspend)
[685.237242] Starting subtest: cursor-suspend
[685.239265] Starting dynamic subtest: pipe-A-HDMI-A-1
[719.745048] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.876s)
[719.764832] Starting dynamic subtest: pipe-B-HDMI-A-1
[754.761201] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.812s)
[754.762970] Subtest cursor-suspend: SUCCESS (3.692s)
[767.508340] Closing watchdogs
results: parsing output: 0/ for test: gem_reg_read
results: parsing output: 1/ for test: kms_flip
results: parsing output: 2/ for test: api_intel_bb
results: parsing output: 3/ for test: kms_big_fb
results: parsing output: 4/ for test: gem_exec_fence
results: parsing output: 5/ for test: syncobj_basic
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: gem_exec_schedule
results: parsing output: 8/ for test: i915_hangman
results: parsing output: 9/ for test: kms_chamelium_color
results: parsing output: 10/ for test: syncobj_wait
results: parsing output: 11/ for test: kms_psr
results: parsing output: 12/ for test: gem_exec_schedule
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_vblank
results: parsing output: 15/ for test: perf_pmu
results: parsing output: 16/ for test: gem_softpin
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_plane
results: parsing output: 19/ for test: kms_chamelium_audio
results: parsing output: 20/ for test: gem_pread
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: kms_ccs
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: gem_exec_whisper
results: parsing output: 25/ for test: kms_invalid_mode
results: parsing output: 26/ for test: i915_suspend
results: parsing output: 27/ for test: kms_addfb_basic
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: gem_flink_basic
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_big_fb
results: parsing output: 32/ for test: gen7_exec_parse
results: parsing output: 33/ for test: kms_ccs
results: parsing output: 34/ for test: prime_vgem
results: parsing output: 35/ for test: kms_pipe_crc_basic
results: parsing output: 36/ for test: kms_chamelium_hpd
results: parsing output: 37/ for test: kms_plane
results: parsing output: 38/ for test: gem_mmap_offset
results: parsing output: 39/ for test: kms_cursor_legacy
results: parsing output: 40/ for test: syncobj_wait
results: parsing output: 41/ for test: vgem_basic
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_psr
results: parsing output: 44/ for test: kms_vblank
results: parsing output: 45/ for test: gem_mmap_gtt
results: parsing output: 46/ for test: kms_psr
results: parsing output: 47/ for test: kms_flip
results: parsing output: 48/ for test: kms_busy
results: parsing output: 49/ for test: kms_draw_crc
results: parsing output: 50/ for test: kms_ccs
results: parsing output: 51/ for test: syncobj_wait
results: parsing output: 52/ for test: kms_plane_scaling
results: parsing output: 53/ for test: gen9_exec_parse
results: parsing output: 54/ for test: gem_eio
results: parsing output: 55/ for test: kms_pm_rpm
results: parsing output: 56/ for test: kms_big_fb
results: parsing output: 57/ for test: api_intel_bb
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: kms_cursor_crc
results: parsing output: 61/ for test: gem_pwrite
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: prime_mmap
results: parsing output: 64/ for test: gem_create
results: parsing output: 65/ for test: syncobj_timeline
results: parsing output: 66/ for test: gem_userptr_blits
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_content_protection
results: parsing output: 69/ for test: syncobj_timeline
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: gem_exec_balancer
results: parsing output: 72/ for test: kms_hdr
results: parsing output: 73/ for test: kms_cursor_legacy
results: parsing output: 74/ for test: perf
results: parsing output: 75/ for test: gem_ccs
results: parsing output: 76/ for test: prime_mmap
results: parsing output: 77/ for test: kms_flip_scaled_crc
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_ccs
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: syncobj_timeline
results: parsing output: 82/ for test: gem_exec_balancer
results: parsing output: 83/ for test: gem_ctx_param
results: parsing output: 84/ for test: kms_cursor_crc
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_psr
results: parsing output: 87/ for test: kms_pm_dc
results: parsing output: 88/ for test: i915_pm_rpm
results: parsing output: 89/ for test: kms_psr2_sf
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gem_exec_flush
results: parsing output: 92/ for test: gem_exec_fence
results: parsing output: 93/ for test: kms_big_fb
results: parsing output: 94/ for test: gem_softpin
results: parsing output: 95/ for test: kms_psr
results: parsing output: 96/ for test: kms_color
results: parsing output: 97/ for test: syncobj_wait
results: parsing output: 98/ for test: gem_workarounds
results: parsing output: 99/ for test: kms_flip
results: parsing output: 100/ for test: gem_fence_thrash
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: syncobj_wait
results: parsing output: 103/ for test: kms_mmap_write_crc
results: parsing output: 104/ for test: gem_pxp
results: parsing output: 105/ for test: syncobj_wait
results: parsing output: 106/ for test: gem_mmap_gtt
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_cursor_legacy
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_plane_scaling
results: parsing output: 112/ for test: kms_psr2_sf
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: intel_hwmon
results: parsing output: 115/ for test: perf_pmu
results: parsing output: 116/ for test: gem_exec_async
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: gem_fence_thrash
results: parsing output: 119/ for test: gem_exec_whisper
results: parsing output: 120/ for test: gem_mmap_wc
results: parsing output: 121/ for test: syncobj_wait
results: parsing output: 122/ for test: gem_wait
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: gem_ctx_persistence
results: parsing output: 125/ for test: dmabuf_sync_file
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_cursor_legacy
results: parsing output: 128/ for test: gem_tiled_wb
results: parsing output: 129/ for test: gem_render_copy
results: parsing output: 130/ for test: perf_pmu
results: parsing output: 131/ for test: kms_pipe_b_c_ivb
results: parsing output: 132/ for test: kms_cursor_crc
Done.