[70.266477] Initializing watchdogs
[70.266624]   /dev/watchdog0
[70.291036] [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.298669] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[70.302220] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[70.309274] [001/133] (960s left) kms_rotation_crc (sprite-rotation-180)
[70.814991] Starting subtest: sprite-rotation-180
[74.299234] Subtest sprite-rotation-180: SUCCESS (3.483s)
[75.095848] [002/133] (955s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[75.156876] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[75.158731] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.001s)
[75.258411] [003/133] (955s left) kms_universal_plane (universal-plane-pageflip-windowed)
[75.748939] Starting subtest: universal-plane-pageflip-windowed
[75.753257] Subtest universal-plane-pageflip-windowed: SKIP (0.000s)
[76.351447] [004/133] (954s left) kms_force_connector_basic (force-connector-state)
[76.420533] Starting subtest: force-connector-state
[77.012133] Subtest force-connector-state: SUCCESS (0.591s)
[77.758776] [005/133] (953s left) gen9_exec_parse (bb-chained)
[77.829798] Subtest bb-chained: SKIP (0.000s)
[77.879609] [006/133] (953s left) i915_pm_rps (thresholds-idle-park)
[77.945333] Starting subtest: thresholds-idle-park
[77.947279] Starting dynamic subtest: gt0
[93.326276] Dynamic subtest gt0: SUCCESS (15.376s)
[93.328407] Subtest thresholds-idle-park: SUCCESS (15.377s)
[93.463705] [007/133] (937s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[93.955088] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[93.959242] Subtest plane-all-modeset-transition-fencing-internal-panels: SKIP (0.000s)
[94.538527] [008/133] (936s left) gem_ctx_shared (exec-shared-gtt)
[94.601888] Subtest exec-shared-gtt: SKIP (0.000s)
[94.723991] [009/133] (936s left) gem_ctx_param (set-priority-invalid-size)
[94.787417] Subtest set-priority-invalid-size: SKIP (0.000s)
[94.909423] [010/133] (936s left) syncobj_basic (bad-destroy)
[94.966077] Starting subtest: bad-destroy
[94.967796] Subtest bad-destroy: SUCCESS (0.000s)
[95.090647] [011/133] (936s left) kms_big_fb (yf-tiled-addfb)
[95.590894] Starting subtest: yf-tiled-addfb
[95.594286] Subtest yf-tiled-addfb: SKIP (0.000s)
[96.206274] [012/133] (935s left) kms_big_fb (x-tiled-64bpp-rotate-0)
[96.706770] Starting subtest: x-tiled-64bpp-rotate-0
[98.569746] Subtest x-tiled-64bpp-rotate-0: SUCCESS (1.862s)
[99.199536] [013/133] (932s left) gem_close_race (multigpu-basic-process)
[99.272803] Starting subtest: multigpu-basic-process
[99.276485] Subtest multigpu-basic-process: SKIP (0.000s)
[99.554522] [014/133] (931s left) gem_sync (basic-store-each)
[99.622203] Starting subtest: basic-store-each
[101.862094] Subtest basic-store-each: SUCCESS (2.239s)
[102.068144] [015/133] (929s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen)
[102.562552] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen
[103.959441] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (1.399s)
[104.588210] [016/133] (926s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[105.085722] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu
[105.088942] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[105.664620] [017/133] (925s left) api_intel_allocator (reloc-allocator)
[105.726462] Starting subtest: reloc-allocator
[105.728195] Starting dynamic subtest: basic
[105.729935] Dynamic subtest basic: SUCCESS (0.004s)
[105.742441] Starting dynamic subtest: parallel-one
[105.744123] Dynamic subtest parallel-one: SUCCESS (0.007s)
[105.755720] Starting dynamic subtest: print
[105.757393] Dynamic subtest print: SUCCESS (0.000s)
[105.772535] Starting dynamic subtest: reuse
[105.774919] Dynamic subtest reuse: SUCCESS (0.000s)
[105.791175] Starting dynamic subtest: fork-reopen-allocator
[105.793319] Dynamic subtest fork-reopen-allocator: SUCCESS (0.021s)
[105.795419] Subtest reloc-allocator: SUCCESS (0.035s)
[105.900887] [018/133] (925s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[106.395794] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[106.399366] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[107.000180] [019/133] (924s left) syncobj_timeline (multi-wait-for-submit-available-signaled)
[107.059083] Starting subtest: multi-wait-for-submit-available-signaled
[107.060800] Subtest multi-wait-for-submit-available-signaled: SUCCESS (0.001s)
[107.160900] [020/133] (924s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs)
[107.224378] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.000s)
[107.276055] [021/133] (924s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[107.767714] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu
[107.771093] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[108.367867] [022/133] (923s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[108.869621] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[108.872868] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[109.468307] [023/133] (922s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[109.527263] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.000s)
[109.587223] [024/133] (922s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy)
[110.081614] Starting subtest: fbcpsr-modesetfrombusy
[110.084920] Subtest fbcpsr-modesetfrombusy: SKIP (0.000s)
[110.678509] [025/133] (921s left) perf (gen12-oa-tlb-invalidate)
[110.819140] Subtest gen12-oa-tlb-invalidate: SKIP (0.000s)
[110.867814] [026/133] (921s left) gem_eio (hibernate)
[110.931481] Starting subtest: hibernate
[125.377059] Subtest hibernate: SUCCESS (14.442s)
[132.419143] [027/133] (905s left) kms_frontbuffer_tracking (psr-2p-rte)
[132.927389] Starting subtest: psr-2p-rte
[132.930697] Subtest psr-2p-rte: SKIP (0.000s)
[133.544170] [028/133] (904s left) gem_sync (basic-store-all)
[133.613719] Starting subtest: basic-store-all
[135.868476] Subtest basic-store-all: SUCCESS (2.255s)
[136.084101] [029/133] (902s left) gem_exec_reloc (basic-wc-read-noreloc)
[136.144427] Starting subtest: basic-wc-read-noreloc
[136.145970] Subtest basic-wc-read-noreloc: SUCCESS (0.002s)
[137.184894] [030/133] (901s left) kms_flip (2x-absolute-wf_vblank)
[137.677172] Starting subtest: 2x-absolute-wf_vblank
[137.679128] Starting dynamic subtest: AB-VGA1-HDMI-A1
[168.111615] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (30.438s)
[168.113547] Subtest 2x-absolute-wf_vblank: SUCCESS (30.442s)
[168.937890] [031/133] (869s left) kms_psr (fbc-psr2-no-drrs)
[169.433836] Subtest fbc-psr2-no-drrs: SKIP (0.000s)
[169.729572] [032/133] (868s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[169.791206] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.000s)
[169.842804] [033/133] (868s left) kms_rotation_crc (primary-y-tiled-reflect-x-90)
[170.333022] Starting subtest: primary-y-tiled-reflect-x-90
[170.336380] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s)
[170.931022] [034/133] (867s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[171.423090] Starting subtest: plane-downscale-factor-0-75-with-rotation
[171.424764] Starting dynamic subtest: pipe-A
[171.429620] Dynamic subtest pipe-A: SKIP (0.001s)
[171.441546] Starting dynamic subtest: pipe-B
[171.446346] Dynamic subtest pipe-B: SKIP (0.001s)
[171.449530] Subtest plane-downscale-factor-0-75-with-rotation: SKIP (0.004s)
[172.028786] [035/133] (866s left) kms_psr (pr-primary-mmap-cpu)
[172.516134] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[172.817582] [036/133] (865s left) gem_flink_race (flink_name)
[172.877112] Starting subtest: flink_name
[178.251245] Subtest flink_name: SUCCESS (5.373s)
[178.382715] [037/133] (860s left) gem_exec_whisper (basic-sync)
[178.457574] Starting subtest: basic-sync
[179.769435] Subtest basic-sync: SUCCESS (1.309s)
[180.021424] [038/133] (858s left) gem_exec_whisper (basic-contexts-forked-all)
[180.090079] Starting subtest: basic-contexts-forked-all
[183.291508] Subtest basic-contexts-forked-all: SUCCESS (3.200s)
[183.536206] [039/133] (855s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[184.023176] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[184.026739] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[184.638594] [040/133] (854s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[185.128732] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.000s)
[185.427589] [041/133] (853s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[185.491074] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s)
[185.546211] [042/133] (853s left) kms_setmode (invalid-clone-single-crtc-stealing)
[185.602350] Starting subtest: invalid-clone-single-crtc-stealing
[185.607431] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[185.738150] [043/133] (853s left) gem_exec_schedule (preempt-user)
[185.808527] Subtest preempt-user: SKIP (0.000s)
[186.050886] [044/133] (853s left) gem_render_copy (y-tiled-to-vebox-linear)
[186.119246] Starting subtest: y-tiled-to-vebox-linear
[186.123332] Subtest y-tiled-to-vebox-linear: SKIP (0.000s)
[186.355859] [045/133] (852s left) prime_vgem (coherency-gtt)
[186.452989] Starting subtest: coherency-gtt
[186.467419] Subtest coherency-gtt: SUCCESS (0.015s)
[186.625970] [FACT prime_vgem (coherency-gtt)] new: kernel.kmod_is_loaded.vgem: true
[186.631282] [046/133] (852s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[187.129833] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[187.133198] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[187.720486] [047/133] (851s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic)
[188.211289] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic
[191.440417] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (3.229s)
[192.172981] [048/133] (847s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[192.244170] Starting subtest: etime-single-wait-for-submit-unsubmitted
[192.346870] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.104s)
[192.491939] [049/133] (846s left) kms_psr (psr-no-drrs)
[192.984639] Subtest psr-no-drrs: SKIP (0.000s)
[193.289452] [050/133] (846s left) kms_cursor_crc (cursor-random-32x10)
[193.784783] Starting subtest: cursor-random-32x10
[193.843714] Subtest cursor-random-32x10: SKIP (0.057s)
[194.460450] [051/133] (845s left) kms_cursor_crc (cursor-onscreen-256x256)
[194.956752] Starting subtest: cursor-onscreen-256x256
[194.958856] Starting dynamic subtest: pipe-A-HDMI-A-1
[197.179077] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.221s)
[197.220249] Starting dynamic subtest: pipe-B-HDMI-A-1
[199.435057] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.226s)
[199.436772] Subtest cursor-onscreen-256x256: SUCCESS (4.480s)
[200.162864] [052/133] (839s left) gem_softpin (reverse)
[200.232554] Starting subtest: reverse
[200.236359] Subtest reverse: SUCCESS (0.006s)
[200.396495] [053/133] (839s left) kms_cursor_edge_walk (256x256-top-edge)
[200.892844] Starting subtest: 256x256-top-edge
[200.894547] Starting dynamic subtest: pipe-A-HDMI-A-1
[204.325461] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.430s)
[204.340140] Starting dynamic subtest: pipe-B-HDMI-A-1
[207.655128] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.328s)
[207.656870] Subtest 256x256-top-edge: SUCCESS (6.762s)
[208.375143] [054/133] (831s left) gem_lmem_swapping (verify-ccs)
[208.443837] Subtest verify-ccs: SKIP (0.000s)
[208.525133] [055/133] (831s left) i915_drm_fdinfo (virtual-busy-idle-all)
[208.589705] Subtest virtual-busy-idle-all: SKIP (0.000s)
[208.653478] [056/133] (831s left) kms_debugfs (display-off-read-all)
[209.145547] Starting subtest: display-off-read-all
[209.220802] Subtest display-off-read-all: SUCCESS (0.076s)
[209.942496] [057/133] (829s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[210.005903] Subtest parallel-dmabuf-import-out-fence: SKIP (0.000s)
[210.141053] [058/133] (829s left) kms_psr (psr2-primary-page-flip)
[210.634671] Subtest psr2-primary-page-flip: SKIP (0.000s)
[210.938725] [059/133] (829s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[211.434540] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[211.438126] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[212.044220] [060/133] (828s left) gem_exec_schedule (fifo)
[212.117591] Starting subtest: fifo
[212.119337] Starting dynamic subtest: rcs0
[212.150090] Dynamic subtest rcs0: SUCCESS (0.031s)
[212.167925] Starting dynamic subtest: bcs0
[212.181263] Dynamic subtest bcs0: SUCCESS (0.029s)
[212.183030] Subtest fifo: SUCCESS (0.065s)
[212.457410] [061/133] (827s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[212.951387] Starting subtest: addfb25-x-tiled-legacy
[212.953879] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[213.570107] [062/133] (826s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted)
[213.637092] Starting subtest: multi-wait-all-for-submit-unsubmitted
[213.739661] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.104s)
[213.855237] [063/133] (826s left) kms_pm_lpsp (screens-disabled)
[225.387138] Starting subtest: screens-disabled
[225.526482] Subtest screens-disabled: SKIP (0.140s)
[226.240813] [064/133] (814s left) kms_setmode (invalid-clone-exclusive-crtc)
[226.302875] Starting subtest: invalid-clone-exclusive-crtc
[226.308014] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s)
[226.451225] [065/133] (813s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[226.941401] Starting subtest: cursorB-vs-flipA-atomic-transitions
[226.944804] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s)
[227.538174] [066/133] (812s left) kms_plane_scaling (planes-upscale-factor-0-25)
[228.030017] Starting subtest: planes-upscale-factor-0-25
[228.031852] Starting dynamic subtest: pipe-A
[228.036870] Dynamic subtest pipe-A: SKIP (0.001s)
[228.050902] Starting dynamic subtest: pipe-B
[228.055810] Dynamic subtest pipe-B: SKIP (0.001s)
[228.059044] Subtest planes-upscale-factor-0-25: SKIP (0.006s)
[228.651740] [067/133] (811s left) kms_atomic (test-only)
[229.143744] Starting subtest: test-only
[229.199032] Starting dynamic subtest: pipe-A-HDMI-A-1
[229.701254] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.504s)
[229.702847] Subtest test-only: SUCCESS (0.559s)
[230.439031] [068/133] (810s left) dmabuf_sync_file (export-before-signal)
[230.514464] Starting subtest: export-before-signal
[230.516121] Subtest export-before-signal: SUCCESS (0.002s)
[230.631740] [069/133] (810s left) kms_chamelium_color (ctm-0-50)
[231.118737] Subtest ctm-0-50: SKIP (0.000s)
[231.426167] [070/133] (809s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[231.922077] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[232.425550] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.503s)
[233.118167] [071/133] (807s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[233.613278] Starting subtest: fbc-tiling-linear
[241.507435] Subtest fbc-tiling-linear: SUCCESS (7.896s)
[242.142791] [072/133] (798s left) gem_tiled_blits (basic)
[242.628940] Starting subtest: basic
[242.647720] Subtest basic: SUCCESS (0.019s)
[242.825144] [073/133] (798s left) kms_addfb_basic (unused-modifier)
[242.961556] Starting subtest: unused-modifier
[242.963160] Subtest unused-modifier: SUCCESS (0.000s)
[244.012315] [074/133] (796s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[246.587707] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted
[246.591862] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SKIP (0.000s)
[246.727262] [075/133] (794s left) gem_fence_thrash (bo-write-verify-threaded-y)
[246.783862] Starting subtest: bo-write-verify-threaded-y
[248.865051] Subtest bo-write-verify-threaded-y: SUCCESS (2.081s)
[249.013286] [076/133] (792s left) i915_drm_fdinfo (all-busy-check-all)
[249.072728] Subtest all-busy-check-all: SKIP (0.000s)
[249.159461] [077/133] (792s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[249.653202] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[250.720931] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (1.067s)
[251.449851] [078/133] (789s left) syncobj_eventfd (invalid-bad-flags)
[251.522110] Starting subtest: invalid-bad-flags
[251.524193] Subtest invalid-bad-flags: SUCCESS (0.000s)
[251.662881] [079/133] (789s left) kms_pm_rpm (legacy-planes)
[263.457226] Subtest legacy-planes: SKIP (0.000s)
[263.770878] [080/133] (777s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[264.275530] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[264.278704] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[264.864088] [081/133] (776s left) kms_addfb_basic (too-wide)
[265.351689] Starting subtest: too-wide
[265.353638] Subtest too-wide: SUCCESS (0.000s)
[265.970917] [082/133] (775s left) gem_eio (in-flight-immediate)
[266.042905] Starting subtest: in-flight-immediate
[267.435675] Subtest in-flight-immediate: SUCCESS (1.391s)
[268.479449] [083/133] (773s left) gem_ctx_param (invalid-ctx-set)
[268.540059] Starting subtest: invalid-ctx-set
[268.541804] Subtest invalid-ctx-set: SUCCESS (0.000s)
[268.674977] [084/133] (772s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[269.165912] Starting subtest: cursor-vs-flip-atomic
[299.872216] Subtest cursor-vs-flip-atomic: SUCCESS (30.706s)
[300.599781] [085/133] (741s left) syncobj_wait (single-wait-all-submitted)
[300.664489] Starting subtest: single-wait-all-submitted
[300.770651] Subtest single-wait-all-submitted: SUCCESS (0.107s)
[300.911265] [086/133] (740s left) gem_partial_pwrite_pread (writes-after-reads-snoop)
[300.971924] Starting subtest: writes-after-reads-snoop
[305.961718] Subtest writes-after-reads-snoop: SUCCESS (4.991s)
[306.130468] [087/133] (735s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[306.630375] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[306.633606] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[307.243992] [088/133] (734s left) gem_exec_schedule (preemptive-hang)
[307.317551] Subtest preemptive-hang: SKIP (0.000s)
[307.560827] [089/133] (734s left) gem_readwrite (write-bad-handle)
[307.620994] Starting subtest: write-bad-handle
[307.624919] Subtest write-bad-handle: SUCCESS (0.000s)
[307.775790] [090/133] (734s left) kms_color (ctm-negative)
[308.269457] Starting subtest: ctm-negative
[308.271269] Starting dynamic subtest: pipe-A-HDMI-A-1
[308.749355] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.478s)
[308.763913] Starting dynamic subtest: pipe-B-HDMI-A-1
[309.272824] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.523s)
[309.274458] Subtest ctm-negative: SUCCESS (1.004s)
[309.984582] [091/133] (732s left) gem_exec_params (invalid-bsd1-flag-on-render)
[310.052238] Starting subtest: invalid-bsd1-flag-on-render
[310.053993] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s)
[310.198495] [092/133] (731s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[310.700821] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[310.704130] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[311.324826] [093/133] (730s left) kms_feature_discovery (psr2)
[311.813730] Starting subtest: psr2
[311.818304] Subtest psr2: SKIP (0.000s)
[312.432857] [094/133] (729s left) i915_query (query-topology-coherent-slice-mask)
[312.496011] Starting subtest: query-topology-coherent-slice-mask
[312.499567] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[312.631919] [095/133] (729s left) kms_lease (cursor-implicit-plane)
[313.126801] Starting subtest: cursor-implicit-plane
[313.128575] Starting dynamic subtest: pipe-A-HDMI-A-1
[313.354778] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.227s)
[313.372582] Starting dynamic subtest: pipe-B-HDMI-A-1
[313.602970] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.245s)
[313.604943] Subtest cursor-implicit-plane: SUCCESS (0.478s)
[314.328441] [096/133] (728s left) gem_ctx_isolation (dirty-create)
[314.399153] Starting subtest: dirty-create
[314.401030] Starting dynamic subtest: rcs0
[314.972113] Dynamic subtest rcs0: SUCCESS (0.571s)
[314.973817] Subtest dirty-create: SUCCESS (0.573s)
[315.245689] [097/133] (727s left) gem_exec_balancer (busy)
[315.309842] Subtest busy: SKIP (0.000s)
[315.454944] [098/133] (727s left) gem_ctx_persistence (heartbeat-hostile)
[315.515728] Subtest heartbeat-hostile: SKIP (0.000s)
[315.585346] [099/133] (726s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[315.655744] Starting subtest: yf-tiled-ccs-to-yf-tiled
[315.657436] Starting dynamic subtest: smem
[315.661112] Dynamic subtest smem: SKIP (0.000s)
[315.665022] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.002s)
[315.894705] [100/133] (726s left) kms_invalid_mode (bad-vsync-end)
[316.392361] Starting subtest: bad-vsync-end
[316.394146] Starting dynamic subtest: pipe-A-HDMI-A-1
[316.467217] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.074s)
[316.485064] Starting dynamic subtest: pipe-B-HDMI-A-1
[316.486856] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s)
[316.488718] Subtest bad-vsync-end: SUCCESS (0.079s)
[316.967525] [101/133] (725s left) kms_psr2_su (frontbuffer-xrgb8888)
[317.030193] Subtest frontbuffer-XRGB8888: SKIP (0.000s)
[317.093202] [102/133] (725s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc)
[317.153544] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SKIP (0.000s)
[317.228421] [103/133] (725s left) gem_exec_fence (submit3)
[317.404768] Subtest submit3: SKIP (0.000s)
[317.817074] [104/133] (725s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[317.877141] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.000s)
[317.940165] [105/133] (724s left) sysfs_heartbeat_interval (nopreempt)
[318.003853] Starting subtest: nopreempt
[318.005583] Starting dynamic subtest: vcs0
[318.008833] Dynamic subtest vcs0: SKIP (0.000s)
[318.030668] Starting dynamic subtest: bcs0
[318.035160] Dynamic subtest bcs0: SKIP (0.000s)
[318.058388] Starting dynamic subtest: rcs0
[318.063043] Dynamic subtest rcs0: SKIP (0.000s)
[318.067129] Subtest nopreempt: SKIP (0.005s)
[318.144695] [106/133] (724s left) perf_pmu (init-wait)
[318.204908] Starting subtest: init-wait
[318.206704] Starting dynamic subtest: rcs0
[318.208377] Dynamic subtest rcs0: SUCCESS (0.001s)
[318.228989] Starting dynamic subtest: bcs0
[318.231319] Dynamic subtest bcs0: SUCCESS (0.000s)
[318.254684] Starting dynamic subtest: vcs0
[318.256951] Dynamic subtest vcs0: SUCCESS (0.000s)
[318.259152] Subtest init-wait: SUCCESS (0.006s)
[318.343542] [107/133] (724s left) kms_big_fb (linear-32bpp-rotate-180)
[318.842316] Starting subtest: linear-32bpp-rotate-180
[320.350246] Subtest linear-32bpp-rotate-180: SUCCESS (1.507s)
[320.988868] [108/133] (722s left) kms_content_protection (uevent-hdcp14)
[321.493867] Starting subtest: uevent-hdcp14
[321.497293] Subtest uevent-hdcp14: SKIP (0.000s)
[322.102913] [109/133] (721s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[322.600064] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (0.000s)
[322.896195] [110/133] (720s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[323.394943] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[323.399507] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[324.018640] [111/133] (719s left) kms_plane_lowres (tiling-x)
[324.512195] Starting subtest: tiling-x
[324.513936] Starting dynamic subtest: pipe-A-HDMI-A-1
[327.078025] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.564s)
[327.175682] Starting dynamic subtest: pipe-B-HDMI-A-1
[329.611699] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.449s)
[329.695307] Subtest tiling-x: SUCCESS (5.183s)
[330.436748] [112/133] (712s left) kms_vblank (wait-forked-hang)
[330.932810] Starting subtest: wait-forked-hang
[330.934978] Starting dynamic subtest: pipe-A-HDMI-A-1
[336.952733] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.018s)
[336.967775] Starting dynamic subtest: pipe-B-HDMI-A-1
[342.921994] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (5.967s)
[342.923728] Subtest wait-forked-hang: SUCCESS (11.991s)
[343.639849] [113/133] (699s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[344.135936] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[344.139291] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[344.757930] [114/133] (698s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[345.256299] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu
[345.259468] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[345.851080] [115/133] (697s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[346.345654] Starting subtest: basic-max-pipe-crc-check
[346.349095] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[346.643639] [116/133] (696s left) gem_blits (basic)
[346.707154] Starting subtest: basic
[348.681172] Subtest basic: SUCCESS (1.973s)
[348.845672] [117/133] (694s left) gem_wait (write-busy)
[348.921334] Starting subtest: write-busy
[348.923159] Starting dynamic subtest: all-engines
[349.440363] Dynamic subtest all-engines: SUCCESS (0.518s)
[349.458128] Starting dynamic subtest: rcs0
[349.962337] Dynamic subtest rcs0: SUCCESS (0.519s)
[349.980010] Starting dynamic subtest: bcs0
[350.484504] Dynamic subtest bcs0: SUCCESS (0.519s)
[350.502136] Starting dynamic subtest: vcs0
[351.003203] Dynamic subtest vcs0: SUCCESS (0.516s)
[351.005434] Subtest write-busy: SUCCESS (2.083s)
[351.267933] [118/133] (692s left) kms_chamelium_hpd (hdmi-hpd-storm)
[351.832324] Subtest hdmi-hpd-storm: SKIP (0.000s)
[352.244524] [119/133] (691s left) gem_mmap_offset (close-race)
[352.306155] Starting subtest: close-race
[372.656036] Subtest close-race: SUCCESS (20.348s)
[372.806386] [120/133] (670s left) sw_sync (timeline_closed_signaled)
[372.865813] Starting subtest: timeline_closed_signaled
[372.867678] Subtest timeline_closed_signaled: SUCCESS (0.000s)
[373.000093] [121/133] (670s left) kms_chamelium_frames (hdmi-crc-fast)
[373.568845] Subtest hdmi-crc-fast: SKIP (0.000s)
[373.978445] [122/133] (669s left) perf (stress-open-close)
[374.167908] Subtest stress-open-close: SKIP (0.000s)
[374.230861] [123/133] (669s left) api_intel_bb (object-reloc-purge-cache)
[374.295390] Starting subtest: object-reloc-purge-cache
[374.299300] Subtest object-reloc-purge-cache: SUCCESS (0.004s)
[374.454823] [124/133] (669s left) gem_eio (reset-stress)
[374.518434] Starting subtest: reset-stress
[374.520118] Starting dynamic subtest: render
[376.173271] Dynamic subtest render: SUCCESS (1.653s)
[376.189302] Starting dynamic subtest: bsd
[377.406655] Dynamic subtest bsd: FAIL (1.173s)
[377.420968] Starting dynamic subtest: blt
[378.933087] Dynamic subtest blt: SUCCESS (1.584s)
[378.934865] Subtest reset-stress: FAIL (4.415s)
[379.945303] [125/133] (664s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[380.007413] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SKIP (0.000s)
[380.083760] [126/133] (664s left) gem_flink_race (flink_close)
[380.142981] Starting subtest: flink_close
[385.172013] Subtest flink_close: SUCCESS (5.029s)
[385.315041] [127/133] (658s left) syncobj_timeline (wait-any-snapshot)
[385.381391] Starting subtest: wait-any-snapshot
[385.465071] Subtest wait-any-snapshot: SUCCESS (0.082s)
[385.596502] [128/133] (658s left) kms_big_fb (4-tiled-32bpp-rotate-180)
[386.097319] Starting subtest: 4-tiled-32bpp-rotate-180
[386.100736] Subtest 4-tiled-32bpp-rotate-180: SKIP (0.000s)
[386.709515] [129/133] (657s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[387.201309] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[387.204598] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[387.803925] [130/133] (656s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[388.296523] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s)
[388.601540] [131/133] (655s left) i915_pm_rpm (reg-read-ioctl)
[400.402732] Subtest reg-read-ioctl: SKIP (0.000s)
[400.713608] [132/133] (643s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[401.213612] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[402.670876] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (1.459s)
[403.296415] [133/133] (641s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping)
[403.787212] Starting subtest: pixel-format-4-tiled-modifier-source-clamping
[403.793929] Subtest pixel-format-4-tiled-modifier-source-clamping: SKIP (0.000s)
[404.404380] Closing watchdogs
results: parsing output: 0/ for test: kms_rotation_crc
results: parsing output: 1/ for test: syncobj_timeline
results: parsing output: 2/ for test: kms_universal_plane
results: parsing output: 3/ for test: kms_force_connector_basic
results: parsing output: 4/ for test: gen9_exec_parse
results: parsing output: 5/ for test: i915_pm_rps
results: parsing output: 6/ for test: kms_atomic_transition
results: parsing output: 7/ for test: gem_ctx_shared
results: parsing output: 8/ for test: gem_ctx_param
results: parsing output: 9/ for test: syncobj_basic
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: kms_big_fb
results: parsing output: 12/ for test: gem_close_race
results: parsing output: 13/ for test: gem_sync
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: api_intel_allocator
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: syncobj_timeline
results: parsing output: 19/ for test: kms_ccs
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: kms_flip_scaled_crc
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: perf
results: parsing output: 25/ for test: gem_eio
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: gem_sync
results: parsing output: 28/ for test: gem_exec_reloc
results: parsing output: 29/ for test: kms_flip
results: parsing output: 30/ for test: kms_psr
results: parsing output: 31/ for test: kms_ccs
results: parsing output: 32/ for test: kms_rotation_crc
results: parsing output: 33/ for test: kms_plane_scaling
results: parsing output: 34/ for test: kms_psr
results: parsing output: 35/ for test: gem_flink_race
results: parsing output: 36/ for test: gem_exec_whisper
results: parsing output: 37/ for test: gem_exec_whisper
results: parsing output: 38/ for test: kms_cursor_legacy
results: parsing output: 39/ for test: kms_psr
results: parsing output: 40/ for test: kms_ccs
results: parsing output: 41/ for test: kms_setmode
results: parsing output: 42/ for test: gem_exec_schedule
results: parsing output: 43/ for test: gem_render_copy
results: parsing output: 44/ for test: prime_vgem
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_cursor_legacy
results: parsing output: 47/ for test: syncobj_timeline
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: kms_cursor_crc
results: parsing output: 50/ for test: kms_cursor_crc
results: parsing output: 51/ for test: gem_softpin
results: parsing output: 52/ for test: kms_cursor_edge_walk
results: parsing output: 53/ for test: gem_lmem_swapping
results: parsing output: 54/ for test: i915_drm_fdinfo
results: parsing output: 55/ for test: kms_debugfs
results: parsing output: 56/ for test: gem_exec_balancer
results: parsing output: 57/ for test: kms_psr
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: gem_exec_schedule
results: parsing output: 60/ for test: kms_addfb_basic
results: parsing output: 61/ for test: syncobj_wait
results: parsing output: 62/ for test: kms_pm_lpsp
results: parsing output: 63/ for test: kms_setmode
results: parsing output: 64/ for test: kms_cursor_legacy
results: parsing output: 65/ for test: kms_plane_scaling
results: parsing output: 66/ for test: kms_atomic
results: parsing output: 67/ for test: dmabuf_sync_file
results: parsing output: 68/ for test: kms_chamelium_color
results: parsing output: 69/ for test: kms_big_fb
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: gem_tiled_blits
results: parsing output: 72/ for test: kms_addfb_basic
results: parsing output: 73/ for test: gem_pxp
results: parsing output: 74/ for test: gem_fence_thrash
results: parsing output: 75/ for test: i915_drm_fdinfo
results: parsing output: 76/ for test: kms_cursor_legacy
results: parsing output: 77/ for test: syncobj_eventfd
results: parsing output: 78/ for test: kms_pm_rpm
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_addfb_basic
results: parsing output: 81/ for test: gem_eio
results: parsing output: 82/ for test: gem_ctx_param
results: parsing output: 83/ for test: kms_cursor_legacy
results: parsing output: 84/ for test: syncobj_wait
results: parsing output: 85/ for test: gem_partial_pwrite_pread
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_exec_schedule
results: parsing output: 88/ for test: gem_readwrite
results: parsing output: 89/ for test: kms_color
results: parsing output: 90/ for test: gem_exec_params
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: kms_feature_discovery
results: parsing output: 93/ for test: i915_query
results: parsing output: 94/ for test: kms_lease
results: parsing output: 95/ for test: gem_ctx_isolation
results: parsing output: 96/ for test: gem_exec_balancer
results: parsing output: 97/ for test: gem_ctx_persistence
results: parsing output: 98/ for test: gem_render_copy
results: parsing output: 99/ for test: kms_invalid_mode
results: parsing output: 100/ for test: kms_psr2_su
results: parsing output: 101/ for test: kms_ccs
results: parsing output: 102/ for test: gem_exec_fence
results: parsing output: 103/ for test: kms_ccs
results: parsing output: 104/ for test: sysfs_heartbeat_interval
results: parsing output: 105/ for test: perf_pmu
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: kms_content_protection
results: parsing output: 108/ for test: kms_psr2_sf
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: kms_plane_lowres
results: parsing output: 111/ for test: kms_vblank
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: kms_multipipe_modeset
results: parsing output: 115/ for test: gem_blits
results: parsing output: 116/ for test: gem_wait
results: parsing output: 117/ for test: kms_chamelium_hpd
results: parsing output: 118/ for test: gem_mmap_offset
results: parsing output: 119/ for test: sw_sync
results: parsing output: 120/ for test: kms_chamelium_frames
results: parsing output: 121/ for test: perf
results: parsing output: 122/ for test: api_intel_bb
results: parsing output: 123/ for test: gem_eio
results: parsing output: 124/ for test: kms_flip_scaled_crc
results: parsing output: 125/ for test: gem_flink_race
results: parsing output: 126/ for test: syncobj_timeline
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_psr2_sf
results: parsing output: 130/ for test: i915_pm_rpm
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: kms_plane
Done.