[OSM-dev] Problems with mod_tile + tirex

[Valery N.]

Hi, community 

I assume that such requests is quite often in your maillist and you have strong protection from it :) But you my last hope how to solve issue: 

I have successfull install under Ubuntu 10.04: 

Mapnik2 + Tirex + Mod_tile,  but for some reason there is no tiles displayed on http request: 

Tirex-master log: 

user@optiplex:~$ tirex-master -d

tirex-master[1492]: tirex-master started with cmd line options: -d

tirex-master[1492]: Config backend_manager_alive_timeout=8

tirex-master[1492]: Config backend_manager_pidfile=/var/run/tirex/tirex-backend-manager.pid

tirex-master[1492]: Config backend_manager_syslog_facility=daemon

tirex-master[1492]: Config bucket=[{maxload=20 maxproc=4 minprio=1 name=live},{maxload=8 maxproc=3 minprio=10 name=important},{maxload=4 maxproc=2 minprio=20 name=background}]

tirex-master[1492]: Config master_logfile=/var/log/tirex/jobs.log

tirex-master[1492]: Config master_pidfile=/var/run/tirex/tirex-master.pid

tirex-master[1492]: Config master_syslog_facility=daemon

tirex-master[1492]: Config modtile_socket_name=/var/lib/tirex/modtile.sock

tirex-master[1492]: Config socket_dir=/var/run/tirex

tirex-master[1492]: Config stats_dir=/var/lib/tirex/stats

tirex-master[1492]: Renderer mapnik: port=9331 procs=3 path=/usr/lib/tirex/backends/mapnik syslog_facility=daemon debug=1 fontdir=/usr/local/lib/mapnik/fonts plugindir=/usr/local/lib/mapnik/input

tirex-master[1492]:   Map mapnik: renderer=mapnik tiledir=/var/lib/tirex/tiles/mapnik zoom=0-14 mapfile=/usr/share/mapnik/osm.xml

tirex-master[1492]: Listening for commands on socket /var/run/tirex/master.sock

tirex-master[1492]: Listening for mod_tile connections on /var/lib/tirex/modtile.sock (UNIX)

tirex-master[1492]: Listening for backend responses

tirex-master[1492]: connection from mod_tile accepted

tirex-master[1492]: read request from mod_tile: ver=2 cmd=5 x=1 y=1 z=1 map=mapnik

tirex-master[1492]: request rendering of job id=1332442501_19889544 prio=1 map=mapnik x=0 y=0 z=1

tirex-master[1492]: sending request to port 9331 id=1332442501_19889544 prio=1 map=mapnik x=0 y=0 z=1

tirex-master[1492]: connection from mod_tile accepted

tirex-master[1492]: read request from mod_tile: ver=2 cmd=5 x=0 y=1 z=1 map=mapnik

tirex-master[1492]: connection from mod_tile accepted

tirex-master[1492]: read request from mod_tile: ver=2 cmd=5 x=0 y=0 z=1 map=mapnik

tirex-master[1492]: connection from mod_tile accepted

tirex-master[1492]: read request from mod_tile: ver=2 cmd=5 x=1 y=0 z=1 map=mapnik

tirex-master[1492]: other side closed mod_tile socket 8

tirex-master[1492]: other side closed mod_tile socket 9

tirex-master[1492]: other side closed mod_tile socket 10

tirex-master[1492]: other side closed mod_tile socket 11

tirex-master[1492]: job rendering done id=1332442501_19889544 map=mapnik x=0 y=0 z=1

Ok, looks like no errors!

In same time tirex-backend show next: 

user@optiplex:~$ tirex-backend-manager -d

tirex-backend-manager[1968]: tirex-backend-manager started with cmd line options: -d

tirex-backend-manager[1968]: Config backend_manager_alive_timeout=8

tirex-backend-manager[1968]: Config backend_manager_pidfile=/var/run/tirex/tirex-backend-manager.pid

