[47.539190] Initializing watchdogs [47.539275] /dev/watchdog0 [47.547405] [001/165] (960s left) i915_module_load (load) [47.627159] Starting subtest: load [49.947037] Subtest load: SUCCESS (2.320s) [49.967830] [002/165] (958s left) core_auth (basic-auth) [50.053355] Starting subtest: basic-auth [50.056775] Subtest basic-auth: SUCCESS (0.001s) [50.118433] [003/165] (957s left) debugfs_test (read_all_entries) [50.206331] Starting subtest: read_all_entries [50.345462] Subtest read_all_entries: SUCCESS (0.136s) [50.646862] [004/165] (957s left) debugfs_test (basic-hwmon) [50.716562] Starting subtest: basic-hwmon [50.723054] Subtest basic-hwmon: SKIP (0.000s) [50.996162] [005/165] (957s left) fbdev (eof) [51.074679] Starting subtest: eof [51.078127] Subtest eof: SUCCESS (0.001s) [51.126038] [006/165] (957s left) fbdev (info) [51.192114] Starting subtest: info [51.195868] Subtest info: SUCCESS (0.000s) [51.276125] [007/165] (956s left) fbdev (nullptr) [51.379453] Starting subtest: nullptr [51.382879] Subtest nullptr: SUCCESS (0.000s) [51.432906] [008/165] (956s left) fbdev (read) [51.513354] Starting subtest: read [51.771316] Subtest read: SUCCESS (0.259s) [51.824833] [009/165] (956s left) fbdev (write) [51.896594] Starting subtest: write [52.038102] Subtest write: SUCCESS (0.139s) [52.090782] [010/165] (956s left) gem_basic (bad-close) [52.158600] Starting subtest: bad-close [52.165156] Subtest bad-close: SUCCESS (0.000s) [52.226190] [011/165] (956s left) gem_basic (create-close) [52.322715] Starting subtest: create-close [52.329154] Subtest create-close: SUCCESS (0.001s) [52.413885] [012/165] (955s left) gem_basic (create-fd-close) [52.488838] Starting subtest: create-fd-close [52.495503] Subtest create-fd-close: SUCCESS (0.000s) [52.570507] [013/165] (955s left) gem_busy (busy@all-engines) [52.663257] Starting subtest: busy [52.666470] Starting dynamic subtest: all-engines [52.718177] Dynamic subtest all-engines: SUCCESS (0.056s) [52.721552] Subtest busy: SUCCESS (0.056s) [53.108686] [014/165] (955s left) gem_close_race (basic-process) [53.206324] Starting subtest: basic-process [53.260736] Subtest basic-process: SUCCESS (0.054s) [53.475606] [015/165] (954s left) gem_close_race (basic-threads) [53.578905] Starting subtest: basic-threads [54.844596] Subtest basic-threads: SUCCESS (1.146s) [55.134747] [016/165] (953s left) gem_ctx_create (basic) [55.623241] Starting subtest: basic [55.688886] Subtest basic: SUCCESS (0.000s) [55.919223] [017/165] (952s left) gem_ctx_create (basic-files) [56.214702] Starting subtest: basic-files [58.234354] Subtest basic-files: SUCCESS (2.021s) [58.462055] [018/165] (950s left) gem_ctx_exec (basic) [58.561902] Starting subtest: basic [58.565056] Subtest basic: SUCCESS (0.003s) [58.665938] [019/165] (950s left) gem_exec_basic (basic) [58.762519] Starting subtest: basic [58.765722] Starting dynamic subtest: rcs0-smem [58.768854] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [58.777522] Starting dynamic subtest: bcs0-smem [58.781586] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [58.789933] Starting dynamic subtest: vcs0-smem [58.793552] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [58.801676] Starting dynamic subtest: vcs1-smem [58.804977] Dynamic subtest vcs1-smem: SUCCESS (0.000s) [58.813089] Starting dynamic subtest: vecs0-smem [58.816502] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [58.819632] Subtest basic: SUCCESS (0.004s) [59.000102] [020/165] (949s left) gem_exec_create (basic) [59.100098] Starting subtest: basic [59.103494] Starting dynamic subtest: smem [61.137400] Dynamic subtest smem: SUCCESS (2.037s) [61.140634] Subtest basic: SUCCESS (2.037s) [61.349946] [021/165] (947s left) gem_exec_fence (basic-busy) [61.561350] Starting subtest: basic-busy [61.565509] Starting dynamic subtest: rcs0 [61.588287] Dynamic subtest rcs0: SUCCESS (0.027s) [61.596782] Starting dynamic subtest: bcs0 [61.616350] Dynamic subtest bcs0: SUCCESS (0.028s) [61.625360] Starting dynamic subtest: vcs0 [61.642326] Dynamic subtest vcs0: SUCCESS (0.026s) [61.650760] Starting dynamic subtest: vcs1 [61.672160] Dynamic subtest vcs1: SUCCESS (0.032s) [61.680665] Starting dynamic subtest: vecs0 [61.700409] Dynamic subtest vecs0: SUCCESS (0.028s) [61.703942] Subtest basic-busy: SUCCESS (0.141s) [62.356946] [022/165] (946s left) gem_exec_fence (basic-wait) [62.604324] Starting subtest: basic-wait [62.608136] Starting dynamic subtest: rcs0 [62.634099] Dynamic subtest rcs0: SUCCESS (0.030s) [62.646552] Starting dynamic subtest: bcs0 [62.663695] Dynamic subtest bcs0: SUCCESS (0.029s) [62.675848] Starting dynamic subtest: vcs0 [62.694549] Dynamic subtest vcs0: SUCCESS (0.031s) [62.706620] Starting dynamic subtest: vcs1 [62.726871] Dynamic subtest vcs1: SUCCESS (0.032s) [62.739086] Starting dynamic subtest: vecs0 [62.754547] Dynamic subtest vecs0: SUCCESS (0.028s) [62.757945] Subtest basic-wait: SUCCESS (0.151s) [63.373453] [023/165] (945s left) gem_exec_fence (basic-await) [63.576850] Starting subtest: basic-await [63.580784] Starting dynamic subtest: rcs0 [63.689585] Dynamic subtest rcs0: SUCCESS (0.113s) [63.699635] Starting dynamic subtest: bcs0 [63.793474] Dynamic subtest bcs0: SUCCESS (0.104s) [63.804597] Starting dynamic subtest: vcs0 [63.901650] Dynamic subtest vcs0: SUCCESS (0.108s) [63.910071] Starting dynamic subtest: vcs1 [64.001552] Dynamic subtest vcs1: SUCCESS (0.100s) [64.012238] Starting dynamic subtest: vecs0 [64.108994] Dynamic subtest vecs0: SUCCESS (0.106s) [64.112504] Subtest basic-await: SUCCESS (0.532s) [64.996926] [024/165] (944s left) gem_exec_fence (nb-await) [65.522162] Starting subtest: nb-await [65.668334] Starting dynamic subtest: rcs0 [65.672403] Dynamic subtest rcs0: SUCCESS (0.072s) [65.692179] Starting dynamic subtest: bcs0 [65.696171] Dynamic subtest bcs0: SUCCESS (0.067s) [65.712929] Starting dynamic subtest: vcs0 [65.717143] Dynamic subtest vcs0: SUCCESS (0.071s) [65.731941] Starting dynamic subtest: vcs1 [65.735677] Dynamic subtest vcs1: SUCCESS (0.071s) [65.746907] Starting dynamic subtest: vecs0 [65.750326] Dynamic subtest vecs0: SUCCESS (0.072s) [65.753817] Subtest nb-await: SUCCESS (0.356s) [66.374911] [025/165] (942s left) gem_exec_gttfill (basic) [66.470466] Starting subtest: basic [70.904621] Subtest basic: SUCCESS (4.434s) [71.084021] [026/165] (938s left) gem_exec_parallel (engines) [71.232435] Starting subtest: engines [71.236562] Starting dynamic subtest: basic [73.548075] Dynamic subtest basic: SUCCESS (2.316s) [73.556952] Starting dynamic subtest: contexts [76.657785] Dynamic subtest contexts: SUCCESS (3.110s) [76.670252] Starting dynamic subtest: fds [82.734219] Dynamic subtest fds: SUCCESS (6.076s) [82.743222] Starting dynamic subtest: userptr [85.190614] Dynamic subtest userptr: SUCCESS (2.457s) [85.194246] Subtest engines: SUCCESS (13.958s) [85.380747] [027/165] (923s left) gem_exec_store (basic) [85.464716] Starting subtest: basic [85.507633] Subtest basic: SUCCESS (0.046s) [85.723721] [028/165] (923s left) gem_flink_basic (bad-flink) [85.814977] Starting subtest: bad-flink [85.818220] Subtest bad-flink: SUCCESS (0.000s) [85.881196] [029/165] (923s left) gem_flink_basic (bad-open) [85.955736] Starting subtest: bad-open [85.959103] Subtest bad-open: SUCCESS (0.000s) [86.022184] [030/165] (923s left) gem_flink_basic (basic) [86.104826] Starting subtest: basic [86.108157] Subtest basic: SUCCESS (0.000s) [86.179300] [031/165] (923s left) gem_flink_basic (double-flink) [86.261336] Starting subtest: double-flink [86.264701] Subtest double-flink: SUCCESS (0.000s) [86.375362] [032/165] (923s left) gem_flink_basic (flink-lifetime) [86.469264] Starting subtest: flink-lifetime [86.472612] Subtest flink-lifetime: SUCCESS (0.001s) [86.567483] [033/165] (922s left) gem_huc_copy (huc-copy) [86.641936] Starting subtest: huc-copy [86.648224] Subtest huc-copy: SKIP (0.000s) [86.741223] [034/165] (922s left) gem_linear_blits (basic) [86.929454] Starting subtest: basic [86.937782] Subtest basic: SUCCESS (0.007s) [87.083222] [035/165] (922s left) gem_mmap (basic) [87.231861] Starting subtest: basic [87.247947] Subtest basic: SUCCESS (0.000s) [87.335428] [036/165] (922s left) gem_mmap_gtt (basic) [87.418800] Starting subtest: basic [87.422065] Subtest basic: SUCCESS (0.001s) [87.476788] [037/165] (922s left) gem_render_linear_blits (basic) [87.556760] Starting subtest: basic [87.590534] Subtest basic: SUCCESS (0.033s) [87.634964] [038/165] (922s left) gem_render_tiled_blits (basic) [87.703046] Starting subtest: basic [87.738903] Subtest basic: SUCCESS (0.037s) [87.785422] [039/165] (921s left) gem_ringfill (basic-all) [88.067912] Starting subtest: basic-all [89.253845] Subtest basic-all: SUCCESS (1.183s) [89.369840] [040/165] (920s left) gem_softpin (allocator-basic) [89.442703] Starting subtest: allocator-basic [89.560935] Subtest allocator-basic: SUCCESS (0.119s) [89.655894] [041/165] (920s left) gem_softpin (allocator-basic-reserve) [89.735182] Starting subtest: allocator-basic-reserve [89.850023] Subtest allocator-basic-reserve: SUCCESS (0.115s) [89.952756] [042/165] (919s left) gem_softpin (safe-alignment) [90.044695] Starting subtest: safe-alignment [90.057974] Subtest safe-alignment: SUCCESS (0.016s) [90.175391] [043/165] (919s left) gem_sync (basic-all) [90.285303] Starting subtest: basic-all [92.591536] Subtest basic-all: SUCCESS (2.324s) [92.803747] [044/165] (917s left) gem_sync (basic-each) [92.904557] Starting subtest: basic-each [95.012301] Subtest basic-each: SUCCESS (2.132s) [95.223097] [045/165] (914s left) gem_tiled_blits (basic) [95.434770] Starting subtest: basic [95.456403] Subtest basic: SUCCESS (0.021s) [95.612339] [046/165] (914s left) gem_tiled_fence_blits (basic) [95.861237] Starting subtest: basic [95.871286] Subtest basic: SUCCESS (0.011s) [96.023273] [047/165] (913s left) gem_tiled_pread_basic [96.409555] [048/165] (913s left) gem_wait (busy@all-engines) [96.500729] Starting subtest: busy [96.504071] Starting dynamic subtest: all-engines [97.019158] Dynamic subtest all-engines: SUCCESS (0.517s) [97.022474] Subtest busy: SUCCESS (0.518s) [97.261583] [049/165] (912s left) gem_wait (wait@all-engines) [97.366729] Starting subtest: wait [97.370147] Starting dynamic subtest: all-engines [98.414388] Dynamic subtest all-engines: SUCCESS (1.046s) [98.418059] Subtest wait: SUCCESS (1.047s) [98.676301] [050/165] (911s left) i915_getparams_basic (basic-eu-total) [98.767245] Starting subtest: basic-eu-total [98.773737] Subtest basic-eu-total: SUCCESS (0.000s) [98.836993] [051/165] (911s left) i915_getparams_basic (basic-subslice-total) [98.913931] Starting subtest: basic-subslice-total [98.920634] Subtest basic-subslice-total: SUCCESS (0.000s) [98.979263] [052/165] (911s left) i915_hangman (error-state-basic) [99.062708] Starting subtest: error-state-basic [99.072931] Subtest error-state-basic: SUCCESS (0.007s) [99.142938] [053/165] (911s left) i915_pciid [99.286386] [054/165] (910s left) kms_addfb_basic (addfb25-4-tiled) [99.598135] Starting subtest: addfb25-4-tiled [99.601069] Subtest addfb25-4-tiled: SUCCESS (0.000s) [99.678403] [055/165] (910s left) kms_addfb_basic (addfb25-bad-modifier) [99.749236] Starting subtest: addfb25-bad-modifier [99.752232] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [100.051254] [056/165] (910s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [100.137618] Starting subtest: addfb25-framebuffer-vs-set-tiling [100.141110] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [100.433152] [057/165] (909s left) kms_addfb_basic (addfb25-modifier-no-flag) [100.521035] Starting subtest: addfb25-modifier-no-flag [100.524132] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [100.816131] [058/165] (909s left) kms_addfb_basic (addfb25-x-tiled-legacy) [100.891074] Starting subtest: addfb25-x-tiled-legacy [100.894640] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [101.192367] [059/165] (909s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [101.280117] Starting subtest: addfb25-x-tiled-mismatch-legacy [101.283215] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [101.584731] [060/165] (908s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [101.873218] Starting subtest: addfb25-yf-tiled-legacy [101.876198] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [101.949870] [061/165] (908s left) kms_addfb_basic (addfb25-y-tiled-legacy) [102.229659] Starting subtest: addfb25-y-tiled-legacy [102.232558] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [102.315579] [062/165] (908s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [102.609910] Starting subtest: addfb25-y-tiled-small-legacy [102.612607] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [102.681803] [063/165] (907s left) kms_addfb_basic (bad-pitch-0) [102.752092] Starting subtest: bad-pitch-0 [102.755070] Subtest bad-pitch-0: SUCCESS (0.000s) [103.053451] [064/165] (907s left) kms_addfb_basic (bad-pitch-1024) [103.133130] Starting subtest: bad-pitch-1024 [103.136126] Subtest bad-pitch-1024: SUCCESS (0.000s) [103.430361] [065/165] (907s left) kms_addfb_basic (bad-pitch-128) [103.510649] Starting subtest: bad-pitch-128 [103.513818] Subtest bad-pitch-128: SUCCESS (0.000s) [103.820290] [066/165] (906s left) kms_addfb_basic (bad-pitch-256) [103.914162] Starting subtest: bad-pitch-256 [103.917478] Subtest bad-pitch-256: SUCCESS (0.000s) [104.201250] [067/165] (906s left) kms_addfb_basic (bad-pitch-32) [104.279585] Starting subtest: bad-pitch-32 [104.283225] Subtest bad-pitch-32: SUCCESS (0.000s) [104.581667] [068/165] (905s left) kms_addfb_basic (bad-pitch-63) [104.665674] Starting subtest: bad-pitch-63 [104.668743] Subtest bad-pitch-63: SUCCESS (0.000s) [104.969891] [069/165] (905s left) kms_addfb_basic (bad-pitch-65536) [105.055829] Starting subtest: bad-pitch-65536 [105.058704] Subtest bad-pitch-65536: SUCCESS (0.000s) [105.348680] [070/165] (905s left) kms_addfb_basic (bad-pitch-999) [105.415325] Starting subtest: bad-pitch-999 [105.417992] Subtest bad-pitch-999: SUCCESS (0.000s) [105.718397] [071/165] (904s left) kms_addfb_basic (basic) [105.792981] Starting subtest: basic [105.796189] Subtest basic: SUCCESS (0.000s) [106.103630] [072/165] (904s left) kms_addfb_basic (basic-x-tiled-legacy) [106.203888] Starting subtest: basic-x-tiled-legacy [106.210428] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [106.494266] [073/165] (904s left) kms_addfb_basic (basic-y-tiled-legacy) [106.566501] Starting subtest: basic-y-tiled-legacy [106.569755] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [106.876512] [074/165] (903s left) kms_addfb_basic (bo-too-small) [107.179926] Starting subtest: bo-too-small [107.182663] Subtest bo-too-small: SUCCESS (0.000s) [107.275779] [075/165] (903s left) kms_addfb_basic (bo-too-small-due-to-tiling) [107.578527] Starting subtest: bo-too-small-due-to-tiling [107.581349] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [107.664958] [076/165] (903s left) kms_addfb_basic (clobberred-modifier) [107.748042] Starting subtest: clobberred-modifier [107.751250] Subtest clobberred-modifier: SUCCESS (0.000s) [108.044790] [077/165] (902s left) kms_addfb_basic (framebuffer-vs-set-tiling) [108.131021] Starting subtest: framebuffer-vs-set-tiling [108.134994] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [108.422869] [078/165] (902s left) kms_addfb_basic (invalid-get-prop) [108.511902] Starting subtest: invalid-get-prop [108.514999] Subtest invalid-get-prop: SUCCESS (0.000s) [108.802861] [079/165] (902s left) kms_addfb_basic (invalid-get-prop-any) [108.881508] Starting subtest: invalid-get-prop-any [108.884634] Subtest invalid-get-prop-any: SUCCESS (0.000s) [109.176616] [080/165] (901s left) kms_addfb_basic (invalid-set-prop) [109.246570] Starting subtest: invalid-set-prop [109.249695] Subtest invalid-set-prop: SUCCESS (0.000s) [109.533667] [081/165] (901s left) kms_addfb_basic (invalid-set-prop-any) [109.606249] Starting subtest: invalid-set-prop-any [109.609155] Subtest invalid-set-prop-any: SUCCESS (0.000s) [109.904923] [082/165] (901s left) kms_addfb_basic (no-handle) [109.987122] Starting subtest: no-handle [109.990242] Subtest no-handle: SUCCESS (0.000s) [110.288501] [083/165] (900s left) kms_addfb_basic (size-max) [110.588053] Starting subtest: size-max [110.590875] Subtest size-max: SUCCESS (0.000s) [110.665686] [084/165] (900s left) kms_addfb_basic (small-bo) [110.944042] Starting subtest: small-bo [110.946782] Subtest small-bo: SUCCESS (0.000s) [111.019026] [085/165] (900s left) kms_addfb_basic (tile-pitch-mismatch) [111.098239] Starting subtest: tile-pitch-mismatch [111.101492] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [111.395346] [086/165] (899s left) kms_addfb_basic (too-high) [111.682807] Starting subtest: too-high [111.685632] Subtest too-high: SUCCESS (0.001s) [111.770277] [087/165] (899s left) kms_addfb_basic (too-wide) [112.084544] Starting subtest: too-wide [112.087442] Subtest too-wide: SUCCESS (0.000s) [112.154243] [088/165] (898s left) kms_addfb_basic (unused-handle) [112.237199] Starting subtest: unused-handle [112.240909] Subtest unused-handle: SUCCESS (0.000s) [112.515258] [089/165] (898s left) kms_addfb_basic (unused-modifier) [112.587455] Starting subtest: unused-modifier [112.590730] Subtest unused-modifier: SUCCESS (0.000s) [112.908465] [090/165] (898s left) kms_addfb_basic (unused-offsets) [113.011888] Starting subtest: unused-offsets [113.015361] Subtest unused-offsets: SUCCESS (0.000s) [113.307208] [091/165] (897s left) kms_addfb_basic (unused-pitches) [113.397894] Starting subtest: unused-pitches [113.401110] Subtest unused-pitches: SUCCESS (0.000s) [113.702694] [092/165] (897s left) kms_busy (basic) [114.011389] Starting subtest: basic [114.014512] Starting dynamic subtest: flip [114.920077] Dynamic subtest flip: SUCCESS (0.819s) [114.984863] Starting dynamic subtest: modeset [116.094500] Dynamic subtest modeset: SUCCESS (1.127s) [116.098038] Subtest basic: SUCCESS (1.949s) [116.583224] [093/165] (894s left) kms_prop_blob (basic) [117.205426] Starting subtest: basic [117.278461] Subtest basic: SUCCESS (0.000s) [117.525458] [094/165] (894s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [118.234251] Starting subtest: basic-busy-flip-before-cursor-atomic [118.364388] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [118.592534] [095/165] (893s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [119.170188] Starting subtest: basic-busy-flip-before-cursor-legacy [119.179180] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [119.220239] [096/165] (892s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [119.513775] Starting subtest: basic-flip-after-cursor-atomic [120.687986] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.054s) [121.203453] [097/165] (890s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [121.505659] Starting subtest: basic-flip-after-cursor-legacy [122.548282] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.045s) [122.943884] [098/165] (889s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [123.228983] Starting subtest: basic-flip-after-cursor-varying-size [124.235332] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.010s) [124.660506] [099/165] (887s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [124.965067] Starting subtest: basic-flip-before-cursor-atomic [125.990621] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.029s) [126.399643] [100/165] (885s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [126.707069] Starting subtest: basic-flip-before-cursor-legacy [127.729558] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.026s) [128.152257] [101/165] (884s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [128.456038] Starting subtest: basic-flip-before-cursor-varying-size [129.482370] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.027s) [129.887712] [102/165] (882s left) kms_dsc (dsc-basic) [130.184517] Subtest dsc-basic: SKIP (0.000s) [130.221968] [103/165] (882s left) kms_flip (basic-flip-vs-dpms) [130.507674] Starting subtest: basic-flip-vs-dpms [130.510657] Starting dynamic subtest: A-DP1 [131.660534] Dynamic subtest A-DP1: SUCCESS (1.147s) [131.670467] Starting dynamic subtest: B-DP1 [132.647696] Dynamic subtest B-DP1: SUCCESS (0.985s) [132.660131] Starting dynamic subtest: C-DP1 [133.665202] Dynamic subtest C-DP1: SUCCESS (1.014s) [133.678965] Starting dynamic subtest: A-DP2 [134.565564] Dynamic subtest A-DP2: SUCCESS (0.897s) [134.576774] Starting dynamic subtest: B-DP2 [135.448237] Dynamic subtest B-DP2: SUCCESS (0.879s) [135.461386] Starting dynamic subtest: C-DP2 [136.358650] Dynamic subtest C-DP2: SUCCESS (0.915s) [136.361990] Subtest basic-flip-vs-dpms: SUCCESS (5.853s) [136.847623] [104/165] (875s left) kms_flip (basic-flip-vs-modeset) [137.156831] Starting subtest: basic-flip-vs-modeset [137.159709] Starting dynamic subtest: A-DP1 [138.234768] Dynamic subtest A-DP1: SUCCESS (1.069s) [138.254201] Starting dynamic subtest: B-DP1 [139.221447] Dynamic subtest B-DP1: SUCCESS (0.985s) [139.233535] Starting dynamic subtest: C-DP1 [140.214300] Dynamic subtest C-DP1: SUCCESS (0.988s) [140.226545] Starting dynamic subtest: A-DP2 [141.126285] Dynamic subtest A-DP2: SUCCESS (0.908s) [141.136844] Starting dynamic subtest: B-DP2 [141.823811] Dynamic subtest B-DP2: SUCCESS (0.698s) [141.833561] Starting dynamic subtest: C-DP2 [142.704092] Dynamic subtest C-DP2: SUCCESS (0.879s) [142.706842] Subtest basic-flip-vs-modeset: SUCCESS (5.551s) [143.169276] [105/165] (869s left) kms_flip (basic-flip-vs-wf_vblank) [143.473095] Starting subtest: basic-flip-vs-wf_vblank [143.476015] Starting dynamic subtest: A-DP1 [144.819232] Dynamic subtest A-DP1: SUCCESS (1.232s) [144.885117] Starting dynamic subtest: B-DP1 [145.937407] Dynamic subtest B-DP1: SUCCESS (1.117s) [146.003300] Starting dynamic subtest: C-DP1 [146.967768] Dynamic subtest C-DP1: SUCCESS (1.116s) [146.980357] Starting dynamic subtest: A-DP2 [148.009707] Dynamic subtest A-DP2: SUCCESS (1.058s) [148.024028] Starting dynamic subtest: B-DP2 [149.081569] Dynamic subtest B-DP2: SUCCESS (1.072s) [149.092847] Starting dynamic subtest: C-DP2 [150.299736] Dynamic subtest C-DP2: SUCCESS (1.215s) [150.304122] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.830s) [150.867397] [106/165] (861s left) kms_flip (basic-plain-flip) [151.156363] Starting subtest: basic-plain-flip [151.159299] Starting dynamic subtest: A-DP1 [152.052075] Dynamic subtest A-DP1: SUCCESS (0.893s) [152.064430] Starting dynamic subtest: B-DP1 [152.923273] Dynamic subtest B-DP1: SUCCESS (0.866s) [152.934403] Starting dynamic subtest: C-DP1 [153.777644] Dynamic subtest C-DP1: SUCCESS (0.851s) [153.809461] Starting dynamic subtest: A-DP2 [154.621444] Dynamic subtest A-DP2: SUCCESS (0.837s) [154.633066] Starting dynamic subtest: B-DP2 [155.394021] Dynamic subtest B-DP2: SUCCESS (0.772s) [155.406851] Starting dynamic subtest: C-DP2 [156.187608] Dynamic subtest C-DP2: SUCCESS (0.789s) [156.191112] Subtest basic-plain-flip: SUCCESS (5.032s) [156.704929] [107/165] (855s left) kms_force_connector_basic (force-connector-state) [156.846248] Starting subtest: force-connector-state [157.455296] Subtest force-connector-state: SUCCESS (0.611s) [158.292250] [108/165] (854s left) kms_force_connector_basic (force-edid) [158.418444] Starting subtest: force-edid [158.528070] Subtest force-edid: SUCCESS (0.110s) [159.043060] [109/165] (853s left) kms_force_connector_basic (force-load-detect) [159.168108] Starting subtest: force-load-detect [159.173482] Subtest force-load-detect: SKIP (0.000s) [159.479094] [110/165] (853s left) kms_force_connector_basic (prune-stale-modes) [159.609211] Starting subtest: prune-stale-modes [159.722416] Subtest prune-stale-modes: SUCCESS (0.112s) [160.242264] [111/165] (852s left) kms_frontbuffer_tracking (basic) [160.542822] Starting subtest: basic [163.346711] Subtest basic: SUCCESS (2.799s) [163.632838] [112/165] (849s left) kms_hdmi_inject (inject-audio) [163.861204] Starting subtest: inject-audio [164.029516] Subtest inject-audio: SUCCESS (0.171s) [164.691561] [113/165] (848s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [164.977500] Starting subtest: compare-crc-sanitycheck-xr24 [164.980333] Starting dynamic subtest: pipe-A-DP-1 [165.589205] Dynamic subtest pipe-A-DP-1: SUCCESS (0.605s) [165.604050] Starting dynamic subtest: pipe-B-DP-2 [166.071770] Dynamic subtest pipe-B-DP-2: SUCCESS (0.482s) [166.083303] Starting dynamic subtest: pipe-C-DP-1 [166.655930] Dynamic subtest pipe-C-DP-1: SUCCESS (0.573s) [166.659505] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.675s) [167.085227] [114/165] (845s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [167.386154] Starting subtest: compare-crc-sanitycheck-nv12 [167.389054] Starting dynamic subtest: pipe-A-DP-1 [168.042824] Dynamic subtest pipe-A-DP-1: SUCCESS (0.648s) [168.057169] Starting dynamic subtest: pipe-B-DP-2 [168.566570] Dynamic subtest pipe-B-DP-2: SUCCESS (0.518s) [168.576796] Starting dynamic subtest: pipe-C-DP-1 [168.583459] Dynamic subtest pipe-C-DP-1: SKIP (0.001s) [168.586859] Subtest compare-crc-sanitycheck-nv12: SUCCESS (1.181s) [168.998037] [115/165] (843s left) kms_pipe_crc_basic (hang-read-crc) [169.283930] Starting subtest: hang-read-crc [169.286713] Starting dynamic subtest: pipe-A-DP-1 [170.675600] Dynamic subtest pipe-A-DP-1: SUCCESS (1.391s) [170.693259] Starting dynamic subtest: pipe-B-DP-2 [171.869457] Dynamic subtest pipe-B-DP-2: SUCCESS (1.188s) [171.879970] Starting dynamic subtest: pipe-C-DP-1 [173.207278] Dynamic subtest pipe-C-DP-1: SUCCESS (1.331s) [173.210654] Subtest hang-read-crc: SUCCESS (3.924s) [173.579147] [116/165] (839s left) kms_pipe_crc_basic (nonblocking-crc) [173.881784] Starting subtest: nonblocking-crc [173.884646] Starting dynamic subtest: pipe-A-DP-1 [174.722026] Dynamic subtest pipe-A-DP-1: SUCCESS (0.751s) [174.791202] Starting dynamic subtest: pipe-B-DP-2 [175.369040] Dynamic subtest pipe-B-DP-2: SUCCESS (0.636s) [175.520889] Starting dynamic subtest: pipe-C-DP-1 [176.020558] Dynamic subtest pipe-C-DP-1: SUCCESS (0.742s) [176.023674] Subtest nonblocking-crc: SUCCESS (2.141s) [176.430320] [117/165] (836s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [176.728448] Starting subtest: nonblocking-crc-frame-sequence [176.731794] Starting dynamic subtest: pipe-A-DP-1 [177.507039] Dynamic subtest pipe-A-DP-1: SUCCESS (0.776s) [177.525412] Starting dynamic subtest: pipe-B-DP-2 [178.173456] Dynamic subtest pipe-B-DP-2: SUCCESS (0.661s) [178.198865] Starting dynamic subtest: pipe-C-DP-1 [178.931768] Dynamic subtest pipe-C-DP-1: SUCCESS (0.749s) [178.935174] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.202s) [179.358845] [118/165] (833s left) kms_pipe_crc_basic (read-crc) [179.663206] Starting subtest: read-crc [179.666044] Starting dynamic subtest: pipe-A-DP-1 [180.366109] Dynamic subtest pipe-A-DP-1: SUCCESS (0.700s) [180.382093] Starting dynamic subtest: pipe-B-DP-2 [180.970719] Dynamic subtest pipe-B-DP-2: SUCCESS (0.602s) [180.980941] Starting dynamic subtest: pipe-C-DP-1 [181.630379] Dynamic subtest pipe-C-DP-1: SUCCESS (0.651s) [181.633982] Subtest read-crc: SUCCESS (1.966s) [182.025256] [119/165] (830s left) kms_pipe_crc_basic (read-crc-frame-sequence) [182.325102] Starting subtest: read-crc-frame-sequence [182.328215] Starting dynamic subtest: pipe-A-DP-1 [183.035486] Dynamic subtest pipe-A-DP-1: SUCCESS (0.705s) [183.051730] Starting dynamic subtest: pipe-B-DP-2 [183.634082] Dynamic subtest pipe-B-DP-2: SUCCESS (0.596s) [183.644285] Starting dynamic subtest: pipe-C-DP-1 [184.290496] Dynamic subtest pipe-C-DP-1: SUCCESS (0.650s) [184.294474] Subtest read-crc-frame-sequence: SUCCESS (1.965s) [184.724735] [120/165] (828s left) kms_pm_backlight (basic-brightness) [185.038864] Subtest basic-brightness: SKIP (0.000s) [185.066103] [121/165] (828s left) kms_pm_rpm (basic-pci-d3-state) [186.912114] Starting subtest: basic-pci-d3-state [187.555603] Subtest basic-pci-d3-state: SUCCESS (0.641s) [187.979260] [122/165] (825s left) kms_pm_rpm (basic-rte) [188.078817] Starting subtest: basic-rte [190.647363] Subtest basic-rte: SUCCESS (2.566s) [191.806122] [123/165] (821s left) kms_psr (psr-primary-page-flip) [192.118464] Subtest psr-primary-page-flip: SKIP (0.000s) [192.157628] [124/165] (821s left) kms_psr (psr-cursor-plane-move) [192.444191] Subtest psr-cursor-plane-move: SKIP (0.000s) [192.475381] [125/165] (820s left) kms_psr (psr-sprite-plane-onoff) [192.778047] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [192.809529] [126/165] (820s left) kms_psr (psr-primary-mmap-gtt) [193.088266] Subtest psr-primary-mmap-gtt: SKIP (0.000s) [193.126173] [127/165] (820s left) kms_setmode (basic-clone-single-crtc) [193.199687] Starting subtest: basic-clone-single-crtc [193.366766] Subtest basic-clone-single-crtc: SKIP (0.171s) [193.765721] [128/165] (819s left) i915_pm_rps (basic-api) [193.855971] Starting subtest: basic-api [193.859433] Subtest basic-api: SUCCESS (0.004s) [193.934248] [129/165] (819s left) prime_self_import (basic-llseek-bad) [193.999084] Starting subtest: basic-llseek-bad [194.005585] Subtest basic-llseek-bad: SUCCESS (0.002s) [194.095667] [130/165] (819s left) prime_self_import (basic-llseek-size) [194.183144] Starting subtest: basic-llseek-size [194.189307] Subtest basic-llseek-size: SUCCESS (0.003s) [194.288957] [131/165] (819s left) prime_self_import (basic-with_fd_dup) [194.374345] Starting subtest: basic-with_fd_dup [194.380605] Subtest basic-with_fd_dup: SUCCESS (0.003s) [194.470812] [132/165] (818s left) prime_self_import (basic-with_one_bo) [194.543024] Starting subtest: basic-with_one_bo [194.549184] Subtest basic-with_one_bo: SUCCESS (0.005s) [194.621799] [133/165] (818s left) prime_self_import (basic-with_one_bo_two_files) [194.691182] Starting subtest: basic-with_one_bo_two_files [194.697274] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s) [194.813859] [134/165] (818s left) prime_self_import (basic-with_two_bos) [194.900230] Starting subtest: basic-with_two_bos [194.906450] Subtest basic-with_two_bos: SUCCESS (0.002s) [194.998204] [135/165] (818s left) prime_vgem (basic-fence-flip) [195.104598] Starting subtest: basic-fence-flip [195.891445] Subtest basic-fence-flip: SUCCESS (0.691s) [196.200313] [136/165] (817s left) prime_vgem (basic-fence-mmap) [196.678598] Starting subtest: basic-fence-mmap [196.747226] Subtest basic-fence-mmap: SUCCESS (0.042s) [197.070554] [137/165] (816s left) prime_vgem (basic-fence-read) [197.171239] Starting subtest: basic-fence-read [197.225598] Subtest basic-fence-read: SUCCESS (0.055s) [197.317317] [138/165] (816s left) prime_vgem (basic-gtt) [197.438202] Starting subtest: basic-gtt [197.449042] Subtest basic-gtt: SUCCESS (0.013s) [197.549848] [139/165] (816s left) prime_vgem (basic-read) [197.663632] Starting subtest: basic-read [197.684838] Subtest basic-read: SUCCESS (0.021s) [197.778385] [140/165] (816s left) prime_vgem (basic-write) [197.871655] Starting subtest: basic-write [197.895021] Subtest basic-write: SUCCESS (0.023s) [197.970300] [141/165] (816s left) vgem_basic (setversion) [198.065276] Starting subtest: setversion [198.073329] Subtest setversion: SUCCESS (0.000s) [198.139044] [142/165] (816s left) vgem_basic (create) [198.230959] Starting subtest: create [198.234543] Subtest create: SUCCESS (0.000s) [198.285853] [143/165] (815s left) vgem_basic (debugfs) [198.367519] Starting subtest: debugfs [198.370803] Subtest debugfs: SUCCESS (0.000s) [198.415423] [144/165] (815s left) vgem_basic (dmabuf-export) [198.483592] Starting subtest: dmabuf-export [198.490202] Subtest dmabuf-export: SUCCESS (0.002s) [198.588527] [145/165] (815s left) vgem_basic (dmabuf-fence) [198.668972] Starting subtest: dmabuf-fence [198.672971] Subtest dmabuf-fence: SUCCESS (0.001s) [198.740491] [146/165] (815s left) vgem_basic (dmabuf-fence-before) [198.831184] Starting subtest: dmabuf-fence-before [198.834195] Subtest dmabuf-fence-before: SUCCESS (0.000s) [198.882439] [147/165] (815s left) vgem_basic (dmabuf-mmap) [198.964188] Starting subtest: dmabuf-mmap [198.975699] Subtest dmabuf-mmap: SUCCESS (0.013s) [199.038494] [148/165] (815s left) vgem_basic (mmap) [199.149243] Starting subtest: mmap [199.170448] Subtest mmap: SUCCESS (0.023s) [199.242198] [149/165] (815s left) vgem_basic (second-client) [199.331611] Starting subtest: second-client [199.365884] Subtest second-client: SUCCESS (0.034s) [199.446316] [150/165] (815s left) vgem_basic (sysfs) [199.535252] Starting subtest: sysfs [199.539215] Subtest sysfs: SUCCESS (0.001s) [199.608707] [151/165] (814s left) core_hotunplug (unbind-rebind) [199.746480] Starting subtest: unbind-rebind [203.194078] Subtest unbind-rebind: SUCCESS (3.447s) [203.226764] [152/165] (811s left) vgem_basic (unload) [203.304667] Starting subtest: unload [232.281729] Subtest unload: SUCCESS (28.978s) [232.406246] [153/165] (782s left) i915_module_load (reload) [232.488172] Starting subtest: reload [235.362493] Subtest reload: SUCCESS (2.879s) [235.388410] [154/165] (779s left) gem_lmem_swapping (basic) [235.506169] Subtest basic: SKIP (0.000s) [235.544842] [155/165] (779s left) gem_lmem_swapping (parallel-random-engines) [235.624805] Subtest parallel-random-engines: SKIP (0.000s) [235.644609] [156/165] (779s left) gem_lmem_swapping (random-engines) [235.715642] Subtest random-engines: SKIP (0.000s) [235.744736] [157/165] (778s left) gem_lmem_swapping (verify-random) [235.816912] Subtest verify-random: SKIP (0.000s) [235.845624] [158/165] (778s left) i915_pm_rpm (module-reload) [238.321732] Starting subtest: module-reload [246.174965] Subtest module-reload: SUCCESS (7.861s) [246.205720] [159/165] (768s left) i915_selftest (live) [246.298413] Starting subtest: live [246.301887] Starting dynamic subtest: sanitycheck [246.958274] Dynamic subtest sanitycheck: SUCCESS (0.657s) [246.966639] Starting dynamic subtest: uncore [247.670262] Dynamic subtest uncore: SUCCESS (0.710s) [247.679586] Starting dynamic subtest: workarounds [248.556314] Dynamic subtest workarounds: SUCCESS (0.885s) [248.567536] Starting dynamic subtest: gt_engines [249.750240] Dynamic subtest gt_engines: SUCCESS (1.191s) [249.759059] Starting dynamic subtest: gt_timelines [261.106338] Dynamic subtest gt_timelines: SUCCESS (11.354s) [261.118519] Starting dynamic subtest: gt_contexts [261.912958] Dynamic subtest gt_contexts: SUCCESS (0.807s) [261.923974] Starting dynamic subtest: gt_lrc [265.567022] Dynamic subtest gt_lrc: SUCCESS (3.652s) [265.577065] Starting dynamic subtest: gt_mocs [266.391111] Dynamic subtest gt_mocs: SUCCESS (0.822s) [266.400236] Starting dynamic subtest: gt_pm [273.023228] Dynamic subtest gt_pm: SUCCESS (6.628s) [273.032137] Starting dynamic subtest: gt_heartbeat [273.804460] Dynamic subtest gt_heartbeat: SUCCESS (0.782s) [273.814753] Starting dynamic subtest: gt_tlb [275.538179] Dynamic subtest gt_tlb: SUCCESS (1.730s) [275.547504] Starting dynamic subtest: requests [283.628059] Dynamic subtest requests: SUCCESS (8.090s) [283.639172] Starting dynamic subtest: migrate [287.120103] Dynamic subtest migrate: SUCCESS (3.490s) [287.130221] Starting dynamic subtest: active [287.810210] Dynamic subtest active: SUCCESS (0.688s) [287.821246] Starting dynamic subtest: objects [289.520106] Dynamic subtest objects: SUCCESS (1.708s) [289.528979] Starting dynamic subtest: mman [294.110340] Dynamic subtest mman: SUCCESS (4.586s) [294.121757] Starting dynamic subtest: dmabuf [294.826157] Dynamic subtest dmabuf: SUCCESS (0.716s) [294.837181] Starting dynamic subtest: vma [295.530102] Dynamic subtest vma: SUCCESS (0.702s) [295.540354] Starting dynamic subtest: coherency [297.191488] Dynamic subtest coherency: SUCCESS (1.659s) [297.204919] Starting dynamic subtest: gtt [305.077842] Dynamic subtest gtt: SUCCESS (7.885s) [305.086260] Starting dynamic subtest: gem [305.922998] Dynamic subtest gem: SUCCESS (0.844s) [305.933425] Starting dynamic subtest: evict [308.323460] Dynamic subtest evict: SUCCESS (2.398s) [308.332340] Starting dynamic subtest: hugepages [315.439239] Dynamic subtest hugepages: SUCCESS (7.114s) [315.449389] Starting dynamic subtest: gem_contexts [331.933212] Dynamic subtest gem_contexts: SUCCESS (16.492s) [331.944310] Starting dynamic subtest: client [332.709068] Dynamic subtest client: SUCCESS (0.774s) [332.721229] Starting dynamic subtest: gem_migrate [333.390027] Dynamic subtest gem_migrate: SUCCESS (0.679s) [333.399091] Starting dynamic subtest: reset [334.902993] Dynamic subtest reset: SUCCESS (1.511s) [334.912531] Starting dynamic subtest: memory_region [335.599229] Dynamic subtest memory_region: SUCCESS (0.692s) [335.607849] Starting dynamic subtest: hangcheck [364.804998] Dynamic subtest hangcheck: SUCCESS (29.206s) [364.814163] Starting dynamic subtest: execlists [377.980606] Dynamic subtest execlists: SUCCESS (13.174s) [377.992281] Starting dynamic subtest: ring_submission [378.669354] Dynamic subtest ring_submission: SUCCESS (0.685s) [378.681935] Starting dynamic subtest: perf [379.422142] Dynamic subtest perf: SUCCESS (0.753s) [379.433308] Starting dynamic subtest: slpc [380.110979] Dynamic subtest slpc: SUCCESS (0.687s) [380.120056] Starting dynamic subtest: guc [380.782019] Dynamic subtest guc: SUCCESS (0.669s) [380.793162] Starting dynamic subtest: guc_multi_lrc [381.461253] Dynamic subtest guc_multi_lrc: SUCCESS (0.675s) [381.472614] Starting dynamic subtest: guc_hang [382.164027] Dynamic subtest guc_hang: SUCCESS (0.703s) [382.175449] Starting dynamic subtest: late_gt_pm [382.952164] Dynamic subtest late_gt_pm: SUCCESS (0.784s) [382.955268] Subtest live: SUCCESS (136.653s) [382.975654] [160/165] (631s left) dmabuf (all-tests) [383.058326] Starting subtest: all-tests [383.066206] Starting dynamic subtest: sanitycheck [383.135343] Dynamic subtest sanitycheck: SUCCESS (0.075s) [383.157377] Starting dynamic subtest: dma_fence [383.321572] Dynamic subtest dma_fence: SUCCESS (0.183s) [383.334495] Starting dynamic subtest: dma_fence_chain [398.254953] Dynamic subtest dma_fence_chain: SUCCESS (14.931s) [398.275507] Starting dynamic subtest: dma_fence_unwrap [398.333260] Dynamic subtest dma_fence_unwrap: SUCCESS (0.073s) [398.353290] Starting dynamic subtest: dma_resv [398.416317] Dynamic subtest dma_resv: SUCCESS (0.080s) [398.420098] Subtest all-tests: SUCCESS (15.358s) [398.457424] [161/165] (616s left) i915_suspend (basic-s2idle-without-i915) [398.545881] Starting subtest: basic-s2idle-without-i915 [417.148496] Subtest basic-s2idle-without-i915: SUCCESS (3.747s) [420.761141] [162/165] (611s left) i915_suspend (basic-s3-without-i915) [420.838197] Starting subtest: basic-s3-without-i915 [439.895707] Subtest basic-s3-without-i915: SUCCESS (3.353s) [443.487579] [163/165] (607s left) gem_exec_suspend (basic-s0) [443.608601] Starting subtest: basic-S0 [443.611866] Starting dynamic subtest: smem [462.080098] Dynamic subtest smem: SUCCESS (2.941s) [462.083372] Subtest basic-S0: SUCCESS (2.943s) [467.274638] [164/165] (604s left) gem_exec_suspend (basic-s3) [467.353811] Starting subtest: basic-S3 [467.357164] Starting dynamic subtest: smem [486.748545] Dynamic subtest smem: SUCCESS (3.490s) [486.751967] Subtest basic-S3: SUCCESS (3.491s) [489.935425] [165/165] (601s left) kms_pipe_crc_basic (suspend-read-crc) [490.258213] Starting subtest: suspend-read-crc [490.261487] Starting dynamic subtest: pipe-A-DP-1 [509.733055] Dynamic subtest pipe-A-DP-1: SUCCESS (3.071s) [509.746905] Starting dynamic subtest: pipe-B-DP-2 [528.673622] Dynamic subtest pipe-B-DP-2: SUCCESS (2.687s) [528.685727] Starting dynamic subtest: pipe-C-DP-1 [547.749351] Dynamic subtest pipe-C-DP-1: SUCCESS (2.831s) [547.752615] Subtest suspend-read-crc: SUCCESS (8.598s) [552.130189] Closing watchdogs Done.