builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-060 starttime: 1464359297.87 results: success (0) buildid: 20160527062742 builduid: 035667decf304021b3c5862c967568e3 revision: dd3e899cfa818fcbb47b3d7432e0977e835702ee ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-27 07:28:17.865742) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-27 07:28:17.866422) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-27 07:28:17.866783) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-27 07:28:17.943919) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 07:28:17.944316) ========= 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=337fe3f4b1febe37b85fccc40000019e-1464358775.984300-115721101 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-27 07:28: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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 50.8M=0s 2016-05-27 07:28:18 (50.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.126258 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 07:28:18.088121) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 07:28:18.088697) ========= 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=337fe3f4b1febe37b85fccc40000019e-1464358775.984300-115721101 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019975 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 07:28:18.139819) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 07:28:18.140209) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev dd3e899cfa818fcbb47b3d7432e0977e835702ee --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 dd3e899cfa818fcbb47b3d7432e0977e835702ee --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=337fe3f4b1febe37b85fccc40000019e-1464358775.984300-115721101 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-27 07:28:19,000 truncating revision to first 12 chars 2016-05-27 07:28:19,000 Setting DEBUG logging. 2016-05-27 07:28:19,000 attempt 1/10 2016-05-27 07:28:19,000 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/dd3e899cfa81?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-27 07:28:19,291 unpacking tar archive at: fx-team-dd3e899cfa81/testing/mozharness/ program finished with exit code 0 elapsedTime=0.669926 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 07:28:18.823907) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-27 07:28:18.824222) ========= script_repo_revision: dd3e899cfa818fcbb47b3d7432e0977e835702ee ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-27 07:28:18.824645) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-27 07:28:18.824926) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-27 07:28:18.835011) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-05-27 07:28:18.835320) ========= /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=337fe3f4b1febe37b85fccc40000019e-1464358775.984300-115721101 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:28:19 INFO - MultiFileLogger online at 20160527 07:28:19 in /builds/slave/test 07:28: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 07:28:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:28:19 INFO - {'append_to_log': False, 07:28:19 INFO - 'base_work_dir': '/builds/slave/test', 07:28:19 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 07:28:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:28:19 INFO - 'branch': 'Fx-Team-Non-PGO', 07:28:19 INFO - 'buildbot_json_path': 'buildprops.json', 07:28:19 INFO - 'config_files': ('talos/linux_config.py',), 07:28:19 INFO - 'default_actions': ('clobber', 07:28:19 INFO - 'read-buildbot-config', 07:28:19 INFO - 'download-and-extract', 07:28:19 INFO - 'populate-webroot', 07:28:19 INFO - 'create-virtualenv', 07:28:19 INFO - 'install', 07:28:19 INFO - 'run-tests'), 07:28:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:28:19 INFO - 'download_minidump_stackwalk': True, 07:28:19 INFO - 'download_symbols': 'ondemand', 07:28:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:28:19 INFO - 'tooltool.py': '/tools/tooltool.py', 07:28:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:28:19 INFO - '/tools/misc-python/virtualenv.py')}, 07:28:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:28:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:28:19 INFO - 'installer_path': 'installer.exe', 07:28:19 INFO - 'log_level': 'info', 07:28:19 INFO - 'log_name': 'talos', 07:28:19 INFO - 'log_to_console': True, 07:28:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:28:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:28:19 INFO - 'opt_config_files': (), 07:28:19 INFO - 'pip_index': False, 07:28:19 INFO - 'sps_profile': False, 07:28:19 INFO - 'sps_profile_interval': 0, 07:28:19 INFO - 'suite': 'dromaeojs', 07:28:19 INFO - 'system_bits': '32', 07:28:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:28:19 INFO - 'title': 'talos-linux64-ix-060', 07:28:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:28:19 INFO - 'use_talos_json': True, 07:28:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:28:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:28:19 INFO - 'work_dir': 'build'} 07:28:19 INFO - ##### 07:28:19 INFO - ##### Running clobber step. 07:28:19 INFO - ##### 07:28:19 INFO - Running pre-action listener: _resource_record_pre_action 07:28:19 INFO - Running main action method: clobber 07:28:19 INFO - rmtree: /builds/slave/test/build 07:28:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:28:20 INFO - Running post-action listener: _resource_record_post_action 07:28:20 INFO - ##### 07:28:20 INFO - ##### Finished clobber step (success) 07:28:20 INFO - ##### 07:28:20 INFO - ##### 07:28:20 INFO - ##### Running read-buildbot-config step. 07:28:20 INFO - ##### 07:28:20 INFO - Running pre-action listener: _resource_record_pre_action 07:28:20 INFO - Running main action method: read_buildbot_config 07:28:20 INFO - Using buildbot properties: 07:28:20 INFO - { 07:28:20 INFO - "project": "", 07:28:20 INFO - "product": "firefox", 07:28:20 INFO - "script_repo_revision": "production", 07:28:20 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 07:28:20 INFO - "repository": "", 07:28:20 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 07:28:20 INFO - "buildid": "20160527062742", 07:28:20 INFO - "pgo_build": "False", 07:28:20 INFO - "basedir": "/builds/slave/test", 07:28:20 INFO - "buildnumber": 1793, 07:28:20 INFO - "slavename": "talos-linux64-ix-060", 07:28:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:28:20 INFO - "platform": "ubuntu64_hw", 07:28:20 INFO - "scheduler": "tests-fx-team-linux64-talos", 07:28:20 INFO - "branch": "fx-team", 07:28:20 INFO - "repo_path": "integration/fx-team", 07:28:20 INFO - "revision": "dd3e899cfa818fcbb47b3d7432e0977e835702ee", 07:28:20 INFO - "stage_platform": "linux64", 07:28:20 INFO - "builduid": "035667decf304021b3c5862c967568e3", 07:28:20 INFO - "slavebuilddir": "test" 07:28:20 INFO - } 07:28:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/LdwHZ-v-T3ShHldFVDqqgg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 07:28:20 INFO - Running post-action listener: _resource_record_post_action 07:28:20 INFO - ##### 07:28:20 INFO - ##### Finished read-buildbot-config step (success) 07:28:20 INFO - ##### 07:28:20 INFO - ##### 07:28:20 INFO - ##### Running download-and-extract step. 07:28:20 INFO - ##### 07:28:20 INFO - Running pre-action listener: _resource_record_pre_action 07:28:20 INFO - Running main action method: download_and_extract 07:28:20 INFO - mkdir: /builds/slave/test/build/tests 07:28: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')]} 07:28:20 INFO - https://queue.taskcluster.net/v1/task/LdwHZ-v-T3ShHldFVDqqgg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:28:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LdwHZ-v-T3ShHldFVDqqgg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:28:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LdwHZ-v-T3ShHldFVDqqgg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:28:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LdwHZ-v-T3ShHldFVDqqgg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:28:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LdwHZ-v-T3ShHldFVDqqgg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:28:20 INFO - Downloaded 1361 bytes. 07:28:20 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:28:20 INFO - Using the following test package requirements: 07:28:20 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:28:20 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:28:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:28:20 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:28:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:28:20 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:28:20 INFO - u'jsshell-linux-x86_64.zip'], 07:28:20 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:28:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:28:20 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:28:20 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:28:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:28:20 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:28:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:28:20 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:28:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:28:20 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:28:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:28:20 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:28: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')]} 07:28:20 INFO - https://queue.taskcluster.net/v1/task/LdwHZ-v-T3ShHldFVDqqgg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:28:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LdwHZ-v-T3ShHldFVDqqgg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:28:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LdwHZ-v-T3ShHldFVDqqgg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:28:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LdwHZ-v-T3ShHldFVDqqgg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:28:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LdwHZ-v-T3ShHldFVDqqgg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:28:22 INFO - Downloaded 22837963 bytes. 07:28:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:28:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:28:23 INFO - Return code: 0 07:28:23 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:28: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')]} 07:28:23 INFO - https://queue.taskcluster.net/v1/task/LdwHZ-v-T3ShHldFVDqqgg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:28:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LdwHZ-v-T3ShHldFVDqqgg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:28:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LdwHZ-v-T3ShHldFVDqqgg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:28:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LdwHZ-v-T3ShHldFVDqqgg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:28:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LdwHZ-v-T3ShHldFVDqqgg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:28:25 INFO - Downloaded 22837963 bytes. 07:28:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:28:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:28:26 INFO - Return code: 0 07:28: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')]} 07:28:26 INFO - https://queue.taskcluster.net/v1/task/LdwHZ-v-T3ShHldFVDqqgg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:28:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LdwHZ-v-T3ShHldFVDqqgg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:28:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LdwHZ-v-T3ShHldFVDqqgg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:28:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LdwHZ-v-T3ShHldFVDqqgg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:28:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LdwHZ-v-T3ShHldFVDqqgg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:28:27 INFO - Downloaded 10834034 bytes. 07:28:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:28:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 07:28:27 INFO - Return code: 0 07:28:27 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')]} 07:28:27 INFO - https://queue.taskcluster.net/v1/task/LdwHZ-v-T3ShHldFVDqqgg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:28:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LdwHZ-v-T3ShHldFVDqqgg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:28:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LdwHZ-v-T3ShHldFVDqqgg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:28:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LdwHZ-v-T3ShHldFVDqqgg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:28:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LdwHZ-v-T3ShHldFVDqqgg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:28:29 INFO - Downloaded 54834482 bytes. 07:28:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LdwHZ-v-T3ShHldFVDqqgg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:28:29 INFO - mkdir: /builds/slave/test/properties 07:28:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:28:29 INFO - Writing to file /builds/slave/test/properties/build_url 07:28:29 INFO - Contents: 07:28:29 INFO - build_url:https://queue.taskcluster.net/v1/task/LdwHZ-v-T3ShHldFVDqqgg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:28:29 INFO - Running post-action listener: _resource_record_post_action 07:28:29 INFO - Running post-action listener: set_extra_try_arguments 07:28:29 INFO - ##### 07:28:29 INFO - ##### Finished download-and-extract step (success) 07:28:29 INFO - ##### 07:28:29 INFO - ##### 07:28:29 INFO - ##### Running populate-webroot step. 07:28:29 INFO - ##### 07:28:29 INFO - Running pre-action listener: _resource_record_pre_action 07:28:29 INFO - Running main action method: populate_webroot 07:28:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:28:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:28:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:28:29 INFO - '--tppagecycles', 07:28:29 INFO - '7'], 07:28:29 INFO - 'tests': ['tsvgm']}}, 07:28:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:28:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:28:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:28:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:28:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:28:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:28:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:28:29 INFO - 'talos_options': ['--disable-e10s'], 07:28:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:28:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:28:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:28:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:28:29 INFO - 'talos_options': ['--disable-e10s'], 07:28:29 INFO - 'tests': ['damp', 'tps']}, 07:28:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:28:29 INFO - 'tests': ['damp', 'tps']}, 07:28:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:28:29 INFO - 'tests': ['dromaeo_dom']}, 07:28:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:28:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:28:29 INFO - 'tests': ['a11yr', 07:28:29 INFO - 'ts_paint', 07:28:29 INFO - 'tpaint', 07:28:29 INFO - 'sessionrestore', 07:28:29 INFO - 'sessionrestore_no_auto_restore', 07:28:29 INFO - 'tabpaint']}, 07:28:29 INFO - 'other-e10s': {'tests': ['a11yr', 07:28:29 INFO - 'ts_paint', 07:28:29 INFO - 'tpaint', 07:28:29 INFO - 'sessionrestore', 07:28:29 INFO - 'sessionrestore_no_auto_restore', 07:28:29 INFO - 'tabpaint']}, 07:28:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:28:29 INFO - 'ts_paint', 07:28:29 INFO - 'tpaint', 07:28:29 INFO - 'sessionrestore', 07:28:29 INFO - 'sessionrestore_no_auto_restore', 07:28:29 INFO - 'tabpaint']}, 07:28:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:28:29 INFO - 'ts_paint', 07:28:29 INFO - 'tpaint', 07:28:29 INFO - 'sessionrestore', 07:28:29 INFO - 'sessionrestore_no_auto_restore', 07:28:29 INFO - 'tabpaint']}, 07:28:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:28:29 INFO - 'tests': ['a11yr', 07:28:29 INFO - 'ts_paint', 07:28:29 INFO - 'tpaint', 07:28:29 INFO - 'sessionrestore', 07:28:29 INFO - 'sessionrestore_no_auto_restore', 07:28:29 INFO - 'tabpaint']}, 07:28:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:28:29 INFO - 'tests': ['a11yr', 07:28:29 INFO - 'ts_paint', 07:28:29 INFO - 'tpaint', 07:28:29 INFO - 'sessionrestore', 07:28:29 INFO - 'sessionrestore_no_auto_restore', 07:28:29 INFO - 'tabpaint']}, 07:28:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:28:29 INFO - 'tests': ['tsvgx', 07:28:29 INFO - 'tsvgr_opacity', 07:28:29 INFO - 'tart', 07:28:29 INFO - 'tscrollx', 07:28:29 INFO - 'cart']}, 07:28:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:28:29 INFO - 'tsvgr_opacity', 07:28:29 INFO - 'tart', 07:28:29 INFO - 'tscrollx', 07:28:29 INFO - 'cart']}, 07:28:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:28:29 INFO - 'talos_options': ['--disable-e10s'], 07:28:29 INFO - 'tests': ['tp5o']}, 07:28:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:28:29 INFO - 'tests': ['tp5o']}, 07:28:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:28:29 INFO - 'talos_options': ['--disable-e10s', 07:28:29 INFO - '--xperf_path', 07:28:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:28:29 INFO - 'tests': ['tp5n']}, 07:28:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:28:29 INFO - 'talos_options': ['--xperf_path', 07:28:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:28:29 INFO - 'tests': ['tp5n']}}, 07:28:29 INFO - 'talos.zip': {'path': '', 07:28:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:28:29 INFO - Running post-action listener: _resource_record_post_action 07:28:29 INFO - ##### 07:28:29 INFO - ##### Finished populate-webroot step (success) 07:28:29 INFO - ##### 07:28:29 INFO - ##### 07:28:29 INFO - ##### Running create-virtualenv step. 07:28:29 INFO - ##### 07:28:29 INFO - Running pre-action listener: _resource_record_pre_action 07:28:29 INFO - Running main action method: create_virtualenv 07:28:29 INFO - Creating virtualenv /builds/slave/test/build/venv 07:28:29 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 07:28:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:28:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:28:30 INFO - Using real prefix '/usr' 07:28:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:28:30 INFO - Installing distribute.............................................................................................................................................................................................done. 07:28:32 INFO - Installing pip.................done. 07:28:32 INFO - Return code: 0 07:28:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:28:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:32 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 0x7f2e655bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2799770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28289c0>, '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 0x28298c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2829d50>, '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': '337fe3f4b1febe37b85fccc40000019e-1464358775.984300-115721101', '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 07:28:32 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 07:28:32 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 07:28:32 INFO - Using env: {'DISPLAY': ':0', 07:28:32 INFO - 'HOME': '/home/cltbld', 07:28:32 INFO - 'LANG': 'en_US.UTF-8', 07:28:32 INFO - 'LANGUAGE': 'en_US:en', 07:28:32 INFO - 'LOGNAME': 'cltbld', 07:28:32 INFO - 'MAIL': '/var/mail/cltbld', 07:28:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:32 INFO - 'MOZ_NO_REMOTE': '1', 07:28:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:32 INFO - 'NO_EM_RESTART': '1', 07:28:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:32 INFO - 'PWD': '/builds/slave/test', 07:28:32 INFO - 'SHELL': '/bin/bash', 07:28:32 INFO - 'SHLVL': '1', 07:28:32 INFO - 'TERM': 'linux', 07:28:32 INFO - 'TMOUT': '86400', 07:28:32 INFO - 'USER': 'cltbld', 07:28:32 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1464358775.984300-115721101', 07:28:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:32 INFO - '_': '/tools/buildbot/bin/python'} 07:28:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:32 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 07:28:32 INFO - Cleaning up... 07:28:32 INFO - Return code: 0 07:28:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:28:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:32 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 0x7f2e655bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2799770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28289c0>, '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 0x28298c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2829d50>, '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': '337fe3f4b1febe37b85fccc40000019e-1464358775.984300-115721101', '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 07:28:32 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 07:28:32 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 07:28:32 INFO - Using env: {'DISPLAY': ':0', 07:28:32 INFO - 'HOME': '/home/cltbld', 07:28:32 INFO - 'LANG': 'en_US.UTF-8', 07:28:32 INFO - 'LANGUAGE': 'en_US:en', 07:28:32 INFO - 'LOGNAME': 'cltbld', 07:28:32 INFO - 'MAIL': '/var/mail/cltbld', 07:28:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:32 INFO - 'MOZ_NO_REMOTE': '1', 07:28:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:32 INFO - 'NO_EM_RESTART': '1', 07:28:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:32 INFO - 'PWD': '/builds/slave/test', 07:28:32 INFO - 'SHELL': '/bin/bash', 07:28:32 INFO - 'SHLVL': '1', 07:28:32 INFO - 'TERM': 'linux', 07:28:32 INFO - 'TMOUT': '86400', 07:28:32 INFO - 'USER': 'cltbld', 07:28:32 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1464358775.984300-115721101', 07:28:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:32 INFO - '_': '/tools/buildbot/bin/python'} 07:28:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:32 INFO - Downloading/unpacking psutil>=3.1.1 07:28:32 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 07:28:32 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 07:28:32 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 07:28:32 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 07:28:32 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 07:28:32 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 07:28:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:28:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:28:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:28:34 INFO - Installing collected packages: psutil 07:28:34 INFO - Running setup.py install for psutil 07:28:35 INFO - building 'psutil._psutil_linux' extension 07:28:35 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 07:28:35 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 07:28:35 INFO - building 'psutil._psutil_posix' extension 07:28:35 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 07:28:35 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 07:28:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:28:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:28:35 INFO - Successfully installed psutil 07:28:35 INFO - Cleaning up... 07:28:35 INFO - Return code: 0 07:28:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:28:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2e655bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2799770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28289c0>, '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 0x28298c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2829d50>, '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': '337fe3f4b1febe37b85fccc40000019e-1464358775.984300-115721101', '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 07:28:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:28:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:28:35 INFO - Using env: {'DISPLAY': ':0', 07:28:35 INFO - 'HOME': '/home/cltbld', 07:28:35 INFO - 'LANG': 'en_US.UTF-8', 07:28:35 INFO - 'LANGUAGE': 'en_US:en', 07:28:35 INFO - 'LOGNAME': 'cltbld', 07:28:35 INFO - 'MAIL': '/var/mail/cltbld', 07:28:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:35 INFO - 'MOZ_NO_REMOTE': '1', 07:28:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:35 INFO - 'NO_EM_RESTART': '1', 07:28:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:35 INFO - 'PWD': '/builds/slave/test', 07:28:35 INFO - 'SHELL': '/bin/bash', 07:28:35 INFO - 'SHLVL': '1', 07:28:35 INFO - 'TERM': 'linux', 07:28:35 INFO - 'TMOUT': '86400', 07:28:35 INFO - 'USER': 'cltbld', 07:28:35 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1464358775.984300-115721101', 07:28:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:35 INFO - '_': '/tools/buildbot/bin/python'} 07:28:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:28:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:28:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:28:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:28:37 INFO - Installing collected packages: mozsystemmonitor 07:28:37 INFO - Running setup.py install for mozsystemmonitor 07:28:37 INFO - Successfully installed mozsystemmonitor 07:28:37 INFO - Cleaning up... 07:28:37 INFO - Return code: 0 07:28:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:28:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2e655bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2799770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28289c0>, '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 0x28298c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2829d50>, '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': '337fe3f4b1febe37b85fccc40000019e-1464358775.984300-115721101', '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 07:28:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:28:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:28:37 INFO - Using env: {'DISPLAY': ':0', 07:28:37 INFO - 'HOME': '/home/cltbld', 07:28:37 INFO - 'LANG': 'en_US.UTF-8', 07:28:37 INFO - 'LANGUAGE': 'en_US:en', 07:28:37 INFO - 'LOGNAME': 'cltbld', 07:28:37 INFO - 'MAIL': '/var/mail/cltbld', 07:28:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:37 INFO - 'MOZ_NO_REMOTE': '1', 07:28:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:37 INFO - 'NO_EM_RESTART': '1', 07:28:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:37 INFO - 'PWD': '/builds/slave/test', 07:28:37 INFO - 'SHELL': '/bin/bash', 07:28:37 INFO - 'SHLVL': '1', 07:28:37 INFO - 'TERM': 'linux', 07:28:37 INFO - 'TMOUT': '86400', 07:28:37 INFO - 'USER': 'cltbld', 07:28:37 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1464358775.984300-115721101', 07:28:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:37 INFO - '_': '/tools/buildbot/bin/python'} 07:28:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:38 INFO - Downloading/unpacking blobuploader==1.2.4 07:28: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 07:28: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 07:28: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 07:28: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 07:28: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 07:28: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 07:28:39 INFO - Downloading blobuploader-1.2.4.tar.gz 07:28:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:28:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:28:39 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 07:28:39 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 07:28:39 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 07:28:39 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 07:28:39 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 07:28:39 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 07:28:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:28:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:28:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:40 INFO - Downloading docopt-0.6.1.tar.gz 07:28:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:28:40 INFO - Installing collected packages: blobuploader, requests, docopt 07:28:40 INFO - Running setup.py install for blobuploader 07:28:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:28:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:28:40 INFO - Running setup.py install for requests 07:28:41 INFO - Running setup.py install for docopt 07:28:41 INFO - Successfully installed blobuploader requests docopt 07:28:41 INFO - Cleaning up... 07:28:41 INFO - Return code: 0 07:28:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:28: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')]} 07:28:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28: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')]} 07:28:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2e655bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2799770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28289c0>, '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 0x28298c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2829d50>, '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': '337fe3f4b1febe37b85fccc40000019e-1464358775.984300-115721101', '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 07:28:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:28:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:28:41 INFO - Using env: {'DISPLAY': ':0', 07:28:41 INFO - 'HOME': '/home/cltbld', 07:28:41 INFO - 'LANG': 'en_US.UTF-8', 07:28:41 INFO - 'LANGUAGE': 'en_US:en', 07:28:41 INFO - 'LOGNAME': 'cltbld', 07:28:41 INFO - 'MAIL': '/var/mail/cltbld', 07:28:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:41 INFO - 'MOZ_NO_REMOTE': '1', 07:28:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:41 INFO - 'NO_EM_RESTART': '1', 07:28:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:41 INFO - 'PWD': '/builds/slave/test', 07:28:41 INFO - 'SHELL': '/bin/bash', 07:28:41 INFO - 'SHLVL': '1', 07:28:41 INFO - 'TERM': 'linux', 07:28:41 INFO - 'TMOUT': '86400', 07:28:41 INFO - 'USER': 'cltbld', 07:28:41 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1464358775.984300-115721101', 07:28:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:41 INFO - '_': '/tools/buildbot/bin/python'} 07:28:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:28:41 INFO - Running setup.py (path:/tmp/pip-Y6zGkc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:28:41 INFO - Running setup.py (path:/tmp/pip-ygRVvZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:28:41 INFO - Running setup.py (path:/tmp/pip-rNd1zE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:28:41 INFO - Running setup.py (path:/tmp/pip-cUuq_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:28:41 INFO - Running setup.py (path:/tmp/pip-3rYEpa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:28:41 INFO - Running setup.py (path:/tmp/pip-ISHSlq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:28:41 INFO - Running setup.py (path:/tmp/pip-UqqH38-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:28:41 INFO - Running setup.py (path:/tmp/pip-sldJsW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:28:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:28:42 INFO - Running setup.py (path:/tmp/pip-ClKMPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:28:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:28:42 INFO - Running setup.py (path:/tmp/pip-OepXfb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:28:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:28:42 INFO - Running setup.py (path:/tmp/pip-cOYp0_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:28:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:28:42 INFO - Running setup.py (path:/tmp/pip-hK0JxH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:28:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:28:42 INFO - Running setup.py (path:/tmp/pip-jekjUs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:28:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:28:42 INFO - Running setup.py (path:/tmp/pip-e7d0Az-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:28:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:28:42 INFO - Running setup.py (path:/tmp/pip-WADTyu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:28:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:28:42 INFO - Running setup.py (path:/tmp/pip-Zt0wra-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:28:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:28:42 INFO - Running setup.py (path:/tmp/pip-sWhShh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:28:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:28:42 INFO - Running setup.py install for manifestparser 07:28:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:28:42 INFO - Running setup.py install for mozcrash 07:28:42 INFO - Running setup.py install for mozdebug 07:28:42 INFO - Running setup.py install for mozdevice 07:28:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:28:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:28:43 INFO - Running setup.py install for mozfile 07:28:43 INFO - Running setup.py install for mozhttpd 07:28:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:28:43 INFO - Running setup.py install for mozinfo 07:28:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:28:43 INFO - Running setup.py install for mozInstall 07:28:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:28:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:28:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:28:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:28:43 INFO - Running setup.py install for mozleak 07:28:43 INFO - Running setup.py install for mozlog 07:28:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:28:43 INFO - Running setup.py install for moznetwork 07:28:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:28:43 INFO - Running setup.py install for mozprocess 07:28:43 INFO - Running setup.py install for mozprofile 07:28:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:28:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:28:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:28:44 INFO - Running setup.py install for mozrunner 07:28:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:28:44 INFO - Running setup.py install for mozscreenshot 07:28:44 INFO - Running setup.py install for moztest 07:28:44 INFO - Running setup.py install for mozversion 07:28:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:28:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:28:44 INFO - Cleaning up... 07:28:44 INFO - Return code: 0 07:28:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:28:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2e655bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2799770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28289c0>, '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 0x28298c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2829d50>, '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': '337fe3f4b1febe37b85fccc40000019e-1464358775.984300-115721101', '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 07:28:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:28:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:28:44 INFO - Using env: {'DISPLAY': ':0', 07:28:44 INFO - 'HOME': '/home/cltbld', 07:28:44 INFO - 'LANG': 'en_US.UTF-8', 07:28:44 INFO - 'LANGUAGE': 'en_US:en', 07:28:44 INFO - 'LOGNAME': 'cltbld', 07:28:44 INFO - 'MAIL': '/var/mail/cltbld', 07:28:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:44 INFO - 'MOZ_NO_REMOTE': '1', 07:28:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:44 INFO - 'NO_EM_RESTART': '1', 07:28:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:44 INFO - 'PWD': '/builds/slave/test', 07:28:44 INFO - 'SHELL': '/bin/bash', 07:28:44 INFO - 'SHLVL': '1', 07:28:44 INFO - 'TERM': 'linux', 07:28:44 INFO - 'TMOUT': '86400', 07:28:44 INFO - 'USER': 'cltbld', 07:28:44 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1464358775.984300-115721101', 07:28:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:44 INFO - '_': '/tools/buildbot/bin/python'} 07:28:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:28:44 INFO - Running setup.py (path:/tmp/pip-U0u7vh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:28:44 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:28:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:28:44 INFO - Running setup.py (path:/tmp/pip-bKl3mU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:28:44 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)) 07:28:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:28:44 INFO - Running setup.py (path:/tmp/pip-rnwqiu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:28:44 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)) 07:28:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:28:44 INFO - Running setup.py (path:/tmp/pip-arTJKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:28:44 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)) 07:28:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:28:44 INFO - Running setup.py (path:/tmp/pip-I_8Owz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:28:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:28:45 INFO - Running setup.py (path:/tmp/pip-vSQ1PD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:28:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:28:45 INFO - Running setup.py (path:/tmp/pip-JO7Dvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:28:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:28:45 INFO - Running setup.py (path:/tmp/pip-nj1xyN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:28:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:28:45 INFO - Running setup.py (path:/tmp/pip-Ncdezq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:28:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:28:45 INFO - Running setup.py (path:/tmp/pip-459NPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:28:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:28:45 INFO - Running setup.py (path:/tmp/pip-AR6ME9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:28:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:28:45 INFO - Running setup.py (path:/tmp/pip-B1GiGC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:28:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:28:45 INFO - Running setup.py (path:/tmp/pip-G5doMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:28:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:28:45 INFO - Running setup.py (path:/tmp/pip-UMSC_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:28:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:28:45 INFO - Running setup.py (path:/tmp/pip-qMwqAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:28:45 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)) 07:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:28:45 INFO - Running setup.py (path:/tmp/pip-q7qD1Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:28:45 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)) 07:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:28:45 INFO - Running setup.py (path:/tmp/pip-ayWB6j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:28:45 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)) 07:28:45 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)) 07:28:45 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)) 07:28:45 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)) 07:28:45 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)) 07:28:45 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)) 07:28:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:47 INFO - Downloading blessings-1.6.tar.gz 07:28:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:28:47 INFO - Installing collected packages: blessings 07:28:47 INFO - Running setup.py install for blessings 07:28:48 INFO - Successfully installed blessings 07:28:48 INFO - Cleaning up... 07:28:48 INFO - Return code: 0 07:28:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:28:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:28:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:28:48 INFO - Reading from file tmpfile_stdout 07:28:48 INFO - Current package versions: 07:28:48 INFO - argparse == 1.2.1 07:28:48 INFO - blessings == 1.6 07:28:48 INFO - blobuploader == 1.2.4 07:28:48 INFO - docopt == 0.6.1 07:28:48 INFO - manifestparser == 1.1 07:28:48 INFO - mozInstall == 1.12 07:28:48 INFO - mozcrash == 0.17 07:28:48 INFO - mozdebug == 0.1 07:28:48 INFO - mozdevice == 0.48 07:28:48 INFO - mozfile == 1.2 07:28:48 INFO - mozhttpd == 0.7 07:28:48 INFO - mozinfo == 0.9 07:28:48 INFO - mozleak == 0.1 07:28:48 INFO - mozlog == 3.2 07:28:48 INFO - moznetwork == 0.27 07:28:48 INFO - mozprocess == 0.22 07:28:48 INFO - mozprofile == 0.28 07:28:48 INFO - mozrunner == 6.11 07:28:48 INFO - mozscreenshot == 0.1 07:28:48 INFO - mozsystemmonitor == 0.3 07:28:48 INFO - moztest == 0.7 07:28:48 INFO - mozversion == 1.4 07:28:48 INFO - psutil == 3.1.1 07:28:48 INFO - requests == 1.2.3 07:28:48 INFO - wsgiref == 0.1.2 07:28:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:28:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2e655bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2799770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28289c0>, '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 0x28298c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2829d50>, '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': '337fe3f4b1febe37b85fccc40000019e-1464358775.984300-115721101', '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 07:28:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:28:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:28:48 INFO - Using env: {'DISPLAY': ':0', 07:28:48 INFO - 'HOME': '/home/cltbld', 07:28:48 INFO - 'LANG': 'en_US.UTF-8', 07:28:48 INFO - 'LANGUAGE': 'en_US:en', 07:28:48 INFO - 'LOGNAME': 'cltbld', 07:28:48 INFO - 'MAIL': '/var/mail/cltbld', 07:28:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:48 INFO - 'MOZ_NO_REMOTE': '1', 07:28:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:48 INFO - 'NO_EM_RESTART': '1', 07:28:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:48 INFO - 'PWD': '/builds/slave/test', 07:28:48 INFO - 'SHELL': '/bin/bash', 07:28:48 INFO - 'SHLVL': '1', 07:28:48 INFO - 'TERM': 'linux', 07:28:48 INFO - 'TMOUT': '86400', 07:28:48 INFO - 'USER': 'cltbld', 07:28:48 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1464358775.984300-115721101', 07:28:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:48 INFO - '_': '/tools/buildbot/bin/python'} 07:28:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:28:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:28:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:28:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:28:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:28:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:28:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:28:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:28:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:28:48 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:28:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:28:48 INFO - Cleaning up... 07:28:48 INFO - Return code: 0 07:28:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:28:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2e655bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2799770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28289c0>, '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 0x28298c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2829d50>, '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': '337fe3f4b1febe37b85fccc40000019e-1464358775.984300-115721101', '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 07:28:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:28:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:28:48 INFO - Using env: {'DISPLAY': ':0', 07:28:48 INFO - 'HOME': '/home/cltbld', 07:28:48 INFO - 'LANG': 'en_US.UTF-8', 07:28:48 INFO - 'LANGUAGE': 'en_US:en', 07:28:48 INFO - 'LOGNAME': 'cltbld', 07:28:48 INFO - 'MAIL': '/var/mail/cltbld', 07:28:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:48 INFO - 'MOZ_NO_REMOTE': '1', 07:28:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:48 INFO - 'NO_EM_RESTART': '1', 07:28:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:48 INFO - 'PWD': '/builds/slave/test', 07:28:48 INFO - 'SHELL': '/bin/bash', 07:28:48 INFO - 'SHLVL': '1', 07:28:48 INFO - 'TERM': 'linux', 07:28:48 INFO - 'TMOUT': '86400', 07:28:48 INFO - 'USER': 'cltbld', 07:28:48 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1464358775.984300-115721101', 07:28:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:48 INFO - '_': '/tools/buildbot/bin/python'} 07:28:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:48 INFO - Downloading/unpacking jsonschema 07:28: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 07:28: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 07:28: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 07:28: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 07:28: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 07:28: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 07:28:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:28:50 INFO - Downloading/unpacking functools32 (from jsonschema) 07:28:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:50 INFO - Downloading functools32-3.2.3-2.tar.gz 07:28:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:28:50 INFO - warning: no files found matching '*.txt' 07:28:50 INFO - no previously-included directories found matching 'build' 07:28:50 INFO - no previously-included directories found matching 'dist' 07:28:50 INFO - no previously-included directories found matching '.git*' 07:28:50 INFO - Installing collected packages: jsonschema, functools32 07:28:50 INFO - Running setup.py install for functools32 07:28:51 INFO - warning: no files found matching '*.txt' 07:28:51 INFO - no previously-included directories found matching 'build' 07:28:51 INFO - no previously-included directories found matching 'dist' 07:28:51 INFO - no previously-included directories found matching '.git*' 07:28:51 INFO - Successfully installed jsonschema functools32 07:28:51 INFO - Cleaning up... 07:28:51 INFO - Return code: 0 07:28:51 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:28:51 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')]} 07:28:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:51 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')]} 07:28:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:51 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 0x7f2e655bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2799770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28289c0>, '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 0x28298c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2829d50>, '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': '337fe3f4b1febe37b85fccc40000019e-1464358775.984300-115721101', '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 07:28:51 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 07:28:51 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 07:28:51 INFO - Using env: {'DISPLAY': ':0', 07:28:51 INFO - 'HOME': '/home/cltbld', 07:28:51 INFO - 'LANG': 'en_US.UTF-8', 07:28:51 INFO - 'LANGUAGE': 'en_US:en', 07:28:51 INFO - 'LOGNAME': 'cltbld', 07:28:51 INFO - 'MAIL': '/var/mail/cltbld', 07:28:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:51 INFO - 'MOZ_NO_REMOTE': '1', 07:28:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:51 INFO - 'NO_EM_RESTART': '1', 07:28:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:51 INFO - 'PWD': '/builds/slave/test', 07:28:51 INFO - 'SHELL': '/bin/bash', 07:28:51 INFO - 'SHLVL': '1', 07:28:51 INFO - 'TERM': 'linux', 07:28:51 INFO - 'TMOUT': '86400', 07:28:51 INFO - 'USER': 'cltbld', 07:28:51 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1464358775.984300-115721101', 07:28:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:51 INFO - '_': '/tools/buildbot/bin/python'} 07:28:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:51 INFO - Downloading/unpacking flake8 07:28:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:53 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:28:53 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:28:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:53 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:28:53 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:28:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:53 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:28:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:28:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:28:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:28:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:28:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:28:53 INFO - no previously-included directories found matching 'docs/_build' 07:28:53 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:28:54 INFO - Running setup.py install for pep8 07:28:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:28:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:28:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:28:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:28:54 INFO - no previously-included directories found matching 'docs/_build' 07:28:54 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:28:54 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:28:54 INFO - Cleaning up... 07:28:54 INFO - Return code: 0 07:28:54 INFO - Running post-action listener: _resource_record_post_action 07:28:54 INFO - Running post-action listener: _start_resource_monitoring 07:28:54 INFO - Starting resource monitoring. 07:28:54 INFO - ##### 07:28:54 INFO - ##### Finished create-virtualenv step (success) 07:28:54 INFO - ##### 07:28:54 INFO - ##### 07:28:54 INFO - ##### Running install step. 07:28:54 INFO - ##### 07:28:54 INFO - Running pre-action listener: _resource_record_pre_action 07:28:54 INFO - Running main action method: install 07:28:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:28:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:28:54 INFO - Reading from file tmpfile_stdout 07:28:54 INFO - Detecting whether we're running mozinstall >=1.0... 07:28:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:28:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:28:54 INFO - Reading from file tmpfile_stdout 07:28:54 INFO - Output received: 07:28:54 INFO - Usage: mozinstall [options] installer 07:28:54 INFO - Options: 07:28:54 INFO - -h, --help show this help message and exit 07:28:54 INFO - -d DEST, --destination=DEST 07:28:54 INFO - Directory to install application into. [default: 07:28:54 INFO - "/builds/slave/test"] 07:28:54 INFO - --app=APP Application being installed. [default: firefox] 07:28:54 INFO - mkdir: /builds/slave/test/build/application 07:28:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:28:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:29:10 INFO - Reading from file tmpfile_stdout 07:29:10 INFO - Output received: 07:29:10 INFO - /builds/slave/test/build/application/firefox/firefox 07:29:10 INFO - Running post-action listener: _resource_record_post_action 07:29:10 INFO - ##### 07:29:10 INFO - ##### Finished install step (success) 07:29:10 INFO - ##### 07:29:10 INFO - ##### 07:29:10 INFO - ##### Running run-tests step. 07:29:10 INFO - ##### 07:29:10 INFO - Running pre-action listener: _resource_record_pre_action 07:29:10 INFO - Running main action method: run_tests 07:29:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:29:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:29:10 INFO - Python 2.7.3 07:29:10 INFO - Return code: 0 07:29:10 INFO - grabbing minidump binary from tooltool 07:29:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:29:10 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 0x28289c0>, '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 0x28298c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2829d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:29:10 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 07:29:10 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 07:29:10 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 07:29:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:29:10 INFO - Return code: 0 07:29:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:29:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:29:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:29:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:29:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:29:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:29:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:29:11 INFO - Return code: 0 07:29:11 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/LdwHZ-v-T3ShHldFVDqqgg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 07:29:11 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/LdwHZ-v-T3ShHldFVDqqgg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --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 07:29:11 INFO - Using env: {'DISPLAY': ':0', 07:29:11 INFO - 'HOME': '/home/cltbld', 07:29:11 INFO - 'LANG': 'en_US.UTF-8', 07:29:11 INFO - 'LANGUAGE': 'en_US:en', 07:29:11 INFO - 'LOGNAME': 'cltbld', 07:29:11 INFO - 'MAIL': '/var/mail/cltbld', 07:29:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:29:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:29:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:11 INFO - 'MOZ_NO_REMOTE': '1', 07:29:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:29:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:11 INFO - 'NO_EM_RESTART': '1', 07:29:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:11 INFO - 'PWD': '/builds/slave/test', 07:29:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:29:11 INFO - 'SHELL': '/bin/bash', 07:29:11 INFO - 'SHLVL': '1', 07:29:11 INFO - 'TERM': 'linux', 07:29:11 INFO - 'TMOUT': '86400', 07:29:11 INFO - 'USER': 'cltbld', 07:29:11 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1464358775.984300-115721101', 07:29:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:11 INFO - '_': '/tools/buildbot/bin/python'} 07:29:11 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/LdwHZ-v-T3ShHldFVDqqgg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 07:29:11 INFO - mozversion application_buildid: 20160527062742 07:29:11 INFO - mozversion application_changeset: dd3e899cfa818fcbb47b3d7432e0977e835702ee 07:29:11 INFO - mozversion application_display_name: Nightly 07:29:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:29:11 INFO - mozversion application_name: Firefox 07:29:11 INFO - mozversion application_remotingname: firefox 07:29:11 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:29:11 INFO - mozversion application_vendor: Mozilla 07:29:11 INFO - mozversion application_version: 49.0a1 07:29:11 INFO - mozversion platform_buildid: 20160527062742 07:29:11 INFO - mozversion platform_changeset: dd3e899cfa818fcbb47b3d7432e0977e835702ee 07:29:11 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:29:11 INFO - mozversion platform_version: 49.0a1 07:29:11 INFO - using testdate: 1464359351 07:29:11 INFO - actual date: 1464359351 07:29:11 INFO - starting webserver on 'localhost:48689' 07:29:11 INFO - SUITE-START | Running 2 tests 07:29:11 INFO - TEST-START | dromaeo_css 07:29:11 INFO - operating with platform_type : linux_ 07:29:11 INFO - Initialising browser for dromaeo_css test... 07:29:11 INFO - TEST-INFO | started process 18340 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMfHruq/profile http://localhost:48689/getInfo.html) 07:29:15 INFO - PROCESS | 18340 | __metrics Screen width/height:1600/1200 07:29:15 INFO - PROCESS | 18340 | colorDepth:24 07:29:15 INFO - PROCESS | 18340 | Browser inner width/height: 1024/697 07:29:15 INFO - PROCESS | 18340 | __metrics 07:29:16 ERROR - PROCESS | 18340 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:29:17 INFO - TEST-INFO | 18340: exit 0 07:29:17 INFO - Browser initialized. 07:29:17 INFO - Running cycle 1/1 for dromaeo_css test... 07:29:17 INFO - TEST-INFO | started process 18421 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMfHruq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:29:29 INFO - PROCESS | 18421 | RSS: Main: 157036544 07:29:29 INFO - PROCESS | 18421 | 07:30:21 INFO - PROCESS | 18421 | 1464359421263 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] 07:32:32 INFO - PROCESS | 18421 | Cycle 1(1): loaded http://localhost:48689/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48689/tests/dromaeo/cssquery-ext.html) 07:32:34 INFO - PROCESS | 18421 | RSS: Main: 278548480 07:32:34 INFO - PROCESS | 18421 | 07:35:37 INFO - PROCESS | 18421 | Cycle 1(1): loaded http://localhost:48689/tests/dromaeo/cssquery-ext.html (next: http://localhost:48689/tests/dromaeo/cssquery-jquery.html) 07:35:37 INFO - PROCESS | 18421 | RSS: Main: 242446336 07:35:37 INFO - PROCESS | 18421 | 07:38:39 INFO - PROCESS | 18421 | Cycle 1(1): loaded http://localhost:48689/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48689/tests/dromaeo/cssquery-mootools.html) 07:38:40 INFO - PROCESS | 18421 | RSS: Main: 246235136 07:38:40 INFO - PROCESS | 18421 | 07:41:42 INFO - PROCESS | 18421 | Cycle 1(1): loaded http://localhost:48689/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48689/tests/dromaeo/cssquery-prototype.html) 07:41:43 INFO - PROCESS | 18421 | RSS: Main: 235503616 07:41:43 INFO - PROCESS | 18421 | 07:44:46 INFO - PROCESS | 18421 | Cycle 1(1): loaded http://localhost:48689/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48689/tests/dromaeo/cssquery-yui.html) 07:44:46 INFO - PROCESS | 18421 | RSS: Main: 214843392 07:44:46 INFO - PROCESS | 18421 | 07:47:49 INFO - PROCESS | 18421 | Cycle 1(1): loaded http://localhost:48689/tests/dromaeo/cssquery-yui.html (next: http://localhost:48689/tests/dromaeo/cssquery-dojo.html) 07:47:49 INFO - PROCESS | 18421 | RSS: Main: 268025856 07:47:49 INFO - PROCESS | 18421 | 07:47:49 INFO - PROCESS | 18421 | __start_tp_report 07:47:49 INFO - PROCESS | 18421 | _x_x_mozilla_page_load 07:47:49 INFO - PROCESS | 18421 | _x_x_mozilla_page_load_details 07:47:49 INFO - PROCESS | 18421 | |i|pagename|runs| 07:47:49 INFO - PROCESS | 18421 | |0;dojo.html;2695.272276485349;2700.1494529223305;2717.266338088716;2746.395792925557;2764.6129541864143;4716.646251531131;4786.856394308172;4808.567228949394;4857.902841943163;4898.877528061796;4789.640776941726;4797.520247975201;4831.033793241349;4868.975655121728;4880.09718202132;4352.064306174172;4402.7358358498595;4443.022535042302;4472.038511719979;4616.746078965655;4544.840930567414;4556.407667003302;4572.291294849287;4601.3558101865765;4626.97686511567;4343.044530203382;4382.605565499089;4387.319965405367;4420.11597680462;4420.51374348823;4400.339949007643;4404.383386325917;4417.514073451917;4429.180601588684;4448.33275008748;4441.200583894898;4444.133393988173;4452.1986042512335;4466.55334466554;4485.506594274627;4628.074385122955;4713.34013238147;4740.952590474086;4765.904681906377;4846.466888642247;5207.661502002357;5209.505097015777;5238.292830467914;5252.921206181911;5271.209318602202;5208.5572726318305;5276.103062479349;5285.07511185541;5288.127458969304;5297.523222909918;4710.81156753726;4816.446108697474;4859.927101093486;4872.561469467765;4911.778969946361;5395.352557693023;5398.460153984649;5399.190121481809;5412.83761487156;5417.18742188667;5184.196449550326;5185.0407674579565;5193.246979187997;5194.168932970707;5200.037992971313;5058.291839142523;5103.668261563061;5111.952049829776;5114.71869047206;5167.560757335668;5090.261912022736;5127.717975511308;5129.12804823181;5131.897362052813;5180.404253510819;4972.129877271463;5108.131617625013;5120.61595380348;5125.897482050413;5128.153854613947;4275.358696195533;4326.567343265649;4369.104333611602;4369.978150109293;4405.581469760367;3816.44661524083;3831.04223944014;3833.1375440526217;3868.7485313454536;3876.5541962674088;4450.287953927356;4463.933041004388;4465.24090904547;4468.151051300242;4514.796834142471;5121;5169.7932082717025;5197.8440646780655;5205.9739701302005;5233.738313084331;4437.711548749321;4459.152760975404;4469.709468884512;4473.217186992263;4505;4510.977445112819;4646.326282689059;4658.208104622222;4660.720356778605;4701.623870090384;4854.684445510959;4896.069746748107;4899.044686286283;4923.803047878188;4927.852164435073;5196.506331898615;5216.686998780086;5220.269162317202;5255.973720131375;5267.499587539178;4774.1883879739835;4834.009028149291;4875.6099512038245;4925.335079764329;4927.063857866994;5061.164907790173;5107.923381149211;5122.769475373691;5126.231065340229;5177.611679124156;5204.2974198484235;5204.687718736888;5208.140656791587;5209.114450543492;5260.658057226268;4885.87785305356;4973.254011898244;4987.80048798044;5042.697438153723;5043.924341134959;4987.551120399182;5012.874678133076;5019.472955339636;5019.824306149268;5042.823501177441;4971.875703107451;4973.577245934136;4989.750512474289;5011.223260394645;5031.270465782368;4937.790241390739;4958.057968985881;4980.228064649985;5005.274235235943;5114.411842638145;4894.95105048945;4980.22806464984;4995.100881841304;5005.199168133081;5005.249212618136 07:47:49 INFO - PROCESS | 18421 | |1;ext.html;546.3252882689877;596.4035964035965;598.5929567893836;603.0321334258515;605.4883623338279;26638.86680566597;39290.21419571611;39640.20719585606;39823.2035359293;40028.59971400285;37785.244295114084;38368.808155959254;42150.156996860045;42162.156756864846;42233.155336893244;7420.628968551578;7698.2686644768655;7855.882161767549;7856;7859.214078592124;10099.899001010006;10342.379457232553;10349.172066234722;10355.430451325174;10691.251612387136;9987.950060249688;10108.444035578077;10359.171266298677;10364.378137311785;10368.429736364496;10224.284300098996;10313.38119712816;10314.278000539965;10314.535845886952;10322.48387580618;10155.492225388702;10265.384076955406;10273.794524109477;10279.537420816081;10280.177585793193;39357;39500.407493887615;39720.60279397198;39759.20481590381;39762;2954.202365361362;3003.9249018774703;3046.817190968527;3052.9694703052905;3107.6115485564305;30370.240743981358;30713.69286307131;30834.53748193779;31001.224969375722;31954.201144971328;3204.807711537292;3224.0650211438656;3229.6124465064345;3240.659730728287;3250.6586808385014;256809;262682.6865865678;262767;263227;263979;57588.71205644029;58522.4147758517;58580;58633.4136658628;58634.70682646645;62170.378296217365;62296.68851655803;62320;62389.68805155945;62457;13435;13686.65783355424;13716.108452950526;13729.176249425067;13743.312834358243;9162.450252984841;9998.200143988464;10007.549660265306;10202.438865862301;10242.948785256174;19103.617927641648;19131.23475060982;19169.233230670896;19298.71051934222;19390.612187756167;7098.467614928901;7129.508409701958;7199.028131202325;7257.221980614678;7323.7436689715605;807.3339494916718;850.7575341027901;876.9605367758467;931.1526510875071;951;27308.590371144448;27608.447831043668;28407;28440.146795596163;28477;919.3242966419676;934.8784657994553;947.4646824544111;952.0574631115146;955.6082006377352;14712.411503539952;14759.335829887681;15035.774463383059;15095.32071056805;15201.391944322324;368351;372867;373580;373761;373770;49921.75039124781;50479.49520504822;50523;50568.74715626472;50572;1086.28305318491;1175.6002958993984;1181.0846593889632;1203.771283456158;1220.7619514195003;28479.28801779972;29640;29795.10614681563;29873;30238.848805756712;41837.58162418337;42461;42463.36304955366;42486.78756606197;42534.57465425306;297284;303066;303132;304085;304204;31697.8415107923;32117.67882321147;33366.16584585405;33372.66627333793;34004.14989625279;38264.426033608965;41597.96005099897;42370;42738;43323.566764331954;34201.47469210677;36070.81964590265;36182;36373.45439818458;36599.08502287357;35734.8213258932;36380;36402.4539631911;36445.45331820078;36478.4528232082;36208.18959051984;36219.818900905324;38796.6120338793;39525.40711889382;39671.801640992766;31647;33365.48119350207;33675.66324336725;33767;34206.48690269598;25446.363840904127;25644.358891027874;25683.10109146171;25723.228303150936;26085.478290434465 07:47:49 INFO - PROCESS | 18421 | |2;jquery.html;384.834521155903;384.91147036181695;390.20593093055635;400.19161294185744;403.0910297279634;15646.921765391171;16812.32750689971;17683.46949591511;17782.288708451662;17795.110244487772;16257.51227463175;16332.510024699248;16730.916345418285;17032.744508832377;17052.23264953077;5121.692698438096;5263.921041184366;5267.578593712513;5298.496642818926;5315.309009828717;3694.4273637586216;3936.1143742657814;5738.254026976487;6032.969835150818;6037.0340745480735;6026.728797204137;6075.696215189245;6099.756009759604;6118.3269840317525;6119.816405507842;5922.851928701773;6042.57701960863;6070.180525629028;6073.848153796168;6074.908876366858;3373.207296285371;5055.721935293557;5418.187271909245;5427.348718153808;5511.063119269694;20131;20224.393268201977;20549;20620;20670.793292067036;1715.476779582227;1805.3681211575974;1865.1979648751033;1885.6417280716757;1939.0498655658766;12642.936785316106;13006.284654344006;13184.274864882427;13404.732254047323;13767.655808604764;1601.375463569209;1632.0370981121077;1689.898606083639;1695.9406420775213;1708.197147340748;66278.66860665714;69191.30808691899;69210;70376;72911.63544182297;9911.553980070914;10215.540300686338;10311.587536498457;10427.5828966842;10531.473426328654;14141.29293535319;14204.502842400467;14274.643133921734;14316.928415358065;14325.713485730435;6945.583265004116;7073.71705131789;7084.901840214775;7186.7125314986815;7205.675744591506;6615.239247486505;6636.767713130113;6711.798646040626;6724.865502690017;6745.0556922030955;4370.650347972155;4415.315626077963;4425.22558552252;4489.124620698998;4550.180967425895;1606.7027599893822;1739.3912130754136;1739.4864420911913;1748.0560497331553;1835.8853865912697;759.1762937213075;828.2131974624131;915.1306259053925;937.5434968483362;946.7301818981557;15860.841391586167;16399.590010249838;16539.173041347884;16702.49892503227;17241;800.1798156889118;805.8106345008919;820.5609998650693;836.9288610468057;842.3345557010016;9202.349791196255;9710.611575537041;9725.854112188323;9765.121139097373;9798.069183427562;362172;362533;370130;370710;374762;47537.286940695914;47963.280550791766;71558.2844171562;73686.26313736901;74414;924.3621900888365;925.5048549026238;926.0554234680588;936.7470782888719;945.3666043750703;15055.849441505445;15086.54740357791;15098.245087745789;15300.693986119993;15561.688766224386;32936;33718.49422258717;33742.3251534963;34666.13334666654;35359.64640353563;43783.34324985064;47156.52843471659;47765.761171193924;47878.760606196745;48087.27869081897;7165.605891676008;7168.17565979919;7186.856262874818;7224.602646854263;7279.344858962719;9002.954985225031;10243.436610986468;10427.374357538572;10447.68656940293;10792.784144317227;8747.212750852454;8904.910950890668;8956.507392093497;9049.77375565616;9428.434293942386;8728.67550794028;9119.908800912172;9177.632894684139;9275.907240927505;9390.530473476163;9058.592363343534;9313.208377288007;9372.812543749224;9553.092456216647;9643.896909378685;7387.667554959932;7628.580428076509;7634.122075961335;7647.273509016634;7760.14638389788;8841.336899732674;9037.231835294073;9123.31575131881;9230.400023998418;9332.813343733224 07:47:49 INFO - PROCESS | 18421 | |3;mootools.html;1286.5689993852059;1420.7584710599197;1480.222882986432;1595.7765912772206;1794.147779804593;6489.156409666743;7654.196309387511;7910.248526389998;7916.683332666694;8174.100848906615;7865.528068315905;8028.678852845879;8029.638666260033;8050.516968981865;8051.597420128999;2251.5722012817596;2284.3603790938564;2285.3029825903095;2285.4971906180613;2287.9084836606517;2204.360735386736;2248.4041728941843;2274.0789980058103;2280.247518318951;2281.281396360141;2201.2924103352884;2208.0615738311235;2221.2891874600136;2222.3777342344088;2222.48882756966;2115.4499830044147;2165.7509386420606;2170.446536133292;2172.934811955644;2176.4885251965857;2176.684380764796;2185.868847869117;2190.1896298369547;2190.7371115466244;2194.0565556810566;7690.615469226572;7969.521828690297;7992.560409177493;8057.758267251933;8074.878876816852;4697.060587882403;4912.7297998610065;4915.705057696549;4920.991196804683;4922.581580565657;2994.2065352681557;3085.305806193611;3165.5409965554863;3183.840807959593;3186.3149422874194;957.5978089202551;972.5963725054094;982.8132654795565;999.3959694690063;1025.651278565284;10589.417582032986;10807.351558906412;10808.081313088396;10823.24237303389;10834.458277086193;4431.556844315543;4560.293154561048;4564.1556312082375;4579.152856721451;4580.679352445297;9316.673916412892;9343.065693430603;9372.812543749224;9380.530973451436;9383.24934005278;4933.432655244621;4936.234883593049;4936.531029552187;4941.678790878582;4942.110420124341;3642.927141457156;3844.75009124406;4370.825166993348;4408.933865992013;4445.044315472189;3751.6248375162268;3788.0719223789797;3852.6339997700734;3885.436611691289;3893.124047089382;1242.2794779028143;1264.4562837979572;1272.662744372742;1275.1074248026234;1287.9613611591667;672.1060988884772;697.2469732688684;701.2916953876519;777.0364747712796;788.6411682684364;5146.922796158061;5239.973800130975;5297.073012222845;5401.432849550741;5478.863028424242;839.9958000210082;848.245061894914;856.6787454704486;899.1772528136681;904.6652738486671;3633.8364773585254;3749.3251214781058;3803.82882770276;3820.0917736779547;3852.768833869977;9568.521573921415;9926.454045027449;9933.403995760278;9939.403635781731;9947.602095916227;9612.269791437608;9798.167155791694;9811.313208075366;9814.06766357195;9829.950850245847;7291.380232680175;7395.186529481753;7415.2214017527385;7434;7457.142428620669;5167.922481162861;5285.365756109291;5329.866753331198;5405.756740946588;5408.9459105410015;8744.431611945203;8804.339674524565;8851.114888511098;9105.135012173832;9119.361644684808;9107.681231156877;9169.954150229207;9209.815803683754;9215.907840921505;9220.631174753204;6626.53614246998;6696.531242812956;6729.663516824237;6761.459083273228;6765.661716914036;7498.775036748906;7533.886991695019;7566.31903128721;7585.848283034198;7603.315701586663;6010.759569617167;6298.874022519432;6729.394354508117;6856.108705868205;6981.650917454209;6793.286704895915;6803.489738269748;6860.3139686031;6916.135483064617;6923.203831559234;6411.96794016027;6452.774152904626;6564.113844631104;6567.9014814776865;6576.441002514648;4645.3496510487885;4656.509916826583;4691.671582989158;4703.601163406619;4733.360996265598;4695.647826413101;4728.787204575871;4731.172044892061;4783.545563171493;4812.25410061441 07:47:49 INFO - PROCESS | 18421 | |4;prototype.html;309.19454820193397;309.36116918563164;311.09161249152476;313.5672771575229;317.25603459886565;4768.284757286405;4803.9759801201035;4804.591609713169;4831.371921650185;4865;4760.476347601761;4761.976190119053;4815.927761083578;4818;4825.155597770394;3609.6029436761937;3726.2672857121433;3738.3831667774784;3738.9439158412647;3842.8078596070222;3775.848366248293;3817.790021548814;3821.789801560913;3841.5774264830848;3848.730588858781;3771.283456143338;3792.601776813436;3805.3340665383585;3807.2385522895393;3811.9047023824487;3612.259486805199;3715.609860964587;3785.886423407302;3794.848206071754;3825.9043523911846;3386.271951530433;3395.439752440844;3412.129906873756;3415.3852306584804;3434.5363375944175;4634.467036290802;4641.350210970467;4653.0693861227555;4653.534646535353;4653.557911998355;4237.940514871282;4354.194474022316;4354.978225108885;4359.607635312837;4403.185410699031;4986.152354099811;4990.700557966534;5018.447970723218;5027.49725027498;5034.1122079220295;3716.7212459065677;3724.888253352404;3728.8694895678523;3729.1236559408517;3737.5328083989502;5071.366079240095;5190.71451070191;5243.475652434726;5299.12564426873;5317.255584218213;3696.445533170046;3705.8517659293325;3708.962910370916;3725.4970578971493;3745.157339598623;3774.905627359338;3781.697464202857;3784.899380843603;3788.9431658525145;3794.203217324393;4268.957310426918;4281.400603915455;4294.506131794821;4295.269804133305;4297.527272000078;4874.780634871439;5059.392872855281;5080.11371300955;5082.161443361878;5090.669106508065;1332.640706479405;1335.1588499245413;1337.9397927093305;1344.3547097393307;1359.3611002828852;860.3633311349681;862.5773371048141;882.2765332427476;919.4758987377264;945.0832692288469;4381.751200907726;4391.824327026883;4402.405675233803;4407.184670835905;4409.581089796464;5095.770690318945;5096.898062038738;5099.36257967754;5108.335916330853;5120.746871376582;4226.535081141134;4365.628921541705;4371.562843715603;4404.779761011937;4430.313301438282;2737.2472570043396;2751.5047291487726;2791.6231308773463;2795.566687163493;2809.0870467098275;4908.04293162837;4918.508149185124;4929.630277729185;4939.777710003059;4958.958618690043;5040.546350828443;5325.573954083664;5337.51962323385;5342.492463215988;5361.410244873061;4928.581070608967;4942.901141977212;4946.925796113133;4948.080632426885;4963.404391472975;5204.271402003798;5227.3465816772905;5234.476552344735;5245.6852588844795;5248.186531087687;4855.6115510758345;5142.354446577059;5142.820001299937;5198.218952860202;5200.297959775382;4920.031987205003;4930.383702037246;4936.605071594336;4962.727050012284;4963;3712.554493460802;3714.7213958953726;3730.8880733578035;3754.0103745015185;3755.7934313613014;5127.92308115386;5204.609654275869;5212.322398088224;5284.656497327662;5304.204369344629;5011.699298042129;5045.394552653705;5066.898662026812;5068.873278167928;5088;5048.318477005557;5050.84847454577;5056.82301119459;5063.670861393997;5095.87260318495;4895.632827537877;4986.850394488171;4991.775370108281;5000.674821172465;5032.949670503248;4861;4958.677685950402;5081.237814327733;5085.7457127144235;5088.643794934319;4945.357103576512;4958.8760280993265;4967.82612608557;4975.875603109806;5004.299398084344 07:47:49 INFO - PROCESS | 18421 | |5;yui.html;568.1903287814863;635.0125554762344;651.4625434016937;712.9964350178252;765.5291995422809;10064.748381290472;11704.590339338125;12067.818982715255;12563.05777066719;13572.185668859875;13013.08908376414;13556.932215338935;13557.728845423086;13597.660058498543;13602.863971360284;620.6214209332304;775.8758598624221;799.6681377228458;804.1636697834275;807.563915485637;803.0363563723525;806.5402720449346;807.4912804932884;807.6204184033495;807.9474834135792;836.2599099796694;839.7396806989822;839.8068444257824;840.970566030189;841.7180244618061;833.3000279765026;833.5748768128237;833.9416240863142;834.0783434305097;834.407570624851;615.827568280882;617.4288782875867;617.8609812792131;618.5175563060819;618.6751955223499;11909.702257443547;11915.106367022508;11932.46303916317;11941.104417168746;11942.104342174373;12464.501419943192;12475.313857737821;12614.621561353175;12971.286579238138;13123.86876131236;9752.658656946973;9767.706968790948;10069;10385.169186465064;10404.895951040544;3214.8231847248394;3218.3241519280978;3241.983790081058;3280.1963518938014;3341;46798;46942;46954.530454695356;47163.76418117888;48122;9199.4940278284;9371.109744574254;9380.671676491427;9419.670311539063;9513.571889265;17116.315347386215;17117.486475405756;17197.312107515558;17199.484015479557;17253.654926901643;6584.176977877765;6646.136002319764;6732;6751.324867513307;6883.724651014004;3534.134137136418;3547.733919955962;3575.6781889630056;3611.33190359779;3684.244729830378;2945.4403663303906;3008.187789296878;3012.894548690829;3024.9848750756546;3032.77254205931;502.71345333159746;522.1932114882516;525.088970635954;525.1413938211052;538.4346436241931;502.47993326906476;565.2566874559941;602.7860109661007;603.7072020070262;613.6134235431649;7331.413486921034;7408.7036518539735;7505.774826755206;7682.96158519215;7735.574543400055;560.1569637695243;576.247996364748;583.3466517500342;588.3584798412381;607.5595193484688;3620.2035552179004;3659.9451008234896;3757.7369584128846;3768.453574231721;3773.6226377362045;52612.210816837774;53370.733146334795;54200.18699719507;55508.72245638746;55836.16245756317;49016.75491622519;49674.254886176735;50454.243186352236;50521.242181367306;50778.74610626923;44758.77620611876;44817;45102.32346514805;45104;45302.32046519239;6679.532432729662;6729.158855143107;6797.388235058868;6934.826629334105;6997.545159564612;30579.54130688086;30594;30929.69070309268;31513.8424307877;31862.362752745277;40588.39117413182;41100.38349424701;41212.58787412087;41243.38134927918;41400.58599414088;9720.513974301399;9990.400575965465;10054.899451005396;10200;10204.591816327264;11318.434078296217;11335.546578136782;11651.067914566984;12005.819912701141;12033.819492707442;9833.557489912828;9918.156956658477;10077.546510407195;10437.373757574569;10892.945535272273;10388.740281493023;10430.843537346795;10531.526081326205;10852.403117828595;11223.438828058728;10406.271560990961;10574.154067674413;10611.575536978435;10613.257072004886;10895;9276.953615231881;9328.95335523318;9386.249100071842;9605.37565058269;9716.611335546499;9019.954900225457;9391.20174785151;9394.765130871783;9437.828083171864;9577 07:47:49 INFO - PROCESS | 18421 | __end_tp_report 07:47:49 INFO - PROCESS | 18421 | __start_cc_report 07:47:49 INFO - PROCESS | 18421 | _x_x_mozilla_cycle_collect,1177 07:47:49 INFO - PROCESS | 18421 | __end_cc_report 07:47:49 INFO - PROCESS | 18421 | __startTimestamp1464360469604__endTimestamp 07:47:49 INFO - PROCESS | 18421 | 07:47:49 INFO - PROCESS | 18421 | ------- Summary: start ------- 07:47:49 INFO - PROCESS | 18421 | Number of tests: 6 07:47:49 INFO - PROCESS | 18421 | 07:47:49 INFO - PROCESS | 18421 | [#0] dojo.html Cycles:165 Average:4786.52 Median:4911.78 stddev:504.78 (10.3%) stddev-sans-first:478.93 07:47:49 INFO - PROCESS | 18421 | Values: 2695.3 2700.1 2717.3 2746.4 2764.6 4716.6 4786.9 4808.6 4857.9 4898.9 4789.6 4797.5 4831.0 4869.0 4880.1 4352.1 4402.7 4443.0 4472.0 4616.7 4544.8 4556.4 4572.3 4601.4 4627.0 4343.0 4382.6 4387.3 4420.1 4420.5 4400.3 4404.4 4417.5 4429.2 4448.3 4441.2 4444.1 4452.2 4466.6 4485.5 4628.1 4713.3 4741.0 4765.9 4846.5 5207.7 5209.5 5238.3 5252.9 5271.2 5208.6 5276.1 5285.1 5288.1 5297.5 4710.8 4816.4 4859.9 4872.6 4911.8 5395.4 5398.5 5399.2 5412.8 5417.2 5184.2 5185.0 5193.2 5194.2 5200.0 5058.3 5103.7 5112.0 5114.7 5167.6 5090.3 5127.7 5129.1 5131.9 5180.4 4972.1 5108.1 5120.6 5125.9 5128.2 4275.4 4326.6 4369.1 4370.0 4405.6 3816.4 3831.0 3833.1 3868.7 3876.6 4450.3 4463.9 4465.2 4468.2 4514.8 5121.0 5169.8 5197.8 5206.0 5233.7 4437.7 4459.2 4469.7 4473.2 4505.0 4511.0 4646.3 4658.2 4660.7 4701.6 4854.7 4896.1 4899.0 4923.8 4927.9 5196.5 5216.7 5220.3 5256.0 5267.5 4774.2 4834.0 4875.6 4925.3 4927.1 5061.2 5107.9 5122.8 5126.2 5177.6 5204.3 5204.7 5208.1 5209.1 5260.7 4885.9 4973.3 4987.8 5042.7 5043.9 4987.6 5012.9 5019.5 5019.8 5042.8 4971.9 4973.6 4989.8 5011.2 5031.3 4937.8 4958.1 4980.2 5005.3 5114.4 4895.0 4980.2 4995.1 5005.2 5005.2 07:47:49 INFO - PROCESS | 18421 | 07:47:49 INFO - PROCESS | 18421 | [#1] ext.html Cycles:180 Average:47879.46 Median:33885.57 stddev:82758.11 (244.2%) stddev-sans-first:82913.96 07:47:49 INFO - PROCESS | 18421 | Values: 546.3 596.4 598.6 603.0 605.5 26638.9 39290.2 39640.2 39823.2 40028.6 37785.2 38368.8 42150.2 42162.2 42233.2 7420.6 7698.3 7855.9 7856.0 7859.2 10099.9 10342.4 10349.2 10355.4 10691.3 9988.0 10108.4 10359.2 10364.4 10368.4 10224.3 10313.4 10314.3 10314.5 10322.5 10155.5 10265.4 10273.8 10279.5 10280.2 39357.0 39500.4 39720.6 39759.2 39762.0 2954.2 3003.9 3046.8 3053.0 3107.6 30370.2 30713.7 30834.5 31001.2 31954.2 3204.8 3224.1 3229.6 3240.7 3250.7 256809.0 262682.7 262767.0 263227.0 263979.0 57588.7 58522.4 58580.0 58633.4 58634.7 62170.4 62296.7 62320.0 62389.7 62457.0 13435.0 13686.7 13716.1 13729.2 13743.3 9162.5 9998.2 10007.5 10202.4 10242.9 19103.6 19131.2 19169.2 19298.7 19390.6 7098.5 7129.5 7199.0 7257.2 7323.7 807.3 850.8 877.0 931.2 951.0 27308.6 27608.4 28407.0 28440.1 28477.0 919.3 934.9 947.5 952.1 955.6 14712.4 14759.3 15035.8 15095.3 15201.4 368351.0 372867.0 373580.0 373761.0 373770.0 49921.8 50479.5 50523.0 50568.7 50572.0 1086.3 1175.6 1181.1 1203.8 1220.8 28479.3 29640.0 29795.1 29873.0 30238.8 41837.6 42461.0 42463.4 42486.8 42534.6 297284.0 303066.0 303132.0 304085.0 304204.0 31697.8 32117.7 33366.2 33372.7 34004.1 38264.4 41598.0 42370.0 42738.0 43323.6 34201.5 36070.8 36182.0 36373.5 36599.1 35734.8 36380.0 36402.5 36445.5 36478.5 36208.2 36219.8 38796.6 39525.4 39671.8 31647.0 33365.5 33675.7 33767.0 34206.5 25446.4 25644.4 25683.1 25723.2 26085.5 07:47:49 INFO - PROCESS | 18421 | 07:47:49 INFO - PROCESS | 18421 | [#2] jquery.html Cycles:180 Average:23074.81 Median:5265.75 stddev:60623.75 (1151.3%) stddev-sans-first:60769.87 07:47:49 INFO - PROCESS | 18421 | Values: 384.8 384.9 390.2 400.2 403.1 15646.9 16812.3 17683.5 17782.3 17795.1 16257.5 16332.5 16730.9 17032.7 17052.2 5121.7 5263.9 5267.6 5298.5 5315.3 3694.4 3936.1 5738.3 6033.0 6037.0 6026.7 6075.7 6099.8 6118.3 6119.8 5922.9 6042.6 6070.2 6073.8 6074.9 3373.2 5055.7 5418.2 5427.3 5511.1 20131.0 20224.4 20549.0 20620.0 20670.8 1715.5 1805.4 1865.2 1885.6 1939.0 12642.9 13006.3 13184.3 13404.7 13767.7 1601.4 1632.0 1689.9 1695.9 1708.2 66278.7 69191.3 69210.0 70376.0 72911.6 9911.6 10215.5 10311.6 10427.6 10531.5 14141.3 14204.5 14274.6 14316.9 14325.7 6945.6 7073.7 7084.9 7186.7 7205.7 6615.2 6636.8 6711.8 6724.9 6745.1 4370.7 4415.3 4425.2 4489.1 4550.2 1606.7 1739.4 1739.5 1748.1 1835.9 759.2 828.2 915.1 937.5 946.7 15860.8 16399.6 16539.2 16702.5 17241.0 800.2 805.8 820.6 836.9 842.3 9202.3 9710.6 9725.9 9765.1 9798.1 362172.0 362533.0 370130.0 370710.0 374762.0 47537.3 47963.3 71558.3 73686.3 74414.0 924.4 925.5 926.1 936.7 945.4 15055.8 15086.5 15098.2 15300.7 15561.7 32936.0 33718.5 33742.3 34666.1 35359.6 43783.3 47156.5 47765.8 47878.8 48087.3 7165.6 7168.2 7186.9 7224.6 7279.3 9003.0 10243.4 10427.4 10447.7 10792.8 8747.2 8904.9 8956.5 9049.8 9428.4 8728.7 9119.9 9177.6 9275.9 9390.5 9058.6 9313.2 9372.8 9553.1 9643.9 7387.7 7628.6 7634.1 7647.3 7760.1 8841.3 9037.2 9123.3 9230.4 9332.8 07:47:49 INFO - PROCESS | 18421 | 07:47:49 INFO - PROCESS | 18421 | [#3] mootools.html Cycles:180 Average:5245.94 Median:5313.47 stddev:2905.82 (54.7%) stddev-sans-first:2898.74 07:47:49 INFO - PROCESS | 18421 | Values: 1286.6 1420.8 1480.2 1595.8 1794.1 6489.2 7654.2 7910.2 7916.7 8174.1 7865.5 8028.7 8029.6 8050.5 8051.6 2251.6 2284.4 2285.3 2285.5 2287.9 2204.4 2248.4 2274.1 2280.2 2281.3 2201.3 2208.1 2221.3 2222.4 2222.5 2115.4 2165.8 2170.4 2172.9 2176.5 2176.7 2185.9 2190.2 2190.7 2194.1 7690.6 7969.5 7992.6 8057.8 8074.9 4697.1 4912.7 4915.7 4921.0 4922.6 2994.2 3085.3 3165.5 3183.8 3186.3 957.6 972.6 982.8 999.4 1025.7 10589.4 10807.4 10808.1 10823.2 10834.5 4431.6 4560.3 4564.2 4579.2 4580.7 9316.7 9343.1 9372.8 9380.5 9383.2 4933.4 4936.2 4936.5 4941.7 4942.1 3642.9 3844.8 4370.8 4408.9 4445.0 3751.6 3788.1 3852.6 3885.4 3893.1 1242.3 1264.5 1272.7 1275.1 1288.0 672.1 697.2 701.3 777.0 788.6 5146.9 5240.0 5297.1 5401.4 5478.9 840.0 848.2 856.7 899.2 904.7 3633.8 3749.3 3803.8 3820.1 3852.8 9568.5 9926.5 9933.4 9939.4 9947.6 9612.3 9798.2 9811.3 9814.1 9830.0 7291.4 7395.2 7415.2 7434.0 7457.1 5167.9 5285.4 5329.9 5405.8 5408.9 8744.4 8804.3 8851.1 9105.1 9119.4 9107.7 9170.0 9209.8 9215.9 9220.6 6626.5 6696.5 6729.7 6761.5 6765.7 7498.8 7533.9 7566.3 7585.8 7603.3 6010.8 6298.9 6729.4 6856.1 6981.7 6793.3 6803.5 6860.3 6916.1 6923.2 6412.0 6452.8 6564.1 6567.9 6576.4 4645.3 4656.5 4691.7 4703.6 4733.4 4695.6 4728.8 4731.2 4783.5 4812.3 07:47:49 INFO - PROCESS | 18421 | 07:47:49 INFO - PROCESS | 18421 | [#4] prototype.html Cycles:180 Average:4210.29 Median:4816.96 stddev:1203.84 (25.0%) stddev-sans-first:1171.06 07:47:49 INFO - PROCESS | 18421 | Values: 309.2 309.4 311.1 313.6 317.3 4768.3 4804.0 4804.6 4831.4 4865.0 4760.5 4762.0 4815.9 4818.0 4825.2 3609.6 3726.3 3738.4 3738.9 3842.8 3775.8 3817.8 3821.8 3841.6 3848.7 3771.3 3792.6 3805.3 3807.2 3811.9 3612.3 3715.6 3785.9 3794.8 3825.9 3386.3 3395.4 3412.1 3415.4 3434.5 4634.5 4641.4 4653.1 4653.5 4653.6 4237.9 4354.2 4355.0 4359.6 4403.2 4986.2 4990.7 5018.4 5027.5 5034.1 3716.7 3724.9 3728.9 3729.1 3737.5 5071.4 5190.7 5243.5 5299.1 5317.3 3696.4 3705.9 3709.0 3725.5 3745.2 3774.9 3781.7 3784.9 3788.9 3794.2 4269.0 4281.4 4294.5 4295.3 4297.5 4874.8 5059.4 5080.1 5082.2 5090.7 1332.6 1335.2 1337.9 1344.4 1359.4 860.4 862.6 882.3 919.5 945.1 4381.8 4391.8 4402.4 4407.2 4409.6 5095.8 5096.9 5099.4 5108.3 5120.7 4226.5 4365.6 4371.6 4404.8 4430.3 2737.2 2751.5 2791.6 2795.6 2809.1 4908.0 4918.5 4929.6 4939.8 4959.0 5040.5 5325.6 5337.5 5342.5 5361.4 4928.6 4942.9 4946.9 4948.1 4963.4 5204.3 5227.3 5234.5 5245.7 5248.2 4855.6 5142.4 5142.8 5198.2 5200.3 4920.0 4930.4 4936.6 4962.7 4963.0 3712.6 3714.7 3730.9 3754.0 3755.8 5127.9 5204.6 5212.3 5284.7 5304.2 5011.7 5045.4 5066.9 5068.9 5088.0 5048.3 5050.8 5056.8 5063.7 5095.9 4895.6 4986.9 4991.8 5000.7 5032.9 4861.0 4958.7 5081.2 5085.7 5088.6 4945.4 4958.9 4967.8 4975.9 5004.3 07:47:49 INFO - PROCESS | 18421 | 07:47:49 INFO - PROCESS | 18421 | [#5] yui.html Cycles:180 Average:13013.55 Median:25088.37 stddev:15259.26 (60.8%) stddev-sans-first:15273.45 07:47:49 INFO - PROCESS | 18421 | Values: 568.2 635.0 651.5 713.0 765.5 10064.7 11704.6 12067.8 12563.1 13572.2 13013.1 13556.9 13557.7 13597.7 13602.9 620.6 775.9 799.7 804.2 807.6 803.0 806.5 807.5 807.6 807.9 836.3 839.7 839.8 841.0 841.7 833.3 833.6 833.9 834.1 834.4 615.8 617.4 617.9 618.5 618.7 11909.7 11915.1 11932.5 11941.1 11942.1 12464.5 12475.3 12614.6 12971.3 13123.9 9752.7 9767.7 10069.0 10385.2 10404.9 3214.8 3218.3 3242.0 3280.2 3341.0 46798.0 46942.0 46954.5 47163.8 48122.0 9199.5 9371.1 9380.7 9419.7 9513.6 17116.3 17117.5 17197.3 17199.5 17253.7 6584.2 6646.1 6732.0 6751.3 6883.7 3534.1 3547.7 3575.7 3611.3 3684.2 2945.4 3008.2 3012.9 3025.0 3032.8 502.7 522.2 525.1 525.1 538.4 502.5 565.3 602.8 603.7 613.6 7331.4 7408.7 7505.8 7683.0 7735.6 560.2 576.2 583.3 588.4 607.6 3620.2 3659.9 3757.7 3768.5 3773.6 52612.2 53370.7 54200.2 55508.7 55836.2 49016.8 49674.3 50454.2 50521.2 50778.7 44758.8 44817.0 45102.3 45104.0 45302.3 6679.5 6729.2 6797.4 6934.8 6997.5 30579.5 30594.0 30929.7 31513.8 31862.4 40588.4 41100.4 41212.6 41243.4 41400.6 9720.5 9990.4 10054.9 10200.0 10204.6 11318.4 11335.5 11651.1 12005.8 12033.8 9833.6 9918.2 10077.5 10437.4 10892.9 10388.7 10430.8 10531.5 10852.4 11223.4 10406.3 10574.2 10611.6 10613.3 10895.0 9277.0 9329.0 9386.2 9605.4 9716.6 9020.0 9391.2 9394.8 9437.8 9577.0 07:47:49 INFO - PROCESS | 18421 | -------- Summary: end -------- 07:47:49 INFO - PROCESS | 18421 | 07:47:50 INFO - TEST-INFO | 18421: exit 0 07:47:50 INFO - TEST-OK | dromaeo_css | took 1118730ms 07:47:50 INFO - TEST-START | kraken 07:47:50 INFO - operating with platform_type : linux_ 07:47:50 INFO - Initialising browser for kraken test... 07:47:50 INFO - TEST-INFO | started process 18639 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbhgbrf/profile http://localhost:48689/getInfo.html) 07:47:54 INFO - PROCESS | 18639 | __metrics Screen width/height:1600/1200 07:47:54 INFO - PROCESS | 18639 | colorDepth:24 07:47:54 INFO - PROCESS | 18639 | Browser inner width/height: 1024/697 07:47:54 INFO - PROCESS | 18639 | __metrics 07:47:55 ERROR - PROCESS | 18639 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:47:56 INFO - TEST-INFO | 18639: exit 0 07:47:56 INFO - Browser initialized. 07:47:56 INFO - Running cycle 1/1 for kraken test... 07:47:56 INFO - TEST-INFO | started process 18720 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbhgbrf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:48:08 INFO - PROCESS | 18720 | RSS: Main: 157315072 07:48:08 INFO - PROCESS | 18720 | 07:48:11 INFO - PROCESS | 18720 | Cycle 1(1): loaded http://localhost:48689/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48689/tests/kraken/driver.html?testName=audio-beat-detection) 07:48:12 INFO - PROCESS | 18720 | RSS: Main: 214798336 07:48:12 INFO - PROCESS | 18720 | 07:48:14 INFO - PROCESS | 18720 | Cycle 1(1): loaded http://localhost:48689/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48689/tests/kraken/driver.html?testName=audio-dft) 07:48:15 INFO - PROCESS | 18720 | RSS: Main: 204656640 07:48:15 INFO - PROCESS | 18720 | 07:48:18 INFO - PROCESS | 18720 | Cycle 1(1): loaded http://localhost:48689/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48689/tests/kraken/driver.html?testName=audio-fft) 07:48:19 INFO - PROCESS | 18720 | RSS: Main: 270766080 07:48:19 INFO - PROCESS | 18720 | 07:48:21 INFO - PROCESS | 18720 | Cycle 1(1): loaded http://localhost:48689/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48689/tests/kraken/driver.html?testName=audio-oscillator) 07:48:22 INFO - PROCESS | 18720 | RSS: Main: 181022720 07:48:22 INFO - PROCESS | 18720 | 07:48:24 INFO - PROCESS | 18720 | Cycle 1(1): loaded http://localhost:48689/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48689/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:48:24 INFO - PROCESS | 18720 | RSS: Main: 184483840 07:48:24 INFO - PROCESS | 18720 | 07:48:28 INFO - PROCESS | 18720 | Cycle 1(1): loaded http://localhost:48689/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48689/tests/kraken/driver.html?testName=imaging-darkroom) 07:48:28 INFO - PROCESS | 18720 | RSS: Main: 220450816 07:48:28 INFO - PROCESS | 18720 | 07:48:32 INFO - PROCESS | 18720 | Cycle 1(1): loaded http://localhost:48689/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48689/tests/kraken/driver.html?testName=imaging-desaturate) 07:48:32 INFO - PROCESS | 18720 | RSS: Main: 217522176 07:48:32 INFO - PROCESS | 18720 | 07:48:35 INFO - PROCESS | 18720 | Cycle 1(1): loaded http://localhost:48689/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48689/tests/kraken/driver.html?testName=json-parse-financial) 07:48:36 INFO - PROCESS | 18720 | RSS: Main: 219398144 07:48:36 INFO - PROCESS | 18720 | 07:48:38 INFO - PROCESS | 18720 | Cycle 1(1): loaded http://localhost:48689/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48689/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:48:38 INFO - PROCESS | 18720 | RSS: Main: 209858560 07:48:38 INFO - PROCESS | 18720 | 07:48:40 INFO - PROCESS | 18720 | Cycle 1(1): loaded http://localhost:48689/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48689/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:48:41 INFO - PROCESS | 18720 | RSS: Main: 210669568 07:48:41 INFO - PROCESS | 18720 | 07:48:43 INFO - PROCESS | 18720 | Cycle 1(1): loaded http://localhost:48689/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48689/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:48:44 INFO - PROCESS | 18720 | RSS: Main: 216293376 07:48:44 INFO - PROCESS | 18720 | 07:48:46 INFO - PROCESS | 18720 | Cycle 1(1): loaded http://localhost:48689/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48689/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:48:47 INFO - PROCESS | 18720 | RSS: Main: 222228480 07:48:47 INFO - PROCESS | 18720 | 07:48:50 INFO - PROCESS | 18720 | Cycle 1(1): loaded http://localhost:48689/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48689/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:48:50 INFO - PROCESS | 18720 | RSS: Main: 222859264 07:48:50 INFO - PROCESS | 18720 | 07:48:52 INFO - PROCESS | 18720 | Cycle 1(1): loaded http://localhost:48689/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48689/tests/kraken/driver.html?testName=ai-astar) 07:48:52 INFO - PROCESS | 18720 | RSS: Main: 264679424 07:48:52 INFO - PROCESS | 18720 | 07:48:52 INFO - PROCESS | 18720 | __start_tp_report 07:48:52 INFO - PROCESS | 18720 | _x_x_mozilla_page_load 07:48:52 INFO - PROCESS | 18720 | _x_x_mozilla_page_load_details 07:48:52 INFO - PROCESS | 18720 | |i|pagename|runs| 07:48:52 INFO - PROCESS | 18720 | |0;ai-astar;116;111;114;116;116;114;111;114;113;113 07:48:52 INFO - PROCESS | 18720 | |1;audio-beat-detection;165;129;131;185;131;135;162;129;172;132 07:48:52 INFO - PROCESS | 18720 | |2;audio-dft;161;160;160;161;162;162;163;161;161;161 07:48:52 INFO - PROCESS | 18720 | |3;audio-fft;75;76;74;103;76;77;75;74;98;76 07:48:52 INFO - PROCESS | 18720 | |4;audio-oscillator;84;84;124;85;84;86;118;84;84;130 07:48:52 INFO - PROCESS | 18720 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 07:48:52 INFO - PROCESS | 18720 | |6;imaging-darkroom;147;147;145;145;146;146;146;146;147;146 07:48:52 INFO - PROCESS | 18720 | |7;imaging-desaturate;96;94;95;95;95;95;95;95;95;95 07:48:52 INFO - PROCESS | 18720 | |8;json-parse-financial;62;62;62;62;63;62;64;62;63;63 07:48:52 INFO - PROCESS | 18720 | |9;json-stringify-tinderbox;65;65;65;64;66;65;65;64;66;64 07:48:52 INFO - PROCESS | 18720 | |10;stanford-crypto-aes;83;84;83;82;84;83;83;84;123;84 07:48:52 INFO - PROCESS | 18720 | |11;stanford-crypto-ccm;141;132;137;140;135;130;126;139;137;132 07:48:52 INFO - PROCESS | 18720 | |12;stanford-crypto-pbkdf2;169;170;171;170;173;169;178;169;171;167 07:48:52 INFO - PROCESS | 18720 | |13;stanford-crypto-sha256-iterative;67;67;67;65;66;77;68;66;65;66 07:48:52 INFO - PROCESS | 18720 | __end_tp_report 07:48:52 INFO - PROCESS | 18720 | __start_cc_report 07:48:52 INFO - PROCESS | 18720 | _x_x_mozilla_cycle_collect,1891 07:48:52 INFO - PROCESS | 18720 | __end_cc_report 07:48:52 INFO - PROCESS | 18720 | __startTimestamp1464360532940__endTimestamp 07:48:52 INFO - PROCESS | 18720 | 07:48:52 INFO - PROCESS | 18720 | ------- Summary: start ------- 07:48:52 INFO - PROCESS | 18720 | Number of tests: 14 07:48:52 INFO - PROCESS | 18720 | 07:48:52 INFO - PROCESS | 18720 | [#0] ai-astar Cycles:10 Average:113.80 Median:114.00 stddev:1.87 (1.6%) stddev-sans-first:1.81 07:48:52 INFO - PROCESS | 18720 | Values: 116.0 111.0 114.0 116.0 116.0 114.0 111.0 114.0 113.0 113.0 07:48:52 INFO - PROCESS | 18720 | 07:48:52 INFO - PROCESS | 18720 | [#1] audio-beat-detection Cycles:10 Average:147.10 Median:148.50 stddev:21.47 (14.5%) stddev-sans-first:21.77 07:48:52 INFO - PROCESS | 18720 | Values: 165.0 129.0 131.0 185.0 131.0 135.0 162.0 129.0 172.0 132.0 07:48:52 INFO - PROCESS | 18720 | 07:48:52 INFO - PROCESS | 18720 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 07:48:52 INFO - PROCESS | 18720 | Values: 161.0 160.0 160.0 161.0 162.0 162.0 163.0 161.0 161.0 161.0 07:48:52 INFO - PROCESS | 18720 | 07:48:52 INFO - PROCESS | 18720 | [#3] audio-fft Cycles:10 Average:80.40 Median:76.00 stddev:10.70 (14.1%) stddev-sans-first:11.17 07:48:52 INFO - PROCESS | 18720 | Values: 75.0 76.0 74.0 103.0 76.0 77.0 75.0 74.0 98.0 76.0 07:48:52 INFO - PROCESS | 18720 | 07:48:52 INFO - PROCESS | 18720 | [#4] audio-oscillator Cycles:10 Average:96.30 Median:84.00 stddev:19.33 (23.0%) stddev-sans-first:19.99 07:48:52 INFO - PROCESS | 18720 | Values: 84.0 84.0 124.0 85.0 84.0 86.0 118.0 84.0 84.0 130.0 07:48:52 INFO - PROCESS | 18720 | 07:48:52 INFO - PROCESS | 18720 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 07:48:52 INFO - PROCESS | 18720 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 07:48:52 INFO - PROCESS | 18720 | 07:48:52 INFO - PROCESS | 18720 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 07:48:52 INFO - PROCESS | 18720 | Values: 147.0 147.0 145.0 145.0 146.0 146.0 146.0 146.0 147.0 146.0 07:48:52 INFO - PROCESS | 18720 | 07:48:52 INFO - PROCESS | 18720 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.33 07:48:52 INFO - PROCESS | 18720 | Values: 96.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 07:48:52 INFO - PROCESS | 18720 | 07:48:52 INFO - PROCESS | 18720 | [#8] json-parse-financial Cycles:10 Average:62.50 Median:62.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 07:48:52 INFO - PROCESS | 18720 | Values: 62.0 62.0 62.0 62.0 63.0 62.0 64.0 62.0 63.0 63.0 07:48:52 INFO - PROCESS | 18720 | 07:48:52 INFO - PROCESS | 18720 | [#9] json-stringify-tinderbox Cycles:10 Average:64.90 Median:65.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 07:48:52 INFO - PROCESS | 18720 | Values: 65.0 65.0 65.0 64.0 66.0 65.0 65.0 64.0 66.0 64.0 07:48:52 INFO - PROCESS | 18720 | 07:48:52 INFO - PROCESS | 18720 | [#10] stanford-crypto-aes Cycles:10 Average:87.30 Median:83.50 stddev:12.56 (15.0%) stddev-sans-first:13.23 07:48:52 INFO - PROCESS | 18720 | Values: 83.0 84.0 83.0 82.0 84.0 83.0 83.0 84.0 123.0 84.0 07:48:52 INFO - PROCESS | 18720 | 07:48:52 INFO - PROCESS | 18720 | [#11] stanford-crypto-ccm Cycles:10 Average:134.90 Median:137.00 stddev:4.82 (3.5%) stddev-sans-first:4.58 07:48:52 INFO - PROCESS | 18720 | Values: 141.0 132.0 137.0 140.0 135.0 130.0 126.0 139.0 137.0 132.0 07:48:52 INFO - PROCESS | 18720 | 07:48:52 INFO - PROCESS | 18720 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.70 Median:170.50 stddev:3.02 (1.8%) stddev-sans-first:3.14 07:48:52 INFO - PROCESS | 18720 | Values: 169.0 170.0 171.0 170.0 173.0 169.0 178.0 169.0 171.0 167.0 07:48:52 INFO - PROCESS | 18720 | 07:48:52 INFO - PROCESS | 18720 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:67.00 stddev:3.50 (5.2%) stddev-sans-first:3.71 07:48:52 INFO - PROCESS | 18720 | Values: 67.0 67.0 67.0 65.0 66.0 77.0 68.0 66.0 65.0 66.0 07:48:52 INFO - PROCESS | 18720 | -------- Summary: end -------- 07:48:52 INFO - PROCESS | 18720 | 07:48:53 INFO - TEST-INFO | 18720: exit 0 07:48:54 INFO - TEST-OK | kraken | took 63705ms 07:48:54 INFO - SUITE-END | took 1182s 07:48:54 INFO - Completed test suite (00:19:42) 07:48:54 INFO - javascript benchmark 07:48:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2695.272276485349, 2700.1494529223305, 2717.266338088716, 2746.395792925557, 2764.6129541864143, 4716.646251531131, 4786.856394308172, 4808.567228949394, 4857.902841943163, 4898.877528061796, 4789.640776941726, 4797.520247975201, 4831.033793241349, 4868.975655121728, 4880.09718202132, 4352.064306174172, 4402.7358358498595, 4443.022535042302, 4472.038511719979, 4616.746078965655, 4544.840930567414, 4556.407667003302, 4572.291294849287, 4601.3558101865765, 4626.97686511567, 4343.044530203382, 4382.605565499089, 4387.319965405367, 4420.11597680462, 4420.51374348823, 4400.339949007643, 4404.383386325917, 4417.514073451917, 4429.180601588684, 4448.33275008748, 4441.200583894898, 4444.133393988173, 4452.1986042512335, 4466.55334466554, 4485.506594274627, 4628.074385122955, 4713.34013238147, 4740.952590474086, 4765.904681906377, 4846.466888642247, 5207.661502002357, 5209.505097015777, 5238.292830467914, 5252.921206181911, 5271.209318602202, 5208.5572726318305, 5276.103062479349, 5285.07511185541, 5288.127458969304, 5297.523222909918, 4710.81156753726, 4816.446108697474, 4859.927101093486, 4872.561469467765, 4911.778969946361, 5395.352557693023, 5398.460153984649, 5399.190121481809, 5412.83761487156, 5417.18742188667, 5184.196449550326, 5185.0407674579565, 5193.246979187997, 5194.168932970707, 5200.037992971313, 5058.291839142523, 5103.668261563061, 5111.952049829776, 5114.71869047206, 5167.560757335668, 5090.261912022736, 5127.717975511308, 5129.12804823181, 5131.897362052813, 5180.404253510819, 4972.129877271463, 5108.131617625013, 5120.61595380348, 5125.897482050413, 5128.153854613947, 4275.358696195533, 4326.567343265649, 4369.104333611602, 4369.978150109293, 4405.581469760367, 3816.44661524083, 3831.04223944014, 3833.1375440526217, 3868.7485313454536, 3876.5541962674088, 4450.287953927356, 4463.933041004388, 4465.24090904547, 4468.151051300242, 4514.796834142471, 5121.0, 5169.7932082717025, 5197.8440646780655, 5205.9739701302005, 5233.738313084331, 4437.711548749321, 4459.152760975404, 4469.709468884512, 4473.217186992263, 4505.0, 4510.977445112819, 4646.326282689059, 4658.208104622222, 4660.720356778605, 4701.623870090384, 4854.684445510959, 4896.069746748107, 4899.044686286283, 4923.803047878188, 4927.852164435073, 5196.506331898615, 5216.686998780086, 5220.269162317202, 5255.973720131375, 5267.499587539178, 4774.1883879739835, 4834.009028149291, 4875.6099512038245, 4925.335079764329, 4927.063857866994, 5061.164907790173, 5107.923381149211, 5122.769475373691, 5126.231065340229, 5177.611679124156, 5204.2974198484235, 5204.687718736888, 5208.140656791587, 5209.114450543492, 5260.658057226268, 4885.87785305356, 4973.254011898244, 4987.80048798044, 5042.697438153723, 5043.924341134959, 4987.551120399182, 5012.874678133076, 5019.472955339636, 5019.824306149268, 5042.823501177441, 4971.875703107451, 4973.577245934136, 4989.750512474289, 5011.223260394645, 5031.270465782368, 4937.790241390739, 4958.057968985881, 4980.228064649985, 5005.274235235943, 5114.411842638145, 4894.95105048945, 4980.22806464984, 4995.100881841304, 5005.199168133081, 5005.249212618136], "value": 4754.370667122692, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [546.3252882689877, 596.4035964035965, 598.5929567893836, 603.0321334258515, 605.4883623338279, 26638.86680566597, 39290.21419571611, 39640.20719585606, 39823.2035359293, 40028.59971400285, 37785.244295114084, 38368.808155959254, 42150.156996860045, 42162.156756864846, 42233.155336893244, 7420.628968551578, 7698.2686644768655, 7855.882161767549, 7856.0, 7859.214078592124, 10099.899001010006, 10342.379457232553, 10349.172066234722, 10355.430451325174, 10691.251612387136, 9987.950060249688, 10108.444035578077, 10359.171266298677, 10364.378137311785, 10368.429736364496, 10224.284300098996, 10313.38119712816, 10314.278000539965, 10314.535845886952, 10322.48387580618, 10155.492225388702, 10265.384076955406, 10273.794524109477, 10279.537420816081, 10280.177585793193, 39357.0, 39500.407493887615, 39720.60279397198, 39759.20481590381, 39762.0, 2954.202365361362, 3003.9249018774703, 3046.817190968527, 3052.9694703052905, 3107.6115485564305, 30370.240743981358, 30713.69286307131, 30834.53748193779, 31001.224969375722, 31954.201144971328, 3204.807711537292, 3224.0650211438656, 3229.6124465064345, 3240.659730728287, 3250.6586808385014, 256809.0, 262682.6865865678, 262767.0, 263227.0, 263979.0, 57588.71205644029, 58522.4147758517, 58580.0, 58633.4136658628, 58634.70682646645, 62170.378296217365, 62296.68851655803, 62320.0, 62389.68805155945, 62457.0, 13435.0, 13686.65783355424, 13716.108452950526, 13729.176249425067, 13743.312834358243, 9162.450252984841, 9998.200143988464, 10007.549660265306, 10202.438865862301, 10242.948785256174, 19103.617927641648, 19131.23475060982, 19169.233230670896, 19298.71051934222, 19390.612187756167, 7098.467614928901, 7129.508409701958, 7199.028131202325, 7257.221980614678, 7323.7436689715605, 807.3339494916718, 850.7575341027901, 876.9605367758467, 931.1526510875071, 951.0, 27308.590371144448, 27608.447831043668, 28407.0, 28440.146795596163, 28477.0, 919.3242966419676, 934.8784657994553, 947.4646824544111, 952.0574631115146, 955.6082006377352, 14712.411503539952, 14759.335829887681, 15035.774463383059, 15095.32071056805, 15201.391944322324, 368351.0, 372867.0, 373580.0, 373761.0, 373770.0, 49921.75039124781, 50479.49520504822, 50523.0, 50568.74715626472, 50572.0, 1086.28305318491, 1175.6002958993984, 1181.0846593889632, 1203.771283456158, 1220.7619514195003, 28479.28801779972, 29640.0, 29795.10614681563, 29873.0, 30238.848805756712, 41837.58162418337, 42461.0, 42463.36304955366, 42486.78756606197, 42534.57465425306, 297284.0, 303066.0, 303132.0, 304085.0, 304204.0, 31697.8415107923, 32117.67882321147, 33366.16584585405, 33372.66627333793, 34004.14989625279, 38264.426033608965, 41597.96005099897, 42370.0, 42738.0, 43323.566764331954, 34201.47469210677, 36070.81964590265, 36182.0, 36373.45439818458, 36599.08502287357, 35734.8213258932, 36380.0, 36402.4539631911, 36445.45331820078, 36478.4528232082, 36208.18959051984, 36219.818900905324, 38796.6120338793, 39525.40711889382, 39671.801640992766, 31647.0, 33365.48119350207, 33675.66324336725, 33767.0, 34206.48690269598, 25446.363840904127, 25644.358891027874, 25683.10109146171, 25723.228303150936, 26085.478290434465], "value": 18303.207631752663, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.834521155903, 384.91147036181695, 390.20593093055635, 400.19161294185744, 403.0910297279634, 15646.921765391171, 16812.32750689971, 17683.46949591511, 17782.288708451662, 17795.110244487772, 16257.51227463175, 16332.510024699248, 16730.916345418285, 17032.744508832377, 17052.23264953077, 5121.692698438096, 5263.921041184366, 5267.578593712513, 5298.496642818926, 5315.309009828717, 3694.4273637586216, 3936.1143742657814, 5738.254026976487, 6032.969835150818, 6037.0340745480735, 6026.728797204137, 6075.696215189245, 6099.756009759604, 6118.3269840317525, 6119.816405507842, 5922.851928701773, 6042.57701960863, 6070.180525629028, 6073.848153796168, 6074.908876366858, 3373.207296285371, 5055.721935293557, 5418.187271909245, 5427.348718153808, 5511.063119269694, 20131.0, 20224.393268201977, 20549.0, 20620.0, 20670.793292067036, 1715.476779582227, 1805.3681211575974, 1865.1979648751033, 1885.6417280716757, 1939.0498655658766, 12642.936785316106, 13006.284654344006, 13184.274864882427, 13404.732254047323, 13767.655808604764, 1601.375463569209, 1632.0370981121077, 1689.898606083639, 1695.9406420775213, 1708.197147340748, 66278.66860665714, 69191.30808691899, 69210.0, 70376.0, 72911.63544182297, 9911.553980070914, 10215.540300686338, 10311.587536498457, 10427.5828966842, 10531.473426328654, 14141.29293535319, 14204.502842400467, 14274.643133921734, 14316.928415358065, 14325.713485730435, 6945.583265004116, 7073.71705131789, 7084.901840214775, 7186.7125314986815, 7205.675744591506, 6615.239247486505, 6636.767713130113, 6711.798646040626, 6724.865502690017, 6745.0556922030955, 4370.650347972155, 4415.315626077963, 4425.22558552252, 4489.124620698998, 4550.180967425895, 1606.7027599893822, 1739.3912130754136, 1739.4864420911913, 1748.0560497331553, 1835.8853865912697, 759.1762937213075, 828.2131974624131, 915.1306259053925, 937.5434968483362, 946.7301818981557, 15860.841391586167, 16399.590010249838, 16539.173041347884, 16702.49892503227, 17241.0, 800.1798156889118, 805.8106345008919, 820.5609998650693, 836.9288610468057, 842.3345557010016, 9202.349791196255, 9710.611575537041, 9725.854112188323, 9765.121139097373, 9798.069183427562, 362172.0, 362533.0, 370130.0, 370710.0, 374762.0, 47537.286940695914, 47963.280550791766, 71558.2844171562, 73686.26313736901, 74414.0, 924.3621900888365, 925.5048549026238, 926.0554234680588, 936.7470782888719, 945.3666043750703, 15055.849441505445, 15086.54740357791, 15098.245087745789, 15300.693986119993, 15561.688766224386, 32936.0, 33718.49422258717, 33742.3251534963, 34666.13334666654, 35359.64640353563, 43783.34324985064, 47156.52843471659, 47765.761171193924, 47878.760606196745, 48087.27869081897, 7165.605891676008, 7168.17565979919, 7186.856262874818, 7224.602646854263, 7279.344858962719, 9002.954985225031, 10243.436610986468, 10427.374357538572, 10447.68656940293, 10792.784144317227, 8747.212750852454, 8904.910950890668, 8956.507392093497, 9049.77375565616, 9428.434293942386, 8728.67550794028, 9119.908800912172, 9177.632894684139, 9275.907240927505, 9390.530473476163, 9058.592363343534, 9313.208377288007, 9372.812543749224, 9553.092456216647, 9643.896909378685, 7387.667554959932, 7628.580428076509, 7634.122075961335, 7647.273509016634, 7760.14638389788, 8841.336899732674, 9037.231835294073, 9123.31575131881, 9230.400023998418, 9332.813343733224], "value": 8049.433127451748, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1286.5689993852059, 1420.7584710599197, 1480.222882986432, 1595.7765912772206, 1794.147779804593, 6489.156409666743, 7654.196309387511, 7910.248526389998, 7916.683332666694, 8174.100848906615, 7865.528068315905, 8028.678852845879, 8029.638666260033, 8050.516968981865, 8051.597420128999, 2251.5722012817596, 2284.3603790938564, 2285.3029825903095, 2285.4971906180613, 2287.9084836606517, 2204.360735386736, 2248.4041728941843, 2274.0789980058103, 2280.247518318951, 2281.281396360141, 2201.2924103352884, 2208.0615738311235, 2221.2891874600136, 2222.3777342344088, 2222.48882756966, 2115.4499830044147, 2165.7509386420606, 2170.446536133292, 2172.934811955644, 2176.4885251965857, 2176.684380764796, 2185.868847869117, 2190.1896298369547, 2190.7371115466244, 2194.0565556810566, 7690.615469226572, 7969.521828690297, 7992.560409177493, 8057.758267251933, 8074.878876816852, 4697.060587882403, 4912.7297998610065, 4915.705057696549, 4920.991196804683, 4922.581580565657, 2994.2065352681557, 3085.305806193611, 3165.5409965554863, 3183.840807959593, 3186.3149422874194, 957.5978089202551, 972.5963725054094, 982.8132654795565, 999.3959694690063, 1025.651278565284, 10589.417582032986, 10807.351558906412, 10808.081313088396, 10823.24237303389, 10834.458277086193, 4431.556844315543, 4560.293154561048, 4564.1556312082375, 4579.152856721451, 4580.679352445297, 9316.673916412892, 9343.065693430603, 9372.812543749224, 9380.530973451436, 9383.24934005278, 4933.432655244621, 4936.234883593049, 4936.531029552187, 4941.678790878582, 4942.110420124341, 3642.927141457156, 3844.75009124406, 4370.825166993348, 4408.933865992013, 4445.044315472189, 3751.6248375162268, 3788.0719223789797, 3852.6339997700734, 3885.436611691289, 3893.124047089382, 1242.2794779028143, 1264.4562837979572, 1272.662744372742, 1275.1074248026234, 1287.9613611591667, 672.1060988884772, 697.2469732688684, 701.2916953876519, 777.0364747712796, 788.6411682684364, 5146.922796158061, 5239.973800130975, 5297.073012222845, 5401.432849550741, 5478.863028424242, 839.9958000210082, 848.245061894914, 856.6787454704486, 899.1772528136681, 904.6652738486671, 3633.8364773585254, 3749.3251214781058, 3803.82882770276, 3820.0917736779547, 3852.768833869977, 9568.521573921415, 9926.454045027449, 9933.403995760278, 9939.403635781731, 9947.602095916227, 9612.269791437608, 9798.167155791694, 9811.313208075366, 9814.06766357195, 9829.950850245847, 7291.380232680175, 7395.186529481753, 7415.2214017527385, 7434.0, 7457.142428620669, 5167.922481162861, 5285.365756109291, 5329.866753331198, 5405.756740946588, 5408.9459105410015, 8744.431611945203, 8804.339674524565, 8851.114888511098, 9105.135012173832, 9119.361644684808, 9107.681231156877, 9169.954150229207, 9209.815803683754, 9215.907840921505, 9220.631174753204, 6626.53614246998, 6696.531242812956, 6729.663516824237, 6761.459083273228, 6765.661716914036, 7498.775036748906, 7533.886991695019, 7566.31903128721, 7585.848283034198, 7603.315701586663, 6010.759569617167, 6298.874022519432, 6729.394354508117, 6856.108705868205, 6981.650917454209, 6793.286704895915, 6803.489738269748, 6860.3139686031, 6916.135483064617, 6923.203831559234, 6411.96794016027, 6452.774152904626, 6564.113844631104, 6567.9014814776865, 6576.441002514648, 4645.3496510487885, 4656.509916826583, 4691.671582989158, 4703.601163406619, 4733.360996265598, 4695.647826413101, 4728.787204575871, 4731.172044892061, 4783.545563171493, 4812.25410061441], "value": 4231.0926881066125, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.19454820193397, 309.36116918563164, 311.09161249152476, 313.5672771575229, 317.25603459886565, 4768.284757286405, 4803.9759801201035, 4804.591609713169, 4831.371921650185, 4865.0, 4760.476347601761, 4761.976190119053, 4815.927761083578, 4818.0, 4825.155597770394, 3609.6029436761937, 3726.2672857121433, 3738.3831667774784, 3738.9439158412647, 3842.8078596070222, 3775.848366248293, 3817.790021548814, 3821.789801560913, 3841.5774264830848, 3848.730588858781, 3771.283456143338, 3792.601776813436, 3805.3340665383585, 3807.2385522895393, 3811.9047023824487, 3612.259486805199, 3715.609860964587, 3785.886423407302, 3794.848206071754, 3825.9043523911846, 3386.271951530433, 3395.439752440844, 3412.129906873756, 3415.3852306584804, 3434.5363375944175, 4634.467036290802, 4641.350210970467, 4653.0693861227555, 4653.534646535353, 4653.557911998355, 4237.940514871282, 4354.194474022316, 4354.978225108885, 4359.607635312837, 4403.185410699031, 4986.152354099811, 4990.700557966534, 5018.447970723218, 5027.49725027498, 5034.1122079220295, 3716.7212459065677, 3724.888253352404, 3728.8694895678523, 3729.1236559408517, 3737.5328083989502, 5071.366079240095, 5190.71451070191, 5243.475652434726, 5299.12564426873, 5317.255584218213, 3696.445533170046, 3705.8517659293325, 3708.962910370916, 3725.4970578971493, 3745.157339598623, 3774.905627359338, 3781.697464202857, 3784.899380843603, 3788.9431658525145, 3794.203217324393, 4268.957310426918, 4281.400603915455, 4294.506131794821, 4295.269804133305, 4297.527272000078, 4874.780634871439, 5059.392872855281, 5080.11371300955, 5082.161443361878, 5090.669106508065, 1332.640706479405, 1335.1588499245413, 1337.9397927093305, 1344.3547097393307, 1359.3611002828852, 860.3633311349681, 862.5773371048141, 882.2765332427476, 919.4758987377264, 945.0832692288469, 4381.751200907726, 4391.824327026883, 4402.405675233803, 4407.184670835905, 4409.581089796464, 5095.770690318945, 5096.898062038738, 5099.36257967754, 5108.335916330853, 5120.746871376582, 4226.535081141134, 4365.628921541705, 4371.562843715603, 4404.779761011937, 4430.313301438282, 2737.2472570043396, 2751.5047291487726, 2791.6231308773463, 2795.566687163493, 2809.0870467098275, 4908.04293162837, 4918.508149185124, 4929.630277729185, 4939.777710003059, 4958.958618690043, 5040.546350828443, 5325.573954083664, 5337.51962323385, 5342.492463215988, 5361.410244873061, 4928.581070608967, 4942.901141977212, 4946.925796113133, 4948.080632426885, 4963.404391472975, 5204.271402003798, 5227.3465816772905, 5234.476552344735, 5245.6852588844795, 5248.186531087687, 4855.6115510758345, 5142.354446577059, 5142.820001299937, 5198.218952860202, 5200.297959775382, 4920.031987205003, 4930.383702037246, 4936.605071594336, 4962.727050012284, 4963.0, 3712.554493460802, 3714.7213958953726, 3730.8880733578035, 3754.0103745015185, 3755.7934313613014, 5127.92308115386, 5204.609654275869, 5212.322398088224, 5284.656497327662, 5304.204369344629, 5011.699298042129, 5045.394552653705, 5066.898662026812, 5068.873278167928, 5088.0, 5048.318477005557, 5050.84847454577, 5056.82301119459, 5063.670861393997, 5095.87260318495, 4895.632827537877, 4986.850394488171, 4991.775370108281, 5000.674821172465, 5032.949670503248, 4861.0, 4958.677685950402, 5081.237814327733, 5085.7457127144235, 5088.643794934319, 4945.357103576512, 4958.8760280993265, 4967.82612608557, 4975.875603109806, 5004.299398084344], "value": 3834.2714135234623, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.1903287814863, 635.0125554762344, 651.4625434016937, 712.9964350178252, 765.5291995422809, 10064.748381290472, 11704.590339338125, 12067.818982715255, 12563.05777066719, 13572.185668859875, 13013.08908376414, 13556.932215338935, 13557.728845423086, 13597.660058498543, 13602.863971360284, 620.6214209332304, 775.8758598624221, 799.6681377228458, 804.1636697834275, 807.563915485637, 803.0363563723525, 806.5402720449346, 807.4912804932884, 807.6204184033495, 807.9474834135792, 836.2599099796694, 839.7396806989822, 839.8068444257824, 840.970566030189, 841.7180244618061, 833.3000279765026, 833.5748768128237, 833.9416240863142, 834.0783434305097, 834.407570624851, 615.827568280882, 617.4288782875867, 617.8609812792131, 618.5175563060819, 618.6751955223499, 11909.702257443547, 11915.106367022508, 11932.46303916317, 11941.104417168746, 11942.104342174373, 12464.501419943192, 12475.313857737821, 12614.621561353175, 12971.286579238138, 13123.86876131236, 9752.658656946973, 9767.706968790948, 10069.0, 10385.169186465064, 10404.895951040544, 3214.8231847248394, 3218.3241519280978, 3241.983790081058, 3280.1963518938014, 3341.0, 46798.0, 46942.0, 46954.530454695356, 47163.76418117888, 48122.0, 9199.4940278284, 9371.109744574254, 9380.671676491427, 9419.670311539063, 9513.571889265, 17116.315347386215, 17117.486475405756, 17197.312107515558, 17199.484015479557, 17253.654926901643, 6584.176977877765, 6646.136002319764, 6732.0, 6751.324867513307, 6883.724651014004, 3534.134137136418, 3547.733919955962, 3575.6781889630056, 3611.33190359779, 3684.244729830378, 2945.4403663303906, 3008.187789296878, 3012.894548690829, 3024.9848750756546, 3032.77254205931, 502.71345333159746, 522.1932114882516, 525.088970635954, 525.1413938211052, 538.4346436241931, 502.47993326906476, 565.2566874559941, 602.7860109661007, 603.7072020070262, 613.6134235431649, 7331.413486921034, 7408.7036518539735, 7505.774826755206, 7682.96158519215, 7735.574543400055, 560.1569637695243, 576.247996364748, 583.3466517500342, 588.3584798412381, 607.5595193484688, 3620.2035552179004, 3659.9451008234896, 3757.7369584128846, 3768.453574231721, 3773.6226377362045, 52612.210816837774, 53370.733146334795, 54200.18699719507, 55508.72245638746, 55836.16245756317, 49016.75491622519, 49674.254886176735, 50454.243186352236, 50521.242181367306, 50778.74610626923, 44758.77620611876, 44817.0, 45102.32346514805, 45104.0, 45302.32046519239, 6679.532432729662, 6729.158855143107, 6797.388235058868, 6934.826629334105, 6997.545159564612, 30579.54130688086, 30594.0, 30929.69070309268, 31513.8424307877, 31862.362752745277, 40588.39117413182, 41100.38349424701, 41212.58787412087, 41243.38134927918, 41400.58599414088, 9720.513974301399, 9990.400575965465, 10054.899451005396, 10200.0, 10204.591816327264, 11318.434078296217, 11335.546578136782, 11651.067914566984, 12005.819912701141, 12033.819492707442, 9833.557489912828, 9918.156956658477, 10077.546510407195, 10437.373757574569, 10892.945535272273, 10388.740281493023, 10430.843537346795, 10531.526081326205, 10852.403117828595, 11223.438828058728, 10406.271560990961, 10574.154067674413, 10611.575536978435, 10613.257072004886, 10895.0, 9276.953615231881, 9328.95335523318, 9386.249100071842, 9605.37565058269, 9716.611335546499, 9019.954900225457, 9391.20174785151, 9394.765130871783, 9437.828083171864, 9577.0], "value": 5881.78847717215, "unit": "score"}], "name": "dromaeo_css", "value": 6370.595208737304, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 111.0, 114.0, 116.0, 116.0, 114.0, 111.0, 114.0, 113.0, 113.0], "value": 113.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 129.0, 131.0, 185.0, 131.0, 135.0, 162.0, 129.0, 172.0, 132.0], "value": 147.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 161.0, 162.0, 162.0, 163.0, 161.0, 161.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 74.0, 103.0, 76.0, 77.0, 75.0, 74.0, 98.0, 76.0], "value": 80.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 124.0, 85.0, 84.0, 86.0, 118.0, 84.0, 84.0, 130.0], "value": 96.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 145.0, 145.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 62.0, 63.0, 62.0, 64.0, 62.0, 63.0, 63.0], "value": 62.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 64.0, 66.0, 65.0, 65.0, 64.0, 66.0, 64.0], "value": 64.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 83.0, 82.0, 84.0, 83.0, 83.0, 84.0, 123.0, 84.0], "value": 87.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 132.0, 137.0, 140.0, 135.0, 130.0, 126.0, 139.0, 137.0, 132.0], "value": 134.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 170.0, 171.0, 170.0, 173.0, 169.0, 178.0, 169.0, 171.0, 167.0], "value": 170.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 65.0, 66.0, 77.0, 68.0, 66.0, 65.0, 66.0], "value": 67.4, "unit": "score"}], "name": "kraken", "value": 1544.6000000000001, "alertThreshold": 2.0}]} 07:48:54 INFO - Return code: 0 07:48:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:48:54 ERROR - # TBPL SUCCESS # 07:48:54 INFO - Running post-action listener: _resource_record_post_action 07:48:54 INFO - ##### 07:48:54 INFO - ##### Finished run-tests step (success) 07:48:54 INFO - ##### 07:48:54 INFO - Running post-run listener: _resource_record_post_run 07:48:54 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 2670592; Write bytes: 531415040; Read time: 1036; Write time: 472376 07:48:54 INFO - TinderboxPrint: CPU usage
13.1% 07:48:54 INFO - TinderboxPrint: I/O read bytes / time
2,670,592 / 1,036 07:48:54 INFO - TinderboxPrint: I/O write bytes / time
531,415,040 / 472,376 07:48:54 INFO - TinderboxPrint: CPU idle
8,315.7 (86.9%) 07:48:54 INFO - TinderboxPrint: CPU user
1,210.0 (12.6%) 07:48:54 INFO - TinderboxPrint: Swap in / out
0 / 0 07:48:54 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 246870016; Read time: 0; Write time: 268372 07:48:54 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 2670592; Write bytes: 284467200; Read time: 1036; Write time: 204004 07:48:54 INFO - Running post-run listener: _upload_blobber_files 07:48:54 INFO - Blob upload gear active. 07:48:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:48:54 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 07:48:54 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'] 07:48:54 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 07:48:55 INFO - (blobuploader) - INFO - Open directory for files ... 07:48:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:48:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:48:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:48:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:48:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:48:56 INFO - (blobuploader) - INFO - Done attempting. 07:48:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:48:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:48:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:48:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:48:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:48:56 INFO - (blobuploader) - INFO - Done attempting. 07:48:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:48:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:48:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:49:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:49:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:49:02 INFO - (blobuploader) - INFO - Done attempting. 07:49:02 INFO - (blobuploader) - INFO - Iteration through files over. 07:49:02 INFO - Return code: 0 07:49:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:49:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:49:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b0ea73e53049ce0ba20612841c87b7097e823198ca9dd4cecc434cf657f032d0403a476e7b834f144f098ab9575a2793b29291fcb4a5f7741a94e91b212ad735", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e661e19a084b529b44da10210d8c3c85dc3c0403d07290aa1d3d8ae2854d1240edab82bdde7e175a5307e4b967ca2842d9ca3bb34439f165cbb1d41731f459c7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/827d226f2e4fe7d25701fa8fa3f0e8c155ce2806c470035233062f320cb08e75b66980a9d9c04d99aa91ac8eceac5ed00137d7691b81b0e96cd75fa944b82446"} 07:49:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:49:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:49:02 INFO - Contents: 07:49:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b0ea73e53049ce0ba20612841c87b7097e823198ca9dd4cecc434cf657f032d0403a476e7b834f144f098ab9575a2793b29291fcb4a5f7741a94e91b212ad735", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e661e19a084b529b44da10210d8c3c85dc3c0403d07290aa1d3d8ae2854d1240edab82bdde7e175a5307e4b967ca2842d9ca3bb34439f165cbb1d41731f459c7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/827d226f2e4fe7d25701fa8fa3f0e8c155ce2806c470035233062f320cb08e75b66980a9d9c04d99aa91ac8eceac5ed00137d7691b81b0e96cd75fa944b82446"} 07:49:02 INFO - Running post-run listener: copy_logs_to_upload_dir 07:49:02 INFO - Copying logs to upload dir... 07:49:02 INFO - mkdir: /builds/slave/test/build/upload/logs 07:49:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.439668 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-05-27 07:49:01.289116) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-27 07:49:01.293129) ========= 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=337fe3f4b1febe37b85fccc40000019e-1464358775.984300-115721101 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/b0ea73e53049ce0ba20612841c87b7097e823198ca9dd4cecc434cf657f032d0403a476e7b834f144f098ab9575a2793b29291fcb4a5f7741a94e91b212ad735", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e661e19a084b529b44da10210d8c3c85dc3c0403d07290aa1d3d8ae2854d1240edab82bdde7e175a5307e4b967ca2842d9ca3bb34439f165cbb1d41731f459c7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/827d226f2e4fe7d25701fa8fa3f0e8c155ce2806c470035233062f320cb08e75b66980a9d9c04d99aa91ac8eceac5ed00137d7691b81b0e96cd75fa944b82446"} build_url:https://queue.taskcluster.net/v1/task/LdwHZ-v-T3ShHldFVDqqgg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011265 build_url: 'https://queue.taskcluster.net/v1/task/LdwHZ-v-T3ShHldFVDqqgg/artifacts/public/build/firefox-49.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/b0ea73e53049ce0ba20612841c87b7097e823198ca9dd4cecc434cf657f032d0403a476e7b834f144f098ab9575a2793b29291fcb4a5f7741a94e91b212ad735", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e661e19a084b529b44da10210d8c3c85dc3c0403d07290aa1d3d8ae2854d1240edab82bdde7e175a5307e4b967ca2842d9ca3bb34439f165cbb1d41731f459c7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/827d226f2e4fe7d25701fa8fa3f0e8c155ce2806c470035233062f320cb08e75b66980a9d9c04d99aa91ac8eceac5ed00137d7691b81b0e96cd75fa944b82446"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-27 07:49:01.319671) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 07:49:01.320018) ========= 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=337fe3f4b1febe37b85fccc40000019e-1464358775.984300-115721101 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004421 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 07:49:01.405584) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-27 07:49:01.406062) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-27 07:49:01.406711) ========= ========= Total master_lag: 0.17 =========