[57.488236] Initializing watchdogs
[57.488284]   /dev/watchdog0
[57.503257] [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.508021] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.510257] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.513356] [001/133] (960s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted)
[57.587888] Starting subtest: etime-single-wait-for-submit-unsubmitted
[57.687866] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.102s)
[57.764262] [002/133] (960s left) gem_pxp (hw-rejects-pxp-context)
[57.891675] Starting subtest: hw-rejects-pxp-context
[57.896476] Subtest hw-rejects-pxp-context: SKIP (0.000s)
[58.010849] [003/133] (960s left) gem_exec_await (wide-all)
[58.228751] Starting subtest: wide-all
[81.196819] Subtest wide-all: SUCCESS (22.990s)
[81.372959] [FACT gem_exec_await (wide-all)] new: kernel.kmod_is_loaded.vgem: true
[81.377616] [004/133] (936s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[81.525979] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[81.528419] Starting dynamic subtest: pipe-A-eDP-1
[81.660430] Dynamic subtest pipe-A-eDP-1: SKIP (0.139s)
[81.671678] Starting dynamic subtest: pipe-B-eDP-1
[82.856855] Dynamic subtest pipe-B-eDP-1: SKIP (1.195s)
[82.861622] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.336s)
[84.041039] [005/133] (934s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-sf)
[84.148989] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-sf
[84.151411] Starting dynamic subtest: pipe-A-eDP-1
[84.248821] Dynamic subtest pipe-A-eDP-1: SKIP (0.102s)
[84.260609] Starting dynamic subtest: pipe-B-eDP-1
[85.421751] Dynamic subtest pipe-B-eDP-1: SKIP (1.171s)
[85.426056] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-sf: SKIP (1.276s)
[86.603880] [006/133] (931s left) gem_exec_schedule (pi-common)
[86.807917] Starting subtest: pi-common
[86.810199] Starting dynamic subtest: rcs0
[86.833099] Dynamic subtest rcs0: SUCCESS (0.028s)
[86.847866] Starting dynamic subtest: bcs0
[86.861789] Dynamic subtest bcs0: SUCCESS (0.028s)
[86.875192] Starting dynamic subtest: vcs0
[86.888297] Dynamic subtest vcs0: SUCCESS (0.026s)
[86.901726] Starting dynamic subtest: vcs1
[86.914797] Dynamic subtest vcs1: SUCCESS (0.026s)
[86.928178] Starting dynamic subtest: vecs0
[86.940114] Dynamic subtest vecs0: SUCCESS (0.025s)
[86.953727] Starting dynamic subtest: ccs0
[86.965924] Dynamic subtest ccs0: SUCCESS (0.025s)
[86.968114] Subtest pi-common: SUCCESS (0.161s)
[87.218320] [007/133] (931s left) prime_vgem (fence-write-hang)
[87.299246] Subtest fence-write-hang: SKIP (0.000s)
[87.407812] [008/133] (930s left) gem_exec_store (cachelines)
[87.471596] Starting subtest: cachelines
[87.474030] Starting dynamic subtest: rcs0
[87.546854] Dynamic subtest rcs0: SUCCESS (0.075s)
[87.558277] Starting dynamic subtest: bcs0
[87.597301] Dynamic subtest bcs0: SUCCESS (0.051s)
[87.608167] Starting dynamic subtest: vcs0
[87.647689] Dynamic subtest vcs0: SUCCESS (0.050s)
[87.658755] Starting dynamic subtest: vcs1
[87.714084] Dynamic subtest vcs1: SUCCESS (0.066s)
[87.726085] Starting dynamic subtest: vecs0
[87.767782] Dynamic subtest vecs0: SUCCESS (0.052s)
[87.777902] Starting dynamic subtest: ccs0
[87.838105] Dynamic subtest ccs0: SUCCESS (0.069s)
[87.840679] Subtest cachelines: SUCCESS (0.368s)
[88.021010] [009/133] (930s left) perf_pmu (busy)
[88.059479] Starting subtest: busy
[88.061920] Starting dynamic subtest: rcs0
[88.635690] Dynamic subtest rcs0: SUCCESS (0.577s)
[88.648471] Starting dynamic subtest: bcs0
[89.195678] Dynamic subtest bcs0: SUCCESS (0.559s)
[89.205898] Starting dynamic subtest: vcs0
[90.301360] Dynamic subtest vcs0: SUCCESS (1.103s)
[90.311651] Starting dynamic subtest: vcs1
[92.285130] Dynamic subtest vcs1: SUCCESS (1.983s)
[92.295248] Starting dynamic subtest: vecs0
[94.269441] Dynamic subtest vecs0: SUCCESS (1.983s)
[94.280464] Starting dynamic subtest: ccs0
[94.839264] Dynamic subtest ccs0: SUCCESS (0.570s)
[94.841921] Subtest busy: SUCCESS (6.781s)
[94.944958] [010/133] (923s left) gem_lmem_swapping (parallel-random-verify-ccs)
[94.992794] Subtest parallel-random-verify-ccs: SKIP (0.000s)
[95.039996] [011/133] (923s left) kms_rmfb (close-fd)
[95.134885] Starting subtest: close-fd
[95.137301] Starting dynamic subtest: pipe-A-eDP-1
[95.244984] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.108s)
[95.256775] Starting dynamic subtest: pipe-B-eDP-1
[96.462895] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.217s)
[96.474056] Starting dynamic subtest: pipe-C-eDP-1
[97.677062] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.213s)
[97.688776] Starting dynamic subtest: pipe-D-eDP-1
[98.823923] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.147s)
[98.826369] Subtest close-fd: SUCCESS (3.689s)
[100.033352] [012/133] (918s left) syncobj_basic (bad-flags-fd-to-handle)
[100.090592] Starting subtest: bad-flags-fd-to-handle
[100.092973] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[100.188181] [013/133] (918s left) perf_pmu (invalid-init)
[100.225219] Starting subtest: invalid-init
[100.227641] Subtest invalid-init: SUCCESS (0.000s)
[100.334709] [014/133] (918s left) kms_getfb (getfb2-into-addfb2)
[100.428183] Starting subtest: getfb2-into-addfb2
[100.430389] Subtest getfb2-into-addfb2: SUCCESS (0.000s)
[100.540688] [015/133] (918s left) gem_exec_capture (capture-invisible)
[100.598681] Starting subtest: capture-invisible
[100.600618] Starting dynamic subtest: smem0
[100.604749] Dynamic subtest smem0: SKIP (0.000s)
[100.609269] Subtest capture-invisible: SKIP (0.000s)
[100.697831] [016/133] (917s left) perf_pmu (event-wait)
[100.732301] Starting subtest: event-wait
[100.734631] Starting dynamic subtest: rcs0
[100.738758] Dynamic subtest rcs0: SKIP (0.000s)
[100.743035] Subtest event-wait: SKIP (0.000s)
[100.847894] [017/133] (917s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt)
[100.950154] Starting subtest: fbc-farfromfence-mmap-gtt
[100.954589] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s)
[101.044197] [018/133] (917s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted)
[101.105201] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted
[101.210071] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.103s)
[101.288666] [019/133] (917s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[101.386497] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[101.388767] Starting dynamic subtest: pipe-A-eDP-1
[101.397835] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[101.409181] Starting dynamic subtest: pipe-B-eDP-1
[101.418051] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[101.427213] Starting dynamic subtest: pipe-C-eDP-1
[101.435546] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[101.444362] Starting dynamic subtest: pipe-D-eDP-1
[101.452787] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[101.456838] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[103.690033] [020/133] (915s left) kms_chamelium_edid (hdmi-edid-stress-resolution-non-4k)
[104.078401] Subtest hdmi-edid-stress-resolution-non-4k: SKIP (0.000s)
[104.898785] [021/133] (913s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[104.999618] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt
[105.003590] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[105.096590] [022/133] (913s left) gem_mmap_offset (clear-via-pagefault)
[105.155610] Starting subtest: clear-via-pagefault
[105.157573] Starting dynamic subtest: smem0
[136.619570] Dynamic subtest smem0: SUCCESS (31.460s)
[136.624999] Subtest clear-via-pagefault: SUCCESS (31.460s)
[136.725060] [023/133] (882s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite)
[136.826162] Starting subtest: psr-rgb101010-draw-pwrite
[144.834904] Subtest psr-rgb101010-draw-pwrite: SUCCESS (8.012s)
[144.950881] [024/133] (874s left) gem_exec_schedule (u-semaphore-noskip)
[145.018102] Starting subtest: u-semaphore-noskip
[145.421201] Subtest u-semaphore-noskip: SUCCESS (0.409s)
[145.766620] [025/133] (873s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc)
[145.863218] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc
[145.865485] Starting dynamic subtest: pipe-A-eDP-1
[145.924710] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[145.935949] Starting dynamic subtest: pipe-B-eDP-1
[145.997130] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[146.007869] Starting dynamic subtest: pipe-C-eDP-1
[146.065574] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[146.076908] Starting dynamic subtest: pipe-D-eDP-1
[146.132976] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[146.137084] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.007s)
[148.197753] [026/133] (870s left) gen7_exec_parse (basic-allocation)
[148.250154] Subtest basic-allocation: SKIP (0.000s)
[148.316339] [027/133] (870s left) dumb_buffer (map-invalid-size)
[148.360998] Starting subtest: map-invalid-size
[148.362979] Subtest map-invalid-size: SUCCESS (0.000s)
[148.464734] [028/133] (870s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc)
[148.567658] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc
[148.571827] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[148.659394] [029/133] (870s left) syncobj_timeline (invalid-wait-bad-flags)
[148.708852] Starting subtest: invalid-wait-bad-flags
[148.710728] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[148.815282] [030/133] (870s left) kms_lease (setcrtc-implicit-plane)
[148.909760] Starting subtest: setcrtc-implicit-plane
[148.912119] Starting dynamic subtest: pipe-A-eDP-1
[149.368475] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.458s)
[149.381659] Starting dynamic subtest: pipe-B-eDP-1
[150.551145] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.182s)
[150.561651] Starting dynamic subtest: pipe-C-eDP-1
[151.660313] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.109s)
[151.671653] Starting dynamic subtest: pipe-D-eDP-1
[152.799407] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.136s)
[152.801882] Subtest setcrtc-implicit-plane: SUCCESS (3.890s)
[153.656245] [031/133] (865s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs)
[153.746178] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs
[153.748560] Starting dynamic subtest: pipe-A-eDP-1
[153.772909] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[153.783529] Starting dynamic subtest: pipe-B-eDP-1
[153.805255] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[153.813635] Starting dynamic subtest: pipe-C-eDP-1
[153.835438] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[153.844552] Starting dynamic subtest: pipe-D-eDP-1
[153.866600] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[153.870964] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[155.941244] [032/133] (863s left) i915_query (query-topology-unsupported)
[155.996202] Starting subtest: query-topology-unsupported
[156.000455] Subtest query-topology-unsupported: SKIP (0.000s)
[156.084083] [033/133] (863s left) gem_exec_flush (basic-wb-ro-default)
[156.156913] Starting subtest: basic-wb-ro-default
[161.611801] Subtest basic-wb-ro-default: SUCCESS (5.456s)
[161.803252] [034/133] (857s left) kms_chamelium_hpd (common-hpd-after-suspend)
[162.191272] Subtest common-hpd-after-suspend: SKIP (0.000s)
[163.045714] [035/133] (856s left) gem_ppgtt (shrink-vs-evict-any)
[163.103738] Starting subtest: shrink-vs-evict-any
[168.284333] Subtest shrink-vs-evict-any: SUCCESS (5.181s)
[168.380786] [036/133] (851s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[168.493855] Starting subtest: y-tiled-8bpp-rotate-0
[168.498262] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[168.604557] [037/133] (850s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-blt)
[168.710880] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-blt
[175.596261] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (6.887s)
[175.757317] [038/133] (843s left) syncobj_wait (wait-for-submit-snapshot)
[175.812791] Starting subtest: wait-for-submit-snapshot
[175.893339] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[175.987070] [039/133] (843s left) kms_flip (2x-flip-vs-dpms-on-nop)
[176.075409] Starting subtest: 2x-flip-vs-dpms-on-nop
[176.084914] Subtest 2x-flip-vs-dpms-on-nop: SKIP (0.011s)
[176.170262] [040/133] (843s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[176.286878] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[176.292061] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[176.383100] [041/133] (843s left) gem_exec_fence (syncobj-timeline-signal)
[176.934325] Starting subtest: syncobj-timeline-signal
[176.939901] Subtest syncobj-timeline-signal: SUCCESS (0.009s)
[178.394856] [042/133] (841s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc)
[178.486104] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc
[178.488437] Starting dynamic subtest: pipe-A-eDP-1
[178.508592] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[178.520552] Starting dynamic subtest: pipe-B-eDP-1
[178.539577] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[178.548970] Starting dynamic subtest: pipe-C-eDP-1
[178.568604] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[178.578745] Starting dynamic subtest: pipe-D-eDP-1
[178.597288] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[178.599158] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.007s)
[180.757395] [043/133] (839s left) kms_psr (psr-primary-blt)
[180.847857] Starting subtest: psr-primary-blt
[180.850053] Starting dynamic subtest: eDP-1
[182.569296] Dynamic subtest eDP-1: SUCCESS (1.722s)
[182.571677] Subtest psr-primary-blt: SUCCESS (1.723s)
[183.437194] [044/133] (836s left) kms_properties (invalid-properties-legacy)
[183.535106] Starting subtest: invalid-properties-legacy
[183.645303] Subtest invalid-properties-legacy: SUCCESS (0.111s)
[183.720752] [045/133] (836s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[183.840799] Starting subtest: flip-vs-cursor-crc-legacy
[184.586722] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.747s)
[185.454391] [046/133] (834s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[185.598963] Starting subtest: cursor-rapid-movement-32x32
[185.648545] Subtest cursor-rapid-movement-32x32: SKIP (0.045s)
[185.950036] [047/133] (833s left) gem_exercise_blt (fast-copy)
[186.012733] Starting subtest: fast-copy
[186.015056] Starting dynamic subtest: linear-smem-smem
[186.037375] Dynamic subtest linear-smem-smem: SUCCESS (0.025s)
[186.049563] Starting dynamic subtest: xmajor-smem-smem
[186.055911] Dynamic subtest xmajor-smem-smem: SUCCESS (0.018s)
[186.065852] Starting dynamic subtest: tile4-smem-smem
[186.073092] Dynamic subtest tile4-smem-smem: SUCCESS (0.017s)
[186.082572] Starting dynamic subtest: tile64-smem-smem
[186.090629] Dynamic subtest tile64-smem-smem: SUCCESS (0.017s)
[186.092925] Subtest fast-copy: SUCCESS (0.078s)
[186.208864] [048/133] (833s left) gem_ctx_shared (q-out-order)
[186.273797] Starting subtest: Q-out-order
[186.276160] Starting dynamic subtest: rcs0
[186.377771] Dynamic subtest rcs0: SUCCESS (0.103s)
[186.394728] Starting dynamic subtest: vcs0
[186.455823] Dynamic subtest vcs0: SUCCESS (0.078s)
[186.473779] Starting dynamic subtest: vcs1
[186.565950] Dynamic subtest vcs1: SUCCESS (0.109s)
[186.583420] Starting dynamic subtest: vecs0
[186.638024] Dynamic subtest vecs0: SUCCESS (0.072s)
[186.655157] Starting dynamic subtest: ccs0
[186.718463] Dynamic subtest ccs0: SUCCESS (0.080s)
[186.720800] Subtest Q-out-order: SUCCESS (0.445s)
[188.380827] [049/133] (831s left) kms_atomic (test-only)
[188.479385] Starting subtest: test-only
[188.527096] Starting dynamic subtest: pipe-A-eDP-1
[191.064702] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.538s)
[191.066979] Subtest test-only: SUCCESS (2.588s)
[191.936845] [050/133] (828s left) kms_plane (pixel-format-4-tiled-lnl-ccs-modifier-source-clamping)
[192.038934] Starting subtest: pixel-format-4-tiled-lnl-ccs-modifier-source-clamping
[192.043207] Subtest pixel-format-4-tiled-lnl-ccs-modifier-source-clamping: SKIP (0.000s)
[192.126491] [051/133] (827s left) syncobj_timeline (single-wait-for-submit-available-submitted)
[192.177795] Starting subtest: single-wait-for-submit-available-submitted
[192.179904] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s)
[192.279457] [052/133] (827s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu)
[192.378110] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu
[195.933572] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.561s)
[197.148501] [053/133] (823s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[197.203371] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[197.205296] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[197.317376] [054/133] (822s left) kms_big_fb (4-tiled-8bpp-rotate-180)
[197.421090] Starting subtest: 4-tiled-8bpp-rotate-180
[198.623472] Subtest 4-tiled-8bpp-rotate-180: SUCCESS (1.203s)
[198.758974] [055/133] (821s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[198.852181] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[198.855671] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[198.954841] [056/133] (821s left) gem_eio (wait-wedge-10ms)
[199.194723] Starting subtest: wait-wedge-10ms
[200.398993] Subtest wait-wedge-10ms: SUCCESS (1.204s)
[200.543923] [057/133] (819s left) gem_ccs (ctrl-surf-copy)
[200.604886] Starting subtest: ctrl-surf-copy
[200.609315] Subtest ctrl-surf-copy: SKIP (0.000s)
[200.750850] [058/133] (819s left) kms_big_fb (yf-tiled-8bpp-rotate-180)
[200.853101] Starting subtest: yf-tiled-8bpp-rotate-180
[200.857370] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s)
[200.953186] [059/133] (819s left) kms_plane_alpha_blend (alpha-7efc)
[201.055349] Starting subtest: alpha-7efc
[201.343024] Starting dynamic subtest: pipe-A-eDP-1
[201.955460] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.610s)
[201.986058] Starting dynamic subtest: pipe-D-eDP-1
[203.264552] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.287s)
[203.266462] Subtest alpha-7efc: SUCCESS (2.211s)
[204.111447] [060/133] (816s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs)
[204.211077] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs
[204.213415] Starting dynamic subtest: pipe-A-eDP-1
[204.955989] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.739s)
[204.966090] Starting dynamic subtest: pipe-B-eDP-1
[206.742296] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.785s)
[206.753876] Starting dynamic subtest: pipe-C-eDP-1
[208.584911] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.842s)
[208.605368] Starting dynamic subtest: pipe-D-eDP-1
[210.401994] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.815s)
[210.404227] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.186s)
[211.537761] [061/133] (809s left) kms_plane_lowres (tiling-y)
[211.636751] Starting subtest: tiling-y
[211.641248] Subtest tiling-y: SKIP (0.000s)
[211.725626] [062/133] (808s left) core_debugfs (read-all-entries)
[211.772229] Starting subtest: read-all-entries
[211.867076] Subtest read-all-entries: SUCCESS (0.096s)
[211.950570] [063/133] (808s left) gem_render_copy (y-tiled-to-vebox-x-tiled)
[212.016961] Starting subtest: y-tiled-to-vebox-x-tiled
[212.021076] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s)
[212.199830] [064/133] (808s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[212.304363] Starting subtest: plane-lut1d-ctm3x4
[212.451836] Starting dynamic subtest: pipe-A-plane-0
[212.618249] Dynamic subtest pipe-A-plane-0: SUCCESS (0.167s)
[212.629031] Starting dynamic subtest: pipe-A-plane-1
[212.806558] Dynamic subtest pipe-A-plane-1: SUCCESS (0.187s)
[212.816818] Starting dynamic subtest: pipe-A-plane-2
[212.974776] Dynamic subtest pipe-A-plane-2: SUCCESS (0.166s)
[214.140404] Starting dynamic subtest: pipe-B-plane-0
[214.331588] Dynamic subtest pipe-B-plane-0: SUCCESS (0.200s)
[214.343068] Starting dynamic subtest: pipe-B-plane-1
[214.523086] Dynamic subtest pipe-B-plane-1: SUCCESS (0.188s)
[214.533779] Starting dynamic subtest: pipe-B-plane-2
[214.710417] Dynamic subtest pipe-B-plane-2: SUCCESS (0.188s)
[215.972886] Starting dynamic subtest: pipe-C-plane-0
[216.129784] Dynamic subtest pipe-C-plane-0: SUCCESS (0.166s)
[216.140102] Starting dynamic subtest: pipe-C-plane-1
[216.296800] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s)
[216.310397] Starting dynamic subtest: pipe-C-plane-2
[216.464588] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s)
[217.710591] Starting dynamic subtest: pipe-D-plane-0
[217.857598] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s)
[217.869254] Starting dynamic subtest: pipe-D-plane-1
[218.024278] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s)
[218.035140] Starting dynamic subtest: pipe-D-plane-2
[218.190509] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s)
[218.480955] Subtest plane-lut1d-ctm3x4: SUCCESS (6.176s)
[219.365197] [065/133] (801s left) gem_ccs (suspend-resume)
[219.430289] Starting subtest: suspend-resume
[219.434415] Subtest suspend-resume: SKIP (0.000s)
[219.552709] [066/133] (801s left) kms_psr (pr-cursor-plane-move)
[219.653796] Starting subtest: pr-cursor-plane-move
[219.657697] Subtest pr-cursor-plane-move: SKIP (0.000s)
[219.726962] [067/133] (801s left) kms_vblank (query-idle-hang)
[219.824344] Starting subtest: query-idle-hang
[219.826642] Starting dynamic subtest: pipe-A-eDP-1
[246.094248] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.268s)
[246.109792] Starting dynamic subtest: pipe-D-eDP-1
[271.049907] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.954s)
[271.052130] Subtest query-idle-hang: SUCCESS (51.227s)
[271.916966] [068/133] (748s left) kms_pm_backlight (fade)
[272.016078] Starting subtest: fade
[272.071511] Starting dynamic subtest: eDP-1
[275.086242] Dynamic subtest eDP-1: SUCCESS (3.012s)
[275.088488] Subtest fade: SUCCESS (3.070s)
[275.957742] [069/133] (744s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen)
[276.057959] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen
[276.062279] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[276.151884] [070/133] (744s left) sw_sync (sync_merge_invalid)
[276.192803] Starting subtest: sync_merge_invalid
[276.215461] Subtest sync_merge_invalid: SUCCESS (0.022s)
[276.285492] [071/133] (744s left) syncobj_wait (reset-during-wait-for-submit)
[276.342582] Starting subtest: reset-during-wait-for-submit
[276.444645] Subtest reset-during-wait-for-submit: SUCCESS (0.102s)
[276.524957] [072/133] (744s left) kms_hdr (static-toggle-dpms)
[276.619334] Starting subtest: static-toggle-dpms
[276.625790] Subtest static-toggle-dpms: SKIP (0.000s)
[276.702750] [073/133] (744s left) gem_ctx_isolation (nonpriv-switch)
[276.764854] Starting subtest: nonpriv-switch
[276.767070] Starting dynamic subtest: rcs0
[277.074822] Dynamic subtest rcs0: SUCCESS (0.309s)
[277.085479] Starting dynamic subtest: bcs0
[277.373896] Dynamic subtest bcs0: SUCCESS (0.298s)
[277.384942] Starting dynamic subtest: vcs0
[277.665565] Dynamic subtest vcs0: SUCCESS (0.291s)
[277.678215] Starting dynamic subtest: vcs1
[279.613191] Dynamic subtest vcs1: SUCCESS (1.946s)
[279.624981] Starting dynamic subtest: vecs0
[281.575484] Dynamic subtest vecs0: SUCCESS (1.962s)
[281.590763] Starting dynamic subtest: ccs0
[283.661111] Dynamic subtest ccs0: SUCCESS (2.084s)
[283.663612] Subtest nonpriv-switch: SUCCESS (6.897s)
[283.904939] [074/133] (737s left) kms_psr (fbc-psr-sprite-plane-move)
[284.000955] Starting subtest: fbc-psr-sprite-plane-move
[284.003217] Starting dynamic subtest: eDP-1
[284.007224] Dynamic subtest eDP-1: SKIP (0.000s)
[284.011226] Subtest fbc-psr-sprite-plane-move: SKIP (0.001s)
[284.076850] [075/133] (737s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite)
[284.179851] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite
[291.970564] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.793s)
[292.082761] [076/133] (729s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[292.181602] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[292.185968] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[292.289506] [077/133] (728s left) prime_mmap (test_dup)
[292.351469] Starting subtest: test_dup
[292.353382] Starting dynamic subtest: test_dup-smem
[292.383399] Dynamic subtest test_dup-smem: SUCCESS (0.033s)
[292.386723] Subtest test_dup: SUCCESS (0.034s)
[292.459499] [078/133] (728s left) kms_cursor_crc (cursor-suspend)
[292.591851] Starting subtest: cursor-suspend
[292.594141] Starting dynamic subtest: pipe-A-eDP-1
[325.659370] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.342s)
[325.670916] Starting dynamic subtest: pipe-D-eDP-1
[359.653886] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.802s)
[359.656209] Subtest cursor-suspend: SUCCESS (7.147s)
[360.473806] [079/133] (660s left) gem_exec_params (sol-reset-invalid)
[360.542280] Starting subtest: sol-reset-invalid
[360.547402] Subtest sol-reset-invalid: SUCCESS (0.003s)
[362.254041] [080/133] (659s left) kms_addfb_basic (invalid-smem-bo-on-discrete)
[362.312477] Starting subtest: invalid-smem-bo-on-discrete
[362.316885] Subtest invalid-smem-bo-on-discrete: SKIP (0.000s)
[362.458944] [081/133] (658s left) sw_sync (alloc_merge_fence)
[362.495236] Starting subtest: alloc_merge_fence
[362.497073] Subtest alloc_merge_fence: SUCCESS (0.000s)
[362.556414] [082/133] (658s left) i915_suspend (debugfs-reader)
[362.613519] Starting subtest: debugfs-reader
[381.167259] Subtest debugfs-reader: SUCCESS (3.151s)
[381.294771] [083/133] (640s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-20x20)
[381.405999] Starting subtest: planes-downscale-factor-0-75-upscale-20x20
[381.408288] Starting dynamic subtest: pipe-A
[381.469241] Dynamic subtest pipe-A: SUCCESS (0.065s)
[381.490318] Starting dynamic subtest: pipe-B
[382.653141] Dynamic subtest pipe-B: SUCCESS (1.189s)
[382.666056] Starting dynamic subtest: pipe-C
[383.766169] Dynamic subtest pipe-C: SUCCESS (1.117s)
[383.778103] Starting dynamic subtest: pipe-D
[384.887005] Dynamic subtest pipe-D: SUCCESS (1.123s)
[384.889325] Subtest planes-downscale-factor-0-75-upscale-20x20: SUCCESS (3.501s)
[386.039530] [084/133] (635s left) kms_flip (2x-wf_vblank-ts-check)
[386.133981] Starting subtest: 2x-wf_vblank-ts-check
[386.146270] Subtest 2x-wf_vblank-ts-check: SKIP (0.012s)
[386.227191] [085/133] (635s left) gem_exec_fence (syncobj-unused-fence)
[386.649861] Starting subtest: syncobj-unused-fence
[386.655152] Subtest syncobj-unused-fence: SUCCESS (0.004s)
[387.764559] [086/133] (633s left) i915_pm_rpm (sysfs-read)
[389.788140] Starting subtest: sysfs-read
[390.958445] Subtest sysfs-read: SUCCESS (1.171s)
[391.344088] [087/133] (630s left) kms_addfb_basic (bad-pitch-32)
[391.397003] Starting subtest: bad-pitch-32
[391.399067] Subtest bad-pitch-32: SUCCESS (0.000s)
[391.544655] [088/133] (630s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc)
[391.641800] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc
[391.646082] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[391.731161] [089/133] (630s left) kms_content_protection (dp-mst-type-1-suspend-resume)
[391.890426] Starting subtest: dp-mst-type-1-suspend-resume
[391.895023] Subtest dp-mst-type-1-suspend-resume: SKIP (0.000s)
[391.997430] [090/133] (629s left) gem_linear_blits (normal)
[392.223349] Starting subtest: normal
[395.798237] Subtest normal: SUCCESS (3.580s)
[395.916961] [091/133] (626s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[396.067475] Starting subtest: psr-2p-primscrn-spr-indfb-move
[396.071846] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[396.157681] [092/133] (625s left) kms_flip (wf_vblank-ts-check)
[396.255438] Starting subtest: wf_vblank-ts-check
[396.257718] Starting dynamic subtest: A-eDP1
[405.154301] Dynamic subtest A-eDP1: SUCCESS (8.909s)
[405.166129] Starting dynamic subtest: B-eDP1
[414.085484] Dynamic subtest B-eDP1: SUCCESS (8.925s)
[414.103359] Starting dynamic subtest: C-eDP1
[423.007424] Dynamic subtest C-eDP1: SUCCESS (8.923s)
[423.020879] Starting dynamic subtest: D-eDP1
[431.937551] Dynamic subtest D-eDP1: SUCCESS (8.927s)
[431.939736] Subtest wf_vblank-ts-check: SUCCESS (35.693s)
[433.178569] [093/133] (588s left) i915_pm_freq_api (freq-basic-api)
[433.238204] Starting subtest: freq-basic-api
[433.240468] Starting dynamic subtest: gt0
[433.242351] Dynamic subtest gt0: SUCCESS (0.004s)
[433.255022] Starting dynamic subtest: gt1
[433.257199] Dynamic subtest gt1: SUCCESS (0.004s)
[433.259290] Subtest freq-basic-api: SUCCESS (0.009s)
[433.367926] [094/133] (588s left) gen7_exec_parse (chained-batch)
[433.426434] Subtest chained-batch: SKIP (0.000s)
[433.509893] [095/133] (588s left) kms_big_fb (x-tiled-addfb-size-overflow)
[433.605121] Starting subtest: x-tiled-addfb-size-overflow
[433.607455] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.000s)
[433.710241] [096/133] (588s left) prime_busy (before)
[433.771766] Starting subtest: before
[433.776919] Starting dynamic subtest: rcs0
[433.812411] Dynamic subtest rcs0: SUCCESS (0.036s)
[433.826404] Starting dynamic subtest: bcs0
[433.859872] Dynamic subtest bcs0: SUCCESS (0.046s)
[433.873650] Starting dynamic subtest: vcs0
[433.899330] Dynamic subtest vcs0: SUCCESS (0.040s)
[433.910214] Starting dynamic subtest: vcs1
[433.940693] Dynamic subtest vcs1: SUCCESS (0.041s)
[433.952092] Starting dynamic subtest: vecs0
[433.981640] Dynamic subtest vecs0: SUCCESS (0.040s)
[433.992998] Starting dynamic subtest: ccs0
[434.022837] Dynamic subtest ccs0: SUCCESS (0.040s)
[434.131131] Subtest before: SUCCESS (0.357s)
[434.213209] [097/133] (587s left) gem_exec_balancer (bonded-false-hang)
[434.483982] Starting subtest: bonded-false-hang
[434.488708] Subtest bonded-false-hang: SKIP (0.000s)
[434.581167] [098/133] (587s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt)
[434.680059] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt
[434.684169] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[434.780369] [099/133] (587s left) vgem_basic (busy-fence)
[434.831752] Starting subtest: busy-fence
[434.833650] Subtest busy-fence: SUCCESS (0.000s)
[434.891617] [100/133] (587s left) kms_big_fb (x-tiled-8bpp-rotate-0)
[434.983027] Starting subtest: x-tiled-8bpp-rotate-0
[436.196579] Subtest x-tiled-8bpp-rotate-0: SUCCESS (1.214s)
[436.344570] [101/133] (586s left) perf (polling)
[436.499554] Starting subtest: polling
[436.501153] Starting dynamic subtest: 0-rcs0
[446.522052] Dynamic subtest 0-rcs0: SUCCESS (10.024s)
[446.534949] Starting dynamic subtest: 1-vecs0
[456.543662] Dynamic subtest 1-vecs0: SUCCESS (10.023s)
[456.546526] Subtest polling: SUCCESS (20.049s)
[456.598210] [102/133] (565s left) gem_ctx_persistence (legacy-engines-cleanup)
[456.649238] Starting subtest: legacy-engines-cleanup
[456.651626] Starting dynamic subtest: render
[456.725990] Dynamic subtest render: SUCCESS (0.074s)
[456.739681] Starting dynamic subtest: bsd1
[456.774578] Dynamic subtest bsd1: SUCCESS (0.046s)
[456.787058] Starting dynamic subtest: bsd2
[456.824936] Dynamic subtest bsd2: SUCCESS (0.048s)
[456.841090] Starting dynamic subtest: blt
[456.879887] Dynamic subtest blt: SUCCESS (0.052s)
[456.893200] Starting dynamic subtest: vebox
[456.917890] Dynamic subtest vebox: SUCCESS (0.035s)
[456.920584] Subtest legacy-engines-cleanup: SUCCESS (0.269s)
[457.005148] [103/133] (565s left) gem_exec_suspend (basic-s3-devices)
[457.067845] Starting subtest: basic-S3-devices
[457.070213] Starting dynamic subtest: smem
[467.672209] Dynamic subtest smem: SUCCESS (10.605s)
[467.675020] Subtest basic-S3-devices: SUCCESS (10.607s)
[467.862356] [104/133] (554s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s
[468.002440] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size
[468.007048] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s)
[468.151326] [105/133] (554s left) kms_psr (fbc-psr2-basic)
[468.250001] Starting subtest: fbc-psr2-basic
[468.252255] Starting dynamic subtest: eDP-1
[468.256302] Dynamic subtest eDP-1: SKIP (0.000s)
[468.260392] Subtest fbc-psr2-basic: SKIP (0.001s)
[468.326500] [106/133] (554s left) kms_addfb_basic (invalid-get-prop)
[468.379317] Starting subtest: invalid-get-prop
[468.381517] Subtest invalid-get-prop: SUCCESS (0.000s)
[468.522097] [107/133] (554s left) kms_pm_rpm (pm-tiling)
[470.754329] Starting subtest: pm-tiling
[470.759840] Subtest pm-tiling: SKIP (0.000s)
[471.158506] [108/133] (551s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[471.206532] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[471.273126] [109/133] (551s left) gem_exec_params (rel-constants-invalid-rel-gen5)
[471.322172] Starting subtest: rel-constants-invalid-rel-gen5
[471.324466] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s)
[471.414656] [110/133] (551s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-move)
[471.520355] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-move
[471.524277] Subtest fbcpsr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[471.634013] [111/133] (551s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite)
[471.731555] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite
[471.736015] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[471.834325] [112/133] (551s left) gem_exec_reloc (basic-cpu-wc-noreloc)
[471.888586] Subtest basic-cpu-wc-noreloc: SKIP (0.000s)
[471.966880] [113/133] (550s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf)
[472.055896] Starting subtest: psr2-overlay-plane-update-continuous-sf
[472.058302] Starting dynamic subtest: pipe-A-eDP-1
[473.193341] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.140s)
[473.205628] Starting dynamic subtest: pipe-B-eDP-1
[474.977843] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.786s)
[474.980686] Subtest psr2-overlay-plane-update-continuous-sf: SUCCESS (2.929s)
[475.812812] [114/133] (547s left) syncobj_timeline (multi-wait-available-submitted)
[475.872078] Starting subtest: multi-wait-available-submitted
[475.874470] Subtest multi-wait-available-submitted: SUCCESS (0.000s)
[475.968137] [115/133] (547s left) perf_pmu (interrupts-sync)
[476.007227] Starting subtest: interrupts-sync
[477.118589] Subtest interrupts-sync: SUCCESS (1.111s)
[477.247034] [116/133] (545s left) gem_softpin (zero)
[477.308690] Starting subtest: zero
[477.312971] Subtest zero: SUCCESS (0.005s)
[477.456082] [117/133] (545s left) i915_drm_fdinfo (memory-info-active)
[477.498614] Starting subtest: memory-info-active
[477.501044] Starting dynamic subtest: smem0
[480.190880] Dynamic subtest smem0: SUCCESS (2.693s)
[480.193334] Subtest memory-info-active: SUCCESS (2.695s)
[480.283458] [118/133] (542s left) gem_exec_flush (basic-wb-pro-default)
[480.339659] Starting subtest: basic-wb-pro-default
[485.811356] Subtest basic-wb-pro-default: SUCCESS (5.471s)
[486.000970] [119/133] (537s left) gem_eio (in-flight-contexts-immediate)
[486.249346] Starting subtest: in-flight-contexts-immediate
[499.695550] Subtest in-flight-contexts-immediate: SUCCESS (13.446s)
[499.818574] [120/133] (523s left) kms_draw_crc (draw-method-mmap-cpu)
[499.917106] Starting subtest: draw-method-mmap-cpu
[499.919335] Starting dynamic subtest: xrgb8888-untiled
[500.182254] Dynamic subtest xrgb8888-untiled: SUCCESS (0.267s)
[500.194332] Starting dynamic subtest: rgb565-untiled
[500.415465] Dynamic subtest rgb565-untiled: SUCCESS (0.232s)
[500.427566] Starting dynamic subtest: xrgb2101010-untiled
[500.638636] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s)
[500.652413] Starting dynamic subtest: xbgr16161616f-untiled
[500.859431] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.221s)
[500.871187] Starting dynamic subtest: xrgb8888-xtiled
[500.992931] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.133s)
[501.004362] Starting dynamic subtest: rgb565-xtiled
[501.126287] Dynamic subtest rgb565-xtiled: SUCCESS (0.132s)
[501.139445] Starting dynamic subtest: xrgb2101010-xtiled
[501.248505] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.122s)
[501.260009] Starting dynamic subtest: xbgr16161616f-xtiled
[501.381601] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.133s)
[501.393477] Starting dynamic subtest: xrgb8888-4tiled
[501.526666] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.144s)
[501.538471] Starting dynamic subtest: rgb565-4tiled
[501.670618] Dynamic subtest rgb565-4tiled: SUCCESS (0.143s)
[501.682174] Starting dynamic subtest: xrgb2101010-4tiled
[501.815171] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.143s)
[501.827539] Starting dynamic subtest: xbgr16161616f-4tiled
[501.959569] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.144s)
[501.961355] Subtest draw-method-mmap-cpu: SUCCESS (2.045s)
[502.069687] [121/133] (521s left) kms_selftest (drm_dp_mst_helper)
[502.107732] Starting subtest: drm_dp_mst_helper
[502.152969] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[502.235617] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.084s)
[502.249271] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[502.353966] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.116s)
[502.365555] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[502.458408] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.105s)
[502.460018] Subtest drm_dp_mst_helper: SUCCESS (0.350s)
[502.623651] [122/133] (520s left) kms_psr (psr-cursor-mmap-cpu)
[502.719240] Starting subtest: psr-cursor-mmap-cpu
[502.721129] Starting dynamic subtest: eDP-1
[504.499705] Dynamic subtest eDP-1: SUCCESS (1.778s)
[504.502167] Subtest psr-cursor-mmap-cpu: SUCCESS (1.779s)
[505.373726] [123/133] (517s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[505.486846] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[505.491055] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.000s)
[505.576910] [124/133] (517s left) kms_properties (crtc-properties-atomic)
[505.663565] Starting subtest: crtc-properties-atomic
[505.665801] Starting dynamic subtest: pipe-A-eDP-1
[506.114129] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.450s)
[506.126201] Starting dynamic subtest: pipe-B-eDP-1
[507.232974] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.117s)
[507.244934] Starting dynamic subtest: pipe-C-eDP-1
[508.372773] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.140s)
[508.385496] Starting dynamic subtest: pipe-D-eDP-1
[509.494412] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.122s)
[509.496757] Subtest crtc-properties-atomic: SUCCESS (3.834s)
[510.305516] [125/133] (513s left) gem_exec_nop (basic-series)
[510.380227] Starting subtest: basic-series
[526.619615] Subtest basic-series: SUCCESS (16.247s)
[526.852460] [126/133] (496s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[526.985314] Starting subtest: flip-vs-cursor-varying-size
[536.111999] Subtest flip-vs-cursor-varying-size: SUCCESS (9.125s)
[536.930567] [127/133] (486s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[537.036215] Starting subtest: plane-downscale-factor-0-75-with-rotation
[537.038564] Starting dynamic subtest: pipe-A
[537.265029] Dynamic subtest pipe-A: SUCCESS (0.231s)
[537.277284] Starting dynamic subtest: pipe-B
[538.614045] Dynamic subtest pipe-B: SUCCESS (1.348s)
[538.628572] Starting dynamic subtest: pipe-C
[539.941942] Dynamic subtest pipe-C: SUCCESS (1.327s)
[539.953775] Starting dynamic subtest: pipe-D
[541.285331] Dynamic subtest pipe-D: SUCCESS (1.343s)
[541.287662] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (4.253s)
[542.482778] [128/133] (481s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[542.582204] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[543.406645] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.826s)
[543.571174] [129/133] (480s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[543.663262] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-wc
[543.667138] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[543.771211] [130/133] (479s left) gem_ctx_create (basic-files)
[543.832452] Starting subtest: basic-files
[545.841104] Subtest basic-files: SUCCESS (2.009s)
[547.654070] [131/133] (476s left) kms_cursor_crc (cursor-onscreen-256x85)
[547.940566] Starting subtest: cursor-onscreen-256x85
[547.992868] Subtest cursor-onscreen-256x85: SKIP (0.046s)
[548.181104] [132/133] (475s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[548.280258] Starting subtest: extended-pageflip-modeset-hang-oldfb
[548.282610] Starting dynamic subtest: pipe-A
[556.177013] Dynamic subtest pipe-A: SUCCESS (7.897s)
[556.189227] Starting dynamic subtest: pipe-D
[564.808609] Dynamic subtest pipe-D: SUCCESS (8.630s)
[564.810861] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.532s)
[565.650834] [133/133] (458s left) kms_rotation_crc (sprite-rotation-270)
[565.749072] Starting subtest: sprite-rotation-270
[565.753530] Subtest sprite-rotation-270: SKIP (0.001s)
[565.822227] Closing watchdogs
results: parsing output: 0/ for test: syncobj_timeline
results: parsing output: 1/ for test: gem_pxp
results: parsing output: 2/ for test: gem_exec_await
results: parsing output: 3/ for test: kms_psr2_sf
results: parsing output: 4/ for test: kms_psr2_sf
results: parsing output: 5/ for test: gem_exec_schedule
results: parsing output: 6/ for test: prime_vgem
results: parsing output: 7/ for test: gem_exec_store
results: parsing output: 8/ for test: perf_pmu
results: parsing output: 9/ for test: gem_lmem_swapping
results: parsing output: 10/ for test: kms_rmfb
results: parsing output: 11/ for test: syncobj_basic
results: parsing output: 12/ for test: perf_pmu
results: parsing output: 13/ for test: kms_getfb
results: parsing output: 14/ for test: gem_exec_capture
results: parsing output: 15/ for test: perf_pmu
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: syncobj_timeline
results: parsing output: 18/ for test: kms_ccs
results: parsing output: 19/ for test: kms_chamelium_edid
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: gem_mmap_offset
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: gem_exec_schedule
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: gen7_exec_parse
results: parsing output: 26/ for test: dumb_buffer
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: syncobj_timeline
results: parsing output: 29/ for test: kms_lease
results: parsing output: 30/ for test: kms_ccs
results: parsing output: 31/ for test: i915_query
results: parsing output: 32/ for test: gem_exec_flush
results: parsing output: 33/ for test: kms_chamelium_hpd
results: parsing output: 34/ for test: gem_ppgtt
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: syncobj_wait
results: parsing output: 38/ for test: kms_flip
results: parsing output: 39/ for test: kms_frontbuffer_tracking
results: parsing output: 40/ for test: gem_exec_fence
results: parsing output: 41/ for test: kms_ccs
results: parsing output: 42/ for test: kms_psr
results: parsing output: 43/ for test: kms_properties
results: parsing output: 44/ for test: kms_cursor_legacy
results: parsing output: 45/ for test: kms_cursor_crc
results: parsing output: 46/ for test: gem_exercise_blt
results: parsing output: 47/ for test: gem_ctx_shared
results: parsing output: 48/ for test: kms_atomic
results: parsing output: 49/ for test: kms_plane
results: parsing output: 50/ for test: syncobj_timeline
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: syncobj_wait
results: parsing output: 53/ for test: kms_big_fb
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: gem_eio
results: parsing output: 56/ for test: gem_ccs
results: parsing output: 57/ for test: kms_big_fb
results: parsing output: 58/ for test: kms_plane_alpha_blend
results: parsing output: 59/ for test: kms_ccs
results: parsing output: 60/ for test: kms_plane_lowres
results: parsing output: 61/ for test: core_debugfs
results: parsing output: 62/ for test: gem_render_copy
results: parsing output: 63/ for test: kms_color_pipeline
results: parsing output: 64/ for test: gem_ccs
results: parsing output: 65/ for test: kms_psr
results: parsing output: 66/ for test: kms_vblank
results: parsing output: 67/ for test: kms_pm_backlight
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: sw_sync
results: parsing output: 70/ for test: syncobj_wait
results: parsing output: 71/ for test: kms_hdr
results: parsing output: 72/ for test: gem_ctx_isolation
results: parsing output: 73/ for test: kms_psr
results: parsing output: 74/ for test: kms_frontbuffer_tracking
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: prime_mmap
results: parsing output: 77/ for test: kms_cursor_crc
results: parsing output: 78/ for test: gem_exec_params
results: parsing output: 79/ for test: kms_addfb_basic
results: parsing output: 80/ for test: sw_sync
results: parsing output: 81/ for test: i915_suspend
results: parsing output: 82/ for test: kms_plane_scaling
results: parsing output: 83/ for test: kms_flip
results: parsing output: 84/ for test: gem_exec_fence
results: parsing output: 85/ for test: i915_pm_rpm
results: parsing output: 86/ for test: kms_addfb_basic
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: kms_content_protection
results: parsing output: 89/ for test: gem_linear_blits
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: kms_flip
results: parsing output: 92/ for test: i915_pm_freq_api
results: parsing output: 93/ for test: gen7_exec_parse
results: parsing output: 94/ for test: kms_big_fb
results: parsing output: 95/ for test: prime_busy
results: parsing output: 96/ for test: gem_exec_balancer
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: vgem_basic
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: perf
results: parsing output: 101/ for test: gem_ctx_persistence
results: parsing output: 102/ for test: gem_exec_suspend
results: parsing output: 103/ for test: kms_cursor_legacy
results: parsing output: 104/ for test: kms_psr
results: parsing output: 105/ for test: kms_addfb_basic
results: parsing output: 106/ for test: kms_pm_rpm
results: parsing output: 107/ for test: kms_pipe_b_c_ivb
results: parsing output: 108/ for test: gem_exec_params
results: parsing output: 109/ for test: kms_frontbuffer_tracking
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: gem_exec_reloc
results: parsing output: 112/ for test: kms_psr2_sf
results: parsing output: 113/ for test: syncobj_timeline
results: parsing output: 114/ for test: perf_pmu
results: parsing output: 115/ for test: gem_softpin
results: parsing output: 116/ for test: i915_drm_fdinfo
results: parsing output: 117/ for test: gem_exec_flush
results: parsing output: 118/ for test: gem_eio
results: parsing output: 119/ for test: kms_draw_crc
results: parsing output: 120/ for test: kms_selftest
results: parsing output: 121/ for test: kms_psr
results: parsing output: 122/ for test: kms_flip_scaled_crc
results: parsing output: 123/ for test: kms_properties
results: parsing output: 124/ for test: gem_exec_nop
results: parsing output: 125/ for test: kms_cursor_legacy
results: parsing output: 126/ for test: kms_plane_scaling
results: parsing output: 127/ for test: kms_big_fb
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: gem_ctx_create
results: parsing output: 130/ for test: kms_cursor_crc
results: parsing output: 131/ for test: kms_busy
results: parsing output: 132/ for test: kms_rotation_crc
Done.