[57.093514] Initializing watchdogs
[57.093564]   /dev/watchdog0
[57.107657] [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.112012] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.114274] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.117336] [001/132] (960s left) syncobj_timeline (multi-wait-submitted-signaled)
[57.191857] Starting subtest: multi-wait-submitted-signaled
[57.194258] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[57.324151] [002/132] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[57.427391] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[57.431265] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[57.550461] [003/132] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-blt)
[57.651217] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-blt
[57.655069] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[57.775883] [004/132] (959s left) kms_addfb_basic (too-high)
[57.868621] Starting subtest: too-high
[57.870827] Subtest too-high: SUCCESS (0.001s)
[57.988967] [005/132] (959s left) kms_universal_plane (cursor-fb-leak)
[58.077739] Starting subtest: cursor-fb-leak
[58.079894] Starting dynamic subtest: pipe-A-eDP-1
[58.403564] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.325s)
[58.415302] Starting dynamic subtest: pipe-B-eDP-1
[59.710897] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.309s)
[59.719668] Starting dynamic subtest: pipe-C-eDP-1
[61.018693] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.306s)
[61.026533] Starting dynamic subtest: pipe-D-eDP-1
[62.339938] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.324s)
[62.342298] Subtest cursor-fb-leak: SUCCESS (4.269s)
[63.535440] [006/132] (954s left) kms_pm_dc (dc3co-vpb-simulation)
[64.649577] Starting subtest: dc3co-vpb-simulation
[73.728021] Subtest dc3co-vpb-simulation: SKIP (9.081s)
[73.891245] [007/132] (943s left) syncobj_wait (wait-all-complex)
[73.956858] Starting subtest: wait-all-complex
[74.172862] Subtest wait-all-complex: SUCCESS (0.214s)
[74.268223] [008/132] (943s left) kms_pm_rpm (pc8-residency)
[76.121756] Starting subtest: pc8-residency
[76.126786] Subtest pc8-residency: SKIP (0.000s)
[76.569835] [009/132] (941s left) gem_ctx_persistence (engines-mixed-process)
[76.640255] Starting subtest: engines-mixed-process
[76.642652] Starting dynamic subtest: rcs0
[77.876100] Dynamic subtest rcs0: SUCCESS (1.236s)
[77.885692] Starting dynamic subtest: bcs0
[79.926711] Dynamic subtest bcs0: SUCCESS (2.050s)
[79.934138] Starting dynamic subtest: vcs0
[81.970070] Dynamic subtest vcs0: SUCCESS (2.042s)
[81.978819] Starting dynamic subtest: vcs1
[83.954810] Dynamic subtest vcs1: SUCCESS (1.984s)
[83.964107] Starting dynamic subtest: vecs0
[85.891278] Dynamic subtest vecs0: SUCCESS (1.933s)
[85.898289] Starting dynamic subtest: ccs0
[87.859198] Dynamic subtest ccs0: SUCCESS (1.969s)
[87.862022] Subtest engines-mixed-process: SUCCESS (11.219s)
[87.957993] [010/132] (929s left) kms_hdr (invalid-hdr)
[88.068435] Starting subtest: invalid-hdr
[90.139870] Starting dynamic subtest: pipe-A-eDP-1
[92.686465] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.547s)
[92.688805] Subtest invalid-hdr: SUCCESS (4.621s)
[92.823139] [011/132] (925s left) kms_3d (basic)
[92.884880] Starting subtest: basic
[94.833160] Subtest basic: SUCCESS (1.950s)
[95.337203] [012/132] (922s left) gem_mmap_gtt (hang-busy)
[95.389808] Subtest hang-busy: SKIP (0.000s)
[95.459242] [013/132] (922s left) gem_pread (self)
[95.508048] Subtest self: SKIP (0.000s)
[95.570358] [014/132] (922s left) gem_exec_reloc (basic-write-read)
[95.623107] Subtest basic-write-read: SKIP (0.000s)
[95.707345] [015/132] (922s left) kms_plane_multiple (2x-tiling-yf)
[95.804518] Starting subtest: 2x-tiling-yf
[95.808962] Subtest 2x-tiling-yf: SKIP (0.000s)
[95.900441] [016/132] (922s left) gem_ringfill (legacy-basic)
[101.912733] Starting subtest: legacy-basic
[101.915584] Starting dynamic subtest: default
[101.968721] Dynamic subtest default: SUCCESS (0.057s)
[101.978436] Starting dynamic subtest: render
[102.011798] Dynamic subtest render: SUCCESS (0.042s)
[102.021542] Starting dynamic subtest: bsd
[102.054202] Dynamic subtest bsd: SUCCESS (0.041s)
[102.063606] Starting dynamic subtest: bsd1
[102.095880] Dynamic subtest bsd1: SUCCESS (0.040s)
[102.105130] Starting dynamic subtest: bsd2
[102.136133] Dynamic subtest bsd2: SUCCESS (0.039s)
[102.144042] Starting dynamic subtest: blt
[102.181156] Dynamic subtest blt: SUCCESS (0.044s)
[102.190782] Starting dynamic subtest: vebox
[102.221955] Dynamic subtest vebox: SUCCESS (0.040s)
[102.224380] Subtest legacy-basic: SUCCESS (0.312s)
[102.318645] [FACT gem_ringfill (legacy-basic)] new: kernel.kmod_is_loaded.vgem: true
[102.321996] [017/132] (915s left) perf (gen12-unprivileged-single-ctx-counters)
[102.460297] Starting subtest: gen12-unprivileged-single-ctx-counters
[102.462060] Starting dynamic subtest: rcs0
[102.545294] Dynamic subtest rcs0: SUCCESS (0.087s)
[102.547630] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.087s)
[102.595032] [018/132] (915s left) kms_lease (lease-unleased-crtc)
[102.735383] Starting subtest: lease-unleased-crtc
[102.737867] Starting dynamic subtest: pipe-A-eDP-1
[103.041667] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.306s)
[103.050853] Starting dynamic subtest: pipe-B-eDP-1
[103.812628] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.768s)
[103.821781] Starting dynamic subtest: pipe-C-eDP-1
[103.824039] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[103.831494] Starting dynamic subtest: pipe-D-eDP-1
[103.833387] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.005s)
[103.835281] Subtest lease-unleased-crtc: SUCCESS (1.088s)
[104.204255] [019/132] (914s left) kms_dsc (dsc-with-output-formats)
[104.301683] Starting subtest: dsc-with-output-formats
[104.324296] Subtest dsc-with-output-formats: SKIP (0.000s)
[104.404729] [020/132] (913s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs)
[104.498254] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs
[104.500404] Starting dynamic subtest: pipe-A-eDP-1
[104.522375] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[104.532600] Starting dynamic subtest: pipe-B-eDP-1
[104.554867] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[104.563241] Starting dynamic subtest: pipe-C-eDP-1
[104.584222] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[104.591609] Starting dynamic subtest: pipe-D-eDP-1
[104.613504] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[104.617687] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs: SKIP (0.003s)
[106.718508] [021/132] (911s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[107.129828] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[107.975600] [022/132] (910s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[108.023802] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[108.025770] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[108.157481] [023/132] (910s left) gem_softpin (reverse)
[108.208769] Starting subtest: reverse
[108.214693] Subtest reverse: SUCCESS (0.006s)
[108.377237] [024/132] (910s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[108.460060] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[108.462403] Starting dynamic subtest: pipe-A-eDP-1
[108.487782] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[108.496684] Starting dynamic subtest: pipe-B-eDP-1
[108.520249] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[108.527893] Starting dynamic subtest: pipe-C-eDP-1
[108.552927] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[108.562565] Starting dynamic subtest: pipe-D-eDP-1
[108.586793] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[108.591203] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.003s)
[110.718955] [025/132] (907s left) kms_atomic_transition (modeset-transition)
[110.820588] Starting subtest: modeset-transition
[110.822758] Starting dynamic subtest: 1x-outputs
[121.881713] Dynamic subtest 1x-outputs: SUCCESS (11.062s)
[121.884201] Subtest modeset-transition: SUCCESS (11.063s)
[122.717372] [026/132] (895s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[122.807569] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[122.809727] Starting dynamic subtest: pipe-A-eDP-1
[122.831904] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[122.840745] Starting dynamic subtest: pipe-B-eDP-1
[122.861162] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[122.868738] Starting dynamic subtest: pipe-C-eDP-1
[122.889910] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[122.898265] Starting dynamic subtest: pipe-D-eDP-1
[122.920493] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[122.924654] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.003s)
[125.111551] [027/132] (893s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[125.177278] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[125.258190] [028/132] (893s left) gem_flink_basic (basic)
[125.319582] Starting subtest: basic
[125.322077] Subtest basic: SUCCESS (0.001s)
[125.459937] [029/132] (893s left) gem_wait (busy)
[125.520984] Starting subtest: busy
[125.523503] Starting dynamic subtest: all-engines
[126.868729] Dynamic subtest all-engines: SUCCESS (1.345s)
[126.879273] Starting dynamic subtest: rcs0
[127.408825] Dynamic subtest rcs0: SUCCESS (0.541s)
[127.419164] Starting dynamic subtest: bcs0
[127.949476] Dynamic subtest bcs0: SUCCESS (0.540s)
[127.959140] Starting dynamic subtest: vcs0
[129.876508] Dynamic subtest vcs0: SUCCESS (1.925s)
[129.886707] Starting dynamic subtest: vcs1
[131.924394] Dynamic subtest vcs1: SUCCESS (2.047s)
[131.934980] Starting dynamic subtest: vecs0
[133.907933] Dynamic subtest vecs0: SUCCESS (1.982s)
[133.918294] Starting dynamic subtest: ccs0
[134.449199] Dynamic subtest ccs0: SUCCESS (0.542s)
[134.451883] Subtest busy: SUCCESS (8.928s)
[134.668639] [030/132] (884s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[134.766815] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[134.769133] Starting dynamic subtest: pipe-A-default-mode
[135.053071] Dynamic subtest pipe-A-default-mode: SKIP (0.284s)
[135.057756] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.285s)
[135.900383] [031/132] (882s left) sysfs_defaults (readonly)
[135.962869] Starting subtest: readonly
[135.965382] Starting dynamic subtest: vecs0
[135.967642] Dynamic subtest vecs0: SUCCESS (0.000s)
[135.976849] Starting dynamic subtest: ccs0
[135.978764] Dynamic subtest ccs0: SUCCESS (0.000s)
[135.985984] Starting dynamic subtest: vcs0
[135.987862] Dynamic subtest vcs0: SUCCESS (0.000s)
[135.994963] Starting dynamic subtest: bcs0
[135.996978] Dynamic subtest bcs0: SUCCESS (0.000s)
[136.004578] Starting dynamic subtest: rcs0
[136.006493] Dynamic subtest rcs0: SUCCESS (0.000s)
[136.013332] Starting dynamic subtest: vcs1
[136.015218] Dynamic subtest vcs1: SUCCESS (0.000s)
[136.017151] Subtest readonly: SUCCESS (0.004s)
[136.110161] [032/132] (882s left) gem_exec_whisper (basic-fds-forked-all)
[136.172389] Starting subtest: basic-fds-forked-all
[158.204586] Subtest basic-fds-forked-all: SUCCESS (22.028s)
[158.409518] [033/132] (860s left) kms_cdclk (mode-transition)
[158.523794] Starting subtest: mode-transition
[158.526061] Starting dynamic subtest: pipe-A-eDP-1
[158.804146] Dynamic subtest pipe-A-eDP-1: SKIP (0.285s)
[158.814329] Starting dynamic subtest: pipe-B-eDP-1
[158.818931] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[158.827253] Starting dynamic subtest: pipe-C-eDP-1
[158.831775] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[158.839894] Starting dynamic subtest: pipe-D-eDP-1
[158.844116] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[158.848269] Subtest mode-transition: SKIP (0.291s)
[159.621485] [034/132] (859s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[159.720469] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[159.722915] Starting dynamic subtest: A-eDP1
[163.310117] Dynamic subtest A-eDP1: SUCCESS (3.586s)
[163.319118] Starting dynamic subtest: B-eDP1
[166.627336] Dynamic subtest B-eDP1: SUCCESS (3.317s)
[166.636826] Starting dynamic subtest: C-eDP1
[169.911715] Dynamic subtest C-eDP1: SUCCESS (3.285s)
[169.921090] Starting dynamic subtest: D-eDP1
[173.213042] Dynamic subtest D-eDP1: SUCCESS (3.297s)
[173.215353] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.492s)
[174.107978] [035/132] (844s left) gem_exec_params (invalid-fence-in)
[174.175102] Starting subtest: invalid-fence-in
[174.177074] Subtest invalid-fence-in: SUCCESS (0.000s)
[174.313744] [036/132] (844s left) kms_vblank (wait-forked-busy)
[174.404006] Starting subtest: wait-forked-busy
[174.405832] Starting dynamic subtest: pipe-A-eDP-1
[176.291096] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.886s)
[176.304835] Starting dynamic subtest: pipe-D-eDP-1
[178.812920] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.519s)
[178.815306] Subtest wait-forked-busy: SUCCESS (4.408s)
[179.713469] [037/132] (839s left) syncobj_wait (single-wait-submitted)
[179.776221] Starting subtest: single-wait-submitted
[179.880911] Subtest single-wait-submitted: SUCCESS (0.105s)
[179.980276] [038/132] (839s left) gem_mmap_gtt (big-copy-odd)
[180.032927] Subtest big-copy-odd: SKIP (0.000s)
[180.094519] [039/132] (838s left) gem_exec_schedule (timeslicing)
[180.162228] Starting subtest: timeslicing
[180.164196] Starting dynamic subtest: rcs0
[180.172726] Dynamic subtest rcs0: SUCCESS (0.021s)
[180.183027] Starting dynamic subtest: bcs0
[180.195508] Dynamic subtest bcs0: SUCCESS (0.022s)
[180.209586] Starting dynamic subtest: vcs0
[180.219683] Dynamic subtest vcs0: SUCCESS (0.023s)
[180.229069] Starting dynamic subtest: vcs1
[180.239901] Dynamic subtest vcs1: SUCCESS (0.019s)
[180.248211] Starting dynamic subtest: vecs0
[180.259639] Dynamic subtest vecs0: SUCCESS (0.019s)
[180.268819] Starting dynamic subtest: ccs0
[180.280024] Dynamic subtest ccs0: SUCCESS (0.020s)
[180.282417] Subtest timeslicing: SUCCESS (0.129s)
[181.970390] [040/132] (837s left) gem_softpin (invalid)
[182.034180] Starting subtest: invalid
[182.039142] Subtest invalid: SUCCESS (0.006s)
[182.187242] [041/132] (836s left) gem_exec_balancer (bonded-pair)
[182.255159] Starting subtest: bonded-pair
[182.259650] Subtest bonded-pair: SKIP (0.000s)
[182.558026] [042/132] (836s left) syncobj_wait (single-wait-all-signaled)
[182.620518] Starting subtest: single-wait-all-signaled
[182.622988] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[182.765711] [043/132] (836s left) i915_hangman (engine-error-state-capture)
[182.825695] Starting subtest: engine-error-state-capture
[182.828115] Starting dynamic subtest: rcs0
[185.907389] Dynamic subtest rcs0: SUCCESS (3.081s)
[185.918535] Starting dynamic subtest: bcs0
[191.859771] Dynamic subtest bcs0: SUCCESS (5.950s)
[191.870471] Starting dynamic subtest: vcs0
[197.877358] Dynamic subtest vcs0: SUCCESS (6.015s)
[197.888497] Starting dynamic subtest: vcs1
[203.826809] Dynamic subtest vcs1: SUCCESS (5.947s)
[203.838081] Starting dynamic subtest: vecs0
[208.819407] Dynamic subtest vecs0: SUCCESS (4.990s)
[208.832094] Starting dynamic subtest: ccs0
[213.876161] Dynamic subtest ccs0: SUCCESS (5.055s)
[213.879158] Subtest engine-error-state-capture: SUCCESS (31.050s)
[213.982149] [044/132] (805s left) gem_tiled_wb
[214.104202] [045/132] (805s left) kms_cursor_edge_walk (64x64-top-edge)
[214.201222] Starting subtest: 64x64-top-edge
[214.203505] Starting dynamic subtest: pipe-A-eDP-1
[217.721686] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.518s)
[217.731264] Starting dynamic subtest: pipe-D-eDP-1
[220.892513] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.171s)
[220.894812] Subtest 64x64-top-edge: SUCCESS (6.691s)
[221.702799] [046/132] (797s left) kms_panel_fitting (legacy)
[221.795059] Starting subtest: legacy
[221.797340] Starting dynamic subtest: pipe-A-eDP-1
[222.370994] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.578s)
[222.398088] Starting dynamic subtest: pipe-B-eDP-1
[223.931963] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.540s)
[223.962756] Starting dynamic subtest: pipe-C-eDP-1
[225.485579] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.532s)
[225.509567] Starting dynamic subtest: pipe-D-eDP-1
[226.982822] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.478s)
[226.985146] Subtest legacy: SUCCESS (5.190s)
[228.195322] [047/132] (791s left) kms_invalid_mode (uint-max-clock)
[228.288508] Starting subtest: uint-max-clock
[228.290925] Starting dynamic subtest: pipe-A-eDP-1
[228.575637] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.286s)
[228.584571] Starting dynamic subtest: pipe-B-eDP-1
[228.586837] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[228.594726] Starting dynamic subtest: pipe-C-eDP-1
[228.597054] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[228.604830] Starting dynamic subtest: pipe-D-eDP-1
[228.607149] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[228.609384] Subtest uint-max-clock: SUCCESS (0.292s)
[229.402582] [048/132] (790s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[229.508404] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[229.513061] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[229.633332] [049/132] (789s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[229.694486] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[229.801757] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.106s)
[229.902450] [050/132] (789s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf)
[234.961466] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf
[234.963887] Starting dynamic subtest: pipe-A-eDP-1
[235.721174] Dynamic subtest pipe-A-eDP-1: SKIP (0.758s)
[235.730185] Starting dynamic subtest: pipe-B-eDP-1
[236.828229] Dynamic subtest pipe-B-eDP-1: SKIP (1.106s)
[236.832702] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.867s)
[237.996804] [051/132] (781s left) api_intel_allocator (simple-allocator)
[238.061982] Starting subtest: simple-allocator
[238.064319] Starting dynamic subtest: basic
[238.066606] Dynamic subtest basic: SUCCESS (0.005s)
[238.081578] Starting dynamic subtest: parallel-one
[238.252362] Dynamic subtest parallel-one: SUCCESS (0.186s)
[238.261644] Starting dynamic subtest: print
[238.263869] Dynamic subtest print: SUCCESS (0.000s)
[238.271766] Starting dynamic subtest: reuse
[238.273670] Dynamic subtest reuse: SUCCESS (0.000s)
[238.280804] Starting dynamic subtest: reserve
[238.282665] Dynamic subtest reserve: SUCCESS (0.000s)
[238.289848] Starting dynamic subtest: fork-reopen-allocator
[238.291730] Dynamic subtest fork-reopen-allocator: SUCCESS (0.012s)
[238.293680] Subtest simple-allocator: SUCCESS (0.208s)
[238.403520] [052/132] (781s left) gem_ctx_sseu (invalid-sseu)
[238.459311] Subtest invalid-sseu: SKIP (0.000s)
[238.540299] [053/132] (781s left) kms_plane_alpha_blend (constant-alpha-max)
[238.633058] Starting subtest: constant-alpha-max
[238.913287] Starting dynamic subtest: pipe-A-eDP-1
[239.798464] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.884s)
[239.807078] Starting dynamic subtest: pipe-D-eDP-1
[241.486456] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.685s)
[241.488678] Subtest constant-alpha-max: SUCCESS (2.853s)
[242.310749] [054/132] (777s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[242.411279] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[242.415592] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s)
[242.533166] [055/132] (777s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[242.630152] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[242.634416] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[242.745557] [056/132] (777s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt)
[242.839241] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt
[242.843168] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[242.958433] [057/132] (776s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle)
[243.082080] Starting subtest: short-busy-flip-before-cursor-toggle
[243.086264] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s)
[243.250013] [058/132] (776s left) kms_cursor_legacy (cursora-vs-flipb-toggle)
[243.370060] Starting subtest: cursorA-vs-flipB-toggle
[243.373982] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s)
[243.536720] [059/132] (776s left) kms_scaling_modes (scaling-mode-full)
[243.632314] Starting subtest: scaling-mode-full
[243.634364] Starting dynamic subtest: pipe-A-eDP-1
[243.724231] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.094s)
[243.735783] Starting dynamic subtest: pipe-B-eDP-1
[244.875893] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.148s)
[244.887966] Starting dynamic subtest: pipe-C-eDP-1
[246.044253] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.165s)
[246.052816] Starting dynamic subtest: pipe-D-eDP-1
[247.158233] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.113s)
[247.160493] Subtest scaling-mode-full: SUCCESS (3.529s)
[248.394119] [060/132] (771s left) kms_chamelium_edid (dp-edid-read)
[248.779591] Subtest dp-edid-read: SKIP (0.000s)
[249.557503] [061/132] (770s left) kms_psr (psr-basic)
[249.663192] Starting subtest: psr-basic
[249.665536] Starting dynamic subtest: eDP-1
[251.234096] Dynamic subtest eDP-1: SUCCESS (1.575s)
[251.236455] Subtest psr-basic: SUCCESS (1.576s)
[252.108493] [062/132] (767s left) kms_busy (basic-hang)
[252.209602] Starting subtest: basic-hang
[252.211857] Starting dynamic subtest: flip-pipe-A
[252.798861] Dynamic subtest flip-pipe-A: SUCCESS (0.588s)
[252.807777] Starting dynamic subtest: modeset-pipe-A
[256.520621] Dynamic subtest modeset-pipe-A: SUCCESS (3.721s)
[256.529866] Starting dynamic subtest: flip-pipe-D
[257.768930] Dynamic subtest flip-pipe-D: SUCCESS (1.246s)
[257.777226] Starting dynamic subtest: modeset-pipe-D
[261.105316] Dynamic subtest modeset-pipe-D: SUCCESS (3.337s)
[261.107612] Subtest basic-hang: SUCCESS (8.898s)
[261.997459] [063/132] (758s left) kms_big_fb (y-tiled-16bpp-rotate-0)
[262.099252] Starting subtest: y-tiled-16bpp-rotate-0
[262.103795] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s)
[262.234448] [064/132] (757s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[262.326890] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[262.338696] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.010s)
[262.433716] [065/132] (757s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[262.540324] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[262.544634] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[262.651594] [066/132] (757s left) kms_color (legacy-gamma)
[262.735822] Starting subtest: legacy-gamma
[262.738064] Starting dynamic subtest: pipe-A-eDP-1
[263.434913] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.700s)
[263.445210] Starting dynamic subtest: pipe-B-eDP-1
[264.836353] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.399s)
[264.845321] Starting dynamic subtest: pipe-C-eDP-1
[266.205607] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.369s)
[266.214959] Starting dynamic subtest: pipe-D-eDP-1
[267.595068] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.391s)
[267.597389] Subtest legacy-gamma: SUCCESS (4.861s)
[268.500841] [067/132] (751s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[268.604139] Starting subtest: x-tiled-64bpp-rotate-270
[268.623822] Subtest x-tiled-64bpp-rotate-270: SKIP (0.019s)
[268.768162] [068/132] (751s left) gem_userptr_blits (process-exit)
[268.836449] Starting subtest: process-exit
[268.843278] Subtest process-exit: SUCCESS (0.007s)
[269.005318] [069/132] (751s left) syncobj_timeline (device-submit-unordered)
[269.062971] Starting subtest: device-submit-unordered
[269.065271] Subtest device-submit-unordered: SUCCESS (0.000s)
[269.180992] [070/132] (751s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-pwrite)
[269.286375] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-pwrite
[269.290593] Subtest psr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[269.420027] [071/132] (750s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-blt)
[269.521071] Starting subtest: psr-1p-primscrn-cur-indfb-draw-blt
[276.240411] Subtest psr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.721s)
[276.390253] [072/132] (744s left) gem_exec_flush (basic-uc-prw-default)
[276.463755] Starting subtest: basic-uc-prw-default
[281.956094] Subtest basic-uc-prw-default: SUCCESS (5.493s)
[282.164163] [073/132] (738s left) kms_psr (fbc-psr-dpms)
[282.263134] Starting subtest: fbc-psr-dpms
[282.265293] Starting dynamic subtest: eDP-1
[282.269186] Dynamic subtest eDP-1: SKIP (0.000s)
[282.273102] Subtest fbc-psr-dpms: SKIP (0.001s)
[282.360684] [074/132] (738s left) prime_mmap (test_correct)
[282.429668] Starting subtest: test_correct
[282.432201] Starting dynamic subtest: test_correct-smem
[282.454892] Dynamic subtest test_correct-smem: SUCCESS (0.028s)
[282.457274] Subtest test_correct: SUCCESS (0.029s)
[282.588176] [075/132] (737s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[282.681833] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[282.684180] Starting dynamic subtest: pipe-A-default-mode
[285.346219] Dynamic subtest pipe-A-default-mode: SUCCESS (2.665s)
[285.348414] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.666s)
[286.191671] [076/132] (734s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled)
[286.254853] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[286.257232] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[286.375921] [077/132] (734s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-onoff)
[286.465616] Starting subtest: fbc-2p-scndscrn-spr-indfb-onoff
[286.469692] Subtest fbc-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[286.601394] [078/132] (734s left) gen9_exec_parse (valid-registers)
[286.672388] Subtest valid-registers: SKIP (0.000s)
[286.750338] [079/132] (733s left) core_hotunplug (unbind-rebind)
[286.827411] Starting subtest: unbind-rebind
[292.283062] Subtest unbind-rebind: SUCCESS (5.453s)
[292.320640] [080/132] (728s left) sysfs_timeslice_duration (duration)
[293.887061] Starting subtest: duration
[293.889302] Starting dynamic subtest: vecs0
[308.852723] Dynamic subtest vecs0: SUCCESS (14.965s)
[308.865088] Starting dynamic subtest: ccs0
[322.006466] Dynamic subtest ccs0: SUCCESS (13.151s)
[322.018100] Starting dynamic subtest: vcs0
[336.818929] Dynamic subtest vcs0: SUCCESS (14.808s)
[336.830483] Starting dynamic subtest: bcs0
[349.992513] Dynamic subtest bcs0: SUCCESS (13.172s)
[350.005428] Starting dynamic subtest: rcs0
[363.170045] Dynamic subtest rcs0: SUCCESS (13.175s)
[363.181969] Starting dynamic subtest: vcs1
[376.818393] Dynamic subtest vcs1: SUCCESS (13.644s)
[376.822663] Subtest duration: SUCCESS (82.930s)
[376.919259] [081/132] (643s left) gem_lmem_swapping (verify-random)
[376.971104] Subtest verify-random: SKIP (0.000s)
[377.020095] [082/132] (643s left) kms_psr (fbc-pr-sprite-plane-onoff)
[377.127887] Starting subtest: fbc-pr-sprite-plane-onoff
[377.132334] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[377.223916] [083/132] (643s left) kms_flip (2x-plain-flip-ts-check)
[377.315984] Starting subtest: 2x-plain-flip-ts-check
[377.324486] Subtest 2x-plain-flip-ts-check: SKIP (0.010s)
[377.427904] [084/132] (643s left) syncobj_timeline (invalid-transfer-bad-pad)
[377.477584] Starting subtest: invalid-transfer-bad-pad
[377.479727] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s)
[377.596457] [085/132] (643s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-rotation)
[377.687885] Starting subtest: plane-scaler-with-clipping-clamping-rotation
[377.690103] Starting dynamic subtest: pipe-A
[377.938492] Dynamic subtest pipe-A: SUCCESS (0.252s)
[377.947524] Starting dynamic subtest: pipe-B
[379.246577] Dynamic subtest pipe-B: SUCCESS (1.307s)
[379.262023] Starting dynamic subtest: pipe-C
[380.564571] Dynamic subtest pipe-C: SUCCESS (1.317s)
[380.574123] Starting dynamic subtest: pipe-D
[381.890511] Dynamic subtest pipe-D: SUCCESS (1.324s)
[381.892679] Subtest plane-scaler-with-clipping-clamping-rotation: SUCCESS (4.206s)
[383.105069] [086/132] (637s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[383.204506] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[390.519469] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.318s)
[390.683471] [087/132] (630s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[390.778460] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[390.780627] Starting dynamic subtest: pipe-A-eDP-1
[390.789261] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[390.798143] Starting dynamic subtest: pipe-B-eDP-1
[390.806729] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[390.815503] Starting dynamic subtest: pipe-C-eDP-1
[390.823584] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[390.832031] Starting dynamic subtest: pipe-D-eDP-1
[390.840132] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[390.844064] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[393.074933] [088/132] (627s left) gem_eio (in-flight-1us)
[393.250764] Starting subtest: in-flight-1us
[401.481130] Subtest in-flight-1us: SUCCESS (8.230s)
[401.695833] [089/132] (619s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[401.794139] Starting subtest: yf-tiled-64bpp-rotate-0
[401.798172] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[401.929260] [090/132] (619s left) kms_psr (pr-cursor-plane-onoff)
[402.023259] Starting subtest: pr-cursor-plane-onoff
[402.027638] Subtest pr-cursor-plane-onoff: SKIP (0.000s)
[402.121482] [091/132] (619s left) gem_compute (compute-square)
[402.178341] Starting subtest: compute-square
[402.183662] Subtest compute-square: SUCCESS (0.007s)
[402.338630] [092/132] (618s left) gem_exec_balancer (waits)
[402.390512] Starting subtest: waits
[408.818300] Subtest waits: SUCCESS (6.426s)
[409.134883] [093/132] (612s left) perf_pmu (most-busy-check-all)
[409.178173] Starting subtest: most-busy-check-all
[409.180424] Starting dynamic subtest: rcs0
[410.901524] Dynamic subtest rcs0: SUCCESS (1.722s)
[410.913862] Starting dynamic subtest: bcs0
[412.885631] Dynamic subtest bcs0: SUCCESS (1.981s)
[412.897736] Starting dynamic subtest: vcs0
[414.934247] Dynamic subtest vcs0: SUCCESS (2.045s)
[414.946271] Starting dynamic subtest: vcs1
[416.917359] Dynamic subtest vcs1: SUCCESS (1.980s)
[416.929426] Starting dynamic subtest: vecs0
[418.900087] Dynamic subtest vecs0: SUCCESS (1.980s)
[418.911903] Starting dynamic subtest: ccs0
[420.884974] Dynamic subtest ccs0: SUCCESS (1.982s)
[420.887527] Subtest most-busy-check-all: SUCCESS (11.708s)
[420.997512] [094/132] (600s left) gem_softpin (noreloc-interruptible)
[421.063817] Starting subtest: noreloc-interruptible
[426.485762] Subtest noreloc-interruptible: SUCCESS (5.421s)
[426.647159] [095/132] (594s left) kms_flip (2x-blocking-wf_vblank)
[426.764991] Starting subtest: 2x-blocking-wf_vblank
[426.775965] Subtest 2x-blocking-wf_vblank: SKIP (0.010s)
[426.914416] [096/132] (594s left) kms_big_fb (linear-64bpp-rotate-270)
[427.012884] Starting subtest: linear-64bpp-rotate-270
[427.032065] Subtest linear-64bpp-rotate-270: SKIP (0.018s)
[427.190895] [097/132] (594s left) gem_exec_reloc (basic-cpu-active)
[427.246444] Subtest basic-cpu-active: SKIP (0.000s)
[427.323897] [098/132] (594s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[427.596032] Starting subtest: cursor-rapid-movement-512x512
[427.599413] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[427.798869] [099/132] (593s left) kms_content_protection (legacy-hdcp14)
[427.938589] Starting subtest: legacy-hdcp14
[427.942091] Subtest legacy-hdcp14: SKIP (0.000s)
[428.094404] [100/132] (593s left) gem_exec_suspend (basic)
[428.157673] Starting subtest: basic
[428.159793] Starting dynamic subtest: smem
[429.910032] Dynamic subtest smem: SUCCESS (1.750s)
[429.913083] Subtest basic: SUCCESS (1.752s)
[430.122094] [101/132] (591s left) gem_exec_schedule (in-order)
[430.198057] Starting subtest: in-order
[430.200419] Starting dynamic subtest: rcs0
[430.289553] Dynamic subtest rcs0: SUCCESS (0.100s)
[430.301155] Starting dynamic subtest: vcs0
[430.372072] Dynamic subtest vcs0: SUCCESS (0.082s)
[430.383795] Starting dynamic subtest: vcs1
[430.480144] Dynamic subtest vcs1: SUCCESS (0.107s)
[430.492466] Starting dynamic subtest: vecs0
[430.587955] Dynamic subtest vecs0: SUCCESS (0.107s)
[430.599469] Starting dynamic subtest: ccs0
[430.722032] Dynamic subtest ccs0: SUCCESS (0.133s)
[430.724993] Subtest in-order: SUCCESS (0.533s)
[432.030218] [102/132] (589s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-gtt)
[432.146532] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-gtt
[432.150606] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[432.278384] [103/132] (589s left) gem_exec_fence (syncobj-invalid-wait)
[432.728993] Starting subtest: syncobj-invalid-wait
[432.731688] Subtest syncobj-invalid-wait: SUCCESS (0.001s)
[434.002338] [104/132] (587s left) i915_pm_rpm (system-suspend)
[436.122529] Starting subtest: system-suspend
[453.804538] Subtest system-suspend: SUCCESS (6.532s)
[454.200743] [105/132] (567s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[459.181191] Starting subtest: pr-primary-plane-update-sf-dmg-area
[459.185683] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.002s)
[460.048074] [106/132] (561s left) gem_exec_reloc (basic-cpu-noreloc)
[460.109830] Subtest basic-cpu-noreloc: SKIP (0.000s)
[460.203223] [107/132] (561s left) kms_cursor_legacy (flip-vs-cursor-atomic)
[460.313550] Starting subtest: flip-vs-cursor-atomic
[467.415645] Subtest flip-vs-cursor-atomic: SUCCESS (7.125s)
[468.246032] [108/132] (553s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[468.344553] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc
[474.907166] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.574s)
[475.080227] [109/132] (546s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions)
[475.209070] Starting subtest: short-flip-after-cursor-atomic-transitions
[476.180207] Subtest short-flip-after-cursor-atomic-transitions: SUCCESS (0.972s)
[477.087261] [110/132] (544s left) api_intel_bb (intel-bb-blit-x)
[477.141163] Starting subtest: intel-bb-blit-x
[480.503822] Subtest intel-bb-blit-x: SUCCESS (3.365s)
[480.668923] [111/132] (541s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[480.789692] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[480.794143] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[480.935483] [112/132] (541s left) kms_big_fb (4-tiled-8bpp-rotate-0)
[481.033058] Starting subtest: 4-tiled-8bpp-rotate-0
[482.134398] Subtest 4-tiled-8bpp-rotate-0: SUCCESS (1.102s)
[482.313269] [113/132] (539s left) gem_ctx_persistence (engines-queued)
[482.370851] Starting subtest: engines-queued
[482.373231] Starting dynamic subtest: rcs0
[482.488996] Dynamic subtest rcs0: SUCCESS (0.117s)
[482.501209] Starting dynamic subtest: bcs0
[482.525104] Dynamic subtest bcs0: SUCCESS (0.035s)
[482.534062] Starting dynamic subtest: vcs0
[484.038144] Dynamic subtest vcs0: SUCCESS (1.510s)
[484.050726] Starting dynamic subtest: vcs1
[486.020786] Dynamic subtest vcs1: SUCCESS (1.978s)
[486.033291] Starting dynamic subtest: vecs0
[488.004334] Dynamic subtest vecs0: SUCCESS (1.980s)
[488.016742] Starting dynamic subtest: ccs0
[488.186685] Dynamic subtest ccs0: SUCCESS (0.182s)
[488.189383] Subtest engines-queued: SUCCESS (5.814s)
[488.363504] [114/132] (533s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[488.426314] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[488.531260] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.103s)
[488.648683] [115/132] (533s left) gen9_exec_parse (bb-oversize)
[488.704347] Subtest bb-oversize: SKIP (0.000s)
[488.793882] [116/132] (533s left) gem_render_copy (mixed-tiled-to-yf-tiled-ccs)
[488.857118] Starting subtest: mixed-tiled-to-yf-tiled-ccs
[488.861533] Subtest mixed-tiled-to-yf-tiled-ccs: SKIP (0.000s)
[489.068136] [117/132] (533s left) i915_selftest (live)
[490.983998] Starting subtest: live
[490.986601] Starting dynamic subtest: sanitycheck
[495.480047] Dynamic subtest sanitycheck: SUCCESS (4.495s)
[495.489041] Starting dynamic subtest: uncore
[498.241596] Dynamic subtest uncore: SUCCESS (2.759s)
[498.250908] Starting dynamic subtest: workarounds
[516.139440] Dynamic subtest workarounds: FAIL (17.418s)
[516.148408] Starting dynamic subtest: gt_engines
[520.323699] Dynamic subtest gt_engines: SUCCESS (4.666s)
[520.332672] Starting dynamic subtest: gt_timelines
[537.556893] Dynamic subtest gt_timelines: SUCCESS (17.235s)
[537.566280] Starting dynamic subtest: gt_contexts
[541.988574] Dynamic subtest gt_contexts: SUCCESS (4.431s)
[541.997754] Starting dynamic subtest: gt_lrc
[548.259819] Dynamic subtest gt_lrc: SUCCESS (6.272s)
[548.269358] Starting dynamic subtest: gt_mocs
[551.385666] Dynamic subtest gt_mocs: SUCCESS (3.122s)
[551.395114] Starting dynamic subtest: gt_pm
[558.238817] Dynamic subtest gt_pm: SUCCESS (6.848s)
[558.248587] Starting dynamic subtest: gt_heartbeat
[562.727719] Dynamic subtest gt_heartbeat: SUCCESS (4.485s)
[562.736966] Starting dynamic subtest: gt_tlb
[572.131451] Dynamic subtest gt_tlb: SUCCESS (9.400s)
[572.141021] Starting dynamic subtest: requests
[583.767117] Dynamic subtest requests: SUCCESS (11.633s)
[583.776855] Starting dynamic subtest: migrate
[589.846802] Dynamic subtest migrate: SUCCESS (6.078s)
[589.855082] Starting dynamic subtest: active
[594.288670] Dynamic subtest active: SUCCESS (4.440s)
[594.298275] Starting dynamic subtest: objects
[599.265458] Dynamic subtest objects: SUCCESS (4.975s)
[599.275190] Starting dynamic subtest: mman
[604.293100] Dynamic subtest mman: SUCCESS (5.026s)
[604.305310] Starting dynamic subtest: dmabuf
[608.784298] Dynamic subtest dmabuf: SUCCESS (4.490s)
[608.793239] Starting dynamic subtest: vma
[613.201585] Dynamic subtest vma: SUCCESS (4.416s)
[613.210979] Starting dynamic subtest: coherency
[618.259557] Dynamic subtest coherency: SUCCESS (5.056s)
[618.268864] Starting dynamic subtest: gtt
[628.300947] Dynamic subtest gtt: SUCCESS (10.042s)
[628.310485] Starting dynamic subtest: gem
[635.914694] Dynamic subtest gem: SUCCESS (7.614s)
[635.924356] Starting dynamic subtest: evict
[641.407525] Dynamic subtest evict: SUCCESS (5.492s)
[641.416902] Starting dynamic subtest: hugepages
[652.519596] Dynamic subtest hugepages: SUCCESS (11.113s)
[652.529184] Starting dynamic subtest: gem_contexts
[681.077677] Dynamic subtest gem_contexts: SUCCESS (28.561s)
[681.091508] Starting dynamic subtest: client
[685.546398] Dynamic subtest client: SUCCESS (4.465s)
[685.555310] Starting dynamic subtest: gem_migrate
[690.072386] Dynamic subtest gem_migrate: SUCCESS (4.522s)
[690.082206] Starting dynamic subtest: reset
[694.556590] Dynamic subtest reset: SUCCESS (4.481s)
[694.566649] Starting dynamic subtest: memory_region
[699.065337] Dynamic subtest memory_region: SUCCESS (4.506s)
[699.074984] Starting dynamic subtest: hangcheck
[712.303844] Dynamic subtest hangcheck: SUCCESS (13.233s)
[712.318307] Starting dynamic subtest: execlists
[716.712518] Dynamic subtest execlists: SUCCESS (4.406s)
[716.722146] Starting dynamic subtest: ring_submission
[721.097515] Dynamic subtest ring_submission: SUCCESS (4.382s)
[721.106689] Starting dynamic subtest: perf
[725.451464] Dynamic subtest perf: SUCCESS (4.351s)
[725.460740] Starting dynamic subtest: slpc
[739.569861] Dynamic subtest slpc: SUCCESS (14.115s)
[739.579143] Starting dynamic subtest: guc
[743.589783] Dynamic subtest guc: SUCCESS (4.018s)
[743.599175] Starting dynamic subtest: guc_multi_lrc
[748.084329] Dynamic subtest guc_multi_lrc: SUCCESS (4.493s)
[748.092944] Starting dynamic subtest: guc_hang
[753.132640] Dynamic subtest guc_hang: SUCCESS (5.047s)
[753.148185] Starting dynamic subtest: late_gt_pm
[757.631639] Dynamic subtest late_gt_pm: SUCCESS (4.496s)
[757.634275] Subtest live: FAIL (266.657s)
[757.662327] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[757.663117] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[757.666280] [118/132] (264s left) kms_cursor_crc (cursor-onscreen-32x10)
[759.264214] Starting subtest: cursor-onscreen-32x10
[759.314827] Subtest cursor-onscreen-32x10: SKIP (0.045s)
[759.589839] [FACT kms_cursor_crc (cursor-onscreen-32x10)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[759.590980] [FACT kms_cursor_crc (cursor-onscreen-32x10)] new: kernel.kmod_is_loaded.i915: true
[759.594530] [119/132] (262s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[759.710791] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[759.715205] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[759.839480] [120/132] (262s left) gem_exec_reloc (basic-gtt-read-active)
[759.899410] Subtest basic-gtt-read-active: SKIP (0.000s)
[759.969229] [121/132] (262s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[760.026215] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[760.086508] [122/132] (262s left) gem_softpin (softpin)
[760.138942] Starting subtest: softpin
[792.438829] Subtest softpin: SUCCESS (32.297s)
[792.578067] [123/132] (229s left) gen3_mixed_blits
[792.711354] [124/132] (229s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-blt)
[792.819204] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-blt
[792.823207] Subtest fbc-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[792.969121] [125/132] (229s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[797.991305] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[797.996200] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.002s)
[798.862353] [126/132] (223s left) gem_exec_fence (syncobj-timeline-repeat)
[799.444585] Starting subtest: syncobj-timeline-repeat
[799.662767] Subtest syncobj-timeline-repeat: SUCCESS (0.218s)
[801.188296] [127/132] (221s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-gtt)
[801.282153] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-gtt
[801.287152] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[801.411700] [128/132] (221s left) gem_busy (extended)
[801.603750] Starting subtest: extended
[801.606314] Starting dynamic subtest: rcs0
[801.689793] Dynamic subtest rcs0: SUCCESS (0.086s)
[801.701364] Starting dynamic subtest: bcs0
[801.732591] Dynamic subtest bcs0: SUCCESS (0.041s)
[801.743505] Starting dynamic subtest: vcs0
[803.047338] Dynamic subtest vcs0: SUCCESS (1.311s)
[803.058903] Starting dynamic subtest: vcs1
[805.031473] Dynamic subtest vcs1: SUCCESS (1.981s)
[805.043702] Starting dynamic subtest: vecs0
[807.078315] Dynamic subtest vecs0: SUCCESS (2.044s)
[807.089386] Starting dynamic subtest: ccs0
[807.121909] Dynamic subtest ccs0: SUCCESS (0.043s)
[807.124289] Subtest extended: SUCCESS (5.521s)
[807.409134] [129/132] (215s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[807.530130] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[814.497589] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (6.970s)
[814.637942] [130/132] (208s left) kms_cursor_legacy (short-flip-after-cursor-atomic-transitions-varying-size)
[814.770697] Starting subtest: short-flip-after-cursor-atomic-transitions-varying-size
[815.721197] Subtest short-flip-after-cursor-atomic-transitions-varying-size: SUCCESS (0.952s)
[816.618060] [131/132] (206s left) gem_gpgpu_fill (offset-16x16)
[816.681701] Starting subtest: offset-16x16
[816.688756] Subtest offset-16x16: SUCCESS (0.007s)
[816.846062] [132/132] (205s left) kms_psr (pr-sprite-mmap-cpu)
[816.934435] Starting subtest: pr-sprite-mmap-cpu
[816.938391] Subtest pr-sprite-mmap-cpu: SKIP (0.000s)
[817.033765] Closing watchdogs
results: parsing output: 0/ for test: syncobj_timeline
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_addfb_basic
results: parsing output: 4/ for test: kms_universal_plane
results: parsing output: 5/ for test: kms_pm_dc
results: parsing output: 6/ for test: syncobj_wait
results: parsing output: 7/ for test: kms_pm_rpm
results: parsing output: 8/ for test: gem_ctx_persistence
results: parsing output: 9/ for test: kms_hdr
results: parsing output: 10/ for test: kms_3d
results: parsing output: 11/ for test: gem_mmap_gtt
results: parsing output: 12/ for test: gem_pread
results: parsing output: 13/ for test: gem_exec_reloc
results: parsing output: 14/ for test: kms_plane_multiple
results: parsing output: 15/ for test: gem_ringfill
results: parsing output: 16/ for test: perf
results: parsing output: 17/ for test: kms_lease
results: parsing output: 18/ for test: kms_dsc
results: parsing output: 19/ for test: kms_ccs
results: parsing output: 20/ for test: kms_chamelium_hpd
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: gem_softpin
results: parsing output: 23/ for test: kms_ccs
results: parsing output: 24/ for test: kms_atomic_transition
results: parsing output: 25/ for test: kms_ccs
results: parsing output: 26/ for test: gem_exec_reloc
results: parsing output: 27/ for test: gem_flink_basic
results: parsing output: 28/ for test: gem_wait
results: parsing output: 29/ for test: kms_flip_scaled_crc
results: parsing output: 30/ for test: sysfs_defaults
results: parsing output: 31/ for test: gem_exec_whisper
results: parsing output: 32/ for test: kms_cdclk
results: parsing output: 33/ for test: kms_flip
results: parsing output: 34/ for test: gem_exec_params
results: parsing output: 35/ for test: kms_vblank
results: parsing output: 36/ for test: syncobj_wait
results: parsing output: 37/ for test: gem_mmap_gtt
results: parsing output: 38/ for test: gem_exec_schedule
results: parsing output: 39/ for test: gem_softpin
results: parsing output: 40/ for test: gem_exec_balancer
results: parsing output: 41/ for test: syncobj_wait
results: parsing output: 42/ for test: i915_hangman
results: parsing output: 43/ for test: gem_tiled_wb
results: parsing output: 44/ for test: kms_cursor_edge_walk
results: parsing output: 45/ for test: kms_panel_fitting
results: parsing output: 46/ for test: kms_invalid_mode
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: syncobj_timeline
results: parsing output: 49/ for test: kms_psr2_sf
results: parsing output: 50/ for test: api_intel_allocator
results: parsing output: 51/ for test: gem_ctx_sseu
results: parsing output: 52/ for test: kms_plane_alpha_blend
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_cursor_legacy
results: parsing output: 57/ for test: kms_cursor_legacy
results: parsing output: 58/ for test: kms_scaling_modes
results: parsing output: 59/ for test: kms_chamelium_edid
results: parsing output: 60/ for test: kms_psr
results: parsing output: 61/ for test: kms_busy
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: kms_flip
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: kms_color
results: parsing output: 66/ for test: kms_big_fb
results: parsing output: 67/ for test: gem_userptr_blits
results: parsing output: 68/ for test: syncobj_timeline
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: gem_exec_flush
results: parsing output: 72/ for test: kms_psr
results: parsing output: 73/ for test: prime_mmap
results: parsing output: 74/ for test: kms_flip_scaled_crc
results: parsing output: 75/ for test: syncobj_wait
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: gen9_exec_parse
results: parsing output: 78/ for test: core_hotunplug
results: parsing output: 79/ for test: sysfs_timeslice_duration
results: parsing output: 80/ for test: gem_lmem_swapping
results: parsing output: 81/ for test: kms_psr
results: parsing output: 82/ for test: kms_flip
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: kms_plane_scaling
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_ccs
results: parsing output: 87/ for test: gem_eio
results: parsing output: 88/ for test: kms_big_fb
results: parsing output: 89/ for test: kms_psr
results: parsing output: 90/ for test: gem_compute
results: parsing output: 91/ for test: gem_exec_balancer
results: parsing output: 92/ for test: perf_pmu
results: parsing output: 93/ for test: gem_softpin
results: parsing output: 94/ for test: kms_flip
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: gem_exec_reloc
results: parsing output: 97/ for test: kms_cursor_crc
results: parsing output: 98/ for test: kms_content_protection
results: parsing output: 99/ for test: gem_exec_suspend
results: parsing output: 100/ for test: gem_exec_schedule
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gem_exec_fence
results: parsing output: 103/ for test: i915_pm_rpm
results: parsing output: 104/ for test: kms_psr2_sf
results: parsing output: 105/ for test: gem_exec_reloc
results: parsing output: 106/ for test: kms_cursor_legacy
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: kms_cursor_legacy
results: parsing output: 109/ for test: api_intel_bb
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: gem_ctx_persistence
results: parsing output: 113/ for test: syncobj_wait
results: parsing output: 114/ for test: gen9_exec_parse
results: parsing output: 115/ for test: gem_render_copy
results: parsing output: 116/ for test: i915_selftest
results: parsing output: 117/ for test: kms_cursor_crc
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: gem_exec_reloc
results: parsing output: 120/ for test: gem_exec_reloc
results: parsing output: 121/ for test: gem_softpin
results: parsing output: 122/ for test: gen3_mixed_blits
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_psr2_sf
results: parsing output: 125/ for test: gem_exec_fence
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: gem_busy
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_cursor_legacy
results: parsing output: 130/ for test: gem_gpgpu_fill
results: parsing output: 131/ for test: kms_psr
Done.