[71.189096] Initializing watchdogs [71.189227] /dev/watchdog0 [71.210814] [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.220253] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [71.223923] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [71.227520] [001/131] (960s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-upscaling) [71.298306] Subtest flip-64bpp-yftile-to-32bpp-yftile-upscaling: SKIP (0.000s) [71.357213] [002/131] (960s left) dumb_buffer (create-clear) [71.415355] Starting subtest: create-clear [111.503118] Subtest create-clear: SUCCESS (40.072s) [111.616539] [003/131] (920s left) syncobj_wait (reset-unsignaled) [111.678305] Starting subtest: reset-unsignaled [111.679477] Subtest reset-unsignaled: SUCCESS (0.000s) [111.768523] [004/131] (920s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt) [112.263982] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt [112.266352] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [112.371158] [005/131] (919s left) gem_exec_reloc (basic-gtt-read-active) [112.436032] Starting subtest: basic-gtt-read-active [112.548997] Subtest basic-gtt-read-active: SUCCESS (0.113s) [113.067367] [006/131] (918s left) gem_mmap (basic-small-bo) [113.125124] Starting subtest: basic-small-bo [113.655717] Subtest basic-small-bo: SUCCESS (0.530s) [113.761541] [007/131] (918s left) kms_force_connector_basic (force-edid) [113.944157] Starting subtest: force-edid [113.967365] Subtest force-edid: SUCCESS (0.024s) [114.338250] [008/131] (917s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled) [114.418640] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled [114.420927] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.001s) [114.513984] [009/131] (917s left) kms_cursor_crc (cursor-rapid-movement-256x256) [115.043826] Starting subtest: cursor-rapid-movement-256x256 [115.063546] Starting dynamic subtest: pipe-A-VGA-1 [115.517336] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.455s) [115.562493] Starting dynamic subtest: pipe-B-HDMI-A-1 [115.917337] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.365s) [115.918511] Subtest cursor-rapid-movement-256x256: SUCCESS (0.874s) [116.203182] [010/131] (915s left) i915_pm_freq_api (freq-basic-api) [116.266956] Subtest freq-basic-api: SKIP (0.000s) [116.327653] [011/131] (915s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc) [116.816449] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc [116.818867] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s) [116.917055] [012/131] (915s left) kms_flip (2x-flip-vs-suspend) [117.405470] Starting subtest: 2x-flip-vs-suspend [117.406644] Starting dynamic subtest: AB-VGA1-HDMI-A1 [321.841761] Per-test timeout exceeded. Killing the current test with SIGQUIT. [333.542149] Closing watchdogs [333.549015] Initializing watchdogs [333.549109] /dev/watchdog0 [333.571334] [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) [333.579192] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [333.580857] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [333.584597] [013/131] (709s left) gem_ccs (ctrl-surf-copy) [333.654406] Subtest ctrl-surf-copy: SKIP (0.000s) [333.712917] [014/131] (709s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render) [334.200273] Starting subtest: fbc-rgb101010-draw-render [336.879008] Subtest fbc-rgb101010-draw-render: SUCCESS (2.678s) [337.116355] [015/131] (706s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc) [337.179899] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.000s) [337.238485] [016/131] (706s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw) [337.724365] Starting subtest: fbc-2p-pri-indfb-multidraw [351.924824] Subtest fbc-2p-pri-indfb-multidraw: SUCCESS (14.201s) [352.060759] [017/131] (691s left) kms_lease (lease-invalid-connector) [352.544947] Starting subtest: lease-invalid-connector [352.546069] Starting dynamic subtest: pipe-A-VGA-1 [352.547287] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.000s) [352.563290] Starting dynamic subtest: pipe-A-HDMI-A-1 [352.564830] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.000s) [352.580591] Starting dynamic subtest: pipe-B-VGA-1 [352.581855] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.000s) [352.597271] Starting dynamic subtest: pipe-B-HDMI-A-1 [352.599230] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s) [352.600962] Subtest lease-invalid-connector: SUCCESS (0.006s) [352.644759] [018/131] (690s left) kms_color (ctm-red-to-blue) [353.124760] Starting subtest: ctm-red-to-blue [353.126066] Starting dynamic subtest: pipe-A-VGA-1 [353.667849] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.543s) [353.682023] Starting dynamic subtest: pipe-A-HDMI-A-1 [354.182091] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.513s) [354.196340] Starting dynamic subtest: pipe-B-VGA-1 [354.592155] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.410s) [354.607369] Starting dynamic subtest: pipe-B-HDMI-A-1 [355.103362] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.509s) [355.104454] Subtest ctm-red-to-blue: SUCCESS (1.980s) [355.360528] [019/131] (688s left) gem_exec_schedule (u-fairslice) [355.430962] Subtest u-fairslice: SKIP (0.000s) [355.627116] [020/131] (688s left) kms_psr2_su (page_flip-nv12) [355.682972] Subtest page_flip-NV12: SKIP (0.000s) [355.738269] [021/131] (688s left) i915_query (engine-info) [355.800818] Starting subtest: engine-info [355.801975] Subtest engine-info: SUCCESS (0.001s) [355.894623] [022/131] (687s left) gem_pxp (protected-raw-src-copy-not-readible) [358.467366] Starting subtest: protected-raw-src-copy-not-readible [358.469562] Subtest protected-raw-src-copy-not-readible: SKIP (0.000s) [358.567941] [023/131] (685s left) kms_getfb (getfb-handle-protection) [359.051649] Starting subtest: getfb-handle-protection [359.074678] Subtest getfb-handle-protection: SUCCESS (0.024s) [359.189037] [024/131] (684s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render) [359.675475] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render [359.677722] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [359.785480] [025/131] (684s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode) [360.375211] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s) [360.585493] [026/131] (683s left) gem_exec_balancer (sliced) [360.648448] Subtest sliced: SKIP (0.000s) [360.740100] [027/131] (683s left) gem_softpin (allocator-basic) [360.802476] Subtest allocator-basic: SKIP (0.000s) [360.888935] [028/131] (683s left) i915_pm_rps (min-max-config-idle) [360.954517] Starting subtest: min-max-config-idle [361.162970] Subtest min-max-config-idle: SUCCESS (0.208s) [361.289710] [029/131] (682s left) kms_selftest (drm_format_helper) [361.358390] Starting subtest: drm_format_helper [361.375437] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8 [361.455197] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.082s) [361.472349] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332 [361.520146] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.064s) [361.539475] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565 [361.594525] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.072s) [361.612098] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555 [361.672996] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.075s) [361.689226] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555 [361.738056] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.064s) [361.753465] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551 [361.816238] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.077s) [361.832001] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888 [361.895016] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.076s) [361.909574] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888 [361.964810] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.069s) [361.979584] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888 [362.033073] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.067s) [362.049407] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010 [362.111251] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.074s) [362.127545] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010 [362.187303] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.075s) [362.201901] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono [362.264694] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.075s) [362.280264] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab [362.340882] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.074s) [362.356203] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888 [362.418097] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.076s) [362.434144] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888 [362.491869] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.072s) [362.507050] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset [362.567657] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.074s) [362.582562] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy [362.653467] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.083s) [362.654464] Subtest drm_format_helper: SUCCESS (1.295s) [362.804730] [030/131] (681s left) kms_psr (psr-primary-mmap-cpu) [363.281523] Subtest psr-primary-mmap-cpu: SKIP (0.000s) [363.345473] [031/131] (680s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs) [363.407423] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SKIP (0.000s) [363.469398] [032/131] (680s left) gem_exec_params (rel-constants-invalid) [363.530469] Starting subtest: rel-constants-invalid [363.531472] Subtest rel-constants-invalid: SUCCESS (0.000s) [363.642575] [033/131] (680s left) api_intel_allocator (simple-allocator) [363.702211] Starting subtest: simple-allocator [363.703702] Starting dynamic subtest: basic [363.708483] Dynamic subtest basic: SUCCESS (0.007s) [363.726395] Starting dynamic subtest: parallel-one [364.008603] Dynamic subtest parallel-one: SUCCESS (0.298s) [364.025809] Starting dynamic subtest: print [364.026952] Dynamic subtest print: SUCCESS (0.000s) [364.043178] Starting dynamic subtest: reuse [364.044600] Dynamic subtest reuse: SUCCESS (0.000s) [364.059751] Starting dynamic subtest: reserve [364.061102] Dynamic subtest reserve: SUCCESS (0.000s) [364.076254] Starting dynamic subtest: fork-reopen-allocator [364.077831] Dynamic subtest fork-reopen-allocator: SUCCESS (0.020s) [364.079348] Subtest simple-allocator: SUCCESS (0.335s) [364.161755] [034/131] (680s left) kms_pm_rpm (fences) [375.937214] Subtest fences: SKIP (0.000s) [376.005027] [035/131] (668s left) sysfs_timeslice_duration (idempotent) [376.069538] Starting subtest: idempotent [376.070675] Starting dynamic subtest: vcs0 [376.072912] Dynamic subtest vcs0: SKIP (0.000s) [376.087969] Starting dynamic subtest: bcs0 [376.090632] Dynamic subtest bcs0: SKIP (0.000s) [376.108117] Starting dynamic subtest: rcs0 [376.110926] Dynamic subtest rcs0: SKIP (0.000s) [376.113410] Subtest idempotent: SKIP (0.005s) [376.173757] [036/131] (668s left) gem_mmap_gtt (basic-copy) [376.232838] Starting subtest: basic-copy [376.449593] Subtest basic-copy: SUCCESS (0.217s) [376.571355] [037/131] (668s left) kms_addfb_basic (addfb25-4-tiled) [377.049634] Starting subtest: addfb25-4-tiled [377.050805] Subtest addfb25-4-tiled: SUCCESS (0.000s) [377.163534] [038/131] (667s left) gem_exec_store (pages) [377.239704] Starting subtest: pages [377.240824] Starting dynamic subtest: rcs0 [377.297290] Dynamic subtest rcs0: SUCCESS (0.057s) [377.315290] Starting dynamic subtest: bcs0 [377.345049] Dynamic subtest bcs0: SUCCESS (0.045s) [377.348790] Subtest pages: SUCCESS (0.108s) [377.553779] [039/131] (667s left) gen7_exec_parse (basic-allocation) [377.615036] Subtest basic-allocation: SKIP (0.000s) [377.680739] [040/131] (667s left) kms_big_fb (yf-tiled-16bpp-rotate-90) [378.168834] Starting subtest: yf-tiled-16bpp-rotate-90 [378.171200] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s) [378.284601] [041/131] (666s left) gem_ctx_persistence (legacy-engines-mixed) [378.347208] Subtest legacy-engines-mixed: SKIP (0.000s) [378.417665] [042/131] (666s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move) [378.900007] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move [378.902495] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [379.002878] [043/131] (665s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs) [379.063607] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s) [379.133527] [044/131] (665s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt) [379.620456] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt [379.622485] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [379.730831] [045/131] (665s left) gem_pwrite_snooped [379.925690] [046/131] (665s left) gem_ctx_shared (disjoint-timelines) [379.985012] Subtest disjoint-timelines: SKIP (0.000s) [380.081477] [047/131] (665s left) gem_exec_flush (basic-wb-prw-default) [380.158520] Starting subtest: basic-wb-prw-default [385.609438] Subtest basic-wb-prw-default: SUCCESS (5.451s) [385.810971] [048/131] (659s left) gem_partial_pwrite_pread (write-snoop) [385.874901] Starting subtest: write-snoop [389.869825] Subtest write-snoop: SUCCESS (3.995s) [389.995726] [049/131] (655s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs) [390.052434] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.000s) [390.121711] [050/131] (655s left) kms_big_fb (yf-tiled-8bpp-rotate-270) [390.610132] Starting subtest: yf-tiled-8bpp-rotate-270 [390.612477] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s) [390.725713] [051/131] (654s left) kms_atomic_transition (plane-toggle-modeset-transition) [391.207441] Starting subtest: plane-toggle-modeset-transition [391.208603] Starting dynamic subtest: pipe-A-VGA-1 [391.927622] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.718s) [391.945198] Starting dynamic subtest: pipe-A-HDMI-A-1 [392.852256] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.920s) [392.871730] Starting dynamic subtest: pipe-B-VGA-1 [393.478797] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.622s) [393.496474] Starting dynamic subtest: pipe-B-HDMI-A-1 [394.437354] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.954s) [394.438587] Subtest plane-toggle-modeset-transition: SUCCESS (3.231s) [394.726933] [052/131] (650s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-render) [395.211464] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-render [396.713620] Subtest fbc-1p-offscreen-pri-shrfb-draw-render: SUCCESS (1.503s) [396.949577] [053/131] (648s left) gem_lmem_swapping (heavy-verify-multi-ccs) [397.017859] Subtest heavy-verify-multi-ccs: SKIP (0.000s) [397.076313] [054/131] (648s left) kms_plane_multiple (tiling-y) [397.553111] Starting subtest: tiling-y [397.555596] Subtest tiling-y: SKIP (0.000s) [397.646837] [055/131] (647s left) gem_lmem_swapping (verify-random-ccs) [397.712346] Subtest verify-random-ccs: SKIP (0.000s) [397.774510] [056/131] (647s left) perf (polling-small-buf) [397.903476] Subtest polling-small-buf: SKIP (0.000s) [397.958140] [057/131] (647s left) syncobj_basic (bad-pad-handle-to-fd) [398.025883] Starting subtest: bad-pad-handle-to-fd [398.027019] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s) [398.119019] [058/131] (647s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen) [398.603558] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen [398.606033] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [398.715577] [059/131] (646s left) kms_psr (pr-no-drrs) [399.194636] Subtest pr-no-drrs: SKIP (0.000s) [399.261908] [060/131] (646s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite) [399.745924] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite [399.748417] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [399.861595] [061/131] (645s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf) [400.346117] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s) [400.404163] [062/131] (645s left) prime_mmap_coherency (write) [400.468006] Starting subtest: write [405.849476] Subtest write: SUCCESS (5.379s) [406.461318] [063/131] (639s left) gem_exec_balancer (hang) [406.522236] Subtest hang: SKIP (0.000s) [406.622886] [064/131] (639s left) kms_feature_discovery (display-2x) [407.100792] Starting subtest: display-2x [407.101987] Subtest display-2x: SUCCESS (0.000s) [407.195838] [065/131] (638s left) kms_addfb_basic (too-high) [407.667894] Starting subtest: too-high [407.669114] Subtest too-high: SUCCESS (0.001s) [407.777116] [066/131] (638s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move) [408.258367] Starting subtest: fbc-2p-scndscrn-spr-indfb-move [410.371515] Subtest fbc-2p-scndscrn-spr-indfb-move: SUCCESS (2.113s) [410.537497] [067/131] (635s left) kms_cursor_legacy (cursora-vs-flipb-legacy) [411.015193] Starting subtest: cursorA-vs-flipB-legacy [421.965779] Subtest cursorA-vs-flipB-legacy: SUCCESS (10.949s) [422.232961] [068/131] (623s left) gem_mmap_gtt (pf-nonblock) [422.291170] Starting subtest: pf-nonblock [422.296447] Subtest pf-nonblock: SUCCESS (0.001s) [422.412845] [069/131] (623s left) kms_frontbuffer_tracking (psr-2p-pri-indfb-multidraw) [422.898471] Starting subtest: psr-2p-pri-indfb-multidraw [422.900883] Subtest psr-2p-pri-indfb-multidraw: SKIP (0.000s) [423.010735] [070/131] (623s left) syncobj_wait (multi-wait-all-submitted) [423.076400] Starting subtest: multi-wait-all-submitted [423.183310] Subtest multi-wait-all-submitted: SUCCESS (0.108s) [423.277889] [071/131] (623s left) gem_ringfill (engines-basic) [423.463425] Starting subtest: engines-basic [423.464517] Starting dynamic subtest: rcs0 [423.493408] Dynamic subtest rcs0: SUCCESS (0.029s) [423.512431] Starting dynamic subtest: bcs0 [423.513796] Dynamic subtest bcs0: SUCCESS (0.017s) [423.515207] Subtest engines-basic: SUCCESS (0.052s) [423.613998] [FACT gem_ringfill (engines-basic)] new: kernel.kmod_is_loaded.vgem: true [423.617538] [072/131] (622s left) gem_linear_blits (normal) [423.887771] Starting subtest: normal [425.956154] Subtest normal: SUCCESS (2.068s) [426.113140] [073/131] (620s left) kms_cursor_crc (cursor-sliding-32x10) [426.702203] Starting subtest: cursor-sliding-32x10 [426.760565] Subtest cursor-sliding-32x10: SKIP (0.055s) [426.876595] [074/131] (619s left) kms_plane (pixel-format-4-tiled-modifier) [427.353169] Starting subtest: pixel-format-4-tiled-modifier [427.355702] Subtest pixel-format-4-tiled-modifier: SKIP (0.000s) [427.459740] [075/131] (619s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt) [427.947460] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt [429.800016] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SUCCESS (1.853s) [429.953256] [076/131] (616s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic) [430.434317] Starting subtest: flip-vs-cursor-busy-crc-atomic [431.059821] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.625s) [431.348858] [077/131] (615s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite) [431.834369] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite [431.836423] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [431.946990] [078/131] (614s left) syncobj_timeline (multi-wait-available-submitted) [432.025707] Starting subtest: multi-wait-available-submitted [432.026842] Subtest multi-wait-available-submitted: SUCCESS (0.001s) [432.130926] [079/131] (614s left) kms_psr (fbc-psr-cursor-render) [432.605436] Subtest fbc-psr-cursor-render: SKIP (0.000s) [432.675966] [080/131] (614s left) gem_exec_fence (syncobj-timeline-repeat) [432.998261] Starting subtest: syncobj-timeline-repeat [433.597690] Subtest syncobj-timeline-repeat: SUCCESS (0.599s) [433.831699] [081/131] (613s left) gen9_exec_parse (allowed-all) [433.897635] Subtest allowed-all: SKIP (0.000s) [433.972404] [082/131] (612s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt) [434.456580] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt [434.458955] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [434.572609] [083/131] (612s left) kms_psr (psr-cursor-blt) [435.052363] Subtest psr-cursor-blt: SKIP (0.000s) [435.119350] [084/131] (611s left) kms_cursor_crc (cursor-onscreen-32x10) [435.602644] Starting subtest: cursor-onscreen-32x10 [435.653249] Subtest cursor-onscreen-32x10: SKIP (0.051s) [435.770828] [085/131] (611s left) gem_caching (read-writes) [435.836185] Starting subtest: read-writes [440.906855] Subtest read-writes: SUCCESS (5.071s) [441.047666] [086/131] (606s left) gem_create (create-ext-placement-each) [441.219656] Starting subtest: create-ext-placement-each [441.220877] Subtest create-ext-placement-each: SUCCESS (0.000s) [441.340932] [087/131] (605s left) kms_psr (fbc-psr2-primary-blt) [441.811308] Subtest fbc-psr2-primary-blt: SKIP (0.000s) [441.888484] [088/131] (605s left) gem_exec_gttfill (multigpu-basic) [442.070445] Starting subtest: multigpu-basic [446.621172] Subtest multigpu-basic: SUCCESS (4.550s) [446.690095] [089/131] (600s left) gem_workarounds (basic-read-context) [446.850238] Starting subtest: basic-read-context [446.855194] Subtest basic-read-context: SUCCESS (0.006s) [446.985179] [090/131] (600s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible) [447.474113] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible [447.476704] Starting dynamic subtest: AB-VGA1-HDMI-A1 [478.263206] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (30.787s) [478.268271] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SUCCESS (30.793s) [478.525094] [091/131] (568s left) gem_render_copy_redux (interruptible) [478.592686] Starting subtest: interruptible [479.179347] Subtest interruptible: SUCCESS (0.586s) [479.311196] [092/131] (568s left) i915_query (query-garbage) [479.378101] Starting subtest: query-garbage [479.379253] Subtest query-garbage: SUCCESS (0.000s) [479.471699] [093/131] (568s left) kms_big_fb (x-tiled-16bpp-rotate-0) [479.961476] Starting subtest: x-tiled-16bpp-rotate-0 [481.272520] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.312s) [481.542150] [094/131] (566s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite) [482.030248] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite [484.131287] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SUCCESS (2.104s) [484.305277] [095/131] (563s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted) [484.383505] Starting subtest: etime-multi-wait-all-available-unsubmitted [484.487330] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.103s) [484.589865] [096/131] (563s left) kms_content_protection (atomic-dpms-hdcp14) [485.086969] Starting subtest: atomic-dpms-hdcp14 [485.089420] Subtest atomic-dpms-hdcp14: SKIP (0.000s) [485.206634] [097/131] (562s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf) [485.689672] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (0.000s) [485.759957] [098/131] (562s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt) [486.242416] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt [486.244712] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [486.364562] [099/131] (561s left) gem_mmap_gtt (big-bo) [486.425207] Starting subtest: big-bo [486.773436] Subtest big-bo: SUCCESS (0.348s) [486.922428] [100/131] (561s left) i915_drm_fdinfo (context-close-stress) [487.092774] Subtest context-close-stress: SKIP (0.000s) [487.158065] [101/131] (560s left) kms_plane (plane-panning-top-left) [487.648404] Starting subtest: plane-panning-top-left [487.649986] Starting dynamic subtest: pipe-A [488.211473] Dynamic subtest pipe-A: SUCCESS (0.563s) [488.229358] Starting dynamic subtest: pipe-B [488.817825] Dynamic subtest pipe-B: SUCCESS (0.604s) [488.818966] Subtest plane-panning-top-left: SUCCESS (1.171s) [489.088824] [102/131] (559s left) kms_chamelium_frames (dp-crc-multiple) [489.682461] Subtest dp-crc-multiple: SKIP (0.000s) [489.897898] [103/131] (558s left) drm_read (short-buffer-block) [490.531524] Starting subtest: short-buffer-block [490.532818] Subtest short-buffer-block: SUCCESS (0.000s) [490.752898] [104/131] (557s left) kms_vblank (wait-idle-hang) [491.228016] Starting subtest: wait-idle-hang [491.229515] Starting dynamic subtest: pipe-A-VGA-1 [497.252463] Dynamic subtest pipe-A-VGA-1: SUCCESS (6.022s) [497.272371] Starting dynamic subtest: pipe-A-HDMI-A-1 [503.287244] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.032s) [503.308582] Starting dynamic subtest: pipe-B-VGA-1 [509.215733] Dynamic subtest pipe-B-VGA-1: SUCCESS (5.926s) [509.237179] Starting dynamic subtest: pipe-B-HDMI-A-1 [515.252315] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (6.034s) [515.253443] Subtest wait-idle-hang: SUCCESS (24.026s) [515.534032] [105/131] (532s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc) [515.636917] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s) [515.711926] [106/131] (532s left) kms_atomic_transition (modeset-transition-fencing) [516.189459] Starting subtest: modeset-transition-fencing [516.190456] Starting dynamic subtest: 1x-outputs [516.985657] Dynamic subtest 1x-outputs: SUCCESS (0.797s) [517.004819] Starting dynamic subtest: 2x-outputs [519.096354] Dynamic subtest 2x-outputs: SUCCESS (2.107s) [519.097484] Subtest modeset-transition-fencing: SUCCESS (2.909s) [519.382460] [107/131] (529s left) perf (low-oa-exponent-permissions) [519.542649] Subtest low-oa-exponent-permissions: SKIP (0.000s) [519.606625] [108/131] (528s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size) [520.088715] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size [531.084208] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SUCCESS (10.996s) [531.350841] [109/131] (517s left) kms_big_fb (y-tiled-64bpp-rotate-270) [531.841358] Starting subtest: y-tiled-64bpp-rotate-270 [531.844069] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s) [531.951476] [110/131] (516s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75) [532.424982] Starting subtest: planes-unity-scaling-downscale-factor-0-75 [532.426008] Starting dynamic subtest: pipe-A [532.430219] Dynamic subtest pipe-A: SKIP (0.002s) [532.447604] Starting dynamic subtest: pipe-B [532.452434] Dynamic subtest pipe-B: SKIP (0.001s) [532.454672] Subtest planes-unity-scaling-downscale-factor-0-75: SKIP (0.006s) [532.531781] [111/131] (516s left) kms_dirtyfb (fbc-dirtyfb-ioctl) [533.007200] Starting subtest: fbc-dirtyfb-ioctl [533.008385] Starting dynamic subtest: A-VGA-1 [534.371255] Dynamic subtest A-VGA-1: SUCCESS (1.361s) [534.388186] Starting dynamic subtest: A-HDMI-A-1 [535.814583] Dynamic subtest A-HDMI-A-1: SUCCESS (1.442s) [535.815557] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.809s) [536.080043] [112/131] (512s left) gem_userptr_blits (usage-restrictions) [536.147682] Starting subtest: usage-restrictions [536.148808] Subtest usage-restrictions: SUCCESS (0.000s) [536.295984] [113/131] (512s left) prime_mmap (test_userptr) [536.356018] Starting subtest: test_userptr [536.357383] Starting dynamic subtest: test_userptr-smem [536.358489] Dynamic subtest test_userptr-smem: SUCCESS (0.000s) [536.359577] Subtest test_userptr: SUCCESS (0.002s) [536.479315] [114/131] (512s left) kms_multipipe_modeset (basic-max-pipe-crc-check) [536.950758] Starting subtest: basic-max-pipe-crc-check [537.629866] Subtest basic-max-pipe-crc-check: SUCCESS (0.680s) [537.719768] [115/131] (511s left) gem_exec_reloc (basic-wc-gtt) [537.781367] Starting subtest: basic-wc-gtt [537.785809] Subtest basic-wc-gtt: SUCCESS (0.004s) [538.298506] [116/131] (510s left) kms_vrr (max-min) [538.778460] Starting subtest: max-min [538.783317] Subtest max-min: SKIP (0.000s) [538.883513] [117/131] (510s left) kms_rotation_crc (primary-y-tiled-reflect-x-90) [539.355958] Starting subtest: primary-y-tiled-reflect-x-90 [539.358390] Subtest primary-y-tiled-reflect-x-90: SKIP (0.001s) [539.463952] [118/131] (509s left) gem_exec_schedule (pi-ringfull) [539.542519] Subtest pi-ringfull: SKIP (0.000s) [539.756743] [119/131] (509s left) kms_big_fb (4-tiled-16bpp-rotate-90) [540.239575] Starting subtest: 4-tiled-16bpp-rotate-90 [540.241938] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.000s) [540.362969] [120/131] (508s left) gem_ctx_isolation (preservation) [540.434922] Starting subtest: preservation [540.436070] Starting dynamic subtest: rcs0 [540.999239] Dynamic subtest rcs0: SUCCESS (0.562s) [541.001234] Subtest preservation: SUCCESS (0.564s) [541.242638] [121/131] (507s left) gem_basic (create-fd-close) [541.301505] Starting subtest: create-fd-close [541.303661] Subtest create-fd-close: SUCCESS (0.000s) [541.411976] [122/131] (507s left) perf_pmu (most-busy-check-all) [541.473257] Starting subtest: most-busy-check-all [541.474358] Starting dynamic subtest: rcs0 [541.990835] Dynamic subtest rcs0: SUCCESS (0.516s) [542.009997] Starting dynamic subtest: bcs0 [542.506742] Dynamic subtest bcs0: SUCCESS (0.514s) [542.526063] Starting dynamic subtest: vcs0 [543.026347] Dynamic subtest vcs0: SUCCESS (0.518s) [543.027499] Subtest most-busy-check-all: SUCCESS (1.554s) [543.129530] [123/131] (506s left) kms_big_fb (linear-64bpp-rotate-90) [543.611265] Starting subtest: linear-64bpp-rotate-90 [543.696356] Subtest linear-64bpp-rotate-90: SKIP (0.085s) [543.974784] [124/131] (505s left) gem_exec_params (secure-non-root) [544.039498] Starting subtest: secure-non-root [544.041884] Subtest secure-non-root: SKIP (0.000s) [544.157383] [125/131] (505s left) gem_ppgtt (shrink-vs-evict-pinned) [544.221166] Starting subtest: shrink-vs-evict-pinned [544.223453] Subtest shrink-vs-evict-pinned: SKIP (0.001s) [544.313278] [126/131] (505s left) syncobj_timeline (wait-any-interrupted) [544.377137] Starting subtest: wait-any-interrupted [544.479310] Subtest wait-any-interrupted: SUCCESS (0.104s) [544.587970] [127/131] (504s left) kms_joiner (invalid-modeset-force-big-joiner) [545.062870] Starting subtest: invalid-modeset-force-big-joiner [545.065426] Subtest invalid-modeset-force-big-joiner: SKIP (0.000s) [545.173966] [128/131] (504s left) drm_read (empty-nonblock) [545.754166] Starting subtest: empty-nonblock [545.755621] Subtest empty-nonblock: SUCCESS (0.000s) [545.995070] [129/131] (503s left) kms_busy (basic-hang) [546.476592] Starting subtest: basic-hang [546.477687] Starting dynamic subtest: flip-pipe-A [546.927145] Dynamic subtest flip-pipe-A: SUCCESS (0.449s) [546.948660] Starting dynamic subtest: modeset-pipe-A [547.466699] Dynamic subtest modeset-pipe-A: SUCCESS (0.538s) [547.487943] Starting dynamic subtest: flip-pipe-B [547.907597] Dynamic subtest flip-pipe-B: SUCCESS (0.438s) [547.925330] Starting dynamic subtest: modeset-pipe-B [548.691780] Dynamic subtest modeset-pipe-B: SUCCESS (0.783s) [548.694491] Subtest basic-hang: SUCCESS (2.218s) [549.003625] [130/131] (500s left) api_intel_bb (offset-control) [549.065542] Starting subtest: offset-control [549.067597] Subtest offset-control: SUCCESS (0.003s) [549.191010] [131/131] (500s left) syncobj_timeline (etime-multi-wait-all-submitted) [549.251105] Starting subtest: etime-multi-wait-all-submitted [549.359247] Subtest etime-multi-wait-all-submitted: SUCCESS (0.108s) [549.453026] Closing watchdogs results: parsing output: 0/ for test: kms_flip_scaled_crc results: parsing output: 1/ for test: dumb_buffer results: parsing output: 2/ for test: syncobj_wait results: parsing output: 3/ for test: kms_frontbuffer_tracking results: parsing output: 4/ for test: gem_exec_reloc results: parsing output: 5/ for test: gem_mmap results: parsing output: 6/ for test: kms_force_connector_basic results: parsing output: 7/ for test: syncobj_timeline results: parsing output: 8/ for test: kms_cursor_crc results: parsing output: 9/ for test: i915_pm_freq_api results: parsing output: 10/ for test: kms_frontbuffer_tracking results: parsing output: 11/ for test: kms_flip results: parsing output: 12/ for test: gem_ccs results: parsing output: 13/ for test: kms_frontbuffer_tracking results: parsing output: 14/ for test: kms_ccs results: parsing output: 15/ for test: kms_frontbuffer_tracking results: parsing output: 16/ for test: kms_lease results: parsing output: 17/ for test: kms_color results: parsing output: 18/ for test: gem_exec_schedule results: parsing output: 19/ for test: kms_psr2_su results: parsing output: 20/ for test: i915_query results: parsing output: 21/ for test: gem_pxp results: parsing output: 22/ for test: kms_getfb results: parsing output: 23/ for test: kms_frontbuffer_tracking results: parsing output: 24/ for test: kms_chamelium_hpd results: parsing output: 25/ for test: gem_exec_balancer results: parsing output: 26/ for test: gem_softpin results: parsing output: 27/ for test: i915_pm_rps results: parsing output: 28/ for test: kms_selftest results: parsing output: 29/ for test: kms_psr results: parsing output: 30/ for test: kms_ccs results: parsing output: 31/ for test: gem_exec_params results: parsing output: 32/ for test: api_intel_allocator results: parsing output: 33/ for test: kms_pm_rpm results: parsing output: 34/ for test: sysfs_timeslice_duration results: parsing output: 35/ for test: gem_mmap_gtt results: parsing output: 36/ for test: kms_addfb_basic results: parsing output: 37/ for test: gem_exec_store results: parsing output: 38/ for test: gen7_exec_parse results: parsing output: 39/ for test: kms_big_fb results: parsing output: 40/ for test: gem_ctx_persistence results: parsing output: 41/ for test: kms_frontbuffer_tracking results: parsing output: 42/ for test: kms_ccs results: parsing output: 43/ for test: kms_frontbuffer_tracking results: parsing output: 44/ for test: gem_pwrite_snooped results: parsing output: 45/ for test: gem_ctx_shared results: parsing output: 46/ for test: gem_exec_flush results: parsing output: 47/ for test: gem_partial_pwrite_pread results: parsing output: 48/ for test: kms_ccs results: parsing output: 49/ for test: kms_big_fb results: parsing output: 50/ for test: kms_atomic_transition results: parsing output: 51/ for test: kms_frontbuffer_tracking results: parsing output: 52/ for test: gem_lmem_swapping results: parsing output: 53/ for test: kms_plane_multiple results: parsing output: 54/ for test: gem_lmem_swapping results: parsing output: 55/ for test: perf results: parsing output: 56/ for test: syncobj_basic results: parsing output: 57/ for test: kms_frontbuffer_tracking results: parsing output: 58/ for test: kms_psr results: parsing output: 59/ for test: kms_frontbuffer_tracking results: parsing output: 60/ for test: kms_psr2_sf results: parsing output: 61/ for test: prime_mmap_coherency results: parsing output: 62/ for test: gem_exec_balancer results: parsing output: 63/ for test: kms_feature_discovery results: parsing output: 64/ for test: kms_addfb_basic results: parsing output: 65/ for test: kms_frontbuffer_tracking results: parsing output: 66/ for test: kms_cursor_legacy results: parsing output: 67/ for test: gem_mmap_gtt results: parsing output: 68/ for test: kms_frontbuffer_tracking results: parsing output: 69/ for test: syncobj_wait results: parsing output: 70/ for test: gem_ringfill results: parsing output: 71/ for test: gem_linear_blits results: parsing output: 72/ for test: kms_cursor_crc results: parsing output: 73/ for test: kms_plane results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: kms_cursor_legacy results: parsing output: 76/ for test: kms_frontbuffer_tracking results: parsing output: 77/ for test: syncobj_timeline results: parsing output: 78/ for test: kms_psr results: parsing output: 79/ for test: gem_exec_fence results: parsing output: 80/ for test: gen9_exec_parse results: parsing output: 81/ for test: kms_frontbuffer_tracking results: parsing output: 82/ for test: kms_psr results: parsing output: 83/ for test: kms_cursor_crc results: parsing output: 84/ for test: gem_caching results: parsing output: 85/ for test: gem_create results: parsing output: 86/ for test: kms_psr results: parsing output: 87/ for test: gem_exec_gttfill results: parsing output: 88/ for test: gem_workarounds results: parsing output: 89/ for test: kms_flip results: parsing output: 90/ for test: gem_render_copy_redux results: parsing output: 91/ for test: i915_query results: parsing output: 92/ for test: kms_big_fb results: parsing output: 93/ for test: kms_frontbuffer_tracking results: parsing output: 94/ for test: syncobj_timeline results: parsing output: 95/ for test: kms_content_protection results: parsing output: 96/ for test: kms_psr2_sf results: parsing output: 97/ for test: kms_frontbuffer_tracking results: parsing output: 98/ for test: gem_mmap_gtt results: parsing output: 99/ for test: i915_drm_fdinfo results: parsing output: 100/ for test: kms_plane results: parsing output: 101/ for test: kms_chamelium_frames results: parsing output: 102/ for test: drm_read results: parsing output: 103/ for test: kms_vblank results: parsing output: 104/ for test: kms_ccs results: parsing output: 105/ for test: kms_atomic_transition results: parsing output: 106/ for test: perf results: parsing output: 107/ for test: kms_cursor_legacy results: parsing output: 108/ for test: kms_big_fb results: parsing output: 109/ for test: kms_plane_scaling results: parsing output: 110/ for test: kms_dirtyfb results: parsing output: 111/ for test: gem_userptr_blits results: parsing output: 112/ for test: prime_mmap results: parsing output: 113/ for test: kms_multipipe_modeset results: parsing output: 114/ for test: gem_exec_reloc results: parsing output: 115/ for test: kms_vrr results: parsing output: 116/ for test: kms_rotation_crc results: parsing output: 117/ for test: gem_exec_schedule results: parsing output: 118/ for test: kms_big_fb results: parsing output: 119/ for test: gem_ctx_isolation results: parsing output: 120/ for test: gem_basic results: parsing output: 121/ for test: perf_pmu results: parsing output: 122/ for test: kms_big_fb results: parsing output: 123/ for test: gem_exec_params results: parsing output: 124/ for test: gem_ppgtt results: parsing output: 125/ for test: syncobj_timeline results: parsing output: 126/ for test: kms_joiner results: parsing output: 127/ for test: drm_read results: parsing output: 128/ for test: kms_busy results: parsing output: 129/ for test: api_intel_bb results: parsing output: 130/ for test: syncobj_timeline Done.