[58.374104] Initializing watchdogs [58.374184] /dev/watchdog0 [58.388206] [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.392910] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [58.395182] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [58.398236] [001/133] (960s left) kms_atomic_transition (plane-all-transition-fencing) [58.516697] Starting subtest: plane-all-transition-fencing [58.519133] Starting dynamic subtest: pipe-A-eDP-1 [61.051947] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.540s) [61.356352] Starting dynamic subtest: pipe-B-eDP-1 [64.571397] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.227s) [64.876677] Subtest plane-all-transition-fencing: SUCCESS (6.367s) [65.693688] [002/133] (953s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu) [65.798664] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu [69.753918] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (3.961s) [70.898329] [003/133] (948s left) kms_pm_rpm (dpms-mode-unset-lpsp) [73.059672] Starting subtest: dpms-mode-unset-lpsp [77.132811] Subtest dpms-mode-unset-lpsp: SUCCESS (4.077s) [77.510833] [004/133] (941s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling) [77.609271] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling [77.613866] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-upscaling: SKIP (0.000s) [77.709913] [005/133] (941s left) gem_pxp (fail-invalid-protected-context) [77.839240] Starting subtest: fail-invalid-protected-context [77.841722] Subtest fail-invalid-protected-context: SUCCESS (0.000s) [77.944510] [006/133] (941s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt) [78.041199] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt [78.045217] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [78.132749] [007/133] (941s left) kms_selftest (drm_cmdline_parser) [78.168524] Starting subtest: drm_cmdline_parser [78.181066] Starting dynamic subtest: drm_test_cmdline_force_d_only [78.274078] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.093s) [78.282647] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi [78.382897] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.108s) [78.391253] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi [78.490688] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.109s) [78.499082] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital [78.610074] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.117s) [78.618738] Starting dynamic subtest: drm_test_cmdline_force_e_only [78.704193] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.095s) [78.712650] Starting dynamic subtest: drm_test_cmdline_res [78.799391] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.095s) [78.807529] Starting dynamic subtest: drm_test_cmdline_res_vesa [78.888472] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.090s) [78.896629] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank [78.971092] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.082s) [78.979753] Starting dynamic subtest: drm_test_cmdline_res_rblank [79.049343] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.078s) [79.057377] Starting dynamic subtest: drm_test_cmdline_res_bpp [79.141354] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.092s) [79.149811] Starting dynamic subtest: drm_test_cmdline_res_refresh [79.228554] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.087s) [79.236591] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh [79.321906] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.093s) [79.330564] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced [79.408624] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.086s) [79.417479] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins [79.496783] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.088s) [79.505440] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off [79.598779] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.101s) [79.607488] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on [79.696750] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.100s) [79.705196] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog [79.803989] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.106s) [79.812479] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital [79.912772] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.109s) [79.921306] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on [80.013063] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.099s) [80.021794] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on [80.117162] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.104s) [80.125238] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins [80.204900] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.087s) [80.213154] Starting dynamic subtest: drm_test_cmdline_name [80.303072] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.099s) [80.311106] Starting dynamic subtest: drm_test_cmdline_name_bpp [80.414062] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.110s) [80.422027] Starting dynamic subtest: drm_test_cmdline_name_option [80.514945] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.101s) [80.522597] Starting dynamic subtest: drm_test_cmdline_name_bpp_option [80.634468] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.117s) [80.643155] Starting dynamic subtest: drm_test_cmdline_rotate_0 [80.718842] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.084s) [80.726524] Starting dynamic subtest: drm_test_cmdline_rotate_90 [80.810988] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.091s) [80.818136] Starting dynamic subtest: drm_test_cmdline_rotate_180 [80.925683] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.114s) [80.934479] Starting dynamic subtest: drm_test_cmdline_rotate_270 [81.042562] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.115s) [81.051403] Starting dynamic subtest: drm_test_cmdline_hmirror [81.139508] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.097s) [81.148269] Starting dynamic subtest: drm_test_cmdline_vmirror [81.226464] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.086s) [81.235697] Starting dynamic subtest: drm_test_cmdline_margin_options [81.309454] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.083s) [81.317972] Starting dynamic subtest: drm_test_cmdline_multiple_options [81.402463] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.093s) [81.411217] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option [81.521639] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.117s) [81.530620] Starting dynamic subtest: drm_test_cmdline_extra_and_option [81.633582] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.112s) [81.642173] Starting dynamic subtest: drm_test_cmdline_freestanding_options [81.742580] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.109s) [81.750988] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options [81.852989] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.110s) [81.865282] Starting dynamic subtest: drm_test_cmdline_panel_orientation [81.960440] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.106s) [81.968074] Starting dynamic subtest: drm_test_cmdline_invalid [82.057206] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.097s) [82.064269] Starting dynamic subtest: drm_test_cmdline_tv_options [82.169350] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.111s) [82.171520] Subtest drm_cmdline_parser: SUCCESS (4.003s) [82.320736] [008/133] (936s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180) [82.440911] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180 [82.445348] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s) [82.526403] [009/133] (936s left) api_intel_bb (object-reloc-purge-cache) [82.580546] Starting subtest: object-reloc-purge-cache [82.584481] Subtest object-reloc-purge-cache: SKIP (0.003s) [82.678208] [010/133] (936s left) gem_ctx_shared (disjoint-timelines) [82.738284] Starting subtest: disjoint-timelines [82.774123] Subtest disjoint-timelines: SUCCESS (0.036s) [83.011527] [FACT gem_ctx_shared (disjoint-timelines)] new: kernel.kmod_is_loaded.vgem: true [83.015135] [011/133] (936s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt) [83.105724] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt [86.891571] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (3.790s) [88.021351] [012/133] (931s left) gem_exec_params (cliprects-invalid) [88.095759] Starting subtest: cliprects-invalid [88.098172] Subtest cliprects-invalid: SUCCESS (0.000s) [88.192411] [013/133] (931s left) gem_userptr_blits (dmabuf-unsync) [88.272385] Subtest dmabuf-unsync: SKIP (0.000s) [88.392160] [014/133] (931s left) i915_pm_rpm (reg-read-ioctl) [90.119064] Starting subtest: reg-read-ioctl [92.405779] Subtest reg-read-ioctl: SUCCESS (2.290s) [92.785056] [015/133] (926s left) sw_sync (sync_expired_merge) [92.828788] Starting subtest: sync_expired_merge [93.900949] Subtest sync_expired_merge: SUCCESS (1.074s) [93.959917] [016/133] (925s left) gem_ctx_persistence (legacy-engines-mixed-process) [94.009965] Starting subtest: legacy-engines-mixed-process [94.012320] Starting dynamic subtest: render [95.900817] Dynamic subtest render: SUCCESS (1.891s) [95.909119] Starting dynamic subtest: bsd1 [97.947211] Dynamic subtest bsd1: SUCCESS (2.043s) [97.955151] Starting dynamic subtest: bsd2 [99.908021] Dynamic subtest bsd2: SUCCESS (1.959s) [99.915717] Starting dynamic subtest: blt [101.918104] Dynamic subtest blt: SUCCESS (2.012s) [101.928043] Starting dynamic subtest: vebox [103.895611] Dynamic subtest vebox: SUCCESS (1.976s) [103.897964] Subtest legacy-engines-mixed-process: SUCCESS (9.887s) [103.978809] [017/133] (915s left) kms_vblank (wait-busy) [104.081074] Starting subtest: wait-busy [104.083421] Starting dynamic subtest: pipe-A-eDP-1 [105.961646] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.879s) [105.975105] Starting dynamic subtest: pipe-D-eDP-1 [108.543734] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.580s) [108.546193] Subtest wait-busy: SUCCESS (4.462s) [109.341126] [018/133] (910s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc) [109.429034] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc [109.433419] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [109.526487] [019/133] (910s left) kms_cursor_crc (cursor-onscreen-32x32) [109.673643] Starting subtest: cursor-onscreen-32x32 [109.719283] Subtest cursor-onscreen-32x32: SKIP (0.040s) [110.000297] [020/133] (909s left) perf (whitelisted-registers-userspace-config) [110.127246] Starting subtest: whitelisted-registers-userspace-config [110.129723] Subtest whitelisted-registers-userspace-config: SUCCESS (0.000s) [110.173487] [021/133] (909s left) kms_setmode (basic) [110.228696] Starting subtest: basic [110.548262] Starting dynamic subtest: pipe-A-eDP-1 [112.661844] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.108s) [113.000812] Starting dynamic subtest: pipe-B-eDP-1 [115.096059] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.097s) [115.406694] Subtest basic: SUCCESS (5.176s) [116.251780] [022/133] (903s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs) [116.359261] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs [116.361483] Starting dynamic subtest: pipe-A-eDP-1 [116.617725] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.228s) [116.628278] Starting dynamic subtest: pipe-B-eDP-1 [117.895854] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.275s) [117.906475] Starting dynamic subtest: pipe-C-eDP-1 [119.101514] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.207s) [119.111651] Starting dynamic subtest: pipe-D-eDP-1 [120.350708] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.248s) [120.353174] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (3.961s) [121.459171] [023/133] (898s left) gem_exec_capture (capture-invisible) [121.531217] Starting subtest: capture-invisible [121.533625] Starting dynamic subtest: smem0 [121.538320] Dynamic subtest smem0: SKIP (0.000s) [121.542970] Subtest capture-invisible: SKIP (0.000s) [121.647287] [024/133] (898s left) gem_fenced_exec_thrash (no-spare-fences) [121.709065] Subtest no-spare-fences: SKIP (0.000s) [121.782017] [025/133] (898s left) kms_flip (modeset-vs-vblank-race) [121.888526] Starting subtest: modeset-vs-vblank-race [121.890904] Starting dynamic subtest: A-eDP1 [126.587641] Dynamic subtest A-eDP1: SUCCESS (4.701s) [126.597397] Starting dynamic subtest: B-eDP1 [131.305445] Dynamic subtest B-eDP1: SUCCESS (4.715s) [131.316853] Starting dynamic subtest: C-eDP1 [135.932196] Dynamic subtest C-eDP1: SUCCESS (4.625s) [135.940402] Starting dynamic subtest: D-eDP1 [140.549092] Dynamic subtest D-eDP1: SUCCESS (4.615s) [140.554377] Subtest modeset-vs-vblank-race: SUCCESS (18.668s) [141.741501] [026/133] (878s left) gem_mmap_gtt (cpuset-medium-copy) [141.809984] Subtest cpuset-medium-copy: SKIP (0.000s) [141.878923] [027/133] (878s left) gem_eio (in-flight-immediate) [142.064722] Starting subtest: in-flight-immediate [150.269300] Subtest in-flight-immediate: SUCCESS (8.205s) [150.392115] [028/133] (869s left) gem_userptr_blits (sd-probe) [150.449847] Starting subtest: sd-probe [150.451778] Subtest sd-probe: SUCCESS (0.000s) [150.583499] [029/133] (869s left) kms_addfb_basic (addfb25-y-tiled-legacy) [150.675421] Starting subtest: addfb25-y-tiled-legacy [150.677552] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [150.764899] [030/133] (869s left) syncobj_wait (invalid-single-wait-unsubmitted) [150.811943] Starting subtest: invalid-single-wait-unsubmitted [150.814352] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s) [150.905443] [031/133] (869s left) fbdev (read) [150.946795] Starting subtest: read [151.470223] Subtest read: SUCCESS (0.522s) [151.534123] [032/133] (868s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180) [151.630698] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180 [152.722607] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.093s) [152.829616] [033/133] (867s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format) [152.925473] Starting subtest: plane-upscale-20x20-with-pixel-format [152.927473] Starting dynamic subtest: pipe-A [153.973690] Dynamic subtest pipe-A: SUCCESS (1.050s) [153.983871] Starting dynamic subtest: pipe-B [156.107514] Dynamic subtest pipe-B: SUCCESS (2.133s) [156.115573] Starting dynamic subtest: pipe-C [157.302363] Dynamic subtest pipe-C: SUCCESS (1.193s) [157.311398] Starting dynamic subtest: pipe-D [158.452126] Dynamic subtest pipe-D: SUCCESS (1.149s) [158.454264] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.529s) [159.652289] [034/133] (860s left) gem_exec_parallel (userptr) [159.711327] Starting subtest: userptr [159.713661] Starting dynamic subtest: rcs0 [161.098783] Dynamic subtest rcs0: SUCCESS (1.387s) [161.109286] Starting dynamic subtest: bcs0 [162.573864] Dynamic subtest bcs0: SUCCESS (1.474s) [162.583944] Starting dynamic subtest: vcs0 [163.964088] Dynamic subtest vcs0: SUCCESS (1.388s) [163.975318] Starting dynamic subtest: vcs1 [165.909225] Dynamic subtest vcs1: SUCCESS (1.942s) [165.921635] Starting dynamic subtest: vecs0 [167.894420] Dynamic subtest vecs0: SUCCESS (1.984s) [167.905048] Starting dynamic subtest: ccs0 [169.392329] Dynamic subtest ccs0: SUCCESS (1.497s) [169.394566] Subtest userptr: SUCCESS (9.681s) [169.580144] [035/133] (850s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [169.691570] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip [169.695887] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s) [169.786590] [036/133] (850s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt) [169.894472] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt [169.898788] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [169.988796] [037/133] (850s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled) [170.040906] Starting subtest: etime-multi-wait-all-submitted-signaled [170.146063] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.103s) [170.221822] [038/133] (850s left) gem_eio (in-flight-internal-immediate) [170.440955] Starting subtest: in-flight-internal-immediate [171.926343] Subtest in-flight-internal-immediate: SUCCESS (1.486s) [172.064112] [039/133] (848s left) perf_pmu (render-node-busy-idle) [172.128579] Starting subtest: render-node-busy-idle [172.131106] Starting dynamic subtest: rcs0 [172.817704] Dynamic subtest rcs0: SUCCESS (0.688s) [172.829076] Starting dynamic subtest: bcs0 [173.479641] Dynamic subtest bcs0: SUCCESS (0.659s) [173.490837] Starting dynamic subtest: vcs0 [174.932979] Dynamic subtest vcs0: SUCCESS (1.449s) [174.943158] Starting dynamic subtest: vcs1 [176.915958] Dynamic subtest vcs1: SUCCESS (1.980s) [176.928434] Starting dynamic subtest: vecs0 [178.900883] Dynamic subtest vecs0: SUCCESS (1.982s) [178.912876] Starting dynamic subtest: ccs0 [179.570450] Dynamic subtest ccs0: SUCCESS (0.668s) [179.573185] Subtest render-node-busy-idle: SUCCESS (7.442s) [179.646829] [040/133] (840s left) gem_exec_schedule (preempt-user) [179.729853] Starting subtest: preempt-user [179.731836] Starting dynamic subtest: rcs0 [179.756053] Dynamic subtest rcs0: SUCCESS (0.032s) [179.765186] Starting dynamic subtest: bcs0 [179.787258] Dynamic subtest bcs0: SUCCESS (0.031s) [179.795990] Starting dynamic subtest: vcs0 [179.809096] Dynamic subtest vcs0: SUCCESS (0.021s) [179.819630] Starting dynamic subtest: vcs1 [179.832641] Dynamic subtest vcs1: SUCCESS (0.023s) [179.843509] Starting dynamic subtest: vecs0 [179.857429] Dynamic subtest vecs0: SUCCESS (0.024s) [179.866206] Starting dynamic subtest: ccs0 [179.887724] Dynamic subtest ccs0: SUCCESS (0.030s) [179.889925] Subtest preempt-user: SUCCESS (0.165s) [180.956615] [041/133] (839s left) syncobj_wait (single-wait-submitted) [181.014071] Starting subtest: single-wait-submitted [181.120971] Subtest single-wait-submitted: SUCCESS (0.107s) [181.213793] [042/133] (839s left) kms_flip (nonblocking-read) [181.300867] Starting subtest: nonblocking-read [181.303014] Subtest nonblocking-read: SUCCESS (0.000s) [181.421500] [043/133] (839s left) kms_invalid_mode (clock-too-high) [181.507164] Starting subtest: clock-too-high [181.509434] Starting dynamic subtest: pipe-A-eDP-1 [181.513581] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [181.522784] Starting dynamic subtest: pipe-B-eDP-1 [181.526712] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [181.535072] Starting dynamic subtest: pipe-C-eDP-1 [181.539147] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [181.547589] Starting dynamic subtest: pipe-D-eDP-1 [181.551751] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [181.556103] Subtest clock-too-high: SKIP (0.005s) [181.592467] [044/133] (839s left) kms_chamelium_frames (dp-crc-single) [181.983557] Subtest dp-crc-single: SKIP (0.000s) [182.772099] [045/133] (837s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt) [182.877755] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt [182.881967] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s) [182.976559] [046/133] (837s left) kms_plane_multiple (tiling-4) [183.067204] Starting subtest: tiling-4 [183.069412] Starting dynamic subtest: pipe-A-eDP-1 [186.837510] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.768s) [186.846905] Starting dynamic subtest: pipe-B-eDP-1 [191.264721] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.426s) [191.275026] Starting dynamic subtest: pipe-C-eDP-1 [195.595197] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.329s) [195.605087] Starting dynamic subtest: pipe-D-eDP-1 [200.052917] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.458s) [200.055219] Subtest tiling-4: SUCCESS (16.987s) [200.866951] [047/133] (819s left) gen3_render_linear_blits [201.006328] [048/133] (819s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render) [201.102524] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render [201.106593] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [201.207462] [049/133] (819s left) api_intel_bb (blit-reloc-keep-cache) [201.262987] Starting subtest: blit-reloc-keep-cache [201.267136] Subtest blit-reloc-keep-cache: SKIP (0.001s) [201.384693] [050/133] (819s left) gem_exec_fence (long-history) [201.838279] Starting subtest: long-history [208.632162] Subtest long-history: SUCCESS (6.794s) [209.156404] [051/133] (811s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling) [209.255690] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling [209.257809] Starting dynamic subtest: pipe-A-default-mode [210.414740] Dynamic subtest pipe-A-default-mode: SKIP (1.156s) [210.418793] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.158s) [210.572123] [052/133] (810s left) kms_getfb (getfb-handle-zero) [210.671354] Starting subtest: getfb-handle-zero [210.673505] Subtest getfb-handle-zero: SUCCESS (0.000s) [210.779587] [053/133] (810s left) gem_readwrite (write-bad-handle) [210.838178] Subtest write-bad-handle: SKIP (0.000s) [210.905279] [054/133] (810s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move) [210.997600] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move [211.001962] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [211.086875] [055/133] (810s left) gem_basic (create-fd-close) [211.134184] Starting subtest: create-fd-close [211.138724] Subtest create-fd-close: SUCCESS (0.000s) [211.240094] [056/133] (809s left) gem_mmap_offset (oob-read) [211.304575] Starting subtest: oob-read [211.306542] Subtest oob-read: SUCCESS (0.000s) [211.404067] [057/133] (809s left) prime_busy (before-wait) [211.465995] Starting subtest: before-wait [211.470475] Starting dynamic subtest: rcs0 [211.500037] Dynamic subtest rcs0: SUCCESS (0.031s) [211.509962] Starting dynamic subtest: bcs0 [211.547936] Dynamic subtest bcs0: SUCCESS (0.047s) [211.557115] Starting dynamic subtest: vcs0 [211.587514] Dynamic subtest vcs0: SUCCESS (0.038s) [211.595936] Starting dynamic subtest: vcs1 [211.628283] Dynamic subtest vcs1: SUCCESS (0.040s) [211.636929] Starting dynamic subtest: vecs0 [211.670317] Dynamic subtest vecs0: SUCCESS (0.041s) [211.679351] Starting dynamic subtest: ccs0 [211.712155] Dynamic subtest ccs0: SUCCESS (0.041s) [211.820870] Subtest before-wait: SUCCESS (0.352s) [211.909204] [058/133] (809s left) gem_exec_balancer (full-late-pulse) [211.962897] Starting subtest: full-late-pulse [216.752623] Subtest full-late-pulse: SUCCESS (4.792s) [217.048743] [059/133] (804s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode) [217.431396] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s) [218.209137] [060/133] (803s left) kms_flip (flip-vs-rmfb) [218.299371] Starting subtest: flip-vs-rmfb [218.301809] Starting dynamic subtest: A-eDP1 [226.940280] Dynamic subtest A-eDP1: SUCCESS (8.641s) [226.950903] Starting dynamic subtest: B-eDP1 [235.568524] Dynamic subtest B-eDP1: SUCCESS (8.625s) [235.580322] Starting dynamic subtest: C-eDP1 [244.190860] Dynamic subtest C-eDP1: SUCCESS (8.619s) [244.202198] Starting dynamic subtest: D-eDP1 [252.822677] Dynamic subtest D-eDP1: SUCCESS (8.629s) [252.827079] Subtest flip-vs-rmfb: SUCCESS (34.529s) [254.013371] [061/133] (767s left) gem_exec_whisper (basic-fds-forked) [254.071874] Starting subtest: basic-fds-forked [277.779129] Subtest basic-fds-forked: SUCCESS (23.699s) [277.977762] [062/133] (743s left) kms_content_protection (dp-mst-type-0-suspend-resume) [278.119518] Starting subtest: dp-mst-type-0-suspend-resume [278.123991] Subtest dp-mst-type-0-suspend-resume: SKIP (0.000s) [278.254573] [063/133] (743s left) gem_exec_schedule (pi-shared-iova) [278.438230] Starting subtest: pi-shared-iova [278.440683] Starting dynamic subtest: rcs0 [278.515197] Dynamic subtest rcs0: SUCCESS (0.079s) [278.530014] Starting dynamic subtest: vcs0 [278.572645] Dynamic subtest vcs0: SUCCESS (0.057s) [278.586201] Starting dynamic subtest: vcs1 [278.631601] Dynamic subtest vcs1: SUCCESS (0.058s) [278.642052] Starting dynamic subtest: vecs0 [278.686516] Dynamic subtest vecs0: SUCCESS (0.054s) [278.696930] Starting dynamic subtest: ccs0 [278.754841] Dynamic subtest ccs0: SUCCESS (0.067s) [278.757284] Subtest pi-shared-iova: SUCCESS (0.321s) [279.992916] [064/133] (741s left) perf_pmu (busy) [280.037452] Starting subtest: busy [280.039829] Starting dynamic subtest: rcs0 [280.622587] Dynamic subtest rcs0: SUCCESS (0.584s) [280.634271] Starting dynamic subtest: bcs0 [281.190195] Dynamic subtest bcs0: SUCCESS (0.565s) [281.201648] Starting dynamic subtest: vcs0 [282.900833] Dynamic subtest vcs0: SUCCESS (1.706s) [282.912706] Starting dynamic subtest: vcs1 [284.885238] Dynamic subtest vcs1: SUCCESS (1.981s) [284.898105] Starting dynamic subtest: vecs0 [286.933548] Dynamic subtest vecs0: SUCCESS (2.045s) [286.945527] Starting dynamic subtest: ccs0 [287.498057] Dynamic subtest ccs0: SUCCESS (0.563s) [287.500984] Subtest busy: SUCCESS (7.461s) [287.612217] [065/133] (733s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0-hflip) [287.712058] Starting subtest: linear-max-hw-stride-64bpp-rotate-0-hflip [287.716575] Subtest linear-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s) [287.835199] [066/133] (733s left) kms_addfb_basic (invalid-set-prop-any) [287.892731] Starting subtest: invalid-set-prop-any [287.894751] Subtest invalid-set-prop-any: SUCCESS (0.000s) [288.045526] [067/133] (733s left) gem_softpin (full) [288.106853] Starting subtest: full [288.114108] Subtest full: SUCCESS (0.008s) [288.228802] [068/133] (733s left) gem_render_copy (x-tiled-to-vebox-y-tiled) [288.282659] Starting subtest: x-tiled-to-vebox-y-tiled [288.286850] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s) [288.464451] [069/133] (733s left) kms_frontbuffer_tracking (psr-suspend) [288.564150] Starting subtest: psr-suspend [327.532829] Subtest psr-suspend: SUCCESS (8.153s) [327.645587] [070/133] (694s left) kms_flip (basic-plain-flip) [327.749738] Starting subtest: basic-plain-flip [327.752094] Starting dynamic subtest: A-eDP1 [329.445274] Dynamic subtest A-eDP1: SUCCESS (1.705s) [329.457387] Starting dynamic subtest: B-eDP1 [331.096241] Dynamic subtest B-eDP1: SUCCESS (1.656s) [331.108133] Starting dynamic subtest: C-eDP1 [332.721541] Dynamic subtest C-eDP1: SUCCESS (1.630s) [332.732584] Starting dynamic subtest: D-eDP1 [334.357746] Dynamic subtest D-eDP1: SUCCESS (1.640s) [334.363488] Subtest basic-plain-flip: SUCCESS (6.643s) [335.523131] [071/133] (686s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping) [335.622303] Starting subtest: pixel-format-4-tiled-modifier-source-clamping [335.649071] Starting dynamic subtest: pipe-A-plane-0 [336.291521] Dynamic subtest pipe-A-plane-0: SUCCESS (0.644s) [336.301771] Starting dynamic subtest: pipe-A-plane-3 [336.712573] Dynamic subtest pipe-A-plane-3: SUCCESS (0.421s) [337.811775] Starting dynamic subtest: pipe-B-plane-0 [338.452399] Dynamic subtest pipe-B-plane-0: SUCCESS (0.655s) [338.465353] Starting dynamic subtest: pipe-B-plane-3 [338.851096] Dynamic subtest pipe-B-plane-3: SUCCESS (0.398s) [339.180904] Subtest pixel-format-4-tiled-modifier-source-clamping: SUCCESS (3.566s) [339.995587] [072/133] (681s left) kms_flip (nonexisting-fb-interruptible) [340.090275] Starting subtest: nonexisting-fb-interruptible [340.092660] Starting dynamic subtest: A-eDP1 [341.262612] Dynamic subtest A-eDP1: SUCCESS (1.173s) [341.273635] Starting dynamic subtest: B-eDP1 [342.398430] Dynamic subtest B-eDP1: SUCCESS (1.136s) [342.408441] Starting dynamic subtest: C-eDP1 [343.524008] Dynamic subtest C-eDP1: SUCCESS (1.125s) [343.533588] Starting dynamic subtest: D-eDP1 [344.659333] Dynamic subtest D-eDP1: SUCCESS (1.134s) [344.664493] Subtest nonexisting-fb-interruptible: SUCCESS (4.580s) [345.836407] [073/133] (676s left) i915_drm_fdinfo (most-busy-check-all) [345.877086] Starting subtest: most-busy-check-all [345.879419] Starting dynamic subtest: rcs0 [345.883957] Dynamic subtest rcs0: SKIP (0.004s) [345.901615] Starting dynamic subtest: bcs0 [345.906224] Dynamic subtest bcs0: SKIP (0.000s) [345.915825] Starting dynamic subtest: vcs0 [345.919681] Dynamic subtest vcs0: SKIP (0.000s) [345.928628] Starting dynamic subtest: vcs1 [345.932645] Dynamic subtest vcs1: SKIP (0.000s) [345.941670] Starting dynamic subtest: vecs0 [345.945726] Dynamic subtest vecs0: SKIP (0.000s) [345.955033] Starting dynamic subtest: ccs0 [345.959065] Dynamic subtest ccs0: SKIP (0.000s) [345.963039] Subtest most-busy-check-all: SKIP (0.009s) [346.001528] [074/133] (675s left) gem_ctx_param (invalid-get-no-zeromap) [346.053493] Starting subtest: invalid-get-no-zeromap [346.055838] Subtest invalid-get-no-zeromap: SUCCESS (0.001s) [346.162141] [075/133] (675s left) i915_suspend (fence-restore-tiled2untiled) [346.213568] Starting subtest: fence-restore-tiled2untiled [346.217918] Subtest fence-restore-tiled2untiled: SKIP (0.000s) [346.328524] [076/133] (675s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area) [346.423479] Starting subtest: pr-overlay-primary-update-sf-dmg-area [346.427586] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s) [346.494711] [077/133] (675s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [346.589582] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip [347.311433] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.726s) [347.494068] [078/133] (674s left) kms_chamelium_audio (hdmi-audio) [347.866688] Subtest hdmi-audio: SKIP (0.000s) [348.650272] [079/133] (673s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt) [348.749907] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt [348.754119] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [348.853656] [080/133] (673s left) gem_tiling_max_stride [348.982164] [081/133] (673s left) gem_mmap_wc (copy) [349.045483] Subtest copy: SKIP (0.000s) [349.105213] [082/133] (673s left) kms_psr (fbc-psr2-sprite-plane-move) [349.198750] Starting subtest: fbc-psr2-sprite-plane-move [349.201034] Starting dynamic subtest: eDP-1 [349.205243] Dynamic subtest eDP-1: SKIP (0.000s) [349.209468] Subtest fbc-psr2-sprite-plane-move: SKIP (0.001s) [349.275449] [083/133] (673s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation) [349.366839] Starting subtest: plane-downscale-factor-0-75-with-rotation [349.369085] Starting dynamic subtest: pipe-A [349.595457] Dynamic subtest pipe-A: SUCCESS (0.231s) [349.604497] Starting dynamic subtest: pipe-B [350.872662] Dynamic subtest pipe-B: SUCCESS (1.277s) [350.882307] Starting dynamic subtest: pipe-C [352.203793] Dynamic subtest pipe-C: SUCCESS (1.331s) [352.214483] Starting dynamic subtest: pipe-D [353.530011] Dynamic subtest pipe-D: SUCCESS (1.326s) [353.532465] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (4.169s) [354.705486] [084/133] (667s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move) [354.818217] Starting subtest: fbc-1p-primscrn-cur-indfb-move [358.870377] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.052s) [360.002494] [085/133] (662s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb) [360.099864] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb [360.102109] Starting dynamic subtest: pipe-A-eDP-1 [366.819075] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.718s) [366.828777] Starting dynamic subtest: pipe-B-eDP-1 [373.880553] Dynamic subtest pipe-B-eDP-1: SUCCESS (7.057s) [373.882974] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.779s) [374.760759] [086/133] (647s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-wc) [374.851922] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-wc [381.391290] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.541s) [381.516657] [087/133] (640s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff) [381.610002] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff [388.562954] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.957s) [388.699095] [088/133] (633s left) syncobj_timeline (reset-multiple-signaled) [388.753317] Starting subtest: reset-multiple-signaled [388.755597] Subtest reset-multiple-signaled: SUCCESS (0.000s) [388.851181] [089/133] (633s left) sysfs_preempt_timeout (invalid) [388.901763] Starting subtest: invalid [388.904551] Starting dynamic subtest: vecs0 [388.907360] Dynamic subtest vecs0: SUCCESS (0.000s) [388.920033] Starting dynamic subtest: ccs0 [388.921960] Dynamic subtest ccs0: SUCCESS (0.000s) [388.931170] Starting dynamic subtest: vcs0 [388.933084] Dynamic subtest vcs0: SUCCESS (0.000s) [388.944134] Starting dynamic subtest: bcs0 [388.945971] Dynamic subtest bcs0: SUCCESS (0.000s) [388.955560] Starting dynamic subtest: rcs0 [388.957708] Dynamic subtest rcs0: SUCCESS (0.000s) [388.966945] Starting dynamic subtest: vcs1 [388.968772] Dynamic subtest vcs1: SUCCESS (0.000s) [388.970610] Subtest invalid: SUCCESS (0.006s) [389.011220] [090/133] (633s left) kms_cursor_legacy (cursora-vs-flipa-varying-size) [389.133124] Starting subtest: cursorA-vs-flipA-varying-size [400.304720] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.170s) [401.142709] [091/133] (621s left) kms_prop_blob (basic) [401.202873] Starting subtest: basic [401.204832] Subtest basic: SUCCESS (0.000s) [401.293013] [092/133] (621s left) kms_ccs (bad-rotation-90-y-tiled-ccs) [401.381890] Starting subtest: bad-rotation-90-y-tiled-ccs [401.384185] Starting dynamic subtest: pipe-A-eDP-1 [401.407112] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [401.418900] Starting dynamic subtest: pipe-B-eDP-1 [401.440216] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [401.449428] Starting dynamic subtest: pipe-C-eDP-1 [401.471151] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [401.482259] Starting dynamic subtest: pipe-D-eDP-1 [401.503043] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [401.507176] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.004s) [403.697033] [093/133] (619s left) kms_psr (psr2-sprite-plane-move) [403.784858] Starting subtest: psr2-sprite-plane-move [403.787071] Starting dynamic subtest: eDP-1 [405.520675] Dynamic subtest eDP-1: SUCCESS (1.736s) [405.522994] Subtest psr2-sprite-plane-move: SUCCESS (1.737s) [406.360380] [094/133] (616s left) gem_exec_flush (basic-wb-set-default) [406.423202] Starting subtest: basic-wb-set-default [411.906930] Subtest basic-wb-set-default: SUCCESS (5.485s) [412.091376] [095/133] (610s left) prime_mmap (test_correct_cpu_write) [412.150093] Starting subtest: test_correct_cpu_write [412.152464] Starting dynamic subtest: test_correct_cpu_write-smem [412.154736] Dynamic subtest test_correct_cpu_write-smem: SUCCESS (0.000s) [412.157042] Subtest test_correct_cpu_write: SUCCESS (0.001s) [412.241461] [096/133] (610s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc) [412.334848] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc [412.336974] Starting dynamic subtest: pipe-A-eDP-1 [412.364194] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [412.375465] Starting dynamic subtest: pipe-B-eDP-1 [412.396323] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [412.405377] Starting dynamic subtest: pipe-C-eDP-1 [412.425865] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [412.434769] Starting dynamic subtest: pipe-D-eDP-1 [412.455555] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [412.459703] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.004s) [414.615299] [097/133] (608s left) sw_sync (alloc_merge_fence) [414.658502] Starting subtest: alloc_merge_fence [414.661037] Subtest alloc_merge_fence: SUCCESS (0.000s) [414.715677] [098/133] (608s left) syncobj_timeline (invalid-signal-bad-pad) [414.782516] Starting subtest: invalid-signal-bad-pad [414.784872] Subtest invalid-signal-bad-pad: SUCCESS (0.000s) [414.890370] [099/133] (608s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-fully-sf) [414.989951] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-fully-sf [414.993909] Subtest fbc-pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s) [415.069536] [100/133] (607s left) kms_psr (psr-sprite-plane-onoff) [415.163883] Starting subtest: psr-sprite-plane-onoff [415.166098] Starting dynamic subtest: eDP-1 [416.965888] Dynamic subtest eDP-1: SUCCESS (1.802s) [416.968287] Subtest psr-sprite-plane-onoff: SUCCESS (1.803s) [417.781973] [101/133] (605s left) i915_drm_fdinfo (virtual-busy-hang-all) [417.831445] Starting subtest: virtual-busy-hang-all [417.835907] Subtest virtual-busy-hang-all: SKIP (0.000s) [417.893077] [102/133] (605s left) gem_gpgpu_fill (basic) [417.954556] Starting subtest: basic [417.956848] Starting dynamic subtest: smem [417.961628] Dynamic subtest smem: SUCCESS (0.007s) [417.963975] Subtest basic: SUCCESS (0.008s) [418.085295] [103/133] (605s left) kms_psr (fbc-psr2-primary-page-flip) [418.173239] Starting subtest: fbc-psr2-primary-page-flip [418.175471] Starting dynamic subtest: eDP-1 [418.179610] Dynamic subtest eDP-1: SKIP (0.000s) [418.183856] Subtest fbc-psr2-primary-page-flip: SKIP (0.002s) [418.249292] [104/133] (604s left) kms_getfb (getfb2-handle-zero) [418.331336] Starting subtest: getfb2-handle-zero [418.333452] Subtest getfb2-handle-zero: SUCCESS (0.000s) [418.437842] [105/133] (604s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs) [418.528570] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs [418.530843] Starting dynamic subtest: pipe-A-eDP-1 [418.553042] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [418.563888] Starting dynamic subtest: pipe-B-eDP-1 [418.584931] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [418.593867] Starting dynamic subtest: pipe-C-eDP-1 [418.614552] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [418.623824] Starting dynamic subtest: pipe-D-eDP-1 [418.647073] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [418.651288] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.018s) [420.831460] [106/133] (602s left) kms_psr (pr-suspend) [420.935255] Starting subtest: pr-suspend [420.939390] Subtest pr-suspend: SKIP (0.000s) [421.020435] [107/133] (602s left) gem_flink_basic (double-flink) [421.082499] Starting subtest: double-flink [421.084831] Subtest double-flink: SUCCESS (0.000s) [421.171175] [108/133] (602s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt) [421.266740] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt [421.270954] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [421.415518] [109/133] (602s left) perf (per-context-mode-unprivileged) [421.513069] Starting subtest: per-context-mode-unprivileged [421.517647] Subtest per-context-mode-unprivileged: SKIP (0.000s) [421.557751] [110/133] (601s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size) [421.672001] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size [432.858283] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (11.181s) [433.673681] [111/133] (589s left) dumb_buffer (create-valid-dumb) [433.724759] Starting subtest: create-valid-dumb [433.727109] Subtest create-valid-dumb: SUCCESS (0.000s) [433.813639] [112/133] (589s left) syncobj_timeline (single-wait-all-for-submit-available-signaled) [433.873155] Starting subtest: single-wait-all-for-submit-available-signaled [433.875521] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s) [433.965208] [113/133] (589s left) kms_setmode (clone-exclusive-crtc) [434.020201] Starting subtest: clone-exclusive-crtc [434.026850] Subtest clone-exclusive-crtc: SKIP (0.000s) [434.132002] [114/133] (589s left) syncobj_basic (bad-destroy-pad) [434.188237] Starting subtest: bad-destroy-pad [434.190162] Subtest bad-destroy-pad: SUCCESS (0.000s) [434.277332] [115/133] (589s left) kms_pipe_crc_basic (hang-read-crc) [434.369838] Starting subtest: hang-read-crc [434.372162] Starting dynamic subtest: pipe-A-eDP-1 [436.442650] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.070s) [436.453439] Starting dynamic subtest: pipe-B-eDP-1 [439.213657] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.770s) [439.223510] Starting dynamic subtest: pipe-C-eDP-1 [441.837520] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.621s) [441.848279] Starting dynamic subtest: pipe-D-eDP-1 [444.516450] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.677s) [444.518658] Subtest hang-read-crc: SUCCESS (10.144s) [445.359518] [116/133] (578s left) kms_legacy_colorkey (basic) [445.473839] Starting subtest: basic [445.475655] Starting dynamic subtest: pipe-A [445.517445] Dynamic subtest pipe-A: SUCCESS (0.045s) [445.530009] Starting dynamic subtest: pipe-B [445.532082] Dynamic subtest pipe-B: SUCCESS (0.001s) [445.541239] Starting dynamic subtest: pipe-C [445.543067] Dynamic subtest pipe-C: SUCCESS (0.000s) [445.551755] Starting dynamic subtest: pipe-D [445.553573] Dynamic subtest pipe-D: SUCCESS (0.000s) [445.555425] Subtest basic: SUCCESS (0.050s) [445.592182] [117/133] (578s left) kms_async_flips (test-time-stamp-atomic) [445.670600] Starting subtest: test-time-stamp-atomic [446.051274] Starting dynamic subtest: pipe-A-eDP-1 [446.856818] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.804s) [447.235243] Starting dynamic subtest: pipe-B-eDP-1 [447.985856] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.757s) [448.366236] Starting dynamic subtest: pipe-C-eDP-1 [449.131362] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.770s) [449.519089] Starting dynamic subtest: pipe-D-eDP-1 [450.269573] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.767s) [450.271927] Subtest test-time-stamp-atomic: SUCCESS (4.598s) [451.437848] [118/133] (572s left) kms_cursor_crc (cursor-rapid-movement-512x170) [451.739601] Starting subtest: cursor-rapid-movement-512x170 [451.743290] Subtest cursor-rapid-movement-512x170: SKIP (0.001s) [451.887125] [119/133] (571s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen) [451.981865] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen [451.986094] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [452.086521] [120/133] (571s left) kms_frontbuffer_tracking (fbc-tiling-linear) [452.191333] Starting subtest: fbc-tiling-linear [455.922322] Subtest fbc-tiling-linear: SUCCESS (3.735s) [457.129311] [121/133] (566s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi [457.196213] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted [457.297183] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.101s) [457.376994] [122/133] (566s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d) [457.469698] Starting subtest: plane-lut1d-ctm3x4-lut1d [457.603845] Starting dynamic subtest: pipe-A-plane-0 [457.760485] Dynamic subtest pipe-A-plane-0: SUCCESS (0.155s) [457.770086] Starting dynamic subtest: pipe-A-plane-1 [457.960216] Dynamic subtest pipe-A-plane-1: SUCCESS (0.199s) [457.970643] Starting dynamic subtest: pipe-A-plane-2 [458.136813] Dynamic subtest pipe-A-plane-2: SUCCESS (0.177s) [459.343835] Starting dynamic subtest: pipe-B-plane-0 [459.514134] Dynamic subtest pipe-B-plane-0: SUCCESS (0.177s) [459.524163] Starting dynamic subtest: pipe-B-plane-1 [459.679064] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s) [459.689102] Starting dynamic subtest: pipe-B-plane-2 [459.823645] Dynamic subtest pipe-B-plane-2: SUCCESS (0.144s) [461.048939] Starting dynamic subtest: pipe-C-plane-0 [461.195409] Dynamic subtest pipe-C-plane-0: SUCCESS (0.155s) [461.206176] Starting dynamic subtest: pipe-C-plane-1 [461.328499] Dynamic subtest pipe-C-plane-1: SUCCESS (0.133s) [461.338663] Starting dynamic subtest: pipe-C-plane-2 [461.473110] Dynamic subtest pipe-C-plane-2: SUCCESS (0.143s) [462.714489] Starting dynamic subtest: pipe-D-plane-0 [462.839937] Dynamic subtest pipe-D-plane-0: SUCCESS (0.133s) [462.849579] Starting dynamic subtest: pipe-D-plane-1 [462.984358] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s) [462.996266] Starting dynamic subtest: pipe-D-plane-2 [463.117813] Dynamic subtest pipe-D-plane-2: SUCCESS (0.133s) [463.410322] Subtest plane-lut1d-ctm3x4-lut1d: SUCCESS (5.942s) [464.247038] [123/133] (559s left) kms_cursor_crc (cursor-sliding-64x64) [464.441840] Starting subtest: cursor-sliding-64x64 [464.444037] Starting dynamic subtest: pipe-A-eDP-1 [467.654744] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.210s) [467.681101] Starting dynamic subtest: pipe-D-eDP-1 [471.545598] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.872s) [471.547860] Subtest cursor-sliding-64x64: SUCCESS (7.107s) [472.418314] [124/133] (551s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip) [472.526720] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip [473.494952] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (0.968s) [473.616546] [125/133] (550s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt) [473.731953] Starting subtest: psr-2p-primscrn-indfb-msflip-blt [473.735484] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [473.833252] [126/133] (550s left) gem_render_copy (y-tiled-to-vebox-y-tiled) [473.885727] Starting subtest: y-tiled-to-vebox-y-tiled [473.889631] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s) [474.073808] [127/133] (550s left) gem_create (create-ext-placement-all) [474.236343] Starting subtest: create-ext-placement-all [474.238441] Subtest create-ext-placement-all: SUCCESS (0.000s) [474.331955] [128/133] (549s left) kms_big_fb (y-tiled-addfb-size-overflow) [474.422251] Starting subtest: y-tiled-addfb-size-overflow [474.426430] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s) [474.521875] [129/133] (549s left) gen7_exec_parse (basic-offset) [474.574407] Subtest basic-offset: SKIP (0.000s) [474.646355] [130/133] (549s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-pwrite) [474.735059] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-pwrite [474.739024] Subtest fbc-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [474.828482] [131/133] (549s left) kms_dither (fb-8bpc-vs-panel-8bpc) [474.922042] Starting subtest: fb-8bpc-vs-panel-8bpc [474.924235] Starting dynamic subtest: pipe-A-eDP-1 [476.291674] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.369s) [476.293984] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.370s) [477.159071] [132/133] (547s left) kms_flip (blocking-wf_vblank) [477.270203] Starting subtest: blocking-wf_vblank [477.272389] Starting dynamic subtest: A-eDP1 [486.207001] Dynamic subtest A-eDP1: SUCCESS (8.939s) [486.217039] Starting dynamic subtest: B-eDP1 [495.149091] Dynamic subtest B-eDP1: SUCCESS (8.942s) [495.162246] Starting dynamic subtest: C-eDP1 [504.070700] Dynamic subtest C-eDP1: SUCCESS (8.920s) [504.084437] Starting dynamic subtest: D-eDP1 [512.998276] Dynamic subtest D-eDP1: SUCCESS (8.929s) [513.003298] Subtest blocking-wf_vblank: SUCCESS (35.741s) [514.239222] [133/133] (510s left) kms_dsc (dsc-with-bpc-formats) [514.327101] Starting subtest: dsc-with-bpc-formats [514.439089] Subtest dsc-with-bpc-formats: SKIP (0.003s) [514.475442] Closing watchdogs results: parsing output: 0/ for test: kms_atomic_transition results: parsing output: 1/ for test: kms_frontbuffer_tracking results: parsing output: 2/ for test: kms_pm_rpm results: parsing output: 3/ for test: kms_flip_scaled_crc results: parsing output: 4/ for test: gem_pxp results: parsing output: 5/ for test: kms_frontbuffer_tracking results: parsing output: 6/ for test: kms_selftest results: parsing output: 7/ for test: kms_big_fb results: parsing output: 8/ for test: api_intel_bb results: parsing output: 9/ for test: gem_ctx_shared results: parsing output: 10/ for test: kms_frontbuffer_tracking results: parsing output: 11/ for test: gem_exec_params results: parsing output: 12/ for test: gem_userptr_blits results: parsing output: 13/ for test: i915_pm_rpm results: parsing output: 14/ for test: sw_sync results: parsing output: 15/ for test: gem_ctx_persistence results: parsing output: 16/ for test: kms_vblank results: parsing output: 17/ for test: kms_frontbuffer_tracking results: parsing output: 18/ for test: kms_cursor_crc results: parsing output: 19/ for test: perf results: parsing output: 20/ for test: kms_setmode results: parsing output: 21/ for test: kms_ccs results: parsing output: 22/ for test: gem_exec_capture results: parsing output: 23/ for test: gem_fenced_exec_thrash results: parsing output: 24/ for test: kms_flip results: parsing output: 25/ for test: gem_mmap_gtt results: parsing output: 26/ for test: gem_eio results: parsing output: 27/ for test: gem_userptr_blits results: parsing output: 28/ for test: kms_addfb_basic results: parsing output: 29/ for test: syncobj_wait results: parsing output: 30/ for test: fbdev results: parsing output: 31/ for test: kms_big_fb results: parsing output: 32/ for test: kms_plane_scaling results: parsing output: 33/ for test: gem_exec_parallel results: parsing output: 34/ for test: kms_big_fb results: parsing output: 35/ for test: kms_frontbuffer_tracking results: parsing output: 36/ for test: syncobj_timeline results: parsing output: 37/ for test: gem_eio results: parsing output: 38/ for test: perf_pmu results: parsing output: 39/ for test: gem_exec_schedule results: parsing output: 40/ for test: syncobj_wait results: parsing output: 41/ for test: kms_flip results: parsing output: 42/ for test: kms_invalid_mode results: parsing output: 43/ for test: kms_chamelium_frames results: parsing output: 44/ for test: kms_frontbuffer_tracking results: parsing output: 45/ for test: kms_plane_multiple results: parsing output: 46/ for test: gen3_render_linear_blits results: parsing output: 47/ for test: kms_frontbuffer_tracking results: parsing output: 48/ for test: api_intel_bb results: parsing output: 49/ for test: gem_exec_fence results: parsing output: 50/ for test: kms_flip_scaled_crc results: parsing output: 51/ for test: kms_getfb results: parsing output: 52/ for test: gem_readwrite results: parsing output: 53/ for test: kms_frontbuffer_tracking results: parsing output: 54/ for test: gem_basic results: parsing output: 55/ for test: gem_mmap_offset results: parsing output: 56/ for test: prime_busy results: parsing output: 57/ for test: gem_exec_balancer results: parsing output: 58/ for test: kms_chamelium_hpd results: parsing output: 59/ for test: kms_flip results: parsing output: 60/ for test: gem_exec_whisper results: parsing output: 61/ for test: kms_content_protection results: parsing output: 62/ for test: gem_exec_schedule results: parsing output: 63/ for test: perf_pmu results: parsing output: 64/ for test: kms_big_fb results: parsing output: 65/ for test: kms_addfb_basic results: parsing output: 66/ for test: gem_softpin results: parsing output: 67/ for test: gem_render_copy results: parsing output: 68/ for test: kms_frontbuffer_tracking results: parsing output: 69/ for test: kms_flip results: parsing output: 70/ for test: kms_plane results: parsing output: 71/ for test: kms_flip results: parsing output: 72/ for test: i915_drm_fdinfo results: parsing output: 73/ for test: gem_ctx_param results: parsing output: 74/ for test: i915_suspend results: parsing output: 75/ for test: kms_psr2_sf results: parsing output: 76/ for test: kms_big_fb results: parsing output: 77/ for test: kms_chamelium_audio results: parsing output: 78/ for test: kms_frontbuffer_tracking results: parsing output: 79/ for test: gem_tiling_max_stride results: parsing output: 80/ for test: gem_mmap_wc results: parsing output: 81/ for test: kms_psr results: parsing output: 82/ for test: kms_plane_scaling results: parsing output: 83/ for test: kms_frontbuffer_tracking results: parsing output: 84/ for test: kms_psr2_sf results: parsing output: 85/ for test: kms_frontbuffer_tracking results: parsing output: 86/ for test: kms_frontbuffer_tracking results: parsing output: 87/ for test: syncobj_timeline results: parsing output: 88/ for test: sysfs_preempt_timeout results: parsing output: 89/ for test: kms_cursor_legacy results: parsing output: 90/ for test: kms_prop_blob results: parsing output: 91/ for test: kms_ccs results: parsing output: 92/ for test: kms_psr results: parsing output: 93/ for test: gem_exec_flush results: parsing output: 94/ for test: prime_mmap results: parsing output: 95/ for test: kms_ccs results: parsing output: 96/ for test: sw_sync results: parsing output: 97/ for test: syncobj_timeline results: parsing output: 98/ for test: kms_psr2_sf results: parsing output: 99/ for test: kms_psr results: parsing output: 100/ for test: i915_drm_fdinfo results: parsing output: 101/ for test: gem_gpgpu_fill results: parsing output: 102/ for test: kms_psr results: parsing output: 103/ for test: kms_getfb results: parsing output: 104/ for test: kms_ccs results: parsing output: 105/ for test: kms_psr results: parsing output: 106/ for test: gem_flink_basic results: parsing output: 107/ for test: kms_frontbuffer_tracking results: parsing output: 108/ for test: perf results: parsing output: 109/ for test: kms_cursor_legacy results: parsing output: 110/ for test: dumb_buffer results: parsing output: 111/ for test: syncobj_timeline results: parsing output: 112/ for test: kms_setmode results: parsing output: 113/ for test: syncobj_basic results: parsing output: 114/ for test: kms_pipe_crc_basic results: parsing output: 115/ for test: kms_legacy_colorkey results: parsing output: 116/ for test: kms_async_flips results: parsing output: 117/ for test: kms_cursor_crc results: parsing output: 118/ for test: kms_frontbuffer_tracking results: parsing output: 119/ for test: kms_frontbuffer_tracking results: parsing output: 120/ for test: syncobj_timeline results: parsing output: 121/ for test: kms_color_pipeline results: parsing output: 122/ for test: kms_cursor_crc results: parsing output: 123/ for test: kms_big_fb results: parsing output: 124/ for test: kms_frontbuffer_tracking results: parsing output: 125/ for test: gem_render_copy results: parsing output: 126/ for test: gem_create results: parsing output: 127/ for test: kms_big_fb results: parsing output: 128/ for test: gen7_exec_parse results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: kms_dither results: parsing output: 131/ for test: kms_flip results: parsing output: 132/ for test: kms_dsc Done.