[57.884320] Initializing watchdogs [57.884372] /dev/watchdog0 [57.902206] [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] [57.906998] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.909563] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.912837] [001/155] (960s left) gem_flink_race (flink_name) [57.967323] Starting subtest: flink_name [63.372565] Subtest flink_name: SUCCESS (5.397s) [63.510647] [002/155] (954s left) gem_exec_async (concurrent-writes) [63.571802] Starting subtest: concurrent-writes [63.574154] Starting dynamic subtest: rcs0 [63.601467] Dynamic subtest rcs0: SUCCESS (0.030s) [63.612637] Starting dynamic subtest: bcs0 [63.615134] Dynamic subtest bcs0: SUCCESS (0.012s) [63.626917] Starting dynamic subtest: vcs0 [63.629076] Dynamic subtest vcs0: SUCCESS (0.011s) [63.638184] Starting dynamic subtest: vcs1 [63.640320] Dynamic subtest vcs1: SUCCESS (0.011s) [63.653869] Starting dynamic subtest: vecs0 [63.656413] Dynamic subtest vecs0: SUCCESS (0.007s) [63.664362] Starting dynamic subtest: ccs0 [63.666652] Dynamic subtest ccs0: SUCCESS (0.012s) [63.668790] Subtest concurrent-writes: SUCCESS (0.084s) [63.889413] [003/155] (954s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt) [63.999700] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt [71.522953] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.528s) [71.628988] [004/155] (946s left) gem_lmem_swapping (verify-random) [71.674441] Subtest verify-random: SKIP (0.000s) [71.719250] [005/155] (946s left) gem_exec_reloc (basic-gtt-cpu-active) [71.783255] Subtest basic-gtt-cpu-active: SKIP (0.000s) [71.866989] [006/155] (946s left) gem_ccs (large-ctrl-surf-copy) [71.919296] Starting subtest: large-ctrl-surf-copy [71.923759] Subtest large-ctrl-surf-copy: SKIP (0.000s) [72.022623] [007/155] (946s left) kms_feature_discovery (chamelium) [72.120267] Starting subtest: chamelium [72.124825] Subtest chamelium: SKIP (0.000s) [72.188187] [008/155] (946s left) gem_exec_whisper (basic-fds-priority-all) [72.250057] Starting subtest: basic-fds-priority-all [96.275736] Subtest basic-fds-priority-all: SUCCESS (24.025s) [96.472869] [009/155] (922s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-blt) [96.579763] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-blt [96.584185] Subtest psrhdr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [96.679823] [010/155] (922s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu) [96.778893] Starting subtest: psr-rgb565-draw-mmap-cpu [103.644040] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.871s) [103.785468] [011/155] (915s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted) [103.850052] Starting subtest: multi-wait-for-submit-unsubmitted-submitted [103.954113] Subtest multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.104s) [104.029623] [012/155] (914s left) gem_exec_fence (basic-busy-all) [104.082717] Starting subtest: basic-busy-all [104.169655] Subtest basic-busy-all: SUCCESS (0.088s) [106.397585] [FACT gem_exec_fence (basic-busy-all)] new: kernel.kmod_is_loaded.vgem: true [106.400618] [013/155] (912s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-render) [106.506236] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-render [106.510438] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s) [106.610963] [014/155] (912s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu) [106.703316] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu [106.707202] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [106.823207] [015/155] (912s left) gem_exec_schedule (preempt-queue) [106.891054] Subtest preempt-queue: SKIP (0.000s) [107.173096] [016/155] (911s left) kms_big_fb (yf-tiled-8bpp-rotate-90) [107.291881] Starting subtest: yf-tiled-8bpp-rotate-90 [107.296464] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s) [107.391890] [017/155] (911s left) gem_exec_fence (syncobj-invalid-wait) [107.812093] Starting subtest: syncobj-invalid-wait [107.814709] Subtest syncobj-invalid-wait: SUCCESS (0.001s) [109.377122] [018/155] (909s left) kms_frontbuffer_tracking (fbcpsrhdr-indfb-scaledprimary) [109.486503] Starting subtest: fbcpsrhdr-indfb-scaledprimary [109.490610] Subtest fbcpsrhdr-indfb-scaledprimary: SKIP (0.000s) [109.588787] [019/155] (909s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-blt) [109.690032] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-blt [109.694746] Subtest fbchdr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [109.806231] [020/155] (909s left) syncobj_wait (multi-wait-for-submit-signaled) [109.856437] Starting subtest: multi-wait-for-submit-signaled [109.858761] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s) [109.961335] [021/155] (909s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf) [110.058119] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf [110.062263] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s) [110.139016] [022/155] (909s left) gem_exec_params (rs-invalid) [110.199019] Starting subtest: rs-invalid [110.203813] Subtest rs-invalid: SUCCESS (0.003s) [110.343575] [023/155] (908s left) gem_flink_basic (basic) [110.391050] Starting subtest: basic [110.393198] Subtest basic: SUCCESS (0.000s) [110.500598] [024/155] (908s left) kms_cursor_crc (cursor-offscreen-256x256) [110.753655] Starting subtest: cursor-offscreen-256x256 [110.757846] Starting dynamic subtest: pipe-A-eDP-1 [112.723689] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.966s) [112.758143] Starting dynamic subtest: pipe-D-eDP-1 [115.397287] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.646s) [115.399603] Subtest cursor-offscreen-256x256: SUCCESS (4.641s) [116.242889] [025/155] (903s left) gem_render_copy_redux (flink) [116.302724] Starting subtest: flink [117.071314] Subtest flink: SUCCESS (0.770s) [117.205212] [026/155] (902s left) syncobj_wait (reset-unsignaled) [117.260136] Starting subtest: reset-unsignaled [117.261931] Subtest reset-unsignaled: SUCCESS (0.000s) [117.362744] [027/155] (902s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt) [117.449468] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt [117.453120] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [117.540934] [028/155] (901s left) i915_drm_fdinfo (all-busy-idle-check-all) [117.581891] Starting subtest: all-busy-idle-check-all [117.587894] Subtest all-busy-idle-check-all: SKIP (0.004s) [117.645605] [029/155] (901s left) drm_buddy (drm_buddy) [117.675304] Starting subtest: drm_buddy [117.679036] Subtest drm_buddy: SKIP (0.001s) [117.725611] [030/155] (901s left) gem_ctx_param (invalid-get-engines) [117.802501] Starting subtest: invalid-get-engines [117.805052] Subtest invalid-get-engines: SUCCESS (0.002s) [117.927622] [031/155] (901s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu) [118.018165] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu [118.021549] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [118.104800] [032/155] (901s left) kms_psr (fbc-pr-cursor-plane-move) [118.198474] Starting subtest: fbc-pr-cursor-plane-move [118.201898] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s) [118.275618] [033/155] (901s left) kms_async_flips (alternate-sync-async-flip-atomic) [118.365097] Starting subtest: alternate-sync-async-flip-atomic [118.742927] Starting dynamic subtest: pipe-A-eDP-1 [121.526044] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.785s) [121.902037] Starting dynamic subtest: pipe-B-eDP-1 [124.658105] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.764s) [125.037743] Starting dynamic subtest: pipe-C-eDP-1 [127.800558] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.771s) [128.166560] Starting dynamic subtest: pipe-D-eDP-1 [130.934220] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.778s) [130.936207] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.571s) [132.120049] [034/155] (887s left) kms_frontbuffer_tracking (fbc-tiling-y) [132.226535] Starting subtest: fbc-tiling-y [132.230737] Subtest fbc-tiling-y: SKIP (0.000s) [132.325218] [035/155] (887s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions) [132.435429] Starting subtest: short-flip-before-cursor-atomic-transitions [133.411591] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.976s) [134.248221] [036/155] (885s left) gem_exec_suspend (basic) [134.305795] Starting subtest: basic [134.308199] Starting dynamic subtest: smem [136.324286] Dynamic subtest smem: SUCCESS (2.016s) [136.327056] Subtest basic: SUCCESS (2.018s) [136.508759] [037/155] (883s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc) [136.608814] Starting subtest: fbcpsr-rgb565-draw-mmap-wc [143.541501] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.940s) [143.654179] [038/155] (876s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt) [143.757262] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt [151.129227] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.376s) [151.281649] [039/155] (868s left) api_intel_bb (render-ccs) [151.337438] Starting subtest: render-ccs [151.694240] Subtest render-ccs: SUCCESS (0.357s) [151.795575] [040/155] (868s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-fullscreen) [151.896284] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-fullscreen [151.900435] Subtest fbchdr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [151.982148] [041/155] (868s left) gem_sync (basic-store-all) [152.052788] Starting subtest: basic-store-all [154.820103] Subtest basic-store-all: SUCCESS (2.777s) [155.008101] [042/155] (865s left) kms_vblank (query-idle-hang) [155.106870] Starting subtest: query-idle-hang [155.109064] Starting dynamic subtest: pipe-A-eDP-1 [182.150461] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.038s) [182.164581] Starting dynamic subtest: pipe-D-eDP-1 [207.042093] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.888s) [207.044487] Subtest query-idle-hang: SUCCESS (51.931s) [207.859997] [043/155] (812s left) kms_vblank (crtc-id) [207.965381] Starting subtest: crtc-id [207.967649] Starting dynamic subtest: pipe-A-eDP-1 [208.423886] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.457s) [208.439647] Starting dynamic subtest: pipe-D-eDP-1 [209.574303] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.149s) [209.576513] Subtest crtc-id: SUCCESS (1.609s) [210.410599] [044/155] (809s left) kms_addfb_basic (unused-modifier) [210.455991] Starting subtest: unused-modifier [210.457905] Subtest unused-modifier: SUCCESS (0.000s) [210.588056] [045/155] (809s left) gem_mmap_gtt (hang) [210.640307] Subtest hang: SKIP (0.000s) [210.699523] [046/155] (809s left) gem_tiled_swapping (non-threaded) [210.753756] Subtest non-threaded: SKIP (0.000s) [210.817611] [047/155] (809s left) kms_psr (fbc-psr2-sprite-render) [210.921819] Starting subtest: fbc-psr2-sprite-render [210.924376] Starting dynamic subtest: eDP-1 [210.928641] Dynamic subtest eDP-1: SKIP (0.000s) [210.932632] Subtest fbc-psr2-sprite-render: SKIP (0.001s) [210.997674] [048/155] (809s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted) [211.052890] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted [211.055155] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s) [211.157970] [049/155] (809s left) perf (invalid-remove-userspace-config) [211.294610] Starting subtest: invalid-remove-userspace-config [211.301899] Subtest invalid-remove-userspace-config: SUCCESS (0.007s) [211.347324] [050/155] (809s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-move) [211.449600] Starting subtest: hdr-1p-primscrn-cur-indfb-move [211.452806] Subtest hdr-1p-primscrn-cur-indfb-move: SKIP (0.000s) [211.557830] [051/155] (808s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode) [211.950058] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s) [212.737336] [052/155] (807s left) kms_plane_cursor (overlay) [212.828307] Starting subtest: overlay [212.832583] Starting dynamic subtest: pipe-A-eDP-1-size-64 [215.405566] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.578s) [215.465570] Starting dynamic subtest: pipe-A-eDP-1-size-128 [218.073056] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.616s) [218.132713] Starting dynamic subtest: pipe-A-eDP-1-size-256 [220.752055] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.627s) [221.104993] Starting dynamic subtest: pipe-B-eDP-1-size-64 [224.322988] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.225s) [224.381213] Starting dynamic subtest: pipe-B-eDP-1-size-128 [226.978682] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.605s) [227.039100] Starting dynamic subtest: pipe-B-eDP-1-size-256 [229.635193] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.605s) [229.987970] Starting dynamic subtest: pipe-C-eDP-1-size-64 [232.914469] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.938s) [232.955465] Starting dynamic subtest: pipe-C-eDP-1-size-128 [235.214309] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.269s) [235.251894] Starting dynamic subtest: pipe-C-eDP-1-size-256 [237.447324] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.203s) [237.784817] Starting dynamic subtest: pipe-D-eDP-1-size-64 [240.732904] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.958s) [240.769736] Starting dynamic subtest: pipe-D-eDP-1-size-128 [242.977456] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.214s) [243.014686] Starting dynamic subtest: pipe-D-eDP-1-size-256 [245.244226] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.237s) [245.563497] Subtest overlay: SUCCESS (32.735s) [246.394219] [053/155] (774s left) sysfs_timeslice_duration (timeout) [246.461141] Starting subtest: timeout [246.463628] Starting dynamic subtest: vecs0 [256.323065] Dynamic subtest vecs0: SUCCESS (9.857s) [256.340070] Starting dynamic subtest: ccs0 [257.690260] Dynamic subtest ccs0: SUCCESS (1.367s) [257.698947] Starting dynamic subtest: vcs0 [267.268381] Dynamic subtest vcs0: SUCCESS (9.576s) [267.279381] Starting dynamic subtest: bcs0 [267.898690] Dynamic subtest bcs0: SUCCESS (0.629s) [267.909690] Starting dynamic subtest: rcs0 [269.163185] Dynamic subtest rcs0: SUCCESS (1.264s) [269.173032] Starting dynamic subtest: vcs1 [278.270660] Dynamic subtest vcs1: SUCCESS (9.104s) [278.273138] Subtest timeout: SUCCESS (31.808s) [278.363142] [054/155] (742s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite) [278.472738] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite [282.887364] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.417s) [284.098387] [055/155] (736s left) perf_pmu (enable-race) [284.135992] Starting subtest: enable-race [284.138683] Starting dynamic subtest: rcs0 [296.901709] Dynamic subtest rcs0: SUCCESS (12.765s) [296.912968] Starting dynamic subtest: bcs0 [309.644894] Dynamic subtest bcs0: SUCCESS (12.741s) [309.654106] Starting dynamic subtest: vcs0 [325.317099] Dynamic subtest vcs0: SUCCESS (15.668s) [325.329591] Starting dynamic subtest: vcs1 [341.253732] Dynamic subtest vcs1: SUCCESS (15.932s) [341.267067] Starting dynamic subtest: vecs0 [357.252476] Dynamic subtest vecs0: SUCCESS (15.996s) [357.264770] Starting dynamic subtest: ccs0 [369.998261] Dynamic subtest ccs0: SUCCESS (12.743s) [370.001271] Subtest enable-race: SUCCESS (85.861s) [370.135935] [056/155] (650s left) gen9_exec_parse (cmd-crossing-page) [370.189637] Subtest cmd-crossing-page: SKIP (0.000s) [370.255335] [057/155] (650s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-pwrite) [370.354668] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-pwrite [370.359057] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s) [370.482409] [058/155] (650s left) gem_mmap_wc (bad-offset) [370.529590] Subtest bad-offset: SKIP (0.000s) [370.584356] [059/155] (650s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt) [370.675104] Starting subtest: fbc-rgb565-draw-blt [374.887266] Subtest fbc-rgb565-draw-blt: SUCCESS (4.218s) [376.088486] [060/155] (644s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted) [376.140695] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted [376.249253] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.108s) [376.329320] [061/155] (644s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc) [376.428996] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc [376.433526] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [376.538739] [062/155] (644s left) gem_gtt_cpu_tlb [376.662455] [063/155] (644s left) kms_cursor_legacy (cursora-vs-flipa-atomic) [376.781308] Starting subtest: cursorA-vs-flipA-atomic [387.919939] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.137s) [388.818365] [064/155] (632s left) gem_watchdog (default-virtual) [388.886779] Starting subtest: default-virtual [395.159899] Subtest default-virtual: SUCCESS (6.282s) [395.242695] [065/155] (625s left) kms_rotation_crc (multiplane-rotation-cropping-bottom) [395.337261] Starting subtest: multiplane-rotation-cropping-bottom [412.752167] Subtest multiplane-rotation-cropping-bottom: SUCCESS (17.415s) [412.870241] [066/155] (608s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [412.989786] Starting subtest: basic-flip-before-cursor-atomic [413.906630] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.915s) [414.720069] [067/155] (606s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-onoff) [414.822842] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-onoff [414.827042] Subtest fbchdr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [414.916191] [068/155] (606s left) gem_create (create-ext-placement-sanity-check) [415.082250] Starting subtest: create-ext-placement-sanity-check [415.089649] Subtest create-ext-placement-sanity-check: SUCCESS (0.004s) [415.190979] [069/155] (606s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-blt) [415.295569] Starting subtest: fbchdr-rgb101010-draw-blt [415.299825] Subtest fbchdr-rgb101010-draw-blt: SKIP (0.000s) [415.390430] [070/155] (605s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-indfb-draw-render) [415.496817] Starting subtest: psrhdr-2p-scndscrn-pri-indfb-draw-render [415.500890] Subtest psrhdr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [415.602936] [071/155] (605s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180) [415.692322] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180 [415.696519] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s) [415.783260] [072/155] (605s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs) [415.878058] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs [415.880474] Starting dynamic subtest: pipe-A-eDP-1 [415.903807] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [415.915723] Starting dynamic subtest: pipe-B-eDP-1 [415.939042] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [415.948327] Starting dynamic subtest: pipe-C-eDP-1 [415.969797] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [415.981111] Starting dynamic subtest: pipe-D-eDP-1 [416.003383] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [416.007475] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.005s) [418.199290] [073/155] (603s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled) [418.256829] Starting subtest: multi-wait-for-submit-unsubmitted-signaled [418.258913] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.001s) [418.369945] [074/155] (603s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-indfb-draw-blt) [418.478443] Starting subtest: fbcpsrhdr-2p-primscrn-pri-indfb-draw-blt [418.482487] Subtest fbcpsrhdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [418.586205] [075/155] (602s left) gem_exec_balancer (invalid-balancer) [418.649076] Starting subtest: invalid-balancer [419.566924] Subtest invalid-balancer: SUCCESS (0.917s) [419.881212] [076/155] (601s left) i915_query (hwconfig_table) [419.935285] Starting subtest: hwconfig_table [420.238370] Subtest hwconfig_table: SUCCESS (0.001s) [420.280754] [077/155] (601s left) gem_mmap_offset (mmap-boundaries) [420.336277] Starting subtest: mmap-boundaries [420.338406] Starting dynamic subtest: smem0 [420.613545] Dynamic subtest smem0: SUCCESS (0.278s) [420.616441] Subtest mmap-boundaries: SUCCESS (0.279s) [420.733296] [078/155] (600s left) kms_flip (flip-vs-panning-vs-hang) [420.817304] Starting subtest: flip-vs-panning-vs-hang [420.819715] Starting dynamic subtest: A-eDP1 [472.751261] Dynamic subtest A-eDP1: SUCCESS (51.932s) [472.761505] Starting dynamic subtest: D-eDP1 [521.781597] Dynamic subtest D-eDP1: SUCCESS (49.028s) [521.784052] Subtest flip-vs-panning-vs-hang: SUCCESS (100.964s) [522.973297] [079/155] (498s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled) [523.034988] Starting subtest: multi-wait-all-for-submit-available-signaled [523.037404] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.000s) [523.119066] [080/155] (498s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc) [523.212343] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc [523.214615] Starting dynamic subtest: pipe-A-eDP-1 [523.237708] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [523.250666] Starting dynamic subtest: pipe-B-eDP-1 [523.271695] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [523.281578] Starting dynamic subtest: pipe-C-eDP-1 [523.303197] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [523.312189] Starting dynamic subtest: pipe-D-eDP-1 [523.333717] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [523.338196] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s) [525.523779] [081/155] (496s left) kms_big_fb (y-tiled-16bpp-rotate-180) [525.623285] Starting subtest: y-tiled-16bpp-rotate-180 [525.627662] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s) [525.715286] [082/155] (496s left) kms_chamelium_audio (hdmi-audio-edid) [526.104217] Subtest hdmi-audio-edid: SKIP (0.000s) [526.947419] [083/155] (494s left) i915_hangman (engine-engine-error) [527.015247] Starting subtest: engine-engine-error [527.017140] Starting dynamic subtest: rcs0 [528.293135] Dynamic subtest rcs0: SUCCESS (1.277s) [528.303762] Starting dynamic subtest: bcs0 [530.275701] Dynamic subtest bcs0: SUCCESS (1.979s) [530.288053] Starting dynamic subtest: vcs0 [532.259310] Dynamic subtest vcs0: SUCCESS (1.981s) [532.271966] Starting dynamic subtest: vcs1 [534.244396] Dynamic subtest vcs1: SUCCESS (1.981s) [534.256703] Starting dynamic subtest: vecs0 [536.291619] Dynamic subtest vecs0: SUCCESS (2.044s) [536.305274] Starting dynamic subtest: ccs0 [538.275365] Dynamic subtest ccs0: SUCCESS (1.981s) [538.277898] Subtest engine-engine-error: SUCCESS (11.262s) [538.358329] [084/155] (483s left) tools_test (sysfs_l3_parity) [538.404811] Starting subtest: sysfs_l3_parity [538.484375] Subtest sysfs_l3_parity: SKIP (0.090s) [538.538562] [085/155] (483s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-blt) [538.644627] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-blt [538.648850] Subtest fbchdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [538.729296] [086/155] (483s left) gem_spin_batch (resubmit-new-all) [538.790085] Starting subtest: resubmit-new-all [538.792499] Starting dynamic subtest: rcs0 [538.803435] Dynamic subtest rcs0: SUCCESS (0.013s) [538.812470] Starting dynamic subtest: bcs0 [538.814790] Dynamic subtest bcs0: SUCCESS (0.009s) [538.824604] Starting dynamic subtest: vcs0 [538.826524] Dynamic subtest vcs0: SUCCESS (0.008s) [538.835683] Starting dynamic subtest: vcs1 [538.838062] Dynamic subtest vcs1: SUCCESS (0.010s) [538.846871] Starting dynamic subtest: vecs0 [538.848810] Dynamic subtest vecs0: SUCCESS (0.009s) [538.857582] Starting dynamic subtest: ccs0 [538.859712] Dynamic subtest ccs0: SUCCESS (0.007s) [538.861809] Subtest resubmit-new-all: SUCCESS (0.061s) [540.345217] [087/155] (481s left) kms_vblank (query-forked-busy) [540.438728] Starting subtest: query-forked-busy [540.440658] Starting dynamic subtest: pipe-A-eDP-1 [542.316205] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.876s) [542.336204] Starting dynamic subtest: pipe-D-eDP-1 [544.923604] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.608s) [544.925992] Subtest query-forked-busy: SUCCESS (4.487s) [545.739130] [088/155] (476s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw) [545.833992] Starting subtest: fbc-1p-pri-indfb-multidraw [558.841070] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (13.012s) [560.263133] [089/155] (461s left) kms_plane (planar-pixel-format-settings) [560.373196] Starting subtest: planar-pixel-format-settings [560.442900] Subtest planar-pixel-format-settings: SUCCESS (0.069s) [560.560512] [090/155] (461s left) kms_big_fb (linear-32bpp-rotate-180) [560.663142] Starting subtest: linear-32bpp-rotate-180 [562.210124] Subtest linear-32bpp-rotate-180: SUCCESS (1.546s) [562.340351] [091/155] (459s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf) [562.437508] Starting subtest: psr2-overlay-plane-move-continuous-sf [562.439532] Starting dynamic subtest: pipe-A-eDP-1 [568.423511] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.986s) [568.434637] Starting dynamic subtest: pipe-B-eDP-1 [575.129082] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.703s) [575.131570] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (12.691s) [575.989538] [092/155] (446s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible) [576.081170] Starting subtest: flip-vs-absolute-wf_vblank-interruptible [576.083534] Starting dynamic subtest: A-eDP1 [585.039918] Dynamic subtest A-eDP1: SUCCESS (8.957s) [585.051119] Starting dynamic subtest: B-eDP1 [593.965749] Dynamic subtest B-eDP1: SUCCESS (8.922s) [593.978490] Starting dynamic subtest: C-eDP1 [602.888663] Dynamic subtest C-eDP1: SUCCESS (8.920s) [602.901090] Starting dynamic subtest: D-eDP1 [611.813650] Dynamic subtest D-eDP1: SUCCESS (8.921s) [611.819642] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.735s) [613.030617] [093/155] (409s left) gem_exec_create (legacy) [613.083589] Starting subtest: legacy [613.086022] Starting dynamic subtest: smem [615.172053] Dynamic subtest smem: SUCCESS (2.088s) [615.174539] Subtest legacy: SUCCESS (2.089s) [615.384529] [094/155] (406s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc) [615.486761] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc [615.490805] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [615.578771] [095/155] (406s left) kms_cursor_edge_walk (128x128-left-edge) [615.672190] Starting subtest: 128x128-left-edge [615.674952] Starting dynamic subtest: pipe-A-eDP-1 [619.107366] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.434s) [619.117066] Starting dynamic subtest: pipe-D-eDP-1 [622.316174] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.207s) [622.318755] Subtest 128x128-left-edge: SUCCESS (6.646s) [623.135611] [096/155] (399s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-mmap-cpu) [623.228201] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-mmap-cpu [623.232168] Subtest hdr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [623.323926] [097/155] (399s left) kms_content_protection (lic-type-0) [623.463942] Starting subtest: lic-type-0 [623.468522] Subtest lic-type-0: SKIP (0.000s) [623.594410] [098/155] (398s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-shrfb-plflip-blt) [623.688918] Starting subtest: hdr-2p-scndscrn-shrfb-plflip-blt [623.693126] Subtest hdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [623.809232] [099/155] (398s left) gem_pxp (regular-baseline-src-copy-readible) [623.935252] Starting subtest: regular-baseline-src-copy-readible [623.992996] Subtest regular-baseline-src-copy-readible: SUCCESS (0.060s) [624.115419] [100/155] (398s left) kms_debugfs (display-on-read-all) [624.206860] Starting subtest: display-on-read-all [624.372231] Subtest display-on-read-all: SUCCESS (0.167s) [624.493370] [101/155] (398s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted) [624.548497] Starting subtest: etime-multi-wait-all-for-submit-submitted [624.657921] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.107s) [624.733214] [102/155] (397s left) prime_vgem (fence-wait) [624.798679] Starting subtest: fence-wait [624.801062] Starting dynamic subtest: rcs0 [625.860092] Dynamic subtest rcs0: SUCCESS (1.059s) [625.871869] Starting dynamic subtest: bcs0 [626.921791] Dynamic subtest bcs0: SUCCESS (1.061s) [626.933821] Starting dynamic subtest: vcs0 [627.961779] Dynamic subtest vcs0: SUCCESS (1.039s) [627.973076] Starting dynamic subtest: vcs1 [629.010117] Dynamic subtest vcs1: SUCCESS (1.046s) [629.021443] Starting dynamic subtest: vecs0 [630.051504] Dynamic subtest vecs0: SUCCESS (1.039s) [630.063787] Starting dynamic subtest: ccs0 [631.096436] Dynamic subtest ccs0: SUCCESS (1.043s) [631.099435] Subtest fence-wait: SUCCESS (6.297s) [631.219258] [103/155] (391s left) kms_flip (2x-flip-vs-panning) [631.321916] Starting subtest: 2x-flip-vs-panning [631.331153] Subtest 2x-flip-vs-panning: SKIP (0.011s) [631.411075] [104/155] (391s left) kms_big_fb (x-tiled-8bpp-rotate-90) [631.504599] Starting subtest: x-tiled-8bpp-rotate-90 [631.527422] Subtest x-tiled-8bpp-rotate-90: SKIP (0.022s) [631.640048] [105/155] (391s left) kms_big_fb (yf-tiled-32bpp-rotate-90) [631.745559] Starting subtest: yf-tiled-32bpp-rotate-90 [631.749758] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s) [631.841712] [106/155] (390s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling) [631.928219] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling [631.932207] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.000s) [631.998496] [107/155] (390s left) kms_frontbuffer_tracking (hdr-2p-primscrn-shrfb-pgflip-blt) [632.093274] Starting subtest: hdr-2p-primscrn-shrfb-pgflip-blt [632.097341] Subtest hdr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [632.187583] [108/155] (390s left) gem_gpgpu_fill (basic) [632.252138] Starting subtest: basic [632.254154] Starting dynamic subtest: smem [632.258111] Dynamic subtest smem: SUCCESS (0.008s) [632.260156] Subtest basic: SUCCESS (0.008s) [632.407646] [109/155] (390s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu) [632.494506] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu [632.498128] Subtest psrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [632.597900] [110/155] (390s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs) [632.695510] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs [632.697393] Starting dynamic subtest: pipe-A-eDP-1 [632.746877] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [632.757057] Starting dynamic subtest: pipe-B-eDP-1 [632.802464] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [632.812331] Starting dynamic subtest: pipe-C-eDP-1 [632.859052] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [632.870323] Starting dynamic subtest: pipe-D-eDP-1 [632.920253] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [632.923898] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.009s) [634.979239] [111/155] (388s left) core_setmaster_vs_auth [635.143404] [112/155] (387s left) kms_frontbuffer_tracking (psr-suspend) [635.239379] Starting subtest: psr-suspend [674.148401] Subtest psr-suspend: SUCCESS (8.109s) [674.264479] [113/155] (348s left) gem_exec_schedule (semaphore-codependency) [674.332629] Starting subtest: semaphore-codependency [674.337468] Subtest semaphore-codependency: SUCCESS (0.013s) [674.686864] [114/155] (348s left) gem_eio (in-flight-internal-1us) [674.929799] Starting subtest: in-flight-internal-1us [676.194697] Subtest in-flight-internal-1us: SUCCESS (1.260s) [676.355365] [115/155] (346s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt) [676.457652] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt [676.461785] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [676.545292] [116/155] (346s left) kms_big_fb (4-tiled-32bpp-rotate-180) [676.650977] Starting subtest: 4-tiled-32bpp-rotate-180 [678.078453] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.426s) [678.226348] [117/155] (345s left) syncobj_timeline (wait-delayed-signal) [678.285423] Starting subtest: wait-delayed-signal [678.387644] Subtest wait-delayed-signal: SUCCESS (0.102s) [678.471127] [118/155] (344s left) gem_mmap_gtt (medium-copy-xy) [678.524655] Subtest medium-copy-XY: SKIP (0.000s) [678.584379] [119/155] (344s left) kms_plane_scaling (planes-downscale-factor-0-75) [678.673874] Starting subtest: planes-downscale-factor-0-75 [678.676128] Starting dynamic subtest: pipe-A [678.698596] Dynamic subtest pipe-A: SKIP (0.018s) [678.711088] Starting dynamic subtest: pipe-B [678.729426] Dynamic subtest pipe-B: SKIP (0.033s) [678.739988] Starting dynamic subtest: pipe-C [678.763715] Dynamic subtest pipe-C: SKIP (0.033s) [678.774181] Starting dynamic subtest: pipe-D [678.797985] Dynamic subtest pipe-D: SKIP (0.033s) [678.802675] Subtest planes-downscale-factor-0-75: SKIP (0.120s) [678.907369] [120/155] (344s left) kms_lease (empty-lease) [679.003684] Starting subtest: empty-lease [679.005993] Starting dynamic subtest: pipe-A-eDP-1 [679.008264] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [679.019098] Starting dynamic subtest: pipe-B-eDP-1 [679.021281] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [679.031808] Starting dynamic subtest: pipe-C-eDP-1 [679.033930] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [679.044160] Starting dynamic subtest: pipe-D-eDP-1 [679.046287] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [679.048467] Subtest empty-lease: SUCCESS (0.009s) [679.129477] [121/155] (344s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-pwrite) [679.229619] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-pwrite [679.234022] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [679.327994] [122/155] (344s left) kms_flip (absolute-wf_vblank-interruptible) [679.427422] Starting subtest: absolute-wf_vblank-interruptible [679.429460] Starting dynamic subtest: A-eDP1 [688.124125] Dynamic subtest A-eDP1: SUCCESS (8.683s) [688.137473] Starting dynamic subtest: B-eDP1 [696.861992] Dynamic subtest B-eDP1: SUCCESS (8.729s) [696.875463] Starting dynamic subtest: C-eDP1 [705.577190] Dynamic subtest C-eDP1: SUCCESS (8.709s) [705.588970] Starting dynamic subtest: D-eDP1 [714.310507] Dynamic subtest D-eDP1: SUCCESS (8.728s) [714.316340] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.858s) [715.534089] [123/155] (307s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc) [715.631575] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc [715.635681] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [715.732231] [124/155] (307s left) gem_caching (writes) [715.783713] Subtest writes: SKIP (0.000s) [715.856095] [125/155] (307s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu) [715.957367] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu [715.961495] Subtest psrhdr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [716.061985] [126/155] (307s left) syncobj_wait (wait-all-delayed-signal) [716.112593] Starting subtest: wait-all-delayed-signal [716.217569] Subtest wait-all-delayed-signal: SUCCESS (0.103s) [716.308063] [127/155] (307s left) kms_color_pipeline (plane-lut1d) [716.398214] Starting subtest: plane-lut1d [716.544164] Starting dynamic subtest: pipe-A-plane-0 [716.723301] Dynamic subtest pipe-A-plane-0: SUCCESS (0.178s) [716.739606] Starting dynamic subtest: pipe-A-plane-1 [716.911098] Dynamic subtest pipe-A-plane-1: SUCCESS (0.186s) [716.923227] Starting dynamic subtest: pipe-A-plane-2 [717.077565] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s) [718.375653] Starting dynamic subtest: pipe-B-plane-0 [718.566205] Dynamic subtest pipe-B-plane-0: SUCCESS (0.199s) [718.577314] Starting dynamic subtest: pipe-B-plane-1 [718.721591] Dynamic subtest pipe-B-plane-1: SUCCESS (0.155s) [718.732495] Starting dynamic subtest: pipe-B-plane-2 [718.887579] Dynamic subtest pipe-B-plane-2: SUCCESS (0.165s) [720.110144] Starting dynamic subtest: pipe-C-plane-0 [720.268198] Dynamic subtest pipe-C-plane-0: SUCCESS (0.166s) [720.281684] Starting dynamic subtest: pipe-C-plane-1 [720.434282] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s) [720.445531] Starting dynamic subtest: pipe-C-plane-2 [720.589948] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s) [721.831701] Starting dynamic subtest: pipe-D-plane-0 [721.976795] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s) [721.988222] Starting dynamic subtest: pipe-D-plane-1 [722.132109] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s) [722.143411] Starting dynamic subtest: pipe-D-plane-2 [722.298947] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s) [722.584614] Subtest plane-lut1d: SUCCESS (6.185s) [723.482043] [128/155] (300s left) kms_hdr (invalid-metadata-sizes) [723.581768] Starting subtest: invalid-metadata-sizes [723.588474] Subtest invalid-metadata-sizes: SKIP (0.000s) [723.656851] [129/155] (300s left) kms_cursor_crc (cursor-random-max-size) [723.990688] Starting subtest: cursor-random-max-size [723.997802] Subtest cursor-random-max-size: SKIP (0.000s) [724.107144] [130/155] (299s left) kms_psr (psr-cursor-plane-move) [724.200568] Starting subtest: psr-cursor-plane-move [724.202755] Starting dynamic subtest: eDP-1 [725.967619] Dynamic subtest eDP-1: SUCCESS (1.763s) [725.970839] Subtest psr-cursor-plane-move: SUCCESS (1.765s) [726.840973] [131/155] (297s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw) [726.997289] Starting subtest: fbcpsr-1p-pri-indfb-multidraw [750.309045] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (23.305s) [750.479958] [132/155] (273s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-mmap-gtt) [750.591309] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-mmap-gtt [750.594748] Subtest hdr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [750.686282] [133/155] (273s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-render) [750.787147] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-render [750.790695] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [750.904133] [134/155] (273s left) i915_pm_rpm (gem-pread) [752.433834] Starting subtest: gem-pread [754.589410] Subtest gem-pread: SUCCESS (2.157s) [754.717401] [135/155] (269s left) kms_atomic (plane-primary-overlay-mutable-zpos) [754.815748] Starting subtest: plane-primary-overlay-mutable-zpos [758.295402] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.476s) [759.496396] [136/155] (264s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt) [759.600295] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt [759.604610] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [759.703634] [137/155] (264s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt) [759.807766] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt [759.812286] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [759.912402] [138/155] (264s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt) [760.014212] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt [760.018279] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [760.097316] [139/155] (264s left) prime_self_import (basic-llseek-size) [760.138118] Starting subtest: basic-llseek-size [760.166819] Subtest basic-llseek-size: SUCCESS (0.031s) [760.291270] [140/155] (263s left) perf_pmu (busy) [760.328890] Starting subtest: busy [760.331200] Starting dynamic subtest: rcs0 [760.948955] Dynamic subtest rcs0: SUCCESS (0.618s) [760.964431] Starting dynamic subtest: bcs0 [761.525010] Dynamic subtest bcs0: SUCCESS (0.573s) [761.539494] Starting dynamic subtest: vcs0 [763.094267] Dynamic subtest vcs0: SUCCESS (1.565s) [763.107609] Starting dynamic subtest: vcs1 [765.078625] Dynamic subtest vcs1: SUCCESS (1.980s) [765.096365] Starting dynamic subtest: vecs0 [767.127207] Dynamic subtest vecs0: SUCCESS (2.044s) [767.141163] Starting dynamic subtest: ccs0 [767.707389] Dynamic subtest ccs0: SUCCESS (0.579s) [767.710195] Subtest busy: SUCCESS (7.376s) [767.823175] [141/155] (256s left) kms_plane_lowres (tiling-y) [767.922357] Starting subtest: tiling-y [767.926324] Subtest tiling-y: SKIP (0.000s) [768.012506] [142/155] (256s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs) [768.096637] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs [768.098598] Starting dynamic subtest: pipe-A-eDP-1 [800.868037] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.861s) [800.880504] Starting dynamic subtest: pipe-B-eDP-1 [833.815616] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.763s) [833.831827] Starting dynamic subtest: pipe-C-eDP-1 [866.787481] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.711s) [866.806928] Starting dynamic subtest: pipe-D-eDP-1 [899.744895] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.595s) [899.747911] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (13.935s) [900.921280] [143/155] (123s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling) [901.019925] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling [901.024822] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s) [901.104283] [144/155] (123s left) gem_ctx_shared (create-shared-gtt) [901.175889] Starting subtest: create-shared-gtt [903.324306] Subtest create-shared-gtt: SUCCESS (2.152s) [903.876920] [145/155] (120s left) kms_psr (pr-suspend) [903.970301] Starting subtest: pr-suspend [903.975426] Subtest pr-suspend: SKIP (0.000s) [904.046208] [146/155] (120s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled) [904.113158] Starting subtest: yf-tiled-to-vebox-yf-tiled [904.118737] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s) [904.311777] [147/155] (120s left) kms_plane_scaling (plane-upscale-20x20-with-rotation) [904.400511] Starting subtest: plane-upscale-20x20-with-rotation [904.402994] Starting dynamic subtest: pipe-A [904.624886] Dynamic subtest pipe-A: SUCCESS (0.227s) [904.635901] Starting dynamic subtest: pipe-B [905.905392] Dynamic subtest pipe-B: SUCCESS (1.281s) [905.916919] Starting dynamic subtest: pipe-C [907.240503] Dynamic subtest pipe-C: SUCCESS (1.336s) [907.252666] Starting dynamic subtest: pipe-D [908.574982] Dynamic subtest pipe-D: SUCCESS (1.334s) [908.577705] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.182s) [909.755056] [148/155] (114s left) kms_psr (fbc-psr-suspend) [909.851670] Starting subtest: fbc-psr-suspend [909.854426] Starting dynamic subtest: eDP-1 [909.859688] Dynamic subtest eDP-1: SKIP (0.000s) [909.864902] Subtest fbc-psr-suspend: SKIP (0.001s) [909.928273] [149/155] (114s left) i915_query (query-garbage) [909.989459] Starting subtest: query-garbage [909.992491] Subtest query-garbage: SUCCESS (0.000s) [910.095414] [150/155] (114s left) kms_pm_rpm (dpms-lpsp) [911.925658] Starting subtest: dpms-lpsp [912.323614] Subtest dpms-lpsp: SUCCESS (0.403s) [912.414171] [151/155] (112s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu) [912.519570] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu [912.524771] Subtest psrhdr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [912.611137] [152/155] (112s left) perf (sysctl-defaults) [912.676411] Starting subtest: sysctl-defaults [912.678747] Subtest sysctl-defaults: SUCCESS (0.000s) [912.756128] [153/155] (112s left) kms_chamelium_frames (hdmi-aspect-ratio) [913.150560] Subtest hdmi-aspect-ratio: SKIP (0.000s) [913.994020] [154/155] (110s left) kms_multipipe_modeset (basic-max-pipe-crc-check) [914.088772] Starting subtest: basic-max-pipe-crc-check [914.094029] Subtest basic-max-pipe-crc-check: SKIP (0.000s) [914.138704] [155/155] (110s left) api_intel_allocator (fork-simple-once) [914.195973] Starting subtest: fork-simple-once [914.208068] Subtest fork-simple-once: SUCCESS (0.015s) [914.318771] Closing watchdogs results: parsing output: 0/ for test: gem_flink_race results: parsing output: 1/ for test: gem_exec_async results: parsing output: 2/ for test: kms_frontbuffer_tracking results: parsing output: 3/ for test: gem_lmem_swapping results: parsing output: 4/ for test: gem_exec_reloc results: parsing output: 5/ for test: gem_ccs results: parsing output: 6/ for test: kms_feature_discovery results: parsing output: 7/ for test: gem_exec_whisper results: parsing output: 8/ for test: kms_frontbuffer_tracking results: parsing output: 9/ for test: kms_frontbuffer_tracking results: parsing output: 10/ for test: syncobj_wait results: parsing output: 11/ for test: gem_exec_fence results: parsing output: 12/ for test: kms_frontbuffer_tracking results: parsing output: 13/ for test: kms_frontbuffer_tracking results: parsing output: 14/ for test: gem_exec_schedule results: parsing output: 15/ for test: kms_big_fb results: parsing output: 16/ for test: gem_exec_fence results: parsing output: 17/ for test: kms_frontbuffer_tracking results: parsing output: 18/ for test: kms_frontbuffer_tracking results: parsing output: 19/ for test: syncobj_wait results: parsing output: 20/ for test: kms_psr2_sf results: parsing output: 21/ for test: gem_exec_params results: parsing output: 22/ for test: gem_flink_basic results: parsing output: 23/ for test: kms_cursor_crc results: parsing output: 24/ for test: gem_render_copy_redux results: parsing output: 25/ for test: syncobj_wait results: parsing output: 26/ for test: kms_frontbuffer_tracking results: parsing output: 27/ for test: i915_drm_fdinfo results: parsing output: 28/ for test: drm_buddy results: parsing output: 29/ for test: gem_ctx_param results: parsing output: 30/ for test: kms_frontbuffer_tracking results: parsing output: 31/ for test: kms_psr results: parsing output: 32/ for test: kms_async_flips results: parsing output: 33/ for test: kms_frontbuffer_tracking results: parsing output: 34/ for test: kms_cursor_legacy results: parsing output: 35/ for test: gem_exec_suspend results: parsing output: 36/ for test: kms_frontbuffer_tracking results: parsing output: 37/ for test: kms_frontbuffer_tracking results: parsing output: 38/ for test: api_intel_bb results: parsing output: 39/ for test: kms_frontbuffer_tracking results: parsing output: 40/ for test: gem_sync results: parsing output: 41/ for test: kms_vblank results: parsing output: 42/ for test: kms_vblank results: parsing output: 43/ for test: kms_addfb_basic results: parsing output: 44/ for test: gem_mmap_gtt results: parsing output: 45/ for test: gem_tiled_swapping results: parsing output: 46/ for test: kms_psr results: parsing output: 47/ for test: syncobj_wait results: parsing output: 48/ for test: perf results: parsing output: 49/ for test: kms_frontbuffer_tracking results: parsing output: 50/ for test: kms_chamelium_hpd results: parsing output: 51/ for test: kms_plane_cursor results: parsing output: 52/ for test: sysfs_timeslice_duration results: parsing output: 53/ for test: kms_frontbuffer_tracking results: parsing output: 54/ for test: perf_pmu results: parsing output: 55/ for test: gen9_exec_parse results: parsing output: 56/ for test: kms_frontbuffer_tracking results: parsing output: 57/ for test: gem_mmap_wc results: parsing output: 58/ for test: kms_frontbuffer_tracking results: parsing output: 59/ for test: syncobj_timeline results: parsing output: 60/ for test: kms_frontbuffer_tracking results: parsing output: 61/ for test: gem_gtt_cpu_tlb results: parsing output: 62/ for test: kms_cursor_legacy results: parsing output: 63/ for test: gem_watchdog results: parsing output: 64/ for test: kms_rotation_crc results: parsing output: 65/ for test: kms_cursor_legacy results: parsing output: 66/ for test: kms_frontbuffer_tracking results: parsing output: 67/ for test: gem_create results: parsing output: 68/ for test: kms_frontbuffer_tracking results: parsing output: 69/ for test: kms_frontbuffer_tracking results: parsing output: 70/ for test: kms_big_fb results: parsing output: 71/ for test: kms_ccs results: parsing output: 72/ for test: syncobj_timeline results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: gem_exec_balancer results: parsing output: 75/ for test: i915_query results: parsing output: 76/ for test: gem_mmap_offset results: parsing output: 77/ for test: kms_flip results: parsing output: 78/ for test: syncobj_timeline results: parsing output: 79/ for test: kms_ccs results: parsing output: 80/ for test: kms_big_fb results: parsing output: 81/ for test: kms_chamelium_audio results: parsing output: 82/ for test: i915_hangman results: parsing output: 83/ for test: tools_test results: parsing output: 84/ for test: kms_frontbuffer_tracking results: parsing output: 85/ for test: gem_spin_batch results: parsing output: 86/ for test: kms_vblank results: parsing output: 87/ for test: kms_frontbuffer_tracking results: parsing output: 88/ for test: kms_plane results: parsing output: 89/ for test: kms_big_fb results: parsing output: 90/ for test: kms_psr2_sf results: parsing output: 91/ for test: kms_flip results: parsing output: 92/ for test: gem_exec_create results: parsing output: 93/ for test: kms_frontbuffer_tracking results: parsing output: 94/ for test: kms_cursor_edge_walk results: parsing output: 95/ for test: kms_frontbuffer_tracking results: parsing output: 96/ for test: kms_content_protection results: parsing output: 97/ for test: kms_frontbuffer_tracking results: parsing output: 98/ for test: gem_pxp results: parsing output: 99/ for test: kms_debugfs results: parsing output: 100/ for test: syncobj_timeline results: parsing output: 101/ for test: prime_vgem results: parsing output: 102/ for test: kms_flip results: parsing output: 103/ for test: kms_big_fb results: parsing output: 104/ for test: kms_big_fb results: parsing output: 105/ for test: kms_flip_scaled_crc results: parsing output: 106/ for test: kms_frontbuffer_tracking results: parsing output: 107/ for test: gem_gpgpu_fill results: parsing output: 108/ for test: kms_frontbuffer_tracking results: parsing output: 109/ for test: kms_ccs results: parsing output: 110/ for test: core_setmaster_vs_auth results: parsing output: 111/ for test: kms_frontbuffer_tracking results: parsing output: 112/ for test: gem_exec_schedule results: parsing output: 113/ for test: gem_eio results: parsing output: 114/ for test: kms_frontbuffer_tracking results: parsing output: 115/ for test: kms_big_fb results: parsing output: 116/ for test: syncobj_timeline results: parsing output: 117/ for test: gem_mmap_gtt results: parsing output: 118/ for test: kms_plane_scaling results: parsing output: 119/ for test: kms_lease results: parsing output: 120/ for test: kms_frontbuffer_tracking results: parsing output: 121/ for test: kms_flip results: parsing output: 122/ for test: kms_frontbuffer_tracking results: parsing output: 123/ for test: gem_caching results: parsing output: 124/ for test: kms_frontbuffer_tracking results: parsing output: 125/ for test: syncobj_wait results: parsing output: 126/ for test: kms_color_pipeline results: parsing output: 127/ for test: kms_hdr results: parsing output: 128/ for test: kms_cursor_crc results: parsing output: 129/ for test: kms_psr results: parsing output: 130/ for test: kms_frontbuffer_tracking results: parsing output: 131/ for test: kms_frontbuffer_tracking results: parsing output: 132/ for test: kms_frontbuffer_tracking results: parsing output: 133/ for test: i915_pm_rpm results: parsing output: 134/ for test: kms_atomic results: parsing output: 135/ for test: kms_frontbuffer_tracking results: parsing output: 136/ for test: kms_frontbuffer_tracking results: parsing output: 137/ for test: kms_frontbuffer_tracking results: parsing output: 138/ for test: prime_self_import results: parsing output: 139/ for test: perf_pmu results: parsing output: 140/ for test: kms_plane_lowres results: parsing output: 141/ for test: kms_ccs results: parsing output: 142/ for test: kms_flip_scaled_crc results: parsing output: 143/ for test: gem_ctx_shared results: parsing output: 144/ for test: kms_psr results: parsing output: 145/ for test: gem_render_copy results: parsing output: 146/ for test: kms_plane_scaling results: parsing output: 147/ for test: kms_psr results: parsing output: 148/ for test: i915_query results: parsing output: 149/ for test: kms_pm_rpm results: parsing output: 150/ for test: kms_frontbuffer_tracking results: parsing output: 151/ for test: perf results: parsing output: 152/ for test: kms_chamelium_frames results: parsing output: 153/ for test: kms_multipipe_modeset results: parsing output: 154/ for test: api_intel_allocator Done.