builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-059 starttime: 1467067297.38 results: success (0) buildid: 20160627130921 builduid: a6b74d1bbac54478809dc3da76fbdb0f revision: f20f82876561686c4f8a619a0e1baa9f58261e0f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 15:41:37.385163) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 15:41:37.385712) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 15:41:37.386085) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 15:41:37.479115) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 15:41:37.479598) ========= 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=3a3620fb28aea1604ab609ef000001d2-1467067296.83389-515992898 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-27 15:41:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 102M=0s 2016-06-27 15:41:37 (102 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124205 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 15:41:37.618351) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 15:41:37.618701) ========= 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=3a3620fb28aea1604ab609ef000001d2-1467067296.83389-515992898 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016126 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 15:41:37.667894) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 15:41:37.668272) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev f20f82876561686c4f8a619a0e1baa9f58261e0f --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 f20f82876561686c4f8a619a0e1baa9f58261e0f --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=3a3620fb28aea1604ab609ef000001d2-1467067296.83389-515992898 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-27 15:41:37,856 truncating revision to first 12 chars 2016-06-27 15:41:37,856 Setting DEBUG logging. 2016-06-27 15:41:37,856 attempt 1/10 2016-06-27 15:41:37,856 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/f20f82876561?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-27 15:41:38,505 unpacking tar archive at: mozilla-aurora-f20f82876561/testing/mozharness/ program finished with exit code 0 elapsedTime=0.982724 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 15:41:38.665554) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 15:41:38.665991) ========= script_repo_revision: f20f82876561686c4f8a619a0e1baa9f58261e0f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 15:41:38.666458) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 15:41:38.666829) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 15:41:38.677270) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-06-27 15:41:38.677594) ========= /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=3a3620fb28aea1604ab609ef000001d2-1467067296.83389-515992898 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:41:38 INFO - MultiFileLogger online at 20160627 15:41:38 in /builds/slave/test 15:41:38 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 15:41:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:41:38 INFO - {'append_to_log': False, 15:41:38 INFO - 'base_work_dir': '/builds/slave/test', 15:41:38 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 15:41:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:41:38 INFO - 'branch': 'Mozilla-Aurora', 15:41:38 INFO - 'buildbot_json_path': 'buildprops.json', 15:41:38 INFO - 'config_files': ('talos/linux_config.py',), 15:41:38 INFO - 'default_actions': ('clobber', 15:41:38 INFO - 'read-buildbot-config', 15:41:38 INFO - 'download-and-extract', 15:41:38 INFO - 'populate-webroot', 15:41:38 INFO - 'create-virtualenv', 15:41:38 INFO - 'install', 15:41:38 INFO - 'run-tests'), 15:41:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:41:38 INFO - 'download_minidump_stackwalk': True, 15:41:38 INFO - 'download_symbols': 'ondemand', 15:41:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:41:38 INFO - 'tooltool.py': '/tools/tooltool.py', 15:41:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:41:38 INFO - '/tools/misc-python/virtualenv.py')}, 15:41:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:41:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:41:38 INFO - 'installer_path': 'installer.exe', 15:41:38 INFO - 'log_level': 'info', 15:41:38 INFO - 'log_name': 'talos', 15:41:38 INFO - 'log_to_console': True, 15:41:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:41:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:41:38 INFO - 'opt_config_files': (), 15:41:38 INFO - 'pip_index': False, 15:41:38 INFO - 'sps_profile': False, 15:41:38 INFO - 'sps_profile_interval': 0, 15:41:38 INFO - 'suite': 'dromaeojs-e10s', 15:41:38 INFO - 'system_bits': '32', 15:41:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:41:38 INFO - 'title': 'talos-linux64-ix-059', 15:41:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:41:38 INFO - 'use_talos_json': True, 15:41:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:41:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:41:38 INFO - 'work_dir': 'build'} 15:41:38 INFO - ##### 15:41:38 INFO - ##### Running clobber step. 15:41:38 INFO - ##### 15:41:38 INFO - Running pre-action listener: _resource_record_pre_action 15:41:38 INFO - Running main action method: clobber 15:41:38 INFO - rmtree: /builds/slave/test/build 15:41:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:41:39 INFO - Running post-action listener: _resource_record_post_action 15:41:39 INFO - ##### 15:41:39 INFO - ##### Finished clobber step (success) 15:41:39 INFO - ##### 15:41:39 INFO - ##### 15:41:39 INFO - ##### Running read-buildbot-config step. 15:41:39 INFO - ##### 15:41:39 INFO - Running pre-action listener: _resource_record_pre_action 15:41:39 INFO - Running main action method: read_buildbot_config 15:41:39 INFO - Using buildbot properties: 15:41:39 INFO - { 15:41:39 INFO - "project": "", 15:41:39 INFO - "product": "firefox", 15:41:39 INFO - "script_repo_revision": "production", 15:41:39 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 15:41:39 INFO - "repository": "", 15:41:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 15:41:39 INFO - "buildid": "20160627130921", 15:41:39 INFO - "pgo_build": "True", 15:41:39 INFO - "basedir": "/builds/slave/test", 15:41:39 INFO - "buildnumber": 421, 15:41:39 INFO - "slavename": "talos-linux64-ix-059", 15:41:39 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:41:39 INFO - "platform": "ubuntu64_hw", 15:41:39 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 15:41:39 INFO - "branch": "mozilla-aurora", 15:41:39 INFO - "repo_path": "releases/mozilla-aurora", 15:41:39 INFO - "revision": "f20f82876561686c4f8a619a0e1baa9f58261e0f", 15:41:39 INFO - "stage_platform": "linux64-pgo", 15:41:39 INFO - "builduid": "a6b74d1bbac54478809dc3da76fbdb0f", 15:41:39 INFO - "slavebuilddir": "test" 15:41:39 INFO - } 15:41:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 15:41:39 INFO - Running post-action listener: _resource_record_post_action 15:41:39 INFO - ##### 15:41:39 INFO - ##### Finished read-buildbot-config step (success) 15:41:39 INFO - ##### 15:41:39 INFO - ##### 15:41:39 INFO - ##### Running download-and-extract step. 15:41:39 INFO - ##### 15:41:39 INFO - Running pre-action listener: _resource_record_pre_action 15:41:39 INFO - Running main action method: download_and_extract 15:41:39 INFO - mkdir: /builds/slave/test/build/tests 15:41:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:41:39 INFO - https://queue.taskcluster.net/v1/task/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:41:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 15:41:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 15:41:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KccG4N1aShm063uDnaMcSw/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 15:41:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KccG4N1aShm063uDnaMcSw/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 15:41:40 INFO - Downloaded 1361 bytes. 15:41:40 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 15:41:40 INFO - Using the following test package requirements: 15:41:40 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 15:41:40 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:41:40 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 15:41:40 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:41:40 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 15:41:40 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:41:40 INFO - u'jsshell-linux-x86_64.zip'], 15:41:40 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:41:40 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 15:41:40 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 15:41:40 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:41:40 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 15:41:40 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:41:40 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 15:41:40 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:41:40 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 15:41:40 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 15:41:40 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 15:41:40 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:41:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:41:40 INFO - https://queue.taskcluster.net/v1/task/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:41:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 15:41:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 15:41:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KccG4N1aShm063uDnaMcSw/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 15:41:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KccG4N1aShm063uDnaMcSw/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 15:41:41 INFO - Downloaded 24525033 bytes. 15:41:41 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'] 15:41:41 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 15:41:42 INFO - Return code: 0 15:41:42 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 15:41: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')]} 15:41:42 INFO - https://queue.taskcluster.net/v1/task/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:41:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 15:41:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 15:41:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KccG4N1aShm063uDnaMcSw/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 15:41:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KccG4N1aShm063uDnaMcSw/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 15:41:43 INFO - Downloaded 24525033 bytes. 15:41:43 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'] 15:41:43 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 15:41:45 INFO - Return code: 0 15:41: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')]} 15:41:45 INFO - https://queue.taskcluster.net/v1/task/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:41:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 15:41:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 15:41:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KccG4N1aShm063uDnaMcSw/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 15:41:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KccG4N1aShm063uDnaMcSw/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 15:41:46 INFO - Downloaded 10833369 bytes. 15:41:46 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'] 15:41:46 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 15:41:46 INFO - Return code: 0 15:41:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:41:46 INFO - https://queue.taskcluster.net/v1/task/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:41:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 15:41:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 15:41:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KccG4N1aShm063uDnaMcSw/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 15:41:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KccG4N1aShm063uDnaMcSw/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 15:41:50 INFO - Downloaded 63614591 bytes. 15:41:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 15:41:50 INFO - mkdir: /builds/slave/test/properties 15:41:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:41:50 INFO - Writing to file /builds/slave/test/properties/build_url 15:41:50 INFO - Contents: 15:41:50 INFO - build_url:https://queue.taskcluster.net/v1/task/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 15:41:51 INFO - Running post-action listener: _resource_record_post_action 15:41:51 INFO - Running post-action listener: set_extra_try_arguments 15:41:51 INFO - ##### 15:41:51 INFO - ##### Finished download-and-extract step (success) 15:41:51 INFO - ##### 15:41:51 INFO - ##### 15:41:51 INFO - ##### Running populate-webroot step. 15:41:51 INFO - ##### 15:41:51 INFO - Running pre-action listener: _resource_record_pre_action 15:41:51 INFO - Running main action method: populate_webroot 15:41:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:41:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:41:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:41:51 INFO - '--tppagecycles', 15:41:51 INFO - '7'], 15:41:51 INFO - 'tests': ['tsvgm']}}, 15:41:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:41:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:41:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:41:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:41:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:41:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:41:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:41:51 INFO - 'talos_options': ['--disable-e10s'], 15:41:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:41:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:41:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:41:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:41:51 INFO - 'talos_options': ['--disable-e10s'], 15:41:51 INFO - 'tests': ['damp', 'tps']}, 15:41:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:41:51 INFO - 'tests': ['damp', 'tps']}, 15:41:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:41:51 INFO - 'tests': ['dromaeo_dom']}, 15:41:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:41:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:41:51 INFO - 'tests': ['a11yr', 15:41:51 INFO - 'ts_paint', 15:41:51 INFO - 'tpaint', 15:41:51 INFO - 'sessionrestore', 15:41:51 INFO - 'sessionrestore_no_auto_restore', 15:41:51 INFO - 'tabpaint']}, 15:41:51 INFO - 'other-e10s': {'tests': ['a11yr', 15:41:51 INFO - 'ts_paint', 15:41:51 INFO - 'tpaint', 15:41:51 INFO - 'sessionrestore', 15:41:51 INFO - 'sessionrestore_no_auto_restore', 15:41:51 INFO - 'tabpaint']}, 15:41:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:41:51 INFO - 'ts_paint', 15:41:51 INFO - 'tpaint', 15:41:51 INFO - 'sessionrestore', 15:41:51 INFO - 'sessionrestore_no_auto_restore', 15:41:51 INFO - 'tabpaint']}, 15:41:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:41:51 INFO - 'ts_paint', 15:41:51 INFO - 'tpaint', 15:41:51 INFO - 'sessionrestore', 15:41:51 INFO - 'sessionrestore_no_auto_restore', 15:41:51 INFO - 'tabpaint']}, 15:41:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:41:51 INFO - 'tests': ['a11yr', 15:41:51 INFO - 'ts_paint', 15:41:51 INFO - 'tpaint', 15:41:51 INFO - 'sessionrestore', 15:41:51 INFO - 'sessionrestore_no_auto_restore', 15:41:51 INFO - 'tabpaint']}, 15:41:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:41:51 INFO - 'tests': ['a11yr', 15:41:51 INFO - 'ts_paint', 15:41:51 INFO - 'tpaint', 15:41:51 INFO - 'sessionrestore', 15:41:51 INFO - 'sessionrestore_no_auto_restore', 15:41:51 INFO - 'tabpaint']}, 15:41:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:41:51 INFO - 'tests': ['tsvgx', 15:41:51 INFO - 'tsvgr_opacity', 15:41:51 INFO - 'tart', 15:41:51 INFO - 'tscrollx', 15:41:51 INFO - 'cart']}, 15:41:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:41:51 INFO - 'tsvgr_opacity', 15:41:51 INFO - 'tart', 15:41:51 INFO - 'tscrollx', 15:41:51 INFO - 'cart']}, 15:41:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:41:51 INFO - 'talos_options': ['--disable-e10s'], 15:41:51 INFO - 'tests': ['tp5o']}, 15:41:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:41:51 INFO - 'tests': ['tp5o']}, 15:41:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:41:51 INFO - 'talos_options': ['--disable-e10s', 15:41:51 INFO - '--xperf_path', 15:41:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:41:51 INFO - 'tests': ['tp5n']}, 15:41:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:41:51 INFO - 'talos_options': ['--xperf_path', 15:41:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:41:51 INFO - 'tests': ['tp5n']}}, 15:41:51 INFO - 'talos.zip': {'path': '', 15:41:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:41:51 INFO - Running post-action listener: _resource_record_post_action 15:41:51 INFO - ##### 15:41:51 INFO - ##### Finished populate-webroot step (success) 15:41:51 INFO - ##### 15:41:51 INFO - ##### 15:41:51 INFO - ##### Running create-virtualenv step. 15:41:51 INFO - ##### 15:41:51 INFO - Running pre-action listener: _resource_record_pre_action 15:41:51 INFO - Running main action method: create_virtualenv 15:41:51 INFO - Creating virtualenv /builds/slave/test/build/venv 15:41:51 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 15:41:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:41:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:41:51 INFO - Using real prefix '/usr' 15:41:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:41:51 INFO - Installing distribute.............................................................................................................................................................................................done. 15:41:53 INFO - Installing pip.................done. 15:41:53 INFO - Return code: 0 15:41:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:41:53 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')]} 15:41:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:41:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:41:53 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')]} 15:41:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:41:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:41:53 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 0x7ff56b766f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bdb450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6a2c0>, '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 0x1c6b1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c6b650>, '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': '3a3620fb28aea1604ab609ef000001d2-1467067296.83389-515992898', '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 15:41:53 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 15:41:53 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 15:41:53 INFO - Using env: {'DISPLAY': ':0', 15:41:53 INFO - 'HOME': '/home/cltbld', 15:41:53 INFO - 'LANG': 'en_US.UTF-8', 15:41:53 INFO - 'LANGUAGE': 'en_US:en', 15:41:53 INFO - 'LOGNAME': 'cltbld', 15:41:53 INFO - 'MAIL': '/var/mail/cltbld', 15:41:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:41:53 INFO - 'MOZ_NO_REMOTE': '1', 15:41:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:41:53 INFO - 'NO_EM_RESTART': '1', 15:41:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:41:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:41:53 INFO - 'PWD': '/builds/slave/test', 15:41:53 INFO - 'SHELL': '/bin/bash', 15:41:53 INFO - 'SHLVL': '1', 15:41:53 INFO - 'TERM': 'linux', 15:41:53 INFO - 'TMOUT': '86400', 15:41:53 INFO - 'USER': 'cltbld', 15:41:53 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1467067296.83389-515992898', 15:41:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:41:53 INFO - '_': '/tools/buildbot/bin/python'} 15:41:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:41:53 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 15:41:53 INFO - Cleaning up... 15:41:53 INFO - Return code: 0 15:41:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:41:53 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')]} 15:41:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:41:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:41:53 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')]} 15:41:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:41:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:41:53 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 0x7ff56b766f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bdb450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6a2c0>, '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 0x1c6b1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c6b650>, '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': '3a3620fb28aea1604ab609ef000001d2-1467067296.83389-515992898', '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 15:41:53 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 15:41:53 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 15:41:53 INFO - Using env: {'DISPLAY': ':0', 15:41:53 INFO - 'HOME': '/home/cltbld', 15:41:53 INFO - 'LANG': 'en_US.UTF-8', 15:41:53 INFO - 'LANGUAGE': 'en_US:en', 15:41:53 INFO - 'LOGNAME': 'cltbld', 15:41:53 INFO - 'MAIL': '/var/mail/cltbld', 15:41:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:41:53 INFO - 'MOZ_NO_REMOTE': '1', 15:41:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:41:53 INFO - 'NO_EM_RESTART': '1', 15:41:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:41:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:41:53 INFO - 'PWD': '/builds/slave/test', 15:41:53 INFO - 'SHELL': '/bin/bash', 15:41:53 INFO - 'SHLVL': '1', 15:41:53 INFO - 'TERM': 'linux', 15:41:53 INFO - 'TMOUT': '86400', 15:41:53 INFO - 'USER': 'cltbld', 15:41:53 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1467067296.83389-515992898', 15:41:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:41:53 INFO - '_': '/tools/buildbot/bin/python'} 15:41:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:41:54 INFO - Downloading/unpacking psutil>=3.1.1 15:41:54 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 15:41:54 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 15:41:54 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 15:41:54 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 15:41:54 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 15:41:54 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 15:41:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:41:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:41:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:41:56 INFO - Installing collected packages: psutil 15:41:56 INFO - Running setup.py install for psutil 15:41:56 INFO - building 'psutil._psutil_linux' extension 15:41:56 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 15:41:56 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 15:41:56 INFO - building 'psutil._psutil_posix' extension 15:41:56 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 15:41:56 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 15:41:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:41:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:41:56 INFO - Successfully installed psutil 15:41:56 INFO - Cleaning up... 15:41:56 INFO - Return code: 0 15:41:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:41:56 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')]} 15:41:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:41:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:41:56 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')]} 15:41:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:41:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:41:56 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 0x7ff56b766f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bdb450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6a2c0>, '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 0x1c6b1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c6b650>, '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': '3a3620fb28aea1604ab609ef000001d2-1467067296.83389-515992898', '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 15:41:56 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 15:41:56 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 15:41:56 INFO - Using env: {'DISPLAY': ':0', 15:41:56 INFO - 'HOME': '/home/cltbld', 15:41:56 INFO - 'LANG': 'en_US.UTF-8', 15:41:56 INFO - 'LANGUAGE': 'en_US:en', 15:41:56 INFO - 'LOGNAME': 'cltbld', 15:41:56 INFO - 'MAIL': '/var/mail/cltbld', 15:41:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:41:56 INFO - 'MOZ_NO_REMOTE': '1', 15:41:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:41:56 INFO - 'NO_EM_RESTART': '1', 15:41:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:41:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:41:56 INFO - 'PWD': '/builds/slave/test', 15:41:56 INFO - 'SHELL': '/bin/bash', 15:41:56 INFO - 'SHLVL': '1', 15:41:56 INFO - 'TERM': 'linux', 15:41:56 INFO - 'TMOUT': '86400', 15:41:56 INFO - 'USER': 'cltbld', 15:41:56 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1467067296.83389-515992898', 15:41:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:41:56 INFO - '_': '/tools/buildbot/bin/python'} 15:41:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:41:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:41:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:41:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:41:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:41:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:41:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:41:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:41:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:41:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:41:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:41:59 INFO - Installing collected packages: mozsystemmonitor 15:41:59 INFO - Running setup.py install for mozsystemmonitor 15:41:59 INFO - Successfully installed mozsystemmonitor 15:41:59 INFO - Cleaning up... 15:41:59 INFO - Return code: 0 15:41:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:41:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:41:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:41:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:41:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:41:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:41:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:41:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff56b766f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bdb450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6a2c0>, '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 0x1c6b1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c6b650>, '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': '3a3620fb28aea1604ab609ef000001d2-1467067296.83389-515992898', '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 15:41:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:41:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:41:59 INFO - Using env: {'DISPLAY': ':0', 15:41:59 INFO - 'HOME': '/home/cltbld', 15:41:59 INFO - 'LANG': 'en_US.UTF-8', 15:41:59 INFO - 'LANGUAGE': 'en_US:en', 15:41:59 INFO - 'LOGNAME': 'cltbld', 15:41:59 INFO - 'MAIL': '/var/mail/cltbld', 15:41:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:41:59 INFO - 'MOZ_NO_REMOTE': '1', 15:41:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:41:59 INFO - 'NO_EM_RESTART': '1', 15:41:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:41:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:41:59 INFO - 'PWD': '/builds/slave/test', 15:41:59 INFO - 'SHELL': '/bin/bash', 15:41:59 INFO - 'SHLVL': '1', 15:41:59 INFO - 'TERM': 'linux', 15:41:59 INFO - 'TMOUT': '86400', 15:41:59 INFO - 'USER': 'cltbld', 15:41:59 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1467067296.83389-515992898', 15:41:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:41:59 INFO - '_': '/tools/buildbot/bin/python'} 15:41:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:41:59 INFO - Downloading/unpacking jsonschema==2.5.1 15:41:59 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 15:41:59 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 15:41:59 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 15:41:59 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 15:41:59 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 15:41:59 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 15:42:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:42:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:42: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 15:42: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 15:42: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 15:42: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 15:42: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 15:42: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 15:42:01 INFO - Downloading functools32-3.2.3-2.tar.gz 15:42:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:42:01 INFO - warning: no files found matching '*.txt' 15:42:01 INFO - no previously-included directories found matching 'build' 15:42:01 INFO - no previously-included directories found matching 'dist' 15:42:01 INFO - no previously-included directories found matching '.git*' 15:42:01 INFO - Installing collected packages: jsonschema, functools32 15:42:01 INFO - Running setup.py install for functools32 15:42:01 INFO - warning: no files found matching '*.txt' 15:42:01 INFO - no previously-included directories found matching 'build' 15:42:01 INFO - no previously-included directories found matching 'dist' 15:42:01 INFO - no previously-included directories found matching '.git*' 15:42:01 INFO - Successfully installed jsonschema functools32 15:42:01 INFO - Cleaning up... 15:42:01 INFO - Return code: 0 15:42:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:42: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')]} 15:42:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:42:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42: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')]} 15:42:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:42:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42: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', '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 0x7ff56b766f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bdb450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6a2c0>, '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 0x1c6b1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c6b650>, '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': '3a3620fb28aea1604ab609ef000001d2-1467067296.83389-515992898', '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 15:42: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:42: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 blobuploader==1.2.4 15:42:01 INFO - Using env: {'DISPLAY': ':0', 15:42:01 INFO - 'HOME': '/home/cltbld', 15:42:01 INFO - 'LANG': 'en_US.UTF-8', 15:42:01 INFO - 'LANGUAGE': 'en_US:en', 15:42:01 INFO - 'LOGNAME': 'cltbld', 15:42:01 INFO - 'MAIL': '/var/mail/cltbld', 15:42:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:42:01 INFO - 'MOZ_NO_REMOTE': '1', 15:42:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:42:01 INFO - 'NO_EM_RESTART': '1', 15:42:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:42:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:42:01 INFO - 'PWD': '/builds/slave/test', 15:42:01 INFO - 'SHELL': '/bin/bash', 15:42:01 INFO - 'SHLVL': '1', 15:42:01 INFO - 'TERM': 'linux', 15:42:01 INFO - 'TMOUT': '86400', 15:42:01 INFO - 'USER': 'cltbld', 15:42:01 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1467067296.83389-515992898', 15:42:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:42:01 INFO - '_': '/tools/buildbot/bin/python'} 15:42:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:42:02 INFO - Downloading/unpacking blobuploader==1.2.4 15:42:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:42:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:42:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:42:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:42:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:42:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:42:03 INFO - Downloading blobuploader-1.2.4.tar.gz 15:42:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:42:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:42: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 15:42: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 15:42: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 15:42: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 15:42: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 15:42: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 15:42:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:42:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:42: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 15:42: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 15:42: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 15:42: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 15:42: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 15:42: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 15:42:04 INFO - Downloading docopt-0.6.1.tar.gz 15:42:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:42:04 INFO - Installing collected packages: blobuploader, requests, docopt 15:42:04 INFO - Running setup.py install for blobuploader 15:42:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:42:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:42:04 INFO - Running setup.py install for requests 15:42:05 INFO - Running setup.py install for docopt 15:42:05 INFO - Successfully installed blobuploader requests docopt 15:42:05 INFO - Cleaning up... 15:42:05 INFO - Return code: 0 15:42:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:42:05 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')]} 15:42:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:42:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:05 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')]} 15:42:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:42:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:05 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 0x7ff56b766f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bdb450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6a2c0>, '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 0x1c6b1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c6b650>, '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': '3a3620fb28aea1604ab609ef000001d2-1467067296.83389-515992898', '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 15:42:05 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 15:42:05 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 15:42:05 INFO - Using env: {'DISPLAY': ':0', 15:42:05 INFO - 'HOME': '/home/cltbld', 15:42:05 INFO - 'LANG': 'en_US.UTF-8', 15:42:05 INFO - 'LANGUAGE': 'en_US:en', 15:42:05 INFO - 'LOGNAME': 'cltbld', 15:42:05 INFO - 'MAIL': '/var/mail/cltbld', 15:42:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:42:05 INFO - 'MOZ_NO_REMOTE': '1', 15:42:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:42:05 INFO - 'NO_EM_RESTART': '1', 15:42:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:42:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:42:05 INFO - 'PWD': '/builds/slave/test', 15:42:05 INFO - 'SHELL': '/bin/bash', 15:42:05 INFO - 'SHLVL': '1', 15:42:05 INFO - 'TERM': 'linux', 15:42:05 INFO - 'TMOUT': '86400', 15:42:05 INFO - 'USER': 'cltbld', 15:42:05 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1467067296.83389-515992898', 15:42:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:42:05 INFO - '_': '/tools/buildbot/bin/python'} 15:42:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:42:05 INFO - Running setup.py (path:/tmp/pip-GUlwT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:42:05 INFO - Running setup.py (path:/tmp/pip-UhaBiI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:42:05 INFO - Running setup.py (path:/tmp/pip-JcO5s_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:42:05 INFO - Running setup.py (path:/tmp/pip-pIYsKr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:42:05 INFO - Running setup.py (path:/tmp/pip-CzDAx9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:42:05 INFO - Running setup.py (path:/tmp/pip-LU3sTy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:42:05 INFO - Running setup.py (path:/tmp/pip-LWm1xx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:42:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:42:05 INFO - Running setup.py (path:/tmp/pip-WLSz6Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:42:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:42:06 INFO - Running setup.py (path:/tmp/pip-UiMfPe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:42:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:42:06 INFO - Running setup.py (path:/tmp/pip-CzfiAM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:42:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:42:06 INFO - Running setup.py (path:/tmp/pip-Bq4zWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:42:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:42:06 INFO - Running setup.py (path:/tmp/pip-gjBHzk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:42:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:42:06 INFO - Running setup.py (path:/tmp/pip-gjQnvH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:42:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:42:06 INFO - Running setup.py (path:/tmp/pip-RZa5ps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:42:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:42:06 INFO - Running setup.py (path:/tmp/pip-ok8aH8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:42:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:42:06 INFO - Running setup.py (path:/tmp/pip-iIH9pU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:42:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:42:06 INFO - Running setup.py (path:/tmp/pip-QGkoYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:42:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:42:06 INFO - Running setup.py install for manifestparser 15:42:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:42:06 INFO - Running setup.py install for mozcrash 15:42:06 INFO - Running setup.py install for mozdebug 15:42:07 INFO - Running setup.py install for mozdevice 15:42:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:42:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:42:07 INFO - Running setup.py install for mozfile 15:42:07 INFO - Running setup.py install for mozhttpd 15:42:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:42:07 INFO - Running setup.py install for mozinfo 15:42:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:42:07 INFO - Running setup.py install for mozInstall 15:42:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:42:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:42:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:42:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:42:07 INFO - Running setup.py install for mozleak 15:42:07 INFO - Running setup.py install for mozlog 15:42:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:42:07 INFO - Running setup.py install for moznetwork 15:42:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:42:07 INFO - Running setup.py install for mozprocess 15:42:07 INFO - Running setup.py install for mozprofile 15:42:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:42:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:42:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:42:08 INFO - Running setup.py install for mozrunner 15:42:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:42:08 INFO - Running setup.py install for mozscreenshot 15:42:08 INFO - Running setup.py install for moztest 15:42:08 INFO - Running setup.py install for mozversion 15:42:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:42:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:42:08 INFO - Cleaning up... 15:42:08 INFO - Return code: 0 15:42:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:42:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:42:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:42:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:42:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:42:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:08 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 0x7ff56b766f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bdb450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6a2c0>, '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 0x1c6b1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c6b650>, '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': '3a3620fb28aea1604ab609ef000001d2-1467067296.83389-515992898', '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 15:42:08 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 15:42:08 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 15:42:08 INFO - Using env: {'DISPLAY': ':0', 15:42:08 INFO - 'HOME': '/home/cltbld', 15:42:08 INFO - 'LANG': 'en_US.UTF-8', 15:42:08 INFO - 'LANGUAGE': 'en_US:en', 15:42:08 INFO - 'LOGNAME': 'cltbld', 15:42:08 INFO - 'MAIL': '/var/mail/cltbld', 15:42:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:42:08 INFO - 'MOZ_NO_REMOTE': '1', 15:42:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:42:08 INFO - 'NO_EM_RESTART': '1', 15:42:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:42:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:42:08 INFO - 'PWD': '/builds/slave/test', 15:42:08 INFO - 'SHELL': '/bin/bash', 15:42:08 INFO - 'SHLVL': '1', 15:42:08 INFO - 'TERM': 'linux', 15:42:08 INFO - 'TMOUT': '86400', 15:42:08 INFO - 'USER': 'cltbld', 15:42:08 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1467067296.83389-515992898', 15:42:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:42:08 INFO - '_': '/tools/buildbot/bin/python'} 15:42:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:42:08 INFO - Running setup.py (path:/tmp/pip-A8B9B8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:42:08 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)) 15:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:42:08 INFO - Running setup.py (path:/tmp/pip-NTm9E1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:42:08 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)) 15:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:42:08 INFO - Running setup.py (path:/tmp/pip-T5aICC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:42:08 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)) 15:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:42:08 INFO - Running setup.py (path:/tmp/pip-xJqdAe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:42:09 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)) 15:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:42:09 INFO - Running setup.py (path:/tmp/pip-51V9Bj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:42:09 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)) 15:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:42:09 INFO - Running setup.py (path:/tmp/pip-C1pMdN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:42:09 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)) 15:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:42:09 INFO - Running setup.py (path:/tmp/pip-Ik22s4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:42:09 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)) 15:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:42:09 INFO - Running setup.py (path:/tmp/pip-_SqIPD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:42:09 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)) 15:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:42:09 INFO - Running setup.py (path:/tmp/pip-2vH3uO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:42:09 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)) 15:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:42:09 INFO - Running setup.py (path:/tmp/pip-x3EQlM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:42:09 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)) 15:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:42:09 INFO - Running setup.py (path:/tmp/pip-yNvV5m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:42:09 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)) 15:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:42:09 INFO - Running setup.py (path:/tmp/pip-pKjB1B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:42:09 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)) 15:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:42:09 INFO - Running setup.py (path:/tmp/pip-rxTWKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:42:09 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)) 15:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:42:09 INFO - Running setup.py (path:/tmp/pip-wj7Vn_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:42:09 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)) 15:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:42:09 INFO - Running setup.py (path:/tmp/pip-mHMPHb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:42:09 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)) 15:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:42:09 INFO - Running setup.py (path:/tmp/pip-QD3cQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:42:09 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)) 15:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:42:09 INFO - Running setup.py (path:/tmp/pip-X_bQgO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:42:09 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)) 15:42:09 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)) 15:42:09 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)) 15:42:09 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)) 15:42:09 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)) 15:42:09 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)) 15:42:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:42:09 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 15:42:09 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 15:42:09 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 15:42:09 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 15:42:09 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 15:42:09 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 15:42:11 INFO - Downloading blessings-1.6.tar.gz 15:42:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:42:11 INFO - Installing collected packages: blessings 15:42:11 INFO - Running setup.py install for blessings 15:42:12 INFO - Successfully installed blessings 15:42:12 INFO - Cleaning up... 15:42:12 INFO - Return code: 0 15:42:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:42:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:42:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:42:12 INFO - Reading from file tmpfile_stdout 15:42:12 INFO - Current package versions: 15:42:12 INFO - argparse == 1.2.1 15:42:12 INFO - blessings == 1.6 15:42:12 INFO - blobuploader == 1.2.4 15:42:12 INFO - docopt == 0.6.1 15:42:12 INFO - functools32 == 3.2.3-2 15:42:12 INFO - jsonschema == 2.5.1 15:42:12 INFO - manifestparser == 1.1 15:42:12 INFO - mozInstall == 1.12 15:42:12 INFO - mozcrash == 0.17 15:42:12 INFO - mozdebug == 0.1 15:42:12 INFO - mozdevice == 0.48 15:42:12 INFO - mozfile == 1.2 15:42:12 INFO - mozhttpd == 0.7 15:42:12 INFO - mozinfo == 0.9 15:42:12 INFO - mozleak == 0.1 15:42:12 INFO - mozlog == 3.2 15:42:12 INFO - moznetwork == 0.27 15:42:12 INFO - mozprocess == 0.22 15:42:12 INFO - mozprofile == 0.28 15:42:12 INFO - mozrunner == 6.11 15:42:12 INFO - mozscreenshot == 0.1 15:42:12 INFO - mozsystemmonitor == 0.3 15:42:12 INFO - moztest == 0.7 15:42:12 INFO - mozversion == 1.4 15:42:12 INFO - psutil == 3.1.1 15:42:12 INFO - requests == 1.2.3 15:42:12 INFO - wsgiref == 0.1.2 15:42:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:42:12 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')]} 15:42:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:42:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:12 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')]} 15:42:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:42:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:12 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 0x7ff56b766f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bdb450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6a2c0>, '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 0x1c6b1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c6b650>, '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': '3a3620fb28aea1604ab609ef000001d2-1467067296.83389-515992898', '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 15:42:12 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 15:42:12 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 15:42:12 INFO - Using env: {'DISPLAY': ':0', 15:42:12 INFO - 'HOME': '/home/cltbld', 15:42:12 INFO - 'LANG': 'en_US.UTF-8', 15:42:12 INFO - 'LANGUAGE': 'en_US:en', 15:42:12 INFO - 'LOGNAME': 'cltbld', 15:42:12 INFO - 'MAIL': '/var/mail/cltbld', 15:42:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:42:12 INFO - 'MOZ_NO_REMOTE': '1', 15:42:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:42:12 INFO - 'NO_EM_RESTART': '1', 15:42:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:42:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:42:12 INFO - 'PWD': '/builds/slave/test', 15:42:12 INFO - 'SHELL': '/bin/bash', 15:42:12 INFO - 'SHLVL': '1', 15:42:12 INFO - 'TERM': 'linux', 15:42:12 INFO - 'TMOUT': '86400', 15:42:12 INFO - 'USER': 'cltbld', 15:42:12 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1467067296.83389-515992898', 15:42:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:42:12 INFO - '_': '/tools/buildbot/bin/python'} 15:42:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:42:12 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)) 15:42:12 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)) 15:42:12 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)) 15:42:12 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)) 15:42:12 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)) 15:42:12 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)) 15:42:12 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)) 15:42:12 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)) 15:42:12 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)) 15:42:12 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)) 15:42:12 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)) 15:42:12 INFO - Cleaning up... 15:42:12 INFO - Return code: 0 15:42:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:42:12 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')]} 15:42:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:42:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:12 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')]} 15:42:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:42:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:12 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 0x7ff56b766f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bdb450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6a2c0>, '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 0x1c6b1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c6b650>, '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': '3a3620fb28aea1604ab609ef000001d2-1467067296.83389-515992898', '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 15:42:12 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 15:42:12 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 15:42:12 INFO - Using env: {'DISPLAY': ':0', 15:42:12 INFO - 'HOME': '/home/cltbld', 15:42:12 INFO - 'LANG': 'en_US.UTF-8', 15:42:12 INFO - 'LANGUAGE': 'en_US:en', 15:42:12 INFO - 'LOGNAME': 'cltbld', 15:42:12 INFO - 'MAIL': '/var/mail/cltbld', 15:42:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:42:12 INFO - 'MOZ_NO_REMOTE': '1', 15:42:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:42:12 INFO - 'NO_EM_RESTART': '1', 15:42:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:42:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:42:12 INFO - 'PWD': '/builds/slave/test', 15:42:12 INFO - 'SHELL': '/bin/bash', 15:42:12 INFO - 'SHLVL': '1', 15:42:12 INFO - 'TERM': 'linux', 15:42:12 INFO - 'TMOUT': '86400', 15:42:12 INFO - 'USER': 'cltbld', 15:42:12 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1467067296.83389-515992898', 15:42:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:42:12 INFO - '_': '/tools/buildbot/bin/python'} 15:42:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:42:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:42:12 INFO - Cleaning up... 15:42:12 INFO - Return code: 0 15:42:12 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:42:12 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')]} 15:42:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:42:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:12 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')]} 15:42:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:42:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:42:12 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 0x7ff56b766f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b0f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bdb450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6a2c0>, '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 0x1c6b1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c6b650>, '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': '3a3620fb28aea1604ab609ef000001d2-1467067296.83389-515992898', '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 15:42:12 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 15:42:12 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 15:42:12 INFO - Using env: {'DISPLAY': ':0', 15:42:12 INFO - 'HOME': '/home/cltbld', 15:42:12 INFO - 'LANG': 'en_US.UTF-8', 15:42:12 INFO - 'LANGUAGE': 'en_US:en', 15:42:12 INFO - 'LOGNAME': 'cltbld', 15:42:12 INFO - 'MAIL': '/var/mail/cltbld', 15:42:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:42:12 INFO - 'MOZ_NO_REMOTE': '1', 15:42:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:42:12 INFO - 'NO_EM_RESTART': '1', 15:42:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:42:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:42:12 INFO - 'PWD': '/builds/slave/test', 15:42:12 INFO - 'SHELL': '/bin/bash', 15:42:12 INFO - 'SHLVL': '1', 15:42:12 INFO - 'TERM': 'linux', 15:42:12 INFO - 'TMOUT': '86400', 15:42:12 INFO - 'USER': 'cltbld', 15:42:12 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1467067296.83389-515992898', 15:42:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:42:12 INFO - '_': '/tools/buildbot/bin/python'} 15:42:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:42:12 INFO - Downloading/unpacking flake8 15:42:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:42:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:42:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:42:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:42:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:42:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:42:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:42:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:42:14 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 15:42:14 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 15:42:14 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 15:42:14 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 15:42:14 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 15:42:14 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 15:42:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:42:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:42:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:42:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:42:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:42:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:42:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:42:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:42:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:42:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:42:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:42:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:42:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:42:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:42:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:42:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:42:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:42:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:42:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:42:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:42:15 INFO - no previously-included directories found matching 'docs/_build' 15:42:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:42:15 INFO - Running setup.py install for pep8 15:42:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:42:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:42:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:42:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:42:15 INFO - no previously-included directories found matching 'docs/_build' 15:42:15 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:42:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:42:15 INFO - Cleaning up... 15:42:15 INFO - Return code: 0 15:42:15 INFO - Running post-action listener: _resource_record_post_action 15:42:15 INFO - Running post-action listener: _start_resource_monitoring 15:42:15 INFO - Starting resource monitoring. 15:42:15 INFO - ##### 15:42:15 INFO - ##### Finished create-virtualenv step (success) 15:42:15 INFO - ##### 15:42:15 INFO - ##### 15:42:15 INFO - ##### Running install step. 15:42:15 INFO - ##### 15:42:15 INFO - Running pre-action listener: _resource_record_pre_action 15:42:15 INFO - Running main action method: install 15:42:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:42:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:42:16 INFO - Reading from file tmpfile_stdout 15:42:16 INFO - Detecting whether we're running mozinstall >=1.0... 15:42:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:42:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:42:16 INFO - Reading from file tmpfile_stdout 15:42:16 INFO - Output received: 15:42:16 INFO - Usage: mozinstall [options] installer 15:42:16 INFO - Options: 15:42:16 INFO - -h, --help show this help message and exit 15:42:16 INFO - -d DEST, --destination=DEST 15:42:16 INFO - Directory to install application into. [default: 15:42:16 INFO - "/builds/slave/test"] 15:42:16 INFO - --app=APP Application being installed. [default: firefox] 15:42:16 INFO - mkdir: /builds/slave/test/build/application 15:42:16 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'] 15:42:16 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 15:42:31 INFO - Reading from file tmpfile_stdout 15:42:31 INFO - Output received: 15:42:31 INFO - /builds/slave/test/build/application/firefox/firefox 15:42:31 INFO - Running post-action listener: _resource_record_post_action 15:42:31 INFO - ##### 15:42:31 INFO - ##### Finished install step (success) 15:42:31 INFO - ##### 15:42:31 INFO - ##### 15:42:31 INFO - ##### Running run-tests step. 15:42:31 INFO - ##### 15:42:31 INFO - Running pre-action listener: _resource_record_pre_action 15:42:31 INFO - Running main action method: run_tests 15:42:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:42:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:42:32 INFO - Python 2.7.3 15:42:32 INFO - Return code: 0 15:42:32 INFO - grabbing minidump binary from tooltool 15:42:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:42:32 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6a2c0>, '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 0x1c6b1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c6b650>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:42:32 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:42:32 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:42:32 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 15:42:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:42:32 INFO - Return code: 0 15:42:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:42:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:42:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:42:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:42:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:42:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:42:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:42:32 INFO - Return code: 0 15:42:32 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/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 15:42:32 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/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-059 --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 15:42:32 INFO - Using env: {'DISPLAY': ':0', 15:42:32 INFO - 'HOME': '/home/cltbld', 15:42:32 INFO - 'LANG': 'en_US.UTF-8', 15:42:32 INFO - 'LANGUAGE': 'en_US:en', 15:42:32 INFO - 'LOGNAME': 'cltbld', 15:42:32 INFO - 'MAIL': '/var/mail/cltbld', 15:42:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:42:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:42:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:42:32 INFO - 'MOZ_NO_REMOTE': '1', 15:42:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:42:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:42:32 INFO - 'NO_EM_RESTART': '1', 15:42:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:42:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:42:32 INFO - 'PWD': '/builds/slave/test', 15:42:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:42:32 INFO - 'SHELL': '/bin/bash', 15:42:32 INFO - 'SHLVL': '1', 15:42:32 INFO - 'TERM': 'linux', 15:42:32 INFO - 'TMOUT': '86400', 15:42:32 INFO - 'USER': 'cltbld', 15:42:32 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1467067296.83389-515992898', 15:42:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:42:32 INFO - '_': '/tools/buildbot/bin/python'} 15:42:32 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/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 15:42:33 INFO - mozversion application_buildid: 20160627130921 15:42:33 INFO - mozversion application_changeset: f20f82876561686c4f8a619a0e1baa9f58261e0f 15:42:33 INFO - mozversion application_display_name: FirefoxDeveloperEdition 15:42:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:42:33 INFO - mozversion application_name: Firefox 15:42:33 INFO - mozversion application_remotingname: firefox-dev 15:42:33 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:42:33 INFO - mozversion application_vendor: Mozilla 15:42:33 INFO - mozversion application_version: 49.0a2 15:42:33 INFO - mozversion platform_buildid: 20160627130921 15:42:33 INFO - mozversion platform_changeset: f20f82876561686c4f8a619a0e1baa9f58261e0f 15:42:33 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:42:33 INFO - mozversion platform_version: 49.0a2 15:42:33 INFO - using testdate: 1467067353 15:42:33 INFO - actual date: 1467067353 15:42:33 INFO - starting webserver on 'localhost:49615' 15:42:33 INFO - SUITE-START | Running 2 tests 15:42:33 INFO - TEST-START | dromaeo_css 15:42:33 INFO - operating with platform_type : linux_ 15:42:33 INFO - Initialising browser for dromaeo_css test... 15:42:33 INFO - TEST-INFO | started process 4477 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp23CuQG/profile http://localhost:49615/getInfo.html) 15:42:37 INFO - PROCESS | 4477 | __metrics Screen width/height:1600/1200 15:42:37 INFO - PROCESS | 4477 | colorDepth:24 15:42:37 INFO - PROCESS | 4477 | Browser inner width/height: 1024/697 15:42:37 INFO - PROCESS | 4477 | __metrics 15:42:38 ERROR - PROCESS | 4477 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 15:42:39 INFO - TEST-INFO | 4477: exit 0 15:42:39 INFO - Browser initialized. 15:42:39 INFO - Running cycle 1/1 for dromaeo_css test... 15:42:39 INFO - TEST-INFO | started process 4603 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp23CuQG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:42:50 INFO - PROCESS | 4603 | RSS: Main: 156123136 15:42:50 INFO - PROCESS | 4603 | 15:43:40 INFO - PROCESS | 4603 | 1467067420425 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] 15:45:48 INFO - PROCESS | 4603 | Cycle 1(1): loaded http://localhost:49615/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49615/tests/dromaeo/cssquery-ext.html) 15:45:49 INFO - PROCESS | 4603 | RSS: Main: 158912512 15:45:49 INFO - PROCESS | 4603 | 15:48:51 INFO - PROCESS | 4603 | Cycle 1(1): loaded http://localhost:49615/tests/dromaeo/cssquery-ext.html (next: http://localhost:49615/tests/dromaeo/cssquery-jquery.html) 15:48:52 INFO - PROCESS | 4603 | RSS: Main: 157036544 15:48:52 INFO - PROCESS | 4603 | 15:51:54 INFO - PROCESS | 4603 | Cycle 1(1): loaded http://localhost:49615/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49615/tests/dromaeo/cssquery-mootools.html) 15:51:54 INFO - PROCESS | 4603 | RSS: Main: 156909568 15:51:54 INFO - PROCESS | 4603 | 15:54:56 INFO - PROCESS | 4603 | Cycle 1(1): loaded http://localhost:49615/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49615/tests/dromaeo/cssquery-prototype.html) 15:54:57 INFO - PROCESS | 4603 | RSS: Main: 156643328 15:54:57 INFO - PROCESS | 4603 | 15:57:59 INFO - PROCESS | 4603 | Cycle 1(1): loaded http://localhost:49615/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49615/tests/dromaeo/cssquery-yui.html) 15:58:00 INFO - PROCESS | 4603 | RSS: Main: 158830592 15:58:00 INFO - PROCESS | 4603 | 16:01:02 INFO - PROCESS | 4603 | Cycle 1(1): loaded http://localhost:49615/tests/dromaeo/cssquery-yui.html (next: http://localhost:49615/tests/dromaeo/cssquery-dojo.html) 16:01:02 INFO - PROCESS | 4603 | RSS: Main: 158711808 16:01:02 INFO - PROCESS | 4603 | 16:01:02 INFO - PROCESS | 4603 | __start_tp_report 16:01:02 INFO - PROCESS | 4603 | _x_x_mozilla_page_load 16:01:02 INFO - PROCESS | 4603 | _x_x_mozilla_page_load_details 16:01:02 INFO - PROCESS | 4603 | |i|pagename|runs| 16:01:02 INFO - PROCESS | 4603 | |0;dojo.html;3447.1726785571464;3480.077779388461;3480.2691434798708;3494.59812121606;3497.9300413991723;5785.132230165472;5800.53595712343;5853;5895.675737834417;5919.674417907014;5906.202662640542;5934.554908381867;5964.015937370329;5964.254468191476;6006;5233.8953220935555;5278.102722537159;5371.785128594852;5408.594355423339;5413.972930135344;5247.2653828464045;5256.342957130359;5284.154535274357;5416.404195538487;5423.403425623178;5295.152775555912;5312.389075256337;5316.043112239795;5388.488093631099;5389.8113566025195;5337.226102215157;5378.2470454136455;5385.892282154374;5386.757595908174;5407.188921661743;5020.347354843847;5227.059129356714;5251.897101608667;5270.499302566289;5272.393674727378;5806.44838740319;5811.128330750379;5812.215350927613;5819.970900145515;5836.6789826559525;6330.905036424458;6366.522510811661;6368.936310636927;6380.042993550958;6388.744450221986;6153;6167.4757645600175;6212.440880320748;6244.188255526798;6407.070974708641;5778.508826749731;5798.449147330997;5817.272840894888;5863.706814659293;5878.882422351529;6439.3238709934785;6441.066045423388;6442.355764423613;6442.355764423613;6446.774362897276;6118.253719382578;6125.479334256549;6149.631022138686;6203.534734894901;6229.127922090911;6303;6309.274433440121;6313.43179113882;6313.558050936482;6314.62112273265;6038.184845045863;6151.784687535915;6267.373262673696;6270.31026587075;6286.654234017173;6224.128621992924;6314.71583778731;6316.494680425555;6337.2395312562785;6341.143945567382;4791.712497250176;4797.064572408347;4800.855974320776;4813.326134341195;4828.082664293843;4154.771487568213;4186.91626167475;4226.978865105716;4286.635635970977;4302.053548219386;5885.3820348862755;5989.760409583568;6027.186329845503;6091.086337049478;6113.96943015291;6302.4958003359625;6354.8411289717205;6367.395097465734;6389.201349831271;6395.104685344056;5855.268091488564;5909.409059094142;6003.249593800775;6084.30030546484;6093.29927058394;5406.2701535292235;5411.350637923396;5420.159875219348;5435.864103397367;5442.074847275972;6500.902486462707;6545.854475466869;6569.37590928861;6583.868322633521;6592.8351791205605;6143;6148.938510614837;6185.41238582334;6245.812625621239;6362.045693146065;6459.967700161469;6460.903086453613;6486.902696459651;6508.511861610304;6516.543841931019;6200.534959877937;6208.50331973432;6208.534359923115;6214.751409943552;6216.129741836056;6106.664133472524;6268.216472940882;6320.778772742932;6338.049292606146;6431.260405053479;6201.627902325875;6206.193194884817;6225.968870155802;6237.8752424950335;6246.18799556073;6004.729787159676;6139.969300153471;6146.692665366803;6167.938320616916;6173.074038894202;6026.246719160105;6035.758569657164;6058.909116363347;6115.327313995546;6138.263408391022;6211.8192398563715;6217.409346112112;6229.937700623117;6280.214973128359;6286.371362863677;5862.530997520274;5946.613470124428;6109.991851344656;6125.264968203844;6132.9080063799975 16:01:02 INFO - PROCESS | 4603 | |1;ext.html;566.8860688746614;619.4146531527706;634.5145963338048;637.3499030988394;649.9740010399585;42843.143137137275;46671.29993050103;46936.53063469364;47022;47120.29319560209;46406.76796616021;46874.53125468753;47020.29469557959;47033;47129;9018.819623607524;9184.494852783095;9196.724098277062;9200.631974721036;9206.907930920706;9090.045545217756;9151.67969121081;9167.083291670846;9178.173964343208;9224.723258302261;9198.494082825442;9236.122568355995;9250;9255.213306868924;9262.44425334482;9240.907590924073;9255;9256.213221876114;9268.536573171348;9279.118483744101;9027.45835249887;9111.49886756228;9129.497877616728;9131.634734610607;9133.949595796503;42901.57098429007;42997.57002429967;43080.35379469279;43104.13791724148;43396.566034339565;3752.1932784451474;3896.298666240076;3905.3556163233034;3933.1347103637154;3959.5050618672667;33166.834165829256;35616.82191589051;35645.46531802025;35663.82168089143;35710.8214458926;4521.389612402317;4616.7691615419435;4617.2381557043045;4691.7888695008805;4706.917408995916;417764;420094;424760;427000;427388;39012.804935975706;70056.29943700497;70898;70999.2900071003;71189;40745.79627101905;42212.36681449781;42292.57707422948;42373.57626423758;42534.361984570256;15680.05919644825;15724.764128538081;15901.840981590036;15907.602309942344;15917.761233581505;15349.923250383677;15543.533693989199;15545.533633990999;15545.922270388575;15569.377224911103;9384.906150938403;9418.623255069857;9422.246220302359;9495.192908602847;9552.856707149398;3586.228960773446;3610.819459027038;3640.508531348234;3655.6709896108946;3697.3344797936093;1085.4518468173521;1114.7380365614074;1123.09029685953;1187.6437068879302;1189.143816452153;32620.347593048005;33103.172420689676;33141;33788;33796.155096122304;1207.8550573931009;1218.2020776391478;1250.9249445033327;1270.8220849081135;1286.7619490394306;17574.209160587805;17702.380416685355;17805.287788488575;17850.375236866646;17918.104094795468;649615;656333;657867;659046;659412;64744.67627661832;65184.674076629315;65241.347586524476;65266.347336526975;65472;1481.8073650425376;1483.2138966347636;1494.9476768313057;1495.5513345996158;1533.7392643250673;32943.50584741279;32956.50565241571;33187.33625327432;33889.322213556086;34703.826480867436;62115;62744;62753.43116422126;62895;62902.370976289654;584250;589092;589453;591388;591770;48614.756926215145;49038;50397.748011261174;50477;50857.23714144365;53400;53612;53712.73143634257;54294.185587215434;54585.454145459626;45355;45688;45768.084638307715;47033.52966470292;47375.76312118417;44731.776341118086;44864;44892.55107448884;45109;45598.31602525898;44965.77517112393;45482.31776523289;45951.54048459473;46340;47895.28157077577;39317.60682393254;39438.80280598579;39586.604133958295;39809.80095099506;40260.39609405803;30062;30574.235644109074;30822.69177308198;31072.844635776677;31150.532742008436 16:01:02 INFO - PROCESS | 4603 | |2;jquery.html;424.6878544269961;427.22032291068797;428.23559945497294;428.49865657181107;448.9304157855531;18953.147108380123;19732;20544.178232870705;20615.793842061576;20757.481062973435;17203.74194387082;19013.61972760544;19851.30520431785;19908.104135313908;19981.20075196994;5298.337707786527;5499.065158922993;5500.037493438632;5510.779568817243;5513.9448605514035;5371.919421208666;5375;5402.702851343174;5415;5852.736626851802;5777.884442311151;5784.652920824743;5797.043487824504;5815.185873977646;5816.069428891378;5412.404635490093;5419.566434685235;5441.755121019524;5755.884882302352;5807.477327040566;5299.046171689094;5322.840314790563;5335.253064570963;5336.813211537617;5343.946560534384;14464.276786160755;21317.68023479649;22533;22579.774202257933;23405.648915266283;2331.370529956902;2452.3256104571205;2542.834715743489;2622.632831403605;2903.6951120132294;10317.84523232152;10479.68560943173;10725.463726813707;10871.184661150366;10959.178061645409;1882.4164509002253;1947.8149575790278;1974.032723965261;1996.4409965209763;2002.3092033248652;67875.66062169707;81600.59199704023;81610.9999999994;81753;84612.15387846105;11615.88384116148;11966.102542309187;12082.335471548973;12156.270623762426;12177.147599667938;16990.660186796194;17066.23201955915;17199.742003869953;17242.482725518254;17255.22351494186;8317.625706843206;8755.737327880173;8756.956215218883;8766.561671916379;9325.580348884316;8776.868346974801;8854.64581416749;8894.199522043047;8894.510801905828;8995.370324077383;5000.974995125074;5090.363704536933;5148.33071700684;5187.584993200535;5230.189320655304;2000.6298834715624;2029.7665768436818;2051.4871282179456;2086.478380404899;2103.43207334022;936.2135805922921;1068.3483075324045;1103.1340397787858;1103.674416047268;1132.428123797477;19492.51268718265;19515.41453756361;19639;20310.187592496135;20425;1094.6223552874246;1098.4013712526692;1126.4592995362273;1139.8746137924823;1155.4915837031679;10805.351678899291;11323.490442930088;11351.091912646969;11358;11467.655970320904;528912;533658;547465;554415;563182;107795;108199;109295.45352273347;110942.44528777305;111124;1021.0810270756231;1060.0830281806336;1070.2936062198912;1077.488193108283;1089.7765957978595;17786.37747678825;17911.104444777447;18190.636187275915;18335.90832045831;18402.171902264163;42004.36993445162;43153.56846431621;43304.78347608242;43823.34264986092;45276.09814602022;60321.396786031575;60636;64143.67928160329;64831.35168648253;65346.34653653402;8933.374663773473;9179.632814687338;9184.403013804082;9205;9294.58174382168;12791.104622676323;12868.613941581767;13792.103513271606;13979.930100349433;14232.074915130483;12170.57402990891;12593.244405335709;12648.87351126477;12807.61577152687;12816.935915320364;12263;12268.938655306667;12332.938335308267;12469.875301246871;12593;7438.73964411243;9694.612215511583;12322;12880.935595321964;12924.483020679067;9222.170004699608;9267.165955064076;9305.302102342215;9317.208037316905;9430.481323527272;10538.420386878795;11838.230515016496;12185.268883866996;12270.141090123605;12312.322822244863 16:01:02 INFO - PROCESS | 4603 | |3;mootools.html;1571.984280157198;1586.912719800411;1831.5695811484306;1930.7586551681031;1954.8045195480445;8496.32029437645;9272.258219342444;9404.341696081277;9804.460754658481;9818.950905245472;9323.487208203545;9650.42097474152;9691.709248722533;9728.221742260619;9742.07450292221;2368.5262947410542;2412.6984126984125;2415.6255780353986;2416.4562973331035;2422.4912768318673;2461;2476.108600903682;2495.0394098272204;2497.2882728422405;2498.2755001049763;2454.2514533067406;2454.4232105455203;2457;2466.7163276223287;2484.8633325167107;2350.74141844397;2365.597848365782;2372.6203807390907;2402.423418379594;2420.0561780905373;2457.569925263072;2493.364192131013;2494;2501.399664080626;2504.035946160723;9561.808763824754;9604.90395096047;9670;9689.079537443931;9796.510174491246;5648.548116150698;5779.046457334534;5781.13283007548;5792.971035144839;5794.159846822229;3643.7813731176216;3693;3696.3716168251194;3747.081964918585;3807.733458657895;1184.461070213051;1191.1304747534348;1201.8377519034905;1226.8589112252116;1232.1990706041056;13262;13331.400086996011;13339.866601333959;13428.0600357974;13483.05618606688;4855.247436647325;4868.659193856467;4922.606191504671;4966.577840883565;4973.104841128632;11247.156463265288;11282.266652667551;11300.660980170444;11304.15218858589;11428.714282143013;5803.274590676166;5813.186153938452;5855.473007429352;5868.559858010666;5874.295084589877;4708.529147085264;5174.068667639861;5309.442508536626;5317.787288508416;5442.346918369821;4427.114577084596;4453.22068637987;4466.486354069324;4481.663875209372;4500.212462818994;1381.7650999330137;1391.3947432866735;1392.693607406369;1395.183817466773;1422.4381369359046;906.6146887572755;986.659602437158;1024.5850430575629;1052.9105026072716;1058.30680904008;6262.279837818618;6336.493080553545;6390.520710946697;6395.488360931115;6456.580322279036;481.1051444313574;481.1411630240005;492.6034542193497;501.1680610187072;513.2993463921795;4329.675274354436;4346.543612920661;4371.256886329332;4394.12117576486;4403.757793321334;11942.223755455867;12380.81428778569;12396.690082748004;12448.439820208112;12508.49966001368;12163.087768417405;12231.877681223074;12256.509739610316;12297.815532767016;12369.814452783216;8725.825483490295;9085;9136.314776391797;9151.450912945245;9157.084291570924;6481.773137940149;6531.706073226621;6571.98134289186;6725.697343619451;6725.697343619647;10988.230823842574;11089.22375433712;11222.66332010041;11391.373474458984;11470.139739519402;11137.164712646745;11228.606998755004;11434.42827858587;11464.484098215768;11594.130440217186;7892.4869883457395;8425.662973480992;8469.61886715087;8505.787355316166;8645.481271123752;9360.297977651568;9409.435433873989;9443.102905223992;9489;9490.193333566447;8336.124706905688;8512;8564.657413703382;8610.483370997761;8632.266257367943;8390.286825619647;8423.11557286476;8487.448315859448;8523.190296921783;8549;7681.577513236825;7692.730754423568;7761.379089672925;7763.844723105619;7809.2190780921455;5463.562914966714;5502.724863756876;5503.449655034465;5583.050881350261;5650.378458369494;5563.415841336601;5587.776488940397;5592.972035139798;5596.132599447093;5671.489565939085 16:01:02 INFO - PROCESS | 4603 | |4;prototype.html;357.57091490211735;358.97307701922364;360.1302853608536;362.36947710982884;364.9343118238718;5900.970495147523;5975.4920831729305;5983.49140323072;6010.3989601039875;6019.398060193978;5583.441655834425;5752.482276595106;5774.538036957044;5779.133130030497;5822.45704888205;4500.279955207167;4504.842330518432;4514.232580461313;4519.66102542309;4545.863624091283;4557.954420455802;4563.288766712483;4572.657050721193;4578.198815207342;4586.4266966629175;4489.9570695333705;4507.571780680846;4514.164879497303;4521.321801729734;4545.181867263891;4265.765382903939;4458.576435238647;4473.910521789546;4486;4489.6408287336935;3932.311845427039;3936.2914675358425;3939.2712348215673;3949.7630142191274;3983.2431837950985;5657.943420565783;5695.689991302023;5702.116171993348;5703.600747947646;5774.971125144348;5039.672421292605;5124.333836601255;5154.845354639367;5163.819266325698;5170.017696637627;6035.849103772397;6103.359147289515;6115.327313995457;6118.357572454917;6141.477974372184;4235.237657221699;4349.369341445505;4388.341748737683;4415.8233670653135;4440.333949907507;6168.444839964424;6236.875262494816;6330.335314791972;6387.776427825051;6392.584482008655;4411.117776444724;4418.7127836690515;4439.800208990603;4456.3538286948215;4457.509673935864;4555.817767289338;4557.521460246693;4558.521355257651;4566.84016059443;4576.290674945389;4926.187179115406;5155.845324640267;5197.168453047494;5205.360311501865;5206.817761378334;6095;6134.2332208473945;6166.64333846553;6172.85802126608;6173.067792798385;1542.7994360733032;1558.7505999040327;1564.5306408077531;1569.536986588959;1588.721973654629;961.2502248246379;992.4293531219433;994.6966175316597;1002.1181360402799;1008.369768894441;5221.55616772571;5237.764300606482;5289.47105289468;5291.417944026154;5294.523492885582;5614.69119198448;5627.774889004394;5648;5664.830055098354;5692;5275.441410915702;5369.275147855068;5543.445655434505;6012.655064524839;6065.484433823086;3387.542681737934;3387.983060084733;3412;3414.6243913169533;3422.6748458896363;6374.139491168726;6459.644719540376;6523.7064332105165;6584.341565843377;6633.104530888365;6454;6454.806355809334;6460.866479757314;6480.805575832638;6498.870022599522;6262.2172228472355;6494.577852439576;6531.8367040823405;6626.9337306627285;6647.235567909753;6238.313785483684;6292.905606415999;6306.684665766785;6316.526260530387;6386.68066596659;5932.822015339547;6211.720472578835;6212.9068063979985;6243.469305109116;6260.311365749855;6364.331745166691;6492.837679058061;6496.577722448026;6504.317046710027;6584.176977877765;4392.934105988476;4442.111577684541;4445.177642136216;4459.331100334975;4476.529964353696;6235.75056997715;6327.430531252209;6337.9366206337345;6354.489976459365;6411.839704007437;6139.508839292936;6153.169322141633;6180.8763824722355;6181.072839074175;6233.594816337105;5958.702064896825;6128.540359473147;6163.630182188904;6166.352532984151;6172.22847144107;6077.48341390969;6093.268807743099;6111.419415155553;6118.663473509;6132.969335153296;6124.510039196764;6130.448259656474;6197.783077592263;6237;6285.937140628535;5804.912926306024;6042.1540984261355;6047.334793172836;6059.909101363395;6064.818055458343 16:01:02 INFO - PROCESS | 4603 | |5;yui.html;769.4575324396301;804.9034115906088;841.1042240014384;875.321625740051;878.7012415778636;15121.546353609396;16091.356345746171;16145.919270403632;16236.83763162371;16273.593160170987;15853.920730396361;16075;16075.83924160758;16128.193590320467;16140.919295403535;713.9071920650321;848.3255811629738;875.7066382761751;876.8027193881389;877.3069275272559;859.0850743957665;864.4381152251025;864.965401383947;870.0907551608584;875.4965894610592;909.0228004894732;912.4844462878485;912.9406588571754;913.808100298938;916.6241840845255;900.8873890763655;901.04489241404;901.4591245252828;903.6475774447971;907.1019690506351;667.7996601019674;667.9131712877344;670.4401824476568;671.7883866582011;671.9865602687968;16526.66946661072;16529.256183471774;16530;16553.66892662152;16593;15049.54851354461;15689.137097459748;15876.206189690469;16422.67154656912;16728.498145055666;12048.819267710991;12061.698457538632;12073;12133.575324863587;12243.20419172751;4196.265653510623;4228.682848786353;4229.598188172119;4262.850800222009;4264.658827293809;82132.17867821305;82857;83000;83519.16480835175;84861.57569212175;12493.625191244277;12726.363681815872;12818.55135070268;12829.550965716155;12969.481220751064;24108.758912411;24483.77581120937;24506.264812055666;24523.754762452147;24577.87711061469;8822.602982865787;8953.776155596162;9003.954980225188;9133.132352426508;9196.724098277062;5023.673461225008;5097.617678674114;5189;5189.818356357585;5267.0256002639635;3798.6771124454176;3915.197384536163;3936.6850651947775;3939.03493644059;3942.2312649033165;667.3460009190923;669.7086767256259;673.939345458911;677.4546490075438;679.4055201698513;689.9379055884895;759.4190444310108;760;760.1638197982176;773.2499475508747;10132.645357412603;10244.334118282437;10410.5849415656;10622.787544249226;10704.983026612459;659.7361055577711;660.9372109649576;730.5105579261907;781.6052893288853;809.8582748019073;4843.4430040545785;4859.669817190006;4880.219164933594;4886.560209581155;4971.726555039435;102019;118556.50009745266;120644;121515;132006.33996830147;89630;103488.48255758824;105094;105939.470302648;106843;87993.56003220071;89185.55407223052;89349.55325223332;93045;93855.53072234595;9126.817463650557;9564.086853863697;9768.006110620448;9917.950410247902;10005.349652272578;52761;54050.18924716211;54925.45074549203;54960.450395495536;56239.43760562342;75562.62218688871;83425;84715;85248;85322.57338713267;13629.478561316366;13795.310234488436;13809.51666691661;13871.167729936236;14599.92700036493;15037.248137592858;15873.285702143663;15980.121093339978;16512.25694843759;16561.917190414453;15200.771988419961;15205.847941520444;15327.386904523693;15361.846381536041;15536;14643.487477938646;14807.777883331973;15092.16993065392;15203.695926081638;15398.46105386306;14422.278886055865;14812.407503700162;14954;15113.622159445662;15143.167125808186;11147.832782508107;11345.886541134812;11538.423078846192;11874.643760687193;12310.876891230973;11576.421178940851;11926.284422934652;11949.820752688891;11992.520299188283;12107.152499324962 16:01:02 INFO - PROCESS | 4603 | __end_tp_report 16:01:02 INFO - PROCESS | 4603 | __start_cc_report 16:01:02 INFO - PROCESS | 4603 | _x_x_mozilla_cycle_collect,338 16:01:02 INFO - PROCESS | 4603 | __end_cc_report 16:01:02 INFO - PROCESS | 4603 | __startTimestamp1467068462569__endTimestamp 16:01:02 INFO - PROCESS | 4603 | 16:01:02 INFO - PROCESS | 4603 | ------- Summary: start ------- 16:01:02 INFO - PROCESS | 4603 | Number of tests: 6 16:01:02 INFO - PROCESS | 4603 | 16:01:02 INFO - PROCESS | 4603 | [#0] dojo.html Cycles:165 Average:5844.26 Median:6109.99 stddev:667.26 (10.9%) stddev-sans-first:642.26 16:01:02 INFO - PROCESS | 4603 | Values: 3447.2 3480.1 3480.3 3494.6 3497.9 5785.1 5800.5 5853.0 5895.7 5919.7 5906.2 5934.6 5964.0 5964.3 6006.0 5233.9 5278.1 5371.8 5408.6 5414.0 5247.3 5256.3 5284.2 5416.4 5423.4 5295.2 5312.4 5316.0 5388.5 5389.8 5337.2 5378.2 5385.9 5386.8 5407.2 5020.3 5227.1 5251.9 5270.5 5272.4 5806.4 5811.1 5812.2 5820.0 5836.7 6330.9 6366.5 6368.9 6380.0 6388.7 6153.0 6167.5 6212.4 6244.2 6407.1 5778.5 5798.4 5817.3 5863.7 5878.9 6439.3 6441.1 6442.4 6442.4 6446.8 6118.3 6125.5 6149.6 6203.5 6229.1 6303.0 6309.3 6313.4 6313.6 6314.6 6038.2 6151.8 6267.4 6270.3 6286.7 6224.1 6314.7 6316.5 6337.2 6341.1 4791.7 4797.1 4800.9 4813.3 4828.1 4154.8 4186.9 4227.0 4286.6 4302.1 5885.4 5989.8 6027.2 6091.1 6114.0 6302.5 6354.8 6367.4 6389.2 6395.1 5855.3 5909.4 6003.2 6084.3 6093.3 5406.3 5411.4 5420.2 5435.9 5442.1 6500.9 6545.9 6569.4 6583.9 6592.8 6143.0 6148.9 6185.4 6245.8 6362.0 6460.0 6460.9 6486.9 6508.5 6516.5 6200.5 6208.5 6208.5 6214.8 6216.1 6106.7 6268.2 6320.8 6338.0 6431.3 6201.6 6206.2 6226.0 6237.9 6246.2 6004.7 6140.0 6146.7 6167.9 6173.1 6026.2 6035.8 6058.9 6115.3 6138.3 6211.8 6217.4 6229.9 6280.2 6286.4 5862.5 5946.6 6110.0 6125.3 6132.9 16:01:02 INFO - PROCESS | 4603 | 16:01:02 INFO - PROCESS | 4603 | [#1] ext.html Cycles:180 Average:71507.00 Median:45643.16 stddev:150678.64 (330.1%) stddev-sans-first:151007.19 16:01:02 INFO - PROCESS | 4603 | Values: 566.9 619.4 634.5 637.3 650.0 42843.1 46671.3 46936.5 47022.0 47120.3 46406.8 46874.5 47020.3 47033.0 47129.0 9018.8 9184.5 9196.7 9200.6 9206.9 9090.0 9151.7 9167.1 9178.2 9224.7 9198.5 9236.1 9250.0 9255.2 9262.4 9240.9 9255.0 9256.2 9268.5 9279.1 9027.5 9111.5 9129.5 9131.6 9133.9 42901.6 42997.6 43080.4 43104.1 43396.6 3752.2 3896.3 3905.4 3933.1 3959.5 33166.8 35616.8 35645.5 35663.8 35710.8 4521.4 4616.8 4617.2 4691.8 4706.9 417764.0 420094.0 424760.0 427000.0 427388.0 39012.8 70056.3 70898.0 70999.3 71189.0 40745.8 42212.4 42292.6 42373.6 42534.4 15680.1 15724.8 15901.8 15907.6 15917.8 15349.9 15543.5 15545.5 15545.9 15569.4 9384.9 9418.6 9422.2 9495.2 9552.9 3586.2 3610.8 3640.5 3655.7 3697.3 1085.5 1114.7 1123.1 1187.6 1189.1 32620.3 33103.2 33141.0 33788.0 33796.2 1207.9 1218.2 1250.9 1270.8 1286.8 17574.2 17702.4 17805.3 17850.4 17918.1 649615.0 656333.0 657867.0 659046.0 659412.0 64744.7 65184.7 65241.3 65266.3 65472.0 1481.8 1483.2 1494.9 1495.6 1533.7 32943.5 32956.5 33187.3 33889.3 34703.8 62115.0 62744.0 62753.4 62895.0 62902.4 584250.0 589092.0 589453.0 591388.0 591770.0 48614.8 49038.0 50397.7 50477.0 50857.2 53400.0 53612.0 53712.7 54294.2 54585.5 45355.0 45688.0 45768.1 47033.5 47375.8 44731.8 44864.0 44892.6 45109.0 45598.3 44965.8 45482.3 45951.5 46340.0 47895.3 39317.6 39438.8 39586.6 39809.8 40260.4 30062.0 30574.2 30822.7 31072.8 31150.5 16:01:02 INFO - PROCESS | 4603 | 16:01:02 INFO - PROCESS | 4603 | [#2] jquery.html Cycles:180 Average:31413.88 Median:11421.98 stddev:90059.11 (788.5%) stddev-sans-first:90281.69 16:01:02 INFO - PROCESS | 4603 | Values: 424.7 427.2 428.2 428.5 448.9 18953.1 19732.0 20544.2 20615.8 20757.5 17203.7 19013.6 19851.3 19908.1 19981.2 5298.3 5499.1 5500.0 5510.8 5513.9 5371.9 5375.0 5402.7 5415.0 5852.7 5777.9 5784.7 5797.0 5815.2 5816.1 5412.4 5419.6 5441.8 5755.9 5807.5 5299.0 5322.8 5335.3 5336.8 5343.9 14464.3 21317.7 22533.0 22579.8 23405.6 2331.4 2452.3 2542.8 2622.6 2903.7 10317.8 10479.7 10725.5 10871.2 10959.2 1882.4 1947.8 1974.0 1996.4 2002.3 67875.7 81600.6 81611.0 81753.0 84612.2 11615.9 11966.1 12082.3 12156.3 12177.1 16990.7 17066.2 17199.7 17242.5 17255.2 8317.6 8755.7 8757.0 8766.6 9325.6 8776.9 8854.6 8894.2 8894.5 8995.4 5001.0 5090.4 5148.3 5187.6 5230.2 2000.6 2029.8 2051.5 2086.5 2103.4 936.2 1068.3 1103.1 1103.7 1132.4 19492.5 19515.4 19639.0 20310.2 20425.0 1094.6 1098.4 1126.5 1139.9 1155.5 10805.4 11323.5 11351.1 11358.0 11467.7 528912.0 533658.0 547465.0 554415.0 563182.0 107795.0 108199.0 109295.5 110942.4 111124.0 1021.1 1060.1 1070.3 1077.5 1089.8 17786.4 17911.1 18190.6 18335.9 18402.2 42004.4 43153.6 43304.8 43823.3 45276.1 60321.4 60636.0 64143.7 64831.4 65346.3 8933.4 9179.6 9184.4 9205.0 9294.6 12791.1 12868.6 13792.1 13979.9 14232.1 12170.6 12593.2 12648.9 12807.6 12816.9 12263.0 12268.9 12332.9 12469.9 12593.0 7438.7 9694.6 12322.0 12880.9 12924.5 9222.2 9267.2 9305.3 9317.2 9430.5 10538.4 11838.2 12185.3 12270.1 12312.3 16:01:02 INFO - PROCESS | 4603 | 16:01:02 INFO - PROCESS | 4603 | [#3] mootools.html Cycles:180 Average:6351.35 Median:2668.19 stddev:3692.14 (138.4%) stddev-sans-first:3685.03 16:01:02 INFO - PROCESS | 4603 | Values: 1572.0 1586.9 1831.6 1930.8 1954.8 8496.3 9272.3 9404.3 9804.5 9819.0 9323.5 9650.4 9691.7 9728.2 9742.1 2368.5 2412.7 2415.6 2416.5 2422.5 2461.0 2476.1 2495.0 2497.3 2498.3 2454.3 2454.4 2457.0 2466.7 2484.9 2350.7 2365.6 2372.6 2402.4 2420.1 2457.6 2493.4 2494.0 2501.4 2504.0 9561.8 9604.9 9670.0 9689.1 9796.5 5648.5 5779.0 5781.1 5793.0 5794.2 3643.8 3693.0 3696.4 3747.1 3807.7 1184.5 1191.1 1201.8 1226.9 1232.2 13262.0 13331.4 13339.9 13428.1 13483.1 4855.2 4868.7 4922.6 4966.6 4973.1 11247.2 11282.3 11300.7 11304.2 11428.7 5803.3 5813.2 5855.5 5868.6 5874.3 4708.5 5174.1 5309.4 5317.8 5442.3 4427.1 4453.2 4466.5 4481.7 4500.2 1381.8 1391.4 1392.7 1395.2 1422.4 906.6 986.7 1024.6 1052.9 1058.3 6262.3 6336.5 6390.5 6395.5 6456.6 481.1 481.1 492.6 501.2 513.3 4329.7 4346.5 4371.3 4394.1 4403.8 11942.2 12380.8 12396.7 12448.4 12508.5 12163.1 12231.9 12256.5 12297.8 12369.8 8725.8 9085.0 9136.3 9151.5 9157.1 6481.8 6531.7 6572.0 6725.7 6725.7 10988.2 11089.2 11222.7 11391.4 11470.1 11137.2 11228.6 11434.4 11464.5 11594.1 7892.5 8425.7 8469.6 8505.8 8645.5 9360.3 9409.4 9443.1 9489.0 9490.2 8336.1 8512.0 8564.7 8610.5 8632.3 8390.3 8423.1 8487.4 8523.2 8549.0 7681.6 7692.7 7761.4 7763.8 7809.2 5463.6 5502.7 5503.4 5583.1 5650.4 5563.4 5587.8 5593.0 5596.1 5671.5 16:01:02 INFO - PROCESS | 4603 | 16:01:02 INFO - PROCESS | 4603 | [#4] prototype.html Cycles:180 Average:5120.55 Median:5763.51 stddev:1515.80 (26.3%) stddev-sans-first:1477.30 16:01:02 INFO - PROCESS | 4603 | Values: 357.6 359.0 360.1 362.4 364.9 5901.0 5975.5 5983.5 6010.4 6019.4 5583.4 5752.5 5774.5 5779.1 5822.5 4500.3 4504.8 4514.2 4519.7 4545.9 4558.0 4563.3 4572.7 4578.2 4586.4 4490.0 4507.6 4514.2 4521.3 4545.2 4265.8 4458.6 4473.9 4486.0 4489.6 3932.3 3936.3 3939.3 3949.8 3983.2 5657.9 5695.7 5702.1 5703.6 5775.0 5039.7 5124.3 5154.8 5163.8 5170.0 6035.8 6103.4 6115.3 6118.4 6141.5 4235.2 4349.4 4388.3 4415.8 4440.3 6168.4 6236.9 6330.3 6387.8 6392.6 4411.1 4418.7 4439.8 4456.4 4457.5 4555.8 4557.5 4558.5 4566.8 4576.3 4926.2 5155.8 5197.2 5205.4 5206.8 6095.0 6134.2 6166.6 6172.9 6173.1 1542.8 1558.8 1564.5 1569.5 1588.7 961.3 992.4 994.7 1002.1 1008.4 5221.6 5237.8 5289.5 5291.4 5294.5 5614.7 5627.8 5648.0 5664.8 5692.0 5275.4 5369.3 5543.4 6012.7 6065.5 3387.5 3388.0 3412.0 3414.6 3422.7 6374.1 6459.6 6523.7 6584.3 6633.1 6454.0 6454.8 6460.9 6480.8 6498.9 6262.2 6494.6 6531.8 6626.9 6647.2 6238.3 6292.9 6306.7 6316.5 6386.7 5932.8 6211.7 6212.9 6243.5 6260.3 6364.3 6492.8 6496.6 6504.3 6584.2 4392.9 4442.1 4445.2 4459.3 4476.5 6235.8 6327.4 6337.9 6354.5 6411.8 6139.5 6153.2 6180.9 6181.1 6233.6 5958.7 6128.5 6163.6 6166.4 6172.2 6077.5 6093.3 6111.4 6118.7 6133.0 6124.5 6130.4 6197.8 6237.0 6285.9 5804.9 6042.2 6047.3 6059.9 6064.8 16:01:02 INFO - PROCESS | 4603 | 16:01:02 INFO - PROCESS | 4603 | [#5] yui.html Cycles:180 Average:22211.42 Median:4212.47 stddev:31589.29 (749.9%) stddev-sans-first:31636.88 16:01:02 INFO - PROCESS | 4603 | Values: 769.5 804.9 841.1 875.3 878.7 15121.5 16091.4 16145.9 16236.8 16273.6 15853.9 16075.0 16075.8 16128.2 16140.9 713.9 848.3 875.7 876.8 877.3 859.1 864.4 865.0 870.1 875.5 909.0 912.5 912.9 913.8 916.6 900.9 901.0 901.5 903.6 907.1 667.8 667.9 670.4 671.8 672.0 16526.7 16529.3 16530.0 16553.7 16593.0 15049.5 15689.1 15876.2 16422.7 16728.5 12048.8 12061.7 12073.0 12133.6 12243.2 4196.3 4228.7 4229.6 4262.9 4264.7 82132.2 82857.0 83000.0 83519.2 84861.6 12493.6 12726.4 12818.6 12829.6 12969.5 24108.8 24483.8 24506.3 24523.8 24577.9 8822.6 8953.8 9004.0 9133.1 9196.7 5023.7 5097.6 5189.0 5189.8 5267.0 3798.7 3915.2 3936.7 3939.0 3942.2 667.3 669.7 673.9 677.5 679.4 689.9 759.4 760.0 760.2 773.2 10132.6 10244.3 10410.6 10622.8 10705.0 659.7 660.9 730.5 781.6 809.9 4843.4 4859.7 4880.2 4886.6 4971.7 102019.0 118556.5 120644.0 121515.0 132006.3 89630.0 103488.5 105094.0 105939.5 106843.0 87993.6 89185.6 89349.6 93045.0 93855.5 9126.8 9564.1 9768.0 9918.0 10005.3 52761.0 54050.2 54925.5 54960.5 56239.4 75562.6 83425.0 84715.0 85248.0 85322.6 13629.5 13795.3 13809.5 13871.2 14599.9 15037.2 15873.3 15980.1 16512.3 16561.9 15200.8 15205.8 15327.4 15361.8 15536.0 14643.5 14807.8 15092.2 15203.7 15398.5 14422.3 14812.4 14954.0 15113.6 15143.2 11147.8 11345.9 11538.4 11874.6 12310.9 11576.4 11926.3 11949.8 11992.5 12107.2 16:01:02 INFO - PROCESS | 4603 | -------- Summary: end -------- 16:01:02 INFO - PROCESS | 4603 | 16:01:03 INFO - TEST-INFO | 4603: exit 0 16:01:03 INFO - TEST-OK | dromaeo_css | took 1110054ms 16:01:03 INFO - TEST-START | kraken 16:01:03 INFO - operating with platform_type : linux_ 16:01:03 INFO - Initialising browser for kraken test... 16:01:03 INFO - TEST-INFO | started process 4836 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgabsXN/profile http://localhost:49615/getInfo.html) 16:01:07 INFO - PROCESS | 4836 | __metrics Screen width/height:1600/1200 16:01:07 INFO - PROCESS | 4836 | colorDepth:24 16:01:07 INFO - PROCESS | 4836 | Browser inner width/height: 1024/697 16:01:07 INFO - PROCESS | 4836 | __metrics 16:01:08 ERROR - PROCESS | 4836 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 16:01:08 INFO - TEST-INFO | 4836: exit 0 16:01:08 INFO - Browser initialized. 16:01:08 INFO - Running cycle 1/1 for kraken test... 16:01:08 INFO - TEST-INFO | started process 4964 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgabsXN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:01:20 INFO - PROCESS | 4964 | RSS: Main: 155951104 16:01:20 INFO - PROCESS | 4964 | 16:01:23 INFO - PROCESS | 4964 | Cycle 1(1): loaded http://localhost:49615/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49615/tests/kraken/driver.html?testName=audio-beat-detection) 16:01:23 INFO - PROCESS | 4964 | RSS: Main: 161218560 16:01:23 INFO - PROCESS | 4964 | 16:01:26 INFO - PROCESS | 4964 | Cycle 1(1): loaded http://localhost:49615/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49615/tests/kraken/driver.html?testName=audio-dft) 16:01:27 INFO - PROCESS | 4964 | RSS: Main: 160546816 16:01:27 INFO - PROCESS | 4964 | 16:01:30 INFO - PROCESS | 4964 | Cycle 1(1): loaded http://localhost:49615/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49615/tests/kraken/driver.html?testName=audio-fft) 16:01:30 INFO - PROCESS | 4964 | RSS: Main: 161382400 16:01:30 INFO - PROCESS | 4964 | 16:01:32 INFO - PROCESS | 4964 | Cycle 1(1): loaded http://localhost:49615/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49615/tests/kraken/driver.html?testName=audio-oscillator) 16:01:33 INFO - PROCESS | 4964 | RSS: Main: 161386496 16:01:33 INFO - PROCESS | 4964 | 16:01:35 INFO - PROCESS | 4964 | Cycle 1(1): loaded http://localhost:49615/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49615/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:01:36 INFO - PROCESS | 4964 | RSS: Main: 161255424 16:01:36 INFO - PROCESS | 4964 | 16:01:39 INFO - PROCESS | 4964 | Cycle 1(1): loaded http://localhost:49615/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49615/tests/kraken/driver.html?testName=imaging-darkroom) 16:01:39 INFO - PROCESS | 4964 | RSS: Main: 161296384 16:01:39 INFO - PROCESS | 4964 | 16:01:43 INFO - PROCESS | 4964 | Cycle 1(1): loaded http://localhost:49615/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49615/tests/kraken/driver.html?testName=imaging-desaturate) 16:01:43 INFO - PROCESS | 4964 | RSS: Main: 161603584 16:01:43 INFO - PROCESS | 4964 | 16:01:46 INFO - PROCESS | 4964 | Cycle 1(1): loaded http://localhost:49615/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49615/tests/kraken/driver.html?testName=json-parse-financial) 16:01:47 INFO - PROCESS | 4964 | RSS: Main: 161218560 16:01:47 INFO - PROCESS | 4964 | 16:01:48 INFO - PROCESS | 4964 | Cycle 1(1): loaded http://localhost:49615/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49615/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:01:49 INFO - PROCESS | 4964 | RSS: Main: 161017856 16:01:49 INFO - PROCESS | 4964 | 16:01:51 INFO - PROCESS | 4964 | Cycle 1(1): loaded http://localhost:49615/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49615/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:01:52 INFO - PROCESS | 4964 | RSS: Main: 161583104 16:01:52 INFO - PROCESS | 4964 | 16:01:54 INFO - PROCESS | 4964 | Cycle 1(1): loaded http://localhost:49615/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49615/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:01:54 INFO - PROCESS | 4964 | RSS: Main: 161804288 16:01:54 INFO - PROCESS | 4964 | 16:01:57 INFO - PROCESS | 4964 | Cycle 1(1): loaded http://localhost:49615/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49615/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:01:57 INFO - PROCESS | 4964 | RSS: Main: 162091008 16:01:57 INFO - PROCESS | 4964 | 16:02:00 INFO - PROCESS | 4964 | Cycle 1(1): loaded http://localhost:49615/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49615/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:02:01 INFO - PROCESS | 4964 | RSS: Main: 161705984 16:02:01 INFO - PROCESS | 4964 | 16:02:02 INFO - PROCESS | 4964 | Cycle 1(1): loaded http://localhost:49615/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49615/tests/kraken/driver.html?testName=ai-astar) 16:02:03 INFO - PROCESS | 4964 | RSS: Main: 162144256 16:02:03 INFO - PROCESS | 4964 | 16:02:03 INFO - PROCESS | 4964 | __start_tp_report 16:02:03 INFO - PROCESS | 4964 | _x_x_mozilla_page_load 16:02:03 INFO - PROCESS | 4964 | _x_x_mozilla_page_load_details 16:02:03 INFO - PROCESS | 4964 | |i|pagename|runs| 16:02:03 INFO - PROCESS | 4964 | |0;ai-astar;111;103;111;113;111;113;112;109;112;108 16:02:03 INFO - PROCESS | 4964 | |1;audio-beat-detection;166;130;156;165;130;160;149;128;180;130 16:02:03 INFO - PROCESS | 4964 | |2;audio-dft;163;161;161;160;161;161;161;167;160;164 16:02:03 INFO - PROCESS | 4964 | |3;audio-fft;74;76;73;166;78;75;75;75;180;75 16:02:03 INFO - PROCESS | 4964 | |4;audio-oscillator;89;85;143;84;85;85;136;86;85;140 16:02:03 INFO - PROCESS | 4964 | |5;imaging-gaussian-blur;118;118;117;118;118;117;118;118;119;118 16:02:03 INFO - PROCESS | 4964 | |6;imaging-darkroom;146;147;146;146;147;149;147;147;146;147 16:02:03 INFO - PROCESS | 4964 | |7;imaging-desaturate;95;95;97;96;96;98;96;96;100;95 16:02:03 INFO - PROCESS | 4964 | |8;json-parse-financial;50;53;52;52;52;58;53;51;53;53 16:02:03 INFO - PROCESS | 4964 | |9;json-stringify-tinderbox;61;59;61;62;64;64;60;60;64;61 16:02:03 INFO - PROCESS | 4964 | |10;stanford-crypto-aes;76;76;78;78;79;77;77;78;107;77 16:02:03 INFO - PROCESS | 4964 | |11;stanford-crypto-ccm;127;127;127;131;120;118;126;121;132;118 16:02:03 INFO - PROCESS | 4964 | |12;stanford-crypto-pbkdf2;154;153;155;152;162;162;153;154;154;155 16:02:03 INFO - PROCESS | 4964 | |13;stanford-crypto-sha256-iterative;62;62;63;62;63;62;62;63;63;62 16:02:03 INFO - PROCESS | 4964 | __end_tp_report 16:02:03 INFO - PROCESS | 4964 | __start_cc_report 16:02:03 INFO - PROCESS | 4964 | _x_x_mozilla_cycle_collect,861 16:02:03 INFO - PROCESS | 4964 | __end_cc_report 16:02:03 INFO - PROCESS | 4964 | __startTimestamp1467068523036__endTimestamp 16:02:03 INFO - PROCESS | 4964 | 16:02:03 INFO - PROCESS | 4964 | ------- Summary: start ------- 16:02:03 INFO - PROCESS | 4964 | Number of tests: 14 16:02:03 INFO - PROCESS | 4964 | 16:02:03 INFO - PROCESS | 4964 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.50 stddev:3.02 (2.7%) stddev-sans-first:3.19 16:02:03 INFO - PROCESS | 4964 | Values: 111.0 103.0 111.0 113.0 111.0 113.0 112.0 109.0 112.0 108.0 16:02:03 INFO - PROCESS | 4964 | 16:02:03 INFO - PROCESS | 4964 | [#1] audio-beat-detection Cycles:10 Average:149.40 Median:158.00 stddev:18.85 (11.9%) stddev-sans-first:19.01 16:02:03 INFO - PROCESS | 4964 | Values: 166.0 130.0 156.0 165.0 130.0 160.0 149.0 128.0 180.0 130.0 16:02:03 INFO - PROCESS | 4964 | 16:02:03 INFO - PROCESS | 4964 | [#2] audio-dft Cycles:10 Average:161.90 Median:161.00 stddev:2.18 (1.4%) stddev-sans-first:2.28 16:02:03 INFO - PROCESS | 4964 | Values: 163.0 161.0 161.0 160.0 161.0 161.0 161.0 167.0 160.0 164.0 16:02:03 INFO - PROCESS | 4964 | 16:02:03 INFO - PROCESS | 4964 | [#3] audio-fft Cycles:10 Average:94.70 Median:75.00 stddev:41.42 (55.2%) stddev-sans-first:43.25 16:02:03 INFO - PROCESS | 4964 | Values: 74.0 76.0 73.0 166.0 78.0 75.0 75.0 75.0 180.0 75.0 16:02:03 INFO - PROCESS | 4964 | 16:02:03 INFO - PROCESS | 4964 | [#4] audio-oscillator Cycles:10 Average:101.80 Median:85.00 stddev:26.22 (30.8%) stddev-sans-first:27.39 16:02:03 INFO - PROCESS | 4964 | Values: 89.0 85.0 143.0 84.0 85.0 85.0 136.0 86.0 85.0 140.0 16:02:03 INFO - PROCESS | 4964 | 16:02:03 INFO - PROCESS | 4964 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 16:02:03 INFO - PROCESS | 4964 | Values: 118.0 118.0 117.0 118.0 118.0 117.0 118.0 118.0 119.0 118.0 16:02:03 INFO - PROCESS | 4964 | 16:02:03 INFO - PROCESS | 4964 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 16:02:03 INFO - PROCESS | 4964 | Values: 146.0 147.0 146.0 146.0 147.0 149.0 147.0 147.0 146.0 147.0 16:02:03 INFO - PROCESS | 4964 | 16:02:03 INFO - PROCESS | 4964 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.00 stddev:1.58 (1.6%) stddev-sans-first:1.59 16:02:03 INFO - PROCESS | 4964 | Values: 95.0 95.0 97.0 96.0 96.0 98.0 96.0 96.0 100.0 95.0 16:02:03 INFO - PROCESS | 4964 | 16:02:03 INFO - PROCESS | 4964 | [#8] json-parse-financial Cycles:10 Average:52.70 Median:53.00 stddev:2.11 (4.0%) stddev-sans-first:2.00 16:02:03 INFO - PROCESS | 4964 | Values: 50.0 53.0 52.0 52.0 52.0 58.0 53.0 51.0 53.0 53.0 16:02:03 INFO - PROCESS | 4964 | 16:02:03 INFO - PROCESS | 4964 | [#9] json-stringify-tinderbox Cycles:10 Average:61.60 Median:61.50 stddev:1.84 (3.0%) stddev-sans-first:1.94 16:02:03 INFO - PROCESS | 4964 | Values: 61.0 59.0 61.0 62.0 64.0 64.0 60.0 60.0 64.0 61.0 16:02:03 INFO - PROCESS | 4964 | 16:02:03 INFO - PROCESS | 4964 | [#10] stanford-crypto-aes Cycles:10 Average:80.30 Median:77.50 stddev:9.43 (12.2%) stddev-sans-first:9.87 16:02:03 INFO - PROCESS | 4964 | Values: 76.0 76.0 78.0 78.0 79.0 77.0 77.0 78.0 107.0 77.0 16:02:03 INFO - PROCESS | 4964 | 16:02:03 INFO - PROCESS | 4964 | [#11] stanford-crypto-ccm Cycles:10 Average:124.70 Median:127.00 stddev:5.12 (4.0%) stddev-sans-first:5.36 16:02:03 INFO - PROCESS | 4964 | Values: 127.0 127.0 127.0 131.0 120.0 118.0 126.0 121.0 132.0 118.0 16:02:03 INFO - PROCESS | 4964 | 16:02:03 INFO - PROCESS | 4964 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.40 Median:154.50 stddev:3.60 (2.3%) stddev-sans-first:3.78 16:02:03 INFO - PROCESS | 4964 | Values: 154.0 153.0 155.0 152.0 162.0 162.0 153.0 154.0 154.0 155.0 16:02:03 INFO - PROCESS | 4964 | 16:02:03 INFO - PROCESS | 4964 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.40 Median:62.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 16:02:03 INFO - PROCESS | 4964 | Values: 62.0 62.0 63.0 62.0 63.0 62.0 62.0 63.0 63.0 62.0 16:02:03 INFO - PROCESS | 4964 | -------- Summary: end -------- 16:02:03 INFO - PROCESS | 4964 | 16:02:03 INFO - TEST-INFO | 4964: exit 0 16:02:03 INFO - TEST-OK | kraken | took 60713ms 16:02:03 INFO - SUITE-END | took 1170s 16:02:04 INFO - Completed test suite (00:19:31) 16:02:04 INFO - javascript benchmark 16:02:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7769.684563190947, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3447.1726785571464, 3480.077779388461, 3480.2691434798708, 3494.59812121606, 3497.9300413991723, 5785.132230165472, 5800.53595712343, 5853.0, 5895.675737834417, 5919.674417907014, 5906.202662640542, 5934.554908381867, 5964.015937370329, 5964.254468191476, 6006.0, 5233.8953220935555, 5278.102722537159, 5371.785128594852, 5408.594355423339, 5413.972930135344, 5247.2653828464045, 5256.342957130359, 5284.154535274357, 5416.404195538487, 5423.403425623178, 5295.152775555912, 5312.389075256337, 5316.043112239795, 5388.488093631099, 5389.8113566025195, 5337.226102215157, 5378.2470454136455, 5385.892282154374, 5386.757595908174, 5407.188921661743, 5020.347354843847, 5227.059129356714, 5251.897101608667, 5270.499302566289, 5272.393674727378, 5806.44838740319, 5811.128330750379, 5812.215350927613, 5819.970900145515, 5836.6789826559525, 6330.905036424458, 6366.522510811661, 6368.936310636927, 6380.042993550958, 6388.744450221986, 6153.0, 6167.4757645600175, 6212.440880320748, 6244.188255526798, 6407.070974708641, 5778.508826749731, 5798.449147330997, 5817.272840894888, 5863.706814659293, 5878.882422351529, 6439.3238709934785, 6441.066045423388, 6442.355764423613, 6442.355764423613, 6446.774362897276, 6118.253719382578, 6125.479334256549, 6149.631022138686, 6203.534734894901, 6229.127922090911, 6303.0, 6309.274433440121, 6313.43179113882, 6313.558050936482, 6314.62112273265, 6038.184845045863, 6151.784687535915, 6267.373262673696, 6270.31026587075, 6286.654234017173, 6224.128621992924, 6314.71583778731, 6316.494680425555, 6337.2395312562785, 6341.143945567382, 4791.712497250176, 4797.064572408347, 4800.855974320776, 4813.326134341195, 4828.082664293843, 4154.771487568213, 4186.91626167475, 4226.978865105716, 4286.635635970977, 4302.053548219386, 5885.3820348862755, 5989.760409583568, 6027.186329845503, 6091.086337049478, 6113.96943015291, 6302.4958003359625, 6354.8411289717205, 6367.395097465734, 6389.201349831271, 6395.104685344056, 5855.268091488564, 5909.409059094142, 6003.249593800775, 6084.30030546484, 6093.29927058394, 5406.2701535292235, 5411.350637923396, 5420.159875219348, 5435.864103397367, 5442.074847275972, 6500.902486462707, 6545.854475466869, 6569.37590928861, 6583.868322633521, 6592.8351791205605, 6143.0, 6148.938510614837, 6185.41238582334, 6245.812625621239, 6362.045693146065, 6459.967700161469, 6460.903086453613, 6486.902696459651, 6508.511861610304, 6516.543841931019, 6200.534959877937, 6208.50331973432, 6208.534359923115, 6214.751409943552, 6216.129741836056, 6106.664133472524, 6268.216472940882, 6320.778772742932, 6338.049292606146, 6431.260405053479, 6201.627902325875, 6206.193194884817, 6225.968870155802, 6237.8752424950335, 6246.18799556073, 6004.729787159676, 6139.969300153471, 6146.692665366803, 6167.938320616916, 6173.074038894202, 6026.246719160105, 6035.758569657164, 6058.909116363347, 6115.327313995546, 6138.263408391022, 6211.8192398563715, 6217.409346112112, 6229.937700623117, 6280.214973128359, 6286.371362863677, 5862.530997520274, 5946.613470124428, 6109.991851344656, 6125.264968203844, 6132.9080063799975], "value": 5799.476432459662, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.8860688746614, 619.4146531527706, 634.5145963338048, 637.3499030988394, 649.9740010399585, 42843.143137137275, 46671.29993050103, 46936.53063469364, 47022.0, 47120.29319560209, 46406.76796616021, 46874.53125468753, 47020.29469557959, 47033.0, 47129.0, 9018.819623607524, 9184.494852783095, 9196.724098277062, 9200.631974721036, 9206.907930920706, 9090.045545217756, 9151.67969121081, 9167.083291670846, 9178.173964343208, 9224.723258302261, 9198.494082825442, 9236.122568355995, 9250.0, 9255.213306868924, 9262.44425334482, 9240.907590924073, 9255.0, 9256.213221876114, 9268.536573171348, 9279.118483744101, 9027.45835249887, 9111.49886756228, 9129.497877616728, 9131.634734610607, 9133.949595796503, 42901.57098429007, 42997.57002429967, 43080.35379469279, 43104.13791724148, 43396.566034339565, 3752.1932784451474, 3896.298666240076, 3905.3556163233034, 3933.1347103637154, 3959.5050618672667, 33166.834165829256, 35616.82191589051, 35645.46531802025, 35663.82168089143, 35710.8214458926, 4521.389612402317, 4616.7691615419435, 4617.2381557043045, 4691.7888695008805, 4706.917408995916, 417764.0, 420094.0, 424760.0, 427000.0, 427388.0, 39012.804935975706, 70056.29943700497, 70898.0, 70999.2900071003, 71189.0, 40745.79627101905, 42212.36681449781, 42292.57707422948, 42373.57626423758, 42534.361984570256, 15680.05919644825, 15724.764128538081, 15901.840981590036, 15907.602309942344, 15917.761233581505, 15349.923250383677, 15543.533693989199, 15545.533633990999, 15545.922270388575, 15569.377224911103, 9384.906150938403, 9418.623255069857, 9422.246220302359, 9495.192908602847, 9552.856707149398, 3586.228960773446, 3610.819459027038, 3640.508531348234, 3655.6709896108946, 3697.3344797936093, 1085.4518468173521, 1114.7380365614074, 1123.09029685953, 1187.6437068879302, 1189.143816452153, 32620.347593048005, 33103.172420689676, 33141.0, 33788.0, 33796.155096122304, 1207.8550573931009, 1218.2020776391478, 1250.9249445033327, 1270.8220849081135, 1286.7619490394306, 17574.209160587805, 17702.380416685355, 17805.287788488575, 17850.375236866646, 17918.104094795468, 649615.0, 656333.0, 657867.0, 659046.0, 659412.0, 64744.67627661832, 65184.674076629315, 65241.347586524476, 65266.347336526975, 65472.0, 1481.8073650425376, 1483.2138966347636, 1494.9476768313057, 1495.5513345996158, 1533.7392643250673, 32943.50584741279, 32956.50565241571, 33187.33625327432, 33889.322213556086, 34703.826480867436, 62115.0, 62744.0, 62753.43116422126, 62895.0, 62902.370976289654, 584250.0, 589092.0, 589453.0, 591388.0, 591770.0, 48614.756926215145, 49038.0, 50397.748011261174, 50477.0, 50857.23714144365, 53400.0, 53612.0, 53712.73143634257, 54294.185587215434, 54585.454145459626, 45355.0, 45688.0, 45768.084638307715, 47033.52966470292, 47375.76312118417, 44731.776341118086, 44864.0, 44892.55107448884, 45109.0, 45598.31602525898, 44965.77517112393, 45482.31776523289, 45951.54048459473, 46340.0, 47895.28157077577, 39317.60682393254, 39438.80280598579, 39586.604133958295, 39809.80095099506, 40260.39609405803, 30062.0, 30574.235644109074, 30822.69177308198, 31072.844635776677, 31150.532742008436], "value": 21122.6632494287, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [424.6878544269961, 427.22032291068797, 428.23559945497294, 428.49865657181107, 448.9304157855531, 18953.147108380123, 19732.0, 20544.178232870705, 20615.793842061576, 20757.481062973435, 17203.74194387082, 19013.61972760544, 19851.30520431785, 19908.104135313908, 19981.20075196994, 5298.337707786527, 5499.065158922993, 5500.037493438632, 5510.779568817243, 5513.9448605514035, 5371.919421208666, 5375.0, 5402.702851343174, 5415.0, 5852.736626851802, 5777.884442311151, 5784.652920824743, 5797.043487824504, 5815.185873977646, 5816.069428891378, 5412.404635490093, 5419.566434685235, 5441.755121019524, 5755.884882302352, 5807.477327040566, 5299.046171689094, 5322.840314790563, 5335.253064570963, 5336.813211537617, 5343.946560534384, 14464.276786160755, 21317.68023479649, 22533.0, 22579.774202257933, 23405.648915266283, 2331.370529956902, 2452.3256104571205, 2542.834715743489, 2622.632831403605, 2903.6951120132294, 10317.84523232152, 10479.68560943173, 10725.463726813707, 10871.184661150366, 10959.178061645409, 1882.4164509002253, 1947.8149575790278, 1974.032723965261, 1996.4409965209763, 2002.3092033248652, 67875.66062169707, 81600.59199704023, 81610.9999999994, 81753.0, 84612.15387846105, 11615.88384116148, 11966.102542309187, 12082.335471548973, 12156.270623762426, 12177.147599667938, 16990.660186796194, 17066.23201955915, 17199.742003869953, 17242.482725518254, 17255.22351494186, 8317.625706843206, 8755.737327880173, 8756.956215218883, 8766.561671916379, 9325.580348884316, 8776.868346974801, 8854.64581416749, 8894.199522043047, 8894.510801905828, 8995.370324077383, 5000.974995125074, 5090.363704536933, 5148.33071700684, 5187.584993200535, 5230.189320655304, 2000.6298834715624, 2029.7665768436818, 2051.4871282179456, 2086.478380404899, 2103.43207334022, 936.2135805922921, 1068.3483075324045, 1103.1340397787858, 1103.674416047268, 1132.428123797477, 19492.51268718265, 19515.41453756361, 19639.0, 20310.187592496135, 20425.0, 1094.6223552874246, 1098.4013712526692, 1126.4592995362273, 1139.8746137924823, 1155.4915837031679, 10805.351678899291, 11323.490442930088, 11351.091912646969, 11358.0, 11467.655970320904, 528912.0, 533658.0, 547465.0, 554415.0, 563182.0, 107795.0, 108199.0, 109295.45352273347, 110942.44528777305, 111124.0, 1021.0810270756231, 1060.0830281806336, 1070.2936062198912, 1077.488193108283, 1089.7765957978595, 17786.37747678825, 17911.104444777447, 18190.636187275915, 18335.90832045831, 18402.171902264163, 42004.36993445162, 43153.56846431621, 43304.78347608242, 43823.34264986092, 45276.09814602022, 60321.396786031575, 60636.0, 64143.67928160329, 64831.35168648253, 65346.34653653402, 8933.374663773473, 9179.632814687338, 9184.403013804082, 9205.0, 9294.58174382168, 12791.104622676323, 12868.613941581767, 13792.103513271606, 13979.930100349433, 14232.074915130483, 12170.57402990891, 12593.244405335709, 12648.87351126477, 12807.61577152687, 12816.935915320364, 12263.0, 12268.938655306667, 12332.938335308267, 12469.875301246871, 12593.0, 7438.73964411243, 9694.612215511583, 12322.0, 12880.935595321964, 12924.483020679067, 9222.170004699608, 9267.165955064076, 9305.302102342215, 9317.208037316905, 9430.481323527272, 10538.420386878795, 11838.230515016496, 12185.268883866996, 12270.141090123605, 12312.322822244863], "value": 9633.257689100164, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1571.984280157198, 1586.912719800411, 1831.5695811484306, 1930.7586551681031, 1954.8045195480445, 8496.32029437645, 9272.258219342444, 9404.341696081277, 9804.460754658481, 9818.950905245472, 9323.487208203545, 9650.42097474152, 9691.709248722533, 9728.221742260619, 9742.07450292221, 2368.5262947410542, 2412.6984126984125, 2415.6255780353986, 2416.4562973331035, 2422.4912768318673, 2461.0, 2476.108600903682, 2495.0394098272204, 2497.2882728422405, 2498.2755001049763, 2454.2514533067406, 2454.4232105455203, 2457.0, 2466.7163276223287, 2484.8633325167107, 2350.74141844397, 2365.597848365782, 2372.6203807390907, 2402.423418379594, 2420.0561780905373, 2457.569925263072, 2493.364192131013, 2494.0, 2501.399664080626, 2504.035946160723, 9561.808763824754, 9604.90395096047, 9670.0, 9689.079537443931, 9796.510174491246, 5648.548116150698, 5779.046457334534, 5781.13283007548, 5792.971035144839, 5794.159846822229, 3643.7813731176216, 3693.0, 3696.3716168251194, 3747.081964918585, 3807.733458657895, 1184.461070213051, 1191.1304747534348, 1201.8377519034905, 1226.8589112252116, 1232.1990706041056, 13262.0, 13331.400086996011, 13339.866601333959, 13428.0600357974, 13483.05618606688, 4855.247436647325, 4868.659193856467, 4922.606191504671, 4966.577840883565, 4973.104841128632, 11247.156463265288, 11282.266652667551, 11300.660980170444, 11304.15218858589, 11428.714282143013, 5803.274590676166, 5813.186153938452, 5855.473007429352, 5868.559858010666, 5874.295084589877, 4708.529147085264, 5174.068667639861, 5309.442508536626, 5317.787288508416, 5442.346918369821, 4427.114577084596, 4453.22068637987, 4466.486354069324, 4481.663875209372, 4500.212462818994, 1381.7650999330137, 1391.3947432866735, 1392.693607406369, 1395.183817466773, 1422.4381369359046, 906.6146887572755, 986.659602437158, 1024.5850430575629, 1052.9105026072716, 1058.30680904008, 6262.279837818618, 6336.493080553545, 6390.520710946697, 6395.488360931115, 6456.580322279036, 481.1051444313574, 481.1411630240005, 492.6034542193497, 501.1680610187072, 513.2993463921795, 4329.675274354436, 4346.543612920661, 4371.256886329332, 4394.12117576486, 4403.757793321334, 11942.223755455867, 12380.81428778569, 12396.690082748004, 12448.439820208112, 12508.49966001368, 12163.087768417405, 12231.877681223074, 12256.509739610316, 12297.815532767016, 12369.814452783216, 8725.825483490295, 9085.0, 9136.314776391797, 9151.450912945245, 9157.084291570924, 6481.773137940149, 6531.706073226621, 6571.98134289186, 6725.697343619451, 6725.697343619647, 10988.230823842574, 11089.22375433712, 11222.66332010041, 11391.373474458984, 11470.139739519402, 11137.164712646745, 11228.606998755004, 11434.42827858587, 11464.484098215768, 11594.130440217186, 7892.4869883457395, 8425.662973480992, 8469.61886715087, 8505.787355316166, 8645.481271123752, 9360.297977651568, 9409.435433873989, 9443.102905223992, 9489.0, 9490.193333566447, 8336.124706905688, 8512.0, 8564.657413703382, 8610.483370997761, 8632.266257367943, 8390.286825619647, 8423.11557286476, 8487.448315859448, 8523.190296921783, 8549.0, 7681.577513236825, 7692.730754423568, 7761.379089672925, 7763.844723105619, 7809.2190780921455, 5463.562914966714, 5502.724863756876, 5503.449655034465, 5583.050881350261, 5650.378458369494, 5563.415841336601, 5587.776488940397, 5592.972035139798, 5596.132599447093, 5671.489565939085], "value": 4959.199707785568, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.57091490211735, 358.97307701922364, 360.1302853608536, 362.36947710982884, 364.9343118238718, 5900.970495147523, 5975.4920831729305, 5983.49140323072, 6010.3989601039875, 6019.398060193978, 5583.441655834425, 5752.482276595106, 5774.538036957044, 5779.133130030497, 5822.45704888205, 4500.279955207167, 4504.842330518432, 4514.232580461313, 4519.66102542309, 4545.863624091283, 4557.954420455802, 4563.288766712483, 4572.657050721193, 4578.198815207342, 4586.4266966629175, 4489.9570695333705, 4507.571780680846, 4514.164879497303, 4521.321801729734, 4545.181867263891, 4265.765382903939, 4458.576435238647, 4473.910521789546, 4486.0, 4489.6408287336935, 3932.311845427039, 3936.2914675358425, 3939.2712348215673, 3949.7630142191274, 3983.2431837950985, 5657.943420565783, 5695.689991302023, 5702.116171993348, 5703.600747947646, 5774.971125144348, 5039.672421292605, 5124.333836601255, 5154.845354639367, 5163.819266325698, 5170.017696637627, 6035.849103772397, 6103.359147289515, 6115.327313995457, 6118.357572454917, 6141.477974372184, 4235.237657221699, 4349.369341445505, 4388.341748737683, 4415.8233670653135, 4440.333949907507, 6168.444839964424, 6236.875262494816, 6330.335314791972, 6387.776427825051, 6392.584482008655, 4411.117776444724, 4418.7127836690515, 4439.800208990603, 4456.3538286948215, 4457.509673935864, 4555.817767289338, 4557.521460246693, 4558.521355257651, 4566.84016059443, 4576.290674945389, 4926.187179115406, 5155.845324640267, 5197.168453047494, 5205.360311501865, 5206.817761378334, 6095.0, 6134.2332208473945, 6166.64333846553, 6172.85802126608, 6173.067792798385, 1542.7994360733032, 1558.7505999040327, 1564.5306408077531, 1569.536986588959, 1588.721973654629, 961.2502248246379, 992.4293531219433, 994.6966175316597, 1002.1181360402799, 1008.369768894441, 5221.55616772571, 5237.764300606482, 5289.47105289468, 5291.417944026154, 5294.523492885582, 5614.69119198448, 5627.774889004394, 5648.0, 5664.830055098354, 5692.0, 5275.441410915702, 5369.275147855068, 5543.445655434505, 6012.655064524839, 6065.484433823086, 3387.542681737934, 3387.983060084733, 3412.0, 3414.6243913169533, 3422.6748458896363, 6374.139491168726, 6459.644719540376, 6523.7064332105165, 6584.341565843377, 6633.104530888365, 6454.0, 6454.806355809334, 6460.866479757314, 6480.805575832638, 6498.870022599522, 6262.2172228472355, 6494.577852439576, 6531.8367040823405, 6626.9337306627285, 6647.235567909753, 6238.313785483684, 6292.905606415999, 6306.684665766785, 6316.526260530387, 6386.68066596659, 5932.822015339547, 6211.720472578835, 6212.9068063979985, 6243.469305109116, 6260.311365749855, 6364.331745166691, 6492.837679058061, 6496.577722448026, 6504.317046710027, 6584.176977877765, 4392.934105988476, 4442.111577684541, 4445.177642136216, 4459.331100334975, 4476.529964353696, 6235.75056997715, 6327.430531252209, 6337.9366206337345, 6354.489976459365, 6411.839704007437, 6139.508839292936, 6153.169322141633, 6180.8763824722355, 6181.072839074175, 6233.594816337105, 5958.702064896825, 6128.540359473147, 6163.630182188904, 6166.352532984151, 6172.22847144107, 6077.48341390969, 6093.268807743099, 6111.419415155553, 6118.663473509, 6132.969335153296, 6124.510039196764, 6130.448259656474, 6197.783077592263, 6237.0, 6285.937140628535, 5804.912926306024, 6042.1540984261355, 6047.334793172836, 6059.909101363395, 6064.818055458343], "value": 4634.95310934231, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [769.4575324396301, 804.9034115906088, 841.1042240014384, 875.321625740051, 878.7012415778636, 15121.546353609396, 16091.356345746171, 16145.919270403632, 16236.83763162371, 16273.593160170987, 15853.920730396361, 16075.0, 16075.83924160758, 16128.193590320467, 16140.919295403535, 713.9071920650321, 848.3255811629738, 875.7066382761751, 876.8027193881389, 877.3069275272559, 859.0850743957665, 864.4381152251025, 864.965401383947, 870.0907551608584, 875.4965894610592, 909.0228004894732, 912.4844462878485, 912.9406588571754, 913.808100298938, 916.6241840845255, 900.8873890763655, 901.04489241404, 901.4591245252828, 903.6475774447971, 907.1019690506351, 667.7996601019674, 667.9131712877344, 670.4401824476568, 671.7883866582011, 671.9865602687968, 16526.66946661072, 16529.256183471774, 16530.0, 16553.66892662152, 16593.0, 15049.54851354461, 15689.137097459748, 15876.206189690469, 16422.67154656912, 16728.498145055666, 12048.819267710991, 12061.698457538632, 12073.0, 12133.575324863587, 12243.20419172751, 4196.265653510623, 4228.682848786353, 4229.598188172119, 4262.850800222009, 4264.658827293809, 82132.17867821305, 82857.0, 83000.0, 83519.16480835175, 84861.57569212175, 12493.625191244277, 12726.363681815872, 12818.55135070268, 12829.550965716155, 12969.481220751064, 24108.758912411, 24483.77581120937, 24506.264812055666, 24523.754762452147, 24577.87711061469, 8822.602982865787, 8953.776155596162, 9003.954980225188, 9133.132352426508, 9196.724098277062, 5023.673461225008, 5097.617678674114, 5189.0, 5189.818356357585, 5267.0256002639635, 3798.6771124454176, 3915.197384536163, 3936.6850651947775, 3939.03493644059, 3942.2312649033165, 667.3460009190923, 669.7086767256259, 673.939345458911, 677.4546490075438, 679.4055201698513, 689.9379055884895, 759.4190444310108, 760.0, 760.1638197982176, 773.2499475508747, 10132.645357412603, 10244.334118282437, 10410.5849415656, 10622.787544249226, 10704.983026612459, 659.7361055577711, 660.9372109649576, 730.5105579261907, 781.6052893288853, 809.8582748019073, 4843.4430040545785, 4859.669817190006, 4880.219164933594, 4886.560209581155, 4971.726555039435, 102019.0, 118556.50009745266, 120644.0, 121515.0, 132006.33996830147, 89630.0, 103488.48255758824, 105094.0, 105939.470302648, 106843.0, 87993.56003220071, 89185.55407223052, 89349.55325223332, 93045.0, 93855.53072234595, 9126.817463650557, 9564.086853863697, 9768.006110620448, 9917.950410247902, 10005.349652272578, 52761.0, 54050.18924716211, 54925.45074549203, 54960.450395495536, 56239.43760562342, 75562.62218688871, 83425.0, 84715.0, 85248.0, 85322.57338713267, 13629.478561316366, 13795.310234488436, 13809.51666691661, 13871.167729936236, 14599.92700036493, 15037.248137592858, 15873.285702143663, 15980.121093339978, 16512.25694843759, 16561.917190414453, 15200.771988419961, 15205.847941520444, 15327.386904523693, 15361.846381536041, 15536.0, 14643.487477938646, 14807.777883331973, 15092.16993065392, 15203.695926081638, 15398.46105386306, 14422.278886055865, 14812.407503700162, 14954.0, 15113.622159445662, 15143.167125808186, 11147.832782508107, 11345.886541134812, 11538.423078846192, 11874.643760687193, 12310.876891230973, 11576.421178940851, 11926.284422934652, 11949.820752688891, 11992.520299188283, 12107.152499324962], "value": 8109.849112692399, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1516.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 103.0, 111.0, 113.0, 111.0, 113.0, 112.0, 109.0, 112.0, 108.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 130.0, 156.0, 165.0, 130.0, 160.0, 149.0, 128.0, 180.0, 130.0], "value": 149.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 161.0, 160.0, 161.0, 161.0, 161.0, 167.0, 160.0, 164.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 73.0, 166.0, 78.0, 75.0, 75.0, 75.0, 180.0, 75.0], "value": 94.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 85.0, 143.0, 84.0, 85.0, 85.0, 136.0, 86.0, 85.0, 140.0], "value": 101.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 118.0, 117.0, 118.0, 118.0, 119.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 147.0, 149.0, 147.0, 147.0, 146.0, 147.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 97.0, 96.0, 96.0, 98.0, 96.0, 96.0, 100.0, 95.0], "value": 96.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 53.0, 52.0, 52.0, 52.0, 58.0, 53.0, 51.0, 53.0, 53.0], "value": 52.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 59.0, 61.0, 62.0, 64.0, 64.0, 60.0, 60.0, 64.0, 61.0], "value": 61.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 78.0, 78.0, 79.0, 77.0, 77.0, 78.0, 107.0, 77.0], "value": 80.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 127.0, 127.0, 131.0, 120.0, 118.0, 126.0, 121.0, 132.0, 118.0], "value": 124.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 153.0, 155.0, 152.0, 162.0, 162.0, 153.0, 154.0, 154.0, 155.0], "value": 155.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 63.0, 62.0, 63.0, 62.0, 62.0, 63.0, 63.0, 62.0], "value": 62.4, "unit": "score"}]}]} 16:02:04 INFO - Return code: 0 16:02:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:02:04 ERROR - # TBPL SUCCESS # 16:02:04 INFO - Running post-action listener: _resource_record_post_action 16:02:04 INFO - ##### 16:02:04 INFO - ##### Finished run-tests step (success) 16:02:04 INFO - ##### 16:02:04 INFO - Running post-run listener: _resource_record_post_run 16:02:04 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 266567680; Read time: 12; Write time: 153996 16:02:04 INFO - TinderboxPrint: CPU usage
13.4% 16:02:04 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 16:02:04 INFO - TinderboxPrint: I/O write bytes / time
266,567,680 / 153,996 16:02:04 INFO - TinderboxPrint: CPU idle
8,211.6 (86.6%) 16:02:04 INFO - TinderboxPrint: CPU user
1,213.1 (12.8%) 16:02:04 INFO - TinderboxPrint: Swap in / out
0 / 0 16:02:04 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 13910016; Read time: 0; Write time: 2480 16:02:04 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 248766464; Read time: 12; Write time: 150760 16:02:04 INFO - Running post-run listener: _upload_blobber_files 16:02:04 INFO - Blob upload gear active. 16:02:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:02:04 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:02:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:02:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:02:05 INFO - (blobuploader) - INFO - Open directory for files ... 16:02:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:02:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:02:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:02:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:02:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:02:06 INFO - (blobuploader) - INFO - Done attempting. 16:02:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:02:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:02:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:02:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:02:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:02:09 INFO - (blobuploader) - INFO - Done attempting. 16:02:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:02:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:02:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:02:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:02:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:02:10 INFO - (blobuploader) - INFO - Done attempting. 16:02:10 INFO - (blobuploader) - INFO - Iteration through files over. 16:02:10 INFO - Return code: 0 16:02:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:02:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:02:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/226ab60b735a188bff3a3d442d401eaae24f0e4faa190a603a58f6864f121cb3efb9a7484df197967f8b16410fde2bdfcfa574e61eebf04684d18a7aaaa2f9d8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2196c8e7e9d9b76a03af72f2b0cf89bb0d69a6131b8a37c3cbd6c15da3caf4fe0ae98ed99764be4c166c4fd78bd93b0bbc16c9ea617b746717d52fe19bfbf5cf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e4a1241dc431e9a7bffecdaf89cb2461bccec160c882b50b21faacbde4981952773de7a2caf5218c8925a4a4855c1300677ce7c906ef7e5a66be6579c2a008a6"} 16:02:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:02:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:02:10 INFO - Contents: 16:02:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/226ab60b735a188bff3a3d442d401eaae24f0e4faa190a603a58f6864f121cb3efb9a7484df197967f8b16410fde2bdfcfa574e61eebf04684d18a7aaaa2f9d8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2196c8e7e9d9b76a03af72f2b0cf89bb0d69a6131b8a37c3cbd6c15da3caf4fe0ae98ed99764be4c166c4fd78bd93b0bbc16c9ea617b746717d52fe19bfbf5cf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e4a1241dc431e9a7bffecdaf89cb2461bccec160c882b50b21faacbde4981952773de7a2caf5218c8925a4a4855c1300677ce7c906ef7e5a66be6579c2a008a6"} 16:02:10 INFO - Running post-run listener: copy_logs_to_upload_dir 16:02:10 INFO - Copying logs to upload dir... 16:02:10 INFO - mkdir: /builds/slave/test/build/upload/logs 16:02:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.088105 ========= master_lag: 0.36 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-06-27 16:02:11.126732) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 16:02:11.134550) ========= 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=3a3620fb28aea1604ab609ef000001d2-1467067296.83389-515992898 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/226ab60b735a188bff3a3d442d401eaae24f0e4faa190a603a58f6864f121cb3efb9a7484df197967f8b16410fde2bdfcfa574e61eebf04684d18a7aaaa2f9d8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2196c8e7e9d9b76a03af72f2b0cf89bb0d69a6131b8a37c3cbd6c15da3caf4fe0ae98ed99764be4c166c4fd78bd93b0bbc16c9ea617b746717d52fe19bfbf5cf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e4a1241dc431e9a7bffecdaf89cb2461bccec160c882b50b21faacbde4981952773de7a2caf5218c8925a4a4855c1300677ce7c906ef7e5a66be6579c2a008a6"} build_url:https://queue.taskcluster.net/v1/task/KccG4N1aShm063uDnaMcSw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011395 build_url: 'https://queue.taskcluster.net/v1/task/KccG4N1aShm063uDnaMcSw/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/226ab60b735a188bff3a3d442d401eaae24f0e4faa190a603a58f6864f121cb3efb9a7484df197967f8b16410fde2bdfcfa574e61eebf04684d18a7aaaa2f9d8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2196c8e7e9d9b76a03af72f2b0cf89bb0d69a6131b8a37c3cbd6c15da3caf4fe0ae98ed99764be4c166c4fd78bd93b0bbc16c9ea617b746717d52fe19bfbf5cf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e4a1241dc431e9a7bffecdaf89cb2461bccec160c882b50b21faacbde4981952773de7a2caf5218c8925a4a4855c1300677ce7c906ef7e5a66be6579c2a008a6"}' ========= master_lag: 0.35 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 16:02:11.499956) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 16:02:11.500397) ========= 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=3a3620fb28aea1604ab609ef000001d2-1467067296.83389-515992898 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004415 ========= master_lag: 0.03 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 16:02:11.539457) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 16:02:11.539896) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 16:02:11.544233) ========= ========= Total master_lag: 0.81 =========