[58.004765] Initializing watchdogs [58.004815] /dev/watchdog0 [58.018189] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [58.021938] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [58.023990] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [58.027176] [001/130] (960s left) gem_mmap_wc (write-gtt-read-wc) [58.144502] Subtest write-gtt-read-wc: SKIP (0.000s) [58.186570] [002/130] (960s left) gem_exec_reloc (basic-write-wc-noreloc) [58.254084] Subtest basic-write-wc-noreloc: SKIP (0.000s) [58.320811] [003/130] (960s left) kms_big_fb (linear-8bpp-rotate-90) [58.421834] Starting subtest: linear-8bpp-rotate-90 [58.456135] Subtest linear-8bpp-rotate-90: SKIP (0.033s) [58.558648] [004/130] (960s left) gem_vm_create (invalid-create) [58.614579] Starting subtest: invalid-create [58.619358] Subtest invalid-create: SUCCESS (0.002s) [58.720239] [005/130] (959s left) vgem_slow (nohang) [58.779465] Starting subtest: nohang [69.254238] Subtest nohang: SUCCESS (10.521s) [69.310936] [FACT vgem_slow (nohang)] new: kernel.kmod_is_loaded.vgem: true [69.313859] [006/130] (949s left) gen9_exec_parse (bb-secure) [69.380481] Subtest bb-secure: SKIP (0.000s) [69.452946] [007/130] (949s left) gem_mmap_gtt (cpuset-big-copy-xy) [69.523740] Subtest cpuset-big-copy-XY: SKIP (0.000s) [69.582552] [008/130] (949s left) kms_flip (2x-flip-vs-panning) [69.688073] Starting subtest: 2x-flip-vs-panning [69.698429] Subtest 2x-flip-vs-panning: SKIP (0.010s) [69.818397] [009/130] (948s left) kms_selftest (drm_format_helper) [69.855406] Starting subtest: drm_format_helper [69.862149] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8 [69.994054] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.131s) [70.001617] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332 [70.110983] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.119s) [70.117094] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565 [70.270480] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.157s) [70.276387] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555 [70.401394] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.131s) [70.407563] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555 [70.545992] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.146s) [70.553858] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551 [70.688443] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.143s) [70.696213] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888 [70.817353] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.127s) [70.824918] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888 [71.166417] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.351s) [71.193388] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888 [71.959688] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.791s) [71.968064] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010 [72.181593] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.224s) [72.189612] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010 [72.323254] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.140s) [72.329707] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono [72.460218] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.139s) [72.468440] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab [72.615757] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.153s) [72.623577] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888 [72.734461] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.121s) [72.742701] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888 [72.826281] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.091s) [72.832946] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset [72.952073] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.126s) [72.959514] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_build_fourcc_list [73.088739] Dynamic subtest drm_format_helper_test-drm_test_fb_build_fourcc_list: SUCCESS (0.137s) [73.095678] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy [73.232655] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.142s) [73.234623] Subtest drm_format_helper: SUCCESS (3.382s) [73.407133] [010/130] (945s left) kms_busy (extended-modeset-hang-newfb) [73.517141] Starting subtest: extended-modeset-hang-newfb [73.519336] Starting dynamic subtest: pipe-A [107.768229] Dynamic subtest pipe-A: SUCCESS (34.254s) [107.774783] Starting dynamic subtest: pipe-D [130.754670] Dynamic subtest pipe-D: SUCCESS (22.985s) [130.757094] Subtest extended-modeset-hang-newfb: SUCCESS (57.244s) [131.553838] [011/130] (887s left) sysfs_timeslice_duration (idempotent) [131.613479] Starting subtest: idempotent [131.615740] Starting dynamic subtest: vecs0 [131.618089] Dynamic subtest vecs0: SUCCESS (0.000s) [131.626258] Starting dynamic subtest: ccs0 [131.628329] Dynamic subtest ccs0: SUCCESS (0.000s) [131.634655] Starting dynamic subtest: vcs0 [131.636732] Dynamic subtest vcs0: SUCCESS (0.000s) [131.642772] Starting dynamic subtest: bcs0 [131.644931] Dynamic subtest bcs0: SUCCESS (0.000s) [131.650933] Starting dynamic subtest: rcs0 [131.653133] Dynamic subtest rcs0: SUCCESS (0.000s) [131.662405] Starting dynamic subtest: vcs1 [131.664607] Dynamic subtest vcs1: SUCCESS (0.000s) [131.666844] Subtest idempotent: SUCCESS (0.003s) [131.719442] [012/130] (887s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc) [131.825531] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc [136.181273] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (4.358s) [136.274431] [013/130] (882s left) syncobj_wait (wait-zero-handles) [136.330220] Starting subtest: wait-zero-handles [136.332581] Subtest wait-zero-handles: SUCCESS (0.000s) [136.431565] [014/130] (882s left) kms_psr2_su (page_flip-xrgb8888) [136.495018] Subtest page_flip-XRGB8888: SKIP (0.000s) [136.549482] [015/130] (882s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt) [136.657250] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt [136.661736] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [136.766043] [016/130] (882s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt) [136.873731] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt [136.878274] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [136.992586] [017/130] (882s left) kms_rmfb (close-fd) [137.094936] Starting subtest: close-fd [137.097242] Starting dynamic subtest: pipe-A-eDP-1 [137.211336] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.114s) [137.222668] Starting dynamic subtest: pipe-B-eDP-1 [138.350400] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.138s) [138.360497] Starting dynamic subtest: pipe-C-eDP-1 [139.472731] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.123s) [139.480390] Starting dynamic subtest: pipe-D-eDP-1 [140.591980] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.119s) [140.593981] Subtest close-fd: SUCCESS (3.495s) [141.793588] [018/130] (877s left) syncobj_wait (wait-any-complex) [141.848073] Starting subtest: wait-any-complex [141.908473] Subtest wait-any-complex: SUCCESS (0.061s) [141.973203] [019/130] (877s left) gem_exec_endless (dispatch) [142.030318] Starting subtest: dispatch [142.032830] Starting dynamic subtest: rcs0 [142.037378] Dynamic subtest rcs0: SUCCESS (0.006s) [142.048220] Starting dynamic subtest: bcs0 [142.052336] Dynamic subtest bcs0: SUCCESS (0.004s) [142.059922] Starting dynamic subtest: vcs0 [142.064206] Dynamic subtest vcs0: SUCCESS (0.005s) [142.070202] Starting dynamic subtest: vcs1 [142.074151] Dynamic subtest vcs1: SUCCESS (0.004s) [142.080066] Starting dynamic subtest: vecs0 [142.084056] Dynamic subtest vecs0: SUCCESS (0.004s) [142.089924] Starting dynamic subtest: ccs0 [142.094018] Dynamic subtest ccs0: SUCCESS (0.005s) [142.095863] Subtest dispatch: SUCCESS (0.028s) [143.947208] [020/130] (875s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc) [144.036956] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc [144.039366] Starting dynamic subtest: pipe-A-eDP-1 [144.098314] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [144.107061] Starting dynamic subtest: pipe-B-eDP-1 [144.163863] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [144.171117] Starting dynamic subtest: pipe-C-eDP-1 [144.229902] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [144.237068] Starting dynamic subtest: pipe-D-eDP-1 [144.294385] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [144.298899] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s) [146.141854] [021/130] (872s left) kms_psr (fbc-psr-cursor-blt) [146.243188] Starting subtest: fbc-psr-cursor-blt [146.245467] Starting dynamic subtest: eDP-1 [146.249981] Dynamic subtest eDP-1: SKIP (0.000s) [146.254534] Subtest fbc-psr-cursor-blt: SKIP (0.000s) [146.311346] [022/130] (872s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite) [146.406376] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite [146.410811] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [146.501343] [023/130] (872s left) kms_flip (busy-flip) [146.602115] Starting subtest: busy-flip [146.604392] Starting dynamic subtest: A-eDP1 [148.359084] Dynamic subtest A-eDP1: SUCCESS (1.757s) [148.365925] Starting dynamic subtest: B-eDP1 [150.081759] Dynamic subtest B-eDP1: SUCCESS (1.722s) [150.090868] Starting dynamic subtest: C-eDP1 [151.792921] Dynamic subtest C-eDP1: SUCCESS (1.710s) [151.801718] Starting dynamic subtest: D-eDP1 [153.518899] Dynamic subtest D-eDP1: SUCCESS (1.726s) [153.521445] Subtest busy-flip: SUCCESS (6.920s) [154.660921] [024/130] (864s left) drm_fdinfo (context-close-stress) [154.707790] Starting subtest: context-close-stress [165.454065] Subtest context-close-stress: SUCCESS (10.745s) [165.519587] [025/130] (853s left) kms_pm_rpm (fences-dpms) [167.066146] Starting subtest: fences-dpms [167.071680] Subtest fences-dpms: SKIP (0.000s) [167.799885] [026/130] (851s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip) [167.894090] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip [167.898214] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s) [167.993952] [027/130] (851s left) gem_exec_reloc (basic-wc-read-active) [168.057626] Subtest basic-wc-read-active: SKIP (0.000s) [168.124209] [028/130] (851s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff) [168.224835] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff [168.228787] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [168.343066] [029/130] (851s left) perf (unprivileged-single-ctx-counters) [168.447413] Starting subtest: unprivileged-single-ctx-counters [168.451783] Subtest unprivileged-single-ctx-counters: SKIP (0.000s) [168.485317] [030/130] (850s left) kms_big_fb (yf-tiled-32bpp-rotate-180) [168.580075] Starting subtest: yf-tiled-32bpp-rotate-180 [168.584217] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s) [168.685928] [031/130] (850s left) gem_ctx_persistence (legacy-engines-queued) [168.745104] Starting subtest: legacy-engines-queued [168.747245] Starting dynamic subtest: render [168.865391] Dynamic subtest render: SUCCESS (0.120s) [168.874394] Starting dynamic subtest: bsd1 [170.887412] Dynamic subtest bsd1: SUCCESS (2.018s) [170.897706] Starting dynamic subtest: bsd2 [172.870903] Dynamic subtest bsd2: SUCCESS (1.981s) [172.881547] Starting dynamic subtest: blt [172.929481] Dynamic subtest blt: SUCCESS (0.059s) [172.938591] Starting dynamic subtest: vebox [174.854938] Dynamic subtest vebox: SUCCESS (1.921s) [174.857681] Subtest legacy-engines-queued: SUCCESS (6.107s) [174.931653] [032/130] (844s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot) [175.055934] Starting subtest: modeset-atomic-cursor-hotspot [175.060595] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s) [175.149673] [033/130] (844s left) gem_exec_params (no-blt) [175.208514] Starting subtest: no-blt [175.210528] Subtest no-blt: SUCCESS (0.003s) [175.327483] [034/130] (844s left) syncobj_wait (wait-delayed-signal) [175.379929] Starting subtest: wait-delayed-signal [175.482881] Subtest wait-delayed-signal: SUCCESS (0.102s) [175.550480] [035/130] (844s left) gem_exec_schedule (preempt-self) [175.621570] Starting subtest: preempt-self [175.623748] Starting dynamic subtest: rcs0 [175.635227] Dynamic subtest rcs0: SUCCESS (0.018s) [175.644504] Starting dynamic subtest: bcs0 [175.649784] Dynamic subtest bcs0: SUCCESS (0.015s) [175.656568] Starting dynamic subtest: vcs0 [175.669288] Dynamic subtest vcs0: SUCCESS (0.019s) [175.676079] Starting dynamic subtest: vcs1 [175.682211] Dynamic subtest vcs1: SUCCESS (0.013s) [175.689236] Starting dynamic subtest: vecs0 [175.699214] Dynamic subtest vecs0: SUCCESS (0.017s) [175.706118] Starting dynamic subtest: ccs0 [175.714246] Dynamic subtest ccs0: SUCCESS (0.015s) [175.716573] Subtest preempt-self: SUCCESS (0.098s) [177.023140] [036/130] (842s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted) [177.075832] Starting subtest: multi-wait-all-for-submit-available-submitted [177.078261] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.001s) [177.176568] [037/130] (842s left) kms_flip (2x-plain-flip-interruptible) [177.276946] Starting subtest: 2x-plain-flip-interruptible [177.288432] Subtest 2x-plain-flip-interruptible: SKIP (0.010s) [177.362574] [038/130] (842s left) core_auth (getclient-simple) [177.392988] Starting subtest: getclient-simple [177.419857] Subtest getclient-simple: SUCCESS (0.026s) [177.527382] [039/130] (842s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf) [182.542694] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf [182.545272] Starting dynamic subtest: pipe-A-eDP-1 [183.327107] Dynamic subtest pipe-A-eDP-1: SKIP (0.781s) [183.333815] Starting dynamic subtest: pipe-B-eDP-1 [184.455654] Dynamic subtest pipe-B-eDP-1: SKIP (1.126s) [184.460250] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.910s) [185.622676] [040/130] (834s left) kms_invalid_mode (zero-hdisplay) [185.719221] Starting subtest: zero-hdisplay [185.721589] Starting dynamic subtest: pipe-A-eDP-1 [186.000918] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.283s) [186.008953] Starting dynamic subtest: pipe-B-eDP-1 [186.010898] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [186.017108] Starting dynamic subtest: pipe-C-eDP-1 [186.018994] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [186.025582] Starting dynamic subtest: pipe-D-eDP-1 [186.027860] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [186.030145] Subtest zero-hdisplay: SUCCESS (0.287s) [186.851790] [041/130] (832s left) gem_eio (in-flight-10ms) [187.070478] Starting subtest: in-flight-10ms [195.846096] Subtest in-flight-10ms: SUCCESS (8.774s) [196.022451] [042/130] (823s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k) [196.412055] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s) [197.257272] [043/130] (822s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render) [197.377097] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render [202.544924] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (5.174s) [202.697035] [044/130] (817s left) prime_self_import (export-vs-gem_close-race) [202.734680] Starting subtest: export-vs-gem_close-race [207.841042] Subtest export-vs-gem_close-race: SUCCESS (5.106s) [207.913281] [045/130] (811s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0) [208.029989] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0 [209.110280] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.080s) [209.270278] [046/130] (810s left) gem_softpin (noreloc-s3) [209.339577] Starting subtest: noreloc-S3 [229.085413] Subtest noreloc-S3: SUCCESS (5.382s) [229.220963] [047/130] (805s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [229.326286] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [230.128937] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SUCCESS (0.814s) [230.315566] [048/130] (804s left) kms_plane_multiple (tiling-x) [230.412082] Starting subtest: tiling-x [230.414361] Starting dynamic subtest: pipe-A-eDP-1 [234.015251] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.633s) [234.024202] Starting dynamic subtest: pipe-B-eDP-1 [238.399849] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.405s) [238.408228] Starting dynamic subtest: pipe-C-eDP-1 [242.682498] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.297s) [242.690347] Starting dynamic subtest: pipe-D-eDP-1 [247.074036] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.401s) [247.076392] Subtest tiling-x: SUCCESS (16.739s) [247.885834] [049/130] (786s left) kms_flip (2x-plain-flip-ts-check-interruptible) [247.988096] Starting subtest: 2x-plain-flip-ts-check-interruptible [248.000585] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.010s) [248.085939] [050/130] (786s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc) [248.196051] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc [248.200567] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [248.284895] [051/130] (786s left) gem_exec_reloc (basic-wc-read-noreloc) [248.357734] Subtest basic-wc-read-noreloc: SKIP (0.000s) [248.418577] [052/130] (785s left) gem_ctx_persistence (heartbeat-hostile) [248.474717] Starting subtest: heartbeat-hostile [248.479305] Subtest heartbeat-hostile: SKIP (0.000s) [248.585417] [053/130] (785s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc) [248.684353] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc [248.688510] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [248.781731] [054/130] (785s left) kms_pm_dc (dc5-dpms-negative) [249.888157] Starting subtest: dc5-dpms-negative [249.892632] Subtest dc5-dpms-negative: SKIP (0.000s) [249.955251] [055/130] (784s left) api_intel_allocator (two-level-inception-interruptible) [250.010574] Starting subtest: two-level-inception-interruptible [255.416595] Subtest two-level-inception-interruptible: SUCCESS (5.413s) [255.536049] [056/130] (778s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt) [255.654020] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt [255.658513] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [255.765036] [057/130] (778s left) syncobj_timeline (etime-multi-wait-all-submitted) [255.827088] Starting subtest: etime-multi-wait-all-submitted [255.936996] Subtest etime-multi-wait-all-submitted: SUCCESS (0.108s) [256.006865] [058/130] (778s left) gem_pread (uncached) [256.073460] Subtest uncached: SKIP (0.000s) [256.136017] [059/130] (778s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs) [256.236316] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs [256.238821] Starting dynamic subtest: pipe-A-eDP-1 [256.262349] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [256.272948] Starting dynamic subtest: pipe-B-eDP-1 [256.293766] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [256.301456] Starting dynamic subtest: pipe-C-eDP-1 [256.322244] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [256.329524] Starting dynamic subtest: pipe-D-eDP-1 [256.350314] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [256.354555] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.003s) [258.436068] [060/130] (776s left) kms_cursor_crc (cursor-rapid-movement-128x128) [258.641257] Starting subtest: cursor-rapid-movement-128x128 [258.646270] Starting dynamic subtest: pipe-A-eDP-1 [259.198959] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.553s) [259.223649] Starting dynamic subtest: pipe-D-eDP-1 [260.459873] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.242s) [260.462118] Subtest cursor-rapid-movement-128x128: SUCCESS (1.816s) [261.295168] [061/130] (773s left) gem_readwrite (beyond-eob) [261.363090] Subtest beyond-EOB: SKIP (0.000s) [261.415055] [062/130] (773s left) kms_vblank (query-forked) [261.520534] Starting subtest: query-forked [261.522724] Starting dynamic subtest: pipe-A-eDP-1 [263.355690] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.832s) [263.369018] Starting dynamic subtest: pipe-D-eDP-1 [265.918519] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.559s) [265.920442] Subtest query-forked: SUCCESS (4.394s) [266.745140] [063/130] (768s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt) [266.847993] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt [269.564172] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (2.721s) [269.694478] [064/130] (765s left) i915_pm_rps (basic-api) [269.753537] Starting subtest: basic-api [269.757702] Subtest basic-api: SKIP (0.000s) [269.817114] [065/130] (765s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf) [274.850933] Starting subtest: fbc-pr-cursor-plane-update-sf [274.855522] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.002s) [275.679254] [066/130] (759s left) kms_cursor_crc (cursor-onscreen-256x256) [275.887334] Starting subtest: cursor-onscreen-256x256 [275.892408] Starting dynamic subtest: pipe-A-eDP-1 [278.191292] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.298s) [278.218293] Starting dynamic subtest: pipe-D-eDP-1 [281.102432] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.892s) [281.104693] Subtest cursor-onscreen-256x256: SUCCESS (5.210s) [281.935460] [067/130] (752s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling) [282.032700] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling [282.034839] Starting dynamic subtest: pipe-A-default-mode [282.323386] Dynamic subtest pipe-A-default-mode: SKIP (0.285s) [282.327835] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.286s) [283.160424] [068/130] (751s left) gem_bad_reloc (negative-reloc) [283.229272] Subtest negative-reloc: SKIP (0.000s) [283.304080] [069/130] (751s left) gem_readwrite (read-bad-handle) [283.365832] Subtest read-bad-handle: SKIP (0.000s) [283.423852] [070/130] (751s left) syncobj_wait (invalid-signal-illegal-handle) [283.483203] Starting subtest: invalid-signal-illegal-handle [283.485584] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [283.558819] [071/130] (751s left) gem_lmem_swapping (heavy-random) [283.598706] Subtest heavy-random: SKIP (0.000s) [283.633199] [072/130] (751s left) gem_exec_schedule (independent) [283.713441] Starting subtest: independent [283.715720] Starting dynamic subtest: rcs0 [285.302852] Dynamic subtest rcs0: SUCCESS (1.598s) [285.314364] Starting dynamic subtest: vcs0 [287.367705] Dynamic subtest vcs0: SUCCESS (2.063s) [287.378007] Starting dynamic subtest: vcs1 [289.342805] Dynamic subtest vcs1: SUCCESS (1.973s) [289.353246] Starting dynamic subtest: vecs0 [291.335156] Dynamic subtest vecs0: SUCCESS (1.992s) [291.349728] Starting dynamic subtest: ccs0 [293.364960] Dynamic subtest ccs0: SUCCESS (2.028s) [293.367492] Subtest independent: SUCCESS (9.664s) [293.663162] [073/130] (741s left) i915_query (test-query-geometry-subslices) [293.719975] Starting subtest: test-query-geometry-subslices [293.721903] Subtest test-query-geometry-subslices: SUCCESS (0.000s) [293.819242] [074/130] (741s left) gem_exec_whisper (basic-fds) [293.885097] Starting subtest: basic-fds [301.335425] Subtest basic-fds: SUCCESS (7.451s) [301.519939] [075/130] (733s left) kms_vrr (max-min) [301.624026] Starting subtest: max-min [301.630947] Subtest max-min: SKIP (0.000s) [301.707957] [076/130] (733s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [301.831769] Starting subtest: basic-busy-flip-before-cursor-atomic [301.836025] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [301.962816] [077/130] (733s left) kms_atomic (plane-primary-legacy) [302.055532] Starting subtest: plane-primary-legacy [302.057746] Starting dynamic subtest: pipe-A-eDP-1 [302.498171] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.441s) [302.500330] Subtest plane-primary-legacy: SUCCESS (0.442s) [303.281843] [078/130] (732s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-cpu) [303.382970] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-cpu [306.376127] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (2.998s) [306.495821] [079/130] (728s left) kms_lease (multimaster-lease) [306.593512] Starting subtest: multimaster-lease [306.598427] Subtest multimaster-lease: SUCCESS (0.003s) [306.702579] [080/130] (728s left) sw_sync (alloc_timeline) [306.739045] Starting subtest: alloc_timeline [306.740649] Subtest alloc_timeline: SUCCESS (0.000s) [306.786342] [081/130] (728s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt) [306.898755] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt [306.902171] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [307.000175] [082/130] (728s left) kms_content_protection (lic-type-0) [307.167685] Starting subtest: lic-type-0 [310.531988] Subtest lic-type-0: SKIP (3.363s) [311.706424] [083/130] (723s left) gem_exec_fence (syncobj-timeline-chain-engines) [312.272786] Starting subtest: syncobj-timeline-chain-engines [312.361680] Subtest syncobj-timeline-chain-engines: SUCCESS (0.091s) [313.418594] [084/130] (722s left) gem_render_copy (y-tiled-ccs-to-yf-tiled) [313.490159] Starting subtest: y-tiled-ccs-to-yf-tiled [313.494533] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s) [313.661911] [085/130] (721s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite) [313.760837] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite [320.101225] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.345s) [320.196100] [086/130] (715s left) kms_pipe_crc_basic (read-crc) [320.304187] Starting subtest: read-crc [320.306490] Starting dynamic subtest: pipe-A-eDP-1 [320.992723] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.689s) [321.002163] Starting dynamic subtest: pipe-B-eDP-1 [322.329484] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.335s) [322.340169] Starting dynamic subtest: pipe-C-eDP-1 [323.596179] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.265s) [323.605512] Starting dynamic subtest: pipe-D-eDP-1 [324.929785] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.331s) [324.932096] Subtest read-crc: SUCCESS (4.626s) [325.775388] [087/130] (709s left) gem_pxp (reject-modify-context-protection-off-2) [325.892580] Starting subtest: reject-modify-context-protection-off-2 [325.895026] Subtest reject-modify-context-protection-off-2: SUCCESS (0.002s) [326.015096] [088/130] (709s left) gem_ctx_exec (basic-nohangcheck) [326.077872] Starting subtest: basic-nohangcheck [326.333848] Subtest basic-nohangcheck: SUCCESS (0.255s) [326.458568] [089/130] (709s left) kms_color (ctm-max) [326.556238] Starting subtest: ctm-max [326.558589] Starting dynamic subtest: pipe-A-eDP-1 [327.279046] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.719s) [327.290517] Starting dynamic subtest: pipe-B-eDP-1 [328.645978] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.367s) [328.657139] Starting dynamic subtest: pipe-C-eDP-1 [329.939308] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.293s) [329.950492] Starting dynamic subtest: pipe-D-eDP-1 [331.246463] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.306s) [331.248609] Subtest ctm-max: SUCCESS (4.688s) [332.082423] [090/130] (703s left) gem_spin_batch (legacy-resubmit) [332.153813] Starting subtest: legacy-resubmit [332.156106] Starting dynamic subtest: default [332.160530] Dynamic subtest default: SUCCESS (0.005s) [332.170128] Starting dynamic subtest: render [332.172559] Dynamic subtest render: SUCCESS (0.001s) [332.183190] Starting dynamic subtest: bsd [332.185442] Dynamic subtest bsd: SUCCESS (0.002s) [332.193840] Starting dynamic subtest: bsd1 [332.196117] Dynamic subtest bsd1: SUCCESS (0.001s) [332.204428] Starting dynamic subtest: bsd2 [332.206684] Dynamic subtest bsd2: SUCCESS (0.002s) [332.215128] Starting dynamic subtest: blt [332.217612] Dynamic subtest blt: SUCCESS (0.002s) [332.227587] Starting dynamic subtest: vebox [332.229750] Dynamic subtest vebox: SUCCESS (0.002s) [332.231947] Subtest legacy-resubmit: SUCCESS (0.019s) [332.414705] [091/130] (703s left) perf_pmu (invalid-init) [332.454645] Starting subtest: invalid-init [332.507167] Subtest invalid-init: FAIL (0.005s) [332.565920] [092/130] (703s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt) [332.660637] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt [336.167915] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (3.510s) [336.317465] [093/130] (699s left) perf_pmu (busy-start) [336.356997] Starting subtest: busy-start [336.359170] Starting dynamic subtest: rcs0 [338.906897] Dynamic subtest rcs0: SUCCESS (2.550s) [338.918404] Starting dynamic subtest: bcs0 [341.455995] Dynamic subtest bcs0: SUCCESS (2.547s) [341.467279] Starting dynamic subtest: vcs0 [345.332224] Dynamic subtest vcs0: SUCCESS (3.872s) [345.344393] Starting dynamic subtest: vcs1 [349.364390] Dynamic subtest vcs1: SUCCESS (4.029s) [349.374493] Starting dynamic subtest: vecs0 [353.332829] Dynamic subtest vecs0: SUCCESS (3.966s) [353.343181] Starting dynamic subtest: ccs0 [355.881139] Dynamic subtest ccs0: SUCCESS (2.547s) [355.883975] Subtest busy-start: SUCCESS (19.524s) [355.997587] [094/130] (679s left) kms_addfb_basic (bad-pitch-0) [356.055779] Starting subtest: bad-pitch-0 [356.058060] Subtest bad-pitch-0: SUCCESS (0.000s) [356.202369] [095/130] (679s left) drm_mm (drm_mm) [356.240688] Starting subtest: drm_mm [356.248680] Starting dynamic subtest: drm_test_mm_init [356.388938] Dynamic subtest drm_test_mm_init: SUCCESS (0.139s) [356.399107] Starting dynamic subtest: drm_test_mm_debug [356.513675] Dynamic subtest drm_test_mm_debug: SUCCESS (0.123s) [356.524034] Starting dynamic subtest: drm_test_mm_align32 [356.657027] Dynamic subtest drm_test_mm_align32: SUCCESS (0.142s) [356.666404] Starting dynamic subtest: drm_test_mm_align64 [356.785261] Dynamic subtest drm_test_mm_align64: SUCCESS (0.127s) [356.793352] Starting dynamic subtest: drm_test_mm_lowest [356.924684] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.137s) [356.934349] Starting dynamic subtest: drm_test_mm_highest [357.067595] Dynamic subtest drm_test_mm_highest: SUCCESS (0.142s) [357.069941] Subtest drm_mm: SUCCESS (0.825s) [357.254955] [096/130] (678s left) kms_getfb (getfb-handle-valid) [357.306938] Starting subtest: getfb-handle-valid [357.309145] Subtest getfb-handle-valid: SUCCESS (0.000s) [357.411542] [097/130] (678s left) gem_exec_store (dword) [357.468766] Starting subtest: dword [357.471062] Starting dynamic subtest: rcs0 [357.553694] Dynamic subtest rcs0: SUCCESS (0.087s) [357.565517] Starting dynamic subtest: bcs0 [357.596975] Dynamic subtest bcs0: SUCCESS (0.042s) [357.607326] Starting dynamic subtest: vcs0 [357.638585] Dynamic subtest vcs0: SUCCESS (0.040s) [357.649236] Starting dynamic subtest: vcs1 [357.681494] Dynamic subtest vcs1: SUCCESS (0.041s) [357.693081] Starting dynamic subtest: vecs0 [357.722681] Dynamic subtest vecs0: SUCCESS (0.039s) [357.732248] Starting dynamic subtest: ccs0 [357.764774] Dynamic subtest ccs0: SUCCESS (0.040s) [357.767130] Subtest dword: SUCCESS (0.299s) [357.944679] [098/130] (678s left) perf (polling-parameterized) [358.023309] Starting subtest: polling-parameterized [378.055110] Subtest polling-parameterized: SUCCESS (20.031s) [378.099791] [099/130] (657s left) sw_sync (alloc_fence_invalid_timeline) [378.137146] Starting subtest: alloc_fence_invalid_timeline [378.139394] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s) [378.190154] [100/130] (657s left) drm_read (empty-block) [378.341935] Starting subtest: empty-block [379.343188] Subtest empty-block: SUCCESS (1.001s) [379.474047] [101/130] (656s left) kms_psr (fbc-psr2-cursor-blt) [379.573514] Starting subtest: fbc-psr2-cursor-blt [379.575393] Starting dynamic subtest: eDP-1 [379.579555] Dynamic subtest eDP-1: SKIP (0.000s) [379.583685] Subtest fbc-psr2-cursor-blt: SKIP (0.001s) [379.639564] [102/130] (656s left) kms_flip (2x-flip-vs-modeset) [379.729501] Starting subtest: 2x-flip-vs-modeset [379.741379] Subtest 2x-flip-vs-modeset: SKIP (0.011s) [379.812661] [103/130] (656s left) kms_hdr (invalid-hdr) [379.910585] Starting subtest: invalid-hdr [380.976378] Starting dynamic subtest: pipe-A-eDP-1 [383.983874] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.009s) [383.986153] Subtest invalid-hdr: SUCCESS (4.074s) [384.107598] [104/130] (652s left) kms_feature_discovery (display-2x) [384.203261] Starting subtest: display-2x [384.207565] Subtest display-2x: SKIP (0.000s) [384.268933] [105/130] (651s left) kms_psr (pr-primary-blt) [384.357752] Starting subtest: pr-primary-blt [384.362023] Subtest pr-primary-blt: SKIP (0.000s) [384.426802] [106/130] (651s left) syncobj_timeline (etime-single-wait-all-available-unsubmitted) [384.482231] Starting subtest: etime-single-wait-all-available-unsubmitted [384.584526] Subtest etime-single-wait-all-available-unsubmitted: SUCCESS (0.101s) [384.657167] [107/130] (651s left) gem_mmap_offset (clear) [384.708872] Starting subtest: clear [384.711123] Starting dynamic subtest: smem0 [411.096309] Dynamic subtest smem0: SUCCESS (26.389s) [411.098692] Subtest clear: SUCCESS (26.390s) [411.341459] [108/130] (624s left) syncobj_timeline (multi-wait-submitted-signaled) [411.451778] Starting subtest: multi-wait-submitted-signaled [411.454063] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s) [411.523147] [109/130] (624s left) sriov_basic (enable-vfs-autoprobe-on) [411.587203] Starting subtest: enable-vfs-autoprobe-on [411.589171] Starting dynamic subtest: numvfs-1 [411.667624] Dynamic subtest numvfs-1: FAIL (0.027s) [411.677207] Starting dynamic subtest: numvfs-2 [411.747313] Dynamic subtest numvfs-2: FAIL (0.003s) [411.756693] Starting dynamic subtest: numvfs-3 [411.831115] Dynamic subtest numvfs-3: FAIL (0.003s) [411.841812] Starting dynamic subtest: numvfs-4 [411.915864] Dynamic subtest numvfs-4: FAIL (0.003s) [411.926836] Starting dynamic subtest: numvfs-5 [412.000994] Dynamic subtest numvfs-5: FAIL (0.003s) [412.012335] Starting dynamic subtest: numvfs-6 [412.086252] Dynamic subtest numvfs-6: FAIL (0.003s) [412.097256] Starting dynamic subtest: numvfs-7 [412.171916] Dynamic subtest numvfs-7: FAIL (0.003s) [412.183083] Starting dynamic subtest: numvfs-random [412.258031] Dynamic subtest numvfs-random: FAIL (0.003s) [412.268309] Starting dynamic subtest: numvfs-all [412.330639] Dynamic subtest numvfs-all: FAIL (0.515s) [412.332596] Subtest enable-vfs-autoprobe-on: FAIL (0.570s) [412.364735] [110/130] (624s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats) [412.491228] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats [412.493263] Starting dynamic subtest: pipe-A [413.671055] Dynamic subtest pipe-A: SKIP (1.173s) [413.680895] Starting dynamic subtest: pipe-B [414.888289] Dynamic subtest pipe-B: SKIP (1.219s) [414.898319] Starting dynamic subtest: pipe-C [416.097524] Dynamic subtest pipe-C: SUCCESS (1.210s) [416.107467] Starting dynamic subtest: pipe-D [417.291833] Dynamic subtest pipe-D: SUCCESS (1.198s) [417.294173] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (4.802s) [418.478509] [111/130] (617s left) kms_psr (pr-sprite-blt) [418.578554] Starting subtest: pr-sprite-blt [418.582785] Subtest pr-sprite-blt: SKIP (0.000s) [418.646183] [112/130] (617s left) prime_vgem (basic-gtt) [418.718964] Starting subtest: basic-gtt [418.723788] Subtest basic-gtt: SKIP (0.000s) [418.818301] [113/130] (617s left) gem_exec_create (madvise) [418.890716] Starting subtest: madvise [418.893221] Starting dynamic subtest: smem [439.413010] Dynamic subtest smem: SUCCESS (20.525s) [439.415278] Subtest madvise: SUCCESS (20.525s) [440.118442] [114/130] (596s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled) [440.189345] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled [440.193662] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s) [440.368264] [115/130] (596s left) kms_ccs (bad-pixel-format-4-tiled-mtl-mc-ccs) [440.469217] Starting subtest: bad-pixel-format-4-tiled-mtl-mc-ccs [440.471788] Starting dynamic subtest: pipe-A-eDP-1 [440.492604] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [440.503327] Starting dynamic subtest: pipe-B-eDP-1 [440.523542] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [440.532299] Starting dynamic subtest: pipe-C-eDP-1 [440.552004] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [440.562029] Starting dynamic subtest: pipe-D-eDP-1 [440.581097] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [440.583231] Subtest bad-pixel-format-4-tiled-mtl-mc-ccs: SUCCESS (0.007s) [442.628376] [116/130] (593s left) kms_frontbuffer_tracking (psr-slowdraw) [442.729121] Starting subtest: psr-slowdraw [465.776843] Subtest psr-slowdraw: SUCCESS (23.048s) [465.928972] [117/130] (570s left) vgem_basic (dmabuf-fence) [465.976953] Starting subtest: dmabuf-fence [465.979229] Subtest dmabuf-fence: SUCCESS (0.000s) [466.029014] [118/130] (570s left) kms_chamelium_audio (dp-audio) [466.421271] Subtest dp-audio: SKIP (0.000s) [467.184370] [119/130] (569s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode) [467.588562] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s) [468.404581] [120/130] (568s left) kms_psr (psr2-sprite-plane-move) [468.507818] Starting subtest: psr2-sprite-plane-move [468.510119] Starting dynamic subtest: eDP-1 [470.252968] Dynamic subtest eDP-1: SUCCESS (1.743s) [470.255307] Subtest psr2-sprite-plane-move: SUCCESS (1.744s) [471.079836] [121/130] (565s left) gem_exec_nop (basic-series) [471.158894] Starting subtest: basic-series [487.352794] Subtest basic-series: SUCCESS (16.197s) [487.562640] [122/130] (549s left) kms_dither (fb-8bpc-vs-panel-8bpc) [487.664539] Starting subtest: fb-8bpc-vs-panel-8bpc [487.666764] Starting dynamic subtest: pipe-A-eDP-1 [489.049544] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.383s) [489.052329] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.384s) [489.837617] [123/130] (547s left) i915_pciid [489.985055] [124/130] (546s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-wc) [490.090740] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-wc [494.556060] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-wc: SUCCESS (4.467s) [494.698239] [125/130] (542s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt) [494.811788] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt [494.816207] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [494.919372] [126/130] (542s left) prime_vgem (fence-read-hang) [494.995031] Subtest fence-read-hang: SKIP (0.000s) [495.098067] [127/130] (541s left) kms_atomic (crtc-invalid-params) [495.185487] Starting subtest: crtc-invalid-params [495.187805] Starting dynamic subtest: pipe-A-eDP-1 [495.587239] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.400s) [495.589627] Subtest crtc-invalid-params: SUCCESS (0.401s) [496.425361] [128/130] (540s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs) [496.532526] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs [496.534728] Starting dynamic subtest: pipe-A-eDP-1 [496.556655] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [496.565891] Starting dynamic subtest: pipe-B-eDP-1 [496.587197] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [496.595875] Starting dynamic subtest: pipe-C-eDP-1 [496.617860] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [496.626572] Starting dynamic subtest: pipe-D-eDP-1 [496.649655] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [496.653713] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.005s) [498.673471] [129/130] (538s left) gem_exec_balancer (individual) [498.754810] Starting subtest: individual [500.323943] Subtest individual: SUCCESS (1.567s) [500.633131] [130/130] (536s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc) [500.727024] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc [500.731480] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [500.823125] Closing watchdogs results: parsing output: 0/ for test: gem_mmap_wc results: parsing output: 1/ for test: gem_exec_reloc results: parsing output: 2/ for test: kms_big_fb results: parsing output: 3/ for test: gem_vm_create results: parsing output: 4/ for test: vgem_slow results: parsing output: 5/ for test: gen9_exec_parse results: parsing output: 6/ for test: gem_mmap_gtt results: parsing output: 7/ for test: kms_flip results: parsing output: 8/ for test: kms_selftest results: parsing output: 9/ for test: kms_busy results: parsing output: 10/ for test: sysfs_timeslice_duration results: parsing output: 11/ for test: kms_frontbuffer_tracking results: parsing output: 12/ for test: syncobj_wait results: parsing output: 13/ for test: kms_psr2_su results: parsing output: 14/ for test: kms_frontbuffer_tracking results: parsing output: 15/ for test: kms_frontbuffer_tracking results: parsing output: 16/ for test: kms_rmfb results: parsing output: 17/ for test: syncobj_wait results: parsing output: 18/ for test: gem_exec_endless results: parsing output: 19/ for test: kms_ccs results: parsing output: 20/ for test: kms_psr results: parsing output: 21/ for test: kms_frontbuffer_tracking results: parsing output: 22/ for test: kms_flip results: parsing output: 23/ for test: drm_fdinfo results: parsing output: 24/ for test: kms_pm_rpm results: parsing output: 25/ for test: kms_big_fb results: parsing output: 26/ for test: gem_exec_reloc results: parsing output: 27/ for test: kms_frontbuffer_tracking results: parsing output: 28/ for test: perf results: parsing output: 29/ for test: kms_big_fb results: parsing output: 30/ for test: gem_ctx_persistence results: parsing output: 31/ for test: kms_cursor_legacy results: parsing output: 32/ for test: gem_exec_params results: parsing output: 33/ for test: syncobj_wait results: parsing output: 34/ for test: gem_exec_schedule results: parsing output: 35/ for test: syncobj_timeline results: parsing output: 36/ for test: kms_flip results: parsing output: 37/ for test: core_auth results: parsing output: 38/ for test: kms_psr2_sf results: parsing output: 39/ for test: kms_invalid_mode results: parsing output: 40/ for test: gem_eio results: parsing output: 41/ for test: kms_chamelium_edid results: parsing output: 42/ for test: kms_frontbuffer_tracking results: parsing output: 43/ for test: prime_self_import results: parsing output: 44/ for test: kms_big_fb results: parsing output: 45/ for test: gem_softpin results: parsing output: 46/ for test: kms_big_fb results: parsing output: 47/ for test: kms_plane_multiple results: parsing output: 48/ for test: kms_flip results: parsing output: 49/ for test: kms_frontbuffer_tracking results: parsing output: 50/ for test: gem_exec_reloc results: parsing output: 51/ for test: gem_ctx_persistence results: parsing output: 52/ for test: kms_frontbuffer_tracking results: parsing output: 53/ for test: kms_pm_dc results: parsing output: 54/ for test: api_intel_allocator results: parsing output: 55/ for test: kms_frontbuffer_tracking results: parsing output: 56/ for test: syncobj_timeline results: parsing output: 57/ for test: gem_pread results: parsing output: 58/ for test: kms_ccs results: parsing output: 59/ for test: kms_cursor_crc results: parsing output: 60/ for test: gem_readwrite results: parsing output: 61/ for test: kms_vblank results: parsing output: 62/ for test: kms_frontbuffer_tracking results: parsing output: 63/ for test: i915_pm_rps results: parsing output: 64/ for test: kms_psr2_sf results: parsing output: 65/ for test: kms_cursor_crc results: parsing output: 66/ for test: kms_flip_scaled_crc results: parsing output: 67/ for test: gem_bad_reloc results: parsing output: 68/ for test: gem_readwrite results: parsing output: 69/ for test: syncobj_wait results: parsing output: 70/ for test: gem_lmem_swapping results: parsing output: 71/ for test: gem_exec_schedule results: parsing output: 72/ for test: i915_query results: parsing output: 73/ for test: gem_exec_whisper results: parsing output: 74/ for test: kms_vrr results: parsing output: 75/ for test: kms_cursor_legacy results: parsing output: 76/ for test: kms_atomic results: parsing output: 77/ for test: kms_frontbuffer_tracking results: parsing output: 78/ for test: kms_lease results: parsing output: 79/ for test: sw_sync results: parsing output: 80/ for test: kms_frontbuffer_tracking results: parsing output: 81/ for test: kms_content_protection results: parsing output: 82/ for test: gem_exec_fence results: parsing output: 83/ for test: gem_render_copy results: parsing output: 84/ for test: kms_frontbuffer_tracking results: parsing output: 85/ for test: kms_pipe_crc_basic results: parsing output: 86/ for test: gem_pxp results: parsing output: 87/ for test: gem_ctx_exec results: parsing output: 88/ for test: kms_color results: parsing output: 89/ for test: gem_spin_batch results: parsing output: 90/ for test: perf_pmu results: parsing output: 91/ for test: kms_frontbuffer_tracking results: parsing output: 92/ for test: perf_pmu results: parsing output: 93/ for test: kms_addfb_basic results: parsing output: 94/ for test: drm_mm results: parsing output: 95/ for test: kms_getfb results: parsing output: 96/ for test: gem_exec_store results: parsing output: 97/ for test: perf results: parsing output: 98/ for test: sw_sync results: parsing output: 99/ for test: drm_read results: parsing output: 100/ for test: kms_psr results: parsing output: 101/ for test: kms_flip results: parsing output: 102/ for test: kms_hdr results: parsing output: 103/ for test: kms_feature_discovery results: parsing output: 104/ for test: kms_psr results: parsing output: 105/ for test: syncobj_timeline results: parsing output: 106/ for test: gem_mmap_offset results: parsing output: 107/ for test: syncobj_timeline results: parsing output: 108/ for test: sriov_basic results: parsing output: 109/ for test: kms_plane_scaling results: parsing output: 110/ for test: kms_psr results: parsing output: 111/ for test: prime_vgem results: parsing output: 112/ for test: gem_exec_create results: parsing output: 113/ for test: gem_render_copy results: parsing output: 114/ for test: kms_ccs results: parsing output: 115/ for test: kms_frontbuffer_tracking results: parsing output: 116/ for test: vgem_basic results: parsing output: 117/ for test: kms_chamelium_audio results: parsing output: 118/ for test: kms_chamelium_hpd results: parsing output: 119/ for test: kms_psr results: parsing output: 120/ for test: gem_exec_nop results: parsing output: 121/ for test: kms_dither results: parsing output: 122/ for test: i915_pciid results: parsing output: 123/ for test: kms_frontbuffer_tracking results: parsing output: 124/ for test: kms_frontbuffer_tracking results: parsing output: 125/ for test: prime_vgem results: parsing output: 126/ for test: kms_atomic results: parsing output: 127/ for test: kms_ccs results: parsing output: 128/ for test: gem_exec_balancer results: parsing output: 129/ for test: kms_frontbuffer_tracking Done.