[56.963381] Initializing watchdogs
[56.963430]   /dev/watchdog0
[56.977731] [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]
[56.982377] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.984940] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.988310] [001/133] (960s left) kms_psr (fbc-psr2-sprite-blt)
[57.097665] Starting subtest: fbc-psr2-sprite-blt
[57.099938] Starting dynamic subtest: eDP-1
[57.104213] Dynamic subtest eDP-1: SKIP (0.000s)
[57.108469] Subtest fbc-psr2-sprite-blt: SKIP (0.000s)
[57.177538] [002/133] (960s left) kms_big_fb (linear-8bpp-rotate-90)
[57.281632] Starting subtest: linear-8bpp-rotate-90
[57.319350] Subtest linear-8bpp-rotate-90: SKIP (0.037s)
[57.442436] [003/133] (960s left) kms_pm_rpm (universal-planes-dpms)
[59.102195] Starting subtest: universal-planes-dpms
[59.104552] Starting dynamic subtest: plane-34
[67.680237] Dynamic subtest plane-34: SUCCESS (8.598s)
[67.689274] Starting dynamic subtest: plane-64
[76.265035] Dynamic subtest plane-64: SUCCESS (8.589s)
[76.275325] Starting dynamic subtest: plane-94
[84.575137] Dynamic subtest plane-94: SUCCESS (8.309s)
[84.585337] Starting dynamic subtest: plane-124
[92.905442] Dynamic subtest plane-124: SUCCESS (8.328s)
[92.915791] Starting dynamic subtest: plane-134
[101.586067] Dynamic subtest plane-134: SUCCESS (8.680s)
[101.595865] Starting dynamic subtest: plane-144
[109.903838] Dynamic subtest plane-144: SUCCESS (8.317s)
[109.906286] Subtest universal-planes-dpms: SUCCESS (50.828s)
[110.294597] [004/133] (907s left) tools_test (tools_test)
[110.354343] Starting subtest: tools_test
[110.401717] Subtest tools_test: SUCCESS (0.062s)
[110.457228] [005/133] (907s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[110.554046] Starting subtest: plane-upscale-20x20-with-modifiers
[110.556423] Starting dynamic subtest: pipe-A
[110.889217] Dynamic subtest pipe-A: SUCCESS (0.338s)
[110.897160] Starting dynamic subtest: pipe-B
[112.256401] Dynamic subtest pipe-B: SUCCESS (1.367s)
[112.263609] Starting dynamic subtest: pipe-C
[113.683423] Dynamic subtest pipe-C: SUCCESS (1.426s)
[113.692775] Starting dynamic subtest: pipe-D
[115.121814] Dynamic subtest pipe-D: SUCCESS (1.438s)
[115.124221] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.571s)
[116.289559] [006/133] (901s left) kms_color (invalid-ctm-matrix-sizes)
[116.398022] Starting subtest: invalid-ctm-matrix-sizes
[116.400384] Starting dynamic subtest: pipe-A
[116.402621] Dynamic subtest pipe-A: SUCCESS (0.002s)
[116.411422] Starting dynamic subtest: pipe-B
[116.413610] Dynamic subtest pipe-B: SUCCESS (0.003s)
[116.420662] Starting dynamic subtest: pipe-C
[116.422809] Dynamic subtest pipe-C: SUCCESS (0.004s)
[116.429831] Starting dynamic subtest: pipe-D
[116.431680] Dynamic subtest pipe-D: SUCCESS (0.004s)
[116.433591] Subtest invalid-ctm-matrix-sizes: SUCCESS (0.014s)
[116.492645] [007/133] (901s left) gem_softpin (noreloc-s3)
[116.556044] Starting subtest: noreloc-S3
[137.124705] Subtest noreloc-S3: SUCCESS (5.389s)
[137.236827] [008/133] (880s left) kms_cursor_crc (cursor-size-change)
[137.350937] Starting subtest: cursor-size-change
[137.353180] Starting dynamic subtest: pipe-A-eDP-1
[138.145694] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.802s)
[138.158177] Starting dynamic subtest: pipe-D-eDP-1
[139.572066] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.436s)
[139.574387] Subtest cursor-size-change: SUCCESS (2.240s)
[140.361940] [009/133] (877s left) gem_ctx_exec (basic-nohangcheck)
[140.418021] Starting subtest: basic-nohangcheck
[140.667379] Subtest basic-nohangcheck: SUCCESS (0.252s)
[140.776626] [010/133] (877s left) gem_softpin (allocator-nopin-reserve)
[140.837696] Starting subtest: allocator-nopin-reserve
[140.942889] Subtest allocator-nopin-reserve: SUCCESS (0.103s)
[141.083515] [011/133] (876s left) kms_draw_crc (fill-fb)
[141.187079] Starting subtest: fill-fb
[141.690381] Subtest fill-fb: SUCCESS (0.508s)
[141.792884] [012/133] (876s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-blt)
[141.897714] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-blt
[146.341864] Subtest fbc-1p-primscrn-pri-indfb-draw-blt: SUCCESS (4.468s)
[147.476273] [013/133] (870s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-rc-ccs-cc)
[147.574788] Starting subtest: crc-primary-suspend-y-tiled-gen12-rc-ccs-cc
[147.577162] Starting dynamic subtest: pipe-A-eDP-1
[147.586505] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[147.595961] Starting dynamic subtest: pipe-B-eDP-1
[147.605269] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[147.613582] Starting dynamic subtest: pipe-C-eDP-1
[147.622633] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[147.630988] Starting dynamic subtest: pipe-D-eDP-1
[147.639733] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[147.644104] Subtest crc-primary-suspend-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[149.811146] [014/133] (868s left) gem_ctx_shared (q-smoketest-all)
[149.889883] Starting subtest: Q-smoketest-all
[182.276295] Subtest Q-smoketest-all: SUCCESS (32.341s)
[183.159352] [015/133] (834s left) kms_psr (pr-primary-mmap-gtt)
[183.257771] Starting subtest: pr-primary-mmap-gtt
[183.261811] Subtest pr-primary-mmap-gtt: SKIP (0.000s)
[183.327967] [016/133] (834s left) api_intel_allocator (fork-simple-once)
[183.377264] Starting subtest: fork-simple-once
[183.396038] Subtest fork-simple-once: SUCCESS (0.021s)
[183.522998] [017/133] (834s left) kms_psr (fbc-psr-primary-render)
[183.616143] Starting subtest: fbc-psr-primary-render
[183.618437] Starting dynamic subtest: eDP-1
[183.622851] Dynamic subtest eDP-1: SKIP (0.000s)
[183.627360] Subtest fbc-psr-primary-render: SKIP (0.001s)
[183.701141] [018/133] (834s left) gem_ccs (block-multicopy-compressed)
[183.750018] Starting subtest: block-multicopy-compressed
[183.754472] Subtest block-multicopy-compressed: SKIP (0.000s)
[183.863151] [019/133] (834s left) gem_ctx_create (basic-files)
[183.921813] Starting subtest: basic-files
[185.928703] Subtest basic-files: SUCCESS (2.009s)
[187.260008] [020/133] (830s left) gem_lmem_swapping (heavy-verify-multi)
[187.305694] Subtest heavy-verify-multi: SKIP (0.000s)
[187.347073] [021/133] (830s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-16bpp-yftile-downscaling)
[187.437948] Starting subtest: flip-64bpp-yftile-to-16bpp-yftile-downscaling
[187.442095] Subtest flip-64bpp-yftile-to-16bpp-yftile-downscaling: SKIP (0.000s)
[187.524483] [022/133] (830s left) gem_mmap_wc (pf-nonblock)
[187.580141] Subtest pf-nonblock: SKIP (0.000s)
[187.637142] [023/133] (830s left) kms_vrr (flip-suspend)
[187.736861] Starting subtest: flip-suspend
[187.743158] Subtest flip-suspend: SKIP (0.000s)
[187.817908] [024/133] (830s left) gem_render_copy (y-tiled-to-vebox-y-tiled)
[187.871392] Starting subtest: y-tiled-to-vebox-y-tiled
[187.875726] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s)
[188.049796] [025/133] (830s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[188.112179] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[188.213069] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.102s)
[188.302342] [026/133] (830s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180)
[188.399932] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180
[188.403917] Subtest y-tiled-max-hw-stride-32bpp-rotate-180: SKIP (0.000s)
[188.498565] [027/133] (829s left) drm_read (invalid-buffer)
[188.638148] Starting subtest: invalid-buffer
[188.640455] Subtest invalid-buffer: SUCCESS (0.000s)
[188.745399] [028/133] (829s left) gem_wait (write-wait)
[188.811935] Starting subtest: write-wait
[188.814223] Starting dynamic subtest: all-engines
[189.994094] Dynamic subtest all-engines: SUCCESS (1.182s)
[190.010780] Starting dynamic subtest: rcs0
[191.047999] Dynamic subtest rcs0: SUCCESS (1.053s)
[191.064309] Starting dynamic subtest: bcs0
[192.102213] Dynamic subtest bcs0: SUCCESS (1.053s)
[192.119235] Starting dynamic subtest: vcs0
[193.157456] Dynamic subtest vcs0: SUCCESS (1.054s)
[193.172810] Starting dynamic subtest: vcs1
[194.210218] Dynamic subtest vcs1: SUCCESS (1.052s)
[194.227457] Starting dynamic subtest: vecs0
[195.263435] Dynamic subtest vecs0: SUCCESS (1.052s)
[195.279067] Starting dynamic subtest: ccs0
[196.320321] Dynamic subtest ccs0: SUCCESS (1.056s)
[196.322911] Subtest write-wait: SUCCESS (7.511s)
[196.517611] [FACT gem_wait (write-wait)] new: kernel.kmod_is_loaded.vgem: true
[196.520839] [029/133] (822s left) gem_ctx_persistence (legacy-engines-queued)
[196.583440] Starting subtest: legacy-engines-queued
[196.585685] Starting dynamic subtest: render
[196.662296] Dynamic subtest render: SUCCESS (0.079s)
[196.673291] Starting dynamic subtest: bsd1
[198.122915] Dynamic subtest bsd1: SUCCESS (1.457s)
[198.133764] Starting dynamic subtest: bsd2
[200.104161] Dynamic subtest bsd2: SUCCESS (1.979s)
[200.115361] Starting dynamic subtest: blt
[200.158930] Dynamic subtest blt: SUCCESS (0.054s)
[200.168528] Starting dynamic subtest: vebox
[202.088225] Dynamic subtest vebox: SUCCESS (1.927s)
[202.091008] Subtest legacy-engines-queued: SUCCESS (5.505s)
[202.167102] [030/133] (816s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[202.563564] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[203.400764] [031/133] (815s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[203.509497] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[212.178126] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.673s)
[212.295014] [032/133] (806s left) gem_exec_schedule (noreorder)
[212.472143] Starting subtest: noreorder
[212.474768] Starting dynamic subtest: rcs0
[212.541345] Dynamic subtest rcs0: SUCCESS (0.069s)
[212.557033] Starting dynamic subtest: vcs0
[214.063834] Dynamic subtest vcs0: SUCCESS (1.519s)
[214.075955] Starting dynamic subtest: vcs1
[216.141507] Dynamic subtest vcs1: SUCCESS (2.077s)
[216.157105] Starting dynamic subtest: vecs0
[218.118820] Dynamic subtest vecs0: SUCCESS (1.976s)
[218.129928] Starting dynamic subtest: ccs0
[218.206168] Dynamic subtest ccs0: SUCCESS (0.086s)
[218.208967] Subtest noreorder: SUCCESS (5.737s)
[218.390499] [033/133] (800s left) gem_basic (create-close)
[218.447199] Starting subtest: create-close
[218.451849] Subtest create-close: SUCCESS (0.000s)
[218.557710] [034/133] (800s left) perf (buffer-fill)
[218.677842] Starting subtest: buffer-fill
[218.680031] Starting dynamic subtest: 0-rcs0
[220.959927] Dynamic subtest 0-rcs0: SUCCESS (2.283s)
[220.969148] Starting dynamic subtest: 1-vecs0
[225.393064] Dynamic subtest 1-vecs0: SUCCESS (4.433s)
[225.396180] Subtest buffer-fill: SUCCESS (6.718s)
[225.461716] [035/133] (793s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[225.577324] Starting subtest: psr-shrfb-scaledprimary
[231.415385] Subtest psr-shrfb-scaledprimary: SUCCESS (5.841s)
[231.562193] [036/133] (787s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0)
[231.669355] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0
[232.681457] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.012s)
[232.809055] [037/133] (786s left) kms_async_flips (alternate-sync-async-flip)
[232.902161] Starting subtest: alternate-sync-async-flip
[233.277383] Starting dynamic subtest: pipe-A-eDP-1
[236.111628] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.834s)
[236.492824] Starting dynamic subtest: pipe-B-eDP-1
[239.246115] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.760s)
[239.616573] Starting dynamic subtest: pipe-C-eDP-1
[242.367410] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.759s)
[242.747312] Starting dynamic subtest: pipe-D-eDP-1
[245.502887] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.765s)
[245.504893] Subtest alternate-sync-async-flip: SUCCESS (12.598s)
[246.672611] [038/133] (772s left) perf_pmu (busy-idle-no-semaphores)
[246.728758] Starting subtest: busy-idle-no-semaphores
[246.731097] Starting dynamic subtest: rcs0
[247.392660] Dynamic subtest rcs0: SUCCESS (0.664s)
[247.405202] Starting dynamic subtest: bcs0
[248.044493] Dynamic subtest bcs0: SUCCESS (0.649s)
[248.056415] Starting dynamic subtest: vcs0
[248.696021] Dynamic subtest vcs0: SUCCESS (0.649s)
[248.706460] Starting dynamic subtest: vcs1
[250.740820] Dynamic subtest vcs1: SUCCESS (2.041s)
[250.752464] Starting dynamic subtest: vecs0
[252.789431] Dynamic subtest vecs0: SUCCESS (2.045s)
[252.801541] Starting dynamic subtest: ccs0
[254.702380] Dynamic subtest ccs0: SUCCESS (1.910s)
[254.705098] Subtest busy-idle-no-semaphores: SUCCESS (7.974s)
[254.837116] [039/133] (764s left) sw_sync (alloc_merge_fence)
[254.878592] Starting subtest: alloc_merge_fence
[254.880961] Subtest alloc_merge_fence: SUCCESS (0.001s)
[254.934580] [040/133] (764s left) gem_render_linear_blits (basic)
[254.994372] Starting subtest: basic
[255.034908] Subtest basic: SUCCESS (0.041s)
[255.125920] [041/133] (763s left) kms_dsc (dsc-fractional-bpp)
[255.225978] Starting subtest: dsc-fractional-bpp
[255.239167] Subtest dsc-fractional-bpp: SKIP (0.000s)
[255.394615] [042/133] (763s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-sf)
[255.495860] Starting subtest: fbc-pr-cursor-plane-move-continuous-sf
[255.500022] Subtest fbc-pr-cursor-plane-move-continuous-sf: SKIP (0.000s)
[255.564814] [043/133] (763s left) kms_atomic (atomic-plane-damage)
[255.647542] Starting subtest: atomic-plane-damage
[255.703059] Starting dynamic subtest: pipe-A-eDP-1
[256.268377] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.565s)
[256.270627] Subtest atomic-plane-damage: SUCCESS (0.621s)
[257.106058] [044/133] (762s left) gem_softpin (invalid)
[257.168233] Starting subtest: invalid
[257.177922] Subtest invalid: SUCCESS (0.009s)
[257.318020] [045/133] (762s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[257.434244] Starting subtest: cursor-vs-flip-varying-size
[288.393375] Subtest cursor-vs-flip-varying-size: SUCCESS (30.958s)
[289.228929] [046/133] (730s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted)
[289.289777] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted
[289.292156] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s)
[289.385878] [047/133] (730s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[289.446200] Starting subtest: multi-wait-available-submitted-signaled
[289.448184] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.000s)
[289.545329] [048/133] (729s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt)
[289.642332] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt
[296.430893] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.794s)
[296.568256] [049/133] (722s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[296.662484] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[296.664805] Starting dynamic subtest: pipe-A
[297.011716] Dynamic subtest pipe-A: SUCCESS (0.350s)
[297.024238] Starting dynamic subtest: pipe-B
[298.423983] Dynamic subtest pipe-B: SUCCESS (1.410s)
[298.433551] Starting dynamic subtest: pipe-C
[299.862934] Dynamic subtest pipe-C: SUCCESS (1.438s)
[299.872324] Starting dynamic subtest: pipe-D
[301.294249] Dynamic subtest pipe-D: SUCCESS (1.430s)
[301.296698] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.634s)
[302.472439] [050/133] (717s left) i915_drm_fdinfo (memory-info-purgeable)
[302.510850] Starting subtest: memory-info-purgeable
[302.513192] Starting dynamic subtest: smem0
[305.111767] Dynamic subtest smem0: SUCCESS (2.602s)
[305.114163] Subtest memory-info-purgeable: SUCCESS (2.603s)
[305.191061] [051/133] (714s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[305.298264] Starting subtest: psr2-cursor-plane-update-sf
[305.299803] Starting dynamic subtest: pipe-A-eDP-1
[305.893691] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.595s)
[305.903764] Starting dynamic subtest: pipe-B-eDP-1
[307.153012] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.259s)
[307.155387] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.857s)
[308.026242] [052/133] (711s left) gem_request_retire (retire-vma-not-inactive)
[308.080887] Starting subtest: retire-vma-not-inactive
[308.140590] Subtest retire-vma-not-inactive: SUCCESS (0.057s)
[308.275834] [053/133] (711s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[308.329256] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[308.438438] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.109s)
[308.516264] [054/133] (711s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs)
[308.612018] Starting subtest: ccs-on-another-bo-y-tiled-ccs
[308.614312] Starting dynamic subtest: pipe-A-eDP-1
[308.636195] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[308.647116] Starting dynamic subtest: pipe-B-eDP-1
[308.667987] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[308.676550] Starting dynamic subtest: pipe-C-eDP-1
[308.697190] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[308.705586] Starting dynamic subtest: pipe-D-eDP-1
[308.726579] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[308.730747] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.005s)
[310.886233] [055/133] (708s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[311.263212] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[312.102512] [056/133] (707s left) perf (invalid-remove-userspace-config)
[312.188440] Starting subtest: invalid-remove-userspace-config
[312.199905] Subtest invalid-remove-userspace-config: SUCCESS (0.012s)
[312.243596] [057/133] (707s left) kms_vblank (query-idle)
[312.345817] Starting subtest: query-idle
[312.347914] Starting dynamic subtest: pipe-A-eDP-1
[314.094557] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.748s)
[314.108914] Starting dynamic subtest: pipe-D-eDP-1
[316.566328] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.469s)
[316.568498] Subtest query-idle: SUCCESS (4.221s)
[317.397617] [058/133] (702s left) i915_pm_rpm (gem-idle)
[322.150448] Starting subtest: gem-idle
[328.340871] Subtest gem-idle: SUCCESS (6.193s)
[328.676504] [059/133] (691s left) gem_exec_fence (syncobj-timeline-signal)
[330.523801] Starting subtest: syncobj-timeline-signal
[330.527575] Subtest syncobj-timeline-signal: SUCCESS (0.008s)
[332.198585] [060/133] (687s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render)
[332.337549] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render
[339.662252] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.328s)
[339.776010] [061/133] (680s left) gen7_exec_parse (chained-batch)
[339.842894] Subtest chained-batch: SKIP (0.000s)
[339.923221] [062/133] (680s left) kms_psr (psr2-no-drrs)
[340.011183] Starting subtest: psr2-no-drrs
[340.013396] Starting dynamic subtest: eDP-1
[341.664079] Dynamic subtest eDP-1: SUCCESS (1.653s)
[341.666637] Subtest psr2-no-drrs: SUCCESS (1.654s)
[342.457888] [063/133] (677s left) kms_lease (lease-invalid-connector)
[342.553192] Starting subtest: lease-invalid-connector
[342.555714] Starting dynamic subtest: pipe-A-eDP-1
[342.557788] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s)
[342.576663] Starting dynamic subtest: pipe-B-eDP-1
[342.579091] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[342.597319] Starting dynamic subtest: pipe-C-eDP-1
[342.599384] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[342.610912] Starting dynamic subtest: pipe-D-eDP-1
[342.612742] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[342.614596] Subtest lease-invalid-connector: SUCCESS (0.005s)
[342.654774] [064/133] (677s left) kms_psr (psr-sprite-render)
[342.759320] Starting subtest: psr-sprite-render
[342.761547] Starting dynamic subtest: eDP-1
[344.478778] Dynamic subtest eDP-1: SUCCESS (1.717s)
[344.480912] Subtest psr-sprite-render: SUCCESS (1.719s)
[345.332175] [065/133] (674s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt)
[345.438255] Starting subtest: fbcpsr-farfromfence-mmap-gtt
[345.442696] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s)
[345.548493] [066/133] (674s left) syncobj_wait (wait-all-for-submit-snapshot)
[345.614006] Starting subtest: wait-all-for-submit-snapshot
[345.693367] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[345.777098] [067/133] (674s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[345.882921] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[345.887347] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[345.979068] [068/133] (674s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[346.081074] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[350.065467] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (3.990s)
[351.245613] [069/133] (669s left) gem_exec_balancer (busy)
[351.309951] Starting subtest: busy
[353.100729] Subtest busy: SUCCESS (1.793s)
[353.414608] [070/133] (667s left) gem_exec_schedule (timeslicing)
[353.496963] Starting subtest: timeslicing
[353.499069] Starting dynamic subtest: rcs0
[353.510816] Dynamic subtest rcs0: SUCCESS (0.022s)
[353.522145] Starting dynamic subtest: bcs0
[353.532435] Dynamic subtest bcs0: SUCCESS (0.021s)
[353.541636] Starting dynamic subtest: vcs0
[353.553615] Dynamic subtest vcs0: SUCCESS (0.020s)
[353.562927] Starting dynamic subtest: vcs1
[353.574533] Dynamic subtest vcs1: SUCCESS (0.020s)
[353.583893] Starting dynamic subtest: vecs0
[353.595460] Dynamic subtest vecs0: SUCCESS (0.020s)
[353.604793] Starting dynamic subtest: ccs0
[353.615406] Dynamic subtest ccs0: SUCCESS (0.019s)
[353.617627] Subtest timeslicing: SUCCESS (0.127s)
[355.187536] [071/133] (665s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[355.286453] Starting subtest: 4-tiled-64bpp-rotate-90
[355.306703] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.020s)
[355.413077] [072/133] (665s left) gem_ctx_param (invalid-param-set)
[355.472096] Starting subtest: invalid-param-set
[355.473979] Subtest invalid-param-set: SUCCESS (0.000s)
[355.558366] [073/133] (664s left) gem_render_copy_redux (normal)
[355.624952] Starting subtest: normal
[355.888201] Subtest normal: SUCCESS (0.265s)
[356.011845] [074/133] (664s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[356.075677] Starting subtest: invalid-bsd2-flag-on-blt
[356.077970] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[356.187703] [075/133] (664s left) kms_flip (2x-wf_vblank-ts-check-interruptible)
[356.278041] Starting subtest: 2x-wf_vblank-ts-check-interruptible
[356.288661] Subtest 2x-wf_vblank-ts-check-interruptible: SKIP (0.011s)
[356.366010] [076/133] (664s left) kms_setmode (basic)
[356.419260] Starting subtest: basic
[356.741080] Starting dynamic subtest: pipe-A-eDP-1
[358.851220] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.105s)
[359.193195] Starting dynamic subtest: pipe-B-eDP-1
[361.274837] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.085s)
[361.585604] Subtest basic: SUCCESS (5.160s)
[362.424314] [077/133] (658s left) kms_selftest (drm_cmdline_parser)
[362.465532] Starting subtest: drm_cmdline_parser
[362.482717] Starting dynamic subtest: drm_test_cmdline_force_d_only
[362.562233] Dynamic subtest drm_test_cmdline_force_d_only: SUCCESS (0.079s)
[362.572692] Starting dynamic subtest: drm_test_cmdline_force_D_only_dvi
[362.654977] Dynamic subtest drm_test_cmdline_force_D_only_dvi: SUCCESS (0.092s)
[362.665783] Starting dynamic subtest: drm_test_cmdline_force_D_only_hdmi
[362.744293] Dynamic subtest drm_test_cmdline_force_D_only_hdmi: SUCCESS (0.089s)
[362.755049] Starting dynamic subtest: drm_test_cmdline_force_D_only_not_digital
[362.852336] Dynamic subtest drm_test_cmdline_force_D_only_not_digital: SUCCESS (0.106s)
[362.863102] Starting dynamic subtest: drm_test_cmdline_force_e_only
[362.955322] Dynamic subtest drm_test_cmdline_force_e_only: SUCCESS (0.103s)
[362.966137] Starting dynamic subtest: drm_test_cmdline_res
[363.056408] Dynamic subtest drm_test_cmdline_res: SUCCESS (0.100s)
[363.067239] Starting dynamic subtest: drm_test_cmdline_res_vesa
[363.150261] Dynamic subtest drm_test_cmdline_res_vesa: SUCCESS (0.094s)
[363.161075] Starting dynamic subtest: drm_test_cmdline_res_vesa_rblank
[363.260291] Dynamic subtest drm_test_cmdline_res_vesa_rblank: SUCCESS (0.107s)
[363.270615] Starting dynamic subtest: drm_test_cmdline_res_rblank
[363.355447] Dynamic subtest drm_test_cmdline_res_rblank: SUCCESS (0.095s)
[363.365854] Starting dynamic subtest: drm_test_cmdline_res_bpp
[363.450634] Dynamic subtest drm_test_cmdline_res_bpp: SUCCESS (0.095s)
[363.460976] Starting dynamic subtest: drm_test_cmdline_res_refresh
[363.555679] Dynamic subtest drm_test_cmdline_res_refresh: SUCCESS (0.103s)
[363.565845] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh
[363.659439] Dynamic subtest drm_test_cmdline_res_bpp_refresh: SUCCESS (0.103s)
[363.668844] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced
[363.747735] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced: SUCCESS (0.086s)
[363.757791] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_margins
[363.857909] Dynamic subtest drm_test_cmdline_res_bpp_refresh_margins: SUCCESS (0.110s)
[363.868292] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_off
[363.959252] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_off: SUCCESS (0.101s)
[363.967508] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on
[364.061444] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on: SUCCESS (0.101s)
[364.071074] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_analog
[364.146648] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_analog: SUCCESS (0.085s)
[364.155149] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_force_on_digital
[364.234635] Dynamic subtest drm_test_cmdline_res_bpp_refresh_force_on_digital: SUCCESS (0.087s)
[364.243278] Starting dynamic subtest: drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on
[364.330787] Dynamic subtest drm_test_cmdline_res_bpp_refresh_interlaced_margins_force_on: SUCCESS (0.096s)
[364.339321] Starting dynamic subtest: drm_test_cmdline_res_margins_force_on
[364.436670] Dynamic subtest drm_test_cmdline_res_margins_force_on: SUCCESS (0.105s)
[364.445468] Starting dynamic subtest: drm_test_cmdline_res_vesa_margins
[364.529032] Dynamic subtest drm_test_cmdline_res_vesa_margins: SUCCESS (0.091s)
[364.537693] Starting dynamic subtest: drm_test_cmdline_name
[364.636909] Dynamic subtest drm_test_cmdline_name: SUCCESS (0.108s)
[364.645686] Starting dynamic subtest: drm_test_cmdline_name_bpp
[364.737516] Dynamic subtest drm_test_cmdline_name_bpp: SUCCESS (0.099s)
[364.747565] Starting dynamic subtest: drm_test_cmdline_name_option
[364.831636] Dynamic subtest drm_test_cmdline_name_option: SUCCESS (0.094s)
[364.840148] Starting dynamic subtest: drm_test_cmdline_name_bpp_option
[364.946667] Dynamic subtest drm_test_cmdline_name_bpp_option: SUCCESS (0.115s)
[364.955253] Starting dynamic subtest: drm_test_cmdline_rotate_0
[365.058623] Dynamic subtest drm_test_cmdline_rotate_0: SUCCESS (0.111s)
[365.067242] Starting dynamic subtest: drm_test_cmdline_rotate_90
[365.146137] Dynamic subtest drm_test_cmdline_rotate_90: SUCCESS (0.085s)
[365.161750] Starting dynamic subtest: drm_test_cmdline_rotate_180
[365.231805] Dynamic subtest drm_test_cmdline_rotate_180: SUCCESS (0.086s)
[365.240463] Starting dynamic subtest: drm_test_cmdline_rotate_270
[365.313765] Dynamic subtest drm_test_cmdline_rotate_270: SUCCESS (0.081s)
[365.324337] Starting dynamic subtest: drm_test_cmdline_hmirror
[365.406162] Dynamic subtest drm_test_cmdline_hmirror: SUCCESS (0.090s)
[365.415968] Starting dynamic subtest: drm_test_cmdline_vmirror
[365.511482] Dynamic subtest drm_test_cmdline_vmirror: SUCCESS (0.104s)
[365.520480] Starting dynamic subtest: drm_test_cmdline_margin_options
[365.602431] Dynamic subtest drm_test_cmdline_margin_options: SUCCESS (0.090s)
[365.612931] Starting dynamic subtest: drm_test_cmdline_multiple_options
[365.692756] Dynamic subtest drm_test_cmdline_multiple_options: SUCCESS (0.089s)
[365.703166] Starting dynamic subtest: drm_test_cmdline_bpp_extra_and_option
[365.776426] Dynamic subtest drm_test_cmdline_bpp_extra_and_option: SUCCESS (0.083s)
[365.785933] Starting dynamic subtest: drm_test_cmdline_extra_and_option
[365.869369] Dynamic subtest drm_test_cmdline_extra_and_option: SUCCESS (0.093s)
[365.878064] Starting dynamic subtest: drm_test_cmdline_freestanding_options
[365.965474] Dynamic subtest drm_test_cmdline_freestanding_options: SUCCESS (0.094s)
[365.975347] Starting dynamic subtest: drm_test_cmdline_freestanding_force_e_and_options
[366.059480] Dynamic subtest drm_test_cmdline_freestanding_force_e_and_options: SUCCESS (0.093s)
[366.069791] Starting dynamic subtest: drm_test_cmdline_panel_orientation
[366.151622] Dynamic subtest drm_test_cmdline_panel_orientation: SUCCESS (0.091s)
[366.162040] Starting dynamic subtest: drm_test_cmdline_invalid
[366.259343] Dynamic subtest drm_test_cmdline_invalid: SUCCESS (0.108s)
[366.268287] Starting dynamic subtest: drm_test_cmdline_tv_options
[366.367696] Dynamic subtest drm_test_cmdline_tv_options: SUCCESS (0.108s)
[366.369620] Subtest drm_cmdline_parser: SUCCESS (3.904s)
[366.520593] [078/133] (654s left) kms_content_protection (dp-mst-lic-type-0)
[366.663700] Starting subtest: dp-mst-lic-type-0
[366.667524] Subtest dp-mst-lic-type-0: SKIP (0.000s)
[366.780333] [079/133] (654s left) kms_flip (2x-flip-vs-suspend)
[366.887385] Starting subtest: 2x-flip-vs-suspend
[366.897504] Subtest 2x-flip-vs-suspend: SKIP (0.011s)
[366.990917] [080/133] (653s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions)
[367.103971] Starting subtest: cursorB-vs-flipB-atomic-transitions
[367.107709] Subtest cursorB-vs-flipB-atomic-transitions: SKIP (0.001s)
[367.256550] [081/133] (653s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[367.362984] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[367.366609] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[367.466031] [082/133] (653s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted)
[367.521717] Starting subtest: invalid-multi-wait-all-unsubmitted
[367.523738] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[367.613069] [083/133] (653s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[367.712738] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[367.716274] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[367.816463] [084/133] (653s left) syncobj_timeline (signal-point-0)
[367.870067] Starting subtest: signal-point-0
[367.872071] Subtest signal-point-0: SUCCESS (0.000s)
[367.961563] [085/133] (653s left) sysfs_defaults (readonly)
[368.021323] Starting subtest: readonly
[368.023215] Starting dynamic subtest: vecs0
[368.025179] Dynamic subtest vecs0: SUCCESS (0.000s)
[368.034632] Starting dynamic subtest: ccs0
[368.036250] Dynamic subtest ccs0: SUCCESS (0.000s)
[368.044658] Starting dynamic subtest: vcs0
[368.046283] Dynamic subtest vcs0: SUCCESS (0.000s)
[368.054482] Starting dynamic subtest: bcs0
[368.056175] Dynamic subtest bcs0: SUCCESS (0.000s)
[368.064971] Starting dynamic subtest: rcs0
[368.066850] Dynamic subtest rcs0: SUCCESS (0.000s)
[368.075509] Starting dynamic subtest: vcs1
[368.077155] Dynamic subtest vcs1: SUCCESS (0.000s)
[368.078847] Subtest readonly: SUCCESS (0.006s)
[368.118575] [086/133] (652s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render)
[368.213246] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render
[368.216889] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[368.331270] [087/133] (652s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt)
[368.415035] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt
[372.884479] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (4.471s)
[374.023942] [088/133] (647s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[374.143408] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[381.028654] Subtest psr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.890s)
[381.168961] [089/133] (640s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[381.229219] Starting subtest: invalid-signal-one-illegal-handle
[381.231485] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[381.332247] [090/133] (639s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-msflip-blt)
[381.424442] Starting subtest: fbcpsr-2p-scndscrn-indfb-msflip-blt
[381.428819] Subtest fbcpsr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[381.518642] [091/133] (639s left) kms_pm_backlight (fade-with-dpms)
[381.611255] Starting subtest: fade-with-dpms
[383.700046] Starting dynamic subtest: eDP-1
[386.195372] Dynamic subtest eDP-1: SUCCESS (2.496s)
[386.197959] Subtest fade-with-dpms: SUCCESS (4.587s)
[386.996459] [092/133] (634s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[387.097505] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[387.099513] Starting dynamic subtest: pipe-A-eDP-1
[403.404501] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.402s)
[403.415093] Starting dynamic subtest: pipe-B-eDP-1
[420.363618] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.429s)
[420.373125] Starting dynamic subtest: pipe-C-eDP-1
[437.320566] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.344s)
[437.330931] Starting dynamic subtest: pipe-D-eDP-1
[454.339296] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.389s)
[454.342215] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (8.570s)
[455.546038] [093/133] (565s left) i915_power (sanity)
[455.617313] Starting subtest: sanity
[459.663719] Subtest sanity: SUCCESS (4.076s)
[460.938754] [094/133] (560s left) gem_render_copy (x-tiled-to-vebox-yf-tiled)
[461.001704] Starting subtest: x-tiled-to-vebox-yf-tiled
[461.006428] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[461.192978] [095/133] (560s left) dumb_buffer (invalid-bpp)
[461.246409] Starting subtest: invalid-bpp
[461.249262] Subtest invalid-bpp: SUCCESS (0.000s)
[461.350350] [096/133] (560s left) gem_exec_fence (basic-wait)
[461.542093] Starting subtest: basic-wait
[461.544673] Starting dynamic subtest: rcs0
[461.627291] Dynamic subtest rcs0: SUCCESS (0.085s)
[461.640027] Starting dynamic subtest: bcs0
[461.681619] Dynamic subtest bcs0: SUCCESS (0.052s)
[461.693272] Starting dynamic subtest: vcs0
[461.737614] Dynamic subtest vcs0: SUCCESS (0.053s)
[461.749656] Starting dynamic subtest: vcs1
[461.789986] Dynamic subtest vcs1: SUCCESS (0.051s)
[461.801386] Starting dynamic subtest: vecs0
[461.844315] Dynamic subtest vecs0: SUCCESS (0.053s)
[461.854321] Starting dynamic subtest: ccs0
[461.899087] Dynamic subtest ccs0: SUCCESS (0.053s)
[461.902017] Subtest basic-wait: SUCCESS (0.360s)
[463.967256] [097/133] (557s left) i915_module_load (resize-bar)
[463.999251] Starting subtest: resize-bar
[464.008056] Subtest resize-bar: SKIP (0.006s)
[464.052676] [098/133] (557s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt)
[464.162024] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt
[471.528775] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.395s)
[471.698921] [099/133] (549s left) gem_partial_pwrite_pread (write-snoop)
[471.754197] Subtest write-snoop: SKIP (0.000s)
[471.833792] [100/133] (549s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all)
[471.887216] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all
[471.971439] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.019s)
[472.010024] [101/133] (549s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier)
[472.107850] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier
[472.134404] Starting dynamic subtest: pipe-A-plane-0
[472.433976] Dynamic subtest pipe-A-plane-0: SUCCESS (0.300s)
[472.443578] Starting dynamic subtest: pipe-A-plane-3
[472.699682] Dynamic subtest pipe-A-plane-3: SUCCESS (0.264s)
[472.708943] Starting dynamic subtest: pipe-A-plane-5
[472.712612] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[473.762899] Starting dynamic subtest: pipe-B-plane-0
[474.066156] Dynamic subtest pipe-B-plane-0: SUCCESS (0.311s)
[474.076022] Starting dynamic subtest: pipe-B-plane-3
[474.310001] Dynamic subtest pipe-B-plane-3: SUCCESS (0.244s)
[474.319429] Starting dynamic subtest: pipe-B-plane-5
[474.324035] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[474.619475] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SUCCESS (2.516s)
[475.434807] [102/133] (546s left) gem_exec_flush (basic-uc-prw-default)
[475.492320] Starting subtest: basic-uc-prw-default
[480.970573] Subtest basic-uc-prw-default: SUCCESS (5.485s)
[481.171511] [103/133] (540s left) kms_cursor_crc (cursor-onscreen-256x256)
[481.424698] Starting subtest: cursor-onscreen-256x256
[481.429878] Starting dynamic subtest: pipe-A-eDP-1
[483.556103] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.127s)
[483.587033] Starting dynamic subtest: pipe-D-eDP-1
[486.326398] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.749s)
[486.329217] Subtest cursor-onscreen-256x256: SUCCESS (4.903s)
[487.184205] [104/133] (534s left) gem_exec_reloc (basic-gtt-read)
[487.246254] Subtest basic-gtt-read: SKIP (0.000s)
[487.324468] [105/133] (534s left) kms_plane_lowres (tiling-none)
[487.410401] Starting subtest: tiling-none
[487.412731] Starting dynamic subtest: pipe-A-eDP-1
[487.417258] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[487.704049] Starting dynamic subtest: pipe-B-eDP-1
[487.708564] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[487.717585] Starting dynamic subtest: pipe-C-eDP-1
[487.722267] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[487.731714] Starting dynamic subtest: pipe-D-eDP-1
[487.736872] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[487.741249] Subtest tiling-none: SKIP (0.294s)
[488.518312] [106/133] (533s left) gem_exec_reloc (basic-gtt)
[488.571508] Subtest basic-gtt: SKIP (0.000s)
[488.640325] [107/133] (533s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-gtt)
[488.739299] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-gtt
[488.744367] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[488.847537] [108/133] (533s left) kms_cursor_crc (cursor-sliding-64x21)
[489.051466] Starting subtest: cursor-sliding-64x21
[489.101066] Subtest cursor-sliding-64x21: SKIP (0.046s)
[489.338524] [109/133] (532s left) gem_cs_tlb (engines)
[489.395806] Starting subtest: engines
[489.397865] Starting dynamic subtest: rcs0
[491.550254] Dynamic subtest rcs0: SUCCESS (2.152s)
[491.560575] Starting dynamic subtest: bcs0
[493.705659] Dynamic subtest bcs0: SUCCESS (2.155s)
[493.715366] Starting dynamic subtest: vcs0
[495.861439] Dynamic subtest vcs0: SUCCESS (2.153s)
[495.871207] Starting dynamic subtest: vcs1
[498.015107] Dynamic subtest vcs1: SUCCESS (2.152s)
[498.025852] Starting dynamic subtest: vecs0
[500.169047] Dynamic subtest vecs0: SUCCESS (2.153s)
[500.180444] Starting dynamic subtest: ccs0
[502.323465] Dynamic subtest ccs0: SUCCESS (2.154s)
[502.325941] Subtest engines: SUCCESS (12.925s)
[502.449322] [110/133] (519s left) gem_mmap_wc (close)
[502.512111] Subtest close: SKIP (0.000s)
[502.574994] [111/133] (519s left) template (b)
[502.623674] Starting subtest: B
[502.625979] Subtest B: SUCCESS (0.000s)
[502.718514] [112/133] (519s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[502.827953] Starting subtest: x-tiled-16bpp-rotate-0
[504.075237] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.246s)
[504.223953] [113/133] (518s left) prime_mmap (test_dup)
[504.282160] Starting subtest: test_dup
[504.284388] Starting dynamic subtest: test_dup-smem
[504.312762] Dynamic subtest test_dup-smem: SUCCESS (0.033s)
[504.315247] Subtest test_dup: SUCCESS (0.033s)
[504.390230] [114/133] (517s left) gem_pread (display)
[504.447893] Subtest display: SKIP (0.000s)
[504.506502] [115/133] (517s left) kms_invalid_mode (bad-hsync-start)
[504.602836] Starting subtest: bad-hsync-start
[504.604784] Starting dynamic subtest: pipe-A-eDP-1
[504.891714] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.287s)
[504.902453] Starting dynamic subtest: pipe-B-eDP-1
[504.905232] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[504.914698] Starting dynamic subtest: pipe-C-eDP-1
[504.916927] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[504.926118] Starting dynamic subtest: pipe-D-eDP-1
[504.928423] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[504.931268] Subtest bad-hsync-start: SUCCESS (0.293s)
[505.730324] [116/133] (516s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[505.825307] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[505.830401] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[505.923955] [117/133] (516s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[506.010989] Starting subtest: compare-crc-sanitycheck-nv12
[506.012929] Starting dynamic subtest: pipe-A-eDP-1
[506.708443] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.697s)
[506.718893] Starting dynamic subtest: pipe-B-eDP-1
[508.007184] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.298s)
[508.019212] Starting dynamic subtest: pipe-C-eDP-1
[509.306395] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.298s)
[509.317696] Starting dynamic subtest: pipe-D-eDP-1
[510.522297] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.213s)
[510.524876] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.512s)
[511.352858] [118/133] (511s left) gem_mmap_gtt (fault-concurrent-y)
[511.418864] Subtest fault-concurrent-Y: SKIP (0.000s)
[511.484071] [119/133] (511s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[511.555194] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[511.622140] [120/133] (510s left) api_intel_bb (render-ccs)
[511.678425] Starting subtest: render-ccs
[512.264661] Subtest render-ccs: SUCCESS (0.588s)
[512.368871] [121/133] (510s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[512.467281] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[512.469874] Starting dynamic subtest: pipe-A-eDP-1
[512.495240] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[512.505443] Starting dynamic subtest: pipe-B-eDP-1
[512.531142] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[512.540307] Starting dynamic subtest: pipe-C-eDP-1
[512.565434] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[512.574290] Starting dynamic subtest: pipe-D-eDP-1
[512.599607] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[512.604113] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[514.711659] [122/133] (507s left) gem_exec_whisper (basic-contexts-all)
[514.779366] Starting subtest: basic-contexts-all
[524.929269] Subtest basic-contexts-all: SUCCESS (10.150s)
[525.112851] [123/133] (497s left) kms_flip (busy-flip)
[525.222976] Starting subtest: busy-flip
[525.225698] Starting dynamic subtest: A-eDP1
[526.918979] Dynamic subtest A-eDP1: SUCCESS (1.699s)
[526.928923] Starting dynamic subtest: B-eDP1
[528.657200] Dynamic subtest B-eDP1: SUCCESS (1.736s)
[528.668642] Starting dynamic subtest: C-eDP1
[530.380006] Dynamic subtest C-eDP1: SUCCESS (1.720s)
[530.390834] Starting dynamic subtest: D-eDP1
[532.011889] Dynamic subtest D-eDP1: SUCCESS (1.632s)
[532.014287] Subtest busy-flip: SUCCESS (6.799s)
[533.174821] [124/133] (489s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite)
[533.271066] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite
[537.672423] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (4.408s)
[538.890926] [125/133] (483s left) kms_dp_linktrain_fallback (dsc-fallback)
[538.989439] Starting subtest: dsc-fallback
[538.997162] Subtest dsc-fallback: SKIP (0.000s)
[539.060979] [126/133] (483s left) gem_exec_alignment (single)
[539.127938] Starting subtest: single
[539.133437] Subtest single: SUCCESS (0.004s)
[539.224039] [127/133] (483s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0)
[539.331167] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0
[539.336250] Subtest y-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s)
[539.434657] [128/133] (483s left) kms_ccs (bad-pixel-format-y-tiled-gen12-mc-ccs)
[539.523193] Starting subtest: bad-pixel-format-y-tiled-gen12-mc-ccs
[539.526121] Starting dynamic subtest: pipe-A-eDP-1
[539.552229] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[539.562551] Starting dynamic subtest: pipe-B-eDP-1
[539.588290] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[539.597673] Starting dynamic subtest: pipe-C-eDP-1
[539.622364] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[539.631404] Starting dynamic subtest: pipe-D-eDP-1
[539.657534] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[539.662737] Subtest bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[541.836233] [129/133] (481s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[541.940835] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[541.943586] Starting dynamic subtest: pipe-A-eDP-1
[542.037332] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[542.048821] Starting dynamic subtest: pipe-B-eDP-1
[543.217446] Dynamic subtest pipe-B-eDP-1: SKIP (1.177s)
[543.223274] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.280s)
[544.407101] [130/133] (478s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[544.468018] Subtest basic-cpu-wc-noreloc: SKIP (0.000s)
[544.539247] [131/133] (478s left) gem_exec_fence (syncobj-channel)
[544.994063] Starting subtest: syncobj-channel
[546.017806] Subtest syncobj-channel: SUCCESS (1.020s)
[546.985110] [132/133] (476s left) kms_cursor_crc (cursor-random-256x256)
[547.237311] Starting subtest: cursor-random-256x256
[547.243247] Starting dynamic subtest: pipe-A-eDP-1
[550.632425] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.391s)
[550.663137] Starting dynamic subtest: pipe-D-eDP-1
[554.608744] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.951s)
[554.611300] Subtest cursor-random-256x256: SUCCESS (7.369s)
[555.473964] [133/133] (467s left) syncobj_wait (reset-signaled)
[555.531564] Starting subtest: reset-signaled
[555.534257] Subtest reset-signaled: SUCCESS (0.000s)
[555.637970] Closing watchdogs
results: parsing output: 0/ for test: kms_psr
results: parsing output: 1/ for test: kms_big_fb
results: parsing output: 2/ for test: kms_pm_rpm
results: parsing output: 3/ for test: tools_test
results: parsing output: 4/ for test: kms_plane_scaling
results: parsing output: 5/ for test: kms_color
results: parsing output: 6/ for test: gem_softpin
results: parsing output: 7/ for test: kms_cursor_crc
results: parsing output: 8/ for test: gem_ctx_exec
results: parsing output: 9/ for test: gem_softpin
results: parsing output: 10/ for test: kms_draw_crc
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_ccs
results: parsing output: 13/ for test: gem_ctx_shared
results: parsing output: 14/ for test: kms_psr
results: parsing output: 15/ for test: api_intel_allocator
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: gem_ccs
results: parsing output: 18/ for test: gem_ctx_create
results: parsing output: 19/ for test: gem_lmem_swapping
results: parsing output: 20/ for test: kms_flip_scaled_crc
results: parsing output: 21/ for test: gem_mmap_wc
results: parsing output: 22/ for test: kms_vrr
results: parsing output: 23/ for test: gem_render_copy
results: parsing output: 24/ for test: syncobj_wait
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: drm_read
results: parsing output: 27/ for test: gem_wait
results: parsing output: 28/ for test: gem_ctx_persistence
results: parsing output: 29/ for test: kms_chamelium_edid
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: gem_exec_schedule
results: parsing output: 32/ for test: gem_basic
results: parsing output: 33/ for test: perf
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: kms_async_flips
results: parsing output: 37/ for test: perf_pmu
results: parsing output: 38/ for test: sw_sync
results: parsing output: 39/ for test: gem_render_linear_blits
results: parsing output: 40/ for test: kms_dsc
results: parsing output: 41/ for test: kms_psr2_sf
results: parsing output: 42/ for test: kms_atomic
results: parsing output: 43/ for test: gem_softpin
results: parsing output: 44/ for test: kms_cursor_legacy
results: parsing output: 45/ for test: syncobj_wait
results: parsing output: 46/ for test: syncobj_timeline
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_plane_scaling
results: parsing output: 49/ for test: i915_drm_fdinfo
results: parsing output: 50/ for test: kms_psr2_sf
results: parsing output: 51/ for test: gem_request_retire
results: parsing output: 52/ for test: syncobj_timeline
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: kms_chamelium_hpd
results: parsing output: 55/ for test: perf
results: parsing output: 56/ for test: kms_vblank
results: parsing output: 57/ for test: i915_pm_rpm
results: parsing output: 58/ for test: gem_exec_fence
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: gen7_exec_parse
results: parsing output: 61/ for test: kms_psr
results: parsing output: 62/ for test: kms_lease
results: parsing output: 63/ for test: kms_psr
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: syncobj_wait
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: gem_exec_balancer
results: parsing output: 69/ for test: gem_exec_schedule
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: gem_ctx_param
results: parsing output: 72/ for test: gem_render_copy_redux
results: parsing output: 73/ for test: gem_exec_params
results: parsing output: 74/ for test: kms_flip
results: parsing output: 75/ for test: kms_setmode
results: parsing output: 76/ for test: kms_selftest
results: parsing output: 77/ for test: kms_content_protection
results: parsing output: 78/ for test: kms_flip
results: parsing output: 79/ for test: kms_cursor_legacy
results: parsing output: 80/ for test: kms_frontbuffer_tracking
results: parsing output: 81/ for test: syncobj_timeline
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: sysfs_defaults
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: syncobj_timeline
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_pm_backlight
results: parsing output: 91/ for test: kms_ccs
results: parsing output: 92/ for test: i915_power
results: parsing output: 93/ for test: gem_render_copy
results: parsing output: 94/ for test: dumb_buffer
results: parsing output: 95/ for test: gem_exec_fence
results: parsing output: 96/ for test: i915_module_load
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: gem_partial_pwrite_pread
results: parsing output: 99/ for test: sriov_basic
results: parsing output: 100/ for test: kms_plane
results: parsing output: 101/ for test: gem_exec_flush
results: parsing output: 102/ for test: kms_cursor_crc
results: parsing output: 103/ for test: gem_exec_reloc
results: parsing output: 104/ for test: kms_plane_lowres
results: parsing output: 105/ for test: gem_exec_reloc
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_cursor_crc
results: parsing output: 108/ for test: gem_cs_tlb
results: parsing output: 109/ for test: gem_mmap_wc
results: parsing output: 110/ for test: template
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: prime_mmap
results: parsing output: 113/ for test: gem_pread
results: parsing output: 114/ for test: kms_invalid_mode
results: parsing output: 115/ for test: kms_big_fb
results: parsing output: 116/ for test: kms_pipe_crc_basic
results: parsing output: 117/ for test: gem_mmap_gtt
results: parsing output: 118/ for test: gem_mmap_gtt
results: parsing output: 119/ for test: api_intel_bb
results: parsing output: 120/ for test: kms_ccs
results: parsing output: 121/ for test: gem_exec_whisper
results: parsing output: 122/ for test: kms_flip
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: kms_dp_linktrain_fallback
results: parsing output: 125/ for test: gem_exec_alignment
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: kms_ccs
results: parsing output: 128/ for test: kms_psr2_sf
results: parsing output: 129/ for test: gem_exec_reloc
results: parsing output: 130/ for test: gem_exec_fence
results: parsing output: 131/ for test: kms_cursor_crc
results: parsing output: 132/ for test: syncobj_wait
Done.