builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-048 starttime: 1465401197.93 results: success (0) buildid: 20160608082029 builduid: 4f07cda2c93f4ef1bc4c680291701c8b revision: daadc8567a11c6165986c05719fa44a7ed8af839 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 08:53:17.928727) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 08:53:17.929357) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 08:53:17.929654) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 08:53:17.952905) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 08:53:17.953406) ========= 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=fa44defc139c4ba8574fe040000001db-1465400314.319056-228213986 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-08 08:53:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 88.2M=0s 2016-06-08 08:53:18 (88.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.087442 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 08:53:18.064179) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 08:53:18.064526) ========= 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=fa44defc139c4ba8574fe040000001db-1465400314.319056-228213986 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018338 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 08:53:18.124532) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-08 08:53:18.124843) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev daadc8567a11c6165986c05719fa44a7ed8af839 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev daadc8567a11c6165986c05719fa44a7ed8af839 --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=fa44defc139c4ba8574fe040000001db-1465400314.319056-228213986 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-08 08:53:18,232 truncating revision to first 12 chars 2016-06-08 08:53:18,232 Setting DEBUG logging. 2016-06-08 08:53:18,232 attempt 1/10 2016-06-08 08:53:18,232 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/daadc8567a11?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-08 08:53:18,763 unpacking tar archive at: fx-team-daadc8567a11/testing/mozharness/ program finished with exit code 0 elapsedTime=1.282870 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-08 08:53:19.421562) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 08:53:19.421866) ========= script_repo_revision: daadc8567a11c6165986c05719fa44a7ed8af839 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 08:53:19.422256) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 08:53:19.422550) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 08:53:19.431362) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-06-08 08:53:19.431699) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa44defc139c4ba8574fe040000001db-1465400314.319056-228213986 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:53:19 INFO - MultiFileLogger online at 20160608 08:53:19 in /builds/slave/test 08:53:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 08:53:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:53:19 INFO - {'append_to_log': False, 08:53:19 INFO - 'base_work_dir': '/builds/slave/test', 08:53:19 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 08:53:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:53:19 INFO - 'branch': 'Fx-Team-Non-PGO', 08:53:19 INFO - 'buildbot_json_path': 'buildprops.json', 08:53:19 INFO - 'config_files': ('talos/linux_config.py',), 08:53:19 INFO - 'default_actions': ('clobber', 08:53:19 INFO - 'read-buildbot-config', 08:53:19 INFO - 'download-and-extract', 08:53:19 INFO - 'populate-webroot', 08:53:19 INFO - 'create-virtualenv', 08:53:19 INFO - 'install', 08:53:19 INFO - 'run-tests'), 08:53:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:53:19 INFO - 'download_minidump_stackwalk': True, 08:53:19 INFO - 'download_symbols': 'ondemand', 08:53:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:53:19 INFO - 'tooltool.py': '/tools/tooltool.py', 08:53:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:53:19 INFO - '/tools/misc-python/virtualenv.py')}, 08:53:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:53:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:53:19 INFO - 'installer_path': 'installer.exe', 08:53:19 INFO - 'log_level': 'info', 08:53:19 INFO - 'log_name': 'talos', 08:53:19 INFO - 'log_to_console': True, 08:53:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:53:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:53:19 INFO - 'opt_config_files': (), 08:53:19 INFO - 'pip_index': False, 08:53:19 INFO - 'sps_profile': False, 08:53:19 INFO - 'sps_profile_interval': 0, 08:53:19 INFO - 'suite': 'dromaeojs', 08:53:19 INFO - 'system_bits': '32', 08:53:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:53:19 INFO - 'title': 'talos-linux64-ix-048', 08:53:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:53:19 INFO - 'use_talos_json': True, 08:53:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:53:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:53:19 INFO - 'work_dir': 'build'} 08:53:19 INFO - ##### 08:53:19 INFO - ##### Running clobber step. 08:53:19 INFO - ##### 08:53:19 INFO - Running pre-action listener: _resource_record_pre_action 08:53:19 INFO - Running main action method: clobber 08:53:19 INFO - rmtree: /builds/slave/test/build 08:53:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:53:20 INFO - Running post-action listener: _resource_record_post_action 08:53:20 INFO - ##### 08:53:20 INFO - ##### Finished clobber step (success) 08:53:20 INFO - ##### 08:53:20 INFO - ##### 08:53:20 INFO - ##### Running read-buildbot-config step. 08:53:20 INFO - ##### 08:53:20 INFO - Running pre-action listener: _resource_record_pre_action 08:53:20 INFO - Running main action method: read_buildbot_config 08:53:20 INFO - Using buildbot properties: 08:53:20 INFO - { 08:53:20 INFO - "project": "", 08:53:20 INFO - "product": "firefox", 08:53:20 INFO - "script_repo_revision": "production", 08:53:20 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:53:20 INFO - "repository": "", 08:53:20 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 08:53:20 INFO - "buildid": "20160608082029", 08:53:20 INFO - "pgo_build": "False", 08:53:20 INFO - "basedir": "/builds/slave/test", 08:53:20 INFO - "buildnumber": 3063, 08:53:20 INFO - "slavename": "talos-linux64-ix-048", 08:53:20 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:53:20 INFO - "platform": "ubuntu64_hw", 08:53:20 INFO - "scheduler": "tests-fx-team-linux64-talos", 08:53:20 INFO - "branch": "fx-team", 08:53:20 INFO - "repo_path": "integration/fx-team", 08:53:20 INFO - "revision": "daadc8567a11c6165986c05719fa44a7ed8af839", 08:53:20 INFO - "stage_platform": "linux64", 08:53:20 INFO - "builduid": "4f07cda2c93f4ef1bc4c680291701c8b", 08:53:20 INFO - "slavebuilddir": "test" 08:53:20 INFO - } 08:53:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/JEf-drlOQwek0NmKtpUbKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 08:53:20 INFO - Running post-action listener: _resource_record_post_action 08:53:20 INFO - ##### 08:53:20 INFO - ##### Finished read-buildbot-config step (success) 08:53:20 INFO - ##### 08:53:20 INFO - ##### 08:53:20 INFO - ##### Running download-and-extract step. 08:53:20 INFO - ##### 08:53:20 INFO - Running pre-action listener: _resource_record_pre_action 08:53:20 INFO - Running main action method: download_and_extract 08:53:20 INFO - mkdir: /builds/slave/test/build/tests 08:53: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')]} 08:53:20 INFO - https://queue.taskcluster.net/v1/task/JEf-drlOQwek0NmKtpUbKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:53:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JEf-drlOQwek0NmKtpUbKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:53:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JEf-drlOQwek0NmKtpUbKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:53:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JEf-drlOQwek0NmKtpUbKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:53:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JEf-drlOQwek0NmKtpUbKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:53:23 INFO - Downloaded 1361 bytes. 08:53:23 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:53:23 INFO - Using the following test package requirements: 08:53:23 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:53:23 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:53:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:53:23 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:53:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:53:23 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:53:23 INFO - u'jsshell-linux-x86_64.zip'], 08:53:23 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:53:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:53:23 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:53:23 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:53:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:53:23 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:53:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:53:23 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:53:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:53:23 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:53:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:53:23 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:53: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')]} 08:53:23 INFO - https://queue.taskcluster.net/v1/task/JEf-drlOQwek0NmKtpUbKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:53:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JEf-drlOQwek0NmKtpUbKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:53:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JEf-drlOQwek0NmKtpUbKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:53:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JEf-drlOQwek0NmKtpUbKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:53:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JEf-drlOQwek0NmKtpUbKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:53:24 INFO - Downloaded 22878228 bytes. 08:53:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:53:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:53:26 INFO - Return code: 0 08:53:26 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:53:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:53:26 INFO - https://queue.taskcluster.net/v1/task/JEf-drlOQwek0NmKtpUbKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:53:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JEf-drlOQwek0NmKtpUbKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:53:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JEf-drlOQwek0NmKtpUbKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:53:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JEf-drlOQwek0NmKtpUbKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:53:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JEf-drlOQwek0NmKtpUbKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:53:27 INFO - Downloaded 22878228 bytes. 08:53:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:53:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:53:28 INFO - Return code: 0 08:53:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:53:28 INFO - https://queue.taskcluster.net/v1/task/JEf-drlOQwek0NmKtpUbKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:53:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JEf-drlOQwek0NmKtpUbKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:53:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JEf-drlOQwek0NmKtpUbKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:53:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JEf-drlOQwek0NmKtpUbKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:53:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JEf-drlOQwek0NmKtpUbKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:53:30 INFO - Downloaded 10833369 bytes. 08:53:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:53:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:53:30 INFO - Return code: 0 08:53: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')]} 08:53:30 INFO - https://queue.taskcluster.net/v1/task/JEf-drlOQwek0NmKtpUbKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:53:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JEf-drlOQwek0NmKtpUbKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:53:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JEf-drlOQwek0NmKtpUbKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:53:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JEf-drlOQwek0NmKtpUbKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:53:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JEf-drlOQwek0NmKtpUbKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:53:34 INFO - Downloaded 55337484 bytes. 08:53:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JEf-drlOQwek0NmKtpUbKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:53:34 INFO - mkdir: /builds/slave/test/properties 08:53:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:53:34 INFO - Writing to file /builds/slave/test/properties/build_url 08:53:34 INFO - Contents: 08:53:34 INFO - build_url:https://queue.taskcluster.net/v1/task/JEf-drlOQwek0NmKtpUbKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:53:35 INFO - Running post-action listener: _resource_record_post_action 08:53:35 INFO - Running post-action listener: set_extra_try_arguments 08:53:35 INFO - ##### 08:53:35 INFO - ##### Finished download-and-extract step (success) 08:53:35 INFO - ##### 08:53:35 INFO - ##### 08:53:35 INFO - ##### Running populate-webroot step. 08:53:35 INFO - ##### 08:53:35 INFO - Running pre-action listener: _resource_record_pre_action 08:53:35 INFO - Running main action method: populate_webroot 08:53:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:53:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:53:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:53:35 INFO - '--tppagecycles', 08:53:35 INFO - '7'], 08:53:35 INFO - 'tests': ['tsvgm']}}, 08:53:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:53:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:53:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:53:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:53:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:53:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:53:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:35 INFO - 'talos_options': ['--disable-e10s'], 08:53:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:53:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:53:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:35 INFO - 'talos_options': ['--disable-e10s'], 08:53:35 INFO - 'tests': ['damp', 'tps']}, 08:53:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:35 INFO - 'tests': ['damp', 'tps']}, 08:53:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:53:35 INFO - 'tests': ['dromaeo_dom']}, 08:53:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:53:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:53:35 INFO - 'tests': ['a11yr', 08:53:35 INFO - 'ts_paint', 08:53:35 INFO - 'tpaint', 08:53:35 INFO - 'sessionrestore', 08:53:35 INFO - 'sessionrestore_no_auto_restore', 08:53:35 INFO - 'tabpaint']}, 08:53:35 INFO - 'other-e10s': {'tests': ['a11yr', 08:53:35 INFO - 'ts_paint', 08:53:35 INFO - 'tpaint', 08:53:35 INFO - 'sessionrestore', 08:53:35 INFO - 'sessionrestore_no_auto_restore', 08:53:35 INFO - 'tabpaint']}, 08:53:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:53:35 INFO - 'ts_paint', 08:53:35 INFO - 'tpaint', 08:53:35 INFO - 'sessionrestore', 08:53:35 INFO - 'sessionrestore_no_auto_restore', 08:53:35 INFO - 'tabpaint']}, 08:53:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:53:35 INFO - 'ts_paint', 08:53:35 INFO - 'tpaint', 08:53:35 INFO - 'sessionrestore', 08:53:35 INFO - 'sessionrestore_no_auto_restore', 08:53:35 INFO - 'tabpaint']}, 08:53:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:53:35 INFO - 'tests': ['a11yr', 08:53:35 INFO - 'ts_paint', 08:53:35 INFO - 'tpaint', 08:53:35 INFO - 'sessionrestore', 08:53:35 INFO - 'sessionrestore_no_auto_restore', 08:53:35 INFO - 'tabpaint']}, 08:53:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:53:35 INFO - 'tests': ['a11yr', 08:53:35 INFO - 'ts_paint', 08:53:35 INFO - 'tpaint', 08:53:35 INFO - 'sessionrestore', 08:53:35 INFO - 'sessionrestore_no_auto_restore', 08:53:35 INFO - 'tabpaint']}, 08:53:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:53:35 INFO - 'tests': ['tsvgx', 08:53:35 INFO - 'tsvgr_opacity', 08:53:35 INFO - 'tart', 08:53:35 INFO - 'tscrollx', 08:53:35 INFO - 'cart']}, 08:53:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:53:35 INFO - 'tsvgr_opacity', 08:53:35 INFO - 'tart', 08:53:35 INFO - 'tscrollx', 08:53:35 INFO - 'cart']}, 08:53:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:35 INFO - 'talos_options': ['--disable-e10s'], 08:53:35 INFO - 'tests': ['tp5o']}, 08:53:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:35 INFO - 'tests': ['tp5o']}, 08:53:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:35 INFO - 'talos_options': ['--disable-e10s', 08:53:35 INFO - '--xperf_path', 08:53:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:53:35 INFO - 'tests': ['tp5n']}, 08:53:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:35 INFO - 'talos_options': ['--xperf_path', 08:53:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:53:35 INFO - 'tests': ['tp5n']}}, 08:53:35 INFO - 'talos.zip': {'path': '', 08:53:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:53:35 INFO - Running post-action listener: _resource_record_post_action 08:53:35 INFO - ##### 08:53:35 INFO - ##### Finished populate-webroot step (success) 08:53:35 INFO - ##### 08:53:35 INFO - ##### 08:53:35 INFO - ##### Running create-virtualenv step. 08:53:35 INFO - ##### 08:53:35 INFO - Running pre-action listener: _resource_record_pre_action 08:53:35 INFO - Running main action method: create_virtualenv 08:53:35 INFO - Creating virtualenv /builds/slave/test/build/venv 08:53:35 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 08:53:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:53:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:53:35 INFO - Using real prefix '/usr' 08:53:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:53:36 INFO - Installing distribute.............................................................................................................................................................................................done. 08:53:38 INFO - Installing pip.................done. 08:53:38 INFO - Return code: 0 08:53:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:53:38 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')]} 08:53:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:38 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')]} 08:53:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:38 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 0x7f1ca550bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ca1c0>, '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 0x11cb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11cb550>, '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': 'fa44defc139c4ba8574fe040000001db-1465400314.319056-228213986', '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 08:53:38 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 08:53:38 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 08:53:38 INFO - Using env: {'DISPLAY': ':0', 08:53:38 INFO - 'HOME': '/home/cltbld', 08:53:38 INFO - 'LANG': 'en_US.UTF-8', 08:53:38 INFO - 'LANGUAGE': 'en_US:en', 08:53:38 INFO - 'LOGNAME': 'cltbld', 08:53:38 INFO - 'MAIL': '/var/mail/cltbld', 08:53:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:38 INFO - 'MOZ_NO_REMOTE': '1', 08:53:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:38 INFO - 'NO_EM_RESTART': '1', 08:53:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:38 INFO - 'PWD': '/builds/slave/test', 08:53:38 INFO - 'SHELL': '/bin/bash', 08:53:38 INFO - 'SHLVL': '1', 08:53:38 INFO - 'TERM': 'linux', 08:53:38 INFO - 'TMOUT': '86400', 08:53:38 INFO - 'USER': 'cltbld', 08:53:38 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1465400314.319056-228213986', 08:53:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:38 INFO - '_': '/tools/buildbot/bin/python'} 08:53:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:38 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 08:53:38 INFO - Cleaning up... 08:53:38 INFO - Return code: 0 08:53:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:53:38 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')]} 08:53:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:38 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')]} 08:53:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:38 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 0x7f1ca550bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ca1c0>, '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 0x11cb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11cb550>, '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': 'fa44defc139c4ba8574fe040000001db-1465400314.319056-228213986', '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 08:53:38 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 08:53:38 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 08:53:38 INFO - Using env: {'DISPLAY': ':0', 08:53:38 INFO - 'HOME': '/home/cltbld', 08:53:38 INFO - 'LANG': 'en_US.UTF-8', 08:53:38 INFO - 'LANGUAGE': 'en_US:en', 08:53:38 INFO - 'LOGNAME': 'cltbld', 08:53:38 INFO - 'MAIL': '/var/mail/cltbld', 08:53:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:38 INFO - 'MOZ_NO_REMOTE': '1', 08:53:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:38 INFO - 'NO_EM_RESTART': '1', 08:53:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:38 INFO - 'PWD': '/builds/slave/test', 08:53:38 INFO - 'SHELL': '/bin/bash', 08:53:38 INFO - 'SHLVL': '1', 08:53:38 INFO - 'TERM': 'linux', 08:53:38 INFO - 'TMOUT': '86400', 08:53:38 INFO - 'USER': 'cltbld', 08:53:38 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1465400314.319056-228213986', 08:53:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:38 INFO - '_': '/tools/buildbot/bin/python'} 08:53:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:38 INFO - Downloading/unpacking psutil>=3.1.1 08:53: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 08:53: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 08:53: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 08:53: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 08:53: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 08:53: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 08:53:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:53:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:53:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:53:41 INFO - Installing collected packages: psutil 08:53:41 INFO - Running setup.py install for psutil 08:53:41 INFO - building 'psutil._psutil_linux' extension 08:53:41 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 08:53:41 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 08:53:41 INFO - building 'psutil._psutil_posix' extension 08:53:41 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 08:53:41 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 08:53:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:53:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:53:41 INFO - Successfully installed psutil 08:53:41 INFO - Cleaning up... 08:53:41 INFO - Return code: 0 08:53:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:53: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')]} 08:53:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53: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')]} 08:53:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1ca550bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ca1c0>, '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 0x11cb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11cb550>, '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': 'fa44defc139c4ba8574fe040000001db-1465400314.319056-228213986', '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 08:53:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:53:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:53:41 INFO - Using env: {'DISPLAY': ':0', 08:53:41 INFO - 'HOME': '/home/cltbld', 08:53:41 INFO - 'LANG': 'en_US.UTF-8', 08:53:41 INFO - 'LANGUAGE': 'en_US:en', 08:53:41 INFO - 'LOGNAME': 'cltbld', 08:53:41 INFO - 'MAIL': '/var/mail/cltbld', 08:53:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:41 INFO - 'MOZ_NO_REMOTE': '1', 08:53:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:41 INFO - 'NO_EM_RESTART': '1', 08:53:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:41 INFO - 'PWD': '/builds/slave/test', 08:53:41 INFO - 'SHELL': '/bin/bash', 08:53:41 INFO - 'SHLVL': '1', 08:53:41 INFO - 'TERM': 'linux', 08:53:41 INFO - 'TMOUT': '86400', 08:53:41 INFO - 'USER': 'cltbld', 08:53:41 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1465400314.319056-228213986', 08:53:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:41 INFO - '_': '/tools/buildbot/bin/python'} 08:53:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:53:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:53:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:53:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:53:43 INFO - Installing collected packages: mozsystemmonitor 08:53:43 INFO - Running setup.py install for mozsystemmonitor 08:53:43 INFO - Successfully installed mozsystemmonitor 08:53:43 INFO - Cleaning up... 08:53:43 INFO - Return code: 0 08:53:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:53:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:53:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:53:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1ca550bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ca1c0>, '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 0x11cb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11cb550>, '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': 'fa44defc139c4ba8574fe040000001db-1465400314.319056-228213986', '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 08:53:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:53:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:53:43 INFO - Using env: {'DISPLAY': ':0', 08:53:43 INFO - 'HOME': '/home/cltbld', 08:53:43 INFO - 'LANG': 'en_US.UTF-8', 08:53:43 INFO - 'LANGUAGE': 'en_US:en', 08:53:43 INFO - 'LOGNAME': 'cltbld', 08:53:43 INFO - 'MAIL': '/var/mail/cltbld', 08:53:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:43 INFO - 'MOZ_NO_REMOTE': '1', 08:53:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:43 INFO - 'NO_EM_RESTART': '1', 08:53:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:43 INFO - 'PWD': '/builds/slave/test', 08:53:43 INFO - 'SHELL': '/bin/bash', 08:53:43 INFO - 'SHLVL': '1', 08:53:43 INFO - 'TERM': 'linux', 08:53:43 INFO - 'TMOUT': '86400', 08:53:43 INFO - 'USER': 'cltbld', 08:53:43 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1465400314.319056-228213986', 08:53:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:43 INFO - '_': '/tools/buildbot/bin/python'} 08:53:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:44 INFO - Downloading/unpacking jsonschema==2.5.1 08:53:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:53:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:53: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 08:53: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 08:53: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 08:53: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 08:53: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 08:53: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 08:53:46 INFO - Downloading functools32-3.2.3-2.tar.gz 08:53:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:53:46 INFO - warning: no files found matching '*.txt' 08:53:46 INFO - no previously-included directories found matching 'build' 08:53:46 INFO - no previously-included directories found matching 'dist' 08:53:46 INFO - no previously-included directories found matching '.git*' 08:53:46 INFO - Installing collected packages: jsonschema, functools32 08:53:46 INFO - Running setup.py install for functools32 08:53:46 INFO - warning: no files found matching '*.txt' 08:53:46 INFO - no previously-included directories found matching 'build' 08:53:46 INFO - no previously-included directories found matching 'dist' 08:53:46 INFO - no previously-included directories found matching '.git*' 08:53:46 INFO - Successfully installed jsonschema functools32 08:53:46 INFO - Cleaning up... 08:53:46 INFO - Return code: 0 08:53:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:53:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:53:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1ca550bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ca1c0>, '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 0x11cb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11cb550>, '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': 'fa44defc139c4ba8574fe040000001db-1465400314.319056-228213986', '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 08:53:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:53:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:53:46 INFO - Using env: {'DISPLAY': ':0', 08:53:46 INFO - 'HOME': '/home/cltbld', 08:53:46 INFO - 'LANG': 'en_US.UTF-8', 08:53:46 INFO - 'LANGUAGE': 'en_US:en', 08:53:46 INFO - 'LOGNAME': 'cltbld', 08:53:46 INFO - 'MAIL': '/var/mail/cltbld', 08:53:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:46 INFO - 'MOZ_NO_REMOTE': '1', 08:53:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:46 INFO - 'NO_EM_RESTART': '1', 08:53:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:46 INFO - 'PWD': '/builds/slave/test', 08:53:46 INFO - 'SHELL': '/bin/bash', 08:53:46 INFO - 'SHLVL': '1', 08:53:46 INFO - 'TERM': 'linux', 08:53:46 INFO - 'TMOUT': '86400', 08:53:46 INFO - 'USER': 'cltbld', 08:53:46 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1465400314.319056-228213986', 08:53:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:46 INFO - '_': '/tools/buildbot/bin/python'} 08:53:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:46 INFO - Downloading/unpacking blobuploader==1.2.4 08:53: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 08:53: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 08:53: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 08:53: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 08:53: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 08:53: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 08:53:48 INFO - Downloading blobuploader-1.2.4.tar.gz 08:53:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:53:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:53:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:53: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 08:53: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 08:53: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 08:53: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 08:53: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 08:53: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 08:53:49 INFO - Downloading docopt-0.6.1.tar.gz 08:53:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:53:49 INFO - Installing collected packages: blobuploader, requests, docopt 08:53:49 INFO - Running setup.py install for blobuploader 08:53:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:53:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:53:49 INFO - Running setup.py install for requests 08:53:49 INFO - Running setup.py install for docopt 08:53:49 INFO - Successfully installed blobuploader requests docopt 08:53:49 INFO - Cleaning up... 08:53:49 INFO - Return code: 0 08:53:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:53:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:53:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:53:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:49 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 0x7f1ca550bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ca1c0>, '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 0x11cb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11cb550>, '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': 'fa44defc139c4ba8574fe040000001db-1465400314.319056-228213986', '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 08:53:49 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 08:53:49 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 08:53:49 INFO - Using env: {'DISPLAY': ':0', 08:53:49 INFO - 'HOME': '/home/cltbld', 08:53:49 INFO - 'LANG': 'en_US.UTF-8', 08:53:49 INFO - 'LANGUAGE': 'en_US:en', 08:53:49 INFO - 'LOGNAME': 'cltbld', 08:53:49 INFO - 'MAIL': '/var/mail/cltbld', 08:53:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:49 INFO - 'MOZ_NO_REMOTE': '1', 08:53:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:49 INFO - 'NO_EM_RESTART': '1', 08:53:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:49 INFO - 'PWD': '/builds/slave/test', 08:53:49 INFO - 'SHELL': '/bin/bash', 08:53:49 INFO - 'SHLVL': '1', 08:53:49 INFO - 'TERM': 'linux', 08:53:49 INFO - 'TMOUT': '86400', 08:53:49 INFO - 'USER': 'cltbld', 08:53:49 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1465400314.319056-228213986', 08:53:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:49 INFO - '_': '/tools/buildbot/bin/python'} 08:53:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:53:50 INFO - Running setup.py (path:/tmp/pip-oKAUDm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:53:50 INFO - Running setup.py (path:/tmp/pip-EEJiDh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:53:50 INFO - Running setup.py (path:/tmp/pip-HCER14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:53:50 INFO - Running setup.py (path:/tmp/pip-uEU9rB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:53:50 INFO - Running setup.py (path:/tmp/pip-RDBQTp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:53:50 INFO - Running setup.py (path:/tmp/pip-0sk0wn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:53:50 INFO - Running setup.py (path:/tmp/pip-INIU2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:53:50 INFO - Running setup.py (path:/tmp/pip-b9CE2j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:53:50 INFO - Running setup.py (path:/tmp/pip-jynK5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:53:50 INFO - Running setup.py (path:/tmp/pip-LZfTuo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:53:50 INFO - Running setup.py (path:/tmp/pip-5c_rTL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:53:50 INFO - Running setup.py (path:/tmp/pip-tm4Awl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:53:51 INFO - Running setup.py (path:/tmp/pip-SrMFvH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:53:51 INFO - Running setup.py (path:/tmp/pip-dcPjvL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:53:51 INFO - Running setup.py (path:/tmp/pip-m5R_g0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:53:51 INFO - Running setup.py (path:/tmp/pip-gbaqDT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:53:51 INFO - Running setup.py (path:/tmp/pip-nVOt5R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:53:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:53:51 INFO - Running setup.py install for manifestparser 08:53:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:53:51 INFO - Running setup.py install for mozcrash 08:53:51 INFO - Running setup.py install for mozdebug 08:53:51 INFO - Running setup.py install for mozdevice 08:53:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:53:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:53:51 INFO - Running setup.py install for mozfile 08:53:51 INFO - Running setup.py install for mozhttpd 08:53:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:53:52 INFO - Running setup.py install for mozinfo 08:53:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:53:52 INFO - Running setup.py install for mozInstall 08:53:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:53:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:53:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:53:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:53:52 INFO - Running setup.py install for mozleak 08:53:52 INFO - Running setup.py install for mozlog 08:53:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:53:52 INFO - Running setup.py install for moznetwork 08:53:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:53:52 INFO - Running setup.py install for mozprocess 08:53:52 INFO - Running setup.py install for mozprofile 08:53:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:53:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:53:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:53:52 INFO - Running setup.py install for mozrunner 08:53:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:53:52 INFO - Running setup.py install for mozscreenshot 08:53:52 INFO - Running setup.py install for moztest 08:53:53 INFO - Running setup.py install for mozversion 08:53:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:53:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:53:53 INFO - Cleaning up... 08:53:53 INFO - Return code: 0 08:53:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:53:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:53:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:53 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 0x7f1ca550bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ca1c0>, '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 0x11cb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11cb550>, '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': 'fa44defc139c4ba8574fe040000001db-1465400314.319056-228213986', '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 08:53:53 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 08:53:53 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 08:53:53 INFO - Using env: {'DISPLAY': ':0', 08:53:53 INFO - 'HOME': '/home/cltbld', 08:53:53 INFO - 'LANG': 'en_US.UTF-8', 08:53:53 INFO - 'LANGUAGE': 'en_US:en', 08:53:53 INFO - 'LOGNAME': 'cltbld', 08:53:53 INFO - 'MAIL': '/var/mail/cltbld', 08:53:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:53 INFO - 'MOZ_NO_REMOTE': '1', 08:53:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:53 INFO - 'NO_EM_RESTART': '1', 08:53:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:53 INFO - 'PWD': '/builds/slave/test', 08:53:53 INFO - 'SHELL': '/bin/bash', 08:53:53 INFO - 'SHLVL': '1', 08:53:53 INFO - 'TERM': 'linux', 08:53:53 INFO - 'TMOUT': '86400', 08:53:53 INFO - 'USER': 'cltbld', 08:53:53 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1465400314.319056-228213986', 08:53:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:53 INFO - '_': '/tools/buildbot/bin/python'} 08:53:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:53:53 INFO - Running setup.py (path:/tmp/pip-SB9gpz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:53:53 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)) 08:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:53:53 INFO - Running setup.py (path:/tmp/pip-R67VzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:53:53 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)) 08:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:53:53 INFO - Running setup.py (path:/tmp/pip-8VXcCg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:53:53 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)) 08:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:53:53 INFO - Running setup.py (path:/tmp/pip-1WWo_K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:53:53 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)) 08:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:53:53 INFO - Running setup.py (path:/tmp/pip-Dl6cXl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:53:53 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)) 08:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:53:53 INFO - Running setup.py (path:/tmp/pip-_TNaO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:53:53 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)) 08:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:53:53 INFO - Running setup.py (path:/tmp/pip-ZNZ9Wu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:53:53 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)) 08:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:53:53 INFO - Running setup.py (path:/tmp/pip-tsHB4W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:53:53 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)) 08:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:53:53 INFO - Running setup.py (path:/tmp/pip-wqes5X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:53:54 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)) 08:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:53:54 INFO - Running setup.py (path:/tmp/pip-mwyuRx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:53:54 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)) 08:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:53:54 INFO - Running setup.py (path:/tmp/pip-XotFTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:53:54 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)) 08:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:53:54 INFO - Running setup.py (path:/tmp/pip-s3e4fd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:53:54 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)) 08:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:53:54 INFO - Running setup.py (path:/tmp/pip-NPoHPG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:53:54 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)) 08:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:53:54 INFO - Running setup.py (path:/tmp/pip-SEa1lx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:53:54 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)) 08:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:53:54 INFO - Running setup.py (path:/tmp/pip-4nRwYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:53:54 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)) 08:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:53:54 INFO - Running setup.py (path:/tmp/pip-eC9skO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:53:54 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)) 08:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:53:54 INFO - Running setup.py (path:/tmp/pip-VXoYBs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:53:54 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)) 08:53:54 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)) 08:53:54 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)) 08:53:54 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)) 08:53:54 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)) 08:53:54 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)) 08:53:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:53:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:56 INFO - Downloading blessings-1.6.tar.gz 08:53:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:53:56 INFO - Installing collected packages: blessings 08:53:56 INFO - Running setup.py install for blessings 08:53:56 INFO - Successfully installed blessings 08:53:56 INFO - Cleaning up... 08:53:56 INFO - Return code: 0 08:53:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:53:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:53:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:53:56 INFO - Reading from file tmpfile_stdout 08:53:56 INFO - Current package versions: 08:53:56 INFO - argparse == 1.2.1 08:53:56 INFO - blessings == 1.6 08:53:56 INFO - blobuploader == 1.2.4 08:53:56 INFO - docopt == 0.6.1 08:53:56 INFO - functools32 == 3.2.3-2 08:53:56 INFO - jsonschema == 2.5.1 08:53:56 INFO - manifestparser == 1.1 08:53:56 INFO - mozInstall == 1.12 08:53:56 INFO - mozcrash == 0.17 08:53:56 INFO - mozdebug == 0.1 08:53:56 INFO - mozdevice == 0.48 08:53:56 INFO - mozfile == 1.2 08:53:56 INFO - mozhttpd == 0.7 08:53:56 INFO - mozinfo == 0.9 08:53:56 INFO - mozleak == 0.1 08:53:56 INFO - mozlog == 3.2 08:53:56 INFO - moznetwork == 0.27 08:53:56 INFO - mozprocess == 0.22 08:53:56 INFO - mozprofile == 0.28 08:53:56 INFO - mozrunner == 6.11 08:53:56 INFO - mozscreenshot == 0.1 08:53:56 INFO - mozsystemmonitor == 0.3 08:53:56 INFO - moztest == 0.7 08:53:56 INFO - mozversion == 1.4 08:53:56 INFO - psutil == 3.1.1 08:53:56 INFO - requests == 1.2.3 08:53:56 INFO - wsgiref == 0.1.2 08:53:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:53:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:53:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:53:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:56 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 0x7f1ca550bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ca1c0>, '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 0x11cb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11cb550>, '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': 'fa44defc139c4ba8574fe040000001db-1465400314.319056-228213986', '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 08:53:56 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 08:53:56 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 08:53:56 INFO - Using env: {'DISPLAY': ':0', 08:53:56 INFO - 'HOME': '/home/cltbld', 08:53:56 INFO - 'LANG': 'en_US.UTF-8', 08:53:56 INFO - 'LANGUAGE': 'en_US:en', 08:53:56 INFO - 'LOGNAME': 'cltbld', 08:53:56 INFO - 'MAIL': '/var/mail/cltbld', 08:53:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:56 INFO - 'MOZ_NO_REMOTE': '1', 08:53:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:56 INFO - 'NO_EM_RESTART': '1', 08:53:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:56 INFO - 'PWD': '/builds/slave/test', 08:53:56 INFO - 'SHELL': '/bin/bash', 08:53:56 INFO - 'SHLVL': '1', 08:53:56 INFO - 'TERM': 'linux', 08:53:56 INFO - 'TMOUT': '86400', 08:53:56 INFO - 'USER': 'cltbld', 08:53:56 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1465400314.319056-228213986', 08:53:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:56 INFO - '_': '/tools/buildbot/bin/python'} 08:53:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:57 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)) 08:53:57 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)) 08:53:57 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)) 08:53:57 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)) 08:53:57 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)) 08:53:57 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)) 08:53:57 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)) 08:53:57 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)) 08:53:57 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)) 08:53:57 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)) 08:53:57 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)) 08:53:57 INFO - Cleaning up... 08:53:57 INFO - Return code: 0 08:53:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:53:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:53:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:57 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 0x7f1ca550bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ca1c0>, '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 0x11cb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11cb550>, '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': 'fa44defc139c4ba8574fe040000001db-1465400314.319056-228213986', '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 08:53:57 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 08:53:57 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 08:53:57 INFO - Using env: {'DISPLAY': ':0', 08:53:57 INFO - 'HOME': '/home/cltbld', 08:53:57 INFO - 'LANG': 'en_US.UTF-8', 08:53:57 INFO - 'LANGUAGE': 'en_US:en', 08:53:57 INFO - 'LOGNAME': 'cltbld', 08:53:57 INFO - 'MAIL': '/var/mail/cltbld', 08:53:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:57 INFO - 'MOZ_NO_REMOTE': '1', 08:53:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:57 INFO - 'NO_EM_RESTART': '1', 08:53:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:57 INFO - 'PWD': '/builds/slave/test', 08:53:57 INFO - 'SHELL': '/bin/bash', 08:53:57 INFO - 'SHLVL': '1', 08:53:57 INFO - 'TERM': 'linux', 08:53:57 INFO - 'TMOUT': '86400', 08:53:57 INFO - 'USER': 'cltbld', 08:53:57 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1465400314.319056-228213986', 08:53:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:57 INFO - '_': '/tools/buildbot/bin/python'} 08:53:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:53:57 INFO - Cleaning up... 08:53:57 INFO - Return code: 0 08:53:57 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:53:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:53:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:57 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 0x7f1ca550bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10708a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ca1c0>, '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 0x11cb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11cb550>, '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': 'fa44defc139c4ba8574fe040000001db-1465400314.319056-228213986', '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 08:53:57 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 08:53:57 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 08:53:57 INFO - Using env: {'DISPLAY': ':0', 08:53:57 INFO - 'HOME': '/home/cltbld', 08:53:57 INFO - 'LANG': 'en_US.UTF-8', 08:53:57 INFO - 'LANGUAGE': 'en_US:en', 08:53:57 INFO - 'LOGNAME': 'cltbld', 08:53:57 INFO - 'MAIL': '/var/mail/cltbld', 08:53:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:57 INFO - 'MOZ_NO_REMOTE': '1', 08:53:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:57 INFO - 'NO_EM_RESTART': '1', 08:53:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:57 INFO - 'PWD': '/builds/slave/test', 08:53:57 INFO - 'SHELL': '/bin/bash', 08:53:57 INFO - 'SHLVL': '1', 08:53:57 INFO - 'TERM': 'linux', 08:53:57 INFO - 'TMOUT': '86400', 08:53:57 INFO - 'USER': 'cltbld', 08:53:57 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1465400314.319056-228213986', 08:53:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:57 INFO - '_': '/tools/buildbot/bin/python'} 08:53:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:57 INFO - Downloading/unpacking flake8 08:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:53:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:53:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:54:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:54:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:54:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:54:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:54:00 INFO - no previously-included directories found matching 'docs/_build' 08:54:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:54:00 INFO - Running setup.py install for pep8 08:54:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:54:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:54:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:54:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:54:00 INFO - no previously-included directories found matching 'docs/_build' 08:54:00 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:54:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:54:00 INFO - Cleaning up... 08:54:00 INFO - Return code: 0 08:54:00 INFO - Running post-action listener: _resource_record_post_action 08:54:00 INFO - Running post-action listener: _start_resource_monitoring 08:54:00 INFO - Starting resource monitoring. 08:54:00 INFO - ##### 08:54:00 INFO - ##### Finished create-virtualenv step (success) 08:54:00 INFO - ##### 08:54:00 INFO - ##### 08:54:00 INFO - ##### Running install step. 08:54:00 INFO - ##### 08:54:00 INFO - Running pre-action listener: _resource_record_pre_action 08:54:00 INFO - Running main action method: install 08:54:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:54:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:54:00 INFO - Reading from file tmpfile_stdout 08:54:00 INFO - Detecting whether we're running mozinstall >=1.0... 08:54:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:54:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:54:00 INFO - Reading from file tmpfile_stdout 08:54:00 INFO - Output received: 08:54:00 INFO - Usage: mozinstall [options] installer 08:54:00 INFO - Options: 08:54:00 INFO - -h, --help show this help message and exit 08:54:00 INFO - -d DEST, --destination=DEST 08:54:00 INFO - Directory to install application into. [default: 08:54:00 INFO - "/builds/slave/test"] 08:54:00 INFO - --app=APP Application being installed. [default: firefox] 08:54:00 INFO - mkdir: /builds/slave/test/build/application 08:54:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:54:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:54:16 INFO - Reading from file tmpfile_stdout 08:54:16 INFO - Output received: 08:54:16 INFO - /builds/slave/test/build/application/firefox/firefox 08:54:16 INFO - Running post-action listener: _resource_record_post_action 08:54:16 INFO - ##### 08:54:16 INFO - ##### Finished install step (success) 08:54:16 INFO - ##### 08:54:16 INFO - ##### 08:54:16 INFO - ##### Running run-tests step. 08:54:16 INFO - ##### 08:54:16 INFO - Running pre-action listener: _resource_record_pre_action 08:54:16 INFO - Running main action method: run_tests 08:54:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:54:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:54:16 INFO - Python 2.7.3 08:54:16 INFO - Return code: 0 08:54:16 INFO - grabbing minidump binary from tooltool 08:54:16 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')]} 08:54:16 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 0x11ca1c0>, '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 0x11cb0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11cb550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:54:16 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 08:54:16 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 08:54:16 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 08:54:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:54:16 INFO - Return code: 0 08:54:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:54:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:54:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:54:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:54:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:54:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:54:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:54:17 INFO - Return code: 0 08:54:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JEf-drlOQwek0NmKtpUbKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:54:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JEf-drlOQwek0NmKtpUbKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:54:17 INFO - Using env: {'DISPLAY': ':0', 08:54:17 INFO - 'HOME': '/home/cltbld', 08:54:17 INFO - 'LANG': 'en_US.UTF-8', 08:54:17 INFO - 'LANGUAGE': 'en_US:en', 08:54:17 INFO - 'LOGNAME': 'cltbld', 08:54:17 INFO - 'MAIL': '/var/mail/cltbld', 08:54:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:54:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:54:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:17 INFO - 'MOZ_NO_REMOTE': '1', 08:54:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:54:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:54:17 INFO - 'NO_EM_RESTART': '1', 08:54:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:54:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:17 INFO - 'PWD': '/builds/slave/test', 08:54:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:54:17 INFO - 'SHELL': '/bin/bash', 08:54:17 INFO - 'SHLVL': '1', 08:54:17 INFO - 'TERM': 'linux', 08:54:17 INFO - 'TMOUT': '86400', 08:54:17 INFO - 'USER': 'cltbld', 08:54:17 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1465400314.319056-228213986', 08:54:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:17 INFO - '_': '/tools/buildbot/bin/python'} 08:54:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JEf-drlOQwek0NmKtpUbKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:54:18 INFO - mozversion application_buildid: 20160608082029 08:54:18 INFO - mozversion application_changeset: daadc8567a11c6165986c05719fa44a7ed8af839 08:54:18 INFO - mozversion application_display_name: Nightly 08:54:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:54:18 INFO - mozversion application_name: Firefox 08:54:18 INFO - mozversion application_remotingname: firefox 08:54:18 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:54:18 INFO - mozversion application_vendor: Mozilla 08:54:18 INFO - mozversion application_version: 50.0a1 08:54:18 INFO - mozversion platform_buildid: 20160608082029 08:54:18 INFO - mozversion platform_changeset: daadc8567a11c6165986c05719fa44a7ed8af839 08:54:18 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:54:18 INFO - mozversion platform_version: 50.0a1 08:54:18 INFO - using testdate: 1465401258 08:54:18 INFO - actual date: 1465401258 08:54:18 INFO - starting webserver on 'localhost:45162' 08:54:18 INFO - SUITE-START | Running 2 tests 08:54:18 INFO - TEST-START | dromaeo_css 08:54:18 INFO - operating with platform_type : linux_ 08:54:18 INFO - Initialising browser for dromaeo_css test... 08:54:18 INFO - TEST-INFO | started process 6564 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBFYXvL/profile http://localhost:45162/getInfo.html) 08:54:22 INFO - PROCESS | 6564 | __metrics Screen width/height:1600/1200 08:54:22 INFO - PROCESS | 6564 | colorDepth:24 08:54:22 INFO - PROCESS | 6564 | Browser inner width/height: 1024/697 08:54:22 INFO - PROCESS | 6564 | __metrics 08:54:23 ERROR - PROCESS | 6564 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:54:23 INFO - PROCESS | 6564 | console.error: PushService: 08:54:23 INFO - PROCESS | 6564 | stateChangeProcessEnqueue: Error transitioning state 08:54:23 INFO - PROCESS | 6564 | UnknownError 08:54:24 INFO - TEST-INFO | 6564: exit 0 08:54:24 INFO - Browser initialized. 08:54:24 INFO - Running cycle 1/1 for dromaeo_css test... 08:54:24 INFO - TEST-INFO | started process 6646 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBFYXvL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:54:36 INFO - PROCESS | 6646 | RSS: Main: 157020160 08:54:36 INFO - PROCESS | 6646 | 08:55:27 INFO - PROCESS | 6646 | 1465401327859 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] 08:57:40 INFO - PROCESS | 6646 | Cycle 1(1): loaded http://localhost:45162/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45162/tests/dromaeo/cssquery-ext.html) 08:57:42 INFO - PROCESS | 6646 | RSS: Main: 251375616 08:57:42 INFO - PROCESS | 6646 | 09:00:44 INFO - PROCESS | 6646 | Cycle 1(1): loaded http://localhost:45162/tests/dromaeo/cssquery-ext.html (next: http://localhost:45162/tests/dromaeo/cssquery-jquery.html) 09:00:45 INFO - PROCESS | 6646 | RSS: Main: 240967680 09:00:45 INFO - PROCESS | 6646 | 09:03:47 INFO - PROCESS | 6646 | Cycle 1(1): loaded http://localhost:45162/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45162/tests/dromaeo/cssquery-mootools.html) 09:03:48 INFO - PROCESS | 6646 | RSS: Main: 246251520 09:03:48 INFO - PROCESS | 6646 | 09:06:50 INFO - PROCESS | 6646 | Cycle 1(1): loaded http://localhost:45162/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45162/tests/dromaeo/cssquery-prototype.html) 09:06:51 INFO - PROCESS | 6646 | RSS: Main: 236081152 09:06:51 INFO - PROCESS | 6646 | 09:09:54 INFO - PROCESS | 6646 | Cycle 1(1): loaded http://localhost:45162/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45162/tests/dromaeo/cssquery-yui.html) 09:09:54 INFO - PROCESS | 6646 | RSS: Main: 217550848 09:09:54 INFO - PROCESS | 6646 | 09:12:57 INFO - PROCESS | 6646 | Cycle 1(1): loaded http://localhost:45162/tests/dromaeo/cssquery-yui.html (next: http://localhost:45162/tests/dromaeo/cssquery-dojo.html) 09:12:57 INFO - PROCESS | 6646 | RSS: Main: 291180544 09:12:57 INFO - PROCESS | 6646 | 09:12:57 INFO - PROCESS | 6646 | __start_tp_report 09:12:57 INFO - PROCESS | 6646 | _x_x_mozilla_page_load 09:12:57 INFO - PROCESS | 6646 | _x_x_mozilla_page_load_details 09:12:57 INFO - PROCESS | 6646 | |i|pagename|runs| 09:12:57 INFO - PROCESS | 6646 | |0;dojo.html;2652.602109683547;2670.82639628424;2695.7304269573037;2707.12018593957;2713.362359845436;4616.56142666447;4657.953420465794;4679.719216846992;4718.4809670936165;4772.522747725226;4653.930191047137;4701.623870090393;4704.811807527703;4725.9054818903605;4727.645426593002;4244.214820258255;4282.850100246492;4319.654427645796;4354.542773008836;4514.796834142455;4416.867493975186;4444.31113177458;4471.217536931041;4480.19356515827;4507.188706032913;4208.936865947013;4252.829886804524;4282.528921818597;4326.480822301312;4329.047609525931;4261.382099595572;4282.635975942048;4329.826806927719;4340.826366945318;4347.956520434786;4310.52584215736;4319.568043195687;4325.82696692132;4357.520672725997;4363.694541382105;4530.388397566352;4573.63410927125;4624.583787459145;4632.351470794091;4654.837080702193;5116.334876466073;5117.309163262949;5153.665011774223;5155.458676838915;5168.534831865112;5158.484151584849;5165.251038599419;5196.402413722432;5210.322658054467;5211.817586384458;4628.305754136839;4700.929486057712;4767.046590681808;4767.308740232646;4863.221884498464;5266.710330931835;5301.125314323093;5306.336707911511;5309.203619457112;5309.893802124013;4852.951470485321;5076.111680455905;5079.288899554065;5079.3650793650795;5082.669626474268;5049.495050494921;5094.363204599425;5100.897982040338;5146.176611742103;5188;5067.062593420229;5079.771410286546;5079.87300317495;5083.771230294646;5131.358580177478;5047.16721740916;5054.620903432257;5061.139606266944;5063.569596584258;5069.138246498104;4141.192467468814;4177.352510360899;4177.97911010443;4231.4710661167355;4233.25917964355;3680.392735198716;3699.315626609086;3734.8506059757847;3762;3772.6981841452616;4444.73331600105;4450.109978004412;4461.709988850715;4490.416245888079;4494.37078808967;5095.8980820383385;5097.719625420564;5111.591072714174;5114.411842638145;5158.226266060121;4311.784410779511;4411.536788637211;4437.312216606431;4454.532274111171;4489.820407183742;4559.863204103882;4581.129585378834;4588.334691469719;4618.676692631483;4636.652251081183;4868.95131048692;4879.512048795092;4882.487338829514;4884.07202631506;4931.926021109758;4905.754712264444;5055.51972562606;5095.235714642833;5116.820911268237;5153.639245252796;4822.373091498082;4840.031993601364;4844.346013288161;4878.0975519529;4893.877653058702;5050.267711181931;5052.520010598987;5052.646314757932;5052.9494705052475;5096.872578185575;4909.729964851825;5015.899682006412;5024.84925452237;5098.082345177903;5163.690178589297;4959.479254678206;4960.355153829979;4962;4962.131626965339;4999;4949.183384741477;4949.505049495022;4962.354893863775;4965.205567109245;4993.575546078624;4714.4106986626675;4792.520747925179;4810.470848206624;4835.153848076502;4913.459519452786;4918.5819205366515;4923.753812309298;4931.220095693723;4944.554990050912;4993.4756850530175;4833.9033219334715;4841.515848415131;4843.709377437365;4846.660733748745;4901.460839307744 09:12:57 INFO - PROCESS | 6646 | |1;ext.html;550.4623099827613;580.0313476494255;583.5652438932995;584.5791030458074;599.6162456028142;27575.44849103019;40297.798511007444;41455;41567.376489352646;45402;39094.41358379627;39800.80099599505;39829.402558961636;39857.8007109964;39895.401568976486;7412.4440666950195;7541.811454713621;7557.546547207171;7578.355839753627;7732.845343093163;7543.69825206991;9859.35914165577;10182.541785619665;10192.847107293397;10510.789784204311;10164.847527287096;10239.283250172492;10243.590256389736;10255.846162307571;10267;7538.246175382418;7799.5320280783335;10074.69775906724;10166.9491652542;10210.795784084277;7621.275978782007;9606.807863842754;10014.248931330107;10023.298369114165;10304.845427318596;39652;40107.39838902419;40118;40124.799376003226;40188.19623607511;2916;2932.472155012097;3126.484130118528;3451.11996440906;3549.8580056797696;29797.404051918842;30190.24524386886;30609.234769130726;30653.540196897065;31091;3250.3174333390016;3269.820159891205;3278.0493656839726;3325.5177999190223;3371.9157021074425;254561;255624.99999999814;256005;256720;256911;54164.45835541594;54735.726321368136;54738;54750.45249547533;54779.72610136924;58112.41887581155;58139.418605814244;58201;58289;58291;14555.12669239849;14817.259137043106;14877.702445951021;14878.553643390716;14902.850971490363;10163.390196588081;10998.230123891411;11239.775204496027;11443.542258309575;11493.42532873353;17043.40348087811;17077.146142692814;17141.400050998403;17199.484015479306;17252.223649935782;5645.435456454322;5716.456936591017;5748.137779333133;5767.480926716616;5898.469137777534;812.3663542436909;866.467122719523;899.9505027223435;921.0768442673897;983.0022527134963;27160.592591111148;27846.27047299876;27943.860280698467;28227.435451290858;28323.57514637282;935.1677007463363;959.8032403357295;1008.2186305613062;1041.5313109100935;1052.7315534538643;14422.42310307576;14870.925645371704;14895.92552037233;15013.249337533298;15101.546953591409;374256;377744;378241;378679;380439;48879.511204887494;49093.509064908896;49147.50852491501;49294;49312;1069.3583849690124;1131.9773604528027;1169.6783384569312;1224.64485299264;1241;26191;28764.280892977844;29178.41643167167;29534.704652953194;29565;42784;42951.49009353973;43241.567584325014;43372;43401.782991086104;295670;295793;296403;296506;297748;31186.376272473968;36056.819715901256;36406.635933640326;37575.81212093922;37598;40798;41985.370219447344;42120;42449.78775106105;42793.572064280204;35562.46656300106;36494.8175259122;36516.45225321569;36800.63199367972;37116.25767484689;35893.461598076574;35999.64000359963;36302.63697363098;36304.27391452209;36591.63408365989;35358.46962295619;35551.11122221965;35573.466398004566;36166.819165904;36271.45592816057;31674.683253168096;32090.839545802122;32282.677173227967;32380.676193237767;32700;24661.26016219516;24765.50468990574;25057.123000695618;25391.61912571276;25419.36451588725 09:12:57 INFO - PROCESS | 6646 | |2;jquery.html;363.5550920062579;368.3829585444381;372.4617927095347;374.0214266530056;380.3666894620457;15854.207289635515;17372.826271737278;17384.47846564605;17670.204840782164;17826.19782109805;16548.420805271817;17192.742108868377;17610.383636572722;17615.207315670792;17627;4883.951160488394;5106.106431374513;5131.563817075535;5143;5152.201408781645;3712.109093817491;3907;4953.108440480712;5640.520555752766;5962.612430192045;6003.519718422515;6010.639361638294;6018.488428483584;6031.819045428644;6049.364816694249;5849.795257165979;5883.970580147115;5927.199828023205;5935.28776546815;6027.09593560965;3312.569365982431;4884.511548845123;5169.793208271664;5188.948110518884;5213.765380557884;19845;20397.38807835767;20527;20766.58466830655;20779.79220207809;1799.9010054447;2050.4156315450173;2122.991578999978;2151.7310336207975;2262.196920093376;12713.809292860615;13065.804012939814;13065.934670326682;13491.797623035662;13551.932240338834;1724.6787387539973;1755.3154269834774;1793.1303317890813;1802.78366596008;1805.9458216253533;41828.79085604583;46879.53120468786;67151.32848671499;67388;67873.66063169652;9314.95342523283;9375.671851485302;9564.18704410119;9573.952130239304;9960.352577082467;12510.937445312715;12526.874731252754;12598.181118227287;12606.55877044299;12632.684182895317;6862.897056544156;7194.388476979515;7284.526505777108;7372.705091796375;7404;6646.202455705346;6658.134442522538;6882.208546017172;6942.8611427772175;7107.964460177666;6004.42957918997;6240.876642204446;6241.21984751906;6256.186695729617;6370.426661600385;1609.3723447855346;1724.8878822876472;1765.1791916758768;1766.4563029237856;1816.4641430777951;813.2558708781517;845.9915400846036;910.1808372464702;924.5469719837231;971.6842026341467;16668.916655416888;16955.15224238783;17239;17286.13569321529;17581.7362739559;826.7002369081;836.9707060252862;867.6312567158932;870.8998465176459;892.0856122474515;9685.370450920667;9877.506124693737;9926.602935882629;9944.80110397788;10005.19958403326;382439;387883;388673;390773;395469;43061.78469107635;61515.692421537606;69080.6545967267;69232.65383673151;69968.6501567499;918.9724308270629;928.331601247101;928.5218112671979;937.5406051034944;947.6446332625266;15129.092254464767;15186.316615752097;15370.538883833502;15402.46091386796;15648.92175539115;31651.683483164874;32872.67127328792;33094;34060.14849628779;34191;43490;44801.55198448104;45597;46773.76613117049;47412.52587474081;6515.902261466176;6825.761098361533;6879.552829066095;7706.3449606781805;7855.921440785748;11298.887011130113;11843.460350154424;11936.224145430519;11980.820287695866;12057.336846473529;6735.562188457735;9875.456849873326;10104.292699510963;10237.590496380359;10263.7434064149;5761.193432919478;7686.538807671557;9868.279744451853;10253.384796912209;10542.52558634848;10086.29395942277;10454.163666906477;10560.888330691754;10647.680569582924;10697.839532407175;7612.200718924433;7674.9232507674205;7741;7764.184760600281;7934.2859142677435;7791.805204869697;9729.756756081155;10306.742331441474;10407.583696652351;10509.894901050891 09:12:57 INFO - PROCESS | 6646 | |3;mootools.html;1217.8112392579142;1354.7155097429543;1405.5642750747265;1436.439788482492;1665.6169081111336;6811;7709.5374277543315;7955.085165206003;7973.760787176379;8209.876851847228;7937.20627937206;8092.0694120176195;8113.188681131898;8115.3101986331085;8120.066192387877;1836.2287839107607;1895.1755986146002;1899.221319259097;2215.7562668106493;2246.382244882654;1925.922963081482;2048.5288383671764;2098.6222479953603;2110.1453911166004;2133.3386650138427;2092.932604371766;2117.100232401231;2121.7772133925946;2125.415510734545;2125.9893700531475;1797.6494583556212;2087.551176497053;2093.235968871351;2095.287602215254;2097.737782777153;2068.7103805467245;2146.270268108835;2146.3239079689847;2169.8155656769195;2172.2288587551507;7968.880466792944;8017.919820801834;8024.27781499662;8027.719029833927;8035.357171426272;4618.307253911907;4777.402824646919;4778.020505796303;4780.11567859947;4781.8087276508895;2798.608194852722;2900.129961011688;2908.69458706837;2917.081119447367;2977.940441191164;889.7597648634897;920.3741455810047;948.2271948362063;970.6990832841842;973.0609961387224;10994.890051099466;10997.175211859143;11004;11015.944920275348;11031.062359699356;4232.661387089025;4302.26861433557;4380.386745855582;4407.316865885793;4409.184300904343;9367.578458969363;9401.10689484498;9404.670836520689;9416.058394160666;9419.576119074658;4642.72143671374;4698.1778188816825;4701.200795864711;4708.4820669726305;4710.3405523226775;3579.6062433132333;3755.493008443825;4129.793510324532;4163.437935878678;4164.43780089684;3612.945805812915;3675.9632403676155;3735.738498305147;3757.49273848027;3761.3417651910804;1121.9382933938548;1168.2873447197203;1172.7713095946208;1175.9412029398495;1206.6199147268583;760.2207737069548;786.0371045469369;794.8887155798193;827.7020272701823;851.0510780479844;5143.897122057538;5196.870078247998;5345.919811202835;5531.3915469298345;5537.1140617501005;801.531104303977;815.5718247919771;821.4947807098711;858.3350678441577;870.6604424274537;3542.1852973816167;3574.1243395367783;3617.330793803155;3627.002574292038;3687.502187204693;9576.712698619052;9838.409695418297;9912.851307230398;9919.553620087114;9922.950385248172;9449.858252126223;9575.329726919188;9640.517974101267;9670.274729395323;9848;7133.286671332825;7150.785476435715;7219.74730884427;7243.4929554931705;7250.782476525713;4979.850604481871;5005.549500544968;5099.745012749422;5148.279240906201;5200.557952574073;8609.708543718492;8647.78930949655;8727.476351418934;8743.081976392386;8748.69379571712;8766.21104100634;8868;9099.226565741987;9126.45241285525;9417.670381536613;5868.354481007001;6482.643454610042;6601.933980660132;6911.343422374866;7171.390431813355;7252.927470725225;7438.516496427715;7513.323800857949;7514.699412023458;7515.586642734484;6370.968145159244;6652.501062420241;6726;6732.629705366252;6773.288804675438;6457.741690332334;6501.609903405811;6519.054737063194;6529.412352888263;6579.374959378852;6196;6299.023651334051;6318.115463834974;6321.589096708699;6324.905126423199;4173.457450531411;4321.632661223831;4350.9347359789;4365.301551751704;4391.407160033355;4357.607815296638;4402.84590039347;4468.664850136188;4476.820927162877;4536.546345365569 09:12:57 INFO - PROCESS | 6646 | |4;prototype.html;285.9676567590996;293.96766355700873;296.5418428527924;297.98957036503725;299.4639595124727;4761.40482439695;4827.734474603895;4828.758562071891;4845.22476403775;4865.008020067659;4696.201645720227;4718.197906355919;4734.84564523142;4739.644526660497;4747.667663263573;3565.768225065369;3623;3696.5009723687363;3708.6278077111506;3777.58446570877;3728.8881333560034;3729.9254014919684;3736.9813150934206;3771.66055055045;3775.207206486641;3552.2717842842158;3728.832202550892;3740.4389341598708;3743.9438408423894;3750.324941510527;3607;3686.318031164243;3694.4827724118377;3702.129999450127;3712.795796231206;3266.03651922681;3272.394606997689;3275.902572638169;3290.8683652654104;3291.358185153896;4532.3201519771965;4538.546145385468;4549.7042692224895;4582.335561343587;4610.216263235225;4095.3242714952;4279.229738647074;4292.892677683051;4297.247981603207;4297.634701050414;4989.351384320052;5002.474740152268;5012.649114561982;5017.422996355429;5045.344105266328;3617.2042150726797;3628.5645722513204;3637.7089832813313;3641.14433108222;3644.3804553226014;5037.244413338029;5178.896422071537;5212.322398088224;5267.947320526822;5276.736163191825;3675.9081022974638;3678.006938126691;3685.6682898538725;3687.391580389259;3698.556173259226;3753.9061523461587;3764.3036038333;3772.9434058489146;3775.0751065989007;3777.471154038437;4268.573142685706;4298.398224248608;4298.570142985676;4311.805968731414;4312.396264522969;4829;4978.6763860348965;4978.904640978979;5012.172991456368;5067.290579318898;1316.1247770232687;1328.35574746248;1331.3409862118313;1335.1721932401972;1344.4017412251453;855.8587833007484;865.4288169807896;883.2492381475822;900.4867225681298;902.8284625921054;4429.512753597101;4449.888752781141;4451.221036318631;4474.977625111918;4478.977605111953;5093.18509038552;5115.846524604268;5141.948580514222;5169.121249387613;5198.7140707260705;4234.237837189274;4416.734995900256;4454.844080457168;4460.598546130864;4463.174312752151;2706.9729302707115;2715.5383584790634;2718.9592156117674;2728.6043523688954;2744.67063952327;4850.08421673437;4887.437944636341;4887.755612219375;4894.706317620954;4897.191963326082;5065.1765364468765;5165.870853228699;5216.921746173811;5240.973795131;5253.264542963988;4807.158747219222;4820.493848145964;4824.059308434821;4843.2735089736825;4877.487863774252;5093.60600517756;5126;5148.58811295103;5148.665336753099;5155.6284109308635;4725.196716558262;4948.6535942485125;4994.300797888226;5051.74741262928;5054.69671819692;4791.4729379767505;4824.8793780155775;4825.300331451849;4837.588804951478;4844.563989240985;3735.8045425463592;3743.1952130292116;3759.661630453272;3772.396416573335;3779.168582911755;4858.319835223001;5144.459831717765;5144.688104533469;5145.536901678867;5223.608229382736;5036.924446133385;5042;5046.823361182341;5050.949490505195;5052.191649336089;5046.142155833444;5055.418626857811;5058.570021548209;5060.544550990281;5078.136716758234;4758.834085648899;4838.177509823409;4961.975190124026;5006.449290577961;5008.6243531734535;4935.580475659609;5049.621278404061;5070.721110338966;5074.416442109205;5080.46655101209;4942.20924652054;4957.578605818546;4966.875828104182;4977.800887964441;4993.950060499348 09:12:57 INFO - PROCESS | 6646 | |5;yui.html;577.2582231832096;627.1627377451103;631.4317114596862;677.5121912223198;715.778108786276;12328.938355308223;13381;14136.36386362615;14732.33704483298;14758.778618320734;13475.460981560751;13519.391627376766;13530.18818870866;13561.864381356183;13602.523911663095;622.4926684751936;767.2902565127263;792.976210713678;800.4916877782591;801.883726859605;791.3708601661692;802.7110240313483;802.7591722483261;802.8755542890832;802.9678812847479;835.5905606252923;842.5155535567043;842.5913431985482;843.464400105934;843.5908584336592;642.75575281393;810.7973006748313;837.7863644770605;843.2452954605624;843.7089204224533;617.5121653893419;617.8887800195963;618.1191801682585;618.1253526260336;618.165476606582;12866.228026318357;12911.483540658362;13072.346382680827;13128.803067953988;13140.540081097211;11664;11997.28016319015;12235.93882030584;12280.815787763191;12410.317432541207;11618;11663.86571285515;11746.588869389616;11867.465964031639;11938.462769175409;4113.8971525711795;4137.958620413788;4168.499780026386;4202.831886724527;4267.231898258312;56427.153592696144;57078.42921570773;57489.13766293509;57918.13122803161;57942.13086803701;9924.057214564606;9969.601215951281;10043.899561004297;10231.59073637061;10302.227332950059;18286.542836429195;18723.25106995705;18743.156557954924;18748;18779.718304225175;6873.072135261776;7108.182559005677;7138.607376594337;7143.178534468499;7359;3720.720945929066;3793.696504279706;3832.885013449601;3841.9231615368094;3929.8035098244973;2876.395956849043;3006.7895247332913;3011.8795248189826;3012.4125795470113;3013.608230929965;530.3079481276893;531.4021725558746;535.9115745901961;540.4730387871793;547.7261369315343;424.4227850123829;442.7122370459163;470.41198501872657;496.84349429929455;521.4186182406589;7491.363234125051;7663.808404789925;7717.961410192913;7849.136594974549;7951.522908625501;415.65915948921594;463.5480406603535;487.9143904811836;509.4548832748923;509.94187061846816;4104;4372.584604462634;4469.955300447019;4524.954750452519;4534.909301813946;69911;96648.51675741577;100623.49688251512;100831;102555;53618.73190634022;60784.392156077876;79522.20477795148;85058.57470712607;89520;75055.24944750592;76092;76454;77709.61145194237;77832.61083694658;8416.452930559493;8416.915830841614;8428.154214325901;8507.702230421906;8528.403011789364;44686;45177.54822451865;45188.77405612951;45321.77339113283;45790;64129.35870641234;67625;67861.3213867855;67972.32027679858;68273;10792.676219713421;10932.398718070264;11106.111511079256;11268.098552115975;11507.367094809866;11840.70398240051;12336.938315308365;12704.30126343023;12724.427400766803;13208.801867971795;10957.232993690364;11292.892860889293;11376.658700239006;11427.885721142682;11604.361760103275;10830.350178989285;10853.945730271298;10856.45717714127;11006.504707288032;11378.601748938747;10134.949325253621;10177.338472999232;10253.384796912209;10367.377957322586;10944.45277736094;9624.855627165738;10066.949665251626;10081.596736130767;10129.696109116738;10153.289269751047;9683.32216744821;9906.950465247628;9942.75715535558;9982.201423885926;10076.395416274754 09:12:57 INFO - PROCESS | 6646 | __end_tp_report 09:12:57 INFO - PROCESS | 6646 | __start_cc_report 09:12:57 INFO - PROCESS | 6646 | _x_x_mozilla_cycle_collect,923 09:12:57 INFO - PROCESS | 6646 | __end_cc_report 09:12:57 INFO - PROCESS | 6646 | __startTimestamp1465402377804__endTimestamp 09:12:57 INFO - PROCESS | 6646 | 09:12:57 INFO - PROCESS | 6646 | ------- Summary: start ------- 09:12:57 INFO - PROCESS | 6646 | Number of tests: 6 09:12:57 INFO - PROCESS | 6646 | 09:12:57 INFO - PROCESS | 6646 | [#0] dojo.html Cycles:165 Average:4699.08 Median:4843.71 stddev:503.62 (10.4%) stddev-sans-first:478.89 09:12:57 INFO - PROCESS | 6646 | Values: 2652.6 2670.8 2695.7 2707.1 2713.4 4616.6 4658.0 4679.7 4718.5 4772.5 4653.9 4701.6 4704.8 4725.9 4727.6 4244.2 4282.9 4319.7 4354.5 4514.8 4416.9 4444.3 4471.2 4480.2 4507.2 4208.9 4252.8 4282.5 4326.5 4329.0 4261.4 4282.6 4329.8 4340.8 4348.0 4310.5 4319.6 4325.8 4357.5 4363.7 4530.4 4573.6 4624.6 4632.4 4654.8 5116.3 5117.3 5153.7 5155.5 5168.5 5158.5 5165.3 5196.4 5210.3 5211.8 4628.3 4700.9 4767.0 4767.3 4863.2 5266.7 5301.1 5306.3 5309.2 5309.9 4853.0 5076.1 5079.3 5079.4 5082.7 5049.5 5094.4 5100.9 5146.2 5188.0 5067.1 5079.8 5079.9 5083.8 5131.4 5047.2 5054.6 5061.1 5063.6 5069.1 4141.2 4177.4 4178.0 4231.5 4233.3 3680.4 3699.3 3734.9 3762.0 3772.7 4444.7 4450.1 4461.7 4490.4 4494.4 5095.9 5097.7 5111.6 5114.4 5158.2 4311.8 4411.5 4437.3 4454.5 4489.8 4559.9 4581.1 4588.3 4618.7 4636.7 4869.0 4879.5 4882.5 4884.1 4931.9 4905.8 5055.5 5095.2 5116.8 5153.6 4822.4 4840.0 4844.3 4878.1 4893.9 5050.3 5052.5 5052.6 5052.9 5096.9 4909.7 5015.9 5024.8 5098.1 5163.7 4959.5 4960.4 4962.0 4962.1 4999.0 4949.2 4949.5 4962.4 4965.2 4993.6 4714.4 4792.5 4810.5 4835.2 4913.5 4918.6 4923.8 4931.2 4944.6 4993.5 4833.9 4841.5 4843.7 4846.7 4901.5 09:12:57 INFO - PROCESS | 6646 | 09:12:57 INFO - PROCESS | 6646 | [#1] ext.html Cycles:180 Average:47357.85 Median:35556.79 stddev:82449.51 (231.9%) stddev-sans-first:82605.91 09:12:57 INFO - PROCESS | 6646 | Values: 550.5 580.0 583.6 584.6 599.6 27575.4 40297.8 41455.0 41567.4 45402.0 39094.4 39800.8 39829.4 39857.8 39895.4 7412.4 7541.8 7557.5 7578.4 7732.8 7543.7 9859.4 10182.5 10192.8 10510.8 10164.8 10239.3 10243.6 10255.8 10267.0 7538.2 7799.5 10074.7 10166.9 10210.8 7621.3 9606.8 10014.2 10023.3 10304.8 39652.0 40107.4 40118.0 40124.8 40188.2 2916.0 2932.5 3126.5 3451.1 3549.9 29797.4 30190.2 30609.2 30653.5 31091.0 3250.3 3269.8 3278.0 3325.5 3371.9 254561.0 255625.0 256005.0 256720.0 256911.0 54164.5 54735.7 54738.0 54750.5 54779.7 58112.4 58139.4 58201.0 58289.0 58291.0 14555.1 14817.3 14877.7 14878.6 14902.9 10163.4 10998.2 11239.8 11443.5 11493.4 17043.4 17077.1 17141.4 17199.5 17252.2 5645.4 5716.5 5748.1 5767.5 5898.5 812.4 866.5 900.0 921.1 983.0 27160.6 27846.3 27943.9 28227.4 28323.6 935.2 959.8 1008.2 1041.5 1052.7 14422.4 14870.9 14895.9 15013.2 15101.5 374256.0 377744.0 378241.0 378679.0 380439.0 48879.5 49093.5 49147.5 49294.0 49312.0 1069.4 1132.0 1169.7 1224.6 1241.0 26191.0 28764.3 29178.4 29534.7 29565.0 42784.0 42951.5 43241.6 43372.0 43401.8 295670.0 295793.0 296403.0 296506.0 297748.0 31186.4 36056.8 36406.6 37575.8 37598.0 40798.0 41985.4 42120.0 42449.8 42793.6 35562.5 36494.8 36516.5 36800.6 37116.3 35893.5 35999.6 36302.6 36304.3 36591.6 35358.5 35551.1 35573.5 36166.8 36271.5 31674.7 32090.8 32282.7 32380.7 32700.0 24661.3 24765.5 25057.1 25391.6 25419.4 09:12:57 INFO - PROCESS | 6646 | 09:12:57 INFO - PROCESS | 6646 | [#2] jquery.html Cycles:180 Average:23392.16 Median:45199.28 stddev:63728.13 (141.0%) stddev-sans-first:63883.45 09:12:57 INFO - PROCESS | 6646 | Values: 363.6 368.4 372.5 374.0 380.4 15854.2 17372.8 17384.5 17670.2 17826.2 16548.4 17192.7 17610.4 17615.2 17627.0 4884.0 5106.1 5131.6 5143.0 5152.2 3712.1 3907.0 4953.1 5640.5 5962.6 6003.5 6010.6 6018.5 6031.8 6049.4 5849.8 5884.0 5927.2 5935.3 6027.1 3312.6 4884.5 5169.8 5188.9 5213.8 19845.0 20397.4 20527.0 20766.6 20779.8 1799.9 2050.4 2123.0 2151.7 2262.2 12713.8 13065.8 13065.9 13491.8 13551.9 1724.7 1755.3 1793.1 1802.8 1805.9 41828.8 46879.5 67151.3 67388.0 67873.7 9315.0 9375.7 9564.2 9574.0 9960.4 12510.9 12526.9 12598.2 12606.6 12632.7 6862.9 7194.4 7284.5 7372.7 7404.0 6646.2 6658.1 6882.2 6942.9 7108.0 6004.4 6240.9 6241.2 6256.2 6370.4 1609.4 1724.9 1765.2 1766.5 1816.5 813.3 846.0 910.2 924.5 971.7 16668.9 16955.2 17239.0 17286.1 17581.7 826.7 837.0 867.6 870.9 892.1 9685.4 9877.5 9926.6 9944.8 10005.2 382439.0 387883.0 388673.0 390773.0 395469.0 43061.8 61515.7 69080.7 69232.7 69968.7 919.0 928.3 928.5 937.5 947.6 15129.1 15186.3 15370.5 15402.5 15648.9 31651.7 32872.7 33094.0 34060.1 34191.0 43490.0 44801.6 45597.0 46773.8 47412.5 6515.9 6825.8 6879.6 7706.3 7855.9 11298.9 11843.5 11936.2 11980.8 12057.3 6735.6 9875.5 10104.3 10237.6 10263.7 5761.2 7686.5 9868.3 10253.4 10542.5 10086.3 10454.2 10560.9 10647.7 10697.8 7612.2 7674.9 7741.0 7764.2 7934.3 7791.8 9729.8 10306.7 10407.6 10509.9 09:12:57 INFO - PROCESS | 6646 | 09:12:57 INFO - PROCESS | 6646 | [#3] mootools.html Cycles:180 Average:5135.42 Median:5198.71 stddev:2937.96 (56.5%) stddev-sans-first:2931.45 09:12:57 INFO - PROCESS | 6646 | Values: 1217.8 1354.7 1405.6 1436.4 1665.6 6811.0 7709.5 7955.1 7973.8 8209.9 7937.2 8092.1 8113.2 8115.3 8120.1 1836.2 1895.2 1899.2 2215.8 2246.4 1925.9 2048.5 2098.6 2110.1 2133.3 2092.9 2117.1 2121.8 2125.4 2126.0 1797.6 2087.6 2093.2 2095.3 2097.7 2068.7 2146.3 2146.3 2169.8 2172.2 7968.9 8017.9 8024.3 8027.7 8035.4 4618.3 4777.4 4778.0 4780.1 4781.8 2798.6 2900.1 2908.7 2917.1 2977.9 889.8 920.4 948.2 970.7 973.1 10994.9 10997.2 11004.0 11015.9 11031.1 4232.7 4302.3 4380.4 4407.3 4409.2 9367.6 9401.1 9404.7 9416.1 9419.6 4642.7 4698.2 4701.2 4708.5 4710.3 3579.6 3755.5 4129.8 4163.4 4164.4 3612.9 3676.0 3735.7 3757.5 3761.3 1121.9 1168.3 1172.8 1175.9 1206.6 760.2 786.0 794.9 827.7 851.1 5143.9 5196.9 5345.9 5531.4 5537.1 801.5 815.6 821.5 858.3 870.7 3542.2 3574.1 3617.3 3627.0 3687.5 9576.7 9838.4 9912.9 9919.6 9923.0 9449.9 9575.3 9640.5 9670.3 9848.0 7133.3 7150.8 7219.7 7243.5 7250.8 4979.9 5005.5 5099.7 5148.3 5200.6 8609.7 8647.8 8727.5 8743.1 8748.7 8766.2 8868.0 9099.2 9126.5 9417.7 5868.4 6482.6 6601.9 6911.3 7171.4 7252.9 7438.5 7513.3 7514.7 7515.6 6371.0 6652.5 6726.0 6732.6 6773.3 6457.7 6501.6 6519.1 6529.4 6579.4 6196.0 6299.0 6318.1 6321.6 6324.9 4173.5 4321.6 4350.9 4365.3 4391.4 4357.6 4402.8 4468.7 4476.8 4536.5 09:12:57 INFO - PROCESS | 6646 | 09:12:57 INFO - PROCESS | 6646 | [#4] prototype.html Cycles:180 Average:4165.83 Median:4753.25 stddev:1197.80 (25.2%) stddev-sans-first:1165.22 09:12:57 INFO - PROCESS | 6646 | Values: 286.0 294.0 296.5 298.0 299.5 4761.4 4827.7 4828.8 4845.2 4865.0 4696.2 4718.2 4734.8 4739.6 4747.7 3565.8 3623.0 3696.5 3708.6 3777.6 3728.9 3729.9 3737.0 3771.7 3775.2 3552.3 3728.8 3740.4 3743.9 3750.3 3607.0 3686.3 3694.5 3702.1 3712.8 3266.0 3272.4 3275.9 3290.9 3291.4 4532.3 4538.5 4549.7 4582.3 4610.2 4095.3 4279.2 4292.9 4297.2 4297.6 4989.4 5002.5 5012.6 5017.4 5045.3 3617.2 3628.6 3637.7 3641.1 3644.4 5037.2 5178.9 5212.3 5267.9 5276.7 3675.9 3678.0 3685.7 3687.4 3698.6 3753.9 3764.3 3772.9 3775.1 3777.5 4268.6 4298.4 4298.6 4311.8 4312.4 4829.0 4978.7 4978.9 5012.2 5067.3 1316.1 1328.4 1331.3 1335.2 1344.4 855.9 865.4 883.2 900.5 902.8 4429.5 4449.9 4451.2 4475.0 4479.0 5093.2 5115.8 5141.9 5169.1 5198.7 4234.2 4416.7 4454.8 4460.6 4463.2 2707.0 2715.5 2719.0 2728.6 2744.7 4850.1 4887.4 4887.8 4894.7 4897.2 5065.2 5165.9 5216.9 5241.0 5253.3 4807.2 4820.5 4824.1 4843.3 4877.5 5093.6 5126.0 5148.6 5148.7 5155.6 4725.2 4948.7 4994.3 5051.7 5054.7 4791.5 4824.9 4825.3 4837.6 4844.6 3735.8 3743.2 3759.7 3772.4 3779.2 4858.3 5144.5 5144.7 5145.5 5223.6 5036.9 5042.0 5046.8 5050.9 5052.2 5046.1 5055.4 5058.6 5060.5 5078.1 4758.8 4838.2 4962.0 5006.4 5008.6 4935.6 5049.6 5070.7 5074.4 5080.5 4942.2 4957.6 4966.9 4977.8 4994.0 09:12:57 INFO - PROCESS | 6646 | 09:12:57 INFO - PROCESS | 6646 | [#5] yui.html Cycles:180 Average:17451.12 Median:24923.36 stddev:24655.98 (98.9%) stddev-sans-first:24692.59 09:12:57 INFO - PROCESS | 6646 | Values: 577.3 627.2 631.4 677.5 715.8 12328.9 13381.0 14136.4 14732.3 14758.8 13475.5 13519.4 13530.2 13561.9 13602.5 622.5 767.3 793.0 800.5 801.9 791.4 802.7 802.8 802.9 803.0 835.6 842.5 842.6 843.5 843.6 642.8 810.8 837.8 843.2 843.7 617.5 617.9 618.1 618.1 618.2 12866.2 12911.5 13072.3 13128.8 13140.5 11664.0 11997.3 12235.9 12280.8 12410.3 11618.0 11663.9 11746.6 11867.5 11938.5 4113.9 4138.0 4168.5 4202.8 4267.2 56427.2 57078.4 57489.1 57918.1 57942.1 9924.1 9969.6 10043.9 10231.6 10302.2 18286.5 18723.3 18743.2 18748.0 18779.7 6873.1 7108.2 7138.6 7143.2 7359.0 3720.7 3793.7 3832.9 3841.9 3929.8 2876.4 3006.8 3011.9 3012.4 3013.6 530.3 531.4 535.9 540.5 547.7 424.4 442.7 470.4 496.8 521.4 7491.4 7663.8 7718.0 7849.1 7951.5 415.7 463.5 487.9 509.5 509.9 4104.0 4372.6 4470.0 4525.0 4534.9 69911.0 96648.5 100623.5 100831.0 102555.0 53618.7 60784.4 79522.2 85058.6 89520.0 75055.2 76092.0 76454.0 77709.6 77832.6 8416.5 8416.9 8428.2 8507.7 8528.4 44686.0 45177.5 45188.8 45321.8 45790.0 64129.4 67625.0 67861.3 67972.3 68273.0 10792.7 10932.4 11106.1 11268.1 11507.4 11840.7 12336.9 12704.3 12724.4 13208.8 10957.2 11292.9 11376.7 11427.9 11604.4 10830.4 10853.9 10856.5 11006.5 11378.6 10134.9 10177.3 10253.4 10367.4 10944.5 9624.9 10066.9 10081.6 10129.7 10153.3 9683.3 9907.0 9942.8 9982.2 10076.4 09:12:57 INFO - PROCESS | 6646 | -------- Summary: end -------- 09:12:57 INFO - PROCESS | 6646 | 09:12:58 INFO - TEST-INFO | 6646: exit 0 09:12:58 INFO - TEST-OK | dromaeo_css | took 1120588ms 09:12:58 INFO - TEST-START | kraken 09:12:58 INFO - operating with platform_type : linux_ 09:12:58 INFO - Initialising browser for kraken test... 09:12:58 INFO - TEST-INFO | started process 6821 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpht3kNr/profile http://localhost:45162/getInfo.html) 09:13:02 INFO - PROCESS | 6821 | __metrics Screen width/height:1600/1200 09:13:02 INFO - PROCESS | 6821 | colorDepth:24 09:13:02 INFO - PROCESS | 6821 | Browser inner width/height: 1024/697 09:13:02 INFO - PROCESS | 6821 | __metrics 09:13:04 ERROR - PROCESS | 6821 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:13:04 INFO - PROCESS | 6821 | console.error: PushService: 09:13:04 INFO - PROCESS | 6821 | stateChangeProcessEnqueue: Error transitioning state 09:13:04 INFO - PROCESS | 6821 | UnknownError 09:13:04 INFO - TEST-INFO | 6821: exit 0 09:13:04 INFO - Browser initialized. 09:13:04 INFO - Running cycle 1/1 for kraken test... 09:13:04 INFO - TEST-INFO | started process 6902 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpht3kNr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:13:16 INFO - PROCESS | 6902 | RSS: Main: 157929472 09:13:16 INFO - PROCESS | 6902 | 09:13:19 INFO - PROCESS | 6902 | Cycle 1(1): loaded http://localhost:45162/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45162/tests/kraken/driver.html?testName=audio-beat-detection) 09:13:20 INFO - PROCESS | 6902 | RSS: Main: 215195648 09:13:20 INFO - PROCESS | 6902 | 09:13:23 INFO - PROCESS | 6902 | Cycle 1(1): loaded http://localhost:45162/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45162/tests/kraken/driver.html?testName=audio-dft) 09:13:23 INFO - PROCESS | 6902 | RSS: Main: 202358784 09:13:23 INFO - PROCESS | 6902 | 09:13:27 INFO - PROCESS | 6902 | Cycle 1(1): loaded http://localhost:45162/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45162/tests/kraken/driver.html?testName=audio-fft) 09:13:27 INFO - PROCESS | 6902 | RSS: Main: 270348288 09:13:27 INFO - PROCESS | 6902 | 09:13:29 INFO - PROCESS | 6902 | Cycle 1(1): loaded http://localhost:45162/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45162/tests/kraken/driver.html?testName=audio-oscillator) 09:13:30 INFO - PROCESS | 6902 | RSS: Main: 180838400 09:13:30 INFO - PROCESS | 6902 | 09:13:32 INFO - PROCESS | 6902 | Cycle 1(1): loaded http://localhost:45162/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45162/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:13:33 INFO - PROCESS | 6902 | RSS: Main: 184795136 09:13:33 INFO - PROCESS | 6902 | 09:13:36 INFO - PROCESS | 6902 | Cycle 1(1): loaded http://localhost:45162/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45162/tests/kraken/driver.html?testName=imaging-darkroom) 09:13:37 INFO - PROCESS | 6902 | RSS: Main: 221167616 09:13:37 INFO - PROCESS | 6902 | 09:13:40 INFO - PROCESS | 6902 | Cycle 1(1): loaded http://localhost:45162/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45162/tests/kraken/driver.html?testName=imaging-desaturate) 09:13:41 INFO - PROCESS | 6902 | RSS: Main: 221253632 09:13:41 INFO - PROCESS | 6902 | 09:13:44 INFO - PROCESS | 6902 | Cycle 1(1): loaded http://localhost:45162/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45162/tests/kraken/driver.html?testName=json-parse-financial) 09:13:44 INFO - PROCESS | 6902 | RSS: Main: 221270016 09:13:44 INFO - PROCESS | 6902 | 09:13:46 INFO - PROCESS | 6902 | Cycle 1(1): loaded http://localhost:45162/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45162/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:13:47 INFO - PROCESS | 6902 | RSS: Main: 207081472 09:13:47 INFO - PROCESS | 6902 | 09:13:48 INFO - PROCESS | 6902 | Cycle 1(1): loaded http://localhost:45162/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45162/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:13:49 INFO - PROCESS | 6902 | RSS: Main: 209469440 09:13:49 INFO - PROCESS | 6902 | 09:13:51 INFO - PROCESS | 6902 | Cycle 1(1): loaded http://localhost:45162/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45162/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:13:52 INFO - PROCESS | 6902 | RSS: Main: 218873856 09:13:52 INFO - PROCESS | 6902 | 09:13:55 INFO - PROCESS | 6902 | Cycle 1(1): loaded http://localhost:45162/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45162/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:13:55 INFO - PROCESS | 6902 | RSS: Main: 222568448 09:13:55 INFO - PROCESS | 6902 | 09:13:58 INFO - PROCESS | 6902 | Cycle 1(1): loaded http://localhost:45162/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45162/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:13:59 INFO - PROCESS | 6902 | RSS: Main: 222773248 09:13:59 INFO - PROCESS | 6902 | 09:14:01 INFO - PROCESS | 6902 | Cycle 1(1): loaded http://localhost:45162/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45162/tests/kraken/driver.html?testName=ai-astar) 09:14:01 INFO - PROCESS | 6902 | RSS: Main: 265097216 09:14:01 INFO - PROCESS | 6902 | 09:14:01 INFO - PROCESS | 6902 | __start_tp_report 09:14:01 INFO - PROCESS | 6902 | _x_x_mozilla_page_load 09:14:01 INFO - PROCESS | 6902 | _x_x_mozilla_page_load_details 09:14:01 INFO - PROCESS | 6902 | |i|pagename|runs| 09:14:01 INFO - PROCESS | 6902 | |0;ai-astar;113;109;114;121;112;114;112;113;112;112 09:14:01 INFO - PROCESS | 6902 | |1;audio-beat-detection;154;137;133;186;133;135;162;134;172;135 09:14:01 INFO - PROCESS | 6902 | |2;audio-dft;161;161;161;163;162;162;161;161;160;162 09:14:01 INFO - PROCESS | 6902 | |3;audio-fft;84;76;77;126;75;76;76;75;99;76 09:14:01 INFO - PROCESS | 6902 | |4;audio-oscillator;86;87;129;86;88;86;122;86;86;125 09:14:01 INFO - PROCESS | 6902 | |5;imaging-gaussian-blur;117;117;117;117;117;117;119;117;118;117 09:14:01 INFO - PROCESS | 6902 | |6;imaging-darkroom;148;146;147;146;147;146;145;146;146;147 09:14:01 INFO - PROCESS | 6902 | |7;imaging-desaturate;96;94;95;95;94;95;94;96;95;95 09:14:01 INFO - PROCESS | 6902 | |8;json-parse-financial;62;62;63;63;63;63;63;62;63;63 09:14:01 INFO - PROCESS | 6902 | |9;json-stringify-tinderbox;65;66;65;65;65;65;65;66;65;64 09:14:01 INFO - PROCESS | 6902 | |10;stanford-crypto-aes;84;84;93;83;85;84;85;91;117;84 09:14:01 INFO - PROCESS | 6902 | |11;stanford-crypto-ccm;138;141;132;133;139;137;138;134;144;136 09:14:01 INFO - PROCESS | 6902 | |12;stanford-crypto-pbkdf2;166;170;172;170;167;174;168;170;168;171 09:14:01 INFO - PROCESS | 6902 | |13;stanford-crypto-sha256-iterative;67;67;67;67;67;66;67;67;67;66 09:14:01 INFO - PROCESS | 6902 | __end_tp_report 09:14:01 INFO - PROCESS | 6902 | __start_cc_report 09:14:01 INFO - PROCESS | 6902 | _x_x_mozilla_cycle_collect,1871 09:14:01 INFO - PROCESS | 6902 | __end_cc_report 09:14:01 INFO - PROCESS | 6902 | __startTimestamp1465402441355__endTimestamp 09:14:01 INFO - PROCESS | 6902 | 09:14:01 INFO - PROCESS | 6902 | ------- Summary: start ------- 09:14:01 INFO - PROCESS | 6902 | Number of tests: 14 09:14:01 INFO - PROCESS | 6902 | 09:14:01 INFO - PROCESS | 6902 | [#0] ai-astar Cycles:10 Average:113.20 Median:113.00 stddev:3.08 (2.7%) stddev-sans-first:3.27 09:14:01 INFO - PROCESS | 6902 | Values: 113.0 109.0 114.0 121.0 112.0 114.0 112.0 113.0 112.0 112.0 09:14:01 INFO - PROCESS | 6902 | 09:14:01 INFO - PROCESS | 6902 | [#1] audio-beat-detection Cycles:10 Average:148.10 Median:145.50 stddev:19.31 (13.3%) stddev-sans-first:20.37 09:14:01 INFO - PROCESS | 6902 | Values: 154.0 137.0 133.0 186.0 133.0 135.0 162.0 134.0 172.0 135.0 09:14:01 INFO - PROCESS | 6902 | 09:14:01 INFO - PROCESS | 6902 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:0.84 (0.5%) stddev-sans-first:0.88 09:14:01 INFO - PROCESS | 6902 | Values: 161.0 161.0 161.0 163.0 162.0 162.0 161.0 161.0 160.0 162.0 09:14:01 INFO - PROCESS | 6902 | 09:14:01 INFO - PROCESS | 6902 | [#3] audio-fft Cycles:10 Average:84.00 Median:76.00 stddev:16.52 (21.7%) stddev-sans-first:17.52 09:14:01 INFO - PROCESS | 6902 | Values: 84.0 76.0 77.0 126.0 75.0 76.0 76.0 75.0 99.0 76.0 09:14:01 INFO - PROCESS | 6902 | 09:14:01 INFO - PROCESS | 6902 | [#4] audio-oscillator Cycles:10 Average:98.10 Median:86.00 stddev:18.88 (21.9%) stddev-sans-first:19.51 09:14:01 INFO - PROCESS | 6902 | Values: 86.0 87.0 129.0 86.0 88.0 86.0 122.0 86.0 86.0 125.0 09:14:01 INFO - PROCESS | 6902 | 09:14:01 INFO - PROCESS | 6902 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 09:14:01 INFO - PROCESS | 6902 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 119.0 117.0 118.0 117.0 09:14:01 INFO - PROCESS | 6902 | 09:14:01 INFO - PROCESS | 6902 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.84 (0.6%) stddev-sans-first:0.67 09:14:01 INFO - PROCESS | 6902 | Values: 148.0 146.0 147.0 146.0 147.0 146.0 145.0 146.0 146.0 147.0 09:14:01 INFO - PROCESS | 6902 | 09:14:01 INFO - PROCESS | 6902 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.67 09:14:01 INFO - PROCESS | 6902 | Values: 96.0 94.0 95.0 95.0 94.0 95.0 94.0 96.0 95.0 95.0 09:14:01 INFO - PROCESS | 6902 | 09:14:01 INFO - PROCESS | 6902 | [#8] json-parse-financial Cycles:10 Average:62.70 Median:63.00 stddev:0.48 (0.8%) stddev-sans-first:0.44 09:14:01 INFO - PROCESS | 6902 | Values: 62.0 62.0 63.0 63.0 63.0 63.0 63.0 62.0 63.0 63.0 09:14:01 INFO - PROCESS | 6902 | 09:14:01 INFO - PROCESS | 6902 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 09:14:01 INFO - PROCESS | 6902 | Values: 65.0 66.0 65.0 65.0 65.0 65.0 65.0 66.0 65.0 64.0 09:14:01 INFO - PROCESS | 6902 | 09:14:01 INFO - PROCESS | 6902 | [#10] stanford-crypto-aes Cycles:10 Average:89.00 Median:84.50 stddev:10.39 (12.3%) stddev-sans-first:10.86 09:14:01 INFO - PROCESS | 6902 | Values: 84.0 84.0 93.0 83.0 85.0 84.0 85.0 91.0 117.0 84.0 09:14:01 INFO - PROCESS | 6902 | 09:14:01 INFO - PROCESS | 6902 | [#11] stanford-crypto-ccm Cycles:10 Average:137.20 Median:138.00 stddev:3.68 (2.7%) stddev-sans-first:3.89 09:14:01 INFO - PROCESS | 6902 | Values: 138.0 141.0 132.0 133.0 139.0 137.0 138.0 134.0 144.0 136.0 09:14:01 INFO - PROCESS | 6902 | 09:14:01 INFO - PROCESS | 6902 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.60 Median:170.00 stddev:2.41 (1.4%) stddev-sans-first:2.18 09:14:01 INFO - PROCESS | 6902 | Values: 166.0 170.0 172.0 170.0 167.0 174.0 168.0 170.0 168.0 171.0 09:14:01 INFO - PROCESS | 6902 | 09:14:01 INFO - PROCESS | 6902 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 09:14:01 INFO - PROCESS | 6902 | Values: 67.0 67.0 67.0 67.0 67.0 66.0 67.0 67.0 67.0 66.0 09:14:01 INFO - PROCESS | 6902 | -------- Summary: end -------- 09:14:01 INFO - PROCESS | 6902 | 09:14:02 INFO - TEST-INFO | 6902: exit 0 09:14:02 INFO - TEST-OK | kraken | took 63791ms 09:14:02 INFO - SUITE-END | took 1184s 09:14:02 INFO - Completed test suite (00:19:44) 09:14:02 INFO - javascript benchmark 09:14:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2652.602109683547, 2670.82639628424, 2695.7304269573037, 2707.12018593957, 2713.362359845436, 4616.56142666447, 4657.953420465794, 4679.719216846992, 4718.4809670936165, 4772.522747725226, 4653.930191047137, 4701.623870090393, 4704.811807527703, 4725.9054818903605, 4727.645426593002, 4244.214820258255, 4282.850100246492, 4319.654427645796, 4354.542773008836, 4514.796834142455, 4416.867493975186, 4444.31113177458, 4471.217536931041, 4480.19356515827, 4507.188706032913, 4208.936865947013, 4252.829886804524, 4282.528921818597, 4326.480822301312, 4329.047609525931, 4261.382099595572, 4282.635975942048, 4329.826806927719, 4340.826366945318, 4347.956520434786, 4310.52584215736, 4319.568043195687, 4325.82696692132, 4357.520672725997, 4363.694541382105, 4530.388397566352, 4573.63410927125, 4624.583787459145, 4632.351470794091, 4654.837080702193, 5116.334876466073, 5117.309163262949, 5153.665011774223, 5155.458676838915, 5168.534831865112, 5158.484151584849, 5165.251038599419, 5196.402413722432, 5210.322658054467, 5211.817586384458, 4628.305754136839, 4700.929486057712, 4767.046590681808, 4767.308740232646, 4863.221884498464, 5266.710330931835, 5301.125314323093, 5306.336707911511, 5309.203619457112, 5309.893802124013, 4852.951470485321, 5076.111680455905, 5079.288899554065, 5079.3650793650795, 5082.669626474268, 5049.495050494921, 5094.363204599425, 5100.897982040338, 5146.176611742103, 5188.0, 5067.062593420229, 5079.771410286546, 5079.87300317495, 5083.771230294646, 5131.358580177478, 5047.16721740916, 5054.620903432257, 5061.139606266944, 5063.569596584258, 5069.138246498104, 4141.192467468814, 4177.352510360899, 4177.97911010443, 4231.4710661167355, 4233.25917964355, 3680.392735198716, 3699.315626609086, 3734.8506059757847, 3762.0, 3772.6981841452616, 4444.73331600105, 4450.109978004412, 4461.709988850715, 4490.416245888079, 4494.37078808967, 5095.8980820383385, 5097.719625420564, 5111.591072714174, 5114.411842638145, 5158.226266060121, 4311.784410779511, 4411.536788637211, 4437.312216606431, 4454.532274111171, 4489.820407183742, 4559.863204103882, 4581.129585378834, 4588.334691469719, 4618.676692631483, 4636.652251081183, 4868.95131048692, 4879.512048795092, 4882.487338829514, 4884.07202631506, 4931.926021109758, 4905.754712264444, 5055.51972562606, 5095.235714642833, 5116.820911268237, 5153.639245252796, 4822.373091498082, 4840.031993601364, 4844.346013288161, 4878.0975519529, 4893.877653058702, 5050.267711181931, 5052.520010598987, 5052.646314757932, 5052.9494705052475, 5096.872578185575, 4909.729964851825, 5015.899682006412, 5024.84925452237, 5098.082345177903, 5163.690178589297, 4959.479254678206, 4960.355153829979, 4962.0, 4962.131626965339, 4999.0, 4949.183384741477, 4949.505049495022, 4962.354893863775, 4965.205567109245, 4993.575546078624, 4714.4106986626675, 4792.520747925179, 4810.470848206624, 4835.153848076502, 4913.459519452786, 4918.5819205366515, 4923.753812309298, 4931.220095693723, 4944.554990050912, 4993.4756850530175, 4833.9033219334715, 4841.515848415131, 4843.709377437365, 4846.660733748745, 4901.460839307744], "value": 4666.734484014416, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [550.4623099827613, 580.0313476494255, 583.5652438932995, 584.5791030458074, 599.6162456028142, 27575.44849103019, 40297.798511007444, 41455.0, 41567.376489352646, 45402.0, 39094.41358379627, 39800.80099599505, 39829.402558961636, 39857.8007109964, 39895.401568976486, 7412.4440666950195, 7541.811454713621, 7557.546547207171, 7578.355839753627, 7732.845343093163, 7543.69825206991, 9859.35914165577, 10182.541785619665, 10192.847107293397, 10510.789784204311, 10164.847527287096, 10239.283250172492, 10243.590256389736, 10255.846162307571, 10267.0, 7538.246175382418, 7799.5320280783335, 10074.69775906724, 10166.9491652542, 10210.795784084277, 7621.275978782007, 9606.807863842754, 10014.248931330107, 10023.298369114165, 10304.845427318596, 39652.0, 40107.39838902419, 40118.0, 40124.799376003226, 40188.19623607511, 2916.0, 2932.472155012097, 3126.484130118528, 3451.11996440906, 3549.8580056797696, 29797.404051918842, 30190.24524386886, 30609.234769130726, 30653.540196897065, 31091.0, 3250.3174333390016, 3269.820159891205, 3278.0493656839726, 3325.5177999190223, 3371.9157021074425, 254561.0, 255624.99999999814, 256005.0, 256720.0, 256911.0, 54164.45835541594, 54735.726321368136, 54738.0, 54750.45249547533, 54779.72610136924, 58112.41887581155, 58139.418605814244, 58201.0, 58289.0, 58291.0, 14555.12669239849, 14817.259137043106, 14877.702445951021, 14878.553643390716, 14902.850971490363, 10163.390196588081, 10998.230123891411, 11239.775204496027, 11443.542258309575, 11493.42532873353, 17043.40348087811, 17077.146142692814, 17141.400050998403, 17199.484015479306, 17252.223649935782, 5645.435456454322, 5716.456936591017, 5748.137779333133, 5767.480926716616, 5898.469137777534, 812.3663542436909, 866.467122719523, 899.9505027223435, 921.0768442673897, 983.0022527134963, 27160.592591111148, 27846.27047299876, 27943.860280698467, 28227.435451290858, 28323.57514637282, 935.1677007463363, 959.8032403357295, 1008.2186305613062, 1041.5313109100935, 1052.7315534538643, 14422.42310307576, 14870.925645371704, 14895.92552037233, 15013.249337533298, 15101.546953591409, 374256.0, 377744.0, 378241.0, 378679.0, 380439.0, 48879.511204887494, 49093.509064908896, 49147.50852491501, 49294.0, 49312.0, 1069.3583849690124, 1131.9773604528027, 1169.6783384569312, 1224.64485299264, 1241.0, 26191.0, 28764.280892977844, 29178.41643167167, 29534.704652953194, 29565.0, 42784.0, 42951.49009353973, 43241.567584325014, 43372.0, 43401.782991086104, 295670.0, 295793.0, 296403.0, 296506.0, 297748.0, 31186.376272473968, 36056.819715901256, 36406.635933640326, 37575.81212093922, 37598.0, 40798.0, 41985.370219447344, 42120.0, 42449.78775106105, 42793.572064280204, 35562.46656300106, 36494.8175259122, 36516.45225321569, 36800.63199367972, 37116.25767484689, 35893.461598076574, 35999.64000359963, 36302.63697363098, 36304.27391452209, 36591.63408365989, 35358.46962295619, 35551.11122221965, 35573.466398004566, 36166.819165904, 36271.45592816057, 31674.683253168096, 32090.839545802122, 32282.677173227967, 32380.676193237767, 32700.0, 24661.26016219516, 24765.50468990574, 25057.123000695618, 25391.61912571276, 25419.36451588725], "value": 18045.598231592256, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.5550920062579, 368.3829585444381, 372.4617927095347, 374.0214266530056, 380.3666894620457, 15854.207289635515, 17372.826271737278, 17384.47846564605, 17670.204840782164, 17826.19782109805, 16548.420805271817, 17192.742108868377, 17610.383636572722, 17615.207315670792, 17627.0, 4883.951160488394, 5106.106431374513, 5131.563817075535, 5143.0, 5152.201408781645, 3712.109093817491, 3907.0, 4953.108440480712, 5640.520555752766, 5962.612430192045, 6003.519718422515, 6010.639361638294, 6018.488428483584, 6031.819045428644, 6049.364816694249, 5849.795257165979, 5883.970580147115, 5927.199828023205, 5935.28776546815, 6027.09593560965, 3312.569365982431, 4884.511548845123, 5169.793208271664, 5188.948110518884, 5213.765380557884, 19845.0, 20397.38807835767, 20527.0, 20766.58466830655, 20779.79220207809, 1799.9010054447, 2050.4156315450173, 2122.991578999978, 2151.7310336207975, 2262.196920093376, 12713.809292860615, 13065.804012939814, 13065.934670326682, 13491.797623035662, 13551.932240338834, 1724.6787387539973, 1755.3154269834774, 1793.1303317890813, 1802.78366596008, 1805.9458216253533, 41828.79085604583, 46879.53120468786, 67151.32848671499, 67388.0, 67873.66063169652, 9314.95342523283, 9375.671851485302, 9564.18704410119, 9573.952130239304, 9960.352577082467, 12510.937445312715, 12526.874731252754, 12598.181118227287, 12606.55877044299, 12632.684182895317, 6862.897056544156, 7194.388476979515, 7284.526505777108, 7372.705091796375, 7404.0, 6646.202455705346, 6658.134442522538, 6882.208546017172, 6942.8611427772175, 7107.964460177666, 6004.42957918997, 6240.876642204446, 6241.21984751906, 6256.186695729617, 6370.426661600385, 1609.3723447855346, 1724.8878822876472, 1765.1791916758768, 1766.4563029237856, 1816.4641430777951, 813.2558708781517, 845.9915400846036, 910.1808372464702, 924.5469719837231, 971.6842026341467, 16668.916655416888, 16955.15224238783, 17239.0, 17286.13569321529, 17581.7362739559, 826.7002369081, 836.9707060252862, 867.6312567158932, 870.8998465176459, 892.0856122474515, 9685.370450920667, 9877.506124693737, 9926.602935882629, 9944.80110397788, 10005.19958403326, 382439.0, 387883.0, 388673.0, 390773.0, 395469.0, 43061.78469107635, 61515.692421537606, 69080.6545967267, 69232.65383673151, 69968.6501567499, 918.9724308270629, 928.331601247101, 928.5218112671979, 937.5406051034944, 947.6446332625266, 15129.092254464767, 15186.316615752097, 15370.538883833502, 15402.46091386796, 15648.92175539115, 31651.683483164874, 32872.67127328792, 33094.0, 34060.14849628779, 34191.0, 43490.0, 44801.55198448104, 45597.0, 46773.76613117049, 47412.52587474081, 6515.902261466176, 6825.761098361533, 6879.552829066095, 7706.3449606781805, 7855.921440785748, 11298.887011130113, 11843.460350154424, 11936.224145430519, 11980.820287695866, 12057.336846473529, 6735.562188457735, 9875.456849873326, 10104.292699510963, 10237.590496380359, 10263.7434064149, 5761.193432919478, 7686.538807671557, 9868.279744451853, 10253.384796912209, 10542.52558634848, 10086.29395942277, 10454.163666906477, 10560.888330691754, 10647.680569582924, 10697.839532407175, 7612.200718924433, 7674.9232507674205, 7741.0, 7764.184760600281, 7934.2859142677435, 7791.805204869697, 9729.756756081155, 10306.742331441474, 10407.583696652351, 10509.894901050891], "value": 8160.202017059195, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1217.8112392579142, 1354.7155097429543, 1405.5642750747265, 1436.439788482492, 1665.6169081111336, 6811.0, 7709.5374277543315, 7955.085165206003, 7973.760787176379, 8209.876851847228, 7937.20627937206, 8092.0694120176195, 8113.188681131898, 8115.3101986331085, 8120.066192387877, 1836.2287839107607, 1895.1755986146002, 1899.221319259097, 2215.7562668106493, 2246.382244882654, 1925.922963081482, 2048.5288383671764, 2098.6222479953603, 2110.1453911166004, 2133.3386650138427, 2092.932604371766, 2117.100232401231, 2121.7772133925946, 2125.415510734545, 2125.9893700531475, 1797.6494583556212, 2087.551176497053, 2093.235968871351, 2095.287602215254, 2097.737782777153, 2068.7103805467245, 2146.270268108835, 2146.3239079689847, 2169.8155656769195, 2172.2288587551507, 7968.880466792944, 8017.919820801834, 8024.27781499662, 8027.719029833927, 8035.357171426272, 4618.307253911907, 4777.402824646919, 4778.020505796303, 4780.11567859947, 4781.8087276508895, 2798.608194852722, 2900.129961011688, 2908.69458706837, 2917.081119447367, 2977.940441191164, 889.7597648634897, 920.3741455810047, 948.2271948362063, 970.6990832841842, 973.0609961387224, 10994.890051099466, 10997.175211859143, 11004.0, 11015.944920275348, 11031.062359699356, 4232.661387089025, 4302.26861433557, 4380.386745855582, 4407.316865885793, 4409.184300904343, 9367.578458969363, 9401.10689484498, 9404.670836520689, 9416.058394160666, 9419.576119074658, 4642.72143671374, 4698.1778188816825, 4701.200795864711, 4708.4820669726305, 4710.3405523226775, 3579.6062433132333, 3755.493008443825, 4129.793510324532, 4163.437935878678, 4164.43780089684, 3612.945805812915, 3675.9632403676155, 3735.738498305147, 3757.49273848027, 3761.3417651910804, 1121.9382933938548, 1168.2873447197203, 1172.7713095946208, 1175.9412029398495, 1206.6199147268583, 760.2207737069548, 786.0371045469369, 794.8887155798193, 827.7020272701823, 851.0510780479844, 5143.897122057538, 5196.870078247998, 5345.919811202835, 5531.3915469298345, 5537.1140617501005, 801.531104303977, 815.5718247919771, 821.4947807098711, 858.3350678441577, 870.6604424274537, 3542.1852973816167, 3574.1243395367783, 3617.330793803155, 3627.002574292038, 3687.502187204693, 9576.712698619052, 9838.409695418297, 9912.851307230398, 9919.553620087114, 9922.950385248172, 9449.858252126223, 9575.329726919188, 9640.517974101267, 9670.274729395323, 9848.0, 7133.286671332825, 7150.785476435715, 7219.74730884427, 7243.4929554931705, 7250.782476525713, 4979.850604481871, 5005.549500544968, 5099.745012749422, 5148.279240906201, 5200.557952574073, 8609.708543718492, 8647.78930949655, 8727.476351418934, 8743.081976392386, 8748.69379571712, 8766.21104100634, 8868.0, 9099.226565741987, 9126.45241285525, 9417.670381536613, 5868.354481007001, 6482.643454610042, 6601.933980660132, 6911.343422374866, 7171.390431813355, 7252.927470725225, 7438.516496427715, 7513.323800857949, 7514.699412023458, 7515.586642734484, 6370.968145159244, 6652.501062420241, 6726.0, 6732.629705366252, 6773.288804675438, 6457.741690332334, 6501.609903405811, 6519.054737063194, 6529.412352888263, 6579.374959378852, 6196.0, 6299.023651334051, 6318.115463834974, 6321.589096708699, 6324.905126423199, 4173.457450531411, 4321.632661223831, 4350.9347359789, 4365.301551751704, 4391.407160033355, 4357.607815296638, 4402.84590039347, 4468.664850136188, 4476.820927162877, 4536.546345365569], "value": 4101.912293739392, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [285.9676567590996, 293.96766355700873, 296.5418428527924, 297.98957036503725, 299.4639595124727, 4761.40482439695, 4827.734474603895, 4828.758562071891, 4845.22476403775, 4865.008020067659, 4696.201645720227, 4718.197906355919, 4734.84564523142, 4739.644526660497, 4747.667663263573, 3565.768225065369, 3623.0, 3696.5009723687363, 3708.6278077111506, 3777.58446570877, 3728.8881333560034, 3729.9254014919684, 3736.9813150934206, 3771.66055055045, 3775.207206486641, 3552.2717842842158, 3728.832202550892, 3740.4389341598708, 3743.9438408423894, 3750.324941510527, 3607.0, 3686.318031164243, 3694.4827724118377, 3702.129999450127, 3712.795796231206, 3266.03651922681, 3272.394606997689, 3275.902572638169, 3290.8683652654104, 3291.358185153896, 4532.3201519771965, 4538.546145385468, 4549.7042692224895, 4582.335561343587, 4610.216263235225, 4095.3242714952, 4279.229738647074, 4292.892677683051, 4297.247981603207, 4297.634701050414, 4989.351384320052, 5002.474740152268, 5012.649114561982, 5017.422996355429, 5045.344105266328, 3617.2042150726797, 3628.5645722513204, 3637.7089832813313, 3641.14433108222, 3644.3804553226014, 5037.244413338029, 5178.896422071537, 5212.322398088224, 5267.947320526822, 5276.736163191825, 3675.9081022974638, 3678.006938126691, 3685.6682898538725, 3687.391580389259, 3698.556173259226, 3753.9061523461587, 3764.3036038333, 3772.9434058489146, 3775.0751065989007, 3777.471154038437, 4268.573142685706, 4298.398224248608, 4298.570142985676, 4311.805968731414, 4312.396264522969, 4829.0, 4978.6763860348965, 4978.904640978979, 5012.172991456368, 5067.290579318898, 1316.1247770232687, 1328.35574746248, 1331.3409862118313, 1335.1721932401972, 1344.4017412251453, 855.8587833007484, 865.4288169807896, 883.2492381475822, 900.4867225681298, 902.8284625921054, 4429.512753597101, 4449.888752781141, 4451.221036318631, 4474.977625111918, 4478.977605111953, 5093.18509038552, 5115.846524604268, 5141.948580514222, 5169.121249387613, 5198.7140707260705, 4234.237837189274, 4416.734995900256, 4454.844080457168, 4460.598546130864, 4463.174312752151, 2706.9729302707115, 2715.5383584790634, 2718.9592156117674, 2728.6043523688954, 2744.67063952327, 4850.08421673437, 4887.437944636341, 4887.755612219375, 4894.706317620954, 4897.191963326082, 5065.1765364468765, 5165.870853228699, 5216.921746173811, 5240.973795131, 5253.264542963988, 4807.158747219222, 4820.493848145964, 4824.059308434821, 4843.2735089736825, 4877.487863774252, 5093.60600517756, 5126.0, 5148.58811295103, 5148.665336753099, 5155.6284109308635, 4725.196716558262, 4948.6535942485125, 4994.300797888226, 5051.74741262928, 5054.69671819692, 4791.4729379767505, 4824.8793780155775, 4825.300331451849, 4837.588804951478, 4844.563989240985, 3735.8045425463592, 3743.1952130292116, 3759.661630453272, 3772.396416573335, 3779.168582911755, 4858.319835223001, 5144.459831717765, 5144.688104533469, 5145.536901678867, 5223.608229382736, 5036.924446133385, 5042.0, 5046.823361182341, 5050.949490505195, 5052.191649336089, 5046.142155833444, 5055.418626857811, 5058.570021548209, 5060.544550990281, 5078.136716758234, 4758.834085648899, 4838.177509823409, 4961.975190124026, 5006.449290577961, 5008.6243531734535, 4935.580475659609, 5049.621278404061, 5070.721110338966, 5074.416442109205, 5080.46655101209, 4942.20924652054, 4957.578605818546, 4966.875828104182, 4977.800887964441, 4993.950060499348], "value": 3787.5761674500463, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.2582231832096, 627.1627377451103, 631.4317114596862, 677.5121912223198, 715.778108786276, 12328.938355308223, 13381.0, 14136.36386362615, 14732.33704483298, 14758.778618320734, 13475.460981560751, 13519.391627376766, 13530.18818870866, 13561.864381356183, 13602.523911663095, 622.4926684751936, 767.2902565127263, 792.976210713678, 800.4916877782591, 801.883726859605, 791.3708601661692, 802.7110240313483, 802.7591722483261, 802.8755542890832, 802.9678812847479, 835.5905606252923, 842.5155535567043, 842.5913431985482, 843.464400105934, 843.5908584336592, 642.75575281393, 810.7973006748313, 837.7863644770605, 843.2452954605624, 843.7089204224533, 617.5121653893419, 617.8887800195963, 618.1191801682585, 618.1253526260336, 618.165476606582, 12866.228026318357, 12911.483540658362, 13072.346382680827, 13128.803067953988, 13140.540081097211, 11664.0, 11997.28016319015, 12235.93882030584, 12280.815787763191, 12410.317432541207, 11618.0, 11663.86571285515, 11746.588869389616, 11867.465964031639, 11938.462769175409, 4113.8971525711795, 4137.958620413788, 4168.499780026386, 4202.831886724527, 4267.231898258312, 56427.153592696144, 57078.42921570773, 57489.13766293509, 57918.13122803161, 57942.13086803701, 9924.057214564606, 9969.601215951281, 10043.899561004297, 10231.59073637061, 10302.227332950059, 18286.542836429195, 18723.25106995705, 18743.156557954924, 18748.0, 18779.718304225175, 6873.072135261776, 7108.182559005677, 7138.607376594337, 7143.178534468499, 7359.0, 3720.720945929066, 3793.696504279706, 3832.885013449601, 3841.9231615368094, 3929.8035098244973, 2876.395956849043, 3006.7895247332913, 3011.8795248189826, 3012.4125795470113, 3013.608230929965, 530.3079481276893, 531.4021725558746, 535.9115745901961, 540.4730387871793, 547.7261369315343, 424.4227850123829, 442.7122370459163, 470.41198501872657, 496.84349429929455, 521.4186182406589, 7491.363234125051, 7663.808404789925, 7717.961410192913, 7849.136594974549, 7951.522908625501, 415.65915948921594, 463.5480406603535, 487.9143904811836, 509.4548832748923, 509.94187061846816, 4104.0, 4372.584604462634, 4469.955300447019, 4524.954750452519, 4534.909301813946, 69911.0, 96648.51675741577, 100623.49688251512, 100831.0, 102555.0, 53618.73190634022, 60784.392156077876, 79522.20477795148, 85058.57470712607, 89520.0, 75055.24944750592, 76092.0, 76454.0, 77709.61145194237, 77832.61083694658, 8416.452930559493, 8416.915830841614, 8428.154214325901, 8507.702230421906, 8528.403011789364, 44686.0, 45177.54822451865, 45188.77405612951, 45321.77339113283, 45790.0, 64129.35870641234, 67625.0, 67861.3213867855, 67972.32027679858, 68273.0, 10792.676219713421, 10932.398718070264, 11106.111511079256, 11268.098552115975, 11507.367094809866, 11840.70398240051, 12336.938315308365, 12704.30126343023, 12724.427400766803, 13208.801867971795, 10957.232993690364, 11292.892860889293, 11376.658700239006, 11427.885721142682, 11604.361760103275, 10830.350178989285, 10853.945730271298, 10856.45717714127, 11006.504707288032, 11378.601748938747, 10134.949325253621, 10177.338472999232, 10253.384796912209, 10367.377957322586, 10944.45277736094, 9624.855627165738, 10066.949665251626, 10081.596736130767, 10129.696109116738, 10153.289269751047, 9683.32216744821, 9906.950465247628, 9942.75715535558, 9982.201423885926, 10076.395416274754], "value": 6524.736015961151, "unit": "score"}], "name": "dromaeo_css", "value": 6414.673142372798, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 109.0, 114.0, 121.0, 112.0, 114.0, 112.0, 113.0, 112.0, 112.0], "value": 113.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 137.0, 133.0, 186.0, 133.0, 135.0, 162.0, 134.0, 172.0, 135.0], "value": 148.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 163.0, 162.0, 162.0, 161.0, 161.0, 160.0, 162.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 76.0, 77.0, 126.0, 75.0, 76.0, 76.0, 75.0, 99.0, 76.0], "value": 84.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 129.0, 86.0, 88.0, 86.0, 122.0, 86.0, 86.0, 125.0], "value": 98.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 119.0, 117.0, 118.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 146.0, 147.0, 146.0, 147.0, 146.0, 145.0, 146.0, 146.0, 147.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 94.0, 95.0, 95.0, 94.0, 95.0, 94.0, 96.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 63.0, 63.0, 63.0, 63.0, 63.0, 62.0, 63.0, 63.0], "value": 62.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 65.0, 65.0, 65.0, 65.0, 66.0, 65.0, 64.0], "value": 65.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 93.0, 83.0, 85.0, 84.0, 85.0, 91.0, 117.0, 84.0], "value": 89.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 141.0, 132.0, 133.0, 139.0, 137.0, 138.0, 134.0, 144.0, 136.0], "value": 137.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 170.0, 172.0, 170.0, 167.0, 174.0, 168.0, 170.0, 168.0, 171.0], "value": 169.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 67.0, 67.0, 66.0, 67.0, 67.0, 67.0, 66.0], "value": 66.8, "unit": "score"}], "name": "kraken", "value": 1553.7999999999997, "alertThreshold": 2.0}]} 09:14:02 INFO - Return code: 0 09:14:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:14:02 ERROR - # TBPL SUCCESS # 09:14:02 INFO - Running post-action listener: _resource_record_post_action 09:14:02 INFO - ##### 09:14:02 INFO - ##### Finished run-tests step (success) 09:14:02 INFO - ##### 09:14:02 INFO - Running post-run listener: _resource_record_post_run 09:14:02 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 200704; Write bytes: 299339776; Read time: 304; Write time: 242264 09:14:02 INFO - TinderboxPrint: CPU usage
13.1% 09:14:02 INFO - TinderboxPrint: I/O read bytes / time
200,704 / 304 09:14:02 INFO - TinderboxPrint: I/O write bytes / time
299,339,776 / 242,264 09:14:02 INFO - TinderboxPrint: CPU idle
8,337.9 (86.9%) 09:14:02 INFO - TinderboxPrint: CPU user
1,213.8 (12.6%) 09:14:02 INFO - TinderboxPrint: Swap in / out
0 / 0 09:14:02 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 18038784; Read time: 0; Write time: 3068 09:14:02 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 200704; Write bytes: 281300992; Read time: 304; Write time: 239196 09:14:03 INFO - Running post-run listener: _upload_blobber_files 09:14:03 INFO - Blob upload gear active. 09:14:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:14:03 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 09:14:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:14:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:14:03 INFO - (blobuploader) - INFO - Open directory for files ... 09:14:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:14:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:14:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:14:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:14:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:14:07 INFO - (blobuploader) - INFO - Done attempting. 09:14:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:14:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:14:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:14:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:14:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:14:08 INFO - (blobuploader) - INFO - Done attempting. 09:14:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:14:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:14:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:14:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:14:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:14:09 INFO - (blobuploader) - INFO - Done attempting. 09:14:09 INFO - (blobuploader) - INFO - Iteration through files over. 09:14:09 INFO - Return code: 0 09:14:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:14:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:14:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/eb8dc03ad72b1edbebbe2ae9d2b89a86808ecbb23a7d5c7abc6e2e3592893fe2585027e3736b0d3434cb02de0b79a3861562c798ab71e4a944f1f9edf14ca34b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b2f3adc72475c53299838e197ce407cb35d479618bff61d425fceeca76514760caa1ec861ff8b916a0e7a15521357c5eed19e8561fcfc0adf920a505d9c9dd15", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3361a5bc43d6f1d7c96d77dca672d14d64193e5ba66c32fdba2149bd08ae5921d2cca53fd1a57b726d184032fe48129622bcb20b4696e4e8f8547c456e78c1fb"} 09:14:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:14:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:14:09 INFO - Contents: 09:14:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/eb8dc03ad72b1edbebbe2ae9d2b89a86808ecbb23a7d5c7abc6e2e3592893fe2585027e3736b0d3434cb02de0b79a3861562c798ab71e4a944f1f9edf14ca34b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b2f3adc72475c53299838e197ce407cb35d479618bff61d425fceeca76514760caa1ec861ff8b916a0e7a15521357c5eed19e8561fcfc0adf920a505d9c9dd15", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3361a5bc43d6f1d7c96d77dca672d14d64193e5ba66c32fdba2149bd08ae5921d2cca53fd1a57b726d184032fe48129622bcb20b4696e4e8f8547c456e78c1fb"} 09:14:09 INFO - Running post-run listener: copy_logs_to_upload_dir 09:14:09 INFO - Copying logs to upload dir... 09:14:09 INFO - mkdir: /builds/slave/test/build/upload/logs 09:14:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.060323 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-06-08 09:14:09.497341) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 09:14:09.501082) ========= 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=fa44defc139c4ba8574fe040000001db-1465400314.319056-228213986 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/eb8dc03ad72b1edbebbe2ae9d2b89a86808ecbb23a7d5c7abc6e2e3592893fe2585027e3736b0d3434cb02de0b79a3861562c798ab71e4a944f1f9edf14ca34b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b2f3adc72475c53299838e197ce407cb35d479618bff61d425fceeca76514760caa1ec861ff8b916a0e7a15521357c5eed19e8561fcfc0adf920a505d9c9dd15", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3361a5bc43d6f1d7c96d77dca672d14d64193e5ba66c32fdba2149bd08ae5921d2cca53fd1a57b726d184032fe48129622bcb20b4696e4e8f8547c456e78c1fb"} build_url:https://queue.taskcluster.net/v1/task/JEf-drlOQwek0NmKtpUbKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011294 build_url: 'https://queue.taskcluster.net/v1/task/JEf-drlOQwek0NmKtpUbKg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/eb8dc03ad72b1edbebbe2ae9d2b89a86808ecbb23a7d5c7abc6e2e3592893fe2585027e3736b0d3434cb02de0b79a3861562c798ab71e4a944f1f9edf14ca34b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b2f3adc72475c53299838e197ce407cb35d479618bff61d425fceeca76514760caa1ec861ff8b916a0e7a15521357c5eed19e8561fcfc0adf920a505d9c9dd15", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3361a5bc43d6f1d7c96d77dca672d14d64193e5ba66c32fdba2149bd08ae5921d2cca53fd1a57b726d184032fe48129622bcb20b4696e4e8f8547c456e78c1fb"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 09:14:09.526939) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 09:14:09.527394) ========= 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=fa44defc139c4ba8574fe040000001db-1465400314.319056-228213986 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004751 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 09:14:09.611826) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 09:14:09.612144) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 09:14:09.614754) ========= ========= Total master_lag: 0.18 =========