[71.474316] Initializing watchdogs
[71.474420]   /dev/watchdog0
[71.492997] [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.500901] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[71.504786] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[71.507766] [001/131] (960s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[71.899339] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[75.178827] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (3.280s)
[75.727313] [002/131] (956s left) kms_chamelium_audio (hdmi-audio)
[76.182860] Subtest hdmi-audio: SKIP (0.000s)
[76.557118] [003/131] (955s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[76.923631] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[76.925343] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[77.366603] [004/131] (954s left) kms_busy (extended-modeset-hang-oldfb)
[77.737154] Starting subtest: extended-modeset-hang-oldfb
[77.737853] Starting dynamic subtest: pipe-A
[84.164654] Dynamic subtest pipe-A: SUCCESS (6.427s)
[84.173931] Starting dynamic subtest: pipe-B
[90.159345] Dynamic subtest pipe-B: SUCCESS (5.993s)
[90.160086] Subtest extended-modeset-hang-oldfb: SUCCESS (12.424s)
[90.711122] [005/131] (941s left) kms_vblank (ts-continuation-idle-hang)
[91.085884] Starting subtest: ts-continuation-idle-hang
[91.088257] Starting dynamic subtest: pipe-A-HDMI-A-1
[96.954454] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (5.866s)
[96.963962] Starting dynamic subtest: pipe-B-HDMI-A-1
[102.968979] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (6.014s)
[102.969891] Subtest ts-continuation-idle-hang: SUCCESS (11.884s)
[103.513164] [006/131] (928s left) gem_readwrite (new-obj)
[103.571877] Starting subtest: new-obj
[103.573353] Subtest new-obj: SUCCESS (0.000s)
[103.676943] [007/131] (928s left) kms_cursor_crc (cursor-onscreen-512x512)
[104.046849] Starting subtest: cursor-onscreen-512x512
[104.049189] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[104.474973] [008/131] (927s left) i915_pm_rps (reset)
[104.538541] Starting subtest: reset
[108.071134] Subtest reset: SUCCESS (3.532s)
[108.186738] [009/131] (924s left) kms_color (ctm-blue-to-red)
[108.544830] Starting subtest: ctm-blue-to-red
[108.546123] Starting dynamic subtest: pipe-A-HDMI-A-1
[109.006684] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.464s)
[109.015901] Starting dynamic subtest: pipe-B-HDMI-A-1
[109.524277] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.517s)
[109.525177] Subtest ctm-blue-to-red: SUCCESS (0.982s)
[110.069753] [010/131] (922s left) kms_async_flips (test-time-stamp)
[110.441221] Starting subtest: test-time-stamp
[110.576111] Starting dynamic subtest: pipe-A-HDMI-A-1
[110.751713] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.174s)
[110.910739] Starting dynamic subtest: pipe-B-HDMI-A-1
[111.038658] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.135s)
[111.039722] Subtest test-time-stamp: SUCCESS (0.598s)
[111.728214] [011/131] (920s left) gen9_exec_parse (shadow-peek)
[111.786263] Subtest shadow-peek: SKIP (0.000s)
[111.840196] [012/131] (920s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[112.201582] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[112.419095] [013/131] (920s left) perf (non-sampling-read-error)
[112.517556] Subtest non-sampling-read-error: SKIP (0.000s)
[112.568665] [014/131] (920s left) kms_pm_backlight (bad-brightness)
[112.925469] Subtest bad-brightness: SKIP (0.000s)
[113.152504] [015/131] (919s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[113.511779] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[113.513383] Subtest psr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[113.943391] [016/131] (918s left) gem_exec_schedule (manyslice)
[114.012289] Subtest manyslice: SKIP (0.000s)
[114.212180] [017/131] (918s left) kms_pm_rpm (basic-pci-d3-state)
[125.793856] Subtest basic-pci-d3-state: SKIP (0.000s)
[126.040074] [018/131] (906s left) core_setmaster (master-drop-set-root)
[126.135136] Starting subtest: master-drop-set-root
[126.137261] Subtest master-drop-set-root: SUCCESS (0.005s)
[126.195112] [019/131] (906s left) gem_busy (extended)
[126.378505] Starting subtest: extended
[126.379585] Starting dynamic subtest: rcs0
[126.406746] Dynamic subtest rcs0: SUCCESS (0.028s)
[126.423902] Starting dynamic subtest: bcs0
[126.424707] Dynamic subtest bcs0: SUCCESS (0.015s)
[126.425447] Subtest extended: SUCCESS (0.045s)
[126.646282] [020/131] (906s left) gem_exec_schedule (smoketest)
[126.716494] Subtest smoketest: SKIP (0.000s)
[126.912431] [021/131] (905s left) syncobj_wait (single-wait-all-for-submit-signaled)
[126.968689] Starting subtest: single-wait-all-for-submit-signaled
[126.969358] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[127.059977] [022/131] (905s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[127.423042] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[127.423951] Starting dynamic subtest: pipe-A
[127.426505] Dynamic subtest pipe-A: SKIP (0.001s)
[127.435985] Starting dynamic subtest: pipe-B
[127.437850] Dynamic subtest pipe-B: SKIP (0.001s)
[127.438980] Subtest plane-scaler-unity-scaling-with-pixel-format: SKIP (0.004s)
[127.860693] [023/131] (905s left) kms_cursor_crc (cursor-sliding-256x85)
[128.230475] Starting subtest: cursor-sliding-256x85
[128.288599] Subtest cursor-sliding-256x85: SKIP (0.054s)
[128.728256] [024/131] (904s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[129.093810] Starting subtest: cursorA-vs-flipB-toggle
[129.095209] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s)
[129.525822] [025/131] (903s left) kms_psr (fbc-psr2-sprite-render)
[129.889156] Subtest fbc-psr2-sprite-render: SKIP (0.000s)
[130.115808] [026/131] (903s left) kms_addfb_basic (bad-pitch-256)
[130.174331] Starting subtest: bad-pitch-256
[130.174990] Subtest bad-pitch-256: SUCCESS (0.000s)
[130.924537] [027/131] (902s left) kms_psr (pr-dpms)
[131.284338] Subtest pr-dpms: SKIP (0.000s)
[131.513416] [028/131] (901s left) gem_lmem_swapping (heavy-random)
[131.569603] Subtest heavy-random: SKIP (0.000s)
[131.629920] [029/131] (901s left) gem_softpin (allocator-nopin-reserve)
[131.686860] Subtest allocator-nopin-reserve: SKIP (0.000s)
[131.769729] [030/131] (901s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[132.136557] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[132.137688] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[132.568227] [031/131] (900s left) syncobj_timeline (multi-wait-signaled)
[132.628701] Starting subtest: multi-wait-signaled
[132.630313] Subtest multi-wait-signaled: SUCCESS (0.001s)
[132.719283] [032/131] (900s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[133.084964] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[133.086444] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[133.518290] [033/131] (899s left) gem_exec_gttfill (all-engines)
[133.587056] Starting subtest: all-engines
[157.599762] Subtest all-engines: SUCCESS (24.005s)
[157.790326] [034/131] (875s left) gem_exec_params (no-bsd)
[157.938942] Starting subtest: no-bsd
[157.939942] Subtest no-bsd: SUCCESS (0.000s)
[158.050946] [035/131] (875s left) gem_exec_params (cliprects_ptr-dirt)
[158.107481] Starting subtest: cliprects_ptr-dirt
[158.108349] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[158.202156] [036/131] (875s left) api_intel_allocator (alloc-simple)
[158.257977] Starting subtest: alloc-simple
[158.260652] Subtest alloc-simple: SUCCESS (0.004s)
[158.374499] [037/131] (875s left) gem_exec_whisper (basic-fds-priority)
[158.439224] Starting subtest: basic-fds-priority
[158.441861] Subtest basic-fds-priority: SKIP (0.001s)
[158.639556] [038/131] (875s left) syncobj_timeline (single-wait-all-signaled)
[158.706068] Starting subtest: single-wait-all-signaled
[158.707161] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[158.790168] [039/131] (874s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[158.849094] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SKIP (0.000s)
[158.901264] [040/131] (874s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[159.280349] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[159.281653] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[159.724965] [041/131] (874s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[160.091846] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[160.093153] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[160.518963] [042/131] (873s left) kms_pm_rpm (pm-tiling)
[172.186221] Subtest pm-tiling: SKIP (0.000s)
[172.411310] [043/131] (861s left) kms_vrr (flip-basic)
[172.772074] Starting subtest: flip-basic
[172.773826] Subtest flip-basic: SKIP (0.000s)
[173.215459] [044/131] (860s left) gem_ppgtt (blt-vs-render-ctxn)
[173.278616] Starting subtest: blt-vs-render-ctxN
[205.809703] Subtest blt-vs-render-ctxN: SUCCESS (32.527s)
[205.945497] [045/131] (828s left) gem_exec_flush (basic-uc-set-default)
[206.108413] Starting subtest: basic-uc-set-default
[211.551585] Subtest basic-uc-set-default: SUCCESS (5.442s)
[211.744926] [046/131] (822s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[212.116420] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[212.118876] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[212.559090] [047/131] (821s left) kms_chamelium_hpd (common-hpd-after-suspend)
[212.998746] Subtest common-hpd-after-suspend: SKIP (0.000s)
[213.331537] [048/131] (820s left) kms_addfb_basic (unused-handle)
[213.389738] Starting subtest: unused-handle
[213.390305] Subtest unused-handle: SUCCESS (0.000s)
[214.120315] [049/131] (820s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[214.492371] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[214.493797] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[214.936120] [050/131] (819s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[215.303105] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[215.304379] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[215.734419] [051/131] (818s left) gem_exec_store (pages)
[215.802882] Starting subtest: pages
[215.803710] Starting dynamic subtest: rcs0
[215.871972] Dynamic subtest rcs0: SUCCESS (0.068s)
[215.885436] Starting dynamic subtest: bcs0
[215.915292] Dynamic subtest bcs0: SUCCESS (0.042s)
[215.916431] Subtest pages: SUCCESS (0.114s)
[216.118144] [052/131] (818s left) gem_exec_reloc (basic-gtt-active)
[216.178925] Starting subtest: basic-gtt-active
[216.290210] Subtest basic-gtt-active: SUCCESS (0.111s)
[217.015257] [053/131] (817s left) syncobj_wait (wait-all-snapshot)
[217.088337] Starting subtest: wait-all-snapshot
[217.171236] Subtest wait-all-snapshot: SUCCESS (0.082s)
[217.264648] [054/131] (817s left) gem_eio (wait-1us)
[217.324322] Starting subtest: wait-1us
[217.359633] Subtest wait-1us: SUCCESS (0.035s)
[218.093324] [055/131] (816s left) perf_pmu (semaphore-wait-idle)
[218.155040] Starting subtest: semaphore-wait-idle
[218.155730] Starting dynamic subtest: rcs0
[218.157057] Dynamic subtest rcs0: SKIP (0.001s)
[218.169655] Starting dynamic subtest: bcs0
[218.171572] Dynamic subtest bcs0: SKIP (0.000s)
[218.183462] Starting dynamic subtest: vcs0
[218.185214] Dynamic subtest vcs0: SKIP (0.000s)
[218.186806] Subtest semaphore-wait-idle: SKIP (0.005s)
[218.261267] [056/131] (816s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[218.316313] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SKIP (0.000s)
[218.371361] [057/131] (816s left) kms_psr (psr2-sprite-mmap-cpu)
[218.726878] Subtest psr2-sprite-mmap-cpu: SKIP (0.000s)
[218.953081] [058/131] (815s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[219.321467] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[219.324153] Subtest psr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[219.762128] [059/131] (814s left) kms_legacy_colorkey (basic)
[220.119949] Starting subtest: basic
[220.120653] Starting dynamic subtest: pipe-A
[220.121343] Dynamic subtest pipe-A: SUCCESS (0.000s)
[220.131797] Starting dynamic subtest: pipe-B
[220.132460] Dynamic subtest pipe-B: SUCCESS (0.000s)
[220.133282] Subtest basic: SUCCESS (0.003s)
[220.560492] [060/131] (814s left) prime_mmap_coherency (ioctl-errors)
[220.627257] Starting subtest: ioctl-errors
[229.630720] Subtest ioctl-errors: SUCCESS (9.002s)
[229.785504] [061/131] (804s left) kms_addfb_basic (legacy-format)
[229.948711] Starting subtest: legacy-format
[230.039658] Subtest legacy-format: SUCCESS (0.083s)
[230.767571] [062/131] (804s left) sysfs_heartbeat_interval (invalid)
[230.848827] Starting subtest: invalid
[230.850950] Starting dynamic subtest: vcs0
[230.851837] Dynamic subtest vcs0: SUCCESS (0.000s)
[230.865274] Starting dynamic subtest: bcs0
[230.866290] Dynamic subtest bcs0: SUCCESS (0.000s)
[230.876828] Starting dynamic subtest: rcs0
[230.877624] Dynamic subtest rcs0: SUCCESS (0.000s)
[230.878289] Subtest invalid: SUCCESS (0.006s)
[230.931245] [063/131] (803s left) kms_cursor_edge_walk (64x64-left-edge)
[231.276253] Starting subtest: 64x64-left-edge
[231.277031] Starting dynamic subtest: pipe-A-HDMI-A-1
[234.782640] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.506s)
[234.796760] Starting dynamic subtest: pipe-B-HDMI-A-1
[238.116398] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.331s)
[238.117129] Subtest 64x64-left-edge: SUCCESS (6.841s)
[238.668797] [064/131] (796s left) gem_wait (wait)
[238.755781] Starting subtest: wait
[238.756532] Starting dynamic subtest: all-engines
[239.778686] Dynamic subtest all-engines: SUCCESS (1.022s)
[239.791266] Starting dynamic subtest: rcs0
[240.796820] Dynamic subtest rcs0: SUCCESS (1.016s)
[240.809920] Starting dynamic subtest: bcs0
[241.817566] Dynamic subtest bcs0: SUCCESS (1.019s)
[241.830319] Starting dynamic subtest: vcs0
[242.837842] Dynamic subtest vcs0: SUCCESS (1.018s)
[242.840015] Subtest wait: SUCCESS (4.083s)
[243.070324] [065/131] (791s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[243.437379] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[243.438782] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[243.882759] [066/131] (791s left) gem_mmap (basic)
[243.941301] Starting subtest: basic
[243.944936] Subtest basic: SUCCESS (0.000s)
[244.052215] [067/131] (790s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[244.408521] Starting subtest: plane-primary-overlay-mutable-zpos
[244.699638] Subtest plane-primary-overlay-mutable-zpos: SKIP (0.290s)
[245.307615] [068/131] (789s left) kms_flip (2x-blocking-wf_vblank)
[245.672926] Starting subtest: 2x-blocking-wf_vblank
[245.673669] Starting dynamic subtest: AB-VGA1-HDMI-A1
[276.398055] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (30.723s)
[276.402019] Subtest 2x-blocking-wf_vblank: SUCCESS (30.727s)
[277.041564] [069/131] (758s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[277.413233] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[277.414590] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[277.841285] [070/131] (757s left) sw_sync (sync_expired_merge)
[277.908651] Starting subtest: sync_expired_merge
[278.983318] Subtest sync_expired_merge: SUCCESS (1.074s)
[279.058230] [071/131] (756s left) kms_plane_lowres (tiling-y)
[279.417180] Starting subtest: tiling-y
[279.419063] Subtest tiling-y: SKIP (0.000s)
[279.854261] [072/131] (755s left) sw_sync (sync_merge_invalid)
[279.913115] Starting subtest: sync_merge_invalid
[279.917878] Subtest sync_merge_invalid: SUCCESS (0.004s)
[279.982770] [073/131] (755s left) gem_wait (invalid-flags)
[280.038744] Starting subtest: invalid-flags
[280.039534] Subtest invalid-flags: SUCCESS (0.000s)
[280.266636] [074/131] (755s left) gem_mmap_gtt (basic-copy)
[280.320185] Starting subtest: basic-copy
[280.530755] Subtest basic-copy: SUCCESS (0.210s)
[280.632760] [075/131] (754s left) gem_caching (writes)
[280.690327] Starting subtest: writes
[283.685521] Subtest writes: SUCCESS (2.996s)
[283.811480] [076/131] (751s left) gem_mmap_wc (bad-offset)
[283.876561] Starting subtest: bad-offset
[283.877509] Subtest bad-offset: SUCCESS (0.000s)
[283.993987] [077/131] (751s left) gem_userptr_blits (huge-split)
[284.076994] Starting subtest: huge-split
[284.081205] Subtest huge-split: SUCCESS (0.004s)
[284.194636] [078/131] (751s left) syncobj_timeline (32bits-limit)
[284.253905] Starting subtest: 32bits-limit
[284.254752] Subtest 32bits-limit: SUCCESS (0.001s)
[284.344880] [079/131] (751s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc)
[284.400876] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s)
[284.457604] [080/131] (751s left) kms_psr2_su (frontbuffer-xrgb8888)
[284.514794] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[284.574230] [081/131] (751s left) i915_pm_rpm (gem-evict-pwrite)
[296.164959] Subtest gem-evict-pwrite: SKIP (0.000s)
[296.397875] [082/131] (739s left) gem_exec_nop (basic-parallel)
[296.468205] Starting subtest: basic-parallel
[299.251636] Subtest basic-parallel: SUCCESS (2.783s)
[299.499199] [083/131] (736s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[299.857638] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[299.858892] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[300.296337] [084/131] (735s left) gem_eio (in-flight-1us)
[300.363095] Starting subtest: in-flight-1us
[301.866080] Subtest in-flight-1us: SUCCESS (1.501s)
[302.614633] [FACT gem_eio (in-flight-1us)] new: kernel.kmod_is_loaded.vgem: true
[302.617744] [085/131] (733s left) gem_exec_endless (dispatch)
[302.679298] Subtest dispatch: SKIP (0.000s)
[302.775871] [086/131] (733s left) api_intel_bb (misplaced-blitter)
[302.830363] Starting subtest: misplaced-blitter
[302.832826] Subtest misplaced-blitter: SUCCESS (0.003s)
[302.961621] [087/131] (733s left) gem_flink_basic (basic)
[303.015574] Starting subtest: basic
[303.016210] Subtest basic: SUCCESS (0.000s)
[303.122406] [088/131] (732s left) gem_ctx_persistence (smoketest)
[303.181046] Subtest smoketest: SKIP (0.000s)
[303.242284] [089/131] (732s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[303.603337] Starting subtest: psr-dirtyfb-ioctl
[303.606435] Subtest psr-dirtyfb-ioctl: SKIP (0.000s)
[304.039569] [090/131] (732s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[304.403989] Starting subtest: cursorA-vs-flipA-varying-size
[315.332972] Subtest cursorA-vs-flipA-varying-size: SUCCESS (10.929s)
[315.879827] [091/131] (720s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[315.943767] Subtest invalidate-primary-flip-overlay: SKIP (0.000s)
[316.022836] [092/131] (720s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[316.378559] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[316.380253] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[316.830628] [093/131] (719s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted)
[316.888966] Starting subtest: invalid-multi-wait-all-unsubmitted
[316.889724] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[316.982789] [094/131] (719s left) prime_busy (hang-wait)
[317.043371] Starting subtest: hang-wait
[317.045609] Starting dynamic subtest: rcs0
[322.862660] Dynamic subtest rcs0: SUCCESS (5.817s)
[322.874969] Starting dynamic subtest: bcs0
[328.877613] Dynamic subtest bcs0: SUCCESS (6.013s)
[328.889851] Starting dynamic subtest: vcs0
[334.897688] Dynamic subtest vcs0: SUCCESS (6.019s)
[334.898528] Subtest hang-wait: SUCCESS (17.855s)
[335.023867] [095/131] (701s left) gem_sync (basic-each)
[335.105525] Starting subtest: basic-each
[337.216056] Subtest basic-each: SUCCESS (2.110s)
[337.424268] [096/131] (699s left) gem_exec_balancer (parallel-keep-in-fence)
[337.482944] Subtest parallel-keep-in-fence: SKIP (0.000s)
[337.570948] [097/131] (698s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[337.950884] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[337.952261] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[338.386486] [098/131] (698s left) kms_big_fb (linear-32bpp-rotate-90)
[338.753624] Starting subtest: linear-32bpp-rotate-90
[338.767354] Subtest linear-32bpp-rotate-90: SKIP (0.014s)
[339.218513] [099/131] (697s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[339.284653] Starting subtest: yf-tiled-to-vebox-y-tiled
[339.286757] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[339.484146] [100/131] (697s left) kms_hdr (static-swap)
[339.837461] Starting subtest: static-swap
[339.839802] Subtest static-swap: SKIP (0.000s)
[340.301789] [101/131] (696s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[340.658892] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[340.660126] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[341.093869] [102/131] (695s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[341.461089] Starting subtest: x-tiled-64bpp-rotate-270
[341.478577] Subtest x-tiled-64bpp-rotate-270: SKIP (0.016s)
[341.946796] [103/131] (694s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[342.308557] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[342.309800] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[342.741645] [104/131] (694s left) gem_exec_reloc (basic-cpu-wc)
[342.801753] Starting subtest: basic-cpu-wc
[342.804694] Subtest basic-cpu-wc: SUCCESS (0.003s)
[343.539229] [105/131] (693s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[343.903678] Starting subtest: y-tiled-64bpp-rotate-180
[343.905113] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[344.339585] [106/131] (692s left) kms_flip (2x-flip-vs-suspend-interruptible)
[344.711525] Starting subtest: 2x-flip-vs-suspend-interruptible
[344.713403] Starting dynamic subtest: AB-VGA1-HDMI-A1
[531.551823] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[539.032335] Closing watchdogs
[539.037327] Initializing watchdogs
[539.037419]   /dev/watchdog0
[539.068573] [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)
[539.083087] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[539.084709] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[539.085536] [FACT before any test] new: kernel.kmod_is_loaded.vgem: true
[539.088791] [107/131] (505s left) kms_psr (pr-primary-mmap-gtt)
[539.487471] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[539.722251] [108/131] (504s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[540.084812] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[540.086092] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[540.543139] [109/131] (503s left) dumb_buffer (map-valid)
[540.606440] Starting subtest: map-valid
[540.607512] Subtest map-valid: SUCCESS (0.000s)
[540.720808] [110/131] (503s left) gem_pxp (regular-baseline-src-copy-readible)
[543.339563] Starting subtest: regular-baseline-src-copy-readible
[543.341176] Subtest regular-baseline-src-copy-readible: SKIP (0.000s)
[543.447037] [111/131] (500s left) syncobj_wait (multi-wait-for-submit-submitted)
[543.502020] Starting subtest: multi-wait-for-submit-submitted
[543.609121] Subtest multi-wait-for-submit-submitted: SUCCESS (0.103s)
[543.719277] [112/131] (500s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[544.090800] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[544.324563] [113/131] (500s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[544.385920] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.000s)
[544.451845] [114/131] (500s left) gem_create (create-massive)
[544.506321] Starting subtest: create-massive
[544.507194] Subtest create-massive: SUCCESS (0.000s)
[544.723719] [115/131] (499s left) syncobj_timeline (invalid-signal-illegal-point)
[544.778773] Starting subtest: invalid-signal-illegal-point
[544.779596] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[544.876092] [116/131] (499s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[544.930684] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SKIP (0.000s)
[544.986587] [117/131] (499s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[545.364696] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[545.365906] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[545.811447] [118/131] (498s left) kms_addfb_basic (bad-pitch-32)
[545.868451] Starting subtest: bad-pitch-32
[545.869324] Subtest bad-pitch-32: SUCCESS (0.000s)
[546.659478] [119/131] (498s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[546.719990] Starting subtest: invalid-single-wait-all-unsubmitted
[546.720753] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[546.839502] [120/131] (498s left) kms_joiner (invalid-modeset-big-joiner)
[547.203725] Starting subtest: invalid-modeset-big-joiner
[547.205101] Subtest invalid-modeset-big-joiner: SKIP (0.000s)
[547.656540] [121/131] (497s left) i915_drm_fdinfo (virtual-busy-idle-all)
[547.716264] Subtest virtual-busy-idle-all: SKIP (0.000s)
[547.796420] [122/131] (497s left) gem_exec_async (concurrent-writes)
[547.861182] Starting subtest: concurrent-writes
[547.862023] Starting dynamic subtest: rcs0
[547.863678] Dynamic subtest rcs0: SUCCESS (0.002s)
[547.879732] Starting dynamic subtest: bcs0
[547.880521] Dynamic subtest bcs0: SUCCESS (0.001s)
[547.896635] Starting dynamic subtest: vcs0
[547.897379] Dynamic subtest vcs0: SUCCESS (0.002s)
[547.898085] Subtest concurrent-writes: SUCCESS (0.008s)
[548.095691] [123/131] (496s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[548.152630] Starting subtest: basic-cpu-gtt-noreloc
[548.155325] Subtest basic-cpu-gtt-noreloc: SUCCESS (0.002s)
[548.904215] [124/131] (496s left) kms_flip (absolute-wf_vblank-interruptible)
[549.272710] Starting subtest: absolute-wf_vblank-interruptible
[549.274787] Starting dynamic subtest: A-VGA1
[557.085916] Dynamic subtest A-VGA1: SUCCESS (7.750s)
[557.101515] Starting dynamic subtest: B-VGA1
[564.827317] Dynamic subtest B-VGA1: SUCCESS (7.715s)
[564.845430] Starting dynamic subtest: A-HDMI-A1
[572.711673] Dynamic subtest A-HDMI-A1: SUCCESS (7.873s)
[572.730055] Starting dynamic subtest: B-HDMI-A1
[580.633421] Dynamic subtest B-HDMI-A1: SUCCESS (7.915s)
[580.634543] Subtest absolute-wf_vblank-interruptible: SUCCESS (31.264s)
[581.258241] [125/131] (463s left) perf (gen12-group-exclusive-stream-sample-oa)
[581.429604] Subtest gen12-group-exclusive-stream-sample-oa: SKIP (0.000s)
[581.511122] [126/131] (463s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[581.564398] Starting subtest: cpuset-basic-small-copy-XY
[582.555041] Subtest cpuset-basic-small-copy-XY: SUCCESS (0.991s)
[582.675554] [127/131] (462s left) kms_chamelium_edid (dp-edid-read)
[583.234362] Subtest dp-edid-read: SKIP (0.000s)
[583.582491] [128/131] (461s left) gem_userptr_blits (unsync-unmap-cycles)
[583.643172] Subtest unsync-unmap-cycles: SKIP (0.000s)
[583.793191] [129/131] (461s left) gem_ctx_persistence (heartbeat-hostile)
[583.852856] Subtest heartbeat-hostile: SKIP (0.000s)
[583.913352] [130/131] (461s left) kms_content_protection (atomic-dpms)
[584.303730] Starting subtest: atomic-dpms
[584.518028] Subtest atomic-dpms: SKIP (0.213s)
[585.153478] [131/131] (460s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[585.216321] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[585.286192] Closing watchdogs
results: parsing output: 0/ for test: kms_cursor_legacy
results: parsing output: 1/ for test: kms_chamelium_audio
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_busy
results: parsing output: 4/ for test: kms_vblank
results: parsing output: 5/ for test: gem_readwrite
results: parsing output: 6/ for test: kms_cursor_crc
results: parsing output: 7/ for test: i915_pm_rps
results: parsing output: 8/ for test: kms_color
results: parsing output: 9/ for test: kms_async_flips
results: parsing output: 10/ for test: gen9_exec_parse
results: parsing output: 11/ for test: kms_psr2_sf
results: parsing output: 12/ for test: perf
results: parsing output: 13/ for test: kms_pm_backlight
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: gem_exec_schedule
results: parsing output: 16/ for test: kms_pm_rpm
results: parsing output: 17/ for test: core_setmaster
results: parsing output: 18/ for test: gem_busy
results: parsing output: 19/ for test: gem_exec_schedule
results: parsing output: 20/ for test: syncobj_wait
results: parsing output: 21/ for test: kms_plane_scaling
results: parsing output: 22/ for test: kms_cursor_crc
results: parsing output: 23/ for test: kms_cursor_legacy
results: parsing output: 24/ for test: kms_psr
results: parsing output: 25/ for test: kms_addfb_basic
results: parsing output: 26/ for test: kms_psr
results: parsing output: 27/ for test: gem_lmem_swapping
results: parsing output: 28/ for test: gem_softpin
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: syncobj_timeline
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_exec_gttfill
results: parsing output: 33/ for test: gem_exec_params
results: parsing output: 34/ for test: gem_exec_params
results: parsing output: 35/ for test: api_intel_allocator
results: parsing output: 36/ for test: gem_exec_whisper
results: parsing output: 37/ for test: syncobj_timeline
results: parsing output: 38/ for test: kms_ccs
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_pm_rpm
results: parsing output: 42/ for test: kms_vrr
results: parsing output: 43/ for test: gem_ppgtt
results: parsing output: 44/ for test: gem_exec_flush
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_chamelium_hpd
results: parsing output: 47/ for test: kms_addfb_basic
results: parsing output: 48/ for test: kms_big_fb
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: gem_exec_store
results: parsing output: 51/ for test: gem_exec_reloc
results: parsing output: 52/ for test: syncobj_wait
results: parsing output: 53/ for test: gem_eio
results: parsing output: 54/ for test: perf_pmu
results: parsing output: 55/ for test: kms_flip_scaled_crc
results: parsing output: 56/ for test: kms_psr
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_legacy_colorkey
results: parsing output: 59/ for test: prime_mmap_coherency
results: parsing output: 60/ for test: kms_addfb_basic
results: parsing output: 61/ for test: sysfs_heartbeat_interval
results: parsing output: 62/ for test: kms_cursor_edge_walk
results: parsing output: 63/ for test: gem_wait
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: gem_mmap
results: parsing output: 66/ for test: kms_atomic
results: parsing output: 67/ for test: kms_flip
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: sw_sync
results: parsing output: 70/ for test: kms_plane_lowres
results: parsing output: 71/ for test: sw_sync
results: parsing output: 72/ for test: gem_wait
results: parsing output: 73/ for test: gem_mmap_gtt
results: parsing output: 74/ for test: gem_caching
results: parsing output: 75/ for test: gem_mmap_wc
results: parsing output: 76/ for test: gem_userptr_blits
results: parsing output: 77/ for test: syncobj_timeline
results: parsing output: 78/ for test: kms_ccs
results: parsing output: 79/ for test: kms_psr2_su
results: parsing output: 80/ for test: i915_pm_rpm
results: parsing output: 81/ for test: gem_exec_nop
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: gem_eio
results: parsing output: 84/ for test: gem_exec_endless
results: parsing output: 85/ for test: api_intel_bb
results: parsing output: 86/ for test: gem_flink_basic
results: parsing output: 87/ for test: gem_ctx_persistence
results: parsing output: 88/ for test: kms_dirtyfb
results: parsing output: 89/ for test: kms_cursor_legacy
results: parsing output: 90/ for test: kms_psr_stress_test
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: syncobj_timeline
results: parsing output: 93/ for test: prime_busy
results: parsing output: 94/ for test: gem_sync
results: parsing output: 95/ for test: gem_exec_balancer
results: parsing output: 96/ for test: kms_big_fb
results: parsing output: 97/ for test: kms_big_fb
results: parsing output: 98/ for test: gem_render_copy
results: parsing output: 99/ for test: kms_hdr
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_exec_reloc
results: parsing output: 104/ for test: kms_big_fb
results: parsing output: 105/ for test: kms_flip
results: parsing output: 106/ for test: kms_psr
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: dumb_buffer
results: parsing output: 109/ for test: gem_pxp
results: parsing output: 110/ for test: syncobj_wait
results: parsing output: 111/ for test: kms_psr2_sf
results: parsing output: 112/ for test: kms_flip_scaled_crc
results: parsing output: 113/ for test: gem_create
results: parsing output: 114/ for test: syncobj_timeline
results: parsing output: 115/ for test: kms_ccs
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_addfb_basic
results: parsing output: 118/ for test: syncobj_wait
results: parsing output: 119/ for test: kms_joiner
results: parsing output: 120/ for test: i915_drm_fdinfo
results: parsing output: 121/ for test: gem_exec_async
results: parsing output: 122/ for test: gem_exec_reloc
results: parsing output: 123/ for test: kms_flip
results: parsing output: 124/ for test: perf
results: parsing output: 125/ for test: gem_mmap_gtt
results: parsing output: 126/ for test: kms_chamelium_edid
results: parsing output: 127/ for test: gem_userptr_blits
results: parsing output: 128/ for test: gem_ctx_persistence
results: parsing output: 129/ for test: kms_content_protection
results: parsing output: 130/ for test: kms_ccs
Done.