Lazy primitive group deserialization #309

msbarry · 2022-07-28T10:49:45Z

Reduce strain on JVM's garbage collector when reading an osm.pbf file by deferring parsing each primitive group (see https://wiki.openstreetmap.org/wiki/PBF_Format) so there's less deserialized data in-memory at any given point in time.
Pull in osm protobuf definitions from https://github.com/openstreetmap/OSM-binary/tree/master/osmpbf to replace an LGPL dependency with MIT and give more flexibility for future tweaks
Replace LongHashSet with more memory-efficient Roaring64Bitmap for storing IDs of ways that are members of multipolygons

Previously osm_pass1 was taking ~3 minutes and spending 1.5 minutes in GC, now it takes 1:45-2:00 and spends 14 seconds in GC on a cg6d.metal instance. This also helps running with a smaller heap in memory-mapped mode (which should probably be the default now unlesss you have 150GB+ of RAM).

wipfli · 2022-07-28T10:54:30Z

What is GC pressure and primitive group?

github-actions · 2022-07-28T10:59:56Z

Base c14be44 This Branch 4d609e8

0:02:10 DEB [mbtiles] - Tile stats:
0:02:10 DEB [mbtiles] - z0 avg:7.9k max:7.9k
0:02:10 DEB [mbtiles] - z1 avg:4k max:4k
0:02:10 DEB [mbtiles] - z2 avg:9.4k max:9.4k
0:02:10 DEB [mbtiles] - z3 avg:3.9k max:6.4k
0:02:10 DEB [mbtiles] - z4 avg:1.6k max:4.6k
0:02:10 DEB [mbtiles] - z5 avg:1.4k max:8.1k
0:02:10 DEB [mbtiles] - z6 avg:973 max:22k
0:02:10 DEB [mbtiles] - z7 avg:751 max:55k
0:02:10 DEB [mbtiles] - z8 avg:395 max:112k
0:02:10 DEB [mbtiles] - z9 avg:270 max:278k
0:02:10 DEB [mbtiles] - z10 avg:154 max:233k
0:02:10 DEB [mbtiles] - z11 avg:102 max:132k
0:02:10 DEB [mbtiles] - z12 avg:83 max:119k
0:02:10 DEB [mbtiles] - z13 avg:71 max:109k
0:02:10 DEB [mbtiles] - z14 avg:67 max:277k
0:02:10 DEB [mbtiles] - all avg:69 max:0
0:02:10 DEB [mbtiles] -  # features: 5,296,447
0:02:10 DEB [mbtiles] -     # tiles: 4,115,450
0:02:10 INF [mbtiles] - Finished in 34s cpu:1m6s avg:2
0:02:10 INF [mbtiles] -   read    1x(3% 0.9s wait:32s)
0:02:10 INF [mbtiles] -   encode  2x(60% 20s wait:2s)
0:02:10 INF [mbtiles] -   write   1x(24% 8s wait:24s)
0:02:10 INF - Finished in 2m10s cpu:3m59s gc:4s avg:1.8
0:02:10 INF - FINISHED!
0:02:10 INF - 
0:02:10 INF - ----------------------------------------
0:02:10 INF - 	overall          2m10s cpu:3m59s gc:4s avg:1.8
0:02:10 INF - 	lake_centerlines 3s cpu:5s avg:1.8
0:02:10 INF - 	  read     1x(84% 2s)
0:02:10 INF - 	  process  2x(14% 0.4s wait:2s)
0:02:10 INF - 	  write    1x(0% 0s wait:3s)
0:02:10 INF - 	water_polygons   29s cpu:52s gc:3s avg:1.8
0:02:10 INF - 	  read     1x(56% 16s wait:3s)
0:02:10 INF - 	  process  2x(31% 9s wait:12s)
0:02:10 INF - 	  write    1x(2% 0.7s wait:28s)
0:02:10 INF - 	natural_earth    12s cpu:18s avg:1.5
0:02:10 INF - 	  read     1x(88% 10s sys:2s)
0:02:10 INF - 	  process  2x(18% 2s wait:10s)
0:02:10 INF - 	  write    1x(0% 0s wait:11s)
0:02:10 INF - 	osm_pass1        5s cpu:9s avg:1.9
0:02:10 INF - 	  read     1x(2% 0.1s wait:4s)
0:02:10 INF - 	  parse    1x(65% 3s wait:1s)
0:02:10 INF - 	  process  1x(48% 2s wait:2s)
0:02:10 INF - 	osm_pass2        37s cpu:1m14s avg:2
0:02:10 INF - 	  read     1x(0% 0s wait:19s done:19s)
0:02:10 INF - 	  process  2x(77% 29s)
0:02:10 INF - 	  write    1x(1% 0.5s wait:37s)
0:02:10 INF - 	boundaries       0.1s cpu:0.1s avg:1.2
0:02:10 INF - 	sort             2s cpu:4s avg:1.6
0:02:10 INF - 	  worker  1x(97% 2s)
0:02:10 INF - 	mbtiles          34s cpu:1m6s avg:2
0:02:10 INF - 	  read    1x(3% 0.9s wait:32s)
0:02:10 INF - 	  encode  2x(60% 20s wait:2s)
0:02:10 INF - 	  write   1x(24% 8s wait:24s)
0:02:10 INF - ----------------------------------------
0:02:10 INF - 	features	270MB
0:02:10 INF - 	mbtiles	108MB
-rw-r--r-- 1 runner docker 56M Jul 28 11:08 run.jar

0:02:18 DEB [mbtiles] - Tile stats:
0:02:18 DEB [mbtiles] - z0 avg:7.9k max:7.9k
0:02:18 DEB [mbtiles] - z1 avg:4k max:4k
0:02:18 DEB [mbtiles] - z2 avg:9.4k max:9.4k
0:02:18 DEB [mbtiles] - z3 avg:3.9k max:6.4k
0:02:18 DEB [mbtiles] - z4 avg:1.6k max:4.6k
0:02:18 DEB [mbtiles] - z5 avg:1.4k max:8.1k
0:02:18 DEB [mbtiles] - z6 avg:973 max:22k
0:02:18 DEB [mbtiles] - z7 avg:751 max:55k
0:02:18 DEB [mbtiles] - z8 avg:395 max:112k
0:02:18 DEB [mbtiles] - z9 avg:270 max:278k
0:02:18 DEB [mbtiles] - z10 avg:154 max:233k
0:02:18 DEB [mbtiles] - z11 avg:102 max:132k
0:02:18 DEB [mbtiles] - z12 avg:83 max:119k
0:02:18 DEB [mbtiles] - z13 avg:71 max:109k
0:02:18 DEB [mbtiles] - z14 avg:67 max:277k
0:02:18 DEB [mbtiles] - all avg:69 max:0
0:02:18 DEB [mbtiles] -  # features: 5,296,447
0:02:18 DEB [mbtiles] -     # tiles: 4,115,450
0:02:18 INF [mbtiles] - Finished in 34s cpu:1m7s avg:2
0:02:18 INF [mbtiles] -   read    1x(3% 1s wait:33s)
0:02:18 INF [mbtiles] -   encode  2x(58% 20s wait:2s)
0:02:18 INF [mbtiles] -   write   1x(24% 8s wait:24s)
0:02:18 INF - Finished in 2m18s cpu:4m2s gc:5s avg:1.8
0:02:18 INF - FINISHED!
0:02:18 INF - 
0:02:18 INF - ----------------------------------------
0:02:18 INF - 	overall          2m18s cpu:4m2s gc:5s avg:1.8
0:02:18 INF - 	lake_centerlines 3s cpu:5s avg:1.9
0:02:18 INF - 	  read     1x(80% 2s)
0:02:18 INF - 	  process  2x(14% 0.4s wait:2s)
0:02:18 INF - 	  write    1x(0% 0s wait:2s)
0:02:18 INF - 	water_polygons   29s cpu:51s gc:3s avg:1.7
0:02:18 INF - 	  read     1x(57% 17s sys:1s wait:3s)
0:02:18 INF - 	  process  2x(30% 9s wait:13s)
0:02:18 INF - 	  write    1x(2% 0.7s wait:29s)
0:02:18 INF - 	natural_earth    14s cpu:21s avg:1.5
0:02:18 INF - 	  read     1x(85% 12s sys:2s done:1s)
0:02:18 INF - 	  process  2x(18% 2s wait:12s done:1s)
0:02:18 INF - 	  write    1x(0% 0s wait:13s done:1s)
0:02:18 INF - 	osm_pass1        6s cpu:9s avg:1.5
0:02:18 INF - 	  read     1x(2% 0.1s wait:5s)
0:02:18 INF - 	  parse    1x(49% 3s wait:2s)
0:02:18 INF - 	  process  1x(41% 2s wait:2s)
0:02:18 INF - 	osm_pass2        37s cpu:1m14s avg:2
0:02:18 INF - 	  read     1x(0% 0s wait:20s done:18s)
0:02:18 INF - 	  process  2x(78% 29s)
0:02:18 INF - 	  write    1x(1% 0.4s wait:37s)
0:02:18 INF - 	boundaries       0.1s cpu:0.1s avg:2
0:02:18 INF - 	sort             3s cpu:4s avg:1.3
0:02:18 INF - 	  worker  1x(84% 2s)
0:02:18 INF - 	mbtiles          34s cpu:1m7s avg:2
0:02:18 INF - 	  read    1x(3% 1s wait:33s)
0:02:18 INF - 	  encode  2x(58% 20s wait:2s)
0:02:18 INF - 	  write   1x(24% 8s wait:24s)
0:02:18 INF - ----------------------------------------
0:02:18 INF - 	features	270MB
0:02:18 INF - 	mbtiles	108MB
-rw-r--r-- 1 runner docker 56M Jul 28 11:05 run.jar

