[73.351657] Initializing watchdogs [73.351792] /dev/watchdog0 [73.372976] [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.380845] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [73.385069] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [73.388171] [001/132] (960s left) i915_pm_rpm (gem-evict-pwrite) [85.288458] Subtest gem-evict-pwrite: SKIP (0.000s) [85.599012] [002/132] (948s left) kms_frontbuffer_tracking (fbc-tiling-y) [86.118757] Starting subtest: fbc-tiling-y [86.120123] Subtest fbc-tiling-y: SKIP (0.000s) [86.736634] [003/132] (947s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset) [87.233387] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset [87.234288] Starting dynamic subtest: A-VGA1 [88.036635] Dynamic subtest A-VGA1: SUCCESS (0.803s) [88.045412] Starting dynamic subtest: B-VGA1 [88.743900] Dynamic subtest B-VGA1: SUCCESS (0.706s) [88.752885] Starting dynamic subtest: A-HDMI-A1 [89.515828] Dynamic subtest A-HDMI-A1: SUCCESS (0.771s) [89.524823] Starting dynamic subtest: B-HDMI-A1 [90.288852] Dynamic subtest B-HDMI-A1: SUCCESS (0.772s) [90.289751] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (3.057s) [91.035217] [004/132] (942s left) gem_pxp (reject-modify-context-protection-off-1) [93.625473] Starting subtest: reject-modify-context-protection-off-1 [93.627260] Subtest reject-modify-context-protection-off-1: SKIP (0.000s) [93.739410] [005/132] (940s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs) [93.794412] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s) [93.848870] [006/132] (940s left) gem_exec_whisper (basic-queues-all) [93.915056] Starting subtest: basic-queues-all [93.917609] Subtest basic-queues-all: SKIP (0.003s) [94.153264] [007/132] (940s left) gem_exec_params (rs-invalid) [94.208686] Starting subtest: rs-invalid [94.210951] Subtest rs-invalid: SUCCESS (0.002s) [94.359193] [008/132] (939s left) gem_unfence_active_buffers [94.588490] [009/132] (939s left) gem_exec_reloc (basic-range-active) [94.644759] Starting subtest: basic-range-active [94.668139] Subtest basic-range-active: SUCCESS (0.024s) [95.715922] [010/132] (938s left) api_intel_allocator (reserve-simple) [95.771464] Starting subtest: reserve-simple [95.774721] Subtest reserve-simple: SUCCESS (0.004s) [95.933777] [011/132] (938s left) vgem_basic (dmabuf-fence) [96.040509] Starting subtest: dmabuf-fence [96.042621] Subtest dmabuf-fence: SUCCESS (0.002s) [96.157652] [FACT vgem_basic (dmabuf-fence)] new: kernel.kmod_is_loaded.vgem: true [96.160208] [012/132] (938s left) gem_ctx_exec (basic-close-race) [96.218562] Starting subtest: basic-close-race [101.792395] Subtest basic-close-race: SUCCESS (5.571s) [101.961546] [013/132] (932s left) gem_exec_await (wide-contexts) [102.043680] Starting subtest: wide-contexts [123.985855] Subtest wide-contexts: SUCCESS (21.942s) [124.231330] [014/132] (910s left) kms_chamelium_audio (dp-audio) [124.917166] Subtest dp-audio: SKIP (0.000s) [125.323610] [015/132] (909s left) perf_pmu (init-sema) [125.384522] Starting subtest: init-sema [125.385545] Starting dynamic subtest: rcs0 [125.386313] Dynamic subtest rcs0: SUCCESS (0.001s) [125.399956] Starting dynamic subtest: bcs0 [125.401284] Dynamic subtest bcs0: SUCCESS (0.000s) [125.411524] Starting dynamic subtest: vcs0 [125.412895] Dynamic subtest vcs0: SUCCESS (0.001s) [125.414162] Subtest init-sema: SUCCESS (0.004s) [125.514318] [016/132] (909s left) gem_exec_schedule (u-submit-early-slice) [125.596231] Subtest u-submit-early-slice: SKIP (0.000s) [125.828928] [017/132] (908s left) syncobj_timeline (invalid-transfer-illegal-handle) [125.885562] Starting subtest: invalid-transfer-illegal-handle [125.886375] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s) [126.011328] [018/132] (908s left) kms_psr (fbc-psr-sprite-mmap-gtt) [126.509243] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.000s) [126.806961] [019/132] (907s left) perf (buffer-fill) [127.002869] Subtest buffer-fill: SKIP (0.000s) [127.056099] [020/132] (907s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format) [127.549347] Starting subtest: plane-upscale-20x20-with-pixel-format [127.550148] Starting dynamic subtest: pipe-A [127.551850] Dynamic subtest pipe-A: SKIP (0.001s) [127.562588] Starting dynamic subtest: pipe-B [127.564300] Dynamic subtest pipe-B: SKIP (0.001s) [127.565425] Subtest plane-upscale-20x20-with-pixel-format: SKIP (0.003s) [128.158133] [021/132] (906s left) gem_fence_thrash (bo-write-verify-x) [128.217327] Starting subtest: bo-write-verify-x [129.340853] Subtest bo-write-verify-x: SUCCESS (1.124s) [129.489135] [022/132] (905s left) kms_plane_alpha_blend (coverage-7efc) [129.979353] Starting subtest: coverage-7efc [130.154925] Subtest coverage-7efc: SKIP (0.176s) [130.956689] [023/132] (904s left) drm_mm (drm_mm) [131.020338] Starting subtest: drm_mm [131.037836] Starting dynamic subtest: drm_test_mm_init [131.139864] Dynamic subtest drm_test_mm_init: SUCCESS (0.102s) [131.151567] Starting dynamic subtest: drm_test_mm_debug [131.243734] Dynamic subtest drm_test_mm_debug: SUCCESS (0.103s) [131.255709] Starting dynamic subtest: drm_test_mm_align32 [131.332757] Dynamic subtest drm_test_mm_align32: SUCCESS (0.088s) [131.347466] Starting dynamic subtest: drm_test_mm_align64 [131.436483] Dynamic subtest drm_test_mm_align64: SUCCESS (0.103s) [131.448355] Starting dynamic subtest: drm_test_mm_lowest [131.514214] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.077s) [131.527166] Starting dynamic subtest: drm_test_mm_highest [131.609857] Dynamic subtest drm_test_mm_highest: SUCCESS (0.095s) [131.611029] Subtest drm_mm: SUCCESS (0.589s) [131.824166] [024/132] (903s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt) [132.318244] Starting subtest: psr-rgb565-draw-blt [132.319653] Subtest psr-rgb565-draw-blt: SKIP (0.000s) [132.935895] [025/132] (902s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs) [132.992788] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.000s) [133.048720] [026/132] (902s left) gem_exec_alignment (pi-isolated) [133.108982] Starting subtest: pi-isolated [133.110545] Subtest pi-isolated: SKIP (0.000s) [133.272117] [027/132] (901s left) gem_exec_reloc (basic-softpin) [133.332892] Starting subtest: basic-softpin [133.333677] Subtest basic-softpin: SUCCESS (0.001s) [134.367298] [028/132] (900s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip) [134.872060] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip [134.873414] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s) [135.480566] [029/132] (899s left) kms_chamelium_hpd (hdmi-hpd-fast) [136.064170] Subtest hdmi-hpd-fast: SKIP (0.000s) [136.465128] [030/132] (898s left) syncobj_timeline (device-submit-unordered) [136.527661] Starting subtest: device-submit-unordered [136.528437] Subtest device-submit-unordered: SUCCESS (0.001s) [136.661901] [031/132] (898s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render) [137.161772] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render [137.166803] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [137.774485] [032/132] (897s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite) [138.272030] Starting subtest: psr-rgb565-draw-pwrite [138.273450] Subtest psr-rgb565-draw-pwrite: SKIP (0.000s) [138.868098] [033/132] (896s left) gem_pread (bench) [138.923934] Starting subtest: bench [140.238093] Subtest bench: SUCCESS (1.313s) [140.380079] [034/132] (895s left) sysfs_timeslice_duration (invalid) [140.438066] Starting subtest: invalid [140.440196] Starting dynamic subtest: vcs0 [140.441569] Dynamic subtest vcs0: SKIP (0.000s) [140.452076] Starting dynamic subtest: bcs0 [140.453323] Dynamic subtest bcs0: SKIP (0.000s) [140.463441] Starting dynamic subtest: rcs0 [140.465095] Dynamic subtest rcs0: SKIP (0.000s) [140.466698] Subtest invalid: SKIP (0.004s) [140.564738] [035/132] (895s left) sw_sync (sync_merge) [140.618797] Starting subtest: sync_merge [140.619576] Subtest sync_merge: SUCCESS (0.001s) [140.732862] [036/132] (894s left) kms_big_fb (linear-16bpp-rotate-90) [141.232663] Starting subtest: linear-16bpp-rotate-90 [141.251649] Subtest linear-16bpp-rotate-90: SKIP (0.017s) [141.879524] [037/132] (893s left) gem_userptr_blits (stress-mm-invalidate-close-overlap) [141.953221] Starting subtest: stress-mm-invalidate-close-overlap [144.102197] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.148s) [144.259673] [038/132] (891s left) gem_exec_fence (expired-history) [144.451423] Starting subtest: expired-history [144.521258] Subtest expired-history: SUCCESS (0.070s) [144.878391] [039/132] (890s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt) [145.372287] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt [146.791122] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SUCCESS (1.420s) [147.422033] [040/132] (888s left) gem_workarounds (reset) [147.494952] Starting subtest: reset [147.501333] Subtest reset: SUCCESS (0.007s) [147.651538] [041/132] (888s left) gem_exec_params (no-blt) [147.709846] Starting subtest: no-blt [147.710718] Subtest no-blt: SUCCESS (0.000s) [147.855367] [042/132] (888s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [148.345986] Starting subtest: basic-busy-flip-before-cursor-atomic [149.383012] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (1.037s) [150.110540] [043/132] (885s left) kms_cursor_crc (cursor-onscreen-256x256) [150.617416] Starting subtest: cursor-onscreen-256x256 [150.620096] Starting dynamic subtest: pipe-A-HDMI-A-1 [152.820348] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.200s) [152.859251] Starting dynamic subtest: pipe-B-HDMI-A-1 [155.074269] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.225s) [155.075057] Subtest cursor-onscreen-256x256: SUCCESS (4.456s) [155.802534] [044/132] (880s left) gem_ctx_persistence (processes) [155.868102] Subtest processes: SKIP (0.000s) [155.927348] [045/132] (880s left) kms_pm_rpm (pm-tiling) [167.721261] Subtest pm-tiling: SKIP (0.000s) [168.019392] [046/132] (868s left) api_intel_bb (simple-bb) [168.079205] Starting subtest: simple-bb [168.080240] Subtest simple-bb: SUCCESS (0.003s) [168.240954] [047/132] (867s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move) [168.737474] Starting subtest: psr-2p-primscrn-cur-indfb-move [168.738913] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [169.341945] [048/132] (866s left) gem_exec_nop (basic-parallel) [169.413518] Starting subtest: basic-parallel [172.214953] Subtest basic-parallel: SUCCESS (2.801s) [172.481557] [049/132] (863s left) kms_psr2_sf (pr-cursor-plane-update-sf) [172.975271] Subtest pr-cursor-plane-update-sf: SKIP (0.000s) [173.274746] [050/132] (863s left) gem_exec_reloc (basic-write-read-active) [173.332012] Starting subtest: basic-write-read-active [173.441787] Subtest basic-write-read-active: SUCCESS (0.109s) [174.478936] [051/132] (861s left) gem_partial_pwrite_pread (write) [174.538036] Starting subtest: write [178.372247] Subtest write: SUCCESS (3.834s) [178.534854] [052/132] (857s left) gem_wait (await) [178.608199] Starting subtest: await [178.608974] Starting dynamic subtest: all-engines [179.640558] Dynamic subtest all-engines: SUCCESS (1.032s) [179.653746] Starting dynamic subtest: rcs0 [180.666498] Dynamic subtest rcs0: SUCCESS (1.024s) [180.679633] Starting dynamic subtest: bcs0 [181.695637] Dynamic subtest bcs0: SUCCESS (1.026s) [181.710034] Starting dynamic subtest: vcs0 [182.729636] Dynamic subtest vcs0: SUCCESS (1.031s) [182.731080] Subtest await: SUCCESS (4.122s) [182.975472] [053/132] (853s left) prime_busy (hang) [183.038701] Starting subtest: hang [183.039341] Starting dynamic subtest: rcs0 [188.857399] Dynamic subtest rcs0: SUCCESS (5.818s) [188.869507] Starting dynamic subtest: bcs0 [194.867153] Dynamic subtest bcs0: SUCCESS (6.009s) [194.879350] Starting dynamic subtest: vcs0 [200.877505] Dynamic subtest vcs0: SUCCESS (6.010s) [200.879392] Subtest hang: SUCCESS (17.841s) [201.040727] [054/132] (835s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc) [201.533906] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc [201.536536] Subtest fbcpsr-rgb101010-draw-mmap-wc: SKIP (0.000s) [202.140483] [055/132] (834s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible) [202.640893] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible [202.642917] Starting dynamic subtest: AB-VGA1-HDMI-A1 [204.215135] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (1.572s) [204.215993] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (1.575s) [204.955962] [056/132] (831s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic) [205.448679] Starting subtest: 2x-long-cursor-vs-flip-atomic [205.449916] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.002s) [206.056714] [057/132] (830s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite) [206.549938] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite [206.551361] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [207.152708] [058/132] (829s left) kms_rotation_crc (primary-rotation-180) [207.642491] Starting subtest: primary-rotation-180 [208.936314] Subtest primary-rotation-180: SUCCESS (1.294s) [209.756151] [059/132] (827s left) gem_lmem_swapping (parallel-random-verify) [209.819217] Subtest parallel-random-verify: SKIP (0.000s) [209.893547] [060/132] (826s left) gem_eio (reset-stress) [209.962924] Starting subtest: reset-stress [209.963718] Starting dynamic subtest: render [211.669372] Dynamic subtest render: SUCCESS (1.705s) [211.680792] Starting dynamic subtest: bsd [212.872900] Dynamic subtest bsd: FAIL (1.177s) [212.889725] Starting dynamic subtest: blt [214.502232] Dynamic subtest blt: SUCCESS (1.653s) [214.503207] Subtest reset-stress: FAIL (4.540s) [215.545453] [061/132] (821s left) syncobj_basic (bad-destroy) [215.606435] Starting subtest: bad-destroy [215.607275] Subtest bad-destroy: SUCCESS (0.000s) [215.726636] [062/132] (821s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc) [215.783813] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s) [215.839743] [063/132] (821s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [216.332427] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip [216.874590] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.542s) [217.591161] [064/132] (819s left) gem_softpin (zero) [217.653101] Subtest zero: SKIP (0.000s) [217.770853] [065/132] (819s left) kms_addfb_basic (basic-x-tiled-legacy) [217.831630] Starting subtest: basic-x-tiled-legacy [217.832440] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [218.879609] [066/132] (818s left) kms_big_fb (yf-tiled-8bpp-rotate-180) [219.373240] Starting subtest: yf-tiled-8bpp-rotate-180 [219.374881] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s) [219.984934] [067/132] (817s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render) [220.472442] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render [220.473990] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s) [221.088730] [068/132] (816s left) gem_ctx_exec (basic-norecovery) [221.148289] Starting subtest: basic-norecovery [221.158825] Subtest basic-norecovery: SUCCESS (0.010s) [221.330392] [069/132] (816s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling) [221.384575] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s) [221.445605] [070/132] (815s left) syncobj_timeline (single-wait-all-for-submit-signaled) [221.499983] Starting subtest: single-wait-all-for-submit-signaled [221.500828] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.001s) [221.628681] [071/132] (815s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled) [221.682162] Starting subtest: etime-multi-wait-all-submitted-signaled [221.785069] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.102s) [221.916825] [072/132] (815s left) perf_pmu (interrupts) [221.972408] Starting subtest: interrupts [223.024943] Subtest interrupts: SUCCESS (1.052s) [223.165808] [073/132] (814s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [223.650864] Starting subtest: compare-crc-sanitycheck-xr24 [223.653292] Starting dynamic subtest: pipe-A-HDMI-A-1 [224.025032] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.372s) [224.038791] Starting dynamic subtest: pipe-B-HDMI-A-1 [224.447853] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.419s) [224.448569] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.797s) [225.162739] [074/132] (812s left) gem_exec_schedule (preempt-queue-contexts) [225.233394] Subtest preempt-queue-contexts: SKIP (0.000s) [225.464616] [075/132] (812s left) kms_color_pipeline (plane-ctm3x4-lut1d) [225.951548] Starting subtest: plane-ctm3x4-lut1d [226.225655] Subtest plane-ctm3x4-lut1d: SKIP (0.273s) [226.942852] [076/132] (810s left) kms_chamelium_frames (hdmi-crc-fast) [227.508234] Subtest hdmi-crc-fast: SKIP (0.000s) [227.915739] [077/132] (809s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt) [228.405913] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt [228.407486] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [229.014879] [078/132] (808s left) gem_userptr_blits (dmabuf-unsync) [229.077936] Subtest dmabuf-unsync: SKIP (0.000s) [229.240335] [079/132] (808s left) kms_big_fb (x-tiled-64bpp-rotate-90) [229.734690] Starting subtest: x-tiled-64bpp-rotate-90 [229.747416] Subtest x-tiled-64bpp-rotate-90: SKIP (0.013s) [230.366144] [080/132] (807s left) kms_psr (fbc-psr2-primary-blt) [230.852426] Subtest fbc-psr2-primary-blt: SKIP (0.000s) [231.157103] [081/132] (806s left) kms_properties (plane-properties-legacy) [231.644774] Starting subtest: plane-properties-legacy [231.645557] Starting dynamic subtest: pipe-A-HDMI-A-1 [231.974577] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.329s) [231.988314] Starting dynamic subtest: pipe-B-HDMI-A-1 [232.395895] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.419s) [232.396579] Subtest plane-properties-legacy: SUCCESS (0.753s) [233.114062] [082/132] (804s left) kms_psr (pr-suspend) [233.610777] Subtest pr-suspend: SKIP (0.000s) [233.923455] [083/132] (804s left) gen9_exec_parse (bb-chained) [233.984413] Subtest bb-chained: SKIP (0.000s) [234.050539] [084/132] (804s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs) [234.108148] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.000s) [234.168246] [085/132] (804s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu) [234.656995] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu [234.658464] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [235.271436] [086/132] (802s left) i915_hangman (engine-error-state-capture) [235.333513] Subtest engine-error-state-capture: SKIP (0.000s) [235.400637] [087/132] (802s left) gem_mmap_offset (oob-read) [235.459241] Starting subtest: oob-read [235.459880] Subtest oob-read: SUCCESS (0.001s) [235.603885] [088/132] (802s left) kms_vblank (wait-busy) [236.099914] Starting subtest: wait-busy [236.100956] Starting dynamic subtest: pipe-A-HDMI-A-1 [238.498543] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.396s) [238.511136] Starting dynamic subtest: pipe-B-HDMI-A-1 [240.922608] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.422s) [240.923310] Subtest wait-busy: SUCCESS (4.823s) [241.646901] [089/132] (796s left) kms_content_protection (uevent-hdcp14) [242.152882] Starting subtest: uevent-hdcp14 [242.154254] Subtest uevent-hdcp14: SKIP (0.000s) [242.780777] [090/132] (795s left) syncobj_wait (single-wait-all-for-submit-submitted) [242.843551] Starting subtest: single-wait-all-for-submit-submitted [242.945111] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.101s) [243.071294] [091/132] (795s left) kms_pm_rpm (legacy-planes) [254.849951] Subtest legacy-planes: SKIP (0.000s) [255.144475] [092/132] (783s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt) [255.636871] Starting subtest: psr-2p-primscrn-indfb-plflip-blt [255.638170] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [256.247737] [093/132] (782s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs) [256.316945] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs [256.318581] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s) [256.562747] [094/132] (782s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area) [257.057780] Subtest psr2-primary-plane-update-sf-dmg-area: SKIP (0.000s) [257.357752] [095/132] (781s left) kms_vblank (ts-continuation-modeset) [257.841278] Starting subtest: ts-continuation-modeset [257.842424] Starting dynamic subtest: pipe-A-HDMI-A-1 [258.238855] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.396s) [258.252921] Starting dynamic subtest: pipe-B-HDMI-A-1 [258.666790] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.425s) [258.667578] Subtest ts-continuation-modeset: SUCCESS (0.828s) [259.381100] [096/132] (779s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt) [259.877391] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt [259.878820] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [260.481693] [097/132] (778s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible) [260.976894] Starting subtest: flip-vs-absolute-wf_vblank-interruptible [260.979109] Starting dynamic subtest: A-VGA1 [269.011869] Dynamic subtest A-VGA1: SUCCESS (8.033s) [269.026754] Starting dynamic subtest: B-VGA1 [276.985889] Dynamic subtest B-VGA1: SUCCESS (7.970s) [277.000259] Starting dynamic subtest: A-HDMI-A1 [285.126841] Dynamic subtest A-HDMI-A1: SUCCESS (8.138s) [285.141929] Starting dynamic subtest: B-HDMI-A1 [293.310733] Dynamic subtest B-HDMI-A1: SUCCESS (8.181s) [293.314847] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (32.336s) [294.082795] [098/132] (744s left) kms_sequence (get-forked-busy) [294.580936] Starting subtest: get-forked-busy [294.582211] Starting dynamic subtest: pipe-A-HDMI-A-1 [296.990571] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.408s) [297.004111] Starting dynamic subtest: pipe-B-HDMI-A-1 [299.431276] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.439s) [299.432016] Subtest get-forked-busy: SUCCESS (4.852s) [300.160906] [099/132] (738s left) kms_big_fb (y-tiled-64bpp-rotate-180) [300.658413] Starting subtest: y-tiled-64bpp-rotate-180 [300.659758] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s) [301.270942] [100/132] (737s left) sysfs_heartbeat_interval (idempotent) [301.332274] Starting subtest: idempotent [301.334557] Starting dynamic subtest: vcs0 [301.335180] Dynamic subtest vcs0: SUCCESS (0.001s) [301.349280] Starting dynamic subtest: bcs0 [301.349977] Dynamic subtest bcs0: SUCCESS (0.001s) [301.362379] Starting dynamic subtest: rcs0 [301.363579] Dynamic subtest rcs0: SUCCESS (0.001s) [301.364645] Subtest idempotent: SUCCESS (0.009s) [301.470803] [101/132] (737s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25) [301.950768] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25 [301.951558] Starting dynamic subtest: pipe-A [301.953598] Dynamic subtest pipe-A: SKIP (0.001s) [301.968412] Starting dynamic subtest: pipe-B [301.970352] Dynamic subtest pipe-B: SKIP (0.001s) [301.971607] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SKIP (0.005s) [302.551862] [102/132] (736s left) kms_psr (psr-sprite-plane-onoff) [303.036862] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [303.346641] [103/132] (735s left) kms_cursor_edge_walk (256x256-top-edge) [303.836158] Starting subtest: 256x256-top-edge [303.851106] Starting dynamic subtest: pipe-A-HDMI-A-1 [307.285472] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.447s) [307.299252] Starting dynamic subtest: pipe-B-HDMI-A-1 [310.620805] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.333s) [310.621558] Subtest 256x256-top-edge: SUCCESS (6.785s) [311.329745] [104/132] (727s left) fbdev (info) [311.412515] Starting subtest: info [311.413263] Subtest info: SUCCESS (0.000s) [311.545690] [105/132] (727s left) kms_atomic (crtc-invalid-params-fence) [312.031961] Starting subtest: crtc-invalid-params-fence [312.033920] Starting dynamic subtest: pipe-A-HDMI-A-1 [312.227349] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.192s) [312.228155] Subtest crtc-invalid-params-fence: SUCCESS (0.195s) [312.936511] [106/132] (726s left) sw_sync (sync_merge_same) [312.993272] Starting subtest: sync_merge_same [312.993977] Subtest sync_merge_same: SUCCESS (0.000s) [313.111701] [107/132] (726s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc) [313.596924] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc [313.598477] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [314.203495] [108/132] (725s left) kms_plane_multiple (tiling-4) [314.693436] Starting subtest: tiling-4 [314.695180] Subtest tiling-4: SKIP (0.000s) [315.303589] [109/132] (724s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling) [315.361091] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SKIP (0.000s) [315.428543] [110/132] (724s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [315.922454] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [315.923874] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [316.530783] [111/132] (723s left) kms_lease (empty-lease) [317.018505] Starting subtest: empty-lease [317.019331] Starting dynamic subtest: pipe-A-HDMI-A-1 [317.020020] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s) [317.034759] Starting dynamic subtest: pipe-B-HDMI-A-1 [317.035631] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s) [317.036452] Subtest empty-lease: SUCCESS (0.006s) [317.627604] [112/132] (722s left) gem_exec_flush (basic-uc-ro-default) [317.694543] Starting subtest: basic-uc-ro-default [323.141546] Subtest basic-uc-ro-default: SUCCESS (5.447s) [323.386864] [113/132] (716s left) gem_softpin (overlap) [323.446063] Starting subtest: overlap [323.629425] Subtest overlap: SUCCESS (0.183s) [323.796440] [114/132] (715s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt) [324.286502] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt [324.287754] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [324.896922] [115/132] (714s left) gem_mmap_wc (copy) [324.960096] Starting subtest: copy [325.161945] Subtest copy: SUCCESS (0.201s) [325.299045] [116/132] (714s left) kms_flip (dpms-vs-vblank-race) [325.783805] Starting subtest: dpms-vs-vblank-race [325.784560] Starting dynamic subtest: A-VGA1 [328.843818] Dynamic subtest A-VGA1: SUCCESS (3.058s) [328.856108] Starting dynamic subtest: B-VGA1 [331.875168] Dynamic subtest B-VGA1: SUCCESS (3.028s) [331.890532] Starting dynamic subtest: A-HDMI-A1 [334.922257] Dynamic subtest A-HDMI-A1: SUCCESS (3.047s) [334.936383] Starting dynamic subtest: B-HDMI-A1 [337.906081] Dynamic subtest B-HDMI-A1: SUCCESS (2.981s) [337.906937] Subtest dpms-vs-vblank-race: SUCCESS (12.123s) [338.647288] [117/132] (701s left) gem_exec_schedule (preempt-queue) [338.750473] Subtest preempt-queue: SKIP (0.000s) [338.976719] [118/132] (701s left) i915_query (query-regions-sanity-check) [339.031408] Starting subtest: query-regions-sanity-check [339.044867] Subtest query-regions-sanity-check: SUCCESS (0.013s) [339.197727] [119/132] (700s left) testdisplay [349.116343] [120/132] (690s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt) [349.623321] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt [349.624646] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [350.228478] [121/132] (689s left) kms_cursor_legacy (single-move) [350.727734] Starting subtest: single-move [350.728438] Starting dynamic subtest: pipe-A [356.112915] Dynamic subtest pipe-A: SUCCESS (5.383s) [356.126145] Starting dynamic subtest: pipe-B [361.498338] Dynamic subtest pipe-B: SUCCESS (5.382s) [361.514206] Starting dynamic subtest: all-pipes [366.884605] Dynamic subtest all-pipes: SUCCESS (5.383s) [366.885895] Subtest single-move: SUCCESS (16.157s) [367.491490] [122/132] (672s left) gem_exec_capture (capture) [367.552803] Subtest capture: SKIP (0.000s) [367.637539] [123/132] (672s left) drm_read (fault-buffer) [368.175392] Starting subtest: fault-buffer [368.176255] Subtest fault-buffer: SUCCESS (0.001s) [368.819464] [124/132] (671s left) syncobj_wait (signal) [368.882154] Starting subtest: signal [368.882890] Subtest signal: SUCCESS (0.000s) [369.003154] [125/132] (671s left) kms_cursor_crc (cursor-random-512x512) [369.498047] Starting subtest: cursor-random-512x512 [369.500864] Subtest cursor-random-512x512: SKIP (0.001s) [370.105789] [126/132] (670s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite) [370.600236] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite [372.546905] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (1.947s) [373.196699] [127/132] (667s left) gem_exec_balancer (bonded-chain) [373.258621] Subtest bonded-chain: SKIP (0.000s) [373.378632] [128/132] (667s left) gem_eio (throttle) [373.443798] Starting subtest: throttle [373.465677] Subtest throttle: SUCCESS (0.022s) [374.500849] [129/132] (666s left) syncobj_timeline (etime-single-wait-for-submit-submitted) [374.557584] Starting subtest: etime-single-wait-for-submit-submitted [374.664991] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.107s) [374.796162] [130/132] (665s left) i915_drm_fdinfo (all-busy-idle-check-all) [374.853918] Subtest all-busy-idle-check-all: SKIP (0.000s) [374.922232] [131/132] (665s left) kms_flip (2x-flip-vs-suspend) [375.406226] Starting subtest: 2x-flip-vs-suspend [375.407429] Starting dynamic subtest: AB-VGA1-HDMI-A1 [579.179382] Per-test timeout exceeded. Killing the current test with SIGQUIT. [586.016489] Closing watchdogs [586.019490] Initializing watchdogs [586.019564] /dev/watchdog0 [586.049248] [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) [586.061107] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [586.062729] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [586.063482] [FACT before any test] new: kernel.kmod_is_loaded.vgem: true [586.067645] [132/132] (460s left) kms_psr (fbc-pr-sprite-plane-onoff) [586.601540] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s) [586.919815] 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.