[69.575134] Initializing watchdogs
[69.575243]   /dev/watchdog0
[69.595977] [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)
[69.603665] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[69.607452] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[69.610560] [001/130] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[69.987545] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[69.989600] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[70.432052] [002/130] (959s left) kms_flip (2x-plain-flip-fb-recreate-interruptible)
[70.812208] Starting subtest: 2x-plain-flip-fb-recreate-interruptible
[70.812920] Starting dynamic subtest: AB-VGA1-HDMI-A1
[101.490968] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (30.653s)
[101.491955] Subtest 2x-plain-flip-fb-recreate-interruptible: SUCCESS (30.656s)
[102.177254] [003/130] (928s left) kms_cursor_edge_walk (128x128-top-edge)
[102.539906] Starting subtest: 128x128-top-edge
[102.541507] Starting dynamic subtest: pipe-A-HDMI-A-1
[105.958595] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.416s)
[105.969503] Starting dynamic subtest: pipe-B-HDMI-A-1
[109.294547] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.334s)
[109.295109] Subtest 128x128-top-edge: SUCCESS (6.753s)
[109.844194] [004/130] (920s left) kms_content_protection (dp-mst-lic-type-0)
[110.234597] Starting subtest: dp-mst-lic-type-0
[110.235795] Subtest dp-mst-lic-type-0: SKIP (0.000s)
[110.674185] [005/130] (919s left) kms_joiner (basic-max-non-joiner)
[111.042019] Starting subtest: basic-max-non-joiner
[111.043137] Subtest basic-max-non-joiner: SKIP (0.000s)
[111.480388] [006/130] (918s left) gem_ctx_isolation (preservation-reset)
[111.648691] Starting subtest: preservation-reset
[111.649727] Starting dynamic subtest: rcs0
[112.203179] Dynamic subtest rcs0: SUCCESS (0.554s)
[112.205601] Subtest preservation-reset: SUCCESS (0.556s)
[112.336737] [007/130] (918s left) prime_mmap (test_dup)
[112.390405] Starting subtest: test_dup
[112.390950] Starting dynamic subtest: test_dup-smem
[112.392530] Dynamic subtest test_dup-smem: SUCCESS (0.002s)
[112.393120] Subtest test_dup: SUCCESS (0.003s)
[112.490703] [008/130] (917s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[112.548194] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[112.549235] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.001s)
[112.641856] [009/130] (917s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers)
[113.001499] Starting subtest: plane-scaler-with-clipping-clamping-modifiers
[113.002526] Starting dynamic subtest: pipe-A
[113.004419] Dynamic subtest pipe-A: SKIP (0.002s)
[113.015882] Starting dynamic subtest: pipe-B
[113.017737] Dynamic subtest pipe-B: SKIP (0.001s)
[113.018753] Subtest plane-scaler-with-clipping-clamping-modifiers: SKIP (0.003s)
[113.444408] [010/130] (917s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt)
[113.816431] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt
[113.817342] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[114.255292] [011/130] (916s left) kms_joiner (invalid-modeset-ultra-joiner)
[114.628428] Starting subtest: invalid-modeset-ultra-joiner
[114.630018] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[115.066333] [012/130] (915s left) i915_pm_rc6_residency (media-rc6-accuracy)
[115.119586] Starting subtest: media-rc6-accuracy
[115.120693] Subtest media-rc6-accuracy: SKIP (0.000s)
[115.201607] [013/130] (915s left) kms_pm_rpm (pm-caching)
[126.812287] Subtest pm-caching: SKIP (0.000s)
[127.056958] [014/130] (903s left) kms_addfb_basic (too-high)
[127.429393] Starting subtest: too-high
[127.430959] Subtest too-high: SUCCESS (0.002s)
[127.899057] [015/130] (902s left) gem_eio (context-create)
[127.959460] Starting subtest: context-create
[127.979452] Subtest context-create: SUCCESS (0.020s)
[128.728054] [016/130] (902s left) gem_exec_suspend (basic-s4-devices)
[128.796366] Starting subtest: basic-S4-devices
[128.797039] Starting dynamic subtest: smem
[136.811956] Dynamic subtest smem: SUCCESS (8.013s)
[136.813404] Subtest basic-S4-devices: SUCCESS (8.014s)
[143.016812] [017/130] (893s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite)
[143.387888] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite
[143.389023] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[143.840388] [018/130] (893s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[144.205654] Starting subtest: cursorB-vs-flipB-atomic
[144.206634] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[144.650703] [019/130] (892s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area)
[145.019502] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[145.236191] [020/130] (891s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-gtt)
[145.606137] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-gtt
[147.014422] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-gtt: SUCCESS (1.408s)
[147.487935] [021/130] (889s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[147.863752] Starting subtest: y-tiled-16bpp-rotate-180
[147.864983] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s)
[148.312201] [022/130] (888s left) sw_sync (sync_busy_fork_unixsocket)
[148.366014] Starting subtest: sync_busy_fork_unixsocket
[148.380253] Subtest sync_busy_fork_unixsocket: SUCCESS (0.013s)
[148.451517] [023/130] (888s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-submitted-signaled)
[148.506308] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled
[148.507656] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[148.611161] [024/130] (888s left) gem_exec_params (invalid-bsd-ring)
[148.670798] Starting subtest: invalid-bsd-ring
[148.671506] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[148.772279] [025/130] (888s left) syncobj_timeline (invalid-wait-illegal-handle)
[148.822598] Starting subtest: invalid-wait-illegal-handle
[148.823108] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[148.919759] [026/130] (888s left) kms_psr (psr2-cursor-plane-onoff)
[149.280308] Subtest psr2-cursor-plane-onoff: SKIP (0.000s)
[149.526830] [027/130] (887s left) gem_render_copy (y-tiled-ccs-to-y-tiled)
[149.586259] Starting subtest: y-tiled-ccs-to-y-tiled
[149.586877] Starting dynamic subtest: smem
[149.587752] Dynamic subtest smem: SKIP (0.000s)
[149.588727] Subtest y-tiled-ccs-to-y-tiled: SKIP (0.001s)
[149.794362] [028/130] (887s left) gen9_exec_parse (allowed-all)
[149.854090] Subtest allowed-all: SKIP (0.000s)
[149.907909] [029/130] (887s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[150.284804] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[150.819340] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.534s)
[151.307183] [030/130] (886s left) gem_userptr_blits (stress-purge)
[151.376721] Starting subtest: stress-purge
[156.764798] Subtest stress-purge: SUCCESS (5.389s)
[156.913126] [031/130] (880s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[157.053964] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[157.054772] Starting dynamic subtest: smem
[157.056211] Dynamic subtest smem: SKIP (0.000s)
[157.057331] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.001s)
[157.253640] [032/130] (880s left) core_setmaster (master-drop-set-root)
[157.350625] Starting subtest: master-drop-set-root
[157.354572] Subtest master-drop-set-root: SUCCESS (0.004s)
[157.419380] [033/130] (880s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[157.796737] Starting subtest: psr-farfromfence-mmap-gtt
[157.798455] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[158.232118] [034/130] (879s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[158.601384] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[158.604256] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[159.049631] [035/130] (878s left) kms_psr (psr-primary-mmap-gtt)
[159.411309] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[159.655658] [036/130] (878s left) api_intel_allocator (reopen)
[159.708834] Starting subtest: reopen
[159.714443] Subtest reopen: SUCCESS (0.005s)
[159.827703] [037/130] (877s left) gem_ctx_persistence (idempotent)
[159.884070] Subtest idempotent: SKIP (0.000s)
[159.940057] [038/130] (877s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[159.999223] Starting subtest: multi-wait-for-submit-unsubmitted
[160.100555] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.101s)
[160.200927] [039/130] (877s left) gem_mmap_gtt (medium-copy-odd)
[160.251293] Starting subtest: medium-copy-odd
[161.097210] Subtest medium-copy-odd: SUCCESS (0.843s)
[161.200862] [040/130] (876s left) kms_psr (fbc-psr-sprite-blt)
[161.640751] Subtest fbc-psr-sprite-blt: SKIP (0.000s)
[161.884891] [041/130] (876s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-render)
[162.253866] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-render
[162.254787] Subtest fbc-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[162.687085] [042/130] (875s left) perf (create-destroy-userspace-config)
[162.829645] Subtest create-destroy-userspace-config: SKIP (0.000s)
[162.884699] [043/130] (875s left) gem_exec_reloc (basic-gtt-wc)
[162.937785] Starting subtest: basic-gtt-wc
[162.941261] Subtest basic-gtt-wc: SUCCESS (0.004s)
[163.696964] [044/130] (874s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc)
[164.069268] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc
[164.070480] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[164.511780] [045/130] (873s left) gem_mmap (basic)
[164.565851] Starting subtest: basic
[164.568597] Subtest basic: SUCCESS (0.000s)
[164.667205] [046/130] (873s left) gem_bad_reloc (negative-reloc-bltcopy)
[164.721268] Starting subtest: negative-reloc-bltcopy
[165.096648] Subtest negative-reloc-bltcopy: SUCCESS (0.375s)
[165.278162] [047/130] (873s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[165.641998] Starting subtest: sprite-rotation-90-pos-100-0
[165.646069] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[166.080921] [048/130] (872s left) perf (sysctl-defaults)
[166.181724] Starting subtest: sysctl-defaults
[166.182205] Subtest sysctl-defaults: SUCCESS (0.000s)
[166.239609] [049/130] (872s left) gem_ctx_persistence (legacy-engines-queued)
[166.296450] Subtest legacy-engines-queued: SKIP (0.000s)
[166.358355] [050/130] (872s left) kms_psr (fbc-pr-sprite-render)
[166.712983] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[166.942163] [051/130] (871s left) gem_exercise_blt (fast-copy)
[166.998763] Subtest fast-copy: SKIP (0.000s)
[167.058274] [052/130] (871s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu)
[167.423954] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu
[167.426752] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[167.859681] [053/130] (870s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[167.918175] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[167.969898] [054/130] (870s left) gem_mmap_gtt (cpuset-big-copy-xy)
[168.026358] Starting subtest: cpuset-big-copy-XY
[171.247738] Subtest cpuset-big-copy-XY: SUCCESS (3.221s)
[171.366631] [055/130] (867s left) gem_exec_schedule (fifo)
[171.503665] Starting subtest: fifo
[171.504199] Starting dynamic subtest: rcs0
[171.534149] Dynamic subtest rcs0: SUCCESS (0.030s)
[171.549022] Starting dynamic subtest: bcs0
[171.563581] Dynamic subtest bcs0: SUCCESS (0.028s)
[171.564177] Subtest fifo: SUCCESS (0.060s)
[171.786174] [056/130] (866s left) gem_create (create-ext-cpu-access-big)
[171.956670] Starting subtest: create-ext-cpu-access-big
[171.957947] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[172.053885] [057/130] (866s left) kms_plane_multiple (2x-tiling-y)
[172.415850] Starting subtest: 2x-tiling-y
[172.417408] Subtest 2x-tiling-y: SKIP (0.000s)
[172.853200] [058/130] (865s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[173.228439] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[173.230469] Subtest psr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[173.664429] [059/130] (865s left) kms_scaling_modes (scaling-mode-none)
[174.029786] Starting subtest: scaling-mode-none
[174.032105] Subtest scaling-mode-none: SKIP (0.000s)
[174.467889] [060/130] (864s left) gem_pxp (create-protected-buffer)
[177.038849] Starting subtest: create-protected-buffer
[177.039854] Subtest create-protected-buffer: SKIP (0.000s)
[177.135233] [061/130] (861s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[177.188464] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.000s)
[177.259228] [062/130] (861s left) perf_pmu (busy-start)
[177.315811] Starting subtest: busy-start
[177.316367] Starting dynamic subtest: rcs0
[179.834473] Dynamic subtest rcs0: SUCCESS (2.519s)
[179.849285] Starting dynamic subtest: bcs0
[182.359385] Dynamic subtest bcs0: SUCCESS (2.523s)
[182.380670] Starting dynamic subtest: vcs0
[185.375421] Dynamic subtest vcs0: SUCCESS (3.014s)
[185.376337] Subtest busy-start: SUCCESS (8.061s)
[185.485139] [063/130] (853s left) kms_color (legacy-gamma)
[185.848731] Starting subtest: legacy-gamma
[185.849349] Starting dynamic subtest: pipe-A-HDMI-A-1
[186.344958] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.497s)
[186.359780] Starting dynamic subtest: pipe-B-HDMI-A-1
[186.868205] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.523s)
[186.868700] Subtest legacy-gamma: SUCCESS (1.022s)
[187.420421] [064/130] (851s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[187.791831] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu
[187.792814] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[188.233482] [065/130] (850s left) kms_dp_link_training (uhbr-mst)
[188.595749] Starting subtest: uhbr-mst
[188.597126] Subtest uhbr-mst: SKIP (0.000s)
[188.872127] [066/130] (850s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[189.236996] Subtest psr2-plane-move-sf-dmg-area: SKIP (0.000s)
[189.480105] [067/130] (849s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[189.544125] Starting subtest: y-tiled-to-vebox-y-tiled
[189.545728] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[189.750135] [068/130] (849s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[190.115022] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[191.946555] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (1.831s)
[192.435138] [069/130] (846s left) i915_drm_fdinfo (busy-hang)
[192.489161] Subtest busy-hang: SKIP (0.000s)
[192.553684] [070/130] (846s left) kms_flip (2x-flip-vs-wf_vblank)
[192.919181] Starting subtest: 2x-flip-vs-wf_vblank
[192.919999] Starting dynamic subtest: AB-VGA1-HDMI-A1
[195.584753] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (2.665s)
[195.587812] Subtest 2x-flip-vs-wf_vblank: SUCCESS (2.669s)
[196.215931] [071/130] (843s left) gem_lmem_swapping (basic)
[196.277626] Subtest basic: SKIP (0.000s)
[196.327117] [072/130] (843s left) kms_atomic_transition (plane-all-transition-nonblocking)
[196.682658] Starting subtest: plane-all-transition-nonblocking
[196.685647] Starting dynamic subtest: pipe-A-HDMI-A-1
[197.848801] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.164s)
[197.946684] Starting dynamic subtest: pipe-B-HDMI-A-1
[199.259153] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.324s)
[199.343913] Subtest plane-all-transition-nonblocking: SUCCESS (2.660s)
[199.903365] [073/130] (839s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[200.262764] Starting subtest: cursorA-vs-flipA-atomic
[211.164129] Subtest cursorA-vs-flipA-atomic: SUCCESS (10.901s)
[211.722415] [074/130] (827s left) syncobj_timeline (single-wait-all-available-submitted)
[211.777776] Starting subtest: single-wait-all-available-submitted
[211.778377] Subtest single-wait-all-available-submitted: SUCCESS (0.000s)
[211.874577] [075/130] (827s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[212.236202] Starting subtest: psr-rgb565-draw-blt
[212.237344] Subtest psr-rgb565-draw-blt: SKIP (0.000s)
[212.668535] [076/130] (827s left) kms_vblank (wait-forked-busy)
[213.027085] Starting subtest: wait-forked-busy
[213.027775] Starting dynamic subtest: pipe-A-HDMI-A-1
[215.434629] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.406s)
[215.448552] Starting dynamic subtest: pipe-B-HDMI-A-1
[217.860562] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.424s)
[217.861162] Subtest wait-forked-busy: SUCCESS (4.835s)
[218.440269] [077/130] (821s left) kms_properties (crtc-properties-atomic)
[218.806562] Starting subtest: crtc-properties-atomic
[218.807150] Starting dynamic subtest: pipe-A-HDMI-A-1
[219.031458] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.224s)
[219.045221] Starting dynamic subtest: pipe-B-HDMI-A-1
[219.336483] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.303s)
[219.336957] Subtest crtc-properties-atomic: SUCCESS (0.531s)
[219.893289] [078/130] (819s left) kms_big_fb (y-tiled-addfb-size-overflow)
[220.268022] Starting subtest: y-tiled-addfb-size-overflow
[220.269045] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s)
[220.715359] [079/130] (819s left) syncobj_timeline (invalid-multi-wait-unsubmitted)
[220.771288] Starting subtest: invalid-multi-wait-unsubmitted
[220.771881] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[220.861868] [080/130] (819s left) kms_addfb_basic (master-rmfb)
[220.916733] Starting subtest: master-rmfb
[220.917298] Subtest master-rmfb: SUCCESS (0.001s)
[221.659619] [081/130] (818s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[222.031749] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[222.032938] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[222.471791] [082/130] (817s left) gem_exec_store (pages)
[222.537895] Starting subtest: pages
[222.538597] Starting dynamic subtest: rcs0
[222.599193] Dynamic subtest rcs0: SUCCESS (0.060s)
[222.620452] Starting dynamic subtest: bcs0
[222.647838] Dynamic subtest bcs0: SUCCESS (0.045s)
[222.649213] Subtest pages: SUCCESS (0.111s)
[222.861426] [083/130] (817s left) kms_plane_alpha_blend (constant-alpha-mid)
[223.225627] Starting subtest: constant-alpha-mid
[223.389034] Subtest constant-alpha-mid: SKIP (0.165s)
[224.032015] [084/130] (816s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[224.402616] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[224.403676] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[224.834385] [085/130] (815s left) kms_pm_dc (dc5-dpms-negative)
[235.936454] Subtest dc5-dpms-negative: SKIP (0.000s)
[235.991217] [086/130] (804s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen)
[236.355964] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen
[236.356987] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[236.801782] [087/130] (803s left) kms_atomic_transition (modeset-transition-nonblocking-fencing)
[237.170642] Starting subtest: modeset-transition-nonblocking-fencing
[237.171100] Starting dynamic subtest: 1x-outputs
[238.329152] Dynamic subtest 1x-outputs: SUCCESS (1.158s)
[238.387940] Subtest modeset-transition-nonblocking-fencing: SUCCESS (1.215s)
[238.950676] [088/130] (801s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs)
[239.005582] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.000s)
[239.058228] [089/130] (801s left) kms_busy (extended-pageflip-hang-oldfb)
[239.428968] Starting subtest: extended-pageflip-hang-oldfb
[239.429786] Starting dynamic subtest: pipe-A
[239.611272] Dynamic subtest pipe-A: SUCCESS (0.181s)
[239.625700] Starting dynamic subtest: pipe-B
[239.876826] Dynamic subtest pipe-B: SUCCESS (0.263s)
[239.878450] Subtest extended-pageflip-hang-oldfb: SUCCESS (0.450s)
[240.437759] [090/130] (800s left) kms_chamelium_color (ctm-blue-to-red)
[240.792912] Subtest ctm-blue-to-red: SKIP (0.000s)
[241.029202] [091/130] (799s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[241.392611] Starting subtest: yf-tiled-64bpp-rotate-90
[241.393760] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[241.836368] [092/130] (798s left) gem_readwrite (read-write)
[241.892663] Starting subtest: read-write
[241.895127] Subtest read-write: SUCCESS (0.000s)
[242.000849] [093/130] (798s left) gem_exec_create (legacy)
[242.064632] Starting subtest: legacy
[242.065385] Starting dynamic subtest: smem
[244.109895] Dynamic subtest smem: SUCCESS (2.044s)
[244.113251] Subtest legacy: SUCCESS (2.046s)
[244.317718] [094/130] (796s left) kms_async_flips (invalid-async-flip-atomic)
[244.673386] Starting subtest: invalid-async-flip-atomic
[244.674699] Subtest invalid-async-flip-atomic: SKIP (0.000s)
[245.372777] [095/130] (795s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[245.739870] Starting subtest: flip-vs-cursor-crc-legacy
[246.291160] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.551s)
[246.844433] [096/130] (793s left) kms_big_fb (x-tiled-32bpp-rotate-90)
[247.219218] Starting subtest: x-tiled-32bpp-rotate-90
[247.232102] Subtest x-tiled-32bpp-rotate-90: SKIP (0.010s)
[247.710632] [097/130] (793s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[248.078827] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[248.079867] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[248.508262] [098/130] (792s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[248.867109] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[248.868053] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[249.306288] [099/130] (791s left) prime_busy (before)
[249.361734] Starting subtest: before
[249.371525] Starting dynamic subtest: rcs0
[249.372934] Dynamic subtest rcs0: SUCCESS (0.003s)
[249.392947] Starting dynamic subtest: bcs0
[249.394931] Dynamic subtest bcs0: SUCCESS (0.020s)
[249.410216] Starting dynamic subtest: vcs0
[249.411293] Dynamic subtest vcs0: SUCCESS (0.015s)
[249.519321] Subtest before: SUCCESS (0.157s)
[249.607794] [100/130] (791s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-pgflip-blt)
[249.973826] Starting subtest: fbcpsr-1p-primscrn-indfb-pgflip-blt
[249.975043] Subtest fbcpsr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s)
[250.424096] [101/130] (790s left) gem_mmap_offset (partial-remap)
[250.479423] Starting subtest: partial-remap
[250.480131] Starting dynamic subtest: smem0
[250.488181] Dynamic subtest smem0: SUCCESS (0.005s)
[250.489019] Subtest partial-remap: SUCCESS (0.006s)
[250.604759] [102/130] (790s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[250.963851] Starting subtest: plane-use-after-nonblocking-unbind
[250.964586] Starting dynamic subtest: pipe-A-HDMI-A-1
[251.072123] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.107s)
[251.171541] Starting dynamic subtest: pipe-B-HDMI-A-1
[251.412566] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.256s)
[251.496094] Subtest plane-use-after-nonblocking-unbind: SUCCESS (0.533s)
[252.041562] [103/130] (789s left) syncobj_basic (bad-flags-handle-to-fd)
[252.097723] Starting subtest: bad-flags-handle-to-fd
[252.098404] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s)
[252.186757] [104/130] (788s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[252.238991] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (0.000s)
[252.296447] [105/130] (788s left) dmabuf_sync_file (import-basic)
[252.389658] Starting subtest: import-basic
[252.391189] Subtest import-basic: SUCCESS (0.002s)
[252.473709] [FACT dmabuf_sync_file (import-basic)] new: kernel.kmod_is_loaded.vgem: true
[252.476485] [106/130] (788s left) kms_chamelium_frames (hdmi-cmp-planar-formats)
[252.920642] Subtest hdmi-cmp-planar-formats: SKIP (0.000s)
[253.265121] [107/130] (788s left) gem_render_copy_redux (flink)
[253.323813] Starting subtest: flink
[254.448421] Subtest flink: SUCCESS (1.124s)
[254.597116] [108/130] (786s left) gem_exec_schedule (preempt-contexts)
[254.659925] Subtest preempt-contexts: SKIP (0.000s)
[254.870735] [109/130] (786s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[255.238095] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[255.240066] Starting dynamic subtest: AB-VGA1-HDMI-A1
[257.851472] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (2.611s)
[257.854552] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SUCCESS (2.615s)
[258.509360] [110/130] (782s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[258.567919] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SKIP (0.000s)
[258.635655] [111/130] (782s left) gem_exec_balancer (persistence)
[258.689488] Subtest persistence: SKIP (0.000s)
[258.804198] [112/130] (782s left) i915_pm_rps (thresholds-idle)
[258.865998] Starting subtest: thresholds-idle
[258.868476] Starting dynamic subtest: gt0
[269.229244] Dynamic subtest gt0: SUCCESS (10.361s)
[269.231917] Subtest thresholds-idle: SUCCESS (10.364s)
[269.321589] [113/130] (772s left) gem_exec_params (sol-reset-not-gen7)
[269.382287] Starting subtest: sol-reset-not-gen7
[269.384205] Subtest sol-reset-not-gen7: SUCCESS (0.001s)
[269.520449] [114/130] (772s left) kms_big_fb (linear-16bpp-rotate-180)
[269.889293] Starting subtest: linear-16bpp-rotate-180
[271.248586] Subtest linear-16bpp-rotate-180: SUCCESS (1.359s)
[271.718674] [115/130] (770s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[272.083620] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[272.084807] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[272.529046] [116/130] (769s left) kms_psr (fbc-psr2-sprite-mmap-cpu)
[272.897140] Subtest fbc-psr2-sprite-mmap-cpu: SKIP (0.000s)
[273.125771] [117/130] (768s left) kms_cursor_crc (cursor-random-256x256)
[273.491159] Starting subtest: cursor-random-256x256
[273.493831] Starting dynamic subtest: pipe-A-HDMI-A-1
[277.187913] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.692s)
[277.229765] Starting dynamic subtest: pipe-B-HDMI-A-1
[280.906670] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.689s)
[280.907383] Subtest cursor-random-256x256: SUCCESS (7.415s)
[281.466684] [118/130] (760s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[281.840526] Starting subtest: plane-upscale-20x20-with-pixel-format
[281.841161] Starting dynamic subtest: pipe-A
[281.843558] Dynamic subtest pipe-A: SKIP (0.001s)
[281.860380] Starting dynamic subtest: pipe-B
[281.862505] Dynamic subtest pipe-B: SKIP (0.001s)
[281.863797] Subtest plane-upscale-20x20-with-pixel-format: SKIP (0.006s)
[282.298404] [119/130] (759s left) perf (global-sseu-config)
[282.452477] Subtest global-sseu-config: SKIP (0.000s)
[282.523225] [120/130] (759s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[282.579128] Starting subtest: etime-multi-wait-all-for-submit-submitted
[282.684630] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.105s)
[282.780751] [121/130] (759s left) kms_flip (nonexisting-fb-interruptible)
[283.147130] Starting subtest: nonexisting-fb-interruptible
[283.148952] Starting dynamic subtest: A-VGA1
[283.370138] Dynamic subtest A-VGA1: SUCCESS (0.221s)
[283.385903] Starting dynamic subtest: B-VGA1
[283.555159] Dynamic subtest B-VGA1: SUCCESS (0.182s)
[283.570807] Starting dynamic subtest: A-HDMI-A1
[283.796487] Dynamic subtest A-HDMI-A1: SUCCESS (0.238s)
[283.811949] Starting dynamic subtest: B-HDMI-A1
[284.057537] Dynamic subtest B-HDMI-A1: SUCCESS (0.259s)
[284.060060] Subtest nonexisting-fb-interruptible: SUCCESS (0.912s)
[284.680009] [122/130] (757s left) i915_drm_fdinfo (isolation)
[284.736934] Subtest isolation: SKIP (0.000s)
[284.806652] [123/130] (757s left) gem_exec_await (wide-contexts)
[284.891203] Starting subtest: wide-contexts
[306.595224] Subtest wide-contexts: SUCCESS (21.702s)
[306.826252] [124/130] (735s left) kms_ccs (random-ccs-data-y-tiled-ccs)
[306.925755] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.000s)
[306.980307] [125/130] (735s left) gem_exec_params (invalid-fence-in-submit)
[307.041248] Starting subtest: invalid-fence-in-submit
[307.043649] Subtest invalid-fence-in-submit: SUCCESS (0.001s)
[307.174997] [126/130] (735s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90)
[307.545425] Starting subtest: primary-yf-tiled-reflect-x-90
[307.546472] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s)
[307.987286] [127/130] (734s left) kms_sequence (get-idle)
[308.350645] Starting subtest: get-idle
[308.351157] Starting dynamic subtest: pipe-A-HDMI-A-1
[310.595551] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.243s)
[310.611177] Starting dynamic subtest: pipe-B-HDMI-A-1
[312.853392] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.256s)
[312.853957] Subtest get-idle: SUCCESS (4.503s)
[313.414891] [128/130] (729s left) kms_properties (invalid-properties-atomic)
[313.777888] Starting subtest: invalid-properties-atomic
[313.814934] Subtest invalid-properties-atomic: SUCCESS (0.038s)
[314.260249] [129/130] (728s left) kms_cursor_crc (cursor-sliding-max-size)
[314.627975] Starting subtest: cursor-sliding-max-size
[314.629600] Subtest cursor-sliding-max-size: SKIP (0.000s)
[315.073805] [130/130] (727s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[315.434775] Starting subtest: basic-flip-after-cursor-varying-size
[316.467267] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.032s)
[317.020102] 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.