[66.305735] Initializing watchdogs
[66.305806]   /dev/watchdog0
[66.319565] [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]
[66.323631] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[66.325833] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[66.329343] [001/130] (960s left) kms_chamelium_color (gamma)
[66.439646] Subtest gamma: SKIP (0.000s)
[66.480425] [002/130] (960s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-wc)
[66.579691] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-wc
[70.950746] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (4.384s)
[72.098213] [003/130] (954s left) perf_pmu (busy-no-semaphores)
[72.144785] Starting subtest: busy-no-semaphores
[72.147223] Starting dynamic subtest: rcs0
[72.769668] Dynamic subtest rcs0: SUCCESS (0.623s)
[72.779700] Starting dynamic subtest: bcs0
[73.316988] Dynamic subtest bcs0: SUCCESS (0.547s)
[73.327090] Starting dynamic subtest: vcs0
[73.866433] Dynamic subtest vcs0: SUCCESS (0.549s)
[73.875050] Starting dynamic subtest: vcs1
[75.416712] Dynamic subtest vcs1: SUCCESS (1.550s)
[75.427595] Starting dynamic subtest: vecs0
[77.407329] Dynamic subtest vecs0: SUCCESS (1.991s)
[77.416113] Starting dynamic subtest: ccs0
[79.385546] Dynamic subtest ccs0: SUCCESS (1.977s)
[79.388378] Subtest busy-no-semaphores: SUCCESS (7.245s)
[79.548617] [004/130] (947s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling)
[79.642660] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling
[79.645069] Starting dynamic subtest: pipe-A-default-mode
[80.825625] Dynamic subtest pipe-A-default-mode: SKIP (1.178s)
[80.829820] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.179s)
[81.011173] [005/130] (945s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-pwrite)
[81.110795] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-pwrite
[89.499302] Subtest psr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.391s)
[89.631530] [006/130] (937s left) gem_fenced_exec_thrash (no-spare-fences)
[89.700577] Subtest no-spare-fences: SKIP (0.000s)
[89.762205] [007/130] (937s left) gem_render_linear_blits (basic)
[89.814624] Starting subtest: basic
[89.837644] Subtest basic: SUCCESS (0.023s)
[89.945794] [008/130] (937s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc)
[90.037200] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc
[90.039613] Starting dynamic subtest: pipe-A-eDP-1
[90.063097] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[90.073182] Starting dynamic subtest: pipe-B-eDP-1
[90.094740] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[90.101920] Starting dynamic subtest: pipe-C-eDP-1
[90.123639] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[90.130967] Starting dynamic subtest: pipe-D-eDP-1
[90.153426] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[90.157860] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[92.363263] [009/130] (934s left) gem_userptr_blits (mmap-offset-banned)
[92.423059] Starting subtest: mmap-offset-banned
[92.425335] Starting dynamic subtest: wb
[92.427309] Dynamic subtest wb: SUCCESS (0.000s)
[92.436934] Starting dynamic subtest: wc
[92.439110] Dynamic subtest wc: SUCCESS (0.000s)
[92.446271] Starting dynamic subtest: uc
[92.448396] Dynamic subtest uc: SUCCESS (0.000s)
[92.450524] Subtest mmap-offset-banned: SUCCESS (0.001s)
[92.590636] [010/130] (934s left) kms_properties (crtc-properties-atomic)
[92.674533] Starting subtest: crtc-properties-atomic
[92.676496] Starting dynamic subtest: pipe-A-eDP-1
[93.153315] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.479s)
[93.164620] Starting dynamic subtest: pipe-B-eDP-1
[94.323792] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.165s)
[94.332664] Starting dynamic subtest: pipe-C-eDP-1
[95.444360] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.122s)
[95.453951] Starting dynamic subtest: pipe-D-eDP-1
[96.590266] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.145s)
[96.592665] Subtest crtc-properties-atomic: SUCCESS (3.915s)
[97.391228] [011/130] (929s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[97.488323] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[102.131749] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.647s)
[103.304420] [012/130] (923s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[103.364754] Starting subtest: x-tiled-to-vebox-yf-tiled
[103.368994] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[103.555414] [013/130] (923s left) gem_exec_create (madvise)
[103.622302] Starting subtest: madvise
[103.624638] Starting dynamic subtest: smem
[124.949221] Dynamic subtest smem: SUCCESS (21.324s)
[124.951728] Subtest madvise: SUCCESS (21.324s)
[126.095046] [014/130] (901s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt)
[126.202699] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt
[132.959696] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.759s)
[133.126203] [015/130] (894s left) gem_ctx_exec (basic-invalid-context)
[133.182021] Starting subtest: basic-invalid-context
[133.186550] Subtest basic-invalid-context: SUCCESS (0.005s)
[133.346251] [016/130] (894s left) i915_pm_freq_mult (media-freq)
[133.404154] Starting subtest: media-freq
[133.406576] Starting dynamic subtest: gt0
[133.411133] Dynamic subtest gt0: SKIP (0.000s)
[133.420171] Starting dynamic subtest: gt1
[133.424575] Dynamic subtest gt1: SKIP (0.000s)
[133.428983] Subtest media-freq: SKIP (0.001s)
[133.547233] [017/130] (893s left) gem_exec_params (invalid-bsd-ring)
[133.600826] Starting subtest: invalid-bsd-ring
[133.603123] Subtest invalid-bsd-ring: SUCCESS (0.000s)
[133.727206] [018/130] (893s left) syncobj_timeline (invalid-single-wait-unsubmitted)
[133.787303] Starting subtest: invalid-single-wait-unsubmitted
[133.789710] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[133.920920] [019/130] (893s left) kms_flip (basic-flip-vs-dpms)
[134.017105] Starting subtest: basic-flip-vs-dpms
[134.018907] Starting dynamic subtest: A-eDP1
[136.601158] Dynamic subtest A-eDP1: SUCCESS (2.580s)
[136.609574] Starting dynamic subtest: B-eDP1
[138.777152] Dynamic subtest B-eDP1: SUCCESS (2.176s)
[138.786523] Starting dynamic subtest: C-eDP1
[140.857879] Dynamic subtest C-eDP1: SUCCESS (2.081s)
[140.866020] Starting dynamic subtest: D-eDP1
[142.936074] Dynamic subtest D-eDP1: SUCCESS (2.078s)
[142.938240] Subtest basic-flip-vs-dpms: SUCCESS (8.921s)
[143.752097] [020/130] (883s left) syncobj_wait (multi-wait-for-submit-unsubmitted)
[143.798648] Starting subtest: multi-wait-for-submit-unsubmitted
[143.904732] Subtest multi-wait-for-submit-unsubmitted: SUCCESS (0.105s)
[143.977957] [021/130] (883s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[144.074919] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[151.187891] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.115s)
[151.362832] [022/130] (876s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[151.462070] Starting subtest: fbc-psr2-sprite-mmap-gtt
[151.464238] Starting dynamic subtest: eDP-1
[151.468641] Dynamic subtest eDP-1: SKIP (0.000s)
[151.473088] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[151.542620] [023/130] (876s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[151.643246] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[151.645208] Starting dynamic subtest: pipe-A
[151.980045] Dynamic subtest pipe-A: SUCCESS (0.339s)
[151.990336] Starting dynamic subtest: pipe-B
[153.353059] Dynamic subtest pipe-B: SUCCESS (1.373s)
[153.361292] Starting dynamic subtest: pipe-C
[154.784649] Dynamic subtest pipe-C: SUCCESS (1.431s)
[154.794444] Starting dynamic subtest: pipe-D
[156.221524] Dynamic subtest pipe-D: SUCCESS (1.435s)
[156.223860] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.582s)
[157.402381] [024/130] (870s left) gem_eio (context-create)
[157.636435] Starting subtest: context-create
[157.976264] Subtest context-create: SUCCESS (0.339s)
[158.146771] [025/130] (869s left) gen7_exec_parse (oacontrol-tracking)
[158.208054] Subtest oacontrol-tracking: SKIP (0.000s)
[158.290634] [026/130] (869s left) gem_partial_pwrite_pread (reads-display)
[158.347704] Subtest reads-display: SKIP (0.000s)
[158.421838] [027/130] (869s left) syncobj_wait (invalid-signal-bad-pad)
[158.474708] Starting subtest: invalid-signal-bad-pad
[158.476482] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[158.589142] [028/130] (869s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[158.696539] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[159.521556] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.826s)
[159.751932] [029/130] (868s left) kms_async_flips (crc-atomic)
[159.845415] Starting subtest: crc-atomic
[160.222967] Starting dynamic subtest: pipe-A-eDP-1
[163.101210] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.877s)
[163.478359] Starting dynamic subtest: pipe-B-eDP-1
[166.337305] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.867s)
[166.714437] Starting dynamic subtest: pipe-C-eDP-1
[169.557940] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.853s)
[169.924265] Starting dynamic subtest: pipe-D-eDP-1
[172.787882] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.872s)
[172.790118] Subtest crc-atomic: SUCCESS (12.941s)
[173.969843] [030/130] (853s left) kms_big_fb (x-tiled-8bpp-rotate-270)
[174.075837] Starting subtest: x-tiled-8bpp-rotate-270
[174.096336] Subtest x-tiled-8bpp-rotate-270: SKIP (0.020s)
[174.241602] [031/130] (853s left) kms_getfb (getfb-repeated-different-handles)
[174.327034] Starting subtest: getfb-repeated-different-handles
[174.329251] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[174.446137] [032/130] (853s left) kms_ccs (crc-primary-basic-4-tiled-dg2-mc-ccs)
[174.537605] Starting subtest: crc-primary-basic-4-tiled-dg2-mc-ccs
[174.539574] Starting dynamic subtest: pipe-A-eDP-1
[174.563847] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[174.572260] Starting dynamic subtest: pipe-B-eDP-1
[174.593083] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[174.600776] Starting dynamic subtest: pipe-C-eDP-1
[174.621567] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[174.629130] Starting dynamic subtest: pipe-D-eDP-1
[174.651224] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[174.655255] Subtest crc-primary-basic-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[176.727424] [033/130] (851s left) kms_color (degamma)
[176.822281] Starting subtest: degamma
[176.824420] Starting dynamic subtest: pipe-A-eDP-1
[177.528342] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.706s)
[177.536778] Starting dynamic subtest: pipe-B-eDP-1
[178.915404] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.383s)
[178.925294] Starting dynamic subtest: pipe-C-eDP-1
[180.292201] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.377s)
[180.300560] Starting dynamic subtest: pipe-D-eDP-1
[181.638249] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.346s)
[181.640703] Subtest degamma: SUCCESS (4.815s)
[182.451734] [034/130] (845s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[182.552768] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[182.556957] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[182.668577] [035/130] (845s left) kms_frontbuffer_tracking (psr-rgb101010-draw-blt)
[182.771887] Starting subtest: psr-rgb101010-draw-blt
[189.988048] Subtest psr-rgb101010-draw-blt: SUCCESS (7.219s)
[190.145353] [036/130] (837s left) kms_flip (2x-blocking-absolute-wf_vblank)
[190.241525] Starting subtest: 2x-blocking-absolute-wf_vblank
[190.249746] Subtest 2x-blocking-absolute-wf_vblank: SKIP (0.010s)
[190.338827] [037/130] (837s left) kms_vrr (max-min)
[190.433092] Starting subtest: max-min
[190.439148] Subtest max-min: SKIP (0.000s)
[190.509991] [038/130] (837s left) kms_pm_rpm (system-suspend-modeset)
[192.027698] Starting subtest: system-suspend-modeset
[211.662492] Subtest system-suspend-modeset: SUCCESS (4.482s)
[212.053937] [039/130] (816s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled)
[212.123914] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled
[212.224769] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.105s)
[212.323664] [040/130] (815s left) gem_mmap_gtt (cpuset-medium-copy-odd)
[212.382980] Subtest cpuset-medium-copy-odd: SKIP (0.000s)
[212.446381] [041/130] (815s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[212.545275] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[213.173872] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.637s)
[213.357210] [042/130] (815s left) api_intel_bb (intel-bb-blit-y)
[213.416270] Starting subtest: intel-bb-blit-y
[217.085630] Subtest intel-bb-blit-y: SUCCESS (3.705s)
[217.235668] [043/130] (811s left) gem_readwrite (new-obj)
[217.289134] Subtest new-obj: SKIP (0.000s)
[217.356174] [044/130] (811s left) kms_plane_scaling (planes-scaler-unity-scaling)
[217.451193] Starting subtest: planes-scaler-unity-scaling
[217.453934] Starting dynamic subtest: pipe-A
[217.513623] Dynamic subtest pipe-A: SUCCESS (0.063s)
[217.522091] Starting dynamic subtest: pipe-B
[218.692410] Dynamic subtest pipe-B: SUCCESS (1.185s)
[218.701342] Starting dynamic subtest: pipe-C
[219.814004] Dynamic subtest pipe-C: SUCCESS (1.127s)
[219.822695] Starting dynamic subtest: pipe-D
[220.931234] Dynamic subtest pipe-D: SUCCESS (1.122s)
[220.934161] Subtest planes-scaler-unity-scaling: SUCCESS (3.502s)
[222.102657] [045/130] (806s left) gem_eio (in-flight-internal-1us)
[222.337177] Starting subtest: in-flight-internal-1us
[224.179422] Subtest in-flight-internal-1us: SUCCESS (1.846s)
[224.352668] [046/130] (804s left) core_getstats (basic)
[224.409304] Starting subtest: basic
[224.412199] Subtest basic: SUCCESS (0.000s)
[224.522929] [047/130] (804s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[224.628120] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[224.632769] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[224.745337] [048/130] (803s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[224.844206] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[224.849038] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[224.960162] [049/130] (803s left) gem_mmap_wc (write-gtt-read-wc)
[225.019392] Subtest write-gtt-read-wc: SKIP (0.000s)
[225.079744] [050/130] (803s left) gem_exec_balancer (parallel-balancer)
[225.336189] Starting subtest: parallel-balancer
[226.177434] Subtest parallel-balancer: SUCCESS (0.843s)
[226.269450] [051/130] (802s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[226.366174] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[229.932966] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.579s)
[231.053678] [052/130] (797s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[231.148387] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[231.151297] Starting dynamic subtest: pipe-A-default-mode
[231.443517] Dynamic subtest pipe-A-default-mode: SKIP (0.293s)
[231.449172] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.294s)
[232.278240] [053/130] (796s left) kms_lease (setcrtc-implicit-plane)
[232.370251] Starting subtest: setcrtc-implicit-plane
[232.373181] Starting dynamic subtest: pipe-A-eDP-1
[232.834715] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.467s)
[232.845397] Starting dynamic subtest: pipe-B-eDP-1
[234.008094] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.170s)
[234.018216] Starting dynamic subtest: pipe-C-eDP-1
[235.108041] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.103s)
[235.118242] Starting dynamic subtest: pipe-D-eDP-1
[236.231128] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.122s)
[236.233710] Subtest setcrtc-implicit-plane: SUCCESS (3.868s)
[237.097104] [054/130] (791s left) syncobj_wait (signal)
[237.148196] Starting subtest: signal
[237.151032] Subtest signal: SUCCESS (0.000s)
[237.261897] [055/130] (791s left) fbdev (read)
[237.299090] Starting subtest: read
[237.918134] Subtest read: SUCCESS (0.618s)
[237.989912] [056/130] (790s left) kms_plane_cursor (primary)
[238.078696] Starting subtest: primary
[238.083352] Starting dynamic subtest: pipe-A-eDP-1-size-64
[240.638718] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.561s)
[240.662969] Starting dynamic subtest: pipe-A-eDP-1-size-128
[243.241383] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.583s)
[243.264258] Starting dynamic subtest: pipe-A-eDP-1-size-256
[245.844319] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.571s)
[246.166698] Starting dynamic subtest: pipe-B-eDP-1-size-64
[249.485003] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.344s)
[249.509829] Starting dynamic subtest: pipe-B-eDP-1-size-128
[252.052746] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.549s)
[252.081718] Starting dynamic subtest: pipe-B-eDP-1-size-256
[254.643728] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.571s)
[254.970407] Starting dynamic subtest: pipe-C-eDP-1-size-64
[257.871400] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.913s)
[257.898186] Starting dynamic subtest: pipe-C-eDP-1-size-128
[260.103998] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.213s)
[260.129193] Starting dynamic subtest: pipe-C-eDP-1-size-256
[262.314484] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.191s)
[262.636714] Starting dynamic subtest: pipe-D-eDP-1-size-64
[265.556744] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.932s)
[265.582941] Starting dynamic subtest: pipe-D-eDP-1-size-128
[267.821831] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.246s)
[267.847994] Starting dynamic subtest: pipe-D-eDP-1-size-256
[270.054101] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.213s)
[270.368082] Subtest primary: SUCCESS (32.294s)
[271.218518] [057/130] (757s left) kms_psr (fbc-psr-primary-mmap-cpu)
[271.314148] Starting subtest: fbc-psr-primary-mmap-cpu
[271.316843] Starting dynamic subtest: eDP-1
[271.322166] Dynamic subtest eDP-1: SKIP (0.000s)
[271.327509] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.001s)
[271.410412] [058/130] (757s left) sysfs_preempt_timeout (timeout)
[271.468309] Starting subtest: timeout
[271.471136] Starting dynamic subtest: vecs0
[281.080529] Dynamic subtest vecs0: SUCCESS (9.611s)
[281.093105] Starting dynamic subtest: ccs0
[282.485446] Dynamic subtest ccs0: SUCCESS (1.405s)
[282.494656] Starting dynamic subtest: vcs0
[292.088511] Dynamic subtest vcs0: SUCCESS (9.603s)
[292.099221] Starting dynamic subtest: bcs0
[293.385477] Dynamic subtest bcs0: SUCCESS (1.296s)
[293.397029] Starting dynamic subtest: rcs0
[294.707723] Dynamic subtest rcs0: SUCCESS (1.321s)
[294.719463] Starting dynamic subtest: vcs1
[304.127199] Dynamic subtest vcs1: SUCCESS (9.420s)
[304.130174] Subtest timeout: SUCCESS (32.670s)
[304.203584] [059/130] (724s left) kms_lease (lease-unleased-crtc)
[304.302505] Starting subtest: lease-unleased-crtc
[304.305200] Starting dynamic subtest: pipe-A-eDP-1
[304.596255] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.293s)
[304.611811] Starting dynamic subtest: pipe-B-eDP-1
[305.347989] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.748s)
[305.365842] Starting dynamic subtest: pipe-C-eDP-1
[305.368458] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.004s)
[305.377411] Starting dynamic subtest: pipe-D-eDP-1
[305.380202] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s)
[305.382907] Subtest lease-unleased-crtc: SUCCESS (1.056s)
[305.742789] [060/130] (723s left) gem_exec_fence (syncobj-wait)
[306.191532] Starting subtest: syncobj-wait
[308.079773] Subtest syncobj-wait: SUCCESS (1.885s)
[308.454347] [FACT gem_exec_fence (syncobj-wait)] new: kernel.kmod_is_loaded.vgem: true
[308.457568] [061/130] (720s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[308.558829] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[315.776353] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.217s)
[315.927375] [062/130] (713s left) kms_hdmi_inject (inject-audio)
[316.268863] Starting subtest: inject-audio
[316.545985] Subtest inject-audio: SUCCESS (0.277s)
[317.132688] [063/130] (712s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[317.191144] Starting subtest: single-wait-all-for-submit-signaled
[317.194180] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[317.341438] [064/130] (711s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[317.441910] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[317.446970] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[317.548807] [065/130] (711s left) gem_exec_basic (basic)
[317.608381] Starting subtest: basic
[317.611154] Starting dynamic subtest: rcs0-smem
[317.613883] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[317.624012] Starting dynamic subtest: bcs0-smem
[317.626414] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[317.635423] Starting dynamic subtest: vcs0-smem
[317.637793] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[317.646540] Starting dynamic subtest: vcs1-smem
[317.648888] Dynamic subtest vcs1-smem: SUCCESS (0.002s)
[317.657730] Starting dynamic subtest: vecs0-smem
[317.659970] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[317.669080] Starting dynamic subtest: ccs0-smem
[317.671359] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[317.673635] Subtest basic: SUCCESS (0.018s)
[319.129769] [066/130] (710s left) kms_dp_link_training (uhbr-sst)
[319.223392] Starting subtest: uhbr-sst
[319.234311] Subtest uhbr-sst: SKIP (0.000s)
[319.304541] [067/130] (710s left) gem_pwrite_snooped
[319.452775] [068/130] (709s left) gem_eio (in-flight-contexts-1us)
[319.661534] Starting subtest: in-flight-contexts-1us
[333.124395] Subtest in-flight-contexts-1us: SUCCESS (13.458s)
[333.314934] [069/130] (696s left) kms_psr (fbc-pr-sprite-blt)
[333.415154] Starting subtest: fbc-pr-sprite-blt
[333.420125] Subtest fbc-pr-sprite-blt: SKIP (0.000s)
[333.500926] [070/130] (695s left) kms_chamelium_hpd (dp-hpd-storm-disable)
[333.892318] Subtest dp-hpd-storm-disable: SKIP (0.000s)
[334.682210] [071/130] (694s left) gem_ringfill (basic-all)
[340.075387] Starting subtest: basic-all
[341.237940] Subtest basic-all: SUCCESS (1.163s)
[341.407218] [072/130] (688s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[341.505003] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[341.507422] Starting dynamic subtest: pipe-A-eDP-1
[341.530659] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[341.541309] Starting dynamic subtest: pipe-B-eDP-1
[341.564171] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[341.573051] Starting dynamic subtest: pipe-C-eDP-1
[341.595844] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[341.604814] Starting dynamic subtest: pipe-D-eDP-1
[341.627175] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[341.629285] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.007s)
[343.718701] [073/130] (685s left) gem_mmap_offset (close-race)
[343.782280] Starting subtest: close-race
[363.885145] Subtest close-race: SUCCESS (20.103s)
[364.052288] [074/130] (665s left) kms_cursor_legacy (single-bo)
[364.184408] Starting subtest: single-bo
[364.186709] Starting dynamic subtest: pipe-A
[369.599998] Dynamic subtest pipe-A: SUCCESS (5.380s)
[369.610289] Starting dynamic subtest: pipe-B
[374.946995] Dynamic subtest pipe-B: SUCCESS (5.379s)
[374.957594] Starting dynamic subtest: pipe-C
[380.324354] Dynamic subtest pipe-C: SUCCESS (5.378s)
[380.335369] Starting dynamic subtest: pipe-D
[385.704375] Dynamic subtest pipe-D: SUCCESS (5.378s)
[385.715409] Starting dynamic subtest: all-pipes
[391.091361] Dynamic subtest all-pipes: SUCCESS (5.386s)
[391.094214] Subtest single-bo: SUCCESS (26.912s)
[391.253611] [075/130] (638s left) gem_ccs (suspend-resume)
[391.313279] Starting subtest: suspend-resume
[391.319291] Subtest suspend-resume: SKIP (0.000s)
[391.462203] [076/130] (638s left) template (b)
[391.524149] Starting subtest: B
[391.526798] Subtest B: SUCCESS (0.000s)
[391.625735] [077/130] (638s left) gem_exec_schedule (promotion)
[391.704660] Starting subtest: promotion
[391.707184] Starting dynamic subtest: rcs0
[391.795160] Dynamic subtest rcs0: SUCCESS (0.101s)
[391.807149] Starting dynamic subtest: vcs0
[391.886524] Dynamic subtest vcs0: SUCCESS (0.090s)
[391.898839] Starting dynamic subtest: vcs1
[391.972286] Dynamic subtest vcs1: SUCCESS (0.084s)
[391.984810] Starting dynamic subtest: vecs0
[392.058363] Dynamic subtest vecs0: SUCCESS (0.083s)
[392.071446] Starting dynamic subtest: ccs0
[392.155088] Dynamic subtest ccs0: SUCCESS (0.095s)
[392.158093] Subtest promotion: SUCCESS (0.463s)
[393.243173] [078/130] (636s left) kms_psr (psr-suspend)
[393.335993] Starting subtest: psr-suspend
[393.338396] Starting dynamic subtest: eDP-1
[410.862622] Dynamic subtest eDP-1: SUCCESS (2.937s)
[410.865089] Subtest psr-suspend: SUCCESS (2.938s)
[411.662345] [079/130] (618s left) kms_psr (psr2-cursor-plane-move)
[411.760568] Starting subtest: psr2-cursor-plane-move
[411.762810] Starting dynamic subtest: eDP-1
[413.463391] Dynamic subtest eDP-1: SUCCESS (1.728s)
[413.465740] Subtest psr2-cursor-plane-move: SUCCESS (1.729s)
[414.308371] [080/130] (615s left) perf_pmu (busy-start)
[414.346671] Starting subtest: busy-start
[414.349004] Starting dynamic subtest: rcs0
[416.896916] Dynamic subtest rcs0: SUCCESS (2.577s)
[416.907361] Starting dynamic subtest: bcs0
[419.446074] Dynamic subtest bcs0: SUCCESS (2.565s)
[419.456477] Starting dynamic subtest: vcs0
[422.692099] Dynamic subtest vcs0: SUCCESS (3.259s)
[422.703137] Starting dynamic subtest: vcs1
[426.659912] Dynamic subtest vcs1: SUCCESS (3.979s)
[426.671503] Starting dynamic subtest: vecs0
[430.691941] Dynamic subtest vecs0: SUCCESS (4.038s)
[430.704134] Starting dynamic subtest: ccs0
[433.240020] Dynamic subtest ccs0: SUCCESS (2.551s)
[433.242469] Subtest busy-start: SUCCESS (18.983s)
[433.376153] [081/130] (596s left) kms_flip (flip-vs-absolute-wf_vblank)
[433.475020] Starting subtest: flip-vs-absolute-wf_vblank
[433.477274] Starting dynamic subtest: A-eDP1
[442.415319] Dynamic subtest A-eDP1: SUCCESS (8.949s)
[442.428154] Starting dynamic subtest: B-eDP1
[451.308422] Dynamic subtest B-eDP1: SUCCESS (8.888s)
[451.317493] Starting dynamic subtest: C-eDP1
[460.203650] Dynamic subtest C-eDP1: SUCCESS (8.892s)
[460.213360] Starting dynamic subtest: D-eDP1
[469.101468] Dynamic subtest D-eDP1: SUCCESS (8.896s)
[469.104134] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.633s)
[470.319798] [082/130] (559s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[470.429604] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt
[470.433574] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[470.564261] [083/130] (559s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[471.112317] Starting subtest: syncobj-backward-timeline-chain-engines
[471.210441] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.100s)
[472.796902] [084/130] (557s left) kms_atomic_interruptible (atomic-setmode)
[472.906216] Starting subtest: atomic-setmode
[472.908690] Starting dynamic subtest: pipe-A-eDP-1
[479.802060] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.895s)
[479.804525] Subtest atomic-setmode: SUCCESS (6.896s)
[480.620245] [085/130] (549s left) gem_ppgtt (shrink-vs-evict-any)
[480.684619] Starting subtest: shrink-vs-evict-any
[486.652572] Subtest shrink-vs-evict-any: SUCCESS (5.967s)
[486.763899] [086/130] (543s left) gem_exec_params (invalid-bsd1-flag-on-vebox)
[486.832322] Starting subtest: invalid-bsd1-flag-on-vebox
[486.834623] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s)
[486.975765] [087/130] (543s left) gem_exec_schedule (independent)
[487.053387] Starting subtest: independent
[487.055908] Starting dynamic subtest: rcs0
[488.677167] Dynamic subtest rcs0: SUCCESS (1.631s)
[488.690585] Starting dynamic subtest: vcs0
[490.697237] Dynamic subtest vcs0: SUCCESS (2.018s)
[490.710519] Starting dynamic subtest: vcs1
[492.739182] Dynamic subtest vcs1: SUCCESS (2.041s)
[492.752392] Starting dynamic subtest: vecs0
[494.711265] Dynamic subtest vecs0: SUCCESS (1.970s)
[494.723813] Starting dynamic subtest: ccs0
[496.676298] Dynamic subtest ccs0: SUCCESS (1.963s)
[496.678888] Subtest independent: SUCCESS (9.634s)
[497.000303] [088/130] (533s left) kms_psr (psr2-primary-blt)
[497.092746] Starting subtest: psr2-primary-blt
[497.095079] Starting dynamic subtest: eDP-1
[498.840154] Dynamic subtest eDP-1: SUCCESS (1.746s)
[498.842133] Subtest psr2-primary-blt: SUCCESS (1.747s)
[499.701197] [089/130] (530s left) kms_async_flips (crc)
[499.785116] Starting subtest: crc
[500.156577] Starting dynamic subtest: pipe-A-eDP-1
[503.069628] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.911s)
[503.451060] Starting dynamic subtest: pipe-B-eDP-1
[506.370198] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.936s)
[506.758016] Starting dynamic subtest: pipe-C-eDP-1
[509.643282] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.897s)
[510.024558] Starting dynamic subtest: pipe-D-eDP-1
[512.963736] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.950s)
[512.965906] Subtest crc: SUCCESS (13.181s)
[514.194412] [090/130] (516s left) kms_cursor_crc (cursor-onscreen-128x42)
[514.407091] Starting subtest: cursor-onscreen-128x42
[514.452757] Subtest cursor-onscreen-128x42: SKIP (0.041s)
[514.664781] [091/130] (515s left) i915_drm_fdinfo (memory-info-purgeable)
[514.700284] Starting subtest: memory-info-purgeable
[514.702132] Starting dynamic subtest: smem0
[517.616752] Dynamic subtest smem0: SUCCESS (2.917s)
[517.619245] Subtest memory-info-purgeable: SUCCESS (2.919s)
[517.701041] [092/130] (512s left) kms_cursor_crc (cursor-random-64x64)
[517.863032] Starting subtest: cursor-random-64x64
[517.867070] Starting dynamic subtest: pipe-A-eDP-1
[521.221313] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.352s)
[521.252303] Starting dynamic subtest: pipe-D-eDP-1
[525.250771] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.006s)
[525.253179] Subtest cursor-random-64x64: SUCCESS (7.384s)
[526.099952] [093/130] (504s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-sf)
[531.156370] Starting subtest: fbc-psr2-cursor-plane-move-continuous-sf
[531.158723] Starting dynamic subtest: pipe-A-eDP-1
[531.922596] Dynamic subtest pipe-A-eDP-1: SKIP (0.762s)
[531.934715] Starting dynamic subtest: pipe-B-eDP-1
[533.040241] Dynamic subtest pipe-B-eDP-1: SKIP (1.117s)
[533.045181] Subtest fbc-psr2-cursor-plane-move-continuous-sf: SKIP (1.883s)
[534.297645] [094/130] (496s left) gem_spin_batch (legacy)
[534.360344] Starting subtest: legacy
[534.362510] Starting dynamic subtest: default
[537.597926] Dynamic subtest default: SUCCESS (3.232s)
[537.607575] Starting dynamic subtest: render
[540.831812] Dynamic subtest render: SUCCESS (3.230s)
[540.843230] Starting dynamic subtest: bsd
[544.067617] Dynamic subtest bsd: SUCCESS (3.233s)
[544.078071] Starting dynamic subtest: bsd1
[547.302935] Dynamic subtest bsd1: SUCCESS (3.233s)
[547.314429] Starting dynamic subtest: bsd2
[550.533783] Dynamic subtest bsd2: SUCCESS (3.228s)
[550.545628] Starting dynamic subtest: blt
[553.771915] Dynamic subtest blt: SUCCESS (3.236s)
[553.780754] Starting dynamic subtest: vebox
[557.006141] Dynamic subtest vebox: SUCCESS (3.232s)
[557.008353] Subtest legacy: SUCCESS (22.644s)
[557.699539] [095/130] (472s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[557.748785] Starting subtest: etime-single-wait-for-submit-unsubmitted
[557.856798] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.107s)
[557.947366] [096/130] (472s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[558.052301] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[558.787419] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.737s)
[558.973669] [097/130] (471s left) api_intel_allocator (standalone)
[559.023807] Starting subtest: standalone
[559.042199] Subtest standalone: SUCCESS (0.018s)
[559.195320] [098/130] (471s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[559.299308] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[559.303802] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[559.397811] [099/130] (471s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-fully-sf)
[564.445909] Starting subtest: psr2-cursor-plane-move-continuous-exceed-fully-sf
[564.448212] Starting dynamic subtest: pipe-A-eDP-1
[576.146910] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.701s)
[576.157730] Starting dynamic subtest: pipe-B-eDP-1
[587.841089] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.695s)
[587.843503] Subtest psr2-cursor-plane-move-continuous-exceed-fully-sf: SUCCESS (23.401s)
[588.692701] [100/130] (442s left) gem_render_copy_redux (flink-interruptible)
[588.754106] Starting subtest: flink-interruptible
[589.446187] Subtest flink-interruptible: SUCCESS (0.695s)
[589.610858] [101/130] (441s left) gem_exec_reloc (basic-gtt)
[589.675707] Subtest basic-gtt: SKIP (0.000s)
[589.761953] [102/130] (441s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-blt)
[589.862204] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-blt
[596.953684] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.093s)
[597.127018] [103/130] (433s left) gem_exec_whisper (basic-normal-all)
[597.187887] Starting subtest: basic-normal-all
[599.448578] Subtest basic-normal-all: SUCCESS (2.260s)
[599.655174] [104/130] (431s left) kms_pm_rpm (dpms-lpsp)
[601.884414] Starting subtest: dpms-lpsp
[602.189073] Subtest dpms-lpsp: SUCCESS (0.307s)
[602.301255] [105/130] (428s left) kms_vblank (query-forked-busy-hang)
[602.391288] Starting subtest: query-forked-busy-hang
[602.393565] Starting dynamic subtest: pipe-A-eDP-1
[628.506022] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.120s)
[628.520814] Starting dynamic subtest: pipe-D-eDP-1
[653.413579] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.909s)
[653.415555] Subtest query-forked-busy-hang: SUCCESS (51.034s)
[654.270882] [106/130] (376s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[654.367787] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[654.370051] Starting dynamic subtest: pipe-A-eDP-1
[670.638478] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.398s)
[670.649072] Starting dynamic subtest: pipe-B-eDP-1
[687.560165] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.367s)
[687.570454] Starting dynamic subtest: pipe-C-eDP-1
[704.534362] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.339s)
[704.545266] Starting dynamic subtest: pipe-D-eDP-1
[721.548419] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.375s)
[721.551235] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (8.484s)
[722.718177] [107/130] (308s left) syncobj_timeline (reset-multiple-signaled)
[722.788564] Starting subtest: reset-multiple-signaled
[722.791032] Subtest reset-multiple-signaled: SUCCESS (0.000s)
[722.925934] [108/130] (308s left) kms_flip (basic-plain-flip)
[723.018378] Starting subtest: basic-plain-flip
[723.020855] Starting dynamic subtest: A-eDP1
[724.655627] Dynamic subtest A-eDP1: SUCCESS (1.661s)
[724.666651] Starting dynamic subtest: B-eDP1
[726.325597] Dynamic subtest B-eDP1: SUCCESS (1.686s)
[726.337510] Starting dynamic subtest: C-eDP1
[728.003511] Dynamic subtest C-eDP1: SUCCESS (1.689s)
[728.019802] Starting dynamic subtest: D-eDP1
[729.709607] Dynamic subtest D-eDP1: SUCCESS (1.693s)
[729.711753] Subtest basic-plain-flip: SUCCESS (6.741s)
[730.927523] [109/130] (300s left) gem_exec_reloc (basic-gtt-read)
[730.992524] Subtest basic-gtt-read: SKIP (0.000s)
[731.068209] [110/130] (300s left) gem_exec_whisper (basic-queues-forked)
[731.121730] Starting subtest: basic-queues-forked
[755.483771] Subtest basic-queues-forked: SUCCESS (24.398s)
[755.692271] [111/130] (275s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc)
[755.815573] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc
[755.820459] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[755.928979] [112/130] (275s left) kms_frontbuffer_tracking (fbc-rgb565-draw-pwrite)
[756.028446] Starting subtest: fbc-rgb565-draw-pwrite
[760.588057] Subtest fbc-rgb565-draw-pwrite: SUCCESS (4.562s)
[761.810624] [113/130] (269s left) prime_busy (hang-wait)
[761.889634] Starting subtest: hang-wait
[761.892123] Starting dynamic subtest: rcs0
[787.943864] Dynamic subtest rcs0: SUCCESS (26.054s)
[787.954292] Starting dynamic subtest: bcs0
[795.168765] Dynamic subtest bcs0: SUCCESS (7.223s)
[795.179108] Starting dynamic subtest: vcs0
[802.141755] Dynamic subtest vcs0: SUCCESS (6.973s)
[802.154761] Starting dynamic subtest: vcs1
[809.112509] Dynamic subtest vcs1: SUCCESS (6.974s)
[809.125615] Starting dynamic subtest: vecs0
[816.090786] Dynamic subtest vecs0: SUCCESS (6.975s)
[816.102748] Starting dynamic subtest: ccs0
[829.933642] Dynamic subtest ccs0: SUCCESS (13.837s)
[829.936193] Subtest hang-wait: SUCCESS (68.047s)
[830.074644] [114/130] (201s left) kms_joiner (basic-max-non-joiner)
[830.176138] Starting subtest: basic-max-non-joiner
[830.181441] Subtest basic-max-non-joiner: SKIP (0.000s)
[830.247307] [115/130] (201s left) gem_exec_reloc (basic-wc-read)
[830.308327] Subtest basic-wc-read: SKIP (0.000s)
[830.384940] [116/130] (201s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt)
[830.474468] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt
[830.479680] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s)
[830.612198] [117/130] (200s left) i915_query (test-query-geometry-subslices)
[830.669745] Starting subtest: test-query-geometry-subslices
[830.672509] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[830.787278] [118/130] (200s left) kms_cursor_legacy (cursora-vs-flipa-atomic)
[830.896385] Starting subtest: cursorA-vs-flipA-atomic
[842.027535] Subtest cursorA-vs-flipA-atomic: SUCCESS (11.129s)
[842.883016] [119/130] (188s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-render)
[842.984494] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-render
[847.053580] Subtest fbc-1p-offscreen-pri-shrfb-draw-render: SUCCESS (4.073s)
[848.196835] [120/130] (183s left) kms_flip (nonexisting-fb)
[848.288141] Starting subtest: nonexisting-fb
[848.290577] Starting dynamic subtest: A-eDP1
[849.420556] Dynamic subtest A-eDP1: SUCCESS (1.135s)
[849.431792] Starting dynamic subtest: B-eDP1
[850.613553] Dynamic subtest B-eDP1: SUCCESS (1.192s)
[850.623982] Starting dynamic subtest: C-eDP1
[851.821890] Dynamic subtest C-eDP1: SUCCESS (1.207s)
[851.840334] Starting dynamic subtest: D-eDP1
[853.015434] Dynamic subtest D-eDP1: SUCCESS (1.192s)
[853.018335] Subtest nonexisting-fb: SUCCESS (4.734s)
[854.267988] [121/130] (177s left) kms_frontbuffer_tracking (psr-rgb565-draw-render)
[854.367593] Starting subtest: psr-rgb565-draw-render
[861.265215] Subtest psr-rgb565-draw-render: SUCCESS (6.901s)
[861.402971] [122/130] (170s left) perf (rc6-disable)
[861.530987] Starting subtest: rc6-disable
[861.719131] Subtest rc6-disable: SUCCESS (0.188s)
[861.777381] [123/130] (169s left) gem_ctx_persistence (legacy-engines-hang)
[861.844596] Starting subtest: legacy-engines-hang
[861.847536] Starting dynamic subtest: render
[861.993125] Dynamic subtest render: SUCCESS (0.148s)
[862.005363] Starting dynamic subtest: bsd1
[862.100115] Dynamic subtest bsd1: SUCCESS (0.104s)
[862.112794] Starting dynamic subtest: bsd2
[862.212580] Dynamic subtest bsd2: SUCCESS (0.110s)
[862.226151] Starting dynamic subtest: blt
[862.304547] Dynamic subtest blt: SUCCESS (0.090s)
[862.318445] Starting dynamic subtest: vebox
[862.411655] Dynamic subtest vebox: SUCCESS (0.104s)
[862.414417] Subtest legacy-engines-hang: SUCCESS (0.569s)
[862.506113] [124/130] (169s left) kms_chamelium_edid (dp-edid-stress-resolution-4k)
[862.885685] Subtest dp-edid-stress-resolution-4k: SKIP (0.000s)
[863.733985] [125/130] (168s left) i915_hangman (gt-engine-error)
[863.802378] Starting subtest: gt-engine-error
[863.804740] Starting dynamic subtest: rcs0
[865.454468] Dynamic subtest rcs0: SUCCESS (1.652s)
[865.469002] Starting dynamic subtest: bcs0
[867.437206] Dynamic subtest bcs0: SUCCESS (1.981s)
[867.451156] Starting dynamic subtest: vcs0
[869.420159] Dynamic subtest vcs0: SUCCESS (1.981s)
[869.433780] Starting dynamic subtest: vcs1
[871.470739] Dynamic subtest vcs1: SUCCESS (2.047s)
[871.489356] Starting dynamic subtest: vecs0
[873.453744] Dynamic subtest vecs0: SUCCESS (1.981s)
[873.467433] Starting dynamic subtest: ccs0
[875.437990] Dynamic subtest ccs0: SUCCESS (1.981s)
[875.440682] Subtest gt-engine-error: SUCCESS (11.639s)
[875.533599] [126/130] (156s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[875.629161] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[875.631364] Starting dynamic subtest: pipe-A-eDP-1
[876.345420] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.708s)
[876.356718] Starting dynamic subtest: pipe-B-eDP-1
[878.130683] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.785s)
[878.140974] Starting dynamic subtest: pipe-C-eDP-1
[879.933149] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.801s)
[879.944126] Starting dynamic subtest: pipe-D-eDP-1
[881.733648] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.798s)
[881.736170] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.097s)
[882.877710] [127/130] (148s left) kms_cursor_edge_walk (256x256-left-edge)
[882.977171] Starting subtest: 256x256-left-edge
[882.979502] Starting dynamic subtest: pipe-A-eDP-1
[886.401030] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.421s)
[886.412733] Starting dynamic subtest: pipe-D-eDP-1
[889.575761] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.173s)
[889.578550] Subtest 256x256-left-edge: SUCCESS (6.597s)
[890.470026] [128/130] (141s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[890.575374] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[890.580573] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[890.686246] [129/130] (141s left) gem_exec_reloc (basic-write-gtt)
[890.748744] Subtest basic-write-gtt: SKIP (0.000s)
[890.825403] [130/130] (141s left) kms_flip (dpms-vs-vblank-race-interruptible)
[890.926327] Starting subtest: dpms-vs-vblank-race-interruptible
[890.928732] Starting dynamic subtest: A-eDP1
[894.806554] Dynamic subtest A-eDP1: SUCCESS (3.879s)
[894.817731] Starting dynamic subtest: B-eDP1
[898.308017] Dynamic subtest B-eDP1: SUCCESS (3.501s)
[898.325326] Starting dynamic subtest: C-eDP1
[901.802445] Dynamic subtest C-eDP1: SUCCESS (3.494s)
[901.812928] Starting dynamic subtest: D-eDP1
[905.304752] Dynamic subtest D-eDP1: SUCCESS (3.502s)
[905.307663] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (14.384s)
[906.173786] Closing watchdogs
results: parsing output: 0/ for test: kms_chamelium_color
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: perf_pmu
results: parsing output: 3/ for test: kms_flip_scaled_crc
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: gem_fenced_exec_thrash
results: parsing output: 6/ for test: gem_render_linear_blits
results: parsing output: 7/ for test: kms_ccs
results: parsing output: 8/ for test: gem_userptr_blits
results: parsing output: 9/ for test: kms_properties
results: parsing output: 10/ for test: kms_frontbuffer_tracking
results: parsing output: 11/ for test: gem_render_copy
results: parsing output: 12/ for test: gem_exec_create
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: gem_ctx_exec
results: parsing output: 15/ for test: i915_pm_freq_mult
results: parsing output: 16/ for test: gem_exec_params
results: parsing output: 17/ for test: syncobj_timeline
results: parsing output: 18/ for test: kms_flip
results: parsing output: 19/ for test: syncobj_wait
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_psr
results: parsing output: 22/ for test: kms_plane_scaling
results: parsing output: 23/ for test: gem_eio
results: parsing output: 24/ for test: gen7_exec_parse
results: parsing output: 25/ for test: gem_partial_pwrite_pread
results: parsing output: 26/ for test: syncobj_wait
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: kms_async_flips
results: parsing output: 29/ for test: kms_big_fb
results: parsing output: 30/ for test: kms_getfb
results: parsing output: 31/ for test: kms_ccs
results: parsing output: 32/ for test: kms_color
results: parsing output: 33/ for test: kms_big_fb
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_flip
results: parsing output: 36/ for test: kms_vrr
results: parsing output: 37/ for test: kms_pm_rpm
results: parsing output: 38/ for test: syncobj_timeline
results: parsing output: 39/ for test: gem_mmap_gtt
results: parsing output: 40/ for test: kms_big_fb
results: parsing output: 41/ for test: api_intel_bb
results: parsing output: 42/ for test: gem_readwrite
results: parsing output: 43/ for test: kms_plane_scaling
results: parsing output: 44/ for test: gem_eio
results: parsing output: 45/ for test: core_getstats
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: gem_mmap_wc
results: parsing output: 49/ for test: gem_exec_balancer
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: kms_flip_scaled_crc
results: parsing output: 52/ for test: kms_lease
results: parsing output: 53/ for test: syncobj_wait
results: parsing output: 54/ for test: fbdev
results: parsing output: 55/ for test: kms_plane_cursor
results: parsing output: 56/ for test: kms_psr
results: parsing output: 57/ for test: sysfs_preempt_timeout
results: parsing output: 58/ for test: kms_lease
results: parsing output: 59/ for test: gem_exec_fence
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_hdmi_inject
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: gem_exec_basic
results: parsing output: 65/ for test: kms_dp_link_training
results: parsing output: 66/ for test: gem_pwrite_snooped
results: parsing output: 67/ for test: gem_eio
results: parsing output: 68/ for test: kms_psr
results: parsing output: 69/ for test: kms_chamelium_hpd
results: parsing output: 70/ for test: gem_ringfill
results: parsing output: 71/ for test: kms_ccs
results: parsing output: 72/ for test: gem_mmap_offset
results: parsing output: 73/ for test: kms_cursor_legacy
results: parsing output: 74/ for test: gem_ccs
results: parsing output: 75/ for test: template
results: parsing output: 76/ for test: gem_exec_schedule
results: parsing output: 77/ for test: kms_psr
results: parsing output: 78/ for test: kms_psr
results: parsing output: 79/ for test: perf_pmu
results: parsing output: 80/ for test: kms_flip
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: gem_exec_fence
results: parsing output: 83/ for test: kms_atomic_interruptible
results: parsing output: 84/ for test: gem_ppgtt
results: parsing output: 85/ for test: gem_exec_params
results: parsing output: 86/ for test: gem_exec_schedule
results: parsing output: 87/ for test: kms_psr
results: parsing output: 88/ for test: kms_async_flips
results: parsing output: 89/ for test: kms_cursor_crc
results: parsing output: 90/ for test: i915_drm_fdinfo
results: parsing output: 91/ for test: kms_cursor_crc
results: parsing output: 92/ for test: kms_psr2_sf
results: parsing output: 93/ for test: gem_spin_batch
results: parsing output: 94/ for test: syncobj_timeline
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: api_intel_allocator
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_psr2_sf
results: parsing output: 99/ for test: gem_render_copy_redux
results: parsing output: 100/ for test: gem_exec_reloc
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gem_exec_whisper
results: parsing output: 103/ for test: kms_pm_rpm
results: parsing output: 104/ for test: kms_vblank
results: parsing output: 105/ for test: kms_ccs
results: parsing output: 106/ for test: syncobj_timeline
results: parsing output: 107/ for test: kms_flip
results: parsing output: 108/ for test: gem_exec_reloc
results: parsing output: 109/ for test: gem_exec_whisper
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: prime_busy
results: parsing output: 113/ for test: kms_joiner
results: parsing output: 114/ for test: gem_exec_reloc
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: i915_query
results: parsing output: 117/ for test: kms_cursor_legacy
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: parsing output: 119/ for test: kms_flip
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: perf
results: parsing output: 122/ for test: gem_ctx_persistence
results: parsing output: 123/ for test: kms_chamelium_edid
results: parsing output: 124/ for test: i915_hangman
results: parsing output: 125/ for test: kms_ccs
results: parsing output: 126/ for test: kms_cursor_edge_walk
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: gem_exec_reloc
results: parsing output: 129/ for test: kms_flip
Done.