[57.497177] Initializing watchdogs
[57.497221]   /dev/watchdog0
[57.510309] [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.514904] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.517230] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.520616] [001/133] (960s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[57.642101] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[57.646580] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[58.816835] [002/133] (959s left) kms_pm_rpm (pc8-residency)
[61.063518] Starting subtest: pc8-residency
[61.068431] Subtest pc8-residency: SKIP (0.000s)
[61.433135] [003/133] (956s left) api_intel_allocator (default-alignment)
[61.499651] Starting subtest: default-alignment
[61.501618] Subtest default-alignment: SUCCESS (0.003s)
[61.653178] [004/133] (956s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[61.754128] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[66.198764] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.457s)
[67.435966] [005/133] (950s left) syncobj_wait (invalid-reset-zero-handles)
[67.646940] Starting subtest: invalid-reset-zero-handles
[67.649543] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[67.852947] [006/133] (950s left) gem_close (basic)
[68.027363] Starting subtest: basic
[68.029817] Subtest basic: SUCCESS (0.000s)
[68.146092] [007/133] (950s left) gem_exec_schedule (implicit-write-read)
[68.219019] Starting subtest: implicit-write-read
[68.221271] Starting dynamic subtest: rcs0
[68.319712] Dynamic subtest rcs0: SUCCESS (0.108s)
[68.329923] Starting dynamic subtest: vcs0
[68.402840] Dynamic subtest vcs0: SUCCESS (0.083s)
[68.413563] Starting dynamic subtest: vcs1
[68.479455] Dynamic subtest vcs1: SUCCESS (0.077s)
[68.489880] Starting dynamic subtest: vecs0
[68.551996] Dynamic subtest vecs0: SUCCESS (0.072s)
[68.562583] Starting dynamic subtest: ccs0
[68.633685] Dynamic subtest ccs0: SUCCESS (0.080s)
[68.636087] Subtest implicit-write-read: SUCCESS (0.421s)
[70.035191] [008/133] (948s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[70.138408] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[70.142621] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[70.255241] [009/133] (948s left) intel_hwmon (hwmon-write)
[70.317194] Subtest hwmon-write: SKIP (0.000s)
[70.377161] [010/133] (948s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc)
[70.468950] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc
[70.471286] Starting dynamic subtest: pipe-A-eDP-1
[70.494707] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[70.509832] Starting dynamic subtest: pipe-B-eDP-1
[70.532492] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[70.539496] Starting dynamic subtest: pipe-C-eDP-1
[70.562083] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[70.569340] Starting dynamic subtest: pipe-D-eDP-1
[70.591575] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[70.595685] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[72.669123] [011/133] (945s left) gem_watchdog (default-physical)
[72.746707] Starting subtest: default-physical
[74.511980] Subtest default-physical: SUCCESS (1.776s)
[74.642311] [012/133] (943s left) kms_psr (fbc-pr-sprite-mmap-gtt)
[74.743059] Starting subtest: fbc-pr-sprite-mmap-gtt
[74.747582] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s)
[74.829997] [013/133] (943s left) kms_flip (2x-absolute-wf_vblank-interruptible)
[74.934399] Starting subtest: 2x-absolute-wf_vblank-interruptible
[74.947916] Subtest 2x-absolute-wf_vblank-interruptible: SKIP (0.011s)
[75.034828] [014/133] (943s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[75.131800] Starting subtest: fbc-pr-cursor-mmap-gtt
[75.136114] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[75.210666] [015/133] (943s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[75.310238] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[82.251890] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (6.947s)
[82.408569] [016/133] (936s left) syncobj_timeline (multi-wait-for-submit-available-unsubmitted-submitted-signa
[82.463587] Starting subtest: multi-wait-for-submit-available-unsubmitted-submitted-signaled
[82.466141] Subtest multi-wait-for-submit-available-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[82.564653] [017/133] (936s left) kms_psr (psr-sprite-mmap-cpu)
[82.657050] Starting subtest: psr-sprite-mmap-cpu
[82.659431] Starting dynamic subtest: eDP-1
[84.412099] Dynamic subtest eDP-1: SUCCESS (1.755s)
[84.414273] Subtest psr-sprite-mmap-cpu: SUCCESS (1.755s)
[85.254017] [018/133] (933s left) perf_pmu (multi-client)
[85.302986] Starting subtest: multi-client
[85.305203] Starting dynamic subtest: rcs0
[86.384230] Dynamic subtest rcs0: SUCCESS (1.081s)
[86.392989] Starting dynamic subtest: bcs0
[87.431546] Dynamic subtest bcs0: SUCCESS (1.046s)
[87.439987] Starting dynamic subtest: vcs0
[88.479921] Dynamic subtest vcs0: SUCCESS (1.048s)
[88.490173] Starting dynamic subtest: vcs1
[89.931309] Dynamic subtest vcs1: SUCCESS (1.451s)
[89.941716] Starting dynamic subtest: vecs0
[91.915970] Dynamic subtest vecs0: SUCCESS (1.984s)
[91.925778] Starting dynamic subtest: ccs0
[93.903712] Dynamic subtest ccs0: SUCCESS (1.987s)
[93.906303] Subtest multi-client: SUCCESS (8.602s)
[94.049576] [019/133] (924s left) syncobj_timeline (etime-multi-wait-available-unsubmitted)
[94.114301] Starting subtest: etime-multi-wait-available-unsubmitted
[94.217854] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.101s)
[94.305988] [020/133] (924s left) kms_plane (plane-position-covered)
[94.406657] Starting subtest: plane-position-covered
[94.907534] Starting dynamic subtest: pipe-A-plane-1
[96.214081] Dynamic subtest pipe-A-plane-1: SUCCESS (1.307s)
[96.224197] Starting dynamic subtest: pipe-A-plane-2
[97.490874] Dynamic subtest pipe-A-plane-2: SUCCESS (1.276s)
[97.500435] Starting dynamic subtest: pipe-A-plane-3
[98.792867] Dynamic subtest pipe-A-plane-3: SUCCESS (1.303s)
[98.800218] Starting dynamic subtest: pipe-A-plane-4
[100.019144] Dynamic subtest pipe-A-plane-4: SUCCESS (1.223s)
[100.027412] Starting dynamic subtest: pipe-A-plane-5
[100.044295] Dynamic subtest pipe-A-plane-5: SUCCESS (0.025s)
[101.179476] Starting dynamic subtest: pipe-B-plane-1
[102.444713] Dynamic subtest pipe-B-plane-1: SUCCESS (1.273s)
[102.457264] Starting dynamic subtest: pipe-B-plane-2
[103.735822] Dynamic subtest pipe-B-plane-2: SUCCESS (1.290s)
[103.744833] Starting dynamic subtest: pipe-B-plane-3
[104.964099] Dynamic subtest pipe-B-plane-3: SUCCESS (1.229s)
[104.972190] Starting dynamic subtest: pipe-B-plane-4
[106.198847] Dynamic subtest pipe-B-plane-4: SUCCESS (1.234s)
[106.207876] Starting dynamic subtest: pipe-B-plane-5
[106.223021] Dynamic subtest pipe-B-plane-5: SUCCESS (0.023s)
[106.225303] Subtest plane-position-covered: SUCCESS (11.817s)
[107.006156] [021/133] (911s left) gem_create (hog-create)
[107.069564] Starting subtest: hog-create
[107.071933] Starting dynamic subtest: smem0
[140.903861] Dynamic subtest smem0: SUCCESS (33.832s)
[140.906826] Subtest hog-create: SUCCESS (33.834s)
[141.098258] [022/133] (877s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-wc)
[141.208612] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-wc
[148.248278] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (7.042s)
[148.372789] [023/133] (870s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[148.438165] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[148.546572] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.108s)
[148.646129] [024/133] (870s left) gem_media_fill (media-fill)
[148.707298] Subtest media-fill: SKIP (0.000s)
[148.827194] [025/133] (870s left) gem_exec_store (dword)
[148.892515] Starting subtest: dword
[148.894686] Starting dynamic subtest: rcs0
[148.972509] Dynamic subtest rcs0: SUCCESS (0.081s)
[148.982815] Starting dynamic subtest: bcs0
[149.013625] Dynamic subtest bcs0: SUCCESS (0.040s)
[149.023178] Starting dynamic subtest: vcs0
[149.053998] Dynamic subtest vcs0: SUCCESS (0.039s)
[149.062444] Starting dynamic subtest: vcs1
[149.095728] Dynamic subtest vcs1: SUCCESS (0.040s)
[149.105890] Starting dynamic subtest: vecs0
[149.138613] Dynamic subtest vecs0: SUCCESS (0.042s)
[149.148111] Starting dynamic subtest: ccs0
[149.179432] Dynamic subtest ccs0: SUCCESS (0.040s)
[149.181778] Subtest dword: SUCCESS (0.289s)
[149.372460] [026/133] (869s left) gem_lmem_evict (dontneed-evict-race)
[149.417262] Subtest dontneed-evict-race: SKIP (0.000s)
[149.457946] [027/133] (869s left) sysfs_heartbeat_interval (nopreempt)
[149.520651] Starting subtest: nopreempt
[149.523118] Starting dynamic subtest: vecs0
[158.942818] Dynamic subtest vecs0: SUCCESS (9.419s)
[158.953635] Starting dynamic subtest: ccs0
[163.021450] Dynamic subtest ccs0: SUCCESS (4.076s)
[163.031981] Starting dynamic subtest: vcs0
[172.900118] Dynamic subtest vcs0: SUCCESS (9.878s)
[172.911065] Starting dynamic subtest: bcs0
[176.989267] Dynamic subtest bcs0: SUCCESS (4.086s)
[176.998734] Starting dynamic subtest: rcs0
[181.102727] Dynamic subtest rcs0: SUCCESS (4.111s)
[181.112868] Starting dynamic subtest: vcs1
[190.938255] Dynamic subtest vcs1: SUCCESS (9.834s)
[190.940761] Subtest nopreempt: SUCCESS (41.415s)
[191.022735] [028/133] (828s left) kms_cursor_legacy (2x-flip-vs-cursor-legacy)
[191.145302] Starting subtest: 2x-flip-vs-cursor-legacy
[191.149736] Subtest 2x-flip-vs-cursor-legacy: SKIP (0.001s)
[191.304333] [029/133] (827s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[191.421536] Starting subtest: flip-vs-cursor-legacy
[198.448738] Subtest flip-vs-cursor-legacy: SUCCESS (7.027s)
[199.273064] [030/133] (819s left) kms_psr (psr2-cursor-plane-move)
[199.385982] Starting subtest: psr2-cursor-plane-move
[199.388214] Starting dynamic subtest: eDP-1
[201.029699] Dynamic subtest eDP-1: SUCCESS (1.651s)
[201.031829] Subtest psr2-cursor-plane-move: SUCCESS (1.651s)
[201.831945] [031/133] (817s left) kms_cursor_crc (cursor-offscreen-64x64)
[202.066784] Starting subtest: cursor-offscreen-64x64
[202.071510] Starting dynamic subtest: pipe-A-eDP-1
[204.035399] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.962s)
[204.062039] Starting dynamic subtest: pipe-D-eDP-1
[206.614466] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.557s)
[206.616780] Subtest cursor-offscreen-64x64: SUCCESS (4.548s)
[207.493561] [032/133] (811s left) kms_cursor_crc (cursor-rapid-movement-512x512)
[207.773875] Starting subtest: cursor-rapid-movement-512x512
[207.778224] Subtest cursor-rapid-movement-512x512: SKIP (0.001s)
[207.960851] [033/133] (811s left) kms_psr (fbc-psr-sprite-mmap-cpu)
[208.060098] Starting subtest: fbc-psr-sprite-mmap-cpu
[208.062388] Starting dynamic subtest: eDP-1
[208.066792] Dynamic subtest eDP-1: SKIP (0.000s)
[208.071236] Subtest fbc-psr-sprite-mmap-cpu: SKIP (0.001s)
[208.140902] [034/133] (811s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[208.235214] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[208.239277] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[208.361416] [035/133] (810s left) gem_exec_params (secure-non-root)
[208.425245] Starting subtest: secure-non-root
[208.428951] Subtest secure-non-root: SKIP (0.000s)
[208.550779] [036/133] (810s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[208.648912] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[215.617910] Subtest psr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.971s)
[215.785722] [037/133] (803s left) gem_ctx_persistence (legacy-engines-mixed-process)
[215.856026] Starting subtest: legacy-engines-mixed-process
[215.858195] Starting dynamic subtest: render
[217.960952] Dynamic subtest render: SUCCESS (2.104s)
[217.969855] Starting dynamic subtest: bsd1
[219.896049] Dynamic subtest bsd1: SUCCESS (1.933s)
[219.909326] Starting dynamic subtest: bsd2
[221.940892] Dynamic subtest bsd2: SUCCESS (2.042s)
[221.954194] Starting dynamic subtest: blt
[223.879482] Dynamic subtest blt: SUCCESS (1.934s)
[223.887972] Starting dynamic subtest: vebox
[225.902270] Dynamic subtest vebox: SUCCESS (2.023s)
[225.904846] Subtest legacy-engines-mixed-process: SUCCESS (10.047s)
[226.003134] [038/133] (793s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-msflip-blt)
[226.113418] Starting subtest: fbc-2p-primscrn-indfb-msflip-blt
[226.117867] Subtest fbc-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[226.231801] [039/133] (793s left) kms_content_protection (dp-mst-type-0)
[226.374449] Starting subtest: dp-mst-type-0
[226.378900] Subtest dp-mst-type-0: SKIP (0.000s)
[226.535338] [040/133] (793s left) i915_hangman (engine-engine-error)
[226.608425] Starting subtest: engine-engine-error
[226.610635] Starting dynamic subtest: rcs0
[227.892396] Dynamic subtest rcs0: SUCCESS (1.284s)
[227.904974] Starting dynamic subtest: bcs0
[229.875100] Dynamic subtest bcs0: SUCCESS (1.980s)
[229.885657] Starting dynamic subtest: vcs0
[231.860075] Dynamic subtest vcs0: SUCCESS (1.982s)
[231.871054] Starting dynamic subtest: vcs1
[233.843612] Dynamic subtest vcs1: SUCCESS (1.981s)
[233.854900] Starting dynamic subtest: vecs0
[235.892214] Dynamic subtest vecs0: SUCCESS (2.046s)
[235.906322] Starting dynamic subtest: ccs0
[237.874976] Dynamic subtest ccs0: SUCCESS (1.980s)
[237.877942] Subtest engine-engine-error: SUCCESS (11.269s)
[237.966945] [041/133] (781s left) i915_pm_rps (min-max-config-loaded)
[238.044826] Starting subtest: min-max-config-loaded
[238.049460] Subtest min-max-config-loaded: SKIP (0.001s)
[238.173733] [042/133] (781s left) kms_color_pipeline (plane-ctm3x4)
[238.280722] Starting subtest: plane-ctm3x4
[238.294298] Starting dynamic subtest: pipe-A-eDP-1
[238.947857] Dynamic subtest pipe-A-eDP-1: FAIL (0.291s)
[239.677813] Starting dynamic subtest: pipe-B-eDP-1
[240.442179] Dynamic subtest pipe-B-eDP-1: FAIL (0.269s)
[241.016243] Starting dynamic subtest: pipe-C-eDP-1
[241.813960] Dynamic subtest pipe-C-eDP-1: FAIL (0.224s)
[242.352285] Starting dynamic subtest: pipe-D-eDP-1
[243.162460] Dynamic subtest pipe-D-eDP-1: FAIL (0.237s)
[243.164823] Subtest plane-ctm3x4: FAIL (4.585s)
[243.736773] [043/133] (775s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[243.844127] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[243.848137] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[243.973396] [044/133] (775s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[244.082954] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[247.743574] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.663s)
[248.946238] [045/133] (770s left) gem_readwrite (beyond-eob)
[249.006112] Subtest beyond-EOB: SKIP (0.000s)
[249.070508] [046/133] (770s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[249.175401] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[249.179793] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[249.288915] [047/133] (770s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[249.352429] Starting subtest: yf-tiled-to-vebox-x-tiled
[249.357071] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[249.543931] [048/133] (770s left) kms_invalid_mode (zero-hdisplay)
[249.645021] Starting subtest: zero-hdisplay
[249.647355] Starting dynamic subtest: pipe-A-eDP-1
[249.934255] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.290s)
[249.942078] Starting dynamic subtest: pipe-B-eDP-1
[249.943936] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[249.951081] Starting dynamic subtest: pipe-C-eDP-1
[249.952951] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[249.960585] Starting dynamic subtest: pipe-D-eDP-1
[249.962723] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[249.964950] Subtest zero-hdisplay: SUCCESS (0.296s)
[250.760942] [049/133] (769s left) gem_userptr_blits (process-exit)
[250.827337] Starting subtest: process-exit
[250.834297] Subtest process-exit: SUCCESS (0.010s)
[250.998395] [050/133] (768s left) kms_atomic_transition (plane-all-transition-nonblocking)
[251.106333] Starting subtest: plane-all-transition-nonblocking
[251.108630] Starting dynamic subtest: pipe-A-eDP-1
[253.598497] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.493s)
[253.920199] Starting dynamic subtest: pipe-B-eDP-1
[257.193440] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.282s)
[257.489653] Subtest plane-all-transition-nonblocking: SUCCESS (6.385s)
[258.325502] [051/133] (761s left) gem_exec_flush (basic-batch-kernel-default-cmd)
[258.387388] Starting subtest: basic-batch-kernel-default-cmd
[258.391767] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s)
[258.580472] [052/133] (761s left) i915_drm_fdinfo (memory-info-shared)
[258.617785] Starting subtest: memory-info-shared
[258.619702] Starting dynamic subtest: smem0
[258.696277] Dynamic subtest smem0: SUCCESS (0.082s)
[258.698740] Subtest memory-info-shared: SUCCESS (0.082s)
[258.778925] [053/133] (761s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[258.881960] Starting subtest: psr-shrfb-scaledprimary
[264.667725] Subtest psr-shrfb-scaledprimary: SUCCESS (5.789s)
[264.802108] [054/133] (755s left) kms_big_fb (4-tiled-16bpp-rotate-270)
[264.925264] Starting subtest: 4-tiled-16bpp-rotate-270
[264.945271] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.019s)
[265.103870] [055/133] (755s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[265.215779] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[265.895478] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.681s)
[266.099536] [056/133] (754s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[266.195716] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[266.197957] Starting dynamic subtest: pipe-A
[266.258370] Dynamic subtest pipe-A: SUCCESS (0.064s)
[266.267327] Starting dynamic subtest: pipe-B
[267.361158] Dynamic subtest pipe-B: SUCCESS (1.102s)
[267.375535] Starting dynamic subtest: pipe-C
[268.479445] Dynamic subtest pipe-C: SUCCESS (1.117s)
[268.488202] Starting dynamic subtest: pipe-D
[269.620796] Dynamic subtest pipe-D: SUCCESS (1.141s)
[269.623076] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.428s)
[270.779156] [057/133] (749s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[270.880073] Starting subtest: fbcpsr-rgb565-draw-blt
[277.898298] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (7.020s)
[278.077253] [058/133] (742s left) gem_eio (wait-wedge-10ms)
[278.303834] Starting subtest: wait-wedge-10ms
[279.956425] Subtest wait-wedge-10ms: SUCCESS (1.651s)
[280.130009] [059/133] (740s left) gem_ctx_param (invalid-get-engines)
[280.203103] Starting subtest: invalid-get-engines
[280.205456] Subtest invalid-get-engines: SUCCESS (0.001s)
[280.349180] [060/133] (739s left) kms_psr (pr-primary-mmap-cpu)
[280.438797] Starting subtest: pr-primary-mmap-cpu
[280.443665] Subtest pr-primary-mmap-cpu: SKIP (0.000s)
[280.522346] [061/133] (739s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[280.627070] Starting subtest: y-tiled-8bpp-rotate-90
[280.631610] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[280.754483] [062/133] (739s left) kms_ccs (random-ccs-data-yf-tiled-ccs)
[280.839990] Starting subtest: random-ccs-data-yf-tiled-ccs
[280.842286] Starting dynamic subtest: pipe-A-eDP-1
[280.866534] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[280.876086] Starting dynamic subtest: pipe-B-eDP-1
[280.895526] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[280.903532] Starting dynamic subtest: pipe-C-eDP-1
[280.923176] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[280.931309] Starting dynamic subtest: pipe-D-eDP-1
[280.952865] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[280.956463] Subtest random-ccs-data-yf-tiled-ccs: SKIP (0.004s)
[283.173798] [063/133] (737s left) kms_flip (flip-vs-absolute-wf_vblank)
[283.275439] Starting subtest: flip-vs-absolute-wf_vblank
[283.277844] Starting dynamic subtest: A-eDP1
[292.200872] Dynamic subtest A-eDP1: SUCCESS (8.928s)
[292.208408] Starting dynamic subtest: B-eDP1
[301.136111] Dynamic subtest B-eDP1: SUCCESS (8.933s)
[301.146824] Starting dynamic subtest: C-eDP1
[310.048746] Dynamic subtest C-eDP1: SUCCESS (8.911s)
[310.059570] Starting dynamic subtest: D-eDP1
[318.970677] Dynamic subtest D-eDP1: SUCCESS (8.919s)
[318.975595] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.704s)
[320.206756] [064/133] (700s left) syncobj_wait (signal)
[320.262216] Starting subtest: signal
[320.264471] Subtest signal: SUCCESS (0.000s)
[320.371861] [065/133] (700s left) kms_pipe_crc_basic (bad-source)
[320.468753] Starting subtest: bad-source
[320.471058] Subtest bad-source: SUCCESS (0.000s)
[320.553718] [066/133] (699s left) gem_exec_fence (syncobj-invalid-flags)
[321.018592] Starting subtest: syncobj-invalid-flags
[321.021050] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[322.071188] [FACT gem_exec_fence (syncobj-invalid-flags)] new: kernel.kmod_is_loaded.vgem: true
[322.074596] [067/133] (698s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[322.187076] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf
[322.191382] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[322.265172] [068/133] (698s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs)
[322.368626] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs
[322.370942] Starting dynamic subtest: pipe-A-eDP-1
[322.393555] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[322.407333] Starting dynamic subtest: pipe-B-eDP-1
[322.428527] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[322.436508] Starting dynamic subtest: pipe-C-eDP-1
[322.457957] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[322.466083] Starting dynamic subtest: pipe-D-eDP-1
[322.488031] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[322.492065] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[324.672740] [069/133] (695s left) kms_plane_multiple (2x-tiling-yf)
[324.767918] Starting subtest: 2x-tiling-yf
[324.771889] Subtest 2x-tiling-yf: SKIP (0.000s)
[324.852589] [070/133] (695s left) sw_sync (sync_merge)
[324.891565] Starting subtest: sync_merge
[324.893767] Subtest sync_merge: SUCCESS (0.000s)
[324.959035] [071/133] (695s left) core_debugfs (read-all-entries)
[325.020586] Starting subtest: read-all-entries
[325.101243] Subtest read-all-entries: SUCCESS (0.083s)
[325.183961] [072/133] (695s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180)
[325.289356] Starting subtest: linear-max-hw-stride-64bpp-rotate-180
[326.414723] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.124s)
[326.595316] [073/133] (694s left) kms_frontbuffer_tracking (fbcpsr-tiling-y)
[326.716152] Starting subtest: fbcpsr-tiling-y
[326.719964] Subtest fbcpsr-tiling-y: SKIP (0.000s)
[326.854878] [074/133] (694s left) kms_lease (lease-revoke)
[326.956334] Starting subtest: lease-revoke
[326.958312] Starting dynamic subtest: pipe-A-eDP-1
[326.985709] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.031s)
[326.995188] Starting dynamic subtest: pipe-B-eDP-1
[327.021349] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.032s)
[327.029999] Starting dynamic subtest: pipe-C-eDP-1
[327.048696] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.028s)
[327.057043] Starting dynamic subtest: pipe-D-eDP-1
[327.076727] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.026s)
[327.078584] Subtest lease-revoke: SUCCESS (0.124s)
[327.234516] [075/133] (693s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[327.350573] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[327.353872] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[327.472033] [076/133] (693s left) kms_plane (pixel-format-4-tiled-mtl-rc-ccs-cc-modifier)
[327.566942] Starting subtest: pixel-format-4-tiled-mtl-rc-ccs-cc-modifier
[327.596324] Starting dynamic subtest: pipe-A-plane-0
[327.884671] Dynamic subtest pipe-A-plane-0: SUCCESS (0.288s)
[327.894653] Starting dynamic subtest: pipe-A-plane-3
[328.118081] Dynamic subtest pipe-A-plane-3: SUCCESS (0.233s)
[328.126724] Starting dynamic subtest: pipe-A-plane-5
[328.130207] Dynamic subtest pipe-A-plane-5: SKIP (0.000s)
[329.234242] Starting dynamic subtest: pipe-B-plane-0
[329.527757] Dynamic subtest pipe-B-plane-0: SUCCESS (0.300s)
[329.536552] Starting dynamic subtest: pipe-B-plane-3
[329.760752] Dynamic subtest pipe-B-plane-3: SUCCESS (0.231s)
[329.769812] Starting dynamic subtest: pipe-B-plane-5
[329.774225] Dynamic subtest pipe-B-plane-5: SKIP (0.000s)
[330.071788] Subtest pixel-format-4-tiled-mtl-rc-ccs-cc-modifier: SUCCESS (2.502s)
[330.907158] [077/133] (690s left) perf (global-sseu-config-invalid)
[331.041589] Starting subtest: global-sseu-config-invalid
[331.045813] Subtest global-sseu-config-invalid: SKIP (0.000s)
[331.089260] [078/133] (689s left) gem_render_copy (y-tiled-ccs-to-x-tiled)
[331.159183] Starting subtest: y-tiled-ccs-to-x-tiled
[331.164153] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s)
[331.369096] [079/133] (689s left) gem_exec_balancer (full)
[331.441099] Starting subtest: full
[335.806844] Subtest full: SUCCESS (4.365s)
[336.181182] [080/133] (684s left) gem_fenced_exec_thrash (too-many-fences)
[336.242433] Subtest too-many-fences: SKIP (0.000s)
[336.314452] [081/133] (684s left) gem_exec_balancer (parallel-dmabuf-import-out-fence)
[336.572857] Starting subtest: parallel-dmabuf-import-out-fence
[337.730609] Subtest parallel-dmabuf-import-out-fence: SUCCESS (1.158s)
[337.857295] [082/133] (683s left) gem_mmap_offset (bad-flags)
[337.921711] Starting subtest: bad-flags
[337.924152] Subtest bad-flags: SUCCESS (0.000s)
[338.054479] [083/133] (683s left) kms_dp_aux_dev
[338.429100] [084/133] (682s left) gem_exec_schedule (timeslicing)
[338.502961] Starting subtest: timeslicing
[338.504971] Starting dynamic subtest: rcs0
[338.513161] Dynamic subtest rcs0: SUCCESS (0.021s)
[338.524691] Starting dynamic subtest: bcs0
[338.533526] Dynamic subtest bcs0: SUCCESS (0.020s)
[338.541901] Starting dynamic subtest: vcs0
[338.554480] Dynamic subtest vcs0: SUCCESS (0.020s)
[338.563327] Starting dynamic subtest: vcs1
[338.574502] Dynamic subtest vcs1: SUCCESS (0.019s)
[338.583487] Starting dynamic subtest: vecs0
[338.600271] Dynamic subtest vecs0: SUCCESS (0.025s)
[338.613735] Starting dynamic subtest: ccs0
[338.624672] Dynamic subtest ccs0: SUCCESS (0.023s)
[338.626997] Subtest timeslicing: SUCCESS (0.134s)
[340.003208] [085/133] (681s left) gem_exec_reloc (basic-cpu-gtt-active)
[340.065889] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[340.156405] [086/133] (681s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-wc)
[340.264096] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-wc
[340.268244] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[340.389903] [087/133] (681s left) kms_cursor_legacy (cursorb-vs-flipb-atomic-transitions-varying-size)
[340.511400] Starting subtest: cursorB-vs-flipB-atomic-transitions-varying-size
[340.515919] Subtest cursorB-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[340.668272] [088/133] (680s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[340.763944] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[340.774781] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.010s)
[340.903962] [089/133] (680s left) kms_pipe_crc_basic (suspend-read-crc)
[340.994565] Starting subtest: suspend-read-crc
[340.996252] Starting dynamic subtest: pipe-A-eDP-1
[358.873911] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.818s)
[358.883684] Starting dynamic subtest: pipe-B-eDP-1
[377.713177] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.133s)
[377.722808] Starting dynamic subtest: pipe-C-eDP-1
[395.659462] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.021s)
[395.669638] Starting dynamic subtest: pipe-D-eDP-1
[413.677313] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.055s)
[413.680057] Subtest suspend-read-crc: SUCCESS (12.032s)
[414.510367] [090/133] (607s left) kms_addfb_basic (unused-modifier)
[414.580060] Starting subtest: unused-modifier
[414.582210] Subtest unused-modifier: SUCCESS (0.000s)
[414.747720] [091/133] (606s left) kms_pm_rpm (basic-pci-d3-state)
[416.877419] Starting subtest: basic-pci-d3-state
[418.352408] Subtest basic-pci-d3-state: SUCCESS (1.488s)
[418.451325] [092/133] (603s left) gem_exec_params (rsvd2-dirt)
[418.509321] Starting subtest: rsvd2-dirt
[418.515060] Subtest rsvd2-dirt: SKIP (0.000s)
[418.621635] [093/133] (603s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[418.722979] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[418.725660] Starting dynamic subtest: pipe-A-eDP-1
[418.750068] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[418.760785] Starting dynamic subtest: pipe-B-eDP-1
[418.785241] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[418.793982] Starting dynamic subtest: pipe-C-eDP-1
[418.819768] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[418.829641] Starting dynamic subtest: pipe-D-eDP-1
[418.855685] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[418.860596] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[420.972708] [094/133] (600s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-blt)
[421.072334] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-blt
[427.970066] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.927s)
[428.157698] [095/133] (593s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[428.552431] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[429.370889] [096/133] (592s left) gem_exec_schedule (fairslice)
[429.446886] Starting subtest: fairslice
[429.449861] Starting dynamic subtest: rcs0
[431.455094] Dynamic subtest rcs0: SUCCESS (2.024s)
[431.467477] Starting dynamic subtest: bcs0
[433.474665] Dynamic subtest bcs0: SUCCESS (2.023s)
[433.485883] Starting dynamic subtest: vcs0
[435.498355] Dynamic subtest vcs0: SUCCESS (2.023s)
[435.507823] Starting dynamic subtest: vcs1
[437.518792] Dynamic subtest vcs1: SUCCESS (2.022s)
[437.528625] Starting dynamic subtest: vecs0
[439.536561] Dynamic subtest vecs0: SUCCESS (2.019s)
[439.545760] Starting dynamic subtest: ccs0
[441.557875] Dynamic subtest ccs0: SUCCESS (2.022s)
[441.560552] Subtest fairslice: SUCCESS (12.138s)
[441.881208] [097/133] (579s left) kms_psr2_sf (pr-overlay-plane-update-sf-dmg-area)
[441.991931] Starting subtest: pr-overlay-plane-update-sf-dmg-area
[441.996750] Subtest pr-overlay-plane-update-sf-dmg-area: SKIP (0.000s)
[442.069807] [098/133] (579s left) gem_eio (create-ext)
[442.276682] Starting subtest: create-ext
[442.571245] Subtest create-ext: SUCCESS (0.293s)
[442.721226] [099/133] (579s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[442.828224] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[442.832919] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[442.964074] [100/133] (579s left) kms_dsc (dsc-with-output-formats)
[443.056605] Starting subtest: dsc-with-output-formats
[443.076816] Subtest dsc-with-output-formats: SKIP (0.000s)
[443.141210] [101/133] (578s left) kms_vblank (ts-continuation-dpms-suspend)
[443.238876] Starting subtest: ts-continuation-dpms-suspend
[443.240880] Starting dynamic subtest: pipe-A-eDP-1
[460.559053] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.039s)
[460.573891] Starting dynamic subtest: pipe-D-eDP-1
[478.344469] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.498s)
[478.347377] Subtest ts-continuation-dpms-suspend: SUCCESS (4.540s)
[479.142960] [102/133] (542s left) sw_sync (sync_expired_merge)
[479.186484] Starting subtest: sync_expired_merge
[480.244884] Subtest sync_expired_merge: SUCCESS (1.074s)
[480.316981] [103/133] (541s left) tools_test (tools_test)
[480.370771] Starting subtest: tools_test
[480.429992] Subtest tools_test: SUCCESS (0.072s)
[480.525756] [104/133] (541s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[480.582743] Starting subtest: single-wait-for-submit-available-signaled
[480.585565] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[480.706991] [105/133] (541s left) fbdev (nullptr)
[480.748141] Starting subtest: nullptr
[480.750657] Subtest nullptr: SUCCESS (0.000s)
[480.822217] [106/133] (541s left) kms_busy (basic-hang)
[480.924735] Starting subtest: basic-hang
[480.927531] Starting dynamic subtest: flip-pipe-A
[481.493001] Dynamic subtest flip-pipe-A: SUCCESS (0.574s)
[481.509877] Starting dynamic subtest: modeset-pipe-A
[484.908732] Dynamic subtest modeset-pipe-A: SUCCESS (3.442s)
[484.920118] Starting dynamic subtest: flip-pipe-D
[486.120530] Dynamic subtest flip-pipe-D: SUCCESS (1.217s)
[486.131752] Starting dynamic subtest: modeset-pipe-D
[489.526502] Dynamic subtest modeset-pipe-D: SUCCESS (3.419s)
[489.529047] Subtest basic-hang: SUCCESS (8.659s)
[490.338129] [107/133] (531s left) kms_vblank (accuracy-idle)
[490.441718] Starting subtest: accuracy-idle
[490.444631] Starting dynamic subtest: pipe-A-eDP-1
[492.201768] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.765s)
[492.219453] Starting dynamic subtest: pipe-D-eDP-1
[494.692735] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.490s)
[494.695050] Subtest accuracy-idle: SUCCESS (4.260s)
[495.512947] [108/133] (526s left) gen9_exec_parse (bb-start-param)
[495.582612] Subtest bb-start-param: SKIP (0.000s)
[495.652818] [109/133] (526s left) gem_pxp (hw-rejects-pxp-buffer)
[495.777416] Starting subtest: hw-rejects-pxp-buffer
[495.782575] Subtest hw-rejects-pxp-buffer: SKIP (0.000s)
[495.921750] [110/133] (526s left) i915_query (engine-info)
[495.973367] Starting subtest: engine-info
[495.975437] Subtest engine-info: SUCCESS (0.005s)
[496.111266] [111/133] (526s left) gem_eio (wait-10ms)
[496.323644] Starting subtest: wait-10ms
[496.653601] Subtest wait-10ms: SUCCESS (0.331s)
[496.826003] [112/133] (525s left) gem_pxp (create-protected-buffer)
[496.889194] Starting subtest: create-protected-buffer
[496.891565] Subtest create-protected-buffer: SUCCESS (0.000s)
[497.019027] [113/133] (525s left) device_reset (unbind-reset-rebind)
[497.068729] Starting subtest: unbind-reset-rebind
[500.170589] Subtest unbind-reset-rebind: SUCCESS (3.102s)
[500.213888] [114/133] (522s left) perf (missing-sample-flags)
[500.340832] Starting subtest: missing-sample-flags
[500.343513] Subtest missing-sample-flags: SUCCESS (0.001s)
[500.385322] [115/133] (522s left) gem_userptr_blits (stress-mm)
[500.463645] Starting subtest: stress-mm
[505.827408] Subtest stress-mm: SUCCESS (5.369s)
[505.993237] [116/133] (516s left) gem_spin_batch (resubmit)
[506.057757] Starting subtest: resubmit
[506.060595] Starting dynamic subtest: rcs0
[506.070445] Dynamic subtest rcs0: SUCCESS (0.013s)
[506.082861] Starting dynamic subtest: bcs0
[506.086221] Dynamic subtest bcs0: SUCCESS (0.006s)
[506.095762] Starting dynamic subtest: vcs0
[506.098580] Dynamic subtest vcs0: SUCCESS (0.007s)
[506.109057] Starting dynamic subtest: vcs1
[506.111802] Dynamic subtest vcs1: SUCCESS (0.003s)
[506.121489] Starting dynamic subtest: vecs0
[506.124417] Dynamic subtest vecs0: SUCCESS (0.004s)
[506.133750] Starting dynamic subtest: ccs0
[506.136768] Dynamic subtest ccs0: SUCCESS (0.006s)
[506.139661] Subtest resubmit: SUCCESS (0.043s)
[506.350626] [117/133] (516s left) sriov_basic (enable-vfs-autoprobe-off)
[506.412405] Starting subtest: enable-vfs-autoprobe-off
[506.414910] Starting dynamic subtest: numvfs-1
[506.492556] Dynamic subtest numvfs-1: FAIL (0.005s)
[506.502624] Starting dynamic subtest: numvfs-2
[506.590825] Dynamic subtest numvfs-2: FAIL (0.004s)
[506.601779] Starting dynamic subtest: numvfs-3
[506.688685] Dynamic subtest numvfs-3: FAIL (0.003s)
[506.698646] Starting dynamic subtest: numvfs-4
[506.786153] Dynamic subtest numvfs-4: FAIL (0.004s)
[506.797187] Starting dynamic subtest: numvfs-5
[506.879506] Dynamic subtest numvfs-5: FAIL (0.003s)
[506.889652] Starting dynamic subtest: numvfs-6
[506.965352] Dynamic subtest numvfs-6: FAIL (0.004s)
[506.975547] Starting dynamic subtest: numvfs-7
[507.048505] Dynamic subtest numvfs-7: FAIL (0.003s)
[507.058476] Starting dynamic subtest: numvfs-random
[507.130346] Dynamic subtest numvfs-random: FAIL (0.003s)
[507.139877] Starting dynamic subtest: numvfs-all
[507.214690] Dynamic subtest numvfs-all: FAIL (0.571s)
[507.216894] Subtest enable-vfs-autoprobe-off: FAIL (0.608s)
[507.256830] [118/133] (515s left) gem_flink_race (flink_close)
[507.296814] Starting subtest: flink_close
[512.404157] Subtest flink_close: SUCCESS (5.108s)
[512.520672] [119/133] (510s left) kms_flip (basic-flip-vs-dpms)
[512.626801] Starting subtest: basic-flip-vs-dpms
[512.629345] Starting dynamic subtest: A-eDP1
[515.195746] Dynamic subtest A-eDP1: SUCCESS (2.565s)
[515.207391] Starting dynamic subtest: B-eDP1
[517.369292] Dynamic subtest B-eDP1: SUCCESS (2.171s)
[517.381025] Starting dynamic subtest: C-eDP1
[519.449564] Dynamic subtest C-eDP1: SUCCESS (2.078s)
[519.460873] Starting dynamic subtest: D-eDP1
[521.618532] Dynamic subtest D-eDP1: SUCCESS (2.167s)
[521.624922] Subtest basic-flip-vs-dpms: SUCCESS (8.992s)
[522.434487] [120/133] (500s left) kms_flip (2x-flip-vs-suspend)
[522.537025] Starting subtest: 2x-flip-vs-suspend
[522.545753] Subtest 2x-flip-vs-suspend: SKIP (0.011s)
[522.672024] [121/133] (500s left) prime_vgem (basic-fence-read)
[522.759759] Starting subtest: basic-fence-read
[522.779624] Subtest basic-fence-read: SKIP (0.020s)
[522.903814] [122/133] (500s left) perf (rc6-disable)
[522.999254] Starting subtest: rc6-disable
[523.197077] Subtest rc6-disable: SUCCESS (0.198s)
[523.248770] [123/133] (499s left) kms_cursor_crc (cursor-sliding-64x64)
[523.418854] Starting subtest: cursor-sliding-64x64
[523.432320] Starting dynamic subtest: pipe-A-eDP-1
[526.675752] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.241s)
[526.703231] Starting dynamic subtest: pipe-D-eDP-1
[530.579532] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.885s)
[530.582466] Subtest cursor-sliding-64x64: SUCCESS (7.160s)
[531.394267] [124/133] (491s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-upscaling)
[531.491156] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-upscaling
[531.493514] Starting dynamic subtest: pipe-A-default-mode
[534.258753] Dynamic subtest pipe-A-default-mode: SUCCESS (2.768s)
[534.261798] Subtest flip-64bpp-xtile-to-16bpp-xtile-upscaling: SUCCESS (2.769s)
[535.107982] [125/133] (487s left) kms_chamelium_frames (dp-crc-multiple)
[535.489681] Subtest dp-crc-multiple: SKIP (0.000s)
[536.302458] [126/133] (486s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[536.415876] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[536.420821] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[536.535754] [127/133] (486s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[536.644635] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[536.650321] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[536.756439] [128/133] (486s left) kms_async_flips (invalid-async-flip)
[536.845481] Starting subtest: invalid-async-flip
[537.235488] Starting dynamic subtest: pipe-A-eDP-1
[538.065410] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.830s)
[538.437367] Starting dynamic subtest: pipe-B-eDP-1
[539.299653] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.871s)
[539.657313] Starting dynamic subtest: pipe-C-eDP-1
[540.401740] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.752s)
[540.755518] Starting dynamic subtest: pipe-D-eDP-1
[541.540317] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.793s)
[541.542971] Subtest invalid-async-flip: SUCCESS (4.699s)
[542.694491] [129/133] (480s left) syncobj_timeline (invalid-wait-illegal-handle)
[542.754821] Starting subtest: invalid-wait-illegal-handle
[542.757516] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[542.860415] [130/133] (480s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0)
[542.974058] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0
[543.929488] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (0.956s)
[544.091231] [131/133] (479s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu)
[544.189448] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu
[550.708637] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (6.524s)
[550.878316] [132/133] (472s left) gem_mmap_gtt (basic-copy)
[550.948459] Subtest basic-copy: SKIP (0.000s)
[551.017595] [133/133] (472s left) gem_userptr_blits (usage-restrictions)
[551.093761] Starting subtest: usage-restrictions
[551.096389] Subtest usage-restrictions: SUCCESS (0.000s)
[551.248313] Closing watchdogs
results: parsing output: 0/ for test: kms_ccs
results: parsing output: 1/ for test: kms_pm_rpm
results: parsing output: 2/ for test: api_intel_allocator
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: syncobj_wait
results: parsing output: 5/ for test: gem_close
results: parsing output: 6/ for test: gem_exec_schedule
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: intel_hwmon
results: parsing output: 9/ for test: kms_ccs
results: parsing output: 10/ for test: gem_watchdog
results: parsing output: 11/ for test: kms_psr
results: parsing output: 12/ for test: kms_flip
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: syncobj_timeline
results: parsing output: 16/ for test: kms_psr
results: parsing output: 17/ for test: perf_pmu
results: parsing output: 18/ for test: syncobj_timeline
results: parsing output: 19/ for test: kms_plane
results: parsing output: 20/ for test: gem_create
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: syncobj_timeline
results: parsing output: 23/ for test: gem_media_fill
results: parsing output: 24/ for test: gem_exec_store
results: parsing output: 25/ for test: gem_lmem_evict
results: parsing output: 26/ for test: sysfs_heartbeat_interval
results: parsing output: 27/ for test: kms_cursor_legacy
results: parsing output: 28/ for test: kms_cursor_legacy
results: parsing output: 29/ for test: kms_psr
results: parsing output: 30/ for test: kms_cursor_crc
results: parsing output: 31/ for test: kms_cursor_crc
results: parsing output: 32/ for test: kms_psr
results: parsing output: 33/ for test: kms_big_fb
results: parsing output: 34/ for test: gem_exec_params
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: gem_ctx_persistence
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_content_protection
results: parsing output: 39/ for test: i915_hangman
results: parsing output: 40/ for test: i915_pm_rps
results: parsing output: 41/ for test: kms_color_pipeline
results: parsing output: 42/ for test: kms_frontbuffer_tracking
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: gem_readwrite
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: gem_render_copy
results: parsing output: 47/ for test: kms_invalid_mode
results: parsing output: 48/ for test: gem_userptr_blits
results: parsing output: 49/ for test: kms_atomic_transition
results: parsing output: 50/ for test: gem_exec_flush
results: parsing output: 51/ for test: i915_drm_fdinfo
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: kms_plane_scaling
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: gem_eio
results: parsing output: 58/ for test: gem_ctx_param
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: kms_big_fb
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: kms_flip
results: parsing output: 63/ for test: syncobj_wait
results: parsing output: 64/ for test: kms_pipe_crc_basic
results: parsing output: 65/ for test: gem_exec_fence
results: parsing output: 66/ for test: kms_psr2_sf
results: parsing output: 67/ for test: kms_ccs
results: parsing output: 68/ for test: kms_plane_multiple
results: parsing output: 69/ for test: sw_sync
results: parsing output: 70/ for test: core_debugfs
results: parsing output: 71/ for test: kms_big_fb
results: parsing output: 72/ for test: kms_frontbuffer_tracking
results: parsing output: 73/ for test: kms_lease
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_plane
results: parsing output: 76/ for test: perf
results: parsing output: 77/ for test: gem_render_copy
results: parsing output: 78/ for test: gem_exec_balancer
results: parsing output: 79/ for test: gem_fenced_exec_thrash
results: parsing output: 80/ for test: gem_exec_balancer
results: parsing output: 81/ for test: gem_mmap_offset
results: parsing output: 82/ for test: kms_dp_aux_dev
results: parsing output: 83/ for test: gem_exec_schedule
results: parsing output: 84/ for test: gem_exec_reloc
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_cursor_legacy
results: parsing output: 87/ for test: kms_flip
results: parsing output: 88/ for test: kms_pipe_crc_basic
results: parsing output: 89/ for test: kms_addfb_basic
results: parsing output: 90/ for test: kms_pm_rpm
results: parsing output: 91/ for test: gem_exec_params
results: parsing output: 92/ for test: kms_ccs
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_chamelium_hpd
results: parsing output: 95/ for test: gem_exec_schedule
results: parsing output: 96/ for test: kms_psr2_sf
results: parsing output: 97/ for test: gem_eio
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_dsc
results: parsing output: 100/ for test: kms_vblank
results: parsing output: 101/ for test: sw_sync
results: parsing output: 102/ for test: tools_test
results: parsing output: 103/ for test: syncobj_timeline
results: parsing output: 104/ for test: fbdev
results: parsing output: 105/ for test: kms_busy
results: parsing output: 106/ for test: kms_vblank
results: parsing output: 107/ for test: gen9_exec_parse
results: parsing output: 108/ for test: gem_pxp
results: parsing output: 109/ for test: i915_query
results: parsing output: 110/ for test: gem_eio
results: parsing output: 111/ for test: gem_pxp
results: parsing output: 112/ for test: device_reset
results: parsing output: 113/ for test: perf
results: parsing output: 114/ for test: gem_userptr_blits
results: parsing output: 115/ for test: gem_spin_batch
results: parsing output: 116/ for test: sriov_basic
results: parsing output: 117/ for test: gem_flink_race
results: parsing output: 118/ for test: kms_flip
results: parsing output: 119/ for test: kms_flip
results: parsing output: 120/ for test: prime_vgem
results: parsing output: 121/ for test: perf
results: parsing output: 122/ for test: kms_cursor_crc
results: parsing output: 123/ for test: kms_flip_scaled_crc
results: parsing output: 124/ for test: kms_chamelium_frames
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_async_flips
results: parsing output: 128/ for test: syncobj_timeline
results: parsing output: 129/ for test: kms_big_fb
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: gem_mmap_gtt
results: parsing output: 132/ for test: gem_userptr_blits
Done.