[67.727355] Initializing watchdogs [67.727495] /dev/watchdog0 [67.747110] [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) [67.754523] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [67.758135] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [67.761452] [001/133] (960s left) gem_partial_pwrite_pread (write-snoop) [67.836186] Starting subtest: write-snoop [71.713158] Subtest write-snoop: SUCCESS (3.876s) [71.886690] [002/133] (956s left) kms_content_protection (content-type-change) [72.413144] Starting subtest: content-type-change [72.415157] Subtest content-type-change: SKIP (0.000s) [73.021555] [003/133] (955s left) kms_rotation_crc (multiplane-rotation) [73.513399] Starting subtest: multiplane-rotation [73.515510] Subtest multiplane-rotation: SKIP (0.000s) [74.100202] [004/133] (954s left) kms_chamelium_color (ctm-red-to-blue) [74.599861] Subtest ctm-red-to-blue: SKIP (0.000s) [74.893623] [005/133] (953s left) syncobj_wait (invalid-reset-one-illegal-handle) [74.950122] Starting subtest: invalid-reset-one-illegal-handle [74.951263] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s) [75.062021] [006/133] (953s left) kms_pipe_crc_basic (disable-crc-after-crtc) [75.556501] Starting subtest: disable-crc-after-crtc [75.557517] Starting dynamic subtest: pipe-A-HDMI-A-1 [76.054911] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.497s) [76.066094] Starting dynamic subtest: pipe-B-HDMI-A-1 [76.590214] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.533s) [76.591321] Subtest disable-crc-after-crtc: SUCCESS (1.033s) [77.296136] [007/133] (951s left) gem_set_tiling_vs_blt (tiled-to-tiled) [77.356730] Starting subtest: tiled-to-tiled [77.386905] Subtest tiled-to-tiled: SUCCESS (0.029s) [77.562591] [008/133] (950s left) syncobj_wait (wait-all-interrupted) [77.619204] Starting subtest: wait-all-interrupted [77.721342] Subtest wait-all-interrupted: SUCCESS (0.101s) [77.862717] [009/133] (950s left) syncobj_wait (wait-all-complex) [77.918518] Starting subtest: wait-all-complex [78.132874] Subtest wait-all-complex: SUCCESS (0.214s) [78.245769] [010/133] (950s left) gem_pxp (reject-modify-context-protection-on) [80.813517] Starting subtest: reject-modify-context-protection-on [80.815578] Subtest reject-modify-context-protection-on: SKIP (0.000s) [80.921487] [011/133] (947s left) kms_cursor_legacy (cursora-vs-flipb-varying-size) [81.414734] Starting subtest: cursorA-vs-flipB-varying-size [81.416984] Subtest cursorA-vs-flipB-varying-size: SKIP (0.001s) [82.024286] [012/133] (946s left) kms_rotation_crc (primary-rotation-90) [82.517335] Starting subtest: primary-rotation-90 [82.519447] Subtest primary-rotation-90: SKIP (0.001s) [83.119521] [013/133] (945s left) syncobj_wait (reset-multiple-signaled) [83.176914] Starting subtest: reset-multiple-signaled [83.177952] Subtest reset-multiple-signaled: SUCCESS (0.001s) [83.304227] [014/133] (945s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs) [83.357870] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s) [83.413192] [015/133] (945s left) gem_softpin (noreloc-s3) [83.466522] Starting subtest: noreloc-S3 [138.166440] Subtest noreloc-S3: SUCCESS (5.398s) [146.344249] [016/133] (890s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt) [146.865008] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt [148.865141] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (1.918s) [149.515824] [017/133] (887s left) gem_ctx_param (invalid-ctx-set) [149.571850] Starting subtest: invalid-ctx-set [149.573177] Subtest invalid-ctx-set: SUCCESS (0.000s) [149.702651] [018/133] (887s left) syncobj_wait (single-wait-all-for-submit-unsubmitted) [149.759092] Starting subtest: single-wait-all-for-submit-unsubmitted [149.864797] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.103s) [149.995887] [019/133] (887s left) kms_big_fb (x-tiled-64bpp-rotate-90) [150.512282] Starting subtest: x-tiled-64bpp-rotate-90 [150.519463] Subtest x-tiled-64bpp-rotate-90: SKIP (0.005s) [151.164654] [020/133] (885s left) gem_mmap_gtt (cpuset-basic-small-copy-xy) [151.220204] Starting subtest: cpuset-basic-small-copy-XY [152.402469] Subtest cpuset-basic-small-copy-XY: SUCCESS (1.152s) [152.550268] [021/133] (884s left) kms_psr (fbc-psr-cursor-plane-move) [153.176132] Subtest fbc-psr-cursor-plane-move: SKIP (0.000s) [153.472210] [022/133] (883s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180) [153.987115] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180 [153.989529] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.002s) [154.598023] [023/133] (882s left) kms_flip (2x-flip-vs-rmfb) [155.094974] Starting subtest: 2x-flip-vs-rmfb [155.096128] Starting dynamic subtest: AB-VGA1-HDMI-A1 [185.521987] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (30.295s) [185.524827] Subtest 2x-flip-vs-rmfb: SUCCESS (30.298s) [186.360966] [024/133] (850s left) kms_plane_cursor (viewport) [186.852940] Starting subtest: viewport [186.855096] Starting dynamic subtest: pipe-A-HDMI-A-1-size-64 [189.540182] Dynamic subtest pipe-A-HDMI-A-1-size-64: SUCCESS (2.684s) [189.605723] Starting dynamic subtest: pipe-A-HDMI-A-1-size-128 [192.303072] Dynamic subtest pipe-A-HDMI-A-1-size-128: SUCCESS (2.710s) [192.365513] Starting dynamic subtest: pipe-A-HDMI-A-1-size-256 [195.065814] Dynamic subtest pipe-A-HDMI-A-1-size-256: SUCCESS (2.710s) [195.215781] Starting dynamic subtest: pipe-B-HDMI-A-1-size-64 [197.984069] Dynamic subtest pipe-B-HDMI-A-1-size-64: SUCCESS (2.781s) [198.048980] Starting dynamic subtest: pipe-B-HDMI-A-1-size-128 [200.746562] Dynamic subtest pipe-B-HDMI-A-1-size-128: SUCCESS (2.711s) [200.808568] Starting dynamic subtest: pipe-B-HDMI-A-1-size-256 [203.509240] Dynamic subtest pipe-B-HDMI-A-1-size-256: SUCCESS (2.711s) [203.644026] Subtest viewport: SUCCESS (16.780s) [204.363249] [025/133] (833s left) kms_cdclk (mode-transition) [204.423104] Subtest mode-transition: SKIP (0.000s) [204.485401] [026/133] (832s left) gem_exec_balancer (fairslice) [204.546603] Subtest fairslice: SKIP (0.000s) [204.674578] [027/133] (832s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [205.169379] Starting subtest: basic-flip-before-cursor-varying-size [206.161628] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.990s) [206.869196] [028/133] (830s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling) [206.927815] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s) [206.983332] [029/133] (830s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling) [207.039846] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SKIP (0.000s) [207.099965] [030/133] (830s left) core_getstats (basic) [207.153032] Starting subtest: basic [207.154187] Subtest basic: SUCCESS (0.000s) [207.281847] [031/133] (830s left) kms_rmfb (close-fd) [207.768495] Starting subtest: close-fd [207.769562] Starting dynamic subtest: pipe-A-HDMI-A-1 [207.876829] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.107s) [207.889376] Starting dynamic subtest: pipe-B-HDMI-A-1 [208.160838] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.282s) [208.161912] Subtest close-fd: SUCCESS (0.394s) [208.923942] [032/133] (828s left) gem_exec_reloc (basic-gtt-wc) [208.982785] Starting subtest: basic-gtt-wc [208.986791] Subtest basic-gtt-wc: SUCCESS (0.004s) [210.022813] [033/133] (827s left) kms_properties (crtc-properties-legacy) [210.514726] Starting subtest: crtc-properties-legacy [210.515781] Starting dynamic subtest: pipe-A-HDMI-A-1 [210.744277] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.229s) [210.759611] Starting dynamic subtest: pipe-B-HDMI-A-1 [211.053206] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.308s) [211.054411] Subtest crtc-properties-legacy: SUCCESS (0.541s) [211.759661] [034/133] (826s left) kms_invalid_mode (zero-hdisplay) [212.248592] Starting subtest: zero-hdisplay [212.249688] Starting dynamic subtest: pipe-A-HDMI-A-1 [212.332994] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.084s) [212.347615] Starting dynamic subtest: pipe-B-HDMI-A-1 [212.348724] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s) [212.349753] Subtest zero-hdisplay: SUCCESS (0.089s) [212.823462] [035/133] (825s left) kms_plane_scaling (plane-upscale-factor-0-25-with-pixel-format) [213.314293] Starting subtest: plane-upscale-factor-0-25-with-pixel-format [213.315387] Starting dynamic subtest: pipe-A [213.318689] Dynamic subtest pipe-A: SKIP (0.001s) [213.334321] Starting dynamic subtest: pipe-B [213.337588] Dynamic subtest pipe-B: SKIP (0.001s) [213.339596] Subtest plane-upscale-factor-0-25-with-pixel-format: SKIP (0.004s) [213.923039] [036/133] (823s left) kms_pm_rpm (legacy-planes-dpms) [225.708747] Subtest legacy-planes-dpms: SKIP (0.000s) [225.998570] [037/133] (811s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt) [226.490631] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt [226.492721] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [227.103710] [038/133] (810s left) kms_dirtyfb (default-dirtyfb-ioctl) [227.590625] Starting subtest: default-dirtyfb-ioctl [227.591769] Starting dynamic subtest: A-HDMI-A-1 [228.935886] Dynamic subtest A-HDMI-A-1: SUCCESS (1.344s) [228.937108] Subtest default-dirtyfb-ioctl: SUCCESS (1.346s) [229.627031] [039/133] (808s left) kms_cursor_legacy (cursorb-vs-flipa-legacy) [230.110090] Starting subtest: cursorB-vs-flipA-legacy [230.114188] Subtest cursorB-vs-flipA-legacy: SKIP (0.002s) [230.721246] [040/133] (807s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-signaled) [230.783949] Starting subtest: multi-wait-for-submit-available-unsubmitted-signaled [230.785081] Subtest multi-wait-for-submit-available-unsubmitted-signaled: SUCCESS (0.001s) [230.907176] [041/133] (807s left) kms_prime (basic-crc-vgem) [231.435514] Starting subtest: basic-crc-vgem [231.436594] Starting dynamic subtest: second-to-first [232.867234] Dynamic subtest second-to-first: SUCCESS (1.430s) [232.868705] Subtest basic-crc-vgem: SUCCESS (1.432s) [234.037230] [FACT kms_prime (basic-crc-vgem)] new: kernel.kmod_is_loaded.vgem: true [234.040195] [042/133] (804s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c) [234.100885] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s) [234.170269] [043/133] (804s left) i915_drm_fdinfo (busy) [234.226646] Subtest busy: SKIP (0.000s) [234.289293] [044/133] (804s left) gem_userptr_blits (nohangcheck) [234.371934] Starting subtest: nohangcheck [234.421341] Subtest nohangcheck: SUCCESS (0.048s) [234.573849] [045/133] (803s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [235.069961] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip [235.072224] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s) [235.672775] [046/133] (802s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs) [235.729937] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s) [235.784022] [047/133] (802s left) kms_scaling_modes (scaling-mode-full) [236.265832] Starting subtest: scaling-mode-full [236.270084] Subtest scaling-mode-full: SKIP (0.000s) [236.887118] [048/133] (801s left) kms_psr (fbc-pr-basic) [237.374786] Subtest fbc-pr-basic: SKIP (0.000s) [237.697256] [049/133] (800s left) gem_ringfill (basic-all) [237.861945] Starting subtest: basic-all [238.961035] Subtest basic-all: SUCCESS (1.097s) [239.118107] [050/133] (799s left) gem_exec_whisper (basic-fds-forked-all) [239.186709] Starting subtest: basic-fds-forked-all [242.808307] Subtest basic-fds-forked-all: SUCCESS (3.617s) [243.043981] [051/133] (795s left) api_intel_bb (full-batch) [243.103489] Starting subtest: full-batch [243.104670] Subtest full-batch: SUCCESS (0.001s) [243.260976] [052/133] (795s left) kms_cursor_crc (cursor-sliding-256x85) [243.754166] Starting subtest: cursor-sliding-256x85 [243.809389] Subtest cursor-sliding-256x85: SKIP (0.053s) [244.442907] [053/133] (794s left) kms_ccs (crc-sprite-planes-basic-y-tiled-ccs) [244.498682] Subtest crc-sprite-planes-basic-y-tiled-ccs: SKIP (0.000s) [244.570132] [054/133] (794s left) gen9_exec_parse (allowed-single) [244.626509] Subtest allowed-single: SKIP (0.000s) [244.690027] [055/133] (794s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu) [245.182683] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu [245.184785] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [245.788856] [056/133] (793s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip) [246.281214] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip [246.283473] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s) [246.883407] [057/133] (792s left) gem_exec_fence (expired-history) [247.077816] Starting subtest: expired-history [247.143537] Subtest expired-history: SUCCESS (0.066s) [247.501949] [058/133] (791s left) kms_psr (fbc-psr-sprite-plane-move) [247.985466] Subtest fbc-psr-sprite-plane-move: SKIP (0.000s) [248.296067] [059/133] (790s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc) [248.787915] Starting subtest: fbcpsr-rgb565-draw-mmap-wc [248.790099] Subtest fbcpsr-rgb565-draw-mmap-wc: SKIP (0.000s) [249.395235] [060/133] (789s left) gem_ctx_bad_destroy (double-destroy) [249.453188] Starting subtest: double-destroy [249.454307] Subtest double-destroy: SUCCESS (0.000s) [249.578562] [061/133] (789s left) syncobj_timeline (invalid-signal-illegal-handle) [249.635325] Starting subtest: invalid-signal-illegal-handle [249.636387] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [249.780115] [062/133] (789s left) kms_chamelium_hpd (common-hpd-after-suspend) [250.341975] Subtest common-hpd-after-suspend: SKIP (0.000s) [250.750479] [063/133] (788s left) kms_frontbuffer_tracking (fbc-tiling-4) [251.237165] Starting subtest: fbc-tiling-4 [251.239466] Subtest fbc-tiling-4: SKIP (0.000s) [251.836765] [064/133] (787s left) gem_cs_tlb (engines) [251.898298] Starting subtest: engines [251.899497] Starting dynamic subtest: rcs0 [253.985053] Dynamic subtest rcs0: SUCCESS (2.084s) [254.000931] Starting dynamic subtest: bcs0 [256.053963] Dynamic subtest bcs0: SUCCESS (2.068s) [256.069180] Starting dynamic subtest: vcs0 [258.183944] Dynamic subtest vcs0: SUCCESS (2.130s) [258.185183] Subtest engines: SUCCESS (6.286s) [258.355683] [065/133] (781s left) gem_mmap_gtt (hang-busy) [258.411431] Starting subtest: hang-busy [264.208191] Subtest hang-busy: SUCCESS (5.797s) [264.362791] [066/133] (775s left) kms_psr (psr2-sprite-plane-onoff) [264.844338] Subtest psr2-sprite-plane-onoff: SKIP (0.000s) [265.151986] [067/133] (774s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [265.647559] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip [266.185874] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.538s) [266.839453] [068/133] (772s left) kms_big_fb (y-tiled-64bpp-rotate-270) [267.334180] Starting subtest: y-tiled-64bpp-rotate-270 [267.336427] Subtest y-tiled-64bpp-rotate-270: SKIP (0.000s) [267.942270] [069/133] (771s left) gem_bad_reloc (negative-reloc-lut) [268.001028] Starting subtest: negative-reloc-lut [268.003464] Subtest negative-reloc-lut: SKIP (0.000s) [268.169051] [070/133] (771s left) gem_ctx_persistence (engines-mixed) [268.229738] Subtest engines-mixed: SKIP (0.000s) [268.297088] [071/133] (771s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25) [268.781471] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25 [268.782497] Starting dynamic subtest: pipe-A [268.786132] Dynamic subtest pipe-A: SKIP (0.001s) [268.810937] Starting dynamic subtest: pipe-B [268.826252] Dynamic subtest pipe-B: SKIP (0.001s) [268.828345] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SKIP (0.005s) [269.400450] [072/133] (770s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu) [269.893954] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu [269.896082] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [270.495711] [073/133] (769s left) gem_exec_schedule (semaphore-noskip) [270.566043] Subtest semaphore-noskip: SKIP (0.000s) [270.796361] [074/133] (769s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc) [271.285795] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc [271.288814] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [271.894849] [075/133] (768s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render) [272.384752] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render [272.386920] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [272.991986] [076/133] (767s left) kms_big_fb (4-tiled-16bpp-rotate-0) [273.492379] Starting subtest: 4-tiled-16bpp-rotate-0 [273.494650] Subtest 4-tiled-16bpp-rotate-0: SKIP (0.000s) [274.108893] [077/133] (766s left) gem_exec_basic (basic) [274.172945] Starting subtest: basic [274.174123] Starting dynamic subtest: rcs0-smem [274.175274] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [274.192144] Starting dynamic subtest: bcs0-smem [274.193370] Dynamic subtest bcs0-smem: SUCCESS (0.000s) [274.211133] Starting dynamic subtest: vcs0-smem [274.212236] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [274.213327] Subtest basic: SUCCESS (0.008s) [274.423421] [078/133] (765s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt) [274.914597] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt [274.916671] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [275.522269] [079/133] (764s left) gem_mmap (short-mmap) [275.622511] Starting subtest: short-mmap [275.623856] Subtest short-mmap: SUCCESS (0.000s) [275.720446] [080/133] (764s left) gem_exec_reloc (basic-gtt-wc-active) [275.777770] Starting subtest: basic-gtt-wc-active [275.888599] Subtest basic-gtt-wc-active: SUCCESS (0.110s) [276.921158] [081/133] (763s left) gem_ctx_shared (create-shared-gtt) [276.979651] Subtest create-shared-gtt: SKIP (0.000s) [277.101082] [082/133] (763s left) gem_exec_reloc (basic-write-wc) [277.157987] Starting subtest: basic-write-wc [277.160804] Subtest basic-write-wc: SUCCESS (0.003s) [278.201645] [083/133] (762s left) gem_eio (wait-immediate) [278.267806] Starting subtest: wait-immediate [278.299645] Subtest wait-immediate: SUCCESS (0.032s) [279.349901] [084/133] (761s left) gem_ctx_persistence (legacy-engines-mixed) [279.409427] Subtest legacy-engines-mixed: SKIP (0.000s) [279.473616] [085/133] (761s left) perf_pmu (semaphore-busy) [279.533557] Starting subtest: semaphore-busy [279.534578] Starting dynamic subtest: rcs0 [279.536663] Dynamic subtest rcs0: SKIP (0.001s) [279.556405] Starting dynamic subtest: bcs0 [279.558866] Dynamic subtest bcs0: SKIP (0.000s) [279.583172] Starting dynamic subtest: vcs0 [279.586040] Dynamic subtest vcs0: SKIP (0.000s) [279.588458] Subtest semaphore-busy: SKIP (0.006s) [279.677150] [086/133] (760s left) gem_exec_schedule (pi-common) [279.744004] Subtest pi-common: SKIP (0.000s) [279.977799] [087/133] (760s left) i915_hangman (engine-error-state-capture) [280.037173] Subtest engine-error-state-capture: SKIP (0.000s) [280.123562] [088/133] (760s left) syncobj_timeline (wait-for-submit-snapshot) [280.183346] Starting subtest: wait-for-submit-snapshot [280.266613] Subtest wait-for-submit-snapshot: SUCCESS (0.083s) [280.396731] [089/133] (760s left) kms_color (ctm-blue-to-red) [280.886843] Starting subtest: ctm-blue-to-red [280.888186] Starting dynamic subtest: pipe-A-HDMI-A-1 [281.355238] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.469s) [281.372112] Starting dynamic subtest: pipe-B-HDMI-A-1 [281.850445] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.493s) [281.851615] Subtest ctm-blue-to-red: SUCCESS (0.966s) [282.578019] [090/133] (758s left) prime_vgem (basic-gtt) [282.646848] Starting subtest: basic-gtt [282.660083] Subtest basic-gtt: SUCCESS (0.013s) [282.809953] [091/133] (758s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt) [283.299368] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt [283.301467] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [283.907913] [092/133] (757s left) api_intel_allocator (default-alignment) [283.963306] Starting subtest: default-alignment [283.966323] Subtest default-alignment: SUCCESS (0.005s) [284.125062] [093/133] (756s left) i915_pm_rps (fence-order) [284.186066] Starting subtest: fence-order [285.471025] Subtest fence-order: SUCCESS (1.284s) [285.661615] [094/133] (755s left) kms_vblank (query-busy) [286.142544] Starting subtest: query-busy [286.143914] Starting dynamic subtest: pipe-A-HDMI-A-1 [288.527843] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.384s) [288.545170] Starting dynamic subtest: pipe-B-HDMI-A-1 [290.952287] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.422s) [290.953379] Subtest query-busy: SUCCESS (4.811s) [291.682253] [095/133] (749s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0) [292.174052] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0 [292.176256] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s) [292.788527] [096/133] (748s left) kms_addfb_basic (invalid-get-prop-any) [292.844555] Starting subtest: invalid-get-prop-any [292.845617] Subtest invalid-get-prop-any: SUCCESS (0.000s) [293.873942] [097/133] (747s left) kms_psr (fbc-psr2-cursor-mmap-gtt) [294.354714] Subtest fbc-psr2-cursor-mmap-gtt: SKIP (0.000s) [294.651760] [098/133] (746s left) kms_flip (2x-blocking-absolute-wf_vblank) [295.138110] Starting subtest: 2x-blocking-absolute-wf_vblank [295.139188] Starting dynamic subtest: AB-VGA1-HDMI-A1 [325.585020] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (30.437s) [325.588798] Subtest 2x-blocking-absolute-wf_vblank: SUCCESS (30.442s) [326.398912] [099/133] (714s left) kms_cursor_crc (cursor-onscreen-256x85) [326.888752] Starting subtest: cursor-onscreen-256x85 [326.950475] Subtest cursor-onscreen-256x85: SKIP (0.055s) [327.563039] [100/133] (713s left) kms_flip (2x-modeset-vs-vblank-race) [328.052423] Starting subtest: 2x-modeset-vs-vblank-race [328.053518] Starting dynamic subtest: AB-VGA1-HDMI-A1 [338.783116] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (10.727s) [338.786507] Subtest 2x-modeset-vs-vblank-race: SUCCESS (10.731s) [339.614068] [101/133] (701s left) kms_atomic_interruptible (atomic-setmode) [340.115233] Starting subtest: atomic-setmode [340.118327] Starting dynamic subtest: pipe-A-HDMI-A-1 [346.420799] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.301s) [346.421919] Subtest atomic-setmode: SUCCESS (6.304s) [347.140898] [102/133] (694s left) kms_frontbuffer_tracking (psr-argb161616f-draw-render) [347.630662] Starting subtest: psr-argb161616f-draw-render [347.632796] Subtest psr-argb161616f-draw-render: SKIP (0.000s) [348.256593] [103/133] (693s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt) [348.753803] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt [348.756115] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [349.359643] [104/133] (692s left) kms_plane_scaling (invalid-num-scalers) [349.841506] Starting subtest: invalid-num-scalers [349.843565] Subtest invalid-num-scalers: SKIP (0.002s) [350.450988] [105/133] (691s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt) [350.942704] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt [350.946428] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [351.552077] [106/133] (690s left) sw_sync (alloc_fence_invalid_timeline) [351.607822] Starting subtest: alloc_fence_invalid_timeline [351.608869] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s) [351.732416] [107/133] (690s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted) [351.788334] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted [351.896588] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.107s) [352.033991] [108/133] (689s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible) [352.520939] Starting subtest: flip-vs-absolute-wf_vblank-interruptible [352.523930] Starting dynamic subtest: A-VGA1 [360.550048] Dynamic subtest A-VGA1: SUCCESS (8.024s) [360.567772] Starting dynamic subtest: B-VGA1 [368.543101] Dynamic subtest B-VGA1: SUCCESS (7.987s) [368.561131] Starting dynamic subtest: A-HDMI-A1 [376.689868] Dynamic subtest A-HDMI-A1: SUCCESS (8.154s) [376.708550] Starting dynamic subtest: B-HDMI-A1 [384.863989] Dynamic subtest B-HDMI-A1: SUCCESS (8.180s) [384.868194] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (32.358s) [385.669234] [109/133] (656s left) kms_addfb_basic (size-max) [386.152832] Starting subtest: size-max [386.153801] Subtest size-max: SUCCESS (0.000s) [386.766835] [110/133] (655s left) kms_cursor_crc (cursor-rapid-movement-256x256) [387.254967] Starting subtest: cursor-rapid-movement-256x256 [387.257845] Starting dynamic subtest: pipe-A-HDMI-A-1 [387.593333] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.336s) [387.635879] Starting dynamic subtest: pipe-B-HDMI-A-1 [387.981875] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.361s) [387.982798] Subtest cursor-rapid-movement-256x256: SUCCESS (0.728s) [388.726687] [111/133] (653s left) gem_exec_whisper (basic-queues-all) [388.800996] Starting subtest: basic-queues-all [388.804726] Subtest basic-queues-all: SKIP (0.002s) [389.042759] [112/133] (653s left) kms_dsc (dsc-fractional-bpp) [389.529194] Subtest dsc-fractional-bpp: SKIP (0.000s) [389.836879] [113/133] (652s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling) [389.893578] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.000s) [389.951128] [114/133] (652s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc) [390.442058] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc [390.444290] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [391.060018] [115/133] (651s left) gem_softpin (evict-prime) [391.122635] Subtest evict-prime: SKIP (0.000s) [391.251156] [116/133] (651s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt) [391.741519] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt [391.743625] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [392.346952] [117/133] (650s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [392.836926] Starting subtest: addfb25-x-tiled-mismatch-legacy [392.837987] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s) [393.449960] [118/133] (649s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa [393.506734] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled [393.608393] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.101s) [393.750057] [119/133] (648s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt) [394.238600] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt [394.240715] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [394.843300] [120/133] (647s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move) [395.332509] Starting subtest: fbc-1p-primscrn-cur-indfb-move [397.681543] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (2.352s) [398.333917] [121/133] (644s left) gem_mmap_wc (bad-size) [398.390780] Starting subtest: bad-size [398.391822] Subtest bad-size: SUCCESS (0.001s) [398.532644] [122/133] (644s left) kms_hdr (static-toggle-suspend) [399.016398] Starting subtest: static-toggle-suspend [399.019691] Subtest static-toggle-suspend: SKIP (0.000s) [399.628137] [123/133] (643s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-pgflip-blt) [400.117560] Starting subtest: fbc-2p-primscrn-shrfb-pgflip-blt [400.119621] Subtest fbc-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [400.728103] [124/133] (642s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf) [401.218666] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s) [401.520264] [125/133] (641s left) kms_frontbuffer_tracking (fbcpsr-1p-indfb-fliptrack-mmap-gtt) [402.014093] Starting subtest: fbcpsr-1p-indfb-fliptrack-mmap-gtt [402.016469] Subtest fbcpsr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [402.622091] [126/133] (640s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs) [402.676293] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SKIP (0.000s) [402.735991] [127/133] (640s left) syncobj_timeline (single-wait-all-available-submitted) [402.791229] Starting subtest: single-wait-all-available-submitted [402.792611] Subtest single-wait-all-available-submitted: SUCCESS (0.000s) [402.921926] [128/133] (640s left) gem_exec_parallel (userptr) [402.987306] Starting subtest: userptr [402.988443] Starting dynamic subtest: rcs0 [404.597560] Dynamic subtest rcs0: SUCCESS (1.610s) [404.626926] Starting dynamic subtest: bcs0 [406.202646] Dynamic subtest bcs0: SUCCESS (1.603s) [406.207895] Subtest userptr: SUCCESS (3.218s) [406.448618] [129/133] (636s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render) [406.936616] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render [406.939103] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [407.543942] [130/133] (635s left) i915_selftest (mock) [408.504844] Starting subtest: mock [408.505902] Starting dynamic subtest: sanitycheck [409.728700] Dynamic subtest sanitycheck: SUCCESS (1.223s) [409.751281] Starting dynamic subtest: shmem [410.914635] Dynamic subtest shmem: SUCCESS (1.184s) [410.930768] Starting dynamic subtest: fence [419.315781] Dynamic subtest fence: SUCCESS (8.401s) [419.331049] Starting dynamic subtest: scatterlist [421.502987] Dynamic subtest scatterlist: SUCCESS (2.185s) [421.519207] Starting dynamic subtest: syncmap [424.682677] Dynamic subtest syncmap: SUCCESS (3.179s) [424.699057] Starting dynamic subtest: uncore [425.853483] Dynamic subtest uncore: SUCCESS (1.169s) [425.870316] Starting dynamic subtest: ring [427.030588] Dynamic subtest ring: SUCCESS (1.175s) [427.047205] Starting dynamic subtest: engine [428.169509] Dynamic subtest engine: SUCCESS (1.137s) [428.185751] Starting dynamic subtest: timelines [434.474655] Dynamic subtest timelines: SUCCESS (6.304s) [434.491212] Starting dynamic subtest: requests [437.832584] Dynamic subtest requests: SUCCESS (3.356s) [437.848645] Starting dynamic subtest: objects [439.150671] Dynamic subtest objects: SUCCESS (1.316s) [439.167748] Starting dynamic subtest: phys [440.389755] Dynamic subtest phys: SUCCESS (1.237s) [440.406667] Starting dynamic subtest: dmabuf [441.647733] Dynamic subtest dmabuf: SUCCESS (1.256s) [441.662365] Starting dynamic subtest: vma [453.336652] Dynamic subtest vma: SUCCESS (11.687s) [453.353085] Starting dynamic subtest: evict [455.923525] Dynamic subtest evict: SUCCESS (2.585s) [455.939834] Starting dynamic subtest: gtt [460.232548] Dynamic subtest gtt: SUCCESS (4.307s) [460.254272] Starting dynamic subtest: hugepages [461.808385] Dynamic subtest hugepages: SUCCESS (1.573s) [461.823940] Starting dynamic subtest: memory_region [467.045564] Dynamic subtest memory_region: SUCCESS (5.235s) [467.046692] Subtest mock: SUCCESS (58.545s) [467.087959] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [467.089505] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true [467.092329] [131/133] (576s left) gem_mmap_gtt (basic-write-read) [469.275052] Starting subtest: basic-write-read [469.290933] Subtest basic-write-read: SUCCESS (0.017s) [469.366178] [FACT gem_mmap_gtt (basic-write-read)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [469.367817] [FACT gem_mmap_gtt (basic-write-read)] new: kernel.kmod_is_loaded.i915: true [469.371802] [132/133] (573s left) perf (gen12-group-exclusive-stream-sample-oa) [469.547298] Subtest gen12-group-exclusive-stream-sample-oa: SKIP (0.000s) [469.602872] [133/133] (573s left) perf_pmu (busy-double-start) [469.663056] Starting subtest: busy-double-start [469.664222] Starting dynamic subtest: rcs0 [473.202018] Dynamic subtest rcs0: SUCCESS (3.538s) [473.219851] Starting dynamic subtest: bcs0 [476.723969] Dynamic subtest bcs0: SUCCESS (3.519s) [476.742398] Starting dynamic subtest: vcs0 [480.740043] Dynamic subtest vcs0: SUCCESS (4.013s) [480.741393] Subtest busy-double-start: SUCCESS (11.077s) [480.865749] Closing watchdogs results: parsing output: 0/ for test: gem_partial_pwrite_pread results: parsing output: 1/ for test: kms_content_protection results: parsing output: 2/ for test: kms_rotation_crc results: parsing output: 3/ for test: kms_chamelium_color results: parsing output: 4/ for test: syncobj_wait results: parsing output: 5/ for test: kms_pipe_crc_basic results: parsing output: 6/ for test: gem_set_tiling_vs_blt results: parsing output: 7/ for test: syncobj_wait results: parsing output: 8/ for test: syncobj_wait results: parsing output: 9/ for test: gem_pxp results: parsing output: 10/ for test: kms_cursor_legacy results: parsing output: 11/ for test: kms_rotation_crc results: parsing output: 12/ for test: syncobj_wait results: parsing output: 13/ for test: kms_ccs results: parsing output: 14/ for test: gem_softpin results: parsing output: 15/ for test: kms_frontbuffer_tracking results: parsing output: 16/ for test: gem_ctx_param results: parsing output: 17/ for test: syncobj_wait results: parsing output: 18/ for test: kms_big_fb results: parsing output: 19/ for test: gem_mmap_gtt results: parsing output: 20/ for test: kms_psr results: parsing output: 21/ for test: kms_big_fb results: parsing output: 22/ for test: kms_flip results: parsing output: 23/ for test: kms_plane_cursor results: parsing output: 24/ for test: kms_cdclk results: parsing output: 25/ for test: gem_exec_balancer results: parsing output: 26/ for test: kms_cursor_legacy results: parsing output: 27/ for test: kms_flip_scaled_crc results: parsing output: 28/ for test: kms_flip_scaled_crc results: parsing output: 29/ for test: core_getstats results: parsing output: 30/ for test: kms_rmfb results: parsing output: 31/ for test: gem_exec_reloc results: parsing output: 32/ for test: kms_properties results: parsing output: 33/ for test: kms_invalid_mode results: parsing output: 34/ for test: kms_plane_scaling results: parsing output: 35/ for test: kms_pm_rpm results: parsing output: 36/ for test: kms_frontbuffer_tracking results: parsing output: 37/ for test: kms_dirtyfb results: parsing output: 38/ for test: kms_cursor_legacy results: parsing output: 39/ for test: syncobj_timeline results: parsing output: 40/ for test: kms_prime results: parsing output: 41/ for test: kms_pipe_b_c_ivb results: parsing output: 42/ for test: i915_drm_fdinfo results: parsing output: 43/ for test: gem_userptr_blits results: parsing output: 44/ for test: kms_big_fb results: parsing output: 45/ for test: kms_ccs results: parsing output: 46/ for test: kms_scaling_modes results: parsing output: 47/ for test: kms_psr results: parsing output: 48/ for test: gem_ringfill results: parsing output: 49/ for test: gem_exec_whisper results: parsing output: 50/ for test: api_intel_bb results: parsing output: 51/ for test: kms_cursor_crc results: parsing output: 52/ for test: kms_ccs results: parsing output: 53/ for test: gen9_exec_parse results: parsing output: 54/ for test: kms_frontbuffer_tracking results: parsing output: 55/ for test: kms_big_fb results: parsing output: 56/ for test: gem_exec_fence results: parsing output: 57/ for test: kms_psr results: parsing output: 58/ for test: kms_frontbuffer_tracking results: parsing output: 59/ for test: gem_ctx_bad_destroy results: parsing output: 60/ for test: syncobj_timeline results: parsing output: 61/ for test: kms_chamelium_hpd results: parsing output: 62/ for test: kms_frontbuffer_tracking results: parsing output: 63/ for test: gem_cs_tlb results: parsing output: 64/ for test: gem_mmap_gtt results: parsing output: 65/ for test: kms_psr results: parsing output: 66/ for test: kms_big_fb results: parsing output: 67/ for test: kms_big_fb results: parsing output: 68/ for test: gem_bad_reloc results: parsing output: 69/ for test: gem_ctx_persistence results: parsing output: 70/ for test: kms_plane_scaling results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: gem_exec_schedule results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: kms_big_fb results: parsing output: 76/ for test: gem_exec_basic results: parsing output: 77/ for test: kms_frontbuffer_tracking results: parsing output: 78/ for test: gem_mmap results: parsing output: 79/ for test: gem_exec_reloc results: parsing output: 80/ for test: gem_ctx_shared results: parsing output: 81/ for test: gem_exec_reloc results: parsing output: 82/ for test: gem_eio results: parsing output: 83/ for test: gem_ctx_persistence results: parsing output: 84/ for test: perf_pmu results: parsing output: 85/ for test: gem_exec_schedule results: parsing output: 86/ for test: i915_hangman results: parsing output: 87/ for test: syncobj_timeline results: parsing output: 88/ for test: kms_color results: parsing output: 89/ for test: prime_vgem results: parsing output: 90/ for test: kms_frontbuffer_tracking results: parsing output: 91/ for test: api_intel_allocator results: parsing output: 92/ for test: i915_pm_rps results: parsing output: 93/ for test: kms_vblank results: parsing output: 94/ for test: kms_big_fb results: parsing output: 95/ for test: kms_addfb_basic results: parsing output: 96/ for test: kms_psr results: parsing output: 97/ for test: kms_flip results: parsing output: 98/ for test: kms_cursor_crc results: parsing output: 99/ for test: kms_flip results: parsing output: 100/ for test: kms_atomic_interruptible results: parsing output: 101/ for test: kms_frontbuffer_tracking results: parsing output: 102/ for test: kms_frontbuffer_tracking results: parsing output: 103/ for test: kms_plane_scaling results: parsing output: 104/ for test: kms_frontbuffer_tracking results: parsing output: 105/ for test: sw_sync results: parsing output: 106/ for test: syncobj_timeline results: parsing output: 107/ for test: kms_flip results: parsing output: 108/ for test: kms_addfb_basic results: parsing output: 109/ for test: kms_cursor_crc results: parsing output: 110/ for test: gem_exec_whisper results: parsing output: 111/ for test: kms_dsc results: parsing output: 112/ for test: kms_flip_scaled_crc results: parsing output: 113/ for test: kms_frontbuffer_tracking results: parsing output: 114/ for test: gem_softpin results: parsing output: 115/ for test: kms_frontbuffer_tracking results: parsing output: 116/ for test: kms_addfb_basic results: parsing output: 117/ for test: syncobj_timeline results: parsing output: 118/ for test: kms_frontbuffer_tracking results: parsing output: 119/ for test: kms_frontbuffer_tracking results: parsing output: 120/ for test: gem_mmap_wc results: parsing output: 121/ for test: kms_hdr results: parsing output: 122/ for test: kms_frontbuffer_tracking results: parsing output: 123/ for test: kms_psr2_sf results: parsing output: 124/ for test: kms_frontbuffer_tracking results: parsing output: 125/ for test: kms_ccs results: parsing output: 126/ for test: syncobj_timeline results: parsing output: 127/ for test: gem_exec_parallel results: parsing output: 128/ for test: kms_frontbuffer_tracking results: parsing output: 129/ for test: i915_selftest results: parsing output: 130/ for test: gem_mmap_gtt results: parsing output: 131/ for test: perf results: parsing output: 132/ for test: perf_pmu Done.