search

jordansissel / fpm

Effing package management! Build packages for multiple platforms (deb, rpm, etc) with great ease and sanity.
http://fpm.readthedocs.io/en/latest/
Other
11.16k stars 1.07k forks source link

Error when attempting to build an RPM from a Node.js package #630

Open nzakas opened 10 years ago

nzakas commented 10 years ago

I'm a bit baffled at the moment by this. When I run fpm via a Makefile, I'm getting this error:

{:message=>"Process failed: npm failed (exit code 1). Full command was:[\"npm\", \"ls\", \"--json\", \"--long\", \"--prefix\", \"/tmp/package-npm-staging20140131-16297-k6q3kr/usr\", \"--global\", \"true\", \"--cache\", \"/tmp/package-npm-build20140131-16297-t4m1vm/npm_cache\", \"--loglevel\", \"warn\"]", :level=>:error, :timestamp=>"2014-01-31T15:48:38.   %6N-0800"}

If I take the exact same string and paste it into the console directly, it works fine. The command is:

 fpm -s npm -t rpm --prefix /usr -p ./dist -n node-box-generator-boxnode .

(This is using the current directory.)

Any insights into what is failing?

jordansissel commented 10 years ago

Can you show me the Makefile or link me to the code repo (if possible) where I can try to reproduce this?

nzakas commented 10 years ago

Unfortunately, the code isn't open source. :( I'll see if I can come up with a minimal test case to reproduce.

jordansissel commented 10 years ago

No worries. Can you rerun the fpm command from your makefile but add --debug? This will show the output of the npm failure and should help us identify the problem.

-Jordan

On Saturday, February 1, 2014, Nicholas C. Zakas notifications@github.com wrote:

Unfortunately, the code isn't open source. :( I'll see if I can come up with a minimal test case to reproduce.

Reply to this email directly or view it on GitHubhttps://github.com/jordansissel/fpm/issues/630#issuecomment-33876441 .

nzakas commented 10 years ago

Here's what I got:

