[43.091131] Initializing watchdogs [43.091361] /dev/watchdog0 [43.125444] [001/165] (960s left) i915_module_load (load) [43.360392] Starting subtest: load [45.851966] Subtest load: SUCCESS (2.488s) [45.961524] [002/165] (957s left) core_auth (basic-auth) [46.225860] Starting subtest: basic-auth [46.247309] Subtest basic-auth: SUCCESS (0.005s) [46.376443] [003/165] (957s left) debugfs_test (read_all_entries) [46.623613] Starting subtest: read_all_entries [47.036190] Subtest read_all_entries: SUCCESS (0.410s) [47.234595] [004/165] (956s left) debugfs_test (basic-hwmon) [47.467246] Starting subtest: basic-hwmon [47.507626] Subtest basic-hwmon: SKIP (0.000s) [47.647391] [005/165] (956s left) fbdev (eof) [47.866829] Starting subtest: eof [47.887184] Subtest eof: SUCCESS (0.002s) [47.997610] [006/165] (956s left) fbdev (info) [48.212391] Starting subtest: info [48.234696] Subtest info: SUCCESS (0.000s) [48.343940] [007/165] (955s left) fbdev (nullptr) [48.554947] Starting subtest: nullptr [48.574916] Subtest nullptr: SUCCESS (0.000s) [48.683844] [008/165] (955s left) fbdev (read) [48.898982] Starting subtest: read [50.357553] Subtest read: SUCCESS (1.474s) [50.465490] [009/165] (953s left) fbdev (write) [50.665187] Starting subtest: write [51.411875] Subtest write: SUCCESS (0.762s) [51.521496] [010/165] (952s left) gem_basic (bad-close) [51.756303] Starting subtest: bad-close [51.797923] Subtest bad-close: SUCCESS (0.000s) [51.885358] [011/165] (952s left) gem_basic (create-close) [52.115994] Starting subtest: create-close [52.156774] Subtest create-close: SUCCESS (0.000s) [52.245060] [012/165] (952s left) gem_basic (create-fd-close) [52.473077] Starting subtest: create-fd-close [52.517085] Subtest create-fd-close: SUCCESS (0.000s) [52.606223] [013/165] (952s left) gem_busy (busy@all-engines) [52.844615] Starting subtest: busy [52.866883] Starting dynamic subtest: all-engines [52.943186] Dynamic subtest all-engines: SUCCESS (0.103s) [52.964070] Subtest busy: SUCCESS (0.104s) [53.362671] [014/165] (951s left) gem_close_race (basic-process) [53.608910] Starting subtest: basic-process [53.713661] Subtest basic-process: SUCCESS (0.106s) [53.947331] [015/165] (950s left) gem_close_race (basic-threads) [54.177875] Starting subtest: basic-threads [55.388266] Subtest basic-threads: SUCCESS (1.208s) [55.613902] [016/165] (949s left) gem_ctx_create (basic) [55.851841] Starting subtest: basic [55.891741] Subtest basic: SUCCESS (0.000s) [56.083164] [017/165] (948s left) gem_ctx_create (basic-files) [56.326543] Starting subtest: basic-files [58.351293] Subtest basic-files: SUCCESS (2.039s) [58.616131] [018/165] (946s left) gem_ctx_exec (basic) [58.862131] Starting subtest: basic [58.884650] Subtest basic: SUCCESS (0.008s) [58.973590] [019/165] (946s left) gem_exec_basic (basic) [59.212361] Starting subtest: basic [59.233077] Starting dynamic subtest: rcs0-smem [59.256506] Dynamic subtest rcs0-smem: SUCCESS (0.003s) [59.293368] Starting dynamic subtest: bcs0-smem [59.313097] Dynamic subtest bcs0-smem: SUCCESS (0.002s) [59.347646] Starting dynamic subtest: vcs0-smem [59.370444] Dynamic subtest vcs0-smem: SUCCESS (0.002s) [59.405530] Starting dynamic subtest: vecs0-smem [59.425746] Dynamic subtest vecs0-smem: SUCCESS (0.002s) [59.446700] Subtest basic: SUCCESS (0.011s) [59.535243] [020/165] (945s left) gem_exec_create (basic) [59.773590] Starting subtest: basic [59.795959] Starting dynamic subtest: smem [61.849509] Dynamic subtest smem: SUCCESS (2.075s) [61.870271] Subtest basic: SUCCESS (2.075s) [62.069224] [021/165] (943s left) gem_exec_fence (basic-busy) [62.432382] Starting subtest: basic-busy [62.454277] Starting dynamic subtest: rcs0 [62.494034] Dynamic subtest rcs0: SUCCESS (0.029s) [62.533475] Starting dynamic subtest: bcs0 [62.576153] Dynamic subtest bcs0: SUCCESS (0.036s) [62.610208] Starting dynamic subtest: vcs0 [62.655604] Dynamic subtest vcs0: SUCCESS (0.038s) [62.691472] Starting dynamic subtest: vecs0 [62.734937] Dynamic subtest vecs0: SUCCESS (0.029s) [62.757147] Subtest basic-busy: SUCCESS (0.133s) [63.382438] [022/165] (942s left) gem_exec_fence (basic-wait) [63.738583] Starting subtest: basic-wait [63.758587] Starting dynamic subtest: rcs0 [63.781386] Dynamic subtest rcs0: SUCCESS (0.031s) [63.819511] Starting dynamic subtest: bcs0 [63.840683] Dynamic subtest bcs0: SUCCESS (0.031s) [63.875113] Starting dynamic subtest: vcs0 [63.898657] Dynamic subtest vcs0: SUCCESS (0.024s) [63.934869] Starting dynamic subtest: vecs0 [63.955106] Dynamic subtest vecs0: SUCCESS (0.024s) [63.976174] Subtest basic-wait: SUCCESS (0.111s) [64.551113] [023/165] (940s left) gem_exec_fence (basic-await) [64.904138] Starting subtest: basic-await [64.926071] Starting dynamic subtest: rcs0 [65.043373] Dynamic subtest rcs0: SUCCESS (0.137s) [65.082093] Starting dynamic subtest: bcs0 [65.179777] Dynamic subtest bcs0: SUCCESS (0.135s) [65.221947] Starting dynamic subtest: vcs0 [65.313133] Dynamic subtest vcs0: SUCCESS (0.133s) [65.353782] Starting dynamic subtest: vecs0 [65.445712] Dynamic subtest vecs0: SUCCESS (0.133s) [65.466385] Subtest basic-await: SUCCESS (0.541s) [66.162103] [024/165] (939s left) gem_exec_fence (nb-await) [66.520775] Starting subtest: nb-await [66.544720] Starting dynamic subtest: rcs0 [66.602353] Dynamic subtest rcs0: SUCCESS (0.076s) [66.644451] Starting dynamic subtest: bcs0 [66.668192] Dynamic subtest bcs0: SUCCESS (0.071s) [66.712327] Starting dynamic subtest: vcs0 [66.738250] Dynamic subtest vcs0: SUCCESS (0.071s) [66.780461] Starting dynamic subtest: vecs0 [66.841752] Dynamic subtest vecs0: SUCCESS (0.070s) [66.869466] Subtest nb-await: SUCCESS (0.290s) [67.510642] [025/165] (938s left) gem_exec_gttfill (basic) [67.753350] Starting subtest: basic [89.766745] Subtest basic: SUCCESS (21.850s) [89.863445] [026/165] (915s left) gem_exec_parallel (engines) [90.260401] Starting subtest: engines [90.281521] Starting dynamic subtest: basic [94.054134] Dynamic subtest basic: SUCCESS (3.624s) [94.091610] Starting dynamic subtest: contexts [98.893514] Dynamic subtest contexts: SUCCESS (4.836s) [98.930131] Starting dynamic subtest: fds [105.475100] Dynamic subtest fds: SUCCESS (6.601s) [105.512132] Starting dynamic subtest: userptr [109.124606] Dynamic subtest userptr: SUCCESS (3.635s) [109.145109] Subtest engines: SUCCESS (18.697s) [109.257791] [027/165] (896s left) gem_exec_store (basic) [109.549649] Starting subtest: basic [109.570074] Subtest basic: SUCCESS (0.072s) [109.803558] [028/165] (896s left) gem_flink_basic (bad-flink) [110.045163] Starting subtest: bad-flink [110.068344] Subtest bad-flink: SUCCESS (0.000s) [110.170823] [029/165] (895s left) gem_flink_basic (bad-open) [110.440310] Starting subtest: bad-open [110.466860] Subtest bad-open: SUCCESS (0.000s) [110.571280] [030/165] (895s left) gem_flink_basic (basic) [111.148874] Starting subtest: basic [111.181612] Subtest basic: SUCCESS (0.000s) [111.299353] [031/165] (895s left) gem_flink_basic (double-flink) [111.564389] Starting subtest: double-flink [111.592354] Subtest double-flink: SUCCESS (0.000s) [111.706344] [032/165] (894s left) gem_flink_basic (flink-lifetime) [111.962609] Starting subtest: flink-lifetime [111.991686] Subtest flink-lifetime: SUCCESS (0.003s) [112.098467] [033/165] (894s left) gem_huc_copy (huc-copy) [112.330630] Starting subtest: huc-copy [112.351189] Subtest huc-copy: SUCCESS (0.006s) [112.451319] [034/165] (894s left) gem_linear_blits (basic) [112.843953] Starting subtest: basic [112.866473] Subtest basic: SUCCESS (0.018s) [113.034405] [035/165] (893s left) gem_mmap (basic) [113.437095] Starting subtest: basic [113.549516] Subtest basic: SUCCESS (0.001s) [113.642856] [036/165] (893s left) gem_mmap_gtt (basic) [113.884292] Starting subtest: basic [113.907174] Subtest basic: SUCCESS (0.002s) [113.998451] [037/165] (893s left) gem_render_linear_blits (basic) [114.237734] Starting subtest: basic [114.341611] Subtest basic: SUCCESS (0.094s) [114.433587] [038/165] (892s left) gem_render_tiled_blits (basic) [114.666414] Starting subtest: basic [114.794373] Subtest basic: SUCCESS (0.117s) [114.885300] [039/165] (892s left) gem_ringfill (basic-all) [115.384064] Starting subtest: basic-all [116.571743] Subtest basic-all: SUCCESS (1.205s) [116.718634] [040/165] (890s left) gem_softpin (allocator-basic) [116.956856] Starting subtest: allocator-basic [117.173673] Subtest allocator-basic: SUCCESS (0.242s) [117.317303] [041/165] (890s left) gem_softpin (allocator-basic-reserve) [117.547639] Starting subtest: allocator-basic-reserve [117.768694] Subtest allocator-basic-reserve: SUCCESS (0.248s) [117.917691] [042/165] (889s left) gem_softpin (safe-alignment) [118.127046] Starting subtest: safe-alignment [118.148939] Subtest safe-alignment: SUCCESS (0.031s) [118.281809] [043/165] (889s left) gem_sync (basic-all) [118.697421] Starting subtest: basic-all [121.693730] Subtest basic-all: SUCCESS (3.003s) [121.784275] [044/165] (885s left) gem_sync (basic-each) [122.199329] Starting subtest: basic-each [124.318970] Subtest basic-each: SUCCESS (2.301s) [124.534793] [045/165] (883s left) gem_tiled_blits (basic) [124.916186] Starting subtest: basic [124.967798] Subtest basic: SUCCESS (0.050s) [125.156326] [046/165] (882s left) gem_tiled_fence_blits (basic) [125.728659] Starting subtest: basic [125.791302] Subtest basic: SUCCESS (0.042s) [126.007490] [047/165] (881s left) gem_tiled_pread_basic [126.766681] [048/165] (881s left) gem_wait (busy@all-engines) [127.028506] Starting subtest: busy [127.051116] Starting dynamic subtest: all-engines [127.552452] Dynamic subtest all-engines: SUCCESS (0.529s) [127.575620] Subtest busy: SUCCESS (0.529s) [127.820753] [049/165] (880s left) gem_wait (wait@all-engines) [128.073209] Starting subtest: wait [128.095873] Starting dynamic subtest: all-engines [129.107605] Dynamic subtest all-engines: SUCCESS (1.039s) [129.130610] Subtest wait: SUCCESS (1.039s) [129.366645] [050/165] (878s left) i915_getparams_basic (basic-eu-total) [129.600343] Starting subtest: basic-eu-total [129.642486] Subtest basic-eu-total: SUCCESS (0.000s) [129.734329] [051/165] (878s left) i915_getparams_basic (basic-subslice-total) [129.963411] Starting subtest: basic-subslice-total [130.008845] Subtest basic-subslice-total: SUCCESS (0.000s) [130.098684] [052/165] (878s left) i915_hangman (error-state-basic) [130.341156] Starting subtest: error-state-basic [130.635115] Subtest error-state-basic: SUCCESS (0.292s) [130.732863] [053/165] (877s left) i915_pciid [131.088305] [054/165] (877s left) kms_addfb_basic (addfb25-4-tiled) [131.482568] Starting subtest: addfb25-4-tiled [131.503891] Subtest addfb25-4-tiled: SUCCESS (0.001s) [131.599406] [055/165] (877s left) kms_addfb_basic (addfb25-bad-modifier) [131.829844] Starting subtest: addfb25-bad-modifier [131.851764] Subtest addfb25-bad-modifier: SUCCESS (0.001s) [132.035780] [056/165] (876s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [132.243258] Starting subtest: addfb25-framebuffer-vs-set-tiling [132.264078] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [132.434492] [057/165] (876s left) kms_addfb_basic (addfb25-modifier-no-flag) [132.667966] Starting subtest: addfb25-modifier-no-flag [132.690281] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [132.866103] [058/165] (876s left) kms_addfb_basic (addfb25-x-tiled-legacy) [133.097207] Starting subtest: addfb25-x-tiled-legacy [133.118673] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [133.301222] [059/165] (875s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [133.534491] Starting subtest: addfb25-x-tiled-mismatch-legacy [133.555876] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s) [133.734271] [060/165] (875s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [134.055759] Starting subtest: addfb25-yf-tiled-legacy [134.076981] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [134.170573] [061/165] (874s left) kms_addfb_basic (addfb25-y-tiled-legacy) [134.467269] Starting subtest: addfb25-y-tiled-legacy [134.493777] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [134.588726] [062/165] (874s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [134.908411] Starting subtest: addfb25-y-tiled-small-legacy [134.928745] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.001s) [135.026315] [063/165] (874s left) kms_addfb_basic (bad-pitch-0) [135.258978] Starting subtest: bad-pitch-0 [135.279633] Subtest bad-pitch-0: SUCCESS (0.000s) [135.448418] [064/165] (873s left) kms_addfb_basic (bad-pitch-1024) [135.675698] Starting subtest: bad-pitch-1024 [135.696121] Subtest bad-pitch-1024: SUCCESS (0.000s) [135.884534] [065/165] (873s left) kms_addfb_basic (bad-pitch-128) [136.113981] Starting subtest: bad-pitch-128 [136.133561] Subtest bad-pitch-128: SUCCESS (0.000s) [136.332591] [066/165] (873s left) kms_addfb_basic (bad-pitch-256) [136.595625] Starting subtest: bad-pitch-256 [136.620776] Subtest bad-pitch-256: SUCCESS (0.000s) [136.787982] [067/165] (872s left) kms_addfb_basic (bad-pitch-32) [137.049976] Starting subtest: bad-pitch-32 [137.078066] Subtest bad-pitch-32: SUCCESS (0.000s) [137.243631] [068/165] (872s left) kms_addfb_basic (bad-pitch-63) [137.476820] Starting subtest: bad-pitch-63 [137.497434] Subtest bad-pitch-63: SUCCESS (0.000s) [137.670246] [069/165] (872s left) kms_addfb_basic (bad-pitch-65536) [137.907386] Starting subtest: bad-pitch-65536 [137.928862] Subtest bad-pitch-65536: SUCCESS (0.001s) [138.106403] [070/165] (871s left) kms_addfb_basic (bad-pitch-999) [138.343120] Starting subtest: bad-pitch-999 [138.366076] Subtest bad-pitch-999: SUCCESS (0.000s) [138.536301] [071/165] (871s left) kms_addfb_basic (basic) [138.767283] Starting subtest: basic [138.789931] Subtest basic: SUCCESS (0.000s) [138.967293] [072/165] (871s left) kms_addfb_basic (basic-x-tiled-legacy) [139.204538] Starting subtest: basic-x-tiled-legacy [139.225849] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [139.406472] [073/165] (870s left) kms_addfb_basic (basic-y-tiled-legacy) [139.643731] Starting subtest: basic-y-tiled-legacy [139.666139] Subtest basic-y-tiled-legacy: SUCCESS (0.001s) [139.835504] [074/165] (870s left) kms_addfb_basic (bo-too-small) [140.160591] Starting subtest: bo-too-small [140.184231] Subtest bo-too-small: SUCCESS (0.001s) [140.278357] [075/165] (870s left) kms_addfb_basic (bo-too-small-due-to-tiling) [140.583719] Starting subtest: bo-too-small-due-to-tiling [140.605287] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s) [140.706647] [076/165] (869s left) kms_addfb_basic (clobberred-modifier) [140.940679] Starting subtest: clobberred-modifier [140.963333] Subtest clobberred-modifier: SUCCESS (0.000s) [141.135288] [077/165] (869s left) kms_addfb_basic (framebuffer-vs-set-tiling) [141.374397] Starting subtest: framebuffer-vs-set-tiling [141.396984] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [141.569587] [078/165] (869s left) kms_addfb_basic (invalid-get-prop) [141.803040] Starting subtest: invalid-get-prop [141.825411] Subtest invalid-get-prop: SUCCESS (0.000s) [141.998575] [079/165] (868s left) kms_addfb_basic (invalid-get-prop-any) [142.217881] Starting subtest: invalid-get-prop-any [142.240758] Subtest invalid-get-prop-any: SUCCESS (0.000s) [142.401084] [080/165] (868s left) kms_addfb_basic (invalid-set-prop) [142.633673] Starting subtest: invalid-set-prop [142.655414] Subtest invalid-set-prop: SUCCESS (0.000s) [142.816561] [081/165] (868s left) kms_addfb_basic (invalid-set-prop-any) [143.031521] Starting subtest: invalid-set-prop-any [143.052603] Subtest invalid-set-prop-any: SUCCESS (0.000s) [143.231941] [082/165] (867s left) kms_addfb_basic (no-handle) [143.470119] Starting subtest: no-handle [143.490835] Subtest no-handle: SUCCESS (0.000s) [143.667686] [083/165] (867s left) kms_addfb_basic (size-max) [143.975124] Starting subtest: size-max [143.996251] Subtest size-max: SUCCESS (0.000s) [144.106333] [084/165] (867s left) kms_addfb_basic (small-bo) [144.408730] Starting subtest: small-bo [144.430378] Subtest small-bo: SUCCESS (0.000s) [144.534710] [085/165] (866s left) kms_addfb_basic (tile-pitch-mismatch) [144.764972] Starting subtest: tile-pitch-mismatch [144.795222] Subtest tile-pitch-mismatch: SUCCESS (0.001s) [144.987519] [086/165] (866s left) kms_addfb_basic (too-high) [145.316809] Starting subtest: too-high [145.343299] Subtest too-high: SUCCESS (0.002s) [145.458951] [087/165] (866s left) kms_addfb_basic (too-wide) [145.784551] Starting subtest: too-wide [145.815244] Subtest too-wide: SUCCESS (0.000s) [145.940792] [088/165] (865s left) kms_addfb_basic (unused-handle) [146.185732] Starting subtest: unused-handle [146.207350] Subtest unused-handle: SUCCESS (0.000s) [146.385292] [089/165] (865s left) kms_addfb_basic (unused-modifier) [146.620524] Starting subtest: unused-modifier [146.642937] Subtest unused-modifier: SUCCESS (0.000s) [146.816111] [090/165] (864s left) kms_addfb_basic (unused-offsets) [147.049417] Starting subtest: unused-offsets [147.071042] Subtest unused-offsets: SUCCESS (0.000s) [147.250158] [091/165] (864s left) kms_addfb_basic (unused-pitches) [147.482635] Starting subtest: unused-pitches [147.502983] Subtest unused-pitches: SUCCESS (0.000s) [147.685506] [092/165] (864s left) kms_busy (basic) [148.017395] Starting subtest: basic [148.039191] Starting dynamic subtest: flip [149.003534] Dynamic subtest flip: SUCCESS (0.981s) [149.051445] Starting dynamic subtest: modeset [150.379132] Dynamic subtest modeset: SUCCESS (1.386s) [150.400780] Subtest basic: SUCCESS (2.370s) [150.765749] [093/165] (861s left) kms_prop_blob (basic) [151.014542] Starting subtest: basic [151.035229] Subtest basic: SUCCESS (0.000s) [151.131971] [094/165] (860s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [151.445658] Starting subtest: basic-busy-flip-before-cursor-atomic [151.488737] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [151.582717] [095/165] (860s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [151.886105] Starting subtest: basic-busy-flip-before-cursor-legacy [151.930104] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [152.033408] [096/165] (860s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [152.359335] Starting subtest: basic-flip-after-cursor-atomic [153.462851] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.091s) [153.847280] [097/165] (858s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [154.163816] Starting subtest: basic-flip-after-cursor-legacy [155.225482] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.056s) [155.579717] [098/165] (856s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [155.891869] Starting subtest: basic-flip-after-cursor-varying-size [156.966327] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.070s) [157.331369] [099/165] (855s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [157.652988] Starting subtest: basic-flip-before-cursor-atomic [158.685677] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.057s) [159.057200] [100/165] (853s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [159.361323] Starting subtest: basic-flip-before-cursor-legacy [160.412306] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.051s) [160.786467] [101/165] (851s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [161.092155] Starting subtest: basic-flip-before-cursor-varying-size [162.167876] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.070s) [162.555706] [102/165] (850s left) kms_dsc (dsc-basic) [162.894184] Subtest dsc-basic: SKIP (0.000s) [162.992667] [103/165] (849s left) kms_flip (basic-flip-vs-dpms) [163.326033] Starting subtest: basic-flip-vs-dpms [163.349181] Starting dynamic subtest: A-DP1 [164.556180] Dynamic subtest A-DP1: SUCCESS (1.235s) [164.595367] Starting dynamic subtest: B-DP1 [165.679077] Dynamic subtest B-DP1: SUCCESS (1.120s) [165.727362] Starting dynamic subtest: C-DP1 [166.821983] Dynamic subtest C-DP1: SUCCESS (1.149s) [166.842396] Subtest basic-flip-vs-dpms: SUCCESS (3.514s) [167.225751] [104/165] (845s left) kms_flip (basic-flip-vs-modeset) [167.549103] Starting subtest: basic-flip-vs-modeset [167.570574] Starting dynamic subtest: A-DP1 [168.804956] Dynamic subtest A-DP1: SUCCESS (1.280s) [168.845415] Starting dynamic subtest: B-DP1 [169.961761] Dynamic subtest B-DP1: SUCCESS (1.156s) [170.003743] Starting dynamic subtest: C-DP1 [171.097153] Dynamic subtest C-DP1: SUCCESS (1.121s) [171.120118] Subtest basic-flip-vs-modeset: SUCCESS (3.568s) [171.474581] [105/165] (841s left) kms_flip (basic-flip-vs-wf_vblank) [171.804049] Starting subtest: basic-flip-vs-wf_vblank [171.827228] Starting dynamic subtest: A-DP1 [173.234309] Dynamic subtest A-DP1: SUCCESS (1.449s) [173.490222] Starting dynamic subtest: B-DP1 [174.619048] Dynamic subtest B-DP1: SUCCESS (1.389s) [174.663593] Starting dynamic subtest: C-DP1 [176.012812] Dynamic subtest C-DP1: SUCCESS (1.385s) [176.038445] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.233s) [176.470677] [106/165] (836s left) kms_flip (basic-plain-flip) [176.787057] Starting subtest: basic-plain-flip [176.810226] Starting dynamic subtest: A-DP1 [177.959187] Dynamic subtest A-DP1: SUCCESS (1.179s) [177.998173] Starting dynamic subtest: B-DP1 [179.073894] Dynamic subtest B-DP1: SUCCESS (1.108s) [179.113098] Starting dynamic subtest: C-DP1 [180.183577] Dynamic subtest C-DP1: SUCCESS (1.111s) [180.206364] Subtest basic-plain-flip: SUCCESS (3.410s) [180.644534] [107/165] (832s left) kms_force_connector_basic (force-connector-state) [180.908909] Subtest force-connector-state: SKIP (0.000s) [181.005535] [108/165] (832s left) kms_force_connector_basic (force-edid) [181.261978] Subtest force-edid: SKIP (0.000s) [181.359973] [109/165] (832s left) kms_force_connector_basic (force-load-detect) [181.617230] Subtest force-load-detect: SKIP (0.000s) [181.714308] [110/165] (831s left) kms_force_connector_basic (prune-stale-modes) [181.975975] Subtest prune-stale-modes: SKIP (0.000s) [182.074351] [111/165] (831s left) kms_frontbuffer_tracking (basic) [182.470427] Starting subtest: basic [185.478586] Subtest basic: SUCCESS (3.080s) [185.605598] [112/165] (828s left) kms_hdmi_inject (inject-audio) [185.870497] Subtest inject-audio: SKIP (0.000s) [185.964982] [113/165] (827s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [186.306624] Starting subtest: compare-crc-sanitycheck-xr24 [186.333387] Starting dynamic subtest: pipe-A-DP-1 [186.725857] Dynamic subtest pipe-A-DP-1: SUCCESS (0.423s) [186.773266] Starting dynamic subtest: pipe-B-DP-1 [187.299375] Dynamic subtest pipe-B-DP-1: SUCCESS (0.595s) [187.342163] Starting dynamic subtest: pipe-C-DP-1 [187.919550] Dynamic subtest pipe-C-DP-1: SUCCESS (0.617s) [187.942060] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.649s) [188.297896] [114/165] (825s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [188.606047] Starting subtest: compare-crc-sanitycheck-nv12 [188.628676] Starting dynamic subtest: pipe-A-DP-1 [188.671101] Dynamic subtest pipe-A-DP-1: SKIP (0.001s) [188.711065] Starting dynamic subtest: pipe-B-DP-1 [188.755554] Dynamic subtest pipe-B-DP-1: SKIP (0.001s) [188.794244] Starting dynamic subtest: pipe-C-DP-1 [188.839794] Dynamic subtest pipe-C-DP-1: SKIP (0.001s) [188.881757] Subtest compare-crc-sanitycheck-nv12: SKIP (0.017s) [188.986143] [115/165] (825s left) kms_pipe_crc_basic (hang-read-crc) [189.291879] Starting subtest: hang-read-crc [189.315050] Starting dynamic subtest: pipe-A-DP-1 [190.758550] Dynamic subtest pipe-A-DP-1: SUCCESS (1.462s) [190.810689] Starting dynamic subtest: pipe-B-DP-1 [192.416329] Dynamic subtest pipe-B-DP-1: SUCCESS (1.646s) [192.471526] Starting dynamic subtest: pipe-C-DP-1 [194.081099] Dynamic subtest pipe-C-DP-1: SUCCESS (1.661s) [194.101576] Subtest hang-read-crc: SUCCESS (4.782s) [194.439274] [116/165] (819s left) kms_pipe_crc_basic (nonblocking-crc) [194.752089] Starting subtest: nonblocking-crc [194.773193] Starting dynamic subtest: pipe-A-DP-1 [195.364442] Dynamic subtest pipe-A-DP-1: SUCCESS (0.582s) [195.411997] Starting dynamic subtest: pipe-B-DP-1 [196.103151] Dynamic subtest pipe-B-DP-1: SUCCESS (0.744s) [196.165996] Starting dynamic subtest: pipe-C-DP-1 [196.834508] Dynamic subtest pipe-C-DP-1: SUCCESS (0.751s) [196.857405] Subtest nonblocking-crc: SUCCESS (2.090s) [197.198347] [117/165] (817s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [197.503760] Starting subtest: nonblocking-crc-frame-sequence [197.524432] Starting dynamic subtest: pipe-A-DP-1 [198.100467] Dynamic subtest pipe-A-DP-1: SUCCESS (0.591s) [198.155284] Starting dynamic subtest: pipe-B-DP-1 [198.825411] Dynamic subtest pipe-B-DP-1: SUCCESS (0.725s) [198.865835] Starting dynamic subtest: pipe-C-DP-1 [199.585815] Dynamic subtest pipe-C-DP-1: SUCCESS (0.751s) [199.610215] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.081s) [199.944407] [118/165] (814s left) kms_pipe_crc_basic (read-crc) [200.249462] Starting subtest: read-crc [200.269863] Starting dynamic subtest: pipe-A-DP-1 [200.778423] Dynamic subtest pipe-A-DP-1: SUCCESS (0.524s) [200.830795] Starting dynamic subtest: pipe-B-DP-1 [201.489121] Dynamic subtest pipe-B-DP-1: SUCCESS (0.685s) [201.533274] Starting dynamic subtest: pipe-C-DP-1 [202.174464] Dynamic subtest pipe-C-DP-1: SUCCESS (0.703s) [202.195054] Subtest read-crc: SUCCESS (1.927s) [202.537712] [119/165] (811s left) kms_pipe_crc_basic (read-crc-frame-sequence) [202.848052] Starting subtest: read-crc-frame-sequence [202.876769] Starting dynamic subtest: pipe-A-DP-1 [203.341199] Dynamic subtest pipe-A-DP-1: SUCCESS (0.493s) [203.381785] Starting dynamic subtest: pipe-B-DP-1 [204.065467] Dynamic subtest pipe-B-DP-1: SUCCESS (0.695s) [204.122545] Starting dynamic subtest: pipe-C-DP-1 [204.748974] Dynamic subtest pipe-C-DP-1: SUCCESS (0.693s) [204.777330] Subtest read-crc-frame-sequence: SUCCESS (1.895s) [205.106287] [120/165] (809s left) kms_pm_backlight (basic-brightness) [205.442702] Subtest basic-brightness: SKIP (0.000s) [205.542239] [121/165] (809s left) kms_pm_rpm (basic-pci-d3-state) [207.436920] Starting subtest: basic-pci-d3-state [208.300617] Subtest basic-pci-d3-state: SUCCESS (0.848s) [208.570407] [122/165] (806s left) kms_pm_rpm (basic-rte) [208.784612] Starting subtest: basic-rte [211.146657] Subtest basic-rte: SUCCESS (2.370s) [212.107430] [123/165] (802s left) kms_psr (primary_page_flip) [212.381083] Subtest primary_page_flip: SKIP (0.000s) [212.483192] [124/165] (802s left) kms_psr (cursor_plane_move) [212.718944] Subtest cursor_plane_move: SKIP (0.000s) [212.816544] [125/165] (802s left) kms_psr (sprite_plane_onoff) [213.079171] Subtest sprite_plane_onoff: SKIP (0.000s) [213.176554] [126/165] (802s left) kms_psr (primary_mmap_gtt) [213.444811] Subtest primary_mmap_gtt: SKIP (0.000s) [213.539950] [127/165] (801s left) kms_setmode (basic-clone-single-crtc) [213.788760] Starting subtest: basic-clone-single-crtc [213.850393] Subtest basic-clone-single-crtc: SKIP (0.000s) [213.968807] [128/165] (801s left) i915_pm_rps (basic-api) [214.244149] Starting subtest: basic-api [214.273348] Subtest basic-api: SUCCESS (0.007s) [214.421246] [129/165] (801s left) prime_self_import (basic-llseek-bad) [214.647300] Starting subtest: basic-llseek-bad [214.693498] Subtest basic-llseek-bad: SUCCESS (0.004s) [214.791768] [130/165] (800s left) prime_self_import (basic-llseek-size) [215.003623] Starting subtest: basic-llseek-size [215.046428] Subtest basic-llseek-size: SUCCESS (0.006s) [215.149429] [131/165] (800s left) prime_self_import (basic-with_fd_dup) [215.340845] Starting subtest: basic-with_fd_dup [215.389067] Subtest basic-with_fd_dup: SUCCESS (0.006s) [215.488533] [132/165] (800s left) prime_self_import (basic-with_one_bo) [215.701799] Starting subtest: basic-with_one_bo [215.746135] Subtest basic-with_one_bo: SUCCESS (0.007s) [215.842754] [133/165] (800s left) prime_self_import (basic-with_one_bo_two_files) [216.055429] Starting subtest: basic-with_one_bo_two_files [216.096937] Subtest basic-with_one_bo_two_files: SUCCESS (0.006s) [216.196741] [134/165] (799s left) prime_self_import (basic-with_two_bos) [216.410336] Starting subtest: basic-with_two_bos [216.455262] Subtest basic-with_two_bos: SUCCESS (0.007s) [216.551558] [135/165] (799s left) prime_vgem (basic-fence-flip) [216.818926] Starting subtest: basic-fence-flip [217.422713] Subtest basic-fence-flip: SUCCESS (0.625s) [217.552925] [136/165] (798s left) prime_vgem (basic-fence-mmap) [217.810432] Starting subtest: basic-fence-mmap [217.861336] Subtest basic-fence-mmap: SUCCESS (0.073s) [217.985567] [137/165] (798s left) prime_vgem (basic-fence-read) [218.232187] Starting subtest: basic-fence-read [218.321366] Subtest basic-fence-read: SUCCESS (0.113s) [218.439837] [138/165] (797s left) prime_vgem (basic-gtt) [218.693419] Starting subtest: basic-gtt [218.714660] Subtest basic-gtt: SUCCESS (0.037s) [218.857118] [139/165] (797s left) prime_vgem (basic-read) [219.116598] Starting subtest: basic-read [219.160360] Subtest basic-read: SUCCESS (0.056s) [219.286799] [140/165] (797s left) prime_vgem (basic-write) [219.542307] Starting subtest: basic-write [219.587897] Subtest basic-write: SUCCESS (0.068s) [219.707094] [141/165] (796s left) vgem_basic (setversion) [219.951287] Starting subtest: setversion [219.997358] Subtest setversion: SUCCESS (0.000s) [220.095101] [142/165] (796s left) vgem_basic (create) [220.358427] Starting subtest: create [220.382062] Subtest create: SUCCESS (0.000s) [220.482084] [143/165] (796s left) vgem_basic (debugfs) [220.720323] Starting subtest: debugfs [220.741118] Subtest debugfs: SUCCESS (0.001s) [220.842663] [144/165] (796s left) vgem_basic (dmabuf-export) [221.055850] Starting subtest: dmabuf-export [221.102879] Subtest dmabuf-export: SUCCESS (0.015s) [221.200875] [145/165] (795s left) vgem_basic (dmabuf-fence) [221.438396] Starting subtest: dmabuf-fence [221.461419] Subtest dmabuf-fence: SUCCESS (0.002s) [221.559301] [146/165] (795s left) vgem_basic (dmabuf-fence-before) [221.795204] Starting subtest: dmabuf-fence-before [221.815818] Subtest dmabuf-fence-before: SUCCESS (0.001s) [221.914946] [147/165] (795s left) vgem_basic (dmabuf-mmap) [222.129566] Starting subtest: dmabuf-mmap [222.151977] Subtest dmabuf-mmap: SUCCESS (0.043s) [222.257961] [148/165] (795s left) vgem_basic (mmap) [222.471695] Starting subtest: mmap [222.494946] Subtest mmap: SUCCESS (0.026s) [222.592161] [149/165] (794s left) vgem_basic (second-client) [222.808740] Starting subtest: second-client [222.851561] Subtest second-client: SUCCESS (0.033s) [222.966422] [150/165] (794s left) vgem_basic (sysfs) [223.230715] Starting subtest: sysfs [223.262874] Subtest sysfs: SUCCESS (0.002s) [223.381796] [151/165] (794s left) core_hotunplug (unbind-rebind) [223.878980] Starting subtest: unbind-rebind [227.803891] Subtest unbind-rebind: SUCCESS (3.949s) [227.907873] [152/165] (789s left) vgem_basic (unload) [228.128125] Starting subtest: unload [257.155135] Subtest unload: SUCCESS (29.046s) [257.325116] [153/165] (760s left) i915_module_load (reload) [257.549232] Starting subtest: reload [261.328748] Subtest reload: SUCCESS (3.798s) [261.462812] [154/165] (756s left) gem_lmem_swapping (basic) [261.788353] Subtest basic: SKIP (0.000s) [261.881303] [155/165] (756s left) gem_lmem_swapping (parallel-random-engines) [262.115706] Subtest parallel-random-engines: SKIP (0.000s) [262.210984] [156/165] (756s left) gem_lmem_swapping (random-engines) [262.464197] Subtest random-engines: SKIP (0.000s) [262.559374] [157/165] (755s left) gem_lmem_swapping (verify-random) [262.811996] Subtest verify-random: SKIP (0.000s) [262.906198] [158/165] (755s left) i915_pm_rpm (module-reload) [265.119655] Starting subtest: module-reload [274.633368] Subtest module-reload: SUCCESS (9.535s) [274.726828] [159/165] (743s left) i915_selftest (live) [274.963733] Starting subtest: live [274.985739] Starting dynamic subtest: sanitycheck [276.452518] Dynamic subtest sanitycheck: SUCCESS (1.484s) [276.500458] Starting dynamic subtest: uncore [277.937658] Dynamic subtest uncore: SUCCESS (1.481s) [277.972830] Starting dynamic subtest: workarounds [279.864846] Dynamic subtest workarounds: SUCCESS (1.921s) [279.901579] Starting dynamic subtest: gt_engines [281.981644] Dynamic subtest gt_engines: SUCCESS (2.109s) [282.035692] Starting dynamic subtest: gt_timelines [304.732045] Dynamic subtest gt_timelines: SUCCESS (22.750s) [304.767391] Starting dynamic subtest: gt_contexts [306.551389] Dynamic subtest gt_contexts: SUCCESS (1.815s) [306.598239] Starting dynamic subtest: gt_lrc [310.975696] Dynamic subtest gt_lrc: SUCCESS (4.423s) [311.013392] Starting dynamic subtest: gt_mocs [312.597689] Dynamic subtest gt_mocs: SUCCESS (1.618s) [312.632895] Starting dynamic subtest: gt_pm [321.499241] Dynamic subtest gt_pm: SUCCESS (8.895s) [321.535293] Starting dynamic subtest: gt_heartbeat [323.320243] Dynamic subtest gt_heartbeat: SUCCESS (1.820s) [323.367476] Starting dynamic subtest: gt_tlb [325.831284] Dynamic subtest gt_tlb: SUCCESS (2.504s) [325.868950] Starting dynamic subtest: requests [333.892360] Dynamic subtest requests: SUCCESS (8.057s) [333.938923] Starting dynamic subtest: migrate [338.669645] Dynamic subtest migrate: SUCCESS (4.775s) [338.705318] Starting dynamic subtest: active [340.196084] Dynamic subtest active: SUCCESS (1.522s) [340.231389] Starting dynamic subtest: objects [344.772241] Dynamic subtest objects: SUCCESS (4.573s) [344.810093] Starting dynamic subtest: mman [353.572157] Dynamic subtest mman: SUCCESS (8.797s) [353.608931] Starting dynamic subtest: dmabuf [355.297448] Dynamic subtest dmabuf: SUCCESS (1.720s) [355.344321] Starting dynamic subtest: vma [356.857551] Dynamic subtest vma: SUCCESS (1.550s) [356.899494] Starting dynamic subtest: coherency [366.401406] Dynamic subtest coherency: SUCCESS (9.544s) [366.439222] Starting dynamic subtest: gtt [375.713348] Dynamic subtest gtt: SUCCESS (9.309s) [375.749976] Starting dynamic subtest: gem [378.602329] Dynamic subtest gem: SUCCESS (2.885s) [378.650232] Starting dynamic subtest: evict [384.946744] Dynamic subtest evict: SUCCESS (6.340s) [384.982178] Starting dynamic subtest: hugepages [393.245672] Dynamic subtest hugepages: SUCCESS (8.297s) [393.281764] Starting dynamic subtest: gem_contexts [418.218169] Dynamic subtest gem_contexts: SUCCESS (24.795s) [418.253508] Starting dynamic subtest: client [419.636974] Dynamic subtest client: SUCCESS (1.586s) [419.685087] Starting dynamic subtest: gem_migrate [421.239986] Dynamic subtest gem_migrate: SUCCESS (1.599s) [421.288664] Starting dynamic subtest: reset [434.967144] Dynamic subtest reset: SUCCESS (13.724s) [435.004348] Starting dynamic subtest: memory_region [436.451700] Dynamic subtest memory_region: SUCCESS (1.481s) [436.488647] Starting dynamic subtest: hangcheck [461.175372] Dynamic subtest hangcheck: SUCCESS (24.719s) [461.213917] Starting dynamic subtest: execlists [473.589223] Dynamic subtest execlists: SUCCESS (12.407s) [473.627268] Starting dynamic subtest: ring_submission [475.089048] Dynamic subtest ring_submission: SUCCESS (1.500s) [475.127843] Starting dynamic subtest: perf [476.756500] Dynamic subtest perf: SUCCESS (1.664s) [476.795044] Starting dynamic subtest: slpc [478.281474] Dynamic subtest slpc: SUCCESS (1.513s) [478.317265] Starting dynamic subtest: guc [479.938206] Dynamic subtest guc: SUCCESS (1.654s) [479.993550] Starting dynamic subtest: guc_multi_lrc [481.426655] Dynamic subtest guc_multi_lrc: SUCCESS (1.490s) [481.464411] Starting dynamic subtest: guc_hang [483.039991] Dynamic subtest guc_hang: SUCCESS (1.608s) [483.087991] Starting dynamic subtest: late_gt_pm [484.613873] Dynamic subtest late_gt_pm: SUCCESS (1.570s) [484.634106] Subtest live: SUCCESS (209.651s) [484.727802] [160/165] (533s left) dmabuf (all-tests) [484.937824] Starting subtest: all-tests [484.960929] Starting dynamic subtest: sanitycheck [485.027577] Dynamic subtest sanitycheck: SUCCESS (0.087s) [485.063502] Starting dynamic subtest: dma_fence [485.210631] Dynamic subtest dma_fence: SUCCESS (0.182s) [485.249546] Starting dynamic subtest: dma_fence_chain [508.264358] Dynamic subtest dma_fence_chain: SUCCESS (23.050s) [508.304207] Starting dynamic subtest: dma_fence_unwrap [508.351305] Dynamic subtest dma_fence_unwrap: SUCCESS (0.083s) [508.393088] Starting dynamic subtest: dma_resv [508.436050] Dynamic subtest dma_resv: SUCCESS (0.080s) [508.458934] Subtest all-tests: SUCCESS (23.496s) [508.551622] [161/165] (510s left) i915_suspend (basic-s2idle-without-i915) [508.775381] Starting subtest: basic-s2idle-without-i915 [528.561950] Subtest basic-s2idle-without-i915: SUCCESS (4.804s) [534.305846] [162/165] (504s left) i915_suspend (basic-s3-without-i915) [534.505516] Starting subtest: basic-s3-without-i915 [553.576945] Subtest basic-s3-without-i915: SUCCESS (3.531s) [557.304237] [163/165] (500s left) gem_exec_suspend (basic-s0) [557.571856] Starting subtest: basic-S0 [557.594272] Starting dynamic subtest: smem [579.391411] Dynamic subtest smem: SUCCESS (5.619s) [579.412201] Subtest basic-S0: SUCCESS (5.621s) [582.801312] [164/165] (494s left) gem_exec_suspend (basic-s3) [583.042975] Starting subtest: basic-S3 [583.063516] Starting dynamic subtest: smem [603.797279] Dynamic subtest smem: SUCCESS (5.917s) [603.819074] Subtest basic-S3: SUCCESS (5.920s) [606.181194] [165/165] (488s left) kms_pipe_crc_basic (suspend-read-crc) [606.509566] Starting subtest: suspend-read-crc [606.529295] Starting dynamic subtest: pipe-A-DP-1 [624.558841] Dynamic subtest pipe-A-DP-1: SUCCESS (2.494s) [624.607596] Starting dynamic subtest: pipe-B-DP-1 [642.547473] Dynamic subtest pipe-B-DP-1: SUCCESS (2.411s) [642.593160] Starting dynamic subtest: pipe-C-DP-1 [660.584428] Dynamic subtest pipe-C-DP-1: SUCCESS (2.570s) [660.605430] Subtest suspend-read-crc: SUCCESS (7.490s) [664.997860] Closing watchdogs Done.