https://github.com/onthegomap/planetiler/actions/runs/2753288275

ℹ️ Base Logs c14be44

0:00:00 DEB - argument: config=null (path to config file)
0:00:00 DEB - argument: area=rhode island (name of the extract to download if osm_url/osm_path not specified (i.e. 'monaco' 'rhode island' 'australia' or 'planet'))
0:00:00 INF - Using in-memory stats
0:00:00 INF [overall] - 
0:00:00 INF [overall] - Starting...
0:00:00 DEB - argument: madvise=true (default value for whether to use linux madvise(random) to improve memory-mapped read performance for temporary storage)
0:00:00 DEB - argument: storage=mmap (default storage type for temporary data, one of [ram, mmap, direct])
0:00:00 DEB - argument: threads=2 (num threads)
0:00:00 DEB - argument: write_threads=1 (number of threads to use when writing temp features)
0:00:00 DEB - argument: process_threads=2 (number of threads to use when processing input features)
0:00:00 DEB - argument: bounds=Env[-74.07 : -17.84, 21.34 : 43.55] (bounds)
0:00:00 DEB - argument: polygon=null (a .poly file that limits output to tiles intersecting the shape)
0:00:00 DEB - argument: minzoom=0 (minimum zoom level)
0:00:00 DEB - argument: maxzoom=14 (maximum zoom level up to 15)
0:00:00 DEB - argument: render_maxzoom=14 (maximum rendering zoom level up to 15)
0:00:00 DEB - argument: feature_read_threads=1 (number of threads to use when reading features at tile write time)
0:00:00 DEB - argument: loginterval=10 seconds (time between logs)
0:00:00 DEB - argument: skip_mbtiles_index_creation=false (skip adding index to mbtiles file)
0:00:00 DEB - argument: optimize_db=false (optimize mbtiles after writing)
0:00:00 DEB - argument: emit_tiles_in_order=true (emit tiles in index order)
0:00:00 DEB - argument: force=false (overwriting output file and ignore disk/RAM warnings)
0:00:00 DEB - argument: gzip_temp=false (gzip temporary feature storage (uses more CPU, but less disk space))
0:00:00 DEB - argument: mmap_temp=true (use memory-mapped IO for temp feature files)
0:00:00 DEB - argument: sort_max_readers=6 (maximum number of concurrent read threads to use when sorting chunks)
0:00:00 DEB - argument: sort_max_writers=6 (maximum number of concurrent write threads to use when sorting chunks)
0:00:00 DEB - argument: nodemap_type=sparsearray (type of node location map, one of [noop, sortedtable, sparsearray, array])
0:00:00 DEB - argument: nodemap_storage=mmap (storage for node location map, one of [ram, mmap, direct])
0:00:00 DEB - argument: nodemap_madvise=true (use linux madvise(random) for node locations)
0:00:00 DEB - argument: multipolygon_geometry_storage=mmap (storage for multipolygon geometries, one of [ram, mmap, direct])
0:00:00 DEB - argument: multipolygon_geometry_madvise=true (use linux madvise(random) for temporary multipolygon geometry storage)
0:00:00 DEB - argument: http_user_agent=Planetiler downloader (https://github.com/onthegomap/planetiler) (User-Agent header to set when downloading files over HTTP)
0:00:00 DEB - argument: http_timeout=30 seconds (Timeout to use when downloading files over HTTP)
0:00:00 DEB - argument: http_retries=1 (Retries to use when downloading files over HTTP)
0:00:00 DEB - argument: download_chunk_size_mb=100 (Size of file chunks to download in parallel in megabytes)
0:00:00 DEB - argument: download_threads=1 (Number of parallel threads to use when downloading each file)
0:00:00 DEB - argument: min_feature_size_at_max_zoom=0.0625 (Default value for the minimum size in tile pixels of features to emit at the maximum zoom level to allow for overzooming)
0:00:00 DEB - argument: min_feature_size=1.0 (Default value for the minimum size in tile pixels of features to emit below the maximum zoom level)
0:00:00 DEB - argument: simplify_tolerance_at_max_zoom=0.0625 (Default value for the tile pixel tolerance to use when simplifying features at the maximum zoom level to allow for overzooming)
0:00:00 DEB - argument: simplify_tolerance=0.1 (Default value for the tile pixel tolerance to use when simplifying features below the maximum zoom level)
0:00:00 DEB - argument: osm_lazy_reads=true (Read OSM blocks from disk in worker threads)
0:00:00 DEB - argument: compact_db=true (Reduce the DB size by separating and deduping the tile data)
0:00:00 DEB - argument: skip_filled_tiles=false (Skip writing tiles containing only polygon fills to the output)
0:00:00 DEB - argument: tile_warning_size_mb=1.0 (Maximum size in megabytes of a tile to emit a warning about)
0:00:00 DEB - argument: tmpdir=data/tmp (temp directory)
0:00:00 DEB - argument: only_download=false (download source data then exit)
0:00:00 DEB - argument: download=false (download sources)
0:00:00 DEB - argument: temp_nodes=data/tmp/node.db (temp node db location)
0:00:00 DEB - argument: temp_multipolygons=data/tmp/multipolygon.db (temp multipolygon db location)
0:00:00 DEB - argument: temp_features=data/tmp/feature.db (temp feature db location)
0:00:00 DEB - argument: osm_parse_node_bounds=false (parse bounds from OSM nodes instead of header)
0:00:00 DEB - argument: only_fetch_wikidata=false (fetch wikidata translations then quit)
0:00:00 DEB - argument: fetch_wikidata=false (fetch wikidata translations then continue)
0:00:00 DEB - argument: use_wikidata=true (use wikidata translations)
0:00:00 DEB - argument: wikidata_cache=data/sources/wikidata_names.json (wikidata cache file)
0:00:00 DEB - argument: lake_centerlines_path=data/sources/lake_centerline.shp.zip (lake_centerlines shapefile path)
0:00:00 DEB - argument: free_lake_centerlines_after_read=false (delete lake_centerlines input file after reading to make space for output (reduces peak disk usage))
0:00:00 DEB - argument: water_polygons_path=data/sources/water-polygons-split-3857.zip (water_polygons shapefile path)
0:00:00 DEB - argument: free_water_polygons_after_read=false (delete water_polygons input file after reading to make space for output (reduces peak disk usage))
0:00:00 DEB - argument: natural_earth_path=data/sources/natural_earth_vector.sqlite.zip (natural_earth sqlite db path)
0:00:00 DEB - argument: free_natural_earth_after_read=false (delete natural_earth input file after reading to make space for output (reduces peak disk usage))
0:00:00 DEB - argument: osm_path=data/sources/rhode_island.osm.pbf (osm OSM input file path)
0:00:00 DEB - argument: free_osm_after_read=false (delete osm input file after reading to make space for output (reduces peak disk usage))
0:00:00 DEB - argument: mbtiles=data/out.mbtiles (mbtiles output file)
0:00:00 DEB - argument: transliterate=true (attempt to transliterate latin names)
0:00:00 DEB - argument: languages=am,ar,az,be,bg,br,bs,ca,co,cs,cy,da,de,el,en,eo,es,et,eu,fi,fr,fy,ga,gd,he,hi,hr,hu,hy,id,is,it,ja,ja_kana,ja_rm,ja-Latn,ja-Hira,ka,kk,kn,ko,ko-Latn,ku,la,lb,lt,lv,mk,mt,ml,nl,no,oc,pl,pt,rm,ro,ru,sk,sl,sq,sr,sr-Latn,sv,ta,te,th,tr,uk,zh (languages to use)
0:00:00 DEB - argument: only_layers= (Include only certain layers)
0:00:00 DEB - argument: exclude_layers= (Exclude certain layers)
0:00:00 DEB - argument: boundary_country_names=true (boundary layer: add left/right codes of neighboring countries)
0:00:00 DEB - argument: transportation_z13_paths=false (transportation(_name) layer: show all paths on z13)
0:00:00 DEB - argument: building_merge_z13=true (building layer: merge nearby buildings at z13)
0:00:00 DEB - argument: transportation_name_brunnel=false (transportation_name layer: set to false to omit brunnel and help merge long highways)
0:00:00 DEB - argument: transportation_name_size_for_shield=false (transportation_name layer: allow road names on shorter segments (ie. they will have a shield))
0:00:00 DEB - argument: transportation_name_limit_merge=false (transportation_name layer: limit merge so we don't combine different relations to help merge long highways)
0:00:00 DEB - argument: transportation_name_minor_refs=false (transportation_name layer: include name and refs from minor road networks if not present on a way)
0:00:00 DEB - argument: mbtiles_name=OpenMapTiles ('name' attribute for mbtiles metadata)
0:00:00 DEB - argument: mbtiles_description=A tileset showcasing all layers in OpenMapTiles. https://openmaptiles.org ('description' attribute for mbtiles metadata)
0:00:00 DEB - argument: mbtiles_attribution=<a href="https://www.openmaptiles.org/" target="_blank">&copy; OpenMapTiles</a> <a href="https://www.openstreetmap.org/copyright" target="_blank">&copy; OpenStreetMap contributors</a> ('attribution' attribute for mbtiles metadata)
0:00:00 DEB - argument: mbtiles_version=3.13.1 ('version' attribute for mbtiles metadata)
0:00:00 DEB - argument: mbtiles_type=baselayer ('type' attribute for mbtiles metadata)
0:00:00 DEB - argument: help=false (show arguments then exit)
0:00:00 INF - Building BasemapProfile profile into data/out.mbtiles in these phases:
0:00:00 INF -   lake_centerlines: Process features in data/sources/lake_centerline.shp.zip
0:00:00 INF -   water_polygons: Process features in data/sources/water-polygons-split-3857.zip
0:00:00 INF -   natural_earth: Process features in data/sources/natural_earth_vector.sqlite.zip
0:00:00 INF -   osm_pass1: Pre-process OpenStreetMap input (store node locations then relation members)
0:00:00 INF -   osm_pass2: Process OpenStreetMap nodes, ways, then relations
0:00:00 INF -   sort: Sort rendered features by tile ID
0:00:00 INF -   mbtiles: Encode each tile and write to data/out.mbtiles
0:00:00 INF - no wikidata translations found, run with --fetch-wikidata to download
0:00:00 DEB - ✓ 195M storage on / (/dev/root) requested for read phase disk, 30G available
0:00:00 DEB -  - 43M used for temporary node location cache
0:00:00 DEB -  - 6.6M used for temporary multipolygon geometry cache
0:00:00 DEB -  - 144M used for temporary feature storage
0:00:00 DEB - ✓ 217M storage on / (/dev/root) requested for write phase disk, 30G available
0:00:00 DEB -  - 144M used for temporary feature storage
0:00:00 DEB -  - 72M used for mbtiles output
0:00:00 DEB - ✓ 50M storage on / (/dev/root) requested for read phase, 30G available
0:00:00 DEB -  - 43M used for sparsearray node location cache
0:00:00 DEB -  - 6.6M used for multipolygon way geometries
0:00:00 DEB - ✓ 312M JVM heap requested for read phase, 4.2G available
0:00:00 DEB -  - 300M used for sparsearray node location in-memory index
0:00:00 DEB -  - 12M used for temporary profile storage
0:00:00 DEB - ✓ 50M temporary files and 2.9G of free memory for OS to cache them
0:00:00 INF - Using merge sort feature map, chunk size=1431mb max workers=2
0:00:01 INF - dataFileCache open start
0:00:02 INF [lake_centerlines] - 
0:00:02 INF [lake_centerlines] - Starting...
0:00:04 INF [lake_centerlines] -  read: [  59k 100%  23k/s ] write: [    0    0/s ] 0    
    cpus: 1.8 gc:  3% heap: 153M/4.2G direct: 237k postGC: 74M
    read( -%) ->    (0/1k) -> process( -%  -%) ->   (0/53k) -> write( -%)
0:00:04 INF [lake_centerlines] - Finished in 3s cpu:5s avg:1.8
0:00:04 INF [lake_centerlines] -   read     1x(84% 2s)
0:00:04 INF [lake_centerlines] -   process  2x(14% 0.4s wait:2s)
0:00:04 INF [lake_centerlines] -   write    1x(0% 0s wait:3s)
0:00:04 INF [water_polygons] - 
0:00:04 INF [water_polygons] - Starting...
0:00:14 INF [water_polygons] -  read: [ 1.8k  13%  181/s ] write: [  46k 4.5k/s ] 1.4G 
    cpus: 2 gc: 11% heap: 1.6G/4.2G direct: 52M postGC: 831M
    read(53%) ->    (0/1k) -> process(14% 46%) -> (871/53k) -> write( 0%)
0:00:24 INF [water_polygons] -  read: [ 4.1k  29%  237/s ] write: [ 229k  18k/s ] 1.4G 
    cpus: 1.9 gc: 11% heap: 2.1G/4.2G direct: 52M postGC: 1.5G
    read(58%) ->    (2/1k) -> process(27% 39%) -> (1.3k/53k) -> write( 0%)
0:00:33 INF [water_polygons] -  read: [  14k 100% 1.1k/s ] write: [ 4.3M 475k/s ] 186M 
    cpus: 1.6 gc:  6% heap: 1.9G/4.2G direct: 52M postGC: 1.7G
    read( -%) ->    (0/1k) -> process( -%  -%) ->   (0/53k) -> write( -%)
0:00:33 INF [water_polygons] - Finished in 29s cpu:52s gc:3s avg:1.8
0:00:33 INF [water_polygons] -   read     1x(56% 16s wait:3s)
0:00:33 INF [water_polygons] -   process  2x(31% 9s wait:12s)
0:00:33 INF [water_polygons] -   write    1x(2% 0.7s wait:28s)
0:00:33 INF [natural_earth] - unzipping /home/runner/work/planetiler/planetiler/data/sources/natural_earth_vector.sqlite.zip to data/tmp/natearth.sqlite
0:00:39 INF [natural_earth] - 
0:00:39 INF [natural_earth] - Starting...
0:00:50 INF [natural_earth] -  read: [ 328k  94%  32k/s ] write: [    0    0/s ] 1.6G 
    cpus: 1.5 gc:  0% heap: 3G/4.2G direct: 52M postGC: 1.7G
    read(95%) ->   (87/1k) -> process(19% 18%) -> (132/53k) -> write( 0%)
0:00:51 INF [natural_earth] -  read: [ 349k 100%  21k/s ] write: [  181  176/s ] 186M 
    cpus: 1.8 gc:  0% heap: 3.3G/4.2G direct: 52M postGC: 1.7G
    read( -%) ->    (0/1k) -> process( -%  -%) ->   (0/53k) -> write( -%)
0:00:51 INF [natural_earth] - Finished in 12s cpu:18s avg:1.5
0:00:51 INF [natural_earth] -   read     1x(88% 10s sys:2s)
0:00:51 INF [natural_earth] -   process  2x(18% 2s wait:10s)
0:00:51 INF [natural_earth] -   write    1x(0% 0s wait:11s)
0:00:51 INF [osm_pass1] - 
0:00:51 INF [osm_pass1] - Starting...
0:00:54 INF [osm_pass1:process] - Finished nodes: 4,607,020 (1.4M/s) in 3s cpu:6s avg:1.8
0:00:55 INF [osm_pass1:process] - Finished ways: 333,591 (275k/s) in 1s cpu:2s avg:2
0:00:56 INF [osm_pass1:process] - Finished relations: 7,760 (107k/s) in 0.1s cpu:0.1s avg:1.9
0:00:56 INF [osm_pass1] -  nodes: [ 4.6M 981k/s ] 419M  ways: [ 333k  71k/s ] rels: [ 7.7k 1.6k/s ] blocks: [  619  131/s ]
    cpus: 1.9 gc:  1% heap: 987M/4.2G direct: 52M postGC: 843M hppc: 880k
    read( -%) ->     (0/4) -> parse( -%) ->     (0/4) -> process( -%)
0:00:56 DEB [osm_pass1] - Processed 619 blocks:
0:00:56 DEB [osm_pass1] -   nodes: 4,607,020 (1.4M/s) in 3s cpu:6s avg:1.8
0:00:56 DEB [osm_pass1] -   ways: 333,591 (275k/s) in 1s cpu:2s avg:2
0:00:56 DEB [osm_pass1] -   relations: 7,760 (107k/s) in 0.1s cpu:0.1s avg:1.9
0:00:56 INF [osm_pass1] - Finished in 5s cpu:9s avg:1.9
0:00:56 INF [osm_pass1] -   read     1x(2% 0.1s wait:4s)
0:00:56 INF [osm_pass1] -   parse    1x(65% 3s wait:1s)
0:00:56 INF [osm_pass1] -   process  1x(48% 2s wait:2s)
0:00:56 INF [osm_pass2] - 
0:00:56 INF [osm_pass2] - Starting...
0:00:58 DEB [osm_pass2:process] - Sorting long long multimap...
0:00:58 INF [osm_pass2:process] - Finished nodes: 4,607,020 (1.7M/s) in 3s cpu:5s avg:1.9
0:00:58 DEB [osm_pass2:process] - Sorted long long multimap 0s cpu:0s avg:1.6
0:00:58 WAR [osm_pass2:process] - No GB polygon for inferring route network types
0:01:06 INF [osm_pass2] -  nodes: [ 4.6M 100% 460k/s ] 419M  ways: [ 100k  30%  10k/s ] rels: [    0   0%    0/s ] features: [ 4.7M  44k/s ] 1.6G  blocks: [  588  95%   58/s ]
    cpus: 2 gc:  0% heap: 3G/4.2G direct: 52M postGC: 852M relInfo: 829k mpGeoms: 524k 
    read( 0%) ->   (11/13) -> process(64% 65%) -> (450/53k) -> write( 2%)
0:01:16 INF [osm_pass2] -  nodes: [ 4.6M 100%    0/s ] 419M  ways: [ 260k  78%  15k/s ] rels: [    0   0%    0/s ] features: [ 5.1M  33k/s ] 1.6G  blocks: [  607  98%    1/s ]
    cpus: 2 gc:  1% heap: 2.5G/4.2G direct: 52M postGC: 863M relInfo: 829k mpGeoms: 13M  
    read( -%) ->   (10/13) -> process(79% 81%) ->  (1k/53k) -> write( 2%)
0:01:20 INF [osm_pass2:process] - Finished ways: 333,591 (15k/s) in 22s cpu:43s avg:2
0:01:26 INF [osm_pass2] -  nodes: [ 4.6M 100%    0/s ] 419M  ways: [ 333k 100% 7.3k/s ] rels: [ 3.6k  48%  368/s ] features: [ 5.2M  17k/s ] 1.6G  blocks: [  618 100%    1/s ]
    cpus: 2 gc:  1% heap: 2.5G/4.2G direct: 52M postGC: 858M relInfo: 829k mpGeoms: 19M  
    read( -%) ->    (0/13) -> process(82% 80%) -> (573/53k) -> write( 1%)
0:01:30 INF [osm_pass2:process] - Finished relations: 7,760 (747/s) in 10s cpu:20s avg:2
0:01:33 INF [osm_pass2] -  nodes: [ 4.6M 100%    0/s ] 419M  ways: [ 333k 100%    0/s ] rels: [ 7.7k 100%  553/s ] features: [ 5.2M 2.6k/s ] 270M  blocks: [  619 100%   <1/s ]
    cpus: 2 gc:  1% heap: 794M/4.2G direct: 52M postGC: 850M relInfo: 829k mpGeoms: 19M  
    read( -%) ->    (0/13) -> process( -%  -%) ->   (0/53k) -> write( -%)
0:01:33 DEB [osm_pass2] - Processed 619 blocks:
0:01:33 DEB [osm_pass2] -   nodes: 4,607,020 (1.7M/s) in 3s cpu:5s avg:1.9
0:01:33 DEB [osm_pass2] -   ways: 333,591 (15k/s) in 22s cpu:43s avg:2
0:01:33 DEB [osm_pass2] -   relations: 7,760 (747/s) in 10s cpu:20s avg:2
0:01:33 INF [osm_pass2] - Finished in 37s cpu:1m14s avg:2
0:01:33 INF [osm_pass2] -   read     1x(0% 0s wait:19s done:19s)
0:01:33 INF [osm_pass2] -   process  2x(77% 29s)
0:01:33 INF [osm_pass2] -   write    1x(1% 0.5s wait:37s)
0:01:33 INF [boundaries] - 
0:01:33 INF [boundaries] - Starting...
0:01:33 INF [boundaries] - Creating polygons for 1 boundaries
0:01:33 WAR [boundaries] - Unable to form closed polygon for OSM relation 148838 (likely missing edges)
0:01:33 INF [boundaries] - Finished creating 0 country polygons
0:01:33 INF [boundaries] - Finished in 0.1s cpu:0.1s avg:1.2
0:01:33 INF - Deleting node.db to make room for output file
0:01:33 INF [sort] - 
0:01:33 INF [sort] - Starting...
0:01:33 INF [sort] - Grouped 8 chunks into 1
0:01:35 INF [sort] -  chunks: [   1 /   1 100% ] 270M 
    cpus: 1.6 gc:  0% heap: 1.2G/4.2G direct: 52M postGC: 850M
    ->     (0/3) -> worker( -%)
0:01:35 INF [sort] - Finished in 2s cpu:4s avg:1.6
0:01:35 INF [sort] -   worker  1x(97% 2s)
0:01:35 INF - read:0s write:0s sort:1s
0:01:36 INF [mbtiles] - 
0:01:36 INF [mbtiles] - Starting...
0:01:36 DEB [mbtiles:write] - Execute mbtiles: create table metadata (name text, value text);
0:01:36 DEB [mbtiles:write] - Execute mbtiles: create unique index name on metadata (name);
0:01:36 DEB [mbtiles:write] - Execute mbtiles: create table tiles_shallow (
  zoom_level integer,
  tile_column integer,
  tile_row integer,
  tile_data_id integer

  , primary key(zoom_level,tile_column,tile_row)

) without rowid

0:01:36 DEB [mbtiles:write] - Execute mbtiles: create table tiles_data (
  tile_data_id integer primary key,
  tile_data blob
)

0:01:36 DEB [mbtiles:write] - Execute mbtiles: create view tiles AS
select
  tiles_shallow.zoom_level as zoom_level,
  tiles_shallow.tile_column as tile_column,
  tiles_shallow.tile_row as tile_row,
  tiles_data.tile_data as tile_data
from tiles_shallow
join tiles_data on tiles_shallow.tile_data_id = tiles_data.tile_data_id

0:01:36 DEB [mbtiles:write] - Set mbtiles metadata: name=OpenMapTiles
0:01:36 DEB [mbtiles:write] - Set mbtiles metadata: format=pbf
0:01:36 DEB [mbtiles:write] - Set mbtiles metadata: description=A tileset showcasing all layers in OpenMapTiles. https://openmaptiles.org
0:01:36 DEB [mbtiles:write] - Set mbtiles metadata: attribution=<a href="https://www.openmaptiles.org/" target="_blank">&copy; OpenMapTiles</a> <a href="https://www.openstreetmap.org/copyright" target="_blank">&copy; OpenStreetMap contributors</a>
0:01:36 DEB [mbtiles:write] - Set mbtiles metadata: version=3.13.1
0:01:36 DEB [mbtiles:write] - Set mbtiles metadata: type=baselayer
0:01:36 DEB [mbtiles:write] - Set mbtiles metadata: bounds=-74.07,21.34,-17.84,43.55
0:01:36 DEB [mbtiles:write] - Set mbtiles metadata: center=-45.955,32.445,3
0:01:36 DEB [mbtiles:write] - Set mbtiles metadata: minzoom=0
0:01:36 DEB [mbtiles:write] - Set mbtiles metadata: maxzoom=14
0:01:36 DEB [mbtiles:write] - Set mbtiles metadata: json={"vector_layers":[{"id":"aerodrome_label","fields":{"name_int":"String","iata":"String","ele_ft":"Number","name_de":"String","name":"String","icao":"String","name:en":"String","class":"String","ele":"Number","name_en":"String","name:latin":"String"},"minzoom":10,"maxzoom":14},{"id":"aeroway","fields":{"ref":"String","class":"String"},"minzoom":10,"maxzoom":14},{"id":"boundary","fields":{"disputed":"Number","admin_level":"Number","maritime":"Number"},"minzoom":0,"maxzoom":14},{"id":"building","fields":{"colour":"String","render_height":"Number","render_min_height":"Number"},"minzoom":13,"maxzoom":14},{"id":"housenumber","fields":{"housenumber":"String"},"minzoom":14,"maxzoom":14},{"id":"landcover","fields":{"subclass":"String","class":"String","_numpoints":"Number"},"minzoom":7,"maxzoom":14},{"id":"landuse","fields":{"class":"String"},"minzoom":4,"maxzoom":14},{"id":"mountain_peak","fields":{"name_int":"String","customary_ft":"Number","ele_ft":"Number","name_de":"String","name":"String"... 2244 more characters
0:01:38 INF [mbtiles:write] - Starting z0
0:01:38 INF [mbtiles:write] - Finished z0 in 0s cpu:0s avg:0, now starting z1
0:01:38 INF [mbtiles:write] - Finished z1 in 0s cpu:0s avg:0, now starting z2
0:01:38 INF [mbtiles:write] - Finished z2 in 0s cpu:0s avg:72.7, now starting z3
0:01:38 INF [mbtiles:write] - Finished z3 in 0s cpu:0s avg:0, now starting z4
0:01:38 INF [mbtiles:write] - Finished z4 in 0s cpu:0s avg:0, now starting z5
0:01:38 INF [mbtiles:write] - Finished z5 in 0s cpu:0s avg:0, now starting z6
0:01:38 INF [mbtiles:write] - Finished z6 in 0s cpu:0s avg:0, now starting z7
0:01:39 INF [mbtiles:write] - Finished z7 in 0.9s cpu:2s avg:2, now starting z8
0:01:40 INF [mbtiles:write] - Finished z8 in 2s cpu:3s avg:2, now starting z9
0:01:41 INF [mbtiles:write] - Finished z9 in 1s cpu:2s avg:2, now starting z10
0:01:42 INF [mbtiles:write] - Finished z10 in 1s cpu:2s avg:1.9, now starting z11
0:01:44 INF [mbtiles:write] - Finished z11 in 2s cpu:3s avg:2, now starting z12
0:01:46 INF [mbtiles] -  features: [ 307k   6%  30k/s ] 270M  tiles: [  97k 9.7k/s ] 9.2M 
    cpus: 2 gc:  2% heap: 2.2G/4.2G direct: 52M postGC: 1.4G
    read( 1%) -> (212/217) -> encode(63% 61%) -> (216/216) -> write( 3%)
    last tile: 12/1315/1797 (z12 17%) https://www.openstreetmap.org/#map=12/21.53485/-64.42383
0:01:47 INF [mbtiles:write] - Finished z12 in 3s cpu:6s avg:2, now starting z13
0:01:56 INF [mbtiles] -  features: [ 741k  14%  43k/s ] 270M  tiles: [ 291k  19k/s ] 13M  
    cpus: 2 gc:  2% heap: 3.2G/4.2G direct: 52M postGC: 1.4G
    read( 0%) -> (214/217) -> encode(62% 64%) -> (215/216) -> write( 4%)
    last tile: 13/2470/3046 (z13 5%) https://www.openstreetmap.org/#map=13/41.83683/-71.45508
0:02:01 INF [mbtiles:write] - Finished z13 in 14s cpu:28s avg:2, now starting z14
0:02:06 INF [mbtiles] -  features: [ 3.6M  69% 289k/s ] 270M  tiles: [ 2.2M 200k/s ] 76M  
    cpus: 2 gc:  2% heap: 1.9G/4.2G direct: 52M postGC: 1.4G
    read( 4%) ->   (0/217) -> encode(63% 64%) -> (216/216) -> write(38%)
    last tile: 14/5883/6984 (z14 42%) https://www.openstreetmap.org/#map=14/25.64153/-50.73486
0:02:10 DEB [mbtiles:write] - Shallow tiles written: 4,115,450
0:02:10 DEB [mbtiles:write] - Tile data written: 21,291 (99% omitted)
0:02:10 DEB [mbtiles:write] - Unique tile hashes: 11,284
0:02:10 INF [mbtiles:write] - Finished z14 in 8s cpu:15s avg:1.9
0:02:10 INF [mbtiles] -  features: [ 5.2M 100% 445k/s ] 270M  tiles: [ 4.1M 490k/s ] 108M 
    cpus: 1.8 gc:  2% heap: 1.6G/4.2G direct: 52M postGC: 1.4G
    read( -%) ->   (0/217) -> encode( -%  -%) ->   (0/216) -> write( -%)
    last tile: 14/7380/5985 (z14 100%) https://www.openstreetmap.org/#map=14/43.56447/-17.84180
0:02:10 DEB [mbtiles] - Tile stats:
0:02:10 DEB [mbtiles] - z0 avg:7.9k max:7.9k
0:02:10 DEB [mbtiles] - z1 avg:4k max:4k
0:02:10 DEB [mbtiles] - z2 avg:9.4k max:9.4k
0:02:10 DEB [mbtiles] - z3 avg:3.9k max:6.4k
0:02:10 DEB [mbtiles] - z4 avg:1.6k max:4.6k
0:02:10 DEB [mbtiles] - z5 avg:1.4k max:8.1k
0:02:10 DEB [mbtiles] - z6 avg:973 max:22k
0:02:10 DEB [mbtiles] - z7 avg:751 max:55k
0:02:10 DEB [mbtiles] - z8 avg:395 max:112k
0:02:10 DEB [mbtiles] - z9 avg:270 max:278k
0:02:10 DEB [mbtiles] - z10 avg:154 max:233k
0:02:10 DEB [mbtiles] - z11 avg:102 max:132k
0:02:10 DEB [mbtiles] - z12 avg:83 max:119k
0:02:10 DEB [mbtiles] - z13 avg:71 max:109k
0:02:10 DEB [mbtiles] - z14 avg:67 max:277k
0:02:10 DEB [mbtiles] - all avg:69 max:0
0:02:10 DEB [mbtiles] -  # features: 5,296,447
0:02:10 DEB [mbtiles] -     # tiles: 4,115,450
0:02:10 INF [mbtiles] - Finished in 34s cpu:1m6s avg:2
0:02:10 INF [mbtiles] -   read    1x(3% 0.9s wait:32s)
0:02:10 INF [mbtiles] -   encode  2x(60% 20s wait:2s)
0:02:10 INF [mbtiles] -   write   1x(24% 8s wait:24s)
0:02:10 INF - Finished in 2m10s cpu:3m59s gc:4s avg:1.8
0:02:10 INF - FINISHED!
0:02:10 INF - 
0:02:10 INF - ----------------------------------------
0:02:10 INF - 	overall          2m10s cpu:3m59s gc:4s avg:1.8
0:02:10 INF - 	lake_centerlines 3s cpu:5s avg:1.8
0:02:10 INF - 	  read     1x(84% 2s)
0:02:10 INF - 	  process  2x(14% 0.4s wait:2s)
0:02:10 INF - 	  write    1x(0% 0s wait:3s)
0:02:10 INF - 	water_polygons   29s cpu:52s gc:3s avg:1.8
0:02:10 INF - 	  read     1x(56% 16s wait:3s)
0:02:10 INF - 	  process  2x(31% 9s wait:12s)
0:02:10 INF - 	  write    1x(2% 0.7s wait:28s)
0:02:10 INF - 	natural_earth    12s cpu:18s avg:1.5
0:02:10 INF - 	  read     1x(88% 10s sys:2s)
0:02:10 INF - 	  process  2x(18% 2s wait:10s)
0:02:10 INF - 	  write    1x(0% 0s wait:11s)
0:02:10 INF - 	osm_pass1        5s cpu:9s avg:1.9
0:02:10 INF - 	  read     1x(2% 0.1s wait:4s)
0:02:10 INF - 	  parse    1x(65% 3s wait:1s)
0:02:10 INF - 	  process  1x(48% 2s wait:2s)
0:02:10 INF - 	osm_pass2        37s cpu:1m14s avg:2
0:02:10 INF - 	  read     1x(0% 0s wait:19s done:19s)
0:02:10 INF - 	  process  2x(77% 29s)
0:02:10 INF - 	  write    1x(1% 0.5s wait:37s)
0:02:10 INF - 	boundaries       0.1s cpu:0.1s avg:1.2
0:02:10 INF - 	sort             2s cpu:4s avg:1.6
0:02:10 INF - 	  worker  1x(97% 2s)
0:02:10 INF - 	mbtiles          34s cpu:1m6s avg:2
0:02:10 INF - 	  read    1x(3% 0.9s wait:32s)
0:02:10 INF - 	  encode  2x(60% 20s wait:2s)
0:02:10 INF - 	  write   1x(24% 8s wait:24s)
0:02:10 INF - ----------------------------------------
0:02:10 INF - 	features	270MB
0:02:10 INF - 	mbtiles	108MB
-rw-r--r-- 1 runner docker 56M Jul 28 11:08 run.jar

ℹ️ This Branch Logs 4d609e8

0:00:00 DEB - argument: config=null (path to config file)
0:00:00 DEB - argument: area=rhode island (name of the extract to download if osm_url/osm_path not specified (i.e. 'monaco' 'rhode island' 'australia' or 'planet'))
0:00:00 INF - Using in-memory stats
0:00:00 INF [overall] - 
0:00:00 INF [overall] - Starting...
0:00:00 DEB - argument: madvise=true (default value for whether to use linux madvise(random) to improve memory-mapped read performance for temporary storage)
0:00:00 DEB - argument: storage=mmap (default storage type for temporary data, one of [ram, mmap, direct])
0:00:00 DEB - argument: threads=2 (num threads)
0:00:00 DEB - argument: write_threads=1 (number of threads to use when writing temp features)
0:00:00 DEB - argument: process_threads=2 (number of threads to use when processing input features)
0:00:00 DEB - argument: bounds=Env[-74.07 : -17.84, 21.34 : 43.55] (bounds)
0:00:00 DEB - argument: polygon=null (a .poly file that limits output to tiles intersecting the shape)
0:00:00 DEB - argument: minzoom=0 (minimum zoom level)
0:00:00 DEB - argument: maxzoom=14 (maximum zoom level up to 15)
0:00:00 DEB - argument: render_maxzoom=14 (maximum rendering zoom level up to 15)
0:00:00 DEB - argument: feature_read_threads=1 (number of threads to use when reading features at tile write time)
0:00:00 DEB - argument: loginterval=10 seconds (time between logs)
0:00:00 DEB - argument: skip_mbtiles_index_creation=false (skip adding index to mbtiles file)
0:00:00 DEB - argument: optimize_db=false (optimize mbtiles after writing)
0:00:00 DEB - argument: emit_tiles_in_order=true (emit tiles in index order)
0:00:00 DEB - argument: force=false (overwriting output file and ignore disk/RAM warnings)
0:00:00 DEB - argument: gzip_temp=false (gzip temporary feature storage (uses more CPU, but less disk space))
0:00:00 DEB - argument: mmap_temp=true (use memory-mapped IO for temp feature files)
0:00:00 DEB - argument: sort_max_readers=6 (maximum number of concurrent read threads to use when sorting chunks)
0:00:00 DEB - argument: sort_max_writers=6 (maximum number of concurrent write threads to use when sorting chunks)
0:00:00 DEB - argument: nodemap_type=sparsearray (type of node location map, one of [noop, sortedtable, sparsearray, array])
0:00:00 DEB - argument: nodemap_storage=mmap (storage for node location map, one of [ram, mmap, direct])
0:00:00 DEB - argument: nodemap_madvise=true (use linux madvise(random) for node locations)
0:00:00 DEB - argument: multipolygon_geometry_storage=mmap (storage for multipolygon geometries, one of [ram, mmap, direct])
0:00:00 DEB - argument: multipolygon_geometry_madvise=true (use linux madvise(random) for temporary multipolygon geometry storage)
0:00:00 DEB - argument: http_user_agent=Planetiler downloader (https://github.com/onthegomap/planetiler) (User-Agent header to set when downloading files over HTTP)
0:00:00 DEB - argument: http_timeout=30 seconds (Timeout to use when downloading files over HTTP)
0:00:00 DEB - argument: http_retries=1 (Retries to use when downloading files over HTTP)
0:00:00 DEB - argument: download_chunk_size_mb=100 (Size of file chunks to download in parallel in megabytes)
0:00:00 DEB - argument: download_threads=1 (Number of parallel threads to use when downloading each file)
0:00:00 DEB - argument: min_feature_size_at_max_zoom=0.0625 (Default value for the minimum size in tile pixels of features to emit at the maximum zoom level to allow for overzooming)
0:00:00 DEB - argument: min_feature_size=1.0 (Default value for the minimum size in tile pixels of features to emit below the maximum zoom level)
0:00:00 DEB - argument: simplify_tolerance_at_max_zoom=0.0625 (Default value for the tile pixel tolerance to use when simplifying features at the maximum zoom level to allow for overzooming)
0:00:00 DEB - argument: simplify_tolerance=0.1 (Default value for the tile pixel tolerance to use when simplifying features below the maximum zoom level)
0:00:00 DEB - argument: osm_lazy_reads=true (Read OSM blocks from disk in worker threads)
0:00:00 DEB - argument: compact_db=true (Reduce the DB size by separating and deduping the tile data)
0:00:00 DEB - argument: skip_filled_tiles=false (Skip writing tiles containing only polygon fills to the output)
0:00:00 DEB - argument: tile_warning_size_mb=1.0 (Maximum size in megabytes of a tile to emit a warning about)
0:00:00 DEB - argument: tmpdir=data/tmp (temp directory)
0:00:00 DEB - argument: only_download=false (download source data then exit)
0:00:00 DEB - argument: download=false (download sources)
0:00:00 DEB - argument: temp_nodes=data/tmp/node.db (temp node db location)
0:00:00 DEB - argument: temp_multipolygons=data/tmp/multipolygon.db (temp multipolygon db location)
0:00:00 DEB - argument: temp_features=data/tmp/feature.db (temp feature db location)
0:00:00 DEB - argument: osm_parse_node_bounds=false (parse bounds from OSM nodes instead of header)
0:00:00 DEB - argument: only_fetch_wikidata=false (fetch wikidata translations then quit)
0:00:00 DEB - argument: fetch_wikidata=false (fetch wikidata translations then continue)
0:00:00 DEB - argument: use_wikidata=true (use wikidata translations)
0:00:00 DEB - argument: wikidata_cache=data/sources/wikidata_names.json (wikidata cache file)
0:00:00 DEB - argument: lake_centerlines_path=data/sources/lake_centerline.shp.zip (lake_centerlines shapefile path)
0:00:00 DEB - argument: free_lake_centerlines_after_read=false (delete lake_centerlines input file after reading to make space for output (reduces peak disk usage))
0:00:00 DEB - argument: water_polygons_path=data/sources/water-polygons-split-3857.zip (water_polygons shapefile path)
0:00:00 DEB - argument: free_water_polygons_after_read=false (delete water_polygons input file after reading to make space for output (reduces peak disk usage))
0:00:00 DEB - argument: natural_earth_path=data/sources/natural_earth_vector.sqlite.zip (natural_earth sqlite db path)
0:00:00 DEB - argument: free_natural_earth_after_read=false (delete natural_earth input file after reading to make space for output (reduces peak disk usage))
0:00:00 DEB - argument: osm_path=data/sources/rhode_island.osm.pbf (osm OSM input file path)
0:00:00 DEB - argument: free_osm_after_read=false (delete osm input file after reading to make space for output (reduces peak disk usage))
0:00:00 DEB - argument: mbtiles=data/out.mbtiles (mbtiles output file)
0:00:00 DEB - argument: transliterate=true (attempt to transliterate latin names)
0:00:00 DEB - argument: languages=am,ar,az,be,bg,br,bs,ca,co,cs,cy,da,de,el,en,eo,es,et,eu,fi,fr,fy,ga,gd,he,hi,hr,hu,hy,id,is,it,ja,ja_kana,ja_rm,ja-Latn,ja-Hira,ka,kk,kn,ko,ko-Latn,ku,la,lb,lt,lv,mk,mt,ml,nl,no,oc,pl,pt,rm,ro,ru,sk,sl,sq,sr,sr-Latn,sv,ta,te,th,tr,uk,zh (languages to use)
0:00:00 DEB - argument: only_layers= (Include only certain layers)
0:00:00 DEB - argument: exclude_layers= (Exclude certain layers)
0:00:00 DEB - argument: boundary_country_names=true (boundary layer: add left/right codes of neighboring countries)
0:00:00 DEB - argument: transportation_z13_paths=false (transportation(_name) layer: show all paths on z13)
0:00:00 DEB - argument: building_merge_z13=true (building layer: merge nearby buildings at z13)
0:00:00 DEB - argument: transportation_name_brunnel=false (transportation_name layer: set to false to omit brunnel and help merge long highways)
0:00:00 DEB - argument: transportation_name_size_for_shield=false (transportation_name layer: allow road names on shorter segments (ie. they will have a shield))
0:00:00 DEB - argument: transportation_name_limit_merge=false (transportation_name layer: limit merge so we don't combine different relations to help merge long highways)
0:00:00 DEB - argument: transportation_name_minor_refs=false (transportation_name layer: include name and refs from minor road networks if not present on a way)
0:00:00 DEB - argument: mbtiles_name=OpenMapTiles ('name' attribute for mbtiles metadata)
0:00:00 DEB - argument: mbtiles_description=A tileset showcasing all layers in OpenMapTiles. https://openmaptiles.org ('description' attribute for mbtiles metadata)
0:00:00 DEB - argument: mbtiles_attribution=<a href="https://www.openmaptiles.org/" target="_blank">&copy; OpenMapTiles</a> <a href="https://www.openstreetmap.org/copyright" target="_blank">&copy; OpenStreetMap contributors</a> ('attribution' attribute for mbtiles metadata)
0:00:00 DEB - argument: mbtiles_version=3.13.1 ('version' attribute for mbtiles metadata)
0:00:00 DEB - argument: mbtiles_type=baselayer ('type' attribute for mbtiles metadata)
0:00:00 DEB - argument: help=false (show arguments then exit)
0:00:00 INF - Building BasemapProfile profile into data/out.mbtiles in these phases:
0:00:00 INF -   lake_centerlines: Process features in data/sources/lake_centerline.shp.zip
0:00:00 INF -   water_polygons: Process features in data/sources/water-polygons-split-3857.zip
0:00:00 INF -   natural_earth: Process features in data/sources/natural_earth_vector.sqlite.zip
0:00:00 INF -   osm_pass1: Pre-process OpenStreetMap input (store node locations then relation members)
0:00:00 INF -   osm_pass2: Process OpenStreetMap nodes, ways, then relations
0:00:00 INF -   sort: Sort rendered features by tile ID
0:00:00 INF -   mbtiles: Encode each tile and write to data/out.mbtiles
0:00:00 INF - no wikidata translations found, run with --fetch-wikidata to download
0:00:00 DEB - ✓ 195M storage on / (/dev/root) requested for read phase disk, 30G available
0:00:00 DEB -  - 43M used for temporary node location cache
0:00:00 DEB -  - 6.6M used for temporary multipolygon geometry cache
0:00:00 DEB -  - 144M used for temporary feature storage
0:00:00 DEB - ✓ 217M storage on / (/dev/root) requested for write phase disk, 30G available
0:00:00 DEB -  - 144M used for temporary feature storage
0:00:00 DEB -  - 72M used for mbtiles output
0:00:00 DEB - ✓ 50M storage on / (/dev/root) requested for read phase, 30G available
0:00:00 DEB -  - 43M used for sparsearray node location cache
0:00:00 DEB -  - 6.6M used for multipolygon way geometries
0:00:00 DEB - ✓ 312M JVM heap requested for read phase, 4.2G available
0:00:00 DEB -  - 300M used for sparsearray node location in-memory index
0:00:00 DEB -  - 12M used for temporary profile storage
0:00:00 DEB - ✓ 50M temporary files and 2.9G of free memory for OS to cache them
0:00:00 INF - Using merge sort feature map, chunk size=1431mb max workers=2
0:00:02 INF - dataFileCache open start
0:00:02 INF [lake_centerlines] - 
0:00:02 INF [lake_centerlines] - Starting...
0:00:05 INF [lake_centerlines] -  read: [  59k 100%  24k/s ] write: [    0    0/s ] 0    
    cpus: 1.9 gc:  3% heap: 159M/4.2G direct: 237k postGC: 74M
    read( -%) ->    (0/1k) -> process( -%  -%) ->   (0/53k) -> write( -%)
0:00:05 INF [lake_centerlines] - Finished in 3s cpu:5s avg:1.9
0:00:05 INF [lake_centerlines] -   read     1x(80% 2s)
0:00:05 INF [lake_centerlines] -   process  2x(14% 0.4s wait:2s)
0:00:05 INF [lake_centerlines] -   write    1x(0% 0s wait:2s)
0:00:05 INF [water_polygons] - 
0:00:05 INF [water_polygons] - Starting...
0:00:15 INF [water_polygons] -  read: [ 1.8k  13%  185/s ] write: [  45k 4.4k/s ] 1.4G 
    cpus: 2 gc: 14% heap: 915M/4.2G direct: 52M postGC: 880M
    read(54%) ->    (0/1k) -> process(12% 45%) -> (1.8k/53k) -> write( 0%)
0:00:25 INF [water_polygons] -  read: [   4k  28%  214/s ] write: [ 230k  18k/s ] 1.4G 
    cpus: 1.7 gc:  9% heap: 2.2G/4.2G direct: 52M postGC: 1.4G
    read(56%) ->    (0/1k) -> process(28% 38%) -> (391/53k) -> write( 0%)
0:00:34 INF [water_polygons] -  read: [  14k 100% 1.1k/s ] write: [ 4.3M 440k/s ] 186M 
    cpus: 1.5 gc:  7% heap: 2.2G/4.2G direct: 52M postGC: 1.6G
    read( -%) ->    (0/1k) -> process( -%  -%) ->   (0/53k) -> write( -%)
0:00:34 INF [water_polygons] - Finished in 29s cpu:51s gc:3s avg:1.7
0:00:34 INF [water_polygons] -   read     1x(57% 17s sys:1s wait:3s)
0:00:34 INF [water_polygons] -   process  2x(30% 9s wait:13s)
0:00:34 INF [water_polygons] -   write    1x(2% 0.7s wait:29s)
0:00:34 INF [natural_earth] - unzipping /home/runner/work/planetiler/planetiler/data/sources/natural_earth_vector.sqlite.zip to data/tmp/natearth.sqlite
0:00:43 INF [natural_earth] - 
0:00:43 INF [natural_earth] - Starting...
0:00:54 INF [natural_earth] -  read: [ 265k  76%  26k/s ] write: [    0    0/s ] 1.6G 
    cpus: 1.5 gc:  1% heap: 2.8G/4.2G direct: 52M postGC: 1.6G
    read(93%) ->   (87/1k) -> process(17% 19%) -> (132/53k) -> write( 0%)
0:00:57 INF [natural_earth] -  read: [ 349k 100%  31k/s ] write: [  181   68/s ] 186M 
    cpus: 1.6 gc:  0% heap: 3.5G/4.2G direct: 52M postGC: 1.6G
    read( -%) ->    (0/1k) -> process( -%  -%) ->   (0/53k) -> write( -%)
0:00:57 INF [natural_earth] - Finished in 14s cpu:21s avg:1.5
0:00:57 INF [natural_earth] -   read     1x(85% 12s sys:2s done:1s)
0:00:57 INF [natural_earth] -   process  2x(18% 2s wait:12s done:1s)
0:00:57 INF [natural_earth] -   write    1x(0% 0s wait:13s done:1s)
0:00:57 INF [osm_pass1] - 
0:00:57 INF [osm_pass1] - Starting...
0:01:02 INF [osm_pass1:process] - Finished nodes: 4,607,020 (1M/s) in 4s cpu:6s avg:1.4
0:01:03 INF [osm_pass1:process] - Finished ways: 333,591 (325k/s) in 1s cpu:2s avg:1.9
0:01:03 INF [osm_pass1:process] - Finished relations: 7,760 (54k/s) in 0.1s cpu:0.3s avg:1.8
0:01:03 INF [osm_pass1] -  nodes: [ 4.6M 815k/s ] 419M  ways: [ 333k  59k/s ] rels: [ 7.7k 1.3k/s ] blocks: [  619  109/s ]
    cpus: 1.5 gc:  3% heap: 871M/4.2G direct: 52M postGC: 829M hppc: 463k
    read( -%) ->     (0/4) -> parse( -%) ->     (0/4) -> process( -%)
0:01:03 DEB [osm_pass1] - Processed 619 blocks:
0:01:03 DEB [osm_pass1] -   nodes: 4,607,020 (1M/s) in 4s cpu:6s avg:1.4
0:01:03 DEB [osm_pass1] -   ways: 333,591 (325k/s) in 1s cpu:2s avg:1.9
0:01:03 DEB [osm_pass1] -   relations: 7,760 (54k/s) in 0.1s cpu:0.3s avg:1.8
0:01:03 INF [osm_pass1] - Finished in 6s cpu:9s avg:1.5
0:01:03 INF [osm_pass1] -   read     1x(2% 0.1s wait:5s)
0:01:03 INF [osm_pass1] -   parse    1x(49% 3s wait:2s)
0:01:03 INF [osm_pass1] -   process  1x(41% 2s wait:2s)
0:01:03 INF [osm_pass2] - 
0:01:03 INF [osm_pass2] - Starting...
0:01:06 DEB [osm_pass2:process] - Sorting long long multimap...
0:01:06 INF [osm_pass2:process] - Finished nodes: 4,607,020 (1.5M/s) in 3s cpu:6s avg:2
0:01:06 DEB [osm_pass2:process] - Sorted long long multimap 0s cpu:0.1s avg:2.1
0:01:06 WAR [osm_pass2:process] - No GB polygon for inferring route network types
0:01:13 INF [osm_pass2] -  nodes: [ 4.6M 100% 460k/s ] 419M  ways: [  86k  26% 8.6k/s ] rels: [    0   0%    0/s ] features: [ 4.7M  40k/s ] 1.6G  blocks: [  586  95%   58/s ]
    cpus: 2 gc:  0% heap: 2.6G/4.2G direct: 52M postGC: 839M relInfo: 412k mpGeoms: 474k 
    read( 0%) ->   (11/13) -> process(64% 61%) -> (1.5k/53k) -> write( 2%)
0:01:23 INF [osm_pass2] -  nodes: [ 4.6M 100%    0/s ] 419M  ways: [ 256k  77%  16k/s ] rels: [    0   0%    0/s ] features: [   5M  36k/s ] 1.6G  blocks: [  607  98%    2/s ]
    cpus: 2 gc:  1% heap: 2G/4.2G direct: 52M postGC: 854M relInfo: 412k mpGeoms: 13M  
    read( -%) ->   (10/13) -> process(75% 82%) -> (993/53k) -> write( 1%)
0:01:27 INF [osm_pass2:process] - Finished ways: 333,591 (15k/s) in 21s cpu:42s avg:2
0:01:33 INF [osm_pass2] -  nodes: [ 4.6M 100%    0/s ] 419M  ways: [ 333k 100% 7.7k/s ] rels: [ 3.6k  47%  366/s ] features: [ 5.2M  18k/s ] 1.6G  blocks: [  618 100%    1/s ]
    cpus: 2 gc:  1% heap: 2.8G/4.2G direct: 52M postGC: 847M relInfo: 412k mpGeoms: 19M  
    read( -%) ->    (0/13) -> process(86% 84%) -> (1.6k/53k) -> write( 1%)
0:01:37 INF [osm_pass2:process] - Finished relations: 7,760 (768/s) in 10s cpu:20s avg:2
0:01:40 INF [osm_pass2] -  nodes: [ 4.6M 100%    0/s ] 419M  ways: [ 333k 100%    0/s ] rels: [ 7.7k 100%  567/s ] features: [ 5.2M 2.7k/s ] 270M  blocks: [  619 100%   <1/s ]
    cpus: 2 gc:  1% heap: 970M/4.2G direct: 52M postGC: 835M relInfo: 412k mpGeoms: 19M  
    read( -%) ->    (0/13) -> process( -%  -%) ->   (0/53k) -> write( -%)
0:01:40 DEB [osm_pass2] - Processed 619 blocks:
0:01:40 DEB [osm_pass2] -   nodes: 4,607,020 (1.5M/s) in 3s cpu:6s avg:2
0:01:40 DEB [osm_pass2] -   ways: 333,591 (15k/s) in 21s cpu:42s avg:2
0:01:40 DEB [osm_pass2] -   relations: 7,760 (768/s) in 10s cpu:20s avg:2
0:01:40 INF [osm_pass2] - Finished in 37s cpu:1m14s avg:2
0:01:40 INF [osm_pass2] -   read     1x(0% 0s wait:20s done:18s)
0:01:40 INF [osm_pass2] -   process  2x(78% 29s)
0:01:40 INF [osm_pass2] -   write    1x(1% 0.4s wait:37s)
0:01:40 INF [boundaries] - 
0:01:40 INF [boundaries] - Starting...
0:01:40 INF [boundaries] - Creating polygons for 1 boundaries
0:01:40 WAR [boundaries] - Unable to form closed polygon for OSM relation 148838 (likely missing edges)
0:01:40 INF [boundaries] - Finished creating 0 country polygons
0:01:40 INF [boundaries] - Finished in 0.1s cpu:0.1s avg:2
0:01:40 INF - Deleting node.db to make room for output file
0:01:40 INF [sort] - 
0:01:40 INF [sort] - Starting...
0:01:40 INF [sort] - Grouped 8 chunks into 1
0:01:43 INF [sort] -  chunks: [   1 /   1 100% ] 270M 
    cpus: 1.3 gc:  0% heap: 1.4G/4.2G direct: 52M postGC: 835M
    ->     (0/3) -> worker(84%)
0:01:43 INF [sort] - Finished in 3s cpu:4s avg:1.3
0:01:43 INF [sort] -   worker  1x(84% 2s)
0:01:43 INF - read:0s write:0s sort:1s
0:01:43 INF [mbtiles] - 
0:01:43 INF [mbtiles] - Starting...
0:01:44 DEB [mbtiles:write] - Execute mbtiles: create table metadata (name text, value text);
0:01:44 DEB [mbtiles:write] - Execute mbtiles: create unique index name on metadata (name);
0:01:44 DEB [mbtiles:write] - Execute mbtiles: create table tiles_shallow (
  zoom_level integer,
  tile_column integer,
  tile_row integer,
  tile_data_id integer

  , primary key(zoom_level,tile_column,tile_row)

) without rowid

0:01:44 DEB [mbtiles:write] - Execute mbtiles: create table tiles_data (
  tile_data_id integer primary key,
  tile_data blob
)

0:01:44 DEB [mbtiles:write] - Execute mbtiles: create view tiles AS
select
  tiles_shallow.zoom_level as zoom_level,
  tiles_shallow.tile_column as tile_column,
  tiles_shallow.tile_row as tile_row,
  tiles_data.tile_data as tile_data
from tiles_shallow
join tiles_data on tiles_shallow.tile_data_id = tiles_data.tile_data_id

0:01:44 DEB [mbtiles:write] - Set mbtiles metadata: name=OpenMapTiles
0:01:44 DEB [mbtiles:write] - Set mbtiles metadata: format=pbf
0:01:44 DEB [mbtiles:write] - Set mbtiles metadata: description=A tileset showcasing all layers in OpenMapTiles. https://openmaptiles.org
0:01:44 DEB [mbtiles:write] - Set mbtiles metadata: attribution=<a href="https://www.openmaptiles.org/" target="_blank">&copy; OpenMapTiles</a> <a href="https://www.openstreetmap.org/copyright" target="_blank">&copy; OpenStreetMap contributors</a>
0:01:44 DEB [mbtiles:write] - Set mbtiles metadata: version=3.13.1
0:01:44 DEB [mbtiles:write] - Set mbtiles metadata: type=baselayer
0:01:44 DEB [mbtiles:write] - Set mbtiles metadata: bounds=-74.07,21.34,-17.84,43.55
0:01:44 DEB [mbtiles:write] - Set mbtiles metadata: center=-45.955,32.445,3
0:01:44 DEB [mbtiles:write] - Set mbtiles metadata: minzoom=0
0:01:44 DEB [mbtiles:write] - Set mbtiles metadata: maxzoom=14
0:01:44 DEB [mbtiles:write] - Set mbtiles metadata: json={"vector_layers":[{"id":"aerodrome_label","fields":{"name_int":"String","iata":"String","ele_ft":"Number","name_de":"String","name":"String","icao":"String","name:en":"String","class":"String","name_en":"String","name:latin":"String","ele":"Number"},"minzoom":10,"maxzoom":14},{"id":"aeroway","fields":{"ref":"String","class":"String"},"minzoom":10,"maxzoom":14},{"id":"boundary","fields":{"disputed":"Number","admin_level":"Number","maritime":"Number"},"minzoom":0,"maxzoom":14},{"id":"building","fields":{"colour":"String","render_height":"Number","render_min_height":"Number"},"minzoom":13,"maxzoom":14},{"id":"housenumber","fields":{"housenumber":"String"},"minzoom":14,"maxzoom":14},{"id":"landcover","fields":{"subclass":"String","class":"String","_numpoints":"Number"},"minzoom":7,"maxzoom":14},{"id":"landuse","fields":{"class":"String"},"minzoom":4,"maxzoom":14},{"id":"mountain_peak","fields":{"name_int":"String","customary_ft":"Number","ele_ft":"Number","name_de":"String","name":"String"... 2244 more characters
0:01:46 INF [mbtiles:write] - Starting z0
0:01:46 INF [mbtiles:write] - Finished z0 in 0s cpu:0s avg:10.3, now starting z1
0:01:46 INF [mbtiles:write] - Finished z1 in 0s cpu:0s avg:0, now starting z2
0:01:46 INF [mbtiles:write] - Finished z2 in 0s cpu:0s avg:0, now starting z3
0:01:46 INF [mbtiles:write] - Finished z3 in 0s cpu:0s avg:0, now starting z4
0:01:46 INF [mbtiles:write] - Finished z4 in 0s cpu:0s avg:0, now starting z5
0:01:46 INF [mbtiles:write] - Finished z5 in 0s cpu:0s avg:0, now starting z6
0:01:46 INF [mbtiles:write] - Finished z6 in 0s cpu:0s avg:0, now starting z7
0:01:46 INF [mbtiles:write] - Finished z7 in 0.6s cpu:1s avg:2, now starting z8
0:01:48 INF [mbtiles:write] - Finished z8 in 2s cpu:3s avg:2, now starting z9
0:01:49 INF [mbtiles:write] - Finished z9 in 1s cpu:3s avg:1.9, now starting z10
0:01:50 INF [mbtiles:write] - Finished z10 in 1s cpu:2s avg:2, now starting z11
0:01:52 INF [mbtiles:write] - Finished z11 in 2s cpu:3s avg:2, now starting z12
0:01:54 INF [mbtiles] -  features: [ 298k   6%  29k/s ] 270M  tiles: [  90k   9k/s ] 9.1M 
    cpus: 2 gc:  3% heap: 1.7G/4.2G direct: 52M postGC: 1.4G
    read( 2%) -> (214/217) -> encode(62% 58%) -> (215/216) -> write( 3%)
    last tile: 12/1291/1501 (z12 13%) https://www.openstreetmap.org/#map=12/43.26121/-66.53320
0:01:55 INF [mbtiles:write] - Finished z12 in 3s cpu:6s avg:2, now starting z13
0:02:04 INF [mbtiles] -  features: [ 736k  14%  43k/s ] 270M  tiles: [ 291k  20k/s ] 13M  
    cpus: 2 gc:  2% heap: 2.5G/4.2G direct: 52M postGC: 1.4G
    read( 1%) -> (214/217) -> encode(61% 62%) -> (215/216) -> write( 4%)
    last tile: 13/2470/3047 (z13 5%) https://www.openstreetmap.org/#map=13/41.80408/-71.45508
0:02:10 INF [mbtiles:write] - Finished z13 in 15s cpu:29s avg:2, now starting z14
0:02:14 INF [mbtiles] -  features: [ 3.3M  63% 261k/s ] 270M  tiles: [   2M 172k/s ] 72M  
    cpus: 2 gc:  2% heap: 3.1G/4.2G direct: 52M postGC: 1.4G
    read( 4%) ->   (0/217) -> encode(61% 63%) -> (215/216) -> write(34%)
    last tile: 14/5649/6142 (z14 32%) https://www.openstreetmap.org/#map=14/41.01307/-55.87646
0:02:18 DEB [mbtiles:write] - Shallow tiles written: 4,115,450
0:02:18 DEB [mbtiles:write] - Tile data written: 21,280 (99% omitted)
0:02:18 DEB [mbtiles:write] - Unique tile hashes: 11,273
0:02:18 INF [mbtiles:write] - Finished z14 in 8s cpu:15s avg:1.9
0:02:18 INF [mbtiles] -  features: [ 5.2M 100% 455k/s ] 270M  tiles: [ 4.1M 491k/s ] 108M 
    cpus: 1.8 gc:  1% heap: 3G/4.2G direct: 52M postGC: 1.4G
    read( -%) ->   (0/217) -> encode( -%  -%) ->   (0/216) -> write( -%)
    last tile: 14/7380/5985 (z14 100%) https://www.openstreetmap.org/#map=14/43.56447/-17.84180
0:02:18 DEB [mbtiles] - Tile stats:
0:02:18 DEB [mbtiles] - z0 avg:7.9k max:7.9k
0:02:18 DEB [mbtiles] - z1 avg:4k max:4k
0:02:18 DEB [mbtiles] - z2 avg:9.4k max:9.4k
0:02:18 DEB [mbtiles] - z3 avg:3.9k max:6.4k
0:02:18 DEB [mbtiles] - z4 avg:1.6k max:4.6k
0:02:18 DEB [mbtiles] - z5 avg:1.4k max:8.1k
0:02:18 DEB [mbtiles] - z6 avg:973 max:22k
0:02:18 DEB [mbtiles] - z7 avg:751 max:55k
0:02:18 DEB [mbtiles] - z8 avg:395 max:112k
0:02:18 DEB [mbtiles] - z9 avg:270 max:278k
0:02:18 DEB [mbtiles] - z10 avg:154 max:233k
0:02:18 DEB [mbtiles] - z11 avg:102 max:132k
0:02:18 DEB [mbtiles] - z12 avg:83 max:119k
0:02:18 DEB [mbtiles] - z13 avg:71 max:109k
0:02:18 DEB [mbtiles] - z14 avg:67 max:277k
0:02:18 DEB [mbtiles] - all avg:69 max:0
0:02:18 DEB [mbtiles] -  # features: 5,296,447
0:02:18 DEB [mbtiles] -     # tiles: 4,115,450
0:02:18 INF [mbtiles] - Finished in 34s cpu:1m7s avg:2
0:02:18 INF [mbtiles] -   read    1x(3% 1s wait:33s)
0:02:18 INF [mbtiles] -   encode  2x(58% 20s wait:2s)
0:02:18 INF [mbtiles] -   write   1x(24% 8s wait:24s)
0:02:18 INF - Finished in 2m18s cpu:4m2s gc:5s avg:1.8
0:02:18 INF - FINISHED!
0:02:18 INF - 
0:02:18 INF - ----------------------------------------
0:02:18 INF - 	overall          2m18s cpu:4m2s gc:5s avg:1.8
0:02:18 INF - 	lake_centerlines 3s cpu:5s avg:1.9
0:02:18 INF - 	  read     1x(80% 2s)
0:02:18 INF - 	  process  2x(14% 0.4s wait:2s)
0:02:18 INF - 	  write    1x(0% 0s wait:2s)
0:02:18 INF - 	water_polygons   29s cpu:51s gc:3s avg:1.7
0:02:18 INF - 	  read     1x(57% 17s sys:1s wait:3s)
0:02:18 INF - 	  process  2x(30% 9s wait:13s)
0:02:18 INF - 	  write    1x(2% 0.7s wait:29s)
0:02:18 INF - 	natural_earth    14s cpu:21s avg:1.5
0:02:18 INF - 	  read     1x(85% 12s sys:2s done:1s)
0:02:18 INF - 	  process  2x(18% 2s wait:12s done:1s)
0:02:18 INF - 	  write    1x(0% 0s wait:13s done:1s)
0:02:18 INF - 	osm_pass1        6s cpu:9s avg:1.5
0:02:18 INF - 	  read     1x(2% 0.1s wait:5s)
0:02:18 INF - 	  parse    1x(49% 3s wait:2s)
0:02:18 INF - 	  process  1x(41% 2s wait:2s)
0:02:18 INF - 	osm_pass2        37s cpu:1m14s avg:2
0:02:18 INF - 	  read     1x(0% 0s wait:20s done:18s)
0:02:18 INF - 	  process  2x(78% 29s)
0:02:18 INF - 	  write    1x(1% 0.4s wait:37s)
0:02:18 INF - 	boundaries       0.1s cpu:0.1s avg:2
0:02:18 INF - 	sort             3s cpu:4s avg:1.3
0:02:18 INF - 	  worker  1x(84% 2s)
0:02:18 INF - 	mbtiles          34s cpu:1m7s avg:2
0:02:18 INF - 	  read    1x(3% 1s wait:33s)
0:02:18 INF - 	  encode  2x(58% 20s wait:2s)
0:02:18 INF - 	  write   1x(24% 8s wait:24s)
0:02:18 INF - ----------------------------------------
0:02:18 INF - 	features	270MB
0:02:18 INF - 	mbtiles	108MB
-rw-r--r-- 1 runner docker 56M Jul 28 11:05 run.jar