builder: fx-team_ubuntu64_hw_test-g2 slave: talos-linux64-ix-064 starttime: 1453954416.95 results: success (0) buildid: 20160127194100 builduid: 39b4f66fd63d4c0ca5b42cefc01be5fe revision: 0ecd7d72f232304da046b352c457e039e35ceed7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-27 20:13:36.947330) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-27 20:13:36.947774) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-27 20:13:36.948072) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1453954416.658122-38840208 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.004339 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-27 20:13:36.964523) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-27 20:13:36.964829) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-27 20:13:36.976638) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 20:13:36.977019) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1453954416.658122-38840208 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004652 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 20:13:37.026188) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-27 20:13:37.026499) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-27 20:13:37.026892) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 20:13:37.027163) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1453954416.658122-38840208 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-27 20:13:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.1M=0s 2016-01-27 20:13:37 (40.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.159874 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 20:13:37.199364) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 20:13:37.199685) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1453954416.658122-38840208 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019872 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 20:13:37.249386) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 20:13:37.249806) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0ecd7d72f232304da046b352c457e039e35ceed7 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 0ecd7d72f232304da046b352c457e039e35ceed7 --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=a12cd81e0ef515edd9e0d800000001bb-1453954416.658122-38840208 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-27 20:13:37,690 truncating revision to first 12 chars 2016-01-27 20:13:37,690 Setting DEBUG logging. 2016-01-27 20:13:37,690 attempt 1/10 2016-01-27 20:13:37,690 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0ecd7d72f232?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-27 20:13:38,098 unpacking tar archive at: fx-team-0ecd7d72f232/testing/mozharness/ program finished with exit code 0 elapsedTime=0.689862 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 20:13:37.952911) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-27 20:13:37.953272) ========= echo 0ecd7d72f232304da046b352c457e039e35ceed7 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'0ecd7d72f232304da046b352c457e039e35ceed7'] 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=a12cd81e0ef515edd9e0d800000001bb-1453954416.658122-38840208 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 0ecd7d72f232304da046b352c457e039e35ceed7 program finished with exit code 0 elapsedTime=0.003827 script_repo_revision: '0ecd7d72f232304da046b352c457e039e35ceed7' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-27 20:13:38.002258) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-27 20:13:38.002623) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-27 20:13:38.012864) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 31 mins, 20 secs) (at 2016-01-27 20:13:38.013295) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite g2 --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-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', 'g2', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-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=a12cd81e0ef515edd9e0d800000001bb-1453954416.658122-38840208 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:13:38 INFO - MultiFileLogger online at 20160127 20:13:38 in /builds/slave/test 20:13:38 INFO - Run as scripts/scripts/talos_script.py --suite g2 --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 20:13:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:13:38 INFO - {'append_to_log': False, 20:13:38 INFO - 'base_work_dir': '/builds/slave/test', 20:13:38 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 20:13:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:13:38 INFO - 'branch': 'Fx-Team-Non-PGO', 20:13:38 INFO - 'buildbot_json_path': 'buildprops.json', 20:13:38 INFO - 'config_files': ('talos/linux_config.py',), 20:13:38 INFO - 'default_actions': ('clobber', 20:13:38 INFO - 'read-buildbot-config', 20:13:38 INFO - 'download-and-extract', 20:13:38 INFO - 'populate-webroot', 20:13:38 INFO - 'create-virtualenv', 20:13:38 INFO - 'install', 20:13:38 INFO - 'run-tests'), 20:13:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:13:38 INFO - 'download_minidump_stackwalk': True, 20:13:38 INFO - 'download_symbols': 'ondemand', 20:13:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:13:38 INFO - 'tooltool.py': '/tools/tooltool.py', 20:13:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:13:38 INFO - '/tools/misc-python/virtualenv.py')}, 20:13:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:13:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:13:38 INFO - 'installer_path': 'installer.exe', 20:13:38 INFO - 'log_level': 'info', 20:13:38 INFO - 'log_name': 'talos', 20:13:38 INFO - 'log_to_console': True, 20:13:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:13:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:13:38 INFO - 'opt_config_files': (), 20:13:38 INFO - 'pip_index': False, 20:13:38 INFO - 'sps_profile': False, 20:13:38 INFO - 'sps_profile_interval': 0, 20:13:38 INFO - 'suite': 'g2', 20:13:38 INFO - 'system_bits': '32', 20:13:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:13:38 INFO - 'title': 'talos-linux64-ix-064', 20:13:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:13:38 INFO - 'use_talos_json': True, 20:13:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:13:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:13:38 INFO - 'work_dir': 'build'} 20:13:38 INFO - ##### 20:13:38 INFO - ##### Running clobber step. 20:13:38 INFO - ##### 20:13:38 INFO - Running pre-action listener: _resource_record_pre_action 20:13:38 INFO - Running main action method: clobber 20:13:38 INFO - rmtree: /builds/slave/test/build 20:13:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:13:38 INFO - Running post-action listener: _resource_record_post_action 20:13:38 INFO - ##### 20:13:38 INFO - ##### Running read-buildbot-config step. 20:13:38 INFO - ##### 20:13:38 INFO - Running pre-action listener: _resource_record_pre_action 20:13:38 INFO - Running main action method: read_buildbot_config 20:13:38 INFO - Using buildbot properties: 20:13:38 INFO - { 20:13:38 INFO - "project": "", 20:13:38 INFO - "product": "firefox", 20:13:38 INFO - "script_repo_revision": "production", 20:13:38 INFO - "builddir": "fx-team_ubuntu64_hw_test-g2", 20:13:38 INFO - "repository": "", 20:13:38 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos g2", 20:13:38 INFO - "buildid": "20160127194100", 20:13:38 INFO - "pgo_build": "False", 20:13:38 INFO - "basedir": "/builds/slave/test", 20:13:38 INFO - "buildnumber": 1263, 20:13:38 INFO - "slavename": "talos-linux64-ix-064", 20:13:38 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 20:13:38 INFO - "platform": "ubuntu64_hw", 20:13:38 INFO - "scheduler": "tests-fx-team-linux64-talos", 20:13:38 INFO - "branch": "fx-team", 20:13:38 INFO - "repo_path": "integration/fx-team", 20:13:38 INFO - "revision": "0ecd7d72f232304da046b352c457e039e35ceed7", 20:13:38 INFO - "stage_platform": "linux64", 20:13:38 INFO - "builduid": "39b4f66fd63d4c0ca5b42cefc01be5fe", 20:13:38 INFO - "slavebuilddir": "test" 20:13:38 INFO - } 20:13:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/KQcZlzQYRNijrldyEU-2Yw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 20:13:38 INFO - Running post-action listener: _resource_record_post_action 20:13:38 INFO - ##### 20:13:38 INFO - ##### Running download-and-extract step. 20:13:38 INFO - ##### 20:13:38 INFO - Running pre-action listener: _resource_record_pre_action 20:13:38 INFO - Running main action method: download_and_extract 20:13:38 INFO - mkdir: /builds/slave/test/build/tests 20:13:38 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')]} 20:13:38 INFO - https://queue.taskcluster.net/v1/task/KQcZlzQYRNijrldyEU-2Yw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 20:13:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KQcZlzQYRNijrldyEU-2Yw/artifacts/public/build/test_packages.json 20:13:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KQcZlzQYRNijrldyEU-2Yw/artifacts/public/build/test_packages.json 20:13:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KQcZlzQYRNijrldyEU-2Yw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 20:13:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KQcZlzQYRNijrldyEU-2Yw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 20:13:39 INFO - Downloaded 1448 bytes. 20:13:39 INFO - Reading from file /builds/slave/test/build/test_packages.json 20:13:39 INFO - Using the following test package requirements: 20:13:39 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 20:13:39 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 20:13:39 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:13:39 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 20:13:39 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:13:39 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 20:13:39 INFO - u'jsshell-linux-x86_64.zip'], 20:13:39 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 20:13:39 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:13:39 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 20:13:39 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 20:13:39 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:13:39 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 20:13:39 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:13:39 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 20:13:39 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:13:39 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 20:13:39 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 20:13:39 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:13:39 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:13:39 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')]} 20:13:39 INFO - https://queue.taskcluster.net/v1/task/KQcZlzQYRNijrldyEU-2Yw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:13:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KQcZlzQYRNijrldyEU-2Yw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 20:13:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KQcZlzQYRNijrldyEU-2Yw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 20:13:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KQcZlzQYRNijrldyEU-2Yw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 20:13:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KQcZlzQYRNijrldyEU-2Yw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:13:40 INFO - Downloaded 21235255 bytes. 20:13:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:13:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:13:41 INFO - Return code: 0 20:13:41 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:13:41 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')]} 20:13:41 INFO - https://queue.taskcluster.net/v1/task/KQcZlzQYRNijrldyEU-2Yw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:13:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KQcZlzQYRNijrldyEU-2Yw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 20:13:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KQcZlzQYRNijrldyEU-2Yw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 20:13:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KQcZlzQYRNijrldyEU-2Yw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 20:13:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KQcZlzQYRNijrldyEU-2Yw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:13:42 INFO - Downloaded 21235255 bytes. 20:13:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:13:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:13:44 INFO - Return code: 0 20:13: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')]} 20:13:44 INFO - https://queue.taskcluster.net/v1/task/KQcZlzQYRNijrldyEU-2Yw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:13:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KQcZlzQYRNijrldyEU-2Yw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 20:13:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KQcZlzQYRNijrldyEU-2Yw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 20:13:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KQcZlzQYRNijrldyEU-2Yw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 20:13:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KQcZlzQYRNijrldyEU-2Yw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:13:45 INFO - Downloaded 10706572 bytes. 20:13:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:13:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 20:13:45 INFO - Return code: 0 20:13:45 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')]} 20:13:45 INFO - https://queue.taskcluster.net/v1/task/KQcZlzQYRNijrldyEU-2Yw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:13:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KQcZlzQYRNijrldyEU-2Yw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 20:13:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KQcZlzQYRNijrldyEU-2Yw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 20:13:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KQcZlzQYRNijrldyEU-2Yw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 20:13:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KQcZlzQYRNijrldyEU-2Yw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:13:46 INFO - Downloaded 54196202 bytes. 20:13:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KQcZlzQYRNijrldyEU-2Yw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 20:13:46 INFO - mkdir: /builds/slave/test/properties 20:13:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:13:46 INFO - Writing to file /builds/slave/test/properties/build_url 20:13:46 INFO - Contents: 20:13:46 INFO - build_url:https://queue.taskcluster.net/v1/task/KQcZlzQYRNijrldyEU-2Yw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 20:13:46 INFO - Running post-action listener: _resource_record_post_action 20:13:46 INFO - Running post-action listener: set_extra_try_arguments 20:13:46 INFO - ##### 20:13:46 INFO - ##### Running populate-webroot step. 20:13:46 INFO - ##### 20:13:46 INFO - Running pre-action listener: _resource_record_pre_action 20:13:46 INFO - Running main action method: populate_webroot 20:13:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:13:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:13:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:13:46 INFO - '--tppagecycles', 20:13:46 INFO - '7'], 20:13:46 INFO - 'tests': ['tsvgm']}}, 20:13:46 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 20:13:46 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 20:13:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:13:46 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 20:13:46 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 20:13:46 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 20:13:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:13:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:13:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:13:46 INFO - 'talos_options': ['--e10s'], 20:13:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:13:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:13:46 INFO - 'tests': ['damp', 'tps']}, 20:13:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:13:46 INFO - 'talos_options': ['--e10s'], 20:13:46 INFO - 'tests': ['damp', 'tps']}, 20:13:46 INFO - 'g3': {'tests': ['dromaeo_dom']}, 20:13:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:13:46 INFO - 'other': {'tests': ['a11yr', 20:13:46 INFO - 'ts_paint', 20:13:46 INFO - 'tpaint', 20:13:46 INFO - 'sessionrestore', 20:13:46 INFO - 'sessionrestore_no_auto_restore']}, 20:13:46 INFO - 'other-e10s': {'talos_options': ['--e10s'], 20:13:46 INFO - 'tests': ['a11yr', 20:13:46 INFO - 'ts_paint', 20:13:46 INFO - 'tpaint', 20:13:46 INFO - 'sessionrestore', 20:13:46 INFO - 'sessionrestore_no_auto_restore']}, 20:13:46 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 20:13:46 INFO - 'tests': ['a11yr', 20:13:46 INFO - 'ts_paint', 20:13:46 INFO - 'tpaint', 20:13:46 INFO - 'sessionrestore', 20:13:46 INFO - 'sessionrestore_no_auto_restore']}, 20:13:46 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 20:13:46 INFO - 'tests': ['a11yr', 20:13:46 INFO - 'ts_paint', 20:13:46 INFO - 'tpaint', 20:13:46 INFO - 'sessionrestore', 20:13:46 INFO - 'sessionrestore_no_auto_restore']}, 20:13:46 INFO - 'other_l64': {'tests': ['a11yr', 20:13:46 INFO - 'ts_paint', 20:13:46 INFO - 'tpaint', 20:13:46 INFO - 'sessionrestore', 20:13:46 INFO - 'sessionrestore_no_auto_restore']}, 20:13:46 INFO - 'other_nol64': {'tests': ['a11yr', 20:13:46 INFO - 'ts_paint', 20:13:46 INFO - 'tpaint', 20:13:46 INFO - 'sessionrestore', 20:13:46 INFO - 'sessionrestore_no_auto_restore']}, 20:13:46 INFO - 'svgr': {'tests': ['tsvgx', 20:13:46 INFO - 'tsvgr_opacity', 20:13:46 INFO - 'tart', 20:13:46 INFO - 'tscrollx', 20:13:46 INFO - 'cart']}, 20:13:46 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 20:13:46 INFO - 'tests': ['tsvgx', 20:13:46 INFO - 'tsvgr_opacity', 20:13:46 INFO - 'tart', 20:13:46 INFO - 'tscrollx', 20:13:46 INFO - 'cart']}, 20:13:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:13:46 INFO - 'tests': ['tp5o']}, 20:13:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:13:46 INFO - 'talos_options': ['--e10s'], 20:13:46 INFO - 'tests': ['tp5o']}, 20:13:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:13:46 INFO - 'talos_options': ['--xperf_path', 20:13:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:13:46 INFO - 'tests': ['tp5n']}, 20:13:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:13:46 INFO - 'talos_options': ['--e10s', 20:13:46 INFO - '--xperf_path', 20:13:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:13:46 INFO - 'tests': ['tp5n']}}, 20:13:46 INFO - 'talos.zip': {'path': '', 20:13:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:13:46 INFO - Downloading pageset... 20:13:46 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')]} 20:13:46 INFO - trying http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip 20:13:46 INFO - Downloading http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip to /builds/slave/test/build/tp5n.zip 20:13:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 'file_name': '/builds/slave/test/build/tp5n.zip'}, attempt #1 20:13:47 INFO - Downloaded 81753769 bytes. 20:13:47 INFO - Running command: ['unzip', '-q', '-o', '/builds/slave/test/build/tp5n.zip', '-d', '/builds/slave/test/build/tests/talos/talos/tests'] 20:13:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/tp5n.zip -d /builds/slave/test/build/tests/talos/talos/tests 20:13:49 INFO - Return code: 0 20:13:49 INFO - Running post-action listener: _resource_record_post_action 20:13:49 INFO - ##### 20:13:49 INFO - ##### Running create-virtualenv step. 20:13:49 INFO - ##### 20:13:49 INFO - Running pre-action listener: _resource_record_pre_action 20:13:49 INFO - Running main action method: create_virtualenv 20:13:49 INFO - Creating virtualenv /builds/slave/test/build/venv 20:13:49 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 20:13:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:13:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:13:49 INFO - Using real prefix '/usr' 20:13:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:13:51 INFO - Installing distribute.............................................................................................................................................................................................done. 20:13:55 INFO - Installing pip.................done. 20:13:55 INFO - Return code: 0 20:13:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:13:55 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')]} 20:13:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:13:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:13:55 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')]} 20:13:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:13:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:13:55 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 0x7fdbc3752f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b2dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22453d0>, '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 0x21b0ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b1360>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1453954416.658122-38840208', '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 20:13:55 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 20:13:55 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 20:13:55 INFO - Using env: {'DISPLAY': ':0', 20:13:55 INFO - 'HOME': '/home/cltbld', 20:13:55 INFO - 'LANG': 'en_US.UTF-8', 20:13:55 INFO - 'LANGUAGE': 'en_US:en', 20:13:55 INFO - 'LOGNAME': 'cltbld', 20:13:55 INFO - 'MAIL': '/var/mail/cltbld', 20:13:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:13:55 INFO - 'MOZ_NO_REMOTE': '1', 20:13:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:13:55 INFO - 'NO_EM_RESTART': '1', 20:13:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:13:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:13:55 INFO - 'PWD': '/builds/slave/test', 20:13:55 INFO - 'SHELL': '/bin/bash', 20:13:55 INFO - 'SHLVL': '1', 20:13:55 INFO - 'TERM': 'linux', 20:13:55 INFO - 'TMOUT': '86400', 20:13:55 INFO - 'USER': 'cltbld', 20:13:55 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1453954416.658122-38840208', 20:13:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:13:55 INFO - '_': '/tools/buildbot/bin/python'} 20:13:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:13:55 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 20:13:55 INFO - Cleaning up... 20:13:55 INFO - Return code: 0 20:13:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 20:13:55 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')]} 20:13:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:13:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:13:55 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')]} 20:13:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:13:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:13:55 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 0x7fdbc3752f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b2dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22453d0>, '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 0x21b0ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b1360>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1453954416.658122-38840208', '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 20:13:55 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 20:13:55 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 20:13:55 INFO - Using env: {'DISPLAY': ':0', 20:13:55 INFO - 'HOME': '/home/cltbld', 20:13:55 INFO - 'LANG': 'en_US.UTF-8', 20:13:55 INFO - 'LANGUAGE': 'en_US:en', 20:13:55 INFO - 'LOGNAME': 'cltbld', 20:13:55 INFO - 'MAIL': '/var/mail/cltbld', 20:13:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:13:55 INFO - 'MOZ_NO_REMOTE': '1', 20:13:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:13:55 INFO - 'NO_EM_RESTART': '1', 20:13:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:13:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:13:55 INFO - 'PWD': '/builds/slave/test', 20:13:55 INFO - 'SHELL': '/bin/bash', 20:13:55 INFO - 'SHLVL': '1', 20:13:55 INFO - 'TERM': 'linux', 20:13:55 INFO - 'TMOUT': '86400', 20:13:55 INFO - 'USER': 'cltbld', 20:13:55 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1453954416.658122-38840208', 20:13:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:13:55 INFO - '_': '/tools/buildbot/bin/python'} 20:13:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:13:55 INFO - Downloading/unpacking psutil>=0.7.1 20:13:55 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 20:13:55 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 20:13:55 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 20:13:55 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 20:13:55 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 20:13:55 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 20:13:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:13:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:13:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:13:57 INFO - Installing collected packages: psutil 20:13:57 INFO - Running setup.py install for psutil 20:13:57 INFO - building 'psutil._psutil_linux' extension 20:13:57 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 20:13:57 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 20:13:57 INFO - building 'psutil._psutil_posix' extension 20:13:57 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 20:13:58 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 20:13:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:13:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:13:58 INFO - Successfully installed psutil 20:13:58 INFO - Cleaning up... 20:13:58 INFO - Return code: 0 20:13:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 20:13:58 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')]} 20:13:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:13:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:13:58 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')]} 20:13:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:13:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:13:58 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 0x7fdbc3752f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b2dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22453d0>, '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 0x21b0ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b1360>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1453954416.658122-38840208', '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 20:13:58 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 20:13:58 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 20:13:58 INFO - Using env: {'DISPLAY': ':0', 20:13:58 INFO - 'HOME': '/home/cltbld', 20:13:58 INFO - 'LANG': 'en_US.UTF-8', 20:13:58 INFO - 'LANGUAGE': 'en_US:en', 20:13:58 INFO - 'LOGNAME': 'cltbld', 20:13:58 INFO - 'MAIL': '/var/mail/cltbld', 20:13:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:13:58 INFO - 'MOZ_NO_REMOTE': '1', 20:13:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:13:58 INFO - 'NO_EM_RESTART': '1', 20:13:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:13:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:13:58 INFO - 'PWD': '/builds/slave/test', 20:13:58 INFO - 'SHELL': '/bin/bash', 20:13:58 INFO - 'SHLVL': '1', 20:13:58 INFO - 'TERM': 'linux', 20:13:58 INFO - 'TMOUT': '86400', 20:13:58 INFO - 'USER': 'cltbld', 20:13:58 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1453954416.658122-38840208', 20:13:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:13:58 INFO - '_': '/tools/buildbot/bin/python'} 20:13:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:13:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:13:58 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 20:13:58 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 20:13:58 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 20:13:58 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 20:13:58 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 20:13:58 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 20:14:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:14:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:14:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 20:14:00 INFO - Installing collected packages: mozsystemmonitor 20:14:00 INFO - Running setup.py install for mozsystemmonitor 20:14:00 INFO - Successfully installed mozsystemmonitor 20:14:00 INFO - Cleaning up... 20:14:00 INFO - Return code: 0 20:14:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:14:00 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')]} 20:14:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:00 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')]} 20:14:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:00 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 0x7fdbc3752f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b2dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22453d0>, '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 0x21b0ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b1360>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1453954416.658122-38840208', '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 20:14:00 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 20:14:00 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 20:14:00 INFO - Using env: {'DISPLAY': ':0', 20:14:00 INFO - 'HOME': '/home/cltbld', 20:14:00 INFO - 'LANG': 'en_US.UTF-8', 20:14:00 INFO - 'LANGUAGE': 'en_US:en', 20:14:00 INFO - 'LOGNAME': 'cltbld', 20:14:00 INFO - 'MAIL': '/var/mail/cltbld', 20:14:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:00 INFO - 'MOZ_NO_REMOTE': '1', 20:14:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:14:00 INFO - 'NO_EM_RESTART': '1', 20:14:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:14:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:00 INFO - 'PWD': '/builds/slave/test', 20:14:00 INFO - 'SHELL': '/bin/bash', 20:14:00 INFO - 'SHLVL': '1', 20:14:00 INFO - 'TERM': 'linux', 20:14:00 INFO - 'TMOUT': '86400', 20:14:00 INFO - 'USER': 'cltbld', 20:14:00 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1453954416.658122-38840208', 20:14:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:00 INFO - '_': '/tools/buildbot/bin/python'} 20:14:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:00 INFO - Downloading/unpacking blobuploader==1.2.4 20:14:00 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 20:14:00 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 20:14:00 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 20:14:00 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 20:14:00 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 20:14:00 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 20:14:02 INFO - Downloading blobuploader-1.2.4.tar.gz 20:14:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:14:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:14:02 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 20:14:02 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 20:14:02 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 20:14:02 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 20:14:02 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 20:14:02 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 20:14:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:14:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:14:02 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 20:14:02 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 20:14:02 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 20:14:02 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 20:14:02 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 20:14:02 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 20:14:02 INFO - Downloading docopt-0.6.1.tar.gz 20:14:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:14:03 INFO - Installing collected packages: blobuploader, requests, docopt 20:14:03 INFO - Running setup.py install for blobuploader 20:14:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:14:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:14:03 INFO - Running setup.py install for requests 20:14:03 INFO - Running setup.py install for docopt 20:14:03 INFO - Successfully installed blobuploader requests docopt 20:14:03 INFO - Cleaning up... 20:14:03 INFO - Return code: 0 20:14:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:14:03 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')]} 20:14:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:03 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')]} 20:14:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:03 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 0x7fdbc3752f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b2dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22453d0>, '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 0x21b0ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b1360>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1453954416.658122-38840208', '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 20:14:03 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 20:14:03 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 20:14:03 INFO - Using env: {'DISPLAY': ':0', 20:14:03 INFO - 'HOME': '/home/cltbld', 20:14:03 INFO - 'LANG': 'en_US.UTF-8', 20:14:03 INFO - 'LANGUAGE': 'en_US:en', 20:14:03 INFO - 'LOGNAME': 'cltbld', 20:14:03 INFO - 'MAIL': '/var/mail/cltbld', 20:14:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:03 INFO - 'MOZ_NO_REMOTE': '1', 20:14:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:14:03 INFO - 'NO_EM_RESTART': '1', 20:14:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:14:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:03 INFO - 'PWD': '/builds/slave/test', 20:14:03 INFO - 'SHELL': '/bin/bash', 20:14:03 INFO - 'SHLVL': '1', 20:14:03 INFO - 'TERM': 'linux', 20:14:03 INFO - 'TMOUT': '86400', 20:14:03 INFO - 'USER': 'cltbld', 20:14:03 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1453954416.658122-38840208', 20:14:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:03 INFO - '_': '/tools/buildbot/bin/python'} 20:14:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:14:03 INFO - Running setup.py (path:/tmp/pip-EnGACz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:14:03 INFO - Running setup.py (path:/tmp/pip-rP79n_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:14:04 INFO - Running setup.py (path:/tmp/pip-6_NY20-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:14:04 INFO - Running setup.py (path:/tmp/pip-317oxN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:14:04 INFO - Running setup.py (path:/tmp/pip-RDNQWQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:14:04 INFO - Running setup.py (path:/tmp/pip-8eddQg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:14:04 INFO - Running setup.py (path:/tmp/pip-7Tvhx6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:14:04 INFO - Running setup.py (path:/tmp/pip-90iuhM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:14:04 INFO - Running setup.py (path:/tmp/pip-XY6Svq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:14:04 INFO - Running setup.py (path:/tmp/pip-z00HQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:14:04 INFO - Running setup.py (path:/tmp/pip-5EkG9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:14:04 INFO - Running setup.py (path:/tmp/pip-UPl1P0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:14:04 INFO - Running setup.py (path:/tmp/pip-yeUuHR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:14:04 INFO - Running setup.py (path:/tmp/pip-y_JVxi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:14:04 INFO - Running setup.py (path:/tmp/pip-ANvosu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:14:04 INFO - Running setup.py (path:/tmp/pip-ocGCe9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:14:05 INFO - Running setup.py (path:/tmp/pip-lUD6xz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:14:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:14:05 INFO - Running setup.py install for manifestparser 20:14:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:14:05 INFO - Running setup.py install for mozcrash 20:14:05 INFO - Running setup.py install for mozdebug 20:14:05 INFO - Running setup.py install for mozdevice 20:14:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:14:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:14:05 INFO - Running setup.py install for mozfile 20:14:05 INFO - Running setup.py install for mozhttpd 20:14:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:14:05 INFO - Running setup.py install for mozinfo 20:14:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:14:05 INFO - Running setup.py install for mozInstall 20:14:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:14:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:14:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:14:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:14:05 INFO - Running setup.py install for mozleak 20:14:05 INFO - Running setup.py install for mozlog 20:14:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:14:06 INFO - Running setup.py install for moznetwork 20:14:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:14:06 INFO - Running setup.py install for mozprocess 20:14:06 INFO - Running setup.py install for mozprofile 20:14:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:14:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:14:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:14:06 INFO - Running setup.py install for mozrunner 20:14:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:14:06 INFO - Running setup.py install for mozscreenshot 20:14:06 INFO - Running setup.py install for moztest 20:14:06 INFO - Running setup.py install for mozversion 20:14:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:14:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:14:06 INFO - Cleaning up... 20:14:06 INFO - Return code: 0 20:14:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:14: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')]} 20:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14: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')]} 20:14:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:06 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 0x7fdbc3752f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b2dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22453d0>, '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 0x21b0ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b1360>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1453954416.658122-38840208', '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 20:14:06 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 20:14:06 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 20:14:06 INFO - Using env: {'DISPLAY': ':0', 20:14:06 INFO - 'HOME': '/home/cltbld', 20:14:06 INFO - 'LANG': 'en_US.UTF-8', 20:14:06 INFO - 'LANGUAGE': 'en_US:en', 20:14:06 INFO - 'LOGNAME': 'cltbld', 20:14:06 INFO - 'MAIL': '/var/mail/cltbld', 20:14:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:06 INFO - 'MOZ_NO_REMOTE': '1', 20:14:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:14:06 INFO - 'NO_EM_RESTART': '1', 20:14:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:14:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:06 INFO - 'PWD': '/builds/slave/test', 20:14:06 INFO - 'SHELL': '/bin/bash', 20:14:06 INFO - 'SHLVL': '1', 20:14:06 INFO - 'TERM': 'linux', 20:14:06 INFO - 'TMOUT': '86400', 20:14:06 INFO - 'USER': 'cltbld', 20:14:06 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1453954416.658122-38840208', 20:14:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:06 INFO - '_': '/tools/buildbot/bin/python'} 20:14:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:14:07 INFO - Running setup.py (path:/tmp/pip-g64VTF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:14:07 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)) 20:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:14:07 INFO - Running setup.py (path:/tmp/pip-tSohtS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:14:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 20:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:14:07 INFO - Running setup.py (path:/tmp/pip-A9Mo0i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:14:07 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)) 20:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:14:07 INFO - Running setup.py (path:/tmp/pip-g1WuZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:14:07 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)) 20:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:14:07 INFO - Running setup.py (path:/tmp/pip-rfRxp2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:14:07 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)) 20:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:14:07 INFO - Running setup.py (path:/tmp/pip-92b8Hw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:14:07 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)) 20:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:14:07 INFO - Running setup.py (path:/tmp/pip-t41Jvd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:14:07 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)) 20:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:14:07 INFO - Running setup.py (path:/tmp/pip-9YUe3U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:14:07 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)) 20:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:14:07 INFO - Running setup.py (path:/tmp/pip-hsCz8M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:14:07 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)) 20:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:14:07 INFO - Running setup.py (path:/tmp/pip-hNAlei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:14:07 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)) 20:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:14:07 INFO - Running setup.py (path:/tmp/pip-QnoPbQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:14:07 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)) 20:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:14:07 INFO - Running setup.py (path:/tmp/pip-eLbJB4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:14:07 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)) 20:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:14:07 INFO - Running setup.py (path:/tmp/pip-3aH6VU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:14:08 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)) 20:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:14:08 INFO - Running setup.py (path:/tmp/pip-2935o9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:14:08 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)) 20:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:14:08 INFO - Running setup.py (path:/tmp/pip-DVSdbh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:14:08 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)) 20:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:14:08 INFO - Running setup.py (path:/tmp/pip-5JB1Mr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:14:08 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)) 20:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:14:08 INFO - Running setup.py (path:/tmp/pip-lFDzBz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:14:08 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)) 20:14:08 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:14:08 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:14:08 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)) 20:14:08 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)) 20:14:08 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)) 20:14:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:14:08 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 20:14:08 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 20:14:08 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 20:14:08 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 20:14:08 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 20:14:08 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 20:14:10 INFO - Downloading blessings-1.6.tar.gz 20:14:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:14:10 INFO - Installing collected packages: blessings 20:14:10 INFO - Running setup.py install for blessings 20:14:10 INFO - Successfully installed blessings 20:14:10 INFO - Cleaning up... 20:14:10 INFO - Return code: 0 20:14:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:14:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:14:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:14:10 INFO - Reading from file tmpfile_stdout 20:14:10 INFO - Current package versions: 20:14:10 INFO - argparse == 1.2.1 20:14:10 INFO - blessings == 1.6 20:14:10 INFO - blobuploader == 1.2.4 20:14:10 INFO - docopt == 0.6.1 20:14:10 INFO - manifestparser == 1.1 20:14:10 INFO - mozInstall == 1.12 20:14:10 INFO - mozcrash == 0.16 20:14:10 INFO - mozdebug == 0.1 20:14:10 INFO - mozdevice == 0.48 20:14:10 INFO - mozfile == 1.2 20:14:10 INFO - mozhttpd == 0.7 20:14:10 INFO - mozinfo == 0.9 20:14:10 INFO - mozleak == 0.1 20:14:10 INFO - mozlog == 3.1 20:14:10 INFO - moznetwork == 0.27 20:14:10 INFO - mozprocess == 0.22 20:14:10 INFO - mozprofile == 0.28 20:14:10 INFO - mozrunner == 6.11 20:14:10 INFO - mozscreenshot == 0.1 20:14:10 INFO - mozsystemmonitor == 0.0 20:14:10 INFO - moztest == 0.7 20:14:10 INFO - mozversion == 1.4 20:14:10 INFO - psutil == 3.1.1 20:14:10 INFO - requests == 1.2.3 20:14:10 INFO - wsgiref == 0.1.2 20:14:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:14:10 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')]} 20:14:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:10 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')]} 20:14:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:10 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 0x7fdbc3752f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b2dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22453d0>, '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 0x21b0ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b1360>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1453954416.658122-38840208', '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 20:14:10 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 20:14:10 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 20:14:10 INFO - Using env: {'DISPLAY': ':0', 20:14:10 INFO - 'HOME': '/home/cltbld', 20:14:10 INFO - 'LANG': 'en_US.UTF-8', 20:14:10 INFO - 'LANGUAGE': 'en_US:en', 20:14:10 INFO - 'LOGNAME': 'cltbld', 20:14:10 INFO - 'MAIL': '/var/mail/cltbld', 20:14:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:10 INFO - 'MOZ_NO_REMOTE': '1', 20:14:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:14:10 INFO - 'NO_EM_RESTART': '1', 20:14:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:14:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:10 INFO - 'PWD': '/builds/slave/test', 20:14:10 INFO - 'SHELL': '/bin/bash', 20:14:10 INFO - 'SHLVL': '1', 20:14:10 INFO - 'TERM': 'linux', 20:14:10 INFO - 'TMOUT': '86400', 20:14:10 INFO - 'USER': 'cltbld', 20:14:10 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1453954416.658122-38840208', 20:14:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:10 INFO - '_': '/tools/buildbot/bin/python'} 20:14:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:10 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)) 20:14:10 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)) 20:14:10 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)) 20:14:10 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)) 20:14:10 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)) 20:14:10 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)) 20:14:10 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)) 20:14:10 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)) 20:14:10 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)) 20:14:10 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)) 20:14:10 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)) 20:14:10 INFO - Cleaning up... 20:14:10 INFO - Return code: 0 20:14:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:14:10 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')]} 20:14:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:10 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')]} 20:14:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:10 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 0x7fdbc3752f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b2dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22453d0>, '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 0x21b0ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b1360>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1453954416.658122-38840208', '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 20:14:10 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 20:14:10 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 20:14:10 INFO - Using env: {'DISPLAY': ':0', 20:14:10 INFO - 'HOME': '/home/cltbld', 20:14:10 INFO - 'LANG': 'en_US.UTF-8', 20:14:10 INFO - 'LANGUAGE': 'en_US:en', 20:14:10 INFO - 'LOGNAME': 'cltbld', 20:14:10 INFO - 'MAIL': '/var/mail/cltbld', 20:14:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:10 INFO - 'MOZ_NO_REMOTE': '1', 20:14:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:14:10 INFO - 'NO_EM_RESTART': '1', 20:14:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:14:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:10 INFO - 'PWD': '/builds/slave/test', 20:14:10 INFO - 'SHELL': '/bin/bash', 20:14:10 INFO - 'SHLVL': '1', 20:14:10 INFO - 'TERM': 'linux', 20:14:10 INFO - 'TMOUT': '86400', 20:14:10 INFO - 'USER': 'cltbld', 20:14:10 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1453954416.658122-38840208', 20:14:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:10 INFO - '_': '/tools/buildbot/bin/python'} 20:14:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:10 INFO - Downloading/unpacking jsonschema 20:14:10 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 20:14:10 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 20:14:10 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 20:14:10 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 20:14:10 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 20:14:10 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 20:14:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:14:12 INFO - Downloading/unpacking functools32 (from jsonschema) 20:14:12 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 20:14:12 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 20:14:12 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 20:14:12 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 20:14:12 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 20:14:12 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 20:14:12 INFO - Downloading functools32-3.2.3-2.tar.gz 20:14:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:14:12 INFO - warning: no files found matching '*.txt' 20:14:12 INFO - no previously-included directories found matching 'build' 20:14:12 INFO - no previously-included directories found matching 'dist' 20:14:12 INFO - no previously-included directories found matching '.git*' 20:14:12 INFO - Installing collected packages: jsonschema, functools32 20:14:13 INFO - Running setup.py install for functools32 20:14:13 INFO - warning: no files found matching '*.txt' 20:14:13 INFO - no previously-included directories found matching 'build' 20:14:13 INFO - no previously-included directories found matching 'dist' 20:14:13 INFO - no previously-included directories found matching '.git*' 20:14:13 INFO - Successfully installed jsonschema functools32 20:14:13 INFO - Cleaning up... 20:14:13 INFO - Return code: 0 20:14:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:14:13 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')]} 20:14:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:13 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')]} 20:14:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:13 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 0x7fdbc3752f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21b2dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22453d0>, '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 0x21b0ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b1360>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1453954416.658122-38840208', '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 20:14:13 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 20:14:13 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 20:14:13 INFO - Using env: {'DISPLAY': ':0', 20:14:13 INFO - 'HOME': '/home/cltbld', 20:14:13 INFO - 'LANG': 'en_US.UTF-8', 20:14:13 INFO - 'LANGUAGE': 'en_US:en', 20:14:13 INFO - 'LOGNAME': 'cltbld', 20:14:13 INFO - 'MAIL': '/var/mail/cltbld', 20:14:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:13 INFO - 'MOZ_NO_REMOTE': '1', 20:14:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:14:13 INFO - 'NO_EM_RESTART': '1', 20:14:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:14:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:13 INFO - 'PWD': '/builds/slave/test', 20:14:13 INFO - 'SHELL': '/bin/bash', 20:14:13 INFO - 'SHLVL': '1', 20:14:13 INFO - 'TERM': 'linux', 20:14:13 INFO - 'TMOUT': '86400', 20:14:13 INFO - 'USER': 'cltbld', 20:14:13 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1453954416.658122-38840208', 20:14:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:13 INFO - '_': '/tools/buildbot/bin/python'} 20:14:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:13 INFO - Downloading/unpacking flake8 20:14:13 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 20:14:13 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 20:14:13 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 20:14:13 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 20:14:13 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 20:14:13 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 20:14:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:14:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:14:15 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 20:14:15 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 20:14:15 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 20:14:15 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 20:14:15 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 20:14:15 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 20:14:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:14:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:14:15 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 20:14:15 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 20:14:15 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 20:14:15 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 20:14:15 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 20:14:15 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 20:14:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:14:15 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 20:14:15 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 20:14:15 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 20:14:15 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 20:14:15 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 20:14:15 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 20:14:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:14:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:14:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:14:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:14:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:14:15 INFO - no previously-included directories found matching 'docs/_build' 20:14:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:14:15 INFO - Running setup.py install for pep8 20:14:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:14:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:14:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:14:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:14:16 INFO - no previously-included directories found matching 'docs/_build' 20:14:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:14:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:14:16 INFO - Cleaning up... 20:14:16 INFO - Return code: 0 20:14:16 INFO - Running post-action listener: _resource_record_post_action 20:14:16 INFO - Running post-action listener: _start_resource_monitoring 20:14:16 INFO - Starting resource monitoring. 20:14:16 INFO - ##### 20:14:16 INFO - ##### Running install step. 20:14:16 INFO - ##### 20:14:16 INFO - Running pre-action listener: _resource_record_pre_action 20:14:16 INFO - Running main action method: install 20:14:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:14:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:14:16 INFO - Reading from file tmpfile_stdout 20:14:16 INFO - Detecting whether we're running mozinstall >=1.0... 20:14:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:14:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:14:16 INFO - Reading from file tmpfile_stdout 20:14:16 INFO - Output received: 20:14:16 INFO - Usage: mozinstall [options] installer 20:14:16 INFO - Options: 20:14:16 INFO - -h, --help show this help message and exit 20:14:16 INFO - -d DEST, --destination=DEST 20:14:16 INFO - Directory to install application into. [default: 20:14:16 INFO - "/builds/slave/test"] 20:14:16 INFO - --app=APP Application being installed. [default: firefox] 20:14:16 INFO - mkdir: /builds/slave/test/build/application 20:14:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:14:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:14:32 INFO - Reading from file tmpfile_stdout 20:14:32 INFO - Output received: 20:14:32 INFO - /builds/slave/test/build/application/firefox/firefox 20:14:32 INFO - Running post-action listener: _resource_record_post_action 20:14:32 INFO - ##### 20:14:32 INFO - ##### Running run-tests step. 20:14:32 INFO - ##### 20:14:32 INFO - Running pre-action listener: _resource_record_pre_action 20:14:32 INFO - Running main action method: run_tests 20:14:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:14:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:14:32 INFO - Python 2.7.3 20:14:32 INFO - Return code: 0 20:14:32 INFO - grabbing minidump binary from tooltool 20:14:32 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')]} 20:14:32 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 0x22453d0>, '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 0x21b0ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b1360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:14:32 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 20:14:32 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 20:14:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:14:32 INFO - Return code: 0 20:14:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:14:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:14:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:14:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:14:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:14:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:14:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:14:33 INFO - Return code: 0 20:14:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'g2', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KQcZlzQYRNijrldyEU-2Yw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/g2_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/g2_raw.log'] in /builds/slave/test/build 20:14:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite g2 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KQcZlzQYRNijrldyEU-2Yw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/g2_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/g2_raw.log 20:14:33 INFO - Using env: {'DISPLAY': ':0', 20:14:33 INFO - 'HOME': '/home/cltbld', 20:14:33 INFO - 'LANG': 'en_US.UTF-8', 20:14:33 INFO - 'LANGUAGE': 'en_US:en', 20:14:33 INFO - 'LOGNAME': 'cltbld', 20:14:33 INFO - 'MAIL': '/var/mail/cltbld', 20:14:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:14:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:14:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:33 INFO - 'MOZ_NO_REMOTE': '1', 20:14:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:14:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:14:33 INFO - 'NO_EM_RESTART': '1', 20:14:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:14:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:33 INFO - 'PWD': '/builds/slave/test', 20:14:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:14:33 INFO - 'SHELL': '/bin/bash', 20:14:33 INFO - 'SHLVL': '1', 20:14:33 INFO - 'TERM': 'linux', 20:14:33 INFO - 'TMOUT': '86400', 20:14:33 INFO - 'USER': 'cltbld', 20:14:33 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1453954416.658122-38840208', 20:14:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:33 INFO - '_': '/tools/buildbot/bin/python'} 20:14:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'g2', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KQcZlzQYRNijrldyEU-2Yw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/g2_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/g2_raw.log'] with output_timeout 3600 20:14:34 INFO - mozversion application_buildid: 20160127194100 20:14:34 INFO - mozversion application_changeset: 0ecd7d72f232304da046b352c457e039e35ceed7 20:14:34 INFO - mozversion application_display_name: Nightly 20:14:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:14:34 INFO - mozversion application_name: Firefox 20:14:34 INFO - mozversion application_remotingname: firefox 20:14:34 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:14:34 INFO - mozversion application_vendor: Mozilla 20:14:34 INFO - mozversion application_version: 47.0a1 20:14:34 INFO - mozversion platform_buildid: 20160127194100 20:14:34 INFO - mozversion platform_changeset: 0ecd7d72f232304da046b352c457e039e35ceed7 20:14:34 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:14:34 INFO - mozversion platform_version: 47.0a1 20:14:34 INFO - using testdate: 1453954474 20:14:34 INFO - actual date: 1453954474 20:14:34 INFO - starting webserver on 'localhost:41160' 20:14:34 INFO - SUITE-START | Running 2 tests 20:14:34 INFO - TEST-START | damp 20:14:34 INFO - operating with platform_type : linux_ 20:14:34 INFO - Initialising browser for damp test... 20:14:34 INFO - TEST-INFO | started process 6407 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD47MEo/profile http://localhost:41160/getInfo.html) 20:14:38 INFO - PROCESS | 6407 | __metrics Screen width/height:1600/1200 20:14:38 INFO - PROCESS | 6407 | colorDepth:24 20:14:38 INFO - PROCESS | 6407 | Browser inner width/height: 1024/697 20:14:38 INFO - PROCESS | 6407 | __metrics 20:14:39 INFO - PROCESS | 6407 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:14:39 INFO - PROCESS | 6407 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:14:40 INFO - TEST-INFO | 6407: exit 0 20:14:40 INFO - Browser initialized. 20:14:40 INFO - Running cycle 1/1 for damp test... 20:14:40 INFO - TEST-INFO | started process 6502 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD47MEo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/devtools/damp.manifest.develop -tpchrome -tpnoisy -tploadnocache -tpcycles 1 -tppagecycles 25) 20:14:52 INFO - PROCESS | 6502 | RSS: Main: 149557248 20:14:52 INFO - PROCESS | 6502 | 20:14:52 INFO - PROCESS | 6502 | console.error: 20:14:52 INFO - PROCESS | 6502 | Failed to load module devtools/shared/gcli/commands/mdn: Module `devtools/shared/gcli/commands/mdn` is not found at resource://devtools/shared/gcli/commands/mdn.js 20:14:52 INFO - PROCESS | 6502 | console.error: 20:14:52 INFO - PROCESS | 6502 | exports.createSystem/system.addItemsByModule/damp: 282.18 20:44:53 INFO - RETURN: tps: 58.24 20:44:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [1348.3950000000004, 355.93500000000495, 343.6399999999994, 347.9899999999907, 355.3500000000058, 344.1500000000233, 375.66499999997905, 357.8500000000349, 346.15499999996973, 356.304999999993, 382.03000000002794, 369.38000000000466, 354.9300000000512, 362.61999999999534, 349.70999999996275, 341.78999999992084, 352.25, 340.59499999997206, 374.8050000000512, 347.35999999998603, 347.0450000000419, 361.40500000002794, 345.9550000000745, 376.60000000009313, 345.01499999989755], "unit": "ms", "name": "simple.webconsole.open.DAMP", "value": 353.5900000000256}, {"lowerIsBetter": true, "replicates": [45.58499999999913, 44.63499999999476, 34.625, 44.69999999998254, 44.64999999999418, 39.149999999965075, 39.039999999979045, 41.03499999997439, 41.625, 39.945000000006985, 40.54000000003725, 40.699999999953434, 44.25, 41.59000000008382, 41.54500000004191, 45.11999999999534, 34.94500000006519, 37.949999999953434, 35.625, 45.14000000001397, 45.11999999999534, 35.97999999998137, 34.66500000003725, 35.794999999925494, 46.550000000046566], "unit": "ms", "name": "simple.webconsole.reload.DAMP", "value": 40.86749999996391}, {"lowerIsBetter": true, "replicates": [44.525000000001455, 46.80500000000029, 39.55500000000757, 43.83999999999651, 43.654999999998836, 43.73999999999069, 45.86000000004424, 51.35499999998137, 54.01000000000931, 45.69000000000233, 55.85499999998137, 44.43000000005122, 41.455000000074506, 42.339999999967404, 40.59999999997672, 41.26000000000931, 40.31499999994412, 41.75, 44.39500000001863, 44.035000000032596, 43.39500000001863, 45.20999999996275, 43.014999999897555, 45.69500000006519, 44.94000000017695], "unit": "ms", "name": "simple.webconsole.close.DAMP", "value": 43.93750000001455}, {"lowerIsBetter": true, "replicates": [698.6949999999997, 478.97000000000116, 464.4400000000023, 464.5450000000128, 455.66499999997905, 443.2950000000419, 450.4099999999744, 469.36999999999534, 460.95999999996275, 464.0650000000023, 468.5649999999441, 471.7949999999255, 482.8049999999348, 462.97500000009313, 463.4199999999255, 475.5350000000326, 455.32499999995343, 447.16500000003725, 487.46999999997206, 473.4449999999488, 446.5100000000093, 476.8599999998696, 466.2150000000838, 472.95999999996275, 452.3300000000745], "unit": "ms", "name": "simple.inspector.open.DAMP", "value": 464.49250000000757}, {"lowerIsBetter": true, "replicates": [157.10000000000036, 123.73500000000058, 119.86999999999534, 116.89499999998952, 121.05499999999302, 117.46999999997206, 116.89000000001397, 116.55499999999302, 120.47000000003027, 126.59999999997672, 118.5, 117.65499999991152, 117.22499999997672, 117.19500000006519, 117.32499999995343, 118.01000000000931, 120.125, 118.83499999996275, 119.34999999997672, 121.66500000003725, 125.56000000005588, 123.125, 121.88000000012107, 126.82000000006519, 121.0], "unit": "ms", "name": "simple.inspector.reload.DAMP", "value": 119.60999999998603}, {"lowerIsBetter": true, "replicates": [88.31500000000051, 64.27000000000407, 61.345000000001164, 64.4550000000163, 63.08999999999651, 61.225000000034925, 62.65000000002328, 63.53499999997439, 71.17999999999302, 64.74499999999534, 64.58499999996275, 64.76000000000931, 69.38500000000931, 64.70000000006985, 66.93500000005588, 61.824999999953434, 62.214999999967404, 63.050000000046566, 61.36999999999534, 64.31000000005588, 72.49499999999534, 63.0, 61.05499999993481, 61.96499999985099, 65.625], "unit": "ms", "name": "simple.inspector.close.DAMP", "value": 63.90249999998923}, {"lowerIsBetter": true, "replicates": [645.4499999999989, 511.1499999999942, 499.4499999999971, 478.0249999999942, 499.20999999999185, 503.00500000000466, 527.140000000014, 517.7099999999627, 539.2050000000163, 514.8899999999558, 532.9249999999302, 645.2449999999953, 521.765000000014, 511.3299999999581, 488.08499999996275, 479.33499999996275, 504.3399999999674, 481.18499999993946, 505.5100000000093, 491.6949999999488, 485.96999999997206, 500.7650000001304, 486.089999999851, 536.3700000001118, 505.5700000000652], "unit": "ms", "name": "simple.jsdebugger.open.DAMP", "value": 504.92499999998836}, {"lowerIsBetter": true, "replicates": [56.20000000000073, 49.43000000000757, 47.705000000001746, 47.81500000000233, 48.46999999997206, 47.23999999999069, 47.01999999996042, 55.68499999999767, 52.75, 47.47999999998137, 52.57500000006985, 361.29999999993015, 56.76500000001397, 44.13000000000466, 50.08499999996275, 47.925000000046566, 52.514999999897555, 47.339999999967404, 55.04999999993015, 46.78000000002794, 47.464999999967404, 47.13000000012107, 46.66500000003725, 54.765000000130385, 47.22000000020489], "unit": "ms", "name": "simple.jsdebugger.reload.DAMP", "value": 47.87000000002445}, {"lowerIsBetter": true, "replicates": [34.75, 47.27500000000873, 43.544999999998254, 40.585000000020955, 41.76999999998952, 39.67499999998836, 52.27500000002328, 45.97499999997672, 49.09999999997672, 41.625, 47.839999999967404, 52.27000000001863, 46.860000000102445, 40.809999999939464, 41.86499999999069, 45.21000000007916, 43.22500000009313, 40.23999999999069, 45.95000000006985, 43.68500000005588, 39.47999999998137, 82.375, 42.74500000011176, 47.08499999996275, 43.99499999987893], "unit": "ms", "name": "simple.jsdebugger.close.DAMP", "value": 43.839999999967404}, {"lowerIsBetter": true, "replicates": [643.875, 743.304999999993, 685.945000000007, 666.2850000000035, 696.9550000000163, 669.375, 740.609999999986, 768.3550000000396, 690.9799999999814, 665.3399999999674, 689.9799999999814, 697.2299999999814, 761.3899999998976, 643.5250000000233, 627.609999999986, 630.8149999999441, 658.7899999999208, 645.0650000000605, 714.4349999999395, 667.5450000000419, 613.1750000000466, 834.9399999999441, 643.9700000002049, 757.7800000000279, 654.184999999823], "unit": "ms", "name": "simple.styleeditor.open.DAMP", "value": 677.6600000000035}, {"lowerIsBetter": true, "replicates": [39.93499999999949, 59.820000000006985, 36.93499999999767, 54.375, 53.75, 54.89499999996042, 54.55999999999767, 58.22000000003027, 50.90000000002328, 54.225000000034925, 52.964999999967404, 57.25500000000466, 77.95999999996275, 37.46999999997206, 36.76000000000931, 54.81499999994412, 36.46999999997206, 55.19500000006519, 62.57500000006985, 37.55500000005122, 56.35000000009313, 56.674999999813735, 53.045000000158325, 55.54000000003725, 54.860000000102445], "unit": "ms", "name": "simple.styleeditor.reload.DAMP", "value": 54.687499999970896}, {"lowerIsBetter": true, "replicates": [39.89499999999862, 59.0, 48.054999999993015, 50.19000000000233, 46.31500000000233, 52.84500000003027, 53.65000000002328, 54.73000000003958, 48.13000000000466, 53.60499999998137, 49.10499999998137, 50.77000000001863, 55.65999999991618, 46.99500000011176, 45.85499999998137, 54.5, 45.84499999997206, 53.07999999995809, 46.35999999998603, 48.76000000000931, 55.43500000005588, 51.34499999997206, 48.390000000130385, 48.18000000016764, 52.25499999988824], "unit": "ms", "name": "simple.styleeditor.close.DAMP", "value": 50.48000000001048}, {"lowerIsBetter": true, "replicates": [479.28499999999985, 640.5500000000029, 344.3549999999959, 469.11000000001513, 483.4649999999965, 341.0, 583.710000000021, 666.0800000000163, 462.75, 513.335000000021, 363.0899999999674, 377.1049999999814, 561.2550000000047, 340.35999999998603, 469.75500000000466, 486.08499999996275, 352.80999999993946, 337.5100000000093, 564.0250000000233, 494.1450000000186, 361.39000000001397, 374.3049999999348, 327.73500000010245, 558.0549999999348, 497.89999999990687], "unit": "ms", "name": "simple.performance.open.DAMP", "value": 469.4325000000099}, {"lowerIsBetter": true, "replicates": [30.774999999999636, 36.86500000000524, 126.375, 67.19000000000233, 82.14499999998952, 33.960000000020955, 91.20000000001164, 42.54999999998836, 162.80499999999302, 82.17999999999302, 79.95999999996275, 34.76500000001397, 114.22000000008848, 120.94999999995343, 81.78000000002794, 76.89000000001397, 123.39500000001863, 40.375, 85.84500000008848, 77.56499999994412, 36.425000000046566, 34.074999999953434, 30.800000000046566, 61.94499999983236, 82.88500000000931], "unit": "ms", "name": "simple.performance.reload.DAMP", "value": 78.76249999995343}, {"lowerIsBetter": true, "replicates": [29.36499999999978, 38.195000000006985, 57.52500000000873, 49.17499999998836, 44.779999999998836, 37.90499999996973, 41.47000000003027, 43.210000000020955, 82.30499999999302, 42.65000000002328, 64.93499999993946, 40.49499999999534, 86.14500000001863, 55.75, 53.13000000000466, 58.32999999995809, 58.91499999992084, 40.31499999994412, 44.96500000008382, 64.19500000006519, 101.82499999995343, 37.625, 42.06499999994412, 54.455000000074506, 50.700000000186265], "unit": "ms", "name": "simple.performance.close.DAMP", "value": 49.93750000008731}, {"lowerIsBetter": true, "replicates": [398.5400000000009, 348.97000000000116, 543.0299999999988, 439.429999999993, 454.8150000000023, 655.859999999986, 417.8649999999907, 391.75, 425.70000000001164, 465.28000000002794, 456.6549999999115, 357.5, 401.32499999995343, 582.125, 425.63000000000466, 412.7949999999255, 542.890000000014, 665.2049999999581, 421.1600000000326, 428.69999999995343, 679.2700000000186, 362.68000000016764, 510.58499999996275, 394.6149999999907, 459.1500000001397], "unit": "ms", "name": "simple.netmonitor.open.DAMP", "value": 434.0649999999732}, {"lowerIsBetter": true, "replicates": [86.17500000000291, 38.86500000000524, 40.69499999999243, 37.920000000012806, 34.45000000001164, 75.125, 42.73499999998603, 49.789999999979045, 36.61999999999534, 38.615000000048894, 43.65000000002328, 46.050000000046566, 43.98999999999069, 46.27500000002328, 40.58499999996275, 42.0, 44.45499999995809, 133.53999999992084, 42.73499999998603, 38.32000000006519, 65.2949999999255, 34.35000000009313, 151.14999999990687, 41.32000000006519, 39.765000000130385], "unit": "ms", "name": "simple.netmonitor.reload.DAMP", "value": 42.367499999993015}, {"lowerIsBetter": true, "replicates": [86.90500000000247, 54.38000000000466, 54.120000000009895, 54.30500000002212, 57.74499999999534, 55.81500000000233, 60.375, 60.68499999999767, 60.46999999997206, 56.18499999999767, 59.190000000060536, 68.65499999991152, 59.160000000032596, 52.82000000006519, 59.64499999990221, 57.81499999994412, 55.339999999967404, 71.30000000004657, 59.46999999997206, 54.589999999967404, 67.31000000005588, 55.31000000005588, 107.66500000003725, 62.18499999982305, 60.75500000012107], "unit": "ms", "name": "simple.netmonitor.close.DAMP", "value": 59.175000000046566}, {"lowerIsBetter": true, "replicates": [479.1800000000003, 380.2749999999942, 413.3399999999965, 393.0100000000093, 410.0249999999942, 437.27999999996973, 404.5, 430.54000000003725, 395.17499999998836, 419.8299999999581, 421.8850000000093, 440.7700000000186, 413.89000000001397, 435.3850000000093, 399.7249999999767, 421.86999999999534, 394.9100000000326, 451.1700000000419, 403.26500000001397, 414.6350000000093, 415.60999999998603, 434.55000000004657, 439.8850000000093, 425.1149999999907, 407.30999999982305], "unit": "ms", "name": "simple.memory.open.DAMP", "value": 415.1224999999977}, {"lowerIsBetter": true, "replicates": [51.5, 37.83999999999651, 42.595000000001164, 51.279999999998836, 41.929999999993015, 49.76000000000931, 62.52000000001863, 53.910000000032596, 40.25500000000466, 41.42499999998836, 41.07999999995809, 49.43999999994412, 49.56499999994412, 41.52500000002328, 47.93500000005588, 42.89500000001863, 47.58499999996275, 46.07000000006519, 47.19499999994878, 60.19500000006519, 49.40500000002794, 55.19500000006519, 65.11000000010245, 55.40500000002794, 40.56000000005588], "unit": "ms", "name": "simple.memory.reload.DAMP", "value": 47.76000000000931}, {"lowerIsBetter": true, "replicates": [73.09000000000015, 78.47999999999593, 80.60000000000582, 77.57500000001164, 79.14999999999418, 81.625, 75.54000000003725, 77.40999999997439, 81.42499999998836, 76.71000000002095, 81.125, 80.09000000008382, 78.31499999994412, 76.94500000006519, 73.2149999999674, 79.38500000000931, 75.82500000006985, 78.88500000000931, 80.16500000003725, 85.03000000002794, 75.1600000000326, 79.9550000000745, 74.37000000011176, 75.41000000014901, 77.25499999988824], "unit": "ms", "name": "simple.saveHeapSnapshot", "value": 78.39749999997002}, {"lowerIsBetter": true, "replicates": [10.625, 9.855000000010477, 17.35000000000582, 9.690000000002328, 9.785000000003492, 9.26500000001397, 20.095000000030268, 14.479999999981374, 10.835000000020955, 8.89000000001397, 12.480000000097789, 13.024999999906868, 11.305000000051223, 9.415000000037253, 15.28000000002794, 9.425000000046566, 11.589999999967404, 9.395000000018626, 9.869999999995343, 8.755000000004657, 14.940000000060536, 11.659999999916181, 10.955000000074506, 15.645000000018626, 11.96999999997206], "unit": "ms", "name": "simple.readHeapSnapshot", "value": 11.130000000062864}, {"lowerIsBetter": true, "replicates": [4.7150000000001455, 4.650000000008731, 4.919999999998254, 4.820000000006985, 4.940000000002328, 4.705000000016298, 4.695000000006985, 4.544999999983702, 4.820000000006985, 4.945000000006985, 4.78000000002794, 5.0450000000419095, 5.475000000093132, 4.814999999944121, 5.4799999999813735, 4.85999999998603, 4.864999999990687, 4.805000000051223, 4.930000000051223, 4.785000000032596, 4.614999999990687, 4.925000000046566, 4.75, 4.649999999906868, 4.754999999888241], "unit": "ms", "name": "simple.takeCensus", "value": 4.817499999975553}, {"lowerIsBetter": true, "replicates": [33.05499999999665, 23.839999999996508, 40.74000000000524, 50.43000000002212, 38.61499999999069, 28.205000000016298, 39.97999999998137, 44.03499999997439, 43.97000000003027, 45.17000000004191, 43.55499999993481, 46.089999999967404, 37.81999999994878, 26.005000000004657, 36.94500000006519, 43.580000000074506, 40.410000000032596, 49.61999999999534, 27.089999999967404, 44.934999999939464, 28.739999999990687, 43.60499999998137, 42.72999999998137, 40.10499999998137, 40.125], "unit": "ms", "name": "simple.memory.close.DAMP", "value": 40.57500000001892}, {"lowerIsBetter": true, "replicates": [650.7700000000004, 662.179999999993, 645.9549999999872, 661.890000000014, 675.5, 652.835000000021, 685.5299999999697, 667.820000000007, 638.7449999999953, 676.1450000000186, 654.4900000001071, 611.6149999999907, 692.2200000000885, 636.2950000000419, 624.2549999998882, 693.8099999999395, 655.6550000000279, 673.6899999999441, 647.8549999999814, 656.2100000000792, 637.4299999999348, 596.214999999851, 614.535000000149, 662.1000000000931, 663.2099999999627], "unit": "ms", "name": "complicated.webconsole.open.DAMP", "value": 655.9325000000536}, {"lowerIsBetter": true, "replicates": [3142.4350000000013, 2632.274999999994, 2688.720000000001, 2682.8399999999965, 2637.475000000006, 2657.1900000000023, 2684.7900000000373, 2718.210000000021, 2597.1149999999907, 2665.9650000000256, 2700.305000000051, 2646.4599999999627, 2684.590000000084, 2700.1900000000605, 2696.4649999999674, 2628.564999999944, 2688.1650000000373, 2679.7600000000093, 2718.975000000093, 2667.3249999999534, 2698.3549999999814, 2587.25, 2685.9599999999627, 2708.2399999999907, 2709.5800000000745], "unit": "ms", "name": "complicated.webconsole.reload.DAMP", "value": 2684.6900000000605}, {"lowerIsBetter": true, "replicates": [794.2850000000035, 774.9400000000023, 813.2299999999959, 777.7699999999895, 785.3999999999942, 795.070000000007, 824.0899999999674, 807.2200000000303, 788.4550000000163, 811.4650000000256, 794.6549999999115, 1066.7050000000745, 816.3000000000466, 816.234999999986, 812.6300000000047, 799.609999999986, 791.7900000000373, 807.5250000000233, 798.4400000000605, 805.5499999999302, 838.6599999999162, 1131.469999999972, 817.4799999999814, 770.4350000000559, 809.7649999998976], "unit": "ms", "name": "complicated.webconsole.close.DAMP", "value": 807.3725000000268}, {"lowerIsBetter": true, "replicates": [864.9700000000012, 845.4650000000111, 867.9900000000052, 850.9750000000058, 1079.2799999999988, 1060.5149999999558, 852.2750000000233, 849.8950000000186, 781.4400000000023, 843.765000000014, 1003.0599999999395, 805.9350000000559, 874.9350000000559, 885.6600000000326, 878.7250000000931, 855.8100000000559, 1025.75, 1128.1999999999534, 974.1149999999907, 1320.6900000000605, 876.8850000000093, 844.2299999999814, 890.9150000000373, 837.4250000000466, 855.5100000000093], "unit": "ms", "name": "complicated.inspector.open.DAMP", "value": 871.4625000000306}, {"lowerIsBetter": true, "replicates": [2529.494999999999, 2530.6399999999994, 3009.9500000000116, 3315.8499999999767, 2833.6900000000023, 2788.8549999999814, 2523.875, 2514.5650000000023, 2680.9049999999697, 2536.3349999999627, 2875.3950000000186, 2520.460000000079, 2548.4349999999395, 3058.2949999999255, 3045.6450000000186, 2581.2550000000047, 2858.765000000014, 2609.554999999935, 2741.4199999999255, 2605.234999999986, 3088.1200000001118, 2528.375, 2928.5, 2576.189999999944, 2603.2450000001118], "unit": "ms", "name": "complicated.inspector.reload.DAMP", "value": 2645.2299999999523}, {"lowerIsBetter": true, "replicates": [958.6500000000015, 927.9650000000111, 868.6699999999837, 875.6549999999988, 883.3450000000012, 883.2950000000419, 853.570000000007, 885.4550000000163, 847.640000000014, 861.8800000000047, 881.2150000000838, 873.109999999986, 856.3999999999069, 882.3150000000605, 854.609999999986, 913.890000000014, 888.0999999999767, 876.1749999999302, 866.9899999999907, 861.8950000000186, 902.6699999999255, 870.4350000000559, 868.0700000000652, 954.8400000000838, 863.4949999998789], "unit": "ms", "name": "complicated.inspector.close.DAMP", "value": 874.3824999999924}, {"lowerIsBetter": true, "replicates": [754.4799999999996, 798.1899999999878, 906.015000000014, 776.1450000000186, 897.9700000000012, 920.5749999999534, 772.1749999999884, 759.960000000021, 1154.405000000028, 761.2000000000116, 906.125, 756.1999999999534, 759.1999999999534, 910.1049999999814, 892.0449999999255, 817.2900000000373, 905.3350000000792, 941.5350000000326, 903.7550000000047, 898.5999999999767, 931.0300000000279, 774.9050000000279, 867.2399999999907, 784.4250000000466, 760.1300000001211], "unit": "ms", "name": "complicated.jsdebugger.open.DAMP", "value": 879.6424999999581}, {"lowerIsBetter": true, "replicates": [2665.050000000003, 2570.0650000000023, 2757.664999999979, 2634.875, 2778.6749999999884, 2762.0749999999534, 2542.359999999986, 2580.710000000021, 2739.4700000000303, 2563.469999999972, 2807.399999999907, 2803.4150000000373, 2585.6149999999907, 2778.609999999986, 2793.6450000000186, 2625.210000000079, 2795.965000000084, 2692.0, 2733.939999999944, 2782.7500000001164, 2851.2949999999255, 2906.8300000000745, 2742.9599999999627, 2657.554999999935, 2568.304999999935], "unit": "ms", "name": "complicated.jsdebugger.reload.DAMP", "value": 2741.2149999999965}, {"lowerIsBetter": true, "replicates": [1030.479999999996, 1072.7200000000012, 737.1499999999942, 696.820000000007, 1136.7550000000047, 1122.070000000007, 684.1499999999651, 666.7449999999953, 659.5499999999884, 682.5349999999744, 754.0600000000559, 754.6199999999953, 666.0550000000512, 741.9599999999627, 730.0899999999674, 1034.2350000001024, 1147.6049999999814, 1187.5850000000792, 743.0349999999162, 1159.6899999999441, 724.9599999999627, 712.8649999999907, 730.3850000000093, 1041.154999999795, 663.9050000000279], "unit": "ms", "name": "complicated.jsdebugger.close.DAMP", "value": 739.5549999999785}, {"lowerIsBetter": true, "replicates": [2568.4949999999953, 2294.1199999999953, 2950.6900000000023, 2808.5250000000233, 2267.4799999999814, 2335.295000000042, 2814.640000000014, 2338.695000000007, 2689.3949999999604, 2400.640000000014, 2360.8499999999767, 3112.609999999986, 2398.2900000000373, 2992.935000000056, 2973.069999999949, 2339.3950000000186, 2324.9799999999814, 2251.7550000000047, 2373.1500000000233, 2314.1149999999907, 2948.0250000001397, 2834.630000000121, 3164.310000000056, 2334.935000000056, 2495.659999999916], "unit": "ms", "name": "complicated.styleeditor.open.DAMP", "value": 2399.4650000000256}, {"lowerIsBetter": true, "replicates": [2653.0149999999994, 2590.3399999999965, 2763.220000000001, 3113.139999999985, 2578.375, 2543.8150000000023, 2898.3250000000116, 3195.0750000000116, 2659.640000000014, 3200.4649999999674, 2693.9400000000605, 2592.79999999993, 2830.829999999958, 2761.820000000065, 2782.6049999999814, 2563.5050000000047, 2560.1750000000466, 2608.8649999999907, 2719.189999999944, 2668.6999999999534, 2579.7649999998976, 2612.4899999999907, 2534.8600000001024, 2571.8649999999907, 2664.9500000001863], "unit": "ms", "name": "complicated.styleeditor.reload.DAMP", "value": 2662.2950000001}, {"lowerIsBetter": true, "replicates": [1104.0349999999962, 706.6600000000035, 806.0, 889.8800000000047, 715.8649999999907, 703.8699999999953, 750.0499999999884, 771.0599999999977, 1044.274999999965, 679.0499999999884, 760.3200000000652, 729.8199999999488, 1005.125, 794.3649999999907, 797.6149999999907, 692.9949999999953, 694.7550000000047, 696.640000000014, 767.4499999999534, 715.9449999999488, 806.9449999998324, 817.3000000000466, 773.5749999999534, 682.4499999999534, 1148.7700000000186], "unit": "ms", "name": "complicated.styleeditor.close.DAMP", "value": 763.8850000000093}, {"lowerIsBetter": true, "replicates": [705.4000000000015, 714.5900000000111, 683.3250000000116, 673.7949999999837, 624.8699999999953, 657.359999999986, 785.140000000014, 693.5299999999697, 682.2050000000163, 676.9599999999627, 1090.5100000000093, 891.2449999999953, 679.6700000000419, 675.0400000000373, 664.2149999999674, 712.5, 633.9949999999953, 730.875, 781.2100000000792, 635.1600000000326, 750.7299999999814, 811.5449999999255, 925.6400000001304, 669.1499999999069, 687.6899999999441], "unit": "ms", "name": "complicated.performance.open.DAMP", "value": 685.5074999999779}, {"lowerIsBetter": true, "replicates": [2346.479999999996, 2521.3150000000023, 2684.764999999985, 2622.4799999999814, 2574.859999999986, 2585.820000000007, 2512.5149999999558, 2361.5500000000466, 2329.3150000000023, 2328.8950000000186, 2353.6199999999953, 2526.280000000028, 2534.7550000000047, 2720.3000000000466, 2752.8399999999674, 2547.234999999986, 2441.155000000028, 2698.155000000028, 2359.984999999986, 2443.265000000014, 2476.4550000000745, 2521.929999999935, 2402.975000000093, 2574.565000000177, 2326.9200000001583], "unit": "ms", "name": "complicated.performance.reload.DAMP", "value": 2521.6224999999686}, {"lowerIsBetter": true, "replicates": [666.3549999999959, 696.9100000000035, 676.0500000000175, 701.414999999979, 729.6049999999814, 749.210000000021, 1015.2449999999953, 673.6149999999907, 674.5599999999977, 698.6300000000047, 683.2850000000326, 1044.4799999999814, 874.7950000000419, 716.5999999999767, 699.0949999999721, 704.5050000000047, 775.0249999999069, 740.7199999999721, 688.8000000000466, 741.5299999999115, 1011.0699999998324, 1017.7899999998044, 1039.719999999972, 708.9099999999162, 672.1699999999255], "unit": "ms", "name": "complicated.performance.close.DAMP", "value": 712.7549999999464}, {"lowerIsBetter": true, "replicates": [601.3300000000017, 933.0999999999913, 649.7050000000163, 654.0799999999872, 594.8399999999965, 648.0449999999837, 667.4400000000023, 610.9550000000163, 615.2299999999814, 630.3300000000163, 716.3699999999953, 655.8899999998976, 613.6799999999348, 648.2449999999953, 674.3000000000466, 833.3950000000186, 665.5550000000512, 1240.3250000000698, 627.9899999999907, 707.6850000000559, 663.8200000000652, 664.3100000000559, 655.9450000000652, 781.9000000001397, 618.375], "unit": "ms", "name": "complicated.netmonitor.open.DAMP", "value": 655.9174999999814}, {"lowerIsBetter": true, "replicates": [2755.4449999999997, 3095.145000000004, 2747.834999999992, 2784.0, 3261.970000000001, 3321.2999999999884, 2838.2550000000047, 2959.3550000000396, 2814.695000000007, 2965.820000000007, 2893.8699999999953, 2832.79999999993, 3162.780000000028, 2748.8850000000093, 2733.9700000000885, 3369.6549999999115, 2999.1149999999907, 2838.590000000084, 2825.0899999999674, 3001.5200000000186, 2787.935000000056, 2924.0800000000745, 2827.5800000000745, 3257.8950000000186, 2846.119999999879], "unit": "ms", "name": "complicated.netmonitor.reload.DAMP", "value": 2869.994999999937}, {"lowerIsBetter": true, "replicates": [872.0050000000047, 944.2949999999983, 889.0950000000012, 915.4049999999988, 936.4950000000244, 908.5350000000326, 939.4650000000256, 1053.4349999999977, 994.6849999999977, 1022.195000000007, 952.0200000000186, 931.5850000000792, 933.8800000000047, 879.0699999999488, 912.4050000000279, 926.9450000000652, 1344.890000000014, 940.265000000014, 911.9300000000512, 1388.765000000014, 914.1000000000931, 979.4599999999627, 913.4299999999348, 948.7900000000373, 963.5049999998882], "unit": "ms", "name": "complicated.netmonitor.close.DAMP", "value": 937.980000000025}, {"lowerIsBetter": true, "replicates": [954.2649999999994, 795.6100000000006, 668.7799999999988, 685.6450000000186, 778.5599999999977, 689.1599999999744, 655.5249999999651, 682.679999999993, 752.4050000000279, 705.3699999999953, 722.1049999999814, 651.3100000000559, 696.2550000000047, 710.6350000000093, 685.1049999999814, 779.8850000000093, 700.0200000000186, 660.5449999999255, 725.2399999999907, 709.0299999999115, 637.8200000000652, 827.5349999999162, 652.3400000000838, 753.1100000001024, 895.8449999999721], "unit": "ms", "name": "complicated.memory.open.DAMP", "value": 702.695000000007}, {"lowerIsBetter": true, "replicates": [2542.6500000000015, 2623.1600000000035, 2731.664999999979, 2463.390000000014, 2618.095000000001, 2407.8800000000047, 2403.5750000000116, 2890.524999999965, 2403.725000000035, 3016.8800000000047, 2371.0400000000373, 2418.484999999986, 2407.9799999999814, 2464.460000000079, 2475.564999999944, 2642.840000000084, 2400.9700000000885, 2412.1650000000373, 2546.2399999999907, 2429.2750000000233, 2550.4250000000466, 2657.054999999935, 2403.814999999944, 2549.060000000056, 2416.7050000000745], "unit": "ms", "name": "complicated.memory.reload.DAMP", "value": 2463.9250000000466}, {"lowerIsBetter": true, "replicates": [2090.7949999999983, 1705.5600000000122, 1864.7900000000081, 1940.0, 2070.8250000000116, 1488.6350000000093, 1438.1599999999744, 1563.75, 1782.835000000021, 1488.054999999993, 1551.1849999999395, 1502.4949999999953, 1530.780000000028, 1700.5850000000792, 1990.8850000000093, 1720.625, 1504.0399999999208, 1423.3800000000047, 2132.975000000093, 1524.4799999999814, 1567.875, 1607.1599999999162, 1445.619999999879, 2204.5499999998137, 1736.4099999999162], "unit": "ms", "name": "complicated.saveHeapSnapshot", "value": 1587.517499999958}, {"lowerIsBetter": true, "replicates": [332.01000000000204, 353.45500000000175, 319.5799999999872, 304.30000000001746, 305.47000000003027, 238.5, 243.52000000001863, 302.0250000000233, 228.67499999998836, 304.20000000001164, 330.4799999999814, 245.96500000008382, 244.3299999999581, 250.18000000005122, 333.6500000000233, 298.20999999996275, 293.0799999999581, 244.31499999994412, 306.0700000000652, 347.36999999999534, 259.99500000011176, 297.1099999998696, 248.7949999999255, 314.1349999997765, 212.83499999996275], "unit": "ms", "name": "complicated.readHeapSnapshot", "value": 297.6599999999162}, {"lowerIsBetter": true, "replicates": [152.91999999999825, 165.2549999999901, 150.11999999999534, 147.7399999999907, 143.9199999999837, 142.08500000002095, 139.9100000000326, 136.07500000001164, 98.01499999995576, 134.8399999999674, 149.5100000000093, 141.59999999997672, 146.625, 154.8850000000093, 144.09499999997206, 153.68000000005122, 150.9899999999907, 146.06000000005588, 154.19999999995343, 151.28000000002794, 142.6350000000093, 135.38000000012107, 140.65500000002794, 142.73500000010245, 99.61000000010245], "unit": "ms", "name": "complicated.takeCensus", "value": 144.00749999997788}, {"lowerIsBetter": true, "replicates": [287.7850000000035, 673.0049999999901, 358.554999999993, 416.22000000000116, 352.04999999998836, 287.45000000001164, 296.7700000000186, 306.77999999996973, 323.1900000000023, 323.02999999996973, 299.9550000000745, 386.0550000000512, 286.48499999998603, 690.9249999999302, 403.3149999999441, 813.2149999999674, 293.2399999999907, 310.875, 381.0200000000186, 297.7299999999814, 333.5100000000093, 303.8950000000186, 374.35000000009313, 344.09499999997206, 310.1850000000559], "unit": "ms", "name": "complicated.memory.close.DAMP", "value": 328.3500000000058}, {"lowerIsBetter": true, "replicates": [151.5199999999968, 111.2549999999901, 108.49499999999534, 110.42999999999302, 119.72000000003027, 116.59000000002561, 123.54000000003725, 112.48499999998603, 113.57500000001164, 114.48000000003958, 106.57000000006519, 116.15999999991618, 113.29999999993015, 114.71000000007916, 116.14999999990687, 117.07000000006519, 108.65000000002328, 121.5, 108.40500000002794, 106.13500000000931, 113.14000000013039, 119.06499999994412, 107.94999999995343, 109.51000000000931, 125.2750000001397], "unit": "ms", "name": "console.bulklog", "value": 113.4374999999709}, {"lowerIsBetter": true, "replicates": [31.0, 28.0, 28.0, 29.0, 28.0, 34.0, 29.0, 32.0, 28.0, 33.0, 29.0, 34.0, 30.0, 29.0, 29.0, 28.0, 32.0, 32.0, 29.0, 33.0, 34.0, 29.0, 34.0, 29.0, 28.0], "unit": "ms", "name": "console.streamlog", "value": 29.0}], "name": "damp", "value": 282.17144573443386}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [83.01499999999942, 78.46499999999651, 67.96499999999651, 116.77999999999884, 69.38000000000466], "unit": "ms", "name": "amazon.com", "value": 73.92250000000058}, {"lowerIsBetter": true, "replicates": [64.61999999999534, 68.21500000001106, 69.14500000000407, 65.14499999998952, 73.625], "unit": "ms", "name": "cgi.ebay.com", "value": 68.68000000000757}, {"lowerIsBetter": true, "replicates": [68.36500000000524, 77.80999999999767, 64.58000000000175, 65.75, 70.09000000001106], "unit": "ms", "name": "163.com", "value": 67.92000000000553}, {"lowerIsBetter": true, "replicates": [62.220000000001164, 70.55999999999767, 70.86499999999069, 54.904999999998836, 56.97500000000582], "unit": "ms", "name": "mail.ru", "value": 63.767500000001746}, {"lowerIsBetter": true, "replicates": [43.55500000000757, 54.67499999998836, 44.46999999998661, 45.26499999999942, 46.65000000000873], "unit": "ms", "name": "bbc.co.uk", "value": 45.957500000004075}, {"lowerIsBetter": true, "replicates": [79.7450000000099, 82.75, 104.30000000000291, 93.60499999999593, 82.44999999999709], "unit": "ms", "name": "store.apple.com", "value": 88.17749999999796}, {"lowerIsBetter": true, "replicates": [51.204999999987194, 51.429999999993015, 63.7100000000064, 57.095000000001164, 54.42500000000291], "unit": "ms", "name": "imdb.com", "value": 55.76000000000204}, {"lowerIsBetter": true, "replicates": [52.91500000000815, 54.080000000001746, 54.3350000000064, 59.22500000000582, 53.8350000000064], "unit": "ms", "name": "cnn.com", "value": 54.207500000004075}, {"lowerIsBetter": true, "replicates": [75.43999999998778, 70.59500000000116, 71.66999999999825, 76.88500000000931, 63.895000000004075], "unit": "ms", "name": "sohu.com", "value": 71.13249999999971}, {"lowerIsBetter": true, "replicates": [53.58999999999651, 63.63000000000466, 60.09999999999127, 55.870000000009895, 55.22499999999127], "unit": "ms", "name": "youku.com", "value": 57.98500000000058}, {"lowerIsBetter": true, "replicates": [89.375, 85.71499999999651, 85.86999999999534, 79.91999999999825, 88.56499999998778], "unit": "ms", "name": "ifeng.com", "value": 85.79249999999593}, {"lowerIsBetter": true, "replicates": [62.379999999990105, 51.83999999999651, 52.94499999999243, 64.77999999999884, 58.875], "unit": "ms", "name": "tudou.com", "value": 55.90999999999622}, {"lowerIsBetter": true, "replicates": [45.88000000000466, 62.125, 46.38499999999476, 45.545000000012806, 44.23500000000058], "unit": "ms", "name": "chemistry.about.com", "value": 45.96500000000378}, {"lowerIsBetter": true, "replicates": [41.15000000000873, 54.06999999999243, 43.25999999999476, 41.125, 56.5], "unit": "ms", "name": "beatonna.livejournal.com", "value": 48.6649999999936}, {"lowerIsBetter": true, "replicates": [74.75500000000466, 80.89999999999418, 76.76000000000931, 69.9600000000064, 66.57499999999709], "unit": "ms", "name": "rakuten.co.jp", "value": 73.36000000000786}, {"lowerIsBetter": true, "replicates": [61.38999999999942, 52.21499999999651, 60.76000000000931, 50.91000000000349, 70.65000000000873], "unit": "ms", "name": "uol.com.br", "value": 56.48750000000291}, {"lowerIsBetter": true, "replicates": [46.56500000000233, 49.75999999999476, 48.1649999999936, 55.375, 52.354999999995925], "unit": "ms", "name": "thepiratebay.org", "value": 51.05749999999534}, {"lowerIsBetter": true, "replicates": [50.43499999999767, 52.78500000000349, 56.080000000001746, 54.01499999999942, 47.2899999999936], "unit": "ms", "name": "page.renren.com", "value": 53.400000000001455}, {"lowerIsBetter": true, "replicates": [61.86500000000524, 66.02999999999884, 67.0850000000064, 56.745000000009895, 68.14500000000407], "unit": "ms", "name": "chinaz.com", "value": 66.55750000000262}, {"lowerIsBetter": true, "replicates": [57.30500000000757, 62.63499999999476, 57.93000000000757, 56.71499999999651, 52.904999999998836], "unit": "ms", "name": "globo.com", "value": 57.32250000000204}, {"lowerIsBetter": true, "replicates": [41.44999999999709, 51.19999999999709, 41.82499999999709, 39.73500000000058, 41.35000000000582], "unit": "ms", "name": "spiegel.de", "value": 41.587500000001455}, {"lowerIsBetter": true, "replicates": [46.78500000000349, 44.24499999999534, 49.330000000001746, 47.195000000006985, 48.604999999995925], "unit": "ms", "name": "dailymotion.com", "value": 47.900000000001455}, {"lowerIsBetter": true, "replicates": [59.11499999999069, 61.58999999999651, 58.854999999995925, 60.5399999999936, 68.14000000001397], "unit": "ms", "name": "goo.ne.jp", "value": 61.06499999999505}, {"lowerIsBetter": true, "replicates": [52.76499999999942, 52.5, 60.42500000000291, 71.01499999999942, 59.39999999999418], "unit": "ms", "name": "stackoverflow.com", "value": 59.912499999998545}, {"lowerIsBetter": true, "replicates": [72.19500000000698, 47.48500000000058, 49.65000000000873, 43.705000000001746, 45.21499999999651], "unit": "ms", "name": "ezinearticles.com", "value": 46.349999999998545}, {"lowerIsBetter": true, "replicates": [48.17500000000291, 50.67500000000291, 59.329999999987194, 45.14999999999418, 54.820000000006985], "unit": "ms", "name": "huffingtonpost.com", "value": 52.74750000000495}, {"lowerIsBetter": true, "replicates": [53.870000000009895, 63.9149999999936, 49.50999999999476, 46.904999999998836, 47.794999999998254], "unit": "ms", "name": "media.photobucket.com", "value": 48.65249999999651}, {"lowerIsBetter": true, "replicates": [42.82499999999709, 50.054999999993015, 55.48500000000058, 44.51499999999942, 49.74000000000524], "unit": "ms", "name": "imgur.com", "value": 49.89749999999913}, {"lowerIsBetter": true, "replicates": [52.52499999999418, 58.120000000009895, 47.470000000001164, 56.72499999999127, 54.060000000012224], "unit": "ms", "name": "reddit.com", "value": 55.392500000001746}, {"lowerIsBetter": true, "replicates": [54.34999999999127, 61.6649999999936, 58.455000000001746, 50.720000000001164, 52.03500000000349], "unit": "ms", "name": "noimpactman.typepad.com", "value": 55.24500000000262}, {"lowerIsBetter": true, "replicates": [53.154999999998836, 57.479999999995925, 62.429999999993015, 55.38000000000466, 55.13999999999942], "unit": "ms", "name": "myspace.com", "value": 56.43000000000029}, {"lowerIsBetter": true, "replicates": [45.455000000001746, 51.55500000000757, 55.01499999999942, 73.01999999998952, 49.22500000000582], "unit": "ms", "name": "mashable.com", "value": 53.28500000000349}, {"lowerIsBetter": true, "replicates": [68.875, 67.1299999999901, 65.51499999999942, 56.68499999999767, 65.30499999999302], "unit": "ms", "name": "dailymail.co.uk", "value": 65.40999999999622}, {"lowerIsBetter": true, "replicates": [39.49499999999534, 52.604999999995925, 40.65000000000873, 40.604999999995925, 39.66000000000349], "unit": "ms", "name": "whois.domaintools.com", "value": 40.62750000000233}, {"lowerIsBetter": true, "replicates": [50.8350000000064, 56.98500000000058, 61.629999999990105, 57.39999999999418, 56.00500000000466], "unit": "ms", "name": "indiatimes.com", "value": 57.19249999999738}, {"lowerIsBetter": true, "replicates": [51.570000000006985, 47.94499999999243, 51.44999999999709, 54.625, 55.794999999998254], "unit": "ms", "name": "reuters.com", "value": 53.037499999998545}, {"lowerIsBetter": true, "replicates": [78.96499999999651, 86.0399999999936, 89.42999999999302, 81.19499999999243, 106.82500000001164], "unit": "ms", "name": "xinhuanet.com", "value": 87.7349999999933}, {"lowerIsBetter": true, "replicates": [61.845000000001164, 72.35000000000582, 78.22499999999127, 64.99499999999534, 66.47499999999127], "unit": "ms", "name": "56.com", "value": 69.41249999999854}, {"lowerIsBetter": true, "replicates": [40.804999999993015, 40.48000000001048, 52.36999999999534, 39.42500000000291, 50.104999999995925], "unit": "ms", "name": "bild.de", "value": 45.2925000000032}, {"lowerIsBetter": true, "replicates": [58.095000000001164, 55.60000000000582, 49.07499999999709, 55.970000000001164, 49.94999999999709], "unit": "ms", "name": "guardian.co.uk", "value": 52.775000000001455}, {"lowerIsBetter": true, "replicates": [76.78500000000349, 74.375, 82.26499999999942, 84.68999999998778, 71.27499999999418], "unit": "ms", "name": "naver.com", "value": 78.31999999999971}, {"lowerIsBetter": true, "replicates": [65.61000000000058, 57.21499999999651, 59.06999999999243, 56.220000000001164, 55.74000000000524], "unit": "ms", "name": "yelp.com", "value": 56.717499999998836}, {"lowerIsBetter": true, "replicates": [57.419999999998254, 57.2899999999936, 55.28000000001339, 76.61000000000058, 54.845000000001164], "unit": "ms", "name": "wsj.com", "value": 56.28500000000349}, {"lowerIsBetter": true, "replicates": [47.13999999999942, 58.670000000012806, 42.73999999999069, 42.00500000000466, 42.02499999999418], "unit": "ms", "name": "google.com", "value": 42.38249999999243}, {"lowerIsBetter": true, "replicates": [90.09500000000116, 80.01499999999942, 77.50500000000466, 76.55000000000291, 73.96499999999651], "unit": "ms", "name": "xunlei.com", "value": 77.02750000000378}, {"lowerIsBetter": true, "replicates": [58.68499999999767, 65.47000000000116, 60.020000000004075, 42.36500000000524, 49.770000000004075], "unit": "ms", "name": "aljazeera.net", "value": 54.895000000004075}, {"lowerIsBetter": true, "replicates": [54.0, 50.34499999998661, 58.80000000000291, 53.2100000000064, 54.3350000000064], "unit": "ms", "name": "w3.org", "value": 53.7725000000064}, {"lowerIsBetter": true, "replicates": [71.13499999999476, 77.8350000000064, 89.49000000000524, 70.47000000000116, 74.18000000000757], "unit": "ms", "name": "homeway.com.cn", "value": 76.00750000000698}, {"lowerIsBetter": true, "replicates": [53.91500000000815, 49.13999999999942, 43.49000000000524, 48.05999999999767, 47.129999999990105], "unit": "ms", "name": "youtube.com", "value": 47.59499999999389}, {"lowerIsBetter": true, "replicates": [94.67999999999302, 86.61000000000058, 84.07000000000698, 109.32000000000698, 85.57499999999709], "unit": "ms", "name": "people.com.cn", "value": 86.09249999999884}], "name": "tps", "value": 58.244021232443686}]} 20:44:54 INFO - TinderboxPrint: TalosResult: {"graphserver": {"damp": {"url": "http://graphs.mozilla.org/graph.html#tests=[[327,132,35]]", "result": "282.18"}, "tps": {"url": "http://graphs.mozilla.org/graph.html#tests=[[329,132,35]]", "result": "58.24"}}} 20:44:54 INFO - Return code: 0 20:44:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:44:54 INFO - # TBPL SUCCESS # 20:44:54 INFO - Running post-action listener: _resource_record_post_action 20:44:54 INFO - Running post-run listener: _resource_record_post_run 20:44:55 INFO - Total resource usage - Wall time: 1838s; CPU: 14.0%; Read bytes: 12288; Write bytes: 958935040; Read time: 216; Write time: 741868 20:44:55 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 88027136; Read time: 0; Write time: 27776 20:44:55 INFO - run-tests - Wall time: 1822s; CPU: 14.0%; Read bytes: 12288; Write bytes: 870907904; Read time: 216; Write time: 714092 20:44:55 INFO - Running post-run listener: _upload_blobber_files 20:44:55 INFO - Blob upload gear active. 20:44:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:44:55 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 20:44:55 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:44:55 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:44:55 INFO - (blobuploader) - INFO - Open directory for files ... 20:44:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/g2_raw.log ... 20:44:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:44:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:44:57 INFO - (blobuploader) - INFO - TinderboxPrint: g2_raw.log: uploaded 20:44:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:44:57 INFO - (blobuploader) - INFO - Done attempting. 20:44:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/g2_errorsummary.log ... 20:44:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:44:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:44:58 INFO - (blobuploader) - INFO - TinderboxPrint: g2_errorsummary.log: uploaded 20:44:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:44:58 INFO - (blobuploader) - INFO - Done attempting. 20:44:58 INFO - (blobuploader) - INFO - Iteration through files over. 20:44:58 INFO - Return code: 0 20:44:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:44:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:44:58 INFO - Setting buildbot property blobber_files to {"g2_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8fefda5ee646e77620e749c870ef79242f04f936b2a7eaf03e9f51c23bf494b64183811b26440d1145212d82256ddaf9b54562b38732c682a7a2a03671a900f3", "g2_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2cbc5f9ada14d46b64f89b9dbe939daadff32e1769a147ec9745ff9cd0504b466075d62705355d8697b2d23b3229461ec42f6cd216c711d86adb8f03149955fd"} 20:44:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:44:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:44:58 INFO - Contents: 20:44:58 INFO - blobber_files:{"g2_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8fefda5ee646e77620e749c870ef79242f04f936b2a7eaf03e9f51c23bf494b64183811b26440d1145212d82256ddaf9b54562b38732c682a7a2a03671a900f3", "g2_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2cbc5f9ada14d46b64f89b9dbe939daadff32e1769a147ec9745ff9cd0504b466075d62705355d8697b2d23b3229461ec42f6cd216c711d86adb8f03149955fd"} 20:44:58 INFO - Running post-run listener: copy_logs_to_upload_dir 20:44:58 INFO - Copying logs to upload dir... 20:44:58 INFO - mkdir: /builds/slave/test/build/upload/logs 20:44:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1880.352684 ========= master_lag: 0.39 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 31 mins, 20 secs) (at 2016-01-27 20:44:58.760288) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-27 20:44:58.763804) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1453954416.658122-38840208 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"g2_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8fefda5ee646e77620e749c870ef79242f04f936b2a7eaf03e9f51c23bf494b64183811b26440d1145212d82256ddaf9b54562b38732c682a7a2a03671a900f3", "g2_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2cbc5f9ada14d46b64f89b9dbe939daadff32e1769a147ec9745ff9cd0504b466075d62705355d8697b2d23b3229461ec42f6cd216c711d86adb8f03149955fd"} build_url:https://queue.taskcluster.net/v1/task/KQcZlzQYRNijrldyEU-2Yw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011480 build_url: 'https://queue.taskcluster.net/v1/task/KQcZlzQYRNijrldyEU-2Yw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"g2_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8fefda5ee646e77620e749c870ef79242f04f936b2a7eaf03e9f51c23bf494b64183811b26440d1145212d82256ddaf9b54562b38732c682a7a2a03671a900f3", "g2_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2cbc5f9ada14d46b64f89b9dbe939daadff32e1769a147ec9745ff9cd0504b466075d62705355d8697b2d23b3229461ec42f6cd216c711d86adb8f03149955fd"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-27 20:44:58.791516) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 20:44:58.791920) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1453954416.658122-38840208 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004611 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-27 20:44:58.842118) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-27 20:44:58.845474) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-27 20:44:58.845776) ========= ========= Total master_lag: 0.61 =========