builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-064 starttime: 1465437206.69 results: success (0) buildid: 20160608162130 builduid: e7fb6fde1ab84048a2ef78273e087856 revision: 214e3a1a150a65e5400ff67f5eb5fb048929b183 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 18:53:26.691926) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 18:53:26.692457) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 18:53:26.692798) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 18:53:26.709107) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 18:53:26.709783) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1465436853.792480-1095647097 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-08 18:53:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 213M=0s 2016-06-08 18:53:27 (213 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.071101 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 18:53:26.800321) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 18:53:26.801134) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1465436853.792480-1095647097 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015438 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 18:53:26.852907) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 18:53:26.853330) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 214e3a1a150a65e5400ff67f5eb5fb048929b183 --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 214e3a1a150a65e5400ff67f5eb5fb048929b183 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1465436853.792480-1095647097 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-08 18:53:27,746 truncating revision to first 12 chars 2016-06-08 18:53:27,746 Setting DEBUG logging. 2016-06-08 18:53:27,746 attempt 1/10 2016-06-08 18:53:27,746 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/214e3a1a150a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-08 18:53:28,049 unpacking tar archive at: mozilla-aurora-214e3a1a150a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.646405 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 18:53:27.514973) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 18:53:27.515378) ========= script_repo_revision: 214e3a1a150a65e5400ff67f5eb5fb048929b183 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 18:53:27.515865) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 18:53:27.516186) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 18:53:27.527092) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-06-08 18:53:27.527674) ========= /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=a12cd81e0ef515edd9e0d800000001bb-1465436853.792480-1095647097 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:53:28 INFO - MultiFileLogger online at 20160608 18:53:28 in /builds/slave/test 18:53:28 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 18:53:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:53:28 INFO - {'append_to_log': False, 18:53:28 INFO - 'base_work_dir': '/builds/slave/test', 18:53:28 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 18:53:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:53:28 INFO - 'branch': 'Mozilla-Aurora', 18:53:28 INFO - 'buildbot_json_path': 'buildprops.json', 18:53:28 INFO - 'config_files': ('talos/linux_config.py',), 18:53:28 INFO - 'default_actions': ('clobber', 18:53:28 INFO - 'read-buildbot-config', 18:53:28 INFO - 'download-and-extract', 18:53:28 INFO - 'populate-webroot', 18:53:28 INFO - 'create-virtualenv', 18:53:28 INFO - 'install', 18:53:28 INFO - 'run-tests'), 18:53:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:53:28 INFO - 'download_minidump_stackwalk': True, 18:53:28 INFO - 'download_symbols': 'ondemand', 18:53:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:53:28 INFO - 'tooltool.py': '/tools/tooltool.py', 18:53:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:53:28 INFO - '/tools/misc-python/virtualenv.py')}, 18:53:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:53:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:53:28 INFO - 'installer_path': 'installer.exe', 18:53:28 INFO - 'log_level': 'info', 18:53:28 INFO - 'log_name': 'talos', 18:53:28 INFO - 'log_to_console': True, 18:53:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:53:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:53:28 INFO - 'opt_config_files': (), 18:53:28 INFO - 'pip_index': False, 18:53:28 INFO - 'sps_profile': False, 18:53:28 INFO - 'sps_profile_interval': 0, 18:53:28 INFO - 'suite': 'dromaeojs-e10s', 18:53:28 INFO - 'system_bits': '32', 18:53:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:53:28 INFO - 'title': 'talos-linux64-ix-064', 18:53:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:53:28 INFO - 'use_talos_json': True, 18:53:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:53:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:53:28 INFO - 'work_dir': 'build'} 18:53:28 INFO - ##### 18:53:28 INFO - ##### Running clobber step. 18:53:28 INFO - ##### 18:53:28 INFO - Running pre-action listener: _resource_record_pre_action 18:53:28 INFO - Running main action method: clobber 18:53:28 INFO - rmtree: /builds/slave/test/build 18:53:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:53:28 INFO - Running post-action listener: _resource_record_post_action 18:53:28 INFO - ##### 18:53:28 INFO - ##### Finished clobber step (success) 18:53:28 INFO - ##### 18:53:28 INFO - ##### 18:53:28 INFO - ##### Running read-buildbot-config step. 18:53:28 INFO - ##### 18:53:28 INFO - Running pre-action listener: _resource_record_pre_action 18:53:28 INFO - Running main action method: read_buildbot_config 18:53:28 INFO - Using buildbot properties: 18:53:28 INFO - { 18:53:28 INFO - "project": "", 18:53:28 INFO - "product": "firefox", 18:53:28 INFO - "script_repo_revision": "production", 18:53:28 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 18:53:28 INFO - "repository": "", 18:53:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 18:53:28 INFO - "buildid": "20160608162130", 18:53:28 INFO - "pgo_build": "True", 18:53:28 INFO - "basedir": "/builds/slave/test", 18:53:28 INFO - "buildnumber": 345, 18:53:28 INFO - "slavename": "talos-linux64-ix-064", 18:53:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:53:28 INFO - "platform": "ubuntu64_hw", 18:53:28 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 18:53:28 INFO - "branch": "mozilla-aurora", 18:53:28 INFO - "repo_path": "releases/mozilla-aurora", 18:53:28 INFO - "revision": "214e3a1a150a65e5400ff67f5eb5fb048929b183", 18:53:28 INFO - "stage_platform": "linux64-pgo", 18:53:28 INFO - "builduid": "e7fb6fde1ab84048a2ef78273e087856", 18:53:28 INFO - "slavebuilddir": "test" 18:53:28 INFO - } 18:53:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/aa32Osp6SBu1BHhbpV2-ew/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 18:53:28 INFO - Running post-action listener: _resource_record_post_action 18:53:28 INFO - ##### 18:53:28 INFO - ##### Finished read-buildbot-config step (success) 18:53:28 INFO - ##### 18:53:28 INFO - ##### 18:53:28 INFO - ##### Running download-and-extract step. 18:53:28 INFO - ##### 18:53:28 INFO - Running pre-action listener: _resource_record_pre_action 18:53:28 INFO - Running main action method: download_and_extract 18:53:28 INFO - mkdir: /builds/slave/test/build/tests 18:53:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:28 INFO - https://queue.taskcluster.net/v1/task/aa32Osp6SBu1BHhbpV2-ew/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:53:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aa32Osp6SBu1BHhbpV2-ew/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 18:53:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aa32Osp6SBu1BHhbpV2-ew/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 18:53:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aa32Osp6SBu1BHhbpV2-ew/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 18:53:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aa32Osp6SBu1BHhbpV2-ew/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 18:53:29 INFO - Downloaded 1361 bytes. 18:53:29 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 18:53:29 INFO - Using the following test package requirements: 18:53:29 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 18:53:29 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 18:53:29 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 18:53:29 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 18:53:29 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 18:53:29 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 18:53:29 INFO - u'jsshell-linux-x86_64.zip'], 18:53:29 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 18:53:29 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 18:53:29 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 18:53:29 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 18:53:29 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 18:53:29 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 18:53:29 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 18:53:29 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 18:53:29 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 18:53:29 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 18:53:29 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 18:53:29 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:53: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')]} 18:53:29 INFO - https://queue.taskcluster.net/v1/task/aa32Osp6SBu1BHhbpV2-ew/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:53:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aa32Osp6SBu1BHhbpV2-ew/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 18:53:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aa32Osp6SBu1BHhbpV2-ew/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 18:53:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aa32Osp6SBu1BHhbpV2-ew/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 18:53:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aa32Osp6SBu1BHhbpV2-ew/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 18:53:32 INFO - Downloaded 24473779 bytes. 18:53:32 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'] 18:53:32 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 18:53:34 INFO - Return code: 0 18:53:34 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 18:53: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')]} 18:53:34 INFO - https://queue.taskcluster.net/v1/task/aa32Osp6SBu1BHhbpV2-ew/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:53:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aa32Osp6SBu1BHhbpV2-ew/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 18:53:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aa32Osp6SBu1BHhbpV2-ew/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 18:53:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aa32Osp6SBu1BHhbpV2-ew/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 18:53:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aa32Osp6SBu1BHhbpV2-ew/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 18:53:35 INFO - Downloaded 24473779 bytes. 18:53:35 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'] 18:53:35 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 18:53:36 INFO - Return code: 0 18:53:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:36 INFO - https://queue.taskcluster.net/v1/task/aa32Osp6SBu1BHhbpV2-ew/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:53:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aa32Osp6SBu1BHhbpV2-ew/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 18:53:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aa32Osp6SBu1BHhbpV2-ew/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 18:53:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aa32Osp6SBu1BHhbpV2-ew/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 18:53:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aa32Osp6SBu1BHhbpV2-ew/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 18:53:37 INFO - Downloaded 10833369 bytes. 18:53:37 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'] 18:53:37 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 18:53:37 INFO - Return code: 0 18:53:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:37 INFO - https://queue.taskcluster.net/v1/task/aa32Osp6SBu1BHhbpV2-ew/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:53:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aa32Osp6SBu1BHhbpV2-ew/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 18:53:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aa32Osp6SBu1BHhbpV2-ew/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 18:53:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aa32Osp6SBu1BHhbpV2-ew/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 18:53:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aa32Osp6SBu1BHhbpV2-ew/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 18:53:39 INFO - Downloaded 63574221 bytes. 18:53:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aa32Osp6SBu1BHhbpV2-ew/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 18:53:39 INFO - mkdir: /builds/slave/test/properties 18:53:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:53:39 INFO - Writing to file /builds/slave/test/properties/build_url 18:53:39 INFO - Contents: 18:53:39 INFO - build_url:https://queue.taskcluster.net/v1/task/aa32Osp6SBu1BHhbpV2-ew/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 18:53:40 INFO - Running post-action listener: _resource_record_post_action 18:53:40 INFO - Running post-action listener: set_extra_try_arguments 18:53:40 INFO - ##### 18:53:40 INFO - ##### Finished download-and-extract step (success) 18:53:40 INFO - ##### 18:53:40 INFO - ##### 18:53:40 INFO - ##### Running populate-webroot step. 18:53:40 INFO - ##### 18:53:40 INFO - Running pre-action listener: _resource_record_pre_action 18:53:40 INFO - Running main action method: populate_webroot 18:53:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:53:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:53:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:53:40 INFO - '--tppagecycles', 18:53:40 INFO - '7'], 18:53:40 INFO - 'tests': ['tsvgm']}}, 18:53:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:53:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:53:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:53:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:53:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:53:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:53:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:53:40 INFO - 'talos_options': ['--disable-e10s'], 18:53:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:53:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:53:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:53:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:53:40 INFO - 'talos_options': ['--disable-e10s'], 18:53:40 INFO - 'tests': ['damp', 'tps']}, 18:53:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:53:40 INFO - 'tests': ['damp', 'tps']}, 18:53:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:53:40 INFO - 'tests': ['dromaeo_dom']}, 18:53:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:53:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:53:40 INFO - 'tests': ['a11yr', 18:53:40 INFO - 'ts_paint', 18:53:40 INFO - 'tpaint', 18:53:40 INFO - 'sessionrestore', 18:53:40 INFO - 'sessionrestore_no_auto_restore', 18:53:40 INFO - 'tabpaint']}, 18:53:40 INFO - 'other-e10s': {'tests': ['a11yr', 18:53:40 INFO - 'ts_paint', 18:53:40 INFO - 'tpaint', 18:53:40 INFO - 'sessionrestore', 18:53:40 INFO - 'sessionrestore_no_auto_restore', 18:53:40 INFO - 'tabpaint']}, 18:53:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:53:40 INFO - 'ts_paint', 18:53:40 INFO - 'tpaint', 18:53:40 INFO - 'sessionrestore', 18:53:40 INFO - 'sessionrestore_no_auto_restore', 18:53:40 INFO - 'tabpaint']}, 18:53:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:53:40 INFO - 'ts_paint', 18:53:40 INFO - 'tpaint', 18:53:40 INFO - 'sessionrestore', 18:53:40 INFO - 'sessionrestore_no_auto_restore', 18:53:40 INFO - 'tabpaint']}, 18:53:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:53:40 INFO - 'tests': ['a11yr', 18:53:40 INFO - 'ts_paint', 18:53:40 INFO - 'tpaint', 18:53:40 INFO - 'sessionrestore', 18:53:40 INFO - 'sessionrestore_no_auto_restore', 18:53:40 INFO - 'tabpaint']}, 18:53:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:53:40 INFO - 'tests': ['a11yr', 18:53:40 INFO - 'ts_paint', 18:53:40 INFO - 'tpaint', 18:53:40 INFO - 'sessionrestore', 18:53:40 INFO - 'sessionrestore_no_auto_restore', 18:53:40 INFO - 'tabpaint']}, 18:53:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:53:40 INFO - 'tests': ['tsvgx', 18:53:40 INFO - 'tsvgr_opacity', 18:53:40 INFO - 'tart', 18:53:40 INFO - 'tscrollx', 18:53:40 INFO - 'cart']}, 18:53:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:53:40 INFO - 'tsvgr_opacity', 18:53:40 INFO - 'tart', 18:53:40 INFO - 'tscrollx', 18:53:40 INFO - 'cart']}, 18:53:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:53:40 INFO - 'talos_options': ['--disable-e10s'], 18:53:40 INFO - 'tests': ['tp5o']}, 18:53:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:53:40 INFO - 'tests': ['tp5o']}, 18:53:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:53:40 INFO - 'talos_options': ['--disable-e10s', 18:53:40 INFO - '--xperf_path', 18:53:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:53:40 INFO - 'tests': ['tp5n']}, 18:53:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:53:40 INFO - 'talos_options': ['--xperf_path', 18:53:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:53:40 INFO - 'tests': ['tp5n']}}, 18:53:40 INFO - 'talos.zip': {'path': '', 18:53:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:53:40 INFO - Running post-action listener: _resource_record_post_action 18:53:40 INFO - ##### 18:53:40 INFO - ##### Finished populate-webroot step (success) 18:53:40 INFO - ##### 18:53:40 INFO - ##### 18:53:40 INFO - ##### Running create-virtualenv step. 18:53:40 INFO - ##### 18:53:40 INFO - Running pre-action listener: _resource_record_pre_action 18:53:40 INFO - Running main action method: create_virtualenv 18:53:40 INFO - Creating virtualenv /builds/slave/test/build/venv 18:53:40 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:53:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:53:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:53:40 INFO - Using real prefix '/usr' 18:53:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:53:40 INFO - Installing distribute.............................................................................................................................................................................................done. 18:53:42 INFO - Installing pip.................done. 18:53:42 INFO - Return code: 0 18:53:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:53:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:53:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:53:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:42 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 0x7fd9fabc1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c0b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9a1c0>, '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 0x2c9b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9b550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1465436853.792480-1095647097', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:53:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:53:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:53:42 INFO - Using env: {'DISPLAY': ':0', 18:53:42 INFO - 'HOME': '/home/cltbld', 18:53:42 INFO - 'LANG': 'en_US.UTF-8', 18:53:42 INFO - 'LANGUAGE': 'en_US:en', 18:53:42 INFO - 'LOGNAME': 'cltbld', 18:53:42 INFO - 'MAIL': '/var/mail/cltbld', 18:53:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:42 INFO - 'MOZ_NO_REMOTE': '1', 18:53:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:53:42 INFO - 'NO_EM_RESTART': '1', 18:53:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:53:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:53:42 INFO - 'PWD': '/builds/slave/test', 18:53:42 INFO - 'SHELL': '/bin/bash', 18:53:42 INFO - 'SHLVL': '1', 18:53:42 INFO - 'TERM': 'linux', 18:53:42 INFO - 'TMOUT': '86400', 18:53:42 INFO - 'USER': 'cltbld', 18:53:42 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1465436853.792480-1095647097', 18:53:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:42 INFO - '_': '/tools/buildbot/bin/python'} 18:53:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:53:42 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:53:42 INFO - Cleaning up... 18:53:43 INFO - Return code: 0 18:53:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:53:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:53:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:53:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:43 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 0x7fd9fabc1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c0b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9a1c0>, '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 0x2c9b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9b550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1465436853.792480-1095647097', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:53:43 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 18:53:43 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 18:53:43 INFO - Using env: {'DISPLAY': ':0', 18:53:43 INFO - 'HOME': '/home/cltbld', 18:53:43 INFO - 'LANG': 'en_US.UTF-8', 18:53:43 INFO - 'LANGUAGE': 'en_US:en', 18:53:43 INFO - 'LOGNAME': 'cltbld', 18:53:43 INFO - 'MAIL': '/var/mail/cltbld', 18:53:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:43 INFO - 'MOZ_NO_REMOTE': '1', 18:53:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:53:43 INFO - 'NO_EM_RESTART': '1', 18:53:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:53:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:53:43 INFO - 'PWD': '/builds/slave/test', 18:53:43 INFO - 'SHELL': '/bin/bash', 18:53:43 INFO - 'SHLVL': '1', 18:53:43 INFO - 'TERM': 'linux', 18:53:43 INFO - 'TMOUT': '86400', 18:53:43 INFO - 'USER': 'cltbld', 18:53:43 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1465436853.792480-1095647097', 18:53:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:43 INFO - '_': '/tools/buildbot/bin/python'} 18:53:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:53:43 INFO - Downloading/unpacking psutil>=3.1.1 18:53:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:53:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:53:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:53:45 INFO - Installing collected packages: psutil 18:53:45 INFO - Running setup.py install for psutil 18:53:45 INFO - building 'psutil._psutil_linux' extension 18:53:45 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 18:53:45 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 18:53:45 INFO - building 'psutil._psutil_posix' extension 18:53:45 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 18:53:45 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 18:53:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:53:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:53:45 INFO - Successfully installed psutil 18:53:45 INFO - Cleaning up... 18:53:45 INFO - Return code: 0 18:53:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:53:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:53:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:53:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:45 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 0x7fd9fabc1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c0b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9a1c0>, '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 0x2c9b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9b550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1465436853.792480-1095647097', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:53:45 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 18:53:45 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 18:53:45 INFO - Using env: {'DISPLAY': ':0', 18:53:45 INFO - 'HOME': '/home/cltbld', 18:53:45 INFO - 'LANG': 'en_US.UTF-8', 18:53:45 INFO - 'LANGUAGE': 'en_US:en', 18:53:45 INFO - 'LOGNAME': 'cltbld', 18:53:45 INFO - 'MAIL': '/var/mail/cltbld', 18:53:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:45 INFO - 'MOZ_NO_REMOTE': '1', 18:53:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:53:45 INFO - 'NO_EM_RESTART': '1', 18:53:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:53:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:53:45 INFO - 'PWD': '/builds/slave/test', 18:53:45 INFO - 'SHELL': '/bin/bash', 18:53:45 INFO - 'SHLVL': '1', 18:53:45 INFO - 'TERM': 'linux', 18:53:45 INFO - 'TMOUT': '86400', 18:53:45 INFO - 'USER': 'cltbld', 18:53:45 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1465436853.792480-1095647097', 18:53:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:45 INFO - '_': '/tools/buildbot/bin/python'} 18:53:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:53:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:53: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 18:53: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 18:53: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 18:53: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 18:53: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 18:53: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 18:53:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:53:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:53:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:53:47 INFO - Installing collected packages: mozsystemmonitor 18:53:47 INFO - Running setup.py install for mozsystemmonitor 18:53:48 INFO - Successfully installed mozsystemmonitor 18:53:48 INFO - Cleaning up... 18:53:48 INFO - Return code: 0 18:53:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:53:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:53:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:53:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:48 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 0x7fd9fabc1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c0b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9a1c0>, '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 0x2c9b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9b550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1465436853.792480-1095647097', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:53:48 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 18:53:48 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 18:53:48 INFO - Using env: {'DISPLAY': ':0', 18:53:48 INFO - 'HOME': '/home/cltbld', 18:53:48 INFO - 'LANG': 'en_US.UTF-8', 18:53:48 INFO - 'LANGUAGE': 'en_US:en', 18:53:48 INFO - 'LOGNAME': 'cltbld', 18:53:48 INFO - 'MAIL': '/var/mail/cltbld', 18:53:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:48 INFO - 'MOZ_NO_REMOTE': '1', 18:53:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:53:48 INFO - 'NO_EM_RESTART': '1', 18:53:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:53:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:53:48 INFO - 'PWD': '/builds/slave/test', 18:53:48 INFO - 'SHELL': '/bin/bash', 18:53:48 INFO - 'SHLVL': '1', 18:53:48 INFO - 'TERM': 'linux', 18:53:48 INFO - 'TMOUT': '86400', 18:53:48 INFO - 'USER': 'cltbld', 18:53:48 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1465436853.792480-1095647097', 18:53:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:48 INFO - '_': '/tools/buildbot/bin/python'} 18:53:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:53:48 INFO - Downloading/unpacking jsonschema==2.5.1 18:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:53:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:53:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:50 INFO - Downloading functools32-3.2.3-2.tar.gz 18:53:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:53:50 INFO - warning: no files found matching '*.txt' 18:53:50 INFO - no previously-included directories found matching 'build' 18:53:50 INFO - no previously-included directories found matching 'dist' 18:53:50 INFO - no previously-included directories found matching '.git*' 18:53:50 INFO - Installing collected packages: jsonschema, functools32 18:53:50 INFO - Running setup.py install for functools32 18:53:50 INFO - warning: no files found matching '*.txt' 18:53:50 INFO - no previously-included directories found matching 'build' 18:53:50 INFO - no previously-included directories found matching 'dist' 18:53:50 INFO - no previously-included directories found matching '.git*' 18:53:50 INFO - Successfully installed jsonschema functools32 18:53:50 INFO - Cleaning up... 18:53:50 INFO - Return code: 0 18:53:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:53:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:53:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:53:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:50 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 0x7fd9fabc1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c0b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9a1c0>, '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 0x2c9b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9b550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1465436853.792480-1095647097', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:53:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:53:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:53:50 INFO - Using env: {'DISPLAY': ':0', 18:53:50 INFO - 'HOME': '/home/cltbld', 18:53:50 INFO - 'LANG': 'en_US.UTF-8', 18:53:50 INFO - 'LANGUAGE': 'en_US:en', 18:53:50 INFO - 'LOGNAME': 'cltbld', 18:53:50 INFO - 'MAIL': '/var/mail/cltbld', 18:53:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:50 INFO - 'MOZ_NO_REMOTE': '1', 18:53:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:53:50 INFO - 'NO_EM_RESTART': '1', 18:53:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:53:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:53:50 INFO - 'PWD': '/builds/slave/test', 18:53:50 INFO - 'SHELL': '/bin/bash', 18:53:50 INFO - 'SHLVL': '1', 18:53:50 INFO - 'TERM': 'linux', 18:53:50 INFO - 'TMOUT': '86400', 18:53:50 INFO - 'USER': 'cltbld', 18:53:50 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1465436853.792480-1095647097', 18:53:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:50 INFO - '_': '/tools/buildbot/bin/python'} 18:53:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:53:50 INFO - Downloading/unpacking blobuploader==1.2.4 18:53:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:52 INFO - Downloading blobuploader-1.2.4.tar.gz 18:53:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:53:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:53:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:53:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:53 INFO - Downloading docopt-0.6.1.tar.gz 18:53:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:53:53 INFO - Installing collected packages: blobuploader, requests, docopt 18:53:53 INFO - Running setup.py install for blobuploader 18:53:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:53:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:53:53 INFO - Running setup.py install for requests 18:53:53 INFO - Running setup.py install for docopt 18:53:54 INFO - Successfully installed blobuploader requests docopt 18:53:54 INFO - Cleaning up... 18:53:54 INFO - Return code: 0 18:53:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:53:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:53:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:53:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:54 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 0x7fd9fabc1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c0b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9a1c0>, '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 0x2c9b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9b550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1465436853.792480-1095647097', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:53:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:53:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:53:54 INFO - Using env: {'DISPLAY': ':0', 18:53:54 INFO - 'HOME': '/home/cltbld', 18:53:54 INFO - 'LANG': 'en_US.UTF-8', 18:53:54 INFO - 'LANGUAGE': 'en_US:en', 18:53:54 INFO - 'LOGNAME': 'cltbld', 18:53:54 INFO - 'MAIL': '/var/mail/cltbld', 18:53:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:54 INFO - 'MOZ_NO_REMOTE': '1', 18:53:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:53:54 INFO - 'NO_EM_RESTART': '1', 18:53:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:53:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:53:54 INFO - 'PWD': '/builds/slave/test', 18:53:54 INFO - 'SHELL': '/bin/bash', 18:53:54 INFO - 'SHLVL': '1', 18:53:54 INFO - 'TERM': 'linux', 18:53:54 INFO - 'TMOUT': '86400', 18:53:54 INFO - 'USER': 'cltbld', 18:53:54 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1465436853.792480-1095647097', 18:53:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:54 INFO - '_': '/tools/buildbot/bin/python'} 18:53:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:53:54 INFO - Running setup.py (path:/tmp/pip-0Slqpy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:53:54 INFO - Running setup.py (path:/tmp/pip-cICP1W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:53:54 INFO - Running setup.py (path:/tmp/pip-fNzwZb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:53:54 INFO - Running setup.py (path:/tmp/pip-uAsOfC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:53:54 INFO - Running setup.py (path:/tmp/pip-UqRB6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:53:54 INFO - Running setup.py (path:/tmp/pip-GcOcxj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:53:54 INFO - Running setup.py (path:/tmp/pip-dO9Gkd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:53:54 INFO - Running setup.py (path:/tmp/pip-UL1rHn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:53:54 INFO - Running setup.py (path:/tmp/pip-6GKcJn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:53:55 INFO - Running setup.py (path:/tmp/pip-qRLZur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:53:55 INFO - Running setup.py (path:/tmp/pip-k2hMdM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:53:55 INFO - Running setup.py (path:/tmp/pip-Vi75jJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:53:55 INFO - Running setup.py (path:/tmp/pip-saghh3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:53:55 INFO - Running setup.py (path:/tmp/pip-YTAtPg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:53:55 INFO - Running setup.py (path:/tmp/pip-46PkTx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:53:55 INFO - Running setup.py (path:/tmp/pip-PwOzxB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:53:55 INFO - Running setup.py (path:/tmp/pip-s_U_ry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:53:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:53:55 INFO - Running setup.py install for manifestparser 18:53:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:53:55 INFO - Running setup.py install for mozcrash 18:53:55 INFO - Running setup.py install for mozdebug 18:53:55 INFO - Running setup.py install for mozdevice 18:53:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:53:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:53:55 INFO - Running setup.py install for mozfile 18:53:56 INFO - Running setup.py install for mozhttpd 18:53:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:53:56 INFO - Running setup.py install for mozinfo 18:53:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:53:56 INFO - Running setup.py install for mozInstall 18:53:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:53:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:53:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:53:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:53:56 INFO - Running setup.py install for mozleak 18:53:56 INFO - Running setup.py install for mozlog 18:53:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:53:56 INFO - Running setup.py install for moznetwork 18:53:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:53:56 INFO - Running setup.py install for mozprocess 18:53:56 INFO - Running setup.py install for mozprofile 18:53:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:53:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:53:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:53:56 INFO - Running setup.py install for mozrunner 18:53:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:53:57 INFO - Running setup.py install for mozscreenshot 18:53:57 INFO - Running setup.py install for moztest 18:53:57 INFO - Running setup.py install for mozversion 18:53:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:53:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:53:57 INFO - Cleaning up... 18:53:57 INFO - Return code: 0 18:53:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:53:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:53:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:53:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:53:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:53:57 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 0x7fd9fabc1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c0b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9a1c0>, '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 0x2c9b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9b550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1465436853.792480-1095647097', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:53:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:53:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:53:57 INFO - Using env: {'DISPLAY': ':0', 18:53:57 INFO - 'HOME': '/home/cltbld', 18:53:57 INFO - 'LANG': 'en_US.UTF-8', 18:53:57 INFO - 'LANGUAGE': 'en_US:en', 18:53:57 INFO - 'LOGNAME': 'cltbld', 18:53:57 INFO - 'MAIL': '/var/mail/cltbld', 18:53:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:53:57 INFO - 'MOZ_NO_REMOTE': '1', 18:53:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:53:57 INFO - 'NO_EM_RESTART': '1', 18:53:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:53:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:53:57 INFO - 'PWD': '/builds/slave/test', 18:53:57 INFO - 'SHELL': '/bin/bash', 18:53:57 INFO - 'SHLVL': '1', 18:53:57 INFO - 'TERM': 'linux', 18:53:57 INFO - 'TMOUT': '86400', 18:53:57 INFO - 'USER': 'cltbld', 18:53:57 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1465436853.792480-1095647097', 18:53:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:53:57 INFO - '_': '/tools/buildbot/bin/python'} 18:53:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:53:57 INFO - Running setup.py (path:/tmp/pip-CXTgVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 18:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:53:57 INFO - Running setup.py (path:/tmp/pip-uREYi6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:53:57 INFO - Running setup.py (path:/tmp/pip-5toI1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:53:57 INFO - Running setup.py (path:/tmp/pip-iycxec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:53:57 INFO - Running setup.py (path:/tmp/pip-CZ29M_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 18:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:53:57 INFO - Running setup.py (path:/tmp/pip-YE9bns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 18:53:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:53:58 INFO - Running setup.py (path:/tmp/pip-ST7kRQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 18:53:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:53:58 INFO - Running setup.py (path:/tmp/pip-5r9wEx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:53:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:53:58 INFO - Running setup.py (path:/tmp/pip-g64Z9X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 18:53:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:53:58 INFO - Running setup.py (path:/tmp/pip-xlcohL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:53:58 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)) 18:53:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:53:58 INFO - Running setup.py (path:/tmp/pip-5NLVII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 18:53:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:53:58 INFO - Running setup.py (path:/tmp/pip-3Oc_73-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:53:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:53:58 INFO - Running setup.py (path:/tmp/pip-jnC6Wx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 18:53:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:53:58 INFO - Running setup.py (path:/tmp/pip-gwKLtd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:53:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:53:58 INFO - Running setup.py (path:/tmp/pip-c0ESrd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 18:53:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:53:58 INFO - Running setup.py (path:/tmp/pip-Wsn3B4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:53:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:53:58 INFO - Running setup.py (path:/tmp/pip-edjX4l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 18:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:53:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:53:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:53:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:53:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:53:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:54:00 INFO - Downloading blessings-1.6.tar.gz 18:54:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:54:00 INFO - Installing collected packages: blessings 18:54:00 INFO - Running setup.py install for blessings 18:54:00 INFO - Successfully installed blessings 18:54:00 INFO - Cleaning up... 18:54:00 INFO - Return code: 0 18:54:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:54:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:54:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:54:01 INFO - Reading from file tmpfile_stdout 18:54:01 INFO - Current package versions: 18:54:01 INFO - argparse == 1.2.1 18:54:01 INFO - blessings == 1.6 18:54:01 INFO - blobuploader == 1.2.4 18:54:01 INFO - docopt == 0.6.1 18:54:01 INFO - functools32 == 3.2.3-2 18:54:01 INFO - jsonschema == 2.5.1 18:54:01 INFO - manifestparser == 1.1 18:54:01 INFO - mozInstall == 1.12 18:54:01 INFO - mozcrash == 0.17 18:54:01 INFO - mozdebug == 0.1 18:54:01 INFO - mozdevice == 0.48 18:54:01 INFO - mozfile == 1.2 18:54:01 INFO - mozhttpd == 0.7 18:54:01 INFO - mozinfo == 0.9 18:54:01 INFO - mozleak == 0.1 18:54:01 INFO - mozlog == 3.2 18:54:01 INFO - moznetwork == 0.27 18:54:01 INFO - mozprocess == 0.22 18:54:01 INFO - mozprofile == 0.28 18:54:01 INFO - mozrunner == 6.11 18:54:01 INFO - mozscreenshot == 0.1 18:54:01 INFO - mozsystemmonitor == 0.3 18:54:01 INFO - moztest == 0.7 18:54:01 INFO - mozversion == 1.4 18:54:01 INFO - psutil == 3.1.1 18:54:01 INFO - requests == 1.2.3 18:54:01 INFO - wsgiref == 0.1.2 18:54:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:54:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:54:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:54:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:54:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:01 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 0x7fd9fabc1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c0b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9a1c0>, '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 0x2c9b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9b550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1465436853.792480-1095647097', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:54:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 18:54:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:54:01 INFO - Using env: {'DISPLAY': ':0', 18:54:01 INFO - 'HOME': '/home/cltbld', 18:54:01 INFO - 'LANG': 'en_US.UTF-8', 18:54:01 INFO - 'LANGUAGE': 'en_US:en', 18:54:01 INFO - 'LOGNAME': 'cltbld', 18:54:01 INFO - 'MAIL': '/var/mail/cltbld', 18:54:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:54:01 INFO - 'MOZ_NO_REMOTE': '1', 18:54:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:54:01 INFO - 'NO_EM_RESTART': '1', 18:54:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:54:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:54:01 INFO - 'PWD': '/builds/slave/test', 18:54:01 INFO - 'SHELL': '/bin/bash', 18:54:01 INFO - 'SHLVL': '1', 18:54:01 INFO - 'TERM': 'linux', 18:54:01 INFO - 'TMOUT': '86400', 18:54:01 INFO - 'USER': 'cltbld', 18:54:01 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1465436853.792480-1095647097', 18:54:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:54:01 INFO - '_': '/tools/buildbot/bin/python'} 18:54:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:54:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:54:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 18:54:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 18:54:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:54:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 18:54:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 18:54:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 18:54:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 18:54:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 18:54:01 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:54:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:54:01 INFO - Cleaning up... 18:54:01 INFO - Return code: 0 18:54:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:54:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:54:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:54:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:54:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:01 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 0x7fd9fabc1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c0b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9a1c0>, '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 0x2c9b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9b550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1465436853.792480-1095647097', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:54:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:54:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:54:01 INFO - Using env: {'DISPLAY': ':0', 18:54:01 INFO - 'HOME': '/home/cltbld', 18:54:01 INFO - 'LANG': 'en_US.UTF-8', 18:54:01 INFO - 'LANGUAGE': 'en_US:en', 18:54:01 INFO - 'LOGNAME': 'cltbld', 18:54:01 INFO - 'MAIL': '/var/mail/cltbld', 18:54:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:54:01 INFO - 'MOZ_NO_REMOTE': '1', 18:54:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:54:01 INFO - 'NO_EM_RESTART': '1', 18:54:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:54:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:54:01 INFO - 'PWD': '/builds/slave/test', 18:54:01 INFO - 'SHELL': '/bin/bash', 18:54:01 INFO - 'SHLVL': '1', 18:54:01 INFO - 'TERM': 'linux', 18:54:01 INFO - 'TMOUT': '86400', 18:54:01 INFO - 'USER': 'cltbld', 18:54:01 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1465436853.792480-1095647097', 18:54:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:54:01 INFO - '_': '/tools/buildbot/bin/python'} 18:54:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:54:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:54:01 INFO - Cleaning up... 18:54:01 INFO - Return code: 0 18:54:01 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:54:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:54:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:54:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:54:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:54:01 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 0x7fd9fabc1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c0b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9a1c0>, '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 0x2c9b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9b550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1465436853.792480-1095647097', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:54:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 18:54:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 18:54:01 INFO - Using env: {'DISPLAY': ':0', 18:54:01 INFO - 'HOME': '/home/cltbld', 18:54:01 INFO - 'LANG': 'en_US.UTF-8', 18:54:01 INFO - 'LANGUAGE': 'en_US:en', 18:54:01 INFO - 'LOGNAME': 'cltbld', 18:54:01 INFO - 'MAIL': '/var/mail/cltbld', 18:54:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:54:01 INFO - 'MOZ_NO_REMOTE': '1', 18:54:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:54:01 INFO - 'NO_EM_RESTART': '1', 18:54:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:54:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:54:01 INFO - 'PWD': '/builds/slave/test', 18:54:01 INFO - 'SHELL': '/bin/bash', 18:54:01 INFO - 'SHLVL': '1', 18:54:01 INFO - 'TERM': 'linux', 18:54:01 INFO - 'TMOUT': '86400', 18:54:01 INFO - 'USER': 'cltbld', 18:54:01 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1465436853.792480-1095647097', 18:54:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:54:01 INFO - '_': '/tools/buildbot/bin/python'} 18:54:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:54:01 INFO - Downloading/unpacking flake8 18:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:54:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:54:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:54:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:54:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:54:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:54:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:54:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:54:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:54:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:54:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:54:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:54:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:54:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:54:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:54:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:54:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:54:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:54:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:54:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:54:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:54:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:54:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:54:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:54:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:54:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:54:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:54:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:54:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:54:04 INFO - no previously-included directories found matching 'docs/_build' 18:54:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:54:04 INFO - Running setup.py install for pep8 18:54:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:54:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:54:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:54:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:54:04 INFO - no previously-included directories found matching 'docs/_build' 18:54:04 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:54:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:54:04 INFO - Cleaning up... 18:54:04 INFO - Return code: 0 18:54:04 INFO - Running post-action listener: _resource_record_post_action 18:54:04 INFO - Running post-action listener: _start_resource_monitoring 18:54:04 INFO - Starting resource monitoring. 18:54:04 INFO - ##### 18:54:04 INFO - ##### Finished create-virtualenv step (success) 18:54:04 INFO - ##### 18:54:04 INFO - ##### 18:54:04 INFO - ##### Running install step. 18:54:04 INFO - ##### 18:54:04 INFO - Running pre-action listener: _resource_record_pre_action 18:54:04 INFO - Running main action method: install 18:54:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:54:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:54:04 INFO - Reading from file tmpfile_stdout 18:54:04 INFO - Detecting whether we're running mozinstall >=1.0... 18:54:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:54:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:54:05 INFO - Reading from file tmpfile_stdout 18:54:05 INFO - Output received: 18:54:05 INFO - Usage: mozinstall [options] installer 18:54:05 INFO - Options: 18:54:05 INFO - -h, --help show this help message and exit 18:54:05 INFO - -d DEST, --destination=DEST 18:54:05 INFO - Directory to install application into. [default: 18:54:05 INFO - "/builds/slave/test"] 18:54:05 INFO - --app=APP Application being installed. [default: firefox] 18:54:05 INFO - mkdir: /builds/slave/test/build/application 18:54:05 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'] 18:54:05 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 18:54:20 INFO - Reading from file tmpfile_stdout 18:54:20 INFO - Output received: 18:54:20 INFO - /builds/slave/test/build/application/firefox/firefox 18:54:20 INFO - Running post-action listener: _resource_record_post_action 18:54:20 INFO - ##### 18:54:20 INFO - ##### Finished install step (success) 18:54:20 INFO - ##### 18:54:20 INFO - ##### 18:54:20 INFO - ##### Running run-tests step. 18:54:20 INFO - ##### 18:54:20 INFO - Running pre-action listener: _resource_record_pre_action 18:54:20 INFO - Running main action method: run_tests 18:54:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:54:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:54:20 INFO - Python 2.7.3 18:54:20 INFO - Return code: 0 18:54:20 INFO - grabbing minidump binary from tooltool 18:54:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:54:20 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 0x2c9a1c0>, '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 0x2c9b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9b550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:54:20 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:54:20 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 18:54:20 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 18:54:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:54:20 INFO - Return code: 0 18:54:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:54:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:54:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:54:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:54:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:54:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:54:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:54:21 INFO - Return code: 0 18:54:21 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/aa32Osp6SBu1BHhbpV2-ew/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 18:54:21 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/aa32Osp6SBu1BHhbpV2-ew/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 18:54:21 INFO - Using env: {'DISPLAY': ':0', 18:54:21 INFO - 'HOME': '/home/cltbld', 18:54:21 INFO - 'LANG': 'en_US.UTF-8', 18:54:21 INFO - 'LANGUAGE': 'en_US:en', 18:54:21 INFO - 'LOGNAME': 'cltbld', 18:54:21 INFO - 'MAIL': '/var/mail/cltbld', 18:54:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:54:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:54:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:54:21 INFO - 'MOZ_NO_REMOTE': '1', 18:54:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:54:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:54:21 INFO - 'NO_EM_RESTART': '1', 18:54:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:54:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:54:21 INFO - 'PWD': '/builds/slave/test', 18:54:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:54:21 INFO - 'SHELL': '/bin/bash', 18:54:21 INFO - 'SHLVL': '1', 18:54:21 INFO - 'TERM': 'linux', 18:54:21 INFO - 'TMOUT': '86400', 18:54:21 INFO - 'USER': 'cltbld', 18:54:21 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1465436853.792480-1095647097', 18:54:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:54:21 INFO - '_': '/tools/buildbot/bin/python'} 18:54:21 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/aa32Osp6SBu1BHhbpV2-ew/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 18:54:22 INFO - mozversion application_buildid: 20160608162130 18:54:22 INFO - mozversion application_changeset: 214e3a1a150a65e5400ff67f5eb5fb048929b183 18:54:22 INFO - mozversion application_display_name: FirefoxDeveloperEdition 18:54:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:54:22 INFO - mozversion application_name: Firefox 18:54:22 INFO - mozversion application_remotingname: firefox-dev 18:54:22 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:54:22 INFO - mozversion application_vendor: Mozilla 18:54:22 INFO - mozversion application_version: 49.0a2 18:54:22 INFO - mozversion platform_buildid: 20160608162130 18:54:22 INFO - mozversion platform_changeset: 214e3a1a150a65e5400ff67f5eb5fb048929b183 18:54:22 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 18:54:22 INFO - mozversion platform_version: 49.0a2 18:54:22 INFO - using testdate: 1465437262 18:54:22 INFO - actual date: 1465437262 18:54:22 INFO - starting webserver on 'localhost:42145' 18:54:22 INFO - SUITE-START | Running 2 tests 18:54:22 INFO - TEST-START | dromaeo_css 18:54:22 INFO - operating with platform_type : linux_ 18:54:22 INFO - Initialising browser for dromaeo_css test... 18:54:22 INFO - TEST-INFO | started process 2557 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0KuwLC/profile http://localhost:42145/getInfo.html) 18:54:27 INFO - PROCESS | 2557 | __metrics Screen width/height:1600/1200 18:54:27 INFO - PROCESS | 2557 | colorDepth:24 18:54:27 INFO - PROCESS | 2557 | Browser inner width/height: 1024/697 18:54:27 INFO - PROCESS | 2557 | __metrics 18:54:28 ERROR - PROCESS | 2557 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2944: TypeError: this.tabs is undefined 18:54:28 INFO - TEST-INFO | 2557: exit 0 18:54:28 INFO - Browser initialized. 18:54:28 INFO - Running cycle 1/1 for dromaeo_css test... 18:54:28 INFO - TEST-INFO | started process 2689 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0KuwLC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:54:40 INFO - PROCESS | 2689 | RSS: Main: 156381184 18:54:40 INFO - PROCESS | 2689 | 18:55:30 INFO - PROCESS | 2689 | 1465437330330 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 18:57:38 INFO - PROCESS | 2689 | Cycle 1(1): loaded http://localhost:42145/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42145/tests/dromaeo/cssquery-ext.html) 18:57:39 INFO - PROCESS | 2689 | RSS: Main: 160509952 18:57:39 INFO - PROCESS | 2689 | 19:00:41 INFO - PROCESS | 2689 | Cycle 1(1): loaded http://localhost:42145/tests/dromaeo/cssquery-ext.html (next: http://localhost:42145/tests/dromaeo/cssquery-jquery.html) 19:00:42 INFO - PROCESS | 2689 | RSS: Main: 157577216 19:00:42 INFO - PROCESS | 2689 | 19:03:44 INFO - PROCESS | 2689 | Cycle 1(1): loaded http://localhost:42145/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42145/tests/dromaeo/cssquery-mootools.html) 19:03:44 INFO - PROCESS | 2689 | RSS: Main: 156962816 19:03:44 INFO - PROCESS | 2689 | 19:06:46 INFO - PROCESS | 2689 | Cycle 1(1): loaded http://localhost:42145/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42145/tests/dromaeo/cssquery-prototype.html) 19:06:47 INFO - PROCESS | 2689 | RSS: Main: 156516352 19:06:47 INFO - PROCESS | 2689 | 19:09:49 INFO - PROCESS | 2689 | Cycle 1(1): loaded http://localhost:42145/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42145/tests/dromaeo/cssquery-yui.html) 19:09:50 INFO - PROCESS | 2689 | RSS: Main: 159068160 19:09:50 INFO - PROCESS | 2689 | 19:12:52 INFO - PROCESS | 2689 | Cycle 1(1): loaded http://localhost:42145/tests/dromaeo/cssquery-yui.html (next: http://localhost:42145/tests/dromaeo/cssquery-dojo.html) 19:12:52 INFO - PROCESS | 2689 | RSS: Main: 159145984 19:12:52 INFO - PROCESS | 2689 | 19:12:52 INFO - PROCESS | 2689 | __start_tp_report 19:12:52 INFO - PROCESS | 2689 | _x_x_mozilla_page_load 19:12:52 INFO - PROCESS | 2689 | _x_x_mozilla_page_load_details 19:12:52 INFO - PROCESS | 2689 | |i|pagename|runs| 19:12:52 INFO - PROCESS | 2689 | |0;dojo.html;3385.322935412917;3419.589649242091;3422.794632322061;3443.621201667816;3464.4803279508055;5675.3189617245935;5715.742791574378;5736.856578585533;5774.16274640178;5776.508996735272;5747.683877386742;5769.134629805531;5798.391168927265;5822.039363505017;5826.155207494921;5260.736963151846;5338.27933229015;5357.330333708286;5367.946320536803;5422.783088676449;5258.0535503609335;5322.680639161663;5388.164834450667;5426.321709786277;5431.375391829951;5323.787048518055;5357.383900851413;5364.946350536484;5370.91943620846;5425.9728701356435;5415.323084614423;5427.701476418795;5428.972855135718;5430.185472179165;5436.130219164915;5152.845414637567;5213.400458947193;5294.338207724035;5365.919511207335;5479.397266300703;5621.943780562183;5694.060480020791;5696.974544582015;5756.33802112754;5767.971160144214;6236.438720515175;6258.311585725566;6286.402791734778;6288.245410550763;6289.811305660837;6109.053096770008;6230.844228894269;6280.183576135073;6308.810735677937;6350.682465876734;5909.143174239711;5911.201987731644;5914.4676979071655;5921.555883308813;5946.821595352147;6403.551751377358;6413.647249401328;6437.871242575122;6446.903296450557;6479.3520647935775;5925.05199168131;5985.191999080069;6022.247219097613;6043.36544662804;6217.875642487125;6151.169592105098;6173.56785025044;6179.104029915727;6179.876402472015;6181.783637572664;6105.725242364104;6159.907601385983;6161.96919015411;6166.229221347332;6171.506279497629;6086.695665216722;6110.923300256496;6141.907871381933;6254.906176407358;6269.153664255358;4746.952530474651;4749.548792864673;4759.405074365704;4778.283257511401;4779.115863565252;4168.603982621707;4236.5128010278595;4265.97867010663;4270.12462445198;4280.743155410685;5831.329397119385;5948.405159484017;5970.910436343458;5971.910421343683;6007.339192688888;6189.35011823761;6204.410580994799;6225.159603453566;6248.375162483715;6276.592021518587;5929.169916211734;6013.729382177812;6029.095635654599;6071.574989750763;6074.696265186812;5167.586593072545;5170.353705786777;5188.092083885305;5189.377274726981;5220.660657057279;6523.478121750249;6565.080888675589;6566.1135746674545;6567.737290508422;6584.473242140617;6091.390860914051;6134.008014331881;6306.1171435998995;6315.336889626707;6351.555391122762;6335.683215839282;6405.615663060231;6498.122753428227;6508.511861610493;6524.3149469305035;6107.053406721965;6127.111568822406;6131.877362452815;6132.233470816148;6166.951618224823;5907.261592300963;6138.1738283688655;6193.287771906108;6234.407731265704;6252.406021427957;6097.209380933946;6101.969490152698;6150.292716337678;6160.784372546939;6176;6132.233470816148;6137.752221850432;6141.07883817431;6142.744345496893;6152.446279834837;5802.65184088956;5900.911486327795;5936.673482958478;5972.25346831646;5993.22088128558;6089.665068421279;6168.599041062316;6170.598911070766;6182.567220294536;6205.410486003822;6005.579609427298;6038.456538911343;6040.214772079602;6087.36082711309;6090.482309003607 19:12:52 INFO - PROCESS | 2689 | |1;ext.html;589.5431040943268;653.0661154548993;653.353180351452;655.7835914148328;675.0987431778577;34855.4771678425;38631.22737545247;45651.77174114129;46337.53662463383;46479.76760116195;48172.51827481733;48696.51303486964;48807.75596122023;48812;48851.51148488523;9072.591733371997;9307.11582399671;9312.115349041864;9321.300902432311;9370.765730856749;9073.63705451781;9181.724548263563;9257.861132083024;9258.398204116744;9258.953705231497;9291.814163716721;9311.953440232823;9328.906710932906;9334.253259739238;9369.812603747921;9170.816583668322;9249.445033298023;9258.583363748647;9295.256379489625;9328.533573321307;9166.220871225954;9215.078492150798;9300.069993000714;9306.069393060707;9309.115634014826;44662.33006504905;44883.551164488264;44997;45007;45021.32468012982;3559.7330200235087;3565.7682250653625;3699.6855267302044;3701.9629803701887;3783.564890037626;33361;33850.661493385;35851;36234;37515.24969500595;4690.390249267573;4821.7589120543835;4829.758512074382;4842.297866809328;4881.658283920127;366991;367437;368736;368910;371761.141194295;36361.63638363582;71425.64287178531;71807.6409617959;72798.63600682068;72907.63546182342;39397.40903886444;41730.58269417267;41889.79055104705;41893;41952.58047419487;16989.065601391794;17221.225044873012;17263.39578114785;17313.913430432767;17317.567060823327;14169.574912752427;14285.64285892861;14359.85640143606;14417.855821441652;14431.567052988426;9405.15353618164;9433.622655093719;9474.905250947402;9482.478463684563;9501.572429240701;3595.0832537702718;3620.330238905811;3632.4006538921312;3665.17533554948;3676.6874815640435;1122.693667150251;1124.3141683573015;1166.585862018988;1177.7055736065984;1240.1938739819009;33571.83214083963;33849.32301354008;33961;33995.15012124717;34675.826620866734;1192.9582464613698;1216.1790791215894;1245.2217364147407;1254.3665448948223;1286.8069789531646;17324.566885827702;17630.735538966925;17666.470005899842;17863.106844657974;17900.731489027676;620678;680119;689662;690701;694144;60984.69507652433;61501;61520.384796152364;67312;67467.66266168735;1494.9327280272414;1508.9170095644624;1512.470635277644;1520.6426489774894;1533.4862820955104;33614.15964600807;33651.66348336485;34160;34295.7729019462;34370.65629343675;56329.71835140798;56964.71517642551;57312.42687573071;57369.42630573808;57385;384298;389541;389827;392164;392705;45951;46747.29879051885;47078;47377;47442;50801.74599126981;51595;51815;52199.21701174409;52504;44134.55865441304;44300;44625.33062004137;44683.329750053126;45302.320465193705;43607.34588981231;44302;44382.3342649854;44924.10151797011;45115.54884451245;43116;43507;43550.782246088565;44562.55437445584;44573.77713111414;38628;38820.6117938817;38957.415638764876;39576;39931.40102898401;29198.416031679673;29810.70189298166;29974.25064373408;30050;30129.548056778727 19:12:52 INFO - PROCESS | 2689 | |2;jquery.html;412.1406866682966;418.32858262488685;428.98069586868587;434.25308469432576;443.69385124264255;18605.72091418628;19966;20257.290994815165;20447.28434504789;20627.17491300348;19654.803451965476;19655.60688786227;19772.703409448834;20358.694619580718;20425.28511502098;5789.0448076067505;5955.1960485334575;5969.403059694017;5970.701464926758;6001.87996240075;4362.018545827195;5889.204957330749;5991.790287339944;6365.872682546346;6389.265234498022;6351.396617321347;6437.80686579401;6448.032795080729;6458.063580780784;6577.440917522016;6642.767503137367;6713.664316784141;6755.054292399043;6759.695813688371;6782.423494003016;5198.428172900978;5512.503874651301;5514.0901751211;5599;5900.20347253124;14953.177575233358;15066.698666026728;22164.11343546256;23722.644160337437;23815;2238.921637742671;2273.090763694519;2338.088145623208;2458.299384675359;2649.3111790934304;10584.629537966212;10790.784184316348;10905.890941090567;11046.889531104667;11243.943780281128;2032.1058734156923;2040.357287454447;2086.4992401823606;2116.9153233870625;2120.310898957845;83208.58395708044;83940.16059839446;84446.57776711139;85661.57169214176;86125.56937215336;11663.608960163147;11673.416329183678;12191.390430478441;12533.122681412213;12581.245125292511;16911.91544042272;16947.661046778994;16971.575710607332;17079.658406831793;17120.74318885218;8716.694915678048;8859;8991.955040224757;9011.504367259864;9115.407498512575;8594.183552562497;8613.095624959415;8664.436811607351;8895.777605559913;8907.688230912017;5086.847394578169;5092.465291144451;5110.310108135429;5121.103806833789;5224.190250511177;2079.9376018719463;2130.371540395587;2148.8710677359095;2155.3964889830872;2175.7029866014495;1003.2375394700081;1047.3035431438161;1109.1514991031868;1128.5993472317373;1138.1805100327751;19451.51371215731;19895.905725184963;20048.59902801936;20518.17927282892;20715;1034.5551412892378;1057.0116940660507;1082.4533610526635;1087.6628245243999;1117.413357987047;11239.550417983353;11447.599334023436;11527.596534121432;11534.884651153381;11605.477753501113;521174;529093;536219;537928;542981;100780;100809.49595251976;101400;103196;103914.48042759737;1077.4828082520435;1083.9403832789114;1092.1426680056118;1097.983530247047;1098.566066403766;17878.821211787716;18011.819881801013;18051.909740451214;18270.634587308446;18325.816741832412;40428.79785601053;40906.79546602248;41511.7924410376;42005.78997105117;43604.56395436005;60187;61376.69311653413;62186;62514.687426562574;62975.6851215741;8797.868031979653;9087.863682044906;9150.816983660423;9326.533673316442;9464.905350946403;10511.94744026275;13073;13884.09753366028;14111.2944352784;14337.56987290383;12081.637550873487;12327.630171094881;12444.751104978031;12680.74638507243;12768.74462510726;12195.878041219474;12306.200096993667;12308.876911230773;12324.32216228116;12418.627441176779;12217.633470995885;12495.187812792139;12506.43721032574;12557.93721031389;12701.174423662433;7693.4614576979075;8032.196780321921;9157.130072643089;9388.155066044088;9422.858657120285;11920.344381058778;12116.818247726467;12234.327112008568;12319.876801231872;12341.3829308536 19:12:52 INFO - PROCESS | 2689 | |3;mootools.html;1528.3580896023666;1591.1487354265466;1794.102948525737;1884.4346695991198;1922.4617107209976;8494.91505084949;9167.358284920057;9202.861957070641;9835;9871.506424678764;9124.133207345292;9387.249020078394;9407.952960235189;9419.858702119474;9496.145346918776;2417.2869003643923;2438.6463962725393;2438.890249938757;2445.572024895645;2461.163204510466;2362.14962613459;2395.149721848736;2398.712154541449;2403.71155461344;2410.5660981023407;2360.7993320567684;2378.227076200233;2427.9393015174587;2470.1601455505124;2471.7033955925226;2372.169740590788;2373.9287821365388;2390.414348484615;2419.358869899478;2425.333033415816;2355.2227764837735;2383.2611890314056;2393.1623931623794;2394.437307232799;2407.4944261705064;9254.814903701956;9327.533623318806;9334.486603236819;9391.436513809193;9392.530373481299;5594.888102237933;5763.3948435414095;5765.509931655814;5771.913421298684;5788.565857560699;3521.542199514047;3525.11872031992;3541.734369922266;3549.3256281306467;3616.1140520572367;1167.7781221567875;1200.6278053803348;1206.9939650301692;1220.4690959432676;1237.257645412754;13421;13463.326833658279;13570.050096493249;13578.660533486644;13584;4695.5069717679835;4721.693089949143;4823.9517604824205;4856.757162141878;4877.756112194376;10506.474676266156;10525.473726313654;10571.577136914591;10575.153987680967;10626.36241825493;5522.889542209134;5550.389457159709;5552.139418390156;5608.186812912105;5627.493525582635;4461.843835465743;4934.210526315772;5028.924566131511;5031.723255220924;5231.503007214308;4125.938110928339;4128.318827393447;4196.412502249687;4230.598093181143;4247.193033323659;1235.9382030898419;1240.4294024748717;1245.894099001577;1247.5197049135966;1248.875112488762;986.2701600815345;989.6684610655367;1025.2464438637596;1028.9639862604772;1065.9946700266605;6171.876562468726;6262.185915830913;6432.388923052303;6618.966905165444;6656.567323123982;1030.8144533983955;1043.0820877627639;1045.6810672744734;1051.5951358726945;1057.1384321777728;4127;4189.664826813848;4231.724937879028;4246.978765106154;4260.8721738347895;11381.943090284662;11812.940935295268;11830.822537661941;11838;11839.58561450345;11522.193446458667;11594;11604;11670.358130302915;11723.4138293085;8855.114488551222;8917.866232006525;8961.193492585699;9071.954640226757;9092.499912504876;6306.180196574416;6355.046742988588;6419.101325814297;6431.163948686641;6560.442362399059;10888.51001704941;11174.55301787952;11249;11289.37908415045;11361.772764544829;11134.888651113386;11359.602413915472;11480.425978701198;11488.597899073493;11553.30680159193;7850.764477065697;8007.439479236397;8009.879851802344;8236.258736713724;8251.587420629065;8745.387822852339;8769.298456123623;8776.34177436682;8808.471491710518;8843.955780221315;8186.7953301167945;8385.245327920273;8439.240468357631;8455.830883382421;8499.19257670545;7959.920400795918;8054.879176812469;8184.8772268417215;8246.299064579578;8338.583070846313;7142.214356420894;7346.449016323691;7390.076240469942;7396.704131834666;7418.369438597564;5235.869103272296;5311.575073994149;5346.1980702893325;5431.321084864392;5587.44125587438;5367.194920761917;5369.35567731859;5384.246205531307;5476.069068258326;5541.168824676331 19:12:52 INFO - PROCESS | 2689 | |4;prototype.html;355.1069061310802;364.1533434764174;366.63336663336645;369.2098908336161;374.3019269063198;5615.9157612635745;5697.601167918242;5727.627704199234;5819;5854.970725146373;5739.770409183628;5772.5670574706855;5779.190913272135;5792.71036448178;5803.535717142629;4532.297493888453;4540.818367265306;4549.749763762991;4555.271156614942;4629.79165937532;4478.26108692067;4535.841245556406;4542.886427839314;4547.795349209294;4633.142868569325;4468.5754853289045;4475.373447717322;4497.797599108032;4530.207213737599;4538.341940418637;4280.700350975433;4528.864134075983;4547.681662283641;4563.70335928167;4587.793549290256;3938.5667576566557;3949.2299001694682;3957.1492129192075;3960.890950533855;3964.108075682977;5549;5609.411011843738;5643.661380317153;5644;5653.236813030229;5124.538791508782;5138.820141295074;5164.793408263665;5182.170852663593;5193.844184674465;6016.157737916695;6017.849553761147;6019.789307374221;6031.45716885478;6086.2087928569;4394.934075988863;4398.296272596369;4402.141582391435;4402.867913962555;4423.203823311803;6178.351273116303;6355.618662880288;6365.395287447685;6398.264199617057;6408.871822563523;4480.305552639346;4504.211762941472;4506.211413002711;4514.187446259639;4520.141173177086;4546.568076032771;4579.771011449481;4586.862394128181;4595.839145629887;4599.218132917412;5045.672031317952;5064.471797619542;5144.485551444825;5165.560927321219;5184.170532714747;5845.88308233833;6042.335343112254;6068.4538391544975;6084.908726369108;6134.018557030854;1555.7588573771084;1564.1319067917416;1568.3648122510401;1571.1986886687644;1574.8582627563574;978.6379039755336;998.8951160128082;1009.3842755918884;1014.1329163565193;1025.6922923123182;5345.251664766935;5355.839324820262;5381.892362152735;5391.676499410048;5433.755481003364;5576.358718747396;5635.859103522363;5641.210230567724;5660.320761508646;5695.231143795618;5249.897521520447;5385.353757549041;5514;6016.345504986164;6023.367546407651;3310.486874534451;3340.7494437917253;3362.646922073147;3363.3105213431186;3367.0572239772905;6246.937530624727;6509.349065093453;6544.280129185786;6567;6577.901331480031;6350.364963503705;6393.840153996187;6397.7440902364315;6432.494290611628;6433.839154021093;6327.2090988625505;6486.4486518646445;6511.218653761579;6520;6529.934700653028;6244.937550624436;6283.868903597397;6289.811305660837;6292.2134733158355;6327.303996560467;6210.130581718473;6230.566969596927;6235.095911092957;6266.436020758154;6273;6270.905936411049;6450.677466126581;6480.416762491398;6511.120998665119;6529.640869752209;4405.9339109912735;4415.867523974286;4424.955750442455;4453.75504347264;4463.955360446354;6174.24034150265;6346.397092276226;6377.521685873671;6384.201974753156;6406.711697973696;6107.4197951194565;6115.480184184395;6138.14066030765;6144.8771024580155;6177.444030037318;6000.669963152069;6168.845778855564;6183.258009038944;6209.534284928558;6210.844728881814;5980.132880732356;5985.700714964321;5991.281046274301;5995.2206213192;6013.759449622141;6099.573029887865;6119.694015299307;6141.877162456636;6214.353196402866;6233.407826256498;5941.643501389931;6020.367861374492;6041.2750469943885;6045.879082418239;6072.301685306246 19:12:52 INFO - PROCESS | 2689 | |5;yui.html;769.4344656677341;818.8935438393008;828.5070383122048;846.1961136919924;898.5237823953303;15736;16481.505554833344;16485.175741212952;16536.66926661466;16634.085125318103;15596.454124105658;15770.526884193463;15808.841911580881;15818.367265309402;15837;703.5110598134298;839.2530647723531;859.8237361340941;861.0485413617956;864.8313578852126;852.9530875801828;855.9101294364095;857.8455877941968;858.6908712863365;858.7080392666492;905.44767691708;907.5552979040289;908.6410867707285;909.2725819344531;910.2354022620997;891.3893982621893;896.7802888292377;899.0200681257428;900.5497251374313;900.6847603338779;661.4443867151616;661.9900701489481;663.0716996205351;663.3002182697253;666.4768156996782;15282.617934551725;15297.388104475807;15367;15402.845971540253;15420.922895385564;16226;16293.755593666105;16433.753493697604;16646.50060498187;16983.74524382135;13240.73518529624;13557.186568805902;13559.118657287245;13602.183868967795;13690.726185476335;4049.6152865478025;4060.309747342959;4096.180763847213;4154.5222299435345;4169.958300417018;77616.22383776147;78051;78467;78826.60586697087;80645.19354806436;12327.260364378166;12383.62849114528;12431.440585173508;12536.059795515373;12572.4342404592;21729.56540869174;22484.437889052904;23857.880710596335;24068.27795166148;24107.879460602584;8738.86891696625;8821.470711757314;8905.287576993825;8983.326250531105;9331.813363732688;5311.575073994071;5375.596830237748;5388.218708287276;5392.4607539246545;5455.1544510600925;3714.795686237283;3847.03824043989;3857.1707082977296;3864.381698928214;3868.052327179859;650.5088658063132;652.6997581112741;657.8750037492957;660.9173853268342;670.8557660103102;690.602903330587;745.6197339356967;766.8849672549162;801.0987638906231;807.1323327422926;10823.83764243537;10830.350178989285;10959.452027398598;11137.10903127764;11324.263922845154;695.2352412346379;745.9067616547932;761.3072104384983;789.1910791438821;794.2414993681136;4959.603231741452;4966.975165124151;4984.476629953802;5159.2003239497935;5166.43169251382;115921;118215;118425.40787296009;122781.38609306897;124447;90311.09688903028;93807.53096234475;99885.50057249668;101209.49395252977;104702.38244043807;91614;92996.07003930009;93201.5339923296;93276;94683.52658236664;9756.317057805885;9767.462789546644;9812.803743925224;9823.410595364301;9848.359856609297;55315.72342138264;55557.72221138868;55873.44126558682;56916.14625780699;57707.1343929833;73241.6337918307;78068;79035.20964790278;81403;81839.59080204561;12787.552435664707;12931.612051638465;12981.221126732426;13003.609891703263;13406.93296533511;14133.575992720234;14522.20127892976;14538.927305363406;14567.271636418349;14998.400063997318;12498.693074039411;12576.387921253376;12855.29295888735;13184.670383240496;13259.933700331436;13432.932835335761;13461.461541538229;13480.988925830798;13691.246981416118;13700;13196.736065278832;13307.733845322846;13482.730345392842;13823.377947992163;13862.098963567336;11187.776244475228;11243.212975091665;11322.886771132513;11348.489317980875;11353.659390218307;11321.547138114713;11447.370394628042;11519.88480115188;11553.94223028913;11600.88399115998 19:12:52 INFO - PROCESS | 2689 | __end_tp_report 19:12:52 INFO - PROCESS | 2689 | __start_cc_report 19:12:52 INFO - PROCESS | 2689 | _x_x_mozilla_cycle_collect,345 19:12:52 INFO - PROCESS | 2689 | __end_cc_report 19:12:52 INFO - PROCESS | 2689 | __startTimestamp1465438372960__endTimestamp 19:12:52 INFO - PROCESS | 2689 | 19:12:52 INFO - PROCESS | 2689 | ------- Summary: start ------- 19:12:52 INFO - PROCESS | 2689 | Number of tests: 6 19:12:52 INFO - PROCESS | 2689 | 19:12:52 INFO - PROCESS | 2689 | [#0] dojo.html Cycles:165 Average:5795.13 Median:6029.10 stddev:653.75 (10.8%) stddev-sans-first:627.82 19:12:52 INFO - PROCESS | 2689 | Values: 3385.3 3419.6 3422.8 3443.6 3464.5 5675.3 5715.7 5736.9 5774.2 5776.5 5747.7 5769.1 5798.4 5822.0 5826.2 5260.7 5338.3 5357.3 5367.9 5422.8 5258.1 5322.7 5388.2 5426.3 5431.4 5323.8 5357.4 5364.9 5370.9 5426.0 5415.3 5427.7 5429.0 5430.2 5436.1 5152.8 5213.4 5294.3 5365.9 5479.4 5621.9 5694.1 5697.0 5756.3 5768.0 6236.4 6258.3 6286.4 6288.2 6289.8 6109.1 6230.8 6280.2 6308.8 6350.7 5909.1 5911.2 5914.5 5921.6 5946.8 6403.6 6413.6 6437.9 6446.9 6479.4 5925.1 5985.2 6022.2 6043.4 6217.9 6151.2 6173.6 6179.1 6179.9 6181.8 6105.7 6159.9 6162.0 6166.2 6171.5 6086.7 6110.9 6141.9 6254.9 6269.2 4747.0 4749.5 4759.4 4778.3 4779.1 4168.6 4236.5 4266.0 4270.1 4280.7 5831.3 5948.4 5970.9 5971.9 6007.3 6189.4 6204.4 6225.2 6248.4 6276.6 5929.2 6013.7 6029.1 6071.6 6074.7 5167.6 5170.4 5188.1 5189.4 5220.7 6523.5 6565.1 6566.1 6567.7 6584.5 6091.4 6134.0 6306.1 6315.3 6351.6 6335.7 6405.6 6498.1 6508.5 6524.3 6107.1 6127.1 6131.9 6132.2 6167.0 5907.3 6138.2 6193.3 6234.4 6252.4 6097.2 6102.0 6150.3 6160.8 6176.0 6132.2 6137.8 6141.1 6142.7 6152.4 5802.7 5900.9 5936.7 5972.3 5993.2 6089.7 6168.6 6170.6 6182.6 6205.4 6005.6 6038.5 6040.2 6087.4 6090.5 19:12:52 INFO - PROCESS | 2689 | 19:12:52 INFO - PROCESS | 2689 | [#1] ext.html Cycles:180 Average:64514.32 Median:44472.44 stddev:132903.80 (298.8%) stddev-sans-first:133189.97 19:12:52 INFO - PROCESS | 2689 | Values: 589.5 653.1 653.4 655.8 675.1 34855.5 38631.2 45651.8 46337.5 46479.8 48172.5 48696.5 48807.8 48812.0 48851.5 9072.6 9307.1 9312.1 9321.3 9370.8 9073.6 9181.7 9257.9 9258.4 9259.0 9291.8 9312.0 9328.9 9334.3 9369.8 9170.8 9249.4 9258.6 9295.3 9328.5 9166.2 9215.1 9300.1 9306.1 9309.1 44662.3 44883.6 44997.0 45007.0 45021.3 3559.7 3565.8 3699.7 3702.0 3783.6 33361.0 33850.7 35851.0 36234.0 37515.2 4690.4 4821.8 4829.8 4842.3 4881.7 366991.0 367437.0 368736.0 368910.0 371761.1 36361.6 71425.6 71807.6 72798.6 72907.6 39397.4 41730.6 41889.8 41893.0 41952.6 16989.1 17221.2 17263.4 17313.9 17317.6 14169.6 14285.6 14359.9 14417.9 14431.6 9405.2 9433.6 9474.9 9482.5 9501.6 3595.1 3620.3 3632.4 3665.2 3676.7 1122.7 1124.3 1166.6 1177.7 1240.2 33571.8 33849.3 33961.0 33995.2 34675.8 1193.0 1216.2 1245.2 1254.4 1286.8 17324.6 17630.7 17666.5 17863.1 17900.7 620678.0 680119.0 689662.0 690701.0 694144.0 60984.7 61501.0 61520.4 67312.0 67467.7 1494.9 1508.9 1512.5 1520.6 1533.5 33614.2 33651.7 34160.0 34295.8 34370.7 56329.7 56964.7 57312.4 57369.4 57385.0 384298.0 389541.0 389827.0 392164.0 392705.0 45951.0 46747.3 47078.0 47377.0 47442.0 50801.7 51595.0 51815.0 52199.2 52504.0 44134.6 44300.0 44625.3 44683.3 45302.3 43607.3 44302.0 44382.3 44924.1 45115.5 43116.0 43507.0 43550.8 44562.6 44573.8 38628.0 38820.6 38957.4 39576.0 39931.4 29198.4 29810.7 29974.3 30050.0 30129.5 19:12:52 INFO - PROCESS | 2689 | 19:12:52 INFO - PROCESS | 2689 | [#2] jquery.html Cycles:180 Average:31040.68 Median:2101.71 stddev:87976.51 (4186.0%) stddev-sans-first:88193.24 19:12:52 INFO - PROCESS | 2689 | Values: 412.1 418.3 429.0 434.3 443.7 18605.7 19966.0 20257.3 20447.3 20627.2 19654.8 19655.6 19772.7 20358.7 20425.3 5789.0 5955.2 5969.4 5970.7 6001.9 4362.0 5889.2 5991.8 6365.9 6389.3 6351.4 6437.8 6448.0 6458.1 6577.4 6642.8 6713.7 6755.1 6759.7 6782.4 5198.4 5512.5 5514.1 5599.0 5900.2 14953.2 15066.7 22164.1 23722.6 23815.0 2238.9 2273.1 2338.1 2458.3 2649.3 10584.6 10790.8 10905.9 11046.9 11243.9 2032.1 2040.4 2086.5 2116.9 2120.3 83208.6 83940.2 84446.6 85661.6 86125.6 11663.6 11673.4 12191.4 12533.1 12581.2 16911.9 16947.7 16971.6 17079.7 17120.7 8716.7 8859.0 8992.0 9011.5 9115.4 8594.2 8613.1 8664.4 8895.8 8907.7 5086.8 5092.5 5110.3 5121.1 5224.2 2079.9 2130.4 2148.9 2155.4 2175.7 1003.2 1047.3 1109.2 1128.6 1138.2 19451.5 19895.9 20048.6 20518.2 20715.0 1034.6 1057.0 1082.5 1087.7 1117.4 11239.6 11447.6 11527.6 11534.9 11605.5 521174.0 529093.0 536219.0 537928.0 542981.0 100780.0 100809.5 101400.0 103196.0 103914.5 1077.5 1083.9 1092.1 1098.0 1098.6 17878.8 18011.8 18051.9 18270.6 18325.8 40428.8 40906.8 41511.8 42005.8 43604.6 60187.0 61376.7 62186.0 62514.7 62975.7 8797.9 9087.9 9150.8 9326.5 9464.9 10511.9 13073.0 13884.1 14111.3 14337.6 12081.6 12327.6 12444.8 12680.7 12768.7 12195.9 12306.2 12308.9 12324.3 12418.6 12217.6 12495.2 12506.4 12557.9 12701.2 7693.5 8032.2 9157.1 9388.2 9422.9 11920.3 12116.8 12234.3 12319.9 12341.4 19:12:52 INFO - PROCESS | 2689 | 19:12:52 INFO - PROCESS | 2689 | [#3] mootools.html Cycles:180 Average:6187.08 Median:4247.09 stddev:3577.01 (84.2%) stddev-sans-first:3569.92 19:12:52 INFO - PROCESS | 2689 | Values: 1528.4 1591.1 1794.1 1884.4 1922.5 8494.9 9167.4 9202.9 9835.0 9871.5 9124.1 9387.2 9408.0 9419.9 9496.1 2417.3 2438.6 2438.9 2445.6 2461.2 2362.1 2395.1 2398.7 2403.7 2410.6 2360.8 2378.2 2427.9 2470.2 2471.7 2372.2 2373.9 2390.4 2419.4 2425.3 2355.2 2383.3 2393.2 2394.4 2407.5 9254.8 9327.5 9334.5 9391.4 9392.5 5594.9 5763.4 5765.5 5771.9 5788.6 3521.5 3525.1 3541.7 3549.3 3616.1 1167.8 1200.6 1207.0 1220.5 1237.3 13421.0 13463.3 13570.1 13578.7 13584.0 4695.5 4721.7 4824.0 4856.8 4877.8 10506.5 10525.5 10571.6 10575.2 10626.4 5522.9 5550.4 5552.1 5608.2 5627.5 4461.8 4934.2 5028.9 5031.7 5231.5 4125.9 4128.3 4196.4 4230.6 4247.2 1235.9 1240.4 1245.9 1247.5 1248.9 986.3 989.7 1025.2 1029.0 1066.0 6171.9 6262.2 6432.4 6619.0 6656.6 1030.8 1043.1 1045.7 1051.6 1057.1 4127.0 4189.7 4231.7 4247.0 4260.9 11381.9 11812.9 11830.8 11838.0 11839.6 11522.2 11594.0 11604.0 11670.4 11723.4 8855.1 8917.9 8961.2 9072.0 9092.5 6306.2 6355.0 6419.1 6431.2 6560.4 10888.5 11174.6 11249.0 11289.4 11361.8 11134.9 11359.6 11480.4 11488.6 11553.3 7850.8 8007.4 8009.9 8236.3 8251.6 8745.4 8769.3 8776.3 8808.5 8844.0 8186.8 8385.2 8439.2 8455.8 8499.2 7959.9 8054.9 8184.9 8246.3 8338.6 7142.2 7346.4 7390.1 7396.7 7418.4 5235.9 5311.6 5346.2 5431.3 5587.4 5367.2 5369.4 5384.2 5476.1 5541.2 19:12:52 INFO - PROCESS | 2689 | 19:12:52 INFO - PROCESS | 2689 | [#4] prototype.html Cycles:180 Average:5109.03 Median:5677.78 stddev:1501.89 (26.5%) stddev-sans-first:1463.10 19:12:52 INFO - PROCESS | 2689 | Values: 355.1 364.2 366.6 369.2 374.3 5615.9 5697.6 5727.6 5819.0 5855.0 5739.8 5772.6 5779.2 5792.7 5803.5 4532.3 4540.8 4549.7 4555.3 4629.8 4478.3 4535.8 4542.9 4547.8 4633.1 4468.6 4475.4 4497.8 4530.2 4538.3 4280.7 4528.9 4547.7 4563.7 4587.8 3938.6 3949.2 3957.1 3960.9 3964.1 5549.0 5609.4 5643.7 5644.0 5653.2 5124.5 5138.8 5164.8 5182.2 5193.8 6016.2 6017.8 6019.8 6031.5 6086.2 4394.9 4398.3 4402.1 4402.9 4423.2 6178.4 6355.6 6365.4 6398.3 6408.9 4480.3 4504.2 4506.2 4514.2 4520.1 4546.6 4579.8 4586.9 4595.8 4599.2 5045.7 5064.5 5144.5 5165.6 5184.2 5845.9 6042.3 6068.5 6084.9 6134.0 1555.8 1564.1 1568.4 1571.2 1574.9 978.6 998.9 1009.4 1014.1 1025.7 5345.3 5355.8 5381.9 5391.7 5433.8 5576.4 5635.9 5641.2 5660.3 5695.2 5249.9 5385.4 5514.0 6016.3 6023.4 3310.5 3340.7 3362.6 3363.3 3367.1 6246.9 6509.3 6544.3 6567.0 6577.9 6350.4 6393.8 6397.7 6432.5 6433.8 6327.2 6486.4 6511.2 6520.0 6529.9 6244.9 6283.9 6289.8 6292.2 6327.3 6210.1 6230.6 6235.1 6266.4 6273.0 6270.9 6450.7 6480.4 6511.1 6529.6 4405.9 4415.9 4425.0 4453.8 4464.0 6174.2 6346.4 6377.5 6384.2 6406.7 6107.4 6115.5 6138.1 6144.9 6177.4 6000.7 6168.8 6183.3 6209.5 6210.8 5980.1 5985.7 5991.3 5995.2 6013.8 6099.6 6119.7 6141.9 6214.4 6233.4 5941.6 6020.4 6041.3 6045.9 6072.3 19:12:52 INFO - PROCESS | 2689 | 19:12:52 INFO - PROCESS | 2689 | [#5] yui.html Cycles:180 Average:21768.61 Median:4162.24 stddev:31127.26 (747.8%) stddev-sans-first:31174.65 19:12:52 INFO - PROCESS | 2689 | Values: 769.4 818.9 828.5 846.2 898.5 15736.0 16481.5 16485.2 16536.7 16634.1 15596.5 15770.5 15808.8 15818.4 15837.0 703.5 839.3 859.8 861.0 864.8 853.0 855.9 857.8 858.7 858.7 905.4 907.6 908.6 909.3 910.2 891.4 896.8 899.0 900.5 900.7 661.4 662.0 663.1 663.3 666.5 15282.6 15297.4 15367.0 15402.8 15420.9 16226.0 16293.8 16433.8 16646.5 16983.7 13240.7 13557.2 13559.1 13602.2 13690.7 4049.6 4060.3 4096.2 4154.5 4170.0 77616.2 78051.0 78467.0 78826.6 80645.2 12327.3 12383.6 12431.4 12536.1 12572.4 21729.6 22484.4 23857.9 24068.3 24107.9 8738.9 8821.5 8905.3 8983.3 9331.8 5311.6 5375.6 5388.2 5392.5 5455.2 3714.8 3847.0 3857.2 3864.4 3868.1 650.5 652.7 657.9 660.9 670.9 690.6 745.6 766.9 801.1 807.1 10823.8 10830.4 10959.5 11137.1 11324.3 695.2 745.9 761.3 789.2 794.2 4959.6 4967.0 4984.5 5159.2 5166.4 115921.0 118215.0 118425.4 122781.4 124447.0 90311.1 93807.5 99885.5 101209.5 104702.4 91614.0 92996.1 93201.5 93276.0 94683.5 9756.3 9767.5 9812.8 9823.4 9848.4 55315.7 55557.7 55873.4 56916.1 57707.1 73241.6 78068.0 79035.2 81403.0 81839.6 12787.6 12931.6 12981.2 13003.6 13406.9 14133.6 14522.2 14538.9 14567.3 14998.4 12498.7 12576.4 12855.3 13184.7 13259.9 13432.9 13461.5 13481.0 13691.2 13700.0 13196.7 13307.7 13482.7 13823.4 13862.1 11187.8 11243.2 11322.9 11348.5 11353.7 11321.5 11447.4 11519.9 11553.9 11600.9 19:12:52 INFO - PROCESS | 2689 | -------- Summary: end -------- 19:12:52 INFO - PROCESS | 2689 | 19:12:53 INFO - TEST-INFO | 2689: exit 0 19:12:53 INFO - TEST-OK | dromaeo_css | took 1111519ms 19:12:53 INFO - TEST-START | kraken 19:12:53 INFO - operating with platform_type : linux_ 19:12:53 INFO - Initialising browser for kraken test... 19:12:53 INFO - TEST-INFO | started process 3036 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnw7ruH/profile http://localhost:42145/getInfo.html) 19:12:58 INFO - PROCESS | 3036 | __metrics Screen width/height:1600/1200 19:12:58 INFO - PROCESS | 3036 | colorDepth:24 19:12:58 INFO - PROCESS | 3036 | Browser inner width/height: 1024/697 19:12:58 INFO - PROCESS | 3036 | __metrics 19:12:59 ERROR - PROCESS | 3036 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2944: TypeError: this.tabs is undefined 19:13:00 INFO - TEST-INFO | 3036: exit 0 19:13:00 INFO - Browser initialized. 19:13:00 INFO - Running cycle 1/1 for kraken test... 19:13:00 INFO - TEST-INFO | started process 3166 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnw7ruH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:13:11 INFO - PROCESS | 3166 | RSS: Main: 156127232 19:13:11 INFO - PROCESS | 3166 | 19:13:14 INFO - PROCESS | 3166 | Cycle 1(1): loaded http://localhost:42145/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42145/tests/kraken/driver.html?testName=audio-beat-detection) 19:13:15 INFO - PROCESS | 3166 | RSS: Main: 161603584 19:13:15 INFO - PROCESS | 3166 | 19:13:17 INFO - PROCESS | 3166 | Cycle 1(1): loaded http://localhost:42145/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42145/tests/kraken/driver.html?testName=audio-dft) 19:13:18 INFO - PROCESS | 3166 | RSS: Main: 160788480 19:13:18 INFO - PROCESS | 3166 | 19:13:21 INFO - PROCESS | 3166 | Cycle 1(1): loaded http://localhost:42145/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42145/tests/kraken/driver.html?testName=audio-fft) 19:13:22 INFO - PROCESS | 3166 | RSS: Main: 161697792 19:13:22 INFO - PROCESS | 3166 | 19:13:24 INFO - PROCESS | 3166 | Cycle 1(1): loaded http://localhost:42145/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42145/tests/kraken/driver.html?testName=audio-oscillator) 19:13:24 INFO - PROCESS | 3166 | RSS: Main: 161087488 19:13:24 INFO - PROCESS | 3166 | 19:13:26 INFO - PROCESS | 3166 | Cycle 1(1): loaded http://localhost:42145/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42145/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:13:27 INFO - PROCESS | 3166 | RSS: Main: 161329152 19:13:27 INFO - PROCESS | 3166 | 19:13:30 INFO - PROCESS | 3166 | Cycle 1(1): loaded http://localhost:42145/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42145/tests/kraken/driver.html?testName=imaging-darkroom) 19:13:31 INFO - PROCESS | 3166 | RSS: Main: 160899072 19:13:31 INFO - PROCESS | 3166 | 19:13:34 INFO - PROCESS | 3166 | Cycle 1(1): loaded http://localhost:42145/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42145/tests/kraken/driver.html?testName=imaging-desaturate) 19:13:35 INFO - PROCESS | 3166 | RSS: Main: 157925376 19:13:35 INFO - PROCESS | 3166 | 19:13:38 INFO - PROCESS | 3166 | Cycle 1(1): loaded http://localhost:42145/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42145/tests/kraken/driver.html?testName=json-parse-financial) 19:13:38 INFO - PROCESS | 3166 | RSS: Main: 159358976 19:13:38 INFO - PROCESS | 3166 | 19:13:40 INFO - PROCESS | 3166 | Cycle 1(1): loaded http://localhost:42145/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42145/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:13:40 INFO - PROCESS | 3166 | RSS: Main: 159309824 19:13:40 INFO - PROCESS | 3166 | 19:13:42 INFO - PROCESS | 3166 | Cycle 1(1): loaded http://localhost:42145/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42145/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:13:43 INFO - PROCESS | 3166 | RSS: Main: 159805440 19:13:43 INFO - PROCESS | 3166 | 19:13:45 INFO - PROCESS | 3166 | Cycle 1(1): loaded http://localhost:42145/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42145/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:13:46 INFO - PROCESS | 3166 | RSS: Main: 160468992 19:13:46 INFO - PROCESS | 3166 | 19:13:48 INFO - PROCESS | 3166 | Cycle 1(1): loaded http://localhost:42145/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42145/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:13:49 INFO - PROCESS | 3166 | RSS: Main: 160456704 19:13:49 INFO - PROCESS | 3166 | 19:13:51 INFO - PROCESS | 3166 | Cycle 1(1): loaded http://localhost:42145/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42145/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:13:52 INFO - PROCESS | 3166 | RSS: Main: 160309248 19:13:52 INFO - PROCESS | 3166 | 19:13:54 INFO - PROCESS | 3166 | Cycle 1(1): loaded http://localhost:42145/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42145/tests/kraken/driver.html?testName=ai-astar) 19:13:54 INFO - PROCESS | 3166 | RSS: Main: 161386496 19:13:54 INFO - PROCESS | 3166 | 19:13:54 INFO - PROCESS | 3166 | __start_tp_report 19:13:54 INFO - PROCESS | 3166 | _x_x_mozilla_page_load 19:13:54 INFO - PROCESS | 3166 | _x_x_mozilla_page_load_details 19:13:54 INFO - PROCESS | 3166 | |i|pagename|runs| 19:13:54 INFO - PROCESS | 3166 | |0;ai-astar;113;103;110;110;111;110;111;111;110;110 19:13:54 INFO - PROCESS | 3166 | |1;audio-beat-detection;155;126;156;177;127;147;156;125;180;126 19:13:54 INFO - PROCESS | 3166 | |2;audio-dft;163;165;163;164;164;164;164;163;163;164 19:13:54 INFO - PROCESS | 3166 | |3;audio-fft;76;77;76;190;76;77;75;77;177;75 19:13:54 INFO - PROCESS | 3166 | |4;audio-oscillator;83;84;154;84;84;84;145;90;85;153 19:13:54 INFO - PROCESS | 3166 | |5;imaging-gaussian-blur;118;121;117;117;117;117;122;117;119;117 19:13:54 INFO - PROCESS | 3166 | |6;imaging-darkroom;150;150;147;147;147;147;147;154;147;148 19:13:54 INFO - PROCESS | 3166 | |7;imaging-desaturate;96;98;95;95;95;97;96;96;96;96 19:13:54 INFO - PROCESS | 3166 | |8;json-parse-financial;58;53;53;52;58;53;54;56;53;60 19:13:54 INFO - PROCESS | 3166 | |9;json-stringify-tinderbox;60;60;61;60;59;60;60;61;61;64 19:13:54 INFO - PROCESS | 3166 | |10;stanford-crypto-aes;82;76;82;75;81;78;78;77;100;79 19:13:54 INFO - PROCESS | 3166 | |11;stanford-crypto-ccm;134;128;137;129;137;131;130;127;127;125 19:13:54 INFO - PROCESS | 3166 | |12;stanford-crypto-pbkdf2;155;158;155;161;155;157;159;161;155;157 19:13:54 INFO - PROCESS | 3166 | |13;stanford-crypto-sha256-iterative;61;62;64;63;63;67;63;63;61;65 19:13:54 INFO - PROCESS | 3166 | __end_tp_report 19:13:54 INFO - PROCESS | 3166 | __start_cc_report 19:13:54 INFO - PROCESS | 3166 | _x_x_mozilla_cycle_collect,852 19:13:54 INFO - PROCESS | 3166 | __end_cc_report 19:13:54 INFO - PROCESS | 3166 | __startTimestamp1465438434453__endTimestamp 19:13:54 INFO - PROCESS | 3166 | 19:13:54 INFO - PROCESS | 3166 | ------- Summary: start ------- 19:13:54 INFO - PROCESS | 3166 | Number of tests: 14 19:13:54 INFO - PROCESS | 3166 | 19:13:54 INFO - PROCESS | 3166 | [#0] ai-astar Cycles:10 Average:109.90 Median:110.50 stddev:2.60 (2.4%) stddev-sans-first:2.51 19:13:54 INFO - PROCESS | 3166 | Values: 113.0 103.0 110.0 110.0 111.0 110.0 111.0 111.0 110.0 110.0 19:13:54 INFO - PROCESS | 3166 | 19:13:54 INFO - PROCESS | 3166 | [#1] audio-beat-detection Cycles:10 Average:147.50 Median:155.50 stddev:21.03 (13.5%) stddev-sans-first:22.12 19:13:54 INFO - PROCESS | 3166 | Values: 155.0 126.0 156.0 177.0 127.0 147.0 156.0 125.0 180.0 126.0 19:13:54 INFO - PROCESS | 3166 | 19:13:54 INFO - PROCESS | 3166 | [#2] audio-dft Cycles:10 Average:163.70 Median:164.00 stddev:0.67 (0.4%) stddev-sans-first:0.67 19:13:54 INFO - PROCESS | 3166 | Values: 163.0 165.0 163.0 164.0 164.0 164.0 164.0 163.0 163.0 164.0 19:13:54 INFO - PROCESS | 3166 | 19:13:54 INFO - PROCESS | 3166 | [#3] audio-fft Cycles:10 Average:97.60 Median:76.00 stddev:45.38 (59.7%) stddev-sans-first:47.46 19:13:54 INFO - PROCESS | 3166 | Values: 76.0 77.0 76.0 190.0 76.0 77.0 75.0 77.0 177.0 75.0 19:13:54 INFO - PROCESS | 3166 | 19:13:54 INFO - PROCESS | 3166 | [#4] audio-oscillator Cycles:10 Average:104.60 Median:84.00 stddev:31.93 (38.0%) stddev-sans-first:32.90 19:13:54 INFO - PROCESS | 3166 | Values: 83.0 84.0 154.0 84.0 84.0 84.0 145.0 90.0 85.0 153.0 19:13:54 INFO - PROCESS | 3166 | 19:13:54 INFO - PROCESS | 3166 | [#5] imaging-gaussian-blur Cycles:10 Average:118.20 Median:117.50 stddev:1.87 (1.6%) stddev-sans-first:1.99 19:13:54 INFO - PROCESS | 3166 | Values: 118.0 121.0 117.0 117.0 117.0 117.0 122.0 117.0 119.0 117.0 19:13:54 INFO - PROCESS | 3166 | 19:13:54 INFO - PROCESS | 3166 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:147.50 stddev:2.32 (1.6%) stddev-sans-first:2.39 19:13:54 INFO - PROCESS | 3166 | Values: 150.0 150.0 147.0 147.0 147.0 147.0 147.0 154.0 147.0 148.0 19:13:54 INFO - PROCESS | 3166 | 19:13:54 INFO - PROCESS | 3166 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.94 (1.0%) stddev-sans-first:1.00 19:13:54 INFO - PROCESS | 3166 | Values: 96.0 98.0 95.0 95.0 95.0 97.0 96.0 96.0 96.0 96.0 19:13:54 INFO - PROCESS | 3166 | 19:13:54 INFO - PROCESS | 3166 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:55.00 stddev:2.79 (5.1%) stddev-sans-first:2.74 19:13:54 INFO - PROCESS | 3166 | Values: 58.0 53.0 53.0 52.0 58.0 53.0 54.0 56.0 53.0 60.0 19:13:54 INFO - PROCESS | 3166 | 19:13:54 INFO - PROCESS | 3166 | [#9] json-stringify-tinderbox Cycles:10 Average:60.60 Median:60.50 stddev:1.35 (2.2%) stddev-sans-first:1.41 19:13:54 INFO - PROCESS | 3166 | Values: 60.0 60.0 61.0 60.0 59.0 60.0 60.0 61.0 61.0 64.0 19:13:54 INFO - PROCESS | 3166 | 19:13:54 INFO - PROCESS | 3166 | [#10] stanford-crypto-aes Cycles:10 Average:80.80 Median:78.50 stddev:7.16 (9.1%) stddev-sans-first:7.58 19:13:54 INFO - PROCESS | 3166 | Values: 82.0 76.0 82.0 75.0 81.0 78.0 78.0 77.0 100.0 79.0 19:13:54 INFO - PROCESS | 3166 | 19:13:54 INFO - PROCESS | 3166 | [#11] stanford-crypto-ccm Cycles:10 Average:130.50 Median:130.50 stddev:4.22 (3.2%) stddev-sans-first:4.28 19:13:54 INFO - PROCESS | 3166 | Values: 134.0 128.0 137.0 129.0 137.0 131.0 130.0 127.0 127.0 125.0 19:13:54 INFO - PROCESS | 3166 | 19:13:54 INFO - PROCESS | 3166 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.30 Median:157.50 stddev:2.41 (1.5%) stddev-sans-first:2.40 19:13:54 INFO - PROCESS | 3166 | Values: 155.0 158.0 155.0 161.0 155.0 157.0 159.0 161.0 155.0 157.0 19:13:54 INFO - PROCESS | 3166 | 19:13:54 INFO - PROCESS | 3166 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:63.00 stddev:1.81 (2.9%) stddev-sans-first:1.74 19:13:54 INFO - PROCESS | 3166 | Values: 61.0 62.0 64.0 63.0 63.0 67.0 63.0 63.0 61.0 65.0 19:13:54 INFO - PROCESS | 3166 | -------- Summary: end -------- 19:13:54 INFO - PROCESS | 3166 | 19:13:55 INFO - TEST-INFO | 3166: exit 0 19:13:55 INFO - TEST-OK | kraken | took 61783ms 19:13:55 INFO - SUITE-END | took 1173s 19:13:55 INFO - Completed test suite (00:19:33) 19:13:55 INFO - javascript benchmark 19:13:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7716.452973442659, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3385.322935412917, 3419.589649242091, 3422.794632322061, 3443.621201667816, 3464.4803279508055, 5675.3189617245935, 5715.742791574378, 5736.856578585533, 5774.16274640178, 5776.508996735272, 5747.683877386742, 5769.134629805531, 5798.391168927265, 5822.039363505017, 5826.155207494921, 5260.736963151846, 5338.27933229015, 5357.330333708286, 5367.946320536803, 5422.783088676449, 5258.0535503609335, 5322.680639161663, 5388.164834450667, 5426.321709786277, 5431.375391829951, 5323.787048518055, 5357.383900851413, 5364.946350536484, 5370.91943620846, 5425.9728701356435, 5415.323084614423, 5427.701476418795, 5428.972855135718, 5430.185472179165, 5436.130219164915, 5152.845414637567, 5213.400458947193, 5294.338207724035, 5365.919511207335, 5479.397266300703, 5621.943780562183, 5694.060480020791, 5696.974544582015, 5756.33802112754, 5767.971160144214, 6236.438720515175, 6258.311585725566, 6286.402791734778, 6288.245410550763, 6289.811305660837, 6109.053096770008, 6230.844228894269, 6280.183576135073, 6308.810735677937, 6350.682465876734, 5909.143174239711, 5911.201987731644, 5914.4676979071655, 5921.555883308813, 5946.821595352147, 6403.551751377358, 6413.647249401328, 6437.871242575122, 6446.903296450557, 6479.3520647935775, 5925.05199168131, 5985.191999080069, 6022.247219097613, 6043.36544662804, 6217.875642487125, 6151.169592105098, 6173.56785025044, 6179.104029915727, 6179.876402472015, 6181.783637572664, 6105.725242364104, 6159.907601385983, 6161.96919015411, 6166.229221347332, 6171.506279497629, 6086.695665216722, 6110.923300256496, 6141.907871381933, 6254.906176407358, 6269.153664255358, 4746.952530474651, 4749.548792864673, 4759.405074365704, 4778.283257511401, 4779.115863565252, 4168.603982621707, 4236.5128010278595, 4265.97867010663, 4270.12462445198, 4280.743155410685, 5831.329397119385, 5948.405159484017, 5970.910436343458, 5971.910421343683, 6007.339192688888, 6189.35011823761, 6204.410580994799, 6225.159603453566, 6248.375162483715, 6276.592021518587, 5929.169916211734, 6013.729382177812, 6029.095635654599, 6071.574989750763, 6074.696265186812, 5167.586593072545, 5170.353705786777, 5188.092083885305, 5189.377274726981, 5220.660657057279, 6523.478121750249, 6565.080888675589, 6566.1135746674545, 6567.737290508422, 6584.473242140617, 6091.390860914051, 6134.008014331881, 6306.1171435998995, 6315.336889626707, 6351.555391122762, 6335.683215839282, 6405.615663060231, 6498.122753428227, 6508.511861610493, 6524.3149469305035, 6107.053406721965, 6127.111568822406, 6131.877362452815, 6132.233470816148, 6166.951618224823, 5907.261592300963, 6138.1738283688655, 6193.287771906108, 6234.407731265704, 6252.406021427957, 6097.209380933946, 6101.969490152698, 6150.292716337678, 6160.784372546939, 6176.0, 6132.233470816148, 6137.752221850432, 6141.07883817431, 6142.744345496893, 6152.446279834837, 5802.65184088956, 5900.911486327795, 5936.673482958478, 5972.25346831646, 5993.22088128558, 6089.665068421279, 6168.599041062316, 6170.598911070766, 6182.567220294536, 6205.410486003822, 6005.579609427298, 6038.456538911343, 6040.214772079602, 6087.36082711309, 6090.482309003607], "value": 5751.595069806958, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [589.5431040943268, 653.0661154548993, 653.353180351452, 655.7835914148328, 675.0987431778577, 34855.4771678425, 38631.22737545247, 45651.77174114129, 46337.53662463383, 46479.76760116195, 48172.51827481733, 48696.51303486964, 48807.75596122023, 48812.0, 48851.51148488523, 9072.591733371997, 9307.11582399671, 9312.115349041864, 9321.300902432311, 9370.765730856749, 9073.63705451781, 9181.724548263563, 9257.861132083024, 9258.398204116744, 9258.953705231497, 9291.814163716721, 9311.953440232823, 9328.906710932906, 9334.253259739238, 9369.812603747921, 9170.816583668322, 9249.445033298023, 9258.583363748647, 9295.256379489625, 9328.533573321307, 9166.220871225954, 9215.078492150798, 9300.069993000714, 9306.069393060707, 9309.115634014826, 44662.33006504905, 44883.551164488264, 44997.0, 45007.0, 45021.32468012982, 3559.7330200235087, 3565.7682250653625, 3699.6855267302044, 3701.9629803701887, 3783.564890037626, 33361.0, 33850.661493385, 35851.0, 36234.0, 37515.24969500595, 4690.390249267573, 4821.7589120543835, 4829.758512074382, 4842.297866809328, 4881.658283920127, 366991.0, 367437.0, 368736.0, 368910.0, 371761.141194295, 36361.63638363582, 71425.64287178531, 71807.6409617959, 72798.63600682068, 72907.63546182342, 39397.40903886444, 41730.58269417267, 41889.79055104705, 41893.0, 41952.58047419487, 16989.065601391794, 17221.225044873012, 17263.39578114785, 17313.913430432767, 17317.567060823327, 14169.574912752427, 14285.64285892861, 14359.85640143606, 14417.855821441652, 14431.567052988426, 9405.15353618164, 9433.622655093719, 9474.905250947402, 9482.478463684563, 9501.572429240701, 3595.0832537702718, 3620.330238905811, 3632.4006538921312, 3665.17533554948, 3676.6874815640435, 1122.693667150251, 1124.3141683573015, 1166.585862018988, 1177.7055736065984, 1240.1938739819009, 33571.83214083963, 33849.32301354008, 33961.0, 33995.15012124717, 34675.826620866734, 1192.9582464613698, 1216.1790791215894, 1245.2217364147407, 1254.3665448948223, 1286.8069789531646, 17324.566885827702, 17630.735538966925, 17666.470005899842, 17863.106844657974, 17900.731489027676, 620678.0, 680119.0, 689662.0, 690701.0, 694144.0, 60984.69507652433, 61501.0, 61520.384796152364, 67312.0, 67467.66266168735, 1494.9327280272414, 1508.9170095644624, 1512.470635277644, 1520.6426489774894, 1533.4862820955104, 33614.15964600807, 33651.66348336485, 34160.0, 34295.7729019462, 34370.65629343675, 56329.71835140798, 56964.71517642551, 57312.42687573071, 57369.42630573808, 57385.0, 384298.0, 389541.0, 389827.0, 392164.0, 392705.0, 45951.0, 46747.29879051885, 47078.0, 47377.0, 47442.0, 50801.74599126981, 51595.0, 51815.0, 52199.21701174409, 52504.0, 44134.55865441304, 44300.0, 44625.33062004137, 44683.329750053126, 45302.320465193705, 43607.34588981231, 44302.0, 44382.3342649854, 44924.10151797011, 45115.54884451245, 43116.0, 43507.0, 43550.782246088565, 44562.55437445584, 44573.77713111414, 38628.0, 38820.6117938817, 38957.415638764876, 39576.0, 39931.40102898401, 29198.416031679673, 29810.70189298166, 29974.25064373408, 30050.0, 30129.548056778727], "value": 20677.94274153445, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [412.1406866682966, 418.32858262488685, 428.98069586868587, 434.25308469432576, 443.69385124264255, 18605.72091418628, 19966.0, 20257.290994815165, 20447.28434504789, 20627.17491300348, 19654.803451965476, 19655.60688786227, 19772.703409448834, 20358.694619580718, 20425.28511502098, 5789.0448076067505, 5955.1960485334575, 5969.403059694017, 5970.701464926758, 6001.87996240075, 4362.018545827195, 5889.204957330749, 5991.790287339944, 6365.872682546346, 6389.265234498022, 6351.396617321347, 6437.80686579401, 6448.032795080729, 6458.063580780784, 6577.440917522016, 6642.767503137367, 6713.664316784141, 6755.054292399043, 6759.695813688371, 6782.423494003016, 5198.428172900978, 5512.503874651301, 5514.0901751211, 5599.0, 5900.20347253124, 14953.177575233358, 15066.698666026728, 22164.11343546256, 23722.644160337437, 23815.0, 2238.921637742671, 2273.090763694519, 2338.088145623208, 2458.299384675359, 2649.3111790934304, 10584.629537966212, 10790.784184316348, 10905.890941090567, 11046.889531104667, 11243.943780281128, 2032.1058734156923, 2040.357287454447, 2086.4992401823606, 2116.9153233870625, 2120.310898957845, 83208.58395708044, 83940.16059839446, 84446.57776711139, 85661.57169214176, 86125.56937215336, 11663.608960163147, 11673.416329183678, 12191.390430478441, 12533.122681412213, 12581.245125292511, 16911.91544042272, 16947.661046778994, 16971.575710607332, 17079.658406831793, 17120.74318885218, 8716.694915678048, 8859.0, 8991.955040224757, 9011.504367259864, 9115.407498512575, 8594.183552562497, 8613.095624959415, 8664.436811607351, 8895.777605559913, 8907.688230912017, 5086.847394578169, 5092.465291144451, 5110.310108135429, 5121.103806833789, 5224.190250511177, 2079.9376018719463, 2130.371540395587, 2148.8710677359095, 2155.3964889830872, 2175.7029866014495, 1003.2375394700081, 1047.3035431438161, 1109.1514991031868, 1128.5993472317373, 1138.1805100327751, 19451.51371215731, 19895.905725184963, 20048.59902801936, 20518.17927282892, 20715.0, 1034.5551412892378, 1057.0116940660507, 1082.4533610526635, 1087.6628245243999, 1117.413357987047, 11239.550417983353, 11447.599334023436, 11527.596534121432, 11534.884651153381, 11605.477753501113, 521174.0, 529093.0, 536219.0, 537928.0, 542981.0, 100780.0, 100809.49595251976, 101400.0, 103196.0, 103914.48042759737, 1077.4828082520435, 1083.9403832789114, 1092.1426680056118, 1097.983530247047, 1098.566066403766, 17878.821211787716, 18011.819881801013, 18051.909740451214, 18270.634587308446, 18325.816741832412, 40428.79785601053, 40906.79546602248, 41511.7924410376, 42005.78997105117, 43604.56395436005, 60187.0, 61376.69311653413, 62186.0, 62514.687426562574, 62975.6851215741, 8797.868031979653, 9087.863682044906, 9150.816983660423, 9326.533673316442, 9464.905350946403, 10511.94744026275, 13073.0, 13884.09753366028, 14111.2944352784, 14337.56987290383, 12081.637550873487, 12327.630171094881, 12444.751104978031, 12680.74638507243, 12768.74462510726, 12195.878041219474, 12306.200096993667, 12308.876911230773, 12324.32216228116, 12418.627441176779, 12217.633470995885, 12495.187812792139, 12506.43721032574, 12557.93721031389, 12701.174423662433, 7693.4614576979075, 8032.196780321921, 9157.130072643089, 9388.155066044088, 9422.858657120285, 11920.344381058778, 12116.818247726467, 12234.327112008568, 12319.876801231872, 12341.3829308536], "value": 9764.453996403417, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1528.3580896023666, 1591.1487354265466, 1794.102948525737, 1884.4346695991198, 1922.4617107209976, 8494.91505084949, 9167.358284920057, 9202.861957070641, 9835.0, 9871.506424678764, 9124.133207345292, 9387.249020078394, 9407.952960235189, 9419.858702119474, 9496.145346918776, 2417.2869003643923, 2438.6463962725393, 2438.890249938757, 2445.572024895645, 2461.163204510466, 2362.14962613459, 2395.149721848736, 2398.712154541449, 2403.71155461344, 2410.5660981023407, 2360.7993320567684, 2378.227076200233, 2427.9393015174587, 2470.1601455505124, 2471.7033955925226, 2372.169740590788, 2373.9287821365388, 2390.414348484615, 2419.358869899478, 2425.333033415816, 2355.2227764837735, 2383.2611890314056, 2393.1623931623794, 2394.437307232799, 2407.4944261705064, 9254.814903701956, 9327.533623318806, 9334.486603236819, 9391.436513809193, 9392.530373481299, 5594.888102237933, 5763.3948435414095, 5765.509931655814, 5771.913421298684, 5788.565857560699, 3521.542199514047, 3525.11872031992, 3541.734369922266, 3549.3256281306467, 3616.1140520572367, 1167.7781221567875, 1200.6278053803348, 1206.9939650301692, 1220.4690959432676, 1237.257645412754, 13421.0, 13463.326833658279, 13570.050096493249, 13578.660533486644, 13584.0, 4695.5069717679835, 4721.693089949143, 4823.9517604824205, 4856.757162141878, 4877.756112194376, 10506.474676266156, 10525.473726313654, 10571.577136914591, 10575.153987680967, 10626.36241825493, 5522.889542209134, 5550.389457159709, 5552.139418390156, 5608.186812912105, 5627.493525582635, 4461.843835465743, 4934.210526315772, 5028.924566131511, 5031.723255220924, 5231.503007214308, 4125.938110928339, 4128.318827393447, 4196.412502249687, 4230.598093181143, 4247.193033323659, 1235.9382030898419, 1240.4294024748717, 1245.894099001577, 1247.5197049135966, 1248.875112488762, 986.2701600815345, 989.6684610655367, 1025.2464438637596, 1028.9639862604772, 1065.9946700266605, 6171.876562468726, 6262.185915830913, 6432.388923052303, 6618.966905165444, 6656.567323123982, 1030.8144533983955, 1043.0820877627639, 1045.6810672744734, 1051.5951358726945, 1057.1384321777728, 4127.0, 4189.664826813848, 4231.724937879028, 4246.978765106154, 4260.8721738347895, 11381.943090284662, 11812.940935295268, 11830.822537661941, 11838.0, 11839.58561450345, 11522.193446458667, 11594.0, 11604.0, 11670.358130302915, 11723.4138293085, 8855.114488551222, 8917.866232006525, 8961.193492585699, 9071.954640226757, 9092.499912504876, 6306.180196574416, 6355.046742988588, 6419.101325814297, 6431.163948686641, 6560.442362399059, 10888.51001704941, 11174.55301787952, 11249.0, 11289.37908415045, 11361.772764544829, 11134.888651113386, 11359.602413915472, 11480.425978701198, 11488.597899073493, 11553.30680159193, 7850.764477065697, 8007.439479236397, 8009.879851802344, 8236.258736713724, 8251.587420629065, 8745.387822852339, 8769.298456123623, 8776.34177436682, 8808.471491710518, 8843.955780221315, 8186.7953301167945, 8385.245327920273, 8439.240468357631, 8455.830883382421, 8499.19257670545, 7959.920400795918, 8054.879176812469, 8184.8772268417215, 8246.299064579578, 8338.583070846313, 7142.214356420894, 7346.449016323691, 7390.076240469942, 7396.704131834666, 7418.369438597564, 5235.869103272296, 5311.575073994149, 5346.1980702893325, 5431.321084864392, 5587.44125587438, 5367.194920761917, 5369.35567731859, 5384.246205531307, 5476.069068258326, 5541.168824676331], "value": 4923.916491336691, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.1069061310802, 364.1533434764174, 366.63336663336645, 369.2098908336161, 374.3019269063198, 5615.9157612635745, 5697.601167918242, 5727.627704199234, 5819.0, 5854.970725146373, 5739.770409183628, 5772.5670574706855, 5779.190913272135, 5792.71036448178, 5803.535717142629, 4532.297493888453, 4540.818367265306, 4549.749763762991, 4555.271156614942, 4629.79165937532, 4478.26108692067, 4535.841245556406, 4542.886427839314, 4547.795349209294, 4633.142868569325, 4468.5754853289045, 4475.373447717322, 4497.797599108032, 4530.207213737599, 4538.341940418637, 4280.700350975433, 4528.864134075983, 4547.681662283641, 4563.70335928167, 4587.793549290256, 3938.5667576566557, 3949.2299001694682, 3957.1492129192075, 3960.890950533855, 3964.108075682977, 5549.0, 5609.411011843738, 5643.661380317153, 5644.0, 5653.236813030229, 5124.538791508782, 5138.820141295074, 5164.793408263665, 5182.170852663593, 5193.844184674465, 6016.157737916695, 6017.849553761147, 6019.789307374221, 6031.45716885478, 6086.2087928569, 4394.934075988863, 4398.296272596369, 4402.141582391435, 4402.867913962555, 4423.203823311803, 6178.351273116303, 6355.618662880288, 6365.395287447685, 6398.264199617057, 6408.871822563523, 4480.305552639346, 4504.211762941472, 4506.211413002711, 4514.187446259639, 4520.141173177086, 4546.568076032771, 4579.771011449481, 4586.862394128181, 4595.839145629887, 4599.218132917412, 5045.672031317952, 5064.471797619542, 5144.485551444825, 5165.560927321219, 5184.170532714747, 5845.88308233833, 6042.335343112254, 6068.4538391544975, 6084.908726369108, 6134.018557030854, 1555.7588573771084, 1564.1319067917416, 1568.3648122510401, 1571.1986886687644, 1574.8582627563574, 978.6379039755336, 998.8951160128082, 1009.3842755918884, 1014.1329163565193, 1025.6922923123182, 5345.251664766935, 5355.839324820262, 5381.892362152735, 5391.676499410048, 5433.755481003364, 5576.358718747396, 5635.859103522363, 5641.210230567724, 5660.320761508646, 5695.231143795618, 5249.897521520447, 5385.353757549041, 5514.0, 6016.345504986164, 6023.367546407651, 3310.486874534451, 3340.7494437917253, 3362.646922073147, 3363.3105213431186, 3367.0572239772905, 6246.937530624727, 6509.349065093453, 6544.280129185786, 6567.0, 6577.901331480031, 6350.364963503705, 6393.840153996187, 6397.7440902364315, 6432.494290611628, 6433.839154021093, 6327.2090988625505, 6486.4486518646445, 6511.218653761579, 6520.0, 6529.934700653028, 6244.937550624436, 6283.868903597397, 6289.811305660837, 6292.2134733158355, 6327.303996560467, 6210.130581718473, 6230.566969596927, 6235.095911092957, 6266.436020758154, 6273.0, 6270.905936411049, 6450.677466126581, 6480.416762491398, 6511.120998665119, 6529.640869752209, 4405.9339109912735, 4415.867523974286, 4424.955750442455, 4453.75504347264, 4463.955360446354, 6174.24034150265, 6346.397092276226, 6377.521685873671, 6384.201974753156, 6406.711697973696, 6107.4197951194565, 6115.480184184395, 6138.14066030765, 6144.8771024580155, 6177.444030037318, 6000.669963152069, 6168.845778855564, 6183.258009038944, 6209.534284928558, 6210.844728881814, 5980.132880732356, 5985.700714964321, 5991.281046274301, 5995.2206213192, 6013.759449622141, 6099.573029887865, 6119.694015299307, 6141.877162456636, 6214.353196402866, 6233.407826256498, 5941.643501389931, 6020.367861374492, 6041.2750469943885, 6045.879082418239, 6072.301685306246], "value": 4630.264788171018, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [769.4344656677341, 818.8935438393008, 828.5070383122048, 846.1961136919924, 898.5237823953303, 15736.0, 16481.505554833344, 16485.175741212952, 16536.66926661466, 16634.085125318103, 15596.454124105658, 15770.526884193463, 15808.841911580881, 15818.367265309402, 15837.0, 703.5110598134298, 839.2530647723531, 859.8237361340941, 861.0485413617956, 864.8313578852126, 852.9530875801828, 855.9101294364095, 857.8455877941968, 858.6908712863365, 858.7080392666492, 905.44767691708, 907.5552979040289, 908.6410867707285, 909.2725819344531, 910.2354022620997, 891.3893982621893, 896.7802888292377, 899.0200681257428, 900.5497251374313, 900.6847603338779, 661.4443867151616, 661.9900701489481, 663.0716996205351, 663.3002182697253, 666.4768156996782, 15282.617934551725, 15297.388104475807, 15367.0, 15402.845971540253, 15420.922895385564, 16226.0, 16293.755593666105, 16433.753493697604, 16646.50060498187, 16983.74524382135, 13240.73518529624, 13557.186568805902, 13559.118657287245, 13602.183868967795, 13690.726185476335, 4049.6152865478025, 4060.309747342959, 4096.180763847213, 4154.5222299435345, 4169.958300417018, 77616.22383776147, 78051.0, 78467.0, 78826.60586697087, 80645.19354806436, 12327.260364378166, 12383.62849114528, 12431.440585173508, 12536.059795515373, 12572.4342404592, 21729.56540869174, 22484.437889052904, 23857.880710596335, 24068.27795166148, 24107.879460602584, 8738.86891696625, 8821.470711757314, 8905.287576993825, 8983.326250531105, 9331.813363732688, 5311.575073994071, 5375.596830237748, 5388.218708287276, 5392.4607539246545, 5455.1544510600925, 3714.795686237283, 3847.03824043989, 3857.1707082977296, 3864.381698928214, 3868.052327179859, 650.5088658063132, 652.6997581112741, 657.8750037492957, 660.9173853268342, 670.8557660103102, 690.602903330587, 745.6197339356967, 766.8849672549162, 801.0987638906231, 807.1323327422926, 10823.83764243537, 10830.350178989285, 10959.452027398598, 11137.10903127764, 11324.263922845154, 695.2352412346379, 745.9067616547932, 761.3072104384983, 789.1910791438821, 794.2414993681136, 4959.603231741452, 4966.975165124151, 4984.476629953802, 5159.2003239497935, 5166.43169251382, 115921.0, 118215.0, 118425.40787296009, 122781.38609306897, 124447.0, 90311.09688903028, 93807.53096234475, 99885.50057249668, 101209.49395252977, 104702.38244043807, 91614.0, 92996.07003930009, 93201.5339923296, 93276.0, 94683.52658236664, 9756.317057805885, 9767.462789546644, 9812.803743925224, 9823.410595364301, 9848.359856609297, 55315.72342138264, 55557.72221138868, 55873.44126558682, 56916.14625780699, 57707.1343929833, 73241.6337918307, 78068.0, 79035.20964790278, 81403.0, 81839.59080204561, 12787.552435664707, 12931.612051638465, 12981.221126732426, 13003.609891703263, 13406.93296533511, 14133.575992720234, 14522.20127892976, 14538.927305363406, 14567.271636418349, 14998.400063997318, 12498.693074039411, 12576.387921253376, 12855.29295888735, 13184.670383240496, 13259.933700331436, 13432.932835335761, 13461.461541538229, 13480.988925830798, 13691.246981416118, 13700.0, 13196.736065278832, 13307.733845322846, 13482.730345392842, 13823.377947992163, 13862.098963567336, 11187.776244475228, 11243.212975091665, 11322.886771132513, 11348.489317980875, 11353.659390218307, 11321.547138114713, 11447.370394628042, 11519.88480115188, 11553.94223028913, 11600.88399115998], "value": 7972.718396278957, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1533.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 103.0, 110.0, 110.0, 111.0, 110.0, 111.0, 111.0, 110.0, 110.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 126.0, 156.0, 177.0, 127.0, 147.0, 156.0, 125.0, 180.0, 126.0], "value": 147.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 163.0, 164.0, 164.0, 164.0, 164.0, 163.0, 163.0, 164.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 190.0, 76.0, 77.0, 75.0, 77.0, 177.0, 75.0], "value": 97.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 154.0, 84.0, 84.0, 84.0, 145.0, 90.0, 85.0, 153.0], "value": 104.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 121.0, 117.0, 117.0, 117.0, 117.0, 122.0, 117.0, 119.0, 117.0], "value": 118.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 147.0, 147.0, 147.0, 147.0, 147.0, 154.0, 147.0, 148.0], "value": 148.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 98.0, 95.0, 95.0, 95.0, 97.0, 96.0, 96.0, 96.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 53.0, 53.0, 52.0, 58.0, 53.0, 54.0, 56.0, 53.0, 60.0], "value": 55.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 61.0, 60.0, 59.0, 60.0, 60.0, 61.0, 61.0, 64.0], "value": 60.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 76.0, 82.0, 75.0, 81.0, 78.0, 78.0, 77.0, 100.0, 79.0], "value": 80.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 128.0, 137.0, 129.0, 137.0, 131.0, 130.0, 127.0, 127.0, 125.0], "value": 130.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 158.0, 155.0, 161.0, 155.0, 157.0, 159.0, 161.0, 155.0, 157.0], "value": 157.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 64.0, 63.0, 63.0, 67.0, 63.0, 63.0, 61.0, 65.0], "value": 63.2, "unit": "score"}]}]} 19:13:55 INFO - Return code: 0 19:13:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:13:55 ERROR - # TBPL SUCCESS # 19:13:55 INFO - Running post-action listener: _resource_record_post_action 19:13:55 INFO - ##### 19:13:55 INFO - ##### Finished run-tests step (success) 19:13:55 INFO - ##### 19:13:55 INFO - Running post-run listener: _resource_record_post_run 19:13:55 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 266240; Write bytes: 510980096; Read time: 28; Write time: 529000 19:13:55 INFO - TinderboxPrint: CPU usage
13.4% 19:13:55 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 28 19:13:55 INFO - TinderboxPrint: I/O write bytes / time
510,980,096 / 529,000 19:13:55 INFO - TinderboxPrint: CPU idle
8,218.6 (86.6%) 19:13:55 INFO - TinderboxPrint: CPU user
1,215.8 (12.8%) 19:13:55 INFO - TinderboxPrint: Swap in / out
0 / 0 19:13:55 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 261095424; Read time: 0; Write time: 407728 19:13:55 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 266240; Write bytes: 249884672; Read time: 28; Write time: 121272 19:13:56 INFO - Running post-run listener: _upload_blobber_files 19:13:56 INFO - Blob upload gear active. 19:13:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:13:56 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:13:56 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'] 19:13:56 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 19:13:56 INFO - (blobuploader) - INFO - Open directory for files ... 19:13:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:13:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:13:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:13:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:13:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:13:57 INFO - (blobuploader) - INFO - Done attempting. 19:13:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:13:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:13:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:14:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:14:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:14:00 INFO - (blobuploader) - INFO - Done attempting. 19:14:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:14:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:14:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:14:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:14:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:14:01 INFO - (blobuploader) - INFO - Done attempting. 19:14:01 INFO - (blobuploader) - INFO - Iteration through files over. 19:14:01 INFO - Return code: 0 19:14:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:14:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:14:01 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a5b1b2634fb9604f2150b1c03c5cf7c6c8272351a5f97f0a3c93e8fa99e11480283efcd541458bc97ee6aa0062679e269b131d8cd110495cb0da93f0a678c097", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e556c2205814a3e503dbe1fefaa2ca200e8c028d462ed23c81836e036e2aae033ef2cfddf28f92d52957ac9a31499661a3459e7177af2d817ab2b0731d182f67", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d076a27b17226b14f4cbd0aef8fb801177d5f1447c69fcd197169be14284a2277e61c6b4331ce55900e4e3e5cc5550ae15c19c71663580b6e746e22f2c2aa4c6"} 19:14:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:14:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:14:01 INFO - Contents: 19:14:01 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a5b1b2634fb9604f2150b1c03c5cf7c6c8272351a5f97f0a3c93e8fa99e11480283efcd541458bc97ee6aa0062679e269b131d8cd110495cb0da93f0a678c097", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e556c2205814a3e503dbe1fefaa2ca200e8c028d462ed23c81836e036e2aae033ef2cfddf28f92d52957ac9a31499661a3459e7177af2d817ab2b0731d182f67", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d076a27b17226b14f4cbd0aef8fb801177d5f1447c69fcd197169be14284a2277e61c6b4331ce55900e4e3e5cc5550ae15c19c71663580b6e746e22f2c2aa4c6"} 19:14:01 INFO - Running post-run listener: copy_logs_to_upload_dir 19:14:01 INFO - Copying logs to upload dir... 19:14:01 INFO - mkdir: /builds/slave/test/build/upload/logs 19:14:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.383581 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-06-08 19:14:00.908549) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 19:14:00.911979) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1465436853.792480-1095647097 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/a5b1b2634fb9604f2150b1c03c5cf7c6c8272351a5f97f0a3c93e8fa99e11480283efcd541458bc97ee6aa0062679e269b131d8cd110495cb0da93f0a678c097", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e556c2205814a3e503dbe1fefaa2ca200e8c028d462ed23c81836e036e2aae033ef2cfddf28f92d52957ac9a31499661a3459e7177af2d817ab2b0731d182f67", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d076a27b17226b14f4cbd0aef8fb801177d5f1447c69fcd197169be14284a2277e61c6b4331ce55900e4e3e5cc5550ae15c19c71663580b6e746e22f2c2aa4c6"} build_url:https://queue.taskcluster.net/v1/task/aa32Osp6SBu1BHhbpV2-ew/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011314 build_url: 'https://queue.taskcluster.net/v1/task/aa32Osp6SBu1BHhbpV2-ew/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/a5b1b2634fb9604f2150b1c03c5cf7c6c8272351a5f97f0a3c93e8fa99e11480283efcd541458bc97ee6aa0062679e269b131d8cd110495cb0da93f0a678c097", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e556c2205814a3e503dbe1fefaa2ca200e8c028d462ed23c81836e036e2aae033ef2cfddf28f92d52957ac9a31499661a3459e7177af2d817ab2b0731d182f67", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d076a27b17226b14f4cbd0aef8fb801177d5f1447c69fcd197169be14284a2277e61c6b4331ce55900e4e3e5cc5550ae15c19c71663580b6e746e22f2c2aa4c6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 19:14:00.942926) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 19:14:00.943564) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1465436853.792480-1095647097 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004448 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 19:14:01.024306) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 19:14:01.025008) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 19:14:01.025653) ========= ========= Total master_lag: 0.16 =========