src/lib/server.cc

   1 /*
   2     Copyright (C) 2012-2014 Carl Hetherington <cth@carlh.net>
   3
   4     This program is free software; you can redistribute it and/or modify
   5     it under the terms of the GNU General Public License as published by
   6     the Free Software Foundation; either version 2 of the License, or
   7     (at your option) any later version.
   8
   9     This program is distributed in the hope that it will be useful,
  10     but WITHOUT ANY WARRANTY; without even the implied warranty of
  11     MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE.  See the
  12     GNU General Public License for more details.
  13
  14     You should have received a copy of the GNU General Public License
  15     along with this program; if not, write to the Free Software
  16     Foundation, Inc., 675 Mass Ave, Cambridge, MA 02139, USA.
  17
  18 */
  19
  20 /** @file src/server.cc
  21  *  @brief Class to describe a server to which we can send
  22  *  encoding work, and a class to implement such a server.
  23  */
  24
  25 #include <string>
  26 #include <vector>
  27 #include <sstream>
  28 #include <iostream>
  29 #include <boost/algorithm/string.hpp>
  30 #include <boost/scoped_array.hpp>
  31 #include <libcxml/cxml.h>
  32 #include <libdcp/raw_convert.h>
  33 #include "server.h"
  34 #include "util.h"
  35 #include "scaler.h"
  36 #include "image.h"
  37 #include "dcp_video_frame.h"
  38 #include "config.h"
  39 #include "cross.h"
  40 #include "player_video_frame.h"
  41
  42 #include "i18n.h"
  43
  44 #define LOG_GENERAL(...) _log->microsecond_log (String::compose (__VA_ARGS__), Log::GENERAL);
  45 #define LOG_GENERAL_NC(...) _log->microsecond_log (__VA_ARGS__, Log::GENERAL);
  46 #define LOG_ERROR(...) _log->microsecond_log (String::compose (__VA_ARGS__), Log::ERROR);
  47 #define LOG_ERROR_NC(...) _log->microsecond_log (__VA_ARGS__, Log::ERROR);
  48
  49 using std::string;
  50 using std::stringstream;
  51 using std::multimap;
  52 using std::vector;
  53 using std::list;
  54 using std::cout;
  55 using std::cerr;
  56 using std::setprecision;
  57 using std::fixed;
  58 using boost::shared_ptr;
  59 using boost::algorithm::is_any_of;
  60 using boost::algorithm::split;
  61 using boost::thread;
  62 using boost::bind;
  63 using boost::scoped_array;
  64 using boost::optional;
  65 using libdcp::Size;
  66 using libdcp::raw_convert;
  67
  68 Server::Server (shared_ptr<Log> log, bool verbose)
  69         : _log (log)
  70         , _verbose (verbose)
  71 {
  72
  73 }
  74
  75 /** @param after_read Filled in with gettimeofday() after reading the input from the network.
  76  *  @param after_encode Filled in with gettimeofday() after encoding the image.
  77  */
  78 int
  79 Server::process (shared_ptr<Socket> socket, struct timeval& after_read, struct timeval& after_encode)
  80 {
  81         uint32_t length = socket->read_uint32 ();
  82         scoped_array<char> buffer (new char[length]);
  83         socket->read (reinterpret_cast<uint8_t*> (buffer.get()), length);
  84
  85         stringstream s (buffer.get());
  86         shared_ptr<cxml::Document> xml (new cxml::Document ("EncodingRequest"));
  87         xml->read_stream (s);
  88         if (xml->number_child<int> ("Version") != SERVER_LINK_VERSION) {
  89                 cerr << "Mismatched server/client versions\n";
  90                 LOG_ERROR_NC ("Mismatched server/client versions");
  91                 return -1;
  92         }
  93
  94         shared_ptr<PlayerVideoFrame> pvf (new PlayerVideoFrame (xml, socket, _log));
  95
  96         DCPVideoFrame dcp_video_frame (pvf, xml, _log);
  97
  98         gettimeofday (&after_read, 0);
  99
 100         shared_ptr<EncodedData> encoded = dcp_video_frame.encode_locally ();
 101
 102         gettimeofday (&after_encode, 0);
 103
 104         try {
 105                 encoded->send (socket);
 106         } catch (std::exception& e) {
 107                 LOG_ERROR ("Send failed; frame %1", dcp_video_frame.index());
 108                 throw;
 109         }
 110
 111         return dcp_video_frame.index ();
 112 }
 113
 114 void
 115 Server::worker_thread ()
 116 {
 117         while (1) {
 118                 boost::mutex::scoped_lock lock (_worker_mutex);
 119                 while (_queue.empty ()) {
 120                         _worker_condition.wait (lock);
 121                 }
 122
 123                 shared_ptr<Socket> socket = _queue.front ();
 124                 _queue.pop_front ();
 125
 126                 lock.unlock ();
 127
 128                 int frame = -1;
 129                 string ip;
 130
 131                 struct timeval start;
 132                 struct timeval after_read;
 133                 struct timeval after_encode;
 134                 struct timeval end;
 135
 136                 gettimeofday (&start, 0);
 137
 138                 try {
 139                         frame = process (socket, after_read, after_encode);
 140                         ip = socket->socket().remote_endpoint().address().to_string();
 141                 } catch (std::exception& e) {
 142                         LOG_ERROR ("Error: %1", e.what());
 143                 }
 144
 145                 gettimeofday (&end, 0);
 146
 147                 socket.reset ();
 148
 149                 lock.lock ();
 150
 151                 if (frame >= 0) {
 152                         struct timeval end;
 153                         gettimeofday (&end, 0);
 154
 155                         stringstream message;
 156                         message.precision (2);
 157                         message << fixed
 158                                 << "Encoded frame " << frame << " from " << ip << ": "
 159                                 << "receive " << (seconds(after_read) - seconds(start)) << "s "
 160                                 << "encode " << (seconds(after_encode) - seconds(after_read)) << "s "
 161                                 << "send " << (seconds(end) - seconds(after_encode)) << "s.";
 162
 163                         if (_verbose) {
 164                                 cout << message.str() << "\n";
 165                         }
 166
 167                         LOG_GENERAL_NC (message.str ());
 168                 }
 169
 170                 _worker_condition.notify_all ();
 171         }
 172 }
 173
 174 void
 175 Server::run (int num_threads)
 176 {
 177         LOG_GENERAL ("Server starting with %1 threads", num_threads);
 178         if (_verbose) {
 179                 cout << "DCP-o-matic server starting with " << num_threads << " threads.\n";
 180         }
 181
 182         for (int i = 0; i < num_threads; ++i) {
 183                 _worker_threads.push_back (new thread (bind (&Server::worker_thread, this)));
 184         }
 185
 186         _broadcast.thread = new thread (bind (&Server::broadcast_thread, this));
 187
 188         boost::asio::io_service io_service;
 189
 190         boost::asio::ip::tcp::acceptor acceptor (
 191                 io_service,
 192                 boost::asio::ip::tcp::endpoint (boost::asio::ip::tcp::v4(), Config::instance()->server_port_base ())
 193                 );
 194
 195         while (1) {
 196                 shared_ptr<Socket> socket (new Socket);
 197                 acceptor.accept (socket->socket ());
 198
 199                 boost::mutex::scoped_lock lock (_worker_mutex);
 200
 201                 /* Wait until the queue has gone down a bit */
 202                 while (int (_queue.size()) >= num_threads * 2) {
 203                         _worker_condition.wait (lock);
 204                 }
 205
 206                 _queue.push_back (socket);
 207                 _worker_condition.notify_all ();
 208         }
 209 }
 210
 211 void
 212 Server::broadcast_thread ()
 213 try
 214 {
 215         boost::asio::io_service io_service;
 216
 217         boost::asio::ip::address address = boost::asio::ip::address_v4::any ();
 218         boost::asio::ip::udp::endpoint listen_endpoint (address, Config::instance()->server_port_base() + 1);
 219
 220         _broadcast.socket = new boost::asio::ip::udp::socket (io_service);
 221         _broadcast.socket->open (listen_endpoint.protocol ());
 222         _broadcast.socket->bind (listen_endpoint);
 223
 224         _broadcast.socket->async_receive_from (
 225                 boost::asio::buffer (_broadcast.buffer, sizeof (_broadcast.buffer)),
 226                 _broadcast.send_endpoint,
 227                 boost::bind (&Server::broadcast_received, this)
 228                 );
 229
 230         io_service.run ();
 231 }
 232 catch (...)
 233 {
 234         store_current ();
 235 }
 236
 237 void
 238 Server::broadcast_received ()
 239 {
 240         _broadcast.buffer[sizeof(_broadcast.buffer) - 1] = '\0';
 241
 242         if (strcmp (_broadcast.buffer, DCPOMATIC_HELLO) == 0) {
 243                 /* Reply to the client saying what we can do */
 244                 xmlpp::Document doc;
 245                 xmlpp::Element* root = doc.create_root_node ("ServerAvailable");
 246                 root->add_child("Threads")->add_child_text (raw_convert<string> (_worker_threads.size ()));
 247                 stringstream xml;
 248                 doc.write_to_stream (xml, "UTF-8");
 249
 250                 shared_ptr<Socket> socket (new Socket);
 251                 try {
 252                         socket->connect (boost::asio::ip::tcp::endpoint (_broadcast.send_endpoint.address(), Config::instance()->server_port_base() + 1));
 253                         socket->write (xml.str().length() + 1);
 254                         socket->write ((uint8_t *) xml.str().c_str(), xml.str().length() + 1);
 255                 } catch (...) {
 256
 257                 }
 258         }
 259
 260         _broadcast.socket->async_receive_from (
 261                 boost::asio::buffer (_broadcast.buffer, sizeof (_broadcast.buffer)),
 262                 _broadcast.send_endpoint, boost::bind (&Server::broadcast_received, this)
 263                 );
 264 }