[57.069686] Initializing watchdogs
[57.069751]   /dev/watchdog0
[57.090464] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[57.101554] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[57.105558] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.108118] [001/131] (960s left) gem_flink_basic (double-flink)
[57.185254] Starting subtest: double-flink
[57.186176] Subtest double-flink: SUCCESS (0.000s)
[57.355212] [002/131] (960s left) kms_plane (pixel-format-source-clamping)
[57.542167] Starting subtest: pixel-format-source-clamping
[57.576037] Starting dynamic subtest: pipe-A-plane-0
[65.925392] Dynamic subtest pipe-A-plane-0: SUCCESS (8.350s)
[65.933366] Starting dynamic subtest: pipe-A-plane-3
[70.241262] Dynamic subtest pipe-A-plane-3: SUCCESS (4.316s)
[70.250072] Starting dynamic subtest: pipe-A-plane-5
[70.251191] Dynamic subtest pipe-A-plane-5: SUCCESS (0.000s)
[70.461958] Starting dynamic subtest: pipe-B-plane-0
[78.416106] Dynamic subtest pipe-B-plane-0: SUCCESS (7.967s)
[78.425084] Starting dynamic subtest: pipe-B-plane-3
[82.532377] Dynamic subtest pipe-B-plane-3: SUCCESS (4.116s)
[82.541185] Starting dynamic subtest: pipe-B-plane-5
[82.542298] Dynamic subtest pipe-B-plane-5: SUCCESS (0.000s)
[82.608155] Subtest pixel-format-source-clamping: SUCCESS (25.067s)
[82.930182] [003/131] (934s left) gem_exec_fence (submit)
[83.139163] Starting subtest: submit
[83.141607] Subtest submit: SKIP (0.000s)
[83.869332] [FACT gem_exec_fence (submit)] new: kernel.kmod_is_loaded.vgem: true
[83.871471] [004/131] (933s left) i915_pm_rpm (reg-read-ioctl)
[86.015066] Starting subtest: reg-read-ioctl
[86.772470] Subtest reg-read-ioctl: SUCCESS (0.757s)
[87.152340] [005/131] (930s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[87.361113] Starting subtest: y-tiled-16bpp-rotate-180
[87.362905] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s)
[87.491436] [006/131] (930s left) i915_hangman (engine-engine-hang)
[87.595045] Starting subtest: engine-engine-hang
[87.595983] Starting dynamic subtest: rcs0
[88.464434] Dynamic subtest rcs0: SUCCESS (0.870s)
[88.473233] Starting dynamic subtest: bcs0
[89.274380] Dynamic subtest bcs0: SUCCESS (0.810s)
[89.282853] Starting dynamic subtest: vcs0
[90.076524] Dynamic subtest vcs0: SUCCESS (0.802s)
[90.085163] Starting dynamic subtest: vcs1
[90.912549] Dynamic subtest vcs1: SUCCESS (0.836s)
[90.922838] Starting dynamic subtest: vecs0
[91.720878] Dynamic subtest vecs0: SUCCESS (0.808s)
[91.729488] Starting dynamic subtest: vecs1
[92.551531] Dynamic subtest vecs1: SUCCESS (0.830s)
[92.560413] Starting dynamic subtest: ccs0
[93.355339] Dynamic subtest ccs0: SUCCESS (0.804s)
[93.356286] Subtest engine-engine-hang: SUCCESS (5.761s)
[93.501579] [007/131] (924s left) kms_feature_discovery (display-3x)
[93.697952] Starting subtest: display-3x
[93.699695] Subtest display-3x: SKIP (0.000s)
[93.816926] [008/131] (924s left) gen7_exec_parse (load-register-reg)
[93.902582] Subtest load-register-reg: SKIP (0.000s)
[93.977811] [009/131] (924s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[94.169612] Starting subtest: basic-flip-before-cursor-legacy
[95.172075] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.001s)
[95.429402] [010/131] (922s left) gem_eio (wait-wedge-immediate)
[95.685882] Starting subtest: wait-wedge-immediate
[96.895453] Subtest wait-wedge-immediate: SUCCESS (1.209s)
[97.120988] [011/131] (921s left) api_intel_bb (crc32)
[97.205024] Starting subtest: crc32
[97.205989] Starting dynamic subtest: rcs0-lmem0
[97.449476] Dynamic subtest rcs0-lmem0: SUCCESS (0.243s)
[97.463494] Starting dynamic subtest: rcs0-smem0
[97.764239] Dynamic subtest rcs0-smem0: SUCCESS (0.314s)
[97.803688] Starting dynamic subtest: bcs0-lmem0
[98.024231] Dynamic subtest bcs0-lmem0: SUCCESS (0.259s)
[98.037399] Starting dynamic subtest: bcs0-smem0
[98.345613] Dynamic subtest bcs0-smem0: SUCCESS (0.320s)
[98.357157] Starting dynamic subtest: vcs0-lmem0
[98.702892] Dynamic subtest vcs0-lmem0: SUCCESS (0.356s)
[98.716479] Starting dynamic subtest: vcs0-smem0
[99.179422] Dynamic subtest vcs0-smem0: SUCCESS (0.476s)
[99.191195] Starting dynamic subtest: vcs1-lmem0
[99.529136] Dynamic subtest vcs1-lmem0: SUCCESS (0.349s)
[99.542387] Starting dynamic subtest: vcs1-smem0
[100.014637] Dynamic subtest vcs1-smem0: SUCCESS (0.485s)
[100.026144] Starting dynamic subtest: vecs0-lmem0
[100.363368] Dynamic subtest vecs0-lmem0: SUCCESS (0.348s)
[100.377504] Starting dynamic subtest: vecs0-smem0
[100.848134] Dynamic subtest vecs0-smem0: SUCCESS (0.484s)
[100.859200] Starting dynamic subtest: vecs1-lmem0
[101.201599] Dynamic subtest vecs1-lmem0: SUCCESS (0.353s)
[101.242158] Starting dynamic subtest: vecs1-smem0
[101.720383] Dynamic subtest vecs1-smem0: SUCCESS (0.518s)
[101.732057] Starting dynamic subtest: ccs0-lmem0
[101.958140] Dynamic subtest ccs0-lmem0: SUCCESS (0.237s)
[101.997890] Starting dynamic subtest: ccs0-smem0
[102.323248] Dynamic subtest ccs0-smem0: SUCCESS (0.364s)
[102.325229] Subtest crc32: SUCCESS (5.117s)
[102.492594] [012/131] (915s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[102.697585] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt
[102.699262] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[102.833361] [013/131] (915s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[103.061435] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[103.778876] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.717s)
[104.022945] [014/131] (914s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[104.223429] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[104.225158] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[104.378974] [015/131] (914s left) gem_ctx_param (get-priority-new-ctx)
[104.455392] Starting subtest: get-priority-new-ctx
[104.457274] Subtest get-priority-new-ctx: SUCCESS (0.001s)
[104.579501] [016/131] (914s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw)
[104.783845] Starting subtest: fbc-2p-pri-indfb-multidraw
[104.785494] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s)
[104.914657] [017/131] (913s left) i915_pm_rpm (sysfs-read)
[107.033705] Starting subtest: sysfs-read
[107.343688] Subtest sysfs-read: SUCCESS (0.311s)
[107.755361] [018/131] (910s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[107.960949] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc
[107.962509] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[108.065550] [019/131] (910s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-sf)
[108.269493] Subtest psr2-cursor-plane-move-continuous-sf: SKIP (0.000s)
[108.316278] [020/131] (910s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[108.519972] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[108.521781] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[108.672093] [021/131] (910s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite)
[108.875453] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite
[108.877129] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[109.014871] [022/131] (909s left) gem_mmap_gtt (basic)
[109.096023] Subtest basic: SKIP (0.000s)
[109.169324] [023/131] (909s left) gem_exec_store (pages)
[109.259178] Starting subtest: pages
[109.260478] Starting dynamic subtest: rcs0
[109.404344] Dynamic subtest rcs0: SUCCESS (0.145s)
[109.414372] Starting dynamic subtest: bcs0
[109.516677] Dynamic subtest bcs0: SUCCESS (0.112s)
[109.526604] Starting dynamic subtest: vcs0
[109.638556] Dynamic subtest vcs0: SUCCESS (0.122s)
[109.647783] Starting dynamic subtest: vcs1
[109.738709] Dynamic subtest vcs1: SUCCESS (0.100s)
[109.747585] Starting dynamic subtest: vecs0
[109.836626] Dynamic subtest vecs0: SUCCESS (0.098s)
[109.846147] Starting dynamic subtest: vecs1
[109.935729] Dynamic subtest vecs1: SUCCESS (0.099s)
[109.945042] Starting dynamic subtest: ccs0
[110.041618] Dynamic subtest ccs0: SUCCESS (0.105s)
[110.042664] Subtest pages: SUCCESS (0.782s)
[110.296769] [024/131] (908s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs)
[110.491251] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs
[110.492207] Starting dynamic subtest: pipe-A-DP-3
[149.201325] Dynamic subtest pipe-A-DP-3: SUCCESS (8.576s)
[149.240671] Starting dynamic subtest: pipe-B-DP-3
[188.123634] Dynamic subtest pipe-B-DP-3: SUCCESS (7.330s)
[188.137789] Starting dynamic subtest: pipe-C-DP-3
[227.375470] Dynamic subtest pipe-C-DP-3: SUCCESS (7.487s)
[227.388631] Starting dynamic subtest: pipe-D-DP-3
[266.553591] Dynamic subtest pipe-D-DP-3: SUCCESS (7.526s)
[266.554537] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SUCCESS (30.926s)
[266.921730] [025/131] (752s left) template (a)
[267.006326] Starting subtest: A
[267.007294] Subtest A: SUCCESS (0.000s)
[267.153303] [026/131] (752s left) i915_drm_fdinfo (all-busy-idle-check-all)
[267.222982] Starting subtest: all-busy-idle-check-all
[267.251428] Subtest all-busy-idle-check-all: SKIP (0.027s)
[267.353738] [027/131] (751s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu)
[267.589177] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu
[267.590925] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[267.730654] [028/131] (751s left) gem_exec_schedule (implicit-boths)
[267.820800] Starting subtest: implicit-boths
[267.821704] Starting dynamic subtest: rcs0
[268.120872] Dynamic subtest rcs0: SUCCESS (0.300s)
[268.132188] Starting dynamic subtest: bcs0
[268.324565] Dynamic subtest bcs0: SUCCESS (0.203s)
[268.335741] Starting dynamic subtest: vcs0
[268.535612] Dynamic subtest vcs0: SUCCESS (0.211s)
[268.546725] Starting dynamic subtest: vcs1
[268.747462] Dynamic subtest vcs1: SUCCESS (0.211s)
[268.758512] Starting dynamic subtest: vecs0
[268.958894] Dynamic subtest vecs0: SUCCESS (0.211s)
[268.970391] Starting dynamic subtest: vecs1
[269.174823] Dynamic subtest vecs1: SUCCESS (0.216s)
[269.186482] Starting dynamic subtest: ccs0
[269.386481] Dynamic subtest ccs0: SUCCESS (0.210s)
[269.388463] Subtest implicit-boths: SUCCESS (1.566s)
[269.834996] [029/131] (749s left) syncobj_wait (wait-any-interrupted)
[269.911582] Starting subtest: wait-any-interrupted
[270.014073] Subtest wait-any-interrupted: SUCCESS (0.101s)
[270.136480] [030/131] (749s left) gem_exec_reloc (basic-cpu-gtt-active)
[270.222691] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[270.318185] [031/131] (749s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[270.510760] Starting subtest: plane-all-transition-nonblocking-fencing
[270.512869] Starting dynamic subtest: pipe-A-DP-3
[274.235688] Dynamic subtest pipe-A-DP-3: SUCCESS (3.723s)
[274.325310] Starting dynamic subtest: pipe-B-DP-3
[278.082793] Dynamic subtest pipe-B-DP-3: SUCCESS (3.772s)
[278.136559] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (7.627s)
[278.392012] [032/131] (741s left) gem_shrink (reclaim)
[278.475411] Starting subtest: reclaim
[280.723467] Subtest reclaim: SUCCESS (2.248s)
[280.863516] [033/131] (738s left) gem_userptr_blits (userfault)
[280.986341] Starting subtest: userfault
[280.991102] Subtest userfault: SUCCESS (0.007s)
[281.189786] [034/131] (738s left) kms_vrr (negative-basic)
[281.391518] Starting subtest: negative-basic
[281.394119] Starting dynamic subtest: pipe-A-DP-3
[286.858829] Dynamic subtest pipe-A-DP-3: SUCCESS (5.464s)
[286.966676] Subtest negative-basic: SUCCESS (5.574s)
[287.234963] [035/131] (732s left) kms_vrr (seamless-rr-switch-virtual)
[287.428591] Starting subtest: seamless-rr-switch-virtual
[287.431347] Subtest seamless-rr-switch-virtual: SKIP (0.000s)
[287.520961] [036/131] (732s left) kms_pm_dc (dc6-dpms)
[288.722457] Starting subtest: dc6-dpms
[288.724255] Subtest dc6-dpms: SKIP (0.000s)
[288.821835] [037/131] (731s left) kms_chamelium_color (ctm-0-75)
[289.017603] Subtest ctm-0-75: SKIP (0.000s)
[289.080792] [038/131] (730s left) perf_pmu (rc6)
[289.152600] Starting subtest: rc6
[289.153869] Starting dynamic subtest: gt0
[295.520173] Dynamic subtest gt0: SUCCESS (6.366s)
[295.533758] Starting dynamic subtest: runtime-pm-gt0
[303.221053] Dynamic subtest runtime-pm-gt0: SUCCESS (7.696s)
[303.233125] Starting dynamic subtest: runtime-pm-long-gt0
[315.844964] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.617s)
[315.856733] Starting dynamic subtest: other-idle-gt0
[315.858486] Dynamic subtest other-idle-gt0: SKIP (0.000s)
[315.859374] Subtest rc6: SUCCESS (26.686s)
[316.857940] [039/131] (703s left) kms_busy (extended-modeset-hang-oldfb)
[317.057595] Starting subtest: extended-modeset-hang-oldfb
[317.059778] Starting dynamic subtest: pipe-A
[325.113856] Dynamic subtest pipe-A: SUCCESS (8.052s)
[325.137869] Starting dynamic subtest: pipe-D
[333.162921] Dynamic subtest pipe-D: SUCCESS (8.041s)
[333.164238] Subtest extended-modeset-hang-oldfb: SUCCESS (16.102s)
[333.388916] [040/131] (686s left) kms_ccs (random-ccs-data-y-tiled-gen12-mc-ccs)
[333.583658] Starting subtest: random-ccs-data-y-tiled-gen12-mc-ccs
[333.584651] Starting dynamic subtest: pipe-A-DP-3
[333.594356] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[333.607089] Starting dynamic subtest: pipe-B-DP-3
[333.617846] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[333.629840] Starting dynamic subtest: pipe-C-DP-3
[333.639738] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[333.652087] Starting dynamic subtest: pipe-D-DP-3
[333.663691] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[333.665749] Subtest random-ccs-data-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[333.988780] [041/131] (686s left) kms_psr (psr-sprite-mmap-gtt)
[334.185407] Subtest psr-sprite-mmap-gtt: SKIP (0.000s)
[334.238384] [042/131] (686s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[334.430592] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[334.432762] Starting dynamic subtest: pipe-A-DP-3
[334.454844] Dynamic subtest pipe-A-DP-3: SKIP (0.002s)
[334.466929] Starting dynamic subtest: pipe-B-DP-3
[334.489115] Dynamic subtest pipe-B-DP-3: SKIP (0.002s)
[334.501348] Starting dynamic subtest: pipe-C-DP-3
[334.526649] Dynamic subtest pipe-C-DP-3: SKIP (0.002s)
[334.538527] Starting dynamic subtest: pipe-D-DP-3
[334.563756] Dynamic subtest pipe-D-DP-3: SKIP (0.002s)
[334.565744] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.013s)
[334.803845] [043/131] (685s left) gem_ctx_param (set-priority-invalid-size)
[334.884756] Starting subtest: set-priority-invalid-size
[334.885694] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[334.964869] [044/131] (685s left) kms_rotation_crc (cursor-rotation-180)
[335.157591] Starting subtest: cursor-rotation-180
[335.953981] Subtest cursor-rotation-180: SUCCESS (0.795s)
[336.268821] [045/131] (684s left) kms_lease (lease-revoke)
[336.462583] Starting subtest: lease-revoke
[336.464735] Starting dynamic subtest: pipe-A-DP-3
[336.572430] Dynamic subtest pipe-A-DP-3: SUCCESS (0.108s)
[336.584375] Starting dynamic subtest: pipe-B-DP-3
[336.650425] Dynamic subtest pipe-B-DP-3: SUCCESS (0.076s)
[336.663269] Starting dynamic subtest: pipe-C-DP-3
[336.731516] Dynamic subtest pipe-C-DP-3: SUCCESS (0.079s)
[336.744056] Starting dynamic subtest: pipe-D-DP-3
[336.807452] Dynamic subtest pipe-D-DP-3: SUCCESS (0.074s)
[336.808264] Subtest lease-revoke: SUCCESS (0.343s)
[336.905608] [046/131] (683s left) gem_exec_flush (basic-uc-ro-default)
[336.990438] Subtest basic-uc-ro-default: SKIP (0.000s)
[337.142758] [047/131] (683s left) gem_exec_reloc (basic-write-read)
[337.227576] Subtest basic-write-read: SKIP (0.000s)
[337.316202] [048/131] (683s left) kms_flip (dpms-vs-vblank-race)
[337.511292] Starting subtest: dpms-vs-vblank-race
[337.515690] Starting dynamic subtest: A-DP3
[340.648079] Dynamic subtest A-DP3: SUCCESS (3.131s)
[340.660743] Starting dynamic subtest: B-DP3
[343.797683] Dynamic subtest B-DP3: SUCCESS (3.148s)
[343.812487] Starting dynamic subtest: C-DP3
[346.949681] Dynamic subtest C-DP3: SUCCESS (3.149s)
[346.967172] Starting dynamic subtest: D-DP3
[350.094554] Dynamic subtest D-DP3: SUCCESS (3.143s)
[350.095480] Subtest dpms-vs-vblank-race: SUCCESS (12.582s)
[350.297470] [049/131] (670s left) syncobj_timeline (reset-signaled)
[350.386617] Starting subtest: reset-signaled
[350.387546] Subtest reset-signaled: SUCCESS (0.000s)
[350.486493] [050/131] (670s left) kms_plane_scaling (planes-downscale-factor-0-25-unity-scaling)
[350.681743] Starting subtest: planes-downscale-factor-0-25-unity-scaling
[350.682617] Starting dynamic subtest: pipe-A
[351.374679] Dynamic subtest pipe-A: SKIP (0.690s)
[351.387003] Starting dynamic subtest: pipe-B
[352.423090] Dynamic subtest pipe-B: SKIP (1.047s)
[352.435585] Starting dynamic subtest: pipe-C
[353.471337] Dynamic subtest pipe-C: SKIP (1.047s)
[353.483565] Starting dynamic subtest: pipe-D
[354.516937] Dynamic subtest pipe-D: SKIP (1.045s)
[354.518455] Subtest planes-downscale-factor-0-25-unity-scaling: SKIP (3.834s)
[354.607255] [051/131] (666s left) kms_rotation_crc (sprite-rotation-180)
[354.808793] Starting subtest: sprite-rotation-180
[361.390158] Subtest sprite-rotation-180: SUCCESS (6.580s)
[361.758598] [052/131] (659s left) kms_plane_alpha_blend (alpha-basic)
[361.956791] Starting subtest: alpha-basic
[362.210560] Starting dynamic subtest: pipe-A-DP-3
[364.752802] Dynamic subtest pipe-A-DP-3: SUCCESS (2.540s)
[364.795470] Starting dynamic subtest: pipe-D-DP-3
[367.451503] Dynamic subtest pipe-D-DP-3: SUCCESS (2.666s)
[367.452489] Subtest alpha-basic: SUCCESS (5.494s)
[367.651638] [053/131] (653s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[367.733707] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[367.837458] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.103s)
[367.917418] [054/131] (653s left) gem_mmap_gtt (cpuset-medium-copy)
[367.996492] Subtest cpuset-medium-copy: SKIP (0.000s)
[368.079808] [055/131] (653s left) kms_psr (fbc-pr-suspend)
[368.275453] Subtest fbc-pr-suspend: SKIP (0.000s)
[368.343139] [056/131] (652s left) perf (sysctl-defaults)
[368.411590] Starting subtest: sysctl-defaults
[368.412533] Subtest sysctl-defaults: SUCCESS (0.000s)
[368.729810] [057/131] (652s left) syncobj_wait (single-wait-signaled)
[368.809593] Starting subtest: single-wait-signaled
[368.810516] Subtest single-wait-signaled: SUCCESS (0.000s)
[368.901955] [058/131] (652s left) gem_exec_balancer (persistence)
[369.269650] Starting subtest: persistence
[370.872689] Subtest persistence: SUCCESS (1.603s)
[370.979018] [059/131] (650s left) kms_flip (2x-plain-flip-ts-check)
[371.173293] Starting subtest: 2x-plain-flip-ts-check
[371.188685] Subtest 2x-plain-flip-ts-check: SKIP (0.015s)
[371.262639] [060/131] (650s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[371.465210] Starting subtest: psr-farfromfence-mmap-gtt
[371.466906] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[371.545447] [061/131] (649s left) kms_flip (2x-flip-vs-expired-vblank-interruptible)
[371.744207] Starting subtest: 2x-flip-vs-expired-vblank-interruptible
[371.759590] Subtest 2x-flip-vs-expired-vblank-interruptible: SKIP (0.014s)
[371.829472] [062/131] (649s left) perf (stress-open-close)
[372.007824] Starting subtest: stress-open-close
[372.008696] Starting dynamic subtest: 0-rcs0
[374.281417] Dynamic subtest 0-rcs0: SUCCESS (2.272s)
[374.287517] Subtest stress-open-close: SUCCESS (2.275s)
[374.401791] [063/131] (647s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-cpu)
[374.600284] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-cpu
[376.819204] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-cpu: SUCCESS (2.218s)
[376.958601] [064/131] (644s left) kms_hdr (static-toggle)
[377.160726] Starting subtest: static-toggle
[380.411366] Starting dynamic subtest: pipe-A-DP-3
[381.487332] Dynamic subtest pipe-A-DP-3: SUCCESS (1.075s)
[381.489085] Subtest static-toggle: SUCCESS (4.327s)
[381.789891] [065/131] (639s left) perf (polling)
[381.940612] Starting subtest: polling
[381.941465] Starting dynamic subtest: 0-rcs0
[391.965180] Dynamic subtest 0-rcs0: SUCCESS (10.023s)
[391.966292] Subtest polling: SUCCESS (10.024s)
[392.030443] [066/131] (629s left) kms_psr (pr-sprite-mmap-gtt)
[392.233537] Subtest pr-sprite-mmap-gtt: SKIP (0.000s)
[392.310520] [067/131] (629s left) gem_eio (context-create)
[392.634164] Starting subtest: context-create
[393.162404] Subtest context-create: SUCCESS (0.529s)
[393.337301] [068/131] (628s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[393.415641] Starting subtest: etime-multi-wait-all-available-unsubmitted
[393.517297] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.101s)
[393.632185] [069/131] (628s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[393.830864] Starting subtest: bo-too-small-due-to-tiling
[393.832621] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[393.928024] [070/131] (628s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[394.129759] Starting subtest: extended-pageflip-modeset-hang-oldfb
[394.132109] Starting dynamic subtest: pipe-A
[401.949572] Dynamic subtest pipe-A: SUCCESS (7.817s)
[401.964216] Starting dynamic subtest: pipe-D
[409.787104] Dynamic subtest pipe-D: SUCCESS (7.834s)
[409.788036] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (15.657s)
[409.985567] [071/131] (612s left) kms_cursor_crc (cursor-onscreen-64x64)
[410.320177] Starting subtest: cursor-onscreen-64x64
[410.324729] Starting dynamic subtest: pipe-A-DP-3
[413.090780] Dynamic subtest pipe-A-DP-3: SUCCESS (2.764s)
[413.140930] Starting dynamic subtest: pipe-D-DP-3
[415.813932] Dynamic subtest pipe-D-DP-3: SUCCESS (2.684s)
[415.814890] Subtest cursor-onscreen-64x64: SUCCESS (5.493s)
[416.210094] [072/131] (605s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-render)
[416.413517] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-render
[416.415370] Subtest fbc-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[416.537608] [073/131] (605s left) syncobj_timeline (invalid-query-bad-pad)
[416.615683] Starting subtest: invalid-query-bad-pad
[416.616606] Subtest invalid-query-bad-pad: SUCCESS (0.000s)
[416.739965] [074/131] (605s left) gem_exercise_blt (fast-copy)
[416.826037] Starting subtest: fast-copy
[416.826946] Starting dynamic subtest: linear-smem-smem
[416.873581] Dynamic subtest linear-smem-smem: SUCCESS (0.047s)
[416.887710] Starting dynamic subtest: linear-smem-lmem0
[416.891483] Dynamic subtest linear-smem-lmem0: SUCCESS (0.017s)
[416.905600] Starting dynamic subtest: linear-lmem0-smem
[416.996278] Dynamic subtest linear-lmem0-smem: SUCCESS (0.104s)
[417.009178] Starting dynamic subtest: linear-lmem0-lmem0
[417.104725] Dynamic subtest linear-lmem0-lmem0: SUCCESS (0.107s)
[417.117450] Starting dynamic subtest: xmajor-smem-smem
[417.122282] Dynamic subtest xmajor-smem-smem: SUCCESS (0.017s)
[417.136340] Starting dynamic subtest: xmajor-smem-lmem0
[417.139344] Dynamic subtest xmajor-smem-lmem0: SUCCESS (0.016s)
[417.153429] Starting dynamic subtest: xmajor-lmem0-smem
[417.236733] Dynamic subtest xmajor-lmem0-smem: SUCCESS (0.096s)
[417.248957] Starting dynamic subtest: xmajor-lmem0-lmem0
[417.329709] Dynamic subtest xmajor-lmem0-lmem0: SUCCESS (0.092s)
[417.342475] Starting dynamic subtest: tile4-smem-smem
[417.346985] Dynamic subtest tile4-smem-smem: SUCCESS (0.016s)
[417.361282] Starting dynamic subtest: tile4-smem-lmem0
[417.363796] Dynamic subtest tile4-smem-lmem0: SUCCESS (0.016s)
[417.377934] Starting dynamic subtest: tile4-lmem0-smem
[417.461859] Dynamic subtest tile4-lmem0-smem: SUCCESS (0.097s)
[417.474656] Starting dynamic subtest: tile4-lmem0-lmem0
[417.563122] Dynamic subtest tile4-lmem0-lmem0: SUCCESS (0.100s)
[417.575796] Starting dynamic subtest: tile64-smem-smem
[417.580456] Dynamic subtest tile64-smem-smem: SUCCESS (0.016s)
[417.594577] Starting dynamic subtest: tile64-smem-lmem0
[417.597558] Dynamic subtest tile64-smem-lmem0: SUCCESS (0.016s)
[417.611616] Starting dynamic subtest: tile64-lmem0-smem
[417.700072] Dynamic subtest tile64-lmem0-smem: SUCCESS (0.101s)
[417.714284] Starting dynamic subtest: tile64-lmem0-lmem0
[417.808068] Dynamic subtest tile64-lmem0-lmem0: SUCCESS (0.107s)
[417.809072] Subtest fast-copy: SUCCESS (0.983s)
[417.903555] [075/131] (604s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling)
[418.098833] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling
[418.101288] Starting dynamic subtest: pipe-A-valid-mode
[418.177629] Dynamic subtest pipe-A-valid-mode: SKIP (0.076s)
[418.179569] Subtest flip-64bpp-ytile-to-32bpp-ytilercccs-downscaling: SKIP (0.078s)
[418.327374] [076/131] (604s left) i915_selftest (perf)
[419.603989] Starting subtest: perf
[419.604938] Starting dynamic subtest: engine_cs
[421.177459] Dynamic subtest engine_cs: SUCCESS (1.573s)
[421.189394] Starting dynamic subtest: request
[425.860184] Dynamic subtest request: SUCCESS (4.681s)
[425.870158] Starting dynamic subtest: migrate
[427.591340] Dynamic subtest migrate: SUCCESS (1.730s)
[427.601575] Starting dynamic subtest: region
[455.925157] Dynamic subtest region: SUCCESS (28.331s)
[455.926239] Subtest perf: SUCCESS (36.321s)
[455.987216] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[455.988633] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[455.991241] [077/131] (566s left) gem_ctx_engines (none)
[457.338102] Starting subtest: none
[457.345132] Subtest none: SUCCESS (0.007s)
[457.568994] [FACT gem_ctx_engines (none)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[457.573429] [FACT gem_ctx_engines (none)] new: kernel.kmod_is_loaded.i915: true
[457.576786] [078/131] (565s left) syncobj_basic (bad-flags-fd-to-handle)
[457.656915] Starting subtest: bad-flags-fd-to-handle
[457.657783] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[457.753458] [079/131] (564s left) gem_mmap_offset (partial-remap)
[457.830629] Starting subtest: partial-remap
[457.831587] Starting dynamic subtest: lmem0
[457.839529] Dynamic subtest lmem0: SUCCESS (0.008s)
[457.853878] Starting dynamic subtest: smem0
[457.856288] Dynamic subtest smem0: SUCCESS (0.006s)
[457.857594] Subtest partial-remap: SUCCESS (0.016s)
[457.915407] [080/131] (564s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling)
[458.112818] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling
[458.115231] Starting dynamic subtest: pipe-A-valid-mode
[458.194589] Dynamic subtest pipe-A-valid-mode: SKIP (0.079s)
[458.196378] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.080s)
[458.387213] [081/131] (564s left) gem_pipe_control_store_loop (fresh-buffer)
[458.471650] Starting subtest: fresh-buffer
[460.649173] Subtest fresh-buffer: SUCCESS (2.178s)
[460.746859] [082/131] (562s left) gen3_render_mixed_blits
[460.895914] [083/131] (562s left) kms_pm_rpm (pm-tiling)
[463.224550] Starting subtest: pm-tiling
[463.227729] Subtest pm-tiling: SKIP (0.000s)
[463.507742] [084/131] (559s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[463.776811] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[463.925571] [085/131] (559s left) sysfs_preempt_timeout (timeout)
[464.011651] Starting subtest: timeout
[464.012543] Starting dynamic subtest: vecs0
[466.019292] Dynamic subtest vecs0: SUCCESS (2.007s)
[466.030833] Starting dynamic subtest: ccs0
[467.819015] Dynamic subtest ccs0: SUCCESS (1.799s)
[467.835776] Starting dynamic subtest: vcs0
[469.533551] Dynamic subtest vcs0: SUCCESS (1.712s)
[469.545268] Starting dynamic subtest: bcs0
[471.274554] Dynamic subtest bcs0: SUCCESS (1.740s)
[471.286509] Starting dynamic subtest: vecs1
[472.992334] Dynamic subtest vecs1: SUCCESS (1.717s)
[473.003750] Starting dynamic subtest: rcs0
[474.712357] Dynamic subtest rcs0: SUCCESS (1.719s)
[474.724433] Starting dynamic subtest: vcs1
[476.425497] Dynamic subtest vcs1: SUCCESS (1.712s)
[476.426405] Subtest timeout: SUCCESS (12.415s)
[476.523548] [086/131] (546s left) kms_psr (fbc-psr-suspend)
[476.719281] Subtest fbc-psr-suspend: SKIP (0.000s)
[476.783431] [087/131] (546s left) gem_busy (close-race)
[476.876552] Starting subtest: close-race
[499.106061] Subtest close-race: SUCCESS (22.230s)
[499.620052] [088/131] (523s left) gem_create (create-clear)
[499.744548] Starting subtest: create-clear
[499.745612] Starting dynamic subtest: lmem0
[534.760316] Dynamic subtest lmem0: SUCCESS (35.009s)
[534.775005] Starting dynamic subtest: smem0
[568.479155] Dynamic subtest smem0: SUCCESS (33.715s)
[568.480132] Subtest create-clear: SUCCESS (68.727s)
[568.989550] [089/131] (454s left) syncobj_wait (invalid-reset-bad-pad)
[569.100121] Starting subtest: invalid-reset-bad-pad
[569.101058] Subtest invalid-reset-bad-pad: SUCCESS (0.000s)
[569.189211] [090/131] (454s left) syncobj_timeline (transfer-timeline-point)
[569.283475] Starting subtest: transfer-timeline-point
[569.284545] Subtest transfer-timeline-point: SUCCESS (0.000s)
[569.440123] [091/131] (453s left) kms_frontbuffer_tracking (fbc-modesetfrombusy)
[569.642694] Starting subtest: fbc-modesetfrombusy
[570.851472] Subtest fbc-modesetfrombusy: SUCCESS (1.210s)
[571.009033] [092/131] (452s left) api_intel_allocator (default-alignment)
[571.091576] Starting subtest: default-alignment
[571.097407] Subtest default-alignment: SUCCESS (0.006s)
[571.230488] [093/131] (452s left) gem_lmem_swapping (heavy-verify-multi-ccs)
[573.883166] Starting subtest: heavy-verify-multi-ccs
[573.884048] Starting dynamic subtest: lmem0
[586.426665] Dynamic subtest lmem0: SUCCESS (12.542s)
[586.427656] Subtest heavy-verify-multi-ccs: SUCCESS (12.543s)
[587.750474] [FACT gem_lmem_swapping (heavy-verify-multi-ccs)] deleted: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[587.751459] [FACT gem_lmem_swapping (heavy-verify-multi-ccs)] deleted: kernel.kmod_is_loaded.i915: true
[587.753345] [094/131] (435s left) kms_dirtyfb (drrs-dirtyfb-ioctl)
[589.228984] Starting subtest: drrs-dirtyfb-ioctl
[589.234140] Subtest drrs-dirtyfb-ioctl: SKIP (0.001s)
[589.320205] [FACT kms_dirtyfb (drrs-dirtyfb-ioctl)] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[589.323803] [FACT kms_dirtyfb (drrs-dirtyfb-ioctl)] new: kernel.kmod_is_loaded.i915: true
[589.326786] [095/131] (434s left) kms_color (ctm-negative)
[589.524739] Starting subtest: ctm-negative
[589.525675] Starting dynamic subtest: pipe-A-DP-3
[590.236375] Dynamic subtest pipe-A-DP-3: SUCCESS (0.708s)
[590.250491] Starting dynamic subtest: pipe-B-DP-3
[590.838686] Dynamic subtest pipe-B-DP-3: SUCCESS (0.599s)
[590.856432] Starting dynamic subtest: pipe-C-DP-3
[591.397793] Dynamic subtest pipe-C-DP-3: SUCCESS (0.559s)
[591.411351] Starting dynamic subtest: pipe-D-DP-3
[591.985606] Dynamic subtest pipe-D-DP-3: SUCCESS (0.587s)
[591.986538] Subtest ctm-negative: SUCCESS (2.460s)
[592.188003] [096/131] (431s left) kms_big_fb (yf-tiled-8bpp-rotate-270)
[592.397769] Starting subtest: yf-tiled-8bpp-rotate-270
[592.399485] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s)
[592.483935] [097/131] (431s left) kms_frontbuffer_tracking (psr-suspend)
[592.684535] Starting subtest: psr-suspend
[592.686314] Subtest psr-suspend: SKIP (0.000s)
[592.765395] [098/131] (431s left) gem_exec_schedule (semaphore-power)
[592.979103] Subtest semaphore-power: SKIP (0.000s)
[593.165579] [099/131] (430s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-gtt)
[593.372393] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-gtt
[593.374129] Subtest psr-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[593.448571] [100/131] (430s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[593.640711] Starting subtest: plane-primary-overlay-mutable-zpos
[595.667020] Subtest plane-primary-overlay-mutable-zpos: SKIP (2.024s)
[595.932103] [101/131] (428s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[596.016998] Starting subtest: y-tiled-to-vebox-x-tiled
[596.018969] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[596.185035] [102/131] (427s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[596.392501] Starting subtest: x-tiled-32bpp-rotate-270
[596.445876] Subtest x-tiled-32bpp-rotate-270: SKIP (0.053s)
[596.606139] [103/131] (427s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset)
[596.799598] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset
[596.814668] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset: SKIP (0.015s)
[596.877873] [104/131] (427s left) gem_eio (in-flight-contexts-1us)
[597.174271] Starting subtest: in-flight-contexts-1us
[611.066504] Subtest in-flight-contexts-1us: SUCCESS (13.892s)
[611.246580] [105/131] (412s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[611.445772] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[611.446660] Starting dynamic subtest: pipe-A
[611.545771] Dynamic subtest pipe-A: SUCCESS (0.099s)
[611.574625] Starting dynamic subtest: pipe-B
[611.760435] Dynamic subtest pipe-B: SUCCESS (0.213s)
[611.783140] Starting dynamic subtest: pipe-C
[611.977430] Dynamic subtest pipe-C: SUCCESS (0.215s)
[612.000032] Starting dynamic subtest: pipe-D
[612.192683] Dynamic subtest pipe-D: SUCCESS (0.214s)
[612.193733] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (0.748s)
[612.441315] [106/131] (411s left) kms_psr (fbc-pr-primary-mmap-gtt)
[612.641338] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s)
[612.708436] [107/131] (411s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[613.046144] Starting subtest: cursor-rapid-movement-64x64
[613.051645] Starting dynamic subtest: pipe-A-DP-3
[613.490442] Dynamic subtest pipe-A-DP-3: SUCCESS (0.437s)
[613.542454] Starting dynamic subtest: pipe-D-DP-3
[613.918194] Dynamic subtest pipe-D-DP-3: SUCCESS (0.388s)
[613.919316] Subtest cursor-rapid-movement-64x64: SUCCESS (0.872s)
[614.294122] [108/131] (410s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs)
[614.488758] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs
[614.491130] Starting dynamic subtest: pipe-A-DP-3
[614.499740] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[614.512590] Starting dynamic subtest: pipe-B-DP-3
[614.521381] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[614.533847] Starting dynamic subtest: pipe-C-DP-3
[614.542342] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[614.554978] Starting dynamic subtest: pipe-D-DP-3
[614.565574] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[614.567561] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.007s)
[614.862869] [109/131] (409s left) gem_ctx_shared (create-shared-gtt)
[614.953015] Starting subtest: create-shared-gtt
[617.103465] Subtest create-shared-gtt: SUCCESS (2.150s)
[619.684215] [110/131] (404s left) kms_content_protection (lic-type-0)
[619.946840] Starting subtest: lic-type-0
[619.981620] Starting dynamic subtest: pipe-A-DP-3
[743.884750] Dynamic subtest pipe-A-DP-3: FAIL (123.722s)
[743.885772] Subtest lic-type-0: FAIL (123.860s)
[744.009141] [111/131] (280s left) kms_addfb_basic (master-rmfb)
[744.089160] Starting subtest: master-rmfb
[744.104599] Subtest master-rmfb: SUCCESS (0.017s)
[744.331736] [112/131] (280s left) kms_dirtyfb (default-dirtyfb-ioctl)
[744.533945] Starting subtest: default-dirtyfb-ioctl
[744.536503] Starting dynamic subtest: A-DP-3
[745.978965] Dynamic subtest A-DP-3: SUCCESS (1.443s)
[745.979860] Subtest default-dirtyfb-ioctl: SUCCESS (1.445s)
[746.169386] [113/131] (278s left) dumb_buffer (invalid-bpp)
[746.251688] Starting subtest: invalid-bpp
[746.252621] Subtest invalid-bpp: SUCCESS (0.000s)
[746.386414] [114/131] (278s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[746.462593] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[746.463628] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[746.562259] [115/131] (278s left) api_intel_bb (simple-bb)
[746.637644] Starting subtest: simple-bb
[746.666541] Subtest simple-bb: SUCCESS (0.029s)
[746.812590] [116/131] (278s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[747.011399] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[747.013192] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[747.106688] [117/131] (277s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-render)
[747.317331] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-render
[747.319259] Subtest psr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[747.401706] [118/131] (277s left) kms_vblank (query-forked-hang)
[747.604776] Starting subtest: query-forked-hang
[747.607184] Starting dynamic subtest: pipe-A-DP-3
[773.708316] Dynamic subtest pipe-A-DP-3: SUCCESS (26.101s)
[773.725231] Starting dynamic subtest: pipe-D-DP-3
[798.732510] Dynamic subtest pipe-D-DP-3: SUCCESS (25.020s)
[798.733420] Subtest query-forked-hang: SUCCESS (51.127s)
[798.924570] [119/131] (226s left) gem_pxp (protected-raw-src-copy-not-readible)
[801.533422] Starting subtest: protected-raw-src-copy-not-readible
[801.535358] Subtest protected-raw-src-copy-not-readible: SKIP (0.000s)
[801.601037] [120/131] (223s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[801.678491] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[801.747716] [121/131] (223s left) prime_vgem (coherency-gtt)
[801.835349] Starting subtest: coherency-gtt
[801.837466] Subtest coherency-gtt: SKIP (0.000s)
[801.917349] [122/131] (223s left) gem_ctx_persistence (heartbeat-stop)
[802.004732] Starting subtest: heartbeat-stop
[802.006828] Subtest heartbeat-stop: SKIP (0.000s)
[802.119822] [123/131] (223s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[802.317444] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[802.319253] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[802.400428] [124/131] (222s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[802.609316] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip
[803.867560] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.257s)
[804.004994] [125/131] (221s left) gem_exec_reloc (basic-wc-cpu)
[804.091658] Subtest basic-wc-cpu: SKIP (0.000s)
[804.183891] [126/131] (221s left) gem_exec_gttfill (multigpu-basic)
[804.381054] Starting subtest: multigpu-basic
[819.629859] Subtest multigpu-basic: SUCCESS (15.248s)
[819.880061] [127/131] (205s left) kms_prop_blob (invalid-get-prop)
[819.997594] Starting subtest: invalid-get-prop
[819.998532] Subtest invalid-get-prop: SUCCESS (0.000s)
[820.090692] [128/131] (205s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[820.298905] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[820.300615] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[820.385621] [129/131] (205s left) kms_psr (psr-primary-mmap-cpu)
[820.583481] Subtest psr-primary-mmap-cpu: SKIP (0.000s)
[820.648278] [130/131] (205s left) perf_pmu (enable-race)
[820.721836] Starting subtest: enable-race
[820.722686] Starting dynamic subtest: rcs0
[833.500843] Dynamic subtest rcs0: SUCCESS (12.778s)
[833.514702] Starting dynamic subtest: bcs0
[846.242737] Dynamic subtest bcs0: SUCCESS (12.741s)
[846.256992] Starting dynamic subtest: vcs0
[858.986773] Dynamic subtest vcs0: SUCCESS (12.743s)
[859.000196] Starting dynamic subtest: vcs1
[871.729788] Dynamic subtest vcs1: SUCCESS (12.742s)
[871.743146] Starting dynamic subtest: vecs0
[884.470803] Dynamic subtest vecs0: SUCCESS (12.740s)
[884.484199] Starting dynamic subtest: vecs1
[897.211811] Dynamic subtest vecs1: SUCCESS (12.740s)
[897.225469] Starting dynamic subtest: ccs0
[909.955816] Dynamic subtest ccs0: SUCCESS (12.743s)
[909.956723] Subtest enable-race: SUCCESS (89.233s)
[910.068836] [131/131] (115s left) gem_render_copy (y-tiled-ccs-to-y-tiled-ccs)
[910.155008] Starting subtest: y-tiled-ccs-to-y-tiled-ccs
[910.157394] Subtest y-tiled-ccs-to-y-tiled-ccs: SKIP (0.000s)
[910.330997] Closing watchdogs
results: parsing output: 0/ for test: gem_flink_basic
results: parsing output: 1/ for test: kms_plane
results: parsing output: 2/ for test: gem_exec_fence
results: parsing output: 3/ for test: i915_pm_rpm
results: parsing output: 4/ for test: kms_big_fb
results: parsing output: 5/ for test: i915_hangman
results: parsing output: 6/ for test: kms_feature_discovery
results: parsing output: 7/ for test: gen7_exec_parse
results: parsing output: 8/ for test: kms_cursor_legacy
results: parsing output: 9/ for test: gem_eio
results: parsing output: 10/ for test: api_intel_bb
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: kms_frontbuffer_tracking
results: parsing output: 14/ for test: gem_ctx_param
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: i915_pm_rpm
results: parsing output: 17/ for test: kms_frontbuffer_tracking
results: parsing output: 18/ for test: kms_psr2_sf
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: gem_mmap_gtt
results: parsing output: 22/ for test: gem_exec_store
results: parsing output: 23/ for test: kms_ccs
results: parsing output: 24/ for test: template
results: parsing output: 25/ for test: i915_drm_fdinfo
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: gem_exec_schedule
results: parsing output: 28/ for test: syncobj_wait
results: parsing output: 29/ for test: gem_exec_reloc
results: parsing output: 30/ for test: kms_atomic_transition
results: parsing output: 31/ for test: gem_shrink
results: parsing output: 32/ for test: gem_userptr_blits
results: parsing output: 33/ for test: kms_vrr
results: parsing output: 34/ for test: kms_vrr
results: parsing output: 35/ for test: kms_pm_dc
results: parsing output: 36/ for test: kms_chamelium_color
results: parsing output: 37/ for test: perf_pmu
results: parsing output: 38/ for test: kms_busy
results: parsing output: 39/ for test: kms_ccs
results: parsing output: 40/ for test: kms_psr
results: parsing output: 41/ for test: kms_ccs
results: parsing output: 42/ for test: gem_ctx_param
results: parsing output: 43/ for test: kms_rotation_crc
results: parsing output: 44/ for test: kms_lease
results: parsing output: 45/ for test: gem_exec_flush
results: parsing output: 46/ for test: gem_exec_reloc
results: parsing output: 47/ for test: kms_flip
results: parsing output: 48/ for test: syncobj_timeline
results: parsing output: 49/ for test: kms_plane_scaling
results: parsing output: 50/ for test: kms_rotation_crc
results: parsing output: 51/ for test: kms_plane_alpha_blend
results: parsing output: 52/ for test: syncobj_wait
results: parsing output: 53/ for test: gem_mmap_gtt
results: parsing output: 54/ for test: kms_psr
results: parsing output: 55/ for test: perf
results: parsing output: 56/ for test: syncobj_wait
results: parsing output: 57/ for test: gem_exec_balancer
results: parsing output: 58/ for test: kms_flip
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_flip
results: parsing output: 61/ for test: perf
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_hdr
results: parsing output: 64/ for test: perf
results: parsing output: 65/ for test: kms_psr
results: parsing output: 66/ for test: gem_eio
results: parsing output: 67/ for test: syncobj_timeline
results: parsing output: 68/ for test: kms_addfb_basic
results: parsing output: 69/ for test: kms_busy
results: parsing output: 70/ for test: kms_cursor_crc
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: syncobj_timeline
results: parsing output: 73/ for test: gem_exercise_blt
results: parsing output: 74/ for test: kms_flip_scaled_crc
results: parsing output: 75/ for test: i915_selftest
results: parsing output: 76/ for test: gem_ctx_engines
results: parsing output: 77/ for test: syncobj_basic
results: parsing output: 78/ for test: gem_mmap_offset
results: parsing output: 79/ for test: kms_flip_scaled_crc
results: parsing output: 80/ for test: gem_pipe_control_store_loop
results: parsing output: 81/ for test: gen3_render_mixed_blits
results: parsing output: 82/ for test: kms_pm_rpm
results: parsing output: 83/ for test: kms_chamelium_hpd
results: parsing output: 84/ for test: sysfs_preempt_timeout
results: parsing output: 85/ for test: kms_psr
results: parsing output: 86/ for test: gem_busy
results: parsing output: 87/ for test: gem_create
results: parsing output: 88/ for test: syncobj_wait
results: parsing output: 89/ for test: syncobj_timeline
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: api_intel_allocator
results: parsing output: 92/ for test: gem_lmem_swapping
results: parsing output: 93/ for test: kms_dirtyfb
results: parsing output: 94/ for test: kms_color
results: parsing output: 95/ for test: kms_big_fb
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: gem_exec_schedule
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_atomic
results: parsing output: 100/ for test: gem_render_copy
results: parsing output: 101/ for test: kms_big_fb
results: parsing output: 102/ for test: kms_flip
results: parsing output: 103/ for test: gem_eio
results: parsing output: 104/ for test: kms_plane_scaling
results: parsing output: 105/ for test: kms_psr
results: parsing output: 106/ for test: kms_cursor_crc
results: parsing output: 107/ for test: kms_ccs
results: parsing output: 108/ for test: gem_ctx_shared
results: parsing output: 109/ for test: kms_content_protection
results: parsing output: 110/ for test: kms_addfb_basic
results: parsing output: 111/ for test: kms_dirtyfb
results: parsing output: 112/ for test: dumb_buffer
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: api_intel_bb
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_frontbuffer_tracking
results: parsing output: 117/ for test: kms_vblank
results: parsing output: 118/ for test: gem_pxp
results: parsing output: 119/ for test: gem_mmap_gtt
results: parsing output: 120/ for test: prime_vgem
results: parsing output: 121/ for test: gem_ctx_persistence
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_big_fb
results: parsing output: 124/ for test: gem_exec_reloc
results: parsing output: 125/ for test: gem_exec_gttfill
results: parsing output: 126/ for test: kms_prop_blob
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_psr
results: parsing output: 129/ for test: perf_pmu
results: parsing output: 130/ for test: gem_render_copy
Done.