[55.770669] Initializing watchdogs [55.770711] /dev/watchdog0 [55.784147] [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] [55.788679] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [55.790942] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [55.794195] [001/134] (960s left) gem_mmap_offset (partial-unmap) [55.862583] Starting subtest: partial-unmap [55.864993] Starting dynamic subtest: smem0 [56.349816] Dynamic subtest smem0: SUCCESS (0.486s) [56.352598] Subtest partial-unmap: SUCCESS (0.487s) [56.515900] [002/134] (959s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt) [56.625408] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt [56.630056] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [56.742547] [003/134] (959s left) perf (short-reads) [56.883112] Starting subtest: short-reads [56.896997] Subtest short-reads: SUCCESS (0.016s) [56.934644] [004/134] (959s left) gem_exec_balancer (parallel-balancer) [57.189983] Starting subtest: parallel-balancer [58.023945] Subtest parallel-balancer: SUCCESS (0.834s) [58.138163] [005/134] (958s left) kms_vblank (invalid) [58.227132] Starting subtest: invalid [58.229497] Starting dynamic subtest: pipe-A-eDP-1 [58.659268] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.431s) [58.661495] Subtest invalid: SUCCESS (0.432s) [59.474806] [006/134] (956s left) i915_drm_fdinfo (busy-hang) [59.513851] Starting subtest: busy-hang [59.516216] Starting dynamic subtest: rcs0 [59.555853] Dynamic subtest rcs0: SKIP (0.040s) [59.564878] Starting dynamic subtest: bcs0 [59.569202] Dynamic subtest bcs0: SKIP (0.002s) [59.577665] Starting dynamic subtest: vcs0 [59.581746] Dynamic subtest vcs0: SKIP (0.001s) [59.588113] Starting dynamic subtest: vcs1 [59.592077] Dynamic subtest vcs1: SKIP (0.001s) [59.598087] Starting dynamic subtest: vecs0 [59.602098] Dynamic subtest vecs0: SKIP (0.000s) [59.608164] Starting dynamic subtest: ccs0 [59.612260] Dynamic subtest ccs0: SKIP (0.000s) [59.616486] Subtest busy-hang: SKIP (0.048s) [59.652874] [007/134] (956s left) fbdev (info) [59.684806] Starting subtest: info [59.687069] Subtest info: SUCCESS (0.000s) [59.785232] [008/134] (956s left) syncobj_timeline (multi-wait-submitted-signaled) [59.845599] Starting subtest: multi-wait-submitted-signaled [59.847625] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s) [59.942639] [009/134] (956s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc) [60.025466] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc [60.027839] Starting dynamic subtest: pipe-A-eDP-1 [60.478847] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.426s) [60.486979] Starting dynamic subtest: pipe-B-eDP-1 [61.910071] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.429s) [61.919120] Starting dynamic subtest: pipe-C-eDP-1 [63.275185] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.363s) [63.284784] Starting dynamic subtest: pipe-D-eDP-1 [64.612784] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.336s) [64.615075] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (4.557s) [65.801805] [010/134] (950s left) kms_psr (psr2-primary-page-flip) [65.898044] Starting subtest: psr2-primary-page-flip [65.900440] Starting dynamic subtest: eDP-1 [67.584096] Dynamic subtest eDP-1: SUCCESS (1.688s) [67.586547] Subtest psr2-primary-page-flip: SUCCESS (1.688s) [68.465441] [011/134] (948s left) gem_exec_nop (basic-parallel) [68.540421] Starting subtest: basic-parallel [84.888827] Subtest basic-parallel: SUCCESS (16.358s) [85.158626] [012/134] (931s left) gem_exec_reloc (basic-wc) [85.213964] Subtest basic-wc: SKIP (0.000s) [85.286710] [013/134] (931s left) kms_chamelium_hpd (dp-hpd-after-suspend) [85.675695] Subtest dp-hpd-after-suspend: SKIP (0.000s) [86.467436] [014/134] (930s left) kms_setmode (basic) [86.528973] Starting subtest: basic [86.874979] Starting dynamic subtest: pipe-A-eDP-1 [88.910596] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.031s) [89.257019] Starting dynamic subtest: pipe-B-eDP-1 [91.344092] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.090s) [91.650577] Subtest basic: SUCCESS (5.118s) [92.499864] [015/134] (924s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt) [92.604776] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt [92.609215] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [92.733188] [016/134] (924s left) kms_pm_rpm (modeset-non-lpsp-stress) [94.269737] Starting subtest: modeset-non-lpsp-stress [95.416744] Subtest modeset-non-lpsp-stress: SKIP (1.147s) [95.810343] [017/134] (921s left) gem_softpin (allocator-evict) [95.872762] Starting subtest: allocator-evict [95.875216] Starting dynamic subtest: rcs0 [119.175692] Dynamic subtest rcs0: SUCCESS (23.303s) [119.184435] Starting dynamic subtest: bcs0 [142.850204] Dynamic subtest bcs0: SUCCESS (23.673s) [142.860581] Starting dynamic subtest: vcs0 [166.226683] Dynamic subtest vcs0: SUCCESS (23.375s) [166.236928] Starting dynamic subtest: vcs1 [189.745295] Dynamic subtest vcs1: SUCCESS (23.517s) [189.754999] Starting dynamic subtest: vecs0 [213.348891] Dynamic subtest vecs0: SUCCESS (23.602s) [213.357303] Starting dynamic subtest: ccs0 [236.870211] Dynamic subtest ccs0: SUCCESS (23.521s) [236.872791] Subtest allocator-evict: SUCCESS (140.994s) [236.971424] [018/134] (779s left) gem_ctx_persistence (legacy-engines-hang) [237.075887] Starting subtest: legacy-engines-hang [237.078265] Starting dynamic subtest: render [237.168351] Dynamic subtest render: SUCCESS (0.094s) [237.178939] Starting dynamic subtest: bsd1 [237.286927] Dynamic subtest bsd1: SUCCESS (0.117s) [237.297781] Starting dynamic subtest: bsd2 [237.398888] Dynamic subtest bsd2: SUCCESS (0.110s) [237.406629] Starting dynamic subtest: blt [237.525547] Dynamic subtest blt: SUCCESS (0.126s) [237.536666] Starting dynamic subtest: vebox [237.650806] Dynamic subtest vebox: SUCCESS (0.123s) [237.654115] Subtest legacy-engines-hang: SUCCESS (0.578s) [237.752051] [019/134] (779s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt) [237.859043] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt [237.862555] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [237.980512] [020/134] (779s left) syncobj_wait (wait-all-for-submit-complex) [238.041224] Starting subtest: wait-all-for-submit-complex [238.256703] Subtest wait-all-for-submit-complex: SUCCESS (0.213s) [238.336648] [021/134] (778s left) kms_ccs (crc-primary-basic-yf-tiled-ccs) [238.431610] Starting subtest: crc-primary-basic-yf-tiled-ccs [238.433851] Starting dynamic subtest: pipe-A-eDP-1 [238.456462] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [238.465603] Starting dynamic subtest: pipe-B-eDP-1 [238.487083] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [238.494862] Starting dynamic subtest: pipe-C-eDP-1 [238.515261] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [238.523306] Starting dynamic subtest: pipe-D-eDP-1 [238.546397] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [238.550691] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.004s) [240.669248] [022/134] (776s left) i915_pm_rpm (gem-idle) [242.239730] Starting subtest: gem-idle [248.440459] Subtest gem-idle: SUCCESS (6.202s) [248.788555] [023/134] (768s left) syncobj_timeline (multi-wait-available-submitted) [249.847918] Starting subtest: multi-wait-available-submitted [249.850404] Subtest multi-wait-available-submitted: SUCCESS (0.001s) [249.993405] [024/134] (767s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc) [250.099369] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc [250.103686] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [250.213472] [025/134] (766s left) gem_ctx_persistence (engines-mixed-process) [250.269990] Starting subtest: engines-mixed-process [250.272019] Starting dynamic subtest: rcs0 [251.940717] Dynamic subtest rcs0: SUCCESS (1.673s) [251.951052] Starting dynamic subtest: bcs0 [253.945950] Dynamic subtest bcs0: SUCCESS (2.004s) [253.956535] Starting dynamic subtest: vcs0 [255.926837] Dynamic subtest vcs0: SUCCESS (1.980s) [255.937806] Starting dynamic subtest: vcs1 [257.897979] Dynamic subtest vcs1: SUCCESS (1.970s) [257.907789] Starting dynamic subtest: vecs0 [259.954925] Dynamic subtest vecs0: SUCCESS (2.056s) [259.965743] Starting dynamic subtest: ccs0 [261.930949] Dynamic subtest ccs0: SUCCESS (1.975s) [261.933631] Subtest engines-mixed-process: SUCCESS (11.664s) [262.019194] [026/134] (755s left) kms_plane (plane-position-hole-dpms) [262.119732] Starting subtest: plane-position-hole-dpms [262.641050] Starting dynamic subtest: pipe-A-plane-1 [265.045442] Dynamic subtest pipe-A-plane-1: SUCCESS (2.401s) [265.055164] Starting dynamic subtest: pipe-A-plane-2 [267.394582] Dynamic subtest pipe-A-plane-2: SUCCESS (2.351s) [267.404362] Starting dynamic subtest: pipe-A-plane-3 [269.756495] Dynamic subtest pipe-A-plane-3: SUCCESS (2.362s) [269.764375] Starting dynamic subtest: pipe-A-plane-4 [272.069518] Dynamic subtest pipe-A-plane-4: SUCCESS (2.309s) [272.078603] Starting dynamic subtest: pipe-A-plane-5 [272.093258] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s) [273.282032] Starting dynamic subtest: pipe-B-plane-1 [275.610933] Dynamic subtest pipe-B-plane-1: SUCCESS (2.336s) [275.620597] Starting dynamic subtest: pipe-B-plane-2 [277.984357] Dynamic subtest pipe-B-plane-2: SUCCESS (2.373s) [277.994230] Starting dynamic subtest: pipe-B-plane-3 [280.327606] Dynamic subtest pipe-B-plane-3: SUCCESS (2.341s) [280.335612] Starting dynamic subtest: pipe-B-plane-4 [282.675464] Dynamic subtest pipe-B-plane-4: SUCCESS (2.346s) [282.684718] Starting dynamic subtest: pipe-B-plane-5 [282.699984] Dynamic subtest pipe-B-plane-5: SUCCESS (0.026s) [282.702312] Subtest plane-position-hole-dpms: SUCCESS (20.578s) [283.511342] [027/134] (733s left) gem_userptr_blits (readonly-pwrite-unsync) [283.583582] Subtest readonly-pwrite-unsync: SKIP (0.000s) [283.755640] [028/134] (733s left) gem_eio (suspend) [283.983619] Starting subtest: suspend [296.037742] Subtest suspend: SUCCESS (12.053s) [296.201336] [029/134] (721s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy) [296.326877] Starting subtest: 2x-flip-vs-cursor-legacy [296.331675] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s) [296.510082] [030/134] (720s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs) [296.602712] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs [296.604973] Starting dynamic subtest: pipe-A-eDP-1 [296.613458] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [296.622607] Starting dynamic subtest: pipe-B-eDP-1 [296.631343] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [296.640968] Starting dynamic subtest: pipe-C-eDP-1 [296.649195] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [296.657651] Starting dynamic subtest: pipe-D-eDP-1 [296.666102] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [296.670331] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.004s) [298.840653] [031/134] (718s left) gem_exec_suspend (basic) [298.900156] Starting subtest: basic [298.902527] Starting dynamic subtest: smem [300.885118] Dynamic subtest smem: SUCCESS (1.983s) [300.887692] Subtest basic: SUCCESS (1.984s) [301.073210] [032/134] (716s left) kms_atomic_transition (plane-all-transition-nonblocking) [301.164348] Starting subtest: plane-all-transition-nonblocking [301.166860] Starting dynamic subtest: pipe-A-eDP-1 [303.659634] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.497s) [303.962427] Starting dynamic subtest: pipe-B-eDP-1 [307.161647] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.206s) [307.457439] Subtest plane-all-transition-nonblocking: SUCCESS (6.295s) [308.290867] [033/134] (709s left) gen9_exec_parse (secure-batches) [308.345197] Subtest secure-batches: SKIP (0.000s) [308.414959] [034/134] (709s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [308.527495] Starting subtest: basic-flip-before-cursor-varying-size [309.460451] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.931s) [310.320561] [035/134] (707s left) gem_exec_whisper (basic-forked) [310.391855] Starting subtest: basic-forked [318.455792] Subtest basic-forked: SUCCESS (8.064s) [318.651338] [036/134] (698s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy) [318.776126] Starting subtest: 2x-long-cursor-vs-flip-legacy [318.780380] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.001s) [318.951011] [037/134] (698s left) kms_vrr (seamless-rr-switch-vrr) [319.056829] Starting subtest: seamless-rr-switch-vrr [319.063735] Subtest seamless-rr-switch-vrr: SKIP (0.000s) [319.153738] [038/134] (698s left) perf_pmu (semaphore-wait-idle) [319.199081] Starting subtest: semaphore-wait-idle [319.201140] Starting dynamic subtest: rcs0 [319.714850] Dynamic subtest rcs0: SUCCESS (0.515s) [319.724838] Starting dynamic subtest: bcs0 [320.230051] Dynamic subtest bcs0: SUCCESS (0.512s) [320.241034] Starting dynamic subtest: vcs0 [320.743597] Dynamic subtest vcs0: SUCCESS (0.510s) [320.754195] Starting dynamic subtest: vcs1 [321.258449] Dynamic subtest vcs1: SUCCESS (0.510s) [321.274966] Starting dynamic subtest: vecs0 [321.769779] Dynamic subtest vecs0: SUCCESS (0.510s) [321.781572] Starting dynamic subtest: ccs0 [322.286092] Dynamic subtest ccs0: SUCCESS (0.513s) [322.288984] Subtest semaphore-wait-idle: SUCCESS (3.089s) [322.420857] [039/134] (695s left) kms_psr (fbc-pr-sprite-render) [322.514094] Starting subtest: fbc-pr-sprite-render [322.518448] Subtest fbc-pr-sprite-render: SKIP (0.000s) [322.595620] [040/134] (695s left) gem_userptr_blits (nohangcheck) [322.665180] Starting subtest: nohangcheck [322.886479] Subtest nohangcheck: SUCCESS (0.219s) [323.023655] [041/134] (694s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc) [323.117611] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc [323.121609] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [323.261082] [042/134] (694s left) kms_big_fb (4-tiled-16bpp-rotate-90) [323.357449] Starting subtest: 4-tiled-16bpp-rotate-90 [323.377360] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.019s) [323.503433] [043/134] (694s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling) [323.586992] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling [323.589305] Starting dynamic subtest: pipe-A-default-mode [324.765341] Dynamic subtest pipe-A-default-mode: SKIP (1.176s) [324.769507] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.177s) [324.958624] [044/134] (692s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-pwrite) [325.048676] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-pwrite [325.053093] Subtest fbc-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [325.178398] [045/134] (692s left) prime_vgem (fence-flip-hang) [325.330334] Subtest fence-flip-hang: SKIP (0.000s) [325.451593] [FACT prime_vgem (fence-flip-hang)] new: kernel.kmod_is_loaded.vgem: true [325.454939] [046/134] (692s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling) [325.551179] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling [325.553424] Starting dynamic subtest: pipe-A-default-mode [326.687059] Dynamic subtest pipe-A-default-mode: SKIP (1.134s) [326.691610] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.136s) [326.893176] [047/134] (691s left) kms_psr (fbc-psr-sprite-render) [326.989432] Starting subtest: fbc-psr-sprite-render [326.991691] Starting dynamic subtest: eDP-1 [326.995771] Dynamic subtest eDP-1: SKIP (0.000s) [326.999853] Subtest fbc-psr-sprite-render: SKIP (0.001s) [327.075816] [048/134] (691s left) gem_pwrite_snooped [327.219960] [049/134] (690s left) kms_colorop (plane-xr24-xr24-srgb_eotf-srgb_inv_eotf-srgb_eotf) [327.351235] Subtest plane-XR24-XR24-srgb_eotf-srgb_inv_eotf-srgb_eotf: SKIP (0.000s) [327.443417] [050/134] (690s left) kms_addfb_basic (invalid-set-prop-any) [327.494029] Starting subtest: invalid-set-prop-any [327.496183] Subtest invalid-set-prop-any: SUCCESS (0.000s) [327.648845] [051/134] (690s left) gem_ctx_param (invalid-param-set) [327.702430] Starting subtest: invalid-param-set [327.704181] Subtest invalid-param-set: SUCCESS (0.000s) [327.806031] [052/134] (690s left) kms_pm_backlight (fade-with-suspend) [327.904344] Starting subtest: fade-with-suspend [344.162928] Starting dynamic subtest: eDP-1 [346.828292] Dynamic subtest eDP-1: SUCCESS (2.670s) [346.830610] Subtest fade-with-suspend: SUCCESS (3.878s) [347.679310] [053/134] (670s left) kms_getfb (getfb-handle-valid) [347.792518] Starting subtest: getfb-handle-valid [347.794797] Subtest getfb-handle-valid: SUCCESS (0.000s) [347.922286] [054/134] (670s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt) [348.025060] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt [348.029202] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [348.136821] [055/134] (670s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions) [348.251641] Starting subtest: cursorB-vs-flipB-atomic-transitions [348.256171] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s) [348.418612] [056/134] (670s left) kms_flip (absolute-wf_vblank) [348.508601] Starting subtest: absolute-wf_vblank [348.510899] Starting dynamic subtest: A-eDP1 [357.210326] Dynamic subtest A-eDP1: SUCCESS (8.699s) [357.222987] Starting dynamic subtest: B-eDP1 [365.948928] Dynamic subtest B-eDP1: SUCCESS (8.735s) [365.961068] Starting dynamic subtest: C-eDP1 [374.673735] Dynamic subtest C-eDP1: SUCCESS (8.722s) [374.686156] Starting dynamic subtest: D-eDP1 [383.403142] Dynamic subtest D-eDP1: SUCCESS (8.728s) [383.405533] Subtest absolute-wf_vblank: SUCCESS (34.892s) [384.639838] [057/134] (633s left) kms_dp_link_training (uhbr-sst) [384.743814] Starting subtest: uhbr-sst [384.752466] Subtest uhbr-sst: SKIP (0.000s) [384.843905] [058/134] (633s left) gem_ctx_param (set-priority-range) [384.902831] Starting subtest: set-priority-range [384.912933] Subtest set-priority-range: SUCCESS (0.012s) [385.042035] [059/134] (633s left) kms_color (ctm-max) [385.127524] Starting subtest: ctm-max [385.129506] Starting dynamic subtest: pipe-A-eDP-1 [385.836888] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.708s) [385.847688] Starting dynamic subtest: pipe-B-eDP-1 [387.223766] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.386s) [387.233468] Starting dynamic subtest: pipe-C-eDP-1 [388.617821] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.393s) [388.627725] Starting dynamic subtest: pipe-D-eDP-1 [389.945025] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.328s) [389.947367] Subtest ctm-max: SUCCESS (4.818s) [390.744746] [060/134] (627s left) gem_render_copy (yf-tiled-ccs-to-linear) [390.812931] Starting subtest: yf-tiled-ccs-to-linear [390.817217] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s) [391.017644] [061/134] (627s left) i915_drm_fdinfo (virtual-busy-idle) [391.058301] Starting subtest: virtual-busy-idle [391.062542] Subtest virtual-busy-idle: SKIP (0.000s) [391.135078] [062/134] (627s left) gem_mmap_gtt (basic-write) [391.198215] Subtest basic-write: SKIP (0.000s) [391.266224] [063/134] (627s left) kms_psr (fbc-psr-cursor-render) [391.361669] Starting subtest: fbc-psr-cursor-render [391.363874] Starting dynamic subtest: eDP-1 [391.367916] Dynamic subtest eDP-1: SKIP (0.000s) [391.371975] Subtest fbc-psr-cursor-render: SKIP (0.001s) [391.445678] [064/134] (627s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt) [391.548353] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt [398.531802] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.986s) [398.712107] [065/134] (620s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-plflip-blt) [398.800045] Starting subtest: psr-1p-primscrn-shrfb-plflip-blt [406.329835] Subtest psr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.531s) [406.453788] [066/134] (612s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs) [406.517526] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs [406.522214] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s) [406.711845] [067/134] (612s left) gem_pxp (create-protected-buffer) [406.830345] Starting subtest: create-protected-buffer [406.832815] Subtest create-protected-buffer: SUCCESS (0.000s) [406.956866] [068/134] (611s left) kms_lease (cursor-implicit-plane) [407.046377] Starting subtest: cursor-implicit-plane [407.048566] Starting dynamic subtest: pipe-A-eDP-1 [407.498364] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.451s) [407.509267] Starting dynamic subtest: pipe-B-eDP-1 [408.595036] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.094s) [408.604839] Starting dynamic subtest: pipe-C-eDP-1 [409.709729] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.114s) [409.719360] Starting dynamic subtest: pipe-D-eDP-1 [410.832002] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.120s) [410.833893] Subtest cursor-implicit-plane: SUCCESS (3.786s) [411.701747] [069/134] (607s left) kms_frontbuffer_tracking (psr-suspend) [411.797748] Starting subtest: psr-suspend [450.392969] Subtest psr-suspend: SUCCESS (7.696s) [450.522924] [070/134] (568s left) api_intel_bb (simple-bb) [450.581354] Starting subtest: simple-bb [450.586455] Subtest simple-bb: SUCCESS (0.007s) [450.766418] [071/134] (568s left) kms_psr (psr-cursor-mmap-gtt) [450.858819] Starting subtest: psr-cursor-mmap-gtt [450.861118] Starting dynamic subtest: eDP-1 [452.594705] Dynamic subtest eDP-1: SUCCESS (1.733s) [452.597372] Subtest psr-cursor-mmap-gtt: SUCCESS (1.734s) [453.482268] [072/134] (565s left) gem_userptr_blits (stress-mm-invalidate-close-overlap) [453.554653] Starting subtest: stress-mm-invalidate-close-overlap [455.706666] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.150s) [455.869257] [073/134] (563s left) kms_atomic (atomic-invalid-params) [455.961802] Starting subtest: atomic-invalid-params [455.964132] Starting dynamic subtest: pipe-A-eDP-1 [456.351629] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.388s) [456.353620] Subtest atomic-invalid-params: SUCCESS (0.389s) [457.209367] [074/134] (561s left) gem_exec_schedule (submit-early-slice) [457.285393] Starting subtest: submit-early-slice [457.287414] Starting dynamic subtest: rcs0 [457.313450] Dynamic subtest rcs0: SUCCESS (0.037s) [457.326085] Starting dynamic subtest: bcs0 [457.346340] Dynamic subtest bcs0: SUCCESS (0.032s) [457.356616] Starting dynamic subtest: vcs0 [457.384630] Dynamic subtest vcs0: SUCCESS (0.038s) [457.395223] Starting dynamic subtest: vcs1 [457.418591] Dynamic subtest vcs1: SUCCESS (0.033s) [457.429448] Starting dynamic subtest: vecs0 [457.456170] Dynamic subtest vecs0: SUCCESS (0.037s) [457.468380] Starting dynamic subtest: ccs0 [457.489223] Dynamic subtest ccs0: SUCCESS (0.033s) [457.491470] Subtest submit-early-slice: SUCCESS (0.214s) [458.958434] [075/134] (560s left) kms_big_fb (yf-tiled-8bpp-rotate-90) [459.062858] Starting subtest: yf-tiled-8bpp-rotate-90 [459.067338] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s) [459.197221] [076/134] (560s left) perf_pmu (enable-race) [459.233420] Starting subtest: enable-race [459.235258] Starting dynamic subtest: rcs0 [472.001855] Dynamic subtest rcs0: SUCCESS (12.763s) [472.014391] Starting dynamic subtest: bcs0 [484.738664] Dynamic subtest bcs0: SUCCESS (12.729s) [484.749845] Starting dynamic subtest: vcs0 [499.851651] Dynamic subtest vcs0: SUCCESS (15.104s) [499.862147] Starting dynamic subtest: vcs1 [515.851084] Dynamic subtest vcs1: SUCCESS (15.989s) [515.863761] Starting dynamic subtest: vecs0 [531.850681] Dynamic subtest vecs0: SUCCESS (15.990s) [531.862821] Starting dynamic subtest: ccs0 [544.607608] Dynamic subtest ccs0: SUCCESS (12.750s) [544.609927] Subtest enable-race: SUCCESS (85.339s) [544.726965] [077/134] (474s left) syncobj_timeline (wait-all-for-submit-delayed-submit) [544.776202] Starting subtest: wait-all-for-submit-delayed-submit [544.879637] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s) [544.988347] [078/134] (474s left) kms_big_fb (y-tiled-64bpp-rotate-90) [545.092709] Starting subtest: y-tiled-64bpp-rotate-90 [545.097305] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s) [545.228414] [079/134] (474s left) drm_read (fault-buffer) [545.375858] Starting subtest: fault-buffer [545.378405] Subtest fault-buffer: SUCCESS (0.001s) [545.539175] [080/134] (473s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc) [545.633109] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc [552.362483] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (6.737s) [552.499258] [081/134] (466s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip) [552.593843] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip [553.826083] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip: FAIL (0.646s) [553.865455] [082/134] (465s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format) [553.969186] Starting subtest: plane-scaler-unity-scaling-with-pixel-format [553.971078] Starting dynamic subtest: pipe-A [555.073457] Dynamic subtest pipe-A: SUCCESS (1.106s) [555.082782] Starting dynamic subtest: pipe-B [557.229102] Dynamic subtest pipe-B: SUCCESS (2.156s) [557.238588] Starting dynamic subtest: pipe-C [558.454171] Dynamic subtest pipe-C: SUCCESS (1.225s) [558.465803] Starting dynamic subtest: pipe-D [559.682934] Dynamic subtest pipe-D: SUCCESS (1.228s) [559.685547] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (5.720s) [560.891875] [083/134] (458s left) kms_content_protection (lic-type-1) [561.029840] Starting subtest: lic-type-1 [561.034391] Subtest lic-type-1: SKIP (0.000s) [561.199572] [084/134] (458s left) prime_vgem (basic-fence-mmap) [561.288771] Starting subtest: basic-fence-mmap [561.293434] Subtest basic-fence-mmap: SKIP (0.000s) [561.422442] [085/134] (458s left) kms_feature_discovery (psr2) [561.519722] Starting subtest: psr2 [561.521993] Subtest psr2: SUCCESS (0.000s) [561.609910] [086/134] (458s left) prime_self_import (reimport-vs-gem_close-race) [561.643148] Starting subtest: reimport-vs-gem_close-race [566.733658] Subtest reimport-vs-gem_close-race: SUCCESS (5.097s) [566.823732] [087/134] (452s left) kms_ccs (bad-rotation-90-4-tiled-lnl-ccs) [566.922691] Starting subtest: bad-rotation-90-4-tiled-lnl-ccs [566.927166] Subtest bad-rotation-90-4-tiled-lnl-ccs: SKIP (0.000s) [568.015198] [088/134] (451s left) sysfs_timeslice_duration (invalid) [568.063852] Starting subtest: invalid [568.066333] Starting dynamic subtest: vecs0 [568.068730] Dynamic subtest vecs0: SUCCESS (0.000s) [568.080635] Starting dynamic subtest: ccs0 [568.082927] Dynamic subtest ccs0: SUCCESS (0.000s) [568.092725] Starting dynamic subtest: vcs0 [568.094952] Dynamic subtest vcs0: SUCCESS (0.000s) [568.104641] Starting dynamic subtest: bcs0 [568.106933] Dynamic subtest bcs0: SUCCESS (0.000s) [568.116663] Starting dynamic subtest: rcs0 [568.118915] Dynamic subtest rcs0: SUCCESS (0.000s) [568.127979] Starting dynamic subtest: vcs1 [568.130276] Dynamic subtest vcs1: SUCCESS (0.000s) [568.132198] Subtest invalid: SUCCESS (0.006s) [568.197552] [089/134] (451s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt) [568.302257] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt [568.306644] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [568.437483] [090/134] (451s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted) [568.499707] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted [568.608096] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.107s) [568.694433] [091/134] (451s left) kms_hdr (static-toggle-suspend) [568.789045] Starting subtest: static-toggle-suspend [568.795507] Subtest static-toggle-suspend: SKIP (0.000s) [568.876069] [092/134] (451s left) kms_chamelium_color (ctm-0-25) [568.976356] Subtest ctm-0-25: SKIP (0.000s) [569.019663] [093/134] (450s left) kms_vblank (crtc-id) [569.115088] Starting subtest: crtc-id [569.116988] Starting dynamic subtest: pipe-A-eDP-1 [569.559320] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.444s) [569.574816] Starting dynamic subtest: pipe-D-eDP-1 [570.732290] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.172s) [570.734585] Subtest crtc-id: SUCCESS (1.620s) [571.583040] [094/134] (448s left) kms_addfb_basic (framebuffer-vs-set-tiling) [571.640623] Starting subtest: framebuffer-vs-set-tiling [571.645194] Subtest framebuffer-vs-set-tiling: SKIP (0.000s) [571.799730] [095/134] (448s left) kms_big_fb (x-tiled-16bpp-rotate-180) [571.897445] Starting subtest: x-tiled-16bpp-rotate-180 [573.243626] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.348s) [573.397433] [096/134] (446s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff) [573.493225] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff [573.496815] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [573.631771] [097/134] (446s left) kms_flip (wf_vblank-ts-check) [573.722323] Starting subtest: wf_vblank-ts-check [573.724247] Starting dynamic subtest: A-eDP1 [582.622768] Dynamic subtest A-eDP1: SUCCESS (8.903s) [582.633064] Starting dynamic subtest: B-eDP1 [591.550891] Dynamic subtest B-eDP1: SUCCESS (8.927s) [591.560796] Starting dynamic subtest: C-eDP1 [600.457690] Dynamic subtest C-eDP1: SUCCESS (8.904s) [600.469483] Starting dynamic subtest: D-eDP1 [609.383803] Dynamic subtest D-eDP1: SUCCESS (8.925s) [609.388605] Subtest wf_vblank-ts-check: SUCCESS (35.672s) [610.625871] [098/134] (409s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt) [610.732446] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt [610.736570] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s) [610.851387] [099/134] (409s left) kms_cursor_crc (cursor-onscreen-128x128) [611.051208] Starting subtest: cursor-onscreen-128x128 [611.056134] Starting dynamic subtest: pipe-A-eDP-1 [613.153728] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.096s) [613.187031] Starting dynamic subtest: pipe-D-eDP-1 [615.887996] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.710s) [615.890102] Subtest cursor-onscreen-128x128: SUCCESS (4.836s) [616.699798] [100/134] (403s left) drm_read (invalid-buffer) [616.848600] Starting subtest: invalid-buffer [616.850539] Subtest invalid-buffer: SUCCESS (0.000s) [616.997132] [101/134] (403s left) gem_sync (basic-store-all) [617.066213] Starting subtest: basic-store-all [619.948284] Subtest basic-store-all: SUCCESS (2.892s) [620.150961] [102/134] (400s left) kms_async_flips (async-flip-hang) [620.258727] Starting subtest: async-flip-hang [620.632512] Starting dynamic subtest: pipe-A-eDP-1 [621.861816] Dynamic subtest pipe-A-eDP-1: FAIL (0.736s) [621.873457] Starting dynamic subtest: pipe-B-eDP-1 [622.757642] Dynamic subtest pipe-B-eDP-1: FAIL (0.763s) [622.873638] Starting dynamic subtest: pipe-C-eDP-1 [638.379491] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.514s) [638.755099] Starting dynamic subtest: pipe-D-eDP-1 [654.308602] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.558s) [654.311329] Subtest async-flip-hang: FAIL (34.043s) [655.545875] [103/134] (364s left) gem_exec_reloc (basic-cpu-wc) [655.605255] Subtest basic-cpu-wc: SKIP (0.000s) [655.701165] [104/134] (364s left) kms_lease (lease-uevent) [655.793219] Starting subtest: lease-uevent [656.802108] Subtest lease-uevent: SUCCESS (1.010s) [656.908311] [105/134] (363s left) i915_query (engine-info-invalid) [656.965807] Starting subtest: engine-info-invalid [656.968065] Subtest engine-info-invalid: SUCCESS (0.000s) [657.083948] [106/134] (363s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip) [657.189777] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip [658.167047] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (0.979s) [658.324078] [107/134] (362s left) syncobj_basic (bad-destroy) [658.380392] Starting subtest: bad-destroy [658.381948] Subtest bad-destroy: SUCCESS (0.000s) [658.487948] [108/134] (362s left) kms_cursor_edge_walk (64x64-right-edge) [658.576293] Starting subtest: 64x64-right-edge [658.578168] Starting dynamic subtest: pipe-A-eDP-1 [661.989619] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.411s) [661.999870] Starting dynamic subtest: pipe-D-eDP-1 [665.115936] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.125s) [665.118205] Subtest 64x64-right-edge: SUCCESS (6.539s) [665.944643] [109/134] (354s left) kms_busy (extended-modeset-hang-oldfb) [666.039143] Starting subtest: extended-modeset-hang-oldfb [666.041532] Starting dynamic subtest: pipe-A [677.707648] Dynamic subtest pipe-A: SUCCESS (11.668s) [677.720405] Starting dynamic subtest: pipe-D [689.963843] Dynamic subtest pipe-D: SUCCESS (12.254s) [689.966066] Subtest extended-modeset-hang-oldfb: SUCCESS (23.927s) [690.774984] [110/134] (329s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc) [690.872293] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc [697.935292] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.065s) [698.096766] [111/134] (322s left) gem_create (create-ext-set-pat) [698.256730] Starting subtest: create-ext-set-pat [698.259539] Subtest create-ext-set-pat: SUCCESS (0.001s) [698.383884] [112/134] (322s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing) [698.479722] Starting subtest: plane-use-after-nonblocking-unbind-fencing [698.482138] Starting dynamic subtest: pipe-A-eDP-1 [698.541188] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.063s) [698.836693] Starting dynamic subtest: pipe-B-eDP-1 [699.610449] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.783s) [699.908149] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (1.428s) [700.788262] [113/134] (319s left) gem_set_tiling_vs_blt (tiled-to-tiled) [700.852183] Subtest tiled-to-tiled: SKIP (0.000s) [700.931567] [114/134] (319s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb) [705.933657] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb [705.935867] Starting dynamic subtest: pipe-A-eDP-1 [712.768996] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.834s) [712.779858] Starting dynamic subtest: pipe-B-eDP-1 [719.701431] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.929s) [719.703303] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.767s) [720.578595] [115/134] (300s left) gem_ctx_shared (exec-single-timeline) [720.647315] Starting subtest: exec-single-timeline [720.649541] Starting dynamic subtest: rcs0 [721.703938] Dynamic subtest rcs0: SUCCESS (1.054s) [721.717244] Starting dynamic subtest: bcs0 [722.792040] Dynamic subtest bcs0: SUCCESS (1.085s) [722.805779] Starting dynamic subtest: vcs0 [723.881182] Dynamic subtest vcs0: SUCCESS (1.085s) [723.897951] Starting dynamic subtest: vcs1 [724.969415] Dynamic subtest vcs1: SUCCESS (1.085s) [724.981860] Starting dynamic subtest: vecs0 [726.056775] Dynamic subtest vecs0: SUCCESS (1.084s) [726.069958] Starting dynamic subtest: ccs0 [727.144413] Dynamic subtest ccs0: SUCCESS (1.084s) [727.147181] Subtest exec-single-timeline: SUCCESS (6.497s) [727.903203] [116/134] (292s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move) [728.003127] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move [728.007200] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [728.147460] [117/134] (292s left) kms_chamelium_hpd (dp-hpd-fast) [728.546297] Subtest dp-hpd-fast: SKIP (0.000s) [729.377881] [118/134] (291s left) syncobj_eventfd (binary-wait) [729.443556] Starting subtest: binary-wait [729.452174] Subtest binary-wait: SUCCESS (0.011s) [729.583360] [119/134] (291s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt) [729.694441] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt [729.698994] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [729.813654] [120/134] (291s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes) [730.374557] Starting subtest: syncobj-timeline-multiple-ext-nodes [730.377510] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.004s) [731.949899] [121/134] (289s left) kms_plane_alpha_blend (coverage-7efc) [732.048007] Starting subtest: coverage-7efc [732.327481] Starting dynamic subtest: pipe-A-eDP-1 [732.890560] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.561s) [732.918222] Starting dynamic subtest: pipe-D-eDP-1 [734.213070] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.301s) [734.215375] Subtest coverage-7efc: SUCCESS (2.165s) [735.085039] [122/134] (286s left) gem_mmap_gtt (cpuset-medium-copy-odd) [735.144592] Subtest cpuset-medium-copy-odd: SKIP (0.000s) [735.213963] [123/134] (285s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf) [740.228650] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf [740.233318] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.003s) [741.094555] [124/134] (280s left) gem_exec_endless (dispatch) [741.167399] Starting subtest: dispatch [741.169930] Starting dynamic subtest: rcs0 [741.174612] Dynamic subtest rcs0: SUCCESS (0.005s) [741.190901] Starting dynamic subtest: bcs0 [741.195352] Dynamic subtest bcs0: SUCCESS (0.004s) [741.209292] Starting dynamic subtest: vcs0 [741.213424] Dynamic subtest vcs0: SUCCESS (0.005s) [741.223078] Starting dynamic subtest: vcs1 [741.227188] Dynamic subtest vcs1: SUCCESS (0.004s) [741.236550] Starting dynamic subtest: vecs0 [741.240868] Dynamic subtest vecs0: SUCCESS (0.005s) [741.250612] Starting dynamic subtest: ccs0 [741.255091] Dynamic subtest ccs0: SUCCESS (0.004s) [741.257002] Subtest dispatch: SUCCESS (0.031s) [742.913102] [125/134] (278s left) kms_cursor_crc (cursor-size-hints) [743.045492] Starting subtest: cursor-size-hints [743.047579] Starting dynamic subtest: pipe-A-eDP-1 [743.656417] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.612s) [743.667047] Starting dynamic subtest: pipe-D-eDP-1 [744.956806] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.298s) [744.959163] Subtest cursor-size-hints: SUCCESS (1.913s) [745.785402] [126/134] (275s left) kms_prop_blob (blob-prop-validate) [745.843130] Starting subtest: blob-prop-validate [745.845541] Subtest blob-prop-validate: SUCCESS (0.000s) [745.966243] [127/134] (275s left) gem_lmem_swapping (parallel-random) [746.009347] Subtest parallel-random: SKIP (0.000s) [746.058406] [128/134] (275s left) gem_exec_gttfill (multigpu-basic) [746.231774] Starting subtest: multigpu-basic [761.979542] Subtest multigpu-basic: SUCCESS (15.746s) [762.036019] [129/134] (259s left) gem_exec_schedule (pi-ringfull) [762.272828] Starting subtest: pi-ringfull [762.275040] Starting dynamic subtest: rcs0 [762.307118] Dynamic subtest rcs0: SUCCESS (0.038s) [762.322150] Starting dynamic subtest: bcs0 [762.344828] Dynamic subtest bcs0: SUCCESS (0.037s) [762.355960] Starting dynamic subtest: vcs0 [762.386133] Dynamic subtest vcs0: SUCCESS (0.040s) [762.399707] Starting dynamic subtest: vcs1 [762.418639] Dynamic subtest vcs1: SUCCESS (0.032s) [762.428540] Starting dynamic subtest: vecs0 [762.452687] Dynamic subtest vecs0: SUCCESS (0.033s) [762.462576] Starting dynamic subtest: ccs0 [762.484803] Dynamic subtest ccs0: SUCCESS (0.031s) [762.486909] Subtest pi-ringfull: SUCCESS (0.217s) [762.729210] [130/134] (258s left) syncobj_timeline (invalid-signal-bad-pad) [762.785528] Starting subtest: invalid-signal-bad-pad [762.787807] Subtest invalid-signal-bad-pad: SUCCESS (0.000s) [762.951821] [131/134] (258s left) core_setmaster (master-drop-set-user) [763.044042] Starting subtest: master-drop-set-user [763.058246] Subtest master-drop-set-user: SUCCESS (0.014s) [763.100778] [132/134] (258s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render) [763.204666] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render [763.208862] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [763.326159] [133/134] (258s left) kms_scaling_modes (scaling-mode-full-aspect) [763.421864] Starting subtest: scaling-mode-full-aspect [763.424140] Starting dynamic subtest: pipe-A-eDP-1 [763.517299] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.097s) [763.528155] Starting dynamic subtest: pipe-B-eDP-1 [764.678888] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.161s) [764.689514] Starting dynamic subtest: pipe-C-eDP-1 [765.794686] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.114s) [765.805134] Starting dynamic subtest: pipe-D-eDP-1 [766.927533] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.132s) [766.929863] Subtest scaling-mode-full-aspect: SUCCESS (3.508s) [768.111039] [134/134] (253s left) kms_colorop (plane-xr30-xr30-ctm_3x4_bt709_enc) [768.252980] Subtest plane-XR30-XR30-ctm_3x4_bt709_enc: SKIP (0.000s) [768.332199] Closing watchdogs results: parsing output: 0/ for test: gem_mmap_offset results: parsing output: 1/ for test: kms_frontbuffer_tracking results: parsing output: 2/ for test: perf results: parsing output: 3/ for test: gem_exec_balancer results: parsing output: 4/ for test: kms_vblank results: parsing output: 5/ for test: i915_drm_fdinfo results: parsing output: 6/ for test: fbdev results: parsing output: 7/ for test: syncobj_timeline results: parsing output: 8/ for test: kms_ccs results: parsing output: 9/ for test: kms_psr results: parsing output: 10/ for test: gem_exec_nop results: parsing output: 11/ for test: gem_exec_reloc results: parsing output: 12/ for test: kms_chamelium_hpd results: parsing output: 13/ for test: kms_setmode results: parsing output: 14/ for test: kms_frontbuffer_tracking results: parsing output: 15/ for test: kms_pm_rpm results: parsing output: 16/ for test: gem_softpin results: parsing output: 17/ for test: gem_ctx_persistence results: parsing output: 18/ for test: kms_frontbuffer_tracking results: parsing output: 19/ for test: syncobj_wait results: parsing output: 20/ for test: kms_ccs results: parsing output: 21/ for test: i915_pm_rpm results: parsing output: 22/ for test: syncobj_timeline results: parsing output: 23/ for test: kms_frontbuffer_tracking results: parsing output: 24/ for test: gem_ctx_persistence results: parsing output: 25/ for test: kms_plane results: parsing output: 26/ for test: gem_userptr_blits results: parsing output: 27/ for test: gem_eio results: parsing output: 28/ for test: kms_cursor_legacy results: parsing output: 29/ for test: kms_ccs results: parsing output: 30/ for test: gem_exec_suspend results: parsing output: 31/ for test: kms_atomic_transition results: parsing output: 32/ for test: gen9_exec_parse results: parsing output: 33/ for test: kms_cursor_legacy results: parsing output: 34/ for test: gem_exec_whisper results: parsing output: 35/ for test: kms_cursor_legacy results: parsing output: 36/ for test: kms_vrr results: parsing output: 37/ for test: perf_pmu results: parsing output: 38/ for test: kms_psr results: parsing output: 39/ for test: gem_userptr_blits results: parsing output: 40/ for test: kms_frontbuffer_tracking results: parsing output: 41/ for test: kms_big_fb results: parsing output: 42/ for test: kms_flip_scaled_crc results: parsing output: 43/ for test: kms_frontbuffer_tracking results: parsing output: 44/ for test: prime_vgem results: parsing output: 45/ for test: kms_flip_scaled_crc results: parsing output: 46/ for test: kms_psr results: parsing output: 47/ for test: gem_pwrite_snooped results: parsing output: 48/ for test: kms_colorop results: parsing output: 49/ for test: kms_addfb_basic results: parsing output: 50/ for test: gem_ctx_param results: parsing output: 51/ for test: kms_pm_backlight results: parsing output: 52/ for test: kms_getfb results: parsing output: 53/ for test: kms_frontbuffer_tracking results: parsing output: 54/ for test: kms_cursor_legacy results: parsing output: 55/ for test: kms_flip results: parsing output: 56/ for test: kms_dp_link_training results: parsing output: 57/ for test: gem_ctx_param results: parsing output: 58/ for test: kms_color results: parsing output: 59/ for test: gem_render_copy results: parsing output: 60/ for test: i915_drm_fdinfo results: parsing output: 61/ for test: gem_mmap_gtt results: parsing output: 62/ for test: kms_psr results: parsing output: 63/ for test: kms_frontbuffer_tracking results: parsing output: 64/ for test: kms_frontbuffer_tracking results: parsing output: 65/ for test: gem_render_copy results: parsing output: 66/ for test: gem_pxp results: parsing output: 67/ for test: kms_lease results: parsing output: 68/ for test: kms_frontbuffer_tracking results: parsing output: 69/ for test: api_intel_bb results: parsing output: 70/ for test: kms_psr results: parsing output: 71/ for test: gem_userptr_blits results: parsing output: 72/ for test: kms_atomic results: parsing output: 73/ for test: gem_exec_schedule results: parsing output: 74/ for test: kms_big_fb results: parsing output: 75/ for test: perf_pmu results: parsing output: 76/ for test: syncobj_timeline results: parsing output: 77/ for test: kms_big_fb results: parsing output: 78/ for test: drm_read results: parsing output: 79/ for test: kms_frontbuffer_tracking results: parsing output: 80/ for test: kms_big_fb results: parsing output: 81/ for test: kms_plane_scaling results: parsing output: 82/ for test: kms_content_protection results: parsing output: 83/ for test: prime_vgem results: parsing output: 84/ for test: kms_feature_discovery results: parsing output: 85/ for test: prime_self_import results: parsing output: 86/ for test: kms_ccs results: parsing output: 87/ for test: sysfs_timeslice_duration results: parsing output: 88/ for test: kms_frontbuffer_tracking results: parsing output: 89/ for test: syncobj_timeline results: parsing output: 90/ for test: kms_hdr results: parsing output: 91/ for test: kms_chamelium_color results: parsing output: 92/ for test: kms_vblank results: parsing output: 93/ for test: kms_addfb_basic results: parsing output: 94/ for test: kms_big_fb results: parsing output: 95/ for test: kms_frontbuffer_tracking results: parsing output: 96/ for test: kms_flip results: parsing output: 97/ for test: kms_frontbuffer_tracking results: parsing output: 98/ for test: kms_cursor_crc results: parsing output: 99/ for test: drm_read results: parsing output: 100/ for test: gem_sync results: parsing output: 101/ for test: kms_async_flips results: parsing output: 102/ for test: gem_exec_reloc results: parsing output: 103/ for test: kms_lease results: parsing output: 104/ for test: i915_query results: parsing output: 105/ for test: kms_big_fb results: parsing output: 106/ for test: syncobj_basic results: parsing output: 107/ for test: kms_cursor_edge_walk results: parsing output: 108/ for test: kms_busy results: parsing output: 109/ for test: kms_frontbuffer_tracking results: parsing output: 110/ for test: gem_create results: parsing output: 111/ for test: kms_atomic_transition results: parsing output: 112/ for test: gem_set_tiling_vs_blt results: parsing output: 113/ for test: kms_psr2_sf results: parsing output: 114/ for test: gem_ctx_shared results: parsing output: 115/ for test: kms_frontbuffer_tracking results: parsing output: 116/ for test: kms_chamelium_hpd results: parsing output: 117/ for test: syncobj_eventfd results: parsing output: 118/ for test: kms_frontbuffer_tracking results: parsing output: 119/ for test: gem_exec_fence results: parsing output: 120/ for test: kms_plane_alpha_blend results: parsing output: 121/ for test: gem_mmap_gtt results: parsing output: 122/ for test: kms_psr2_sf results: parsing output: 123/ for test: gem_exec_endless results: parsing output: 124/ for test: kms_cursor_crc results: parsing output: 125/ for test: kms_prop_blob results: parsing output: 126/ for test: gem_lmem_swapping results: parsing output: 127/ for test: gem_exec_gttfill results: parsing output: 128/ for test: gem_exec_schedule results: parsing output: 129/ for test: syncobj_timeline results: parsing output: 130/ for test: core_setmaster results: parsing output: 131/ for test: kms_frontbuffer_tracking results: parsing output: 132/ for test: kms_scaling_modes results: parsing output: 133/ for test: kms_colorop Done.