[60.503469] Initializing watchdogs [60.503537] /dev/watchdog0 [60.523617] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770] [60.534596] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [60.538737] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [60.541210] [001/134] (960s left) kms_cursor_crc (cursor-sliding-64x64) [60.872986] Starting subtest: cursor-sliding-64x64 [60.886992] Starting dynamic subtest: pipe-A-DP-3 [65.117498] Dynamic subtest pipe-A-DP-3: SUCCESS (4.212s) [65.160560] Starting dynamic subtest: pipe-D-DP-3 [69.185596] Dynamic subtest pipe-D-DP-3: SUCCESS (4.023s) [69.186520] Subtest cursor-sliding-64x64: SUCCESS (8.287s) [69.668170] [002/134] (951s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite) [69.854706] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite [69.856388] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [70.048843] [003/134] (951s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size) [70.226937] Starting subtest: cursorB-vs-flipB-varying-size [70.228655] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s) [70.352952] [004/134] (950s left) gem_lmem_swapping (smem-oom) [73.009111] Starting subtest: smem-oom [73.009965] Starting dynamic subtest: lmem0 [100.530638] Dynamic subtest lmem0: SUCCESS (27.505s) [100.531788] Subtest smem-oom: SUCCESS (27.506s) [101.674635] [FACT gem_lmem_swapping (smem-oom)] deleted: kernel.kmod_is_loaded.i915: true [101.677615] [005/134] (919s left) syncobj_wait (single-wait-all-submitted) [103.367969] Starting subtest: single-wait-all-submitted [103.470592] Subtest single-wait-all-submitted: SUCCESS (0.103s) [103.575997] [FACT syncobj_wait (single-wait-all-submitted)] new: kernel.kmod_is_loaded.i915: true [103.578927] [006/134] (917s left) kms_selftest (drm_format) [103.624545] Starting subtest: drm_format [103.630615] Starting dynamic subtest: drm_test_format_block_width_invalid [103.751191] Dynamic subtest drm_test_format_block_width_invalid: SUCCESS (0.120s) [103.764120] Starting dynamic subtest: drm_test_format_block_width_one_plane [103.856115] Dynamic subtest drm_test_format_block_width_one_plane: SUCCESS (0.100s) [103.894572] Starting dynamic subtest: drm_test_format_block_width_two_plane [103.942993] Dynamic subtest drm_test_format_block_width_two_plane: SUCCESS (0.090s) [103.952912] Starting dynamic subtest: drm_test_format_block_width_three_plane [104.053744] Dynamic subtest drm_test_format_block_width_three_plane: SUCCESS (0.108s) [104.091400] Starting dynamic subtest: drm_test_format_block_width_tiled [104.141398] Dynamic subtest drm_test_format_block_width_tiled: SUCCESS (0.086s) [104.177645] Starting dynamic subtest: drm_test_format_block_height_invalid [104.237703] Dynamic subtest drm_test_format_block_height_invalid: SUCCESS (0.096s) [104.275349] Starting dynamic subtest: drm_test_format_block_height_one_plane [104.341693] Dynamic subtest drm_test_format_block_height_one_plane: SUCCESS (0.102s) [104.368983] Starting dynamic subtest: drm_test_format_block_height_two_plane [104.433110] Dynamic subtest drm_test_format_block_height_two_plane: SUCCESS (0.091s) [104.449548] Starting dynamic subtest: drm_test_format_block_height_three_plane [104.527975] Dynamic subtest drm_test_format_block_height_three_plane: SUCCESS (0.094s) [104.565809] Starting dynamic subtest: drm_test_format_block_height_tiled [104.633794] Dynamic subtest drm_test_format_block_height_tiled: SUCCESS (0.105s) [104.643107] Starting dynamic subtest: drm_test_format_min_pitch_invalid [104.721091] Dynamic subtest drm_test_format_min_pitch_invalid: SUCCESS (0.087s) [104.759840] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_8bpp [104.820884] Dynamic subtest drm_test_format_min_pitch_one_plane_8bpp: SUCCESS (0.097s) [104.859747] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_16bpp [104.915064] Dynamic subtest drm_test_format_min_pitch_one_plane_16bpp: SUCCESS (0.094s) [104.953343] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_24bpp [105.014181] Dynamic subtest drm_test_format_min_pitch_one_plane_24bpp: SUCCESS (0.100s) [105.033264] Starting dynamic subtest: drm_test_format_min_pitch_one_plane_32bpp [105.095190] Dynamic subtest drm_test_format_min_pitch_one_plane_32bpp: SUCCESS (0.081s) [105.111689] Starting dynamic subtest: drm_test_format_min_pitch_two_plane [105.206088] Dynamic subtest drm_test_format_min_pitch_two_plane: SUCCESS (0.110s) [105.217164] Starting dynamic subtest: drm_test_format_min_pitch_three_plane_8bpp [105.287181] Dynamic subtest drm_test_format_min_pitch_three_plane_8bpp: SUCCESS (0.080s) [105.300794] Starting dynamic subtest: drm_test_format_min_pitch_tiled [105.372523] Dynamic subtest drm_test_format_min_pitch_tiled: SUCCESS (0.086s) [105.373400] Subtest drm_format: SUCCESS (1.747s) [105.596918] [007/134] (915s left) kms_vrr (max-min) [105.789957] Starting subtest: max-min [105.792457] Subtest max-min: SKIP (0.000s) [105.971582] [008/134] (915s left) prime_mmap (test_forked_cpu_write) [106.042894] Starting subtest: test_forked_cpu_write [106.043788] Starting dynamic subtest: test_forked_cpu_write-smem [106.050560] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.008s) [106.060212] Starting dynamic subtest: test_forked_cpu_write-lmem0 [106.061155] Dynamic subtest test_forked_cpu_write-lmem0: SUCCESS (0.008s) [106.061998] Subtest test_forked_cpu_write: SUCCESS (0.017s) [106.236534] [009/134] (915s left) kms_plane (plane-panning-top-left) [106.414056] Starting subtest: plane-panning-top-left [106.415930] Starting dynamic subtest: pipe-A [107.222029] Dynamic subtest pipe-A: SUCCESS (0.806s) [107.232235] Starting dynamic subtest: pipe-B [107.891102] Dynamic subtest pipe-B: SUCCESS (0.667s) [107.892176] Subtest plane-panning-top-left: SUCCESS (1.476s) [108.207345] [010/134] (913s left) gem_exec_flush (basic-wb-set-default) [108.292706] Subtest basic-wb-set-default: SKIP (0.000s) [108.367632] [011/134] (913s left) kms_invalid_mode (bad-hsync-start) [108.550053] Starting subtest: bad-hsync-start [108.550934] Starting dynamic subtest: pipe-A-DP-3 [108.634923] Dynamic subtest pipe-A-DP-3: SUCCESS (0.084s) [108.648482] Starting dynamic subtest: pipe-B-DP-3 [108.649519] Dynamic subtest pipe-B-DP-3: SUCCESS (0.001s) [108.662680] Starting dynamic subtest: pipe-C-DP-3 [108.663832] Dynamic subtest pipe-C-DP-3: SUCCESS (0.001s) [108.676442] Starting dynamic subtest: pipe-D-DP-3 [108.677402] Dynamic subtest pipe-D-DP-3: SUCCESS (0.001s) [108.678397] Subtest bad-hsync-start: SUCCESS (0.091s) [108.919657] [012/134] (912s left) prime_udl [109.025886] [013/134] (912s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt) [109.208434] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt [112.038792] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (2.830s) [112.234946] [014/134] (909s left) dmabuf_sync_file (export-basic) [112.321421] Starting subtest: export-basic [112.322340] Subtest export-basic: SUCCESS (0.001s) [112.435296] [FACT dmabuf_sync_file (export-basic)] new: kernel.kmod_is_loaded.vgem: true [112.436946] [015/134] (909s left) kms_big_fb (x-tiled-64bpp-rotate-270) [112.633991] Starting subtest: x-tiled-64bpp-rotate-270 [112.688377] Subtest x-tiled-64bpp-rotate-270: SKIP (0.054s) [112.906715] [016/134] (909s left) gem_ctx_isolation (dirty-create) [112.996442] Starting subtest: dirty-create [112.997371] Starting dynamic subtest: rcs0 [113.629714] Dynamic subtest rcs0: SUCCESS (0.633s) [113.639960] Starting dynamic subtest: bcs0 [114.280017] Dynamic subtest bcs0: SUCCESS (0.650s) [114.290087] Starting dynamic subtest: vcs0 [114.946408] Dynamic subtest vcs0: SUCCESS (0.666s) [114.956478] Starting dynamic subtest: vcs1 [115.587742] Dynamic subtest vcs1: SUCCESS (0.632s) [115.597970] Starting dynamic subtest: vecs0 [116.244774] Dynamic subtest vecs0: SUCCESS (0.665s) [116.255063] Starting dynamic subtest: vecs1 [116.912418] Dynamic subtest vecs1: SUCCESS (0.667s) [116.922545] Starting dynamic subtest: ccs0 [117.549630] Dynamic subtest ccs0: SUCCESS (0.637s) [117.550579] Subtest dirty-create: SUCCESS (4.552s) [117.879102] [017/134] (904s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu) [118.071453] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu [118.073120] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [118.271458] [018/134] (903s left) syncobj_wait (multi-wait-all-for-submit-signaled) [118.353964] Starting subtest: multi-wait-all-for-submit-signaled [118.354863] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s) [118.538165] [019/134] (903s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-blt) [118.728525] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-blt [118.730225] Subtest psr-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s) [118.894637] [020/134] (903s left) kms_big_fb (y-tiled-64bpp-rotate-90) [119.097442] Starting subtest: y-tiled-64bpp-rotate-90 [119.099247] Subtest y-tiled-64bpp-rotate-90: SKIP (0.000s) [119.306434] [021/134] (903s left) gem_eio (reset-stress) [119.580509] Starting subtest: reset-stress [119.581405] Starting dynamic subtest: render [126.665935] Dynamic subtest render: SUCCESS (7.083s) [126.677572] Starting dynamic subtest: bsd1 [133.621170] Dynamic subtest bsd1: SUCCESS (6.954s) [133.632607] Starting dynamic subtest: bsd2 [140.465083] Dynamic subtest bsd2: SUCCESS (6.843s) [140.476832] Starting dynamic subtest: blt [147.372235] Dynamic subtest blt: SUCCESS (6.907s) [147.387695] Starting dynamic subtest: vebox [154.314400] Dynamic subtest vebox: SUCCESS (6.942s) [154.315449] Subtest reset-stress: SUCCESS (34.731s) [154.586165] [022/134] (867s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render) [154.779452] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render [154.781225] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [154.978933] [023/134] (867s left) kms_content_protection (atomic-hdcp14) [155.234510] Starting subtest: atomic-hdcp14 [155.259172] Starting dynamic subtest: pipe-A-DP-3 [276.518255] Dynamic subtest pipe-A-DP-3: FAIL (121.071s) [276.519223] Subtest atomic-hdcp14: FAIL (121.189s) [276.748924] [024/134] (745s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb) [276.945295] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s) [277.006633] [025/134] (745s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes) [277.655284] Starting subtest: syncobj-timeline-multiple-ext-nodes [277.656266] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.002s) [277.946424] [026/134] (744s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite) [278.140539] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite [278.142215] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [278.331276] [027/134] (744s left) kms_big_fb (yf-tiled-64bpp-rotate-90) [278.529778] Starting subtest: yf-tiled-64bpp-rotate-90 [278.531428] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s) [278.703341] [028/134] (744s left) syncobj_timeline (device-signal-unordered) [278.784208] Starting subtest: device-signal-unordered [278.785194] Subtest device-signal-unordered: SUCCESS (0.000s) [278.974104] [029/134] (744s left) i915_drm_fdinfo (most-busy-idle-check-all) [279.045211] Starting subtest: most-busy-idle-check-all [279.046128] Starting dynamic subtest: rcs0 [279.078413] Dynamic subtest rcs0: SKIP (0.032s) [279.090148] Starting dynamic subtest: bcs0 [279.092390] Dynamic subtest bcs0: SKIP (0.001s) [279.103412] Starting dynamic subtest: vcs0 [279.105570] Dynamic subtest vcs0: SKIP (0.000s) [279.116545] Starting dynamic subtest: vcs1 [279.118870] Dynamic subtest vcs1: SKIP (0.000s) [279.129714] Starting dynamic subtest: vecs0 [279.132011] Dynamic subtest vecs0: SKIP (0.000s) [279.142851] Starting dynamic subtest: vecs1 [279.145312] Dynamic subtest vecs1: SKIP (0.000s) [279.155893] Starting dynamic subtest: ccs0 [279.161208] Dynamic subtest ccs0: SKIP (0.000s) [279.164576] Subtest most-busy-idle-check-all: SKIP (0.037s) [279.210698] [030/134] (743s left) gem_basic (create-fd-close) [279.328399] Starting subtest: create-fd-close [279.330534] Subtest create-fd-close: SUCCESS (0.000s) [279.463773] [031/134] (743s left) gem_exec_balancer (hang) [279.812574] Starting subtest: hang [283.386235] Subtest hang: SUCCESS (3.574s) [283.567542] [032/134] (739s left) kms_psr (psr-primary-render) [283.756574] Subtest psr-primary-render: SKIP (0.000s) [283.823486] [033/134] (739s left) kms_psr (pr-cursor-plane-onoff) [284.010736] Subtest pr-cursor-plane-onoff: SKIP (0.000s) [284.074021] [034/134] (739s left) gem_ctx_engines (none) [284.172005] Starting subtest: none [284.174303] Subtest none: SUCCESS (0.002s) [284.460545] [035/134] (738s left) kms_plane_alpha_blend (coverage-7efc) [284.650055] Starting subtest: coverage-7efc [284.918418] Starting dynamic subtest: pipe-A-DP-3 [285.403035] Dynamic subtest pipe-A-DP-3: SUCCESS (0.484s) [285.437598] Starting dynamic subtest: pipe-D-DP-3 [286.093466] Dynamic subtest pipe-D-DP-3: SUCCESS (0.666s) [286.094406] Subtest coverage-7efc: SUCCESS (1.445s) [286.403262] [036/134] (737s left) gen9_exec_parse (allowed-all) [286.488431] Subtest allowed-all: SKIP (0.000s) [286.562124] [037/134] (737s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render) [286.756344] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render [286.758063] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s) [286.953333] [038/134] (736s left) kms_plane_multiple (2x-tiling-y) [287.149190] Starting subtest: 2x-tiling-y [287.151131] Subtest 2x-tiling-y: SKIP (0.000s) [287.292789] [039/134] (736s left) gem_mmap_gtt (basic-write-cpu-read-gtt) [287.373069] Subtest basic-write-cpu-read-gtt: SKIP (0.000s) [287.447256] [040/134] (736s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling) [287.640601] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling [287.642319] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s) [287.771296] [041/134] (736s left) kms_pm_dc (dc6-psr) [288.965275] Starting subtest: dc6-psr [288.967150] Subtest dc6-psr: SKIP (0.000s) [289.111612] [042/134] (734s left) kms_lease (lease-invalid-crtc) [289.303638] Starting subtest: lease-invalid-crtc [289.304506] Starting dynamic subtest: pipe-A-DP-3 [289.305418] Dynamic subtest pipe-A-DP-3: SUCCESS (0.000s) [289.316774] Starting dynamic subtest: pipe-B-DP-3 [289.317611] Dynamic subtest pipe-B-DP-3: SUCCESS (0.000s) [289.328844] Starting dynamic subtest: pipe-C-DP-3 [289.330024] Dynamic subtest pipe-C-DP-3: SUCCESS (0.000s) [289.341349] Starting dynamic subtest: pipe-D-DP-3 [289.342610] Dynamic subtest pipe-D-DP-3: SUCCESS (0.000s) [289.343742] Subtest lease-invalid-crtc: SUCCESS (0.005s) [289.453790] [043/134] (734s left) vgem_basic (bad-fence) [289.518779] Starting subtest: bad-fence [289.519789] Subtest bad-fence: SUCCESS (0.000s) [289.653102] [044/134] (734s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode) [289.928534] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s) [290.082118] [045/134] (734s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180) [290.279136] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180 [291.589896] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.310s) [291.806054] [046/134] (732s left) kms_cursor_crc (cursor-onscreen-256x256) [292.221184] Starting subtest: cursor-onscreen-256x256 [292.226237] Starting dynamic subtest: pipe-A-DP-3 [294.973318] Dynamic subtest pipe-A-DP-3: SUCCESS (2.746s) [295.010593] Starting dynamic subtest: pipe-D-DP-3 [297.705357] Dynamic subtest pipe-D-DP-3: SUCCESS (2.706s) [297.706404] Subtest cursor-onscreen-256x256: SUCCESS (5.485s) [298.121709] [047/134] (726s left) kms_frontbuffer_tracking (fbcpsr-tiling-y) [298.316841] Starting subtest: fbcpsr-tiling-y [298.318429] Subtest fbcpsr-tiling-y: SKIP (0.000s) [298.502101] [048/134] (725s left) gem_vm_create (invalid-create) [298.595931] Starting subtest: invalid-create [298.600568] Subtest invalid-create: SUCCESS (0.005s) [298.752345] [049/134] (725s left) gem_mmap_wc (read-write-distinct) [298.835223] Subtest read-write-distinct: SKIP (0.000s) [298.915398] [050/134] (725s left) gem_mmap_offset (bad-extensions) [298.994275] Starting subtest: bad-extensions [298.995184] Subtest bad-extensions: SUCCESS (0.000s) [299.138394] [051/134] (725s left) kms_dsc (dsc-with-output-formats-with-bpc) [299.333040] Starting subtest: dsc-with-output-formats-with-bpc [299.356939] Subtest dsc-with-output-formats-with-bpc: SKIP (0.002s) [299.516352] [052/134] (725s left) gem_wait (invalid-flags) [299.601363] Starting subtest: invalid-flags [299.602292] Subtest invalid-flags: SUCCESS (0.000s) [299.904581] [053/134] (724s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu) [300.099544] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu [303.002104] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (2.903s) [303.200977] [054/134] (721s left) i915_pm_rpm (gem-execbuf-stress-pc8) [305.113972] Starting subtest: gem-execbuf-stress-pc8 [305.226315] Subtest gem-execbuf-stress-pc8: SKIP (0.115s) [305.540244] [055/134] (719s left) kms_getfb (getfb-addfb-different-handles) [305.726221] Starting subtest: getfb-addfb-different-handles [305.727124] Subtest getfb-addfb-different-handles: SUCCESS (0.000s) [305.904689] [056/134] (719s left) gem_exec_whisper (basic-contexts-priority) [305.998571] Starting subtest: basic-contexts-priority [328.519124] Subtest basic-contexts-priority: SUCCESS (22.519s) [328.821596] [057/134] (696s left) kms_pwrite_crc [329.999799] [058/134] (695s left) gem_exec_whisper (basic-queues-priority-all) [330.089498] Starting subtest: basic-queues-priority-all [352.093640] Subtest basic-queues-priority-all: SUCCESS (21.995s) [352.379306] [059/134] (672s left) kms_psr (psr2-primary-render) [352.569177] Subtest psr2-primary-render: SKIP (0.000s) [352.628029] [060/134] (672s left) prime_mmap (test_invalid_sync_flags) [352.706404] Starting subtest: test_invalid_sync_flags [352.707343] Starting dynamic subtest: test_invalid_sync_flags-smem [352.708283] Dynamic subtest test_invalid_sync_flags-smem: SUCCESS (0.000s) [352.720193] Starting dynamic subtest: test_invalid_sync_flags-lmem0 [352.721375] Dynamic subtest test_invalid_sync_flags-lmem0: SUCCESS (0.000s) [352.722644] Subtest test_invalid_sync_flags: SUCCESS (0.001s) [352.897523] [061/134] (672s left) kms_hdr (static-toggle) [353.088281] Starting subtest: static-toggle [353.673688] Starting dynamic subtest: pipe-A-DP-3 [354.724310] Dynamic subtest pipe-A-DP-3: SUCCESS (1.051s) [354.725608] Subtest static-toggle: SUCCESS (1.638s) [355.105654] [062/134] (670s left) gem_ctx_sseu (invalid-sseu) [355.190183] Subtest invalid-sseu: SKIP (0.000s) [355.269257] [063/134] (670s left) gem_sync (basic-all) [355.373277] Starting subtest: basic-all [358.400577] Subtest basic-all: SUCCESS (3.026s) [358.640057] [064/134] (666s left) gem_busy (extended) [358.921060] Starting subtest: extended [358.922038] Starting dynamic subtest: rcs0 [359.018041] Dynamic subtest rcs0: SUCCESS (0.096s) [359.034963] Starting dynamic subtest: bcs0 [359.062260] Dynamic subtest bcs0: SUCCESS (0.042s) [359.079153] Starting dynamic subtest: vcs0 [359.104692] Dynamic subtest vcs0: SUCCESS (0.041s) [359.131234] Starting dynamic subtest: vcs1 [359.149530] Dynamic subtest vcs1: SUCCESS (0.043s) [359.175256] Starting dynamic subtest: vecs0 [359.196272] Dynamic subtest vecs0: SUCCESS (0.045s) [359.212196] Starting dynamic subtest: vecs1 [359.239159] Dynamic subtest vecs1: SUCCESS (0.042s) [359.258586] Starting dynamic subtest: ccs0 [359.282560] Dynamic subtest ccs0: SUCCESS (0.042s) [359.283604] Subtest extended: SUCCESS (0.362s) [359.640370] [065/134] (665s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt) [359.829909] Starting subtest: psr-rgb565-draw-blt [359.831588] Subtest psr-rgb565-draw-blt: SKIP (0.000s) [360.041553] [066/134] (665s left) gem_mmap_gtt (basic-write-read) [360.122078] Subtest basic-write-read: SKIP (0.000s) [360.206240] [067/134] (665s left) kms_flip (2x-flip-vs-panning) [360.392279] Starting subtest: 2x-flip-vs-panning [360.407132] Subtest 2x-flip-vs-panning: SKIP (0.014s) [360.549645] [068/134] (665s left) gem_exec_schedule (preempt-contexts) [360.649551] Starting subtest: preempt-contexts [360.650465] Starting dynamic subtest: rcs0 [360.757201] Dynamic subtest rcs0: SUCCESS (0.107s) [360.769451] Starting dynamic subtest: bcs0 [360.833912] Dynamic subtest bcs0: SUCCESS (0.076s) [360.846241] Starting dynamic subtest: vcs0 [360.908116] Dynamic subtest vcs0: SUCCESS (0.073s) [360.920097] Starting dynamic subtest: vcs1 [360.980998] Dynamic subtest vcs1: SUCCESS (0.072s) [360.992881] Starting dynamic subtest: vecs0 [361.053364] Dynamic subtest vecs0: SUCCESS (0.072s) [361.065241] Starting dynamic subtest: vecs1 [361.131266] Dynamic subtest vecs1: SUCCESS (0.077s) [361.143383] Starting dynamic subtest: ccs0 [361.206758] Dynamic subtest ccs0: SUCCESS (0.075s) [361.207574] Subtest preempt-contexts: SUCCESS (0.558s) [361.738479] [069/134] (664s left) kms_rotation_crc (sprite-rotation-90-pos-100-0) [361.923984] Starting subtest: sprite-rotation-90-pos-100-0 [361.925741] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s) [362.085855] [070/134] (663s left) kms_psr (fbc-psr-sprite-blt) [362.281386] Subtest fbc-psr-sprite-blt: SKIP (0.000s) [362.350733] [071/134] (663s left) kms_force_connector_basic (force-connector-state) [362.458780] Starting subtest: force-connector-state [362.807821] Subtest force-connector-state: SUCCESS (0.349s) [363.243415] [072/134] (662s left) syncobj_timeline (transfer-timeline-point) [363.353419] Starting subtest: transfer-timeline-point [363.354616] Subtest transfer-timeline-point: SUCCESS (0.000s) [363.534471] [073/134] (662s left) gem_exec_fence (concurrent) [363.738211] Starting subtest: concurrent [363.740404] Subtest concurrent: SKIP (0.000s) [364.467287] [074/134] (661s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt) [364.658853] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt [364.660515] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [364.854543] [075/134] (661s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled) [364.942590] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled [364.943513] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s) [365.133519] [076/134] (661s left) gem_linear_blits (normal) [365.409510] Starting subtest: normal [375.177267] Subtest normal: SUCCESS (9.767s) [375.486901] [077/134] (650s left) gem_mmap_gtt (basic-copy) [375.604135] Subtest basic-copy: SKIP (0.000s) [375.677791] [078/134] (650s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [375.884224] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s) [376.077407] [079/134] (650s left) gem_mmap_gtt (big-copy-xy) [376.164164] Subtest big-copy-XY: SKIP (0.000s) [376.253640] [080/134] (650s left) kms_flip (flip-vs-suspend-interruptible) [376.445066] Starting subtest: flip-vs-suspend-interruptible [376.449681] Starting dynamic subtest: A-DP3 [415.528413] Dynamic subtest A-DP3: SUCCESS (7.848s) [415.545891] Starting dynamic subtest: B-DP3 [454.391504] Dynamic subtest B-DP3: SUCCESS (7.307s) [454.409892] Starting dynamic subtest: C-DP3 [493.229075] Dynamic subtest C-DP3: SUCCESS (7.300s) [493.250074] Starting dynamic subtest: D-DP3 [532.134050] Dynamic subtest D-DP3: SUCCESS (7.254s) [532.137332] Subtest flip-vs-suspend-interruptible: SUCCESS (29.724s) [532.414579] [081/134] (494s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite) [532.607906] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite [532.609519] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [532.805551] [082/134] (494s left) kms_cursor_crc (cursor-random-max-size) [533.318822] Starting subtest: cursor-random-max-size [533.322825] Subtest cursor-random-max-size: SKIP (0.000s) [533.500775] [083/134] (493s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt) [533.696097] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt [533.697832] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s) [533.900604] [084/134] (493s left) gem_mmap_wc (bad-offset) [533.980189] Subtest bad-offset: SKIP (0.000s) [534.070234] [085/134] (492s left) vgem_basic (dmabuf-fence) [534.128264] Starting subtest: dmabuf-fence [534.129190] Subtest dmabuf-fence: SUCCESS (0.000s) [534.292344] [086/134] (492s left) kms_prop_blob (invalid-get-prop) [534.370397] Starting subtest: invalid-get-prop [534.371339] Subtest invalid-get-prop: SUCCESS (0.000s) [534.565054] [087/134] (492s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip) [534.762682] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip [536.073348] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.299s) [536.303741] [088/134] (491s left) syncobj_timeline (invalid-multi-wait-unsubmitted) [536.403333] Starting subtest: invalid-multi-wait-unsubmitted [536.404278] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s) [536.567744] [089/134] (490s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render) [536.757185] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render [536.758934] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [536.950452] [090/134] (490s left) kms_chamelium_edid (dp-edid-stress-resolution-non-4k) [537.223314] Subtest dp-edid-stress-resolution-non-4k: SKIP (0.000s) [537.410935] [091/134] (490s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs) [537.602938] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs [537.605207] Starting dynamic subtest: pipe-A-DP-3 [537.614290] Dynamic subtest pipe-A-DP-3: SKIP (0.000s) [537.630204] Starting dynamic subtest: pipe-B-DP-3 [537.639537] Dynamic subtest pipe-B-DP-3: SKIP (0.000s) [537.655227] Starting dynamic subtest: pipe-C-DP-3 [537.665979] Dynamic subtest pipe-C-DP-3: SKIP (0.000s) [537.681227] Starting dynamic subtest: pipe-D-DP-3 [537.692576] Dynamic subtest pipe-D-DP-3: SKIP (0.000s) [537.694493] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.007s) [538.089589] [092/134] (489s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs) [538.291463] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs [538.292340] Starting dynamic subtest: pipe-A-DP-3 [538.300662] Dynamic subtest pipe-A-DP-3: SKIP (0.000s) [538.316270] Starting dynamic subtest: pipe-B-DP-3 [538.324576] Dynamic subtest pipe-B-DP-3: SKIP (0.000s) [538.340054] Starting dynamic subtest: pipe-C-DP-3 [538.348982] Dynamic subtest pipe-C-DP-3: SKIP (0.000s) [538.364617] Starting dynamic subtest: pipe-D-DP-3 [538.375486] Dynamic subtest pipe-D-DP-3: SKIP (0.000s) [538.377223] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.007s) [538.764156] [093/134] (488s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite) [538.954171] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite [538.955887] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [539.128535] [094/134] (488s left) perf_pmu (semaphore-wait) [539.201270] Starting subtest: semaphore-wait [539.202190] Starting dynamic subtest: rcs0 [539.742811] Dynamic subtest rcs0: SUCCESS (0.540s) [539.765617] Starting dynamic subtest: bcs0 [540.259849] Dynamic subtest bcs0: SUCCESS (0.511s) [540.285222] Starting dynamic subtest: vcs0 [540.779334] Dynamic subtest vcs0: SUCCESS (0.514s) [540.802010] Starting dynamic subtest: vcs1 [541.296126] Dynamic subtest vcs1: SUCCESS (0.511s) [541.318104] Starting dynamic subtest: vecs0 [541.812792] Dynamic subtest vecs0: SUCCESS (0.511s) [541.834942] Starting dynamic subtest: vecs1 [542.328633] Dynamic subtest vecs1: SUCCESS (0.510s) [542.353205] Starting dynamic subtest: ccs0 [542.847403] Dynamic subtest ccs0: SUCCESS (0.513s) [542.853702] Subtest semaphore-wait: SUCCESS (3.646s) [543.064741] [095/134] (484s left) kms_flip (busy-flip) [543.253424] Starting subtest: busy-flip [543.258161] Starting dynamic subtest: A-DP3 [544.100530] Dynamic subtest A-DP3: SUCCESS (0.842s) [544.120318] Starting dynamic subtest: B-DP3 [544.872476] Dynamic subtest B-DP3: SUCCESS (0.770s) [544.893814] Starting dynamic subtest: C-DP3 [545.645504] Dynamic subtest C-DP3: SUCCESS (0.771s) [545.663822] Starting dynamic subtest: D-DP3 [546.415490] Dynamic subtest D-DP3: SUCCESS (0.768s) [546.417936] Subtest busy-flip: SUCCESS (3.163s) [546.807440] [096/134] (481s left) gem_tiled_partial_pwrite_pread (writes) [546.891242] Subtest writes: SKIP (0.000s) [546.962951] [097/134] (481s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt) [547.154225] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt [547.155932] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [547.352569] [098/134] (480s left) gem_ctx_persistence (legacy-engines-hang) [547.455333] Starting subtest: legacy-engines-hang [547.456228] Starting dynamic subtest: render [547.550282] Dynamic subtest render: SUCCESS (0.094s) [547.571591] Starting dynamic subtest: bsd1 [547.663434] Dynamic subtest bsd1: SUCCESS (0.111s) [547.718988] Starting dynamic subtest: bsd2 [547.736309] Dynamic subtest bsd2: SUCCESS (0.067s) [547.756532] Starting dynamic subtest: blt [547.773054] Dynamic subtest blt: SUCCESS (0.035s) [547.791495] Starting dynamic subtest: vebox [547.877414] Dynamic subtest vebox: SUCCESS (0.102s) [547.883925] Subtest legacy-engines-hang: SUCCESS (0.424s) [548.118890] [099/134] (480s left) api_intel_bb (object-noreloc-purge-cache-simple) [548.195600] Starting subtest: object-noreloc-purge-cache-simple [548.226221] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.031s) [548.406544] [100/134] (479s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20) [548.599477] Starting subtest: planes-downscale-factor-0-75-upscale-20x20 [548.600312] Starting dynamic subtest: pipe-A [548.695390] Dynamic subtest pipe-A: SUCCESS (0.096s) [548.728326] Starting dynamic subtest: pipe-B [548.924697] Dynamic subtest pipe-B: SUCCESS (0.228s) [548.947565] Starting dynamic subtest: pipe-C [549.120919] Dynamic subtest pipe-C: SUCCESS (0.195s) [549.147324] Starting dynamic subtest: pipe-D [549.336190] Dynamic subtest pipe-D: SUCCESS (0.213s) [549.337398] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (0.738s) [549.706092] [101/134] (478s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping) [549.892945] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping [549.915792] Starting dynamic subtest: pipe-A-plane-0 [549.917485] Dynamic subtest pipe-A-plane-0: SKIP (0.000s) [549.933975] Starting dynamic subtest: pipe-A-plane-3 [549.935800] Dynamic subtest pipe-A-plane-3: SKIP (0.000s) [549.952142] Starting dynamic subtest: pipe-A-plane-5 [549.953945] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [550.159302] Starting dynamic subtest: pipe-B-plane-0 [550.161285] Dynamic subtest pipe-B-plane-0: SKIP (0.000s) [550.183215] Starting dynamic subtest: pipe-B-plane-3 [550.185577] Dynamic subtest pipe-B-plane-3: SKIP (0.000s) [550.201822] Starting dynamic subtest: pipe-B-plane-5 [550.204147] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [550.221066] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.326s) [550.476887] [102/134] (477s left) kms_big_fb (4-tiled-64bpp-rotate-270) [550.674104] Starting subtest: 4-tiled-64bpp-rotate-270 [550.734296] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.059s) [550.975780] [103/134] (477s left) kms_prime (basic-crc-vgem) [551.166475] Subtest basic-crc-vgem: SKIP (0.000s) [551.381705] [104/134] (477s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt) [551.571990] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt [551.573640] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [551.746121] [105/134] (477s left) gem_ringfill (legacy-basic) [552.225696] Starting subtest: legacy-basic [552.231562] Starting dynamic subtest: default [552.337427] Dynamic subtest default: SUCCESS (0.110s) [552.357496] Starting dynamic subtest: render [552.379552] Dynamic subtest render: SUCCESS (0.041s) [552.404472] Starting dynamic subtest: bsd [552.422415] Dynamic subtest bsd: SUCCESS (0.041s) [552.448323] Starting dynamic subtest: bsd1 [552.464410] Dynamic subtest bsd1: SUCCESS (0.040s) [552.483652] Starting dynamic subtest: bsd2 [552.506563] Dynamic subtest bsd2: SUCCESS (0.040s) [552.530568] Starting dynamic subtest: blt [552.549419] Dynamic subtest blt: SUCCESS (0.041s) [552.573201] Starting dynamic subtest: vebox [552.591304] Dynamic subtest vebox: SUCCESS (0.040s) [552.592314] Subtest legacy-basic: SUCCESS (0.367s) [552.883679] [106/134] (476s left) gen3_mixed_blits [553.035164] [107/134] (475s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d) [553.224000] Starting subtest: plane-lut1d-ctm3x4-lut1d [553.252470] Starting dynamic subtest: pipe-A-DP-3 [553.651779] Dynamic subtest pipe-A-DP-3: SUCCESS (0.400s) [553.863817] Starting dynamic subtest: pipe-B-DP-3 [554.196489] Dynamic subtest pipe-B-DP-3: SUCCESS (0.348s) [554.409094] Starting dynamic subtest: pipe-C-DP-3 [554.734406] Dynamic subtest pipe-C-DP-3: SUCCESS (0.375s) [554.920596] Starting dynamic subtest: pipe-D-DP-3 [555.268132] Dynamic subtest pipe-D-DP-3: SUCCESS (0.365s) [555.374098] Subtest plane-lut1d-ctm3x4-lut1d: SUCCESS (2.149s) [555.666355] [108/134] (473s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc) [555.850961] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc [555.853432] Starting dynamic subtest: pipe-A-DP-3 [555.861662] Dynamic subtest pipe-A-DP-3: SKIP (0.001s) [555.878412] Starting dynamic subtest: pipe-B-DP-3 [555.886991] Dynamic subtest pipe-B-DP-3: SKIP (0.001s) [555.903588] Starting dynamic subtest: pipe-C-DP-3 [555.913402] Dynamic subtest pipe-C-DP-3: SKIP (0.001s) [555.930267] Starting dynamic subtest: pipe-D-DP-3 [555.940475] Dynamic subtest pipe-D-DP-3: SKIP (0.001s) [555.942032] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.009s) [556.312744] [109/134] (472s left) gem_exec_params (rs-invalid) [556.396852] Starting subtest: rs-invalid [556.399281] Subtest rs-invalid: SUCCESS (0.002s) [556.575560] [110/134] (472s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs) [556.766810] Starting subtest: missing-ccs-buffer-y-tiled-ccs [556.769320] Starting dynamic subtest: pipe-A-DP-3 [556.777981] Dynamic subtest pipe-A-DP-3: SKIP (0.000s) [556.794515] Starting dynamic subtest: pipe-B-DP-3 [556.803067] Dynamic subtest pipe-B-DP-3: SKIP (0.000s) [556.819058] Starting dynamic subtest: pipe-C-DP-3 [556.830154] Dynamic subtest pipe-C-DP-3: SKIP (0.000s) [556.846271] Starting dynamic subtest: pipe-D-DP-3 [556.857382] Dynamic subtest pipe-D-DP-3: SKIP (0.000s) [556.859533] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.007s) [557.258158] [111/134] (472s left) kms_draw_crc (fill-fb) [557.445399] Starting subtest: fill-fb [557.966080] Subtest fill-fb: SUCCESS (0.520s) [558.191540] [112/134] (471s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs) [558.381361] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs [558.382263] Starting dynamic subtest: pipe-A-DP-3 [558.390601] Dynamic subtest pipe-A-DP-3: SKIP (0.000s) [558.407034] Starting dynamic subtest: pipe-B-DP-3 [558.415415] Dynamic subtest pipe-B-DP-3: SKIP (0.000s) [558.431612] Starting dynamic subtest: pipe-C-DP-3 [558.441177] Dynamic subtest pipe-C-DP-3: SKIP (0.000s) [558.457280] Starting dynamic subtest: pipe-D-DP-3 [558.467162] Dynamic subtest pipe-D-DP-3: SKIP (0.000s) [558.468979] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.007s) [558.870936] [113/134] (470s left) kms_addfb_basic (too-wide) [559.058379] Starting subtest: too-wide [559.059275] Subtest too-wide: SUCCESS (0.000s) [559.239464] [114/134] (470s left) gem_pxp (reject-modify-context-protection-off-1) [561.849318] Starting subtest: reject-modify-context-protection-off-1 [561.851368] Subtest reject-modify-context-protection-off-1: SKIP (0.000s) [561.998633] [115/134] (467s left) prime_busy (hang-wait) [562.082538] Starting subtest: hang-wait [562.084958] Starting dynamic subtest: rcs0 [588.474878] Dynamic subtest rcs0: SUCCESS (26.389s) [588.491692] Starting dynamic subtest: bcs0 [595.627806] Dynamic subtest bcs0: SUCCESS (7.151s) [595.644757] Starting dynamic subtest: vcs0 [602.606283] Dynamic subtest vcs0: SUCCESS (6.978s) [602.624448] Starting dynamic subtest: vcs1 [609.586511] Dynamic subtest vcs1: SUCCESS (6.977s) [609.603409] Starting dynamic subtest: vecs0 [616.622875] Dynamic subtest vecs0: SUCCESS (7.035s) [616.639951] Starting dynamic subtest: vecs1 [623.600888] Dynamic subtest vecs1: SUCCESS (6.976s) [623.617973] Starting dynamic subtest: ccs0 [637.428004] Dynamic subtest ccs0: SUCCESS (13.827s) [637.428990] Subtest hang-wait: SUCCESS (75.344s) [637.603621] [116/134] (392s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180) [637.800407] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180 [637.802159] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s) [638.005750] [117/134] (391s left) gem_spin_batch (legacy-resubmit-new) [638.099008] Starting subtest: legacy-resubmit-new [638.099949] Starting dynamic subtest: default [638.132451] Dynamic subtest default: SUCCESS (0.032s) [638.151469] Starting dynamic subtest: render [638.152445] Dynamic subtest render: SUCCESS (0.004s) [638.169861] Starting dynamic subtest: bsd [638.170775] Dynamic subtest bsd: SUCCESS (0.006s) [638.187618] Starting dynamic subtest: bsd1 [638.188646] Dynamic subtest bsd1: SUCCESS (0.004s) [638.205181] Starting dynamic subtest: bsd2 [638.206205] Dynamic subtest bsd2: SUCCESS (0.004s) [638.222852] Starting dynamic subtest: blt [638.223727] Dynamic subtest blt: SUCCESS (0.004s) [638.239986] Starting dynamic subtest: vebox [638.240863] Dynamic subtest vebox: SUCCESS (0.004s) [638.241665] Subtest legacy-resubmit-new: SUCCESS (0.069s) [638.471656] [118/134] (391s left) kms_cursor_legacy (forked-bo) [638.661386] Starting subtest: forked-bo [638.662298] Starting dynamic subtest: pipe-A [644.083634] Dynamic subtest pipe-A: SUCCESS (5.420s) [644.110721] Starting dynamic subtest: pipe-B [649.507894] Dynamic subtest pipe-B: SUCCESS (5.423s) [649.538319] Starting dynamic subtest: pipe-C [654.944175] Dynamic subtest pipe-C: SUCCESS (5.434s) [654.977525] Starting dynamic subtest: pipe-D [660.372761] Dynamic subtest pipe-D: SUCCESS (5.424s) [660.407362] Starting dynamic subtest: all-pipes [665.816441] Dynamic subtest all-pipes: SUCCESS (5.441s) [665.817330] Subtest forked-bo: SUCCESS (27.154s) [665.981494] [119/134] (363s left) i915_hangman (detector) [666.080398] Starting subtest: detector [666.081313] Starting dynamic subtest: rcs0 [676.175189] Dynamic subtest rcs0: SUCCESS (10.095s) [676.193130] Starting dynamic subtest: bcs0 [686.112435] Dynamic subtest bcs0: SUCCESS (9.935s) [686.130975] Starting dynamic subtest: vcs0 [696.107243] Dynamic subtest vcs0: SUCCESS (9.993s) [696.125807] Starting dynamic subtest: vcs1 [706.162304] Dynamic subtest vcs1: SUCCESS (10.054s) [706.180254] Starting dynamic subtest: vecs0 [716.140543] Dynamic subtest vecs0: SUCCESS (9.977s) [716.158784] Starting dynamic subtest: vecs1 [726.161848] Dynamic subtest vecs1: SUCCESS (10.020s) [726.199188] Starting dynamic subtest: ccs0 [735.150804] Dynamic subtest ccs0: SUCCESS (8.987s) [735.151642] Subtest detector: SUCCESS (69.072s) [735.370207] [120/134] (294s left) kms_getfb (getfb-handle-valid) [735.563383] Starting subtest: getfb-handle-valid [735.564271] Subtest getfb-handle-valid: SUCCESS (0.000s) [735.775825] [121/134] (294s left) gem_exec_schedule (submit-golden-slice) [735.871588] Starting subtest: submit-golden-slice [735.872506] Starting dynamic subtest: rcs0 [735.956169] Dynamic subtest rcs0: SUCCESS (0.084s) [735.974212] Starting dynamic subtest: bcs0 [736.013430] Dynamic subtest bcs0: SUCCESS (0.056s) [736.031596] Starting dynamic subtest: vcs0 [736.067401] Dynamic subtest vcs0: SUCCESS (0.053s) [736.085638] Starting dynamic subtest: vcs1 [736.124963] Dynamic subtest vcs1: SUCCESS (0.056s) [736.142836] Starting dynamic subtest: vecs0 [736.177558] Dynamic subtest vecs0: SUCCESS (0.051s) [736.195540] Starting dynamic subtest: vecs1 [736.234322] Dynamic subtest vecs1: SUCCESS (0.056s) [736.252172] Starting dynamic subtest: ccs0 [736.287948] Dynamic subtest ccs0: SUCCESS (0.052s) [736.288966] Subtest submit-golden-slice: SUCCESS (0.417s) [736.796529] [122/134] (293s left) kms_flip (blocking-wf_vblank) [736.981227] Starting subtest: blocking-wf_vblank [736.985938] Starting dynamic subtest: A-DP3 [745.115101] Dynamic subtest A-DP3: SUCCESS (8.129s) [745.141831] Starting dynamic subtest: B-DP3 [753.168014] Dynamic subtest B-DP3: SUCCESS (8.051s) [753.187642] Starting dynamic subtest: C-DP3 [761.222280] Dynamic subtest C-DP3: SUCCESS (8.053s) [761.241596] Starting dynamic subtest: D-DP3 [769.277245] Dynamic subtest D-DP3: SUCCESS (8.053s) [769.279508] Subtest blocking-wf_vblank: SUCCESS (32.297s) [769.637943] [123/134] (260s left) kms_async_flips (test-cursor) [769.823478] Starting subtest: test-cursor [770.057972] Starting dynamic subtest: pipe-A-DP-3 [770.344004] Dynamic subtest pipe-A-DP-3: SUCCESS (0.286s) [770.593366] Starting dynamic subtest: pipe-B-DP-3 [770.709255] Dynamic subtest pipe-B-DP-3: SUCCESS (0.133s) [770.929852] Starting dynamic subtest: pipe-C-DP-3 [771.022091] Dynamic subtest pipe-C-DP-3: SUCCESS (0.108s) [771.236993] Starting dynamic subtest: pipe-D-DP-3 [771.361931] Dynamic subtest pipe-D-DP-3: SUCCESS (0.141s) [771.362943] Subtest test-cursor: SUCCESS (1.540s) [771.922019] [124/134] (258s left) i915_pm_rps (thresholds-idle) [772.015406] Starting subtest: thresholds-idle [772.017285] Subtest thresholds-idle: SKIP (0.000s) [772.157858] [125/134] (258s left) kms_flip (basic-flip-vs-wf_vblank) [772.345084] Starting subtest: basic-flip-vs-wf_vblank [772.349831] Starting dynamic subtest: A-DP3 [773.472479] Dynamic subtest A-DP3: SUCCESS (1.123s) [773.498408] Starting dynamic subtest: B-DP3 [774.521631] Dynamic subtest B-DP3: SUCCESS (1.047s) [774.540567] Starting dynamic subtest: C-DP3 [775.577648] Dynamic subtest C-DP3: SUCCESS (1.055s) [775.596630] Starting dynamic subtest: D-DP3 [776.629996] Dynamic subtest D-DP3: SUCCESS (1.051s) [776.632459] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.287s) [776.991043] [126/134] (253s left) kms_psr (fbc-psr2-sprite-mmap-gtt) [777.180446] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.000s) [777.246206] [127/134] (253s left) kms_psr (fbc-pr-primary-mmap-gtt) [777.434567] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s) [777.498504] [128/134] (253s left) perf (blocking-parameterized) [777.948919] Starting subtest: blocking-parameterized [797.984241] Subtest blocking-parameterized: SUCCESS (20.034s) [798.050458] [129/134] (232s left) vgem_basic (debugfs) [798.113755] Starting subtest: debugfs [798.114632] Subtest debugfs: SUCCESS (0.000s) [798.255366] [130/134] (232s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-onoff) [798.450210] Starting subtest: fbc-1p-primscrn-cur-indfb-onoff [803.714599] Subtest fbc-1p-primscrn-cur-indfb-onoff: SUCCESS (5.265s) [803.990143] [131/134] (226s left) kms_addfb_basic (clobberred-modifier) [804.066777] Starting subtest: clobberred-modifier [804.068459] Subtest clobberred-modifier: SKIP (0.000s) [804.370996] [132/134] (226s left) syncobj_timeline (invalid-single-wait-all-unsubmitted) [804.450512] Starting subtest: invalid-single-wait-all-unsubmitted [804.451394] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s) [804.596433] [133/134] (226s left) api_intel_allocator (standalone) [804.672562] Starting subtest: standalone [804.714094] Subtest standalone: SUCCESS (0.041s) [804.904145] [134/134] (226s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc) [805.104197] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc [805.105899] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [805.305323] Closing watchdogs results: parsing output: 0/ for test: kms_cursor_crc results: parsing output: 1/ for test: kms_frontbuffer_tracking results: parsing output: 2/ for test: kms_cursor_legacy results: parsing output: 3/ for test: gem_lmem_swapping results: parsing output: 4/ for test: syncobj_wait results: parsing output: 5/ for test: kms_selftest results: parsing output: 6/ for test: kms_vrr results: parsing output: 7/ for test: prime_mmap results: parsing output: 8/ for test: kms_plane results: parsing output: 9/ for test: gem_exec_flush results: parsing output: 10/ for test: kms_invalid_mode results: parsing output: 11/ for test: prime_udl results: parsing output: 12/ for test: kms_frontbuffer_tracking results: parsing output: 13/ for test: dmabuf_sync_file results: parsing output: 14/ for test: kms_big_fb results: parsing output: 15/ for test: gem_ctx_isolation results: parsing output: 16/ for test: kms_frontbuffer_tracking results: parsing output: 17/ for test: syncobj_wait results: parsing output: 18/ for test: kms_frontbuffer_tracking results: parsing output: 19/ for test: kms_big_fb results: parsing output: 20/ for test: gem_eio results: parsing output: 21/ for test: kms_frontbuffer_tracking results: parsing output: 22/ for test: kms_content_protection results: parsing output: 23/ for test: kms_psr2_sf results: parsing output: 24/ for test: gem_exec_fence results: parsing output: 25/ for test: kms_frontbuffer_tracking results: parsing output: 26/ for test: kms_big_fb results: parsing output: 27/ for test: syncobj_timeline results: parsing output: 28/ for test: i915_drm_fdinfo results: parsing output: 29/ for test: gem_basic results: parsing output: 30/ for test: gem_exec_balancer results: parsing output: 31/ for test: kms_psr results: parsing output: 32/ for test: kms_psr results: parsing output: 33/ for test: gem_ctx_engines results: parsing output: 34/ for test: kms_plane_alpha_blend results: parsing output: 35/ for test: gen9_exec_parse results: parsing output: 36/ for test: kms_frontbuffer_tracking results: parsing output: 37/ for test: kms_plane_multiple results: parsing output: 38/ for test: gem_mmap_gtt results: parsing output: 39/ for test: kms_flip_scaled_crc results: parsing output: 40/ for test: kms_pm_dc results: parsing output: 41/ for test: kms_lease results: parsing output: 42/ for test: vgem_basic results: parsing output: 43/ for test: kms_chamelium_hpd results: parsing output: 44/ for test: kms_big_fb results: parsing output: 45/ for test: kms_cursor_crc results: parsing output: 46/ for test: kms_frontbuffer_tracking results: parsing output: 47/ for test: gem_vm_create results: parsing output: 48/ for test: gem_mmap_wc results: parsing output: 49/ for test: gem_mmap_offset results: parsing output: 50/ for test: kms_dsc results: parsing output: 51/ for test: gem_wait results: parsing output: 52/ for test: kms_frontbuffer_tracking results: parsing output: 53/ for test: i915_pm_rpm results: parsing output: 54/ for test: kms_getfb results: parsing output: 55/ for test: gem_exec_whisper results: parsing output: 56/ for test: kms_pwrite_crc results: parsing output: 57/ for test: gem_exec_whisper results: parsing output: 58/ for test: kms_psr results: parsing output: 59/ for test: prime_mmap results: parsing output: 60/ for test: kms_hdr results: parsing output: 61/ for test: gem_ctx_sseu results: parsing output: 62/ for test: gem_sync results: parsing output: 63/ for test: gem_busy results: parsing output: 64/ for test: kms_frontbuffer_tracking results: parsing output: 65/ for test: gem_mmap_gtt results: parsing output: 66/ for test: kms_flip results: parsing output: 67/ for test: gem_exec_schedule results: parsing output: 68/ for test: kms_rotation_crc results: parsing output: 69/ for test: kms_psr results: parsing output: 70/ for test: kms_force_connector_basic results: parsing output: 71/ for test: syncobj_timeline results: parsing output: 72/ for test: gem_exec_fence results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: syncobj_timeline results: parsing output: 75/ for test: gem_linear_blits results: parsing output: 76/ for test: gem_mmap_gtt results: parsing output: 77/ for test: kms_addfb_basic results: parsing output: 78/ for test: gem_mmap_gtt results: parsing output: 79/ for test: kms_flip results: parsing output: 80/ for test: kms_frontbuffer_tracking results: parsing output: 81/ for test: kms_cursor_crc results: parsing output: 82/ for test: kms_frontbuffer_tracking results: parsing output: 83/ for test: gem_mmap_wc results: parsing output: 84/ for test: vgem_basic results: parsing output: 85/ for test: kms_prop_blob results: parsing output: 86/ for test: kms_big_fb results: parsing output: 87/ for test: syncobj_timeline results: parsing output: 88/ for test: kms_frontbuffer_tracking results: parsing output: 89/ for test: kms_chamelium_edid results: parsing output: 90/ for test: kms_ccs results: parsing output: 91/ for test: kms_ccs results: parsing output: 92/ for test: kms_frontbuffer_tracking results: parsing output: 93/ for test: perf_pmu results: parsing output: 94/ for test: kms_flip results: parsing output: 95/ for test: gem_tiled_partial_pwrite_pread results: parsing output: 96/ for test: kms_frontbuffer_tracking results: parsing output: 97/ for test: gem_ctx_persistence results: parsing output: 98/ for test: api_intel_bb results: parsing output: 99/ for test: kms_plane_scaling results: parsing output: 100/ for test: kms_plane results: parsing output: 101/ for test: kms_big_fb results: parsing output: 102/ for test: kms_prime results: parsing output: 103/ for test: kms_frontbuffer_tracking results: parsing output: 104/ for test: gem_ringfill results: parsing output: 105/ for test: gen3_mixed_blits results: parsing output: 106/ for test: kms_color_pipeline results: parsing output: 107/ for test: kms_ccs results: parsing output: 108/ for test: gem_exec_params results: parsing output: 109/ for test: kms_ccs results: parsing output: 110/ for test: kms_draw_crc results: parsing output: 111/ for test: kms_ccs results: parsing output: 112/ for test: kms_addfb_basic results: parsing output: 113/ for test: gem_pxp results: parsing output: 114/ for test: prime_busy results: parsing output: 115/ for test: kms_big_fb results: parsing output: 116/ for test: gem_spin_batch results: parsing output: 117/ for test: kms_cursor_legacy results: parsing output: 118/ for test: i915_hangman results: parsing output: 119/ for test: kms_getfb results: parsing output: 120/ for test: gem_exec_schedule results: parsing output: 121/ for test: kms_flip results: parsing output: 122/ for test: kms_async_flips results: parsing output: 123/ for test: i915_pm_rps results: parsing output: 124/ for test: kms_flip results: parsing output: 125/ for test: kms_psr results: parsing output: 126/ for test: kms_psr results: parsing output: 127/ for test: perf results: parsing output: 128/ for test: vgem_basic results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: kms_addfb_basic results: parsing output: 131/ for test: syncobj_timeline results: parsing output: 132/ for test: api_intel_allocator results: parsing output: 133/ for test: kms_frontbuffer_tracking Done.