[70.539827] Initializing watchdogs
[70.539975]   /dev/watchdog0
[70.561233] [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)
[70.569185] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[70.573189] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[70.576227] [001/130] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[70.969106] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[70.971945] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[71.404312] [002/130] (959s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[71.776170] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[71.777769] Starting dynamic subtest: AB-VGA1-HDMI-A1
[102.450350] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (30.674s)
[102.451440] Subtest 2x-plain-flip-fb-recreate-interruptible: SUCCESS (30.677s)
[103.084726] [003/130] (928s left) kms_cursor_edge_walk (128x128-top-edge)
[103.458257] Starting subtest: 128x128-top-edge
[103.458907] Starting dynamic subtest: pipe-A-HDMI-A-1
[106.888086] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.430s)
[106.896386] Starting dynamic subtest: pipe-B-HDMI-A-1
[110.219599] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.330s)
[110.220531] Subtest 128x128-top-edge: SUCCESS (6.762s)
[110.753914] [004/130] (920s left) kms_content_protection (dp-mst-lic-type-0)
[111.133735] Starting subtest: dp-mst-lic-type-0
[111.135011] Subtest dp-mst-lic-type-0: SKIP (0.000s)
[111.568617] [005/130] (919s left) kms_joiner (basic-max-non-joiner)
[111.937467] Starting subtest: basic-max-non-joiner
[111.938983] Subtest basic-max-non-joiner: SKIP (0.000s)
[112.370146] [006/130] (918s left) gem_ctx_isolation (preservation-reset)
[112.542792] Starting subtest: preservation-reset
[112.543728] Starting dynamic subtest: rcs0
[112.982461] Dynamic subtest rcs0: SUCCESS (0.439s)
[112.983437] Subtest preservation-reset: SUCCESS (0.442s)
[113.117966] [007/130] (918s left) prime_mmap (test_dup)
[113.176889] Starting subtest: test_dup
[113.177646] Starting dynamic subtest: test_dup-smem
[113.180109] Dynamic subtest test_dup-smem: SUCCESS (0.004s)
[113.180842] Subtest test_dup: SUCCESS (0.004s)
[113.284700] [008/130] (918s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[113.339605] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[113.340260] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.001s)
[113.433127] [009/130] (917s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[113.792790] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[113.793663] Starting dynamic subtest: pipe-A
[113.795736] Dynamic subtest pipe-A: SKIP (0.001s)
[113.806614] Starting dynamic subtest: pipe-B
[113.808865] Dynamic subtest pipe-B: SKIP (0.001s)
[113.810609] Subtest plane-scaler-with-clipping-clamping-modifiers: SKIP (0.003s)
[114.231876] [010/130] (917s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[114.595707] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[114.597198] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[115.033165] [011/130] (916s left) kms_joiner (invalid-modeset-ultra-joiner)
[115.390562] Starting subtest: invalid-modeset-ultra-joiner
[115.391999] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[115.828926] [012/130] (915s left) i915_pm_rc6_residency (media-rc6-accuracy)
[115.884527] Starting subtest: media-rc6-accuracy
[115.886082] Subtest media-rc6-accuracy: SKIP (0.000s)
[115.980732] [013/130] (915s left) kms_pm_rpm (pm-caching)
[127.580227] Subtest pm-caching: SKIP (0.000s)
[127.796177] [014/130] (903s left) kms_addfb_basic (too-high)
[128.155022] Starting subtest: too-high
[128.156965] Subtest too-high: SUCCESS (0.001s)
[128.587602] [015/130] (903s left) gem_eio (context-create)
[128.653042] Starting subtest: context-create
[128.677874] Subtest context-create: SUCCESS (0.025s)
[129.419333] [016/130] (902s left) gem_exec_suspend (basic-s4-devices)
[129.489456] Starting subtest: basic-S4-devices
[129.490353] Starting dynamic subtest: smem
[137.113477] Dynamic subtest smem: SUCCESS (7.624s)
[137.114727] Subtest basic-S4-devices: SUCCESS (7.624s)
[143.319379] [017/130] (894s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[143.704271] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[143.705737] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[144.133050] [018/130] (893s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[144.505928] Starting subtest: cursorB-vs-flipB-atomic
[144.507413] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[144.950810] [019/130] (892s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[145.316723] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[145.540954] [020/130] (892s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-gtt)
[145.901254] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-gtt
[147.317779] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-gtt: SUCCESS (1.416s)
[147.776239] [021/130] (890s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[148.153491] Starting subtest: y-tiled-16bpp-rotate-180
[148.155515] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s)
[148.591475] [022/130] (889s left) sw_sync (sync_busy_fork_unixsocket)
[148.646949] Starting subtest: sync_busy_fork_unixsocket
[148.663277] Subtest sync_busy_fork_unixsocket: SUCCESS (0.014s)
[148.739331] [023/130] (889s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[148.793414] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[148.795180] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[148.892482] [024/130] (889s left) gem_exec_params (invalid-bsd-ring)
[148.946923] Starting subtest: invalid-bsd-ring
[148.947909] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[149.062276] [025/130] (889s left) syncobj_timeline (invalid-wait-illegal-handle)
[149.119926] Starting subtest: invalid-wait-illegal-handle
[149.120663] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[149.207311] [026/130] (889s left) kms_psr (psr2-cursor-plane-onoff)
[149.564692] Subtest psr2-cursor-plane-onoff: SKIP (0.000s)
[149.785362] [027/130] (888s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[149.846628] Starting subtest: y-tiled-ccs-to-y-tiled
[149.847601] Starting dynamic subtest: smem
[149.849247] Dynamic subtest smem: SKIP (0.000s)
[149.850575] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.001s)
[150.044078] [028/130] (888s left) gen9_exec_parse (allowed-all)
[150.107221] Subtest allowed-all: SKIP (0.000s)
[150.164424] [029/130] (888s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[150.534546] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[151.075095] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.539s)
[151.587515] [030/130] (886s left) gem_userptr_blits (stress-purge)
[151.667443] Starting subtest: stress-purge
[157.058945] Subtest stress-purge: SUCCESS (5.391s)
[157.189223] [031/130] (881s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[157.364820] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[157.365549] Starting dynamic subtest: smem
[157.367292] Dynamic subtest smem: SKIP (0.000s)
[157.369095] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.001s)
[157.557280] [032/130] (880s left) core_setmaster (master-drop-set-root)
[157.656860] Starting subtest: master-drop-set-root
[157.660659] Subtest master-drop-set-root: SUCCESS (0.004s)
[157.729955] [033/130] (880s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[158.109621] Starting subtest: psr-farfromfence-mmap-gtt
[158.110997] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[158.537674] [034/130] (880s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[158.903290] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[158.904908] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[159.336202] [035/130] (879s left) kms_psr (psr-primary-mmap-gtt)
[159.703765] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[159.930752] [036/130] (878s left) api_intel_allocator (reopen)
[159.989175] Starting subtest: reopen
[159.995398] Subtest reopen: SUCCESS (0.006s)
[160.117292] [037/130] (878s left) gem_ctx_persistence (idempotent)
[160.175752] Subtest idempotent: SKIP (0.000s)
[160.229423] [038/130] (878s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[160.290935] Starting subtest: multi-wait-for-submit-unsubmitted
[160.393252] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.101s)
[160.487018] [039/130] (878s left) gem_mmap_gtt (medium-copy-odd)
[160.541962] Starting subtest: medium-copy-odd
[161.370974] Subtest medium-copy-odd: SUCCESS (0.829s)
[161.468876] [040/130] (877s left) kms_psr (fbc-psr-sprite-blt)
[161.941848] Subtest fbc-psr-sprite-blt: SKIP (0.000s)
[162.179476] [041/130] (876s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[162.553141] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[162.554415] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[162.993835] [042/130] (875s left) perf (create-destroy-userspace-config)
[163.172711] Subtest create-destroy-userspace-config: SKIP (0.000s)
[163.221543] [043/130] (875s left) gem_exec_reloc (basic-gtt-wc)
[163.277918] Starting subtest: basic-gtt-wc
[163.282125] Subtest basic-gtt-wc: SUCCESS (0.004s)
[164.026851] [044/130] (875s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[164.397560] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[164.398994] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[164.826705] [045/130] (874s left) gem_mmap (basic)
[164.887602] Starting subtest: basic
[164.892027] Subtest basic: SUCCESS (0.001s)
[164.996600] [046/130] (874s left) gem_bad_reloc (negative-reloc-bltcopy)
[165.056162] Starting subtest: negative-reloc-bltcopy
[165.434834] Subtest negative-reloc-bltcopy: SUCCESS (0.378s)
[165.612223] [047/130] (873s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[165.971272] Starting subtest: sprite-rotation-90-pos-100-0
[165.974955] Subtest sprite-rotation-90-pos-100-0: SKIP (0.002s)
[166.405865] [048/130] (872s left) perf (sysctl-defaults)
[166.506105] Starting subtest: sysctl-defaults
[166.506777] Subtest sysctl-defaults: SUCCESS (0.000s)
[166.567621] [049/130] (872s left) gem_ctx_persistence (legacy-engines-queued)
[166.627925] Subtest legacy-engines-queued: SKIP (0.000s)
[166.684448] [050/130] (872s left) kms_psr (fbc-pr-sprite-render)
[167.040460] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[167.266493] [051/130] (872s left) gem_exercise_blt (fast-copy)
[167.326954] Subtest fast-copy: SKIP (0.000s)
[167.381118] [052/130] (872s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[167.742328] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[167.743854] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[168.172927] [053/130] (871s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[168.237675] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[168.295873] [054/130] (871s left) gem_mmap_gtt (cpuset-big-copy-xy)
[168.350153] Starting subtest: cpuset-big-copy-XY
[171.496943] Subtest cpuset-big-copy-XY: SUCCESS (3.146s)
[171.699821] [055/130] (867s left) gem_exec_schedule (fifo)
[171.882021] Starting subtest: fifo
[171.882991] Starting dynamic subtest: rcs0
[171.913296] Dynamic subtest rcs0: SUCCESS (0.031s)
[171.926546] Starting dynamic subtest: bcs0
[171.942325] Dynamic subtest bcs0: SUCCESS (0.028s)
[171.943164] Subtest fifo: SUCCESS (0.061s)
[172.182744] [056/130] (867s left) gem_create (create-ext-cpu-access-big)
[172.355156] Starting subtest: create-ext-cpu-access-big
[172.357017] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[172.450265] [057/130] (867s left) kms_plane_multiple (2x-tiling-y)
[172.827476] Starting subtest: 2x-tiling-y
[172.828953] Subtest 2x-tiling-y: SKIP (0.000s)
[173.262463] [058/130] (866s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[173.626559] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[173.627896] Subtest psr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[174.058337] [059/130] (865s left) kms_scaling_modes (scaling-mode-none)
[174.430956] Starting subtest: scaling-mode-none
[174.433808] Subtest scaling-mode-none: SKIP (0.000s)
[174.856775] [060/130] (864s left) gem_pxp (create-protected-buffer)
[177.435368] Starting subtest: create-protected-buffer
[177.437236] Subtest create-protected-buffer: SKIP (0.000s)
[177.534980] [061/130] (862s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[177.592823] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.000s)
[177.644857] [062/130] (862s left) perf_pmu (busy-start)
[177.702467] Starting subtest: busy-start
[177.703254] Starting dynamic subtest: rcs0
[180.220680] Dynamic subtest rcs0: SUCCESS (2.517s)
[180.235798] Starting dynamic subtest: bcs0
[182.739583] Dynamic subtest bcs0: SUCCESS (2.517s)
[182.755843] Starting dynamic subtest: vcs0
[185.757430] Dynamic subtest vcs0: SUCCESS (3.016s)
[185.758829] Subtest busy-start: SUCCESS (8.056s)
[185.849419] [063/130] (854s left) kms_color (legacy-gamma)
[186.212168] Starting subtest: legacy-gamma
[186.212970] Starting dynamic subtest: pipe-A-HDMI-A-1
[186.701121] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.489s)
[186.713962] Starting dynamic subtest: pipe-B-HDMI-A-1
[187.197251] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.494s)
[187.198920] Subtest legacy-gamma: SUCCESS (0.986s)
[187.776526] [064/130] (852s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[188.141983] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[188.143202] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[188.576514] [065/130] (851s left) kms_dp_link_training (uhbr-mst)
[188.943373] Starting subtest: uhbr-mst
[188.944637] Subtest uhbr-mst: SKIP (0.000s)
[189.206352] [066/130] (850s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[189.570021] Subtest psr2-plane-move-sf-dmg-area: SKIP (0.000s)
[189.799417] [067/130] (850s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[189.865694] Starting subtest: y-tiled-to-vebox-y-tiled
[189.867841] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[190.071264] [068/130] (850s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[190.436234] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[192.269524] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (1.832s)
[192.734651] [069/130] (847s left) i915_drm_fdinfo (busy-hang)
[192.798973] Subtest busy-hang: SKIP (0.000s)
[192.859856] [070/130] (847s left) kms_flip (2x-flip-vs-wf_vblank)
[193.216385] Starting subtest: 2x-flip-vs-wf_vblank
[193.217058] Starting dynamic subtest: AB-VGA1-HDMI-A1
[195.906958] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (2.689s)
[195.910726] Subtest 2x-flip-vs-wf_vblank: SUCCESS (2.694s)
[196.559988] [071/130] (843s left) gem_lmem_swapping (basic)
[196.625402] Subtest basic: SKIP (0.000s)
[196.683482] [072/130] (843s left) kms_atomic_transition (plane-all-transition-nonblocking)
[197.042577] Starting subtest: plane-all-transition-nonblocking
[197.043295] Starting dynamic subtest: pipe-A-HDMI-A-1
[198.204281] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.160s)
[198.318219] Starting dynamic subtest: pipe-B-HDMI-A-1
[199.669693] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.362s)
[199.750517] Subtest plane-all-transition-nonblocking: SUCCESS (2.710s)
[200.297157] [073/130] (840s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[200.657394] Starting subtest: cursorA-vs-flipA-atomic
[211.554090] Subtest cursorA-vs-flipA-atomic: SUCCESS (10.898s)
[212.099333] [074/130] (828s left) syncobj_timeline (single-wait-all-available-submitted)
[212.157974] Starting subtest: single-wait-all-available-submitted
[212.158859] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[212.261696] [075/130] (828s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[212.620031] Starting subtest: psr-rgb565-draw-blt
[212.621395] Subtest psr-rgb565-draw-blt: SKIP (0.000s)
[213.058235] [076/130] (827s left) kms_vblank (wait-forked-busy)
[213.421651] Starting subtest: wait-forked-busy
[213.422510] Starting dynamic subtest: pipe-A-HDMI-A-1
[215.810442] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.387s)
[215.833342] Starting dynamic subtest: pipe-B-HDMI-A-1
[218.261405] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.449s)
[218.262057] Subtest wait-forked-busy: SUCCESS (4.842s)
[218.826458] [077/130] (821s left) kms_properties (crtc-properties-atomic)
[219.188115] Starting subtest: crtc-properties-atomic
[219.188822] Starting dynamic subtest: pipe-A-HDMI-A-1
[219.424735] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.235s)
[219.438479] Starting dynamic subtest: pipe-B-HDMI-A-1
[219.729371] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.303s)
[219.730027] Subtest crtc-properties-atomic: SUCCESS (0.544s)
[220.282324] [078/130] (820s left) kms_big_fb (y-tiled-addfb-size-overflow)
[220.650652] Starting subtest: y-tiled-addfb-size-overflow
[220.652016] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s)
[221.098876] [079/130] (819s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[221.158204] Starting subtest: invalid-multi-wait-unsubmitted
[221.158893] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[221.259602] [080/130] (819s left) kms_addfb_basic (master-rmfb)
[221.315382] Starting subtest: master-rmfb
[221.316039] Subtest master-rmfb: SUCCESS (0.001s)
[222.051475] [081/130] (818s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[222.409152] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[222.410385] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[222.855796] [082/130] (818s left) gem_exec_store (pages)
[222.928109] Starting subtest: pages
[222.929411] Starting dynamic subtest: rcs0
[222.994115] Dynamic subtest rcs0: SUCCESS (0.065s)
[223.010758] Starting dynamic subtest: bcs0
[223.037626] Dynamic subtest bcs0: SUCCESS (0.041s)
[223.038941] Subtest pages: SUCCESS (0.110s)
[223.234134] [083/130] (817s left) kms_plane_alpha_blend (constant-alpha-mid)
[223.593365] Starting subtest: constant-alpha-mid
[223.749956] Subtest constant-alpha-mid: SKIP (0.158s)
[224.366641] [084/130] (816s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[224.729474] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[224.730666] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[225.162803] [085/130] (815s left) kms_pm_dc (dc5-dpms-negative)
[236.266427] Subtest dc5-dpms-negative: SKIP (0.000s)
[236.332056] [086/130] (804s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[236.696320] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[236.697955] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[237.142304] [087/130] (804s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[237.500565] Starting subtest: modeset-transition-nonblocking-fencing
[237.501315] Starting dynamic subtest: 1x-outputs
[238.655724] Dynamic subtest 1x-outputs: SUCCESS (1.155s)
[238.696365] Subtest modeset-transition-nonblocking-fencing: SUCCESS (1.197s)
[239.237964] [088/130] (802s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[239.298867] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.000s)
[239.352759] [089/130] (801s left) kms_busy (extended-pageflip-hang-oldfb)
[239.709025] Starting subtest: extended-pageflip-hang-oldfb
[239.709848] Starting dynamic subtest: pipe-A
[239.890338] Dynamic subtest pipe-A: SUCCESS (0.180s)
[239.904495] Starting dynamic subtest: pipe-B
[240.159156] Dynamic subtest pipe-B: SUCCESS (0.266s)
[240.160992] Subtest extended-pageflip-hang-oldfb: SUCCESS (0.453s)
[240.730693] [090/130] (800s left) kms_chamelium_color (ctm-blue-to-red)
[241.089350] Subtest ctm-blue-to-red: SKIP (0.000s)
[241.324756] [091/130] (800s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[241.687353] Starting subtest: yf-tiled-64bpp-rotate-90
[241.688864] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[242.131911] [092/130] (799s left) gem_readwrite (read-write)
[242.192114] Starting subtest: read-write
[242.195043] Subtest read-write: SUCCESS (0.000s)
[242.301184] [093/130] (799s left) gem_exec_create (legacy)
[242.365207] Starting subtest: legacy
[242.366121] Starting dynamic subtest: smem
[244.416115] Dynamic subtest smem: SUCCESS (2.048s)
[244.417481] Subtest legacy: SUCCESS (2.050s)
[244.633893] [094/130] (796s left) kms_async_flips (invalid-async-flip-atomic)
[244.997558] Starting subtest: invalid-async-flip-atomic
[244.999395] Subtest invalid-async-flip-atomic: SKIP (0.000s)
[245.691508] [095/130] (795s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[246.045115] Starting subtest: flip-vs-cursor-crc-legacy
[246.572605] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.527s)
[247.107823] [096/130] (794s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[247.478831] Starting subtest: x-tiled-32bpp-rotate-90
[247.487682] Subtest x-tiled-32bpp-rotate-90: SKIP (0.009s)
[247.932751] [097/130] (793s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[248.293075] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[248.294505] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[248.730942] [098/130] (793s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[249.089799] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[249.091091] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[249.533533] [099/130] (792s left) prime_busy (before)
[249.592670] Starting subtest: before
[249.600326] Starting dynamic subtest: rcs0
[249.616801] Dynamic subtest rcs0: SUCCESS (0.016s)
[249.633658] Starting dynamic subtest: bcs0
[249.636355] Dynamic subtest bcs0: SUCCESS (0.015s)
[249.656068] Starting dynamic subtest: vcs0
[249.657447] Dynamic subtest vcs0: SUCCESS (0.012s)
[249.756683] Subtest before: SUCCESS (0.163s)
[249.852544] [100/130] (792s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[250.210073] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[250.211564] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[250.646657] [101/130] (791s left) gem_mmap_offset (partial-remap)
[250.705789] Starting subtest: partial-remap
[250.706383] Starting dynamic subtest: smem0
[250.711082] Dynamic subtest smem0: SUCCESS (0.004s)
[250.711901] Subtest partial-remap: SUCCESS (0.006s)
[250.828703] [102/130] (791s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[251.189308] Starting subtest: plane-use-after-nonblocking-unbind
[251.190237] Starting dynamic subtest: pipe-A-HDMI-A-1
[251.295912] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.106s)
[251.407723] Starting dynamic subtest: pipe-B-HDMI-A-1
[251.651778] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.270s)
[251.735578] Subtest plane-use-after-nonblocking-unbind: SUCCESS (0.546s)
[252.292774] [103/130] (789s left) syncobj_basic (bad-flags-handle-to-fd)
[252.352262] Starting subtest: bad-flags-handle-to-fd
[252.352991] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[252.442846] [104/130] (789s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[252.497096] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (0.000s)
[252.563200] [105/130] (789s left) dmabuf_sync_file (import-basic)
[252.684160] Starting subtest: import-basic
[252.684869] Subtest import-basic: SUCCESS (0.003s)
[252.768880] [FACT dmabuf_sync_file (import-basic)] new: kernel.kmod_is_loaded.vgem: true
[252.771876] [106/130] (789s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[253.200752] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[253.551732] [107/130] (788s left) gem_render_copy_redux (flink)
[253.614208] Starting subtest: flink
[254.713452] Subtest flink: SUCCESS (1.099s)
[254.843644] [108/130] (787s left) gem_exec_schedule (preempt-contexts)
[254.909317] Subtest preempt-contexts: SKIP (0.000s)
[255.118569] [109/130] (787s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[255.476893] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[255.478933] Starting dynamic subtest: AB-VGA1-HDMI-A1
[258.101159] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (2.622s)
[258.106236] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SUCCESS (2.626s)
[258.738815] [110/130] (783s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[258.799169] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SKIP (0.000s)
[258.874654] [111/130] (783s left) gem_exec_balancer (persistence)
[258.936770] Subtest persistence: SKIP (0.000s)
[259.037888] [112/130] (783s left) i915_pm_rps (thresholds-idle)
[259.104857] Starting subtest: thresholds-idle
[259.105655] Starting dynamic subtest: gt0
[269.414220] Dynamic subtest gt0: SUCCESS (10.308s)
[269.417213] Subtest thresholds-idle: SUCCESS (10.311s)
[269.514544] [113/130] (773s left) gem_exec_params (sol-reset-not-gen7)
[269.576930] Starting subtest: sol-reset-not-gen7
[269.577894] Subtest sol-reset-not-gen7: SUCCESS (0.001s)
[269.696452] [114/130] (772s left) kms_big_fb (linear-16bpp-rotate-180)
[270.061081] Starting subtest: linear-16bpp-rotate-180
[271.393237] Subtest linear-16bpp-rotate-180: SUCCESS (1.333s)
[271.867341] [115/130] (770s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[272.232508] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[272.234056] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[272.678312] [116/130] (770s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[273.033724] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.000s)
[273.265809] [117/130] (769s left) kms_cursor_crc (cursor-random-256x256)
[273.634383] Starting subtest: cursor-random-256x256
[273.636485] Starting dynamic subtest: pipe-A-HDMI-A-1
[277.314558] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.677s)
[277.360964] Starting dynamic subtest: pipe-B-HDMI-A-1
[281.035679] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.690s)
[281.036489] Subtest cursor-random-256x256: SUCCESS (7.402s)
[281.615216] [118/130] (761s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[281.972660] Starting subtest: plane-upscale-20x20-with-pixel-format
[281.973416] Starting dynamic subtest: pipe-A
[281.975607] Dynamic subtest pipe-A: SKIP (0.001s)
[281.991373] Starting dynamic subtest: pipe-B
[281.994368] Dynamic subtest pipe-B: SKIP (0.001s)
[281.996061] Subtest plane-upscale-20x20-with-pixel-format: SKIP (0.005s)
[282.418586] [119/130] (760s left) perf (global-sseu-config)
[282.584230] Subtest global-sseu-config: SKIP (0.000s)
[282.647873] [120/130] (760s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[282.703864] Starting subtest: etime-multi-wait-all-for-submit-submitted
[282.809122] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.106s)
[282.923823] [121/130] (760s left) kms_flip (nonexisting-fb-interruptible)
[283.287906] Starting subtest: nonexisting-fb-interruptible
[283.289980] Starting dynamic subtest: A-VGA1
[283.505549] Dynamic subtest A-VGA1: SUCCESS (0.216s)
[283.521593] Starting dynamic subtest: B-VGA1
[283.682484] Dynamic subtest B-VGA1: SUCCESS (0.173s)
[283.700614] Starting dynamic subtest: A-HDMI-A1
[283.917919] Dynamic subtest A-HDMI-A1: SUCCESS (0.232s)
[283.934631] Starting dynamic subtest: B-HDMI-A1
[284.171069] Dynamic subtest B-HDMI-A1: SUCCESS (0.248s)
[284.171854] Subtest nonexisting-fb-interruptible: SUCCESS (0.882s)
[284.791469] [122/130] (758s left) i915_drm_fdinfo (isolation)
[284.851325] Subtest isolation: SKIP (0.000s)
[284.920589] [123/130] (758s left) gem_exec_await (wide-contexts)
[285.006837] Starting subtest: wide-contexts
[306.738675] Subtest wide-contexts: SUCCESS (21.732s)
[306.974423] [124/130] (736s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[307.133286] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.000s)
[307.191561] [125/130] (736s left) gem_exec_params (invalid-fence-in-submit)
[307.253111] Starting subtest: invalid-fence-in-submit
[307.255890] Subtest invalid-fence-in-submit: SUCCESS (0.002s)
[307.378676] [126/130] (735s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[307.747232] Starting subtest: primary-yf-tiled-reflect-x-90
[307.749107] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s)
[308.199359] [127/130] (735s left) kms_sequence (get-idle)
[308.567229] Starting subtest: get-idle
[308.567861] Starting dynamic subtest: pipe-A-HDMI-A-1
[310.820879] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.252s)
[310.835712] Starting dynamic subtest: pipe-B-HDMI-A-1
[313.078703] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.256s)
[313.079425] Subtest get-idle: SUCCESS (4.514s)
[313.637674] [128/130] (729s left) kms_properties (invalid-properties-atomic)
[313.999141] Starting subtest: invalid-properties-atomic
[314.033596] Subtest invalid-properties-atomic: SUCCESS (0.037s)
[314.484617] [129/130] (729s left) kms_cursor_crc (cursor-sliding-max-size)
[314.850798] Starting subtest: cursor-sliding-max-size
[314.853538] Subtest cursor-sliding-max-size: SKIP (0.000s)
[315.297866] [130/130] (728s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[315.663604] Starting subtest: basic-flip-after-cursor-varying-size
[316.693927] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.030s)
[317.261563] 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.