tirex-backend-manager[1968]: Config backend_manager_syslog_facility=daemon

tirex-backend-manager[1968]: Config bucket=[{maxload=20 maxproc=4 minprio=1 name=live},{maxload=8 maxproc=3 minprio=10 name=important},{maxload=4 maxproc=2 minprio=20 name=background}]

tirex-backend-manager[1968]: Config master_logfile=/var/log/tirex/jobs.log

tirex-backend-manager[1968]: Config master_pidfile=/var/run/tirex/tirex-master.pid

tirex-backend-manager[1968]: Config master_syslog_facility=daemon

tirex-backend-manager[1968]: Config modtile_socket_name=/var/lib/tirex/modtile.sock

tirex-backend-manager[1968]: Config socket_dir=/var/run/tirex

tirex-backend-manager[1968]: Config stats_dir=/var/lib/tirex/stats

tirex-backend-manager[1968]: Found config for renderers: mapnik

tirex-backend-manager[1968]: opened port 9331 for renderer 'mapnik'

tirex-backend-manager[1968]: renderer mapnik started with pid 1969

tirex-backend-manager[1968]: renderer mapnik started with pid 1970

tirex-backend-manager[1968]: renderer mapnik started with pid 1971

tirex-backend-mapnik[1971]: Renderer started (name=mapnik)

tirex-backend-mapnik[1970]: Renderer started (name=mapnik)

tirex-backend-mapnik[1969]: Renderer started (name=mapnik)

tirex-backend-mapnik[1971]: added style 'mapnik' from map /etc/tirex/renderer/mapnik/example.conf

tirex-backend-mapnik[1971]: using existing socket 5

tirex-backend-mapnik[1969]: added style 'mapnik' from map /etc/tirex/renderer/mapnik/example.conf

tirex-backend-mapnik[1969]: using existing socket 5

tirex-backend-mapnik[1970]: added style 'mapnik' from map /etc/tirex/renderer/mapnik/example.conf

tirex-backend-mapnik[1970]: using existing socket 5

tirex-backend-mapnik[1970]: read: id=1332442652_22071328

map=mapnik

prio=1

type=metatile_render_request

x=0

y=0

z=1

tirex-backend-mapnik[1970]: >> NetworkMessage::parse

tirex-backend-mapnik[1970]: << NetworkMessage::parse

tirex-backend-mapnik[1970]: >> MetatileHandler::handleRequest

tirex-backend-mapnik[1970]: >> MetatileHandler::render

tirex-backend-mapnik[1970]: rendering area -20037508.342789,-60112525.028368 - 60112525.028368,20037508.342789 in SRS 3857 to 1024x1024 px

tirex-backend-mapnik[1970]: width: 1024, height:1024

tirex-backend-mapnik[1970]: << MetatileHandler::render

tirex-backend-mapnik[1970]: created /var/lib/tirex/tiles/mapnik/1/0/0/0/0/0.meta

tirex-backend-mapnik[1970]: << MetatileHandler::handleRequest

tirex-backend-mapnik[1970]: >> NetworkMessage::build

tirex-backend-mapnik[1970]: << NetworkMessage::build

tirex-backend-mapnik[1970]: sending: id=1332442652_22071328

map=mapnik

metatile=/var/lib/tirex/tiles/mapnik/1/0/0/0/0/0.meta

render_time=4562

result=ok

type=metatile_render_request

x=0

y=0

z=1

ok, so looks there is all fine with rendering 

next is Apache logs: 

[Thu Mar 22 20:59:08 2012] [debug] ./mod_tile.c(909): [client 87.252.227.84] tile_translate: uri(/)

[Thu Mar 22 20:59:08 2012] [debug] ./mod_tile.c(934): [client 87.252.227.84] tile_translate: testing baseuri(/tiles/mapnik/) name(mapnik) extension(png)

[Thu Mar 22 20:59:08 2012] [debug] ./mod_tile.c(1000): [client 87.252.227.84] tile_translate: No suitable tile layer found

