[67.337548] Initializing watchdogs
[67.337694]   /dev/watchdog0
[67.362072] [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)
[67.369634] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[67.373227] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[67.377612] [001/131] (960s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[67.753879] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[71.069646] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (3.315s)
[71.621209] [002/131] (956s left) kms_chamelium_audio (hdmi-audio)
[72.071969] Subtest hdmi-audio: SKIP (0.000s)
[72.405570] [003/131] (955s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[72.770830] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[72.773919] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[73.195614] [004/131] (954s left) kms_busy (extended-modeset-hang-oldfb)
[73.571046] Starting subtest: extended-modeset-hang-oldfb
[73.572800] Starting dynamic subtest: pipe-A
[80.136693] Dynamic subtest pipe-A: SUCCESS (6.563s)
[80.146455] Starting dynamic subtest: pipe-B
[86.150122] Dynamic subtest pipe-B: SUCCESS (6.011s)
[86.151855] Subtest extended-modeset-hang-oldfb: SUCCESS (12.577s)
[86.705648] [005/131] (941s left) kms_vblank (ts-continuation-idle-hang)
[87.067873] Starting subtest: ts-continuation-idle-hang
[87.069785] Starting dynamic subtest: pipe-A-HDMI-A-1
[92.925663] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (5.856s)
[92.935568] Starting dynamic subtest: pipe-B-HDMI-A-1
[98.947036] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (6.016s)
[98.948624] Subtest ts-continuation-idle-hang: SUCCESS (11.875s)
[99.484523] [006/131] (928s left) gem_readwrite (new-obj)
[99.547371] Starting subtest: new-obj
[99.550516] Subtest new-obj: SUCCESS (0.000s)
[99.649927] [007/131] (928s left) kms_cursor_crc (cursor-onscreen-512x512)
[100.017798] Starting subtest: cursor-onscreen-512x512
[100.021139] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[100.455716] [008/131] (927s left) i915_pm_rps (reset)
[100.519335] Starting subtest: reset
[104.052187] Subtest reset: SUCCESS (3.532s)
[104.157535] [009/131] (924s left) kms_color (ctm-blue-to-red)
[104.508494] Starting subtest: ctm-blue-to-red
[104.510542] Starting dynamic subtest: pipe-A-HDMI-A-1
[104.980697] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.473s)
[104.990562] Starting dynamic subtest: pipe-B-HDMI-A-1
[105.476671] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.496s)
[105.478229] Subtest ctm-blue-to-red: SUCCESS (0.970s)
[106.023142] [010/131] (922s left) kms_async_flips (test-time-stamp)
[106.383350] Starting subtest: test-time-stamp
[106.526885] Starting dynamic subtest: pipe-A-HDMI-A-1
[106.700719] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.171s)
[106.860823] Starting dynamic subtest: pipe-B-HDMI-A-1
[106.986524] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.133s)
[106.988474] Subtest test-time-stamp: SUCCESS (0.603s)
[107.657641] [011/131] (920s left) gen9_exec_parse (shadow-peek)
[107.723143] Subtest shadow-peek: SKIP (0.000s)
[107.783323] [012/131] (920s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[108.149104] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[108.383601] [013/131] (920s left) perf (non-sampling-read-error)
[108.491692] Subtest non-sampling-read-error: SKIP (0.000s)
[108.553096] [014/131] (919s left) kms_pm_backlight (bad-brightness)
[108.905122] Subtest bad-brightness: SKIP (0.000s)
[109.128054] [015/131] (919s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[109.494041] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[109.498726] Subtest psr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[109.934092] [016/131] (918s left) gem_exec_schedule (manyslice)
[110.008246] Subtest manyslice: SKIP (0.000s)
[110.198497] [017/131] (918s left) kms_pm_rpm (basic-pci-d3-state)
[121.800833] Subtest basic-pci-d3-state: SKIP (0.000s)
[122.019624] [018/131] (906s left) core_setmaster (master-drop-set-root)
[122.124437] Starting subtest: master-drop-set-root
[122.129835] Subtest master-drop-set-root: SUCCESS (0.004s)
[122.193681] [019/131] (906s left) gem_busy (extended)
[122.380933] Starting subtest: extended
[122.382759] Starting dynamic subtest: rcs0
[122.414305] Dynamic subtest rcs0: SUCCESS (0.035s)
[122.429440] Starting dynamic subtest: bcs0
[122.441358] Dynamic subtest bcs0: SUCCESS (0.026s)
[122.443075] Subtest extended: SUCCESS (0.063s)
[122.672261] [020/131] (906s left) gem_exec_schedule (smoketest)
[122.742741] Subtest smoketest: SKIP (0.000s)
[122.940751] [021/131] (905s left) syncobj_wait (single-wait-all-for-submit-signaled)
[122.999863] Starting subtest: single-wait-all-for-submit-signaled
[123.001592] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[123.088109] [022/131] (905s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[123.453495] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[123.455075] Starting dynamic subtest: pipe-A
[123.459768] Dynamic subtest pipe-A: SKIP (0.001s)
[123.472677] Starting dynamic subtest: pipe-B
[123.478818] Dynamic subtest pipe-B: SKIP (0.001s)
[123.482920] Subtest plane-scaler-unity-scaling-with-pixel-format: SKIP (0.003s)
[123.890720] [023/131] (905s left) kms_cursor_crc (cursor-sliding-256x85)
[124.260852] Starting subtest: cursor-sliding-256x85
[124.318517] Subtest cursor-sliding-256x85: SKIP (0.053s)
[124.750443] [024/131] (904s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[125.119724] Starting subtest: cursorA-vs-flipB-toggle
[125.125559] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s)
[125.569730] [025/131] (903s left) kms_psr (fbc-psr2-sprite-render)
[125.932143] Subtest fbc-psr2-sprite-render: SKIP (0.000s)
[126.161972] [026/131] (902s left) kms_addfb_basic (bad-pitch-256)
[126.220881] Starting subtest: bad-pitch-256
[126.222630] Subtest bad-pitch-256: SUCCESS (0.000s)
[126.966142] [027/131] (902s left) kms_psr (pr-dpms)
[127.331170] Subtest pr-dpms: SKIP (0.000s)
[127.562537] [028/131] (901s left) gem_lmem_swapping (heavy-random)
[127.627652] Subtest heavy-random: SKIP (0.000s)
[127.676800] [029/131] (901s left) gem_softpin (allocator-nopin-reserve)
[127.737477] Subtest allocator-nopin-reserve: SKIP (0.000s)
[127.829964] [030/131] (901s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[128.199130] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[128.202247] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[128.651153] [031/131] (900s left) syncobj_timeline (multi-wait-signaled)
[128.713921] Starting subtest: multi-wait-signaled
[128.715754] Subtest multi-wait-signaled: SUCCESS (0.001s)
[128.810289] [032/131] (900s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[129.174181] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[129.177555] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[129.612963] [033/131] (899s left) gem_exec_gttfill (all-engines)
[129.678093] Starting subtest: all-engines
[153.690534] Subtest all-engines: SUCCESS (24.012s)
[153.903521] [034/131] (875s left) gem_exec_params (no-bsd)
[154.020756] Starting subtest: no-bsd
[154.022284] Subtest no-bsd: SUCCESS (0.000s)
[154.121675] [035/131] (875s left) gem_exec_params (cliprects_ptr-dirt)
[154.177811] Starting subtest: cliprects_ptr-dirt
[154.179443] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[154.268088] [036/131] (875s left) api_intel_allocator (alloc-simple)
[154.322752] Starting subtest: alloc-simple
[154.326949] Subtest alloc-simple: SUCCESS (0.005s)
[154.442291] [037/131] (875s left) gem_exec_whisper (basic-fds-priority)
[154.509273] Starting subtest: basic-fds-priority
[154.512739] Subtest basic-fds-priority: SKIP (0.001s)
[154.719281] [038/131] (874s left) syncobj_timeline (single-wait-all-signaled)
[154.789472] Starting subtest: single-wait-all-signaled
[154.791165] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[154.876352] [039/131] (874s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[154.941821] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SKIP (0.000s)
[155.003465] [040/131] (874s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[155.389221] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[155.392394] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[155.819941] [041/131] (874s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[156.171085] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[156.175697] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[156.608868] [042/131] (873s left) kms_pm_rpm (pm-tiling)
[168.262294] Subtest pm-tiling: SKIP (0.000s)
[168.494998] [043/131] (861s left) kms_vrr (flip-basic)
[168.856740] Starting subtest: flip-basic
[168.862538] Subtest flip-basic: SKIP (0.000s)
[169.301801] [044/131] (860s left) gem_ppgtt (blt-vs-render-ctxn)
[169.364966] Starting subtest: blt-vs-render-ctxN
[201.906645] Subtest blt-vs-render-ctxN: SUCCESS (32.540s)
[202.023899] [045/131] (828s left) gem_exec_flush (basic-uc-set-default)
[202.158991] Starting subtest: basic-uc-set-default
[207.603095] Subtest basic-uc-set-default: SUCCESS (5.444s)
[207.799361] [046/131] (822s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[208.173941] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[208.177057] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[208.598301] [047/131] (821s left) kms_chamelium_hpd (common-hpd-after-suspend)
[209.037685] Subtest common-hpd-after-suspend: SKIP (0.000s)
[209.376280] [048/131] (820s left) kms_addfb_basic (unused-handle)
[209.437927] Starting subtest: unused-handle
[209.439644] Subtest unused-handle: SUCCESS (0.000s)
[210.184512] [049/131] (820s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[210.555889] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[210.559060] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[210.995451] [050/131] (819s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[211.363162] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[211.366173] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[211.794980] [051/131] (818s left) gem_exec_store (pages)
[211.864929] Starting subtest: pages
[211.866918] Starting dynamic subtest: rcs0
[211.927928] Dynamic subtest rcs0: SUCCESS (0.062s)
[211.944241] Starting dynamic subtest: bcs0
[211.965842] Dynamic subtest bcs0: SUCCESS (0.036s)
[211.967863] Subtest pages: SUCCESS (0.101s)
[212.174706] [052/131] (818s left) gem_exec_reloc (basic-gtt-active)
[212.237631] Starting subtest: basic-gtt-active
[212.348655] Subtest basic-gtt-active: SUCCESS (0.110s)
[213.092050] [053/131] (817s left) syncobj_wait (wait-all-snapshot)
[213.159201] Starting subtest: wait-all-snapshot
[213.243072] Subtest wait-all-snapshot: SUCCESS (0.082s)
[213.338482] [054/131] (817s left) gem_eio (wait-1us)
[213.407552] Starting subtest: wait-1us
[213.440752] Subtest wait-1us: SUCCESS (0.033s)
[214.190490] [055/131] (816s left) perf_pmu (semaphore-wait-idle)
[214.249775] Starting subtest: semaphore-wait-idle
[214.251330] Starting dynamic subtest: rcs0
[214.254502] Dynamic subtest rcs0: SKIP (0.001s)
[214.272371] Starting dynamic subtest: bcs0
[214.276341] Dynamic subtest bcs0: SKIP (0.000s)
[214.293358] Starting dynamic subtest: vcs0
[214.297316] Dynamic subtest vcs0: SKIP (0.000s)
[214.301225] Subtest semaphore-wait-idle: SKIP (0.005s)
[214.375831] [056/131] (816s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[214.434516] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SKIP (0.000s)
[214.492553] [057/131] (816s left) kms_psr (psr2-sprite-mmap-cpu)
[214.874385] Subtest psr2-sprite-mmap-cpu: SKIP (0.000s)
[215.092732] [058/131] (815s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[215.457939] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[215.461401] Subtest psr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[215.887407] [059/131] (814s left) kms_legacy_colorkey (basic)
[216.243540] Starting subtest: basic
[216.245263] Starting dynamic subtest: pipe-A
[216.246998] Dynamic subtest pipe-A: SUCCESS (0.000s)
[216.261976] Starting dynamic subtest: pipe-B
[216.264270] Dynamic subtest pipe-B: SUCCESS (0.000s)
[216.266160] Subtest basic: SUCCESS (0.003s)
[216.682409] [060/131] (814s left) prime_mmap_coherency (ioctl-errors)
[216.747249] Starting subtest: ioctl-errors
[225.714498] Subtest ioctl-errors: SUCCESS (8.966s)
[225.852970] [061/131] (804s left) kms_addfb_basic (legacy-format)
[225.985099] Starting subtest: legacy-format
[226.059624] Subtest legacy-format: SUCCESS (0.073s)
[226.790755] [062/131] (804s left) sysfs_heartbeat_interval (invalid)
[226.858071] Starting subtest: invalid
[226.859786] Starting dynamic subtest: vcs0
[226.861476] Dynamic subtest vcs0: SUCCESS (0.000s)
[226.873827] Starting dynamic subtest: bcs0
[226.875539] Dynamic subtest bcs0: SUCCESS (0.000s)
[226.886606] Starting dynamic subtest: rcs0
[226.888205] Dynamic subtest rcs0: SUCCESS (0.001s)
[226.889818] Subtest invalid: SUCCESS (0.006s)
[226.956586] [063/131] (803s left) kms_cursor_edge_walk (64x64-left-edge)
[227.316687] Starting subtest: 64x64-left-edge
[227.318298] Starting dynamic subtest: pipe-A-HDMI-A-1
[230.792924] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.477s)
[230.806479] Starting dynamic subtest: pipe-B-HDMI-A-1
[234.139803] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.343s)
[234.141395] Subtest 64x64-left-edge: SUCCESS (6.824s)
[234.684268] [064/131] (796s left) gem_wait (wait)
[234.758954] Starting subtest: wait
[234.760942] Starting dynamic subtest: all-engines
[235.780431] Dynamic subtest all-engines: SUCCESS (1.021s)
[235.794794] Starting dynamic subtest: rcs0
[236.802397] Dynamic subtest rcs0: SUCCESS (1.019s)
[236.814364] Starting dynamic subtest: bcs0
[237.827550] Dynamic subtest bcs0: SUCCESS (1.023s)
[237.841607] Starting dynamic subtest: vcs0
[238.853322] Dynamic subtest vcs0: SUCCESS (1.023s)
[238.855372] Subtest wait: SUCCESS (4.095s)
[239.079483] [065/131] (791s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[239.444037] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[239.447096] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[239.873870] [066/131] (791s left) gem_mmap (basic)
[239.935464] Starting subtest: basic
[239.945073] Subtest basic: SUCCESS (0.000s)
[240.041194] [067/131] (791s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[240.399018] Starting subtest: plane-primary-overlay-mutable-zpos
[240.670505] Subtest plane-primary-overlay-mutable-zpos: SKIP (0.271s)
[241.303813] [068/131] (789s left) kms_flip (2x-blocking-wf_vblank)
[241.661145] Starting subtest: 2x-blocking-wf_vblank
[241.662864] Starting dynamic subtest: AB-VGA1-HDMI-A1
[272.384729] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (30.722s)
[272.387283] Subtest 2x-blocking-wf_vblank: SUCCESS (30.726s)
[273.011725] [069/131] (758s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[273.375266] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[273.378710] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[273.805214] [070/131] (757s left) sw_sync (sync_expired_merge)
[273.869519] Starting subtest: sync_expired_merge
[274.944631] Subtest sync_expired_merge: SUCCESS (1.074s)
[275.032472] [071/131] (756s left) kms_plane_lowres (tiling-y)
[275.390409] Starting subtest: tiling-y
[275.393549] Subtest tiling-y: SKIP (0.000s)
[275.837448] [072/131] (755s left) sw_sync (sync_merge_invalid)
[275.901693] Starting subtest: sync_merge_invalid
[275.905291] Subtest sync_merge_invalid: SUCCESS (0.004s)
[275.969448] [073/131] (755s left) gem_wait (invalid-flags)
[276.031395] Starting subtest: invalid-flags
[276.033019] Subtest invalid-flags: SUCCESS (0.000s)
[276.271684] [074/131] (755s left) gem_mmap_gtt (basic-copy)
[276.331719] Starting subtest: basic-copy
[276.545491] Subtest basic-copy: SUCCESS (0.213s)
[276.664967] [075/131] (754s left) gem_caching (writes)
[276.728063] Starting subtest: writes
[279.683017] Subtest writes: SUCCESS (2.955s)
[279.830973] [076/131] (751s left) gem_mmap_wc (bad-offset)
[279.892123] Starting subtest: bad-offset
[279.893694] Subtest bad-offset: SUCCESS (0.001s)
[279.988432] [077/131] (751s left) gem_userptr_blits (huge-split)
[280.071091] Starting subtest: huge-split
[280.075346] Subtest huge-split: SUCCESS (0.004s)
[280.182363] [078/131] (751s left) syncobj_timeline (32bits-limit)
[280.251931] Starting subtest: 32bits-limit
[280.253801] Subtest 32bits-limit: SUCCESS (0.001s)
[280.345548] [079/131] (751s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc)
[280.411476] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s)
[280.474891] [080/131] (751s left) kms_psr2_su (frontbuffer-xrgb8888)
[280.532807] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[280.589619] [081/131] (751s left) i915_pm_rpm (gem-evict-pwrite)
[292.187989] Subtest gem-evict-pwrite: SKIP (0.000s)
[292.416974] [082/131] (739s left) gem_exec_nop (basic-parallel)
[292.483028] Starting subtest: basic-parallel
[295.281863] Subtest basic-parallel: SUCCESS (2.796s)
[295.499973] [083/131] (736s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[295.862555] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[295.867685] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[296.290662] [084/131] (735s left) gem_eio (in-flight-1us)
[296.354528] Starting subtest: in-flight-1us
[297.809076] Subtest in-flight-1us: SUCCESS (1.453s)
[298.557673] [FACT gem_eio (in-flight-1us)] new: kernel.kmod_is_loaded.vgem: true
[298.562695] [085/131] (733s left) gem_exec_endless (dispatch)
[298.627771] Subtest dispatch: SKIP (0.000s)
[298.731022] [086/131] (733s left) api_intel_bb (misplaced-blitter)
[298.792025] Starting subtest: misplaced-blitter
[298.793722] Subtest misplaced-blitter: SUCCESS (0.003s)
[298.938822] [087/131] (733s left) gem_flink_basic (basic)
[298.997769] Starting subtest: basic
[299.000088] Subtest basic: SUCCESS (0.000s)
[299.105785] [088/131] (733s left) gem_ctx_persistence (smoketest)
[299.170444] Subtest smoketest: SKIP (0.000s)
[299.238870] [089/131] (733s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[299.595254] Starting subtest: psr-dirtyfb-ioctl
[299.601402] Subtest psr-dirtyfb-ioctl: SKIP (0.000s)
[300.043257] [090/131] (732s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[300.395653] Starting subtest: cursorA-vs-flipA-varying-size
[311.313711] Subtest cursorA-vs-flipA-varying-size: SUCCESS (10.919s)
[311.868697] [091/131] (720s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[311.933998] Subtest invalidate-primary-flip-overlay: SKIP (0.000s)
[312.011553] [092/131] (720s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[312.373339] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[312.376636] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[312.817309] [093/131] (719s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted)
[312.875771] Starting subtest: invalid-multi-wait-all-unsubmitted
[312.877546] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[312.981773] [094/131] (719s left) prime_busy (hang-wait)
[313.040941] Starting subtest: hang-wait
[313.042851] Starting dynamic subtest: rcs0
[318.831095] Dynamic subtest rcs0: SUCCESS (5.789s)
[318.843426] Starting dynamic subtest: bcs0
[324.848342] Dynamic subtest bcs0: SUCCESS (6.012s)
[324.860953] Starting dynamic subtest: vcs0
[330.862653] Dynamic subtest vcs0: SUCCESS (6.014s)
[330.864303] Subtest hang-wait: SUCCESS (17.822s)
[330.998058] [095/131] (701s left) gem_sync (basic-each)
[331.072067] Starting subtest: basic-each
[333.176298] Subtest basic-each: SUCCESS (2.104s)
[333.393253] [096/131] (699s left) gem_exec_balancer (parallel-keep-in-fence)
[333.455381] Subtest parallel-keep-in-fence: SKIP (0.000s)
[333.555413] [097/131] (699s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[333.927070] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[333.930478] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[334.371682] [098/131] (698s left) kms_big_fb (linear-32bpp-rotate-90)
[334.733835] Starting subtest: linear-32bpp-rotate-90
[334.752184] Subtest linear-32bpp-rotate-90: SKIP (0.017s)
[335.203158] [099/131] (697s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[335.272661] Starting subtest: yf-tiled-to-vebox-y-tiled
[335.276838] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[335.493400] [100/131] (697s left) kms_hdr (static-swap)
[335.850042] Starting subtest: static-swap
[335.855688] Subtest static-swap: SKIP (0.000s)
[336.283711] [101/131] (696s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[336.648770] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[336.652085] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[337.085414] [102/131] (695s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[337.455780] Starting subtest: x-tiled-64bpp-rotate-270
[337.465219] Subtest x-tiled-64bpp-rotate-270: SKIP (0.006s)
[337.916322] [103/131] (695s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[338.283553] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[338.286746] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[338.734946] [104/131] (694s left) gem_exec_reloc (basic-cpu-wc)
[338.802772] Starting subtest: basic-cpu-wc
[338.807956] Subtest basic-cpu-wc: SUCCESS (0.005s)
[339.549140] [105/131] (693s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[339.920414] Starting subtest: y-tiled-64bpp-rotate-180
[339.923590] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[340.367399] [106/131] (692s left) kms_flip (2x-flip-vs-suspend-interruptible)
[340.731801] Starting subtest: 2x-flip-vs-suspend-interruptible
[340.736233] Starting dynamic subtest: AB-VGA1-HDMI-A1
[544.802015] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[552.654870] Closing watchdogs
[552.660689] Initializing watchdogs
[552.660763]   /dev/watchdog0
[552.692078] [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)
[552.705742] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[552.707445] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[552.708245] [FACT before any test] new: kernel.kmod_is_loaded.vgem: true
[552.712659] [107/131] (487s left) kms_psr (pr-primary-mmap-gtt)
[553.104511] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[553.369377] [108/131] (487s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[553.754665] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[553.757955] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[554.216034] [109/131] (486s left) dumb_buffer (map-valid)
[554.283146] Starting subtest: map-valid
[554.285014] Subtest map-valid: SUCCESS (0.000s)
[554.405945] [110/131] (486s left) gem_pxp (regular-baseline-src-copy-readible)
[557.028985] Starting subtest: regular-baseline-src-copy-readible
[557.032735] Subtest regular-baseline-src-copy-readible: SKIP (0.000s)
[557.122536] [111/131] (483s left) syncobj_wait (multi-wait-for-submit-submitted)
[557.183074] Starting subtest: multi-wait-for-submit-submitted
[557.287331] Subtest multi-wait-for-submit-submitted: SUCCESS (0.099s)
[557.403164] [112/131] (483s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[557.771289] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[558.008138] [113/131] (482s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[558.069192] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.000s)
[558.148793] [114/131] (482s left) gem_create (create-massive)
[558.207846] Starting subtest: create-massive
[558.209561] Subtest create-massive: SUCCESS (0.000s)
[558.435365] [115/131] (482s left) syncobj_timeline (invalid-signal-illegal-point)
[558.496984] Starting subtest: invalid-signal-illegal-point
[558.498825] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[558.594430] [116/131] (482s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[558.651644] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SKIP (0.000s)
[558.728153] [117/131] (482s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[559.097538] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[559.100885] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[559.545957] [118/131] (481s left) kms_addfb_basic (bad-pitch-32)
[559.611554] Starting subtest: bad-pitch-32
[559.613128] Subtest bad-pitch-32: SUCCESS (0.000s)
[560.364410] [119/131] (480s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[560.428621] Starting subtest: invalid-single-wait-all-unsubmitted
[560.430916] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[560.538380] [120/131] (480s left) kms_joiner (invalid-modeset-big-joiner)
[560.910725] Starting subtest: invalid-modeset-big-joiner
[560.914013] Subtest invalid-modeset-big-joiner: SKIP (0.000s)
[561.376462] [121/131] (479s left) i915_drm_fdinfo (virtual-busy-idle-all)
[561.448569] Subtest virtual-busy-idle-all: SKIP (0.000s)
[561.527983] [122/131] (479s left) gem_exec_async (concurrent-writes)
[561.592801] Starting subtest: concurrent-writes
[561.594508] Starting dynamic subtest: rcs0
[561.596106] Dynamic subtest rcs0: SUCCESS (0.002s)
[561.612963] Starting dynamic subtest: bcs0
[561.614843] Dynamic subtest bcs0: SUCCESS (0.001s)
[561.631883] Starting dynamic subtest: vcs0
[561.633747] Dynamic subtest vcs0: SUCCESS (0.002s)
[561.635522] Subtest concurrent-writes: SUCCESS (0.008s)
[561.836052] [123/131] (479s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[561.897712] Starting subtest: basic-cpu-gtt-noreloc
[561.901633] Subtest basic-cpu-gtt-noreloc: SUCCESS (0.002s)
[562.654424] [124/131] (478s left) kms_flip (absolute-wf_vblank-interruptible)
[563.033824] Starting subtest: absolute-wf_vblank-interruptible
[563.035580] Starting dynamic subtest: A-VGA1
[570.838814] Dynamic subtest A-VGA1: SUCCESS (7.737s)
[570.855918] Starting dynamic subtest: B-VGA1
[578.554328] Dynamic subtest B-VGA1: SUCCESS (7.687s)
[578.571650] Starting dynamic subtest: A-HDMI-A1
[586.433887] Dynamic subtest A-HDMI-A1: SUCCESS (7.871s)
[586.450900] Starting dynamic subtest: B-HDMI-A1
[594.341774] Dynamic subtest B-HDMI-A1: SUCCESS (7.899s)
[594.343573] Subtest absolute-wf_vblank-interruptible: SUCCESS (31.206s)
[594.965004] [125/131] (446s left) perf (gen12-group-exclusive-stream-sample-oa)
[595.118980] Subtest gen12-group-exclusive-stream-sample-oa: SKIP (0.000s)
[595.178352] [126/131] (446s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[595.236195] Starting subtest: cpuset-basic-small-copy-XY
[596.233069] Subtest cpuset-basic-small-copy-XY: SUCCESS (0.998s)
[596.348513] [127/131] (445s left) kms_chamelium_edid (dp-edid-read)
[596.878206] Subtest dp-edid-read: SKIP (0.000s)
[597.218570] [128/131] (444s left) gem_userptr_blits (unsync-unmap-cycles)
[597.286226] Subtest unsync-unmap-cycles: SKIP (0.000s)
[597.429155] [129/131] (444s left) gem_ctx_persistence (heartbeat-hostile)
[597.493282] Subtest heartbeat-hostile: SKIP (0.000s)
[597.558396] [130/131] (444s left) kms_content_protection (atomic-dpms)
[597.950790] Starting subtest: atomic-dpms
[598.178278] Subtest atomic-dpms: SKIP (0.225s)
[598.812605] [131/131] (443s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[598.874766] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[598.932365] 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.