[57.936528] Initializing watchdogs
[57.936681]   /dev/watchdog0
[57.955806] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.959994] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.962196] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.965540] [001/155] (960s left) gem_softpin (allocator-fork)
[58.059708] Starting subtest: allocator-fork
[60.307884] Subtest allocator-fork: SUCCESS (2.223s)
[60.435009] [002/155] (958s left) kms_addfb_basic (addfb25-modifier-no-flag)
[60.532862] Starting subtest: addfb25-modifier-no-flag
[60.535131] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[60.631354] [003/155] (957s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-indfb-msflip-blt)
[60.741850] Starting subtest: hdr-2p-scndscrn-indfb-msflip-blt
[60.746183] Subtest hdr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[60.871328] [004/155] (957s left) gem_ctx_shared (exec-shared-gtt)
[60.936192] Starting subtest: exec-shared-gtt
[60.938531] Starting dynamic subtest: rcs0
[60.948440] Dynamic subtest rcs0: SUCCESS (0.012s)
[60.961062] Starting dynamic subtest: bcs0
[60.963312] Dynamic subtest bcs0: SUCCESS (0.006s)
[60.971847] Starting dynamic subtest: vcs0
[60.974124] Dynamic subtest vcs0: SUCCESS (0.008s)
[60.982367] Starting dynamic subtest: vcs1
[60.984247] Dynamic subtest vcs1: SUCCESS (0.007s)
[60.991347] Starting dynamic subtest: vecs0
[60.993292] Dynamic subtest vecs0: SUCCESS (0.004s)
[61.000232] Starting dynamic subtest: ccs0
[61.002165] Dynamic subtest ccs0: SUCCESS (0.005s)
[61.004090] Subtest exec-shared-gtt: SUCCESS (0.043s)
[61.221100] [005/155] (957s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[61.324231] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[61.328730] Subtest hdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[61.439592] [006/155] (957s left) kms_getfb (getfb2-handle-zero)
[61.535908] Starting subtest: getfb2-handle-zero
[61.537726] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[61.626637] [007/155] (957s left) gen9_exec_parse (bb-start-cmd)
[61.687514] Subtest bb-start-cmd: SKIP (0.000s)
[61.748727] [008/155] (957s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier)
[61.833372] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier
[61.837322] Subtest pixel-format-4-tiled-lnl-ccs-modifier: SKIP (0.000s)
[61.905905] [009/155] (956s left) kms_addfb_basic (small-bo)
[61.995134] Starting subtest: small-bo
[61.996704] Subtest small-bo: SUCCESS (0.000s)
[62.074608] [010/155] (956s left) api_intel_allocator (default-alignment)
[62.125202] Starting subtest: default-alignment
[62.129194] Subtest default-alignment: SUCCESS (0.004s)
[62.256203] [011/155] (956s left) kms_chamelium_hpd (dp-hpd-after-suspend)
[62.644858] Subtest dp-hpd-after-suspend: SKIP (0.000s)
[63.516616] [012/155] (955s left) gem_exec_schedule (in-order)
[63.588486] Starting subtest: in-order
[63.590703] Starting dynamic subtest: rcs0
[63.681988] Dynamic subtest rcs0: SUCCESS (0.101s)
[63.691607] Starting dynamic subtest: vcs0
[63.770067] Dynamic subtest vcs0: SUCCESS (0.086s)
[63.782457] Starting dynamic subtest: vcs1
[63.847719] Dynamic subtest vcs1: SUCCESS (0.077s)
[63.860320] Starting dynamic subtest: vecs0
[63.931743] Dynamic subtest vecs0: SUCCESS (0.084s)
[63.943993] Starting dynamic subtest: ccs0
[64.018221] Dynamic subtest ccs0: SUCCESS (0.085s)
[64.020818] Subtest in-order: SUCCESS (0.435s)
[65.370670] [013/155] (953s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-render)
[65.471593] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-render
[65.475653] Subtest psrhdr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[65.560010] [014/155] (953s left) gem_mmap_offset (partial-mmap)
[65.618665] Starting subtest: partial-mmap
[65.620722] Starting dynamic subtest: smem0
[65.623629] Dynamic subtest smem0: SUCCESS (0.004s)
[65.625986] Subtest partial-mmap: SUCCESS (0.004s)
[65.730965] [015/155] (953s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[65.832760] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[70.601439] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (4.758s)
[70.697202] [016/155] (948s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[70.804691] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[70.809191] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[70.919601] [017/155] (948s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[71.018808] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[71.023143] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[71.130551] [018/155] (947s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0)
[71.230297] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0
[72.210822] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (0.979s)
[72.397611] [019/155] (946s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[72.647757] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[72.650416] Starting dynamic subtest: pipe-A
[72.984687] Dynamic subtest pipe-A: SUCCESS (0.339s)
[72.993221] Starting dynamic subtest: pipe-B
[74.404670] Dynamic subtest pipe-B: SUCCESS (1.417s)
[74.416207] Starting dynamic subtest: pipe-C
[75.832021] Dynamic subtest pipe-C: SUCCESS (1.425s)
[75.841803] Starting dynamic subtest: pipe-D
[77.281795] Dynamic subtest pipe-D: SUCCESS (1.448s)
[77.284344] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.631s)
[78.440109] [020/155] (940s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-render)
[78.542122] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-render
[78.546576] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[78.629111] [021/155] (940s left) kms_plane (pixel-format-linear-modifier)
[78.722838] Starting subtest: pixel-format-linear-modifier
[78.752502] Starting dynamic subtest: pipe-A-plane-0
[79.295426] Dynamic subtest pipe-A-plane-0: SUCCESS (0.544s)
[79.303080] Starting dynamic subtest: pipe-A-plane-3
[79.729570] Dynamic subtest pipe-A-plane-3: SUCCESS (0.432s)
[79.737482] Starting dynamic subtest: pipe-A-plane-5
[79.940156] Dynamic subtest pipe-A-plane-5: SUCCESS (0.210s)
[81.033381] Starting dynamic subtest: pipe-B-plane-0
[81.626600] Dynamic subtest pipe-B-plane-0: SUCCESS (0.600s)
[81.637385] Starting dynamic subtest: pipe-B-plane-3
[82.037990] Dynamic subtest pipe-B-plane-3: SUCCESS (0.411s)
[82.047071] Starting dynamic subtest: pipe-B-plane-5
[82.237823] Dynamic subtest pipe-B-plane-5: SUCCESS (0.200s)
[82.554197] Subtest pixel-format-linear-modifier: SUCCESS (3.828s)
[83.415280] [022/155] (935s left) syncobj_timeline (wait-all-for-submit-complex)
[83.468192] Starting subtest: wait-all-for-submit-complex
[83.682139] Subtest wait-all-for-submit-complex: SUCCESS (0.214s)
[83.779682] [023/155] (935s left) kms_psr2_sf (pr-plane-move-sf-dmg-area)
[83.884266] Starting subtest: pr-plane-move-sf-dmg-area
[83.888338] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s)
[83.948403] [024/155] (935s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[84.041302] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[84.045518] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[84.135056] [025/155] (935s left) gem_userptr_blits (userfault)
[84.204858] Starting subtest: userfault
[84.207224] Subtest userfault: SUCCESS (0.006s)
[84.337820] [026/155] (935s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[84.378056] Subtest heavy-verify-multi-ccs: SKIP (0.000s)
[84.421527] [027/155] (935s left) gem_exec_flush (basic-wb-rw-before-default)
[84.496200] Starting subtest: basic-wb-rw-before-default
[89.945691] Subtest basic-wb-rw-before-default: SUCCESS (5.448s)
[90.129437] [028/155] (929s left) i915_drm_fdinfo (all-busy-idle-check-all)
[90.171897] Starting subtest: all-busy-idle-check-all
[90.178887] Subtest all-busy-idle-check-all: SKIP (0.005s)
[90.238109] [029/155] (929s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-draw-pwrite)
[90.363120] Starting subtest: fbchdr-2p-primscrn-spr-indfb-draw-pwrite
[90.367383] Subtest fbchdr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[90.463273] [030/155] (929s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc)
[90.565537] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc
[90.569991] Subtest fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[90.658703] [031/155] (928s left) gem_mmap_gtt (basic-write)
[90.718238] Subtest basic-write: SKIP (0.000s)
[90.778554] [032/155] (928s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[90.877792] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[90.882233] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[90.988984] [033/155] (928s left) kms_frontbuffer_tracking (psr-1p-rte)
[91.088166] Starting subtest: psr-1p-rte
[96.513201] Subtest psr-1p-rte: SUCCESS (5.428s)
[96.657249] [034/155] (923s left) kms_cursor_edge_walk (64x64-top-edge)
[96.752017] Starting subtest: 64x64-top-edge
[96.754323] Starting dynamic subtest: pipe-A-eDP-1
[100.203343] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.451s)
[100.212755] Starting dynamic subtest: pipe-D-eDP-1
[103.327243] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.121s)
[103.329469] Subtest 64x64-top-edge: SUCCESS (6.574s)
[104.134682] [035/155] (915s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted)
[104.196941] Starting subtest: multi-wait-all-for-submit-unsubmitted
[104.302890] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.105s)
[104.384835] [036/155] (915s left) gem_bad_reloc (negative-reloc-bltcopy)
[104.451241] Subtest negative-reloc-bltcopy: SKIP (0.000s)
[104.516778] [037/155] (915s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[104.610415] Starting subtest: psr-rgb565-draw-pwrite
[111.742495] Subtest psr-rgb565-draw-pwrite: SUCCESS (7.137s)
[111.853632] [038/155] (908s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[111.960679] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[118.942387] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.985s)
[119.079896] [039/155] (900s left) kms_big_fb (y-tiled-16bpp-rotate-90)
[119.185212] Starting subtest: y-tiled-16bpp-rotate-90
[119.189468] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s)
[119.284843] [040/155] (900s left) kms_cursor_crc (cursor-onscreen-64x64)
[119.454839] Starting subtest: cursor-onscreen-64x64
[119.457202] Starting dynamic subtest: pipe-A-eDP-1
[121.567726] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.110s)
[121.594245] Starting dynamic subtest: pipe-D-eDP-1
[124.370596] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.781s)
[124.372818] Subtest cursor-onscreen-64x64: SUCCESS (4.915s)
[125.252707] [041/155] (894s left) gem_ctx_bad_destroy (invalid-pad)
[125.298619] Starting subtest: invalid-pad
[125.300802] Subtest invalid-pad: SUCCESS (0.000s)
[125.370144] [042/155] (894s left) gem_mmap_gtt (close-race)
[125.423061] Subtest close-race: SKIP (0.000s)
[125.475859] [043/155] (894s left) kms_addfb_basic (bad-pitch-65536)
[125.524329] Starting subtest: bad-pitch-65536
[125.526899] Subtest bad-pitch-65536: SUCCESS (0.000s)
[125.668386] [044/155] (894s left) api_intel_bb (intel-bb-blit-x)
[125.723431] Starting subtest: intel-bb-blit-x
[129.090623] Subtest intel-bb-blit-x: SUCCESS (3.367s)
[129.199202] [045/155] (891s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[129.246507] Starting subtest: legacy-engines-hostile-preempt
[129.249064] Starting dynamic subtest: render
[129.349597] Dynamic subtest render: SUCCESS (0.103s)
[129.359261] Starting dynamic subtest: bsd1
[131.232771] Dynamic subtest bsd1: SUCCESS (1.880s)
[131.245680] Starting dynamic subtest: bsd2
[133.305336] Dynamic subtest bsd2: SUCCESS (2.068s)
[133.316107] Starting dynamic subtest: blt
[133.365761] Dynamic subtest blt: SUCCESS (0.060s)
[133.375562] Starting dynamic subtest: vebox
[135.288362] Dynamic subtest vebox: SUCCESS (1.919s)
[135.291059] Subtest legacy-engines-hostile-preempt: SUCCESS (6.041s)
[135.370727] [046/155] (884s left) kms_big_fb (linear-64bpp-rotate-90)
[135.483347] Starting subtest: linear-64bpp-rotate-90
[135.503075] Subtest linear-64bpp-rotate-90: SKIP (0.020s)
[135.641364] [047/155] (884s left) dmabuf_sync_file (export-multiwait)
[135.747225] Starting subtest: export-multiwait
[135.749237] Subtest export-multiwait: SUCCESS (0.001s)
[135.802671] [FACT dmabuf_sync_file (export-multiwait)] new: kernel.kmod_is_loaded.vgem: true
[135.806146] [048/155] (884s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[135.909791] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[142.927906] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.023s)
[143.064814] [049/155] (877s left) gem_exec_parallel (basic)
[143.126631] Starting subtest: basic
[143.129030] Starting dynamic subtest: rcs0
[144.596039] Dynamic subtest rcs0: SUCCESS (1.469s)
[144.607892] Starting dynamic subtest: bcs0
[146.049908] Dynamic subtest bcs0: SUCCESS (1.452s)
[146.058365] Starting dynamic subtest: vcs0
[149.307496] Dynamic subtest vcs0: SUCCESS (3.255s)
[149.319037] Starting dynamic subtest: vcs1
[151.226718] Dynamic subtest vcs1: SUCCESS (1.917s)
[151.238448] Starting dynamic subtest: vecs0
[153.274455] Dynamic subtest vecs0: SUCCESS (2.046s)
[153.285758] Starting dynamic subtest: ccs0
[154.760467] Dynamic subtest ccs0: SUCCESS (1.485s)
[154.763036] Subtest basic: SUCCESS (11.635s)
[154.953736] [050/155] (865s left) perf_pmu (busy-double-start)
[154.998954] Starting subtest: busy-double-start
[155.001698] Starting dynamic subtest: rcs0
[158.636937] Dynamic subtest rcs0: FAIL (3.585s)
[158.647112] Starting dynamic subtest: bcs0
[162.155763] Dynamic subtest bcs0: SUCCESS (3.573s)
[162.166850] Starting dynamic subtest: vcs0
[165.857041] Dynamic subtest vcs0: SUCCESS (3.699s)
[165.867079] Starting dynamic subtest: vcs1
[169.789778] Dynamic subtest vcs1: SUCCESS (3.931s)
[169.800706] Starting dynamic subtest: vecs0
[173.840766] Dynamic subtest vecs0: SUCCESS (4.049s)
[173.851399] Starting dynamic subtest: ccs0
[177.475419] Dynamic subtest ccs0: FAIL (3.567s)
[177.477645] Subtest busy-double-start: FAIL (22.414s)
[177.521812] [051/155] (842s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-shrfb-draw-blt)
[177.628153] Starting subtest: psrhdr-1p-primscrn-pri-shrfb-draw-blt
[177.632133] Subtest psrhdr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[177.725583] [052/155] (842s left) gem_ctx_param (invalid-set-ringsize)
[177.779728] Starting subtest: invalid-set-ringsize
[177.781616] Subtest invalid-set-ringsize: SUCCESS (0.000s)
[177.882097] [053/155] (842s left) gem_exec_parallel (contexts)
[177.935164] Starting subtest: contexts
[177.937495] Starting dynamic subtest: rcs0
[180.931768] Dynamic subtest rcs0: SUCCESS (2.995s)
[180.943603] Starting dynamic subtest: bcs0
[184.232098] Dynamic subtest bcs0: SUCCESS (3.300s)
[184.242363] Starting dynamic subtest: vcs0
[188.581896] Dynamic subtest vcs0: SUCCESS (4.348s)
[188.595317] Starting dynamic subtest: vcs1
[192.691821] Dynamic subtest vcs1: SUCCESS (4.107s)
[192.700800] Starting dynamic subtest: vecs0
[196.732968] Dynamic subtest vecs0: SUCCESS (4.041s)
[196.741969] Starting dynamic subtest: ccs0
[200.414944] Dynamic subtest ccs0: SUCCESS (3.681s)
[200.417303] Subtest contexts: SUCCESS (22.479s)
[200.604892] [054/155] (819s left) syncobj_basic (create-signaled)
[200.665387] Starting subtest: create-signaled
[200.667984] Subtest create-signaled: SUCCESS (0.000s)
[200.773947] [055/155] (819s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[200.883818] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu
[200.888388] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[200.983449] [056/155] (819s left) kms_lease (lease-uevent)
[201.074104] Starting subtest: lease-uevent
[202.080410] Subtest lease-uevent: SUCCESS (1.009s)
[202.154245] [057/155] (818s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-cpu)
[202.260278] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-cpu
[209.326456] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (7.072s)
[209.426167] [058/155] (811s left) kms_psr (psr-primary-render)
[209.525798] Starting subtest: psr-primary-render
[209.528097] Starting dynamic subtest: eDP-1
[211.301759] Dynamic subtest eDP-1: SUCCESS (1.774s)
[211.304280] Subtest psr-primary-render: SUCCESS (1.775s)
[212.149380] [059/155] (808s left) kms_ccs (crc-sprite-planes-basic-4-tiled-bmg-ccs)
[212.247220] Starting subtest: crc-sprite-planes-basic-4-tiled-bmg-ccs
[212.251846] Subtest crc-sprite-planes-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[213.371859] [060/155] (807s left) kms_flip (absolute-wf_vblank-interruptible)
[213.474723] Starting subtest: absolute-wf_vblank-interruptible
[213.477185] Starting dynamic subtest: A-eDP1
[222.231254] Dynamic subtest A-eDP1: SUCCESS (8.755s)
[222.239955] Starting dynamic subtest: B-eDP1
[230.967860] Dynamic subtest B-eDP1: SUCCESS (8.734s)
[230.979700] Starting dynamic subtest: C-eDP1
[239.701731] Dynamic subtest C-eDP1: SUCCESS (8.732s)
[239.710280] Starting dynamic subtest: D-eDP1
[248.439525] Dynamic subtest D-eDP1: SUCCESS (8.736s)
[248.442203] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.967s)
[249.647854] [061/155] (771s left) kms_prop_blob (blob-prop-lifetime)
[249.702989] Starting subtest: blob-prop-lifetime
[249.705250] Subtest blob-prop-lifetime: SUCCESS (0.001s)
[249.797720] [062/155] (771s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[249.849212] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[249.853553] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[250.035274] [063/155] (770s left) gem_pxp (create-protected-buffer)
[250.156765] Starting subtest: create-protected-buffer
[250.159511] Subtest create-protected-buffer: SUCCESS (0.000s)
[250.274814] [064/155] (770s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[250.327067] Subtest tiled-to-untiled: SKIP (0.000s)
[250.405823] [065/155] (770s left) i915_module_load (reload-no-display)
[250.441174] Starting subtest: reload-no-display
[257.686656] Subtest reload-no-display: SUCCESS (7.247s)
[257.717484] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[257.718198] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true
[257.721416] [066/155] (763s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[259.283953] Starting subtest: y-tiled-to-vebox-x-tiled
[259.288651] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[259.433660] [FACT gem_render_copy (y-tiled-to-vebox-x-tiled)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[259.434903] [FACT gem_render_copy (y-tiled-to-vebox-x-tiled)] new: kernel.kmod_is_loaded.i915: true
[259.438981] [067/155] (761s left) kms_vblank (wait-forked)
[259.534274] Starting subtest: wait-forked
[259.536357] Starting dynamic subtest: pipe-A-eDP-1
[261.384231] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.849s)
[261.396726] Starting dynamic subtest: pipe-D-eDP-1
[263.933816] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.547s)
[263.936037] Subtest wait-forked: SUCCESS (4.399s)
[264.789553] [068/155] (756s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-mmap-wc)
[264.891082] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-mmap-wc
[264.895242] Subtest hdr-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[264.996830] [069/155] (756s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite)
[265.105756] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite
[265.109749] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[265.202502] [070/155] (756s left) gem_exec_flush (basic-wb-pro-default)
[265.272365] Starting subtest: basic-wb-pro-default
[270.725327] Subtest basic-wb-pro-default: SUCCESS (5.456s)
[270.926490] [071/155] (750s left) kms_async_flips (invalid-async-flip)
[271.013735] Starting subtest: invalid-async-flip
[271.387345] Starting dynamic subtest: pipe-A-eDP-1
[272.211218] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.824s)
[272.588619] Starting dynamic subtest: pipe-B-eDP-1
[273.441399] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.863s)
[273.797007] Starting dynamic subtest: pipe-C-eDP-1
[274.652553] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.862s)
[275.014228] Starting dynamic subtest: pipe-D-eDP-1
[275.799322] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.794s)
[275.801760] Subtest invalid-async-flip: SUCCESS (4.788s)
[276.950411] [072/155] (744s left) gem_mmap_gtt (big-bo-tiledy)
[277.007204] Subtest big-bo-tiledY: SKIP (0.000s)
[277.070745] [073/155] (744s left) kms_invalid_mode (zero-clock)
[277.165653] Starting subtest: zero-clock
[277.167929] Starting dynamic subtest: pipe-A-eDP-1
[277.447967] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s)
[277.457428] Starting dynamic subtest: pipe-B-eDP-1
[277.459540] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[277.469185] Starting dynamic subtest: pipe-C-eDP-1
[277.471696] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[277.482803] Starting dynamic subtest: pipe-D-eDP-1
[277.485220] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[277.487700] Subtest zero-clock: SUCCESS (0.289s)
[278.267566] [074/155] (743s left) syncobj_timeline (multi-wait-submitted-signaled)
[278.321922] Starting subtest: multi-wait-submitted-signaled
[278.324450] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s)
[278.427645] [075/155] (743s left) kms_psr (fbc-pr-basic)
[278.520394] Starting subtest: fbc-pr-basic
[278.524535] Subtest fbc-pr-basic: SKIP (0.000s)
[278.589550] [076/155] (742s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-cpu)
[278.681088] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-cpu
[282.281021] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-cpu: SUCCESS (3.605s)
[283.515913] [077/155] (738s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[283.575969] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[283.678218] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.101s)
[283.769372] [078/155] (737s left) gem_exec_fence (syncobj-invalid-flags)
[284.180082] Starting subtest: syncobj-invalid-flags
[284.182633] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[285.387626] [079/155] (736s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[285.489242] Starting subtest: primary-x-tiled-reflect-x-0
[292.518667] Subtest primary-x-tiled-reflect-x-0: SUCCESS (7.031s)
[293.742868] [080/155] (727s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[293.839190] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[293.841456] Starting dynamic subtest: pipe-A-default-mode
[295.004377] Dynamic subtest pipe-A-default-mode: SKIP (1.163s)
[295.008900] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (1.165s)
[295.152927] [081/155] (726s left) kms_chamelium_color (ctm-max)
[295.244363] Subtest ctm-max: SKIP (0.000s)
[295.289169] [082/155] (726s left) prime_mmap (test_forked_cpu_write)
[295.352049] Starting subtest: test_forked_cpu_write
[295.354415] Starting dynamic subtest: test_forked_cpu_write-smem
[295.360676] Dynamic subtest test_forked_cpu_write-smem: SUCCESS (0.008s)
[295.363071] Subtest test_forked_cpu_write: SUCCESS (0.009s)
[295.451964] [083/155] (726s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt)
[295.553640] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt
[295.557969] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[295.644216] [084/155] (726s left) kms_color (invalid-degamma-lut-sizes)
[295.730816] Starting subtest: invalid-degamma-lut-sizes
[295.733097] Starting dynamic subtest: pipe-A
[296.022401] Dynamic subtest pipe-A: SUCCESS (0.290s)
[296.031541] Starting dynamic subtest: pipe-B
[296.033928] Dynamic subtest pipe-B: SUCCESS (0.000s)
[296.042516] Starting dynamic subtest: pipe-C
[296.045060] Dynamic subtest pipe-C: SUCCESS (0.000s)
[296.053511] Starting dynamic subtest: pipe-D
[296.055926] Dynamic subtest pipe-D: SUCCESS (0.000s)
[296.058332] Subtest invalid-degamma-lut-sizes: SUCCESS (0.294s)
[296.903467] [085/155] (724s left) gem_exec_params (readonly)
[296.963634] Starting subtest: readonly
[296.968481] Subtest readonly: SUCCESS (0.003s)
[297.107465] [086/155] (724s left) kms_psr (pr-cursor-blt)
[297.206109] Starting subtest: pr-cursor-blt
[297.210664] Subtest pr-cursor-blt: SKIP (0.000s)
[297.283615] [087/155] (724s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[297.382588] Starting subtest: plane-all-transition-nonblocking-fencing
[297.384891] Starting dynamic subtest: pipe-A-eDP-1
[299.875616] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[300.196397] Starting dynamic subtest: pipe-B-eDP-1
[303.448220] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.259s)
[303.745564] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (6.365s)
[304.567475] [088/155] (717s left) kms_rotation_crc (bad-tiling)
[304.657098] Starting subtest: bad-tiling
[304.661047] Subtest bad-tiling: SKIP (0.000s)
[304.728013] [089/155] (717s left) gem_busy (busy)
[304.789232] Starting subtest: busy
[304.791420] Starting dynamic subtest: all-engines
[304.856385] Dynamic subtest all-engines: SUCCESS (0.070s)
[304.865508] Starting dynamic subtest: rcs0
[306.305774] Dynamic subtest rcs0: SUCCESS (1.448s)
[306.317200] Starting dynamic subtest: bcs0
[306.346516] Dynamic subtest bcs0: SUCCESS (0.038s)
[306.358881] Starting dynamic subtest: vcs0
[306.388809] Dynamic subtest vcs0: SUCCESS (0.039s)
[306.406967] Starting dynamic subtest: vcs1
[308.291531] Dynamic subtest vcs1: SUCCESS (1.901s)
[308.308281] Starting dynamic subtest: vecs0
[310.273562] Dynamic subtest vecs0: SUCCESS (1.980s)
[310.285067] Starting dynamic subtest: ccs0
[312.320394] Dynamic subtest ccs0: SUCCESS (2.045s)
[312.322546] Subtest busy: SUCCESS (7.531s)
[312.687308] [090/155] (709s left) kms_frontbuffer_tracking (hdr-1p-pri-indfb-multidraw)
[312.788370] Starting subtest: hdr-1p-pri-indfb-multidraw
[312.792306] Subtest hdr-1p-pri-indfb-multidraw: SKIP (0.000s)
[312.881121] [091/155] (709s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[312.984721] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[312.988726] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[313.084509] [092/155] (709s left) kms_cursor_legacy (cursorb-vs-flipa-legacy)
[313.194400] Starting subtest: cursorB-vs-flipA-legacy
[313.198799] Subtest cursorB-vs-flipA-legacy: SKIP (0.001s)
[313.337573] [093/155] (708s left) gem_exec_reloc (basic-wc-active)
[313.399105] Subtest basic-wc-active: SKIP (0.000s)
[313.473549] [094/155] (708s left) kms_feature_discovery (display-4x)
[313.559244] Starting subtest: display-4x
[313.563539] Subtest display-4x: SKIP (0.000s)
[313.642813] [095/155] (708s left) kms_plane_alpha_blend (alpha-basic)
[313.725521] Starting subtest: alpha-basic
[314.014082] Starting dynamic subtest: pipe-A-eDP-1
[315.916305] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.898s)
[315.941095] Starting dynamic subtest: pipe-D-eDP-1
[318.655064] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.721s)
[318.657558] Subtest alpha-basic: SUCCESS (4.931s)
[319.523700] [096/155] (702s left) gem_create (create-ext-cpu-access-big)
[319.691233] Starting subtest: create-ext-cpu-access-big
[319.696154] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[319.763943] [097/155] (702s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[319.869288] Starting subtest: fbcpsr-2p-rte
[319.873576] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[319.965795] [098/155] (702s left) kms_content_protection (content-type-change)
[320.103800] Starting subtest: content-type-change
[320.108423] Subtest content-type-change: SKIP (0.000s)
[320.229152] [099/155] (702s left) gem_softpin (overlap)
[320.296054] Starting subtest: overlap
[321.170545] Subtest overlap: SUCCESS (0.874s)
[321.287903] [100/155] (701s left) perf_pmu (module-unload)