> generator-boxnode@0.3.1 rpm /home/nzakas/code/generator-boxnode
  3 > node Makefile.js rpm
  4
  5 generator-boxnode
  6 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :output_type=>"rpm", :timestamp=>"2014-02-03T08:27:08.   %6N-0800    "}
  7 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :input_type=>"npm", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"    }
  8 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :ch    dir=>nil, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
  9 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :pr    efix=>"/usr", :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
 10 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :pa    ckage=>"./dist", :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"    }
 11 {:file=>"fpm/command.rb", :message=>"Setting attribute", :force?=>false, :le    vel=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
 12 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :name=>"node-box-generator-boxnode", :timestamp=>"2014-02-03T08:2    7:08.   %6N-0800"}
 13 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :ve    rbose?=>nil, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
 14 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :de    bug?=>true, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
 15 {:file=>"fpm/command.rb", :version=>1.0, :message=>"Setting attribute", :lev    el=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
 16 {:iteration=>nil, :file=>"fpm/command.rb", :message=>"Setting attribute", :l    evel=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
 17 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :epoch=>nil, :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
 18 {:file=>"fpm/command.rb", :license=>nil, :message=>"Setting attribute", :lev    el=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
 19 {:file=>"fpm/command.rb", :message=>"Setting attribute", :vendor=>nil, :leve    l=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
 20 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :category=>"none", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
 21 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :dependencies=>[], :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
22  {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :no_depends?=>false, :timestamp=>"2014-02-03T08:27:08.   %6N-0800    "}
 23 {:no_auto_depends?=>false, :file=>"fpm/command.rb", :message=>"Setting attri    bute", :level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N    -0800"}
 24 {:file=>"fpm/command.rb", :provides=>[], :message=>"Setting attribute", :lev    el=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
 25 {:file=>"fpm/command.rb", :message=>"Setting attribute", :conflicts=>[], :le    vel=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
 26 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :re    places=>[], :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
 27 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :config_files=>[], :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
 28 {:directories=>[], :file=>"fpm/command.rb", :message=>"Setting attribute", :    level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
 29 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :architecture=>nil, :timestamp=>"2014-02-03T08:27:08.   %6N-0800"    }
 30 {:file=>"fpm/command.rb", :maintainer=>"<nzakas@nzakas.dev.box.net>", :messa    ge=>"Setting attribute", :level=>:debug, :line=>"283", :timestamp=>"2014-02-    03T08:27:08.   %6N-0800"}
 31 {:file=>"fpm/command.rb", :message=>"Setting attribute", :package_name_suffi    x=>nil, :level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6    N-0800"}
 32 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :edit?=>false, :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
 33 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :excludes=>nil, :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
 34 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :de    scription=>"no description", :line=>"283", :timestamp=>"2014-02-03T08:27:08.       %6N-0800"}
 35 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :ur    l=>"http://example.com/no-uri-given", :line=>"283", :timestamp=>"2014-02-03T    08:27:08.   %6N-0800"}
 36 {:file=>"fpm/command.rb", :message=>"Setting attribute", :inputs=>nil, :leve    l=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
 37 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :po    st_install=>nil, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"    }
 38 {:file=>"fpm/command.rb", :pre_install=>nil, :message=>"Setting attribute",     :level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
 39 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :post_uninstall=>nil, :timestamp=>"2014-02-03T08:27:08.   %6N-080    0"}
 40 {:file=>"fpm/command.rb", :message=>"Setting attribute", :pre_uninstall=>nil    , :level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800    "}
 41 {:file=>"fpm/command.rb", :after_install=>nil, :message=>"Setting attribute"    , :level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800    "}
 42 {:before_install=>nil, :file=>"fpm/command.rb", :message=>"Setting attribute    ", :level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-080    0"}
 43 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :af    ter_remove=>nil, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"    }
 44 {:file=>"fpm/command.rb", :message=>"Setting attribute", :before_remove=>nil    , :level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800    "}
 45 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :template_scripts?=>nil, :timestamp=>"2014-02-03T08:27:08.   %6N-    0800"}
 46 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :template_value_list=>[], :timestamp=>"2014-02-03T08:27:08.   %6N    -0800"}
 47 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :workdir=>"/tmp", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
 48 {:file=>"fpm/command.rb", :npm_bin=>"npm", :message=>"Setting attribute", :l    evel=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
 49 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :npm_package_name_prefix=>"node", :timestamp=>"2014-02-03T08:27:0    8.   %6N-0800"}
  50 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :np    m_registry=>nil, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"    }
 51 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :pear_package_name_prefix=>"php-pear", :timestamp=>"2014-02-03T08    :27:08.   %6N-0800"}
 52 {:pear_channel=>nil, :file=>"fpm/command.rb", :message=>"Setting attribute",     :level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"    }
 53 {:pear_channel_update?=>nil, :file=>"fpm/command.rb", :message=>"Setting att    ribute", :level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %    6N-0800"}
 54 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :pe    ar_bin_dir=>nil, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"    }
 55 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :pear_php_bin=>nil, :timestamp=>"2014-02-03T08:27:08.   %6N-0800"    }
 56 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :pe    ar_php_dir=>nil, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"    }
 57 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :pear_data_dir=>nil, :timestamp=>"2014-02-03T08:27:08.   %6N-0800    "}
 58 {:file=>"fpm/command.rb", :rpm_use_file_permissions?=>nil, :message=>"Settin    g attribute", :level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08    .   %6N-0800"}
 59 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :rp    m_user=>"root", :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
 60 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :rpm_group=>"root", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"    }
 61 {:file=>"fpm/command.rb", :message=>"Setting attribute", :rpm_defattrfile=>"    -", :level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-08    00"}
 62 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :rp    m_defattrdir=>"-", :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-080    0"}
 63 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :rp    m_rpmbuild_define=>nil, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6    N-0800"}
 64 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :rpm_digest=>"md5", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"    }
 65 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :rp    m_compression=>"gzip", :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N    -0800"}
 66 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :rpm_os=>nil, :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
 67 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :rpm_changelog=>nil, :timestamp=>"2014-02-03T08:27:08.   %6N-0800    "}
 68 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :rpm_sign?=>nil, :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
 69 {:rpm_auto_add_directories?=>nil, :file=>"fpm/command.rb", :message=>"Settin    g attribute", :level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08    .   %6N-0800"}
 70 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :rp    m_autoreqprov?=>nil, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0    800"}
 71 {:rpm_autoreq?=>nil, :file=>"fpm/command.rb", :message=>"Setting attribute",     :level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"    }
 72 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :rp    m_autoprov?=>nil, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800    "}
 73 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :rp    m_filter_from_provides=>nil, :line=>"283", :timestamp=>"2014-02-03T08:27:08.       %6N-0800"}
 74 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :rpm_filter_from_requires=>nil, :timestamp=>"2014-02-03T08:27:08.       %6N-0800"}
 75 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :rp    m_ignore_iteration_in_dependencies?=>nil, :line=>"283", :timestamp=>"2014-02    -03T08:27:08.   %6N-0800"}
 76 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :python_bin=>"python", :timestamp=>"2014-02-03T08:27:08.   %6N-08    00"}
 77 {:file=>"fpm/command.rb", :python_easyinstall=>"easy_install", :message=>"Se    tting attribute", :level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:2    7:08.   %6N-0800"}
 78 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :python_pip=>nil, :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
 79 {:file=>"fpm/command.rb", :message=>"Setting attribute", :python_pypi=>"http    ://pypi.python.org/simple", :level=>:debug, :line=>"283", :timestamp=>"2014-    02-03T08:27:08.   %6N-0800"}
 80 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :python_package_prefix=>nil, :timestamp=>"2014-02-03T08:27:08.       %6N-0800"}
 81 {:python_package_name_prefix=>"python", :file=>"fpm/command.rb", :message=>"    Setting attribute", :level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08    :27:08.   %6N-0800"}
 82 {:file=>"fpm/command.rb", :python_fix_name?=>true, :message=>"Setting attrib    ute", :level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-    0800"}
 83 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :py    thon_fix_dependencies?=>true, :line=>"283", :timestamp=>"2014-02-03T08:27:08    .   %6N-0800"}
 84 {:file=>"fpm/command.rb", :message=>"Setting attribute", :python_downcase_na    me?=>true, :level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.       %6N-0800"}
 85 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :python_downcase_dependencies?=>true, :timestamp=>"2014-02-03T08:    27:08.   %6N-0800"}
 86 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :python_install_bin=>nil, :timestamp=>"2014-02-03T08:27:08.   %6N    -0800"}
 87 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :py    thon_install_lib=>nil, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N    -0800"}
 88 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :python_install_data=>nil, :timestamp=>"2014-02-03T08:27:08.   %6    N-0800"}
 89 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :py    thon_dependencies?=>true, :line=>"283", :timestamp=>"2014-02-03T08:27:08.       %6N-0800"}
 90 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :py    thon_obey_requirements_txt?=>false, :line=>"283", :timestamp=>"2014-02-03T08    :27:08.   %6N-0800"}
 91 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :cp    an_perl_bin=>"perl", :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0    800"}
 92 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :cpan_cpanm_bin=>"cpanm", :timestamp=>"2014-02-03T08:27:08.   %6N    -0800"}
 93 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :cp    an_mirror=>nil, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
 94 {:file=>"fpm/command.rb", :message=>"Setting attribute", :cpan_mirror_only?=    >false, :level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6    N-0800"}
 95 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :cp    an_package_name_prefix=>"perl", :line=>"283", :timestamp=>"2014-02-03T08:27:    08.   %6N-0800"}
 96 {:cpan_test?=>true, :file=>"fpm/command.rb", :message=>"Setting attribute",     :level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
 97 {:file=>"fpm/command.rb", :message=>"Setting attribute", :cpan_perl_lib_path    =>nil, :level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N    -0800"}
 98 {:file=>"fpm/command.rb", :message=>"Setting attribute", :deb_ignore_iterati    on_in_dependencies?=>nil, :level=>:debug, :line=>"283", :timestamp=>"2014-02    -03T08:27:08.   %6N-0800"}
 99 {:file=>"fpm/command.rb", :message=>"Setting attribute", :deb_build_depends=    >nil, :level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-    0800"}
100 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :deb_pre_depends=>nil, :timestamp=>"2014-02-03T08:27:08.   %6N-08    00"}
101 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :deb_compression=>"gz", :timestamp=>"2014-02-03T08:27:08.   %6N-0    800"}
102 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :deb_custom_control=>nil, :timestamp=>"2014-02-03T08:27:08.   %6N    -0800"}
103 {:file=>"fpm/command.rb", :deb_config=>nil, :message=>"Setting attribute", :    level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
104 {:file=>"fpm/command.rb", :message=>"Setting attribute", :deb_templates=>nil    , :level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800    "}
105 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :de    b_installed_size=>nil, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N    -0800"}
106 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :de    b_priority=>"extra", :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0    800"}
107 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :deb_user=>"root", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
108 {:deb_group=>"root", :file=>"fpm/command.rb", :message=>"Setting attribute",     :level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"    }
109 {:file=>"fpm/command.rb", :deb_changelog=>nil, :message=>"Setting attribute"    , :level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800    "}
110 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :deb_recommends=>nil, :timestamp=>"2014-02-03T08:27:08.   %6N-080    0"}
111 {:file=>"fpm/command.rb", :deb_suggests=>nil, :message=>"Setting attribute",     :level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"    }
112 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :de    b_field=>nil, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
113 {:file=>"fpm/command.rb", :message=>"Setting attribute", :deb_shlibs=>nil, :    level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
114 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :de    b_init_list=>[], :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"    }
115 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :deb_default_list=>[], :timestamp=>"2014-02-03T08:27:08.   %6N-08    00"}
116 {:file=>"fpm/command.rb", :message=>"Setting attribute", :deb_upstart_list=>    [], :level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-08    00"}
117 {:file=>"fpm/command.rb", :gem_bin_path=>nil, :message=>"Setting attribute",     :level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"    }
118 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :ge    m_package_prefix=>nil, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N    -0800"}
119 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :ge    m_package_name_prefix=>"rubygem", :line=>"283", :timestamp=>"2014-02-03T08:2    7:08.   %6N-0800"}
120 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :ge    m_gem=>"gem", :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
121 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :ge    m_fix_name?=>true, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-080    0"}
122 {:file=>"fpm/command.rb", :message=>"Setting attribute", :gem_fix_dependenci    es?=>true, :level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.       %6N-0800"}
123 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :ge    m_env_shebang?=>true, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-    0800"}
124 {:file=>"fpm/command.rb", :message=>"Setting attribute", :gem_prerelease?=>f    alse, :level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-    0800"}
125 {:solaris_user=>"root", :file=>"fpm/command.rb", :message=>"Setting attribut    e", :level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-08    00"}
126 {:file=>"fpm/command.rb", :solaris_group=>"root", :message=>"Setting attribu    te", :level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0    800"}
127 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :osxpkg_identifier_prefix=>nil, :timestamp=>"2014-02-03T08:27:08.       %6N-0800"}
128 {:file=>"fpm/command.rb", :osxpkg_payload_free?=>false, :message=>"Setting a    ttribute", :level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.       %6N-0800"}
129 {:file=>"fpm/command.rb", :message=>"Setting attribute", :osxpkg_ownership=>    "recommended", :level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:0    8.   %6N-0800"}
130 {:file=>"fpm/command.rb", :message=>"Setting attribute", :osxpkg_postinstall    _action=>nil, :level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08    .   %6N-0800"}
131 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :osxpkg_dont_obsolete=>nil, :timestamp=>"2014-02-03T08:27:08.   %    6N-0800"}
132 {"loglevel"=>"warn", :file=>"fpm/package/npm.rb", :message=>"Configuring npm    ", :level=>:debug, :line=>"45", :timestamp=>"2014-02-03T08:27:08.   %6N-0800    "}
133 {:file=>"fpm/package/npm.rb", "global"=>"true", :message=>"Configuring npm",     :level=>:debug, :line=>"45", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
134 {:file=>"fpm/package/npm.rb", :message=>"Configuring npm", "cache"=>"/tmp/pa    ckage-npm-build20140203-11620-1tie6ss/npm_cache", :level=>:debug, :line=>"45    ", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
135 {:file=>"fpm/package/npm.rb", :message=>"Configuring npm", "prefix"=>"/tmp/p    ackage-npm-staging20140203-11620-rtrajf/usr", :level=>:debug, :line=>"45", :    timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
136 {:file=>"fpm/util.rb", :message=>"Running command", :level=>:debug, :args=>[    "npm", "install", ".", "--loglevel", "warn", "--global", "true", "--cache",     "/tmp/package-npm-build20140203-11620-1tie6ss/npm_cache", "--prefix", "/tmp/    package-npm-staging20140203-11620-rtrajf/usr"], :line=>"48", :timestamp=>"20    14-02-03T08:27:08.   %6N-0800"}
137 {:file=>"fpm/util.rb", :message=>"Process is running", :level=>:debug, :pid=    >11621, :line=>"61", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
138 {:file=>"cabin/mixins/pipe.rb", :message=>"generator-boxnode@0.3.1 /tmp/pack    age-npm-staging20140203-11620-rtrajf/usr/lib/node_modules/generator-boxnode"    , :level=>:info, :line=>"46", :timestamp=>"2014-02-03T08:27:41.   %6N-0800"}
139 {:file=>"cabin/mixins/pipe.rb", :message=>"\342\224\234\342\224\200\342\224\    200 shelljs@0.2.6", :level=>:info, :line=>"46", :timestamp=>"2014-02-03T08:2    7:41.   %6N-0800"}
140 {:file=>"cabin/mixins/pipe.rb", :message=>"\342\224\224\342\224\200\342\224\    200 yeoman-generator@0.16.0 (dargs@0.1.0, diff@1.0.8, debug@0.7.4, class-ext    end@0.1.1, rimraf@2.2.6, text-table@0.2.0, mime@1.2.11, async@0.2.10, mkdirp    @0.3.5, isbinaryfile@2.0.1, chalk@0.4.0, underscore.string@2.3.3, iconv-lite    @0.2.11, glob@3.2.8, lodash@2.4.1, findup-sync@0.1.2, request@2.30.0, file-u    tils@0.1.5, inquirer@0.4.0, download@0.1.10, cheerio@0.13.1)", :level=>:info    , :line=>"46", :timestamp=>"2014-02-03T08:27:41.   %6N-0800"}
141 {:file=>"fpm/util.rb", :message=>"Running command", :level=>:debug, :args=>[    "npm", "ls", "--json", "--long", "--loglevel", "warn", "--global", "true", "    --cache", "/tmp/package-npm-build20140203-11620-1tie6ss/npm_cache", "--prefi    x", "/tmp/package-npm-staging20140203-11620-rtrajf/usr"], :line=>"87", :time    stamp=>"2014-02-03T08:27:42.   %6N-0800"}
142 {:file=>"fpm/util.rb", :message=>"Process is running", :level=>:debug, :pid=    >11675, :line=>"100", :timestamp=>"2014-02-03T08:27:42.   %6N-0800"}
143 {:file=>"fpm/command.rb", :message=>"Process failed: npm failed (exit code 1    ). Full command was:[\"npm\", \"ls\", \"--json\", \"--long\", \"--loglevel\"    , \"warn\", \"--global\", \"true\", \"--cache\", \"/tmp/package-npm-build201    40203-11620-1tie6ss/npm_cache\", \"--prefix\", \"/tmp/package-npm-staging201    40203-11620-rtrajf/usr\"]", :level=>:error, :line=>"409", :timestamp=>"2014-    02-03T08:27:42.   %6N-0800"}
144 1
145 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :output_type=>"rpm", :timestamp=>"2014-02-03T08:27:08.   %6N-0800    "}
146 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :input_type=>"npm", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"    }
147 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :ch    dir=>nil, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
148 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :pr    efix=>"/usr", :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
149 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :pa    ckage=>"./dist", :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"    }
150 {:file=>"fpm/command.rb", :message=>"Setting attribute", :force?=>false, :le    vel=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
151 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :name=>"node-box-generator-boxnode", :timestamp=>"2014-02-03T08:2    7:08.   %6N-0800"}
152 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :ve    rbose?=>nil, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
153 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :de    bug?=>true, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
154 {:file=>"fpm/command.rb", :version=>1.0, :message=>"Setting attribute", :lev    el=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
155 {:iteration=>nil, :file=>"fpm/command.rb", :message=>"Setting attribute", :l    evel=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
156 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :epoch=>nil, :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
157 {:file=>"fpm/command.rb", :license=>nil, :message=>"Setting attribute", :lev    el=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
158 {:file=>"fpm/command.rb", :message=>"Setting attribute", :vendor=>nil, :leve    l=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
159 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :category=>"none", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
160 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :dependencies=>[], :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
161 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :no_depends?=>false, :timestamp=>"2014-02-03T08:27:08.   %6N-0800    "}
162 {:no_auto_depends?=>false, :file=>"fpm/command.rb", :message=>"Setting attri    bute", :level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N    -0800"}
163 {:file=>"fpm/command.rb", :provides=>[], :message=>"Setting attribute", :lev    el=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
164 {:file=>"fpm/command.rb", :message=>"Setting attribute", :conflicts=>[], :le    vel=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
165 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :re    places=>[], :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
166 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :config_files=>[], :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
167 {:directories=>[], :file=>"fpm/command.rb", :message=>"Setting attribute", :    level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
168 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :architecture=>nil, :timestamp=>"2014-02-03T08:27:08.   %6N-0800"    }
169 {:file=>"fpm/command.rb", :maintainer=>"<nzakas@nzakas.dev.box.net>", :messa    ge=>"Setting attribute", :level=>:debug, :line=>"283", :timestamp=>"2014-02-    03T08:27:08.   %6N-0800"}
170 {:file=>"fpm/command.rb", :message=>"Setting attribute", :package_name_suffi    x=>nil, :level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6    N-0800"}
171 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :edit?=>false, :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
172 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :excludes=>nil, :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
173 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :de    scription=>"no description", :line=>"283", :timestamp=>"2014-02-03T08:27:08.       %6N-0800"}
174 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :ur    l=>"http://example.com/no-uri-given", :line=>"283", :timestamp=>"2014-02-03T    08:27:08.   %6N-0800"}
175 {:file=>"fpm/command.rb", :message=>"Setting attribute", :inputs=>nil, :leve    l=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
176 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :po    st_install=>nil, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"    }
177 {:file=>"fpm/command.rb", :pre_install=>nil, :message=>"Setting attribute",     :level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
178 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :post_uninstall=>nil, :timestamp=>"2014-02-03T08:27:08.   %6N-080    0"}
179 {:file=>"fpm/command.rb", :message=>"Setting attribute", :pre_uninstall=>nil    , :level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800    "}
180 {:file=>"fpm/command.rb", :after_install=>nil, :message=>"Setting attribute"    , :level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800    "}
181 {:before_install=>nil, :file=>"fpm/command.rb", :message=>"Setting attribute    ", :level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-080    0"}
182 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :af    ter_remove=>nil, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"    }
183 {:file=>"fpm/command.rb", :message=>"Setting attribute", :before_remove=>nil    , :level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800    "}
184 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :template_scripts?=>nil, :timestamp=>"2014-02-03T08:27:08.   %6N-    0800"}
185 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :template_value_list=>[], :timestamp=>"2014-02-03T08:27:08.   %6N    -0800"}
186 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :workdir=>"/tmp", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
187 {:file=>"fpm/command.rb", :npm_bin=>"npm", :message=>"Setting attribute", :l    evel=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
188 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :npm_package_name_prefix=>"node", :timestamp=>"2014-02-03T08:27:0    8.   %6N-0800"}
189 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :np    m_registry=>nil, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"    }
190 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :pear_package_name_prefix=>"php-pear", :timestamp=>"2014-02-03T08    :27:08.   %6N-0800"}
191 {:pear_channel=>nil, :file=>"fpm/command.rb", :message=>"Setting attribute",     :level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"    }
192 {:pear_channel_update?=>nil, :file=>"fpm/command.rb", :message=>"Setting att    ribute", :level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %    6N-0800"}
193 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :pe    ar_bin_dir=>nil, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"    }
194 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :pear_php_bin=>nil, :timestamp=>"2014-02-03T08:27:08.   %6N-0800"    }
195 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :pe    ar_php_dir=>nil, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"    }
196 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :pear_data_dir=>nil, :timestamp=>"2014-02-03T08:27:08.   %6N-0800    "}
197 {:file=>"fpm/command.rb", :rpm_use_file_permissions?=>nil, :message=>"Settin    g attribute", :level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08    .   %6N-0800"}
198 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :rp    m_user=>"root", :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
199 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :rpm_group=>"root", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"    }
200 {:file=>"fpm/command.rb", :message=>"Setting attribute", :rpm_defattrfile=>"    -", :level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-08    00"}
201 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :rp    m_defattrdir=>"-", :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-080    0"}
202 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :rp    m_rpmbuild_define=>nil, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6    N-0800"}
203 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :rpm_digest=>"md5", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"    }
204 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :rp    m_compression=>"gzip", :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N    -0800"}
205 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :rpm_os=>nil, :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
206 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :rpm_changelog=>nil, :timestamp=>"2014-02-03T08:27:08.   %6N-0800    "}
207 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :rpm_sign?=>nil, :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
208 {:rpm_auto_add_directories?=>nil, :file=>"fpm/command.rb", :message=>"Settin    g attribute", :level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08    .   %6N-0800"}
209 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :rp    m_autoreqprov?=>nil, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0    800"}
210 {:rpm_autoreq?=>nil, :file=>"fpm/command.rb", :message=>"Setting attribute",     :level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"    }
211 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :rp    m_autoprov?=>nil, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800    "}
212 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :rp    m_filter_from_provides=>nil, :line=>"283", :timestamp=>"2014-02-03T08:27:08.       %6N-0800"}
213 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :rpm_filter_from_requires=>nil, :timestamp=>"2014-02-03T08:27:08.       %6N-0800"}
214 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :rp    m_ignore_iteration_in_dependencies?=>nil, :line=>"283", :timestamp=>"2014-02    -03T08:27:08.   %6N-0800"}
215 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :python_bin=>"python", :timestamp=>"2014-02-03T08:27:08.   %6N-08    00"}
216 {:file=>"fpm/command.rb", :python_easyinstall=>"easy_install", :message=>"Se    tting attribute", :level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:2    7:08.   %6N-0800"}
217 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :python_pip=>nil, :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
218 {:file=>"fpm/command.rb", :message=>"Setting attribute", :python_pypi=>"http    ://pypi.python.org/simple", :level=>:debug, :line=>"283", :timestamp=>"2014-    02-03T08:27:08.   %6N-0800"}
219 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :python_package_prefix=>nil, :timestamp=>"2014-02-03T08:27:08.       %6N-0800"}
220 {:python_package_name_prefix=>"python", :file=>"fpm/command.rb", :message=>"    Setting attribute", :level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08    :27:08.   %6N-0800"}
221 {:file=>"fpm/command.rb", :python_fix_name?=>true, :message=>"Setting attrib    ute", :level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-    0800"}
222 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :py    thon_fix_dependencies?=>true, :line=>"283", :timestamp=>"2014-02-03T08:27:08    .   %6N-0800"}
223 {:file=>"fpm/command.rb", :message=>"Setting attribute", :python_downcase_na    me?=>true, :level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.       %6N-0800"}
224 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :python_downcase_dependencies?=>true, :timestamp=>"2014-02-03T08:    27:08.   %6N-0800"}
225 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :python_install_bin=>nil, :timestamp=>"2014-02-03T08:27:08.   %6N    -0800"}
226 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :py    thon_install_lib=>nil, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N    -0800"}
227 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :python_install_data=>nil, :timestamp=>"2014-02-03T08:27:08.   %6    N-0800"}
228 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :py    thon_dependencies?=>true, :line=>"283", :timestamp=>"2014-02-03T08:27:08.       %6N-0800"}
229 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :py    thon_obey_requirements_txt?=>false, :line=>"283", :timestamp=>"2014-02-03T08    :27:08.   %6N-0800"}
230 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :cp    an_perl_bin=>"perl", :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0    800"}
231 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :cpan_cpanm_bin=>"cpanm", :timestamp=>"2014-02-03T08:27:08.   %6N    -0800"}
232 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :cp    an_mirror=>nil, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
233 {:file=>"fpm/command.rb", :message=>"Setting attribute", :cpan_mirror_only?=    >false, :level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6    N-0800"}
234 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :cp    an_package_name_prefix=>"perl", :line=>"283", :timestamp=>"2014-02-03T08:27:    08.   %6N-0800"}
235 {:cpan_test?=>true, :file=>"fpm/command.rb", :message=>"Setting attribute",     :level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
236 {:file=>"fpm/command.rb", :message=>"Setting attribute", :cpan_perl_lib_path    =>nil, :level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N    -0800"}
237 {:file=>"fpm/command.rb", :message=>"Setting attribute", :deb_ignore_iterati    on_in_dependencies?=>nil, :level=>:debug, :line=>"283", :timestamp=>"2014-02    -03T08:27:08.   %6N-0800"}
238 {:file=>"fpm/command.rb", :message=>"Setting attribute", :deb_build_depends=    >nil, :level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-    0800"}
239 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :deb_pre_depends=>nil, :timestamp=>"2014-02-03T08:27:08.   %6N-08    00"}
240 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :deb_compression=>"gz", :timestamp=>"2014-02-03T08:27:08.   %6N-0    800"}
241 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :deb_custom_control=>nil, :timestamp=>"2014-02-03T08:27:08.   %6N    -0800"}
242 {:file=>"fpm/command.rb", :deb_config=>nil, :message=>"Setting attribute", :    level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
243 {:file=>"fpm/command.rb", :message=>"Setting attribute", :deb_templates=>nil    , :level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800    "}
244 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :de    b_installed_size=>nil, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N    -0800"}
245 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :de    b_priority=>"extra", :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0    800"}
246 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :deb_user=>"root", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
247 {:deb_group=>"root", :file=>"fpm/command.rb", :message=>"Setting attribute",     :level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"    }
248 {:file=>"fpm/command.rb", :deb_changelog=>nil, :message=>"Setting attribute"    , :level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800    "}
249 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :deb_recommends=>nil, :timestamp=>"2014-02-03T08:27:08.   %6N-080    0"}
250 {:file=>"fpm/command.rb", :deb_suggests=>nil, :message=>"Setting attribute",     :level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"    }
251 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :de    b_field=>nil, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
252 {:file=>"fpm/command.rb", :message=>"Setting attribute", :deb_shlibs=>nil, :    level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
253 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :de    b_init_list=>[], :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"    }
254 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :deb_default_list=>[], :timestamp=>"2014-02-03T08:27:08.   %6N-08    00"}
255 {:file=>"fpm/command.rb", :message=>"Setting attribute", :deb_upstart_list=>    [], :level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-08    00"}
256 {:file=>"fpm/command.rb", :gem_bin_path=>nil, :message=>"Setting attribute",     :level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"    }
257 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :ge    m_package_prefix=>nil, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N    -0800"}
258 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :ge    m_package_name_prefix=>"rubygem", :line=>"283", :timestamp=>"2014-02-03T08:2    7:08.   %6N-0800"}
259 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :ge    m_gem=>"gem", :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
260 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :ge    m_fix_name?=>true, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-080    0"}
261 {:file=>"fpm/command.rb", :message=>"Setting attribute", :gem_fix_dependenci    es?=>true, :level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.       %6N-0800"}
262 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :ge    m_env_shebang?=>true, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-    0800"}
263 {:file=>"fpm/command.rb", :message=>"Setting attribute", :gem_prerelease?=>f    alse, :level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-    0800"}
264 {:solaris_user=>"root", :file=>"fpm/command.rb", :message=>"Setting attribut    e", :level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-08    00"}
265 {:file=>"fpm/command.rb", :solaris_group=>"root", :message=>"Setting attribu    te", :level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.   %6N-0    800"}
266 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :osxpkg_identifier_prefix=>nil, :timestamp=>"2014-02-03T08:27:08.       %6N-0800"}
267 {:file=>"fpm/command.rb", :osxpkg_payload_free?=>false, :message=>"Setting a    ttribute", :level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08.       %6N-0800"}
268 {:file=>"fpm/command.rb", :message=>"Setting attribute", :osxpkg_ownership=>    "recommended", :level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:0    8.   %6N-0800"}
269 {:file=>"fpm/command.rb", :message=>"Setting attribute", :osxpkg_postinstall    _action=>nil, :level=>:debug, :line=>"283", :timestamp=>"2014-02-03T08:27:08    .   %6N-0800"}
270 {:file=>"fpm/command.rb", :message=>"Setting attribute", :level=>:debug, :li    ne=>"283", :osxpkg_dont_obsolete=>nil, :timestamp=>"2014-02-03T08:27:08.   %    6N-0800"}
271 {"loglevel"=>"warn", :file=>"fpm/package/npm.rb", :message=>"Configuring npm    ", :level=>:debug, :line=>"45", :timestamp=>"2014-02-03T08:27:08.   %6N-0800    "}
272 {:file=>"fpm/package/npm.rb", "global"=>"true", :message=>"Configuring npm",     :level=>:debug, :line=>"45", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
273 {:file=>"fpm/package/npm.rb", :message=>"Configuring npm", "cache"=>"/tmp/pa    ckage-npm-build20140203-11620-1tie6ss/npm_cache", :level=>:debug, :line=>"45    ", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
274 {:file=>"fpm/package/npm.rb", :message=>"Configuring npm", "prefix"=>"/tmp/p    ackage-npm-staging20140203-11620-rtrajf/usr", :level=>:debug, :line=>"45", :    timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
275 {:file=>"fpm/util.rb", :message=>"Running command", :level=>:debug, :args=>[    "npm", "install", ".", "--loglevel", "warn", "--global", "true", "--cache",     "/tmp/package-npm-build20140203-11620-1tie6ss/npm_cache", "--prefix", "/tmp/    package-npm-staging20140203-11620-rtrajf/usr"], :line=>"48", :timestamp=>"20    14-02-03T08:27:08.   %6N-0800"}
276 {:file=>"fpm/util.rb", :message=>"Process is running", :level=>:debug, :pid=    >11621, :line=>"61", :timestamp=>"2014-02-03T08:27:08.   %6N-0800"}
277 {:file=>"cabin/mixins/pipe.rb", :message=>"generator-boxnode@0.3.1 /tmp/pack    age-npm-staging20140203-11620-rtrajf/usr/lib/node_modules/generator-boxnode"    , :level=>:info, :line=>"46", :timestamp=>"2014-02-03T08:27:41.   %6N-0800"}
278 {:file=>"cabin/mixins/pipe.rb", :message=>"\342\224\234\342\224\200\342\224\    200 shelljs@0.2.6", :level=>:info, :line=>"46", :timestamp=>"2014-02-03T08:2    7:41.   %6N-0800"}
279 {:file=>"cabin/mixins/pipe.rb", :message=>"\342\224\224\342\224\200\342\224\    200 yeoman-generator@0.16.0 (dargs@0.1.0, diff@1.0.8, debug@0.7.4, class-ext    end@0.1.1, rimraf@2.2.6, text-table@0.2.0, mime@1.2.11, async@0.2.10, mkdirp    @0.3.5, isbinaryfile@2.0.1, chalk@0.4.0, underscore.string@2.3.3, iconv-lite    @0.2.11, glob@3.2.8, lodash@2.4.1, findup-sync@0.1.2, request@2.30.0, file-u    tils@0.1.5, inquirer@0.4.0, download@0.1.10, cheerio@0.13.1)", :level=>:info    , :line=>"46", :timestamp=>"2014-02-03T08:27:41.   %6N-0800"}
280 {:file=>"fpm/util.rb", :message=>"Running command", :level=>:debug, :args=>[    "npm", "ls", "--json", "--long", "--loglevel", "warn", "--global", "true", "    --cache", "/tmp/package-npm-build20140203-11620-1tie6ss/npm_cache", "--prefi    x", "/tmp/package-npm-staging20140203-11620-rtrajf/usr"], :line=>"87", :time    stamp=>"2014-02-03T08:27:42.   %6N-0800"}
281 {:file=>"fpm/util.rb", :message=>"Process is running", :level=>:debug, :pid=    >11675, :line=>"100", :timestamp=>"2014-02-03T08:27:42.   %6N-0800"}
282 {:file=>"fpm/command.rb", :message=>"Process failed: npm failed (exit code 1    ). Full command was:[\"npm\", \"ls\", \"--json\", \"--long\", \"--loglevel\"    , \"warn\", \"--global\", \"true\", \"--cache\", \"/tmp/package-npm-build201    40203-11620-1tie6ss/npm_cache\", \"--prefix\", \"/tmp/package-npm-staging201    40203-11620-rtrajf/usr\"]", :level=>:error, :line=>"409", :timestamp=>"2014-    02-03T08:27:42.   %6N-0800"}
aug24 commented 10 years ago

I'm getting exactly the same error. I have two projects, both to be packaged with fpm. One (which works) has the command

fpm -s npm -t deb -a all \ --name footman \ --prefix /usr/lib/footman \ --iteration ${PIPELINE_NUMBER} \ --verbose \ --depends couchdb \ --after-install app/service-wrapper/install-service-wrapper.sh \ --after-remove app/service-wrapper/uninstall-service-wrapper.sh \ app

and the other (which fails) has the command:

fpm -s npm -t deb -a all \ --name hivehome \ --prefix /usr/lib/hivehome \ --iteration ${BUILD_NUMBER} \ --verbose \ hivehome

The latter project has far more npm dependencies, but nothing special. A complete log of that section of the build is below:

:message=>"npm WARN unmet dependency /tmp/package-npm-staging20140314-31548-ujflyd/usr/lib/hivehome/lib/node_modules/RHC/node_modules/express/node_modules/connect requires debug@'>= 0.7.3 < 1' but will load", :level=>:info, :timestamp=>"2014-03-14T13:10:50. %6N+0000"} {:message=>"npm WARN unmet dependency undefined,", :level=>:info, :timestamp=>"2014-03-14T13:10:50. %6N+0000"} {:message=>"npm WARN unmet dependency which is version undefined", :level=>:info, :timestamp=>"2014-03-14T13:10:50. %6N+0000"} {:message=>"npm WARN unmet dependency /tmp/package-npm-staging20140314-31548-ujflyd/usr/lib/hivehome/lib/node_modules/RHC/node_modules/express/node_modules/send requires debug@'*' but will load", :level=>:info, :timestamp=>"2014-03-14T13:10:50. %6N+0000"} {:message=>"npm WARN unmet dependency undefined,", :level=>:info, :timestamp=>"2014-03-14T13:10:50. %6N+0000"} {:message=>"npm WARN unmet dependency which is version undefined", :level=>:info, :timestamp=>"2014-03-14T13:10:50. %6N+0000"} {:message=>"RHC@0.0.1 /tmp/package-npm-staging20140314-31548-ujflyd/usr/lib/hivehome/lib/node_modules/RHC", :level=>:info, :timestamp=>"2014-03-14T13:10:51. %6N+0000"} {:message=>"\342\224\234\342\224\200\342\224\200 churchill@0.0.5", :level=>:info, :timestamp=>"2014-03-14T13:10:51. %6N+0000"} {:message=>"\342\224\234\342\224\200\342\224\200 express-chromeframe@0.2.0", :level=>:info, :timestamp=>"2014-03-14T13:10:51. %6N+0000"} {:message=>"\342\224\234\342\224\200\342\224\200 sitemap@0.7.1", :level=>:info, :timestamp=>"2014-03-14T13:10:51. %6N+0000"} {:message=>"\342\224\234\342\224\200\342\224\200 underscore@1.5.2", :level=>:info, :timestamp=>"2014-03-14T13:10:51. %6N+0000"} {:message=>"\342\224\234\342\224\200\342\224\200 k-router@0.2.0", :level=>:info, :timestamp=>"2014-03-14T13:10:51. %6N+0000"} {:message=>"\342\224\234\342\224\200\342\224\200 nobleclass@0.1.2", :level=>:info, :timestamp=>"2014-03-14T13:10:51. %6N+0000"} {:message=>"\342\224\234\342\224\200\342\224\200 q@1.0.0", :level=>:info, :timestamp=>"2014-03-14T13:10:51. %6N+0000"} {:message=>"\342\224\234\342\224\200\342\224\200 hood@0.2.1", :level=>:info, :timestamp=>"2014-03-14T13:10:51. %6N+0000"} {:message=>"\342\224\234\342\224\200\342\224\200 backbone@1.1.0", :level=>:info, :timestamp=>"2014-03-14T13:10:51. %6N+0000"} {:message=>"\342\224\234\342\224\200\342\224\200 simple-jadeify@2.1.0 (through@2.3.4)", :level=>:info, :timestamp=>"2014-03-14T13:10:51. %6N+0000"} {:message=>"\342\224\234\342\224\200\342\224\200 redis@0.10.0", :level=>:info, :timestamp=>"2014-03-14T13:10:51. %6N+0000"} {:message=>"\342\224\234\342\224\200\342\224\200 markdown@0.5.0 (nopt@2.1.2)", :level=>:info, :timestamp=>"2014-03-14T13:10:51. %6N+0000"} {:message=>"\342\224\234\342\224\200\342\224\200 requirejs@2.1.11", :level=>:info, :timestamp=>"2014-03-14T13:10:51. %6N+0000"} {:message=>"\342\224\234\342\224\200\342\224\200 karma-requirejs@0.2.1", :level=>:info, :timestamp=>"2014-03-14T13:10:51. %6N+0000"} {:message=>"\342\224\234\342\224\200\342\224\200 karma-html2js-preprocessor@0.1.0", :level=>:info, :timestamp=>"2014-03-14T13:10:51. %6N+0000"} {:message=>"\342\224\234\342\224\200\342\224\200 karma-jasmine@0.2.2", :level=>:info, :timestamp=>"2014-03-14T13:10:51. %6N+0000"} {:message=>"\342\224\234\342\224\200\342\224\200 connect-redis@1.4.6 (redis@0.9.2)", :level=>:info, :timestamp=>"2014-03-14T13:10:51. %6N+0000"} {:message=>"\342\224\234\342\224\200\342\224\200 tempus@0.1.10", :level=>:info, :timestamp=>"2014-03-14T13:10:51. %6N+0000"} {:message=>"\342\224\234\342\224\200\342\224\200 karma-phantomjs-launcher@0.1.2 (phantomjs@1.9.7-1)", :level=>:info, :timestamp=>"2014-03-14T13:10:51. %6N+0000"} {:message=>"\342\224\234\342\224\200\342\224\200 moment@2.5.1", :level=>:info, :timestamp=>"2014-03-14T13:10:51. %6N+0000"} {:message=>"\342\224\234\342\224\200\342\224\200 stylus@0.42.1 (css-parse@1.7.0, mkdirp@0.3.5, sax@0.5.8, glob@3.2.9)", :level=>:info, :timestamp=>"2014-03-14T13:10:51. %6N+0000"} {:message=>"\342\224\234\342\224\200\342\224\200 winston@0.7.2 (cycle@1.0.3, stack-trace@0.0.9, eyes@0.1.8, colors@0.6.2, async@0.2.10, pkginfo@0.3.0, request@2.16.6)", :level=>:info, :timestamp=>"2014-03-14T13:10:51. %6N+0000"} {:message=>"\342\224\234\342\224\200\342\224\200 restler@3.1.0 (qs@0.6.6, yaml@0.2.3, iconv-lite@0.2.11, xml2js@0.4.0)", :level=>:info, :timestamp=>"2014-03-14T13:10:51. %6N+0000"} {:message=>"\342\224\234\342\224\200\342\224\200 winston-loggly@1.0.1 (loggly@1.0.3)", :level=>:info, :timestamp=>"2014-03-14T13:10:51. %6N+0000"} {:message=>"\342\224\234\342\224\200\342\224\200 jade@0.35.0 (character-parser@1.2.0, commander@2.0.0, mkdirp@0.3.5, transformers@2.1.0, constantinople@1.0.2, monocle@1.1.50, with@1.1.1)", :level=>:info, :timestamp=>"2014-03-14T13:10:51. %6N+0000"} {:message=>"\342\224\234\342\224\200\342\224\200 nib@1.0.1 (stylus@0.35.1)", :level=>:info, :timestamp=>"2014-03-14T13:10:51. %6N+0000"} {:message=>"\342\224\234\342\224\200\342\224\200 d3@3.3.11 (jsdom@0.5.7)", :level=>:info, :timestamp=>"2014-03-14T13:10:51. %6N+0000"} {:message=>"\342\224\234\342\224\200\342\224\200 express@3.4.8 (methods@0.1.0, merge-descriptors@0.0.1, cookie-signature@1.0.1, range-parser@0.0.4, fresh@0.2.0, buffer-crc32@0.2.1, cookie@0.1.0, mkdirp@0.3.5, commander@1.3.2, send@0.1.4, connect@2.12.0)", :level=>:info, :timestamp=>"2014-03-14T13:10:51. %6N+0000"} {:message=>"\342\224\234\342\224\200\342\224\200 karma@0.12.0 (di@0.0.1, graceful-fs@2.0.2, rimraf@2.2.6, colors@0.6.2, chokidar@0.8.1, mime@1.2.11, q@0.9.7, minimatch@0.2.14, glob@3.2.9, optimist@0.6.1, source-map@0.1.33, lodash@2.4.1, log4js@0.6.12, http-proxy@0.10.4, useragent@2.0.7, connect@2.12.0, socket.io@0.9.16)", :level=>:info, :timestamp=>"2014-03-14T13:10:51. %6N+0000"} {:message=>"\342\224\234\342\224\200\342\224\200 karma-script-launcher@0.1.0", :level=>:info, :timestamp=>"2014-03-14T13:10:51. %6N+0000"} {:message=>"\342\224\234\342\224\200\342\224\200 browserify@3.32.1 (builtins@0.0.2, https-browserify@0.0.0, tty-browserify@0.0.0, constants-browserify@0.0.1, path-browserify@0.0.0, os-browserify@0.1.2, inherits@2.0.1, commondir@0.0.1, domain-browser@1.1.1, defined@0.0.0, stream-combiner@0.0.4, duplexer@0.1.1, shell-quote@0.0.1, deep-equal@0.1.2, shallow-copy@0.0.1, parents@0.0.2, console-browserify@1.0.3, through@2.3.4, querystring-es3@0.2.0, punycode@1.2.4, string_decoder@0.0.1, util@0.10.3, browser-resolve@1.2.2, events@1.0.0, timers-browserify@1.0.1, resolve@0.6.1, vm-browserify@0.0.4, stream-browserify@0.1.3, subarg@0.0.1, glob@3.2.9, assert@1.1.1, JSONStream@0.7.1, concat-stream@1.4.4, zlib-browserify@0.0.3, http-browserify@1.3.2, crypto-browserify@1.0.9, buffer@2.1.5, deps-sort@0.1.1, browser-pack@2.0.1, umd@2.0.0, syntax-error@0.1.0, derequire@0.6.1, insert-module-globals@3.2.0, module-deps@1.7.1, url@0.7.9)", :level=>:info, :timestamp=>"2014-03-14T13:10:51. %6N+0000"} {:message=>"\342\224\224\342\224\200\342\224\200 enchilada@0.7.1 (convert-source-map@0.3.3, mime@1.2.11, uglify-js@2.4.8, browserify@3.18.0)", :level=>:info, :timestamp=>"2014-03-14T13:10:51. %6N+0000"} {:message=>"Process failed: npm failed (exit code 1). Full command was:[\"npm\", \"ls\", \"--json\", \"--long\", \"--global\", \"true\", \"--prefix\", \"/tmp/package-npm-staging20140314-31548-ujflyd/usr/lib/hivehome\", \"--cache\", \"/tmp/package-npm-build20140314-31548-1xrpq4o/npm_cache\", \"--loglevel\", \"warn\"]", :level=>:error, :timestamp=>"2014-03-14T13:11:24. %6N+0000"} Build step 'Execute shell' marked build as failure

aug24 commented 10 years ago

Complete output with debug turned on:

fpm -s npm -t deb -a all --name hivehome --prefix /usr/lib/hivehome --iteration 17 --verbose --debug hivehome {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :output_type=>"deb", :timestamp=>"2014-03-14T13:15:47. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :input_type=>"npm", :timestamp=>"2014-03-14T13:15:47. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :chdir=>nil, :timestamp=>"2014-03-14T13:15:47. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :prefix=>"/usr/lib/hivehome", :timestamp=>"2014-03-14T13:15:47. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :package=>nil, :message=>"Setting attribute", :level=>:debug, :timestamp=>"2014-03-14T13:15:47. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :force?=>false, :message=>"Setting attribute", :level=>:debug, :timestamp=>"2014-03-14T13:15:47. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :name=>"hivehome", :timestamp=>"2014-03-14T13:15:47. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :verbose?=>true, :timestamp=>"2014-03-14T13:15:47. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :debug?=>true, :timestamp=>"2014-03-14T13:15:47. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :version=>1.0, :timestamp=>"2014-03-14T13:15:47. %6N+0000"} {:iteration=>"17", :file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :timestamp=>"2014-03-14T13:15:47. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :epoch=>nil, :timestamp=>"2014-03-14T13:15:47. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :license=>nil, :timestamp=>"2014-03-14T13:15:47. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :vendor=>nil, :timestamp=>"2014-03-14T13:15:47. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :category=>"none", :timestamp=>"2014-03-14T13:15:47. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :dependencies=>[], :timestamp=>"2014-03-14T13:15:47. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :no_depends?=>false, :timestamp=>"2014-03-14T13:15:47. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :no_auto_depends?=>false, :timestamp=>"2014-03-14T13:15:47. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :provides=>[], :message=>"Setting attribute", :level=>:debug, :timestamp=>"2014-03-14T13:15:47. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :conflicts=>[], :message=>"Setting attribute", :level=>:debug, :timestamp=>"2014-03-14T13:15:47. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :replaces=>[], :timestamp=>"2014-03-14T13:15:47. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :config_files=>[], :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :directories=>[], :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :timestamp=>"2014-03-14T13:15:48. %6N+0000", :architecture=>"all"} {:file=>"fpm/command.rb", :line=>"283", :maintainer=>"jenkins@ip-10-4-199-17", :message=>"Setting attribute", :level=>:debug, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :package_name_suffix=>nil, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :edit?=>false, :message=>"Setting attribute", :level=>:debug, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :excludes=>nil, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :description=>"no description", :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :url=>"http://example.com/no-uri-given", :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :inputs=>nil, :message=>"Setting attribute", :level=>:debug, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :post_install=>nil, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :pre_install=>nil, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :post_uninstall=>nil, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :pre_uninstall=>nil, :message=>"Setting attribute", :level=>:debug, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :after_install=>nil, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :before_install=>nil, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:after_remove=>nil, :file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :before_remove=>nil, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :template_scripts?=>nil, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :template_value_list=>[], :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :workdir=>"/tmp", :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :python_bin=>"python", :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :python_easyinstall=>"easy_install", :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :timestamp=>"2014-03-14T13:15:48. %6N+0000", :python_pip=>nil} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :python_pypi=>"http://pypi.python.org/simple", :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :python_package_prefix=>nil, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:python_package_name_prefix=>"python", :file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :python_fix_name?=>true, :message=>"Setting attribute", :level=>:debug, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :python_fix_dependencies?=>true, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :python_downcase_name?=>true, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :python_downcase_dependencies?=>true, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :timestamp=>"2014-03-14T13:15:48. %6N+0000", :python_install_bin=>nil} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :python_install_lib=>nil, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :python_install_data=>nil, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :python_dependencies?=>true, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :python_obey_requirements_txt?=>false, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :timestamp=>"2014-03-14T13:15:48. %6N+0000", :pear_package_name_prefix=>"php-pear"} {:file=>"fpm/command.rb", :line=>"283", :pear_channel=>nil, :message=>"Setting attribute", :level=>:debug, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :pear_channel_update?=>nil, :message=>"Setting attribute", :level=>:debug, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :pear_bin_dir=>nil, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:pear_php_bin=>nil, :file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :timestamp=>"2014-03-14T13:15:48. %6N+0000", :pear_php_dir=>nil} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :pear_data_dir=>nil, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :solaris_user=>"root", :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :timestamp=>"2014-03-14T13:15:48. %6N+0000", :solaris_group=>"root"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :npm_bin=>"npm", :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :npm_package_name_prefix=>"node", :message=>"Setting attribute", :level=>:debug, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :npm_registry=>nil, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :osxpkg_identifier_prefix=>nil, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :osxpkg_payload_free?=>false, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:osxpkg_ownership=>"recommended", :file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:osxpkg_postinstall_action=>nil, :file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :osxpkg_dont_obsolete=>nil, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :rpm_use_file_permissions?=>nil, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :rpm_user=>"root", :message=>"Setting attribute", :level=>:debug, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :rpm_group=>"root", :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :rpm_defattrfile=>"-", :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :rpm_defattrdir=>"-", :message=>"Setting attribute", :level=>:debug, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :rpm_rpmbuild_define=>nil, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :rpm_digest=>"md5", :message=>"Setting attribute", :level=>:debug, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :rpm_compression=>"gzip", :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:rpm_os=>nil, :file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :rpm_changelog=>nil, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:rpm_sign?=>nil, :file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :rpm_auto_add_directories?=>nil, :message=>"Setting attribute", :level=>:debug, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:rpm_autoreqprov?=>nil, :file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :rpm_autoreq?=>nil, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :rpm_autoprov?=>nil, :message=>"Setting attribute", :level=>:debug, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:rpm_filter_from_provides=>nil, :file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :rpm_filter_from_requires=>nil, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :rpm_ignore_iteration_in_dependencies?=>nil, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :deb_ignore_iteration_in_dependencies?=>nil, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :deb_build_depends=>nil, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :deb_pre_depends=>nil, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :deb_compression=>"gz", :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :deb_custom_control=>nil, :message=>"Setting attribute", :level=>:debug, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :deb_config=>nil, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :deb_templates=>nil, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:deb_installed_size=>nil, :file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:deb_priority=>"extra", :file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :deb_user=>"root", :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :deb_group=>"root", :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :deb_changelog=>nil, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :deb_recommends=>nil, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :deb_suggests=>nil, :message=>"Setting attribute", :level=>:debug, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :deb_field=>nil, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :deb_shlibs=>nil, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:deb_init_list=>[], :file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :deb_default_list=>[], :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :deb_upstart_list=>[], :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :gem_bin_path=>nil, :message=>"Setting attribute", :level=>:debug, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :gem_package_prefix=>nil, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :timestamp=>"2014-03-14T13:15:48. %6N+0000", :gem_package_name_prefix=>"rubygem"} {:gem_gem=>"gem", :file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :gem_fix_name?=>true, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :gem_fix_dependencies?=>true, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :gem_env_shebang?=>true, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :gem_prerelease?=>false, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :cpan_perl_bin=>"perl", :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :cpan_cpanm_bin=>"cpanm", :message=>"Setting attribute", :level=>:debug, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :cpan_mirror=>nil, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :cpan_mirror_only?=>false, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :cpan_package_name_prefix=>"perl", :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :cpan_test?=>true, :message=>"Setting attribute", :level=>:debug, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/command.rb", :line=>"283", :message=>"Setting attribute", :level=>:debug, :cpan_perl_lib_path=>nil, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {"cache"=>"/tmp/package-npm-build20140314-24510-1lf1u67/npm_cache", :file=>"fpm/package/npm.rb", :line=>"45", :message=>"Configuring npm", :level=>:debug, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/package/npm.rb", :line=>"45", "global"=>"true", :message=>"Configuring npm", :level=>:debug, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/package/npm.rb", :line=>"45", "prefix"=>"/tmp/package-npm-staging20140314-24510-109bkcr/usr/lib/hivehome", :message=>"Configuring npm", :level=>:debug, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/package/npm.rb", :line=>"45", :message=>"Configuring npm", :level=>:debug, "loglevel"=>"warn", :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/util.rb", :line=>"48", :message=>"Running command", :level=>:debug, :args=>["npm", "install", "hivehome", "--cache", "/tmp/package-npm-build20140314-24510-1lf1u67/npm_cache", "--global", "true", "--prefix", "/tmp/package-npm-staging20140314-24510-109bkcr/usr/lib/hivehome", "--loglevel", "warn"], :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"fpm/util.rb", :line=>"61", :message=>"Process is running", :level=>:debug, :pid=>24512, :timestamp=>"2014-03-14T13:15:48. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>"", :level=>:info, :timestamp=>"2014-03-14T13:21:51. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>"> phantomjs@1.9.7-1 install /tmp/package-npm-staging20140314-24510-109bkcr/usr/lib/hivehome/lib/node_modules/RHC/node_modules/karma-phantomjs-launcher/node_modules/phantomjs", :level=>:info, :timestamp=>"2014-03-14T13:21:51. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>"> node install.js", :level=>:info, :timestamp=>"2014-03-14T13:21:51. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>"", :level=>:info, :timestamp=>"2014-03-14T13:21:51. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>"Download already available at /tmp/phantomjs/phantomjs-1.9.7-linux-x86_64.tar.bz2", :level=>:info, :timestamp=>"2014-03-14T13:21:53. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>"Extracting tar contents (via spawned process)", :level=>:info, :timestamp=>"2014-03-14T13:21:53. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>"Copying extracted folder /tmp/phantomjs/phantomjs-1.9.7-linux-x86_64.tar.bz2-extract-1394803313651/phantomjs-1.9.7-linux-x86_64 -> /tmp/package-npm-staging20140314-24510-109bkcr/usr/lib/hivehome/lib/node_modules/RHC/node_modules/karma-phantomjs-launcher/node_modules/phantomjs/lib/phantom", :level=>:info, :timestamp=>"2014-03-14T13:22:23. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>"Writing location.js file", :level=>:info, :timestamp=>"2014-03-14T13:22:25. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>"Done. Phantomjs binary available at /tmp/package-npm-staging20140314-24510-109bkcr/usr/lib/hivehome/lib/node_modules/RHC/node_modules/karma-phantomjs-launcher/node_modules/phantomjs/lib/phantom/bin/phantomjs", :level=>:info, :timestamp=>"2014-03-14T13:22:25. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>"npm WARN engine hawk@0.10.2: wanted: {\"node\":\"0.8.x\"} (current: {\"node\":\"v0.10.17\",\"npm\":\"1.3.8\"})", :level=>:info, :timestamp=>"2014-03-14T13:23:36. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>"npm WARN engine cryptiles@0.1.3: wanted: {\"node\":\"0.8.x\"} (current: {\"node\":\"v0.10.17\",\"npm\":\"1.3.8\"})", :level=>:info, :timestamp=>"2014-03-14T13:24:36. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>"npm WARN engine sntp@0.1.4: wanted: {\"node\":\"0.8.x\"} (current: {\"node\":\"v0.10.17\",\"npm\":\"1.3.8\"})", :level=>:info, :timestamp=>"2014-03-14T13:24:36. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>"npm WARN engine boom@0.3.8: wanted: {\"node\":\"0.8.x\"} (current: {\"node\":\"v0.10.17\",\"npm\":\"1.3.8\"})", :level=>:info, :timestamp=>"2014-03-14T13:24:36. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>"npm WARN engine hoek@0.7.6: wanted: {\"node\":\"0.8.x\"} (current: {\"node\":\"v0.10.17\",\"npm\":\"1.3.8\"})", :level=>:info, :timestamp=>"2014-03-14T13:24:36. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>"", :level=>:info, :timestamp=>"2014-03-14T13:27:36. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>"> chokidar@0.8.1 postinstall /tmp/package-npm-staging20140314-24510-109bkcr/usr/lib/hivehome/lib/node_modules/RHC/node_modules/karma/node_modules/chokidar", :level=>:info, :timestamp=>"2014-03-14T13:27:36. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>"> node setup-deps.js", :level=>:info, :timestamp=>"2014-03-14T13:27:36. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>"", :level=>:info, :timestamp=>"2014-03-14T13:27:36. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>"", :level=>:info, :timestamp=>"2014-03-14T13:27:38. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>"> contextify@0.1.7 install /tmp/package-npm-staging20140314-24510-109bkcr/usr/lib/hivehome/lib/node_modules/RHC/node_modules/d3/node_modules/jsdom/node_modules/contextify", :level=>:info, :timestamp=>"2014-03-14T13:27:38. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>"> node-gyp rebuild", :level=>:info, :timestamp=>"2014-03-14T13:27:38. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>"", :level=>:info, :timestamp=>"2014-03-14T13:27:38. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>"make: Entering directory /tmp/package-npm-staging20140314-24510-109bkcr/usr/lib/hivehome/lib/node_modules/RHC/node_modules/d3/node_modules/jsdom/node_modules/contextify/build'", :level=>:info, :timestamp=>"2014-03-14T13:27:44. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>" CXX(target) Release/obj.target/contextify/src/contextify.o", :level=>:info, :timestamp=>"2014-03-14T13:27:44. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>" SOLINK_MODULE(target) Release/obj.target/contextify.node", :level=>:info, :timestamp=>"2014-03-14T13:27:49. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>" SOLINK_MODULE(target) Release/obj.target/contextify.node: Finished", :level=>:info, :timestamp=>"2014-03-14T13:27:50. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>" COPY Release/contextify.node", :level=>:info, :timestamp=>"2014-03-14T13:27:50. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>"make: Leaving directory/tmp/package-npm-staging20140314-24510-109bkcr/usr/lib/hivehome/lib/node_modules/RHC/node_modules/d3/node_modules/jsdom/node_modules/contextify/build'", :level=>:info, :timestamp=>"2014-03-14T13:27:50. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>"", :level=>:info, :timestamp=>"2014-03-14T13:31:32. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>"> ws@0.4.31 install /tmp/package-npm-staging20140314-24510-109bkcr/usr/lib/hivehome/lib/node_modules/RHC/node_modules/karma/node_modules/socket.io/node_modules/socket.io-client/node_modules/ws", :level=>:info, :timestamp=>"2014-03-14T13:31:32. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>"> (node-gyp rebuild 2> builderror.log) || (exit 0)", :level=>:info, :timestamp=>"2014-03-14T13:31:32. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>"", :level=>:info, :timestamp=>"2014-03-14T13:31:32. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>"make: Entering directory /tmp/package-npm-staging20140314-24510-109bkcr/usr/lib/hivehome/lib/node_modules/RHC/node_modules/karma/node_modules/socket.io/node_modules/socket.io-client/node_modules/ws/build'", :level=>:info, :timestamp=>"2014-03-14T13:31:38. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>" CXX(target) Release/obj.target/bufferutil/src/bufferutil.o", :level=>:info, :timestamp=>"2014-03-14T13:31:38. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>" SOLINK_MODULE(target) Release/obj.target/bufferutil.node", :level=>:info, :timestamp=>"2014-03-14T13:31:42. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>" SOLINK_MODULE(target) Release/obj.target/bufferutil.node: Finished", :level=>:info, :timestamp=>"2014-03-14T13:31:42. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>" COPY Release/bufferutil.node", :level=>:info, :timestamp=>"2014-03-14T13:31:42. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>" CXX(target) Release/obj.target/validation/src/validation.o", :level=>:info, :timestamp=>"2014-03-14T13:31:42. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>" SOLINK_MODULE(target) Release/obj.target/validation.node", :level=>:info, :timestamp=>"2014-03-14T13:31:45. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>" SOLINK_MODULE(target) Release/obj.target/validation.node: Finished", :level=>:info, :timestamp=>"2014-03-14T13:31:46. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>" COPY Release/validation.node", :level=>:info, :timestamp=>"2014-03-14T13:31:46. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>"make: Leaving directory/tmp/package-npm-staging20140314-24510-109bkcr/usr/lib/hivehome/lib/node_modules/RHC/node_modules/karma/node_modules/socket.io/node_modules/socket.io-client/node_modules/ws/build'", :level=>:info, :timestamp=>"2014-03-14T13:31:46. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>"npm WARN unmet dependency /tmp/package-npm-staging20140314-24510-109bkcr/usr/lib/hivehome/lib/node_modules/RHC/node_modules/express/node_modules/connect requires debug@'>= 0.7.3 < 1' but will load", :level=>:info, :timestamp=>"2014-03-14T13:34:03. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>"npm WARN unmet dependency undefined,", :level=>:info, :timestamp=>"2014-03-14T13:34:03. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>"npm WARN unmet dependency which is version undefined", :level=>:info, :timestamp=>"2014-03-14T13:34:03. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>"npm WARN unmet dependency /tmp/package-npm-staging20140314-24510-109bkcr/usr/lib/hivehome/lib/node_modules/RHC/node_modules/express/node_modules/send requires debug@'*' but will load", :level=>:info, :timestamp=>"2014-03-14T13:34:03. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>"npm WARN unmet dependency undefined,", :level=>:info, :timestamp=>"2014-03-14T13:34:03. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>"npm WARN unmet dependency which is version undefined", :level=>:info, :timestamp=>"2014-03-14T13:34:03. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>"RHC@0.0.1 /tmp/package-npm-staging20140314-24510-109bkcr/usr/lib/hivehome/lib/node_modules/RHC", :level=>:info, :timestamp=>"2014-03-14T13:34:03. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>"\342\224\234\342\224\200\342\224\200 churchill@0.0.5", :level=>:info, :timestamp=>"2014-03-14T13:34:03. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>"\342\224\234\342\224\200\342\224\200 express-chromeframe@0.2.0", :level=>:info, :timestamp=>"2014-03-14T13:34:03. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>"\342\224\234\342\224\200\342\224\200 sitemap@0.7.1", :level=>:info, :timestamp=>"2014-03-14T13:34:03. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>"\342\224\234\342\224\200\342\224\200 underscore@1.5.2", :level=>:info, :timestamp=>"2014-03-14T13:34:03. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>"\342\224\234\342\224\200\342\224\200 k-router@0.2.0", :level=>:info, :timestamp=>"2014-03-14T13:34:03. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>"\342\224\234\342\224\200\342\224\200 nobleclass@0.1.2", :level=>:info, :timestamp=>"2014-03-14T13:34:03. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>"\342\224\234\342\224\200\342\224\200 q@1.0.0", :level=>:info, :timestamp=>"2014-03-14T13:34:03. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>"\342\224\234\342\224\200\342\224\200 hood@0.2.1", :level=>:info, :timestamp=>"2014-03-14T13:34:03. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>"\342\224\234\342\224\200\342\224\200 backbone@1.1.0", :level=>:info, :timestamp=>"2014-03-14T13:34:03. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>"\342\224\234\342\224\200\342\224\200 simple-jadeify@2.1.0 (through@2.3.4)", :level=>:info, :timestamp=>"2014-03-14T13:34:03. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>"\342\224\234\342\224\200\342\224\200 redis@0.10.0", :level=>:info, :timestamp=>"2014-03-14T13:34:03. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>"\342\224\234\342\224\200\342\224\200 markdown@0.5.0 (nopt@2.1.2)", :level=>:info, :timestamp=>"2014-03-14T13:34:03. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>"\342\224\234\342\224\200\342\224\200 requirejs@2.1.11", :level=>:info, :timestamp=>"2014-03-14T13:34:03. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>"\342\224\234\342\224\200\342\224\200 karma-requirejs@0.2.1", :level=>:info, :timestamp=>"2014-03-14T13:34:03. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>"\342\224\234\342\224\200\342\224\200 karma-html2js-preprocessor@0.1.0", :level=>:info, :timestamp=>"2014-03-14T13:34:03. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>"\342\224\234\342\224\200\342\224\200 karma-jasmine@0.2.2", :level=>:info, :timestamp=>"2014-03-14T13:34:03. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>"\342\224\234\342\224\200\342\224\200 connect-redis@1.4.6 (redis@0.9.2)", :level=>:info, :timestamp=>"2014-03-14T13:34:03. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>"\342\224\234\342\224\200\342\224\200 tempus@0.1.10", :level=>:info, :timestamp=>"2014-03-14T13:34:03. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>"\342\224\234\342\224\200\342\224\200 karma-phantomjs-launcher@0.1.2 (phantomjs@1.9.7-1)", :level=>:info, :timestamp=>"2014-03-14T13:34:03. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>"\342\224\234\342\224\200\342\224\200 stylus@0.42.1 (css-parse@1.7.0, mkdirp@0.3.5, sax@0.5.8, glob@3.2.9)", :level=>:info, :timestamp=>"2014-03-14T13:34:03. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>"\342\224\234\342\224\200\342\224\200 moment@2.5.1", :level=>:info, :timestamp=>"2014-03-14T13:34:03. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>"\342\224\234\342\224\200\342\224\200 winston@0.7.2 (cycle@1.0.3, stack-trace@0.0.9, eyes@0.1.8, colors@0.6.2, async@0.2.10, pkginfo@0.3.0, request@2.16.6)", :level=>:info, :timestamp=>"2014-03-14T13:34:03. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>"\342\224\234\342\224\200\342\224\200 restler@3.1.0 (qs@0.6.6, yaml@0.2.3, iconv-lite@0.2.11, xml2js@0.4.0)", :level=>:info, :timestamp=>"2014-03-14T13:34:03. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>"\342\224\234\342\224\200\342\224\200 winston-loggly@1.0.1 (loggly@1.0.3)", :level=>:info, :timestamp=>"2014-03-14T13:34:03. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>"\342\224\234\342\224\200\342\224\200 jade@0.35.0 (character-parser@1.2.0, commander@2.0.0, mkdirp@0.3.5, transformers@2.1.0, constantinople@1.0.2, monocle@1.1.50, with@1.1.1)", :level=>:info, :timestamp=>"2014-03-14T13:34:03. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>"\342\224\234\342\224\200\342\224\200 nib@1.0.1 (stylus@0.35.1)", :level=>:info, :timestamp=>"2014-03-14T13:34:03. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>"\342\224\234\342\224\200\342\224\200 d3@3.3.11 (jsdom@0.5.7)", :level=>:info, :timestamp=>"2014-03-14T13:34:03. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>"\342\224\234\342\224\200\342\224\200 express@3.4.8 (methods@0.1.0, merge-descriptors@0.0.1, cookie-signature@1.0.1, range-parser@0.0.4, fresh@0.2.0, buffer-crc32@0.2.1, cookie@0.1.0, mkdirp@0.3.5, commander@1.3.2, send@0.1.4, connect@2.12.0)", :level=>:info, :timestamp=>"2014-03-14T13:34:03. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>"\342\224\234\342\224\200\342\224\200 karma@0.12.0 (di@0.0.1, graceful-fs@2.0.2, rimraf@2.2.6, colors@0.6.2, chokidar@0.8.1, mime@1.2.11, q@0.9.7, minimatch@0.2.14, glob@3.2.9, optimist@0.6.1, lodash@2.4.1, source-map@0.1.33, log4js@0.6.12, http-proxy@0.10.4, useragent@2.0.7, connect@2.12.0, socket.io@0.9.16)", :level=>:info, :timestamp=>"2014-03-14T13:34:03. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>"\342\224\234\342\224\200\342\224\200 karma-script-launcher@0.1.0", :level=>:info, :timestamp=>"2014-03-14T13:34:03. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>"\342\224\234\342\224\200\342\224\200 browserify@3.32.1 (builtins@0.0.2, https-browserify@0.0.0, tty-browserify@0.0.0, constants-browserify@0.0.1, path-browserify@0.0.0, os-browserify@0.1.2, inherits@2.0.1, commondir@0.0.1, domain-browser@1.1.1, defined@0.0.0, stream-combiner@0.0.4, duplexer@0.1.1, shell-quote@0.0.1, deep-equal@0.1.2, shallow-copy@0.0.1, parents@0.0.2, console-browserify@1.0.3, through@2.3.4, querystring-es3@0.2.0, punycode@1.2.4, string_decoder@0.0.1, util@0.10.3, browser-resolve@1.2.2, events@1.0.0, timers-browserify@1.0.1, resolve@0.6.1, vm-browserify@0.0.4, stream-browserify@0.1.3, subarg@0.0.1, glob@3.2.9, assert@1.1.1, JSONStream@0.7.1, concat-stream@1.4.4, zlib-browserify@0.0.3, http-browserify@1.3.2, crypto-browserify@1.0.9, buffer@2.1.5, deps-sort@0.1.1, browser-pack@2.0.1, umd@2.0.0, syntax-error@0.1.0, insert-module-globals@3.2.0, module-deps@1.7.1, derequire@0.6.1, url@0.7.9)", :level=>:info, :timestamp=>"2014-03-14T13:34:03. %6N+0000"} {:file=>"cabin/mixins/pipe.rb", :line=>"46", :message=>"\342\224\224\342\224\200\342\224\200 enchilada@0.7.1 (convert-source-map@0.3.3, mime@1.2.11, uglify-js@2.4.8, browserify@3.18.0)", :level=>:info, :timestamp=>"2014-03-14T13:34:03. %6N+0000"} {:file=>"fpm/util.rb", :line=>"87", :message=>"Running command", :level=>:debug, :args=>["npm", "ls", "--json", "--long", "--cache", "/tmp/package-npm-build20140314-24510-1lf1u67/npm_cache", "--global", "true", "--prefix", "/tmp/package-npm-staging20140314-24510-109bkcr/usr/lib/hivehome", "--loglevel", "warn"], :timestamp=>"2014-03-14T13:34:13. %6N+0000"} {:file=>"fpm/util.rb", :line=>"100", :message=>"Process is running", :level=>:debug, :pid=>12992, :timestamp=>"2014-03-14T13:34:39. %6N+0000"} {:file=>"fpm/command.rb", :line=>"409", :message=>"Process failed: npm failed (exit code 1). Full command was:[\"npm\", \"ls\", \"--json\", \"--long\", \"--cache\", \"/tmp/package-npm-build20140314-24510-1lf1u67/npm_cache\", \"--global\", \"true\", \"--prefix\", \"/tmp/package-npm-staging20140314-24510-109bkcr/usr/lib/hivehome\", \"--loglevel\", \"warn\"]", :level=>:error, :timestamp=>"2014-03-14T13:34:39. %6N+0000"}

alivespirit commented 9 years ago

Hi, Any updates on this? Have the same problem when running fpm --debug -v 4.0.7 -s npm -t rpm appdynamics
Error: Process failed: npm failed (exit code 1). Full command was:["npm", "ls", "--json", "--long", "--cache", "/tmp/package-npm-build20151105-31435-12fch45/npm_cache", "--loglevel", "warn", "--global", "true", "--prefix", "/tmp/package-npm-staging20151105-31435-1g1wlvy/usr"] {:level=>:error, :file=>"fpm/command.rb", :line=>"493"}

When running the same command directly, I see there's 2 extraneous packages. Problem is fpm is trying to parse json output of npm ls, while in the output 2 last lines are about those extraneous packages and not in json format. I can't remove those packages (npm prune doesn't help) and I don't know where from those packages appeared.

avengerpenguin commented 8 years ago

Here: https://github.com/jordansissel/fpm/blob/master/lib/fpm/package/npm.rb#L58-L63 can we get it to print out the contents of npm_ls_out if the command has failed and the output doesn't parse as JSON?

avengerpenguin commented 8 years ago

For what it's worth, I'm seeing this having moved from npm v1 to v2.

avengerpenguin commented 8 years ago

Actually, the error I'm getting is that npm ls is failing with exit code >0 due to "extraneous" dependencies that have come in because they are peer dependencies. npm install is bringing them down by default in npm v2 but npm ls then thinks those dependencies shouldn't be there!

daurnimator commented 7 years ago

I think I'm having the same issue:

$ fpm --verbose  -s npm -t rpm  react-dom@^15.4.0
Setting workdir {:workdir=>"/tmp", :level=>:info}
Setting default npm install prefix {:prefix=>"/usr", :level=>:info}
npm WARN react-dom@15.6.2 requires a peer of react@^15.6.2 but none is installed. You must install peer dependencies yourself. {:level=>:info}
 {:level=>:info}
+ react-dom@15.6.2 {:level=>:info}
added 17 packages in 1.976s {:level=>:info}
Process failed: npm failed (exit code 1). Full command was:["npm", "ls", "--json", "--long", "--cache", "/tmp/package-npm-build-d90d12119dfcef686ea51ba0629cf6c7d0a3ac25967f225aefdfca8f0f31/npm_cache", "--loglevel", "warn", "--global", "true", "--prefix", "/tmp/package-npm-staging-3709ac64b2369a0a13f2a66805c5992756cea04ca768f6f294fa7cb53d9f/usr"] {:level=>:error}
CarwynNelson commented 5 years ago

As per @avengerpenguin's comment, it looks like this is an issue with the dependencies of the project I am working on.

If you do an npm install --production and then an npm ls you might find the error you are trying to resolve. In my case the error was:

npm ERR! peer dep missing: typescript@*, required by ts-pnp@1.0.1

So it looks like there are dev-dependencies that are propping up the production dependencies in my app.