[76.616133] Initializing watchdogs
[76.616298]   /dev/watchdog0
[76.636822] [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)
[76.644807] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[76.648809] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[76.652195] [001/133] (960s left) gem_eio (in-flight-10ms)
[76.754612] Starting subtest: in-flight-10ms
[78.229632] Subtest in-flight-10ms: SUCCESS (1.477s)
[78.768107] [FACT gem_eio (in-flight-10ms)] new: kernel.kmod_is_loaded.vgem: true
[78.771096] [002/133] (958s left) gem_ctx_shared (q-smoketest-all)
[78.830599] Subtest Q-smoketest-all: SKIP (0.000s)
[78.943722] [003/133] (958s left) kms_joiner (basic-max-non-joiner)
[79.430906] Starting subtest: basic-max-non-joiner
[79.432548] Subtest basic-max-non-joiner: SKIP (0.000s)
[79.569940] [004/133] (957s left) gem_exec_balancer (parallel-out-fence)
[79.634985] Subtest parallel-out-fence: SKIP (0.000s)
[79.731954] [005/133] (957s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[80.229789] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip
[80.322913] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.089s)
[80.538576] [006/133] (956s left) gem_exec_schedule (preempt-other-chain)
[80.610729] Subtest preempt-other-chain: SKIP (0.000s)
[80.815915] [007/133] (956s left) kms_addfb_basic (invalid-smem-bo-on-discrete)
[80.876665] Starting subtest: invalid-smem-bo-on-discrete
[80.877902] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s)
[81.401863] [008/133] (956s left) gem_eio (in-flight-internal-10ms)
[81.465100] Starting subtest: in-flight-internal-10ms
[81.503671] Subtest in-flight-internal-10ms: SUCCESS (0.039s)
[82.043461] [009/133] (955s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[82.527149] Starting subtest: basic-busy-flip-before-cursor-atomic
[83.582802] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (1.055s)
[83.854990] [010/133] (953s left) gem_busy (parallel)
[84.048569] Starting subtest: parallel
[84.049806] Starting dynamic subtest: rcs0
[84.082644] Dynamic subtest rcs0: SUCCESS (0.034s)
[84.093408] Starting dynamic subtest: bcs0
[84.100537] Dynamic subtest bcs0: SUCCESS (0.017s)
[84.101626] Subtest parallel: SUCCESS (0.053s)
[84.337564] [011/133] (953s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[84.833061] Starting subtest: x-tiled-32bpp-rotate-270
[84.907651] Subtest x-tiled-32bpp-rotate-270: SKIP (0.073s)
[85.140206] [012/133] (952s left) syncobj_timeline (etime-multi-wait-submitted)
[85.201693] Starting subtest: etime-multi-wait-submitted
[85.307676] Subtest etime-multi-wait-submitted: SUCCESS (0.106s)
[85.404960] [013/133] (952s left) gem_exec_schedule (submit-late-slice)
[85.480474] Subtest submit-late-slice: SKIP (0.000s)
[85.676272] [014/133] (952s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[85.730873] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.000s)
[85.785708] [015/133] (952s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[86.275154] Starting subtest: fbc-farfromfence-mmap-gtt
[88.332844] Subtest fbc-farfromfence-mmap-gtt: SUCCESS (2.057s)
[88.552398] [016/133] (949s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[89.036802] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[89.037787] Starting dynamic subtest: pipe-A
[89.042091] Dynamic subtest pipe-A: SKIP (0.002s)
[89.053894] Starting dynamic subtest: pipe-B
[89.057916] Dynamic subtest pipe-B: SKIP (0.001s)
[89.059924] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.004s)
[89.134029] [017/133] (948s left) kms_psr (pr-basic)
[89.612283] Subtest pr-basic: SKIP (0.000s)
[89.662724] [018/133] (948s left) gen7_exec_parse (basic-allowed)
[89.722403] Subtest basic-allowed: SKIP (0.000s)
[89.778053] [019/133] (948s left) gen7_exec_parse (oacontrol-tracking)
[89.836787] Subtest oacontrol-tracking: SKIP (0.000s)
[89.896477] [020/133] (948s left) gem_workarounds (suspend-resume-context)
[89.966842] Starting subtest: suspend-resume-context
[107.018200] Subtest suspend-resume-context: SUCCESS (0.604s)
[114.165990] [021/133] (931s left) gem_mmap_wc (set-cache-level)
[114.255562] Starting subtest: set-cache-level
[114.256241] Subtest set-cache-level: SUCCESS (0.001s)
[114.365689] [022/133] (930s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[114.865533] Starting subtest: yf-tiled-8bpp-rotate-90
[114.867666] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[114.980814] [023/133] (930s left) perf_pmu (busy-accuracy-50)
[115.046119] Starting subtest: busy-accuracy-50
[115.047225] Starting dynamic subtest: rcs0
[115.049101] Dynamic subtest rcs0: SKIP (0.000s)
[115.062118] Starting dynamic subtest: bcs0
[115.064797] Dynamic subtest bcs0: SKIP (0.000s)
[115.078411] Starting dynamic subtest: vcs0
[115.080799] Dynamic subtest vcs0: SKIP (0.000s)
[115.082612] Subtest busy-accuracy-50: SKIP (0.002s)
[115.148259] [024/133] (930s left) kms_flip (dpms-off-confusion-interruptible)
[115.652385] Starting subtest: dpms-off-confusion-interruptible
[115.653241] Starting dynamic subtest: A-VGA1
[123.420460] Dynamic subtest A-VGA1: SUCCESS (7.610s)
[123.435078] Starting dynamic subtest: B-VGA1
[131.104762] Dynamic subtest B-VGA1: SUCCESS (7.623s)
[131.118655] Starting dynamic subtest: A-HDMI-A1
[138.819056] Dynamic subtest A-HDMI-A1: SUCCESS (7.688s)
[138.831321] Starting dynamic subtest: B-HDMI-A1
[146.579036] Dynamic subtest B-HDMI-A1: SUCCESS (7.751s)
[146.580149] Subtest dpms-off-confusion-interruptible: SUCCESS (30.679s)
[146.766961] [025/133] (898s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic)
[147.256180] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic
[148.840227] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.584s)
[149.098850] [026/133] (896s left) kms_chamelium_frames (vga-frame-dump)
[149.717174] Subtest vga-frame-dump: SKIP (0.000s)
[149.958770] [027/133] (895s left) kms_draw_crc (draw-method-mmap-wc)
[150.451682] Starting subtest: draw-method-mmap-wc
[150.452605] Starting dynamic subtest: xrgb8888-untiled
[150.785857] Dynamic subtest xrgb8888-untiled: SUCCESS (0.333s)
[150.799307] Starting dynamic subtest: rgb565-untiled
[151.053246] Dynamic subtest rgb565-untiled: SUCCESS (0.266s)
[151.067558] Starting dynamic subtest: xrgb2101010-untiled
[151.320991] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.266s)
[151.336159] Starting dynamic subtest: xbgr16161616f-untiled
[151.604947] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.283s)
[151.617533] Starting dynamic subtest: xrgb8888-xtiled
[151.755454] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.149s)
[151.767664] Starting dynamic subtest: rgb565-xtiled
[151.889089] Dynamic subtest rgb565-xtiled: SUCCESS (0.133s)
[151.902518] Starting dynamic subtest: xrgb2101010-xtiled
[152.039869] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.150s)
[152.053057] Starting dynamic subtest: xbgr16161616f-xtiled
[152.190046] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.149s)
[152.191145] Subtest draw-method-mmap-wc: SUCCESS (1.739s)
[152.393768] [028/133] (893s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[152.884441] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[152.885743] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[152.994303] [029/133] (892s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[153.482033] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[153.483682] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[153.597484] [030/133] (892s left) kms_chamelium_frames (hdmi-crc-multiple)
[154.194442] Subtest hdmi-crc-multiple: SKIP (0.000s)
[154.424827] [031/133] (891s left) gem_exec_fence (submit-chain)
[154.602428] Subtest submit-chain: SKIP (0.000s)
[154.975741] [032/133] (890s left) kms_pm_rpm (i2c)
[166.759064] Subtest i2c: SKIP (0.000s)
[166.819825] [033/133] (879s left) gem_mmap_offset (partial-remap)
[166.890830] Starting subtest: partial-remap
[166.891739] Starting dynamic subtest: smem0
[166.897524] Dynamic subtest smem0: SUCCESS (0.006s)
[166.898370] Subtest partial-remap: SUCCESS (0.006s)
[167.024977] [034/133] (878s left) kms_atomic_interruptible (atomic-setmode)
[167.506857] Starting subtest: atomic-setmode
[167.509310] Starting dynamic subtest: pipe-A-VGA-1
[173.772913] Dynamic subtest pipe-A-VGA-1: SUCCESS (6.262s)
[173.773743] Subtest atomic-setmode: SUCCESS (6.264s)
[174.034908] [035/133] (871s left) gem_ctx_create (basic-files)
[174.104706] Starting subtest: basic-files
[176.120884] Subtest basic-files: SUCCESS (2.015s)
[176.355408] [036/133] (869s left) gen3_render_tiledx_blits
[176.477596] [037/133] (869s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[176.970320] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[178.561010] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SUCCESS (1.590s)
[178.710725] [038/133] (867s left) drm_read (short-buffer-wakeup)
[179.295216] Starting subtest: short-buffer-wakeup
[211.520880] Subtest short-buffer-wakeup: SUCCESS (32.215s)
[211.743096] [039/133] (834s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled)
[211.805876] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled
[211.807479] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[211.906521] [040/133] (834s left) syncobj_basic (illegal-fd-to-handle)
[211.961986] Starting subtest: illegal-fd-to-handle
[211.962625] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[212.054860] [041/133] (834s left) kms_scaling_modes (scaling-mode-full-aspect)
[212.531970] Starting subtest: scaling-mode-full-aspect
[212.537179] Subtest scaling-mode-full-aspect: SKIP (0.000s)
[212.647769] [042/133] (833s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[213.144252] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[213.145959] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[213.258728] [043/133] (833s left) kms_dirtyfb (default-dirtyfb-ioctl)
[213.741375] Starting subtest: default-dirtyfb-ioctl
[213.742147] Starting dynamic subtest: A-VGA-1
[215.115505] Dynamic subtest A-VGA-1: SUCCESS (1.374s)
[215.129380] Starting dynamic subtest: A-HDMI-A-1
[216.538349] Dynamic subtest A-HDMI-A-1: SUCCESS (1.422s)
[216.539045] Subtest default-dirtyfb-ioctl: SUCCESS (2.799s)
[216.790056] [044/133] (829s left) kms_rotation_crc (sprite-rotation-270)
[217.274229] Starting subtest: sprite-rotation-270
[217.275912] Subtest sprite-rotation-270: SKIP (0.001s)
[217.369733] [045/133] (829s left) kms_addfb_basic (bad-pitch-0)
[217.428069] Starting subtest: bad-pitch-0
[217.428711] Subtest bad-pitch-0: SUCCESS (0.000s)
[218.000191] [046/133] (828s left) syncobj_wait (multi-wait-for-submit-submitted)
[218.064104] Starting subtest: multi-wait-for-submit-submitted
[218.170829] Subtest multi-wait-for-submit-submitted: SUCCESS (0.106s)
[218.268014] [047/133] (828s left) kms_flip (blocking-absolute-wf_vblank)
[218.751800] Starting subtest: blocking-absolute-wf_vblank
[218.752554] Starting dynamic subtest: A-VGA1
[226.560504] Dynamic subtest A-VGA1: SUCCESS (7.809s)
[226.574983] Starting dynamic subtest: B-VGA1
[234.284533] Dynamic subtest B-VGA1: SUCCESS (7.721s)
[234.299091] Starting dynamic subtest: A-HDMI-A1
[242.178224] Dynamic subtest A-HDMI-A1: SUCCESS (7.891s)
[242.195117] Starting dynamic subtest: B-HDMI-A1
[250.098340] Dynamic subtest B-HDMI-A1: SUCCESS (7.917s)
[250.100785] Subtest blocking-absolute-wf_vblank: SUCCESS (31.350s)
[250.282895] [048/133] (796s left) gem_exec_reloc (basic-gtt-wc-active)
[250.346205] Starting subtest: basic-gtt-wc-active
[250.457524] Subtest basic-gtt-wc-active: SUCCESS (0.111s)
[250.963917] [049/133] (795s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[251.025038] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SKIP (0.000s)
[251.089590] [050/133] (795s left) i915_drm_fdinfo (virtual-busy-hang)
[251.149394] Subtest virtual-busy-hang: SKIP (0.000s)
[251.214711] [051/133] (795s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[251.698422] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[251.700144] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[251.813666] [052/133] (795s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[251.882053] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[251.884167] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[252.084169] [053/133] (794s left) gem_eio (in-flight-1us)
[252.148356] Starting subtest: in-flight-1us
[253.522159] Subtest in-flight-1us: SUCCESS (1.373s)
[254.043133] [054/133] (792s left) gem_exec_reloc (basic-write-wc)
[254.106037] Starting subtest: basic-write-wc
[254.109446] Subtest basic-write-wc: SUCCESS (0.003s)
[254.627095] [055/133] (792s left) syncobj_wait (wait-zero-handles)
[254.685240] Starting subtest: wait-zero-handles
[254.685978] Subtest wait-zero-handles: SUCCESS (0.000s)
[254.777273] [056/133] (792s left) perf_pmu (enable-race)
[254.840284] Starting subtest: enable-race
[254.841103] Starting dynamic subtest: rcs0
[254.842678] Dynamic subtest rcs0: SKIP (0.000s)
[254.855696] Starting dynamic subtest: bcs0
[254.858060] Dynamic subtest bcs0: SKIP (0.000s)
[254.872126] Starting dynamic subtest: vcs0
[254.874600] Dynamic subtest vcs0: SKIP (0.000s)
[254.876600] Subtest enable-race: SKIP (0.003s)
[254.947947] [057/133] (792s left) gem_softpin (zero)
[255.007493] Subtest zero: SKIP (0.000s)
[255.105594] [058/133] (792s left) gem_pxp (verify-pxp-stale-ctx-execution)
[257.678686] Starting subtest: verify-pxp-stale-ctx-execution
[257.680324] Subtest verify-pxp-stale-ctx-execution: SKIP (0.000s)
[257.826046] [059/133] (789s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[258.316570] Starting subtest: y-tiled-64bpp-rotate-0
[258.318554] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[258.432183] [060/133] (788s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[258.497536] Starting subtest: etime-multi-wait-all-for-submit-submitted
[258.602938] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.105s)
[258.707600] [061/133] (788s left) syncobj_timeline (invalid-signal-zero-handles)
[258.765914] Starting subtest: invalid-signal-zero-handles
[258.766916] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[258.870138] [062/133] (788s left) gem_exec_suspend (basic-s3)
[258.941526] Starting subtest: basic-S3
[258.942385] Starting dynamic subtest: smem
[276.220333] Dynamic subtest smem: SUCCESS (1.483s)
[276.221427] Subtest basic-S3: SUCCESS (1.485s)
[283.448520] [063/133] (771s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[283.518281] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.000s)
[283.604799] [064/133] (770s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier)
[284.102893] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier
[284.104828] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier: SKIP (0.000s)
[284.212345] [065/133] (770s left) kms_lease (possible-crtcs-filtering)
[284.706263] Starting subtest: possible-crtcs-filtering
[284.708562] Subtest possible-crtcs-filtering: SUCCESS (0.003s)
[284.810078] [066/133] (769s left) i915_hangman (engine-engine-error)
[284.874013] Subtest engine-engine-error: SKIP (0.000s)
[284.951462] [067/133] (769s left) gem_softpin (evict-active)
[285.010961] Starting subtest: evict-active
[285.014854] Subtest evict-active: SUCCESS (0.005s)
[285.140063] [068/133] (769s left) vgem_basic (unload)
[285.195051] Starting subtest: unload
[314.207967] Subtest unload: SUCCESS (28.773s)
[314.363171] [069/133] (740s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[314.856936] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[314.858529] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[314.973176] [070/133] (739s left) api_intel_allocator (fork-simple-once)
[315.032171] Starting subtest: fork-simple-once
[315.058104] Subtest fork-simple-once: SUCCESS (0.026s)
[315.187192] [071/133] (739s left) kms_vblank (wait-forked-hang)
[315.670518] Starting subtest: wait-forked-hang
[315.672182] Starting dynamic subtest: pipe-A-VGA-1
[321.972416] Dynamic subtest pipe-A-VGA-1: SUCCESS (6.298s)
[321.990437] Starting dynamic subtest: pipe-A-HDMI-A-1
[328.014512] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.037s)
[328.031155] Starting dynamic subtest: pipe-B-VGA-1
[334.008603] Dynamic subtest pipe-B-VGA-1: SUCCESS (5.989s)
[334.024319] Starting dynamic subtest: pipe-B-HDMI-A-1
[340.046300] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (6.034s)
[340.047141] Subtest wait-forked-hang: SUCCESS (24.370s)
[340.319959] [072/133] (714s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[340.813708] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[340.815684] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[340.944250] [073/133] (714s left) gem_ctx_persistence (hostile)
[341.004332] Subtest hostile: SKIP (0.000s)
[341.064192] [074/133] (714s left) gem_mmap_wc (write-prefaulted)
[341.121731] Starting subtest: write-prefaulted
[341.268889] Subtest write-prefaulted: SUCCESS (0.145s)
[341.366268] [075/133] (713s left) gem_exec_reloc (basic-cpu-noreloc)
[341.423398] Starting subtest: basic-cpu-noreloc
[341.425359] Subtest basic-cpu-noreloc: SUCCESS (0.002s)
[341.934768] [076/133] (713s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[342.415256] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[342.417096] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[342.521091] [077/133] (712s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[343.001362] Starting subtest: coverage-vs-premult-vs-constant
[343.228509] Subtest coverage-vs-premult-vs-constant: SKIP (0.228s)
[343.575165] [078/133] (711s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[344.064353] Starting subtest: cursor-rapid-movement-64x64
[344.082359] Starting dynamic subtest: pipe-A-VGA-1
[344.496904] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.414s)
[344.543962] Starting dynamic subtest: pipe-B-HDMI-A-1
[344.929559] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.400s)
[344.930413] Subtest cursor-rapid-movement-64x64: SUCCESS (0.865s)
[345.201686] [079/133] (710s left) kms_plane_scaling (planes-downscale-factor-0-75)
[345.687020] Starting subtest: planes-downscale-factor-0-75
[345.687946] Starting dynamic subtest: pipe-A
[345.690699] Dynamic subtest pipe-A: SKIP (0.002s)
[345.705542] Starting dynamic subtest: pipe-B
[345.710164] Dynamic subtest pipe-B: SKIP (0.001s)
[345.712377] Subtest planes-downscale-factor-0-75: SKIP (0.006s)
[345.798869] [080/133] (709s left) gem_userptr_blits (coherency-sync)
[345.875021] Starting subtest: coherency-sync
[371.817121] Subtest coherency-sync: SUCCESS (25.930s)
[371.971278] [081/133] (683s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[372.138240] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.000s)
[372.199045] [082/133] (683s left) kms_cursor_crc (cursor-onscreen-256x85)
[372.709456] Starting subtest: cursor-onscreen-256x85
[372.760415] Subtest cursor-onscreen-256x85: SKIP (0.049s)
[372.876358] [083/133] (682s left) kms_psr (psr2-primary-mmap-cpu)
[373.352555] Subtest psr2-primary-mmap-cpu: SKIP (0.000s)
[373.419435] [084/133] (682s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[373.900357] Starting subtest: short-flip-after-cursor-atomic-transitions
[374.982052] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (1.080s)
[375.254066] [085/133] (680s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[375.745160] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[377.357015] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SUCCESS (1.610s)
[377.524698] [086/133] (678s left) kms_pm_rpm (drm-resources-equal)
[389.292491] Subtest drm-resources-equal: SKIP (0.000s)
[389.360941] [087/133] (666s left) gem_userptr_blits (map-fixed-invalidate-busy)
[389.442898] Starting subtest: map-fixed-invalidate-busy
[389.443596] Starting dynamic subtest: gtt
[390.445300] Dynamic subtest gtt: SUCCESS (1.003s)
[390.462568] Starting dynamic subtest: wb
[391.433855] Dynamic subtest wb: SUCCESS (0.987s)
[391.449448] Starting dynamic subtest: wc
[392.411372] Dynamic subtest wc: SUCCESS (0.976s)
[392.426009] Starting dynamic subtest: uc
[393.388674] Dynamic subtest uc: SUCCESS (0.976s)
[393.389459] Subtest map-fixed-invalidate-busy: SUCCESS (3.950s)
[393.531318] [088/133] (662s left) sw_sync (alloc_merge_fence)
[393.600219] Starting subtest: alloc_merge_fence
[393.601109] Subtest alloc_merge_fence: SUCCESS (0.000s)
[393.688091] [089/133] (662s left) kms_flip (2x-flip-vs-suspend-interruptible)
[394.171813] Starting subtest: 2x-flip-vs-suspend-interruptible
[394.173989] Starting dynamic subtest: AB-VGA1-HDMI-A1
[598.845298] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[607.358682] Closing watchdogs
[607.364827] Initializing watchdogs
[607.364898]   /dev/watchdog0
[607.388074] [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)
[607.400422] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[607.402248] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[607.402997] [FACT before any test] new: kernel.kmod_is_loaded.vgem: true
[607.406661] [090/133] (456s left) gem_exec_fence (syncobj-timeline-unused-fence)
[607.772386] Starting subtest: syncobj-timeline-unused-fence
[607.774488] Subtest syncobj-timeline-unused-fence: SUCCESS (0.002s)
[608.027235] [091/133] (456s left) gem_exec_whisper (basic-fds-forked)
[608.104650] Starting subtest: basic-fds-forked
[610.668394] Subtest basic-fds-forked: SUCCESS (2.485s)
[610.873197] [092/133] (453s left) gem_exec_capture (userptr)
[610.944596] Subtest userptr: SKIP (0.000s)
[611.027887] [093/133] (453s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[611.092797] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.000s)
[611.160375] [094/133] (453s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[611.659912] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt
[611.661206] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[611.779737] [095/133] (452s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[612.272421] Starting subtest: psr-modesetfrombusy
[612.274112] Subtest psr-modesetfrombusy: SKIP (0.000s)
[612.390094] [096/133] (452s left) kms_content_protection (lic-type-0)
[612.899952] Starting subtest: lic-type-0
[612.901506] Subtest lic-type-0: SKIP (0.000s)
[613.019712] [097/133] (451s left) gem_mmap_gtt (basic-read)
[613.080419] Starting subtest: basic-read
[613.122713] Subtest basic-read: SUCCESS (0.041s)
[613.238204] [098/133] (451s left) api_intel_bb (purge-bb)
[613.295143] Starting subtest: purge-bb
[613.296308] Subtest purge-bb: SUCCESS (0.002s)
[613.442173] [099/133] (451s left) kms_color (legacy-gamma-reset)
[613.933330] Starting subtest: legacy-gamma-reset
[613.934311] Starting dynamic subtest: pipe-A-VGA-1
[614.182872] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.245s)
[614.200071] Starting dynamic subtest: pipe-A-HDMI-A-1
[614.200834] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.004s)
[614.218621] Starting dynamic subtest: pipe-B-VGA-1
[614.219350] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.004s)
[614.234776] Starting dynamic subtest: pipe-B-HDMI-A-1
[614.235421] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.004s)
[614.236183] Subtest legacy-gamma-reset: SUCCESS (0.263s)
[614.449786] [100/133] (450s left) kms_hdr (invalid-metadata-sizes)
[614.938977] Starting subtest: invalid-metadata-sizes
[614.942921] Subtest invalid-metadata-sizes: SKIP (0.000s)
[615.044601] [101/133] (449s left) kms_async_flips (test-cursor-atomic)
[615.532527] Starting subtest: test-cursor-atomic
[615.782751] Starting dynamic subtest: pipe-A-VGA-1
[615.881906] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.098s)
[616.002770] Starting dynamic subtest: pipe-A-HDMI-A-1
[616.138284] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.149s)
[616.301137] Starting dynamic subtest: pipe-B-VGA-1
[616.402853] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.112s)
[616.519428] Starting dynamic subtest: pipe-B-HDMI-A-1
[616.655458] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.150s)
[616.656382] Subtest test-cursor-atomic: SUCCESS (1.110s)
[617.069118] [102/133] (447s left) kms_psr (fbc-psr-no-drrs)
[617.556971] Subtest fbc-psr-no-drrs: SKIP (0.000s)
[617.617367] [103/133] (447s left) kms_psr (fbc-psr2-cursor-mmap-gtt)
[618.095841] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.000s)
[618.156361] [104/133] (446s left) syncobj_timeline (wait-all-interrupted)
[618.221276] Starting subtest: wait-all-interrupted
[618.324950] Subtest wait-all-interrupted: SUCCESS (0.101s)
[618.437485] [105/133] (446s left) gem_linear_blits (basic)
[618.630161] Starting subtest: basic
[618.640691] Subtest basic: SUCCESS (0.010s)
[618.781804] [106/133] (446s left) kms_tv_load_detect (load-detect)
[618.953648] Subtest load-detect: SKIP (0.000s)
[619.016951] [107/133] (446s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[619.512896] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[619.582695] [108/133] (445s left) prime_vgem (basic-fence-mmap)
[619.662103] Starting subtest: basic-fence-mmap
[619.694575] Subtest basic-fence-mmap: SUCCESS (0.032s)
[619.813483] [109/133] (445s left) gem_lmem_swapping (verify-random)
[619.886334] Subtest verify-random: SKIP (0.000s)
[619.949903] [110/133] (445s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[620.436145] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[620.438478] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[620.565735] [111/133] (444s left) kms_plane_lowres (tiling-4)
[621.042869] Starting subtest: tiling-4
[621.045628] Subtest tiling-4: SKIP (0.000s)
[621.183721] [112/133] (444s left) kms_psr2_su (page_flip-p010)
[621.240745] Subtest page_flip-P010: SKIP (0.000s)
[621.333192] [113/133] (444s left) kms_properties (colorop-properties-legacy)
[621.816426] Starting subtest: colorop-properties-legacy
[621.818626] Starting dynamic subtest: pipe-A-VGA-1
[622.037578] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.218s)
[622.054613] Starting dynamic subtest: pipe-A-HDMI-A-1
[622.244536] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.203s)
[622.263916] Starting dynamic subtest: pipe-B-VGA-1
[622.374474] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.127s)
[622.390077] Starting dynamic subtest: pipe-B-HDMI-A-1
[622.581670] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.203s)
[622.582781] Subtest colorop-properties-legacy: SUCCESS (0.761s)
[622.860014] [114/133] (442s left) gem_ctx_isolation (preservation-reset)
[623.040922] Starting subtest: preservation-reset
[623.041874] Starting dynamic subtest: rcs0
[623.612600] Dynamic subtest rcs0: SUCCESS (0.568s)
[623.615048] Subtest preservation-reset: SUCCESS (0.571s)
[623.776232] [115/133] (441s left) i915_pm_rpm (gem-evict-pwrite)
[635.556370] Subtest gem-evict-pwrite: SKIP (0.000s)
[635.627220] [116/133] (429s left) gem_gpgpu_fill (basic)
[635.689914] Subtest basic: SKIP (0.000s)
[635.821934] [117/133] (429s left) gem_exec_balancer (full-pulse)
[635.884841] Subtest full-pulse: SKIP (0.000s)
[635.984532] [118/133] (429s left) sw_sync (sync_merge)
[636.045900] Starting subtest: sync_merge
[636.046640] Subtest sync_merge: SUCCESS (0.001s)
[636.137784] [119/133] (429s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[636.618839] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[638.637045] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SUCCESS (2.016s)
[638.775343] [120/133] (427s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[638.842584] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (0.000s)
[638.900042] [121/133] (426s left) kms_big_fb (linear-32bpp-rotate-270)
[639.389445] Starting subtest: linear-32bpp-rotate-270
[639.475386] Subtest linear-32bpp-rotate-270: SKIP (0.084s)
[639.714470] [122/133] (426s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[640.202833] Starting subtest: 4-tiled-64bpp-rotate-180
[640.204069] Subtest 4-tiled-64bpp-rotate-180: SKIP (0.000s)
[640.315365] [123/133] (425s left) perf (polling-small-buf)
[640.501169] Subtest polling-small-buf: SKIP (0.000s)
[640.562639] [124/133] (425s left) i915_query (query-regions-garbage-items)
[640.621684] Starting subtest: query-regions-garbage-items
[640.622543] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[640.732880] [125/133] (425s left) kms_selftest (drm_plane_helper)
[640.805955] Starting subtest: drm_plane_helper
[640.820206] Starting dynamic subtest: drm_test_check_plane_state
[640.898202] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.077s)
[640.916371] Starting dynamic subtest: drm_test_check_invalid_plane_state
[640.965946] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.064s)
[640.966684] Subtest drm_plane_helper: SUCCESS (0.159s)
[641.114932] [126/133] (425s left) gem_mmap_gtt (medium-copy-xy)
[641.171931] Starting subtest: medium-copy-XY
[642.020109] Subtest medium-copy-XY: SUCCESS (0.848s)
[642.146652] [127/133] (424s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions)
[642.740319] Starting subtest: cursorB-vs-flipB-atomic-transitions
[653.822682] Subtest cursorB-vs-flipB-atomic-transitions: SUCCESS (11.076s)
[654.087762] [128/133] (412s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[654.579529] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[654.580879] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[654.688261] [129/133] (411s left) gem_exec_nop (basic-parallel)
[654.762185] Starting subtest: basic-parallel
[657.547375] Subtest basic-parallel: SUCCESS (2.785s)
[657.783681] [130/133] (408s left) vgem_basic (debugfs)
[657.859809] Starting subtest: debugfs
[657.860516] Subtest debugfs: SUCCESS (0.001s)
[657.946360] [131/133] (408s left) gem_create (create-massive)
[658.005366] Starting subtest: create-massive
[658.006104] Subtest create-massive: SUCCESS (0.000s)
[658.212867] [132/133] (408s left) kms_cursor_edge_walk (256x256-top-bottom)
[658.688958] Starting subtest: 256x256-top-bottom
[658.689762] Starting dynamic subtest: pipe-A-VGA-1
[662.095618] Dynamic subtest pipe-A-VGA-1: SUCCESS (3.404s)
[662.114091] Starting dynamic subtest: pipe-B-HDMI-A-1
[665.428368] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.330s)
[665.429157] Subtest 256x256-top-bottom: SUCCESS (6.739s)
[665.677388] [133/133] (400s left) kms_busy (extended-modeset-hang-newfb)
[666.159390] Starting subtest: extended-modeset-hang-newfb
[666.162145] Starting dynamic subtest: pipe-A
[678.800526] Dynamic subtest pipe-A: SUCCESS (12.634s)
[678.817422] Starting dynamic subtest: pipe-B
[690.899724] Dynamic subtest pipe-B: SUCCESS (12.091s)
[690.900537] Subtest extended-modeset-hang-newfb: SUCCESS (24.731s)
[691.155059] Closing watchdogs
results: parsing output: 0/ for test: gem_eio
results: parsing output: 1/ for test: gem_ctx_shared
results: parsing output: 2/ for test: kms_joiner
results: parsing output: 3/ for test: gem_exec_balancer
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: gem_exec_schedule
results: parsing output: 6/ for test: kms_addfb_basic
results: parsing output: 7/ for test: gem_eio
results: parsing output: 8/ for test: kms_cursor_legacy
results: parsing output: 9/ for test: gem_busy
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: syncobj_timeline
results: parsing output: 12/ for test: gem_exec_schedule
results: parsing output: 13/ for test: kms_ccs
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_plane_scaling
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: gen7_exec_parse
results: parsing output: 18/ for test: gen7_exec_parse
results: parsing output: 19/ for test: gem_workarounds
results: parsing output: 20/ for test: gem_mmap_wc
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: perf_pmu
results: parsing output: 23/ for test: kms_flip
results: parsing output: 24/ for test: kms_cursor_legacy
results: parsing output: 25/ for test: kms_chamelium_frames
results: parsing output: 26/ for test: kms_draw_crc
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_chamelium_frames
results: parsing output: 30/ for test: gem_exec_fence
results: parsing output: 31/ for test: kms_pm_rpm
results: parsing output: 32/ for test: gem_mmap_offset
results: parsing output: 33/ for test: kms_atomic_interruptible
results: parsing output: 34/ for test: gem_ctx_create
results: parsing output: 35/ for test: gen3_render_tiledx_blits
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: drm_read
results: parsing output: 38/ for test: syncobj_timeline
results: parsing output: 39/ for test: syncobj_basic
results: parsing output: 40/ for test: kms_scaling_modes
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_dirtyfb
results: parsing output: 43/ for test: kms_rotation_crc
results: parsing output: 44/ for test: kms_addfb_basic
results: parsing output: 45/ for test: syncobj_wait
results: parsing output: 46/ for test: kms_flip
results: parsing output: 47/ for test: gem_exec_reloc
results: parsing output: 48/ for test: kms_ccs
results: parsing output: 49/ for test: i915_drm_fdinfo
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_render_copy
results: parsing output: 52/ for test: gem_eio
results: parsing output: 53/ for test: gem_exec_reloc
results: parsing output: 54/ for test: syncobj_wait
results: parsing output: 55/ for test: perf_pmu
results: parsing output: 56/ for test: gem_softpin
results: parsing output: 57/ for test: gem_pxp
results: parsing output: 58/ for test: kms_big_fb
results: parsing output: 59/ for test: syncobj_timeline
results: parsing output: 60/ for test: syncobj_timeline
results: parsing output: 61/ for test: gem_exec_suspend
results: parsing output: 62/ for test: kms_ccs
results: parsing output: 63/ for test: kms_plane
results: parsing output: 64/ for test: kms_lease
results: parsing output: 65/ for test: i915_hangman
results: parsing output: 66/ for test: gem_softpin
results: parsing output: 67/ for test: vgem_basic
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: api_intel_allocator
results: parsing output: 70/ for test: kms_vblank
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: gem_ctx_persistence
results: parsing output: 73/ for test: gem_mmap_wc
results: parsing output: 74/ for test: gem_exec_reloc
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_plane_alpha_blend
results: parsing output: 77/ for test: kms_cursor_crc
results: parsing output: 78/ for test: kms_plane_scaling
results: parsing output: 79/ for test: gem_userptr_blits
results: parsing output: 80/ for test: kms_ccs
results: parsing output: 81/ for test: kms_cursor_crc
results: parsing output: 82/ for test: kms_psr
results: parsing output: 83/ for test: kms_cursor_legacy
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_pm_rpm
results: parsing output: 86/ for test: gem_userptr_blits
results: parsing output: 87/ for test: sw_sync
results: parsing output: 88/ for test: kms_flip
results: parsing output: 89/ for test: gem_exec_fence
results: parsing output: 90/ for test: gem_exec_whisper
results: parsing output: 91/ for test: gem_exec_capture
results: parsing output: 92/ for test: kms_ccs
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_frontbuffer_tracking
results: parsing output: 95/ for test: kms_content_protection
results: parsing output: 96/ for test: gem_mmap_gtt
results: parsing output: 97/ for test: api_intel_bb
results: parsing output: 98/ for test: kms_color
results: parsing output: 99/ for test: kms_hdr
results: parsing output: 100/ for test: kms_async_flips
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: kms_psr
results: parsing output: 103/ for test: syncobj_timeline
results: parsing output: 104/ for test: gem_linear_blits
results: parsing output: 105/ for test: kms_tv_load_detect
results: parsing output: 106/ for test: kms_psr2_sf
results: parsing output: 107/ for test: prime_vgem
results: parsing output: 108/ for test: gem_lmem_swapping
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_plane_lowres
results: parsing output: 111/ for test: kms_psr2_su
results: parsing output: 112/ for test: kms_properties
results: parsing output: 113/ for test: gem_ctx_isolation
results: parsing output: 114/ for test: i915_pm_rpm
results: parsing output: 115/ for test: gem_gpgpu_fill
results: parsing output: 116/ for test: gem_exec_balancer
results: parsing output: 117/ for test: sw_sync
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_flip_scaled_crc
results: parsing output: 120/ for test: kms_big_fb
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: perf
results: parsing output: 123/ for test: i915_query
results: parsing output: 124/ for test: kms_selftest
results: parsing output: 125/ for test: gem_mmap_gtt
results: parsing output: 126/ for test: kms_cursor_legacy
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: gem_exec_nop
results: parsing output: 129/ for test: vgem_basic
results: parsing output: 130/ for test: gem_create
results: parsing output: 131/ for test: kms_cursor_edge_walk
results: parsing output: 132/ for test: kms_busy
Done.