builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-030 starttime: 1458006795.42 results: success (0) buildid: 20160314173233 builduid: d682d730bc49476098fb58d1cee9a0bc revision: 21077a8abccf547e9ff9d40629902a676626544e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-14 18:53:15.416407) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-14 18:53:15.417227) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-14 18:53:15.417847) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4ac8d263c7293b36a1be1aed000001be-1458005854.276392-610488406 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006377 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-14 18:53:15.445494) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-14 18:53:15.445825) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-14 18:53:15.461664) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 18:53:15.462432) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4ac8d263c7293b36a1be1aed000001be-1458005854.276392-610488406 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004553 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 18:53:15.516167) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-14 18:53:15.516887) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-14 18:53:15.517764) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 18:53:15.518395) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4ac8d263c7293b36a1be1aed000001be-1458005854.276392-610488406 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-14 18:53:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-03-14 18:53:15 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.154201 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 18:53:15.695614) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 18:53:15.696312) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4ac8d263c7293b36a1be1aed000001be-1458005854.276392-610488406 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013930 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 18:53:15.751105) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 18:53:15.751526) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 21077a8abccf547e9ff9d40629902a676626544e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 21077a8abccf547e9ff9d40629902a676626544e --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4ac8d263c7293b36a1be1aed000001be-1458005854.276392-610488406 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-14 18:53:16,061 truncating revision to first 12 chars 2016-03-14 18:53:16,061 Setting DEBUG logging. 2016-03-14 18:53:16,061 attempt 1/10 2016-03-14 18:53:16,061 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/21077a8abccf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-14 18:53:16,298 unpacking tar archive at: mozilla-central-21077a8abccf/testing/mozharness/ program finished with exit code 0 elapsedTime=0.527574 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 18:53:16.294059) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-14 18:53:16.294466) ========= echo 21077a8abccf547e9ff9d40629902a676626544e in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'21077a8abccf547e9ff9d40629902a676626544e'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4ac8d263c7293b36a1be1aed000001be-1458005854.276392-610488406 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21077a8abccf547e9ff9d40629902a676626544e program finished with exit code 0 elapsedTime=0.004885 script_repo_revision: '21077a8abccf547e9ff9d40629902a676626544e' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-14 18:53:16.350002) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-14 18:53:16.350373) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-14 18:53:16.361337) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-03-14 18:53:16.361667) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4ac8d263c7293b36a1be1aed000001be-1458005854.276392-610488406 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:53:16 INFO - MultiFileLogger online at 20160314 18:53:16 in /builds/slave/test 18:53:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 18:53:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:53:16 INFO - {'append_to_log': False, 18:53:16 INFO - 'base_work_dir': '/builds/slave/test', 18:53:16 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 18:53:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:53:16 INFO - 'branch': 'Firefox-Non-PGO', 18:53:16 INFO - 'buildbot_json_path': 'buildprops.json', 18:53:16 INFO - 'config_files': ('talos/linux_config.py',), 18:53:16 INFO - 'default_actions': ('clobber', 18:53:16 INFO - 'read-buildbot-config', 18:53:16 INFO - 'download-and-extract', 18:53:16 INFO - 'populate-webroot', 18:53:16 INFO - 'create-virtualenv', 18:53:16 INFO - 'install', 18:53:16 INFO - 'run-tests'), 18:53:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:53:16 INFO - 'download_minidump_stackwalk': True, 18:53:16 INFO - 'download_symbols': 'ondemand', 18:53:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:53:16 INFO - 'tooltool.py': '/tools/tooltool.py', 18:53:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:53:16 INFO - '/tools/misc-python/virtualenv.py')}, 18:53:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:53:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:53:16 INFO - 'installer_path': 'installer.exe', 18:53:16 INFO - 'log_level': 'info', 18:53:16 INFO - 'log_name': 'talos', 18:53:16 INFO - 'log_to_console': True, 18:53:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:53:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:53:16 INFO - 'opt_config_files': (), 18:53:16 INFO - 'pip_index': False, 18:53:16 INFO - 'sps_profile': False, 18:53:16 INFO - 'sps_profile_interval': 0, 18:53:16 INFO - 'suite': 'dromaeojs', 18:53:16 INFO - 'system_bits': '32', 18:53:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:53:16 INFO - 'title': 'talos-linux64-ix-030', 18:53:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:53:16 INFO - 'use_talos_json': True, 18:53:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:53:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:53:16 INFO - 'work_dir': 'build'} 18:53:16 INFO - ##### 18:53:16 INFO - ##### Running clobber step. 18:53:16 INFO - ##### 18:53:16 INFO - Running pre-action listener: _resource_record_pre_action 18:53:16 INFO - Running main action method: clobber 18:53:16 INFO - rmtree: /builds/slave/test/build 18:53:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:53:17 INFO - Running post-action listener: _resource_record_post_action 18:53:17 INFO - ##### 18:53:17 INFO - ##### Running read-buildbot-config step. 18:53:17 INFO - ##### 18:53:17 INFO - Running pre-action listener: _resource_record_pre_action 18:53:17 INFO - Running main action method: read_buildbot_config 18:53:17 INFO - Using buildbot properties: 18:53:17 INFO - { 18:53:17 INFO - "project": "", 18:53:17 INFO - "product": "firefox", 18:53:17 INFO - "script_repo_revision": "production", 18:53:17 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 18:53:17 INFO - "repository": "", 18:53:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 18:53:17 INFO - "buildid": "20160314173233", 18:53:17 INFO - "pgo_build": "False", 18:53:17 INFO - "basedir": "/builds/slave/test", 18:53:17 INFO - "buildnumber": 447, 18:53:17 INFO - "slavename": "talos-linux64-ix-030", 18:53:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:53:17 INFO - "platform": "ubuntu64_hw", 18:53:17 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 18:53:17 INFO - "branch": "mozilla-central", 18:53:17 INFO - "repo_path": "mozilla-central", 18:53:17 INFO - "revision": "21077a8abccf547e9ff9d40629902a676626544e", 18:53:17 INFO - "stage_platform": "linux64", 18:53:17 INFO - "builduid": "d682d730bc49476098fb58d1cee9a0bc", 18:53:17 INFO - "slavebuilddir": "test" 18:53:17 INFO - } 18:53:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/Azh-4B7pTGGXGrHquUhqOg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 18:53:17 INFO - Running post-action listener: _resource_record_post_action 18:53:17 INFO - ##### 18:53:17 INFO - ##### Running download-and-extract step. 18:53:17 INFO - ##### 18:53:17 INFO - Running pre-action listener: _resource_record_pre_action 18:53:17 INFO - Running main action method: download_and_extract 18:53:17 INFO - mkdir: /builds/slave/test/build/tests 18:53:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:17 INFO - https://queue.taskcluster.net/v1/task/Azh-4B7pTGGXGrHquUhqOg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:53:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Azh-4B7pTGGXGrHquUhqOg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:53:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Azh-4B7pTGGXGrHquUhqOg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:53:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Azh-4B7pTGGXGrHquUhqOg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:53:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Azh-4B7pTGGXGrHquUhqOg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 18:53:17 INFO - Downloaded 1361 bytes. 18:53:17 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 18:53:17 INFO - Using the following test package requirements: 18:53:17 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 18:53:17 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:53:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:53:17 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:53:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:53:17 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:53:17 INFO - u'jsshell-linux-x86_64.zip'], 18:53:17 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:53:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:53:17 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 18:53:17 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:53:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:53:17 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:53:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:53:17 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:53:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:53:17 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 18:53:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:53:17 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:53:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:17 INFO - https://queue.taskcluster.net/v1/task/Azh-4B7pTGGXGrHquUhqOg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:53:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Azh-4B7pTGGXGrHquUhqOg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:53:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Azh-4B7pTGGXGrHquUhqOg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:53:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Azh-4B7pTGGXGrHquUhqOg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:53:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Azh-4B7pTGGXGrHquUhqOg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:53:18 INFO - Downloaded 21990584 bytes. 18:53:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:53:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 18:53:20 INFO - Return code: 0 18:53:20 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:53:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:20 INFO - https://queue.taskcluster.net/v1/task/Azh-4B7pTGGXGrHquUhqOg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:53:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Azh-4B7pTGGXGrHquUhqOg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:53:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Azh-4B7pTGGXGrHquUhqOg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:53:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Azh-4B7pTGGXGrHquUhqOg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 18:53:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Azh-4B7pTGGXGrHquUhqOg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:53:21 INFO - Downloaded 21990584 bytes. 18:53:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:53:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 18:53:22 INFO - Return code: 0 18:53:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:22 INFO - https://queue.taskcluster.net/v1/task/Azh-4B7pTGGXGrHquUhqOg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:53:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Azh-4B7pTGGXGrHquUhqOg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 18:53:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Azh-4B7pTGGXGrHquUhqOg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 18:53:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Azh-4B7pTGGXGrHquUhqOg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 18:53:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Azh-4B7pTGGXGrHquUhqOg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:53:23 INFO - Downloaded 10845263 bytes. 18:53:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:53:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 18:53:23 INFO - Return code: 0 18:53:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:23 INFO - https://queue.taskcluster.net/v1/task/Azh-4B7pTGGXGrHquUhqOg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:53:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Azh-4B7pTGGXGrHquUhqOg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:53:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Azh-4B7pTGGXGrHquUhqOg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:53:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Azh-4B7pTGGXGrHquUhqOg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:53:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Azh-4B7pTGGXGrHquUhqOg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:53:25 INFO - Downloaded 54136330 bytes. 18:53:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Azh-4B7pTGGXGrHquUhqOg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:53:25 INFO - mkdir: /builds/slave/test/properties 18:53:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:53:25 INFO - Writing to file /builds/slave/test/properties/build_url 18:53:25 INFO - Contents: 18:53:25 INFO - build_url:https://queue.taskcluster.net/v1/task/Azh-4B7pTGGXGrHquUhqOg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 18:53:26 INFO - Running post-action listener: _resource_record_post_action 18:53:26 INFO - Running post-action listener: set_extra_try_arguments 18:53:26 INFO - ##### 18:53:26 INFO - ##### Running populate-webroot step. 18:53:26 INFO - ##### 18:53:26 INFO - Running pre-action listener: _resource_record_pre_action 18:53:26 INFO - Running main action method: populate_webroot 18:53:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:53:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:53:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:53:26 INFO - '--tppagecycles', 18:53:26 INFO - '7'], 18:53:26 INFO - 'tests': ['tsvgm']}}, 18:53:26 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:53:26 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:53:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:53:26 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 18:53:26 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:53:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:53:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:53:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:53:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:53:26 INFO - 'talos_options': ['--e10s'], 18:53:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:53:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:53:26 INFO - 'tests': ['damp', 'tps']}, 18:53:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:53:26 INFO - 'talos_options': ['--e10s'], 18:53:26 INFO - 'tests': ['damp', 'tps']}, 18:53:26 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:53:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:53:26 INFO - 'other': {'tests': ['a11yr', 18:53:26 INFO - 'ts_paint', 18:53:26 INFO - 'tpaint', 18:53:26 INFO - 'sessionrestore', 18:53:26 INFO - 'sessionrestore_no_auto_restore', 18:53:26 INFO - 'tabpaint']}, 18:53:26 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:53:26 INFO - 'tests': ['a11yr', 18:53:26 INFO - 'ts_paint', 18:53:26 INFO - 'tpaint', 18:53:26 INFO - 'sessionrestore', 18:53:26 INFO - 'sessionrestore_no_auto_restore', 18:53:26 INFO - 'tabpaint']}, 18:53:26 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:53:26 INFO - 'tests': ['a11yr', 18:53:26 INFO - 'ts_paint', 18:53:26 INFO - 'tpaint', 18:53:26 INFO - 'sessionrestore', 18:53:26 INFO - 'sessionrestore_no_auto_restore', 18:53:26 INFO - 'tabpaint']}, 18:53:26 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:53:26 INFO - 'tests': ['a11yr', 18:53:26 INFO - 'ts_paint', 18:53:26 INFO - 'tpaint', 18:53:26 INFO - 'sessionrestore', 18:53:26 INFO - 'sessionrestore_no_auto_restore', 18:53:26 INFO - 'tabpaint']}, 18:53:26 INFO - 'other_l64': {'tests': ['a11yr', 18:53:26 INFO - 'ts_paint', 18:53:26 INFO - 'tpaint', 18:53:26 INFO - 'sessionrestore', 18:53:26 INFO - 'sessionrestore_no_auto_restore', 18:53:26 INFO - 'tabpaint']}, 18:53:26 INFO - 'other_nol64': {'tests': ['a11yr', 18:53:26 INFO - 'ts_paint', 18:53:26 INFO - 'tpaint', 18:53:26 INFO - 'sessionrestore', 18:53:26 INFO - 'sessionrestore_no_auto_restore', 18:53:26 INFO - 'tabpaint']}, 18:53:26 INFO - 'svgr': {'tests': ['tsvgx', 18:53:26 INFO - 'tsvgr_opacity', 18:53:26 INFO - 'tart', 18:53:26 INFO - 'tscrollx', 18:53:26 INFO - 'cart']}, 18:53:26 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:53:26 INFO - 'tests': ['tsvgx', 18:53:26 INFO - 'tsvgr_opacity', 18:53:26 INFO - 'tart', 18:53:26 INFO - 'tscrollx', 18:53:26 INFO - 'cart']}, 18:53:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:53:26 INFO - 'tests': ['tp5o']}, 18:53:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:53:26 INFO - 'talos_options': ['--e10s'], 18:53:26 INFO - 'tests': ['tp5o']}, 18:53:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:53:26 INFO - 'talos_options': ['--xperf_path', 18:53:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:53:26 INFO - 'tests': ['tp5n']}, 18:53:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:53:26 INFO - 'talos_options': ['--e10s', 18:53:26 INFO - '--xperf_path', 18:53:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:53:26 INFO - 'tests': ['tp5n']}}, 18:53:26 INFO - 'talos.zip': {'path': '', 18:53:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:53:26 INFO - Running post-action listener: _resource_record_post_action 18:53:26 INFO - ##### 18:53:26 INFO - ##### Running create-virtualenv step. 18:53:26 INFO - ##### 18:53:26 INFO - Running pre-action listener: _resource_record_pre_action 18:53:26 INFO - Running main action method: create_virtualenv 18:53:26 INFO - Creating virtualenv /builds/slave/test/build/venv 18:53:26 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:53:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:53:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:53:26 INFO - Using real prefix '/usr' 18:53:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:53:26 INFO - Installing distribute.............................................................................................................................................................................................done. 18:53:28 INFO - Installing pip.................done. 18:53:28 INFO - Return code: 0 18:53:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:53:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:53:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:53:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa45fc01f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe02410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe91160>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe92060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe924f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1458005854.276392-610488406', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:53:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:53:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:53:28 INFO - Using env: {'DISPLAY': ':0', 18:53:28 INFO - 'HOME': '/home/cltbld', 18:53:28 INFO - 'LANG': 'en_US.UTF-8', 18:53:28 INFO - 'LANGUAGE': 'en_US:en', 18:53:28 INFO - 'LOGNAME': 'cltbld', 18:53:28 INFO - 'MAIL': '/var/mail/cltbld', 18:53:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:28 INFO - 'MOZ_NO_REMOTE': '1', 18:53:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:53:28 INFO - 'NO_EM_RESTART': '1', 18:53:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:53:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:53:28 INFO - 'PWD': '/builds/slave/test', 18:53:28 INFO - 'SHELL': '/bin/bash', 18:53:28 INFO - 'SHLVL': '1', 18:53:28 INFO - 'TERM': 'linux', 18:53:28 INFO - 'TMOUT': '86400', 18:53:28 INFO - 'USER': 'cltbld', 18:53:28 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1458005854.276392-610488406', 18:53:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:28 INFO - '_': '/tools/buildbot/bin/python'} 18:53:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:53:28 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:53:28 INFO - Cleaning up... 18:53:28 INFO - Return code: 0 18:53:28 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:53:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:53:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:53:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa45fc01f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe02410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe91160>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe92060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe924f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1458005854.276392-610488406', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:53:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 18:53:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 18:53:28 INFO - Using env: {'DISPLAY': ':0', 18:53:28 INFO - 'HOME': '/home/cltbld', 18:53:28 INFO - 'LANG': 'en_US.UTF-8', 18:53:28 INFO - 'LANGUAGE': 'en_US:en', 18:53:28 INFO - 'LOGNAME': 'cltbld', 18:53:28 INFO - 'MAIL': '/var/mail/cltbld', 18:53:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:28 INFO - 'MOZ_NO_REMOTE': '1', 18:53:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:53:28 INFO - 'NO_EM_RESTART': '1', 18:53:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:53:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:53:28 INFO - 'PWD': '/builds/slave/test', 18:53:28 INFO - 'SHELL': '/bin/bash', 18:53:28 INFO - 'SHLVL': '1', 18:53:28 INFO - 'TERM': 'linux', 18:53:28 INFO - 'TMOUT': '86400', 18:53:28 INFO - 'USER': 'cltbld', 18:53:28 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1458005854.276392-610488406', 18:53:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:28 INFO - '_': '/tools/buildbot/bin/python'} 18:53:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:53:29 INFO - Downloading/unpacking psutil>=0.7.1 18:53:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:53:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:53:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:53:31 INFO - Installing collected packages: psutil 18:53:31 INFO - Running setup.py install for psutil 18:53:31 INFO - building 'psutil._psutil_linux' extension 18:53:31 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 18:53:31 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 18:53:31 INFO - building 'psutil._psutil_posix' extension 18:53:31 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 18:53:31 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 18:53:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:53:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:53:31 INFO - Successfully installed psutil 18:53:31 INFO - Cleaning up... 18:53:31 INFO - Return code: 0 18:53:31 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:53:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:53:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:53:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa45fc01f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe02410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe91160>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe92060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe924f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1458005854.276392-610488406', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:53:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 18:53:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 18:53:31 INFO - Using env: {'DISPLAY': ':0', 18:53:31 INFO - 'HOME': '/home/cltbld', 18:53:31 INFO - 'LANG': 'en_US.UTF-8', 18:53:31 INFO - 'LANGUAGE': 'en_US:en', 18:53:31 INFO - 'LOGNAME': 'cltbld', 18:53:31 INFO - 'MAIL': '/var/mail/cltbld', 18:53:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:31 INFO - 'MOZ_NO_REMOTE': '1', 18:53:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:53:31 INFO - 'NO_EM_RESTART': '1', 18:53:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:53:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:53:31 INFO - 'PWD': '/builds/slave/test', 18:53:31 INFO - 'SHELL': '/bin/bash', 18:53:31 INFO - 'SHLVL': '1', 18:53:31 INFO - 'TERM': 'linux', 18:53:31 INFO - 'TMOUT': '86400', 18:53:31 INFO - 'USER': 'cltbld', 18:53:31 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1458005854.276392-610488406', 18:53:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:31 INFO - '_': '/tools/buildbot/bin/python'} 18:53:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:53:31 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:33 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:53:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:53:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:53:33 INFO - Installing collected packages: mozsystemmonitor 18:53:33 INFO - Running setup.py install for mozsystemmonitor 18:53:33 INFO - Successfully installed mozsystemmonitor 18:53:33 INFO - Cleaning up... 18:53:33 INFO - Return code: 0 18:53:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:53:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:53:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:53:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa45fc01f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe02410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe91160>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe92060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe924f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1458005854.276392-610488406', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:53:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:53:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:53:33 INFO - Using env: {'DISPLAY': ':0', 18:53:33 INFO - 'HOME': '/home/cltbld', 18:53:33 INFO - 'LANG': 'en_US.UTF-8', 18:53:33 INFO - 'LANGUAGE': 'en_US:en', 18:53:33 INFO - 'LOGNAME': 'cltbld', 18:53:33 INFO - 'MAIL': '/var/mail/cltbld', 18:53:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:33 INFO - 'MOZ_NO_REMOTE': '1', 18:53:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:53:33 INFO - 'NO_EM_RESTART': '1', 18:53:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:53:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:53:33 INFO - 'PWD': '/builds/slave/test', 18:53:33 INFO - 'SHELL': '/bin/bash', 18:53:33 INFO - 'SHLVL': '1', 18:53:33 INFO - 'TERM': 'linux', 18:53:33 INFO - 'TMOUT': '86400', 18:53:33 INFO - 'USER': 'cltbld', 18:53:33 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1458005854.276392-610488406', 18:53:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:33 INFO - '_': '/tools/buildbot/bin/python'} 18:53:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:53:34 INFO - Downloading/unpacking blobuploader==1.2.4 18:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:35 INFO - Downloading blobuploader-1.2.4.tar.gz 18:53:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:53:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:53:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:53:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:53:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:36 INFO - Downloading docopt-0.6.1.tar.gz 18:53:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:53:36 INFO - Installing collected packages: blobuploader, requests, docopt 18:53:36 INFO - Running setup.py install for blobuploader 18:53:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:53:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:53:36 INFO - Running setup.py install for requests 18:53:37 INFO - Running setup.py install for docopt 18:53:37 INFO - Successfully installed blobuploader requests docopt 18:53:37 INFO - Cleaning up... 18:53:37 INFO - Return code: 0 18:53:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:53:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:53:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:53:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa45fc01f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe02410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe91160>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe92060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe924f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1458005854.276392-610488406', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:53:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:53:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:53:37 INFO - Using env: {'DISPLAY': ':0', 18:53:37 INFO - 'HOME': '/home/cltbld', 18:53:37 INFO - 'LANG': 'en_US.UTF-8', 18:53:37 INFO - 'LANGUAGE': 'en_US:en', 18:53:37 INFO - 'LOGNAME': 'cltbld', 18:53:37 INFO - 'MAIL': '/var/mail/cltbld', 18:53:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:37 INFO - 'MOZ_NO_REMOTE': '1', 18:53:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:53:37 INFO - 'NO_EM_RESTART': '1', 18:53:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:53:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:53:37 INFO - 'PWD': '/builds/slave/test', 18:53:37 INFO - 'SHELL': '/bin/bash', 18:53:37 INFO - 'SHLVL': '1', 18:53:37 INFO - 'TERM': 'linux', 18:53:37 INFO - 'TMOUT': '86400', 18:53:37 INFO - 'USER': 'cltbld', 18:53:37 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1458005854.276392-610488406', 18:53:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:37 INFO - '_': '/tools/buildbot/bin/python'} 18:53:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:53:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:53:37 INFO - Running setup.py (path:/tmp/pip-wQTamt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:53:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:53:37 INFO - Running setup.py (path:/tmp/pip-hcXw8Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:53:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:53:37 INFO - Running setup.py (path:/tmp/pip-M4E8og-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:53:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:53:37 INFO - Running setup.py (path:/tmp/pip-dXM_fT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:53:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:53:37 INFO - Running setup.py (path:/tmp/pip-pC6Yf6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:53:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:53:37 INFO - Running setup.py (path:/tmp/pip-wVP5GB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:53:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:53:37 INFO - Running setup.py (path:/tmp/pip-qxRjzj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:53:38 INFO - Running setup.py (path:/tmp/pip-RLm83B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:53:38 INFO - Running setup.py (path:/tmp/pip-qi3m2V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:53:38 INFO - Running setup.py (path:/tmp/pip-xzstzY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:53:38 INFO - Running setup.py (path:/tmp/pip-1rrcQF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:53:38 INFO - Running setup.py (path:/tmp/pip-QrKVCB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:53:38 INFO - Running setup.py (path:/tmp/pip-sMHvNS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:53:38 INFO - Running setup.py (path:/tmp/pip-WhEb3_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:53:38 INFO - Running setup.py (path:/tmp/pip-57bMmR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:53:38 INFO - Running setup.py (path:/tmp/pip-r_uJNd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:53:38 INFO - Running setup.py (path:/tmp/pip-TMtvTg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:53:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:53:38 INFO - Running setup.py install for manifestparser 18:53:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:53:38 INFO - Running setup.py install for mozcrash 18:53:38 INFO - Running setup.py install for mozdebug 18:53:39 INFO - Running setup.py install for mozdevice 18:53:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:53:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:53:39 INFO - Running setup.py install for mozfile 18:53:39 INFO - Running setup.py install for mozhttpd 18:53:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:53:39 INFO - Running setup.py install for mozinfo 18:53:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:53:39 INFO - Running setup.py install for mozInstall 18:53:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:53:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:53:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:53:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:53:39 INFO - Running setup.py install for mozleak 18:53:39 INFO - Running setup.py install for mozlog 18:53:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:53:39 INFO - Running setup.py install for moznetwork 18:53:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:53:39 INFO - Running setup.py install for mozprocess 18:53:39 INFO - Running setup.py install for mozprofile 18:53:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:53:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:53:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:53:40 INFO - Running setup.py install for mozrunner 18:53:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:53:40 INFO - Running setup.py install for mozscreenshot 18:53:40 INFO - Running setup.py install for moztest 18:53:40 INFO - Running setup.py install for mozversion 18:53:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:53:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:53:40 INFO - Cleaning up... 18:53:40 INFO - Return code: 0 18:53:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:53:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:53:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:53:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa45fc01f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe02410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe91160>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe92060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe924f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1458005854.276392-610488406', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:53:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:53:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:53:40 INFO - Using env: {'DISPLAY': ':0', 18:53:40 INFO - 'HOME': '/home/cltbld', 18:53:40 INFO - 'LANG': 'en_US.UTF-8', 18:53:40 INFO - 'LANGUAGE': 'en_US:en', 18:53:40 INFO - 'LOGNAME': 'cltbld', 18:53:40 INFO - 'MAIL': '/var/mail/cltbld', 18:53:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:40 INFO - 'MOZ_NO_REMOTE': '1', 18:53:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:53:40 INFO - 'NO_EM_RESTART': '1', 18:53:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:53:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:53:40 INFO - 'PWD': '/builds/slave/test', 18:53:40 INFO - 'SHELL': '/bin/bash', 18:53:40 INFO - 'SHLVL': '1', 18:53:40 INFO - 'TERM': 'linux', 18:53:40 INFO - 'TMOUT': '86400', 18:53:40 INFO - 'USER': 'cltbld', 18:53:40 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1458005854.276392-610488406', 18:53:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:40 INFO - '_': '/tools/buildbot/bin/python'} 18:53:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:53:40 INFO - Running setup.py (path:/tmp/pip-xUbbiI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:53:40 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 18:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:53:40 INFO - Running setup.py (path:/tmp/pip-3uSKxl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:53:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:53:40 INFO - Running setup.py (path:/tmp/pip-60kVlU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:53:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:53:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:53:40 INFO - Running setup.py (path:/tmp/pip-5HtdHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:53:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:53:41 INFO - Running setup.py (path:/tmp/pip-vPvOd2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:53:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 18:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:53:41 INFO - Running setup.py (path:/tmp/pip-KXuUEH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:53:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 18:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:53:41 INFO - Running setup.py (path:/tmp/pip-x4EVD2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:53:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 18:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:53:41 INFO - Running setup.py (path:/tmp/pip-F3a5jQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:53:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:53:41 INFO - Running setup.py (path:/tmp/pip-SzXnQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:53:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 18:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:53:41 INFO - Running setup.py (path:/tmp/pip-W4CMFb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:53:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:53:41 INFO - Running setup.py (path:/tmp/pip-LkMqwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:53:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 18:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:53:41 INFO - Running setup.py (path:/tmp/pip-diWpm6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:53:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:53:41 INFO - Running setup.py (path:/tmp/pip-lReyeV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:53:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 18:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:53:41 INFO - Running setup.py (path:/tmp/pip-ztaWRm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:53:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:53:41 INFO - Running setup.py (path:/tmp/pip-re4roh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:53:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 18:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:53:41 INFO - Running setup.py (path:/tmp/pip-thCx_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:53:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:53:41 INFO - Running setup.py (path:/tmp/pip-WTJCD7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:53:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 18:53:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:53:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:53:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:53:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:53:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:53:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:53:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:43 INFO - Downloading blessings-1.6.tar.gz 18:53:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:53:43 INFO - Installing collected packages: blessings 18:53:43 INFO - Running setup.py install for blessings 18:53:43 INFO - Successfully installed blessings 18:53:43 INFO - Cleaning up... 18:53:44 INFO - Return code: 0 18:53:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:53:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:53:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:53:44 INFO - Reading from file tmpfile_stdout 18:53:44 INFO - Current package versions: 18:53:44 INFO - argparse == 1.2.1 18:53:44 INFO - blessings == 1.6 18:53:44 INFO - blobuploader == 1.2.4 18:53:44 INFO - docopt == 0.6.1 18:53:44 INFO - manifestparser == 1.1 18:53:44 INFO - mozInstall == 1.12 18:53:44 INFO - mozcrash == 0.17 18:53:44 INFO - mozdebug == 0.1 18:53:44 INFO - mozdevice == 0.48 18:53:44 INFO - mozfile == 1.2 18:53:44 INFO - mozhttpd == 0.7 18:53:44 INFO - mozinfo == 0.9 18:53:44 INFO - mozleak == 0.1 18:53:44 INFO - mozlog == 3.1 18:53:44 INFO - moznetwork == 0.27 18:53:44 INFO - mozprocess == 0.22 18:53:44 INFO - mozprofile == 0.28 18:53:44 INFO - mozrunner == 6.11 18:53:44 INFO - mozscreenshot == 0.1 18:53:44 INFO - mozsystemmonitor == 0.0 18:53:44 INFO - moztest == 0.7 18:53:44 INFO - mozversion == 1.4 18:53:44 INFO - psutil == 3.1.1 18:53:44 INFO - requests == 1.2.3 18:53:44 INFO - wsgiref == 0.1.2 18:53:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:53:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:53:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:53:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa45fc01f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe02410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe91160>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe92060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe924f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1458005854.276392-610488406', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:53:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 18:53:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:53:44 INFO - Using env: {'DISPLAY': ':0', 18:53:44 INFO - 'HOME': '/home/cltbld', 18:53:44 INFO - 'LANG': 'en_US.UTF-8', 18:53:44 INFO - 'LANGUAGE': 'en_US:en', 18:53:44 INFO - 'LOGNAME': 'cltbld', 18:53:44 INFO - 'MAIL': '/var/mail/cltbld', 18:53:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:44 INFO - 'MOZ_NO_REMOTE': '1', 18:53:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:53:44 INFO - 'NO_EM_RESTART': '1', 18:53:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:53:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:53:44 INFO - 'PWD': '/builds/slave/test', 18:53:44 INFO - 'SHELL': '/bin/bash', 18:53:44 INFO - 'SHLVL': '1', 18:53:44 INFO - 'TERM': 'linux', 18:53:44 INFO - 'TMOUT': '86400', 18:53:44 INFO - 'USER': 'cltbld', 18:53:44 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1458005854.276392-610488406', 18:53:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:44 INFO - '_': '/tools/buildbot/bin/python'} 18:53:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:53:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:53:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 18:53:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 18:53:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:53:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 18:53:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 18:53:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 18:53:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 18:53:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 18:53:44 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:53:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:53:44 INFO - Cleaning up... 18:53:44 INFO - Return code: 0 18:53:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:53:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:53:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:53:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa45fc01f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe02410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe91160>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe92060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe924f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1458005854.276392-610488406', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:53:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:53:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:53:44 INFO - Using env: {'DISPLAY': ':0', 18:53:44 INFO - 'HOME': '/home/cltbld', 18:53:44 INFO - 'LANG': 'en_US.UTF-8', 18:53:44 INFO - 'LANGUAGE': 'en_US:en', 18:53:44 INFO - 'LOGNAME': 'cltbld', 18:53:44 INFO - 'MAIL': '/var/mail/cltbld', 18:53:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:44 INFO - 'MOZ_NO_REMOTE': '1', 18:53:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:53:44 INFO - 'NO_EM_RESTART': '1', 18:53:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:53:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:53:44 INFO - 'PWD': '/builds/slave/test', 18:53:44 INFO - 'SHELL': '/bin/bash', 18:53:44 INFO - 'SHLVL': '1', 18:53:44 INFO - 'TERM': 'linux', 18:53:44 INFO - 'TMOUT': '86400', 18:53:44 INFO - 'USER': 'cltbld', 18:53:44 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1458005854.276392-610488406', 18:53:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:44 INFO - '_': '/tools/buildbot/bin/python'} 18:53:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:53:44 INFO - Downloading/unpacking jsonschema 18:53:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:53:46 INFO - Downloading/unpacking functools32 (from jsonschema) 18:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:46 INFO - Downloading functools32-3.2.3-2.tar.gz 18:53:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:53:46 INFO - warning: no files found matching '*.txt' 18:53:46 INFO - no previously-included directories found matching 'build' 18:53:46 INFO - no previously-included directories found matching 'dist' 18:53:46 INFO - no previously-included directories found matching '.git*' 18:53:46 INFO - Installing collected packages: jsonschema, functools32 18:53:46 INFO - Running setup.py install for functools32 18:53:46 INFO - warning: no files found matching '*.txt' 18:53:46 INFO - no previously-included directories found matching 'build' 18:53:46 INFO - no previously-included directories found matching 'dist' 18:53:46 INFO - no previously-included directories found matching '.git*' 18:53:46 INFO - Successfully installed jsonschema functools32 18:53:46 INFO - Cleaning up... 18:53:47 INFO - Return code: 0 18:53:47 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:53:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:53:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:53:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa45fc01f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe02410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe91160>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe92060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe924f0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1458005854.276392-610488406', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:53:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 18:53:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 18:53:47 INFO - Using env: {'DISPLAY': ':0', 18:53:47 INFO - 'HOME': '/home/cltbld', 18:53:47 INFO - 'LANG': 'en_US.UTF-8', 18:53:47 INFO - 'LANGUAGE': 'en_US:en', 18:53:47 INFO - 'LOGNAME': 'cltbld', 18:53:47 INFO - 'MAIL': '/var/mail/cltbld', 18:53:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:47 INFO - 'MOZ_NO_REMOTE': '1', 18:53:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:53:47 INFO - 'NO_EM_RESTART': '1', 18:53:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:53:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:53:47 INFO - 'PWD': '/builds/slave/test', 18:53:47 INFO - 'SHELL': '/bin/bash', 18:53:47 INFO - 'SHLVL': '1', 18:53:47 INFO - 'TERM': 'linux', 18:53:47 INFO - 'TMOUT': '86400', 18:53:47 INFO - 'USER': 'cltbld', 18:53:47 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1458005854.276392-610488406', 18:53:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:47 INFO - '_': '/tools/buildbot/bin/python'} 18:53:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:53:47 INFO - Downloading/unpacking flake8 18:53:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:49 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:53:49 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:53:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:49 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:53:49 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:53:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:49 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:53:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:53:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:53:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:53:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:53:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:53:49 INFO - no previously-included directories found matching 'docs/_build' 18:53:49 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:53:49 INFO - Running setup.py install for pep8 18:53:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:53:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:53:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:53:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:53:49 INFO - no previously-included directories found matching 'docs/_build' 18:53:49 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:53:49 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:53:49 INFO - Cleaning up... 18:53:50 INFO - Return code: 0 18:53:50 INFO - Running post-action listener: _resource_record_post_action 18:53:50 INFO - Running post-action listener: _start_resource_monitoring 18:53:50 INFO - Starting resource monitoring. 18:53:50 INFO - ##### 18:53:50 INFO - ##### Running install step. 18:53:50 INFO - ##### 18:53:50 INFO - Running pre-action listener: _resource_record_pre_action 18:53:50 INFO - Running main action method: install 18:53:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:53:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:53:50 INFO - Reading from file tmpfile_stdout 18:53:50 INFO - Detecting whether we're running mozinstall >=1.0... 18:53:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:53:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:53:50 INFO - Reading from file tmpfile_stdout 18:53:50 INFO - Output received: 18:53:50 INFO - Usage: mozinstall [options] installer 18:53:50 INFO - Options: 18:53:50 INFO - -h, --help show this help message and exit 18:53:50 INFO - -d DEST, --destination=DEST 18:53:50 INFO - Directory to install application into. [default: 18:53:50 INFO - "/builds/slave/test"] 18:53:50 INFO - --app=APP Application being installed. [default: firefox] 18:53:50 INFO - mkdir: /builds/slave/test/build/application 18:53:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:53:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 18:54:06 INFO - Reading from file tmpfile_stdout 18:54:06 INFO - Output received: 18:54:06 INFO - /builds/slave/test/build/application/firefox/firefox 18:54:06 INFO - Running post-action listener: _resource_record_post_action 18:54:06 INFO - ##### 18:54:06 INFO - ##### Running run-tests step. 18:54:06 INFO - ##### 18:54:06 INFO - Running pre-action listener: _resource_record_pre_action 18:54:06 INFO - Running main action method: run_tests 18:54:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:54:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:54:06 INFO - Python 2.7.3 18:54:06 INFO - Return code: 0 18:54:06 INFO - grabbing minidump binary from tooltool 18:54:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:54:06 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe91160>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe92060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe924f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:54:06 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:54:06 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 18:54:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:54:06 INFO - Return code: 0 18:54:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:54:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:54:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:54:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:54:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:54:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:54:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:54:07 INFO - Return code: 0 18:54:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Azh-4B7pTGGXGrHquUhqOg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 18:54:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Azh-4B7pTGGXGrHquUhqOg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-030 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 18:54:07 INFO - Using env: {'DISPLAY': ':0', 18:54:07 INFO - 'HOME': '/home/cltbld', 18:54:07 INFO - 'LANG': 'en_US.UTF-8', 18:54:07 INFO - 'LANGUAGE': 'en_US:en', 18:54:07 INFO - 'LOGNAME': 'cltbld', 18:54:07 INFO - 'MAIL': '/var/mail/cltbld', 18:54:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:54:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:54:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:54:07 INFO - 'MOZ_NO_REMOTE': '1', 18:54:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:54:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:54:07 INFO - 'NO_EM_RESTART': '1', 18:54:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:54:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:54:07 INFO - 'PWD': '/builds/slave/test', 18:54:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:54:07 INFO - 'SHELL': '/bin/bash', 18:54:07 INFO - 'SHLVL': '1', 18:54:07 INFO - 'TERM': 'linux', 18:54:07 INFO - 'TMOUT': '86400', 18:54:07 INFO - 'USER': 'cltbld', 18:54:07 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1458005854.276392-610488406', 18:54:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:54:07 INFO - '_': '/tools/buildbot/bin/python'} 18:54:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Azh-4B7pTGGXGrHquUhqOg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 18:54:07 INFO - mozversion application_buildid: 20160314173233 18:54:07 INFO - mozversion application_changeset: 21077a8abccf547e9ff9d40629902a676626544e 18:54:07 INFO - mozversion application_display_name: Nightly 18:54:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:54:07 INFO - mozversion application_name: Firefox 18:54:07 INFO - mozversion application_remotingname: firefox 18:54:07 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:54:07 INFO - mozversion application_vendor: Mozilla 18:54:07 INFO - mozversion application_version: 48.0a1 18:54:07 INFO - mozversion platform_buildid: 20160314173233 18:54:07 INFO - mozversion platform_changeset: 21077a8abccf547e9ff9d40629902a676626544e 18:54:07 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:54:07 INFO - mozversion platform_version: 48.0a1 18:54:07 INFO - using testdate: 1458006847 18:54:07 INFO - actual date: 1458006847 18:54:07 INFO - starting webserver on 'localhost:57356' 18:54:07 INFO - SUITE-START | Running 2 tests 18:54:07 INFO - TEST-START | dromaeo_css 18:54:07 INFO - operating with platform_type : linux_ 18:54:07 INFO - Initialising browser for dromaeo_css test... 18:54:07 INFO - TEST-INFO | started process 30856 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHCx9L4/profile http://localhost:57356/getInfo.html) 18:54:11 INFO - PROCESS | 30856 | __metrics Screen width/height:1600/1200 18:54:11 INFO - PROCESS | 30856 | colorDepth:24 18:54:11 INFO - PROCESS | 30856 | Browser inner width/height: 1024/697 18:54:11 INFO - PROCESS | 30856 | __metrics 18:54:12 ERROR - PROCESS | 30856 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:54:13 INFO - TEST-INFO | 30856: exit 0 18:54:13 INFO - Browser initialized. 18:54:13 INFO - Running cycle 1/1 for dromaeo_css test... 18:54:13 INFO - TEST-INFO | started process 30946 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHCx9L4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:54:25 INFO - PROCESS | 30946 | RSS: Main: 153948160 18:54:25 INFO - PROCESS | 30946 | 18:55:16 INFO - PROCESS | 30946 | 1458006916646 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 18:57:28 INFO - PROCESS | 30946 | Cycle 1(1): loaded http://localhost:57356/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57356/tests/dromaeo/cssquery-ext.html) 18:57:29 INFO - PROCESS | 30946 | RSS: Main: 229646336 18:57:29 INFO - PROCESS | 30946 | 19:00:31 INFO - PROCESS | 30946 | Cycle 1(1): loaded http://localhost:57356/tests/dromaeo/cssquery-ext.html (next: http://localhost:57356/tests/dromaeo/cssquery-jquery.html) 19:00:32 INFO - PROCESS | 30946 | RSS: Main: 240840704 19:00:32 INFO - PROCESS | 30946 | 19:03:34 INFO - PROCESS | 30946 | Cycle 1(1): loaded http://localhost:57356/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57356/tests/dromaeo/cssquery-mootools.html) 19:03:34 INFO - PROCESS | 30946 | RSS: Main: 240771072 19:03:34 INFO - PROCESS | 30946 | 19:06:36 INFO - PROCESS | 30946 | Cycle 1(1): loaded http://localhost:57356/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57356/tests/dromaeo/cssquery-prototype.html) 19:06:37 INFO - PROCESS | 30946 | RSS: Main: 196882432 19:06:37 INFO - PROCESS | 30946 | 19:09:39 INFO - PROCESS | 30946 | Cycle 1(1): loaded http://localhost:57356/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57356/tests/dromaeo/cssquery-yui.html) 19:09:40 INFO - PROCESS | 30946 | RSS: Main: 204218368 19:09:40 INFO - PROCESS | 30946 | 19:12:42 INFO - PROCESS | 30946 | Cycle 1(1): loaded http://localhost:57356/tests/dromaeo/cssquery-yui.html (next: http://localhost:57356/tests/dromaeo/cssquery-dojo.html) 19:12:43 INFO - PROCESS | 30946 | RSS: Main: 270839808 19:12:43 INFO - PROCESS | 30946 | 19:12:43 INFO - PROCESS | 30946 | __start_tp_report 19:12:43 INFO - PROCESS | 30946 | _x_x_mozilla_page_load 19:12:43 INFO - PROCESS | 30946 | _x_x_mozilla_page_load_details 19:12:43 INFO - PROCESS | 30946 | |i|pagename|runs| 19:12:43 INFO - PROCESS | 30946 | |0;dojo.html;2608.321836322556;2652;2685.5300322443572;2696.32591852037;2696.366353906833;4579.267317229244;4654.883627909299;4677.999999999995;4683.76581170941;4715.669903106784;4623.468301145369;4676.485586585472;4679.76601169941;4681.344611754357;4692.906141877161;4175.269327867626;4254.87235382939;4305.203537345586;4340.1102773931425;4360.302351623741;4188.099558594901;4257.446531950842;4333.306670932651;4337.978310108445;4349.499807522144;4236.152769446092;4238.597333253336;4283.87148385549;4310;4315.956840431587;4210.242156411845;4213.810378532973;4214.346776249687;4218.557051509578;4252.744835309892;4190.308599081148;4208.810603522848;4211.410402543646;4245.830166793356;4249.4475718156755;4518.615917647004;4530.3204519322035;4558.270676691714;4605.700629459075;4616.53834616539;4963.057019166346;4979.925301120486;4986.700797952134;5033.647644664875;5035.723035233061;4972.328735620681;5004.749762511859;5005.749712514396;5007.424146223195;5008.048470790538;4670.112678591091;4745.905081898342;4748.240281554935;4754.524547545287;4754.738489383048;5100.8778068824795;5139.640225184276;5140.383154021467;5140.408852981955;5141.048905952411;4786.760661966888;4915.287283343895;4916.631252656065;4917.262410638361;4965.82619608312;4993.450720420751;5004.674696144739;5019.598432125421;5063;5067.062593420229;4986.301917731521;4999.900001999939;5000.099982003274;5002.649814512949;5048.924266136011;4802.375691160127;4937.8271760488215;4964.429090654621;4979.178435558165;5035.420926593415;4191.224623444673;4195.49654041517;4217.768022758716;4222.514410842731;4253.787310634456;3701.204241088125;3708.5364329458816;3713.9071523212137;3742.962570374316;3753.8123093845197;4334.956650433455;4376;4387.956120438818;4400.295952647561;4420.115976804652;5058.620603454756;5062.620303477181;5066.06277838601;5067.5185857343495;5080.7205603692155;4390.3414487827085;4400.295952647625;4402.757848318309;4426.291793313055;4433.135538569948;4430.468343798765;4504.6396288296855;4523.479799823062;4558.703684260512;4578.381918441034;4773.37946067009;4773.570378665937;4790.7844147012775;4791.425028996473;4821.7348045856415;5015.623828212972;5045.091883460866;5047.343845300087;5049.065922804293;5092.668976516515;4696.530346965276;4748.572628463455;4766.642501812447;4813.085513752376;4826.251930950708;4935.75321233944;4936.432310284364;4958.57852082577;4960.8759781005765;4997.625178111583;4930.457649658606;5018.723970181675;5029.421616514148;5032.798688052583;5078.669886457368;4842.370491836039;4845.515448455127;4866;4894.265860120868;4922.409310882717;4868.902621947612;4894.070126675921;4895.46149923501;4905.484924083063;4954.826581069645;4684.718916864999;4758.690685105457;4828.61371090319;4843.07981483517;4886.462489126265;4775.188218003017;4817.494163112963;4881.536254055859;4889.828855990023;4934.728589927445;4803.471618122074;4812.326274321527;4825.662203645851;4827.300041494034;4869.756512174448 19:12:43 INFO - PROCESS | 30946 | |1;ext.html;533.674458580266;541.8564080518663;547.1819629653669;564.5709260961668;576.7491141353512;27011;37234.81382593087;37846;37881.810590947;37973.43039854404;41074.38388424176;41595.58404415955;41685;41752.16495670092;41773.79113104438;7839.568823714708;8036.477628954129;8040.356771458299;8042;8043.638036288352;7771.533707977539;7858.096318923312;7858.842823143534;7876.094249161334;7884.290413862751;7890.921090789105;7926.841463170733;7946.880796788053;7952.721654742085;7961.1242763295995;7841.294283514482;7864.449488535804;7869.331106855867;7880.724174653859;7904.723334683258;7832.412569057344;7975.322097621709;7976.162502937166;7979;7980.241877021732;37362.065948351235;37706.43440348397;37761.0559736006;37773.433398499044;37788;2938.045135331026;3074.677158898306;3210.085125739153;3361.344537815127;3377.2907689385015;28984.565231521545;29128.271793205127;29324.853375732986;29333.43948410722;29656.40687186244;3273.836308184605;3282.8522716477814;3302.78531895426;3316.535685004101;3352.4468462703867;252657;254207;254613.72693136602;255329;256858;41118.38322425166;55216;55381;55510.72244638751;55566.16650750242;42177.36733948993;42255;42652.78673606612;42684.359734604004;42685.35971960423;12809.423575939105;13081.084324097223;13083.215007099605;13085.803712944313;13095.672608184872;10598.25812193139;10687.412192329497;10692.411917344465;10697.090747286567;10704.839427408438;14646.853531464762;14678.559643210721;14708.55874323772;14747.92626036863;14814;5771.711414429262;5900.645961242253;5940.46535811779;5958.970205149033;6040.335563088057;887.401004322093;906.5467266366817;960.4621412009298;992.6376872441507;1033.4625994482826;29110;30598.54102188469;30633.81508789566;31104.22239443987;33160.66839331624;860.9827803444022;991.0981007283337;992.965246216379;1005.1355833982769;1059.8728152621734;12819.294938778457;13130.293061901892;13251.271180084996;13360.93319533396;13407.731845363038;367920;368719;375015.8738094599;375247;376182;45843.541564583924;46256.53743462522;46258.30612540815;46264.53735462602;46359.76820115945;1081.6268387406333;1138.7551676389617;1225.1668865171769;1249.194269696041;1266.9303188324545;26222.86888565545;27739.44521109607;28008.859955700093;28109.859450703432;28214.294642634097;38964.61035389723;39312.803435982634;39560;39571;39610.80194599008;210448;213705;214646;215385;216919;26566.070187543344;30947.69052309538;31580.368392632477;32421.51367729533;32710.83644581762;37762.24475510529;37833.62166378301;38124.80937595405;38417.42373864338;38741.806290968365;32859.34281314408;33061.33877322488;33134.502982455764;33548;33850;32677.836610816794;32717;32929.506057409635;33089.834550827094;33391.165220869676;33203.667963320055;33417.83291083529;33490.82782102615;35839;37263.6273637271;29201.85399073076;30820;31533.684663153075;31662.525062124547;31682.20794480064;24260.514789703753;24716;24734.25797226014;24959.500809984063;25223.11719089823 19:12:43 INFO - PROCESS | 30946 | |2;jquery.html;352.494170864809;353.39745733524336;360.84303328052295;363.2390142651145;369.8557562550604;15333.38666453342;15684.451044213454;15783.526494205193;16163.191840407962;16197.595060123487;13914.165150091001;14120.505782297621;14578.927105364484;14592.343344549494;14615.853841461581;4882.096812089757;4917.729524876139;5028.371453568304;5053.646244762868;5059.873503162432;4927.50724927508;5035.748212589356;5066.84799456015;5085;5095.6942583444925;4972.378452693413;4972.950270497285;4979.825706100287;4980.9252861207115;4982.028504441635;4813.061453016663;4937.308776771255;4946.678465899705;4962.5533701966815;5015.623828212899;4746.644001699887;4750.477447480775;4761.452432970218;4770.809167633291;4777.307290442901;12117.212381195282;15757;19524.70712939307;19580.412587622395;19604.901975490175;1878.1829903991807;1895.289266525053;1896.2509808625516;1915.9616807663908;1966.8131527504863;12225.938870305681;12376.13367064306;12500.437480313407;12623.39364808237;12891.16207446513;1697.8811483196182;1735.8177391373977;1748.9593691753514;1800.558863078541;1803.359807268414;41170.58829411698;44080.559194407964;53691.463085369425;57433.71283143557;60748.69625651887;9306.06939306064;9889.406635601887;9968.850467242997;10143.768370958525;10455.94772026135;12101.818472722916;12108.636740897788;12110.152289339838;12428.192167509264;12877.098603097693;7163.534370265916;7277.526960747535;7297.814643483855;7408.814779630552;7495.213002634645;7149.9285007149265;7251.92748072523;7282.453815963824;7283.8543229136185;7318.707251709979;4351.499577548622;4356.978215108904;4414.227510185705;4466.932996005063;4482.103579284156;1848.6302739452162;1849.5745978424768;1861.8510519158706;1866.887986720801;1898.6107847891149;858.1932982995963;899.1727610598265;904.900460949295;920.0385597051097;920.1948295241664;14992.175430351435;16004.839951600568;16061;16404.343826246815;16584.419545316097;812.5490352854105;842.995785021071;859.6647307550061;878;912.3613470570494;9115.635374585076;9343.90656093444;9353.812923741487;9398.825520055629;9429.90570094304;318342;322479;326347;326733;432838;74511;76554.61722691462;77302.22697773062;77390.6130469344;79597.20402796014;982.3467394182932;983.2674657380297;1004.0260946881659;1009.5356136177294;1012.4380968562518;15166.620834478785;15325.46360877364;15370.846291536942;15551.76672349893;15778.13220272896;33550.161245969044;34016;34592.82703586466;34920.65079349174;35176;45344;46677;47043.52956470392;47258;47521.287180693005;7090.397316228178;7206.387457066208;7226.024486694229;7350.926490735024;7566.35685966699;9281.67514137002;11435.828462573234;11444;11513.942430287794;11609.883901161218;7043.471739619651;7045.330693584101;7176.9641151795995;7256.528325658815;9652;7262.96368518154;7396.223396543285;7550.622468876644;7659.042619672541;7764.650590723544;5557.971775221436;7387.076615423072;7427.8143046424275;7495.250474952461;7500.1374841893885;10636.734081647712;10660.413677247825;10852.837207441737;10953.233273671085;11031.117510599293;10389.688309350731;10398.948005260228;10456.529456174338;10587.841182382424;10806.081483073713 19:12:43 INFO - PROCESS | 30946 | |3;mootools.html;1315.6842357834112;1415.8442571317153;1435.6410897275682;1591.872650187985;1805.8194180581936;7245.058142441482;7391.113066432023;7399.7780066598025;7404;7412.407007439406;7181.138263408386;7336.779896603097;7340.155882073564;7346;7356.374708149814;1951.375559820858;2218.7892150245702;2263.875486848223;2272.36373815332;2290.633498640218;2278.1456953642382;2285.165914441234;2286.599845027122;2289.2445492987276;2289.7023386959672;2202.2622421488823;2279.384566167134;2279.7150356205475;2283.4177284792354;2283.4291427143216;2211.7124773779387;2219;2254.9436264093365;2264.060414927803;2281.7946384825277;2206.79035491628;2231.4309850988056;2238.3285014495586;2238.440389902524;2264.9660255096023;7467.439942004371;7549.282818132268;7549.660265288076;7557.206493318177;7575.659095340668;4477.731336119843;4570.885727856797;4575.58819706228;4583.152116858392;4586.449626044862;2889.8410587417684;2905.7094290570985;2958.156925276286;2959.5856580078807;3001.054667779664;918.2883265469248;921.8801555797703;927.601131513449;935.1723724503795;951.2342564235856;10189.439580823051;10202.795944081077;10209.89790102097;10230.335028223142;10234.1300989416;4310.849120280775;4373.300271956472;4443.311286750559;4445.044315472189;4461.04087621163;8731.869021964676;8763.868541971875;8772.38593298463;8781.165789250012;8781.20969112783;4097.09863829957;4633.096546173464;4634.86095417138;4638.5593368629925;4654.045920586272;3708.6291370863237;3749.2126653402547;4061.7766022869027;4120.587941205856;4124.731892426983;3702.851885924533;3745.7752534847996;3778.414345776409;3780.6597406233573;3792.58281589025;1218.7988981818078;1244.2161438293817;1248.975020499603;1249.0257599072738;1254.9749005019848;933.1368484152132;940.8400571902656;952.8904176019707;967.9661211857692;1097.8188598881254;7154.570725756471;7178.748743794046;7202.135743710788;7230.457715671346;7230.602316872517;471.5284715284715;479.14233521995936;1119.8768135505088;1172.7713095946208;1183.3077649574923;5317.282166907496;5368.2752828367675;5376.946230537723;5407.45925407464;5411.648242864201;9202.861957070649;9321.347505674674;9381.5309234538;9450.243980481546;9500.334976551714;8581.871271930926;8675.609597568124;8706.95646521776;9331;9365.531723413802;6938.722451101899;7020.5787652741;7025.262347453444;7044.401225895856;7048.718051277891;6974.058502102152;7012;7075.716971321295;7111.679974401268;7142.107236595426;8227.588620569068;8348.161625047513;8450.788730281793;8527;8547.230749232598;8675.826483470422;8699.43453675509;8742.431741936754;8745.737627871174;8939.865902011605;5608.495235428668;6308.779192728232;6443.194600674916;6648.5346025777735;6747.257801641717;6939.375456208965;6964.825879353057;6978.616176110363;6993.055937448379;6993.650317484004;6198.907016394848;6392.520560957853;6431.389018043278;6439.935600643934;6467.094606755152;5976.342602313655;6100.023996160593;6100.786472473442;6181.783637572664;6296.33888441707;6519.478441724746;6526.477881769542;6585.934140658532;6587.275399705933;6590.275069742229;5897.469227769521;5917.5857689961285;5958.314793798595;5959.642421454727;5964.628135528766;5941.792037278675;5985;5987.371326010706;5988.041913293852;5998.880022399615 19:12:43 INFO - PROCESS | 30946 | |4;prototype.html;297.47941103069627;301.6410471538868;306.4896946583938;322.96285927118373;324.8797944760439;5222;5295.0733621616255;5295.338082739658;5295.8146464873735;5306.92039619405;5168.121419358708;5180.8704782380455;5193.376794784622;5201.245819356201;5201.791928322863;3923.195744872294;4020.2964481215818;4141.337386018237;4142.523609784876;4179.310413781723;4145.730527515701;4155.085881106167;4166;4166.375043743447;4167;4133.524644665857;4138.213739389506;4146.937795933063;4149.502059752834;4150.43969064177;3903.5706072332023;4026.939595906049;4138.52406973199;4138.937915931264;4141.337386018223;3671.229041901204;3674.540682414698;3676.6874815640704;3676.9448458273146;3682.7606205596817;5099.515546023122;5113.207452844815;5114.079465696173;5124.333836601218;5130.461301563357;4812.302216178669;4818.710877347336;4819.421669399694;4826.444958829745;4830.178869592178;5588.413216612238;5590.86022849428;5592.86017849553;5593.860153496154;5598.468145526169;4045.7167998240134;4081.877543673665;4082.4692789937117;4085.1216988347646;4085.9795701021603;5645.379008309083;5821.126830975388;5822.737976791012;5822.941770582324;5830.533557315404;3926.9789854638;3969.622885825842;3970.6029397060065;3971.007248187953;3978.6419222270133;4030.214108248922;4034.1124952510986;4034.1326614777963;4034.3343348347194;4035.7376770509823;4620.653450991189;4623;4624.237000894815;4625.791839367236;4687.929681054787;5564.8330550083565;5600.747966341524;5612.102063669793;5613.578981576398;5619.157126431068;1407.1135184833695;1445.4146070841325;1446.5949534130461;1447.4572035486692;1450.100937418807;907.5099446299057;952.1858810716876;953.113604347963;959.4003747657714;969.8351280282228;4916.5820905222745;4938.1358262304675;4956.256561515729;4966;4966.1309270877455;5755.6834374108985;5758.337791153987;5760.222369979999;5764.625299355528;5766.135079738073;4938.678985865908;4954.455009948902;4955.380577427822;4956.752162391866;4956.851294461172;3062.6631070582216;3091.041777049122;3093.9535906961414;3094.8297843618816;3097.3340731742783;5440.7551660174595;5443.292371991695;5451.836444906659;5457.263269458652;5458.536024437888;5688.23208866806;5858.941410585925;5861.70691465425;5883.558733095035;5898.262717160355;5382.78468861249;5417.6478528895495;5420.24116623673;5420.728963551806;5438.428964958623;5717.9993501136305;5727.656340619576;5742.741576629145;5742.7702891883855;5745.1956726059225;5587.832365029056;5620.803271885465;5636.436356364495;5640.097584386478;5641.802536911188;5430.67415955044;5433.864153396196;5435.891282174413;5443.183522471661;5451.945480545144;3900.0639846436084;4049.5950404960445;4062.410950412233;4065.10567675111;4066.8373265069067;5749.7125143741805;5771.7402716877;5788.27646544182;5791;5805.071188609802;5563.082091455027;5603.747831347518;5604.747786349542;5608.943910560843;5612.691301978267;5561.304836895388;5595.412481689526;5601.915971260516;5605.103183490785;5610.242617246783;5514.724263786875;5517.393086760373;5517.779288828562;5519.806806761744;5522.751476183662;5434.864128396822;5623.831285061455;5628.634138780966;5675.177099320658;5684.77260909559;5510.283663123929;5542.224088627676;5544.584156188222;5552.278203833475;5554.91667624994 19:12:43 INFO - PROCESS | 30946 | |5;yui.html;596.37678625836;632.4371309534515;687.1650944102914;688.4286042584655;704.4505285877015;11119.444027798609;11257.324560526353;11373.772524549504;13745.175289482613;13980.790288145687;13876;13903.304834758272;13926.582202533915;14017.92991035046;14018.299085045757;654.7708302094277;788.5032429569363;812.305478815613;822.0341099208437;825.2119226139052;816.2042009041168;819.49191501269;820.0323618130603;820.6758330459465;821.2772759971247;852.3692467573982;853.4367317570404;856.8457677618027;857.3869683176528;857.6097875466647;678.9151356080515;840.3151431583301;846.652872322348;847.3983471735075;855.0167307596251;620.110141946304;625.2840497630233;627.2410383436048;627.5826575327402;628.1488582970101;12152.453139608739;12182.451789669487;12189.51241950321;12265.0187984961;12268.938655306756;12396.194247373893;12535.686607834787;12906.741865162645;12934.288614126219;12987.839436815793;9926.404415735078;10130.08829205375;10225.539850706737;10248.846267305997;10377.584896604127;3277.3936821687826;3289.1777055736065;3330.6003279606603;3351.782134161296;3362.1090411041096;44679.32981005288;44725.10549789019;44864.32703509483;45328.77335613334;45814.77092614549;9943.254255930835;9970.30207885441;10054.798904021878;10120.595176193017;10249.282550221413;17645.205965731573;17656.91171544134;17666.470005899842;17692.380766673105;17692.823071769373;6757.493188010919;6792.524523283421;6846.418054465426;6889.345512176335;6995.755148569776;3634.0914771307175;3637.5271214742443;3771.113788259757;3819.9618003819605;3879.650831425185;2646.629471873939;2666.1335066103593;2668.5196664600558;2668.746469085434;2675.2375572961614;465.28810919293534;480.03992015968066;484.8400027990755;490.9582685471775;493.1936284175399;468.7773307678825;503.5769953239297;513.0175713508663;579.9130130480462;593.5489028338408;6898.620575868375;6998.965005174941;7381.8154546136775;7496.812579685442;7668.923310766932;496.6498618473967;527.614841165951;536.8523655994633;542.4412854759604;558.6675927822939;3457.792532448061;3511.157322242643;3511.455724362728;3516.8065756383644;3568.411212149966;49244.50755492471;49472;49595;49657;49687;47697.4687404696;48209.75895120502;48709.999999999294;48783.26825097627;48786.75606622015;42581.78709106435;42977.35533966993;44695.55304446914;46887.531124688314;47050.76474617605;8780.253678437404;8786.297096232414;8831.69089081879;8940.99304389544;8946.418482798597;33185.004449866545;33864.322713546084;34127.31745365128;34614.480782788785;34629.653703462645;39520.01199970024;39683.404748929366;42592.361114583924;43538.564614353454;44064.77967610142;9643.662471813454;9777.071178238057;9795.314327996972;9936.453495057842;10192.184625230113;11348.716282093013;11668.70828229301;11778.76442471163;11803.468843902217;11963.342016189194;11426.314421134759;11611.88388116108;11675.941620291844;12251.571195008131;12417.751644967231;11476.713082172679;11631.360275184947;11939.641810745692;12027.939860300643;12074.154809163274;10679.733006674895;10737.194710396596;11308.717282068013;11450.255733377304;11635;9393.85909211376;9559.187469065208;9799.902000979899;9941.353812002486;10126.493675316353;9073.818523629358;9664.275179361435;9683;9714;9783 19:12:43 INFO - PROCESS | 30946 | __end_tp_report 19:12:43 INFO - PROCESS | 30946 | __start_cc_report 19:12:43 INFO - PROCESS | 30946 | _x_x_mozilla_cycle_collect,1016 19:12:43 INFO - PROCESS | 30946 | __end_cc_report 19:12:43 INFO - PROCESS | 30946 | __startTimestamp1458007963196__endTimestamp 19:12:43 INFO - PROCESS | 30946 | 19:12:43 INFO - PROCESS | 30946 | ------- Summary: start ------- 19:12:43 INFO - PROCESS | 30946 | Number of tests: 6 19:12:43 INFO - PROCESS | 30946 | 19:12:43 INFO - PROCESS | 30946 | [#0] dojo.html Cycles:165 Average:4629.94 Median:4775.19 stddev:482.83 (10.1%) stddev-sans-first:457.52 19:12:43 INFO - PROCESS | 30946 | Values: 2608.3 2652.0 2685.5 2696.3 2696.4 4579.3 4654.9 4678.0 4683.8 4715.7 4623.5 4676.5 4679.8 4681.3 4692.9 4175.3 4254.9 4305.2 4340.1 4360.3 4188.1 4257.4 4333.3 4338.0 4349.5 4236.2 4238.6 4283.9 4310.0 4316.0 4210.2 4213.8 4214.3 4218.6 4252.7 4190.3 4208.8 4211.4 4245.8 4249.4 4518.6 4530.3 4558.3 4605.7 4616.5 4963.1 4979.9 4986.7 5033.6 5035.7 4972.3 5004.7 5005.7 5007.4 5008.0 4670.1 4745.9 4748.2 4754.5 4754.7 5100.9 5139.6 5140.4 5140.4 5141.0 4786.8 4915.3 4916.6 4917.3 4965.8 4993.5 5004.7 5019.6 5063.0 5067.1 4986.3 4999.9 5000.1 5002.6 5048.9 4802.4 4937.8 4964.4 4979.2 5035.4 4191.2 4195.5 4217.8 4222.5 4253.8 3701.2 3708.5 3713.9 3743.0 3753.8 4335.0 4376.0 4388.0 4400.3 4420.1 5058.6 5062.6 5066.1 5067.5 5080.7 4390.3 4400.3 4402.8 4426.3 4433.1 4430.5 4504.6 4523.5 4558.7 4578.4 4773.4 4773.6 4790.8 4791.4 4821.7 5015.6 5045.1 5047.3 5049.1 5092.7 4696.5 4748.6 4766.6 4813.1 4826.3 4935.8 4936.4 4958.6 4960.9 4997.6 4930.5 5018.7 5029.4 5032.8 5078.7 4842.4 4845.5 4866.0 4894.3 4922.4 4868.9 4894.1 4895.5 4905.5 4954.8 4684.7 4758.7 4828.6 4843.1 4886.5 4775.2 4817.5 4881.5 4889.8 4934.7 4803.5 4812.3 4825.7 4827.3 4869.8 19:12:43 INFO - PROCESS | 30946 | 19:12:43 INFO - PROCESS | 30946 | [#1] ext.html Cycles:180 Average:43275.97 Median:18613.65 stddev:75848.48 (407.5%) stddev-sans-first:75993.36 19:12:43 INFO - PROCESS | 30946 | Values: 533.7 541.9 547.2 564.6 576.7 27011.0 37234.8 37846.0 37881.8 37973.4 41074.4 41595.6 41685.0 41752.2 41773.8 7839.6 8036.5 8040.4 8042.0 8043.6 7771.5 7858.1 7858.8 7876.1 7884.3 7890.9 7926.8 7946.9 7952.7 7961.1 7841.3 7864.4 7869.3 7880.7 7904.7 7832.4 7975.3 7976.2 7979.0 7980.2 37362.1 37706.4 37761.1 37773.4 37788.0 2938.0 3074.7 3210.1 3361.3 3377.3 28984.6 29128.3 29324.9 29333.4 29656.4 3273.8 3282.9 3302.8 3316.5 3352.4 252657.0 254207.0 254613.7 255329.0 256858.0 41118.4 55216.0 55381.0 55510.7 55566.2 42177.4 42255.0 42652.8 42684.4 42685.4 12809.4 13081.1 13083.2 13085.8 13095.7 10598.3 10687.4 10692.4 10697.1 10704.8 14646.9 14678.6 14708.6 14747.9 14814.0 5771.7 5900.6 5940.5 5959.0 6040.3 887.4 906.5 960.5 992.6 1033.5 29110.0 30598.5 30633.8 31104.2 33160.7 861.0 991.1 993.0 1005.1 1059.9 12819.3 13130.3 13251.3 13360.9 13407.7 367920.0 368719.0 375015.9 375247.0 376182.0 45843.5 46256.5 46258.3 46264.5 46359.8 1081.6 1138.8 1225.2 1249.2 1266.9 26222.9 27739.4 28008.9 28109.9 28214.3 38964.6 39312.8 39560.0 39571.0 39610.8 210448.0 213705.0 214646.0 215385.0 216919.0 26566.1 30947.7 31580.4 32421.5 32710.8 37762.2 37833.6 38124.8 38417.4 38741.8 32859.3 33061.3 33134.5 33548.0 33850.0 32677.8 32717.0 32929.5 33089.8 33391.2 33203.7 33417.8 33490.8 35839.0 37263.6 29201.9 30820.0 31533.7 31662.5 31682.2 24260.5 24716.0 24734.3 24959.5 25223.1 19:12:43 INFO - PROCESS | 30946 | 19:12:43 INFO - PROCESS | 30946 | [#2] jquery.html Cycles:180 Average:22012.44 Median:24913.05 stddev:57497.13 (230.8%) stddev-sans-first:57635.43 19:12:43 INFO - PROCESS | 30946 | Values: 352.5 353.4 360.8 363.2 369.9 15333.4 15684.5 15783.5 16163.2 16197.6 13914.2 14120.5 14578.9 14592.3 14615.9 4882.1 4917.7 5028.4 5053.6 5059.9 4927.5 5035.7 5066.8 5085.0 5095.7 4972.4 4973.0 4979.8 4980.9 4982.0 4813.1 4937.3 4946.7 4962.6 5015.6 4746.6 4750.5 4761.5 4770.8 4777.3 12117.2 15757.0 19524.7 19580.4 19604.9 1878.2 1895.3 1896.3 1916.0 1966.8 12225.9 12376.1 12500.4 12623.4 12891.2 1697.9 1735.8 1749.0 1800.6 1803.4 41170.6 44080.6 53691.5 57433.7 60748.7 9306.1 9889.4 9968.9 10143.8 10455.9 12101.8 12108.6 12110.2 12428.2 12877.1 7163.5 7277.5 7297.8 7408.8 7495.2 7149.9 7251.9 7282.5 7283.9 7318.7 4351.5 4357.0 4414.2 4466.9 4482.1 1848.6 1849.6 1861.9 1866.9 1898.6 858.2 899.2 904.9 920.0 920.2 14992.2 16004.8 16061.0 16404.3 16584.4 812.5 843.0 859.7 878.0 912.4 9115.6 9343.9 9353.8 9398.8 9429.9 318342.0 322479.0 326347.0 326733.0 432838.0 74511.0 76554.6 77302.2 77390.6 79597.2 982.3 983.3 1004.0 1009.5 1012.4 15166.6 15325.5 15370.8 15551.8 15778.1 33550.2 34016.0 34592.8 34920.7 35176.0 45344.0 46677.0 47043.5 47258.0 47521.3 7090.4 7206.4 7226.0 7350.9 7566.4 9281.7 11435.8 11444.0 11513.9 11609.9 7043.5 7045.3 7177.0 7256.5 9652.0 7263.0 7396.2 7550.6 7659.0 7764.7 5558.0 7387.1 7427.8 7495.3 7500.1 10636.7 10660.4 10852.8 10953.2 11031.1 10389.7 10398.9 10456.5 10587.8 10806.1 19:12:43 INFO - PROCESS | 30946 | 19:12:43 INFO - PROCESS | 30946 | [#3] mootools.html Cycles:180 Average:5238.92 Median:5987.71 stddev:2724.38 (45.5%) stddev-sans-first:2716.06 19:12:43 INFO - PROCESS | 30946 | Values: 1315.7 1415.8 1435.6 1591.9 1805.8 7245.1 7391.1 7399.8 7404.0 7412.4 7181.1 7336.8 7340.2 7346.0 7356.4 1951.4 2218.8 2263.9 2272.4 2290.6 2278.1 2285.2 2286.6 2289.2 2289.7 2202.3 2279.4 2279.7 2283.4 2283.4 2211.7 2219.0 2254.9 2264.1 2281.8 2206.8 2231.4 2238.3 2238.4 2265.0 7467.4 7549.3 7549.7 7557.2 7575.7 4477.7 4570.9 4575.6 4583.2 4586.4 2889.8 2905.7 2958.2 2959.6 3001.1 918.3 921.9 927.6 935.2 951.2 10189.4 10202.8 10209.9 10230.3 10234.1 4310.8 4373.3 4443.3 4445.0 4461.0 8731.9 8763.9 8772.4 8781.2 8781.2 4097.1 4633.1 4634.9 4638.6 4654.0 3708.6 3749.2 4061.8 4120.6 4124.7 3702.9 3745.8 3778.4 3780.7 3792.6 1218.8 1244.2 1249.0 1249.0 1255.0 933.1 940.8 952.9 968.0 1097.8 7154.6 7178.7 7202.1 7230.5 7230.6 471.5 479.1 1119.9 1172.8 1183.3 5317.3 5368.3 5376.9 5407.5 5411.6 9202.9 9321.3 9381.5 9450.2 9500.3 8581.9 8675.6 8707.0 9331.0 9365.5 6938.7 7020.6 7025.3 7044.4 7048.7 6974.1 7012.0 7075.7 7111.7 7142.1 8227.6 8348.2 8450.8 8527.0 8547.2 8675.8 8699.4 8742.4 8745.7 8939.9 5608.5 6308.8 6443.2 6648.5 6747.3 6939.4 6964.8 6978.6 6993.1 6993.7 6198.9 6392.5 6431.4 6439.9 6467.1 5976.3 6100.0 6100.8 6181.8 6296.3 6519.5 6526.5 6585.9 6587.3 6590.3 5897.5 5917.6 5958.3 5959.6 5964.6 5941.8 5985.0 5987.4 5988.0 5998.9 19:12:43 INFO - PROCESS | 30946 | 19:12:43 INFO - PROCESS | 30946 | [#4] prototype.html Cycles:180 Average:4634.98 Median:5258.54 stddev:1351.25 (25.7%) stddev-sans-first:1315.24 19:12:43 INFO - PROCESS | 30946 | Values: 297.5 301.6 306.5 323.0 324.9 5222.0 5295.1 5295.3 5295.8 5306.9 5168.1 5180.9 5193.4 5201.2 5201.8 3923.2 4020.3 4141.3 4142.5 4179.3 4145.7 4155.1 4166.0 4166.4 4167.0 4133.5 4138.2 4146.9 4149.5 4150.4 3903.6 4026.9 4138.5 4138.9 4141.3 3671.2 3674.5 3676.7 3676.9 3682.8 5099.5 5113.2 5114.1 5124.3 5130.5 4812.3 4818.7 4819.4 4826.4 4830.2 5588.4 5590.9 5592.9 5593.9 5598.5 4045.7 4081.9 4082.5 4085.1 4086.0 5645.4 5821.1 5822.7 5822.9 5830.5 3927.0 3969.6 3970.6 3971.0 3978.6 4030.2 4034.1 4034.1 4034.3 4035.7 4620.7 4623.0 4624.2 4625.8 4687.9 5564.8 5600.7 5612.1 5613.6 5619.2 1407.1 1445.4 1446.6 1447.5 1450.1 907.5 952.2 953.1 959.4 969.8 4916.6 4938.1 4956.3 4966.0 4966.1 5755.7 5758.3 5760.2 5764.6 5766.1 4938.7 4954.5 4955.4 4956.8 4956.9 3062.7 3091.0 3094.0 3094.8 3097.3 5440.8 5443.3 5451.8 5457.3 5458.5 5688.2 5858.9 5861.7 5883.6 5898.3 5382.8 5417.6 5420.2 5420.7 5438.4 5718.0 5727.7 5742.7 5742.8 5745.2 5587.8 5620.8 5636.4 5640.1 5641.8 5430.7 5433.9 5435.9 5443.2 5451.9 3900.1 4049.6 4062.4 4065.1 4066.8 5749.7 5771.7 5788.3 5791.0 5805.1 5563.1 5603.7 5604.7 5608.9 5612.7 5561.3 5595.4 5601.9 5605.1 5610.2 5514.7 5517.4 5517.8 5519.8 5522.8 5434.9 5623.8 5628.6 5675.2 5684.8 5510.3 5542.2 5544.6 5552.3 5554.9 19:12:43 INFO - PROCESS | 30946 | 19:12:43 INFO - PROCESS | 30946 | [#5] yui.html Cycles:180 Average:13087.07 Median:45571.77 stddev:14791.10 (32.5%) stddev-sans-first:14802.85 19:12:43 INFO - PROCESS | 30946 | Values: 596.4 632.4 687.2 688.4 704.5 11119.4 11257.3 11373.8 13745.2 13980.8 13876.0 13903.3 13926.6 14017.9 14018.3 654.8 788.5 812.3 822.0 825.2 816.2 819.5 820.0 820.7 821.3 852.4 853.4 856.8 857.4 857.6 678.9 840.3 846.7 847.4 855.0 620.1 625.3 627.2 627.6 628.1 12152.5 12182.5 12189.5 12265.0 12268.9 12396.2 12535.7 12906.7 12934.3 12987.8 9926.4 10130.1 10225.5 10248.8 10377.6 3277.4 3289.2 3330.6 3351.8 3362.1 44679.3 44725.1 44864.3 45328.8 45814.8 9943.3 9970.3 10054.8 10120.6 10249.3 17645.2 17656.9 17666.5 17692.4 17692.8 6757.5 6792.5 6846.4 6889.3 6995.8 3634.1 3637.5 3771.1 3820.0 3879.7 2646.6 2666.1 2668.5 2668.7 2675.2 465.3 480.0 484.8 491.0 493.2 468.8 503.6 513.0 579.9 593.5 6898.6 6999.0 7381.8 7496.8 7668.9 496.6 527.6 536.9 542.4 558.7 3457.8 3511.2 3511.5 3516.8 3568.4 49244.5 49472.0 49595.0 49657.0 49687.0 47697.5 48209.8 48710.0 48783.3 48786.8 42581.8 42977.4 44695.6 46887.5 47050.8 8780.3 8786.3 8831.7 8941.0 8946.4 33185.0 33864.3 34127.3 34614.5 34629.7 39520.0 39683.4 42592.4 43538.6 44064.8 9643.7 9777.1 9795.3 9936.5 10192.2 11348.7 11668.7 11778.8 11803.5 11963.3 11426.3 11611.9 11675.9 12251.6 12417.8 11476.7 11631.4 11939.6 12027.9 12074.2 10679.7 10737.2 11308.7 11450.3 11635.0 9393.9 9559.2 9799.9 9941.4 10126.5 9073.8 9664.3 9683.0 9714.0 9783.0 19:12:43 INFO - PROCESS | 30946 | -------- Summary: end -------- 19:12:43 INFO - PROCESS | 30946 | 19:12:43 INFO - TEST-INFO | 30946: exit 0 19:12:43 INFO - TEST-OK | dromaeo_css | took 1116335ms 19:12:43 INFO - TEST-START | kraken 19:12:43 INFO - operating with platform_type : linux_ 19:12:43 INFO - Initialising browser for kraken test... 19:12:43 INFO - TEST-INFO | started process 31125 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpf5NZBW/profile http://localhost:57356/getInfo.html) 19:12:47 INFO - PROCESS | 31125 | __metrics Screen width/height:1600/1200 19:12:47 INFO - PROCESS | 31125 | colorDepth:24 19:12:47 INFO - PROCESS | 31125 | Browser inner width/height: 1024/697 19:12:47 INFO - PROCESS | 31125 | __metrics 19:12:48 ERROR - PROCESS | 31125 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 19:12:49 INFO - TEST-INFO | 31125: exit 0 19:12:49 INFO - Browser initialized. 19:12:49 INFO - Running cycle 1/1 for kraken test... 19:12:49 INFO - TEST-INFO | started process 31205 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpf5NZBW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:13:01 INFO - PROCESS | 31205 | RSS: Main: 153165824 19:13:01 INFO - PROCESS | 31205 | 19:13:04 INFO - PROCESS | 31205 | Cycle 1(1): loaded http://localhost:57356/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57356/tests/kraken/driver.html?testName=audio-beat-detection) 19:13:04 INFO - PROCESS | 31205 | RSS: Main: 194445312 19:13:04 INFO - PROCESS | 31205 | 19:13:07 INFO - PROCESS | 31205 | Cycle 1(1): loaded http://localhost:57356/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57356/tests/kraken/driver.html?testName=audio-dft) 19:13:08 INFO - PROCESS | 31205 | RSS: Main: 184082432 19:13:08 INFO - PROCESS | 31205 | 19:13:13 INFO - PROCESS | 31205 | Cycle 1(1): loaded http://localhost:57356/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57356/tests/kraken/driver.html?testName=audio-fft) 19:13:14 INFO - PROCESS | 31205 | RSS: Main: 174436352 19:13:14 INFO - PROCESS | 31205 | 19:13:16 INFO - PROCESS | 31205 | Cycle 1(1): loaded http://localhost:57356/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57356/tests/kraken/driver.html?testName=audio-oscillator) 19:13:16 INFO - PROCESS | 31205 | RSS: Main: 173711360 19:13:16 INFO - PROCESS | 31205 | 19:13:18 INFO - PROCESS | 31205 | Cycle 1(1): loaded http://localhost:57356/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57356/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:13:19 INFO - PROCESS | 31205 | RSS: Main: 176140288 19:13:19 INFO - PROCESS | 31205 | 19:13:22 INFO - PROCESS | 31205 | Cycle 1(1): loaded http://localhost:57356/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57356/tests/kraken/driver.html?testName=imaging-darkroom) 19:13:23 INFO - PROCESS | 31205 | RSS: Main: 175407104 19:13:23 INFO - PROCESS | 31205 | 19:13:27 INFO - PROCESS | 31205 | Cycle 1(1): loaded http://localhost:57356/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57356/tests/kraken/driver.html?testName=imaging-desaturate) 19:13:27 INFO - PROCESS | 31205 | RSS: Main: 173744128 19:13:27 INFO - PROCESS | 31205 | 19:13:30 INFO - PROCESS | 31205 | Cycle 1(1): loaded http://localhost:57356/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57356/tests/kraken/driver.html?testName=json-parse-financial) 19:13:31 INFO - PROCESS | 31205 | RSS: Main: 174473216 19:13:31 INFO - PROCESS | 31205 | 19:13:32 INFO - PROCESS | 31205 | Cycle 1(1): loaded http://localhost:57356/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57356/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:13:33 INFO - PROCESS | 31205 | RSS: Main: 189104128 19:13:33 INFO - PROCESS | 31205 | 19:13:35 INFO - PROCESS | 31205 | Cycle 1(1): loaded http://localhost:57356/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57356/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:13:36 INFO - PROCESS | 31205 | RSS: Main: 186712064 19:13:36 INFO - PROCESS | 31205 | 19:13:38 INFO - PROCESS | 31205 | Cycle 1(1): loaded http://localhost:57356/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57356/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:13:38 INFO - PROCESS | 31205 | RSS: Main: 195764224 19:13:38 INFO - PROCESS | 31205 | 19:13:41 INFO - PROCESS | 31205 | Cycle 1(1): loaded http://localhost:57356/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57356/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:13:41 INFO - PROCESS | 31205 | RSS: Main: 202285056 19:13:41 INFO - PROCESS | 31205 | 19:13:44 INFO - PROCESS | 31205 | Cycle 1(1): loaded http://localhost:57356/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57356/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:13:44 INFO - PROCESS | 31205 | RSS: Main: 201822208 19:13:44 INFO - PROCESS | 31205 | 19:13:46 INFO - PROCESS | 31205 | Cycle 1(1): loaded http://localhost:57356/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57356/tests/kraken/driver.html?testName=ai-astar) 19:13:46 INFO - PROCESS | 31205 | RSS: Main: 261402624 19:13:46 INFO - PROCESS | 31205 | 19:13:46 INFO - PROCESS | 31205 | __start_tp_report 19:13:46 INFO - PROCESS | 31205 | _x_x_mozilla_page_load 19:13:46 INFO - PROCESS | 31205 | _x_x_mozilla_page_load_details 19:13:46 INFO - PROCESS | 31205 | |i|pagename|runs| 19:13:46 INFO - PROCESS | 31205 | |0;ai-astar;113;114;107;113;113;112;102;111;111;113 19:13:46 INFO - PROCESS | 31205 | |1;audio-beat-detection;157;133;154;168;137;155;154;129;179;139 19:13:46 INFO - PROCESS | 31205 | |2;audio-dft;387;385;383;383;387;385;384;386;384;383 19:13:46 INFO - PROCESS | 31205 | |3;audio-fft;76;77;100;95;75;73;75;105;91;76 19:13:46 INFO - PROCESS | 31205 | |4;audio-oscillator;95;94;145;94;96;95;135;94;94;130 19:13:46 INFO - PROCESS | 31205 | |5;imaging-gaussian-blur;117;117;117;117;116;116;116;117;117;117 19:13:46 INFO - PROCESS | 31205 | |6;imaging-darkroom;193;193;194;193;193;193;193;193;193;193 19:13:46 INFO - PROCESS | 31205 | |7;imaging-desaturate;95;97;97;96;95;95;96;95;95;95 19:13:46 INFO - PROCESS | 31205 | |8;json-parse-financial;66;72;64;64;64;65;65;65;65;66 19:13:46 INFO - PROCESS | 31205 | |9;json-stringify-tinderbox;65;65;65;64;65;64;64;65;64;64 19:13:46 INFO - PROCESS | 31205 | |10;stanford-crypto-aes;81;83;86;82;82;82;82;80;93;82 19:13:46 INFO - PROCESS | 31205 | |11;stanford-crypto-ccm;115;118;113;112;113;117;125;116;119;114 19:13:46 INFO - PROCESS | 31205 | |12;stanford-crypto-pbkdf2;138;143;146;143;139;134;144;140;138;138 19:13:46 INFO - PROCESS | 31205 | |13;stanford-crypto-sha256-iterative;66;68;66;65;65;65;66;68;73;65 19:13:46 INFO - PROCESS | 31205 | __end_tp_report 19:13:46 INFO - PROCESS | 31205 | __start_cc_report 19:13:46 INFO - PROCESS | 31205 | _x_x_mozilla_cycle_collect,1114 19:13:46 INFO - PROCESS | 31205 | __end_cc_report 19:13:46 INFO - PROCESS | 31205 | __startTimestamp1458008026955__endTimestamp 19:13:46 INFO - PROCESS | 31205 | 19:13:46 INFO - PROCESS | 31205 | ------- Summary: start ------- 19:13:46 INFO - PROCESS | 31205 | Number of tests: 14 19:13:46 INFO - PROCESS | 31205 | 19:13:46 INFO - PROCESS | 31205 | [#0] ai-astar Cycles:10 Average:110.90 Median:113.00 stddev:3.70 (3.3%) stddev-sans-first:3.84 19:13:46 INFO - PROCESS | 31205 | Values: 113.0 114.0 107.0 113.0 113.0 112.0 102.0 111.0 111.0 113.0 19:13:46 INFO - PROCESS | 31205 | 19:13:46 INFO - PROCESS | 31205 | [#1] audio-beat-detection Cycles:10 Average:150.50 Median:154.50 stddev:15.95 (10.3%) stddev-sans-first:16.74 19:13:46 INFO - PROCESS | 31205 | Values: 157.0 133.0 154.0 168.0 137.0 155.0 154.0 129.0 179.0 139.0 19:13:46 INFO - PROCESS | 31205 | 19:13:46 INFO - PROCESS | 31205 | [#2] audio-dft Cycles:10 Average:384.70 Median:385.00 stddev:1.57 (0.4%) stddev-sans-first:1.42 19:13:46 INFO - PROCESS | 31205 | Values: 387.0 385.0 383.0 383.0 387.0 385.0 384.0 386.0 384.0 383.0 19:13:46 INFO - PROCESS | 31205 | 19:13:46 INFO - PROCESS | 31205 | [#3] audio-fft Cycles:10 Average:84.30 Median:76.00 stddev:12.14 (16.0%) stddev-sans-first:12.50 19:13:46 INFO - PROCESS | 31205 | Values: 76.0 77.0 100.0 95.0 75.0 73.0 75.0 105.0 91.0 76.0 19:13:46 INFO - PROCESS | 31205 | 19:13:46 INFO - PROCESS | 31205 | [#4] audio-oscillator Cycles:10 Average:107.20 Median:94.00 stddev:20.66 (22.0%) stddev-sans-first:21.44 19:13:46 INFO - PROCESS | 31205 | Values: 95.0 94.0 145.0 94.0 96.0 95.0 135.0 94.0 94.0 130.0 19:13:46 INFO - PROCESS | 31205 | 19:13:46 INFO - PROCESS | 31205 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 19:13:46 INFO - PROCESS | 31205 | Values: 117.0 117.0 117.0 117.0 116.0 116.0 116.0 117.0 117.0 117.0 19:13:46 INFO - PROCESS | 31205 | 19:13:46 INFO - PROCESS | 31205 | [#6] imaging-darkroom Cycles:10 Average:193.10 Median:193.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 19:13:46 INFO - PROCESS | 31205 | Values: 193.0 193.0 194.0 193.0 193.0 193.0 193.0 193.0 193.0 193.0 19:13:46 INFO - PROCESS | 31205 | 19:13:46 INFO - PROCESS | 31205 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:95.50 stddev:0.84 (0.9%) stddev-sans-first:0.87 19:13:46 INFO - PROCESS | 31205 | Values: 95.0 97.0 97.0 96.0 95.0 95.0 96.0 95.0 95.0 95.0 19:13:46 INFO - PROCESS | 31205 | 19:13:46 INFO - PROCESS | 31205 | [#8] json-parse-financial Cycles:10 Average:65.60 Median:65.00 stddev:2.37 (3.6%) stddev-sans-first:2.51 19:13:46 INFO - PROCESS | 31205 | Values: 66.0 72.0 64.0 64.0 64.0 65.0 65.0 65.0 65.0 66.0 19:13:46 INFO - PROCESS | 31205 | 19:13:46 INFO - PROCESS | 31205 | [#9] json-stringify-tinderbox Cycles:10 Average:64.50 Median:65.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 19:13:46 INFO - PROCESS | 31205 | Values: 65.0 65.0 65.0 64.0 65.0 64.0 64.0 65.0 64.0 64.0 19:13:46 INFO - PROCESS | 31205 | 19:13:46 INFO - PROCESS | 31205 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:82.00 stddev:3.74 (4.6%) stddev-sans-first:3.88 19:13:46 INFO - PROCESS | 31205 | Values: 81.0 83.0 86.0 82.0 82.0 82.0 82.0 80.0 93.0 82.0 19:13:46 INFO - PROCESS | 31205 | 19:13:46 INFO - PROCESS | 31205 | [#11] stanford-crypto-ccm Cycles:10 Average:116.20 Median:116.50 stddev:3.85 (3.3%) stddev-sans-first:4.06 19:13:46 INFO - PROCESS | 31205 | Values: 115.0 118.0 113.0 112.0 113.0 117.0 125.0 116.0 119.0 114.0 19:13:46 INFO - PROCESS | 31205 | 19:13:46 INFO - PROCESS | 31205 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.30 Median:141.50 stddev:3.62 (2.6%) stddev-sans-first:3.75 19:13:46 INFO - PROCESS | 31205 | Values: 138.0 143.0 146.0 143.0 139.0 134.0 144.0 140.0 138.0 138.0 19:13:46 INFO - PROCESS | 31205 | 19:13:46 INFO - PROCESS | 31205 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:66.00 stddev:2.50 (3.8%) stddev-sans-first:2.64 19:13:46 INFO - PROCESS | 31205 | Values: 66.0 68.0 66.0 65.0 65.0 65.0 66.0 68.0 73.0 65.0 19:13:46 INFO - PROCESS | 31205 | -------- Summary: end -------- 19:13:46 INFO - PROCESS | 31205 | 19:13:47 INFO - TEST-INFO | 31205: exit 0 19:13:47 INFO - TEST-OK | kraken | took 63945ms 19:13:47 INFO - SUITE-END | took 1180s 19:13:48 INFO - Completed test suite (00:19:40) 19:13:48 INFO - javascript benchmark 19:13:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2608.321836322556, 2652.0, 2685.5300322443572, 2696.32591852037, 2696.366353906833, 4579.267317229244, 4654.883627909299, 4677.999999999995, 4683.76581170941, 4715.669903106784, 4623.468301145369, 4676.485586585472, 4679.76601169941, 4681.344611754357, 4692.906141877161, 4175.269327867626, 4254.87235382939, 4305.203537345586, 4340.1102773931425, 4360.302351623741, 4188.099558594901, 4257.446531950842, 4333.306670932651, 4337.978310108445, 4349.499807522144, 4236.152769446092, 4238.597333253336, 4283.87148385549, 4310.0, 4315.956840431587, 4210.242156411845, 4213.810378532973, 4214.346776249687, 4218.557051509578, 4252.744835309892, 4190.308599081148, 4208.810603522848, 4211.410402543646, 4245.830166793356, 4249.4475718156755, 4518.615917647004, 4530.3204519322035, 4558.270676691714, 4605.700629459075, 4616.53834616539, 4963.057019166346, 4979.925301120486, 4986.700797952134, 5033.647644664875, 5035.723035233061, 4972.328735620681, 5004.749762511859, 5005.749712514396, 5007.424146223195, 5008.048470790538, 4670.112678591091, 4745.905081898342, 4748.240281554935, 4754.524547545287, 4754.738489383048, 5100.8778068824795, 5139.640225184276, 5140.383154021467, 5140.408852981955, 5141.048905952411, 4786.760661966888, 4915.287283343895, 4916.631252656065, 4917.262410638361, 4965.82619608312, 4993.450720420751, 5004.674696144739, 5019.598432125421, 5063.0, 5067.062593420229, 4986.301917731521, 4999.900001999939, 5000.099982003274, 5002.649814512949, 5048.924266136011, 4802.375691160127, 4937.8271760488215, 4964.429090654621, 4979.178435558165, 5035.420926593415, 4191.224623444673, 4195.49654041517, 4217.768022758716, 4222.514410842731, 4253.787310634456, 3701.204241088125, 3708.5364329458816, 3713.9071523212137, 3742.962570374316, 3753.8123093845197, 4334.956650433455, 4376.0, 4387.956120438818, 4400.295952647561, 4420.115976804652, 5058.620603454756, 5062.620303477181, 5066.06277838601, 5067.5185857343495, 5080.7205603692155, 4390.3414487827085, 4400.295952647625, 4402.757848318309, 4426.291793313055, 4433.135538569948, 4430.468343798765, 4504.6396288296855, 4523.479799823062, 4558.703684260512, 4578.381918441034, 4773.37946067009, 4773.570378665937, 4790.7844147012775, 4791.425028996473, 4821.7348045856415, 5015.623828212972, 5045.091883460866, 5047.343845300087, 5049.065922804293, 5092.668976516515, 4696.530346965276, 4748.572628463455, 4766.642501812447, 4813.085513752376, 4826.251930950708, 4935.75321233944, 4936.432310284364, 4958.57852082577, 4960.8759781005765, 4997.625178111583, 4930.457649658606, 5018.723970181675, 5029.421616514148, 5032.798688052583, 5078.669886457368, 4842.370491836039, 4845.515448455127, 4866.0, 4894.265860120868, 4922.409310882717, 4868.902621947612, 4894.070126675921, 4895.46149923501, 4905.484924083063, 4954.826581069645, 4684.718916864999, 4758.690685105457, 4828.61371090319, 4843.07981483517, 4886.462489126265, 4775.188218003017, 4817.494163112963, 4881.536254055859, 4889.828855990023, 4934.728589927445, 4803.471618122074, 4812.326274321527, 4825.662203645851, 4827.300041494034, 4869.756512174448], "unit": "score", "name": "dojo.html", "value": 4599.6222398841965}, {"lowerIsBetter": false, "replicates": [533.674458580266, 541.8564080518663, 547.1819629653669, 564.5709260961668, 576.7491141353512, 27011.0, 37234.81382593087, 37846.0, 37881.810590947, 37973.43039854404, 41074.38388424176, 41595.58404415955, 41685.0, 41752.16495670092, 41773.79113104438, 7839.568823714708, 8036.477628954129, 8040.356771458299, 8042.0, 8043.638036288352, 7771.533707977539, 7858.096318923312, 7858.842823143534, 7876.094249161334, 7884.290413862751, 7890.921090789105, 7926.841463170733, 7946.880796788053, 7952.721654742085, 7961.1242763295995, 7841.294283514482, 7864.449488535804, 7869.331106855867, 7880.724174653859, 7904.723334683258, 7832.412569057344, 7975.322097621709, 7976.162502937166, 7979.0, 7980.241877021732, 37362.065948351235, 37706.43440348397, 37761.0559736006, 37773.433398499044, 37788.0, 2938.045135331026, 3074.677158898306, 3210.085125739153, 3361.344537815127, 3377.2907689385015, 28984.565231521545, 29128.271793205127, 29324.853375732986, 29333.43948410722, 29656.40687186244, 3273.836308184605, 3282.8522716477814, 3302.78531895426, 3316.535685004101, 3352.4468462703867, 252657.0, 254207.0, 254613.72693136602, 255329.0, 256858.0, 41118.38322425166, 55216.0, 55381.0, 55510.72244638751, 55566.16650750242, 42177.36733948993, 42255.0, 42652.78673606612, 42684.359734604004, 42685.35971960423, 12809.423575939105, 13081.084324097223, 13083.215007099605, 13085.803712944313, 13095.672608184872, 10598.25812193139, 10687.412192329497, 10692.411917344465, 10697.090747286567, 10704.839427408438, 14646.853531464762, 14678.559643210721, 14708.55874323772, 14747.92626036863, 14814.0, 5771.711414429262, 5900.645961242253, 5940.46535811779, 5958.970205149033, 6040.335563088057, 887.401004322093, 906.5467266366817, 960.4621412009298, 992.6376872441507, 1033.4625994482826, 29110.0, 30598.54102188469, 30633.81508789566, 31104.22239443987, 33160.66839331624, 860.9827803444022, 991.0981007283337, 992.965246216379, 1005.1355833982769, 1059.8728152621734, 12819.294938778457, 13130.293061901892, 13251.271180084996, 13360.93319533396, 13407.731845363038, 367920.0, 368719.0, 375015.8738094599, 375247.0, 376182.0, 45843.541564583924, 46256.53743462522, 46258.30612540815, 46264.53735462602, 46359.76820115945, 1081.6268387406333, 1138.7551676389617, 1225.1668865171769, 1249.194269696041, 1266.9303188324545, 26222.86888565545, 27739.44521109607, 28008.859955700093, 28109.859450703432, 28214.294642634097, 38964.61035389723, 39312.803435982634, 39560.0, 39571.0, 39610.80194599008, 210448.0, 213705.0, 214646.0, 215385.0, 216919.0, 26566.070187543344, 30947.69052309538, 31580.368392632477, 32421.51367729533, 32710.83644581762, 37762.24475510529, 37833.62166378301, 38124.80937595405, 38417.42373864338, 38741.806290968365, 32859.34281314408, 33061.33877322488, 33134.502982455764, 33548.0, 33850.0, 32677.836610816794, 32717.0, 32929.506057409635, 33089.834550827094, 33391.165220869676, 33203.667963320055, 33417.83291083529, 33490.82782102615, 35839.0, 37263.6273637271, 29201.85399073076, 30820.0, 31533.684663153075, 31662.525062124547, 31682.20794480064, 24260.514789703753, 24716.0, 24734.25797226014, 24959.500809984063, 25223.11719089823], "unit": "score", "name": "ext.html", "value": 16802.544577562727}, {"lowerIsBetter": false, "replicates": [352.494170864809, 353.39745733524336, 360.84303328052295, 363.2390142651145, 369.8557562550604, 15333.38666453342, 15684.451044213454, 15783.526494205193, 16163.191840407962, 16197.595060123487, 13914.165150091001, 14120.505782297621, 14578.927105364484, 14592.343344549494, 14615.853841461581, 4882.096812089757, 4917.729524876139, 5028.371453568304, 5053.646244762868, 5059.873503162432, 4927.50724927508, 5035.748212589356, 5066.84799456015, 5085.0, 5095.6942583444925, 4972.378452693413, 4972.950270497285, 4979.825706100287, 4980.9252861207115, 4982.028504441635, 4813.061453016663, 4937.308776771255, 4946.678465899705, 4962.5533701966815, 5015.623828212899, 4746.644001699887, 4750.477447480775, 4761.452432970218, 4770.809167633291, 4777.307290442901, 12117.212381195282, 15757.0, 19524.70712939307, 19580.412587622395, 19604.901975490175, 1878.1829903991807, 1895.289266525053, 1896.2509808625516, 1915.9616807663908, 1966.8131527504863, 12225.938870305681, 12376.13367064306, 12500.437480313407, 12623.39364808237, 12891.16207446513, 1697.8811483196182, 1735.8177391373977, 1748.9593691753514, 1800.558863078541, 1803.359807268414, 41170.58829411698, 44080.559194407964, 53691.463085369425, 57433.71283143557, 60748.69625651887, 9306.06939306064, 9889.406635601887, 9968.850467242997, 10143.768370958525, 10455.94772026135, 12101.818472722916, 12108.636740897788, 12110.152289339838, 12428.192167509264, 12877.098603097693, 7163.534370265916, 7277.526960747535, 7297.814643483855, 7408.814779630552, 7495.213002634645, 7149.9285007149265, 7251.92748072523, 7282.453815963824, 7283.8543229136185, 7318.707251709979, 4351.499577548622, 4356.978215108904, 4414.227510185705, 4466.932996005063, 4482.103579284156, 1848.6302739452162, 1849.5745978424768, 1861.8510519158706, 1866.887986720801, 1898.6107847891149, 858.1932982995963, 899.1727610598265, 904.900460949295, 920.0385597051097, 920.1948295241664, 14992.175430351435, 16004.839951600568, 16061.0, 16404.343826246815, 16584.419545316097, 812.5490352854105, 842.995785021071, 859.6647307550061, 878.0, 912.3613470570494, 9115.635374585076, 9343.90656093444, 9353.812923741487, 9398.825520055629, 9429.90570094304, 318342.0, 322479.0, 326347.0, 326733.0, 432838.0, 74511.0, 76554.61722691462, 77302.22697773062, 77390.6130469344, 79597.20402796014, 982.3467394182932, 983.2674657380297, 1004.0260946881659, 1009.5356136177294, 1012.4380968562518, 15166.620834478785, 15325.46360877364, 15370.846291536942, 15551.76672349893, 15778.13220272896, 33550.161245969044, 34016.0, 34592.82703586466, 34920.65079349174, 35176.0, 45344.0, 46677.0, 47043.52956470392, 47258.0, 47521.287180693005, 7090.397316228178, 7206.387457066208, 7226.024486694229, 7350.926490735024, 7566.35685966699, 9281.67514137002, 11435.828462573234, 11444.0, 11513.942430287794, 11609.883901161218, 7043.471739619651, 7045.330693584101, 7176.9641151795995, 7256.528325658815, 9652.0, 7262.96368518154, 7396.223396543285, 7550.622468876644, 7659.042619672541, 7764.650590723544, 5557.971775221436, 7387.076615423072, 7427.8143046424275, 7495.250474952461, 7500.1374841893885, 10636.734081647712, 10660.413677247825, 10852.837207441737, 10953.233273671085, 11031.117510599293, 10389.688309350731, 10398.948005260228, 10456.529456174338, 10587.841182382424, 10806.081483073713], "unit": "score", "name": "jquery.html", "value": 7814.235945470854}, {"lowerIsBetter": false, "replicates": [1315.6842357834112, 1415.8442571317153, 1435.6410897275682, 1591.872650187985, 1805.8194180581936, 7245.058142441482, 7391.113066432023, 7399.7780066598025, 7404.0, 7412.407007439406, 7181.138263408386, 7336.779896603097, 7340.155882073564, 7346.0, 7356.374708149814, 1951.375559820858, 2218.7892150245702, 2263.875486848223, 2272.36373815332, 2290.633498640218, 2278.1456953642382, 2285.165914441234, 2286.599845027122, 2289.2445492987276, 2289.7023386959672, 2202.2622421488823, 2279.384566167134, 2279.7150356205475, 2283.4177284792354, 2283.4291427143216, 2211.7124773779387, 2219.0, 2254.9436264093365, 2264.060414927803, 2281.7946384825277, 2206.79035491628, 2231.4309850988056, 2238.3285014495586, 2238.440389902524, 2264.9660255096023, 7467.439942004371, 7549.282818132268, 7549.660265288076, 7557.206493318177, 7575.659095340668, 4477.731336119843, 4570.885727856797, 4575.58819706228, 4583.152116858392, 4586.449626044862, 2889.8410587417684, 2905.7094290570985, 2958.156925276286, 2959.5856580078807, 3001.054667779664, 918.2883265469248, 921.8801555797703, 927.601131513449, 935.1723724503795, 951.2342564235856, 10189.439580823051, 10202.795944081077, 10209.89790102097, 10230.335028223142, 10234.1300989416, 4310.849120280775, 4373.300271956472, 4443.311286750559, 4445.044315472189, 4461.04087621163, 8731.869021964676, 8763.868541971875, 8772.38593298463, 8781.165789250012, 8781.20969112783, 4097.09863829957, 4633.096546173464, 4634.86095417138, 4638.5593368629925, 4654.045920586272, 3708.6291370863237, 3749.2126653402547, 4061.7766022869027, 4120.587941205856, 4124.731892426983, 3702.851885924533, 3745.7752534847996, 3778.414345776409, 3780.6597406233573, 3792.58281589025, 1218.7988981818078, 1244.2161438293817, 1248.975020499603, 1249.0257599072738, 1254.9749005019848, 933.1368484152132, 940.8400571902656, 952.8904176019707, 967.9661211857692, 1097.8188598881254, 7154.570725756471, 7178.748743794046, 7202.135743710788, 7230.457715671346, 7230.602316872517, 471.5284715284715, 479.14233521995936, 1119.8768135505088, 1172.7713095946208, 1183.3077649574923, 5317.282166907496, 5368.2752828367675, 5376.946230537723, 5407.45925407464, 5411.648242864201, 9202.861957070649, 9321.347505674674, 9381.5309234538, 9450.243980481546, 9500.334976551714, 8581.871271930926, 8675.609597568124, 8706.95646521776, 9331.0, 9365.531723413802, 6938.722451101899, 7020.5787652741, 7025.262347453444, 7044.401225895856, 7048.718051277891, 6974.058502102152, 7012.0, 7075.716971321295, 7111.679974401268, 7142.107236595426, 8227.588620569068, 8348.161625047513, 8450.788730281793, 8527.0, 8547.230749232598, 8675.826483470422, 8699.43453675509, 8742.431741936754, 8745.737627871174, 8939.865902011605, 5608.495235428668, 6308.779192728232, 6443.194600674916, 6648.5346025777735, 6747.257801641717, 6939.375456208965, 6964.825879353057, 6978.616176110363, 6993.055937448379, 6993.650317484004, 6198.907016394848, 6392.520560957853, 6431.389018043278, 6439.935600643934, 6467.094606755152, 5976.342602313655, 6100.023996160593, 6100.786472473442, 6181.783637572664, 6296.33888441707, 6519.478441724746, 6526.477881769542, 6585.934140658532, 6587.275399705933, 6590.275069742229, 5897.469227769521, 5917.5857689961285, 5958.314793798595, 5959.642421454727, 5964.628135528766, 5941.792037278675, 5985.0, 5987.371326010706, 5988.041913293852, 5998.880022399615], "unit": "score", "name": "mootools.html", "value": 4293.341217021517}, {"lowerIsBetter": false, "replicates": [297.47941103069627, 301.6410471538868, 306.4896946583938, 322.96285927118373, 324.8797944760439, 5222.0, 5295.0733621616255, 5295.338082739658, 5295.8146464873735, 5306.92039619405, 5168.121419358708, 5180.8704782380455, 5193.376794784622, 5201.245819356201, 5201.791928322863, 3923.195744872294, 4020.2964481215818, 4141.337386018237, 4142.523609784876, 4179.310413781723, 4145.730527515701, 4155.085881106167, 4166.0, 4166.375043743447, 4167.0, 4133.524644665857, 4138.213739389506, 4146.937795933063, 4149.502059752834, 4150.43969064177, 3903.5706072332023, 4026.939595906049, 4138.52406973199, 4138.937915931264, 4141.337386018223, 3671.229041901204, 3674.540682414698, 3676.6874815640704, 3676.9448458273146, 3682.7606205596817, 5099.515546023122, 5113.207452844815, 5114.079465696173, 5124.333836601218, 5130.461301563357, 4812.302216178669, 4818.710877347336, 4819.421669399694, 4826.444958829745, 4830.178869592178, 5588.413216612238, 5590.86022849428, 5592.86017849553, 5593.860153496154, 5598.468145526169, 4045.7167998240134, 4081.877543673665, 4082.4692789937117, 4085.1216988347646, 4085.9795701021603, 5645.379008309083, 5821.126830975388, 5822.737976791012, 5822.941770582324, 5830.533557315404, 3926.9789854638, 3969.622885825842, 3970.6029397060065, 3971.007248187953, 3978.6419222270133, 4030.214108248922, 4034.1124952510986, 4034.1326614777963, 4034.3343348347194, 4035.7376770509823, 4620.653450991189, 4623.0, 4624.237000894815, 4625.791839367236, 4687.929681054787, 5564.8330550083565, 5600.747966341524, 5612.102063669793, 5613.578981576398, 5619.157126431068, 1407.1135184833695, 1445.4146070841325, 1446.5949534130461, 1447.4572035486692, 1450.100937418807, 907.5099446299057, 952.1858810716876, 953.113604347963, 959.4003747657714, 969.8351280282228, 4916.5820905222745, 4938.1358262304675, 4956.256561515729, 4966.0, 4966.1309270877455, 5755.6834374108985, 5758.337791153987, 5760.222369979999, 5764.625299355528, 5766.135079738073, 4938.678985865908, 4954.455009948902, 4955.380577427822, 4956.752162391866, 4956.851294461172, 3062.6631070582216, 3091.041777049122, 3093.9535906961414, 3094.8297843618816, 3097.3340731742783, 5440.7551660174595, 5443.292371991695, 5451.836444906659, 5457.263269458652, 5458.536024437888, 5688.23208866806, 5858.941410585925, 5861.70691465425, 5883.558733095035, 5898.262717160355, 5382.78468861249, 5417.6478528895495, 5420.24116623673, 5420.728963551806, 5438.428964958623, 5717.9993501136305, 5727.656340619576, 5742.741576629145, 5742.7702891883855, 5745.1956726059225, 5587.832365029056, 5620.803271885465, 5636.436356364495, 5640.097584386478, 5641.802536911188, 5430.67415955044, 5433.864153396196, 5435.891282174413, 5443.183522471661, 5451.945480545144, 3900.0639846436084, 4049.5950404960445, 4062.410950412233, 4065.10567675111, 4066.8373265069067, 5749.7125143741805, 5771.7402716877, 5788.27646544182, 5791.0, 5805.071188609802, 5563.082091455027, 5603.747831347518, 5604.747786349542, 5608.943910560843, 5612.691301978267, 5561.304836895388, 5595.412481689526, 5601.915971260516, 5605.103183490785, 5610.242617246783, 5514.724263786875, 5517.393086760373, 5517.779288828562, 5519.806806761744, 5522.751476183662, 5434.864128396822, 5623.831285061455, 5628.634138780966, 5675.177099320658, 5684.77260909559, 5510.283663123929, 5542.224088627676, 5544.584156188222, 5552.278203833475, 5554.91667624994], "unit": "score", "name": "prototype.html", "value": 4200.139710621482}, {"lowerIsBetter": false, "replicates": [596.37678625836, 632.4371309534515, 687.1650944102914, 688.4286042584655, 704.4505285877015, 11119.444027798609, 11257.324560526353, 11373.772524549504, 13745.175289482613, 13980.790288145687, 13876.0, 13903.304834758272, 13926.582202533915, 14017.92991035046, 14018.299085045757, 654.7708302094277, 788.5032429569363, 812.305478815613, 822.0341099208437, 825.2119226139052, 816.2042009041168, 819.49191501269, 820.0323618130603, 820.6758330459465, 821.2772759971247, 852.3692467573982, 853.4367317570404, 856.8457677618027, 857.3869683176528, 857.6097875466647, 678.9151356080515, 840.3151431583301, 846.652872322348, 847.3983471735075, 855.0167307596251, 620.110141946304, 625.2840497630233, 627.2410383436048, 627.5826575327402, 628.1488582970101, 12152.453139608739, 12182.451789669487, 12189.51241950321, 12265.0187984961, 12268.938655306756, 12396.194247373893, 12535.686607834787, 12906.741865162645, 12934.288614126219, 12987.839436815793, 9926.404415735078, 10130.08829205375, 10225.539850706737, 10248.846267305997, 10377.584896604127, 3277.3936821687826, 3289.1777055736065, 3330.6003279606603, 3351.782134161296, 3362.1090411041096, 44679.32981005288, 44725.10549789019, 44864.32703509483, 45328.77335613334, 45814.77092614549, 9943.254255930835, 9970.30207885441, 10054.798904021878, 10120.595176193017, 10249.282550221413, 17645.205965731573, 17656.91171544134, 17666.470005899842, 17692.380766673105, 17692.823071769373, 6757.493188010919, 6792.524523283421, 6846.418054465426, 6889.345512176335, 6995.755148569776, 3634.0914771307175, 3637.5271214742443, 3771.113788259757, 3819.9618003819605, 3879.650831425185, 2646.629471873939, 2666.1335066103593, 2668.5196664600558, 2668.746469085434, 2675.2375572961614, 465.28810919293534, 480.03992015968066, 484.8400027990755, 490.9582685471775, 493.1936284175399, 468.7773307678825, 503.5769953239297, 513.0175713508663, 579.9130130480462, 593.5489028338408, 6898.620575868375, 6998.965005174941, 7381.8154546136775, 7496.812579685442, 7668.923310766932, 496.6498618473967, 527.614841165951, 536.8523655994633, 542.4412854759604, 558.6675927822939, 3457.792532448061, 3511.157322242643, 3511.455724362728, 3516.8065756383644, 3568.411212149966, 49244.50755492471, 49472.0, 49595.0, 49657.0, 49687.0, 47697.4687404696, 48209.75895120502, 48709.999999999294, 48783.26825097627, 48786.75606622015, 42581.78709106435, 42977.35533966993, 44695.55304446914, 46887.531124688314, 47050.76474617605, 8780.253678437404, 8786.297096232414, 8831.69089081879, 8940.99304389544, 8946.418482798597, 33185.004449866545, 33864.322713546084, 34127.31745365128, 34614.480782788785, 34629.653703462645, 39520.01199970024, 39683.404748929366, 42592.361114583924, 43538.564614353454, 44064.77967610142, 9643.662471813454, 9777.071178238057, 9795.314327996972, 9936.453495057842, 10192.184625230113, 11348.716282093013, 11668.70828229301, 11778.76442471163, 11803.468843902217, 11963.342016189194, 11426.314421134759, 11611.88388116108, 11675.941620291844, 12251.571195008131, 12417.751644967231, 11476.713082172679, 11631.360275184947, 11939.641810745692, 12027.939860300643, 12074.154809163274, 10679.733006674895, 10737.194710396596, 11308.717282068013, 11450.255733377304, 11635.0, 9393.85909211376, 9559.187469065208, 9799.902000979899, 9941.353812002486, 10126.493675316353, 9073.818523629358, 9664.275179361435, 9683.0, 9714.0, 9783.0], "unit": "score", "name": "yui.html", "value": 5946.478502421691}], "name": "dromaeo_css", "value": 6337.103900447777}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 114.0, 107.0, 113.0, 113.0, 112.0, 102.0, 111.0, 111.0, 113.0], "unit": "score", "name": "ai-astar", "value": 110.9}, {"lowerIsBetter": true, "replicates": [157.0, 133.0, 154.0, 168.0, 137.0, 155.0, 154.0, 129.0, 179.0, 139.0], "unit": "score", "name": "audio-beat-detection", "value": 150.5}, {"lowerIsBetter": true, "replicates": [387.0, 385.0, 383.0, 383.0, 387.0, 385.0, 384.0, 386.0, 384.0, 383.0], "unit": "score", "name": "audio-dft", "value": 384.7}, {"lowerIsBetter": true, "replicates": [76.0, 77.0, 100.0, 95.0, 75.0, 73.0, 75.0, 105.0, 91.0, 76.0], "unit": "score", "name": "audio-fft", "value": 84.3}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 145.0, 94.0, 96.0, 95.0, 135.0, 94.0, 94.0, 130.0], "unit": "score", "name": "audio-oscillator", "value": 107.2}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 116.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.7}, {"lowerIsBetter": true, "replicates": [193.0, 193.0, 194.0, 193.0, 193.0, 193.0, 193.0, 193.0, 193.0, 193.0], "unit": "score", "name": "imaging-darkroom", "value": 193.1}, {"lowerIsBetter": true, "replicates": [95.0, 97.0, 97.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [66.0, 72.0, 64.0, 64.0, 64.0, 65.0, 65.0, 65.0, 65.0, 66.0], "unit": "score", "name": "json-parse-financial", "value": 65.6}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 65.0, 64.0, 65.0, 64.0, 64.0, 65.0, 64.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.5}, {"lowerIsBetter": true, "replicates": [81.0, 83.0, 86.0, 82.0, 82.0, 82.0, 82.0, 80.0, 93.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.3}, {"lowerIsBetter": true, "replicates": [115.0, 118.0, 113.0, 112.0, 113.0, 117.0, 125.0, 116.0, 119.0, 114.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.2}, {"lowerIsBetter": true, "replicates": [138.0, 143.0, 146.0, 143.0, 139.0, 134.0, 144.0, 140.0, 138.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 140.3}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 66.0, 65.0, 65.0, 65.0, 66.0, 68.0, 73.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.7}], "name": "kraken", "value": 1779.5999999999997}]} 19:13:48 INFO - Return code: 0 19:13:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:13:48 ERROR - # TBPL SUCCESS # 19:13:48 INFO - Running post-action listener: _resource_record_post_action 19:13:48 INFO - Running post-run listener: _resource_record_post_run 19:13:49 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 8192; Write bytes: 530427904; Read time: 12; Write time: 634784 19:13:49 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 242511872; Read time: 0; Write time: 368804 19:13:49 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 8192; Write bytes: 284033024; Read time: 12; Write time: 265180 19:13:49 INFO - Running post-run listener: _upload_blobber_files 19:13:49 INFO - Blob upload gear active. 19:13:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:13:49 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:13:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:13:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:13:49 INFO - (blobuploader) - INFO - Open directory for files ... 19:13:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:13:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:13:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:13:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:13:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:13:50 INFO - (blobuploader) - INFO - Done attempting. 19:13:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:13:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:13:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:13:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:13:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:13:51 INFO - (blobuploader) - INFO - Done attempting. 19:13:51 INFO - (blobuploader) - INFO - Iteration through files over. 19:13:51 INFO - Return code: 0 19:13:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:13:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:13:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d77893ec5939eac4c67e791ba8277bf7066ac40f1208d1009a28a587063ddc9d45fb9d0b8c0d1d7b59fd50423542fad7d267c7847a9d51f34d6fed75869d195a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/38a5a30ea964c9c449c6bd609f57e1a761f2c0807a8ffa7559390cb4be51a9600b2a764faf2f5839e0167c9c590a6c924d7a1b37278950178aef48ff4b0a4b5d"} 19:13:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:13:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:13:51 INFO - Contents: 19:13:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d77893ec5939eac4c67e791ba8277bf7066ac40f1208d1009a28a587063ddc9d45fb9d0b8c0d1d7b59fd50423542fad7d267c7847a9d51f34d6fed75869d195a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/38a5a30ea964c9c449c6bd609f57e1a761f2c0807a8ffa7559390cb4be51a9600b2a764faf2f5839e0167c9c590a6c924d7a1b37278950178aef48ff4b0a4b5d"} 19:13:51 INFO - Running post-run listener: copy_logs_to_upload_dir 19:13:51 INFO - Copying logs to upload dir... 19:13:51 INFO - mkdir: /builds/slave/test/build/upload/logs 19:13:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.673722 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-03-14 19:13:51.059728) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-14 19:13:51.063421) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4ac8d263c7293b36a1be1aed000001be-1458005854.276392-610488406 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d77893ec5939eac4c67e791ba8277bf7066ac40f1208d1009a28a587063ddc9d45fb9d0b8c0d1d7b59fd50423542fad7d267c7847a9d51f34d6fed75869d195a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/38a5a30ea964c9c449c6bd609f57e1a761f2c0807a8ffa7559390cb4be51a9600b2a764faf2f5839e0167c9c590a6c924d7a1b37278950178aef48ff4b0a4b5d"} build_url:https://queue.taskcluster.net/v1/task/Azh-4B7pTGGXGrHquUhqOg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011462 build_url: 'https://queue.taskcluster.net/v1/task/Azh-4B7pTGGXGrHquUhqOg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d77893ec5939eac4c67e791ba8277bf7066ac40f1208d1009a28a587063ddc9d45fb9d0b8c0d1d7b59fd50423542fad7d267c7847a9d51f34d6fed75869d195a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/38a5a30ea964c9c449c6bd609f57e1a761f2c0807a8ffa7559390cb4be51a9600b2a764faf2f5839e0167c9c590a6c924d7a1b37278950178aef48ff4b0a4b5d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-14 19:13:51.090312) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 19:13:51.090635) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4ac8d263c7293b36a1be1aed000001be-1458005854.276392-610488406 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004636 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 19:13:51.172778) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-14 19:13:51.173098) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-14 19:13:51.173381) ========= ========= Total master_lag: 0.32 =========