builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-020 starttime: 1466692646.62 results: success (0) buildid: 20160623061527 builduid: e3c26f3b32d64c27b2893dcb1ae7ed73 revision: 3c54e4e048dcd7b1a7a54a8fbc4a68962a8fdce4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 07:37:26.616466) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 07:37:26.617541) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 07:37:26.617876) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 07:37:26.633889) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 07:37:26.634396) ========= 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=af724c981e2a0f424dbabf99000001e7-1466692646.264076-367915751 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-23 07:37:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 70.4M=0s 2016-06-23 07:37:27 (70.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.448623 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 07:37:27.098584) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 07:37:27.098970) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', '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=af724c981e2a0f424dbabf99000001e7-1466692646.264076-367915751 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016793 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 07:37:27.150506) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 07:37:27.150917) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3c54e4e048dcd7b1a7a54a8fbc4a68962a8fdce4 --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 3c54e4e048dcd7b1a7a54a8fbc4a68962a8fdce4 --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=af724c981e2a0f424dbabf99000001e7-1466692646.264076-367915751 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-23 07:37:27,895 truncating revision to first 12 chars 2016-06-23 07:37:27,895 Setting DEBUG logging. 2016-06-23 07:37:27,895 attempt 1/10 2016-06-23 07:37:27,896 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3c54e4e048dc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-23 07:37:28,216 unpacking tar archive at: fx-team-3c54e4e048dc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.669785 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 07:37:27.834867) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 07:37:27.835357) ========= script_repo_revision: 3c54e4e048dcd7b1a7a54a8fbc4a68962a8fdce4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 07:37:27.835872) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 07:37:27.836214) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 07:37:27.845828) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-23 07:37:27.846214) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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', 'dromaeojs-e10s', '--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=af724c981e2a0f424dbabf99000001e7-1466692646.264076-367915751 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:37:28 INFO - MultiFileLogger online at 20160623 07:37:28 in /builds/slave/test 07:37:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 07:37:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:37:28 INFO - {'append_to_log': False, 07:37:28 INFO - 'base_work_dir': '/builds/slave/test', 07:37:28 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 07:37:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:37:28 INFO - 'branch': 'Fx-Team-Non-PGO', 07:37:28 INFO - 'buildbot_json_path': 'buildprops.json', 07:37:28 INFO - 'config_files': ('talos/linux_config.py',), 07:37:28 INFO - 'default_actions': ('clobber', 07:37:28 INFO - 'read-buildbot-config', 07:37:28 INFO - 'download-and-extract', 07:37:28 INFO - 'populate-webroot', 07:37:28 INFO - 'create-virtualenv', 07:37:28 INFO - 'install', 07:37:28 INFO - 'run-tests'), 07:37:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:37:28 INFO - 'download_minidump_stackwalk': True, 07:37:28 INFO - 'download_symbols': 'ondemand', 07:37:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:37:28 INFO - 'tooltool.py': '/tools/tooltool.py', 07:37:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:37:28 INFO - '/tools/misc-python/virtualenv.py')}, 07:37:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:37:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:37:28 INFO - 'installer_path': 'installer.exe', 07:37:28 INFO - 'log_level': 'info', 07:37:28 INFO - 'log_name': 'talos', 07:37:28 INFO - 'log_to_console': True, 07:37:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:37:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:37:28 INFO - 'opt_config_files': (), 07:37:28 INFO - 'pip_index': False, 07:37:28 INFO - 'sps_profile': False, 07:37:28 INFO - 'sps_profile_interval': 0, 07:37:28 INFO - 'suite': 'dromaeojs-e10s', 07:37:28 INFO - 'system_bits': '32', 07:37:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:37:28 INFO - 'title': 'talos-linux64-ix-020', 07:37:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:37:28 INFO - 'use_talos_json': True, 07:37:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:37:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:37:28 INFO - 'work_dir': 'build'} 07:37:28 INFO - ##### 07:37:28 INFO - ##### Running clobber step. 07:37:28 INFO - ##### 07:37:28 INFO - Running pre-action listener: _resource_record_pre_action 07:37:28 INFO - Running main action method: clobber 07:37:28 INFO - rmtree: /builds/slave/test/build 07:37:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:37:29 INFO - Running post-action listener: _resource_record_post_action 07:37:29 INFO - ##### 07:37:29 INFO - ##### Finished clobber step (success) 07:37:29 INFO - ##### 07:37:29 INFO - ##### 07:37:29 INFO - ##### Running read-buildbot-config step. 07:37:29 INFO - ##### 07:37:29 INFO - Running pre-action listener: _resource_record_pre_action 07:37:29 INFO - Running main action method: read_buildbot_config 07:37:29 INFO - Using buildbot properties: 07:37:29 INFO - { 07:37:29 INFO - "project": "", 07:37:29 INFO - "product": "firefox", 07:37:29 INFO - "script_repo_revision": "production", 07:37:29 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 07:37:29 INFO - "repository": "", 07:37:29 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 07:37:29 INFO - "buildid": "20160623061527", 07:37:29 INFO - "pgo_build": "False", 07:37:29 INFO - "basedir": "/builds/slave/test", 07:37:29 INFO - "buildnumber": 1606, 07:37:29 INFO - "slavename": "talos-linux64-ix-020", 07:37:29 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:37:29 INFO - "platform": "ubuntu64_hw", 07:37:29 INFO - "scheduler": "tests-fx-team-linux64-talos", 07:37:29 INFO - "branch": "fx-team", 07:37:29 INFO - "repo_path": "integration/fx-team", 07:37:29 INFO - "revision": "3c54e4e048dcd7b1a7a54a8fbc4a68962a8fdce4", 07:37:29 INFO - "stage_platform": "linux64", 07:37:29 INFO - "builduid": "e3c26f3b32d64c27b2893dcb1ae7ed73", 07:37:29 INFO - "slavebuilddir": "test" 07:37:29 INFO - } 07:37:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/XWDgoZ6mRki9zqJ56B5nvA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 07:37:29 INFO - Running post-action listener: _resource_record_post_action 07:37:29 INFO - ##### 07:37:29 INFO - ##### Finished read-buildbot-config step (success) 07:37:29 INFO - ##### 07:37:29 INFO - ##### 07:37:29 INFO - ##### Running download-and-extract step. 07:37:29 INFO - ##### 07:37:29 INFO - Running pre-action listener: _resource_record_pre_action 07:37:29 INFO - Running main action method: download_and_extract 07:37:29 INFO - mkdir: /builds/slave/test/build/tests 07:37:29 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')]} 07:37:29 INFO - https://queue.taskcluster.net/v1/task/XWDgoZ6mRki9zqJ56B5nvA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:37:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XWDgoZ6mRki9zqJ56B5nvA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:37:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XWDgoZ6mRki9zqJ56B5nvA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:37:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XWDgoZ6mRki9zqJ56B5nvA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:37:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XWDgoZ6mRki9zqJ56B5nvA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:37:30 INFO - Downloaded 1361 bytes. 07:37:30 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:37:30 INFO - Using the following test package requirements: 07:37:30 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:37:30 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:37:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:37:30 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:37:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:37:30 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:37:30 INFO - u'jsshell-linux-x86_64.zip'], 07:37:30 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:37:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:37:30 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:37:30 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:37:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:37:30 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:37:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:37:30 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:37:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:37:30 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:37:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:37:30 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:37:30 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')]} 07:37:30 INFO - https://queue.taskcluster.net/v1/task/XWDgoZ6mRki9zqJ56B5nvA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:37:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XWDgoZ6mRki9zqJ56B5nvA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:37:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XWDgoZ6mRki9zqJ56B5nvA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:37:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XWDgoZ6mRki9zqJ56B5nvA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:37:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XWDgoZ6mRki9zqJ56B5nvA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:37:31 INFO - Downloaded 22709646 bytes. 07:37:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:37:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:37:32 INFO - Return code: 0 07:37:32 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:37: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')]} 07:37:32 INFO - https://queue.taskcluster.net/v1/task/XWDgoZ6mRki9zqJ56B5nvA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:37:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XWDgoZ6mRki9zqJ56B5nvA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:37:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XWDgoZ6mRki9zqJ56B5nvA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:37:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XWDgoZ6mRki9zqJ56B5nvA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:37:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XWDgoZ6mRki9zqJ56B5nvA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:37:33 INFO - Downloaded 22709646 bytes. 07:37:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:37:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:37:35 INFO - Return code: 0 07:37:35 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')]} 07:37:35 INFO - https://queue.taskcluster.net/v1/task/XWDgoZ6mRki9zqJ56B5nvA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:37:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XWDgoZ6mRki9zqJ56B5nvA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:37:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XWDgoZ6mRki9zqJ56B5nvA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:37:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XWDgoZ6mRki9zqJ56B5nvA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:37:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XWDgoZ6mRki9zqJ56B5nvA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:37:36 INFO - Downloaded 14405384 bytes. 07:37:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:37:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 07:37:36 INFO - Return code: 0 07:37:36 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')]} 07:37:36 INFO - https://queue.taskcluster.net/v1/task/XWDgoZ6mRki9zqJ56B5nvA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:37:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XWDgoZ6mRki9zqJ56B5nvA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:37:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XWDgoZ6mRki9zqJ56B5nvA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:37:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XWDgoZ6mRki9zqJ56B5nvA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:37:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XWDgoZ6mRki9zqJ56B5nvA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:37:37 INFO - Downloaded 56253978 bytes. 07:37:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XWDgoZ6mRki9zqJ56B5nvA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:37:37 INFO - mkdir: /builds/slave/test/properties 07:37:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:37:37 INFO - Writing to file /builds/slave/test/properties/build_url 07:37:37 INFO - Contents: 07:37:37 INFO - build_url:https://queue.taskcluster.net/v1/task/XWDgoZ6mRki9zqJ56B5nvA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:37:38 INFO - Running post-action listener: _resource_record_post_action 07:37:38 INFO - Running post-action listener: set_extra_try_arguments 07:37:38 INFO - ##### 07:37:38 INFO - ##### Finished download-and-extract step (success) 07:37:38 INFO - ##### 07:37:38 INFO - ##### 07:37:38 INFO - ##### Running populate-webroot step. 07:37:38 INFO - ##### 07:37:38 INFO - Running pre-action listener: _resource_record_pre_action 07:37:38 INFO - Running main action method: populate_webroot 07:37:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:37:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:37:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:37:38 INFO - '--tppagecycles', 07:37:38 INFO - '7'], 07:37:38 INFO - 'tests': ['tsvgm']}}, 07:37:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:37:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:37:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:37:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:37:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:37:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:37:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:38 INFO - 'talos_options': ['--disable-e10s'], 07:37:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:37:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:37:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:38 INFO - 'talos_options': ['--disable-e10s'], 07:37:38 INFO - 'tests': ['damp', 'tps']}, 07:37:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:38 INFO - 'tests': ['damp', 'tps']}, 07:37:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:37:38 INFO - 'tests': ['dromaeo_dom']}, 07:37:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:37:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:37:38 INFO - 'tests': ['basic_compositor_video']}, 07:37:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:37:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:37:38 INFO - 'tests': ['a11yr', 07:37:38 INFO - 'ts_paint', 07:37:38 INFO - 'tpaint', 07:37:38 INFO - 'sessionrestore', 07:37:38 INFO - 'sessionrestore_no_auto_restore', 07:37:38 INFO - 'tabpaint']}, 07:37:38 INFO - 'other-e10s': {'tests': ['a11yr', 07:37:38 INFO - 'ts_paint', 07:37:38 INFO - 'tpaint', 07:37:38 INFO - 'sessionrestore', 07:37:38 INFO - 'sessionrestore_no_auto_restore', 07:37:38 INFO - 'tabpaint']}, 07:37:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:37:38 INFO - 'ts_paint', 07:37:38 INFO - 'tpaint', 07:37:38 INFO - 'sessionrestore', 07:37:38 INFO - 'sessionrestore_no_auto_restore', 07:37:38 INFO - 'tabpaint']}, 07:37:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:37:38 INFO - 'ts_paint', 07:37:38 INFO - 'tpaint', 07:37:38 INFO - 'sessionrestore', 07:37:38 INFO - 'sessionrestore_no_auto_restore', 07:37:38 INFO - 'tabpaint']}, 07:37:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:37:38 INFO - 'tests': ['a11yr', 07:37:38 INFO - 'ts_paint', 07:37:38 INFO - 'tpaint', 07:37:38 INFO - 'sessionrestore', 07:37:38 INFO - 'sessionrestore_no_auto_restore', 07:37:38 INFO - 'tabpaint']}, 07:37:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:37:38 INFO - 'tests': ['a11yr', 07:37:38 INFO - 'ts_paint', 07:37:38 INFO - 'tpaint', 07:37:38 INFO - 'sessionrestore', 07:37:38 INFO - 'sessionrestore_no_auto_restore', 07:37:38 INFO - 'tabpaint']}, 07:37:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:37:38 INFO - 'tests': ['tsvgx', 07:37:38 INFO - 'tsvgr_opacity', 07:37:38 INFO - 'tart', 07:37:38 INFO - 'tscrollx', 07:37:38 INFO - 'cart']}, 07:37:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:37:38 INFO - 'tsvgr_opacity', 07:37:38 INFO - 'tart', 07:37:38 INFO - 'tscrollx', 07:37:38 INFO - 'cart']}, 07:37:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:38 INFO - 'talos_options': ['--disable-e10s'], 07:37:38 INFO - 'tests': ['tp5o']}, 07:37:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:38 INFO - 'tests': ['tp5o']}, 07:37:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:38 INFO - 'talos_options': ['--disable-e10s', 07:37:38 INFO - '--xperf_path', 07:37:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:37:38 INFO - 'tests': ['tp5n']}, 07:37:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:37:38 INFO - 'talos_options': ['--xperf_path', 07:37:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:37:38 INFO - 'tests': ['tp5n']}}, 07:37:38 INFO - 'talos.zip': {'path': '', 07:37:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:37:38 INFO - Running post-action listener: _resource_record_post_action 07:37:38 INFO - ##### 07:37:38 INFO - ##### Finished populate-webroot step (success) 07:37:38 INFO - ##### 07:37:38 INFO - ##### 07:37:38 INFO - ##### Running create-virtualenv step. 07:37:38 INFO - ##### 07:37:38 INFO - Running pre-action listener: _resource_record_pre_action 07:37:38 INFO - Running main action method: create_virtualenv 07:37:38 INFO - Creating virtualenv /builds/slave/test/build/venv 07:37:38 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 07:37:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:37:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:37:38 INFO - Using real prefix '/usr' 07:37:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:37:39 INFO - Installing distribute.............................................................................................................................................................................................done. 07:37:41 INFO - Installing pip.................done. 07:37:41 INFO - Return code: 0 07:37:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:37: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')]} 07:37:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37: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')]} 07:37:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:41 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 0x7f9b535f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2758350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e71c0>, '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 0x27e80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e8550>, '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': 'af724c981e2a0f424dbabf99000001e7-1466692646.264076-367915751', '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 07:37:41 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 07:37:41 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 07:37:41 INFO - Using env: {'DISPLAY': ':0', 07:37:41 INFO - 'HOME': '/home/cltbld', 07:37:41 INFO - 'LANG': 'en_US.UTF-8', 07:37:41 INFO - 'LANGUAGE': 'en_US:en', 07:37:41 INFO - 'LOGNAME': 'cltbld', 07:37:41 INFO - 'MAIL': '/var/mail/cltbld', 07:37:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:41 INFO - 'MOZ_NO_REMOTE': '1', 07:37:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:41 INFO - 'NO_EM_RESTART': '1', 07:37:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:41 INFO - 'PWD': '/builds/slave/test', 07:37:41 INFO - 'SHELL': '/bin/bash', 07:37:41 INFO - 'SHLVL': '1', 07:37:41 INFO - 'TERM': 'linux', 07:37:41 INFO - 'TMOUT': '86400', 07:37:41 INFO - 'USER': 'cltbld', 07:37:41 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1466692646.264076-367915751', 07:37:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:41 INFO - '_': '/tools/buildbot/bin/python'} 07:37:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:41 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 07:37:41 INFO - Cleaning up... 07:37:41 INFO - Return code: 0 07:37:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:37: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')]} 07:37:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37: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')]} 07:37:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:41 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b535f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2758350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e71c0>, '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 0x27e80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e8550>, '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': 'af724c981e2a0f424dbabf99000001e7-1466692646.264076-367915751', '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 07:37:41 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>=3.1.1'] in /builds/slave/test/build 07:37:41 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>=3.1.1 07:37:41 INFO - Using env: {'DISPLAY': ':0', 07:37:41 INFO - 'HOME': '/home/cltbld', 07:37:41 INFO - 'LANG': 'en_US.UTF-8', 07:37:41 INFO - 'LANGUAGE': 'en_US:en', 07:37:41 INFO - 'LOGNAME': 'cltbld', 07:37:41 INFO - 'MAIL': '/var/mail/cltbld', 07:37:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:41 INFO - 'MOZ_NO_REMOTE': '1', 07:37:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:41 INFO - 'NO_EM_RESTART': '1', 07:37:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:41 INFO - 'PWD': '/builds/slave/test', 07:37:41 INFO - 'SHELL': '/bin/bash', 07:37:41 INFO - 'SHLVL': '1', 07:37:41 INFO - 'TERM': 'linux', 07:37:41 INFO - 'TMOUT': '86400', 07:37:41 INFO - 'USER': 'cltbld', 07:37:41 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1466692646.264076-367915751', 07:37:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:41 INFO - '_': '/tools/buildbot/bin/python'} 07:37:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:41 INFO - Downloading/unpacking psutil>=3.1.1 07:37:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:37:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:37:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:37:43 INFO - Installing collected packages: psutil 07:37:43 INFO - Running setup.py install for psutil 07:37:43 INFO - building 'psutil._psutil_linux' extension 07:37:43 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 07:37:43 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 07:37:44 INFO - building 'psutil._psutil_posix' extension 07:37:44 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 07:37:44 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 07:37:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:37:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:37:44 INFO - Successfully installed psutil 07:37:44 INFO - Cleaning up... 07:37:44 INFO - Return code: 0 07:37:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:37: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')]} 07:37:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37: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')]} 07:37:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b535f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2758350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e71c0>, '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 0x27e80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e8550>, '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': 'af724c981e2a0f424dbabf99000001e7-1466692646.264076-367915751', '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 07:37:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:37:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:37:44 INFO - Using env: {'DISPLAY': ':0', 07:37:44 INFO - 'HOME': '/home/cltbld', 07:37:44 INFO - 'LANG': 'en_US.UTF-8', 07:37:44 INFO - 'LANGUAGE': 'en_US:en', 07:37:44 INFO - 'LOGNAME': 'cltbld', 07:37:44 INFO - 'MAIL': '/var/mail/cltbld', 07:37:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:44 INFO - 'MOZ_NO_REMOTE': '1', 07:37:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:44 INFO - 'NO_EM_RESTART': '1', 07:37:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:44 INFO - 'PWD': '/builds/slave/test', 07:37:44 INFO - 'SHELL': '/bin/bash', 07:37:44 INFO - 'SHLVL': '1', 07:37:44 INFO - 'TERM': 'linux', 07:37:44 INFO - 'TMOUT': '86400', 07:37:44 INFO - 'USER': 'cltbld', 07:37:44 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1466692646.264076-367915751', 07:37:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:44 INFO - '_': '/tools/buildbot/bin/python'} 07:37:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:37:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:37:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:37:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:37:46 INFO - Installing collected packages: mozsystemmonitor 07:37:46 INFO - Running setup.py install for mozsystemmonitor 07:37:46 INFO - Successfully installed mozsystemmonitor 07:37:46 INFO - Cleaning up... 07:37:46 INFO - Return code: 0 07:37:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:37: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')]} 07:37:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37: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')]} 07:37:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:46 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b535f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2758350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e71c0>, '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 0x27e80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e8550>, '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': 'af724c981e2a0f424dbabf99000001e7-1466692646.264076-367915751', '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 07:37:46 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==2.5.1'] in /builds/slave/test/build 07:37:46 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==2.5.1 07:37:46 INFO - Using env: {'DISPLAY': ':0', 07:37:46 INFO - 'HOME': '/home/cltbld', 07:37:46 INFO - 'LANG': 'en_US.UTF-8', 07:37:46 INFO - 'LANGUAGE': 'en_US:en', 07:37:46 INFO - 'LOGNAME': 'cltbld', 07:37:46 INFO - 'MAIL': '/var/mail/cltbld', 07:37:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:46 INFO - 'MOZ_NO_REMOTE': '1', 07:37:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:46 INFO - 'NO_EM_RESTART': '1', 07:37:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:46 INFO - 'PWD': '/builds/slave/test', 07:37:46 INFO - 'SHELL': '/bin/bash', 07:37:46 INFO - 'SHLVL': '1', 07:37:46 INFO - 'TERM': 'linux', 07:37:46 INFO - 'TMOUT': '86400', 07:37:46 INFO - 'USER': 'cltbld', 07:37:46 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1466692646.264076-367915751', 07:37:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:46 INFO - '_': '/tools/buildbot/bin/python'} 07:37:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:46 INFO - Downloading/unpacking jsonschema==2.5.1 07:37:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:37:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:37:48 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 07:37:48 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 07:37:48 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 07:37:48 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 07:37:48 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 07:37:48 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 07:37:48 INFO - Downloading functools32-3.2.3-2.tar.gz 07:37:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:37:48 INFO - warning: no files found matching '*.txt' 07:37:48 INFO - no previously-included directories found matching 'build' 07:37:48 INFO - no previously-included directories found matching 'dist' 07:37:48 INFO - no previously-included directories found matching '.git*' 07:37:48 INFO - Installing collected packages: jsonschema, functools32 07:37:49 INFO - Running setup.py install for functools32 07:37:49 INFO - warning: no files found matching '*.txt' 07:37:49 INFO - no previously-included directories found matching 'build' 07:37:49 INFO - no previously-included directories found matching 'dist' 07:37:49 INFO - no previously-included directories found matching '.git*' 07:37:49 INFO - Successfully installed jsonschema functools32 07:37:49 INFO - Cleaning up... 07:37:49 INFO - Return code: 0 07:37:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:37:49 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')]} 07:37:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:49 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')]} 07:37:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:49 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 0x7f9b535f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2758350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e71c0>, '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 0x27e80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e8550>, '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': 'af724c981e2a0f424dbabf99000001e7-1466692646.264076-367915751', '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 07:37:49 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 07:37:49 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 07:37:49 INFO - Using env: {'DISPLAY': ':0', 07:37:49 INFO - 'HOME': '/home/cltbld', 07:37:49 INFO - 'LANG': 'en_US.UTF-8', 07:37:49 INFO - 'LANGUAGE': 'en_US:en', 07:37:49 INFO - 'LOGNAME': 'cltbld', 07:37:49 INFO - 'MAIL': '/var/mail/cltbld', 07:37:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:49 INFO - 'MOZ_NO_REMOTE': '1', 07:37:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:49 INFO - 'NO_EM_RESTART': '1', 07:37:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:49 INFO - 'PWD': '/builds/slave/test', 07:37:49 INFO - 'SHELL': '/bin/bash', 07:37:49 INFO - 'SHLVL': '1', 07:37:49 INFO - 'TERM': 'linux', 07:37:49 INFO - 'TMOUT': '86400', 07:37:49 INFO - 'USER': 'cltbld', 07:37:49 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1466692646.264076-367915751', 07:37:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:49 INFO - '_': '/tools/buildbot/bin/python'} 07:37:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:49 INFO - Downloading/unpacking blobuploader==1.2.4 07:37:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:51 INFO - Downloading blobuploader-1.2.4.tar.gz 07:37:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:37:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:37:51 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 07:37:51 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 07:37:51 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 07:37:51 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 07:37:51 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 07:37:51 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 07:37:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:37:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:37:51 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 07:37:51 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 07:37:51 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 07:37:51 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 07:37:51 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 07:37:51 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 07:37:51 INFO - Downloading docopt-0.6.1.tar.gz 07:37:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:37:52 INFO - Installing collected packages: blobuploader, requests, docopt 07:37:52 INFO - Running setup.py install for blobuploader 07:37:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:37:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:37:52 INFO - Running setup.py install for requests 07:37:52 INFO - Running setup.py install for docopt 07:37:52 INFO - Successfully installed blobuploader requests docopt 07:37:52 INFO - Cleaning up... 07:37:52 INFO - Return code: 0 07:37:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:37:52 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')]} 07:37:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:52 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')]} 07:37:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:52 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 0x7f9b535f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2758350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e71c0>, '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 0x27e80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e8550>, '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': 'af724c981e2a0f424dbabf99000001e7-1466692646.264076-367915751', '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 07:37:52 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 07:37:52 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 07:37:52 INFO - Using env: {'DISPLAY': ':0', 07:37:52 INFO - 'HOME': '/home/cltbld', 07:37:52 INFO - 'LANG': 'en_US.UTF-8', 07:37:52 INFO - 'LANGUAGE': 'en_US:en', 07:37:52 INFO - 'LOGNAME': 'cltbld', 07:37:52 INFO - 'MAIL': '/var/mail/cltbld', 07:37:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:52 INFO - 'MOZ_NO_REMOTE': '1', 07:37:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:52 INFO - 'NO_EM_RESTART': '1', 07:37:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:52 INFO - 'PWD': '/builds/slave/test', 07:37:52 INFO - 'SHELL': '/bin/bash', 07:37:52 INFO - 'SHLVL': '1', 07:37:52 INFO - 'TERM': 'linux', 07:37:52 INFO - 'TMOUT': '86400', 07:37:52 INFO - 'USER': 'cltbld', 07:37:52 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1466692646.264076-367915751', 07:37:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:52 INFO - '_': '/tools/buildbot/bin/python'} 07:37:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:37:52 INFO - Running setup.py (path:/tmp/pip-QWG8qT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:37:52 INFO - Running setup.py (path:/tmp/pip-A7z0v6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:37:53 INFO - Running setup.py (path:/tmp/pip-wEh1xV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:37:53 INFO - Running setup.py (path:/tmp/pip-foISL4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:37:53 INFO - Running setup.py (path:/tmp/pip-4WQw8w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:37:53 INFO - Running setup.py (path:/tmp/pip-N8_ICh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:37:53 INFO - Running setup.py (path:/tmp/pip-ZnbpV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:37:53 INFO - Running setup.py (path:/tmp/pip-CAk7nO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:37:53 INFO - Running setup.py (path:/tmp/pip-CiWPkE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:37:53 INFO - Running setup.py (path:/tmp/pip-7bHtzy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:37:53 INFO - Running setup.py (path:/tmp/pip-Ia45Vv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:37:53 INFO - Running setup.py (path:/tmp/pip-rhIkiO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:37:53 INFO - Running setup.py (path:/tmp/pip-GQ3mMI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:37:53 INFO - Running setup.py (path:/tmp/pip-Z35O7L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:37:53 INFO - Running setup.py (path:/tmp/pip-EClt8v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:37:53 INFO - Running setup.py (path:/tmp/pip-A3F9zS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:37:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:37:54 INFO - Running setup.py (path:/tmp/pip-yUzBim-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:37:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:37:54 INFO - Running setup.py install for manifestparser 07:37:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:37:54 INFO - Running setup.py install for mozcrash 07:37:54 INFO - Running setup.py install for mozdebug 07:37:54 INFO - Running setup.py install for mozdevice 07:37:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:37:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:37:54 INFO - Running setup.py install for mozfile 07:37:54 INFO - Running setup.py install for mozhttpd 07:37:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:37:54 INFO - Running setup.py install for mozinfo 07:37:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:37:54 INFO - Running setup.py install for mozInstall 07:37:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:37:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:37:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:37:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:37:54 INFO - Running setup.py install for mozleak 07:37:54 INFO - Running setup.py install for mozlog 07:37:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:37:55 INFO - Running setup.py install for moznetwork 07:37:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:37:55 INFO - Running setup.py install for mozprocess 07:37:55 INFO - Running setup.py install for mozprofile 07:37:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:37:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:37:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:37:55 INFO - Running setup.py install for mozrunner 07:37:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:37:55 INFO - Running setup.py install for mozscreenshot 07:37:55 INFO - Running setup.py install for moztest 07:37:55 INFO - Running setup.py install for mozversion 07:37:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:37:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:37:55 INFO - Cleaning up... 07:37:55 INFO - Return code: 0 07:37:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:37: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')]} 07:37:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37: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')]} 07:37:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:55 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 0x7f9b535f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2758350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e71c0>, '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 0x27e80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e8550>, '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': 'af724c981e2a0f424dbabf99000001e7-1466692646.264076-367915751', '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 07:37:55 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 07:37:55 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 07:37:55 INFO - Using env: {'DISPLAY': ':0', 07:37:55 INFO - 'HOME': '/home/cltbld', 07:37:55 INFO - 'LANG': 'en_US.UTF-8', 07:37:55 INFO - 'LANGUAGE': 'en_US:en', 07:37:55 INFO - 'LOGNAME': 'cltbld', 07:37:55 INFO - 'MAIL': '/var/mail/cltbld', 07:37:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:55 INFO - 'MOZ_NO_REMOTE': '1', 07:37:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:55 INFO - 'NO_EM_RESTART': '1', 07:37:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:55 INFO - 'PWD': '/builds/slave/test', 07:37:55 INFO - 'SHELL': '/bin/bash', 07:37:55 INFO - 'SHLVL': '1', 07:37:55 INFO - 'TERM': 'linux', 07:37:55 INFO - 'TMOUT': '86400', 07:37:55 INFO - 'USER': 'cltbld', 07:37:55 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1466692646.264076-367915751', 07:37:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:55 INFO - '_': '/tools/buildbot/bin/python'} 07:37:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:37:56 INFO - Running setup.py (path:/tmp/pip-Y41i34-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:37:56 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)) 07:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:37:56 INFO - Running setup.py (path:/tmp/pip-ztiHX_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:37:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:37:56 INFO - Running setup.py (path:/tmp/pip-W5GdKF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:37:56 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)) 07:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:37:56 INFO - Running setup.py (path:/tmp/pip-N5cR5H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:37:56 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)) 07:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:37:56 INFO - Running setup.py (path:/tmp/pip-mnEFra-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:37:56 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)) 07:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:37:56 INFO - Running setup.py (path:/tmp/pip-zYl_2e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:37:56 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)) 07:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:37:56 INFO - Running setup.py (path:/tmp/pip-NFecLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:37:56 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)) 07:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:37:56 INFO - Running setup.py (path:/tmp/pip-8qpKxJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:37:56 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)) 07:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:37:56 INFO - Running setup.py (path:/tmp/pip-nRBEyi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:37:56 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)) 07:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:37:56 INFO - Running setup.py (path:/tmp/pip-LWkLZm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:37:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 07:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:37:56 INFO - Running setup.py (path:/tmp/pip-SdOoQj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:37:56 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)) 07:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:37:56 INFO - Running setup.py (path:/tmp/pip-wvU8WS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:37:56 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)) 07:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:37:56 INFO - Running setup.py (path:/tmp/pip-F5rjRw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:37:57 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)) 07:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:37:57 INFO - Running setup.py (path:/tmp/pip-2TxWLk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:37:57 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)) 07:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:37:57 INFO - Running setup.py (path:/tmp/pip-hy3g8y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:37:57 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)) 07:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:37:57 INFO - Running setup.py (path:/tmp/pip-gjnw_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:37:57 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)) 07:37:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:37:57 INFO - Running setup.py (path:/tmp/pip-hrQayK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:37:57 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)) 07:37:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:37:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:37:57 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)) 07:37:57 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)) 07:37:57 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)) 07:37:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:37:57 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 07:37:57 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 07:37:57 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 07:37:57 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 07:37:57 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 07:37:57 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 07:37:59 INFO - Downloading blessings-1.6.tar.gz 07:37:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:37:59 INFO - Installing collected packages: blessings 07:37:59 INFO - Running setup.py install for blessings 07:37:59 INFO - Successfully installed blessings 07:37:59 INFO - Cleaning up... 07:37:59 INFO - Return code: 0 07:37:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:37:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:37:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:37:59 INFO - Reading from file tmpfile_stdout 07:37:59 INFO - Current package versions: 07:37:59 INFO - argparse == 1.2.1 07:37:59 INFO - blessings == 1.6 07:37:59 INFO - blobuploader == 1.2.4 07:37:59 INFO - docopt == 0.6.1 07:37:59 INFO - functools32 == 3.2.3-2 07:37:59 INFO - jsonschema == 2.5.1 07:37:59 INFO - manifestparser == 1.1 07:37:59 INFO - mozInstall == 1.12 07:37:59 INFO - mozcrash == 0.17 07:37:59 INFO - mozdebug == 0.1 07:37:59 INFO - mozdevice == 0.48 07:37:59 INFO - mozfile == 1.2 07:37:59 INFO - mozhttpd == 0.7 07:37:59 INFO - mozinfo == 0.9 07:37:59 INFO - mozleak == 0.1 07:37:59 INFO - mozlog == 3.2 07:37:59 INFO - moznetwork == 0.27 07:37:59 INFO - mozprocess == 0.22 07:37:59 INFO - mozprofile == 0.28 07:37:59 INFO - mozrunner == 6.11 07:37:59 INFO - mozscreenshot == 0.1 07:37:59 INFO - mozsystemmonitor == 0.3 07:37:59 INFO - moztest == 0.7 07:37:59 INFO - mozversion == 1.4 07:37:59 INFO - psutil == 3.1.1 07:37:59 INFO - requests == 1.2.3 07:37:59 INFO - wsgiref == 0.1.2 07:37:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:37:59 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')]} 07:37:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:59 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')]} 07:37:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:59 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 0x7f9b535f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2758350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e71c0>, '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 0x27e80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e8550>, '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': 'af724c981e2a0f424dbabf99000001e7-1466692646.264076-367915751', '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 07:37:59 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 07:37:59 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 07:37:59 INFO - Using env: {'DISPLAY': ':0', 07:37:59 INFO - 'HOME': '/home/cltbld', 07:37:59 INFO - 'LANG': 'en_US.UTF-8', 07:37:59 INFO - 'LANGUAGE': 'en_US:en', 07:37:59 INFO - 'LOGNAME': 'cltbld', 07:37:59 INFO - 'MAIL': '/var/mail/cltbld', 07:37:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:59 INFO - 'MOZ_NO_REMOTE': '1', 07:37:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:59 INFO - 'NO_EM_RESTART': '1', 07:37:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:59 INFO - 'PWD': '/builds/slave/test', 07:37:59 INFO - 'SHELL': '/bin/bash', 07:37:59 INFO - 'SHLVL': '1', 07:37:59 INFO - 'TERM': 'linux', 07:37:59 INFO - 'TMOUT': '86400', 07:37:59 INFO - 'USER': 'cltbld', 07:37:59 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1466692646.264076-367915751', 07:37:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:59 INFO - '_': '/tools/buildbot/bin/python'} 07:37:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:59 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)) 07:37:59 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)) 07:37:59 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)) 07:37:59 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)) 07:37:59 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)) 07:37:59 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)) 07:37:59 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)) 07:37:59 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)) 07:37:59 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)) 07:37:59 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)) 07:37:59 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)) 07:37:59 INFO - Cleaning up... 07:37:59 INFO - Return code: 0 07:37:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:37:59 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')]} 07:37:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:59 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')]} 07:37:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:59 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 0x7f9b535f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2758350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e71c0>, '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 0x27e80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e8550>, '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': 'af724c981e2a0f424dbabf99000001e7-1466692646.264076-367915751', '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 07:37:59 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 07:37:59 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 07:37:59 INFO - Using env: {'DISPLAY': ':0', 07:37:59 INFO - 'HOME': '/home/cltbld', 07:37:59 INFO - 'LANG': 'en_US.UTF-8', 07:37:59 INFO - 'LANGUAGE': 'en_US:en', 07:37:59 INFO - 'LOGNAME': 'cltbld', 07:37:59 INFO - 'MAIL': '/var/mail/cltbld', 07:37:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:59 INFO - 'MOZ_NO_REMOTE': '1', 07:37:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:59 INFO - 'NO_EM_RESTART': '1', 07:37:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:59 INFO - 'PWD': '/builds/slave/test', 07:37:59 INFO - 'SHELL': '/bin/bash', 07:37:59 INFO - 'SHLVL': '1', 07:37:59 INFO - 'TERM': 'linux', 07:37:59 INFO - 'TMOUT': '86400', 07:37:59 INFO - 'USER': 'cltbld', 07:37:59 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1466692646.264076-367915751', 07:37:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:59 INFO - '_': '/tools/buildbot/bin/python'} 07:38:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:38:00 INFO - Cleaning up... 07:38:00 INFO - Return code: 0 07:38:00 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:38: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')]} 07:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38: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')]} 07:38:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b535f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x268d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2758350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e71c0>, '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 0x27e80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e8550>, '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': 'af724c981e2a0f424dbabf99000001e7-1466692646.264076-367915751', '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 07:38: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', 'flake8'] in /builds/slave/test/build 07:38: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 flake8 07:38:00 INFO - Using env: {'DISPLAY': ':0', 07:38:00 INFO - 'HOME': '/home/cltbld', 07:38:00 INFO - 'LANG': 'en_US.UTF-8', 07:38:00 INFO - 'LANGUAGE': 'en_US:en', 07:38:00 INFO - 'LOGNAME': 'cltbld', 07:38:00 INFO - 'MAIL': '/var/mail/cltbld', 07:38:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:00 INFO - 'MOZ_NO_REMOTE': '1', 07:38:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:00 INFO - 'NO_EM_RESTART': '1', 07:38:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:00 INFO - 'PWD': '/builds/slave/test', 07:38:00 INFO - 'SHELL': '/bin/bash', 07:38:00 INFO - 'SHLVL': '1', 07:38:00 INFO - 'TERM': 'linux', 07:38:00 INFO - 'TMOUT': '86400', 07:38:00 INFO - 'USER': 'cltbld', 07:38:00 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1466692646.264076-367915751', 07:38:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:00 INFO - '_': '/tools/buildbot/bin/python'} 07:38:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:00 INFO - Downloading/unpacking flake8 07:38: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 07:38: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 07:38: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 07:38: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 07:38: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 07:38: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 07:38:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:38:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:38: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 07:38: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 07:38: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 07:38: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 07:38: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 07:38: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 07:38:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:38:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:38: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 07:38: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 07:38: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 07:38: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 07:38: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 07:38: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 07:38:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:38: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 07:38: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 07:38: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 07:38: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 07:38: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 07:38: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 07:38:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:38:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:38:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:38:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:38:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:38:02 INFO - no previously-included directories found matching 'docs/_build' 07:38:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:38:03 INFO - Running setup.py install for pep8 07:38:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:38:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:38:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:38:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:38:03 INFO - no previously-included directories found matching 'docs/_build' 07:38:03 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:38:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:38:03 INFO - Cleaning up... 07:38:03 INFO - Return code: 0 07:38:03 INFO - Running post-action listener: _resource_record_post_action 07:38:03 INFO - Running post-action listener: _start_resource_monitoring 07:38:03 INFO - Starting resource monitoring. 07:38:03 INFO - ##### 07:38:03 INFO - ##### Finished create-virtualenv step (success) 07:38:03 INFO - ##### 07:38:03 INFO - ##### 07:38:03 INFO - ##### Running install step. 07:38:03 INFO - ##### 07:38:03 INFO - Running pre-action listener: _resource_record_pre_action 07:38:03 INFO - Running main action method: install 07:38:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:38:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:38:03 INFO - Reading from file tmpfile_stdout 07:38:03 INFO - Detecting whether we're running mozinstall >=1.0... 07:38:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:38:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:38:03 INFO - Reading from file tmpfile_stdout 07:38:03 INFO - Output received: 07:38:03 INFO - Usage: mozinstall [options] installer 07:38:03 INFO - Options: 07:38:03 INFO - -h, --help show this help message and exit 07:38:03 INFO - -d DEST, --destination=DEST 07:38:03 INFO - Directory to install application into. [default: 07:38:03 INFO - "/builds/slave/test"] 07:38:03 INFO - --app=APP Application being installed. [default: firefox] 07:38:03 INFO - mkdir: /builds/slave/test/build/application 07:38:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:38:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:38:19 INFO - Reading from file tmpfile_stdout 07:38:19 INFO - Output received: 07:38:19 INFO - /builds/slave/test/build/application/firefox/firefox 07:38:19 INFO - Running post-action listener: _resource_record_post_action 07:38:19 INFO - ##### 07:38:19 INFO - ##### Finished install step (success) 07:38:19 INFO - ##### 07:38:19 INFO - ##### 07:38:19 INFO - ##### Running run-tests step. 07:38:19 INFO - ##### 07:38:19 INFO - Running pre-action listener: _resource_record_pre_action 07:38:19 INFO - Running main action method: run_tests 07:38:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:38:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:38:19 INFO - Python 2.7.3 07:38:19 INFO - Return code: 0 07:38:19 INFO - grabbing minidump binary from tooltool 07:38:19 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')]} 07:38:19 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27e71c0>, '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 0x27e80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27e8550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:38:19 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 07:38:19 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 07:38:19 INFO - Calling ['/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'] with output_timeout 600 07:38:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:38:19 INFO - Return code: 0 07:38:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:38:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:38:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:38:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:38:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:38:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:38:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:38:20 INFO - Return code: 0 07:38:20 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', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XWDgoZ6mRki9zqJ56B5nvA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 07:38:20 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 dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XWDgoZ6mRki9zqJ56B5nvA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:38:20 INFO - Using env: {'DISPLAY': ':0', 07:38:20 INFO - 'HOME': '/home/cltbld', 07:38:20 INFO - 'LANG': 'en_US.UTF-8', 07:38:20 INFO - 'LANGUAGE': 'en_US:en', 07:38:20 INFO - 'LOGNAME': 'cltbld', 07:38:20 INFO - 'MAIL': '/var/mail/cltbld', 07:38:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:38:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:38:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:20 INFO - 'MOZ_NO_REMOTE': '1', 07:38:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:38:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:20 INFO - 'NO_EM_RESTART': '1', 07:38:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:20 INFO - 'PWD': '/builds/slave/test', 07:38:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:38:20 INFO - 'SHELL': '/bin/bash', 07:38:20 INFO - 'SHLVL': '1', 07:38:20 INFO - 'TERM': 'linux', 07:38:20 INFO - 'TMOUT': '86400', 07:38:20 INFO - 'USER': 'cltbld', 07:38:20 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1466692646.264076-367915751', 07:38:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:20 INFO - '_': '/tools/buildbot/bin/python'} 07:38:20 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', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XWDgoZ6mRki9zqJ56B5nvA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:38:20 INFO - mozversion application_buildid: 20160623061527 07:38:20 INFO - mozversion application_changeset: 3c54e4e048dcd7b1a7a54a8fbc4a68962a8fdce4 07:38:20 INFO - mozversion application_display_name: Nightly 07:38:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:38:20 INFO - mozversion application_name: Firefox 07:38:20 INFO - mozversion application_remotingname: firefox 07:38:20 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:38:20 INFO - mozversion application_vendor: Mozilla 07:38:20 INFO - mozversion application_version: 50.0a1 07:38:20 INFO - mozversion platform_buildid: 20160623061527 07:38:20 INFO - mozversion platform_changeset: 3c54e4e048dcd7b1a7a54a8fbc4a68962a8fdce4 07:38:20 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:38:20 INFO - mozversion platform_version: 50.0a1 07:38:20 INFO - using testdate: 1466692700 07:38:20 INFO - actual date: 1466692700 07:38:20 INFO - starting webserver on 'localhost:50343' 07:38:20 INFO - SUITE-START | Running 2 tests 07:38:20 INFO - TEST-START | dromaeo_css 07:38:20 INFO - operating with platform_type : linux_ 07:38:20 INFO - Initialising browser for dromaeo_css test... 07:38:20 INFO - TEST-INFO | started process 24612 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc9upjE/profile http://localhost:50343/getInfo.html) 07:38:26 INFO - PROCESS | 24612 | __metrics Screen width/height:1600/1200 07:38:26 INFO - PROCESS | 24612 | colorDepth:24 07:38:26 INFO - PROCESS | 24612 | Browser inner width/height: 1024/697 07:38:26 INFO - PROCESS | 24612 | __metrics 07:38:27 ERROR - PROCESS | 24612 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 07:38:28 INFO - TEST-INFO | 24612: exit 0 07:38:28 INFO - Browser initialized. 07:38:28 INFO - Running cycle 1/1 for dromaeo_css test... 07:38:28 INFO - TEST-INFO | started process 24731 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc9upjE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:38:40 INFO - PROCESS | 24731 | RSS: Main: 185929728 07:38:40 INFO - PROCESS | 24731 | 07:39:29 INFO - PROCESS | 24731 | 1466692769990 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:41:42 INFO - PROCESS | 24731 | Cycle 1(1): loaded http://localhost:50343/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50343/tests/dromaeo/cssquery-ext.html) 07:41:43 INFO - PROCESS | 24731 | RSS: Main: 188944384 07:41:43 INFO - PROCESS | 24731 | 07:44:45 INFO - PROCESS | 24731 | Cycle 1(1): loaded http://localhost:50343/tests/dromaeo/cssquery-ext.html (next: http://localhost:50343/tests/dromaeo/cssquery-jquery.html) 07:44:46 INFO - PROCESS | 24731 | RSS: Main: 187740160 07:44:46 INFO - PROCESS | 24731 | 07:47:48 INFO - PROCESS | 24731 | Cycle 1(1): loaded http://localhost:50343/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50343/tests/dromaeo/cssquery-mootools.html) 07:47:49 INFO - PROCESS | 24731 | RSS: Main: 188973056 07:47:49 INFO - PROCESS | 24731 | 07:50:51 INFO - PROCESS | 24731 | Cycle 1(1): loaded http://localhost:50343/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50343/tests/dromaeo/cssquery-prototype.html) 07:50:51 INFO - PROCESS | 24731 | RSS: Main: 186609664 07:50:51 INFO - PROCESS | 24731 | 07:53:54 INFO - PROCESS | 24731 | Cycle 1(1): loaded http://localhost:50343/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50343/tests/dromaeo/cssquery-yui.html) 07:53:55 INFO - PROCESS | 24731 | RSS: Main: 189095936 07:53:55 INFO - PROCESS | 24731 | 07:56:57 INFO - PROCESS | 24731 | Cycle 1(1): loaded http://localhost:50343/tests/dromaeo/cssquery-yui.html (next: http://localhost:50343/tests/dromaeo/cssquery-dojo.html) 07:56:58 INFO - PROCESS | 24731 | RSS: Main: 189591552 07:56:58 INFO - PROCESS | 24731 | 07:56:58 INFO - PROCESS | 24731 | __start_tp_report 07:56:58 INFO - PROCESS | 24731 | _x_x_mozilla_page_load 07:56:58 INFO - PROCESS | 24731 | _x_x_mozilla_page_load_details 07:56:58 INFO - PROCESS | 24731 | |i|pagename|runs| 07:56:58 INFO - PROCESS | 24731 | |0;dojo.html;2647.774939130174;2648.1658277642546;2669.666291713536;2682.10149599884;2685.7314268573145;4772;4846.9757651211785;4854.150523658363;4881.5118488151165;4916.655834091615;4709;4818.686785358949;4834.661573689843;4840.298156767267;4851.1753001989655;4383.123375324932;4398.318260669601;4500.21246281901;4507.639388848885;4509.098180363924;245.25233029657156;4479.328100784892;4481.708688935225;4524.298733696266;4527.56988086133;4483.641308695296;4490.169318676056;4491.214037543449;4493;4543.0459603483305;4430.490493593245;4493.752843593601;4500.5274446183;4508.909821803545;4512.661550383701;4436.401085853401;4450.777461126931;4455.777211139462;4507.256302710049;4516.18708632446;4861.489543597907;4868.561829435368;4914.90170196594;4922.187839006559;4952.959878425499;5121.129408000649;5167.638265321429;5219.164933610642;5255.527002569787;5275.683458992473;5247.23915032322;5270.314859068335;5286.682799032071;5291.656042357235;5321.962217367615;4916.213405855046;4922.803087876517;4925.162722337212;4926.679765815211;4972.57733092684;5230.137027390514;5349.81275655358;5366.248725178478;5398.91901621476;5404.621676482609;5141.588672906233;5168.508991645787;5178.559822415062;5190.11767999441;5195.090859099642;5253.080710875582;5254.13306804373;5261.842144735664;5267.367915850046;5309.044372013074;5074.188129899198;5150.768215430315;5150.99555586657;5183.637145399861;5185.844424667266;5000.874978125503;5086.931744333731;5119.948800512022;5132.640715149978;5173.844784656466;4443.800028998703;4445.555444455528;4451.955480445219;4452.799624016862;4491.910161796745;3802.2775672622115;3830.7893065881085;3843.673287770515;3898.5126859142606;3903.6291552302487;4486.865394038184;4493.281075028045;4497.100579884036;4522.276435770261;4554.180247555406;5127.435982041972;5235.947640523622;5242.68543887368;5249.370075590878;5287.894242115136;4474.082813023388;4508.549145085531;4510.481294651091;4512.684112112186;4535.160995215896;4739.597134243559;4758.78585463655;4768.61851051915;4775.21209000511;4805.255185446262;4763.976180119216;4789.736564488987;4913.041956818529;4931.432885218246;4981.975090124526;5123.846284611468;5199.948000519947;5206.869828254173;5215.895682086413;5256.553192978639;4845.8061677532505;4849.248366503198;4853.781579828846;4854.762035680878;4906.730129842893;5111.64218504716;5117.232415137759;5159.896802064013;5196.272521846869;5200.245964335075;5271.868203294948;5273.630845840754;5275.261463395051;5287.074761916726;5299.258103865539;5138.3833939927445;5143.71709555963;5144.125498665161;5147.40804807452;5187.351581052369;4946.777395017305;5058.367704036996;5071.061853557104;5105.33630628016;5125.154349532286;4908.901821963612;4923.4584195737725;4938.975305123451;5002.549770520671;5048.343715316985;5133.640645154804;5139.691618502902;5145.71698556568;5152.510511501401;5203.115470370122;4895.755212239445;4968.22992436173;5004.649674522749;5023.196288593807;5046.293518907282 07:56:58 INFO - PROCESS | 24731 | |1;ext.html;548.2180542052971;571.7541457173417;574.8361716910679;596.3023262782542;609.4697613076625;31532.68467315326;34653;34687.653123468786;34705.479417808754;34857.825710871475;39538.8023059885;40306.59693403065;40419.39370909439;40453.19093618126;40456.39315410264;7730.111037230734;7738.49699769516;7761.2626800454145;7828.725994590191;7835.490693104958;7699.846003079935;7724.575148366837;7761.844763104735;7765.844683106335;7779.416543759213;7761.961190194041;7791.961040194819;7805.921940780605;7813.257740514642;7872.094709108468;7760.370322232338;7765.456418050739;7785.026871641045;7802.609869506502;7810.960945195295;7612.162662107164;7629.961850190769;7676.309132178131;7705.537667739954;7707.653155608011;36915.63084369175;37025.148742562764;37248.81375593132;37323.62676373229;37324.8942616312;2970.5395663672166;3078.184281165493;3099.8605062772003;3431.330890476358;3738.7943663098517;27584.586231206547;29746;30287.394252115053;30329.393412131856;30371.544426833614;3322.4684050551796;3382.4249877520633;3443.276911848515;3487.581490221164;3499.4400895856797;252828;253096;253635;254771;255061;31719.207019824687;32623.836880815918;54050.45949540533;54626.72686636541;54831.725841371335;32373.352532949208;32761.18097047593;32822.34355312928;32837.507437388456;32875;13355.732885342433;13366.198028118344;13503.59489215325;13519.662008449868;13607;11232.49453774582;11287.887121128848;11291.887081129247;11298.54805807775;11390.145739069603;7756.573388463688;7821.843563128706;7833.138354780969;7868.449208555347;7954.443188976832;3070.1557071804987;3114.7196752292402;3124.875084942216;3134.670859559759;3177.0786471922884;896.2292428511475;916.3402350307767;979.5494072726483;982.9924327564304;983.1201075037944;27546.586801198;28282;28751;28864.422711545652;28946.565801512996;949.1979277510493;950.6150009246267;968.6464440479315;992.4739887859446;1005.1205195453978;14699.853001469848;15017.774733379008;15146.242687865562;15398.615034624;15493.07041577509;425718;429126;431672;434797;437138;49800.25299620508;49817.501824981286;50332.49667503278;50347.496525035014;50419.747901260256;1143.9370834604176;1165.930044197334;1181.9468123934444;1184.407796101949;1184.644606618011;26718.46563068689;27957;27978;28275.57586636161;28336;43484.130317394105;43785.56214437815;43832;43936.12127757363;44010.33984490299;334469;335493;336139;337548;337807;24671.753282466947;24904;25000.124995625065;25069.122580709587;25270.49459010846;41899.58100418957;42048.789756051025;42300;42372.78813605912;42528.362074568286;37222.627773723;37447;37541.2491750158;37556.2488750218;37589;36681.816590917944;36689.81655091814;37226.8138659305;37516.62483375131;37955.24089518249;32160.356792863542;35973.10067248235;36206.27587448289;37200.44199337066;39174.60825391824;31543.52684709777;32292.19269518281;32667;32929;32929.506057409635;24991.500169996863;25200;25502.23493295204;25861.48277034411;25926.611100833125 07:56:58 INFO - PROCESS | 24731 | |2;jquery.html;369.66360611843226;371.2778645534436;379.04858804400965;385.5335044596039;389.39449156561534;15626.453074142408;16544.751828722565;16655.08397038164;17105;17158.742618860728;15833.208339583003;16126.596835079099;16654.417095401663;16706.665866682688;16746;5021.1213037718435;5199.766010529516;5235.293235413209;5238.423773384925;5240.213967904807;3795.7722536647752;5129.487051294878;5808.273965754281;6244.625322480643;6249.125122482856;6144.539159563028;6237.220347456568;6290.276618188898;6292.968535157318;6300.8109756707145;6287.968560157193;6304;6304.590201636879;6313.273973493038;6321.209848768904;5362.65142765719;5482.205080263379;5513.61404701671;5515.227868098469;5518.951399234133;20403.285884994104;20461.28385506515;20953.161873525194;21752.782472175393;21778.673319900216;2021.3632705697657;2209.5470428562107;2230.141395562704;2320.825938054653;2483.540544999181;13205.86794132056;13223.33883305831;13344.199348039148;13379.732405351935;13851.792223116661;1640.450449099553;1721.7331313646405;1733.03816381908;1733.2633630707026;1745.2233755978596;67919.32080679179;68626;69748.30251697519;70380.99999999949;71877;9810.607575696893;9836.852447213298;10013;10022.3485473444;10194.796104077877;13577.864221357857;13694.520691775939;13766;13771.449142034407;13950.581482555539;7325.816854578678;7351.8162045949275;7474.476786624993;7488.588127652923;7591.962040189764;7051.788446346618;7084.610346430995;7116.64416779159;7247.4926755126635;7262.055932728711;6242.812715618538;6362.172917520693;6408.55140140195;6441.291457939623;6449.226092868886;1666.2668425892568;1722.3885520639992;1802.7825774297687;1812.0758413209358;1883.369071361082;808.567416432206;910.41733290694;920.0201785098849;942.0202988891476;981.4307701533094;17986.280548778162;18121.912685238665;18215.72676409855;18333;18350.357737479124;875.7591662292921;882.8190221004679;887.4852585500395;915.514777168102;935.8034812689275;9982.80034399308;10307.330023548595;10362.844557331646;10429.843552346721;10578.365298082139;399379;403002;425193;426039;427378;73252;73934;74945;76368;77112.61443692746;899.9055099214619;932.4778124250306;947.7156852944089;950.8716323296267;956.3592393096503;13774.793378099135;14498.710025799213;15868;16231.837681623032;16278.267477963283;31988.20029499281;33679.32641347208;36221.91655204106;38251;38739.225215496095;53305.733471332394;54397;54695.72652136714;55296.44703552913;56906;7632.8855067175145;7680.5391676499585;7769.378449724121;7910.644021018953;7935.563544005136;8395.622197001028;10528.631497897537;11569.7107572308;11610.24533405326;11645.126615503701;9889.50552472359;9934.45360505179;10068.597256109966;10208.387496750218;10263.486825658836;9746.853797192905;10357.223208259562;10439.895601044196;10490.31812932157;10535.947320263349;9927.354721943051;10167.18662506983;10288.897111029093;10327.741806454598;10705.518251678537;7177.246389129066;7235.167955685163;7459.738909138371;7653.732119375795;7753.612319383896;9977.401355918668;9977.800443990935;10001.2999090063;10120.493975301059;10452.529636166542 07:56:58 INFO - PROCESS | 24731 | |3;mootools.html;1365.1263191557405;1397.2594524901801;1458.1907041591912;1661.2939500712193;1674.4474323473255;6750.763723269686;7475;7534.095908490989;8040.316573091287;8058.677652893884;7570;7762.767116986485;7798.883016754753;7899;7926.9207307927045;2175.695402643631;2217.5121473275935;2221.522372689871;2224.065892325227;2230.710007699005;2148.387709502792;2152.817010554105;2186.5408264264524;2187.3437968609433;2192.8136108430804;2146.1308170191096;2212.889355532225;2214.402111429913;2225.6995305633695;2233.8212942964524;2126.7873212678765;2127.914883404662;2136.69017992391;2137.1665050630113;2144.9249276275254;2099.7060411542243;2134.9466263343543;2140.807327340531;2141.0365335599045;2141.3361857824125;7901.644426000844;7903.3282171015535;7977.641006154737;7982.32150267228;7994.920050799476;4444.177827101997;4632.467266264355;4647.279671650899;4649.279361698942;4651.581357677791;2875.2811797050736;2941.1176647005814;2990.177701132184;3009.5335223040465;3012.653544842349;929.7489677786959;934.4673536084434;947.161761840769;960.4669408478292;969.0406497567428;10551.683449496528;10631.149508039338;10638.57445702171;10647.946760266226;10698.518566664441;4149.481314835645;4217.957820421818;4268.103698223408;4297.72064815786;4298.075913678574;9146.542672866462;9176.31177661678;9236.214921731593;9245.214156796614;9270.675526356545;4720.433547974265;4792.9281060784115;4794.7842347094465;4809.158397280462;4829.5653391194965;3641.5083963665097;4192.4759405074365;4323.200207961474;4389.231884420214;4406;3682.226732386175;3690.391085470921;3744.1014156602764;3776;3800.1639639279315;1204.566356111799;1210.5883999440232;1211.8000529912642;1226.2213494430923;1227.9324637145044;678.396227357652;684.9383555480031;795.5783434779576;797.7048492057976;808.3815880851154;4759.857204283877;5216.869578260574;5246.501582349671;5320.467953204648;5387.380451248078;411.1920077048614;415.634241867161;422.5225495190415;423.11568821163917;427.2885645400373;3338.198832280284;3502.2120022994623;3503.3168532135987;3514.876979305712;3537.3102245061964;9275.304352173614;9579.089986451276;9606.615735370508;9670.516474176264;9676.225901927828;9584.137427631407;9599;9610.038996100335;9622.807543849223;9644.855327170098;6934.618595977269;7171.318724721247;7209.855802883913;7280.490365674458;7315.634218289064;5378.623496355218;5460.099083651312;5479.424660410599;5510.641808282448;5571.164325351229;9043.68347107848;9049.230815380766;9054.502002389932;9081.863772043556;9117.635294588408;8522.829543409222;8910;8967.730968070968;9037.09629037091;9215.815683686154;6110.450059494667;6543.934560654523;6646.202455705346;6779.796606101825;6833.760818371333;7587.317141457295;7609.353204977418;7614.390848732199;7633.503822251536;7633.69465221385;6668.566543174678;6901.654917254217;6905.75829845953;6951.721931122698;6989.231184569591;6566.868662626625;6572.507061970276;6712.899306510309;6716.630585317855;6938.930610693828;5611.438856114356;5851.063829787214;5928.466438020599;5930.377310382348;5934.139549765174;4202.66378689698;4348.9130217396105;4395.164918665443;4416.845410410749;4456.086502267092;4526.796294166837;4530.818767249273;4531.750753708578;4569.977150114228;4574.954250457453 07:56:58 INFO - PROCESS | 24731 | |4;prototype.html;296.38647998642807;301.82644979136995;301.91395452296075;302.52654595557965;305.8577761340976;5049.747512624368;5098.923516147261;5106.183010718286;5125.513076257759;5135.460776618457;5025.472325405825;5035.169197082477;5036.722980236085;5056.115179843522;5060;3691.612380700035;3824.4836947012213;3957.861474848381;3964.9207015859665;3965.4250133730593;3967.3255546557157;3972.7616343019367;3983.9203215935663;3998.4402183694306;4017.8593749218785;3977.701672374569;3984.9402258965993;3989.122393073519;3994.4208089826957;3996.2007598480277;3674.2100448403453;3871;3872.5159355080614;3979.0262172284642;4014.7390419622775;3329.9833500832583;3354.2117602363423;3357.244619960489;3357.345317663057;3361.3781450431748;4939.901201975977;4953.653244272902;4960.528749768766;4960.578350840183;4973.7421988597525;4243.872683819491;4444.31113177458;4478.731276123443;4483.887902802456;4487.6634252431195;5230.110881150214;5293.206019097128;5295.7881684732565;5309.973450132763;5325.760340784674;3669.3395188865993;3671.0822294426393;3674.595794462607;3700.4634328022285;3705.0181701849033;5407.53917492801;5526.171074338841;5530.308711411074;5541.168824676291;5565.499105080522;3754.7934863582764;3765.8305376258136;3777.320082385197;3780.5085338906315;3781.6596506314563;3773.660370566662;3789.389509458469;3817.61823817616;3826.7895265760094;3838.443425703313;4426.845060422934;4446.044100518404;4449.399331090326;4466.816293682177;4474.440694913136;5108;5310.92033619496;5319.7340132993195;5325.707086110224;5357.866053348697;1335.2922950836073;1348.312360696052;1352.4387379237703;1356.6743981444579;1364.3110229334122;833.358314098141;840.932725381968;859.2481578618708;866.1987661413168;883.7437143228392;4521.276595744665;4522.525134860793;4541.9545804542195;4542.136993971135;4544.840930567414;5359;5415.48552887475;5428.185772134211;5432.75552600134;5462.617616766867;4341.60925516705;4583.931241031387;4585.81656733727;4585.839495617704;4593.242115050979;2910.4761142994466;2933.82397056173;2935.33954860159;2936.7503762180027;2971.777116716255;5172.663776854492;5196.402413722395;5202.81790137351;5208;5222.451642577475;5491.7254137292975;5588.329400471969;5696;5723.7996670116345;5748.338941021752;5146.125158723026;5153.768080436389;5160.922586161286;5166.535011848877;5177.378714554277;5472.972635136799;5497.202905578749;5507.779688812563;5521.861953451196;5546.500814926676;5276.34045744282;5414.431484694208;5423.376311724202;5431.6740995540395;5468.91796623059;5105.412877519133;5131.92302115476;5133.614978876524;5156.767945442389;5167.819126330561;3844.3272427325664;3853.788041657736;3858;3870.632289932452;3880.1463677990796;5413.702246376487;5531.695756733257;5547.8890422190525;5554.722263886871;5566.526845218202;5363.517283444353;5368.141097424394;5389.490942536097;5397.8110766123;5402.75687594067;5027.773750181177;5269.262303277621;5319.574434045345;5325.387580428145;5366.731663416892;5293.973530132324;5307.7611507483025;5310.707911064928;5312.548433383051;5353.78584856617;5145.710158979218;5237.607179461479;5427.6472029317965;5431.0801226663125;5447.727613619382;5230.581553475637;5299.258103865539;5300.70846103468;5309.36287645485;5323 07:56:58 INFO - PROCESS | 24731 | |5;yui.html;612.9080637904311;649.1042361541073;705.3933617089306;719.8200449887528;741.2476336518433;12471.127021108527;13276.867231327684;13300.401481933312;13322.800157997637;13355.599332020054;12550;13651.726965460684;14256.144631322128;14282.214478203694;15001.399944002254;622.1321256846719;771.3327971304809;787.9369650427981;797.7048492057946;799.848028874512;783.7296132834192;788.4914230321439;790.7864876483346;794.2613369566301;794.6582969323189;838.8490071787076;838.9203025712548;839.3411172229801;839.5424493650975;841.6338892581716;821.5850995247391;823;824.1428913929536;831.1439217605875;832.5961908474385;607.3562024254304;608.6165715599188;608.6469847488446;608.7564974010431;610.8961476548953;14057;14255.501057463043;14296.142231466145;14382.640433989129;14394.424223031067;13253.939684825287;13382.531611393651;13673.726525469534;13729.176249424967;13754.724905501835;10921.344719316867;11016.228863979524;11041.779164416666;11175.944120279346;11638.243514171552;3322.069820450278;3380.2732412531423;3400.0649821299094;3417.3848707232687;3502.176988407722;70346;70840;71285.64357178233;72067.63966180188;72711.63644181799;9838.75403114928;9989.60041598328;9995.200383969264;10031.097201251923;10135.9493202535;19632.705509417083;19761.308354207533;19882;19883.403497895088;19911.60176796485;6891.3797758202;6930.410915072275;6989.790306290718;7025.192102908129;7127.643617819088;3726.2733766915735;3860.343741563941;3899.3566061600086;3917.177392747498;3948.822302996372;3020.426119037376;3133.529970504397;3134.044116544476;3155.3689262147664;3159.636641786224;505.3026822984258;551.5367091643039;563.9154126880919;583.2243116654839;585.8242527241811;582.4554041970771;622.2626187967182;631.7504585688719;645.9741610335534;652.8759535688204;7969.800754981172;8341.95829020851;8501.829963400822;8594.87107693385;8808.5595720215;519.5246349590158;525.1859617592715;588.5879884081161;639.3318981664172;640.414021170633;3799.848006079781;3925.7055720821054;3979.422983667352;4015.13674559971;4106.137711080706;61675.074873876925;92002.53998730097;101905.49047254716;108044;108450.45774771234;94549.5272523633;95877;96048.51975740076;96418.51790741141;96639;76201;77477;79381.60309198417;81724.59137704273;81848.18151818524;7555.433342499445;7556.395488360808;7586.924130758843;7800.102988156435;7835.177306382976;46396;47620.28569571528;47749.522504774504;47812.28281575849;48293.275600865316;54845;55735.44264557303;55969;63729.36270637234;64349;11565.190436669352;11645.708857278636;11695.12286578527;11887.821682674594;12279.508819647113;12336.444859981502;12891.162074465505;12932.0066170225;13013.219206847241;13326.33368331599;11512.19414640967;11733.882661173278;12032.27806331623;12389;12481.687957801129;12144.39278036077;12156;12175.573854915036;12321.199122057038;12574.434150463434;11149.72125696864;11239.67926325793;11383.829242561535;11499.367534785668;11807.645770626552;9277.582508786985;9469.242460603273;9474.763130921507;9742.95128524353;10173.389596624227;9566.66516671913;9570.377925434825;9613.711588652352;9643;9670.178034867115 07:56:58 INFO - PROCESS | 24731 | __end_tp_report 07:56:58 INFO - PROCESS | 24731 | __start_cc_report 07:56:58 INFO - PROCESS | 24731 | _x_x_mozilla_cycle_collect,377 07:56:58 INFO - PROCESS | 24731 | __end_cc_report 07:56:58 INFO - PROCESS | 24731 | __startTimestamp1466693818114__endTimestamp 07:56:58 INFO - PROCESS | 24731 | 07:56:58 INFO - PROCESS | 24731 | ------- Summary: start ------- 07:56:58 INFO - PROCESS | 24731 | Number of tests: 6 07:56:58 INFO - PROCESS | 24731 | 07:56:58 INFO - PROCESS | 24731 | [#0] dojo.html Cycles:165 Average:4797.20 Median:4925.16 stddev:625.04 (12.7%) stddev-sans-first:603.78 07:56:58 INFO - PROCESS | 24731 | Values: 2647.8 2648.2 2669.7 2682.1 2685.7 4772.0 4847.0 4854.2 4881.5 4916.7 4709.0 4818.7 4834.7 4840.3 4851.2 4383.1 4398.3 4500.2 4507.6 4509.1 245.3 4479.3 4481.7 4524.3 4527.6 4483.6 4490.2 4491.2 4493.0 4543.0 4430.5 4493.8 4500.5 4508.9 4512.7 4436.4 4450.8 4455.8 4507.3 4516.2 4861.5 4868.6 4914.9 4922.2 4953.0 5121.1 5167.6 5219.2 5255.5 5275.7 5247.2 5270.3 5286.7 5291.7 5322.0 4916.2 4922.8 4925.2 4926.7 4972.6 5230.1 5349.8 5366.2 5398.9 5404.6 5141.6 5168.5 5178.6 5190.1 5195.1 5253.1 5254.1 5261.8 5267.4 5309.0 5074.2 5150.8 5151.0 5183.6 5185.8 5000.9 5086.9 5119.9 5132.6 5173.8 4443.8 4445.6 4452.0 4452.8 4491.9 3802.3 3830.8 3843.7 3898.5 3903.6 4486.9 4493.3 4497.1 4522.3 4554.2 5127.4 5235.9 5242.7 5249.4 5287.9 4474.1 4508.5 4510.5 4512.7 4535.2 4739.6 4758.8 4768.6 4775.2 4805.3 4764.0 4789.7 4913.0 4931.4 4982.0 5123.8 5199.9 5206.9 5215.9 5256.6 4845.8 4849.2 4853.8 4854.8 4906.7 5111.6 5117.2 5159.9 5196.3 5200.2 5271.9 5273.6 5275.3 5287.1 5299.3 5138.4 5143.7 5144.1 5147.4 5187.4 4946.8 5058.4 5071.1 5105.3 5125.2 4908.9 4923.5 4939.0 5002.5 5048.3 5133.6 5139.7 5145.7 5152.5 5203.1 4895.8 4968.2 5004.6 5023.2 5046.3 07:56:58 INFO - PROCESS | 24731 | 07:56:58 INFO - PROCESS | 24731 | [#1] ext.html Cycles:180 Average:47990.50 Median:36685.82 stddev:92224.91 (251.4%) stddev-sans-first:92414.84 07:56:58 INFO - PROCESS | 24731 | Values: 548.2 571.8 574.8 596.3 609.5 31532.7 34653.0 34687.7 34705.5 34857.8 39538.8 40306.6 40419.4 40453.2 40456.4 7730.1 7738.5 7761.3 7828.7 7835.5 7699.8 7724.6 7761.8 7765.8 7779.4 7762.0 7792.0 7805.9 7813.3 7872.1 7760.4 7765.5 7785.0 7802.6 7811.0 7612.2 7630.0 7676.3 7705.5 7707.7 36915.6 37025.1 37248.8 37323.6 37324.9 2970.5 3078.2 3099.9 3431.3 3738.8 27584.6 29746.0 30287.4 30329.4 30371.5 3322.5 3382.4 3443.3 3487.6 3499.4 252828.0 253096.0 253635.0 254771.0 255061.0 31719.2 32623.8 54050.5 54626.7 54831.7 32373.4 32761.2 32822.3 32837.5 32875.0 13355.7 13366.2 13503.6 13519.7 13607.0 11232.5 11287.9 11291.9 11298.5 11390.1 7756.6 7821.8 7833.1 7868.4 7954.4 3070.2 3114.7 3124.9 3134.7 3177.1 896.2 916.3 979.5 983.0 983.1 27546.6 28282.0 28751.0 28864.4 28946.6 949.2 950.6 968.6 992.5 1005.1 14699.9 15017.8 15146.2 15398.6 15493.1 425718.0 429126.0 431672.0 434797.0 437138.0 49800.3 49817.5 50332.5 50347.5 50419.7 1143.9 1165.9 1181.9 1184.4 1184.6 26718.5 27957.0 27978.0 28275.6 28336.0 43484.1 43785.6 43832.0 43936.1 44010.3 334469.0 335493.0 336139.0 337548.0 337807.0 24671.8 24904.0 25000.1 25069.1 25270.5 41899.6 42048.8 42300.0 42372.8 42528.4 37222.6 37447.0 37541.2 37556.2 37589.0 36681.8 36689.8 37226.8 37516.6 37955.2 32160.4 35973.1 36206.3 37200.4 39174.6 31543.5 32292.2 32667.0 32929.0 32929.5 24991.5 25200.0 25502.2 25861.5 25926.6 07:56:58 INFO - PROCESS | 24731 | 07:56:58 INFO - PROCESS | 24731 | [#2] jquery.html Cycles:180 Average:25336.45 Median:216199.56 stddev:68541.06 (31.7%) stddev-sans-first:68707.70 07:56:58 INFO - PROCESS | 24731 | Values: 369.7 371.3 379.0 385.5 389.4 15626.5 16544.8 16655.1 17105.0 17158.7 15833.2 16126.6 16654.4 16706.7 16746.0 5021.1 5199.8 5235.3 5238.4 5240.2 3795.8 5129.5 5808.3 6244.6 6249.1 6144.5 6237.2 6290.3 6293.0 6300.8 6288.0 6304.0 6304.6 6313.3 6321.2 5362.7 5482.2 5513.6 5515.2 5519.0 20403.3 20461.3 20953.2 21752.8 21778.7 2021.4 2209.5 2230.1 2320.8 2483.5 13205.9 13223.3 13344.2 13379.7 13851.8 1640.5 1721.7 1733.0 1733.3 1745.2 67919.3 68626.0 69748.3 70381.0 71877.0 9810.6 9836.9 10013.0 10022.3 10194.8 13577.9 13694.5 13766.0 13771.4 13950.6 7325.8 7351.8 7474.5 7488.6 7592.0 7051.8 7084.6 7116.6 7247.5 7262.1 6242.8 6362.2 6408.6 6441.3 6449.2 1666.3 1722.4 1802.8 1812.1 1883.4 808.6 910.4 920.0 942.0 981.4 17986.3 18121.9 18215.7 18333.0 18350.4 875.8 882.8 887.5 915.5 935.8 9982.8 10307.3 10362.8 10429.8 10578.4 399379.0 403002.0 425193.0 426039.0 427378.0 73252.0 73934.0 74945.0 76368.0 77112.6 899.9 932.5 947.7 950.9 956.4 13774.8 14498.7 15868.0 16231.8 16278.3 31988.2 33679.3 36221.9 38251.0 38739.2 53305.7 54397.0 54695.7 55296.4 56906.0 7632.9 7680.5 7769.4 7910.6 7935.6 8395.6 10528.6 11569.7 11610.2 11645.1 9889.5 9934.5 10068.6 10208.4 10263.5 9746.9 10357.2 10439.9 10490.3 10535.9 9927.4 10167.2 10288.9 10327.7 10705.5 7177.2 7235.2 7459.7 7653.7 7753.6 9977.4 9977.8 10001.3 10120.5 10452.5 07:56:58 INFO - PROCESS | 24731 | 07:56:58 INFO - PROCESS | 24731 | [#3] mootools.html Cycles:180 Average:5123.75 Median:5023.22 stddev:2896.41 (57.7%) stddev-sans-first:2890.77 07:56:58 INFO - PROCESS | 24731 | Values: 1365.1 1397.3 1458.2 1661.3 1674.4 6750.8 7475.0 7534.1 8040.3 8058.7 7570.0 7762.8 7798.9 7899.0 7926.9 2175.7 2217.5 2221.5 2224.1 2230.7 2148.4 2152.8 2186.5 2187.3 2192.8 2146.1 2212.9 2214.4 2225.7 2233.8 2126.8 2127.9 2136.7 2137.2 2144.9 2099.7 2134.9 2140.8 2141.0 2141.3 7901.6 7903.3 7977.6 7982.3 7994.9 4444.2 4632.5 4647.3 4649.3 4651.6 2875.3 2941.1 2990.2 3009.5 3012.7 929.7 934.5 947.2 960.5 969.0 10551.7 10631.1 10638.6 10647.9 10698.5 4149.5 4218.0 4268.1 4297.7 4298.1 9146.5 9176.3 9236.2 9245.2 9270.7 4720.4 4792.9 4794.8 4809.2 4829.6 3641.5 4192.5 4323.2 4389.2 4406.0 3682.2 3690.4 3744.1 3776.0 3800.2 1204.6 1210.6 1211.8 1226.2 1227.9 678.4 684.9 795.6 797.7 808.4 4759.9 5216.9 5246.5 5320.5 5387.4 411.2 415.6 422.5 423.1 427.3 3338.2 3502.2 3503.3 3514.9 3537.3 9275.3 9579.1 9606.6 9670.5 9676.2 9584.1 9599.0 9610.0 9622.8 9644.9 6934.6 7171.3 7209.9 7280.5 7315.6 5378.6 5460.1 5479.4 5510.6 5571.2 9043.7 9049.2 9054.5 9081.9 9117.6 8522.8 8910.0 8967.7 9037.1 9215.8 6110.5 6543.9 6646.2 6779.8 6833.8 7587.3 7609.4 7614.4 7633.5 7633.7 6668.6 6901.7 6905.8 6951.7 6989.2 6566.9 6572.5 6712.9 6716.6 6938.9 5611.4 5851.1 5928.5 5930.4 5934.1 4202.7 4348.9 4395.2 4416.8 4456.1 4526.8 4530.8 4531.8 4570.0 4575.0 07:56:58 INFO - PROCESS | 24731 | 07:56:58 INFO - PROCESS | 24731 | [#4] prototype.html Cycles:180 Average:4400.26 Median:5058.06 stddev:1300.87 (25.7%) stddev-sans-first:1267.53 07:56:58 INFO - PROCESS | 24731 | Values: 296.4 301.8 301.9 302.5 305.9 5049.7 5098.9 5106.2 5125.5 5135.5 5025.5 5035.2 5036.7 5056.1 5060.0 3691.6 3824.5 3957.9 3964.9 3965.4 3967.3 3972.8 3983.9 3998.4 4017.9 3977.7 3984.9 3989.1 3994.4 3996.2 3674.2 3871.0 3872.5 3979.0 4014.7 3330.0 3354.2 3357.2 3357.3 3361.4 4939.9 4953.7 4960.5 4960.6 4973.7 4243.9 4444.3 4478.7 4483.9 4487.7 5230.1 5293.2 5295.8 5310.0 5325.8 3669.3 3671.1 3674.6 3700.5 3705.0 5407.5 5526.2 5530.3 5541.2 5565.5 3754.8 3765.8 3777.3 3780.5 3781.7 3773.7 3789.4 3817.6 3826.8 3838.4 4426.8 4446.0 4449.4 4466.8 4474.4 5108.0 5310.9 5319.7 5325.7 5357.9 1335.3 1348.3 1352.4 1356.7 1364.3 833.4 840.9 859.2 866.2 883.7 4521.3 4522.5 4542.0 4542.1 4544.8 5359.0 5415.5 5428.2 5432.8 5462.6 4341.6 4583.9 4585.8 4585.8 4593.2 2910.5 2933.8 2935.3 2936.8 2971.8 5172.7 5196.4 5202.8 5208.0 5222.5 5491.7 5588.3 5696.0 5723.8 5748.3 5146.1 5153.8 5160.9 5166.5 5177.4 5473.0 5497.2 5507.8 5521.9 5546.5 5276.3 5414.4 5423.4 5431.7 5468.9 5105.4 5131.9 5133.6 5156.8 5167.8 3844.3 3853.8 3858.0 3870.6 3880.1 5413.7 5531.7 5547.9 5554.7 5566.5 5363.5 5368.1 5389.5 5397.8 5402.8 5027.8 5269.3 5319.6 5325.4 5366.7 5294.0 5307.8 5310.7 5312.5 5353.8 5145.7 5237.6 5427.6 5431.1 5447.7 5230.6 5299.3 5300.7 5309.4 5323.0 07:56:58 INFO - PROCESS | 24731 | 07:56:58 INFO - PROCESS | 24731 | [#5] yui.html Cycles:180 Average:18525.35 Median:28143.49 stddev:26816.40 (95.3%) stddev-sans-first:26857.90 07:56:58 INFO - PROCESS | 24731 | Values: 612.9 649.1 705.4 719.8 741.2 12471.1 13276.9 13300.4 13322.8 13355.6 12550.0 13651.7 14256.1 14282.2 15001.4 622.1 771.3 787.9 797.7 799.8 783.7 788.5 790.8 794.3 794.7 838.8 838.9 839.3 839.5 841.6 821.6 823.0 824.1 831.1 832.6 607.4 608.6 608.6 608.8 610.9 14057.0 14255.5 14296.1 14382.6 14394.4 13253.9 13382.5 13673.7 13729.2 13754.7 10921.3 11016.2 11041.8 11175.9 11638.2 3322.1 3380.3 3400.1 3417.4 3502.2 70346.0 70840.0 71285.6 72067.6 72711.6 9838.8 9989.6 9995.2 10031.1 10135.9 19632.7 19761.3 19882.0 19883.4 19911.6 6891.4 6930.4 6989.8 7025.2 7127.6 3726.3 3860.3 3899.4 3917.2 3948.8 3020.4 3133.5 3134.0 3155.4 3159.6 505.3 551.5 563.9 583.2 585.8 582.5 622.3 631.8 646.0 652.9 7969.8 8342.0 8501.8 8594.9 8808.6 519.5 525.2 588.6 639.3 640.4 3799.8 3925.7 3979.4 4015.1 4106.1 61675.1 92002.5 101905.5 108044.0 108450.5 94549.5 95877.0 96048.5 96418.5 96639.0 76201.0 77477.0 79381.6 81724.6 81848.2 7555.4 7556.4 7586.9 7800.1 7835.2 46396.0 47620.3 47749.5 47812.3 48293.3 54845.0 55735.4 55969.0 63729.4 64349.0 11565.2 11645.7 11695.1 11887.8 12279.5 12336.4 12891.2 12932.0 13013.2 13326.3 11512.2 11733.9 12032.3 12389.0 12481.7 12144.4 12156.0 12175.6 12321.2 12574.4 11149.7 11239.7 11383.8 11499.4 11807.6 9277.6 9469.2 9474.8 9743.0 10173.4 9566.7 9570.4 9613.7 9643.0 9670.2 07:56:58 INFO - PROCESS | 24731 | -------- Summary: end -------- 07:56:58 INFO - PROCESS | 24731 | 07:56:58 INFO - TEST-INFO | 24731: exit 0 07:56:58 INFO - TEST-OK | dromaeo_css | took 1118018ms 07:56:58 INFO - TEST-START | kraken 07:56:58 INFO - operating with platform_type : linux_ 07:56:58 INFO - Initialising browser for kraken test... 07:56:58 INFO - TEST-INFO | started process 24967 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpH8Rblq/profile http://localhost:50343/getInfo.html) 07:57:04 INFO - PROCESS | 24967 | __metrics Screen width/height:1600/1200 07:57:04 INFO - PROCESS | 24967 | colorDepth:24 07:57:04 INFO - PROCESS | 24967 | Browser inner width/height: 1024/697 07:57:04 INFO - PROCESS | 24967 | __metrics 07:57:05 ERROR - PROCESS | 24967 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 07:57:06 INFO - TEST-INFO | 24967: exit 0 07:57:06 INFO - Browser initialized. 07:57:06 INFO - Running cycle 1/1 for kraken test... 07:57:06 INFO - TEST-INFO | started process 25087 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpH8Rblq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:57:18 INFO - PROCESS | 25087 | RSS: Main: 185937920 07:57:18 INFO - PROCESS | 25087 | 07:57:21 INFO - PROCESS | 25087 | Cycle 1(1): loaded http://localhost:50343/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50343/tests/kraken/driver.html?testName=audio-beat-detection) 07:57:21 INFO - PROCESS | 25087 | RSS: Main: 190611456 07:57:21 INFO - PROCESS | 25087 | 07:57:24 INFO - PROCESS | 25087 | Cycle 1(1): loaded http://localhost:50343/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50343/tests/kraken/driver.html?testName=audio-dft) 07:57:25 INFO - PROCESS | 25087 | RSS: Main: 190672896 07:57:25 INFO - PROCESS | 25087 | 07:57:28 INFO - PROCESS | 25087 | Cycle 1(1): loaded http://localhost:50343/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50343/tests/kraken/driver.html?testName=audio-fft) 07:57:29 INFO - PROCESS | 25087 | RSS: Main: 186265600 07:57:29 INFO - PROCESS | 25087 | 07:57:31 INFO - PROCESS | 25087 | Cycle 1(1): loaded http://localhost:50343/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50343/tests/kraken/driver.html?testName=audio-oscillator) 07:57:31 INFO - PROCESS | 25087 | RSS: Main: 186859520 07:57:31 INFO - PROCESS | 25087 | 07:57:34 INFO - PROCESS | 25087 | Cycle 1(1): loaded http://localhost:50343/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50343/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:57:34 INFO - PROCESS | 25087 | RSS: Main: 186990592 07:57:34 INFO - PROCESS | 25087 | 07:57:37 INFO - PROCESS | 25087 | Cycle 1(1): loaded http://localhost:50343/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50343/tests/kraken/driver.html?testName=imaging-darkroom) 07:57:38 INFO - PROCESS | 25087 | RSS: Main: 187678720 07:57:38 INFO - PROCESS | 25087 | 07:57:42 INFO - PROCESS | 25087 | Cycle 1(1): loaded http://localhost:50343/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50343/tests/kraken/driver.html?testName=imaging-desaturate) 07:57:42 INFO - PROCESS | 25087 | RSS: Main: 184446976 07:57:42 INFO - PROCESS | 25087 | 07:57:45 INFO - PROCESS | 25087 | Cycle 1(1): loaded http://localhost:50343/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50343/tests/kraken/driver.html?testName=json-parse-financial) 07:57:46 INFO - PROCESS | 25087 | RSS: Main: 185880576 07:57:46 INFO - PROCESS | 25087 | 07:57:47 INFO - PROCESS | 25087 | Cycle 1(1): loaded http://localhost:50343/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50343/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:57:48 INFO - PROCESS | 25087 | RSS: Main: 186613760 07:57:48 INFO - PROCESS | 25087 | 07:57:50 INFO - PROCESS | 25087 | Cycle 1(1): loaded http://localhost:50343/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50343/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:57:51 INFO - PROCESS | 25087 | RSS: Main: 186499072 07:57:51 INFO - PROCESS | 25087 | 07:57:53 INFO - PROCESS | 25087 | Cycle 1(1): loaded http://localhost:50343/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50343/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:57:54 INFO - PROCESS | 25087 | RSS: Main: 186339328 07:57:54 INFO - PROCESS | 25087 | 07:57:56 INFO - PROCESS | 25087 | Cycle 1(1): loaded http://localhost:50343/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50343/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:57:57 INFO - PROCESS | 25087 | RSS: Main: 187215872 07:57:57 INFO - PROCESS | 25087 | 07:58:00 INFO - PROCESS | 25087 | Cycle 1(1): loaded http://localhost:50343/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50343/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:58:01 INFO - PROCESS | 25087 | RSS: Main: 187019264 07:58:01 INFO - PROCESS | 25087 | 07:58:02 INFO - PROCESS | 25087 | Cycle 1(1): loaded http://localhost:50343/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50343/tests/kraken/driver.html?testName=ai-astar) 07:58:03 INFO - PROCESS | 25087 | RSS: Main: 187936768 07:58:03 INFO - PROCESS | 25087 | 07:58:03 INFO - PROCESS | 25087 | __start_tp_report 07:58:03 INFO - PROCESS | 25087 | _x_x_mozilla_page_load 07:58:03 INFO - PROCESS | 25087 | _x_x_mozilla_page_load_details 07:58:03 INFO - PROCESS | 25087 | |i|pagename|runs| 07:58:03 INFO - PROCESS | 25087 | |0;ai-astar;104;114;107;114;118;115;115;112;113;113 07:58:03 INFO - PROCESS | 25087 | |1;audio-beat-detection;179;132;156;178;134;159;160;133;185;133 07:58:03 INFO - PROCESS | 25087 | |2;audio-dft;163;166;176;162;163;162;164;164;162;163 07:58:03 INFO - PROCESS | 25087 | |3;audio-fft;75;77;76;153;78;77;76;76;152;76 07:58:03 INFO - PROCESS | 25087 | |4;audio-oscillator;88;86;156;86;87;87;130;85;87;135 07:58:03 INFO - PROCESS | 25087 | |5;imaging-gaussian-blur;117;118;118;118;118;119;118;118;118;118 07:58:03 INFO - PROCESS | 25087 | |6;imaging-darkroom;149;149;149;149;149;149;148;148;147;149 07:58:03 INFO - PROCESS | 25087 | |7;imaging-desaturate;95;96;96;95;95;97;95;97;96;95 07:58:03 INFO - PROCESS | 25087 | |8;json-parse-financial;66;66;67;65;66;66;65;67;66;68 07:58:03 INFO - PROCESS | 25087 | |9;json-stringify-tinderbox;67;65;65;66;66;66;65;65;65;65 07:58:03 INFO - PROCESS | 25087 | |10;stanford-crypto-aes;84;82;88;91;84;84;87;90;98;86 07:58:03 INFO - PROCESS | 25087 | |11;stanford-crypto-ccm;142;132;134;133;139;138;135;132;143;148 07:58:03 INFO - PROCESS | 25087 | |12;stanford-crypto-pbkdf2;171;176;178;175;173;172;170;172;178;170 07:58:03 INFO - PROCESS | 25087 | |13;stanford-crypto-sha256-iterative;68;70;69;68;68;71;66;68;66;68 07:58:03 INFO - PROCESS | 25087 | __end_tp_report 07:58:03 INFO - PROCESS | 25087 | __start_cc_report 07:58:03 INFO - PROCESS | 25087 | _x_x_mozilla_cycle_collect,987 07:58:03 INFO - PROCESS | 25087 | __end_cc_report 07:58:03 INFO - PROCESS | 25087 | __startTimestamp1466693883054__endTimestamp 07:58:03 INFO - PROCESS | 25087 | 07:58:03 INFO - PROCESS | 25087 | ------- Summary: start ------- 07:58:03 INFO - PROCESS | 25087 | Number of tests: 14 07:58:03 INFO - PROCESS | 25087 | 07:58:03 INFO - PROCESS | 25087 | [#0] ai-astar Cycles:10 Average:112.50 Median:114.00 stddev:4.09 (3.6%) stddev-sans-first:2.96 07:58:03 INFO - PROCESS | 25087 | Values: 104.0 114.0 107.0 114.0 118.0 115.0 115.0 112.0 113.0 113.0 07:58:03 INFO - PROCESS | 25087 | 07:58:03 INFO - PROCESS | 25087 | [#1] audio-beat-detection Cycles:10 Average:154.90 Median:159.50 stddev:21.04 (13.2%) stddev-sans-first:20.43 07:58:03 INFO - PROCESS | 25087 | Values: 179.0 132.0 156.0 178.0 134.0 159.0 160.0 133.0 185.0 133.0 07:58:03 INFO - PROCESS | 25087 | 07:58:03 INFO - PROCESS | 25087 | [#2] audio-dft Cycles:10 Average:164.50 Median:163.50 stddev:4.22 (2.6%) stddev-sans-first:4.44 07:58:03 INFO - PROCESS | 25087 | Values: 163.0 166.0 176.0 162.0 163.0 162.0 164.0 164.0 162.0 163.0 07:58:03 INFO - PROCESS | 25087 | 07:58:03 INFO - PROCESS | 25087 | [#3] audio-fft Cycles:10 Average:91.60 Median:76.00 stddev:32.11 (42.2%) stddev-sans-first:33.49 07:58:03 INFO - PROCESS | 25087 | Values: 75.0 77.0 76.0 153.0 78.0 77.0 76.0 76.0 152.0 76.0 07:58:03 INFO - PROCESS | 25087 | 07:58:03 INFO - PROCESS | 25087 | [#4] audio-oscillator Cycles:10 Average:102.70 Median:86.50 stddev:26.78 (31.0%) stddev-sans-first:27.87 07:58:03 INFO - PROCESS | 25087 | Values: 88.0 86.0 156.0 86.0 87.0 87.0 130.0 85.0 87.0 135.0 07:58:03 INFO - PROCESS | 25087 | 07:58:03 INFO - PROCESS | 25087 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.47 (0.4%) stddev-sans-first:0.33 07:58:03 INFO - PROCESS | 25087 | Values: 117.0 118.0 118.0 118.0 118.0 119.0 118.0 118.0 118.0 118.0 07:58:03 INFO - PROCESS | 25087 | 07:58:03 INFO - PROCESS | 25087 | [#6] imaging-darkroom Cycles:10 Average:148.60 Median:149.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 07:58:03 INFO - PROCESS | 25087 | Values: 149.0 149.0 149.0 149.0 149.0 149.0 148.0 148.0 147.0 149.0 07:58:03 INFO - PROCESS | 25087 | 07:58:03 INFO - PROCESS | 25087 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.83 07:58:03 INFO - PROCESS | 25087 | Values: 95.0 96.0 96.0 95.0 95.0 97.0 95.0 97.0 96.0 95.0 07:58:03 INFO - PROCESS | 25087 | 07:58:03 INFO - PROCESS | 25087 | [#8] json-parse-financial Cycles:10 Average:66.20 Median:66.00 stddev:0.92 (1.4%) stddev-sans-first:0.97 07:58:03 INFO - PROCESS | 25087 | Values: 66.0 66.0 67.0 65.0 66.0 66.0 65.0 67.0 66.0 68.0 07:58:03 INFO - PROCESS | 25087 | 07:58:03 INFO - PROCESS | 25087 | [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:65.50 stddev:0.71 (1.1%) stddev-sans-first:0.50 07:58:03 INFO - PROCESS | 25087 | Values: 67.0 65.0 65.0 66.0 66.0 66.0 65.0 65.0 65.0 65.0 07:58:03 INFO - PROCESS | 25087 | 07:58:03 INFO - PROCESS | 25087 | [#10] stanford-crypto-aes Cycles:10 Average:87.40 Median:87.50 stddev:4.70 (5.4%) stddev-sans-first:4.82 07:58:03 INFO - PROCESS | 25087 | Values: 84.0 82.0 88.0 91.0 84.0 84.0 87.0 90.0 98.0 86.0 07:58:03 INFO - PROCESS | 25087 | 07:58:03 INFO - PROCESS | 25087 | [#11] stanford-crypto-ccm Cycles:10 Average:137.60 Median:138.50 stddev:5.40 (3.9%) stddev-sans-first:5.49 07:58:03 INFO - PROCESS | 25087 | Values: 142.0 132.0 134.0 133.0 139.0 138.0 135.0 132.0 143.0 148.0 07:58:03 INFO - PROCESS | 25087 | 07:58:03 INFO - PROCESS | 25087 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.50 Median:174.00 stddev:3.06 (1.8%) stddev-sans-first:3.11 07:58:03 INFO - PROCESS | 25087 | Values: 171.0 176.0 178.0 175.0 173.0 172.0 170.0 172.0 178.0 170.0 07:58:03 INFO - PROCESS | 25087 | 07:58:03 INFO - PROCESS | 25087 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.00 stddev:1.55 (2.3%) stddev-sans-first:1.64 07:58:03 INFO - PROCESS | 25087 | Values: 68.0 70.0 69.0 68.0 68.0 71.0 66.0 68.0 66.0 68.0 07:58:03 INFO - PROCESS | 25087 | -------- Summary: end -------- 07:58:03 INFO - PROCESS | 25087 | 07:58:04 INFO - TEST-INFO | 25087: exit 0 07:58:04 INFO - TEST-OK | kraken | took 65229ms 07:58:04 INFO - SUITE-END | took 1183s 07:58:04 INFO - Completed test suite (00:19:43) 07:58:04 INFO - javascript benchmark 07:58:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6469.063827440159, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2647.774939130174, 2648.1658277642546, 2669.666291713536, 2682.10149599884, 2685.7314268573145, 4772.0, 4846.9757651211785, 4854.150523658363, 4881.5118488151165, 4916.655834091615, 4709.0, 4818.686785358949, 4834.661573689843, 4840.298156767267, 4851.1753001989655, 4383.123375324932, 4398.318260669601, 4500.21246281901, 4507.639388848885, 4509.098180363924, 245.25233029657156, 4479.328100784892, 4481.708688935225, 4524.298733696266, 4527.56988086133, 4483.641308695296, 4490.169318676056, 4491.214037543449, 4493.0, 4543.0459603483305, 4430.490493593245, 4493.752843593601, 4500.5274446183, 4508.909821803545, 4512.661550383701, 4436.401085853401, 4450.777461126931, 4455.777211139462, 4507.256302710049, 4516.18708632446, 4861.489543597907, 4868.561829435368, 4914.90170196594, 4922.187839006559, 4952.959878425499, 5121.129408000649, 5167.638265321429, 5219.164933610642, 5255.527002569787, 5275.683458992473, 5247.23915032322, 5270.314859068335, 5286.682799032071, 5291.656042357235, 5321.962217367615, 4916.213405855046, 4922.803087876517, 4925.162722337212, 4926.679765815211, 4972.57733092684, 5230.137027390514, 5349.81275655358, 5366.248725178478, 5398.91901621476, 5404.621676482609, 5141.588672906233, 5168.508991645787, 5178.559822415062, 5190.11767999441, 5195.090859099642, 5253.080710875582, 5254.13306804373, 5261.842144735664, 5267.367915850046, 5309.044372013074, 5074.188129899198, 5150.768215430315, 5150.99555586657, 5183.637145399861, 5185.844424667266, 5000.874978125503, 5086.931744333731, 5119.948800512022, 5132.640715149978, 5173.844784656466, 4443.800028998703, 4445.555444455528, 4451.955480445219, 4452.799624016862, 4491.910161796745, 3802.2775672622115, 3830.7893065881085, 3843.673287770515, 3898.5126859142606, 3903.6291552302487, 4486.865394038184, 4493.281075028045, 4497.100579884036, 4522.276435770261, 4554.180247555406, 5127.435982041972, 5235.947640523622, 5242.68543887368, 5249.370075590878, 5287.894242115136, 4474.082813023388, 4508.549145085531, 4510.481294651091, 4512.684112112186, 4535.160995215896, 4739.597134243559, 4758.78585463655, 4768.61851051915, 4775.21209000511, 4805.255185446262, 4763.976180119216, 4789.736564488987, 4913.041956818529, 4931.432885218246, 4981.975090124526, 5123.846284611468, 5199.948000519947, 5206.869828254173, 5215.895682086413, 5256.553192978639, 4845.8061677532505, 4849.248366503198, 4853.781579828846, 4854.762035680878, 4906.730129842893, 5111.64218504716, 5117.232415137759, 5159.896802064013, 5196.272521846869, 5200.245964335075, 5271.868203294948, 5273.630845840754, 5275.261463395051, 5287.074761916726, 5299.258103865539, 5138.3833939927445, 5143.71709555963, 5144.125498665161, 5147.40804807452, 5187.351581052369, 4946.777395017305, 5058.367704036996, 5071.061853557104, 5105.33630628016, 5125.154349532286, 4908.901821963612, 4923.4584195737725, 4938.975305123451, 5002.549770520671, 5048.343715316985, 5133.640645154804, 5139.691618502902, 5145.71698556568, 5152.510511501401, 5203.115470370122, 4895.755212239445, 4968.22992436173, 5004.649674522749, 5023.196288593807, 5046.293518907282], "value": 4758.83919467296, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [548.2180542052971, 571.7541457173417, 574.8361716910679, 596.3023262782542, 609.4697613076625, 31532.68467315326, 34653.0, 34687.653123468786, 34705.479417808754, 34857.825710871475, 39538.8023059885, 40306.59693403065, 40419.39370909439, 40453.19093618126, 40456.39315410264, 7730.111037230734, 7738.49699769516, 7761.2626800454145, 7828.725994590191, 7835.490693104958, 7699.846003079935, 7724.575148366837, 7761.844763104735, 7765.844683106335, 7779.416543759213, 7761.961190194041, 7791.961040194819, 7805.921940780605, 7813.257740514642, 7872.094709108468, 7760.370322232338, 7765.456418050739, 7785.026871641045, 7802.609869506502, 7810.960945195295, 7612.162662107164, 7629.961850190769, 7676.309132178131, 7705.537667739954, 7707.653155608011, 36915.63084369175, 37025.148742562764, 37248.81375593132, 37323.62676373229, 37324.8942616312, 2970.5395663672166, 3078.184281165493, 3099.8605062772003, 3431.330890476358, 3738.7943663098517, 27584.586231206547, 29746.0, 30287.394252115053, 30329.393412131856, 30371.544426833614, 3322.4684050551796, 3382.4249877520633, 3443.276911848515, 3487.581490221164, 3499.4400895856797, 252828.0, 253096.0, 253635.0, 254771.0, 255061.0, 31719.207019824687, 32623.836880815918, 54050.45949540533, 54626.72686636541, 54831.725841371335, 32373.352532949208, 32761.18097047593, 32822.34355312928, 32837.507437388456, 32875.0, 13355.732885342433, 13366.198028118344, 13503.59489215325, 13519.662008449868, 13607.0, 11232.49453774582, 11287.887121128848, 11291.887081129247, 11298.54805807775, 11390.145739069603, 7756.573388463688, 7821.843563128706, 7833.138354780969, 7868.449208555347, 7954.443188976832, 3070.1557071804987, 3114.7196752292402, 3124.875084942216, 3134.670859559759, 3177.0786471922884, 896.2292428511475, 916.3402350307767, 979.5494072726483, 982.9924327564304, 983.1201075037944, 27546.586801198, 28282.0, 28751.0, 28864.422711545652, 28946.565801512996, 949.1979277510493, 950.6150009246267, 968.6464440479315, 992.4739887859446, 1005.1205195453978, 14699.853001469848, 15017.774733379008, 15146.242687865562, 15398.615034624, 15493.07041577509, 425718.0, 429126.0, 431672.0, 434797.0, 437138.0, 49800.25299620508, 49817.501824981286, 50332.49667503278, 50347.496525035014, 50419.747901260256, 1143.9370834604176, 1165.930044197334, 1181.9468123934444, 1184.407796101949, 1184.644606618011, 26718.46563068689, 27957.0, 27978.0, 28275.57586636161, 28336.0, 43484.130317394105, 43785.56214437815, 43832.0, 43936.12127757363, 44010.33984490299, 334469.0, 335493.0, 336139.0, 337548.0, 337807.0, 24671.753282466947, 24904.0, 25000.124995625065, 25069.122580709587, 25270.49459010846, 41899.58100418957, 42048.789756051025, 42300.0, 42372.78813605912, 42528.362074568286, 37222.627773723, 37447.0, 37541.2491750158, 37556.2488750218, 37589.0, 36681.816590917944, 36689.81655091814, 37226.8138659305, 37516.62483375131, 37955.24089518249, 32160.356792863542, 35973.10067248235, 36206.27587448289, 37200.44199337066, 39174.60825391824, 31543.52684709777, 32292.19269518281, 32667.0, 32929.0, 32929.506057409635, 24991.500169996863, 25200.0, 25502.23493295204, 25861.48277034411, 25926.611100833125], "value": 16527.43056782587, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.66360611843226, 371.2778645534436, 379.04858804400965, 385.5335044596039, 389.39449156561534, 15626.453074142408, 16544.751828722565, 16655.08397038164, 17105.0, 17158.742618860728, 15833.208339583003, 16126.596835079099, 16654.417095401663, 16706.665866682688, 16746.0, 5021.1213037718435, 5199.766010529516, 5235.293235413209, 5238.423773384925, 5240.213967904807, 3795.7722536647752, 5129.487051294878, 5808.273965754281, 6244.625322480643, 6249.125122482856, 6144.539159563028, 6237.220347456568, 6290.276618188898, 6292.968535157318, 6300.8109756707145, 6287.968560157193, 6304.0, 6304.590201636879, 6313.273973493038, 6321.209848768904, 5362.65142765719, 5482.205080263379, 5513.61404701671, 5515.227868098469, 5518.951399234133, 20403.285884994104, 20461.28385506515, 20953.161873525194, 21752.782472175393, 21778.673319900216, 2021.3632705697657, 2209.5470428562107, 2230.141395562704, 2320.825938054653, 2483.540544999181, 13205.86794132056, 13223.33883305831, 13344.199348039148, 13379.732405351935, 13851.792223116661, 1640.450449099553, 1721.7331313646405, 1733.03816381908, 1733.2633630707026, 1745.2233755978596, 67919.32080679179, 68626.0, 69748.30251697519, 70380.99999999949, 71877.0, 9810.607575696893, 9836.852447213298, 10013.0, 10022.3485473444, 10194.796104077877, 13577.864221357857, 13694.520691775939, 13766.0, 13771.449142034407, 13950.581482555539, 7325.816854578678, 7351.8162045949275, 7474.476786624993, 7488.588127652923, 7591.962040189764, 7051.788446346618, 7084.610346430995, 7116.64416779159, 7247.4926755126635, 7262.055932728711, 6242.812715618538, 6362.172917520693, 6408.55140140195, 6441.291457939623, 6449.226092868886, 1666.2668425892568, 1722.3885520639992, 1802.7825774297687, 1812.0758413209358, 1883.369071361082, 808.567416432206, 910.41733290694, 920.0201785098849, 942.0202988891476, 981.4307701533094, 17986.280548778162, 18121.912685238665, 18215.72676409855, 18333.0, 18350.357737479124, 875.7591662292921, 882.8190221004679, 887.4852585500395, 915.514777168102, 935.8034812689275, 9982.80034399308, 10307.330023548595, 10362.844557331646, 10429.843552346721, 10578.365298082139, 399379.0, 403002.0, 425193.0, 426039.0, 427378.0, 73252.0, 73934.0, 74945.0, 76368.0, 77112.61443692746, 899.9055099214619, 932.4778124250306, 947.7156852944089, 950.8716323296267, 956.3592393096503, 13774.793378099135, 14498.710025799213, 15868.0, 16231.837681623032, 16278.267477963283, 31988.20029499281, 33679.32641347208, 36221.91655204106, 38251.0, 38739.225215496095, 53305.733471332394, 54397.0, 54695.72652136714, 55296.44703552913, 56906.0, 7632.8855067175145, 7680.5391676499585, 7769.378449724121, 7910.644021018953, 7935.563544005136, 8395.622197001028, 10528.631497897537, 11569.7107572308, 11610.24533405326, 11645.126615503701, 9889.50552472359, 9934.45360505179, 10068.597256109966, 10208.387496750218, 10263.486825658836, 9746.853797192905, 10357.223208259562, 10439.895601044196, 10490.31812932157, 10535.947320263349, 9927.354721943051, 10167.18662506983, 10288.897111029093, 10327.741806454598, 10705.518251678537, 7177.246389129066, 7235.167955685163, 7459.738909138371, 7653.732119375795, 7753.612319383896, 9977.401355918668, 9977.800443990935, 10001.2999090063, 10120.493975301059, 10452.529636166542], "value": 8557.707239083811, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1365.1263191557405, 1397.2594524901801, 1458.1907041591912, 1661.2939500712193, 1674.4474323473255, 6750.763723269686, 7475.0, 7534.095908490989, 8040.316573091287, 8058.677652893884, 7570.0, 7762.767116986485, 7798.883016754753, 7899.0, 7926.9207307927045, 2175.695402643631, 2217.5121473275935, 2221.522372689871, 2224.065892325227, 2230.710007699005, 2148.387709502792, 2152.817010554105, 2186.5408264264524, 2187.3437968609433, 2192.8136108430804, 2146.1308170191096, 2212.889355532225, 2214.402111429913, 2225.6995305633695, 2233.8212942964524, 2126.7873212678765, 2127.914883404662, 2136.69017992391, 2137.1665050630113, 2144.9249276275254, 2099.7060411542243, 2134.9466263343543, 2140.807327340531, 2141.0365335599045, 2141.3361857824125, 7901.644426000844, 7903.3282171015535, 7977.641006154737, 7982.32150267228, 7994.920050799476, 4444.177827101997, 4632.467266264355, 4647.279671650899, 4649.279361698942, 4651.581357677791, 2875.2811797050736, 2941.1176647005814, 2990.177701132184, 3009.5335223040465, 3012.653544842349, 929.7489677786959, 934.4673536084434, 947.161761840769, 960.4669408478292, 969.0406497567428, 10551.683449496528, 10631.149508039338, 10638.57445702171, 10647.946760266226, 10698.518566664441, 4149.481314835645, 4217.957820421818, 4268.103698223408, 4297.72064815786, 4298.075913678574, 9146.542672866462, 9176.31177661678, 9236.214921731593, 9245.214156796614, 9270.675526356545, 4720.433547974265, 4792.9281060784115, 4794.7842347094465, 4809.158397280462, 4829.5653391194965, 3641.5083963665097, 4192.4759405074365, 4323.200207961474, 4389.231884420214, 4406.0, 3682.226732386175, 3690.391085470921, 3744.1014156602764, 3776.0, 3800.1639639279315, 1204.566356111799, 1210.5883999440232, 1211.8000529912642, 1226.2213494430923, 1227.9324637145044, 678.396227357652, 684.9383555480031, 795.5783434779576, 797.7048492057976, 808.3815880851154, 4759.857204283877, 5216.869578260574, 5246.501582349671, 5320.467953204648, 5387.380451248078, 411.1920077048614, 415.634241867161, 422.5225495190415, 423.11568821163917, 427.2885645400373, 3338.198832280284, 3502.2120022994623, 3503.3168532135987, 3514.876979305712, 3537.3102245061964, 9275.304352173614, 9579.089986451276, 9606.615735370508, 9670.516474176264, 9676.225901927828, 9584.137427631407, 9599.0, 9610.038996100335, 9622.807543849223, 9644.855327170098, 6934.618595977269, 7171.318724721247, 7209.855802883913, 7280.490365674458, 7315.634218289064, 5378.623496355218, 5460.099083651312, 5479.424660410599, 5510.641808282448, 5571.164325351229, 9043.68347107848, 9049.230815380766, 9054.502002389932, 9081.863772043556, 9117.635294588408, 8522.829543409222, 8910.0, 8967.730968070968, 9037.09629037091, 9215.815683686154, 6110.450059494667, 6543.934560654523, 6646.202455705346, 6779.796606101825, 6833.760818371333, 7587.317141457295, 7609.353204977418, 7614.390848732199, 7633.503822251536, 7633.69465221385, 6668.566543174678, 6901.654917254217, 6905.75829845953, 6951.721931122698, 6989.231184569591, 6566.868662626625, 6572.507061970276, 6712.899306510309, 6716.630585317855, 6938.930610693828, 5611.438856114356, 5851.063829787214, 5928.466438020599, 5930.377310382348, 5934.139549765174, 4202.66378689698, 4348.9130217396105, 4395.164918665443, 4416.845410410749, 4456.086502267092, 4526.796294166837, 4530.818767249273, 4531.750753708578, 4569.977150114228, 4574.954250457453], "value": 4053.1001881219736, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.38647998642807, 301.82644979136995, 301.91395452296075, 302.52654595557965, 305.8577761340976, 5049.747512624368, 5098.923516147261, 5106.183010718286, 5125.513076257759, 5135.460776618457, 5025.472325405825, 5035.169197082477, 5036.722980236085, 5056.115179843522, 5060.0, 3691.612380700035, 3824.4836947012213, 3957.861474848381, 3964.9207015859665, 3965.4250133730593, 3967.3255546557157, 3972.7616343019367, 3983.9203215935663, 3998.4402183694306, 4017.8593749218785, 3977.701672374569, 3984.9402258965993, 3989.122393073519, 3994.4208089826957, 3996.2007598480277, 3674.2100448403453, 3871.0, 3872.5159355080614, 3979.0262172284642, 4014.7390419622775, 3329.9833500832583, 3354.2117602363423, 3357.244619960489, 3357.345317663057, 3361.3781450431748, 4939.901201975977, 4953.653244272902, 4960.528749768766, 4960.578350840183, 4973.7421988597525, 4243.872683819491, 4444.31113177458, 4478.731276123443, 4483.887902802456, 4487.6634252431195, 5230.110881150214, 5293.206019097128, 5295.7881684732565, 5309.973450132763, 5325.760340784674, 3669.3395188865993, 3671.0822294426393, 3674.595794462607, 3700.4634328022285, 3705.0181701849033, 5407.53917492801, 5526.171074338841, 5530.308711411074, 5541.168824676291, 5565.499105080522, 3754.7934863582764, 3765.8305376258136, 3777.320082385197, 3780.5085338906315, 3781.6596506314563, 3773.660370566662, 3789.389509458469, 3817.61823817616, 3826.7895265760094, 3838.443425703313, 4426.845060422934, 4446.044100518404, 4449.399331090326, 4466.816293682177, 4474.440694913136, 5108.0, 5310.92033619496, 5319.7340132993195, 5325.707086110224, 5357.866053348697, 1335.2922950836073, 1348.312360696052, 1352.4387379237703, 1356.6743981444579, 1364.3110229334122, 833.358314098141, 840.932725381968, 859.2481578618708, 866.1987661413168, 883.7437143228392, 4521.276595744665, 4522.525134860793, 4541.9545804542195, 4542.136993971135, 4544.840930567414, 5359.0, 5415.48552887475, 5428.185772134211, 5432.75552600134, 5462.617616766867, 4341.60925516705, 4583.931241031387, 4585.81656733727, 4585.839495617704, 4593.242115050979, 2910.4761142994466, 2933.82397056173, 2935.33954860159, 2936.7503762180027, 2971.777116716255, 5172.663776854492, 5196.402413722395, 5202.81790137351, 5208.0, 5222.451642577475, 5491.7254137292975, 5588.329400471969, 5696.0, 5723.7996670116345, 5748.338941021752, 5146.125158723026, 5153.768080436389, 5160.922586161286, 5166.535011848877, 5177.378714554277, 5472.972635136799, 5497.202905578749, 5507.779688812563, 5521.861953451196, 5546.500814926676, 5276.34045744282, 5414.431484694208, 5423.376311724202, 5431.6740995540395, 5468.91796623059, 5105.412877519133, 5131.92302115476, 5133.614978876524, 5156.767945442389, 5167.819126330561, 3844.3272427325664, 3853.788041657736, 3858.0, 3870.632289932452, 3880.1463677990796, 5413.702246376487, 5531.695756733257, 5547.8890422190525, 5554.722263886871, 5566.526845218202, 5363.517283444353, 5368.141097424394, 5389.490942536097, 5397.8110766123, 5402.75687594067, 5027.773750181177, 5269.262303277621, 5319.574434045345, 5325.387580428145, 5366.731663416892, 5293.973530132324, 5307.7611507483025, 5310.707911064928, 5312.548433383051, 5353.78584856617, 5145.710158979218, 5237.607179461479, 5427.6472029317965, 5431.0801226663125, 5447.727613619382, 5230.581553475637, 5299.258103865539, 5300.70846103468, 5309.36287645485, 5323.0], "value": 3981.1825269405895, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [612.9080637904311, 649.1042361541073, 705.3933617089306, 719.8200449887528, 741.2476336518433, 12471.127021108527, 13276.867231327684, 13300.401481933312, 13322.800157997637, 13355.599332020054, 12550.0, 13651.726965460684, 14256.144631322128, 14282.214478203694, 15001.399944002254, 622.1321256846719, 771.3327971304809, 787.9369650427981, 797.7048492057946, 799.848028874512, 783.7296132834192, 788.4914230321439, 790.7864876483346, 794.2613369566301, 794.6582969323189, 838.8490071787076, 838.9203025712548, 839.3411172229801, 839.5424493650975, 841.6338892581716, 821.5850995247391, 823.0, 824.1428913929536, 831.1439217605875, 832.5961908474385, 607.3562024254304, 608.6165715599188, 608.6469847488446, 608.7564974010431, 610.8961476548953, 14057.0, 14255.501057463043, 14296.142231466145, 14382.640433989129, 14394.424223031067, 13253.939684825287, 13382.531611393651, 13673.726525469534, 13729.176249424967, 13754.724905501835, 10921.344719316867, 11016.228863979524, 11041.779164416666, 11175.944120279346, 11638.243514171552, 3322.069820450278, 3380.2732412531423, 3400.0649821299094, 3417.3848707232687, 3502.176988407722, 70346.0, 70840.0, 71285.64357178233, 72067.63966180188, 72711.63644181799, 9838.75403114928, 9989.60041598328, 9995.200383969264, 10031.097201251923, 10135.9493202535, 19632.705509417083, 19761.308354207533, 19882.0, 19883.403497895088, 19911.60176796485, 6891.3797758202, 6930.410915072275, 6989.790306290718, 7025.192102908129, 7127.643617819088, 3726.2733766915735, 3860.343741563941, 3899.3566061600086, 3917.177392747498, 3948.822302996372, 3020.426119037376, 3133.529970504397, 3134.044116544476, 3155.3689262147664, 3159.636641786224, 505.3026822984258, 551.5367091643039, 563.9154126880919, 583.2243116654839, 585.8242527241811, 582.4554041970771, 622.2626187967182, 631.7504585688719, 645.9741610335534, 652.8759535688204, 7969.800754981172, 8341.95829020851, 8501.829963400822, 8594.87107693385, 8808.5595720215, 519.5246349590158, 525.1859617592715, 588.5879884081161, 639.3318981664172, 640.414021170633, 3799.848006079781, 3925.7055720821054, 3979.422983667352, 4015.13674559971, 4106.137711080706, 61675.074873876925, 92002.53998730097, 101905.49047254716, 108044.0, 108450.45774771234, 94549.5272523633, 95877.0, 96048.51975740076, 96418.51790741141, 96639.0, 76201.0, 77477.0, 79381.60309198417, 81724.59137704273, 81848.18151818524, 7555.433342499445, 7556.395488360808, 7586.924130758843, 7800.102988156435, 7835.177306382976, 46396.0, 47620.28569571528, 47749.522504774504, 47812.28281575849, 48293.275600865316, 54845.0, 55735.44264557303, 55969.0, 63729.36270637234, 64349.0, 11565.190436669352, 11645.708857278636, 11695.12286578527, 11887.821682674594, 12279.508819647113, 12336.444859981502, 12891.162074465505, 12932.0066170225, 13013.219206847241, 13326.33368331599, 11512.19414640967, 11733.882661173278, 12032.27806331623, 12389.0, 12481.687957801129, 12144.39278036077, 12156.0, 12175.573854915036, 12321.199122057038, 12574.434150463434, 11149.72125696864, 11239.67926325793, 11383.829242561535, 11499.367534785668, 11807.645770626552, 9277.582508786985, 9469.242460603273, 9474.763130921507, 9742.95128524353, 10173.389596624227, 9566.66516671913, 9570.377925434825, 9613.711588652352, 9643.0, 9670.178034867115], "value": 6747.444505648059, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1586.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 107.0, 114.0, 118.0, 115.0, 115.0, 112.0, 113.0, 113.0], "value": 112.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 132.0, 156.0, 178.0, 134.0, 159.0, 160.0, 133.0, 185.0, 133.0], "value": 154.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 166.0, 176.0, 162.0, 163.0, 162.0, 164.0, 164.0, 162.0, 163.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 153.0, 78.0, 77.0, 76.0, 76.0, 152.0, 76.0], "value": 91.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 156.0, 86.0, 87.0, 87.0, 130.0, 85.0, 87.0, 135.0], "value": 102.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 118.0, 118.0, 119.0, 118.0, 118.0, 118.0, 118.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 149.0, 149.0, 149.0, 149.0, 148.0, 148.0, 147.0, 149.0], "value": 148.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 95.0, 97.0, 95.0, 97.0, 96.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 65.0, 66.0, 66.0, 65.0, 67.0, 66.0, 68.0], "value": 66.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 65.0, 66.0, 66.0, 66.0, 65.0, 65.0, 65.0, 65.0], "value": 65.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 88.0, 91.0, 84.0, 84.0, 87.0, 90.0, 98.0, 86.0], "value": 87.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 132.0, 134.0, 133.0, 139.0, 138.0, 135.0, 132.0, 143.0, 148.0], "value": 137.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 176.0, 178.0, 175.0, 173.0, 172.0, 170.0, 172.0, 178.0, 170.0], "value": 173.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 69.0, 68.0, 68.0, 71.0, 66.0, 68.0, 66.0, 68.0], "value": 68.2, "unit": "score"}]}]} 07:58:04 INFO - Return code: 0 07:58:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:58:04 ERROR - # TBPL SUCCESS # 07:58:04 INFO - Running post-action listener: _resource_record_post_action 07:58:04 INFO - ##### 07:58:04 INFO - ##### Finished run-tests step (success) 07:58:04 INFO - ##### 07:58:04 INFO - Running post-run listener: _resource_record_post_run 07:58:04 INFO - Total resource usage - Wall time: 1201s; CPU: 14.0%; Read bytes: 4096; Write bytes: 545083392; Read time: 4; Write time: 1208636 07:58:04 INFO - TinderboxPrint: CPU usage
13.5% 07:58:04 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 07:58:04 INFO - TinderboxPrint: I/O write bytes / time
545,083,392 / 1,208,636 07:58:04 INFO - TinderboxPrint: CPU idle
8,283.4 (86.5%) 07:58:04 INFO - TinderboxPrint: CPU user
1,232.7 (12.9%) 07:58:04 INFO - TinderboxPrint: Swap in / out
0 / 0 07:58:04 INFO - install - Wall time: 16s; CPU: 17.0%; Read bytes: 0; Write bytes: 252456960; Read time: 0; Write time: 753788 07:58:04 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292040704; Read time: 4; Write time: 454840 07:58:04 INFO - Running post-run listener: _upload_blobber_files 07:58:04 INFO - Blob upload gear active. 07:58:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:58:04 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 07:58:04 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'] 07:58:04 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 07:58:05 INFO - (blobuploader) - INFO - Open directory for files ... 07:58:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:58:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:58:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:58:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:58:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:58:10 INFO - (blobuploader) - INFO - Done attempting. 07:58:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:58:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:58:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:58:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:58:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:58:11 INFO - (blobuploader) - INFO - Done attempting. 07:58:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:58:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:58:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:58:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:58:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:58:12 INFO - (blobuploader) - INFO - Done attempting. 07:58:12 INFO - (blobuploader) - INFO - Iteration through files over. 07:58:12 INFO - Return code: 0 07:58:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:58:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:58:12 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e25ca494bd3f401cc2fa3a02c6b98e593a24bb00dc6f640b797211eabbbbc159a1e41a44a4dcda10960168a6b73dd9819a89419c33aae2de12b4b6e89e31c655", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a96df7ac0e57d8e34f0c4f03a9eb92a52ffc9c0bff38ce81786929a9007a7dae4b32ae0fa37c53dab94b4ce5bf0bbf8c53c3357008438bf62ee65236ff2fed7b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fcb3db628650f8eeaa76b96bc5dbacf08bbccbafac6ef7aa65e2928c8d09d92842e053f96b753b024449a9462584720f139fb184200a58cc02226d1de1509d95"} 07:58:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:58:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:58:12 INFO - Contents: 07:58:12 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e25ca494bd3f401cc2fa3a02c6b98e593a24bb00dc6f640b797211eabbbbc159a1e41a44a4dcda10960168a6b73dd9819a89419c33aae2de12b4b6e89e31c655", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a96df7ac0e57d8e34f0c4f03a9eb92a52ffc9c0bff38ce81786929a9007a7dae4b32ae0fa37c53dab94b4ce5bf0bbf8c53c3357008438bf62ee65236ff2fed7b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fcb3db628650f8eeaa76b96bc5dbacf08bbccbafac6ef7aa65e2928c8d09d92842e053f96b753b024449a9462584720f139fb184200a58cc02226d1de1509d95"} 07:58:12 INFO - Running post-run listener: copy_logs_to_upload_dir 07:58:12 INFO - Copying logs to upload dir... 07:58:12 INFO - mkdir: /builds/slave/test/build/upload/logs 07:58:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.808742 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-23 07:58:11.668232) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 07:58:11.671400) ========= 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=af724c981e2a0f424dbabf99000001e7-1466692646.264076-367915751 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e25ca494bd3f401cc2fa3a02c6b98e593a24bb00dc6f640b797211eabbbbc159a1e41a44a4dcda10960168a6b73dd9819a89419c33aae2de12b4b6e89e31c655", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a96df7ac0e57d8e34f0c4f03a9eb92a52ffc9c0bff38ce81786929a9007a7dae4b32ae0fa37c53dab94b4ce5bf0bbf8c53c3357008438bf62ee65236ff2fed7b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fcb3db628650f8eeaa76b96bc5dbacf08bbccbafac6ef7aa65e2928c8d09d92842e053f96b753b024449a9462584720f139fb184200a58cc02226d1de1509d95"} build_url:https://queue.taskcluster.net/v1/task/XWDgoZ6mRki9zqJ56B5nvA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011176 build_url: 'https://queue.taskcluster.net/v1/task/XWDgoZ6mRki9zqJ56B5nvA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e25ca494bd3f401cc2fa3a02c6b98e593a24bb00dc6f640b797211eabbbbc159a1e41a44a4dcda10960168a6b73dd9819a89419c33aae2de12b4b6e89e31c655", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a96df7ac0e57d8e34f0c4f03a9eb92a52ffc9c0bff38ce81786929a9007a7dae4b32ae0fa37c53dab94b4ce5bf0bbf8c53c3357008438bf62ee65236ff2fed7b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fcb3db628650f8eeaa76b96bc5dbacf08bbccbafac6ef7aa65e2928c8d09d92842e053f96b753b024449a9462584720f139fb184200a58cc02226d1de1509d95"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 07:58:11.696392) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 07:58:11.696674) ========= 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=af724c981e2a0f424dbabf99000001e7-1466692646.264076-367915751 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004488 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 07:58:11.779940) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 07:58:11.780260) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 07:58:11.780569) ========= ========= Total master_lag: 0.17 =========