[57.104249] Initializing watchdogs
[57.104298]   /dev/watchdog0
[57.119831] [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.124845] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.127476] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.132896] [001/156] (960s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[57.263039] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[57.267563] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[57.359869] [002/156] (960s left) kms_vblank (crtc-id)
[57.463421] Starting subtest: crtc-id
[57.465648] Starting dynamic subtest: pipe-A-eDP-1
[57.935958] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.466s)
[57.948784] Starting dynamic subtest: pipe-D-eDP-1
[59.085668] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.127s)
[59.088167] Subtest crtc-id: SUCCESS (1.596s)
[59.937532] [003/156] (957s left) gem_exec_nop (basic-sequential)
[60.027433] Starting subtest: basic-sequential
[74.831959] Subtest basic-sequential: SUCCESS (14.725s)
[75.069828] [004/156] (942s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs)
[75.166789] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs
[75.171409] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s)
[76.286145] [005/156] (941s left) gem_mmap_gtt (close-race)
[76.337076] Subtest close-race: SKIP (0.000s)
[76.391656] [006/156] (941s left) kms_hdr (invalid-metadata-sizes)
[76.484102] Starting subtest: invalid-metadata-sizes
[76.486485] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010
[76.491014] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SKIP (0.000s)
[76.499669] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F
[76.503810] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SKIP (0.000s)
[76.507878] Subtest invalid-metadata-sizes: SKIP (0.002s)
[76.552228] [007/156] (941s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180)
[76.656545] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180
[76.660960] Subtest y-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[76.757583] [008/156] (941s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[76.859896] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[76.864393] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.000s)
[76.930490] [009/156] (940s left) kms_cursor_edge_walk (64x64-right-edge)
[77.018587] Starting subtest: 64x64-right-edge
[77.020920] Starting dynamic subtest: pipe-A-eDP-1
[80.474854] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.454s)
[80.484798] Starting dynamic subtest: pipe-D-eDP-1
[83.688809] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.210s)
[83.691176] Subtest 64x64-right-edge: SUCCESS (6.666s)
[84.491210] [010/156] (933s left) kms_pm_rpm (universal-planes)
[86.431308] Starting subtest: universal-planes
[86.433975] Starting dynamic subtest: plane-35
[94.756357] Dynamic subtest plane-35: SUCCESS (8.322s)
[94.765701] Starting dynamic subtest: plane-65
[103.067549] Dynamic subtest plane-65: SUCCESS (8.308s)
[103.077795] Starting dynamic subtest: plane-95
[111.493719] Dynamic subtest plane-95: SUCCESS (8.423s)
[111.504065] Starting dynamic subtest: plane-125
[119.803613] Dynamic subtest plane-125: SUCCESS (8.307s)
[119.814777] Starting dynamic subtest: plane-135
[128.225775] Dynamic subtest plane-135: SUCCESS (8.420s)
[128.235945] Starting dynamic subtest: plane-145
[136.521486] Dynamic subtest plane-145: SUCCESS (8.294s)
[136.524393] Subtest universal-planes: SUCCESS (50.081s)
[136.922228] [011/156] (881s left) kms_addfb_basic (invalid-get-prop-any)
[136.993971] Starting subtest: invalid-get-prop-any
[136.996447] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[137.133878] [012/156] (880s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[137.238217] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[141.499640] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (4.268s)
[142.634235] [013/156] (875s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-mmap-wc)
[142.731853] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-mmap-wc
[142.736274] Subtest hdr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[142.828949] [014/156] (875s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[142.934597] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-cpu
[149.513074] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.586s)
[149.635639] [015/156] (868s left) kms_vrr (negative-basic)
[149.731042] Starting subtest: negative-basic
[149.738024] Starting dynamic subtest: pipe-A-eDP-1
[155.160605] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.422s)
[155.478313] Subtest negative-basic: SUCCESS (5.748s)
[156.280941] [016/156] (861s left) kms_addfb_basic (bad-pitch-256)
[156.333308] Starting subtest: bad-pitch-256
[156.335536] Subtest bad-pitch-256: SUCCESS (0.000s)
[156.451945] [017/156] (861s left) i915_suspend (fence-restore-tiled2untiled)
[156.498242] Starting subtest: fence-restore-tiled2untiled
[156.502706] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[156.609588] [018/156] (861s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[156.688428] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[156.692850] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[157.810642] [019/156] (860s left) gem_mmap_wc (fault-concurrent)
[157.868708] Subtest fault-concurrent: SKIP (0.000s)
[157.922384] [020/156] (860s left) gem_exec_balancer (parallel-bb-first)
[158.182060] Starting subtest: parallel-bb-first
[159.165904] Subtest parallel-bb-first: SUCCESS (0.984s)
[160.368349] [021/156] (858s left) gem_exec_big (single)
[160.440213] Starting subtest: single
[165.149584] Subtest single: SUCCESS (4.710s)
[165.405286] [022/156] (853s left) gem_mmap_gtt (big-bo)
[165.512647] Subtest big-bo: SKIP (0.000s)
[165.578527] [023/156] (852s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-indfb-pgflip-blt)
[165.695857] Starting subtest: fbchdr-2p-scndscrn-indfb-pgflip-blt
[165.700260] Subtest fbchdr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[165.792646] [024/156] (852s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs)
[165.897064] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs
[165.899378] Starting dynamic subtest: pipe-A-eDP-1
[165.922891] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[165.931621] Starting dynamic subtest: pipe-B-eDP-1
[165.953601] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[165.962155] Starting dynamic subtest: pipe-C-eDP-1
[165.985086] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[165.994425] Starting dynamic subtest: pipe-D-eDP-1
[166.016609] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[166.020742] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.005s)
[168.189751] [025/156] (850s left) gem_pwrite (basic-exhaustion)
[168.246053] Subtest basic-exhaustion: SKIP (0.000s)
[168.304136] [026/156] (850s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[168.698781] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[169.488252] [027/156] (849s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[169.542476] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[169.547071] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[169.724228] [028/156] (848s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[169.834576] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[169.838978] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[169.920602] [029/156] (848s left) gem_exec_flush (basic-uc-ro-default)
[169.988534] Starting subtest: basic-uc-ro-default
[175.445707] Subtest basic-uc-ro-default: SUCCESS (5.458s)
[175.630381] [030/156] (843s left) kms_flip (2x-busy-flip)
[175.731217] Starting subtest: 2x-busy-flip
[175.740791] Subtest 2x-busy-flip: SKIP (0.011s)
[175.832050] [031/156] (842s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-indfb-msflip-blt)
[175.942653] Starting subtest: psrhdr-2p-scndscrn-indfb-msflip-blt
[175.946681] Subtest psrhdr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[176.029036] [032/156] (842s left) kms_atomic (plane-primary-legacy)
[176.121849] Starting subtest: plane-primary-legacy
[176.124865] Starting dynamic subtest: pipe-A-eDP-1
[176.587715] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.465s)
[176.589731] Subtest plane-primary-legacy: SUCCESS (0.466s)
[177.434680] [033/156] (841s left) gem_workarounds (reset-fd)
[177.496906] Starting subtest: reset-fd
[177.680702] Subtest reset-fd: SUCCESS (0.183s)
[177.811788] [034/156] (841s left) gem_exec_schedule (fifo)
[177.896282] Starting subtest: fifo
[177.898176] Starting dynamic subtest: rcs0
[177.990476] Dynamic subtest rcs0: SUCCESS (0.104s)
[178.001887] Starting dynamic subtest: vcs0
[178.072938] Dynamic subtest vcs0: SUCCESS (0.082s)
[178.083702] Starting dynamic subtest: vcs1
[178.156035] Dynamic subtest vcs1: SUCCESS (0.082s)
[178.168761] Starting dynamic subtest: vecs0
[178.234738] Dynamic subtest vecs0: SUCCESS (0.078s)
[178.246079] Starting dynamic subtest: ccs0
[178.327642] Dynamic subtest ccs0: SUCCESS (0.093s)
[178.330030] Subtest fifo: SUCCESS (0.442s)
[179.438569] [035/156] (839s left) kms_psr (fbc-pr-sprite-render)
[179.541160] Starting subtest: fbc-pr-sprite-render
[179.545701] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[179.611475] [036/156] (839s left) gem_wait (busy)
[179.680222] Starting subtest: busy
[179.682604] Starting dynamic subtest: all-engines
[181.321124] Dynamic subtest all-engines: SUCCESS (1.642s)
[181.332325] Starting dynamic subtest: rcs0
[181.861322] Dynamic subtest rcs0: SUCCESS (0.541s)
[181.871378] Starting dynamic subtest: bcs0
[182.401662] Dynamic subtest bcs0: SUCCESS (0.539s)
[182.412467] Starting dynamic subtest: vcs0
[184.328228] Dynamic subtest vcs0: SUCCESS (1.925s)
[184.339713] Starting dynamic subtest: vcs1
[186.312050] Dynamic subtest vcs1: SUCCESS (1.982s)
[186.323113] Starting dynamic subtest: vecs0
[188.296242] Dynamic subtest vecs0: SUCCESS (1.983s)
[188.307655] Starting dynamic subtest: ccs0
[188.838949] Dynamic subtest ccs0: SUCCESS (0.542s)
[188.841824] Subtest busy: SUCCESS (9.162s)
[189.036845] [037/156] (829s left) kms_psr (fbc-pr-dpms)
[189.132052] Starting subtest: fbc-pr-dpms
[189.136470] Subtest fbc-pr-dpms: SKIP (0.000s)
[189.212041] [038/156] (829s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[189.307203] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[189.311570] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[189.376307] [039/156] (829s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs)
[189.474968] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs
[189.477277] Starting dynamic subtest: pipe-A-eDP-1
[189.499999] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[189.511480] Starting dynamic subtest: pipe-B-eDP-1
[189.533248] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[189.541523] Starting dynamic subtest: pipe-C-eDP-1
[189.563219] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[189.570986] Starting dynamic subtest: pipe-D-eDP-1
[189.593060] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[189.597487] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs: SKIP (0.003s)
[191.789791] [040/156] (827s left) kms_plane_alpha_blend (alpha-7efc)
[191.877087] Starting subtest: alpha-7efc
[192.177483] Starting dynamic subtest: pipe-A-eDP-1
[192.792606] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.614s)
[192.821881] Starting dynamic subtest: pipe-D-eDP-1
[194.121105] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.307s)
[194.123447] Subtest alpha-7efc: SUCCESS (2.245s)
[194.955468] [041/156] (824s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-indfb-pgflip-blt)
[195.061362] Starting subtest: hdr-2p-scndscrn-indfb-pgflip-blt
[195.066119] Subtest hdr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[195.151678] [042/156] (824s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-spr-indfb-move)
[195.251108] Starting subtest: fbchdr-2p-scndscrn-spr-indfb-move
[195.255678] Subtest fbchdr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[195.354097] [043/156] (823s left) kms_content_protection (dp-mst-type-1-suspend-resume)
[195.497985] Starting subtest: dp-mst-type-1-suspend-resume
[195.502739] Subtest dp-mst-type-1-suspend-resume: SKIP (0.000s)
[195.621291] [044/156] (823s left) kms_chamelium_color (ctm-red-to-blue)
[195.724616] Subtest ctm-red-to-blue: SKIP (0.000s)
[195.767590] [045/156] (823s left) kms_panel_fitting (legacy)
[195.851833] Starting subtest: legacy
[195.854068] Starting dynamic subtest: pipe-A-eDP-1
[196.358741] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.509s)
[196.386997] Starting dynamic subtest: pipe-B-eDP-1
[197.882876] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.505s)
[197.909123] Starting dynamic subtest: pipe-C-eDP-1
[199.370860] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.470s)
[199.396269] Starting dynamic subtest: pipe-D-eDP-1
[200.912806] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.523s)
[200.915881] Subtest legacy: SUCCESS (5.064s)
[202.173268] [046/156] (817s left) gem_exec_whisper (basic-normal-all)
[202.236823] Starting subtest: basic-normal-all
[204.568557] Subtest basic-normal-all: SUCCESS (2.330s)
[204.759957] [047/156] (814s left) kms_pm_backlight (basic-brightness)
[204.860561] Starting subtest: basic-brightness
[204.911670] Starting dynamic subtest: eDP-1
[205.432204] Dynamic subtest eDP-1: SUCCESS (0.523s)
[205.434471] Subtest basic-brightness: SUCCESS (0.575s)
[206.302488] [048/156] (813s left) kms_big_fb (linear-64bpp-rotate-90)
[206.407758] Starting subtest: linear-64bpp-rotate-90
[206.427448] Subtest linear-64bpp-rotate-90: SKIP (0.019s)
[206.542477] [049/156] (812s left) i915_drm_fdinfo (isolation)
[206.585263] Starting subtest: isolation
[206.587372] Starting dynamic subtest: rcs0
[206.607984] Dynamic subtest rcs0: SKIP (0.022s)
[206.617153] Starting dynamic subtest: bcs0
[206.621209] Dynamic subtest bcs0: SKIP (0.000s)
[206.629993] Starting dynamic subtest: vcs0
[206.634336] Dynamic subtest vcs0: SKIP (0.000s)
[206.643178] Starting dynamic subtest: vcs1
[206.647249] Dynamic subtest vcs1: SKIP (0.000s)
[206.655839] Starting dynamic subtest: vecs0
[206.659968] Dynamic subtest vecs0: SKIP (0.000s)
[206.668463] Starting dynamic subtest: ccs0
[206.672571] Dynamic subtest ccs0: SKIP (0.000s)
[206.676687] Subtest isolation: SKIP (0.027s)
[206.711854] [050/156] (812s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[206.809329] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[206.813413] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.000s)
[206.880229] [051/156] (812s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[206.977607] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[206.981606] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[207.064659] [052/156] (812s left) gem_exec_params (no-vebox)
[207.127019] Starting subtest: no-vebox
[207.132601] Subtest no-vebox: SUCCESS (0.002s)
[208.374059] [053/156] (811s left) prime_busy (hang)
[208.438718] Starting subtest: hang
[208.441125] Starting dynamic subtest: rcs0
[234.853842] Dynamic subtest rcs0: SUCCESS (26.410s)
[234.862600] Starting dynamic subtest: bcs0
[241.947042] Dynamic subtest bcs0: SUCCESS (7.094s)
[241.956326] Starting dynamic subtest: vcs0
[248.982626] Dynamic subtest vcs0: SUCCESS (7.031s)
[248.995592] Starting dynamic subtest: vcs1
[255.956639] Dynamic subtest vcs1: SUCCESS (6.974s)
[255.969661] Starting dynamic subtest: vecs0
[262.932822] Dynamic subtest vecs0: SUCCESS (6.973s)
[262.943454] Starting dynamic subtest: ccs0
[276.834257] Dynamic subtest ccs0: SUCCESS (13.900s)
[276.836374] Subtest hang: SUCCESS (68.389s)
[276.950164] [054/156] (742s left) syncobj_basic (bad-destroy)
[277.016766] Starting subtest: bad-destroy
[277.019275] Subtest bad-destroy: SUCCESS (0.000s)
[277.121625] [055/156] (742s left) kms_flip (flip-vs-wf_vblank-interruptible)
[277.211598] Starting subtest: flip-vs-wf_vblank-interruptible
[277.213931] Starting dynamic subtest: A-eDP1
[279.145195] Dynamic subtest A-eDP1: SUCCESS (1.932s)
[279.157580] Starting dynamic subtest: B-eDP1
[281.073264] Dynamic subtest B-eDP1: SUCCESS (1.925s)
[281.085092] Starting dynamic subtest: C-eDP1
[282.985045] Dynamic subtest C-eDP1: SUCCESS (1.909s)
[282.996988] Starting dynamic subtest: D-eDP1
[284.907157] Dynamic subtest D-eDP1: SUCCESS (1.920s)
[284.912454] Subtest flip-vs-wf_vblank-interruptible: SUCCESS (7.700s)
[286.131203] [056/156] (733s left) perf_pmu (busy-idle-no-semaphores)
[286.173740] Starting subtest: busy-idle-no-semaphores
[286.176114] Starting dynamic subtest: rcs0
[286.827403] Dynamic subtest rcs0: SUCCESS (0.651s)
[286.838361] Starting dynamic subtest: bcs0
[287.479927] Dynamic subtest bcs0: SUCCESS (0.650s)
[287.495378] Starting dynamic subtest: vcs0
[288.132102] Dynamic subtest vcs0: SUCCESS (0.650s)
[288.144182] Starting dynamic subtest: vcs1
[289.907750] Dynamic subtest vcs1: SUCCESS (1.773s)
[289.918339] Starting dynamic subtest: vecs0
[291.889316] Dynamic subtest vecs0: SUCCESS (1.979s)
[291.901156] Starting dynamic subtest: ccs0
[293.940307] Dynamic subtest ccs0: SUCCESS (2.049s)
[293.943355] Subtest busy-idle-no-semaphores: SUCCESS (7.766s)
[294.069574] [057/156] (725s left) kms_pm_rpm (modeset-lpsp-stress)
[295.603450] Starting subtest: modeset-lpsp-stress
[311.948073] Subtest modeset-lpsp-stress: SUCCESS (16.343s)
[312.042990] [058/156] (707s left) kms_psr (psr2-cursor-mmap-gtt)
[312.130202] Starting subtest: psr2-cursor-mmap-gtt
[312.132498] Starting dynamic subtest: eDP-1
[313.886684] Dynamic subtest eDP-1: SUCCESS (1.757s)
[313.888990] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.758s)
[314.767430] [059/156] (705s left) kms_dsc (dsc-fractional-bpp-with-bpc)
[314.855081] Starting subtest: dsc-fractional-bpp-with-bpc
[314.885080] Subtest dsc-fractional-bpp-with-bpc: SKIP (0.001s)
[314.930142] [060/156] (704s left) gem_userptr_blits (create-destroy-sync)
[315.000690] Starting subtest: create-destroy-sync
[320.018750] Subtest create-destroy-sync: SUCCESS (5.019s)
[320.148610] [061/156] (699s left) gem_exec_params (invalid-ring2)
[320.210379] Starting subtest: invalid-ring2
[320.212669] Subtest invalid-ring2: SUCCESS (0.000s)
[320.314016] [062/156] (699s left) perf_pmu (idle)
[320.352437] Starting subtest: idle
[320.354666] Starting dynamic subtest: rcs0
[320.904442] Dynamic subtest rcs0: SUCCESS (0.552s)
[320.916169] Starting dynamic subtest: bcs0
[321.436481] Dynamic subtest bcs0: SUCCESS (0.528s)
[321.447683] Starting dynamic subtest: vcs0
[321.953608] Dynamic subtest vcs0: SUCCESS (0.515s)
[321.963607] Starting dynamic subtest: vcs1
[322.483522] Dynamic subtest vcs1: SUCCESS (0.527s)
[322.496364] Starting dynamic subtest: vecs0
[322.999851] Dynamic subtest vecs0: SUCCESS (0.513s)
[323.012038] Starting dynamic subtest: ccs0
[323.519796] Dynamic subtest ccs0: SUCCESS (0.517s)
[323.523021] Subtest idle: SUCCESS (3.170s)
[323.640039] [063/156] (696s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[323.764071] Starting subtest: modeset-atomic-cursor-hotspot
[323.768507] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[323.903529] [064/156] (696s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[323.996873] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[323.999143] Starting dynamic subtest: A-eDP1
[332.913097] Dynamic subtest A-eDP1: SUCCESS (8.915s)
[332.925364] Starting dynamic subtest: B-eDP1
[341.847207] Dynamic subtest B-eDP1: SUCCESS (8.933s)
[341.858523] Starting dynamic subtest: C-eDP1
[350.758185] Dynamic subtest C-eDP1: SUCCESS (8.909s)
[350.767887] Starting dynamic subtest: D-eDP1
[359.683810] Dynamic subtest D-eDP1: SUCCESS (8.924s)
[359.691058] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.691s)
[360.908929] [065/156] (659s left) gem_exec_fence (basic-wait-all)
[360.980401] Starting subtest: basic-wait-all
[361.075371] Subtest basic-wait-all: SUCCESS (0.098s)
[363.341975] [FACT gem_exec_fence (basic-wait-all)] new: kernel.kmod_is_loaded.vgem: true
[363.345418] [066/156] (656s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-blt)
[363.461675] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-blt
[363.465946] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-blt: SKIP (0.000s)
[363.539707] [067/156] (656s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite)
[363.637093] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite
[363.641620] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[363.748945] [068/156] (656s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw)
[363.859951] Starting subtest: fbcpsr-1p-pri-indfb-multidraw
[387.146148] Subtest fbcpsr-1p-pri-indfb-multidraw: SUCCESS (23.291s)
[387.282042] [069/156] (632s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[387.380502] Starting subtest: hdr-1p-offscreen-pri-indfb-draw-mmap-cpu
[387.384045] Subtest hdr-1p-offscreen-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[387.477404] [070/156] (632s left) kms_joiner (basic-force-ultra-joiner)
[387.577691] Starting subtest: basic-force-ultra-joiner
[387.580974] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[387.643351] [071/156] (632s left) kms_cursor_crc (cursor-random-max-size)
[387.969091] Starting subtest: cursor-random-max-size
[387.974474] Subtest cursor-random-max-size: SKIP (0.000s)
[388.100970] [072/156] (632s left) kms_addfb_basic (master-rmfb)
[388.164330] Starting subtest: master-rmfb
[388.166146] Subtest master-rmfb: SUCCESS (0.001s)
[388.320967] [073/156] (632s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-gtt)
[388.429295] Starting subtest: fbcpsr-rgb101010-draw-mmap-gtt
[388.432646] Subtest fbcpsr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[388.532696] [074/156] (631s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[388.635100] Starting subtest: psr2-cursor-plane-update-sf
[388.637261] Starting dynamic subtest: pipe-A-eDP-1
[389.208376] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.575s)
[389.221991] Starting dynamic subtest: pipe-B-eDP-1
[390.552985] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.344s)
[390.555552] Subtest psr2-cursor-plane-update-sf: SUCCESS (1.921s)
[391.423028] [075/156] (629s left) gem_ctx_persistence (processes)
[391.484480] Starting subtest: processes
[393.295607] Subtest processes: SUCCESS (1.811s)
[393.376272] [076/156] (627s left) kms_psr (psr2-primary-blt)
[393.472474] Starting subtest: psr2-primary-blt
[393.474757] Starting dynamic subtest: eDP-1
[395.213787] Dynamic subtest eDP-1: SUCCESS (1.741s)
[395.215661] Subtest psr2-primary-blt: SUCCESS (1.742s)
[396.080256] [077/156] (624s left) kms_psr (psr-sprite-render)
[396.176315] Starting subtest: psr-sprite-render
[396.178784] Starting dynamic subtest: eDP-1
[397.880766] Dynamic subtest eDP-1: SUCCESS (1.705s)
[397.883101] Subtest psr-sprite-render: SUCCESS (1.706s)
[398.749178] [078/156] (621s left) gem_mmap_gtt (isolation)
[398.805694] Subtest isolation: SKIP (0.000s)
[398.866936] [079/156] (621s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[398.965352] Starting subtest: psr-rgb565-draw-mmap-wc
[405.839405] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.879s)
[405.939561] [080/156] (614s left) i915_pciid
[406.075373] [081/156] (614s left) kms_lease (simple-lease)
[406.174269] Starting subtest: simple-lease
[406.176467] Starting dynamic subtest: pipe-A-eDP-1
[406.683422] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.509s)
[406.693145] Starting dynamic subtest: pipe-B-eDP-1
[408.122499] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.438s)
[408.132294] Starting dynamic subtest: pipe-C-eDP-1
[409.607067] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.481s)
[409.616670] Starting dynamic subtest: pipe-D-eDP-1
[411.007123] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.400s)
[411.009657] Subtest simple-lease: SUCCESS (4.835s)
[411.867714] [082/156] (608s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-mmap-gtt)
[411.970221] Starting subtest: hdr-rgb101010-draw-mmap-gtt
[411.974752] Subtest hdr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[412.091749] [083/156] (608s left) gem_softpin (allocator-nopin-reserve)
[412.141969] Starting subtest: allocator-nopin-reserve
[412.237228] Subtest allocator-nopin-reserve: SUCCESS (0.094s)
[412.344908] [084/156] (608s left) gem_ctx_param (set-priority-invalid-size)
[412.396895] Starting subtest: set-priority-invalid-size
[412.399256] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[412.490345] [085/156] (608s left) kms_big_fb (yf-tiled-64bpp-rotate-0)
[412.591890] Starting subtest: yf-tiled-64bpp-rotate-0
[412.596480] Subtest yf-tiled-64bpp-rotate-0: SKIP (0.000s)
[412.682519] [086/156] (608s left) i915_pm_rpm (reg-read-ioctl)
[414.418724] Starting subtest: reg-read-ioctl
[416.809873] Subtest reg-read-ioctl: SUCCESS (2.394s)
[417.193658] [087/156] (603s left) kms_cursor_crc (cursor-offscreen-32x10)
[417.357075] Starting subtest: cursor-offscreen-32x10
[417.409102] Subtest cursor-offscreen-32x10: SKIP (0.047s)
[417.690772] [088/156] (603s left) syncobj_wait (multi-wait-all-signaled)
[417.749074] Starting subtest: multi-wait-all-signaled
[417.751480] Subtest multi-wait-all-signaled: SUCCESS (0.000s)
[417.862478] [089/156] (603s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-pwrite)
[417.969068] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-pwrite
[422.395329] Subtest fbc-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (4.431s)
[423.627827] [090/156] (597s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-cpu)
[423.732693] Starting subtest: fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-cpu
[423.736992] Subtest fbcpsrhdr-2p-scndscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[423.831383] [091/156] (597s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-pwrite)
[423.929192] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-pwrite
[423.933598] Subtest fbchdr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[424.030731] [092/156] (597s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[424.139385] Starting subtest: basic-flip-before-cursor-legacy
[425.056219] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.914s)
[425.922247] [093/156] (595s left) gem_exec_alignment (pi-isolated)
[425.976861] Starting subtest: pi-isolated
[479.767890] Subtest pi-isolated: SUCCESS (53.784s)
[480.714803] [094/156] (540s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-onoff)
[480.857888] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-onoff
[480.862244] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[480.970647] [095/156] (540s left) gem_render_copy (yf-tiled-ccs-to-yf-tiled-ccs)
[481.034796] Starting subtest: yf-tiled-ccs-to-yf-tiled-ccs
[481.039038] Subtest yf-tiled-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[481.219521] [096/156] (540s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[481.318528] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[481.322626] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[481.421058] [097/156] (540s left) kms_flip (flip-vs-rmfb)
[481.516543] Starting subtest: flip-vs-rmfb
[481.518893] Starting dynamic subtest: A-eDP1
[490.205431] Dynamic subtest A-eDP1: SUCCESS (8.688s)
[490.217964] Starting dynamic subtest: B-eDP1
[498.849454] Dynamic subtest B-eDP1: SUCCESS (8.642s)
[498.859020] Starting dynamic subtest: C-eDP1
[507.479325] Dynamic subtest C-eDP1: SUCCESS (8.628s)
[507.493208] Starting dynamic subtest: D-eDP1
[516.110089] Dynamic subtest D-eDP1: SUCCESS (8.628s)
[516.114694] Subtest flip-vs-rmfb: SUCCESS (34.598s)
[517.284432] [098/156] (504s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-mmap-gtt)
[517.382233] Starting subtest: fbchdr-rgb101010-draw-mmap-gtt
[517.386741] Subtest fbchdr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[517.487761] [099/156] (504s left) kms_big_fb (y-tiled-8bpp-rotate-270)
[517.592858] Starting subtest: y-tiled-8bpp-rotate-270
[517.597493] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s)
[517.692091] [100/156] (503s left) kms_chamelium_frames (hdmi-crc-multiple)
[518.079284] Subtest hdmi-crc-multiple: SKIP (0.000s)
[518.898233] [101/156] (502s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[519.006031] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[526.127199] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.127s)
[526.253143] [102/156] (495s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-render)
[526.359927] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-render
[526.364280] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[526.463106] [103/156] (495s left) fbdev (unaligned-write)
[526.501528] Starting subtest: unaligned-write
[526.603963] Subtest unaligned-write: SUCCESS (0.101s)
[526.665694] [104/156] (495s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc)
[526.765693] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc
[526.769963] Subtest fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[526.868325] [105/156] (494s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-mmap-wc)
[526.973785] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-mmap-wc
[526.977774] Subtest psrhdr-1p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[527.067879] [106/156] (494s left) sw_sync (sync_busy_fork)
[527.106345] Starting subtest: sync_busy_fork
[528.119926] Subtest sync_busy_fork: SUCCESS (1.012s)
[528.206847] [107/156] (493s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-render)
[528.318845] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-render
[535.169113] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.854s)
[535.320245] [108/156] (486s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[535.428196] Starting subtest: x-tiled-32bpp-rotate-270
[535.447696] Subtest x-tiled-32bpp-rotate-270: SKIP (0.019s)
[535.586344] [109/156] (486s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-submitted-signal
[535.653706] Starting subtest: etime-multi-wait-all-available-unsubmitted-submitted-signaled
[535.757622] Subtest etime-multi-wait-all-available-unsubmitted-submitted-signaled: SUCCESS (0.104s)
[535.837715] [110/156] (486s left) api_intel_bb (misplaced-blitter)
[535.896915] Starting subtest: misplaced-blitter
[535.902697] Subtest misplaced-blitter: SUCCESS (0.008s)
[536.053792] [111/156] (486s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[536.150364] Starting subtest: plane-lut1d-ctm3x4
[536.298968] Starting dynamic subtest: pipe-A-plane-0
[536.485412] Dynamic subtest pipe-A-plane-0: SUCCESS (0.189s)
[536.497296] Starting dynamic subtest: pipe-A-plane-1
[536.652453] Dynamic subtest pipe-A-plane-1: SUCCESS (0.166s)
[536.665247] Starting dynamic subtest: pipe-A-plane-2
[536.817768] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[537.999107] Starting dynamic subtest: pipe-B-plane-0
[538.165468] Dynamic subtest pipe-B-plane-0: SUCCESS (0.177s)
[538.177529] Starting dynamic subtest: pipe-B-plane-1
[538.332885] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s)
[538.342880] Starting dynamic subtest: pipe-B-plane-2
[538.509854] Dynamic subtest pipe-B-plane-2: SUCCESS (0.177s)
[539.707206] Starting dynamic subtest: pipe-C-plane-0
[539.843901] Dynamic subtest pipe-C-plane-0: SUCCESS (0.144s)
[539.854711] Starting dynamic subtest: pipe-C-plane-1
[539.987932] Dynamic subtest pipe-C-plane-1: SUCCESS (0.144s)
[540.001075] Starting dynamic subtest: pipe-C-plane-2
[540.143922] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s)
[541.347972] Starting dynamic subtest: pipe-D-plane-0
[541.484154] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s)
[541.494778] Starting dynamic subtest: pipe-D-plane-1
[541.631442] Dynamic subtest pipe-D-plane-1: SUCCESS (0.144s)
[541.641627] Starting dynamic subtest: pipe-D-plane-2
[541.785574] Dynamic subtest pipe-D-plane-2: SUCCESS (0.153s)
[542.070989] Subtest plane-lut1d-ctm3x4: SUCCESS (5.921s)
[542.921354] [112/156] (479s left) gem_tiled_blits (interruptible)
[542.990277] Subtest interruptible: SKIP (0.000s)
[543.063362] [113/156] (479s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic)
[543.189149] Starting subtest: flip-vs-cursor-crc-atomic
[543.881214] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.690s)
[544.736686] [114/156] (477s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[544.795976] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[544.902105] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.105s)
[544.981699] [115/156] (477s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy)
[545.092240] Starting subtest: 2x-cursor-vs-flip-legacy
[545.096703] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s)
[545.250312] [116/156] (477s left) gem_exec_fence (syncobj-invalid-wait)
[545.695657] Starting subtest: syncobj-invalid-wait
[545.698121] Subtest syncobj-invalid-wait: SUCCESS (0.000s)
[547.369403] [117/156] (474s left) kms_frontbuffer_tracking (psrhdr-rgb565-draw-mmap-cpu)
[547.464162] Starting subtest: psrhdr-rgb565-draw-mmap-cpu
[547.468212] Subtest psrhdr-rgb565-draw-mmap-cpu: SKIP (0.000s)
[547.560746] [118/156] (474s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-pwrite)
[547.665923] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-pwrite
[547.669946] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[547.758975] [119/156] (474s left) gem_userptr_blits (sync-unmap-cycles)
[547.821142] Starting subtest: sync-unmap-cycles
[553.190570] Subtest sync-unmap-cycles: SUCCESS (5.371s)
[553.323724] [120/156] (469s left) gem_cs_tlb (engines)
[553.374700] Starting subtest: engines
[553.376362] Starting dynamic subtest: rcs0
[555.530966] Dynamic subtest rcs0: SUCCESS (2.154s)
[555.541773] Starting dynamic subtest: bcs0
[557.684512] Dynamic subtest bcs0: SUCCESS (2.153s)
[557.695635] Starting dynamic subtest: vcs0
[559.838624] Dynamic subtest vcs0: SUCCESS (2.152s)
[559.854849] Starting dynamic subtest: vcs1
[561.993124] Dynamic subtest vcs1: SUCCESS (2.154s)
[562.007219] Starting dynamic subtest: vecs0
[564.147089] Dynamic subtest vecs0: SUCCESS (2.152s)
[564.161921] Starting dynamic subtest: ccs0
[566.302440] Dynamic subtest ccs0: SUCCESS (2.154s)
[566.304918] Subtest engines: SUCCESS (12.927s)
[566.425183] [121/156] (456s left) syncobj_wait (wait-all-for-submit-complex)
[566.473355] Starting subtest: wait-all-for-submit-complex
[566.686650] Subtest wait-all-for-submit-complex: SUCCESS (0.213s)
[566.765885] [122/156] (455s left) api_intel_allocator (fork-simple-once)
[566.830065] Starting subtest: fork-simple-once
[566.848171] Subtest fork-simple-once: SUCCESS (0.019s)
[566.967140] [123/156] (455s left) syncobj_timeline (invalid-signal-bad-pad)
[567.010766] Starting subtest: invalid-signal-bad-pad
[567.013126] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[567.111199] [124/156] (455s left) gem_exec_fence (basic-busy-all)
[567.165163] Starting subtest: basic-busy-all
[567.277928] Subtest basic-busy-all: SUCCESS (0.113s)
[569.368251] [125/156] (453s left) kms_frontbuffer_tracking (psrhdr-1p-offscreen-pri-indfb-draw-pwrite)
[569.478583] Starting subtest: psrhdr-1p-offscreen-pri-indfb-draw-pwrite
[569.482745] Subtest psrhdr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s)
[569.575651] [126/156] (453s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc)
[569.672590] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc
[569.676626] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[569.790476] [127/156] (452s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-msflip-blt)
[569.886889] Starting subtest: fbcpsr-2p-primscrn-shrfb-msflip-blt
[569.891296] Subtest fbcpsr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[569.989643] [128/156] (452s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[570.084191] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[570.764057] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.681s)
[570.954086] [129/156] (451s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[571.012660] Starting subtest: multi-wait-for-submit-available-submitted
[571.014714] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.000s)
[571.140123] [130/156] (451s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[571.259510] Starting subtest: cursor-vs-flip-atomic
[600.832448] Subtest cursor-vs-flip-atomic: SUCCESS (29.569s)
[601.655147] [131/156] (421s left) gem_lmem_swapping (parallel-multi)
[601.694848] Subtest parallel-multi: SKIP (0.000s)
[601.741324] [132/156] (421s left) kms_plane_multiple (2x-tiling-y)
[601.830311] Starting subtest: 2x-tiling-y
[601.834464] Subtest 2x-tiling-y: SKIP (0.000s)
[601.907086] [133/156] (421s left) gem_exec_schedule (u-submit-early-slice)
[601.987662] Starting subtest: u-submit-early-slice
[601.990069] Starting dynamic subtest: rcs0
[602.025478] Dynamic subtest rcs0: SUCCESS (0.043s)
[602.040301] Starting dynamic subtest: bcs0
[602.067416] Dynamic subtest bcs0: SUCCESS (0.041s)
[602.077494] Starting dynamic subtest: vcs0
[602.110860] Dynamic subtest vcs0: SUCCESS (0.043s)
[602.122315] Starting dynamic subtest: vcs1
[602.154402] Dynamic subtest vcs1: SUCCESS (0.043s)
[602.165753] Starting dynamic subtest: vecs0
[602.194561] Dynamic subtest vecs0: SUCCESS (0.039s)
[602.206297] Starting dynamic subtest: ccs0
[602.237398] Dynamic subtest ccs0: SUCCESS (0.042s)
[602.239635] Subtest u-submit-early-slice: SUCCESS (0.256s)
[603.432485] [134/156] (419s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[603.489086] Starting subtest: etime-single-wait-all-for-submit-submitted
[603.597106] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.107s)
[603.673410] [135/156] (419s left) kms_tiled_display (basic-test-pattern-with-chamelium)
[603.782556] Subtest basic-test-pattern-with-chamelium: SKIP (0.000s)
[603.830885] [136/156] (419s left) kms_addfb_basic (invalid-set-prop)
[603.891354] Starting subtest: invalid-set-prop
[603.893631] Subtest invalid-set-prop: SUCCESS (0.000s)
[604.023911] [137/156] (419s left) gem_render_copy_redux (normal)
[604.088545] Starting subtest: normal
[604.391537] Subtest normal: SUCCESS (0.303s)
[604.485085] [138/156] (418s left) vgem_basic (busy-fence)
[604.524090] Starting subtest: busy-fence
[604.526085] Subtest busy-fence: SUCCESS (0.000s)
[604.584493] [139/156] (418s left) syncobj_timeline (wait-any-complex)
[604.637513] Starting subtest: wait-any-complex
[604.698595] Subtest wait-any-complex: SUCCESS (0.061s)
[604.775607] [140/156] (418s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[604.880487] Starting subtest: 4-tiled-8bpp-rotate-180
[606.138592] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.258s)
[606.261584] [141/156] (417s left) prime_mmap (test_aperture_limit)
[606.319621] Starting subtest: test_aperture_limit
[606.321496] Starting dynamic subtest: test_aperture_limit-smem
[606.329650] Dynamic subtest test_aperture_limit-smem: SKIP (0.008s)
[606.333270] Subtest test_aperture_limit: SKIP (0.008s)
[606.444878] [142/156] (416s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[606.536293] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[606.538147] Starting dynamic subtest: pipe-A
[606.557590] Dynamic subtest pipe-A: SKIP (0.017s)
[606.567314] Starting dynamic subtest: pipe-B
[606.587531] Dynamic subtest pipe-B: SKIP (0.031s)
[606.597291] Starting dynamic subtest: pipe-C
[606.622034] Dynamic subtest pipe-C: SKIP (0.031s)
[606.631562] Starting dynamic subtest: pipe-D
[606.652557] Dynamic subtest pipe-D: SKIP (0.032s)
[606.655765] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.114s)
[606.745130] [143/156] (416s left) kms_psr (fbc-psr-cursor-plane-move)
[606.837717] Starting subtest: fbc-psr-cursor-plane-move
[606.839585] Starting dynamic subtest: eDP-1
[606.842913] Dynamic subtest eDP-1: SKIP (0.000s)
[606.846262] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[606.913986] [144/156] (416s left) gem_exec_reloc (basic-gtt-cpu-active)
[606.979338] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[607.048327] [145/156] (416s left) kms_cursor_legacy (cursorb-vs-flipb-toggle)
[607.166994] Starting subtest: cursorB-vs-flipB-toggle
[607.170723] Subtest cursorB-vs-flipB-toggle: SKIP (0.001s)
[607.338047] [146/156] (416s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu)
[607.443260] Starting subtest: psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu
[607.446839] Subtest psrhdr-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[607.548296] [147/156] (416s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[607.604111] Starting subtest: wait-all-for-submit-delayed-submit
[607.709217] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[607.789977] [148/156] (415s left) drm_mm (drm_mm)
[607.827107] Starting subtest: drm_mm
[607.855041] Starting dynamic subtest: drm_test_mm_init
[607.955128] Dynamic subtest drm_test_mm_init: SUCCESS (0.099s)
[607.966463] Starting dynamic subtest: drm_test_mm_debug
[608.039177] Dynamic subtest drm_test_mm_debug: SUCCESS (0.083s)
[608.049414] Starting dynamic subtest: drm_test_mm_align32
[608.126074] Dynamic subtest drm_test_mm_align32: SUCCESS (0.086s)
[608.135632] Starting dynamic subtest: drm_test_mm_align64
[608.225169] Dynamic subtest drm_test_mm_align64: SUCCESS (0.099s)
[608.234309] Starting dynamic subtest: drm_test_mm_lowest
[608.331233] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.106s)
[608.340877] Starting dynamic subtest: drm_test_mm_highest
[608.423511] Dynamic subtest drm_test_mm_highest: SUCCESS (0.086s)
[608.425416] Subtest drm_mm: SUCCESS (0.592s)
[608.595831] [149/156] (415s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-fullscreen)
[608.704772] Starting subtest: hdr-1p-primscrn-spr-indfb-fullscreen
[608.708727] Subtest hdr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[608.807454] [150/156] (414s left) gem_ctx_persistence (engines-queued)
[608.867125] Starting subtest: engines-queued
[608.868918] Starting dynamic subtest: rcs0
[608.956458] Dynamic subtest rcs0: SUCCESS (0.089s)
[608.971254] Starting dynamic subtest: bcs0
[609.000999] Dynamic subtest bcs0: SUCCESS (0.042s)
[609.011085] Starting dynamic subtest: vcs0
[610.280580] Dynamic subtest vcs0: SUCCESS (1.275s)
[610.293758] Starting dynamic subtest: vcs1
[612.262057] Dynamic subtest vcs1: SUCCESS (1.979s)
[612.274689] Starting dynamic subtest: vecs0
[614.248117] Dynamic subtest vecs0: SUCCESS (1.983s)
[614.260573] Starting dynamic subtest: ccs0
[614.413271] Dynamic subtest ccs0: SUCCESS (0.164s)
[614.415857] Subtest engines-queued: SUCCESS (5.545s)
[614.518376] [151/156] (409s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[614.625637] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf
[614.629792] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[614.696443] [152/156] (409s left) gem_mmap_gtt (basic-read-write)
[614.760875] Subtest basic-read-write: SKIP (0.000s)
[614.823585] [153/156] (409s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[614.929590] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt
[614.933809] Subtest psrhdr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[615.028245] [154/156] (408s left) gen9_exec_parse (bb-start-far)
[615.082594] Subtest bb-start-far: SKIP (0.000s)
[615.158810] [155/156] (408s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-mmap-wc)
[615.260710] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-mmap-wc
[615.264762] Subtest hdr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[615.383802] [156/156] (408s left) gem_exec_schedule (preempt-hang)
[615.562025] Starting subtest: preempt-hang
[615.564561] Starting dynamic subtest: rcs0
[615.790474] Dynamic subtest rcs0: SUCCESS (0.230s)
[615.802776] Starting dynamic subtest: bcs0
[616.019855] Dynamic subtest bcs0: SUCCESS (0.229s)
[616.030610] Starting dynamic subtest: vcs0
[616.252764] Dynamic subtest vcs0: SUCCESS (0.232s)
[616.265572] Starting dynamic subtest: vcs1
[616.483553] Dynamic subtest vcs1: SUCCESS (0.231s)
[616.495933] Starting dynamic subtest: vecs0
[616.718295] Dynamic subtest vecs0: SUCCESS (0.232s)
[616.731442] Starting dynamic subtest: ccs0
[616.944654] Dynamic subtest ccs0: SUCCESS (0.226s)
[616.946576] Subtest preempt-hang: SUCCESS (1.386s)
[617.385928] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_vblank
results: parsing output: 2/ for test: gem_exec_nop
results: parsing output: 3/ for test: kms_ccs
results: parsing output: 4/ for test: gem_mmap_gtt
results: parsing output: 5/ for test: kms_hdr
results: parsing output: 6/ for test: kms_big_fb
results: parsing output: 7/ for test: kms_flip_scaled_crc
results: parsing output: 8/ for test: kms_cursor_edge_walk
results: parsing output: 9/ for test: kms_pm_rpm
results: parsing output: 10/ for test: kms_addfb_basic
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: kms_vrr
results: parsing output: 15/ for test: kms_addfb_basic
results: parsing output: 16/ for test: i915_suspend
results: parsing output: 17/ for test: kms_ccs
results: parsing output: 18/ for test: gem_mmap_wc
results: parsing output: 19/ for test: gem_exec_balancer
results: parsing output: 20/ for test: gem_exec_big
results: parsing output: 21/ for test: gem_mmap_gtt
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: kms_ccs
results: parsing output: 24/ for test: gem_pwrite
results: parsing output: 25/ for test: kms_chamelium_hpd
results: parsing output: 26/ for test: gem_render_copy
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: gem_exec_flush
results: parsing output: 29/ for test: kms_flip
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_atomic
results: parsing output: 32/ for test: gem_workarounds
results: parsing output: 33/ for test: gem_exec_schedule
results: parsing output: 34/ for test: kms_psr
results: parsing output: 35/ for test: gem_wait
results: parsing output: 36/ for test: kms_psr
results: parsing output: 37/ for test: kms_plane
results: parsing output: 38/ for test: kms_ccs
results: parsing output: 39/ for test: kms_plane_alpha_blend
results: parsing output: 40/ for test: kms_frontbuffer_tracking
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: kms_content_protection
results: parsing output: 43/ for test: kms_chamelium_color
results: parsing output: 44/ for test: kms_panel_fitting
results: parsing output: 45/ for test: gem_exec_whisper
results: parsing output: 46/ for test: kms_pm_backlight
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: i915_drm_fdinfo
results: parsing output: 49/ for test: kms_flip_scaled_crc
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_exec_params
results: parsing output: 52/ for test: prime_busy
results: parsing output: 53/ for test: syncobj_basic
results: parsing output: 54/ for test: kms_flip
results: parsing output: 55/ for test: perf_pmu
results: parsing output: 56/ for test: kms_pm_rpm
results: parsing output: 57/ for test: kms_psr
results: parsing output: 58/ for test: kms_dsc
results: parsing output: 59/ for test: gem_userptr_blits
results: parsing output: 60/ for test: gem_exec_params
results: parsing output: 61/ for test: perf_pmu
results: parsing output: 62/ for test: kms_cursor_legacy
results: parsing output: 63/ for test: kms_flip
results: parsing output: 64/ for test: gem_exec_fence
results: parsing output: 65/ for test: kms_frontbuffer_tracking
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_joiner
results: parsing output: 70/ for test: kms_cursor_crc
results: parsing output: 71/ for test: kms_addfb_basic
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_psr2_sf
results: parsing output: 74/ for test: gem_ctx_persistence
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: kms_psr
results: parsing output: 77/ for test: gem_mmap_gtt
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: i915_pciid
results: parsing output: 80/ for test: kms_lease
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: gem_softpin
results: parsing output: 83/ for test: gem_ctx_param
results: parsing output: 84/ for test: kms_big_fb
results: parsing output: 85/ for test: i915_pm_rpm
results: parsing output: 86/ for test: kms_cursor_crc
results: parsing output: 87/ for test: syncobj_wait
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_cursor_legacy
results: parsing output: 92/ for test: gem_exec_alignment
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: gem_render_copy
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_flip
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: kms_chamelium_frames
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: fbdev
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: sw_sync
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_big_fb
results: parsing output: 108/ for test: syncobj_timeline
results: parsing output: 109/ for test: api_intel_bb
results: parsing output: 110/ for test: kms_color_pipeline
results: parsing output: 111/ for test: gem_tiled_blits
results: parsing output: 112/ for test: kms_cursor_legacy
results: parsing output: 113/ for test: syncobj_wait
results: parsing output: 114/ for test: kms_cursor_legacy
results: parsing output: 115/ for test: gem_exec_fence
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: gem_userptr_blits
results: parsing output: 119/ for test: gem_cs_tlb
results: parsing output: 120/ for test: syncobj_wait
results: parsing output: 121/ for test: api_intel_allocator
results: parsing output: 122/ for test: syncobj_timeline
results: parsing output: 123/ for test: gem_exec_fence
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: syncobj_timeline
results: parsing output: 129/ for test: kms_cursor_legacy
results: parsing output: 130/ for test: gem_lmem_swapping
results: parsing output: 131/ for test: kms_plane_multiple
results: parsing output: 132/ for test: gem_exec_schedule
results: parsing output: 133/ for test: syncobj_timeline
results: parsing output: 134/ for test: kms_tiled_display
results: parsing output: 135/ for test: kms_addfb_basic
results: parsing output: 136/ for test: gem_render_copy_redux
results: parsing output: 137/ for test: vgem_basic
results: parsing output: 138/ for test: syncobj_timeline
results: parsing output: 139/ for test: kms_big_fb
results: parsing output: 140/ for test: prime_mmap
results: parsing output: 141/ for test: kms_plane_scaling
results: parsing output: 142/ for test: kms_psr
results: parsing output: 143/ for test: gem_exec_reloc
results: parsing output: 144/ for test: kms_cursor_legacy
results: parsing output: 145/ for test: kms_frontbuffer_tracking
results: parsing output: 146/ for test: syncobj_wait
results: parsing output: 147/ for test: drm_mm
results: parsing output: 148/ for test: kms_frontbuffer_tracking
results: parsing output: 149/ for test: gem_ctx_persistence
results: parsing output: 150/ for test: kms_psr2_sf
results: parsing output: 151/ for test: gem_mmap_gtt
results: parsing output: 152/ for test: kms_frontbuffer_tracking
results: parsing output: 153/ for test: gen9_exec_parse
results: parsing output: 154/ for test: kms_frontbuffer_tracking
results: parsing output: 155/ for test: gem_exec_schedule
Done.