[71.794724] Initializing watchdogs
[71.794855]   /dev/watchdog0
[71.815509] [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.823152] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[71.827038] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[71.830387] [001/133] (960s left) gem_userptr_blits (relocations)
[71.903389] Starting subtest: relocations
[71.904350] Subtest relocations: SUCCESS (0.001s)
[72.044219] [002/133] (960s left) syncobj_timeline (single-wait-available-submitted)
[72.105840] Starting subtest: single-wait-available-submitted
[72.107013] Subtest single-wait-available-submitted: SUCCESS (0.001s)
[72.196383] [003/133] (960s left) gem_softpin (allocator-fork)
[72.257179] Subtest allocator-fork: SKIP (0.000s)
[72.344153] [004/133] (960s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[72.835869] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[72.838643] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[72.956235] [005/133] (959s left) kms_psr (pr-primary-mmap-cpu)
[73.436888] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[73.497269] [006/133] (959s left) gem_readwrite (write-bad-handle)
[73.556615] Starting subtest: write-bad-handle
[73.558844] Subtest write-bad-handle: SUCCESS (0.000s)
[73.669766] [007/133] (958s left) gem_create (create-ext-placement-all)
[73.840949] Starting subtest: create-ext-placement-all
[73.842309] Subtest create-ext-placement-all: SUCCESS (0.000s)
[73.952244] [008/133] (958s left) kms_content_protection (dp-mst-type-1-suspend-resume)
[74.460162] Starting subtest: dp-mst-type-1-suspend-resume
[74.467275] Subtest dp-mst-type-1-suspend-resume: SKIP (0.000s)
[74.571554] [009/133] (958s left) gem_exec_flush (basic-uc-rw-default)
[74.642939] Starting subtest: basic-uc-rw-default
[80.089572] Subtest basic-uc-rw-default: SUCCESS (5.449s)
[80.287124] [010/133] (952s left) gem_ringfill (engines-basic)
[80.484280] Starting subtest: engines-basic
[80.485454] Starting dynamic subtest: rcs0
[80.512844] Dynamic subtest rcs0: SUCCESS (0.028s)
[80.524714] Starting dynamic subtest: bcs0
[80.530696] Dynamic subtest bcs0: SUCCESS (0.017s)
[80.532091] Subtest engines-basic: SUCCESS (0.047s)
[80.622490] [FACT gem_ringfill (engines-basic)] new: kernel.kmod_is_loaded.vgem: true
[80.625232] [011/133] (952s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[81.112019] Starting subtest: 2x-absolute-wf_vblank-interruptible
[81.113206] Starting dynamic subtest: AB-VGA1-HDMI-A1
[111.607908] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (30.506s)
[111.610408] Subtest 2x-absolute-wf_vblank-interruptible: SUCCESS (30.509s)
[111.881572] [012/133] (920s left) syncobj_wait (invalid-reset-bad-pad)
[111.940162] Starting subtest: invalid-reset-bad-pad
[111.941255] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[112.037998] [013/133] (920s left) kms_chamelium_hpd (dp-hpd-storm)
[112.633659] Subtest dp-hpd-storm: SKIP (0.000s)
[112.843273] [014/133] (920s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling)
[112.904498] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SKIP (0.000s)
[112.958148] [015/133] (920s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[113.019820] Starting subtest: invalid-multi-wait-unsubmitted
[113.020852] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[113.115049] [016/133] (919s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[113.170374] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s)
[113.224705] [017/133] (919s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier-source-clamping)
[113.708312] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier-source-clamping
[113.710715] Subtest pixel-format-4-tiled-bmg-ccs-modifier-source-clamping: SKIP (0.000s)
[113.795118] [018/133] (919s left) i915_pm_freq_api (freq-suspend)
[113.855570] Subtest freq-suspend: SKIP (0.000s)
[113.921851] [019/133] (919s left) gem_exec_fence (syncobj-timeline-invalid-flags)
[114.245971] Starting subtest: syncobj-timeline-invalid-flags
[114.247297] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.001s)
[114.478805] [020/133] (918s left) kms_color_pipeline (plane-ctm3x4)
[114.969349] Starting subtest: plane-ctm3x4
[115.571658] Subtest plane-ctm3x4: SKIP (0.602s)
[115.844526] [021/133] (917s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[116.330622] Starting subtest: plane-upscale-20x20-with-modifiers
[116.331794] Starting dynamic subtest: pipe-A
[116.336263] Dynamic subtest pipe-A: SKIP (0.002s)
[116.348209] Starting dynamic subtest: pipe-B
[116.353252] Dynamic subtest pipe-B: SKIP (0.001s)
[116.355434] Subtest plane-upscale-20x20-with-modifiers: SKIP (0.004s)
[116.434968] [022/133] (916s left) gem_exec_whisper (basic-fds-priority-all)
[116.501484] Starting subtest: basic-fds-priority-all
[116.504623] Subtest basic-fds-priority-all: SKIP (0.001s)
[116.702327] [023/133] (916s left) kms_flip (2x-dpms-vs-vblank-race)
[117.186390] Starting subtest: 2x-dpms-vs-vblank-race
[117.188142] Starting dynamic subtest: AB-VGA1-HDMI-A1
[127.987156] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (10.799s)
[127.988438] Subtest 2x-dpms-vs-vblank-race: SUCCESS (10.802s)
[128.237687] [024/133] (905s left) kms_pm_lpsp (kms-lpsp)
[139.780914] Starting subtest: kms-lpsp
[139.783417] Subtest kms-lpsp: SKIP (0.001s)
[139.878036] [025/133] (893s left) perf_pmu (init-sema)
[139.942490] Starting subtest: init-sema
[139.943441] Starting dynamic subtest: rcs0
[139.944521] Dynamic subtest rcs0: SUCCESS (0.001s)
[139.955633] Starting dynamic subtest: bcs0
[139.956997] Dynamic subtest bcs0: SUCCESS (0.000s)
[139.968185] Starting dynamic subtest: vcs0
[139.969617] Dynamic subtest vcs0: SUCCESS (0.000s)
[139.970909] Subtest init-sema: SUCCESS (0.004s)
[140.043975] [026/133] (893s left) kms_psr (psr2-primary-page-flip)
[140.527146] Subtest psr2-primary-page-flip: SKIP (0.000s)
[140.590346] [027/133] (893s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[141.089390] Starting subtest: y-tiled-64bpp-rotate-180
[141.091830] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[141.199929] [028/133] (892s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[141.683534] Starting subtest: fbc-1p-pri-indfb-multidraw
[155.715666] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (14.026s)
[155.972740] [029/133] (877s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-pgflip-blt)
[156.462087] Starting subtest: fbc-2p-primscrn-indfb-pgflip-blt
[158.408192] Subtest fbc-2p-primscrn-indfb-pgflip-blt: SUCCESS (1.946s)
[158.561334] [030/133] (875s left) kms_invalid_mode (bad-hsync-start)
[159.041372] Starting subtest: bad-hsync-start
[159.042460] Starting dynamic subtest: pipe-A-VGA-1
[159.158098] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.115s)
[159.170794] Starting dynamic subtest: pipe-A-HDMI-A-1
[159.172288] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.000s)
[159.184237] Starting dynamic subtest: pipe-B-VGA-1
[159.185323] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.001s)
[159.197967] Starting dynamic subtest: pipe-B-HDMI-A-1
[159.199123] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[159.200191] Subtest bad-hsync-start: SUCCESS (0.125s)
[159.440791] [031/133] (874s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[159.929461] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[159.931822] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[160.034277] [032/133] (873s left) core_setmaster (master-drop-set-shared-fd)
[160.168441] Starting subtest: master-drop-set-shared-fd
[160.201887] Subtest master-drop-set-shared-fd: SUCCESS (0.034s)
[160.251515] [033/133] (873s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[160.736389] Starting subtest: yf-tiled-8bpp-rotate-90
[160.738688] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[160.850475] [034/133] (873s left) gem_pxp (regular-baseline-src-copy-readible)
[163.422668] Starting subtest: regular-baseline-src-copy-readible
[163.425019] Subtest regular-baseline-src-copy-readible: SKIP (0.000s)
[163.511494] [035/133] (870s left) kms_plane_scaling (intel-max-src-size)
[163.999227] Starting subtest: intel-max-src-size
[164.001369] Subtest intel-max-src-size: SKIP (0.000s)
[164.093474] [036/133] (869s left) syncobj_eventfd (invalid-illegal-eventfd)
[164.155261] Starting subtest: invalid-illegal-eventfd
[164.156395] Subtest invalid-illegal-eventfd: SUCCESS (0.000s)
[164.245356] [037/133] (869s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[164.310409] Starting subtest: basic-gtt-cpu-noreloc
[164.313928] Subtest basic-gtt-cpu-noreloc: SUCCESS (0.003s)
[164.833218] [038/133] (869s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[165.326627] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[165.328967] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[165.441701] [039/133] (868s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[165.500439] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[165.560803] [040/133] (868s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[166.041598] Starting subtest: async-flip-with-page-flip-events-tiled
[166.275596] Starting dynamic subtest: pipe-A-VGA-1-x
[168.386390] Dynamic subtest pipe-A-VGA-1-x: SUCCESS (2.109s)
[168.493284] Starting dynamic subtest: pipe-A-HDMI-A-1-x
[170.649111] Dynamic subtest pipe-A-HDMI-A-1-x: SUCCESS (2.163s)
[170.804433] Starting dynamic subtest: pipe-B-VGA-1-x
[172.901292] Dynamic subtest pipe-B-VGA-1-x: SUCCESS (2.105s)
[173.003646] Starting dynamic subtest: pipe-B-HDMI-A-1-x
[175.166763] Dynamic subtest pipe-B-HDMI-A-1-x: SUCCESS (2.171s)
[175.168112] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (9.124s)
[175.552477] [041/133] (858s left) kms_cursor_crc (cursor-offscreen-max-size)
[176.049486] Starting subtest: cursor-offscreen-max-size
[176.053154] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[176.166132] [042/133] (858s left) kms_vblank (wait-busy-hang)
[176.645076] Starting subtest: wait-busy-hang
[176.646409] Starting dynamic subtest: pipe-A-VGA-1
[182.939431] Dynamic subtest pipe-A-VGA-1: SUCCESS (6.292s)
[182.952031] Starting dynamic subtest: pipe-A-HDMI-A-1
[188.921281] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (5.980s)
[188.933618] Starting dynamic subtest: pipe-B-VGA-1
[194.913451] Dynamic subtest pipe-B-VGA-1: SUCCESS (5.989s)
[194.925412] Starting dynamic subtest: pipe-B-HDMI-A-1
[200.960934] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (6.046s)
[200.964111] Subtest wait-busy-hang: SUCCESS (24.316s)
[201.254993] [043/133] (833s left) kms_vblank (query-busy)
[201.733731] Starting subtest: query-busy
[201.734941] Starting dynamic subtest: pipe-A-VGA-1
[204.230480] Dynamic subtest pipe-A-VGA-1: SUCCESS (2.496s)
[204.242577] Starting dynamic subtest: pipe-A-HDMI-A-1
[206.658907] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.426s)
[206.671390] Starting dynamic subtest: pipe-B-VGA-1
[209.008653] Dynamic subtest pipe-B-VGA-1: SUCCESS (2.348s)
[209.020519] Starting dynamic subtest: pipe-B-HDMI-A-1
[211.435431] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.424s)
[211.436585] Subtest query-busy: SUCCESS (9.702s)
[211.691292] [044/133] (822s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[212.180322] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[212.275619] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.092s)
[212.493369] [045/133] (822s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[212.553515] Starting subtest: invalid-single-wait-all-unsubmitted
[212.554818] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[212.654334] [046/133] (821s left) kms_cursor_legacy (2x-flip-vs-cursor-atomic)
[213.130875] Starting subtest: 2x-flip-vs-cursor-atomic
[213.596159] Subtest 2x-flip-vs-cursor-atomic: SUCCESS (0.460s)
[213.849624] [047/133] (820s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[213.910269] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[213.911377] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[214.012606] [048/133] (820s left) syncobj_wait (wait-zero-handles)
[214.073212] Starting subtest: wait-zero-handles
[214.074241] Subtest wait-zero-handles: SUCCESS (0.000s)
[214.161895] [049/133] (820s left) gem_exec_params (batch-first)
[214.225636] Starting subtest: batch-first
[214.231418] Subtest batch-first: SUCCESS (0.006s)
[214.350341] [050/133] (820s left) api_intel_bb (full-batch)
[214.408737] Starting subtest: full-batch
[214.409790] Subtest full-batch: SUCCESS (0.002s)
[214.532098] [051/133] (820s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt)
[215.014492] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt
[215.016986] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[215.118503] [052/133] (819s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[215.604240] Starting subtest: psr-rgb565-draw-mmap-wc
[215.606483] Subtest psr-rgb565-draw-mmap-wc: SKIP (0.000s)
[215.715203] [053/133] (819s left) kms_psr (psr-no-drrs)
[216.193335] Subtest psr-no-drrs: SKIP (0.000s)
[216.256575] [054/133] (818s left) gem_exec_gttfill (basic)
[216.326319] Starting subtest: basic
[220.172980] Subtest basic: SUCCESS (3.848s)
[220.386374] [055/133] (814s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[220.524142] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (0.000s)
[220.602603] [056/133] (814s left) kms_prop_blob (basic)
[220.662540] Starting subtest: basic
[220.663589] Subtest basic: SUCCESS (0.000s)
[220.792769] [057/133] (814s left) perf_pmu (semaphore-wait-idle)
[220.852338] Starting subtest: semaphore-wait-idle
[220.853443] Starting dynamic subtest: rcs0
[220.855563] Dynamic subtest rcs0: SKIP (0.001s)
[220.869543] Starting dynamic subtest: bcs0
[220.872266] Dynamic subtest bcs0: SKIP (0.001s)
[220.885939] Starting dynamic subtest: vcs0
[220.888612] Dynamic subtest vcs0: SKIP (0.000s)
[220.891091] Subtest semaphore-wait-idle: SKIP (0.005s)
[220.966591] [058/133] (814s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc)
[221.027437] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s)
[221.080415] [059/133] (814s left) gem_exec_balancer (semaphore)
[221.143516] Subtest semaphore: SKIP (0.000s)
[221.233905] [060/133] (814s left) gem_exec_reloc (basic-cpu-wc-active)
[221.294562] Starting subtest: basic-cpu-wc-active
[221.404822] Subtest basic-cpu-wc-active: SUCCESS (0.110s)
[221.935561] [061/133] (813s left) kms_cursor_crc (cursor-random-512x512)
[222.433882] Starting subtest: cursor-random-512x512
[222.436080] Subtest cursor-random-512x512: SKIP (0.001s)
[222.557604] [062/133] (812s left) gen9_exec_parse (valid-registers)
[222.622309] Subtest valid-registers: SKIP (0.000s)
[222.698146] [063/133] (812s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[223.186668] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[223.189265] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[223.295947] [064/133] (812s left) gem_exec_reloc (basic-cpu-gtt-active)
[223.360468] Starting subtest: basic-cpu-gtt-active
[223.470144] Subtest basic-cpu-gtt-active: SUCCESS (0.110s)
[223.980388] [065/133] (811s left) kms_psr (fbc-pr-primary-render)
[224.456378] Subtest fbc-pr-primary-render: SKIP (0.000s)
[224.522214] [066/133] (811s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[224.582989] Starting subtest: cpuset-basic-small-copy-XY
[225.435996] Subtest cpuset-basic-small-copy-XY: SUCCESS (0.853s)
[225.583624] [067/133] (810s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[226.178076] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[226.181356] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[226.289179] [068/133] (809s left) kms_chamelium_audio (dp-audio-edid)
[226.873923] Subtest dp-audio-edid: SKIP (0.000s)
[227.086794] [069/133] (808s left) gem_ctx_persistence (heartbeat-stop)
[227.149296] Subtest heartbeat-stop: SKIP (0.000s)
[227.219549] [070/133] (808s left) gem_userptr_blits (nohangcheck)
[227.309914] Starting subtest: nohangcheck
[227.363329] Subtest nohangcheck: SUCCESS (0.052s)
[227.488619] [071/133] (808s left) kms_flip (plain-flip-ts-check)
[227.964484] Starting subtest: plain-flip-ts-check
[227.965509] Starting dynamic subtest: A-VGA1
[236.104204] Dynamic subtest A-VGA1: SUCCESS (8.138s)
[236.117658] Starting dynamic subtest: B-VGA1
[244.105461] Dynamic subtest B-VGA1: SUCCESS (7.998s)
[244.119774] Starting dynamic subtest: A-HDMI-A1
[252.142931] Dynamic subtest A-HDMI-A1: SUCCESS (8.034s)
[252.161360] Starting dynamic subtest: B-HDMI-A1
[260.202117] Dynamic subtest B-HDMI-A1: SUCCESS (8.057s)
[260.205775] Subtest plain-flip-ts-check: SUCCESS (32.240s)
[260.390710] [072/133] (775s left) kms_pipe_crc_basic (suspend-read-crc)
[260.868550] Starting subtest: suspend-read-crc
[260.869721] Starting dynamic subtest: pipe-A-VGA-1
[278.356771] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.635s)
[278.372262] Starting dynamic subtest: pipe-B-HDMI-A-1
[296.430048] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.606s)
[296.431044] Subtest suspend-read-crc: SUCCESS (3.247s)
[306.700381] [073/133] (739s left) gem_softpin (evict-active-interruptible)
[306.773131] Starting subtest: evict-active-interruptible
[306.775849] Subtest evict-active-interruptible: SUCCESS (0.004s)
[306.927140] [074/133] (739s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render)
[307.428414] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render
[309.062891] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SUCCESS (1.581s)
[309.222001] [075/133] (737s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[309.716106] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[309.718462] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[309.840354] [076/133] (736s left) gem_exec_balancer (full)
[309.908643] Subtest full: SKIP (0.000s)
[310.009855] [077/133] (736s left) sw_sync (sync_busy_fork_unixsocket)
[310.077682] Starting subtest: sync_busy_fork_unixsocket
[310.093770] Subtest sync_busy_fork_unixsocket: SUCCESS (0.015s)
[310.190799] [078/133] (736s left) kms_cursor_crc (cursor-tearing-position-change)
[310.682116] Starting subtest: cursor-tearing-position-change
[310.685541] Starting dynamic subtest: pipe-A-VGA-1
[311.108942] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.414s)
[311.123208] Starting dynamic subtest: pipe-B-HDMI-A-1
[311.484423] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.364s)
[311.485627] Subtest cursor-tearing-position-change: SUCCESS (0.783s)
[311.766270] [079/133] (734s left) gem_mmap_wc (bad-size)
[311.828287] Starting subtest: bad-size
[311.829464] Subtest bad-size: SUCCESS (0.001s)
[311.949957] [080/133] (734s left) i915_pm_rpm (gem-idle)
[323.742063] Subtest gem-idle: SKIP (0.000s)
[323.805852] [081/133] (722s left) kms_dp_link_training (non-uhbr-sst)
[324.291134] Starting subtest: non-uhbr-sst
[324.298445] Subtest non-uhbr-sst: SKIP (0.000s)
[324.394438] [082/133] (722s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[324.880480] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[324.883788] Starting dynamic subtest: AB-VGA1-HDMI-A1
[327.541368] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (2.648s)
[327.546454] Subtest 2x-flip-vs-wf_vblank-interruptible: SUCCESS (2.653s)
[327.817899] [083/133] (718s left) kms_pwrite_crc
[329.061873] [084/133] (717s left) kms_frontbuffer_tracking (psr-suspend)
[329.553044] Starting subtest: psr-suspend
[329.555447] Subtest psr-suspend: SKIP (0.000s)
[329.682048] [085/133] (717s left) gem_eio (context-create)
[329.750241] Starting subtest: context-create
[329.778082] Subtest context-create: SUCCESS (0.027s)
[330.301468] [086/133] (716s left) kms_big_fb (x-tiled-64bpp-rotate-0)
[330.786880] Starting subtest: x-tiled-64bpp-rotate-0
[332.522681] Subtest x-tiled-64bpp-rotate-0: SUCCESS (1.731s)
[332.814456] [087/133] (714s left) kms_psr2_su (page_flip-p010)
[332.873530] Subtest page_flip-P010: SKIP (0.000s)
[332.945339] [088/133] (714s left) syncobj_wait (single-wait-all-signaled)
[333.007884] Starting subtest: single-wait-all-signaled
[333.008987] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[333.112677] [089/133] (713s left) kms_big_fb (linear-16bpp-rotate-180)
[333.598076] Starting subtest: linear-16bpp-rotate-180
[334.983619] Subtest linear-16bpp-rotate-180: SUCCESS (1.384s)
[335.242660] [090/133] (711s left) gem_exec_create (forked)
[335.312164] Starting subtest: forked
[335.313152] Starting dynamic subtest: smem
[355.417890] Dynamic subtest smem: SUCCESS (20.099s)
[355.422125] Subtest forked: SUCCESS (20.102s)
[355.627149] [091/133] (691s left) kms_chamelium_edid (dp-edid-resolution-list)
[356.223349] Subtest dp-edid-resolution-list: SKIP (0.000s)
[356.465538] [092/133] (690s left) gem_exec_schedule (pi-userfault)
[356.540873] Subtest pi-userfault: SKIP (0.000s)
[356.750640] [093/133] (690s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[357.240292] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[359.351224] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (2.110s)
[359.491238] [094/133] (687s left) api_intel_allocator (gem-pool)
[359.554864] Starting subtest: gem-pool
[359.558097] Subtest gem-pool: SUCCESS (0.004s)
[359.689769] [095/133] (687s left) gem_busy (semaphore)
[359.881258] Subtest semaphore: SKIP (0.000s)
[360.109385] [096/133] (687s left) syncobj_timeline (reset-unsignaled)
[360.166430] Starting subtest: reset-unsignaled
[360.167491] Subtest reset-unsignaled: SUCCESS (0.000s)
[360.275582] [097/133] (687s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[360.760365] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[360.762638] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[360.878778] [098/133] (686s left) kms_async_flips (test-cursor)
[361.352339] Starting subtest: test-cursor
[361.582449] Starting dynamic subtest: pipe-A-VGA-1
[361.681211] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.099s)
[361.800255] Starting dynamic subtest: pipe-A-HDMI-A-1
[361.933870] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.148s)
[362.096050] Starting dynamic subtest: pipe-B-VGA-1
[362.191244] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.109s)
[362.306814] Starting dynamic subtest: pipe-B-HDMI-A-1
[362.440957] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.147s)
[362.442153] Subtest test-cursor: SUCCESS (1.089s)
[362.852462] [099/133] (684s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[363.336252] Starting subtest: 4-tiled-32bpp-rotate-180
[363.338286] Subtest 4-tiled-32bpp-rotate-180: SKIP (0.000s)
[363.451248] [100/133] (684s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[363.930268] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[365.888223] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SUCCESS (1.957s)
[366.025066] [101/133] (681s left) gem_softpin (evict-active)
[366.086391] Starting subtest: evict-active
[366.089304] Subtest evict-active: SUCCESS (0.004s)
[366.207061] [102/133] (681s left) i915_query (query-regions-garbage-items)
[366.271035] Starting subtest: query-regions-garbage-items
[366.272124] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[366.374622] [103/133] (681s left) kms_psr (fbc-psr-no-drrs)
[366.852719] Subtest fbc-psr-no-drrs: SKIP (0.000s)
[366.924477] [104/133] (681s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[367.411216] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[367.413558] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[367.532359] [105/133] (680s left) gem_render_copy_redux (interruptible)
[367.596267] Starting subtest: interruptible
[368.155542] Subtest interruptible: SUCCESS (0.558s)
[368.255697] [106/133] (679s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff)
[368.736272] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff
[368.738458] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[368.855496] [107/133] (679s left) gem_mmap_gtt (basic-small-copy-odd)
[368.916275] Starting subtest: basic-small-copy-odd
[369.460136] Subtest basic-small-copy-odd: SUCCESS (0.544s)
[369.575718] [108/133] (678s left) gem_exec_gttfill (multigpu-basic)
[369.856873] Starting subtest: multigpu-basic
[374.368561] Subtest multigpu-basic: SUCCESS (4.510s)
[374.437843] [109/133] (673s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[375.001344] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[376.459518] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SUCCESS (1.459s)
[376.612190] [110/133] (671s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[377.099062] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[377.159061] [111/133] (671s left) gem_mmap_offset (blt-coherency)
[377.216284] Starting subtest: blt-coherency
[377.221796] Subtest blt-coherency: SUCCESS (0.006s)
[377.347935] [112/133] (671s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-pwrite)
[377.827083] Starting subtest: psr-1p-offscreen-pri-indfb-draw-pwrite
[377.829130] Subtest psr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s)
[377.931114] [113/133] (670s left) kms_feature_discovery (psr1)
[378.408332] Starting subtest: psr1
[378.410555] Subtest psr1: SKIP (0.000s)
[378.511076] [114/133] (669s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[378.987095] Starting subtest: flip-vs-cursor-legacy
[388.937896] Subtest flip-vs-cursor-legacy: SUCCESS (9.945s)
[389.197694] [115/133] (659s left) gem_sync (basic-store-all)
[389.270889] Starting subtest: basic-store-all
[391.504502] Subtest basic-store-all: SUCCESS (2.230s)
[391.717505] [116/133] (656s left) gem_exec_schedule (preempt-self)
[391.801200] Subtest preempt-self: SKIP (0.000s)
[392.010509] [117/133] (656s left) kms_vrr (seamless-rr-switch-virtual)
[392.487031] Starting subtest: seamless-rr-switch-virtual
[392.491337] Subtest seamless-rr-switch-virtual: SKIP (0.000s)
[392.595786] [118/133] (656s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[392.654711] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[392.721361] [119/133] (656s left) kms_lease (lease-uevent)
[393.192474] Starting subtest: lease-uevent
[394.238956] Subtest lease-uevent: SUCCESS (1.047s)
[394.341737] [120/133] (654s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite)
[394.833111] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite
[396.882137] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SUCCESS (2.051s)
[397.041599] [121/133] (651s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[397.522355] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[398.924858] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (1.403s)
[399.165755] [122/133] (649s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area)
[399.643013] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[399.708489] [123/133] (649s left) syncobj_wait (invalid-reset-one-illegal-handle)
[399.770203] Starting subtest: invalid-reset-one-illegal-handle
[399.771246] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s)
[399.862211] [124/133] (649s left) kms_plane (pixel-format-linear-modifier-source-clamping)
[400.339249] Starting subtest: pixel-format-linear-modifier-source-clamping
[400.444993] Starting dynamic subtest: pipe-A-plane-0
[401.262627] Dynamic subtest pipe-A-plane-0: SUCCESS (0.818s)
[401.280634] Starting dynamic subtest: pipe-A-plane-1
[402.198297] Dynamic subtest pipe-A-plane-1: SUCCESS (0.934s)
[402.424782] Starting dynamic subtest: pipe-B-plane-0
[403.787655] Dynamic subtest pipe-B-plane-0: SUCCESS (1.379s)
[403.805409] Starting dynamic subtest: pipe-B-plane-1
[404.718603] Dynamic subtest pipe-B-plane-1: SUCCESS (0.928s)
[404.818313] Subtest pixel-format-linear-modifier-source-clamping: SUCCESS (4.482s)
[405.084052] [125/133] (644s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move)
[405.567248] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move
[405.569688] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SKIP (0.000s)
[405.681667] [126/133] (643s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[406.170513] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[408.230133] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (2.062s)
[408.403671] [127/133] (640s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted)
[408.466311] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted
[408.574013] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.107s)
[408.687519] [128/133] (640s left) gem_workarounds (basic-read-context)
[408.763305] Starting subtest: basic-read-context
[408.767829] Subtest basic-read-context: SUCCESS (0.005s)
[408.904595] [129/133] (640s left) gem_madvise (dontneed-before-pwrite)
[408.961259] Starting subtest: dontneed-before-pwrite
[408.963534] Subtest dontneed-before-pwrite: SUCCESS (0.002s)
[409.071509] [130/133] (640s left) gem_exec_reloc (basic-write-gtt-noreloc)
[409.133243] Starting subtest: basic-write-gtt-noreloc
[409.136607] Subtest basic-write-gtt-noreloc: SUCCESS (0.003s)
[409.665062] [131/133] (639s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[409.726841] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.000s)
[409.802108] [132/133] (639s left) gem_ctx_isolation (preservation-s3)
[409.872732] Starting subtest: preservation-S3
[409.873992] Starting dynamic subtest: rcs0
[427.125447] Dynamic subtest rcs0: SUCCESS (1.145s)
[427.126509] Subtest preservation-S3: SUCCESS (1.147s)
[436.371320] [133/133] (622s left) gen7_exec_parse (cmd-crossing-page)
[436.433518] Subtest cmd-crossing-page: SKIP (0.000s)
[436.496816] 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.