[Thu Mar 22 20:59:08 2012] [debug] ./mod_tile.c(909): [client 87.252.227.84] tile_translate: uri(/index.html)

[Thu Mar 22 20:59:08 2012] [debug] ./mod_tile.c(934): [client 87.252.227.84] tile_translate: testing baseuri(/tiles/mapnik/) name(mapnik) extension(png)

[Thu Mar 22 20:59:08 2012] [debug] ./mod_tile.c(1000): [client 87.252.227.84] tile_translate: No suitable tile layer found

[Thu Mar 22 20:59:08 2012] [debug] mod_deflate.c(615): [client 87.252.227.84] Zlib: Compressed 1453 to 570 : URL /index.html

[Thu Mar 22 20:59:25 2012] [debug] ./mod_tile.c(909): [client 87.252.227.84] tile_translate: uri(/tiles/mapnik/1/1/1.png), referer: http://mapserv.test.maps.local/

[Thu Mar 22 20:59:25 2012] [debug] ./mod_tile.c(934): [client 87.252.227.84] tile_translate: testing baseuri(/tiles/mapnik/) name(mapnik) extension(png), referer: http://mapserv.test.maps.local/

[Thu Mar 22 20:59:25 2012] [debug] ./mod_tile.c(994): [client 87.252.227.84] tile_translate: op(tile_serve) xml(mapnik) mime(image/png) z(1) x(1) y(1), referer: http://mapserv.test.maps.local/

[Thu Mar 22 20:59:25 2012] [info] [client 87.252.227.84] tile_storage_hook: handler(tile_serve), uri(/tiles/mapnik/1/1/1.png), filename(/var/lib/mod_tile/mapnik/1/0/0/0/0/0.meta), path_info((null)), referer: http://mapserv.test.maps.local/

[Thu Mar 22 20:59:25 2012] [info] [client 87.252.227.84] Requesting style(mapnik) z(1) x(1) y(1) from renderer with priority 5, referer: http://mapserv.test.maps.local/

[Thu Mar 22 20:59:25 2012] [debug] ./mod_tile.c(909): [client 87.252.227.84] tile_translate: uri(/tiles/mapnik/1/0/1.png), referer: http://mapserv.test.maps.local/

[Thu Mar 22 20:59:25 2012] [debug] ./mod_tile.c(934): [client 87.252.227.84] tile_translate: testing baseuri(/tiles/mapnik/) name(mapnik) extension(png), referer: http://mapserv.test.maps.local/

[Thu Mar 22 20:59:25 2012] [debug] ./mod_tile.c(994): [client 87.252.227.84] tile_translate: op(tile_serve) xml(mapnik) mime(image/png) z(1) x(0) y(1), referer: http://mapserv.test.maps.local/

[Thu Mar 22 20:59:25 2012] [info] [client 87.252.227.84] tile_storage_hook: handler(tile_serve), uri(/tiles/mapnik/1/0/1.png), filename(/var/lib/mod_tile/mapnik/1/0/0/0/0/0.meta), path_info((null)), referer: http://mapserv.test.maps.local/

[Thu Mar 22 20:59:25 2012] [info] [client 87.252.227.84] Requesting style(mapnik) z(1) x(0) y(1) from renderer with priority 5, referer: http://mapserv.test.maps.local/

[Thu Mar 22 20:59:25 2012] [debug] ./mod_tile.c(909): [client 87.252.227.84] tile_translate: uri(/tiles/mapnik/1/0/0.png), referer: http://mapserv.test.maps.local/

[Thu Mar 22 20:59:25 2012] [debug] ./mod_tile.c(934): [client 87.252.227.84] tile_translate: testing baseuri(/tiles/mapnik/) name(mapnik) extension(png), referer: http://mapserv.test.maps.local/

