builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-059 starttime: 1467193876.23 results: success (0) buildid: 20160629000926 builduid: 6a62e26a3d784a559cfa831962fc9801 revision: c83de296c78d277a35e67cdc950162ee8e75bf39 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 02:51:16.229548) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 02:51:16.230192) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 02:51:16.230859) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 02:51:16.247883) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 02:51:16.248326) ========= 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-1467193874.967769-489965380 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-29 02:51:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 113M=0s 2016-06-29 02:51:16 (113 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.106528 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 02:51:16.370436) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 02:51:16.370814) ========= 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-1467193874.967769-489965380 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018025 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 02:51:16.421371) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 02:51:16.421849) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c83de296c78d277a35e67cdc950162ee8e75bf39 --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 c83de296c78d277a35e67cdc950162ee8e75bf39 --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-1467193874.967769-489965380 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-29 02:51:16,673 truncating revision to first 12 chars 2016-06-29 02:51:16,673 Setting DEBUG logging. 2016-06-29 02:51:16,673 attempt 1/10 2016-06-29 02:51:16,673 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/c83de296c78d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-29 02:51:16,988 unpacking tar archive at: mozilla-aurora-c83de296c78d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.683227 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 02:51:17.120926) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 02:51:17.121581) ========= script_repo_revision: c83de296c78d277a35e67cdc950162ee8e75bf39 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 02:51:17.122217) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 02:51:17.122728) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 02:51:17.133676) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-06-29 02:51:17.134080) ========= /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-1467193874.967769-489965380 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:51:17 INFO - MultiFileLogger online at 20160629 02:51:17 in /builds/slave/test 02:51:17 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 02:51:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:51:17 INFO - {'append_to_log': False, 02:51:17 INFO - 'base_work_dir': '/builds/slave/test', 02:51:17 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:51:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:51:17 INFO - 'branch': 'Mozilla-Aurora', 02:51:17 INFO - 'buildbot_json_path': 'buildprops.json', 02:51:17 INFO - 'config_files': ('talos/linux_config.py',), 02:51:17 INFO - 'default_actions': ('clobber', 02:51:17 INFO - 'read-buildbot-config', 02:51:17 INFO - 'download-and-extract', 02:51:17 INFO - 'populate-webroot', 02:51:17 INFO - 'create-virtualenv', 02:51:17 INFO - 'install', 02:51:17 INFO - 'run-tests'), 02:51:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:51:17 INFO - 'download_minidump_stackwalk': True, 02:51:17 INFO - 'download_symbols': 'ondemand', 02:51:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:51:17 INFO - 'tooltool.py': '/tools/tooltool.py', 02:51:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:51:17 INFO - '/tools/misc-python/virtualenv.py')}, 02:51:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:51:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:51:17 INFO - 'installer_path': 'installer.exe', 02:51:17 INFO - 'log_level': 'info', 02:51:17 INFO - 'log_name': 'talos', 02:51:17 INFO - 'log_to_console': True, 02:51:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:51:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:51:17 INFO - 'opt_config_files': (), 02:51:17 INFO - 'pip_index': False, 02:51:17 INFO - 'sps_profile': False, 02:51:17 INFO - 'sps_profile_interval': 0, 02:51:17 INFO - 'suite': 'dromaeojs-e10s', 02:51:17 INFO - 'system_bits': '32', 02:51:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:51:17 INFO - 'title': 'talos-linux64-ix-059', 02:51:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:51:17 INFO - 'use_talos_json': True, 02:51:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:51:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:51:17 INFO - 'work_dir': 'build'} 02:51:17 INFO - ##### 02:51:17 INFO - ##### Running clobber step. 02:51:17 INFO - ##### 02:51:17 INFO - Running pre-action listener: _resource_record_pre_action 02:51:17 INFO - Running main action method: clobber 02:51:17 INFO - rmtree: /builds/slave/test/build 02:51:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:51:17 INFO - Running post-action listener: _resource_record_post_action 02:51:17 INFO - ##### 02:51:17 INFO - ##### Finished clobber step (success) 02:51:17 INFO - ##### 02:51:17 INFO - ##### 02:51:17 INFO - ##### Running read-buildbot-config step. 02:51:17 INFO - ##### 02:51:17 INFO - Running pre-action listener: _resource_record_pre_action 02:51:17 INFO - Running main action method: read_buildbot_config 02:51:17 INFO - Using buildbot properties: 02:51:17 INFO - { 02:51:17 INFO - "project": "", 02:51:17 INFO - "product": "firefox", 02:51:17 INFO - "script_repo_revision": "production", 02:51:17 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 02:51:17 INFO - "repository": "", 02:51:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 02:51:17 INFO - "buildid": "20160629000926", 02:51:17 INFO - "pgo_build": "True", 02:51:17 INFO - "basedir": "/builds/slave/test", 02:51:17 INFO - "buildnumber": 424, 02:51:17 INFO - "slavename": "talos-linux64-ix-059", 02:51:17 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:51:17 INFO - "platform": "ubuntu64_hw", 02:51:17 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 02:51:17 INFO - "branch": "mozilla-aurora", 02:51:17 INFO - "repo_path": "releases/mozilla-aurora", 02:51:17 INFO - "revision": "c83de296c78d277a35e67cdc950162ee8e75bf39", 02:51:17 INFO - "stage_platform": "linux64-pgo", 02:51:17 INFO - "builduid": "6a62e26a3d784a559cfa831962fc9801", 02:51:17 INFO - "slavebuilddir": "test" 02:51:17 INFO - } 02:51:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/dzEqWNsYQHicKavLnap7RA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 02:51:17 INFO - Running post-action listener: _resource_record_post_action 02:51:17 INFO - ##### 02:51:17 INFO - ##### Finished read-buildbot-config step (success) 02:51:17 INFO - ##### 02:51:17 INFO - ##### 02:51:17 INFO - ##### Running download-and-extract step. 02:51:17 INFO - ##### 02:51:17 INFO - Running pre-action listener: _resource_record_pre_action 02:51:17 INFO - Running main action method: download_and_extract 02:51:17 INFO - mkdir: /builds/slave/test/build/tests 02:51:17 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')]} 02:51:17 INFO - https://queue.taskcluster.net/v1/task/dzEqWNsYQHicKavLnap7RA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:51:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dzEqWNsYQHicKavLnap7RA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 02:51:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dzEqWNsYQHicKavLnap7RA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 02:51:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dzEqWNsYQHicKavLnap7RA/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 02:51:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dzEqWNsYQHicKavLnap7RA/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 02:51:18 INFO - Downloaded 1361 bytes. 02:51:18 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 02:51:18 INFO - Using the following test package requirements: 02:51:18 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 02:51:18 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:51:18 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 02:51:18 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:51:18 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 02:51:18 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:51:18 INFO - u'jsshell-linux-x86_64.zip'], 02:51:18 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:51:18 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 02:51:18 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 02:51:18 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:51:18 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 02:51:18 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:51:18 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 02:51:18 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:51:18 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 02:51:18 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:51:18 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 02:51:18 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:51:18 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')]} 02:51:18 INFO - https://queue.taskcluster.net/v1/task/dzEqWNsYQHicKavLnap7RA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:51:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dzEqWNsYQHicKavLnap7RA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 02:51:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dzEqWNsYQHicKavLnap7RA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 02:51:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dzEqWNsYQHicKavLnap7RA/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 02:51:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dzEqWNsYQHicKavLnap7RA/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 02:51:19 INFO - Downloaded 24524198 bytes. 02:51:19 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'] 02:51:19 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 02:51:20 INFO - Return code: 0 02:51:20 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 02:51:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:20 INFO - https://queue.taskcluster.net/v1/task/dzEqWNsYQHicKavLnap7RA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:51:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dzEqWNsYQHicKavLnap7RA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 02:51:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dzEqWNsYQHicKavLnap7RA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 02:51:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dzEqWNsYQHicKavLnap7RA/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 02:51:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dzEqWNsYQHicKavLnap7RA/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 02:51:22 INFO - Downloaded 24524198 bytes. 02:51:22 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'] 02:51:22 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 02:51:23 INFO - Return code: 0 02:51:23 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')]} 02:51:23 INFO - https://queue.taskcluster.net/v1/task/dzEqWNsYQHicKavLnap7RA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:51:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dzEqWNsYQHicKavLnap7RA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 02:51:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dzEqWNsYQHicKavLnap7RA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 02:51:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dzEqWNsYQHicKavLnap7RA/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 02:51:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dzEqWNsYQHicKavLnap7RA/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 02:51:24 INFO - Downloaded 10833369 bytes. 02:51:24 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'] 02:51:24 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 02:51:24 INFO - Return code: 0 02:51:24 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')]} 02:51:24 INFO - https://queue.taskcluster.net/v1/task/dzEqWNsYQHicKavLnap7RA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:51:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dzEqWNsYQHicKavLnap7RA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 02:51:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dzEqWNsYQHicKavLnap7RA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 02:51:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dzEqWNsYQHicKavLnap7RA/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 02:51:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dzEqWNsYQHicKavLnap7RA/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 02:51:26 INFO - Downloaded 63608570 bytes. 02:51:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dzEqWNsYQHicKavLnap7RA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 02:51:26 INFO - mkdir: /builds/slave/test/properties 02:51:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:51:26 INFO - Writing to file /builds/slave/test/properties/build_url 02:51:26 INFO - Contents: 02:51:26 INFO - build_url:https://queue.taskcluster.net/v1/task/dzEqWNsYQHicKavLnap7RA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 02:51:27 INFO - Running post-action listener: _resource_record_post_action 02:51:27 INFO - Running post-action listener: set_extra_try_arguments 02:51:27 INFO - ##### 02:51:27 INFO - ##### Finished download-and-extract step (success) 02:51:27 INFO - ##### 02:51:27 INFO - ##### 02:51:27 INFO - ##### Running populate-webroot step. 02:51:27 INFO - ##### 02:51:27 INFO - Running pre-action listener: _resource_record_pre_action 02:51:27 INFO - Running main action method: populate_webroot 02:51:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:51:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:51:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:51:27 INFO - '--tppagecycles', 02:51:27 INFO - '7'], 02:51:27 INFO - 'tests': ['tsvgm']}}, 02:51:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:51:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:51:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:51:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:51:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:51:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:51:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:51:27 INFO - 'talos_options': ['--disable-e10s'], 02:51:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:51:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:51:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:51:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:51:27 INFO - 'talos_options': ['--disable-e10s'], 02:51:27 INFO - 'tests': ['damp', 'tps']}, 02:51:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:51:27 INFO - 'tests': ['damp', 'tps']}, 02:51:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:51:27 INFO - 'tests': ['dromaeo_dom']}, 02:51:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:51:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:51:27 INFO - 'tests': ['a11yr', 02:51:27 INFO - 'ts_paint', 02:51:27 INFO - 'tpaint', 02:51:27 INFO - 'sessionrestore', 02:51:27 INFO - 'sessionrestore_no_auto_restore', 02:51:27 INFO - 'tabpaint']}, 02:51:27 INFO - 'other-e10s': {'tests': ['a11yr', 02:51:27 INFO - 'ts_paint', 02:51:27 INFO - 'tpaint', 02:51:27 INFO - 'sessionrestore', 02:51:27 INFO - 'sessionrestore_no_auto_restore', 02:51:27 INFO - 'tabpaint']}, 02:51:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:51:27 INFO - 'ts_paint', 02:51:27 INFO - 'tpaint', 02:51:27 INFO - 'sessionrestore', 02:51:27 INFO - 'sessionrestore_no_auto_restore', 02:51:27 INFO - 'tabpaint']}, 02:51:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:51:27 INFO - 'ts_paint', 02:51:27 INFO - 'tpaint', 02:51:27 INFO - 'sessionrestore', 02:51:27 INFO - 'sessionrestore_no_auto_restore', 02:51:27 INFO - 'tabpaint']}, 02:51:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:51:27 INFO - 'tests': ['a11yr', 02:51:27 INFO - 'ts_paint', 02:51:27 INFO - 'tpaint', 02:51:27 INFO - 'sessionrestore', 02:51:27 INFO - 'sessionrestore_no_auto_restore', 02:51:27 INFO - 'tabpaint']}, 02:51:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:51:27 INFO - 'tests': ['a11yr', 02:51:27 INFO - 'ts_paint', 02:51:27 INFO - 'tpaint', 02:51:27 INFO - 'sessionrestore', 02:51:27 INFO - 'sessionrestore_no_auto_restore', 02:51:27 INFO - 'tabpaint']}, 02:51:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:51:27 INFO - 'tests': ['tsvgx', 02:51:27 INFO - 'tsvgr_opacity', 02:51:27 INFO - 'tart', 02:51:27 INFO - 'tscrollx', 02:51:27 INFO - 'cart']}, 02:51:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:51:27 INFO - 'tsvgr_opacity', 02:51:27 INFO - 'tart', 02:51:27 INFO - 'tscrollx', 02:51:27 INFO - 'cart']}, 02:51:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:51:27 INFO - 'talos_options': ['--disable-e10s'], 02:51:27 INFO - 'tests': ['tp5o']}, 02:51:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:51:27 INFO - 'tests': ['tp5o']}, 02:51:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:51:27 INFO - 'talos_options': ['--disable-e10s', 02:51:27 INFO - '--xperf_path', 02:51:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:51:27 INFO - 'tests': ['tp5n']}, 02:51:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:51:27 INFO - 'talos_options': ['--xperf_path', 02:51:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:51:27 INFO - 'tests': ['tp5n']}}, 02:51:27 INFO - 'talos.zip': {'path': '', 02:51:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:51:27 INFO - Running post-action listener: _resource_record_post_action 02:51:27 INFO - ##### 02:51:27 INFO - ##### Finished populate-webroot step (success) 02:51:27 INFO - ##### 02:51:27 INFO - ##### 02:51:27 INFO - ##### Running create-virtualenv step. 02:51:27 INFO - ##### 02:51:27 INFO - Running pre-action listener: _resource_record_pre_action 02:51:27 INFO - Running main action method: create_virtualenv 02:51:27 INFO - Creating virtualenv /builds/slave/test/build/venv 02:51:27 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 02:51:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:51:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:51:27 INFO - Using real prefix '/usr' 02:51:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:51:28 INFO - Installing distribute.............................................................................................................................................................................................done. 02:51:30 INFO - Installing pip.................done. 02:51:30 INFO - Return code: 0 02:51:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:51:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:30 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 0x7fe3e45baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c3f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cce1c0>, '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 0x2ccf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ccf550>, '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-1467193874.967769-489965380', '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 02:51:30 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 02:51:30 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 02:51:30 INFO - Using env: {'DISPLAY': ':0', 02:51:30 INFO - 'HOME': '/home/cltbld', 02:51:30 INFO - 'LANG': 'en_US.UTF-8', 02:51:30 INFO - 'LANGUAGE': 'en_US:en', 02:51:30 INFO - 'LOGNAME': 'cltbld', 02:51:30 INFO - 'MAIL': '/var/mail/cltbld', 02:51:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:30 INFO - 'MOZ_NO_REMOTE': '1', 02:51:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:51:30 INFO - 'NO_EM_RESTART': '1', 02:51:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:51:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:30 INFO - 'PWD': '/builds/slave/test', 02:51:30 INFO - 'SHELL': '/bin/bash', 02:51:30 INFO - 'SHLVL': '1', 02:51:30 INFO - 'TERM': 'linux', 02:51:30 INFO - 'TMOUT': '86400', 02:51:30 INFO - 'USER': 'cltbld', 02:51:30 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1467193874.967769-489965380', 02:51:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:30 INFO - '_': '/tools/buildbot/bin/python'} 02:51:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:30 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 02:51:30 INFO - Cleaning up... 02:51:30 INFO - Return code: 0 02:51:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:51:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:30 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 0x7fe3e45baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c3f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cce1c0>, '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 0x2ccf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ccf550>, '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-1467193874.967769-489965380', '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 02:51:30 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 02:51:30 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 02:51:30 INFO - Using env: {'DISPLAY': ':0', 02:51:30 INFO - 'HOME': '/home/cltbld', 02:51:30 INFO - 'LANG': 'en_US.UTF-8', 02:51:30 INFO - 'LANGUAGE': 'en_US:en', 02:51:30 INFO - 'LOGNAME': 'cltbld', 02:51:30 INFO - 'MAIL': '/var/mail/cltbld', 02:51:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:30 INFO - 'MOZ_NO_REMOTE': '1', 02:51:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:51:30 INFO - 'NO_EM_RESTART': '1', 02:51:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:51:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:30 INFO - 'PWD': '/builds/slave/test', 02:51:30 INFO - 'SHELL': '/bin/bash', 02:51:30 INFO - 'SHLVL': '1', 02:51:30 INFO - 'TERM': 'linux', 02:51:30 INFO - 'TMOUT': '86400', 02:51:30 INFO - 'USER': 'cltbld', 02:51:30 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1467193874.967769-489965380', 02:51:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:30 INFO - '_': '/tools/buildbot/bin/python'} 02:51:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:30 INFO - Downloading/unpacking psutil>=3.1.1 02:51:30 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 02:51:30 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 02:51:30 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 02:51:30 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 02:51:30 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 02:51:30 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 02:51:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:51:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:51:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:51:32 INFO - Installing collected packages: psutil 02:51:32 INFO - Running setup.py install for psutil 02:51:32 INFO - building 'psutil._psutil_linux' extension 02:51:32 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 02:51:32 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 02:51:32 INFO - building 'psutil._psutil_posix' extension 02:51:32 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 02:51:32 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 02:51:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:51:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:51:33 INFO - Successfully installed psutil 02:51:33 INFO - Cleaning up... 02:51:33 INFO - Return code: 0 02:51:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:51:33 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')]} 02:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:33 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')]} 02:51:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:33 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 0x7fe3e45baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c3f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cce1c0>, '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 0x2ccf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ccf550>, '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-1467193874.967769-489965380', '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 02:51:33 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 02:51:33 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 02:51:33 INFO - Using env: {'DISPLAY': ':0', 02:51:33 INFO - 'HOME': '/home/cltbld', 02:51:33 INFO - 'LANG': 'en_US.UTF-8', 02:51:33 INFO - 'LANGUAGE': 'en_US:en', 02:51:33 INFO - 'LOGNAME': 'cltbld', 02:51:33 INFO - 'MAIL': '/var/mail/cltbld', 02:51:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:33 INFO - 'MOZ_NO_REMOTE': '1', 02:51:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:51:33 INFO - 'NO_EM_RESTART': '1', 02:51:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:51:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:33 INFO - 'PWD': '/builds/slave/test', 02:51:33 INFO - 'SHELL': '/bin/bash', 02:51:33 INFO - 'SHLVL': '1', 02:51:33 INFO - 'TERM': 'linux', 02:51:33 INFO - 'TMOUT': '86400', 02:51:33 INFO - 'USER': 'cltbld', 02:51:33 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1467193874.967769-489965380', 02:51:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:33 INFO - '_': '/tools/buildbot/bin/python'} 02:51:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:51:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:51:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:51:35 INFO - Installing collected packages: mozsystemmonitor 02:51:35 INFO - Running setup.py install for mozsystemmonitor 02:51:35 INFO - Successfully installed mozsystemmonitor 02:51:35 INFO - Cleaning up... 02:51:35 INFO - Return code: 0 02:51:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:51:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:35 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 0x7fe3e45baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c3f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cce1c0>, '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 0x2ccf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ccf550>, '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-1467193874.967769-489965380', '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 02:51:35 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 02:51:35 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 02:51:35 INFO - Using env: {'DISPLAY': ':0', 02:51:35 INFO - 'HOME': '/home/cltbld', 02:51:35 INFO - 'LANG': 'en_US.UTF-8', 02:51:35 INFO - 'LANGUAGE': 'en_US:en', 02:51:35 INFO - 'LOGNAME': 'cltbld', 02:51:35 INFO - 'MAIL': '/var/mail/cltbld', 02:51:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:35 INFO - 'MOZ_NO_REMOTE': '1', 02:51:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:51:35 INFO - 'NO_EM_RESTART': '1', 02:51:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:51:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:35 INFO - 'PWD': '/builds/slave/test', 02:51:35 INFO - 'SHELL': '/bin/bash', 02:51:35 INFO - 'SHLVL': '1', 02:51:35 INFO - 'TERM': 'linux', 02:51:35 INFO - 'TMOUT': '86400', 02:51:35 INFO - 'USER': 'cltbld', 02:51:35 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1467193874.967769-489965380', 02:51:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:35 INFO - '_': '/tools/buildbot/bin/python'} 02:51:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:35 INFO - Downloading/unpacking jsonschema==2.5.1 02:51:35 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 02:51:35 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 02:51:35 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 02:51:35 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 02:51:35 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 02:51:35 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 02:51:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:51:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:51:37 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 02:51:37 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 02:51:37 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 02:51:37 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 02:51:37 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 02:51:37 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 02:51:37 INFO - Downloading functools32-3.2.3-2.tar.gz 02:51:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:51:37 INFO - warning: no files found matching '*.txt' 02:51:37 INFO - no previously-included directories found matching 'build' 02:51:37 INFO - no previously-included directories found matching 'dist' 02:51:37 INFO - no previously-included directories found matching '.git*' 02:51:37 INFO - Installing collected packages: jsonschema, functools32 02:51:37 INFO - Running setup.py install for functools32 02:51:37 INFO - warning: no files found matching '*.txt' 02:51:37 INFO - no previously-included directories found matching 'build' 02:51:37 INFO - no previously-included directories found matching 'dist' 02:51:37 INFO - no previously-included directories found matching '.git*' 02:51:37 INFO - Successfully installed jsonschema functools32 02:51:37 INFO - Cleaning up... 02:51:37 INFO - Return code: 0 02:51:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:51:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:37 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 0x7fe3e45baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c3f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cce1c0>, '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 0x2ccf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ccf550>, '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-1467193874.967769-489965380', '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 02:51:37 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 02:51:37 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 02:51:37 INFO - Using env: {'DISPLAY': ':0', 02:51:37 INFO - 'HOME': '/home/cltbld', 02:51:37 INFO - 'LANG': 'en_US.UTF-8', 02:51:37 INFO - 'LANGUAGE': 'en_US:en', 02:51:37 INFO - 'LOGNAME': 'cltbld', 02:51:37 INFO - 'MAIL': '/var/mail/cltbld', 02:51:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:37 INFO - 'MOZ_NO_REMOTE': '1', 02:51:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:51:37 INFO - 'NO_EM_RESTART': '1', 02:51:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:51:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:37 INFO - 'PWD': '/builds/slave/test', 02:51:37 INFO - 'SHELL': '/bin/bash', 02:51:37 INFO - 'SHLVL': '1', 02:51:37 INFO - 'TERM': 'linux', 02:51:37 INFO - 'TMOUT': '86400', 02:51:37 INFO - 'USER': 'cltbld', 02:51:37 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1467193874.967769-489965380', 02:51:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:37 INFO - '_': '/tools/buildbot/bin/python'} 02:51:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:38 INFO - Downloading/unpacking blobuploader==1.2.4 02:51:38 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 02:51:38 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 02:51:38 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 02:51:38 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 02:51:38 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 02:51:38 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 02:51:40 INFO - Downloading blobuploader-1.2.4.tar.gz 02:51:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:51:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:51:40 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 02:51:40 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 02:51:40 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 02:51:40 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 02:51:40 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 02:51:40 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 02:51:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:51:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:51:40 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 02:51:40 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 02:51:40 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 02:51:40 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 02:51:40 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 02:51:40 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 02:51:40 INFO - Downloading docopt-0.6.1.tar.gz 02:51:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:51:40 INFO - Installing collected packages: blobuploader, requests, docopt 02:51:40 INFO - Running setup.py install for blobuploader 02:51:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:51:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:51:40 INFO - Running setup.py install for requests 02:51:41 INFO - Running setup.py install for docopt 02:51:41 INFO - Successfully installed blobuploader requests docopt 02:51:41 INFO - Cleaning up... 02:51:41 INFO - Return code: 0 02:51:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:51:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:41 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 0x7fe3e45baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c3f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cce1c0>, '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 0x2ccf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ccf550>, '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-1467193874.967769-489965380', '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 02:51:41 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 02:51:41 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 02:51:41 INFO - Using env: {'DISPLAY': ':0', 02:51:41 INFO - 'HOME': '/home/cltbld', 02:51:41 INFO - 'LANG': 'en_US.UTF-8', 02:51:41 INFO - 'LANGUAGE': 'en_US:en', 02:51:41 INFO - 'LOGNAME': 'cltbld', 02:51:41 INFO - 'MAIL': '/var/mail/cltbld', 02:51:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:41 INFO - 'MOZ_NO_REMOTE': '1', 02:51:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:51:41 INFO - 'NO_EM_RESTART': '1', 02:51:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:51:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:41 INFO - 'PWD': '/builds/slave/test', 02:51:41 INFO - 'SHELL': '/bin/bash', 02:51:41 INFO - 'SHLVL': '1', 02:51:41 INFO - 'TERM': 'linux', 02:51:41 INFO - 'TMOUT': '86400', 02:51:41 INFO - 'USER': 'cltbld', 02:51:41 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1467193874.967769-489965380', 02:51:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:41 INFO - '_': '/tools/buildbot/bin/python'} 02:51:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:51:41 INFO - Running setup.py (path:/tmp/pip-6k457W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:51:41 INFO - Running setup.py (path:/tmp/pip-xzrrSV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:51:41 INFO - Running setup.py (path:/tmp/pip-eU_8VY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:51:41 INFO - Running setup.py (path:/tmp/pip-aBPXtt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:51:41 INFO - Running setup.py (path:/tmp/pip-8suqG0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:51:42 INFO - Running setup.py (path:/tmp/pip-fOrbrG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:51:42 INFO - Running setup.py (path:/tmp/pip-qtISPv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:51:42 INFO - Running setup.py (path:/tmp/pip-FmIv2z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:51:42 INFO - Running setup.py (path:/tmp/pip-L06zEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:51:42 INFO - Running setup.py (path:/tmp/pip-TUPoQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:51:42 INFO - Running setup.py (path:/tmp/pip-raWaxa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:51:42 INFO - Running setup.py (path:/tmp/pip-cwCBhg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:51:42 INFO - Running setup.py (path:/tmp/pip-wF2Bxl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:51:42 INFO - Running setup.py (path:/tmp/pip-1GBgMI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:51:42 INFO - Running setup.py (path:/tmp/pip-Dnj93w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:51:42 INFO - Running setup.py (path:/tmp/pip-4l7I_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:51:42 INFO - Running setup.py (path:/tmp/pip-2q43i8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:51:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:51:42 INFO - Running setup.py install for manifestparser 02:51:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:51:43 INFO - Running setup.py install for mozcrash 02:51:43 INFO - Running setup.py install for mozdebug 02:51:43 INFO - Running setup.py install for mozdevice 02:51:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:51:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:51:43 INFO - Running setup.py install for mozfile 02:51:43 INFO - Running setup.py install for mozhttpd 02:51:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:51:43 INFO - Running setup.py install for mozinfo 02:51:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:51:43 INFO - Running setup.py install for mozInstall 02:51:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:51:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:51:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:51:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:51:43 INFO - Running setup.py install for mozleak 02:51:43 INFO - Running setup.py install for mozlog 02:51:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:51:43 INFO - Running setup.py install for moznetwork 02:51:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:51:44 INFO - Running setup.py install for mozprocess 02:51:44 INFO - Running setup.py install for mozprofile 02:51:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:51:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:51:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:51:44 INFO - Running setup.py install for mozrunner 02:51:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:51:44 INFO - Running setup.py install for mozscreenshot 02:51:44 INFO - Running setup.py install for moztest 02:51:44 INFO - Running setup.py install for mozversion 02:51:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:51:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:51:44 INFO - Cleaning up... 02:51:44 INFO - Return code: 0 02:51:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:51:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:44 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 0x7fe3e45baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c3f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cce1c0>, '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 0x2ccf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ccf550>, '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-1467193874.967769-489965380', '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 02:51:44 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 02:51:44 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 02:51:44 INFO - Using env: {'DISPLAY': ':0', 02:51:44 INFO - 'HOME': '/home/cltbld', 02:51:44 INFO - 'LANG': 'en_US.UTF-8', 02:51:44 INFO - 'LANGUAGE': 'en_US:en', 02:51:44 INFO - 'LOGNAME': 'cltbld', 02:51:44 INFO - 'MAIL': '/var/mail/cltbld', 02:51:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:44 INFO - 'MOZ_NO_REMOTE': '1', 02:51:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:51:44 INFO - 'NO_EM_RESTART': '1', 02:51:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:51:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:44 INFO - 'PWD': '/builds/slave/test', 02:51:44 INFO - 'SHELL': '/bin/bash', 02:51:44 INFO - 'SHLVL': '1', 02:51:44 INFO - 'TERM': 'linux', 02:51:44 INFO - 'TMOUT': '86400', 02:51:44 INFO - 'USER': 'cltbld', 02:51:44 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1467193874.967769-489965380', 02:51:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:44 INFO - '_': '/tools/buildbot/bin/python'} 02:51:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:51:44 INFO - Running setup.py (path:/tmp/pip-rBFxPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:51:44 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)) 02:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:51:44 INFO - Running setup.py (path:/tmp/pip-6RXiWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:51:45 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)) 02:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:51:45 INFO - Running setup.py (path:/tmp/pip-EQefAQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:51:45 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)) 02:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:51:45 INFO - Running setup.py (path:/tmp/pip-6uwUo3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:51:45 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)) 02:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:51:45 INFO - Running setup.py (path:/tmp/pip-gtjWco-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:51:45 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)) 02:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:51:45 INFO - Running setup.py (path:/tmp/pip-c0NZgn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:51:45 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)) 02:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:51:45 INFO - Running setup.py (path:/tmp/pip-AwNO83-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:51:45 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)) 02:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:51:45 INFO - Running setup.py (path:/tmp/pip-HEOi0s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:51:45 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)) 02:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:51:45 INFO - Running setup.py (path:/tmp/pip-vhRA0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:51:45 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)) 02:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:51:45 INFO - Running setup.py (path:/tmp/pip-9kkc30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:51:45 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)) 02:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:51:45 INFO - Running setup.py (path:/tmp/pip-o5Q_3q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:51:45 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)) 02:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:51:45 INFO - Running setup.py (path:/tmp/pip-dSevi_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:51:45 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)) 02:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:51:45 INFO - Running setup.py (path:/tmp/pip-ZaXjTb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:51:45 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)) 02:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:51:45 INFO - Running setup.py (path:/tmp/pip-ZMHo4Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:51:45 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)) 02:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:51:45 INFO - Running setup.py (path:/tmp/pip-kyNePT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:51:46 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)) 02:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:51:46 INFO - Running setup.py (path:/tmp/pip-pQ90gg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:51:46 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)) 02:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:51:46 INFO - Running setup.py (path:/tmp/pip-yVvQ8X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:51:46 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)) 02:51:46 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)) 02:51:46 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)) 02:51:46 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)) 02:51:46 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)) 02:51:46 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)) 02:51:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:51:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:48 INFO - Downloading blessings-1.6.tar.gz 02:51:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:51:48 INFO - Installing collected packages: blessings 02:51:48 INFO - Running setup.py install for blessings 02:51:48 INFO - Successfully installed blessings 02:51:48 INFO - Cleaning up... 02:51:48 INFO - Return code: 0 02:51:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:51:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:51:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:51:48 INFO - Reading from file tmpfile_stdout 02:51:48 INFO - Current package versions: 02:51:48 INFO - argparse == 1.2.1 02:51:48 INFO - blessings == 1.6 02:51:48 INFO - blobuploader == 1.2.4 02:51:48 INFO - docopt == 0.6.1 02:51:48 INFO - functools32 == 3.2.3-2 02:51:48 INFO - jsonschema == 2.5.1 02:51:48 INFO - manifestparser == 1.1 02:51:48 INFO - mozInstall == 1.12 02:51:48 INFO - mozcrash == 0.17 02:51:48 INFO - mozdebug == 0.1 02:51:48 INFO - mozdevice == 0.48 02:51:48 INFO - mozfile == 1.2 02:51:48 INFO - mozhttpd == 0.7 02:51:48 INFO - mozinfo == 0.9 02:51:48 INFO - mozleak == 0.1 02:51:48 INFO - mozlog == 3.2 02:51:48 INFO - moznetwork == 0.27 02:51:48 INFO - mozprocess == 0.22 02:51:48 INFO - mozprofile == 0.28 02:51:48 INFO - mozrunner == 6.11 02:51:48 INFO - mozscreenshot == 0.1 02:51:48 INFO - mozsystemmonitor == 0.3 02:51:48 INFO - moztest == 0.7 02:51:48 INFO - mozversion == 1.4 02:51:48 INFO - psutil == 3.1.1 02:51:48 INFO - requests == 1.2.3 02:51:48 INFO - wsgiref == 0.1.2 02:51:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:51:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:48 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 0x7fe3e45baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c3f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cce1c0>, '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 0x2ccf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ccf550>, '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-1467193874.967769-489965380', '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 02:51:48 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 02:51:48 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 02:51:48 INFO - Using env: {'DISPLAY': ':0', 02:51:48 INFO - 'HOME': '/home/cltbld', 02:51:48 INFO - 'LANG': 'en_US.UTF-8', 02:51:48 INFO - 'LANGUAGE': 'en_US:en', 02:51:48 INFO - 'LOGNAME': 'cltbld', 02:51:48 INFO - 'MAIL': '/var/mail/cltbld', 02:51:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:48 INFO - 'MOZ_NO_REMOTE': '1', 02:51:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:51:48 INFO - 'NO_EM_RESTART': '1', 02:51:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:51:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:48 INFO - 'PWD': '/builds/slave/test', 02:51:48 INFO - 'SHELL': '/bin/bash', 02:51:48 INFO - 'SHLVL': '1', 02:51:48 INFO - 'TERM': 'linux', 02:51:48 INFO - 'TMOUT': '86400', 02:51:48 INFO - 'USER': 'cltbld', 02:51:48 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1467193874.967769-489965380', 02:51:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:48 INFO - '_': '/tools/buildbot/bin/python'} 02:51:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:48 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)) 02:51:48 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)) 02:51:48 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)) 02:51:48 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)) 02:51:48 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)) 02:51:48 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)) 02:51:48 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)) 02:51:48 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)) 02:51:48 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)) 02:51:48 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)) 02:51:48 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)) 02:51:48 INFO - Cleaning up... 02:51:48 INFO - Return code: 0 02:51:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:51:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3e45baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c3f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cce1c0>, '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 0x2ccf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ccf550>, '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-1467193874.967769-489965380', '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 02:51:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:51:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:51:48 INFO - Using env: {'DISPLAY': ':0', 02:51:48 INFO - 'HOME': '/home/cltbld', 02:51:48 INFO - 'LANG': 'en_US.UTF-8', 02:51:48 INFO - 'LANGUAGE': 'en_US:en', 02:51:48 INFO - 'LOGNAME': 'cltbld', 02:51:48 INFO - 'MAIL': '/var/mail/cltbld', 02:51:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:48 INFO - 'MOZ_NO_REMOTE': '1', 02:51:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:51:48 INFO - 'NO_EM_RESTART': '1', 02:51:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:51:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:48 INFO - 'PWD': '/builds/slave/test', 02:51:48 INFO - 'SHELL': '/bin/bash', 02:51:48 INFO - 'SHLVL': '1', 02:51:48 INFO - 'TERM': 'linux', 02:51:48 INFO - 'TMOUT': '86400', 02:51:48 INFO - 'USER': 'cltbld', 02:51:48 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1467193874.967769-489965380', 02:51:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:48 INFO - '_': '/tools/buildbot/bin/python'} 02:51:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:51:48 INFO - Cleaning up... 02:51:48 INFO - Return code: 0 02:51:48 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:51:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:51:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:51:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:51:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:51:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3e45baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c3f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cce1c0>, '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 0x2ccf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ccf550>, '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-1467193874.967769-489965380', '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 02:51:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 02:51:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 02:51:48 INFO - Using env: {'DISPLAY': ':0', 02:51:48 INFO - 'HOME': '/home/cltbld', 02:51:48 INFO - 'LANG': 'en_US.UTF-8', 02:51:48 INFO - 'LANGUAGE': 'en_US:en', 02:51:48 INFO - 'LOGNAME': 'cltbld', 02:51:48 INFO - 'MAIL': '/var/mail/cltbld', 02:51:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:51:48 INFO - 'MOZ_NO_REMOTE': '1', 02:51:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:51:48 INFO - 'NO_EM_RESTART': '1', 02:51:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:51:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:51:48 INFO - 'PWD': '/builds/slave/test', 02:51:48 INFO - 'SHELL': '/bin/bash', 02:51:48 INFO - 'SHLVL': '1', 02:51:48 INFO - 'TERM': 'linux', 02:51:48 INFO - 'TMOUT': '86400', 02:51:48 INFO - 'USER': 'cltbld', 02:51:48 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1467193874.967769-489965380', 02:51:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:51:48 INFO - '_': '/tools/buildbot/bin/python'} 02:51:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:51:49 INFO - Downloading/unpacking flake8 02:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:51 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:51:51 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:51:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:51 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:51:51 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:51:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:51 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:51:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:51:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:51:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:51:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:51:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:51:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:51:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:51:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:51:51 INFO - no previously-included directories found matching 'docs/_build' 02:51:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:51:51 INFO - Running setup.py install for pep8 02:51:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:51:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:51:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:51:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:51:51 INFO - no previously-included directories found matching 'docs/_build' 02:51:51 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:51:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:51:51 INFO - Cleaning up... 02:51:52 INFO - Return code: 0 02:51:52 INFO - Running post-action listener: _resource_record_post_action 02:51:52 INFO - Running post-action listener: _start_resource_monitoring 02:51:52 INFO - Starting resource monitoring. 02:51:52 INFO - ##### 02:51:52 INFO - ##### Finished create-virtualenv step (success) 02:51:52 INFO - ##### 02:51:52 INFO - ##### 02:51:52 INFO - ##### Running install step. 02:51:52 INFO - ##### 02:51:52 INFO - Running pre-action listener: _resource_record_pre_action 02:51:52 INFO - Running main action method: install 02:51:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:51:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:51:52 INFO - Reading from file tmpfile_stdout 02:51:52 INFO - Detecting whether we're running mozinstall >=1.0... 02:51:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:51:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:51:52 INFO - Reading from file tmpfile_stdout 02:51:52 INFO - Output received: 02:51:52 INFO - Usage: mozinstall [options] installer 02:51:52 INFO - Options: 02:51:52 INFO - -h, --help show this help message and exit 02:51:52 INFO - -d DEST, --destination=DEST 02:51:52 INFO - Directory to install application into. [default: 02:51:52 INFO - "/builds/slave/test"] 02:51:52 INFO - --app=APP Application being installed. [default: firefox] 02:51:52 INFO - mkdir: /builds/slave/test/build/application 02:51:52 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'] 02:51:52 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 02:52:08 INFO - Reading from file tmpfile_stdout 02:52:08 INFO - Output received: 02:52:08 INFO - /builds/slave/test/build/application/firefox/firefox 02:52:08 INFO - Running post-action listener: _resource_record_post_action 02:52:08 INFO - ##### 02:52:08 INFO - ##### Finished install step (success) 02:52:08 INFO - ##### 02:52:08 INFO - ##### 02:52:08 INFO - ##### Running run-tests step. 02:52:08 INFO - ##### 02:52:08 INFO - Running pre-action listener: _resource_record_pre_action 02:52:08 INFO - Running main action method: run_tests 02:52:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:52:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:52:08 INFO - Python 2.7.3 02:52:08 INFO - Return code: 0 02:52:08 INFO - grabbing minidump binary from tooltool 02:52: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')]} 02:52:08 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 0x2cce1c0>, '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 0x2ccf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ccf550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:52:08 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 02:52:08 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 02:52:08 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 02:52:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:52:08 INFO - Return code: 0 02:52:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:52:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:52:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:52:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:52:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:52:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:52:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:52:09 INFO - Return code: 0 02:52:09 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/dzEqWNsYQHicKavLnap7RA/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 02:52:09 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/dzEqWNsYQHicKavLnap7RA/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 02:52:09 INFO - Using env: {'DISPLAY': ':0', 02:52:09 INFO - 'HOME': '/home/cltbld', 02:52:09 INFO - 'LANG': 'en_US.UTF-8', 02:52:09 INFO - 'LANGUAGE': 'en_US:en', 02:52:09 INFO - 'LOGNAME': 'cltbld', 02:52:09 INFO - 'MAIL': '/var/mail/cltbld', 02:52:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:52:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:52:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:09 INFO - 'MOZ_NO_REMOTE': '1', 02:52:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:52:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:52:09 INFO - 'NO_EM_RESTART': '1', 02:52:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:52:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:09 INFO - 'PWD': '/builds/slave/test', 02:52:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:52:09 INFO - 'SHELL': '/bin/bash', 02:52:09 INFO - 'SHLVL': '1', 02:52:09 INFO - 'TERM': 'linux', 02:52:09 INFO - 'TMOUT': '86400', 02:52:09 INFO - 'USER': 'cltbld', 02:52:09 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1467193874.967769-489965380', 02:52:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:09 INFO - '_': '/tools/buildbot/bin/python'} 02:52:09 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/dzEqWNsYQHicKavLnap7RA/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 02:52:09 INFO - mozversion application_buildid: 20160629000926 02:52:09 INFO - mozversion application_changeset: c83de296c78d277a35e67cdc950162ee8e75bf39 02:52:09 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:52:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:52:09 INFO - mozversion application_name: Firefox 02:52:09 INFO - mozversion application_remotingname: firefox-dev 02:52:09 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:52:09 INFO - mozversion application_vendor: Mozilla 02:52:09 INFO - mozversion application_version: 49.0a2 02:52:09 INFO - mozversion platform_buildid: 20160629000926 02:52:09 INFO - mozversion platform_changeset: c83de296c78d277a35e67cdc950162ee8e75bf39 02:52:09 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:52:09 INFO - mozversion platform_version: 49.0a2 02:52:09 INFO - using testdate: 1467193929 02:52:09 INFO - actual date: 1467193929 02:52:09 INFO - starting webserver on 'localhost:49511' 02:52:09 INFO - SUITE-START | Running 2 tests 02:52:09 INFO - TEST-START | dromaeo_css 02:52:09 INFO - operating with platform_type : linux_ 02:52:09 INFO - Initialising browser for dromaeo_css test... 02:52:09 INFO - TEST-INFO | started process 7541 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZWDWyz/profile http://localhost:49511/getInfo.html) 02:52:13 INFO - PROCESS | 7541 | __metrics Screen width/height:1600/1200 02:52:13 INFO - PROCESS | 7541 | colorDepth:24 02:52:13 INFO - PROCESS | 7541 | Browser inner width/height: 1024/697 02:52:13 INFO - PROCESS | 7541 | __metrics 02:52:14 ERROR - PROCESS | 7541 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 02:52:15 INFO - TEST-INFO | 7541: exit 0 02:52:15 INFO - Browser initialized. 02:52:15 INFO - Running cycle 1/1 for dromaeo_css test... 02:52:15 INFO - TEST-INFO | started process 7672 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZWDWyz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:52:27 INFO - PROCESS | 7672 | RSS: Main: 156106752 02:52:27 INFO - PROCESS | 7672 | 02:53:16 INFO - PROCESS | 7672 | 1467193996677 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] 02:55:25 INFO - PROCESS | 7672 | Cycle 1(1): loaded http://localhost:49511/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49511/tests/dromaeo/cssquery-ext.html) 02:55:26 INFO - PROCESS | 7672 | RSS: Main: 160301056 02:55:26 INFO - PROCESS | 7672 | 02:58:28 INFO - PROCESS | 7672 | Cycle 1(1): loaded http://localhost:49511/tests/dromaeo/cssquery-ext.html (next: http://localhost:49511/tests/dromaeo/cssquery-jquery.html) 02:58:28 INFO - PROCESS | 7672 | RSS: Main: 157622272 02:58:28 INFO - PROCESS | 7672 | 03:01:30 INFO - PROCESS | 7672 | Cycle 1(1): loaded http://localhost:49511/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49511/tests/dromaeo/cssquery-mootools.html) 03:01:31 INFO - PROCESS | 7672 | RSS: Main: 157208576 03:01:31 INFO - PROCESS | 7672 | 03:04:32 INFO - PROCESS | 7672 | Cycle 1(1): loaded http://localhost:49511/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49511/tests/dromaeo/cssquery-prototype.html) 03:04:33 INFO - PROCESS | 7672 | RSS: Main: 156717056 03:04:33 INFO - PROCESS | 7672 | 03:07:35 INFO - PROCESS | 7672 | Cycle 1(1): loaded http://localhost:49511/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49511/tests/dromaeo/cssquery-yui.html) 03:07:36 INFO - PROCESS | 7672 | RSS: Main: 158892032 03:07:36 INFO - PROCESS | 7672 | 03:10:38 INFO - PROCESS | 7672 | Cycle 1(1): loaded http://localhost:49511/tests/dromaeo/cssquery-yui.html (next: http://localhost:49511/tests/dromaeo/cssquery-dojo.html) 03:10:38 INFO - PROCESS | 7672 | RSS: Main: 159219712 03:10:38 INFO - PROCESS | 7672 | 03:10:38 INFO - PROCESS | 7672 | __start_tp_report 03:10:38 INFO - PROCESS | 7672 | _x_x_mozilla_page_load 03:10:38 INFO - PROCESS | 7672 | _x_x_mozilla_page_load_details 03:10:38 INFO - PROCESS | 7672 | |i|pagename|runs| 03:10:38 INFO - PROCESS | 7672 | |0;dojo.html;3422.1786771174916;3471.704905083068;3488.7732297400667;3501.3172431375892;3514.174169070268;5855.531557475402;5874.618149820259;5895.557833162508;5927.8221653350365;5952.077427998667;5901.616394934326;5926.051831706928;5956.70216489176;5972.820815375546;5974.73113709883;5256.763445644946;5310.309659744228;5350.678959262437;5382.2464854920345;5392.622516423832;5172.069027575035;5173.146430838907;5217.2695822584865;5396.64921780085;5402.432744561824;5264.684118952856;5265.894682106375;5275.920861187085;5306.283651707028;5323.387810401795;5304.3634763828395;5339.919901201485;5356.169793682005;5368.865778355534;5370;5104.336436263299;5238.528532432061;5289.550388217006;5332.760025798849;5335.893282134336;5622.240997465331;5640.351359593658;5655.406182350876;5729.541636669056;5741.110127930177;6257.499400048031;6284.654344011077;6309.652969086698;6334.809955701337;6340.556161068727;6142.6522545212965;6273.686315684197;6363.826878361793;6380.7128679209545;6396.232452105731;5914.142449344821;5994.97002514989;5996.580239383201;5997.910031349533;6037.275526936795;6422.8715425691225;6525.21697396306;6536.8365790855605;6538.346165383424;6556.967215163989;6043.516518678495;6126.456603435116;6128.625347140816;6229.626222426669;6231.906521402183;6354.586951848115;6367.968160159262;6370.108184854124;6371.9681401593625;6384.936150638527;6276.435120839146;6347.809565713036;6349.07938348946;6351.428371446592;6358.554901156875;6072.36240194782;6230.906536401958;6259.906101408483;6307.653079080695;6343.904841427382;4818.975905120452;4820.276958456259;4823.059503396804;4851.878703032452;4852.272159176152;4286.571342865688;4303.053328267839;4315.266404711207;4316.374125751749;4322.027543802619;5827.4172582741385;5944.464998150187;6022.488088512526;6074.9392506075255;6078.422549857845;6359.554831161774;6359.841003974938;6401.263854656774;6402.231732192166;6441.066045423388;6136.110264011782;6167.167432396569;6184.783532576338;6192.8761424771255;6211.440970312694;5224.895502089937;5283.867903302448;5290.338707661543;5397.622166448389;5400.405955344909;6660.800175994728;6677.632730199885;6698;6715.160604924385;6736.2590115087305;6483.675816209265;6497.772577959749;6502.414782669583;6505.772297969548;6528;6309;6469.676516174079;6504.15445992018;6616.503762217757;6706.396424321834;6381.361863813767;6383.329750376143;6389.16940797712;6394.392532709385;6396.616203027833;6436.613803171825;6441.67791610427;6476.384743449365;6483.481321494175;6493.707783149675;6039;6165.630062196283;6238.594491358047;6283.120363149072;6367.395097465734;6299.559030867796;6339.3343698912795;6342.39747224013;6346.365363463617;6351.110844481684;5927.229460170322;6175.475084617858;6183.721732521957;6185.876282474415;6187.071939209155;6150.969245153925;6163.938360616516;6276.560640755103;6351.079093531504;6359.618422894641;6203.689815509116;6230.719617617127;6234.719437625408;6261.843453913689;6265.091561723433 03:10:38 INFO - PROCESS | 7672 | |1;ext.html;645.5352146454552;656.4321861589725;656.714329266769;673.61267271319;681.9829504262395;39712;41209.79395103024;45308.99999999992;45337;45468.54531454684;46268.30597541031;47423.28865067018;47497.76251118748;47501.28748068773;47557;8831.249343805768;9096.363254572183;9103.726888193365;9113.043130471304;9133;8937.77655558613;8952.060033696465;8952.820943581124;9008.68469603564;9017.95491022544;9027.684031058914;9066.592003359865;9073.682421115262;9080.500572468512;9124.178823905848;8260.421770476069;8277;8897.466152030835;8962.86555701665;9021.548922553879;8788.912110878873;8868.645254189825;8922.687705930326;8964.551772411418;8974.730758077203;30398.240043998856;30788.538171927437;30830.075097747103;30878.691213087804;37367.4394884077;3501.719862411001;3554.235839294564;3576.5708115026105;3622.492851000862;3794.4687743715626;33244.33511329784;33717.32565348679;34077;34107.317853643035;34469;4512.616427603658;4514.232580461329;4551.067031258584;4582.770861456914;4641.234196357597;325997;326736;327085.9999999976;327554;328936;36203.63796362003;36585.81707091501;36744.08139796527;36868.81565592155;38805.22389552193;39764.602353976086;40991.7950410252;41244.1751164975;41271.38092928608;41476.37785433221;15840.841591583936;15872.365105395886;15968.281427335798;16045.197740112948;16072;13107.082504224803;13117.868821311855;13136.474541018251;13161.078724489385;13179.74792394721;9249.953750231205;9297.116773906468;9346.813063738688;9404.294677899185;9409.952950235205;3465.54947856777;3503.772254803481;3526.8060256685617;3558.91102722434;3610.837512311952;1091.8362245663213;1133.070881876853;1181;1192.2488832035763;1255.171586752739;33484.49773253403;33535.66464335325;33537.66462335394;33967.4904876427;34389.82805086009;1155.4858088150693;1208.0758219961735;1217.4034722985673;1237.294741997053;1273.4587800184884;17617.647647047244;17720.113994300234;17767.644647106987;17938.370873495584;18042.548936276697;541729;541985;545655;547965;552625;65592.67203663952;66215;66405.66797165983;66467.33532664708;66488;1435.382785402266;1439.4673970630934;1447.4210315873734;1451.4629587052648;1452.1359790924382;32214.355712885143;32676.83661581772;33404.498932516515;33496.83251583727;33602.66397335995;58684.706576466844;58748.706256468446;58948.41051589601;59119;59145;461535;461885;465912;466873;467187;31204.687953121087;31415.685843141277;31723.524147138272;31798.205044874063;31869.521957170196;52722.736386317825;53631;53880.96379765;54870.72564637151;54936.725316373166;46090.539094608626;46211.07577848491;46505.76747116243;46937;47436;45199.77400112979;46069.30896036629;46135.76932115318;46560.53439465698;46629.53370466252;41634.58365416307;44348.55651443573;44763.55236447594;45689.77155114203;45881.77059114683;37599;38343.808280959536;38743.418848717854;39557.2088558233;39657;30738.53892191574;30818.53772193374;30823.845880770452;30871.2282192938;30915.845420772752 03:10:38 INFO - PROCESS | 7672 | |2;jquery.html;398.95412027616834;412.47615528279067;413.4748868936451;420.0716416719051;439.1721604774998;18958.526036849067;19752.111154998023;19984.90007549962;20323.898380508115;20513;19145.425637230906;19247.615047699037;20201.292954746586;20274;20287.18851245952;5686.630369026;5952.077427998667;5981.371955944628;5994.550408719363;5995.280566332046;5657.688827114507;5784.913226301609;5856.121581762748;5882.264716910387;5889.028310328812;5784.219130417382;5828.679422631753;5833.008388573931;5843.357230704619;5856.443637854397;5531.529819965288;5747.1666608341975;5753.165790960287;5757.050086735704;5825;5133;5144.948550514484;5145.279660847485;5163.096458119851;5189.66267192635;23016.42458938523;23871.522569548684;23977.52044959091;24034.879825600936;24154.87922560376;2584.4443444659487;2606.9478610427686;2748.477789220042;2820.464111818748;3218.806871587712;15124.848751512563;15362.615934601612;15484.148371839545;15498.845011549965;15668.68662626741;1727.5853795089213;1734.9311393310722;1752.115181833179;2011.1955217912805;2031.3804289691639;54743;63535;85786.57106714489;85804.14195858024;87628;10336.276460647832;10643.84034239487;10701.946490267499;10768.407737574353;11051.447427628747;14792.852071479363;14895.77656335156;14935.327910244065;14945.178015209269;14977.251137443085;7828.686852525835;8156;8267.875981860278;8434.367422443342;8468.110848360957;7848;7865.292123708894;7927.603619818986;8075.555844428495;8114.8782768258525;6844.486663500257;6908.1019467468905;6922.58464492132;6951.6871740771785;7044.401225895856;1901.83834374077;1902.6955687090276;1938.8351990080719;1955.2276850643916;1958.412476257117;994.5922171909482;1056.9048785609177;1068.5885933915342;1121.775644871029;1132.7621199548187;20115;20191;20333.593328133353;20435;20571.691424628643;1063.2663462211049;1115.4590023838432;1133.3086817041599;1135.5855112883737;1152.262551966742;10783.191260655482;11244.49399777012;11268.267562608404;11305.830412543819;11426.771464570827;528358;532224;533377;533684;551883;103450;105967;108377;108660;109740.451297743;1096.5613754498106;1103.475848971732;1123.4607388453587;1138.2203190814319;1142.782871254459;17869.73195402096;17890.194941227935;18072;18171;18188;43171.35242971295;43343.78328108465;44556.77721611371;45134.32298515459;45541.54458455506;62386;63878;64384.35615643783;64529.35470645234;66228.0065799023;8796.296296296154;8939.284857211278;8984.685536006209;9089.31830112731;9115.544222788967;10161.085502304828;13729.931350343184;13907.827651704245;14071.648208794863;14389.352479138255;11606.375107485128;12173.2696038238;12337.50649973991;12456.875431245571;12619.432125554189;12121.575744848888;12148.635540933787;12170.330631815335;12228.266304021787;12274;12260.38698065111;12714.936425317814;12807;12828.935855320664;12952.352382381032;9045.321600879828;9084.682036128705;9154.862677059982;9345.252379809735;9369.297302702189;11658.125640576822;12527.621961584036;12638.684032898884;12699.619011429671;12713.745725085631 03:10:38 INFO - PROCESS | 7672 | |3;mootools.html;1608.7426011838104;1616.5150454863542;1831.8259765322289;1917.3576851754663;1954.0620502158954;8516.829663406743;9438.339316247866;9604.375715578482;10127.949360253198;10145.746356341086;9618.086281803235;9878.851817222729;9936.950315248432;9979.800403991916;10045.296829221958;2532;2578.22653204039;2579.4067364506177;2579.471208402273;2579.8710064496795;2525.6590360301398;2582.4447743735095;2605.0882191233104;2608.4783043391303;2624.6325514427995;2608.2827222513865;2631.618415329776;2636.7626913577774;2651.5757478803393;2652.5888487284406;2581.1482210870463;2585.728498507667;2586.107792811477;2593.9753797250073;2603.0238660502314;2474.2206205045354;2490.601503759408;2492.239866840613;2500.6999160100904;2530.784883284923;9964.95017524915;9982;9985.450800205987;9994.900050999542;10021.09810117093;5983.1025346197985;6048.243969503812;6055.636661800306;6113.449789518964;6131.816045518642;3823.330917089526;3840.1551658635058;3917.843286268546;3950.723449358546;3981.98009009956;1219.3354621731178;1246.1339369138452;1249.262934868423;1280.7054377493137;1301.3623324570892;14502.274886255645;14600.196989165592;14637.268136593128;14696.926515367462;14714.852851471562;5294.92057619136;5321.122014867581;5450.427705090988;5455.09990851513;5469.507744303032;11828.408579570987;11910.106741994385;11919.463624136935;11938.22401543897;12048.638540843789;6025.8192254232445;6070.332263451017;6099.69501524922;6108.908366374419;6124.050772130327;4844.75776211188;5446.046941785172;5449.700266485302;5570.5265052470995;5577.498025177753;4566.223741963874;4578.519255478193;4591.79336929839;4649.907001859944;4814.085323788469;1416.596270063027;1436.0880840666252;1460.5691321060312;1461.7734251191082;1487.4422091715608;1073.414988831089;1075.8601381820313;1084.002717499902;1085.3867564826005;1088.455772113943;6749.493787965922;6754.358335958076;6795.762148324785;6835.043093966849;6920.377166055079;503.07434320849814;506.5694159964001;512.1677274429053;512.2700152282982;514.9433562308143;4782.234842425195;4808.110499557523;4840.467548569654;4842.055799119208;4887.65786394956;12311.938440307742;12672.80990785139;12729.10896237273;12756.61730148097;12821.551245706356;12148;12630.494780208872;12695.87304126947;12759;12819.29493877827;9038.051004644549;9067.183953444222;9170.853643294588;9262.073792620818;9282.90717092834;6849.691763870538;6862.210845752603;6910.896336554855;6929.237783843874;6984.4761642878;11356.26184298018;11470.598529051444;11673.533058677558;11678.70803229926;11733.530658773554;11826.34955077479;11900.40497975115;11922.940385298018;11934.52261909514;11966.401679915794;8453.450525715809;9129.77175570616;9177.21993630549;9284.860727088964;9341.11259430353;9332;9680.515974201402;9729.221662267144;9733.221342292458;9753.170980466739;8436.53599052058;8690.478571285743;8692.087330830425;8857.11428857109;8862.556872156496;8219.753407397788;8273.46222495536;8455.154484551496;8477;8587.613557390057;7889.329407000239;7949.244821741925;7959.721409750631;8042;8067.273945344947;5854.707264636666;5916.230889984275;5944.910826337695;6080.90878636812;6102.328743838086;6153.907691384722;6168.444839964424;6210.378962103753;6246.125542424155;6273.027680709497 03:10:38 INFO - PROCESS | 7672 | |4;prototype.html;350.86491700695234;352.05122195682634;356.6576086956522;360.624950051946;361.8064335580465;5909.704514774266;5919.289685237772;5941.792037278701;5945.524358051356;5945.762169513225;5823.010088284991;5824;5830;5838.562107841918;5875.647461152334;4470.485894122169;4493.191225579394;4503.459584849823;4517.322401639747;4521.525239849818;4467.905363186024;4485.6187224085825;4505.211587972108;4517.3224016397635;4535.365048893158;4466.731996080245;4468.798904049326;4483.798229079699;4488.551144885501;4510.571495707903;4366.366876802862;4435.179491793996;4442.822287108512;4456.487503937024;4479.902423906147;3946.250212459652;3966.960330396688;3969.7816620085882;3974.3442332015184;3975.5428125765616;5653.434656534355;5681.715914204273;5688.5494198978995;5691.918535478246;5711.40030296817;5051.19180931053;5185.740712964374;5191.273221748958;5192.948070519285;5212.478752124795;6037.577369584087;6060.212172417558;6116.4800991915745;6118.388161183891;6129.69351532426;4275.2044141460665;4404.009097952967;4405.713628614162;4425.8229670813125;4441.356003379492;6148.200733904609;6260.342664020303;6287;6309.936900630981;6347.270063942706;4370.497392799805;4400.933985990213;4406.669499787528;4419.315006174048;4420.359047938031;4421.182081314967;4453.198424283595;4463;4463.4420697412825;4467.419235499365;4909.901801963941;5110.386753589593;5119.897602047939;5137.306463627362;5137.614678899097;6123.387661233841;6130;6133;6140.078988151813;6164.4760195383;1531.0890020438044;1533.800605921223;1537.961550961235;1540.8921375503608;1560.9843901561067;931.2038207332633;960.1742501448748;962.3456049886145;977.0913050862624;979.6228452046014;5307.575393968474;5333.932988531532;5367.2485851980755;5377.650452720561;5452.536534394541;5664.49019588239;5689.886202276014;5706.4864162225595;5717.685527295956;5724.25584673998;5475.123980163155;5491.203775452537;5627.748900439857;6084.178635884099;6137.693115344304;3325.318309746496;3417.4361230396707;3418.2992486540697;3437.673421024999;3442.5008373786163;6272.278687950853;6575.112359831457;6624.8343791405605;6626.171728533934;6667.433268172163;6506.3493650634555;6510;6537.934620653733;6540.607563546202;6601.2738598754095;6292.370762923671;6663.433608143265;6669.966650166718;6706.53054286205;6715.4291885190305;6387.5209359297305;6423.261324947691;6438.422586466346;6439.259485159079;6441.67791610427;6098;6340.365963403808;6367.872642547216;6379.904301435389;6402;6377.394147555975;6507.609543427409;6568.343165683394;6600.1089852869245;6617.172853393326;4321.7406955582765;4400.273954797551;4416.668749843839;4467.798949047366;4487.977560112178;6357.23713154406;6371.968140159455;6441.1304473895425;6453.51598630114;6577.375149360803;6221.346758590464;6243.469305109116;6280.623162610258;6284.465820405317;6292.27638821523;5959.582829202088;6154.076888466766;6225.533085018551;6243.500519958483;6285.874282514415;6120.143179954899;6143.815685529441;6146.631202127886;6146.907796382969;6161.5686901918225;6163.876722465615;6265.310815810349;6285.59143655661;6315.747370105144;6335.493160547053;6069.605475644069;6119.479844213113;6155.322914479493;6169.2288463942;6170.876582468236 03:10:38 INFO - PROCESS | 7672 | |5;yui.html;820.3437250199838;822.8230930349976;823.337213543098;875.4548222387483;876.1282523888727;15383.384664613402;16807.74788378172;16817.83182168178;17170.48488545344;17195.398161064364;15846.20768961553;16083.11542865142;16090.59773505663;16111.919440402811;16136.919315403436;714.5069901767789;855.6235256487157;859.145150575177;862.4911302331623;865.5023361567092;877.1316396767187;878.565110270417;881.1056777370974;881.4402854187605;883.4390162246988;919.56320747645;921.5898924978387;921.7603423110006;922.1608336413865;923.2982932970923;911.3893691226928;916.1617120334886;916.6333466613341;917.3899356927635;919.6045700348848;673.5117040145904;673.6463356737703;674.848159164189;675.3111825937565;679.0425500044913;15582.9220853895;15609.297581608855;15648.139352335731;15657.217139142997;15668.451604193799;16007.919960400124;16274.918625406797;16505.17474126301;16584.17079146038;16708.41520546787;12748.872511274862;13126.934365328209;13152.736945261136;13224.471021159143;13265.204087754766;3945.1123497213184;4011.8194681239415;4042.312806822818;4086.3870419437026;4140.358244472111;81087.5945620274;82296.58851705703;82631.58684206661;84287.57856210742;84341.57829210877;12220.450079746433;12227;12267.57063502773;12348.753024939451;12485.438155283035;23565.7643423567;23581.174658886855;23590.7640923592;23617.173398930954;24034.639480407808;8669.609867555975;8901.510416927002;8917.197452229331;8978.371513993958;9024.323175761843;5059.519345662156;5145;5148.6910785353;5181.715005674724;5215.426303106655;3894.532656081288;4038.333674943601;4045.110075783323;4057.2494088593703;4063.4717486726536;668.2281964331205;669.4945316286173;671.4695390641339;673.1686367336433;677.2381071294793;772.6754762999441;789.8538770327508;809.7732634862248;810.0360570920585;813.422470046262;10079.244056695778;10640.46797660114;10668.14654827612;10698.197635177392;10784.838227426595;717.8313096422337;723.4248772226093;733.5635296998278;745.2994185465645;883.0860059838166;5084.847454576368;5256.947430525645;5276.129438642658;5336.439673834191;5378.381486129067;71468;112966.87033129563;116618;117197.4140129311;122966;65089.67455162694;82620.17379826245;85935.57032214799;97206;97357.51321243348;60100.39899601036;82231.53305400847;91050.54474727584;95413;97843;9945.353552019096;10263.538140783832;10415.114715248985;10432.478376081317;10562.8415573768;53070;54022;54139;54660.453395465534;54722.90554188973;66737.33262667505;67780.3221967774;68707;69213.30786692069;75152;12739.29933853647;13354.799678005033;13540.526081587097;13726.588202353945;13755.31223438804;15234.923825381245;15552;15812.288447020142;15918.68162636764;16058.598535036717;13834.584962451143;13966.158884532997;14110.788338175142;14438.783418248524;16015.75779390863;14779.187144707144;14786.704265914837;14899.255037247878;14946.252687365806;15127.848721512644;12450.626481205578;14209.715805684034;14348.569542913729;14377.712445750818;14907.329170187584;11631.127665424958;11975.101867360157;11995.1003674723;12109.212901161396;12123.393830308625;12025.579104731292;12312.569060082855;12474.376281185723;12524.624261272176;12715.618531444072 03:10:38 INFO - PROCESS | 7672 | __end_tp_report 03:10:38 INFO - PROCESS | 7672 | __start_cc_report 03:10:38 INFO - PROCESS | 7672 | _x_x_mozilla_cycle_collect,339 03:10:38 INFO - PROCESS | 7672 | __end_cc_report 03:10:38 INFO - PROCESS | 7672 | __startTimestamp1467195038896__endTimestamp 03:10:38 INFO - PROCESS | 7672 | 03:10:38 INFO - PROCESS | 7672 | ------- Summary: start ------- 03:10:38 INFO - PROCESS | 7672 | Number of tests: 6 03:10:38 INFO - PROCESS | 7672 | 03:10:38 INFO - PROCESS | 7672 | [#0] dojo.html Cycles:165 Average:5894.53 Median:6175.48 stddev:698.79 (11.3%) stddev-sans-first:673.48 03:10:38 INFO - PROCESS | 7672 | Values: 3422.2 3471.7 3488.8 3501.3 3514.2 5855.5 5874.6 5895.6 5927.8 5952.1 5901.6 5926.1 5956.7 5972.8 5974.7 5256.8 5310.3 5350.7 5382.2 5392.6 5172.1 5173.1 5217.3 5396.6 5402.4 5264.7 5265.9 5275.9 5306.3 5323.4 5304.4 5339.9 5356.2 5368.9 5370.0 5104.3 5238.5 5289.6 5332.8 5335.9 5622.2 5640.4 5655.4 5729.5 5741.1 6257.5 6284.7 6309.7 6334.8 6340.6 6142.7 6273.7 6363.8 6380.7 6396.2 5914.1 5995.0 5996.6 5997.9 6037.3 6422.9 6525.2 6536.8 6538.3 6557.0 6043.5 6126.5 6128.6 6229.6 6231.9 6354.6 6368.0 6370.1 6372.0 6384.9 6276.4 6347.8 6349.1 6351.4 6358.6 6072.4 6230.9 6259.9 6307.7 6343.9 4819.0 4820.3 4823.1 4851.9 4852.3 4286.6 4303.1 4315.3 4316.4 4322.0 5827.4 5944.5 6022.5 6074.9 6078.4 6359.6 6359.8 6401.3 6402.2 6441.1 6136.1 6167.2 6184.8 6192.9 6211.4 5224.9 5283.9 5290.3 5397.6 5400.4 6660.8 6677.6 6698.0 6715.2 6736.3 6483.7 6497.8 6502.4 6505.8 6528.0 6309.0 6469.7 6504.2 6616.5 6706.4 6381.4 6383.3 6389.2 6394.4 6396.6 6436.6 6441.7 6476.4 6483.5 6493.7 6039.0 6165.6 6238.6 6283.1 6367.4 6299.6 6339.3 6342.4 6346.4 6351.1 5927.2 6175.5 6183.7 6185.9 6187.1 6151.0 6163.9 6276.6 6351.1 6359.6 6203.7 6230.7 6234.7 6261.8 6265.1 03:10:38 INFO - PROCESS | 7672 | 03:10:38 INFO - PROCESS | 7672 | [#1] ext.html Cycles:180 Average:60393.75 Median:41373.88 stddev:120895.32 (292.2%) stddev-sans-first:121151.23 03:10:38 INFO - PROCESS | 7672 | Values: 645.5 656.4 656.7 673.6 682.0 39712.0 41209.8 45309.0 45337.0 45468.5 46268.3 47423.3 47497.8 47501.3 47557.0 8831.2 9096.4 9103.7 9113.0 9133.0 8937.8 8952.1 8952.8 9008.7 9018.0 9027.7 9066.6 9073.7 9080.5 9124.2 8260.4 8277.0 8897.5 8962.9 9021.5 8788.9 8868.6 8922.7 8964.6 8974.7 30398.2 30788.5 30830.1 30878.7 37367.4 3501.7 3554.2 3576.6 3622.5 3794.5 33244.3 33717.3 34077.0 34107.3 34469.0 4512.6 4514.2 4551.1 4582.8 4641.2 325997.0 326736.0 327086.0 327554.0 328936.0 36203.6 36585.8 36744.1 36868.8 38805.2 39764.6 40991.8 41244.2 41271.4 41476.4 15840.8 15872.4 15968.3 16045.2 16072.0 13107.1 13117.9 13136.5 13161.1 13179.7 9250.0 9297.1 9346.8 9404.3 9410.0 3465.5 3503.8 3526.8 3558.9 3610.8 1091.8 1133.1 1181.0 1192.2 1255.2 33484.5 33535.7 33537.7 33967.5 34389.8 1155.5 1208.1 1217.4 1237.3 1273.5 17617.6 17720.1 17767.6 17938.4 18042.5 541729.0 541985.0 545655.0 547965.0 552625.0 65592.7 66215.0 66405.7 66467.3 66488.0 1435.4 1439.5 1447.4 1451.5 1452.1 32214.4 32676.8 33404.5 33496.8 33602.7 58684.7 58748.7 58948.4 59119.0 59145.0 461535.0 461885.0 465912.0 466873.0 467187.0 31204.7 31415.7 31723.5 31798.2 31869.5 52722.7 53631.0 53881.0 54870.7 54936.7 46090.5 46211.1 46505.8 46937.0 47436.0 45199.8 46069.3 46135.8 46560.5 46629.5 41634.6 44348.6 44763.6 45689.8 45881.8 37599.0 38343.8 38743.4 39557.2 39657.0 30738.5 30818.5 30823.8 30871.2 30915.8 03:10:38 INFO - PROCESS | 7672 | 03:10:38 INFO - PROCESS | 7672 | [#2] jquery.html Cycles:180 Average:31231.77 Median:20384.30 stddev:88399.11 (433.7%) stddev-sans-first:88616.77 03:10:38 INFO - PROCESS | 7672 | Values: 399.0 412.5 413.5 420.1 439.2 18958.5 19752.1 19984.9 20323.9 20513.0 19145.4 19247.6 20201.3 20274.0 20287.2 5686.6 5952.1 5981.4 5994.6 5995.3 5657.7 5784.9 5856.1 5882.3 5889.0 5784.2 5828.7 5833.0 5843.4 5856.4 5531.5 5747.2 5753.2 5757.1 5825.0 5133.0 5144.9 5145.3 5163.1 5189.7 23016.4 23871.5 23977.5 24034.9 24154.9 2584.4 2606.9 2748.5 2820.5 3218.8 15124.8 15362.6 15484.1 15498.8 15668.7 1727.6 1734.9 1752.1 2011.2 2031.4 54743.0 63535.0 85786.6 85804.1 87628.0 10336.3 10643.8 10701.9 10768.4 11051.4 14792.9 14895.8 14935.3 14945.2 14977.3 7828.7 8156.0 8267.9 8434.4 8468.1 7848.0 7865.3 7927.6 8075.6 8114.9 6844.5 6908.1 6922.6 6951.7 7044.4 1901.8 1902.7 1938.8 1955.2 1958.4 994.6 1056.9 1068.6 1121.8 1132.8 20115.0 20191.0 20333.6 20435.0 20571.7 1063.3 1115.5 1133.3 1135.6 1152.3 10783.2 11244.5 11268.3 11305.8 11426.8 528358.0 532224.0 533377.0 533684.0 551883.0 103450.0 105967.0 108377.0 108660.0 109740.5 1096.6 1103.5 1123.5 1138.2 1142.8 17869.7 17890.2 18072.0 18171.0 18188.0 43171.4 43343.8 44556.8 45134.3 45541.5 62386.0 63878.0 64384.4 64529.4 66228.0 8796.3 8939.3 8984.7 9089.3 9115.5 10161.1 13729.9 13907.8 14071.6 14389.4 11606.4 12173.3 12337.5 12456.9 12619.4 12121.6 12148.6 12170.3 12228.3 12274.0 12260.4 12714.9 12807.0 12828.9 12952.4 9045.3 9084.7 9154.9 9345.3 9369.3 11658.1 12527.6 12638.7 12699.6 12713.7 03:10:38 INFO - PROCESS | 7672 | 03:10:38 INFO - PROCESS | 7672 | [#3] mootools.html Cycles:180 Average:6636.98 Median:4827.28 stddev:3837.93 (79.5%) stddev-sans-first:3830.09 03:10:38 INFO - PROCESS | 7672 | Values: 1608.7 1616.5 1831.8 1917.4 1954.1 8516.8 9438.3 9604.4 10127.9 10145.7 9618.1 9878.9 9937.0 9979.8 10045.3 2532.0 2578.2 2579.4 2579.5 2579.9 2525.7 2582.4 2605.1 2608.5 2624.6 2608.3 2631.6 2636.8 2651.6 2652.6 2581.1 2585.7 2586.1 2594.0 2603.0 2474.2 2490.6 2492.2 2500.7 2530.8 9965.0 9982.0 9985.5 9994.9 10021.1 5983.1 6048.2 6055.6 6113.4 6131.8 3823.3 3840.2 3917.8 3950.7 3982.0 1219.3 1246.1 1249.3 1280.7 1301.4 14502.3 14600.2 14637.3 14696.9 14714.9 5294.9 5321.1 5450.4 5455.1 5469.5 11828.4 11910.1 11919.5 11938.2 12048.6 6025.8 6070.3 6099.7 6108.9 6124.1 4844.8 5446.0 5449.7 5570.5 5577.5 4566.2 4578.5 4591.8 4649.9 4814.1 1416.6 1436.1 1460.6 1461.8 1487.4 1073.4 1075.9 1084.0 1085.4 1088.5 6749.5 6754.4 6795.8 6835.0 6920.4 503.1 506.6 512.2 512.3 514.9 4782.2 4808.1 4840.5 4842.1 4887.7 12311.9 12672.8 12729.1 12756.6 12821.6 12148.0 12630.5 12695.9 12759.0 12819.3 9038.1 9067.2 9170.9 9262.1 9282.9 6849.7 6862.2 6910.9 6929.2 6984.5 11356.3 11470.6 11673.5 11678.7 11733.5 11826.3 11900.4 11922.9 11934.5 11966.4 8453.5 9129.8 9177.2 9284.9 9341.1 9332.0 9680.5 9729.2 9733.2 9753.2 8436.5 8690.5 8692.1 8857.1 8862.6 8219.8 8273.5 8455.2 8477.0 8587.6 7889.3 7949.2 7959.7 8042.0 8067.3 5854.7 5916.2 5944.9 6080.9 6102.3 6153.9 6168.4 6210.4 6246.1 6273.0 03:10:38 INFO - PROCESS | 7672 | 03:10:38 INFO - PROCESS | 7672 | [#4] prototype.html Cycles:180 Average:5146.52 Median:5834.28 stddev:1545.16 (26.5%) stddev-sans-first:1506.98 03:10:38 INFO - PROCESS | 7672 | Values: 350.9 352.1 356.7 360.6 361.8 5909.7 5919.3 5941.8 5945.5 5945.8 5823.0 5824.0 5830.0 5838.6 5875.6 4470.5 4493.2 4503.5 4517.3 4521.5 4467.9 4485.6 4505.2 4517.3 4535.4 4466.7 4468.8 4483.8 4488.6 4510.6 4366.4 4435.2 4442.8 4456.5 4479.9 3946.3 3967.0 3969.8 3974.3 3975.5 5653.4 5681.7 5688.5 5691.9 5711.4 5051.2 5185.7 5191.3 5192.9 5212.5 6037.6 6060.2 6116.5 6118.4 6129.7 4275.2 4404.0 4405.7 4425.8 4441.4 6148.2 6260.3 6287.0 6309.9 6347.3 4370.5 4400.9 4406.7 4419.3 4420.4 4421.2 4453.2 4463.0 4463.4 4467.4 4909.9 5110.4 5119.9 5137.3 5137.6 6123.4 6130.0 6133.0 6140.1 6164.5 1531.1 1533.8 1538.0 1540.9 1561.0 931.2 960.2 962.3 977.1 979.6 5307.6 5333.9 5367.2 5377.7 5452.5 5664.5 5689.9 5706.5 5717.7 5724.3 5475.1 5491.2 5627.7 6084.2 6137.7 3325.3 3417.4 3418.3 3437.7 3442.5 6272.3 6575.1 6624.8 6626.2 6667.4 6506.3 6510.0 6537.9 6540.6 6601.3 6292.4 6663.4 6670.0 6706.5 6715.4 6387.5 6423.3 6438.4 6439.3 6441.7 6098.0 6340.4 6367.9 6379.9 6402.0 6377.4 6507.6 6568.3 6600.1 6617.2 4321.7 4400.3 4416.7 4467.8 4488.0 6357.2 6372.0 6441.1 6453.5 6577.4 6221.3 6243.5 6280.6 6284.5 6292.3 5959.6 6154.1 6225.5 6243.5 6285.9 6120.1 6143.8 6146.6 6146.9 6161.6 6163.9 6265.3 6285.6 6315.7 6335.5 6069.6 6119.5 6155.3 6169.2 6170.9 03:10:38 INFO - PROCESS | 7672 | 03:10:38 INFO - PROCESS | 7672 | [#5] yui.html Cycles:180 Average:20894.05 Median:4074.93 stddev:28765.02 (705.9%) stddev-sans-first:28806.22 03:10:38 INFO - PROCESS | 7672 | Values: 820.3 822.8 823.3 875.5 876.1 15383.4 16807.7 16817.8 17170.5 17195.4 15846.2 16083.1 16090.6 16111.9 16136.9 714.5 855.6 859.1 862.5 865.5 877.1 878.6 881.1 881.4 883.4 919.6 921.6 921.8 922.2 923.3 911.4 916.2 916.6 917.4 919.6 673.5 673.6 674.8 675.3 679.0 15582.9 15609.3 15648.1 15657.2 15668.5 16007.9 16274.9 16505.2 16584.2 16708.4 12748.9 13126.9 13152.7 13224.5 13265.2 3945.1 4011.8 4042.3 4086.4 4140.4 81087.6 82296.6 82631.6 84287.6 84341.6 12220.5 12227.0 12267.6 12348.8 12485.4 23565.8 23581.2 23590.8 23617.2 24034.6 8669.6 8901.5 8917.2 8978.4 9024.3 5059.5 5145.0 5148.7 5181.7 5215.4 3894.5 4038.3 4045.1 4057.2 4063.5 668.2 669.5 671.5 673.2 677.2 772.7 789.9 809.8 810.0 813.4 10079.2 10640.5 10668.1 10698.2 10784.8 717.8 723.4 733.6 745.3 883.1 5084.8 5256.9 5276.1 5336.4 5378.4 71468.0 112966.9 116618.0 117197.4 122966.0 65089.7 82620.2 85935.6 97206.0 97357.5 60100.4 82231.5 91050.5 95413.0 97843.0 9945.4 10263.5 10415.1 10432.5 10562.8 53070.0 54022.0 54139.0 54660.5 54722.9 66737.3 67780.3 68707.0 69213.3 75152.0 12739.3 13354.8 13540.5 13726.6 13755.3 15234.9 15552.0 15812.3 15918.7 16058.6 13834.6 13966.2 14110.8 14438.8 16015.8 14779.2 14786.7 14899.3 14946.3 15127.8 12450.6 14209.7 14348.6 14377.7 14907.3 11631.1 11975.1 11995.1 12109.2 12123.4 12025.6 12312.6 12474.4 12524.6 12715.6 03:10:38 INFO - PROCESS | 7672 | -------- Summary: end -------- 03:10:38 INFO - PROCESS | 7672 | 03:10:39 INFO - TEST-INFO | 7672: exit 0 03:10:39 INFO - TEST-OK | dromaeo_css | took 1109974ms 03:10:39 INFO - TEST-START | kraken 03:10:39 INFO - operating with platform_type : linux_ 03:10:39 INFO - Initialising browser for kraken test... 03:10:39 INFO - TEST-INFO | started process 7917 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJ01Tct/profile http://localhost:49511/getInfo.html) 03:10:43 INFO - PROCESS | 7917 | __metrics Screen width/height:1600/1200 03:10:43 INFO - PROCESS | 7917 | colorDepth:24 03:10:43 INFO - PROCESS | 7917 | Browser inner width/height: 1024/697 03:10:43 INFO - PROCESS | 7917 | __metrics 03:10:44 ERROR - PROCESS | 7917 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 03:10:45 INFO - TEST-INFO | 7917: exit 0 03:10:45 INFO - Browser initialized. 03:10:45 INFO - Running cycle 1/1 for kraken test... 03:10:45 INFO - TEST-INFO | started process 8048 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJ01Tct/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:10:56 INFO - PROCESS | 8048 | RSS: Main: 156135424 03:10:56 INFO - PROCESS | 8048 | 03:10:59 INFO - PROCESS | 8048 | Cycle 1(1): loaded http://localhost:49511/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49511/tests/kraken/driver.html?testName=audio-beat-detection) 03:11:00 INFO - PROCESS | 8048 | RSS: Main: 161026048 03:11:00 INFO - PROCESS | 8048 | 03:11:02 INFO - PROCESS | 8048 | Cycle 1(1): loaded http://localhost:49511/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49511/tests/kraken/driver.html?testName=audio-dft) 03:11:03 INFO - PROCESS | 8048 | RSS: Main: 160210944 03:11:03 INFO - PROCESS | 8048 | 03:11:06 INFO - PROCESS | 8048 | Cycle 1(1): loaded http://localhost:49511/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49511/tests/kraken/driver.html?testName=audio-fft) 03:11:07 INFO - PROCESS | 8048 | RSS: Main: 161492992 03:11:07 INFO - PROCESS | 8048 | 03:11:09 INFO - PROCESS | 8048 | Cycle 1(1): loaded http://localhost:49511/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49511/tests/kraken/driver.html?testName=audio-oscillator) 03:11:09 INFO - PROCESS | 8048 | RSS: Main: 161132544 03:11:09 INFO - PROCESS | 8048 | 03:11:11 INFO - PROCESS | 8048 | Cycle 1(1): loaded http://localhost:49511/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49511/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:11:12 INFO - PROCESS | 8048 | RSS: Main: 161251328 03:11:12 INFO - PROCESS | 8048 | 03:11:15 INFO - PROCESS | 8048 | Cycle 1(1): loaded http://localhost:49511/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49511/tests/kraken/driver.html?testName=imaging-darkroom) 03:11:16 INFO - PROCESS | 8048 | RSS: Main: 161378304 03:11:16 INFO - PROCESS | 8048 | 03:11:19 INFO - PROCESS | 8048 | Cycle 1(1): loaded http://localhost:49511/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49511/tests/kraken/driver.html?testName=imaging-desaturate) 03:11:20 INFO - PROCESS | 8048 | RSS: Main: 157696000 03:11:20 INFO - PROCESS | 8048 | 03:11:23 INFO - PROCESS | 8048 | Cycle 1(1): loaded http://localhost:49511/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49511/tests/kraken/driver.html?testName=json-parse-financial) 03:11:23 INFO - PROCESS | 8048 | RSS: Main: 158990336 03:11:23 INFO - PROCESS | 8048 | 03:11:25 INFO - PROCESS | 8048 | Cycle 1(1): loaded http://localhost:49511/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49511/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:11:25 INFO - PROCESS | 8048 | RSS: Main: 158846976 03:11:25 INFO - PROCESS | 8048 | 03:11:27 INFO - PROCESS | 8048 | Cycle 1(1): loaded http://localhost:49511/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49511/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:11:28 INFO - PROCESS | 8048 | RSS: Main: 159162368 03:11:28 INFO - PROCESS | 8048 | 03:11:30 INFO - PROCESS | 8048 | Cycle 1(1): loaded http://localhost:49511/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49511/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:11:30 INFO - PROCESS | 8048 | RSS: Main: 159744000 03:11:30 INFO - PROCESS | 8048 | 03:11:33 INFO - PROCESS | 8048 | Cycle 1(1): loaded http://localhost:49511/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49511/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:11:34 INFO - PROCESS | 8048 | RSS: Main: 160071680 03:11:34 INFO - PROCESS | 8048 | 03:11:36 INFO - PROCESS | 8048 | Cycle 1(1): loaded http://localhost:49511/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49511/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:11:37 INFO - PROCESS | 8048 | RSS: Main: 159899648 03:11:37 INFO - PROCESS | 8048 | 03:11:38 INFO - PROCESS | 8048 | Cycle 1(1): loaded http://localhost:49511/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49511/tests/kraken/driver.html?testName=ai-astar) 03:11:39 INFO - PROCESS | 8048 | RSS: Main: 160800768 03:11:39 INFO - PROCESS | 8048 | 03:11:39 INFO - PROCESS | 8048 | __start_tp_report 03:11:39 INFO - PROCESS | 8048 | _x_x_mozilla_page_load 03:11:39 INFO - PROCESS | 8048 | _x_x_mozilla_page_load_details 03:11:39 INFO - PROCESS | 8048 | |i|pagename|runs| 03:11:39 INFO - PROCESS | 8048 | |0;ai-astar;113;103;115;109;111;110;109;109;110;109 03:11:39 INFO - PROCESS | 8048 | |1;audio-beat-detection;161;125;151;180;126;155;150;133;184;125 03:11:39 INFO - PROCESS | 8048 | |2;audio-dft;162;162;162;163;162;163;164;161;163;161 03:11:39 INFO - PROCESS | 8048 | |3;audio-fft;76;76;76;172;76;76;74;76;183;76 03:11:39 INFO - PROCESS | 8048 | |4;audio-oscillator;84;84;155;84;84;85;142;85;84;144 03:11:39 INFO - PROCESS | 8048 | |5;imaging-gaussian-blur;117;117;118;118;117;117;117;118;117;118 03:11:39 INFO - PROCESS | 8048 | |6;imaging-darkroom;149;147;146;150;147;147;149;147;148;146 03:11:39 INFO - PROCESS | 8048 | |7;imaging-desaturate;95;95;96;95;95;95;95;95;95;95 03:11:39 INFO - PROCESS | 8048 | |8;json-parse-financial;52;55;55;54;56;54;54;58;52;55 03:11:39 INFO - PROCESS | 8048 | |9;json-stringify-tinderbox;61;60;61;61;61;61;61;61;62;61 03:11:39 INFO - PROCESS | 8048 | |10;stanford-crypto-aes;76;76;77;80;81;79;78;79;114;84 03:11:39 INFO - PROCESS | 8048 | |11;stanford-crypto-ccm;119;129;127;127;127;120;128;123;130;118 03:11:39 INFO - PROCESS | 8048 | |12;stanford-crypto-pbkdf2;159;156;157;153;152;154;153;159;152;153 03:11:39 INFO - PROCESS | 8048 | |13;stanford-crypto-sha256-iterative;63;62;61;68;63;64;63;60;61;60 03:11:39 INFO - PROCESS | 8048 | __end_tp_report 03:11:39 INFO - PROCESS | 8048 | __start_cc_report 03:11:39 INFO - PROCESS | 8048 | _x_x_mozilla_cycle_collect,889 03:11:39 INFO - PROCESS | 8048 | __end_cc_report 03:11:39 INFO - PROCESS | 8048 | __startTimestamp1467195099244__endTimestamp 03:11:39 INFO - PROCESS | 8048 | 03:11:39 INFO - PROCESS | 8048 | ------- Summary: start ------- 03:11:39 INFO - PROCESS | 8048 | Number of tests: 14 03:11:39 INFO - PROCESS | 8048 | 03:11:39 INFO - PROCESS | 8048 | [#0] ai-astar Cycles:10 Average:109.80 Median:110.00 stddev:3.12 (2.8%) stddev-sans-first:3.09 03:11:39 INFO - PROCESS | 8048 | Values: 113.0 103.0 115.0 109.0 111.0 110.0 109.0 109.0 110.0 109.0 03:11:39 INFO - PROCESS | 8048 | 03:11:39 INFO - PROCESS | 8048 | [#1] audio-beat-detection Cycles:10 Average:149.00 Median:153.00 stddev:21.88 (14.3%) stddev-sans-first:22.77 03:11:39 INFO - PROCESS | 8048 | Values: 161.0 125.0 151.0 180.0 126.0 155.0 150.0 133.0 184.0 125.0 03:11:39 INFO - PROCESS | 8048 | 03:11:39 INFO - PROCESS | 8048 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.50 stddev:0.95 (0.6%) stddev-sans-first:1.00 03:11:39 INFO - PROCESS | 8048 | Values: 162.0 162.0 162.0 163.0 162.0 163.0 164.0 161.0 163.0 161.0 03:11:39 INFO - PROCESS | 8048 | 03:11:39 INFO - PROCESS | 8048 | [#3] audio-fft Cycles:10 Average:96.10 Median:76.00 stddev:42.98 (56.6%) stddev-sans-first:44.97 03:11:39 INFO - PROCESS | 8048 | Values: 76.0 76.0 76.0 172.0 76.0 76.0 74.0 76.0 183.0 76.0 03:11:39 INFO - PROCESS | 8048 | 03:11:39 INFO - PROCESS | 8048 | [#4] audio-oscillator Cycles:10 Average:103.10 Median:84.00 stddev:30.48 (36.3%) stddev-sans-first:31.53 03:11:39 INFO - PROCESS | 8048 | Values: 84.0 84.0 155.0 84.0 84.0 85.0 142.0 85.0 84.0 144.0 03:11:39 INFO - PROCESS | 8048 | 03:11:39 INFO - PROCESS | 8048 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 03:11:39 INFO - PROCESS | 8048 | Values: 117.0 117.0 118.0 118.0 117.0 117.0 117.0 118.0 117.0 118.0 03:11:39 INFO - PROCESS | 8048 | 03:11:39 INFO - PROCESS | 8048 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:147.50 stddev:1.35 (0.9%) stddev-sans-first:1.33 03:11:39 INFO - PROCESS | 8048 | Values: 149.0 147.0 146.0 150.0 147.0 147.0 149.0 147.0 148.0 146.0 03:11:39 INFO - PROCESS | 8048 | 03:11:39 INFO - PROCESS | 8048 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 03:11:39 INFO - PROCESS | 8048 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 03:11:39 INFO - PROCESS | 8048 | 03:11:39 INFO - PROCESS | 8048 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:55.00 stddev:1.78 (3.2%) stddev-sans-first:1.64 03:11:39 INFO - PROCESS | 8048 | Values: 52.0 55.0 55.0 54.0 56.0 54.0 54.0 58.0 52.0 55.0 03:11:39 INFO - PROCESS | 8048 | 03:11:39 INFO - PROCESS | 8048 | [#9] json-stringify-tinderbox Cycles:10 Average:61.00 Median:61.00 stddev:0.47 (0.8%) stddev-sans-first:0.50 03:11:39 INFO - PROCESS | 8048 | Values: 61.0 60.0 61.0 61.0 61.0 61.0 61.0 61.0 62.0 61.0 03:11:39 INFO - PROCESS | 8048 | 03:11:39 INFO - PROCESS | 8048 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:79.00 stddev:11.36 (14.4%) stddev-sans-first:11.82 03:11:39 INFO - PROCESS | 8048 | Values: 76.0 76.0 77.0 80.0 81.0 79.0 78.0 79.0 114.0 84.0 03:11:39 INFO - PROCESS | 8048 | 03:11:39 INFO - PROCESS | 8048 | [#11] stanford-crypto-ccm Cycles:10 Average:124.80 Median:127.00 stddev:4.42 (3.5%) stddev-sans-first:4.16 03:11:39 INFO - PROCESS | 8048 | Values: 119.0 129.0 127.0 127.0 127.0 120.0 128.0 123.0 130.0 118.0 03:11:39 INFO - PROCESS | 8048 | 03:11:39 INFO - PROCESS | 8048 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.80 Median:155.00 stddev:2.74 (1.8%) stddev-sans-first:2.45 03:11:39 INFO - PROCESS | 8048 | Values: 159.0 156.0 157.0 153.0 152.0 154.0 153.0 159.0 152.0 153.0 03:11:39 INFO - PROCESS | 8048 | 03:11:39 INFO - PROCESS | 8048 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.50 Median:63.00 stddev:2.37 (3.8%) stddev-sans-first:2.51 03:11:39 INFO - PROCESS | 8048 | Values: 63.0 62.0 61.0 68.0 63.0 64.0 63.0 60.0 61.0 60.0 03:11:39 INFO - PROCESS | 8048 | -------- Summary: end -------- 03:11:39 INFO - PROCESS | 8048 | 03:11:40 INFO - TEST-INFO | 8048: exit 0 03:11:40 INFO - TEST-OK | kraken | took 60604ms 03:11:40 INFO - SUITE-END | took 1170s 03:11:40 INFO - Completed test suite (00:19:30) 03:11:40 INFO - javascript benchmark 03:11:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7760.074034468026, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3422.1786771174916, 3471.704905083068, 3488.7732297400667, 3501.3172431375892, 3514.174169070268, 5855.531557475402, 5874.618149820259, 5895.557833162508, 5927.8221653350365, 5952.077427998667, 5901.616394934326, 5926.051831706928, 5956.70216489176, 5972.820815375546, 5974.73113709883, 5256.763445644946, 5310.309659744228, 5350.678959262437, 5382.2464854920345, 5392.622516423832, 5172.069027575035, 5173.146430838907, 5217.2695822584865, 5396.64921780085, 5402.432744561824, 5264.684118952856, 5265.894682106375, 5275.920861187085, 5306.283651707028, 5323.387810401795, 5304.3634763828395, 5339.919901201485, 5356.169793682005, 5368.865778355534, 5370.0, 5104.336436263299, 5238.528532432061, 5289.550388217006, 5332.760025798849, 5335.893282134336, 5622.240997465331, 5640.351359593658, 5655.406182350876, 5729.541636669056, 5741.110127930177, 6257.499400048031, 6284.654344011077, 6309.652969086698, 6334.809955701337, 6340.556161068727, 6142.6522545212965, 6273.686315684197, 6363.826878361793, 6380.7128679209545, 6396.232452105731, 5914.142449344821, 5994.97002514989, 5996.580239383201, 5997.910031349533, 6037.275526936795, 6422.8715425691225, 6525.21697396306, 6536.8365790855605, 6538.346165383424, 6556.967215163989, 6043.516518678495, 6126.456603435116, 6128.625347140816, 6229.626222426669, 6231.906521402183, 6354.586951848115, 6367.968160159262, 6370.108184854124, 6371.9681401593625, 6384.936150638527, 6276.435120839146, 6347.809565713036, 6349.07938348946, 6351.428371446592, 6358.554901156875, 6072.36240194782, 6230.906536401958, 6259.906101408483, 6307.653079080695, 6343.904841427382, 4818.975905120452, 4820.276958456259, 4823.059503396804, 4851.878703032452, 4852.272159176152, 4286.571342865688, 4303.053328267839, 4315.266404711207, 4316.374125751749, 4322.027543802619, 5827.4172582741385, 5944.464998150187, 6022.488088512526, 6074.9392506075255, 6078.422549857845, 6359.554831161774, 6359.841003974938, 6401.263854656774, 6402.231732192166, 6441.066045423388, 6136.110264011782, 6167.167432396569, 6184.783532576338, 6192.8761424771255, 6211.440970312694, 5224.895502089937, 5283.867903302448, 5290.338707661543, 5397.622166448389, 5400.405955344909, 6660.800175994728, 6677.632730199885, 6698.0, 6715.160604924385, 6736.2590115087305, 6483.675816209265, 6497.772577959749, 6502.414782669583, 6505.772297969548, 6528.0, 6309.0, 6469.676516174079, 6504.15445992018, 6616.503762217757, 6706.396424321834, 6381.361863813767, 6383.329750376143, 6389.16940797712, 6394.392532709385, 6396.616203027833, 6436.613803171825, 6441.67791610427, 6476.384743449365, 6483.481321494175, 6493.707783149675, 6039.0, 6165.630062196283, 6238.594491358047, 6283.120363149072, 6367.395097465734, 6299.559030867796, 6339.3343698912795, 6342.39747224013, 6346.365363463617, 6351.110844481684, 5927.229460170322, 6175.475084617858, 6183.721732521957, 6185.876282474415, 6187.071939209155, 6150.969245153925, 6163.938360616516, 6276.560640755103, 6351.079093531504, 6359.618422894641, 6203.689815509116, 6230.719617617127, 6234.719437625408, 6261.843453913689, 6265.091561723433], "value": 5846.270482865684, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [645.5352146454552, 656.4321861589725, 656.714329266769, 673.61267271319, 681.9829504262395, 39712.0, 41209.79395103024, 45308.99999999992, 45337.0, 45468.54531454684, 46268.30597541031, 47423.28865067018, 47497.76251118748, 47501.28748068773, 47557.0, 8831.249343805768, 9096.363254572183, 9103.726888193365, 9113.043130471304, 9133.0, 8937.77655558613, 8952.060033696465, 8952.820943581124, 9008.68469603564, 9017.95491022544, 9027.684031058914, 9066.592003359865, 9073.682421115262, 9080.500572468512, 9124.178823905848, 8260.421770476069, 8277.0, 8897.466152030835, 8962.86555701665, 9021.548922553879, 8788.912110878873, 8868.645254189825, 8922.687705930326, 8964.551772411418, 8974.730758077203, 30398.240043998856, 30788.538171927437, 30830.075097747103, 30878.691213087804, 37367.4394884077, 3501.719862411001, 3554.235839294564, 3576.5708115026105, 3622.492851000862, 3794.4687743715626, 33244.33511329784, 33717.32565348679, 34077.0, 34107.317853643035, 34469.0, 4512.616427603658, 4514.232580461329, 4551.067031258584, 4582.770861456914, 4641.234196357597, 325997.0, 326736.0, 327085.9999999976, 327554.0, 328936.0, 36203.63796362003, 36585.81707091501, 36744.08139796527, 36868.81565592155, 38805.22389552193, 39764.602353976086, 40991.7950410252, 41244.1751164975, 41271.38092928608, 41476.37785433221, 15840.841591583936, 15872.365105395886, 15968.281427335798, 16045.197740112948, 16072.0, 13107.082504224803, 13117.868821311855, 13136.474541018251, 13161.078724489385, 13179.74792394721, 9249.953750231205, 9297.116773906468, 9346.813063738688, 9404.294677899185, 9409.952950235205, 3465.54947856777, 3503.772254803481, 3526.8060256685617, 3558.91102722434, 3610.837512311952, 1091.8362245663213, 1133.070881876853, 1181.0, 1192.2488832035763, 1255.171586752739, 33484.49773253403, 33535.66464335325, 33537.66462335394, 33967.4904876427, 34389.82805086009, 1155.4858088150693, 1208.0758219961735, 1217.4034722985673, 1237.294741997053, 1273.4587800184884, 17617.647647047244, 17720.113994300234, 17767.644647106987, 17938.370873495584, 18042.548936276697, 541729.0, 541985.0, 545655.0, 547965.0, 552625.0, 65592.67203663952, 66215.0, 66405.66797165983, 66467.33532664708, 66488.0, 1435.382785402266, 1439.4673970630934, 1447.4210315873734, 1451.4629587052648, 1452.1359790924382, 32214.355712885143, 32676.83661581772, 33404.498932516515, 33496.83251583727, 33602.66397335995, 58684.706576466844, 58748.706256468446, 58948.41051589601, 59119.0, 59145.0, 461535.0, 461885.0, 465912.0, 466873.0, 467187.0, 31204.687953121087, 31415.685843141277, 31723.524147138272, 31798.205044874063, 31869.521957170196, 52722.736386317825, 53631.0, 53880.96379765, 54870.72564637151, 54936.725316373166, 46090.539094608626, 46211.07577848491, 46505.76747116243, 46937.0, 47436.0, 45199.77400112979, 46069.30896036629, 46135.76932115318, 46560.53439465698, 46629.53370466252, 41634.58365416307, 44348.55651443573, 44763.55236447594, 45689.77155114203, 45881.77059114683, 37599.0, 38343.808280959536, 38743.418848717854, 39557.2088558233, 39657.0, 30738.53892191574, 30818.53772193374, 30823.845880770452, 30871.2282192938, 30915.845420772752], "value": 19673.160551977773, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [398.95412027616834, 412.47615528279067, 413.4748868936451, 420.0716416719051, 439.1721604774998, 18958.526036849067, 19752.111154998023, 19984.90007549962, 20323.898380508115, 20513.0, 19145.425637230906, 19247.615047699037, 20201.292954746586, 20274.0, 20287.18851245952, 5686.630369026, 5952.077427998667, 5981.371955944628, 5994.550408719363, 5995.280566332046, 5657.688827114507, 5784.913226301609, 5856.121581762748, 5882.264716910387, 5889.028310328812, 5784.219130417382, 5828.679422631753, 5833.008388573931, 5843.357230704619, 5856.443637854397, 5531.529819965288, 5747.1666608341975, 5753.165790960287, 5757.050086735704, 5825.0, 5133.0, 5144.948550514484, 5145.279660847485, 5163.096458119851, 5189.66267192635, 23016.42458938523, 23871.522569548684, 23977.52044959091, 24034.879825600936, 24154.87922560376, 2584.4443444659487, 2606.9478610427686, 2748.477789220042, 2820.464111818748, 3218.806871587712, 15124.848751512563, 15362.615934601612, 15484.148371839545, 15498.845011549965, 15668.68662626741, 1727.5853795089213, 1734.9311393310722, 1752.115181833179, 2011.1955217912805, 2031.3804289691639, 54743.0, 63535.0, 85786.57106714489, 85804.14195858024, 87628.0, 10336.276460647832, 10643.84034239487, 10701.946490267499, 10768.407737574353, 11051.447427628747, 14792.852071479363, 14895.77656335156, 14935.327910244065, 14945.178015209269, 14977.251137443085, 7828.686852525835, 8156.0, 8267.875981860278, 8434.367422443342, 8468.110848360957, 7848.0, 7865.292123708894, 7927.603619818986, 8075.555844428495, 8114.8782768258525, 6844.486663500257, 6908.1019467468905, 6922.58464492132, 6951.6871740771785, 7044.401225895856, 1901.83834374077, 1902.6955687090276, 1938.8351990080719, 1955.2276850643916, 1958.412476257117, 994.5922171909482, 1056.9048785609177, 1068.5885933915342, 1121.775644871029, 1132.7621199548187, 20115.0, 20191.0, 20333.593328133353, 20435.0, 20571.691424628643, 1063.2663462211049, 1115.4590023838432, 1133.3086817041599, 1135.5855112883737, 1152.262551966742, 10783.191260655482, 11244.49399777012, 11268.267562608404, 11305.830412543819, 11426.771464570827, 528358.0, 532224.0, 533377.0, 533684.0, 551883.0, 103450.0, 105967.0, 108377.0, 108660.0, 109740.451297743, 1096.5613754498106, 1103.475848971732, 1123.4607388453587, 1138.2203190814319, 1142.782871254459, 17869.73195402096, 17890.194941227935, 18072.0, 18171.0, 18188.0, 43171.35242971295, 43343.78328108465, 44556.77721611371, 45134.32298515459, 45541.54458455506, 62386.0, 63878.0, 64384.35615643783, 64529.35470645234, 66228.0065799023, 8796.296296296154, 8939.284857211278, 8984.685536006209, 9089.31830112731, 9115.544222788967, 10161.085502304828, 13729.931350343184, 13907.827651704245, 14071.648208794863, 14389.352479138255, 11606.375107485128, 12173.2696038238, 12337.50649973991, 12456.875431245571, 12619.432125554189, 12121.575744848888, 12148.635540933787, 12170.330631815335, 12228.266304021787, 12274.0, 12260.38698065111, 12714.936425317814, 12807.0, 12828.935855320664, 12952.352382381032, 9045.321600879828, 9084.682036128705, 9154.862677059982, 9345.252379809735, 9369.297302702189, 11658.125640576822, 12527.621961584036, 12638.684032898884, 12699.619011429671, 12713.745725085631], "value": 9788.276864661364, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1608.7426011838104, 1616.5150454863542, 1831.8259765322289, 1917.3576851754663, 1954.0620502158954, 8516.829663406743, 9438.339316247866, 9604.375715578482, 10127.949360253198, 10145.746356341086, 9618.086281803235, 9878.851817222729, 9936.950315248432, 9979.800403991916, 10045.296829221958, 2532.0, 2578.22653204039, 2579.4067364506177, 2579.471208402273, 2579.8710064496795, 2525.6590360301398, 2582.4447743735095, 2605.0882191233104, 2608.4783043391303, 2624.6325514427995, 2608.2827222513865, 2631.618415329776, 2636.7626913577774, 2651.5757478803393, 2652.5888487284406, 2581.1482210870463, 2585.728498507667, 2586.107792811477, 2593.9753797250073, 2603.0238660502314, 2474.2206205045354, 2490.601503759408, 2492.239866840613, 2500.6999160100904, 2530.784883284923, 9964.95017524915, 9982.0, 9985.450800205987, 9994.900050999542, 10021.09810117093, 5983.1025346197985, 6048.243969503812, 6055.636661800306, 6113.449789518964, 6131.816045518642, 3823.330917089526, 3840.1551658635058, 3917.843286268546, 3950.723449358546, 3981.98009009956, 1219.3354621731178, 1246.1339369138452, 1249.262934868423, 1280.7054377493137, 1301.3623324570892, 14502.274886255645, 14600.196989165592, 14637.268136593128, 14696.926515367462, 14714.852851471562, 5294.92057619136, 5321.122014867581, 5450.427705090988, 5455.09990851513, 5469.507744303032, 11828.408579570987, 11910.106741994385, 11919.463624136935, 11938.22401543897, 12048.638540843789, 6025.8192254232445, 6070.332263451017, 6099.69501524922, 6108.908366374419, 6124.050772130327, 4844.75776211188, 5446.046941785172, 5449.700266485302, 5570.5265052470995, 5577.498025177753, 4566.223741963874, 4578.519255478193, 4591.79336929839, 4649.907001859944, 4814.085323788469, 1416.596270063027, 1436.0880840666252, 1460.5691321060312, 1461.7734251191082, 1487.4422091715608, 1073.414988831089, 1075.8601381820313, 1084.002717499902, 1085.3867564826005, 1088.455772113943, 6749.493787965922, 6754.358335958076, 6795.762148324785, 6835.043093966849, 6920.377166055079, 503.07434320849814, 506.5694159964001, 512.1677274429053, 512.2700152282982, 514.9433562308143, 4782.234842425195, 4808.110499557523, 4840.467548569654, 4842.055799119208, 4887.65786394956, 12311.938440307742, 12672.80990785139, 12729.10896237273, 12756.61730148097, 12821.551245706356, 12148.0, 12630.494780208872, 12695.87304126947, 12759.0, 12819.29493877827, 9038.051004644549, 9067.183953444222, 9170.853643294588, 9262.073792620818, 9282.90717092834, 6849.691763870538, 6862.210845752603, 6910.896336554855, 6929.237783843874, 6984.4761642878, 11356.26184298018, 11470.598529051444, 11673.533058677558, 11678.70803229926, 11733.530658773554, 11826.34955077479, 11900.40497975115, 11922.940385298018, 11934.52261909514, 11966.401679915794, 8453.450525715809, 9129.77175570616, 9177.21993630549, 9284.860727088964, 9341.11259430353, 9332.0, 9680.515974201402, 9729.221662267144, 9733.221342292458, 9753.170980466739, 8436.53599052058, 8690.478571285743, 8692.087330830425, 8857.11428857109, 8862.556872156496, 8219.753407397788, 8273.46222495536, 8455.154484551496, 8477.0, 8587.613557390057, 7889.329407000239, 7949.244821741925, 7959.721409750631, 8042.0, 8067.273945344947, 5854.707264636666, 5916.230889984275, 5944.910826337695, 6080.90878636812, 6102.328743838086, 6153.907691384722, 6168.444839964424, 6210.378962103753, 6246.125542424155, 6273.027680709497], "value": 5193.765450732457, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.86491700695234, 352.05122195682634, 356.6576086956522, 360.624950051946, 361.8064335580465, 5909.704514774266, 5919.289685237772, 5941.792037278701, 5945.524358051356, 5945.762169513225, 5823.010088284991, 5824.0, 5830.0, 5838.562107841918, 5875.647461152334, 4470.485894122169, 4493.191225579394, 4503.459584849823, 4517.322401639747, 4521.525239849818, 4467.905363186024, 4485.6187224085825, 4505.211587972108, 4517.3224016397635, 4535.365048893158, 4466.731996080245, 4468.798904049326, 4483.798229079699, 4488.551144885501, 4510.571495707903, 4366.366876802862, 4435.179491793996, 4442.822287108512, 4456.487503937024, 4479.902423906147, 3946.250212459652, 3966.960330396688, 3969.7816620085882, 3974.3442332015184, 3975.5428125765616, 5653.434656534355, 5681.715914204273, 5688.5494198978995, 5691.918535478246, 5711.40030296817, 5051.19180931053, 5185.740712964374, 5191.273221748958, 5192.948070519285, 5212.478752124795, 6037.577369584087, 6060.212172417558, 6116.4800991915745, 6118.388161183891, 6129.69351532426, 4275.2044141460665, 4404.009097952967, 4405.713628614162, 4425.8229670813125, 4441.356003379492, 6148.200733904609, 6260.342664020303, 6287.0, 6309.936900630981, 6347.270063942706, 4370.497392799805, 4400.933985990213, 4406.669499787528, 4419.315006174048, 4420.359047938031, 4421.182081314967, 4453.198424283595, 4463.0, 4463.4420697412825, 4467.419235499365, 4909.901801963941, 5110.386753589593, 5119.897602047939, 5137.306463627362, 5137.614678899097, 6123.387661233841, 6130.0, 6133.0, 6140.078988151813, 6164.4760195383, 1531.0890020438044, 1533.800605921223, 1537.961550961235, 1540.8921375503608, 1560.9843901561067, 931.2038207332633, 960.1742501448748, 962.3456049886145, 977.0913050862624, 979.6228452046014, 5307.575393968474, 5333.932988531532, 5367.2485851980755, 5377.650452720561, 5452.536534394541, 5664.49019588239, 5689.886202276014, 5706.4864162225595, 5717.685527295956, 5724.25584673998, 5475.123980163155, 5491.203775452537, 5627.748900439857, 6084.178635884099, 6137.693115344304, 3325.318309746496, 3417.4361230396707, 3418.2992486540697, 3437.673421024999, 3442.5008373786163, 6272.278687950853, 6575.112359831457, 6624.8343791405605, 6626.171728533934, 6667.433268172163, 6506.3493650634555, 6510.0, 6537.934620653733, 6540.607563546202, 6601.2738598754095, 6292.370762923671, 6663.433608143265, 6669.966650166718, 6706.53054286205, 6715.4291885190305, 6387.5209359297305, 6423.261324947691, 6438.422586466346, 6439.259485159079, 6441.67791610427, 6098.0, 6340.365963403808, 6367.872642547216, 6379.904301435389, 6402.0, 6377.394147555975, 6507.609543427409, 6568.343165683394, 6600.1089852869245, 6617.172853393326, 4321.7406955582765, 4400.273954797551, 4416.668749843839, 4467.798949047366, 4487.977560112178, 6357.23713154406, 6371.968140159455, 6441.1304473895425, 6453.51598630114, 6577.375149360803, 6221.346758590464, 6243.469305109116, 6280.623162610258, 6284.465820405317, 6292.27638821523, 5959.582829202088, 6154.076888466766, 6225.533085018551, 6243.500519958483, 6285.874282514415, 6120.143179954899, 6143.815685529441, 6146.631202127886, 6146.907796382969, 6161.5686901918225, 6163.876722465615, 6265.310815810349, 6285.59143655661, 6315.747370105144, 6335.493160547053, 6069.605475644069, 6119.479844213113, 6155.322914479493, 6169.2288463942, 6170.876582468236], "value": 4646.6556866888795, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [820.3437250199838, 822.8230930349976, 823.337213543098, 875.4548222387483, 876.1282523888727, 15383.384664613402, 16807.74788378172, 16817.83182168178, 17170.48488545344, 17195.398161064364, 15846.20768961553, 16083.11542865142, 16090.59773505663, 16111.919440402811, 16136.919315403436, 714.5069901767789, 855.6235256487157, 859.145150575177, 862.4911302331623, 865.5023361567092, 877.1316396767187, 878.565110270417, 881.1056777370974, 881.4402854187605, 883.4390162246988, 919.56320747645, 921.5898924978387, 921.7603423110006, 922.1608336413865, 923.2982932970923, 911.3893691226928, 916.1617120334886, 916.6333466613341, 917.3899356927635, 919.6045700348848, 673.5117040145904, 673.6463356737703, 674.848159164189, 675.3111825937565, 679.0425500044913, 15582.9220853895, 15609.297581608855, 15648.139352335731, 15657.217139142997, 15668.451604193799, 16007.919960400124, 16274.918625406797, 16505.17474126301, 16584.17079146038, 16708.41520546787, 12748.872511274862, 13126.934365328209, 13152.736945261136, 13224.471021159143, 13265.204087754766, 3945.1123497213184, 4011.8194681239415, 4042.312806822818, 4086.3870419437026, 4140.358244472111, 81087.5945620274, 82296.58851705703, 82631.58684206661, 84287.57856210742, 84341.57829210877, 12220.450079746433, 12227.0, 12267.57063502773, 12348.753024939451, 12485.438155283035, 23565.7643423567, 23581.174658886855, 23590.7640923592, 23617.173398930954, 24034.639480407808, 8669.609867555975, 8901.510416927002, 8917.197452229331, 8978.371513993958, 9024.323175761843, 5059.519345662156, 5145.0, 5148.6910785353, 5181.715005674724, 5215.426303106655, 3894.532656081288, 4038.333674943601, 4045.110075783323, 4057.2494088593703, 4063.4717486726536, 668.2281964331205, 669.4945316286173, 671.4695390641339, 673.1686367336433, 677.2381071294793, 772.6754762999441, 789.8538770327508, 809.7732634862248, 810.0360570920585, 813.422470046262, 10079.244056695778, 10640.46797660114, 10668.14654827612, 10698.197635177392, 10784.838227426595, 717.8313096422337, 723.4248772226093, 733.5635296998278, 745.2994185465645, 883.0860059838166, 5084.847454576368, 5256.947430525645, 5276.129438642658, 5336.439673834191, 5378.381486129067, 71468.0, 112966.87033129563, 116618.0, 117197.4140129311, 122966.0, 65089.67455162694, 82620.17379826245, 85935.57032214799, 97206.0, 97357.51321243348, 60100.39899601036, 82231.53305400847, 91050.54474727584, 95413.0, 97843.0, 9945.353552019096, 10263.538140783832, 10415.114715248985, 10432.478376081317, 10562.8415573768, 53070.0, 54022.0, 54139.0, 54660.453395465534, 54722.90554188973, 66737.33262667505, 67780.3221967774, 68707.0, 69213.30786692069, 75152.0, 12739.29933853647, 13354.799678005033, 13540.526081587097, 13726.588202353945, 13755.31223438804, 15234.923825381245, 15552.0, 15812.288447020142, 15918.68162636764, 16058.598535036717, 13834.584962451143, 13966.158884532997, 14110.788338175142, 14438.783418248524, 16015.75779390863, 14779.187144707144, 14786.704265914837, 14899.255037247878, 14946.252687365806, 15127.848721512644, 12450.626481205578, 14209.715805684034, 14348.569542913729, 14377.712445750818, 14907.329170187584, 11631.127665424958, 11975.101867360157, 11995.1003674723, 12109.212901161396, 12123.393830308625, 12025.579104731292, 12312.569060082855, 12474.376281185723, 12524.624261272176, 12715.618531444072], "value": 8036.686460691907, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1520.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 103.0, 115.0, 109.0, 111.0, 110.0, 109.0, 109.0, 110.0, 109.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 125.0, 151.0, 180.0, 126.0, 155.0, 150.0, 133.0, 184.0, 125.0], "value": 149.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 163.0, 162.0, 163.0, 164.0, 161.0, 163.0, 161.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 172.0, 76.0, 76.0, 74.0, 76.0, 183.0, 76.0], "value": 96.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 155.0, 84.0, 84.0, 85.0, 142.0, 85.0, 84.0, 144.0], "value": 103.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 146.0, 150.0, 147.0, 147.0, 149.0, 147.0, 148.0, 146.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 55.0, 55.0, 54.0, 56.0, 54.0, 54.0, 58.0, 52.0, 55.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 62.0, 61.0], "value": 61.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 80.0, 81.0, 79.0, 78.0, 79.0, 114.0, 84.0], "value": 82.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 129.0, 127.0, 127.0, 127.0, 120.0, 128.0, 123.0, 130.0, 118.0], "value": 124.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 156.0, 157.0, 153.0, 152.0, 154.0, 153.0, 159.0, 152.0, 153.0], "value": 154.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 61.0, 68.0, 63.0, 64.0, 63.0, 60.0, 61.0, 60.0], "value": 62.5, "unit": "score"}]}]} 03:11:40 INFO - Return code: 0 03:11:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:11:40 ERROR - # TBPL SUCCESS # 03:11:40 INFO - Running post-action listener: _resource_record_post_action 03:11:40 INFO - ##### 03:11:40 INFO - ##### Finished run-tests step (success) 03:11:40 INFO - ##### 03:11:40 INFO - Running post-run listener: _resource_record_post_run 03:11:40 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 290816; Write bytes: 519053312; Read time: 40; Write time: 392440 03:11:40 INFO - TinderboxPrint: CPU usage
13.4% 03:11:40 INFO - TinderboxPrint: I/O read bytes / time
290,816 / 40 03:11:40 INFO - TinderboxPrint: I/O write bytes / time
519,053,312 / 392,440 03:11:40 INFO - TinderboxPrint: CPU idle
8,212.2 (86.6%) 03:11:40 INFO - TinderboxPrint: CPU user
1,212.5 (12.8%) 03:11:40 INFO - TinderboxPrint: Swap in / out
0 / 0 03:11:40 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 212819968; Read time: 0; Write time: 220292 03:11:40 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 266240; Write bytes: 254033920; Read time: 24; Write time: 153212 03:11:41 INFO - Running post-run listener: _upload_blobber_files 03:11:41 INFO - Blob upload gear active. 03:11:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:11:41 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:11:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:11:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:11:41 INFO - (blobuploader) - INFO - Open directory for files ... 03:11:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:11:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:11:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:11:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:11:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:11:42 INFO - (blobuploader) - INFO - Done attempting. 03:11:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:11:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:11:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:11:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:11:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:11:46 INFO - (blobuploader) - INFO - Done attempting. 03:11:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:11:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:11:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:11:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:11:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:11:46 INFO - (blobuploader) - INFO - Done attempting. 03:11:46 INFO - (blobuploader) - INFO - Iteration through files over. 03:11:46 INFO - Return code: 0 03:11:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:11:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:11:46 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e9e7c0165dab5e6fe410ba780e41dc7dd14d5f4cb59861589dce0fbf62e5431aba073182e947cb24502e44f13734952040b8af9c56059ac58f901b7339f47222", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3df90f279af5d399a0f8840c842fd4bc48c14a6b7c1d5cecd223c83ded7fd798608d813596bbb53254affaaba0b16e68dbbb9b04ab571d84e6175fb358192be3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/645636d80236c8552edf01bd9d06bdfd381615cafba8ef4702d7ec9485912002529d3c1d70696b7aa391eb264d507b96ba0596bc5d67aa4b82ac25e977f26d78"} 03:11:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:11:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:11:46 INFO - Contents: 03:11:46 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e9e7c0165dab5e6fe410ba780e41dc7dd14d5f4cb59861589dce0fbf62e5431aba073182e947cb24502e44f13734952040b8af9c56059ac58f901b7339f47222", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3df90f279af5d399a0f8840c842fd4bc48c14a6b7c1d5cecd223c83ded7fd798608d813596bbb53254affaaba0b16e68dbbb9b04ab571d84e6175fb358192be3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/645636d80236c8552edf01bd9d06bdfd381615cafba8ef4702d7ec9485912002529d3c1d70696b7aa391eb264d507b96ba0596bc5d67aa4b82ac25e977f26d78"} 03:11:46 INFO - Running post-run listener: copy_logs_to_upload_dir 03:11:46 INFO - Copying logs to upload dir... 03:11:46 INFO - mkdir: /builds/slave/test/build/upload/logs 03:11:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.600843 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-06-29 03:11:46.736520) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 03:11:46.740542) ========= 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-1467193874.967769-489965380 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/e9e7c0165dab5e6fe410ba780e41dc7dd14d5f4cb59861589dce0fbf62e5431aba073182e947cb24502e44f13734952040b8af9c56059ac58f901b7339f47222", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3df90f279af5d399a0f8840c842fd4bc48c14a6b7c1d5cecd223c83ded7fd798608d813596bbb53254affaaba0b16e68dbbb9b04ab571d84e6175fb358192be3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/645636d80236c8552edf01bd9d06bdfd381615cafba8ef4702d7ec9485912002529d3c1d70696b7aa391eb264d507b96ba0596bc5d67aa4b82ac25e977f26d78"} build_url:https://queue.taskcluster.net/v1/task/dzEqWNsYQHicKavLnap7RA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011272 build_url: 'https://queue.taskcluster.net/v1/task/dzEqWNsYQHicKavLnap7RA/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/e9e7c0165dab5e6fe410ba780e41dc7dd14d5f4cb59861589dce0fbf62e5431aba073182e947cb24502e44f13734952040b8af9c56059ac58f901b7339f47222", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3df90f279af5d399a0f8840c842fd4bc48c14a6b7c1d5cecd223c83ded7fd798608d813596bbb53254affaaba0b16e68dbbb9b04ab571d84e6175fb358192be3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/645636d80236c8552edf01bd9d06bdfd381615cafba8ef4702d7ec9485912002529d3c1d70696b7aa391eb264d507b96ba0596bc5d67aa4b82ac25e977f26d78"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 03:11:46.769565) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 03:11:46.770241) ========= 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-1467193874.967769-489965380 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004523 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 03:11:46.854960) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 03:11:46.855866) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 03:11:46.856726) ========= ========= Total master_lag: 0.16 =========