[68.825752] Initializing watchdogs
[68.825878]   /dev/watchdog0
[68.845832] [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)
[68.853293] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[68.857106] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[68.861796] [001/130] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[69.268142] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[69.271719] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[69.701116] [002/130] (959s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[70.075684] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[70.077296] Starting dynamic subtest: AB-VGA1-HDMI-A1
[100.735404] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (30.662s)
[100.737453] Subtest 2x-plain-flip-fb-recreate-interruptible: SUCCESS (30.664s)
[101.408548] [003/130] (928s left) kms_cursor_edge_walk (128x128-top-edge)
[101.772881] Starting subtest: 128x128-top-edge
[101.774804] Starting dynamic subtest: pipe-A-HDMI-A-1
[105.199360] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.425s)
[105.209228] Starting dynamic subtest: pipe-B-HDMI-A-1
[108.533237] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.331s)
[108.534985] Subtest 128x128-top-edge: SUCCESS (6.759s)
[109.073109] [004/130] (920s left) kms_content_protection (dp-mst-lic-type-0)
[109.456760] Starting subtest: dp-mst-lic-type-0
[109.460293] Subtest dp-mst-lic-type-0: SKIP (0.000s)
[109.893997] [005/130] (919s left) kms_joiner (basic-max-non-joiner)
[110.263266] Starting subtest: basic-max-non-joiner
[110.266457] Subtest basic-max-non-joiner: SKIP (0.000s)
[110.707992] [006/130] (918s left) gem_ctx_isolation (preservation-reset)
[110.886738] Starting subtest: preservation-reset
[110.888387] Starting dynamic subtest: rcs0
[111.408865] Dynamic subtest rcs0: SUCCESS (0.522s)
[111.410634] Subtest preservation-reset: SUCCESS (0.523s)
[111.536528] [007/130] (918s left) prime_mmap (test_dup)
[111.596715] Starting subtest: test_dup
[111.598442] Starting dynamic subtest: test_dup-smem
[111.600296] Dynamic subtest test_dup-smem: SUCCESS (0.002s)
[111.601937] Subtest test_dup: SUCCESS (0.002s)
[111.711296] [008/130] (917s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[111.767856] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[111.769699] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[111.852519] [009/130] (917s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[112.219603] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[112.221307] Starting dynamic subtest: pipe-A
[112.227123] Dynamic subtest pipe-A: SKIP (0.001s)
[112.242900] Starting dynamic subtest: pipe-B
[112.248859] Dynamic subtest pipe-B: SKIP (0.001s)
[112.252746] Subtest plane-scaler-with-clipping-clamping-modifiers: SKIP (0.003s)
[112.649375] [010/130] (917s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[113.024771] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[113.028098] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[113.486074] [011/130] (916s left) kms_joiner (invalid-modeset-ultra-joiner)
[113.848307] Starting subtest: invalid-modeset-ultra-joiner
[113.852235] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[114.298741] [012/130] (915s left) i915_pm_rc6_residency (media-rc6-accuracy)
[114.355671] Starting subtest: media-rc6-accuracy
[114.359075] Subtest media-rc6-accuracy: SKIP (0.000s)
[114.449834] [013/130] (915s left) kms_pm_rpm (pm-caching)
[126.064177] Subtest pm-caching: SKIP (0.000s)
[126.287589] [014/130] (903s left) kms_addfb_basic (too-high)
[126.653906] Starting subtest: too-high
[126.655737] Subtest too-high: SUCCESS (0.001s)
[127.091879] [015/130] (902s left) gem_eio (context-create)
[127.160552] Starting subtest: context-create
[127.182722] Subtest context-create: SUCCESS (0.022s)
[127.942466] [016/130] (902s left) gem_exec_suspend (basic-s4-devices)
[128.012432] Starting subtest: basic-S4-devices
[128.014378] Starting dynamic subtest: smem
[135.960682] Dynamic subtest smem: SUCCESS (7.947s)
[135.963196] Subtest basic-S4-devices: SUCCESS (7.948s)
[143.174526] [017/130] (893s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[143.556065] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[143.560137] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[144.012339] [018/130] (893s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[144.379810] Starting subtest: cursorB-vs-flipB-atomic
[144.383271] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[144.828255] [019/130] (892s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[145.207809] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[145.438605] [020/130] (891s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-gtt)
[145.808995] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-gtt
[147.210688] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-gtt: SUCCESS (1.405s)
[147.694493] [021/130] (889s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[148.073794] Starting subtest: y-tiled-16bpp-rotate-180
[148.077312] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s)
[148.518789] [022/130] (888s left) sw_sync (sync_busy_fork_unixsocket)
[148.576898] Starting subtest: sync_busy_fork_unixsocket
[148.591246] Subtest sync_busy_fork_unixsocket: SUCCESS (0.014s)
[148.672574] [023/130] (888s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[148.731701] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[148.733317] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[148.821392] [024/130] (888s left) gem_exec_params (invalid-bsd-ring)
[148.881352] Starting subtest: invalid-bsd-ring
[148.883083] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[148.986821] [025/130] (888s left) syncobj_timeline (invalid-wait-illegal-handle)
[149.045856] Starting subtest: invalid-wait-illegal-handle
[149.047664] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[149.142595] [026/130] (888s left) kms_psr (psr2-cursor-plane-onoff)
[149.512266] Subtest psr2-cursor-plane-onoff: SKIP (0.000s)
[149.748191] [027/130] (887s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[149.817424] Starting subtest: y-tiled-ccs-to-y-tiled
[149.819425] Starting dynamic subtest: smem
[149.822701] Dynamic subtest smem: SKIP (0.000s)
[149.826361] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.001s)
[150.013300] [028/130] (887s left) gen9_exec_parse (allowed-all)
[150.077481] Subtest allowed-all: SKIP (0.000s)
[150.131807] [029/130] (887s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[150.512128] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[151.050959] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.538s)
[151.581186] [030/130] (886s left) gem_userptr_blits (stress-purge)
[151.655215] Starting subtest: stress-purge
[157.036434] Subtest stress-purge: SUCCESS (5.381s)
[157.176920] [031/130] (880s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[157.314433] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[157.316071] Starting dynamic subtest: smem
[157.319756] Dynamic subtest smem: SKIP (0.000s)
[157.323906] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.001s)
[157.524132] [032/130] (880s left) core_setmaster (master-drop-set-root)
[157.634188] Starting subtest: master-drop-set-root
[157.637775] Subtest master-drop-set-root: SUCCESS (0.002s)
[157.705257] [033/130] (880s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[158.082345] Starting subtest: psr-farfromfence-mmap-gtt
[158.086827] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[158.528936] [034/130] (879s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[158.926033] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[158.930124] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[159.338720] [035/130] (878s left) kms_psr (psr-primary-mmap-gtt)
[159.703871] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[159.961831] [036/130] (878s left) api_intel_allocator (reopen)
[160.022583] Starting subtest: reopen
[160.028792] Subtest reopen: SUCCESS (0.006s)
[160.142453] [037/130] (878s left) gem_ctx_persistence (idempotent)
[160.202239] Subtest idempotent: SKIP (0.000s)
[160.261278] [038/130] (878s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[160.324791] Starting subtest: multi-wait-for-submit-unsubmitted
[160.426906] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.101s)
[160.521340] [039/130] (877s left) gem_mmap_gtt (medium-copy-odd)
[160.579711] Starting subtest: medium-copy-odd
[161.419918] Subtest medium-copy-odd: SUCCESS (0.841s)
[161.534207] [040/130] (876s left) kms_psr (fbc-psr-sprite-blt)
[161.981792] Subtest fbc-psr-sprite-blt: SKIP (0.000s)
[162.241295] [041/130] (876s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[162.620040] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[162.623359] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[163.062857] [042/130] (875s left) perf (create-destroy-userspace-config)
[163.211732] Subtest create-destroy-userspace-config: SKIP (0.000s)
[163.267500] [043/130] (875s left) gem_exec_reloc (basic-gtt-wc)
[163.327508] Starting subtest: basic-gtt-wc
[163.331608] Subtest basic-gtt-wc: SUCCESS (0.004s)
[164.091157] [044/130] (874s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[164.467178] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[164.470443] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[164.905483] [045/130] (873s left) gem_mmap (basic)
[164.968266] Starting subtest: basic
[164.977028] Subtest basic: SUCCESS (0.001s)
[165.091311] [046/130] (873s left) gem_bad_reloc (negative-reloc-bltcopy)
[165.154573] Starting subtest: negative-reloc-bltcopy
[165.528553] Subtest negative-reloc-bltcopy: SUCCESS (0.373s)
[165.717694] [047/130] (873s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[166.076959] Starting subtest: sprite-rotation-90-pos-100-0
[166.080340] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[166.521431] [048/130] (872s left) perf (sysctl-defaults)
[166.630871] Starting subtest: sysctl-defaults
[166.632731] Subtest sysctl-defaults: SUCCESS (0.000s)
[166.695944] [049/130] (872s left) gem_ctx_persistence (legacy-engines-queued)
[166.756720] Subtest legacy-engines-queued: SKIP (0.000s)
[166.818570] [050/130] (872s left) kms_psr (fbc-pr-sprite-render)
[167.178705] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[167.417230] [051/130] (871s left) gem_exercise_blt (fast-copy)
[167.512662] Subtest fast-copy: SKIP (0.000s)
[167.563109] [052/130] (871s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[167.939553] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[167.944090] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[168.391316] [053/130] (870s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[168.451463] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[168.510876] [054/130] (870s left) gem_mmap_gtt (cpuset-big-copy-xy)
[168.568988] Starting subtest: cpuset-big-copy-XY
[171.767192] Subtest cpuset-big-copy-XY: SUCCESS (3.197s)
[171.919706] [055/130] (867s left) gem_exec_schedule (fifo)
[172.060740] Starting subtest: fifo
[172.062614] Starting dynamic subtest: rcs0
[172.091727] Dynamic subtest rcs0: SUCCESS (0.031s)
[172.105826] Starting dynamic subtest: bcs0
[172.122458] Dynamic subtest bcs0: SUCCESS (0.028s)
[172.124192] Subtest fifo: SUCCESS (0.061s)
[172.364812] [056/130] (866s left) gem_create (create-ext-cpu-access-big)
[172.539437] Starting subtest: create-ext-cpu-access-big
[172.543181] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[172.641930] [057/130] (866s left) kms_plane_multiple (2x-tiling-y)
[173.015619] Starting subtest: 2x-tiling-y
[173.018951] Subtest 2x-tiling-y: SKIP (0.000s)
[173.459031] [058/130] (865s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[173.834820] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[173.838188] Subtest psr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[174.275270] [059/130] (865s left) kms_scaling_modes (scaling-mode-none)
[174.643500] Starting subtest: scaling-mode-none
[174.649900] Subtest scaling-mode-none: SKIP (0.000s)
[175.087172] [060/130] (864s left) gem_pxp (create-protected-buffer)
[177.663104] Starting subtest: create-protected-buffer
[177.667196] Subtest create-protected-buffer: SKIP (0.000s)
[177.764904] [061/130] (861s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[177.820683] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.000s)
[177.874310] [062/130] (861s left) perf_pmu (busy-start)
[177.936311] Starting subtest: busy-start
[177.938183] Starting dynamic subtest: rcs0
[180.453480] Dynamic subtest rcs0: SUCCESS (2.517s)
[180.474161] Starting dynamic subtest: bcs0
[182.972443] Dynamic subtest bcs0: SUCCESS (2.516s)
[182.993726] Starting dynamic subtest: vcs0
[185.994367] Dynamic subtest vcs0: SUCCESS (3.020s)
[185.996618] Subtest busy-start: SUCCESS (8.060s)
[186.099269] [063/130] (853s left) kms_color (legacy-gamma)
[186.470911] Starting subtest: legacy-gamma
[186.473075] Starting dynamic subtest: pipe-A-HDMI-A-1
[186.960830] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.491s)
[186.976509] Starting dynamic subtest: pipe-B-HDMI-A-1
[187.475792] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.513s)
[187.477426] Subtest legacy-gamma: SUCCESS (1.007s)
[188.027567] [064/130] (851s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[188.401220] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[188.404372] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[188.844664] [065/130] (850s left) kms_dp_link_training (uhbr-mst)
[189.229581] Starting subtest: uhbr-mst
[189.233679] Subtest uhbr-mst: SKIP (0.000s)
[189.511590] [066/130] (850s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[189.886475] Subtest psr2-plane-move-sf-dmg-area: SKIP (0.000s)
[190.118378] [067/130] (849s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[190.185929] Starting subtest: y-tiled-to-vebox-y-tiled
[190.190099] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[190.391476] [068/130] (849s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[190.760209] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[192.585478] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (1.826s)
[193.071503] [069/130] (846s left) i915_drm_fdinfo (busy-hang)
[193.139621] Subtest busy-hang: SKIP (0.000s)
[193.199905] [070/130] (846s left) kms_flip (2x-flip-vs-wf_vblank)
[193.567735] Starting subtest: 2x-flip-vs-wf_vblank
[193.569471] Starting dynamic subtest: AB-VGA1-HDMI-A1
[196.235732] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (2.667s)
[196.237558] Subtest 2x-flip-vs-wf_vblank: SUCCESS (2.671s)
[196.874744] [071/130] (843s left) gem_lmem_swapping (basic)
[196.940318] Subtest basic: SKIP (0.000s)
[197.002301] [072/130] (843s left) kms_atomic_transition (plane-all-transition-nonblocking)
[197.370813] Starting subtest: plane-all-transition-nonblocking
[197.372536] Starting dynamic subtest: pipe-A-HDMI-A-1
[198.535526] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.163s)
[198.634492] Starting dynamic subtest: pipe-B-HDMI-A-1
[199.939798] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.320s)
[200.021735] Subtest plane-all-transition-nonblocking: SUCCESS (2.652s)
[200.579050] [073/130] (839s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[200.944893] Starting subtest: cursorA-vs-flipA-atomic
[211.837555] Subtest cursorA-vs-flipA-atomic: SUCCESS (10.895s)
[212.398760] [074/130] (827s left) syncobj_timeline (single-wait-all-available-submitted)
[212.460859] Starting subtest: single-wait-all-available-submitted
[212.462811] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[212.559280] [075/130] (827s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[212.934772] Starting subtest: psr-rgb565-draw-blt
[212.938161] Subtest psr-rgb565-draw-blt: SKIP (0.000s)
[213.379398] [076/130] (827s left) kms_vblank (wait-forked-busy)
[213.747726] Starting subtest: wait-forked-busy
[213.750044] Starting dynamic subtest: pipe-A-HDMI-A-1
[216.150925] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.404s)
[216.168773] Starting dynamic subtest: pipe-B-HDMI-A-1
[218.578042] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.424s)
[218.579591] Subtest wait-forked-busy: SUCCESS (4.834s)
[219.154258] [077/130] (821s left) kms_properties (crtc-properties-atomic)
[219.517155] Starting subtest: crtc-properties-atomic
[219.518860] Starting dynamic subtest: pipe-A-HDMI-A-1
[219.754350] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.237s)
[219.768870] Starting dynamic subtest: pipe-B-HDMI-A-1
[220.057934] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.301s)
[220.061861] Subtest crtc-properties-atomic: SUCCESS (0.543s)
[220.613893] [078/130] (819s left) kms_big_fb (y-tiled-addfb-size-overflow)
[220.983920] Starting subtest: y-tiled-addfb-size-overflow
[220.987290] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s)
[221.418725] [079/130] (819s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[221.480322] Starting subtest: invalid-multi-wait-unsubmitted
[221.482133] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[221.580201] [080/130] (819s left) kms_addfb_basic (master-rmfb)
[221.638487] Starting subtest: master-rmfb
[221.640805] Subtest master-rmfb: SUCCESS (0.001s)
[222.390419] [081/130] (818s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[222.751256] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[222.754431] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[223.189325] [082/130] (817s left) gem_exec_store (pages)
[223.259973] Starting subtest: pages
[223.261955] Starting dynamic subtest: rcs0
[223.326158] Dynamic subtest rcs0: SUCCESS (0.065s)
[223.347540] Starting dynamic subtest: bcs0
[223.388827] Dynamic subtest bcs0: SUCCESS (0.060s)
[223.391295] Subtest pages: SUCCESS (0.130s)
[223.610814] [083/130] (817s left) kms_plane_alpha_blend (constant-alpha-mid)
[223.979239] Starting subtest: constant-alpha-mid
[224.144517] Subtest constant-alpha-mid: SKIP (0.164s)
[224.761131] [084/130] (816s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[225.131065] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[225.134544] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[225.577344] [085/130] (815s left) kms_pm_dc (dc5-dpms-negative)
[236.683391] Subtest dc5-dpms-negative: SKIP (0.000s)
[236.753023] [086/130] (804s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[237.121673] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[237.124977] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[237.555312] [087/130] (803s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[237.926715] Starting subtest: modeset-transition-nonblocking-fencing
[237.928518] Starting dynamic subtest: 1x-outputs
[239.105913] Dynamic subtest 1x-outputs: SUCCESS (1.178s)
[239.161816] Subtest modeset-transition-nonblocking-fencing: SUCCESS (1.236s)
[239.722708] [088/130] (801s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[239.784926] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.000s)
[239.851810] [089/130] (801s left) kms_busy (extended-pageflip-hang-oldfb)
[240.223395] Starting subtest: extended-pageflip-hang-oldfb
[240.224979] Starting dynamic subtest: pipe-A
[240.415878] Dynamic subtest pipe-A: SUCCESS (0.192s)
[240.433339] Starting dynamic subtest: pipe-B
[240.698520] Dynamic subtest pipe-B: SUCCESS (0.280s)
[240.700192] Subtest extended-pageflip-hang-oldfb: SUCCESS (0.479s)
[241.255812] [090/130] (799s left) kms_chamelium_color (ctm-blue-to-red)
[241.619916] Subtest ctm-blue-to-red: SKIP (0.000s)
[241.859182] [091/130] (799s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[242.233726] Starting subtest: yf-tiled-64bpp-rotate-90
[242.237756] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[242.682172] [092/130] (798s left) gem_readwrite (read-write)
[242.739346] Starting subtest: read-write
[242.747087] Subtest read-write: SUCCESS (0.000s)
[242.858150] [093/130] (798s left) gem_exec_create (legacy)
[242.927048] Starting subtest: legacy
[242.928899] Starting dynamic subtest: smem
[244.987913] Dynamic subtest smem: SUCCESS (2.060s)
[244.990221] Subtest legacy: SUCCESS (2.062s)
[245.206461] [094/130] (796s left) kms_async_flips (invalid-async-flip-atomic)
[245.571012] Starting subtest: invalid-async-flip-atomic
[245.575071] Subtest invalid-async-flip-atomic: SKIP (0.000s)
[246.273277] [095/130] (795s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[246.646930] Starting subtest: flip-vs-cursor-crc-legacy
[247.185170] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.537s)
[247.741884] [096/130] (793s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[248.117469] Starting subtest: x-tiled-32bpp-rotate-90
[248.137404] Subtest x-tiled-32bpp-rotate-90: SKIP (0.019s)
[248.584719] [097/130] (793s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[248.953682] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[248.956835] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[249.388682] [098/130] (792s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[249.766472] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[249.769586] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[250.207485] [099/130] (791s left) prime_busy (before)
[250.269813] Starting subtest: before
[250.276936] Starting dynamic subtest: rcs0
[250.291552] Dynamic subtest rcs0: SUCCESS (0.015s)
[250.314736] Starting dynamic subtest: bcs0
[250.316954] Dynamic subtest bcs0: SUCCESS (0.017s)
[250.339535] Starting dynamic subtest: vcs0
[250.341388] Dynamic subtest vcs0: SUCCESS (0.012s)
[250.433137] Subtest before: SUCCESS (0.162s)
[250.535883] [100/130] (791s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[250.909488] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[250.912721] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[251.352205] [101/130] (790s left) gem_mmap_offset (partial-remap)
[251.414701] Starting subtest: partial-remap
[251.416926] Starting dynamic subtest: smem0
[251.425910] Dynamic subtest smem0: SUCCESS (0.005s)
[251.428151] Subtest partial-remap: SUCCESS (0.006s)
[251.531290] [102/130] (790s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[251.899835] Starting subtest: plane-use-after-nonblocking-unbind
[251.901517] Starting dynamic subtest: pipe-A-HDMI-A-1
[252.011195] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.111s)
[252.110694] Starting dynamic subtest: pipe-B-HDMI-A-1
[252.346755] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.251s)
[252.430908] Subtest plane-use-after-nonblocking-unbind: SUCCESS (0.531s)
[252.987716] [103/130] (788s left) syncobj_basic (bad-flags-handle-to-fd)
[253.055038] Starting subtest: bad-flags-handle-to-fd
[253.057242] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[253.158270] [104/130] (788s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[253.222365] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (0.000s)
[253.285451] [105/130] (788s left) dmabuf_sync_file (import-basic)
[253.403578] Starting subtest: import-basic
[253.405194] Subtest import-basic: SUCCESS (0.002s)
[253.490448] [FACT dmabuf_sync_file (import-basic)] new: kernel.kmod_is_loaded.vgem: true
[253.495254] [106/130] (788s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[253.972714] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[254.319345] [107/130] (787s left) gem_render_copy_redux (flink)
[254.389096] Starting subtest: flink
[255.516444] Subtest flink: SUCCESS (1.129s)
[255.661765] [108/130] (786s left) gem_exec_schedule (preempt-contexts)
[255.734876] Subtest preempt-contexts: SKIP (0.000s)
[255.939922] [109/130] (786s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[256.307958] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[256.312084] Starting dynamic subtest: AB-VGA1-HDMI-A1
[258.917367] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (2.607s)
[258.922021] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SUCCESS (2.611s)
[259.627971] [110/130] (782s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[259.691329] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SKIP (0.000s)
[259.752702] [111/130] (782s left) gem_exec_balancer (persistence)
[259.815234] Subtest persistence: SKIP (0.000s)
[259.917394] [112/130] (782s left) i915_pm_rps (thresholds-idle)
[259.981663] Starting subtest: thresholds-idle
[259.983447] Starting dynamic subtest: gt0
[270.301204] Dynamic subtest gt0: SUCCESS (10.318s)
[270.303511] Subtest thresholds-idle: SUCCESS (10.321s)
[270.410783] [113/130] (772s left) gem_exec_params (sol-reset-not-gen7)
[270.472184] Starting subtest: sol-reset-not-gen7
[270.473906] Subtest sol-reset-not-gen7: SUCCESS (0.001s)
[270.606140] [114/130] (772s left) kms_big_fb (linear-16bpp-rotate-180)
[270.976257] Starting subtest: linear-16bpp-rotate-180
[272.313209] Subtest linear-16bpp-rotate-180: SUCCESS (1.336s)
[272.801149] [115/130] (769s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[273.174122] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[273.177842] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[273.614867] [116/130] (769s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[273.980356] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.000s)
[274.226952] [117/130] (768s left) kms_cursor_crc (cursor-random-256x256)
[274.591737] Starting subtest: cursor-random-256x256
[274.596506] Starting dynamic subtest: pipe-A-HDMI-A-1
[278.283932] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.689s)
[278.326911] Starting dynamic subtest: pipe-B-HDMI-A-1
[282.001960] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.688s)
[282.003738] Subtest cursor-random-256x256: SUCCESS (7.411s)
[282.565144] [118/130] (760s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[282.937871] Starting subtest: plane-upscale-20x20-with-pixel-format
[282.939546] Starting dynamic subtest: pipe-A
[282.944490] Dynamic subtest pipe-A: SKIP (0.001s)
[282.963896] Starting dynamic subtest: pipe-B
[282.970035] Dynamic subtest pipe-B: SKIP (0.001s)
[282.973773] Subtest plane-upscale-20x20-with-pixel-format: SKIP (0.004s)
[283.413972] [119/130] (759s left) perf (global-sseu-config)
[283.563387] Subtest global-sseu-config: SKIP (0.000s)
[283.668724] [120/130] (759s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[283.736592] Starting subtest: etime-multi-wait-all-for-submit-submitted
[283.842774] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.107s)
[283.944210] [121/130] (759s left) kms_flip (nonexisting-fb-interruptible)
[284.323855] Starting subtest: nonexisting-fb-interruptible
[284.325685] Starting dynamic subtest: A-VGA1
[284.548323] Dynamic subtest A-VGA1: SUCCESS (0.223s)
[284.567686] Starting dynamic subtest: B-VGA1
[284.729532] Dynamic subtest B-VGA1: SUCCESS (0.178s)
[284.746965] Starting dynamic subtest: A-HDMI-A1
[284.952403] Dynamic subtest A-HDMI-A1: SUCCESS (0.219s)
[284.970186] Starting dynamic subtest: B-HDMI-A1
[285.234677] Dynamic subtest B-HDMI-A1: SUCCESS (0.278s)
[285.236485] Subtest nonexisting-fb-interruptible: SUCCESS (0.911s)
[285.863632] [122/130] (757s left) i915_drm_fdinfo (isolation)
[285.927904] Subtest isolation: SKIP (0.000s)
[285.988606] [123/130] (757s left) gem_exec_await (wide-contexts)
[286.079232] Starting subtest: wide-contexts
[307.791214] Subtest wide-contexts: SUCCESS (21.709s)
[308.026148] [124/130] (735s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[308.151668] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.000s)
[308.211658] [125/130] (735s left) gem_exec_params (invalid-fence-in-submit)
[308.270850] Starting subtest: invalid-fence-in-submit
[308.272572] Subtest invalid-fence-in-submit: SUCCESS (0.001s)
[308.406145] [126/130] (734s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[308.776911] Starting subtest: primary-yf-tiled-reflect-x-90
[308.780434] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.002s)
[309.238863] [127/130] (734s left) kms_sequence (get-idle)
[309.612886] Starting subtest: get-idle
[309.614528] Starting dynamic subtest: pipe-A-HDMI-A-1
[311.850803] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.237s)
[311.866099] Starting dynamic subtest: pipe-B-HDMI-A-1
[314.124271] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.272s)
[314.126025] Subtest get-idle: SUCCESS (4.514s)
[314.697512] [128/130] (728s left) kms_properties (invalid-properties-atomic)
[315.065811] Starting subtest: invalid-properties-atomic
[315.101137] Subtest invalid-properties-atomic: SUCCESS (0.039s)
[315.562273] [129/130] (728s left) kms_cursor_crc (cursor-sliding-max-size)
[315.937773] Starting subtest: cursor-sliding-max-size
[315.942370] Subtest cursor-sliding-max-size: SKIP (0.000s)
[316.392744] [130/130] (727s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[316.758029] Starting subtest: basic-flip-after-cursor-varying-size
[317.762501] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.005s)
[318.315801] 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.