[41.811176] Initializing watchdogs [41.811340] /dev/watchdog0 [41.821243] [001/171] (960s left) i915_module_load (load) [41.954276] Starting subtest: load [44.446263] Subtest load: SUCCESS (2.492s) [44.468327] [002/171] (957s left) core_auth (basic-auth) [44.598925] Starting subtest: basic-auth [44.600463] Subtest basic-auth: SUCCESS (0.001s) [44.680423] [003/171] (957s left) debugfs_test (read_all_entries) [44.814804] Starting subtest: read_all_entries [44.881496] Subtest read_all_entries: SUCCESS (0.066s) [44.991814] [004/171] (957s left) debugfs_test (basic-hwmon) [45.124335] Starting subtest: basic-hwmon [45.126506] Subtest basic-hwmon: SKIP (0.000s) [45.247568] [005/171] (957s left) fbdev (eof) [45.431079] Starting subtest: eof [45.434915] Subtest eof: SUCCESS (0.000s) [45.491159] [006/171] (956s left) fbdev (info) [45.618163] Starting subtest: info [45.619392] Subtest info: SUCCESS (0.000s) [45.695615] [007/171] (956s left) fbdev (nullptr) [45.830391] Starting subtest: nullptr [45.831505] Subtest nullptr: SUCCESS (0.000s) [45.896607] [008/171] (956s left) fbdev (read) [46.030652] Starting subtest: read [53.110205] Subtest read: SUCCESS (7.045s) [53.142393] [009/171] (949s left) fbdev (write) [53.281701] Starting subtest: write [57.061167] Subtest write: SUCCESS (3.746s) [57.093325] [010/171] (945s left) gem_basic (bad-close) [57.211792] Starting subtest: bad-close [57.214145] Subtest bad-close: SUCCESS (0.000s) [57.292444] [011/171] (945s left) gem_basic (create-close) [57.410968] Starting subtest: create-close [57.413170] Subtest create-close: SUCCESS (0.000s) [57.509373] [012/171] (945s left) gem_basic (create-fd-close) [57.626986] Starting subtest: create-fd-close [57.629043] Subtest create-fd-close: SUCCESS (0.000s) [57.726753] [013/171] (944s left) gem_busy (busy@all-engines) [57.863178] Starting subtest: busy [57.864488] Starting dynamic subtest: all-engines [57.908208] Dynamic subtest all-engines: SUCCESS (0.045s) [57.909599] Subtest busy: SUCCESS (0.046s) [58.293955] [014/171] (944s left) gem_close_race (basic-process) [58.432881] Starting subtest: basic-process [58.496478] Subtest basic-process: SUCCESS (0.064s) [58.694205] [015/171] (943s left) gem_close_race (basic-threads) [58.840031] Starting subtest: basic-threads [59.990983] Subtest basic-threads: SUCCESS (1.151s) [60.215180] [016/171] (942s left) gem_ctx_create (basic) [60.364284] Starting subtest: basic [60.365497] Subtest basic: SUCCESS (0.000s) [60.560712] [017/171] (942s left) gem_ctx_create (basic-files) [60.691674] Starting subtest: basic-files [62.710699] Subtest basic-files: SUCCESS (2.020s) [62.913696] [018/171] (939s left) gem_ctx_exec (basic) [63.035562] Starting subtest: basic [63.040092] Subtest basic: SUCCESS (0.004s) [63.161063] [019/171] (939s left) gem_exec_basic (basic) [63.286396] Starting subtest: basic [63.287567] Starting dynamic subtest: rcs0-smem [63.288676] Dynamic subtest rcs0-smem: SUCCESS (0.002s) [63.299815] Starting dynamic subtest: bcs0-smem [63.301198] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [63.311084] Starting dynamic subtest: vcs0-smem [63.312445] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [63.322102] Starting dynamic subtest: vecs0-smem [63.323366] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [63.324680] Subtest basic: SUCCESS (0.005s) [63.493772] [020/171] (939s left) gem_exec_create (basic) [63.625795] Starting subtest: basic [63.627514] Starting dynamic subtest: smem [65.659690] Dynamic subtest smem: SUCCESS (2.033s) [65.660852] Subtest basic: SUCCESS (2.034s) [65.869117] [021/171] (936s left) gem_exec_fence (basic-busy) [66.145091] Starting subtest: basic-busy [66.146413] Starting dynamic subtest: rcs0 [66.166657] Dynamic subtest rcs0: SUCCESS (0.030s) [66.182031] Starting dynamic subtest: bcs0 [66.192421] Dynamic subtest bcs0: SUCCESS (0.026s) [66.202807] Starting dynamic subtest: vcs0 [66.217628] Dynamic subtest vcs0: SUCCESS (0.025s) [66.228955] Starting dynamic subtest: vecs0 [66.241790] Dynamic subtest vecs0: SUCCESS (0.024s) [66.243191] Subtest basic-busy: SUCCESS (0.106s) [66.838673] [022/171] (935s left) gem_exec_fence (basic-wait) [67.122985] Starting subtest: basic-wait [67.124448] Starting dynamic subtest: rcs0 [67.144917] Dynamic subtest rcs0: SUCCESS (0.030s) [67.157190] Starting dynamic subtest: bcs0 [67.180836] Dynamic subtest bcs0: SUCCESS (0.035s) [67.193739] Starting dynamic subtest: vcs0 [67.222865] Dynamic subtest vcs0: SUCCESS (0.042s) [67.238865] Starting dynamic subtest: vecs0 [67.256041] Dynamic subtest vecs0: SUCCESS (0.033s) [67.257941] Subtest basic-wait: SUCCESS (0.142s) [67.777779] [023/171] (935s left) gem_exec_fence (basic-await) [68.063174] Starting subtest: basic-await [68.064436] Starting dynamic subtest: rcs0 [68.144925] Dynamic subtest rcs0: SUCCESS (0.089s) [68.169597] Starting dynamic subtest: bcs0 [68.253047] Dynamic subtest bcs0: SUCCESS (0.107s) [68.278925] Starting dynamic subtest: vcs0 [68.372481] Dynamic subtest vcs0: SUCCESS (0.119s) [68.398688] Starting dynamic subtest: vecs0 [68.485846] Dynamic subtest vecs0: SUCCESS (0.113s) [68.487824] Subtest basic-await: SUCCESS (0.430s) [69.062316] [024/171] (933s left) gem_exec_fence (nb-await) [69.344735] Starting subtest: nb-await [69.346013] Starting dynamic subtest: rcs0 [69.404886] Dynamic subtest rcs0: SUCCESS (0.066s) [69.427923] Starting dynamic subtest: bcs0 [69.476684] Dynamic subtest bcs0: SUCCESS (0.072s) [69.501767] Starting dynamic subtest: vcs0 [69.555133] Dynamic subtest vcs0: SUCCESS (0.078s) [69.580748] Starting dynamic subtest: vecs0 [69.628410] Dynamic subtest vecs0: SUCCESS (0.073s) [69.631593] Subtest nb-await: SUCCESS (0.291s) [70.178053] [025/171] (932s left) gem_exec_gttfill (basic) [70.310331] Starting subtest: basic [77.572208] Subtest basic: SUCCESS (7.253s) [77.749664] [026/171] (925s left) gem_exec_parallel (engines) [77.955999] Starting subtest: engines [77.957726] Starting dynamic subtest: basic [80.347612] Dynamic subtest basic: SUCCESS (2.369s) [80.360056] Starting dynamic subtest: contexts [83.737752] Dynamic subtest contexts: SUCCESS (3.404s) [83.751080] Starting dynamic subtest: fds [87.417693] Dynamic subtest fds: SUCCESS (3.688s) [87.436794] Starting dynamic subtest: userptr [89.978597] Dynamic subtest userptr: SUCCESS (2.540s) [89.980486] Subtest engines: SUCCESS (12.002s) [90.165054] [027/171] (912s left) gem_exec_store (basic) [90.303110] Starting subtest: basic [90.361857] Subtest basic: SUCCESS (0.058s) [90.563496] [028/171] (912s left) gem_flink_basic (bad-flink) [90.682828] Starting subtest: bad-flink [90.684236] Subtest bad-flink: SUCCESS (0.000s) [90.762682] [029/171] (912s left) gem_flink_basic (bad-open) [90.890639] Starting subtest: bad-open [90.891812] Subtest bad-open: SUCCESS (0.000s) [90.963397] [030/171] (911s left) gem_flink_basic (basic) [91.090446] Starting subtest: basic [91.091592] Subtest basic: SUCCESS (0.000s) [91.195703] [031/171] (911s left) gem_flink_basic (double-flink) [91.315621] Starting subtest: double-flink [91.316752] Subtest double-flink: SUCCESS (0.000s) [91.412326] [032/171] (911s left) gem_flink_basic (flink-lifetime) [91.530279] Starting subtest: flink-lifetime [91.532725] Subtest flink-lifetime: SUCCESS (0.002s) [91.628975] [033/171] (911s left) gem_huc_copy (huc-copy) [91.754530] Starting subtest: huc-copy [91.756913] Subtest huc-copy: SKIP (0.000s) [91.862424] [034/171] (911s left) gem_linear_blits (basic) [92.151978] Starting subtest: basic [92.164143] Subtest basic: SUCCESS (0.012s) [92.278566] [035/171] (910s left) gem_mmap (basic) [92.465907] Starting subtest: basic [92.470880] Subtest basic: SUCCESS (0.001s) [92.579398] [036/171] (910s left) gem_mmap_gtt (basic) [92.698805] Starting subtest: basic [92.700162] Subtest basic: SUCCESS (0.001s) [92.781196] [037/171] (910s left) gem_render_linear_blits (basic) [92.912328] Starting subtest: basic [92.961727] Subtest basic: SUCCESS (0.048s) [93.013829] [038/171] (910s left) gem_render_tiled_blits (basic) [93.139617] Starting subtest: basic [93.199588] Subtest basic: SUCCESS (0.060s) [93.264554] [039/171] (909s left) gem_ringfill (basic-all) [93.522347] Starting subtest: basic-all [94.758109] Subtest basic-all: SUCCESS (1.228s) [94.832025] [040/171] (908s left) gem_softpin (allocator-basic) [94.958648] Starting subtest: allocator-basic [95.120389] Subtest allocator-basic: SUCCESS (0.153s) [95.234665] [041/171] (907s left) gem_softpin (allocator-basic-reserve) [95.382551] Starting subtest: allocator-basic-reserve [95.544319] Subtest allocator-basic-reserve: SUCCESS (0.153s) [95.646919] [042/171] (907s left) gem_softpin (safe-alignment) [95.796365] Starting subtest: safe-alignment [95.813405] Subtest safe-alignment: SUCCESS (0.017s) [95.929385] [043/171] (907s left) gem_sync (basic-all) [96.061937] Starting subtest: basic-all [98.594883] Subtest basic-all: SUCCESS (2.507s) [98.763309] [044/171] (904s left) gem_sync (basic-each) [98.896065] Starting subtest: basic-each [101.223153] Subtest basic-each: SUCCESS (2.324s) [101.440748] [045/171] (901s left) gem_tiled_blits (basic) [101.720087] Starting subtest: basic [101.747940] Subtest basic: SUCCESS (0.029s) [101.864462] [046/171] (901s left) gem_tiled_fence_blits (basic) [102.222219] Starting subtest: basic [102.248364] Subtest basic: SUCCESS (0.026s) [102.376380] [047/171] (900s left) gem_tiled_pread_basic [102.915173] [048/171] (900s left) gem_wait (busy@all-engines) [103.053858] Starting subtest: busy [103.055120] Starting dynamic subtest: all-engines [103.587533] Dynamic subtest all-engines: SUCCESS (0.534s) [103.588682] Subtest busy: SUCCESS (0.534s) [103.831165] [049/171] (899s left) gem_wait (wait@all-engines) [103.968335] Starting subtest: wait [103.969547] Starting dynamic subtest: all-engines [105.002288] Dynamic subtest all-engines: SUCCESS (1.029s) [105.003699] Subtest wait: SUCCESS (1.029s) [105.231432] [050/171] (898s left) i915_getparams_basic (basic-eu-total) [105.351618] Starting subtest: basic-eu-total [105.354065] Subtest basic-eu-total: SUCCESS (0.000s) [105.429686] [051/171] (898s left) i915_getparams_basic (basic-subslice-total) [105.547586] Starting subtest: basic-subslice-total [105.550085] Subtest basic-subslice-total: SUCCESS (0.000s) [105.629207] [052/171] (897s left) i915_hangman (error-state-basic) [105.763513] Starting subtest: error-state-basic [105.776187] Subtest error-state-basic: SUCCESS (0.013s) [105.863311] [053/171] (897s left) i915_pciid [106.063315] [054/171] (897s left) kms_addfb_basic (addfb25-bad-modifier) [106.183430] Starting subtest: addfb25-bad-modifier [106.184493] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [106.311873] [055/171] (897s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [106.430871] Starting subtest: addfb25-framebuffer-vs-set-tiling [106.432023] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [106.546342] [056/171] (897s left) kms_addfb_basic (addfb25-modifier-no-flag) [106.666362] Starting subtest: addfb25-modifier-no-flag [106.667440] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [106.779484] [057/171] (896s left) kms_addfb_basic (addfb25-x-tiled-legacy) [106.899252] Starting subtest: addfb25-x-tiled-legacy [106.900323] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [107.012600] [058/171] (896s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [107.133146] Starting subtest: addfb25-x-tiled-mismatch-legacy [107.134218] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [107.245884] [059/171] (896s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [107.391889] Starting subtest: addfb25-yf-tiled-legacy [107.393258] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [107.478981] [060/171] (896s left) kms_addfb_basic (addfb25-y-tiled-legacy) [107.626172] Starting subtest: addfb25-y-tiled-legacy [107.627294] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [107.730025] [061/171] (895s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [107.877055] Starting subtest: addfb25-y-tiled-small-legacy [107.878318] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [107.979562] [062/171] (895s left) kms_addfb_basic (bad-pitch-0) [108.106336] Starting subtest: bad-pitch-0 [108.107419] Subtest bad-pitch-0: SUCCESS (0.000s) [108.212628] [063/171] (895s left) kms_addfb_basic (bad-pitch-1024) [108.342597] Starting subtest: bad-pitch-1024 [108.343918] Subtest bad-pitch-1024: SUCCESS (0.000s) [108.483202] [064/171] (895s left) kms_addfb_basic (bad-pitch-128) [108.622097] Starting subtest: bad-pitch-128 [108.623201] Subtest bad-pitch-128: SUCCESS (0.000s) [108.746422] [065/171] (895s left) kms_addfb_basic (bad-pitch-256) [108.863837] Starting subtest: bad-pitch-256 [108.865277] Subtest bad-pitch-256: SUCCESS (0.000s) [108.997293] [066/171] (894s left) kms_addfb_basic (bad-pitch-32) [109.116179] Starting subtest: bad-pitch-32 [109.117259] Subtest bad-pitch-32: SUCCESS (0.000s) [109.246732] [067/171] (894s left) kms_addfb_basic (bad-pitch-63) [109.365271] Starting subtest: bad-pitch-63 [109.366449] Subtest bad-pitch-63: SUCCESS (0.000s) [109.497137] [068/171] (894s left) kms_addfb_basic (bad-pitch-65536) [109.626376] Starting subtest: bad-pitch-65536 [109.627530] Subtest bad-pitch-65536: SUCCESS (0.000s) [109.745933] [069/171] (894s left) kms_addfb_basic (bad-pitch-999) [109.877968] Starting subtest: bad-pitch-999 [109.879136] Subtest bad-pitch-999: SUCCESS (0.000s) [110.012741] [070/171] (893s left) kms_addfb_basic (basic) [110.131119] Starting subtest: basic [110.132187] Subtest basic: SUCCESS (0.000s) [110.246101] [071/171] (893s left) kms_addfb_basic (basic-x-tiled-legacy) [110.365702] Starting subtest: basic-x-tiled-legacy [110.366787] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [110.479670] [072/171] (893s left) kms_addfb_basic (basic-y-tiled-legacy) [110.609278] Starting subtest: basic-y-tiled-legacy [110.610345] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [110.729811] [073/171] (893s left) kms_addfb_basic (bo-too-small) [110.878789] Starting subtest: bo-too-small [110.880219] Subtest bo-too-small: SUCCESS (0.000s) [110.979724] [074/171] (893s left) kms_addfb_basic (bo-too-small-due-to-tiling) [111.126833] Starting subtest: bo-too-small-due-to-tiling [111.128169] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [111.212371] [075/171] (892s left) kms_addfb_basic (clobberred-modifier) [111.337164] Starting subtest: clobberred-modifier [111.338327] Subtest clobberred-modifier: SUCCESS (0.000s) [111.463023] [076/171] (892s left) kms_addfb_basic (framebuffer-vs-set-tiling) [111.582983] Starting subtest: framebuffer-vs-set-tiling [111.584102] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [111.714427] [077/171] (892s left) kms_addfb_basic (invalid-get-prop) [111.833459] Starting subtest: invalid-get-prop [111.834531] Subtest invalid-get-prop: SUCCESS (0.000s) [111.963127] [078/171] (892s left) kms_addfb_basic (invalid-get-prop-any) [112.083107] Starting subtest: invalid-get-prop-any [112.084205] Subtest invalid-get-prop-any: SUCCESS (0.000s) [112.212449] [079/171] (891s left) kms_addfb_basic (invalid-set-prop) [112.341934] Starting subtest: invalid-set-prop [112.343143] Subtest invalid-set-prop: SUCCESS (0.000s) [112.462776] [080/171] (891s left) kms_addfb_basic (invalid-set-prop-any) [112.580924] Starting subtest: invalid-set-prop-any [112.582349] Subtest invalid-set-prop-any: SUCCESS (0.000s) [112.695608] [081/171] (891s left) kms_addfb_basic (no-handle) [112.814911] Starting subtest: no-handle [112.816089] Subtest no-handle: SUCCESS (0.000s) [112.956639] [082/171] (891s left) kms_addfb_basic (size-max) [113.114540] Starting subtest: size-max [113.115745] Subtest size-max: SUCCESS (0.000s) [113.212754] [083/171] (891s left) kms_addfb_basic (small-bo) [113.359822] Starting subtest: small-bo [113.361097] Subtest small-bo: SUCCESS (0.000s) [113.462942] [084/171] (890s left) kms_addfb_basic (tile-pitch-mismatch) [113.591876] Starting subtest: tile-pitch-mismatch [113.593084] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [113.712623] [085/171] (890s left) kms_addfb_basic (too-high) [113.860358] Starting subtest: too-high [113.861487] Subtest too-high: SUCCESS (0.001s) [113.962619] [086/171] (890s left) kms_addfb_basic (too-wide) [114.110093] Starting subtest: too-wide [114.111203] Subtest too-wide: SUCCESS (0.000s) [114.195488] [087/171] (890s left) kms_addfb_basic (unused-handle) [114.324960] Starting subtest: unused-handle [114.326195] Subtest unused-handle: SUCCESS (0.000s) [114.446824] [088/171] (889s left) kms_addfb_basic (unused-modifier) [114.567393] Starting subtest: unused-modifier [114.568585] Subtest unused-modifier: SUCCESS (0.000s) [114.697111] [089/171] (889s left) kms_addfb_basic (unused-offsets) [114.815848] Starting subtest: unused-offsets [114.817273] Subtest unused-offsets: SUCCESS (0.000s) [114.929298] [090/171] (889s left) kms_addfb_basic (unused-pitches) [115.056203] Starting subtest: unused-pitches [115.057276] Subtest unused-pitches: SUCCESS (0.000s) [115.179451] [091/171] (889s left) kms_busy (basic) [115.337016] Starting subtest: basic [115.339401] Starting dynamic subtest: flip [116.338863] Dynamic subtest flip: SUCCESS (0.994s) [116.354219] Starting dynamic subtest: modeset [120.145955] Dynamic subtest modeset: SUCCESS (3.809s) [120.149035] Subtest basic: SUCCESS (4.807s) [121.059306] [092/171] (883s left) kms_chamelium_hpd (dp-hpd-fast) [121.527255] Subtest dp-hpd-fast: SKIP (0.000s) [122.416377] [093/171] (882s left) kms_chamelium_edid (dp-edid-read) [122.882557] Subtest dp-edid-read: SKIP (0.000s) [123.758563] [094/171] (880s left) kms_chamelium_frames (dp-crc-fast) [124.227141] Subtest dp-crc-fast: SKIP (0.000s) [125.101779] [095/171] (879s left) kms_chamelium_hpd (hdmi-hpd-fast) [125.570617] Subtest hdmi-hpd-fast: SKIP (0.000s) [126.446616] [096/171] (878s left) kms_chamelium_edid (hdmi-edid-read) [126.910787] Subtest hdmi-edid-read: SKIP (0.000s) [127.791854] [097/171] (876s left) kms_chamelium_frames (hdmi-crc-fast) [128.262666] Subtest hdmi-crc-fast: SKIP (0.000s) [129.134747] [098/171] (875s left) kms_chamelium_hpd (vga-hpd-fast) [129.602217] Subtest vga-hpd-fast: SKIP (0.000s) [130.480331] [099/171] (874s left) kms_chamelium_edid (vga-edid-read) [130.947520] Subtest vga-edid-read: SKIP (0.000s) [131.820984] [100/171] (872s left) kms_prop_blob (basic) [131.942041] Starting subtest: basic [131.943263] Subtest basic: SUCCESS (0.000s) [132.023454] [101/171] (872s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [132.170422] Starting subtest: basic-busy-flip-before-cursor-atomic [132.172482] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [132.250598] [102/171] (872s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [132.395407] Starting subtest: basic-busy-flip-before-cursor-legacy [132.397591] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [132.469981] [103/171] (872s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [132.631320] Starting subtest: basic-flip-after-cursor-atomic [133.914645] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.284s) [134.876430] [104/171] (869s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [135.022430] Starting subtest: basic-flip-after-cursor-legacy [136.291446] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.268s) [137.245918] [105/171] (867s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [137.397675] Starting subtest: basic-flip-after-cursor-varying-size [138.695421] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.292s) [139.615529] [106/171] (865s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [139.761565] Starting subtest: basic-flip-before-cursor-atomic [141.044407] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.282s) [141.982845] [107/171] (862s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [142.130388] Starting subtest: basic-flip-before-cursor-legacy [143.412147] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.283s) [144.350556] [108/171] (860s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [144.497262] Starting subtest: basic-flip-before-cursor-varying-size [145.777581] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.281s) [146.721560] [109/171] (858s left) kms_flip (basic-flip-vs-dpms) [146.849267] Starting subtest: basic-flip-vs-dpms [146.852386] Starting dynamic subtest: A-eDP1 [149.726516] Dynamic subtest A-eDP1: SUCCESS (2.874s) [149.742425] Starting dynamic subtest: B-eDP1 [152.100246] Dynamic subtest B-eDP1: SUCCESS (2.372s) [152.115875] Starting dynamic subtest: C-eDP1 [154.464221] Dynamic subtest C-eDP1: SUCCESS (2.365s) [154.478305] Subtest basic-flip-vs-dpms: SUCCESS (7.630s) [155.369036] [110/171] (849s left) kms_flip (basic-flip-vs-modeset) [155.504317] Starting subtest: basic-flip-vs-modeset [155.507554] Starting dynamic subtest: A-eDP1 [158.358647] Dynamic subtest A-eDP1: SUCCESS (2.850s) [158.375121] Starting dynamic subtest: B-eDP1 [160.734353] Dynamic subtest B-eDP1: SUCCESS (2.369s) [160.748880] Starting dynamic subtest: C-eDP1 [163.095788] Dynamic subtest C-eDP1: SUCCESS (2.367s) [163.098315] Subtest basic-flip-vs-modeset: SUCCESS (7.595s) [164.062687] [111/171] (840s left) kms_flip (basic-flip-vs-wf_vblank) [164.188636] Starting subtest: basic-flip-vs-wf_vblank [164.192512] Starting dynamic subtest: A-eDP1 [166.530322] Dynamic subtest A-eDP1: SUCCESS (2.338s) [166.546105] Starting dynamic subtest: B-eDP1 [168.817533] Dynamic subtest B-eDP1: SUCCESS (2.286s) [168.833732] Starting dynamic subtest: C-eDP1 [171.123361] Dynamic subtest C-eDP1: SUCCESS (2.305s) [171.125894] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.937s) [172.384383] [112/171] (832s left) kms_flip (basic-plain-flip) [172.511257] Starting subtest: basic-plain-flip [172.514557] Starting dynamic subtest: A-eDP1 [174.565084] Dynamic subtest A-eDP1: SUCCESS (2.050s) [174.580851] Starting dynamic subtest: B-eDP1 [176.535362] Dynamic subtest B-eDP1: SUCCESS (1.969s) [176.551727] Starting dynamic subtest: C-eDP1 [178.518497] Dynamic subtest C-eDP1: SUCCESS (1.982s) [178.520943] Subtest basic-plain-flip: SUCCESS (6.011s) [179.808131] [113/171] (825s left) kms_force_connector_basic (force-connector-state) [179.933547] Starting subtest: force-connector-state [181.637053] Subtest force-connector-state: SUCCESS (1.702s) [182.241449] [114/171] (822s left) kms_force_connector_basic (force-edid) [182.374943] Starting subtest: force-edid [182.623816] Subtest force-edid: SUCCESS (0.250s) [182.741188] [115/171] (822s left) kms_force_connector_basic (force-load-detect) [182.872547] Starting subtest: force-load-detect [182.874806] Subtest force-load-detect: SKIP (0.000s) [182.990794] [116/171] (822s left) kms_force_connector_basic (prune-stale-modes) [183.123126] Starting subtest: prune-stale-modes [183.426904] Subtest prune-stale-modes: SUCCESS (0.304s) [183.524500] [117/171] (821s left) kms_frontbuffer_tracking (basic) [183.680219] Starting subtest: basic [187.007526] Subtest basic: SUCCESS (3.328s) [187.125671] [118/171] (817s left) kms_pipe_crc_basic (compare-crc-sanitycheck) [187.288554] Starting subtest: compare-crc-sanitycheck [187.297666] Starting dynamic subtest: pipe-A-eDP-1 [187.956991] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.677s) [187.975345] Starting dynamic subtest: pipe-B-eDP-1 [189.328133] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.365s) [189.346586] Starting dynamic subtest: pipe-C-eDP-1 [190.873128] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.536s) [190.874230] Subtest compare-crc-sanitycheck: SUCCESS (3.590s) [191.778081] [119/171] (813s left) kms_pipe_crc_basic (hang-read-crc) [191.925481] Starting subtest: hang-read-crc [191.928559] Starting dynamic subtest: pipe-A-eDP-1 [194.243092] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.313s) [194.260783] Starting dynamic subtest: pipe-B-eDP-1 [197.201728] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.955s) [197.220529] Starting dynamic subtest: pipe-C-eDP-1 [200.498972] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.293s) [200.500287] Subtest hang-read-crc: SUCCESS (8.573s) [201.450957] [120/171] (803s left) kms_pipe_crc_basic (nonblocking-crc) [201.602201] Starting subtest: nonblocking-crc [201.605604] Starting dynamic subtest: pipe-A-eDP-1 [202.462365] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.857s) [202.482465] Starting dynamic subtest: pipe-B-eDP-1 [204.012376] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.545s) [204.030404] Starting dynamic subtest: pipe-C-eDP-1 [205.714831] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.697s) [205.715971] Subtest nonblocking-crc: SUCCESS (4.112s) [206.682032] [121/171] (798s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [206.840753] Starting subtest: nonblocking-crc-frame-sequence [206.844111] Starting dynamic subtest: pipe-A-eDP-1 [207.710817] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.865s) [207.727736] Starting dynamic subtest: pipe-B-eDP-1 [209.264201] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.549s) [209.281105] Starting dynamic subtest: pipe-C-eDP-1 [210.971294] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.704s) [210.972520] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.130s) [211.930360] [122/171] (793s left) kms_pipe_crc_basic (read-crc) [212.092501] Starting subtest: read-crc [212.095765] Starting dynamic subtest: pipe-A-eDP-1 [212.890740] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.794s) [212.907998] Starting dynamic subtest: pipe-B-eDP-1 [214.379633] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.485s) [214.397363] Starting dynamic subtest: pipe-C-eDP-1 [216.017617] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.634s) [216.018749] Subtest read-crc: SUCCESS (3.925s) [216.923438] [123/171] (788s left) kms_pipe_crc_basic (read-crc-frame-sequence) [217.080485] Starting subtest: read-crc-frame-sequence [217.083520] Starting dynamic subtest: pipe-A-eDP-1 [217.870137] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.786s) [217.887240] Starting dynamic subtest: pipe-B-eDP-1 [219.354726] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.482s) [219.373352] Starting dynamic subtest: pipe-C-eDP-1 [220.998230] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.638s) [220.999370] Subtest read-crc-frame-sequence: SUCCESS (3.918s) [221.914269] [124/171] (783s left) kms_psr (primary_page_flip) [222.068851] Starting subtest: primary_page_flip [226.341334] Subtest primary_page_flip: SUCCESS (4.271s) [227.289083] [125/171] (778s left) kms_psr (cursor_plane_move) [227.440056] Starting subtest: cursor_plane_move [231.598052] Subtest cursor_plane_move: SUCCESS (4.151s) [232.537877] [126/171] (772s left) kms_psr (sprite_plane_onoff) [232.689051] Starting subtest: sprite_plane_onoff [236.948899] Subtest sprite_plane_onoff: SUCCESS (4.258s) [237.859836] [127/171] (767s left) kms_psr (primary_mmap_gtt) [238.019560] Starting subtest: primary_mmap_gtt [242.255703] Subtest primary_mmap_gtt: SUCCESS (4.235s) [243.161584] [128/171] (762s left) kms_setmode (basic-clone-single-crtc) [243.284409] Starting subtest: basic-clone-single-crtc [243.287499] Subtest basic-clone-single-crtc: SKIP (0.000s) [243.361122] [129/171] (762s left) i915_pm_backlight (basic-brightness) [243.512187] Starting subtest: basic-brightness [243.612515] Starting dynamic subtest: eDP-1 [244.173696] Dynamic subtest eDP-1: SUCCESS (0.559s) [244.174882] Subtest basic-brightness: SUCCESS (0.660s) [245.083565] [130/171] (760s left) i915_pm_rpm (basic-pci-d3-state) [246.955788] Starting subtest: basic-pci-d3-state [251.325399] Subtest basic-pci-d3-state: SUCCESS (4.363s) [251.519971] [131/171] (753s left) i915_pm_rpm (basic-rte) [251.648578] Starting subtest: basic-rte [257.783529] Subtest basic-rte: SUCCESS (6.134s) [259.249478] [132/171] (746s left) i915_pm_rps (basic-api) [259.378248] Starting subtest: basic-api [259.382460] Subtest basic-api: SUCCESS (0.004s) [259.465517] [133/171] (746s left) prime_self_import (basic-llseek-bad) [259.584790] Starting subtest: basic-llseek-bad [259.586269] Subtest basic-llseek-bad: SUCCESS (0.002s) [259.681436] [134/171] (745s left) prime_self_import (basic-llseek-size) [259.798120] Starting subtest: basic-llseek-size [259.802337] Subtest basic-llseek-size: SUCCESS (0.004s) [259.898128] [135/171] (745s left) prime_self_import (basic-with_fd_dup) [260.023981] Starting subtest: basic-with_fd_dup [260.029655] Subtest basic-with_fd_dup: SUCCESS (0.004s) [260.131598] [136/171] (745s left) prime_self_import (basic-with_one_bo) [260.258334] Starting subtest: basic-with_one_bo [260.262938] Subtest basic-with_one_bo: SUCCESS (0.005s) [260.348861] [137/171] (745s left) prime_self_import (basic-with_one_bo_two_files) [260.474737] Starting subtest: basic-with_one_bo_two_files [260.478463] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s) [260.581355] [138/171] (745s left) prime_self_import (basic-with_two_bos) [260.707916] Starting subtest: basic-with_two_bos [260.711951] Subtest basic-with_two_bos: SUCCESS (0.004s) [260.814850] [139/171] (744s left) prime_vgem (basic-fence-flip) [260.961639] Starting subtest: basic-fence-flip [261.429304] Subtest basic-fence-flip: SUCCESS (0.468s) [261.549343] [140/171] (744s left) prime_vgem (basic-fence-mmap) [261.688177] Starting subtest: basic-fence-mmap [261.729902] Subtest basic-fence-mmap: SUCCESS (0.042s) [261.815838] [141/171] (743s left) prime_vgem (basic-fence-read) [261.954815] Starting subtest: basic-fence-read [262.022226] Subtest basic-fence-read: SUCCESS (0.067s) [262.098969] [142/171] (743s left) prime_vgem (basic-gtt) [262.237752] Starting subtest: basic-gtt [262.259914] Subtest basic-gtt: SUCCESS (0.022s) [262.348547] [143/171] (743s left) prime_vgem (basic-read) [262.487640] Starting subtest: basic-read [262.521632] Subtest basic-read: SUCCESS (0.034s) [262.635452] [144/171] (743s left) prime_vgem (basic-write) [262.799464] Starting subtest: basic-write [262.839695] Subtest basic-write: SUCCESS (0.040s) [262.931755] [145/171] (742s left) prime_vgem (basic-userptr) [263.077936] Starting subtest: basic-userptr [263.093652] Subtest basic-userptr: SKIP (0.014s) [263.203505] [146/171] (742s left) vgem_basic (setversion) [263.330384] Starting subtest: setversion [263.332675] Subtest setversion: SUCCESS (0.000s) [263.401377] [147/171] (742s left) vgem_basic (create) [263.530217] Starting subtest: create [263.531331] Subtest create: SUCCESS (0.000s) [263.601580] [148/171] (742s left) vgem_basic (debugfs) [263.730856] Starting subtest: debugfs [263.732204] Subtest debugfs: SUCCESS (0.001s) [263.803313] [149/171] (742s left) vgem_basic (dmabuf-export) [263.949190] Starting subtest: dmabuf-export [263.953497] Subtest dmabuf-export: SUCCESS (0.004s) [264.069952] [150/171] (741s left) vgem_basic (dmabuf-fence) [264.198798] Starting subtest: dmabuf-fence [264.200074] Subtest dmabuf-fence: SUCCESS (0.001s) [264.265669] [151/171] (741s left) vgem_basic (dmabuf-fence-before) [264.415599] Starting subtest: dmabuf-fence-before [264.416734] Subtest dmabuf-fence-before: SUCCESS (0.000s) [264.482471] [152/171] (741s left) vgem_basic (dmabuf-mmap) [264.632475] Starting subtest: dmabuf-mmap [264.657052] Subtest dmabuf-mmap: SUCCESS (0.025s) [264.732333] [153/171] (741s left) vgem_basic (mmap) [264.865616] Starting subtest: mmap [264.881112] Subtest mmap: SUCCESS (0.016s) [264.949204] [154/171] (741s left) vgem_basic (second-client) [265.082696] Starting subtest: second-client [265.132681] Subtest second-client: SUCCESS (0.049s) [265.199844] [155/171] (740s left) vgem_basic (sysfs) [265.348947] Starting subtest: sysfs [265.350313] Subtest sysfs: SUCCESS (0.001s) [265.415597] [156/171] (740s left) core_hotunplug (unbind-rebind) [265.582423] Starting subtest: unbind-rebind [267.900102] Subtest unbind-rebind: SUCCESS (2.319s) [267.956930] [157/171] (738s left) vgem_basic (unload) [268.084154] Starting subtest: unload [296.918183] Subtest unload: SUCCESS (28.799s) [297.004250] [158/171] (709s left) i915_module_load (reload) [297.122212] Starting subtest: reload [300.278077] Subtest reload: SUCCESS (3.156s) [300.306451] [159/171] (705s left) gem_lmem_swapping (basic) [300.447267] Subtest basic: SKIP (0.000s) [300.495409] [160/171] (705s left) gem_lmem_swapping (parallel-random-engines) [300.631344] Subtest parallel-random-engines: SKIP (0.000s) [300.679132] [161/171] (705s left) gem_lmem_swapping (random-engines) [300.813838] Subtest random-engines: SKIP (0.000s) [300.861847] [162/171] (705s left) gem_lmem_swapping (verify-random) [300.997354] Subtest verify-random: SKIP (0.000s) [301.046269] [163/171] (705s left) i915_pm_rpm (module-reload) [313.550972] Starting subtest: module-reload [347.827838] Subtest module-reload: SUCCESS (34.268s) [347.846391] [164/171] (658s left) i915_selftest (live) [347.977509] Starting subtest: live [347.979068] Starting dynamic subtest: sanitycheck [349.778717] Dynamic subtest sanitycheck: SUCCESS (1.792s) [349.793071] Starting dynamic subtest: uncore [351.573583] Dynamic subtest uncore: SUCCESS (1.794s) [351.587821] Starting dynamic subtest: workarounds [353.575898] Dynamic subtest workarounds: SUCCESS (2.001s) [353.590222] Starting dynamic subtest: gt_engines [355.797562] Dynamic subtest gt_engines: SUCCESS (2.221s) [355.811494] Starting dynamic subtest: gt_timelines [367.811748] Dynamic subtest gt_timelines: SUCCESS (12.013s) [367.826199] Starting dynamic subtest: gt_contexts [369.707672] Dynamic subtest gt_contexts: SUCCESS (1.895s) [369.721998] Starting dynamic subtest: gt_lrc [374.061626] Dynamic subtest gt_lrc: SUCCESS (4.353s) [374.075828] Starting dynamic subtest: gt_mocs [375.897566] Dynamic subtest gt_mocs: SUCCESS (1.835s) [375.911971] Starting dynamic subtest: gt_pm [380.946612] Dynamic subtest gt_pm: SUCCESS (5.048s) [380.961067] Starting dynamic subtest: gt_heartbeat [382.818716] Dynamic subtest gt_heartbeat: SUCCESS (1.871s) [382.833123] Starting dynamic subtest: requests [390.340725] Dynamic subtest requests: SUCCESS (7.521s) [390.355104] Starting dynamic subtest: migrate [394.888664] Dynamic subtest migrate: SUCCESS (4.547s) [394.903091] Starting dynamic subtest: active [396.710725] Dynamic subtest active: SUCCESS (1.821s) [396.725046] Starting dynamic subtest: objects [400.152706] Dynamic subtest objects: SUCCESS (3.441s) [400.167149] Starting dynamic subtest: mman [407.030703] Dynamic subtest mman: SUCCESS (6.877s) [407.045271] Starting dynamic subtest: dmabuf [408.778815] Dynamic subtest dmabuf: SUCCESS (1.747s) [408.793237] Starting dynamic subtest: vma [410.583566] Dynamic subtest vma: SUCCESS (1.804s) [410.598147] Starting dynamic subtest: coherency [415.015724] Dynamic subtest coherency: SUCCESS (4.431s) [415.030341] Starting dynamic subtest: gtt [426.171685] Dynamic subtest gtt: SUCCESS (11.155s) [426.186306] Starting dynamic subtest: gem [428.065646] Dynamic subtest gem: SUCCESS (1.893s) [428.080267] Starting dynamic subtest: evict [431.707648] Dynamic subtest evict: SUCCESS (3.641s) [431.722249] Starting dynamic subtest: hugepages [438.574874] Dynamic subtest hugepages: SUCCESS (6.866s) [438.590060] Starting dynamic subtest: gem_contexts [453.651648] Dynamic subtest gem_contexts: SUCCESS (15.076s) [453.666659] Starting dynamic subtest: client [455.447713] Dynamic subtest client: SUCCESS (1.795s) [455.462792] Starting dynamic subtest: gem_migrate [457.238755] Dynamic subtest gem_migrate: SUCCESS (1.790s) [457.253817] Starting dynamic subtest: reset [462.578742] Dynamic subtest reset: SUCCESS (5.339s) [462.593854] Starting dynamic subtest: memory_region [464.343740] Dynamic subtest memory_region: SUCCESS (1.764s) [464.358843] Starting dynamic subtest: hangcheck [488.732720] Dynamic subtest hangcheck: SUCCESS (24.388s) [488.747802] Starting dynamic subtest: execlists [498.811327] Dynamic subtest execlists: SUCCESS (10.084s) [498.826743] Starting dynamic subtest: ring_submission [500.629670] Dynamic subtest ring_submission: SUCCESS (1.811s) [500.644841] Starting dynamic subtest: perf [502.491711] Dynamic subtest perf: SUCCESS (1.861s) [502.506943] Starting dynamic subtest: slpc [504.286732] Dynamic subtest slpc: SUCCESS (1.794s) [504.302025] Starting dynamic subtest: guc [506.062724] Dynamic subtest guc: SUCCESS (1.775s) [506.077912] Starting dynamic subtest: guc_multi_lrc [507.870804] Dynamic subtest guc_multi_lrc: SUCCESS (1.807s) [507.885923] Starting dynamic subtest: guc_hang [509.649782] Dynamic subtest guc_hang: SUCCESS (1.778s) [509.665126] Starting dynamic subtest: late_gt_pm [511.458570] Dynamic subtest late_gt_pm: SUCCESS (1.808s) [511.460019] Subtest live: SUCCESS (163.473s) [511.544454] [165/171] (494s left) dmabuf (all-tests) [511.675391] Starting subtest: all-tests [511.678848] Starting dynamic subtest: sanitycheck [511.706798] Dynamic subtest sanitycheck: SUCCESS (0.031s) [511.718934] Starting dynamic subtest: dma_fence [511.847885] Dynamic subtest dma_fence: SUCCESS (0.140s) [511.860173] Starting dynamic subtest: dma_fence_chain [529.454345] Dynamic subtest dma_fence_chain: SUCCESS (17.597s) [529.467533] Starting dynamic subtest: dma_fence_unwrap [529.475545] Dynamic subtest dma_fence_unwrap: SUCCESS (0.029s) [529.487894] Starting dynamic subtest: dma_resv [529.516163] Dynamic subtest dma_resv: SUCCESS (0.039s) [529.518067] Subtest all-tests: SUCCESS (17.841s) [529.543107] [166/171] (476s left) i915_suspend (basic-s2idle-without-i915) [529.660180] Starting subtest: basic-s2idle-without-i915 [553.443569] Subtest basic-s2idle-without-i915: SUCCESS (8.039s) [553.756513] [167/171] (468s left) i915_suspend (basic-s3-without-i915) [553.887132] Starting subtest: basic-s3-without-i915 [576.499729] Subtest basic-s3-without-i915: SUCCESS (6.825s) [576.849388] [168/171] (461s left) gem_exec_suspend (basic-s0) [576.994007] Starting subtest: basic-S0 [576.995204] Starting dynamic subtest: smem [596.553788] Dynamic subtest smem: SUCCESS (3.749s) [596.554830] Subtest basic-S0: SUCCESS (3.750s) [596.699642] [169/171] (457s left) gem_exec_suspend (basic-s3) [596.833976] Starting subtest: basic-S3 [596.835188] Starting dynamic subtest: smem [615.483738] Dynamic subtest smem: SUCCESS (3.440s) [615.484823] Subtest basic-S3: SUCCESS (3.441s) [615.635781] [170/171] (453s left) kms_chamelium_hpd (common-hpd-after-suspend) [616.113948] Subtest common-hpd-after-suspend: SKIP (0.000s) [617.031530] [171/171] (452s left) kms_pipe_crc_basic (suspend-read-crc) [617.182541] Starting subtest: suspend-read-crc [617.186499] Starting dynamic subtest: pipe-A-eDP-1 [634.513405] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.418s) [634.535414] Starting dynamic subtest: pipe-B-eDP-1 [652.471263] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.059s) [652.493843] Starting dynamic subtest: pipe-C-eDP-1 [671.491198] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.228s) [671.492296] Subtest suspend-read-crc: SUCCESS (8.719s) [672.412687] Closing watchdogs Done.