[58.519677] Initializing watchdogs
[58.519720]   /dev/watchdog0
[58.534701] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[58.539249] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[58.541317] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[58.543860] [001/132] (960s left) gem_pxp (verify-pxp-stale-ctx-execution)
[58.672883] Starting subtest: verify-pxp-stale-ctx-execution
[59.742428] Subtest verify-pxp-stale-ctx-execution: SUCCESS (1.066s)
[59.911065] [002/132] (959s left) kms_color_pipeline (plane-lut1d-lut1d)
[60.013030] Starting subtest: plane-lut1d-lut1d
[60.040794] Starting dynamic subtest: pipe-A-eDP-1
[60.523042] Dynamic subtest pipe-A-eDP-1: FAIL (0.334s)
[61.486323] Starting dynamic subtest: pipe-B-eDP-1
[61.991661] Dynamic subtest pipe-B-eDP-1: FAIL (0.313s)
[62.939652] Starting dynamic subtest: pipe-C-eDP-1
[63.415419] Dynamic subtest pipe-C-eDP-1: FAIL (0.257s)
[64.273598] Starting dynamic subtest: pipe-D-eDP-1
[64.718957] Dynamic subtest pipe-D-eDP-1: FAIL (0.236s)
[64.805307] Subtest plane-lut1d-lut1d: FAIL (4.776s)
[65.681075] [003/132] (953s left) template (a)
[65.739442] Starting subtest: A
[65.740532] Subtest A: SUCCESS (0.000s)
[65.868553] [004/132] (953s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling)
[65.964893] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling
[65.965869] Starting dynamic subtest: pipe-A-default-mode
[68.724102] Dynamic subtest pipe-A-default-mode: SUCCESS (2.753s)
[68.725141] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.755s)
[69.565675] [005/132] (949s left) gem_mmap_offset (partial-remap)
[69.625136] Starting subtest: partial-remap
[69.626369] Starting dynamic subtest: smem0
[69.635510] Dynamic subtest smem0: SUCCESS (0.007s)
[69.636368] Subtest partial-remap: SUCCESS (0.008s)
[69.778549] [006/132] (949s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[70.146397] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[70.958315] [007/132] (948s left) kms_frontbuffer_tracking (fbc-tiling-y)
[71.045443] Starting subtest: fbc-tiling-y
[71.047063] Subtest fbc-tiling-y: SKIP (0.000s)
[71.154102] [008/132] (948s left) kms_cursor_legacy (flip-vs-cursor-varying-size)
[71.275765] Starting subtest: flip-vs-cursor-varying-size
[79.930771] Subtest flip-vs-cursor-varying-size: SUCCESS (8.649s)
[80.747729] [009/132] (938s left) kms_plane_cursor (primary)
[80.840418] Starting subtest: primary
[80.842465] Starting dynamic subtest: pipe-A-eDP-1-size-64
[83.428439] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.586s)
[83.451500] Starting dynamic subtest: pipe-A-eDP-1-size-128
[86.020099] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.572s)
[86.044306] Starting dynamic subtest: pipe-A-eDP-1-size-256
[88.579612] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.540s)
[88.909527] Starting dynamic subtest: pipe-B-eDP-1-size-64
[92.209611] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.306s)
[92.234319] Starting dynamic subtest: pipe-B-eDP-1-size-128
[94.779517] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.549s)
[94.803301] Starting dynamic subtest: pipe-B-eDP-1-size-256
[97.336131] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.538s)
[97.670147] Starting dynamic subtest: pipe-C-eDP-1-size-64
[100.658466] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.993s)
[100.684307] Starting dynamic subtest: pipe-C-eDP-1-size-128
[102.947952] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.269s)
[102.973266] Starting dynamic subtest: pipe-C-eDP-1-size-256
[105.126396] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.158s)
[105.445378] Starting dynamic subtest: pipe-D-eDP-1-size-64
[108.331768] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.892s)
[108.357419] Starting dynamic subtest: pipe-D-eDP-1-size-128
[110.520822] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.169s)
[110.546740] Starting dynamic subtest: pipe-D-eDP-1-size-256
[112.721172] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.180s)
[113.031975] Subtest primary: SUCCESS (32.179s)
[113.894842] [010/132] (905s left) gem_ctx_persistence (saturated-hostile)
[113.961375] Starting subtest: saturated-hostile
[113.962277] Starting dynamic subtest: rcs0
[114.825400] Dynamic subtest rcs0: SUCCESS (0.863s)
[114.835371] Starting dynamic subtest: bcs0
[115.636951] Dynamic subtest bcs0: SUCCESS (0.809s)
[115.647602] Starting dynamic subtest: vcs0
[116.444808] Dynamic subtest vcs0: SUCCESS (0.803s)
[116.451081] Starting dynamic subtest: vcs1
[117.267821] Dynamic subtest vcs1: SUCCESS (0.823s)
[117.277583] Starting dynamic subtest: vecs0
[118.081640] Dynamic subtest vecs0: SUCCESS (0.812s)
[118.091726] Starting dynamic subtest: ccs0
[118.900634] Dynamic subtest ccs0: SUCCESS (0.817s)
[118.901806] Subtest saturated-hostile: SUCCESS (4.939s)
[118.995599] [011/132] (900s left) gem_ctx_shared (q-out-order)
[119.053909] Starting subtest: Q-out-order
[119.054905] Starting dynamic subtest: rcs0
[119.247857] Dynamic subtest rcs0: SUCCESS (0.191s)
[119.261612] Starting dynamic subtest: vcs0
[119.350897] Dynamic subtest vcs0: SUCCESS (0.103s)
[119.364650] Starting dynamic subtest: vcs1
[119.457029] Dynamic subtest vcs1: SUCCESS (0.106s)
[119.470883] Starting dynamic subtest: vecs0
[119.557694] Dynamic subtest vecs0: SUCCESS (0.100s)
[119.572073] Starting dynamic subtest: ccs0
[119.674614] Dynamic subtest ccs0: SUCCESS (0.116s)
[119.676584] Subtest Q-out-order: SUCCESS (0.620s)
[121.055473] [FACT gem_ctx_shared (q-out-order)] new: kernel.kmod_is_loaded.vgem: true
[121.057431] [012/132] (898s left) gem_exec_params (larger-than-life-batch)
[121.114194] Starting subtest: larger-than-life-batch
[123.385649] Subtest larger-than-life-batch: SUCCESS (2.271s)
[123.989274] [013/132] (895s left) gem_mmap_offset (pf-nonblock)
[124.077463] Starting subtest: pf-nonblock
[124.088680] Subtest pf-nonblock: SUCCESS (0.012s)
[124.248624] [014/132] (895s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-rc-ccs)
[124.339158] Starting subtest: crc-primary-suspend-4-tiled-dg2-rc-ccs
[124.340066] Starting dynamic subtest: pipe-A-eDP-1
[124.343594] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[124.350221] Starting dynamic subtest: pipe-B-eDP-1
[124.353705] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[124.360249] Starting dynamic subtest: pipe-C-eDP-1
[124.363763] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[124.370041] Starting dynamic subtest: pipe-D-eDP-1
[124.373664] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[124.375452] Subtest crc-primary-suspend-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[126.662080] [015/132] (892s left) vgem_basic (bad-flag)
[126.697947] Starting subtest: bad-flag
[126.698920] Subtest bad-flag: SUCCESS (0.000s)
[126.772097] [016/132] (892s left) vgem_basic (dmabuf-fence-before)
[126.809117] Starting subtest: dmabuf-fence-before
[126.810055] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[126.882201] [017/132] (892s left) gem_eio (wait-1us)
[127.105535] Starting subtest: wait-1us
[127.438532] Subtest wait-1us: SUCCESS (0.334s)
[127.602924] [018/132] (891s left) kms_pm_rpm (pm-caching)
[129.141061] Starting subtest: pm-caching
[129.144449] Subtest pm-caching: SKIP (0.000s)
[129.896355] [019/132] (889s left) gem_exec_balancer (bonded-pair)
[129.964405] Starting subtest: bonded-pair
[129.966253] Subtest bonded-pair: SKIP (0.000s)
[130.289970] [020/132] (889s left) kms_psr (fbc-psr-suspend)
[130.378029] Starting subtest: fbc-psr-suspend
[130.379040] Starting dynamic subtest: eDP-1
[130.380878] Dynamic subtest eDP-1: SKIP (0.000s)
[130.382669] Subtest fbc-psr-suspend: SKIP (0.002s)
[130.491371] [021/132] (889s left) gem_exec_reloc (basic-wc)
[130.552897] Subtest basic-wc: SKIP (0.000s)
[130.637147] [022/132] (889s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-gtt)
[130.727858] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-gtt
[130.729472] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[130.868606] [023/132] (888s left) i915_drm_fdinfo (memory-info-purgeable)
[130.912266] Starting subtest: memory-info-purgeable
[130.913133] Starting dynamic subtest: smem0
[133.491550] Dynamic subtest smem0: SUCCESS (2.578s)
[133.492664] Subtest memory-info-purgeable: SUCCESS (2.580s)
[133.603979] [024/132] (886s left) kms_hdr (invalid-hdr)
[133.700953] Starting subtest: invalid-hdr
[135.788965] Starting dynamic subtest: pipe-A-eDP-1
[138.777293] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.988s)
[138.778422] Subtest invalid-hdr: SUCCESS (5.077s)
[138.923754] [025/132] (880s left) kms_flip_tiling (flip-change-tiling)
[139.015450] Starting subtest: flip-change-tiling
[139.016452] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs
[140.266685] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.251s)
[140.276906] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs
[140.401732] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.131s)
[140.414338] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[140.546288] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.142s)
[140.556322] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-4
[140.688881] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-4: SUCCESS (0.142s)
[140.700499] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-x
[140.832753] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s)
[140.844122] Starting dynamic subtest: pipe-A-eDP-1-4-mc-ccs-to-linear
[140.977581] Dynamic subtest pipe-A-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.143s)
[140.992279] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs
[141.122310] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.141s)
[141.133089] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs
[141.233404] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s)
[141.243615] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[141.368734] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[141.378542] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-4
[141.511456] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-4: SUCCESS (0.142s)
[141.522748] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-x
[141.655165] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s)
[141.665736] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-to-linear
[141.799474] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s)
[141.810086] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[141.933576] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s)
[141.945089] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[142.079991] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.142s)
[142.090338] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[142.189055] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.109s)
[142.200581] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-4
[142.333706] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.142s)
[142.345354] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-x
[142.477538] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.142s)
[142.488541] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-cc-to-linear
[142.621941] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s)
[142.632923] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-mc-ccs
[142.766992] Dynamic subtest pipe-A-eDP-1-4-to-4-mc-ccs: SUCCESS (0.142s)
[142.778537] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs
[142.911408] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs: SUCCESS (0.142s)
[142.922790] Starting dynamic subtest: pipe-A-eDP-1-4-to-4-rc-ccs-cc
[143.055845] Dynamic subtest pipe-A-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.142s)
[143.067746] Starting dynamic subtest: pipe-A-eDP-1-4-to-4
[143.177962] Dynamic subtest pipe-A-eDP-1-4-to-4: SUCCESS (0.120s)
[143.189777] Starting dynamic subtest: pipe-A-eDP-1-4-to-x
[143.322875] Dynamic subtest pipe-A-eDP-1-4-to-x: SUCCESS (0.143s)
[143.334317] Starting dynamic subtest: pipe-A-eDP-1-4-to-linear
[143.466357] Dynamic subtest pipe-A-eDP-1-4-to-linear: SUCCESS (0.142s)
[143.477789] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-mc-ccs
[143.611043] Dynamic subtest pipe-A-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s)
[143.621371] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs
[143.755429] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s)
[143.766864] Starting dynamic subtest: pipe-A-eDP-1-x-to-4-rc-ccs-cc
[143.899827] Dynamic subtest pipe-A-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s)
[143.911038] Starting dynamic subtest: pipe-A-eDP-1-x-to-4
[144.044187] Dynamic subtest pipe-A-eDP-1-x-to-4: SUCCESS (0.142s)
[144.055145] Starting dynamic subtest: pipe-A-eDP-1-x-to-x
[144.167031] Dynamic subtest pipe-A-eDP-1-x-to-x: SUCCESS (0.120s)
[144.178564] Starting dynamic subtest: pipe-A-eDP-1-x-to-linear
[144.311443] Dynamic subtest pipe-A-eDP-1-x-to-linear: SUCCESS (0.142s)
[144.322057] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-mc-ccs
[144.455348] Dynamic subtest pipe-A-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s)
[144.466473] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs
[144.610926] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.153s)
[144.623212] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4-rc-ccs-cc
[144.755616] Dynamic subtest pipe-A-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s)
[144.766900] Starting dynamic subtest: pipe-A-eDP-1-linear-to-4
[144.899721] Dynamic subtest pipe-A-eDP-1-linear-to-4: SUCCESS (0.142s)
[144.910952] Starting dynamic subtest: pipe-A-eDP-1-linear-to-x
[145.044566] Dynamic subtest pipe-A-eDP-1-linear-to-x: SUCCESS (0.142s)
[145.055857] Starting dynamic subtest: pipe-A-eDP-1-linear-to-linear
[145.166665] Dynamic subtest pipe-A-eDP-1-linear-to-linear: SUCCESS (0.120s)
[145.221989] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs
[146.399061] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.187s)
[146.410404] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs
[146.533906] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.131s)
[146.543646] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[146.678271] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.142s)
[146.686393] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-4
[146.820934] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-4: SUCCESS (0.142s)
[146.831299] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-x
[146.965355] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-x: SUCCESS (0.142s)
[146.985808] Starting dynamic subtest: pipe-B-eDP-1-4-mc-ccs-to-linear
[147.120927] Dynamic subtest pipe-B-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.153s)
[147.132842] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs
[147.254662] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.131s)
[147.266296] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs
[147.365875] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.109s)
[147.376044] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[147.500965] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.131s)
[147.510892] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-4
[147.643777] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-4: SUCCESS (0.142s)
[147.655627] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-x
[147.787260] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-x: SUCCESS (0.142s)
[147.798102] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-to-linear
[147.931915] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.142s)
[147.942276] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[148.065787] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.131s)
[148.077659] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[148.201027] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.131s)
[148.211315] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[148.309744] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.109s)
[148.320721] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-4
[148.454346] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.143s)
[148.465546] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-x
[148.598320] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.141s)
[148.609263] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs-cc-to-linear
[148.742890] Dynamic subtest pipe-B-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.142s)
[148.754193] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-mc-ccs
[148.887345] Dynamic subtest pipe-B-eDP-1-4-to-4-mc-ccs: SUCCESS (0.142s)
[148.901690] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs
[149.032281] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs: SUCCESS (0.141s)
[149.042919] Starting dynamic subtest: pipe-B-eDP-1-4-to-4-rc-ccs-cc
[149.176544] Dynamic subtest pipe-B-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.141s)
[149.187693] Starting dynamic subtest: pipe-B-eDP-1-4-to-4
[149.298485] Dynamic subtest pipe-B-eDP-1-4-to-4: SUCCESS (0.120s)
[149.309172] Starting dynamic subtest: pipe-B-eDP-1-4-to-x
[149.453889] Dynamic subtest pipe-B-eDP-1-4-to-x: SUCCESS (0.152s)
[149.464761] Starting dynamic subtest: pipe-B-eDP-1-4-to-linear
[149.598403] Dynamic subtest pipe-B-eDP-1-4-to-linear: SUCCESS (0.142s)
[149.609269] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-mc-ccs
[149.742856] Dynamic subtest pipe-B-eDP-1-x-to-4-mc-ccs: SUCCESS (0.142s)
[149.753558] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs
[149.887347] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs: SUCCESS (0.142s)
[149.897163] Starting dynamic subtest: pipe-B-eDP-1-x-to-4-rc-ccs-cc
[150.031986] Dynamic subtest pipe-B-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.142s)
[150.042808] Starting dynamic subtest: pipe-B-eDP-1-x-to-4
[150.176441] Dynamic subtest pipe-B-eDP-1-x-to-4: SUCCESS (0.142s)
[150.187063] Starting dynamic subtest: pipe-B-eDP-1-x-to-x
[150.298439] Dynamic subtest pipe-B-eDP-1-x-to-x: SUCCESS (0.120s)
[150.308033] Starting dynamic subtest: pipe-B-eDP-1-x-to-linear
[150.443252] Dynamic subtest pipe-B-eDP-1-x-to-linear: SUCCESS (0.142s)
[150.454085] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-mc-ccs
[150.587461] Dynamic subtest pipe-B-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.142s)
[150.598958] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs
[150.754379] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.165s)
[150.769231] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4-rc-ccs-cc
[150.898939] Dynamic subtest pipe-B-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.142s)
[150.910930] Starting dynamic subtest: pipe-B-eDP-1-linear-to-4
[151.042729] Dynamic subtest pipe-B-eDP-1-linear-to-4: SUCCESS (0.142s)
[151.053977] Starting dynamic subtest: pipe-B-eDP-1-linear-to-x
[151.187914] Dynamic subtest pipe-B-eDP-1-linear-to-x: SUCCESS (0.142s)
[151.199448] Starting dynamic subtest: pipe-B-eDP-1-linear-to-linear
[151.310391] Dynamic subtest pipe-B-eDP-1-linear-to-linear: SUCCESS (0.120s)
[151.363283] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs
[152.629896] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.274s)
[152.640646] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs
[152.729817] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[152.738777] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[152.829825] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[152.840635] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-4
[152.940664] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-4: SUCCESS (0.109s)
[152.951839] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-x
[153.051619] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-x: SUCCESS (0.110s)
[153.065206] Starting dynamic subtest: pipe-C-eDP-1-4-mc-ccs-to-linear
[153.162786] Dynamic subtest pipe-C-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.109s)
[153.174071] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs
[153.263553] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.099s)
[153.275394] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs
[153.363669] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[153.373554] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[153.464539] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[153.474680] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-4
[153.574617] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-4: SUCCESS (0.109s)
[153.586477] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-x
[153.696110] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-x: SUCCESS (0.120s)
[153.706440] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-to-linear
[153.807073] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.109s)
[153.817323] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[153.907605] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.098s)
[153.918881] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[154.007784] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.098s)
[154.017316] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[154.107670] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.098s)
[154.117350] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-4
[154.229551] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.121s)
[154.239094] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-x
[154.340479] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.110s)
[154.351204] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs-cc-to-linear
[154.451597] Dynamic subtest pipe-C-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.109s)
[154.464841] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-mc-ccs
[154.563291] Dynamic subtest pipe-C-eDP-1-4-to-4-mc-ccs: SUCCESS (0.109s)
[154.576855] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs
[154.674440] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs: SUCCESS (0.108s)
[154.685639] Starting dynamic subtest: pipe-C-eDP-1-4-to-4-rc-ccs-cc
[154.785574] Dynamic subtest pipe-C-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.108s)
[154.796473] Starting dynamic subtest: pipe-C-eDP-1-4-to-4
[154.896143] Dynamic subtest pipe-C-eDP-1-4-to-4: SUCCESS (0.108s)
[154.906965] Starting dynamic subtest: pipe-C-eDP-1-4-to-x
[155.007175] Dynamic subtest pipe-C-eDP-1-4-to-x: SUCCESS (0.109s)
[155.017544] Starting dynamic subtest: pipe-C-eDP-1-4-to-linear
[155.118233] Dynamic subtest pipe-C-eDP-1-4-to-linear: SUCCESS (0.109s)
[155.129524] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-mc-ccs
[155.229384] Dynamic subtest pipe-C-eDP-1-x-to-4-mc-ccs: SUCCESS (0.109s)
[155.239828] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs
[155.329475] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs: SUCCESS (0.099s)
[155.340249] Starting dynamic subtest: pipe-C-eDP-1-x-to-4-rc-ccs-cc
[155.440573] Dynamic subtest pipe-C-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.109s)
[155.453891] Starting dynamic subtest: pipe-C-eDP-1-x-to-4
[155.590368] Dynamic subtest pipe-C-eDP-1-x-to-4: SUCCESS (0.148s)
[155.601546] Starting dynamic subtest: pipe-C-eDP-1-x-to-x
[155.701777] Dynamic subtest pipe-C-eDP-1-x-to-x: SUCCESS (0.109s)
[155.712863] Starting dynamic subtest: pipe-C-eDP-1-x-to-linear
[155.812815] Dynamic subtest pipe-C-eDP-1-x-to-linear: SUCCESS (0.109s)
[155.821560] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-mc-ccs
[155.912457] Dynamic subtest pipe-C-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.099s)
[155.920957] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs
[156.023592] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.110s)
[156.033677] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4-rc-ccs-cc
[156.134712] Dynamic subtest pipe-C-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.110s)
[156.145208] Starting dynamic subtest: pipe-C-eDP-1-linear-to-4
[156.256956] Dynamic subtest pipe-C-eDP-1-linear-to-4: SUCCESS (0.121s)
[156.266714] Starting dynamic subtest: pipe-C-eDP-1-linear-to-x
[156.368920] Dynamic subtest pipe-C-eDP-1-linear-to-x: SUCCESS (0.109s)
[156.384393] Starting dynamic subtest: pipe-C-eDP-1-linear-to-linear
[156.479687] Dynamic subtest pipe-C-eDP-1-linear-to-linear: SUCCESS (0.109s)
[156.520783] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs
[157.769402] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-mc-ccs: SUCCESS (1.256s)
[157.780510] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs
[157.869429] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs: SUCCESS (0.098s)
[157.879101] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc
[157.969387] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[157.980453] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-4
[158.069299] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-4: SUCCESS (0.098s)
[158.079055] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-x
[158.218651] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-x: SUCCESS (0.148s)
[158.228685] Starting dynamic subtest: pipe-D-eDP-1-4-mc-ccs-to-linear
[158.329635] Dynamic subtest pipe-D-eDP-1-4-mc-ccs-to-linear: SUCCESS (0.109s)
[158.339129] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs
[158.429869] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-mc-ccs: SUCCESS (0.099s)
[158.440092] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs
[158.530179] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs: SUCCESS (0.099s)
[158.540446] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc
[158.630025] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4-rc-ccs-cc: SUCCESS (0.098s)
[158.639873] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-4
[158.741315] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-4: SUCCESS (0.110s)
[158.753369] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-x
[158.852120] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-x: SUCCESS (0.109s)
[158.862983] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-to-linear
[158.963106] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-to-linear: SUCCESS (0.109s)
[158.973637] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs
[159.063210] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-mc-ccs: SUCCESS (0.098s)
[159.074193] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs
[159.163275] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs: SUCCESS (0.098s)
[159.173920] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc
[159.263263] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4-rc-ccs-cc: SUCCESS (0.098s)
[159.273943] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-4
[159.363126] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-4: SUCCESS (0.098s)
[159.374243] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-x
[159.474305] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-x: SUCCESS (0.109s)
[159.484561] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs-cc-to-linear
[159.585304] Dynamic subtest pipe-D-eDP-1-4-rc-ccs-cc-to-linear: SUCCESS (0.109s)
[159.596018] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-mc-ccs
[159.696583] Dynamic subtest pipe-D-eDP-1-4-to-4-mc-ccs: SUCCESS (0.109s)
[159.707550] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs
[159.807962] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs: SUCCESS (0.109s)
[159.818059] Starting dynamic subtest: pipe-D-eDP-1-4-to-4-rc-ccs-cc
[159.907844] Dynamic subtest pipe-D-eDP-1-4-to-4-rc-ccs-cc: SUCCESS (0.098s)
[159.918953] Starting dynamic subtest: pipe-D-eDP-1-4-to-4
[160.018913] Dynamic subtest pipe-D-eDP-1-4-to-4: SUCCESS (0.109s)
[160.029825] Starting dynamic subtest: pipe-D-eDP-1-4-to-x
[160.140903] Dynamic subtest pipe-D-eDP-1-4-to-x: SUCCESS (0.119s)
[160.151336] Starting dynamic subtest: pipe-D-eDP-1-4-to-linear
[160.251999] Dynamic subtest pipe-D-eDP-1-4-to-linear: SUCCESS (0.110s)
[160.260891] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-mc-ccs
[160.363074] Dynamic subtest pipe-D-eDP-1-x-to-4-mc-ccs: SUCCESS (0.109s)
[160.373045] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs
[160.474271] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs: SUCCESS (0.110s)
[160.485978] Starting dynamic subtest: pipe-D-eDP-1-x-to-4-rc-ccs-cc
[160.574193] Dynamic subtest pipe-D-eDP-1-x-to-4-rc-ccs-cc: SUCCESS (0.099s)
[160.583415] Starting dynamic subtest: pipe-D-eDP-1-x-to-4
[160.685285] Dynamic subtest pipe-D-eDP-1-x-to-4: SUCCESS (0.110s)
[160.696065] Starting dynamic subtest: pipe-D-eDP-1-x-to-x
[160.796585] Dynamic subtest pipe-D-eDP-1-x-to-x: SUCCESS (0.110s)
[160.806233] Starting dynamic subtest: pipe-D-eDP-1-x-to-linear
[160.907548] Dynamic subtest pipe-D-eDP-1-x-to-linear: SUCCESS (0.110s)
[160.917493] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-mc-ccs
[161.018657] Dynamic subtest pipe-D-eDP-1-linear-to-4-mc-ccs: SUCCESS (0.110s)
[161.028639] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs
[161.130389] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs: SUCCESS (0.110s)
[161.139822] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4-rc-ccs-cc
[161.263154] Dynamic subtest pipe-D-eDP-1-linear-to-4-rc-ccs-cc: SUCCESS (0.132s)
[161.274556] Starting dynamic subtest: pipe-D-eDP-1-linear-to-4
[161.374318] Dynamic subtest pipe-D-eDP-1-linear-to-4: SUCCESS (0.109s)
[161.384900] Starting dynamic subtest: pipe-D-eDP-1-linear-to-x
[161.485710] Dynamic subtest pipe-D-eDP-1-linear-to-x: SUCCESS (0.109s)
[161.496636] Starting dynamic subtest: pipe-D-eDP-1-linear-to-linear
[161.596723] Dynamic subtest pipe-D-eDP-1-linear-to-linear: SUCCESS (0.109s)
[161.629843] Subtest flip-change-tiling: SUCCESS (22.615s)
[162.786517] [026/132] (857s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt)
[162.877097] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt
[170.516110] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.640s)
[170.691788] [027/132] (849s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[170.797340] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[171.611850] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.815s)
[171.823780] [028/132] (848s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-signa
[171.884640] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-signaled
[171.986065] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-signaled: SUCCESS (0.102s)
[172.079294] [029/132] (847s left) gem_exec_fence (syncobj-backward-timeline-chain-engines)
[172.641376] Starting subtest: syncobj-backward-timeline-chain-engines
[172.763315] Subtest syncobj-backward-timeline-chain-engines: SUCCESS (0.122s)
[174.035120] [030/132] (845s left) gem_exec_balancer (sliced)
[174.094304] Starting subtest: sliced
[174.096271] Subtest sliced: SKIP (0.000s)
[174.418785] [031/132] (845s left) perf (oa-exponents)
[174.560038] Starting subtest: oa-exponents
[174.560895] Starting dynamic subtest: 0-rcs0
[176.345584] Dynamic subtest 0-rcs0: SUCCESS (1.783s)
[176.353219] Starting dynamic subtest: 1-vcs0
[178.171463] Dynamic subtest 1-vcs0: SUCCESS (1.825s)
[178.173045] Subtest oa-exponents: SUCCESS (3.610s)
[178.211814] [032/132] (841s left) gem_userptr_blits (stress-mm)
[178.277537] Starting subtest: stress-mm
[183.647893] Subtest stress-mm: SUCCESS (5.369s)
[183.821667] [033/132] (836s left) gem_mmap_gtt (basic-short)
[183.879607] Subtest basic-short: SKIP (0.000s)
[183.948562] [034/132] (836s left) gen7_exec_parse (bitmasks)
[184.010687] Subtest bitmasks: SKIP (0.000s)
[184.083990] [035/132] (836s left) gem_exec_reloc (basic-cpu-wc)
[184.135430] Subtest basic-cpu-wc: SKIP (0.000s)
[184.204994] [036/132] (835s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip)
[184.313188] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip
[184.314923] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s)
[184.439399] [037/132] (835s left) kms_plane (plane-position-covered)
[184.527205] Starting subtest: plane-position-covered
[185.063422] Starting dynamic subtest: pipe-A-plane-1
[186.310145] Dynamic subtest pipe-A-plane-1: SUCCESS (1.247s)
[186.317474] Starting dynamic subtest: pipe-A-plane-2
[187.651308] Dynamic subtest pipe-A-plane-2: SUCCESS (1.340s)
[187.658905] Starting dynamic subtest: pipe-A-plane-3
[188.998074] Dynamic subtest pipe-A-plane-3: SUCCESS (1.346s)
[189.005823] Starting dynamic subtest: pipe-A-plane-4
[190.325185] Dynamic subtest pipe-A-plane-4: SUCCESS (1.326s)
[190.332789] Starting dynamic subtest: pipe-A-plane-5
[190.349972] Dynamic subtest pipe-A-plane-5: SUCCESS (0.025s)
[191.568898] Starting dynamic subtest: pipe-B-plane-1
[192.881783] Dynamic subtest pipe-B-plane-1: SUCCESS (1.320s)
[192.889304] Starting dynamic subtest: pipe-B-plane-2
[194.249613] Dynamic subtest pipe-B-plane-2: SUCCESS (1.367s)
[194.257680] Starting dynamic subtest: pipe-B-plane-3
[195.556313] Dynamic subtest pipe-B-plane-3: SUCCESS (1.305s)
[195.567555] Starting dynamic subtest: pipe-B-plane-4
[196.890278] Dynamic subtest pipe-B-plane-4: SUCCESS (1.334s)
[196.898971] Starting dynamic subtest: pipe-B-plane-5
[196.915078] Dynamic subtest pipe-B-plane-5: SUCCESS (0.023s)
[196.915947] Subtest plane-position-covered: SUCCESS (12.387s)
[197.785034] [038/132] (822s left) gem_exec_schedule (noreorder-corked)
[197.969766] Starting subtest: noreorder-corked
[197.970902] Starting dynamic subtest: rcs0
[199.127715] Dynamic subtest rcs0: SUCCESS (1.158s)
[199.139197] Starting dynamic subtest: vcs0
[200.929240] Dynamic subtest vcs0: SUCCESS (1.796s)
[200.938369] Starting dynamic subtest: vcs1
[202.877374] Dynamic subtest vcs1: SUCCESS (1.945s)
[202.885412] Starting dynamic subtest: vecs0
[204.916858] Dynamic subtest vecs0: SUCCESS (2.037s)
[204.930511] Starting dynamic subtest: ccs0
[206.081749] Dynamic subtest ccs0: SUCCESS (1.164s)
[206.083131] Subtest noreorder-corked: SUCCESS (8.113s)
[206.288499] [039/132] (813s left) kms_cursor_legacy (nonblocking-modeset-vs-cursor-atomic)
[206.419258] Starting subtest: nonblocking-modeset-vs-cursor-atomic
[207.847126] Subtest nonblocking-modeset-vs-cursor-atomic: SUCCESS (1.428s)
[208.745860] [040/132] (811s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[208.837317] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[208.838184] Starting dynamic subtest: pipe-A-eDP-1
[208.846217] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[208.853864] Starting dynamic subtest: pipe-B-eDP-1
[208.862124] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[208.872111] Starting dynamic subtest: pipe-C-eDP-1
[208.880263] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[208.887175] Starting dynamic subtest: pipe-D-eDP-1
[208.895542] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[208.897177] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[211.109424] [041/132] (809s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[211.356159] Starting subtest: cursor-rapid-movement-256x256
[211.358666] Starting dynamic subtest: pipe-A-eDP-1
[211.898808] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.540s)
[211.928368] Starting dynamic subtest: pipe-D-eDP-1
[213.100322] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.178s)
[213.101206] Subtest cursor-rapid-movement-256x256: SUCCESS (1.745s)
[213.985091] [042/132] (806s left) sw_sync (sync_multi_consumer_producer)
[214.021535] Starting subtest: sync_multi_consumer_producer
[214.302943] Subtest sync_multi_consumer_producer: SUCCESS (0.279s)
[214.380801] [043/132] (806s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[214.475494] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[214.477354] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s)
[214.602155] [044/132] (805s left) gem_lmem_swapping (massive)
[214.636404] Subtest massive: SKIP (0.000s)
[214.674164] [045/132] (805s left) perf_pmu (semaphore-busy)
[214.712951] Starting subtest: semaphore-busy
[214.713865] Starting dynamic subtest: rcs0
[216.390732] Dynamic subtest rcs0: SUCCESS (1.673s)
[216.401153] Starting dynamic subtest: bcs0
[218.024740] Dynamic subtest bcs0: SUCCESS (1.631s)
[218.035330] Starting dynamic subtest: vcs0
[222.416708] Dynamic subtest vcs0: SUCCESS (4.390s)
[222.426963] Starting dynamic subtest: vcs1
[228.433507] Dynamic subtest vcs1: SUCCESS (6.011s)
[228.443961] Starting dynamic subtest: vecs0
[234.384417] Dynamic subtest vecs0: SUCCESS (5.948s)
[234.393854] Starting dynamic subtest: ccs0
[237.520285] Dynamic subtest ccs0: SUCCESS (3.134s)
[237.521477] Subtest semaphore-busy: SUCCESS (22.805s)
[237.653288] [046/132] (782s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[237.760660] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[237.762350] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[237.888530] [047/132] (782s left) kms_pipe_b_c_ivb (pipe-b-dpms-off-modeset-pipe-c)
[237.945839] Subtest pipe-B-dpms-off-modeset-pipe-C: SKIP (0.000s)
[238.009163] [048/132] (782s left) kms_flip (2x-modeset-vs-vblank-race)
[238.098694] Starting subtest: 2x-modeset-vs-vblank-race
[238.110137] Subtest 2x-modeset-vs-vblank-race: SKIP (0.011s)
[238.207650] [049/132] (782s left) kms_flip (nonexisting-fb)
[238.302187] Starting subtest: nonexisting-fb
[238.303045] Starting dynamic subtest: A-eDP1
[239.463065] Dynamic subtest A-eDP1: SUCCESS (1.160s)
[239.471074] Starting dynamic subtest: B-eDP1
[240.594638] Dynamic subtest B-eDP1: SUCCESS (1.130s)
[240.605391] Starting dynamic subtest: C-eDP1
[241.735793] Dynamic subtest C-eDP1: SUCCESS (1.138s)
[241.744386] Starting dynamic subtest: D-eDP1
[242.873451] Dynamic subtest D-eDP1: SUCCESS (1.137s)
[242.876274] Subtest nonexisting-fb: SUCCESS (4.575s)
[244.160583] [050/132] (776s left) kms_psr (psr-basic)
[244.251202] Starting subtest: psr-basic
[244.252230] Starting dynamic subtest: eDP-1
[245.823859] Dynamic subtest eDP-1: SUCCESS (1.573s)
[245.824751] Subtest psr-basic: SUCCESS (1.574s)
[246.715879] [051/132] (773s left) kms_cursor_legacy (cursorb-vs-flipb-atomic)
[246.845087] Starting subtest: cursorB-vs-flipB-atomic
[246.846740] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s)
[247.010338] [052/132] (773s left) kms_cursor_crc (cursor-alpha-transparent)
[247.108221] Starting subtest: cursor-alpha-transparent
[247.109077] Starting dynamic subtest: pipe-A-eDP-1
[247.726856] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.618s)
[247.734749] Starting dynamic subtest: pipe-D-eDP-1
[248.987048] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.258s)
[248.987974] Subtest cursor-alpha-transparent: SUCCESS (1.879s)
[249.886858] [053/132] (770s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[249.976645] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[250.094427] [054/132] (770s left) gem_render_copy (yf-tiled-to-vebox-y-tiled)
[250.150200] Starting subtest: yf-tiled-to-vebox-y-tiled
[250.151941] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s)
[250.351592] [055/132] (770s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip)
[250.459581] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip
[250.461348] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[250.613227] [056/132] (770s left) kms_addfb_basic (bad-pitch-32)
[250.668921] Starting subtest: bad-pitch-32
[250.670257] Subtest bad-pitch-32: SUCCESS (0.000s)
[250.825147] [057/132] (770s left) kms_flip (flip-vs-rmfb)
[250.920093] Starting subtest: flip-vs-rmfb
[250.922084] Starting dynamic subtest: A-eDP1
[259.556113] Dynamic subtest A-eDP1: SUCCESS (8.634s)
[259.565737] Starting dynamic subtest: B-eDP1
[268.189679] Dynamic subtest B-eDP1: SUCCESS (8.630s)
[268.198749] Starting dynamic subtest: C-eDP1
[276.843120] Dynamic subtest C-eDP1: SUCCESS (8.652s)
[276.857728] Starting dynamic subtest: D-eDP1
[285.566861] Dynamic subtest D-eDP1: SUCCESS (8.722s)
[285.572174] Subtest flip-vs-rmfb: SUCCESS (34.653s)
[286.831443] [058/132] (734s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[286.934207] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[286.934978] Starting dynamic subtest: pipe-A-eDP-1
[286.943057] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[286.951069] Starting dynamic subtest: pipe-B-eDP-1
[286.959271] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[286.967401] Starting dynamic subtest: pipe-C-eDP-1
[286.975694] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[286.983069] Starting dynamic subtest: pipe-D-eDP-1
[286.991517] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[286.993115] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[289.207773] [059/132] (731s left) syncobj_wait (multi-wait-all-for-submit-signaled)
[289.255337] Starting subtest: multi-wait-all-for-submit-signaled
[289.256193] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s)
[289.383851] [060/132] (731s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[289.473109] Starting subtest: primary-4-tiled-reflect-x-0
[296.544415] Subtest primary-4-tiled-reflect-x-0: SUCCESS (7.072s)
[297.758336] [061/132] (723s left) gem_close (basic)
[297.821107] Starting subtest: basic
[297.822022] Subtest basic: SUCCESS (0.000s)
[297.935967] [062/132] (723s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[298.053473] Starting subtest: basic-flip-after-cursor-atomic
[298.967821] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.913s)
[299.797279] [063/132] (721s left) syncobj_timeline (multi-wait-for-submit-signaled)
[299.838634] Starting subtest: multi-wait-for-submit-signaled
[299.839602] Subtest multi-wait-for-submit-signaled: SUCCESS (0.001s)
[299.962147] [064/132] (721s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0)
[300.055039] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0
[301.090931] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.036s)
[301.275187] [065/132] (719s left) i915_suspend (basic-s3-without-i915)
[301.312559] Starting subtest: basic-s3-without-i915
[304.738905] Subtest basic-s3-without-i915: SKIP (3.422s)
[306.332140] [066/132] (714s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[306.424477] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[306.425448] Starting dynamic subtest: pipe-A-default-mode
[309.190595] Dynamic subtest pipe-A-default-mode: SUCCESS (2.765s)
[309.191537] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.767s)
[310.024957] [067/132] (711s left) i915_pm_rpm (system-suspend)
[312.066932] Starting subtest: system-suspend
[330.547589] Subtest system-suspend: SUCCESS (3.270s)
[336.946487] [068/132] (690s left) kms_vblank (query-forked-hang)
[337.049291] Starting subtest: query-forked-hang
[337.050705] Starting dynamic subtest: pipe-A-eDP-1
[363.992583] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.752s)
[364.006097] Starting dynamic subtest: pipe-D-eDP-1
[378.888136] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.887s)
[378.889455] Subtest query-forked-hang: SUCCESS (41.645s)
[379.699312] [069/132] (647s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[379.807246] Starting subtest: cursor-vs-flip-atomic
[409.179167] Subtest cursor-vs-flip-atomic: SUCCESS (29.361s)
[410.041700] [070/132] (617s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-blt)
[410.149193] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-blt
[410.151556] Subtest fbc-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[410.283103] [071/132] (617s left) gem_exec_schedule (submit-early-slice)
[410.349692] Starting subtest: submit-early-slice
[410.351025] Starting dynamic subtest: rcs0
[410.395598] Dynamic subtest rcs0: SUCCESS (0.045s)
[410.406583] Starting dynamic subtest: bcs0
[410.436687] Dynamic subtest bcs0: SUCCESS (0.040s)
[410.446555] Starting dynamic subtest: vcs0
[410.477059] Dynamic subtest vcs0: SUCCESS (0.040s)
[410.485894] Starting dynamic subtest: vcs1
[410.518853] Dynamic subtest vcs1: SUCCESS (0.041s)
[410.527033] Starting dynamic subtest: vecs0
[410.557363] Dynamic subtest vecs0: SUCCESS (0.038s)
[410.565952] Starting dynamic subtest: ccs0
[410.595927] Dynamic subtest ccs0: SUCCESS (0.037s)
[410.597300] Subtest submit-early-slice: SUCCESS (0.246s)
[412.219018] [072/132] (615s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[412.343791] Starting subtest: basic-flip-before-cursor-varying-size
[413.271515] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.928s)
[414.181625] [073/132] (613s left) syncobj_timeline (host-signal-ordered)
[414.236774] Starting subtest: host-signal-ordered
[414.237938] Subtest host-signal-ordered: SUCCESS (0.000s)
[414.366010] [074/132] (613s left) kms_big_fb (x-tiled-64bpp-rotate-0)
[414.476657] Starting subtest: x-tiled-64bpp-rotate-0
[416.077939] Subtest x-tiled-64bpp-rotate-0: SUCCESS (1.601s)
[416.266668] [075/132] (611s left) gem_userptr_blits (relocations)
[416.328723] Starting subtest: relocations
[416.331037] Subtest relocations: SKIP (0.000s)
[416.489804] [076/132] (611s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt)
[416.590932] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt
[423.987875] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (7.395s)
[424.122119] [077/132] (603s left) core_getversion (basic)
[424.160193] Starting subtest: basic
[424.162938] Subtest basic: SUCCESS (0.000s)
[424.244313] [078/132] (603s left) perf (enable-disable)
[424.383781] Starting subtest: enable-disable
[424.384662] Starting dynamic subtest: 0-rcs0
[426.662737] Dynamic subtest 0-rcs0: SUCCESS (2.278s)
[426.671079] Starting dynamic subtest: 1-vecs0
[431.140126] Dynamic subtest 1-vecs0: SUCCESS (4.474s)
[431.141594] Subtest enable-disable: SUCCESS (6.753s)
[431.184639] [079/132] (596s left) gem_softpin (allocator-nopin-reserve)
[431.240917] Starting subtest: allocator-nopin-reserve
[431.341100] Subtest allocator-nopin-reserve: SUCCESS (0.099s)
[431.498341] [080/132] (596s left) kms_multipipe_modeset (basic-max-pipe-crc-check)
[431.585913] Starting subtest: basic-max-pipe-crc-check
[431.588190] Subtest basic-max-pipe-crc-check: SKIP (0.000s)
[431.627892] [081/132] (596s left) kms_psr2_sf (fbc-pr-plane-move-sf-dmg-area)
[436.669689] Starting subtest: fbc-pr-plane-move-sf-dmg-area
[436.672277] Subtest fbc-pr-plane-move-sf-dmg-area: SKIP (0.002s)
[437.542909] [082/132] (590s left) api_intel_allocator (two-level-inception-interruptible)
[437.600614] Starting subtest: two-level-inception-interruptible
[443.011234] Subtest two-level-inception-interruptible: SUCCESS (5.411s)
[443.160756] [083/132] (584s left) kms_flip (wf_vblank-ts-check)
[443.260615] Starting subtest: wf_vblank-ts-check
[443.262675] Starting dynamic subtest: A-eDP1
[452.166314] Dynamic subtest A-eDP1: SUCCESS (8.905s)
[452.177402] Starting dynamic subtest: B-eDP1
[461.089589] Dynamic subtest B-eDP1: SUCCESS (8.923s)
[461.098162] Starting dynamic subtest: C-eDP1
[470.020819] Dynamic subtest C-eDP1: SUCCESS (8.930s)
[470.029277] Starting dynamic subtest: D-eDP1
[478.944261] Dynamic subtest D-eDP1: SUCCESS (8.922s)
[478.947698] Subtest wf_vblank-ts-check: SUCCESS (35.688s)
[480.189405] [084/132] (547s left) syncobj_timeline (wait-delayed-signal)
[480.245917] Starting subtest: wait-delayed-signal
[480.348130] Subtest wait-delayed-signal: SUCCESS (0.103s)
[480.444803] [085/132] (547s left) gem_cs_tlb (engines)
[480.501984] Starting subtest: engines
[480.503241] Starting dynamic subtest: rcs0
[482.657329] Dynamic subtest rcs0: SUCCESS (2.153s)
[482.668633] Starting dynamic subtest: bcs0
[484.816015] Dynamic subtest bcs0: SUCCESS (2.155s)
[484.827087] Starting dynamic subtest: vcs0
[486.968944] Dynamic subtest vcs0: SUCCESS (2.152s)
[486.979636] Starting dynamic subtest: vcs1
[489.125470] Dynamic subtest vcs1: SUCCESS (2.153s)
[489.135992] Starting dynamic subtest: vecs0
[491.279097] Dynamic subtest vecs0: SUCCESS (2.154s)
[491.295629] Starting dynamic subtest: ccs0
[493.432700] Dynamic subtest ccs0: SUCCESS (2.154s)
[493.433926] Subtest engines: SUCCESS (12.927s)
[493.569669] [086/132] (534s left) gem_tiled_blits (interruptible)
[493.619195] Subtest interruptible: SKIP (0.000s)
[493.678518] [087/132] (534s left) kms_joiner (basic-big-joiner)
[493.779037] Starting subtest: basic-big-joiner
[493.780833] Subtest basic-big-joiner: SKIP (0.000s)
[493.865966] [088/132] (534s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[493.947581] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[493.948939] Starting dynamic subtest: pipe-A-eDP-1
[493.963151] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[493.980986] Starting dynamic subtest: pipe-B-eDP-1
[493.994481] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[494.003461] Starting dynamic subtest: pipe-C-eDP-1
[494.015149] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[494.023121] Starting dynamic subtest: pipe-D-eDP-1
[494.033841] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[494.036092] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[496.163973] [089/132] (531s left) kms_cursor_crc (cursor-suspend)
[496.325259] Starting subtest: cursor-suspend
[496.326273] Starting dynamic subtest: pipe-A-eDP-1
[530.408323] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.093s)
[530.419240] Starting dynamic subtest: pipe-D-eDP-1
[565.360002] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.593s)
[565.360867] Subtest cursor-suspend: SUCCESS (8.690s)
[572.191754] [090/132] (461s left) gem_tiled_blits (basic)
[572.265457] Subtest basic: SKIP (0.000s)
[572.347636] [091/132] (461s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render)
[572.453941] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render
[572.455713] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[572.583614] [092/132] (461s left) gem_exec_reloc (basic-cpu-gtt-active)
[572.639736] Subtest basic-cpu-gtt-active: SKIP (0.000s)
[572.721447] [093/132] (461s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[572.818243] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[572.819954] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[572.957022] [094/132] (461s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[573.051752] Starting subtest: fbcpsr-rgb565-draw-blt
[580.263724] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (7.097s)
[580.410184] [095/132] (453s left) kms_cursor_crc (cursor-offscreen-64x21)
[580.608487] Starting subtest: cursor-offscreen-64x21
[580.652881] Subtest cursor-offscreen-64x21: SKIP (0.041s)
[580.912441] [096/132] (453s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-pwrite)
[581.014199] Starting subtest: psr-2p-primscrn-spr-indfb-draw-pwrite
[581.016030] Subtest psr-2p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[581.138179] [097/132] (453s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[581.237417] Starting subtest: fbc-rgb565-draw-blt
[585.452161] Subtest fbc-rgb565-draw-blt: SUCCESS (4.186s)
[586.681401] [098/132] (447s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[586.769032] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[590.390190] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.608s)
[591.587923] [099/132] (442s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[591.683639] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[591.685289] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[591.814997] [100/132] (442s left) api_intel_bb (full-batch)
[591.868995] Starting subtest: full-batch
[591.873770] Subtest full-batch: SUCCESS (0.006s)
[592.025847] [101/132] (442s left) perf (gen12-unprivileged-single-ctx-counters)
[592.127246] Starting subtest: gen12-unprivileged-single-ctx-counters
[592.128410] Starting dynamic subtest: rcs0
[592.377976] Dynamic subtest rcs0: SUCCESS (0.250s)
[592.380178] Subtest gen12-unprivileged-single-ctx-counters: SUCCESS (0.252s)
[592.425358] [102/132] (442s left) kms_psr (fbc-psr2-cursor-plane-onoff)
[592.560825] Starting subtest: fbc-psr2-cursor-plane-onoff
[592.561833] Starting dynamic subtest: eDP-1
[592.563668] Dynamic subtest eDP-1: SKIP (0.000s)
[592.565382] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s)
[592.656610] [103/132] (441s left) kms_psr (psr2-primary-mmap-cpu)
[592.748044] Starting subtest: psr2-primary-mmap-cpu
[592.748925] Starting dynamic subtest: eDP-1
[594.455536] Dynamic subtest eDP-1: SUCCESS (1.702s)
[594.456586] Subtest psr2-primary-mmap-cpu: SUCCESS (1.703s)
[595.344965] [104/132] (439s left) gem_exec_await (wide-all)
[595.551267] Starting subtest: wide-all
[619.412465] Subtest wide-all: SUCCESS (23.851s)
[619.631215] [105/132] (414s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[619.739979] Starting subtest: fb-8bpc-vs-panel-6bpc
[619.740850] Starting dynamic subtest: pipe-A-eDP-1
[621.104057] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.363s)
[621.104935] Subtest fb-8bpc-vs-panel-6bpc: SUCCESS (1.365s)
[621.924182] [106/132] (412s left) kms_chamelium_frames (dp-crc-single)
[622.295938] Subtest dp-crc-single: SKIP (0.000s)
[623.110869] [107/132] (411s left) gem_exec_whisper (basic-fds-priority-all)
[623.182633] Starting subtest: basic-fds-priority-all
[646.430731] Subtest basic-fds-priority-all: SUCCESS (23.240s)
[646.635866] [108/132] (388s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[646.745502] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[646.747387] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[646.884755] [109/132] (387s left) fbdev (unaligned-read)
[646.916738] Starting subtest: unaligned-read
[646.931960] Subtest unaligned-read: SUCCESS (0.015s)
[647.008634] [110/132] (387s left) gen3_render_tiledy_blits
[647.131700] [111/132] (387s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[647.247892] Starting subtest: cursorA-vs-flipA-toggle
[658.416844] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.164s)
[659.297670] [112/132] (375s left) gem_eio (in-flight-10ms)
[659.525963] Starting subtest: in-flight-10ms
[668.512263] Subtest in-flight-10ms: SUCCESS (8.982s)
[668.707642] [113/132] (366s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[668.808487] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[668.810324] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[668.931293] [114/132] (365s left) kms_pm_rpm (modeset-non-lpsp-stress-no-wait)
[670.659526] Starting subtest: modeset-non-lpsp-stress-no-wait
[670.717092] Subtest modeset-non-lpsp-stress-no-wait: SKIP (0.059s)
[671.226914] [115/132] (363s left) kms_atomic (plane-immutable-zpos)
[671.334369] Starting subtest: plane-immutable-zpos
[671.335341] Starting dynamic subtest: pipe-A-eDP-1
[671.997547] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.663s)
[671.998473] Subtest plane-immutable-zpos: SUCCESS (0.664s)
[672.854631] [116/132] (362s left) syncobj_timeline (invalid-transfer-non-existent-point)
[672.907955] Starting subtest: invalid-transfer-non-existent-point
[672.908858] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s)
[673.019689] [117/132] (361s left) kms_big_fb (4-tiled-64bpp-rotate-0)
[673.122364] Starting subtest: 4-tiled-64bpp-rotate-0
[674.689670] Subtest 4-tiled-64bpp-rotate-0: SUCCESS (1.568s)
[674.890694] [118/132] (360s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation)
[674.978234] Starting subtest: plane-downscale-factor-0-75-with-rotation
[674.979192] Starting dynamic subtest: pipe-A
[675.210586] Dynamic subtest pipe-A: SUCCESS (0.233s)
[675.228411] Starting dynamic subtest: pipe-B
[676.551477] Dynamic subtest pipe-B: SUCCESS (1.340s)
[676.561310] Starting dynamic subtest: pipe-C
[677.902926] Dynamic subtest pipe-C: SUCCESS (1.351s)
[677.913874] Starting dynamic subtest: pipe-D
[679.210960] Dynamic subtest pipe-D: SUCCESS (1.306s)
[679.211853] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (4.235s)
[680.399789] [119/132] (354s left) kms_cdclk (mode-transition-all-outputs)
[680.506335] Starting subtest: mode-transition-all-outputs
[680.794494] Subtest mode-transition-all-outputs: SKIP (0.288s)
[681.629346] [120/132] (353s left) kms_psr (fbc-pr-sprite-plane-move)
[681.718223] Starting subtest: fbc-pr-sprite-plane-move
[681.720107] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[681.811274] [121/132] (353s left) gem_ctx_persistence (engines-mixed-process)
[681.875219] Starting subtest: engines-mixed-process
[681.876205] Starting dynamic subtest: rcs0
[683.430104] Dynamic subtest rcs0: SUCCESS (1.556s)
[683.439518] Starting dynamic subtest: bcs0
[685.453421] Dynamic subtest bcs0: SUCCESS (2.023s)
[685.466323] Starting dynamic subtest: vcs0
[687.494396] Dynamic subtest vcs0: SUCCESS (2.039s)
[687.506144] Starting dynamic subtest: vcs1
[689.476581] Dynamic subtest vcs1: SUCCESS (1.980s)
[689.489244] Starting dynamic subtest: vecs0
[691.458401] Dynamic subtest vecs0: SUCCESS (1.980s)
[691.470739] Starting dynamic subtest: ccs0
[693.444617] Dynamic subtest ccs0: SUCCESS (1.984s)
[693.445728] Subtest engines-mixed-process: SUCCESS (11.572s)
[693.542470] [122/132] (341s left) kms_draw_crc (draw-method-mmap-gtt)
[693.639878] Starting subtest: draw-method-mmap-gtt
[693.641677] Subtest draw-method-mmap-gtt: SKIP (0.000s)
[693.771864] [123/132] (341s left) syncobj_wait (single-wait-all-submitted)
[693.828354] Starting subtest: single-wait-all-submitted
[693.934346] Subtest single-wait-all-submitted: SUCCESS (0.104s)
[694.027785] [124/132] (341s left) gem_lmem_swapping (verify-ccs)
[694.059240] Subtest verify-ccs: SKIP (0.000s)
[694.104939] [125/132] (341s left) i915_pm_freq_api (freq-suspend)
[694.178188] Starting subtest: freq-suspend
[694.179197] Starting dynamic subtest: gt0
[710.845261] Dynamic subtest gt0: SUCCESS (1.618s)
[710.868449] Starting dynamic subtest: gt1
[727.837396] Dynamic subtest gt1: SUCCESS (1.580s)
[727.838785] Subtest freq-suspend: SUCCESS (3.200s)
[735.942841] [126/132] (307s left) gem_eio (wait-immediate)
[736.166262] Starting subtest: wait-immediate
[736.526711] Subtest wait-immediate: SUCCESS (0.352s)
[736.712272] [127/132] (306s left) gem_vm_create (invalid-create)
[736.776226] Starting subtest: invalid-create
[736.777759] Subtest invalid-create: SUCCESS (0.001s)
[736.915473] [128/132] (306s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[742.000625] Starting subtest: pr-overlay-primary-update-sf-dmg-area
[742.004223] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.002s)
[742.877800] [129/132] (300s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[742.975707] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[742.976699] Starting dynamic subtest: pipe-A
[742.998463] Dynamic subtest pipe-A: SKIP (0.018s)
[743.008325] Starting dynamic subtest: pipe-B
[743.031759] Dynamic subtest pipe-B: SKIP (0.034s)
[743.041300] Starting dynamic subtest: pipe-C
[743.080203] Dynamic subtest pipe-C: SKIP (0.048s)
[743.089461] Starting dynamic subtest: pipe-D
[743.112819] Dynamic subtest pipe-D: SKIP (0.033s)
[743.114567] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.135s)
[743.239863] [130/132] (300s left) kms_vblank (wait-forked-busy)
[743.343282] Starting subtest: wait-forked-busy
[743.344387] Starting dynamic subtest: pipe-A-eDP-1
[745.235708] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.875s)
[745.248410] Starting dynamic subtest: pipe-D-eDP-1
[747.874894] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.618s)
[747.876037] Subtest wait-forked-busy: SUCCESS (4.496s)
[748.699197] [131/132] (294s left) prime_vgem (sync)
[748.785778] Starting subtest: sync
[748.787493] Starting dynamic subtest: rcs0
[748.834757] Dynamic subtest rcs0: SUCCESS (0.049s)
[748.844511] Starting dynamic subtest: bcs0
[748.908850] Dynamic subtest bcs0: SUCCESS (0.073s)
[748.920840] Starting dynamic subtest: vcs0
[748.959417] Dynamic subtest vcs0: SUCCESS (0.049s)
[748.969326] Starting dynamic subtest: vcs1
[749.007807] Dynamic subtest vcs1: SUCCESS (0.047s)
[749.017405] Starting dynamic subtest: vecs0
[749.054793] Dynamic subtest vecs0: SUCCESS (0.046s)
[749.063970] Starting dynamic subtest: ccs0
[749.102247] Dynamic subtest ccs0: SUCCESS (0.046s)
[749.103306] Subtest sync: SUCCESS (0.316s)
[749.252364] [132/132] (294s left) kms_getfb (getfb-repeated-different-handles)
[749.343595] Starting subtest: getfb-repeated-different-handles
[749.344569] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[749.465185] Closing watchdogs
results: parsing output: 0/ for test: gem_pxp
results: parsing output: 1/ for test: kms_color_pipeline
results: parsing output: 2/ for test: template
results: parsing output: 3/ for test: kms_flip_scaled_crc
results: parsing output: 4/ for test: gem_mmap_offset
results: parsing output: 5/ for test: kms_chamelium_hpd
results: parsing output: 6/ for test: kms_frontbuffer_tracking
results: parsing output: 7/ for test: kms_cursor_legacy
results: parsing output: 8/ for test: kms_plane_cursor
results: parsing output: 9/ for test: gem_ctx_persistence
results: parsing output: 10/ for test: gem_ctx_shared
results: parsing output: 11/ for test: gem_exec_params
results: parsing output: 12/ for test: gem_mmap_offset
results: parsing output: 13/ for test: kms_ccs
results: parsing output: 14/ for test: vgem_basic
results: parsing output: 15/ for test: vgem_basic
results: parsing output: 16/ for test: gem_eio
results: parsing output: 17/ for test: kms_pm_rpm
results: parsing output: 18/ for test: gem_exec_balancer
results: parsing output: 19/ for test: kms_psr
results: parsing output: 20/ for test: gem_exec_reloc
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: i915_drm_fdinfo
results: parsing output: 23/ for test: kms_hdr
results: parsing output: 24/ for test: kms_flip_tiling
results: parsing output: 25/ for test: kms_frontbuffer_tracking
results: parsing output: 26/ for test: kms_big_fb
results: parsing output: 27/ for test: syncobj_timeline
results: parsing output: 28/ for test: gem_exec_fence
results: parsing output: 29/ for test: gem_exec_balancer
results: parsing output: 30/ for test: perf
results: parsing output: 31/ for test: gem_userptr_blits
results: parsing output: 32/ for test: gem_mmap_gtt
results: parsing output: 33/ for test: gen7_exec_parse
results: parsing output: 34/ for test: gem_exec_reloc
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: kms_plane
results: parsing output: 37/ for test: gem_exec_schedule
results: parsing output: 38/ for test: kms_cursor_legacy
results: parsing output: 39/ for test: kms_ccs
results: parsing output: 40/ for test: kms_cursor_crc
results: parsing output: 41/ for test: sw_sync
results: parsing output: 42/ for test: kms_big_fb
results: parsing output: 43/ for test: gem_lmem_swapping
results: parsing output: 44/ for test: perf_pmu
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_pipe_b_c_ivb
results: parsing output: 47/ for test: kms_flip
results: parsing output: 48/ for test: kms_flip
results: parsing output: 49/ for test: kms_psr
results: parsing output: 50/ for test: kms_cursor_legacy
results: parsing output: 51/ for test: kms_cursor_crc
results: parsing output: 52/ for test: kms_addfb_basic
results: parsing output: 53/ for test: gem_render_copy
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: kms_addfb_basic
results: parsing output: 56/ for test: kms_flip
results: parsing output: 57/ for test: kms_ccs
results: parsing output: 58/ for test: syncobj_wait
results: parsing output: 59/ for test: kms_rotation_crc
results: parsing output: 60/ for test: gem_close
results: parsing output: 61/ for test: kms_cursor_legacy
results: parsing output: 62/ for test: syncobj_timeline
results: parsing output: 63/ for test: kms_big_fb
results: parsing output: 64/ for test: i915_suspend
results: parsing output: 65/ for test: kms_flip_scaled_crc
results: parsing output: 66/ for test: i915_pm_rpm
results: parsing output: 67/ for test: kms_vblank
results: parsing output: 68/ for test: kms_cursor_legacy
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: gem_exec_schedule
results: parsing output: 71/ for test: kms_cursor_legacy
results: parsing output: 72/ for test: syncobj_timeline
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: gem_userptr_blits
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: core_getversion
results: parsing output: 77/ for test: perf
results: parsing output: 78/ for test: gem_softpin
results: parsing output: 79/ for test: kms_multipipe_modeset
results: parsing output: 80/ for test: kms_psr2_sf
results: parsing output: 81/ for test: api_intel_allocator
results: parsing output: 82/ for test: kms_flip
results: parsing output: 83/ for test: syncobj_timeline
results: parsing output: 84/ for test: gem_cs_tlb
results: parsing output: 85/ for test: gem_tiled_blits
results: parsing output: 86/ for test: kms_joiner
results: parsing output: 87/ for test: kms_ccs
results: parsing output: 88/ for test: kms_cursor_crc
results: parsing output: 89/ for test: gem_tiled_blits
results: parsing output: 90/ for test: kms_frontbuffer_tracking
results: parsing output: 91/ for test: gem_exec_reloc
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: kms_cursor_crc
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: api_intel_bb
results: parsing output: 100/ for test: perf
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: kms_psr
results: parsing output: 103/ for test: gem_exec_await
results: parsing output: 104/ for test: kms_dither
results: parsing output: 105/ for test: kms_chamelium_frames
results: parsing output: 106/ for test: gem_exec_whisper
results: parsing output: 107/ for test: kms_frontbuffer_tracking
results: parsing output: 108/ for test: fbdev
results: parsing output: 109/ for test: gen3_render_tiledy_blits
results: parsing output: 110/ for test: kms_cursor_legacy
results: parsing output: 111/ for test: gem_eio
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_pm_rpm
results: parsing output: 114/ for test: kms_atomic
results: parsing output: 115/ for test: syncobj_timeline
results: parsing output: 116/ for test: kms_big_fb
results: parsing output: 117/ for test: kms_plane_scaling
results: parsing output: 118/ for test: kms_cdclk
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: gem_ctx_persistence
results: parsing output: 121/ for test: kms_draw_crc
results: parsing output: 122/ for test: syncobj_wait
results: parsing output: 123/ for test: gem_lmem_swapping
results: parsing output: 124/ for test: i915_pm_freq_api
results: parsing output: 125/ for test: gem_eio
results: parsing output: 126/ for test: gem_vm_create
results: parsing output: 127/ for test: kms_psr2_sf
results: parsing output: 128/ for test: kms_plane_scaling
results: parsing output: 129/ for test: kms_vblank
results: parsing output: 130/ for test: prime_vgem
results: parsing output: 131/ for test: kms_getfb
Done.