[90.923119] Initializing watchdogs [90.923293] /dev/watchdog0 [90.961781] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3184 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 605] [90.976128] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [90.984651] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [90.991435] [001/133] (960s left) syncobj_timeline (invalid-single-wait-unsubmitted) [91.108231] Starting subtest: invalid-single-wait-unsubmitted [91.110149] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s) [91.250711] [002/133] (960s left) kms_flip (nonexisting-fb-interruptible) [91.432904] Starting subtest: nonexisting-fb-interruptible [91.436909] Starting dynamic subtest: A-HDMI-A1 [92.060119] Dynamic subtest A-HDMI-A1: SUCCESS (0.624s) [92.077067] Starting dynamic subtest: B-HDMI-A1 [92.394133] Dynamic subtest B-HDMI-A1: SUCCESS (0.331s) [92.410973] Starting dynamic subtest: C-HDMI-A1 [92.726533] Dynamic subtest C-HDMI-A1: SUCCESS (0.331s) [92.743380] Starting dynamic subtest: A-HDMI-A2 [93.066995] Dynamic subtest A-HDMI-A2: SUCCESS (0.341s) [93.083879] Starting dynamic subtest: B-HDMI-A2 [93.396783] Dynamic subtest B-HDMI-A2: SUCCESS (0.326s) [93.413621] Starting dynamic subtest: C-HDMI-A2 [93.723461] Dynamic subtest C-HDMI-A2: SUCCESS (0.326s) [93.725366] Subtest nonexisting-fb-interruptible: SUCCESS (2.290s) [94.161667] [003/133] (957s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb) [94.344455] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s) [94.436378] [004/133] (957s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary) [94.619277] Starting subtest: fbcpsr-shrfb-scaledprimary [94.622885] Subtest fbcpsr-shrfb-scaledprimary: SKIP (0.000s) [94.759963] [005/133] (957s left) kms_flip (2x-blocking-absolute-wf_vblank-interruptible) [94.938764] Starting subtest: 2x-blocking-absolute-wf_vblank-interruptible [94.942538] Starting dynamic subtest: AB-HDMI-A1-HDMI-A2 [105.601601] Dynamic subtest AB-HDMI-A1-HDMI-A2: SUCCESS (10.659s) [105.620582] Starting dynamic subtest: AC-HDMI-A1-HDMI-A2 [116.232932] Dynamic subtest AC-HDMI-A1-HDMI-A2: SUCCESS (10.627s) [116.252070] Starting dynamic subtest: BC-HDMI-A1-HDMI-A2 [126.858232] Dynamic subtest BC-HDMI-A1-HDMI-A2: SUCCESS (10.623s) [126.860106] Subtest 2x-blocking-absolute-wf_vblank-interruptible: SUCCESS (31.921s) [127.411134] [006/133] (924s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs) [127.590775] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs [127.592916] Starting dynamic subtest: pipe-A-HDMI-A-1 [127.610931] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s) [127.628791] Starting dynamic subtest: pipe-A-HDMI-A-2 [127.647787] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s) [127.665402] Starting dynamic subtest: pipe-B-HDMI-A-1 [127.683321] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s) [127.699449] Starting dynamic subtest: pipe-B-HDMI-A-2 [127.717210] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s) [127.733113] Starting dynamic subtest: pipe-C-HDMI-A-1 [127.750396] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s) [127.766506] Starting dynamic subtest: pipe-C-HDMI-A-2 [127.785072] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.000s) [127.788946] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SKIP (0.016s) [128.464418] [007/133] (923s left) kms_psr (psr2-sprite-mmap-gtt) [128.638646] Subtest psr2-sprite-mmap-gtt: SKIP (0.000s) [128.722833] [008/133] (923s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted) [128.822470] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted [128.930986] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.106s) [129.063389] [009/133] (923s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render) [129.249817] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render [129.253572] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [129.397678] [010/133] (922s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip) [129.588768] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip [129.592577] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s) [129.731548] [011/133] (922s left) gem_exec_flush (basic-wb-set-default) [129.856602] Starting subtest: basic-wb-set-default [135.305047] Subtest basic-wb-set-default: SUCCESS (5.446s) [135.546843] [012/133] (916s left) kms_selftest (drm_format_helper) [135.646455] Starting subtest: drm_format_helper [135.661965] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8 [135.739868] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.079s) [135.756891] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332 [135.806171] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.064s) [135.823579] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565 [135.863821] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.060s) [135.881553] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555 [135.936364] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.070s) [135.955539] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555 [136.007869] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.070s) [136.025485] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551 [136.077821] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.068s) [136.094638] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888 [136.141962] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.063s) [136.159365] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888 [136.216231] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.075s) [136.233585] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888 [136.279032] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.062s) [136.296403] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010 [136.351854] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.071s) [136.369419] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010 [136.414774] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.063s) [136.432468] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono [136.480184] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.066s) [136.497696] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab [136.550034] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.068s) [136.567470] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888 [136.617154] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.067s) [136.633755] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888 [136.682205] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.066s) [136.699519] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset [136.754943] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.070s) [136.772523] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy [136.833527] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.076s) [136.835443] Subtest drm_format_helper: SUCCESS (1.183s) [136.996535] [013/133] (915s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size) [137.168431] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size [148.417580] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SUCCESS (11.249s) [148.693394] [014/133] (903s left) api_intel_allocator (open-vm) [148.813420] Starting subtest: open-vm [148.816873] Subtest open-vm: SUCCESS (0.005s) [148.942545] [015/133] (903s left) gem_ccs (block-copy-compressed) [149.049980] Subtest block-copy-compressed: SKIP (0.000s) [149.150636] [016/133] (903s left) gem_exec_schedule (fairslice) [149.274839] Starting subtest: fairslice [149.276901] Starting dynamic subtest: rcs0 [151.305384] Dynamic subtest rcs0: SUCCESS (2.028s) [151.322847] Starting dynamic subtest: bcs0 [153.336344] Dynamic subtest bcs0: SUCCESS (2.030s) [153.354272] Starting dynamic subtest: vcs0 [155.365059] Dynamic subtest vcs0: SUCCESS (2.024s) [155.382622] Starting dynamic subtest: vecs0 [157.392392] Dynamic subtest vecs0: SUCCESS (2.026s) [157.395571] Subtest fairslice: SUCCESS (8.116s) [157.761148] [017/133] (895s left) gem_exec_balancer (parallel-bb-first) [157.999114] Subtest parallel-bb-first: SKIP (0.000s) [158.130167] [018/133] (894s left) i915_module_load (reload) [158.229301] Starting subtest: reload [162.067759] Subtest reload: SUCCESS (3.840s) [162.209239] [019/133] (890s left) perf_pmu (idle) [162.338205] Starting subtest: idle [162.340331] Starting dynamic subtest: rcs0 [162.862987] Dynamic subtest rcs0: SUCCESS (0.519s) [162.882542] Starting dynamic subtest: bcs0 [163.380467] Dynamic subtest bcs0: SUCCESS (0.518s) [163.399883] Starting dynamic subtest: vcs0 [163.898723] Dynamic subtest vcs0: SUCCESS (0.516s) [163.918386] Starting dynamic subtest: vecs0 [164.419512] Dynamic subtest vecs0: SUCCESS (0.518s) [164.421528] Subtest idle: SUCCESS (2.082s) [164.562201] [020/133] (888s left) perf_pmu (all-busy-idle-check-all) [164.666264] Starting subtest: all-busy-idle-check-all [165.302896] Subtest all-busy-idle-check-all: SUCCESS (0.634s) [165.427633] [021/133] (887s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf) [165.608013] Subtest psr2-cursor-plane-move-continuous-sf: SKIP (0.000s) [165.706173] [022/133] (887s left) gem_userptr_blits (unsync-unmap-cycles) [165.821905] Subtest unsync-unmap-cycles: SKIP (0.000s) [166.011035] [023/133] (887s left) dmabuf_sync_file (export-multiwait) [166.190155] Starting subtest: export-multiwait [166.192406] Subtest export-multiwait: SUCCESS (0.003s) [166.296249] [FACT dmabuf_sync_file (export-multiwait)] new: kernel.kmod_is_loaded.vgem: true [166.302972] [024/133] (887s left) kms_chamelium_frames (dp-crc-single) [166.853673] Subtest dp-crc-single: SKIP (0.000s) [167.112068] [025/133] (886s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted) [167.214336] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted [167.322488] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.107s) [167.462862] [026/133] (886s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt) [167.652112] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt [169.975250] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SUCCESS (2.324s) [170.247281] [027/133] (883s left) syncobj_timeline (single-wait-all-for-submit-signaled) [170.353133] Starting subtest: single-wait-all-for-submit-signaled [170.355129] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.002s) [170.530548] [028/133] (883s left) kms_color_pipeline (plane-ctm3x4-lut1d) [170.704476] Starting subtest: plane-ctm3x4-lut1d [172.096098] Subtest plane-ctm3x4-lut1d: SKIP (1.392s) [172.363347] [029/133] (881s left) api_intel_bb (reset-bb) [172.464899] Starting subtest: reset-bb [172.470753] Subtest reset-bb: SUCCESS (0.006s) [172.630539] [030/133] (881s left) gem_partial_pwrite_pread (reads-snoop) [172.741222] Starting subtest: reads-snoop [178.376698] Subtest reads-snoop: SUCCESS (5.638s) [178.564792] [031/133] (875s left) gem_ctx_shared (single-timeline) [178.688978] Starting subtest: single-timeline [178.705768] Subtest single-timeline: SUCCESS (0.014s) [178.963063] [032/133] (875s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu) [179.150932] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu [181.589572] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (2.438s) [181.880410] [033/133] (872s left) kms_content_protection (type1) [182.067256] Starting subtest: type1 [182.107649] Subtest type1: SKIP (0.025s) [182.249283] [034/133] (872s left) perf_pmu (busy-check-all) [182.357242] Starting subtest: busy-check-all [182.359091] Starting dynamic subtest: rcs0 [182.892176] Dynamic subtest rcs0: SUCCESS (0.536s) [182.914370] Starting dynamic subtest: bcs0 [183.431238] Dynamic subtest bcs0: SUCCESS (0.536s) [183.456838] Starting dynamic subtest: vcs0 [183.963333] Dynamic subtest vcs0: SUCCESS (0.529s) [183.985084] Starting dynamic subtest: vecs0 [184.500514] Dynamic subtest vecs0: SUCCESS (0.534s) [184.502593] Subtest busy-check-all: SUCCESS (2.148s) [184.679848] [035/133] (869s left) syncobj_wait (invalid-wait-illegal-handle) [184.787296] Starting subtest: invalid-wait-illegal-handle [184.789481] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s) [184.929359] [036/133] (869s left) kms_psr (fbc-pr-suspend) [185.105185] Subtest fbc-pr-suspend: SKIP (0.000s) [185.207483] [037/133] (869s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite) [185.392132] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite [185.396043] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [185.548943] [038/133] (869s left) kms_cursor_edge_walk (64x64-right-edge) [185.724062] Starting subtest: 64x64-right-edge [185.728323] Starting dynamic subtest: pipe-A-HDMI-A-1 [189.557435] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (3.832s) [189.582026] Starting dynamic subtest: pipe-C-HDMI-A-1 [192.948360] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (3.386s) [192.950455] Subtest 64x64-right-edge: SUCCESS (7.228s) [193.225663] [039/133] (861s left) kms_psr (pr-cursor-blt) [193.405431] Subtest pr-cursor-blt: SKIP (0.000s) [193.518282] [040/133] (861s left) gem_mmap_gtt (cpuset-basic-small-copy) [193.621019] Starting subtest: cpuset-basic-small-copy [198.005406] Subtest cpuset-basic-small-copy: SUCCESS (4.387s) [198.164427] [041/133] (856s left) gem_exec_reloc (basic-gtt-noreloc) [198.398308] Starting subtest: basic-gtt-noreloc [198.404461] Subtest basic-gtt-noreloc: SUCCESS (0.009s) [198.626761] [042/133] (856s left) kms_fb_coherency (memset-crc) [198.802731] Starting subtest: memset-crc [198.806222] Starting dynamic subtest: mmap-gtt [199.550280] Dynamic subtest mmap-gtt: SUCCESS (0.748s) [199.787477] Starting dynamic subtest: mmap-offset-wc [200.156728] Dynamic subtest mmap-offset-wc: SUCCESS (0.390s) [200.392537] Starting dynamic subtest: mmap-offset-uc [201.181345] Dynamic subtest mmap-offset-uc: SUCCESS (0.807s) [201.419665] Starting dynamic subtest: mmap-legacy-wc [201.785918] Dynamic subtest mmap-legacy-wc: SUCCESS (0.389s) [201.988149] Subtest memset-crc: SUCCESS (3.188s) [202.282436] [043/133] (852s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation) [202.459434] Starting subtest: plane-upscale-factor-0-25-with-rotation [202.461552] Starting dynamic subtest: pipe-A [206.000828] Dynamic subtest pipe-A: SKIP (3.540s) [206.024926] Starting dynamic subtest: pipe-B [209.530987] Dynamic subtest pipe-B: SKIP (3.525s) [209.555815] Starting dynamic subtest: pipe-C [213.069565] Dynamic subtest pipe-C: SKIP (3.538s) [213.073628] Subtest plane-upscale-factor-0-25-with-rotation: SKIP (10.611s) [213.554949] [044/133] (841s left) perf (non-sampling-read-error) [213.824552] Starting subtest: non-sampling-read-error [213.846818] Subtest non-sampling-read-error: SUCCESS (0.020s) [213.953655] [045/133] (841s left) gem_exec_schedule (reorder-wide) [214.206280] Starting subtest: reorder-wide [214.208319] Starting dynamic subtest: rcs0 [214.364974] Dynamic subtest rcs0: SUCCESS (0.152s) [214.390849] Starting dynamic subtest: bcs0 [214.657079] Dynamic subtest bcs0: SUCCESS (0.292s) [214.685528] Starting dynamic subtest: vcs0 [214.809035] Dynamic subtest vcs0: SUCCESS (0.144s) [214.844980] Starting dynamic subtest: vecs0 [214.967560] Dynamic subtest vecs0: SUCCESS (0.157s) [214.969607] Subtest reorder-wide: SUCCESS (0.760s) [215.237530] [046/133] (840s left) vgem_basic (dmabuf-export) [215.348329] Starting subtest: dmabuf-export [215.352270] Subtest dmabuf-export: SUCCESS (0.004s) [215.525478] [047/133] (840s left) kms_frontbuffer_tracking (fbc-2p-rte) [215.711129] Starting subtest: fbc-2p-rte [220.033511] Subtest fbc-2p-rte: SUCCESS (4.326s) [220.295396] [048/133] (835s left) kms_async_flips (async-flip-dpms) [220.491454] Starting subtest: async-flip-dpms [221.036805] Starting dynamic subtest: pipe-A-HDMI-A-1 [223.722272] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.687s) [224.094806] Starting dynamic subtest: pipe-A-HDMI-A-2 [226.203278] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.131s) [226.551372] Starting dynamic subtest: pipe-B-HDMI-A-1 [228.663489] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.130s) [228.976903] Starting dynamic subtest: pipe-B-HDMI-A-2 [231.109472] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.153s) [231.433918] Starting dynamic subtest: pipe-C-HDMI-A-1 [233.557623] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.148s) [233.875650] Starting dynamic subtest: pipe-C-HDMI-A-2 [235.973934] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.123s) [235.978778] Subtest async-flip-dpms: SUCCESS (15.506s) [236.579715] [049/133] (819s left) kms_big_fb (x-tiled-64bpp-rotate-90) [236.786630] Starting subtest: x-tiled-64bpp-rotate-90 [237.071503] Subtest x-tiled-64bpp-rotate-90: SKIP (0.283s) [237.313507] [050/133] (818s left) perf_pmu (invalid-init) [237.420032] Starting subtest: invalid-init [237.422282] Subtest invalid-init: SUCCESS (0.001s) [237.580545] [051/133] (818s left) gem_userptr_blits (dmabuf-sync) [237.707031] Starting subtest: dmabuf-sync [237.715986] Subtest dmabuf-sync: SKIP (0.006s) [237.957651] [052/133] (818s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt) [238.144042] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt [238.148067] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [238.297853] [053/133] (817s left) kms_psr (fbc-psr-dpms) [238.472227] Subtest fbc-psr-dpms: SKIP (0.000s) [238.589308] [054/133] (817s left) sysfs_timeslice_duration (invalid) [238.701641] Starting subtest: invalid [238.704335] Starting dynamic subtest: vecs0 [238.706369] Dynamic subtest vecs0: SUCCESS (0.001s) [238.730550] Starting dynamic subtest: vcs0 [238.733551] Dynamic subtest vcs0: SUCCESS (0.001s) [238.756750] Starting dynamic subtest: bcs0 [238.759841] Dynamic subtest bcs0: SUCCESS (0.001s) [238.782809] Starting dynamic subtest: rcs0 [238.787410] Dynamic subtest rcs0: SUCCESS (0.001s) [238.790673] Subtest invalid: SUCCESS (0.019s) [238.877939] [055/133] (817s left) kms_cursor_crc (cursor-onscreen-32x32) [239.059218] Starting subtest: cursor-onscreen-32x32 [239.205134] Subtest cursor-onscreen-32x32: SKIP (0.142s) [239.363723] [056/133] (817s left) gen9_exec_parse (bb-large) [239.483830] Starting subtest: bb-large [282.911388] Subtest bb-large: SUCCESS (43.427s) [283.219484] [057/133] (773s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff) [283.543024] Starting subtest: psr-2p-primscrn-cur-indfb-onoff [283.546904] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [283.699790] [058/133] (772s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite) [283.886381] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite [285.842537] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SUCCESS (1.956s) [286.063746] [059/133] (770s left) gem_exec_schedule (preempt-queue-contexts) [286.224294] Starting subtest: preempt-queue-contexts [286.226109] Starting dynamic subtest: rcs0 [287.014406] Dynamic subtest rcs0: SUCCESS (0.790s) [287.045386] Starting dynamic subtest: bcs0 [287.825307] Dynamic subtest bcs0: SUCCESS (0.800s) [287.855266] Starting dynamic subtest: vcs0 [288.620948] Dynamic subtest vcs0: SUCCESS (0.789s) [288.653160] Starting dynamic subtest: vecs0 [289.409093] Dynamic subtest vecs0: SUCCESS (0.786s) [289.411479] Subtest preempt-queue-contexts: SUCCESS (3.187s) [289.815485] [060/133] (767s left) gem_exec_balancer (sequential) [289.935959] Starting subtest: sequential [294.061990] Subtest sequential: SUCCESS (4.125s) [294.331308] [061/133] (762s left) gem_eio (wait-wedge-10ms) [294.464250] Starting subtest: wait-wedge-10ms [294.558142] Subtest wait-wedge-10ms: SUCCESS (0.100s) [294.812243] [062/133] (762s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt) [294.999457] Starting subtest: psr-farfromfence-mmap-gtt [295.003213] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s) [295.149866] [063/133] (762s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc) [295.328905] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc [295.330852] Starting dynamic subtest: pipe-A-HDMI-A-1 [295.349310] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.002s) [295.374424] Starting dynamic subtest: pipe-A-HDMI-A-2 [295.392867] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.002s) [295.417697] Starting dynamic subtest: pipe-B-HDMI-A-1 [295.435805] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.002s) [295.460606] Starting dynamic subtest: pipe-B-HDMI-A-2 [295.478411] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.002s) [295.502775] Starting dynamic subtest: pipe-C-HDMI-A-1 [295.520224] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s) [295.543716] Starting dynamic subtest: pipe-C-HDMI-A-2 [295.592172] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.002s) [295.596296] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.041s) [296.260198] [064/133] (761s left) kms_plane_alpha_blend (alpha-transparent-fb) [296.436039] Starting subtest: alpha-transparent-fb [296.596190] Starting dynamic subtest: pipe-A-HDMI-A-1 [297.628557] Dynamic subtest pipe-A-HDMI-A-1: FAIL (0.452s) [297.653656] Starting dynamic subtest: pipe-C-HDMI-A-1 [298.353863] Dynamic subtest pipe-C-HDMI-A-1: FAIL (1.078s) [298.355836] Subtest alpha-transparent-fb: FAIL (1.699s) [298.595098] [065/133] (758s left) gem_userptr_blits (sd-probe) [298.713915] Starting subtest: sd-probe [298.715987] Subtest sd-probe: SUCCESS (0.001s) [298.909282] [066/133] (758s left) kms_pm_rpm (pc8-residency) [300.802160] Starting subtest: pc8-residency [300.806615] Subtest pc8-residency: SKIP (0.000s) [301.154059] [067/133] (756s left) kms_big_fb (y-tiled-32bpp-rotate-270) [301.347063] Starting subtest: y-tiled-32bpp-rotate-270 [304.909082] Subtest y-tiled-32bpp-rotate-270: SUCCESS (3.560s) [305.286460] [068/133] (752s left) gem_lmem_swapping (massive) [305.396846] Subtest massive: SKIP (0.000s) [305.513617] [069/133] (752s left) i915_query (query-regions-unallocated) [305.610616] Starting subtest: query-regions-unallocated [305.612672] Subtest query-regions-unallocated: SUCCESS (0.000s) [305.751235] [070/133] (752s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs) [305.924584] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs [305.926632] Starting dynamic subtest: pipe-A-HDMI-A-1 [305.945601] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.002s) [305.970110] Starting dynamic subtest: pipe-A-HDMI-A-2 [305.988712] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.002s) [306.012999] Starting dynamic subtest: pipe-B-HDMI-A-1 [306.032099] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.002s) [306.057480] Starting dynamic subtest: pipe-B-HDMI-A-2 [306.076460] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.002s) [306.100447] Starting dynamic subtest: pipe-C-HDMI-A-1 [306.119043] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s) [306.143447] Starting dynamic subtest: pipe-C-HDMI-A-2 [306.162170] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.002s) [306.166105] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.041s) [306.868376] [071/133] (751s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [307.062584] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu [309.408433] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (2.353s) [309.648946] [072/133] (748s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling) [309.825161] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling [309.827068] Starting dynamic subtest: pipe-A-valid-mode [310.776225] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.949s) [310.778193] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SUCCESS (0.954s) [311.077442] [073/133] (747s left) i915_drm_fdinfo (memory-info-active) [311.185107] Starting subtest: memory-info-active [311.187179] Starting dynamic subtest: smem0 [312.599214] Dynamic subtest smem0: SUCCESS (1.410s) [312.602694] Subtest memory-info-active: SUCCESS (1.413s) [312.742563] [074/133] (745s left) kms_prop_blob (blob-prop-validate) [312.841357] Starting subtest: blob-prop-validate [312.843405] Subtest blob-prop-validate: SUCCESS (0.000s) [312.990321] [075/133] (745s left) syncobj_wait (single-wait-all-signaled) [313.096231] Starting subtest: single-wait-all-signaled [313.098261] Subtest single-wait-all-signaled: SUCCESS (0.001s) [313.241153] [076/133] (745s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move) [313.427695] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move [313.431952] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [313.593479] [077/133] (744s left) kms_pm_rpm (basic-rte) [313.690069] Starting subtest: basic-rte [315.779102] Subtest basic-rte: SUCCESS (2.091s) [316.607384] [078/133] (742s left) kms_plane (pixel-format-y-tiled-modifier) [316.783390] Starting subtest: pixel-format-y-tiled-modifier [316.992338] Starting dynamic subtest: pipe-A-plane-0 [317.791271] Dynamic subtest pipe-A-plane-0: SUCCESS (0.799s) [317.819932] Starting dynamic subtest: pipe-A-plane-1 [318.557879] Dynamic subtest pipe-A-plane-1: SUCCESS (0.763s) [318.586535] Starting dynamic subtest: pipe-A-plane-2 [319.091484] Dynamic subtest pipe-A-plane-2: SUCCESS (0.531s) [319.120366] Starting dynamic subtest: pipe-A-plane-3 [319.641948] Dynamic subtest pipe-A-plane-3: SUCCESS (0.547s) [319.669772] Starting dynamic subtest: pipe-A-plane-4 [319.673955] Dynamic subtest pipe-A-plane-4: SKIP (0.000s) [320.007068] Starting dynamic subtest: pipe-B-plane-0 [320.684976] Dynamic subtest pipe-B-plane-0: SUCCESS (0.699s) [320.714173] Starting dynamic subtest: pipe-B-plane-1 [321.451415] Dynamic subtest pipe-B-plane-1: SUCCESS (0.763s) [321.480325] Starting dynamic subtest: pipe-B-plane-2 [322.001907] Dynamic subtest pipe-B-plane-2: SUCCESS (0.546s) [322.027818] Starting dynamic subtest: pipe-B-plane-3 [322.551283] Dynamic subtest pipe-B-plane-3: SUCCESS (0.547s) [322.578812] Starting dynamic subtest: pipe-B-plane-4 [322.582823] Dynamic subtest pipe-B-plane-4: SKIP (0.000s) [322.771262] Subtest pixel-format-y-tiled-modifier: SUCCESS (5.989s) [323.076166] [079/133] (735s left) kms_addfb_basic (too-high) [323.266910] Starting subtest: too-high [323.269167] Subtest too-high: SUCCESS (0.001s) [323.424440] [080/133] (735s left) gem_ctx_param (get-priority-new-ctx) [323.522215] Starting subtest: get-priority-new-ctx [323.524268] Subtest get-priority-new-ctx: SUCCESS (0.000s) [323.673210] [081/133] (735s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite) [323.857667] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite [323.861488] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [324.023236] [082/133] (735s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt) [324.208992] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt [324.212961] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [324.357463] [083/133] (734s left) gem_create (hog-create) [324.470269] Starting subtest: hog-create [324.472165] Starting dynamic subtest: smem0 [356.735765] Dynamic subtest smem0: SUCCESS (32.265s) [356.738473] Subtest hog-create: SUCCESS (32.270s) [356.993412] [084/133] (702s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu) [357.187204] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu [359.962574] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (2.777s) [360.189150] [085/133] (699s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode) [360.732287] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s) [360.984268] [086/133] (698s left) i915_pm_rps (basic-api) [361.098120] Starting subtest: basic-api [361.108780] Subtest basic-api: SUCCESS (0.011s) [361.272478] [087/133] (698s left) kms_invalid_mode (bad-vsync-start) [361.450404] Starting subtest: bad-vsync-start [361.452311] Starting dynamic subtest: pipe-A-HDMI-A-1 [361.841284] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.392s) [361.871228] Starting dynamic subtest: pipe-A-HDMI-A-2 [361.873250] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.002s) [361.897843] Starting dynamic subtest: pipe-B-HDMI-A-1 [361.899831] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.002s) [361.924250] Starting dynamic subtest: pipe-B-HDMI-A-2 [361.926168] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.002s) [361.951084] Starting dynamic subtest: pipe-C-HDMI-A-1 [361.952931] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.002s) [361.978097] Starting dynamic subtest: pipe-C-HDMI-A-2 [361.980118] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.002s) [361.982114] Subtest bad-vsync-start: SUCCESS (0.430s) [362.169782] [088/133] (697s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render) [362.355057] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render [362.359325] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [362.534142] [089/133] (697s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled) [362.654260] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled [362.660801] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s) [362.915976] [090/133] (696s left) kms_chamelium_color (ctm-negative) [363.092404] Subtest ctm-negative: SKIP (0.000s) [363.195823] [091/133] (696s left) kms_plane (pixel-format-linear-modifier-source-clamping) [363.371670] Starting subtest: pixel-format-linear-modifier-source-clamping [363.588893] Starting dynamic subtest: pipe-A-plane-0 [367.155260] Dynamic subtest pipe-A-plane-0: SUCCESS (3.566s) [367.184447] Starting dynamic subtest: pipe-A-plane-1 [370.721216] Dynamic subtest pipe-A-plane-1: SUCCESS (3.563s) [370.750609] Starting dynamic subtest: pipe-A-plane-2 [372.272934] Dynamic subtest pipe-A-plane-2: SUCCESS (1.548s) [372.301320] Starting dynamic subtest: pipe-A-plane-3 [373.821229] Dynamic subtest pipe-A-plane-3: SUCCESS (1.546s) [374.170814] Starting dynamic subtest: pipe-B-plane-0 [377.694350] Dynamic subtest pipe-B-plane-0: SUCCESS (3.549s) [377.723836] Starting dynamic subtest: pipe-B-plane-1 [381.261019] Dynamic subtest pipe-B-plane-1: SUCCESS (3.563s) [381.288764] Starting dynamic subtest: pipe-B-plane-2 [382.811291] Dynamic subtest pipe-B-plane-2: SUCCESS (1.547s) [382.839960] Starting dynamic subtest: pipe-B-plane-3 [384.361768] Dynamic subtest pipe-B-plane-3: SUCCESS (1.547s) [384.594446] Subtest pixel-format-linear-modifier-source-clamping: SUCCESS (21.224s) [384.883454] [092/133] (675s left) gem_ctx_persistence (engines-cleanup) [385.002437] Starting subtest: engines-cleanup [385.004217] Starting dynamic subtest: rcs0 [385.048960] Dynamic subtest rcs0: SUCCESS (0.047s) [385.079049] Starting dynamic subtest: bcs0 [385.088521] Dynamic subtest bcs0: SUCCESS (0.034s) [385.114620] Starting dynamic subtest: vcs0 [385.128032] Dynamic subtest vcs0: SUCCESS (0.038s) [385.156844] Starting dynamic subtest: vecs0 [385.169515] Dynamic subtest vecs0: SUCCESS (0.037s) [385.171891] Subtest engines-cleanup: SUCCESS (0.172s) [385.314608] [093/133] (674s left) kms_cursor_crc (cursor-rapid-movement-512x512) [385.504135] Starting subtest: cursor-rapid-movement-512x512 [385.509279] Subtest cursor-rapid-movement-512x512: SKIP (0.003s) [385.666652] [094/133] (674s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling) [385.841258] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling [385.843272] Starting dynamic subtest: pipe-A-valid-mode [386.719382] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.877s) [386.721436] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (0.882s) [387.020784] [095/133] (673s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt) [387.210528] Starting subtest: psr-rgb565-draw-blt [387.215103] Subtest psr-rgb565-draw-blt: SKIP (0.000s) [387.370320] [096/133] (673s left) gem_exec_params (rel-constants-invalid) [387.482244] Starting subtest: rel-constants-invalid [387.484179] Subtest rel-constants-invalid: SUCCESS (0.000s) [387.650629] [097/133] (672s left) kms_rotation_crc (primary-y-tiled-reflect-x-90) [387.827293] Starting subtest: primary-y-tiled-reflect-x-90 [387.831246] Subtest primary-y-tiled-reflect-x-90: SKIP (0.003s) [387.969502] [098/133] (672s left) prime_busy (after) [388.082103] Starting subtest: after [388.092219] Starting dynamic subtest: rcs0 [388.110109] Dynamic subtest rcs0: SUCCESS (0.017s) [388.140141] Starting dynamic subtest: bcs0 [388.142511] Dynamic subtest bcs0: SUCCESS (0.009s) [388.167597] Starting dynamic subtest: vcs0 [388.170577] Dynamic subtest vcs0: SUCCESS (0.017s) [388.195680] Starting dynamic subtest: vecs0 [388.198540] Dynamic subtest vecs0: SUCCESS (0.013s) [388.272870] Subtest after: SUCCESS (0.191s) [388.417443] [099/133] (672s left) kms_rotation_crc (sprite-rotation-270) [388.592056] Starting subtest: sprite-rotation-270 [402.412105] Subtest sprite-rotation-270: SUCCESS (13.822s) [402.668408] [100/133] (658s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted) [402.796641] Starting subtest: multi-wait-all-for-submit-unsubmitted [402.899085] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.103s) [403.035259] [101/133] (657s left) gem_softpin (noreloc-s3) [403.149688] Starting subtest: noreloc-S3