[73.079103] Initializing watchdogs
[73.079217]   /dev/watchdog0
[73.102500] [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)
[73.112677] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[73.116862] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[73.120152] [001/130] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[73.517979] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[73.519451] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[73.964405] [002/130] (959s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[74.340545] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[74.341142] Starting dynamic subtest: AB-VGA1-HDMI-A1
[105.012384] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (30.675s)
[105.013479] Subtest 2x-plain-flip-fb-recreate-interruptible: SUCCESS (30.677s)
[105.639060] [003/130] (928s left) kms_cursor_edge_walk (128x128-top-edge)
[106.012388] Starting subtest: 128x128-top-edge
[106.013096] Starting dynamic subtest: pipe-A-HDMI-A-1
[109.428356] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.416s)
[109.436960] Starting dynamic subtest: pipe-B-HDMI-A-1
[112.758932] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.330s)
[112.759714] Subtest 128x128-top-edge: SUCCESS (6.749s)
[113.301446] [004/130] (920s left) kms_content_protection (dp-mst-lic-type-0)
[113.700964] Starting subtest: dp-mst-lic-type-0
[113.705272] Subtest dp-mst-lic-type-0: SKIP (0.000s)
[114.132727] [005/130] (919s left) kms_joiner (basic-max-non-joiner)
[114.502538] Starting subtest: basic-max-non-joiner
[114.504017] Subtest basic-max-non-joiner: SKIP (0.000s)
[114.932149] [006/130] (918s left) gem_ctx_isolation (preservation-reset)
[115.104741] Starting subtest: preservation-reset
[115.105537] Starting dynamic subtest: rcs0
[115.577785] Dynamic subtest rcs0: SUCCESS (0.473s)
[115.578715] Subtest preservation-reset: SUCCESS (0.475s)
[115.717524] [007/130] (918s left) prime_mmap (test_dup)
[115.772927] Starting subtest: test_dup
[115.773584] Starting dynamic subtest: test_dup-smem
[115.775094] Dynamic subtest test_dup-smem: SUCCESS (0.002s)
[115.775909] Subtest test_dup: SUCCESS (0.002s)
[115.880136] [008/130] (918s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[115.936523] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[115.937287] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.001s)
[116.030397] [009/130] (917s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[116.396835] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[116.397721] Starting dynamic subtest: pipe-A
[116.399758] Dynamic subtest pipe-A: SKIP (0.002s)
[116.409808] Starting dynamic subtest: pipe-B
[116.412108] Dynamic subtest pipe-B: SKIP (0.001s)
[116.413980] Subtest plane-scaler-with-clipping-clamping-modifiers: SKIP (0.003s)
[116.829103] [010/130] (917s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[117.202904] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[117.204438] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[117.642201] [011/130] (916s left) kms_joiner (invalid-modeset-ultra-joiner)
[118.012269] Starting subtest: invalid-modeset-ultra-joiner
[118.013578] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[118.459149] [012/130] (915s left) i915_pm_rc6_residency (media-rc6-accuracy)
[118.518137] Starting subtest: media-rc6-accuracy
[118.520303] Subtest media-rc6-accuracy: SKIP (0.000s)
[118.605724] [013/130] (915s left) kms_pm_rpm (pm-caching)
[130.220958] Subtest pm-caching: SKIP (0.000s)
[130.461931] [014/130] (903s left) kms_addfb_basic (too-high)
[130.823861] Starting subtest: too-high
[130.826143] Subtest too-high: SUCCESS (0.002s)
[131.266697] [015/130] (902s left) gem_eio (context-create)
[131.329722] Starting subtest: context-create
[131.352234] Subtest context-create: SUCCESS (0.023s)
[132.112435] [016/130] (902s left) gem_exec_suspend (basic-s4-devices)
[132.176830] Starting subtest: basic-S4-devices
[132.177701] Starting dynamic subtest: smem
[139.832032] Dynamic subtest smem: SUCCESS (7.655s)
[139.833180] Subtest basic-S4-devices: SUCCESS (7.655s)
[148.040301] [017/130] (894s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[148.443400] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[148.444912] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[148.873101] [018/130] (893s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[149.242426] Starting subtest: cursorB-vs-flipB-atomic
[149.243916] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[149.705631] [019/130] (892s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[150.076892] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[150.296880] [020/130] (892s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-gtt)
[150.668330] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-gtt
[152.074185] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-gtt: SUCCESS (1.405s)
[152.554305] [021/130] (889s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[152.942035] Starting subtest: y-tiled-16bpp-rotate-180
[152.943319] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s)
[153.385955] [022/130] (889s left) sw_sync (sync_busy_fork_unixsocket)
[153.445650] Starting subtest: sync_busy_fork_unixsocket
[153.459891] Subtest sync_busy_fork_unixsocket: SUCCESS (0.014s)
[153.533362] [023/130] (889s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[153.587572] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[153.589352] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[153.679025] [024/130] (888s left) gem_exec_params (invalid-bsd-ring)
[153.733623] Starting subtest: invalid-bsd-ring
[153.734432] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[153.832245] [025/130] (888s left) syncobj_timeline (invalid-wait-illegal-handle)
[153.883988] Starting subtest: invalid-wait-illegal-handle
[153.884826] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[153.978177] [026/130] (888s left) kms_psr (psr2-cursor-plane-onoff)
[154.336470] Subtest psr2-cursor-plane-onoff: SKIP (0.000s)
[154.556328] [027/130] (888s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[154.623765] Starting subtest: y-tiled-ccs-to-y-tiled
[154.624844] Starting dynamic subtest: smem
[154.626568] Dynamic subtest smem: SKIP (0.000s)
[154.627942] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.001s)
[154.828843] [028/130] (888s left) gen9_exec_parse (allowed-all)
[154.890428] Subtest allowed-all: SKIP (0.000s)
[154.938081] [029/130] (887s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[155.311131] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[155.847548] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.535s)
[156.378932] [030/130] (886s left) gem_userptr_blits (stress-purge)
[156.448556] Starting subtest: stress-purge
[161.844585] Subtest stress-purge: SUCCESS (5.395s)
[161.993157] [031/130] (881s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[162.163064] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[162.163763] Starting dynamic subtest: smem
[162.165145] Dynamic subtest smem: SKIP (0.000s)
[162.166486] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.001s)
[162.361455] [032/130] (880s left) core_setmaster (master-drop-set-root)
[162.478342] Starting subtest: master-drop-set-root
[162.483018] Subtest master-drop-set-root: SUCCESS (0.004s)
[162.546325] [033/130] (880s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[162.929136] Starting subtest: psr-farfromfence-mmap-gtt
[162.930417] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[163.367553] [034/130] (879s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[163.740903] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[163.742370] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[164.179803] [035/130] (879s left) kms_psr (psr-primary-mmap-gtt)
[164.544677] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[164.767133] [036/130] (878s left) api_intel_allocator (reopen)
[164.823236] Starting subtest: reopen
[164.830228] Subtest reopen: SUCCESS (0.008s)
[164.960558] [037/130] (878s left) gem_ctx_persistence (idempotent)
[165.023434] Subtest idempotent: SKIP (0.000s)
[165.083588] [038/130] (878s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[165.147456] Starting subtest: multi-wait-for-submit-unsubmitted
[165.249152] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.101s)
[165.340482] [039/130] (878s left) gem_mmap_gtt (medium-copy-odd)
[165.396772] Starting subtest: medium-copy-odd
[166.242917] Subtest medium-copy-odd: SUCCESS (0.846s)
[166.340376] [040/130] (877s left) kms_psr (fbc-psr-sprite-blt)
[166.808298] Subtest fbc-psr-sprite-blt: SKIP (0.000s)
[167.033529] [041/130] (876s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[167.409033] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[167.410209] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[167.852179] [042/130] (875s left) perf (create-destroy-userspace-config)
[168.028737] Subtest create-destroy-userspace-config: SKIP (0.000s)
[168.083641] [043/130] (875s left) gem_exec_reloc (basic-gtt-wc)
[168.140081] Starting subtest: basic-gtt-wc
[168.143706] Subtest basic-gtt-wc: SUCCESS (0.003s)
[168.883177] [044/130] (874s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[169.260237] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[169.261571] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[169.696785] [045/130] (873s left) gem_mmap (basic)
[169.756114] Starting subtest: basic
[169.759753] Subtest basic: SUCCESS (0.000s)
[169.869889] [046/130] (873s left) gem_bad_reloc (negative-reloc-bltcopy)
[169.925981] Starting subtest: negative-reloc-bltcopy
[170.297676] Subtest negative-reloc-bltcopy: SUCCESS (0.369s)
[170.481900] [047/130] (873s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[170.853802] Starting subtest: sprite-rotation-90-pos-100-0
[170.855132] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[171.302847] [048/130] (872s left) perf (sysctl-defaults)
[171.410298] Starting subtest: sysctl-defaults
[171.411071] Subtest sysctl-defaults: SUCCESS (0.000s)
[171.473522] [049/130] (872s left) gem_ctx_persistence (legacy-engines-queued)
[171.527919] Subtest legacy-engines-queued: SKIP (0.000s)
[171.592496] [050/130] (872s left) kms_psr (fbc-pr-sprite-render)
[171.963312] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[172.204632] [051/130] (871s left) gem_exercise_blt (fast-copy)
[172.266034] Subtest fast-copy: SKIP (0.000s)
[172.323245] [052/130] (871s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[172.688921] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[172.690601] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[173.125910] [053/130] (870s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[173.186057] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[173.240940] [054/130] (870s left) gem_mmap_gtt (cpuset-big-copy-xy)
[173.298254] Starting subtest: cpuset-big-copy-XY
[176.490044] Subtest cpuset-big-copy-XY: SUCCESS (3.191s)
[176.614813] [055/130] (867s left) gem_exec_schedule (fifo)
[176.784102] Starting subtest: fifo
[176.785949] Starting dynamic subtest: rcs0
[176.814892] Dynamic subtest rcs0: SUCCESS (0.030s)
[176.827224] Starting dynamic subtest: bcs0
[176.843961] Dynamic subtest bcs0: SUCCESS (0.028s)
[176.844812] Subtest fifo: SUCCESS (0.060s)
[177.093178] [056/130] (867s left) gem_create (create-ext-cpu-access-big)
[177.264476] Starting subtest: create-ext-cpu-access-big
[177.265974] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[177.353346] [057/130] (866s left) kms_plane_multiple (2x-tiling-y)
[177.723313] Starting subtest: 2x-tiling-y
[177.724693] Subtest 2x-tiling-y: SKIP (0.000s)
[178.161263] [058/130] (866s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[178.528802] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[178.530854] Subtest psr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[178.996849] [059/130] (865s left) kms_scaling_modes (scaling-mode-none)
[179.364761] Starting subtest: scaling-mode-none
[179.369976] Subtest scaling-mode-none: SKIP (0.000s)
[179.812654] [060/130] (864s left) gem_pxp (create-protected-buffer)
[182.382814] Starting subtest: create-protected-buffer
[182.384390] Subtest create-protected-buffer: SKIP (0.000s)
[182.480905] [061/130] (861s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[182.533849] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.000s)
[182.580809] [062/130] (861s left) perf_pmu (busy-start)
[182.640111] Starting subtest: busy-start
[182.640922] Starting dynamic subtest: rcs0
[185.154762] Dynamic subtest rcs0: SUCCESS (2.514s)
[185.174825] Starting dynamic subtest: bcs0
[187.677771] Dynamic subtest bcs0: SUCCESS (2.521s)
[187.697396] Starting dynamic subtest: vcs0
[190.687190] Dynamic subtest vcs0: SUCCESS (3.008s)
[190.688103] Subtest busy-start: SUCCESS (8.048s)
[190.801159] [063/130] (853s left) kms_color (legacy-gamma)
[191.171800] Starting subtest: legacy-gamma
[191.172960] Starting dynamic subtest: pipe-A-HDMI-A-1
[191.656890] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.485s)
[191.673844] Starting dynamic subtest: pipe-B-HDMI-A-1
[192.158296] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.497s)
[192.159055] Subtest legacy-gamma: SUCCESS (0.984s)
[192.740141] [064/130] (851s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[193.113978] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[193.115375] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[193.559640] [065/130] (851s left) kms_dp_link_training (uhbr-mst)
[193.925257] Starting subtest: uhbr-mst
[193.926774] Subtest uhbr-mst: SKIP (0.000s)
[194.183518] [066/130] (850s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[194.554611] Subtest psr2-plane-move-sf-dmg-area: SKIP (0.000s)
[194.779682] [067/130] (849s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[194.843771] Starting subtest: y-tiled-to-vebox-y-tiled
[194.845684] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[195.049444] [068/130] (849s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[195.418500] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[197.247497] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (1.828s)
[197.726921] [069/130] (847s left) i915_drm_fdinfo (busy-hang)
[197.787779] Subtest busy-hang: SKIP (0.000s)
[197.837204] [070/130] (847s left) kms_flip (2x-flip-vs-wf_vblank)
[198.198534] Starting subtest: 2x-flip-vs-wf_vblank
[198.199272] Starting dynamic subtest: AB-VGA1-HDMI-A1
[200.883676] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (2.684s)
[200.886482] Subtest 2x-flip-vs-wf_vblank: SUCCESS (2.688s)
[201.518412] [071/130] (843s left) gem_lmem_swapping (basic)
[201.581947] Subtest basic: SKIP (0.000s)
[201.646543] [072/130] (843s left) kms_atomic_transition (plane-all-transition-nonblocking)
[202.013911] Starting subtest: plane-all-transition-nonblocking
[202.015849] Starting dynamic subtest: pipe-A-HDMI-A-1
[203.181893] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.166s)
[203.275799] Starting dynamic subtest: pipe-B-HDMI-A-1
[204.587850] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.323s)
[204.671964] Subtest plane-all-transition-nonblocking: SUCCESS (2.657s)
[205.232327] [073/130] (839s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[205.601200] Starting subtest: cursorA-vs-flipA-atomic
[216.506140] Subtest cursorA-vs-flipA-atomic: SUCCESS (10.906s)
[217.064300] [074/130] (828s left) syncobj_timeline (single-wait-all-available-submitted)
[217.126219] Starting subtest: single-wait-all-available-submitted
[217.127112] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[217.235773] [075/130] (827s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[217.604493] Starting subtest: psr-rgb565-draw-blt
[217.605933] Subtest psr-rgb565-draw-blt: SKIP (0.000s)
[218.043308] [076/130] (827s left) kms_vblank (wait-forked-busy)
[218.408153] Starting subtest: wait-forked-busy
[218.409037] Starting dynamic subtest: pipe-A-HDMI-A-1
[220.820193] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.411s)
[220.834130] Starting dynamic subtest: pipe-B-HDMI-A-1
[223.246225] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.424s)
[223.248384] Subtest wait-forked-busy: SUCCESS (4.841s)
[223.808861] [077/130] (821s left) kms_properties (crtc-properties-atomic)
[224.176355] Starting subtest: crtc-properties-atomic
[224.177184] Starting dynamic subtest: pipe-A-HDMI-A-1
[224.405428] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.228s)
[224.417983] Starting dynamic subtest: pipe-B-HDMI-A-1
[224.721745] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.303s)
[224.722555] Subtest crtc-properties-atomic: SUCCESS (0.535s)
[225.253447] [078/130] (820s left) kms_big_fb (y-tiled-addfb-size-overflow)
[225.620228] Starting subtest: y-tiled-addfb-size-overflow
[225.621524] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s)
[226.062782] [079/130] (819s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[226.117890] Starting subtest: invalid-multi-wait-unsubmitted
[226.118670] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[226.209054] [080/130] (819s left) kms_addfb_basic (master-rmfb)
[226.263805] Starting subtest: master-rmfb
[226.264475] Subtest master-rmfb: SUCCESS (0.001s)
[227.021414] [081/130] (818s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[227.392122] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[227.393492] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[227.834338] [082/130] (817s left) gem_exec_store (pages)
[227.901385] Starting subtest: pages
[227.902367] Starting dynamic subtest: rcs0
[227.958925] Dynamic subtest rcs0: SUCCESS (0.056s)
[227.976338] Starting dynamic subtest: bcs0
[228.006903] Dynamic subtest bcs0: SUCCESS (0.045s)
[228.008423] Subtest pages: SUCCESS (0.106s)
[228.229053] [083/130] (817s left) kms_plane_alpha_blend (constant-alpha-mid)
[228.598402] Starting subtest: constant-alpha-mid
[228.758711] Subtest constant-alpha-mid: SKIP (0.162s)
[229.378678] [084/130] (816s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[229.747400] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[229.748694] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[230.190250] [085/130] (815s left) kms_pm_dc (dc5-dpms-negative)
[241.298115] Subtest dc5-dpms-negative: SKIP (0.000s)
[241.358351] [086/130] (804s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[241.725410] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[241.726788] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[242.157809] [087/130] (803s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[242.521341] Starting subtest: modeset-transition-nonblocking-fencing
[242.522021] Starting dynamic subtest: 1x-outputs
[243.668958] Dynamic subtest 1x-outputs: SUCCESS (1.147s)
[243.723382] Subtest modeset-transition-nonblocking-fencing: SUCCESS (1.203s)
[244.272842] [088/130] (801s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[244.342869] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.000s)
[244.404581] [089/130] (801s left) kms_busy (extended-pageflip-hang-oldfb)
[244.772156] Starting subtest: extended-pageflip-hang-oldfb
[244.772848] Starting dynamic subtest: pipe-A
[244.955849] Dynamic subtest pipe-A: SUCCESS (0.183s)
[244.970935] Starting dynamic subtest: pipe-B
[245.216365] Dynamic subtest pipe-B: SUCCESS (0.256s)
[245.217030] Subtest extended-pageflip-hang-oldfb: SUCCESS (0.446s)
[245.771423] [090/130] (800s left) kms_chamelium_color (ctm-blue-to-red)
[246.142212] Subtest ctm-blue-to-red: SKIP (0.000s)
[246.362703] [091/130] (799s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[246.736040] Starting subtest: yf-tiled-64bpp-rotate-90
[246.737570] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[247.208196] [092/130] (798s left) gem_readwrite (read-write)
[247.266347] Starting subtest: read-write
[247.271976] Subtest read-write: SUCCESS (0.001s)
[247.369568] [093/130] (798s left) gem_exec_create (legacy)
[247.437607] Starting subtest: legacy
[247.438472] Starting dynamic subtest: smem
[249.490228] Dynamic subtest smem: SUCCESS (2.051s)
[249.491549] Subtest legacy: SUCCESS (2.054s)
[249.697782] [094/130] (796s left) kms_async_flips (invalid-async-flip-atomic)
[250.056967] Starting subtest: invalid-async-flip-atomic
[250.058623] Subtest invalid-async-flip-atomic: SKIP (0.000s)
[250.731856] [095/130] (795s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[251.101118] Starting subtest: flip-vs-cursor-crc-legacy
[251.631908] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.532s)
[252.185798] [096/130] (794s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[252.555847] Starting subtest: x-tiled-32bpp-rotate-90
[252.566655] Subtest x-tiled-32bpp-rotate-90: SKIP (0.010s)
[253.012813] [097/130] (793s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[253.383709] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[253.385090] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[253.827797] [098/130] (792s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[254.194941] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[254.196143] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[254.626233] [099/130] (791s left) prime_busy (before)
[254.687583] Starting subtest: before
[254.695237] Starting dynamic subtest: rcs0
[254.699062] Dynamic subtest rcs0: SUCCESS (0.004s)
[254.719271] Starting dynamic subtest: bcs0
[254.720643] Dynamic subtest bcs0: SUCCESS (0.017s)
[254.738667] Starting dynamic subtest: vcs0
[254.739560] Dynamic subtest vcs0: SUCCESS (0.012s)
[254.839944] Subtest before: SUCCESS (0.151s)
[254.940828] [100/130] (791s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[255.311455] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[255.314227] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[255.760834] [101/130] (790s left) gem_mmap_offset (partial-remap)
[255.819380] Starting subtest: partial-remap
[255.820098] Starting dynamic subtest: smem0
[255.826321] Dynamic subtest smem0: SUCCESS (0.006s)
[255.826959] Subtest partial-remap: SUCCESS (0.007s)
[255.941915] [102/130] (790s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[256.304983] Starting subtest: plane-use-after-nonblocking-unbind
[256.307162] Starting dynamic subtest: pipe-A-HDMI-A-1
[256.407866] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.101s)
[256.506197] Starting dynamic subtest: pipe-B-HDMI-A-1
[256.743819] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.250s)
[256.827191] Subtest plane-use-after-nonblocking-unbind: SUCCESS (0.523s)
[257.378789] [103/130] (789s left) syncobj_basic (bad-flags-handle-to-fd)
[257.435192] Starting subtest: bad-flags-handle-to-fd
[257.435864] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[257.527525] [104/130] (789s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[257.580441] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (0.000s)
[257.639697] [105/130] (789s left) dmabuf_sync_file (import-basic)
[257.748984] Starting subtest: import-basic
[257.749889] Subtest import-basic: SUCCESS (0.003s)
[257.830687] [FACT dmabuf_sync_file (import-basic)] new: kernel.kmod_is_loaded.vgem: true
[257.834198] [106/130] (788s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[258.279393] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[258.623778] [107/130] (788s left) gem_render_copy_redux (flink)
[258.690054] Starting subtest: flink
[259.808775] Subtest flink: SUCCESS (1.119s)
[259.947823] [108/130] (786s left) gem_exec_schedule (preempt-contexts)
[260.018225] Subtest preempt-contexts: SKIP (0.000s)
[260.221646] [109/130] (786s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[260.592502] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[260.594630] Starting dynamic subtest: AB-VGA1-HDMI-A1
[263.209471] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (2.614s)
[263.211837] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SUCCESS (2.618s)
[263.829467] [110/130] (783s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[263.888318] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SKIP (0.000s)
[263.958920] [111/130] (783s left) gem_exec_balancer (persistence)
[264.017863] Subtest persistence: SKIP (0.000s)
[264.113791] [112/130] (782s left) i915_pm_rps (thresholds-idle)
[264.175782] Starting subtest: thresholds-idle
[264.176515] Starting dynamic subtest: gt0
[274.497588] Dynamic subtest gt0: SUCCESS (10.320s)
[274.498940] Subtest thresholds-idle: SUCCESS (10.323s)
[274.590810] [113/130] (772s left) gem_exec_params (sol-reset-not-gen7)
[274.645698] Starting subtest: sol-reset-not-gen7
[274.646321] Subtest sol-reset-not-gen7: SUCCESS (0.001s)
[274.772447] [114/130] (772s left) kms_big_fb (linear-16bpp-rotate-180)
[275.149841] Starting subtest: linear-16bpp-rotate-180
[276.484250] Subtest linear-16bpp-rotate-180: SUCCESS (1.333s)
[276.955577] [115/130] (770s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[277.321459] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[277.322806] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[277.772335] [116/130] (769s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[278.139380] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.000s)
[278.376721] [117/130] (768s left) kms_cursor_crc (cursor-random-256x256)
[278.747759] Starting subtest: cursor-random-256x256
[278.749840] Starting dynamic subtest: pipe-A-HDMI-A-1
[282.440817] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.689s)
[282.485272] Starting dynamic subtest: pipe-B-HDMI-A-1
[286.163463] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.693s)
[286.164184] Subtest cursor-random-256x256: SUCCESS (7.416s)
[286.746314] [118/130] (760s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[287.112822] Starting subtest: plane-upscale-20x20-with-pixel-format
[287.113523] Starting dynamic subtest: pipe-A
[287.115524] Dynamic subtest pipe-A: SKIP (0.001s)
[287.129728] Starting dynamic subtest: pipe-B
[287.131647] Dynamic subtest pipe-B: SKIP (0.001s)
[287.132761] Subtest plane-upscale-20x20-with-pixel-format: SKIP (0.005s)
[287.568790] [119/130] (759s left) perf (global-sseu-config)
[287.729776] Subtest global-sseu-config: SKIP (0.000s)
[287.785810] [120/130] (759s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[287.842823] Starting subtest: etime-multi-wait-all-for-submit-submitted
[287.953264] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.109s)
[288.059757] [121/130] (759s left) kms_flip (nonexisting-fb-interruptible)
[288.431575] Starting subtest: nonexisting-fb-interruptible
[288.433970] Starting dynamic subtest: A-VGA1
[288.649689] Dynamic subtest A-VGA1: SUCCESS (0.216s)
[288.665506] Starting dynamic subtest: B-VGA1
[288.834599] Dynamic subtest B-VGA1: SUCCESS (0.181s)
[288.850826] Starting dynamic subtest: A-HDMI-A1
[289.058048] Dynamic subtest A-HDMI-A1: SUCCESS (0.220s)
[289.074885] Starting dynamic subtest: B-HDMI-A1
[289.311420] Dynamic subtest B-HDMI-A1: SUCCESS (0.248s)
[289.312111] Subtest nonexisting-fb-interruptible: SUCCESS (0.880s)
[289.920756] [122/130] (757s left) i915_drm_fdinfo (isolation)
[289.984325] Subtest isolation: SKIP (0.000s)
[290.049267] [123/130] (757s left) gem_exec_await (wide-contexts)
[290.139283] Starting subtest: wide-contexts
[311.890779] Subtest wide-contexts: SUCCESS (21.751s)
[312.115040] [124/130] (735s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[312.270625] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.000s)
[312.329773] [125/130] (735s left) gem_exec_params (invalid-fence-in-submit)
[312.391884] Starting subtest: invalid-fence-in-submit
[312.394049] Subtest invalid-fence-in-submit: SUCCESS (0.001s)
[312.540273] [126/130] (735s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[312.911871] Starting subtest: primary-yf-tiled-reflect-x-90
[312.913668] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s)
[313.349179] [127/130] (734s left) kms_sequence (get-idle)
[313.724778] Starting subtest: get-idle
[313.725466] Starting dynamic subtest: pipe-A-HDMI-A-1
[315.975693] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.249s)
[315.989242] Starting dynamic subtest: pipe-B-HDMI-A-1
[318.235365] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.258s)
[318.235937] Subtest get-idle: SUCCESS (4.511s)
[318.787552] [128/130] (729s left) kms_properties (invalid-properties-atomic)
[319.156929] Starting subtest: invalid-properties-atomic
[319.191642] Subtest invalid-properties-atomic: SUCCESS (0.036s)
[319.639329] [129/130] (728s left) kms_cursor_crc (cursor-sliding-max-size)
[320.018255] Starting subtest: cursor-sliding-max-size
[320.020252] Subtest cursor-sliding-max-size: SKIP (0.000s)
[320.456435] [130/130] (727s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[320.820173] Starting subtest: basic-flip-after-cursor-varying-size
[321.845840] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.026s)
[322.413250] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_flip
results: parsing output: 2/ for test: kms_cursor_edge_walk
results: parsing output: 3/ for test: kms_content_protection
results: parsing output: 4/ for test: kms_joiner
results: parsing output: 5/ for test: gem_ctx_isolation
results: parsing output: 6/ for test: prime_mmap
results: parsing output: 7/ for test: syncobj_wait
results: parsing output: 8/ for test: kms_plane_scaling
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_joiner
results: parsing output: 11/ for test: i915_pm_rc6_residency
results: parsing output: 12/ for test: kms_pm_rpm
results: parsing output: 13/ for test: kms_addfb_basic
results: parsing output: 14/ for test: gem_eio
results: parsing output: 15/ for test: gem_exec_suspend
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_cursor_legacy
results: parsing output: 18/ for test: kms_psr2_sf
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: sw_sync
results: parsing output: 22/ for test: syncobj_timeline
results: parsing output: 23/ for test: gem_exec_params
results: parsing output: 24/ for test: syncobj_timeline
results: parsing output: 25/ for test: kms_psr
results: parsing output: 26/ for test: gem_render_copy
results: parsing output: 27/ for test: gen9_exec_parse
results: parsing output: 28/ for test: kms_big_fb
results: parsing output: 29/ for test: gem_userptr_blits
results: parsing output: 30/ for test: gem_render_copy
results: parsing output: 31/ for test: core_setmaster
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_psr
results: parsing output: 35/ for test: api_intel_allocator
results: parsing output: 36/ for test: gem_ctx_persistence
results: parsing output: 37/ for test: syncobj_wait
results: parsing output: 38/ for test: gem_mmap_gtt
results: parsing output: 39/ for test: kms_psr
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: perf
results: parsing output: 42/ for test: gem_exec_reloc
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: gem_mmap
results: parsing output: 45/ for test: gem_bad_reloc
results: parsing output: 46/ for test: kms_rotation_crc
results: parsing output: 47/ for test: perf
results: parsing output: 48/ for test: gem_ctx_persistence
results: parsing output: 49/ for test: kms_psr
results: parsing output: 50/ for test: gem_exercise_blt
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_ccs
results: parsing output: 53/ for test: gem_mmap_gtt
results: parsing output: 54/ for test: gem_exec_schedule
results: parsing output: 55/ for test: gem_create
results: parsing output: 56/ for test: kms_plane_multiple
results: parsing output: 57/ for test: kms_frontbuffer_tracking
results: parsing output: 58/ for test: kms_scaling_modes
results: parsing output: 59/ for test: gem_pxp
results: parsing output: 60/ for test: kms_ccs
results: parsing output: 61/ for test: perf_pmu
results: parsing output: 62/ for test: kms_color
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_dp_link_training
results: parsing output: 65/ for test: kms_psr2_sf
results: parsing output: 66/ for test: gem_render_copy
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: i915_drm_fdinfo
results: parsing output: 69/ for test: kms_flip
results: parsing output: 70/ for test: gem_lmem_swapping
results: parsing output: 71/ for test: kms_atomic_transition
results: parsing output: 72/ for test: kms_cursor_legacy
results: parsing output: 73/ for test: syncobj_timeline
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_vblank
results: parsing output: 76/ for test: kms_properties
results: parsing output: 77/ for test: kms_big_fb
results: parsing output: 78/ for test: syncobj_timeline
results: parsing output: 79/ for test: kms_addfb_basic
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: gem_exec_store
results: parsing output: 82/ for test: kms_plane_alpha_blend
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_pm_dc
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_atomic_transition
results: parsing output: 87/ for test: kms_ccs
results: parsing output: 88/ for test: kms_busy
results: parsing output: 89/ for test: kms_chamelium_color
results: parsing output: 90/ for test: kms_big_fb
results: parsing output: 91/ for test: gem_readwrite
results: parsing output: 92/ for test: gem_exec_create
results: parsing output: 93/ for test: kms_async_flips
results: parsing output: 94/ for test: kms_cursor_legacy
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: prime_busy
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: gem_mmap_offset
results: parsing output: 101/ for test: kms_atomic_transition
results: parsing output: 102/ for test: syncobj_basic
results: parsing output: 103/ for test: kms_flip_scaled_crc
results: parsing output: 104/ for test: dmabuf_sync_file
results: parsing output: 105/ for test: kms_chamelium_frames
results: parsing output: 106/ for test: gem_render_copy_redux
results: parsing output: 107/ for test: gem_exec_schedule
results: parsing output: 108/ for test: kms_flip
results: parsing output: 109/ for test: kms_flip_scaled_crc
results: parsing output: 110/ for test: gem_exec_balancer
results: parsing output: 111/ for test: i915_pm_rps
results: parsing output: 112/ for test: gem_exec_params
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_psr
results: parsing output: 116/ for test: kms_cursor_crc
results: parsing output: 117/ for test: kms_plane_scaling
results: parsing output: 118/ for test: perf
results: parsing output: 119/ for test: syncobj_timeline
results: parsing output: 120/ for test: kms_flip
results: parsing output: 121/ for test: i915_drm_fdinfo
results: parsing output: 122/ for test: gem_exec_await
results: parsing output: 123/ for test: kms_ccs
results: parsing output: 124/ for test: gem_exec_params
results: parsing output: 125/ for test: kms_rotation_crc
results: parsing output: 126/ for test: kms_sequence
results: parsing output: 127/ for test: kms_properties
results: parsing output: 128/ for test: kms_cursor_crc
results: parsing output: 129/ for test: kms_cursor_legacy
Done.