[114.045330] Initializing watchdogs [114.045429] /dev/watchdog0 [114.065233] [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) [114.073505] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [114.077227] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [114.080863] [001/133] (960s left) gen9_exec_parse (cmd-crossing-page) [114.178204] Subtest cmd-crossing-page: SKIP (0.000s) [114.237917] [002/133] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc) [114.736489] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc [116.732563] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (1.997s) [117.342653] [003/133] (957s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle) [117.840350] Starting subtest: short-busy-flip-before-cursor-toggle [117.841934] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s) [118.422416] [004/133] (956s left) gem_exec_params (no-vebox) [118.477451] Starting subtest: no-vebox [118.478200] Subtest no-vebox: SUCCESS (0.000s) [118.602284] [005/133] (956s left) kms_plane_multiple (2x-tiling-4) [119.098595] Starting subtest: 2x-tiling-4 [119.100015] Subtest 2x-tiling-4: SKIP (0.000s) [119.700563] [006/133] (955s left) gem_exec_fence (invalid-fence-array) [119.933737] Starting subtest: invalid-fence-array [119.935636] Subtest invalid-fence-array: SUCCESS (0.003s) [120.304878] [FACT gem_exec_fence (invalid-fence-array)] new: kernel.kmod_is_loaded.vgem: true [120.307356] [007/133] (954s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180) [120.815933] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180 [120.817411] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s) [121.403163] [008/133] (953s left) kms_flip (flip-vs-fences-interruptible) [121.903696] Starting subtest: flip-vs-fences-interruptible [121.904566] Starting dynamic subtest: A-VGA1 [129.683566] Dynamic subtest A-VGA1: SUCCESS (7.779s) [129.692908] Starting dynamic subtest: B-VGA1 [137.393663] Dynamic subtest B-VGA1: SUCCESS (7.709s) [137.406208] Starting dynamic subtest: A-HDMI-A1 [145.134455] Dynamic subtest A-HDMI-A1: SUCCESS (7.739s) [145.144900] Starting dynamic subtest: B-HDMI-A1 [152.917847] Dynamic subtest B-HDMI-A1: SUCCESS (7.782s) [152.918609] Subtest flip-vs-fences-interruptible: SUCCESS (31.016s) [153.688099] [009/133] (921s left) syncobj_timeline (single-wait-all-available-signaled) [153.749805] Starting subtest: single-wait-all-available-signaled [153.750666] Subtest single-wait-all-available-signaled: SUCCESS (0.001s) [153.868804] [010/133] (921s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt) [154.365056] Starting subtest: psr-rgb101010-draw-mmap-gtt [154.366450] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s) [154.966433] [011/133] (920s left) gem_exec_create (basic) [155.028436] Starting subtest: basic [155.029316] Starting dynamic subtest: smem [157.076378] Dynamic subtest smem: SUCCESS (2.047s) [157.077521] Subtest basic: SUCCESS (2.048s) [157.313660] [012/133] (917s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier) [157.807060] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier [157.846340] Starting dynamic subtest: pipe-A-plane-0 [157.848259] Dynamic subtest pipe-A-plane-0: SKIP (0.000s) [157.858789] Starting dynamic subtest: pipe-A-plane-1 [157.860033] Dynamic subtest pipe-A-plane-1: SKIP (0.000s) [157.869301] Starting dynamic subtest: pipe-A-plane-2 [157.870884] Dynamic subtest pipe-A-plane-2: SKIP (0.000s) [158.066811] Starting dynamic subtest: pipe-B-plane-0 [158.068229] Dynamic subtest pipe-B-plane-0: SKIP (0.000s) [158.077651] Starting dynamic subtest: pipe-B-plane-1 [158.079404] Dynamic subtest pipe-B-plane-1: SKIP (0.000s) [158.088465] Starting dynamic subtest: pipe-B-plane-2 [158.089866] Dynamic subtest pipe-B-plane-2: SKIP (0.000s) [158.157223] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SKIP (0.349s) [158.847479] [013/133] (916s left) kms_invalid_mode (overflow-vrefresh) [159.337236] Starting subtest: overflow-vrefresh [159.338437] Starting dynamic subtest: pipe-A-HDMI-A-1 [159.416287] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.079s) [159.425809] Starting dynamic subtest: pipe-B-HDMI-A-1 [159.426561] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s) [159.427299] Subtest overflow-vrefresh: SUCCESS (0.081s) [159.890826] [014/133] (915s left) gem_spin_batch (spin-all-new) [159.960381] Starting subtest: spin-all-new [159.963552] Subtest spin-all-new: SUCCESS (0.003s) [160.187895] [015/133] (915s left) kms_pm_rpm (modeset-pc8-residency-stress) [171.969431] Subtest modeset-pc8-residency-stress: SKIP (0.000s) [172.258674] [016/133] (903s left) gem_userptr_blits (access-control) [172.341171] Starting subtest: access-control [172.343493] Subtest access-control: SKIP (0.000s) [172.483297] [017/133] (902s left) api_intel_bb (object-noreloc-keep-cache-simple) [172.533396] Starting subtest: object-noreloc-keep-cache-simple [172.535138] Subtest object-noreloc-keep-cache-simple: SKIP (0.000s) [172.679817] [018/133] (902s left) syncobj_timeline (invalid-single-wait-unsubmitted) [172.732395] Starting subtest: invalid-single-wait-unsubmitted [172.733183] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s) [172.862054] [019/133] (902s left) core_getversion (all-cards) [172.909927] Starting subtest: all-cards [172.930641] Subtest all-cards: SUCCESS (0.022s) [172.996837] [020/133] (902s left) gem_eio (in-flight-contexts-10ms) [173.060254] Starting subtest: in-flight-contexts-10ms [176.955805] Subtest in-flight-contexts-10ms: SUCCESS (3.897s) [177.991408] [021/133] (897s left) gem_exec_reloc (basic-wc-cpu-active) [178.054562] Starting subtest: basic-wc-cpu-active [178.164599] Subtest basic-wc-cpu-active: SUCCESS (0.109s) [179.218944] [022/133] (896s left) i915_suspend (forcewake) [179.277021] Starting subtest: forcewake [212.983298] Subtest forcewake: SUCCESS (1.302s) [221.118496] [023/133] (862s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render) [221.640855] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render [221.642082] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [222.246614] [024/133] (861s left) gem_flink_basic (bad-flink) [222.302073] Starting subtest: bad-flink [222.302842] Subtest bad-flink: SUCCESS (0.000s) [222.417733] [025/133] (861s left) gem_ctx_shared (q-smoketest-all) [222.475362] Subtest Q-smoketest-all: SKIP (0.000s) [222.601245] [026/133] (861s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt) [223.103435] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt [223.104888] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [223.730809] [027/133] (860s left) gem_exec_schedule (noreorder-corked) [223.798505] Subtest noreorder-corked: SKIP (0.000s) [224.016821] [028/133] (859s left) gen9_exec_parse (valid-registers) [224.070908] Subtest valid-registers: SKIP (0.000s) [224.131533] [029/133] (859s left) kms_flip (2x-plain-flip) [224.633646] Starting subtest: 2x-plain-flip [224.634373] Starting dynamic subtest: AB-VGA1-HDMI-A1 [226.983889] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (2.326s) [226.986463] Subtest 2x-plain-flip: SUCCESS (2.330s) [227.811690] [030/133] (856s left) gem_lmem_swapping (heavy-verify-multi-ccs) [227.875222] Subtest heavy-verify-multi-ccs: SKIP (0.000s) [227.941743] [031/133] (856s left) kms_color (legacy-gamma-reset) [228.433286] Starting subtest: legacy-gamma-reset [228.434669] Starting dynamic subtest: pipe-A-HDMI-A-1 [228.583478] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.151s) [228.596352] Starting dynamic subtest: pipe-B-HDMI-A-1 [228.597097] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.005s) [228.597899] Subtest legacy-gamma-reset: SUCCESS (0.158s) [229.314041] [032/133] (854s left) gem_mmap_gtt (cpuset-big-copy-xy) [229.375087] Starting subtest: cpuset-big-copy-XY [233.043270] Subtest cpuset-big-copy-XY: SUCCESS (3.651s) [233.297353] [033/133] (850s left) kms_addfb_basic (bad-pitch-1024) [233.462143] Starting subtest: bad-pitch-1024 [233.463597] Subtest bad-pitch-1024: SUCCESS (0.000s) [234.512237] [034/133] (849s left) gem_pxp (display-protected-crc) [237.089081] Starting subtest: display-protected-crc [237.090995] Subtest display-protected-crc: SKIP (0.000s) [237.212153] [035/133] (847s left) kms_getfb (getfb2-handle-zero) [237.705775] Starting subtest: getfb2-handle-zero [237.706568] Subtest getfb2-handle-zero: SUCCESS (0.000s) [238.324310] [036/133] (846s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant) [238.816085] Starting subtest: coverage-vs-premult-vs-constant [238.986394] Subtest coverage-vs-premult-vs-constant: SKIP (0.171s) [239.790717] [037/133] (844s left) kms_addfb_basic (framebuffer-vs-set-tiling) [239.852999] Starting subtest: framebuffer-vs-set-tiling [239.853800] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [240.893933] [038/133] (843s left) kms_big_fb (x-tiled-addfb-size-overflow) [241.389994] Starting subtest: x-tiled-addfb-size-overflow [241.392149] Subtest x-tiled-addfb-size-overflow: SKIP (0.000s) [241.993480] [039/133] (842s left) gem_exec_flush (basic-uc-pro-default) [242.061076] Starting subtest: basic-uc-pro-default [247.514491] Subtest basic-uc-pro-default: SUCCESS (5.447s) [247.753831] [040/133] (836s left) gem_userptr_blits (coherency-unsync) [247.814743] Subtest coherency-unsync: SKIP (0.000s) [247.969025] [041/133] (836s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt) [248.463505] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt [248.464991] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [249.064753] [042/133] (835s left) kms_big_fb (y-tiled-64bpp-rotate-180) [249.567430] Starting subtest: y-tiled-64bpp-rotate-180 [249.569188] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s) [250.167250] [043/133] (834s left) gem_render_copy (x-tiled-to-vebox-yf-tiled) [250.234513] Starting subtest: x-tiled-to-vebox-yf-tiled [250.236257] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s) [250.470063] [044/133] (834s left) api_intel_bb (blit-noreloc-purge-cache) [250.525890] Starting subtest: blit-noreloc-purge-cache [250.527284] Subtest blit-noreloc-purge-cache: SKIP (0.000s) [250.666064] [045/133] (834s left) gem_exec_schedule (u-lateslice) [250.740138] Subtest u-lateslice: SKIP (0.000s) [250.984636] [046/133] (833s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs) [251.041528] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.000s) [251.108970] [047/133] (833s left) kms_rotation_crc (primary-4-tiled-reflect-x-180) [251.597700] Starting subtest: primary-4-tiled-reflect-x-180 [251.599056] Subtest primary-4-tiled-reflect-x-180: SKIP (0.001s) [252.198224] [048/133] (832s left) gem_eio (in-flight-1us) [252.266612] Starting subtest: in-flight-1us [253.668317] Subtest in-flight-1us: SUCCESS (1.403s) [254.712985] [049/133] (830s left) kms_cursor_crc (cursor-offscreen-512x170) [255.218224] Starting subtest: cursor-offscreen-512x170 [255.219626] Subtest cursor-offscreen-512x170: SKIP (0.001s) [255.822719] [050/133] (829s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render) [256.315634] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render [256.317063] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [256.917730] [051/133] (828s left) gem_exec_params (invalid-bsd2-flag-on-vebox) [256.981306] Starting subtest: invalid-bsd2-flag-on-vebox [256.982856] Subtest invalid-bsd2-flag-on-vebox: SKIP (0.000s) [257.123102] [052/133] (828s left) kms_chamelium_frames (dp-crc-fast) [257.683486] Subtest dp-crc-fast: SKIP (0.000s) [258.093022] [053/133] (827s left) kms_psr (fbc-pr-dpms) [258.581398] Subtest fbc-pr-dpms: SKIP (0.000s) [258.887980] [054/133] (826s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs) [258.945932] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.000s) [259.003034] [055/133] (826s left) gem_mmap_gtt (coherency) [259.058815] Starting subtest: coherency [259.115723] Subtest coherency: SUCCESS (0.058s) [259.258903] [056/133] (826s left) gem_userptr_blits (create-destroy-unsync) [259.315692] Subtest create-destroy-unsync: SKIP (0.000s) [259.485816] [057/133] (826s left) kms_psr (psr2-sprite-plane-onoff) [259.972143] Subtest psr2-sprite-plane-onoff: SKIP (0.000s) [260.267917] [058/133] (825s left) i915_pm_freq_api (freq-suspend) [260.325719] Subtest freq-suspend: SKIP (0.000s) [260.388729] [059/133] (825s left) gem_mmap_offset (clear-via-pagefault) [260.444102] Starting subtest: clear-via-pagefault [260.444770] Starting dynamic subtest: smem0 [285.484292] Dynamic subtest smem0: SUCCESS (25.032s) [285.485064] Subtest clear-via-pagefault: SUCCESS (25.034s) [285.620265] [060/133] (800s left) kms_async_flips (alternate-sync-async-flip-atomic) [286.111308] Starting subtest: alternate-sync-async-flip-atomic [286.259323] Starting dynamic subtest: pipe-A-HDMI-A-1 [288.414452] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.153s) [288.577306] Starting dynamic subtest: pipe-B-HDMI-A-1 [290.680404] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.113s) [290.681506] Subtest alternate-sync-async-flip-atomic: SUCCESS (4.569s) [291.546670] [061/133] (794s left) kms_flip (2x-flip-vs-suspend) [292.036038] Starting subtest: 2x-flip-vs-suspend [292.038810] Starting dynamic subtest: AB-VGA1-HDMI-A1 [496.812555] Per-test timeout exceeded. Killing the current test with SIGQUIT. [503.804925] Closing watchdogs [503.810377] Initializing watchdogs [503.810447] /dev/watchdog0 [503.834666] [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) [503.846694] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [503.848516] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [503.849290] [FACT before any test] new: kernel.kmod_is_loaded.vgem: true [503.852838] [062/133] (587s left) kms_tiled_display (basic-test-pattern) [504.617204] Subtest basic-test-pattern: SKIP (0.000s) [504.933679] [063/133] (586s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling) [504.993684] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s) [505.048050] [064/133] (586s left) kms_cursor_legacy (flip-vs-cursor-varying-size) [505.542033] Starting subtest: flip-vs-cursor-varying-size [519.764459] Subtest flip-vs-cursor-varying-size: SUCCESS (14.136s) [520.479336] [065/133] (571s left) kms_psr (pr-primary-page-flip) [520.987174] Subtest pr-primary-page-flip: SKIP (0.000s) [521.291588] [066/133] (570s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area) [521.779496] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s) [522.082354] [067/133] (570s left) kms_pm_rpm (legacy-planes) [533.870409] Subtest legacy-planes: SKIP (0.000s) [534.165146] [068/133] (557s left) kms_flip (basic-flip-vs-modeset) [534.662241] Starting subtest: basic-flip-vs-modeset [534.664510] Starting dynamic subtest: A-VGA1 [535.485329] Dynamic subtest A-VGA1: SUCCESS (0.821s) [535.503069] Starting dynamic subtest: B-VGA1 [536.226356] Dynamic subtest B-VGA1: SUCCESS (0.737s) [536.243516] Starting dynamic subtest: A-HDMI-A1 [537.067893] Dynamic subtest A-HDMI-A1: SUCCESS (0.839s) [537.082457] Starting dynamic subtest: B-HDMI-A1 [537.903056] Dynamic subtest B-HDMI-A1: SUCCESS (0.833s) [537.905768] Subtest basic-flip-vs-modeset: SUCCESS (3.241s) [538.633406] [069/133] (553s left) gem_exec_store (basic) [538.717889] Starting subtest: basic [538.778776] Subtest basic: SUCCESS (0.061s) [539.012397] [070/133] (553s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render) [539.496545] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render [539.497940] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [540.106573] [071/133] (552s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [540.597991] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [540.599292] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [541.211513] [072/133] (551s left) kms_frontbuffer_tracking (fbcpsr-tiling-4) [541.699615] Starting subtest: fbcpsr-tiling-4 [541.701018] Subtest fbcpsr-tiling-4: SKIP (0.000s) [542.309811] [073/133] (550s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions) [542.800913] Starting subtest: short-flip-before-cursor-atomic-transitions [543.809183] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (1.004s) [544.521359] [074/133] (547s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move) [545.011185] Starting subtest: fbc-2p-primscrn-cur-indfb-move [545.012547] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s) [545.622906] [075/133] (546s left) gem_exec_capture (capture-invisible) [545.685759] Subtest capture-invisible: SKIP (0.000s) [545.762528] [076/133] (546s left) kms_cursor_edge_walk (128x128-right-edge) [546.244450] Starting subtest: 128x128-right-edge [546.246891] Starting dynamic subtest: pipe-A-HDMI-A-1 [549.656563] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.409s) [549.671956] Starting dynamic subtest: pipe-B-HDMI-A-1 [552.987369] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.327s) [552.988148] Subtest 128x128-right-edge: SUCCESS (6.741s) [553.699651] [077/133] (538s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs) [553.757286] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.000s) [553.829873] [078/133] (538s left) vgem_basic (mmap) [553.901301] Starting subtest: mmap [553.914531] Subtest mmap: SUCCESS (0.015s) [554.037424] [079/133] (538s left) gem_render_copy (y-tiled-to-vebox-yf-tiled) [554.101824] Starting subtest: y-tiled-to-vebox-yf-tiled [554.103727] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s) [554.331538] [080/133] (538s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt) [554.813795] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt [556.661802] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SUCCESS (1.845s) [557.291638] [081/133] (535s left) prime_busy (after) [557.354238] Starting subtest: after [557.359878] Starting dynamic subtest: rcs0 [557.374824] Dynamic subtest rcs0: SUCCESS (0.015s) [557.393730] Starting dynamic subtest: bcs0 [557.399760] Dynamic subtest bcs0: SUCCESS (0.023s) [557.417952] Starting dynamic subtest: vcs0 [557.420416] Dynamic subtest vcs0: SUCCESS (0.018s) [557.527913] Subtest after: SUCCESS (0.174s) [557.660464] [082/133] (535s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt) [558.146189] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt [558.147522] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s) [558.762787] [083/133] (534s left) gem_softpin (noreloc-s3) [558.830320] Starting subtest: noreloc-S3 [614.088470] Subtest noreloc-S3: SUCCESS (5.393s) [622.281330] [084/133] (478s left) syncobj_timeline (wait-all-snapshot) [622.356563] Starting subtest: wait-all-snapshot [622.439154] Subtest wait-all-snapshot: SUCCESS (0.082s) [622.578003] [085/133] (478s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa [622.663186] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled [622.773282] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.108s) [622.912804] [086/133] (478s left) gem_close_race (multigpu-basic-process) [622.985586] Starting subtest: multigpu-basic-process [622.987334] Subtest multigpu-basic-process: SKIP (0.000s) [623.282982] [087/133] (477s left) gem_render_copy (y-tiled-ccs-to-x-tiled) [623.344473] Starting subtest: y-tiled-ccs-to-x-tiled [623.345205] Starting dynamic subtest: smem [623.346678] Dynamic subtest smem: SKIP (0.000s) [623.348358] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.002s) [623.589851] [088/133] (477s left) kms_legacy_colorkey (invalid-plane) [624.079078] Starting subtest: invalid-plane [624.079917] Starting dynamic subtest: zero-id [624.080773] Dynamic subtest zero-id: SUCCESS (0.000s) [624.097730] Starting dynamic subtest: outrange-id [624.098509] Dynamic subtest outrange-id: SUCCESS (0.000s) [624.099292] Subtest invalid-plane: SUCCESS (0.004s) [624.694246] [089/133] (476s left) fbdev (pan) [624.754038] Starting subtest: pan [624.789794] Subtest pan: SUCCESS (0.036s) [624.930541] [090/133] (476s left) gem_ctx_isolation (preservation) [624.998334] Starting subtest: preservation [624.999167] Starting dynamic subtest: rcs0 [625.438898] Dynamic subtest rcs0: SUCCESS (0.435s) [625.439783] Subtest preservation: SUCCESS (0.437s) [625.735078] [091/133] (475s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt) [626.230444] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt [626.231683] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [626.838589] [092/133] (474s left) gem_partial_pwrite_pread (reads-uncached) [626.900901] Starting subtest: reads-uncached [628.046820] Subtest reads-uncached: SUCCESS (1.137s) [628.225393] [093/133] (473s left) kms_properties (invalid-properties-legacy) [628.712594] Starting subtest: invalid-properties-legacy [628.724302] Subtest invalid-properties-legacy: SUCCESS (0.013s) [629.331638] [094/133] (472s left) syncobj_wait (wait-all-for-submit-snapshot) [629.389456] Starting subtest: wait-all-for-submit-snapshot [629.472523] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s) [629.599639] [095/133] (472s left) gem_wait (await) [629.671302] Starting subtest: await [629.672253] Starting dynamic subtest: all-engines [630.704838] Dynamic subtest all-engines: SUCCESS (1.027s) [630.724301] Starting dynamic subtest: rcs0 [631.741790] Dynamic subtest rcs0: SUCCESS (1.028s) [631.762133] Starting dynamic subtest: bcs0 [632.769524] Dynamic subtest bcs0: SUCCESS (1.019s) [632.785600] Starting dynamic subtest: vcs0 [633.800390] Dynamic subtest vcs0: SUCCESS (1.025s) [633.803988] Subtest await: SUCCESS (4.115s) [634.057648] [096/133] (467s left) kms_addfb_basic (bad-pitch-128) [634.116358] Starting subtest: bad-pitch-128 [634.117099] Subtest bad-pitch-128: SUCCESS (0.000s) [635.168129] [097/133] (466s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted) [635.224908] Starting subtest: invalid-multi-wait-unsubmitted-submitted [635.225777] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.001s) [635.359400] [098/133] (466s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [635.852449] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [635.854044] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [636.440350] [099/133] (465s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format) [636.928369] Starting subtest: plane-upscale-20x20-with-pixel-format [636.929225] Starting dynamic subtest: pipe-A [636.931335] Dynamic subtest pipe-A: SKIP (0.001s) [636.947046] Starting dynamic subtest: pipe-B [636.948981] Dynamic subtest pipe-B: SKIP (0.001s) [636.950139] Subtest plane-upscale-20x20-with-pixel-format: SKIP (0.006s) [637.524369] [100/133] (464s left) gem_exec_balancer (bonded-semaphore) [637.587189] Subtest bonded-semaphore: SKIP (0.000s) [637.710680] [101/133] (464s left) kms_vblank (ts-continuation-modeset-hang) [638.192865] Starting subtest: ts-continuation-modeset-hang [638.193784] Starting dynamic subtest: pipe-A-HDMI-A-1 [644.780641] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.577s) [644.800792] Starting dynamic subtest: pipe-B-HDMI-A-1 [650.784464] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (5.996s) [650.786901] Subtest ts-continuation-modeset-hang: SUCCESS (12.579s) [651.505235] [102/133] (450s left) kms_atomic (plane-cursor-legacy) [651.995715] Starting subtest: plane-cursor-legacy [651.997833] Starting dynamic subtest: pipe-A-HDMI-A-1 [652.185565] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.187s) [652.186678] Subtest plane-cursor-legacy: SUCCESS (0.190s) [652.923273] [103/133] (449s left) kms_chamelium_audio (hdmi-audio) [653.480047] Subtest hdmi-audio: SKIP (0.000s) [653.887828] [104/133] (448s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [654.379611] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip [654.381118] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s) [654.993251] [105/133] (447s left) kms_draw_crc (draw-method-render) [655.478783] Starting subtest: draw-method-render [655.479627] Starting dynamic subtest: xrgb8888-untiled [655.769544] Dynamic subtest xrgb8888-untiled: SUCCESS (0.290s) [655.787944] Starting dynamic subtest: rgb565-untiled [656.052638] Dynamic subtest rgb565-untiled: SUCCESS (0.281s) [656.069201] Starting dynamic subtest: xrgb2101010-untiled [656.368481] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.313s) [656.384675] Starting dynamic subtest: xbgr16161616f-untiled [656.701100] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.330s) [656.717349] Starting dynamic subtest: xrgb8888-xtiled [656.866864] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.163s) [656.883246] Starting dynamic subtest: rgb565-xtiled [657.017016] Dynamic subtest rgb565-xtiled: SUCCESS (0.147s) [657.033825] Starting dynamic subtest: xrgb2101010-xtiled [657.184200] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.164s) [657.204816] Starting dynamic subtest: xbgr16161616f-xtiled [657.366215] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.180s) [657.369234] Subtest draw-method-render: SUCCESS (1.890s) [657.988675] [106/133] (444s left) gem_workarounds (suspend-resume) [658.060131] Starting subtest: suspend-resume [674.991309] Subtest suspend-resume: SUCCESS (0.491s) [683.116538] [107/133] (427s left) perf (global-sseu-config) [683.336219] Subtest global-sseu-config: SKIP (0.000s) [683.402324] [108/133] (426s left) perf (short-reads) [683.533913] Subtest short-reads: SKIP (0.000s) [683.603000] [109/133] (426s left) kms_psr (fbc-psr2-primary-mmap-gtt) [684.088820] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.000s) [684.393594] [110/133] (426s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc) [684.890691] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc [684.892352] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [685.505680] [111/133] (425s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu) [685.999601] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu [686.003055] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [686.598846] [112/133] (424s left) kms_psr (fbc-psr-sprite-mmap-cpu) [687.087962] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.000s) [687.414782] [113/133] (423s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-modifiers) [687.902847] Starting subtest: plane-scaler-with-clipping-clamping-modifiers [687.903586] Starting dynamic subtest: pipe-A [687.905695] Dynamic subtest pipe-A: SKIP (0.001s) [687.921708] Starting dynamic subtest: pipe-B [687.923853] Dynamic subtest pipe-B: SKIP (0.001s) [687.925051] Subtest plane-scaler-with-clipping-clamping-modifiers: SKIP (0.005s) [688.524404] [114/133] (422s left) kms_ccs (crc-primary-basic-yf-tiled-ccs) [688.596386] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.000s) [688.656310] [115/133] (422s left) gem_eio (execbuf) [688.714270] Starting subtest: execbuf [688.742280] Subtest execbuf: SUCCESS (0.027s) [689.796940] [116/133] (421s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90) [690.285621] Starting subtest: primary-yf-tiled-reflect-x-90 [690.287190] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s) [690.907638] [117/133] (420s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [691.407741] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu [691.408956] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [692.006956] [118/133] (418s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt) [692.492994] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt [692.494626] Subtest psr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [693.110277] [119/133] (417s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-cpu) [693.599836] Starting subtest: fbcpsr-rgb101010-draw-mmap-cpu [693.601201] Subtest fbcpsr-rgb101010-draw-mmap-cpu: SKIP (0.000s) [694.213103] [120/133] (416s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc) [694.704706] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc [696.163300] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (1.454s) [696.799635] [121/133] (414s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf) [697.294065] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s) [697.594484] [122/133] (413s left) sw_sync (alloc_fence_invalid_timeline) [697.652486] Starting subtest: alloc_fence_invalid_timeline [697.653255] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s) [697.766524] [123/133] (413s left) kms_cursor_crc (cursor-rapid-movement-512x512) [698.268006] Starting subtest: cursor-rapid-movement-512x512 [698.269281] Subtest cursor-rapid-movement-512x512: SKIP (0.001s) [698.884178] [124/133] (412s left) prime_mmap (test_forked_cpu_write) [698.941423] Starting subtest: test_forked_cpu_write [698.942527] Starting dynamic subtest: test_forked_cpu_write-smem [698.956478] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.014s) [698.959080] Subtest test_forked_cpu_write: SUCCESS (0.017s) [699.095330] [125/133] (412s left) kms_content_protection (dp-mst-type-1-suspend-resume) [699.597374] Starting subtest: dp-mst-type-1-suspend-resume [699.598869] Subtest dp-mst-type-1-suspend-resume: SKIP (0.000s) [700.200611] [126/133] (411s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu) [700.689725] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu [700.691052] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [701.317566] [127/133] (410s left) kms_big_fb (x-tiled-16bpp-rotate-90) [701.816472] Starting subtest: x-tiled-16bpp-rotate-90 [701.829830] Subtest x-tiled-16bpp-rotate-90: SKIP (0.012s) [702.449227] [128/133] (409s left) kms_chamelium_hpd (hdmi-hpd-after-suspend) [703.012984] Subtest hdmi-hpd-after-suspend: SKIP (0.000s) [703.429761] [129/133] (408s left) i915_pm_rpm (gem-mmap-type) [715.217726] Subtest gem-mmap-type: SKIP (0.000s) [715.523778] [130/133] (396s left) gem_exec_parallel (userptr) [715.594620] Starting subtest: userptr [715.595373] Starting dynamic subtest: rcs0 [717.265293] Dynamic subtest rcs0: SUCCESS (1.667s) [717.283476] Starting dynamic subtest: bcs0 [718.976953] Dynamic subtest bcs0: SUCCESS (1.711s) [718.980704] Subtest userptr: SUCCESS (3.385s) [719.223568] [131/133] (392s left) perf_pmu (module-unload) [719.286349] Starting subtest: module-unload [726.159444] Subtest module-unload: FAIL (6.852s) [726.192610] [FACT perf_pmu (module-unload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [726.194003] [FACT perf_pmu (module-unload)] deleted: kernel.kmod_is_loaded.i915: true [726.196526] [132/133] (385s left) gem_ctx_persistence (saturated-hostile) [728.338106] Subtest saturated-hostile: SKIP (0.000s) [728.403834] [FACT gem_ctx_persistence (saturated-hostile)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [728.405556] [FACT gem_ctx_persistence (saturated-hostile)] new: kernel.kmod_is_loaded.i915: true [728.410963] [133/133] (383s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt) [728.902301] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt [728.903760] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [729.508811] Closing watchdogs results: parsing output: 0/ for test: gen9_exec_parse results: parsing output: 1/ for test: kms_frontbuffer_tracking results: parsing output: 2/ for test: kms_cursor_legacy results: parsing output: 3/ for test: gem_exec_params results: parsing output: 4/ for test: kms_plane_multiple results: parsing output: 5/ for test: gem_exec_fence results: parsing output: 6/ for test: kms_big_fb results: parsing output: 7/ for test: kms_flip results: parsing output: 8/ for test: syncobj_timeline results: parsing output: 9/ for test: kms_frontbuffer_tracking results: parsing output: 10/ for test: gem_exec_create results: parsing output: 11/ for test: kms_plane results: parsing output: 12/ for test: kms_invalid_mode results: parsing output: 13/ for test: gem_spin_batch results: parsing output: 14/ for test: kms_pm_rpm results: parsing output: 15/ for test: gem_userptr_blits results: parsing output: 16/ for test: api_intel_bb results: parsing output: 17/ for test: syncobj_timeline results: parsing output: 18/ for test: core_getversion results: parsing output: 19/ for test: gem_eio results: parsing output: 20/ for test: gem_exec_reloc results: parsing output: 21/ for test: i915_suspend results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: gem_flink_basic results: parsing output: 24/ for test: gem_ctx_shared results: parsing output: 25/ for test: kms_frontbuffer_tracking results: parsing output: 26/ for test: gem_exec_schedule results: parsing output: 27/ for test: gen9_exec_parse results: parsing output: 28/ for test: kms_flip results: parsing output: 29/ for test: gem_lmem_swapping results: parsing output: 30/ for test: kms_color results: parsing output: 31/ for test: gem_mmap_gtt results: parsing output: 32/ for test: kms_addfb_basic results: parsing output: 33/ for test: gem_pxp results: parsing output: 34/ for test: kms_getfb results: parsing output: 35/ for test: kms_plane_alpha_blend results: parsing output: 36/ for test: kms_addfb_basic results: parsing output: 37/ for test: kms_big_fb results: parsing output: 38/ for test: gem_exec_flush results: parsing output: 39/ for test: gem_userptr_blits results: parsing output: 40/ for test: kms_frontbuffer_tracking results: parsing output: 41/ for test: kms_big_fb results: parsing output: 42/ for test: gem_render_copy results: parsing output: 43/ for test: api_intel_bb results: parsing output: 44/ for test: gem_exec_schedule results: parsing output: 45/ for test: kms_ccs results: parsing output: 46/ for test: kms_rotation_crc results: parsing output: 47/ for test: gem_eio results: parsing output: 48/ for test: kms_cursor_crc results: parsing output: 49/ for test: kms_frontbuffer_tracking results: parsing output: 50/ for test: gem_exec_params results: parsing output: 51/ for test: kms_chamelium_frames results: parsing output: 52/ for test: kms_psr results: parsing output: 53/ for test: kms_ccs results: parsing output: 54/ for test: gem_mmap_gtt results: parsing output: 55/ for test: gem_userptr_blits results: parsing output: 56/ for test: kms_psr results: parsing output: 57/ for test: i915_pm_freq_api results: parsing output: 58/ for test: gem_mmap_offset results: parsing output: 59/ for test: kms_async_flips results: parsing output: 60/ for test: kms_flip results: parsing output: 61/ for test: kms_tiled_display results: parsing output: 62/ for test: kms_flip_scaled_crc results: parsing output: 63/ for test: kms_cursor_legacy results: parsing output: 64/ for test: kms_psr results: parsing output: 65/ for test: kms_psr2_sf results: parsing output: 66/ for test: kms_pm_rpm results: parsing output: 67/ for test: kms_flip results: parsing output: 68/ for test: gem_exec_store results: parsing output: 69/ for test: kms_frontbuffer_tracking results: parsing output: 70/ for test: kms_big_fb results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: kms_cursor_legacy results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: gem_exec_capture results: parsing output: 75/ for test: kms_cursor_edge_walk results: parsing output: 76/ for test: kms_ccs results: parsing output: 77/ for test: vgem_basic results: parsing output: 78/ for test: gem_render_copy results: parsing output: 79/ for test: kms_frontbuffer_tracking results: parsing output: 80/ for test: prime_busy results: parsing output: 81/ for test: kms_frontbuffer_tracking results: parsing output: 82/ for test: gem_softpin results: parsing output: 83/ for test: syncobj_timeline results: parsing output: 84/ for test: syncobj_timeline results: parsing output: 85/ for test: gem_close_race results: parsing output: 86/ for test: gem_render_copy results: parsing output: 87/ for test: kms_legacy_colorkey results: parsing output: 88/ for test: fbdev results: parsing output: 89/ for test: gem_ctx_isolation results: parsing output: 90/ for test: kms_frontbuffer_tracking results: parsing output: 91/ for test: gem_partial_pwrite_pread results: parsing output: 92/ for test: kms_properties results: parsing output: 93/ for test: syncobj_wait results: parsing output: 94/ for test: gem_wait results: parsing output: 95/ for test: kms_addfb_basic results: parsing output: 96/ for test: syncobj_timeline results: parsing output: 97/ for test: kms_big_fb results: parsing output: 98/ for test: kms_plane_scaling results: parsing output: 99/ for test: gem_exec_balancer results: parsing output: 100/ for test: kms_vblank results: parsing output: 101/ for test: kms_atomic results: parsing output: 102/ for test: kms_chamelium_audio results: parsing output: 103/ for test: kms_big_fb results: parsing output: 104/ for test: kms_draw_crc results: parsing output: 105/ for test: gem_workarounds results: parsing output: 106/ for test: perf results: parsing output: 107/ for test: perf results: parsing output: 108/ for test: kms_psr results: parsing output: 109/ for test: kms_frontbuffer_tracking results: parsing output: 110/ for test: kms_frontbuffer_tracking results: parsing output: 111/ for test: kms_psr results: parsing output: 112/ for test: kms_plane_scaling results: parsing output: 113/ for test: kms_ccs results: parsing output: 114/ for test: gem_eio results: parsing output: 115/ for test: kms_rotation_crc results: parsing output: 116/ for test: kms_frontbuffer_tracking results: parsing output: 117/ for test: kms_frontbuffer_tracking results: parsing output: 118/ for test: kms_frontbuffer_tracking results: parsing output: 119/ for test: kms_frontbuffer_tracking results: parsing output: 120/ for test: kms_psr2_sf results: parsing output: 121/ for test: sw_sync results: parsing output: 122/ for test: kms_cursor_crc results: parsing output: 123/ for test: prime_mmap results: parsing output: 124/ for test: kms_content_protection results: parsing output: 125/ for test: kms_frontbuffer_tracking results: parsing output: 126/ for test: kms_big_fb results: parsing output: 127/ for test: kms_chamelium_hpd results: parsing output: 128/ for test: i915_pm_rpm results: parsing output: 129/ for test: gem_exec_parallel results: parsing output: 130/ for test: perf_pmu results: parsing output: 131/ for test: gem_ctx_persistence results: parsing output: 132/ for test: kms_frontbuffer_tracking Done.