[59.471671] Initializing watchdogs [59.471721] /dev/watchdog0 [59.485483] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [59.490028] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [59.492362] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [59.495901] [001/133] (960s left) kms_rotation_crc (primary-x-tiled-reflect-x-0) [59.617721] Starting subtest: primary-x-tiled-reflect-x-0 [66.500918] Subtest primary-x-tiled-reflect-x-0: SUCCESS (6.878s) [67.723748] [002/133] (952s left) gem_exec_balancer (full-late) [67.849662] Starting subtest: full-late [72.763364] Subtest full-late: SUCCESS (4.912s) [73.092595] [003/133] (946s left) gem_exec_reloc (basic-cpu-wc-active) [73.149248] Subtest basic-cpu-wc-active: SKIP (0.000s) [73.230899] [004/133] (946s left) kms_atomic_transition (modeset-transition-nonblocking) [73.323738] Starting subtest: modeset-transition-nonblocking [73.325923] Starting dynamic subtest: 1x-outputs [84.417468] Dynamic subtest 1x-outputs: SUCCESS (11.092s) [84.419956] Subtest modeset-transition-nonblocking: SUCCESS (11.092s) [85.303978] [005/133] (934s left) kms_selftest (drm_cmdline_parser) [85.339563] Starting subtest: drm_cmdline_parser [85.374511] Starting dynamic subtest: drm_test_cmdline_force_d_only [85.521472] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.148s) [85.534426] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi [85.662438] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.140s) [85.675110] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi [85.806218] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.143s) [85.814984] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital [85.951131] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.145s) [85.960037] Starting dynamic subtest: drm_test_cmdline_force_e_only [86.102205] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.151s) [86.111399] Starting dynamic subtest: drm_test_cmdline_res [86.240211] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.138s) [86.249398] Starting dynamic subtest: drm_test_cmdline_res_vesa [86.368242] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.128s) [86.377286] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank [86.536440] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.169s) [86.546052] Starting dynamic subtest: drm_test_cmdline_res_rblank [86.689384] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.151s) [86.698775] Starting dynamic subtest: drm_test_cmdline_res_bpp [86.829620] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.140s) [86.837935] Starting dynamic subtest: drm_test_cmdline_res_refresh [86.976095] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.147s) [86.982992] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh [87.129470] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.153s) [87.138113] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced [87.281340] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.152s) [87.290598] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins [87.437394] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.156s) [87.446559] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off [87.584261] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.146s) [87.593291] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on [87.745154] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.161s) [87.751967] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog [87.899354] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.154s) [87.908820] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital [88.060491] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.160s) [88.067580] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on [88.223371] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.163s) [88.232148] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on [88.369397] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.145s) [88.377803] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins [88.508309] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.139s) [88.517706] Starting dynamic subtest: drm_test_cmdline_name [88.662276] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.154s) [88.671786] Starting dynamic subtest: drm_test_cmdline_name_bpp [88.810921] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.148s) [88.818243] Starting dynamic subtest: drm_test_cmdline_name_option [88.959297] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.148s) [88.968463] Starting dynamic subtest: drm_test_cmdline_name_bpp_option [89.113304] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.153s) [89.122611] Starting dynamic subtest: drm_test_cmdline_rotate_0 [89.247084] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.134s) [89.254124] Starting dynamic subtest: drm_test_cmdline_rotate_90 [89.399427] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.151s) [89.408513] Starting dynamic subtest: drm_test_cmdline_rotate_180 [89.554464] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.155s) [89.562215] Starting dynamic subtest: drm_test_cmdline_rotate_270 [89.695257] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.140s) [89.704194] Starting dynamic subtest: drm_test_cmdline_hmirror [89.846344] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.151s) [89.855636] Starting dynamic subtest: drm_test_cmdline_vmirror [90.004788] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.158s) [90.014516] Starting dynamic subtest: drm_test_cmdline_margin_options [90.169197] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.164s) [90.178165] Starting dynamic subtest: drm_test_cmdline_multiple_options [90.325550] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.156s) [90.334552] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option [90.481247] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.155s) [90.490269] Starting dynamic subtest: drm_test_cmdline_extra_and_option [90.627214] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.145s) [90.636142] Starting dynamic subtest: drm_test_cmdline_freestanding_options [90.779190] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.152s) [90.787546] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options [90.927248] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.148s) [90.936676] Starting dynamic subtest: drm_test_cmdline_panel_orientation [91.069497] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.142s) [91.077315] Starting dynamic subtest: drm_test_cmdline_invalid [91.207694] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.138s) [91.215842] Starting dynamic subtest: drm_test_cmdline_tv_options [91.394185] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.161s) [91.398181] Subtest drm_cmdline_parser: SUCCESS (6.029s) [91.575730] [006/133] (928s left) kms_busy (extended-pageflip-modeset-hang-oldfb) [91.687722] Starting subtest: extended-pageflip-modeset-hang-oldfb [91.690098] Starting dynamic subtest: pipe-A [99.581624] Dynamic subtest pipe-A: SUCCESS (7.892s) [99.592988] Starting dynamic subtest: pipe-D [108.190455] Dynamic subtest pipe-D: SUCCESS (8.605s) [108.192643] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.502s) [109.069628] [007/133] (911s left) gen7_exec_parse (bitmasks) [109.140550] Subtest bitmasks: SKIP (0.000s) [109.220094] [008/133] (911s left) gem_ctx_persistence (smoketest) [109.286590] Starting subtest: smoketest [149.816520] Subtest smoketest: SUCCESS (40.527s) [149.902698] [009/133] (870s left) kms_draw_crc (draw-method-mmap-gtt) [150.005115] Starting subtest: draw-method-mmap-gtt [150.009795] Subtest draw-method-mmap-gtt: SKIP (0.000s) [150.094685] [010/133] (870s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render) [150.187993] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render [157.410441] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.226s) [157.568841] [011/133] (862s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf) [157.682807] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf [157.687272] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s) [157.757390] [012/133] (862s left) gem_exec_whisper (basic-fds-forked) [157.836686] Starting subtest: basic-fds-forked [180.939321] Subtest basic-fds-forked: SUCCESS (23.100s) [181.136097] [013/133] (839s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling) [181.243935] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling [181.248526] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s) [181.325335] [014/133] (839s left) kms_chamelium_frames (vga-frame-dump) [181.705505] Subtest vga-frame-dump: SKIP (0.000s) [182.479610] [015/133] (838s left) kms_frontbuffer_tracking (fbcpsr-shrfb-scaledprimary) [182.585646] Starting subtest: fbcpsr-shrfb-scaledprimary [188.389083] Subtest fbcpsr-shrfb-scaledprimary: SUCCESS (5.808s) [188.553334] [016/133] (832s left) kms_psr (psr2-primary-mmap-cpu) [188.647848] Starting subtest: psr2-primary-mmap-cpu [188.650023] Starting dynamic subtest: eDP-1 [190.407427] Dynamic subtest eDP-1: SUCCESS (1.760s) [190.409752] Subtest psr2-primary-mmap-cpu: SUCCESS (1.761s) [191.309232] [017/133] (829s left) kms_psr (fbc-psr2-cursor-render) [191.415750] Starting subtest: fbc-psr2-cursor-render [191.417688] Starting dynamic subtest: eDP-1 [191.421773] Dynamic subtest eDP-1: SKIP (0.000s) [191.425859] Subtest fbc-psr2-cursor-render: SKIP (0.001s) [191.495405] [018/133] (829s left) kms_ccs (bad-aux-stride-yf-tiled-ccs) [191.610194] Starting subtest: bad-aux-stride-yf-tiled-ccs [191.612510] Starting dynamic subtest: pipe-A-eDP-1 [191.635713] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [191.645915] Starting dynamic subtest: pipe-B-eDP-1 [191.667957] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [191.675834] Starting dynamic subtest: pipe-C-eDP-1 [191.696169] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [191.703176] Starting dynamic subtest: pipe-D-eDP-1 [191.725389] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [191.729736] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.005s) [193.891955] [019/133] (826s left) vgem_basic (dmabuf-mmap) [194.025255] Starting subtest: dmabuf-mmap [194.043364] Subtest dmabuf-mmap: SUCCESS (0.022s) [194.112948] [FACT vgem_basic (dmabuf-mmap)] new: kernel.kmod_is_loaded.vgem: true [194.116154] [020/133] (826s left) kms_flip (plain-flip-interruptible) [194.211855] Starting subtest: plain-flip-interruptible [194.214225] Starting dynamic subtest: A-eDP1 [195.867797] Dynamic subtest A-eDP1: SUCCESS (1.654s) [195.881266] Starting dynamic subtest: B-eDP1 [197.498351] Dynamic subtest B-eDP1: SUCCESS (1.629s) [197.512835] Starting dynamic subtest: C-eDP1 [199.118532] Dynamic subtest C-eDP1: SUCCESS (1.618s) [199.127836] Starting dynamic subtest: D-eDP1 [200.753632] Dynamic subtest D-eDP1: SUCCESS (1.635s) [200.758502] Subtest plain-flip-interruptible: SUCCESS (6.545s) [201.937322] [021/133] (818s left) gem_softpin (allocator-fork) [201.997696] Starting subtest: allocator-fork [204.211549] Subtest allocator-fork: SUCCESS (2.213s) [204.367427] [022/133] (816s left) gem_eio (context-create) [204.599053] Starting subtest: context-create [204.935151] Subtest context-create: SUCCESS (0.335s) [205.097868] [023/133] (815s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt) [205.205620] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt [205.209792] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [205.338846] [024/133] (815s left) kms_fbcon_fbt (psr) [205.403364] Starting subtest: psr [212.732896] Subtest psr: SUCCESS (7.325s) [212.817059] [025/133] (808s left) vgem_basic (bad-fence) [212.861404] Starting subtest: bad-fence [212.863580] Subtest bad-fence: SUCCESS (0.000s) [212.933080] [026/133] (808s left) kms_vblank (crtc-id) [213.026860] Starting subtest: crtc-id [213.028695] Starting dynamic subtest: pipe-A-eDP-1 [213.483708] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.457s) [213.497355] Starting dynamic subtest: pipe-D-eDP-1 [214.607743] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.122s) [214.609939] Subtest crtc-id: SUCCESS (1.582s) [215.438684] [027/133] (805s left) i915_drm_fdinfo (isolation) [215.481412] Starting subtest: isolation [215.483677] Starting dynamic subtest: rcs0 [215.525061] Dynamic subtest rcs0: SKIP (0.042s) [215.535589] Starting dynamic subtest: bcs0 [215.539736] Dynamic subtest bcs0: SKIP (0.001s) [215.547777] Starting dynamic subtest: vcs0 [215.551793] Dynamic subtest vcs0: SKIP (0.000s) [215.560109] Starting dynamic subtest: vcs1 [215.564282] Dynamic subtest vcs1: SKIP (0.000s) [215.572441] Starting dynamic subtest: vecs0 [215.576810] Dynamic subtest vecs0: SKIP (0.000s) [215.584958] Starting dynamic subtest: ccs0 [215.589219] Dynamic subtest ccs0: SKIP (0.000s) [215.593517] Subtest isolation: SKIP (0.047s) [215.630180] [028/133] (805s left) gem_partial_pwrite_pread (write-uncached) [215.687259] Subtest write-uncached: SKIP (0.000s) [215.764675] [029/133] (805s left) kms_addfb_basic (bad-pitch-63) [215.829060] Starting subtest: bad-pitch-63 [215.831058] Subtest bad-pitch-63: SUCCESS (0.000s) [215.962746] [030/133] (805s left) kms_big_fb (linear-8bpp-rotate-270) [216.076534] Starting subtest: linear-8bpp-rotate-270 [216.099971] Subtest linear-8bpp-rotate-270: SKIP (0.022s) [216.225402] [031/133] (804s left) kms_pm_rpm (pc8-residency) [218.061380] Starting subtest: pc8-residency [218.066124] Subtest pc8-residency: SKIP (0.000s) [218.486471] [032/133] (802s left) kms_setmode (basic) [218.547410] Starting subtest: basic [218.874854] Starting dynamic subtest: pipe-A-eDP-1 [220.976277] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.096s) [221.317919] Starting dynamic subtest: pipe-B-eDP-1 [223.405570] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.090s) [223.718409] Subtest basic: SUCCESS (5.170s) [224.560268] [033/133] (796s left) syncobj_wait (invalid-reset-one-illegal-handle) [224.624281] Starting subtest: invalid-reset-one-illegal-handle [224.626692] Subtest invalid-reset-one-illegal-handle: SUCCESS (0.000s) [224.728747] [034/133] (796s left) sriov_basic (enable-vfs-autoprobe-off) [224.781448] Starting subtest: enable-vfs-autoprobe-off [224.783775] Starting dynamic subtest: numvfs-1 [224.859129] Dynamic subtest numvfs-1: FAIL (0.015s) [224.870234] Starting dynamic subtest: numvfs-2 [224.946607] Dynamic subtest numvfs-2: FAIL (0.003s) [224.956963] Starting dynamic subtest: numvfs-3 [225.032064] Dynamic subtest numvfs-3: FAIL (0.003s) [225.040909] Starting dynamic subtest: numvfs-4 [225.109567] Dynamic subtest numvfs-4: FAIL (0.003s) [225.118320] Starting dynamic subtest: numvfs-5 [225.187663] Dynamic subtest numvfs-5: FAIL (0.003s) [225.195720] Starting dynamic subtest: numvfs-6 [225.268080] Dynamic subtest numvfs-6: FAIL (0.004s) [225.278481] Starting dynamic subtest: numvfs-7 [225.350691] Dynamic subtest numvfs-7: FAIL (0.003s) [225.358651] Starting dynamic subtest: numvfs-random [225.430444] Dynamic subtest numvfs-random: FAIL (0.003s) [225.440354] Starting dynamic subtest: numvfs-all [225.505553] Dynamic subtest numvfs-all: FAIL (0.506s) [225.507422] Subtest enable-vfs-autoprobe-off: FAIL (0.550s) [225.541907] [035/133] (795s left) kms_color (invalid-ctm-matrix-sizes) [225.634252] Starting subtest: invalid-ctm-matrix-sizes [225.636080] Starting dynamic subtest: pipe-A [225.637994] Dynamic subtest pipe-A: SUCCESS (0.002s) [225.645795] Starting dynamic subtest: pipe-B [225.647697] Dynamic subtest pipe-B: SUCCESS (0.002s) [225.655162] Starting dynamic subtest: pipe-C [225.656949] Dynamic subtest pipe-C: SUCCESS (0.003s) [225.664495] Starting dynamic subtest: pipe-D [225.666046] Dynamic subtest pipe-D: SUCCESS (0.003s) [225.667620] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.013s) [225.725366] [036/133] (795s left) kms_cursor_crc (cursor-random-32x32) [225.866213] Starting subtest: cursor-random-32x32 [225.908631] Subtest cursor-random-32x32: SKIP (0.038s) [226.214811] [037/133] (795s left) gem_exec_schedule (preempt) [226.280099] Starting subtest: preempt [226.281826] Starting dynamic subtest: rcs0 [226.297540] Dynamic subtest rcs0: SUCCESS (0.022s) [226.305501] Starting dynamic subtest: bcs0 [226.315632] Dynamic subtest bcs0: SUCCESS (0.017s) [226.323377] Starting dynamic subtest: vcs0 [226.336569] Dynamic subtest vcs0: SUCCESS (0.021s) [226.344306] Starting dynamic subtest: vcs1 [226.356820] Dynamic subtest vcs1: SUCCESS (0.020s) [226.366947] Starting dynamic subtest: vecs0 [226.379241] Dynamic subtest vecs0: SUCCESS (0.022s) [226.392165] Starting dynamic subtest: ccs0 [226.405778] Dynamic subtest ccs0: SUCCESS (0.024s) [226.409557] Subtest preempt: SUCCESS (0.129s) [228.051897] [038/133] (793s left) i915_pm_freq_api (freq-basic-api) [228.107329] Starting subtest: freq-basic-api [228.109795] Starting dynamic subtest: gt0 [228.112211] Dynamic subtest gt0: SUCCESS (0.002s) [228.123287] Starting dynamic subtest: gt1 [228.125556] Dynamic subtest gt1: SUCCESS (0.003s) [228.127840] Subtest freq-basic-api: SUCCESS (0.006s) [228.226618] [039/133] (793s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite) [228.319416] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite [236.762327] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.446s) [236.887343] [040/133] (784s left) dmabuf_sync_file (export-wait-after-attach) [236.941107] Starting subtest: export-wait-after-attach [236.943504] Subtest export-wait-after-attach: SUCCESS (0.001s) [237.006953] [041/133] (784s left) gem_eio (in-flight-contexts-1us) [237.227201] Starting subtest: in-flight-contexts-1us [250.941646] Subtest in-flight-contexts-1us: SUCCESS (13.713s) [251.175605] [042/133] (770s left) kms_frontbuffer_tracking (psr-1p-rte) [251.275643] Starting subtest: psr-1p-rte [256.691367] Subtest psr-1p-rte: SUCCESS (5.419s) [256.851157] [043/133] (764s left) kms_big_fb (x-tiled-16bpp-rotate-180) [256.958479] Starting subtest: x-tiled-16bpp-rotate-180 [258.203492] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.245s) [258.344512] [044/133] (763s left) gem_unfence_active_buffers [258.498670] [045/133] (763s left) gem_ctx_param (set-priority-invalid-size) [258.543895] Starting subtest: set-priority-invalid-size [258.545887] Subtest set-priority-invalid-size: SUCCESS (0.000s) [258.623688] [046/133] (763s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-rc-ccs) [258.717981] Starting subtest: missing-ccs-buffer-4-tiled-mtl-rc-ccs [258.719812] Starting dynamic subtest: pipe-A-eDP-1 [258.736384] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [258.745890] Starting dynamic subtest: pipe-B-eDP-1 [258.761747] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [258.769476] Starting dynamic subtest: pipe-C-eDP-1 [258.784741] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [258.792555] Starting dynamic subtest: pipe-D-eDP-1 [258.808082] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [258.809844] Subtest missing-ccs-buffer-4-tiled-mtl-rc-ccs: SUCCESS (0.005s) [260.902398] [047/133] (760s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [261.019313] Starting subtest: basic-flip-before-cursor-atomic [261.932363] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.913s) [262.824987] [048/133] (759s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [262.925742] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip [262.930055] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s) [263.025215] [049/133] (758s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt) [263.122607] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt [267.528291] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.410s) [268.709113] [050/133] (753s left) i915_pm_freq_mult (media-freq) [268.773644] Starting subtest: media-freq [268.776065] Starting dynamic subtest: gt0 [268.780282] Dynamic subtest gt0: SKIP (0.000s) [268.790478] Starting dynamic subtest: gt1 [268.794580] Dynamic subtest gt1: SKIP (0.000s) [268.798603] Subtest media-freq: SKIP (0.004s) [268.889941] [051/133] (753s left) gem_render_copy_redux (flink) [268.961624] Starting subtest: flink [269.744604] Subtest flink: SUCCESS (0.783s) [269.886565] [052/133] (752s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu) [269.989147] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu [269.992528] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [270.125961] [053/133] (751s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf) [270.231237] Starting subtest: pr-overlay-plane-update-continuous-sf [270.234743] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.000s) [270.315082] [054/133] (751s left) kms_pm_dc (dc5-dpms-negative) [271.406348] Starting subtest: dc5-dpms-negative [271.415296] Subtest dc5-dpms-negative: SKIP (0.000s) [271.486357] [055/133] (750s left) gem_pwrite (basic-random) [271.547763] Subtest basic-random: SKIP (0.000s) [271.614756] [056/133] (750s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-upscaling) [271.707201] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-upscaling [271.711598] Subtest flip-64bpp-yftile-to-16bpp-yftile-upscaling: SKIP (0.000s) [271.787686] [057/133] (750s left) i915_pm_rps (waitboost) [271.857809] Starting subtest: waitboost [277.946741] Subtest waitboost: SUCCESS (6.090s) [278.111533] [058/133] (744s left) perf (i915-ref-count) [278.190367] Starting subtest: i915-ref-count [278.249026] Subtest i915-ref-count: SUCCESS (0.059s) [278.306107] [059/133] (744s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-fullscreen) [278.420781] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-fullscreen [278.424855] Subtest fbcpsr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [278.545209] [060/133] (743s left) kms_big_fb (yf-tiled-64bpp-rotate-180) [278.640811] Starting subtest: yf-tiled-64bpp-rotate-180 [278.645245] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s) [278.769597] [061/133] (743s left) kms_cursor_edge_walk (64x64-top-bottom) [278.872029] Starting subtest: 64x64-top-bottom [278.874164] Starting dynamic subtest: pipe-A-eDP-1 [282.351113] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.478s) [282.360494] Starting dynamic subtest: pipe-D-eDP-1 [285.466633] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.117s) [285.468992] Subtest 64x64-top-bottom: SUCCESS (6.597s) [286.298265] [062/133] (736s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling) [286.411652] Starting subtest: planes-downscale-factor-0-75-unity-scaling [286.416355] Starting dynamic subtest: pipe-A [286.470216] Dynamic subtest pipe-A: SUCCESS (0.065s) [286.478777] Starting dynamic subtest: pipe-B [287.594730] Dynamic subtest pipe-B: SUCCESS (1.124s) [287.603991] Starting dynamic subtest: pipe-C [288.701098] Dynamic subtest pipe-C: SUCCESS (1.104s) [288.725566] Starting dynamic subtest: pipe-D [289.844558] Dynamic subtest pipe-D: SUCCESS (1.141s) [289.846881] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.440s) [290.998942] [063/133] (731s left) kms_plane (plane-position-hole) [291.093098] Starting subtest: plane-position-hole [291.580085] Starting dynamic subtest: pipe-A-plane-1 [292.871159] Dynamic subtest pipe-A-plane-1: SUCCESS (1.289s) [292.880756] Starting dynamic subtest: pipe-A-plane-2 [294.109487] Dynamic subtest pipe-A-plane-2: SUCCESS (1.239s) [294.120423] Starting dynamic subtest: pipe-A-plane-3 [295.319065] Dynamic subtest pipe-A-plane-3: SUCCESS (1.209s) [295.329011] Starting dynamic subtest: pipe-A-plane-4 [296.546727] Dynamic subtest pipe-A-plane-4: SUCCESS (1.225s) [296.556947] Starting dynamic subtest: pipe-A-plane-5 [296.570319] Dynamic subtest pipe-A-plane-5: SUCCESS (0.023s) [297.709455] Starting dynamic subtest: pipe-B-plane-1 [298.961709] Dynamic subtest pipe-B-plane-1: SUCCESS (1.258s) [298.971024] Starting dynamic subtest: pipe-B-plane-2 [300.261506] Dynamic subtest pipe-B-plane-2: SUCCESS (1.300s) [300.271876] Starting dynamic subtest: pipe-B-plane-3 [301.544059] Dynamic subtest pipe-B-plane-3: SUCCESS (1.281s) [301.552824] Starting dynamic subtest: pipe-B-plane-4 [302.811649] Dynamic subtest pipe-B-plane-4: SUCCESS (1.265s) [302.821360] Starting dynamic subtest: pipe-B-plane-5 [302.836040] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s) [302.838362] Subtest plane-position-hole: SUCCESS (11.744s) [303.631264] [064/133] (718s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled) [303.700610] Starting subtest: multi-wait-for-submit-submitted-signaled [303.702949] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.001s) [303.802209] [065/133] (718s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180) [303.900093] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180 [304.868390] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (0.967s) [305.034202] [066/133] (717s left) syncobj_eventfd (timeline-wait) [305.098647] Starting subtest: timeline-wait [305.108347] Subtest timeline-wait: SUCCESS (0.011s) [305.229774] [067/133] (717s left) kms_async_flips (async-flip-hang) [305.319895] Starting subtest: async-flip-hang [305.691788] Starting dynamic subtest: pipe-A-eDP-1 [321.396303] Dynamic subtest pipe-A-eDP-1: SUCCESS (15.702s) [321.769095] Starting dynamic subtest: pipe-B-eDP-1 [337.398909] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.634s) [337.798837] Starting dynamic subtest: pipe-C-eDP-1 [353.392392] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.600s) [353.768664] Starting dynamic subtest: pipe-D-eDP-1 [369.390256] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.625s) [369.392530] Subtest async-flip-hang: SUCCESS (64.070s) [370.577319] [068/133] (652s left) gem_exec_fence (syncobj-import) [371.045211] Starting subtest: syncobj-import [371.049896] Subtest syncobj-import: SUCCESS (0.004s) [373.002128] [069/133] (649s left) perf_pmu (most-busy-idle-check-all) [373.041294] Starting subtest: most-busy-idle-check-all [373.043815] Starting dynamic subtest: rcs0 [374.936548] Dynamic subtest rcs0: SUCCESS (1.897s) [374.950364] Starting dynamic subtest: bcs0 [376.920344] Dynamic subtest bcs0: SUCCESS (1.980s) [376.930785] Starting dynamic subtest: vcs0 [378.903968] Dynamic subtest vcs0: SUCCESS (1.981s) [378.914888] Starting dynamic subtest: vcs1 [380.888274] Dynamic subtest vcs1: SUCCESS (1.981s) [380.899025] Starting dynamic subtest: vecs0 [382.936469] Dynamic subtest vecs0: SUCCESS (2.045s) [382.946896] Starting dynamic subtest: ccs0 [384.921351] Dynamic subtest ccs0: SUCCESS (1.982s) [384.924443] Subtest most-busy-idle-check-all: SUCCESS (11.884s) [385.047478] [070/133] (637s left) kms_pipe_crc_basic (suspend-read-crc) [385.153070] Starting subtest: suspend-read-crc [385.155352] Starting dynamic subtest: pipe-A-eDP-1 [402.732977] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.626s) [402.745214] Starting dynamic subtest: pipe-B-eDP-1 [420.744462] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.089s) [420.756778] Starting dynamic subtest: pipe-C-eDP-1 [438.711852] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.094s) [438.722406] Starting dynamic subtest: pipe-D-eDP-1 [456.694562] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.033s) [456.696955] Subtest suspend-read-crc: SUCCESS (11.847s) [457.562123] [071/133] (565s left) gem_exec_capture (capture) [457.649484] Starting subtest: capture [457.651470] Starting dynamic subtest: rcs0-smem [458.469335] Dynamic subtest rcs0-smem: SUCCESS (0.811s) [458.480506] Starting dynamic subtest: bcs0-smem [459.281842] Dynamic subtest bcs0-smem: SUCCESS (0.806s) [459.290706] Starting dynamic subtest: vcs0-smem [460.089288] Dynamic subtest vcs0-smem: SUCCESS (0.801s) [460.100630] Starting dynamic subtest: vcs1-smem [461.401251] Dynamic subtest vcs1-smem: SUCCESS (1.306s) [461.413723] Starting dynamic subtest: vecs0-smem [462.284743] Dynamic subtest vecs0-smem: FAIL (0.810s) [462.296537] Starting dynamic subtest: ccs0-smem [463.543995] Dynamic subtest ccs0-smem: SUCCESS (1.319s) [463.546223] Subtest capture: FAIL (5.858s) [463.724408] [072/133] (559s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-wc) [463.830942] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-wc [463.835231] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [463.942032] [073/133] (558s left) kms_chamelium_color (ctm-0-25) [464.036455] Subtest ctm-0-25: SKIP (0.000s) [464.079094] [074/133] (558s left) api_intel_allocator (standalone) [464.135015] Starting subtest: standalone [464.146349] Subtest standalone: SUCCESS (0.016s) [464.312331] [075/133] (558s left) kms_addfb_basic (bad-pitch-999) [464.362542] Starting subtest: bad-pitch-999 [464.364887] Subtest bad-pitch-999: SUCCESS (0.000s) [464.521193] [076/133] (558s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs) [464.581751] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs [464.585797] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s) [464.775903] [077/133] (558s left) kms_plane (pixel-format-linear-modifier) [464.877159] Starting subtest: pixel-format-linear-modifier [464.905369] Starting dynamic subtest: pipe-A-plane-0 [468.393328] Dynamic subtest pipe-A-plane-0: SUCCESS (3.478s) [468.402725] Starting dynamic subtest: pipe-A-plane-3 [470.063976] Dynamic subtest pipe-A-plane-3: SUCCESS (1.666s) [470.073551] Starting dynamic subtest: pipe-A-plane-5 [470.275775] Dynamic subtest pipe-A-plane-5: SUCCESS (0.209s) [471.410221] Starting dynamic subtest: pipe-B-plane-0 [474.949834] Dynamic subtest pipe-B-plane-0: SUCCESS (3.544s) [474.959585] Starting dynamic subtest: pipe-B-plane-3 [476.641120] Dynamic subtest pipe-B-plane-3: SUCCESS (1.688s) [476.653179] Starting dynamic subtest: pipe-B-plane-5 [476.852525] Dynamic subtest pipe-B-plane-5: SUCCESS (0.210s) [477.175343] Subtest pixel-format-linear-modifier: SUCCESS (12.271s) [478.013285] [078/133] (545s left) kms_rotation_crc (cursor-rotation-180) [478.115035] Starting subtest: cursor-rotation-180 [479.658858] Subtest cursor-rotation-180: SUCCESS (1.544s) [480.915636] [079/133] (542s left) perf (missing-sample-flags) [481.025867] Starting subtest: missing-sample-flags [481.027952] Subtest missing-sample-flags: SUCCESS (0.000s) [481.095369] [080/133] (542s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen) [481.199646] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen [487.765091] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.565s) [487.928995] [081/133] (535s left) syncobj_timeline (wait-all-for-submit-complex) [488.016654] Starting subtest: wait-all-for-submit-complex [488.230815] Subtest wait-all-for-submit-complex: SUCCESS (0.214s) [488.319422] [082/133] (534s left) gem_fenced_exec_thrash (no-spare-fences) [488.381905] Subtest no-spare-fences: SKIP (0.000s) [488.459850] [083/133] (534s left) kms_frontbuffer_tracking (fbc-suspend) [488.551765] Starting subtest: fbc-suspend [526.368233] Subtest fbc-suspend: SUCCESS (8.299s) [527.592202] [084/133] (495s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs) [527.664906] Starting subtest: y-tiled-ccs-to-y-tiled-ccs [527.669365] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s) [527.857330] [085/133] (495s left) syncobj_wait (single-wait-all-for-submit-signaled) [527.913551] Starting subtest: single-wait-all-for-submit-signaled [527.915892] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s) [528.022402] [086/133] (495s left) kms_flip (flip-vs-modeset-vs-hang) [528.113207] Starting subtest: flip-vs-modeset-vs-hang [528.115636] Starting dynamic subtest: A-eDP1 [579.456508] Dynamic subtest A-eDP1: SUCCESS (51.293s) [579.466073] Starting dynamic subtest: D-eDP1 [629.505735] Dynamic subtest D-eDP1: SUCCESS (50.036s) [629.508481] Subtest flip-vs-modeset-vs-hang: SUCCESS (101.337s) [629.927057] [087/133] (393s left) core_auth (getclient-simple) [629.960948] Starting subtest: getclient-simple [629.982655] Subtest getclient-simple: SUCCESS (0.021s) [630.106374] [088/133] (393s left) kms_psr (fbc-psr-primary-page-flip) [630.190909] Starting subtest: fbc-psr-primary-page-flip [630.192803] Starting dynamic subtest: eDP-1 [630.197046] Dynamic subtest eDP-1: SKIP (0.000s) [630.201323] Subtest fbc-psr-primary-page-flip: SKIP (0.001s) [630.275928] [089/133] (393s left) kms_joiner (basic-big-joiner) [630.380078] Starting subtest: basic-big-joiner [630.384157] Subtest basic-big-joiner: SKIP (0.000s) [630.460626] [090/133] (393s left) gem_mmap_gtt (basic-write) [630.530450] Subtest basic-write: SKIP (0.000s) [630.598908] [091/133] (393s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu) [630.698321] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu [630.702675] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [630.825755] [092/133] (392s left) gem_exec_parallel (engines) [630.890171] Starting subtest: engines [630.892174] Starting dynamic subtest: basic [633.000227] Dynamic subtest basic: SUCCESS (2.108s) [633.013771] Starting dynamic subtest: contexts [637.379098] Dynamic subtest contexts: SUCCESS (4.377s) [637.388642] Starting dynamic subtest: fds [641.181086] Dynamic subtest fds: SUCCESS (3.799s) [641.192745] Starting dynamic subtest: userptr [643.046946] Dynamic subtest userptr: SUCCESS (1.865s) [643.049666] Subtest engines: SUCCESS (12.156s) [643.256373] [093/133] (380s left) kms_flip (flip-vs-wf_vblank-interruptible) [643.370269] Starting subtest: flip-vs-wf_vblank-interruptible [643.376362] Starting dynamic subtest: A-eDP1 [645.253940] Dynamic subtest A-eDP1: SUCCESS (1.881s) [645.263492] Starting dynamic subtest: B-eDP1 [647.192136] Dynamic subtest B-eDP1: SUCCESS (1.937s) [647.204206] Starting dynamic subtest: C-eDP1 [649.110863] Dynamic subtest C-eDP1: SUCCESS (1.917s) [649.122074] Starting dynamic subtest: D-eDP1 [651.047204] Dynamic subtest D-eDP1: SUCCESS (1.935s) [651.049681] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.678s) [652.311107] [094/133] (371s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt) [652.415995] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt [652.419985] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [652.518016] [095/133] (371s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [652.617183] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt [652.621248] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [652.726691] [096/133] (371s left) gem_exec_whisper (basic-queues-all) [652.797939] Starting subtest: basic-queues-all [664.004562] Subtest basic-queues-all: SUCCESS (11.203s) [664.197800] [097/133] (359s left) syncobj_timeline (multi-wait-all-available-signaled) [664.263118] Starting subtest: multi-wait-all-available-signaled [664.265430] Subtest multi-wait-all-available-signaled: SUCCESS (0.000s) [664.374570] [098/133] (359s left) kms_big_fb (4-tiled-32bpp-rotate-0) [664.476932] Starting subtest: 4-tiled-32bpp-rotate-0 [665.812260] Subtest 4-tiled-32bpp-rotate-0: SUCCESS (1.335s) [665.971608] [099/133] (358s left) kms_getfb (getfb2-handle-closed) [666.080813] Starting subtest: getfb2-handle-closed [666.083138] Subtest getfb2-handle-closed: SUCCESS (0.000s) [666.203954] [100/133] (357s left) gem_ctx_isolation (nonpriv) [666.257141] Starting subtest: nonpriv [666.259177] Starting dynamic subtest: rcs0 [666.488391] Dynamic subtest rcs0: SUCCESS (0.231s) [666.500271] Starting dynamic subtest: bcs0 [666.729748] Dynamic subtest bcs0: SUCCESS (0.240s) [666.741537] Starting dynamic subtest: vcs0 [667.007544] Dynamic subtest vcs0: SUCCESS (0.277s) [667.017195] Starting dynamic subtest: vcs1 [668.247612] Dynamic subtest vcs1: SUCCESS (1.238s) [668.259545] Starting dynamic subtest: vecs0 [670.245608] Dynamic subtest vecs0: SUCCESS (1.997s) [670.257767] Starting dynamic subtest: ccs0 [672.348829] Dynamic subtest ccs0: SUCCESS (2.102s) [672.351196] Subtest nonpriv: SUCCESS (6.091s) [672.628078] [101/133] (351s left) perf (invalid-remove-userspace-config) [672.721108] Starting subtest: invalid-remove-userspace-config [672.731759] Subtest invalid-remove-userspace-config: SUCCESS (0.008s) [672.769931] [102/133] (351s left) perf_pmu (busy-hang) [672.812654] Starting subtest: busy-hang [672.814939] Starting dynamic subtest: rcs0 [674.094934] Dynamic subtest rcs0: SUCCESS (1.279s) [674.105953] Starting dynamic subtest: bcs0 [675.353396] Dynamic subtest bcs0: SUCCESS (1.256s) [675.365063] Starting dynamic subtest: vcs0 [677.554929] Dynamic subtest vcs0: SUCCESS (2.203s) [677.567541] Starting dynamic subtest: vcs1 [679.539822] Dynamic subtest vcs1: SUCCESS (1.983s) [679.552250] Starting dynamic subtest: vecs0 [681.526501] Dynamic subtest vecs0: SUCCESS (1.981s) [681.538782] Starting dynamic subtest: ccs0 [682.779413] Dynamic subtest ccs0: SUCCESS (1.250s) [682.781798] Subtest busy-hang: SUCCESS (9.963s) [682.897559] [103/133] (341s left) kms_flip (2x-absolute-wf_vblank) [682.999109] Starting subtest: 2x-absolute-wf_vblank [683.008077] Subtest 2x-absolute-wf_vblank: SKIP (0.011s) [683.103822] [104/133] (341s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff) [683.190440] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff [683.194796] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [683.338088] [105/133] (340s left) kms_cursor_legacy (forked-move) [683.452096] Starting subtest: forked-move [683.454279] Starting dynamic subtest: pipe-A [688.916792] Dynamic subtest pipe-A: SUCCESS (5.461s) [688.928804] Starting dynamic subtest: pipe-B [694.401951] Dynamic subtest pipe-B: SUCCESS (5.480s) [694.415501] Starting dynamic subtest: pipe-C [699.866079] Dynamic subtest pipe-C: SUCCESS (5.461s) [699.879819] Starting dynamic subtest: pipe-D [705.333748] Dynamic subtest pipe-D: SUCCESS (5.463s) [705.346093] Starting dynamic subtest: all-pipes [710.815411] Dynamic subtest all-pipes: SUCCESS (5.478s) [710.817734] Subtest forked-move: SUCCESS (27.355s) [710.969974] [106/133] (313s left) syncobj_basic (bad-flags-handle-to-fd) [711.037791] Starting subtest: bad-flags-handle-to-fd [711.039986] Subtest bad-flags-handle-to-fd: SUCCESS (0.000s) [711.163558] [107/133] (313s left) gem_wait (invalid-flags) [711.223779] Starting subtest: invalid-flags [711.225992] Subtest invalid-flags: SUCCESS (0.000s) [711.478128] [108/133] (312s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted) [711.540147] Starting subtest: etime-single-wait-all-for-submit-submitted [711.643419] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.104s) [711.731174] [109/133] (312s left) kms_plane_lowres (tiling-yf) [711.829771] Starting subtest: tiling-yf [711.834259] Subtest tiling-yf: SKIP (0.000s) [711.915006] [110/133] (312s left) prime_vgem (basic-fence-mmap) [711.999011] Starting subtest: basic-fence-mmap [712.003502] Subtest basic-fence-mmap: SKIP (0.000s) [712.137946] [111/133] (312s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite) [712.233748] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite [712.238003] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [712.357643] [112/133] (312s left) kms_content_protection (uevent-hdcp14) [712.504281] Starting subtest: uevent-hdcp14 [712.508794] Subtest uevent-hdcp14: SKIP (0.000s) [712.668706] [113/133] (311s left) kms_psr (psr-suspend) [712.766656] Starting subtest: psr-suspend [712.769124] Starting dynamic subtest: eDP-1 [730.277758] Dynamic subtest eDP-1: SUCCESS (2.884s) [730.280143] Subtest psr-suspend: SUCCESS (2.885s) [731.149533] [114/133] (293s left) kms_atomic_interruptible (legacy-dpms) [731.252158] Starting subtest: legacy-dpms [731.254426] Starting dynamic subtest: pipe-A-eDP-1 [738.658535] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.412s) [738.660724] Subtest legacy-dpms: SUCCESS (7.413s) [739.504031] [115/133] (285s left) gem_userptr_blits (nohangcheck) [739.587616] Starting subtest: nohangcheck [739.848533] Subtest nohangcheck: SUCCESS (0.257s) [740.005261] [116/133] (284s left) kms_psr (fbc-psr-suspend) [740.109012] Starting subtest: fbc-psr-suspend [740.111173] Starting dynamic subtest: eDP-1 [740.115101] Dynamic subtest eDP-1: SKIP (0.000s) [740.119021] Subtest fbc-psr-suspend: SKIP (0.001s) [740.196689] [117/133] (284s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area) [740.281651] Starting subtest: psr2-overlay-primary-update-sf-dmg-area [740.283792] Starting dynamic subtest: pipe-A-eDP-1 [746.256177] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.980s) [746.266740] Starting dynamic subtest: pipe-B-eDP-1 [752.837542] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.580s) [752.839946] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (12.563s) [753.729956] [118/133] (271s left) kms_lease (lease-uevent) [753.827701] Starting subtest: lease-uevent [754.844661] Subtest lease-uevent: SUCCESS (1.017s) [754.977228] [119/133] (269s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc) [755.085512] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc [755.087826] Starting dynamic subtest: pipe-A-eDP-1 [755.110480] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [755.120939] Starting dynamic subtest: pipe-B-eDP-1 [755.142596] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [755.151964] Starting dynamic subtest: pipe-C-eDP-1 [755.173349] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [755.182935] Starting dynamic subtest: pipe-D-eDP-1 [755.204554] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [755.208629] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.011s) [757.308225] [120/133] (267s left) gem_close_race (multigpu-basic-process) [757.374612] Starting subtest: multigpu-basic-process [757.379052] Subtest multigpu-basic-process: SKIP (0.000s) [757.644656] [121/133] (267s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible) [757.734754] Starting subtest: flip-vs-absolute-wf_vblank-interruptible [757.737067] Starting dynamic subtest: A-eDP1 [766.636404] Dynamic subtest A-eDP1: SUCCESS (8.899s) [766.654664] Starting dynamic subtest: B-eDP1 [775.579697] Dynamic subtest B-eDP1: SUCCESS (8.938s) [775.590079] Starting dynamic subtest: C-eDP1 [784.497384] Dynamic subtest C-eDP1: SUCCESS (8.914s) [784.512025] Starting dynamic subtest: D-eDP1 [793.347787] Dynamic subtest D-eDP1: SUCCESS (8.847s) [793.352866] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.612s) [794.604829] [122/133] (230s left) prime_self_import (basic-with_two_bos) [794.643869] Starting subtest: basic-with_two_bos [794.667749] Subtest basic-with_two_bos: SUCCESS (0.028s) [794.781969] [123/133] (230s left) kms_chamelium_edid (hdmi-mode-timings) [795.162952] Subtest hdmi-mode-timings: SKIP (0.000s) [795.989343] [124/133] (229s left) sw_sync (sync_multi_consumer_producer) [796.025206] Starting subtest: sync_multi_consumer_producer [796.326347] Subtest sync_multi_consumer_producer: SUCCESS (0.303s) [796.400998] [125/133] (228s left) gem_exec_flush (basic-wb-rw-before-default) [796.467226] Starting subtest: basic-wb-rw-before-default [801.921640] Subtest basic-wb-rw-before-default: SUCCESS (5.456s) [802.117702] [126/133] (223s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc) [802.225833] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc [802.228050] Starting dynamic subtest: pipe-A-eDP-1 [802.249586] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [802.260746] Starting dynamic subtest: pipe-B-eDP-1 [802.282066] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [802.291631] Starting dynamic subtest: pipe-C-eDP-1 [802.312128] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [802.321367] Starting dynamic subtest: pipe-D-eDP-1 [802.342288] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [802.346114] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs-cc: SKIP (0.006s) [804.396560] [127/133] (220s left) gem_mmap_offset (basic-uaf) [804.454974] Starting subtest: basic-uaf [804.457149] Subtest basic-uaf: SUCCESS (0.001s) [804.574816] [128/133] (220s left) gem_busy (busy) [804.629384] Starting subtest: busy [804.631697] Starting dynamic subtest: all-engines [804.692590] Dynamic subtest all-engines: SUCCESS (0.063s) [804.703123] Starting dynamic subtest: rcs0 [806.606644] Dynamic subtest rcs0: SUCCESS (1.913s) [806.616302] Starting dynamic subtest: bcs0 [806.668720] Dynamic subtest bcs0: SUCCESS (0.059s) [806.678073] Starting dynamic subtest: vcs0 [806.707290] Dynamic subtest vcs0: SUCCESS (0.037s) [806.716311] Starting dynamic subtest: vcs1 [808.654464] Dynamic subtest vcs1: SUCCESS (1.945s) [808.664273] Starting dynamic subtest: vecs0 [810.639829] Dynamic subtest vecs0: SUCCESS (1.983s) [810.649632] Starting dynamic subtest: ccs0 [812.621947] Dynamic subtest ccs0: SUCCESS (1.983s) [812.624477] Subtest busy: SUCCESS (7.991s) [813.029105] [129/133] (212s left) gem_lmem_swapping (verify-ccs) [813.067744] Subtest verify-ccs: SKIP (0.000s) [813.111797] [130/133] (212s left) kms_vblank (ts-continuation-modeset-rpm) [813.204758] Starting subtest: ts-continuation-modeset-rpm [813.206965] Starting dynamic subtest: pipe-A-eDP-1 [815.693398] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.489s) [815.713584] Starting dynamic subtest: pipe-D-eDP-1 [817.954100] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.256s) [817.956024] Subtest ts-continuation-modeset-rpm: SUCCESS (4.749s) [818.766484] [131/133] (206s left) gem_exec_schedule (submit-golden-slice) [818.847556] Starting subtest: submit-golden-slice [818.849817] Starting dynamic subtest: rcs0 [818.875316] Dynamic subtest rcs0: SUCCESS (0.033s) [818.886458] Starting dynamic subtest: bcs0 [818.903774] Dynamic subtest bcs0: SUCCESS (0.028s) [818.915409] Starting dynamic subtest: vcs0 [818.936016] Dynamic subtest vcs0: SUCCESS (0.031s) [818.945808] Starting dynamic subtest: vcs1 [818.971613] Dynamic subtest vcs1: SUCCESS (0.035s) [818.981789] Starting dynamic subtest: vecs0 [819.006207] Dynamic subtest vecs0: SUCCESS (0.034s) [819.016039] Starting dynamic subtest: ccs0 [819.037454] Dynamic subtest ccs0: SUCCESS (0.031s) [819.039761] Subtest submit-golden-slice: SUCCESS (0.196s) [820.760433] [132/133] (204s left) kms_cursor_crc (cursor-onscreen-256x256) [821.009629] Starting subtest: cursor-onscreen-256x256 [821.014981] Starting dynamic subtest: pipe-A-eDP-1 [823.109551] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.097s) [823.140414] Starting dynamic subtest: pipe-D-eDP-1 [825.939368] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.805s) [825.941674] Subtest cursor-onscreen-256x256: SUCCESS (4.927s) [826.747580] [133/133] (198s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions) [826.865456] Starting subtest: flip-vs-cursor-atomic-transitions [834.347663] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (7.483s) [835.181932] Closing watchdogs results: parsing output: 0/ for test: kms_rotation_crc results: parsing output: 1/ for test: gem_exec_balancer results: parsing output: 2/ for test: gem_exec_reloc results: parsing output: 3/ for test: kms_atomic_transition results: parsing output: 4/ for test: kms_selftest results: parsing output: 5/ for test: kms_busy results: parsing output: 6/ for test: gen7_exec_parse results: parsing output: 7/ for test: gem_ctx_persistence results: parsing output: 8/ for test: kms_draw_crc results: parsing output: 9/ for test: kms_frontbuffer_tracking results: parsing output: 10/ for test: kms_psr2_sf results: parsing output: 11/ for test: gem_exec_whisper results: parsing output: 12/ for test: kms_flip_scaled_crc results: parsing output: 13/ for test: kms_chamelium_frames results: parsing output: 14/ for test: kms_frontbuffer_tracking results: parsing output: 15/ for test: kms_psr results: parsing output: 16/ for test: kms_psr results: parsing output: 17/ for test: kms_ccs results: parsing output: 18/ for test: vgem_basic results: parsing output: 19/ for test: kms_flip results: parsing output: 20/ for test: gem_softpin results: parsing output: 21/ for test: gem_eio results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: kms_fbcon_fbt results: parsing output: 24/ for test: vgem_basic results: parsing output: 25/ for test: kms_vblank results: parsing output: 26/ for test: i915_drm_fdinfo results: parsing output: 27/ for test: gem_partial_pwrite_pread results: parsing output: 28/ for test: kms_addfb_basic results: parsing output: 29/ for test: kms_big_fb results: parsing output: 30/ for test: kms_pm_rpm results: parsing output: 31/ for test: kms_setmode results: parsing output: 32/ for test: syncobj_wait results: parsing output: 33/ for test: sriov_basic results: parsing output: 34/ for test: kms_color results: parsing output: 35/ for test: kms_cursor_crc results: parsing output: 36/ for test: gem_exec_schedule results: parsing output: 37/ for test: i915_pm_freq_api results: parsing output: 38/ for test: kms_frontbuffer_tracking results: parsing output: 39/ for test: dmabuf_sync_file results: parsing output: 40/ for test: gem_eio results: parsing output: 41/ for test: kms_frontbuffer_tracking results: parsing output: 42/ for test: kms_big_fb results: parsing output: 43/ for test: gem_unfence_active_buffers results: parsing output: 44/ for test: gem_ctx_param results: parsing output: 45/ for test: kms_ccs results: parsing output: 46/ for test: kms_cursor_legacy results: parsing output: 47/ for test: kms_big_fb results: parsing output: 48/ for test: kms_frontbuffer_tracking results: parsing output: 49/ for test: i915_pm_freq_mult results: parsing output: 50/ for test: gem_render_copy_redux results: parsing output: 51/ for test: kms_frontbuffer_tracking results: parsing output: 52/ for test: kms_psr2_sf results: parsing output: 53/ for test: kms_pm_dc results: parsing output: 54/ for test: gem_pwrite results: parsing output: 55/ for test: kms_flip_scaled_crc results: parsing output: 56/ for test: i915_pm_rps results: parsing output: 57/ for test: perf results: parsing output: 58/ for test: kms_frontbuffer_tracking results: parsing output: 59/ for test: kms_big_fb results: parsing output: 60/ for test: kms_cursor_edge_walk results: parsing output: 61/ for test: kms_plane_scaling results: parsing output: 62/ for test: kms_plane results: parsing output: 63/ for test: syncobj_timeline results: parsing output: 64/ for test: kms_big_fb results: parsing output: 65/ for test: syncobj_eventfd results: parsing output: 66/ for test: kms_async_flips results: parsing output: 67/ for test: gem_exec_fence results: parsing output: 68/ for test: perf_pmu results: parsing output: 69/ for test: kms_pipe_crc_basic results: parsing output: 70/ for test: gem_exec_capture results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: kms_chamelium_color results: parsing output: 73/ for test: api_intel_allocator results: parsing output: 74/ for test: kms_addfb_basic results: parsing output: 75/ for test: gem_render_copy results: parsing output: 76/ for test: kms_plane results: parsing output: 77/ for test: kms_rotation_crc results: parsing output: 78/ for test: perf results: parsing output: 79/ for test: kms_frontbuffer_tracking results: parsing output: 80/ for test: syncobj_timeline results: parsing output: 81/ for test: gem_fenced_exec_thrash results: parsing output: 82/ for test: kms_frontbuffer_tracking results: parsing output: 83/ for test: gem_render_copy results: parsing output: 84/ for test: syncobj_wait results: parsing output: 85/ for test: kms_flip results: parsing output: 86/ for test: core_auth results: parsing output: 87/ for test: kms_psr results: parsing output: 88/ for test: kms_joiner results: parsing output: 89/ for test: gem_mmap_gtt results: parsing output: 90/ for test: kms_frontbuffer_tracking results: parsing output: 91/ for test: gem_exec_parallel results: parsing output: 92/ for test: kms_flip results: parsing output: 93/ for test: kms_frontbuffer_tracking results: parsing output: 94/ for test: kms_frontbuffer_tracking results: parsing output: 95/ for test: gem_exec_whisper results: parsing output: 96/ for test: syncobj_timeline results: parsing output: 97/ for test: kms_big_fb results: parsing output: 98/ for test: kms_getfb results: parsing output: 99/ for test: gem_ctx_isolation results: parsing output: 100/ for test: perf results: parsing output: 101/ for test: perf_pmu results: parsing output: 102/ for test: kms_flip results: parsing output: 103/ for test: kms_frontbuffer_tracking results: parsing output: 104/ for test: kms_cursor_legacy results: parsing output: 105/ for test: syncobj_basic results: parsing output: 106/ for test: gem_wait results: parsing output: 107/ for test: syncobj_timeline results: parsing output: 108/ for test: kms_plane_lowres results: parsing output: 109/ for test: prime_vgem results: parsing output: 110/ for test: kms_frontbuffer_tracking results: parsing output: 111/ for test: kms_content_protection results: parsing output: 112/ for test: kms_psr results: parsing output: 113/ for test: kms_atomic_interruptible results: parsing output: 114/ for test: gem_userptr_blits results: parsing output: 115/ for test: kms_psr results: parsing output: 116/ for test: kms_psr2_sf results: parsing output: 117/ for test: kms_lease results: parsing output: 118/ for test: kms_ccs results: parsing output: 119/ for test: gem_close_race results: parsing output: 120/ for test: kms_flip results: parsing output: 121/ for test: prime_self_import results: parsing output: 122/ for test: kms_chamelium_edid results: parsing output: 123/ for test: sw_sync results: parsing output: 124/ for test: gem_exec_flush results: parsing output: 125/ for test: kms_ccs results: parsing output: 126/ for test: gem_mmap_offset results: parsing output: 127/ for test: gem_busy results: parsing output: 128/ for test: gem_lmem_swapping results: parsing output: 129/ for test: kms_vblank results: parsing output: 130/ for test: gem_exec_schedule results: parsing output: 131/ for test: kms_cursor_crc results: parsing output: 132/ for test: kms_cursor_legacy Done.