builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-041 starttime: 1467281280.9 results: success (0) buildid: 20160630003226 builduid: ea3b36b686a74662b30483ebfd5d3643 revision: 64c1a1a17a6db5e81b8be2605acbfc3dd2f1e101 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 03:08:00.896343) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 03:08:00.896824) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 03:08:00.897109) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 03:08:00.941196) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 03:08:00.941450) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1467279608.536344-1779553719 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-30 03:08:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 88.7M=0s 2016-06-30 03:08:01 (88.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.131393 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 03:08:01.087042) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 03:08:01.087361) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1467279608.536344-1779553719 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016496 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 03:08:01.139131) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 03:08:01.139484) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 64c1a1a17a6db5e81b8be2605acbfc3dd2f1e101 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 64c1a1a17a6db5e81b8be2605acbfc3dd2f1e101 --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=8c6b6742ce8f6f39ef4ce27d000001f1-1467279608.536344-1779553719 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-30 03:08:01,542 truncating revision to first 12 chars 2016-06-30 03:08:01,542 Setting DEBUG logging. 2016-06-30 03:08:01,542 attempt 1/10 2016-06-30 03:08:01,542 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/64c1a1a17a6d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-30 03:08:01,881 unpacking tar archive at: mozilla-aurora-64c1a1a17a6d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.694400 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 03:08:01.848431) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 03:08:01.848791) ========= script_repo_revision: 64c1a1a17a6db5e81b8be2605acbfc3dd2f1e101 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 03:08:01.849212) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 03:08:01.849482) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 03:08:01.860571) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-06-30 03:08:01.860983) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=8c6b6742ce8f6f39ef4ce27d000001f1-1467279608.536344-1779553719 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:08:02 INFO - MultiFileLogger online at 20160630 03:08:02 in /builds/slave/test 03:08:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:08:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:08:02 INFO - {'append_to_log': False, 03:08:02 INFO - 'base_work_dir': '/builds/slave/test', 03:08:02 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:08:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:08:02 INFO - 'branch': 'Mozilla-Aurora', 03:08:02 INFO - 'buildbot_json_path': 'buildprops.json', 03:08:02 INFO - 'config_files': ('talos/linux_config.py',), 03:08:02 INFO - 'default_actions': ('clobber', 03:08:02 INFO - 'read-buildbot-config', 03:08:02 INFO - 'download-and-extract', 03:08:02 INFO - 'populate-webroot', 03:08:02 INFO - 'create-virtualenv', 03:08:02 INFO - 'install', 03:08:02 INFO - 'run-tests'), 03:08:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:08:02 INFO - 'download_minidump_stackwalk': True, 03:08:02 INFO - 'download_symbols': 'ondemand', 03:08:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:08:02 INFO - 'tooltool.py': '/tools/tooltool.py', 03:08:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:08:02 INFO - '/tools/misc-python/virtualenv.py')}, 03:08:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:08:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:08:02 INFO - 'installer_path': 'installer.exe', 03:08:02 INFO - 'log_level': 'info', 03:08:02 INFO - 'log_name': 'talos', 03:08:02 INFO - 'log_to_console': True, 03:08:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:08:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:08:02 INFO - 'opt_config_files': (), 03:08:02 INFO - 'pip_index': False, 03:08:02 INFO - 'sps_profile': False, 03:08:02 INFO - 'sps_profile_interval': 0, 03:08:02 INFO - 'suite': 'dromaeojs-e10s', 03:08:02 INFO - 'system_bits': '32', 03:08:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:08:02 INFO - 'title': 'talos-linux64-ix-041', 03:08:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:08:02 INFO - 'use_talos_json': True, 03:08:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:08:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:08:02 INFO - 'work_dir': 'build'} 03:08:02 INFO - ##### 03:08:02 INFO - ##### Running clobber step. 03:08:02 INFO - ##### 03:08:02 INFO - Running pre-action listener: _resource_record_pre_action 03:08:02 INFO - Running main action method: clobber 03:08:02 INFO - rmtree: /builds/slave/test/build 03:08:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:08:03 INFO - Running post-action listener: _resource_record_post_action 03:08:03 INFO - ##### 03:08:03 INFO - ##### Finished clobber step (success) 03:08:03 INFO - ##### 03:08:03 INFO - ##### 03:08:03 INFO - ##### Running read-buildbot-config step. 03:08:03 INFO - ##### 03:08:03 INFO - Running pre-action listener: _resource_record_pre_action 03:08:03 INFO - Running main action method: read_buildbot_config 03:08:03 INFO - Using buildbot properties: 03:08:03 INFO - { 03:08:03 INFO - "project": "", 03:08:03 INFO - "product": "firefox", 03:08:03 INFO - "script_repo_revision": "production", 03:08:03 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:08:03 INFO - "repository": "", 03:08:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:08:03 INFO - "buildid": "20160630003226", 03:08:03 INFO - "pgo_build": "True", 03:08:03 INFO - "basedir": "/builds/slave/test", 03:08:03 INFO - "buildnumber": 383, 03:08:03 INFO - "slavename": "talos-linux64-ix-041", 03:08:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:08:03 INFO - "platform": "ubuntu64_hw", 03:08:03 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:08:03 INFO - "branch": "mozilla-aurora", 03:08:03 INFO - "repo_path": "releases/mozilla-aurora", 03:08:03 INFO - "revision": "64c1a1a17a6db5e81b8be2605acbfc3dd2f1e101", 03:08:03 INFO - "stage_platform": "linux64-pgo", 03:08:03 INFO - "builduid": "ea3b36b686a74662b30483ebfd5d3643", 03:08:03 INFO - "slavebuilddir": "test" 03:08:03 INFO - } 03:08:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/GQHYwunHQ52FW7sPI4yVEQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 03:08:03 INFO - Running post-action listener: _resource_record_post_action 03:08:03 INFO - ##### 03:08:03 INFO - ##### Finished read-buildbot-config step (success) 03:08:03 INFO - ##### 03:08:03 INFO - ##### 03:08:03 INFO - ##### Running download-and-extract step. 03:08:03 INFO - ##### 03:08:03 INFO - Running pre-action listener: _resource_record_pre_action 03:08:03 INFO - Running main action method: download_and_extract 03:08:03 INFO - mkdir: /builds/slave/test/build/tests 03:08:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:03 INFO - https://queue.taskcluster.net/v1/task/GQHYwunHQ52FW7sPI4yVEQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:08:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GQHYwunHQ52FW7sPI4yVEQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:08:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GQHYwunHQ52FW7sPI4yVEQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:08:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GQHYwunHQ52FW7sPI4yVEQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:08:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GQHYwunHQ52FW7sPI4yVEQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:08:08 INFO - Downloaded 1361 bytes. 03:08:08 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:08:08 INFO - Using the following test package requirements: 03:08:08 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:08:08 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:08:08 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:08:08 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:08:08 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:08:08 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:08:08 INFO - u'jsshell-linux-x86_64.zip'], 03:08:08 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:08:08 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:08:08 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:08:08 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:08:08 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:08:08 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:08:08 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:08:08 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:08:08 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:08:08 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:08:08 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:08:08 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:08:08 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')]} 03:08:08 INFO - https://queue.taskcluster.net/v1/task/GQHYwunHQ52FW7sPI4yVEQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:08:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GQHYwunHQ52FW7sPI4yVEQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:08:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GQHYwunHQ52FW7sPI4yVEQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:08:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GQHYwunHQ52FW7sPI4yVEQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:08:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GQHYwunHQ52FW7sPI4yVEQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:08:09 INFO - Downloaded 24524456 bytes. 03:08:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:08:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:08:10 INFO - Return code: 0 03:08:10 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:08:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:10 INFO - https://queue.taskcluster.net/v1/task/GQHYwunHQ52FW7sPI4yVEQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:08:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GQHYwunHQ52FW7sPI4yVEQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:08:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GQHYwunHQ52FW7sPI4yVEQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:08:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GQHYwunHQ52FW7sPI4yVEQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:08:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GQHYwunHQ52FW7sPI4yVEQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:08:17 INFO - Downloaded 24524456 bytes. 03:08:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:08:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:08:19 INFO - Return code: 0 03:08: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')]} 03:08:19 INFO - https://queue.taskcluster.net/v1/task/GQHYwunHQ52FW7sPI4yVEQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:08:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GQHYwunHQ52FW7sPI4yVEQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:08:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GQHYwunHQ52FW7sPI4yVEQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:08:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GQHYwunHQ52FW7sPI4yVEQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:08:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GQHYwunHQ52FW7sPI4yVEQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:08:20 INFO - Downloaded 10833369 bytes. 03:08:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:08:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:08:20 INFO - Return code: 0 03:08:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:20 INFO - https://queue.taskcluster.net/v1/task/GQHYwunHQ52FW7sPI4yVEQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:08:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GQHYwunHQ52FW7sPI4yVEQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:08:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GQHYwunHQ52FW7sPI4yVEQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:08:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GQHYwunHQ52FW7sPI4yVEQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:08:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GQHYwunHQ52FW7sPI4yVEQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:08:22 INFO - Downloaded 63619057 bytes. 03:08:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GQHYwunHQ52FW7sPI4yVEQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:08:22 INFO - mkdir: /builds/slave/test/properties 03:08:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:08:22 INFO - Writing to file /builds/slave/test/properties/build_url 03:08:22 INFO - Contents: 03:08:22 INFO - build_url:https://queue.taskcluster.net/v1/task/GQHYwunHQ52FW7sPI4yVEQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:08:23 INFO - Running post-action listener: _resource_record_post_action 03:08:23 INFO - Running post-action listener: set_extra_try_arguments 03:08:23 INFO - ##### 03:08:23 INFO - ##### Finished download-and-extract step (success) 03:08:23 INFO - ##### 03:08:23 INFO - ##### 03:08:23 INFO - ##### Running populate-webroot step. 03:08:23 INFO - ##### 03:08:23 INFO - Running pre-action listener: _resource_record_pre_action 03:08:23 INFO - Running main action method: populate_webroot 03:08:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:08:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:08:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:08:23 INFO - '--tppagecycles', 03:08:23 INFO - '7'], 03:08:23 INFO - 'tests': ['tsvgm']}}, 03:08:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:08:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:08:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:08:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:08:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:08:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:08:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:23 INFO - 'talos_options': ['--disable-e10s'], 03:08:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:08:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:08:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:23 INFO - 'talos_options': ['--disable-e10s'], 03:08:23 INFO - 'tests': ['damp', 'tps']}, 03:08:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:23 INFO - 'tests': ['damp', 'tps']}, 03:08:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:08:23 INFO - 'tests': ['dromaeo_dom']}, 03:08:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:08:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:08:23 INFO - 'tests': ['a11yr', 03:08:23 INFO - 'ts_paint', 03:08:23 INFO - 'tpaint', 03:08:23 INFO - 'sessionrestore', 03:08:23 INFO - 'sessionrestore_no_auto_restore', 03:08:23 INFO - 'tabpaint']}, 03:08:23 INFO - 'other-e10s': {'tests': ['a11yr', 03:08:23 INFO - 'ts_paint', 03:08:23 INFO - 'tpaint', 03:08:23 INFO - 'sessionrestore', 03:08:23 INFO - 'sessionrestore_no_auto_restore', 03:08:23 INFO - 'tabpaint']}, 03:08:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:08:23 INFO - 'ts_paint', 03:08:23 INFO - 'tpaint', 03:08:23 INFO - 'sessionrestore', 03:08:23 INFO - 'sessionrestore_no_auto_restore', 03:08:23 INFO - 'tabpaint']}, 03:08:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:08:23 INFO - 'ts_paint', 03:08:23 INFO - 'tpaint', 03:08:23 INFO - 'sessionrestore', 03:08:23 INFO - 'sessionrestore_no_auto_restore', 03:08:23 INFO - 'tabpaint']}, 03:08:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:08:23 INFO - 'tests': ['a11yr', 03:08:23 INFO - 'ts_paint', 03:08:23 INFO - 'tpaint', 03:08:23 INFO - 'sessionrestore', 03:08:23 INFO - 'sessionrestore_no_auto_restore', 03:08:23 INFO - 'tabpaint']}, 03:08:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:08:23 INFO - 'tests': ['a11yr', 03:08:23 INFO - 'ts_paint', 03:08:23 INFO - 'tpaint', 03:08:23 INFO - 'sessionrestore', 03:08:23 INFO - 'sessionrestore_no_auto_restore', 03:08:23 INFO - 'tabpaint']}, 03:08:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:08:23 INFO - 'tests': ['tsvgx', 03:08:23 INFO - 'tsvgr_opacity', 03:08:23 INFO - 'tart', 03:08:23 INFO - 'tscrollx', 03:08:23 INFO - 'cart']}, 03:08:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:08:23 INFO - 'tsvgr_opacity', 03:08:23 INFO - 'tart', 03:08:23 INFO - 'tscrollx', 03:08:23 INFO - 'cart']}, 03:08:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:23 INFO - 'talos_options': ['--disable-e10s'], 03:08:23 INFO - 'tests': ['tp5o']}, 03:08:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:23 INFO - 'tests': ['tp5o']}, 03:08:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:23 INFO - 'talos_options': ['--disable-e10s', 03:08:23 INFO - '--xperf_path', 03:08:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:08:23 INFO - 'tests': ['tp5n']}, 03:08:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:08:23 INFO - 'talos_options': ['--xperf_path', 03:08:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:08:23 INFO - 'tests': ['tp5n']}}, 03:08:23 INFO - 'talos.zip': {'path': '', 03:08:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:08:23 INFO - Running post-action listener: _resource_record_post_action 03:08:23 INFO - ##### 03:08:23 INFO - ##### Finished populate-webroot step (success) 03:08:23 INFO - ##### 03:08:23 INFO - ##### 03:08:23 INFO - ##### Running create-virtualenv step. 03:08:23 INFO - ##### 03:08:23 INFO - Running pre-action listener: _resource_record_pre_action 03:08:23 INFO - Running main action method: create_virtualenv 03:08:23 INFO - Creating virtualenv /builds/slave/test/build/venv 03:08:23 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 03:08:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:08:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:08:23 INFO - Using real prefix '/usr' 03:08:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:08:24 INFO - Installing distribute.............................................................................................................................................................................................done. 03:08:26 INFO - Installing pip.................done. 03:08:26 INFO - Return code: 0 03:08:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:08:26 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')]} 03:08:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:26 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')]} 03:08:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:26 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 0x7f7175256f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b49350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd81c0>, '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 0x2bd90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd9550>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1467279608.536344-1779553719', '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 03:08:26 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 03:08:26 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 03:08:26 INFO - Using env: {'DISPLAY': ':0', 03:08:26 INFO - 'HOME': '/home/cltbld', 03:08:26 INFO - 'LANG': 'en_US.UTF-8', 03:08:26 INFO - 'LANGUAGE': 'en_US:en', 03:08:26 INFO - 'LOGNAME': 'cltbld', 03:08:26 INFO - 'MAIL': '/var/mail/cltbld', 03:08:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:26 INFO - 'MOZ_NO_REMOTE': '1', 03:08:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:08:26 INFO - 'NO_EM_RESTART': '1', 03:08:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:08:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:08:26 INFO - 'PWD': '/builds/slave/test', 03:08:26 INFO - 'SHELL': '/bin/bash', 03:08:26 INFO - 'SHLVL': '1', 03:08:26 INFO - 'TERM': 'linux', 03:08:26 INFO - 'TMOUT': '86400', 03:08:26 INFO - 'USER': 'cltbld', 03:08:26 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467279608.536344-1779553719', 03:08:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:26 INFO - '_': '/tools/buildbot/bin/python'} 03:08:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:26 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 03:08:26 INFO - Cleaning up... 03:08:26 INFO - Return code: 0 03:08:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:08:26 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')]} 03:08:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:26 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')]} 03:08:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:26 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 0x7f7175256f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b49350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd81c0>, '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 0x2bd90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd9550>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1467279608.536344-1779553719', '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 03:08:26 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 03:08:26 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 03:08:26 INFO - Using env: {'DISPLAY': ':0', 03:08:26 INFO - 'HOME': '/home/cltbld', 03:08:26 INFO - 'LANG': 'en_US.UTF-8', 03:08:26 INFO - 'LANGUAGE': 'en_US:en', 03:08:26 INFO - 'LOGNAME': 'cltbld', 03:08:26 INFO - 'MAIL': '/var/mail/cltbld', 03:08:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:26 INFO - 'MOZ_NO_REMOTE': '1', 03:08:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:08:26 INFO - 'NO_EM_RESTART': '1', 03:08:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:08:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:08:26 INFO - 'PWD': '/builds/slave/test', 03:08:26 INFO - 'SHELL': '/bin/bash', 03:08:26 INFO - 'SHLVL': '1', 03:08:26 INFO - 'TERM': 'linux', 03:08:26 INFO - 'TMOUT': '86400', 03:08:26 INFO - 'USER': 'cltbld', 03:08:26 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467279608.536344-1779553719', 03:08:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:26 INFO - '_': '/tools/buildbot/bin/python'} 03:08:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:26 INFO - Downloading/unpacking psutil>=3.1.1 03:08:26 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 03:08:26 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 03:08:26 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 03:08:26 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 03:08:26 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 03:08:26 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 03:08:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:08:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:08:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:08:28 INFO - Installing collected packages: psutil 03:08:28 INFO - Running setup.py install for psutil 03:08:28 INFO - building 'psutil._psutil_linux' extension 03:08:28 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 03:08:28 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 03:08:28 INFO - building 'psutil._psutil_posix' extension 03:08:28 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 03:08:28 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 03:08:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:08:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:08:29 INFO - Successfully installed psutil 03:08:29 INFO - Cleaning up... 03:08:29 INFO - Return code: 0 03:08:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:08: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')]} 03:08:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08: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')]} 03:08:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:29 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 0x7f7175256f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b49350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd81c0>, '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 0x2bd90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd9550>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1467279608.536344-1779553719', '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 03:08:29 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 03:08:29 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 03:08:29 INFO - Using env: {'DISPLAY': ':0', 03:08:29 INFO - 'HOME': '/home/cltbld', 03:08:29 INFO - 'LANG': 'en_US.UTF-8', 03:08:29 INFO - 'LANGUAGE': 'en_US:en', 03:08:29 INFO - 'LOGNAME': 'cltbld', 03:08:29 INFO - 'MAIL': '/var/mail/cltbld', 03:08:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:29 INFO - 'MOZ_NO_REMOTE': '1', 03:08:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:08:29 INFO - 'NO_EM_RESTART': '1', 03:08:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:08:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:08:29 INFO - 'PWD': '/builds/slave/test', 03:08:29 INFO - 'SHELL': '/bin/bash', 03:08:29 INFO - 'SHLVL': '1', 03:08:29 INFO - 'TERM': 'linux', 03:08:29 INFO - 'TMOUT': '86400', 03:08:29 INFO - 'USER': 'cltbld', 03:08:29 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467279608.536344-1779553719', 03:08:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:29 INFO - '_': '/tools/buildbot/bin/python'} 03:08:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:08:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:08:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:08:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:08:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:08:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:08:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:08:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:08:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:08:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:08:31 INFO - Installing collected packages: mozsystemmonitor 03:08:31 INFO - Running setup.py install for mozsystemmonitor 03:08:31 INFO - Successfully installed mozsystemmonitor 03:08:31 INFO - Cleaning up... 03:08:31 INFO - Return code: 0 03:08:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:08:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7175256f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b49350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd81c0>, '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 0x2bd90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd9550>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1467279608.536344-1779553719', '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 03:08:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:08:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:08:31 INFO - Using env: {'DISPLAY': ':0', 03:08:31 INFO - 'HOME': '/home/cltbld', 03:08:31 INFO - 'LANG': 'en_US.UTF-8', 03:08:31 INFO - 'LANGUAGE': 'en_US:en', 03:08:31 INFO - 'LOGNAME': 'cltbld', 03:08:31 INFO - 'MAIL': '/var/mail/cltbld', 03:08:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:31 INFO - 'MOZ_NO_REMOTE': '1', 03:08:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:08:31 INFO - 'NO_EM_RESTART': '1', 03:08:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:08:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:08:31 INFO - 'PWD': '/builds/slave/test', 03:08:31 INFO - 'SHELL': '/bin/bash', 03:08:31 INFO - 'SHLVL': '1', 03:08:31 INFO - 'TERM': 'linux', 03:08:31 INFO - 'TMOUT': '86400', 03:08:31 INFO - 'USER': 'cltbld', 03:08:31 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467279608.536344-1779553719', 03:08:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:31 INFO - '_': '/tools/buildbot/bin/python'} 03:08:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:31 INFO - Downloading/unpacking jsonschema==2.5.1 03:08:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:08:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:08:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:08:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:08:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:08:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:08:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:08:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:08:33 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 03:08:33 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 03:08:33 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 03:08:33 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 03:08:33 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 03:08:33 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 03:08:33 INFO - Downloading functools32-3.2.3-2.tar.gz 03:08:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:08:33 INFO - warning: no files found matching '*.txt' 03:08:33 INFO - no previously-included directories found matching 'build' 03:08:33 INFO - no previously-included directories found matching 'dist' 03:08:33 INFO - no previously-included directories found matching '.git*' 03:08:33 INFO - Installing collected packages: jsonschema, functools32 03:08:33 INFO - Running setup.py install for functools32 03:08:33 INFO - warning: no files found matching '*.txt' 03:08:33 INFO - no previously-included directories found matching 'build' 03:08:33 INFO - no previously-included directories found matching 'dist' 03:08:33 INFO - no previously-included directories found matching '.git*' 03:08:33 INFO - Successfully installed jsonschema functools32 03:08:33 INFO - Cleaning up... 03:08:34 INFO - Return code: 0 03:08:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:08:34 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')]} 03:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:34 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')]} 03:08:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:34 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 0x7f7175256f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b49350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd81c0>, '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 0x2bd90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd9550>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1467279608.536344-1779553719', '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 03:08:34 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 03:08:34 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 03:08:34 INFO - Using env: {'DISPLAY': ':0', 03:08:34 INFO - 'HOME': '/home/cltbld', 03:08:34 INFO - 'LANG': 'en_US.UTF-8', 03:08:34 INFO - 'LANGUAGE': 'en_US:en', 03:08:34 INFO - 'LOGNAME': 'cltbld', 03:08:34 INFO - 'MAIL': '/var/mail/cltbld', 03:08:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:34 INFO - 'MOZ_NO_REMOTE': '1', 03:08:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:08:34 INFO - 'NO_EM_RESTART': '1', 03:08:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:08:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:08:34 INFO - 'PWD': '/builds/slave/test', 03:08:34 INFO - 'SHELL': '/bin/bash', 03:08:34 INFO - 'SHLVL': '1', 03:08:34 INFO - 'TERM': 'linux', 03:08:34 INFO - 'TMOUT': '86400', 03:08:34 INFO - 'USER': 'cltbld', 03:08:34 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467279608.536344-1779553719', 03:08:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:34 INFO - '_': '/tools/buildbot/bin/python'} 03:08:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:34 INFO - Downloading/unpacking blobuploader==1.2.4 03:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:08:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:08:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:08:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:08:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:08:36 INFO - Downloading blobuploader-1.2.4.tar.gz 03:08:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:08:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:08:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:08:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:08:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:08:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:08:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:08:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:08:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:08:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:08:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:08:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:08:36 INFO - Downloading docopt-0.6.1.tar.gz 03:08:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:08:36 INFO - Installing collected packages: blobuploader, requests, docopt 03:08:36 INFO - Running setup.py install for blobuploader 03:08:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:08:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:08:36 INFO - Running setup.py install for requests 03:08:37 INFO - Running setup.py install for docopt 03:08:37 INFO - Successfully installed blobuploader requests docopt 03:08:37 INFO - Cleaning up... 03:08:37 INFO - Return code: 0 03:08:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:08:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7175256f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b49350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd81c0>, '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 0x2bd90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd9550>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1467279608.536344-1779553719', '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 03:08:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:08:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:08:37 INFO - Using env: {'DISPLAY': ':0', 03:08:37 INFO - 'HOME': '/home/cltbld', 03:08:37 INFO - 'LANG': 'en_US.UTF-8', 03:08:37 INFO - 'LANGUAGE': 'en_US:en', 03:08:37 INFO - 'LOGNAME': 'cltbld', 03:08:37 INFO - 'MAIL': '/var/mail/cltbld', 03:08:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:37 INFO - 'MOZ_NO_REMOTE': '1', 03:08:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:08:37 INFO - 'NO_EM_RESTART': '1', 03:08:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:08:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:08:37 INFO - 'PWD': '/builds/slave/test', 03:08:37 INFO - 'SHELL': '/bin/bash', 03:08:37 INFO - 'SHLVL': '1', 03:08:37 INFO - 'TERM': 'linux', 03:08:37 INFO - 'TMOUT': '86400', 03:08:37 INFO - 'USER': 'cltbld', 03:08:37 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467279608.536344-1779553719', 03:08:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:37 INFO - '_': '/tools/buildbot/bin/python'} 03:08:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:08:37 INFO - Running setup.py (path:/tmp/pip-kPPy3C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:08:37 INFO - Running setup.py (path:/tmp/pip-yJZ40u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:08:37 INFO - Running setup.py (path:/tmp/pip-bKcDGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:08:37 INFO - Running setup.py (path:/tmp/pip-es52lR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:08:37 INFO - Running setup.py (path:/tmp/pip-D4Zti9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:08:38 INFO - Running setup.py (path:/tmp/pip-5E4KTs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:08:38 INFO - Running setup.py (path:/tmp/pip-0s68IU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:08:38 INFO - Running setup.py (path:/tmp/pip-5Y73qE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:08:38 INFO - Running setup.py (path:/tmp/pip-20yzx0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:08:38 INFO - Running setup.py (path:/tmp/pip-7_W5mg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:08:38 INFO - Running setup.py (path:/tmp/pip-DoLSdK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:08:38 INFO - Running setup.py (path:/tmp/pip-hacgdE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:08:38 INFO - Running setup.py (path:/tmp/pip-BoOk7O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:08:38 INFO - Running setup.py (path:/tmp/pip-rV76ps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:08:38 INFO - Running setup.py (path:/tmp/pip-mEiRKc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:08:38 INFO - Running setup.py (path:/tmp/pip-AbJAVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:08:38 INFO - Running setup.py (path:/tmp/pip-no34CZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:08:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:08:38 INFO - Running setup.py install for manifestparser 03:08:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:08:39 INFO - Running setup.py install for mozcrash 03:08:39 INFO - Running setup.py install for mozdebug 03:08:39 INFO - Running setup.py install for mozdevice 03:08:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:08:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:08:39 INFO - Running setup.py install for mozfile 03:08:39 INFO - Running setup.py install for mozhttpd 03:08:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:08:39 INFO - Running setup.py install for mozinfo 03:08:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:08:39 INFO - Running setup.py install for mozInstall 03:08:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:08:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:08:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:08:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:08:39 INFO - Running setup.py install for mozleak 03:08:39 INFO - Running setup.py install for mozlog 03:08:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:08:39 INFO - Running setup.py install for moznetwork 03:08:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:08:40 INFO - Running setup.py install for mozprocess 03:08:40 INFO - Running setup.py install for mozprofile 03:08:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:08:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:08:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:08:40 INFO - Running setup.py install for mozrunner 03:08:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:08:40 INFO - Running setup.py install for mozscreenshot 03:08:40 INFO - Running setup.py install for moztest 03:08:40 INFO - Running setup.py install for mozversion 03:08:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:08:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:08:40 INFO - Cleaning up... 03:08:40 INFO - Return code: 0 03:08:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:08:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:08:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7175256f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b49350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd81c0>, '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 0x2bd90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd9550>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1467279608.536344-1779553719', '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 03:08:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:08:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:08:40 INFO - Using env: {'DISPLAY': ':0', 03:08:40 INFO - 'HOME': '/home/cltbld', 03:08:40 INFO - 'LANG': 'en_US.UTF-8', 03:08:40 INFO - 'LANGUAGE': 'en_US:en', 03:08:40 INFO - 'LOGNAME': 'cltbld', 03:08:40 INFO - 'MAIL': '/var/mail/cltbld', 03:08:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:40 INFO - 'MOZ_NO_REMOTE': '1', 03:08:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:08:40 INFO - 'NO_EM_RESTART': '1', 03:08:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:08:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:08:40 INFO - 'PWD': '/builds/slave/test', 03:08:40 INFO - 'SHELL': '/bin/bash', 03:08:40 INFO - 'SHLVL': '1', 03:08:40 INFO - 'TERM': 'linux', 03:08:40 INFO - 'TMOUT': '86400', 03:08:40 INFO - 'USER': 'cltbld', 03:08:40 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467279608.536344-1779553719', 03:08:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:40 INFO - '_': '/tools/buildbot/bin/python'} 03:08:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:08:40 INFO - Running setup.py (path:/tmp/pip-x3Efm1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:08:40 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:08:40 INFO - Running setup.py (path:/tmp/pip-9T21r3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:08:41 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)) 03:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:08:41 INFO - Running setup.py (path:/tmp/pip-imieUI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:08:41 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)) 03:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:08:41 INFO - Running setup.py (path:/tmp/pip-sFsRUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:08:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:08:41 INFO - Running setup.py (path:/tmp/pip-Z1eVZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:08:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:08:41 INFO - Running setup.py (path:/tmp/pip-PfwlQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:08:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:08:41 INFO - Running setup.py (path:/tmp/pip-qUSEAm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:08:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:08:41 INFO - Running setup.py (path:/tmp/pip-iztVnz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:08:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:08:41 INFO - Running setup.py (path:/tmp/pip-507dIA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:08:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:08:41 INFO - Running setup.py (path:/tmp/pip-mYFYiH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:08:41 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)) 03:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:08:41 INFO - Running setup.py (path:/tmp/pip-Vy4CaO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:08:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:08:41 INFO - Running setup.py (path:/tmp/pip-hGA7gE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:08:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:08:41 INFO - Running setup.py (path:/tmp/pip-7jLKYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:08:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:08:41 INFO - Running setup.py (path:/tmp/pip-79BnNM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:08:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:08:41 INFO - Running setup.py (path:/tmp/pip-YQq347-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:08:42 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)) 03:08:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:08:42 INFO - Running setup.py (path:/tmp/pip-967rM7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:08:42 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)) 03:08:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:08:42 INFO - Running setup.py (path:/tmp/pip-sV9kxo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:08:42 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)) 03:08:42 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)) 03:08:42 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)) 03:08:42 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)) 03:08:42 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)) 03:08:42 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)) 03:08:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:08:42 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 03:08:42 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 03:08:42 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 03:08:42 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 03:08:42 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 03:08:42 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 03:08:44 INFO - Downloading blessings-1.6.tar.gz 03:08:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:08:44 INFO - Installing collected packages: blessings 03:08:44 INFO - Running setup.py install for blessings 03:08:44 INFO - Successfully installed blessings 03:08:44 INFO - Cleaning up... 03:08:44 INFO - Return code: 0 03:08:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:08:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:08:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:08:44 INFO - Reading from file tmpfile_stdout 03:08:44 INFO - Current package versions: 03:08:44 INFO - argparse == 1.2.1 03:08:44 INFO - blessings == 1.6 03:08:44 INFO - blobuploader == 1.2.4 03:08:44 INFO - docopt == 0.6.1 03:08:44 INFO - functools32 == 3.2.3-2 03:08:44 INFO - jsonschema == 2.5.1 03:08:44 INFO - manifestparser == 1.1 03:08:44 INFO - mozInstall == 1.12 03:08:44 INFO - mozcrash == 0.17 03:08:44 INFO - mozdebug == 0.1 03:08:44 INFO - mozdevice == 0.48 03:08:44 INFO - mozfile == 1.2 03:08:44 INFO - mozhttpd == 0.7 03:08:44 INFO - mozinfo == 0.9 03:08:44 INFO - mozleak == 0.1 03:08:44 INFO - mozlog == 3.2 03:08:44 INFO - moznetwork == 0.27 03:08:44 INFO - mozprocess == 0.22 03:08:44 INFO - mozprofile == 0.28 03:08:44 INFO - mozrunner == 6.11 03:08:44 INFO - mozscreenshot == 0.1 03:08:44 INFO - mozsystemmonitor == 0.3 03:08:44 INFO - moztest == 0.7 03:08:44 INFO - mozversion == 1.4 03:08:44 INFO - psutil == 3.1.1 03:08:44 INFO - requests == 1.2.3 03:08:44 INFO - wsgiref == 0.1.2 03:08:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:08: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')]} 03:08:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08: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')]} 03:08:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7175256f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b49350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd81c0>, '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 0x2bd90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd9550>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1467279608.536344-1779553719', '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 03:08:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:08:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:08:44 INFO - Using env: {'DISPLAY': ':0', 03:08:44 INFO - 'HOME': '/home/cltbld', 03:08:44 INFO - 'LANG': 'en_US.UTF-8', 03:08:44 INFO - 'LANGUAGE': 'en_US:en', 03:08:44 INFO - 'LOGNAME': 'cltbld', 03:08:44 INFO - 'MAIL': '/var/mail/cltbld', 03:08:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:44 INFO - 'MOZ_NO_REMOTE': '1', 03:08:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:08:44 INFO - 'NO_EM_RESTART': '1', 03:08:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:08:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:08:44 INFO - 'PWD': '/builds/slave/test', 03:08:44 INFO - 'SHELL': '/bin/bash', 03:08:44 INFO - 'SHLVL': '1', 03:08:44 INFO - 'TERM': 'linux', 03:08:44 INFO - 'TMOUT': '86400', 03:08:44 INFO - 'USER': 'cltbld', 03:08:44 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467279608.536344-1779553719', 03:08:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:44 INFO - '_': '/tools/buildbot/bin/python'} 03:08:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:08:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:08:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:08:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:08:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:08:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:08:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:08:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:08:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:08:44 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:08:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:08:44 INFO - Cleaning up... 03:08:44 INFO - Return code: 0 03:08:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:08: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')]} 03:08:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08: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')]} 03:08:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7175256f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b49350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd81c0>, '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 0x2bd90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd9550>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1467279608.536344-1779553719', '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 03:08:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:08:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:08:44 INFO - Using env: {'DISPLAY': ':0', 03:08:44 INFO - 'HOME': '/home/cltbld', 03:08:44 INFO - 'LANG': 'en_US.UTF-8', 03:08:44 INFO - 'LANGUAGE': 'en_US:en', 03:08:44 INFO - 'LOGNAME': 'cltbld', 03:08:44 INFO - 'MAIL': '/var/mail/cltbld', 03:08:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:44 INFO - 'MOZ_NO_REMOTE': '1', 03:08:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:08:44 INFO - 'NO_EM_RESTART': '1', 03:08:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:08:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:08:44 INFO - 'PWD': '/builds/slave/test', 03:08:44 INFO - 'SHELL': '/bin/bash', 03:08:44 INFO - 'SHLVL': '1', 03:08:44 INFO - 'TERM': 'linux', 03:08:44 INFO - 'TMOUT': '86400', 03:08:44 INFO - 'USER': 'cltbld', 03:08:44 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467279608.536344-1779553719', 03:08:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:44 INFO - '_': '/tools/buildbot/bin/python'} 03:08:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:08:44 INFO - Cleaning up... 03:08:44 INFO - Return code: 0 03:08:44 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:08: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')]} 03:08:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:08:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08: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')]} 03:08:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:08:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:08: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7175256f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a7e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b49350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd81c0>, '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 0x2bd90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd9550>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1467279608.536344-1779553719', '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 03:08: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', 'flake8'] in /builds/slave/test/build 03:08: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 flake8 03:08:44 INFO - Using env: {'DISPLAY': ':0', 03:08:44 INFO - 'HOME': '/home/cltbld', 03:08:44 INFO - 'LANG': 'en_US.UTF-8', 03:08:44 INFO - 'LANGUAGE': 'en_US:en', 03:08:44 INFO - 'LOGNAME': 'cltbld', 03:08:44 INFO - 'MAIL': '/var/mail/cltbld', 03:08:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:08:44 INFO - 'MOZ_NO_REMOTE': '1', 03:08:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:08:44 INFO - 'NO_EM_RESTART': '1', 03:08:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:08:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:08:44 INFO - 'PWD': '/builds/slave/test', 03:08:44 INFO - 'SHELL': '/bin/bash', 03:08:44 INFO - 'SHLVL': '1', 03:08:44 INFO - 'TERM': 'linux', 03:08:44 INFO - 'TMOUT': '86400', 03:08:44 INFO - 'USER': 'cltbld', 03:08:44 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467279608.536344-1779553719', 03:08:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:08:44 INFO - '_': '/tools/buildbot/bin/python'} 03:08:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:08:45 INFO - Downloading/unpacking flake8 03:08:45 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 03:08:45 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 03:08:45 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 03:08:45 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 03:08:45 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 03:08:45 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 03:08:47 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:08:47 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:08:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:08:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:08:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:08:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:08:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:08:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:08:47 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:08:47 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:08:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:08:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:08:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:08:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:08:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:08:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:08:47 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:08:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:08:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:08:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:08:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:08:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:08:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:08:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:08:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:08:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:08:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:08:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:08:47 INFO - no previously-included directories found matching 'docs/_build' 03:08:47 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:08:47 INFO - Running setup.py install for pep8 03:08:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:08:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:08:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:08:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:08:47 INFO - no previously-included directories found matching 'docs/_build' 03:08:47 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:08:47 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:08:47 INFO - Cleaning up... 03:08:48 INFO - Return code: 0 03:08:48 INFO - Running post-action listener: _resource_record_post_action 03:08:48 INFO - Running post-action listener: _start_resource_monitoring 03:08:48 INFO - Starting resource monitoring. 03:08:48 INFO - ##### 03:08:48 INFO - ##### Finished create-virtualenv step (success) 03:08:48 INFO - ##### 03:08:48 INFO - ##### 03:08:48 INFO - ##### Running install step. 03:08:48 INFO - ##### 03:08:48 INFO - Running pre-action listener: _resource_record_pre_action 03:08:48 INFO - Running main action method: install 03:08:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:08:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:08:48 INFO - Reading from file tmpfile_stdout 03:08:48 INFO - Detecting whether we're running mozinstall >=1.0... 03:08:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:08:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:08:48 INFO - Reading from file tmpfile_stdout 03:08:48 INFO - Output received: 03:08:48 INFO - Usage: mozinstall [options] installer 03:08:48 INFO - Options: 03:08:48 INFO - -h, --help show this help message and exit 03:08:48 INFO - -d DEST, --destination=DEST 03:08:48 INFO - Directory to install application into. [default: 03:08:48 INFO - "/builds/slave/test"] 03:08:48 INFO - --app=APP Application being installed. [default: firefox] 03:08:48 INFO - mkdir: /builds/slave/test/build/application 03:08:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:08:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:09:04 INFO - Reading from file tmpfile_stdout 03:09:04 INFO - Output received: 03:09:04 INFO - /builds/slave/test/build/application/firefox/firefox 03:09:04 INFO - Running post-action listener: _resource_record_post_action 03:09:04 INFO - ##### 03:09:04 INFO - ##### Finished install step (success) 03:09:04 INFO - ##### 03:09:04 INFO - ##### 03:09:04 INFO - ##### Running run-tests step. 03:09:04 INFO - ##### 03:09:04 INFO - Running pre-action listener: _resource_record_pre_action 03:09:04 INFO - Running main action method: run_tests 03:09:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:09:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:09:04 INFO - Python 2.7.3 03:09:04 INFO - Return code: 0 03:09:04 INFO - grabbing minidump binary from tooltool 03:09:04 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')]} 03:09:04 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 0x2bd81c0>, '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 0x2bd90c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd9550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:09:04 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 03:09:04 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 03:09:04 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 03:09:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:09:04 INFO - Return code: 0 03:09:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:09:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:09:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:09:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:09:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:09:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:09:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:09:05 INFO - Return code: 0 03:09:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GQHYwunHQ52FW7sPI4yVEQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 03:09:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GQHYwunHQ52FW7sPI4yVEQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --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 03:09:05 INFO - Using env: {'DISPLAY': ':0', 03:09:05 INFO - 'HOME': '/home/cltbld', 03:09:05 INFO - 'LANG': 'en_US.UTF-8', 03:09:05 INFO - 'LANGUAGE': 'en_US:en', 03:09:05 INFO - 'LOGNAME': 'cltbld', 03:09:05 INFO - 'MAIL': '/var/mail/cltbld', 03:09:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:09:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:09:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:09:05 INFO - 'MOZ_NO_REMOTE': '1', 03:09:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:09:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:09:05 INFO - 'NO_EM_RESTART': '1', 03:09:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:09:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:09:05 INFO - 'PWD': '/builds/slave/test', 03:09:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:09:05 INFO - 'SHELL': '/bin/bash', 03:09:05 INFO - 'SHLVL': '1', 03:09:05 INFO - 'TERM': 'linux', 03:09:05 INFO - 'TMOUT': '86400', 03:09:05 INFO - 'USER': 'cltbld', 03:09:05 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1467279608.536344-1779553719', 03:09:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:09:05 INFO - '_': '/tools/buildbot/bin/python'} 03:09:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GQHYwunHQ52FW7sPI4yVEQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 03:09:05 INFO - mozversion application_buildid: 20160630003226 03:09:05 INFO - mozversion application_changeset: 64c1a1a17a6db5e81b8be2605acbfc3dd2f1e101 03:09:05 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:09:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:09:05 INFO - mozversion application_name: Firefox 03:09:05 INFO - mozversion application_remotingname: firefox-dev 03:09:05 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:09:05 INFO - mozversion application_vendor: Mozilla 03:09:05 INFO - mozversion application_version: 49.0a2 03:09:05 INFO - mozversion platform_buildid: 20160630003226 03:09:05 INFO - mozversion platform_changeset: 64c1a1a17a6db5e81b8be2605acbfc3dd2f1e101 03:09:05 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:09:05 INFO - mozversion platform_version: 49.0a2 03:09:05 INFO - using testdate: 1467281345 03:09:05 INFO - actual date: 1467281345 03:09:05 INFO - starting webserver on 'localhost:36459' 03:09:05 INFO - SUITE-START | Running 2 tests 03:09:05 INFO - TEST-START | dromaeo_css 03:09:05 INFO - operating with platform_type : linux_ 03:09:05 INFO - Initialising browser for dromaeo_css test... 03:09:05 INFO - TEST-INFO | started process 18373 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppetXBi/profile http://localhost:36459/getInfo.html) 03:09:10 INFO - PROCESS | 18373 | __metrics Screen width/height:1600/1200 03:09:10 INFO - PROCESS | 18373 | colorDepth:24 03:09:10 INFO - PROCESS | 18373 | Browser inner width/height: 1024/697 03:09:10 INFO - PROCESS | 18373 | __metrics 03:09:11 ERROR - PROCESS | 18373 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 03:09:11 INFO - TEST-INFO | 18373: exit 0 03:09:11 INFO - Browser initialized. 03:09:11 INFO - Running cycle 1/1 for dromaeo_css test... 03:09:11 INFO - TEST-INFO | started process 18502 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppetXBi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:09:23 INFO - PROCESS | 18502 | RSS: Main: 155860992 03:09:23 INFO - PROCESS | 18502 | 03:10:13 INFO - PROCESS | 18502 | 1467281413306 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] 03:12:21 INFO - PROCESS | 18502 | Cycle 1(1): loaded http://localhost:36459/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36459/tests/dromaeo/cssquery-ext.html) 03:12:22 INFO - PROCESS | 18502 | RSS: Main: 159666176 03:12:22 INFO - PROCESS | 18502 | 03:15:24 INFO - PROCESS | 18502 | Cycle 1(1): loaded http://localhost:36459/tests/dromaeo/cssquery-ext.html (next: http://localhost:36459/tests/dromaeo/cssquery-jquery.html) 03:15:25 INFO - PROCESS | 18502 | RSS: Main: 157011968 03:15:25 INFO - PROCESS | 18502 | 03:18:26 INFO - PROCESS | 18502 | Cycle 1(1): loaded http://localhost:36459/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36459/tests/dromaeo/cssquery-mootools.html) 03:18:27 INFO - PROCESS | 18502 | RSS: Main: 157450240 03:18:27 INFO - PROCESS | 18502 | 03:21:29 INFO - PROCESS | 18502 | Cycle 1(1): loaded http://localhost:36459/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36459/tests/dromaeo/cssquery-prototype.html) 03:21:29 INFO - PROCESS | 18502 | RSS: Main: 155922432 03:21:29 INFO - PROCESS | 18502 | 03:24:32 INFO - PROCESS | 18502 | Cycle 1(1): loaded http://localhost:36459/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36459/tests/dromaeo/cssquery-yui.html) 03:24:32 INFO - PROCESS | 18502 | RSS: Main: 157966336 03:24:32 INFO - PROCESS | 18502 | 03:27:35 INFO - PROCESS | 18502 | Cycle 1(1): loaded http://localhost:36459/tests/dromaeo/cssquery-yui.html (next: http://localhost:36459/tests/dromaeo/cssquery-dojo.html) 03:27:35 INFO - PROCESS | 18502 | RSS: Main: 158535680 03:27:35 INFO - PROCESS | 18502 | 03:27:35 INFO - PROCESS | 18502 | __start_tp_report 03:27:35 INFO - PROCESS | 18502 | _x_x_mozilla_page_load 03:27:35 INFO - PROCESS | 18502 | _x_x_mozilla_page_load_details 03:27:35 INFO - PROCESS | 18502 | |i|pagename|runs| 03:27:35 INFO - PROCESS | 18502 | |0;dojo.html;3433.4849772534126;3467.913302167447;3491.7555771096036;3492.388831954407;3494.3186078714643;5772.769089236431;5802.825915222539;5809.506191973682;5817.825465236049;5841.912371314434;5789.710514474281;5851.444112809277;5855.063189889618;5866.941330586693;5868.970655146729;5211.5309622134;5302.734863256841;5306.840794776143;5341.572674186075;5363.141897296433;5223.216517522383;5235.895282094375;5332.173513105456;5375.865603359908;5376.4085950545405;5282.656627319231;5288.497592728685;5293.311869456965;5305.310309659739;5354.892902141954;5343.358796944372;5356.089464790975;5356.6518176318805;5374.596905232084;5383.488568585978;5069.188929771219;5161.509656582619;5195.792168313301;5262.631615786897;5263.02634012705;5691.743871525791;5714.257146570919;5716.657000579979;5723.914141287884;5740.8851822963725;6215.098810672473;6225.750969961241;6238.220222472191;6262.718177682015;6275.592086514408;6099.390060993909;6185.907211391833;6209.658468784215;6252.030935205051;6281.214848143982;5873.500752436048;5882.705864706748;5883.794067207627;5885.9117113243765;5902.468777810018;6356.269029061625;6396.744130234739;6409.743610255631;6415.13395691585;6466.838329041718;6015.4586087252355;6072.210612620331;6115.027386288435;6131.049687298476;6180.165677633552;6224.221972253468;6247.937520624827;6274.058891166362;6284.811455656338;6299.0866324382705;6082.330943596201;6195.876082478325;6269.592476489013;6271.560990730696;6280.623162610258;6123.5876691309595;6127.647695152957;6138.48821116479;6266.905996410058;6278.811635650938;4746.02706445178;4761.761911904391;4766.666333356701;4772.832950846704;4778.522147785194;4135.503739551273;4137.648299894482;4217.198732240864;4234.576542345741;4258.74447533149;5815.883682326415;5862.501687356537;5913.793017244376;5928.081147422156;5974.133750606138;6230.657313847782;6235.158253635792;6276.905846412307;6306.274778400542;6319.3364696706185;5748.913766293509;5811.0411782056335;5957.1362152487645;5968.1644569760265;6007.789727359609;5265.894682106336;5269.868253293622;5285.867853303621;5326.334208223972;5346.4118946915805;6467.676616169173;6476.287608363076;6476.6114033158165;6485.4811615070685;6507.934920650733;6148.569600127948;6253.437190652863;6267.373262673696;6313;6357.8728425432155;6436;6549.541532092708;6556.311587283458;6571;6597.340265973365;6259.280182779039;6268.341824108403;6273.090401891792;6300.054991751274;6303.275123360689;6027.035674292268;6107.389261073857;6145.525073982123;6369.713362898588;6385.265694445198;6096.420840020191;6132.480767309457;6159.599626024294;6181.690915454299;6190.969045154746;6091.274202250048;6109.3890610940325;6146.692665366624;6165.136880836776;6169.475594574332;5846.473817356458;5890.087036509348;5931.08068249422;5953.880922381441;6109.633421994695;6059.727312271047;6086.087086936995;6128.417800308964;6136.32500424944;6145.201123853871;5990.041593345044;5996.8500787478915;5997.190379298739;5999.580029398075;6000 03:27:35 INFO - PROCESS | 18502 | |1;ext.html;599.2808629644428;635.3678090300152;652.6214795418657;654.9541532092755;657.7204688007598;50578.494215057835;52363;52442;52575.737121314385;52611.210831837554;47990.520094799125;48022.759886200605;48440.75779621106;48785.51214487854;48794.512054879444;9203.677871274507;9240.353175277733;9290.210332121778;9341.53292335384;9368.484733339697;9147.771305717344;9167.220786233145;9169.587368568396;9181.586828592695;9193.724188274362;9211.170994610484;9285.164335209829;9297.581608827586;9298.256139508823;9343.71968840936;9207.631694732236;9240.815183696355;9249.075092490732;9258.67594634188;9266.305027122926;9117.08829117083;9193.862092068624;9194.17252447283;9197.77005574866;9198.908010919871;46459.535404646194;46985.295220571716;46987.76506117482;46993;47109.76445117787;3694.2796154749835;3730.850765969358;3758.3798673218885;3933;4210.705250632457;33631.83184084088;34527.82736086303;35093.29813403718;35325.47011794825;35405.82297088498;4681.204195286809;4765.380500534909;4791.640626952958;4831.830885918976;4841.830535931261;396469.0176549128;398373;400481;401768;402755;37657.05857353588;61856;62626.37373626297;62657.68671156615;62659;38948.805255974105;40512.18975620471;40531.79734101311;40656.59343406587;40711.592884071375;16210;16256;16335.918320408322;16386.590335241715;16422.1788910554;13362.465501380031;13402.597922062354;13444.731105377838;13450.192988420726;13465.124766890121;9151.771205719777;9173.174414302612;9214.677486287948;9260.444373337621;9343.532823358804;3459.3773120837986;3523.1544429336773;3563.2873425315042;3621.80080095592;3629.383004889175;1097.6816723150198;1104.5416152296707;1113.7939481196004;1160.9071274298035;1185.343216178083;34006.149846253546;34137.146571335914;34218.82890585531;34284;34551.4817277736;1164.7903377392151;1193.3019183777415;1198.7362780188344;1213.660175150959;1258.5343422933572;16915.661686766194;17913.37303194382;17951.102444877703;17985;18208.45374638763;577749;628972;640201;646630;648579;56629;61938.69030654818;62529.374706253264;62567.6871615639;62705.05942410776;1501.6696326808085;1522.695460907823;1531.9923400382704;1537.9461718840012;1538.8230353509489;31428.685713142575;32177.839110804296;32595.674043259263;32663;32976;52032;52511.21233181429;52643.47356526539;52749;52891;412978;415598;415974;416158;416526.91736542335;29209.85395073011;29964.250893727833;30166.698333017266;30295.545566816956;52433.95132097413;53835.73082134564;53871.191932120266;56904.71547642235;58066.129008065756;58332.4166758327;46390.76804615955;48570.271445929044;48945.75527122342;49236;49254.507454926425;46331.53668463272;47183.52816471929;47622.28566571573;47742.283865741345;47922;47416.52583474121;47487.52512474831;48179;48239.75880120577;48662.513374867216;40222.79888600538;40359.59640403558;41294.58705412907;41377.1724565513;42040.579594203664;31047.84476077605;32047.198820029687;32062.6793732069;32139.839300803345;32352.676473234966 03:27:35 INFO - PROCESS | 18502 | |2;jquery.html;433.737588758801;435.9025163463443;436.13862621322886;436.46197362337983;448.6231565484992;19183.13675884585;20383.388498345073;20767.792322076795;21431.14275428981;21501.56996860062;19703.605927881435;20030.198792048337;20872.89563552184;20873.269435569757;20942.790572094276;5853.707314634262;6025.186599809013;6056.818295451144;6063.393660633923;6077.209962704842;5464.672119672812;5752.050911599581;5758.884822303551;5873.148393482942;5954.987652099154;5553.888922221553;5785.450382213683;5832.241808564881;6089.78685745999;6091.208142941434;6022.518198544106;6027.367126451725;6088.786892458787;6110.266767987848;6118.388161183891;5704.629199102045;5843.590948633555;5855.882882342372;5858.589898707092;5872.647641141545;14290.857091429161;14625.78061329081;16252.75620865688;24055.398615034588;24186.879065604735;2149.7850214978534;2226.4879077812193;2431.58663027284;2451.6077427611676;2481.994349608041;10745.570177192903;10869.510872010778;10947.233693641449;11048.889511104946;11106.888931110747;1969.5962327722782;2053.5071582820015;2062.7730949595534;2071.85497015209;2086.040421406155;83610;87691.56154219188;89593;89708.99999999935;90565.54717226437;10616.628418005334;10713.303635263683;10859.565617375216;11651.59219427316;11890.28658280506;16616.58458538522;16720.41478548245;16745.497635070966;16786.58033549171;16807.663846722997;8427.831443371098;8433.018240713427;8560.529170895661;8721.694740684046;8804.823903521894;8107.554084525408;8131.390145739093;8290.419670622998;8309.335253179852;8509.787255318543;4870.707757534559;5043.646944713908;5057.6459647824295;5068.214426763858;5164.793408263702;2051.476873397274;2076.8753874767563;2107.757607875114;2112.619728448863;2161.14634719285;985.3595163144014;1081.1999120650662;1120.7702421003676;1134.1663877050526;1146.7821113988316;19854.70217946732;20578.176872924916;20591.8970405147;20731;20957.58084838325;1059.6662051453768;1061.8247989081715;1063.2238465919768;1079.2445288298222;1117.5976648406568;10127.9057609871;11349.546018159346;11410.315381077162;11541.76916461666;11701;478493.74225278874;478658;479968;481583;484919;70923;85843.57078214569;87413;94604;99073.50463247638;1007.4559737741685;1047.2564479219839;1047.2669131607904;1060.2684147937898;1081.6592773276393;17944.820551794837;18425;18596.81403186005;18672.25310987545;18718.064096795377;39290.410643839794;41977;42310.153796923274;42685.78657106694;42811;57191.42808571861;57221;61068;61105.083423749566;61398;7930.722424715338;7981.161977992228;8332.833343333221;8343.874841877498;9032.819343613222;13121.540746073842;13691;14139.293035347986;14366.209858457885;14424.927875360556;6311.116443697978;10191.980801919748;11732;12258.14193006481;12286.139970202357;7917.7624671259955;9880.20958323318;11996.160268781101;12296.877031229573;12519.499220031097;6744.69648865812;11473.254238474472;11914.642560723192;12494.37528123572;12754.68113297175;8895.955520222358;9204.447733136034;9291.907080929375;9372.109649583279;9390.906090939003;12508.124431289722;12621.495140194289;12717.10980231375;12767.61697149087;12888.097833151589 03:27:35 INFO - PROCESS | 18502 | |3;mootools.html;1563.0543521169693;1586.468533041431;1810.6650269700106;1922.0581914861723;1960.950976225594;9326.766830829232;9579.52102394881;9710.805783884327;9781.951090244556;9788.902110978897;9638.807223855518;9786.363886347383;9801.362911410772;9851.75370615735;9898.35660682057;2516.6099254615565;2541.542522345977;2557.539642864284;2566.6021766626204;2570.5630042892753;2507.636392723054;2557.3862273054424;2559.6160575913577;2561.129216066537;2566.358410397401;2494.9251522454265;2505.2734706934966;2508.949821003579;2530.595104783235;2542.6821647294087;2396.532676128156;2445.5720248956363;2450.791682706963;2460.1635443949144;2464.4085419499193;2454.3005243505695;2474.0969546115716;2507.122507122511;2520.193538067819;2546.1852207293673;9414.576344064533;9511.857322140173;9535.666251681158;9541.141297283279;9559.426434413957;5751.424857514257;5884.470397664188;5889.676067816268;5917.905187540276;5931.021381472052;3600.4959305697225;3675.9448608270895;3691.151035261878;3696.611855755134;3809.7714137151584;1201.8497687789027;1214.9878501214964;1250.0874361715908;1255.598208573257;1278.859325474197;13451.125676830974;13479.932600336935;13522.729545409135;13536.05247632666;13647.976401769907;4805.37530121089;4891.730954797449;4989.151844186497;5014.5737612303365;5035.697858128524;10472.581096756045;10537.84193237102;10559.102476289601;10566.101881340172;10570;5679.488846003879;5704.429557044263;5728;5785.190073389729;5794.246747922827;5131.025105229995;5271.314729085195;5348.625596208306;5368.355797304349;5374.140137577969;4413.536578659258;4439.600435960779;4463.218936686132;4477.910441791146;4514.932276015862;1313.1792629606496;1412.6185929798896;1419.141419441244;1424.3519198764745;1443.8339590946966;901.7970956534728;1094.584058057933;1125.3754166437543;1132.7281452451516;1138.1293310617384;6410.294867564564;6462.4183823456115;6468.482521398277;6574.572652777554;6603.372679595431;470.8187347871026;476.7306471843397;482.0599830330799;488.05317683694227;497.0729589315972;4685.765711714401;4705.364775755229;4742.407199100113;4746.928796068062;4770.212914869077;11828;12023.63929082129;12024.398780060961;12043.518259269706;12110.636680899586;11254.324740515594;11686.24039437434;11803.645890623295;12018;12096.334701591497;8895.866562001574;9002.729918102468;9073.047330030384;9129.087091290818;9153.084691530927;6484.805455836333;6760.884454065221;6829.419499342413;6893.310668933066;6954.756583519553;11061.834072488758;11164.88835111671;11177.329360238411;11207.327560346404;11400.486978086172;11097.500612472619;11439.714007149887;11474.082073434272;11483.25358851672;11501.712457188303;7613.809654758676;8162.387820913336;8194.262516373556;8463.153684631488;8539.060703322753;9140.085991400807;9178.357514974155;9182.219511341611;9257.583408746488;9263.76840578964;8183.6726530938095;8338.583070846313;8381.203785640355;8445.746627601182;8466.238038576557;8067.636956337096;8190.836183276182;8191.83616327682;8254.339652827879;8394.45436046655;7224.2414546473965;7534.510256833289;7534.698612055676;7556;7592.240775922363;5460.918086228789;5752.597318187687;5788.305403351625;5805.245318108618;5901.144334071621;5704.686242256716;5762.855928601651;5768.278965129359;5769.62497437682;5886.23478947734 03:27:35 INFO - PROCESS | 18502 | |4;prototype.html;350.9666581674742;351.67997122618425;353.6057296114831;354.30025699243987;361.734125417818;5830.154627579004;5850.531957443405;5868.3838196989345;5895.380984996573;5925.348211696721;5622;5669.6314739542;5693.886122277552;5772.365039845614;5801.390853960336;4515.735594033659;4530.977345113278;4550.953280745431;4561.247394179956;4561.608709343649;4562.543745625428;4563.977180114095;4574.542545745432;4585.908281834361;4592.334111553822;4505.819767209307;4535.548624440181;4547.8180872765215;4559.452865656126;4571.794269257892;4216.325387937931;4433.866983990485;4450.844220452284;4451.910961780779;4464.732116073046;3882.301185786557;3896.7272290939645;3898.2593307271814;3911.647951684362;3915.8433662653742;5622.803201887955;5624.29696287964;5631.155326700987;5636.943630563724;5655.802046928379;4942.975285123587;5116.948830511685;5127.230915362688;5168.638195326329;5179.9381126869275;6099.817005489843;6101.633901965896;6145.293291271516;6160.059581231898;6167.599106058092;4236.555161708007;4295.140971805651;4306.20335237982;4327.285997810358;4338.392625032498;6012.518998480111;6193.040078787795;6351.777687780952;6356.298573106411;6391.808245752588;4339.392485052095;4365.126974605092;4372.846950356722;4377.8248870044845;4424.491183513937;4417.116576684612;4423.889402764892;4427.46870375557;4459.353393757887;4474.306482495218;4927.605791536668;5093.9745301274;5171.81898633546;5175.560077393464;5194.506521880416;6067.150598916155;6075.453209211192;6076.635401875901;6087.665178415141;6098.756049758049;1523.988335397265;1538.8461153884746;1540.6764579438443;1542.082460935764;1548.5122186511212;933.4446004627235;966.6133546581424;974.3617930255552;984.675057231112;987.6543209876486;5201.427842937273;5231.476852314738;5286.8368958829;5299.099153143975;5313.54834839043;5535.7785688572;5555.2222688823595;5593.916091258634;5636.549076073904;5705.828825135252;4943.876403089879;5150.639455238097;5285.312909321764;5314.441983591744;5334.226537152169;2936.280611250215;2963.5702823090533;2973.9553906691417;2982.657803988214;2982.762153706231;5718.856228754183;5731.426857314235;5757.798477053283;5759.308882934075;5828.388019258002;5888.087346461305;6384.553081284265;6440.291567927524;6454.483641308684;6455.806325810233;6534.379233972765;6542.901856472156;6579.736810527621;6593.604383736991;6627.237867645186;6140.662263575547;6387.435078405821;6411.871762564816;6416.48668106541;6419.807405777834;6056.485198758155;6264.624122552661;6322.49420046386;6367.299597044229;6372.776952806629;6380.234371875405;6506.4469520091325;6532.804015879531;6533.216014078341;6534;4407.140607581619;4451.6661250405705;4460.330950357472;4470.7764611769935;4471.977640111779;6284.874302514016;6291.402316779899;6351.872962540631;6356.650384228912;6423.903641445476;6142.32434432221;6171.876562468815;6212.9068063978175;6225.28409232944;6238.284471770299;5947.364474769473;6159.922013647683;6188.628682279078;6195.2255968004;6217.658028808459;6037.396260373927;6101.359357267423;6159.922013647683;6173.166622505904;6197.101420294122;6148.200733904564;6152.16945712341;6170.50635949132;6180.443760061616;6250.781097685907;5790.392008839011;6030;6061.15143879866;6093.878122437615;6108.480779133645 03:27:35 INFO - PROCESS | 18502 | |5;yui.html;746.6154930210943;832.3008672714918;833.937454690898;864.8702694595812;878.8066625342423;14813.259337033145;14865.702685946288;14868.256587170652;14881.18153501557;15751;15253.618659533517;15342.616434589114;15458.458953936615;15475.380984760595;15508.224588770572;707.5507053021317;824.7690646618927;852.9232369086781;856.2764464027917;869.5261082709939;848.6690190825583;853.5134973065356;854.0434713121313;854.7350321400386;857.237059017475;892.6117139044536;894.7807787092172;895.1451363947447;895.3598177303227;899.1323372945106;878.7407714724204;883.5979629268668;884.9292056635486;887.5517863478966;888.595688961521;653.1182903080851;653.7581094994835;654.1300070905684;654.6170490263202;655.017473789316;14017.158970461805;14167.433302667881;14169.858301416956;14253.429862805475;14326.283685815668;14148.434062637481;14202.92898535511;14214.644633884132;14410.495632652806;15057.397704091823;12139.817902731465;12219.694507637292;12261.877381226252;12418.81371779424;12559.874401255962;3999.6600288975474;4050.7772072536295;4072.694547908889;4166.354215096665;4211.473565804275;79433;80731;81002.59498702528;81269.59365203195;82189.58905205436;11280.32318060919;11282.266652667551;11389.94305028486;11464.713382165513;11484.196106272648;22434.653920764806;22522.774772252396;22680.319590411986;22709;22759.203427879944;8141.307988820898;9035.537049795757;9187.678431254873;9242.075792420705;9328.113829186352;4945.826896058621;4987.401511818605;5081.136206844845;5181;5215.348081489814;3429.8113603751535;3529.964700353015;3545.556805399325;3557.324108419392;3578.8926332210076;625.8091282158895;631.8925782616966;633.1420924647036;633.4299130782241;645.6481217736344;656.875193713193;662.2781168526329;664.2394458345168;700.2997002997002;720.8233982674278;8904.332175086765;9333.206677432494;9520;9584.329096963285;9627.711168664951;693.1370443797505;708.4084789201074;714.0752725220851;719.6833393306928;721.2210812322784;4476.910461790746;4592.173408786451;4623.398958135421;4644.117617652635;4825.30033145199;85961;107473.4626326879;108841;108989;113556.43221784003;99830.50084749675;101658.49170754099;101968;102879;102879.48560257151;89826.55086724524;90512.6423103654;90558.54720726355;90566;91410;8974.955125224593;9014.459132452073;9017.864732029157;9039.81920361576;9073.863892041492;53798.731006344715;55093.44906550883;55314.44685553093;55555.44444555664;55568.48238967425;72475;76503.01601885457;77152.22847771451;78519;78531;10619.575216991234;10739.248252622554;10747.731306717395;10972.286801357886;11172.329660220414;12336.136470446983;12471;12472.625821225378;12938.353082346033;12979.675508111995;11422.771544568895;11692.415379231175;11832.645020649394;11839.408029598659;12078.818817717565;11593.130515211562;11670.416479175838;11929.522819087138;12046.638600841989;12127.332996685267;10846.945765271123;10875.728106797076;11299.3785341807;11321.830172547254;11437.885621143681;9903.108720215216;10532.89467105319;10704.678859634223;11202.83195752048;11732;11476.942615286871;11598.420078996185;11744.236624619372;12163.756724865276;12306.384680766105 03:27:35 INFO - PROCESS | 18502 | __end_tp_report 03:27:35 INFO - PROCESS | 18502 | __start_cc_report 03:27:35 INFO - PROCESS | 18502 | _x_x_mozilla_cycle_collect,335 03:27:35 INFO - PROCESS | 18502 | __end_cc_report 03:27:35 INFO - PROCESS | 18502 | __startTimestamp1467282455339__endTimestamp 03:27:35 INFO - PROCESS | 18502 | 03:27:35 INFO - PROCESS | 18502 | ------- Summary: start ------- 03:27:35 INFO - PROCESS | 18502 | Number of tests: 6 03:27:35 INFO - PROCESS | 18502 | 03:27:35 INFO - PROCESS | 18502 | [#0] dojo.html Cycles:165 Average:5796.85 Median:6000.00 stddev:661.11 (11.0%) stddev-sans-first:636.61 03:27:35 INFO - PROCESS | 18502 | Values: 3433.5 3467.9 3491.8 3492.4 3494.3 5772.8 5802.8 5809.5 5817.8 5841.9 5789.7 5851.4 5855.1 5866.9 5869.0 5211.5 5302.7 5306.8 5341.6 5363.1 5223.2 5235.9 5332.2 5375.9 5376.4 5282.7 5288.5 5293.3 5305.3 5354.9 5343.4 5356.1 5356.7 5374.6 5383.5 5069.2 5161.5 5195.8 5262.6 5263.0 5691.7 5714.3 5716.7 5723.9 5740.9 6215.1 6225.8 6238.2 6262.7 6275.6 6099.4 6185.9 6209.7 6252.0 6281.2 5873.5 5882.7 5883.8 5885.9 5902.5 6356.3 6396.7 6409.7 6415.1 6466.8 6015.5 6072.2 6115.0 6131.0 6180.2 6224.2 6247.9 6274.1 6284.8 6299.1 6082.3 6195.9 6269.6 6271.6 6280.6 6123.6 6127.6 6138.5 6266.9 6278.8 4746.0 4761.8 4766.7 4772.8 4778.5 4135.5 4137.6 4217.2 4234.6 4258.7 5815.9 5862.5 5913.8 5928.1 5974.1 6230.7 6235.2 6276.9 6306.3 6319.3 5748.9 5811.0 5957.1 5968.2 6007.8 5265.9 5269.9 5285.9 5326.3 5346.4 6467.7 6476.3 6476.6 6485.5 6507.9 6148.6 6253.4 6267.4 6313.0 6357.9 6436.0 6549.5 6556.3 6571.0 6597.3 6259.3 6268.3 6273.1 6300.1 6303.3 6027.0 6107.4 6145.5 6369.7 6385.3 6096.4 6132.5 6159.6 6181.7 6191.0 6091.3 6109.4 6146.7 6165.1 6169.5 5846.5 5890.1 5931.1 5953.9 6109.6 6059.7 6086.1 6128.4 6136.3 6145.2 5990.0 5996.9 5997.2 5999.6 6000.0 03:27:35 INFO - PROCESS | 18502 | 03:27:35 INFO - PROCESS | 18502 | [#1] ext.html Cycles:180 Average:64760.42 Median:46990.38 stddev:131047.66 (278.9%) stddev-sans-first:131326.74 03:27:35 INFO - PROCESS | 18502 | Values: 599.3 635.4 652.6 655.0 657.7 50578.5 52363.0 52442.0 52575.7 52611.2 47990.5 48022.8 48440.8 48785.5 48794.5 9203.7 9240.4 9290.2 9341.5 9368.5 9147.8 9167.2 9169.6 9181.6 9193.7 9211.2 9285.2 9297.6 9298.3 9343.7 9207.6 9240.8 9249.1 9258.7 9266.3 9117.1 9193.9 9194.2 9197.8 9198.9 46459.5 46985.3 46987.8 46993.0 47109.8 3694.3 3730.9 3758.4 3933.0 4210.7 33631.8 34527.8 35093.3 35325.5 35405.8 4681.2 4765.4 4791.6 4831.8 4841.8 396469.0 398373.0 400481.0 401768.0 402755.0 37657.1 61856.0 62626.4 62657.7 62659.0 38948.8 40512.2 40531.8 40656.6 40711.6 16210.0 16256.0 16335.9 16386.6 16422.2 13362.5 13402.6 13444.7 13450.2 13465.1 9151.8 9173.2 9214.7 9260.4 9343.5 3459.4 3523.2 3563.3 3621.8 3629.4 1097.7 1104.5 1113.8 1160.9 1185.3 34006.1 34137.1 34218.8 34284.0 34551.5 1164.8 1193.3 1198.7 1213.7 1258.5 16915.7 17913.4 17951.1 17985.0 18208.5 577749.0 628972.0 640201.0 646630.0 648579.0 56629.0 61938.7 62529.4 62567.7 62705.1 1501.7 1522.7 1532.0 1537.9 1538.8 31428.7 32177.8 32595.7 32663.0 32976.0 52032.0 52511.2 52643.5 52749.0 52891.0 412978.0 415598.0 415974.0 416158.0 416526.9 29209.9 29964.3 30166.7 30295.5 52434.0 53835.7 53871.2 56904.7 58066.1 58332.4 46390.8 48570.3 48945.8 49236.0 49254.5 46331.5 47183.5 47622.3 47742.3 47922.0 47416.5 47487.5 48179.0 48239.8 48662.5 40222.8 40359.6 41294.6 41377.2 42040.6 31047.8 32047.2 32062.7 32139.8 32352.7 03:27:35 INFO - PROCESS | 18502 | 03:27:35 INFO - PROCESS | 18502 | [#2] jquery.html Cycles:180 Average:29033.02 Median:24121.14 stddev:79362.48 (329.0%) stddev-sans-first:79556.06 03:27:35 INFO - PROCESS | 18502 | Values: 433.7 435.9 436.1 436.5 448.6 19183.1 20383.4 20767.8 21431.1 21501.6 19703.6 20030.2 20872.9 20873.3 20942.8 5853.7 6025.2 6056.8 6063.4 6077.2 5464.7 5752.1 5758.9 5873.1 5955.0 5553.9 5785.5 5832.2 6089.8 6091.2 6022.5 6027.4 6088.8 6110.3 6118.4 5704.6 5843.6 5855.9 5858.6 5872.6 14290.9 14625.8 16252.8 24055.4 24186.9 2149.8 2226.5 2431.6 2451.6 2482.0 10745.6 10869.5 10947.2 11048.9 11106.9 1969.6 2053.5 2062.8 2071.9 2086.0 83610.0 87691.6 89593.0 89709.0 90565.5 10616.6 10713.3 10859.6 11651.6 11890.3 16616.6 16720.4 16745.5 16786.6 16807.7 8427.8 8433.0 8560.5 8721.7 8804.8 8107.6 8131.4 8290.4 8309.3 8509.8 4870.7 5043.6 5057.6 5068.2 5164.8 2051.5 2076.9 2107.8 2112.6 2161.1 985.4 1081.2 1120.8 1134.2 1146.8 19854.7 20578.2 20591.9 20731.0 20957.6 1059.7 1061.8 1063.2 1079.2 1117.6 10127.9 11349.5 11410.3 11541.8 11701.0 478493.7 478658.0 479968.0 481583.0 484919.0 70923.0 85843.6 87413.0 94604.0 99073.5 1007.5 1047.3 1047.3 1060.3 1081.7 17944.8 18425.0 18596.8 18672.3 18718.1 39290.4 41977.0 42310.2 42685.8 42811.0 57191.4 57221.0 61068.0 61105.1 61398.0 7930.7 7981.2 8332.8 8343.9 9032.8 13121.5 13691.0 14139.3 14366.2 14424.9 6311.1 10192.0 11732.0 12258.1 12286.1 7917.8 9880.2 11996.2 12296.9 12519.5 6744.7 11473.3 11914.6 12494.4 12754.7 8896.0 9204.4 9291.9 9372.1 9390.9 12508.1 12621.5 12717.1 12767.6 12888.1 03:27:35 INFO - PROCESS | 18502 | 03:27:35 INFO - PROCESS | 18502 | [#3] mootools.html Cycles:180 Average:6333.42 Median:4787.79 stddev:3606.27 (75.3%) stddev-sans-first:3598.57 03:27:35 INFO - PROCESS | 18502 | Values: 1563.1 1586.5 1810.7 1922.1 1961.0 9326.8 9579.5 9710.8 9782.0 9788.9 9638.8 9786.4 9801.4 9851.8 9898.4 2516.6 2541.5 2557.5 2566.6 2570.6 2507.6 2557.4 2559.6 2561.1 2566.4 2494.9 2505.3 2508.9 2530.6 2542.7 2396.5 2445.6 2450.8 2460.2 2464.4 2454.3 2474.1 2507.1 2520.2 2546.2 9414.6 9511.9 9535.7 9541.1 9559.4 5751.4 5884.5 5889.7 5917.9 5931.0 3600.5 3675.9 3691.2 3696.6 3809.8 1201.8 1215.0 1250.1 1255.6 1278.9 13451.1 13479.9 13522.7 13536.1 13648.0 4805.4 4891.7 4989.2 5014.6 5035.7 10472.6 10537.8 10559.1 10566.1 10570.0 5679.5 5704.4 5728.0 5785.2 5794.2 5131.0 5271.3 5348.6 5368.4 5374.1 4413.5 4439.6 4463.2 4477.9 4514.9 1313.2 1412.6 1419.1 1424.4 1443.8 901.8 1094.6 1125.4 1132.7 1138.1 6410.3 6462.4 6468.5 6574.6 6603.4 470.8 476.7 482.1 488.1 497.1 4685.8 4705.4 4742.4 4746.9 4770.2 11828.0 12023.6 12024.4 12043.5 12110.6 11254.3 11686.2 11803.6 12018.0 12096.3 8895.9 9002.7 9073.0 9129.1 9153.1 6484.8 6760.9 6829.4 6893.3 6954.8 11061.8 11164.9 11177.3 11207.3 11400.5 11097.5 11439.7 11474.1 11483.3 11501.7 7613.8 8162.4 8194.3 8463.2 8539.1 9140.1 9178.4 9182.2 9257.6 9263.8 8183.7 8338.6 8381.2 8445.7 8466.2 8067.6 8190.8 8191.8 8254.3 8394.5 7224.2 7534.5 7534.7 7556.0 7592.2 5460.9 5752.6 5788.3 5805.2 5901.1 5704.7 5762.9 5768.3 5769.6 5886.2 03:27:35 INFO - PROCESS | 18502 | 03:27:35 INFO - PROCESS | 18502 | [#4] prototype.html Cycles:180 Average:5060.12 Median:5681.76 stddev:1519.44 (26.7%) stddev-sans-first:1482.02 03:27:35 INFO - PROCESS | 18502 | Values: 351.0 351.7 353.6 354.3 361.7 5830.2 5850.5 5868.4 5895.4 5925.3 5622.0 5669.6 5693.9 5772.4 5801.4 4515.7 4531.0 4551.0 4561.2 4561.6 4562.5 4564.0 4574.5 4585.9 4592.3 4505.8 4535.5 4547.8 4559.5 4571.8 4216.3 4433.9 4450.8 4451.9 4464.7 3882.3 3896.7 3898.3 3911.6 3915.8 5622.8 5624.3 5631.2 5636.9 5655.8 4943.0 5116.9 5127.2 5168.6 5179.9 6099.8 6101.6 6145.3 6160.1 6167.6 4236.6 4295.1 4306.2 4327.3 4338.4 6012.5 6193.0 6351.8 6356.3 6391.8 4339.4 4365.1 4372.8 4377.8 4424.5 4417.1 4423.9 4427.5 4459.4 4474.3 4927.6 5094.0 5171.8 5175.6 5194.5 6067.2 6075.5 6076.6 6087.7 6098.8 1524.0 1538.8 1540.7 1542.1 1548.5 933.4 966.6 974.4 984.7 987.7 5201.4 5231.5 5286.8 5299.1 5313.5 5535.8 5555.2 5593.9 5636.5 5705.8 4943.9 5150.6 5285.3 5314.4 5334.2 2936.3 2963.6 2974.0 2982.7 2982.8 5718.9 5731.4 5757.8 5759.3 5828.4 5888.1 6384.6 6440.3 6454.5 6455.8 6534.4 6542.9 6579.7 6593.6 6627.2 6140.7 6387.4 6411.9 6416.5 6419.8 6056.5 6264.6 6322.5 6367.3 6372.8 6380.2 6506.4 6532.8 6533.2 6534.0 4407.1 4451.7 4460.3 4470.8 4472.0 6284.9 6291.4 6351.9 6356.7 6423.9 6142.3 6171.9 6212.9 6225.3 6238.3 5947.4 6159.9 6188.6 6195.2 6217.7 6037.4 6101.4 6159.9 6173.2 6197.1 6148.2 6152.2 6170.5 6180.4 6250.8 5790.4 6030.0 6061.2 6093.9 6108.5 03:27:35 INFO - PROCESS | 18502 | 03:27:35 INFO - PROCESS | 18502 | [#5] yui.html Cycles:180 Average:20779.15 Median:4734.71 stddev:30150.51 (636.8%) stddev-sans-first:30197.57 03:27:35 INFO - PROCESS | 18502 | Values: 746.6 832.3 833.9 864.9 878.8 14813.3 14865.7 14868.3 14881.2 15751.0 15253.6 15342.6 15458.5 15475.4 15508.2 707.6 824.8 852.9 856.3 869.5 848.7 853.5 854.0 854.7 857.2 892.6 894.8 895.1 895.4 899.1 878.7 883.6 884.9 887.6 888.6 653.1 653.8 654.1 654.6 655.0 14017.2 14167.4 14169.9 14253.4 14326.3 14148.4 14202.9 14214.6 14410.5 15057.4 12139.8 12219.7 12261.9 12418.8 12559.9 3999.7 4050.8 4072.7 4166.4 4211.5 79433.0 80731.0 81002.6 81269.6 82189.6 11280.3 11282.3 11389.9 11464.7 11484.2 22434.7 22522.8 22680.3 22709.0 22759.2 8141.3 9035.5 9187.7 9242.1 9328.1 4945.8 4987.4 5081.1 5181.0 5215.3 3429.8 3530.0 3545.6 3557.3 3578.9 625.8 631.9 633.1 633.4 645.6 656.9 662.3 664.2 700.3 720.8 8904.3 9333.2 9520.0 9584.3 9627.7 693.1 708.4 714.1 719.7 721.2 4476.9 4592.2 4623.4 4644.1 4825.3 85961.0 107473.5 108841.0 108989.0 113556.4 99830.5 101658.5 101968.0 102879.0 102879.5 89826.6 90512.6 90558.5 90566.0 91410.0 8975.0 9014.5 9017.9 9039.8 9073.9 53798.7 55093.4 55314.4 55555.4 55568.5 72475.0 76503.0 77152.2 78519.0 78531.0 10619.6 10739.2 10747.7 10972.3 11172.3 12336.1 12471.0 12472.6 12938.4 12979.7 11422.8 11692.4 11832.6 11839.4 12078.8 11593.1 11670.4 11929.5 12046.6 12127.3 10846.9 10875.7 11299.4 11321.8 11437.9 9903.1 10532.9 10704.7 11202.8 11732.0 11476.9 11598.4 11744.2 12163.8 12306.4 03:27:35 INFO - PROCESS | 18502 | -------- Summary: end -------- 03:27:35 INFO - PROCESS | 18502 | 03:27:36 INFO - TEST-INFO | 18502: exit 0 03:27:36 INFO - TEST-OK | dromaeo_css | took 1110473ms 03:27:36 INFO - TEST-START | kraken 03:27:36 INFO - operating with platform_type : linux_ 03:27:36 INFO - Initialising browser for kraken test... 03:27:36 INFO - TEST-INFO | started process 18749 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkULQ6B/profile http://localhost:36459/getInfo.html) 03:27:40 INFO - PROCESS | 18749 | __metrics Screen width/height:1600/1200 03:27:40 INFO - PROCESS | 18749 | colorDepth:24 03:27:40 INFO - PROCESS | 18749 | Browser inner width/height: 1024/697 03:27:40 INFO - PROCESS | 18749 | __metrics 03:27:41 ERROR - PROCESS | 18749 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 03:27:42 INFO - TEST-INFO | 18749: exit 0 03:27:42 INFO - Browser initialized. 03:27:42 INFO - Running cycle 1/1 for kraken test... 03:27:42 INFO - TEST-INFO | started process 18877 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkULQ6B/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:27:54 INFO - PROCESS | 18877 | RSS: Main: 155947008 03:27:54 INFO - PROCESS | 18877 | 03:27:56 INFO - PROCESS | 18877 | Cycle 1(1): loaded http://localhost:36459/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36459/tests/kraken/driver.html?testName=audio-beat-detection) 03:27:57 INFO - PROCESS | 18877 | RSS: Main: 161103872 03:27:57 INFO - PROCESS | 18877 | 03:28:00 INFO - PROCESS | 18877 | Cycle 1(1): loaded http://localhost:36459/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36459/tests/kraken/driver.html?testName=audio-dft) 03:28:00 INFO - PROCESS | 18877 | RSS: Main: 160075776 03:28:00 INFO - PROCESS | 18877 | 03:28:03 INFO - PROCESS | 18877 | Cycle 1(1): loaded http://localhost:36459/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36459/tests/kraken/driver.html?testName=audio-fft) 03:28:04 INFO - PROCESS | 18877 | RSS: Main: 160976896 03:28:04 INFO - PROCESS | 18877 | 03:28:06 INFO - PROCESS | 18877 | Cycle 1(1): loaded http://localhost:36459/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36459/tests/kraken/driver.html?testName=audio-oscillator) 03:28:07 INFO - PROCESS | 18877 | RSS: Main: 160903168 03:28:07 INFO - PROCESS | 18877 | 03:28:09 INFO - PROCESS | 18877 | Cycle 1(1): loaded http://localhost:36459/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36459/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:28:09 INFO - PROCESS | 18877 | RSS: Main: 160759808 03:28:09 INFO - PROCESS | 18877 | 03:28:12 INFO - PROCESS | 18877 | Cycle 1(1): loaded http://localhost:36459/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36459/tests/kraken/driver.html?testName=imaging-darkroom) 03:28:13 INFO - PROCESS | 18877 | RSS: Main: 160079872 03:28:13 INFO - PROCESS | 18877 | 03:28:17 INFO - PROCESS | 18877 | Cycle 1(1): loaded http://localhost:36459/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36459/tests/kraken/driver.html?testName=imaging-desaturate) 03:28:17 INFO - PROCESS | 18877 | RSS: Main: 160858112 03:28:17 INFO - PROCESS | 18877 | 03:28:20 INFO - PROCESS | 18877 | Cycle 1(1): loaded http://localhost:36459/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36459/tests/kraken/driver.html?testName=json-parse-financial) 03:28:21 INFO - PROCESS | 18877 | RSS: Main: 160477184 03:28:21 INFO - PROCESS | 18877 | 03:28:22 INFO - PROCESS | 18877 | Cycle 1(1): loaded http://localhost:36459/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36459/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:28:23 INFO - PROCESS | 18877 | RSS: Main: 160247808 03:28:23 INFO - PROCESS | 18877 | 03:28:25 INFO - PROCESS | 18877 | Cycle 1(1): loaded http://localhost:36459/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36459/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:28:25 INFO - PROCESS | 18877 | RSS: Main: 160124928 03:28:25 INFO - PROCESS | 18877 | 03:28:27 INFO - PROCESS | 18877 | Cycle 1(1): loaded http://localhost:36459/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36459/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:28:28 INFO - PROCESS | 18877 | RSS: Main: 160870400 03:28:28 INFO - PROCESS | 18877 | 03:28:30 INFO - PROCESS | 18877 | Cycle 1(1): loaded http://localhost:36459/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36459/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:28:31 INFO - PROCESS | 18877 | RSS: Main: 160854016 03:28:31 INFO - PROCESS | 18877 | 03:28:34 INFO - PROCESS | 18877 | Cycle 1(1): loaded http://localhost:36459/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36459/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:28:34 INFO - PROCESS | 18877 | RSS: Main: 161107968 03:28:34 INFO - PROCESS | 18877 | 03:28:36 INFO - PROCESS | 18877 | Cycle 1(1): loaded http://localhost:36459/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36459/tests/kraken/driver.html?testName=ai-astar) 03:28:36 INFO - PROCESS | 18877 | RSS: Main: 162107392 03:28:36 INFO - PROCESS | 18877 | 03:28:36 INFO - PROCESS | 18877 | __start_tp_report 03:28:36 INFO - PROCESS | 18877 | _x_x_mozilla_page_load 03:28:36 INFO - PROCESS | 18877 | _x_x_mozilla_page_load_details 03:28:36 INFO - PROCESS | 18877 | |i|pagename|runs| 03:28:36 INFO - PROCESS | 18877 | |0;ai-astar;111;105;110;111;110;112;111;111;110;110 03:28:36 INFO - PROCESS | 18877 | |1;audio-beat-detection;159;127;155;184;127;158;159;129;194;125 03:28:36 INFO - PROCESS | 18877 | |2;audio-dft;161;164;163;164;164;162;164;165;170;163 03:28:36 INFO - PROCESS | 18877 | |3;audio-fft;75;76;75;180;77;76;76;76;160;76 03:28:36 INFO - PROCESS | 18877 | |4;audio-oscillator;85;85;145;84;85;85;141;84;85;151 03:28:36 INFO - PROCESS | 18877 | |5;imaging-gaussian-blur;117;118;117;117;117;117;117;117;118;122 03:28:36 INFO - PROCESS | 18877 | |6;imaging-darkroom;147;147;147;147;151;148;147;147;147;146 03:28:36 INFO - PROCESS | 18877 | |7;imaging-desaturate;95;96;97;104;100;96;95;97;95;95 03:28:36 INFO - PROCESS | 18877 | |8;json-parse-financial;52;55;52;55;52;54;63;52;54;58 03:28:36 INFO - PROCESS | 18877 | |9;json-stringify-tinderbox;60;60;59;60;62;61;60;66;61;59 03:28:36 INFO - PROCESS | 18877 | |10;stanford-crypto-aes;80;78;77;81;83;77;84;84;105;84 03:28:36 INFO - PROCESS | 18877 | |11;stanford-crypto-ccm;124;119;120;118;118;128;120;120;137;121 03:28:36 INFO - PROCESS | 18877 | |12;stanford-crypto-pbkdf2;152;151;154;152;152;149;152;152;153;154 03:28:36 INFO - PROCESS | 18877 | |13;stanford-crypto-sha256-iterative;62;62;61;61;65;61;63;59;62;62 03:28:36 INFO - PROCESS | 18877 | __end_tp_report 03:28:36 INFO - PROCESS | 18877 | __start_cc_report 03:28:36 INFO - PROCESS | 18877 | _x_x_mozilla_cycle_collect,892 03:28:36 INFO - PROCESS | 18877 | __end_cc_report 03:28:36 INFO - PROCESS | 18877 | __startTimestamp1467282516638__endTimestamp 03:28:36 INFO - PROCESS | 18877 | 03:28:36 INFO - PROCESS | 18877 | ------- Summary: start ------- 03:28:36 INFO - PROCESS | 18877 | Number of tests: 14 03:28:36 INFO - PROCESS | 18877 | 03:28:36 INFO - PROCESS | 18877 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.00 stddev:1.91 (1.7%) stddev-sans-first:2.00 03:28:36 INFO - PROCESS | 18877 | Values: 111.0 105.0 110.0 111.0 110.0 112.0 111.0 111.0 110.0 110.0 03:28:36 INFO - PROCESS | 18877 | 03:28:36 INFO - PROCESS | 18877 | [#1] audio-beat-detection Cycles:10 Average:151.70 Median:158.50 stddev:24.58 (15.5%) stddev-sans-first:25.93 03:28:36 INFO - PROCESS | 18877 | Values: 159.0 127.0 155.0 184.0 127.0 158.0 159.0 129.0 194.0 125.0 03:28:36 INFO - PROCESS | 18877 | 03:28:36 INFO - PROCESS | 18877 | [#2] audio-dft Cycles:10 Average:164.00 Median:164.00 stddev:2.40 (1.5%) stddev-sans-first:2.29 03:28:36 INFO - PROCESS | 18877 | Values: 161.0 164.0 163.0 164.0 164.0 162.0 164.0 165.0 170.0 163.0 03:28:36 INFO - PROCESS | 18877 | 03:28:36 INFO - PROCESS | 18877 | [#3] audio-fft Cycles:10 Average:94.70 Median:76.00 stddev:39.97 (52.6%) stddev-sans-first:41.75 03:28:36 INFO - PROCESS | 18877 | Values: 75.0 76.0 75.0 180.0 77.0 76.0 76.0 76.0 160.0 76.0 03:28:36 INFO - PROCESS | 18877 | 03:28:36 INFO - PROCESS | 18877 | [#4] audio-oscillator Cycles:10 Average:103.00 Median:85.00 stddev:29.54 (34.8%) stddev-sans-first:30.61 03:28:36 INFO - PROCESS | 18877 | Values: 85.0 85.0 145.0 84.0 85.0 85.0 141.0 84.0 85.0 151.0 03:28:36 INFO - PROCESS | 18877 | 03:28:36 INFO - PROCESS | 18877 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:117.00 stddev:1.57 (1.3%) stddev-sans-first:1.64 03:28:36 INFO - PROCESS | 18877 | Values: 117.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 122.0 03:28:36 INFO - PROCESS | 18877 | 03:28:36 INFO - PROCESS | 18877 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.00 stddev:1.35 (0.9%) stddev-sans-first:1.42 03:28:36 INFO - PROCESS | 18877 | Values: 147.0 147.0 147.0 147.0 151.0 148.0 147.0 147.0 147.0 146.0 03:28:36 INFO - PROCESS | 18877 | 03:28:36 INFO - PROCESS | 18877 | [#7] imaging-desaturate Cycles:10 Average:97.00 Median:95.50 stddev:2.91 (3.0%) stddev-sans-first:2.99 03:28:36 INFO - PROCESS | 18877 | Values: 95.0 96.0 97.0 104.0 100.0 96.0 95.0 97.0 95.0 95.0 03:28:36 INFO - PROCESS | 18877 | 03:28:36 INFO - PROCESS | 18877 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:54.50 stddev:3.50 (6.4%) stddev-sans-first:3.57 03:28:36 INFO - PROCESS | 18877 | Values: 52.0 55.0 52.0 55.0 52.0 54.0 63.0 52.0 54.0 58.0 03:28:36 INFO - PROCESS | 18877 | 03:28:36 INFO - PROCESS | 18877 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:60.50 stddev:2.04 (3.4%) stddev-sans-first:2.15 03:28:36 INFO - PROCESS | 18877 | Values: 60.0 60.0 59.0 60.0 62.0 61.0 60.0 66.0 61.0 59.0 03:28:36 INFO - PROCESS | 18877 | 03:28:36 INFO - PROCESS | 18877 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:82.00 stddev:8.14 (9.9%) stddev-sans-first:8.54 03:28:36 INFO - PROCESS | 18877 | Values: 80.0 78.0 77.0 81.0 83.0 77.0 84.0 84.0 105.0 84.0 03:28:36 INFO - PROCESS | 18877 | 03:28:36 INFO - PROCESS | 18877 | [#11] stanford-crypto-ccm Cycles:10 Average:122.50 Median:120.50 stddev:5.93 (4.9%) stddev-sans-first:6.26 03:28:36 INFO - PROCESS | 18877 | Values: 124.0 119.0 120.0 118.0 118.0 128.0 120.0 120.0 137.0 121.0 03:28:36 INFO - PROCESS | 18877 | 03:28:36 INFO - PROCESS | 18877 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.10 Median:152.00 stddev:1.45 (1.0%) stddev-sans-first:1.54 03:28:36 INFO - PROCESS | 18877 | Values: 152.0 151.0 154.0 152.0 152.0 149.0 152.0 152.0 153.0 154.0 03:28:36 INFO - PROCESS | 18877 | 03:28:36 INFO - PROCESS | 18877 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.80 Median:62.00 stddev:1.55 (2.5%) stddev-sans-first:1.64 03:28:36 INFO - PROCESS | 18877 | Values: 62.0 62.0 61.0 61.0 65.0 61.0 63.0 59.0 62.0 62.0 03:28:36 INFO - PROCESS | 18877 | -------- Summary: end -------- 03:28:36 INFO - PROCESS | 18877 | 03:28:37 INFO - TEST-INFO | 18877: exit 0 03:28:37 INFO - TEST-OK | kraken | took 61590ms 03:28:37 INFO - SUITE-END | took 1172s 03:28:37 INFO - Completed test suite (00:19:32) 03:28:37 INFO - javascript benchmark 03:28:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7601.771699176314, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3433.4849772534126, 3467.913302167447, 3491.7555771096036, 3492.388831954407, 3494.3186078714643, 5772.769089236431, 5802.825915222539, 5809.506191973682, 5817.825465236049, 5841.912371314434, 5789.710514474281, 5851.444112809277, 5855.063189889618, 5866.941330586693, 5868.970655146729, 5211.5309622134, 5302.734863256841, 5306.840794776143, 5341.572674186075, 5363.141897296433, 5223.216517522383, 5235.895282094375, 5332.173513105456, 5375.865603359908, 5376.4085950545405, 5282.656627319231, 5288.497592728685, 5293.311869456965, 5305.310309659739, 5354.892902141954, 5343.358796944372, 5356.089464790975, 5356.6518176318805, 5374.596905232084, 5383.488568585978, 5069.188929771219, 5161.509656582619, 5195.792168313301, 5262.631615786897, 5263.02634012705, 5691.743871525791, 5714.257146570919, 5716.657000579979, 5723.914141287884, 5740.8851822963725, 6215.098810672473, 6225.750969961241, 6238.220222472191, 6262.718177682015, 6275.592086514408, 6099.390060993909, 6185.907211391833, 6209.658468784215, 6252.030935205051, 6281.214848143982, 5873.500752436048, 5882.705864706748, 5883.794067207627, 5885.9117113243765, 5902.468777810018, 6356.269029061625, 6396.744130234739, 6409.743610255631, 6415.13395691585, 6466.838329041718, 6015.4586087252355, 6072.210612620331, 6115.027386288435, 6131.049687298476, 6180.165677633552, 6224.221972253468, 6247.937520624827, 6274.058891166362, 6284.811455656338, 6299.0866324382705, 6082.330943596201, 6195.876082478325, 6269.592476489013, 6271.560990730696, 6280.623162610258, 6123.5876691309595, 6127.647695152957, 6138.48821116479, 6266.905996410058, 6278.811635650938, 4746.02706445178, 4761.761911904391, 4766.666333356701, 4772.832950846704, 4778.522147785194, 4135.503739551273, 4137.648299894482, 4217.198732240864, 4234.576542345741, 4258.74447533149, 5815.883682326415, 5862.501687356537, 5913.793017244376, 5928.081147422156, 5974.133750606138, 6230.657313847782, 6235.158253635792, 6276.905846412307, 6306.274778400542, 6319.3364696706185, 5748.913766293509, 5811.0411782056335, 5957.1362152487645, 5968.1644569760265, 6007.789727359609, 5265.894682106336, 5269.868253293622, 5285.867853303621, 5326.334208223972, 5346.4118946915805, 6467.676616169173, 6476.287608363076, 6476.6114033158165, 6485.4811615070685, 6507.934920650733, 6148.569600127948, 6253.437190652863, 6267.373262673696, 6313.0, 6357.8728425432155, 6436.0, 6549.541532092708, 6556.311587283458, 6571.0, 6597.340265973365, 6259.280182779039, 6268.341824108403, 6273.090401891792, 6300.054991751274, 6303.275123360689, 6027.035674292268, 6107.389261073857, 6145.525073982123, 6369.713362898588, 6385.265694445198, 6096.420840020191, 6132.480767309457, 6159.599626024294, 6181.690915454299, 6190.969045154746, 6091.274202250048, 6109.3890610940325, 6146.692665366624, 6165.136880836776, 6169.475594574332, 5846.473817356458, 5890.087036509348, 5931.08068249422, 5953.880922381441, 6109.633421994695, 6059.727312271047, 6086.087086936995, 6128.417800308964, 6136.32500424944, 6145.201123853871, 5990.041593345044, 5996.8500787478915, 5997.190379298739, 5999.580029398075, 6000.0], "value": 5752.711611561305, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.2808629644428, 635.3678090300152, 652.6214795418657, 654.9541532092755, 657.7204688007598, 50578.494215057835, 52363.0, 52442.0, 52575.737121314385, 52611.210831837554, 47990.520094799125, 48022.759886200605, 48440.75779621106, 48785.51214487854, 48794.512054879444, 9203.677871274507, 9240.353175277733, 9290.210332121778, 9341.53292335384, 9368.484733339697, 9147.771305717344, 9167.220786233145, 9169.587368568396, 9181.586828592695, 9193.724188274362, 9211.170994610484, 9285.164335209829, 9297.581608827586, 9298.256139508823, 9343.71968840936, 9207.631694732236, 9240.815183696355, 9249.075092490732, 9258.67594634188, 9266.305027122926, 9117.08829117083, 9193.862092068624, 9194.17252447283, 9197.77005574866, 9198.908010919871, 46459.535404646194, 46985.295220571716, 46987.76506117482, 46993.0, 47109.76445117787, 3694.2796154749835, 3730.850765969358, 3758.3798673218885, 3933.0, 4210.705250632457, 33631.83184084088, 34527.82736086303, 35093.29813403718, 35325.47011794825, 35405.82297088498, 4681.204195286809, 4765.380500534909, 4791.640626952958, 4831.830885918976, 4841.830535931261, 396469.0176549128, 398373.0, 400481.0, 401768.0, 402755.0, 37657.05857353588, 61856.0, 62626.37373626297, 62657.68671156615, 62659.0, 38948.805255974105, 40512.18975620471, 40531.79734101311, 40656.59343406587, 40711.592884071375, 16210.0, 16256.0, 16335.918320408322, 16386.590335241715, 16422.1788910554, 13362.465501380031, 13402.597922062354, 13444.731105377838, 13450.192988420726, 13465.124766890121, 9151.771205719777, 9173.174414302612, 9214.677486287948, 9260.444373337621, 9343.532823358804, 3459.3773120837986, 3523.1544429336773, 3563.2873425315042, 3621.80080095592, 3629.383004889175, 1097.6816723150198, 1104.5416152296707, 1113.7939481196004, 1160.9071274298035, 1185.343216178083, 34006.149846253546, 34137.146571335914, 34218.82890585531, 34284.0, 34551.4817277736, 1164.7903377392151, 1193.3019183777415, 1198.7362780188344, 1213.660175150959, 1258.5343422933572, 16915.661686766194, 17913.37303194382, 17951.102444877703, 17985.0, 18208.45374638763, 577749.0, 628972.0, 640201.0, 646630.0, 648579.0, 56629.0, 61938.69030654818, 62529.374706253264, 62567.6871615639, 62705.05942410776, 1501.6696326808085, 1522.695460907823, 1531.9923400382704, 1537.9461718840012, 1538.8230353509489, 31428.685713142575, 32177.839110804296, 32595.674043259263, 32663.0, 32976.0, 52032.0, 52511.21233181429, 52643.47356526539, 52749.0, 52891.0, 412978.0, 415598.0, 415974.0, 416158.0, 416526.91736542335, 29209.85395073011, 29964.250893727833, 30166.698333017266, 30295.545566816956, 52433.95132097413, 53835.73082134564, 53871.191932120266, 56904.71547642235, 58066.129008065756, 58332.4166758327, 46390.76804615955, 48570.271445929044, 48945.75527122342, 49236.0, 49254.507454926425, 46331.53668463272, 47183.52816471929, 47622.28566571573, 47742.283865741345, 47922.0, 47416.52583474121, 47487.52512474831, 48179.0, 48239.75880120577, 48662.513374867216, 40222.79888600538, 40359.59640403558, 41294.58705412907, 41377.1724565513, 42040.579594203664, 31047.84476077605, 32047.198820029687, 32062.6793732069, 32139.839300803345, 32352.676473234966], "value": 20634.469341573345, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [433.737588758801, 435.9025163463443, 436.13862621322886, 436.46197362337983, 448.6231565484992, 19183.13675884585, 20383.388498345073, 20767.792322076795, 21431.14275428981, 21501.56996860062, 19703.605927881435, 20030.198792048337, 20872.89563552184, 20873.269435569757, 20942.790572094276, 5853.707314634262, 6025.186599809013, 6056.818295451144, 6063.393660633923, 6077.209962704842, 5464.672119672812, 5752.050911599581, 5758.884822303551, 5873.148393482942, 5954.987652099154, 5553.888922221553, 5785.450382213683, 5832.241808564881, 6089.78685745999, 6091.208142941434, 6022.518198544106, 6027.367126451725, 6088.786892458787, 6110.266767987848, 6118.388161183891, 5704.629199102045, 5843.590948633555, 5855.882882342372, 5858.589898707092, 5872.647641141545, 14290.857091429161, 14625.78061329081, 16252.75620865688, 24055.398615034588, 24186.879065604735, 2149.7850214978534, 2226.4879077812193, 2431.58663027284, 2451.6077427611676, 2481.994349608041, 10745.570177192903, 10869.510872010778, 10947.233693641449, 11048.889511104946, 11106.888931110747, 1969.5962327722782, 2053.5071582820015, 2062.7730949595534, 2071.85497015209, 2086.040421406155, 83610.0, 87691.56154219188, 89593.0, 89708.99999999935, 90565.54717226437, 10616.628418005334, 10713.303635263683, 10859.565617375216, 11651.59219427316, 11890.28658280506, 16616.58458538522, 16720.41478548245, 16745.497635070966, 16786.58033549171, 16807.663846722997, 8427.831443371098, 8433.018240713427, 8560.529170895661, 8721.694740684046, 8804.823903521894, 8107.554084525408, 8131.390145739093, 8290.419670622998, 8309.335253179852, 8509.787255318543, 4870.707757534559, 5043.646944713908, 5057.6459647824295, 5068.214426763858, 5164.793408263702, 2051.476873397274, 2076.8753874767563, 2107.757607875114, 2112.619728448863, 2161.14634719285, 985.3595163144014, 1081.1999120650662, 1120.7702421003676, 1134.1663877050526, 1146.7821113988316, 19854.70217946732, 20578.176872924916, 20591.8970405147, 20731.0, 20957.58084838325, 1059.6662051453768, 1061.8247989081715, 1063.2238465919768, 1079.2445288298222, 1117.5976648406568, 10127.9057609871, 11349.546018159346, 11410.315381077162, 11541.76916461666, 11701.0, 478493.74225278874, 478658.0, 479968.0, 481583.0, 484919.0, 70923.0, 85843.57078214569, 87413.0, 94604.0, 99073.50463247638, 1007.4559737741685, 1047.2564479219839, 1047.2669131607904, 1060.2684147937898, 1081.6592773276393, 17944.820551794837, 18425.0, 18596.81403186005, 18672.25310987545, 18718.064096795377, 39290.410643839794, 41977.0, 42310.153796923274, 42685.78657106694, 42811.0, 57191.42808571861, 57221.0, 61068.0, 61105.083423749566, 61398.0, 7930.722424715338, 7981.161977992228, 8332.833343333221, 8343.874841877498, 9032.819343613222, 13121.540746073842, 13691.0, 14139.293035347986, 14366.209858457885, 14424.927875360556, 6311.116443697978, 10191.980801919748, 11732.0, 12258.14193006481, 12286.139970202357, 7917.7624671259955, 9880.20958323318, 11996.160268781101, 12296.877031229573, 12519.499220031097, 6744.69648865812, 11473.254238474472, 11914.642560723192, 12494.37528123572, 12754.68113297175, 8895.955520222358, 9204.447733136034, 9291.907080929375, 9372.109649583279, 9390.906090939003, 12508.124431289722, 12621.495140194289, 12717.10980231375, 12767.61697149087, 12888.097833151589], "value": 9498.348220989918, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1563.0543521169693, 1586.468533041431, 1810.6650269700106, 1922.0581914861723, 1960.950976225594, 9326.766830829232, 9579.52102394881, 9710.805783884327, 9781.951090244556, 9788.902110978897, 9638.807223855518, 9786.363886347383, 9801.362911410772, 9851.75370615735, 9898.35660682057, 2516.6099254615565, 2541.542522345977, 2557.539642864284, 2566.6021766626204, 2570.5630042892753, 2507.636392723054, 2557.3862273054424, 2559.6160575913577, 2561.129216066537, 2566.358410397401, 2494.9251522454265, 2505.2734706934966, 2508.949821003579, 2530.595104783235, 2542.6821647294087, 2396.532676128156, 2445.5720248956363, 2450.791682706963, 2460.1635443949144, 2464.4085419499193, 2454.3005243505695, 2474.0969546115716, 2507.122507122511, 2520.193538067819, 2546.1852207293673, 9414.576344064533, 9511.857322140173, 9535.666251681158, 9541.141297283279, 9559.426434413957, 5751.424857514257, 5884.470397664188, 5889.676067816268, 5917.905187540276, 5931.021381472052, 3600.4959305697225, 3675.9448608270895, 3691.151035261878, 3696.611855755134, 3809.7714137151584, 1201.8497687789027, 1214.9878501214964, 1250.0874361715908, 1255.598208573257, 1278.859325474197, 13451.125676830974, 13479.932600336935, 13522.729545409135, 13536.05247632666, 13647.976401769907, 4805.37530121089, 4891.730954797449, 4989.151844186497, 5014.5737612303365, 5035.697858128524, 10472.581096756045, 10537.84193237102, 10559.102476289601, 10566.101881340172, 10570.0, 5679.488846003879, 5704.429557044263, 5728.0, 5785.190073389729, 5794.246747922827, 5131.025105229995, 5271.314729085195, 5348.625596208306, 5368.355797304349, 5374.140137577969, 4413.536578659258, 4439.600435960779, 4463.218936686132, 4477.910441791146, 4514.932276015862, 1313.1792629606496, 1412.6185929798896, 1419.141419441244, 1424.3519198764745, 1443.8339590946966, 901.7970956534728, 1094.584058057933, 1125.3754166437543, 1132.7281452451516, 1138.1293310617384, 6410.294867564564, 6462.4183823456115, 6468.482521398277, 6574.572652777554, 6603.372679595431, 470.8187347871026, 476.7306471843397, 482.0599830330799, 488.05317683694227, 497.0729589315972, 4685.765711714401, 4705.364775755229, 4742.407199100113, 4746.928796068062, 4770.212914869077, 11828.0, 12023.63929082129, 12024.398780060961, 12043.518259269706, 12110.636680899586, 11254.324740515594, 11686.24039437434, 11803.645890623295, 12018.0, 12096.334701591497, 8895.866562001574, 9002.729918102468, 9073.047330030384, 9129.087091290818, 9153.084691530927, 6484.805455836333, 6760.884454065221, 6829.419499342413, 6893.310668933066, 6954.756583519553, 11061.834072488758, 11164.88835111671, 11177.329360238411, 11207.327560346404, 11400.486978086172, 11097.500612472619, 11439.714007149887, 11474.082073434272, 11483.25358851672, 11501.712457188303, 7613.809654758676, 8162.387820913336, 8194.262516373556, 8463.153684631488, 8539.060703322753, 9140.085991400807, 9178.357514974155, 9182.219511341611, 9257.583408746488, 9263.76840578964, 8183.6726530938095, 8338.583070846313, 8381.203785640355, 8445.746627601182, 8466.238038576557, 8067.636956337096, 8190.836183276182, 8191.83616327682, 8254.339652827879, 8394.45436046655, 7224.2414546473965, 7534.510256833289, 7534.698612055676, 7556.0, 7592.240775922363, 5460.918086228789, 5752.597318187687, 5788.305403351625, 5805.245318108618, 5901.144334071621, 5704.686242256716, 5762.855928601651, 5768.278965129359, 5769.62497437682, 5886.23478947734], "value": 4986.250900039409, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.9666581674742, 351.67997122618425, 353.6057296114831, 354.30025699243987, 361.734125417818, 5830.154627579004, 5850.531957443405, 5868.3838196989345, 5895.380984996573, 5925.348211696721, 5622.0, 5669.6314739542, 5693.886122277552, 5772.365039845614, 5801.390853960336, 4515.735594033659, 4530.977345113278, 4550.953280745431, 4561.247394179956, 4561.608709343649, 4562.543745625428, 4563.977180114095, 4574.542545745432, 4585.908281834361, 4592.334111553822, 4505.819767209307, 4535.548624440181, 4547.8180872765215, 4559.452865656126, 4571.794269257892, 4216.325387937931, 4433.866983990485, 4450.844220452284, 4451.910961780779, 4464.732116073046, 3882.301185786557, 3896.7272290939645, 3898.2593307271814, 3911.647951684362, 3915.8433662653742, 5622.803201887955, 5624.29696287964, 5631.155326700987, 5636.943630563724, 5655.802046928379, 4942.975285123587, 5116.948830511685, 5127.230915362688, 5168.638195326329, 5179.9381126869275, 6099.817005489843, 6101.633901965896, 6145.293291271516, 6160.059581231898, 6167.599106058092, 4236.555161708007, 4295.140971805651, 4306.20335237982, 4327.285997810358, 4338.392625032498, 6012.518998480111, 6193.040078787795, 6351.777687780952, 6356.298573106411, 6391.808245752588, 4339.392485052095, 4365.126974605092, 4372.846950356722, 4377.8248870044845, 4424.491183513937, 4417.116576684612, 4423.889402764892, 4427.46870375557, 4459.353393757887, 4474.306482495218, 4927.605791536668, 5093.9745301274, 5171.81898633546, 5175.560077393464, 5194.506521880416, 6067.150598916155, 6075.453209211192, 6076.635401875901, 6087.665178415141, 6098.756049758049, 1523.988335397265, 1538.8461153884746, 1540.6764579438443, 1542.082460935764, 1548.5122186511212, 933.4446004627235, 966.6133546581424, 974.3617930255552, 984.675057231112, 987.6543209876486, 5201.427842937273, 5231.476852314738, 5286.8368958829, 5299.099153143975, 5313.54834839043, 5535.7785688572, 5555.2222688823595, 5593.916091258634, 5636.549076073904, 5705.828825135252, 4943.876403089879, 5150.639455238097, 5285.312909321764, 5314.441983591744, 5334.226537152169, 2936.280611250215, 2963.5702823090533, 2973.9553906691417, 2982.657803988214, 2982.762153706231, 5718.856228754183, 5731.426857314235, 5757.798477053283, 5759.308882934075, 5828.388019258002, 5888.087346461305, 6384.553081284265, 6440.291567927524, 6454.483641308684, 6455.806325810233, 6534.379233972765, 6542.901856472156, 6579.736810527621, 6593.604383736991, 6627.237867645186, 6140.662263575547, 6387.435078405821, 6411.871762564816, 6416.48668106541, 6419.807405777834, 6056.485198758155, 6264.624122552661, 6322.49420046386, 6367.299597044229, 6372.776952806629, 6380.234371875405, 6506.4469520091325, 6532.804015879531, 6533.216014078341, 6534.0, 4407.140607581619, 4451.6661250405705, 4460.330950357472, 4470.7764611769935, 4471.977640111779, 6284.874302514016, 6291.402316779899, 6351.872962540631, 6356.650384228912, 6423.903641445476, 6142.32434432221, 6171.876562468815, 6212.9068063978175, 6225.28409232944, 6238.284471770299, 5947.364474769473, 6159.922013647683, 6188.628682279078, 6195.2255968004, 6217.658028808459, 6037.396260373927, 6101.359357267423, 6159.922013647683, 6173.166622505904, 6197.101420294122, 6148.200733904564, 6152.16945712341, 6170.50635949132, 6180.443760061616, 6250.781097685907, 5790.392008839011, 6030.0, 6061.15143879866, 6093.878122437615, 6108.480779133645], "value": 4570.91881309304, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [746.6154930210943, 832.3008672714918, 833.937454690898, 864.8702694595812, 878.8066625342423, 14813.259337033145, 14865.702685946288, 14868.256587170652, 14881.18153501557, 15751.0, 15253.618659533517, 15342.616434589114, 15458.458953936615, 15475.380984760595, 15508.224588770572, 707.5507053021317, 824.7690646618927, 852.9232369086781, 856.2764464027917, 869.5261082709939, 848.6690190825583, 853.5134973065356, 854.0434713121313, 854.7350321400386, 857.237059017475, 892.6117139044536, 894.7807787092172, 895.1451363947447, 895.3598177303227, 899.1323372945106, 878.7407714724204, 883.5979629268668, 884.9292056635486, 887.5517863478966, 888.595688961521, 653.1182903080851, 653.7581094994835, 654.1300070905684, 654.6170490263202, 655.017473789316, 14017.158970461805, 14167.433302667881, 14169.858301416956, 14253.429862805475, 14326.283685815668, 14148.434062637481, 14202.92898535511, 14214.644633884132, 14410.495632652806, 15057.397704091823, 12139.817902731465, 12219.694507637292, 12261.877381226252, 12418.81371779424, 12559.874401255962, 3999.6600288975474, 4050.7772072536295, 4072.694547908889, 4166.354215096665, 4211.473565804275, 79433.0, 80731.0, 81002.59498702528, 81269.59365203195, 82189.58905205436, 11280.32318060919, 11282.266652667551, 11389.94305028486, 11464.713382165513, 11484.196106272648, 22434.653920764806, 22522.774772252396, 22680.319590411986, 22709.0, 22759.203427879944, 8141.307988820898, 9035.537049795757, 9187.678431254873, 9242.075792420705, 9328.113829186352, 4945.826896058621, 4987.401511818605, 5081.136206844845, 5181.0, 5215.348081489814, 3429.8113603751535, 3529.964700353015, 3545.556805399325, 3557.324108419392, 3578.8926332210076, 625.8091282158895, 631.8925782616966, 633.1420924647036, 633.4299130782241, 645.6481217736344, 656.875193713193, 662.2781168526329, 664.2394458345168, 700.2997002997002, 720.8233982674278, 8904.332175086765, 9333.206677432494, 9520.0, 9584.329096963285, 9627.711168664951, 693.1370443797505, 708.4084789201074, 714.0752725220851, 719.6833393306928, 721.2210812322784, 4476.910461790746, 4592.173408786451, 4623.398958135421, 4644.117617652635, 4825.30033145199, 85961.0, 107473.4626326879, 108841.0, 108989.0, 113556.43221784003, 99830.50084749675, 101658.49170754099, 101968.0, 102879.0, 102879.48560257151, 89826.55086724524, 90512.6423103654, 90558.54720726355, 90566.0, 91410.0, 8974.955125224593, 9014.459132452073, 9017.864732029157, 9039.81920361576, 9073.863892041492, 53798.731006344715, 55093.44906550883, 55314.44685553093, 55555.44444555664, 55568.48238967425, 72475.0, 76503.01601885457, 77152.22847771451, 78519.0, 78531.0, 10619.575216991234, 10739.248252622554, 10747.731306717395, 10972.286801357886, 11172.329660220414, 12336.136470446983, 12471.0, 12472.625821225378, 12938.353082346033, 12979.675508111995, 11422.771544568895, 11692.415379231175, 11832.645020649394, 11839.408029598659, 12078.818817717565, 11593.130515211562, 11670.416479175838, 11929.522819087138, 12046.638600841989, 12127.332996685267, 10846.945765271123, 10875.728106797076, 11299.3785341807, 11321.830172547254, 11437.885621143681, 9903.108720215216, 10532.89467105319, 10704.678859634223, 11202.83195752048, 11732.0, 11476.942615286871, 11598.420078996185, 11744.236624619372, 12163.756724865276, 12306.384680766105], "value": 7508.581239899033, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1520.7999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 105.0, 110.0, 111.0, 110.0, 112.0, 111.0, 111.0, 110.0, 110.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 127.0, 155.0, 184.0, 127.0, 158.0, 159.0, 129.0, 194.0, 125.0], "value": 151.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 164.0, 163.0, 164.0, 164.0, 162.0, 164.0, 165.0, 170.0, 163.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 180.0, 77.0, 76.0, 76.0, 76.0, 160.0, 76.0], "value": 94.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 145.0, 84.0, 85.0, 85.0, 141.0, 84.0, 85.0, 151.0], "value": 103.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 122.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 151.0, 148.0, 147.0, 147.0, 147.0, 146.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 97.0, 104.0, 100.0, 96.0, 95.0, 97.0, 95.0, 95.0], "value": 97.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 55.0, 52.0, 55.0, 52.0, 54.0, 63.0, 52.0, 54.0, 58.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 59.0, 60.0, 62.0, 61.0, 60.0, 66.0, 61.0, 59.0], "value": 60.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 77.0, 81.0, 83.0, 77.0, 84.0, 84.0, 105.0, 84.0], "value": 83.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 119.0, 120.0, 118.0, 118.0, 128.0, 120.0, 120.0, 137.0, 121.0], "value": 122.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 151.0, 154.0, 152.0, 152.0, 149.0, 152.0, 152.0, 153.0, 154.0], "value": 152.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 61.0, 65.0, 61.0, 63.0, 59.0, 62.0, 62.0], "value": 61.8, "unit": "score"}]}]} 03:28:37 INFO - Return code: 0 03:28:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:28:37 ERROR - # TBPL SUCCESS # 03:28:37 INFO - Running post-action listener: _resource_record_post_action 03:28:37 INFO - ##### 03:28:37 INFO - ##### Finished run-tests step (success) 03:28:37 INFO - ##### 03:28:37 INFO - Running post-run listener: _resource_record_post_run 03:28:38 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 290816; Write bytes: 503574528; Read time: 36; Write time: 369984 03:28:38 INFO - TinderboxPrint: CPU usage
13.4% 03:28:38 INFO - TinderboxPrint: I/O read bytes / time
290,816 / 36 03:28:38 INFO - TinderboxPrint: I/O write bytes / time
503,574,528 / 369,984 03:28:38 INFO - TinderboxPrint: CPU idle
8,214.4 (86.6%) 03:28:38 INFO - TinderboxPrint: CPU user
1,215.4 (12.8%) 03:28:38 INFO - TinderboxPrint: Swap in / out
0 / 0 03:28:38 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 252706816; Read time: 0; Write time: 228596 03:28:38 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 266240; Write bytes: 250867712; Read time: 24; Write time: 141388 03:28:38 INFO - Running post-run listener: _upload_blobber_files 03:28:38 INFO - Blob upload gear active. 03:28:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:28:38 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 03:28:38 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:28:38 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:28:38 INFO - (blobuploader) - INFO - Open directory for files ... 03:28:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:28:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:28:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:28:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:28:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:28:42 INFO - (blobuploader) - INFO - Done attempting. 03:28:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:28:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:28:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:28:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:28:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:28:43 INFO - (blobuploader) - INFO - Done attempting. 03:28:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:28:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:28:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:28:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:28:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:28:43 INFO - (blobuploader) - INFO - Done attempting. 03:28:43 INFO - (blobuploader) - INFO - Iteration through files over. 03:28:43 INFO - Return code: 0 03:28:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:28:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:28:43 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e6a1ed39ad8a38674a8b9b9a7370db21818ecc9f824282ebac8398a29f13da0d4ef585a1edcabbdc0f2733d3dd53f6c529ea5f7b6bcc85ea486c1fa1082b24c9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/164dde28b1ad5473c264e81e250931f478fc0a247a8006ee537ea419073d0e056a40b531f0ccff1246736661d519ee96d57b2c75968c19fba529b6317a87a194", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0218d956c9e8d35785c6c8935e5473db5ecc310cc8488e8b26910ff8e9580d8cbe31f21f3624c90730b84cd5337fdd7bf2397ae12c2329f6313df33a36e37c59"} 03:28:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:28:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:28:43 INFO - Contents: 03:28:43 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e6a1ed39ad8a38674a8b9b9a7370db21818ecc9f824282ebac8398a29f13da0d4ef585a1edcabbdc0f2733d3dd53f6c529ea5f7b6bcc85ea486c1fa1082b24c9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/164dde28b1ad5473c264e81e250931f478fc0a247a8006ee537ea419073d0e056a40b531f0ccff1246736661d519ee96d57b2c75968c19fba529b6317a87a194", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0218d956c9e8d35785c6c8935e5473db5ecc310cc8488e8b26910ff8e9580d8cbe31f21f3624c90730b84cd5337fdd7bf2397ae12c2329f6313df33a36e37c59"} 03:28:43 INFO - Running post-run listener: copy_logs_to_upload_dir 03:28:43 INFO - Copying logs to upload dir... 03:28:43 INFO - mkdir: /builds/slave/test/build/upload/logs 03:28:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.804217 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-06-30 03:28:43.684245) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 03:28:43.692028) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1467279608.536344-1779553719 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/Mozilla-Aurora/sha512/e6a1ed39ad8a38674a8b9b9a7370db21818ecc9f824282ebac8398a29f13da0d4ef585a1edcabbdc0f2733d3dd53f6c529ea5f7b6bcc85ea486c1fa1082b24c9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/164dde28b1ad5473c264e81e250931f478fc0a247a8006ee537ea419073d0e056a40b531f0ccff1246736661d519ee96d57b2c75968c19fba529b6317a87a194", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0218d956c9e8d35785c6c8935e5473db5ecc310cc8488e8b26910ff8e9580d8cbe31f21f3624c90730b84cd5337fdd7bf2397ae12c2329f6313df33a36e37c59"} build_url:https://queue.taskcluster.net/v1/task/GQHYwunHQ52FW7sPI4yVEQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011389 build_url: 'https://queue.taskcluster.net/v1/task/GQHYwunHQ52FW7sPI4yVEQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e6a1ed39ad8a38674a8b9b9a7370db21818ecc9f824282ebac8398a29f13da0d4ef585a1edcabbdc0f2733d3dd53f6c529ea5f7b6bcc85ea486c1fa1082b24c9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/164dde28b1ad5473c264e81e250931f478fc0a247a8006ee537ea419073d0e056a40b531f0ccff1246736661d519ee96d57b2c75968c19fba529b6317a87a194", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0218d956c9e8d35785c6c8935e5473db5ecc310cc8488e8b26910ff8e9580d8cbe31f21f3624c90730b84cd5337fdd7bf2397ae12c2329f6313df33a36e37c59"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 03:28:43.720849) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 03:28:43.721313) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1467279608.536344-1779553719 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004468 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 03:28:43.805423) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 03:28:43.807029) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 03:28:43.807332) ========= ========= Total master_lag: 0.18 =========