[57.812163] Initializing watchdogs
[57.812293]   /dev/watchdog0
[57.827761] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.832356] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.834571] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.838271] [001/133] (960s left) kms_fb_coherency (memset-crc)
[57.956286] Starting subtest: memset-crc
[57.958635] Starting dynamic subtest: mmap-offset-wc
[58.396723] Dynamic subtest mmap-offset-wc: SUCCESS (0.439s)
[58.701276] Starting dynamic subtest: mmap-offset-uc
[64.734684] Dynamic subtest mmap-offset-uc: SUCCESS (6.016s)
[65.016701] Subtest memset-crc: SUCCESS (7.030s)
[65.854140] [002/133] (952s left) gem_exec_reloc (basic-write-wc)
[65.916177] Subtest basic-write-wc: SKIP (0.000s)
[65.995181] [003/133] (952s left) gem_exec_params (invalid-bsd2-flag-on-render)
[66.053599] Starting subtest: invalid-bsd2-flag-on-render
[66.056066] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[66.158783] [004/133] (952s left) gem_render_copy (linear)
[66.215717] Starting subtest: linear
[66.217669] Starting dynamic subtest: smem
[66.254708] Dynamic subtest smem: SUCCESS (0.041s)
[66.257074] Subtest linear: SUCCESS (0.041s)
[66.478586] [005/133] (952s left) core_auth (basic-auth)
[66.532920] Starting subtest: basic-auth
[66.535039] Subtest basic-auth: SUCCESS (0.001s)
[66.629836] [006/133] (951s left) kms_flip (flip-vs-modeset-vs-hang)
[66.794211] Starting subtest: flip-vs-modeset-vs-hang
[66.796824] Starting dynamic subtest: A-eDP1
[106.354544] Dynamic subtest A-eDP1: SUCCESS (39.538s)
[106.364879] Starting dynamic subtest: D-eDP1
[154.354711] Dynamic subtest D-eDP1: SUCCESS (47.994s)
[154.356978] Subtest flip-vs-modeset-vs-hang: SUCCESS (87.537s)
[154.728267] [007/133] (863s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait)
[154.834926] Starting subtest: plane-primary-toggle-with-vblank-wait
[154.837404] Starting dynamic subtest: pipe-A-eDP-1
[155.009035] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.175s)
[155.330694] Starting dynamic subtest: pipe-B-eDP-1
[156.239628] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.918s)
[156.539217] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.703s)
[157.399699] [008/133] (861s left) kms_frontbuffer_tracking (fbc-1p-rte)
[157.518800] Starting subtest: fbc-1p-rte
[162.976261] Subtest fbc-1p-rte: SUCCESS (5.466s)
[164.117543] [009/133] (854s left) prime_vgem (basic-fence-flip)
[164.215367] Starting subtest: basic-fence-flip
[164.501635] Subtest basic-fence-flip: SUCCESS (0.288s)
[164.625478] [FACT prime_vgem (basic-fence-flip)] new: kernel.kmod_is_loaded.vgem: true
[164.628823] [010/133] (854s left) gem_ctx_shared (q-independent)
[164.701394] Starting subtest: Q-independent
[164.703750] Starting dynamic subtest: rcs0
[164.766948] Dynamic subtest rcs0: SUCCESS (0.065s)
[164.774846] Starting dynamic subtest: vcs0
[164.811205] Dynamic subtest vcs0: SUCCESS (0.045s)
[164.818634] Starting dynamic subtest: vcs1
[164.857444] Dynamic subtest vcs1: SUCCESS (0.046s)
[164.867530] Starting dynamic subtest: vecs0
[164.906648] Dynamic subtest vecs0: SUCCESS (0.048s)
[164.915835] Starting dynamic subtest: ccs0
[164.959487] Dynamic subtest ccs0: SUCCESS (0.053s)
[164.961808] Subtest Q-independent: SUCCESS (0.258s)
[166.007925] [011/133] (852s left) kms_color_pipeline (plane-lut1d)
[166.105359] Starting subtest: plane-lut1d
[166.275412] Starting dynamic subtest: pipe-A-plane-0
[166.442151] Dynamic subtest pipe-A-plane-0: SUCCESS (0.167s)
[166.450277] Starting dynamic subtest: pipe-A-plane-1
[166.609165] Dynamic subtest pipe-A-plane-1: SUCCESS (0.166s)
[166.617713] Starting dynamic subtest: pipe-A-plane-2
[166.798901] Dynamic subtest pipe-A-plane-2: SUCCESS (0.189s)
[168.052565] Starting dynamic subtest: pipe-B-plane-0
[168.194348] Dynamic subtest pipe-B-plane-0: SUCCESS (0.155s)
[168.203757] Starting dynamic subtest: pipe-B-plane-1
[168.350195] Dynamic subtest pipe-B-plane-1: SUCCESS (0.155s)
[168.358848] Starting dynamic subtest: pipe-B-plane-2
[168.482995] Dynamic subtest pipe-B-plane-2: SUCCESS (0.133s)
[169.641473] Starting dynamic subtest: pipe-C-plane-0
[169.801294] Dynamic subtest pipe-C-plane-0: SUCCESS (0.167s)
[169.809050] Starting dynamic subtest: pipe-C-plane-1
[169.946606] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[169.956681] Starting dynamic subtest: pipe-C-plane-2
[170.101746] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s)
[171.277244] Starting dynamic subtest: pipe-D-plane-0
[171.414053] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[171.424866] Starting dynamic subtest: pipe-D-plane-1
[171.558649] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s)
[171.567820] Starting dynamic subtest: pipe-D-plane-2
[171.703262] Dynamic subtest pipe-D-plane-2: SUCCESS (0.144s)
[171.987947] Subtest plane-lut1d: SUCCESS (5.882s)
[172.850445] [012/133] (845s left) kms_pipe_b_c_ivb (disable-pipe-b-enable-pipe-c)
[172.914923] Subtest disable-pipe-B-enable-pipe-C: SKIP (0.000s)
[172.978214] [013/133] (845s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[173.077431] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[173.079816] Starting dynamic subtest: pipe-A-eDP-1
[173.228359] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.139s)
[173.238544] Starting dynamic subtest: pipe-B-eDP-1
[173.258635] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[173.266852] Starting dynamic subtest: pipe-C-eDP-1
[173.286177] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[173.293732] Starting dynamic subtest: pipe-D-eDP-1
[173.313080] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[173.315232] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.148s)
[175.502646] [014/133] (843s left) kms_psr (pr-sprite-plane-move)
[175.611150] Starting subtest: pr-sprite-plane-move
[175.615210] Subtest pr-sprite-plane-move: SKIP (0.000s)
[175.680291] [015/133] (843s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[175.779189] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[175.781526] Starting dynamic subtest: pipe-A-eDP-1
[175.840029] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[175.847682] Starting dynamic subtest: pipe-B-eDP-1
[175.904580] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[175.912116] Starting dynamic subtest: pipe-C-eDP-1
[175.967544] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[175.976225] Starting dynamic subtest: pipe-D-eDP-1
[176.034123] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[176.038334] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.008s)
[178.058964] [016/133] (840s left) gem_mmap_gtt (basic-small-copy-xy)
[178.112197] Subtest basic-small-copy-XY: SKIP (0.000s)
[178.179641] [017/133] (840s left) gem_ctx_persistence (saturated-hostile)
[178.232885] Starting subtest: saturated-hostile
[178.235201] Starting dynamic subtest: rcs0
[179.042762] Dynamic subtest rcs0: SUCCESS (0.812s)
[179.053477] Starting dynamic subtest: bcs0
[179.830982] Dynamic subtest bcs0: SUCCESS (0.787s)
[179.841213] Starting dynamic subtest: vcs0
[180.637581] Dynamic subtest vcs0: SUCCESS (0.805s)
[180.647902] Starting dynamic subtest: vcs1
[181.441713] Dynamic subtest vcs1: SUCCESS (0.803s)
[181.452572] Starting dynamic subtest: vecs0
[182.234590] Dynamic subtest vecs0: SUCCESS (0.791s)
[182.245359] Starting dynamic subtest: ccs0
[183.077183] Dynamic subtest ccs0: SUCCESS (0.841s)
[183.080060] Subtest saturated-hostile: SUCCESS (4.847s)
[183.167657] [018/133] (835s left) kms_getfb (getfb2-handle-protection)
[183.271622] Starting subtest: getfb2-handle-protection
[183.297053] Subtest getfb2-handle-protection: SUCCESS (0.026s)
[183.399014] [019/133] (835s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180-hflip)
[183.506964] Starting subtest: linear-max-hw-stride-64bpp-rotate-180-hflip
[183.511188] Subtest linear-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[183.600038] [020/133] (835s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[183.687668] Starting subtest: async-flip-with-page-flip-events-tiled
[184.079171] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[186.845229] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.764s)
[186.855906] Starting dynamic subtest: pipe-A-eDP-1-4
[189.020103] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.174s)
[189.028107] Starting dynamic subtest: pipe-A-eDP-1-4
[191.030591] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.010s)
[191.040695] Starting dynamic subtest: pipe-A-eDP-1-x
[193.219884] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.189s)
[193.589818] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[196.376211] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.791s)
[196.384687] Starting dynamic subtest: pipe-B-eDP-1-4
[198.562417] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.185s)
[198.572609] Starting dynamic subtest: pipe-B-eDP-1-4
[200.572829] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.010s)
[200.583320] Starting dynamic subtest: pipe-B-eDP-1-x
[202.773688] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.200s)
[203.155933] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[205.912620] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.764s)
[205.922493] Starting dynamic subtest: pipe-C-eDP-1-4
[208.088076] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.175s)
[208.095759] Starting dynamic subtest: pipe-C-eDP-1-4
[210.097109] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[210.105208] Starting dynamic subtest: pipe-C-eDP-1-x
[212.276080] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.178s)
[212.642823] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[215.448619] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.812s)
[215.458821] Starting dynamic subtest: pipe-D-eDP-1-4
[217.623335] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s)
[217.634290] Starting dynamic subtest: pipe-D-eDP-1-4
[219.634033] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.010s)
[219.643060] Starting dynamic subtest: pipe-D-eDP-1-x
[221.800776] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.167s)
[221.803570] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.112s)
[223.041061] [021/133] (796s left) perf_pmu (semaphore-wait-idle)
[223.092335] Starting subtest: semaphore-wait-idle
[223.094262] Starting dynamic subtest: rcs0
[223.607580] Dynamic subtest rcs0: SUCCESS (0.513s)
[223.619289] Starting dynamic subtest: bcs0
[224.121229] Dynamic subtest bcs0: SUCCESS (0.511s)
[224.132678] Starting dynamic subtest: vcs0
[224.633855] Dynamic subtest vcs0: SUCCESS (0.511s)
[224.645057] Starting dynamic subtest: vcs1
[225.145592] Dynamic subtest vcs1: SUCCESS (0.510s)
[225.156829] Starting dynamic subtest: vecs0
[225.659232] Dynamic subtest vecs0: SUCCESS (0.511s)
[225.670668] Starting dynamic subtest: ccs0
[226.174124] Dynamic subtest ccs0: SUCCESS (0.514s)
[226.176934] Subtest semaphore-wait-idle: SUCCESS (3.082s)
[226.293017] [022/133] (792s left) syncobj_wait (wait-for-submit-snapshot)
[226.364072] Starting subtest: wait-for-submit-snapshot
[226.445455] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[226.523237] [023/133] (792s left) vgem_basic (setversion)
[226.574510] Starting subtest: setversion
[226.578715] Subtest setversion: SUCCESS (0.000s)
[226.633540] [024/133] (792s left) gem_exec_schedule (u-independent)
[226.697188] Starting subtest: u-independent
[226.699217] Starting dynamic subtest: rcs0
[227.928874] Dynamic subtest rcs0: SUCCESS (1.241s)
[227.940483] Starting dynamic subtest: vcs0
[229.934842] Dynamic subtest vcs0: SUCCESS (2.005s)
[229.946487] Starting dynamic subtest: vcs1
[231.910867] Dynamic subtest vcs1: SUCCESS (1.974s)
[231.922421] Starting dynamic subtest: vecs0
[233.886986] Dynamic subtest vecs0: SUCCESS (1.975s)
[233.898558] Starting dynamic subtest: ccs0
[235.927320] Dynamic subtest ccs0: SUCCESS (2.038s)
[235.929858] Subtest u-independent: SUCCESS (9.241s)
[236.226414] [025/133] (783s left) kms_vblank (wait-forked-busy)
[236.321374] Starting subtest: wait-forked-busy
[236.323624] Starting dynamic subtest: pipe-A-eDP-1
[238.197091] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.875s)
[238.211110] Starting dynamic subtest: pipe-D-eDP-1
[240.800305] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.599s)
[240.802579] Subtest wait-forked-busy: SUCCESS (4.477s)
[241.610515] [026/133] (777s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[242.000632] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[242.812353] [027/133] (776s left) gem_softpin (noreloc)
[242.878024] Starting subtest: noreloc
[248.296265] Subtest noreloc: SUCCESS (5.416s)
[248.408521] [028/133] (771s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf)
[248.515150] Starting subtest: psr2-overlay-plane-move-continuous-exceed-sf
[248.517464] Starting dynamic subtest: pipe-A-eDP-1
[259.839354] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.324s)
[259.848916] Starting dynamic subtest: pipe-B-eDP-1
[271.855871] Dynamic subtest pipe-B-eDP-1: SUCCESS (12.015s)
[271.858341] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SUCCESS (23.342s)
[272.696504] [029/133] (746s left) kms_cursor_crc (cursor-rapid-movement-32x10)
[272.876039] Starting subtest: cursor-rapid-movement-32x10
[272.920653] Subtest cursor-rapid-movement-32x10: SKIP (0.042s)
[273.170318] [030/133] (746s left) sysfs_heartbeat_interval (nopreempt)
[273.229891] Starting subtest: nopreempt
[273.232146] Starting dynamic subtest: vecs0
[282.900630] Dynamic subtest vecs0: SUCCESS (9.666s)
[282.913995] Starting dynamic subtest: ccs0
[287.004858] Dynamic subtest ccs0: SUCCESS (4.105s)
[287.014220] Starting dynamic subtest: vcs0
[295.891543] Dynamic subtest vcs0: SUCCESS (8.883s)
[295.902959] Starting dynamic subtest: bcs0
[299.759828] Dynamic subtest bcs0: SUCCESS (3.869s)
[299.770406] Starting dynamic subtest: rcs0
[303.823643] Dynamic subtest rcs0: SUCCESS (4.062s)
[303.835286] Starting dynamic subtest: vcs1
[312.920557] Dynamic subtest vcs1: SUCCESS (9.093s)
[312.923114] Subtest nopreempt: SUCCESS (39.686s)
[312.994585] [031/133] (706s left) kms_plane (plane-panning-top-left)
[313.094875] Starting subtest: plane-panning-top-left
[313.097237] Starting dynamic subtest: pipe-A
[314.742860] Dynamic subtest pipe-A: SUCCESS (1.647s)
[314.752493] Starting dynamic subtest: pipe-B
[317.117895] Dynamic subtest pipe-B: SUCCESS (2.374s)
[317.120529] Subtest plane-panning-top-left: SUCCESS (4.023s)
[317.914255] [032/133] (701s left) kms_cursor_crc (cursor-sliding-32x10)
[318.083835] Starting subtest: cursor-sliding-32x10
[318.130835] Subtest cursor-sliding-32x10: SKIP (0.042s)
[318.413294] [033/133] (701s left) gem_exec_suspend (basic-s4-devices)
[318.472732] Starting subtest: basic-S4-devices
[318.475093] Starting dynamic subtest: smem
[329.880056] Dynamic subtest smem: SUCCESS (11.405s)
[329.882763] Subtest basic-S4-devices: SUCCESS (11.407s)
[337.080926] [034/133] (689s left) gem_exec_suspend (basic)
[337.164379] Starting subtest: basic
[337.166822] Starting dynamic subtest: smem
[338.903934] Dynamic subtest smem: SUCCESS (1.737s)
[338.906612] Subtest basic: SUCCESS (1.740s)
[339.091291] [035/133] (687s left) kms_lease (empty-lease)
[339.208712] Starting subtest: empty-lease
[339.213400] Starting dynamic subtest: pipe-A-eDP-1
[339.215586] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[339.225357] Starting dynamic subtest: pipe-B-eDP-1
[339.227280] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[339.236390] Starting dynamic subtest: pipe-C-eDP-1
[339.238218] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[339.247169] Starting dynamic subtest: pipe-D-eDP-1
[339.249014] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[339.250830] Subtest empty-lease: SUCCESS (0.009s)
[339.321486] [036/133] (687s left) gem_exec_params (rs-invalid)
[339.376072] Starting subtest: rs-invalid
[339.381106] Subtest rs-invalid: SUCCESS (0.003s)
[339.496407] [037/133] (687s left) gem_mmap_wc (write-gtt-read-wc)
[339.557215] Subtest write-gtt-read-wc: SKIP (0.000s)
[339.625386] [038/133] (687s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[339.720385] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[339.724647] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[339.817623] [039/133] (687s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[339.874516] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[339.878942] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[340.061873] [040/133] (686s left) gen7_exec_parse (oacontrol-tracking)
[340.122457] Subtest oacontrol-tracking: SKIP (0.000s)
[340.190968] [041/133] (686s left) perf (gen12-mi-rpc)
[340.320068] Starting subtest: gen12-mi-rpc
[340.322221] Starting dynamic subtest: rcs0
[340.339974] Dynamic subtest rcs0: SUCCESS (0.019s)
[340.342257] Subtest gen12-mi-rpc: SUCCESS (0.019s)
[340.390983] [042/133] (686s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[340.520178] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted
[340.652664] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SUCCESS (0.136s)
[340.761666] [043/133] (686s left) gem_mmap_offset (isolation)
[340.828525] Starting subtest: isolation
[340.845132] Subtest isolation: SUCCESS (0.008s)
[340.967203] [044/133] (686s left) kms_properties (colorop-properties-legacy)
[341.064039] Starting subtest: colorop-properties-legacy
[341.065900] Starting dynamic subtest: pipe-A-eDP-1
[341.408238] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.341s)
[341.419645] Starting dynamic subtest: pipe-B-eDP-1
[342.520182] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.113s)
[342.531083] Starting dynamic subtest: pipe-C-eDP-1
[343.540297] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.019s)
[343.550847] Starting dynamic subtest: pipe-D-eDP-1
[344.567773] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.026s)
[344.569974] Subtest colorop-properties-legacy: SUCCESS (3.505s)
[345.365944] [045/133] (681s left) gem_ccs (block-multicopy-compressed)
[345.426658] Starting subtest: block-multicopy-compressed
[345.431431] Subtest block-multicopy-compressed: SKIP (0.000s)
[345.536454] [046/133] (681s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[345.588881] Starting subtest: invalid-signal-one-illegal-handle
[345.591417] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[345.688104] [047/133] (681s left) kms_big_fb (yf-tiled-32bpp-rotate-270)
[345.803129] Starting subtest: yf-tiled-32bpp-rotate-270
[345.807590] Subtest yf-tiled-32bpp-rotate-270: SKIP (0.000s)
[345.899216] [048/133] (681s left) kms_content_protection (dp-mst-type-0-suspend-resume)
[346.043263] Starting subtest: dp-mst-type-0-suspend-resume
[346.048386] Subtest dp-mst-type-0-suspend-resume: SKIP (0.000s)
[346.153815] [049/133] (681s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[346.224758] Starting subtest: multi-wait-available-unsubmitted-submitted
[346.227066] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.001s)
[346.369182] [050/133] (681s left) i915_module_load (reload)
[346.416819] Starting subtest: reload
[351.181356] Subtest reload: SUCCESS (4.765s)
[351.222523] [051/133] (676s left) i915_pm_freq_mult (media-freq)
[352.895656] Starting subtest: media-freq
[352.898330] Starting dynamic subtest: gt0
[352.902710] Dynamic subtest gt0: SKIP (0.000s)
[352.912427] Starting dynamic subtest: gt1
[352.916796] Dynamic subtest gt1: SKIP (0.000s)
[352.921184] Subtest media-freq: SKIP (0.002s)
[353.012593] [052/133] (674s left) kms_big_fb (linear-16bpp-rotate-90)
[353.121270] Starting subtest: linear-16bpp-rotate-90
[353.155797] Subtest linear-16bpp-rotate-90: SKIP (0.034s)
[353.281391] [053/133] (674s left) perf_pmu (interrupts-sync)
[353.326442] Starting subtest: interrupts-sync
[354.418350] Subtest interrupts-sync: SUCCESS (1.090s)
[354.531176] [054/133] (673s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs)
[354.631241] Starting subtest: ccs-on-another-bo-yf-tiled-ccs
[354.633603] Starting dynamic subtest: pipe-A-eDP-1
[354.656059] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[354.671810] Starting dynamic subtest: pipe-B-eDP-1
[354.693648] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[354.703830] Starting dynamic subtest: pipe-C-eDP-1
[354.725247] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[354.736079] Starting dynamic subtest: pipe-D-eDP-1
[354.758068] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[354.762358] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.004s)
[356.794786] [055/133] (670s left) kms_plane (pixel-format-yf-tiled-ccs-modifier)
[356.893032] Starting subtest: pixel-format-yf-tiled-ccs-modifier
[356.897234] Subtest pixel-format-yf-tiled-ccs-modifier: SKIP (0.000s)
[356.965889] [056/133] (670s left) gem_exec_parallel (contexts)
[357.033431] Starting subtest: contexts
[357.035364] Starting dynamic subtest: rcs0
[359.970493] Dynamic subtest rcs0: SUCCESS (2.938s)
[359.981844] Starting dynamic subtest: bcs0
[363.232970] Dynamic subtest bcs0: SUCCESS (3.260s)
[363.244726] Starting dynamic subtest: vcs0
[367.387433] Dynamic subtest vcs0: SUCCESS (4.151s)
[367.400059] Starting dynamic subtest: vcs1
[371.370621] Dynamic subtest vcs1: SUCCESS (3.981s)
[371.380549] Starting dynamic subtest: vecs0
[375.360047] Dynamic subtest vecs0: SUCCESS (3.988s)
[375.370521] Starting dynamic subtest: ccs0
[378.980435] Dynamic subtest ccs0: SUCCESS (3.619s)
[378.983270] Subtest contexts: SUCCESS (21.949s)
[379.168271] [057/133] (648s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[379.264559] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[379.269138] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[379.362475] [058/133] (648s left) kms_addfb_basic (unused-handle)
[379.422955] Starting subtest: unused-handle
[379.425171] Subtest unused-handle: SUCCESS (0.000s)
[379.559959] [059/133] (648s left) kms_joiner (invalid-modeset-big-joiner)
[379.655598] Starting subtest: invalid-modeset-big-joiner
[379.660027] Subtest invalid-modeset-big-joiner: SKIP (0.000s)
[379.719744] [060/133] (648s left) kms_cursor_legacy (cursor-vs-flip-varying-size)
[379.837460] Starting subtest: cursor-vs-flip-varying-size
[411.144579] Subtest cursor-vs-flip-varying-size: SUCCESS (31.303s)
[412.016304] [061/133] (615s left) gem_exec_schedule (independent)
[412.084224] Starting subtest: independent
[412.086210] Starting dynamic subtest: rcs0
[413.912662] Dynamic subtest rcs0: SUCCESS (1.838s)
[413.925420] Starting dynamic subtest: vcs0
[415.905747] Dynamic subtest vcs0: SUCCESS (1.990s)
[415.923064] Starting dynamic subtest: vcs1
[417.880206] Dynamic subtest vcs1: SUCCESS (1.973s)
[417.892395] Starting dynamic subtest: vecs0
[419.933793] Dynamic subtest vecs0: SUCCESS (2.052s)
[419.946296] Starting dynamic subtest: ccs0
[421.911699] Dynamic subtest ccs0: SUCCESS (1.975s)
[421.914650] Subtest independent: SUCCESS (9.838s)
[422.219486] [062/133] (605s left) kms_plane_scaling (planes-scaler-unity-scaling)
[422.324925] Starting subtest: planes-scaler-unity-scaling
[422.327290] Starting dynamic subtest: pipe-A
[422.386955] Dynamic subtest pipe-A: SUCCESS (0.064s)
[422.398093] Starting dynamic subtest: pipe-B
[423.550618] Dynamic subtest pipe-B: SUCCESS (1.162s)
[423.565017] Starting dynamic subtest: pipe-C
[424.650133] Dynamic subtest pipe-C: SUCCESS (1.098s)
[424.659875] Starting dynamic subtest: pipe-D
[425.782363] Dynamic subtest pipe-D: SUCCESS (1.131s)
[425.784748] Subtest planes-scaler-unity-scaling: SUCCESS (3.460s)
[426.936457] [063/133] (601s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[426.993584] Starting subtest: multi-wait-for-submit-submitted-signaled
[426.995545] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[427.107451] [064/133] (600s left) syncobj_wait (invalid-signal-one-illegal-handle)
[427.165391] Starting subtest: invalid-signal-one-illegal-handle
[427.167592] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[427.279622] [065/133] (600s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling)
[427.369648] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling
[427.371900] Starting dynamic subtest: pipe-A-default-mode
[428.491645] Dynamic subtest pipe-A-default-mode: SKIP (1.120s)
[428.496231] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (1.122s)
[428.648647] [066/133] (599s left) gem_basic (create-close)
[428.715011] Starting subtest: create-close
[428.719255] Subtest create-close: SUCCESS (0.000s)
[428.813761] [067/133] (599s left) gem_ctx_param (invalid-get-ringsize)
[428.861679] Starting subtest: invalid-get-ringsize
[428.863865] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[428.969196] [068/133] (599s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[429.086957] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[461.038628] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (31.949s)
[461.892545] [069/133] (566s left) kms_frontbuffer_tracking (fbc-tiling-y)
[461.991597] Starting subtest: fbc-tiling-y
[461.996075] Subtest fbc-tiling-y: SKIP (0.000s)
[462.096107] [070/133] (566s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[462.204076] Starting subtest: extended-modeset-hang-newfb-with-reset
[462.206419] Starting dynamic subtest: pipe-A
[476.206090] Dynamic subtest pipe-A: SUCCESS (14.002s)
[476.220475] Starting dynamic subtest: pipe-D
[491.711217] Dynamic subtest pipe-D: SUCCESS (15.500s)
[491.713611] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (29.506s)
[492.514680] [071/133] (535s left) gem_pxp (hw-rejects-pxp-buffer)
[492.653260] Starting subtest: hw-rejects-pxp-buffer
[492.657791] Subtest hw-rejects-pxp-buffer: SKIP (0.000s)
[492.802939] [072/133] (535s left) api_intel_bb (reset-bb)
[492.851836] Starting subtest: reset-bb
[492.854155] Subtest reset-bb: SUCCESS (0.003s)
[492.978850] [073/133] (535s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[493.092904] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[493.097361] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[493.249872] [074/133] (535s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[493.370436] Starting subtest: basic-flip-after-cursor-legacy
[494.280096] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.908s)
[495.143634] [075/133] (533s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[495.266219] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[504.792126] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (9.525s)
[505.668875] [076/133] (522s left) kms_cursor_crc (cursor-offscreen-128x128)
[505.874183] Starting subtest: cursor-offscreen-128x128
[505.879195] Starting dynamic subtest: pipe-A-eDP-1
[507.804395] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.927s)
[507.835728] Starting dynamic subtest: pipe-D-eDP-1
[510.388617] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.561s)
[510.391061] Subtest cursor-offscreen-128x128: SUCCESS (4.514s)
[511.244264] [077/133] (517s left) kms_prime (basic-crc-hybrid)
[511.325022] Subtest basic-crc-hybrid: SKIP (0.000s)
[511.420240] [078/133] (517s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[511.505361] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[511.509692] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[511.610480] [079/133] (517s left) i915_suspend (fence-restore-untiled)
[511.665971] Starting subtest: fence-restore-untiled
[511.669932] Subtest fence-restore-untiled: SKIP (0.000s)
[511.762640] [080/133] (516s left) kms_pm_dc (dc3co-vpb-simulation)
[512.866757] Starting subtest: dc3co-vpb-simulation
[521.911339] Subtest dc3co-vpb-simulation: SKIP (9.040s)
[522.031825] [081/133] (506s left) gem_wait (write-wait)
[522.104095] Starting subtest: write-wait
[522.105980] Starting dynamic subtest: all-engines
[523.254333] Dynamic subtest all-engines: SUCCESS (1.151s)
[523.267935] Starting dynamic subtest: rcs0
[524.318901] Dynamic subtest rcs0: SUCCESS (1.062s)
[524.332430] Starting dynamic subtest: bcs0
[525.387349] Dynamic subtest bcs0: SUCCESS (1.066s)
[525.409464] Starting dynamic subtest: vcs0
[526.445712] Dynamic subtest vcs0: SUCCESS (1.057s)
[526.461892] Starting dynamic subtest: vcs1
[527.506166] Dynamic subtest vcs1: SUCCESS (1.058s)
[527.523689] Starting dynamic subtest: vecs0
[528.561357] Dynamic subtest vecs0: SUCCESS (1.054s)
[528.579297] Starting dynamic subtest: ccs0
[529.617651] Dynamic subtest ccs0: SUCCESS (1.054s)
[529.620304] Subtest write-wait: SUCCESS (7.517s)
[529.816755] [082/133] (499s left) gem_mmap_gtt (big-bo-tiledx)
[529.880511] Subtest big-bo-tiledX: SKIP (0.000s)
[529.942827] [083/133] (498s left) gem_exec_fence (syncobj-timeline-invalid-wait)
[530.486950] Starting subtest: syncobj-timeline-invalid-wait
[530.493074] Subtest syncobj-timeline-invalid-wait: SUCCESS (0.005s)
[532.009394] [084/133] (496s left) kms_chamelium_audio (dp-audio)
[532.386095] Subtest dp-audio: SKIP (0.000s)
[533.266591] [085/133] (495s left) syncobj_wait (wait-delayed-signal)
[533.322466] Starting subtest: wait-delayed-signal
[533.422853] Subtest wait-delayed-signal: SUCCESS (0.102s)
[533.505401] [086/133] (495s left) template (b)
[533.559162] Starting subtest: B
[533.561351] Subtest B: SUCCESS (0.000s)
[533.674189] [087/133] (495s left) gem_exec_nop (basic-parallel)
[533.750916] Starting subtest: basic-parallel
[549.849555] Subtest basic-parallel: SUCCESS (16.111s)
[550.084140] [088/133] (479s left) syncobj_timeline (signal-point-0)
[550.151645] Starting subtest: signal-point-0
[550.153778] Subtest signal-point-0: SUCCESS (0.000s)
[550.258249] [089/133] (478s left) kms_sequence (queue-busy)
[550.360808] Starting subtest: queue-busy
[550.362679] Starting dynamic subtest: pipe-A-eDP-1
[552.287300] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.925s)
[552.297924] Starting dynamic subtest: pipe-B-eDP-1
[554.904461] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.615s)
[554.916589] Starting dynamic subtest: pipe-C-eDP-1
[557.493296] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.588s)
[557.504378] Starting dynamic subtest: pipe-D-eDP-1
[560.037186] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.545s)
[560.039461] Subtest queue-busy: SUCCESS (9.678s)
[560.866961] [090/133] (468s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[560.967891] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[560.970185] Starting dynamic subtest: pipe-A-eDP-1
[560.992701] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[561.007641] Starting dynamic subtest: pipe-B-eDP-1
[561.029596] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[561.039840] Starting dynamic subtest: pipe-C-eDP-1
[561.061096] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[561.071197] Starting dynamic subtest: pipe-D-eDP-1
[561.093199] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[561.097257] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.006s)
[563.220903] [091/133] (466s left) gem_create (create-ext-placement-sanity-check)
[563.396108] Starting subtest: create-ext-placement-sanity-check
[563.398281] Subtest create-ext-placement-sanity-check: SUCCESS (0.004s)
[563.499402] [092/133] (465s left) gem_exec_params (dr4-dirt)
[563.562430] Starting subtest: DR4-dirt
[563.564393] Subtest DR4-dirt: SUCCESS (0.000s)
[563.657773] [093/133] (465s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-blt)
[563.762612] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-blt
[568.033932] Subtest fbc-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (4.276s)
[569.224365] [094/133] (460s left) kms_cursor_legacy (cursora-vs-flipb-atomic)
[569.339047] Starting subtest: cursorA-vs-flipB-atomic
[569.343779] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s)
[569.508598] [095/133] (459s left) vgem_basic (dmabuf-fence)
[569.564208] Starting subtest: dmabuf-fence
[569.566302] Subtest dmabuf-fence: SUCCESS (0.000s)
[569.620296] [096/133] (459s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[569.721835] Starting subtest: pr-primary-plane-update-sf-dmg-area
[569.726132] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[569.793308] [097/133] (459s left) kms_flip (2x-flip-vs-dpms-on-nop)
[569.893755] Starting subtest: 2x-flip-vs-dpms-on-nop
[569.903237] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.011s)
[569.998644] [098/133] (459s left) gem_exec_balancer (parallel-bb-first)
[570.257666] Starting subtest: parallel-bb-first
[571.225273] Subtest parallel-bb-first: SUCCESS (0.968s)
[571.984686] [099/133] (457s left) i915_drm_fdinfo (memory-info-resident)
[572.029124] Starting subtest: memory-info-resident
[572.031313] Starting dynamic subtest: smem0
[574.905511] Dynamic subtest smem0: SUCCESS (2.878s)
[574.907698] Subtest memory-info-resident: SUCCESS (2.879s)
[574.983796] [100/133] (454s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-fullscreen)
[575.085080] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-fullscreen
[581.764860] Subtest fbcpsr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.681s)
[581.905397] [101/133] (447s left) gem_softpin (safe-alignment)
[581.978185] Starting subtest: safe-alignment
[582.002267] Subtest safe-alignment: SUCCESS (0.027s)
[583.938485] [102/133] (445s left) gem_softpin (evict-snoop)
[584.002036] Starting subtest: evict-snoop
[584.006085] Subtest evict-snoop: SKIP (0.000s)
[584.133665] [103/133] (445s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite)
[584.246810] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite
[584.250792] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[584.353262] [104/133] (445s left) kms_psr (psr2-dpms)
[584.445819] Starting subtest: psr2-dpms
[584.448058] Starting dynamic subtest: eDP-1
[587.399216] Dynamic subtest eDP-1: SUCCESS (2.952s)
[587.401543] Subtest psr2-dpms: SUCCESS (2.954s)
[588.270917] [105/133] (441s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[588.332317] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[588.334588] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[588.431161] [106/133] (441s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted)
[588.485729] Starting subtest: etime-multi-wait-for-submit-unsubmitted
[588.588242] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.103s)
[588.666523] [107/133] (441s left) gem_exec_balancer (parallel-out-fence)
[588.933642] Starting subtest: parallel-out-fence
[590.088713] Subtest parallel-out-fence: SUCCESS (1.155s)
[590.214073] [108/133] (439s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[590.297869] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[590.302100] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[590.391899] [109/133] (439s left) api_intel_allocator (fork-simple-stress)
[590.458707] Starting subtest: fork-simple-stress
[595.856838] Subtest fork-simple-stress: SUCCESS (5.399s)
[596.013166] [110/133] (434s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[596.119588] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[596.123690] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[596.212742] [111/133] (433s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[596.307658] Starting subtest: 4-tiled-8bpp-rotate-90
[596.329226] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.021s)
[596.481984] [112/133] (433s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[596.584534] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[596.589053] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[596.694299] [113/133] (433s left) dmabuf_sync_file (import-multiple-read-only)
[596.737390] Starting subtest: import-multiple-read-only
[596.739750] Subtest import-multiple-read-only: SUCCESS (0.003s)
[596.800639] [114/133] (433s left) kms_async_flips (test-time-stamp-atomic)
[596.903817] Starting subtest: test-time-stamp-atomic
[597.280913] Starting dynamic subtest: pipe-A-eDP-1
[598.058591] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.778s)
[598.449470] Starting dynamic subtest: pipe-B-eDP-1
[599.205254] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.760s)
[599.578489] Starting dynamic subtest: pipe-C-eDP-1
[600.332068] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.759s)
[600.696260] Starting dynamic subtest: pipe-D-eDP-1
[601.463875] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.775s)
[601.466443] Subtest test-time-stamp-atomic: SUCCESS (4.558s)
[602.622202] [115/133] (427s left) kms_psr (psr-sprite-mmap-cpu)
[602.725085] Starting subtest: psr-sprite-mmap-cpu
[602.727394] Starting dynamic subtest: eDP-1
[604.440120] Dynamic subtest eDP-1: SUCCESS (1.713s)
[604.442410] Subtest psr-sprite-mmap-cpu: SUCCESS (1.714s)
[605.292517] [116/133] (425s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[605.382619] Starting subtest: psr-rgb101010-draw-mmap-gtt
[605.386999] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[605.484739] [117/133] (424s left) perf_pmu (rc6-suspend)
[605.531206] Starting subtest: rc6-suspend
[627.494714] Subtest rc6-suspend: SUCCESS (7.545s)
[628.427782] [118/133] (402s left) gem_exec_whisper (basic-queues-forked)
[628.495300] Starting subtest: basic-queues-forked
[653.340777] Subtest basic-queues-forked: SUCCESS (24.698s)
[653.530530] [119/133] (377s left) gem_exec_store (dword)
[653.598541] Starting subtest: dword
[653.600758] Starting dynamic subtest: rcs0
[653.666808] Dynamic subtest rcs0: SUCCESS (0.068s)
[653.681166] Starting dynamic subtest: bcs0
[653.711540] Dynamic subtest bcs0: SUCCESS (0.042s)
[653.722900] Starting dynamic subtest: vcs0
[653.754805] Dynamic subtest vcs0: SUCCESS (0.041s)
[653.765830] Starting dynamic subtest: vcs1
[653.797908] Dynamic subtest vcs1: SUCCESS (0.041s)
[653.809077] Starting dynamic subtest: vecs0
[653.842879] Dynamic subtest vecs0: SUCCESS (0.043s)
[653.854683] Starting dynamic subtest: ccs0
[653.891371] Dynamic subtest ccs0: SUCCESS (0.047s)
[653.893804] Subtest dword: SUCCESS (0.294s)
[654.080943] [120/133] (376s left) kms_psr (fbc-pr-primary-mmap-gtt)
[654.182362] Starting subtest: fbc-pr-primary-mmap-gtt
[654.186833] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[654.256087] [121/133] (376s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[654.311430] Starting subtest: etime-multi-wait-all-for-submit-submitted
[654.412741] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.102s)
[654.491908] [122/133] (376s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[654.620318] Starting subtest: cursorA-vs-flipA-atomic-transitions
[665.802944] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.173s)
[666.623067] [123/133] (364s left) kms_psr (fbc-psr2-sprite-mmap-gtt)
[666.714909] Starting subtest: fbc-psr2-sprite-mmap-gtt
[666.717030] Starting dynamic subtest: eDP-1
[666.720984] Dynamic subtest eDP-1: SKIP (0.000s)
[666.724999] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.001s)
[666.794971] [124/133] (363s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[666.900901] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[666.905435] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[667.000128] [125/133] (363s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[667.103518] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[675.775849] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.670s)
[675.892838] [126/133] (354s left) kms_chamelium_edid (dp-edid-change-during-suspend)
[676.286263] Subtest dp-edid-change-during-suspend: SKIP (0.000s)
[677.133910] [127/133] (353s left) kms_plane_alpha_blend (alpha-basic)
[677.230284] Starting subtest: alpha-basic
[677.545692] Starting dynamic subtest: pipe-A-eDP-1
[679.481852] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.933s)
[679.510882] Starting dynamic subtest: pipe-D-eDP-1
[682.132049] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.629s)
[682.134457] Subtest alpha-basic: SUCCESS (4.901s)
[682.976698] [128/133] (348s left) kms_plane_multiple (tiling-none)
[683.071130] Starting subtest: tiling-none
[683.073454] Starting dynamic subtest: pipe-A-eDP-1
[686.787394] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.714s)
[686.799331] Starting dynamic subtest: pipe-B-eDP-1
[691.327105] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.538s)
[691.342695] Starting dynamic subtest: pipe-C-eDP-1
[695.650189] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.319s)
[695.662031] Starting dynamic subtest: pipe-D-eDP-1
[699.993757] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.337s)
[699.995899] Subtest tiling-none: SUCCESS (16.915s)
[700.814500] [129/133] (330s left) gem_userptr_blits (stress-mm)
[700.885985] Starting subtest: stress-mm
[706.257990] Subtest stress-mm: SUCCESS (5.369s)
[706.375155] [130/133] (324s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[706.480431] Starting subtest: fbc-rgb101010-draw-mmap-wc
[711.181637] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.702s)
[712.307205] [131/133] (318s left) kms_properties (plane-properties-legacy)
[712.395659] Starting subtest: plane-properties-legacy
[712.397537] Starting dynamic subtest: pipe-A-eDP-1
[712.946441] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.552s)
[712.957535] Starting dynamic subtest: pipe-B-eDP-1
[714.250270] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.301s)
[714.265123] Starting dynamic subtest: pipe-C-eDP-1
[715.492713] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.239s)
[715.505023] Starting dynamic subtest: pipe-D-eDP-1
[716.719938] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.225s)
[716.722414] Subtest plane-properties-legacy: SUCCESS (4.324s)
[717.526050] [132/133] (313s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[717.630797] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[724.373628] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.746s)
[724.502515] [133/133] (306s left) gem_mmap_gtt (bad-object)
[724.562816] Subtest bad-object: SKIP (0.000s)
[724.626436] Closing watchdogs
results: parsing output: 0/ for test: kms_fb_coherency
results: parsing output: 1/ for test: gem_exec_reloc
results: parsing output: 2/ for test: gem_exec_params
results: parsing output: 3/ for test: gem_render_copy
results: parsing output: 4/ for test: core_auth
results: parsing output: 5/ for test: kms_flip
results: parsing output: 6/ for test: kms_atomic_transition
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: prime_vgem
results: parsing output: 9/ for test: gem_ctx_shared
results: parsing output: 10/ for test: kms_color_pipeline
results: parsing output: 11/ for test: kms_pipe_b_c_ivb
results: parsing output: 12/ for test: kms_ccs
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: kms_ccs
results: parsing output: 15/ for test: gem_mmap_gtt
results: parsing output: 16/ for test: gem_ctx_persistence
results: parsing output: 17/ for test: kms_getfb
results: parsing output: 18/ for test: kms_big_fb
results: parsing output: 19/ for test: kms_async_flips
results: parsing output: 20/ for test: perf_pmu
results: parsing output: 21/ for test: syncobj_wait
results: parsing output: 22/ for test: vgem_basic
results: parsing output: 23/ for test: gem_exec_schedule
results: parsing output: 24/ for test: kms_vblank
results: parsing output: 25/ for test: kms_chamelium_hpd
results: parsing output: 26/ for test: gem_softpin
results: parsing output: 27/ for test: kms_psr2_sf
results: parsing output: 28/ for test: kms_cursor_crc
results: parsing output: 29/ for test: sysfs_heartbeat_interval
results: parsing output: 30/ for test: kms_plane
results: parsing output: 31/ for test: kms_cursor_crc
results: parsing output: 32/ for test: gem_exec_suspend
results: parsing output: 33/ for test: gem_exec_suspend
results: parsing output: 34/ for test: kms_lease
results: parsing output: 35/ for test: gem_exec_params
results: parsing output: 36/ for test: gem_mmap_wc
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_render_copy
results: parsing output: 39/ for test: gen7_exec_parse
results: parsing output: 40/ for test: perf
results: parsing output: 41/ for test: gem_pxp
results: parsing output: 42/ for test: gem_mmap_offset
results: parsing output: 43/ for test: kms_properties
results: parsing output: 44/ for test: gem_ccs
results: parsing output: 45/ for test: syncobj_timeline
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: kms_content_protection
results: parsing output: 48/ for test: syncobj_timeline
results: parsing output: 49/ for test: i915_module_load
results: parsing output: 50/ for test: i915_pm_freq_mult
results: parsing output: 51/ for test: kms_big_fb
results: parsing output: 52/ for test: perf_pmu
results: parsing output: 53/ for test: kms_ccs
results: parsing output: 54/ for test: kms_plane
results: parsing output: 55/ for test: gem_exec_parallel
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_addfb_basic
results: parsing output: 58/ for test: kms_joiner
results: parsing output: 59/ for test: kms_cursor_legacy
results: parsing output: 60/ for test: gem_exec_schedule
results: parsing output: 61/ for test: kms_plane_scaling
results: parsing output: 62/ for test: syncobj_wait
results: parsing output: 63/ for test: syncobj_wait
results: parsing output: 64/ for test: kms_flip_scaled_crc
results: parsing output: 65/ for test: gem_basic
results: parsing output: 66/ for test: gem_ctx_param
results: parsing output: 67/ for test: kms_cursor_legacy
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_busy
results: parsing output: 70/ for test: gem_pxp
results: parsing output: 71/ for test: api_intel_bb
results: parsing output: 72/ for test: kms_cursor_legacy
results: parsing output: 73/ for test: kms_cursor_legacy
results: parsing output: 74/ for test: kms_cursor_legacy
results: parsing output: 75/ for test: kms_cursor_crc
results: parsing output: 76/ for test: kms_prime
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: i915_suspend
results: parsing output: 79/ for test: kms_pm_dc
results: parsing output: 80/ for test: gem_wait
results: parsing output: 81/ for test: gem_mmap_gtt
results: parsing output: 82/ for test: gem_exec_fence
results: parsing output: 83/ for test: kms_chamelium_audio
results: parsing output: 84/ for test: syncobj_wait
results: parsing output: 85/ for test: template
results: parsing output: 86/ for test: gem_exec_nop
results: parsing output: 87/ for test: syncobj_timeline
results: parsing output: 88/ for test: kms_sequence
results: parsing output: 89/ for test: kms_ccs
results: parsing output: 90/ for test: gem_create
results: parsing output: 91/ for test: gem_exec_params
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_cursor_legacy
results: parsing output: 94/ for test: vgem_basic
results: parsing output: 95/ for test: kms_psr2_sf
results: parsing output: 96/ for test: kms_flip
results: parsing output: 97/ for test: gem_exec_balancer
results: parsing output: 98/ for test: i915_drm_fdinfo
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: gem_softpin
results: parsing output: 101/ for test: gem_softpin
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_psr
results: parsing output: 104/ for test: syncobj_wait
results: parsing output: 105/ for test: syncobj_timeline
results: parsing output: 106/ for test: gem_exec_balancer
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: api_intel_allocator
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_big_fb
results: parsing output: 111/ for test: kms_big_fb
results: parsing output: 112/ for test: dmabuf_sync_file
results: parsing output: 113/ for test: kms_async_flips
results: parsing output: 114/ for test: kms_psr
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: perf_pmu
results: parsing output: 117/ for test: gem_exec_whisper
results: parsing output: 118/ for test: gem_exec_store
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: syncobj_timeline
results: parsing output: 121/ for test: kms_cursor_legacy
results: parsing output: 122/ for test: kms_psr
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_chamelium_edid
results: parsing output: 126/ for test: kms_plane_alpha_blend
results: parsing output: 127/ for test: kms_plane_multiple
results: parsing output: 128/ for test: gem_userptr_blits
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_properties
results: parsing output: 131/ for test: kms_frontbuffer_tracking
results: parsing output: 132/ for test: gem_mmap_gtt
Done.