[133.363302] Initializing watchdogs [133.363474] /dev/watchdog0 [133.402198] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600] [133.416758] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [133.423711] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [133.432042] [001/133] (960s left) syncobj_timeline (invalid-single-wait-unsubmitted) [133.558806] Starting subtest: invalid-single-wait-unsubmitted [133.562795] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.001s) [133.702065] [002/133] (960s left) kms_flip (nonexisting-fb-interruptible) [133.901180] Starting subtest: nonexisting-fb-interruptible [133.906291] Starting dynamic subtest: A-HDMI-A1 [134.572281] Dynamic subtest A-HDMI-A1: SUCCESS (0.673s) [134.606114] Starting dynamic subtest: B-HDMI-A1 [134.962937] Dynamic subtest B-HDMI-A1: SUCCESS (0.387s) [134.996666] Starting dynamic subtest: C-HDMI-A1 [135.342110] Dynamic subtest C-HDMI-A1: SUCCESS (0.376s) [135.374732] Starting dynamic subtest: A-HDMI-A2 [135.742111] Dynamic subtest A-HDMI-A2: SUCCESS (0.399s) [135.776070] Starting dynamic subtest: B-HDMI-A2 [136.165060] Dynamic subtest B-HDMI-A2: SUCCESS (0.391s) [136.191291] Starting dynamic subtest: C-HDMI-A2 [136.530074] Dynamic subtest C-HDMI-A2: SUCCESS (0.390s) [136.534479] Subtest nonexisting-fb-interruptible: SUCCESS (2.631s) [137.023556] [003/133] (957s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb) [137.230142] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s) [137.329355] [004/133] (956s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary) [137.539264] Starting subtest: fbcpsr-shrfb-scaledprimary [137.545433] Subtest fbcpsr-shrfb-scaledprimary: SKIP (0.000s) [137.670839] [005/133] (956s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible) [137.873070] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible [137.882819] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2 [148.771458] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (10.892s) [148.793441] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2 [159.639342] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (10.864s) [159.659359] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2 [170.491496] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (10.844s) [170.494629] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SUCCESS (32.613s) [171.067259] [006/133] (923s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs) [171.259468] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs [171.263503] Starting dynamic subtest: pipe-A-HDMI-A-1 [171.313396] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s) [171.344405] Starting dynamic subtest: pipe-A-HDMI-A-2 [171.391074] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s) [171.409503] Starting dynamic subtest: pipe-B-HDMI-A-1 [171.442228] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s) [171.460519] Starting dynamic subtest: pipe-B-HDMI-A-2 [171.492989] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s) [171.511040] Starting dynamic subtest: pipe-C-HDMI-A-1 [171.543380] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s) [171.561489] Starting dynamic subtest: pipe-C-HDMI-A-2 [171.593725] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.001s) [171.599799] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SKIP (0.018s) [172.237035] [007/133] (922s left) kms_psr (psr2-sprite-mmap-gtt) [172.445104] Subtest psr2-sprite-mmap-gtt: SKIP (0.000s) [172.546559] [008/133] (922s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted) [172.661078] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted [172.765281] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.102s) [172.902309] [009/133] (921s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render) [173.103397] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render [173.110826] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [173.236915] [010/133] (921s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip) [173.460162] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip [173.467329] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s) [173.633286] [011/133] (921s left) gem_exec_flush (basic-wb-set-default) [173.771299] Starting subtest: basic-wb-set-default [179.185754] Subtest basic-wb-set-default: SUCCESS (5.418s) [179.435379] [012/133] (915s left) kms_selftest (drm_format_helper) [179.541879] Starting subtest: drm_format_helper [179.563768] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8 [179.631766] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.066s) [179.651755] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332 [179.687059] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.058s) [179.707031] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565 [179.753511] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.067s) [179.772977] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555 [179.820126] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.062s) [179.839838] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555 [179.875234] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.056s) [179.894824] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551 [179.931200] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.055s) [179.951527] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888 [179.974928] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.044s) [179.996334] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888 [180.030363] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.053s) [180.050166] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888 [180.083634] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.053s) [180.105173] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010 [180.136761] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.053s) [180.155969] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010 [180.197573] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.059s) [180.216946] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono [180.255058] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.058s) [180.274108] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab [180.319545] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.061s) [180.338998] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888 [180.379404] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.060s) [180.399049] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888 [180.434661] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.054s) [180.454529] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset [180.493090] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.056s) [180.512330] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy [180.544079] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.053s) [180.547057] Subtest drm_format_helper: SUCCESS (1.000s) [180.718961] [013/133] (914s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size) [180.899784] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size [192.345088] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SUCCESS (11.327s) [193.089776] [014/133] (902s left) api_intel_allocator (open-vm) [193.675942] Starting subtest: open-vm [193.679205] Subtest open-vm: SUCCESS (0.004s) [193.764078] [015/133] (901s left) gem_ccs (block-copy-compressed) [193.891388] Subtest block-copy-compressed: SKIP (0.000s) [194.000669] [016/133] (901s left) gem_exec_schedule (fairslice) [194.161134] Starting subtest: fairslice [194.164526] Starting dynamic subtest: rcs0 [196.190091] Dynamic subtest rcs0: SUCCESS (2.030s) [196.209136] Starting dynamic subtest: bcs0 [198.226079] Dynamic subtest bcs0: SUCCESS (2.033s) [198.247472] Starting dynamic subtest: vcs0 [200.265517] Dynamic subtest vcs0: SUCCESS (2.035s) [200.284169] Starting dynamic subtest: vecs0 [202.288920] Dynamic subtest vecs0: SUCCESS (2.028s) [202.292991] Subtest fairslice: SUCCESS (8.137s) [202.671817] [017/133] (893s left) gem_exec_balancer (parallel-bb-first) [202.924694] Subtest parallel-bb-first: SKIP (0.000s) [203.073123] [018/133] (892s left) i915_module_load (reload) [203.183254] Starting subtest: reload [207.157977] Subtest reload: SUCCESS (3.978s) [207.324904] [019/133] (888s left) perf_pmu (idle) [207.458102] Starting subtest: idle [207.464450] Starting dynamic subtest: rcs0 [207.990997] Dynamic subtest rcs0: SUCCESS (0.524s) [208.011775] Starting dynamic subtest: bcs0 [208.498841] Dynamic subtest bcs0: SUCCESS (0.511s) [208.519200] Starting dynamic subtest: vcs0 [209.015122] Dynamic subtest vcs0: SUCCESS (0.515s) [209.040548] Starting dynamic subtest: vecs0 [209.536153] Dynamic subtest vecs0: SUCCESS (0.514s) [209.539484] Subtest idle: SUCCESS (2.079s) [209.679942] [020/133] (886s left) perf_pmu (all-busy-idle-check-all) [209.801094] Starting subtest: all-busy-idle-check-all [210.428092] Subtest all-busy-idle-check-all: SUCCESS (0.626s) [210.592365] [021/133] (885s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf) [210.788030] Subtest psr2-cursor-plane-move-continuous-sf: SKIP (0.000s) [210.891584] [022/133] (885s left) gem_userptr_blits (unsync-unmap-cycles) [211.030388] Subtest unsync-unmap-cycles: SKIP (0.000s) [211.200227] [023/133] (885s left) dmabuf_sync_file (export-multiwait) [211.389246] Starting subtest: export-multiwait [211.393311] Subtest export-multiwait: SUCCESS (0.004s) [211.513822] [FACT dmabuf_sync_file (export-multiwait)] new: kernel.kmod_is_loaded.vgem: true [211.520912] [024/133] (885s left) kms_chamelium_frames (dp-crc-single) [212.279077] Subtest dp-crc-single: SKIP (0.000s) [212.805666] [025/133] (884s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted) [213.271619] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted [213.420422] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.104s) [213.514964] [026/133] (883s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt) [213.729163] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt [216.149077] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SUCCESS (2.424s) [216.414885] [027/133] (880s left) syncobj_timeline (single-wait-all-for-submit-signaled) [216.524703] Starting subtest: single-wait-all-for-submit-signaled [216.527901] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.002s) [216.677105] [028/133] (880s left) kms_color_pipeline (plane-ctm3x4-lut1d) [216.860555] Starting subtest: plane-ctm3x4-lut1d [218.508528] Subtest plane-ctm3x4-lut1d: SKIP (1.639s) [218.854115] [029/133] (878s left) api_intel_bb (reset-bb) [218.970522] Starting subtest: reset-bb [218.973759] Subtest reset-bb: SUCCESS (0.007s) [219.116844] [030/133] (878s left) gem_partial_pwrite_pread (reads-snoop) [219.237238] Starting subtest: reads-snoop [225.982752] Subtest reads-snoop: SUCCESS (6.745s) [226.157321] [031/133] (871s left) gem_ctx_shared (single-timeline) [226.301374] Starting subtest: single-timeline [226.324361] Subtest single-timeline: SUCCESS (0.014s) [226.942454] [032/133] (871s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu) [227.597662] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu [229.715807] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (2.480s) [230.042416] [033/133] (868s left) kms_content_protection (type1) [230.256046] Starting subtest: type1 [230.293187] Subtest type1: SKIP (0.029s) [230.439546] [034/133] (867s left) perf_pmu (busy-check-all) [230.558754] Starting subtest: busy-check-all [230.563697] Starting dynamic subtest: rcs0 [231.101619] Dynamic subtest rcs0: SUCCESS (0.534s) [231.126609] Starting dynamic subtest: bcs0 [231.638800] Dynamic subtest bcs0: SUCCESS (0.532s) [231.661388] Starting dynamic subtest: vcs0 [232.170211] Dynamic subtest vcs0: SUCCESS (0.532s) [232.194427] Starting dynamic subtest: vecs0 [232.706433] Dynamic subtest vecs0: SUCCESS (0.529s) [232.711051] Subtest busy-check-all: SUCCESS (2.139s) [232.879837] [035/133] (865s left) syncobj_wait (invalid-wait-illegal-handle) [232.995166] Starting subtest: invalid-wait-illegal-handle [232.999751] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s) [233.149518] [036/133] (865s left) kms_psr (fbc-pr-suspend) [233.337088] Subtest fbc-pr-suspend: SKIP (0.000s) [233.460123] [037/133] (865s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite) [233.677910] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite [233.685708] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [233.834106] [038/133] (864s left) kms_cursor_edge_walk (64x64-right-edge) [234.024125] Starting subtest: 64x64-right-edge [234.028279] Starting dynamic subtest: pipe-A-HDMI-A-1 [237.896606] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.868s) [237.946409] Starting dynamic subtest: pipe-C-HDMI-A-1 [241.315643] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.408s) [241.319648] Subtest 64x64-right-edge: SUCCESS (7.290s) [241.615092] [039/133] (857s left) kms_psr (pr-cursor-blt) [241.827093] Subtest pr-cursor-blt: SKIP (0.000s) [241.950231] [040/133] (857s left) gem_mmap_gtt (cpuset-basic-small-copy) [242.058648] Starting subtest: cpuset-basic-small-copy [246.495304] Subtest cpuset-basic-small-copy: SUCCESS (4.436s) [246.695089] [041/133] (852s left) gem_exec_reloc (basic-gtt-noreloc) [246.954099] Starting subtest: basic-gtt-noreloc [246.963255] Subtest basic-gtt-noreloc: SUCCESS (0.012s) [247.215871] [042/133] (852s left) kms_fb_coherency (memset-crc) [247.426170] Starting subtest: memset-crc [247.431411] Starting dynamic subtest: mmap-gtt [248.228207] Dynamic subtest mmap-gtt: SUCCESS (0.806s) [248.502870] Starting dynamic subtest: mmap-offset-wc [248.847049] Dynamic subtest mmap-offset-wc: SUCCESS (0.392s) [249.110180] Starting dynamic subtest: mmap-offset-uc [249.889332] Dynamic subtest mmap-offset-uc: SUCCESS (0.819s) [250.153215] Starting dynamic subtest: mmap-legacy-wc [250.512133] Dynamic subtest mmap-legacy-wc: SUCCESS (0.404s) [250.740345] Subtest memset-crc: SUCCESS (3.313s) [251.046173] [043/133] (848s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation) [251.241999] Starting subtest: plane-upscale-factor-0-25-with-rotation [251.247369] Starting dynamic subtest: pipe-A [255.126183] Dynamic subtest pipe-A: SKIP (3.885s) [255.176591] Starting dynamic subtest: pipe-B [259.401229] Dynamic subtest pipe-B: SKIP (4.267s) [259.432177] Starting dynamic subtest: pipe-C [264.940489] Dynamic subtest pipe-C: SKIP (5.536s) [264.948268] Subtest plane-upscale-factor-0-25-with-rotation: SKIP (13.697s) [265.535986] [044/133] (833s left) perf (non-sampling-read-error) [266.253357] Starting subtest: non-sampling-read-error [266.318254] Subtest non-sampling-read-error: SUCCESS (0.022s) [266.968383] [045/133] (833s left) gem_exec_schedule (reorder-wide) [267.491885] Starting subtest: reorder-wide [267.496572] Starting dynamic subtest: rcs0 [267.663132] Dynamic subtest rcs0: SUCCESS (0.167s) [267.724106] Starting dynamic subtest: bcs0 [268.019509] Dynamic subtest bcs0: SUCCESS (0.338s) [268.065088] Starting dynamic subtest: vcs0 [268.193352] Dynamic subtest vcs0: SUCCESS (0.171s) [268.218102] Starting dynamic subtest: vecs0 [268.382042] Dynamic subtest vecs0: SUCCESS (0.186s) [268.390909] Subtest reorder-wide: SUCCESS (0.899s) [268.671398] [046/133] (831s left) vgem_basic (dmabuf-export) [268.810796] Starting subtest: dmabuf-export [268.817543] Subtest dmabuf-export: SUCCESS (0.006s) [268.970508] [047/133] (831s left) kms_frontbuffer_tracking (fbc-2p-rte) [269.199885] Starting subtest: fbc-2p-rte [273.648045] Subtest fbc-2p-rte: SUCCESS (4.459s) [273.906365] [048/133] (826s left) kms_async_flips (async-flip-dpms) [274.118249] Starting subtest: async-flip-dpms [274.728144] Starting dynamic subtest: pipe-A-HDMI-A-1 [277.498046] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.767s) [277.913658] Starting dynamic subtest: pipe-A-HDMI-A-2 [280.078566] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.184s) [280.465113] Starting dynamic subtest: pipe-B-HDMI-A-1 [282.579788] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.137s) [282.945973] Starting dynamic subtest: pipe-B-HDMI-A-2 [285.052403] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.135s) [285.415979] Starting dynamic subtest: pipe-C-HDMI-A-1 [287.545497] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.155s) [287.888256] Starting dynamic subtest: pipe-C-HDMI-A-2 [290.037950] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.182s) [290.042825] Subtest async-flip-dpms: SUCCESS (15.926s) [290.706611] [049/133] (809s left) kms_big_fb (x-tiled-64bpp-rotate-90) [290.923086] Starting subtest: x-tiled-64bpp-rotate-90 [291.282800] Subtest x-tiled-64bpp-rotate-90: SKIP (0.356s) [291.574072] [050/133] (809s left) perf_pmu (invalid-init) [291.698068] Starting subtest: invalid-init [291.702395] Subtest invalid-init: SUCCESS (0.002s) [291.854335] [051/133] (808s left) gem_userptr_blits (dmabuf-sync) [292.003102] Starting subtest: dmabuf-sync [292.011106] Subtest dmabuf-sync: SKIP (0.008s) [292.231959] [052/133] (808s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt) [292.439857] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt [292.446735] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [292.588516] [053/133] (808s left) kms_psr (fbc-psr-dpms) [292.795064] Subtest fbc-psr-dpms: SKIP (0.000s) [292.915336] [054/133] (808s left) sysfs_timeslice_duration (invalid) [293.041369] Starting subtest: invalid [293.046084] Starting dynamic subtest: vecs0 [293.049382] Dynamic subtest vecs0: SUCCESS (0.001s) [293.082763] Starting dynamic subtest: vcs0 [293.088113] Dynamic subtest vcs0: SUCCESS (0.001s) [293.113580] Starting dynamic subtest: bcs0 [293.117973] Dynamic subtest bcs0: SUCCESS (0.001s) [293.142488] Starting dynamic subtest: rcs0 [293.146549] Dynamic subtest rcs0: SUCCESS (0.001s) [293.151352] Subtest invalid: SUCCESS (0.022s) [293.250344] [055/133] (807s left) kms_cursor_crc (cursor-onscreen-32x32) [293.457623] Starting subtest: cursor-onscreen-32x32 [293.714069] Subtest cursor-onscreen-32x32: SKIP (0.252s) [293.889249] [056/133] (807s left) gen9_exec_parse (bb-large) [294.023059] Starting subtest: bb-large [339.722885] Subtest bb-large: SUCCESS (45.700s) [340.025669] [057/133] (761s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff) [340.381371] Starting subtest: psr-2p-primscrn-cur-indfb-onoff [340.388175] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [340.541205] [058/133] (760s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite) [340.753520] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite [342.818930] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SUCCESS (2.075s) [343.091891] [059/133] (758s left) gem_exec_schedule (preempt-queue-contexts) [343.267595] Starting subtest: preempt-queue-contexts [343.271022] Starting dynamic subtest: rcs0 [344.097437] Dynamic subtest rcs0: SUCCESS (0.772s) [344.163203] Starting dynamic subtest: bcs0 [344.829305] Dynamic subtest bcs0: SUCCESS (0.780s) [344.854716] Starting dynamic subtest: vcs0 [345.619265] Dynamic subtest vcs0: SUCCESS (0.785s) [345.643525] Starting dynamic subtest: vecs0 [346.400417] Dynamic subtest vecs0: SUCCESS (0.776s) [346.403908] Subtest preempt-queue-contexts: SUCCESS (3.135s) [346.802708] [060/133] (754s left) gem_exec_balancer (sequential) [346.935080] Starting subtest: sequential [351.317659] Subtest sequential: SUCCESS (4.380s) [351.604364] [061/133] (750s left) gem_eio (wait-wedge-10ms) [351.755575] Starting subtest: wait-wedge-10ms [351.896079] Subtest wait-wedge-10ms: SUCCESS (0.152s) [352.153601] [062/133] (749s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt) [352.376738] Starting subtest: psr-farfromfence-mmap-gtt [352.383267] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s) [352.538705] [063/133] (749s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc) [352.725872] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc [352.730161] Starting dynamic subtest: pipe-A-HDMI-A-1 [352.770067] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.003s) [352.820411] Starting dynamic subtest: pipe-A-HDMI-A-2 [352.870423] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.003s) [352.914116] Starting dynamic subtest: pipe-B-HDMI-A-1 [352.946606] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.002s) [352.973087] Starting dynamic subtest: pipe-B-HDMI-A-2 [353.004563] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.002s) [353.029760] Starting dynamic subtest: pipe-C-HDMI-A-1 [353.060312] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s) [353.084720] Starting dynamic subtest: pipe-C-HDMI-A-2 [353.118917] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.004s) [353.124838] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.052s) [353.802496] [064/133] (748s left) kms_plane_alpha_blend (alpha-transparent-fb) [353.995191] Starting subtest: alpha-transparent-fb [354.161528] Starting dynamic subtest: pipe-A-HDMI-A-1 [355.631501] Dynamic subtest pipe-A-HDMI-A-1: FAIL (0.464s) [355.657326] Starting dynamic subtest: pipe-C-HDMI-A-1 [356.684535] Dynamic subtest pipe-C-HDMI-A-1: FAIL (1.323s) [356.688255] Subtest alpha-transparent-fb: FAIL (1.966s) [356.805432] [065/133] (745s left) gem_userptr_blits (sd-probe) [356.934961] Starting subtest: sd-probe [356.938127] Subtest sd-probe: SUCCESS (0.001s) [357.138822] [066/133] (745s left) kms_pm_rpm (pc8-residency) [359.130662] Starting subtest: pc8-residency [359.141207] Subtest pc8-residency: SKIP (0.000s) [359.545594] [067/133] (742s left) kms_big_fb (y-tiled-32bpp-rotate-270) [359.765086] Starting subtest: y-tiled-32bpp-rotate-270 [364.898571] Subtest y-tiled-32bpp-rotate-270: SUCCESS (5.136s) [365.342855] [068/133] (737s left) gem_lmem_swapping (massive) [365.467216] Subtest massive: SKIP (0.000s) [365.593937] [069/133] (737s left) i915_query (query-regions-unallocated) [365.702577] Starting subtest: query-regions-unallocated [365.705819] Subtest query-regions-unallocated: SUCCESS (0.000s) [365.854982] [070/133] (736s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs) [366.040127] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs [366.045074] Starting dynamic subtest: pipe-A-HDMI-A-1 [366.084115] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.002s) [366.136545] Starting dynamic subtest: pipe-A-HDMI-A-2 [366.188066] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.003s) [366.221246] Starting dynamic subtest: pipe-B-HDMI-A-1 [366.253265] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.003s) [366.278851] Starting dynamic subtest: pipe-B-HDMI-A-2 [366.310246] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.002s) [366.335099] Starting dynamic subtest: pipe-C-HDMI-A-1 [366.365798] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s) [366.395133] Starting dynamic subtest: pipe-C-HDMI-A-2 [366.426555] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.003s) [366.432792] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.046s) [367.120275] [071/133] (735s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [367.331836] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu [369.804152] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (2.475s) [370.003360] [072/133] (733s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling) [370.216534] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling [370.223322] Starting dynamic subtest: pipe-A-valid-mode [371.256738] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.934s) [371.322179] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SUCCESS (0.943s) [371.932056] [073/133] (731s left) i915_drm_fdinfo (memory-info-active) [372.488401] Starting subtest: memory-info-active [372.649082] Starting dynamic subtest: smem0 [373.305784] Dynamic subtest smem0: SUCCESS (1.041s) [373.310567] Subtest memory-info-active: SUCCESS (1.044s) [373.457587] [074/133] (730s left) kms_prop_blob (blob-prop-validate) [373.567310] Starting subtest: blob-prop-validate [373.570625] Subtest blob-prop-validate: SUCCESS (0.000s) [373.736230] [075/133] (730s left) syncobj_wait (single-wait-all-signaled) [373.851860] Starting subtest: single-wait-all-signaled [373.855534] Subtest single-wait-all-signaled: SUCCESS (0.001s) [374.005901] [076/133] (729s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move) [374.213080] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move [374.219141] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [374.452244] [077/133] (729s left) kms_pm_rpm (basic-rte) [374.561980] Starting subtest: basic-rte [376.754631] Subtest basic-rte: SUCCESS (2.184s) [377.661382] [078/133] (726s left) kms_plane (pixel-format-y-tiled-modifier) [377.865598] Starting subtest: pixel-format-y-tiled-modifier [378.102271] Starting dynamic subtest: pipe-A-plane-0 [378.934338] Dynamic subtest pipe-A-plane-0: SUCCESS (0.831s) [378.960360] Starting dynamic subtest: pipe-A-plane-1 [379.719105] Dynamic subtest pipe-A-plane-1: SUCCESS (0.780s) [379.744977] Starting dynamic subtest: pipe-A-plane-2 [380.282147] Dynamic subtest pipe-A-plane-2: SUCCESS (0.563s) [380.315575] Starting dynamic subtest: pipe-A-plane-3 [380.851099] Dynamic subtest pipe-A-plane-3: SUCCESS (0.563s) [380.879342] Starting dynamic subtest: pipe-A-plane-4 [380.888241] Dynamic subtest pipe-A-plane-4: SKIP (0.000s) [381.223481] Starting dynamic subtest: pipe-B-plane-0 [381.985459] Dynamic subtest pipe-B-plane-0: SUCCESS (0.782s) [382.011725] Starting dynamic subtest: pipe-B-plane-1 [382.770472] Dynamic subtest pipe-B-plane-1: SUCCESS (0.780s) [382.796198] Starting dynamic subtest: pipe-B-plane-2 [383.336526] Dynamic subtest pipe-B-plane-2: SUCCESS (0.563s) [383.362067] Starting dynamic subtest: pipe-B-plane-3 [383.899662] Dynamic subtest pipe-B-plane-3: SUCCESS (0.563s) [383.927156] Starting dynamic subtest: pipe-B-plane-4 [383.936307] Dynamic subtest pipe-B-plane-4: SKIP (0.000s) [384.125392] Subtest pixel-format-y-tiled-modifier: SUCCESS (6.256s) [384.439461] [079/133] (719s left) kms_addfb_basic (too-high) [384.638697] Starting subtest: too-high [384.641949] Subtest too-high: SUCCESS (0.002s) [384.803450] [080/133] (719s left) gem_ctx_param (get-priority-new-ctx) [384.922210] Starting subtest: get-priority-new-ctx [384.926125] Subtest get-priority-new-ctx: SUCCESS (0.001s) [385.084448] [081/133] (719s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite) [385.289147] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite [385.296928] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [385.437169] [082/133] (719s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt) [385.660421] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt [385.667539] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [385.822185] [083/133] (718s left) gem_create (hog-create) [385.951217] Starting subtest: hog-create [385.955244] Starting dynamic subtest: smem0 [418.199125] Dynamic subtest smem0: SUCCESS (32.252s) [418.202770] Subtest hog-create: SUCCESS (32.257s) [418.468986] [084/133] (686s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu) [418.674764] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu [421.562059] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (2.896s) [421.787433] [085/133] (683s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode) [422.337083] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s) [422.665582] [086/133] (682s left) i915_pm_rps (basic-api) [422.796061] Starting subtest: basic-api [422.811148] Subtest basic-api: SUCCESS (0.013s) [422.961130] [087/133] (682s left) kms_invalid_mode (bad-vsync-start) [423.158194] Starting subtest: bad-vsync-start [423.164227] Starting dynamic subtest: pipe-A-HDMI-A-1 [423.573077] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.417s) [423.636460] Starting dynamic subtest: pipe-A-HDMI-A-2 [423.641896] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.003s) [423.692022] Starting dynamic subtest: pipe-B-HDMI-A-1 [423.695779] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.002s) [423.744707] Starting dynamic subtest: pipe-B-HDMI-A-2 [423.748163] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.002s) [423.778255] Starting dynamic subtest: pipe-C-HDMI-A-1 [423.781784] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.002s) [423.815127] Starting dynamic subtest: pipe-C-HDMI-A-2 [423.820143] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.002s) [423.823359] Subtest bad-vsync-start: SUCCESS (0.466s) [423.960536] [088/133] (681s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render) [424.175891] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render [424.182085] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [424.339672] [089/133] (681s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled) [424.472882] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled [424.480976] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s) [424.739650] [090/133] (680s left) kms_chamelium_color (ctm-negative) [424.939075] Subtest ctm-negative: SKIP (0.000s) [425.065517] [091/133] (680s left) kms_plane (pixel-format-linear-modifier-source-clamping) [425.274061] Starting subtest: pixel-format-linear-modifier-source-clamping [425.499359] Starting dynamic subtest: pipe-A-plane-0 [429.062788] Dynamic subtest pipe-A-plane-0: SUCCESS (3.565s) [429.095457] Starting dynamic subtest: pipe-A-plane-1 [432.650326] Dynamic subtest pipe-A-plane-1: SUCCESS (3.580s) [432.676066] Starting dynamic subtest: pipe-A-plane-2 [434.201044] Dynamic subtest pipe-A-plane-2: SUCCESS (1.546s) [434.227340] Starting dynamic subtest: pipe-A-plane-3 [435.749299] Dynamic subtest pipe-A-plane-3: SUCCESS (1.547s) [436.144843] Starting dynamic subtest: pipe-B-plane-0 [439.671158] Dynamic subtest pipe-B-plane-0: SUCCESS (3.546s) [439.697230] Starting dynamic subtest: pipe-B-plane-1 [443.239782] Dynamic subtest pipe-B-plane-1: SUCCESS (3.563s) [443.265511] Starting dynamic subtest: pipe-B-plane-2 [444.788494] Dynamic subtest pipe-B-plane-2: SUCCESS (1.546s) [444.813747] Starting dynamic subtest: pipe-B-plane-3 [446.354976] Dynamic subtest pipe-B-plane-3: SUCCESS (1.563s) [446.576460] Subtest pixel-format-linear-modifier-source-clamping: SUCCESS (21.303s) [446.898525] [092/133] (658s left) gem_ctx_persistence (engines-cleanup) [447.039366] Starting subtest: engines-cleanup [447.043384] Starting dynamic subtest: rcs0 [447.062238] Dynamic subtest rcs0: SUCCESS (0.029s) [447.100722] Starting dynamic subtest: bcs0 [447.104246] Dynamic subtest bcs0: SUCCESS (0.023s) [447.130713] Starting dynamic subtest: vcs0 [447.135091] Dynamic subtest vcs0: SUCCESS (0.039s) [447.165179] Starting dynamic subtest: vecs0 [447.174883] Dynamic subtest vecs0: SUCCESS (0.033s) [447.178330] Subtest engines-cleanup: SUCCESS (0.141s) [447.357957] [093/133] (658s left) kms_cursor_crc (cursor-rapid-movement-512x512) [447.560392] Starting subtest: cursor-rapid-movement-512x512 [447.570334] Subtest cursor-rapid-movement-512x512: SKIP (0.003s) [447.715471] [094/133] (658s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling) [447.905687] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling [447.909096] Starting dynamic subtest: pipe-A-valid-mode [448.909702] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.992s) [448.915075] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (0.999s) [449.293131] [095/133] (656s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt) [449.515884] Starting subtest: psr-rgb565-draw-blt [449.534281] Subtest psr-rgb565-draw-blt: SKIP (0.000s) [449.679308] [096/133] (656s left) gem_exec_params (rel-constants-invalid) [449.804663] Starting subtest: rel-constants-invalid [449.808118] Subtest rel-constants-invalid: SUCCESS (0.000s) [449.960307] [097/133] (656s left) kms_rotation_crc (primary-y-tiled-reflect-x-90) [450.150032] Starting subtest: primary-y-tiled-reflect-x-90 [450.158371] Subtest primary-y-tiled-reflect-x-90: SKIP (0.003s) [450.311936] [098/133] (656s left) prime_busy (after) [450.429423] Starting subtest: after [450.445115] Starting dynamic subtest: rcs0 [450.457995] Dynamic subtest rcs0: SUCCESS (0.013s) [450.494153] Starting dynamic subtest: bcs0 [450.497457] Dynamic subtest bcs0: SUCCESS (0.011s) [450.525494] Starting dynamic subtest: vcs0 [450.529516] Dynamic subtest vcs0: SUCCESS (0.017s) [450.554810] Starting dynamic subtest: vecs0 [450.559306] Dynamic subtest vecs0: SUCCESS (0.012s) [450.620150] Subtest after: SUCCESS (0.190s) [450.779344] [099/133] (655s left) kms_rotation_crc (sprite-rotation-270) [450.965476] Starting subtest: sprite-rotation-270 [466.563140] Subtest sprite-rotation-270: SUCCESS (15.599s) [466.871358] [100/133] (639s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted) [466.990130] Starting subtest: multi-wait-all-for-submit-unsubmitted [467.091083] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.103s) [467.248860] [101/133] (639s left) gem_softpin (noreloc-s3) [467.369441] Starting subtest: noreloc-S3