[60.316644] Initializing watchdogs
[60.316792]   /dev/watchdog0
[60.332519] [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]
[60.337197] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[60.340051] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[60.343239] [001/131] (960s left) gem_exec_fence (basic-wait-all)
[60.419778] Starting subtest: basic-wait-all
[60.518965] Subtest basic-wait-all: SUCCESS (0.100s)
[61.987144] [FACT gem_exec_fence (basic-wait-all)] new: kernel.kmod_is_loaded.vgem: true
[61.992881] [002/131] (958s left) kms_color (ctm-0-50)
[62.092838] Starting subtest: ctm-0-50
[62.095161] Starting dynamic subtest: pipe-A-eDP-1
[65.710686] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.614s)
[65.719298] Starting dynamic subtest: pipe-B-eDP-1
[69.924550] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.215s)
[69.931795] Starting dynamic subtest: pipe-C-eDP-1
[73.954568] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.028s)
[73.963126] Starting dynamic subtest: pipe-D-eDP-1
[77.955805] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.001s)
[77.958136] Subtest ctm-0-50: SUCCESS (15.860s)
[78.794934] [003/131] (942s left) kms_legacy_colorkey (invalid-plane)
[78.890045] Starting subtest: invalid-plane
[78.892117] Starting dynamic subtest: zero-id
[78.894079] Dynamic subtest zero-id: SUCCESS (0.000s)
[78.902502] Starting dynamic subtest: outrange-id
[78.904786] Dynamic subtest outrange-id: SUCCESS (0.000s)
[78.907098] Subtest invalid-plane: SUCCESS (0.000s)
[78.961062] [004/131] (942s left) kms_chamelium_color (ctm-limited-range)
[79.056297] Subtest ctm-limited-range: SKIP (0.000s)
[79.099787] [005/131] (941s left) prime_vgem (basic-fence-blt)
[79.175364] Starting subtest: basic-fence-blt
[79.252737] Subtest basic-fence-blt: SUCCESS (0.080s)
[79.378584] [006/131] (941s left) perf (buffer-fill)
[79.500197] Starting subtest: buffer-fill
[79.502086] Starting dynamic subtest: 0-rcs0
[81.771956] Dynamic subtest 0-rcs0: SUCCESS (2.272s)
[81.780289] Starting dynamic subtest: 1-vcs1
[86.213595] Dynamic subtest 1-vcs1: SUCCESS (4.442s)
[86.216206] Subtest buffer-fill: SUCCESS (6.715s)
[86.263826] [007/131] (934s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff)
[86.360793] Starting subtest: psr-1p-primscrn-spr-indfb-onoff
[93.525377] Subtest psr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.167s)
[93.664986] [008/131] (927s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180)
[93.763538] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180
[93.767611] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[93.859045] [009/131] (927s left) kms_pm_rpm (dpms-mode-unset-lpsp)
[96.011255] Starting subtest: dpms-mode-unset-lpsp
[100.044561] Subtest dpms-mode-unset-lpsp: SUCCESS (4.032s)
[100.438251] [010/131] (920s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt)
[100.538987] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt
[100.543702] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[100.632091] [011/131] (920s left) gen9_exec_parse (valid-registers)
[100.690129] Subtest valid-registers: SKIP (0.000s)
[100.755012] [012/131] (920s left) kms_flip (basic-plain-flip)
[100.848544] Starting subtest: basic-plain-flip
[100.850907] Starting dynamic subtest: A-eDP1
[102.524987] Dynamic subtest A-eDP1: SUCCESS (1.678s)
[102.537843] Starting dynamic subtest: B-eDP1
[104.183648] Dynamic subtest B-eDP1: SUCCESS (1.657s)
[104.193469] Starting dynamic subtest: C-eDP1
[105.812818] Dynamic subtest C-eDP1: SUCCESS (1.627s)
[105.822214] Starting dynamic subtest: D-eDP1
[107.447726] Dynamic subtest D-eDP1: SUCCESS (1.631s)
[107.450223] Subtest basic-plain-flip: SUCCESS (6.604s)
[108.626252] [013/131] (912s left) i915_query (query-topology-coherent-slice-mask)
[108.690022] Starting subtest: query-topology-coherent-slice-mask
[108.694122] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[108.788733] [014/131] (912s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[108.883615] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[108.887932] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[108.965356] [015/131] (912s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[109.059182] Starting subtest: psr2-primary-plane-update-sf-dmg-area
[109.061451] Starting dynamic subtest: pipe-A-eDP-1
[114.908984] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.857s)
[114.916843] Starting dynamic subtest: pipe-B-eDP-1
[121.579407] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.669s)
[121.581800] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (12.528s)
[122.453048] [016/131] (898s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[122.552836] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[122.554985] Starting dynamic subtest: pipe-A-eDP-1
[122.563804] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[122.572237] Starting dynamic subtest: pipe-B-eDP-1
[122.580998] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[122.589075] Starting dynamic subtest: pipe-C-eDP-1
[122.597141] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[122.604436] Starting dynamic subtest: pipe-D-eDP-1
[122.612761] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[122.616742] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[124.828665] [017/131] (896s left) gem_exec_fence (parallel)
[125.001894] Starting subtest: parallel
[125.004321] Starting dynamic subtest: rcs0
[127.154016] Dynamic subtest rcs0: SUCCESS (2.153s)
[127.162332] Starting dynamic subtest: bcs0
[129.309753] Dynamic subtest bcs0: SUCCESS (2.155s)
[129.318893] Starting dynamic subtest: vcs0
[131.461604] Dynamic subtest vcs0: SUCCESS (2.151s)
[131.470784] Starting dynamic subtest: vcs1
[133.610862] Dynamic subtest vcs1: SUCCESS (2.149s)
[133.619825] Starting dynamic subtest: vecs0
[135.763636] Dynamic subtest vecs0: SUCCESS (2.152s)
[135.775897] Starting dynamic subtest: ccs0
[137.915144] Dynamic subtest ccs0: SUCCESS (2.151s)
[137.917266] Subtest parallel: SUCCESS (12.914s)
[139.006219] [018/131] (882s left) gem_render_copy_redux (interruptible)
[139.076024] Starting subtest: interruptible
[139.452481] Subtest interruptible: SUCCESS (0.376s)
[139.562099] [019/131] (882s left) perf_pmu (init-busy)
[139.606907] Starting subtest: init-busy
[139.609349] Starting dynamic subtest: rcs0
[139.611669] Dynamic subtest rcs0: SUCCESS (0.001s)
[139.621713] Starting dynamic subtest: bcs0
[139.623993] Dynamic subtest bcs0: SUCCESS (0.000s)
[139.631833] Starting dynamic subtest: vcs0
[139.633681] Dynamic subtest vcs0: SUCCESS (0.001s)
[139.641553] Starting dynamic subtest: vcs1
[139.643725] Dynamic subtest vcs1: SUCCESS (0.000s)
[139.651313] Starting dynamic subtest: vecs0
[139.653163] Dynamic subtest vecs0: SUCCESS (0.001s)
[139.660291] Starting dynamic subtest: ccs0
[139.662606] Dynamic subtest ccs0: SUCCESS (0.000s)
[139.664766] Subtest init-busy: SUCCESS (0.006s)
[139.708249] [020/131] (881s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[139.815739] Starting subtest: x-tiled-64bpp-rotate-270
[139.837929] Subtest x-tiled-64bpp-rotate-270: SKIP (0.022s)
[139.939296] [021/131] (881s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[140.029408] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[140.031459] Starting dynamic subtest: pipe-A-eDP-1
[140.052381] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[140.064491] Starting dynamic subtest: pipe-B-eDP-1
[140.085368] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[140.096247] Starting dynamic subtest: pipe-C-eDP-1
[140.116019] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[140.123181] Starting dynamic subtest: pipe-D-eDP-1
[140.142919] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[140.146288] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[142.299065] [022/131] (879s left) gem_mmap_wc (write)
[142.368960] Subtest write: SKIP (0.000s)
[142.439193] [023/131] (879s left) gem_ppgtt (shrink-vs-evict-any)
[142.505867] Starting subtest: shrink-vs-evict-any
[147.882741] Subtest shrink-vs-evict-any: SUCCESS (5.376s)
[147.969472] [024/131] (873s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs)
[148.068673] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs
[148.071090] Starting dynamic subtest: pipe-A-eDP-1
[148.130080] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.063s)
[148.138213] Starting dynamic subtest: pipe-B-eDP-1
[148.193347] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.062s)
[148.201225] Starting dynamic subtest: pipe-C-eDP-1
[148.255801] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.060s)
[148.264118] Starting dynamic subtest: pipe-D-eDP-1
[148.318348] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.062s)
[148.320587] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.252s)
[150.493273] [025/131] (871s left) gem_exec_params (no-bsd)
[150.569737] Starting subtest: no-bsd
[150.571964] Subtest no-bsd: SUCCESS (0.003s)
[151.942617] [026/131] (869s left) i915_pm_rpm (reg-read-ioctl)
[154.085085] Starting subtest: reg-read-ioctl
[156.483637] Subtest reg-read-ioctl: SUCCESS (2.402s)
[156.871821] [027/131] (865s left) syncobj_timeline (multi-wait-signaled)
[156.938099] Starting subtest: multi-wait-signaled
[156.940424] Subtest multi-wait-signaled: SUCCESS (0.001s)
[157.050585] [028/131] (864s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[157.156358] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[157.160714] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[157.258468] [029/131] (864s left) kms_psr (pr-cursor-blt)
[157.357029] Starting subtest: pr-cursor-blt
[157.361305] Subtest pr-cursor-blt: SKIP (0.000s)
[157.437198] [030/131] (864s left) sw_sync (alloc_merge_fence)
[157.475944] Starting subtest: alloc_merge_fence
[157.478270] Subtest alloc_merge_fence: SUCCESS (0.000s)
[157.526947] [031/131] (864s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[157.637286] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[158.261807] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.626s)
[158.427806] [032/131] (863s left) kms_big_fb (y-tiled-32bpp-rotate-270)
[158.532288] Starting subtest: y-tiled-32bpp-rotate-270
[158.536311] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s)
[158.630264] [033/131] (863s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[158.734680] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[158.739097] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[158.844445] [034/131] (863s left) kms_vrr (flip-basic-fastset)
[158.942227] Starting subtest: flip-basic-fastset
[158.948764] Subtest flip-basic-fastset: SKIP (0.000s)
[159.012915] [035/131] (863s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[159.391093] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[160.170505] [036/131] (862s left) gem_ctx_persistence (engines-queued)
[160.231500] Starting subtest: engines-queued
[160.234044] Starting dynamic subtest: rcs0
[160.292768] Dynamic subtest rcs0: SUCCESS (0.061s)
[160.306256] Starting dynamic subtest: bcs0
[160.336469] Dynamic subtest bcs0: SUCCESS (0.043s)
[160.345840] Starting dynamic subtest: vcs0
[161.908447] Dynamic subtest vcs0: SUCCESS (1.569s)
[161.919027] Starting dynamic subtest: vcs1
[163.826269] Dynamic subtest vcs1: SUCCESS (1.915s)
[163.837724] Starting dynamic subtest: vecs0
[165.811577] Dynamic subtest vecs0: SUCCESS (1.981s)
[165.823836] Starting dynamic subtest: ccs0
[166.046699] Dynamic subtest ccs0: SUCCESS (0.234s)
[166.049222] Subtest engines-queued: SUCCESS (5.816s)
[166.128598] [037/131] (856s left) kms_addfb_basic (unused-modifier)
[166.177033] Starting subtest: unused-modifier
[166.178968] Subtest unused-modifier: SUCCESS (0.000s)
[166.317581] [038/131] (856s left) gem_exec_schedule (preempt-other-chain)
[166.390935] Starting subtest: preempt-other-chain
[166.393155] Starting dynamic subtest: rcs0
[166.474063] Dynamic subtest rcs0: SUCCESS (0.091s)
[166.484913] Starting dynamic subtest: bcs0
[166.570057] Dynamic subtest bcs0: SUCCESS (0.096s)
[166.578607] Starting dynamic subtest: vcs0
[166.652654] Dynamic subtest vcs0: SUCCESS (0.081s)
[166.665464] Starting dynamic subtest: vcs1
[166.736866] Dynamic subtest vcs1: SUCCESS (0.082s)
[166.751042] Starting dynamic subtest: vecs0
[166.817391] Dynamic subtest vecs0: SUCCESS (0.080s)
[166.829077] Starting dynamic subtest: ccs0
[166.903402] Dynamic subtest ccs0: SUCCESS (0.085s)
[166.905994] Subtest preempt-other-chain: SUCCESS (0.520s)
[167.975726] [039/131] (854s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[168.066155] Starting subtest: fbc-psr2-primary-mmap-gtt
[168.068522] Starting dynamic subtest: eDP-1
[168.073062] Dynamic subtest eDP-1: SKIP (0.000s)
[168.077451] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s)
[168.154424] [040/131] (854s left) gem_exec_parallel (contexts)
[168.219805] Starting subtest: contexts
[168.222232] Starting dynamic subtest: rcs0
[170.935330] Dynamic subtest rcs0: SUCCESS (2.713s)
[170.946299] Starting dynamic subtest: bcs0
[174.290326] Dynamic subtest bcs0: SUCCESS (3.354s)
[174.322154] Starting dynamic subtest: vcs0
[178.362933] Dynamic subtest vcs0: SUCCESS (4.070s)
[178.374253] Starting dynamic subtest: vcs1
[182.385411] Dynamic subtest vcs1: SUCCESS (4.020s)
[182.394358] Starting dynamic subtest: vecs0
[186.365247] Dynamic subtest vecs0: SUCCESS (3.978s)
[186.376289] Starting dynamic subtest: ccs0
[190.155631] Dynamic subtest ccs0: SUCCESS (3.788s)
[190.158219] Subtest contexts: SUCCESS (21.934s)
[190.345545] [041/131] (832s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[190.443937] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[197.055123] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.613s)
[197.169630] [042/131] (825s left) syncobj_wait (multi-wait-for-submit-signaled)
[197.221514] Starting subtest: multi-wait-for-submit-signaled
[197.223852] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s)
[197.336476] [043/131] (825s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[197.427308] Starting subtest: plane-primary-toggle-with-vblank-wait
[197.429638] Starting dynamic subtest: pipe-A-eDP-1
[197.603304] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.177s)
[197.913594] Starting dynamic subtest: pipe-B-eDP-1
[198.818546] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.912s)
[199.123422] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.695s)
[199.973720] [044/131] (822s left) kms_chamelium_edid (dp-mode-timings)
[200.349610] Subtest dp-mode-timings: SKIP (0.000s)
[201.184076] [045/131] (821s left) kms_plane (pixel-format-4-tiled-mtl-mc-ccs-modifier)
[201.280467] Starting subtest: pixel-format-4-tiled-mtl-mc-ccs-modifier
[201.308581] Starting dynamic subtest: pipe-A-plane-0
[201.752725] Dynamic subtest pipe-A-plane-0: SUCCESS (0.444s)
[201.761593] Starting dynamic subtest: pipe-A-plane-3
[202.030433] Dynamic subtest pipe-A-plane-3: SUCCESS (0.277s)
[202.039558] Starting dynamic subtest: pipe-A-plane-5
[202.044050] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[203.092819] Starting dynamic subtest: pipe-B-plane-0
[203.551986] Dynamic subtest pipe-B-plane-0: SUCCESS (0.466s)
[203.565642] Starting dynamic subtest: pipe-B-plane-3
[203.807616] Dynamic subtest pipe-B-plane-3: SUCCESS (0.255s)
[203.816642] Starting dynamic subtest: pipe-B-plane-5
[203.820847] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[204.119251] Subtest pixel-format-4-tiled-mtl-mc-ccs-modifier: SUCCESS (2.839s)
[204.965863] [046/131] (817s left) kms_properties (colorop-properties-atomic)
[205.061983] Starting subtest: colorop-properties-atomic
[205.064118] Starting dynamic subtest: pipe-A-eDP-1
[205.406566] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.342s)
[205.415802] Starting dynamic subtest: pipe-B-eDP-1
[206.431173] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.025s)
[206.440420] Starting dynamic subtest: pipe-C-eDP-1
[207.465712] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.034s)
[207.475363] Starting dynamic subtest: pipe-D-eDP-1
[208.496835] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.030s)
[208.499270] Subtest colorop-properties-atomic: SUCCESS (3.437s)
[209.306339] [047/131] (813s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[209.409259] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[209.411475] Starting dynamic subtest: A-eDP1
[218.328309] Dynamic subtest A-eDP1: SUCCESS (8.917s)
[218.337132] Starting dynamic subtest: B-eDP1
[227.256561] Dynamic subtest B-eDP1: SUCCESS (8.927s)
[227.272295] Starting dynamic subtest: C-eDP1
[236.178645] Dynamic subtest C-eDP1: SUCCESS (8.919s)
[236.190977] Starting dynamic subtest: D-eDP1
[245.102765] Dynamic subtest D-eDP1: SUCCESS (8.921s)
[245.107386] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.697s)
[246.346858] [048/131] (776s left) kms_draw_crc (draw-method-render)
[246.451412] Starting subtest: draw-method-render
[246.453405] Starting dynamic subtest: xrgb8888-untiled
[246.682749] Dynamic subtest xrgb8888-untiled: SUCCESS (0.233s)
[246.691074] Starting dynamic subtest: rgb565-untiled
[246.916194] Dynamic subtest rgb565-untiled: SUCCESS (0.233s)
[246.926228] Starting dynamic subtest: xrgb2101010-untiled
[247.138323] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s)
[247.147200] Starting dynamic subtest: xbgr16161616f-untiled
[247.371475] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.231s)
[247.379562] Starting dynamic subtest: xrgb8888-xtiled
[247.504706] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.132s)
[247.513461] Starting dynamic subtest: rgb565-xtiled
[247.626866] Dynamic subtest rgb565-xtiled: SUCCESS (0.121s)
[247.637150] Starting dynamic subtest: xrgb2101010-xtiled
[247.749599] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.120s)
[247.758237] Starting dynamic subtest: xbgr16161616f-xtiled
[247.882387] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.132s)
[247.890572] Starting dynamic subtest: xrgb8888-4tiled
[248.004582] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.121s)
[248.013079] Starting dynamic subtest: rgb565-4tiled
[248.126839] Dynamic subtest rgb565-4tiled: SUCCESS (0.121s)
[248.135328] Starting dynamic subtest: xrgb2101010-4tiled
[248.248880] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.121s)
[248.257542] Starting dynamic subtest: xbgr16161616f-4tiled
[248.382483] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.133s)
[248.384274] Subtest draw-method-render: SUCCESS (1.935s)
[248.510598] [049/131] (774s left) kms_content_protection (atomic-dpms)
[248.656904] Starting subtest: atomic-dpms
[248.660727] Subtest atomic-dpms: SKIP (0.000s)
[248.766983] [050/131] (774s left) gem_exec_balancer (bonded-sync)
[248.821309] Starting subtest: bonded-sync
[248.824925] Subtest bonded-sync: SKIP (0.000s)
[249.117749] [051/131] (773s left) gem_partial_pwrite_pread (reads)
[249.170078] Subtest reads: SKIP (0.000s)
[249.238072] [052/131] (773s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[249.338497] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs
[249.342924] Starting dynamic subtest: pipe-A-eDP-1
[249.365124] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[249.374963] Starting dynamic subtest: pipe-B-eDP-1
[249.395639] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[249.403755] Starting dynamic subtest: pipe-C-eDP-1
[249.426382] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[249.435497] Starting dynamic subtest: pipe-D-eDP-1
[249.456614] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[249.460537] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[251.586553] [053/131] (771s left) gem_lmem_swapping (verify-random-ccs)
[251.638143] Subtest verify-random-ccs: SKIP (0.000s)
[251.684973] [054/131] (771s left) gem_render_copy (x-tiled)
[251.743703] Starting subtest: x-tiled
[251.745569] Starting dynamic subtest: smem
[251.784700] Dynamic subtest smem: SUCCESS (0.043s)
[251.787179] Subtest x-tiled: SUCCESS (0.044s)
[251.979583] [055/131] (771s left) kms_rotation_crc (sprite-rotation-270)
[252.077072] Starting subtest: sprite-rotation-270
[252.081406] Subtest sprite-rotation-270: SKIP (0.001s)
[252.162227] [056/131] (770s left) core_setmaster (master-drop-set-root)
[252.230162] Starting subtest: master-drop-set-root
[252.243591] Subtest master-drop-set-root: SUCCESS (0.013s)
[252.291487] [057/131] (770s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[252.391437] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[252.395612] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[252.485280] [058/131] (770s left) syncobj_eventfd (invalid-illegal-eventfd)
[252.543986] Starting subtest: invalid-illegal-eventfd
[252.546229] Subtest invalid-illegal-eventfd: SUCCESS (0.000s)
[252.625418] [059/131] (770s left) kms_psr (psr-cursor-plane-move)
[252.711919] Starting subtest: psr-cursor-plane-move
[252.714126] Starting dynamic subtest: eDP-1
[254.400395] Dynamic subtest eDP-1: SUCCESS (1.688s)
[254.402576] Subtest psr-cursor-plane-move: SUCCESS (1.689s)
[255.267430] [060/131] (767s left) gem_exec_endless (dispatch)
[255.348210] Starting subtest: dispatch
[255.350693] Starting dynamic subtest: rcs0
[255.358140] Dynamic subtest rcs0: SUCCESS (0.006s)
[255.368309] Starting dynamic subtest: bcs0
[255.372331] Dynamic subtest bcs0: SUCCESS (0.004s)
[255.380443] Starting dynamic subtest: vcs0
[255.384940] Dynamic subtest vcs0: SUCCESS (0.005s)
[255.394175] Starting dynamic subtest: vcs1
[255.398407] Dynamic subtest vcs1: SUCCESS (0.007s)
[255.406161] Starting dynamic subtest: vecs0
[255.410391] Dynamic subtest vecs0: SUCCESS (0.009s)
[255.417994] Starting dynamic subtest: ccs0
[255.422219] Dynamic subtest ccs0: SUCCESS (0.004s)
[255.424374] Subtest dispatch: SUCCESS (0.042s)
[256.954966] [061/131] (766s left) kms_psr (fbc-psr-sprite-plane-onoff)
[257.049354] Starting subtest: fbc-psr-sprite-plane-onoff
[257.051568] Starting dynamic subtest: eDP-1
[257.055621] Dynamic subtest eDP-1: SKIP (0.000s)
[257.059686] Subtest fbc-psr-sprite-plane-onoff: SKIP (0.001s)
[257.123542] [062/131] (766s left) api_intel_allocator (default-alignment)
[257.188534] Starting subtest: default-alignment
[257.190836] Subtest default-alignment: SUCCESS (0.003s)
[257.303193] [063/131] (766s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-downscaling)
[257.393213] Starting subtest: flip-64bpp-linear-to-32bpp-linear-downscaling
[257.395511] Starting dynamic subtest: pipe-A-default-mode
[258.529793] Dynamic subtest pipe-A-default-mode: SKIP (1.135s)
[258.534589] Subtest flip-64bpp-linear-to-32bpp-linear-downscaling: SKIP (1.137s)
[258.676574] [064/131] (764s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[258.777181] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[258.781109] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[258.867207] [065/131] (764s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[258.959646] Starting subtest: fbc-rgb101010-draw-mmap-wc
[263.577196] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.620s)
[264.692755] [066/131] (758s left) gem_userptr_blits (unsync-unmap)
[264.759048] Subtest unsync-unmap: SKIP (0.000s)
[264.889862] [067/131] (758s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[264.990727] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[272.312629] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.324s)
[272.441540] [068/131] (751s left) kms_dp_link_training (uhbr-mst)
[272.539615] Starting subtest: uhbr-mst
[272.548342] Subtest uhbr-mst: SKIP (0.000s)
[272.609717] [069/131] (751s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[272.720550] Starting subtest: pr-overlay-plane-move-continuous-sf
[272.724831] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[272.794854] [070/131] (750s left) dumb_buffer (map-valid)
[272.846371] Starting subtest: map-valid
[272.848321] Subtest map-valid: SUCCESS (0.000s)
[272.936546] [071/131] (750s left) gem_exec_whisper (basic-fds-priority-all)
[273.000645] Starting subtest: basic-fds-priority-all
[294.839362] Subtest basic-fds-priority-all: SUCCESS (21.836s)
[295.034633] [072/131] (728s left) gem_exec_schedule (fairslice)
[295.105484] Starting subtest: fairslice
[295.107779] Starting dynamic subtest: rcs0
[297.126270] Dynamic subtest rcs0: SUCCESS (2.024s)
[297.137817] Starting dynamic subtest: bcs0
[299.153364] Dynamic subtest bcs0: SUCCESS (2.025s)
[299.163598] Starting dynamic subtest: vcs0
[301.174911] Dynamic subtest vcs0: SUCCESS (2.023s)
[301.183818] Starting dynamic subtest: vcs1
[303.200152] Dynamic subtest vcs1: SUCCESS (2.020s)
[303.210921] Starting dynamic subtest: vecs0
[305.219181] Dynamic subtest vecs0: SUCCESS (2.017s)
[305.230924] Starting dynamic subtest: ccs0
[307.240366] Dynamic subtest ccs0: SUCCESS (2.022s)
[307.242349] Subtest fairslice: SUCCESS (12.139s)
[307.537816] [073/131] (716s left) syncobj_timeline (single-wait-signaled)
[307.597086] Starting subtest: single-wait-signaled
[307.599422] Subtest single-wait-signaled: SUCCESS (0.000s)
[307.704775] [074/131] (716s left) gem_wait (write-wait)
[307.774555] Starting subtest: write-wait
[307.776874] Starting dynamic subtest: all-engines
[308.913660] Dynamic subtest all-engines: SUCCESS (1.139s)
[308.925254] Starting dynamic subtest: rcs0
[309.984253] Dynamic subtest rcs0: SUCCESS (1.068s)
[309.996486] Starting dynamic subtest: bcs0
[311.052278] Dynamic subtest bcs0: SUCCESS (1.066s)
[311.067925] Starting dynamic subtest: vcs0
[312.113308] Dynamic subtest vcs0: SUCCESS (1.059s)
[312.128874] Starting dynamic subtest: vcs1
[313.169210] Dynamic subtest vcs1: SUCCESS (1.054s)
[313.185851] Starting dynamic subtest: vecs0
[314.223103] Dynamic subtest vecs0: SUCCESS (1.052s)
[314.239825] Starting dynamic subtest: ccs0
[315.280747] Dynamic subtest ccs0: SUCCESS (1.055s)
[315.283411] Subtest write-wait: SUCCESS (7.507s)
[315.487801] [075/131] (708s left) kms_big_fb (linear-16bpp-rotate-90)
[315.585297] Starting subtest: linear-16bpp-rotate-90
[315.606221] Subtest linear-16bpp-rotate-90: SKIP (0.020s)
[315.730910] [076/131] (708s left) kms_big_fb (4-tiled-addfb)
[315.819599] Starting subtest: 4-tiled-addfb
[315.821703] Subtest 4-tiled-addfb: SUCCESS (0.000s)
[315.914450] [077/131] (708s left) gem_mmap_offset (perf)
[315.965293] Starting subtest: perf
[315.967114] Starting dynamic subtest: smem0
[316.299042] Dynamic subtest smem0: SUCCESS (0.333s)
[316.301538] Subtest perf: SUCCESS (0.333s)
[316.407088] [078/131] (707s left) api_intel_bb (intel-bb-blit-y)
[316.459332] Starting subtest: intel-bb-blit-y
[319.932262] Subtest intel-bb-blit-y: SUCCESS (3.473s)
[320.035668] [079/131] (704s left) gem_exec_params (cliprects_ptr-dirt)
[320.088678] Starting subtest: cliprects_ptr-dirt
[320.091049] Subtest cliprects_ptr-dirt: SUCCESS (0.000s)
[320.196934] [080/131] (703s left) sysfs_preempt_timeout (idempotent)
[320.253356] Starting subtest: idempotent
[320.255770] Starting dynamic subtest: vecs0
[320.258234] Dynamic subtest vecs0: SUCCESS (0.000s)
[320.268523] Starting dynamic subtest: ccs0
[320.270599] Dynamic subtest ccs0: SUCCESS (0.000s)
[320.279519] Starting dynamic subtest: vcs0
[320.281583] Dynamic subtest vcs0: SUCCESS (0.000s)
[320.290058] Starting dynamic subtest: bcs0
[320.291886] Dynamic subtest bcs0: SUCCESS (0.000s)
[320.300572] Starting dynamic subtest: rcs0
[320.302764] Dynamic subtest rcs0: SUCCESS (0.000s)
[320.311743] Starting dynamic subtest: vcs1
[320.313631] Dynamic subtest vcs1: SUCCESS (0.000s)
[320.315509] Subtest idempotent: SUCCESS (0.006s)
[320.357040] [081/131] (703s left) drm_read (short-buffer-block)
[320.511683] Starting subtest: short-buffer-block
[320.514128] Subtest short-buffer-block: SUCCESS (0.000s)
[320.622409] [082/131] (703s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[320.672030] Starting subtest: yf-tiled-ccs-to-yf-tiled
[320.676894] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[320.857225] [083/131] (703s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[320.949854] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[320.952160] Starting dynamic subtest: pipe-A
[321.333481] Dynamic subtest pipe-A: SUCCESS (0.388s)
[321.343673] Starting dynamic subtest: pipe-B
[322.809518] Dynamic subtest pipe-B: SUCCESS (1.474s)
[322.819147] Starting dynamic subtest: pipe-C
[324.210235] Dynamic subtest pipe-C: SUCCESS (1.400s)
[324.224635] Starting dynamic subtest: pipe-D
[325.693572] Dynamic subtest pipe-D: SUCCESS (1.481s)
[325.695904] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.748s)
[326.820027] [084/131] (697s left) kms_cursor_crc (cursor-alpha-opaque)
[326.920120] Starting subtest: cursor-alpha-opaque
[326.922080] Starting dynamic subtest: pipe-A-eDP-1
[327.573424] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.653s)
[327.582681] Starting dynamic subtest: pipe-D-eDP-1
[328.910719] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.337s)
[328.912974] Subtest cursor-alpha-opaque: SUCCESS (1.993s)
[329.772563] [085/131] (694s left) gem_ctx_param (basic)
[329.829841] Starting subtest: basic
[329.832264] Subtest basic: SUCCESS (0.001s)
[329.928593] [086/131] (694s left) gem_exec_schedule (semaphore-power)
[330.106188] Subtest semaphore-power: SKIP (0.000s)
[330.318996] [087/131] (694s left) gen9_exec_parse (batch-without-end)
[330.382972] Subtest batch-without-end: SKIP (0.000s)
[330.447445] [088/131] (694s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[330.545066] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[330.549250] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.000s)
[330.635502] [089/131] (693s left) kms_rotation_crc (multiplane-rotation)
[330.738713] Starting subtest: multiplane-rotation
[348.171058] Subtest multiplane-rotation: SUCCESS (17.438s)
[348.274456] [090/131] (676s left) gem_ringfill (legacy-basic)
[353.881582] Starting subtest: legacy-basic
[353.884393] Starting dynamic subtest: default
[353.937099] Dynamic subtest default: SUCCESS (0.055s)
[353.948497] Starting dynamic subtest: render
[353.978911] Dynamic subtest render: SUCCESS (0.040s)
[353.988482] Starting dynamic subtest: bsd
[354.021817] Dynamic subtest bsd: SUCCESS (0.041s)
[354.031847] Starting dynamic subtest: bsd1
[354.063501] Dynamic subtest bsd1: SUCCESS (0.039s)
[354.073071] Starting dynamic subtest: bsd2
[354.105225] Dynamic subtest bsd2: SUCCESS (0.039s)
[354.114675] Starting dynamic subtest: blt
[354.149074] Dynamic subtest blt: SUCCESS (0.041s)
[354.161669] Starting dynamic subtest: vebox
[354.193532] Dynamic subtest vebox: SUCCESS (0.041s)
[354.195957] Subtest legacy-basic: SUCCESS (0.314s)
[354.276581] [091/131] (670s left) i915_module_load (reload)
[354.323588] Starting subtest: reload
[357.523780] Subtest reload: SUCCESS (3.202s)
[357.564812] [092/131] (667s left) kms_invalid_mode (overflow-vrefresh)
[358.879459] Starting subtest: overflow-vrefresh
[358.881823] Starting dynamic subtest: pipe-A-eDP-1
[359.168601] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.288s)
[359.177237] Starting dynamic subtest: pipe-B-eDP-1
[359.179420] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[359.187143] Starting dynamic subtest: pipe-C-eDP-1
[359.189465] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[359.197228] Starting dynamic subtest: pipe-D-eDP-1
[359.199449] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[359.201699] Subtest overflow-vrefresh: SUCCESS (0.294s)
[359.987514] [093/131] (664s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render)
[360.092405] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render
[360.096544] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[360.188653] [094/131] (664s left) syncobj_timeline (etime-single-wait-for-submit-available-unsubmitted)
[360.235319] Starting subtest: etime-single-wait-for-submit-available-unsubmitted
[360.335193] Subtest etime-single-wait-for-submit-available-unsubmitted: SUCCESS (0.101s)
[360.425141] [095/131] (664s left) gem_lmem_swapping (heavy-verify-multi)
[360.479408] Subtest heavy-verify-multi: SKIP (0.000s)
[360.527580] [096/131] (664s left) gem_ctx_persistence (saturated-hostile-nopreempt)
[360.579792] Starting subtest: saturated-hostile-nopreempt
[360.581642] Starting dynamic subtest: rcs0
[360.657084] Dynamic subtest rcs0: SKIP (0.077s)
[360.668821] Starting dynamic subtest: bcs0
[360.675661] Dynamic subtest bcs0: SKIP (0.016s)
[360.682942] Starting dynamic subtest: vcs0
[360.690023] Dynamic subtest vcs0: SKIP (0.013s)
[360.697260] Starting dynamic subtest: vcs1
[360.702125] Dynamic subtest vcs1: SKIP (0.011s)
[360.709303] Starting dynamic subtest: vecs0
[360.714064] Dynamic subtest vecs0: SKIP (0.011s)
[360.721177] Starting dynamic subtest: ccs0
[360.725348] Dynamic subtest ccs0: SKIP (0.012s)
[360.729933] Subtest saturated-hostile-nopreempt: SKIP (0.147s)
[360.795419] [097/131] (664s left) syncobj_wait (invalid-single-wait-unsubmitted)
[360.849121] Starting subtest: invalid-single-wait-unsubmitted
[360.851393] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[360.962354] [098/131] (663s left) gem_eio (in-flight-internal-immediate)
[361.101192] Starting subtest: in-flight-internal-immediate
[362.954048] Subtest in-flight-internal-immediate: SUCCESS (1.850s)
[363.076883] [099/131] (661s left) perf (gen12-invalid-class-instance)
[363.201490] Starting subtest: gen12-invalid-class-instance
[363.215085] Subtest gen12-invalid-class-instance: SUCCESS (0.012s)
[363.258437] [100/131] (661s left) gem_basic (bad-close)
[363.314345] Starting subtest: bad-close
[363.318711] Subtest bad-close: SUCCESS (0.000s)
[363.431425] [101/131] (661s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[363.525321] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[363.529296] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[363.627197] [102/131] (661s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[363.855907] Starting subtest: cursor-rapid-movement-128x42
[363.907080] Subtest cursor-rapid-movement-128x42: SKIP (0.046s)
[364.141623] [103/131] (660s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-render)
[364.244144] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-render
[371.245678] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-render: SUCCESS (7.002s)
[371.397147] [104/131] (653s left) gem_ctx_param (invalid-ctx-get)
[371.445097] Starting subtest: invalid-ctx-get
[371.447636] Subtest invalid-ctx-get: SUCCESS (0.000s)
[371.522673] [105/131] (653s left) gem_caching (read-writes)
[371.591360] Subtest read-writes: SKIP (0.000s)
[371.684569] [106/131] (653s left) kms_cursor_edge_walk (64x64-right-edge)
[371.774405] Starting subtest: 64x64-right-edge
[371.776640] Starting dynamic subtest: pipe-A-eDP-1
[375.290765] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.516s)
[375.299774] Starting dynamic subtest: pipe-D-eDP-1
[378.407360] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.114s)
[378.409614] Subtest 64x64-right-edge: SUCCESS (6.634s)
[379.210862] [107/131] (646s left) kms_sequence (queue-busy)
[379.316189] Starting subtest: queue-busy
[379.318451] Starting dynamic subtest: pipe-A-eDP-1
[381.258909] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.942s)
[381.268203] Starting dynamic subtest: pipe-B-eDP-1
[383.897587] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.639s)
[383.907897] Starting dynamic subtest: pipe-C-eDP-1
[386.507585] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.607s)
[386.517737] Starting dynamic subtest: pipe-D-eDP-1
[389.052034] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.542s)
[389.054414] Subtest queue-busy: SUCCESS (9.735s)
[389.849633] [108/131] (635s left) sw_sync (sync_merge_same)
[389.892193] Starting subtest: sync_merge_same
[389.894473] Subtest sync_merge_same: SUCCESS (0.000s)
[389.947873] [109/131] (635s left) drm_read (empty-nonblock)
[390.104620] Starting subtest: empty-nonblock
[390.106775] Subtest empty-nonblock: SUCCESS (0.000s)
[390.239071] [110/131] (635s left) kms_flip (bo-too-big)
[390.341452] Starting subtest: bo-too-big
[390.343740] Starting dynamic subtest: A-eDP1
[391.615583] Dynamic subtest A-eDP1: SUCCESS (1.273s)
[391.627694] Starting dynamic subtest: B-eDP1
[392.936439] Dynamic subtest B-eDP1: SUCCESS (1.319s)
[392.948248] Starting dynamic subtest: C-eDP1
[394.286743] Dynamic subtest C-eDP1: SUCCESS (1.347s)
[394.297733] Starting dynamic subtest: D-eDP1
[395.618505] Dynamic subtest D-eDP1: SUCCESS (1.331s)
[395.620826] Subtest bo-too-big: SUCCESS (5.281s)
[396.828581] [111/131] (628s left) kms_flip (dpms-vs-vblank-race-interruptible)
[396.922365] Starting subtest: dpms-vs-vblank-race-interruptible
[396.924717] Starting dynamic subtest: A-eDP1
[401.914206] Dynamic subtest A-eDP1: SUCCESS (4.989s)
[401.922808] Starting dynamic subtest: B-eDP1
[406.562024] Dynamic subtest B-eDP1: SUCCESS (4.645s)
[406.579617] Starting dynamic subtest: C-eDP1
[411.164861] Dynamic subtest C-eDP1: SUCCESS (4.600s)
[411.177070] Starting dynamic subtest: D-eDP1
[415.794425] Dynamic subtest D-eDP1: SUCCESS (4.627s)
[415.796929] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (18.874s)
[416.668544] [112/131] (608s left) gem_exec_async (forked-writes)
[416.736926] Starting subtest: forked-writes
[416.739388] Starting dynamic subtest: rcs0
[416.766204] Dynamic subtest rcs0: SUCCESS (0.029s)
[416.777251] Starting dynamic subtest: bcs0
[416.791224] Dynamic subtest bcs0: SUCCESS (0.024s)
[416.800489] Starting dynamic subtest: vcs0
[416.814169] Dynamic subtest vcs0: SUCCESS (0.022s)
[416.824308] Starting dynamic subtest: vcs1
[416.839227] Dynamic subtest vcs1: SUCCESS (0.024s)
[416.848021] Starting dynamic subtest: vecs0
[416.862954] Dynamic subtest vecs0: SUCCESS (0.023s)
[416.873171] Starting dynamic subtest: ccs0
[416.887154] Dynamic subtest ccs0: SUCCESS (0.023s)
[416.889492] Subtest forked-writes: SUCCESS (0.151s)
[417.113236] [113/131] (608s left) kms_atomic (atomic-invalid-params)
[417.206429] Starting subtest: atomic-invalid-params
[417.208717] Starting dynamic subtest: pipe-A-eDP-1
[417.604138] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.399s)
[417.606400] Subtest atomic-invalid-params: SUCCESS (0.400s)
[418.399805] [114/131] (607s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[418.492958] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[418.495106] Starting dynamic subtest: pipe-A-default-mode
[419.659858] Dynamic subtest pipe-A-default-mode: SKIP (1.165s)
[419.664441] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.166s)
[419.815391] [115/131] (605s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[419.912751] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[419.916887] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[419.996103] [116/131] (605s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[420.098512] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[427.180245] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (7.084s)
[427.288559] [117/131] (598s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[427.378263] Starting subtest: plane-upscale-factor-0-25-with-rotation
[427.380578] Starting dynamic subtest: pipe-A
[427.603216] Dynamic subtest pipe-A: SUCCESS (0.227s)
[427.612083] Starting dynamic subtest: pipe-B
[428.872517] Dynamic subtest pipe-B: SUCCESS (1.268s)
[428.883940] Starting dynamic subtest: pipe-C
[430.202408] Dynamic subtest pipe-C: SUCCESS (1.329s)
[430.211316] Starting dynamic subtest: pipe-D
[431.541868] Dynamic subtest pipe-D: SUCCESS (1.338s)
[431.544188] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.167s)
[432.733632] [118/131] (592s left) gem_tiled_partial_pwrite_pread (writes-after-reads)
[432.795873] Subtest writes-after-reads: SKIP (0.000s)
[432.859853] [119/131] (592s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[432.951180] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[432.955609] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[433.061442] [120/131] (592s left) kms_plane_alpha_blend (alpha-basic)
[433.149420] Starting subtest: alpha-basic
[433.443385] Starting dynamic subtest: pipe-A-eDP-1
[435.399496] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.954s)
[435.426135] Starting dynamic subtest: pipe-D-eDP-1
[438.085249] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.663s)
[438.087587] Subtest alpha-basic: SUCCESS (4.936s)
[438.898419] [121/131] (586s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[439.021719] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[440.477446] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.456s)
[441.352264] [122/131] (584s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier-source-clamping)
[441.450150] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier-source-clamping
[441.454644] Subtest pixel-format-4-tiled-bmg-ccs-modifier-source-clamping: SKIP (0.000s)
[441.540502] [123/131] (584s left) i915_selftest (live)
[444.880807] Starting subtest: live
[444.883348] Starting dynamic subtest: sanitycheck
[449.184265] Dynamic subtest sanitycheck: SUCCESS (4.303s)
[449.193943] Starting dynamic subtest: uncore
[453.533989] Dynamic subtest uncore: SUCCESS (4.347s)
[453.543429] Starting dynamic subtest: workarounds
[456.625407] Dynamic subtest workarounds: SUCCESS (3.090s)
[456.634979] Starting dynamic subtest: gt_engines
[461.092492] Dynamic subtest gt_engines: SUCCESS (4.465s)
[461.101622] Starting dynamic subtest: gt_timelines
[476.659520] Dynamic subtest gt_timelines: SUCCESS (15.565s)
[476.670826] Starting dynamic subtest: gt_contexts
[480.999222] Dynamic subtest gt_contexts: SUCCESS (4.338s)
[481.008363] Starting dynamic subtest: gt_lrc
[485.347031] Dynamic subtest gt_lrc: SUCCESS (4.346s)
[485.356551] Starting dynamic subtest: gt_mocs
[489.741759] Dynamic subtest gt_mocs: SUCCESS (4.392s)
[489.751675] Starting dynamic subtest: gt_pm
[496.459317] Dynamic subtest gt_pm: SUCCESS (6.716s)
[496.468783] Starting dynamic subtest: gt_heartbeat
[499.117065] Dynamic subtest gt_heartbeat: SUCCESS (2.657s)
[499.127089] Starting dynamic subtest: gt_tlb
[508.391868] Dynamic subtest gt_tlb: SUCCESS (9.272s)
[508.401699] Starting dynamic subtest: requests
[521.905390] Dynamic subtest requests: SUCCESS (13.511s)
[521.914961] Starting dynamic subtest: migrate
[527.648065] Dynamic subtest migrate: SUCCESS (5.740s)
[527.657428] Starting dynamic subtest: active
[531.957260] Dynamic subtest active: SUCCESS (4.307s)
[531.966706] Starting dynamic subtest: objects
[536.781401] Dynamic subtest objects: SUCCESS (4.823s)
[536.790968] Starting dynamic subtest: mman
[541.584524] Dynamic subtest mman: SUCCESS (4.800s)
[541.594099] Starting dynamic subtest: dmabuf
[545.945285] Dynamic subtest dmabuf: SUCCESS (4.359s)
[545.955714] Starting dynamic subtest: vma
[550.337916] Dynamic subtest vma: SUCCESS (4.389s)
[550.347906] Starting dynamic subtest: coherency
[555.708522] Dynamic subtest coherency: SUCCESS (5.368s)
[555.721503] Starting dynamic subtest: gtt
[567.716656] Dynamic subtest gtt: SUCCESS (12.005s)
[567.726317] Starting dynamic subtest: gem
[575.583428] Dynamic subtest gem: SUCCESS (7.865s)
[575.592776] Starting dynamic subtest: evict
[581.061945] Dynamic subtest evict: SUCCESS (5.477s)
[581.071422] Starting dynamic subtest: hugepages
[589.885347] Dynamic subtest hugepages: SUCCESS (8.821s)
[589.900102] Starting dynamic subtest: gem_contexts
[618.967819] Dynamic subtest gem_contexts: SUCCESS (29.078s)
[618.982585] Starting dynamic subtest: client
[621.641745] Dynamic subtest client: SUCCESS (2.673s)
[621.651672] Starting dynamic subtest: gem_migrate
[625.983624] Dynamic subtest gem_migrate: SUCCESS (4.340s)
[625.993303] Starting dynamic subtest: reset
[630.350546] Dynamic subtest reset: SUCCESS (4.365s)
[630.359959] Starting dynamic subtest: memory_region
[634.666489] Dynamic subtest memory_region: SUCCESS (4.313s)
[634.675496] Starting dynamic subtest: hangcheck
[649.534061] Dynamic subtest hangcheck: SUCCESS (14.865s)
[649.544077] Starting dynamic subtest: execlists
[654.231977] Dynamic subtest execlists: SUCCESS (4.696s)
[654.241511] Starting dynamic subtest: ring_submission
[658.573340] Dynamic subtest ring_submission: SUCCESS (4.338s)
[658.581541] Starting dynamic subtest: perf
[661.305185] Dynamic subtest perf: SUCCESS (2.730s)
[661.316095] Starting dynamic subtest: slpc
[673.308062] Dynamic subtest slpc: SUCCESS (11.999s)
[673.318059] Starting dynamic subtest: guc
[677.239497] Dynamic subtest guc: SUCCESS (3.931s)
[677.248071] Starting dynamic subtest: guc_multi_lrc
[681.603680] Dynamic subtest guc_multi_lrc: SUCCESS (4.362s)
[681.612739] Starting dynamic subtest: guc_hang
[686.514381] Dynamic subtest guc_hang: SUCCESS (4.909s)
[686.524479] Starting dynamic subtest: late_gt_pm
[689.273062] Dynamic subtest late_gt_pm: SUCCESS (2.757s)
[689.275939] Subtest live: SUCCESS (244.381s)
[689.301406] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[689.302128] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[689.305354] [124/131] (336s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[690.813151] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[690.879688] [FACT kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[690.882895] [FACT kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)] new: kernel.kmod_is_loaded.i915: true
[690.887597] [125/131] (335s left) kms_ccs (bad-pixel-format-4-tiled-dg2-mc-ccs)
[690.998399] Starting subtest: bad-pixel-format-4-tiled-dg2-mc-ccs
[691.000759] Starting dynamic subtest: pipe-A-eDP-1
[691.024092] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[691.034832] Starting dynamic subtest: pipe-B-eDP-1
[691.056799] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[691.064769] Starting dynamic subtest: pipe-C-eDP-1
[691.086430] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[691.096083] Starting dynamic subtest: pipe-D-eDP-1
[691.117930] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[691.122031] Subtest bad-pixel-format-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[693.252714] [126/131] (332s left) kms_addfb_basic (master-rmfb)
[693.312061] Starting subtest: master-rmfb
[693.314271] Subtest master-rmfb: SUCCESS (0.001s)
[693.583807] [127/131] (332s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[693.695266] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[693.699683] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[693.959471] [128/131] (332s left) gem_softpin (allocator-evict)
[694.095281] Starting subtest: allocator-evict
[694.097323] Starting dynamic subtest: rcs0
[718.053626] Dynamic subtest rcs0: SUCCESS (23.960s)
[718.062561] Starting dynamic subtest: bcs0
[741.711774] Dynamic subtest bcs0: SUCCESS (23.655s)
[741.720564] Starting dynamic subtest: vcs0
[765.287400] Dynamic subtest vcs0: SUCCESS (23.573s)
[765.297753] Starting dynamic subtest: vcs1
[788.923500] Dynamic subtest vcs1: SUCCESS (23.634s)
[788.932479] Starting dynamic subtest: vecs0
[812.591087] Dynamic subtest vecs0: SUCCESS (23.665s)
[812.601259] Starting dynamic subtest: ccs0
[836.108790] Dynamic subtest ccs0: SUCCESS (23.516s)
[836.111077] Subtest allocator-evict: SUCCESS (142.012s)
[836.205862] [129/131] (189s left) gem_ctx_exec (basic-invalid-context)
[836.294576] Starting subtest: basic-invalid-context
[836.300465] Subtest basic-invalid-context: SUCCESS (0.009s)
[836.429536] [130/131] (189s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[836.546190] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[836.550239] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[836.667451] [131/131] (189s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[836.728822] Starting subtest: invalid-single-wait-all-unsubmitted
[836.731091] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[836.802801] Closing watchdogs
results: parsing output: 0/ for test: gem_exec_fence
results: parsing output: 1/ for test: kms_color
results: parsing output: 2/ for test: kms_legacy_colorkey
results: parsing output: 3/ for test: kms_chamelium_color
results: parsing output: 4/ for test: prime_vgem
results: parsing output: 5/ for test: perf
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_big_fb
results: parsing output: 8/ for test: kms_pm_rpm
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: gen9_exec_parse
results: parsing output: 11/ for test: kms_flip
results: parsing output: 12/ for test: i915_query
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_psr2_sf
results: parsing output: 15/ for test: kms_ccs
results: parsing output: 16/ for test: gem_exec_fence
results: parsing output: 17/ for test: gem_render_copy_redux
results: parsing output: 18/ for test: perf_pmu
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: kms_ccs
results: parsing output: 21/ for test: gem_mmap_wc
results: parsing output: 22/ for test: gem_ppgtt
results: parsing output: 23/ for test: kms_ccs
results: parsing output: 24/ for test: gem_exec_params
results: parsing output: 25/ for test: i915_pm_rpm
results: parsing output: 26/ for test: syncobj_timeline
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_psr
results: parsing output: 29/ for test: sw_sync
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: kms_big_fb
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_vrr
results: parsing output: 34/ for test: kms_chamelium_hpd
results: parsing output: 35/ for test: gem_ctx_persistence
results: parsing output: 36/ for test: kms_addfb_basic
results: parsing output: 37/ for test: gem_exec_schedule
results: parsing output: 38/ for test: kms_psr
results: parsing output: 39/ for test: gem_exec_parallel
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: syncobj_wait
results: parsing output: 42/ for test: kms_atomic_transition
results: parsing output: 43/ for test: kms_chamelium_edid
results: parsing output: 44/ for test: kms_plane
results: parsing output: 45/ for test: kms_properties
results: parsing output: 46/ for test: kms_flip
results: parsing output: 47/ for test: kms_draw_crc
results: parsing output: 48/ for test: kms_content_protection
results: parsing output: 49/ for test: gem_exec_balancer
results: parsing output: 50/ for test: gem_partial_pwrite_pread
results: parsing output: 51/ for test: kms_ccs
results: parsing output: 52/ for test: gem_lmem_swapping
results: parsing output: 53/ for test: gem_render_copy
results: parsing output: 54/ for test: kms_rotation_crc
results: parsing output: 55/ for test: core_setmaster
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: syncobj_eventfd
results: parsing output: 58/ for test: kms_psr
results: parsing output: 59/ for test: gem_exec_endless
results: parsing output: 60/ for test: kms_psr
results: parsing output: 61/ for test: api_intel_allocator
results: parsing output: 62/ for test: kms_flip_scaled_crc
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: gem_userptr_blits
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_dp_link_training
results: parsing output: 68/ for test: kms_psr2_sf
results: parsing output: 69/ for test: dumb_buffer
results: parsing output: 70/ for test: gem_exec_whisper
results: parsing output: 71/ for test: gem_exec_schedule
results: parsing output: 72/ for test: syncobj_timeline
results: parsing output: 73/ for test: gem_wait
results: parsing output: 74/ for test: kms_big_fb
results: parsing output: 75/ for test: kms_big_fb
results: parsing output: 76/ for test: gem_mmap_offset
results: parsing output: 77/ for test: api_intel_bb
results: parsing output: 78/ for test: gem_exec_params
results: parsing output: 79/ for test: sysfs_preempt_timeout
results: parsing output: 80/ for test: drm_read
results: parsing output: 81/ for test: gem_render_copy
results: parsing output: 82/ for test: kms_plane_scaling
results: parsing output: 83/ for test: kms_cursor_crc
results: parsing output: 84/ for test: gem_ctx_param
results: parsing output: 85/ for test: gem_exec_schedule
results: parsing output: 86/ for test: gen9_exec_parse
results: parsing output: 87/ for test: kms_flip_scaled_crc
results: parsing output: 88/ for test: kms_rotation_crc
results: parsing output: 89/ for test: gem_ringfill
results: parsing output: 90/ for test: i915_module_load
results: parsing output: 91/ for test: kms_invalid_mode
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: syncobj_timeline
results: parsing output: 94/ for test: gem_lmem_swapping
results: parsing output: 95/ for test: gem_ctx_persistence
results: parsing output: 96/ for test: syncobj_wait
results: parsing output: 97/ for test: gem_eio
results: parsing output: 98/ for test: perf
results: parsing output: 99/ for test: gem_basic
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_cursor_crc
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: gem_ctx_param
results: parsing output: 104/ for test: gem_caching
results: parsing output: 105/ for test: kms_cursor_edge_walk
results: parsing output: 106/ for test: kms_sequence
results: parsing output: 107/ for test: sw_sync
results: parsing output: 108/ for test: drm_read
results: parsing output: 109/ for test: kms_flip
results: parsing output: 110/ for test: kms_flip
results: parsing output: 111/ for test: gem_exec_async
results: parsing output: 112/ for test: kms_atomic
results: parsing output: 113/ for test: kms_flip_scaled_crc
results: parsing output: 114/ for test: kms_frontbuffer_tracking
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_plane_scaling
results: parsing output: 117/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_plane_alpha_blend
results: parsing output: 120/ for test: kms_cursor_legacy
results: parsing output: 121/ for test: kms_plane
results: parsing output: 122/ for test: i915_selftest
results: parsing output: 123/ for test: kms_pipe_b_c_ivb
results: parsing output: 124/ for test: kms_ccs
results: parsing output: 125/ for test: kms_addfb_basic
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: gem_softpin
results: parsing output: 128/ for test: gem_ctx_exec
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: syncobj_timeline
Done.