[Thu Mar 22 20:59:25 2012] [debug] ./mod_tile.c(994): [client 87.252.227.84] tile_translate: op(tile_serve) xml(mapnik) mime(image/png) z(1) x(0) y(0), referer: http://mapserv.test.maps.local/

[Thu Mar 22 20:59:25 2012] [info] [client 87.252.227.84] tile_storage_hook: handler(tile_serve), uri(/tiles/mapnik/1/0/0.png), filename(/var/lib/mod_tile/mapnik/1/0/0/0/0/0.meta), path_info((null)), referer: http://mapserv.test.maps.local/

[Thu Mar 22 20:59:25 2012] [info] [client 87.252.227.84] Requesting style(mapnik) z(1) x(0) y(0) from renderer with priority 5, referer: http://mapserv.test.maps.local/

[Thu Mar 22 20:59:25 2012] [debug] ./mod_tile.c(909): [client 87.252.227.84] tile_translate: uri(/tiles/mapnik/1/1/0.png), referer: http://mapserv.test.maps.local/

[Thu Mar 22 20:59:25 2012] [debug] ./mod_tile.c(934): [client 87.252.227.84] tile_translate: testing baseuri(/tiles/mapnik/) name(mapnik) extension(png), referer: http://mapserv.test.maps.local/

[Thu Mar 22 20:59:25 2012] [debug] ./mod_tile.c(994): [client 87.252.227.84] tile_translate: op(tile_serve) xml(mapnik) mime(image/png) z(1) x(1) y(0), referer: http://mapserv.test.maps.local/

[Thu Mar 22 20:59:25 2012] [info] [client 87.252.227.84] tile_storage_hook: handler(tile_serve), uri(/tiles/mapnik/1/1/0.png), filename(/var/lib/mod_tile/mapnik/1/0/0/0/0/0.meta), path_info((null)), referer: http://mapserv.test.maps.local/

[Thu Mar 22 20:59:25 2012] [info] [client 87.252.227.84] Requesting style(mapnik) z(1) x(1) y(0) from renderer with priority 5, referer: http://mapserv.test.maps.local/

[Thu Mar 22 20:59:25 2012] [debug] ./mod_tile.c(909): [client 87.252.227.84] tile_translate: uri(/tiles/mapnik/1/0/2.png), referer: http://mapserv.test.maps.local/

[Thu Mar 22 20:59:25 2012] [debug] ./mod_tile.c(934): [client 87.252.227.84] tile_translate: testing baseuri(/tiles/mapnik/) name(mapnik) extension(png), referer: http://mapserv.test.maps.local/

[Thu Mar 22 20:59:25 2012] [debug] ./mod_tile.c(963): [client 87.252.227.84] tile_translate: request for mapnik was outside of allowed bounds, referer: http://mapserv.test.maps.local/

[Thu Mar 22 20:59:25 2012] [debug] ./mod_tile.c(909): [client 87.252.227.84] tile_translate: uri(/tiles/mapnik/1/1/2.png), referer: http://mapserv.test.maps.local/

[Thu Mar 22 20:59:25 2012] [debug] ./mod_tile.c(934): [client 87.252.227.84] tile_translate: testing baseuri(/tiles/mapnik/) name(mapnik) extension(png), referer: http://mapserv.test.maps.local/

[Thu Mar 22 20:59:25 2012] [debug] ./mod_tile.c(963): [client 87.252.227.84] tile_translate: request for mapnik was outside of allowed bounds, referer: http://mapserv.test.maps.local/

[Thu Mar 22 20:59:28 2012] [debug] mod_deflate.c(615): [client 87.252.227.84] Zlib: Compressed 305 to 229 : URL /tiles/mapnik/1/1/1.png, referer: http://mapserv.test.maps.local/

[Thu Mar 22 20:59:28 2012] [debug] ./mod_tile.c(909): [client 87.252.227.84] tile_translate: uri(/tiles/mapnik/1/1/-1.png), referer: http://mapserv.test.maps.local/

