[74.280915] Initializing watchdogs
[74.281101]   /dev/watchdog0
[74.301362] [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)
[74.309025] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[74.313079] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[74.316344] [001/131] (960s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[74.704572] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[78.090121] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (3.385s)
[78.638252] [002/131] (956s left) kms_chamelium_audio (hdmi-audio)
[79.094414] Subtest hdmi-audio: SKIP (0.000s)
[79.440098] [003/131] (955s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-pgflip-blt)
[79.804473] Starting subtest: fbcpsr-2p-primscrn-indfb-pgflip-blt
[79.805868] Subtest fbcpsr-2p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[80.245850] [004/131] (954s left) kms_busy (extended-modeset-hang-oldfb)
[80.623026] Starting subtest: extended-modeset-hang-oldfb
[80.623848] Starting dynamic subtest: pipe-A
[87.205763] Dynamic subtest pipe-A: SUCCESS (6.581s)
[87.216032] Starting dynamic subtest: pipe-B
[93.111304] Dynamic subtest pipe-B: SUCCESS (5.903s)
[93.112344] Subtest extended-modeset-hang-oldfb: SUCCESS (12.489s)
[93.667269] [005/131] (941s left) kms_vblank (ts-continuation-idle-hang)
[94.039126] Starting subtest: ts-continuation-idle-hang
[94.041500] Starting dynamic subtest: pipe-A-HDMI-A-1
[99.958848] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (5.917s)
[99.967796] Starting dynamic subtest: pipe-B-HDMI-A-1
[105.990129] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (6.030s)
[105.990853] Subtest ts-continuation-idle-hang: SUCCESS (11.951s)
[106.531710] [006/131] (928s left) gem_readwrite (new-obj)
[106.591810] Starting subtest: new-obj
[106.593154] Subtest new-obj: SUCCESS (0.000s)
[106.705936] [007/131] (928s left) kms_cursor_crc (cursor-onscreen-512x512)
[107.071608] Starting subtest: cursor-onscreen-512x512
[107.072699] Subtest cursor-onscreen-512x512: SKIP (0.001s)
[107.501810] [008/131] (927s left) i915_pm_rps (reset)
[107.562680] Starting subtest: reset
[111.095579] Subtest reset: SUCCESS (3.533s)
[111.229472] [009/131] (923s left) kms_color (ctm-blue-to-red)
[111.593075] Starting subtest: ctm-blue-to-red
[111.593888] Starting dynamic subtest: pipe-A-HDMI-A-1
[112.062098] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.470s)
[112.073268] Starting dynamic subtest: pipe-B-HDMI-A-1
[112.558207] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.495s)
[112.558998] Subtest ctm-blue-to-red: SUCCESS (0.966s)
[113.101203] [010/131] (922s left) kms_async_flips (test-time-stamp)
[113.460875] Starting subtest: test-time-stamp
[113.606588] Starting dynamic subtest: pipe-A-HDMI-A-1
[113.813310] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.205s)
[113.975428] Starting dynamic subtest: pipe-B-HDMI-A-1
[114.099690] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.132s)
[114.100712] Subtest test-time-stamp: SUCCESS (0.638s)
[114.853800] [011/131] (920s left) gen9_exec_parse (shadow-peek)
[114.915854] Subtest shadow-peek: SKIP (0.000s)
[114.962304] [012/131] (920s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[115.324896] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[115.544918] [013/131] (919s left) perf (non-sampling-read-error)
[115.658972] Subtest non-sampling-read-error: SKIP (0.000s)
[115.707916] [014/131] (919s left) kms_pm_backlight (bad-brightness)
[116.068277] Subtest bad-brightness: SKIP (0.000s)
[116.289849] [015/131] (919s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[116.660595] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[116.662197] Subtest psr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[117.099100] [016/131] (918s left) gem_exec_schedule (manyslice)
[117.167107] Subtest manyslice: SKIP (0.000s)
[117.368493] [017/131] (918s left) kms_pm_rpm (basic-pci-d3-state)
[128.961111] Subtest basic-pci-d3-state: SKIP (0.000s)
[129.193287] [018/131] (906s left) core_setmaster (master-drop-set-root)
[129.289977] Starting subtest: master-drop-set-root
[129.295558] Subtest master-drop-set-root: SUCCESS (0.005s)
[129.353068] [019/131] (906s left) gem_busy (extended)
[129.535416] Starting subtest: extended
[129.536475] Starting dynamic subtest: rcs0
[129.574677] Dynamic subtest rcs0: SUCCESS (0.040s)
[129.590137] Starting dynamic subtest: bcs0
[129.592266] Dynamic subtest bcs0: SUCCESS (0.015s)
[129.593214] Subtest extended: SUCCESS (0.057s)
[129.823669] [020/131] (905s left) gem_exec_schedule (smoketest)
[129.894890] Subtest smoketest: SKIP (0.000s)
[130.089208] [021/131] (905s left) syncobj_wait (single-wait-all-for-submit-signaled)
[130.145255] Starting subtest: single-wait-all-for-submit-signaled
[130.145965] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[130.240337] [022/131] (905s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[130.590937] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[130.591987] Starting dynamic subtest: pipe-A
[130.594313] Dynamic subtest pipe-A: SKIP (0.001s)
[130.606324] Starting dynamic subtest: pipe-B
[130.608618] Dynamic subtest pipe-B: SKIP (0.001s)
[130.610132] Subtest plane-scaler-unity-scaling-with-pixel-format: SKIP (0.004s)
[131.034180] [023/131] (904s left) kms_cursor_crc (cursor-sliding-256x85)
[131.403112] Starting subtest: cursor-sliding-256x85
[131.458923] Subtest cursor-sliding-256x85: SKIP (0.054s)
[131.885509] [024/131] (904s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[132.247666] Starting subtest: cursorA-vs-flipB-toggle
[132.248826] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s)
[132.683273] [025/131] (903s left) kms_psr (fbc-psr2-sprite-render)
[133.043496] Subtest fbc-psr2-sprite-render: SKIP (0.000s)
[133.273511] [026/131] (902s left) kms_addfb_basic (bad-pitch-256)
[133.332188] Starting subtest: bad-pitch-256
[133.332937] Subtest bad-pitch-256: SUCCESS (0.000s)
[134.060554] [027/131] (901s left) kms_psr (pr-dpms)
[134.419031] Subtest pr-dpms: SKIP (0.000s)
[134.638249] [028/131] (901s left) gem_lmem_swapping (heavy-random)
[134.695221] Subtest heavy-random: SKIP (0.000s)
[134.740080] [029/131] (901s left) gem_softpin (allocator-nopin-reserve)
[134.797820] Subtest allocator-nopin-reserve: SKIP (0.000s)
[134.884167] [030/131] (901s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff)
[135.248524] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff
[135.249910] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[135.677426] [031/131] (900s left) syncobj_timeline (multi-wait-signaled)
[135.734187] Starting subtest: multi-wait-signaled
[135.735936] Subtest multi-wait-signaled: SUCCESS (0.001s)
[135.824042] [032/131] (900s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[136.185487] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[136.186930] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[136.624973] [033/131] (899s left) gem_exec_gttfill (all-engines)
[136.694211] Starting subtest: all-engines
[160.754841] Subtest all-engines: SUCCESS (24.062s)
[160.939662] [034/131] (875s left) gem_exec_params (no-bsd)
[161.091628] Starting subtest: no-bsd
[161.092439] Subtest no-bsd: SUCCESS (0.000s)
[161.182952] [035/131] (875s left) gem_exec_params (cliprects_ptr-dirt)
[161.236469] Starting subtest: cliprects_ptr-dirt
[161.237279] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[161.332747] [036/131] (875s left) api_intel_allocator (alloc-simple)
[161.385695] Starting subtest: alloc-simple
[161.389595] Subtest alloc-simple: SUCCESS (0.005s)
[161.527563] [037/131] (874s left) gem_exec_whisper (basic-fds-priority)
[161.595981] Starting subtest: basic-fds-priority
[161.599016] Subtest basic-fds-priority: SKIP (0.001s)
[161.797180] [038/131] (874s left) syncobj_timeline (single-wait-all-signaled)
[161.869710] Starting subtest: single-wait-all-signaled
[161.870452] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[161.956403] [039/131] (874s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs)
[162.016796] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SKIP (0.000s)
[162.071922] [040/131] (874s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[162.449436] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[162.450962] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[162.889637] [041/131] (873s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[163.257650] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[163.258896] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[163.685230] [042/131] (873s left) kms_pm_rpm (pm-tiling)
[175.343126] Subtest pm-tiling: SKIP (0.000s)
[175.591186] [043/131] (861s left) kms_vrr (flip-basic)
[175.955371] Starting subtest: flip-basic
[175.957342] Subtest flip-basic: SKIP (0.000s)
[176.391846] [044/131] (860s left) gem_ppgtt (blt-vs-render-ctxn)
[176.453347] Starting subtest: blt-vs-render-ctxN
[209.016280] Subtest blt-vs-render-ctxN: SUCCESS (32.563s)
[209.147441] [045/131] (827s left) gem_exec_flush (basic-uc-set-default)
[209.320516] Starting subtest: basic-uc-set-default
[214.765541] Subtest basic-uc-set-default: SUCCESS (5.445s)
[214.962522] [046/131] (821s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[215.327522] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[215.328747] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[215.760058] [047/131] (821s left) kms_chamelium_hpd (common-hpd-after-suspend)
[216.182606] Subtest common-hpd-after-suspend: SKIP (0.000s)
[216.497844] [048/131] (820s left) kms_addfb_basic (unused-handle)
[216.559296] Starting subtest: unused-handle
[216.560147] Subtest unused-handle: SUCCESS (0.000s)
[217.306432] [049/131] (819s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[217.675848] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[217.677111] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[218.116164] [050/131] (818s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite)
[218.483373] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite
[218.484553] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[218.912404] [051/131] (818s left) gem_exec_store (pages)
[218.975966] Starting subtest: pages
[218.976800] Starting dynamic subtest: rcs0
[219.042801] Dynamic subtest rcs0: SUCCESS (0.066s)
[219.055823] Starting dynamic subtest: bcs0
[219.087076] Dynamic subtest bcs0: SUCCESS (0.042s)
[219.088275] Subtest pages: SUCCESS (0.112s)
[219.284836] [052/131] (817s left) gem_exec_reloc (basic-gtt-active)
[219.346413] Starting subtest: basic-gtt-active
[219.457469] Subtest basic-gtt-active: SUCCESS (0.110s)
[220.197234] [053/131] (817s left) syncobj_wait (wait-all-snapshot)
[220.269887] Starting subtest: wait-all-snapshot
[220.353286] Subtest wait-all-snapshot: SUCCESS (0.082s)
[220.445449] [054/131] (816s left) gem_eio (wait-1us)
[220.505560] Starting subtest: wait-1us
[220.538474] Subtest wait-1us: SUCCESS (0.032s)
[221.295753] [055/131] (816s left) perf_pmu (semaphore-wait-idle)
[221.361213] Starting subtest: semaphore-wait-idle
[221.362061] Starting dynamic subtest: rcs0
[221.363536] Dynamic subtest rcs0: SKIP (0.001s)
[221.379858] Starting dynamic subtest: bcs0
[221.382161] Dynamic subtest bcs0: SKIP (0.000s)
[221.399516] Starting dynamic subtest: vcs0
[221.401651] Dynamic subtest vcs0: SKIP (0.000s)
[221.403757] Subtest semaphore-wait-idle: SKIP (0.005s)
[221.476717] [056/131] (815s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[221.534084] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SKIP (0.000s)
[221.587361] [057/131] (815s left) kms_psr (psr2-sprite-mmap-cpu)
[221.947132] Subtest psr2-sprite-mmap-cpu: SKIP (0.000s)
[222.169670] [058/131] (815s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[222.533118] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[222.534411] Subtest psr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[222.974529] [059/131] (814s left) kms_legacy_colorkey (basic)
[223.336645] Starting subtest: basic
[223.337330] Starting dynamic subtest: pipe-A
[223.337979] Dynamic subtest pipe-A: SUCCESS (0.000s)
[223.350890] Starting dynamic subtest: pipe-B
[223.351748] Dynamic subtest pipe-B: SUCCESS (0.000s)
[223.352570] Subtest basic: SUCCESS (0.003s)
[223.801756] [060/131] (813s left) prime_mmap_coherency (ioctl-errors)
[223.863323] Starting subtest: ioctl-errors
[233.025724] Subtest ioctl-errors: SUCCESS (9.162s)
[233.157782] [061/131] (804s left) kms_addfb_basic (legacy-format)
[233.324259] Starting subtest: legacy-format
[233.420765] Subtest legacy-format: SUCCESS (0.090s)
[234.147384] [062/131] (803s left) sysfs_heartbeat_interval (invalid)
[234.227363] Starting subtest: invalid
[234.229933] Starting dynamic subtest: vcs0
[234.230715] Dynamic subtest vcs0: SUCCESS (0.000s)
[234.242904] Starting dynamic subtest: bcs0
[234.243625] Dynamic subtest bcs0: SUCCESS (0.000s)
[234.253818] Starting dynamic subtest: rcs0
[234.254626] Dynamic subtest rcs0: SUCCESS (0.001s)
[234.255319] Subtest invalid: SUCCESS (0.008s)
[234.330864] [063/131] (803s left) kms_cursor_edge_walk (64x64-left-edge)
[234.668284] Starting subtest: 64x64-left-edge
[234.668853] Starting dynamic subtest: pipe-A-HDMI-A-1
[238.156130] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.486s)
[238.168360] Starting dynamic subtest: pipe-B-HDMI-A-1
[241.486334] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.328s)
[241.487071] Subtest 64x64-left-edge: SUCCESS (6.819s)
[242.020700] [064/131] (795s left) gem_wait (wait)
[242.106257] Starting subtest: wait
[242.107302] Starting dynamic subtest: all-engines
[243.127655] Dynamic subtest all-engines: SUCCESS (1.022s)
[243.142295] Starting dynamic subtest: rcs0
[244.158502] Dynamic subtest rcs0: SUCCESS (1.027s)
[244.172019] Starting dynamic subtest: bcs0
[245.181466] Dynamic subtest bcs0: SUCCESS (1.020s)
[245.195812] Starting dynamic subtest: vcs0
[246.205754] Dynamic subtest vcs0: SUCCESS (1.021s)
[246.206954] Subtest wait: SUCCESS (4.102s)
[246.428309] [065/131] (791s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[246.793275] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[246.794667] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[247.227505] [066/131] (790s left) gem_mmap (basic)
[247.286103] Starting subtest: basic
[247.289270] Subtest basic: SUCCESS (0.001s)
[247.396039] [067/131] (790s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[247.749062] Starting subtest: plane-primary-overlay-mutable-zpos
[248.007693] Subtest plane-primary-overlay-mutable-zpos: SKIP (0.259s)
[248.621649] [068/131] (789s left) kms_flip (2x-blocking-wf_vblank)
[248.980785] Starting subtest: 2x-blocking-wf_vblank
[248.983517] Starting dynamic subtest: AB-VGA1-HDMI-A1
[279.698891] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (30.718s)
[279.704122] Subtest 2x-blocking-wf_vblank: SUCCESS (30.721s)
[280.365253] [069/131] (757s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[280.730862] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[280.732025] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[281.165092] [070/131] (756s left) sw_sync (sync_expired_merge)
[281.235788] Starting subtest: sync_expired_merge
[282.310402] Subtest sync_expired_merge: SUCCESS (1.074s)
[282.377942] [071/131] (755s left) kms_plane_lowres (tiling-y)
[282.729814] Starting subtest: tiling-y
[282.731104] Subtest tiling-y: SKIP (0.000s)
[283.163937] [072/131] (754s left) sw_sync (sync_merge_invalid)
[283.218686] Starting subtest: sync_merge_invalid
[283.225214] Subtest sync_merge_invalid: SUCCESS (0.007s)
[283.291710] [073/131] (754s left) gem_wait (invalid-flags)
[283.353228] Starting subtest: invalid-flags
[283.353956] Subtest invalid-flags: SUCCESS (0.000s)
[283.594160] [074/131] (754s left) gem_mmap_gtt (basic-copy)
[283.648881] Starting subtest: basic-copy
[283.859326] Subtest basic-copy: SUCCESS (0.210s)
[283.974816] [075/131] (754s left) gem_caching (writes)
[284.035925] Starting subtest: writes
[287.029761] Subtest writes: SUCCESS (2.994s)
[287.135856] [076/131] (751s left) gem_mmap_wc (bad-offset)
[287.194127] Starting subtest: bad-offset
[287.194782] Subtest bad-offset: SUCCESS (0.001s)
[287.301837] [077/131] (751s left) gem_userptr_blits (huge-split)
[287.387625] Starting subtest: huge-split
[287.390249] Subtest huge-split: SUCCESS (0.003s)
[287.518659] [078/131] (750s left) syncobj_timeline (32bits-limit)
[287.577635] Starting subtest: 32bits-limit
[287.579702] Subtest 32bits-limit: SUCCESS (0.001s)
[287.672964] [079/131] (750s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc)
[287.729277] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s)
[287.778143] [080/131] (750s left) kms_psr2_su (frontbuffer-xrgb8888)
[287.837155] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[287.905690] [081/131] (750s left) i915_pm_rpm (gem-evict-pwrite)
[299.495024] Subtest gem-evict-pwrite: SKIP (0.000s)
[299.721928] [082/131] (738s left) gem_exec_nop (basic-parallel)
[299.787320] Starting subtest: basic-parallel
[302.588405] Subtest basic-parallel: SUCCESS (2.800s)
[302.827790] [083/131] (735s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[303.200549] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[303.201775] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[303.635505] [084/131] (735s left) gem_eio (in-flight-1us)
[303.703477] Starting subtest: in-flight-1us
[305.124533] Subtest in-flight-1us: SUCCESS (1.423s)
[305.872653] [FACT gem_eio (in-flight-1us)] new: kernel.kmod_is_loaded.vgem: true
[305.876966] [085/131] (732s left) gem_exec_endless (dispatch)
[305.935403] Subtest dispatch: SKIP (0.000s)
[306.043977] [086/131] (732s left) api_intel_bb (misplaced-blitter)
[306.097282] Starting subtest: misplaced-blitter
[306.099210] Subtest misplaced-blitter: SUCCESS (0.003s)
[306.234057] [087/131] (732s left) gem_flink_basic (basic)
[306.289604] Starting subtest: basic
[306.290376] Subtest basic: SUCCESS (0.000s)
[306.402340] [088/131] (732s left) gem_ctx_persistence (smoketest)
[306.461722] Subtest smoketest: SKIP (0.000s)
[306.530747] [089/131] (732s left) kms_dirtyfb (psr-dirtyfb-ioctl)
[306.889482] Starting subtest: psr-dirtyfb-ioctl
[306.892402] Subtest psr-dirtyfb-ioctl: SKIP (0.000s)
[307.336345] [090/131] (731s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[307.697392] Starting subtest: cursorA-vs-flipA-varying-size
[318.645228] Subtest cursorA-vs-flipA-varying-size: SUCCESS (10.947s)
[319.215923] [091/131] (719s left) kms_psr_stress_test (invalidate-primary-flip-overlay)
[319.276850] Subtest invalidate-primary-flip-overlay: SKIP (0.000s)
[319.356107] [092/131] (719s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[319.718569] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu
[319.719901] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[320.161612] [093/131] (719s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted)
[320.220146] Starting subtest: invalid-multi-wait-all-unsubmitted
[320.220902] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[320.322384] [094/131] (718s left) prime_busy (hang-wait)
[320.382624] Starting subtest: hang-wait
[320.384829] Starting dynamic subtest: rcs0
[326.895108] Dynamic subtest rcs0: SUCCESS (6.511s)
[326.907559] Starting dynamic subtest: bcs0
[332.845008] Dynamic subtest bcs0: SUCCESS (5.948s)
[332.858567] Starting dynamic subtest: vcs0
[338.860995] Dynamic subtest vcs0: SUCCESS (6.013s)
[338.861941] Subtest hang-wait: SUCCESS (18.479s)
[338.988419] [095/131] (700s left) gem_sync (basic-each)
[339.065655] Starting subtest: basic-each
[341.156895] Subtest basic-each: SUCCESS (2.091s)
[341.355634] [096/131] (698s left) gem_exec_balancer (parallel-keep-in-fence)
[341.416336] Subtest parallel-keep-in-fence: SKIP (0.000s)
[341.522695] [097/131] (697s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[341.889208] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[341.890428] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[342.335776] [098/131] (697s left) kms_big_fb (linear-32bpp-rotate-90)
[342.699396] Starting subtest: linear-32bpp-rotate-90
[342.716110] Subtest linear-32bpp-rotate-90: SKIP (0.016s)
[343.163198] [099/131] (696s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[343.228176] Starting subtest: yf-tiled-to-vebox-y-tiled
[343.230740] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[343.432160] [100/131] (696s left) kms_hdr (static-swap)
[343.790332] Starting subtest: static-swap
[343.792317] Subtest static-swap: SKIP (0.000s)
[344.229854] [101/131] (695s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[344.596255] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[344.598033] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[345.031154] [102/131] (694s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[345.393780] Starting subtest: x-tiled-64bpp-rotate-270
[345.410776] Subtest x-tiled-64bpp-rotate-270: SKIP (0.016s)
[345.861665] [103/131] (693s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[346.214419] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[346.215658] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[346.668883] [104/131] (693s left) gem_exec_reloc (basic-cpu-wc)
[346.733238] Starting subtest: basic-cpu-wc
[346.736238] Subtest basic-cpu-wc: SUCCESS (0.003s)
[347.471380] [105/131] (692s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[347.840520] Starting subtest: y-tiled-64bpp-rotate-180
[347.841894] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[348.289623] [106/131] (691s left) kms_flip (2x-flip-vs-suspend-interruptible)
[348.652072] Starting subtest: 2x-flip-vs-suspend-interruptible
[348.653985] Starting dynamic subtest: AB-VGA1-HDMI-A1
[553.257125] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[559.892901] Closing watchdogs
[559.897225] Initializing watchdogs
[559.897300]   /dev/watchdog0
[559.923708] [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)
[559.935430] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[559.937014] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[559.937787] [FACT before any test] new: kernel.kmod_is_loaded.vgem: true
[559.941448] [107/131] (486s left) kms_psr (pr-primary-mmap-gtt)
[560.364668] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[560.626306] [108/131] (485s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[560.998318] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[560.999812] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[561.454272] [109/131] (484s left) dumb_buffer (map-valid)
[561.516558] Starting subtest: map-valid
[561.517402] Subtest map-valid: SUCCESS (0.000s)
[561.627492] [110/131] (484s left) gem_pxp (regular-baseline-src-copy-readible)
[564.229997] Starting subtest: regular-baseline-src-copy-readible
[564.231664] Subtest regular-baseline-src-copy-readible: SKIP (0.000s)
[564.332103] [111/131] (481s left) syncobj_wait (multi-wait-for-submit-submitted)
[564.389626] Starting subtest: multi-wait-for-submit-submitted
[564.495705] Subtest multi-wait-for-submit-submitted: SUCCESS (0.103s)
[564.593849] [112/131] (481s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf)
[564.955261] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[565.190500] [113/131] (481s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[565.250093] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.000s)
[565.310253] [114/131] (481s left) gem_create (create-massive)
[565.368293] Starting subtest: create-massive
[565.369013] Subtest create-massive: SUCCESS (0.000s)
[565.588283] [115/131] (480s left) syncobj_timeline (invalid-signal-illegal-point)
[565.640994] Starting subtest: invalid-signal-illegal-point
[565.641796] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[565.737558] [116/131] (480s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs)
[565.798417] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SKIP (0.000s)
[565.870840] [117/131] (480s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[566.237920] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[566.239353] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[566.690311] [118/131] (479s left) kms_addfb_basic (bad-pitch-32)
[566.747985] Starting subtest: bad-pitch-32
[566.748926] Subtest bad-pitch-32: SUCCESS (0.000s)
[567.511865] [119/131] (479s left) syncobj_wait (invalid-single-wait-all-unsubmitted)
[567.575762] Starting subtest: invalid-single-wait-all-unsubmitted
[567.576488] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[567.680453] [120/131] (479s left) kms_joiner (invalid-modeset-big-joiner)
[568.046201] Starting subtest: invalid-modeset-big-joiner
[568.047760] Subtest invalid-modeset-big-joiner: SKIP (0.000s)
[568.493097] [121/131] (478s left) i915_drm_fdinfo (virtual-busy-idle-all)
[568.555201] Subtest virtual-busy-idle-all: SKIP (0.000s)
[568.621885] [122/131] (478s left) gem_exec_async (concurrent-writes)
[568.688615] Starting subtest: concurrent-writes
[568.689434] Starting dynamic subtest: rcs0
[568.691747] Dynamic subtest rcs0: SUCCESS (0.002s)
[568.710384] Starting dynamic subtest: bcs0
[568.711168] Dynamic subtest bcs0: SUCCESS (0.002s)
[568.727617] Starting dynamic subtest: vcs0
[568.728434] Dynamic subtest vcs0: SUCCESS (0.003s)
[568.729145] Subtest concurrent-writes: SUCCESS (0.012s)
[568.935838] [123/131] (477s left) gem_exec_reloc (basic-cpu-gtt-noreloc)
[568.992493] Starting subtest: basic-cpu-gtt-noreloc
[568.995258] Subtest basic-cpu-gtt-noreloc: SUCCESS (0.003s)
[569.757844] [124/131] (477s left) kms_flip (absolute-wf_vblank-interruptible)
[570.123839] Starting subtest: absolute-wf_vblank-interruptible
[570.126204] Starting dynamic subtest: A-VGA1
[577.916818] Dynamic subtest A-VGA1: SUCCESS (7.742s)
[577.931881] Starting dynamic subtest: B-VGA1
[585.646277] Dynamic subtest B-VGA1: SUCCESS (7.708s)
[585.663026] Starting dynamic subtest: A-HDMI-A1
[593.526728] Dynamic subtest A-HDMI-A1: SUCCESS (7.873s)
[593.542901] Starting dynamic subtest: B-HDMI-A1
[601.431752] Dynamic subtest B-HDMI-A1: SUCCESS (7.899s)
[601.434706] Subtest absolute-wf_vblank-interruptible: SUCCESS (31.233s)
[602.076137] [125/131] (444s left) perf (gen12-group-exclusive-stream-sample-oa)
[602.242350] Subtest gen12-group-exclusive-stream-sample-oa: SKIP (0.000s)
[602.313213] [126/131] (444s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[602.367482] Starting subtest: cpuset-basic-small-copy-XY
[603.352559] Subtest cpuset-basic-small-copy-XY: SUCCESS (0.986s)
[603.480944] [127/131] (443s left) kms_chamelium_edid (dp-edid-read)
[604.033655] Subtest dp-edid-read: SKIP (0.000s)
[604.365900] [128/131] (442s left) gem_userptr_blits (unsync-unmap-cycles)
[604.430428] Subtest unsync-unmap-cycles: SKIP (0.000s)
[604.576035] [129/131] (442s left) gem_ctx_persistence (heartbeat-hostile)
[604.636071] Subtest heartbeat-hostile: SKIP (0.000s)
[604.697113] [130/131] (442s left) kms_content_protection (atomic-dpms)
[605.085466] Starting subtest: atomic-dpms
[605.303134] Subtest atomic-dpms: SKIP (0.216s)
[605.944382] [131/131] (441s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[606.006069] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[606.073475] 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.