[71.649756] Initializing watchdogs
[71.649907]   /dev/watchdog0
[71.669991] [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)
[71.678397] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[71.682685] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[71.687729] [001/133] (960s left) gem_userptr_blits (relocations)
[71.763848] Starting subtest: relocations
[71.765423] Subtest relocations: SUCCESS (0.001s)
[71.912589] [002/133] (960s left) syncobj_timeline (single-wait-available-submitted)
[71.972654] Starting subtest: single-wait-available-submitted
[71.973820] Subtest single-wait-available-submitted: SUCCESS (0.001s)
[72.061515] [003/133] (960s left) gem_softpin (allocator-fork)
[72.123110] Subtest allocator-fork: SKIP (0.000s)
[72.212791] [004/133] (960s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[72.703150] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[72.704014] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[72.806371] [005/133] (959s left) kms_psr (pr-primary-mmap-cpu)
[73.292729] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[73.352537] [006/133] (959s left) gem_readwrite (write-bad-handle)
[73.408659] Starting subtest: write-bad-handle
[73.409802] Subtest write-bad-handle: SUCCESS (0.000s)
[73.509838] [007/133] (958s left) gem_create (create-ext-placement-all)
[73.678157] Starting subtest: create-ext-placement-all
[73.678824] Subtest create-ext-placement-all: SUCCESS (0.000s)
[73.773142] [008/133] (958s left) kms_content_protection (dp-mst-type-1-suspend-resume)
[74.278987] Starting subtest: dp-mst-type-1-suspend-resume
[74.280930] Subtest dp-mst-type-1-suspend-resume: SKIP (0.000s)
[74.388088] [009/133] (958s left) gem_exec_flush (basic-uc-rw-default)
[74.455578] Starting subtest: basic-uc-rw-default
[79.910108] Subtest basic-uc-rw-default: SUCCESS (5.454s)
[80.105261] [010/133] (952s left) gem_ringfill (engines-basic)
[80.294961] Starting subtest: engines-basic
[80.295809] Starting dynamic subtest: rcs0
[80.309333] Dynamic subtest rcs0: SUCCESS (0.014s)
[80.320799] Starting dynamic subtest: bcs0
[80.329410] Dynamic subtest bcs0: SUCCESS (0.019s)
[80.330656] Subtest engines-basic: SUCCESS (0.034s)
[80.430785] [FACT gem_ringfill (engines-basic)] new: kernel.kmod_is_loaded.vgem: true
[80.433228] [011/133] (952s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[80.917586] Starting subtest: 2x-absolute-wf_vblank-interruptible
[80.918875] Starting dynamic subtest: AB-VGA1-HDMI-A1
[111.428344] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (30.505s)
[111.430281] Subtest 2x-absolute-wf_vblank-interruptible: SUCCESS (30.510s)
[111.678235] [012/133] (920s left) syncobj_wait (invalid-reset-bad-pad)
[111.737555] Starting subtest: invalid-reset-bad-pad
[111.738148] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[111.828526] [013/133] (920s left) kms_chamelium_hpd (dp-hpd-storm)
[112.431779] Subtest dp-hpd-storm: SKIP (0.000s)
[112.643087] [014/133] (920s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[112.701899] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SKIP (0.000s)
[112.755181] [015/133] (920s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[112.812201] Starting subtest: invalid-multi-wait-unsubmitted
[112.812800] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[112.922657] [016/133] (919s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[112.977117] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s)
[113.037844] [017/133] (919s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier-source-clamping)
[113.515056] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier-source-clamping
[113.516843] Subtest pixel-format-4-tiled-bmg-ccs-modifier-source-clamping: SKIP (0.000s)
[113.614496] [018/133] (919s left) i915_pm_freq_api (freq-suspend)
[113.671919] Subtest freq-suspend: SKIP (0.000s)
[113.717961] [019/133] (919s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[114.035358] Starting subtest: syncobj-timeline-invalid-flags
[114.036541] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.001s)
[114.277531] [020/133] (918s left) kms_color_pipeline (plane-ctm3x4)
[114.756485] Starting subtest: plane-ctm3x4
[115.372819] Subtest plane-ctm3x4: SKIP (0.615s)
[115.610341] [021/133] (917s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[116.091747] Starting subtest: plane-upscale-20x20-with-modifiers
[116.092469] Starting dynamic subtest: pipe-A
[116.095231] Dynamic subtest pipe-A: SKIP (0.003s)
[116.105431] Starting dynamic subtest: pipe-B
[116.109106] Dynamic subtest pipe-B: SKIP (0.002s)
[116.110725] Subtest plane-upscale-20x20-with-modifiers: SKIP (0.006s)
[116.193977] [022/133] (916s left) gem_exec_whisper (basic-fds-priority-all)
[116.261862] Starting subtest: basic-fds-priority-all
[116.263954] Subtest basic-fds-priority-all: SKIP (0.001s)
[116.459310] [023/133] (916s left) kms_flip (2x-dpms-vs-vblank-race)
[116.941585] Starting subtest: 2x-dpms-vs-vblank-race
[116.942716] Starting dynamic subtest: AB-VGA1-HDMI-A1
[127.864437] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (10.921s)
[127.865816] Subtest 2x-dpms-vs-vblank-race: SUCCESS (10.925s)
[128.110179] [024/133] (905s left) kms_pm_lpsp (kms-lpsp)
[139.645626] Starting subtest: kms-lpsp
[139.647087] Subtest kms-lpsp: SKIP (0.001s)
[139.737659] [025/133] (893s left) perf_pmu (init-sema)
[139.798417] Starting subtest: init-sema
[139.799182] Starting dynamic subtest: rcs0
[139.799817] Dynamic subtest rcs0: SUCCESS (0.001s)
[139.810895] Starting dynamic subtest: bcs0
[139.811866] Dynamic subtest bcs0: SUCCESS (0.000s)
[139.822668] Starting dynamic subtest: vcs0
[139.823575] Dynamic subtest vcs0: SUCCESS (0.000s)
[139.824520] Subtest init-sema: SUCCESS (0.004s)
[139.903804] [026/133] (893s left) kms_psr (psr2-primary-page-flip)
[140.386657] Subtest psr2-primary-page-flip: SKIP (0.000s)
[140.450190] [027/133] (892s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[140.941608] Starting subtest: y-tiled-64bpp-rotate-180
[140.942896] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[141.051589] [028/133] (892s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[141.538571] Starting subtest: fbc-1p-pri-indfb-multidraw
[155.656678] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (14.118s)
[155.891020] [029/133] (877s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[156.376871] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[158.364839] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SUCCESS (1.987s)
[158.528499] [030/133] (874s left) kms_invalid_mode (bad-hsync-start)
[159.008436] Starting subtest: bad-hsync-start
[159.009840] Starting dynamic subtest: pipe-A-VGA-1
[159.129732] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.119s)
[159.140854] Starting dynamic subtest: pipe-A-HDMI-A-1
[159.141781] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.000s)
[159.152072] Starting dynamic subtest: pipe-B-VGA-1
[159.152698] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.000s)
[159.162332] Starting dynamic subtest: pipe-B-HDMI-A-1
[159.162941] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s)
[159.163606] Subtest bad-hsync-start: SUCCESS (0.127s)
[159.382857] [031/133] (874s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[159.882504] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[159.883607] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[159.982504] [032/133] (873s left) core_setmaster (master-drop-set-shared-fd)
[160.122351] Starting subtest: master-drop-set-shared-fd
[160.155253] Subtest master-drop-set-shared-fd: SUCCESS (0.032s)
[160.200519] [033/133] (873s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[160.692364] Starting subtest: yf-tiled-8bpp-rotate-90
[160.693643] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[160.803490] [034/133] (872s left) gem_pxp (regular-baseline-src-copy-readible)
[163.373894] Starting subtest: regular-baseline-src-copy-readible
[163.375341] Subtest regular-baseline-src-copy-readible: SKIP (0.000s)
[163.460953] [035/133] (870s left) kms_plane_scaling (intel-max-src-size)
[163.937284] Starting subtest: intel-max-src-size
[163.938821] Subtest intel-max-src-size: SKIP (0.000s)
[164.027166] [036/133] (869s left) syncobj_eventfd (invalid-illegal-eventfd)
[164.086353] Starting subtest: invalid-illegal-eventfd
[164.086852] Subtest invalid-illegal-eventfd: SUCCESS (0.000s)
[164.180440] [037/133] (869s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[164.243310] Starting subtest: basic-gtt-cpu-noreloc
[164.245969] Subtest basic-gtt-cpu-noreloc: SUCCESS (0.003s)
[164.777081] [038/133] (869s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[165.264730] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[165.265921] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[165.373579] [039/133] (868s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[165.430962] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[165.494082] [040/133] (868s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[165.970096] Starting subtest: async-flip-with-page-flip-events-tiled
[166.207778] Starting dynamic subtest: pipe-A-VGA-1-x
[168.302904] Dynamic subtest pipe-A-VGA-1-x: SUCCESS (2.095s)
[168.410241] Starting dynamic subtest: pipe-A-HDMI-A-1-x
[170.545921] Dynamic subtest pipe-A-HDMI-A-1-x: SUCCESS (2.145s)
[170.699825] Starting dynamic subtest: pipe-B-VGA-1-x
[172.796670] Dynamic subtest pipe-B-VGA-1-x: SUCCESS (2.106s)
[172.898413] Starting dynamic subtest: pipe-B-HDMI-A-1-x
[175.034253] Dynamic subtest pipe-B-HDMI-A-1-x: SUCCESS (2.145s)
[175.034957] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (9.066s)
[175.415867] [041/133] (858s left) kms_cursor_crc (cursor-offscreen-max-size)
[175.902357] Starting subtest: cursor-offscreen-max-size
[175.903916] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[176.015071] [042/133] (858s left) kms_vblank (wait-busy-hang)
[176.491307] Starting subtest: wait-busy-hang
[176.492319] Starting dynamic subtest: pipe-A-VGA-1
[182.961869] Dynamic subtest pipe-A-VGA-1: SUCCESS (6.469s)
[182.973308] Starting dynamic subtest: pipe-A-HDMI-A-1
[188.931659] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (5.966s)
[188.944832] Starting dynamic subtest: pipe-B-VGA-1
[194.913569] Dynamic subtest pipe-B-VGA-1: SUCCESS (5.981s)
[194.926868] Starting dynamic subtest: pipe-B-HDMI-A-1
[200.965264] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (6.050s)
[200.967368] Subtest wait-busy-hang: SUCCESS (24.476s)
[201.261847] [043/133] (832s left) kms_vblank (query-busy)
[201.744808] Starting subtest: query-busy
[201.745737] Starting dynamic subtest: pipe-A-VGA-1
[204.221519] Dynamic subtest pipe-A-VGA-1: SUCCESS (2.476s)
[204.232819] Starting dynamic subtest: pipe-A-HDMI-A-1
[206.646855] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.424s)
[206.661347] Starting dynamic subtest: pipe-B-VGA-1
[209.020706] Dynamic subtest pipe-B-VGA-1: SUCCESS (2.372s)
[209.032232] Starting dynamic subtest: pipe-B-HDMI-A-1
[211.478558] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.455s)
[211.479154] Subtest query-busy: SUCCESS (9.735s)
[211.739520] [044/133] (822s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[212.221521] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[212.309718] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.087s)
[212.525858] [045/133] (821s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[212.583379] Starting subtest: invalid-single-wait-all-unsubmitted
[212.583886] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[212.676969] [046/133] (821s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[213.152621] Starting subtest: 2x-flip-vs-cursor-atomic
[213.613745] Subtest 2x-flip-vs-cursor-atomic: SUCCESS (0.461s)
[213.874274] [047/133] (820s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[213.933591] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[213.934673] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[214.031529] [048/133] (820s left) syncobj_wait (wait-zero-handles)
[214.090249] Starting subtest: wait-zero-handles
[214.090840] Subtest wait-zero-handles: SUCCESS (0.000s)
[214.183709] [049/133] (820s left) gem_exec_params (batch-first)
[214.242114] Starting subtest: batch-first
[214.247892] Subtest batch-first: SUCCESS (0.006s)
[214.388368] [050/133] (820s left) api_intel_bb (full-batch)
[214.446251] Starting subtest: full-batch
[214.447326] Subtest full-batch: SUCCESS (0.002s)
[214.566924] [051/133] (819s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[215.043384] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[215.044950] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[215.149672] [052/133] (819s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[215.631535] Starting subtest: psr-rgb565-draw-mmap-wc
[215.632592] Subtest psr-rgb565-draw-mmap-wc: SKIP (0.000s)
[215.736195] [053/133] (818s left) kms_psr (psr-no-drrs)
[216.211470] Subtest psr-no-drrs: SKIP (0.000s)
[216.275970] [054/133] (818s left) gem_exec_gttfill (basic)
[216.343364] Starting subtest: basic
[220.126036] Subtest basic: SUCCESS (3.783s)
[220.335054] [055/133] (814s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[220.471943] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (0.000s)
[220.542773] [056/133] (814s left) kms_prop_blob (basic)
[220.595502] Starting subtest: basic
[220.596894] Subtest basic: SUCCESS (0.000s)
[220.685740] [057/133] (814s left) perf_pmu (semaphore-wait-idle)
[220.741199] Starting subtest: semaphore-wait-idle
[220.741941] Starting dynamic subtest: rcs0
[220.743373] Dynamic subtest rcs0: SKIP (0.001s)
[220.758233] Starting dynamic subtest: bcs0
[220.759821] Dynamic subtest bcs0: SKIP (0.000s)
[220.771662] Starting dynamic subtest: vcs0
[220.773531] Dynamic subtest vcs0: SKIP (0.000s)
[220.775394] Subtest semaphore-wait-idle: SKIP (0.006s)
[220.855662] [058/133] (814s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[220.913861] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s)
[220.964508] [059/133] (813s left) gem_exec_balancer (semaphore)
[221.023174] Subtest semaphore: SKIP (0.000s)
[221.132999] [060/133] (813s left) gem_exec_reloc (basic-cpu-wc-active)
[221.198478] Starting subtest: basic-cpu-wc-active
[221.309553] Subtest basic-cpu-wc-active: SUCCESS (0.111s)
[221.826974] [061/133] (813s left) kms_cursor_crc (cursor-random-512x512)
[222.324398] Starting subtest: cursor-random-512x512
[222.329335] Subtest cursor-random-512x512: SKIP (0.001s)
[222.435295] [062/133] (812s left) gen9_exec_parse (valid-registers)
[222.498776] Subtest valid-registers: SKIP (0.000s)
[222.563303] [063/133] (812s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[223.051542] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[223.052609] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[223.165093] [064/133] (812s left) gem_exec_reloc (basic-cpu-gtt-active)
[223.224917] Starting subtest: basic-cpu-gtt-active
[223.335903] Subtest basic-cpu-gtt-active: SUCCESS (0.111s)
[223.851356] [065/133] (811s left) kms_psr (fbc-pr-primary-render)
[224.324719] Subtest fbc-pr-primary-render: SKIP (0.000s)
[224.396659] [066/133] (810s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[224.453354] Starting subtest: cpuset-basic-small-copy-XY
[225.297603] Subtest cpuset-basic-small-copy-XY: SUCCESS (0.844s)
[225.420829] [067/133] (809s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[225.996916] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[225.999215] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[226.101359] [068/133] (809s left) kms_chamelium_audio (dp-audio-edid)
[226.699403] Subtest dp-audio-edid: SKIP (0.000s)
[226.927721] [069/133] (808s left) gem_ctx_persistence (heartbeat-stop)
[226.989646] Subtest heartbeat-stop: SKIP (0.000s)
[227.054746] [070/133] (808s left) gem_userptr_blits (nohangcheck)
[227.146197] Starting subtest: nohangcheck
[227.191996] Subtest nohangcheck: SUCCESS (0.047s)
[227.314154] [071/133] (808s left) kms_flip (plain-flip-ts-check)
[227.787675] Starting subtest: plain-flip-ts-check
[227.788951] Starting dynamic subtest: A-VGA1
[235.916627] Dynamic subtest A-VGA1: SUCCESS (8.127s)
[235.930023] Starting dynamic subtest: B-VGA1
[243.912361] Dynamic subtest B-VGA1: SUCCESS (7.992s)
[243.925310] Starting dynamic subtest: A-HDMI-A1
[251.936450] Dynamic subtest A-HDMI-A1: SUCCESS (8.021s)
[251.949843] Starting dynamic subtest: B-HDMI-A1
[259.988947] Dynamic subtest B-HDMI-A1: SUCCESS (8.049s)
[259.991808] Subtest plain-flip-ts-check: SUCCESS (32.203s)
[260.170297] [072/133] (775s left) kms_pipe_crc_basic (suspend-read-crc)
[260.640697] Starting subtest: suspend-read-crc
[260.641372] Starting dynamic subtest: pipe-A-VGA-1
[279.280762] Dynamic subtest pipe-A-VGA-1: SUCCESS (2.488s)
[279.296730] Starting dynamic subtest: pipe-B-HDMI-A-1
[297.143230] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.986s)
[297.147520] Subtest suspend-read-crc: SUCCESS (5.480s)
[304.225487] [073/133] (738s left) gem_softpin (evict-active-interruptible)
[304.287873] Starting subtest: evict-active-interruptible
[304.291879] Subtest evict-active-interruptible: SUCCESS (0.004s)
[304.423961] [074/133] (738s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[304.922743] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[306.582440] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SUCCESS (1.591s)
[306.744615] [075/133] (736s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[307.245926] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[307.246860] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[307.358698] [076/133] (735s left) gem_exec_balancer (full)
[307.422505] Subtest full: SKIP (0.000s)
[307.515538] [077/133] (735s left) sw_sync (sync_busy_fork_unixsocket)
[307.582142] Starting subtest: sync_busy_fork_unixsocket
[307.598351] Subtest sync_busy_fork_unixsocket: SUCCESS (0.015s)
[307.693210] [078/133] (735s left) kms_cursor_crc (cursor-tearing-position-change)
[308.183087] Starting subtest: cursor-tearing-position-change
[308.183788] Starting dynamic subtest: pipe-A-VGA-1
[308.605939] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.408s)
[308.621756] Starting dynamic subtest: pipe-B-HDMI-A-1
[308.978541] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.360s)
[308.978997] Subtest cursor-tearing-position-change: SUCCESS (0.773s)
[309.253812] [079/133] (733s left) gem_mmap_wc (bad-size)
[309.313492] Starting subtest: bad-size
[309.315128] Subtest bad-size: SUCCESS (0.001s)
[309.436577] [080/133] (733s left) i915_pm_rpm (gem-idle)
[321.252783] Subtest gem-idle: SKIP (0.000s)
[321.318564] [081/133] (721s left) kms_dp_link_training (non-uhbr-sst)
[321.798084] Starting subtest: non-uhbr-sst
[321.801559] Subtest non-uhbr-sst: SKIP (0.000s)
[321.902782] [082/133] (721s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[322.387981] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[322.388901] Starting dynamic subtest: AB-VGA1-HDMI-A1
[325.052492] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (2.651s)
[325.056278] Subtest 2x-flip-vs-wf_vblank-interruptible: SUCCESS (2.656s)
[325.321230] [083/133] (717s left) kms_pwrite_crc
[326.543864] [084/133] (716s left) kms_frontbuffer_tracking (psr-suspend)
[327.026984] Starting subtest: psr-suspend
[327.028072] Subtest psr-suspend: SKIP (0.000s)
[327.144363] [085/133] (716s left) gem_eio (context-create)
[327.212036] Starting subtest: context-create
[327.238221] Subtest context-create: SUCCESS (0.026s)
[327.762068] [086/133] (715s left) kms_big_fb (x-tiled-64bpp-rotate-0)
[328.245610] Starting subtest: x-tiled-64bpp-rotate-0
[329.991429] Subtest x-tiled-64bpp-rotate-0: SUCCESS (1.741s)
[330.299558] [087/133] (713s left) kms_psr2_su (page_flip-p010)
[330.357919] Subtest page_flip-P010: SKIP (0.000s)
[330.425998] [088/133] (713s left) syncobj_wait (single-wait-all-signaled)
[330.486737] Starting subtest: single-wait-all-signaled
[330.487508] Subtest single-wait-all-signaled: SUCCESS (0.001s)
[330.580556] [089/133] (712s left) kms_big_fb (linear-16bpp-rotate-180)
[331.064811] Starting subtest: linear-16bpp-rotate-180
[332.435127] Subtest linear-16bpp-rotate-180: SUCCESS (1.369s)
[332.679274] [090/133] (710s left) gem_exec_create (forked)
[332.749867] Starting subtest: forked
[332.750483] Starting dynamic subtest: smem
[352.859679] Dynamic subtest smem: SUCCESS (20.091s)
[352.862965] Subtest forked: SUCCESS (20.094s)
[353.071286] [091/133] (690s left) kms_chamelium_edid (dp-edid-resolution-list)
[353.670491] Subtest dp-edid-resolution-list: SKIP (0.000s)
[353.885572] [092/133] (689s left) gem_exec_schedule (pi-userfault)
[353.959772] Subtest pi-userfault: SKIP (0.000s)
[354.170491] [093/133] (689s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[354.652634] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[356.775884] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (2.122s)
[356.911824] [094/133] (686s left) api_intel_allocator (gem-pool)
[356.976413] Starting subtest: gem-pool
[356.979545] Subtest gem-pool: SUCCESS (0.004s)
[357.110739] [095/133] (686s left) gem_busy (semaphore)
[357.296908] Subtest semaphore: SKIP (0.000s)
[357.529134] [096/133] (686s left) syncobj_timeline (reset-unsignaled)
[357.592700] Starting subtest: reset-unsignaled
[357.593350] Subtest reset-unsignaled: SUCCESS (0.000s)
[357.696847] [097/133] (686s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[358.173555] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[358.174650] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[358.299068] [098/133] (685s left) kms_async_flips (test-cursor)
[358.783129] Starting subtest: test-cursor
[359.026534] Starting dynamic subtest: pipe-A-VGA-1
[359.125126] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.099s)
[359.262329] Starting dynamic subtest: pipe-A-HDMI-A-1
[359.420586] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.173s)
[359.582752] Starting dynamic subtest: pipe-B-VGA-1
[359.680209] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.111s)
[359.798529] Starting dynamic subtest: pipe-B-HDMI-A-1
[359.932412] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.147s)
[359.934308] Subtest test-cursor: SUCCESS (1.151s)
[360.342432] [099/133] (683s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[360.828405] Starting subtest: 4-tiled-32bpp-rotate-180
[360.829778] Subtest 4-tiled-32bpp-rotate-180: SKIP (0.000s)
[360.940945] [100/133] (683s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[361.422977] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[363.397357] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SUCCESS (1.973s)
[363.549764] [101/133] (680s left) gem_softpin (evict-active)
[363.615793] Starting subtest: evict-active
[363.619725] Subtest evict-active: SUCCESS (0.004s)
[363.751871] [102/133] (680s left) i915_query (query-regions-garbage-items)
[363.808740] Starting subtest: query-regions-garbage-items
[363.809304] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[363.898626] [103/133] (680s left) kms_psr (fbc-psr-no-drrs)
[364.374523] Subtest fbc-psr-no-drrs: SKIP (0.000s)
[364.467921] [104/133] (679s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[364.949403] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[364.950702] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[365.067295] [105/133] (679s left) gem_render_copy_redux (interruptible)
[365.126857] Starting subtest: interruptible
[365.662800] Subtest interruptible: SUCCESS (0.535s)
[365.795737] [106/133] (678s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[366.272854] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[366.274515] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[366.380960] [107/133] (678s left) gem_mmap_gtt (basic-small-copy-odd)
[366.439022] Starting subtest: basic-small-copy-odd
[366.969916] Subtest basic-small-copy-odd: SUCCESS (0.531s)
[367.083536] [108/133] (677s left) gem_exec_gttfill (multigpu-basic)
[367.356688] Starting subtest: multigpu-basic
[371.114533] Subtest multigpu-basic: SUCCESS (3.757s)
[371.192347] [109/133] (673s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[371.742201] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[373.201576] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SUCCESS (1.459s)
[373.349913] [110/133] (671s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[373.824966] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[373.883758] [111/133] (670s left) gem_mmap_offset (blt-coherency)
[373.941506] Starting subtest: blt-coherency
[373.945919] Subtest blt-coherency: SUCCESS (0.005s)
[374.068452] [112/133] (670s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-pwrite)
[374.543183] Starting subtest: psr-1p-offscreen-pri-indfb-draw-pwrite
[374.544181] Subtest psr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s)
[374.656061] [113/133] (670s left) kms_feature_discovery (psr1)
[375.138554] Starting subtest: psr1
[375.139693] Subtest psr1: SKIP (0.000s)
[375.244300] [114/133] (669s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[375.727761] Starting subtest: flip-vs-cursor-legacy
[385.750562] Subtest flip-vs-cursor-legacy: SUCCESS (10.017s)
[386.013391] [115/133] (658s left) gem_sync (basic-store-all)
[386.088495] Starting subtest: basic-store-all
[388.343780] Subtest basic-store-all: SUCCESS (2.254s)
[388.551716] [116/133] (656s left) gem_exec_schedule (preempt-self)
[388.631664] Subtest preempt-self: SKIP (0.000s)
[388.841351] [117/133] (656s left) kms_vrr (seamless-rr-switch-virtual)
[389.313859] Starting subtest: seamless-rr-switch-virtual
[389.316331] Subtest seamless-rr-switch-virtual: SKIP (0.000s)
[389.409378] [118/133] (655s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[389.470843] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[389.533990] [119/133] (655s left) kms_lease (lease-uevent)
[390.005849] Starting subtest: lease-uevent
[391.043817] Subtest lease-uevent: SUCCESS (1.038s)
[391.140616] [120/133] (654s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[391.621411] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[393.716250] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SUCCESS (2.093s)
[393.882836] [121/133] (651s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[394.363651] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[395.740424] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (1.377s)
[395.978198] [122/133] (649s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[396.457200] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[396.524749] [123/133] (648s left) syncobj_wait (invalid-reset-one-illegal-handle)
[396.585858] Starting subtest: invalid-reset-one-illegal-handle
[396.587287] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[396.691858] [124/133] (648s left) kms_plane (pixel-format-linear-modifier-source-clamping)
[397.163873] Starting subtest: pixel-format-linear-modifier-source-clamping
[397.259819] Starting dynamic subtest: pipe-A-plane-0
[398.060790] Dynamic subtest pipe-A-plane-0: SUCCESS (0.801s)
[398.078929] Starting dynamic subtest: pipe-A-plane-1
[398.996323] Dynamic subtest pipe-A-plane-1: SUCCESS (0.932s)
[399.239217] Starting dynamic subtest: pipe-B-plane-0
[400.619282] Dynamic subtest pipe-B-plane-0: SUCCESS (1.396s)
[400.636465] Starting dynamic subtest: pipe-B-plane-1
[401.550454] Dynamic subtest pipe-B-plane-1: SUCCESS (0.929s)
[401.651188] Subtest pixel-format-linear-modifier-source-clamping: SUCCESS (4.489s)
[401.908967] [125/133] (643s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[402.388697] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[402.389814] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[402.503697] [126/133] (643s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[402.981803] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[405.059917] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (2.079s)
[405.228297] [127/133] (640s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[405.289216] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[405.395688] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.107s)
[405.500629] [128/133] (640s left) gem_workarounds (basic-read-context)
[405.570755] Starting subtest: basic-read-context
[405.574592] Subtest basic-read-context: SUCCESS (0.004s)
[405.695121] [129/133] (640s left) gem_madvise (dontneed-before-pwrite)
[405.750286] Starting subtest: dontneed-before-pwrite
[405.751812] Subtest dontneed-before-pwrite: SUCCESS (0.002s)
[405.861719] [130/133] (639s left) gem_exec_reloc (basic-write-gtt-noreloc)
[405.921355] Starting subtest: basic-write-gtt-noreloc
[405.924043] Subtest basic-write-gtt-noreloc: SUCCESS (0.003s)
[406.446517] [131/133] (639s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[406.501760] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.000s)
[406.586769] [132/133] (639s left) gem_ctx_isolation (preservation-s3)
[406.652110] Starting subtest: preservation-S3
[406.652682] Starting dynamic subtest: rcs0
[425.563753] Dynamic subtest rcs0: SUCCESS (1.961s)
[425.567766] Subtest preservation-S3: SUCCESS (1.963s)
[430.633111] [133/133] (620s left) gen7_exec_parse (cmd-crossing-page)
[430.701244] Subtest cmd-crossing-page: SKIP (0.000s)
[430.758836] Closing watchdogs
results: parsing output: 0/ for test: gem_userptr_blits
results: parsing output: 1/ for test: syncobj_timeline
results: parsing output: 2/ for test: gem_softpin
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_psr
results: parsing output: 5/ for test: gem_readwrite
results: parsing output: 6/ for test: gem_create
results: parsing output: 7/ for test: kms_content_protection
results: parsing output: 8/ for test: gem_exec_flush
results: parsing output: 9/ for test: gem_ringfill
results: parsing output: 10/ for test: kms_flip
results: parsing output: 11/ for test: syncobj_wait
results: parsing output: 12/ for test: kms_chamelium_hpd
results: parsing output: 13/ for test: kms_flip_scaled_crc
results: parsing output: 14/ for test: syncobj_timeline
results: parsing output: 15/ for test: kms_ccs
results: parsing output: 16/ for test: kms_plane
results: parsing output: 17/ for test: i915_pm_freq_api
results: parsing output: 18/ for test: gem_exec_fence
results: parsing output: 19/ for test: kms_color_pipeline
results: parsing output: 20/ for test: kms_plane_scaling
results: parsing output: 21/ for test: gem_exec_whisper
results: parsing output: 22/ for test: kms_flip
results: parsing output: 23/ for test: kms_pm_lpsp
results: parsing output: 24/ for test: perf_pmu
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_invalid_mode
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: core_setmaster
results: parsing output: 32/ for test: kms_big_fb
results: parsing output: 33/ for test: gem_pxp
results: parsing output: 34/ for test: kms_plane_scaling
results: parsing output: 35/ for test: syncobj_eventfd
results: parsing output: 36/ for test: gem_exec_reloc
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_lmem_swapping
results: parsing output: 39/ for test: kms_async_flips
results: parsing output: 40/ for test: kms_cursor_crc
results: parsing output: 41/ for test: kms_vblank
results: parsing output: 42/ for test: kms_vblank
results: parsing output: 43/ for test: kms_big_fb
results: parsing output: 44/ for test: syncobj_wait
results: parsing output: 45/ for test: kms_cursor_legacy
results: parsing output: 46/ for test: syncobj_wait
results: parsing output: 47/ for test: syncobj_wait
results: parsing output: 48/ for test: gem_exec_params
results: parsing output: 49/ for test: api_intel_bb
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_psr
results: parsing output: 53/ for test: gem_exec_gttfill
results: parsing output: 54/ for test: kms_flip_scaled_crc
results: parsing output: 55/ for test: kms_prop_blob
results: parsing output: 56/ for test: perf_pmu
results: parsing output: 57/ for test: kms_ccs
results: parsing output: 58/ for test: gem_exec_balancer
results: parsing output: 59/ for test: gem_exec_reloc
results: parsing output: 60/ for test: kms_cursor_crc
results: parsing output: 61/ for test: gen9_exec_parse
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: gem_exec_reloc
results: parsing output: 64/ for test: kms_psr
results: parsing output: 65/ for test: gem_mmap_gtt
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_chamelium_audio
results: parsing output: 68/ for test: gem_ctx_persistence
results: parsing output: 69/ for test: gem_userptr_blits
results: parsing output: 70/ for test: kms_flip
results: parsing output: 71/ for test: kms_pipe_crc_basic
results: parsing output: 72/ for test: gem_softpin
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: gem_exec_balancer
results: parsing output: 76/ for test: sw_sync
results: parsing output: 77/ for test: kms_cursor_crc
results: parsing output: 78/ for test: gem_mmap_wc
results: parsing output: 79/ for test: i915_pm_rpm
results: parsing output: 80/ for test: kms_dp_link_training
results: parsing output: 81/ for test: kms_flip
results: parsing output: 82/ for test: kms_pwrite_crc
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: gem_eio
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: kms_psr2_su
results: parsing output: 87/ for test: syncobj_wait
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: gem_exec_create
results: parsing output: 90/ for test: kms_chamelium_edid
results: parsing output: 91/ for test: gem_exec_schedule
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: api_intel_allocator
results: parsing output: 94/ for test: gem_busy
results: parsing output: 95/ for test: syncobj_timeline
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_async_flips
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: gem_softpin
results: parsing output: 101/ for test: i915_query
results: parsing output: 102/ for test: kms_psr
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: gem_render_copy_redux
results: parsing output: 105/ for test: kms_frontbuffer_tracking
results: parsing output: 106/ for test: gem_mmap_gtt
results: parsing output: 107/ for test: gem_exec_gttfill
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_psr2_sf
results: parsing output: 110/ for test: gem_mmap_offset
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: kms_feature_discovery
results: parsing output: 113/ for test: kms_cursor_legacy
results: parsing output: 114/ for test: gem_sync
results: parsing output: 115/ for test: gem_exec_schedule
results: parsing output: 116/ for test: kms_vrr
results: parsing output: 117/ for test: kms_ccs
results: parsing output: 118/ for test: kms_lease
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_psr2_sf
results: parsing output: 122/ for test: syncobj_wait
results: parsing output: 123/ for test: kms_plane
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: syncobj_timeline
results: parsing output: 127/ for test: gem_workarounds
results: parsing output: 128/ for test: gem_madvise
results: parsing output: 129/ for test: gem_exec_reloc
results: parsing output: 130/ for test: kms_ccs
results: parsing output: 131/ for test: gem_ctx_isolation
results: parsing output: 132/ for test: gen7_exec_parse
Done.