[43.905598] Initializing watchdogs [43.905662] /dev/watchdog0 [43.937945] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics] [43.943974] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [43.946541] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [43.948552] [001/154] (960s left) kms_frontbuffer_tracking (fbc-tiling-linear) [44.049347] Starting subtest: fbc-tiling-linear [45.182465] Subtest fbc-tiling-linear: SUCCESS (1.133s) [45.303805] [002/154] (959s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes) [45.338941] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s) [45.376661] [003/154] (959s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc) [45.471240] Starting subtest: psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc [45.472725] Subtest psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [45.549665] [004/154] (959s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt) [45.646152] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt [45.647522] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [45.750907] [005/154] (958s left) kms_force_connector_basic (prune-stale-modes) [45.877867] Starting subtest: prune-stale-modes [46.026054] Subtest prune-stale-modes: SUCCESS (0.149s) [46.181876] [006/154] (958s left) perf_pmu (most-busy-check-all) [46.223324] Starting subtest: most-busy-check-all [46.224061] Starting dynamic subtest: rcs0 [46.745232] Dynamic subtest rcs0: SUCCESS (0.521s) [46.754224] Starting dynamic subtest: bcs0 [47.275363] Dynamic subtest bcs0: SUCCESS (0.524s) [47.285211] Starting dynamic subtest: vcs0 [47.804211] Dynamic subtest vcs0: SUCCESS (0.523s) [47.813732] Starting dynamic subtest: vcs1 [48.335132] Dynamic subtest vcs1: SUCCESS (0.525s) [48.344790] Starting dynamic subtest: vecs0 [48.864157] Dynamic subtest vecs0: SUCCESS (0.523s) [48.865077] Subtest most-busy-check-all: SUCCESS (2.618s) [48.937332] [007/154] (955s left) gem_ccs (large-ctrl-surf-copy) [48.975543] Starting subtest: large-ctrl-surf-copy [48.976981] Subtest large-ctrl-surf-copy: SKIP (0.000s) [49.035456] [008/154] (955s left) kms_plane_alpha_blend (coverage-7efc) [49.125788] Starting subtest: coverage-7efc [49.196278] Starting dynamic subtest: pipe-A-HDMI-A-1 [49.484740] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.285s) [49.519889] Starting dynamic subtest: pipe-D-HDMI-A-1 [49.975567] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.459s) [49.976346] Subtest coverage-7efc: SUCCESS (0.843s) [50.135270] [009/154] (954s left) gem_mmap_gtt (fault-concurrent) [50.172393] Starting subtest: fault-concurrent [52.711254] Subtest fault-concurrent: SUCCESS (2.514s) [52.814286] [010/154] (951s left) api_intel_allocator (gem-pool) [52.848158] Starting subtest: gem-pool [52.854902] Subtest gem-pool: SUCCESS (0.007s) [52.957242] [011/154] (951s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-fullscreen) [53.052279] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-fullscreen [53.053668] Subtest fbchdr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [53.137129] [012/154] (951s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier) [53.224875] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier [53.226331] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier: SKIP (0.000s) [53.292823] [013/154] (951s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs) [53.381618] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs [53.382342] Starting dynamic subtest: pipe-A-HDMI-A-1 [53.389424] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s) [53.396270] Starting dynamic subtest: pipe-B-HDMI-A-1 [53.403323] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s) [53.410115] Starting dynamic subtest: pipe-C-HDMI-A-1 [53.417245] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s) [53.424021] Starting dynamic subtest: pipe-D-HDMI-A-1 [53.430929] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s) [53.432299] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.007s) [53.634675] [014/154] (951s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs) [53.724571] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs [53.725328] Starting dynamic subtest: pipe-A-HDMI-A-1 [53.732367] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s) [53.739241] Starting dynamic subtest: pipe-B-HDMI-A-1 [53.745937] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s) [53.752794] Starting dynamic subtest: pipe-C-HDMI-A-1 [53.759394] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s) [53.766265] Starting dynamic subtest: pipe-D-HDMI-A-1 [53.773030] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s) [53.774344] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.004s) [53.970314] [015/154] (951s left) kms_frontbuffer_tracking (hdr-rgb565-draw-blt) [54.064200] Starting subtest: hdr-rgb565-draw-blt [54.065609] Subtest hdr-rgb565-draw-blt: SKIP (0.000s) [54.173719] [016/154] (950s left) gem_render_copy (x-tiled-to-vebox-y-tiled) [54.213474] Starting subtest: x-tiled-to-vebox-y-tiled [54.214199] Starting dynamic subtest: smem [54.310278] Dynamic subtest smem: SUCCESS (0.096s) [54.311026] Subtest x-tiled-to-vebox-y-tiled: SUCCESS (0.096s) [54.493573] [017/154] (950s left) sysfs_heartbeat_interval (invalid) [54.538211] Starting subtest: invalid [54.538947] Starting dynamic subtest: vecs0 [54.539656] Dynamic subtest vecs0: SUCCESS (0.000s) [54.546693] Starting dynamic subtest: vcs0 [54.547412] Dynamic subtest vcs0: SUCCESS (0.000s) [54.554144] Starting dynamic subtest: bcs0 [54.554857] Dynamic subtest bcs0: SUCCESS (0.000s) [54.561711] Starting dynamic subtest: rcs0 [54.562453] Dynamic subtest rcs0: SUCCESS (0.000s) [54.569291] Starting dynamic subtest: vcs1 [54.569993] Dynamic subtest vcs1: SUCCESS (0.000s) [54.570759] Subtest invalid: SUCCESS (0.003s) [54.597767] [018/154] (950s left) kms_frontbuffer_tracking (fbc-stridechange) [54.691124] Starting subtest: fbc-stridechange [55.661226] Subtest fbc-stridechange: SUCCESS (0.966s) [55.775359] [019/154] (949s left) gem_ctx_param (basic-default) [55.809364] Starting subtest: basic-default [55.810083] Subtest basic-default: SUCCESS (0.000s) [55.871338] [020/154] (949s left) kms_psr (fbc-pr-primary-mmap-gtt) [55.962015] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s) [56.004553] [021/154] (949s left) i915_pm_freq_mult (media-freq) [56.037479] Starting subtest: media-freq [56.038207] Starting dynamic subtest: gt0 [56.039582] Dynamic subtest gt0: SKIP (0.000s) [56.040910] Subtest media-freq: SKIP (0.000s) [56.110241] [022/154] (949s left) prime_busy (before-wait) [56.147313] Starting subtest: before-wait [56.152049] Starting dynamic subtest: rcs0 [56.195785] Dynamic subtest rcs0: SUCCESS (0.043s) [56.209927] Starting dynamic subtest: bcs0 [56.215634] Dynamic subtest bcs0: SUCCESS (0.019s) [56.225370] Starting dynamic subtest: vcs0 [56.231166] Dynamic subtest vcs0: SUCCESS (0.015s) [56.238372] Starting dynamic subtest: vcs1 [56.244141] Dynamic subtest vcs1: SUCCESS (0.013s) [56.250891] Starting dynamic subtest: vecs0 [56.260154] Dynamic subtest vecs0: SUCCESS (0.016s) [56.368162] Subtest before-wait: SUCCESS (0.219s) [56.460622] [023/154] (948s left) gem_exec_gttfill (engines) [56.504443] Starting subtest: engines [56.505193] Starting dynamic subtest: rcs0 [79.703636] Dynamic subtest rcs0: SUCCESS (23.176s) [79.713486] Starting dynamic subtest: bcs0 [102.806378] Dynamic subtest bcs0: SUCCESS (23.103s) [102.815100] Starting dynamic subtest: vcs0 [125.847530] Dynamic subtest vcs0: SUCCESS (23.041s) [125.856948] Starting dynamic subtest: vcs1 [148.841432] Dynamic subtest vcs1: SUCCESS (22.993s) [148.849869] Starting dynamic subtest: vecs0 [172.006848] Dynamic subtest vecs0: SUCCESS (23.163s) [172.007660] Subtest engines: SUCCESS (115.479s) [172.208268] [024/154] (833s left) syncobj_timeline (etime-multi-wait-all-submitted) [172.295491] Starting subtest: etime-multi-wait-all-submitted [172.398403] Subtest etime-multi-wait-all-submitted: SUCCESS (0.102s) [172.466863] [025/154] (832s left) gem_ctx_param (get-priority-new-ctx) [172.501338] Starting subtest: get-priority-new-ctx [172.502146] Subtest get-priority-new-ctx: SUCCESS (0.000s) [172.568973] [026/154] (832s left) kms_big_fb (linear-32bpp-rotate-90) [172.674922] Starting subtest: linear-32bpp-rotate-90 [172.760866] Subtest linear-32bpp-rotate-90: SKIP (0.085s) [172.883618] [027/154] (832s left) gem_lmem_swapping (heavy-verify-multi-ccs) [172.924261] Subtest heavy-verify-multi-ccs: SKIP (0.000s) [172.968792] [028/154] (832s left) gem_ctx_shared (disjoint-timelines) [173.010689] Starting subtest: disjoint-timelines [173.039281] Subtest disjoint-timelines: SUCCESS (0.029s) [173.259822] [FACT gem_ctx_shared (disjoint-timelines)] new: kernel.kmod_is_loaded.vgem: true [173.261644] [029/154] (832s left) kms_psr (fbc-psr2-cursor-plane-move) [173.349383] Subtest fbc-psr2-cursor-plane-move: SKIP (0.000s) [173.402312] [030/154] (832s left) gem_bad_reloc (negative-reloc-bltcopy) [173.441581] Starting subtest: negative-reloc-bltcopy [174.554109] Subtest negative-reloc-bltcopy: SUCCESS (1.103s) [174.666120] [031/154] (830s left) kms_chamelium_hpd (hdmi-hpd) [174.813562] Subtest hdmi-hpd: SKIP (0.000s) [174.913349] [032/154] (830s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf) [175.012772] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s) [175.060442] [033/154] (830s left) gem_eio (wait-10ms) [175.104737] Starting subtest: wait-10ms [175.259785] Subtest wait-10ms: SUCCESS (0.154s) [175.396197] [034/154] (830s left) kms_content_protection (legacy-hdcp14) [175.492149] Starting subtest: legacy-hdcp14 [175.497484] Subtest legacy-hdcp14: SKIP (0.003s) [175.598588] [035/154] (830s left) syncobj_wait (reset-signaled) [175.632707] Starting subtest: reset-signaled [175.633453] Subtest reset-signaled: SUCCESS (0.000s) [175.704365] [036/154] (830s left) gem_ctx_isolation (dirty-switch) [175.746184] Starting subtest: dirty-switch [175.746925] Starting dynamic subtest: rcs0 [175.933280] Dynamic subtest rcs0: SUCCESS (0.178s) [175.941319] Starting dynamic subtest: bcs0 [176.156122] Dynamic subtest bcs0: SUCCESS (0.223s) [176.164242] Starting dynamic subtest: vcs0 [176.380375] Dynamic subtest vcs0: SUCCESS (0.224s) [176.388866] Starting dynamic subtest: vcs1 [176.581472] Dynamic subtest vcs1: SUCCESS (0.209s) [176.589867] Starting dynamic subtest: vecs0 [176.805727] Dynamic subtest vecs0: SUCCESS (0.216s) [176.806489] Subtest dirty-switch: SUCCESS (1.051s) [176.976531] [037/154] (828s left) gem_flink_basic (bad-open) [177.010085] Starting subtest: bad-open [177.010861] Subtest bad-open: SUCCESS (0.000s) [177.079905] [038/154] (828s left) gem_caching (writes) [177.117775] Starting subtest: writes [186.268448] Subtest writes: SUCCESS (9.150s) [186.398683] [039/154] (819s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers) [186.491743] Starting subtest: plane-scaler-unity-scaling-with-modifiers [186.492456] Starting dynamic subtest: pipe-A [186.877216] Dynamic subtest pipe-A: SUCCESS (0.386s) [186.889110] Starting dynamic subtest: pipe-B [187.321545] Dynamic subtest pipe-B: SUCCESS (0.444s) [187.337130] Starting dynamic subtest: pipe-C [187.772033] Dynamic subtest pipe-C: SUCCESS (0.450s) [187.784856] Starting dynamic subtest: pipe-D [188.214465] Dynamic subtest pipe-D: SUCCESS (0.442s) [188.215481] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (1.723s) [188.405309] [040/154] (817s left) syncobj_timeline (single-wait-all-for-submit-available-submitted) [188.441313] Starting subtest: single-wait-all-for-submit-available-submitted [188.442101] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s) [188.519041] [041/154] (817s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-indfb-draw-render) [188.613528] Starting subtest: fbchdr-2p-primscrn-pri-indfb-draw-render [188.614991] Subtest fbchdr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [188.715149] [042/154] (817s left) kms_pm_rpm (system-suspend-idle) [190.127945] Starting subtest: system-suspend-idle [209.755559] Subtest system-suspend-idle: SUCCESS (4.895s) [217.026897] [043/154] (796s left) kms_atomic_transition (modeset-transition) [217.123804] Starting subtest: modeset-transition [217.124635] Starting dynamic subtest: 1x-outputs [218.406614] Dynamic subtest 1x-outputs: SUCCESS (1.269s) [218.407599] Subtest modeset-transition: SUCCESS (1.269s) [218.589324] [044/154] (794s left) kms_frontbuffer_tracking (pipe-fbc-rte) [218.692125] Starting subtest: pipe-fbc-rte [218.696215] Subtest pipe-fbc-rte: SKIP (0.000s) [218.801784] [045/154] (794s left) gem_spin_batch (resubmit-all) [218.844795] Starting subtest: resubmit-all [218.845618] Starting dynamic subtest: rcs0 [218.848858] Dynamic subtest rcs0: SUCCESS (0.004s) [218.858634] Starting dynamic subtest: bcs0 [218.859392] Dynamic subtest bcs0: SUCCESS (0.002s) [218.868416] Starting dynamic subtest: vcs0 [218.869112] Dynamic subtest vcs0: SUCCESS (0.002s) [218.877663] Starting dynamic subtest: vcs1 [218.878395] Dynamic subtest vcs1: SUCCESS (0.002s) [218.886493] Starting dynamic subtest: vecs0 [218.887172] Dynamic subtest vecs0: SUCCESS (0.002s) [218.887847] Subtest resubmit-all: SUCCESS (0.014s) [219.053976] [046/154] (794s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff) [219.146983] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff [219.148366] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [219.244443] [047/154] (794s left) syncobj_basic (illegal-fd-to-handle) [219.278563] Starting subtest: illegal-fd-to-handle [219.279277] Subtest illegal-fd-to-handle: SUCCESS (0.000s) [219.354193] [048/154] (793s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-pwrite) [219.447006] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-pwrite [219.448388] Subtest fbc-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [219.556843] [049/154] (793s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180) [219.656454] Starting subtest: linear-max-hw-stride-32bpp-rotate-180 [220.348516] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (0.686s) [220.483909] [050/154] (792s left) syncobj_timeline (etime-single-wait-all-for-submit-unsubmitted) [220.517786] Starting subtest: etime-single-wait-all-for-submit-unsubmitted [220.626369] Subtest etime-single-wait-all-for-submit-unsubmitted: SUCCESS (0.107s) [220.710016] [051/154] (792s left) api_intel_bb (misplaced-blitter) [220.745659] Starting subtest: misplaced-blitter [220.749702] Subtest misplaced-blitter: SUCCESS (0.005s) [220.852682] [052/154] (792s left) kms_atomic_interruptible (universal-setplane-cursor) [220.946136] Starting subtest: universal-setplane-cursor [220.947785] Starting dynamic subtest: pipe-A-HDMI-A-1 [227.179992] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.198s) [227.180760] Subtest universal-setplane-cursor: SUCCESS (6.200s) [227.336391] [053/154] (786s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [227.440098] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [227.441529] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [227.538329] [054/154] (786s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc) [227.631848] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc [227.633269] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [227.733368] [055/154] (785s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling) [227.825083] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling [227.825835] Starting dynamic subtest: pipe-A-valid-mode [228.935834] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.106s) [228.936574] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SUCCESS (1.108s) [229.092881] [056/154] (784s left) gem_pxp (create-protected-buffer) [229.198115] Starting subtest: create-protected-buffer [229.199265] Subtest create-protected-buffer: SUCCESS (0.000s) [229.290341] [057/154] (784s left) gen9_exec_parse (allowed-single) [229.328209] Subtest allowed-single: SKIP (0.000s) [229.374432] [058/154] (784s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu) [229.467914] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu [229.469341] Subtest psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [229.575465] [059/154] (784s left) gem_exec_balancer (bonded-semaphore) [229.618474] Starting subtest: bonded-semaphore [233.971363] Subtest bonded-semaphore: SUCCESS (4.310s) [234.117415] [060/154] (779s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping) [234.211522] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping [234.227854] Starting dynamic subtest: pipe-A-plane-0 [234.436630] Dynamic subtest pipe-A-plane-0: SUCCESS (0.208s) [234.452956] Starting dynamic subtest: pipe-A-plane-3 [234.603600] Dynamic subtest pipe-A-plane-3: SUCCESS (0.165s) [234.622399] Starting dynamic subtest: pipe-A-plane-5 [234.770769] Dynamic subtest pipe-A-plane-5: SUCCESS (0.165s) [234.920848] Starting dynamic subtest: pipe-B-plane-0 [235.095079] Dynamic subtest pipe-B-plane-0: SUCCESS (0.183s) [235.111700] Starting dynamic subtest: pipe-B-plane-3 [235.261981] Dynamic subtest pipe-B-plane-3: SUCCESS (0.165s) [235.280641] Starting dynamic subtest: pipe-B-plane-5 [235.429055] Dynamic subtest pipe-B-plane-5: SUCCESS (0.165s) [235.502084] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping: SUCCESS (1.288s) [235.663183] [061/154] (778s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc) [235.764156] Starting subtest: fbc-rgb565-draw-mmap-wc [237.025515] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (1.260s) [237.145373] [062/154] (776s left) kms_pwrite_crc (basic) [237.238854] Starting subtest: basic [237.561463] Subtest basic: SUCCESS (0.322s) [237.705306] [063/154] (776s left) gem_flink_basic (bad-flink) [237.742605] Starting subtest: bad-flink [237.743296] Subtest bad-flink: SUCCESS (0.000s) [237.801195] [064/154] (776s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-move) [237.894127] Starting subtest: hdr-2p-primscrn-spr-indfb-move [237.895522] Subtest hdr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [237.996437] [065/154] (776s left) gem_ctx_persistence (legacy-engines-persistence) [238.034052] Starting subtest: legacy-engines-persistence [238.034772] Starting dynamic subtest: render [238.794389] Dynamic subtest render: SUCCESS (0.758s) [238.807677] Starting dynamic subtest: bsd1 [239.558424] Dynamic subtest bsd1: SUCCESS (0.761s) [239.571365] Starting dynamic subtest: bsd2 [240.326436] Dynamic subtest bsd2: SUCCESS (0.765s) [240.340401] Starting dynamic subtest: blt [241.094257] Dynamic subtest blt: SUCCESS (0.764s) [241.106499] Starting dynamic subtest: vebox [241.859288] Dynamic subtest vebox: SUCCESS (0.762s) [241.860487] Subtest legacy-engines-persistence: SUCCESS (3.822s) [241.939270] [066/154] (772s left) gen7_exec_parse (basic-allowed) [241.978804] Subtest basic-allowed: SKIP (0.000s) [242.027144] [067/154] (772s left) gem_exec_schedule (reorder-wide) [242.198334] Starting subtest: reorder-wide [242.199343] Starting dynamic subtest: rcs0 [242.279160] Dynamic subtest rcs0: SUCCESS (0.079s) [242.291829] Starting dynamic subtest: bcs0 [242.356105] Dynamic subtest bcs0: SUCCESS (0.075s) [242.369474] Starting dynamic subtest: vcs0 [242.433992] Dynamic subtest vcs0: SUCCESS (0.075s) [242.451984] Starting dynamic subtest: vcs1 [242.510496] Dynamic subtest vcs1: SUCCESS (0.074s) [242.523520] Starting dynamic subtest: vecs0 [242.584714] Dynamic subtest vecs0: SUCCESS (0.072s) [242.587456] Subtest reorder-wide: SUCCESS (0.387s) [242.767104] [068/154] (771s left) kms_frontbuffer_tracking (psrhdr-slowdraw) [242.863975] Starting subtest: psrhdr-slowdraw [242.865315] Subtest psrhdr-slowdraw: SKIP (0.000s) [242.968573] [069/154] (771s left) perf (non-zero-reason) [243.060072] Starting subtest: non-zero-reason [243.060767] Starting dynamic subtest: 0-rcs0 [250.876936] Dynamic subtest 0-rcs0: SUCCESS (7.782s) [250.877931] Subtest non-zero-reason: SUCCESS (7.783s) [250.917086] [070/154] (763s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-pwrite) [251.014266] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-pwrite [251.015678] Subtest fbchdr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [251.119718] [071/154] (763s left) i915_drm_fdinfo (all-busy-check-all) [251.156958] Starting subtest: all-busy-check-all [251.680948] Subtest all-busy-check-all: SUCCESS (0.524s) [251.758874] [072/154] (762s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt) [251.854310] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt [251.855711] Subtest psrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [251.951970] [073/154] (762s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [252.041755] Starting subtest: compare-crc-sanitycheck-nv12 [252.042464] Starting dynamic subtest: pipe-A-HDMI-A-1 [252.380367] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.338s) [252.394257] Starting dynamic subtest: pipe-B-HDMI-A-1 [252.706155] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.323s) [252.717066] Starting dynamic subtest: pipe-C-HDMI-A-1 [253.035285] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.327s) [253.045962] Starting dynamic subtest: pipe-D-HDMI-A-1 [253.360147] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.323s) [253.360908] Subtest compare-crc-sanitycheck-nv12: SUCCESS (1.319s) [253.514818] [074/154] (760s left) gem_exec_reloc (basic-write-gtt) [253.556929] Starting subtest: basic-write-gtt [253.563270] Subtest basic-write-gtt: SUCCESS (0.006s) [253.700024] [075/154] (760s left) kms_cursor_crc (cursor-rapid-movement-max-size) [253.794966] Starting subtest: cursor-rapid-movement-max-size [253.797182] Subtest cursor-rapid-movement-max-size: SKIP (0.000s) [253.886405] [076/154] (760s left) kms_color_pipeline (plane-lut1d) [253.975653] Starting subtest: plane-lut1d [254.056866] Starting dynamic subtest: pipe-A-plane-0 [254.156604] Dynamic subtest pipe-A-plane-0: SUCCESS (0.099s) [254.174383] Starting dynamic subtest: pipe-A-plane-1 [254.256384] Dynamic subtest pipe-A-plane-1: SUCCESS (0.098s) [254.272688] Starting dynamic subtest: pipe-A-plane-2 [254.356359] Dynamic subtest pipe-A-plane-2: SUCCESS (0.098s) [254.554326] Starting dynamic subtest: pipe-B-plane-0 [254.626326] Dynamic subtest pipe-B-plane-0: SUCCESS (0.083s) [254.642768] Starting dynamic subtest: pipe-B-plane-1 [254.718127] Dynamic subtest pipe-B-plane-1: SUCCESS (0.090s) [254.734373] Starting dynamic subtest: pipe-B-plane-2 [254.818365] Dynamic subtest pipe-B-plane-2: SUCCESS (0.098s) [255.033026] Starting dynamic subtest: pipe-C-plane-0 [255.107322] Dynamic subtest pipe-C-plane-0: SUCCESS (0.083s) [255.124906] Starting dynamic subtest: pipe-C-plane-1 [255.207379] Dynamic subtest pipe-C-plane-1: SUCCESS (0.098s) [255.221862] Starting dynamic subtest: pipe-C-plane-2 [255.299204] Dynamic subtest pipe-C-plane-2: SUCCESS (0.090s) [255.521883] Starting dynamic subtest: pipe-D-plane-0 [255.604934] Dynamic subtest pipe-D-plane-0: SUCCESS (0.091s) [255.619459] Starting dynamic subtest: pipe-D-plane-1 [255.705415] Dynamic subtest pipe-D-plane-1: SUCCESS (0.098s) [255.721711] Starting dynamic subtest: pipe-D-plane-2 [255.805182] Dynamic subtest pipe-D-plane-2: SUCCESS (0.098s) [255.854702] Subtest plane-lut1d: SUCCESS (1.878s) [255.971913] [077/154] (758s left) kms_big_fb (yf-tiled-16bpp-rotate-180) [256.075182] Starting subtest: yf-tiled-16bpp-rotate-180 [256.076591] Subtest yf-tiled-16bpp-rotate-180: SKIP (0.000s) [256.174815] [078/154] (758s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0) [256.272644] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0 [256.274068] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s) [256.383861] [079/154] (758s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt) [256.476172] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt [256.477637] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [256.594025] [080/154] (758s left) gem_exec_reloc (basic-wc-read) [256.633245] Starting subtest: basic-wc-read [256.638683] Subtest basic-wc-read: SUCCESS (0.005s) [256.754530] [081/154] (757s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle) [256.845894] Starting subtest: short-busy-flip-before-cursor-toggle [256.847313] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s) [256.905619] [082/154] (757s left) kms_flip (2x-plain-flip-fb-recreate-interruptible) [257.001868] Starting subtest: 2x-plain-flip-fb-recreate-interruptible [257.011477] Subtest 2x-plain-flip-fb-recreate-interruptible: SKIP (0.009s) [257.096523] [083/154] (757s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu) [257.192115] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu [257.193505] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [257.289596] [084/154] (757s left) kms_draw_crc (draw-method-render) [257.379846] Starting subtest: draw-method-render [257.380608] Starting dynamic subtest: xrgb8888-untiled [257.542196] Dynamic subtest xrgb8888-untiled: SUCCESS (0.162s) [257.559187] Starting dynamic subtest: rgb565-untiled [257.708872] Dynamic subtest rgb565-untiled: SUCCESS (0.164s) [257.728328] Starting dynamic subtest: xrgb2101010-untiled [257.867329] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.156s) [257.887110] Starting dynamic subtest: xbgr16161616f-untiled [258.034089] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.165s) [258.057099] Starting dynamic subtest: xrgb8888-xtiled [258.125736] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.088s) [258.146596] Starting dynamic subtest: rgb565-xtiled [258.217453] Dynamic subtest rgb565-xtiled: SUCCESS (0.089s) [258.238114] Starting dynamic subtest: xrgb2101010-xtiled [258.300795] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.081s) [258.318279] Starting dynamic subtest: xbgr16161616f-xtiled [258.384115] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.081s) [258.403635] Starting dynamic subtest: xrgb8888-ytiled [258.476064] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.089s) [258.496057] Starting dynamic subtest: rgb565-ytiled [258.567746] Dynamic subtest rgb565-ytiled: SUCCESS (0.090s) [258.586997] Starting dynamic subtest: xrgb2101010-ytiled [258.651049] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.081s) [258.668829] Starting dynamic subtest: xbgr16161616f-ytiled [258.734374] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.081s) [258.735484] Subtest draw-method-render: SUCCESS (1.355s) [258.859525] [085/154] (756s left) kms_cursor_crc (cursor-sliding-256x85) [258.957046] Starting subtest: cursor-sliding-256x85 [258.960759] Starting dynamic subtest: pipe-A-HDMI-A-1 [260.793763] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.831s) [260.841941] Starting dynamic subtest: pipe-D-HDMI-A-1 [262.647907] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.817s) [262.648683] Subtest cursor-sliding-256x85: SUCCESS (3.690s) [262.814832] [086/154] (752s left) kms_cursor_crc (cursor-onscreen-256x256) [262.912084] Starting subtest: cursor-onscreen-256x256 [262.916599] Starting dynamic subtest: pipe-A-HDMI-A-1 [264.091422] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.174s) [264.138288] Starting dynamic subtest: pipe-D-HDMI-A-1 [265.282862] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.153s) [265.283653] Subtest cursor-onscreen-256x256: SUCCESS (2.371s) [265.424412] [087/154] (749s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render) [265.521051] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render [265.522454] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [265.614601] [088/154] (749s left) kms_frontbuffer_tracking (fbcpsr-slowdraw) [265.707891] Starting subtest: fbcpsr-slowdraw [265.709362] Subtest fbcpsr-slowdraw: SKIP (0.000s) [265.797996] [089/154] (749s left) kms_lease (cursor-implicit-plane) [265.887121] Starting subtest: cursor-implicit-plane [265.887918] Starting dynamic subtest: pipe-A-HDMI-A-1 [266.058579] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.171s) [266.070128] Starting dynamic subtest: pipe-B-HDMI-A-1 [266.231430] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.169s) [266.243105] Starting dynamic subtest: pipe-C-HDMI-A-1 [266.406856] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.174s) [266.420966] Starting dynamic subtest: pipe-D-HDMI-A-1 [266.582050] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.173s) [266.582780] Subtest cursor-implicit-plane: SUCCESS (0.696s) [266.719552] [090/154] (748s left) syncobj_wait (invalid-reset-zero-handles) [266.757518] Starting subtest: invalid-reset-zero-handles [266.758204] Subtest invalid-reset-zero-handles: SUCCESS (0.000s) [266.849834] [091/154] (748s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render) [266.942220] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render [266.943621] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [267.036717] [092/154] (748s left) kms_big_fb (yf-tiled-64bpp-rotate-90) [267.133903] Starting subtest: yf-tiled-64bpp-rotate-90 [267.135355] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s) [267.247180] [093/154] (748s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc) [267.338884] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc [267.340249] Subtest fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [267.427322] [094/154] (747s left) gem_exec_fence (long-history) [267.749759] Starting subtest: long-history [273.487332] Subtest long-history: SUCCESS (5.730s) [273.940507] [095/154] (741s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt) [274.037283] Starting subtest: psr-1p-primscrn-indfb-msflip-blt [274.038701] Subtest psr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s) [274.132800] [096/154] (741s left) kms_ccs (bad-rotation-90-yf-tiled-ccs) [274.221765] Starting subtest: bad-rotation-90-yf-tiled-ccs [274.223538] Starting dynamic subtest: pipe-A-HDMI-A-1 [274.230438] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s) [274.240138] Starting dynamic subtest: pipe-B-HDMI-A-1 [274.246958] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s) [274.256356] Starting dynamic subtest: pipe-C-HDMI-A-1 [274.263086] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s) [274.272279] Starting dynamic subtest: pipe-D-HDMI-A-1 [274.279310] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s) [274.280662] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.007s) [274.483640] [097/154] (740s left) kms_cursor_legacy (long-nonblocking-modeset-vs-cursor-atomic) [274.573834] Starting subtest: long-nonblocking-modeset-vs-cursor-atomic [276.973266] Subtest long-nonblocking-modeset-vs-cursor-atomic: SUCCESS (2.399s) [277.141019] [098/154] (738s left) kms_chamelium_audio (dp-audio-edid) [277.290174] Subtest dp-audio-edid: SKIP (0.000s) [277.403274] [099/154] (738s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [277.498781] Starting subtest: addfb25-yf-tiled-legacy [277.499564] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [277.592197] [100/154] (737s left) kms_frontbuffer_tracking (hdr-1p-primscrn-indfb-pgflip-blt) [277.685559] Starting subtest: hdr-1p-primscrn-indfb-pgflip-blt [277.687007] Subtest hdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [277.795020] [101/154] (737s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff) [277.888810] Starting subtest: psr-2p-primscrn-cur-indfb-onoff [277.890288] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [277.991785] [102/154] (737s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw) [278.091219] Starting subtest: fbc-2p-pri-indfb-multidraw [278.092665] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s) [278.203135] [103/154] (737s left) kms_sequence (queue-busy) [278.293795] Starting subtest: queue-busy [278.294550] Starting dynamic subtest: pipe-A-HDMI-A-1 [279.593562] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.298s) [279.604746] Starting dynamic subtest: pipe-B-HDMI-A-1 [280.863774] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.268s) [280.874741] Starting dynamic subtest: pipe-C-HDMI-A-1 [282.133393] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.267s) [282.145979] Starting dynamic subtest: pipe-D-HDMI-A-1 [283.410557] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.274s) [283.411281] Subtest queue-busy: SUCCESS (5.115s) [283.528486] [104/154] (732s left) kms_plane_scaling (plane-upscale-20x20-with-rotation) [283.619183] Starting subtest: plane-upscale-20x20-with-rotation [283.620051] Starting dynamic subtest: pipe-A [284.758134] Dynamic subtest pipe-A: SKIP (1.136s) [284.771098] Starting dynamic subtest: pipe-B [285.954450] Dynamic subtest pipe-B: SKIP (1.194s) [285.964156] Starting dynamic subtest: pipe-C [287.138090] Dynamic subtest pipe-C: SKIP (1.183s) [287.150402] Starting dynamic subtest: pipe-D [288.335311] Dynamic subtest pipe-D: SKIP (1.196s) [288.336659] Subtest plane-upscale-20x20-with-rotation: SKIP (4.713s) [288.514637] [105/154] (727s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-pwrite) [288.621206] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-pwrite [288.622662] Subtest psrhdr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [288.712555] [106/154] (727s left) gem_exec_reloc (basic-write-wc) [288.751857] Starting subtest: basic-write-wc [288.757872] Subtest basic-write-wc: SUCCESS (0.006s) [288.887683] [107/154] (726s left) syncobj_timeline (reset-signaled) [288.923123] Starting subtest: reset-signaled [288.923870] Subtest reset-signaled: SUCCESS (0.000s) [288.987014] [108/154] (726s left) kms_psr (pr-cursor-plane-move) [289.075476] Subtest pr-cursor-plane-move: SKIP (0.000s) [289.125068] [109/154] (726s left) syncobj_wait (invalid-wait-illegal-handle) [289.159267] Starting subtest: invalid-wait-illegal-handle [289.159981] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s) [289.228595] [110/154] (726s left) kms_busy (extended-pageflip-modeset-hang-oldfb) [289.322828] Starting subtest: extended-pageflip-modeset-hang-oldfb [289.324628] Starting dynamic subtest: pipe-A [309.267925] Dynamic subtest pipe-A: SUCCESS (19.936s) [309.282095] Starting dynamic subtest: pipe-D [329.233508] Dynamic subtest pipe-D: SUCCESS (19.967s) [329.234285] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (39.910s) [329.372965] [111/154] (686s left) kms_psr (psr2-primary-blt) [329.467986] Subtest psr2-primary-blt: SKIP (0.000s) [329.516362] [112/154] (686s left) gem_softpin (evict-snoop-interruptible) [329.556380] Starting subtest: evict-snoop-interruptible [329.557876] Subtest evict-snoop-interruptible: SKIP (0.000s) [329.624848] [113/154] (686s left) kms_force_connector_basic (force-load-detect) [329.748203] Starting subtest: force-load-detect [329.750093] Subtest force-load-detect: SKIP (0.000s) [329.900821] [114/154] (686s left) kms_chamelium_edid (hdmi-mode-timings) [330.043065] Subtest hdmi-mode-timings: SKIP (0.000s) [330.148865] [115/154] (686s left) syncobj_timeline (invalid-signal-zero-handles) [330.187468] Starting subtest: invalid-signal-zero-handles [330.188223] Subtest invalid-signal-zero-handles: SUCCESS (0.000s) [330.264603] [116/154] (685s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt) [330.357546] Starting subtest: fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt [330.358952] Subtest fbcpsrhdr-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s) [330.461662] [117/154] (685s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt) [330.554471] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt [330.555961] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [330.652059] [118/154] (685s left) gem_mmap_gtt (fault-concurrent-x) [330.687026] Starting subtest: fault-concurrent-X [333.433314] Subtest fault-concurrent-X: SUCCESS (2.737s) [333.551836] [119/154] (682s left) gem_render_copy (y-tiled-to-vebox-y-tiled) [333.594890] Starting subtest: y-tiled-to-vebox-y-tiled [333.595649] Starting dynamic subtest: smem [333.692188] Dynamic subtest smem: SUCCESS (0.097s) [333.692994] Subtest y-tiled-to-vebox-y-tiled: SUCCESS (0.098s) [333.887862] [120/154] (682s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-shrfb-plflip-blt) [333.985935] Starting subtest: psrhdr-2p-scndscrn-shrfb-plflip-blt [333.987397] Subtest psrhdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [334.084160] [121/154] (682s left) vgem_basic (debugfs) [334.119813] Starting subtest: debugfs [334.120530] Subtest debugfs: SUCCESS (0.000s) [334.174636] [122/154] (682s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling) [334.282808] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling [334.284730] Starting dynamic subtest: pipe-A-valid-mode [335.514129] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.230s) [335.514951] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SUCCESS (1.232s) [335.673246] [123/154] (680s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite) [335.769420] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite [335.770835] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [335.846630] [124/154] (680s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu) [335.939772] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu [335.941128] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [336.028351] [125/154] (680s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt) [336.122098] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt [336.123458] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [336.213388] [126/154] (680s left) kms_vblank (wait-forked-hang) [336.302363] Starting subtest: wait-forked-hang [336.304656] Starting dynamic subtest: pipe-A-HDMI-A-1 [350.236794] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (13.931s) [350.249753] Starting dynamic subtest: pipe-D-HDMI-A-1 [364.560806] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (14.317s) [364.561568] Subtest wait-forked-hang: SUCCESS (28.256s) [364.727841] [127/154] (652s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling) [364.819662] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling [364.821551] Starting dynamic subtest: pipe-A-valid-mode [366.695093] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.874s) [366.696970] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SUCCESS (1.876s) [366.848917] [128/154] (649s left) gem_ctx_exec (basic-invalid-context) [366.886437] Starting subtest: basic-invalid-context [366.888959] Subtest basic-invalid-context: SUCCESS (0.003s) [366.999527] [129/154] (649s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-indfb-msflip-blt) [367.093813] Starting subtest: fbcpsrhdr-1p-primscrn-indfb-msflip-blt [367.095281] Subtest fbcpsrhdr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s) [367.166033] [130/154] (649s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf) [367.255187] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (0.000s) [367.300899] [131/154] (649s left) gem_ppgtt (blt-vs-render-ctxn) [367.339340] Starting subtest: blt-vs-render-ctxN [400.005223] Subtest blt-vs-render-ctxN: SUCCESS (32.647s) [400.129431] [132/154] (616s left) gem_exec_reloc (basic-gtt-cpu-noreloc) [400.207621] Starting subtest: basic-gtt-cpu-noreloc [400.211554] Subtest basic-gtt-cpu-noreloc: SUCCESS (0.004s) [400.333914] [133/154] (616s left) gem_softpin (invalid) [400.373573] Starting subtest: invalid [400.377009] Subtest invalid: SUCCESS (0.004s) [400.497657] [134/154] (616s left) gem_exec_capture (capture) [400.535572] Starting subtest: capture [400.536402] Starting dynamic subtest: rcs0-smem [401.812684] Dynamic subtest rcs0-smem: SUCCESS (1.276s) [401.822476] Starting dynamic subtest: bcs0-smem [403.092537] Dynamic subtest bcs0-smem: SUCCESS (1.271s) [403.101925] Starting dynamic subtest: vcs0-smem [404.364894] Dynamic subtest vcs0-smem: SUCCESS (1.273s) [404.374365] Starting dynamic subtest: vcs1-smem [405.637022] Dynamic subtest vcs1-smem: SUCCESS (1.267s) [405.646468] Starting dynamic subtest: vecs0-smem [406.908439] Dynamic subtest vecs0-smem: SUCCESS (1.271s) [406.909108] Subtest capture: SUCCESS (6.363s) [407.006079] [135/154] (610s left) gem_tiled_blits (basic) [407.083607] Starting subtest: basic [407.099355] Subtest basic: SUCCESS (0.016s) [407.213012] [136/154] (609s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt) [407.358472] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt [407.359918] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [407.464100] [137/154] (609s left) gem_mmap_offset (partial-remap) [407.498672] Starting subtest: partial-remap [407.499414] Starting dynamic subtest: smem0 [407.504179] Dynamic subtest smem0: SUCCESS (0.003s) [407.504906] Subtest partial-remap: SUCCESS (0.004s) [407.624059] [138/154] (609s left) kms_frontbuffer_tracking (fbchdr-1p-offscreen-pri-shrfb-draw-blt) [407.719255] Starting subtest: fbchdr-1p-offscreen-pri-shrfb-draw-blt [407.720668] Subtest fbchdr-1p-offscreen-pri-shrfb-draw-blt: SKIP (0.000s) [407.834516] [139/154] (609s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-blt) [407.928228] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-blt [407.929626] Subtest hdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [408.034005] [140/154] (609s left) i915_power (sanity) [408.068461] Starting subtest: sanity [412.087876] Subtest sanity: SUCCESS (4.009s) [412.186593] [141/154] (605s left) gem_exec_schedule (preempt-queue) [412.244125] Starting subtest: preempt-queue [412.244846] Starting dynamic subtest: rcs0 [412.356401] Dynamic subtest rcs0: SUCCESS (0.111s) [412.368577] Starting dynamic subtest: bcs0 [412.463338] Dynamic subtest bcs0: SUCCESS (0.106s) [412.475379] Starting dynamic subtest: vcs0 [412.569151] Dynamic subtest vcs0: SUCCESS (0.105s) [412.581590] Starting dynamic subtest: vcs1 [412.676039] Dynamic subtest vcs1: SUCCESS (0.106s) [412.688119] Starting dynamic subtest: vecs0 [412.781303] Dynamic subtest vecs0: SUCCESS (0.104s) [412.782059] Subtest preempt-queue: SUCCESS (0.538s) [413.086176] [142/154] (604s left) kms_cursor_legacy (cursorb-vs-flipa-legacy) [413.179084] Starting subtest: cursorB-vs-flipA-legacy [413.181564] Subtest cursorB-vs-flipA-legacy: SKIP (0.002s) [413.239980] [143/154] (604s left) i915_pm_rps (reset) [413.279653] Starting subtest: reset [417.816164] Subtest reset: SUCCESS (4.531s) [417.942702] [144/154] (599s left) kms_psr (fbc-psr-cursor-plane-onoff) [418.035615] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.000s) [418.080815] [145/154] (599s left) kms_setmode (clone-exclusive-crtc) [418.114945] Starting subtest: clone-exclusive-crtc [418.117199] Subtest clone-exclusive-crtc: SKIP (0.000s) [418.177715] [146/154] (599s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu) [418.271534] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu [418.272897] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [418.379491] [147/154] (599s left) kms_flip (flip-vs-rmfb) [418.468567] Starting subtest: flip-vs-rmfb [418.471447] Starting dynamic subtest: A-HDMI-A1 [426.171145] Dynamic subtest A-HDMI-A1: SUCCESS (7.697s) [426.188769] Starting dynamic subtest: B-HDMI-A1 [433.831952] Dynamic subtest B-HDMI-A1: SUCCESS (7.655s) [433.850741] Starting dynamic subtest: C-HDMI-A1 [441.509627] Dynamic subtest C-HDMI-A1: SUCCESS (7.677s) [441.529079] Starting dynamic subtest: D-HDMI-A1 [449.200158] Dynamic subtest D-HDMI-A1: SUCCESS (7.690s) [449.205547] Subtest flip-vs-rmfb: SUCCESS (30.737s) [449.365973] [148/154] (568s left) gem_exec_whisper (basic-contexts-all) [449.426028] Starting subtest: basic-contexts-all [451.141885] Subtest basic-contexts-all: SUCCESS (1.716s) [451.334847] [149/154] (566s left) dmabuf_sync_file (export-basic) [451.375316] Starting subtest: export-basic [451.376022] Subtest export-basic: SUCCESS (0.001s) [451.429778] [150/154] (566s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-mmap-cpu) [451.526517] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-mmap-cpu [451.527945] Subtest hdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [451.623090] [151/154] (566s left) gem_sync (basic-each) [451.667612] Starting subtest: basic-each [453.782387] Subtest basic-each: SUCCESS (2.115s) [453.974509] [152/154] (563s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc) [454.065642] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc [454.067450] Starting dynamic subtest: pipe-A-HDMI-A-1 [454.074712] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s) [454.084556] Starting dynamic subtest: pipe-B-HDMI-A-1 [454.091856] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s) [454.101763] Starting dynamic subtest: pipe-C-HDMI-A-1 [454.108948] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s) [454.118566] Starting dynamic subtest: pipe-D-HDMI-A-1 [454.126384] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s) [454.127889] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.007s) [454.322673] [153/154] (563s left) syncobj_wait (multi-wait-for-submit-submitted) [454.359049] Starting subtest: multi-wait-for-submit-submitted [454.466400] Subtest multi-wait-for-submit-submitted: SUCCESS (0.107s) [454.540985] [154/154] (563s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt) [454.636911] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt [454.638316] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [454.731243] Closing watchdogs results: parsing output: 0/ for test: kms_frontbuffer_tracking results: parsing output: 1/ for test: kms_pipe_b_c_ivb results: parsing output: 2/ for test: kms_frontbuffer_tracking results: parsing output: 3/ for test: kms_frontbuffer_tracking results: parsing output: 4/ for test: kms_force_connector_basic results: parsing output: 5/ for test: perf_pmu results: parsing output: 6/ for test: gem_ccs results: parsing output: 7/ for test: kms_plane_alpha_blend results: parsing output: 8/ for test: gem_mmap_gtt results: parsing output: 9/ for test: api_intel_allocator results: parsing output: 10/ for test: kms_frontbuffer_tracking results: parsing output: 11/ for test: kms_plane results: parsing output: 12/ for test: kms_ccs results: parsing output: 13/ for test: kms_ccs results: parsing output: 14/ for test: kms_frontbuffer_tracking results: parsing output: 15/ for test: gem_render_copy results: parsing output: 16/ for test: sysfs_heartbeat_interval results: parsing output: 17/ for test: kms_frontbuffer_tracking results: parsing output: 18/ for test: gem_ctx_param results: parsing output: 19/ for test: kms_psr results: parsing output: 20/ for test: i915_pm_freq_mult results: parsing output: 21/ for test: prime_busy results: parsing output: 22/ for test: gem_exec_gttfill results: parsing output: 23/ for test: syncobj_timeline results: parsing output: 24/ for test: gem_ctx_param results: parsing output: 25/ for test: kms_big_fb results: parsing output: 26/ for test: gem_lmem_swapping results: parsing output: 27/ for test: gem_ctx_shared results: parsing output: 28/ for test: kms_psr results: parsing output: 29/ for test: gem_bad_reloc results: parsing output: 30/ for test: kms_chamelium_hpd results: parsing output: 31/ for test: kms_psr2_sf results: parsing output: 32/ for test: gem_eio results: parsing output: 33/ for test: kms_content_protection results: parsing output: 34/ for test: syncobj_wait results: parsing output: 35/ for test: gem_ctx_isolation results: parsing output: 36/ for test: gem_flink_basic results: parsing output: 37/ for test: gem_caching results: parsing output: 38/ for test: kms_plane_scaling results: parsing output: 39/ for test: syncobj_timeline results: parsing output: 40/ for test: kms_frontbuffer_tracking results: parsing output: 41/ for test: kms_pm_rpm results: parsing output: 42/ for test: kms_atomic_transition results: parsing output: 43/ for test: kms_frontbuffer_tracking results: parsing output: 44/ for test: gem_spin_batch results: parsing output: 45/ for test: kms_frontbuffer_tracking results: parsing output: 46/ for test: syncobj_basic results: parsing output: 47/ for test: kms_frontbuffer_tracking results: parsing output: 48/ for test: kms_big_fb results: parsing output: 49/ for test: syncobj_timeline results: parsing output: 50/ for test: api_intel_bb results: parsing output: 51/ for test: kms_atomic_interruptible results: parsing output: 52/ for test: kms_big_fb results: parsing output: 53/ for test: kms_frontbuffer_tracking results: parsing output: 54/ for test: kms_flip_scaled_crc results: parsing output: 55/ for test: gem_pxp results: parsing output: 56/ for test: gen9_exec_parse results: parsing output: 57/ for test: kms_frontbuffer_tracking results: parsing output: 58/ for test: gem_exec_balancer results: parsing output: 59/ for test: kms_plane results: parsing output: 60/ for test: kms_frontbuffer_tracking results: parsing output: 61/ for test: kms_pwrite_crc results: parsing output: 62/ for test: gem_flink_basic results: parsing output: 63/ for test: kms_frontbuffer_tracking results: parsing output: 64/ for test: gem_ctx_persistence results: parsing output: 65/ for test: gen7_exec_parse results: parsing output: 66/ for test: gem_exec_schedule results: parsing output: 67/ for test: kms_frontbuffer_tracking results: parsing output: 68/ for test: perf results: parsing output: 69/ for test: kms_frontbuffer_tracking results: parsing output: 70/ for test: i915_drm_fdinfo results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: kms_pipe_crc_basic results: parsing output: 73/ for test: gem_exec_reloc results: parsing output: 74/ for test: kms_cursor_crc results: parsing output: 75/ for test: kms_color_pipeline results: parsing output: 76/ for test: kms_big_fb results: parsing output: 77/ for test: kms_big_fb results: parsing output: 78/ for test: kms_frontbuffer_tracking results: parsing output: 79/ for test: gem_exec_reloc results: parsing output: 80/ for test: kms_cursor_legacy results: parsing output: 81/ for test: kms_flip results: parsing output: 82/ for test: kms_frontbuffer_tracking results: parsing output: 83/ for test: kms_draw_crc results: parsing output: 84/ for test: kms_cursor_crc results: parsing output: 85/ for test: kms_cursor_crc results: parsing output: 86/ for test: kms_frontbuffer_tracking results: parsing output: 87/ for test: kms_frontbuffer_tracking results: parsing output: 88/ for test: kms_lease results: parsing output: 89/ for test: syncobj_wait results: parsing output: 90/ for test: kms_frontbuffer_tracking results: parsing output: 91/ for test: kms_big_fb results: parsing output: 92/ for test: kms_frontbuffer_tracking results: parsing output: 93/ for test: gem_exec_fence results: parsing output: 94/ for test: kms_frontbuffer_tracking results: parsing output: 95/ for test: kms_ccs results: parsing output: 96/ for test: kms_cursor_legacy results: parsing output: 97/ for test: kms_chamelium_audio results: parsing output: 98/ for test: kms_addfb_basic results: parsing output: 99/ for test: kms_frontbuffer_tracking results: parsing output: 100/ for test: kms_frontbuffer_tracking results: parsing output: 101/ for test: kms_frontbuffer_tracking results: parsing output: 102/ for test: kms_sequence results: parsing output: 103/ for test: kms_plane_scaling results: parsing output: 104/ for test: kms_frontbuffer_tracking results: parsing output: 105/ for test: gem_exec_reloc results: parsing output: 106/ for test: syncobj_timeline results: parsing output: 107/ for test: kms_psr results: parsing output: 108/ for test: syncobj_wait results: parsing output: 109/ for test: kms_busy results: parsing output: 110/ for test: kms_psr results: parsing output: 111/ for test: gem_softpin results: parsing output: 112/ for test: kms_force_connector_basic results: parsing output: 113/ for test: kms_chamelium_edid results: parsing output: 114/ for test: syncobj_timeline results: parsing output: 115/ for test: kms_frontbuffer_tracking results: parsing output: 116/ for test: kms_frontbuffer_tracking results: parsing output: 117/ for test: gem_mmap_gtt results: parsing output: 118/ for test: gem_render_copy results: parsing output: 119/ for test: kms_frontbuffer_tracking results: parsing output: 120/ for test: vgem_basic results: parsing output: 121/ for test: kms_flip_scaled_crc results: parsing output: 122/ for test: kms_frontbuffer_tracking results: parsing output: 123/ for test: kms_frontbuffer_tracking results: parsing output: 124/ for test: kms_frontbuffer_tracking results: parsing output: 125/ for test: kms_vblank results: parsing output: 126/ for test: kms_flip_scaled_crc results: parsing output: 127/ for test: gem_ctx_exec results: parsing output: 128/ for test: kms_frontbuffer_tracking results: parsing output: 129/ for test: kms_psr2_sf results: parsing output: 130/ for test: gem_ppgtt results: parsing output: 131/ for test: gem_exec_reloc results: parsing output: 132/ for test: gem_softpin results: parsing output: 133/ for test: gem_exec_capture results: parsing output: 134/ for test: gem_tiled_blits results: parsing output: 135/ for test: kms_frontbuffer_tracking results: parsing output: 136/ for test: gem_mmap_offset results: parsing output: 137/ for test: kms_frontbuffer_tracking results: parsing output: 138/ for test: kms_frontbuffer_tracking results: parsing output: 139/ for test: i915_power results: parsing output: 140/ for test: gem_exec_schedule results: parsing output: 141/ for test: kms_cursor_legacy results: parsing output: 142/ for test: i915_pm_rps results: parsing output: 143/ for test: kms_psr results: parsing output: 144/ for test: kms_setmode results: parsing output: 145/ for test: kms_frontbuffer_tracking results: parsing output: 146/ for test: kms_flip results: parsing output: 147/ for test: gem_exec_whisper results: parsing output: 148/ for test: dmabuf_sync_file results: parsing output: 149/ for test: kms_frontbuffer_tracking results: parsing output: 150/ for test: gem_sync results: parsing output: 151/ for test: kms_ccs results: parsing output: 152/ for test: syncobj_wait results: parsing output: 153/ for test: kms_frontbuffer_tracking Done.