[58.100079] Initializing watchdogs
[58.100164]   /dev/watchdog0
[58.114992] [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]
[58.119508] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.122123] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.125479] [001/131] (960s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[58.260816] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[58.265324] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.002s)
[58.390911] [002/131] (960s left) gem_exec_fence (submit3)
[58.569155] Starting subtest: submit3
[58.573986] Subtest submit3: SKIP (0.000s)
[60.051031] [FACT gem_exec_fence (submit3)] new: kernel.kmod_is_loaded.vgem: true
[60.054105] [003/131] (958s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[60.165521] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[60.169973] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[60.299126] [004/131] (958s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc)
[60.400788] Starting subtest: fbc-rgb101010-draw-mmap-wc
[64.973923] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.566s)
[66.118925] [005/131] (952s left) gem_exec_balancer (noheartbeat)
[66.379053] Starting subtest: noheartbeat
[66.384079] Subtest noheartbeat: SKIP (0.000s)
[66.503651] [006/131] (952s left) kms_chamelium_color (ctm-blue-to-red)
[66.586605] Subtest ctm-blue-to-red: SKIP (0.000s)
[66.627019] [007/131] (952s left) gem_workarounds (suspend-resume)
[66.693331] Starting subtest: suspend-resume
[82.928007] Subtest suspend-resume: SUCCESS (5.563s)
[83.094306] [008/131] (935s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[83.211724] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[83.214058] Starting dynamic subtest: pipe-A
[83.275679] Dynamic subtest pipe-A: SUCCESS (0.065s)
[83.286198] Starting dynamic subtest: pipe-B
[84.433232] Dynamic subtest pipe-B: SUCCESS (1.135s)
[84.444404] Starting dynamic subtest: pipe-C
[85.558976] Dynamic subtest pipe-C: SUCCESS (1.104s)
[85.569728] Starting dynamic subtest: pipe-D
[86.710977] Dynamic subtest pipe-D: SUCCESS (1.132s)
[86.713713] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.440s)
[87.899713] [009/131] (931s left) gem_pxp (create-regular-buffer)
[88.043366] Starting subtest: create-regular-buffer
[88.045841] Subtest create-regular-buffer: SUCCESS (0.000s)
[88.186361] [010/131] (930s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[88.248199] Starting subtest: rel-constants-invalid-rel-gen5
[88.250659] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[88.381446] [011/131] (930s left) gem_exec_nop (basic-series)
[88.454720] Starting subtest: basic-series
[104.575960] Subtest basic-series: SUCCESS (16.045s)
[104.844672] [012/131] (914s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc)
[104.975362] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc
[104.979794] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[105.109364] [013/131] (913s left) kms_psr (fbc-psr-primary-page-flip)
[105.201776] Starting subtest: fbc-psr-primary-page-flip
[105.203680] Starting dynamic subtest: eDP-1
[105.207820] Dynamic subtest eDP-1: SKIP (0.000s)
[105.212095] Subtest fbc-psr-primary-page-flip: SKIP (0.000s)
[105.298086] [014/131] (913s left) i915_pm_rps (engine-order)
[105.360342] Starting subtest: engine-order
[110.263317] Subtest engine-order: SUCCESS (4.895s)
[110.411333] [015/131] (908s left) gem_softpin (evict-active)
[110.481679] Starting subtest: evict-active
[110.492461] Subtest evict-active: SUCCESS (0.011s)
[110.649607] [016/131] (908s left) syncobj_timeline (wait-delayed-signal)
[110.699583] Starting subtest: wait-delayed-signal
[110.803679] Subtest wait-delayed-signal: SUCCESS (0.104s)
[110.912261] [017/131] (908s left) kms_panel_fitting (atomic-fastset)
[111.016776] Starting subtest: atomic-fastset
[111.019156] Starting dynamic subtest: pipe-A-eDP-1
[111.157767] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.142s)
[111.169317] Starting dynamic subtest: pipe-B-eDP-1
[112.341005] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.182s)
[112.352673] Starting dynamic subtest: pipe-C-eDP-1
[113.526803] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.184s)
[113.535501] Starting dynamic subtest: pipe-D-eDP-1
[114.654094] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.126s)
[114.656465] Subtest atomic-fastset: SUCCESS (3.636s)
[115.835928] [018/131] (903s left) kms_big_fb (x-tiled-16bpp-rotate-270)
[115.937525] Starting subtest: x-tiled-16bpp-rotate-270
[115.959149] Subtest x-tiled-16bpp-rotate-270: SKIP (0.019s)
[116.109668] [019/131] (903s left) api_intel_bb (render-ccs)
[116.169197] Starting subtest: render-ccs
[116.549751] Subtest render-ccs: SUCCESS (0.381s)
[116.669894] [020/131] (902s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc)
[116.776214] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc
[116.778571] Starting dynamic subtest: pipe-A-eDP-1
[116.802486] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[116.814023] Starting dynamic subtest: pipe-B-eDP-1
[116.836334] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[116.844878] Starting dynamic subtest: pipe-C-eDP-1
[116.866665] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[116.876555] Starting dynamic subtest: pipe-D-eDP-1
[116.898399] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[116.902412] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[119.095078] [021/131] (900s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[119.150108] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[119.256572] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.105s)
[119.357582] [022/131] (900s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[119.455707] Starting subtest: psr-2p-primscrn-cur-indfb-move
[119.460054] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[119.588078] [023/131] (899s left) gem_lmem_swapping (heavy-multi)
[119.631043] Subtest heavy-multi: SKIP (0.000s)
[119.671433] [024/131] (899s left) kms_async_flips (test-cursor)
[119.764921] Starting subtest: test-cursor
[119.769204] Subtest test-cursor: SKIP (0.000s)
[121.015146] [025/131] (898s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf)
[126.079833] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf
[126.082205] Starting dynamic subtest: pipe-A-eDP-1
[126.873921] Dynamic subtest pipe-A-eDP-1: SKIP (0.790s)
[126.884720] Starting dynamic subtest: pipe-B-eDP-1
[127.998646] Dynamic subtest pipe-B-eDP-1: SKIP (1.123s)
[128.003114] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.917s)
[129.197435] [026/131] (890s left) kms_plane_multiple (2x-tiling-4)
[129.294760] Starting subtest: 2x-tiling-4
[129.299223] Subtest 2x-tiling-4: SKIP (0.000s)
[129.389569] [027/131] (890s left) gem_ctx_param (invalid-param-set)
[129.451720] Starting subtest: invalid-param-set
[129.454041] Subtest invalid-param-set: SUCCESS (0.000s)
[129.550167] [028/131] (890s left) kms_ccs (bad-pixel-format-y-tiled-ccs)
[129.652575] Starting subtest: bad-pixel-format-y-tiled-ccs
[129.654980] Starting dynamic subtest: pipe-A-eDP-1
[129.678170] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[129.689382] Starting dynamic subtest: pipe-B-eDP-1
[129.711023] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[129.719507] Starting dynamic subtest: pipe-C-eDP-1
[129.741146] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[129.751257] Starting dynamic subtest: pipe-D-eDP-1
[129.772838] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[129.777176] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.003s)
[131.960656] [029/131] (887s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers)
[132.061268] Starting subtest: plane-downscale-factor-0-5-with-modifiers
[132.063686] Starting dynamic subtest: pipe-A
[132.081878] Dynamic subtest pipe-A: SKIP (0.017s)
[132.095218] Starting dynamic subtest: pipe-B
[132.113119] Dynamic subtest pipe-B: SKIP (0.031s)
[132.125883] Starting dynamic subtest: pipe-C
[132.144344] Dynamic subtest pipe-C: SKIP (0.031s)
[132.154043] Starting dynamic subtest: pipe-D
[132.175544] Dynamic subtest pipe-D: SKIP (0.031s)
[132.179824] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.111s)
[132.305506] [030/131] (887s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[132.379944] Starting subtest: multi-wait-all-available-submitted-signaled
[132.382476] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.001s)
[132.510207] [031/131] (887s left) perf (missing-sample-flags)
[132.656027] Starting subtest: missing-sample-flags
[132.658311] Subtest missing-sample-flags: SUCCESS (0.000s)
[132.699654] [032/131] (887s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite)
[132.804014] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite
[139.013763] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.213s)
[140.161934] [033/131] (879s left) kms_pm_rpm (system-suspend-idle)
[141.718147] Starting subtest: system-suspend-idle
[161.168363] Subtest system-suspend-idle: SUCCESS (4.296s)
[161.554329] [034/131] (858s left) kms_vblank (wait-forked)
[161.648690] Starting subtest: wait-forked
[161.650707] Starting dynamic subtest: pipe-A-eDP-1
[163.460972] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.809s)
[163.476032] Starting dynamic subtest: pipe-D-eDP-1
[165.966948] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.456s)
[165.968973] Subtest wait-forked: SUCCESS (4.268s)
[166.877906] [035/131] (853s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[166.990921] Starting subtest: y-tiled-32bpp-rotate-0
[166.995654] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s)
[167.141620] [036/131] (852s left) kms_pipe_crc_basic (read-crc)
[167.232478] Starting subtest: read-crc
[167.234884] Starting dynamic subtest: pipe-A-eDP-1
[167.944389] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.701s)
[167.954640] Starting dynamic subtest: pipe-B-eDP-1
[169.354729] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.392s)
[169.364034] Starting dynamic subtest: pipe-C-eDP-1
[170.675872] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.308s)
[170.686353] Starting dynamic subtest: pipe-D-eDP-1
[172.018239] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.329s)
[172.020557] Subtest read-crc: SUCCESS (4.735s)
[172.878665] [037/131] (847s left) kms_cursor_legacy (single-move)
[172.991383] Starting subtest: single-move
[172.993642] Starting dynamic subtest: pipe-A
[178.398920] Dynamic subtest pipe-A: SUCCESS (5.379s)
[178.409632] Starting dynamic subtest: pipe-B
[183.795659] Dynamic subtest pipe-B: SUCCESS (5.381s)
[183.806827] Starting dynamic subtest: pipe-C
[189.185409] Dynamic subtest pipe-C: SUCCESS (5.380s)
[189.196263] Starting dynamic subtest: pipe-D
[194.572344] Dynamic subtest pipe-D: SUCCESS (5.380s)
[194.583354] Starting dynamic subtest: all-pipes
[199.960636] Dynamic subtest all-pipes: SUCCESS (5.387s)
[199.963065] Subtest single-move: SUCCESS (26.915s)
[200.128518] [038/131] (819s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf)
[205.188859] Starting subtest: pr-overlay-plane-move-continuous-exceed-sf
[205.193305] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.002s)
[206.062988] [039/131] (814s left) gem_unref_active_buffers
[206.301534] [040/131] (813s left) kms_psr (fbc-psr2-primary-mmap-gtt)
[206.397161] Starting subtest: fbc-psr2-primary-mmap-gtt
[206.399282] Starting dynamic subtest: eDP-1
[206.403290] Dynamic subtest eDP-1: SKIP (0.000s)
[206.407295] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s)
[206.495991] [041/131] (813s left) syncobj_wait (invalid-signal-zero-handles)
[206.556881] Starting subtest: invalid-signal-zero-handles
[206.559247] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[206.678304] [042/131] (813s left) gen9_exec_parse (bb-oversize)
[206.740282] Subtest bb-oversize: SKIP (0.000s)
[206.814712] [043/131] (813s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted)
[206.866294] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted
[206.967173] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.102s)
[207.070400] [044/131] (813s left) gem_exec_reloc (basic-write-cpu-noreloc)
[207.124393] Subtest basic-write-cpu-noreloc: SKIP (0.000s)
[207.203145] [045/131] (813s left) gem_mmap_offset (bad-flags)
[207.264844] Starting subtest: bad-flags
[207.266717] Subtest bad-flags: SUCCESS (0.000s)
[207.403807] [046/131] (813s left) kms_cursor_legacy (cursor-vs-flip-legacy)
[207.521103] Starting subtest: cursor-vs-flip-legacy
[236.810403] Subtest cursor-vs-flip-legacy: SUCCESS (29.280s)
[237.706611] [047/131] (782s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[237.810751] Starting subtest: sprite-rotation-90-pos-100-0
[237.815136] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[237.910918] [048/131] (782s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[238.009167] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip
[239.064918] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.057s)
[239.236337] [049/131] (781s left) gem_create (busy-create)
[239.310284] Starting subtest: busy-create
[239.312223] Starting dynamic subtest: smem0
[272.780291] Dynamic subtest smem0: SUCCESS (33.463s)
[272.783099] Subtest busy-create: SUCCESS (33.464s)
[272.993529] [050/131] (747s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render)
[273.106963] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render
[277.245164] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.143s)
[278.401491] [051/131] (742s left) perf (invalid-open-flags)
[278.512845] Starting subtest: invalid-open-flags
[278.515344] Subtest invalid-open-flags: SUCCESS (0.000s)
[278.556227] [052/131] (742s left) perf (oa-formats)
[278.666616] Starting subtest: oa-formats
[278.668988] Starting dynamic subtest: 0-rcs0
[278.682774] Dynamic subtest 0-rcs0: SUCCESS (0.016s)
[278.693944] Starting dynamic subtest: 1-vecs0
[278.704214] Dynamic subtest 1-vecs0: SUCCESS (0.021s)
[278.706441] Subtest oa-formats: SUCCESS (0.038s)
[278.743656] [053/131] (742s left) kms_big_fb (4-tiled-8bpp-rotate-270)
[278.843987] Starting subtest: 4-tiled-8bpp-rotate-270
[278.864941] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.020s)
[279.025787] [054/131] (741s left) kms_cursor_crc (cursor-onscreen-64x21)
[279.199115] Starting subtest: cursor-onscreen-64x21
[279.245597] Subtest cursor-onscreen-64x21: SKIP (0.042s)
[279.479072] [055/131] (741s left) kms_rotation_crc (primary-4-tiled-reflect-x-180)
[279.587112] Starting subtest: primary-4-tiled-reflect-x-180
[286.832082] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.246s)
[288.053400] [056/131] (732s left) kms_cursor_crc (cursor-onscreen-256x256)
[288.288615] Starting subtest: cursor-onscreen-256x256
[288.293937] Starting dynamic subtest: pipe-A-eDP-1
[290.404328] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.111s)
[290.434883] Starting dynamic subtest: pipe-D-eDP-1
[293.197637] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.770s)
[293.199578] Subtest cursor-onscreen-256x256: SUCCESS (4.906s)
[294.011271] [057/131] (726s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[294.124449] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[301.496934] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.373s)
[301.669923] [058/131] (719s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[301.773714] Starting subtest: async-flip-with-page-flip-events-tiled
[302.146121] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[304.884620] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.736s)
[304.896978] Starting dynamic subtest: pipe-A-eDP-1-4
[307.059916] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.174s)
[307.071935] Starting dynamic subtest: pipe-A-eDP-1-4
[309.070334] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[309.090301] Starting dynamic subtest: pipe-A-eDP-1-x
[311.260163] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.187s)
[311.629170] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[314.407110] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.784s)
[314.416667] Starting dynamic subtest: pipe-B-eDP-1-4
[316.593728] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.184s)
[316.603378] Starting dynamic subtest: pipe-B-eDP-1-4
[318.604058] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[318.615110] Starting dynamic subtest: pipe-B-eDP-1-x
[320.794795] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[321.156228] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[323.931953] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.782s)
[323.941948] Starting dynamic subtest: pipe-C-eDP-1-4
[326.107009] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.173s)
[326.116754] Starting dynamic subtest: pipe-C-eDP-1-4
[328.117669] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[328.129511] Starting dynamic subtest: pipe-C-eDP-1-x
[330.308620] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.190s)
[330.671375] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[333.465460] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.802s)
[333.476934] Starting dynamic subtest: pipe-D-eDP-1-4
[335.642526] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s)
[335.654334] Starting dynamic subtest: pipe-D-eDP-1-4
[337.652878] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[337.662532] Starting dynamic subtest: pipe-D-eDP-1-x
[339.822018] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.167s)
[339.824662] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.041s)
[341.089116] [059/131] (679s left) perf (polling)
[341.183240] Starting subtest: polling
[341.185636] Starting dynamic subtest: 0-rcs0
[351.204329] Dynamic subtest 0-rcs0: SUCCESS (10.016s)
[351.213918] Starting dynamic subtest: 1-vecs0
[361.226563] Dynamic subtest 1-vecs0: SUCCESS (10.017s)
[361.229513] Subtest polling: SUCCESS (20.037s)
[361.277521] [060/131] (659s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[361.377377] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc
[361.381500] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[361.514709] [061/131] (659s left) syncobj_timeline (reset-signaled)
[361.566628] Starting subtest: reset-signaled
[361.568833] Subtest reset-signaled: SUCCESS (0.000s)
[361.703826] [062/131] (659s left) kms_rmfb (rmfb-ioctl)
[361.798389] Starting subtest: rmfb-ioctl
[361.800648] Starting dynamic subtest: pipe-A-eDP-1
[361.902419] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.105s)
[361.913469] Starting dynamic subtest: pipe-B-eDP-1
[363.030897] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.126s)
[363.042275] Starting dynamic subtest: pipe-C-eDP-1
[364.151299] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.119s)
[364.163991] Starting dynamic subtest: pipe-D-eDP-1
[365.390371] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.234s)
[365.392691] Subtest rmfb-ioctl: SUCCESS (3.594s)
[366.618600] [063/131] (654s left) gem_userptr_blits (create-destroy-sync)
[366.691338] Starting subtest: create-destroy-sync
[371.711056] Subtest create-destroy-sync: SUCCESS (5.017s)
[371.879541] [064/131] (649s left) gem_exec_reloc (basic-gtt-cpu-active)
[371.940079] Subtest basic-gtt-cpu-active: SKIP (0.000s)
[372.001826] [065/131] (649s left) api_intel_allocator (execbuf-with-allocator)
[372.052740] Starting subtest: execbuf-with-allocator
[372.062673] Subtest execbuf-with-allocator: SUCCESS (0.010s)
[372.227761] [066/131] (649s left) kms_lease (cursor-implicit-plane)
[372.320597] Starting subtest: cursor-implicit-plane
[372.322959] Starting dynamic subtest: pipe-A-eDP-1
[372.776809] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.457s)
[372.789048] Starting dynamic subtest: pipe-B-eDP-1
[373.925221] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.145s)
[373.935099] Starting dynamic subtest: pipe-C-eDP-1
[375.025793] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.100s)
[375.035934] Starting dynamic subtest: pipe-D-eDP-1
[376.164809] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.135s)
[376.167090] Subtest cursor-implicit-plane: SUCCESS (3.843s)
[377.045487] [067/131] (644s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size)
[377.158929] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size
[377.163192] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s)
[377.329763] [068/131] (644s left) syncobj_wait (invalid-signal-illegal-handle)
[377.379254] Starting subtest: invalid-signal-illegal-handle
[377.381574] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s)
[377.490762] [069/131] (643s left) kms_psr (psr-primary-blt)
[377.586531] Starting subtest: psr-primary-blt
[377.588843] Starting dynamic subtest: eDP-1
[379.316506] Dynamic subtest eDP-1: SUCCESS (1.729s)
[379.319236] Subtest psr-primary-blt: SUCCESS (1.730s)
[380.198025] [070/131] (641s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[380.296429] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[380.298648] Starting dynamic subtest: pipe-A-eDP-1
[380.353753] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[380.363167] Starting dynamic subtest: pipe-B-eDP-1
[380.418955] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[380.428402] Starting dynamic subtest: pipe-C-eDP-1
[380.481742] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[380.490087] Starting dynamic subtest: pipe-D-eDP-1
[380.543682] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[380.548034] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.009s)
[382.566195] [071/131] (638s left) kms_psr (pr-primary-blt)
[382.672916] Starting subtest: pr-primary-blt
[382.677344] Subtest pr-primary-blt: SKIP (0.000s)
[382.770141] [072/131] (638s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[382.878741] Starting subtest: psr-2p-primscrn-spr-indfb-move
[382.883042] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[382.998564] [073/131] (638s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling)
[383.114013] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling
[383.116296] Starting dynamic subtest: pipe-A-default-mode
[384.317248] Dynamic subtest pipe-A-default-mode: SKIP (1.199s)
[384.321722] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.201s)
[384.518523] [074/131] (637s left) gem_exec_schedule (u-semaphore-noskip)
[384.590305] Starting subtest: u-semaphore-noskip
[384.975751] Subtest u-semaphore-noskip: SUCCESS (0.392s)
[385.351634] [075/131] (636s left) i915_drm_fdinfo (memory-info-idle)
[385.395213] Starting subtest: memory-info-idle
[385.397538] Starting dynamic subtest: smem0
[385.454395] Dynamic subtest smem0: SUCCESS (0.059s)
[385.457307] Subtest memory-info-idle: SUCCESS (0.060s)
[385.551928] [076/131] (636s left) i915_selftest (live)
[390.395413] Starting subtest: live
[390.397605] Starting dynamic subtest: sanitycheck
[394.859852] Dynamic subtest sanitycheck: SUCCESS (4.470s)
[394.870190] Starting dynamic subtest: uncore
[399.314151] Dynamic subtest uncore: SUCCESS (4.453s)
[399.324246] Starting dynamic subtest: workarounds
[416.880604] Dynamic subtest workarounds: FAIL (17.456s)
[416.889581] Starting dynamic subtest: gt_engines
[421.546563] Dynamic subtest gt_engines: SUCCESS (4.776s)
[421.553833] Starting dynamic subtest: gt_timelines
[437.961336] Dynamic subtest gt_timelines: SUCCESS (16.413s)
[437.971564] Starting dynamic subtest: gt_contexts
[442.492016] Dynamic subtest gt_contexts: SUCCESS (4.529s)
[442.502639] Starting dynamic subtest: gt_lrc
[448.765483] Dynamic subtest gt_lrc: SUCCESS (6.270s)
[448.774887] Starting dynamic subtest: gt_mocs
[451.867895] Dynamic subtest gt_mocs: SUCCESS (3.101s)
[451.883819] Starting dynamic subtest: gt_pm
[458.770634] Dynamic subtest gt_pm: SUCCESS (6.900s)
[458.780649] Starting dynamic subtest: gt_heartbeat
[463.253742] Dynamic subtest gt_heartbeat: SUCCESS (4.481s)
[463.264198] Starting dynamic subtest: gt_tlb
[473.293910] Dynamic subtest gt_tlb: SUCCESS (10.037s)
[473.309470] Starting dynamic subtest: requests
[485.302038] Dynamic subtest requests: SUCCESS (12.004s)
[485.312485] Starting dynamic subtest: migrate
[493.416672] Dynamic subtest migrate: SUCCESS (8.111s)
[493.426799] Starting dynamic subtest: active
[497.885140] Dynamic subtest active: SUCCESS (4.465s)
[497.895380] Starting dynamic subtest: objects
[502.682016] Dynamic subtest objects: SUCCESS (4.794s)
[502.692095] Starting dynamic subtest: mman
[507.805035] Dynamic subtest mman: SUCCESS (5.120s)
[507.822063] Starting dynamic subtest: dmabuf
[512.325121] Dynamic subtest dmabuf: SUCCESS (4.516s)
[512.335384] Starting dynamic subtest: vma
[516.802975] Dynamic subtest vma: SUCCESS (4.475s)
[516.818991] Starting dynamic subtest: coherency
[522.032913] Dynamic subtest coherency: SUCCESS (5.227s)
[522.043725] Starting dynamic subtest: gtt
[534.421075] Dynamic subtest gtt: SUCCESS (12.383s)
[534.431004] Starting dynamic subtest: gem
[542.519966] Dynamic subtest gem: SUCCESS (8.097s)
[542.528762] Starting dynamic subtest: evict
[548.053674] Dynamic subtest evict: SUCCESS (5.530s)
[548.064323] Starting dynamic subtest: hugepages
[559.678651] Dynamic subtest hugepages: SUCCESS (11.620s)
[559.688994] Starting dynamic subtest: gem_contexts
[587.444269] Dynamic subtest gem_contexts: SUCCESS (27.758s)
[587.454496] Starting dynamic subtest: client
[591.952480] Dynamic subtest client: SUCCESS (4.506s)
[591.962646] Starting dynamic subtest: gem_migrate
[596.430526] Dynamic subtest gem_migrate: SUCCESS (4.474s)
[596.441117] Starting dynamic subtest: reset
[600.945336] Dynamic subtest reset: SUCCESS (4.513s)
[600.955919] Starting dynamic subtest: memory_region
[605.415751] Dynamic subtest memory_region: SUCCESS (4.466s)
[605.429699] Starting dynamic subtest: hangcheck
[619.213510] Dynamic subtest hangcheck: SUCCESS (13.792s)
[619.223454] Starting dynamic subtest: execlists
[623.674269] Dynamic subtest execlists: SUCCESS (4.457s)
[623.684368] Starting dynamic subtest: ring_submission
[628.119179] Dynamic subtest ring_submission: SUCCESS (4.442s)
[628.128983] Starting dynamic subtest: perf
[632.587119] Dynamic subtest perf: SUCCESS (4.465s)
[632.597449] Starting dynamic subtest: slpc
[647.338169] Dynamic subtest slpc: SUCCESS (14.748s)
[647.347958] Starting dynamic subtest: guc
[651.378509] Dynamic subtest guc: SUCCESS (4.041s)
[651.388709] Starting dynamic subtest: guc_multi_lrc
[655.856259] Dynamic subtest guc_multi_lrc: SUCCESS (4.479s)
[655.871750] Starting dynamic subtest: guc_hang
[659.489129] Dynamic subtest guc_hang: SUCCESS (3.632s)
[659.499328] Starting dynamic subtest: late_gt_pm
[664.069582] Dynamic subtest late_gt_pm: SUCCESS (4.581s)
[664.072263] Subtest live: FAIL (273.661s)
[664.102745] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[664.103435] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[664.106487] [077/131] (357s left) gem_userptr_blits (nohangcheck)
[665.753491] Starting subtest: nohangcheck
[666.023544] Subtest nohangcheck: SUCCESS (0.270s)
[666.124339] [FACT gem_userptr_blits (nohangcheck)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[666.125531] [FACT gem_userptr_blits (nohangcheck)] new: kernel.kmod_is_loaded.i915: true
[666.129282] [078/131] (355s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs)
[666.239816] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs
[666.242081] Starting dynamic subtest: pipe-A-eDP-1
[667.085143] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.839s)
[667.094733] Starting dynamic subtest: pipe-B-eDP-1
[668.699527] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.612s)
[668.709383] Starting dynamic subtest: pipe-C-eDP-1
[670.196493] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.497s)
[670.207212] Starting dynamic subtest: pipe-D-eDP-1
[671.840436] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.644s)
[671.842756] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.597s)
[673.312427] [079/131] (348s left) gem_softpin (allocator-nopin)
[673.377643] Starting subtest: allocator-nopin
[673.493857] Subtest allocator-nopin: SUCCESS (0.119s)
[673.628763] [080/131] (348s left) kms_draw_crc (draw-method-pwrite)
[673.718578] Starting subtest: draw-method-pwrite
[673.720877] Starting dynamic subtest: xrgb8888-untiled
[674.351276] Dynamic subtest xrgb8888-untiled: SUCCESS (0.634s)
[674.362855] Starting dynamic subtest: rgb565-untiled
[674.817969] Dynamic subtest rgb565-untiled: SUCCESS (0.464s)
[674.830704] Starting dynamic subtest: xrgb2101010-untiled
[675.396138] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.575s)
[675.405339] Starting dynamic subtest: xbgr16161616f-untiled
[676.172955] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.777s)
[676.182297] Starting dynamic subtest: xrgb8888-xtiled
[678.027828] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.855s)
[678.037048] Starting dynamic subtest: rgb565-xtiled
[679.163822] Dynamic subtest rgb565-xtiled: SUCCESS (1.133s)
[679.173528] Starting dynamic subtest: xrgb2101010-xtiled
[681.004774] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.842s)
[681.015264] Starting dynamic subtest: xbgr16161616f-xtiled
[684.269750] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.266s)
[684.278963] Starting dynamic subtest: xrgb8888-4tiled
[685.369868] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.099s)
[685.379954] Starting dynamic subtest: rgb565-4tiled
[685.936368] Dynamic subtest rgb565-4tiled: SUCCESS (0.565s)
[685.947731] Starting dynamic subtest: xrgb2101010-4tiled
[687.025096] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.088s)
[687.040210] Starting dynamic subtest: xbgr16161616f-4tiled
[690.223699] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (3.199s)
[690.225972] Subtest draw-method-pwrite: SUCCESS (16.513s)
[690.350397] [081/131] (331s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[690.444539] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip
[690.449007] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[690.577582] [082/131] (331s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[690.683416] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[690.687847] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[690.816916] [083/131] (331s left) syncobj_timeline (host-signal-points)
[690.866868] Starting subtest: host-signal-points
[690.871425] Subtest host-signal-points: SUCCESS (0.004s)
[690.999155] [084/131] (331s left) gem_mmap_gtt (basic-small-bo)
[691.061901] Subtest basic-small-bo: SKIP (0.000s)
[691.128863] [085/131] (330s left) perf_pmu (semaphore-wait-idle)
[691.161048] Starting subtest: semaphore-wait-idle
[691.163117] Starting dynamic subtest: rcs0
[691.676939] Dynamic subtest rcs0: SUCCESS (0.514s)
[691.689316] Starting dynamic subtest: bcs0
[692.190589] Dynamic subtest bcs0: SUCCESS (0.510s)
[692.202958] Starting dynamic subtest: vcs0
[692.702741] Dynamic subtest vcs0: SUCCESS (0.510s)
[692.715154] Starting dynamic subtest: vcs1
[693.214371] Dynamic subtest vcs1: SUCCESS (0.510s)
[693.226272] Starting dynamic subtest: vecs0
[693.727674] Dynamic subtest vecs0: SUCCESS (0.510s)
[693.740076] Starting dynamic subtest: ccs0
[694.243161] Dynamic subtest ccs0: SUCCESS (0.513s)
[694.246280] Subtest semaphore-wait-idle: SUCCESS (3.083s)
[695.821853] [086/131] (326s left) kms_addfb_basic (no-handle)
[695.883265] Starting subtest: no-handle
[695.885733] Subtest no-handle: SUCCESS (0.000s)
[696.057906] [087/131] (326s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[696.162310] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[703.184633] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (7.026s)
[703.330806] [088/131] (318s left) gem_render_copy (yf-tiled-ccs-to-linear)
[703.389288] Starting subtest: yf-tiled-ccs-to-linear
[703.393826] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s)
[703.596542] [089/131] (318s left) kms_flip (wf_vblank-ts-check)
[703.697885] Starting subtest: wf_vblank-ts-check
[703.700331] Starting dynamic subtest: A-eDP1
[712.608179] Dynamic subtest A-eDP1: SUCCESS (8.913s)
[712.625718] Starting dynamic subtest: B-eDP1
[721.536758] Dynamic subtest B-eDP1: SUCCESS (8.927s)
[721.545979] Starting dynamic subtest: C-eDP1
[730.451193] Dynamic subtest C-eDP1: SUCCESS (8.912s)
[730.461208] Starting dynamic subtest: D-eDP1
[739.383893] Dynamic subtest D-eDP1: SUCCESS (8.933s)
[739.386339] Subtest wf_vblank-ts-check: SUCCESS (35.697s)
[740.634264] [090/131] (281s left) gem_exec_schedule (deep)
[740.808909] Starting subtest: deep
[740.811415] Starting dynamic subtest: rcs0
[745.717387] Dynamic subtest rcs0: SKIP (4.903s)
[745.728715] Starting dynamic subtest: vcs0
[756.080019] Dynamic subtest vcs0: SUCCESS (10.366s)
[756.092636] Starting dynamic subtest: vcs1
[767.137478] Dynamic subtest vcs1: SUCCESS (11.055s)
[767.148335] Starting dynamic subtest: vecs0
[778.096240] Dynamic subtest vecs0: SUCCESS (10.959s)
[778.105694] Starting dynamic subtest: ccs0
[791.323781] Dynamic subtest ccs0: SUCCESS (13.225s)
[791.326818] Subtest deep: SUCCESS (50.515s)
[792.406040] [091/131] (229s left) kms_sequence (queue-idle)
[792.510699] Starting subtest: queue-idle
[792.513019] Starting dynamic subtest: pipe-A-eDP-1
[794.308749] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.796s)
[794.318287] Starting dynamic subtest: pipe-B-eDP-1
[796.767441] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.459s)
[796.776788] Starting dynamic subtest: pipe-C-eDP-1
[799.169874] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.401s)
[799.179888] Starting dynamic subtest: pipe-D-eDP-1
[801.620114] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.445s)
[801.622161] Subtest queue-idle: SUCCESS (9.107s)
[802.471484] [092/131] (219s left) gem_gtt_cpu_tlb
[802.612074] [093/131] (219s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc)
[802.729443] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc
[809.286907] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.559s)
[809.448814] [094/131] (213s left) gem_eio (create-ext)
[809.683073] Starting subtest: create-ext
[810.029204] Subtest create-ext: SUCCESS (0.346s)
[810.191487] [095/131] (212s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[810.254924] Subtest writes-after-reads-uncached: SKIP (0.000s)
[810.342067] [096/131] (212s left) sysfs_preempt_timeout (idempotent)
[810.406200] Starting subtest: idempotent
[810.408230] Starting dynamic subtest: vecs0
[810.410140] Dynamic subtest vecs0: SUCCESS (0.001s)
[810.420198] Starting dynamic subtest: ccs0
[810.421883] Dynamic subtest ccs0: SUCCESS (0.000s)
[810.430796] Starting dynamic subtest: vcs0
[810.432502] Dynamic subtest vcs0: SUCCESS (0.001s)
[810.442089] Starting dynamic subtest: bcs0
[810.443897] Dynamic subtest bcs0: SUCCESS (0.001s)
[810.452474] Starting dynamic subtest: rcs0
[810.454234] Dynamic subtest rcs0: SUCCESS (0.001s)
[810.464005] Starting dynamic subtest: vcs1
[810.465746] Dynamic subtest vcs1: SUCCESS (0.000s)
[810.467445] Subtest idempotent: SUCCESS (0.011s)
[810.559602] [097/131] (212s left) gem_busy (semaphore)
[810.747859] Subtest semaphore: SKIP (0.000s)
[811.024856] [098/131] (211s left) sriov_basic (enable-vfs-bind-unbind-each)
[811.085559] Starting subtest: enable-vfs-bind-unbind-each
[811.087934] Starting dynamic subtest: numvfs-1
[811.162205] Dynamic subtest numvfs-1: FAIL (0.007s)
[811.174052] Starting dynamic subtest: numvfs-2
[811.246297] Dynamic subtest numvfs-2: FAIL (0.004s)
[811.258765] Starting dynamic subtest: numvfs-3
[811.330003] Dynamic subtest numvfs-3: FAIL (0.004s)
[811.339594] Starting dynamic subtest: numvfs-4
[811.408270] Dynamic subtest numvfs-4: FAIL (0.005s)
[811.417832] Starting dynamic subtest: numvfs-5
[811.485750] Dynamic subtest numvfs-5: FAIL (0.004s)
[811.495421] Starting dynamic subtest: numvfs-6
[811.569078] Dynamic subtest numvfs-6: FAIL (0.004s)
[811.581003] Starting dynamic subtest: numvfs-7
[811.654431] Dynamic subtest numvfs-7: FAIL (0.004s)
[811.664767] Starting dynamic subtest: numvfs-random
[811.735874] Dynamic subtest numvfs-random: FAIL (0.010s)
[811.737836] Subtest enable-vfs-bind-unbind-each: FAIL (0.050s)
[811.776015] [099/131] (210s left) kms_pm_lpsp (screens-disabled)
[812.887839] Starting subtest: screens-disabled
[812.891836] Subtest screens-disabled: SKIP (0.000s)
[812.984542] [100/131] (209s left) gem_exec_capture (capture-invisible)
[813.045798] Starting subtest: capture-invisible
[813.047956] Starting dynamic subtest: smem0
[813.052255] Dynamic subtest smem0: SKIP (0.000s)
[813.056638] Subtest capture-invisible: SKIP (0.001s)
[813.178825] [101/131] (209s left) gem_lmem_swapping (verify-ccs)
[813.218304] Subtest verify-ccs: SKIP (0.000s)
[813.260880] [102/131] (209s left) kms_joiner (basic-force-ultra-joiner)
[813.359754] Starting subtest: basic-force-ultra-joiner
[813.363849] Subtest basic-force-ultra-joiner: SKIP (0.000s)
[813.450331] [103/131] (209s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[813.552284] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[820.081707] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.532s)
[820.237137] [104/131] (202s left) kms_color (legacy-gamma)
[820.331604] Starting subtest: legacy-gamma
[820.333799] Starting dynamic subtest: pipe-A-eDP-1
[821.083058] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.750s)
[821.094219] Starting dynamic subtest: pipe-B-eDP-1
[822.471424] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.388s)
[822.481858] Starting dynamic subtest: pipe-C-eDP-1
[823.868722] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.395s)
[823.879010] Starting dynamic subtest: pipe-D-eDP-1
[825.183547] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.312s)
[825.185835] Subtest legacy-gamma: SUCCESS (4.850s)
[826.026280] [105/131] (196s left) gem_exec_schedule (wide)
[826.210046] Starting subtest: wide
[826.212640] Starting dynamic subtest: rcs0
[836.466772] Dynamic subtest rcs0: SUCCESS (10.256s)
[836.479595] Starting dynamic subtest: vcs0
[847.586354] Dynamic subtest vcs0: SUCCESS (11.116s)
[847.598508] Starting dynamic subtest: vcs1
[857.242512] Dynamic subtest vcs1: SUCCESS (9.654s)
[857.254360] Starting dynamic subtest: vecs0
[868.806694] Dynamic subtest vecs0: SUCCESS (11.562s)
[868.819979] Starting dynamic subtest: ccs0
[883.757503] Dynamic subtest ccs0: SUCCESS (14.948s)
[883.760061] Subtest wide: SUCCESS (57.542s)
[886.718672] [106/131] (136s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[886.810590] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[886.812872] Starting dynamic subtest: pipe-A-default-mode
[887.102789] Dynamic subtest pipe-A-default-mode: SKIP (0.289s)
[887.107508] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.291s)
[887.949667] [107/131] (135s left) kms_big_fb (linear-64bpp-rotate-180)
[888.053542] Starting subtest: linear-64bpp-rotate-180
[889.567520] Subtest linear-64bpp-rotate-180: SUCCESS (1.513s)
[889.780442] [108/131] (133s left) gem_ppgtt (blt-vs-render-ctxn)
[889.840371] Starting subtest: blt-vs-render-ctxN
[923.033528] Subtest blt-vs-render-ctxN: SUCCESS (33.191s)
[923.206373] [109/131] ( 99s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt)
[923.364736] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt
[923.368892] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[923.485804] [110/131] ( 99s left) kms_chamelium_frames (dp-frame-dump)
[923.881885] Subtest dp-frame-dump: SKIP (0.000s)
[924.731438] [111/131] ( 98s left) kms_psr2_su (page_flip-nv12)
[924.798778] Subtest page_flip-NV12: SKIP (0.000s)
[924.872517] [112/131] ( 98s left) gem_tiling_max_stride
[925.005466] [113/131] ( 98s left) perf_pmu (busy-idle)
[925.045746] Starting subtest: busy-idle
[925.048126] Starting dynamic subtest: rcs0
[925.761189] Dynamic subtest rcs0: SUCCESS (0.718s)
[925.774906] Starting dynamic subtest: bcs0
[926.431339] Dynamic subtest bcs0: SUCCESS (0.668s)
[926.444663] Starting dynamic subtest: vcs0
[927.723521] Dynamic subtest vcs0: SUCCESS (1.288s)
[927.736999] Starting dynamic subtest: vcs1
[929.646503] Dynamic subtest vcs1: SUCCESS (1.920s)
[929.659946] Starting dynamic subtest: vecs0
[931.756551] Dynamic subtest vecs0: SUCCESS (2.108s)
[931.769785] Starting dynamic subtest: ccs0
[932.429993] Dynamic subtest ccs0: SUCCESS (0.672s)
[932.432539] Subtest busy-idle: SUCCESS (7.389s)
[932.578695] [114/131] ( 90s left) dmabuf_sync_file (export-before-signal)
[932.623196] Starting subtest: export-before-signal
[932.625390] Subtest export-before-signal: SUCCESS (0.001s)
[932.704402] [115/131] ( 90s left) gem_exec_reloc (basic-cpu-read)
[932.770471] Subtest basic-cpu-read: SKIP (0.000s)
[932.859293] [116/131] ( 90s left) kms_hdr (bpc-switch)
[932.963114] Starting subtest: bpc-switch
[934.020092] Starting dynamic subtest: pipe-A-eDP-1
[937.519102] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.499s)
[937.521534] Subtest bpc-switch: SUCCESS (4.557s)
[937.682404] [117/131] ( 85s left) perf (i915-ref-count)
[937.813575] Starting subtest: i915-ref-count
[937.894865] Subtest i915-ref-count: SUCCESS (0.079s)
[937.952143] [118/131] ( 85s left) gem_ctx_isolation (nonpriv)
[938.017812] Starting subtest: nonpriv
[938.020132] Starting dynamic subtest: rcs0
[938.271231] Dynamic subtest rcs0: SUCCESS (0.253s)
[938.284637] Starting dynamic subtest: bcs0
[938.550644] Dynamic subtest bcs0: SUCCESS (0.279s)
[938.563595] Starting dynamic subtest: vcs0
[938.816084] Dynamic subtest vcs0: SUCCESS (0.265s)
[938.829252] Starting dynamic subtest: vcs1
[939.982230] Dynamic subtest vcs1: SUCCESS (1.165s)
[939.993840] Starting dynamic subtest: vecs0
[942.021031] Dynamic subtest vecs0: SUCCESS (2.038s)
[942.033806] Starting dynamic subtest: ccs0
[944.015877] Dynamic subtest ccs0: SUCCESS (1.994s)
[944.018225] Subtest nonpriv: SUCCESS (5.999s)
[944.277768] [119/131] ( 79s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[944.345584] Starting subtest: y-tiled-to-vebox-x-tiled
[944.350401] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[944.558751] [120/131] ( 79s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[944.658900] Starting subtest: plane-use-after-nonblocking-unbind
[944.661207] Starting dynamic subtest: pipe-A-eDP-1
[944.719524] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s)
[945.017443] Starting dynamic subtest: pipe-B-eDP-1
[945.777106] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.770s)
[946.082752] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.424s)
[946.967288] [121/131] ( 76s left) i915_hangman (engine-error-state-capture)
[947.026136] Starting subtest: engine-error-state-capture
[947.028318] Starting dynamic subtest: rcs0
[950.665947] Dynamic subtest rcs0: SUCCESS (3.640s)
[950.680098] Starting dynamic subtest: bcs0
[956.682787] Dynamic subtest bcs0: SUCCESS (6.014s)
[956.696123] Starting dynamic subtest: vcs0
[962.699635] Dynamic subtest vcs0: SUCCESS (6.014s)
[962.712670] Starting dynamic subtest: vcs1
[968.714464] Dynamic subtest vcs1: SUCCESS (6.012s)
[968.728114] Starting dynamic subtest: vecs0
[974.667247] Dynamic subtest vecs0: SUCCESS (5.950s)
[974.680465] Starting dynamic subtest: ccs0
[980.682649] Dynamic subtest ccs0: SUCCESS (6.012s)
[980.685944] Subtest engine-error-state-capture: SUCCESS (33.659s)
[980.839899] [122/131] ( 42s left) gem_exec_schedule (pi-shared-iova)
[981.027532] Starting subtest: pi-shared-iova
[981.029490] Starting dynamic subtest: rcs0
[981.164004] Dynamic subtest rcs0: SUCCESS (0.137s)
[981.179282] Starting dynamic subtest: vcs0
[981.256464] Dynamic subtest vcs0: SUCCESS (0.094s)
[981.269744] Starting dynamic subtest: vcs1
[981.347579] Dynamic subtest vcs1: SUCCESS (0.090s)
[981.358247] Starting dynamic subtest: vecs0
[981.438118] Dynamic subtest vecs0: SUCCESS (0.090s)
[981.451620] Starting dynamic subtest: ccs0
[981.555363] Dynamic subtest ccs0: SUCCESS (0.115s)
[981.557880] Subtest pi-shared-iova: SUCCESS (0.531s)
[982.839239] [123/131] ( 40s left) syncobj_wait (invalid-reset-illegal-handle)
[982.908188] Starting subtest: invalid-reset-illegal-handle
[982.910715] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[983.059175] [124/131] ( 40s left) syncobj_wait (single-wait-all-for-submit-signaled)
[983.128368] Starting subtest: single-wait-all-for-submit-signaled
[983.130765] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[983.272095] [125/131] ( 40s left) kms_cursor_crc (cursor-sliding-512x170)
[983.595729] Starting subtest: cursor-sliding-512x170
[983.600402] Subtest cursor-sliding-512x170: SKIP (0.001s)
[983.767374] [126/131] ( 40s left) kms_chamelium_hpd (hdmi-hpd-fast)
[984.155161] Subtest hdmi-hpd-fast: SKIP (0.000s)
[984.952523] [127/131] ( 38s left) gem_ctx_persistence (hostile)
[985.019363] Starting subtest: hostile
[995.164911] Subtest hostile: SUCCESS (10.140s)
[995.326070] [128/131] ( 28s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[995.449857] Starting subtest: fbc-rgb565-draw-blt
[999.652631] Subtest fbc-rgb565-draw-blt: SUCCESS (4.206s)
[1000.805340] [129/131] ( 23s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite)
[1000.911652] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite
[1010.192065] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.281s)
[1010.369275] [130/131] ( 13s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[1010.476286] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[1010.480321] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[1010.614768] [131/131] ( 13s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move)
[1010.712867] Starting subtest: fbc-2p-scndscrn-spr-indfb-move
[1010.717260] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[1010.846232] Closing watchdogs
results: parsing output: 0/ for test: kms_big_fb
results: parsing output: 1/ for test: gem_exec_fence
results: parsing output: 2/ for test: kms_frontbuffer_tracking
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: gem_exec_balancer
results: parsing output: 5/ for test: kms_chamelium_color
results: parsing output: 6/ for test: gem_workarounds
results: parsing output: 7/ for test: kms_plane_scaling
results: parsing output: 8/ for test: gem_pxp
results: parsing output: 9/ for test: gem_exec_params
results: parsing output: 10/ for test: gem_exec_nop
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_psr
results: parsing output: 13/ for test: i915_pm_rps
results: parsing output: 14/ for test: gem_softpin
results: parsing output: 15/ for test: syncobj_timeline
results: parsing output: 16/ for test: kms_panel_fitting
results: parsing output: 17/ for test: kms_big_fb
results: parsing output: 18/ for test: api_intel_bb
results: parsing output: 19/ for test: kms_ccs
results: parsing output: 20/ for test: syncobj_wait
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_lmem_swapping
results: parsing output: 23/ for test: kms_async_flips
results: parsing output: 24/ for test: kms_psr2_sf
results: parsing output: 25/ for test: kms_plane_multiple
results: parsing output: 26/ for test: gem_ctx_param
results: parsing output: 27/ for test: kms_ccs
results: parsing output: 28/ for test: kms_plane_scaling
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: perf
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: kms_pm_rpm
results: parsing output: 33/ for test: kms_vblank
results: parsing output: 34/ for test: kms_big_fb
results: parsing output: 35/ for test: kms_pipe_crc_basic
results: parsing output: 36/ for test: kms_cursor_legacy
results: parsing output: 37/ for test: kms_psr2_sf
results: parsing output: 38/ for test: gem_unref_active_buffers
results: parsing output: 39/ for test: kms_psr
results: parsing output: 40/ for test: syncobj_wait
results: parsing output: 41/ for test: gen9_exec_parse
results: parsing output: 42/ for test: syncobj_timeline
results: parsing output: 43/ for test: gem_exec_reloc
results: parsing output: 44/ for test: gem_mmap_offset
results: parsing output: 45/ for test: kms_cursor_legacy
results: parsing output: 46/ for test: kms_rotation_crc
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: gem_create
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: perf
results: parsing output: 51/ for test: perf
results: parsing output: 52/ for test: kms_big_fb
results: parsing output: 53/ for test: kms_cursor_crc
results: parsing output: 54/ for test: kms_rotation_crc
results: parsing output: 55/ for test: kms_cursor_crc
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_async_flips
results: parsing output: 58/ for test: perf
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: syncobj_timeline
results: parsing output: 61/ for test: kms_rmfb
results: parsing output: 62/ for test: gem_userptr_blits
results: parsing output: 63/ for test: gem_exec_reloc
results: parsing output: 64/ for test: api_intel_allocator
results: parsing output: 65/ for test: kms_lease
results: parsing output: 66/ for test: kms_cursor_legacy
results: parsing output: 67/ for test: syncobj_wait
results: parsing output: 68/ for test: kms_psr
results: parsing output: 69/ for test: kms_ccs
results: parsing output: 70/ for test: kms_psr
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_flip_scaled_crc
results: parsing output: 73/ for test: gem_exec_schedule
results: parsing output: 74/ for test: i915_drm_fdinfo
results: parsing output: 75/ for test: i915_selftest
results: parsing output: 76/ for test: gem_userptr_blits
results: parsing output: 77/ for test: kms_ccs
results: parsing output: 78/ for test: gem_softpin
results: parsing output: 79/ for test: kms_draw_crc
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: syncobj_timeline
results: parsing output: 83/ for test: gem_mmap_gtt
results: parsing output: 84/ for test: perf_pmu
results: parsing output: 85/ for test: kms_addfb_basic
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_render_copy
results: parsing output: 88/ for test: kms_flip
results: parsing output: 89/ for test: gem_exec_schedule
results: parsing output: 90/ for test: kms_sequence
results: parsing output: 91/ for test: gem_gtt_cpu_tlb
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: gem_eio
results: parsing output: 94/ for test: gem_partial_pwrite_pread
results: parsing output: 95/ for test: sysfs_preempt_timeout
results: parsing output: 96/ for test: gem_busy
results: parsing output: 97/ for test: sriov_basic
results: parsing output: 98/ for test: kms_pm_lpsp
results: parsing output: 99/ for test: gem_exec_capture
results: parsing output: 100/ for test: gem_lmem_swapping
results: parsing output: 101/ for test: kms_joiner
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_color
results: parsing output: 104/ for test: gem_exec_schedule
results: parsing output: 105/ for test: kms_flip_scaled_crc
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: gem_ppgtt
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: kms_chamelium_frames
results: parsing output: 110/ for test: kms_psr2_su
results: parsing output: 111/ for test: gem_tiling_max_stride
results: parsing output: 112/ for test: perf_pmu
results: parsing output: 113/ for test: dmabuf_sync_file
results: parsing output: 114/ for test: gem_exec_reloc
results: parsing output: 115/ for test: kms_hdr
results: parsing output: 116/ for test: perf
results: parsing output: 117/ for test: gem_ctx_isolation
results: parsing output: 118/ for test: gem_render_copy
results: parsing output: 119/ for test: kms_atomic_transition
results: parsing output: 120/ for test: i915_hangman
results: parsing output: 121/ for test: gem_exec_schedule
results: parsing output: 122/ for test: syncobj_wait
results: parsing output: 123/ for test: syncobj_wait
results: parsing output: 124/ for test: kms_cursor_crc
results: parsing output: 125/ for test: kms_chamelium_hpd
results: parsing output: 126/ for test: gem_ctx_persistence
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: kms_frontbuffer_tracking
results: parsing output: 130/ for test: kms_frontbuffer_tracking
Done.