[58.483675] Initializing watchdogs [58.483724] /dev/watchdog0 [58.497825] [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] [58.502140] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [58.504345] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [58.507706] [001/132] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu) [58.641688] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu [58.646253] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [58.735193] [002/132] (960s left) kms_plane (plane-position-hole-dpms) [58.827760] Starting subtest: plane-position-hole-dpms [59.363122] Starting dynamic subtest: pipe-A-plane-1 [61.706438] Dynamic subtest pipe-A-plane-1: SUCCESS (2.343s) [61.714181] Starting dynamic subtest: pipe-A-plane-2 [64.062301] Dynamic subtest pipe-A-plane-2: SUCCESS (2.355s) [64.070863] Starting dynamic subtest: pipe-A-plane-3 [66.429944] Dynamic subtest pipe-A-plane-3: SUCCESS (2.367s) [66.440994] Starting dynamic subtest: pipe-A-plane-4 [68.794761] Dynamic subtest pipe-A-plane-4: SUCCESS (2.365s) [68.801981] Starting dynamic subtest: pipe-A-plane-5 [68.819751] Dynamic subtest pipe-A-plane-5: SUCCESS (0.024s) [69.968279] Starting dynamic subtest: pipe-B-plane-1 [72.381302] Dynamic subtest pipe-B-plane-1: SUCCESS (2.419s) [72.390247] Starting dynamic subtest: pipe-B-plane-2 [74.758052] Dynamic subtest pipe-B-plane-2: SUCCESS (2.376s) [74.766799] Starting dynamic subtest: pipe-B-plane-3 [77.126888] Dynamic subtest pipe-B-plane-3: SUCCESS (2.370s) [77.135949] Starting dynamic subtest: pipe-B-plane-4 [79.476393] Dynamic subtest pipe-B-plane-4: SUCCESS (2.348s) [79.485221] Starting dynamic subtest: pipe-B-plane-5 [79.502477] Dynamic subtest pipe-B-plane-5: SUCCESS (0.025s) [79.504652] Subtest plane-position-hole-dpms: SUCCESS (20.675s) [80.299568] [003/132] (938s left) i915_pm_freq_api (freq-reset-multiple) [80.378079] Starting subtest: freq-reset-multiple [80.380506] Starting dynamic subtest: gt0 [88.578444] Dynamic subtest gt0: SUCCESS (8.198s) [88.589104] Starting dynamic subtest: gt1 [95.368368] Dynamic subtest gt1: SUCCESS (6.789s) [95.371434] Subtest freq-reset-multiple: SUCCESS (14.988s) [95.444299] [004/132] (923s left) i915_suspend (debugfs-reader) [95.494702] Starting subtest: debugfs-reader [113.909065] Subtest debugfs-reader: SUCCESS (3.988s) [114.060915] [005/132] (905s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs-cc) [114.162697] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs-cc [114.164659] Starting dynamic subtest: pipe-A-eDP-1 [114.992365] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.821s) [115.001316] Starting dynamic subtest: pipe-B-eDP-1 [116.523792] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.531s) [116.533157] Starting dynamic subtest: pipe-C-eDP-1 [117.985296] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.459s) [117.995950] Starting dynamic subtest: pipe-D-eDP-1 [119.517281] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.531s) [119.519125] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.346s) [120.696297] [006/132] (898s left) kms_pipe_crc_basic (nonblocking-crc) [120.785988] Starting subtest: nonblocking-crc [120.788400] Starting dynamic subtest: pipe-A-eDP-1 [121.522941] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.736s) [121.532905] Starting dynamic subtest: pipe-B-eDP-1 [122.918366] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.394s) [122.928200] Starting dynamic subtest: pipe-C-eDP-1 [124.293142] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.374s) [124.302926] Starting dynamic subtest: pipe-D-eDP-1 [125.618675] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.324s) [125.621323] Subtest nonblocking-crc: SUCCESS (4.834s) [126.449300] [007/132] (892s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-fully-sf) [126.545359] Starting subtest: pr-overlay-plane-move-continuous-exceed-fully-sf [126.549502] Subtest pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.000s) [126.612267] [008/132] (892s left) dmabuf_sync_file (import-multiple-read-only) [126.687250] Starting subtest: import-multiple-read-only [126.689534] Subtest import-multiple-read-only: SUCCESS (0.003s) [126.780581] [FACT dmabuf_sync_file (import-multiple-read-only)] new: kernel.kmod_is_loaded.vgem: true [126.785193] [009/132] (892s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc) [126.884635] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc [133.541374] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.658s) [133.655468] [010/132] (885s left) kms_psr (fbc-pr-suspend) [133.759113] Starting subtest: fbc-pr-suspend [133.763480] Subtest fbc-pr-suspend: SKIP (0.000s) [133.839375] [011/132] (885s left) kms_addfb_basic (bad-pitch-128) [133.897081] Starting subtest: bad-pitch-128 [133.899299] Subtest bad-pitch-128: SUCCESS (0.000s) [134.028858] [012/132] (885s left) api_intel_bb (intel-bb-blit-y) [134.086216] Starting subtest: intel-bb-blit-y [137.741630] Subtest intel-bb-blit-y: SUCCESS (3.656s) [137.866753] [013/132] (881s left) gem_exec_flush (basic-wb-ro-before-default) [137.927785] Starting subtest: basic-wb-ro-before-default [143.384432] Subtest basic-wb-ro-before-default: SUCCESS (5.458s) [143.575094] [014/132] (876s left) kms_cursor_legacy (cursor-vs-flip-legacy) [143.723543] Starting subtest: cursor-vs-flip-legacy [173.126197] Subtest cursor-vs-flip-legacy: SUCCESS (29.401s) [173.987992] [015/132] (845s left) kms_vblank (query-idle-hang) [174.092116] Starting subtest: query-idle-hang [174.093897] Starting dynamic subtest: pipe-A-eDP-1 [188.083652] Dynamic subtest pipe-A-eDP-1: SUCCESS (13.989s) [188.098217] Starting dynamic subtest: pipe-D-eDP-1 [203.116690] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.031s) [203.118851] Subtest query-idle-hang: SUCCESS (29.025s) [203.958381] [016/132] (815s left) kms_cursor_crc (cursor-onscreen-32x10) [204.137302] Starting subtest: cursor-onscreen-32x10 [204.182160] Subtest cursor-onscreen-32x10: SKIP (0.040s) [204.440484] [017/132] (815s left) syncobj_timeline (reset-during-wait-for-submit) [204.486170] Starting subtest: reset-during-wait-for-submit [204.590745] Subtest reset-during-wait-for-submit: SUCCESS (0.104s) [204.670377] [018/132] (815s left) perf (gen12-unprivileged-single-ctx-counters) [204.791511] Starting subtest: gen12-unprivileged-single-ctx-counters [204.793719] Starting dynamic subtest: rcs0 [204.956586] Dynamic subtest rcs0: SUCCESS (0.166s) [204.958952] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.168s) [204.998224] [019/132] (814s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-pwrite) [205.131380] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-pwrite [205.135525] Subtest fbc-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [205.223335] [020/132] (814s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted) [205.284339] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted [205.389251] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.105s) [205.504543] [021/132] (814s left) gem_softpin (overlap) [205.580632] Starting subtest: overlap [206.483873] Subtest overlap: SUCCESS (0.902s) [206.601230] [022/132] (813s left) syncobj_basic (create-signaled) [206.655384] Starting subtest: create-signaled [206.657657] Subtest create-signaled: SUCCESS (0.000s) [206.748621] [023/132] (813s left) kms_draw_crc (draw-method-pwrite) [206.835618] Starting subtest: draw-method-pwrite [206.837806] Starting dynamic subtest: xrgb8888-untiled [207.422447] Dynamic subtest xrgb8888-untiled: SUCCESS (0.588s) [207.431256] Starting dynamic subtest: rgb565-untiled [207.867030] Dynamic subtest rgb565-untiled: SUCCESS (0.444s) [207.876213] Starting dynamic subtest: xrgb2101010-untiled [208.423550] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.555s) [208.432569] Starting dynamic subtest: xbgr16161616f-untiled [209.222391] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.799s) [209.231196] Starting dynamic subtest: xrgb8888-xtiled [211.011628] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.788s) [211.020999] Starting dynamic subtest: rgb565-xtiled [212.123183] Dynamic subtest rgb565-xtiled: SUCCESS (1.109s) [212.135830] Starting dynamic subtest: xrgb2101010-xtiled [213.933994] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.809s) [213.943518] Starting dynamic subtest: xbgr16161616f-xtiled [217.300621] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.366s) [217.309722] Starting dynamic subtest: xrgb8888-4tiled [218.400615] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.099s) [218.409341] Starting dynamic subtest: rgb565-4tiled [218.956308] Dynamic subtest rgb565-4tiled: SUCCESS (0.555s) [218.967417] Starting dynamic subtest: xrgb2101010-4tiled [220.067942] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.110s) [220.083062] Starting dynamic subtest: xbgr16161616f-4tiled [223.134543] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (3.064s) [223.136894] Subtest draw-method-pwrite: SUCCESS (16.301s) [223.245118] [024/132] (796s left) kms_frontbuffer_tracking (psr-1p-rte) [223.358458] Starting subtest: psr-1p-rte [228.719479] Subtest psr-1p-rte: SUCCESS (5.367s) [228.830599] [025/132] (791s left) kms_big_fb (linear-8bpp-rotate-180) [228.928013] Starting subtest: linear-8bpp-rotate-180 [230.130579] Subtest linear-8bpp-rotate-180: SUCCESS (1.203s) [230.256562] [026/132] (789s left) kms_addfb_basic (clobberred-modifier) [230.318548] Starting subtest: clobberred-modifier [230.322394] Subtest clobberred-modifier: SKIP (0.000s) [230.445190] [027/132] (789s left) kms_psr2_sf (fbc-pr-overlay-plane-update-sf-dmg-area) [230.544103] Starting subtest: fbc-pr-overlay-plane-update-sf-dmg-area [230.547894] Subtest fbc-pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s) [230.609085] [028/132] (789s left) kms_cursor_crc (cursor-size-change) [230.705550] Starting subtest: cursor-size-change [230.707455] Starting dynamic subtest: pipe-A-eDP-1 [231.519234] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.811s) [231.528586] Starting dynamic subtest: pipe-D-eDP-1 [232.937680] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.416s) [232.939888] Subtest cursor-size-change: SUCCESS (2.229s) [233.795166] [029/132] (786s left) gem_wait (invalid-flags) [233.845595] Starting subtest: invalid-flags [233.847934] Subtest invalid-flags: SUCCESS (0.000s) [234.080862] [030/132] (786s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt) [234.197521] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt [234.201975] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [234.322552] [031/132] (786s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt) [234.415624] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt [238.983583] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.572s) [240.144910] [032/132] (780s left) gem_exec_whisper (basic-contexts-priority-all) [240.201894] Starting subtest: basic-contexts-priority-all [263.161797] Subtest basic-contexts-priority-all: SUCCESS (22.957s) [263.345192] [033/132] (757s left) syncobj_eventfd (timeline-wait-before-signal) [263.401969] Starting subtest: timeline-wait-before-signal [263.431521] Subtest timeline-wait-before-signal: SUCCESS (0.031s) [263.504861] [034/132] (757s left) kms_psr (fbc-psr-suspend) [263.601727] Starting subtest: fbc-psr-suspend [263.603886] Starting dynamic subtest: eDP-1 [263.607751] Dynamic subtest eDP-1: SKIP (0.000s) [263.611728] Subtest fbc-psr-suspend: SKIP (0.001s) [263.673938] [035/132] (756s left) gem_exec_reloc (basic-gtt-wc-active) [263.728673] Subtest basic-gtt-wc-active: SKIP (0.000s) [263.799266] [036/132] (756s left) gem_exec_reloc (basic-cpu-gtt) [263.855916] Subtest basic-cpu-gtt: SKIP (0.000s) [263.933654] [037/132] (756s left) api_intel_bb (add-remove-objects) [263.987201] Starting subtest: add-remove-objects [263.995373] Subtest add-remove-objects: SUCCESS (0.009s) [264.122272] [038/132] (756s left) gem_ctx_persistence (legacy-engines-cleanup) [264.183778] Starting subtest: legacy-engines-cleanup [264.186107] Starting dynamic subtest: render [264.261792] Dynamic subtest render: SUCCESS (0.077s) [264.273082] Starting dynamic subtest: bsd1 [264.303231] Dynamic subtest bsd1: SUCCESS (0.039s) [264.314231] Starting dynamic subtest: bsd2 [264.346261] Dynamic subtest bsd2: SUCCESS (0.040s) [264.357747] Starting dynamic subtest: blt [264.405648] Dynamic subtest blt: SUCCESS (0.056s) [264.419010] Starting dynamic subtest: vebox [264.458595] Dynamic subtest vebox: SUCCESS (0.049s) [264.460965] Subtest legacy-engines-cleanup: SUCCESS (0.276s) [264.534505] [039/132] (756s left) kms_ccs (bad-pixel-format-yf-tiled-ccs) [264.628276] Starting subtest: bad-pixel-format-yf-tiled-ccs [264.630206] Starting dynamic subtest: pipe-A-eDP-1 [264.648938] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [264.658360] Starting dynamic subtest: pipe-B-eDP-1 [264.675046] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [264.682727] Starting dynamic subtest: pipe-C-eDP-1 [264.701297] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [264.709063] Starting dynamic subtest: pipe-D-eDP-1 [264.727719] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [264.731283] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.004s) [266.908341] [040/132] (753s left) vgem_slow (nohang) [266.959807] Starting subtest: nohang [277.199729] Subtest nohang: SUCCESS (10.239s) [277.266907] [041/132] (743s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary) [277.370938] Starting subtest: psr-indfb-scaledprimary [283.185089] Subtest psr-indfb-scaledprimary: SUCCESS (5.816s) [283.309877] [042/132] (737s left) kms_properties (plane-properties-atomic) [283.409094] Starting subtest: plane-properties-atomic [283.411359] Starting dynamic subtest: pipe-A-eDP-1 [283.973194] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.565s) [283.983532] Starting dynamic subtest: pipe-B-eDP-1 [285.215663] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.239s) [285.226071] Starting dynamic subtest: pipe-C-eDP-1 [286.432773] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.216s) [286.443231] Starting dynamic subtest: pipe-D-eDP-1 [287.675108] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.243s) [287.677367] Subtest plane-properties-atomic: SUCCESS (4.267s) [288.488105] [043/132] (732s left) gem_mmap_gtt (zero-extend) [288.558752] Subtest zero-extend: SKIP (0.000s) [288.625926] [044/132] (732s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt) [288.725339] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt [288.729633] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [288.810534] [045/132] (732s left) kms_chamelium_edid (hdmi-edid-change-during-suspend) [289.200243] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s) [289.985685] [046/132] (731s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-gtt) [290.090155] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-gtt [290.094346] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [290.180997] [047/132] (730s left) kms_invalid_mode (bad-htotal) [290.270201] Starting subtest: bad-htotal [290.272430] Starting dynamic subtest: pipe-A-eDP-1 [290.563790] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.296s) [290.574082] Starting dynamic subtest: pipe-B-eDP-1 [290.576393] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [290.585386] Starting dynamic subtest: pipe-C-eDP-1 [290.587764] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [290.596311] Starting dynamic subtest: pipe-D-eDP-1 [290.598291] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [290.600265] Subtest bad-htotal: SUCCESS (0.302s) [291.434775] [048/132] (729s left) gem_lmem_evict (dontneed-evict-race) [291.474175] Subtest dontneed-evict-race: SKIP (0.000s) [291.524049] [049/132] (729s left) prime_mmap (test_correct) [291.585667] Starting subtest: test_correct [291.587963] Starting dynamic subtest: test_correct-smem [291.633693] Dynamic subtest test_correct-smem: SUCCESS (0.048s) [291.636635] Subtest test_correct: SUCCESS (0.049s) [291.749890] [050/132] (729s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt) [291.842623] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt [299.060524] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.221s) [299.205930] [051/132] (722s left) gem_tiling_max_stride [299.321070] [052/132] (722s left) kms_rotation_crc (sprite-rotation-270) [299.413874] Starting subtest: sprite-rotation-270 [299.418322] Subtest sprite-rotation-270: SKIP (0.001s) [299.502914] [053/132] (721s left) prime_vgem (fence-wait) [299.570619] Starting subtest: fence-wait [299.572617] Starting dynamic subtest: rcs0 [300.640373] Dynamic subtest rcs0: SUCCESS (1.068s) [300.652190] Starting dynamic subtest: bcs0 [301.712310] Dynamic subtest bcs0: SUCCESS (1.070s) [301.723245] Starting dynamic subtest: vcs0 [302.757832] Dynamic subtest vcs0: SUCCESS (1.044s) [302.767317] Starting dynamic subtest: vcs1 [303.800247] Dynamic subtest vcs1: SUCCESS (1.041s) [303.812110] Starting dynamic subtest: vecs0 [304.841383] Dynamic subtest vecs0: SUCCESS (1.040s) [304.852918] Starting dynamic subtest: ccs0 [305.883895] Dynamic subtest ccs0: SUCCESS (1.040s) [305.886601] Subtest fence-wait: SUCCESS (6.314s) [306.018135] [054/132] (715s left) gem_userptr_blits (stress-purge) [306.081722] Starting subtest: stress-purge [311.503505] Subtest stress-purge: SUCCESS (5.424s) [311.642475] [055/132] (709s left) gem_sync (basic-many-each) [311.752848] Starting subtest: basic-many-each [314.023707] Subtest basic-many-each: SUCCESS (2.276s) [314.224324] [056/132] (707s left) gem_exec_balancer (invalid-balancer) [314.299991] Starting subtest: invalid-balancer [315.209096] Subtest invalid-balancer: SUCCESS (0.907s) [315.523871] [057/132] (706s left) syncobj_timeline (wait-all-complex) [315.593179] Starting subtest: wait-all-complex [315.810428] Subtest wait-all-complex: SUCCESS (0.215s) [315.905048] [058/132] (705s left) syncobj_basic (bad-handle-to-fd) [315.953286] Starting subtest: bad-handle-to-fd [315.955630] Subtest bad-handle-to-fd: SUCCESS (0.000s) [316.060694] [059/132] (705s left) i915_drm_fdinfo (busy-idle-check-all) [316.104623] Starting subtest: busy-idle-check-all [316.106933] Starting dynamic subtest: rcs0 [316.111408] Dynamic subtest rcs0: SKIP (0.004s) [316.121728] Starting dynamic subtest: bcs0 [316.125844] Dynamic subtest bcs0: SKIP (0.000s) [316.138333] Starting dynamic subtest: vcs0 [316.142593] Dynamic subtest vcs0: SKIP (0.000s) [316.151632] Starting dynamic subtest: vcs1 [316.155985] Dynamic subtest vcs1: SKIP (0.000s) [316.164873] Starting dynamic subtest: vecs0 [316.169251] Dynamic subtest vecs0: SKIP (0.000s) [316.177807] Starting dynamic subtest: ccs0 [316.182074] Dynamic subtest ccs0: SKIP (0.000s) [316.186391] Subtest busy-idle-check-all: SKIP (0.009s) [316.228534] [060/132] (705s left) gem_spin_batch (legacy-resubmit-new) [316.322178] Starting subtest: legacy-resubmit-new [316.324616] Starting dynamic subtest: default [316.334139] Dynamic subtest default: SUCCESS (0.011s) [316.347430] Starting dynamic subtest: render [316.349322] Dynamic subtest render: SUCCESS (0.004s) [316.359461] Starting dynamic subtest: bsd [316.361730] Dynamic subtest bsd: SUCCESS (0.006s) [316.371607] Starting dynamic subtest: bsd1 [316.373514] Dynamic subtest bsd1: SUCCESS (0.004s) [316.382944] Starting dynamic subtest: bsd2 [316.385200] Dynamic subtest bsd2: SUCCESS (0.006s) [316.394437] Starting dynamic subtest: blt [316.396725] Dynamic subtest blt: SUCCESS (0.005s) [316.407162] Starting dynamic subtest: vebox [316.409400] Dynamic subtest vebox: SUCCESS (0.011s) [316.411730] Subtest legacy-resubmit-new: SUCCESS (0.054s) [318.386497] [061/132] (703s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0) [318.495814] Starting subtest: linear-max-hw-stride-32bpp-rotate-0 [319.640336] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.145s) [319.749887] [062/132] (702s left) kms_rotation_crc (primary-4-tiled-reflect-x-0) [319.849308] Starting subtest: primary-4-tiled-reflect-x-0 [326.781437] Subtest primary-4-tiled-reflect-x-0: SUCCESS (6.933s) [327.943273] [063/132] (693s left) kms_addfb_basic (basic-x-tiled-legacy) [328.002523] Starting subtest: basic-x-tiled-legacy [328.007156] Subtest basic-x-tiled-legacy: SKIP (0.000s) [328.137877] [064/132] (693s left) gem_eio (in-flight-1us) [328.366845] Starting subtest: in-flight-1us [337.173047] Subtest in-flight-1us: SUCCESS (8.807s) [337.317403] [065/132] (684s left) gem_ctx_shared (exec-single-timeline) [337.391432] Starting subtest: exec-single-timeline [337.393310] Starting dynamic subtest: rcs0 [338.445572] Dynamic subtest rcs0: SUCCESS (1.051s) [338.458705] Starting dynamic subtest: bcs0 [339.532928] Dynamic subtest bcs0: SUCCESS (1.084s) [339.546005] Starting dynamic subtest: vcs0 [340.622798] Dynamic subtest vcs0: SUCCESS (1.087s) [340.636778] Starting dynamic subtest: vcs1 [341.707675] Dynamic subtest vcs1: SUCCESS (1.083s) [341.720552] Starting dynamic subtest: vecs0 [342.796058] Dynamic subtest vecs0: SUCCESS (1.086s) [342.809726] Starting dynamic subtest: ccs0 [343.885441] Dynamic subtest ccs0: SUCCESS (1.085s) [343.888314] Subtest exec-single-timeline: SUCCESS (6.493s) [344.075106] [066/132] (677s left) kms_chamelium_color (ctm-negative) [344.194278] Subtest ctm-negative: SKIP (0.000s) [344.238266] [067/132] (677s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling) [344.335647] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling [344.339783] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s) [344.408811] [068/132] (677s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite) [344.521558] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite [351.393772] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.874s) [351.518452] [069/132] (670s left) kms_psr (fbc-psr-sprite-blt) [351.619645] Starting subtest: fbc-psr-sprite-blt [351.621888] Starting dynamic subtest: eDP-1 [351.625993] Dynamic subtest eDP-1: SKIP (0.000s) [351.630170] Subtest fbc-psr-sprite-blt: SKIP (0.001s) [351.709321] [070/132] (670s left) kms_color (invalid-ctm-matrix-sizes) [351.806493] Starting subtest: invalid-ctm-matrix-sizes [351.808718] Starting dynamic subtest: pipe-A [351.811879] Dynamic subtest pipe-A: SUCCESS (0.002s) [351.822070] Starting dynamic subtest: pipe-B [351.823976] Dynamic subtest pipe-B: SUCCESS (0.003s) [351.833812] Starting dynamic subtest: pipe-C [351.836056] Dynamic subtest pipe-C: SUCCESS (0.004s) [351.845369] Starting dynamic subtest: pipe-D [351.847273] Dynamic subtest pipe-D: SUCCESS (0.004s) [351.849194] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.015s) [351.903081] [071/132] (670s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions) [352.022108] Starting subtest: short-busy-flip-before-cursor-atomic-transitions [352.026974] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s) [352.180841] [072/132] (669s left) gem_exec_fence (syncobj-timeline-multiple-ext-nodes) [352.710272] Starting subtest: syncobj-timeline-multiple-ext-nodes [352.712872] Subtest syncobj-timeline-multiple-ext-nodes: SUCCESS (0.004s) [354.425584] [073/132] (667s left) gem_mmap_gtt (fault-concurrent) [354.486984] Subtest fault-concurrent: SKIP (0.000s) [354.549249] [074/132] (667s left) kms_async_flips (test-cursor-atomic) [354.638853] Starting subtest: test-cursor-atomic [355.015776] Starting dynamic subtest: pipe-A-eDP-1 [355.816857] Dynamic subtest pipe-A-eDP-1: SKIP (0.797s) [356.205909] Starting dynamic subtest: pipe-B-eDP-1 [356.948940] Dynamic subtest pipe-B-eDP-1: SKIP (0.748s) [357.321797] Starting dynamic subtest: pipe-C-eDP-1 [358.077877] Dynamic subtest pipe-C-eDP-1: SKIP (0.761s) [358.435068] Starting dynamic subtest: pipe-D-eDP-1 [359.204952] Dynamic subtest pipe-D-eDP-1: SKIP (0.775s) [359.209593] Subtest test-cursor-atomic: SKIP (4.567s) [360.387430] [075/132] (661s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-mc-ccs) [360.483728] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-mc-ccs [360.485715] Starting dynamic subtest: pipe-A-eDP-1 [360.808102] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.296s) [360.820110] Starting dynamic subtest: pipe-B-eDP-1 [362.050273] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.237s) [362.060855] Starting dynamic subtest: pipe-C-eDP-1 [363.265662] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.214s) [363.276549] Starting dynamic subtest: pipe-D-eDP-1 [364.501578] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.235s) [364.503523] Subtest crc-sprite-planes-basic-4-tiled-mtl-mc-ccs: SUCCESS (3.988s) [365.614893] [076/132] (656s left) kms_flip (2x-flip-vs-panning-vs-hang) [365.715680] Starting subtest: 2x-flip-vs-panning-vs-hang [365.724912] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.010s) [365.813737] [077/132] (656s left) gem_exec_balancer (sequential) [365.863645] Starting subtest: sequential [368.957089] Subtest sequential: SUCCESS (3.093s) [369.278153] [078/132] (653s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled) [369.345382] Starting subtest: yf-tiled-ccs-to-yf-tiled [369.349983] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s) [369.532737] [079/132] (652s left) gem_softpin (evict-snoop-interruptible) [369.596645] Starting subtest: evict-snoop-interruptible [369.601294] Subtest evict-snoop-interruptible: SKIP (0.000s) [369.714004] [080/132] (652s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs) [369.807049] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs [369.809001] Starting dynamic subtest: pipe-A-eDP-1 [402.163746] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.875s) [402.176059] Starting dynamic subtest: pipe-B-eDP-1 [435.102132] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.711s) [435.112887] Starting dynamic subtest: pipe-C-eDP-1 [468.077476] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.635s) [468.088751] Starting dynamic subtest: pipe-D-eDP-1 [501.064392] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.618s) [501.066750] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (13.844s) [502.299864] [081/132] (520s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [502.415900] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip [503.040894] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.626s) [503.205367] [082/132] (519s left) gem_exec_schedule (manyslice) [503.280408] Starting subtest: manyslice [503.282729] Starting dynamic subtest: rcs0 [508.418028] Dynamic subtest rcs0: SUCCESS (5.140s) [508.434956] Starting dynamic subtest: bcs0 [514.028029] Dynamic subtest bcs0: SUCCESS (5.603s) [514.043646] Starting dynamic subtest: vcs0 [518.620127] Dynamic subtest vcs0: SUCCESS (4.587s) [518.640358] Starting dynamic subtest: vcs1 [525.233372] Dynamic subtest vcs1: SUCCESS (6.608s) [525.247352] Starting dynamic subtest: vecs0 [531.331597] Dynamic subtest vecs0: SUCCESS (6.093s) [531.343609] Starting dynamic subtest: ccs0 [538.021608] Dynamic subtest ccs0: SUCCESS (6.690s) [538.024032] Subtest manyslice: SUCCESS (34.731s) [538.325412] [083/132] (484s left) kms_big_fb (yf-tiled-64bpp-rotate-90) [538.438091] Starting subtest: yf-tiled-64bpp-rotate-90 [538.442540] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s) [538.537731] [084/132] (484s left) kms_chamelium_hpd (hdmi-hpd-with-enabled-mode) [538.915401] Subtest hdmi-hpd-with-enabled-mode: SKIP (0.000s) [539.724108] [085/132] (482s left) gem_exec_schedule (timeslicing) [539.806475] Starting subtest: timeslicing [539.808819] Starting dynamic subtest: rcs0 [539.820737] Dynamic subtest rcs0: SUCCESS (0.024s) [539.832051] Starting dynamic subtest: bcs0 [539.847035] Dynamic subtest bcs0: SUCCESS (0.024s) [539.856692] Starting dynamic subtest: vcs0 [539.872562] Dynamic subtest vcs0: SUCCESS (0.023s) [539.886389] Starting dynamic subtest: vcs1 [539.893469] Dynamic subtest vcs1: SUCCESS (0.020s) [539.903384] Starting dynamic subtest: vecs0 [539.913896] Dynamic subtest vecs0: SUCCESS (0.020s) [539.923509] Starting dynamic subtest: ccs0 [539.934648] Dynamic subtest ccs0: SUCCESS (0.020s) [539.936911] Subtest timeslicing: SUCCESS (0.139s) [541.819038] [086/132] (480s left) gem_partial_pwrite_pread (writes-after-reads-uncached) [541.881865] Subtest writes-after-reads-uncached: SKIP (0.000s) [541.962596] [087/132] (480s left) gem_pread (bench) [542.011925] Subtest bench: SKIP (0.000s) [542.078926] [088/132] (480s left) gem_create (create-ext-cpu-access-sanity-check) [542.251101] Starting subtest: create-ext-cpu-access-sanity-check [542.255810] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s) [542.328167] [089/132] (480s left) gem_ctx_param (basic-default) [542.378972] Starting subtest: basic-default [542.381268] Subtest basic-default: SUCCESS (0.000s) [542.459107] [090/132] (480s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-render) [542.559257] Starting subtest: fbc-rgb101010-draw-render [547.166198] Subtest fbc-rgb101010-draw-render: SUCCESS (4.609s) [548.368735] [091/132] (474s left) kms_psr (psr-cursor-mmap-gtt) [548.460833] Starting subtest: psr-cursor-mmap-gtt [548.462991] Starting dynamic subtest: eDP-1 [550.141432] Dynamic subtest eDP-1: SUCCESS (1.681s) [550.143665] Subtest psr-cursor-mmap-gtt: SUCCESS (1.682s) [551.040607] [092/132] (471s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc) [551.127787] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc [551.131872] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [551.220834] [093/132] (471s left) kms_psr (fbc-pr-cursor-plane-onoff) [551.307975] Starting subtest: fbc-pr-cursor-plane-onoff [551.312283] Subtest fbc-pr-cursor-plane-onoff: SKIP (0.000s) [551.381970] [094/132] (471s left) kms_flip (2x-flip-vs-modeset) [551.478402] Starting subtest: 2x-flip-vs-modeset [551.489119] Subtest 2x-flip-vs-modeset: SKIP (0.010s) [551.569615] [095/132] (471s left) kms_content_protection (lic-type-0-hdcp14) [551.721283] Starting subtest: lic-type-0-hdcp14 [551.725970] Subtest lic-type-0-hdcp14: SKIP (0.000s) [551.852893] [096/132] (471s left) sysfs_timeslice_duration (duration) [551.901813] Starting subtest: duration [551.903893] Starting dynamic subtest: vecs0 [565.667546] Dynamic subtest vecs0: SUCCESS (13.761s) [565.680280] Starting dynamic subtest: ccs0 [578.821457] Dynamic subtest ccs0: SUCCESS (13.148s) [578.838526] Starting dynamic subtest: vcs0 [592.676431] Dynamic subtest vcs0: SUCCESS (13.845s) [592.690123] Starting dynamic subtest: bcs0 [605.808201] Dynamic subtest bcs0: SUCCESS (13.134s) [605.822277] Starting dynamic subtest: rcs0 [618.946021] Dynamic subtest rcs0: SUCCESS (13.139s) [618.959043] Starting dynamic subtest: vcs1 [632.675464] Dynamic subtest vcs1: SUCCESS (13.726s) [632.678472] Subtest duration: SUCCESS (80.769s) [632.751352] [097/132] (390s left) kms_flip (blocking-wf_vblank) [632.862396] Starting subtest: blocking-wf_vblank [632.864746] Starting dynamic subtest: A-eDP1 [641.867466] Dynamic subtest A-eDP1: SUCCESS (9.006s) [641.883990] Starting dynamic subtest: B-eDP1 [650.802184] Dynamic subtest B-eDP1: SUCCESS (8.932s) [650.822200] Starting dynamic subtest: C-eDP1 [659.714540] Dynamic subtest C-eDP1: SUCCESS (8.907s) [659.726090] Starting dynamic subtest: D-eDP1 [668.650543] Dynamic subtest D-eDP1: SUCCESS (8.934s) [668.655539] Subtest blocking-wf_vblank: SUCCESS (35.791s) [669.875610] [098/132] (353s left) syncobj_timeline (invalid-signal-zero-handles) [669.935822] Starting subtest: invalid-signal-zero-handles [669.937885] Subtest invalid-signal-zero-handles: SUCCESS (0.000s) [670.045359] [099/132] (353s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-16bpp-ytile-downscaling) [670.141171] Starting subtest: flip-64bpp-ytile-to-16bpp-ytile-downscaling [670.145574] Subtest flip-64bpp-ytile-to-16bpp-ytile-downscaling: SKIP (0.000s) [670.215572] [100/132] (353s left) gem_render_copy (y-tiled-to-vebox-linear) [670.270722] Starting subtest: y-tiled-to-vebox-linear [670.274842] Subtest y-tiled-to-vebox-linear: SKIP (0.000s) [670.453433] [101/132] (352s left) kms_setmode (invalid-clone-single-crtc) [670.525860] Starting subtest: invalid-clone-single-crtc [670.532419] Subtest invalid-clone-single-crtc: SKIP (0.000s) [670.639056] [102/132] (352s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90) [670.726111] Starting subtest: primary-yf-tiled-reflect-x-90 [670.730319] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s) [670.804234] [103/132] (352s left) gem_busy (parallel) [670.983008] Starting subtest: parallel [670.985414] Starting dynamic subtest: rcs0 [672.710849] Dynamic subtest rcs0: SUCCESS (1.725s) [672.724710] Starting dynamic subtest: bcs0 [674.758547] Dynamic subtest bcs0: SUCCESS (2.044s) [674.771393] Starting dynamic subtest: vcs0 [676.744105] Dynamic subtest vcs0: SUCCESS (1.981s) [676.757530] Starting dynamic subtest: vcs1 [678.726125] Dynamic subtest vcs1: SUCCESS (1.979s) [678.739365] Starting dynamic subtest: vecs0 [680.711106] Dynamic subtest vecs0: SUCCESS (1.981s) [680.724186] Starting dynamic subtest: ccs0 [682.758696] Dynamic subtest ccs0: SUCCESS (2.044s) [682.761274] Subtest parallel: SUCCESS (11.773s) [682.995628] [104/132] (340s left) kms_pm_rpm (dpms-lpsp) [684.941470] Starting subtest: dpms-lpsp [685.245750] Subtest dpms-lpsp: SUCCESS (0.307s) [685.340494] [105/132] (338s left) gem_ctx_param (invalid-get-engines) [685.401809] Starting subtest: invalid-get-engines [685.404250] Subtest invalid-get-engines: SUCCESS (0.001s) [685.517235] [106/132] (338s left) sw_sync (alloc_fence) [685.554101] Starting subtest: alloc_fence [685.556290] Subtest alloc_fence: SUCCESS (0.000s) [685.602271] [107/132] (338s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20) [685.696159] Starting subtest: planes-downscale-factor-0-5-upscale-20x20 [685.698393] Starting dynamic subtest: pipe-A [685.714496] Dynamic subtest pipe-A: SKIP (0.016s) [685.724985] Starting dynamic subtest: pipe-B [685.743895] Dynamic subtest pipe-B: SKIP (0.029s) [685.754000] Starting dynamic subtest: pipe-C [685.775225] Dynamic subtest pipe-C: SKIP (0.029s) [685.785886] Starting dynamic subtest: pipe-D [685.804192] Dynamic subtest pipe-D: SKIP (0.029s) [685.807838] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.106s) [685.889519] [108/132] (337s left) kms_cursor_crc (cursor-random-128x128) [686.081476] Starting subtest: cursor-random-128x128 [686.086118] Starting dynamic subtest: pipe-A-eDP-1 [689.403630] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.315s) [689.430870] Starting dynamic subtest: pipe-D-eDP-1 [693.390362] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.965s) [693.392229] Subtest cursor-random-128x128: SUCCESS (7.305s) [694.259752] [109/132] (329s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner) [694.356409] Starting subtest: switch-modeset-ultra-joiner-big-joiner [694.360757] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s) [694.423104] [110/132] (329s left) kms_big_fb (x-tiled-addfb-size-offset-overflow) [694.530302] Starting subtest: x-tiled-addfb-size-offset-overflow [694.532597] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s) [694.634792] [111/132] (329s left) perf_pmu (invalid-open) [694.679531] Starting subtest: invalid-open [694.681840] Subtest invalid-open: SUCCESS (0.000s) [694.822765] [112/132] (329s left) kms_properties (connector-properties-legacy) [694.920146] Starting subtest: connector-properties-legacy [694.922329] Starting dynamic subtest: pipe-A-eDP-1 [702.781706] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.858s) [702.792528] Starting dynamic subtest: pipe-None-DP-1 [702.796476] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s) [702.805931] Starting dynamic subtest: pipe-None-HDMI-A-1 [702.810085] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s) [702.819973] Starting dynamic subtest: pipe-None-DP-2 [702.824335] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s) [702.834125] Starting dynamic subtest: pipe-None-HDMI-A-2 [702.838524] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s) [702.848508] Starting dynamic subtest: pipe-None-DP-3 [702.852844] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s) [702.862497] Starting dynamic subtest: pipe-None-DP-4 [702.866505] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s) [702.868351] Subtest connector-properties-legacy: SUCCESS (7.869s) [703.643600] [113/132] (320s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0) [703.736459] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0 [703.740706] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s) [703.846525] [114/132] (320s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt) [703.953597] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt [708.091187] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.139s) [709.283413] [115/132] (314s left) kms_plane_lowres (tiling-y) [709.387984] Starting subtest: tiling-y [709.392429] Subtest tiling-y: SKIP (0.000s) [709.460442] [116/132] (314s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff) [709.555567] Starting subtest: psr-1p-primscrn-cur-indfb-onoff [716.513831] Subtest psr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.961s) [716.637965] [117/132] (307s left) kms_vblank (invalid) [716.738987] Starting subtest: invalid [716.740832] Starting dynamic subtest: pipe-A-eDP-1 [717.134227] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.396s) [717.136581] Subtest invalid: SUCCESS (0.397s) [717.994632] [118/132] (306s left) gem_mmap_gtt (fault-concurrent-x) [718.053870] Subtest fault-concurrent-X: SKIP (0.000s) [718.124062] [119/132] (306s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [718.235236] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [718.239719] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [718.355316] [120/132] (305s left) gem_exec_reloc (basic-scanout) [718.418235] Subtest basic-scanout: SKIP (0.000s) [718.495129] [121/132] (305s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size) [718.614977] Starting subtest: basic-busy-flip-before-cursor-varying-size [718.619451] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s) [718.771012] [122/132] (305s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen) [718.869539] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen [718.873772] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [718.968605] [123/132] (305s left) gem_mmap_gtt (coherency) [719.021083] Subtest coherency: SKIP (0.000s) [719.080950] [124/132] (305s left) gen9_exec_parse (bb-start-out) [719.140329] Subtest bb-start-out: SKIP (0.000s) [719.224771] [125/132] (305s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu) [719.320123] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu [719.324276] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [719.435827] [126/132] (305s left) gem_mmap_gtt (big-copy) [719.490250] Subtest big-copy: SKIP (0.000s) [719.556763] [127/132] (304s left) kms_getfb (getfb-handle-valid) [719.644021] Starting subtest: getfb-handle-valid [719.646068] Subtest getfb-handle-valid: SUCCESS (0.000s) [719.753753] [128/132] (304s left) kms_plane (pixel-format-linear-modifier-source-clamping) [719.843265] Starting subtest: pixel-format-linear-modifier-source-clamping [719.872652] Starting dynamic subtest: pipe-A-plane-0 [723.726598] Dynamic subtest pipe-A-plane-0: SUCCESS (3.855s) [723.738716] Starting dynamic subtest: pipe-A-plane-3 [725.382082] Dynamic subtest pipe-A-plane-3: SUCCESS (1.653s) [726.475340] Starting dynamic subtest: pipe-B-plane-0 [730.098722] Dynamic subtest pipe-B-plane-0: SUCCESS (3.633s) [730.108379] Starting dynamic subtest: pipe-B-plane-3 [731.887972] Dynamic subtest pipe-B-plane-3: SUCCESS (1.788s) [732.204676] Subtest pixel-format-linear-modifier-source-clamping: SUCCESS (12.360s) [733.048398] [129/132] (291s left) kms_cursor_legacy (cursorb-vs-flipa-atomic) [733.167890] Starting subtest: cursorB-vs-flipA-atomic [733.172465] Subtest cursorB-vs-flipA-atomic: SKIP (0.002s) [733.314553] [130/132] (291s left) gem_mmap_gtt (basic-write-read) [733.367961] Subtest basic-write-read: SKIP (0.000s) [733.425951] [131/132] (291s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt) [733.527469] Starting subtest: fbcpsr-farfromfence-mmap-gtt [733.531793] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s) [733.625612] [132/132] (291s left) i915_pm_rpm (system-suspend) [735.958867] Starting subtest: system-suspend [753.702272] Subtest system-suspend: SUCCESS (2.868s) [754.078844] Closing watchdogs results: parsing output: 0/ for test: kms_frontbuffer_tracking results: parsing output: 1/ for test: kms_plane results: parsing output: 2/ for test: i915_pm_freq_api results: parsing output: 3/ for test: i915_suspend results: parsing output: 4/ for test: kms_ccs results: parsing output: 5/ for test: kms_pipe_crc_basic results: parsing output: 6/ for test: kms_psr2_sf results: parsing output: 7/ for test: dmabuf_sync_file results: parsing output: 8/ for test: kms_frontbuffer_tracking results: parsing output: 9/ for test: kms_psr results: parsing output: 10/ for test: kms_addfb_basic results: parsing output: 11/ for test: api_intel_bb results: parsing output: 12/ for test: gem_exec_flush results: parsing output: 13/ for test: kms_cursor_legacy results: parsing output: 14/ for test: kms_vblank results: parsing output: 15/ for test: kms_cursor_crc results: parsing output: 16/ for test: syncobj_timeline results: parsing output: 17/ for test: perf results: parsing output: 18/ for test: kms_frontbuffer_tracking results: parsing output: 19/ for test: syncobj_timeline results: parsing output: 20/ for test: gem_softpin results: parsing output: 21/ for test: syncobj_basic results: parsing output: 22/ for test: kms_draw_crc results: parsing output: 23/ for test: kms_frontbuffer_tracking results: parsing output: 24/ for test: kms_big_fb results: parsing output: 25/ for test: kms_addfb_basic results: parsing output: 26/ for test: kms_psr2_sf results: parsing output: 27/ for test: kms_cursor_crc results: parsing output: 28/ for test: gem_wait results: parsing output: 29/ for test: kms_frontbuffer_tracking results: parsing output: 30/ for test: kms_frontbuffer_tracking results: parsing output: 31/ for test: gem_exec_whisper results: parsing output: 32/ for test: syncobj_eventfd results: parsing output: 33/ for test: kms_psr results: parsing output: 34/ for test: gem_exec_reloc results: parsing output: 35/ for test: gem_exec_reloc results: parsing output: 36/ for test: api_intel_bb results: parsing output: 37/ for test: gem_ctx_persistence results: parsing output: 38/ for test: kms_ccs results: parsing output: 39/ for test: vgem_slow results: parsing output: 40/ for test: kms_frontbuffer_tracking results: parsing output: 41/ for test: kms_properties results: parsing output: 42/ for test: gem_mmap_gtt results: parsing output: 43/ for test: kms_frontbuffer_tracking results: parsing output: 44/ for test: kms_chamelium_edid results: parsing output: 45/ for test: kms_frontbuffer_tracking results: parsing output: 46/ for test: kms_invalid_mode results: parsing output: 47/ for test: gem_lmem_evict results: parsing output: 48/ for test: prime_mmap results: parsing output: 49/ for test: kms_frontbuffer_tracking results: parsing output: 50/ for test: gem_tiling_max_stride results: parsing output: 51/ for test: kms_rotation_crc results: parsing output: 52/ for test: prime_vgem results: parsing output: 53/ for test: gem_userptr_blits results: parsing output: 54/ for test: gem_sync results: parsing output: 55/ for test: gem_exec_balancer results: parsing output: 56/ for test: syncobj_timeline results: parsing output: 57/ for test: syncobj_basic results: parsing output: 58/ for test: i915_drm_fdinfo results: parsing output: 59/ for test: gem_spin_batch results: parsing output: 60/ for test: kms_big_fb results: parsing output: 61/ for test: kms_rotation_crc results: parsing output: 62/ for test: kms_addfb_basic results: parsing output: 63/ for test: gem_eio results: parsing output: 64/ for test: gem_ctx_shared results: parsing output: 65/ for test: kms_chamelium_color results: parsing output: 66/ for test: kms_flip_scaled_crc results: parsing output: 67/ for test: kms_frontbuffer_tracking results: parsing output: 68/ for test: kms_psr results: parsing output: 69/ for test: kms_color results: parsing output: 70/ for test: kms_cursor_legacy results: parsing output: 71/ for test: gem_exec_fence results: parsing output: 72/ for test: gem_mmap_gtt results: parsing output: 73/ for test: kms_async_flips results: parsing output: 74/ for test: kms_ccs results: parsing output: 75/ for test: kms_flip results: parsing output: 76/ for test: gem_exec_balancer results: parsing output: 77/ for test: gem_render_copy results: parsing output: 78/ for test: gem_softpin results: parsing output: 79/ for test: kms_ccs results: parsing output: 80/ for test: kms_big_fb results: parsing output: 81/ for test: gem_exec_schedule results: parsing output: 82/ for test: kms_big_fb results: parsing output: 83/ for test: kms_chamelium_hpd results: parsing output: 84/ for test: gem_exec_schedule results: parsing output: 85/ for test: gem_partial_pwrite_pread results: parsing output: 86/ for test: gem_pread results: parsing output: 87/ for test: gem_create results: parsing output: 88/ for test: gem_ctx_param results: parsing output: 89/ for test: kms_frontbuffer_tracking results: parsing output: 90/ for test: kms_psr results: parsing output: 91/ for test: kms_frontbuffer_tracking results: parsing output: 92/ for test: kms_psr results: parsing output: 93/ for test: kms_flip results: parsing output: 94/ for test: kms_content_protection results: parsing output: 95/ for test: sysfs_timeslice_duration results: parsing output: 96/ for test: kms_flip results: parsing output: 97/ for test: syncobj_timeline results: parsing output: 98/ for test: kms_flip_scaled_crc results: parsing output: 99/ for test: gem_render_copy results: parsing output: 100/ for test: kms_setmode results: parsing output: 101/ for test: kms_rotation_crc results: parsing output: 102/ for test: gem_busy results: parsing output: 103/ for test: kms_pm_rpm results: parsing output: 104/ for test: gem_ctx_param results: parsing output: 105/ for test: sw_sync results: parsing output: 106/ for test: kms_plane_scaling results: parsing output: 107/ for test: kms_cursor_crc results: parsing output: 108/ for test: kms_joiner results: parsing output: 109/ for test: kms_big_fb results: parsing output: 110/ for test: perf_pmu results: parsing output: 111/ for test: kms_properties results: parsing output: 112/ for test: kms_big_fb results: parsing output: 113/ for test: kms_frontbuffer_tracking results: parsing output: 114/ for test: kms_plane_lowres results: parsing output: 115/ for test: kms_frontbuffer_tracking results: parsing output: 116/ for test: kms_vblank results: parsing output: 117/ for test: gem_mmap_gtt results: parsing output: 118/ for test: kms_big_fb results: parsing output: 119/ for test: gem_exec_reloc results: parsing output: 120/ for test: kms_cursor_legacy results: parsing output: 121/ for test: kms_frontbuffer_tracking results: parsing output: 122/ for test: gem_mmap_gtt results: parsing output: 123/ for test: gen9_exec_parse results: parsing output: 124/ for test: kms_frontbuffer_tracking results: parsing output: 125/ for test: gem_mmap_gtt results: parsing output: 126/ for test: kms_getfb results: parsing output: 127/ for test: kms_plane results: parsing output: 128/ for test: kms_cursor_legacy results: parsing output: 129/ for test: gem_mmap_gtt results: parsing output: 130/ for test: kms_frontbuffer_tracking results: parsing output: 131/ for test: i915_pm_rpm Done.