[57.839208] Initializing watchdogs [57.839257] /dev/watchdog0 [57.853984] [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] [57.858444] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.860805] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.864181] [001/132] (960s left) prime_mmap (test_dup) [57.944436] Starting subtest: test_dup [57.946349] Starting dynamic subtest: test_dup-smem [57.978264] Dynamic subtest test_dup-smem: SUCCESS (0.036s) [57.980646] Subtest test_dup: SUCCESS (0.036s) [58.062115] [002/132] (960s left) gem_ctx_bad_destroy (invalid-default-ctx) [58.118754] Starting subtest: invalid-default-ctx [58.121866] Subtest invalid-default-ctx: SUCCESS (0.000s) [58.195252] [003/132] (960s left) gen7_exec_parse (basic-rejected) [58.259773] Subtest basic-rejected: SKIP (0.000s) [58.330364] [004/132] (960s left) kms_psr (fbc-pr-suspend) [58.424900] Starting subtest: fbc-pr-suspend [58.429593] Subtest fbc-pr-suspend: SKIP (0.000s) [58.491650] [005/132] (960s left) gem_exec_schedule (in-order) [58.561861] Starting subtest: in-order [58.564266] Starting dynamic subtest: rcs0 [58.664703] Dynamic subtest rcs0: SUCCESS (0.109s) [58.672374] Starting dynamic subtest: vcs0 [58.760539] Dynamic subtest vcs0: SUCCESS (0.095s) [58.771107] Starting dynamic subtest: vcs1 [58.853613] Dynamic subtest vcs1: SUCCESS (0.093s) [58.861437] Starting dynamic subtest: vecs0 [58.940617] Dynamic subtest vecs0: SUCCESS (0.086s) [58.950193] Starting dynamic subtest: ccs0 [59.033086] Dynamic subtest ccs0: SUCCESS (0.092s) [59.035600] Subtest in-order: SUCCESS (0.478s) [60.013509] [006/132] (958s left) kms_fbcon_fbt (fbc-suspend) [60.069513] Starting subtest: fbc-suspend [109.058243] Subtest fbc-suspend: SUCCESS (19.896s) [110.453585] [007/132] (908s left) kms_psr (pr-sprite-mmap-cpu) [110.556677] Starting subtest: pr-sprite-mmap-cpu [110.560888] Subtest pr-sprite-mmap-cpu: SKIP (0.000s) [110.639478] [008/132] (907s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt) [110.740912] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt [118.187842] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.447s) [118.335795] [009/132] (900s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-mc-ccs) [118.431988] Starting subtest: ccs-on-another-bo-4-tiled-mtl-mc-ccs [118.434264] Starting dynamic subtest: pipe-A-eDP-1 [118.454746] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.022s) [118.465431] Starting dynamic subtest: pipe-B-eDP-1 [118.485167] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.022s) [118.493884] Starting dynamic subtest: pipe-C-eDP-1 [118.513233] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.024s) [118.522133] Starting dynamic subtest: pipe-D-eDP-1 [118.543173] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.024s) [118.545303] Subtest ccs-on-another-bo-4-tiled-mtl-mc-ccs: SUCCESS (0.095s) [120.765565] [010/132] (897s left) api_intel_allocator (simple-allocator) [120.820166] Starting subtest: simple-allocator [120.822598] Starting dynamic subtest: basic [120.824963] Dynamic subtest basic: SUCCESS (0.004s) [120.833449] Starting dynamic subtest: parallel-one [121.010842] Dynamic subtest parallel-one: SUCCESS (0.187s) [121.019808] Starting dynamic subtest: print [121.021947] Dynamic subtest print: SUCCESS (0.000s) [121.030372] Starting dynamic subtest: reuse [121.032480] Dynamic subtest reuse: SUCCESS (0.000s) [121.040710] Starting dynamic subtest: reserve [121.042811] Dynamic subtest reserve: SUCCESS (0.000s) [121.050836] Starting dynamic subtest: fork-reopen-allocator [121.052990] Dynamic subtest fork-reopen-allocator: SUCCESS (0.013s) [121.055128] Subtest simple-allocator: SUCCESS (0.208s) [121.127450] [011/132] (897s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt) [121.233586] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt [125.416012] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.184s) [126.563669] [012/132] (892s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted) [126.613139] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted [126.721807] Subtest etime-multi-wait-all-available-unsubmitted-submitted: SUCCESS (0.106s) [126.798392] [013/132] (892s left) kms_frontbuffer_tracking (fbcpsr-modesetfrombusy) [126.911622] Starting subtest: fbcpsr-modesetfrombusy [133.052360] Subtest fbcpsr-modesetfrombusy: SUCCESS (6.145s) [133.180420] [014/132] (885s left) kms_vblank (ts-continuation-dpms-suspend) [133.265091] Starting subtest: ts-continuation-dpms-suspend [133.266905] Starting dynamic subtest: pipe-A-eDP-1 [150.512296] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.836s) [150.526562] Starting dynamic subtest: pipe-D-eDP-1 [168.521801] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.479s) [168.523764] Subtest ts-continuation-dpms-suspend: SUCCESS (4.318s) [169.322812] [015/132] (849s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [169.445052] Starting subtest: basic-busy-flip-before-cursor-atomic [169.449416] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [169.587674] [016/132] (849s left) gem_exec_balancer (hog) [169.647679] Starting subtest: hog [169.652410] Subtest hog: SKIP (0.000s) [169.944008] [017/132] (849s left) kms_pm_rpm (pm-tiling) [172.105361] Starting subtest: pm-tiling [172.111546] Subtest pm-tiling: SKIP (0.000s) [172.497566] [018/132] (846s left) kms_addfb_basic (bad-pitch-1024) [172.561546] Starting subtest: bad-pitch-1024 [172.563784] Subtest bad-pitch-1024: SUCCESS (0.000s) [172.695635] [019/132] (846s left) sysfs_timeslice_duration (timeout) [172.764243] Starting subtest: timeout [172.766497] Starting dynamic subtest: vecs0 [181.903578] Dynamic subtest vecs0: SUCCESS (9.127s) [181.915450] Starting dynamic subtest: ccs0 [183.198551] Dynamic subtest ccs0: SUCCESS (1.293s) [183.210109] Starting dynamic subtest: vcs0 [192.907602] Dynamic subtest vcs0: SUCCESS (9.702s) [192.918542] Starting dynamic subtest: bcs0 [193.492445] Dynamic subtest bcs0: SUCCESS (0.584s) [193.502902] Starting dynamic subtest: rcs0 [194.693058] Dynamic subtest rcs0: SUCCESS (1.199s) [194.704343] Starting dynamic subtest: vcs1 [203.920289] Dynamic subtest vcs1: SUCCESS (9.221s) [203.922979] Subtest timeout: SUCCESS (31.131s) [203.997592] [020/132] (815s left) kms_scaling_modes (scaling-mode-center) [204.092751] Starting subtest: scaling-mode-center [204.095202] Starting dynamic subtest: pipe-A-eDP-1 [204.184080] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.093s) [204.194510] Starting dynamic subtest: pipe-B-eDP-1 [205.319220] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.133s) [205.330706] Starting dynamic subtest: pipe-C-eDP-1 [206.448740] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.127s) [206.458244] Starting dynamic subtest: pipe-D-eDP-1 [207.586701] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.136s) [207.589073] Subtest scaling-mode-center: SUCCESS (3.496s) [208.740633] [021/132] (810s left) gem_pxp (hw-rejects-pxp-buffer) [208.861151] Starting subtest: hw-rejects-pxp-buffer [208.866043] Subtest hw-rejects-pxp-buffer: SKIP (0.000s) [208.963656] [022/132] (810s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip) [209.074762] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip [209.079251] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s) [209.161797] [023/132] (810s left) syncobj_wait (wait-delayed-signal) [209.219836] Starting subtest: wait-delayed-signal [209.322977] Subtest wait-delayed-signal: SUCCESS (0.103s) [209.399522] [024/132] (809s left) kms_plane_cursor (viewport) [209.501893] Starting subtest: viewport [209.506405] Starting dynamic subtest: pipe-A-eDP-1-size-64 [212.023113] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.519s) [212.082731] Starting dynamic subtest: pipe-A-eDP-1-size-128 [214.614687] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.538s) [214.674916] Starting dynamic subtest: pipe-A-eDP-1-size-256 [217.137960] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.471s) [217.496708] Starting dynamic subtest: pipe-B-eDP-1-size-64 [220.675034] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.186s) [220.733522] Starting dynamic subtest: pipe-B-eDP-1-size-128 [223.287675] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.560s) [223.348170] Starting dynamic subtest: pipe-B-eDP-1-size-256 [225.867103] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.526s) [226.233405] Starting dynamic subtest: pipe-C-eDP-1-size-64 [229.015556] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.794s) [229.053007] Starting dynamic subtest: pipe-C-eDP-1-size-128 [231.194096] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.147s) [231.230939] Starting dynamic subtest: pipe-C-eDP-1-size-256 [233.439257] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.214s) [233.773167] Starting dynamic subtest: pipe-D-eDP-1-size-64 [236.616943] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.852s) [236.653819] Starting dynamic subtest: pipe-D-eDP-1-size-128 [238.783938] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.136s) [238.822158] Starting dynamic subtest: pipe-D-eDP-1-size-256 [240.962594] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.147s) [241.281781] Subtest viewport: SUCCESS (31.763s) [242.095364] [025/132] (777s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen) [242.197072] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen [248.898604] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.701s) [249.048362] [026/132] (770s left) gem_exec_params (no-vebox) [249.117271] Starting subtest: no-vebox [249.119673] Subtest no-vebox: SUCCESS (0.002s) [251.008593] [027/132] (768s left) gem_exec_reloc (basic-cpu-gtt-active) [251.069386] Subtest basic-cpu-gtt-active: SKIP (0.000s) [251.136407] [028/132] (768s left) gem_tiled_partial_pwrite_pread (writes-after-reads) [251.200849] Subtest writes-after-reads: SKIP (0.000s) [251.279885] [029/132] (768s left) kms_big_fb (4-tiled-addfb-size-overflow) [251.384823] Starting subtest: 4-tiled-addfb-size-overflow [251.387226] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s) [251.486126] [030/132] (768s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier) [251.585720] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier [251.590131] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier: SKIP (0.000s) [251.660145] [031/132] (767s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes) [251.719307] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s) [251.782069] [032/132] (767s left) gem_ctx_engines (execute-allforone) [251.856336] Starting subtest: execute-allforone [251.870893] Subtest execute-allforone: SUCCESS (0.014s) [253.995630] [033/132] (765s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs) [254.052380] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs [254.056997] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s) [254.237696] [034/132] (765s left) kms_plane_scaling (plane-downscale-factor-0-75-with-modifiers) [254.342702] Starting subtest: plane-downscale-factor-0-75-with-modifiers [254.345033] Starting dynamic subtest: pipe-A [254.682271] Dynamic subtest pipe-A: SUCCESS (0.341s) [254.693404] Starting dynamic subtest: pipe-B [256.104532] Dynamic subtest pipe-B: SUCCESS (1.421s) [256.114489] Starting dynamic subtest: pipe-C [257.581682] Dynamic subtest pipe-C: SUCCESS (1.475s) [257.593881] Starting dynamic subtest: pipe-D [258.997354] Dynamic subtest pipe-D: SUCCESS (1.412s) [258.999800] Subtest plane-downscale-factor-0-75-with-modifiers: SUCCESS (4.656s) [260.160029] [035/132] (759s left) drm_mm (drm_mm) [260.208476] Starting subtest: drm_mm [260.257811] Starting dynamic subtest: drm_test_mm_init [260.346200] Dynamic subtest drm_test_mm_init: SUCCESS (0.087s) [260.355244] Starting dynamic subtest: drm_test_mm_debug [260.436731] Dynamic subtest drm_test_mm_debug: SUCCESS (0.087s) [260.446917] Starting dynamic subtest: drm_test_mm_align32 [260.530601] Dynamic subtest drm_test_mm_align32: SUCCESS (0.093s) [260.539161] Starting dynamic subtest: drm_test_mm_align64 [260.624023] Dynamic subtest drm_test_mm_align64: SUCCESS (0.093s) [260.632448] Starting dynamic subtest: drm_test_mm_lowest [260.713713] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.087s) [260.724294] Starting dynamic subtest: drm_test_mm_highest [260.807747] Dynamic subtest drm_test_mm_highest: SUCCESS (0.092s) [260.809900] Subtest drm_mm: SUCCESS (0.601s) [260.948004] [036/132] (758s left) gem_mmap_offset (mmap-unmap) [260.996752] Starting subtest: mmap-unmap [260.998948] Starting dynamic subtest: smem0 [285.020611] Dynamic subtest smem0: SUCCESS (24.041s) [285.023629] Subtest mmap-unmap: SUCCESS (24.043s) [285.138352] [037/132] (734s left) kms_invalid_mode (clock-too-high) [285.245682] Starting subtest: clock-too-high [285.247852] Starting dynamic subtest: pipe-A-eDP-1 [285.252195] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [285.261414] Starting dynamic subtest: pipe-B-eDP-1 [285.265319] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [285.274356] Starting dynamic subtest: pipe-C-eDP-1 [285.278676] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [285.288563] Starting dynamic subtest: pipe-D-eDP-1 [285.292753] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [285.297006] Subtest clock-too-high: SKIP (0.005s) [285.332836] [038/132] (734s left) gem_exec_whisper (basic-fds-forked-all) [285.398690] Starting subtest: basic-fds-forked-all [305.505814] Subtest basic-fds-forked-all: SUCCESS (20.112s) [305.691958] [039/132] (714s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt) [305.795384] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt [305.799445] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [305.879262] [040/132] (714s left) gem_mmap_gtt (basic-small-bo-tiledy) [305.936731] Subtest basic-small-bo-tiledY: SKIP (0.000s) [306.001960] [041/132] (713s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf) [306.095207] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf [306.099107] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s) [306.160673] [042/132] (713s left) gem_ctx_persistence (hostile) [306.212715] Starting subtest: hostile [315.071828] Subtest hostile: SUCCESS (8.857s) [315.207312] [043/132] (704s left) syncobj_wait (wait-all-delayed-signal) [315.258501] Starting subtest: wait-all-delayed-signal [315.361981] Subtest wait-all-delayed-signal: SUCCESS (0.102s) [315.435220] [044/132] (704s left) prime_busy (before-wait) [315.488170] Starting subtest: before-wait [315.493531] Starting dynamic subtest: rcs0 [315.521292] Dynamic subtest rcs0: SUCCESS (0.029s) [315.532411] Starting dynamic subtest: bcs0 [315.562565] Dynamic subtest bcs0: SUCCESS (0.040s) [315.572250] Starting dynamic subtest: vcs0 [315.605496] Dynamic subtest vcs0: SUCCESS (0.042s) [315.619900] Starting dynamic subtest: vcs1 [315.646448] Dynamic subtest vcs1: SUCCESS (0.039s) [315.656717] Starting dynamic subtest: vecs0 [315.688564] Dynamic subtest vecs0: SUCCESS (0.041s) [315.698723] Starting dynamic subtest: ccs0 [315.730682] Dynamic subtest ccs0: SUCCESS (0.042s) [315.839223] Subtest before-wait: SUCCESS (0.349s) [315.920535] [045/132] (704s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip) [316.025496] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip [317.082496] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.056s) [317.193001] [046/132] (702s left) gem_exec_fence (concurrent) [317.390744] Starting subtest: concurrent [317.395381] Subtest concurrent: SKIP (0.000s) [318.988840] [FACT gem_exec_fence (concurrent)] new: kernel.kmod_is_loaded.vgem: true [318.992126] [047/132] (701s left) kms_psr (fbc-psr-cursor-render) [319.074754] Starting subtest: fbc-psr-cursor-render [319.077044] Starting dynamic subtest: eDP-1 [319.081300] Dynamic subtest eDP-1: SKIP (0.000s) [319.085688] Subtest fbc-psr-cursor-render: SKIP (0.001s) [319.155047] [048/132] (701s left) fbdev (nullptr) [319.199385] Starting subtest: nullptr [319.201869] Subtest nullptr: SUCCESS (0.000s) [319.259751] [049/132] (701s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-gtt) [319.365236] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-gtt [319.369259] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [319.477356] [050/132] (700s left) api_intel_bb (intel-bb-blit-y) [319.528948] Starting subtest: intel-bb-blit-y [323.222194] Subtest intel-bb-blit-y: SUCCESS (3.693s) [323.332361] [051/132] (697s left) vgem_basic (setversion) [323.372350] Starting subtest: setversion [323.376505] Subtest setversion: SUCCESS (0.000s) [323.428865] [052/132] (696s left) i915_pm_rps (waitboost) [323.494282] Starting subtest: waitboost [329.598759] Subtest waitboost: SUCCESS (6.104s) [329.725340] [053/132] (690s left) kms_flip (blocking-wf_vblank) [329.823727] Starting subtest: blocking-wf_vblank [329.826093] Starting dynamic subtest: A-eDP1 [338.780800] Dynamic subtest A-eDP1: SUCCESS (8.955s) [338.796732] Starting dynamic subtest: B-eDP1 [347.709827] Dynamic subtest B-eDP1: SUCCESS (8.925s) [347.723408] Starting dynamic subtest: C-eDP1 [356.642610] Dynamic subtest C-eDP1: SUCCESS (8.927s) [356.653038] Starting dynamic subtest: D-eDP1 [365.573181] Dynamic subtest D-eDP1: SUCCESS (8.930s) [365.578292] Subtest blocking-wf_vblank: SUCCESS (35.748s) [366.805562] [054/132] (653s left) kms_big_fb (y-tiled-16bpp-rotate-0) [366.912738] Starting subtest: y-tiled-16bpp-rotate-0 [366.917166] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s) [367.024883] [055/132] (653s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy) [367.140842] Starting subtest: 2x-flip-vs-cursor-legacy [367.147327] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s) [367.287181] [056/132] (653s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25) [367.380494] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25 [367.382764] Starting dynamic subtest: pipe-A [367.444066] Dynamic subtest pipe-A: SUCCESS (0.065s) [367.453288] Starting dynamic subtest: pipe-B [368.634339] Dynamic subtest pipe-B: SUCCESS (1.189s) [368.645334] Starting dynamic subtest: pipe-C [369.754484] Dynamic subtest pipe-C: SUCCESS (1.119s) [369.764949] Starting dynamic subtest: pipe-D [371.108110] Dynamic subtest pipe-D: SUCCESS (1.352s) [371.110422] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.729s) [372.469150] [057/132] (648s left) kms_setmode (clone-exclusive-crtc) [372.545603] Starting subtest: clone-exclusive-crtc [372.552139] Subtest clone-exclusive-crtc: SKIP (0.000s) [372.655693] [058/132] (648s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling) [372.748582] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling [372.752753] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s) [372.822276] [059/132] (647s left) i915_pm_rpm (system-suspend-devices) [375.042270] Starting subtest: system-suspend-devices [382.715199] Subtest system-suspend-devices: SUCCESS (7.670s) [383.086336] [060/132] (637s left) kms_lease (lease-invalid-plane) [383.187026] Starting subtest: lease-invalid-plane [383.189427] Starting dynamic subtest: pipe-A-eDP-1 [383.191777] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [383.201535] Starting dynamic subtest: pipe-B-eDP-1 [383.203947] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [383.213830] Starting dynamic subtest: pipe-C-eDP-1 [383.216136] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [383.225004] Starting dynamic subtest: pipe-D-eDP-1 [383.226989] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [383.228839] Subtest lease-invalid-plane: SUCCESS (0.004s) [383.269796] [061/132] (637s left) gem_readwrite (new-obj) [383.330236] Subtest new-obj: SKIP (0.000s) [383.401343] [062/132] (637s left) kms_chamelium_hpd (hdmi-hpd-storm-disable) [383.784993] Subtest hdmi-hpd-storm-disable: SKIP (0.000s) [384.594781] [063/132] (636s left) syncobj_timeline (wait-any-interrupted) [384.658886] Starting subtest: wait-any-interrupted [384.766223] Subtest wait-any-interrupted: SUCCESS (0.105s) [384.868923] [064/132] (636s left) kms_big_fb (linear-32bpp-rotate-180) [384.975163] Starting subtest: linear-32bpp-rotate-180 [386.519184] Subtest linear-32bpp-rotate-180: SUCCESS (1.545s) [386.676486] [065/132] (634s left) kms_flip (basic-flip-vs-dpms) [386.772898] Starting subtest: basic-flip-vs-dpms [386.777018] Starting dynamic subtest: A-eDP1 [389.318723] Dynamic subtest A-eDP1: SUCCESS (2.542s) [389.329530] Starting dynamic subtest: B-eDP1 [391.523489] Dynamic subtest B-eDP1: SUCCESS (2.202s) [391.535237] Starting dynamic subtest: C-eDP1 [393.660500] Dynamic subtest C-eDP1: SUCCESS (2.135s) [393.670945] Starting dynamic subtest: D-eDP1 [395.738401] Dynamic subtest D-eDP1: SUCCESS (2.076s) [395.744116] Subtest basic-flip-vs-dpms: SUCCESS (8.971s) [396.539114] [066/132] (624s left) gem_mmap_gtt (basic-write) [396.608202] Subtest basic-write: SKIP (0.000s) [396.678536] [067/132] (624s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt) [396.776383] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt [396.780820] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [396.873563] [068/132] (624s left) kms_color (ctm-signed) [396.963889] Starting subtest: ctm-signed [396.965720] Starting dynamic subtest: pipe-A-eDP-1 [399.016649] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.053s) [399.027105] Starting dynamic subtest: pipe-B-eDP-1 [401.803368] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.786s) [401.814645] Starting dynamic subtest: pipe-C-eDP-1 [404.448296] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.644s) [404.458579] Starting dynamic subtest: pipe-D-eDP-1 [407.093849] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.645s) [407.096206] Subtest ctm-signed: SUCCESS (10.131s) [407.923521] [069/132] (613s left) gem_ctx_isolation (preservation-reset) [408.114667] Starting subtest: preservation-reset [408.117186] Starting dynamic subtest: rcs0 [408.431289] Dynamic subtest rcs0: SUCCESS (0.320s) [408.443880] Starting dynamic subtest: bcs0 [408.774434] Dynamic subtest bcs0: SUCCESS (0.342s) [408.786779] Starting dynamic subtest: vcs0 [409.145233] Dynamic subtest vcs0: SUCCESS (0.370s) [409.156680] Starting dynamic subtest: vcs1 [410.208385] Dynamic subtest vcs1: SUCCESS (1.062s) [410.220752] Starting dynamic subtest: vecs0 [412.218049] Dynamic subtest vecs0: SUCCESS (2.009s) [412.230249] Starting dynamic subtest: ccs0 [414.276939] Dynamic subtest ccs0: SUCCESS (2.058s) [414.279326] Subtest preservation-reset: SUCCESS (6.167s) [414.428925] [070/132] (606s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt) [414.519372] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt [414.523844] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [414.623373] [071/132] (606s left) gem_eio (wait-wedge-10ms) [414.864436] Starting subtest: wait-wedge-10ms [415.972042] Subtest wait-wedge-10ms: SUCCESS (1.106s) [416.114897] [072/132] (605s left) gem_mmap_wc (read-write) [416.162974] Subtest read-write: SKIP (0.000s) [416.226085] [073/132] (605s left) kms_cursor_crc (cursor-rapid-movement-256x85) [416.502780] Starting subtest: cursor-rapid-movement-256x85 [416.547979] Subtest cursor-rapid-movement-256x85: SKIP (0.043s) [416.724184] [074/132] (604s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [416.839027] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [416.843069] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [416.950563] [075/132] (604s left) kms_properties (colorop-properties-atomic) [417.047977] Starting subtest: colorop-properties-atomic [417.049538] Starting dynamic subtest: pipe-A-eDP-1 [417.386158] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.338s) [417.400499] Starting dynamic subtest: pipe-B-eDP-1 [418.498526] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.109s) [418.509528] Starting dynamic subtest: pipe-C-eDP-1 [419.528318] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.027s) [419.538688] Starting dynamic subtest: pipe-D-eDP-1 [420.562833] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.034s) [420.565157] Subtest colorop-properties-atomic: SUCCESS (3.515s) [421.357696] [076/132] (600s left) gem_ctx_sseu (invalid-args) [421.430238] Subtest invalid-args: SKIP (0.000s) [421.498534] [077/132] (599s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render) [421.600196] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render [421.604319] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [421.701602] [078/132] (599s left) syncobj_timeline (multi-wait-all-for-submit-available-submitted-signaled) [421.769514] Starting subtest: multi-wait-all-for-submit-available-submitted-signaled [421.772309] Subtest multi-wait-all-for-submit-available-submitted-signaled: SUCCESS (0.000s) [421.887151] [079/132] (599s left) kms_flip (2x-flip-vs-fences-interruptible) [421.975273] Starting subtest: 2x-flip-vs-fences-interruptible [421.979664] Subtest 2x-flip-vs-fences-interruptible: SKIP (0.000s) [422.081588] [080/132] (599s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt) [422.177937] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt [422.182152] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [422.272578] [081/132] (599s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-msflip-blt) [422.365919] Starting subtest: psr-2p-primscrn-indfb-msflip-blt [422.369426] Subtest psr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [422.462420] [082/132] (599s left) syncobj_timeline (etime-single-wait-available-unsubmitted) [422.518030] Starting subtest: etime-single-wait-available-unsubmitted [422.620248] Subtest etime-single-wait-available-unsubmitted: SUCCESS (0.101s) [422.714596] [083/132] (599s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt) [422.815147] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt [422.819206] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [422.921674] [084/132] (598s left) gem_userptr_blits (stress-mm-invalidate-close) [422.995133] Starting subtest: stress-mm-invalidate-close [425.144579] Subtest stress-mm-invalidate-close: SUCCESS (2.149s) [425.278267] [085/132] (596s left) gem_exec_reloc (basic-wc) [425.348420] Subtest basic-wc: SKIP (0.000s) [425.435548] [086/132] (596s left) gen7_exec_parse (basic-allocation) [425.491565] Subtest basic-allocation: SKIP (0.000s) [425.561314] [087/132] (596s left) syncobj_wait (invalid-signal-zero-handles) [425.611675] Starting subtest: invalid-signal-zero-handles [425.613547] Subtest invalid-signal-zero-handles: SUCCESS (0.000s) [425.711906] [088/132] (596s left) gem_huc_copy (huc-copy) [425.771436] Starting subtest: huc-copy [425.777327] Subtest huc-copy: SUCCESS (0.005s) [425.896455] [089/132] (596s left) gem_lmem_swapping (random-engines) [425.937078] Subtest random-engines: SKIP (0.000s) [425.985981] [090/132] (596s left) gem_softpin (evict-prime-sanity-check) [426.041216] Starting subtest: evict-prime-sanity-check [426.043380] Starting dynamic subtest: rcs0 [427.175506] Dynamic subtest rcs0: SUCCESS (1.133s) [427.189699] Starting dynamic subtest: bcs0 [428.283040] Dynamic subtest bcs0: SUCCESS (1.105s) [428.293070] Starting dynamic subtest: vcs0 [429.879726] Dynamic subtest vcs0: SUCCESS (1.593s) [429.891874] Starting dynamic subtest: vcs1 [431.863880] Dynamic subtest vcs1: SUCCESS (1.982s) [431.875355] Starting dynamic subtest: vecs0 [433.928333] Dynamic subtest vecs0: SUCCESS (2.061s) [433.940340] Starting dynamic subtest: ccs0 [435.044847] Dynamic subtest ccs0: SUCCESS (1.116s) [435.064813] Starting dynamic subtest: all [436.160269] Dynamic subtest all: SUCCESS (1.112s) [436.162885] Subtest evict-prime-sanity-check: SUCCESS (10.119s) [436.261727] [091/132] (585s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted) [436.313780] Starting subtest: multi-wait-all-for-submit-unsubmitted [436.421109] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.107s) [436.506898] [092/132] (585s left) gem_pread (display) [436.561656] Subtest display: SKIP (0.000s) [436.622679] [093/132] (585s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled) [436.673107] Starting subtest: multi-wait-for-submit-available-submitted-signaled [436.675462] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s) [436.778387] [094/132] (585s left) kms_selftest (drm_framebuffer) [436.817372] Starting subtest: drm_framebuffer [436.878193] Starting dynamic subtest: drm_test_framebuffer_check_src_coords [436.977713] Dynamic subtest drm_test_framebuffer_check_src_coords: SUCCESS (0.100s) [436.988696] Starting dynamic subtest: drm_test_framebuffer_cleanup [437.108768] Dynamic subtest drm_test_framebuffer_cleanup: SUCCESS (0.131s) [437.120707] Starting dynamic subtest: drm_test_framebuffer_create [437.303990] Dynamic subtest drm_test_framebuffer_create: SUCCESS (0.192s) [437.316316] Starting dynamic subtest: drm_test_framebuffer_free [437.557821] Dynamic subtest drm_test_framebuffer_free: FAIL (0.204s) [437.562137] Subtest drm_framebuffer: FAIL (0.694s) [437.653827] Aborting: Kernel badly tainted (0x44244, 0x200) (check dmesg for details): TAINT_WARN: WARN_ON has happened. [437.674961] [FACT kms_selftest (drm_framebuffer)] new: kernel.is_tainted.taint_warn: true [437.675982] Closing watchdogs results: parsing output: 0/ for test: prime_mmap results: parsing output: 1/ for test: gem_ctx_bad_destroy results: parsing output: 2/ for test: gen7_exec_parse results: parsing output: 3/ for test: kms_psr results: parsing output: 4/ for test: gem_exec_schedule results: parsing output: 5/ for test: kms_fbcon_fbt results: parsing output: 6/ for test: kms_psr results: parsing output: 7/ for test: kms_frontbuffer_tracking results: parsing output: 8/ for test: kms_ccs results: parsing output: 9/ for test: api_intel_allocator results: parsing output: 10/ for test: kms_frontbuffer_tracking results: parsing output: 11/ for test: syncobj_timeline results: parsing output: 12/ for test: kms_frontbuffer_tracking results: parsing output: 13/ for test: kms_vblank results: parsing output: 14/ for test: kms_cursor_legacy results: parsing output: 15/ for test: gem_exec_balancer results: parsing output: 16/ for test: kms_pm_rpm results: parsing output: 17/ for test: kms_addfb_basic results: parsing output: 18/ for test: sysfs_timeslice_duration results: parsing output: 19/ for test: kms_scaling_modes results: parsing output: 20/ for test: gem_pxp results: parsing output: 21/ for test: kms_big_fb results: parsing output: 22/ for test: syncobj_wait results: parsing output: 23/ for test: kms_plane_cursor results: parsing output: 24/ for test: kms_frontbuffer_tracking results: parsing output: 25/ for test: gem_exec_params results: parsing output: 26/ for test: gem_exec_reloc results: parsing output: 27/ for test: gem_tiled_partial_pwrite_pread results: parsing output: 28/ for test: kms_big_fb results: parsing output: 29/ for test: kms_plane results: parsing output: 30/ for test: kms_pipe_b_c_ivb results: parsing output: 31/ for test: gem_ctx_engines results: parsing output: 32/ for test: gem_render_copy results: parsing output: 33/ for test: kms_plane_scaling results: parsing output: 34/ for test: drm_mm results: parsing output: 35/ for test: gem_mmap_offset results: parsing output: 36/ for test: kms_invalid_mode results: parsing output: 37/ for test: gem_exec_whisper results: parsing output: 38/ for test: kms_frontbuffer_tracking results: parsing output: 39/ for test: gem_mmap_gtt results: parsing output: 40/ for test: kms_psr2_sf results: parsing output: 41/ for test: gem_ctx_persistence results: parsing output: 42/ for test: syncobj_wait results: parsing output: 43/ for test: prime_busy results: parsing output: 44/ for test: kms_big_fb results: parsing output: 45/ for test: gem_exec_fence results: parsing output: 46/ for test: kms_psr results: parsing output: 47/ for test: fbdev results: parsing output: 48/ for test: kms_frontbuffer_tracking results: parsing output: 49/ for test: api_intel_bb results: parsing output: 50/ for test: vgem_basic results: parsing output: 51/ for test: i915_pm_rps results: parsing output: 52/ for test: kms_flip results: parsing output: 53/ for test: kms_big_fb results: parsing output: 54/ for test: kms_cursor_legacy results: parsing output: 55/ for test: kms_plane_scaling results: parsing output: 56/ for test: kms_setmode results: parsing output: 57/ for test: kms_flip_scaled_crc results: parsing output: 58/ for test: i915_pm_rpm results: parsing output: 59/ for test: kms_lease results: parsing output: 60/ for test: gem_readwrite results: parsing output: 61/ for test: kms_chamelium_hpd results: parsing output: 62/ for test: syncobj_timeline results: parsing output: 63/ for test: kms_big_fb results: parsing output: 64/ for test: kms_flip results: parsing output: 65/ for test: gem_mmap_gtt results: parsing output: 66/ for test: kms_frontbuffer_tracking results: parsing output: 67/ for test: kms_color results: parsing output: 68/ for test: gem_ctx_isolation results: parsing output: 69/ for test: kms_frontbuffer_tracking results: parsing output: 70/ for test: gem_eio results: parsing output: 71/ for test: gem_mmap_wc results: parsing output: 72/ for test: kms_cursor_crc results: parsing output: 73/ for test: kms_big_fb results: parsing output: 74/ for test: kms_properties results: parsing output: 75/ for test: gem_ctx_sseu results: parsing output: 76/ for test: kms_frontbuffer_tracking results: parsing output: 77/ for test: syncobj_timeline results: parsing output: 78/ for test: kms_flip results: parsing output: 79/ for test: kms_frontbuffer_tracking results: parsing output: 80/ for test: kms_frontbuffer_tracking results: parsing output: 81/ for test: syncobj_timeline results: parsing output: 82/ for test: kms_frontbuffer_tracking results: parsing output: 83/ for test: gem_userptr_blits results: parsing output: 84/ for test: gem_exec_reloc results: parsing output: 85/ for test: gen7_exec_parse results: parsing output: 86/ for test: syncobj_wait results: parsing output: 87/ for test: gem_huc_copy results: parsing output: 88/ for test: gem_lmem_swapping results: parsing output: 89/ for test: gem_softpin results: parsing output: 90/ for test: syncobj_wait results: parsing output: 91/ for test: gem_pread results: parsing output: 92/ for test: syncobj_timeline results: parsing output: 93/ for test: kms_selftest results: parsing output: 94/ for test: kms_chamelium_edid results: no output, setting notrun results: parsing output: 95/ for test: i915_drm_fdinfo results: no output, setting notrun results: parsing output: 96/ for test: kms_content_protection results: no output, setting notrun results: parsing output: 97/ for test: kms_ccs results: no output, setting notrun results: parsing output: 98/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 99/ for test: gen9_exec_parse results: no output, setting notrun results: parsing output: 100/ for test: gem_exec_fence results: no output, setting notrun results: parsing output: 101/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 102/ for test: kms_atomic_transition results: no output, setting notrun results: parsing output: 103/ for test: kms_multipipe_modeset results: no output, setting notrun results: parsing output: 104/ for test: kms_pm_rpm results: no output, setting notrun results: parsing output: 105/ for test: kms_ccs results: no output, setting notrun results: parsing output: 106/ for test: kms_dither results: no output, setting notrun results: parsing output: 107/ for test: kms_flip_scaled_crc results: no output, setting notrun results: parsing output: 108/ for test: kms_cursor_crc results: no output, setting notrun results: parsing output: 109/ for test: kms_chamelium_color results: no output, setting notrun results: parsing output: 110/ for test: kms_feature_discovery results: no output, setting notrun results: parsing output: 111/ for test: kms_ccs results: no output, setting notrun results: parsing output: 112/ for test: perf results: no output, setting notrun results: parsing output: 113/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 114/ for test: gem_exec_schedule results: no output, setting notrun results: parsing output: 115/ for test: gem_eio results: no output, setting notrun results: parsing output: 116/ for test: gem_exec_parallel results: no output, setting notrun results: parsing output: 117/ for test: kms_frontbuffer_tracking results: no output, setting notrun results: parsing output: 118/ for test: kms_big_fb results: no output, setting notrun results: parsing output: 119/ for test: kms_cursor_edge_walk results: no output, setting notrun results: parsing output: 120/ for test: kms_atomic results: no output, setting notrun results: parsing output: 121/ for test: kms_async_flips results: no output, setting notrun results: parsing output: 122/ for test: gem_eio results: no output, setting notrun results: parsing output: 123/ for test: kms_cursor_legacy results: no output, setting notrun results: parsing output: 124/ for test: kms_psr results: no output, setting notrun results: parsing output: 125/ for test: kms_flip results: no output, setting notrun results: parsing output: 126/ for test: kms_psr results: no output, setting notrun results: parsing output: 127/ for test: kms_hdr results: no output, setting notrun results: parsing output: 128/ for test: gem_mmap results: no output, setting notrun results: parsing output: 129/ for test: gem_userptr_blits results: no output, setting notrun results: parsing output: 130/ for test: kms_cursor_legacy results: no output, setting notrun results: parsing output: 131/ for test: perf_pmu results: no output, setting notrun Done.