[71.978553] Initializing watchdogs [71.978761] /dev/watchdog0 [72.017952] [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) [72.025982] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [72.029726] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [72.033952] [001/133] (960s left) kms_invalid_mode (bad-hsync-end) [72.538457] Starting subtest: bad-hsync-end [72.539762] Starting dynamic subtest: pipe-A-VGA-1 [72.663927] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.124s) [72.674100] Starting dynamic subtest: pipe-A-HDMI-A-1 [72.675036] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s) [72.685025] Starting dynamic subtest: pipe-B-VGA-1 [72.685919] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.000s) [72.696553] Starting dynamic subtest: pipe-B-HDMI-A-1 [72.699520] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s) [72.702544] Subtest bad-hsync-end: SUCCESS (0.131s) [72.936473] [002/133] (959s left) gem_mmap_offset (bad-extensions) [72.993039] Starting subtest: bad-extensions [72.993772] Subtest bad-extensions: SUCCESS (0.000s) [73.087045] [003/133] (959s left) gem_exec_schedule (fairslice) [73.160985] Subtest fairslice: SKIP (0.000s) [73.357023] [004/133] (959s left) gen9_exec_parse (bb-chained) [73.414273] Subtest bb-chained: SKIP (0.000s) [73.469074] [005/133] (959s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions) [73.954707] Starting subtest: short-flip-after-cursor-atomic-transitions [75.053614] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (1.100s) [75.308330] [006/133] (957s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs) [75.364151] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SKIP (0.000s) [75.417567] [007/133] (957s left) kms_universal_plane (disable-primary-vs-flip) [75.905084] Starting subtest: disable-primary-vs-flip [75.905930] Starting dynamic subtest: pipe-A-VGA-1 [76.334739] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.430s) [76.344649] Starting dynamic subtest: pipe-B-HDMI-A-1 [76.742369] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.400s) [76.744490] Subtest disable-primary-vs-flip: SUCCESS (0.832s) [76.986809] [008/133] (955s left) gem_mmap (bad-object) [77.043628] Starting subtest: bad-object [77.044259] Subtest bad-object: SUCCESS (0.000s) [77.140286] [009/133] (955s left) kms_chamelium_color (ctm-0-50) [77.626250] Subtest ctm-0-50: SKIP (0.000s) [77.681273] [010/133] (955s left) gem_render_copy_redux (interruptible) [77.741618] Starting subtest: interruptible [78.284582] Subtest interruptible: SUCCESS (0.541s) [78.387854] [011/133] (954s left) kms_psr (psr2-suspend) [78.869446] Subtest psr2-suspend: SKIP (0.000s) [78.926265] [012/133] (954s left) drm_read (short-buffer-wakeup) [79.517970] Starting subtest: short-buffer-wakeup [111.731744] Subtest short-buffer-wakeup: SUCCESS (32.215s) [111.941686] [013/133] (921s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render) [112.432069] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render [112.433047] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [112.541279] [014/133] (920s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs) [112.598446] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.000s) [112.651246] [015/133] (920s left) gem_tiled_wb [122.768222] [016/133] (910s left) kms_plane_scaling (planes-upscale-factor-0-25) [123.256154] Starting subtest: planes-upscale-factor-0-25 [123.257198] Starting dynamic subtest: pipe-A [123.259534] Dynamic subtest pipe-A: SKIP (0.003s) [123.270078] Starting dynamic subtest: pipe-B [123.273663] Dynamic subtest pipe-B: SKIP (0.002s) [123.275402] Subtest planes-upscale-factor-0-25: SKIP (0.005s) [123.353946] [017/133] (909s left) syncobj_wait (invalid-multi-wait-all-unsubmitted) [123.411456] Starting subtest: invalid-multi-wait-all-unsubmitted [123.411955] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s) [123.503702] [018/133] (909s left) gem_vm_create (create-ext) [123.559820] Subtest create-ext: SKIP (0.000s) [123.615191] [019/133] (909s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling) [123.669941] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.000s) [123.728641] [020/133] (909s left) gem_exec_fence (syncobj-timeline-chain-engines) [124.080207] Subtest syncobj-timeline-chain-engines: SKIP (0.000s) [124.310136] [FACT gem_exec_fence (syncobj-timeline-chain-engines)] new: kernel.kmod_is_loaded.vgem: true [124.312117] [021/133] (909s left) kms_big_fb (x-tiled-16bpp-rotate-180) [124.803935] Starting subtest: x-tiled-16bpp-rotate-180 [126.121959] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.317s) [126.372763] [022/133] (907s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-plflip-blt) [126.859764] Starting subtest: fbc-1p-primscrn-indfb-plflip-blt [128.763055] Subtest fbc-1p-primscrn-indfb-plflip-blt: SUCCESS (1.903s) [128.999279] [023/133] (904s left) kms_cursor_crc (cursor-size-change) [129.474297] Starting subtest: cursor-size-change [129.474895] Starting dynamic subtest: pipe-A-VGA-1 [130.174020] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.698s) [130.184634] Starting dynamic subtest: pipe-B-HDMI-A-1 [130.836521] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.661s) [130.838098] Subtest cursor-size-change: SUCCESS (1.363s) [131.105831] [024/133] (902s left) gem_exec_schedule (preempt-queue-contexts) [131.178714] Subtest preempt-queue-contexts: SKIP (0.000s) [131.381607] [025/133] (902s left) gem_exec_whisper (basic-contexts-priority) [131.446816] Starting subtest: basic-contexts-priority [131.448155] Subtest basic-contexts-priority: SKIP (0.001s) [131.666819] [026/133] (901s left) i915_drm_fdinfo (busy-idle) [131.722752] Subtest busy-idle: SKIP (0.000s) [131.778716] [027/133] (901s left) kms_ccs (bad-rotation-90-yf-tiled-ccs) [131.842831] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.000s) [131.899847] [028/133] (901s left) kms_chamelium_hpd (hdmi-hpd) [132.489845] Subtest hdmi-hpd: SKIP (0.000s) [132.699213] [029/133] (901s left) kms_psr (psr-primary-mmap-cpu) [133.182600] Subtest psr-primary-mmap-cpu: SKIP (0.000s) [133.249659] [030/133] (900s left) syncobj_timeline (wait-all-interrupted) [133.307841] Starting subtest: wait-all-interrupted [133.414749] Subtest wait-all-interrupted: SUCCESS (0.106s) [133.502996] [031/133] (900s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt) [133.992234] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt [133.993385] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s) [134.103828] [032/133] (899s left) kms_cursor_legacy (cursorb-vs-flipb-toggle) [134.585447] Starting subtest: cursorB-vs-flipB-toggle [145.531187] Subtest cursorB-vs-flipB-toggle: SUCCESS (10.946s) [145.790175] [033/133] (888s left) fbdev (read) [145.863186] Starting subtest: read [146.244260] Subtest read: SUCCESS (0.381s) [146.322562] [034/133] (887s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt) [146.806879] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt [146.808122] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [146.923099] [035/133] (887s left) prime_busy (before) [146.983389] Starting subtest: before [146.990031] Starting dynamic subtest: rcs0 [147.005570] Dynamic subtest rcs0: SUCCESS (0.015s) [147.017552] Starting dynamic subtest: bcs0 [147.022706] Dynamic subtest bcs0: SUCCESS (0.016s) [147.034767] Starting dynamic subtest: vcs0 [147.038596] Dynamic subtest vcs0: SUCCESS (0.015s) [147.146100] Subtest before: SUCCESS (0.163s) [147.239633] [036/133] (886s left) kms_flip (2x-modeset-vs-vblank-race-interruptible) [147.727943] Starting subtest: 2x-modeset-vs-vblank-race-interruptible [147.729302] Starting dynamic subtest: AB-VGA1-HDMI-A1 [158.619632] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (10.890s) [158.625135] Subtest 2x-modeset-vs-vblank-race-interruptible: SUCCESS (10.894s) [158.872106] [037/133] (875s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled) [158.948976] Starting subtest: multi-wait-for-submit-submitted-signaled [158.949748] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s) [159.038538] [038/133] (875s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs) [159.100868] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SKIP (0.000s) [159.165549] [039/133] (875s left) kms_addfb_basic (invalid-set-prop-any) [159.223505] Starting subtest: invalid-set-prop-any [159.224076] Subtest invalid-set-prop-any: SUCCESS (0.000s) [159.757466] [040/133] (874s left) kms_flip (2x-flip-vs-suspend-interruptible) [160.241942] Starting subtest: 2x-flip-vs-suspend-interruptible [160.243660] Starting dynamic subtest: AB-VGA1-HDMI-A1 [235.155508] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (10.766s) [235.159698] Subtest 2x-flip-vs-suspend-interruptible: SUCCESS (10.983s) [242.219907] [041/133] (799s left) gem_partial_pwrite_pread (writes-after-reads-display) [242.290177] Starting subtest: writes-after-reads-display [247.472604] Subtest writes-after-reads-display: SUCCESS (5.133s) [247.592606] [042/133] (793s left) kms_psr2_sf (fbc-pr-primary-plane-update-sf-dmg-area) [248.077666] Subtest fbc-pr-primary-plane-update-sf-dmg-area: SKIP (0.000s) [248.139163] [043/133] (793s left) kms_flip (2x-wf_vblank-ts-check) [248.615814] Starting subtest: 2x-wf_vblank-ts-check [248.617268] Starting dynamic subtest: AB-VGA1-HDMI-A1 [313.168934] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (64.482s) [313.173934] Subtest 2x-wf_vblank-ts-check: SUCCESS (64.487s) [313.449137] [044/133] (728s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render) [313.931269] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render [315.927969] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (1.995s) [316.184559] [045/133] (725s left) gem_flink_race (flink_name) [316.243846] Starting subtest: flink_name [321.622763] Subtest flink_name: SUCCESS (5.376s) [321.741347] [046/133] (719s left) kms_flip (2x-flip-vs-panning-vs-hang) [322.217888] Starting subtest: 2x-flip-vs-panning-vs-hang [322.219496] Starting dynamic subtest: AB-VGA1-HDMI-A1 [334.742161] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (12.518s) [334.742809] Subtest 2x-flip-vs-panning-vs-hang: SUCCESS (12.521s) [335.017100] [047/133] (706s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff) [335.509298] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff [335.510419] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s) [335.626475] [048/133] (706s left) kms_cursor_crc (cursor-rapid-movement-128x42) [336.108016] Starting subtest: cursor-rapid-movement-128x42 [336.174417] Subtest cursor-rapid-movement-128x42: SKIP (0.065s) [336.279238] [049/133] (705s left) gem_workarounds (reset-fd) [336.348256] Starting subtest: reset-fd [336.357486] Subtest reset-fd: SUCCESS (0.009s) [336.478781] [050/133] (705s left) kms_cursor_edge_walk (256x256-top-edge) [336.947313] Starting subtest: 256x256-top-edge [336.948010] Starting dynamic subtest: pipe-A-VGA-1 [340.343427] Dynamic subtest pipe-A-VGA-1: SUCCESS (3.397s) [340.357783] Starting dynamic subtest: pipe-B-HDMI-A-1 [343.676431] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (3.332s) [343.676934] Subtest 256x256-top-edge: SUCCESS (6.734s) [343.937418] [051/133] (697s left) syncobj_timeline (invalid-transfer-illegal-handle) [343.996513] Starting subtest: invalid-transfer-illegal-handle [343.997072] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s) [344.087172] [052/133] (697s left) kms_big_fb (y-tiled-8bpp-rotate-90) [344.566955] Starting subtest: y-tiled-8bpp-rotate-90 [344.568232] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s) [344.685034] [053/133] (697s left) vgem_basic (bad-flag) [344.754966] Starting subtest: bad-flag [344.755588] Subtest bad-flag: SUCCESS (0.000s) [344.838669] [054/133] (697s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt) [345.319380] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt [346.860069] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SUCCESS (1.541s) [347.009577] [055/133] (695s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu) [347.490881] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu [347.492090] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [347.591539] [056/133] (694s left) prime_mmap_coherency (write) [347.652998] Starting subtest: write [353.028464] Subtest write: SUCCESS (5.376s) [353.630962] [057/133] (688s left) gem_lmem_swapping (heavy-verify-random) [353.687932] Subtest heavy-verify-random: SKIP (0.000s) [353.760120] [058/133] (688s left) kms_psr (pr-primary-page-flip) [354.236059] Subtest pr-primary-page-flip: SKIP (0.000s) [354.309270] [059/133] (688s left) gem_exec_flush (basic-uc-ro-default) [354.379659] Starting subtest: basic-uc-ro-default [359.834662] Subtest basic-uc-ro-default: SUCCESS (5.457s) [360.043364] [060/133] (682s left) i915_hangman (error-state-basic) [360.108188] Starting subtest: error-state-basic [360.110956] Subtest error-state-basic: SUCCESS (0.003s) [360.174900] [061/133] (682s left) kms_lease (simple-lease) [360.651540] Starting subtest: simple-lease [360.652414] Starting dynamic subtest: pipe-A-VGA-1 [360.819241] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.167s) [360.835307] Starting dynamic subtest: pipe-A-HDMI-A-1 [361.200120] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.376s) [361.216139] Starting dynamic subtest: pipe-B-VGA-1 [361.379510] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.178s) [361.393880] Starting dynamic subtest: pipe-B-HDMI-A-1 [361.689298] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.307s) [361.689883] Subtest simple-lease: SUCCESS (1.039s) [361.955275] [062/133] (680s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt) [362.442031] Starting subtest: fbc-farfromfence-mmap-gtt [364.473062] Subtest fbc-farfromfence-mmap-gtt: SUCCESS (2.030s) [364.712027] [063/133] (677s left) gem_softpin (allocator-nopin) [364.774268] Subtest allocator-nopin: SKIP (0.000s) [364.877996] [064/133] (677s left) kms_psr (fbc-psr2-cursor-render) [365.350440] Subtest fbc-psr2-cursor-render: SKIP (0.000s) [365.404319] [065/133] (677s left) kms_flip (2x-flip-vs-wf_vblank-interruptible) [365.885669] Starting subtest: 2x-flip-vs-wf_vblank-interruptible [365.887442] Starting dynamic subtest: AB-VGA1-HDMI-A1 [368.543796] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (2.656s) [368.547156] Subtest 2x-flip-vs-wf_vblank-interruptible: SUCCESS (2.660s) [368.838706] [066/133] (673s left) kms_panel_fitting (atomic-fastset) [369.314356] Starting subtest: atomic-fastset [369.315527] Subtest atomic-fastset: SKIP (0.000s) [369.414619] [067/133] (673s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move) [369.892574] Starting subtest: fbc-1p-primscrn-cur-indfb-move [372.305363] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (2.415s) [372.579617] [068/133] (670s left) gem_userptr_blits (sync-unmap-cycles) [372.658955] Starting subtest: sync-unmap-cycles [378.036705] Subtest sync-unmap-cycles: SUCCESS (5.377s) [378.177215] [069/133] (664s left) perf_pmu (busy-accuracy-50) [378.238715] Starting subtest: busy-accuracy-50 [378.239486] Starting dynamic subtest: rcs0 [378.240696] Dynamic subtest rcs0: SKIP (0.000s) [378.254296] Starting dynamic subtest: bcs0 [378.256054] Dynamic subtest bcs0: SKIP (0.000s) [378.270768] Starting dynamic subtest: vcs0 [378.272569] Dynamic subtest vcs0: SKIP (0.000s) [378.274023] Subtest busy-accuracy-50: SKIP (0.005s) [378.339380] [070/133] (664s left) kms_flip (flip-vs-panning) [378.821048] Starting subtest: flip-vs-panning [378.822423] Starting dynamic subtest: A-VGA1 [386.650838] Dynamic subtest A-VGA1: SUCCESS (7.826s) [386.668641] Starting dynamic subtest: B-VGA1 [394.402996] Dynamic subtest B-VGA1: SUCCESS (7.748s) [394.420158] Starting dynamic subtest: A-HDMI-A1 [402.180211] Dynamic subtest A-HDMI-A1: SUCCESS (7.773s) [402.196405] Starting dynamic subtest: B-HDMI-A1 [410.003478] Dynamic subtest B-HDMI-A1: SUCCESS (7.817s) [410.007349] Subtest flip-vs-panning: SUCCESS (31.178s) [410.200174] [071/133] (632s left) kms_hdr (bpc-switch-suspend) [410.673273] Starting subtest: bpc-switch-suspend [416.532004] Subtest bpc-switch-suspend: SKIP (5.857s) [416.869520] [072/133] (626s left) kms_psr2_sf (fbc-psr2-overlay-plane-update-continuous-sf) [417.348661] Subtest fbc-psr2-overlay-plane-update-continuous-sf: SKIP (0.000s) [417.413290] [073/133] (625s left) gem_exec_schedule (u-semaphore-noskip) [417.482946] Subtest u-semaphore-noskip: SKIP (0.000s) [417.686757] [074/133] (625s left) kms_busy (extended-pageflip-modeset-hang-oldfb) [418.168813] Starting subtest: extended-pageflip-modeset-hang-oldfb [418.170559] Starting dynamic subtest: pipe-A [424.828441] Dynamic subtest pipe-A: SUCCESS (6.655s) [424.845015] Starting dynamic subtest: pipe-B [430.804700] Dynamic subtest pipe-B: SUCCESS (5.970s) [430.805386] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (12.632s) [431.086275] [075/133] (612s left) api_intel_bb (delta-check) [431.145877] Starting subtest: delta-check [431.146930] Subtest delta-check: SKIP (0.001s) [431.268533] [076/133] (611s left) kms_async_flips (async-flip-with-page-flip-events-linear) [431.741441] Starting subtest: async-flip-with-page-flip-events-linear [431.993178] Subtest async-flip-with-page-flip-events-linear: SKIP (0.250s) [432.238615] [077/133] (611s left) gem_unfence_active_buffers [432.455234] [078/133] (610s left) kms_cursor_legacy (single-move) [432.929490] Starting subtest: single-move [432.930207] Starting dynamic subtest: pipe-A [438.317103] Dynamic subtest pipe-A: SUCCESS (5.385s) [438.338324] Starting dynamic subtest: pipe-B [443.704123] Dynamic subtest pipe-B: SUCCESS (5.383s) [443.723316] Starting dynamic subtest: all-pipes [449.092421] Dynamic subtest all-pipes: SUCCESS (5.383s) [449.093513] Subtest single-move: SUCCESS (16.159s) [449.195443] [079/133] (594s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt) [449.676070] Starting subtest: fbcpsr-rgb565-draw-blt [449.677208] Subtest fbcpsr-rgb565-draw-blt: SKIP (0.000s) [449.793540] [080/133] (593s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted) [449.851386] Starting subtest: etime-single-wait-all-available-unsubmitted [449.952117] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.101s) [450.042571] [081/133] (593s left) gem_ppgtt (flink-and-close-vma-leak) [450.099671] Starting subtest: flink-and-close-vma-leak [450.103587] Subtest flink-and-close-vma-leak: SKIP (0.001s) [450.173628] [082/133] (593s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [450.647189] Starting subtest: nonblocking-crc-frame-sequence [450.648969] Starting dynamic subtest: pipe-A-VGA-1 [451.268350] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.619s) [451.283275] Starting dynamic subtest: pipe-B-HDMI-A-1 [451.834100] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.564s) [451.834579] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.188s) [452.074998] [083/133] (591s left) i915_suspend (forcewake) [452.133197] Starting subtest: forcewake [489.559221] Subtest forcewake: SUCCESS (4.641s) [494.621550] [084/133] (554s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-fullscreen) [495.106036] Starting subtest: psr-2p-scndscrn-spr-indfb-fullscreen [495.107229] Subtest psr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [495.215104] [085/133] (553s left) kms_big_fb (4-tiled-32bpp-rotate-0) [495.701827] Starting subtest: 4-tiled-32bpp-rotate-0 [495.703131] Subtest 4-tiled-32bpp-rotate-0: SKIP (0.000s) [495.820817] [086/133] (552s left) gem_render_copy (x-tiled-to-vebox-yf-tiled) [495.889292] Starting subtest: x-tiled-to-vebox-yf-tiled [495.890936] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s) [496.091088] [087/133] (552s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf) [496.575338] Subtest psr2-overlay-plane-move-continuous-sf: SKIP (0.000s) [496.645066] [088/133] (552s left) gem_render_copy (y-tiled-to-vebox-yf-tiled) [496.715354] Starting subtest: y-tiled-to-vebox-yf-tiled [496.717232] Subtest y-tiled-to-vebox-yf-tiled: SKIP (0.000s) [496.924750] [089/133] (552s left) perf_pmu (busy-idle-no-semaphores) [496.982912] Starting subtest: busy-idle-no-semaphores [496.983612] Starting dynamic subtest: rcs0 [497.614328] Dynamic subtest rcs0: SUCCESS (0.622s) [497.633183] Starting dynamic subtest: bcs0 [498.249696] Dynamic subtest bcs0: SUCCESS (0.626s) [498.266714] Starting dynamic subtest: vcs0 [499.379305] Dynamic subtest vcs0: SUCCESS (1.116s) [499.381278] Subtest busy-idle-no-semaphores: SUCCESS (2.369s) [499.499472] [090/133] (549s left) kms_color_pipeline (plane-lut1d-lut1d) [499.983601] Starting subtest: plane-lut1d-lut1d [500.646398] Subtest plane-lut1d-lut1d: SKIP (0.656s) [500.912989] [091/133] (548s left) kms_dsc (dsc-with-output-formats-with-bpc) [501.390064] Subtest dsc-with-output-formats-with-bpc: SKIP (0.000s) [501.460816] [092/133] (547s left) kms_getfb (getfb-repeated-different-handles) [501.940991] Starting subtest: getfb-repeated-different-handles [501.941579] Subtest getfb-repeated-different-handles: SUCCESS (0.000s) [502.052797] [093/133] (547s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-cpu) [502.538722] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-cpu [502.539929] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [502.656810] [094/133] (546s left) gem_ctx_persistence (legacy-engines-hostile-preempt) [502.715660] Subtest legacy-engines-hostile-preempt: SKIP (0.000s) [502.805658] [095/133] (546s left) gem_compute (compute-square) [502.863353] Starting subtest: compute-square [502.864597] Subtest compute-square: SKIP (0.000s) [502.963082] [096/133] (546s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic) [503.439737] Starting subtest: flip-vs-cursor-busy-crc-atomic [504.024296] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.581s) [504.313975] [097/133] (545s left) gem_exec_reloc (basic-gtt-cpu-active) [504.378957] Starting subtest: basic-gtt-cpu-active [504.489327] Subtest basic-gtt-cpu-active: SUCCESS (0.110s) [505.010874] [098/133] (544s left) kms_prop_blob (blob-multiple) [505.067438] Starting subtest: blob-multiple [505.068486] Subtest blob-multiple: SUCCESS (0.002s) [505.170757] [099/133] (544s left) i915_query (query-garbage) [505.228437] Starting subtest: query-garbage [505.229077] Subtest query-garbage: SUCCESS (0.000s) [505.331149] [100/133] (544s left) kms_cursor_crc (cursor-dpms) [505.806783] Starting subtest: cursor-dpms [505.808579] Starting dynamic subtest: pipe-A-VGA-1 [506.777314] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.964s) [506.793176] Starting dynamic subtest: pipe-B-HDMI-A-1 [507.803486] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.014s) [507.804542] Subtest cursor-dpms: SUCCESS (1.983s) [508.068245] [101/133] (541s left) syncobj_basic (bad-pad-handle-to-fd) [508.125235] Starting subtest: bad-pad-handle-to-fd [508.125856] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s) [508.232817] [102/133] (541s left) kms_psr (fbc-psr-primary-page-flip) [508.708273] Subtest fbc-psr-primary-page-flip: SKIP (0.000s) [508.782622] [103/133] (540s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted) [508.839689] Starting subtest: multi-wait-all-for-submit-unsubmitted [508.940806] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.100s) [509.038096] [104/133] (540s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip) [509.520471] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip [509.521569] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s) [509.640312] [105/133] (540s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [510.116888] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu [510.118073] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [510.224262] [106/133] (539s left) kms_vblank (query-forked-busy) [510.702274] Starting subtest: query-forked-busy [510.703185] Starting dynamic subtest: pipe-A-VGA-1 [513.194391] Dynamic subtest pipe-A-VGA-1: SUCCESS (2.485s) [513.210884] Starting dynamic subtest: pipe-A-HDMI-A-1 [515.632767] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.432s) [515.648959] Starting dynamic subtest: pipe-B-VGA-1 [517.985922] Dynamic subtest pipe-B-VGA-1: SUCCESS (2.347s) [518.001136] Starting dynamic subtest: pipe-B-HDMI-A-1 [520.424010] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.434s) [520.426977] Subtest query-forked-busy: SUCCESS (9.708s) [520.704153] [107/133] (529s left) gem_exec_reloc (basic-cpu) [520.766288] Starting subtest: basic-cpu [520.769925] Subtest basic-cpu: SUCCESS (0.004s) [521.289066] [108/133] (528s left) gem_userptr_blits (sync-unmap) [521.363644] Starting subtest: sync-unmap [521.375584] Subtest sync-unmap: SUCCESS (0.012s) [521.525167] [109/133] (528s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite) [522.004150] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite [522.005220] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [522.124698] [110/133] (528s left) kms_content_protection (legacy) [522.621260] Starting subtest: legacy [522.622263] Subtest legacy: SKIP (0.000s) [522.743574] [111/133] (527s left) gem_lmem_swapping (smem-oom) [522.805161] Subtest smem-oom: SKIP (0.000s) [522.867390] [112/133] (527s left) syncobj_eventfd (invalid-bad-flags) [522.928681] Starting subtest: invalid-bad-flags [522.929582] Subtest invalid-bad-flags: SUCCESS (0.000s) [523.022624] [113/133] (527s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip) [523.504932] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip [523.609526] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.103s) [523.831987] [114/133] (526s left) kms_atomic (plane-primary-overlay-mutable-zpos) [524.304724] Starting subtest: plane-primary-overlay-mutable-zpos [524.624778] Subtest plane-primary-overlay-mutable-zpos: SKIP (0.319s) [524.819284] [115/133] (525s left) gem_render_copy_redux (flink) [524.880858] Starting subtest: flink [526.036748] Subtest flink: SUCCESS (1.155s) [526.171897] [116/133] (524s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt) [526.653167] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt [526.654481] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [526.756076] [117/133] (523s left) gem_exec_alignment (pi) [526.818182] Starting subtest: pi [526.819497] Subtest pi: SKIP (0.000s) [526.940967] [118/133] (523s left) kms_pm_rpm (cursor-dpms) [538.711603] Subtest cursor-dpms: SKIP (0.000s) [538.781811] [119/133] (511s left) gem_ctx_param (vm) [538.842525] Starting subtest: vm [538.843636] Subtest vm: SKIP (0.000s) [538.959057] [120/133] (511s left) gem_exec_balancer (parallel-ordering) [539.018930] Subtest parallel-ordering: SKIP (0.000s) [539.123060] [121/133] (511s left) i915_pm_rpm (system-suspend-devices) [550.891940] Subtest system-suspend-devices: SKIP (0.000s) [550.956818] [122/133] (499s left) gem_workarounds (basic-read-context) [551.029387] Starting subtest: basic-read-context [551.032615] Subtest basic-read-context: SUCCESS (0.004s) [551.159257] [123/133] (499s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [551.639636] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip [551.640967] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s) [551.755778] [124/133] (499s left) kms_chamelium_edid (hdmi-edid-stress-resolution-non-4k) [552.344350] Subtest hdmi-edid-stress-resolution-non-4k: SKIP (0.000s) [552.562335] [125/133] (498s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier) [553.035717] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier [553.037321] Subtest pixel-format-4-tiled-bmg-ccs-modifier: SKIP (0.000s) [553.131871] [126/133] (497s left) api_intel_allocator (execbuf-with-allocator) [553.191260] Starting subtest: execbuf-with-allocator [553.192676] Subtest execbuf-with-allocator: SKIP (0.000s) [553.292810] [127/133] (497s left) prime_vgem (coherency-gtt) [553.369449] Starting subtest: coherency-gtt [553.384909] Subtest coherency-gtt: SUCCESS (0.017s) [553.495718] [128/133] (497s left) syncobj_wait (reset-unsignaled) [553.552556] Starting subtest: reset-unsignaled [553.553114] Subtest reset-unsignaled: SUCCESS (0.000s) [553.645138] [129/133] (497s left) gem_pxp (create-protected-buffer) [556.219865] Starting subtest: create-protected-buffer [556.221124] Subtest create-protected-buffer: SKIP (0.000s) [556.321765] [130/133] (494s left) kms_plane (pixel-format-yf-tiled-ccs-modifier) [556.792267] Starting subtest: pixel-format-yf-tiled-ccs-modifier [556.793745] Subtest pixel-format-yf-tiled-ccs-modifier: SKIP (0.000s) [556.898077] [131/133] (494s left) gem_exec_balancer (hang) [556.960257] Subtest hang: SKIP (0.000s) [557.058878] [132/133] (494s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation) [557.539737] Starting subtest: plane-downscale-factor-0-75-with-rotation [557.540581] Starting dynamic subtest: pipe-A [557.543210] Dynamic subtest pipe-A: SKIP (0.002s) [557.558387] Starting dynamic subtest: pipe-B [557.561503] Dynamic subtest pipe-B: SKIP (0.001s) [557.563017] Subtest plane-downscale-factor-0-75-with-rotation: SKIP (0.008s) [557.652289] [133/133] (493s left) sw_sync (sync_busy) [557.707817] Starting subtest: sync_busy [557.712441] Subtest sync_busy: SUCCESS (0.005s) [557.795203] Closing watchdogs results: parsing output: 0/ for test: kms_invalid_mode results: parsing output: 1/ for test: gem_mmap_offset results: parsing output: 2/ for test: gem_exec_schedule results: parsing output: 3/ for test: gen9_exec_parse results: parsing output: 4/ for test: kms_cursor_legacy results: parsing output: 5/ for test: kms_ccs results: parsing output: 6/ for test: kms_universal_plane results: parsing output: 7/ for test: gem_mmap results: parsing output: 8/ for test: kms_chamelium_color results: parsing output: 9/ for test: gem_render_copy_redux results: parsing output: 10/ for test: kms_psr results: parsing output: 11/ for test: drm_read results: parsing output: 12/ for test: kms_frontbuffer_tracking results: parsing output: 13/ for test: kms_ccs results: parsing output: 14/ for test: gem_tiled_wb results: parsing output: 15/ for test: kms_plane_scaling results: parsing output: 16/ for test: syncobj_wait results: parsing output: 17/ for test: gem_vm_create results: parsing output: 18/ for test: kms_flip_scaled_crc results: parsing output: 19/ for test: gem_exec_fence results: parsing output: 20/ for test: kms_big_fb results: parsing output: 21/ for test: kms_frontbuffer_tracking results: parsing output: 22/ for test: kms_cursor_crc results: parsing output: 23/ for test: gem_exec_schedule results: parsing output: 24/ for test: gem_exec_whisper results: parsing output: 25/ for test: i915_drm_fdinfo results: parsing output: 26/ for test: kms_ccs results: parsing output: 27/ for test: kms_chamelium_hpd results: parsing output: 28/ for test: kms_psr results: parsing output: 29/ for test: syncobj_timeline results: parsing output: 30/ for test: kms_frontbuffer_tracking results: parsing output: 31/ for test: kms_cursor_legacy results: parsing output: 32/ for test: fbdev results: parsing output: 33/ for test: kms_frontbuffer_tracking results: parsing output: 34/ for test: prime_busy results: parsing output: 35/ for test: kms_flip results: parsing output: 36/ for test: syncobj_timeline results: parsing output: 37/ for test: kms_ccs results: parsing output: 38/ for test: kms_addfb_basic results: parsing output: 39/ for test: kms_flip results: parsing output: 40/ for test: gem_partial_pwrite_pread results: parsing output: 41/ for test: kms_psr2_sf results: parsing output: 42/ for test: kms_flip results: parsing output: 43/ for test: kms_frontbuffer_tracking results: parsing output: 44/ for test: gem_flink_race results: parsing output: 45/ for test: kms_flip results: parsing output: 46/ for test: kms_frontbuffer_tracking results: parsing output: 47/ for test: kms_cursor_crc results: parsing output: 48/ for test: gem_workarounds results: parsing output: 49/ for test: kms_cursor_edge_walk results: parsing output: 50/ for test: syncobj_timeline results: parsing output: 51/ for test: kms_big_fb results: parsing output: 52/ for test: vgem_basic results: parsing output: 53/ for test: kms_frontbuffer_tracking results: parsing output: 54/ for test: kms_frontbuffer_tracking results: parsing output: 55/ for test: prime_mmap_coherency results: parsing output: 56/ for test: gem_lmem_swapping results: parsing output: 57/ for test: kms_psr results: parsing output: 58/ for test: gem_exec_flush results: parsing output: 59/ for test: i915_hangman results: parsing output: 60/ for test: kms_lease results: parsing output: 61/ for test: kms_frontbuffer_tracking results: parsing output: 62/ for test: gem_softpin results: parsing output: 63/ for test: kms_psr results: parsing output: 64/ for test: kms_flip results: parsing output: 65/ for test: kms_panel_fitting results: parsing output: 66/ for test: kms_frontbuffer_tracking results: parsing output: 67/ for test: gem_userptr_blits results: parsing output: 68/ for test: perf_pmu results: parsing output: 69/ for test: kms_flip results: parsing output: 70/ for test: kms_hdr results: parsing output: 71/ for test: kms_psr2_sf results: parsing output: 72/ for test: gem_exec_schedule results: parsing output: 73/ for test: kms_busy results: parsing output: 74/ for test: api_intel_bb results: parsing output: 75/ for test: kms_async_flips results: parsing output: 76/ for test: gem_unfence_active_buffers results: parsing output: 77/ for test: kms_cursor_legacy results: parsing output: 78/ for test: kms_frontbuffer_tracking results: parsing output: 79/ for test: syncobj_timeline results: parsing output: 80/ for test: gem_ppgtt results: parsing output: 81/ for test: kms_pipe_crc_basic results: parsing output: 82/ for test: i915_suspend results: parsing output: 83/ for test: kms_frontbuffer_tracking results: parsing output: 84/ for test: kms_big_fb results: parsing output: 85/ for test: gem_render_copy results: parsing output: 86/ for test: kms_psr2_sf results: parsing output: 87/ for test: gem_render_copy results: parsing output: 88/ for test: perf_pmu results: parsing output: 89/ for test: kms_color_pipeline results: parsing output: 90/ for test: kms_dsc results: parsing output: 91/ for test: kms_getfb results: parsing output: 92/ for test: kms_frontbuffer_tracking results: parsing output: 93/ for test: gem_ctx_persistence results: parsing output: 94/ for test: gem_compute results: parsing output: 95/ for test: kms_cursor_legacy results: parsing output: 96/ for test: gem_exec_reloc results: parsing output: 97/ for test: kms_prop_blob results: parsing output: 98/ for test: i915_query results: parsing output: 99/ for test: kms_cursor_crc results: parsing output: 100/ for test: syncobj_basic results: parsing output: 101/ for test: kms_psr results: parsing output: 102/ for test: syncobj_wait results: parsing output: 103/ for test: kms_big_fb results: parsing output: 104/ for test: kms_frontbuffer_tracking results: parsing output: 105/ for test: kms_vblank results: parsing output: 106/ for test: gem_exec_reloc results: parsing output: 107/ for test: gem_userptr_blits results: parsing output: 108/ for test: kms_frontbuffer_tracking results: parsing output: 109/ for test: kms_content_protection results: parsing output: 110/ for test: gem_lmem_swapping results: parsing output: 111/ for test: syncobj_eventfd results: parsing output: 112/ for test: kms_big_fb results: parsing output: 113/ for test: kms_atomic results: parsing output: 114/ for test: gem_render_copy_redux results: parsing output: 115/ for test: kms_frontbuffer_tracking results: parsing output: 116/ for test: gem_exec_alignment results: parsing output: 117/ for test: kms_pm_rpm results: parsing output: 118/ for test: gem_ctx_param results: parsing output: 119/ for test: gem_exec_balancer results: parsing output: 120/ for test: i915_pm_rpm results: parsing output: 121/ for test: gem_workarounds results: parsing output: 122/ for test: kms_big_fb results: parsing output: 123/ for test: kms_chamelium_edid results: parsing output: 124/ for test: kms_plane results: parsing output: 125/ for test: api_intel_allocator results: parsing output: 126/ for test: prime_vgem results: parsing output: 127/ for test: syncobj_wait results: parsing output: 128/ for test: gem_pxp results: parsing output: 129/ for test: kms_plane results: parsing output: 130/ for test: gem_exec_balancer results: parsing output: 131/ for test: kms_plane_scaling results: parsing output: 132/ for test: sw_sync Done.