[Thu Mar 22 20:59:28 2012] [debug] ./mod_tile.c(934): [client 87.252.227.84] tile_translate: testing baseuri(/tiles/mapnik/) name(mapnik) extension(png), referer: http://mapserv.test.maps.local/

[Thu Mar 22 20:59:28 2012] [debug] ./mod_tile.c(963): [client 87.252.227.84] tile_translate: request for mapnik was outside of allowed bounds, referer: http://mapserv.test.maps.local/

[Thu Mar 22 20:59:28 2012] [debug] mod_deflate.c(615): [client 87.252.227.84] Zlib: Compressed 305 to 230 : URL /tiles/mapnik/1/0/1.png, referer: http://mapserv.test.maps.local/

[Thu Mar 22 20:59:28 2012] [debug] mod_deflate.c(615): [client 87.252.227.84] Zlib: Compressed 305 to 230 : URL /tiles/mapnik/1/0/0.png, referer: http://mapserv.test.maps.local/

[Thu Mar 22 20:59:28 2012] [debug] mod_deflate.c(615): [client 87.252.227.84] Zlib: Compressed 305 to 229 : URL /tiles/mapnik/1/0/2.png, referer: http://mapserv.test.maps.local/

[Thu Mar 22 20:59:28 2012] [debug] mod_deflate.c(615): [client 87.252.227.84] Zlib: Compressed 305 to 230 : URL /tiles/mapnik/1/1/0.png, referer: http://mapserv.test.maps.local/

[Thu Mar 22 20:59:28 2012] [debug] mod_deflate.c(615): [client 87.252.227.84] Zlib: Compressed 305 to 229 : URL /tiles/mapnik/1/1/2.png, referer: http://mapserv.test.maps.local/

[Thu Mar 22 20:59:28 2012] [debug] ./mod_tile.c(909): [client 87.252.227.84] tile_translate: uri(/tiles/mapnik/1/0/-1.png), referer: http://mapserv.test.maps.local/

[Thu Mar 22 20:59:28 2012] [debug] ./mod_tile.c(934): [client 87.252.227.84] tile_translate: testing baseuri(/tiles/mapnik/) name(mapnik) extension(png), referer: http://mapserv.test.maps.local/

[Thu Mar 22 20:59:28 2012] [debug] ./mod_tile.c(963): [client 87.252.227.84] tile_translate: request for mapnik was outside of allowed bounds, referer: http://mapserv.test.maps.local/

[Thu Mar 22 20:59:31 2012] [debug] mod_deflate.c(615): [client 87.252.227.84] Zlib: Compressed 306 to 231 : URL /tiles/mapnik/1/1/-1.png, referer: http://mapserv.test.maps.local/

[Thu Mar 22 20:59:31 2012] [debug] mod_deflate.c(615): [client 87.252.227.84] Zlib: Compressed 306 to 230 : URL /tiles/mapnik/1/0/-1.png, referer: http://mapserv.test.maps.local/

[Thu Mar 22 20:59:31 2012] [debug] ./mod_tile.c(909): [client 87.252.227.84] tile_translate: uri(/favicon.ico)

[Thu Mar 22 20:59:31 2012] [debug] ./mod_tile.c(934): [client 87.252.227.84] tile_translate: testing baseuri(/tiles/mapnik/) name(mapnik) extension(png)

[Thu Mar 22 20:59:31 2012] [debug] ./mod_tile.c(1000): [client 87.252.227.84] tile_translate: No suitable tile layer found

For some unknown reasons request like http://mapserv.test.maps.local/tiles/mapnik/1/1/-1.png raise 404 error on web server

Disabling mod_deflate is not influe on result 

Maybe you face such situation and have ready advice

Thanks and have a nice day!

[Kai Krueger]

Valery N. wrote

>
> For some unknown reasons request like

> http://mapserv.test.maps.local/tiles/mapnik/1/1/-1.png raise* 404 error*
> on
> web server
>
Well, that is not a valid request. A negative y coordinate is not allowed
and so it will correctly give a 404 error.

