[74.245028] Initializing watchdogs [74.245118] /dev/watchdog0 [74.274619] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:4905 Intel Dg1 (Gen12) DG1 [Iris Xe MAX Graphics] [74.288657] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [74.293546] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [74.297183] [001/134] (960s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt) [75.800534] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt [75.803509] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [76.027409] [002/134] (958s left) gem_exec_params (secure-non-master) [76.082193] Starting subtest: secure-non-master [76.085783] Subtest secure-non-master: SKIP (0.000s) [76.264434] [003/134] (958s left) tools_test (tools_test) [76.319556] Starting subtest: tools_test [76.418400] Subtest tools_test: SUCCESS (0.109s) [76.538782] [004/134] (958s left) kms_selftest (drm_cmdline_parser) [76.583841] Starting subtest: drm_cmdline_parser [76.670404] Starting dynamic subtest: drm_test_cmdline_force_d_only [76.745768] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.077s) [76.756615] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi [76.833243] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.086s) [76.869862] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi [76.928698] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.094s) [76.963290] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital [77.016923] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.086s) [77.047068] Starting dynamic subtest: drm_test_cmdline_force_e_only [77.081311] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.064s) [77.099019] Starting dynamic subtest: drm_test_cmdline_res [77.159125] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.075s) [77.195744] Starting dynamic subtest: drm_test_cmdline_res_vesa [77.265158] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.105s) [77.301334] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank [77.345299] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.079s) [77.376884] Starting dynamic subtest: drm_test_cmdline_res_rblank [77.432544] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.087s) [77.440862] Starting dynamic subtest: drm_test_cmdline_res_bpp [77.530431] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.094s) [77.566586] Starting dynamic subtest: drm_test_cmdline_res_refresh [77.628559] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.096s) [77.663156] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh [77.716327] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.087s) [77.752436] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced [77.795399] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.078s) [77.824792] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins [77.886086] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.087s) [77.921922] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off [77.993270] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.105s) [78.023148] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on [78.072839] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.081s) [78.105436] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog [78.164120] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.089s) [78.200511] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital [78.255928] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.091s) [78.291866] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on [78.357940] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.100s) [78.393098] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on [78.433528] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.074s) [78.462453] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins [78.516364] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.079s) [78.549692] Starting dynamic subtest: drm_test_cmdline_name [78.607566] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.089s) [78.640593] Starting dynamic subtest: drm_test_cmdline_name_bpp [78.676218] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.071s) [78.704563] Starting dynamic subtest: drm_test_cmdline_name_option [78.767400] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.089s) [78.802830] Starting dynamic subtest: drm_test_cmdline_name_bpp_option [78.872993] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.103s) [78.904567] Starting dynamic subtest: drm_test_cmdline_rotate_0 [78.956308] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.080s) [78.991949] Starting dynamic subtest: drm_test_cmdline_rotate_90 [79.060256] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.103s) [79.094147] Starting dynamic subtest: drm_test_cmdline_rotate_180 [79.136369] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.077s) [79.164697] Starting dynamic subtest: drm_test_cmdline_rotate_270 [79.222243] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.082s) [79.255598] Starting dynamic subtest: drm_test_cmdline_hmirror [79.315558] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.094s) [79.343909] Starting dynamic subtest: drm_test_cmdline_vmirror [79.391783] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.075s) [79.423891] Starting dynamic subtest: drm_test_cmdline_margin_options [79.467931] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.075s) [79.502874] Starting dynamic subtest: drm_test_cmdline_multiple_options [79.553567] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.083s) [79.587970] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option [79.643334] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.089s) [79.672525] Starting dynamic subtest: drm_test_cmdline_extra_and_option [79.732125] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.087s) [79.767299] Starting dynamic subtest: drm_test_cmdline_freestanding_options [79.825672] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.092s) [79.861507] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options [79.910496] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.083s) [79.941426] Starting dynamic subtest: drm_test_cmdline_panel_orientation [79.981538] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.072s) [80.002489] Starting dynamic subtest: drm_test_cmdline_invalid [80.097118] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.112s) [80.127344] Starting dynamic subtest: drm_test_cmdline_tv_options [80.193098] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.096s) [80.195455] Subtest drm_cmdline_parser: SUCCESS (3.610s) [80.409426] [005/134] (954s left) gem_exec_suspend (basic-s0) [80.465662] Starting subtest: basic-S0 [80.467167] Starting dynamic subtest: smem [100.245083] Dynamic subtest smem: SUCCESS (5.338s) [100.254858] Starting dynamic subtest: lmem0 [120.273862] Dynamic subtest lmem0: SUCCESS (4.919s) [120.275419] Subtest basic-S0: SUCCESS (10.258s) [128.582726] [006/134] (914s left) kms_content_protection (uevent) [130.131384] Starting subtest: uevent [130.141503] Subtest uevent: SKIP (0.006s) [130.366223] [007/134] (913s left) gem_eio (in-flight-suspend) [130.557974] Starting subtest: in-flight-suspend [173.735336] Subtest in-flight-suspend: SUCCESS (17.245s) [179.316727] [FACT gem_eio (in-flight-suspend)] new: kernel.kmod_is_loaded.vgem: true [179.322438] [008/134] (868s left) gem_spin_batch (resubmit-all) [179.379195] Starting subtest: resubmit-all [179.380889] Starting dynamic subtest: rcs0 [179.402031] Dynamic subtest rcs0: SUCCESS (0.023s) [179.414395] Starting dynamic subtest: bcs0 [179.416449] Dynamic subtest bcs0: SUCCESS (0.003s) [179.428269] Starting dynamic subtest: vcs0 [179.440283] Dynamic subtest vcs0: SUCCESS (0.002s) [179.451273] Starting dynamic subtest: vcs1 [179.452681] Dynamic subtest vcs1: SUCCESS (0.002s) [179.463690] Starting dynamic subtest: vecs0 [179.465316] Dynamic subtest vecs0: SUCCESS (0.002s) [179.466931] Subtest resubmit-all: SUCCESS (0.033s) [179.745988] [009/134] (867s left) kms_psr (psr-cursor-plane-onoff) [181.232865] Subtest psr-cursor-plane-onoff: SKIP (0.000s) [181.301907] [010/134] (866s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render) [182.796768] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render [182.800073] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s) [183.038889] [011/134] (864s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite) [184.533050] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite [184.536449] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [184.779263] [012/134] (863s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf) [186.278900] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (0.000s) [186.355875] [013/134] (861s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area) [187.856111] Subtest psr2-overlay-primary-update-sf-dmg-area: SKIP (0.000s) [187.920344] [014/134] (860s left) kms_pm_rpm (basic-pci-d3-state) [191.485815] Starting subtest: basic-pci-d3-state [192.707686] Subtest basic-pci-d3-state: SUCCESS (1.235s) [193.575706] [015/134] (854s left) gem_ctx_exec (basic-norecovery) [193.628579] Starting subtest: basic-norecovery [193.907149] Subtest basic-norecovery: SUCCESS (0.277s) [194.126589] [016/134] (854s left) gem_pxp (protected-encrypted-src-copy-not-readible) [196.694302] Starting subtest: protected-encrypted-src-copy-not-readible [196.697781] Subtest protected-encrypted-src-copy-not-readible: SKIP (0.000s) [196.837948] [017/134] (851s left) kms_flip (absolute-wf_vblank) [198.323668] Starting subtest: absolute-wf_vblank [198.330335] Starting dynamic subtest: A-HDMI-A4 [206.237088] Dynamic subtest A-HDMI-A4: SUCCESS (7.908s) [206.251246] Starting dynamic subtest: B-HDMI-A4 [214.085575] Dynamic subtest B-HDMI-A4: SUCCESS (7.848s) [214.098338] Starting dynamic subtest: C-HDMI-A4 [221.939105] Dynamic subtest C-HDMI-A4: SUCCESS (7.854s) [221.952279] Starting dynamic subtest: D-HDMI-A4 [229.792459] Dynamic subtest D-HDMI-A4: SUCCESS (7.854s) [229.793911] Subtest absolute-wf_vblank: SUCCESS (31.474s) [230.119885] [018/134] (818s left) prime_mmap (test_refcounting) [230.165177] Starting subtest: test_refcounting [230.166678] Starting dynamic subtest: test_refcounting-smem [230.224752] Dynamic subtest test_refcounting-smem: SUCCESS (0.061s) [230.236199] Starting dynamic subtest: test_refcounting-lmem0 [230.284699] Dynamic subtest test_refcounting-lmem0: SUCCESS (0.060s) [230.286299] Subtest test_refcounting: SUCCESS (0.121s) [230.503580] [019/134] (818s left) gem_exec_schedule (pi-common) [230.680735] Starting subtest: pi-common [230.682458] Starting dynamic subtest: rcs0 [230.712974] Dynamic subtest rcs0: SUCCESS (0.033s) [230.725034] Starting dynamic subtest: bcs0 [230.746223] Dynamic subtest bcs0: SUCCESS (0.033s) [230.758748] Starting dynamic subtest: vcs0 [230.776342] Dynamic subtest vcs0: SUCCESS (0.030s) [230.787925] Starting dynamic subtest: vcs1 [230.806840] Dynamic subtest vcs1: SUCCESS (0.030s) [230.818798] Starting dynamic subtest: vecs0 [230.837088] Dynamic subtest vecs0: SUCCESS (0.030s) [230.838655] Subtest pi-common: SUCCESS (0.158s) [231.184873] [020/134] (817s left) perf (unprivileged-single-ctx-counters) [231.376577] Starting subtest: unprivileged-single-ctx-counters [231.379285] Subtest unprivileged-single-ctx-counters: SKIP (0.000s) [231.447660] [021/134] (817s left) api_intel_allocator (fork-simple-stress-signal) [231.491847] Starting subtest: fork-simple-stress-signal [236.921940] Subtest fork-simple-stress-signal: SUCCESS (5.429s) [237.165282] [022/134] (811s left) kms_flip (flip-vs-panning-vs-hang) [238.671431] Starting subtest: flip-vs-panning-vs-hang [238.674173] Starting dynamic subtest: A-HDMI-A4 [289.946703] Dynamic subtest A-HDMI-A4: SUCCESS (51.274s) [289.958921] Starting dynamic subtest: D-HDMI-A4 [339.913244] Dynamic subtest D-HDMI-A4: SUCCESS (49.965s) [339.914593] Subtest flip-vs-panning-vs-hang: SUCCESS (101.244s) [340.187903] [023/134] (708s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf) [341.683824] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s) [341.782917] [024/134] (707s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted) [341.839201] Starting subtest: invalid-multi-wait-unsubmitted-submitted [341.840770] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.001s) [342.027903] [025/134] (707s left) gem_exec_create (basic) [342.083095] Starting subtest: basic [342.084876] Starting dynamic subtest: smem [344.176486] Dynamic subtest smem: SUCCESS (2.093s) [344.189863] Starting dynamic subtest: lmem0 [346.271867] Dynamic subtest lmem0: SUCCESS (2.095s) [346.273671] Subtest basic: SUCCESS (4.189s) [346.554379] [026/134] (702s left) gem_ctx_persistence (smoketest) [346.607512] Starting subtest: smoketest [385.083417] Subtest smoketest: SUCCESS (38.477s) [385.295075] [027/134] (663s left) gem_ctx_bad_destroy (invalid-pad) [385.339709] Starting subtest: invalid-pad [385.341197] Subtest invalid-pad: SUCCESS (0.000s) [385.554748] [028/134] (663s left) kms_cursor_legacy (cursora-vs-flipb-legacy) [387.040779] Starting subtest: cursorA-vs-flipB-legacy [387.043622] Subtest cursorA-vs-flipB-legacy: SKIP (0.002s) [387.241121] [029/134] (662s left) kms_atomic_interruptible (legacy-setmode) [388.758620] Starting subtest: legacy-setmode [388.760318] Starting dynamic subtest: pipe-A-HDMI-A-4 [394.968648] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (6.208s) [394.970217] Subtest legacy-setmode: SUCCESS (6.210s) [395.148956] [030/134] (654s left) kms_cdclk (mode-transition) [395.196344] Subtest mode-transition: SKIP (0.000s) [395.312240] [031/134] (654s left) kms_big_fb (linear-8bpp-rotate-270) [396.816721] Starting subtest: linear-8bpp-rotate-270 [396.925997] Subtest linear-8bpp-rotate-270: SKIP (0.108s) [397.146128] [032/134] (652s left) perf_pmu (faulting-read) [397.195293] Starting subtest: faulting-read [397.196844] Starting dynamic subtest: fixed [397.198342] Dynamic subtest fixed: SUCCESS (0.001s) [397.200010] Subtest faulting-read: SUCCESS (0.002s) [397.382042] [033/134] (652s left) kms_psr (fbc-psr2-primary-render) [398.869545] Subtest fbc-psr2-primary-render: SKIP (0.000s) [398.942985] [034/134] (651s left) gem_exec_schedule (deep) [399.155289] Starting subtest: deep [399.157233] Starting dynamic subtest: rcs0 [414.570949] Dynamic subtest rcs0: SUCCESS (15.412s) [414.583999] Starting dynamic subtest: bcs0 [430.314281] Dynamic subtest bcs0: SUCCESS (15.743s) [430.327574] Starting dynamic subtest: vcs0 [445.785620] Dynamic subtest vcs0: SUCCESS (15.461s) [445.800135] Starting dynamic subtest: vcs1 [462.119466] Dynamic subtest vcs1: SUCCESS (16.344s) [462.132682] Starting dynamic subtest: vecs0 [477.971941] Dynamic subtest vecs0: SUCCESS (15.852s) [477.973603] Subtest deep: SUCCESS (78.817s) [478.896725] [035/134] (571s left) kms_selftest (drm_plane_helper) [478.943132] Starting subtest: drm_plane_helper [479.030211] Starting dynamic subtest: drm_test_check_plane_state [479.106431] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.076s) [479.125593] Starting dynamic subtest: drm_test_check_invalid_plane_state [479.186086] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.073s) [479.189106] Subtest drm_plane_helper: SUCCESS (0.238s) [479.428787] [036/134] (570s left) syncobj_basic (bad-pad-fd-to-handle) [479.483596] Starting subtest: bad-pad-fd-to-handle [479.485181] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s) [479.621249] [037/134] (570s left) gem_lmem_swapping (parallel-random-engines) [484.007886] Starting subtest: parallel-random-engines [484.009302] Starting dynamic subtest: lmem0 [530.678144] Dynamic subtest lmem0: SUCCESS (46.668s) [530.679817] Subtest parallel-random-engines: SUCCESS (46.669s) [531.737829] [FACT gem_lmem_swapping (parallel-random-engines)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [531.738946] [FACT gem_lmem_swapping (parallel-random-engines)] deleted: kernel.kmod_is_loaded.i915: true [531.741583] [038/134] (518s left) kms_mmap_write_crc (main) [536.576581] Starting subtest: main [536.578205] Starting dynamic subtest: pipe-A-HDMI-A-4 [540.321729] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (3.742s) [540.323536] Subtest main: SUCCESS (3.744s) [540.577915] [FACT kms_mmap_write_crc (main)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0 [540.581317] [FACT kms_mmap_write_crc (main)] new: kernel.kmod_is_loaded.i915: true [540.584785] [039/134] (509s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite) [542.079350] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite [542.082068] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [542.346344] [040/134] (508s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [543.862251] Starting subtest: addfb25-yf-tiled-legacy [543.863914] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [544.099990] [041/134] (506s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc) [545.622605] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc [545.625922] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [545.831360] [042/134] (504s left) gem_ctx_exec (basic) [545.891390] Starting subtest: basic [545.900916] Subtest basic: SUCCESS (0.010s) [546.110469] [043/134] (504s left) kms_atomic (test-only) [547.599446] Starting subtest: test-only [547.838427] Starting dynamic subtest: pipe-A-HDMI-A-4 [548.362135] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.525s) [548.363438] Subtest test-only: SUCCESS (0.767s) [548.578933] [044/134] (502s left) gem_set_tiling_vs_gtt [548.711295] [045/134] (502s left) kms_big_fb (yf-tiled-16bpp-rotate-0) [550.214995] Starting subtest: yf-tiled-16bpp-rotate-0 [550.218323] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s) [550.428822] [046/134] (500s left) kms_getfb (getfb2-handle-zero) [551.914930] Starting subtest: getfb2-handle-zero [551.916495] Subtest getfb2-handle-zero: SUCCESS (0.000s) [552.163075] [047/134] (499s left) syncobj_timeline (single-wait-all-for-submit-available-submitted) [552.211645] Starting subtest: single-wait-all-for-submit-available-submitted [552.213201] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s) [552.379773] [048/134] (499s left) gem_exec_reloc (basic-wc-cpu) [552.436390] Subtest basic-wc-cpu: SKIP (0.000s) [552.525065] [049/134] (498s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff) [554.018218] Starting subtest: psr-1p-primscrn-spr-indfb-onoff [554.021148] Subtest psr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s) [554.183112] [050/134] (497s left) gem_basic (multigpu-create-close) [554.233221] Starting subtest: multigpu-create-close [554.236474] Subtest multigpu-create-close: SKIP (0.000s) [554.403140] [051/134] (497s left) kms_frontbuffer_tracking (fbc-suspend) [555.896033] Starting subtest: fbc-suspend [602.187313] Subtest fbc-suspend: SUCCESS (22.557s) [605.457913] [052/134] (449s left) gem_wait (wait) [605.526609] Starting subtest: wait [605.528252] Starting dynamic subtest: all-engines [606.616634] Dynamic subtest all-engines: SUCCESS (1.090s) [606.628583] Starting dynamic subtest: rcs0 [607.661442] Dynamic subtest rcs0: SUCCESS (1.043s) [607.711153] Starting dynamic subtest: bcs0 [608.723455] Dynamic subtest bcs0: SUCCESS (1.058s) [608.745561] Starting dynamic subtest: vcs0 [609.786604] Dynamic subtest vcs0: SUCCESS (1.059s) [609.808442] Starting dynamic subtest: vcs1 [610.849441] Dynamic subtest vcs1: SUCCESS (1.059s) [610.900223] Starting dynamic subtest: vecs0 [611.908965] Dynamic subtest vecs0: SUCCESS (1.057s) [611.910155] Subtest wait: SUCCESS (6.383s) [612.184980] [053/134] (442s left) gem_exec_reloc (basic-wc-active) [612.242265] Subtest basic-wc-active: SKIP (0.000s) [612.358455] [054/134] (442s left) kms_pm_rpm (pc8-residency) [616.284856] Starting subtest: pc8-residency [616.290274] Subtest pc8-residency: SKIP (0.000s) [617.306993] [055/134] (437s left) kms_dsc (dsc-with-bpc-formats) [618.798840] Starting subtest: dsc-with-bpc-formats [618.885380] Subtest dsc-with-bpc-formats: SKIP (0.005s) [619.000417] [056/134] (436s left) kms_psr (pr-cursor-plane-move) [620.491547] Subtest pr-cursor-plane-move: SKIP (0.000s) [620.572492] [057/134] (434s left) kms_vblank (ts-continuation-dpms-suspend) [622.060957] Starting subtest: ts-continuation-dpms-suspend [622.062431] Starting dynamic subtest: pipe-A-HDMI-A-4 [643.430374] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (10.109s) [643.448744] Starting dynamic subtest: pipe-D-HDMI-A-4 [665.424261] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (9.536s) [665.425753] Subtest ts-continuation-dpms-suspend: SUCCESS (19.651s) [671.617099] [058/134] (389s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled) [671.668129] Starting subtest: multi-wait-available-unsubmitted-signaled [671.670637] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.001s) [671.805265] [059/134] (389s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [673.340961] Starting subtest: basic-flip-before-cursor-legacy [674.312338] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.973s) [674.556202] [060/134] (386s left) kms_chamelium_hpd (dp-hpd-for-each-pipe) [676.088414] Subtest dp-hpd-for-each-pipe: SKIP (0.000s) [676.202269] [061/134] (385s left) gem_exec_params (invalid-flag) [676.251890] Starting subtest: invalid-flag [676.253394] Subtest invalid-flag: SUCCESS (0.000s) [676.460270] [062/134] (385s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite) [677.955011] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite [677.957705] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [678.166852] [063/134] (383s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled) [678.212830] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled [678.214250] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.001s) [678.396894] [064/134] (383s left) prime_vgem (wait) [678.473884] Starting subtest: wait [678.475489] Starting dynamic subtest: rcs0 [678.540678] Dynamic subtest rcs0: SUCCESS (0.066s) [678.553863] Starting dynamic subtest: bcs0 [678.582784] Dynamic subtest bcs0: SUCCESS (0.041s) [678.595808] Starting dynamic subtest: vcs0 [678.623966] Dynamic subtest vcs0: SUCCESS (0.040s) [678.640368] Starting dynamic subtest: vcs1 [678.662491] Dynamic subtest vcs1: SUCCESS (0.037s) [678.678965] Starting dynamic subtest: vecs0 [678.702372] Dynamic subtest vecs0: SUCCESS (0.039s) [678.704054] Subtest wait: SUCCESS (0.229s) [678.927262] [065/134] (383s left) gem_exec_capture (capture) [678.977993] Starting subtest: capture [678.979651] Starting dynamic subtest: rcs0-smem [679.864377] Dynamic subtest rcs0-smem: SUCCESS (0.885s) [679.877440] Starting dynamic subtest: rcs0-lmem0 [680.725860] Dynamic subtest rcs0-lmem0: SUCCESS (0.860s) [680.738449] Starting dynamic subtest: bcs0-smem [682.092653] Dynamic subtest bcs0-smem: SUCCESS (1.367s) [682.105278] Starting dynamic subtest: bcs0-lmem0 [683.139090] Dynamic subtest bcs0-lmem0: SUCCESS (1.046s) [683.162760] Starting dynamic subtest: vcs0-smem [684.000337] Dynamic subtest vcs0-smem: SUCCESS (0.859s) [684.012725] Starting dynamic subtest: vcs0-lmem0 [684.858339] Dynamic subtest vcs0-lmem0: SUCCESS (0.855s) [684.870650] Starting dynamic subtest: vcs1-smem [685.714517] Dynamic subtest vcs1-smem: SUCCESS (0.855s) [685.726966] Starting dynamic subtest: vcs1-lmem0 [686.570293] Dynamic subtest vcs1-lmem0: SUCCESS (0.856s) [686.582630] Starting dynamic subtest: vecs0-smem [687.995718] Dynamic subtest vecs0-smem: FAIL (1.391s) [688.007831] Starting dynamic subtest: vecs0-lmem0 [688.991248] Dynamic subtest vecs0-lmem0: FAIL (0.981s) [688.992620] Subtest capture: FAIL (9.964s) [689.114434] [066/134] (372s left) kms_cursor_crc (cursor-rapid-movement-512x512) [690.865993] Starting subtest: cursor-rapid-movement-512x512 [690.868937] Subtest cursor-rapid-movement-512x512: SKIP (0.001s) [691.184117] [067/134] (370s left) kms_flip (2x-flip-vs-wf_vblank) [692.678414] Starting subtest: 2x-flip-vs-wf_vblank [692.696511] Subtest 2x-flip-vs-wf_vblank: SKIP (0.017s) [692.914204] [068/134] (369s left) i915_pm_freq_api (freq-suspend) [692.966069] Starting subtest: freq-suspend [692.967727] Starting dynamic subtest: gt0 [709.414224] Dynamic subtest gt0: SUCCESS (1.886s) [709.415646] Subtest freq-suspend: SUCCESS (1.888s) [715.712244] [069/134] (352s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt) [717.902182] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt [717.905381] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [718.138844] [070/134] (350s left) kms_chamelium_frames (hdmi-aspect-ratio) [719.671190] Subtest hdmi-aspect-ratio: SKIP (0.000s) [719.788147] [071/134] (348s left) kms_cursor_crc (cursor-sliding-max-size) [721.582184] Starting subtest: cursor-sliding-max-size [721.586548] Subtest cursor-sliding-max-size: SKIP (0.000s) [721.843545] [072/134] (346s left) kms_color_pipeline (plane-ctm3x4-lut1d) [723.334145] Starting subtest: plane-ctm3x4-lut1d [723.371578] Starting dynamic subtest: pipe-A-HDMI-A-4 [723.787158] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.416s) [723.926404] Starting dynamic subtest: pipe-B-HDMI-A-4 [724.280706] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.365s) [724.393438] Starting dynamic subtest: pipe-C-HDMI-A-4 [724.732112] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.349s) [724.881330] Starting dynamic subtest: pipe-D-HDMI-A-4 [725.220206] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.349s) [725.292222] Subtest plane-ctm3x4-lut1d: SUCCESS (1.956s) [725.551849] [073/134] (343s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw) [727.047871] Starting subtest: psr-1p-pri-indfb-multidraw [727.051355] Subtest psr-1p-pri-indfb-multidraw: SKIP (0.000s) [727.298032] [074/134] (341s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render) [728.794403] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render [728.797477] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [729.053909] [075/134] (340s left) syncobj_timeline (invalid-query-illegal-handle) [729.102234] Starting subtest: invalid-query-illegal-handle [729.104089] Subtest invalid-query-illegal-handle: SUCCESS (0.000s) [729.303155] [076/134] (339s left) kms_ccs (crc-primary-basic-4-tiled-mtl-mc-ccs) [730.791830] Starting subtest: crc-primary-basic-4-tiled-mtl-mc-ccs [730.793477] Starting dynamic subtest: pipe-A-HDMI-A-4 [730.812150] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.001s) [730.825528] Starting dynamic subtest: pipe-B-HDMI-A-4 [730.842411] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.001s) [730.855202] Starting dynamic subtest: pipe-C-HDMI-A-4 [730.869776] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.001s) [730.882528] Starting dynamic subtest: pipe-D-HDMI-A-4 [730.896002] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.001s) [730.898659] Subtest crc-primary-basic-4-tiled-mtl-mc-ccs: SKIP (0.012s) [731.118538] [077/134] (338s left) kms_addfb_basic (too-high) [732.610583] Starting subtest: too-high [732.622290] Subtest too-high: SUCCESS (0.001s) [732.854976] [078/134] (336s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-gtt) [734.346657] Starting subtest: psr-rgb565-draw-mmap-gtt [734.349166] Subtest psr-rgb565-draw-mmap-gtt: SKIP (0.000s) [734.578949] [079/134] (335s left) gem_mmap_offset (mmap-unmap) [734.624934] Starting subtest: mmap-unmap [734.626235] Starting dynamic subtest: lmem0 [735.838827] Dynamic subtest lmem0: SUCCESS (1.212s) [735.852338] Starting dynamic subtest: smem0 [737.576166] Dynamic subtest smem0: SUCCESS (1.739s) [737.577590] Subtest mmap-unmap: SUCCESS (2.953s) [737.859270] [080/134] (331s left) gem_pread (exhaustion) [737.905562] Subtest exhaustion: SKIP (0.000s) [737.987948] [081/134] (331s left) kms_joiner (invalid-modeset-ultra-joiner) [739.476726] Starting subtest: invalid-modeset-ultra-joiner [739.479566] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s) [739.708785] [082/134] (330s left) i915_drm_fdinfo (basics) [739.758087] Starting subtest: basics [739.759571] Subtest basics: SUCCESS (0.000s) [739.925426] [083/134] (330s left) gem_ccs (ctrl-surf-copy-new-ctx) [739.975909] Starting subtest: ctrl-surf-copy-new-ctx [739.979246] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s) [740.116439] [084/134] (329s left) kms_plane (pixel-format-x-tiled-modifier-source-clamping) [741.603161] Starting subtest: pixel-format-x-tiled-modifier-source-clamping [741.643892] Starting dynamic subtest: pipe-A-plane-0 [742.760504] Dynamic subtest pipe-A-plane-0: SUCCESS (1.116s) [742.798721] Starting dynamic subtest: pipe-A-plane-3 [743.627006] Dynamic subtest pipe-A-plane-3: SUCCESS (0.864s) [743.671077] Starting dynamic subtest: pipe-A-plane-5 [744.244650] Dynamic subtest pipe-A-plane-5: SUCCESS (0.614s) [744.261725] Starting dynamic subtest: pipe-A-plane-7 [744.265254] Dynamic subtest pipe-A-plane-7: SKIP (0.000s) [744.392380] Starting dynamic subtest: pipe-B-plane-0 [745.315832] Dynamic subtest pipe-B-plane-0: SUCCESS (0.934s) [745.354429] Starting dynamic subtest: pipe-B-plane-3 [746.131588] Dynamic subtest pipe-B-plane-3: SUCCESS (0.812s) [746.170088] Starting dynamic subtest: pipe-B-plane-5 [746.766070] Dynamic subtest pipe-B-plane-5: SUCCESS (0.630s) [746.783355] Starting dynamic subtest: pipe-B-plane-7 [746.786641] Dynamic subtest pipe-B-plane-7: SKIP (0.000s) [746.822032] Subtest pixel-format-x-tiled-modifier-source-clamping: SUCCESS (5.218s) [747.127977] [085/134] (322s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff) [748.625465] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff [748.628516] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [748.874211] [086/134] (321s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling) [750.360080] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling [750.364209] Starting dynamic subtest: pipe-A-valid-mode [751.590815] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.227s) [751.592417] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SUCCESS (1.229s) [751.860276] [087/134] (318s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt) [753.359646] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt [753.363148] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [753.613659] [088/134] (316s left) kms_draw_crc (fill-fb) [755.102527] Starting subtest: fill-fb [755.658613] Subtest fill-fb: SUCCESS (0.557s) [755.878134] [089/134] (314s left) kms_big_fb (y-tiled-8bpp-rotate-0) [757.383910] Starting subtest: y-tiled-8bpp-rotate-0 [759.043828] Subtest y-tiled-8bpp-rotate-0: SUCCESS (1.659s) [759.268090] [090/134] (311s left) gem_render_copy (yf-tiled-to-vebox-linear) [759.324520] Starting subtest: yf-tiled-to-vebox-linear [759.326211] Starting dynamic subtest: smem [759.399757] Dynamic subtest smem: SUCCESS (0.077s) [759.412843] Starting dynamic subtest: lmem0 [759.524007] Dynamic subtest lmem0: SUCCESS (0.122s) [759.525811] Subtest yf-tiled-to-vebox-linear: SUCCESS (0.202s) [759.865243] [091/134] (310s left) syncobj_wait (invalid-reset-illegal-handle) [759.911829] Starting subtest: invalid-reset-illegal-handle [759.913141] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s) [760.101596] [092/134] (310s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt) [761.593953] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt [761.597475] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s) [761.853932] [093/134] (309s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [763.360767] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [763.364507] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [763.579495] [094/134] (307s left) api_intel_bb (full-batch) [763.624802] Starting subtest: full-batch [763.641077] Subtest full-batch: SUCCESS (0.018s) [763.867934] [095/134] (307s left) kms_psr (fbc-psr-basic) [765.356255] Subtest fbc-psr-basic: SKIP (0.000s) [765.438855] [096/134] (305s left) gem_exercise_blt (fast-copy-emit) [765.491420] Starting subtest: fast-copy-emit [765.493066] Starting dynamic subtest: linear-smem-smem-emit [765.524533] Dynamic subtest linear-smem-smem-emit: SUCCESS (0.032s) [765.537478] Starting dynamic subtest: linear-smem-lmem0-emit [765.541659] Dynamic subtest linear-smem-lmem0-emit: SUCCESS (0.015s) [765.554588] Starting dynamic subtest: linear-lmem0-smem-emit [765.601061] Dynamic subtest linear-lmem0-smem-emit: SUCCESS (0.059s) [765.614113] Starting dynamic subtest: linear-lmem0-lmem0-emit [765.660507] Dynamic subtest linear-lmem0-lmem0-emit: SUCCESS (0.058s) [765.673532] Starting dynamic subtest: ymajor-smem-smem-emit [765.677741] Dynamic subtest ymajor-smem-smem-emit: SUCCESS (0.015s) [765.690852] Starting dynamic subtest: ymajor-smem-lmem0-emit [765.694984] Dynamic subtest ymajor-smem-lmem0-emit: SUCCESS (0.014s) [765.708070] Starting dynamic subtest: ymajor-lmem0-smem-emit [765.764245] Dynamic subtest ymajor-lmem0-smem-emit: SUCCESS (0.059s) [765.777005] Starting dynamic subtest: ymajor-lmem0-lmem0-emit [765.813147] Dynamic subtest ymajor-lmem0-lmem0-emit: SUCCESS (0.059s) [765.825608] Starting dynamic subtest: tile4-smem-smem-emit [765.830051] Dynamic subtest tile4-smem-smem-emit: SUCCESS (0.015s) [765.842872] Starting dynamic subtest: tile4-smem-lmem0-emit [765.846495] Dynamic subtest tile4-smem-lmem0-emit: SUCCESS (0.014s) [765.859476] Starting dynamic subtest: tile4-lmem0-smem-emit [765.906230] Dynamic subtest tile4-lmem0-smem-emit: SUCCESS (0.059s) [765.919028] Starting dynamic subtest: tile4-lmem0-lmem0-emit [765.965749] Dynamic subtest tile4-lmem0-lmem0-emit: SUCCESS (0.058s) [765.978502] Starting dynamic subtest: tile64-smem-smem-emit [765.982133] Dynamic subtest tile64-smem-smem-emit: SUCCESS (0.015s) [765.994980] Starting dynamic subtest: tile64-smem-lmem0-emit [765.998731] Dynamic subtest tile64-smem-lmem0-emit: SUCCESS (0.014s) [766.011631] Starting dynamic subtest: tile64-lmem0-smem-emit [766.057695] Dynamic subtest tile64-lmem0-smem-emit: SUCCESS (0.059s) [766.070487] Starting dynamic subtest: tile64-lmem0-lmem0-emit [766.117214] Dynamic subtest tile64-lmem0-lmem0-emit: SUCCESS (0.058s) [766.118769] Subtest fast-copy-emit: SUCCESS (0.627s) [766.314665] [097/134] (305s left) sysfs_heartbeat_interval (mixed) [766.365418] Starting subtest: mixed [766.366992] Starting dynamic subtest: vecs0 [771.433679] Dynamic subtest vecs0: SUCCESS (5.066s) [771.463561] Starting dynamic subtest: vcs0 [776.759100] Dynamic subtest vcs0: SUCCESS (5.321s) [776.775871] Starting dynamic subtest: bcs0 [781.825399] Dynamic subtest bcs0: SUCCESS (5.063s) [781.842743] Starting dynamic subtest: rcs0 [787.148501] Dynamic subtest rcs0: SUCCESS (5.321s) [787.165451] Starting dynamic subtest: vcs1 [792.227628] Dynamic subtest vcs1: SUCCESS (5.075s) [792.229323] Subtest mixed: SUCCESS (25.864s) [792.415868] [098/134] (279s left) kms_cursor_legacy (cursor-vs-flip-legacy) [793.906796] Starting subtest: cursor-vs-flip-legacy [825.228480] Subtest cursor-vs-flip-legacy: SUCCESS (31.327s) [825.487722] [099/134] (246s left) gem_exec_schedule (semaphore-resolve) [825.552219] Starting subtest: semaphore-resolve [825.610794] Subtest semaphore-resolve: SUCCESS (0.061s) [826.063227] [100/134] (245s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-render) [827.587526] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-render [827.590506] Subtest fbc-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [827.850933] [101/134] (243s left) kms_cursor_legacy (torture-bo) [829.337888] Starting subtest: torture-bo [829.339449] Starting dynamic subtest: pipe-A [834.886956] Dynamic subtest pipe-A: SUCCESS (5.546s) [834.900683] Starting dynamic subtest: pipe-B [840.537490] Dynamic subtest pipe-B: SUCCESS (5.649s) [840.550880] Starting dynamic subtest: pipe-C [846.363821] Dynamic subtest pipe-C: SUCCESS (5.825s) [846.377733] Starting dynamic subtest: pipe-D [851.839141] Dynamic subtest pipe-D: SUCCESS (5.474s) [851.852617] Starting dynamic subtest: all-pipes [857.403840] Dynamic subtest all-pipes: SUCCESS (5.564s) [857.405441] Subtest torture-bo: SUCCESS (28.066s) [857.619250] [102/134] (214s left) gem_ctx_shared (q-independent) [857.676407] Starting subtest: Q-independent [857.678005] Starting dynamic subtest: rcs0 [857.834127] Dynamic subtest rcs0: SUCCESS (0.156s) [857.847762] Starting dynamic subtest: bcs0 [857.932291] Dynamic subtest bcs0: SUCCESS (0.097s) [857.947431] Starting dynamic subtest: vcs0 [858.029525] Dynamic subtest vcs0: SUCCESS (0.096s) [858.042738] Starting dynamic subtest: vcs1 [858.135816] Dynamic subtest vcs1: SUCCESS (0.105s) [858.149183] Starting dynamic subtest: vecs0 [858.241435] Dynamic subtest vecs0: SUCCESS (0.104s) [858.243144] Subtest Q-independent: SUCCESS (0.566s) [858.593348] [103/134] (213s left) gem_exec_fence (syncobj-timeline-invalid-wait) [859.170964] Starting subtest: syncobj-timeline-invalid-wait [859.172757] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.003s) [859.556492] [104/134] (212s left) gem_render_copy (y-tiled-ccs-to-x-tiled) [859.610908] Starting subtest: y-tiled-ccs-to-x-tiled [859.612348] Starting dynamic subtest: smem [859.697227] Dynamic subtest smem: SUCCESS (0.088s) [859.710353] Starting dynamic subtest: lmem0 [860.624901] Dynamic subtest lmem0: SUCCESS (0.923s) [860.626533] Subtest y-tiled-ccs-to-x-tiled: SUCCESS (1.013s) [860.951350] [105/134] (211s left) drm_read (short-buffer-wakeup) [862.491583] Starting subtest: short-buffer-wakeup [894.703815] Subtest short-buffer-wakeup: SUCCESS (32.214s) [894.990253] [106/134] (177s left) kms_atomic_transition (plane-use-after-nonblocking-unbind-fencing) [896.478455] Starting subtest: plane-use-after-nonblocking-unbind-fencing [896.480174] Starting dynamic subtest: pipe-A-HDMI-A-4 [896.569461] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.092s) [896.639332] Starting dynamic subtest: pipe-B-HDMI-A-4 [896.815149] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.188s) [896.839052] Subtest plane-use-after-nonblocking-unbind-fencing: SUCCESS (0.363s) [897.028124] [107/134] (175s left) syncobj_timeline (device-submit-unordered) [897.075497] Starting subtest: device-submit-unordered [897.076847] Subtest device-submit-unordered: SUCCESS (0.000s) [897.288488] [108/134] (175s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs) [898.775118] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs [898.776833] Starting dynamic subtest: pipe-A-HDMI-A-4 [898.828509] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.003s) [898.841462] Starting dynamic subtest: pipe-B-HDMI-A-4 [898.878238] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.003s) [898.891253] Starting dynamic subtest: pipe-C-HDMI-A-4 [898.933214] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.003s) [898.946282] Starting dynamic subtest: pipe-D-HDMI-A-4 [898.994249] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.003s) [898.998269] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SKIP (0.021s) [899.100909] [109/134] (173s left) kms_pipe_crc_basic (nonblocking-crc) [900.589023] Starting subtest: nonblocking-crc [900.590600] Starting dynamic subtest: pipe-A-HDMI-A-4 [901.348455] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.759s) [901.373141] Starting dynamic subtest: pipe-B-HDMI-A-4 [901.944652] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.594s) [901.960250] Starting dynamic subtest: pipe-C-HDMI-A-4 [902.511263] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.563s) [902.527532] Starting dynamic subtest: pipe-D-HDMI-A-4 [903.119681] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.605s) [903.121065] Subtest nonblocking-crc: SUCCESS (2.533s) [903.334265] [110/134] (169s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt) [904.826812] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt [904.829598] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [905.087289] [111/134] (167s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt) [906.579295] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt [906.582030] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [906.845432] [112/134] (166s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping) [908.333514] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping [908.368359] Starting dynamic subtest: pipe-A-plane-0 [908.371862] Dynamic subtest pipe-A-plane-0: SKIP (0.000s) [908.385492] Starting dynamic subtest: pipe-A-plane-3 [908.388841] Dynamic subtest pipe-A-plane-3: SKIP (0.000s) [908.402518] Starting dynamic subtest: pipe-A-plane-5 [908.405977] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [908.430485] Starting dynamic subtest: pipe-A-plane-7 [908.433408] Dynamic subtest pipe-A-plane-7: SKIP (0.000s) [908.535005] Starting dynamic subtest: pipe-B-plane-0 [908.538104] Dynamic subtest pipe-B-plane-0: SKIP (0.000s) [908.551266] Starting dynamic subtest: pipe-B-plane-3 [908.554204] Dynamic subtest pipe-B-plane-3: SKIP (0.000s) [908.567426] Starting dynamic subtest: pipe-B-plane-5 [908.570352] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [908.585031] Starting dynamic subtest: pipe-B-plane-7 [908.587962] Dynamic subtest pipe-B-plane-7: SKIP (0.000s) [908.590880] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier-source-clamping: SKIP (0.230s) [908.751305] [113/134] (164s left) kms_plane_scaling (plane-downscale-factor-0-5-with-rotation) [910.237789] Starting subtest: plane-downscale-factor-0-5-with-rotation [910.239193] Starting dynamic subtest: pipe-A [910.766204] Dynamic subtest pipe-A: SKIP (0.522s) [910.778896] Starting dynamic subtest: pipe-B [911.235708] Dynamic subtest pipe-B: SKIP (0.469s) [911.248870] Starting dynamic subtest: pipe-C [911.713231] Dynamic subtest pipe-C: SKIP (0.475s) [911.726642] Starting dynamic subtest: pipe-D [912.189594] Dynamic subtest pipe-D: SKIP (0.474s) [912.192617] Subtest plane-downscale-factor-0-5-with-rotation: SKIP (1.946s) [912.416127] [114/134] (160s left) perf_pmu (busy-hang) [912.472731] Starting subtest: busy-hang [912.474463] Starting dynamic subtest: rcs0 [913.716563] Dynamic subtest rcs0: SUCCESS (1.243s) [913.730574] Starting dynamic subtest: bcs0 [914.911401] Dynamic subtest bcs0: SUCCESS (1.192s) [914.928066] Starting dynamic subtest: vcs0 [916.109146] Dynamic subtest vcs0: SUCCESS (1.194s) [916.125417] Starting dynamic subtest: vcs1 [917.307520] Dynamic subtest vcs1: SUCCESS (1.190s) [917.321866] Starting dynamic subtest: vecs0 [918.501731] Dynamic subtest vecs0: SUCCESS (1.196s) [918.505941] Subtest busy-hang: SUCCESS (6.032s) [918.665636] [115/134] (154s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs) [920.157233] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs [920.158631] Starting dynamic subtest: pipe-A-HDMI-A-4 [920.171544] Dynamic subtest pipe-A-HDMI-A-4: SKIP (0.001s) [920.185549] Starting dynamic subtest: pipe-B-HDMI-A-4 [920.201493] Dynamic subtest pipe-B-HDMI-A-4: SKIP (0.001s) [920.214945] Starting dynamic subtest: pipe-C-HDMI-A-4 [920.228804] Dynamic subtest pipe-C-HDMI-A-4: SKIP (0.001s) [920.242197] Starting dynamic subtest: pipe-D-HDMI-A-4 [920.257739] Dynamic subtest pipe-D-HDMI-A-4: SKIP (0.001s) [920.260664] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SKIP (0.014s) [920.482685] [116/134] (152s left) kms_cursor_crc (cursor-offscreen-128x42) [922.167641] Starting subtest: cursor-offscreen-128x42 [922.175601] Starting dynamic subtest: pipe-A-HDMI-A-4 [924.700833] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (2.526s) [924.739858] Starting dynamic subtest: pipe-D-HDMI-A-4 [927.119285] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (2.391s) [927.120875] Subtest cursor-offscreen-128x42: SUCCESS (4.951s) [927.533047] [117/134] (145s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75) [929.021409] Starting subtest: planes-upscale-20x20-downscale-factor-0-75 [929.023126] Starting dynamic subtest: pipe-A [929.146551] Dynamic subtest pipe-A: SUCCESS (0.128s) [929.162496] Starting dynamic subtest: pipe-B [929.287419] Dynamic subtest pipe-B: SUCCESS (0.139s) [929.301480] Starting dynamic subtest: pipe-C [929.429341] Dynamic subtest pipe-C: SUCCESS (0.140s) [929.443223] Starting dynamic subtest: pipe-D [929.571517] Dynamic subtest pipe-D: SUCCESS (0.141s) [929.573123] Subtest planes-upscale-20x20-downscale-factor-0-75: SUCCESS (0.554s) [929.801190] [118/134] (143s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-0) [931.307444] Starting subtest: linear-max-hw-stride-64bpp-rotate-0 [932.414420] Subtest linear-max-hw-stride-64bpp-rotate-0: SUCCESS (1.104s) [932.663969] [119/134] (140s left) syncobj_basic (bad-pad-handle-to-fd) [932.709854] Starting subtest: bad-pad-handle-to-fd [932.711432] Subtest bad-pad-handle-to-fd: SUCCESS (0.000s) [932.920546] [120/134] (140s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions) [934.419947] Starting subtest: cursorA-vs-flipB-atomic-transitions [934.423545] Subtest cursorA-vs-flipB-atomic-transitions: SKIP (0.002s) [934.634096] [121/134] (139s left) kms_frontbuffer_tracking (psr-2p-rte) [936.126855] Starting subtest: psr-2p-rte [936.129736] Subtest psr-2p-rte: SKIP (0.000s) [936.381267] [122/134] (137s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary) [937.874547] Starting subtest: psr-shrfb-scaledprimary [937.878353] Subtest psr-shrfb-scaledprimary: SKIP (0.000s) [938.093126] [123/134] (136s left) gen7_exec_parse (cmd-crossing-page) [938.145254] Subtest cmd-crossing-page: SKIP (0.000s) [938.225725] [124/134] (136s left) kms_frontbuffer_tracking (fbc-1p-rte) [939.729476] Starting subtest: fbc-1p-rte [943.229499] Subtest fbc-1p-rte: SUCCESS (3.504s) [943.486642] [125/134] (130s left) gem_mmap_wc (write) [943.535119] Subtest write: SKIP (0.000s) [943.608837] [126/134] (130s left) kms_busy (extended-modeset-hang-newfb) [945.102568] Starting subtest: extended-modeset-hang-newfb [945.104039] Starting dynamic subtest: pipe-A [960.671261] Dynamic subtest pipe-A: SUCCESS (15.569s) [960.688770] Starting dynamic subtest: pipe-D [976.205107] Dynamic subtest pipe-D: SUCCESS (15.527s) [976.206726] Subtest extended-modeset-hang-newfb: SUCCESS (31.105s) [976.477271] [127/134] ( 97s left) i915_pm_rpm (gem-evict-pwrite) [980.616685] Starting subtest: gem-evict-pwrite [980.621610] Subtest gem-evict-pwrite: SKIP (0.000s) [981.576809] [128/134] ( 92s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs) [983.072226] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs [983.073919] Starting dynamic subtest: pipe-A-HDMI-A-4 [983.091006] Dynamic subtest pipe-A-HDMI-A-4: SUCCESS (0.001s) [983.105428] Starting dynamic subtest: pipe-B-HDMI-A-4 [983.120387] Dynamic subtest pipe-B-HDMI-A-4: SUCCESS (0.001s) [983.134071] Starting dynamic subtest: pipe-C-HDMI-A-4 [983.149018] Dynamic subtest pipe-C-HDMI-A-4: SUCCESS (0.001s) [983.163160] Starting dynamic subtest: pipe-D-HDMI-A-4 [983.179520] Dynamic subtest pipe-D-HDMI-A-4: SUCCESS (0.001s) [983.181283] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SUCCESS (0.013s) [983.402326] [129/134] ( 91s left) i915_suspend (basic-s2idle-without-i915) [983.447462] Starting subtest: basic-s2idle-without-i915 [1003.749088] Subtest basic-s2idle-without-i915: SUCCESS (5.685s) [1005.839777] [130/134] ( 70s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling) [1007.331459] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling [1007.332749] Starting dynamic subtest: pipe-A-valid-mode [1008.495614] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.164s) [1008.496919] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (1.166s) [1008.724821] [131/134] ( 68s left) kms_big_fb (4-tiled-addfb) [1010.542287] Starting subtest: 4-tiled-addfb [1010.545594] Subtest 4-tiled-addfb: SKIP (0.000s) [1010.808889] [132/134] ( 66s left) kms_setmode (basic-clone-single-crtc) [1010.855923] Starting subtest: basic-clone-single-crtc [1010.861372] Subtest basic-clone-single-crtc: SKIP (0.000s) [1011.015941] [133/134] ( 66s left) gem_exec_balancer (full-late-pulse) [1011.076099] Starting subtest: full-late-pulse [1013.490260] Subtest full-late-pulse: SUCCESS (2.415s) [1013.986549] [134/134] ( 63s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render) [1015.478708] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render [1015.482378] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [1015.731079] Closing watchdogs results: parsing output: 0/ for test: kms_frontbuffer_tracking results: parsing output: 1/ for test: gem_exec_params results: parsing output: 2/ for test: tools_test results: parsing output: 3/ for test: kms_selftest results: parsing output: 4/ for test: gem_exec_suspend results: parsing output: 5/ for test: kms_content_protection results: parsing output: 6/ for test: gem_eio results: parsing output: 7/ for test: gem_spin_batch results: parsing output: 8/ for test: kms_psr results: parsing output: 9/ for test: kms_frontbuffer_tracking results: parsing output: 10/ for test: kms_frontbuffer_tracking results: parsing output: 11/ for test: kms_psr2_sf results: parsing output: 12/ for test: kms_psr2_sf results: parsing output: 13/ for test: kms_pm_rpm results: parsing output: 14/ for test: gem_ctx_exec results: parsing output: 15/ for test: gem_pxp results: parsing output: 16/ for test: kms_flip results: parsing output: 17/ for test: prime_mmap results: parsing output: 18/ for test: gem_exec_schedule results: parsing output: 19/ for test: perf results: parsing output: 20/ for test: api_intel_allocator results: parsing output: 21/ for test: kms_flip results: parsing output: 22/ for test: kms_psr2_sf results: parsing output: 23/ for test: syncobj_wait results: parsing output: 24/ for test: gem_exec_create results: parsing output: 25/ for test: gem_ctx_persistence results: parsing output: 26/ for test: gem_ctx_bad_destroy results: parsing output: 27/ for test: kms_cursor_legacy results: parsing output: 28/ for test: kms_atomic_interruptible results: parsing output: 29/ for test: kms_cdclk results: parsing output: 30/ for test: kms_big_fb results: parsing output: 31/ for test: perf_pmu results: parsing output: 32/ for test: kms_psr results: parsing output: 33/ for test: gem_exec_schedule results: parsing output: 34/ for test: kms_selftest results: parsing output: 35/ for test: syncobj_basic results: parsing output: 36/ for test: gem_lmem_swapping results: parsing output: 37/ for test: kms_mmap_write_crc results: parsing output: 38/ for test: kms_frontbuffer_tracking results: parsing output: 39/ for test: kms_addfb_basic results: parsing output: 40/ for test: kms_frontbuffer_tracking results: parsing output: 41/ for test: gem_ctx_exec results: parsing output: 42/ for test: kms_atomic results: parsing output: 43/ for test: gem_set_tiling_vs_gtt results: parsing output: 44/ for test: kms_big_fb results: parsing output: 45/ for test: kms_getfb results: parsing output: 46/ for test: syncobj_timeline results: parsing output: 47/ for test: gem_exec_reloc results: parsing output: 48/ for test: kms_frontbuffer_tracking results: parsing output: 49/ for test: gem_basic results: parsing output: 50/ for test: kms_frontbuffer_tracking results: parsing output: 51/ for test: gem_wait results: parsing output: 52/ for test: gem_exec_reloc results: parsing output: 53/ for test: kms_pm_rpm results: parsing output: 54/ for test: kms_dsc results: parsing output: 55/ for test: kms_psr results: parsing output: 56/ for test: kms_vblank results: parsing output: 57/ for test: syncobj_timeline results: parsing output: 58/ for test: kms_cursor_legacy results: parsing output: 59/ for test: kms_chamelium_hpd results: parsing output: 60/ for test: gem_exec_params results: parsing output: 61/ for test: kms_frontbuffer_tracking results: parsing output: 62/ for test: syncobj_timeline results: parsing output: 63/ for test: prime_vgem results: parsing output: 64/ for test: gem_exec_capture results: parsing output: 65/ for test: kms_cursor_crc results: parsing output: 66/ for test: kms_flip results: parsing output: 67/ for test: i915_pm_freq_api results: parsing output: 68/ for test: kms_frontbuffer_tracking results: parsing output: 69/ for test: kms_chamelium_frames results: parsing output: 70/ for test: kms_cursor_crc results: parsing output: 71/ for test: kms_color_pipeline results: parsing output: 72/ for test: kms_frontbuffer_tracking results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: syncobj_timeline results: parsing output: 75/ for test: kms_ccs results: parsing output: 76/ for test: kms_addfb_basic results: parsing output: 77/ for test: kms_frontbuffer_tracking results: parsing output: 78/ for test: gem_mmap_offset results: parsing output: 79/ for test: gem_pread results: parsing output: 80/ for test: kms_joiner results: parsing output: 81/ for test: i915_drm_fdinfo results: parsing output: 82/ for test: gem_ccs results: parsing output: 83/ for test: kms_plane results: parsing output: 84/ for test: kms_frontbuffer_tracking results: parsing output: 85/ for test: kms_flip_scaled_crc results: parsing output: 86/ for test: kms_frontbuffer_tracking results: parsing output: 87/ for test: kms_draw_crc results: parsing output: 88/ for test: kms_big_fb results: parsing output: 89/ for test: gem_render_copy results: parsing output: 90/ for test: syncobj_wait results: parsing output: 91/ for test: kms_frontbuffer_tracking results: parsing output: 92/ for test: kms_big_fb results: parsing output: 93/ for test: api_intel_bb results: parsing output: 94/ for test: kms_psr results: parsing output: 95/ for test: gem_exercise_blt results: parsing output: 96/ for test: sysfs_heartbeat_interval results: parsing output: 97/ for test: kms_cursor_legacy results: parsing output: 98/ for test: gem_exec_schedule results: parsing output: 99/ for test: kms_frontbuffer_tracking results: parsing output: 100/ for test: kms_cursor_legacy results: parsing output: 101/ for test: gem_ctx_shared results: parsing output: 102/ for test: gem_exec_fence results: parsing output: 103/ for test: gem_render_copy results: parsing output: 104/ for test: drm_read results: parsing output: 105/ for test: kms_atomic_transition results: parsing output: 106/ for test: syncobj_timeline results: parsing output: 107/ for test: kms_ccs results: parsing output: 108/ for test: kms_pipe_crc_basic results: parsing output: 109/ for test: kms_frontbuffer_tracking results: parsing output: 110/ for test: kms_frontbuffer_tracking results: parsing output: 111/ for test: kms_plane results: parsing output: 112/ for test: kms_plane_scaling results: parsing output: 113/ for test: perf_pmu results: parsing output: 114/ for test: kms_ccs results: parsing output: 115/ for test: kms_cursor_crc results: parsing output: 116/ for test: kms_plane_scaling results: parsing output: 117/ for test: kms_big_fb results: parsing output: 118/ for test: syncobj_basic results: parsing output: 119/ for test: kms_cursor_legacy results: parsing output: 120/ for test: kms_frontbuffer_tracking results: parsing output: 121/ for test: kms_frontbuffer_tracking results: parsing output: 122/ for test: gen7_exec_parse results: parsing output: 123/ for test: kms_frontbuffer_tracking results: parsing output: 124/ for test: gem_mmap_wc results: parsing output: 125/ for test: kms_busy results: parsing output: 126/ for test: i915_pm_rpm results: parsing output: 127/ for test: kms_ccs results: parsing output: 128/ for test: i915_suspend results: parsing output: 129/ for test: kms_flip_scaled_crc results: parsing output: 130/ for test: kms_big_fb results: parsing output: 131/ for test: kms_setmode results: parsing output: 132/ for test: gem_exec_balancer results: parsing output: 133/ for test: kms_frontbuffer_tracking Done.