[63.475141] Initializing watchdogs [63.475271] /dev/watchdog0 [63.491653] [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] [63.496530] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [63.499679] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [63.503554] [001/156] (960s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted) [63.583831] Starting subtest: multi-wait-all-for-submit-available-submitted [63.586140] Subtest multi-wait-all-for-submit-available-submitted: SUCCESS (0.001s) [63.692173] [002/156] (960s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats) [64.085470] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s) [64.937024] [003/156] (959s left) kms_color_pipeline (plane-ctm3x4) [65.033089] Starting subtest: plane-ctm3x4 [65.211626] Starting dynamic subtest: pipe-A-plane-0 [65.355473] Dynamic subtest pipe-A-plane-0: SUCCESS (0.144s) [65.365190] Starting dynamic subtest: pipe-A-plane-1 [65.466581] Dynamic subtest pipe-A-plane-1: SUCCESS (0.111s) [65.475638] Starting dynamic subtest: pipe-A-plane-2 [65.576781] Dynamic subtest pipe-A-plane-2: SUCCESS (0.111s) [66.764452] Starting dynamic subtest: pipe-B-plane-0 [66.901644] Dynamic subtest pipe-B-plane-0: SUCCESS (0.144s) [66.910901] Starting dynamic subtest: pipe-B-plane-1 [67.034634] Dynamic subtest pipe-B-plane-1: SUCCESS (0.133s) [67.043845] Starting dynamic subtest: pipe-B-plane-2 [67.200256] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s) [68.397886] Starting dynamic subtest: pipe-C-plane-0 [68.511909] Dynamic subtest pipe-C-plane-0: SUCCESS (0.122s) [68.522769] Starting dynamic subtest: pipe-C-plane-1 [68.623434] Dynamic subtest pipe-C-plane-1: SUCCESS (0.111s) [68.632638] Starting dynamic subtest: pipe-C-plane-2 [68.732982] Dynamic subtest pipe-C-plane-2: SUCCESS (0.111s) [69.903686] Starting dynamic subtest: pipe-D-plane-0 [70.009477] Dynamic subtest pipe-D-plane-0: SUCCESS (0.111s) [70.017827] Starting dynamic subtest: pipe-D-plane-1 [70.119075] Dynamic subtest pipe-D-plane-1: SUCCESS (0.111s) [70.127849] Starting dynamic subtest: pipe-D-plane-2 [70.230275] Dynamic subtest pipe-D-plane-2: SUCCESS (0.111s) [70.530747] Subtest plane-ctm3x4: SUCCESS (5.517s) [71.372860] [004/156] (952s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs) [71.474296] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs [71.476588] Starting dynamic subtest: pipe-A-eDP-1 [71.499426] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [71.509633] Starting dynamic subtest: pipe-B-eDP-1 [71.530733] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [71.538070] Starting dynamic subtest: pipe-C-eDP-1 [71.559736] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [71.566985] Starting dynamic subtest: pipe-D-eDP-1 [71.589061] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [71.593144] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.003s) [73.756297] [005/156] (950s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling) [73.846719] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling [73.849198] Starting dynamic subtest: pipe-A-default-mode [75.005864] Dynamic subtest pipe-A-default-mode: SKIP (1.159s) [75.010388] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.160s) [75.148976] [006/156] (949s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-shrfb-plflip-blt) [75.247715] Starting subtest: fbcpsrhdr-2p-scndscrn-shrfb-plflip-blt [75.251690] Subtest fbcpsrhdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [75.327887] [007/156] (948s left) perf_pmu (frequency) [75.372499] Starting subtest: frequency [75.376944] Starting dynamic subtest: gt0 [77.492063] Dynamic subtest gt0: SUCCESS (2.112s) [77.500468] Starting dynamic subtest: idle-gt0 [77.996970] Dynamic subtest idle-gt0: SUCCESS (0.505s) [78.007865] Starting dynamic subtest: gt1 [82.344466] Dynamic subtest gt1: SUCCESS (4.346s) [82.354212] Starting dynamic subtest: idle-gt1 [82.847686] Dynamic subtest idle-gt1: SUCCESS (0.505s) [82.850664] Subtest frequency: SUCCESS (7.481s) [82.959189] [008/156] (941s left) gem_create (create-ext-placement-all) [83.135708] Starting subtest: create-ext-placement-all [83.138030] Subtest create-ext-placement-all: SUCCESS (0.000s) [83.241794] [009/156] (941s left) gem_exec_balancer (invalid-bonds) [83.294800] Starting subtest: invalid-bonds [83.299502] Subtest invalid-bonds: SKIP (0.000s) [83.610604] [010/156] (940s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled) [83.668719] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled [83.670795] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s) [83.775777] [011/156] (940s left) kms_async_flips (alternate-sync-async-flip-atomic) [83.866991] Starting subtest: alternate-sync-async-flip-atomic [84.249803] Starting dynamic subtest: pipe-A-eDP-1 [87.065318] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.816s) [87.443345] Starting dynamic subtest: pipe-B-eDP-1 [90.191287] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.756s) [90.574481] Starting dynamic subtest: pipe-C-eDP-1 [93.329131] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.764s) [93.696642] Starting dynamic subtest: pipe-D-eDP-1 [96.457049] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.770s) [96.459262] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.592s) [97.628678] [012/156] (926s left) gem_exec_nop (basic-sequential) [97.717390] Starting subtest: basic-sequential [112.821497] Subtest basic-sequential: SUCCESS (15.090s) [113.019313] [013/156] (911s left) kms_big_fb (linear-16bpp-rotate-270) [113.126589] Starting subtest: linear-16bpp-rotate-270 [113.145915] Subtest linear-16bpp-rotate-270: SKIP (0.019s) [113.269709] [014/156] (911s left) gen9_exec_parse (batch-zero-length) [113.327602] Subtest batch-zero-length: SKIP (0.000s) [113.408101] [015/156] (911s left) kms_big_fb (yf-tiled-16bpp-rotate-90) [113.513437] Starting subtest: yf-tiled-16bpp-rotate-90 [113.517623] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s) [113.611199] [016/156] (910s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs) [113.708032] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs [113.710240] Starting dynamic subtest: pipe-A-eDP-1 [113.729802] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.023s) [113.739808] Starting dynamic subtest: pipe-B-eDP-1 [113.759954] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.022s) [113.768845] Starting dynamic subtest: pipe-C-eDP-1 [113.786561] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.021s) [113.796277] Starting dynamic subtest: pipe-D-eDP-1 [113.813550] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.022s) [113.815551] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.092s) [116.090696] [017/156] (908s left) kms_fbcon_fbt (fbc) [116.145586] Starting subtest: fbc [122.532507] Subtest fbc: SUCCESS (6.388s) [123.625711] [018/156] (901s left) kms_feature_discovery (psr1) [123.716110] Starting subtest: psr1 [123.718424] Subtest psr1: SUCCESS (0.000s) [123.791416] [019/156] (900s left) gem_exec_schedule (u-semaphore-codependency) [123.859406] Starting subtest: u-semaphore-codependency [123.869913] Subtest u-semaphore-codependency: SUCCESS (0.015s) [124.200761] [020/156] (900s left) kms_psr (psr2-basic) [124.294404] Starting subtest: psr2-basic [124.296733] Starting dynamic subtest: eDP-1 [125.918578] Dynamic subtest eDP-1: SUCCESS (1.623s) [125.920802] Subtest psr2-basic: SUCCESS (1.625s) [126.815214] [021/156] (897s left) kms_chamelium_hpd (dp-hpd-storm-disable) [127.200349] Subtest dp-hpd-storm-disable: SKIP (0.000s) [128.002860] [022/156] (896s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc) [128.114745] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc [128.119178] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [128.199374] [023/156] (896s left) kms_plane_alpha_blend (constant-alpha-max) [128.297397] Starting subtest: constant-alpha-max [128.589254] Starting dynamic subtest: pipe-A-eDP-1 [129.654937] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.064s) [129.665466] Starting dynamic subtest: pipe-D-eDP-1 [131.320461] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.663s) [131.322753] Subtest constant-alpha-max: SUCCESS (3.023s) [132.186987] [024/156] (892s left) kms_getfb (getfb-handle-not-fb) [132.291144] Starting subtest: getfb-handle-not-fb [132.293459] Subtest getfb-handle-not-fb: SUCCESS (0.000s) [132.395723] [025/156] (892s left) perf (enable-disable) [132.511285] Starting subtest: enable-disable [132.513517] Starting dynamic subtest: 0-rcs0 [134.791776] Dynamic subtest 0-rcs0: SUCCESS (2.280s) [134.802726] Starting dynamic subtest: 1-vcs1 [139.298742] Dynamic subtest 1-vcs1: SUCCESS (4.505s) [139.301330] Subtest enable-disable: SUCCESS (6.786s) [139.339929] [026/156] (885s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled) [139.402969] Starting subtest: yf-tiled-to-vebox-yf-tiled [139.407322] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s) [139.587606] [027/156] (885s left) kms_dp_linktrain_fallback (dsc-fallback) [139.687850] Starting subtest: dsc-fallback [139.694222] Subtest dsc-fallback: SKIP (0.000s) [139.759316] [028/156] (885s left) syncobj_wait (multi-wait-all-submitted) [139.824576] Starting subtest: multi-wait-all-submitted [139.927190] Subtest multi-wait-all-submitted: SUCCESS (0.102s) [140.014795] [029/156] (885s left) gem_ctx_param (invalid-set-ringsize) [140.064835] Starting subtest: invalid-set-ringsize [140.067230] Subtest invalid-set-ringsize: SUCCESS (0.000s) [140.149360] [030/156] (885s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area) [140.254265] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area [140.256616] Starting dynamic subtest: pipe-A-eDP-1 [140.349736] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s) [140.361221] Starting dynamic subtest: pipe-B-eDP-1 [141.545360] Dynamic subtest pipe-B-eDP-1: SKIP (1.195s) [141.549961] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.297s) [142.739920] [031/156] (882s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-mmap-wc) [142.832774] Starting subtest: fbchdr-rgb101010-draw-mmap-wc [142.836954] Subtest fbchdr-rgb101010-draw-mmap-wc: SKIP (0.000s) [142.939384] [032/156] (882s left) gem_exec_schedule (preempt-contexts) [143.009898] Starting subtest: preempt-contexts [143.012187] Starting dynamic subtest: rcs0 [143.057684] Dynamic subtest rcs0: SUCCESS (0.056s) [143.067362] Starting dynamic subtest: bcs0 [143.108631] Dynamic subtest bcs0: SUCCESS (0.050s) [143.118017] Starting dynamic subtest: vcs0 [143.160456] Dynamic subtest vcs0: SUCCESS (0.051s) [143.169596] Starting dynamic subtest: vcs1 [143.205488] Dynamic subtest vcs1: SUCCESS (0.045s) [143.215643] Starting dynamic subtest: vecs0 [143.246700] Dynamic subtest vecs0: SUCCESS (0.040s) [143.256066] Starting dynamic subtest: ccs0 [143.294968] Dynamic subtest ccs0: SUCCESS (0.048s) [143.297342] Subtest preempt-contexts: SUCCESS (0.293s) [144.389446] [033/156] (880s left) gem_ppgtt (shrink-vs-evict-any) [144.440651] Starting subtest: shrink-vs-evict-any [150.389527] Subtest shrink-vs-evict-any: SUCCESS (5.894s) [150.430570] [034/156] (874s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt) [150.543669] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt [150.547894] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [150.633563] [035/156] (874s left) kms_hdmi_inject (inject-4k) [150.979431] Starting subtest: inject-4k [151.324754] Subtest inject-4k: SUCCESS (0.348s) [151.897425] [036/156] (873s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-mmap-wc) [151.993627] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-mmap-wc [151.997989] Subtest hdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s) [152.087331] [037/156] (873s left) gem_exec_flush (basic-uc-pro-default) [152.142841] Starting subtest: basic-uc-pro-default [157.632522] Subtest basic-uc-pro-default: SUCCESS (5.458s) [157.804578] [038/156] (867s left) gem_exec_schedule (smoketest-all) [157.878849] Starting subtest: smoketest-all [190.275598] Subtest smoketest-all: SUCCESS (32.353s) [191.474069] [039/156] (834s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-blt) [191.586265] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-blt [191.590278] Subtest hdr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [191.687494] [040/156] (833s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt) [191.783900] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt [191.788086] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [191.897299] [041/156] (833s left) kms_frontbuffer_tracking (psr-slowdraw) [191.984696] Starting subtest: psr-slowdraw [217.247318] Subtest psr-slowdraw: SUCCESS (25.266s) [217.358200] [042/156] (808s left) kms_pm_rpm (cursor-dpms) [219.516269] Starting subtest: cursor-dpms [219.521700] Subtest cursor-dpms: SKIP (0.000s) [219.911448] [043/156] (805s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-pwrite) [220.015964] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-pwrite [220.020157] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [220.113940] [044/156] (805s left) gem_softpin (allocator-fork) [220.168921] Starting subtest: allocator-fork [222.377705] Subtest allocator-fork: SUCCESS (2.207s) [222.499300] [045/156] (803s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling) [222.593999] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling [222.596308] Starting dynamic subtest: pipe-A-default-mode [225.342076] Dynamic subtest pipe-A-default-mode: SUCCESS (2.746s) [225.344410] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.748s) [226.163647] [046/156] (799s left) kms_flip (2x-flip-vs-modeset) [226.262203] Starting subtest: 2x-flip-vs-modeset [226.273934] Subtest 2x-flip-vs-modeset: SKIP (0.011s) [226.386136] [047/156] (799s left) syncobj_basic (create-signaled) [226.443059] Starting subtest: create-signaled [226.444977] Subtest create-signaled: SUCCESS (0.000s) [226.562231] [048/156] (799s left) gem_ctx_shared (create-shared-gtt) [226.623576] Starting subtest: create-shared-gtt [228.774072] Subtest create-shared-gtt: SUCCESS (2.151s) [229.130451] [049/156] (796s left) syncobj_wait (wait-any-complex) [229.188679] Starting subtest: wait-any-complex [229.253109] Subtest wait-any-complex: SUCCESS (0.062s) [229.332450] [050/156] (796s left) kms_prime (d3hot) [229.423511] Subtest D3hot: SKIP (0.000s) [229.573492] [FACT kms_prime (d3hot)] new: kernel.kmod_is_loaded.vgem: true [229.576965] [051/156] (796s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled) [229.633722] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled [229.636351] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s) [229.746455] [052/156] (796s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow) [229.844696] Starting subtest: yf-tiled-addfb-size-offset-overflow [229.849077] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s) [229.938127] [053/156] (796s left) syncobj_timeline (wait-for-submit-delayed-submit) [229.997270] Starting subtest: wait-for-submit-delayed-submit [230.100523] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s) [230.180303] [054/156] (795s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation) [230.281311] Starting subtest: plane-scaler-unity-scaling-with-rotation [230.283339] Starting dynamic subtest: pipe-A [230.517796] Dynamic subtest pipe-A: SUCCESS (0.240s) [230.529793] Starting dynamic subtest: pipe-B [231.807940] Dynamic subtest pipe-B: SUCCESS (1.288s) [231.818260] Starting dynamic subtest: pipe-C [233.108343] Dynamic subtest pipe-C: SUCCESS (1.299s) [233.117841] Starting dynamic subtest: pipe-D [234.403154] Dynamic subtest pipe-D: SUCCESS (1.294s) [234.405492] Subtest plane-scaler-unity-scaling-with-rotation: SUCCESS (4.126s) [235.581192] [055/156] (790s left) gem_basic (multigpu-create-close) [235.636042] Starting subtest: multigpu-create-close [235.640565] Subtest multigpu-create-close: SKIP (0.000s) [235.759915] [056/156] (790s left) kms_flip (plain-flip-fb-recreate) [235.850244] Starting subtest: plain-flip-fb-recreate [235.852635] Starting dynamic subtest: A-eDP1 [244.721204] Dynamic subtest A-eDP1: SUCCESS (8.870s) [244.733577] Starting dynamic subtest: B-eDP1 [253.609250] Dynamic subtest B-eDP1: SUCCESS (8.886s) [253.622504] Starting dynamic subtest: C-eDP1 [262.515734] Dynamic subtest C-eDP1: SUCCESS (8.904s) [262.526780] Starting dynamic subtest: D-eDP1 [271.406408] Dynamic subtest D-eDP1: SUCCESS (8.889s) [271.410842] Subtest plain-flip-fb-recreate: SUCCESS (35.560s) [272.677679] [057/156] (753s left) gem_create (create-invalid-size) [272.734555] Starting subtest: create-invalid-size [272.736500] Subtest create-invalid-size: SUCCESS (0.000s) [272.931512] [058/156] (753s left) kms_plane_multiple (tiling-4) [273.028210] Starting subtest: tiling-4 [273.030151] Starting dynamic subtest: pipe-A-eDP-1 [276.891908] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.862s) [276.901634] Starting dynamic subtest: pipe-B-eDP-1 [281.491118] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.600s) [281.502067] Starting dynamic subtest: pipe-C-eDP-1 [286.081920] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.588s) [286.091726] Starting dynamic subtest: pipe-D-eDP-1 [290.662160] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.579s) [290.664403] Subtest tiling-4: SUCCESS (17.633s) [291.558043] [059/156] (734s left) gem_exec_reloc (basic-cpu-read-noreloc) [291.612720] Subtest basic-cpu-read-noreloc: SKIP (0.000s) [291.686207] [060/156] (734s left) i915_hangman (gt-engine-hang) [291.751920] Starting subtest: gt-engine-hang [291.754227] Starting dynamic subtest: rcs0 [293.313617] Dynamic subtest rcs0: SUCCESS (1.560s) [293.330239] Starting dynamic subtest: bcs0 [295.297465] Dynamic subtest bcs0: SUCCESS (1.981s) [295.309537] Starting dynamic subtest: vcs0 [297.281246] Dynamic subtest vcs0: SUCCESS (1.980s) [297.294096] Starting dynamic subtest: vcs1 [299.265798] Dynamic subtest vcs1: SUCCESS (1.982s) [299.278730] Starting dynamic subtest: vecs0 [301.248312] Dynamic subtest vecs0: SUCCESS (1.980s) [301.260172] Starting dynamic subtest: ccs0 [303.298479] Dynamic subtest ccs0: SUCCESS (2.046s) [303.301713] Subtest gt-engine-hang: SUCCESS (11.547s) [303.444402] [061/156] (723s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted) [303.500671] Starting subtest: invalid-multi-wait-unsubmitted-submitted [303.503098] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s) [303.607981] [062/156] (722s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0-hflip) [303.707415] Starting subtest: linear-max-hw-stride-64bpp-rotate-0-hflip [303.711735] Subtest linear-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s) [303.812874] [063/156] (722s left) api_intel_bb (render-ccs) [303.862332] Starting subtest: render-ccs [304.225327] Subtest render-ccs: SUCCESS (0.363s) [304.312645] [064/156] (722s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-pwrite) [304.411083] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-pwrite [304.415520] Subtest hdr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [304.507115] [065/156] (722s left) i915_drm_fdinfo (busy-idle-check-all) [304.547602] Starting subtest: busy-idle-check-all [304.549817] Starting dynamic subtest: rcs0 [304.556364] Dynamic subtest rcs0: SKIP (0.005s) [304.567095] Starting dynamic subtest: bcs0 [304.571083] Dynamic subtest bcs0: SKIP (0.000s) [304.580311] Starting dynamic subtest: vcs0 [304.584685] Dynamic subtest vcs0: SKIP (0.000s) [304.593581] Starting dynamic subtest: vcs1 [304.597686] Dynamic subtest vcs1: SKIP (0.000s) [304.606546] Starting dynamic subtest: vecs0 [304.610658] Dynamic subtest vecs0: SKIP (0.000s) [304.619379] Starting dynamic subtest: ccs0 [304.623465] Dynamic subtest ccs0: SKIP (0.000s) [304.627521] Subtest busy-idle-check-all: SKIP (0.011s) [304.664913] [066/156] (722s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt) [304.796977] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt [304.801136] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [304.893727] [067/156] (721s left) gem_exec_capture (capture-recoverable) [304.957743] Starting subtest: capture-recoverable [304.960061] Subtest capture-recoverable: SUCCESS (0.003s) [305.093511] [068/156] (721s left) core_sysfs (read-all-entries) [305.144955] Starting subtest: read-all-entries [305.153594] Subtest read-all-entries: SUCCESS (0.011s) [305.240717] [069/156] (721s left) syncobj_wait (invalid-reset-one-illegal-handle) [305.284365] Starting subtest: invalid-reset-one-illegal-handle [305.286319] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s) [305.383227] [070/156] (721s left) kms_psr (fbc-psr-cursor-render) [305.484279] Starting subtest: fbc-psr-cursor-render [305.486149] Starting dynamic subtest: eDP-1 [305.489558] Dynamic subtest eDP-1: SKIP (0.000s) [305.492964] Subtest fbc-psr-cursor-render: SKIP (0.001s) [305.556862] [071/156] (721s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff) [305.657971] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff [305.661837] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [305.763512] [072/156] (721s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-onoff) [305.860163] Starting subtest: psrhdr-1p-primscrn-spr-indfb-onoff [305.863770] Subtest psrhdr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s) [305.955125] [073/156] (721s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render) [306.053990] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render [306.057481] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [306.160405] [074/156] (720s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-indfb-draw-mmap-cpu) [306.269777] Starting subtest: fbchdr-1p-offscreen-pri-indfb-draw-mmap-cpu [306.273184] Subtest fbchdr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [306.358791] [075/156] (720s left) kms_plane (planar-pixel-format-settings) [306.453563] Starting subtest: planar-pixel-format-settings [306.520466] Subtest planar-pixel-format-settings: SUCCESS (0.066s) [306.638354] [076/156] (720s left) gem_exec_whisper (basic-contexts-priority-all) [306.699160] Starting subtest: basic-contexts-priority-all [331.050844] Subtest basic-contexts-priority-all: SUCCESS (24.293s) [331.182173] [077/156] (695s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt) [331.294029] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt [338.655056] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.367s) [338.769304] [078/156] (688s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-mmap-wc) [338.876759] Starting subtest: hdr-rgb101010-draw-mmap-wc [338.881322] Subtest hdr-rgb101010-draw-mmap-wc: SKIP (0.000s) [338.973321] [079/156] (688s left) kms_vblank (ts-continuation-modeset-rpm) [339.064183] Starting subtest: ts-continuation-modeset-rpm [339.066328] Starting dynamic subtest: pipe-A-eDP-1 [341.604557] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.538s) [341.620591] Starting dynamic subtest: pipe-D-eDP-1 [343.797085] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.190s) [343.799293] Subtest ts-continuation-modeset-rpm: SUCCESS (4.732s) [344.645425] [080/156] (682s left) gem_userptr_blits (userfault) [344.704483] Starting subtest: userfault [344.706761] Subtest userfault: SUCCESS (0.006s) [344.851061] [081/156] (682s left) kms_lease (lease-invalid-plane) [344.943309] Starting subtest: lease-invalid-plane [344.945606] Starting dynamic subtest: pipe-A-eDP-1 [344.947805] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [344.957734] Starting dynamic subtest: pipe-B-eDP-1 [344.960028] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [344.969533] Starting dynamic subtest: pipe-C-eDP-1 [344.971661] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [344.981506] Starting dynamic subtest: pipe-D-eDP-1 [344.983679] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [344.985812] Subtest lease-invalid-plane: SUCCESS (0.004s) [345.026220] [082/156] (682s left) gem_lmem_swapping (smem-oom) [345.066349] Subtest smem-oom: SKIP (0.000s) [345.109127] [083/156] (682s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-onoff) [345.210481] Starting subtest: hdr-1p-primscrn-cur-indfb-onoff [345.214655] Subtest hdr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s) [345.314750] [084/156] (682s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff) [345.411479] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff [345.415761] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [345.511553] [085/156] (681s left) kms_cursor_crc (cursor-tearing-position-change) [345.619740] Starting subtest: cursor-tearing-position-change [345.621768] Starting dynamic subtest: pipe-A-eDP-1 [346.188555] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.565s) [346.198294] Starting dynamic subtest: pipe-D-eDP-1 [347.433775] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.246s) [347.436208] Subtest cursor-tearing-position-change: SUCCESS (1.814s) [348.263363] [086/156] (679s left) gem_exec_parallel (userptr) [348.326839] Starting subtest: userptr [348.329142] Starting dynamic subtest: rcs0 [349.787166] Dynamic subtest rcs0: SUCCESS (1.460s) [349.798547] Starting dynamic subtest: bcs0 [351.271563] Dynamic subtest bcs0: SUCCESS (1.483s) [351.284740] Starting dynamic subtest: vcs0 [353.314390] Dynamic subtest vcs0: SUCCESS (2.038s) [353.327274] Starting dynamic subtest: vcs1 [355.299475] Dynamic subtest vcs1: SUCCESS (1.982s) [355.312291] Starting dynamic subtest: vecs0 [357.282446] Dynamic subtest vecs0: SUCCESS (1.981s) [357.294209] Starting dynamic subtest: ccs0 [358.770076] Dynamic subtest ccs0: SUCCESS (1.486s) [358.772409] Subtest userptr: SUCCESS (10.444s) [358.967810] [087/156] (668s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff) [359.066007] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff [366.093083] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.032s) [366.228912] [088/156] (661s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move) [366.333721] Starting subtest: psr-2p-primscrn-cur-indfb-move [366.338262] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [366.433433] [089/156] (661s left) kms_cursor_crc (cursor-onscreen-512x512) [366.706621] Starting subtest: cursor-onscreen-512x512 [366.710661] Subtest cursor-onscreen-512x512: SKIP (0.001s) [366.851834] [090/156] (660s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt) [366.946721] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt [366.950846] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s) [367.038369] [091/156] (660s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-shrfb-draw-mmap-gtt) [367.142139] Starting subtest: fbchdr-1p-primscrn-pri-shrfb-draw-mmap-gtt [367.145612] Subtest fbchdr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [367.261611] [092/156] (660s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area) [367.356044] Starting subtest: psr2-primary-plane-update-sf-dmg-area [367.357832] Starting dynamic subtest: pipe-A-eDP-1 [373.198515] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.846s) [373.209657] Starting dynamic subtest: pipe-B-eDP-1 [379.721234] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.521s) [379.723653] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (12.370s) [380.555279] [093/156] (647s left) i915_pm_rpm (system-suspend-devices) [382.487585] Starting subtest: system-suspend-devices [390.285697] Subtest system-suspend-devices: SUCCESS (7.798s) [395.740456] [094/156] (637s left) kms_flip (bo-too-big-interruptible) [395.850355] Starting subtest: bo-too-big-interruptible [395.852687] Starting dynamic subtest: A-eDP1 [397.167040] Dynamic subtest A-eDP1: SUCCESS (1.315s) [397.179178] Starting dynamic subtest: B-eDP1 [398.474637] Dynamic subtest B-eDP1: SUCCESS (1.283s) [398.485428] Starting dynamic subtest: C-eDP1 [399.768705] Dynamic subtest C-eDP1: SUCCESS (1.316s) [399.779350] Starting dynamic subtest: D-eDP1 [401.069068] Dynamic subtest D-eDP1: SUCCESS (1.298s) [401.073879] Subtest bo-too-big-interruptible: SUCCESS (5.224s) [402.256169] [095/156] (630s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff) [402.360389] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff [402.364577] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [402.456475] [096/156] (630s left) perf (polling-parameterized) [402.531505] Starting subtest: polling-parameterized [422.598443] Subtest polling-parameterized: SUCCESS (20.015s) [422.641671] [097/156] (610s left) kms_big_fb (4-tiled-64bpp-rotate-270) [422.750674] Starting subtest: 4-tiled-64bpp-rotate-270 [422.775102] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.024s) [422.906985] [098/156] (610s left) kms_properties (crtc-properties-atomic) [423.006418] Starting subtest: crtc-properties-atomic [423.008660] Starting dynamic subtest: pipe-A-eDP-1 [423.442051] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.436s) [423.456827] Starting dynamic subtest: pipe-B-eDP-1 [424.571404] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.129s) [424.584709] Starting dynamic subtest: pipe-C-eDP-1 [425.772752] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.200s) [425.785037] Starting dynamic subtest: pipe-D-eDP-1 [426.964258] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.189s) [426.966629] Subtest crtc-properties-atomic: SUCCESS (3.959s) [427.838857] [099/156] (605s left) kms_cursor_legacy (cursora-vs-flipa-toggle) [427.957280] Starting subtest: cursorA-vs-flipA-toggle [439.082424] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.124s) [439.944800] [100/156] (593s left) i915_query (engine-info) [440.013998] Starting subtest: engine-info [440.015890] Subtest engine-info: SUCCESS (0.004s) [440.127823] [101/156] (593s left) gem_exec_whisper (basic-sync) [440.188828] Starting subtest: basic-sync [446.999358] Subtest basic-sync: SUCCESS (6.787s) [447.163354] [102/156] (586s left) kms_cursor_crc (cursor-rapid-movement-32x32) [447.303697] Starting subtest: cursor-rapid-movement-32x32 [447.352717] Subtest cursor-rapid-movement-32x32: SKIP (0.043s) [447.622818] [103/156] (585s left) gem_eio (create-ext) [447.855784] Starting subtest: create-ext [448.207246] Subtest create-ext: SUCCESS (0.351s) [448.334805] [104/156] (585s left) kms_invalid_mode (bad-vtotal) [448.429804] Starting subtest: bad-vtotal [448.431814] Starting dynamic subtest: pipe-A-eDP-1 [448.713468] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s) [448.725081] Starting dynamic subtest: pipe-B-eDP-1 [448.726999] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [448.737458] Starting dynamic subtest: pipe-C-eDP-1 [448.739649] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [448.749675] Starting dynamic subtest: pipe-D-eDP-1 [448.752064] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [448.754349] Subtest bad-vtotal: SUCCESS (0.292s) [449.535764] [105/156] (583s left) gem_render_copy (yf-tiled-ccs-to-linear) [449.595178] Starting subtest: yf-tiled-ccs-to-linear [449.599642] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s) [449.793625] [106/156] (583s left) gem_mmap_gtt (isolation) [449.859827] Subtest isolation: SKIP (0.000s) [449.930475] [107/156] (583s left) gem_softpin (evict-active-interruptible) [449.983923] Starting subtest: evict-active-interruptible [449.990301] Subtest evict-active-interruptible: SUCCESS (0.006s) [450.129795] [108/156] (583s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling) [450.215490] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling [450.219607] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SKIP (0.000s) [450.299432] [109/156] (583s left) kms_busy (extended-modeset-hang-oldfb-with-reset) [450.402483] Starting subtest: extended-modeset-hang-oldfb-with-reset [450.404826] Starting dynamic subtest: pipe-A [462.176224] Dynamic subtest pipe-A: SUCCESS (11.773s) [462.188183] Starting dynamic subtest: pipe-D [474.475731] Dynamic subtest pipe-D: SUCCESS (12.297s) [474.477894] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.073s) [475.343760] [110/156] (558s left) api_intel_allocator (fork-simple-once) [475.405861] Starting subtest: fork-simple-once [475.421049] Subtest fork-simple-once: SUCCESS (0.015s) [475.531901] [111/156] (558s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-blt) [475.633479] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-blt [475.637411] Subtest psrhdr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s) [475.745154] [112/156] (557s left) kms_psr (psr2-primary-mmap-gtt) [475.839280] Starting subtest: psr2-primary-mmap-gtt [475.841575] Starting dynamic subtest: eDP-1 [477.305989] Dynamic subtest eDP-1: SKIP (1.463s) [477.311242] Subtest psr2-primary-mmap-gtt: SKIP (1.466s) [477.430844] [113/156] (556s left) kms_frontbuffer_tracking (psrhdr-rgb101010-draw-mmap-wc) [477.532958] Starting subtest: psrhdr-rgb101010-draw-mmap-wc [477.537865] Subtest psrhdr-rgb101010-draw-mmap-wc: SKIP (0.000s) [477.635686] [114/156] (556s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt) [477.737983] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt [477.742156] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [477.829143] [115/156] (556s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted) [477.873054] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted [477.983320] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.109s) [478.074335] [116/156] (555s left) kms_addfb_basic (framebuffer-vs-set-tiling) [478.122721] Starting subtest: framebuffer-vs-set-tiling [478.127299] Subtest framebuffer-vs-set-tiling: SKIP (0.000s) [478.258124] [117/156] (555s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic) [478.380412] Starting subtest: 2x-long-flip-vs-cursor-atomic [478.384946] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s) [478.537683] [118/156] (555s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-render) [478.633822] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-render [478.637941] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [478.725913] [119/156] (555s left) syncobj_wait (single-wait-all-for-submit-unsubmitted) [478.772063] Starting subtest: single-wait-all-for-submit-unsubmitted [478.879259] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.106s) [478.954918] [120/156] (555s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf) [479.051707] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf [479.055802] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s) [479.121527] [121/156] (554s left) kms_content_protection (lic-type-0-hdcp14) [479.269749] Starting subtest: lic-type-0-hdcp14 [479.274241] Subtest lic-type-0-hdcp14: SKIP (0.000s) [479.393829] [122/156] (554s left) gem_partial_pwrite_pread (writes-after-reads-display) [479.444291] Subtest writes-after-reads-display: SKIP (0.000s) [479.550445] [123/156] (554s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt) [479.654850] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt [479.658905] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [479.748126] [124/156] (554s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-mmap-wc) [479.849760] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-mmap-wc [479.854209] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [479.944836] [125/156] (554s left) kms_getfb (getfb2-handle-zero) [480.034555] Starting subtest: getfb2-handle-zero [480.036533] Subtest getfb2-handle-zero: SUCCESS (0.000s) [480.159739] [126/156] (554s left) kms_chamelium_audio (hdmi-audio-edid) [480.546521] Subtest hdmi-audio-edid: SKIP (0.000s) [481.420206] [127/156] (552s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-draw-blt) [481.530121] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-draw-blt [481.534719] Subtest psrhdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [481.629346] [128/156] (552s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc) [481.735018] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc [481.739140] Subtest fbcpsrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [481.834784] [129/156] (552s left) prime_busy (hang-wait) [481.902628] Starting subtest: hang-wait [481.904998] Starting dynamic subtest: rcs0 [507.782337] Dynamic subtest rcs0: SUCCESS (25.867s) [507.795039] Starting dynamic subtest: bcs0 [514.929238] Dynamic subtest bcs0: SUCCESS (7.154s) [514.942689] Starting dynamic subtest: vcs0 [521.905891] Dynamic subtest vcs0: SUCCESS (6.971s) [521.919904] Starting dynamic subtest: vcs1 [529.007927] Dynamic subtest vcs1: SUCCESS (7.099s) [529.020395] Starting dynamic subtest: vecs0 [535.928862] Dynamic subtest vecs0: SUCCESS (6.912s) [535.941063] Starting dynamic subtest: ccs0 [549.822056] Dynamic subtest ccs0: SUCCESS (13.898s) [549.824550] Subtest hang-wait: SUCCESS (67.914s) [549.937398] [130/156] (484s left) gem_userptr_blits (dmabuf-sync) [550.004244] Starting subtest: dmabuf-sync [550.008897] Subtest dmabuf-sync: SKIP (0.002s) [550.164241] [131/156] (484s left) kms_selftest (drm_format_helper) [550.199662] Starting subtest: drm_format_helper [550.246945] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8 [550.349886] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.102s) [550.360710] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332 [550.453573] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.104s) [550.466455] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565 [550.542215] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.089s) [550.553133] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555 [550.631925] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.088s) [550.642707] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555 [550.732228] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.099s) [550.743416] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551 [550.836745] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.101s) [550.848914] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888 [550.946525] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.109s) [550.957441] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888 [551.036805] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.088s) [551.048367] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888 [551.132911] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.094s) [551.143457] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010 [551.240835] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.106s) [551.251090] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010 [551.336890] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.095s) [551.347234] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono [551.433561] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.097s) [551.444976] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab [551.518727] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.081s) [551.529052] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888 [551.615708] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.096s) [551.626683] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888 [551.708605] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.093s) [551.719679] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset [551.799075] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.090s) [551.809349] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy [551.896571] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.096s) [551.898675] Subtest drm_format_helper: SUCCESS (1.700s) [552.044431] [132/156] (482s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75) [552.135403] Starting subtest: planes-unity-scaling-downscale-factor-0-75 [552.137314] Starting dynamic subtest: pipe-A [552.198447] Dynamic subtest pipe-A: SUCCESS (0.065s) [552.210789] Starting dynamic subtest: pipe-B [553.324800] Dynamic subtest pipe-B: SUCCESS (1.125s) [553.337288] Starting dynamic subtest: pipe-C [554.495906] Dynamic subtest pipe-C: SUCCESS (1.169s) [554.507734] Starting dynamic subtest: pipe-D [555.600965] Dynamic subtest pipe-D: SUCCESS (1.104s) [555.603509] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.467s) [556.729577] [133/156] (477s left) syncobj_wait (single-wait-for-submit-signaled) [556.793349] Starting subtest: single-wait-for-submit-signaled [556.795391] Subtest single-wait-for-submit-signaled: SUCCESS (0.000s) [556.913926] [134/156] (477s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu) [557.016254] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu [563.717759] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.705s) [563.848621] [135/156] (470s left) gem_flink_basic (basic) [563.898190] Starting subtest: basic [563.900096] Subtest basic: SUCCESS (0.000s) [563.992160] [136/156] (470s left) gem_workarounds (reset-context) [564.052397] Starting subtest: reset-context [564.191549] Subtest reset-context: SUCCESS (0.139s) [564.326266] [137/156] (470s left) kms_flip (plain-flip-interruptible) [564.430989] Starting subtest: plain-flip-interruptible [564.433186] Starting dynamic subtest: A-eDP1 [566.101681] Dynamic subtest A-eDP1: SUCCESS (1.669s) [566.118742] Starting dynamic subtest: B-eDP1 [567.794917] Dynamic subtest B-eDP1: SUCCESS (1.691s) [567.809837] Starting dynamic subtest: C-eDP1 [569.488349] Dynamic subtest C-eDP1: SUCCESS (1.691s) [569.499831] Starting dynamic subtest: D-eDP1 [571.189745] Dynamic subtest D-eDP1: SUCCESS (1.700s) [571.196712] Subtest plain-flip-interruptible: SUCCESS (6.762s) [572.422598] [138/156] (462s left) sysfs_heartbeat_interval (nopreempt) [572.490778] Starting subtest: nopreempt [572.493083] Starting dynamic subtest: vecs0 [582.302844] Dynamic subtest vecs0: SUCCESS (9.808s) [582.317428] Starting dynamic subtest: ccs0 [586.259764] Dynamic subtest ccs0: SUCCESS (3.957s) [586.273034] Starting dynamic subtest: vcs0 [595.372694] Dynamic subtest vcs0: SUCCESS (9.110s) [595.387073] Starting dynamic subtest: bcs0 [599.247165] Dynamic subtest bcs0: SUCCESS (3.872s) [599.259990] Starting dynamic subtest: rcs0 [603.282512] Dynamic subtest rcs0: SUCCESS (4.034s) [603.296249] Starting dynamic subtest: vcs1 [613.337066] Dynamic subtest vcs1: SUCCESS (10.053s) [613.339594] Subtest nopreempt: SUCCESS (40.846s) [613.419086] [139/156] (421s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs) [613.511953] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs [613.514267] Starting dynamic subtest: pipe-A-eDP-1 [613.537230] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [613.550451] Starting dynamic subtest: pipe-B-eDP-1 [613.571716] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [613.584087] Starting dynamic subtest: pipe-C-eDP-1 [613.605709] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [613.617036] Starting dynamic subtest: pipe-D-eDP-1 [613.638537] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [613.642892] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.006s) [615.724198] [140/156] (419s left) perf_pmu (busy-accuracy-2) [615.762056] Starting subtest: busy-accuracy-2 [615.764942] Starting dynamic subtest: rcs0 [618.807045] Dynamic subtest rcs0: SUCCESS (3.042s) [618.820799] Starting dynamic subtest: bcs0 [621.918064] Dynamic subtest bcs0: SUCCESS (3.057s) [621.930804] Starting dynamic subtest: vcs0 [624.959572] Dynamic subtest vcs0: SUCCESS (3.041s) [624.975337] Starting dynamic subtest: vcs1 [628.004663] Dynamic subtest vcs1: SUCCESS (3.044s) [628.017273] Starting dynamic subtest: vecs0 [631.050976] Dynamic subtest vecs0: SUCCESS (3.043s) [631.063346] Starting dynamic subtest: ccs0 [634.109203] Dynamic subtest ccs0: SUCCESS (3.055s) [634.111370] Subtest busy-accuracy-2: SUCCESS (18.298s) [634.177615] [141/156] (400s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs) [634.269332] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs [634.271515] Starting dynamic subtest: pipe-A-eDP-1 [634.294461] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [634.307520] Starting dynamic subtest: pipe-B-eDP-1 [634.328337] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [634.339479] Starting dynamic subtest: pipe-C-eDP-1 [634.360453] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [634.371097] Starting dynamic subtest: pipe-D-eDP-1 [634.393210] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [634.397234] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.005s) [636.519383] [142/156] (398s left) kms_psr (fbc-pr-sprite-plane-move) [636.627935] Starting subtest: fbc-pr-sprite-plane-move [636.632104] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s) [636.713438] [143/156] (398s left) gem_close (many-handles-one-vma) [636.772998] Starting subtest: many-handles-one-vma [636.797591] Subtest many-handles-one-vma: SUCCESS (0.024s) [636.907768] [144/156] (398s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu) [637.002760] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu [637.007153] Subtest psrhdr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [637.100412] [145/156] (398s left) syncobj_wait (multi-wait-signaled) [637.146168] Starting subtest: multi-wait-signaled [637.148443] Subtest multi-wait-signaled: SUCCESS (0.000s) [637.249319] [146/156] (397s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-pri-indfb-draw-render) [637.349626] Starting subtest: hdr-2p-scndscrn-pri-indfb-draw-render [637.353593] Subtest hdr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [637.451571] [147/156] (397s left) i915_query (query-topology-kernel-writes) [637.506250] Starting subtest: query-topology-kernel-writes [637.508194] Subtest query-topology-kernel-writes: SUCCESS (0.000s) [637.593087] [148/156] (397s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-indfb-plflip-blt) [637.687979] Starting subtest: fbcpsrhdr-2p-primscrn-indfb-plflip-blt [637.691372] Subtest fbcpsrhdr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [637.777720] [149/156] (397s left) kms_big_fb (y-tiled-16bpp-rotate-90) [637.887981] Starting subtest: y-tiled-16bpp-rotate-90 [637.891731] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s) [637.981433] [150/156] (397s left) gem_render_copy (y-tiled) [638.040839] Starting subtest: y-tiled [638.044306] Subtest y-tiled: SKIP (0.000s) [638.224125] [151/156] (397s left) kms_atomic_transition (modeset-transition-nonblocking) [638.318379] Starting subtest: modeset-transition-nonblocking [638.320368] Starting dynamic subtest: 1x-outputs [649.184718] Dynamic subtest 1x-outputs: SUCCESS (10.864s) [649.186831] Subtest modeset-transition-nonblocking: SUCCESS (10.865s) [650.021025] [152/156] (385s left) kms_psr (psr-sprite-plane-onoff) [650.112297] Starting subtest: psr-sprite-plane-onoff [650.114655] Starting dynamic subtest: eDP-1 [651.910316] Dynamic subtest eDP-1: SUCCESS (1.798s) [651.912290] Subtest psr-sprite-plane-onoff: SUCCESS (1.799s) [652.723411] [153/156] (382s left) gem_ppgtt (blt-vs-render-ctx0) [652.777809] Starting subtest: blt-vs-render-ctx0 [685.817950] Subtest blt-vs-render-ctx0: SUCCESS (33.037s) [685.960469] [154/156] (349s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-mmap-wc) [686.118863] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-mmap-wc [686.123198] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [686.219879] [155/156] (349s left) gem_exec_fence (submit) [686.398669] Starting subtest: submit [686.403468] Subtest submit: SKIP (0.000s) [688.441524] [156/156] (347s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-draw-pwrite) [688.553095] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-draw-pwrite [688.557183] Subtest fbchdr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [688.649216] Closing watchdogs results: parsing output: 0/ for test: syncobj_timeline results: parsing output: 1/ for test: kms_chamelium_frames results: parsing output: 2/ for test: kms_color_pipeline results: parsing output: 3/ for test: kms_ccs results: parsing output: 4/ for test: kms_flip_scaled_crc results: parsing output: 5/ for test: kms_frontbuffer_tracking results: parsing output: 6/ for test: perf_pmu results: parsing output: 7/ for test: gem_create results: parsing output: 8/ for test: gem_exec_balancer results: parsing output: 9/ for test: syncobj_timeline results: parsing output: 10/ for test: kms_async_flips results: parsing output: 11/ for test: gem_exec_nop results: parsing output: 12/ for test: kms_big_fb results: parsing output: 13/ for test: gen9_exec_parse results: parsing output: 14/ for test: kms_big_fb results: parsing output: 15/ for test: kms_ccs results: parsing output: 16/ for test: kms_fbcon_fbt results: parsing output: 17/ for test: kms_feature_discovery results: parsing output: 18/ for test: gem_exec_schedule results: parsing output: 19/ for test: kms_psr results: parsing output: 20/ for test: kms_chamelium_hpd results: parsing output: 21/ for test: kms_frontbuffer_tracking results: parsing output: 22/ for test: kms_plane_alpha_blend results: parsing output: 23/ for test: kms_getfb results: parsing output: 24/ for test: perf results: parsing output: 25/ for test: gem_render_copy results: parsing output: 26/ for test: kms_dp_linktrain_fallback results: parsing output: 27/ for test: syncobj_wait results: parsing output: 28/ for test: gem_ctx_param results: parsing output: 29/ for test: kms_psr2_sf results: parsing output: 30/ for test: kms_frontbuffer_tracking results: parsing output: 31/ for test: gem_exec_schedule results: parsing output: 32/ for test: gem_ppgtt results: parsing output: 33/ for test: kms_frontbuffer_tracking results: parsing output: 34/ for test: kms_hdmi_inject results: parsing output: 35/ for test: kms_frontbuffer_tracking results: parsing output: 36/ for test: gem_exec_flush results: parsing output: 37/ for test: gem_exec_schedule results: parsing output: 38/ for test: kms_frontbuffer_tracking results: parsing output: 39/ for test: kms_frontbuffer_tracking results: parsing output: 40/ for test: kms_frontbuffer_tracking results: parsing output: 41/ for test: kms_pm_rpm results: parsing output: 42/ for test: kms_frontbuffer_tracking results: parsing output: 43/ for test: gem_softpin results: parsing output: 44/ for test: kms_flip_scaled_crc results: parsing output: 45/ for test: kms_flip results: parsing output: 46/ for test: syncobj_basic results: parsing output: 47/ for test: gem_ctx_shared results: parsing output: 48/ for test: syncobj_wait results: parsing output: 49/ for test: kms_prime results: parsing output: 50/ for test: syncobj_timeline results: parsing output: 51/ for test: kms_big_fb results: parsing output: 52/ for test: syncobj_timeline results: parsing output: 53/ for test: kms_plane_scaling results: parsing output: 54/ for test: gem_basic results: parsing output: 55/ for test: kms_flip results: parsing output: 56/ for test: gem_create results: parsing output: 57/ for test: kms_plane_multiple results: parsing output: 58/ for test: gem_exec_reloc results: parsing output: 59/ for test: i915_hangman results: parsing output: 60/ for test: syncobj_wait results: parsing output: 61/ for test: kms_big_fb results: parsing output: 62/ for test: api_intel_bb results: parsing output: 63/ for test: kms_frontbuffer_tracking results: parsing output: 64/ for test: i915_drm_fdinfo results: parsing output: 65/ for test: kms_frontbuffer_tracking results: parsing output: 66/ for test: gem_exec_capture results: parsing output: 67/ for test: core_sysfs results: parsing output: 68/ for test: syncobj_wait results: parsing output: 69/ for test: kms_psr results: parsing output: 70/ for test: kms_frontbuffer_tracking results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: kms_frontbuffer_tracking results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: kms_plane results: parsing output: 75/ for test: gem_exec_whisper results: parsing output: 76/ for test: kms_frontbuffer_tracking results: parsing output: 77/ for test: kms_frontbuffer_tracking results: parsing output: 78/ for test: kms_vblank results: parsing output: 79/ for test: gem_userptr_blits results: parsing output: 80/ for test: kms_lease results: parsing output: 81/ for test: gem_lmem_swapping results: parsing output: 82/ for test: kms_frontbuffer_tracking results: parsing output: 83/ for test: kms_frontbuffer_tracking results: parsing output: 84/ for test: kms_cursor_crc results: parsing output: 85/ for test: gem_exec_parallel results: parsing output: 86/ for test: kms_frontbuffer_tracking results: parsing output: 87/ for test: kms_frontbuffer_tracking results: parsing output: 88/ for test: kms_cursor_crc results: parsing output: 89/ for test: kms_frontbuffer_tracking results: parsing output: 90/ for test: kms_frontbuffer_tracking results: parsing output: 91/ for test: kms_psr2_sf results: parsing output: 92/ for test: i915_pm_rpm results: parsing output: 93/ for test: kms_flip results: parsing output: 94/ for test: kms_frontbuffer_tracking results: parsing output: 95/ for test: perf results: parsing output: 96/ for test: kms_big_fb results: parsing output: 97/ for test: kms_properties results: parsing output: 98/ for test: kms_cursor_legacy results: parsing output: 99/ for test: i915_query results: parsing output: 100/ for test: gem_exec_whisper results: parsing output: 101/ for test: kms_cursor_crc results: parsing output: 102/ for test: gem_eio results: parsing output: 103/ for test: kms_invalid_mode results: parsing output: 104/ for test: gem_render_copy results: parsing output: 105/ for test: gem_mmap_gtt results: parsing output: 106/ for test: gem_softpin results: parsing output: 107/ for test: kms_flip_scaled_crc results: parsing output: 108/ for test: kms_busy results: parsing output: 109/ for test: api_intel_allocator results: parsing output: 110/ for test: kms_frontbuffer_tracking results: parsing output: 111/ for test: kms_psr results: parsing output: 112/ for test: kms_frontbuffer_tracking results: parsing output: 113/ for test: kms_frontbuffer_tracking results: parsing output: 114/ for test: syncobj_timeline results: parsing output: 115/ for test: kms_addfb_basic results: parsing output: 116/ for test: kms_cursor_legacy results: parsing output: 117/ for test: kms_frontbuffer_tracking results: parsing output: 118/ for test: syncobj_wait results: parsing output: 119/ for test: kms_psr2_sf results: parsing output: 120/ for test: kms_content_protection results: parsing output: 121/ for test: gem_partial_pwrite_pread results: parsing output: 122/ for test: kms_frontbuffer_tracking results: parsing output: 123/ for test: kms_frontbuffer_tracking results: parsing output: 124/ for test: kms_getfb results: parsing output: 125/ for test: kms_chamelium_audio results: parsing output: 126/ for test: kms_frontbuffer_tracking results: parsing output: 127/ for test: kms_frontbuffer_tracking results: parsing output: 128/ for test: prime_busy results: parsing output: 129/ for test: gem_userptr_blits results: parsing output: 130/ for test: kms_selftest results: parsing output: 131/ for test: kms_plane_scaling results: parsing output: 132/ for test: syncobj_wait results: parsing output: 133/ for test: kms_frontbuffer_tracking results: parsing output: 134/ for test: gem_flink_basic results: parsing output: 135/ for test: gem_workarounds results: parsing output: 136/ for test: kms_flip results: parsing output: 137/ for test: sysfs_heartbeat_interval results: parsing output: 138/ for test: kms_ccs results: parsing output: 139/ for test: perf_pmu results: parsing output: 140/ for test: kms_ccs results: parsing output: 141/ for test: kms_psr results: parsing output: 142/ for test: gem_close results: parsing output: 143/ for test: kms_frontbuffer_tracking results: parsing output: 144/ for test: syncobj_wait results: parsing output: 145/ for test: kms_frontbuffer_tracking results: parsing output: 146/ for test: i915_query results: parsing output: 147/ for test: kms_frontbuffer_tracking results: parsing output: 148/ for test: kms_big_fb results: parsing output: 149/ for test: gem_render_copy results: parsing output: 150/ for test: kms_atomic_transition results: parsing output: 151/ for test: kms_psr results: parsing output: 152/ for test: gem_ppgtt results: parsing output: 153/ for test: kms_frontbuffer_tracking results: parsing output: 154/ for test: gem_exec_fence results: parsing output: 155/ for test: kms_frontbuffer_tracking Done.