[71.210222] Initializing watchdogs [71.210407] /dev/watchdog0 [71.229639] [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) [71.237772] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [71.241588] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [71.245054] [001/132] (960s left) i915_pm_rpm (gem-evict-pwrite) [83.140438] Subtest gem-evict-pwrite: SKIP (0.000s) [83.427803] [002/132] (948s left) kms_frontbuffer_tracking (fbc-tiling-y) [83.931802] Starting subtest: fbc-tiling-y [83.933256] Subtest fbc-tiling-y: SKIP (0.000s) [84.536842] [003/132] (947s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset) [85.030636] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset [85.031474] Starting dynamic subtest: A-VGA1 [85.818753] Dynamic subtest A-VGA1: SUCCESS (0.788s) [85.827387] Starting dynamic subtest: B-VGA1 [86.510665] Dynamic subtest B-VGA1: SUCCESS (0.690s) [86.519440] Starting dynamic subtest: A-HDMI-A1 [87.299378] Dynamic subtest A-HDMI-A1: SUCCESS (0.789s) [87.310498] Starting dynamic subtest: B-HDMI-A1 [88.064220] Dynamic subtest B-HDMI-A1: SUCCESS (0.764s) [88.064986] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (3.035s) [88.823948] [004/132] (943s left) gem_pxp (reject-modify-context-protection-off-1) [91.417337] Starting subtest: reject-modify-context-protection-off-1 [91.418680] Subtest reject-modify-context-protection-off-1: SKIP (0.000s) [91.531740] [005/132] (940s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs) [91.590173] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s) [91.637190] [006/132] (940s left) gem_exec_whisper (basic-queues-all) [91.700749] Starting subtest: basic-queues-all [91.703776] Subtest basic-queues-all: SKIP (0.003s) [91.926548] [007/132] (940s left) gem_exec_params (rs-invalid) [91.982674] Starting subtest: rs-invalid [91.984916] Subtest rs-invalid: SUCCESS (0.002s) [92.144141] [008/132] (939s left) gem_unfence_active_buffers [92.377578] [009/132] (939s left) gem_exec_reloc (basic-range-active) [92.432583] Starting subtest: basic-range-active [92.457348] Subtest basic-range-active: SUCCESS (0.025s) [93.499034] [010/132] (938s left) api_intel_allocator (reserve-simple) [93.560682] Starting subtest: reserve-simple [93.566961] Subtest reserve-simple: SUCCESS (0.006s) [93.723878] [011/132] (938s left) vgem_basic (dmabuf-fence) [93.816369] Starting subtest: dmabuf-fence [93.817582] Subtest dmabuf-fence: SUCCESS (0.003s) [93.924321] [FACT vgem_basic (dmabuf-fence)] new: kernel.kmod_is_loaded.vgem: true [93.927504] [012/132] (938s left) gem_ctx_exec (basic-close-race) [93.983304] Starting subtest: basic-close-race [99.502613] Subtest basic-close-race: SUCCESS (5.517s) [99.651104] [013/132] (932s left) gem_exec_await (wide-contexts) [99.737773] Starting subtest: wide-contexts [121.543691] Subtest wide-contexts: SUCCESS (21.807s) [121.782090] [014/132] (910s left) kms_chamelium_audio (dp-audio) [122.472189] Subtest dp-audio: SKIP (0.000s) [122.879948] [015/132] (909s left) perf_pmu (init-sema) [122.941558] Starting subtest: init-sema [122.942402] Starting dynamic subtest: rcs0 [122.943186] Dynamic subtest rcs0: SUCCESS (0.001s) [122.955937] Starting dynamic subtest: bcs0 [122.956738] Dynamic subtest bcs0: SUCCESS (0.000s) [122.966333] Starting dynamic subtest: vcs0 [122.967352] Dynamic subtest vcs0: SUCCESS (0.000s) [122.968294] Subtest init-sema: SUCCESS (0.003s) [123.070397] [016/132] (909s left) gem_exec_schedule (u-submit-early-slice) [123.149518] Subtest u-submit-early-slice: SKIP (0.000s) [123.384425] [017/132] (909s left) syncobj_timeline (invalid-transfer-illegal-handle) [123.441196] Starting subtest: invalid-transfer-illegal-handle [123.442105] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s) [123.567439] [018/132] (908s left) kms_psr (fbc-psr-sprite-mmap-gtt) [124.063953] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.000s) [124.357821] [019/132] (908s left) perf (buffer-fill) [124.559616] Subtest buffer-fill: SKIP (0.000s) [124.608892] [020/132] (908s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format) [125.100132] Starting subtest: plane-upscale-20x20-with-pixel-format [125.100894] Starting dynamic subtest: pipe-A [125.103017] Dynamic subtest pipe-A: SKIP (0.001s) [125.113946] Starting dynamic subtest: pipe-B [125.116188] Dynamic subtest pipe-B: SKIP (0.001s) [125.118017] Subtest plane-upscale-20x20-with-pixel-format: SKIP (0.003s) [125.696096] [021/132] (906s left) gem_fence_thrash (bo-write-verify-x) [125.753190] Starting subtest: bo-write-verify-x [126.856301] Subtest bo-write-verify-x: SUCCESS (1.103s) [127.018455] [022/132] (905s left) kms_plane_alpha_blend (coverage-7efc) [127.507667] Starting subtest: coverage-7efc [127.685306] Subtest coverage-7efc: SKIP (0.177s) [128.485189] [023/132] (904s left) drm_mm (drm_mm) [128.548137] Starting subtest: drm_mm [128.567506] Starting dynamic subtest: drm_test_mm_init [128.667581] Dynamic subtest drm_test_mm_init: SUCCESS (0.100s) [128.678918] Starting dynamic subtest: drm_test_mm_debug [128.770996] Dynamic subtest drm_test_mm_debug: SUCCESS (0.103s) [128.781767] Starting dynamic subtest: drm_test_mm_align32 [128.860541] Dynamic subtest drm_test_mm_align32: SUCCESS (0.089s) [128.871988] Starting dynamic subtest: drm_test_mm_align64 [128.947458] Dynamic subtest drm_test_mm_align64: SUCCESS (0.086s) [128.957913] Starting dynamic subtest: drm_test_mm_lowest [129.026314] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.078s) [129.039166] Starting dynamic subtest: drm_test_mm_highest [129.115355] Dynamic subtest drm_test_mm_highest: SUCCESS (0.088s) [129.116031] Subtest drm_mm: SUCCESS (0.567s) [129.299298] [024/132] (903s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt) [129.802461] Starting subtest: psr-rgb565-draw-blt [129.803753] Subtest psr-rgb565-draw-blt: SKIP (0.000s) [130.399118] [025/132] (902s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs) [130.460346] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.000s) [130.508404] [026/132] (902s left) gem_exec_alignment (pi-isolated) [130.568642] Starting subtest: pi-isolated [130.569952] Subtest pi-isolated: SKIP (0.000s) [130.732276] [027/132] (902s left) gem_exec_reloc (basic-softpin) [130.790806] Starting subtest: basic-softpin [130.791600] Subtest basic-softpin: SUCCESS (0.001s) [131.830857] [028/132] (901s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip) [132.334117] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip [132.335702] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s) [132.944819] [029/132] (900s left) kms_chamelium_hpd (hdmi-hpd-fast) [133.513094] Subtest hdmi-hpd-fast: SKIP (0.000s) [133.929415] [030/132] (899s left) syncobj_timeline (device-submit-unordered) [133.999871] Starting subtest: device-submit-unordered [134.000682] Subtest device-submit-unordered: SUCCESS (0.001s) [134.121915] [031/132] (899s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render) [134.615759] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render [134.617218] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [135.220208] [032/132] (898s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite) [135.718042] Starting subtest: psr-rgb565-draw-pwrite [135.719283] Subtest psr-rgb565-draw-pwrite: SKIP (0.000s) [136.334435] [033/132] (896s left) gem_pread (bench) [136.393790] Starting subtest: bench [137.702795] Subtest bench: SUCCESS (1.308s) [137.832171] [034/132] (895s left) sysfs_timeslice_duration (invalid) [137.888505] Starting subtest: invalid [137.889254] Starting dynamic subtest: vcs0 [137.890699] Dynamic subtest vcs0: SKIP (0.000s) [137.901700] Starting dynamic subtest: bcs0 [137.903815] Dynamic subtest bcs0: SKIP (0.000s) [137.919784] Starting dynamic subtest: rcs0 [137.921943] Dynamic subtest rcs0: SKIP (0.000s) [137.924057] Subtest invalid: SKIP (0.003s) [138.012440] [035/132] (895s left) sw_sync (sync_merge) [138.067313] Starting subtest: sync_merge [138.068058] Subtest sync_merge: SUCCESS (0.000s) [138.180190] [036/132] (895s left) kms_big_fb (linear-16bpp-rotate-90) [138.679787] Starting subtest: linear-16bpp-rotate-90 [138.696472] Subtest linear-16bpp-rotate-90: SKIP (0.016s) [139.326071] [037/132] (894s left) gem_userptr_blits (stress-mm-invalidate-close-overlap) [139.399129] Starting subtest: stress-mm-invalidate-close-overlap [141.548337] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.148s) [141.705173] [038/132] (891s left) gem_exec_fence (expired-history) [141.897733] Starting subtest: expired-history [141.971237] Subtest expired-history: SUCCESS (0.073s) [142.321668] [039/132] (891s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt) [142.820376] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt [144.253163] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SUCCESS (1.432s) [144.881455] [040/132] (888s left) gem_workarounds (reset) [144.950914] Starting subtest: reset [144.957802] Subtest reset: SUCCESS (0.007s) [145.118189] [041/132] (888s left) gem_exec_params (no-blt) [145.179759] Starting subtest: no-blt [145.180667] Subtest no-blt: SUCCESS (0.000s) [145.333281] [042/132] (888s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [145.825404] Starting subtest: basic-busy-flip-before-cursor-atomic [146.863306] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (1.038s) [147.601941] [043/132] (886s left) kms_cursor_crc (cursor-onscreen-256x256) [148.109802] Starting subtest: cursor-onscreen-256x256 [148.113018] Starting dynamic subtest: pipe-A-HDMI-A-1 [150.324941] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.212s) [150.362737] Starting dynamic subtest: pipe-B-HDMI-A-1 [152.574504] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.221s) [152.575359] Subtest cursor-onscreen-256x256: SUCCESS (4.464s) [153.313286] [044/132] (880s left) gem_ctx_persistence (processes) [153.375608] Subtest processes: SKIP (0.000s) [153.438659] [045/132] (880s left) kms_pm_rpm (pm-tiling) [165.226329] Subtest pm-tiling: SKIP (0.000s) [165.551857] [046/132] (868s left) api_intel_bb (simple-bb) [165.611581] Starting subtest: simple-bb [165.613463] Subtest simple-bb: SUCCESS (0.002s) [165.752806] [047/132] (868s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move) [166.239145] Starting subtest: psr-2p-primscrn-cur-indfb-move [166.240574] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [166.852199] [048/132] (867s left) gem_exec_nop (basic-parallel) [166.919493] Starting subtest: basic-parallel [169.722291] Subtest basic-parallel: SUCCESS (2.801s) [169.979674] [049/132] (864s left) kms_psr2_sf (pr-cursor-plane-update-sf) [170.474176] Subtest pr-cursor-plane-update-sf: SKIP (0.000s) [170.785469] [050/132] (863s left) gem_exec_reloc (basic-write-read-active) [170.847263] Starting subtest: basic-write-read-active [170.955337] Subtest basic-write-read-active: SUCCESS (0.109s) [171.991591] [051/132] (862s left) gem_partial_pwrite_pread (write) [172.051252] Starting subtest: write [175.898992] Subtest write: SUCCESS (3.848s) [176.082274] [052/132] (858s left) gem_wait (await) [176.154855] Starting subtest: await [176.155569] Starting dynamic subtest: all-engines [177.185725] Dynamic subtest all-engines: SUCCESS (1.030s) [177.199322] Starting dynamic subtest: rcs0 [178.214491] Dynamic subtest rcs0: SUCCESS (1.026s) [178.226915] Starting dynamic subtest: bcs0 [179.238779] Dynamic subtest bcs0: SUCCESS (1.022s) [179.252964] Starting dynamic subtest: vcs0 [180.267476] Dynamic subtest vcs0: SUCCESS (1.027s) [180.268643] Subtest await: SUCCESS (4.114s) [180.523623] [053/132] (853s left) prime_busy (hang) [180.578550] Starting subtest: hang [180.579274] Starting dynamic subtest: rcs0 [186.874880] Dynamic subtest rcs0: SUCCESS (6.295s) [186.886392] Starting dynamic subtest: bcs0 [192.885362] Dynamic subtest bcs0: SUCCESS (6.009s) [192.896696] Starting dynamic subtest: vcs0 [198.902279] Dynamic subtest vcs0: SUCCESS (6.016s) [198.903138] Subtest hang: SUCCESS (18.324s) [199.069470] [054/132] (835s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc) [199.558554] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc [199.559978] Subtest fbcpsr-rgb101010-draw-mmap-wc: SKIP (0.000s) [200.165634] [055/132] (834s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible) [200.669162] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible [200.671851] Starting dynamic subtest: AB-VGA1-HDMI-A1 [202.253174] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (1.578s) [202.253948] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (1.581s) [202.983515] [056/132] (831s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic) [203.475070] Starting subtest: 2x-long-cursor-vs-flip-atomic [203.476520] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s) [204.083817] [057/132] (830s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite) [204.568928] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite [204.570317] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [205.179085] [058/132] (829s left) kms_rotation_crc (primary-rotation-180) [205.667916] Starting subtest: primary-rotation-180 [206.934128] Subtest primary-rotation-180: SUCCESS (1.266s) [207.739098] [059/132] (826s left) gem_lmem_swapping (parallel-random-verify) [207.810767] Subtest parallel-random-verify: SKIP (0.000s) [207.866274] [060/132] (826s left) gem_eio (reset-stress) [207.929890] Starting subtest: reset-stress [207.930697] Starting dynamic subtest: render [209.608324] Dynamic subtest render: SUCCESS (1.678s) [209.619516] Starting dynamic subtest: bsd [211.437171] Dynamic subtest bsd: FAIL (1.793s) [211.447744] Starting dynamic subtest: blt [213.029997] Dynamic subtest blt: SUCCESS (1.626s) [213.030866] Subtest reset-stress: FAIL (5.102s) [214.080665] [061/132] (820s left) syncobj_basic (bad-destroy) [214.138163] Starting subtest: bad-destroy [214.139059] Subtest bad-destroy: SUCCESS (0.000s) [214.271760] [062/132] (820s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc) [214.323925] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s) [214.383388] [063/132] (820s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [214.875337] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip [215.421284] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.546s) [216.104285] [064/132] (818s left) gem_softpin (zero) [216.167164] Subtest zero: SKIP (0.000s) [216.302510] [065/132] (818s left) kms_addfb_basic (basic-x-tiled-legacy) [216.358518] Starting subtest: basic-x-tiled-legacy [216.359236] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [217.386664] [066/132] (817s left) kms_big_fb (yf-tiled-8bpp-rotate-180) [217.878348] Starting subtest: yf-tiled-8bpp-rotate-180 [217.879742] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s) [218.483385] [067/132] (816s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render) [218.972877] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render [218.974157] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s) [219.580263] [068/132] (815s left) gem_ctx_exec (basic-norecovery) [219.640823] Starting subtest: basic-norecovery [219.649298] Subtest basic-norecovery: SUCCESS (0.009s) [219.810751] [069/132] (815s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling) [219.866459] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s) [219.922716] [070/132] (815s left) syncobj_timeline (single-wait-all-for-submit-signaled) [219.978138] Starting subtest: single-wait-all-for-submit-signaled [219.978896] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.001s) [220.111675] [071/132] (815s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled) [220.169960] Starting subtest: etime-multi-wait-all-submitted-signaled [220.275255] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.105s) [220.408886] [072/132] (814s left) perf_pmu (interrupts) [220.462934] Starting subtest: interrupts [221.519882] Subtest interrupts: SUCCESS (1.056s) [221.659730] [073/132] (813s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [222.146129] Starting subtest: compare-crc-sanitycheck-xr24 [222.146848] Starting dynamic subtest: pipe-A-HDMI-A-1 [222.523392] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.375s) [222.536965] Starting dynamic subtest: pipe-B-HDMI-A-1 [222.927881] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.403s) [222.928831] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.784s) [223.642200] [074/132] (811s left) gem_exec_schedule (preempt-queue-contexts) [223.717156] Subtest preempt-queue-contexts: SKIP (0.000s) [223.960353] [075/132] (811s left) kms_color_pipeline (plane-ctm3x4-lut1d) [224.449456] Starting subtest: plane-ctm3x4-lut1d [224.738812] Subtest plane-ctm3x4-lut1d: SKIP (0.288s) [225.452256] [076/132] (810s left) kms_chamelium_frames (hdmi-crc-fast) [226.014188] Subtest hdmi-crc-fast: SKIP (0.000s) [226.421652] [077/132] (809s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt) [226.916649] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt [226.919159] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [227.524302] [078/132] (808s left) gem_userptr_blits (dmabuf-unsync) [227.585589] Subtest dmabuf-unsync: SKIP (0.000s) [227.754380] [079/132] (807s left) kms_big_fb (x-tiled-64bpp-rotate-90) [228.249371] Starting subtest: x-tiled-64bpp-rotate-90 [228.256454] Subtest x-tiled-64bpp-rotate-90: SKIP (0.006s) [228.893691] [080/132] (806s left) kms_psr (fbc-psr2-primary-blt) [229.378073] Subtest fbc-psr2-primary-blt: SKIP (0.000s) [229.680193] [081/132] (806s left) kms_properties (plane-properties-legacy) [230.175094] Starting subtest: plane-properties-legacy [230.176849] Starting dynamic subtest: pipe-A-HDMI-A-1 [230.498211] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.321s) [230.514164] Starting dynamic subtest: pipe-B-HDMI-A-1 [230.898471] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.398s) [230.900526] Subtest plane-properties-legacy: SUCCESS (0.725s) [231.605096] [082/132] (804s left) kms_psr (pr-suspend) [232.097169] Subtest pr-suspend: SKIP (0.000s) [232.417717] [083/132] (803s left) gen9_exec_parse (bb-chained) [232.480697] Subtest bb-chained: SKIP (0.000s) [232.548506] [084/132] (803s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs) [232.602090] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.000s) [232.665324] [085/132] (803s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu) [233.157229] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu [233.158636] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [233.766349] [086/132] (802s left) i915_hangman (engine-error-state-capture) [233.831408] Subtest engine-error-state-capture: SKIP (0.000s) [233.933616] [087/132] (802s left) gem_mmap_offset (oob-read) [233.988856] Starting subtest: oob-read [233.989554] Subtest oob-read: SUCCESS (0.001s) [234.138621] [088/132] (801s left) kms_vblank (wait-busy) [234.621747] Starting subtest: wait-busy [234.622788] Starting dynamic subtest: pipe-A-HDMI-A-1 [237.024477] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.402s) [237.038838] Starting dynamic subtest: pipe-B-HDMI-A-1 [239.449643] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.421s) [239.453391] Subtest wait-busy: SUCCESS (4.829s) [240.172263] [089/132] (795s left) kms_content_protection (uevent-hdcp14) [240.680871] Starting subtest: uevent-hdcp14 [240.682127] Subtest uevent-hdcp14: SKIP (0.000s) [241.290626] [090/132] (794s left) syncobj_wait (single-wait-all-for-submit-submitted) [241.350379] Starting subtest: single-wait-all-for-submit-submitted [241.459073] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.108s) [241.586583] [091/132] (794s left) kms_pm_rpm (legacy-planes) [253.363812] Subtest legacy-planes: SKIP (0.000s) [253.659809] [092/132] (782s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt) [254.154436] Starting subtest: psr-2p-primscrn-indfb-plflip-blt [254.155879] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [254.757917] [093/132] (781s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs) [254.823686] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs [254.825633] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s) [255.078823] [094/132] (781s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area) [255.572154] Subtest psr2-primary-plane-update-sf-dmg-area: SKIP (0.000s) [255.873393] [095/132] (780s left) kms_vblank (ts-continuation-modeset) [256.357363] Starting subtest: ts-continuation-modeset [256.358276] Starting dynamic subtest: pipe-A-HDMI-A-1 [256.734107] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.376s) [256.749732] Starting dynamic subtest: pipe-B-HDMI-A-1 [257.142244] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.406s) [257.144567] Subtest ts-continuation-modeset: SUCCESS (0.787s) [257.860400] [096/132] (778s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt) [258.359342] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt [258.360672] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [258.970668] [097/132] (777s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible) [259.468247] Starting subtest: flip-vs-absolute-wf_vblank-interruptible [259.470886] Starting dynamic subtest: A-VGA1 [267.503926] Dynamic subtest A-VGA1: SUCCESS (8.033s) [267.518343] Starting dynamic subtest: B-VGA1 [275.477650] Dynamic subtest B-VGA1: SUCCESS (7.971s) [275.492190] Starting dynamic subtest: A-HDMI-A1 [283.620488] Dynamic subtest A-HDMI-A1: SUCCESS (8.140s) [283.635087] Starting dynamic subtest: B-HDMI-A1 [291.803458] Dynamic subtest B-HDMI-A1: SUCCESS (8.180s) [291.806845] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (32.337s) [292.576591] [098/132] (744s left) kms_sequence (get-forked-busy) [293.061286] Starting subtest: get-forked-busy [293.061913] Starting dynamic subtest: pipe-A-HDMI-A-1 [295.466378] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.404s) [295.479668] Starting dynamic subtest: pipe-B-HDMI-A-1 [297.905375] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.437s) [297.906361] Subtest get-forked-busy: SUCCESS (4.846s) [298.619170] [099/132] (738s left) kms_big_fb (y-tiled-64bpp-rotate-180) [299.112480] Starting subtest: y-tiled-64bpp-rotate-180 [299.113931] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s) [299.718091] [100/132] (737s left) sysfs_heartbeat_interval (idempotent) [299.778141] Starting subtest: idempotent [299.780244] Starting dynamic subtest: vcs0 [299.780803] Dynamic subtest vcs0: SUCCESS (0.001s) [299.794262] Starting dynamic subtest: bcs0 [299.794972] Dynamic subtest bcs0: SUCCESS (0.001s) [299.806873] Starting dynamic subtest: rcs0 [299.807934] Dynamic subtest rcs0: SUCCESS (0.001s) [299.808814] Subtest idempotent: SUCCESS (0.009s) [299.911443] [101/132] (736s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25) [300.394591] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25 [300.395393] Starting dynamic subtest: pipe-A [300.397225] Dynamic subtest pipe-A: SKIP (0.001s) [300.411741] Starting dynamic subtest: pipe-B [300.413708] Dynamic subtest pipe-B: SKIP (0.001s) [300.415179] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SKIP (0.005s) [300.994850] [102/132] (735s left) kms_psr (psr-sprite-plane-onoff) [301.474424] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [301.772836] [103/132] (735s left) kms_cursor_edge_walk (256x256-top-edge) [302.264543] Starting subtest: 256x256-top-edge [302.265359] Starting dynamic subtest: pipe-A-HDMI-A-1 [305.683744] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.418s) [305.697855] Starting dynamic subtest: pipe-B-HDMI-A-1 [309.032827] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.347s) [309.033684] Subtest 256x256-top-edge: SUCCESS (6.770s) [309.746136] [104/132] (727s left) fbdev (info) [309.808581] Starting subtest: info [309.809376] Subtest info: SUCCESS (0.000s) [309.931579] [105/132] (727s left) kms_atomic (crtc-invalid-params-fence) [310.415065] Starting subtest: crtc-invalid-params-fence [310.415778] Starting dynamic subtest: pipe-A-HDMI-A-1 [310.642935] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.226s) [310.643838] Subtest crtc-invalid-params-fence: SUCCESS (0.229s) [311.353617] [106/132] (725s left) sw_sync (sync_merge_same) [311.410702] Starting subtest: sync_merge_same [311.411572] Subtest sync_merge_same: SUCCESS (0.000s) [311.520697] [107/132] (725s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc) [312.010228] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc [312.011711] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [312.616941] [108/132] (724s left) kms_plane_multiple (tiling-4) [313.113948] Starting subtest: tiling-4 [313.115356] Subtest tiling-4: SKIP (0.000s) [313.718496] [109/132] (723s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling) [313.776353] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SKIP (0.000s) [313.848199] [110/132] (723s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [314.343145] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [314.344745] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [314.951565] [111/132] (722s left) kms_lease (empty-lease) [315.439272] Starting subtest: empty-lease [315.440106] Starting dynamic subtest: pipe-A-HDMI-A-1 [315.440976] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s) [315.456110] Starting dynamic subtest: pipe-B-HDMI-A-1 [315.456785] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s) [315.457623] Subtest empty-lease: SUCCESS (0.007s) [316.045597] [112/132] (721s left) gem_exec_flush (basic-uc-ro-default) [316.111474] Starting subtest: basic-uc-ro-default [321.556865] Subtest basic-uc-ro-default: SUCCESS (5.445s) [321.784227] [113/132] (715s left) gem_softpin (overlap) [321.844786] Starting subtest: overlap [322.026105] Subtest overlap: SUCCESS (0.181s) [322.181592] [114/132] (715s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt) [322.675472] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt [322.676867] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [323.282596] [115/132] (714s left) gem_mmap_wc (copy) [323.338428] Starting subtest: copy [323.533854] Subtest copy: SUCCESS (0.195s) [323.669143] [116/132] (713s left) kms_flip (dpms-vs-vblank-race) [324.155357] Starting subtest: dpms-vs-vblank-race [324.156094] Starting dynamic subtest: A-VGA1 [327.267078] Dynamic subtest A-VGA1: SUCCESS (3.110s) [327.279494] Starting dynamic subtest: B-VGA1 [330.311457] Dynamic subtest B-VGA1: SUCCESS (3.044s) [330.325582] Starting dynamic subtest: A-HDMI-A1 [333.318894] Dynamic subtest A-HDMI-A1: SUCCESS (3.005s) [333.331259] Starting dynamic subtest: B-HDMI-A1 [336.411024] Dynamic subtest B-HDMI-A1: SUCCESS (3.091s) [336.411713] Subtest dpms-vs-vblank-race: SUCCESS (12.257s) [337.149292] [117/132] (700s left) gem_exec_schedule (preempt-queue) [337.257902] Subtest preempt-queue: SKIP (0.000s) [337.499708] [118/132] (700s left) i915_query (query-regions-sanity-check) [337.556721] Starting subtest: query-regions-sanity-check [337.570186] Subtest query-regions-sanity-check: SUCCESS (0.014s) [337.731751] [119/132] (700s left) testdisplay [347.664830] [120/132] (690s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt) [348.177158] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt [348.178496] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [348.778755] [121/132] (689s left) kms_cursor_legacy (single-move) [349.266609] Starting subtest: single-move [349.267455] Starting dynamic subtest: pipe-A [354.653882] Dynamic subtest pipe-A: SUCCESS (5.384s) [354.668739] Starting dynamic subtest: pipe-B [360.039815] Dynamic subtest pipe-B: SUCCESS (5.383s) [360.055312] Starting dynamic subtest: all-pipes [365.425376] Dynamic subtest all-pipes: SUCCESS (5.383s) [365.426163] Subtest single-move: SUCCESS (16.159s) [366.026487] [122/132] (671s left) gem_exec_capture (capture) [366.094532] Subtest capture: SKIP (0.000s) [366.174085] [123/132] (671s left) drm_read (fault-buffer) [366.710683] Starting subtest: fault-buffer [366.711682] Subtest fault-buffer: SUCCESS (0.002s) [367.353197] [124/132] (670s left) syncobj_wait (signal) [367.409036] Starting subtest: signal [367.409752] Subtest signal: SUCCESS (0.000s) [367.538222] [125/132] (670s left) kms_cursor_crc (cursor-random-512x512) [368.029724] Starting subtest: cursor-random-512x512 [368.032480] Subtest cursor-random-512x512: SKIP (0.001s) [368.638387] [126/132] (669s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite) [369.128116] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite [371.082585] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (1.954s) [371.729634] [127/132] (666s left) gem_exec_balancer (bonded-chain) [371.788635] Subtest bonded-chain: SKIP (0.000s) [371.912064] [128/132] (666s left) gem_eio (throttle) [371.974322] Starting subtest: throttle [372.006943] Subtest throttle: SUCCESS (0.032s) [373.046956] [129/132] (665s left) syncobj_timeline (etime-single-wait-for-submit-submitted) [373.102343] Starting subtest: etime-single-wait-for-submit-submitted [373.211103] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.108s) [373.345311] [130/132] (664s left) i915_drm_fdinfo (all-busy-idle-check-all) [373.402899] Subtest all-busy-idle-check-all: SKIP (0.000s) [373.471928] [131/132] (664s left) kms_flip (2x-flip-vs-suspend) [373.950744] Starting subtest: 2x-flip-vs-suspend [373.951902] Starting dynamic subtest: AB-VGA1-HDMI-A1 [577.802796] Per-test timeout exceeded. Killing the current test with SIGQUIT. [584.625355] Closing watchdogs [584.628554] Initializing watchdogs [584.628629] /dev/watchdog0 [584.656138] [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) [584.670653] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [584.672303] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [584.673152] [FACT before any test] new: kernel.kmod_is_loaded.vgem: true [584.676747] [132/132] (459s left) kms_psr (fbc-pr-sprite-plane-onoff) [585.210818] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s) [585.526477] Closing watchdogs results: parsing output: 0/ for test: i915_pm_rpm results: parsing output: 1/ for test: kms_frontbuffer_tracking results: parsing output: 2/ for test: kms_flip results: parsing output: 3/ for test: gem_pxp results: parsing output: 4/ for test: kms_ccs results: parsing output: 5/ for test: gem_exec_whisper results: parsing output: 6/ for test: gem_exec_params results: parsing output: 7/ for test: gem_unfence_active_buffers results: parsing output: 8/ for test: gem_exec_reloc results: parsing output: 9/ for test: api_intel_allocator results: parsing output: 10/ for test: vgem_basic results: parsing output: 11/ for test: gem_ctx_exec results: parsing output: 12/ for test: gem_exec_await results: parsing output: 13/ for test: kms_chamelium_audio results: parsing output: 14/ for test: perf_pmu results: parsing output: 15/ for test: gem_exec_schedule results: parsing output: 16/ for test: syncobj_timeline results: parsing output: 17/ for test: kms_psr results: parsing output: 18/ for test: perf results: parsing output: 19/ for test: kms_plane_scaling results: parsing output: 20/ for test: gem_fence_thrash results: parsing output: 21/ for test: kms_plane_alpha_blend results: parsing output: 22/ for test: drm_mm results: parsing output: 23/ for test: kms_frontbuffer_tracking results: parsing output: 24/ for test: kms_ccs results: parsing output: 25/ for test: gem_exec_alignment results: parsing output: 26/ for test: gem_exec_reloc results: parsing output: 27/ for test: kms_big_fb results: parsing output: 28/ for test: kms_chamelium_hpd results: parsing output: 29/ for test: syncobj_timeline results: parsing output: 30/ for test: kms_frontbuffer_tracking results: parsing output: 31/ for test: kms_frontbuffer_tracking results: parsing output: 32/ for test: gem_pread results: parsing output: 33/ for test: sysfs_timeslice_duration results: parsing output: 34/ for test: sw_sync results: parsing output: 35/ for test: kms_big_fb results: parsing output: 36/ for test: gem_userptr_blits results: parsing output: 37/ for test: gem_exec_fence results: parsing output: 38/ for test: kms_frontbuffer_tracking results: parsing output: 39/ for test: gem_workarounds results: parsing output: 40/ for test: gem_exec_params results: parsing output: 41/ for test: kms_cursor_legacy results: parsing output: 42/ for test: kms_cursor_crc results: parsing output: 43/ for test: gem_ctx_persistence results: parsing output: 44/ for test: kms_pm_rpm results: parsing output: 45/ for test: api_intel_bb results: parsing output: 46/ for test: kms_frontbuffer_tracking results: parsing output: 47/ for test: gem_exec_nop results: parsing output: 48/ for test: kms_psr2_sf results: parsing output: 49/ for test: gem_exec_reloc results: parsing output: 50/ for test: gem_partial_pwrite_pread results: parsing output: 51/ for test: gem_wait results: parsing output: 52/ for test: prime_busy results: parsing output: 53/ for test: kms_frontbuffer_tracking results: parsing output: 54/ for test: kms_flip results: parsing output: 55/ for test: kms_cursor_legacy results: parsing output: 56/ for test: kms_frontbuffer_tracking results: parsing output: 57/ for test: kms_rotation_crc results: parsing output: 58/ for test: gem_lmem_swapping results: parsing output: 59/ for test: gem_eio results: parsing output: 60/ for test: syncobj_basic results: parsing output: 61/ for test: kms_ccs results: parsing output: 62/ for test: kms_big_fb results: parsing output: 63/ for test: gem_softpin results: parsing output: 64/ for test: kms_addfb_basic results: parsing output: 65/ for test: kms_big_fb results: parsing output: 66/ for test: kms_frontbuffer_tracking results: parsing output: 67/ for test: gem_ctx_exec results: parsing output: 68/ for test: kms_flip_scaled_crc results: parsing output: 69/ for test: syncobj_timeline results: parsing output: 70/ for test: syncobj_timeline results: parsing output: 71/ for test: perf_pmu results: parsing output: 72/ for test: kms_pipe_crc_basic results: parsing output: 73/ for test: gem_exec_schedule results: parsing output: 74/ for test: kms_color_pipeline results: parsing output: 75/ for test: kms_chamelium_frames results: parsing output: 76/ for test: kms_frontbuffer_tracking results: parsing output: 77/ for test: gem_userptr_blits results: parsing output: 78/ for test: kms_big_fb results: parsing output: 79/ for test: kms_psr results: parsing output: 80/ for test: kms_properties results: parsing output: 81/ for test: kms_psr results: parsing output: 82/ for test: gen9_exec_parse results: parsing output: 83/ for test: kms_ccs results: parsing output: 84/ for test: kms_frontbuffer_tracking results: parsing output: 85/ for test: i915_hangman results: parsing output: 86/ for test: gem_mmap_offset results: parsing output: 87/ for test: kms_vblank results: parsing output: 88/ for test: kms_content_protection results: parsing output: 89/ for test: syncobj_wait results: parsing output: 90/ for test: kms_pm_rpm results: parsing output: 91/ for test: kms_frontbuffer_tracking results: parsing output: 92/ for test: gem_render_copy results: parsing output: 93/ for test: kms_psr2_sf results: parsing output: 94/ for test: kms_vblank results: parsing output: 95/ for test: kms_frontbuffer_tracking results: parsing output: 96/ for test: kms_flip results: parsing output: 97/ for test: kms_sequence results: parsing output: 98/ for test: kms_big_fb results: parsing output: 99/ for test: sysfs_heartbeat_interval results: parsing output: 100/ for test: kms_plane_scaling results: parsing output: 101/ for test: kms_psr results: parsing output: 102/ for test: kms_cursor_edge_walk results: parsing output: 103/ for test: fbdev results: parsing output: 104/ for test: kms_atomic results: parsing output: 105/ for test: sw_sync results: parsing output: 106/ for test: kms_frontbuffer_tracking results: parsing output: 107/ for test: kms_plane_multiple results: parsing output: 108/ for test: kms_flip_scaled_crc results: parsing output: 109/ for test: kms_big_fb results: parsing output: 110/ for test: kms_lease results: parsing output: 111/ for test: gem_exec_flush results: parsing output: 112/ for test: gem_softpin results: parsing output: 113/ for test: kms_frontbuffer_tracking results: parsing output: 114/ for test: gem_mmap_wc results: parsing output: 115/ for test: kms_flip results: parsing output: 116/ for test: gem_exec_schedule results: parsing output: 117/ for test: i915_query results: parsing output: 118/ for test: testdisplay results: parsing output: 119/ for test: kms_frontbuffer_tracking results: parsing output: 120/ for test: kms_cursor_legacy results: parsing output: 121/ for test: gem_exec_capture results: parsing output: 122/ for test: drm_read results: parsing output: 123/ for test: syncobj_wait results: parsing output: 124/ for test: kms_cursor_crc results: parsing output: 125/ for test: kms_frontbuffer_tracking results: parsing output: 126/ for test: gem_exec_balancer results: parsing output: 127/ for test: gem_eio results: parsing output: 128/ for test: syncobj_timeline results: parsing output: 129/ for test: i915_drm_fdinfo results: parsing output: 130/ for test: kms_flip results: parsing output: 131/ for test: kms_psr Done.