[57.493059] Initializing watchdogs
[57.493111]   /dev/watchdog0
[57.508440] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[57.512917] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.515307] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.518722] [001/131] (960s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled)
[57.602973] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[57.605336] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[57.723882] [002/131] (960s left) gem_ccs (block-copy-compressed)
[57.787949] Starting subtest: block-copy-compressed
[57.792881] Subtest block-copy-compressed: SKIP (0.000s)
[57.918650] [003/131] (960s left) gem_ctx_param (invalid-param-get)
[57.980159] Starting subtest: invalid-param-get
[57.982487] Subtest invalid-param-get: SUCCESS (0.001s)
[58.125918] [004/131] (960s left) api_intel_bb (crc32)
[58.192060] Starting subtest: crc32
[58.194101] Starting dynamic subtest: rcs0-smem0
[58.486070] Dynamic subtest rcs0-smem0: SUCCESS (0.291s)
[58.496557] Starting dynamic subtest: bcs0-smem0
[58.796578] Dynamic subtest bcs0-smem0: SUCCESS (0.306s)
[58.807181] Starting dynamic subtest: vcs0-smem0
[59.169715] Dynamic subtest vcs0-smem0: SUCCESS (0.369s)
[59.180214] Starting dynamic subtest: vcs1-smem0
[59.535288] Dynamic subtest vcs1-smem0: SUCCESS (0.360s)
[59.543056] Starting dynamic subtest: vecs0-smem0
[59.878452] Dynamic subtest vecs0-smem0: SUCCESS (0.339s)
[59.886850] Starting dynamic subtest: ccs0-smem0
[60.202138] Dynamic subtest ccs0-smem0: SUCCESS (0.320s)
[60.204840] Subtest crc32: SUCCESS (1.994s)
[60.367697] [005/131] (957s left) gem_pxp (reject-modify-context-protection-on)
[60.507608] Starting subtest: reject-modify-context-protection-on
[60.510220] Subtest reject-modify-context-protection-on: SUCCESS (0.002s)
[60.633202] [006/131] (957s left) kms_big_fb (yf-tiled-addfb-size-offset-overflow)
[60.742861] Starting subtest: yf-tiled-addfb-size-offset-overflow
[60.747453] Subtest yf-tiled-addfb-size-offset-overflow: SKIP (0.000s)
[60.874216] [007/131] (957s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[60.984796] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[60.989220] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[61.124803] [008/131] (957s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset-interruptible)
[61.227970] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset-interruptible
[61.230698] Starting dynamic subtest: A-eDP1
[64.837820] Dynamic subtest A-eDP1: SUCCESS (3.588s)
[64.846659] Starting dynamic subtest: B-eDP1
[68.038800] Dynamic subtest B-eDP1: SUCCESS (3.190s)
[68.048213] Starting dynamic subtest: C-eDP1
[71.414490] Dynamic subtest C-eDP1: SUCCESS (3.368s)
[71.424337] Starting dynamic subtest: D-eDP1
[74.525490] Dynamic subtest D-eDP1: SUCCESS (3.107s)
[74.527963] Subtest single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (13.259s)
[75.352191] [009/131] (942s left) kms_chamelium_edid (dp-edid-resolution-list)
[75.758683] Subtest dp-edid-resolution-list: SKIP (0.000s)
[76.545565] [010/131] (941s left) gem_exec_balancer (nohangcheck)
[76.808274] Starting subtest: nohangcheck
[77.698825] Subtest nohangcheck: SUCCESS (0.890s)
[77.843569] [011/131] (940s left) gem_eio (in-flight-contexts-10ms)
[78.036780] Starting subtest: in-flight-contexts-10ms
[91.963054] Subtest in-flight-contexts-10ms: SUCCESS (13.918s)
[92.151496] [012/131] (926s left) gem_madvise (dontneed-before-mmap)
[92.193333] Starting subtest: dontneed-before-mmap
[92.206821] Subtest dontneed-before-mmap: SUCCESS (0.017s)
[92.346350] [013/131] (926s left) kms_flip (flip-vs-rmfb-interruptible)
[92.440969] Starting subtest: flip-vs-rmfb-interruptible
[92.443305] Starting dynamic subtest: A-eDP1
[101.057380] Dynamic subtest A-eDP1: SUCCESS (8.613s)
[101.067193] Starting dynamic subtest: B-eDP1
[109.694748] Dynamic subtest B-eDP1: SUCCESS (8.634s)
[109.704535] Starting dynamic subtest: C-eDP1
[118.307366] Dynamic subtest C-eDP1: SUCCESS (8.609s)
[118.320028] Starting dynamic subtest: D-eDP1
[126.937998] Dynamic subtest D-eDP1: SUCCESS (8.626s)
[126.943366] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.496s)
[128.160279] [014/131] (890s left) kms_psr (pr-sprite-mmap-cpu)
[128.259113] Starting subtest: pr-sprite-mmap-cpu
[128.263635] Subtest pr-sprite-mmap-cpu: SKIP (0.000s)
[128.356263] [015/131] (890s left) gem_softpin (evict-active-interruptible)
[128.427830] Starting subtest: evict-active-interruptible
[128.435193] Subtest evict-active-interruptible: SUCCESS (0.007s)
[128.606434] [016/131] (890s left) kms_async_flips (async-flip-hang)
[128.702721] Starting subtest: async-flip-hang
[129.086692] Starting dynamic subtest: pipe-A-eDP-1
[155.385660] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.295s)
[155.763521] Starting dynamic subtest: pipe-B-eDP-1
[171.380879] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.620s)
[171.772036] Starting dynamic subtest: pipe-C-eDP-1
[187.378543] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.608s)
[187.764675] Starting dynamic subtest: pipe-D-eDP-1
[203.379130] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.617s)
[203.381832] Subtest async-flip-hang: SUCCESS (74.672s)
[204.558120] [017/131] (814s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move)
[204.658719] Starting subtest: fbc-2p-scndscrn-cur-indfb-move
[204.663171] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[204.779151] [018/131] (813s left) kms_vblank (query-busy-hang)
[204.878975] Starting subtest: query-busy-hang
[204.881288] Starting dynamic subtest: pipe-A-eDP-1
[232.665039] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.782s)
[232.679187] Starting dynamic subtest: pipe-D-eDP-1
[257.693432] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.024s)
[257.695336] Subtest query-busy-hang: SUCCESS (52.811s)
[258.526169] [019/131] (760s left) gem_exec_whisper (basic-contexts-forked-all)
[258.601080] Starting subtest: basic-contexts-forked-all
[280.910467] Subtest basic-contexts-forked-all: SUCCESS (22.304s)
[281.116905] [020/131] (737s left) kms_atomic (plane-cursor-legacy)
[281.214020] Starting subtest: plane-cursor-legacy
[281.216349] Starting dynamic subtest: pipe-A-eDP-1
[281.609061] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.393s)
[281.611347] Subtest plane-cursor-legacy: SUCCESS (0.395s)
[282.457515] [021/131] (736s left) kms_psr (psr-sprite-plane-onoff)
[282.554863] Starting subtest: psr-sprite-plane-onoff
[282.557125] Starting dynamic subtest: eDP-1
[284.369690] Dynamic subtest eDP-1: SUCCESS (1.816s)
[284.372000] Subtest psr-sprite-plane-onoff: SUCCESS (1.817s)
[285.207706] [022/131] (733s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[285.307163] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[285.309423] Starting dynamic subtest: pipe-A-eDP-1
[285.334608] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[285.344794] Starting dynamic subtest: pipe-B-eDP-1
[285.368394] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[285.377145] Starting dynamic subtest: pipe-C-eDP-1
[285.401195] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[285.411186] Starting dynamic subtest: pipe-D-eDP-1
[285.434655] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[285.438728] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[287.575515] [023/131] (731s left) kms_ccs (crc-primary-suspend-y-tiled-ccs)
[287.679092] Starting subtest: crc-primary-suspend-y-tiled-ccs
[287.681370] Starting dynamic subtest: pipe-A-eDP-1
[287.690131] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[287.699250] Starting dynamic subtest: pipe-B-eDP-1
[287.708098] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[287.716783] Starting dynamic subtest: pipe-C-eDP-1
[287.725604] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[287.733781] Starting dynamic subtest: pipe-D-eDP-1
[287.742064] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[287.746135] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.005s)
[289.846566] [024/131] (729s left) kms_invalid_mode (bad-htotal)
[289.944979] Starting subtest: bad-htotal
[289.947214] Starting dynamic subtest: pipe-A-eDP-1
[290.228988] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.282s)
[290.237679] Starting dynamic subtest: pipe-B-eDP-1
[290.239646] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[290.247794] Starting dynamic subtest: pipe-C-eDP-1
[290.249719] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[290.258182] Starting dynamic subtest: pipe-D-eDP-1
[290.260326] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[290.262534] Subtest bad-htotal: SUCCESS (0.288s)
[291.077912] [025/131] (727s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[291.182382] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt
[291.186795] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[291.314812] [026/131] (727s left) perf (non-zero-reason)
[291.443335] Starting subtest: non-zero-reason
[291.445277] Starting dynamic subtest: 0-rcs0
[296.883806] Dynamic subtest 0-rcs0: SUCCESS (5.440s)
[296.897643] Starting dynamic subtest: 1-vcs1
[300.791577] Dynamic subtest 1-vcs1: SUCCESS (3.907s)
[300.794491] Subtest non-zero-reason: SUCCESS (9.349s)
[300.832063] [027/131] (718s left) kms_addfb_basic (addfb25-modifier-no-flag)
[300.942770] Starting subtest: addfb25-modifier-no-flag
[300.944629] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[301.089913] [028/131] (717s left) kms_frontbuffer_tracking (psr-rgb101010-draw-render)
[301.200572] Starting subtest: psr-rgb101010-draw-render
[308.483724] Subtest psr-rgb101010-draw-render: SUCCESS (7.284s)
[308.632622] [029/131] (710s left) gem_flink_basic (basic)
[308.690460] Starting subtest: basic
[308.692657] Subtest basic: SUCCESS (0.000s)
[308.820967] [030/131] (710s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[308.924498] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt
[308.928639] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[309.060447] [031/131] (710s left) gem_pxp (create-regular-context-2)
[309.127431] Starting subtest: create-regular-context-2
[309.129783] Subtest create-regular-context-2: SUCCESS (0.001s)
[309.252724] [032/131] (709s left) sysfs_timeslice_duration (duration)
[309.312087] Starting subtest: duration
[309.314739] Starting dynamic subtest: vecs0
[323.829666] Dynamic subtest vecs0: SUCCESS (14.514s)
[323.841896] Starting dynamic subtest: ccs0
[336.996082] Dynamic subtest ccs0: SUCCESS (13.165s)
[337.011996] Starting dynamic subtest: vcs0
[351.797629] Dynamic subtest vcs0: SUCCESS (14.796s)
[351.809152] Starting dynamic subtest: bcs0
[364.952311] Dynamic subtest bcs0: SUCCESS (13.152s)
[364.964207] Starting dynamic subtest: rcs0
[378.127645] Dynamic subtest rcs0: SUCCESS (13.172s)
[378.140982] Starting dynamic subtest: vcs1
[391.861324] Dynamic subtest vcs1: SUCCESS (13.729s)
[391.864079] Subtest duration: SUCCESS (82.545s)
[391.961620] [033/131] (627s left) perf (polling)
[392.075415] Starting subtest: polling
[392.077816] Starting dynamic subtest: 0-rcs0
[402.084288] Dynamic subtest 0-rcs0: SUCCESS (10.007s)
[402.093218] Starting dynamic subtest: 1-vcs0
[412.105290] Dynamic subtest 1-vcs0: SUCCESS (10.019s)
[412.108065] Subtest polling: SUCCESS (20.028s)
[412.153665] [034/131] (607s left) kms_psr (fbc-psr2-primary-blt)
[412.249948] Starting subtest: fbc-psr2-primary-blt
[412.252267] Starting dynamic subtest: eDP-1
[412.256308] Dynamic subtest eDP-1: SKIP (0.000s)
[412.260349] Subtest fbc-psr2-primary-blt: SKIP (0.001s)
[412.347533] [035/131] (606s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[412.452234] Starting subtest: bo-too-small-due-to-tiling
[412.456382] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[412.595303] [036/131] (606s left) kms_cursor_crc (cursor-offscreen-32x10)
[412.745642] Starting subtest: cursor-offscreen-32x10
[412.792237] Subtest cursor-offscreen-32x10: SKIP (0.041s)
[413.107515] [037/131] (606s left) gem_ctx_param (invalid-get-ringsize)
[413.167996] Starting subtest: invalid-get-ringsize
[413.170082] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[413.308284] [038/131] (606s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite)
[413.410142] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite
[422.005861] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.595s)
[422.174895] [039/131] (597s left) gem_set_tiling_vs_blt (untiled-to-tiled)
[422.242353] Subtest untiled-to-tiled: SKIP (0.000s)
[422.338371] [040/131] (597s left) gem_ctx_create (basic)
[422.404586] Starting subtest: basic
[422.406825] Subtest basic: SUCCESS (0.000s)
[422.607169] [041/131] (596s left) syncobj_wait (single-wait-for-submit-unsubmitted)
[422.677311] Starting subtest: single-wait-for-submit-unsubmitted
[422.780265] Subtest single-wait-for-submit-unsubmitted: SUCCESS (0.103s)
[422.879039] [042/131] (596s left) kms_fb_coherency (memset-crc)
[422.981153] Starting subtest: memset-crc
[422.983068] Starting dynamic subtest: mmap-offset-wc
[423.659796] Dynamic subtest mmap-offset-wc: CRASH (0.146s)
[424.133756] Subtest memset-crc: CRASH (0.625s)
[424.169676] [043/131] (595s left) kms_pm_dc (dc3co-vpb-simulation)
[425.280635] Starting subtest: dc3co-vpb-simulation
[433.829291] Subtest dc3co-vpb-simulation: SKIP (8.544s)
[434.011192] [044/131] (585s left) gem_create (create-ext-cpu-access-sanity-check)
[434.177796] Starting subtest: create-ext-cpu-access-sanity-check
[434.182547] Subtest create-ext-cpu-access-sanity-check: SKIP (0.001s)
[434.274392] [045/131] (585s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs)
[434.366997] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs
[434.369201] Starting dynamic subtest: pipe-A-eDP-1
[434.389872] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[434.399926] Starting dynamic subtest: pipe-B-eDP-1
[434.418917] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[434.426870] Starting dynamic subtest: pipe-C-eDP-1
[434.445151] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[434.453061] Starting dynamic subtest: pipe-D-eDP-1
[434.471138] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[434.472841] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.008s)
[436.567540] [046/131] (583s left) gem_lmem_swapping (smem-oom)
[436.607050] Subtest smem-oom: SKIP (0.000s)
[436.660682] [047/131] (583s left) perf (polling-small-buf)
[436.751876] Starting subtest: polling-small-buf
[436.841072] Subtest polling-small-buf: SUCCESS (0.086s)
[436.885925] [048/131] (582s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc)
[436.990178] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc
[436.994167] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[437.120660] [049/131] (582s left) i915_pm_rps (fence-order)
[437.185052] Starting subtest: fence-order
[440.058184] Subtest fence-order: SUCCESS (2.871s)
[440.213257] [050/131] (579s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible)
[440.311096] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible
[440.323217] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.011s)
[440.453900] [051/131] (579s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[445.512777] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[445.515220] Starting dynamic subtest: pipe-A-eDP-1
[446.299291] Dynamic subtest pipe-A-eDP-1: SKIP (0.782s)
[446.309331] Starting dynamic subtest: pipe-B-eDP-1
[447.430761] Dynamic subtest pipe-B-eDP-1: SKIP (1.127s)
[447.435027] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.914s)
[448.637299] [052/131] (571s left) gem_exec_balancer (parallel-contexts)
[448.901423] Starting subtest: parallel-contexts
[451.859404] Subtest parallel-contexts: SUCCESS (2.961s)
[452.957359] [053/131] (567s left) syncobj_timeline (wait-all-delayed-signal)
[453.013434] Starting subtest: wait-all-delayed-signal
[453.114060] Subtest wait-all-delayed-signal: SUCCESS (0.102s)
[453.218995] [054/131] (566s left) kms_plane_cursor (primary)
[453.311739] Starting subtest: primary
[453.315640] Starting dynamic subtest: pipe-A-eDP-1-size-64
[455.918085] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.607s)
[455.942303] Starting dynamic subtest: pipe-A-eDP-1-size-128
[458.563410] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.626s)
[458.588138] Starting dynamic subtest: pipe-A-eDP-1-size-256
[461.231939] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.649s)
[461.550649] Starting dynamic subtest: pipe-B-eDP-1-size-64
[464.807691] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.268s)
[464.838715] Starting dynamic subtest: pipe-B-eDP-1-size-128
[467.387148] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.559s)
[467.411735] Starting dynamic subtest: pipe-B-eDP-1-size-256
[469.967717] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.562s)
[470.279163] Starting dynamic subtest: pipe-C-eDP-1-size-64
[473.079304] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.811s)
[473.106988] Starting dynamic subtest: pipe-C-eDP-1-size-128
[475.269138] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.169s)
[475.295492] Starting dynamic subtest: pipe-C-eDP-1-size-256
[477.502437] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.213s)
[477.819560] Starting dynamic subtest: pipe-D-eDP-1-size-64
[480.697377] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.887s)
[480.724929] Starting dynamic subtest: pipe-D-eDP-1-size-128
[482.897735] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.179s)
[482.924085] Starting dynamic subtest: pipe-D-eDP-1-size-256
[485.131435] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.213s)
[485.437269] Subtest primary: SUCCESS (32.123s)
[486.273589] [055/131] (533s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[486.387796] Starting subtest: psr-rgb565-draw-pwrite
[493.341169] Subtest psr-rgb565-draw-pwrite: SUCCESS (6.956s)
[493.490647] [056/131] (526s left) gem_softpin (evict-prime)
[493.549776] Starting subtest: evict-prime
[493.552261] Starting dynamic subtest: rcs0
[494.721031] Dynamic subtest rcs0: SUCCESS (1.171s)
[494.733283] Starting dynamic subtest: bcs0
[495.875929] Dynamic subtest bcs0: SUCCESS (1.153s)
[495.887558] Starting dynamic subtest: vcs0
[497.977433] Dynamic subtest vcs0: SUCCESS (2.097s)
[497.988965] Starting dynamic subtest: vcs1
[499.894827] Dynamic subtest vcs1: SUCCESS (1.915s)
[499.907112] Starting dynamic subtest: vecs0
[501.877702] Dynamic subtest vecs0: SUCCESS (1.980s)
[501.889744] Starting dynamic subtest: ccs0
[503.026923] Dynamic subtest ccs0: SUCCESS (1.148s)
[503.038975] Starting dynamic subtest: all
[504.887606] Dynamic subtest all: SUCCESS (1.857s)
[504.890275] Subtest evict-prime: SUCCESS (11.337s)
[504.990626] [057/131] (515s left) kms_properties (connector-properties-legacy)
[505.088096] Starting subtest: connector-properties-legacy
[505.090060] Starting dynamic subtest: pipe-A-eDP-1
[512.869687] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.777s)
[512.879648] Starting dynamic subtest: pipe-None-DP-1
[512.883877] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[512.892166] Starting dynamic subtest: pipe-None-HDMI-A-1
[512.896877] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[512.907832] Starting dynamic subtest: pipe-None-DP-2
[512.912250] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[512.920822] Starting dynamic subtest: pipe-None-HDMI-A-2
[512.925242] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[512.933680] Starting dynamic subtest: pipe-None-DP-3
[512.938068] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[512.946339] Starting dynamic subtest: pipe-None-DP-4
[512.950823] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[512.953169] Subtest connector-properties-legacy: SUCCESS (7.789s)
[513.762333] [058/131] (506s left) kms_properties (colorop-properties-legacy)
[513.881361] Starting subtest: colorop-properties-legacy
[513.883305] Starting dynamic subtest: pipe-A-eDP-1
[514.239713] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.358s)
[514.249957] Starting dynamic subtest: pipe-B-eDP-1
[515.302836] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.062s)
[515.312842] Starting dynamic subtest: pipe-C-eDP-1
[516.328975] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.024s)
[516.339947] Starting dynamic subtest: pipe-D-eDP-1
[517.350413] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.021s)
[517.352844] Subtest colorop-properties-legacy: SUCCESS (3.470s)
[518.178665] [059/131] (502s left) gem_vm_create (invalid-destroy)
[518.243592] Starting subtest: invalid-destroy
[518.245993] Subtest invalid-destroy: SUCCESS (0.002s)
[518.372541] [060/131] (501s left) kms_flip (absolute-wf_vblank-interruptible)
[518.474877] Starting subtest: absolute-wf_vblank-interruptible
[518.476679] Starting dynamic subtest: A-eDP1
[527.227527] Dynamic subtest A-eDP1: SUCCESS (8.750s)
[527.239105] Starting dynamic subtest: B-eDP1
[535.954174] Dynamic subtest B-eDP1: SUCCESS (8.724s)
[535.964848] Starting dynamic subtest: C-eDP1
[544.658143] Dynamic subtest C-eDP1: SUCCESS (8.703s)
[544.667327] Starting dynamic subtest: D-eDP1
[553.388397] Dynamic subtest D-eDP1: SUCCESS (8.729s)
[553.393426] Subtest absolute-wf_vblank-interruptible: SUCCESS (34.916s)
[554.627130] [061/131] (465s left) kms_big_fb (linear-8bpp-rotate-0)
[554.736093] Starting subtest: linear-8bpp-rotate-0
[555.960347] Subtest linear-8bpp-rotate-0: SUCCESS (1.225s)
[556.130179] [062/131] (464s left) kms_big_fb (x-tiled-addfb)
[556.224479] Starting subtest: x-tiled-addfb
[556.226432] Subtest x-tiled-addfb: SUCCESS (0.000s)
[556.361109] [063/131] (464s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[556.455913] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc
[563.032542] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.577s)
[563.215558] [064/131] (457s left) gem_exec_schedule (promotion)
[563.298809] Starting subtest: promotion
[563.301030] Starting dynamic subtest: rcs0
[563.405719] Dynamic subtest rcs0: SUCCESS (0.113s)
[563.416087] Starting dynamic subtest: vcs0
[563.492977] Dynamic subtest vcs0: SUCCESS (0.086s)
[563.502593] Starting dynamic subtest: vcs1
[563.581213] Dynamic subtest vcs1: SUCCESS (0.087s)
[563.590675] Starting dynamic subtest: vecs0
[563.664331] Dynamic subtest vecs0: SUCCESS (0.082s)
[563.676570] Starting dynamic subtest: ccs0
[563.758062] Dynamic subtest ccs0: SUCCESS (0.093s)
[563.760957] Subtest promotion: SUCCESS (0.466s)
[565.029122] [065/131] (455s left) prime_mmap (test_map_unmap)
[565.079196] Starting subtest: test_map_unmap
[565.081126] Starting dynamic subtest: test_map_unmap-smem
[565.107812] Dynamic subtest test_map_unmap-smem: SUCCESS (0.031s)
[565.110248] Subtest test_map_unmap: SUCCESS (0.031s)
[565.223533] [066/131] (455s left) gem_exec_reloc (basic-write-cpu)
[565.291363] Subtest basic-write-cpu: SKIP (0.000s)
[565.355091] [067/131] (455s left) gem_ctx_persistence (legacy-engines-hang)
[565.415669] Starting subtest: legacy-engines-hang
[565.417896] Starting dynamic subtest: render
[565.554962] Dynamic subtest render: SUCCESS (0.138s)
[565.567065] Starting dynamic subtest: bsd1
[565.633653] Dynamic subtest bsd1: SUCCESS (0.076s)
[565.647329] Starting dynamic subtest: bsd2
[565.817363] Dynamic subtest bsd2: SUCCESS (0.180s)
[565.829677] Starting dynamic subtest: blt
[565.942861] Dynamic subtest blt: SUCCESS (0.123s)
[565.954599] Starting dynamic subtest: vebox
[566.060522] Dynamic subtest vebox: SUCCESS (0.115s)
[566.062721] Subtest legacy-engines-hang: SUCCESS (0.646s)
[566.164667] [068/131] (454s left) prime_vgem (fence-flip-hang)
[566.317905] Subtest fence-flip-hang: SKIP (0.000s)
[566.445352] [FACT prime_vgem (fence-flip-hang)] new: kernel.kmod_is_loaded.vgem: true
[566.448067] [069/131] (454s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-msflip-blt)
[566.555773] Starting subtest: psr-2p-primscrn-shrfb-msflip-blt
[566.559211] Subtest psr-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[566.691078] [070/131] (454s left) kms_plane (plane-position-covered)
[566.787637] Starting subtest: plane-position-covered
[567.304375] Starting dynamic subtest: pipe-A-plane-1
[568.608433] Dynamic subtest pipe-A-plane-1: SUCCESS (1.304s)
[568.618875] Starting dynamic subtest: pipe-A-plane-2
[569.871500] Dynamic subtest pipe-A-plane-2: SUCCESS (1.263s)
[569.880906] Starting dynamic subtest: pipe-A-plane-3
[571.207345] Dynamic subtest pipe-A-plane-3: SUCCESS (1.335s)
[571.217181] Starting dynamic subtest: pipe-A-plane-4
[572.512435] Dynamic subtest pipe-A-plane-4: SUCCESS (1.304s)
[572.522497] Starting dynamic subtest: pipe-A-plane-5
[572.536498] Dynamic subtest pipe-A-plane-5: SUCCESS (0.023s)
[573.751944] Starting dynamic subtest: pipe-B-plane-1
[575.077296] Dynamic subtest pipe-B-plane-1: SUCCESS (1.333s)
[575.086635] Starting dynamic subtest: pipe-B-plane-2
[576.396161] Dynamic subtest pipe-B-plane-2: SUCCESS (1.317s)
[576.406213] Starting dynamic subtest: pipe-B-plane-3
[577.631973] Dynamic subtest pipe-B-plane-3: SUCCESS (1.235s)
[577.642647] Starting dynamic subtest: pipe-B-plane-4
[578.903169] Dynamic subtest pipe-B-plane-4: SUCCESS (1.270s)
[578.913063] Starting dynamic subtest: pipe-B-plane-5
[578.926635] Dynamic subtest pipe-B-plane-5: SUCCESS (0.024s)
[578.928898] Subtest plane-position-covered: SUCCESS (12.139s)
[579.765551] [071/131] (441s left) kms_vrr (max-min)
[579.867821] Starting subtest: max-min
[579.873915] Subtest max-min: SKIP (0.000s)
[579.964157] [072/131] (440s left) i915_fb_tiling (basic-x-tiling)
[580.037947] Subtest basic-x-tiling: SKIP (0.000s)
[580.106640] [073/131] (440s left) gen9_exec_parse (batch-invalid-length)
[580.164289] Subtest batch-invalid-length: SKIP (0.000s)
[580.239087] [074/131] (440s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-blt)
[580.345321] Starting subtest: psr-1p-offscreen-pri-indfb-draw-blt
[587.308878] Subtest psr-1p-offscreen-pri-indfb-draw-blt: SUCCESS (6.968s)
[587.496450] [075/131] (433s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[587.598160] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[587.600426] Starting dynamic subtest: pipe-A-eDP-1
[587.622289] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[587.633588] Starting dynamic subtest: pipe-B-eDP-1
[587.654066] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[587.662444] Starting dynamic subtest: pipe-C-eDP-1
[587.683117] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[587.692027] Starting dynamic subtest: pipe-D-eDP-1
[587.714573] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[587.719034] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[589.777826] [076/131] (431s left) kms_pipe_crc_basic (hang-read-crc)
[589.876305] Starting subtest: hang-read-crc
[589.878192] Starting dynamic subtest: pipe-A-eDP-1
[591.932546] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.057s)
[591.942466] Starting dynamic subtest: pipe-B-eDP-1
[594.594231] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.658s)
[594.604531] Starting dynamic subtest: pipe-C-eDP-1
[597.220763] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.625s)
[597.230711] Starting dynamic subtest: pipe-D-eDP-1
[599.881873] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.660s)
[599.884171] Subtest hang-read-crc: SUCCESS (10.005s)
[600.738367] [077/131] (420s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode)
[601.134698] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s)
[601.928451] [078/131] (419s left) kms_psr (psr2-primary-mmap-gtt)
[602.034919] Starting subtest: psr2-primary-mmap-gtt
[602.037207] Starting dynamic subtest: eDP-1
[603.433665] Dynamic subtest eDP-1: SKIP (1.395s)
[603.438655] Subtest psr2-primary-mmap-gtt: SKIP (1.397s)
[603.623680] [079/131] (417s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[603.689079] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[603.693574] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[603.895543] [080/131] (417s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-wc)
[603.993298] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-wc
[608.002910] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-wc: SUCCESS (4.016s)
[609.202337] [081/131] (411s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[609.309281] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[609.313656] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[609.435180] [082/131] (411s left) gem_exec_reloc (basic-cpu-read-active)
[609.491636] Subtest basic-cpu-read-active: SKIP (0.000s)
[609.574283] [083/131] (411s left) kms_cursor_crc (cursor-onscreen-64x64)
[609.743725] Starting subtest: cursor-onscreen-64x64
[609.748775] Starting dynamic subtest: pipe-A-eDP-1
[611.875203] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.127s)
[611.903474] Starting dynamic subtest: pipe-D-eDP-1
[614.634054] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.736s)
[614.636376] Subtest cursor-onscreen-64x64: SUCCESS (4.888s)
[615.454396] [084/131] (405s left) syncobj_wait (multi-wait-signaled)
[615.518139] Starting subtest: multi-wait-signaled
[615.520406] Subtest multi-wait-signaled: SUCCESS (0.000s)
[615.648065] [085/131] (405s left) kms_flip (2x-flip-vs-wf_vblank-interruptible)
[615.742048] Starting subtest: 2x-flip-vs-wf_vblank-interruptible
[615.753786] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.011s)
[615.856104] [086/131] (405s left) gem_eio (context-create)
[616.086750] Starting subtest: context-create
[616.474516] Subtest context-create: SUCCESS (0.387s)
[616.649227] [087/131] (404s left) gem_exec_reloc (basic-wc)
[616.704240] Subtest basic-wc: SKIP (0.000s)
[616.780713] [088/131] (404s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[616.887075] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[617.556284] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.670s)
[617.762935] [089/131] (403s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt)
[617.876221] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt
[625.305305] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.431s)
[625.486561] [090/131] (396s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-move)
[625.609316] Starting subtest: psr-1p-primscrn-cur-indfb-move
[632.904385] Subtest psr-1p-primscrn-cur-indfb-move: SUCCESS (7.305s)
[633.087555] [091/131] (388s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[633.160884] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[633.163201] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[633.297131] [092/131] (388s left) gem_exec_fence (submit3)
[633.479772] Starting subtest: submit3
[633.484746] Subtest submit3: SKIP (0.000s)
[635.010648] [093/131] (386s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[635.127455] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[635.131971] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[635.296905] [094/131] (386s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted)
[635.360193] Starting subtest: multi-wait-all-for-submit-unsubmitted
[635.467447] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.107s)
[635.568208] [095/131] (386s left) gem_exec_params (larger-than-life-batch)
[635.631356] Starting subtest: larger-than-life-batch
[638.159476] Subtest larger-than-life-batch: SUCCESS (2.527s)
[639.007035] [096/131] (382s left) syncobj_timeline (etime-multi-wait-available-unsubmitted)
[639.122187] Starting subtest: etime-multi-wait-available-unsubmitted
[639.226554] Subtest etime-multi-wait-available-unsubmitted: SUCCESS (0.106s)
[639.332543] [097/131] (382s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt)
[639.452752] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt
[639.457117] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[639.584112] [098/131] (382s left) kms_chamelium_color (ctm-red-to-blue)
[639.687474] Subtest ctm-red-to-blue: SKIP (0.000s)
[639.732396] [099/131] (382s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[639.827123] Starting subtest: plane-upscale-factor-0-25-with-rotation
[639.829229] Starting dynamic subtest: pipe-A
[640.051722] Dynamic subtest pipe-A: SUCCESS (0.227s)
[640.061265] Starting dynamic subtest: pipe-B
[641.353899] Dynamic subtest pipe-B: SUCCESS (1.301s)
[641.364012] Starting dynamic subtest: pipe-C
[642.698605] Dynamic subtest pipe-C: SUCCESS (1.344s)
[642.709094] Starting dynamic subtest: pipe-D
[644.021628] Dynamic subtest pipe-D: SUCCESS (1.322s)
[644.023934] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.197s)
[645.227665] [100/131] (376s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt)
[645.326573] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt
[645.331098] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[645.452611] [101/131] (376s left) gem_mmap_gtt (basic-small-bo)
[645.518043] Subtest basic-small-bo: SKIP (0.000s)
[645.583721] [102/131] (376s left) prime_self_import (export-vs-gem_close-race)
[645.614725] Starting subtest: export-vs-gem_close-race
[650.719490] Subtest export-vs-gem_close-race: SUCCESS (5.103s)
[650.829338] [103/131] (371s left) gem_mmap_offset (basic-uaf)
[650.905562] Starting subtest: basic-uaf
[650.907865] Subtest basic-uaf: SUCCESS (0.001s)
[651.054342] [104/131] (371s left) kms_psr2_sf (psr2-plane-move-sf-dmg-area)
[656.049366] Starting subtest: psr2-plane-move-sf-dmg-area
[656.051683] Starting dynamic subtest: pipe-A-eDP-1
[661.343425] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.293s)
[661.354085] Starting dynamic subtest: pipe-B-eDP-1
[666.667512] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.321s)
[666.670038] Subtest psr2-plane-move-sf-dmg-area: SUCCESS (10.618s)
[667.574044] [105/131] (354s left) kms_atomic_transition (plane-all-transition)
[667.668772] Starting subtest: plane-all-transition
[667.671104] Starting dynamic subtest: pipe-A-eDP-1
[670.163397] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[670.478998] Starting dynamic subtest: pipe-B-eDP-1
[673.677833] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.208s)
[673.977571] Subtest plane-all-transition: SUCCESS (6.307s)
[674.835426] [106/131] (347s left) kms_psr (fbc-psr-basic)
[674.937442] Starting subtest: fbc-psr-basic
[674.939794] Starting dynamic subtest: eDP-1
[674.944132] Dynamic subtest eDP-1: SKIP (0.000s)
[674.948267] Subtest fbc-psr-basic: SKIP (0.001s)
[675.037370] [107/131] (347s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[675.128717] Starting subtest: 4-tiled-32bpp-rotate-270
[675.148210] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.019s)
[675.308642] [108/131] (347s left) prime_busy (before)
[675.368091] Starting subtest: before
[675.373510] Starting dynamic subtest: rcs0
[675.429053] Dynamic subtest rcs0: SUCCESS (0.058s)
[675.440860] Starting dynamic subtest: bcs0
[675.480098] Dynamic subtest bcs0: SUCCESS (0.050s)
[675.490788] Starting dynamic subtest: vcs0
[675.520066] Dynamic subtest vcs0: SUCCESS (0.039s)
[675.529461] Starting dynamic subtest: vcs1
[675.560427] Dynamic subtest vcs1: SUCCESS (0.040s)
[675.570076] Starting dynamic subtest: vecs0
[675.600192] Dynamic subtest vecs0: SUCCESS (0.039s)
[675.609837] Starting dynamic subtest: ccs0
[675.640806] Dynamic subtest ccs0: SUCCESS (0.040s)
[675.749966] Subtest before: SUCCESS (0.380s)
[675.852850] [109/131] (346s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu)
[675.951977] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu
[675.956330] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[676.091059] [110/131] (346s left) gem_fence_thrash (bo-write-verify-threaded-x)
[676.125044] Starting subtest: bo-write-verify-threaded-x
[676.140173] Subtest bo-write-verify-threaded-x: SKIP (0.014s)
[676.215185] [111/131] (346s left) gem_flink_basic (bad-open)
[676.273753] Starting subtest: bad-open
[676.276092] Subtest bad-open: SUCCESS (0.000s)
[676.417754] [112/131] (346s left) syncobj_timeline (multi-wait-all-available-submitted-signaled)
[676.483182] Starting subtest: multi-wait-all-available-submitted-signaled
[676.485329] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s)
[676.618749] [113/131] (345s left) gem_exec_reloc (basic-wc-gtt-noreloc)
[676.689229] Subtest basic-wc-gtt-noreloc: SKIP (0.000s)
[676.790913] [114/131] (345s left) i915_query (engine-info-invalid)
[676.842850] Starting subtest: engine-info-invalid
[676.844523] Subtest engine-info-invalid: SUCCESS (0.000s)
[676.953885] [115/131] (345s left) i915_drm_fdinfo (busy-check-all)
[676.988113] Starting subtest: busy-check-all
[676.989897] Starting dynamic subtest: rcs0
[676.993326] Dynamic subtest rcs0: SKIP (0.003s)
[677.003065] Starting dynamic subtest: bcs0
[677.006802] Dynamic subtest bcs0: SKIP (0.000s)
[677.015784] Starting dynamic subtest: vcs0
[677.019124] Dynamic subtest vcs0: SKIP (0.000s)
[677.027634] Starting dynamic subtest: vcs1
[677.030990] Dynamic subtest vcs1: SKIP (0.000s)
[677.039393] Starting dynamic subtest: vecs0
[677.042830] Dynamic subtest vecs0: SKIP (0.000s)
[677.051374] Starting dynamic subtest: ccs0
[677.054804] Dynamic subtest ccs0: SKIP (0.000s)
[677.058131] Subtest busy-check-all: SKIP (0.008s)
[677.094127] [116/131] (345s left) kms_color (gamma)
[677.193154] Starting subtest: gamma
[677.195051] Starting dynamic subtest: pipe-A-eDP-1
[677.904036] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.709s)
[677.913838] Starting dynamic subtest: pipe-B-eDP-1
[679.310946] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.406s)
[679.321273] Starting dynamic subtest: pipe-C-eDP-1
[680.698683] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.387s)
[680.710670] Starting dynamic subtest: pipe-D-eDP-1
[682.027878] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.328s)
[682.029867] Subtest gamma: SUCCESS (4.834s)
[682.851633] [117/131] (339s left) kms_atomic_interruptible (universal-setplane-primary)
[682.958830] Starting subtest: universal-setplane-primary
[682.961184] Starting dynamic subtest: pipe-A-eDP-1
[690.359812] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.401s)
[690.362078] Subtest universal-setplane-primary: SUCCESS (7.402s)
[691.241969] [118/131] (331s left) gem_ctx_create (basic-files)
[691.309632] Starting subtest: basic-files
[693.322104] Subtest basic-files: SUCCESS (2.012s)
[694.998119] [119/131] (327s left) gem_exec_schedule (pi-distinct-iova)
[695.194710] Starting subtest: pi-distinct-iova
[695.196849] Starting dynamic subtest: rcs0
[695.326790] Dynamic subtest rcs0: SUCCESS (0.135s)
[695.340799] Starting dynamic subtest: vcs0
[695.410025] Dynamic subtest vcs0: SUCCESS (0.083s)
[695.421040] Starting dynamic subtest: vcs1
[695.508686] Dynamic subtest vcs1: SUCCESS (0.098s)
[695.525155] Starting dynamic subtest: vecs0
[695.603411] Dynamic subtest vecs0: SUCCESS (0.093s)
[695.616351] Starting dynamic subtest: ccs0
[695.724050] Dynamic subtest ccs0: SUCCESS (0.119s)
[695.726655] Subtest pi-distinct-iova: SUCCESS (0.533s)
[697.055784] [120/131] (325s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[697.162989] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[697.165298] Starting dynamic subtest: pipe-A-default-mode
[699.903606] Dynamic subtest pipe-A-default-mode: SUCCESS (2.740s)
[699.905935] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.741s)
[700.802480] [121/131] (322s left) kms_flip_event_leak (basic)
[700.908793] Starting subtest: basic
[700.910993] Starting dynamic subtest: pipe-A-eDP-1
[701.336382] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.426s)
[701.346553] Starting dynamic subtest: pipe-B-eDP-1
[702.489826] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.153s)
[702.500924] Starting dynamic subtest: pipe-C-eDP-1
[703.613267] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.123s)
[703.625386] Starting dynamic subtest: pipe-D-eDP-1
[704.732882] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.117s)
[704.735192] Subtest basic: SUCCESS (3.826s)
[705.627154] [122/131] (317s left) kms_flip (basic-flip-vs-wf_vblank)
[705.729505] Starting subtest: basic-flip-vs-wf_vblank
[705.731707] Starting dynamic subtest: A-eDP1
[707.646395] Dynamic subtest A-eDP1: SUCCESS (1.918s)
[707.664083] Starting dynamic subtest: B-eDP1
[709.583948] Dynamic subtest B-eDP1: SUCCESS (1.935s)
[709.593803] Starting dynamic subtest: C-eDP1
[711.503617] Dynamic subtest C-eDP1: SUCCESS (1.917s)
[711.515690] Starting dynamic subtest: D-eDP1
[713.438472] Dynamic subtest D-eDP1: SUCCESS (1.933s)
[713.441839] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.715s)
[714.689508] [123/131] (308s left) kms_prop_blob (blob-prop-core)
[714.760694] Starting subtest: blob-prop-core
[714.762734] Subtest blob-prop-core: SUCCESS (0.000s)
[714.885338] [124/131] (308s left) gem_lmem_swapping (parallel-random)
[714.925401] Subtest parallel-random: SKIP (0.000s)
[714.968938] [125/131] (308s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[715.067591] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[718.633436] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.569s)
[719.799932] [126/131] (303s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[719.920135] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[719.924338] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[720.047237] [127/131] (303s left) kms_lease (lease-get)
[720.142073] Starting subtest: lease-get
[720.144264] Starting dynamic subtest: pipe-A-eDP-1
[720.146575] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[720.157452] Starting dynamic subtest: pipe-B-eDP-1
[720.159335] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[720.168304] Starting dynamic subtest: pipe-C-eDP-1
[720.170207] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[720.179289] Starting dynamic subtest: pipe-D-eDP-1
[720.181123] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[720.182941] Subtest lease-get: SUCCESS (0.009s)
[720.279525] [128/131] (302s left) dmabuf_sync_file (import-multiple-read-write)
[720.329187] Starting subtest: import-multiple-read-write
[720.331628] Subtest import-multiple-read-write: SUCCESS (0.003s)
[720.411898] [129/131] (302s left) gen3_mixed_blits
[720.527420] [130/131] (302s left) kms_ccs (crc-primary-rotation-180-4-tiled-bmg-ccs)
[720.628951] Starting subtest: crc-primary-rotation-180-4-tiled-bmg-ccs
[720.633280] Subtest crc-primary-rotation-180-4-tiled-bmg-ccs: SKIP (0.000s)
[721.820288] [131/131] (301s left) kms_cursor_crc (cursor-sliding-32x32)
[721.966830] Starting subtest: cursor-sliding-32x32
[722.015188] Subtest cursor-sliding-32x32: SKIP (0.043s)
[722.348162] Closing watchdogs
results: parsing output: 0/ for test: syncobj_timeline
results: parsing output: 1/ for test: gem_ccs
results: parsing output: 2/ for test: gem_ctx_param
results: parsing output: 3/ for test: api_intel_bb
results: parsing output: 4/ for test: gem_pxp
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_flip
results: parsing output: 8/ for test: kms_chamelium_edid
results: parsing output: 9/ for test: gem_exec_balancer
results: parsing output: 10/ for test: gem_eio
results: parsing output: 11/ for test: gem_madvise
results: parsing output: 12/ for test: kms_flip
results: parsing output: 13/ for test: kms_psr
results: parsing output: 14/ for test: gem_softpin
results: parsing output: 15/ for test: kms_async_flips
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_vblank
results: parsing output: 18/ for test: gem_exec_whisper
results: parsing output: 19/ for test: kms_atomic
results: parsing output: 20/ for test: kms_psr
results: parsing output: 21/ for test: kms_ccs
results: parsing output: 22/ for test: kms_ccs
results: parsing output: 23/ for test: kms_invalid_mode
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: perf
results: parsing output: 26/ for test: kms_addfb_basic
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: gem_flink_basic
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: gem_pxp
results: parsing output: 31/ for test: sysfs_timeslice_duration
results: parsing output: 32/ for test: perf
results: parsing output: 33/ for test: kms_psr
results: parsing output: 34/ for test: kms_addfb_basic
results: parsing output: 35/ for test: kms_cursor_crc
results: parsing output: 36/ for test: gem_ctx_param
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: gem_set_tiling_vs_blt
results: parsing output: 39/ for test: gem_ctx_create
results: parsing output: 40/ for test: syncobj_wait
results: parsing output: 41/ for test: kms_fb_coherency
results: parsing output: 42/ for test: kms_pm_dc
results: parsing output: 43/ for test: gem_create
results: parsing output: 44/ for test: kms_ccs
results: parsing output: 45/ for test: gem_lmem_swapping
results: parsing output: 46/ for test: perf
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: i915_pm_rps
results: parsing output: 49/ for test: kms_flip
results: parsing output: 50/ for test: kms_psr2_sf
results: parsing output: 51/ for test: gem_exec_balancer
results: parsing output: 52/ for test: syncobj_timeline
results: parsing output: 53/ for test: kms_plane_cursor
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: gem_softpin
results: parsing output: 56/ for test: kms_properties
results: parsing output: 57/ for test: kms_properties
results: parsing output: 58/ for test: gem_vm_create
results: parsing output: 59/ for test: kms_flip
results: parsing output: 60/ for test: kms_big_fb
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: gem_exec_schedule
results: parsing output: 64/ for test: prime_mmap
results: parsing output: 65/ for test: gem_exec_reloc
results: parsing output: 66/ for test: gem_ctx_persistence
results: parsing output: 67/ for test: prime_vgem
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_plane
results: parsing output: 70/ for test: kms_vrr
results: parsing output: 71/ for test: i915_fb_tiling
results: parsing output: 72/ for test: gen9_exec_parse
results: parsing output: 73/ for test: kms_frontbuffer_tracking
results: parsing output: 74/ for test: kms_ccs
results: parsing output: 75/ for test: kms_pipe_crc_basic
results: parsing output: 76/ for test: kms_chamelium_hpd
results: parsing output: 77/ for test: kms_psr
results: parsing output: 78/ for test: gem_render_copy
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: kms_big_fb
results: parsing output: 81/ for test: gem_exec_reloc
results: parsing output: 82/ for test: kms_cursor_crc
results: parsing output: 83/ for test: syncobj_wait
results: parsing output: 84/ for test: kms_flip
results: parsing output: 85/ for test: gem_eio
results: parsing output: 86/ for test: gem_exec_reloc
results: parsing output: 87/ for test: kms_big_fb
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: gem_exec_fence
results: parsing output: 92/ for test: kms_cursor_legacy
results: parsing output: 93/ for test: syncobj_wait
results: parsing output: 94/ for test: gem_exec_params
results: parsing output: 95/ for test: syncobj_timeline
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_chamelium_color
results: parsing output: 98/ for test: kms_plane_scaling
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: gem_mmap_gtt
results: parsing output: 101/ for test: prime_self_import
results: parsing output: 102/ for test: gem_mmap_offset
results: parsing output: 103/ for test: kms_psr2_sf
results: parsing output: 104/ for test: kms_atomic_transition
results: parsing output: 105/ for test: kms_psr
results: parsing output: 106/ for test: kms_big_fb
results: parsing output: 107/ for test: prime_busy
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: parsing output: 109/ for test: gem_fence_thrash
results: parsing output: 110/ for test: gem_flink_basic
results: parsing output: 111/ for test: syncobj_timeline
results: parsing output: 112/ for test: gem_exec_reloc
results: parsing output: 113/ for test: i915_query
results: parsing output: 114/ for test: i915_drm_fdinfo
results: parsing output: 115/ for test: kms_color
results: parsing output: 116/ for test: kms_atomic_interruptible
results: parsing output: 117/ for test: gem_ctx_create
results: parsing output: 118/ for test: gem_exec_schedule
results: parsing output: 119/ for test: kms_flip_scaled_crc
results: parsing output: 120/ for test: kms_flip_event_leak
results: parsing output: 121/ for test: kms_flip
results: parsing output: 122/ for test: kms_prop_blob
results: parsing output: 123/ for test: gem_lmem_swapping
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: kms_lease
results: parsing output: 127/ for test: dmabuf_sync_file
results: parsing output: 128/ for test: gen3_mixed_blits
results: parsing output: 129/ for test: kms_ccs
results: parsing output: 130/ for test: kms_cursor_crc
Done.