[53.055477] Initializing watchdogs [53.055525] /dev/watchdog0 [53.070784] [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] [53.075148] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [53.077544] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [53.080826] [001/133] (960s left) prime_busy (before) [53.171642] Starting subtest: before [53.176620] Starting dynamic subtest: rcs0 [53.213616] Dynamic subtest rcs0: SUCCESS (0.038s) [53.224074] Starting dynamic subtest: bcs0 [53.266615] Dynamic subtest bcs0: SUCCESS (0.053s) [53.275348] Starting dynamic subtest: vcs0 [53.309339] Dynamic subtest vcs0: SUCCESS (0.042s) [53.317861] Starting dynamic subtest: vcs1 [53.349912] Dynamic subtest vcs1: SUCCESS (0.041s) [53.358540] Starting dynamic subtest: vecs0 [53.392183] Dynamic subtest vecs0: SUCCESS (0.042s) [53.399928] Starting dynamic subtest: ccs0 [53.435792] Dynamic subtest ccs0: SUCCESS (0.043s) [53.544436] Subtest before: SUCCESS (0.370s) [53.617419] [002/133] (960s left) gem_exec_fence (keep-in-fence) [53.802150] Starting subtest: keep-in-fence [53.804740] Starting dynamic subtest: rcs0 [53.871973] Dynamic subtest rcs0: SUCCESS (0.070s) [53.880750] Starting dynamic subtest: bcs0 [53.926997] Dynamic subtest bcs0: SUCCESS (0.055s) [53.936413] Starting dynamic subtest: vcs0 [55.894849] Dynamic subtest vcs0: SUCCESS (1.966s) [55.905872] Starting dynamic subtest: vcs1 [57.879448] Dynamic subtest vcs1: SUCCESS (1.983s) [57.894441] Starting dynamic subtest: vecs0 [59.862932] Dynamic subtest vecs0: SUCCESS (1.981s) [59.875203] Starting dynamic subtest: ccs0 [60.089061] Dynamic subtest ccs0: SUCCESS (0.227s) [60.092036] Subtest keep-in-fence: SUCCESS (6.287s) [61.989522] [FACT gem_exec_fence (keep-in-fence)] new: kernel.kmod_is_loaded.vgem: true [61.994802] [003/133] (951s left) kms_panel_fitting (atomic-fastset) [62.094089] Starting subtest: atomic-fastset [62.096425] Starting dynamic subtest: pipe-A-eDP-1 [62.264487] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.170s) [62.274734] Starting dynamic subtest: pipe-B-eDP-1 [63.500089] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.235s) [63.510621] Starting dynamic subtest: pipe-C-eDP-1 [64.679931] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.179s) [64.688986] Starting dynamic subtest: pipe-D-eDP-1 [65.848563] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.168s) [65.850866] Subtest atomic-fastset: SUCCESS (3.754s) [67.121988] [004/133] (946s left) kms_flip (2x-flip-vs-blocking-wf-vblank) [67.256673] Starting subtest: 2x-flip-vs-blocking-wf-vblank [67.268332] Subtest 2x-flip-vs-blocking-wf-vblank: SKIP (0.011s) [67.499750] [005/133] (946s left) kms_pipe_crc_basic (nonblocking-crc) [67.680181] Starting subtest: nonblocking-crc [67.682232] Starting dynamic subtest: pipe-A-eDP-1 [68.477675] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.796s) [68.487346] Starting dynamic subtest: pipe-B-eDP-1 [69.931418] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.456s) [69.939579] Starting dynamic subtest: pipe-C-eDP-1 [71.274788] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.340s) [71.284080] Starting dynamic subtest: pipe-D-eDP-1 [72.608373] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.332s) [72.610388] Subtest nonblocking-crc: SUCCESS (4.928s) [73.414897] [006/133] (940s left) kms_setmode (invalid-clone-exclusive-crtc) [73.474854] Starting subtest: invalid-clone-exclusive-crtc [73.481184] Subtest invalid-clone-exclusive-crtc: SKIP (0.000s) [73.567907] [007/133] (940s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [73.670138] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip [73.674604] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s) [73.778076] [008/133] (940s left) gem_lmem_swapping (random-engines) [73.823419] Subtest random-engines: SKIP (0.000s) [73.863019] [009/133] (940s left) kms_psr (fbc-pr-sprite-mmap-cpu) [73.951865] Starting subtest: fbc-pr-sprite-mmap-cpu [73.956367] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s) [74.028811] [010/133] (939s left) gem_eio (context-create) [74.234536] Starting subtest: context-create [74.535204] Subtest context-create: SUCCESS (0.301s) [74.647418] [011/133] (939s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt) [74.744341] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt [74.747858] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [74.846334] [012/133] (939s left) kms_color (ctm-signed) [74.948976] Starting subtest: ctm-signed [74.950620] Starting dynamic subtest: pipe-A-eDP-1 [77.122445] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.172s) [77.130648] Starting dynamic subtest: pipe-B-eDP-1 [79.967696] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.844s) [79.975635] Starting dynamic subtest: pipe-C-eDP-1 [82.680454] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.713s) [82.688673] Starting dynamic subtest: pipe-D-eDP-1 [85.336123] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.654s) [85.338065] Subtest ctm-signed: SUCCESS (10.385s) [86.171530] [013/133] (927s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen) [86.265529] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen [86.270075] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [86.368071] [014/133] (927s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-pwrite) [86.465692] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-pwrite [95.827848] Subtest psr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.365s) [95.943497] [015/133] (918s left) gem_eio (execbuf) [96.147864] Starting subtest: execbuf [96.442524] Subtest execbuf: SUCCESS (0.293s) [96.554414] [016/133] (917s left) kms_pm_rpm (cursor) [98.107812] Starting subtest: cursor [98.112688] Subtest cursor: SKIP (0.000s) [98.823468] [017/133] (915s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier-source-clamping) [98.928198] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier-source-clamping [98.932308] Subtest pixel-format-4-tiled-lnl-ccs-modifier-source-clamping: SKIP (0.000s) [99.014973] [018/133] (915s left) kms_fbcon_fbt (fbc-suspend) [99.069783] Starting subtest: fbc-suspend [149.125521] Subtest fbc-suspend: SUCCESS (19.930s) [153.453408] [019/133] (863s left) gem_exec_parallel (basic) [153.525267] Starting subtest: basic [153.527544] Starting dynamic subtest: rcs0 [155.031482] Dynamic subtest rcs0: SUCCESS (1.505s) [155.042743] Starting dynamic subtest: bcs0 [156.496373] Dynamic subtest bcs0: SUCCESS (1.463s) [156.505830] Starting dynamic subtest: vcs0 [158.037918] Dynamic subtest vcs0: SUCCESS (1.539s) [158.046675] Starting dynamic subtest: vcs1 [160.065131] Dynamic subtest vcs1: SUCCESS (2.025s) [160.075063] Starting dynamic subtest: vecs0 [161.984129] Dynamic subtest vecs0: SUCCESS (1.917s) [161.994066] Starting dynamic subtest: ccs0 [163.453907] Dynamic subtest ccs0: SUCCESS (1.469s) [163.456578] Subtest basic: SUCCESS (9.928s) [163.651689] [020/133] (853s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs) [163.746749] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs [163.749074] Starting dynamic subtest: pipe-A-eDP-1 [163.774336] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [163.784346] Starting dynamic subtest: pipe-B-eDP-1 [163.808654] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [163.816950] Starting dynamic subtest: pipe-C-eDP-1 [163.840986] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [163.849300] Starting dynamic subtest: pipe-D-eDP-1 [163.873484] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [163.877603] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.003s) [166.036310] [021/133] (851s left) gem_exec_reloc (basic-write-wc-active) [166.094647] Subtest basic-write-wc-active: SKIP (0.000s) [166.158910] [022/133] (851s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc) [166.238234] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc [166.240571] Starting dynamic subtest: pipe-A-eDP-1 [166.260916] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [166.271250] Starting dynamic subtest: pipe-B-eDP-1 [166.290459] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [166.298939] Starting dynamic subtest: pipe-C-eDP-1 [166.317995] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [166.326406] Starting dynamic subtest: pipe-D-eDP-1 [166.345083] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [166.347125] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.004s) [168.498855] [023/133] (849s left) kms_cursor_crc (cursor-rapid-movement-max-size) [168.796074] Starting subtest: cursor-rapid-movement-max-size [168.802283] Subtest cursor-rapid-movement-max-size: SKIP (0.000s) [168.925960] [024/133] (848s left) gem_exec_reloc (basic-write-gtt-active) [168.987088] Subtest basic-write-gtt-active: SKIP (0.000s) [169.057683] [025/133] (848s left) kms_plane_cursor (viewport) [169.150062] Starting subtest: viewport [169.154932] Starting dynamic subtest: pipe-A-eDP-1-size-64 [171.757894] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.608s) [171.818316] Starting dynamic subtest: pipe-A-eDP-1-size-128 [174.358562] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.549s) [174.418664] Starting dynamic subtest: pipe-A-eDP-1-size-256 [176.970967] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.560s) [177.336058] Starting dynamic subtest: pipe-B-eDP-1-size-64 [180.579129] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.254s) [180.637518] Starting dynamic subtest: pipe-B-eDP-1-size-128 [183.189293] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.560s) [183.249469] Starting dynamic subtest: pipe-B-eDP-1-size-256 [185.835262] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.593s) [186.199308] Starting dynamic subtest: pipe-C-eDP-1-size-64 [189.126377] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.938s) [189.165226] Starting dynamic subtest: pipe-C-eDP-1-size-128 [191.393015] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.236s) [191.429593] Starting dynamic subtest: pipe-C-eDP-1-size-256 [193.604301] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.181s) [193.939923] Starting dynamic subtest: pipe-D-eDP-1-size-64 [196.794464] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.864s) [196.832501] Starting dynamic subtest: pipe-D-eDP-1-size-128 [199.005447] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.180s) [199.043912] Starting dynamic subtest: pipe-D-eDP-1-size-256 [201.206422] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.169s) [201.535789] Subtest viewport: SUCCESS (32.383s) [202.368886] [026/133] (815s left) gem_pxp (fail-invalid-protected-context) [202.499045] Starting subtest: fail-invalid-protected-context [202.501517] Subtest fail-invalid-protected-context: SUCCESS (0.000s) [202.631189] [027/133] (815s left) gem_softpin (evict-prime) [202.699643] Starting subtest: evict-prime [202.701603] Starting dynamic subtest: rcs0 [203.857874] Dynamic subtest rcs0: SUCCESS (1.160s) [203.868926] Starting dynamic subtest: bcs0 [204.981693] Dynamic subtest bcs0: SUCCESS (1.122s) [204.991610] Starting dynamic subtest: vcs0 [207.044948] Dynamic subtest vcs0: SUCCESS (2.060s) [207.057221] Starting dynamic subtest: vcs1 [209.026463] Dynamic subtest vcs1: SUCCESS (1.979s) [209.038544] Starting dynamic subtest: vecs0 [211.011644] Dynamic subtest vecs0: SUCCESS (1.983s) [211.023469] Starting dynamic subtest: ccs0 [212.145859] Dynamic subtest ccs0: SUCCESS (1.133s) [212.157087] Starting dynamic subtest: all [214.010059] Dynamic subtest all: SUCCESS (1.860s) [214.013025] Subtest evict-prime: SUCCESS (11.312s) [214.105222] [028/133] (803s left) kms_invalid_mode (bad-hsync-end) [214.202314] Starting subtest: bad-hsync-end [214.204788] Starting dynamic subtest: pipe-A-eDP-1 [214.487550] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s) [214.496747] Starting dynamic subtest: pipe-B-eDP-1 [214.498905] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [214.507325] Starting dynamic subtest: pipe-C-eDP-1 [214.509516] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [214.518793] Starting dynamic subtest: pipe-D-eDP-1 [214.521143] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [214.523359] Subtest bad-hsync-end: SUCCESS (0.290s) [215.297564] [029/133] (802s left) i915_pm_rc6_residency (rc6-idle) [215.363605] Starting subtest: rc6-idle [215.388715] Starting dynamic subtest: gt0-rcs0 [239.605689] Dynamic subtest gt0-rcs0: SUCCESS (24.215s) [239.614301] Starting dynamic subtest: gt0-bcs0 [263.900201] Dynamic subtest gt0-bcs0: SUCCESS (24.292s) [263.909169] Starting dynamic subtest: gt0-ccs0 [288.190974] Dynamic subtest gt0-ccs0: SUCCESS (24.288s) [288.200258] Starting dynamic subtest: gt1-vcs0 [294.365065] Dynamic subtest gt1-vcs0: SUCCESS (6.169s) [294.376753] Starting dynamic subtest: gt1-vecs0 [300.534488] Dynamic subtest gt1-vecs0: SUCCESS (6.169s) [300.537093] Subtest rc6-idle: SUCCESS (85.171s) [300.630075] [030/133] (717s left) sysfs_timeslice_duration (idempotent) [300.697369] Starting subtest: idempotent [300.699847] Starting dynamic subtest: vecs0 [300.702218] Dynamic subtest vecs0: SUCCESS (0.000s) [300.713134] Starting dynamic subtest: ccs0 [300.715298] Dynamic subtest ccs0: SUCCESS (0.000s) [300.724206] Starting dynamic subtest: vcs0 [300.726464] Dynamic subtest vcs0: SUCCESS (0.000s) [300.735502] Starting dynamic subtest: bcs0 [300.737413] Dynamic subtest bcs0: SUCCESS (0.000s) [300.746917] Starting dynamic subtest: rcs0 [300.749249] Dynamic subtest rcs0: SUCCESS (0.000s) [300.757796] Starting dynamic subtest: vcs1 [300.759904] Dynamic subtest vcs1: SUCCESS (0.000s) [300.761803] Subtest idempotent: SUCCESS (0.006s) [300.799320] [031/133] (717s left) syncobj_eventfd (timeline-wait-signaled) [300.864010] Starting subtest: timeline-wait-signaled [300.866500] Subtest timeline-wait-signaled: SUCCESS (0.001s) [300.988775] [032/133] (716s left) kms_pm_rpm (i2c) [303.229774] Starting subtest: i2c [308.562368] Subtest i2c: SUCCESS (5.335s) [308.684771] [033/133] (709s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs) [308.774434] Starting subtest: ccs-on-another-bo-y-tiled-ccs [308.776729] Starting dynamic subtest: pipe-A-eDP-1 [308.799427] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [308.811074] Starting dynamic subtest: pipe-B-eDP-1 [308.831728] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [308.840465] Starting dynamic subtest: pipe-C-eDP-1 [308.861349] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [308.870266] Starting dynamic subtest: pipe-D-eDP-1 [308.892087] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [308.896737] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.005s) [311.098429] [034/133] (706s left) gem_reg_read (timestamp-monotonic) [311.148937] Starting subtest: timestamp-monotonic [316.093632] Subtest timestamp-monotonic: SUCCESS (4.944s) [316.181411] [035/133] (701s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt) [316.281176] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt [320.758998] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.480s) [321.917616] [036/133] (696s left) dmabuf_sync_file (export-multiwait) [321.968469] Starting subtest: export-multiwait [321.970500] Subtest export-multiwait: SUCCESS (0.001s) [322.031262] [037/133] (696s left) gem_pxp (reject-modify-context-protection-off-3) [322.134700] Starting subtest: reject-modify-context-protection-off-3 [322.136983] Subtest reject-modify-context-protection-off-3: SUCCESS (0.001s) [322.267439] [038/133] (695s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip) [322.374098] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip [322.378958] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s) [322.468928] [039/133] (695s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [322.554321] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s) [322.647584] [040/133] (695s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted) [322.707268] Starting subtest: etime-single-wait-for-submit-unsubmitted [322.812497] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.105s) [322.886841] [041/133] (695s left) gem_basic (multigpu-create-close) [322.943427] Starting subtest: multigpu-create-close [322.947799] Subtest multigpu-create-close: SKIP (0.000s) [323.028256] [042/133] (695s left) gem_ctx_param (invalid-param-set) [323.079774] Starting subtest: invalid-param-set [323.082045] Subtest invalid-param-set: SUCCESS (0.000s) [323.156085] [043/133] (695s left) gen3_render_mixed_blits [323.270804] [044/133] (695s left) gem_mmap_offset (open-flood) [323.324369] Starting subtest: open-flood [344.815580] Subtest open-flood: SUCCESS (21.492s) [344.936683] [045/133] (673s left) api_intel_allocator (two-level-inception-interruptible) [345.003373] Starting subtest: two-level-inception-interruptible [350.408682] Subtest two-level-inception-interruptible: SUCCESS (5.405s) [350.538142] [046/133] (667s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf) [350.651444] Starting subtest: psr2-cursor-plane-move-continuous-sf [350.653790] Starting dynamic subtest: pipe-A-eDP-1 [361.006578] Dynamic subtest pipe-A-eDP-1: SUCCESS (10.355s) [361.017436] Starting dynamic subtest: pipe-B-eDP-1 [372.070653] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.060s) [372.072682] Subtest psr2-cursor-plane-move-continuous-sf: SUCCESS (21.418s) [372.864313] [047/133] (645s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0) [372.976350] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0 [373.967336] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (0.990s) [374.092888] [048/133] (644s left) kms_flip (2x-flip-vs-expired-vblank-interruptible) [374.194579] Starting subtest: 2x-flip-vs-expired-vblank-interruptible [374.206735] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.011s) [374.284414] [049/133] (644s left) gem_exec_whisper (basic-fds-forked-all) [374.352507] Starting subtest: basic-fds-forked-all [394.256960] Subtest basic-fds-forked-all: SUCCESS (19.899s) [394.443387] [050/133] (624s left) gem_ctx_persistence (saturated-hostile) [394.497458] Starting subtest: saturated-hostile [394.499648] Starting dynamic subtest: rcs0 [395.325280] Dynamic subtest rcs0: SUCCESS (0.829s) [395.337378] Starting dynamic subtest: bcs0 [396.125728] Dynamic subtest bcs0: SUCCESS (0.799s) [396.137911] Starting dynamic subtest: vcs0 [396.899964] Dynamic subtest vcs0: SUCCESS (0.774s) [396.910535] Starting dynamic subtest: vcs1 [397.698563] Dynamic subtest vcs1: SUCCESS (0.797s) [397.710037] Starting dynamic subtest: vecs0 [398.478726] Dynamic subtest vecs0: SUCCESS (0.778s) [398.491678] Starting dynamic subtest: ccs0 [399.316009] Dynamic subtest ccs0: SUCCESS (0.835s) [399.318698] Subtest saturated-hostile: SUCCESS (4.823s) [399.399782] [051/133] (619s left) kms_vblank (query-busy) [399.492193] Starting subtest: query-busy [399.494444] Starting dynamic subtest: pipe-A-eDP-1 [401.372454] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.880s) [401.388066] Starting dynamic subtest: pipe-D-eDP-1 [403.919302] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.544s) [403.921276] Subtest query-busy: SUCCESS (4.427s) [404.717196] [052/133] (614s left) gen9_exec_parse (batch-invalid-length) [404.770959] Subtest batch-invalid-length: SKIP (0.000s) [404.845512] [053/133] (613s left) gem_exec_balancer (parallel-out-fence) [405.102515] Starting subtest: parallel-out-fence [406.182643] Subtest parallel-out-fence: SUCCESS (1.083s) [406.285767] [054/133] (612s left) gem_mmap_gtt (big-bo-tiledy) [406.335304] Subtest big-bo-tiledY: SKIP (0.000s) [406.403270] [055/133] (612s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt) [406.501301] Starting subtest: psr-rgb101010-draw-blt [413.875337] Subtest psr-rgb101010-draw-blt: SUCCESS (7.377s) [413.991402] [056/133] (604s left) kms_setmode (basic-clone-single-crtc) [414.041869] Starting subtest: basic-clone-single-crtc [414.048533] Subtest basic-clone-single-crtc: SKIP (0.000s) [414.154248] [057/133] (604s left) kms_psr (psr-sprite-blt) [414.250622] Starting subtest: psr-sprite-blt [414.252864] Starting dynamic subtest: eDP-1 [415.967095] Dynamic subtest eDP-1: SUCCESS (1.715s) [415.969425] Subtest psr-sprite-blt: SUCCESS (1.716s) [416.805212] [058/133] (602s left) i915_suspend (fence-restore-untiled) [416.851109] Starting subtest: fence-restore-untiled [416.855222] Subtest fence-restore-untiled: SKIP (0.000s) [416.951416] [059/133] (602s left) i915_module_load (reload) [416.982859] Starting subtest: reload [421.882177] Subtest reload: SUCCESS (4.900s) [421.922800] [060/133] (597s left) kms_flip (2x-flip-vs-modeset) [423.052493] Starting subtest: 2x-flip-vs-modeset [423.061703] Subtest 2x-flip-vs-modeset: SKIP (0.011s) [423.145175] [061/133] (596s left) kms_cdclk (mode-transition-all-outputs) [423.237769] Starting subtest: mode-transition-all-outputs [423.529562] Subtest mode-transition-all-outputs: SKIP (0.290s) [424.352403] [062/133] (594s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff) [424.442089] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff [424.446325] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s) [424.552064] [063/133] (594s left) gem_gtt_cpu_tlb [424.658898] [064/133] (594s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip) [424.775952] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip [424.780145] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s) [424.868766] [065/133] (594s left) syncobj_wait (multi-wait-all-for-submit-signaled) [424.928871] Starting subtest: multi-wait-all-for-submit-signaled [424.931221] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s) [425.051439] [066/133] (594s left) kms_addfb_basic (invalid-get-prop) [425.114616] Starting subtest: invalid-get-prop [425.116982] Subtest invalid-get-prop: SUCCESS (0.000s) [425.253304] [067/133] (594s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling) [425.338682] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling [425.340642] Starting dynamic subtest: pipe-A-default-mode [428.084080] Dynamic subtest pipe-A-default-mode: SUCCESS (2.745s) [428.086532] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.747s) [428.956718] [068/133] (590s left) sw_sync (sync_multi_timeline_wait) [428.991561] Starting subtest: sync_multi_timeline_wait [428.993765] Subtest sync_multi_timeline_wait: SUCCESS (0.000s) [429.055559] [069/133] (590s left) gem_exec_balancer (parallel-balancer) [429.308781] Starting subtest: parallel-balancer [430.213799] Subtest parallel-balancer: SUCCESS (0.905s) [430.312810] [070/133] (589s left) kms_busy (basic-hang) [430.417586] Starting subtest: basic-hang [430.419979] Starting dynamic subtest: flip-pipe-A [431.014131] Dynamic subtest flip-pipe-A: SUCCESS (0.599s) [431.023957] Starting dynamic subtest: modeset-pipe-A [434.469218] Dynamic subtest modeset-pipe-A: SUCCESS (3.455s) [434.482507] Starting dynamic subtest: flip-pipe-D [435.671154] Dynamic subtest flip-pipe-D: SUCCESS (1.197s) [435.680921] Starting dynamic subtest: modeset-pipe-D [439.115076] Dynamic subtest modeset-pipe-D: SUCCESS (3.443s) [439.117919] Subtest basic-hang: SUCCESS (8.701s) [439.912730] [071/133] (579s left) kms_psr (psr-cursor-plane-move) [440.008953] Starting subtest: psr-cursor-plane-move [440.011263] Starting dynamic subtest: eDP-1 [441.729674] Dynamic subtest eDP-1: SUCCESS (1.720s) [441.731958] Subtest psr-cursor-plane-move: SUCCESS (1.721s) [442.590283] [072/133] (577s left) kms_psr (fbc-pr-primary-mmap-cpu) [442.686360] Starting subtest: fbc-pr-primary-mmap-cpu [442.690536] Subtest fbc-pr-primary-mmap-cpu: SKIP (0.000s) [442.759592] [073/133] (576s left) kms_big_fb (4-tiled-64bpp-rotate-270) [442.860373] Starting subtest: 4-tiled-64bpp-rotate-270 [442.880540] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.019s) [443.009957] [074/133] (576s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-cpu) [443.106669] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-cpu [443.110615] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [443.207085] [075/133] (576s left) core_auth (getclient-master-drop) [443.242112] Starting subtest: getclient-master-drop [443.262102] Subtest getclient-master-drop: SUCCESS (0.027s) [443.353449] [076/133] (576s left) kms_content_protection (atomic-dpms) [443.508619] Starting subtest: atomic-dpms [443.513213] Subtest atomic-dpms: SKIP (0.000s) [443.614503] [077/133] (576s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt) [443.704218] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt [450.986377] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.285s) [451.113080] [078/133] (568s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt) [451.220873] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt [451.225319] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [451.321382] [079/133] (568s left) gem_exec_schedule (preempt-other) [451.396107] Starting subtest: preempt-other [451.398451] Starting dynamic subtest: rcs0 [451.461731] Dynamic subtest rcs0: SUCCESS (0.072s) [451.475802] Starting dynamic subtest: bcs0 [451.526850] Dynamic subtest bcs0: SUCCESS (0.064s) [451.540478] Starting dynamic subtest: vcs0 [451.590707] Dynamic subtest vcs0: SUCCESS (0.063s) [451.603257] Starting dynamic subtest: vcs1 [451.662982] Dynamic subtest vcs1: SUCCESS (0.072s) [451.680692] Starting dynamic subtest: vecs0 [451.730095] Dynamic subtest vecs0: SUCCESS (0.065s) [451.745477] Starting dynamic subtest: ccs0 [451.795650] Dynamic subtest ccs0: SUCCESS (0.065s) [451.798835] Subtest preempt-other: SUCCESS (0.406s) [453.144057] [080/133] (566s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt) [453.257060] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt [457.741951] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (4.489s) [458.954475] [081/133] (561s left) i915_drm_fdinfo (basics) [458.995775] Starting subtest: basics [458.998089] Subtest basics: SUCCESS (0.000s) [459.059198] [082/133] (560s left) prime_self_import (basic-llseek-bad) [459.098386] Starting subtest: basic-llseek-bad [459.120687] Subtest basic-llseek-bad: SUCCESS (0.026s) [459.210379] [083/133] (560s left) gem_lmem_swapping (parallel-random-engines) [459.259613] Subtest parallel-random-engines: SKIP (0.000s) [459.307269] [084/133] (560s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite) [459.402908] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite [459.407099] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [459.516740] [085/133] (560s left) gem_userptr_blits (huge-split) [459.594893] Starting subtest: huge-split [459.601938] Subtest huge-split: SUCCESS (0.007s) [459.708822] [086/133] (560s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt) [459.810876] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt [459.815248] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [459.916918] [087/133] (560s left) syncobj_timeline (invalid-single-wait-all-unsubmitted) [459.971708] Starting subtest: invalid-single-wait-all-unsubmitted [459.973667] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s) [460.070006] [088/133] (560s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu) [460.165531] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu [460.169109] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [460.275052] [089/133] (560s left) syncobj_timeline (single-wait-all-for-submit-signaled) [460.329999] Starting subtest: single-wait-all-for-submit-signaled [460.331678] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s) [460.429164] [090/133] (559s left) kms_chamelium_frames (dp-crc-multiple) [460.809570] Subtest dp-crc-multiple: SKIP (0.000s) [461.636081] [091/133] (558s left) vgem_basic (unload) [461.685261] Starting subtest: unload [490.667479] Subtest unload: SUCCESS (28.984s) [490.770172] [092/133] (529s left) kms_psr (pr-primary-render) [490.865917] Starting subtest: pr-primary-render [490.870176] Subtest pr-primary-render: SKIP (0.000s) [490.939145] [093/133] (529s left) kms_psr (fbc-psr2-suspend) [491.024837] Starting subtest: fbc-psr2-suspend [491.027083] Starting dynamic subtest: eDP-1 [491.031128] Dynamic subtest eDP-1: SKIP (0.000s) [491.035102] Subtest fbc-psr2-suspend: SKIP (0.001s) [491.118461] [094/133] (529s left) gem_partial_pwrite_pread (writes-after-reads) [491.177815] Subtest writes-after-reads: SKIP (0.000s) [491.255445] [095/133] (529s left) kms_legacy_colorkey (invalid-plane) [491.351134] Starting subtest: invalid-plane [491.353227] Starting dynamic subtest: zero-id [491.355060] Dynamic subtest zero-id: SUCCESS (0.000s) [491.367103] Starting dynamic subtest: outrange-id [491.369186] Dynamic subtest outrange-id: SUCCESS (0.000s) [491.371293] Subtest invalid-plane: SUCCESS (0.001s) [491.424083] [096/133] (529s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted) [491.495320] Starting subtest: invalid-multi-wait-unsubmitted-submitted [491.497600] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s) [491.598911] [097/133] (529s left) kms_cursor_crc (cursor-offscreen-128x42) [491.817063] Starting subtest: cursor-offscreen-128x42 [491.866208] Subtest cursor-offscreen-128x42: SKIP (0.045s) [492.061663] [098/133] (528s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs) [492.162575] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs [492.164482] Starting dynamic subtest: pipe-A-eDP-1 [509.265173] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.858s) [509.274474] Starting dynamic subtest: pipe-B-eDP-1 [527.236848] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.838s) [527.246839] Starting dynamic subtest: pipe-C-eDP-1 [545.198255] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.811s) [545.207668] Starting dynamic subtest: pipe-D-eDP-1 [563.197272] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.754s) [563.199406] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (10.267s) [570.443350] [099/133] (456s left) prime_mmap (test_forked_cpu_write) [570.507248] Starting subtest: test_forked_cpu_write [570.509235] Starting dynamic subtest: test_forked_cpu_write-smem [570.514012] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.007s) [570.516397] Subtest test_forked_cpu_write: SUCCESS (0.008s) [570.613071] [100/133] (456s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite) [570.723204] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite [580.132488] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.402s) [580.278371] [101/133] (446s left) gem_exec_flush (basic-wb-prw-default) [580.354503] Starting subtest: basic-wb-prw-default [585.824152] Subtest basic-wb-prw-default: SUCCESS (5.465s) [586.012185] [102/133] (440s left) kms_frontbuffer_tracking (fbcpsr-1p-rte) [586.117676] Starting subtest: fbcpsr-1p-rte [593.158515] Subtest fbcpsr-1p-rte: SUCCESS (7.043s) [593.305950] [103/133] (433s left) gem_userptr_blits (unsync-unmap-after-close) [593.365035] Subtest unsync-unmap-after-close: SKIP (0.000s) [593.472852] [104/133] (433s left) gem_create (create-ext-placement-sanity-check) [593.636951] Starting subtest: create-ext-placement-sanity-check [593.643975] Subtest create-ext-placement-sanity-check: SUCCESS (0.007s) [593.734117] [105/133] (433s left) gem_ctx_bad_destroy (invalid-default-ctx) [593.776786] Starting subtest: invalid-default-ctx [593.779117] Subtest invalid-default-ctx: SUCCESS (0.000s) [593.847444] [106/133] (433s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-pwrite) [593.937692] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-pwrite [593.941870] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [594.029946] [107/133] (433s left) sw_sync (sync_busy) [594.063330] Starting subtest: sync_busy [594.065698] Subtest sync_busy: SUCCESS (0.002s) [594.117848] [108/133] (433s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling) [594.206351] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling [594.210785] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.000s) [594.296031] [109/133] (432s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers) [594.393138] Starting subtest: plane-upscale-factor-0-25-with-modifiers [594.395263] Starting dynamic subtest: pipe-A [594.729580] Dynamic subtest pipe-A: SUCCESS (0.338s) [594.740506] Starting dynamic subtest: pipe-B [596.134522] Dynamic subtest pipe-B: SUCCESS (1.403s) [596.149552] Starting dynamic subtest: pipe-C [597.565120] Dynamic subtest pipe-C: SUCCESS (1.428s) [597.575122] Starting dynamic subtest: pipe-D [599.008243] Dynamic subtest pipe-D: SUCCESS (1.442s) [599.010398] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.616s) [600.202419] [110/133] (427s left) prime_vgem (basic-fence-read) [600.268358] Starting subtest: basic-fence-read [600.278143] Subtest basic-fence-read: SKIP (0.007s) [600.378456] [111/133] (426s left) vgem_basic (debugfs) [600.426420] Starting subtest: debugfs [600.428370] Subtest debugfs: SUCCESS (0.000s) [600.500335] [112/133] (426s left) kms_cursor_crc (cursor-sliding-256x256) [600.739238] Starting subtest: cursor-sliding-256x256 [600.741490] Starting dynamic subtest: pipe-A-eDP-1 [604.040664] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.298s) [604.072035] Starting dynamic subtest: pipe-D-eDP-1 [608.004023] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.935s) [608.006565] Subtest cursor-sliding-256x256: SUCCESS (7.262s) [608.863378] [113/133] (418s left) perf_pmu (busy-start) [608.903351] Starting subtest: busy-start [608.905312] Starting dynamic subtest: rcs0 [611.452810] Dynamic subtest rcs0: SUCCESS (2.550s) [611.464893] Starting dynamic subtest: bcs0 [614.005369] Dynamic subtest bcs0: SUCCESS (2.549s) [614.017504] Starting dynamic subtest: vcs0 [617.823140] Dynamic subtest vcs0: SUCCESS (3.813s) [617.835554] Starting dynamic subtest: vcs1 [621.790070] Dynamic subtest vcs1: SUCCESS (3.963s) [621.801887] Starting dynamic subtest: vecs0 [625.821453] Dynamic subtest vecs0: SUCCESS (4.028s) [625.834538] Starting dynamic subtest: ccs0 [628.370636] Dynamic subtest ccs0: SUCCESS (2.548s) [628.373104] Subtest busy-start: SUCCESS (19.465s) [628.474173] [114/133] (398s left) gem_exec_params (rs-invalid) [628.531449] Starting subtest: rs-invalid [628.533641] Subtest rs-invalid: SUCCESS (0.003s) [628.648540] [115/133] (398s left) gem_ctx_exec (basic-norecovery) [628.701586] Starting subtest: basic-norecovery [629.022527] Subtest basic-norecovery: SUCCESS (0.321s) [629.157306] [116/133] (398s left) gem_softpin (softpin) [629.221510] Starting subtest: softpin [661.563371] Subtest softpin: SUCCESS (32.330s) [661.677767] [117/133] (365s left) kms_vblank (ts-continuation-modeset) [661.769298] Starting subtest: ts-continuation-modeset [661.771541] Starting dynamic subtest: pipe-A-eDP-1 [663.218344] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.449s) [663.233023] Starting dynamic subtest: pipe-D-eDP-1 [665.389389] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.171s) [665.391955] Subtest ts-continuation-modeset: SUCCESS (3.624s) [666.193098] [118/133] (361s left) gem_pread (snoop) [666.254198] Subtest snoop: SKIP (0.000s) [666.326104] [119/133] (361s left) kms_dirtyfb (fbc-dirtyfb-ioctl) [666.407971] Starting subtest: fbc-dirtyfb-ioctl [666.410092] Starting dynamic subtest: A-eDP-1 [668.963580] Dynamic subtest A-eDP-1: SUCCESS (2.557s) [668.965856] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.559s) [669.766390] [120/133] (357s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render) [669.880834] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render [669.884952] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s) [669.973352] [121/133] (357s left) gem_render_copy (y-tiled-to-vebox-y-tiled) [670.029486] Starting subtest: y-tiled-to-vebox-y-tiled [670.033778] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s) [670.216370] [122/133] (357s left) gem_exec_schedule (semaphore-codependency) [670.289853] Starting subtest: semaphore-codependency [670.295480] Subtest semaphore-codependency: SUCCESS (0.015s) [670.642875] [123/133] (357s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers) [670.744829] Starting subtest: plane-scaler-unity-scaling-with-modifiers [670.747091] Starting dynamic subtest: pipe-A [671.156659] Dynamic subtest pipe-A: SUCCESS (0.412s) [671.167540] Starting dynamic subtest: pipe-B [672.577197] Dynamic subtest pipe-B: SUCCESS (1.420s) [672.587816] Starting dynamic subtest: pipe-C [673.998882] Dynamic subtest pipe-C: SUCCESS (1.421s) [674.009773] Starting dynamic subtest: pipe-D [675.419740] Dynamic subtest pipe-D: SUCCESS (1.420s) [675.422114] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.678s) [676.603907] [124/133] (351s left) kms_atomic (plane-primary-overlay-mutable-zpos) [676.694347] Starting subtest: plane-primary-overlay-mutable-zpos [680.144195] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.450s) [681.354824] [125/133] (346s left) perf (gen12-invalid-class-instance) [681.488683] Starting subtest: gen12-invalid-class-instance [681.500104] Subtest gen12-invalid-class-instance: SUCCESS (0.011s) [681.550376] [126/133] (346s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move) [681.649673] Starting subtest: fbc-2p-primscrn-spr-indfb-move [681.653768] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s) [681.749716] [127/133] (346s left) kms_flip (2x-flip-vs-suspend-interruptible) [681.849145] Starting subtest: 2x-flip-vs-suspend-interruptible [681.860378] Subtest 2x-flip-vs-suspend-interruptible: SKIP (0.011s) [681.939202] [128/133] (346s left) kms_big_fb (linear-32bpp-rotate-90) [682.038292] Starting subtest: linear-32bpp-rotate-90 [682.058698] Subtest linear-32bpp-rotate-90: SKIP (0.020s) [682.165409] [129/133] (345s left) kms_draw_crc (draw-method-blt) [682.264990] Starting subtest: draw-method-blt [682.266582] Starting dynamic subtest: xrgb8888-untiled [682.497867] Dynamic subtest xrgb8888-untiled: SUCCESS (0.233s) [682.507199] Starting dynamic subtest: rgb565-untiled [682.742363] Dynamic subtest rgb565-untiled: SUCCESS (0.244s) [682.752257] Starting dynamic subtest: xrgb2101010-untiled [682.964415] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s) [682.973733] Starting dynamic subtest: xbgr16161616f-untiled [683.186557] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s) [683.195895] Starting dynamic subtest: xrgb8888-xtiled [683.308837] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s) [683.317836] Starting dynamic subtest: rgb565-xtiled [683.464694] Dynamic subtest rgb565-xtiled: SUCCESS (0.155s) [683.474244] Starting dynamic subtest: xrgb2101010-xtiled [683.575335] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.109s) [683.584880] Starting dynamic subtest: xbgr16161616f-xtiled [683.686663] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.110s) [683.695874] Starting dynamic subtest: xrgb8888-4tiled [683.808975] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.121s) [683.818108] Starting dynamic subtest: rgb565-4tiled [683.931284] Dynamic subtest rgb565-4tiled: SUCCESS (0.121s) [683.941104] Starting dynamic subtest: xrgb2101010-4tiled [684.042111] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.110s) [684.052109] Starting dynamic subtest: xbgr16161616f-4tiled [684.153555] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.110s) [684.155532] Subtest draw-method-blt: SUCCESS (1.890s) [684.274250] [130/133] (343s left) kms_chamelium_hpd (dp-hpd-for-each-pipe) [684.653564] Subtest dp-hpd-for-each-pipe: SKIP (0.000s) [685.449493] [131/133] (342s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area) [685.548707] Starting subtest: fbc-pr-plane-move-sf-dmg-area [685.553088] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.000s) [685.618412] [132/133] (342s left) syncobj_timeline (multi-wait-signaled) [685.672129] Starting subtest: multi-wait-signaled [685.674361] Subtest multi-wait-signaled: SUCCESS (0.000s) [685.779474] [133/133] (342s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt) [685.873523] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt [693.341224] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.472s) [693.473738] Closing watchdogs results: parsing output: 0/ for test: prime_busy results: parsing output: 1/ for test: gem_exec_fence results: parsing output: 2/ for test: kms_panel_fitting results: parsing output: 3/ for test: kms_flip results: parsing output: 4/ for test: kms_pipe_crc_basic results: parsing output: 5/ for test: kms_setmode results: parsing output: 6/ for test: kms_big_fb results: parsing output: 7/ for test: gem_lmem_swapping results: parsing output: 8/ for test: kms_psr results: parsing output: 9/ for test: gem_eio results: parsing output: 10/ for test: kms_frontbuffer_tracking results: parsing output: 11/ for test: kms_color results: parsing output: 12/ for test: kms_frontbuffer_tracking results: parsing output: 13/ for test: kms_frontbuffer_tracking results: parsing output: 14/ for test: gem_eio results: parsing output: 15/ for test: kms_pm_rpm results: parsing output: 16/ for test: kms_plane results: parsing output: 17/ for test: kms_fbcon_fbt results: parsing output: 18/ for test: gem_exec_parallel results: parsing output: 19/ for test: kms_ccs results: parsing output: 20/ for test: gem_exec_reloc results: parsing output: 21/ for test: kms_ccs results: parsing output: 22/ for test: kms_cursor_crc results: parsing output: 23/ for test: gem_exec_reloc results: parsing output: 24/ for test: kms_plane_cursor results: parsing output: 25/ for test: gem_pxp results: parsing output: 26/ for test: gem_softpin results: parsing output: 27/ for test: kms_invalid_mode results: parsing output: 28/ for test: i915_pm_rc6_residency results: parsing output: 29/ for test: sysfs_timeslice_duration results: parsing output: 30/ for test: syncobj_eventfd results: parsing output: 31/ for test: kms_pm_rpm results: parsing output: 32/ for test: kms_ccs results: parsing output: 33/ for test: gem_reg_read results: parsing output: 34/ for test: kms_frontbuffer_tracking results: parsing output: 35/ for test: dmabuf_sync_file results: parsing output: 36/ for test: gem_pxp results: parsing output: 37/ for test: kms_big_fb results: parsing output: 38/ for test: kms_addfb_basic results: parsing output: 39/ for test: syncobj_timeline results: parsing output: 40/ for test: gem_basic results: parsing output: 41/ for test: gem_ctx_param results: parsing output: 42/ for test: gen3_render_mixed_blits results: parsing output: 43/ for test: gem_mmap_offset results: parsing output: 44/ for test: api_intel_allocator results: parsing output: 45/ for test: kms_psr2_sf results: parsing output: 46/ for test: kms_big_fb results: parsing output: 47/ for test: kms_flip results: parsing output: 48/ for test: gem_exec_whisper results: parsing output: 49/ for test: gem_ctx_persistence results: parsing output: 50/ for test: kms_vblank results: parsing output: 51/ for test: gen9_exec_parse results: parsing output: 52/ for test: gem_exec_balancer results: parsing output: 53/ for test: gem_mmap_gtt results: parsing output: 54/ for test: kms_frontbuffer_tracking results: parsing output: 55/ for test: kms_setmode results: parsing output: 56/ for test: kms_psr results: parsing output: 57/ for test: i915_suspend results: parsing output: 58/ for test: i915_module_load results: parsing output: 59/ for test: kms_flip results: parsing output: 60/ for test: kms_cdclk results: parsing output: 61/ for test: kms_frontbuffer_tracking results: parsing output: 62/ for test: gem_gtt_cpu_tlb results: parsing output: 63/ for test: kms_big_fb results: parsing output: 64/ for test: syncobj_wait results: parsing output: 65/ for test: kms_addfb_basic results: parsing output: 66/ for test: kms_flip_scaled_crc results: parsing output: 67/ for test: sw_sync results: parsing output: 68/ for test: gem_exec_balancer results: parsing output: 69/ for test: kms_busy results: parsing output: 70/ for test: kms_psr results: parsing output: 71/ for test: kms_psr results: parsing output: 72/ for test: kms_big_fb results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: core_auth results: parsing output: 75/ for test: kms_content_protection results: parsing output: 76/ for test: kms_frontbuffer_tracking results: parsing output: 77/ for test: kms_frontbuffer_tracking results: parsing output: 78/ for test: gem_exec_schedule results: parsing output: 79/ for test: kms_frontbuffer_tracking results: parsing output: 80/ for test: i915_drm_fdinfo results: parsing output: 81/ for test: prime_self_import results: parsing output: 82/ for test: gem_lmem_swapping results: parsing output: 83/ for test: kms_frontbuffer_tracking results: parsing output: 84/ for test: gem_userptr_blits results: parsing output: 85/ for test: kms_frontbuffer_tracking results: parsing output: 86/ for test: syncobj_timeline results: parsing output: 87/ for test: kms_frontbuffer_tracking results: parsing output: 88/ for test: syncobj_timeline results: parsing output: 89/ for test: kms_chamelium_frames results: parsing output: 90/ for test: vgem_basic results: parsing output: 91/ for test: kms_psr results: parsing output: 92/ for test: kms_psr results: parsing output: 93/ for test: gem_partial_pwrite_pread results: parsing output: 94/ for test: kms_legacy_colorkey results: parsing output: 95/ for test: syncobj_wait results: parsing output: 96/ for test: kms_cursor_crc results: parsing output: 97/ for test: kms_ccs results: parsing output: 98/ for test: prime_mmap results: parsing output: 99/ for test: kms_frontbuffer_tracking results: parsing output: 100/ for test: gem_exec_flush results: parsing output: 101/ for test: kms_frontbuffer_tracking results: parsing output: 102/ for test: gem_userptr_blits results: parsing output: 103/ for test: gem_create results: parsing output: 104/ for test: gem_ctx_bad_destroy results: parsing output: 105/ for test: kms_frontbuffer_tracking results: parsing output: 106/ for test: sw_sync results: parsing output: 107/ for test: kms_flip_scaled_crc results: parsing output: 108/ for test: kms_plane_scaling results: parsing output: 109/ for test: prime_vgem results: parsing output: 110/ for test: vgem_basic results: parsing output: 111/ for test: kms_cursor_crc results: parsing output: 112/ for test: perf_pmu results: parsing output: 113/ for test: gem_exec_params results: parsing output: 114/ for test: gem_ctx_exec results: parsing output: 115/ for test: gem_softpin results: parsing output: 116/ for test: kms_vblank results: parsing output: 117/ for test: gem_pread results: parsing output: 118/ for test: kms_dirtyfb results: parsing output: 119/ for test: kms_frontbuffer_tracking results: parsing output: 120/ for test: gem_render_copy results: parsing output: 121/ for test: gem_exec_schedule results: parsing output: 122/ for test: kms_plane_scaling results: parsing output: 123/ for test: kms_atomic results: parsing output: 124/ for test: perf results: parsing output: 125/ for test: kms_frontbuffer_tracking results: parsing output: 126/ for test: kms_flip results: parsing output: 127/ for test: kms_big_fb results: parsing output: 128/ for test: kms_draw_crc results: parsing output: 129/ for test: kms_chamelium_hpd results: parsing output: 130/ for test: kms_psr2_sf results: parsing output: 131/ for test: syncobj_timeline results: parsing output: 132/ for test: kms_frontbuffer_tracking Done.