[61.609208] Initializing watchdogs
[61.609254]   /dev/watchdog0
[61.624078] [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]
[61.628857] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[61.631532] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[61.635192] [001/133] (960s left) kms_chamelium_hpd (dp-hpd-enable-disable-mode)
[62.044785] Subtest dp-hpd-enable-disable-mode: SKIP (0.000s)
[62.885585] [002/133] (959s left) kms_ccs (bad-rotation-90-y-tiled-ccs)
[62.989355] Starting subtest: bad-rotation-90-y-tiled-ccs
[62.991839] Starting dynamic subtest: pipe-A-eDP-1
[63.017463] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[63.027358] Starting dynamic subtest: pipe-B-eDP-1
[63.049475] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[63.057226] Starting dynamic subtest: pipe-C-eDP-1
[63.079895] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[63.087462] Starting dynamic subtest: pipe-D-eDP-1
[63.110667] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[63.114739] Subtest bad-rotation-90-y-tiled-ccs: SKIP (0.003s)
[65.264501] [003/133] (956s left) i915_hangman (detector)
[65.335476] Starting subtest: detector
[65.337763] Starting dynamic subtest: rcs0
[75.893588] Dynamic subtest rcs0: SUCCESS (10.545s)
[75.904486] Starting dynamic subtest: bcs0
[87.863137] Dynamic subtest bcs0: SUCCESS (11.963s)
[87.875053] Starting dynamic subtest: vcs0
[99.894458] Dynamic subtest vcs0: SUCCESS (12.027s)
[99.905601] Starting dynamic subtest: vcs1
[111.797405] Dynamic subtest vcs1: SUCCESS (11.900s)
[111.808366] Starting dynamic subtest: vecs0
[122.805215] Dynamic subtest vecs0: SUCCESS (11.006s)
[122.816154] Starting dynamic subtest: ccs0
[133.877874] Dynamic subtest ccs0: SUCCESS (11.070s)
[133.881053] Subtest detector: SUCCESS (68.519s)
[133.965545] [004/133] (888s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[134.058311] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[134.062846] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[134.148194] [005/133] (888s left) kms_pm_rpm (pm-tiling)
[136.099183] Starting subtest: pm-tiling
[136.104599] Subtest pm-tiling: SKIP (0.000s)
[136.483622] [006/133] (885s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling)
[136.596361] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling
[136.598858] Starting dynamic subtest: pipe-A-default-mode
[139.315965] Dynamic subtest pipe-A-default-mode: SUCCESS (2.721s)
[139.318491] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.722s)
[140.171170] [007/133] (882s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[140.276815] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[147.082585] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (6.810s)
[147.225985] [008/133] (875s left) kms_plane_scaling (planes-upscale-factor-0-25)
[147.330547] Starting subtest: planes-upscale-factor-0-25
[147.332841] Starting dynamic subtest: pipe-A
[147.393784] Dynamic subtest pipe-A: SUCCESS (0.065s)
[147.402351] Starting dynamic subtest: pipe-B
[148.527858] Dynamic subtest pipe-B: SUCCESS (1.134s)
[148.538573] Starting dynamic subtest: pipe-C
[149.625802] Dynamic subtest pipe-C: SUCCESS (1.097s)
[149.634205] Starting dynamic subtest: pipe-D
[150.768496] Dynamic subtest pipe-D: SUCCESS (1.142s)
[150.770964] Subtest planes-upscale-factor-0-25: SUCCESS (3.440s)
[151.914656] [009/133] (870s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[152.017071] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[152.019250] Starting dynamic subtest: pipe-A-eDP-1
[152.910692] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.889s)
[152.918619] Starting dynamic subtest: pipe-B-eDP-1
[154.524158] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.610s)
[154.533287] Starting dynamic subtest: pipe-C-eDP-1
[156.040743] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.515s)
[156.050495] Starting dynamic subtest: pipe-D-eDP-1
[157.582989] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.542s)
[157.585344] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.560s)
[158.762868] [010/133] (863s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled)
[158.824955] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[158.827204] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.001s)
[158.918812] [011/133] (863s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[159.020174] Starting subtest: 4-tiled-32bpp-rotate-270
[159.044157] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.023s)
[159.142910] [012/133] (863s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[159.269229] Starting subtest: basic-flip-before-cursor-legacy
[160.214435] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.945s)
[161.009060] [013/133] (861s left) kms_psr (fbc-psr2-primary-mmap-cpu)
[161.094086] Starting subtest: fbc-psr2-primary-mmap-cpu
[161.096288] Starting dynamic subtest: eDP-1
[161.100153] Dynamic subtest eDP-1: SKIP (0.000s)
[161.104150] Subtest fbc-psr2-primary-mmap-cpu: SKIP (0.001s)
[161.174718] [014/133] (861s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[161.244859] Starting subtest: y-tiled-ccs-to-yf-tiled
[161.249200] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[161.422905] [015/133] (861s left) gem_softpin (allocator-basic)
[161.473386] Starting subtest: allocator-basic
[161.572571] Subtest allocator-basic: SUCCESS (0.099s)
[161.697905] [016/133] (861s left) kms_content_protection (content-type-change)
[161.839030] Starting subtest: content-type-change
[161.843800] Subtest content-type-change: SKIP (0.000s)
[161.970010] [017/133] (860s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render)
[162.069221] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render
[169.475324] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.409s)
[169.603753] [018/133] (853s left) syncobj_timeline (single-wait-all-for-submit-available-signaled)
[169.654323] Starting subtest: single-wait-all-for-submit-available-signaled
[169.656720] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s)
[169.779820] [019/133] (853s left) gem_exec_suspend (basic)
[169.832699] Starting subtest: basic
[169.835074] Starting dynamic subtest: smem
[171.926289] Dynamic subtest smem: SUCCESS (2.092s)
[171.928795] Subtest basic: SUCCESS (2.093s)
[172.119800] [020/133] (850s left) kms_vblank (wait-forked-hang)
[172.223317] Starting subtest: wait-forked-hang
[172.225702] Starting dynamic subtest: pipe-A-eDP-1
[198.676877] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.449s)
[198.690233] Starting dynamic subtest: pipe-D-eDP-1
[223.631088] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.953s)
[223.633567] Subtest wait-forked-hang: SUCCESS (51.406s)
[224.507560] [021/133] (798s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[224.603692] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[224.608234] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[224.708607] [022/133] (798s left) gem_exec_schedule (fairslice)
[224.776337] Starting subtest: fairslice
[224.778687] Starting dynamic subtest: rcs0
[226.793438] Dynamic subtest rcs0: SUCCESS (2.024s)
[226.806515] Starting dynamic subtest: bcs0
[228.812451] Dynamic subtest bcs0: SUCCESS (2.018s)
[228.825312] Starting dynamic subtest: vcs0
[230.833607] Dynamic subtest vcs0: SUCCESS (2.020s)
[230.842605] Starting dynamic subtest: vcs1
[232.852585] Dynamic subtest vcs1: SUCCESS (2.018s)
[232.862270] Starting dynamic subtest: vecs0
[234.870694] Dynamic subtest vecs0: SUCCESS (2.017s)
[234.880661] Starting dynamic subtest: ccs0
[236.894379] Dynamic subtest ccs0: SUCCESS (2.025s)
[236.896681] Subtest fairslice: SUCCESS (12.125s)
[237.197798] [023/133] (785s left) kms_getfb (getfb-addfb-different-handles)
[237.300812] Starting subtest: getfb-addfb-different-handles
[237.303121] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[237.392711] [024/133] (785s left) kms_vrr (seamless-rr-switch-vrr)
[237.493862] Starting subtest: seamless-rr-switch-vrr
[237.499904] Subtest seamless-rr-switch-vrr: SKIP (0.000s)
[237.561946] [025/133] (785s left) gem_workarounds (suspend-resume-context)
[237.623656] Starting subtest: suspend-resume-context
[254.027741] Subtest suspend-resume-context: SUCCESS (1.258s)
[255.189535] [026/133] (768s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[255.310780] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[255.314950] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[255.417512] [027/133] (768s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[255.519542] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[256.189668] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.659s)
[256.380577] [028/133] (767s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[256.478088] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[256.482215] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[256.606495] [029/133] (767s left) kms_feature_discovery (display-3x)
[256.711164] Starting subtest: display-3x
[256.715716] Subtest display-3x: SKIP (0.000s)
[256.796326] [030/133] (767s left) api_intel_bb (misplaced-blitter)
[256.856043] Starting subtest: misplaced-blitter
[256.861219] Subtest misplaced-blitter: SUCCESS (0.007s)
[256.986785] [031/133] (767s left) gem_lmem_swapping (smem-oom)
[257.039045] Subtest smem-oom: SKIP (0.000s)
[257.086936] [032/133] (767s left) kms_cursor_crc (cursor-offscreen-256x85)
[257.354643] Starting subtest: cursor-offscreen-256x85
[257.404289] Subtest cursor-offscreen-256x85: SKIP (0.044s)
[257.579709] [033/133] (766s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[257.636826] Starting subtest: multi-wait-all-for-submit-signaled
[257.638852] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.001s)
[257.746402] [034/133] (766s left) kms_getfb (getfb-handle-zero)
[257.827491] Starting subtest: getfb-handle-zero
[257.829175] Subtest getfb-handle-zero: SUCCESS (0.000s)
[257.915385] [035/133] (766s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[258.013667] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[258.017183] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[258.126640] [036/133] (766s left) gem_userptr_blits (usage-restrictions)
[258.186173] Starting subtest: usage-restrictions
[258.187831] Subtest usage-restrictions: SUCCESS (0.000s)
[258.318194] [037/133] (766s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-plflip-blt)
[258.412637] Starting subtest: fbc-1p-primscrn-shrfb-plflip-blt
[263.021470] Subtest fbc-1p-primscrn-shrfb-plflip-blt: SUCCESS (4.561s)
[264.218068] [038/133] (760s left) gem_ctx_param (invalid-ctx-set)
[264.294288] Starting subtest: invalid-ctx-set
[264.296833] Subtest invalid-ctx-set: SUCCESS (0.001s)
[264.404914] [039/133] (760s left) kms_legacy_colorkey (basic)
[264.483886] Starting subtest: basic
[264.486266] Starting dynamic subtest: pipe-A
[264.530412] Dynamic subtest pipe-A: SUCCESS (0.045s)
[264.542882] Starting dynamic subtest: pipe-B
[264.545109] Dynamic subtest pipe-B: SUCCESS (0.001s)
[264.553940] Starting dynamic subtest: pipe-C
[264.555887] Dynamic subtest pipe-C: SUCCESS (0.000s)
[264.564458] Starting dynamic subtest: pipe-D
[264.566398] Dynamic subtest pipe-D: SUCCESS (0.000s)
[264.568320] Subtest basic: SUCCESS (0.050s)
[264.605267] [040/133] (760s left) gem_userptr_blits (map-fixed-invalidate-overlap)
[264.674686] Starting subtest: map-fixed-invalidate-overlap
[264.679416] Subtest map-fixed-invalidate-overlap: SKIP (0.000s)
[264.794463] [041/133] (759s left) gem_exec_balancer (full-late)
[264.854043] Starting subtest: full-late
[269.932829] Subtest full-late: SUCCESS (5.054s)
[270.262894] [042/133] (754s left) kms_cursor_crc (cursor-rapid-movement-256x85)
[270.514606] Starting subtest: cursor-rapid-movement-256x85
[270.563736] Subtest cursor-rapid-movement-256x85: SKIP (0.043s)
[270.728735] [043/133] (754s left) kms_big_fb (yf-tiled-64bpp-rotate-180)
[270.832514] Starting subtest: yf-tiled-64bpp-rotate-180
[270.836954] Subtest yf-tiled-64bpp-rotate-180: SKIP (0.000s)
[270.946577] [044/133] (753s left) perf (low-oa-exponent-permissions)
[271.059720] Starting subtest: low-oa-exponent-permissions
[271.095631] Subtest low-oa-exponent-permissions: SUCCESS (0.036s)
[271.148333] [045/133] (753s left) gem_create (create-invalid-size)
[271.213394] Starting subtest: create-invalid-size
[271.215535] Subtest create-invalid-size: SUCCESS (0.000s)
[271.411412] [046/133] (753s left) kms_big_fb (y-tiled-32bpp-rotate-90)
[271.530450] Starting subtest: y-tiled-32bpp-rotate-90
[271.535044] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s)
[271.634753] [047/133] (753s left) api_intel_allocator (fork-simple-stress-signal)
[271.700368] Starting subtest: fork-simple-stress-signal
[277.119167] Subtest fork-simple-stress-signal: SUCCESS (5.406s)
[277.255144] [048/133] (747s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-mmap-wc)
[277.364393] Starting subtest: psr-1p-offscreen-pri-indfb-draw-mmap-wc
[284.149434] Subtest psr-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (6.778s)
[284.275060] [049/133] (740s left) kms_plane (pixel-format-yf-tiled-modifier-source-clamping)
[284.376767] Starting subtest: pixel-format-yf-tiled-modifier-source-clamping
[284.381385] Subtest pixel-format-yf-tiled-modifier-source-clamping: SKIP (0.000s)
[284.456680] [050/133] (740s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu)
[284.552976] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu
[288.831066] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.285s)
[289.966663] [051/133] (735s left) gem_exec_store (dword)
[290.025961] Starting subtest: dword
[290.027918] Starting dynamic subtest: rcs0
[290.091461] Dynamic subtest rcs0: SUCCESS (0.067s)
[290.103830] Starting dynamic subtest: bcs0
[290.132779] Dynamic subtest bcs0: SUCCESS (0.040s)
[290.142948] Starting dynamic subtest: vcs0
[290.174481] Dynamic subtest vcs0: SUCCESS (0.040s)
[290.184822] Starting dynamic subtest: vcs1
[290.215724] Dynamic subtest vcs1: SUCCESS (0.039s)
[290.225552] Starting dynamic subtest: vecs0
[290.257467] Dynamic subtest vecs0: SUCCESS (0.040s)
[290.268329] Starting dynamic subtest: ccs0
[290.299892] Dynamic subtest ccs0: SUCCESS (0.040s)
[290.302256] Subtest dword: SUCCESS (0.278s)
[290.497264] [052/133] (734s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-sf)
[290.594136] Starting subtest: fbc-psr2-overlay-plane-move-continuous-sf
[290.596575] Starting dynamic subtest: pipe-A-eDP-1
[290.689474] Dynamic subtest pipe-A-eDP-1: SKIP (0.100s)
[290.700129] Starting dynamic subtest: pipe-B-eDP-1
[292.056732] Dynamic subtest pipe-B-eDP-1: SKIP (1.364s)
[292.061343] Subtest fbc-psr2-overlay-plane-move-continuous-sf: SKIP (1.467s)
[293.245750] [053/133] (731s left) kms_dirtyfb (drrs-dirtyfb-ioctl)
[293.336509] Starting subtest: drrs-dirtyfb-ioctl
[293.351881] Subtest drrs-dirtyfb-ioctl: SKIP (0.001s)
[293.430288] [054/133] (731s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[293.527684] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[293.531811] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[293.623245] [055/133] (731s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[293.722147] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[293.724351] Starting dynamic subtest: pipe-A-eDP-1
[293.749346] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[293.760634] Starting dynamic subtest: pipe-B-eDP-1
[293.784052] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[293.793938] Starting dynamic subtest: pipe-C-eDP-1
[293.817384] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[293.826583] Starting dynamic subtest: pipe-D-eDP-1
[293.850637] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[293.855001] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[296.013589] [056/133] (729s left) gem_close_race (basic-process)
[296.083758] Starting subtest: basic-process
[296.147117] Subtest basic-process: SUCCESS (0.063s)
[296.333753] [057/133] (729s left) kms_plane_alpha_blend (constant-alpha-mid)
[296.431303] Starting subtest: constant-alpha-mid
[296.723978] Starting dynamic subtest: pipe-A-eDP-1
[297.582064] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.856s)
[297.591981] Starting dynamic subtest: pipe-D-eDP-1
[299.147320] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.564s)
[299.149657] Subtest constant-alpha-mid: SUCCESS (2.716s)
[299.973464] [058/133] (725s left) kms_vblank (accuracy-idle)
[300.076246] Starting subtest: accuracy-idle
[300.078130] Starting dynamic subtest: pipe-A-eDP-1
[301.832369] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.757s)
[301.846832] Starting dynamic subtest: pipe-D-eDP-1
[304.317152] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.481s)
[304.319502] Subtest accuracy-idle: SUCCESS (4.242s)
[305.165793] [059/133] (720s left) kms_ccs (bad-rotation-90-4-tiled-bmg-ccs)
[305.267136] Starting subtest: bad-rotation-90-4-tiled-bmg-ccs
[305.271656] Subtest bad-rotation-90-4-tiled-bmg-ccs: SKIP (0.000s)
[306.359845] [060/133] (719s left) gem_exec_reloc (basic-gtt-cpu-noreloc)
[306.416923] Subtest basic-gtt-cpu-noreloc: SKIP (0.000s)
[306.481667] [061/133] (719s left) i915_pm_rpm (reg-read-ioctl)
[308.221526] Starting subtest: reg-read-ioctl
[310.515073] Subtest reg-read-ioctl: SUCCESS (2.296s)
[310.883405] [062/133] (714s left) gem_exec_schedule (smoketest-all)
[310.966569] Starting subtest: smoketest-all
[343.347724] Subtest smoketest-all: SUCCESS (32.327s)
[345.130731] [063/133] (680s left) gem_exec_flush (basic-wb-pro-default)
[345.193905] Starting subtest: basic-wb-pro-default
[350.660720] Subtest basic-wb-pro-default: SUCCESS (5.465s)
[350.842516] [064/133] (674s left) gem_mmap_offset (open-flood)
[350.921331] Starting subtest: open-flood
[372.408788] Subtest open-flood: SUCCESS (21.490s)
[372.509229] [065/133] (653s left) sysfs_defaults (readonly)
[372.566426] Starting subtest: readonly
[372.568669] Starting dynamic subtest: vecs0
[372.570597] Dynamic subtest vecs0: SUCCESS (0.000s)
[372.581188] Starting dynamic subtest: ccs0
[372.583138] Dynamic subtest ccs0: SUCCESS (0.000s)
[372.592165] Starting dynamic subtest: vcs0
[372.593996] Dynamic subtest vcs0: SUCCESS (0.000s)
[372.603588] Starting dynamic subtest: bcs0
[372.605138] Dynamic subtest bcs0: SUCCESS (0.000s)
[372.614326] Starting dynamic subtest: rcs0
[372.616037] Dynamic subtest rcs0: SUCCESS (0.000s)
[372.625172] Starting dynamic subtest: vcs1
[372.626717] Dynamic subtest vcs1: SUCCESS (0.000s)
[372.628302] Subtest readonly: SUCCESS (0.005s)
[372.666889] [066/133] (653s left) gem_ctx_sseu (engines)
[372.723257] Subtest engines: SKIP (0.000s)
[372.786958] [067/133] (653s left) kms_flip (modeset-vs-vblank-race-interruptible)
[372.895016] Starting subtest: modeset-vs-vblank-race-interruptible
[372.897147] Starting dynamic subtest: A-eDP1
[377.606994] Dynamic subtest A-eDP1: SUCCESS (4.709s)
[377.619602] Starting dynamic subtest: B-eDP1
[382.243921] Dynamic subtest B-eDP1: SUCCESS (4.634s)
[382.268044] Starting dynamic subtest: C-eDP1
[386.682160] Dynamic subtest C-eDP1: SUCCESS (4.434s)
[386.696885] Starting dynamic subtest: D-eDP1
[391.140152] Dynamic subtest D-eDP1: SUCCESS (4.454s)
[391.142639] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.244s)
[392.312578] [068/133] (633s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[392.419852] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[392.424802] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s)
[392.492715] [069/133] (633s left) kms_psr (psr-cursor-plane-move)
[392.590065] Starting subtest: psr-cursor-plane-move
[392.592341] Starting dynamic subtest: eDP-1
[394.306884] Dynamic subtest eDP-1: SUCCESS (1.717s)
[394.309261] Subtest psr-cursor-plane-move: SUCCESS (1.718s)
[395.176027] [070/133] (630s left) kms_chamelium_frames (hdmi-aspect-ratio)
[395.555771] Subtest hdmi-aspect-ratio: SKIP (0.000s)
[396.386585] [071/133] (629s left) gem_mmap (bad-object)
[396.454857] Subtest bad-object: SKIP (0.000s)
[396.521184] [072/133] (629s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[396.612776] Starting subtest: primary-x-tiled-reflect-x-0
[403.453914] Subtest primary-x-tiled-reflect-x-0: SUCCESS (6.840s)
[404.689409] [073/133] (621s left) sriov_basic (enable-vfs-bind-unbind-each)
[404.747902] Starting subtest: enable-vfs-bind-unbind-each
[404.750306] Starting dynamic subtest: numvfs-1
[404.827158] Dynamic subtest numvfs-1: FAIL (0.016s)
[404.838911] Starting dynamic subtest: numvfs-2
[404.909577] Dynamic subtest numvfs-2: FAIL (0.004s)
[404.919951] Starting dynamic subtest: numvfs-3
[404.989691] Dynamic subtest numvfs-3: FAIL (0.004s)
[404.999374] Starting dynamic subtest: numvfs-4
[405.068160] Dynamic subtest numvfs-4: FAIL (0.004s)
[405.078704] Starting dynamic subtest: numvfs-5
[405.149123] Dynamic subtest numvfs-5: FAIL (0.004s)
[405.158587] Starting dynamic subtest: numvfs-6
[405.227988] Dynamic subtest numvfs-6: FAIL (0.004s)
[405.237762] Starting dynamic subtest: numvfs-7
[405.307474] Dynamic subtest numvfs-7: FAIL (0.004s)
[405.317328] Starting dynamic subtest: numvfs-random
[405.386616] Dynamic subtest numvfs-random: FAIL (0.004s)
[405.388535] Subtest enable-vfs-bind-unbind-each: FAIL (0.048s)
[405.429533] [074/133] (620s left) gem_userptr_blits (create-destroy-sync)
[405.498672] Starting subtest: create-destroy-sync
[410.518895] Subtest create-destroy-sync: SUCCESS (5.020s)
[410.646552] [075/133] (615s left) gem_exec_balancer (parallel-ordering)
[410.906148] Starting subtest: parallel-ordering
[411.925750] Subtest parallel-ordering: SUCCESS (1.020s)
[412.044601] [076/133] (614s left) template (a)
[412.104123] Starting subtest: A
[412.106417] Subtest A: SUCCESS (0.000s)
[412.214210] [077/133] (614s left) kms_psr (fbc-psr-cursor-plane-onoff)
[412.314952] Starting subtest: fbc-psr-cursor-plane-onoff
[412.317158] Starting dynamic subtest: eDP-1
[412.321151] Dynamic subtest eDP-1: SKIP (0.000s)
[412.325122] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.001s)
[412.393380] [078/133] (613s left) kms_psr2_su (page_flip-p010)
[412.455700] Subtest page_flip-P010: SKIP (0.000s)
[412.520246] [079/133] (613s left) kms_async_flips (test-cursor-atomic)
[412.619125] Starting subtest: test-cursor-atomic
[412.999782] Starting dynamic subtest: pipe-A-eDP-1
[413.765855] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.766s)
[414.159680] Starting dynamic subtest: pipe-B-eDP-1
[414.908137] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.756s)
[415.287289] Starting dynamic subtest: pipe-C-eDP-1
[416.037732] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.765s)
[416.404298] Starting dynamic subtest: pipe-D-eDP-1
[417.169993] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.774s)
[417.172533] Subtest test-cursor-atomic: SUCCESS (4.551s)
[418.343957] [080/133] (608s left) kms_plane_cursor (viewport)
[418.455718] Starting subtest: viewport
[418.460245] Starting dynamic subtest: pipe-A-eDP-1-size-64
[421.103135] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.647s)
[421.164025] Starting dynamic subtest: pipe-A-eDP-1-size-128
[423.692635] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.538s)
[423.754841] Starting dynamic subtest: pipe-A-eDP-1-size-256
[426.295582] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.549s)
[426.645996] Starting dynamic subtest: pipe-B-eDP-1-size-64
[429.852155] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.216s)
[429.913333] Starting dynamic subtest: pipe-B-eDP-1-size-128
[432.330836] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.427s)
[432.393256] Starting dynamic subtest: pipe-B-eDP-1-size-256
[434.899720] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.515s)
[435.249061] Starting dynamic subtest: pipe-C-eDP-1-size-64
[438.130824] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.892s)
[438.168029] Starting dynamic subtest: pipe-C-eDP-1-size-128
[440.321044] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.160s)
[440.358009] Starting dynamic subtest: pipe-C-eDP-1-size-256
[442.497472] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.147s)
[442.827787] Starting dynamic subtest: pipe-D-eDP-1-size-64
[445.626427] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.810s)
[445.663687] Starting dynamic subtest: pipe-D-eDP-1-size-128
[447.770649] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.114s)
[447.810251] Starting dynamic subtest: pipe-D-eDP-1-size-256
[449.971673] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.169s)
[450.296559] Subtest viewport: SUCCESS (31.832s)
[451.094779] [081/133] (575s left) kms_pm_backlight (fade-with-dpms)
[451.197549] Starting subtest: fade-with-dpms
[453.567371] Starting dynamic subtest: eDP-1
[456.062669] Dynamic subtest eDP-1: SUCCESS (2.494s)
[456.065077] Subtest fade-with-dpms: SUCCESS (4.865s)
[456.856350] [082/133] (569s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-plflip-blt)
[456.961914] Starting subtest: fbc-2p-scndscrn-shrfb-plflip-blt
[456.966318] Subtest fbc-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s)
[457.057121] [083/133] (569s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[457.152378] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[457.156479] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[457.256213] [084/133] (569s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-pwrite)
[457.342319] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-pwrite
[464.549938] Subtest fbc-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (7.209s)
[465.680047] [085/133] (560s left) gem_lmem_swapping (heavy-multi)
[465.727517] Subtest heavy-multi: SKIP (0.000s)
[465.776443] [086/133] (560s left) i915_query (query-regions-garbage-items)
[465.837688] Starting subtest: query-regions-garbage-items
[465.839841] Subtest query-regions-garbage-items: SUCCESS (0.000s)
[465.953016] [087/133] (560s left) gem_softpin (overlap)
[466.010932] Starting subtest: overlap
[466.883804] Subtest overlap: SUCCESS (0.871s)
[466.996705] [088/133] (559s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[467.048780] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[467.051177] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.001s)
[467.127834] [089/133] (559s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[467.252131] Starting subtest: protected-encrypted-src-copy-not-readible
[467.377660] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.127s)
[467.494769] [090/133] (559s left) gem_mmap_gtt (basic-write-gtt)
[467.548924] Subtest basic-write-gtt: SKIP (0.000s)
[467.608809] [091/133] (559s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-180)
[467.720808] Starting subtest: linear-max-hw-stride-32bpp-rotate-180
[468.870375] Subtest linear-max-hw-stride-32bpp-rotate-180: SUCCESS (1.149s)
[468.994198] [092/133] (557s left) gem_mmap_wc (write-wc-read-gtt)
[469.063973] Subtest write-wc-read-gtt: SKIP (0.000s)
[469.121152] [093/133] (557s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[469.224977] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[476.127302] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.900s)
[476.278412] [094/133] (550s left) kms_psr (pr-no-drrs)
[476.370195] Starting subtest: pr-no-drrs
[476.374805] Subtest pr-no-drrs: SKIP (0.000s)
[476.444686] [095/133] (550s left) sw_sync (sync_expired_merge)
[476.483830] Starting subtest: sync_expired_merge
[477.558642] Subtest sync_expired_merge: SUCCESS (1.074s)
[477.627892] [096/133] (549s left) kms_atomic_transition (plane-all-modeset-transition)
[477.717504] Starting subtest: plane-all-modeset-transition
[477.721865] Subtest plane-all-modeset-transition: SKIP (0.000s)
[477.789272] [097/133] (549s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[477.899074] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[477.903526] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[478.006474] [098/133] (549s left) drm_read (short-buffer-wakeup)
[478.152831] Starting subtest: short-buffer-wakeup
[510.364851] Subtest short-buffer-wakeup: SUCCESS (32.216s)
[510.514189] [099/133] (516s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[510.571466] Starting subtest: etime-multi-wait-all-for-submit-submitted
[510.673723] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.103s)
[510.759467] [100/133] (516s left) gem_request_retire (retire-vma-not-inactive)
[510.825221] Starting subtest: retire-vma-not-inactive
[510.883543] Subtest retire-vma-not-inactive: SUCCESS (0.058s)
[511.000356] [101/133] (516s left) gen9_exec_parse (allowed-single)
[511.063200] Subtest allowed-single: SKIP (0.000s)
[511.138487] [102/133] (516s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[511.242812] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[511.247263] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[511.344054] [103/133] (516s left) kms_busy (extended-modeset-hang-oldfb)
[511.447025] Starting subtest: extended-modeset-hang-oldfb
[511.449371] Starting dynamic subtest: pipe-A
[523.051837] Dynamic subtest pipe-A: SUCCESS (11.605s)
[523.062302] Starting dynamic subtest: pipe-D
[535.306157] Dynamic subtest pipe-D: SUCCESS (12.250s)
[535.308439] Subtest extended-modeset-hang-oldfb: SUCCESS (23.860s)
[536.127540] [104/133] (491s left) kms_color (legacy-gamma-reset)
[536.213888] Starting subtest: legacy-gamma-reset
[536.216287] Starting dynamic subtest: pipe-A-eDP-1
[536.585709] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.375s)
[536.596179] Starting dynamic subtest: pipe-B-eDP-1
[536.601051] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.012s)
[536.611155] Starting dynamic subtest: pipe-C-eDP-1
[536.613496] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.012s)
[536.623461] Starting dynamic subtest: pipe-D-eDP-1
[536.625805] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.013s)
[536.628191] Subtest legacy-gamma-reset: SUCCESS (0.415s)
[537.443045] [105/133] (489s left) gem_exec_schedule (preempt-queue-contexts)
[537.518340] Subtest preempt-queue-contexts: SKIP (0.000s)
[537.806216] [106/133] (489s left) kms_properties (colorop-properties-legacy)
[537.905196] Starting subtest: colorop-properties-legacy
[537.907537] Starting dynamic subtest: pipe-A-eDP-1
[538.261631] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.357s)
[538.274220] Starting dynamic subtest: pipe-B-eDP-1
[539.350467] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.086s)
[539.360902] Starting dynamic subtest: pipe-C-eDP-1
[540.439010] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.088s)
[540.451782] Starting dynamic subtest: pipe-D-eDP-1
[541.476919] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.038s)
[541.479204] Subtest colorop-properties-legacy: SUCCESS (3.574s)
[542.296902] [107/133] (485s left) kms_psr (psr-sprite-plane-move)
[542.389279] Starting subtest: psr-sprite-plane-move
[542.391396] Starting dynamic subtest: eDP-1
[544.127544] Dynamic subtest eDP-1: SUCCESS (1.740s)
[544.129773] Subtest psr-sprite-plane-move: SUCCESS (1.741s)
[544.942345] [108/133] (482s left) kms_cursor_legacy (cursorb-vs-flipa-toggle)
[545.063487] Starting subtest: cursorB-vs-flipA-toggle
[545.068121] Subtest cursorB-vs-flipA-toggle: SKIP (0.001s)
[545.222569] [109/133] (482s left) gem_ctx_param (non-root-set)
[545.278853] Starting subtest: non-root-set
[545.309295] Subtest non-root-set: SUCCESS (0.030s)
[545.405946] [110/133] (482s left) kms_big_fb (linear-16bpp-rotate-0)
[545.500377] Starting subtest: linear-16bpp-rotate-0
[546.912357] Subtest linear-16bpp-rotate-0: SUCCESS (1.412s)
[547.035307] [111/133] (480s left) kms_setmode (invalid-clone-single-crtc-stealing)
[547.083465] Starting subtest: invalid-clone-single-crtc-stealing
[547.089153] Subtest invalid-clone-single-crtc-stealing: SKIP (0.000s)
[547.178691] [112/133] (480s left) kms_chamelium_color (ctm-limited-range)
[547.272391] Subtest ctm-limited-range: SKIP (0.000s)
[547.320308] [113/133] (480s left) gem_ccs (block-multicopy-inplace)
[547.373876] Starting subtest: block-multicopy-inplace
[547.377705] Subtest block-multicopy-inplace: SKIP (0.000s)
[547.469644] [114/133] (480s left) gem_exec_schedule (u-semaphore-user)
[547.540981] Starting subtest: u-semaphore-user
[547.605298] Subtest u-semaphore-user: SUCCESS (0.066s)
[549.111826] [115/133] (478s left) gem_create (create-ext-placement-each)
[549.284334] Starting subtest: create-ext-placement-each
[549.286715] Subtest create-ext-placement-each: SUCCESS (0.000s)
[549.368690] [116/133] (478s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[549.478400] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[581.450396] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (31.967s)
[582.283858] [117/133] (445s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render)
[582.395719] Starting subtest: fbc-rgb565-draw-render
[586.570845] Subtest fbc-rgb565-draw-render: SUCCESS (4.177s)
[587.719673] [118/133] (440s left) syncobj_timeline (reset-signaled)
[587.766407] Starting subtest: reset-signaled
[587.768804] Subtest reset-signaled: SUCCESS (0.000s)
[587.858039] [119/133] (440s left) kms_plane (planar-pixel-format-settings)
[587.952579] Starting subtest: planar-pixel-format-settings
[588.026204] Subtest planar-pixel-format-settings: SUCCESS (0.072s)
[588.129587] [120/133] (439s left) gem_ctx_persistence (legacy-engines-hostile-preempt)
[588.184004] Starting subtest: legacy-engines-hostile-preempt
[588.186713] Starting dynamic subtest: render
[588.253556] Dynamic subtest render: SUCCESS (0.069s)
[588.269269] Starting dynamic subtest: bsd1
[590.072678] Dynamic subtest bsd1: SUCCESS (1.814s)
[590.085865] Starting dynamic subtest: bsd2
[592.063828] Dynamic subtest bsd2: SUCCESS (1.988s)
[592.076421] Starting dynamic subtest: blt
[592.107507] Dynamic subtest blt: SUCCESS (0.042s)
[592.118169] Starting dynamic subtest: vebox
[594.024653] Dynamic subtest vebox: SUCCESS (1.913s)
[594.027189] Subtest legacy-engines-hostile-preempt: SUCCESS (5.840s)
[594.139074] [121/133] (433s left) kms_flip (basic-flip-vs-dpms)
[594.232490] Starting subtest: basic-flip-vs-dpms
[594.234784] Starting dynamic subtest: A-eDP1
[596.793844] Dynamic subtest A-eDP1: SUCCESS (2.562s)
[596.806964] Starting dynamic subtest: B-eDP1
[598.962767] Dynamic subtest B-eDP1: SUCCESS (2.163s)
[598.973705] Starting dynamic subtest: C-eDP1
[601.049316] Dynamic subtest C-eDP1: SUCCESS (2.086s)
[601.061296] Starting dynamic subtest: D-eDP1
[603.126768] Dynamic subtest D-eDP1: SUCCESS (2.076s)
[603.128995] Subtest basic-flip-vs-dpms: SUCCESS (8.899s)
[603.925244] [122/133] (424s left) gem_watchdog (default-physical)
[603.997162] Starting subtest: default-physical
[605.752765] Subtest default-physical: SUCCESS (1.770s)
[605.850094] [123/133] (422s left) perf_pmu (idle-no-semaphores)
[605.892757] Starting subtest: idle-no-semaphores
[605.895257] Starting dynamic subtest: rcs0
[606.433368] Dynamic subtest rcs0: SUCCESS (0.543s)
[606.446373] Starting dynamic subtest: bcs0
[606.959571] Dynamic subtest bcs0: SUCCESS (0.523s)
[606.972962] Starting dynamic subtest: vcs0
[607.480008] Dynamic subtest vcs0: SUCCESS (0.516s)
[607.492977] Starting dynamic subtest: vcs1
[608.000432] Dynamic subtest vcs1: SUCCESS (0.517s)
[608.013782] Starting dynamic subtest: vecs0
[608.525652] Dynamic subtest vecs0: SUCCESS (0.522s)
[608.538317] Starting dynamic subtest: ccs0
[609.046397] Dynamic subtest ccs0: SUCCESS (0.517s)
[609.049799] Subtest idle-no-semaphores: SUCCESS (3.157s)
[609.157355] [124/133] (419s left) gem_pwrite_snooped
[609.301885] [125/133] (418s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic)
[609.404121] Starting subtest: async-flip-with-page-flip-events-linear-atomic
[609.780788] Starting dynamic subtest: pipe-A-eDP-1
[612.591589] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.810s)
[612.964118] Starting dynamic subtest: pipe-B-eDP-1
[615.715955] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.764s)
[616.080148] Starting dynamic subtest: pipe-C-eDP-1
[618.840027] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.767s)
[619.206572] Starting dynamic subtest: pipe-D-eDP-1
[621.966947] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.768s)
[621.969326] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.562s)
[623.146385] [126/133] (405s left) gem_ctx_persistence (engines-persistence)
[623.224724] Starting subtest: engines-persistence
[623.226658] Starting dynamic subtest: rcs0
[624.000986] Dynamic subtest rcs0: SUCCESS (0.778s)
[624.014130] Starting dynamic subtest: bcs0
[624.761916] Dynamic subtest bcs0: SUCCESS (0.759s)
[624.775489] Starting dynamic subtest: vcs0
[625.511024] Dynamic subtest vcs0: SUCCESS (0.747s)
[625.522951] Starting dynamic subtest: vcs1
[626.306025] Dynamic subtest vcs1: SUCCESS (0.793s)
[626.328459] Starting dynamic subtest: vecs0
[627.066105] Dynamic subtest vecs0: SUCCESS (0.757s)
[627.079482] Starting dynamic subtest: ccs0
[627.833043] Dynamic subtest ccs0: SUCCESS (0.764s)
[627.835794] Subtest engines-persistence: SUCCESS (4.611s)
[627.915104] [127/133] (400s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[628.030172] Starting subtest: psr-rgb101010-draw-render
[635.403904] Subtest psr-rgb101010-draw-render: SUCCESS (7.375s)
[635.542051] [128/133] (392s left) kms_cursor_edge_walk (64x64-top-edge)
[635.641353] Starting subtest: 64x64-top-edge
[635.643716] Starting dynamic subtest: pipe-A-eDP-1
[639.063293] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.420s)
[639.075128] Starting dynamic subtest: pipe-D-eDP-1
[642.171481] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.107s)
[642.173897] Subtest 64x64-top-edge: SUCCESS (6.530s)
[642.999525] [129/133] (385s left) gem_flink_basic (bad-flink)
[643.057562] Starting subtest: bad-flink
[643.059836] Subtest bad-flink: SUCCESS (0.000s)
[643.152354] [130/133] (385s left) prime_self_import (basic-with_fd_dup)
[643.185813] Starting subtest: basic-with_fd_dup
[643.219622] Subtest basic-with_fd_dup: SUCCESS (0.035s)
[643.334263] [131/133] (385s left) kms_invalid_mode (bad-vsync-start)
[643.432364] Starting subtest: bad-vsync-start
[643.434648] Starting dynamic subtest: pipe-A-eDP-1
[643.729650] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.299s)
[643.740862] Starting dynamic subtest: pipe-B-eDP-1
[643.743140] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[643.752683] Starting dynamic subtest: pipe-C-eDP-1
[643.755004] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[643.764973] Starting dynamic subtest: pipe-D-eDP-1
[643.767574] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[643.769802] Subtest bad-vsync-start: SUCCESS (0.305s)
[644.535418] [132/133] (384s left) gem_exec_fence (syncobj-signal)
[645.007789] Starting subtest: syncobj-signal
[645.013666] Subtest syncobj-signal: SUCCESS (0.005s)
[646.149949] [FACT gem_exec_fence (syncobj-signal)] new: kernel.kmod_is_loaded.vgem: true
[646.153950] [133/133] (382s left) i915_drm_fdinfo (context-close-stress)
[646.194706] Starting subtest: context-close-stress
[656.940225] Subtest context-close-stress: SUCCESS (10.744s)
[657.031017] Closing watchdogs
results: parsing output: 0/ for test: kms_chamelium_hpd
results: parsing output: 1/ for test: kms_ccs
results: parsing output: 2/ for test: i915_hangman
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_pm_rpm
results: parsing output: 5/ for test: kms_flip_scaled_crc
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_plane_scaling
results: parsing output: 8/ for test: kms_ccs
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: kms_cursor_legacy
results: parsing output: 12/ for test: kms_psr
results: parsing output: 13/ for test: gem_render_copy
results: parsing output: 14/ for test: gem_softpin
results: parsing output: 15/ for test: kms_content_protection
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: syncobj_timeline
results: parsing output: 18/ for test: gem_exec_suspend
results: parsing output: 19/ for test: kms_vblank
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: gem_exec_schedule
results: parsing output: 22/ for test: kms_getfb
results: parsing output: 23/ for test: kms_vrr
results: parsing output: 24/ for test: gem_workarounds
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_feature_discovery
results: parsing output: 29/ for test: api_intel_bb
results: parsing output: 30/ for test: gem_lmem_swapping
results: parsing output: 31/ for test: kms_cursor_crc
results: parsing output: 32/ for test: syncobj_wait
results: parsing output: 33/ for test: kms_getfb
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: gem_userptr_blits
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_ctx_param
results: parsing output: 38/ for test: kms_legacy_colorkey
results: parsing output: 39/ for test: gem_userptr_blits
results: parsing output: 40/ for test: gem_exec_balancer
results: parsing output: 41/ for test: kms_cursor_crc
results: parsing output: 42/ for test: kms_big_fb
results: parsing output: 43/ for test: perf
results: parsing output: 44/ for test: gem_create
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: api_intel_allocator
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_plane
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: gem_exec_store
results: parsing output: 51/ for test: kms_psr2_sf
results: parsing output: 52/ for test: kms_dirtyfb
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_ccs
results: parsing output: 55/ for test: gem_close_race
results: parsing output: 56/ for test: kms_plane_alpha_blend
results: parsing output: 57/ for test: kms_vblank
results: parsing output: 58/ for test: kms_ccs
results: parsing output: 59/ for test: gem_exec_reloc
results: parsing output: 60/ for test: i915_pm_rpm
results: parsing output: 61/ for test: gem_exec_schedule
results: parsing output: 62/ for test: gem_exec_flush
results: parsing output: 63/ for test: gem_mmap_offset
results: parsing output: 64/ for test: sysfs_defaults
results: parsing output: 65/ for test: gem_ctx_sseu
results: parsing output: 66/ for test: kms_flip
results: parsing output: 67/ for test: kms_flip_scaled_crc
results: parsing output: 68/ for test: kms_psr
results: parsing output: 69/ for test: kms_chamelium_frames
results: parsing output: 70/ for test: gem_mmap
results: parsing output: 71/ for test: kms_rotation_crc
results: parsing output: 72/ for test: sriov_basic
results: parsing output: 73/ for test: gem_userptr_blits
results: parsing output: 74/ for test: gem_exec_balancer
results: parsing output: 75/ for test: template
results: parsing output: 76/ for test: kms_psr
results: parsing output: 77/ for test: kms_psr2_su
results: parsing output: 78/ for test: kms_async_flips
results: parsing output: 79/ for test: kms_plane_cursor
results: parsing output: 80/ for test: kms_pm_backlight
results: parsing output: 81/ for test: kms_frontbuffer_tracking
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: gem_lmem_swapping
results: parsing output: 85/ for test: i915_query
results: parsing output: 86/ for test: gem_softpin
results: parsing output: 87/ for test: syncobj_timeline
results: parsing output: 88/ for test: gem_pxp
results: parsing output: 89/ for test: gem_mmap_gtt
results: parsing output: 90/ for test: kms_big_fb
results: parsing output: 91/ for test: gem_mmap_wc
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_psr
results: parsing output: 94/ for test: sw_sync
results: parsing output: 95/ for test: kms_atomic_transition
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: drm_read
results: parsing output: 98/ for test: syncobj_timeline
results: parsing output: 99/ for test: gem_request_retire
results: parsing output: 100/ for test: gen9_exec_parse
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: kms_busy
results: parsing output: 103/ for test: kms_color
results: parsing output: 104/ for test: gem_exec_schedule
results: parsing output: 105/ for test: kms_properties
results: parsing output: 106/ for test: kms_psr
results: parsing output: 107/ for test: kms_cursor_legacy
results: parsing output: 108/ for test: gem_ctx_param
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: kms_setmode
results: parsing output: 111/ for test: kms_chamelium_color
results: parsing output: 112/ for test: gem_ccs
results: parsing output: 113/ for test: gem_exec_schedule
results: parsing output: 114/ for test: gem_create
results: parsing output: 115/ for test: kms_cursor_legacy
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: syncobj_timeline
results: parsing output: 118/ for test: kms_plane
results: parsing output: 119/ for test: gem_ctx_persistence
results: parsing output: 120/ for test: kms_flip
results: parsing output: 121/ for test: gem_watchdog
results: parsing output: 122/ for test: perf_pmu
results: parsing output: 123/ for test: gem_pwrite_snooped
results: parsing output: 124/ for test: kms_async_flips
results: parsing output: 125/ for test: gem_ctx_persistence
results: parsing output: 126/ for test: kms_frontbuffer_tracking
results: parsing output: 127/ for test: kms_cursor_edge_walk
results: parsing output: 128/ for test: gem_flink_basic
results: parsing output: 129/ for test: prime_self_import
results: parsing output: 130/ for test: kms_invalid_mode
results: parsing output: 131/ for test: gem_exec_fence
results: parsing output: 132/ for test: i915_drm_fdinfo
Done.