[73.918956] Initializing watchdogs
[73.919156]   /dev/watchdog0
[73.937885] [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)
[73.945979] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[73.949600] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[73.953631] [001/131] (960s left) gem_spin_batch (resubmit-new-all)
[74.034199] Starting subtest: resubmit-new-all
[74.036055] Starting dynamic subtest: rcs0
[74.039705] Dynamic subtest rcs0: SUCCESS (0.004s)
[74.049929] Starting dynamic subtest: bcs0
[74.051727] Dynamic subtest bcs0: SUCCESS (0.003s)
[74.060842] Starting dynamic subtest: vcs0
[74.062546] Dynamic subtest vcs0: SUCCESS (0.001s)
[74.064169] Subtest resubmit-new-all: SUCCESS (0.010s)
[74.280327] [002/131] (960s left) gem_userptr_blits (unsync-unmap-cycles)
[74.347320] Subtest unsync-unmap-cycles: SKIP (0.000s)
[74.512813] [003/131] (960s left) gem_exec_whisper (basic-sync)
[74.579114] Starting subtest: basic-sync
[75.928909] Subtest basic-sync: SUCCESS (1.347s)
[76.162497] [004/131] (958s left) kms_psr (psr2-sprite-plane-move)
[76.457708] Subtest psr2-sprite-plane-move: SKIP (0.000s)
[76.650904] [005/131] (958s left) api_intel_bb (render)
[76.711592] Starting subtest: render
[76.713826] Starting dynamic subtest: render-none-512
[76.808891] Dynamic subtest render-none-512: SUCCESS (0.097s)
[76.819154] Starting dynamic subtest: render-none-reloc-512
[76.896233] Dynamic subtest render-none-reloc-512: SUCCESS (0.087s)
[76.906653] Starting dynamic subtest: render-none-1024
[77.235086] Dynamic subtest render-none-1024: SUCCESS (0.338s)
[77.245457] Starting dynamic subtest: render-none-reloc-1024
[77.567875] Dynamic subtest render-none-reloc-1024: SUCCESS (0.333s)
[77.580059] Starting dynamic subtest: render-x-512
[77.651277] Dynamic subtest render-x-512: SUCCESS (0.083s)
[77.661723] Starting dynamic subtest: render-x-reloc-512
[77.728013] Dynamic subtest render-x-reloc-512: SUCCESS (0.076s)
[77.738491] Starting dynamic subtest: render-x-1024
[78.025636] Dynamic subtest render-x-1024: SUCCESS (0.297s)
[78.036224] Starting dynamic subtest: render-x-reloc-1024
[78.334730] Dynamic subtest render-x-reloc-1024: SUCCESS (0.309s)
[78.345221] Starting dynamic subtest: render-y-512
[78.410205] Dynamic subtest render-y-512: SUCCESS (0.075s)
[78.421474] Starting dynamic subtest: render-y-reloc-512
[78.487262] Dynamic subtest render-y-reloc-512: SUCCESS (0.077s)
[78.497834] Starting dynamic subtest: render-y-1024
[78.797772] Dynamic subtest render-y-1024: SUCCESS (0.310s)
[78.808225] Starting dynamic subtest: render-y-reloc-1024
[79.101785] Dynamic subtest render-y-reloc-1024: SUCCESS (0.303s)
[79.103606] Subtest render: SUCCESS (2.391s)
[79.251036] [006/131] (955s left) gen9_exec_parse (shadow-peek)
[79.313649] Subtest shadow-peek: SKIP (0.000s)
[79.360476] [007/131] (955s left) kms_content_protection (mei-interface)
[79.667326] Starting subtest: mei-interface
[79.670694] Subtest mei-interface: SKIP (0.002s)
[80.087088] [008/131] (954s left) gem_exec_flush (basic-batch-kernel-default-uc)
[80.185923] Starting subtest: basic-batch-kernel-default-uc
[85.877170] Subtest basic-batch-kernel-default-uc: SUCCESS (5.693s)
[86.110198] [009/131] (948s left) gen9_exec_parse (allowed-single)
[86.175790] Subtest allowed-single: SKIP (0.000s)
[86.231488] [010/131] (948s left) gem_ctx_persistence (hostile)
[86.300467] Subtest hostile: SKIP (0.000s)
[86.365751] [011/131] (948s left) gem_ctx_bad_destroy (invalid-ctx)
[86.426509] Starting subtest: invalid-ctx
[86.428131] Subtest invalid-ctx: SUCCESS (0.000s)
[86.549724] [012/131] (948s left) kms_busy (basic-hang)
[86.846785] Starting subtest: basic-hang
[86.848637] Starting dynamic subtest: flip-pipe-A
[87.427204] Dynamic subtest flip-pipe-A: SUCCESS (0.578s)
[87.439362] Starting dynamic subtest: modeset-pipe-A
[88.192185] Dynamic subtest modeset-pipe-A: SUCCESS (0.765s)
[88.203083] Starting dynamic subtest: flip-pipe-B
[88.612874] Dynamic subtest flip-pipe-B: SUCCESS (0.421s)
[88.623904] Starting dynamic subtest: modeset-pipe-B
[89.365476] Dynamic subtest modeset-pipe-B: SUCCESS (0.750s)
[89.367074] Subtest basic-hang: SUCCESS (2.519s)
[89.898965] [013/131] (945s left) gem_userptr_blits (relocations)
[89.964433] Starting subtest: relocations
[89.966010] Subtest relocations: SUCCESS (0.001s)
[90.149705] [014/131] (944s left) kms_vblank (wait-forked)
[90.446530] Starting subtest: wait-forked
[90.448581] Starting dynamic subtest: pipe-A-HDMI-A-1
[92.721519] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.276s)
[92.737844] Starting dynamic subtest: pipe-B-HDMI-A-1
[95.014038] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.290s)
[95.015731] Subtest wait-forked: SUCCESS (4.569s)
[95.525254] [015/131] (939s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[95.822036] Starting subtest: cursorB-vs-flipA-toggle
[95.825348] Subtest cursorB-vs-flipA-toggle: SKIP (0.002s)
[96.229120] [016/131] (938s left) syncobj_wait (reset-during-wait-for-submit)
[96.289211] Starting subtest: reset-during-wait-for-submit
[96.391719] Subtest reset-during-wait-for-submit: SUCCESS (0.102s)
[96.505892] [017/131] (938s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[96.802861] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-gtt
[96.806104] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[97.211803] [018/131] (938s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[97.555081] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[97.714625] [019/131] (937s left) sw_sync (sync_busy_fork_unixsocket)
[97.778312] Starting subtest: sync_busy_fork_unixsocket
[97.794340] Subtest sync_busy_fork_unixsocket: SUCCESS (0.015s)
[97.910564] [020/131] (937s left) kms_ccs (crc-primary-basic-y-tiled-ccs)
[97.969517] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.000s)
[98.036356] [021/131] (937s left) drm_read (short-buffer-wakeup)
[98.374888] Starting subtest: short-buffer-wakeup
[130.590402] Subtest short-buffer-wakeup: SUCCESS (32.215s)
[131.044925] [022/131] (904s left) kms_psr (fbc-psr-primary-blt)
[131.338129] Subtest fbc-psr-primary-blt: SKIP (0.000s)
[131.530246] [023/131] (904s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[131.841826] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[131.845074] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[132.254658] [024/131] (903s left) i915_pm_rpm (gem-evict-pwrite)
[143.764826] Subtest gem-evict-pwrite: SKIP (0.000s)
[143.958321] [025/131] (891s left) kms_frontbuffer_tracking (fbcpsr-slowdraw)
[144.263789] Starting subtest: fbcpsr-slowdraw
[144.266965] Subtest fbcpsr-slowdraw: SKIP (0.000s)
[144.661589] [026/131] (891s left) perf (oa-exponents)
[144.801738] Subtest oa-exponents: SKIP (0.000s)
[144.855666] [027/131] (890s left) gem_exec_fence (basic-wait)
[145.030978] Subtest basic-wait: SKIP (0.000s)
[145.481959] [FACT gem_exec_fence (basic-wait)] new: kernel.kmod_is_loaded.vgem: true
[145.485584] [028/131] (890s left) gem_mmap_gtt (big-copy-odd)
[145.543776] Starting subtest: big-copy-odd
[147.573503] Subtest big-copy-odd: SUCCESS (2.031s)
[147.723251] [029/131] (888s left) kms_cursor_legacy (cursorb-vs-flipa-atomic)
[148.098499] Starting subtest: cursorB-vs-flipA-atomic
[148.101994] Subtest cursorB-vs-flipA-atomic: SKIP (0.002s)
[148.514319] [030/131] (887s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[148.809359] Starting subtest: flip-vs-cursor-legacy
[158.848327] Subtest flip-vs-cursor-legacy: SUCCESS (10.040s)
[159.371026] [031/131] (876s left) kms_flip (2x-blocking-absolute-wf_vblank)
[159.667761] Starting subtest: 2x-blocking-absolute-wf_vblank
[159.669514] Starting dynamic subtest: AB-VGA1-HDMI-A1
[190.096348] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (30.428s)
[190.097987] Subtest 2x-blocking-absolute-wf_vblank: SUCCESS (30.431s)
[190.693922] [032/131] (845s left) gem_bad_reloc (negative-reloc-bltcopy)
[190.759743] Starting subtest: negative-reloc-bltcopy
[191.142731] Subtest negative-reloc-bltcopy: SUCCESS (0.382s)
[191.373575] [033/131] (844s left) kms_addfb_basic (addfb25-bad-modifier)
[191.671014] Starting subtest: addfb25-bad-modifier
[191.672660] Subtest addfb25-bad-modifier: SUCCESS (0.001s)
[192.092174] [034/131] (844s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[192.392068] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc
[192.395411] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[192.828817] [035/131] (843s left) kms_flip (2x-flip-vs-panning-vs-hang)
[193.120212] Starting subtest: 2x-flip-vs-panning-vs-hang
[193.121955] Starting dynamic subtest: AB-VGA1-HDMI-A1
[205.879528] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (12.761s)
[205.881243] Subtest 2x-flip-vs-panning-vs-hang: SUCCESS (12.763s)
[206.483735] [036/131] (829s left) dumb_buffer (map-valid)
[206.542608] Starting subtest: map-valid
[206.544288] Subtest map-valid: SUCCESS (0.000s)
[206.689800] [037/131] (829s left) gem_userptr_blits (stress-purge)
[206.761340] Starting subtest: stress-purge
[212.162978] Subtest stress-purge: SUCCESS (5.402s)
[212.337714] [038/131] (824s left) gem_userptr_blits (sync-overlap)
[212.493132] Starting subtest: sync-overlap
[212.494746] Subtest sync-overlap: SUCCESS (0.000s)
[212.664695] [039/131] (823s left) gem_exec_params (mmapped)
[212.724917] Starting subtest: mmapped
[212.726721] Subtest mmapped: SUCCESS (0.002s)
[212.894428] [040/131] (823s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-msflip-blt)
[213.228092] Starting subtest: fbcpsr-1p-primscrn-indfb-msflip-blt
[213.231546] Subtest fbcpsr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[213.610451] [041/131] (823s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible)
[213.912808] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible
[213.914526] Starting dynamic subtest: AB-VGA1-HDMI-A1
[244.655040] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (30.742s)
[244.656890] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SUCCESS (30.746s)
[245.286806] [042/131] (791s left) gem_exec_fence (basic-wait-all)
[245.366912] Starting subtest: basic-wait-all
[245.417391] Subtest basic-wait-all: SUCCESS (0.050s)
[245.948712] [043/131] (790s left) gem_mmap_offset (open-flood)
[246.011148] Starting subtest: open-flood
[267.521365] Subtest open-flood: SUCCESS (21.512s)
[267.682071] [044/131] (769s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[267.758371] Starting subtest: etime-single-wait-for-submit-unsubmitted
[267.867641] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.108s)
[268.002018] [045/131] (768s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[268.304142] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[268.305901] Starting dynamic subtest: pipe-A
[268.310951] Dynamic subtest pipe-A: SKIP (0.001s)
[268.323543] Starting dynamic subtest: pipe-B
[268.328389] Dynamic subtest pipe-B: SKIP (0.001s)
[268.331539] Subtest planes-unity-scaling-downscale-factor-0-75: SKIP (0.004s)
[268.720526] [046/131] (768s left) gem_exec_fence (keep-in-fence)
[268.907173] Subtest keep-in-fence: SKIP (0.000s)
[269.320659] [047/131] (767s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[269.611221] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[269.612899] Starting dynamic subtest: pipe-A
[269.617942] Dynamic subtest pipe-A: SKIP (0.001s)
[269.631181] Starting dynamic subtest: pipe-B
[269.636174] Dynamic subtest pipe-B: SKIP (0.001s)
[269.639362] Subtest plane-scaler-unity-scaling-with-modifiers: SKIP (0.004s)
[270.030017] [048/131] (767s left) gem_tiled_blits (basic)
[270.269166] Starting subtest: basic
[270.288058] Subtest basic: SUCCESS (0.019s)
[270.456377] [049/131] (766s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[270.910638] Starting subtest: flip-vs-cursor-crc-atomic
[271.572222] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.676s)
[272.245300] [050/131] (765s left) syncobj_wait (wait-any-complex)
[272.319819] Starting subtest: wait-any-complex
[272.383919] Subtest wait-any-complex: SUCCESS (0.063s)
[272.532694] [051/131] (764s left) kms_big_fb (yf-tiled-16bpp-rotate-270)
[272.842055] Starting subtest: yf-tiled-16bpp-rotate-270
[272.846842] Subtest yf-tiled-16bpp-rotate-270: SKIP (0.000s)
[273.257642] [052/131] (764s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[273.561665] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[273.564822] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[273.972581] [053/131] (763s left) kms_prime (basic-crc-vgem)
[274.291527] Starting subtest: basic-crc-vgem
[274.293215] Starting dynamic subtest: second-to-first
[275.522064] Dynamic subtest second-to-first: SUCCESS (1.232s)
[275.524064] Subtest basic-crc-vgem: SUCCESS (1.234s)
[276.520672] [054/131] (761s left) kms_pm_dc (dc5-dpms)
[287.626176] Subtest dc5-dpms: SKIP (0.000s)
[287.696874] [055/131] (749s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[287.996324] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[287.999633] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[288.412165] [056/131] (749s left) kms_plane_alpha_blend (alpha-opaque-fb)
[288.704079] Starting subtest: alpha-opaque-fb
[288.865748] Subtest alpha-opaque-fb: SKIP (0.162s)
[289.456395] [057/131] (748s left) kms_color (ctm-negative)
[289.755099] Starting subtest: ctm-negative
[289.757357] Starting dynamic subtest: pipe-A-HDMI-A-1
[290.215929] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.461s)
[290.228859] Starting dynamic subtest: pipe-B-HDMI-A-1
[290.710233] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.493s)
[290.711991] Subtest ctm-negative: SUCCESS (0.957s)
[291.229996] [058/131] (746s left) kms_joiner (basic-force-big-joiner)
[291.532709] Subtest basic-force-big-joiner: SKIP (0.000s)
[291.944121] [059/131] (745s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[292.240263] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[294.102141] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (1.864s)
[294.557309] [060/131] (743s left) i915_pm_rps (waitboost)
[294.622976] Starting subtest: waitboost
[298.154643] Subtest waitboost: SUCCESS (3.532s)
[298.309677] [061/131] (739s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[298.368610] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[298.435220] [062/131] (739s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[298.732563] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[298.735885] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[299.150891] [063/131] (738s left) kms_feature_discovery (chamelium)
[299.445877] Starting subtest: chamelium
[299.449254] Subtest chamelium: SKIP (0.000s)
[299.856211] [064/131] (738s left) kms_psr (fbc-pr-sprite-plane-onoff)
[300.157586] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[300.359064] [065/131] (737s left) perf_pmu (init-wait)
[300.423335] Starting subtest: init-wait
[300.424976] Starting dynamic subtest: rcs0
[300.426733] Dynamic subtest rcs0: SUCCESS (0.001s)
[300.444538] Starting dynamic subtest: bcs0
[300.446858] Dynamic subtest bcs0: SUCCESS (0.000s)
[300.467224] Starting dynamic subtest: vcs0
[300.469508] Dynamic subtest vcs0: SUCCESS (0.000s)
[300.471716] Subtest init-wait: SUCCESS (0.007s)
[300.557892] [066/131] (737s left) kms_big_fb (y-tiled-16bpp-rotate-270)
[300.860767] Starting subtest: y-tiled-16bpp-rotate-270
[300.864167] Subtest y-tiled-16bpp-rotate-270: SKIP (0.000s)
[301.274464] [067/131] (737s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render)
[301.585768] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render
[301.589170] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[302.011516] [068/131] (736s left) kms_force_connector_basic (force-load-detect)
[302.083939] Starting subtest: force-load-detect
[302.281996] Subtest force-load-detect: SUCCESS (0.199s)
[302.721114] [069/131] (735s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[302.785067] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SKIP (0.000s)
[302.848616] [070/131] (735s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc)
[303.152375] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc
[303.155684] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[303.567601] [071/131] (735s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[303.870411] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[304.060834] [072/131] (734s left) gem_mmap_gtt (cpuset-big-copy-xy)
[304.118729] Starting subtest: cpuset-big-copy-XY
[307.303315] Subtest cpuset-big-copy-XY: SUCCESS (3.185s)
[307.486843] [073/131] (731s left) kms_scaling_modes (scaling-mode-none)
[307.833478] Starting subtest: scaling-mode-none
[307.840070] Subtest scaling-mode-none: SKIP (0.000s)
[308.234508] [074/131] (730s left) kms_big_fb (x-tiled-16bpp-rotate-90)
[308.540846] Starting subtest: x-tiled-16bpp-rotate-90
[308.552141] Subtest x-tiled-16bpp-rotate-90: SKIP (0.010s)
[308.984924] [075/131] (729s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[309.280180] Starting subtest: plane-primary-overlay-mutable-zpos
[309.591595] Subtest plane-primary-overlay-mutable-zpos: SKIP (0.311s)
[310.212092] [076/131] (728s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode)
[310.574379] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s)
[310.886745] [077/131] (728s left) gem_ccs (ctrl-surf-copy-new-ctx)
[310.950071] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[311.016621] [078/131] (727s left) kms_cursor_legacy (single-bo)
[311.313897] Starting subtest: single-bo
[311.315591] Starting dynamic subtest: pipe-A
[316.698764] Dynamic subtest pipe-A: SUCCESS (5.383s)
[316.712822] Starting dynamic subtest: pipe-B
[322.085187] Dynamic subtest pipe-B: SUCCESS (5.383s)
[322.100878] Starting dynamic subtest: all-pipes
[327.469561] Dynamic subtest all-pipes: SUCCESS (5.383s)
[327.471298] Subtest single-bo: SUCCESS (16.156s)
[327.883834] [079/131] (711s left) kms_vblank (query-forked-hang)
[328.187305] Starting subtest: query-forked-hang
[328.189410] Starting dynamic subtest: pipe-A-HDMI-A-1
[333.951786] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (5.764s)
[333.966820] Starting dynamic subtest: pipe-B-HDMI-A-1
[339.966243] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (6.013s)
[339.967980] Subtest query-forked-hang: SUCCESS (11.783s)
[340.484881] [080/131] (698s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-gtt)
[340.789487] Starting subtest: fbc-rgb565-draw-mmap-gtt
[342.576206] Subtest fbc-rgb565-draw-mmap-gtt: SUCCESS (1.790s)
[343.016556] [081/131] (696s left) kms_joiner (basic-ultra-joiner)
[343.323559] Subtest basic-ultra-joiner: SKIP (0.000s)
[343.730289] [082/131] (695s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[344.056061] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[344.059355] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[344.453848] [083/131] (694s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[344.751795] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt
[346.584571] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SUCCESS (1.835s)
[347.020976] [084/131] (692s left) kms_cursor_crc (cursor-sliding-512x170)
[347.330157] Starting subtest: cursor-sliding-512x170
[347.333464] Subtest cursor-sliding-512x170: SKIP (0.001s)
[347.738710] [085/131] (691s left) syncobj_timeline (single-wait-signaled)
[347.806729] Starting subtest: single-wait-signaled
[347.808387] Subtest single-wait-signaled: SUCCESS (0.001s)
[347.918524] [086/131] (691s left) gem_mmap_offset (perf)
[347.977509] Starting subtest: perf
[347.979169] Starting dynamic subtest: smem0
[348.112092] Dynamic subtest smem0: SUCCESS (0.135s)
[348.114089] Subtest perf: SUCCESS (0.136s)
[348.268663] [087/131] (691s left) gem_ctx_param (invalid-set-no-zeromap)
[348.328457] Starting subtest: invalid-set-no-zeromap
[348.330332] Subtest invalid-set-no-zeromap: SUCCESS (0.000s)
[348.473985] [088/131] (691s left) perf (non-zero-reason)
[348.654917] Subtest non-zero-reason: SKIP (0.000s)
[348.716612] [089/131] (690s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[349.012502] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[349.015704] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[349.418948] [090/131] (690s left) kms_psr (fbc-pr-cursor-plane-move)
[349.719897] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s)
[349.925322] [091/131] (689s left) i915_pm_freq_api (freq-suspend)
[349.989142] Subtest freq-suspend: SKIP (0.000s)
[350.073228] [092/131] (689s left) gem_exec_reloc (basic-write-wc-noreloc)
[350.139397] Starting subtest: basic-write-wc-noreloc
[350.143626] Subtest basic-write-wc-noreloc: SUCCESS (0.002s)
[350.797891] [093/131] (689s left) sw_sync (sync_busy)
[350.868577] Starting subtest: sync_busy
[350.870686] Subtest sync_busy: SUCCESS (0.005s)
[350.975849] [094/131] (688s left) kms_psr (pr-sprite-blt)
[351.275601] Subtest pr-sprite-blt: SKIP (0.000s)
[351.477884] [095/131] (688s left) perf (gen8-unprivileged-single-ctx-counters)
[351.631682] Subtest gen8-unprivileged-single-ctx-counters: SKIP (0.000s)
[351.690641] [096/131] (688s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[352.149235] Starting subtest: fbcpsr-rgb565-draw-render
[352.199360] Subtest fbcpsr-rgb565-draw-render: SKIP (0.000s)
[352.499843] [097/131] (687s left) gen3_render_tiledx_blits
[352.968318] [098/131] (687s left) kms_cdclk (plane-scaling)
[353.236961] Subtest plane-scaling: SKIP (0.000s)
[353.294311] [099/131] (687s left) gem_pxp (verify-pxp-stale-buf-execution)
[355.865797] Starting subtest: verify-pxp-stale-buf-execution
[355.869501] Subtest verify-pxp-stale-buf-execution: SKIP (0.000s)
[356.007066] [100/131] (684s left) i915_query (query-topology-kernel-writes)
[356.064176] Starting subtest: query-topology-kernel-writes
[356.068496] Subtest query-topology-kernel-writes: SKIP (0.000s)
[356.229999] [101/131] (684s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[356.531761] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[356.535187] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[356.930680] [102/131] (683s left) sysfs_timeslice_duration (idempotent)
[356.991784] Starting subtest: idempotent
[356.993443] Starting dynamic subtest: vcs0
[356.996578] Dynamic subtest vcs0: SKIP (0.000s)
[357.019283] Starting dynamic subtest: bcs0
[357.022827] Dynamic subtest bcs0: SKIP (0.000s)
[357.041385] Starting dynamic subtest: rcs0
[357.045159] Dynamic subtest rcs0: SKIP (0.000s)
[357.049400] Subtest idempotent: SKIP (0.005s)
[357.137685] [103/131] (683s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[357.436806] Starting subtest: sprite-rotation-90-pos-100-0
[357.440161] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[357.850619] [104/131] (682s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt)
[358.159783] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt
[358.166329] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[358.570638] [105/131] (682s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[358.635082] Starting subtest: multi-wait-available-submitted-signaled
[358.636818] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.001s)
[358.761453] [106/131] (682s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[359.067170] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip
[359.070610] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[359.480118] [107/131] (681s left) gem_userptr_blits (usage-restrictions)
[359.544396] Starting subtest: usage-restrictions
[359.545946] Subtest usage-restrictions: SUCCESS (0.000s)
[359.730753] [108/131] (681s left) prime_vgem (basic-blt)
[359.796857] Starting subtest: basic-blt
[359.819599] Subtest basic-blt: SUCCESS (0.023s)
[359.994176] [109/131] (681s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs)
[360.052435] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SKIP (0.000s)
[360.126675] [110/131] (681s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[360.428696] Starting subtest: yf-tiled-8bpp-rotate-270
[360.431970] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[360.847487] [111/131] (680s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[360.908059] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s)
[360.971564] [112/131] (680s left) syncobj_wait (multi-wait-all-signaled)
[361.032814] Starting subtest: multi-wait-all-signaled
[361.034641] Subtest multi-wait-all-signaled: SUCCESS (0.001s)
[361.159589] [113/131] (680s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs)
[361.220701] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs: SKIP (0.000s)
[361.285899] [114/131] (680s left) api_intel_allocator (reserve-simple)
[361.341399] Starting subtest: reserve-simple
[361.345755] Subtest reserve-simple: SUCCESS (0.005s)
[361.509058] [115/131] (679s left) sw_sync (sync_busy_fork)
[361.563704] Starting subtest: sync_busy_fork
[362.579292] Subtest sync_busy_fork: SUCCESS (1.015s)
[362.688243] [116/131] (678s left) gem_exec_balancer (noheartbeat)
[362.755159] Subtest noheartbeat: SKIP (0.000s)
[362.889294] [117/131] (678s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[362.950703] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.000s)
[363.018530] [118/131] (678s left) gem_exec_schedule (out-order)
[363.085824] Subtest out-order: SKIP (0.000s)
[363.321802] [119/131] (678s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[363.386484] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[363.390188] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[363.620603] [120/131] (678s left) syncobj_timeline (multi-wait-all-available-signaled)
[363.684535] Starting subtest: multi-wait-all-available-signaled
[363.686176] Subtest multi-wait-all-available-signaled: SUCCESS (0.001s)
[363.816676] [121/131] (677s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[364.119268] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[364.122635] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[364.535077] [122/131] (677s left) kms_cursor_crc (cursor-random-128x128)
[364.842514] Starting subtest: cursor-random-128x128
[364.847191] Starting dynamic subtest: pipe-A-HDMI-A-1
[368.521020] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.675s)
[368.563083] Starting dynamic subtest: pipe-B-HDMI-A-1
[372.254975] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.703s)
[372.256774] Subtest cursor-random-128x128: SUCCESS (7.412s)
[372.781497] [123/131] (669s left) kms_plane_multiple (tiling-x)
[373.080808] Starting subtest: tiling-x
[373.082457] Starting dynamic subtest: pipe-A-HDMI-A-1
[374.008330] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.927s)
[374.022596] Starting dynamic subtest: pipe-B-HDMI-A-1
[375.002150] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.992s)
[375.003885] Subtest tiling-x: SUCCESS (1.924s)
[375.526091] [124/131] (666s left) kms_chamelium_hpd (common-hpd-after-suspend)
[375.892455] Subtest common-hpd-after-suspend: SKIP (0.000s)
[376.204942] [125/131] (665s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-blt)
[376.504294] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-blt
[378.000895] Subtest fbc-1p-offscreen-pri-indfb-draw-blt: SUCCESS (1.498s)
[378.451885] [126/131] (663s left) gem_exec_whisper (basic-fds-all)
[378.520999] Starting subtest: basic-fds-all
[380.476627] Subtest basic-fds-all: SUCCESS (1.953s)
[380.716730] [127/131] (661s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled)
[380.778021] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled
[380.884390] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.106s)
[381.011321] [128/131] (661s left) kms_async_flips (async-flip-suspend-resume)
[381.311181] Starting subtest: async-flip-suspend-resume
[381.459323] Starting dynamic subtest: pipe-A-HDMI-A-1
[400.108815] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.746s)
[400.125939] Starting dynamic subtest: pipe-B-HDMI-A-1
[417.987007] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.688s)
[417.988608] Subtest async-flip-suspend-resume: SUCCESS (3.838s)
[424.578612] [129/131] (623s left) kms_setmode (clone-exclusive-crtc)
[424.646303] Starting subtest: clone-exclusive-crtc
[424.651946] Subtest clone-exclusive-crtc: SKIP (0.000s)
[424.785712] [130/131] (623s left) gem_eio (context-create)
[424.858667] Starting subtest: context-create
[424.885314] Subtest context-create: SUCCESS (0.026s)
[425.565784] [131/131] (622s left) gem_exec_schedule (preempt-queue-contexts)
[425.636679] Subtest preempt-queue-contexts: SKIP (0.000s)
[425.889254] 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.