[43.585805] Initializing watchdogs [43.585944] /dev/watchdog0 [43.595743] [001/165] (960s left) i915_module_load (load) [43.698791] Starting subtest: load [46.242811] Subtest load: SUCCESS (2.544s) [46.267310] [002/165] (957s left) core_auth (basic-auth) [46.365954] Starting subtest: basic-auth [46.367195] Subtest basic-auth: SUCCESS (0.001s) [46.444561] [003/165] (957s left) debugfs_test (read_all_entries) [46.546207] Starting subtest: read_all_entries [46.613889] Subtest read_all_entries: SUCCESS (0.066s) [46.733725] [004/165] (957s left) debugfs_test (basic-hwmon) [46.827470] Starting subtest: basic-hwmon [46.829535] Subtest basic-hwmon: SKIP (0.000s) [46.928034] [005/165] (957s left) fbdev (eof) [47.030201] Starting subtest: eof [47.031330] Subtest eof: SUCCESS (0.001s) [47.116345] [006/165] (957s left) fbdev (info) [47.221209] Starting subtest: info [47.222327] Subtest info: SUCCESS (0.000s) [47.291702] [007/165] (956s left) fbdev (nullptr) [47.395165] Starting subtest: nullptr [47.396343] Subtest nullptr: SUCCESS (0.000s) [47.464204] [008/165] (956s left) fbdev (read) [47.561671] Starting subtest: read [54.668751] Subtest read: SUCCESS (7.073s) [54.700706] [009/165] (949s left) fbdev (write) [54.802455] Starting subtest: write [58.574632] Subtest write: SUCCESS (3.738s) [58.627385] [010/165] (945s left) gem_basic (bad-close) [58.717818] Starting subtest: bad-close [58.720186] Subtest bad-close: SUCCESS (0.000s) [58.794506] [011/165] (945s left) gem_basic (create-close) [58.884541] Starting subtest: create-close [58.886814] Subtest create-close: SUCCESS (0.000s) [58.976349] [012/165] (945s left) gem_basic (create-fd-close) [59.067135] Starting subtest: create-fd-close [59.069115] Subtest create-fd-close: SUCCESS (0.000s) [59.177255] [013/165] (945s left) gem_busy (busy@all-engines) [59.288393] Starting subtest: busy [59.289794] Starting dynamic subtest: all-engines [59.352478] Dynamic subtest all-engines: SUCCESS (0.067s) [59.353612] Subtest busy: SUCCESS (0.067s) [59.749680] [014/165] (944s left) gem_close_race (basic-process) [59.860563] Starting subtest: basic-process [59.925356] Subtest basic-process: SUCCESS (0.064s) [60.134875] [015/165] (944s left) gem_close_race (basic-threads) [60.247499] Starting subtest: basic-threads [61.510037] Subtest basic-threads: SUCCESS (1.265s) [61.744556] [016/165] (942s left) gem_ctx_create (basic) [61.851901] Starting subtest: basic [61.853130] Subtest basic: SUCCESS (0.000s) [62.063762] [017/165] (942s left) gem_ctx_create (basic-files) [62.167846] Starting subtest: basic-files [64.193257] Subtest basic-files: SUCCESS (2.024s) [64.423140] [018/165] (940s left) gem_ctx_exec (basic) [64.517859] Starting subtest: basic [64.522565] Subtest basic: SUCCESS (0.005s) [64.634131] [019/165] (939s left) gem_exec_basic (basic) [64.735378] Starting subtest: basic [64.736742] Starting dynamic subtest: rcs0-smem [64.737977] Dynamic subtest rcs0-smem: SUCCESS (0.002s) [64.749127] Starting dynamic subtest: bcs0-smem [64.750457] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [64.760855] Starting dynamic subtest: vcs0-smem [64.762198] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [64.772611] Starting dynamic subtest: vecs0-smem [64.774038] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [64.775374] Subtest basic: SUCCESS (0.006s) [64.933862] [020/165] (939s left) gem_exec_create (basic) [65.037234] Starting subtest: basic [65.038400] Starting dynamic subtest: smem [67.104413] Dynamic subtest smem: SUCCESS (2.067s) [67.105811] Subtest basic: SUCCESS (2.067s) [67.337587] [021/165] (937s left) gem_exec_fence (basic-busy) [67.594407] Starting subtest: basic-busy [67.595841] Starting dynamic subtest: rcs0 [67.627798] Dynamic subtest rcs0: SUCCESS (0.041s) [67.641238] Starting dynamic subtest: bcs0 [67.667435] Dynamic subtest bcs0: SUCCESS (0.039s) [67.683487] Starting dynamic subtest: vcs0 [67.687272] Dynamic subtest vcs0: SUCCESS (0.019s) [67.698321] Starting dynamic subtest: vecs0 [67.709430] Dynamic subtest vecs0: SUCCESS (0.023s) [67.710630] Subtest basic-busy: SUCCESS (0.124s) [68.306536] [022/165] (936s left) gem_exec_fence (basic-wait) [68.562143] Starting subtest: basic-wait [68.563444] Starting dynamic subtest: rcs0 [68.586952] Dynamic subtest rcs0: SUCCESS (0.033s) [68.601288] Starting dynamic subtest: bcs0 [68.618501] Dynamic subtest bcs0: SUCCESS (0.031s) [68.632106] Starting dynamic subtest: vcs0 [68.637375] Dynamic subtest vcs0: SUCCESS (0.019s) [68.648834] Starting dynamic subtest: vecs0 [68.659365] Dynamic subtest vecs0: SUCCESS (0.022s) [68.662037] Subtest basic-wait: SUCCESS (0.106s) [69.208178] [023/165] (935s left) gem_exec_fence (basic-await) [69.460459] Starting subtest: basic-await [69.461688] Starting dynamic subtest: rcs0 [69.554547] Dynamic subtest rcs0: SUCCESS (0.101s) [69.578495] Starting dynamic subtest: bcs0 [69.665864] Dynamic subtest bcs0: SUCCESS (0.110s) [69.692410] Starting dynamic subtest: vcs0 [69.818625] Dynamic subtest vcs0: SUCCESS (0.144s) [69.844760] Starting dynamic subtest: vecs0 [69.942980] Dynamic subtest vecs0: SUCCESS (0.132s) [69.945067] Subtest basic-await: SUCCESS (0.491s) [70.511070] [024/165] (934s left) gem_exec_fence (nb-await) [70.764645] Starting subtest: nb-await [70.765912] Starting dynamic subtest: rcs0 [70.822381] Dynamic subtest rcs0: SUCCESS (0.065s) [70.841015] Starting dynamic subtest: bcs0 [70.891311] Dynamic subtest bcs0: SUCCESS (0.069s) [70.911793] Starting dynamic subtest: vcs0 [70.962636] Dynamic subtest vcs0: SUCCESS (0.070s) [70.981745] Starting dynamic subtest: vecs0 [71.032490] Dynamic subtest vecs0: SUCCESS (0.069s) [71.034854] Subtest nb-await: SUCCESS (0.275s) [71.578853] [025/165] (933s left) gem_exec_gttfill (basic) [71.683955] Starting subtest: basic [77.862707] Subtest basic: SUCCESS (6.178s) [78.068561] [026/165] (926s left) gem_exec_parallel (engines) [78.249076] Starting subtest: engines [78.250363] Starting dynamic subtest: basic [81.227413] Dynamic subtest basic: SUCCESS (2.956s) [81.243378] Starting dynamic subtest: contexts [86.952027] Dynamic subtest contexts: SUCCESS (5.749s) [86.965243] Starting dynamic subtest: fds [96.693398] Dynamic subtest fds: SUCCESS (9.741s) [96.707432] Starting dynamic subtest: userptr [99.851245] Dynamic subtest userptr: SUCCESS (3.129s) [99.853221] Subtest engines: SUCCESS (21.576s) [100.038346] [027/165] (904s left) gem_exec_store (basic) [100.144625] Starting subtest: basic [100.195681] Subtest basic: SUCCESS (0.052s) [100.415153] [028/165] (904s left) gem_flink_basic (bad-flink) [100.504757] Starting subtest: bad-flink [100.506173] Subtest bad-flink: SUCCESS (0.000s) [100.589695] [029/165] (904s left) gem_flink_basic (bad-open) [100.682419] Starting subtest: bad-open [100.683563] Subtest bad-open: SUCCESS (0.000s) [100.774822] [030/165] (904s left) gem_flink_basic (basic) [100.862780] Starting subtest: basic [100.863901] Subtest basic: SUCCESS (0.000s) [100.974662] [031/165] (903s left) gem_flink_basic (double-flink) [101.063300] Starting subtest: double-flink [101.064524] Subtest double-flink: SUCCESS (0.000s) [101.158886] [032/165] (903s left) gem_flink_basic (flink-lifetime) [101.246857] Starting subtest: flink-lifetime [101.249483] Subtest flink-lifetime: SUCCESS (0.002s) [101.360907] [033/165] (903s left) gem_huc_copy (huc-copy) [101.458682] Starting subtest: huc-copy [101.461076] Subtest huc-copy: SKIP (0.000s) [101.574273] [034/165] (903s left) gem_linear_blits (basic) [101.817082] Starting subtest: basic [101.835986] Subtest basic: SUCCESS (0.019s) [101.978994] [035/165] (903s left) gem_mmap (basic) [102.134702] Starting subtest: basic [102.140280] Subtest basic: SUCCESS (0.000s) [102.243075] [036/165] (902s left) gem_mmap_gtt (basic) [102.333767] Starting subtest: basic [102.335035] Subtest basic: SUCCESS (0.001s) [102.417638] [037/165] (902s left) gem_render_linear_blits (basic) [102.514311] Starting subtest: basic [102.567657] Subtest basic: SUCCESS (0.053s) [102.617519] [038/165] (902s left) gem_render_tiled_blits (basic) [102.712468] Starting subtest: basic [102.773250] Subtest basic: SUCCESS (0.060s) [102.835488] [039/165] (902s left) gem_ringfill (basic-all) [103.070756] Starting subtest: basic-all [104.297711] Subtest basic-all: SUCCESS (1.217s) [104.381642] [040/165] (900s left) gem_softpin (allocator-basic) [104.478543] Starting subtest: allocator-basic [104.646566] Subtest allocator-basic: SUCCESS (0.159s) [104.763996] [041/165] (900s left) gem_softpin (allocator-basic-reserve) [104.860134] Starting subtest: allocator-basic-reserve [105.019705] Subtest allocator-basic-reserve: SUCCESS (0.158s) [105.146983] [042/165] (900s left) gem_softpin (safe-alignment) [105.244158] Starting subtest: safe-alignment [105.261638] Subtest safe-alignment: SUCCESS (0.018s) [105.379294] [043/165] (899s left) gem_sync (basic-all) [105.487172] Starting subtest: basic-all [107.738163] Subtest basic-all: SUCCESS (2.228s) [107.933742] [044/165] (897s left) gem_sync (basic-each) [108.041322] Starting subtest: basic-each [110.278217] Subtest basic-each: SUCCESS (2.237s) [110.519926] [045/165] (894s left) gem_tiled_blits (basic) [110.738977] Starting subtest: basic [110.770557] Subtest basic: SUCCESS (0.032s) [110.904931] [046/165] (894s left) gem_tiled_fence_blits (basic) [111.206795] Starting subtest: basic [111.234338] Subtest basic: SUCCESS (0.028s) [111.369724] [047/165] (894s left) gem_tiled_pread_basic [111.871512] [048/165] (893s left) gem_wait (busy@all-engines) [111.989255] Starting subtest: busy [111.990450] Starting dynamic subtest: all-engines [112.523667] Dynamic subtest all-engines: SUCCESS (0.534s) [112.524814] Subtest busy: SUCCESS (0.535s) [112.773102] [049/165] (892s left) gem_wait (wait@all-engines) [112.885601] Starting subtest: wait [112.886756] Starting dynamic subtest: all-engines [113.917486] Dynamic subtest all-engines: SUCCESS (1.032s) [113.918697] Subtest wait: SUCCESS (1.032s) [114.155219] [050/165] (891s left) i915_getparams_basic (basic-eu-total) [114.246297] Starting subtest: basic-eu-total [114.248689] Subtest basic-eu-total: SUCCESS (0.000s) [114.337709] [051/165] (891s left) i915_getparams_basic (basic-subslice-total) [114.427253] Starting subtest: basic-subslice-total [114.429538] Subtest basic-subslice-total: SUCCESS (0.000s) [114.522378] [052/165] (891s left) i915_hangman (error-state-basic) [114.627095] Starting subtest: error-state-basic [114.640474] Subtest error-state-basic: SUCCESS (0.012s) [114.738356] [053/165] (890s left) i915_pciid [114.923794] [054/165] (890s left) kms_addfb_basic (addfb25-4-tiled) [115.049244] Starting subtest: addfb25-4-tiled [115.050395] Subtest addfb25-4-tiled: SUCCESS (0.000s) [115.158255] [055/165] (890s left) kms_addfb_basic (addfb25-bad-modifier) [115.250119] Starting subtest: addfb25-bad-modifier [115.251245] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [115.370595] [056/165] (890s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [115.462825] Starting subtest: addfb25-framebuffer-vs-set-tiling [115.464039] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [115.591986] [057/165] (890s left) kms_addfb_basic (addfb25-modifier-no-flag) [115.684258] Starting subtest: addfb25-modifier-no-flag [115.685318] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [115.806969] [058/165] (889s left) kms_addfb_basic (addfb25-x-tiled-legacy) [115.898316] Starting subtest: addfb25-x-tiled-legacy [115.899467] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [116.048100] [059/165] (889s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [116.137511] Starting subtest: addfb25-x-tiled-mismatch-legacy [116.138609] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [116.274986] [060/165] (889s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [116.395744] Starting subtest: addfb25-yf-tiled-legacy [116.397046] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [116.509778] [061/165] (889s left) kms_addfb_basic (addfb25-y-tiled-legacy) [116.629499] Starting subtest: addfb25-y-tiled-legacy [116.630907] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [116.748029] [062/165] (889s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [116.868467] Starting subtest: addfb25-y-tiled-small-legacy [116.869598] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [116.977210] [063/165] (888s left) kms_addfb_basic (bad-pitch-0) [117.068685] Starting subtest: bad-pitch-0 [117.069810] Subtest bad-pitch-0: SUCCESS (0.000s) [117.209400] [064/165] (888s left) kms_addfb_basic (bad-pitch-1024) [117.299815] Starting subtest: bad-pitch-1024 [117.300875] Subtest bad-pitch-1024: SUCCESS (0.000s) [117.428796] [065/165] (888s left) kms_addfb_basic (bad-pitch-128) [117.521298] Starting subtest: bad-pitch-128 [117.522398] Subtest bad-pitch-128: SUCCESS (0.000s) [117.636628] [066/165] (888s left) kms_addfb_basic (bad-pitch-256) [117.727494] Starting subtest: bad-pitch-256 [117.728632] Subtest bad-pitch-256: SUCCESS (0.000s) [117.859537] [067/165] (888s left) kms_addfb_basic (bad-pitch-32) [117.950462] Starting subtest: bad-pitch-32 [117.951589] Subtest bad-pitch-32: SUCCESS (0.000s) [118.093722] [068/165] (887s left) kms_addfb_basic (bad-pitch-63) [118.183788] Starting subtest: bad-pitch-63 [118.184898] Subtest bad-pitch-63: SUCCESS (0.000s) [118.335199] [069/165] (887s left) kms_addfb_basic (bad-pitch-65536) [118.425714] Starting subtest: bad-pitch-65536 [118.426829] Subtest bad-pitch-65536: SUCCESS (0.000s) [118.561108] [070/165] (887s left) kms_addfb_basic (bad-pitch-999) [118.653228] Starting subtest: bad-pitch-999 [118.654301] Subtest bad-pitch-999: SUCCESS (0.000s) [118.777407] [071/165] (887s left) kms_addfb_basic (basic) [118.869964] Starting subtest: basic [118.871189] Subtest basic: SUCCESS (0.000s) [118.988063] [072/165] (887s left) kms_addfb_basic (basic-x-tiled-legacy) [119.084764] Starting subtest: basic-x-tiled-legacy [119.085893] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [119.211340] [073/165] (886s left) kms_addfb_basic (basic-y-tiled-legacy) [119.302975] Starting subtest: basic-y-tiled-legacy [119.304254] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [119.427147] [074/165] (886s left) kms_addfb_basic (bo-too-small) [119.546691] Starting subtest: bo-too-small [119.547903] Subtest bo-too-small: SUCCESS (0.000s) [119.645323] [075/165] (886s left) kms_addfb_basic (bo-too-small-due-to-tiling) [119.765130] Starting subtest: bo-too-small-due-to-tiling [119.766271] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [119.861808] [076/165] (886s left) kms_addfb_basic (clobberred-modifier) [119.952254] Starting subtest: clobberred-modifier [119.953387] Subtest clobberred-modifier: SUCCESS (0.000s) [120.097049] [077/165] (886s left) kms_addfb_basic (framebuffer-vs-set-tiling) [120.188939] Starting subtest: framebuffer-vs-set-tiling [120.190168] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [120.330288] [078/165] (885s left) kms_addfb_basic (invalid-get-prop) [120.422641] Starting subtest: invalid-get-prop [120.423780] Subtest invalid-get-prop: SUCCESS (0.000s) [120.546197] [079/165] (885s left) kms_addfb_basic (invalid-get-prop-any) [120.637226] Starting subtest: invalid-get-prop-any [120.638259] Subtest invalid-get-prop-any: SUCCESS (0.000s) [120.778977] [080/165] (885s left) kms_addfb_basic (invalid-set-prop) [120.869759] Starting subtest: invalid-set-prop [120.870827] Subtest invalid-set-prop: SUCCESS (0.000s) [120.995169] [081/165] (885s left) kms_addfb_basic (invalid-set-prop-any) [121.085710] Starting subtest: invalid-set-prop-any [121.086814] Subtest invalid-set-prop-any: SUCCESS (0.000s) [121.215101] [082/165] (885s left) kms_addfb_basic (no-handle) [121.306135] Starting subtest: no-handle [121.307420] Subtest no-handle: SUCCESS (0.000s) [121.446442] [083/165] (884s left) kms_addfb_basic (size-max) [121.565907] Starting subtest: size-max [121.567057] Subtest size-max: SUCCESS (0.000s) [121.659277] [084/165] (884s left) kms_addfb_basic (small-bo) [121.779707] Starting subtest: small-bo [121.780877] Subtest small-bo: SUCCESS (0.000s) [121.880087] [085/165] (884s left) kms_addfb_basic (tile-pitch-mismatch) [121.971315] Starting subtest: tile-pitch-mismatch [121.972603] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [122.096156] [086/165] (884s left) kms_addfb_basic (too-high) [122.217351] Starting subtest: too-high [122.218513] Subtest too-high: SUCCESS (0.001s) [122.314363] [087/165] (884s left) kms_addfb_basic (too-wide) [122.435648] Starting subtest: too-wide [122.436827] Subtest too-wide: SUCCESS (0.000s) [122.555926] [088/165] (884s left) kms_addfb_basic (unused-handle) [122.648621] Starting subtest: unused-handle [122.649743] Subtest unused-handle: SUCCESS (0.000s) [122.759530] [089/165] (883s left) kms_addfb_basic (unused-modifier) [122.848212] Starting subtest: unused-modifier [122.849586] Subtest unused-modifier: SUCCESS (0.000s) [122.982333] [090/165] (883s left) kms_addfb_basic (unused-offsets) [123.073997] Starting subtest: unused-offsets [123.075094] Subtest unused-offsets: SUCCESS (0.000s) [123.199206] [091/165] (883s left) kms_addfb_basic (unused-pitches) [123.291161] Starting subtest: unused-pitches [123.292217] Subtest unused-pitches: SUCCESS (0.000s) [123.435953] [092/165] (883s left) kms_busy (basic) [123.561153] Starting subtest: basic [123.564894] Starting dynamic subtest: flip [124.581774] Dynamic subtest flip: SUCCESS (1.018s) [124.599303] Starting dynamic subtest: modeset [128.468259] Dynamic subtest modeset: SUCCESS (3.884s) [128.469397] Subtest basic: SUCCESS (4.905s) [129.392410] [093/165] (877s left) kms_prop_blob (basic) [129.489391] Starting subtest: basic [129.490487] Subtest basic: SUCCESS (0.000s) [129.575986] [094/165] (877s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [129.694826] Starting subtest: basic-busy-flip-before-cursor-atomic [129.697212] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [129.769188] [095/165] (876s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [129.887211] Starting subtest: basic-busy-flip-before-cursor-legacy [129.889590] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [129.971869] [096/165] (876s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [130.089994] Starting subtest: basic-flip-after-cursor-atomic [131.372933] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.282s) [132.334767] [097/165] (874s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [132.453449] Starting subtest: basic-flip-after-cursor-legacy [133.763989] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.310s) [134.702785] [098/165] (872s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [134.821983] Starting subtest: basic-flip-after-cursor-varying-size [136.130087] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.309s) [137.069765] [099/165] (869s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [137.188869] Starting subtest: basic-flip-before-cursor-atomic [138.465178] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.276s) [139.437921] [100/165] (867s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [139.556717] Starting subtest: basic-flip-before-cursor-legacy [140.865085] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.308s) [141.806720] [101/165] (865s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [141.925275] Starting subtest: basic-flip-before-cursor-varying-size [143.252683] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.327s) [144.177425] [102/165] (862s left) kms_dsc (dsc-basic) [144.297607] Subtest dsc-basic: SKIP (0.000s) [144.348284] [103/165] (862s left) kms_flip (basic-flip-vs-dpms) [144.470335] Starting subtest: basic-flip-vs-dpms [144.473080] Starting dynamic subtest: A-eDP1 [147.322760] Dynamic subtest A-eDP1: SUCCESS (2.845s) [147.337479] Starting dynamic subtest: B-eDP1 [149.749929] Dynamic subtest B-eDP1: SUCCESS (2.430s) [149.767953] Starting dynamic subtest: C-eDP1 [152.184197] Dynamic subtest C-eDP1: SUCCESS (2.432s) [152.185447] Subtest basic-flip-vs-dpms: SUCCESS (7.716s) [153.094194] [104/165] (853s left) kms_flip (basic-flip-vs-modeset) [153.215748] Starting subtest: basic-flip-vs-modeset [153.218915] Starting dynamic subtest: A-eDP1 [156.069597] Dynamic subtest A-eDP1: SUCCESS (2.849s) [156.090956] Starting dynamic subtest: B-eDP1 [158.432623] Dynamic subtest B-eDP1: SUCCESS (2.362s) [158.450540] Starting dynamic subtest: C-eDP1 [160.806025] Dynamic subtest C-eDP1: SUCCESS (2.370s) [160.807297] Subtest basic-flip-vs-modeset: SUCCESS (7.591s) [161.776038] [105/165] (845s left) kms_flip (basic-flip-vs-wf_vblank) [161.900027] Starting subtest: basic-flip-vs-wf_vblank [161.904286] Starting dynamic subtest: A-eDP1 [164.236126] Dynamic subtest A-eDP1: SUCCESS (2.332s) [164.253754] Starting dynamic subtest: B-eDP1 [166.520593] Dynamic subtest B-eDP1: SUCCESS (2.282s) [166.539130] Starting dynamic subtest: C-eDP1 [168.763903] Dynamic subtest C-eDP1: SUCCESS (2.241s) [168.769503] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.871s) [170.094383] [106/165] (836s left) kms_flip (basic-plain-flip) [170.216552] Starting subtest: basic-plain-flip [170.219361] Starting dynamic subtest: A-eDP1 [172.274336] Dynamic subtest A-eDP1: SUCCESS (2.054s) [172.296757] Starting dynamic subtest: B-eDP1 [174.238824] Dynamic subtest B-eDP1: SUCCESS (1.962s) [174.256861] Starting dynamic subtest: C-eDP1 [176.219626] Dynamic subtest C-eDP1: SUCCESS (1.979s) [176.223700] Subtest basic-plain-flip: SUCCESS (6.008s) [177.518989] [107/165] (829s left) kms_force_connector_basic (force-connector-state) [177.615265] Starting subtest: force-connector-state [178.211622] Subtest force-connector-state: SUCCESS (0.594s) [179.274292] [108/165] (827s left) kms_force_connector_basic (force-edid) [179.368413] Starting subtest: force-edid [179.628714] Subtest force-edid: SUCCESS (0.259s) [179.770058] [109/165] (827s left) kms_force_connector_basic (force-load-detect) [179.862677] Starting subtest: force-load-detect [179.865078] Subtest force-load-detect: SKIP (0.000s) [179.986900] [110/165] (827s left) kms_force_connector_basic (prune-stale-modes) [180.079321] Starting subtest: prune-stale-modes [180.398720] Subtest prune-stale-modes: SUCCESS (0.316s) [180.538632] [111/165] (826s left) kms_frontbuffer_tracking (basic) [180.668258] Starting subtest: basic [184.037980] Subtest basic: SUCCESS (3.369s) [184.163584] [112/165] (823s left) kms_hdmi_inject (inject-audio) [184.575904] Starting subtest: inject-audio [184.820403] Subtest inject-audio: SUCCESS (0.245s) [185.515096] [113/165] (821s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [185.634806] Starting subtest: compare-crc-sanitycheck-xr24 [185.637700] Starting dynamic subtest: pipe-A-eDP-1 [186.325033] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.684s) [186.344021] Starting dynamic subtest: pipe-B-eDP-1 [187.733839] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.404s) [187.751986] Starting dynamic subtest: pipe-C-eDP-1 [189.107146] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.372s) [189.108328] Subtest compare-crc-sanitycheck-xr24: SUCCESS (3.471s) [190.060316] [114/165] (817s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [190.180429] Starting subtest: compare-crc-sanitycheck-nv12 [190.181595] Starting dynamic subtest: pipe-A-eDP-1 [191.121904] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.938s) [191.139105] Starting dynamic subtest: pipe-B-eDP-1 [192.515346] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.392s) [192.534465] Starting dynamic subtest: pipe-C-eDP-1 [193.899417] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.380s) [193.900578] Subtest compare-crc-sanitycheck-nv12: SUCCESS (3.720s) [194.864092] [115/165] (812s left) kms_pipe_crc_basic (hang-read-crc) [194.983020] Starting subtest: hang-read-crc [194.986250] Starting dynamic subtest: pipe-A-eDP-1 [197.409532] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.423s) [197.427532] Starting dynamic subtest: pipe-B-eDP-1 [200.512555] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.100s) [200.531549] Starting dynamic subtest: pipe-C-eDP-1 [203.503988] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.989s) [203.505277] Subtest hang-read-crc: SUCCESS (8.522s) [204.462837] [116/165] (802s left) kms_pipe_crc_basic (nonblocking-crc) [204.583494] Starting subtest: nonblocking-crc [204.586609] Starting dynamic subtest: pipe-A-eDP-1 [205.475462] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.888s) [205.493817] Starting dynamic subtest: pipe-B-eDP-1 [207.090306] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.612s) [207.109370] Starting dynamic subtest: pipe-C-eDP-1 [208.651714] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.557s) [208.652974] Subtest nonblocking-crc: SUCCESS (4.068s) [209.583267] [117/165] (797s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [209.702566] Starting subtest: nonblocking-crc-frame-sequence [209.705765] Starting dynamic subtest: pipe-A-eDP-1 [210.593160] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.887s) [210.611379] Starting dynamic subtest: pipe-B-eDP-1 [212.210163] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.612s) [212.227726] Starting dynamic subtest: pipe-C-eDP-1 [213.786343] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.573s) [213.787533] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.083s) [214.699917] [118/165] (792s left) kms_pipe_crc_basic (read-crc) [214.819675] Starting subtest: read-crc [214.822839] Starting dynamic subtest: pipe-A-eDP-1 [215.644621] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.821s) [215.662939] Starting dynamic subtest: pipe-B-eDP-1 [217.152166] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.504s) [217.172126] Starting dynamic subtest: pipe-C-eDP-1 [218.632463] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.477s) [218.633767] Subtest read-crc: SUCCESS (3.814s) [219.566509] [119/165] (787s left) kms_pipe_crc_basic (read-crc-frame-sequence) [219.687056] Starting subtest: read-crc-frame-sequence [219.690227] Starting dynamic subtest: pipe-A-eDP-1 [220.509629] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.820s) [220.528141] Starting dynamic subtest: pipe-B-eDP-1 [222.079366] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.565s) [222.097894] Starting dynamic subtest: pipe-C-eDP-1 [223.586641] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.504s) [223.587877] Subtest read-crc-frame-sequence: SUCCESS (3.901s) [224.558279] [120/165] (782s left) kms_pm_backlight (basic-brightness) [224.679343] Starting subtest: basic-brightness [224.784135] Starting dynamic subtest: eDP-1 [225.369554] Dynamic subtest eDP-1: SUCCESS (0.585s) [225.374176] Subtest basic-brightness: SUCCESS (0.692s) [226.288705] [121/165] (781s left) kms_pm_rpm (basic-pci-d3-state) [228.120154] Starting subtest: basic-pci-d3-state [232.517138] Subtest basic-pci-d3-state: SUCCESS (4.397s) [232.739611] [122/165] (774s left) kms_pm_rpm (basic-rte) [232.828496] Starting subtest: basic-rte [242.822807] Subtest basic-rte: SUCCESS (9.993s) [244.313980] [123/165] (763s left) kms_psr (psr-primary-page-flip) [244.437805] Starting subtest: psr-primary-page-flip [244.439088] Starting dynamic subtest: eDP-1 [248.311751] Dynamic subtest eDP-1: SUCCESS (3.871s) [248.312918] Subtest psr-primary-page-flip: SUCCESS (3.874s) [249.264227] [124/165] (758s left) kms_psr (psr-cursor-plane-move) [249.386541] Starting subtest: psr-cursor-plane-move [249.387814] Starting dynamic subtest: eDP-1 [253.193672] Dynamic subtest eDP-1: SUCCESS (3.805s) [253.194813] Subtest psr-cursor-plane-move: SUCCESS (3.809s) [254.136661] [125/165] (753s left) kms_psr (psr-sprite-plane-onoff) [254.257311] Starting subtest: psr-sprite-plane-onoff [254.260758] Starting dynamic subtest: eDP-1 [258.155719] Dynamic subtest eDP-1: SUCCESS (3.895s) [258.156918] Subtest psr-sprite-plane-onoff: SUCCESS (3.898s) [259.119137] [126/165] (748s left) kms_psr (psr-primary-mmap-gtt) [259.238422] Starting subtest: psr-primary-mmap-gtt [259.242153] Starting dynamic subtest: eDP-1 [263.084070] Dynamic subtest eDP-1: SUCCESS (3.843s) [263.085269] Subtest psr-primary-mmap-gtt: SUCCESS (3.846s) [264.048466] [127/165] (743s left) kms_setmode (basic-clone-single-crtc) [264.141904] Starting subtest: basic-clone-single-crtc [264.145319] Subtest basic-clone-single-crtc: SKIP (0.000s) [264.230098] [128/165] (743s left) i915_pm_rps (basic-api) [264.327222] Starting subtest: basic-api [264.331853] Subtest basic-api: SUCCESS (0.005s) [264.415031] [129/165] (743s left) prime_self_import (basic-llseek-bad) [264.502779] Starting subtest: basic-llseek-bad [264.507682] Subtest basic-llseek-bad: SUCCESS (0.003s) [264.616472] [130/165] (743s left) prime_self_import (basic-llseek-size) [264.704916] Starting subtest: basic-llseek-size [264.709622] Subtest basic-llseek-size: SUCCESS (0.004s) [264.833719] [131/165] (742s left) prime_self_import (basic-with_fd_dup) [264.921528] Starting subtest: basic-with_fd_dup [264.926314] Subtest basic-with_fd_dup: SUCCESS (0.005s) [265.033384] [132/165] (742s left) prime_self_import (basic-with_one_bo) [265.121519] Starting subtest: basic-with_one_bo [265.126493] Subtest basic-with_one_bo: SUCCESS (0.005s) [265.211277] [133/165] (742s left) prime_self_import (basic-with_one_bo_two_files) [265.298705] Starting subtest: basic-with_one_bo_two_files [265.303393] Subtest basic-with_one_bo_two_files: SUCCESS (0.004s) [265.418878] [134/165] (742s left) prime_self_import (basic-with_two_bos) [265.506505] Starting subtest: basic-with_two_bos [265.511123] Subtest basic-with_two_bos: SUCCESS (0.005s) [265.617689] [135/165] (742s left) prime_vgem (basic-fence-flip) [265.731601] Starting subtest: basic-fence-flip [266.272546] Subtest basic-fence-flip: SUCCESS (0.541s) [266.403234] [136/165] (741s left) prime_vgem (basic-fence-mmap) [266.540174] Starting subtest: basic-fence-mmap [266.590473] Subtest basic-fence-mmap: SUCCESS (0.050s) [266.688875] [137/165] (741s left) prime_vgem (basic-fence-read) [266.810104] Starting subtest: basic-fence-read [266.886839] Subtest basic-fence-read: SUCCESS (0.077s) [266.987138] [138/165] (741s left) prime_vgem (basic-gtt) [267.107666] Starting subtest: basic-gtt [267.132853] Subtest basic-gtt: SUCCESS (0.025s) [267.260314] [139/165] (740s left) prime_vgem (basic-read) [267.365917] Starting subtest: basic-read [267.404257] Subtest basic-read: SUCCESS (0.037s) [267.501772] [140/165] (740s left) prime_vgem (basic-write) [267.618228] Starting subtest: basic-write [267.660025] Subtest basic-write: SUCCESS (0.044s) [267.751230] [141/165] (740s left) vgem_basic (setversion) [267.862683] Starting subtest: setversion [267.865920] Subtest setversion: SUCCESS (0.000s) [267.935389] [142/165] (740s left) vgem_basic (create) [268.042471] Starting subtest: create [268.043757] Subtest create: SUCCESS (0.000s) [268.119518] [143/165] (740s left) vgem_basic (debugfs) [268.226403] Starting subtest: debugfs [268.227708] Subtest debugfs: SUCCESS (0.001s) [268.301657] [144/165] (739s left) vgem_basic (dmabuf-export) [268.410026] Starting subtest: dmabuf-export [268.426547] Subtest dmabuf-export: SUCCESS (0.014s) [268.535111] [145/165] (739s left) vgem_basic (dmabuf-fence) [268.628845] Starting subtest: dmabuf-fence [268.630075] Subtest dmabuf-fence: SUCCESS (0.001s) [268.696963] [146/165] (739s left) vgem_basic (dmabuf-fence-before) [268.793558] Starting subtest: dmabuf-fence-before [268.794880] Subtest dmabuf-fence-before: SUCCESS (0.001s) [268.870227] [147/165] (739s left) vgem_basic (dmabuf-mmap) [268.976795] Starting subtest: dmabuf-mmap [269.002659] Subtest dmabuf-mmap: SUCCESS (0.026s) [269.065525] [148/165] (739s left) vgem_basic (mmap) [269.161495] Starting subtest: mmap [269.176890] Subtest mmap: SUCCESS (0.017s) [269.249262] [149/165] (739s left) vgem_basic (second-client) [269.343446] Starting subtest: second-client [269.379681] Subtest second-client: SUCCESS (0.034s) [269.454472] [150/165] (738s left) vgem_basic (sysfs) [269.560703] Starting subtest: sysfs [269.562040] Subtest sysfs: SUCCESS (0.001s) [269.637111] [151/165] (738s left) core_hotunplug (unbind-rebind) [269.777126] Starting subtest: unbind-rebind [274.272319] Subtest unbind-rebind: SUCCESS (4.495s) [274.308292] [152/165] (734s left) vgem_basic (unload) [274.402367] Starting subtest: unload [303.450600] Subtest unload: SUCCESS (29.014s) [303.565710] [153/165] (704s left) i915_module_load (reload) [303.654228] Starting subtest: reload [306.991866] Subtest reload: SUCCESS (3.337s) [307.023473] [154/165] (701s left) gem_lmem_swapping (basic) [307.134402] Subtest basic: SKIP (0.000s) [307.177819] [155/165] (701s left) gem_lmem_swapping (parallel-random-engines) [307.275244] Subtest parallel-random-engines: SKIP (0.000s) [307.327022] [156/165] (701s left) gem_lmem_swapping (random-engines) [307.425401] Subtest random-engines: SKIP (0.000s) [307.477033] [157/165] (701s left) gem_lmem_swapping (verify-random) [307.572982] Subtest verify-random: SKIP (0.000s) [307.634360] [158/165] (701s left) i915_pm_rpm (module-reload) [320.095090] Starting subtest: module-reload [349.429904] Subtest module-reload: SUCCESS (29.326s) [349.452434] [159/165] (659s left) i915_selftest (live) [349.554123] Starting subtest: live [349.555393] Starting dynamic subtest: sanitycheck [351.429912] Dynamic subtest sanitycheck: SUCCESS (1.866s) [351.444802] Starting dynamic subtest: uncore [353.290962] Dynamic subtest uncore: SUCCESS (1.857s) [353.305675] Starting dynamic subtest: workarounds [355.419666] Dynamic subtest workarounds: SUCCESS (2.125s) [355.434355] Starting dynamic subtest: gt_engines [357.700151] Dynamic subtest gt_engines: SUCCESS (2.276s) [357.715025] Starting dynamic subtest: gt_timelines [370.421545] Dynamic subtest gt_timelines: SUCCESS (12.718s) [370.436236] Starting dynamic subtest: gt_contexts [372.366537] Dynamic subtest gt_contexts: SUCCESS (1.942s) [372.381356] Starting dynamic subtest: gt_lrc [376.717597] Dynamic subtest gt_lrc: SUCCESS (4.348s) [376.732062] Starting dynamic subtest: gt_mocs [378.691516] Dynamic subtest gt_mocs: SUCCESS (1.970s) [378.706106] Starting dynamic subtest: gt_pm [383.772637] Dynamic subtest gt_pm: SUCCESS (5.078s) [383.787424] Starting dynamic subtest: gt_heartbeat [385.808590] Dynamic subtest gt_heartbeat: SUCCESS (2.032s) [385.823163] Starting dynamic subtest: gt_tlb [388.931690] Dynamic subtest gt_tlb: SUCCESS (3.119s) [388.946514] Starting dynamic subtest: requests [396.559674] Dynamic subtest requests: SUCCESS (7.624s) [396.574345] Starting dynamic subtest: migrate [401.136532] Dynamic subtest migrate: SUCCESS (4.573s) [401.150921] Starting dynamic subtest: active [403.026738] Dynamic subtest active: SUCCESS (1.886s) [403.041644] Starting dynamic subtest: objects [406.401802] Dynamic subtest objects: SUCCESS (3.372s) [406.416212] Starting dynamic subtest: mman [413.720653] Dynamic subtest mman: SUCCESS (7.315s) [413.735662] Starting dynamic subtest: dmabuf [415.634625] Dynamic subtest dmabuf: SUCCESS (1.911s) [415.649341] Starting dynamic subtest: vma [417.481115] Dynamic subtest vma: SUCCESS (1.843s) [417.496219] Starting dynamic subtest: coherency [424.088539] Dynamic subtest coherency: SUCCESS (6.604s) [424.103411] Starting dynamic subtest: gtt [433.535904] Dynamic subtest gtt: SUCCESS (9.444s) [433.550483] Starting dynamic subtest: gem [435.551549] Dynamic subtest gem: SUCCESS (2.012s) [435.566444] Starting dynamic subtest: evict [439.420386] Dynamic subtest evict: SUCCESS (3.866s) [439.435325] Starting dynamic subtest: hugepages [447.132456] Dynamic subtest hugepages: SUCCESS (7.717s) [447.150898] Starting dynamic subtest: gem_contexts [462.357698] Dynamic subtest gem_contexts: SUCCESS (15.213s) [462.372933] Starting dynamic subtest: client [464.194458] Dynamic subtest client: SUCCESS (1.833s) [464.210125] Starting dynamic subtest: gem_migrate [466.033014] Dynamic subtest gem_migrate: SUCCESS (1.835s) [466.048526] Starting dynamic subtest: reset [471.413933] Dynamic subtest reset: SUCCESS (5.378s) [471.429517] Starting dynamic subtest: memory_region [473.281594] Dynamic subtest memory_region: SUCCESS (1.865s) [473.297132] Starting dynamic subtest: hangcheck [497.739548] Dynamic subtest hangcheck: SUCCESS (24.455s) [497.754995] Starting dynamic subtest: execlists [507.883614] Dynamic subtest execlists: SUCCESS (10.141s) [507.899296] Starting dynamic subtest: ring_submission [509.784446] Dynamic subtest ring_submission: SUCCESS (1.898s) [509.799958] Starting dynamic subtest: perf [511.771193] Dynamic subtest perf: SUCCESS (1.983s) [511.786654] Starting dynamic subtest: slpc [513.667504] Dynamic subtest slpc: SUCCESS (1.893s) [513.683038] Starting dynamic subtest: guc [515.539651] Dynamic subtest guc: SUCCESS (1.869s) [515.555141] Starting dynamic subtest: guc_multi_lrc [517.381789] Dynamic subtest guc_multi_lrc: SUCCESS (1.839s) [517.397039] Starting dynamic subtest: guc_hang [519.234583] Dynamic subtest guc_hang: SUCCESS (1.849s) [519.250039] Starting dynamic subtest: late_gt_pm [521.175626] Dynamic subtest late_gt_pm: SUCCESS (1.938s) [521.176980] Subtest live: SUCCESS (171.614s) [521.202677] [160/165] (487s left) dmabuf (all-tests) [521.300211] Starting subtest: all-tests [521.301623] Starting dynamic subtest: sanitycheck [521.372739] Dynamic subtest sanitycheck: SUCCESS (0.071s) [521.391777] Starting dynamic subtest: dma_fence [521.562806] Dynamic subtest dma_fence: SUCCESS (0.186s) [521.586249] Starting dynamic subtest: dma_fence_chain [539.566258] Dynamic subtest dma_fence_chain: SUCCESS (17.991s) [539.579772] Starting dynamic subtest: dma_fence_unwrap [539.636738] Dynamic subtest dma_fence_unwrap: SUCCESS (0.075s) [539.656298] Starting dynamic subtest: dma_resv [539.726647] Dynamic subtest dma_resv: SUCCESS (0.086s) [539.728796] Subtest all-tests: SUCCESS (18.428s) [539.761116] [161/165] (468s left) i915_suspend (basic-s2idle-without-i915) [539.849575] Starting subtest: basic-s2idle-without-i915 [563.146807] Subtest basic-s2idle-without-i915: SUCCESS (8.368s) [563.219490] [162/165] (460s left) i915_suspend (basic-s3-without-i915) [563.309982] Starting subtest: basic-s3-without-i915 [586.269917] Subtest basic-s3-without-i915: SUCCESS (7.197s) [586.324198] [163/165] (453s left) gem_exec_suspend (basic-s0) [586.446102] Starting subtest: basic-S0 [586.447319] Starting dynamic subtest: smem [606.086446] Dynamic subtest smem: SUCCESS (3.798s) [606.087751] Subtest basic-S0: SUCCESS (3.800s) [606.295795] [164/165] (449s left) gem_exec_suspend (basic-s3) [606.400763] Starting subtest: basic-S3 [606.401941] Starting dynamic subtest: smem [625.049268] Dynamic subtest smem: SUCCESS (3.728s) [625.050611] Subtest basic-S3: SUCCESS (3.730s) [625.263921] [165/165] (445s left) kms_pipe_crc_basic (suspend-read-crc) [625.385399] Starting subtest: suspend-read-crc [625.388894] Starting dynamic subtest: pipe-A-eDP-1 [643.028789] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.485s) [643.050944] Starting dynamic subtest: pipe-B-eDP-1 [661.000307] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.142s) [661.022949] Starting dynamic subtest: pipe-C-eDP-1 [678.991334] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.110s) [678.992583] Subtest suspend-read-crc: SUCCESS (8.749s) [679.888119] Closing watchdogs Done.