Also the rest of you mod_tile log seems fine and gives the expected result.
It will correctly mention "no valid tile layer" for request uri's like
"/favicon.ico" or "/index.html", and fall through to normal serving of those
files.

Have you tried waiting for a while and then reloading the tile. At low zoom
levels, rendering tiles can take several minutes and mod_tile will time out
before it is finished rendering. The next time it will then hopefully get
the rendered tile from cache.

Kai

--
View this message in context: http://gis.19327.n5.nabble.com/Problems-with-mod-tile-tirex-tp5587540p5588086.html
Sent from the Developer Discussion mailing list archive at Nabble.com.

_______________________________________________
dev mailing list
d...@openstreetmap.org
http://lists.openstreetmap.org/listinfo/dev

[Valery N.]

Hi, Kai

thank you for answer

I also try valid links like /tiles/mapnik/14/9464/5270.png but result the same - 404 

[Fri Mar 23 07:33:18 2012] [debug] ./mod_tile.c(994): [client 87.252.227.84] tile_translate: op(tile_serve) xml(mapnik) mime(image/png) z(14) x(9464) y(5270), referer: http://mapserv.test.maps.local/

[Fri Mar 23 07:33:18 2012] [info] [client 87.252.227.84] tile_storage_hook: handler(tile_serve), uri(/tiles/mapnik/14/9464/5270.png), filename(/var/lib/mod_tile/tiles/mapnik/14/0/33/68/249/128.meta), path_in

[Fri Mar 23 07:33:18 2012] [debug] ./mod_tile.c(849): [client 87.252.227.84] tile_handler_serve: xml(mapnik) z(14) x(9464) y(5270), referer: http://mapserv.test.maps.local/

[Fri Mar 23 07:33:20 2012] [debug] ./mod_tile.c(909): [client 87.252.227.84] tile_translate: uri(/tiles/mapnik/14/9463/5270.png), referer: http://mapserv.test.maps.local/

[Fri Mar 23 07:33:20 2012] [debug] ./mod_tile.c(934): [client 87.252.227.84] tile_translate: testing baseuri(/tiles/mapnik/) name(mapnik) extension(png), referer: http://mapserv.test.maps.local/

[Fri Mar 23 07:33:20 2012] [debug] ./mod_tile.c(994): [client 87.252.227.84] tile_translate: op(tile_serve) xml(mapnik) mime(image/png) z(14) x(9463) y(5270), referer: http://mapserv.test.maps.local/

is it so, that according debug info in folder /var/lib/mod_tile/tiles/mapnik/14/0/33/68/249/ should be only files with .meta extension ? 

user@optiplex:/var/log/apache2$ ls -la /var/lib/mod_tile/tiles/mapnik/14/0/33/68/249/

total 1680

drwxr-xr-x 2 user user   4096 2012-03-23 07:33 .

drwxr-xr-x 3 user user   4096 2012-03-23 07:33 ..

-rw-r--r-- 1 user user 558007 2012-03-23 07:33 0.meta

-rw-r--r-- 1 user user 379366 2012-03-23 07:33 128.meta

-rw-r--r-- 1 user user 373268 2012-03-23 07:33 136.meta

-rw-r--r-- 1 user user 392739 2012-03-23 07:33 8.meta

So according all logs - all fine, but I recieve 404 :( 

2012/3/23 Kai Krueger <kakr...@gmail.com>

[Kai Krueger]

On 03/23/2012 01:49 AM, Valery N. wrote:
>
> So according all logs - all fine, but I recieve 404 :(

I have committed a few more debug messages for the logs on the serving
path. Could you download the latest svn and recompile?

Kai

>
> 2012/3/23 Kai Krueger <kakr...@gmail.com <mailto:kakr...@gmail.com>>

> d...@openstreetmap.org <mailto:d...@openstreetmap.org>
> http://lists.openstreetmap.org/listinfo/dev