[69.114206] Initializing watchdogs
[69.114359]   /dev/watchdog0
[69.138437] [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.146425] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[69.149968] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[69.154644] [001/131] (960s left) gem_spin_batch (resubmit-new-all)
[69.257095] Starting subtest: resubmit-new-all
[69.258756] Starting dynamic subtest: rcs0
[69.260536] Dynamic subtest rcs0: SUCCESS (0.003s)
[69.270909] Starting dynamic subtest: bcs0
[69.272827] Dynamic subtest bcs0: SUCCESS (0.002s)
[69.281997] Starting dynamic subtest: vcs0
[69.283793] Dynamic subtest vcs0: SUCCESS (0.002s)
[69.285409] Subtest resubmit-new-all: SUCCESS (0.008s)
[69.497670] [002/131] (960s left) gem_userptr_blits (unsync-unmap-cycles)
[69.562082] Subtest unsync-unmap-cycles: SKIP (0.000s)
[69.713834] [003/131] (960s left) gem_exec_whisper (basic-sync)
[69.782749] Starting subtest: basic-sync
[71.134046] Subtest basic-sync: SUCCESS (1.349s)
[71.364161] [004/131] (958s left) kms_psr (psr2-sprite-plane-move)
[71.663822] Subtest psr2-sprite-plane-move: SKIP (0.000s)
[71.852319] [005/131] (958s left) api_intel_bb (render)
[71.914138] Starting subtest: render
[71.916422] Starting dynamic subtest: render-none-512
[72.010673] Dynamic subtest render-none-512: SUCCESS (0.095s)
[72.020930] Starting dynamic subtest: render-none-reloc-512
[72.100164] Dynamic subtest render-none-reloc-512: SUCCESS (0.089s)
[72.110702] Starting dynamic subtest: render-none-1024
[72.440575] Dynamic subtest render-none-1024: SUCCESS (0.340s)
[72.451022] Starting dynamic subtest: render-none-reloc-1024
[72.780523] Dynamic subtest render-none-reloc-1024: SUCCESS (0.339s)
[72.791106] Starting dynamic subtest: render-x-512
[72.860584] Dynamic subtest render-x-512: SUCCESS (0.079s)
[72.870958] Starting dynamic subtest: render-x-reloc-512
[72.938967] Dynamic subtest render-x-reloc-512: SUCCESS (0.078s)
[72.949493] Starting dynamic subtest: render-x-1024
[73.231875] Dynamic subtest render-x-1024: SUCCESS (0.292s)
[73.243380] Starting dynamic subtest: render-x-reloc-1024
[73.534153] Dynamic subtest render-x-reloc-1024: SUCCESS (0.302s)
[73.544441] Starting dynamic subtest: render-y-512
[73.613036] Dynamic subtest render-y-512: SUCCESS (0.078s)
[73.624069] Starting dynamic subtest: render-y-reloc-512
[73.690528] Dynamic subtest render-y-reloc-512: SUCCESS (0.077s)
[73.701021] Starting dynamic subtest: render-y-1024
[73.987749] Dynamic subtest render-y-1024: SUCCESS (0.297s)
[73.998199] Starting dynamic subtest: render-y-reloc-1024
[74.286699] Dynamic subtest render-y-reloc-1024: SUCCESS (0.298s)
[74.288927] Subtest render: SUCCESS (2.372s)
[74.449735] [006/131] (955s left) gen9_exec_parse (shadow-peek)
[74.517915] Subtest shadow-peek: SKIP (0.000s)
[74.581575] [007/131] (955s left) kms_content_protection (mei-interface)
[74.893351] Starting subtest: mei-interface
[74.896582] Subtest mei-interface: SKIP (0.002s)
[75.301395] [008/131] (954s left) gem_exec_flush (basic-batch-kernel-default-uc)
[75.368861] Starting subtest: basic-batch-kernel-default-uc
[81.035888] Subtest basic-batch-kernel-default-uc: SUCCESS (5.669s)
[81.278122] [009/131] (948s left) gen9_exec_parse (allowed-single)
[81.345875] Subtest allowed-single: SKIP (0.000s)
[81.399494] [010/131] (948s left) gem_ctx_persistence (hostile)
[81.462546] Subtest hostile: SKIP (0.000s)
[81.517711] [011/131] (948s left) gem_ctx_bad_destroy (invalid-ctx)
[81.577852] Starting subtest: invalid-ctx
[81.579745] Subtest invalid-ctx: SUCCESS (0.000s)
[81.705022] [012/131] (948s left) kms_busy (basic-hang)
[82.006953] Starting subtest: basic-hang
[82.008759] Starting dynamic subtest: flip-pipe-A
[82.593064] Dynamic subtest flip-pipe-A: SUCCESS (0.586s)
[82.604019] Starting dynamic subtest: modeset-pipe-A
[83.340813] Dynamic subtest modeset-pipe-A: SUCCESS (0.746s)
[83.351836] Starting dynamic subtest: flip-pipe-B
[83.759144] Dynamic subtest flip-pipe-B: SUCCESS (0.417s)
[83.770730] Starting dynamic subtest: modeset-pipe-B
[84.526481] Dynamic subtest modeset-pipe-B: SUCCESS (0.769s)
[84.528197] Subtest basic-hang: SUCCESS (2.522s)
[85.047805] [013/131] (945s left) gem_userptr_blits (relocations)
[85.117579] Starting subtest: relocations
[85.119160] Subtest relocations: SUCCESS (0.001s)
[85.303869] [014/131] (945s left) kms_vblank (wait-forked)
[85.592112] Starting subtest: wait-forked
[85.594184] Starting dynamic subtest: pipe-A-HDMI-A-1
[87.845254] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.250s)
[87.858216] Starting dynamic subtest: pipe-B-HDMI-A-1
[90.133909] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.289s)
[90.135625] Subtest wait-forked: SUCCESS (4.542s)
[90.655777] [015/131] (939s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[90.956951] Starting subtest: cursorB-vs-flipA-toggle
[90.960351] Subtest cursorB-vs-flipA-toggle: SKIP (0.002s)
[91.369676] [016/131] (939s left) syncobj_wait (reset-during-wait-for-submit)
[91.430183] Starting subtest: reset-during-wait-for-submit
[91.532204] Subtest reset-during-wait-for-submit: SUCCESS (0.102s)
[91.648643] [017/131] (938s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[91.955842] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[91.971085] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[92.349541] [018/131] (938s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[92.652385] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[92.842595] [019/131] (937s left) sw_sync (sync_busy_fork_unixsocket)
[92.898777] Starting subtest: sync_busy_fork_unixsocket
[92.913113] Subtest sync_busy_fork_unixsocket: SUCCESS (0.014s)
[93.038768] [020/131] (937s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[93.095732] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.000s)
[93.155130] [021/131] (937s left) drm_read (short-buffer-wakeup)
[93.500412] Starting subtest: short-buffer-wakeup
[125.715764] Subtest short-buffer-wakeup: SUCCESS (32.216s)
[126.161926] [022/131] (904s left) kms_psr (fbc-psr-primary-blt)
[126.459657] Subtest fbc-psr-primary-blt: SKIP (0.000s)
[126.656168] [023/131] (904s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[126.961550] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[126.964883] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[127.364754] [024/131] (903s left) i915_pm_rpm (gem-evict-pwrite)
[138.874134] Subtest gem-evict-pwrite: SKIP (0.000s)
[139.063990] [025/131] (891s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[139.366286] Starting subtest: fbcpsr-slowdraw
[139.369709] Subtest fbcpsr-slowdraw: SKIP (0.000s)
[139.777030] [026/131] (891s left) perf (oa-exponents)
[139.927033] Subtest oa-exponents: SKIP (0.000s)
[139.978266] [027/131] (891s left) gem_exec_fence (basic-wait)
[140.151471] Subtest basic-wait: SKIP (0.000s)
[140.601021] [FACT gem_exec_fence (basic-wait)] new: kernel.kmod_is_loaded.vgem: true
[140.604764] [028/131] (890s left) gem_mmap_gtt (big-copy-odd)
[140.665518] Starting subtest: big-copy-odd
[142.548826] Subtest big-copy-odd: SUCCESS (1.883s)
[142.725843] [029/131] (888s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[143.113217] Starting subtest: cursorB-vs-flipA-atomic
[143.116752] Subtest cursorB-vs-flipA-atomic: SKIP (0.002s)
[143.539410] [030/131] (887s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[143.836473] Starting subtest: flip-vs-cursor-legacy
[153.890218] Subtest flip-vs-cursor-legacy: SUCCESS (10.055s)
[154.412846] [031/131] (876s left) kms_flip (2x-blocking-absolute-wf_vblank)
[154.710542] Starting subtest: 2x-blocking-absolute-wf_vblank
[154.712286] Starting dynamic subtest: AB-VGA1-HDMI-A1
[185.139197] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (30.427s)
[185.142832] Subtest 2x-blocking-absolute-wf_vblank: SUCCESS (30.431s)
[185.739996] [032/131] (845s left) gem_bad_reloc (negative-reloc-bltcopy)
[185.800938] Starting subtest: negative-reloc-bltcopy
[186.184468] Subtest negative-reloc-bltcopy: SUCCESS (0.382s)
[186.420939] [033/131] (844s left) kms_addfb_basic (addfb25-bad-modifier)
[186.723028] Starting subtest: addfb25-bad-modifier
[186.724802] Subtest addfb25-bad-modifier: SUCCESS (0.001s)
[187.138873] [034/131] (844s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[187.441402] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[187.444767] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[187.840737] [035/131] (843s left) kms_flip (2x-flip-vs-panning-vs-hang)
[188.135363] Starting subtest: 2x-flip-vs-panning-vs-hang
[188.137140] Starting dynamic subtest: AB-VGA1-HDMI-A1
[200.899559] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (12.755s)
[200.901108] Subtest 2x-flip-vs-panning-vs-hang: SUCCESS (12.757s)
[201.522365] [036/131] (830s left) dumb_buffer (map-valid)
[201.586362] Starting subtest: map-valid
[201.588151] Subtest map-valid: SUCCESS (0.000s)
[201.738836] [037/131] (829s left) gem_userptr_blits (stress-purge)
[201.809711] Starting subtest: stress-purge
[207.208776] Subtest stress-purge: SUCCESS (5.399s)
[207.385691] [038/131] (824s left) gem_userptr_blits (sync-overlap)
[207.536623] Starting subtest: sync-overlap
[207.538188] Subtest sync-overlap: SUCCESS (0.000s)
[207.705359] [039/131] (824s left) gem_exec_params (mmapped)
[207.767112] Starting subtest: mmapped
[207.768839] Subtest mmapped: SUCCESS (0.002s)
[207.922390] [040/131] (823s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[208.229335] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[208.232601] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[208.647629] [041/131] (823s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible)
[208.956691] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible
[208.958490] Starting dynamic subtest: AB-VGA1-HDMI-A1
[239.699098] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (30.741s)
[239.703141] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SUCCESS (30.744s)
[240.330584] [042/131] (791s left) gem_exec_fence (basic-wait-all)
[240.401136] Starting subtest: basic-wait-all
[240.433472] Subtest basic-wait-all: SUCCESS (0.034s)
[240.965731] [043/131] (791s left) gem_mmap_offset (open-flood)
[241.029476] Starting subtest: open-flood
[262.611364] Subtest open-flood: SUCCESS (21.510s)
[262.798122] [044/131] (769s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[263.046971] Starting subtest: etime-single-wait-for-submit-unsubmitted
[263.151239] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.103s)
[263.407426] [045/131] (768s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[263.833072] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[263.834667] Starting dynamic subtest: pipe-A
[263.839366] Dynamic subtest pipe-A: SKIP (0.001s)
[263.853306] Starting dynamic subtest: pipe-B
[263.857929] Dynamic subtest pipe-B: SKIP (0.001s)
[263.861036] Subtest planes-unity-scaling-downscale-factor-0-75: SKIP (0.004s)
[264.165904] [046/131] (768s left) gem_exec_fence (keep-in-fence)
[264.342776] Subtest keep-in-fence: SKIP (0.000s)
[264.766069] [047/131] (767s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[265.058742] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[265.060350] Starting dynamic subtest: pipe-A
[265.065046] Dynamic subtest pipe-A: SKIP (0.001s)
[265.078029] Starting dynamic subtest: pipe-B
[265.082747] Dynamic subtest pipe-B: SKIP (0.001s)
[265.085863] Subtest plane-scaler-unity-scaling-with-modifiers: SKIP (0.004s)
[265.478396] [048/131] (767s left) gem_tiled_blits (basic)
[265.723035] Starting subtest: basic
[265.738549] Subtest basic: SUCCESS (0.016s)
[265.904424] [049/131] (766s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[266.287660] Starting subtest: flip-vs-cursor-crc-atomic
[266.868453] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.581s)
[267.386628] [050/131] (765s left) syncobj_wait (wait-any-complex)
[267.459187] Starting subtest: wait-any-complex
[267.523711] Subtest wait-any-complex: SUCCESS (0.063s)
[267.656903] [051/131] (765s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[267.962839] Starting subtest: yf-tiled-16bpp-rotate-270
[267.994076] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[268.376833] [052/131] (764s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[268.682069] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[268.685295] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[269.085371] [053/131] (763s left) kms_prime (basic-crc-vgem)
[269.399633] Starting subtest: basic-crc-vgem
[269.401281] Starting dynamic subtest: second-to-first
[270.634291] Dynamic subtest second-to-first: SUCCESS (1.236s)
[270.636503] Subtest basic-crc-vgem: SUCCESS (1.238s)
[271.695578] [054/131] (761s left) kms_pm_dc (dc5-dpms)
[282.806943] Subtest dc5-dpms: SKIP (0.000s)
[282.870885] [055/131] (750s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[283.172740] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[283.176029] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[283.589730] [056/131] (749s left) kms_plane_alpha_blend (alpha-opaque-fb)
[283.886109] Starting subtest: alpha-opaque-fb
[284.046903] Subtest alpha-opaque-fb: SKIP (0.161s)
[284.638881] [057/131] (748s left) kms_color (ctm-negative)
[284.937992] Starting subtest: ctm-negative
[284.940140] Starting dynamic subtest: pipe-A-HDMI-A-1
[285.412786] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.475s)
[285.425229] Starting dynamic subtest: pipe-B-HDMI-A-1
[285.906101] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.493s)
[285.907799] Subtest ctm-negative: SUCCESS (0.971s)
[286.429040] [058/131] (746s left) kms_joiner (basic-force-big-joiner)
[286.725548] Subtest basic-force-big-joiner: SKIP (0.000s)
[287.146691] [059/131] (746s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[287.449203] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[289.319466] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (1.872s)
[289.766041] [060/131] (743s left) i915_pm_rps (waitboost)
[289.830320] Starting subtest: waitboost
[293.364841] Subtest waitboost: SUCCESS (3.534s)
[293.502076] [061/131] (739s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[293.562716] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[293.629921] [062/131] (739s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[293.932875] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[293.936308] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[294.358358] [063/131] (739s left) kms_feature_discovery (chamelium)
[294.652570] Starting subtest: chamelium
[294.655815] Subtest chamelium: SKIP (0.000s)
[295.063049] [064/131] (738s left) kms_psr (fbc-pr-sprite-plane-onoff)
[295.357045] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[295.558856] [065/131] (738s left) perf_pmu (init-wait)
[295.619705] Starting subtest: init-wait
[295.621476] Starting dynamic subtest: rcs0
[295.623100] Dynamic subtest rcs0: SUCCESS (0.001s)
[295.639142] Starting dynamic subtest: bcs0
[295.641171] Dynamic subtest bcs0: SUCCESS (0.000s)
[295.662407] Starting dynamic subtest: vcs0
[295.664604] Dynamic subtest vcs0: SUCCESS (0.001s)
[295.666687] Subtest init-wait: SUCCESS (0.007s)
[295.761362] [066/131] (737s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[296.066233] Starting subtest: y-tiled-16bpp-rotate-270
[296.069531] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[296.474884] [067/131] (737s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[296.773863] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[296.777199] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[297.191547] [068/131] (736s left) kms_force_connector_basic (force-load-detect)
[297.266112] Starting subtest: force-load-detect
[297.466459] Subtest force-load-detect: SUCCESS (0.203s)
[297.897437] [069/131] (735s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[297.957156] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SKIP (0.000s)
[298.034705] [070/131] (735s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[298.335974] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[298.339283] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[298.750811] [071/131] (735s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[299.049349] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[299.241789] [072/131] (734s left) gem_mmap_gtt (cpuset-big-copy-xy)
[299.302764] Starting subtest: cpuset-big-copy-XY
[302.554298] Subtest cpuset-big-copy-XY: SUCCESS (3.252s)
[302.736329] [073/131] (731s left) kms_scaling_modes (scaling-mode-none)
[303.113738] Starting subtest: scaling-mode-none
[303.120811] Subtest scaling-mode-none: SKIP (0.000s)
[303.524718] [074/131] (730s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[303.832724] Starting subtest: x-tiled-16bpp-rotate-90
[303.852272] Subtest x-tiled-16bpp-rotate-90: SKIP (0.018s)
[304.300364] [075/131] (729s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[304.596781] Starting subtest: plane-primary-overlay-mutable-zpos
[304.926886] Subtest plane-primary-overlay-mutable-zpos: SKIP (0.330s)
[305.540986] [076/131] (728s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[305.926635] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[306.244802] [077/131] (728s left) gem_ccs (ctrl-surf-copy-new-ctx)
[306.310490] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[306.376551] [078/131] (727s left) kms_cursor_legacy (single-bo)
[306.678263] Starting subtest: single-bo
[306.680045] Starting dynamic subtest: pipe-A
[312.062853] Dynamic subtest pipe-A: SUCCESS (5.383s)
[312.076660] Starting dynamic subtest: pipe-B
[317.450307] Dynamic subtest pipe-B: SUCCESS (5.382s)
[317.463525] Starting dynamic subtest: all-pipes
[322.836028] Dynamic subtest all-pipes: SUCCESS (5.384s)
[322.837766] Subtest single-bo: SUCCESS (16.159s)
[323.250947] [079/131] (711s left) kms_vblank (query-forked-hang)
[323.554260] Starting subtest: query-forked-hang
[323.556309] Starting dynamic subtest: pipe-A-HDMI-A-1
[329.913124] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.358s)
[329.925937] Starting dynamic subtest: pipe-B-HDMI-A-1
[335.930915] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (6.014s)
[335.932724] Subtest query-forked-hang: SUCCESS (12.378s)
[336.445471] [080/131] (698s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[336.749812] Starting subtest: fbc-rgb565-draw-mmap-gtt
[338.540838] Subtest fbc-rgb565-draw-mmap-gtt: SUCCESS (1.792s)
[338.995719] [081/131] (695s left) kms_joiner (basic-ultra-joiner)
[339.303799] Subtest basic-ultra-joiner: SKIP (0.000s)
[339.729461] [082/131] (694s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[340.030490] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[340.033703] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[340.438789] [083/131] (694s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[340.739268] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[342.566198] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SUCCESS (1.829s)
[343.005745] [084/131] (691s left) kms_cursor_crc (cursor-sliding-512x170)
[343.311722] Starting subtest: cursor-sliding-512x170
[343.314939] Subtest cursor-sliding-512x170: SKIP (0.001s)
[343.721018] [085/131] (691s left) syncobj_timeline (single-wait-signaled)
[343.790856] Starting subtest: single-wait-signaled
[343.792793] Subtest single-wait-signaled: SUCCESS (0.001s)
[343.937854] [086/131] (690s left) gem_mmap_offset (perf)
[343.998013] Starting subtest: perf
[343.999789] Starting dynamic subtest: smem0
[344.132154] Dynamic subtest smem0: SUCCESS (0.134s)
[344.133994] Subtest perf: SUCCESS (0.135s)
[344.295485] [087/131] (690s left) gem_ctx_param (invalid-set-no-zeromap)
[344.353696] Starting subtest: invalid-set-no-zeromap
[344.355654] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[344.484267] [088/131] (690s left) perf (non-zero-reason)
[344.655714] Subtest non-zero-reason: SKIP (0.000s)
[344.731828] [089/131] (690s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[345.032965] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[345.036417] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[345.448239] [090/131] (689s left) kms_psr (fbc-pr-cursor-plane-move)
[345.785403] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s)
[346.098151] [091/131] (689s left) i915_pm_freq_api (freq-suspend)
[346.334134] Subtest freq-suspend: SKIP (0.000s)
[346.516315] [092/131] (688s left) gem_exec_reloc (basic-write-wc-noreloc)
[346.682896] Starting subtest: basic-write-wc-noreloc
[346.706688] Subtest basic-write-wc-noreloc: SUCCESS (0.002s)
[347.277924] [093/131] (688s left) sw_sync (sync_busy)
[347.335625] Starting subtest: sync_busy
[347.339774] Subtest sync_busy: SUCCESS (0.004s)
[347.460960] [094/131] (688s left) kms_psr (pr-sprite-blt)
[347.754887] Subtest pr-sprite-blt: SKIP (0.000s)
[347.955362] [095/131] (687s left) perf (gen8-unprivileged-single-ctx-counters)
[348.112064] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[348.176535] [096/131] (687s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[348.474595] Starting subtest: fbcpsr-rgb565-draw-render
[348.477897] Subtest fbcpsr-rgb565-draw-render: SKIP (0.000s)
[348.890749] [097/131] (686s left) gen3_render_tiledx_blits
[349.015856] [098/131] (686s left) kms_cdclk (plane-scaling)
[349.076525] Subtest plane-scaling: SKIP (0.000s)
[349.131614] [099/131] (686s left) gem_pxp (verify-pxp-stale-buf-execution)
[351.709245] Starting subtest: verify-pxp-stale-buf-execution
[351.713199] Subtest verify-pxp-stale-buf-execution: SKIP (0.000s)
[351.837123] [100/131] (684s left) i915_query (query-topology-kernel-writes)
[351.896405] Starting subtest: query-topology-kernel-writes
[351.899574] Subtest query-topology-kernel-writes: SKIP (0.000s)
[352.034928] [101/131] (683s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[352.342361] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[352.345628] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[352.751440] [102/131] (683s left) sysfs_timeslice_duration (idempotent)
[352.813936] Starting subtest: idempotent
[352.815706] Starting dynamic subtest: vcs0
[352.819018] Dynamic subtest vcs0: SKIP (0.000s)
[352.839217] Starting dynamic subtest: bcs0
[352.843407] Dynamic subtest bcs0: SKIP (0.000s)
[352.868670] Starting dynamic subtest: rcs0
[352.873147] Dynamic subtest rcs0: SKIP (0.000s)
[352.877819] Subtest idempotent: SKIP (0.006s)
[352.951594] [103/131] (683s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[353.246392] Starting subtest: sprite-rotation-90-pos-100-0
[353.249763] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[353.649952] [104/131] (682s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[353.953978] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[353.957338] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[354.363972] [105/131] (681s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[354.424860] Starting subtest: multi-wait-available-submitted-signaled
[354.426600] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.001s)
[354.563934] [106/131] (681s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[354.864791] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip
[354.868051] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[355.280924] [107/131] (681s left) gem_userptr_blits (usage-restrictions)
[355.346947] Starting subtest: usage-restrictions
[355.348636] Subtest usage-restrictions: SUCCESS (0.000s)
[355.514980] [108/131] (680s left) prime_vgem (basic-blt)
[355.600012] Starting subtest: basic-blt
[355.620285] Subtest basic-blt: SUCCESS (0.022s)
[355.777831] [109/131] (680s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[355.837095] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SKIP (0.000s)
[355.911332] [110/131] (680s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[356.211995] Starting subtest: yf-tiled-8bpp-rotate-270
[356.215458] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[356.630732] [111/131] (679s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[356.692911] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s)
[356.757438] [112/131] (679s left) syncobj_wait (multi-wait-all-signaled)
[356.818772] Starting subtest: multi-wait-all-signaled
[356.820523] Subtest multi-wait-all-signaled: SUCCESS (0.001s)
[356.958851] [113/131] (679s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[357.022875] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.000s)
[357.087752] [114/131] (679s left) api_intel_allocator (reserve-simple)
[357.147525] Starting subtest: reserve-simple
[357.151787] Subtest reserve-simple: SUCCESS (0.005s)
[357.306711] [115/131] (679s left) sw_sync (sync_busy_fork)
[357.362522] Starting subtest: sync_busy_fork
[358.378174] Subtest sync_busy_fork: SUCCESS (1.014s)
[358.488605] [116/131] (678s left) gem_exec_balancer (noheartbeat)
[358.551096] Subtest noheartbeat: SKIP (0.000s)
[358.687780] [117/131] (678s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[358.749206] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.000s)
[358.818427] [118/131] (678s left) gem_exec_schedule (out-order)
[358.889902] Subtest out-order: SKIP (0.000s)
[359.135238] [119/131] (677s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[359.200617] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[359.204791] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[359.467786] [120/131] (677s left) syncobj_timeline (multi-wait-all-available-signaled)
[359.530302] Starting subtest: multi-wait-all-available-signaled
[359.531994] Subtest multi-wait-all-available-signaled: SUCCESS (0.001s)
[359.673544] [121/131] (677s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[359.981828] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[359.985075] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[360.389114] [122/131] (676s left) kms_cursor_crc (cursor-random-128x128)
[360.688856] Starting subtest: cursor-random-128x128
[360.690942] Starting dynamic subtest: pipe-A-HDMI-A-1
[364.354749] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.664s)
[364.396220] Starting dynamic subtest: pipe-B-HDMI-A-1
[368.072013] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.686s)
[368.073760] Subtest cursor-random-128x128: SUCCESS (7.384s)
[368.615995] [123/131] (668s left) kms_plane_multiple (tiling-x)
[368.917930] Starting subtest: tiling-x
[368.919633] Starting dynamic subtest: pipe-A-HDMI-A-1
[369.824859] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.907s)
[369.837733] Starting dynamic subtest: pipe-B-HDMI-A-1
[370.840885] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.014s)
[370.842547] Subtest tiling-x: SUCCESS (1.926s)
[371.372673] [124/131] (665s left) kms_chamelium_hpd (common-hpd-after-suspend)
[371.749137] Subtest common-hpd-after-suspend: SKIP (0.000s)
[372.062236] [125/131] (665s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[372.361990] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[373.856323] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (1.496s)
[374.308513] [126/131] (663s left) gem_exec_whisper (basic-fds-all)
[374.376244] Starting subtest: basic-fds-all
[376.365344] Subtest basic-fds-all: SUCCESS (1.987s)
[376.609557] [127/131] (660s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[376.668911] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[376.771670] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.102s)
[376.899852] [128/131] (660s left) kms_async_flips (async-flip-suspend-resume)
[377.200966] Starting subtest: async-flip-suspend-resume
[377.347773] Starting dynamic subtest: pipe-A-HDMI-A-1
[395.552870] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.662s)
[395.598805] Starting dynamic subtest: pipe-B-HDMI-A-1
[413.548243] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.660s)
[413.550070] Subtest async-flip-suspend-resume: SUCCESS (3.716s)
[422.068560] [129/131] (623s left) kms_setmode (clone-exclusive-crtc)
[422.168600] Starting subtest: clone-exclusive-crtc
[422.174281] Subtest clone-exclusive-crtc: SKIP (0.000s)
[422.325640] [130/131] (623s left) gem_eio (context-create)
[422.395321] Starting subtest: context-create
[422.423189] Subtest context-create: SUCCESS (0.026s)
[423.091008] [131/131] (622s left) gem_exec_schedule (preempt-queue-contexts)
[423.163542] Subtest preempt-queue-contexts: SKIP (0.000s)
[423.405830] Closing watchdogs
results: parsing output: 0/ for test: gem_spin_batch
results: parsing output: 1/ for test: gem_userptr_blits
results: parsing output: 2/ for test: gem_exec_whisper
results: parsing output: 3/ for test: kms_psr
results: parsing output: 4/ for test: api_intel_bb
results: parsing output: 5/ for test: gen9_exec_parse
results: parsing output: 6/ for test: kms_content_protection
results: parsing output: 7/ for test: gem_exec_flush
results: parsing output: 8/ for test: gen9_exec_parse
results: parsing output: 9/ for test: gem_ctx_persistence
results: parsing output: 10/ for test: gem_ctx_bad_destroy
results: parsing output: 11/ for test: kms_busy
results: parsing output: 12/ for test: gem_userptr_blits
results: parsing output: 13/ for test: kms_vblank
results: parsing output: 14/ for test: kms_cursor_legacy
results: parsing output: 15/ for test: syncobj_wait
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_psr2_sf
results: parsing output: 18/ for test: sw_sync
results: parsing output: 19/ for test: kms_ccs
results: parsing output: 20/ for test: drm_read
results: parsing output: 21/ for test: kms_psr
results: parsing output: 22/ for test: kms_big_fb
results: parsing output: 23/ for test: i915_pm_rpm
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: perf
results: parsing output: 26/ for test: gem_exec_fence
results: parsing output: 27/ for test: gem_mmap_gtt
results: parsing output: 28/ for test: kms_cursor_legacy
results: parsing output: 29/ for test: kms_cursor_legacy
results: parsing output: 30/ for test: kms_flip
results: parsing output: 31/ for test: gem_bad_reloc
results: parsing output: 32/ for test: kms_addfb_basic
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_flip
results: parsing output: 35/ for test: dumb_buffer
results: parsing output: 36/ for test: gem_userptr_blits
results: parsing output: 37/ for test: gem_userptr_blits
results: parsing output: 38/ for test: gem_exec_params
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: kms_flip
results: parsing output: 41/ for test: gem_exec_fence
results: parsing output: 42/ for test: gem_mmap_offset
results: parsing output: 43/ for test: syncobj_timeline
results: parsing output: 44/ for test: kms_plane_scaling
results: parsing output: 45/ for test: gem_exec_fence
results: parsing output: 46/ for test: kms_plane_scaling
results: parsing output: 47/ for test: gem_tiled_blits
results: parsing output: 48/ for test: kms_cursor_legacy
results: parsing output: 49/ for test: syncobj_wait
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_prime
results: parsing output: 53/ for test: kms_pm_dc
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_plane_alpha_blend
results: parsing output: 56/ for test: kms_color
results: parsing output: 57/ for test: kms_joiner
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: i915_pm_rps
results: parsing output: 60/ for test: kms_pipe_b_c_ivb
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_feature_discovery
results: parsing output: 63/ for test: kms_psr
results: parsing output: 64/ for test: perf_pmu
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_force_connector_basic
results: parsing output: 68/ for test: kms_flip_scaled_crc
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_psr2_sf
results: parsing output: 71/ for test: gem_mmap_gtt
results: parsing output: 72/ for test: kms_scaling_modes
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: kms_atomic
results: parsing output: 75/ for test: kms_chamelium_hpd
results: parsing output: 76/ for test: gem_ccs
results: parsing output: 77/ for test: kms_cursor_legacy
results: parsing output: 78/ for test: kms_vblank
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_joiner
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_cursor_crc
results: parsing output: 84/ for test: syncobj_timeline
results: parsing output: 85/ for test: gem_mmap_offset
results: parsing output: 86/ for test: gem_ctx_param
results: parsing output: 87/ for test: perf
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_psr
results: parsing output: 90/ for test: i915_pm_freq_api
results: parsing output: 91/ for test: gem_exec_reloc
results: parsing output: 92/ for test: sw_sync
results: parsing output: 93/ for test: kms_psr
results: parsing output: 94/ for test: perf
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: gen3_render_tiledx_blits
results: parsing output: 97/ for test: kms_cdclk
results: parsing output: 98/ for test: gem_pxp
results: parsing output: 99/ for test: i915_query
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: sysfs_timeslice_duration
results: parsing output: 102/ for test: kms_rotation_crc
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: syncobj_timeline
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: gem_userptr_blits
results: parsing output: 107/ for test: prime_vgem
results: parsing output: 108/ for test: kms_ccs
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: kms_flip_scaled_crc
results: parsing output: 111/ for test: syncobj_wait
results: parsing output: 112/ for test: kms_ccs
results: parsing output: 113/ for test: api_intel_allocator
results: parsing output: 114/ for test: sw_sync
results: parsing output: 115/ for test: gem_exec_balancer
results: parsing output: 116/ for test: kms_ccs
results: parsing output: 117/ for test: gem_exec_schedule
results: parsing output: 118/ for test: gem_render_copy
results: parsing output: 119/ for test: syncobj_timeline
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_cursor_crc
results: parsing output: 122/ for test: kms_plane_multiple
results: parsing output: 123/ for test: kms_chamelium_hpd
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: gem_exec_whisper
results: parsing output: 126/ for test: syncobj_timeline
results: parsing output: 127/ for test: kms_async_flips
results: parsing output: 128/ for test: kms_setmode
results: parsing output: 129/ for test: gem_eio
results: parsing output: 130/ for test: gem_exec_schedule
Done.