[57.472948] Initializing watchdogs
[57.473021]   /dev/watchdog0
[57.492651] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[57.503330] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[57.507083] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.509732] [001/130] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move)
[57.702868] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move
[57.704537] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[57.885723] [002/130] (960s left) kms_cursor_crc (cursor-random-512x512)
[58.350895] Starting subtest: cursor-random-512x512
[58.352601] Subtest cursor-random-512x512: SKIP (0.001s)
[58.669270] [003/130] (959s left) kms_vblank (query-idle)
[58.860417] Starting subtest: query-idle
[58.862350] Starting dynamic subtest: pipe-A-DP-3
[61.172576] Dynamic subtest pipe-A-DP-3: SUCCESS (2.323s)
[61.186636] Starting dynamic subtest: pipe-D-DP-3
[63.407418] Dynamic subtest pipe-D-DP-3: SUCCESS (2.239s)
[63.408307] Subtest query-idle: SUCCESS (4.568s)
[63.670792] [004/130] (954s left) gem_mmap_gtt (cpuset-medium-copy-odd)
[63.742965] Subtest cpuset-medium-copy-odd: SKIP (0.000s)
[63.834273] [005/130] (954s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[64.019590] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[64.021365] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[64.182245] [006/130] (954s left) i915_hangman (gt-error-state-capture)
[64.277876] Starting subtest: gt-error-state-capture
[64.278732] Starting dynamic subtest: rcs0
[74.101715] Dynamic subtest rcs0: SUCCESS (9.840s)
[74.112873] Starting dynamic subtest: bcs0
[84.123778] Dynamic subtest bcs0: SUCCESS (10.024s)
[84.134991] Starting dynamic subtest: vcs0
[94.066362] Dynamic subtest vcs0: SUCCESS (9.942s)
[94.074748] Starting dynamic subtest: vcs1
[104.054494] Dynamic subtest vcs1: SUCCESS (9.988s)
[104.063207] Starting dynamic subtest: vecs0
[114.102368] Dynamic subtest vecs0: SUCCESS (10.048s)
[114.110731] Starting dynamic subtest: vecs1
[124.127909] Dynamic subtest vecs1: SUCCESS (10.025s)
[124.151098] Starting dynamic subtest: ccs0
[134.087381] Dynamic subtest ccs0: SUCCESS (9.959s)
[134.088358] Subtest gt-error-state-capture: SUCCESS (69.829s)
[134.257613] [007/130] (884s left) gem_workarounds (reset)
[134.360596] Starting subtest: reset
[134.584877] Subtest reset: SUCCESS (0.224s)
[134.758234] [008/130] (883s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[135.027428] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[135.204081] [009/130] (883s left) kms_addfb_basic (bad-pitch-1024)
[135.273969] Starting subtest: bad-pitch-1024
[135.274924] Subtest bad-pitch-1024: SUCCESS (0.000s)
[135.548024] [010/130] (883s left) gem_exec_params (batch-first)
[135.624561] Starting subtest: batch-first
[135.659475] Subtest batch-first: SUCCESS (0.035s)
[135.858133] [011/130] (882s left) gem_wait (write-wait)
[135.944509] Starting subtest: write-wait
[135.945451] Starting dynamic subtest: all-engines
[137.083661] Dynamic subtest all-engines: SUCCESS (1.139s)
[137.102306] Starting dynamic subtest: rcs0
[138.146483] Dynamic subtest rcs0: SUCCESS (1.062s)
[138.162013] Starting dynamic subtest: bcs0
[139.207647] Dynamic subtest bcs0: SUCCESS (1.060s)
[139.221307] Starting dynamic subtest: vcs0
[140.267597] Dynamic subtest vcs0: SUCCESS (1.059s)
[140.281306] Starting dynamic subtest: vcs1
[141.330539] Dynamic subtest vcs1: SUCCESS (1.062s)
[141.344529] Starting dynamic subtest: vecs0
[142.392672] Dynamic subtest vecs0: SUCCESS (1.061s)
[142.406443] Starting dynamic subtest: vecs1
[143.454659] Dynamic subtest vecs1: SUCCESS (1.061s)
[143.468654] Starting dynamic subtest: ccs0
[144.515629] Dynamic subtest ccs0: SUCCESS (1.060s)
[144.517583] Subtest write-wait: SUCCESS (8.571s)
[144.822814] [FACT gem_wait (write-wait)] new: kernel.kmod_is_loaded.vgem: true
[144.825381] [012/130] (873s left) sw_sync (alloc_fence_invalid_timeline)
[144.874007] Starting subtest: alloc_fence_invalid_timeline
[144.875762] Subtest alloc_fence_invalid_timeline: SUCCESS (0.000s)
[144.975849] [013/130] (873s left) gen9_exec_parse (shadow-peek)
[145.059776] Subtest shadow-peek: SKIP (0.000s)
[145.138947] [014/130] (873s left) kms_psr (psr2-basic)
[145.332958] Subtest psr2-basic: SKIP (0.000s)
[145.389721] [015/130] (873s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[145.580719] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[145.581645] Starting dynamic subtest: pipe-A-DP-3
[145.590225] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[145.598596] Starting dynamic subtest: pipe-B-DP-3
[145.607215] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[145.615741] Starting dynamic subtest: pipe-C-DP-3
[145.624121] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[145.632389] Starting dynamic subtest: pipe-D-DP-3
[145.642839] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[145.644664] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.004s)
[146.084238] [016/130] (872s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[146.281729] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[149.468336] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (3.187s)
[149.696514] [017/130] (869s left) gem_userptr_blits (invalid-null-pointer)
[149.793265] Starting subtest: invalid-null-pointer
[149.794179] Subtest invalid-null-pointer: SUCCESS (0.001s)
[149.963495] [018/130] (869s left) gem_ctx_persistence (engines-mixed)
[150.064414] Starting subtest: engines-mixed
[150.065406] Starting dynamic subtest: rcs0
[150.200369] Dynamic subtest rcs0: SUCCESS (0.136s)
[150.210276] Starting dynamic subtest: bcs0
[150.250262] Dynamic subtest bcs0: SUCCESS (0.050s)
[150.265174] Starting dynamic subtest: vcs0
[150.306647] Dynamic subtest vcs0: SUCCESS (0.056s)
[150.338286] Starting dynamic subtest: vcs1
[150.373459] Dynamic subtest vcs1: SUCCESS (0.066s)
[150.396211] Starting dynamic subtest: vecs0
[150.451406] Dynamic subtest vecs0: SUCCESS (0.077s)
[150.487404] Starting dynamic subtest: vecs1
[150.526610] Dynamic subtest vecs1: SUCCESS (0.075s)
[150.540683] Starting dynamic subtest: ccs0
[150.596488] Dynamic subtest ccs0: SUCCESS (0.069s)
[150.598638] Subtest engines-mixed: SUCCESS (0.532s)
[150.799884] [019/130] (868s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[150.999572] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[151.001295] Subtest psr-1p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[151.200347] [020/130] (868s left) kms_psr (psr-primary-page-flip)
[151.399835] Subtest psr-primary-page-flip: SKIP (0.000s)
[151.459950] [021/130] (867s left) kms_atomic (crtc-invalid-params)
[151.656318] Starting subtest: crtc-invalid-params
[151.657284] Starting dynamic subtest: pipe-A-DP-3
[152.234647] Dynamic subtest pipe-A-DP-3: SUCCESS (0.576s)
[152.235898] Subtest crtc-invalid-params: SUCCESS (0.578s)
[152.555322] [022/130] (866s left) syncobj_timeline (invalid-single-wait-all-unsubmitted)
[152.636081] Starting subtest: invalid-single-wait-all-unsubmitted
[152.637055] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s)
[152.782301] [023/130] (866s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled)
[152.869528] Starting subtest: yf-tiled-ccs-to-yf-tiled
[152.871593] Subtest yf-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[153.134470] [024/130] (866s left) gem_exec_balancer (parallel-keep-submit-fence)
[153.525100] Starting subtest: parallel-keep-submit-fence
[155.838258] Subtest parallel-keep-submit-fence: SUCCESS (2.313s)
[156.014697] [025/130] (863s left) prime_self_import (basic-with_one_bo)
[156.062599] Starting subtest: basic-with_one_bo
[156.117107] Subtest basic-with_one_bo: SUCCESS (0.055s)
[156.286606] [026/130] (863s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-onoff)
[156.487543] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-onoff
[156.489338] Subtest fbcpsr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[156.627131] [027/130] (863s left) prime_self_import (basic-llseek-size)
[156.673979] Starting subtest: basic-llseek-size
[156.706179] Subtest basic-llseek-size: SUCCESS (0.033s)
[156.839940] [028/130] (862s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[157.043305] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[157.045069] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[157.250176] [029/130] (862s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[157.330191] Starting subtest: single-wait-for-submit-unsubmitted
[157.438601] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.108s)
[157.566992] [030/130] (862s left) kms_draw_crc (draw-method-pwrite)
[157.757936] Starting subtest: draw-method-pwrite
[157.758864] Starting dynamic subtest: xrgb8888-untiled
[158.203890] Dynamic subtest xrgb8888-untiled: SUCCESS (0.447s)
[158.214370] Starting dynamic subtest: rgb565-untiled
[158.621515] Dynamic subtest rgb565-untiled: SUCCESS (0.416s)
[158.633300] Starting dynamic subtest: xrgb2101010-untiled
[158.987955] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.365s)
[158.999547] Starting dynamic subtest: xbgr16161616f-untiled
[159.420166] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.432s)
[159.429437] Starting dynamic subtest: xrgb8888-xtiled
[159.987238] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.567s)
[159.998199] Starting dynamic subtest: rgb565-xtiled
[160.570485] Dynamic subtest rgb565-xtiled: SUCCESS (0.583s)
[160.581256] Starting dynamic subtest: xrgb2101010-xtiled
[161.103643] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.533s)
[161.113544] Starting dynamic subtest: xbgr16161616f-xtiled
[161.720372] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.616s)
[161.730291] Starting dynamic subtest: xrgb8888-4tiled
[162.154148] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.433s)
[162.167354] Starting dynamic subtest: rgb565-4tiled
[162.488786] Dynamic subtest rgb565-4tiled: SUCCESS (0.333s)
[162.525189] Starting dynamic subtest: xrgb2101010-4tiled
[162.937281] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.448s)
[162.947324] Starting dynamic subtest: xbgr16161616f-4tiled
[163.570655] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.633s)
[163.571594] Subtest draw-method-pwrite: SUCCESS (5.813s)
[163.705859] [031/130] (856s left) kms_plane_scaling (invalid-parameters)
[163.902337] Starting subtest: invalid-parameters
[163.903306] Starting dynamic subtest: less-than-1-height-src
[163.918115] Dynamic subtest less-than-1-height-src: SUCCESS (0.015s)
[163.927122] Starting dynamic subtest: less-than-1-width-src
[163.932442] Dynamic subtest less-than-1-width-src: SUCCESS (0.015s)
[163.933319] Subtest invalid-parameters: SUCCESS (0.030s)
[164.116445] [032/130] (855s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[164.318958] Starting subtest: flip-vs-cursor-varying-size
[176.750477] Subtest flip-vs-cursor-varying-size: SUCCESS (12.430s)
[177.067716] [033/130] (843s left) kms_cursor_legacy (single-bo)
[177.260979] Starting subtest: single-bo
[177.261954] Starting dynamic subtest: pipe-A
[182.641484] Dynamic subtest pipe-A: SUCCESS (5.380s)
[182.651347] Starting dynamic subtest: pipe-B
[188.021129] Dynamic subtest pipe-B: SUCCESS (5.379s)
[188.031128] Starting dynamic subtest: pipe-C
[193.405197] Dynamic subtest pipe-C: SUCCESS (5.383s)
[193.414195] Starting dynamic subtest: pipe-D
[198.784049] Dynamic subtest pipe-D: SUCCESS (5.378s)
[198.793259] Starting dynamic subtest: all-pipes
[204.163522] Dynamic subtest all-pipes: SUCCESS (5.379s)
[204.164422] Subtest single-bo: SUCCESS (26.901s)
[204.290984] [034/130] (815s left) gem_mmap_offset (partial-unmap)
[204.369101] Starting subtest: partial-unmap
[204.370032] Starting dynamic subtest: lmem0
[204.379745] Dynamic subtest lmem0: SUCCESS (0.012s)
[204.389183] Starting dynamic subtest: smem0
[204.390484] Dynamic subtest smem0: SUCCESS (0.004s)
[204.391537] Subtest partial-unmap: SUCCESS (0.016s)
[204.582989] [035/130] (815s left) i915_pm_rps (min-max-config-idle)
[204.669032] Starting subtest: min-max-config-idle
[204.670936] Subtest min-max-config-idle: SKIP (0.001s)
[204.797196] [036/130] (815s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[204.991701] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[204.993467] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[205.188685] [037/130] (815s left) gen9_exec_parse (basic-rejected)
[205.280933] Subtest basic-rejected: SKIP (0.000s)
[205.379098] [038/130] (815s left) gem_mmap_gtt (fault-concurrent)
[205.464987] Subtest fault-concurrent: SKIP (0.000s)
[205.543610] [039/130] (815s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[205.744280] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[205.746077] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s)
[205.939633] [040/130] (814s left) gem_spin_batch (engines)
[206.027138] Starting subtest: engines
[206.028112] Starting dynamic subtest: rcs0
[209.290287] Dynamic subtest rcs0: SUCCESS (3.260s)
[209.301495] Starting dynamic subtest: bcs0
[212.524608] Dynamic subtest bcs0: SUCCESS (3.233s)
[212.535633] Starting dynamic subtest: vcs0
[215.757474] Dynamic subtest vcs0: SUCCESS (3.232s)
[215.769458] Starting dynamic subtest: vcs1
[218.992632] Dynamic subtest vcs1: SUCCESS (3.234s)
[219.002795] Starting dynamic subtest: vecs0
[222.226669] Dynamic subtest vecs0: SUCCESS (3.232s)
[222.237173] Starting dynamic subtest: vecs1
[225.460619] Dynamic subtest vecs1: SUCCESS (3.232s)
[225.472587] Starting dynamic subtest: ccs0
[228.694546] Dynamic subtest ccs0: SUCCESS (3.232s)
[228.696202] Subtest engines: SUCCESS (22.665s)
[228.990410] [041/130] (791s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy)
[229.180513] Starting subtest: 2x-long-cursor-vs-flip-legacy
[229.183417] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.002s)
[229.343908] [042/130] (791s left) gem_exec_balancer (bonded-dual)
[229.432529] Starting subtest: bonded-dual
[229.434491] Subtest bonded-dual: SKIP (0.000s)
[229.811484] [043/130] (790s left) prime_vgem (wait)
[229.915054] Starting subtest: wait
[229.915960] Starting dynamic subtest: rcs0
[229.981561] Dynamic subtest rcs0: SUCCESS (0.066s)
[229.992424] Starting dynamic subtest: bcs0
[230.045671] Dynamic subtest bcs0: SUCCESS (0.064s)
[230.060960] Starting dynamic subtest: vcs0
[230.089575] Dynamic subtest vcs0: SUCCESS (0.043s)
[230.102634] Starting dynamic subtest: vcs1
[230.128179] Dynamic subtest vcs1: SUCCESS (0.038s)
[230.140360] Starting dynamic subtest: vecs0
[230.170187] Dynamic subtest vecs0: SUCCESS (0.042s)
[230.183792] Starting dynamic subtest: vecs1
[230.212035] Dynamic subtest vecs1: SUCCESS (0.041s)
[230.231191] Starting dynamic subtest: ccs0
[230.254128] Dynamic subtest ccs0: SUCCESS (0.041s)
[230.255412] Subtest wait: SUCCESS (0.339s)
[230.440162] [044/130] (790s left) gem_partial_pwrite_pread (write-display)
[230.527441] Subtest write-display: SKIP (0.000s)
[230.604600] [045/130] (790s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[230.802725] Starting subtest: psr-2p-primscrn-cur-indfb-move
[230.804428] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[230.993553] [046/130] (790s left) kms_invalid_mode (uint-max-clock)
[231.185284] Starting subtest: uint-max-clock
[231.186267] Starting dynamic subtest: pipe-A-DP-3
[231.270675] Dynamic subtest pipe-A-DP-3: SUCCESS (0.085s)
[231.284786] Starting dynamic subtest: pipe-B-DP-3
[231.286027] Dynamic subtest pipe-B-DP-3: SUCCESS (0.001s)
[231.298356] Starting dynamic subtest: pipe-C-DP-3
[231.299280] Dynamic subtest pipe-C-DP-3: SUCCESS (0.001s)
[231.311592] Starting dynamic subtest: pipe-D-DP-3
[231.312525] Dynamic subtest pipe-D-DP-3: SUCCESS (0.001s)
[231.313461] Subtest uint-max-clock: SUCCESS (0.093s)
[231.552756] [047/130] (789s left) kms_flip (flip-vs-modeset-vs-hang)
[231.746069] Starting subtest: flip-vs-modeset-vs-hang
[231.748186] Starting dynamic subtest: A-DP3
[282.498682] Dynamic subtest A-DP3: SUCCESS (50.737s)
[282.508522] Starting dynamic subtest: D-DP3
[332.470673] Dynamic subtest D-DP3: SUCCESS (49.983s)
[332.471595] Subtest flip-vs-modeset-vs-hang: SUCCESS (100.724s)
[332.711497] [048/130] (688s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180)
[332.916431] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180
[334.195198] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.278s)
[334.381365] [049/130] (686s left) gem_ppgtt (flink-and-close-vma-leak)
[334.469489] Starting subtest: flink-and-close-vma-leak
[334.542965] Subtest flink-and-close-vma-leak: SUCCESS (0.073s)
[334.707365] [050/130] (686s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[334.901535] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt
[334.903223] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[335.093883] [051/130] (686s left) kms_prop_blob (blob-prop-core)
[335.171056] Starting subtest: blob-prop-core
[335.172212] Subtest blob-prop-core: SUCCESS (0.000s)
[335.327300] [052/130] (686s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-render)
[335.529054] Starting subtest: fbcpsr-rgb565-draw-render
[335.530884] Subtest fbcpsr-rgb565-draw-render: SKIP (0.000s)
[335.707237] [053/130] (685s left) kms_big_fb (4-tiled-32bpp-rotate-90)
[335.907586] Starting subtest: 4-tiled-32bpp-rotate-90
[335.961513] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.053s)
[336.193729] [054/130] (685s left) kms_content_protection (dp-mst-lic-type-1)
[336.451416] Starting subtest: dp-mst-lic-type-1
[336.453560] Subtest dp-mst-lic-type-1: SKIP (0.000s)
[336.659999] [055/130] (684s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[336.739233] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[336.740194] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.001s)
[336.907561] [056/130] (684s left) gem_huc_copy (huc-copy)
[337.022639] Starting subtest: huc-copy
[337.028541] Subtest huc-copy: SUCCESS (0.006s)
[337.240927] [057/130] (684s left) kms_cursor_crc (cursor-offscreen-64x21)
[337.595101] Starting subtest: cursor-offscreen-64x21
[337.599427] Starting dynamic subtest: pipe-A-DP-3
[340.143113] Dynamic subtest pipe-A-DP-3: SUCCESS (2.542s)
[340.191294] Starting dynamic subtest: pipe-D-DP-3
[342.676440] Dynamic subtest pipe-D-DP-3: SUCCESS (2.493s)
[342.677559] Subtest cursor-offscreen-64x21: SUCCESS (5.081s)
[343.220444] [058/130] (678s left) gem_exec_reloc (basic-write-wc-noreloc)
[343.302280] Subtest basic-write-wc-noreloc: SKIP (0.000s)
[343.433349] [059/130] (678s left) kms_psr (fbc-psr-cursor-render)
[343.628247] Subtest fbc-psr-cursor-render: SKIP (0.000s)
[343.694443] [060/130] (678s left) gem_create (create-massive)
[343.772364] Starting subtest: create-massive
[343.773351] Subtest create-massive: SUCCESS (0.000s)
[344.064999] [061/130] (678s left) i915_suspend (sysfs-reader)
[344.154122] Starting subtest: sysfs-reader
[365.610680] Subtest sysfs-reader: SUCCESS (5.717s)
[365.663988] [062/130] (656s left) kms_chamelium_frames (vga-frame-dump)
[365.947993] Subtest vga-frame-dump: SKIP (0.000s)
[366.135008] [063/130] (656s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[366.331674] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[366.333334] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[366.518093] [064/130] (655s left) gem_exec_schedule (out-order)
[366.611210] Starting subtest: out-order
[366.612187] Starting dynamic subtest: rcs0
[366.896947] Dynamic subtest rcs0: SUCCESS (0.285s)
[366.908415] Starting dynamic subtest: bcs0
[367.103700] Dynamic subtest bcs0: SUCCESS (0.206s)
[367.115216] Starting dynamic subtest: vcs0
[367.314017] Dynamic subtest vcs0: SUCCESS (0.210s)
[367.325710] Starting dynamic subtest: vcs1
[367.528555] Dynamic subtest vcs1: SUCCESS (0.214s)
[367.540084] Starting dynamic subtest: vecs0
[367.742643] Dynamic subtest vecs0: SUCCESS (0.213s)
[367.754079] Starting dynamic subtest: vecs1
[367.953443] Dynamic subtest vecs1: SUCCESS (0.210s)
[367.965015] Starting dynamic subtest: ccs0
[368.168046] Dynamic subtest ccs0: SUCCESS (0.214s)
[368.169186] Subtest out-order: SUCCESS (1.556s)
[368.773676] [065/130] (653s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[368.969718] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[369.030969] [066/130] (653s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[369.224677] Starting subtest: fbc-rgb101010-draw-blt
[372.103782] Subtest fbc-rgb101010-draw-blt: SUCCESS (2.880s)
[372.302173] [067/130] (650s left) kms_cursor_crc (cursor-sliding-256x256)
[372.708813] Starting subtest: cursor-sliding-256x256
[372.713417] Starting dynamic subtest: pipe-A-DP-3
[377.117661] Dynamic subtest pipe-A-DP-3: SUCCESS (4.404s)
[377.169892] Starting dynamic subtest: pipe-D-DP-3
[381.513520] Dynamic subtest pipe-D-DP-3: SUCCESS (4.355s)
[381.514433] Subtest cursor-sliding-256x256: SUCCESS (8.805s)
[381.928602] [068/130] (640s left) gem_exec_schedule (submit-golden-slice)
[382.022756] Starting subtest: submit-golden-slice
[382.023790] Starting dynamic subtest: rcs0
[382.102310] Dynamic subtest rcs0: SUCCESS (0.079s)
[382.114296] Starting dynamic subtest: bcs0
[382.154955] Dynamic subtest bcs0: SUCCESS (0.052s)
[382.167427] Starting dynamic subtest: vcs0
[382.207388] Dynamic subtest vcs0: SUCCESS (0.052s)
[382.219198] Starting dynamic subtest: vcs1
[382.259958] Dynamic subtest vcs1: SUCCESS (0.052s)
[382.271522] Starting dynamic subtest: vecs0
[382.311589] Dynamic subtest vecs0: SUCCESS (0.051s)
[382.323495] Starting dynamic subtest: vecs1
[382.364456] Dynamic subtest vecs1: SUCCESS (0.052s)
[382.376172] Starting dynamic subtest: ccs0
[382.418238] Dynamic subtest ccs0: SUCCESS (0.053s)
[382.419271] Subtest submit-golden-slice: SUCCESS (0.396s)
[382.904461] [069/130] (639s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[382.981968] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[383.089276] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.106s)
[383.219280] [070/130] (639s left) syncobj_timeline (wait-all-snapshot)
[383.299039] Starting subtest: wait-all-snapshot
[383.382242] Subtest wait-all-snapshot: SUCCESS (0.082s)
[383.571189] [071/130] (639s left) gem_unfence_active_buffers
[383.831242] [072/130] (639s left) api_intel_bb (render)
[383.906987] Starting subtest: render
[383.907904] Starting dynamic subtest: render-none-512
[383.955159] Dynamic subtest render-none-512: SUCCESS (0.049s)
[383.967612] Starting dynamic subtest: render-none-1024
[384.028020] Dynamic subtest render-none-1024: SUCCESS (0.072s)
[384.039629] Starting dynamic subtest: render-x-512
[384.046967] Dynamic subtest render-x-512: SUCCESS (0.018s)
[384.059021] Starting dynamic subtest: render-x-1024
[384.116789] Dynamic subtest render-x-1024: SUCCESS (0.069s)
[384.128381] Starting dynamic subtest: render-y-512
[384.135538] Dynamic subtest render-y-512: SUCCESS (0.018s)
[384.147213] Starting dynamic subtest: render-y-1024
[384.199283] Dynamic subtest render-y-1024: SUCCESS (0.063s)
[384.200244] Subtest render: SUCCESS (0.293s)
[384.361759] [073/130] (638s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite)
[384.557653] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite
[387.106478] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (2.550s)
[387.327599] [074/130] (635s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[387.521472] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.000s)
[387.585033] [075/130] (635s left) api_intel_allocator (simple-allocator)
[387.662005] Starting subtest: simple-allocator
[387.662992] Starting dynamic subtest: basic
[387.692847] Dynamic subtest basic: SUCCESS (0.031s)
[387.704806] Starting dynamic subtest: parallel-one
[387.872944] Dynamic subtest parallel-one: SUCCESS (0.179s)
[387.884547] Starting dynamic subtest: print
[387.885402] Dynamic subtest print: SUCCESS (0.000s)
[387.897411] Starting dynamic subtest: reuse
[387.898636] Dynamic subtest reuse: SUCCESS (0.000s)
[387.910437] Starting dynamic subtest: reserve
[387.911621] Dynamic subtest reserve: SUCCESS (0.000s)
[387.923006] Starting dynamic subtest: fork-reopen-allocator
[387.924266] Dynamic subtest fork-reopen-allocator: SUCCESS (0.014s)
[387.925384] Subtest simple-allocator: SUCCESS (0.227s)
[388.075636] [076/130] (635s left) kms_pm_dc (dc3co-vpb-simulation)
[389.281982] Starting subtest: dc3co-vpb-simulation
[389.283768] Subtest dc3co-vpb-simulation: SKIP (0.000s)
[389.406704] [077/130] (633s left) gem_render_tiled_blits (basic)
[389.491746] Subtest basic: SKIP (0.000s)
[389.569479] [078/130] (633s left) kms_psr2_sf (psr2-overlay-plane-update-sf-dmg-area)
[389.764846] Subtest psr2-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[389.820364] [079/130] (633s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[390.017669] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[390.019315] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[390.224566] [080/130] (633s left) kms_big_fb (x-tiled-16bpp-rotate-180)
[390.423390] Starting subtest: x-tiled-16bpp-rotate-180
[392.290155] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.866s)
[392.528686] [081/130] (631s left) syncobj_wait (invalid-multi-wait-all-unsubmitted)
[392.610140] Starting subtest: invalid-multi-wait-all-unsubmitted
[392.611174] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[392.779747] [082/130] (630s left) gem_ctx_bad_destroy (invalid-default-ctx)
[392.857421] Starting subtest: invalid-default-ctx
[392.858325] Subtest invalid-default-ctx: SUCCESS (0.000s)
[393.010497] [083/130] (630s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[393.208788] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[393.210544] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[393.408067] [084/130] (630s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[393.603267] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[393.787629] [085/130] (630s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs)
[393.980475] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs
[393.982817] Starting dynamic subtest: pipe-A-DP-3
[393.986242] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[393.997741] Starting dynamic subtest: pipe-B-DP-3
[394.001213] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[394.012466] Starting dynamic subtest: pipe-C-DP-3
[394.015881] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[394.027108] Starting dynamic subtest: pipe-D-DP-3
[394.030666] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[394.032306] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[394.455291] [086/130] (629s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[394.652762] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[394.653726] Starting dynamic subtest: pipe-A-DP-3
[394.663001] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[394.674734] Starting dynamic subtest: pipe-B-DP-3
[394.684105] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[394.695589] Starting dynamic subtest: pipe-C-DP-3
[394.704792] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[394.716369] Starting dynamic subtest: pipe-D-DP-3
[394.727951] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[394.730181] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SKIP (0.005s)
[395.142234] [087/130] (628s left) gem_exec_whisper (basic-fds-priority)
[395.233768] Starting subtest: basic-fds-priority
[417.903263] Subtest basic-fds-priority: SUCCESS (22.665s)
[418.201757] [088/130] (605s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-pwrite)
[418.397425] Starting subtest: psr-1p-offscreen-pri-indfb-draw-pwrite
[418.399149] Subtest psr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s)
[418.598244] [089/130] (605s left) perf_pmu (busy-start)
[418.668729] Starting subtest: busy-start
[418.669759] Starting dynamic subtest: rcs0
[421.249462] Dynamic subtest rcs0: SUCCESS (2.579s)
[421.267216] Starting dynamic subtest: bcs0
[423.799504] Dynamic subtest bcs0: SUCCESS (2.547s)
[423.816462] Starting dynamic subtest: vcs0
[426.349402] Dynamic subtest vcs0: SUCCESS (2.547s)
[426.367031] Starting dynamic subtest: vcs1
[428.899502] Dynamic subtest vcs1: SUCCESS (2.547s)
[428.918074] Starting dynamic subtest: vecs0
[431.449413] Dynamic subtest vecs0: SUCCESS (2.547s)
[431.467015] Starting dynamic subtest: vecs1
[433.998254] Dynamic subtest vecs1: SUCCESS (2.546s)
[434.013443] Starting dynamic subtest: ccs0
[436.546549] Dynamic subtest ccs0: SUCCESS (2.546s)
[436.548485] Subtest busy-start: SUCCESS (17.878s)
[436.773871] [090/130] (587s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[436.962342] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[436.964672] Starting dynamic subtest: pipe-A-valid-mode
[437.052306] Dynamic subtest pipe-A-valid-mode: SKIP (0.088s)
[437.054067] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.089s)
[437.251915] [091/130] (587s left) kms_selftest (drm_damage_helper)
[437.300419] Starting subtest: drm_damage_helper
[437.320790] Starting dynamic subtest: drm_test_damage_iter_no_damage
[437.387446] Dynamic subtest drm_test_damage_iter_no_damage: SUCCESS (0.067s)
[437.407084] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src
[437.475201] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src: SUCCESS (0.086s)
[437.523868] Starting dynamic subtest: drm_test_damage_iter_no_damage_src_moved
[437.584095] Dynamic subtest drm_test_damage_iter_no_damage_src_moved: SUCCESS (0.106s)
[437.597258] Starting dynamic subtest: drm_test_damage_iter_no_damage_fractional_src_moved
[437.659391] Dynamic subtest drm_test_damage_iter_no_damage_fractional_src_moved: SUCCESS (0.074s)
[437.707514] Starting dynamic subtest: drm_test_damage_iter_no_damage_not_visible
[437.737310] Dynamic subtest drm_test_damage_iter_no_damage_not_visible: SUCCESS (0.076s)
[437.756123] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_crtc
[437.829983] Dynamic subtest drm_test_damage_iter_no_damage_no_crtc: SUCCESS (0.089s)
[437.874748] Starting dynamic subtest: drm_test_damage_iter_no_damage_no_fb
[437.927540] Dynamic subtest drm_test_damage_iter_no_damage_no_fb: SUCCESS (0.097s)
[437.975237] Starting dynamic subtest: drm_test_damage_iter_simple_damage
[438.018022] Dynamic subtest drm_test_damage_iter_simple_damage: SUCCESS (0.088s)
[438.048896] Starting dynamic subtest: drm_test_damage_iter_single_damage
[438.091074] Dynamic subtest drm_test_damage_iter_single_damage: SUCCESS (0.072s)
[438.122514] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_src
[438.175852] Dynamic subtest drm_test_damage_iter_single_damage_intersect_src: SUCCESS (0.082s)
[438.217021] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_src
[438.245425] Dynamic subtest drm_test_damage_iter_single_damage_outside_src: SUCCESS (0.068s)
[438.263423] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src
[438.315942] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src: SUCCESS (0.070s)
[438.329496] Starting dynamic subtest: drm_test_damage_iter_single_damage_intersect_fractional_src
[438.395265] Dynamic subtest drm_test_damage_iter_single_damage_intersect_fractional_src: SUCCESS (0.077s)
[438.440604] Starting dynamic subtest: drm_test_damage_iter_single_damage_outside_fractional_src
[438.492084] Dynamic subtest drm_test_damage_iter_single_damage_outside_fractional_src: SUCCESS (0.095s)
[438.535137] Starting dynamic subtest: drm_test_damage_iter_single_damage_src_moved
[438.565357] Dynamic subtest drm_test_damage_iter_single_damage_src_moved: SUCCESS (0.072s)
[438.585301] Starting dynamic subtest: drm_test_damage_iter_single_damage_fractional_src_moved
[438.639092] Dynamic subtest drm_test_damage_iter_single_damage_fractional_src_moved: SUCCESS (0.072s)
[438.685598] Starting dynamic subtest: drm_test_damage_iter_damage
[438.737115] Dynamic subtest drm_test_damage_iter_damage: SUCCESS (0.095s)
[438.753708] Starting dynamic subtest: drm_test_damage_iter_damage_one_intersect
[438.825430] Dynamic subtest drm_test_damage_iter_damage_one_intersect: SUCCESS (0.088s)
[438.840028] Starting dynamic subtest: drm_test_damage_iter_damage_one_outside
[438.917170] Dynamic subtest drm_test_damage_iter_damage_one_outside: SUCCESS (0.089s)
[438.966002] Starting dynamic subtest: drm_test_damage_iter_damage_src_moved
[439.010976] Dynamic subtest drm_test_damage_iter_damage_src_moved: SUCCESS (0.091s)
[439.047398] Starting dynamic subtest: drm_test_damage_iter_damage_not_visible
[439.100410] Dynamic subtest drm_test_damage_iter_damage_not_visible: SUCCESS (0.088s)
[439.102345] Subtest drm_damage_helper: SUCCESS (1.800s)
[439.339002] [092/130] (585s left) gem_exec_schedule (smoketest-all)
[439.433615] Starting subtest: smoketest-all
[471.742873] Subtest smoketest-all: SUCCESS (32.302s)
[472.173111] [093/130] (552s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[472.376816] Starting subtest: yf-tiled-8bpp-rotate-270
[472.378584] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[472.572156] [094/130] (552s left) perf (invalid-create-userspace-config)
[472.969704] Starting subtest: invalid-create-userspace-config
[472.970645] Subtest invalid-create-userspace-config: SUCCESS (0.002s)
[473.024366] [095/130] (551s left) dmabuf_sync_file (export-before-signal)
[473.091036] Starting subtest: export-before-signal
[473.091969] Subtest export-before-signal: SUCCESS (0.001s)
[473.223005] [096/130] (551s left) gem_sync (basic-all)
[473.312116] Starting subtest: basic-all
[475.396108] Subtest basic-all: SUCCESS (2.084s)
[475.643485] [097/130] (549s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[475.844806] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[475.846455] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[476.060569] [098/130] (548s left) gem_ctx_persistence (legacy-engines-hostile)
[476.153412] Starting subtest: legacy-engines-hostile
[476.154346] Starting dynamic subtest: render
[476.346041] Dynamic subtest render: SUCCESS (0.191s)
[476.394937] Starting dynamic subtest: bsd1
[476.409303] Dynamic subtest bsd1: SUCCESS (0.059s)
[476.429120] Starting dynamic subtest: bsd2
[476.510133] Dynamic subtest bsd2: SUCCESS (0.099s)
[476.559872] Starting dynamic subtest: blt
[476.584144] Dynamic subtest blt: SUCCESS (0.070s)
[476.602984] Starting dynamic subtest: vebox
[476.683041] Dynamic subtest vebox: SUCCESS (0.097s)
[476.685164] Subtest legacy-engines-hostile: SUCCESS (0.531s)
[476.895108] [099/130] (548s left) kms_vrr (flipline)
[477.088730] Starting subtest: flipline
[477.091771] Subtest flipline: SKIP (0.000s)
[477.272197] [100/130] (547s left) kms_pm_lpsp (screens-disabled)
[478.464818] Starting subtest: screens-disabled
[478.466634] Subtest screens-disabled: SKIP (0.000s)
[478.629158] [101/130] (546s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[478.826970] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[478.828822] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[479.002747] [102/130] (546s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[479.204814] Starting subtest: y-tiled-64bpp-rotate-0
[479.206787] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[479.395022] [103/130] (545s left) kms_chamelium_audio (dp-audio-edid)
[479.686478] Subtest dp-audio-edid: SKIP (0.000s)
[479.845583] [104/130] (545s left) gem_exec_fence (parallel)
[480.074631] Starting subtest: parallel
[480.076502] Starting dynamic subtest: rcs0
[482.229536] Dynamic subtest rcs0: SUCCESS (2.154s)
[482.242210] Starting dynamic subtest: bcs0
[484.383197] Dynamic subtest bcs0: SUCCESS (2.152s)
[484.396063] Starting dynamic subtest: vcs0
[486.533409] Dynamic subtest vcs0: SUCCESS (2.150s)
[486.546416] Starting dynamic subtest: vcs1
[488.684713] Dynamic subtest vcs1: SUCCESS (2.150s)
[488.697959] Starting dynamic subtest: vecs0
[490.834756] Dynamic subtest vecs0: SUCCESS (2.149s)
[490.848005] Starting dynamic subtest: vecs1
[492.987009] Dynamic subtest vecs1: SUCCESS (2.151s)
[493.000075] Starting dynamic subtest: ccs0
[495.135889] Dynamic subtest ccs0: SUCCESS (2.148s)
[495.137121] Subtest parallel: SUCCESS (15.062s)
[495.959959] [105/130] (529s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[496.163983] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[496.165773] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[496.339298] [106/130] (529s left) kms_flip (2x-plain-flip)
[496.529007] Starting subtest: 2x-plain-flip
[496.544420] Subtest 2x-plain-flip: SKIP (0.015s)
[496.749378] [107/130] (528s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling)
[496.944802] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling
[496.947035] Starting dynamic subtest: pipe-A-valid-mode
[499.236796] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.290s)
[499.238265] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.292s)
[499.563507] [108/130] (526s left) sw_sync (sync_busy)
[499.611661] Starting subtest: sync_busy
[499.614594] Subtest sync_busy: SUCCESS (0.003s)
[499.743238] [109/130] (526s left) kms_big_fb (linear-64bpp-rotate-90)
[499.942863] Starting subtest: linear-64bpp-rotate-90
[499.997763] Subtest linear-64bpp-rotate-90: SKIP (0.054s)
[500.228459] [110/130] (525s left) kms_rmfb (close-fd)
[500.421229] Starting subtest: close-fd
[500.422157] Starting dynamic subtest: pipe-A-DP-3
[500.592386] Dynamic subtest pipe-A-DP-3: SUCCESS (0.171s)
[500.609437] Starting dynamic subtest: pipe-B-DP-3
[500.881240] Dynamic subtest pipe-B-DP-3: SUCCESS (0.286s)
[500.896499] Starting dynamic subtest: pipe-C-DP-3
[501.178364] Dynamic subtest pipe-C-DP-3: SUCCESS (0.295s)
[501.192608] Starting dynamic subtest: pipe-D-DP-3
[501.469081] Dynamic subtest pipe-D-DP-3: SUCCESS (0.289s)
[501.470081] Subtest close-fd: SUCCESS (1.049s)
[501.780067] [111/130] (524s left) kms_pipe_stress (stress-xrgb8888-xtiled)
[501.978042] Starting subtest: stress-xrgb8888-xtiled
[509.846247] Subtest stress-xrgb8888-xtiled: SUCCESS (7.868s)
[510.127649] [112/130] (516s left) gem_exec_fence (syncobj-wait)
[510.629978] Starting subtest: syncobj-wait
[510.752132] Subtest syncobj-wait: SUCCESS (0.122s)
[511.171211] [113/130] (515s left) gem_softpin (noreloc-interruptible)
[511.258484] Starting subtest: noreloc-interruptible
[516.761721] Subtest noreloc-interruptible: SUCCESS (5.503s)
[516.967007] [114/130] (509s left) fbdev (nullptr)
[517.040993] Starting subtest: nullptr
[517.041982] Subtest nullptr: SUCCESS (0.000s)
[517.147809] [115/130] (509s left) kms_sharpness_filter (filter-tap)
[517.340255] Starting subtest: filter-tap
[517.345433] Subtest filter-tap: SKIP (0.001s)
[517.518033] [116/130] (508s left) gem_exec_params (no-vebox)
[517.602869] Starting subtest: no-vebox
[517.605184] Subtest no-vebox: SUCCESS (0.001s)
[517.808276] [117/130] (508s left) kms_lease (master-vs-lease)
[518.009279] Starting subtest: master-vs-lease
[518.011449] Subtest master-vs-lease: SUCCESS (0.002s)
[518.204734] [118/130] (508s left) gem_sync (basic-many-each)
[518.308312] Starting subtest: basic-many-each
[520.722957] Subtest basic-many-each: SUCCESS (2.414s)
[521.027674] [119/130] (505s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[521.105287] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[521.209824] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.104s)
[521.340211] [120/130] (505s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[521.530350] Starting subtest: bad-pixel-format-y-tiled-ccs
[521.532835] Starting dynamic subtest: pipe-A-DP-3
[521.541574] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[521.554540] Starting dynamic subtest: pipe-B-DP-3
[521.563096] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[521.575938] Starting dynamic subtest: pipe-C-DP-3
[521.584260] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[521.597252] Starting dynamic subtest: pipe-D-DP-3
[521.607616] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[521.609917] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.007s)
[522.006782] [121/130] (504s left) kms_flip (flip-vs-wf_vblank-interruptible)
[522.205402] Starting subtest: flip-vs-wf_vblank-interruptible
[522.210338] Starting dynamic subtest: A-DP3
[523.312045] Dynamic subtest A-DP3: SUCCESS (1.102s)
[523.329376] Starting dynamic subtest: B-DP3
[524.345568] Dynamic subtest B-DP3: SUCCESS (1.032s)
[524.360975] Starting dynamic subtest: C-DP3
[525.380351] Dynamic subtest C-DP3: SUCCESS (1.033s)
[525.395541] Starting dynamic subtest: D-DP3
[526.413593] Dynamic subtest D-DP3: SUCCESS (1.032s)
[526.416077] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (4.210s)
[526.749747] [122/130] (500s left) gem_mmap_offset (perf)
[526.829749] Starting subtest: perf
[526.830746] Starting dynamic subtest: lmem0
[527.116179] Dynamic subtest lmem0: SUCCESS (0.286s)
[527.130104] Starting dynamic subtest: smem0
[527.134685] Dynamic subtest smem0: SUCCESS (0.003s)
[527.135854] Subtest perf: SUCCESS (0.291s)
[527.346078] [123/130] (499s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render)
[527.544910] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render
[527.546779] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[527.749187] [124/130] (499s left) kms_plane_multiple (2x-tiling-yf)
[527.938620] Starting subtest: 2x-tiling-yf
[527.940423] Subtest 2x-tiling-yf: SKIP (0.000s)
[528.066679] [125/130] (499s left) perf_pmu (rc6)
[528.137029] Starting subtest: rc6
[528.138001] Starting dynamic subtest: gt0
[534.491730] Dynamic subtest gt0: SUCCESS (6.353s)
[534.508303] Starting dynamic subtest: runtime-pm-gt0
[542.578127] Dynamic subtest runtime-pm-gt0: SUCCESS (8.082s)
[542.622274] Starting dynamic subtest: runtime-pm-long-gt0
[555.208215] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.625s)
[555.223198] Starting dynamic subtest: other-idle-gt0
[555.225055] Dynamic subtest other-idle-gt0: SKIP (0.000s)
[555.226026] Subtest rc6: SUCCESS (27.073s)
[555.438453] [126/130] (471s left) gem_render_copy (yf-tiled-ccs-to-y-tiled-ccs)
[555.523627] Starting subtest: yf-tiled-ccs-to-y-tiled-ccs
[555.525957] Subtest yf-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[555.703570] [127/130] (471s left) kms_psr (fbc-pr-sprite-render)
[555.902058] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[555.955955] [128/130] (471s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[556.037214] Starting subtest: single-wait-for-submit-available-submitted
[556.038164] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s)
[556.108071] [129/130] (471s left) kms_rotation_crc (primary-x-tiled-reflect-x-180)
[556.299258] Starting subtest: primary-x-tiled-reflect-x-180
[566.710068] Subtest primary-x-tiled-reflect-x-180: SUCCESS (10.411s)
[567.034104] [130/130] (460s left) perf_pmu (rc6-all-gts)
[567.105342] Starting subtest: rc6-all-gts
[567.107186] Subtest rc6-all-gts: SKIP (0.000s)
[567.250103] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_cursor_crc
results: parsing output: 2/ for test: kms_vblank
results: parsing output: 3/ for test: gem_mmap_gtt
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: i915_hangman
results: parsing output: 6/ for test: gem_workarounds
results: parsing output: 7/ for test: kms_chamelium_hpd
results: parsing output: 8/ for test: kms_addfb_basic
results: parsing output: 9/ for test: gem_exec_params
results: parsing output: 10/ for test: gem_wait
results: parsing output: 11/ for test: sw_sync
results: parsing output: 12/ for test: gen9_exec_parse
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: kms_ccs
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: gem_userptr_blits
results: parsing output: 17/ for test: gem_ctx_persistence
results: parsing output: 18/ for test: kms_frontbuffer_tracking
results: parsing output: 19/ for test: kms_psr
results: parsing output: 20/ for test: kms_atomic
results: parsing output: 21/ for test: syncobj_timeline
results: parsing output: 22/ for test: gem_render_copy
results: parsing output: 23/ for test: gem_exec_balancer
results: parsing output: 24/ for test: prime_self_import
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: prime_self_import
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: syncobj_wait
results: parsing output: 29/ for test: kms_draw_crc
results: parsing output: 30/ for test: kms_plane_scaling
results: parsing output: 31/ for test: kms_cursor_legacy
results: parsing output: 32/ for test: kms_cursor_legacy
results: parsing output: 33/ for test: gem_mmap_offset
results: parsing output: 34/ for test: i915_pm_rps
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: gen9_exec_parse
results: parsing output: 37/ for test: gem_mmap_gtt
results: parsing output: 38/ for test: kms_big_fb
results: parsing output: 39/ for test: gem_spin_batch
results: parsing output: 40/ for test: kms_cursor_legacy
results: parsing output: 41/ for test: gem_exec_balancer
results: parsing output: 42/ for test: prime_vgem
results: parsing output: 43/ for test: gem_partial_pwrite_pread
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_invalid_mode
results: parsing output: 46/ for test: kms_flip
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: gem_ppgtt
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: kms_prop_blob
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: kms_content_protection
results: parsing output: 54/ for test: syncobj_timeline
results: parsing output: 55/ for test: gem_huc_copy
results: parsing output: 56/ for test: kms_cursor_crc
results: parsing output: 57/ for test: gem_exec_reloc
results: parsing output: 58/ for test: kms_psr
results: parsing output: 59/ for test: gem_create
results: parsing output: 60/ for test: i915_suspend
results: parsing output: 61/ for test: kms_chamelium_frames
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_exec_schedule
results: parsing output: 64/ for test: kms_psr2_sf
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_cursor_crc
results: parsing output: 67/ for test: gem_exec_schedule
results: parsing output: 68/ for test: syncobj_timeline
results: parsing output: 69/ for test: syncobj_timeline
results: parsing output: 70/ for test: gem_unfence_active_buffers
results: parsing output: 71/ for test: api_intel_bb
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: api_intel_allocator
results: parsing output: 75/ for test: kms_pm_dc
results: parsing output: 76/ for test: gem_render_tiled_blits
results: parsing output: 77/ for test: kms_psr2_sf
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_big_fb
results: parsing output: 80/ for test: syncobj_wait
results: parsing output: 81/ for test: gem_ctx_bad_destroy
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_addfb_basic
results: parsing output: 84/ for test: kms_ccs
results: parsing output: 85/ for test: kms_ccs
results: parsing output: 86/ for test: gem_exec_whisper
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: perf_pmu
results: parsing output: 89/ for test: kms_flip_scaled_crc
results: parsing output: 90/ for test: kms_selftest
results: parsing output: 91/ for test: gem_exec_schedule
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: perf
results: parsing output: 94/ for test: dmabuf_sync_file
results: parsing output: 95/ for test: gem_sync
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: gem_ctx_persistence
results: parsing output: 98/ for test: kms_vrr
results: parsing output: 99/ for test: kms_pm_lpsp
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: kms_chamelium_audio
results: parsing output: 103/ for test: gem_exec_fence
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_flip
results: parsing output: 106/ for test: kms_flip_scaled_crc
results: parsing output: 107/ for test: sw_sync
results: parsing output: 108/ for test: kms_big_fb
results: parsing output: 109/ for test: kms_rmfb
results: parsing output: 110/ for test: kms_pipe_stress
results: parsing output: 111/ for test: gem_exec_fence
results: parsing output: 112/ for test: gem_softpin
results: parsing output: 113/ for test: fbdev
results: parsing output: 114/ for test: kms_sharpness_filter
results: parsing output: 115/ for test: gem_exec_params
results: parsing output: 116/ for test: kms_lease
results: parsing output: 117/ for test: gem_sync
results: parsing output: 118/ for test: syncobj_wait
results: parsing output: 119/ for test: kms_ccs
results: parsing output: 120/ for test: kms_flip
results: parsing output: 121/ for test: gem_mmap_offset
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_plane_multiple
results: parsing output: 124/ for test: perf_pmu
results: parsing output: 125/ for test: gem_render_copy
results: parsing output: 126/ for test: kms_psr
results: parsing output: 127/ for test: syncobj_timeline
results: parsing output: 128/ for test: kms_rotation_crc
results: parsing output: 129/ for test: perf_pmu
Done.