builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-037 starttime: 1464228453.09 results: success (0) buildid: 20160525163027 builduid: 7872e1c46449446a99e3ac4ff9a222e9 revision: 35574c1aa9697cb60f05ba4c9d7175d1ffc59efc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-25 19:07:33.091179) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-25 19:07:33.091939) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-25 19:07:33.092355) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-25 19:07:33.167490) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 19:07:33.167811) ========= 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=aa08bb06ff6271ef470a76a4000001be-1464222731.922879-1876657530 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-25 19:07:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-05-25 19:07:33 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.085577 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 19:07:33.282153) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 19:07:33.282513) ========= 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=aa08bb06ff6271ef470a76a4000001be-1464222731.922879-1876657530 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014890 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 19:07:33.341105) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 19:07:33.341652) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 35574c1aa9697cb60f05ba4c9d7175d1ffc59efc --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 35574c1aa9697cb60f05ba4c9d7175d1ffc59efc --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=aa08bb06ff6271ef470a76a4000001be-1464222731.922879-1876657530 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-25 19:07:33,744 truncating revision to first 12 chars 2016-05-25 19:07:33,744 Setting DEBUG logging. 2016-05-25 19:07:33,744 attempt 1/10 2016-05-25 19:07:33,744 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/35574c1aa969?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-25 19:07:34,044 unpacking tar archive at: mozilla-inbound-35574c1aa969/testing/mozharness/ program finished with exit code 0 elapsedTime=0.655785 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 19:07:34.019971) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-25 19:07:34.020544) ========= script_repo_revision: 35574c1aa9697cb60f05ba4c9d7175d1ffc59efc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-25 19:07:34.021191) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-25 19:07:34.021740) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-25 19:07:34.032137) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-05-25 19:07:34.032497) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=aa08bb06ff6271ef470a76a4000001be-1464222731.922879-1876657530 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:07:34 INFO - MultiFileLogger online at 20160525 19:07:34 in /builds/slave/test 19:07:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 19:07:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:07:34 INFO - {'append_to_log': False, 19:07:34 INFO - 'base_work_dir': '/builds/slave/test', 19:07:34 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 19:07:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:07:34 INFO - 'branch': 'Mozilla-Inbound', 19:07:34 INFO - 'buildbot_json_path': 'buildprops.json', 19:07:34 INFO - 'config_files': ('talos/linux_config.py',), 19:07:34 INFO - 'default_actions': ('clobber', 19:07:34 INFO - 'read-buildbot-config', 19:07:34 INFO - 'download-and-extract', 19:07:34 INFO - 'populate-webroot', 19:07:34 INFO - 'create-virtualenv', 19:07:34 INFO - 'install', 19:07:34 INFO - 'run-tests'), 19:07:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:07:34 INFO - 'download_minidump_stackwalk': True, 19:07:34 INFO - 'download_symbols': 'ondemand', 19:07:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:07:34 INFO - 'tooltool.py': '/tools/tooltool.py', 19:07:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:07:34 INFO - '/tools/misc-python/virtualenv.py')}, 19:07:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:07:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:07:34 INFO - 'installer_path': 'installer.exe', 19:07:34 INFO - 'log_level': 'info', 19:07:34 INFO - 'log_name': 'talos', 19:07:34 INFO - 'log_to_console': True, 19:07:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:07:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:07:34 INFO - 'opt_config_files': (), 19:07:34 INFO - 'pip_index': False, 19:07:34 INFO - 'sps_profile': False, 19:07:34 INFO - 'sps_profile_interval': 0, 19:07:34 INFO - 'suite': 'dromaeojs', 19:07:34 INFO - 'system_bits': '32', 19:07:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:07:34 INFO - 'title': 'talos-linux64-ix-037', 19:07:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:07:34 INFO - 'use_talos_json': True, 19:07:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:07:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:07:34 INFO - 'work_dir': 'build'} 19:07:34 INFO - ##### 19:07:34 INFO - ##### Running clobber step. 19:07:34 INFO - ##### 19:07:34 INFO - Running pre-action listener: _resource_record_pre_action 19:07:34 INFO - Running main action method: clobber 19:07:34 INFO - rmtree: /builds/slave/test/build 19:07:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:07:34 INFO - Running post-action listener: _resource_record_post_action 19:07:34 INFO - ##### 19:07:34 INFO - ##### Finished clobber step (success) 19:07:34 INFO - ##### 19:07:34 INFO - ##### 19:07:34 INFO - ##### Running read-buildbot-config step. 19:07:34 INFO - ##### 19:07:34 INFO - Running pre-action listener: _resource_record_pre_action 19:07:34 INFO - Running main action method: read_buildbot_config 19:07:34 INFO - Using buildbot properties: 19:07:34 INFO - { 19:07:34 INFO - "project": "", 19:07:34 INFO - "product": "firefox", 19:07:34 INFO - "script_repo_revision": "production", 19:07:34 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 19:07:34 INFO - "repository": "", 19:07:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 19:07:34 INFO - "buildid": "20160525163027", 19:07:34 INFO - "pgo_build": "True", 19:07:34 INFO - "basedir": "/builds/slave/test", 19:07:34 INFO - "buildnumber": 1065, 19:07:34 INFO - "slavename": "talos-linux64-ix-037", 19:07:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:07:34 INFO - "platform": "ubuntu64_hw", 19:07:34 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 19:07:34 INFO - "branch": "mozilla-inbound", 19:07:34 INFO - "repo_path": "integration/mozilla-inbound", 19:07:34 INFO - "revision": "35574c1aa9697cb60f05ba4c9d7175d1ffc59efc", 19:07:34 INFO - "stage_platform": "linux64-pgo", 19:07:34 INFO - "builduid": "7872e1c46449446a99e3ac4ff9a222e9", 19:07:34 INFO - "slavebuilddir": "test" 19:07:34 INFO - } 19:07:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/AOY275KNTLagf5znPokNsw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 19:07:34 INFO - Running post-action listener: _resource_record_post_action 19:07:34 INFO - ##### 19:07:34 INFO - ##### Finished read-buildbot-config step (success) 19:07:34 INFO - ##### 19:07:34 INFO - ##### 19:07:34 INFO - ##### Running download-and-extract step. 19:07:34 INFO - ##### 19:07:34 INFO - Running pre-action listener: _resource_record_pre_action 19:07:34 INFO - Running main action method: download_and_extract 19:07:34 INFO - mkdir: /builds/slave/test/build/tests 19:07:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:34 INFO - https://queue.taskcluster.net/v1/task/AOY275KNTLagf5znPokNsw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:07:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AOY275KNTLagf5znPokNsw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:07:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AOY275KNTLagf5znPokNsw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:07:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AOY275KNTLagf5znPokNsw/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 19:07:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AOY275KNTLagf5znPokNsw/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 19:07:41 INFO - Downloaded 1361 bytes. 19:07:41 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 19:07:41 INFO - Using the following test package requirements: 19:07:41 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 19:07:41 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:07:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:07:41 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:07:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:07:41 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:07:41 INFO - u'jsshell-linux-x86_64.zip'], 19:07:41 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:07:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:07:41 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 19:07:41 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:07:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:07:41 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:07:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:07:41 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:07:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:07:41 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 19:07:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:07:41 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:07: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')]} 19:07:41 INFO - https://queue.taskcluster.net/v1/task/AOY275KNTLagf5znPokNsw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:07:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AOY275KNTLagf5znPokNsw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:07:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AOY275KNTLagf5znPokNsw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:07:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AOY275KNTLagf5znPokNsw/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 19:07:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AOY275KNTLagf5znPokNsw/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 19:07:46 INFO - Downloaded 24408173 bytes. 19:07:46 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'] 19:07:46 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 19:07:47 INFO - Return code: 0 19:07:47 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 19:07:47 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')]} 19:07:47 INFO - https://queue.taskcluster.net/v1/task/AOY275KNTLagf5znPokNsw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:07:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AOY275KNTLagf5znPokNsw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:07:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AOY275KNTLagf5znPokNsw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 19:07:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AOY275KNTLagf5znPokNsw/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 19:07:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AOY275KNTLagf5znPokNsw/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 19:07:48 INFO - Downloaded 24408173 bytes. 19:07:48 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'] 19:07:48 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 19:07:49 INFO - Return code: 0 19:07:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:49 INFO - https://queue.taskcluster.net/v1/task/AOY275KNTLagf5znPokNsw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:07:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AOY275KNTLagf5znPokNsw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 19:07:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AOY275KNTLagf5znPokNsw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 19:07:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AOY275KNTLagf5znPokNsw/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 19:07:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AOY275KNTLagf5znPokNsw/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 19:07:50 INFO - Downloaded 10834034 bytes. 19:07:50 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'] 19:07:50 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 19:07:51 INFO - Return code: 0 19:07: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')]} 19:07:51 INFO - https://queue.taskcluster.net/v1/task/AOY275KNTLagf5znPokNsw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:07:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AOY275KNTLagf5znPokNsw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:07:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AOY275KNTLagf5znPokNsw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:07:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AOY275KNTLagf5znPokNsw/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 19:07:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AOY275KNTLagf5znPokNsw/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 19:07:53 INFO - Downloaded 58660152 bytes. 19:07:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AOY275KNTLagf5znPokNsw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:07:53 INFO - mkdir: /builds/slave/test/properties 19:07:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:07:53 INFO - Writing to file /builds/slave/test/properties/build_url 19:07:53 INFO - Contents: 19:07:53 INFO - build_url:https://queue.taskcluster.net/v1/task/AOY275KNTLagf5znPokNsw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 19:07:54 INFO - Running post-action listener: _resource_record_post_action 19:07:54 INFO - Running post-action listener: set_extra_try_arguments 19:07:54 INFO - ##### 19:07:54 INFO - ##### Finished download-and-extract step (success) 19:07:54 INFO - ##### 19:07:54 INFO - ##### 19:07:54 INFO - ##### Running populate-webroot step. 19:07:54 INFO - ##### 19:07:54 INFO - Running pre-action listener: _resource_record_pre_action 19:07:54 INFO - Running main action method: populate_webroot 19:07:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:07:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:07:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:07:54 INFO - '--tppagecycles', 19:07:54 INFO - '7'], 19:07:54 INFO - 'tests': ['tsvgm']}}, 19:07:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:07:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:07:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:07:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:07:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:07:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:07:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:54 INFO - 'talos_options': ['--disable-e10s'], 19:07:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:07:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:07:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:54 INFO - 'talos_options': ['--disable-e10s'], 19:07:54 INFO - 'tests': ['damp', 'tps']}, 19:07:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:54 INFO - 'tests': ['damp', 'tps']}, 19:07:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:07:54 INFO - 'tests': ['dromaeo_dom']}, 19:07:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:07:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:07:54 INFO - 'tests': ['a11yr', 19:07:54 INFO - 'ts_paint', 19:07:54 INFO - 'tpaint', 19:07:54 INFO - 'sessionrestore', 19:07:54 INFO - 'sessionrestore_no_auto_restore', 19:07:54 INFO - 'tabpaint']}, 19:07:54 INFO - 'other-e10s': {'tests': ['a11yr', 19:07:54 INFO - 'ts_paint', 19:07:54 INFO - 'tpaint', 19:07:54 INFO - 'sessionrestore', 19:07:54 INFO - 'sessionrestore_no_auto_restore', 19:07:54 INFO - 'tabpaint']}, 19:07:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:07:54 INFO - 'ts_paint', 19:07:54 INFO - 'tpaint', 19:07:54 INFO - 'sessionrestore', 19:07:54 INFO - 'sessionrestore_no_auto_restore', 19:07:54 INFO - 'tabpaint']}, 19:07:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:07:54 INFO - 'ts_paint', 19:07:54 INFO - 'tpaint', 19:07:54 INFO - 'sessionrestore', 19:07:54 INFO - 'sessionrestore_no_auto_restore', 19:07:54 INFO - 'tabpaint']}, 19:07:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:07:54 INFO - 'tests': ['a11yr', 19:07:54 INFO - 'ts_paint', 19:07:54 INFO - 'tpaint', 19:07:54 INFO - 'sessionrestore', 19:07:54 INFO - 'sessionrestore_no_auto_restore', 19:07:54 INFO - 'tabpaint']}, 19:07:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:07:54 INFO - 'tests': ['a11yr', 19:07:54 INFO - 'ts_paint', 19:07:54 INFO - 'tpaint', 19:07:54 INFO - 'sessionrestore', 19:07:54 INFO - 'sessionrestore_no_auto_restore', 19:07:54 INFO - 'tabpaint']}, 19:07:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:07:54 INFO - 'tests': ['tsvgx', 19:07:54 INFO - 'tsvgr_opacity', 19:07:54 INFO - 'tart', 19:07:54 INFO - 'tscrollx', 19:07:54 INFO - 'cart']}, 19:07:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:07:54 INFO - 'tsvgr_opacity', 19:07:54 INFO - 'tart', 19:07:54 INFO - 'tscrollx', 19:07:54 INFO - 'cart']}, 19:07:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:54 INFO - 'talos_options': ['--disable-e10s'], 19:07:54 INFO - 'tests': ['tp5o']}, 19:07:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:54 INFO - 'tests': ['tp5o']}, 19:07:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:54 INFO - 'talos_options': ['--disable-e10s', 19:07:54 INFO - '--xperf_path', 19:07:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:07:54 INFO - 'tests': ['tp5n']}, 19:07:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:54 INFO - 'talos_options': ['--xperf_path', 19:07:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:07:54 INFO - 'tests': ['tp5n']}}, 19:07:54 INFO - 'talos.zip': {'path': '', 19:07:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:07:54 INFO - Running post-action listener: _resource_record_post_action 19:07:54 INFO - ##### 19:07:54 INFO - ##### Finished populate-webroot step (success) 19:07:54 INFO - ##### 19:07:54 INFO - ##### 19:07:54 INFO - ##### Running create-virtualenv step. 19:07:54 INFO - ##### 19:07:54 INFO - Running pre-action listener: _resource_record_pre_action 19:07:54 INFO - Running main action method: create_virtualenv 19:07:54 INFO - Creating virtualenv /builds/slave/test/build/venv 19:07:54 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 19:07:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:07:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:07:54 INFO - Using real prefix '/usr' 19:07:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:07:55 INFO - Installing distribute.............................................................................................................................................................................................done. 19:07:57 INFO - Installing pip.................done. 19:07:57 INFO - Return code: 0 19:07:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:07:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a06d25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9a9c0>, '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 0x1d9b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d9bd50>, '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': 'aa08bb06ff6271ef470a76a4000001be-1464222731.922879-1876657530', '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 19:07:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:07:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:07:57 INFO - Using env: {'DISPLAY': ':0', 19:07:57 INFO - 'HOME': '/home/cltbld', 19:07:57 INFO - 'LANG': 'en_US.UTF-8', 19:07:57 INFO - 'LANGUAGE': 'en_US:en', 19:07:57 INFO - 'LOGNAME': 'cltbld', 19:07:57 INFO - 'MAIL': '/var/mail/cltbld', 19:07:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:57 INFO - 'MOZ_NO_REMOTE': '1', 19:07:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:07:57 INFO - 'NO_EM_RESTART': '1', 19:07:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:07:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:07:57 INFO - 'PWD': '/builds/slave/test', 19:07:57 INFO - 'SHELL': '/bin/bash', 19:07:57 INFO - 'SHLVL': '1', 19:07:57 INFO - 'TERM': 'linux', 19:07:57 INFO - 'TMOUT': '86400', 19:07:57 INFO - 'USER': 'cltbld', 19:07:57 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1464222731.922879-1876657530', 19:07:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:57 INFO - '_': '/tools/buildbot/bin/python'} 19:07:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:57 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 19:07:57 INFO - Cleaning up... 19:07:57 INFO - Return code: 0 19:07:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:07:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9a06d25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9a9c0>, '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 0x1d9b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d9bd50>, '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': 'aa08bb06ff6271ef470a76a4000001be-1464222731.922879-1876657530', '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 19:07:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:07:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:07:57 INFO - Using env: {'DISPLAY': ':0', 19:07:57 INFO - 'HOME': '/home/cltbld', 19:07:57 INFO - 'LANG': 'en_US.UTF-8', 19:07:57 INFO - 'LANGUAGE': 'en_US:en', 19:07:57 INFO - 'LOGNAME': 'cltbld', 19:07:57 INFO - 'MAIL': '/var/mail/cltbld', 19:07:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:57 INFO - 'MOZ_NO_REMOTE': '1', 19:07:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:07:57 INFO - 'NO_EM_RESTART': '1', 19:07:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:07:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:07:57 INFO - 'PWD': '/builds/slave/test', 19:07:57 INFO - 'SHELL': '/bin/bash', 19:07:57 INFO - 'SHLVL': '1', 19:07:57 INFO - 'TERM': 'linux', 19:07:57 INFO - 'TMOUT': '86400', 19:07:57 INFO - 'USER': 'cltbld', 19:07:57 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1464222731.922879-1876657530', 19:07:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:57 INFO - '_': '/tools/buildbot/bin/python'} 19:07:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:57 INFO - Downloading/unpacking psutil>=3.1.1 19:07:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:07:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:07:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:07:59 INFO - Installing collected packages: psutil 19:07:59 INFO - Running setup.py install for psutil 19:07:59 INFO - building 'psutil._psutil_linux' extension 19:07:59 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 19:07:59 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 19:07:59 INFO - building 'psutil._psutil_posix' extension 19:07:59 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 19:07:59 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 19:07:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:07:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:07:59 INFO - Successfully installed psutil 19:07:59 INFO - Cleaning up... 19:08:00 INFO - Return code: 0 19:08:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:08:00 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')]} 19:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:00 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')]} 19:08:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:00 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 0x7f9a06d25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9a9c0>, '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 0x1d9b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d9bd50>, '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': 'aa08bb06ff6271ef470a76a4000001be-1464222731.922879-1876657530', '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 19:08:00 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 19:08:00 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 19:08:00 INFO - Using env: {'DISPLAY': ':0', 19:08:00 INFO - 'HOME': '/home/cltbld', 19:08:00 INFO - 'LANG': 'en_US.UTF-8', 19:08:00 INFO - 'LANGUAGE': 'en_US:en', 19:08:00 INFO - 'LOGNAME': 'cltbld', 19:08:00 INFO - 'MAIL': '/var/mail/cltbld', 19:08:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:00 INFO - 'MOZ_NO_REMOTE': '1', 19:08:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:00 INFO - 'NO_EM_RESTART': '1', 19:08:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:00 INFO - 'PWD': '/builds/slave/test', 19:08:00 INFO - 'SHELL': '/bin/bash', 19:08:00 INFO - 'SHLVL': '1', 19:08:00 INFO - 'TERM': 'linux', 19:08:00 INFO - 'TMOUT': '86400', 19:08:00 INFO - 'USER': 'cltbld', 19:08:00 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1464222731.922879-1876657530', 19:08:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:00 INFO - '_': '/tools/buildbot/bin/python'} 19:08:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:08:00 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 19:08:00 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 19:08:00 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 19:08:00 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 19:08:00 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 19:08:00 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 19:08:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:08:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:08:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:08:02 INFO - Installing collected packages: mozsystemmonitor 19:08:02 INFO - Running setup.py install for mozsystemmonitor 19:08:02 INFO - Successfully installed mozsystemmonitor 19:08:02 INFO - Cleaning up... 19:08:02 INFO - Return code: 0 19:08:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:08:02 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')]} 19:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:02 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')]} 19:08:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:02 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 0x7f9a06d25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9a9c0>, '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 0x1d9b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d9bd50>, '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': 'aa08bb06ff6271ef470a76a4000001be-1464222731.922879-1876657530', '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 19:08:02 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 19:08:02 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 19:08:02 INFO - Using env: {'DISPLAY': ':0', 19:08:02 INFO - 'HOME': '/home/cltbld', 19:08:02 INFO - 'LANG': 'en_US.UTF-8', 19:08:02 INFO - 'LANGUAGE': 'en_US:en', 19:08:02 INFO - 'LOGNAME': 'cltbld', 19:08:02 INFO - 'MAIL': '/var/mail/cltbld', 19:08:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:02 INFO - 'MOZ_NO_REMOTE': '1', 19:08:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:02 INFO - 'NO_EM_RESTART': '1', 19:08:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:02 INFO - 'PWD': '/builds/slave/test', 19:08:02 INFO - 'SHELL': '/bin/bash', 19:08:02 INFO - 'SHLVL': '1', 19:08:02 INFO - 'TERM': 'linux', 19:08:02 INFO - 'TMOUT': '86400', 19:08:02 INFO - 'USER': 'cltbld', 19:08:02 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1464222731.922879-1876657530', 19:08:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:02 INFO - '_': '/tools/buildbot/bin/python'} 19:08:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:02 INFO - Downloading/unpacking blobuploader==1.2.4 19:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:04 INFO - Downloading blobuploader-1.2.4.tar.gz 19:08:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:08:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:08:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:05 INFO - Downloading docopt-0.6.1.tar.gz 19:08:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:08:05 INFO - Installing collected packages: blobuploader, requests, docopt 19:08:05 INFO - Running setup.py install for blobuploader 19:08:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:08:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:08:05 INFO - Running setup.py install for requests 19:08:05 INFO - Running setup.py install for docopt 19:08:05 INFO - Successfully installed blobuploader requests docopt 19:08:05 INFO - Cleaning up... 19:08:05 INFO - Return code: 0 19:08:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:08:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a06d25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9a9c0>, '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 0x1d9b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d9bd50>, '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': 'aa08bb06ff6271ef470a76a4000001be-1464222731.922879-1876657530', '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 19:08:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:08:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:08:05 INFO - Using env: {'DISPLAY': ':0', 19:08:05 INFO - 'HOME': '/home/cltbld', 19:08:05 INFO - 'LANG': 'en_US.UTF-8', 19:08:05 INFO - 'LANGUAGE': 'en_US:en', 19:08:05 INFO - 'LOGNAME': 'cltbld', 19:08:05 INFO - 'MAIL': '/var/mail/cltbld', 19:08:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:05 INFO - 'MOZ_NO_REMOTE': '1', 19:08:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:05 INFO - 'NO_EM_RESTART': '1', 19:08:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:05 INFO - 'PWD': '/builds/slave/test', 19:08:05 INFO - 'SHELL': '/bin/bash', 19:08:05 INFO - 'SHLVL': '1', 19:08:05 INFO - 'TERM': 'linux', 19:08:05 INFO - 'TMOUT': '86400', 19:08:05 INFO - 'USER': 'cltbld', 19:08:05 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1464222731.922879-1876657530', 19:08:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:05 INFO - '_': '/tools/buildbot/bin/python'} 19:08:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:08:06 INFO - Running setup.py (path:/tmp/pip-d9Dydx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:08:06 INFO - Running setup.py (path:/tmp/pip-vvk2ks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:08:06 INFO - Running setup.py (path:/tmp/pip-VIwoyu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:08:06 INFO - Running setup.py (path:/tmp/pip-IE8Vzv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:08:06 INFO - Running setup.py (path:/tmp/pip-rhtgUN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:08:06 INFO - Running setup.py (path:/tmp/pip-g686sf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:08:06 INFO - Running setup.py (path:/tmp/pip-9zhTH8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:08:06 INFO - Running setup.py (path:/tmp/pip-Ajons8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:08:06 INFO - Running setup.py (path:/tmp/pip-_3vPpb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:08:06 INFO - Running setup.py (path:/tmp/pip-2wR6Hv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:08:06 INFO - Running setup.py (path:/tmp/pip-qXcGSD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:08:06 INFO - Running setup.py (path:/tmp/pip-kYGrny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:08:06 INFO - Running setup.py (path:/tmp/pip-e4qP0G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:08:07 INFO - Running setup.py (path:/tmp/pip-eFxliw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:08:07 INFO - Running setup.py (path:/tmp/pip-UjlMEP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:08:07 INFO - Running setup.py (path:/tmp/pip-v4l7p7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:08:07 INFO - Running setup.py (path:/tmp/pip-7PBFUv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:08:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:08:07 INFO - Running setup.py install for manifestparser 19:08:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:08:07 INFO - Running setup.py install for mozcrash 19:08:07 INFO - Running setup.py install for mozdebug 19:08:07 INFO - Running setup.py install for mozdevice 19:08:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:08:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:08:07 INFO - Running setup.py install for mozfile 19:08:07 INFO - Running setup.py install for mozhttpd 19:08:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:08:07 INFO - Running setup.py install for mozinfo 19:08:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:08:08 INFO - Running setup.py install for mozInstall 19:08:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:08:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:08:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:08:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:08:08 INFO - Running setup.py install for mozleak 19:08:08 INFO - Running setup.py install for mozlog 19:08:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:08:08 INFO - Running setup.py install for moznetwork 19:08:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:08:08 INFO - Running setup.py install for mozprocess 19:08:08 INFO - Running setup.py install for mozprofile 19:08:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:08:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:08:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:08:08 INFO - Running setup.py install for mozrunner 19:08:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:08:08 INFO - Running setup.py install for mozscreenshot 19:08:08 INFO - Running setup.py install for moztest 19:08:08 INFO - Running setup.py install for mozversion 19:08:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:08:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:08:09 INFO - Cleaning up... 19:08:09 INFO - Return code: 0 19:08:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:08:09 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')]} 19:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:09 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')]} 19:08:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:09 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 0x7f9a06d25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9a9c0>, '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 0x1d9b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d9bd50>, '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': 'aa08bb06ff6271ef470a76a4000001be-1464222731.922879-1876657530', '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 19:08:09 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 19:08:09 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 19:08:09 INFO - Using env: {'DISPLAY': ':0', 19:08:09 INFO - 'HOME': '/home/cltbld', 19:08:09 INFO - 'LANG': 'en_US.UTF-8', 19:08:09 INFO - 'LANGUAGE': 'en_US:en', 19:08:09 INFO - 'LOGNAME': 'cltbld', 19:08:09 INFO - 'MAIL': '/var/mail/cltbld', 19:08:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:09 INFO - 'MOZ_NO_REMOTE': '1', 19:08:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:09 INFO - 'NO_EM_RESTART': '1', 19:08:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:09 INFO - 'PWD': '/builds/slave/test', 19:08:09 INFO - 'SHELL': '/bin/bash', 19:08:09 INFO - 'SHLVL': '1', 19:08:09 INFO - 'TERM': 'linux', 19:08:09 INFO - 'TMOUT': '86400', 19:08:09 INFO - 'USER': 'cltbld', 19:08:09 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1464222731.922879-1876657530', 19:08:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:09 INFO - '_': '/tools/buildbot/bin/python'} 19:08:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:08:09 INFO - Running setup.py (path:/tmp/pip-2h0YjG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:08:09 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)) 19:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:08:09 INFO - Running setup.py (path:/tmp/pip-c1AsZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:08:09 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)) 19:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:08:09 INFO - Running setup.py (path:/tmp/pip-c2x8US-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:08:09 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)) 19:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:08:09 INFO - Running setup.py (path:/tmp/pip-5vcugM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:08:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:08:09 INFO - Running setup.py (path:/tmp/pip-rhVfyD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:08:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 19:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:08:09 INFO - Running setup.py (path:/tmp/pip-OBsdRD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:08:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 19:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:08:09 INFO - Running setup.py (path:/tmp/pip-JZFVGb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:08:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 19:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:08:09 INFO - Running setup.py (path:/tmp/pip-zdTKJL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:08:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 19:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:08:09 INFO - Running setup.py (path:/tmp/pip-FV5NC1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:08:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 19:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:08:09 INFO - Running setup.py (path:/tmp/pip-4ikd8w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:08:10 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)) 19:08:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:08:10 INFO - Running setup.py (path:/tmp/pip-gLtPTd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:08:10 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)) 19:08:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:08:10 INFO - Running setup.py (path:/tmp/pip-9RJTLV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:08:10 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)) 19:08:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:08:10 INFO - Running setup.py (path:/tmp/pip-zFGZgk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:08:10 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)) 19:08:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:08:10 INFO - Running setup.py (path:/tmp/pip-i23Lib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:08:10 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)) 19:08:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:08:10 INFO - Running setup.py (path:/tmp/pip-qW0kOr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:08:10 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)) 19:08:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:08:10 INFO - Running setup.py (path:/tmp/pip-0jlKxL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:08:10 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)) 19:08:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:08:10 INFO - Running setup.py (path:/tmp/pip-W6LQ6N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:08:10 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)) 19:08:10 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)) 19:08:10 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)) 19:08:10 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)) 19:08:10 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)) 19:08:10 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)) 19:08:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:08:10 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 19:08:10 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 19:08:10 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 19:08:10 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 19:08:10 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 19:08:10 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 19:08:12 INFO - Downloading blessings-1.6.tar.gz 19:08:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:08:12 INFO - Installing collected packages: blessings 19:08:12 INFO - Running setup.py install for blessings 19:08:12 INFO - Successfully installed blessings 19:08:12 INFO - Cleaning up... 19:08:12 INFO - Return code: 0 19:08:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:08:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:08:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:08:12 INFO - Reading from file tmpfile_stdout 19:08:12 INFO - Current package versions: 19:08:12 INFO - argparse == 1.2.1 19:08:12 INFO - blessings == 1.6 19:08:12 INFO - blobuploader == 1.2.4 19:08:12 INFO - docopt == 0.6.1 19:08:12 INFO - manifestparser == 1.1 19:08:12 INFO - mozInstall == 1.12 19:08:12 INFO - mozcrash == 0.17 19:08:12 INFO - mozdebug == 0.1 19:08:12 INFO - mozdevice == 0.48 19:08:12 INFO - mozfile == 1.2 19:08:12 INFO - mozhttpd == 0.7 19:08:12 INFO - mozinfo == 0.9 19:08:12 INFO - mozleak == 0.1 19:08:12 INFO - mozlog == 3.2 19:08:12 INFO - moznetwork == 0.27 19:08:12 INFO - mozprocess == 0.22 19:08:12 INFO - mozprofile == 0.28 19:08:12 INFO - mozrunner == 6.11 19:08:12 INFO - mozscreenshot == 0.1 19:08:12 INFO - mozsystemmonitor == 0.3 19:08:12 INFO - moztest == 0.7 19:08:12 INFO - mozversion == 1.4 19:08:12 INFO - psutil == 3.1.1 19:08:12 INFO - requests == 1.2.3 19:08:12 INFO - wsgiref == 0.1.2 19:08:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:08:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a06d25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9a9c0>, '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 0x1d9b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d9bd50>, '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': 'aa08bb06ff6271ef470a76a4000001be-1464222731.922879-1876657530', '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 19:08:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 19:08:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:08:12 INFO - Using env: {'DISPLAY': ':0', 19:08:12 INFO - 'HOME': '/home/cltbld', 19:08:12 INFO - 'LANG': 'en_US.UTF-8', 19:08:12 INFO - 'LANGUAGE': 'en_US:en', 19:08:12 INFO - 'LOGNAME': 'cltbld', 19:08:12 INFO - 'MAIL': '/var/mail/cltbld', 19:08:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:12 INFO - 'MOZ_NO_REMOTE': '1', 19:08:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:12 INFO - 'NO_EM_RESTART': '1', 19:08:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:12 INFO - 'PWD': '/builds/slave/test', 19:08:12 INFO - 'SHELL': '/bin/bash', 19:08:12 INFO - 'SHLVL': '1', 19:08:12 INFO - 'TERM': 'linux', 19:08:12 INFO - 'TMOUT': '86400', 19:08:12 INFO - 'USER': 'cltbld', 19:08:12 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1464222731.922879-1876657530', 19:08:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:12 INFO - '_': '/tools/buildbot/bin/python'} 19:08:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:13 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)) 19:08:13 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)) 19:08:13 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)) 19:08:13 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)) 19:08:13 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)) 19:08:13 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)) 19:08:13 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)) 19:08:13 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)) 19:08:13 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)) 19:08:13 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)) 19:08:13 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)) 19:08:13 INFO - Cleaning up... 19:08:13 INFO - Return code: 0 19:08:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:08:13 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')]} 19:08:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:13 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')]} 19:08:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:13 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 0x7f9a06d25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9a9c0>, '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 0x1d9b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d9bd50>, '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': 'aa08bb06ff6271ef470a76a4000001be-1464222731.922879-1876657530', '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 19:08:13 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 19:08:13 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 19:08:13 INFO - Using env: {'DISPLAY': ':0', 19:08:13 INFO - 'HOME': '/home/cltbld', 19:08:13 INFO - 'LANG': 'en_US.UTF-8', 19:08:13 INFO - 'LANGUAGE': 'en_US:en', 19:08:13 INFO - 'LOGNAME': 'cltbld', 19:08:13 INFO - 'MAIL': '/var/mail/cltbld', 19:08:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:13 INFO - 'MOZ_NO_REMOTE': '1', 19:08:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:13 INFO - 'NO_EM_RESTART': '1', 19:08:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:13 INFO - 'PWD': '/builds/slave/test', 19:08:13 INFO - 'SHELL': '/bin/bash', 19:08:13 INFO - 'SHLVL': '1', 19:08:13 INFO - 'TERM': 'linux', 19:08:13 INFO - 'TMOUT': '86400', 19:08:13 INFO - 'USER': 'cltbld', 19:08:13 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1464222731.922879-1876657530', 19:08:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:13 INFO - '_': '/tools/buildbot/bin/python'} 19:08:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:13 INFO - Downloading/unpacking jsonschema 19:08:13 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 19:08:13 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 19:08:13 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 19:08:13 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 19:08:13 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 19:08:13 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 19:08:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:08:15 INFO - Downloading/unpacking functools32 (from jsonschema) 19:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:15 INFO - Downloading functools32-3.2.3-2.tar.gz 19:08:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:08:15 INFO - warning: no files found matching '*.txt' 19:08:15 INFO - no previously-included directories found matching 'build' 19:08:15 INFO - no previously-included directories found matching 'dist' 19:08:15 INFO - no previously-included directories found matching '.git*' 19:08:15 INFO - Installing collected packages: jsonschema, functools32 19:08:15 INFO - Running setup.py install for functools32 19:08:15 INFO - warning: no files found matching '*.txt' 19:08:15 INFO - no previously-included directories found matching 'build' 19:08:15 INFO - no previously-included directories found matching 'dist' 19:08:15 INFO - no previously-included directories found matching '.git*' 19:08:15 INFO - Successfully installed jsonschema functools32 19:08:15 INFO - Cleaning up... 19:08:15 INFO - Return code: 0 19:08:15 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:08:15 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')]} 19:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:15 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')]} 19:08:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:15 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 0x7f9a06d25f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c408a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d9a9c0>, '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 0x1d9b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d9bd50>, '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': 'aa08bb06ff6271ef470a76a4000001be-1464222731.922879-1876657530', '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 19:08:15 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 19:08:15 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 19:08:15 INFO - Using env: {'DISPLAY': ':0', 19:08:15 INFO - 'HOME': '/home/cltbld', 19:08:15 INFO - 'LANG': 'en_US.UTF-8', 19:08:15 INFO - 'LANGUAGE': 'en_US:en', 19:08:15 INFO - 'LOGNAME': 'cltbld', 19:08:15 INFO - 'MAIL': '/var/mail/cltbld', 19:08:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:15 INFO - 'MOZ_NO_REMOTE': '1', 19:08:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:15 INFO - 'NO_EM_RESTART': '1', 19:08:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:15 INFO - 'PWD': '/builds/slave/test', 19:08:15 INFO - 'SHELL': '/bin/bash', 19:08:15 INFO - 'SHLVL': '1', 19:08:15 INFO - 'TERM': 'linux', 19:08:15 INFO - 'TMOUT': '86400', 19:08:15 INFO - 'USER': 'cltbld', 19:08:15 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1464222731.922879-1876657530', 19:08:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:15 INFO - '_': '/tools/buildbot/bin/python'} 19:08:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:15 INFO - Downloading/unpacking flake8 19:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:08:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:08:17 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 19:08:17 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 19:08:17 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 19:08:17 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 19:08:17 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 19:08:17 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 19:08:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:08:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:08:18 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 19:08:18 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 19:08:18 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 19:08:18 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 19:08:18 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 19:08:18 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 19:08:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:08:18 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 19:08:18 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 19:08:18 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 19:08:18 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 19:08:18 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 19:08:18 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 19:08:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:08:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:08:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:08:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:08:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:08:18 INFO - no previously-included directories found matching 'docs/_build' 19:08:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:08:18 INFO - Running setup.py install for pep8 19:08:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:08:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:08:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:08:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:08:18 INFO - no previously-included directories found matching 'docs/_build' 19:08:18 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:08:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:08:18 INFO - Cleaning up... 19:08:18 INFO - Return code: 0 19:08:18 INFO - Running post-action listener: _resource_record_post_action 19:08:18 INFO - Running post-action listener: _start_resource_monitoring 19:08:18 INFO - Starting resource monitoring. 19:08:18 INFO - ##### 19:08:18 INFO - ##### Finished create-virtualenv step (success) 19:08:18 INFO - ##### 19:08:18 INFO - ##### 19:08:18 INFO - ##### Running install step. 19:08:18 INFO - ##### 19:08:18 INFO - Running pre-action listener: _resource_record_pre_action 19:08:18 INFO - Running main action method: install 19:08:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:08:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:08:19 INFO - Reading from file tmpfile_stdout 19:08:19 INFO - Detecting whether we're running mozinstall >=1.0... 19:08:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:08:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:08:19 INFO - Reading from file tmpfile_stdout 19:08:19 INFO - Output received: 19:08:19 INFO - Usage: mozinstall [options] installer 19:08:19 INFO - Options: 19:08:19 INFO - -h, --help show this help message and exit 19:08:19 INFO - -d DEST, --destination=DEST 19:08:19 INFO - Directory to install application into. [default: 19:08:19 INFO - "/builds/slave/test"] 19:08:19 INFO - --app=APP Application being installed. [default: firefox] 19:08:19 INFO - mkdir: /builds/slave/test/build/application 19:08:19 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'] 19:08:19 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 19:08:35 INFO - Reading from file tmpfile_stdout 19:08:35 INFO - Output received: 19:08:35 INFO - /builds/slave/test/build/application/firefox/firefox 19:08:35 INFO - Running post-action listener: _resource_record_post_action 19:08:35 INFO - ##### 19:08:35 INFO - ##### Finished install step (success) 19:08:35 INFO - ##### 19:08:35 INFO - ##### 19:08:35 INFO - ##### Running run-tests step. 19:08:35 INFO - ##### 19:08:35 INFO - Running pre-action listener: _resource_record_pre_action 19:08:35 INFO - Running main action method: run_tests 19:08:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:08:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:08:35 INFO - Python 2.7.3 19:08:35 INFO - Return code: 0 19:08:35 INFO - grabbing minidump binary from tooltool 19:08: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')]} 19:08:35 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 0x1d9a9c0>, '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 0x1d9b8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d9bd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:08:35 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 19:08:35 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 19:08:35 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 19:08:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:08:35 INFO - Return code: 0 19:08:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:08:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:08:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:08:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:08:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:08:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:08:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:08:36 INFO - Return code: 0 19:08:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AOY275KNTLagf5znPokNsw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 19:08:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AOY275KNTLagf5znPokNsw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --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 19:08:36 INFO - Using env: {'DISPLAY': ':0', 19:08:36 INFO - 'HOME': '/home/cltbld', 19:08:36 INFO - 'LANG': 'en_US.UTF-8', 19:08:36 INFO - 'LANGUAGE': 'en_US:en', 19:08:36 INFO - 'LOGNAME': 'cltbld', 19:08:36 INFO - 'MAIL': '/var/mail/cltbld', 19:08:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:08:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:08:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:36 INFO - 'MOZ_NO_REMOTE': '1', 19:08:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:08:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:36 INFO - 'NO_EM_RESTART': '1', 19:08:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:36 INFO - 'PWD': '/builds/slave/test', 19:08:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:08:36 INFO - 'SHELL': '/bin/bash', 19:08:36 INFO - 'SHLVL': '1', 19:08:36 INFO - 'TERM': 'linux', 19:08:36 INFO - 'TMOUT': '86400', 19:08:36 INFO - 'USER': 'cltbld', 19:08:36 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1464222731.922879-1876657530', 19:08:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:36 INFO - '_': '/tools/buildbot/bin/python'} 19:08:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AOY275KNTLagf5znPokNsw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 19:08:37 INFO - mozversion application_buildid: 20160525163027 19:08:37 INFO - mozversion application_changeset: 35574c1aa9697cb60f05ba4c9d7175d1ffc59efc 19:08:37 INFO - mozversion application_display_name: Nightly 19:08:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:08:37 INFO - mozversion application_name: Firefox 19:08:37 INFO - mozversion application_remotingname: firefox 19:08:37 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:08:37 INFO - mozversion application_vendor: Mozilla 19:08:37 INFO - mozversion application_version: 49.0a1 19:08:37 INFO - mozversion platform_buildid: 20160525163027 19:08:37 INFO - mozversion platform_changeset: 35574c1aa9697cb60f05ba4c9d7175d1ffc59efc 19:08:37 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:08:37 INFO - mozversion platform_version: 49.0a1 19:08:37 INFO - using testdate: 1464228517 19:08:37 INFO - actual date: 1464228517 19:08:37 INFO - starting webserver on 'localhost:47794' 19:08:37 INFO - SUITE-START | Running 2 tests 19:08:37 INFO - TEST-START | dromaeo_css 19:08:37 INFO - operating with platform_type : linux_ 19:08:37 INFO - Initialising browser for dromaeo_css test... 19:08:37 INFO - TEST-INFO | started process 19203 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSRb1a_/profile http://localhost:47794/getInfo.html) 19:08:41 INFO - PROCESS | 19203 | __metrics Screen width/height:1600/1200 19:08:41 INFO - PROCESS | 19203 | colorDepth:24 19:08:41 INFO - PROCESS | 19203 | Browser inner width/height: 1024/697 19:08:41 INFO - PROCESS | 19203 | __metrics 19:08:42 ERROR - PROCESS | 19203 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 19:08:43 INFO - TEST-INFO | 19203: exit 0 19:08:43 INFO - Browser initialized. 19:08:43 INFO - Running cycle 1/1 for dromaeo_css test... 19:08:43 INFO - TEST-INFO | started process 19284 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSRb1a_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:08:54 INFO - PROCESS | 19284 | RSS: Main: 154677248 19:08:54 INFO - PROCESS | 19284 | 19:09:46 INFO - PROCESS | 19284 | 1464228586016 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] 19:11:53 INFO - PROCESS | 19284 | Cycle 1(1): loaded http://localhost:47794/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47794/tests/dromaeo/cssquery-ext.html) 19:11:54 INFO - PROCESS | 19284 | RSS: Main: 246214656 19:11:54 INFO - PROCESS | 19284 | 19:14:57 INFO - PROCESS | 19284 | Cycle 1(1): loaded http://localhost:47794/tests/dromaeo/cssquery-ext.html (next: http://localhost:47794/tests/dromaeo/cssquery-jquery.html) 19:14:58 INFO - PROCESS | 19284 | RSS: Main: 243830784 19:14:58 INFO - PROCESS | 19284 | 19:17:59 INFO - PROCESS | 19284 | Cycle 1(1): loaded http://localhost:47794/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47794/tests/dromaeo/cssquery-mootools.html) 19:18:00 INFO - PROCESS | 19284 | RSS: Main: 243359744 19:18:00 INFO - PROCESS | 19284 | 19:21:02 INFO - PROCESS | 19284 | Cycle 1(1): loaded http://localhost:47794/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47794/tests/dromaeo/cssquery-prototype.html) 19:21:03 INFO - PROCESS | 19284 | RSS: Main: 242683904 19:21:03 INFO - PROCESS | 19284 | 19:24:05 INFO - PROCESS | 19284 | Cycle 1(1): loaded http://localhost:47794/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47794/tests/dromaeo/cssquery-yui.html) 19:24:06 INFO - PROCESS | 19284 | RSS: Main: 229646336 19:24:06 INFO - PROCESS | 19284 | 19:27:09 INFO - PROCESS | 19284 | Cycle 1(1): loaded http://localhost:47794/tests/dromaeo/cssquery-yui.html (next: http://localhost:47794/tests/dromaeo/cssquery-dojo.html) 19:27:09 INFO - PROCESS | 19284 | RSS: Main: 286822400 19:27:09 INFO - PROCESS | 19284 | 19:27:09 INFO - PROCESS | 19284 | __start_tp_report 19:27:09 INFO - PROCESS | 19284 | _x_x_mozilla_page_load 19:27:09 INFO - PROCESS | 19284 | _x_x_mozilla_page_load_details 19:27:09 INFO - PROCESS | 19284 | |i|pagename|runs| 19:27:09 INFO - PROCESS | 19284 | |0;dojo.html;3104.7516198704107;3114.00351887396;3143.1670607289066;3148.4332820092372;3172.8096314221148;5304.257403963448;5342.626016178869;5374.274472946151;5470.4256053114395;5505.862353441161;5358.839234822952;5398.6220964532495;5431.185322201672;5436.456354364562;5499.395066542677;4782.66521343507;4866.07544566533;4870.6103511718975;4881.780319885596;5055.949440505585;4924.704517728947;5003.449620541755;5024.371953505812;5032.4212715537815;5036.194208926572;4764.785584648699;4846.927296090579;4864.781084851154;4891.315215869781;4928.654994150411;4856.927146092811;4873.171560834667;4874.195757699975;4935.35840340757;4981.352424184869;4913.852584422473;4925.7783399747095;4927.704337739747;4930.408350997867;4936.7531623419045;5226.320578324831;5229.137192363255;5317.042932272189;5335;5377.193420986844;5792.594518383715;5805.82582522525;5814.563907706896;5815.88368232633;5826.126081087828;5605.215269862222;5833.7958171464215;5847.064469684872;5847.7953271635715;5852.67810270435;5346.03771321162;5396.730163491809;5408.567314614861;5468.808591699271;5488.451154884479;5973.163757074013;5991.910121348184;5995.970020149958;6002.4897883679505;6015.037593984942;5498.725063746797;5623.437656234426;5746.913796293059;5759.798407055817;5763.740631671585;5767.279090113736;5800.564957628195;5816.47651711348;5819.505342045889;5873.353931067579;5732.885342293131;5770.740316685759;5779.624324418899;5786.623869448473;5786.913196302059;5643.068893632505;5650.632708873993;5705.172749951317;5777.162311464814;5791.62354446968;4355.3684715716045;4365.039691267916;4366.017646029618;4399.252127138394;4405.889852753707;3874.050857539921;3894.883153505399;3903.0632648164237;3919.529656441245;3925.8822235332987;5357.303550538405;5399.082156033405;5400.21696853954;5413.404525502192;5480.287562616914;5772.884542309131;5796.739146738407;5798.304203495608;5826.009578371687;5853.180554722342;5453.15476101205;5454.072807622713;5455.236266922634;5460.126379779216;5464.371597266286;4824.975875120672;4959.479254678206;4963;5022.547970682656;5024.648274620815;6076.969615151896;6079.300880398722;6081.361457046946;6083.7870674526175;6089.208402907594;5872.383399743051;5892.558058145571;5896.852578685567;5901.586888917906;5902.291724992857;5857.648541087548;6003.279606447254;6046.939530604637;6054.606450580698;6081.726322315418;5726.341470730919;5760.308762948473;5764.855878603068;5770.422957704196;5775.5090817281;5648.096304591246;5866.853328666817;5878.2064421302575;5891;5898.20374249488;5603.831885043455;5647.1529270609735;5670.404607516316;5678.943210568007;5711.971440142773;5601.551875849841;5629.6903670298525;5633.746481408429;5638.520725738358;5647.0964645656495;5432.837014889559;5576.693281869536;5588.022096133242;5588.497035266845;5593.356763972195;5667;5707.914381284367;5730;5808.593398462067;5809.477147056785;5585.748641311232;5622.971885140548;5629.6903670298525;5631.1271752878365;5675.432456754292 19:27:09 INFO - PROCESS | 19284 | |1;ext.html;627.7206643043844;640.2349192714707;644.7936660268713;647.6437959122485;661.3783043938697;42722.572774272245;45171.77414112929;45416;49068.75465622676;49089;43836.780816095874;44457.11085778291;44507;44523;44559.331610025794;8576.95711521443;8741.475511469333;8749.781255468632;8753.474791512497;8756.080611535792;8577.957110214471;8667.566621668922;8676.913230867705;8679.262262707678;8681.913180868205;8751.299896008335;8753.868691969594;8803.559822008874;8804.779880503007;8808.075152109033;8743.213110820025;8745.300375969908;8762.299016078698;8798.51608161551;8802.427842190236;8671.4363566368;8817.559122043873;8820.823583528358;8823.205911467998;8827.249683776887;40953.59046409527;41355;41422;41449.79275103635;41472.585274147474;3406.352792969353;3559.2881423715103;3596.1189508570305;4008.498937632796;4172.457580514544;31976.360472790413;32033.199170020704;32301.51547726786;32813.01560953151;33040.83479582611;4238.590329468575;4316.805743741539;4400.207962566737;4410.558944105596;4479.059397526524;202072;206598;206823;206943;207324;57836.42163578395;58261.70869145627;58408.4159158403;58426;58436.41563584395;56433.7178314114;62259.44351391251;63857;64016.35983640104;68480.31519684839;15323.157226352434;15414.922925385301;15483.148426836633;15488;15497.07017578949;11597.826032609517;11694.2983420995;11694.70763230909;11709.238899471507;11713.062954963583;16440.917795411187;18054.201598752214;18314.542136446697;18369.54076148107;18686.71969920452;6579.868402631921;6612.338766123349;6685.662867426534;6778.288279730656;6918.446524278146;999.6801023672355;1035.5236591167995;1062.7608788022787;1179.3087635700203;1198.2271434924426;33390;33427.665723342456;33567.49648755271;33715.662843371254;34319.656803431644;1119.4794420594462;1124.1344164992909;1150.9079273658087;1161.5005547614437;1208.812634041725;17768.55578610545;17779;17784.911075444797;17787.911060444614;17802;468307;470860;471527;471963;472841;60171;60223;60335;60375.69812150999;60481;1251.7559075980278;1346.8922486201081;1371.5885234429832;1375.3329635126956;1383.3152589468077;32948.83525582357;34041.48937765886;34241.48637770485;34267.31465370728;34509.13727156841;50917.490825092755;51533.227001594256;51553.742231288605;51559;51581.22628160506;295132;301252.9874701225;301494;301693;303073;35746.28507429785;45780.77109614431;46439;47611.28583071187;51386.74306628443;46205;46455.07089858252;46748;51357;52480.21279680884;30026.84986575053;30201.244968875955;30443.2389190272;30668.38663226678;30693.316801983903;42991.57008429876;43130.56869431266;43199.56800432081;43524.12951741011;44317.55682443134;42332.36501452419;42780.358294626225;43362.78318608387;43554.56445435632;43665;34813.477797832544;38153;38188.61811381962;39018.414723778595;39185.608143918194;28975.13093579757;29097.85451072731;29338.11985640434;29463.410731784814;29570.704292957656 19:27:09 INFO - PROCESS | 19284 | |2;jquery.html;374.60292090384195;375.94548790425387;386.7756701113354;398.3864848133874;399.34507407851146;18383.908080459594;20012.399628011146;20754.481137971557;20762.89618551905;20781;18538.907305463454;18703.90648046758;19333.130009149587;19353.806461935375;19474.31839885601;5199.792008319662;5507.311586051744;5508.3114610673665;5664.461876121762;5694.402087780785;5518.172274158868;5531.778728850841;5537.307836520435;5556.555475561945;5558.944410555883;5488.396276409591;5527.55779537636;5531.419200983899;5585.078462053756;5590.972045139769;5447.1829225616075;5514.117741161435;5515.7242137893345;5535.280413546254;5575.1358539426255;5207.765650545697;5384.6499977501335;5407.053765591006;5411.2965314508865;5414.756335964891;12789;12900.161489503153;12910.806337904938;12953.028522860728;12988.155769874928;2134.562414704997;2158.3740715192575;2255.1994042114975;2308.746037935826;2835.39039106591;9572.61709531625;9629.90370096297;9651.179649729782;10016.949915250378;10071.5467803949;1880.9905950470297;1900.572371216479;1926.4605910345126;1961.548843765942;1989.3932350633052;67392.32607673909;71306.28693713048;81186.59406702929;81593;82450.58774706148;10552.47237638115;10561.524731387106;10731.40977246259;10751.247412681194;10824.242303038869;14428.567142985727;14466.927665361605;14486.420543178365;14501.274936253145;14519.419223231163;7883.36933045355;8142.389320800964;8160.4287699861625;8270.793230169294;8309.37679674027;7903.841923161504;8035.55804430762;8052.194780521901;8092.150324215872;8131.634076466573;4513.593776560126;4521.59305662492;4559.703619264737;4559.817607295671;4606.884827879263;1814.5936898903456;1941.5922656242346;1948.1330807790398;1990.701394790793;2019.1620477501965;932.5756780664781;975.4634950777045;992.8808542974889;1060.6552870317178;1120.0703416164727;18755.249790008245;19596.726212796122;19631.411057668294;19683.901580492005;20015.799842001685;979.6228452045871;994.4480813148627;1034.110664828247;1048.9580416783242;1064.1912146768511;10557.208209384327;11070.889291106985;11124.49939752713;11145.609903653332;11166.776664466828;459826;469927;470292;476932;484028;87557.56221218852;88477;89262;89889;90780;947.9194268487256;964.99035009649;976.2092704909046;993.7515621094726;1003.8717918013857;17281.481555553353;17473.12634368302;17570.472885813448;17624.823751762317;17801.109944502983;37982.240355193295;38142;39185.21629567336;40894;42601.36097958471;58357.416425835196;58377.708111460866;59593.10610340935;59785.40214597798;60257.39742602693;8295.95852020736;8332.083470818327;8441.83116337682;8445.535495547803;8707.695230666895;12420.192687475284;13063.009103977258;13408.798868017182;13418.463261469431;13443;11399.772004559696;11848.111391645489;12002.879971200176;12035.518579257083;12041.45813438415;11087.833682494607;11171.888281117084;11223.60717374888;11317.71705707364;11561.826572601585;11613.593524226611;11621.360825154698;12005.159638825548;12039.939800300943;12303.56937507183;8120.75637730869;8133.918660813553;8322.50064996102;8500.31997440191;8672.696455624275;10091.344062635904;11794.705132371759;11935.940320298343;12024.278543287432;12269.631911042683 19:27:09 INFO - PROCESS | 19284 | |3;mootools.html;1313.3498918035561;1436.964075898102;1479.0016738701377;1613.2175894691072;1807.764990551229;8080.272775450208;8319.792005199866;8337.041240257364;8593.613287402066;8598.656053757857;8397.748067557983;8556.101609331025;8562.571871406435;8563.314934805216;8583.227509524142;1956.2859556261933;2011.0347033423966;2212.203606701586;2259.491614386758;2283.303592404316;2277.703898493202;2297.1959814065112;2299.1148407862925;2300.654901764732;2304.158981971577;2207.348832094536;2226.599212141822;2228.955420891581;2230;2230.9107635694554;1855.8422534084552;2134.9573008539896;2159.2010955946243;2183.377737344865;2187.3109970359446;2232.7767223277706;2235.1394713035434;2246.4720790614356;2256.605094108541;2258.4692597239637;8477.915220847835;8530.70142545008;8532.14678532148;8538.87191692125;8540.274076703488;5008.499150084999;5113.69317840927;5148.124818780779;5151.021305951857;5157.7936882524655;3152.274976755336;3166.0976621662944;3224.0650211438656;3272.4764037753844;3321.601407831076;987.4766373821886;1016.4120654090997;1017.7710015246511;1024.0783295034455;1042.135027926819;11215.102791776639;11561.421928903605;11570.826437603442;11903.523859045628;11924.284542927453;4178.12259425518;4181.393697913846;4237.322028475429;4246.8725938221905;4279.251131052116;9449.196818270386;9464.1009104135;9467.621295148117;9472.052794720474;9478.194353479894;4924.704517728947;4945.455999840015;4981.12830254704;4983.227599722049;4983.800647974041;3995.081131339808;4610.585047345688;4657.417822772153;4702.224133018082;4742.359781429532;3634.400323946519;3650.105724097613;3725.8695945642316;3735.14091758897;3803.676687481595;1101.8126918423727;1118.4463690473267;1120.383788916093;1134.5064896769932;1150.5052827284348;933.3186773655269;942.5417773929353;1015.294370412571;1031.242037102729;1033.26121822897;5964.7912323068485;6026.879462410815;6146.108814221912;6161.383861613893;6201.875962480725;408.5812042656301;410.9034376921481;411.9114390406077;412.0337807840609;412.83486605357496;4147.730397524151;4271.337942618899;4309.978450107729;4344.9348259776125;4399.934000989988;10308.226882983807;10582.629607963685;10660.94669526663;10679.62621308266;10703.571857125784;10524.263301568817;10608.098311643442;10629.149668026539;10634.893651063545;10649.520771565298;7632.236776322435;7971.641276142472;8025.117237103914;8096.473729207582;8119.959400203079;6097.115918191748;6208.4722798562625;6255.687215639109;6333.20834895638;6419.646919419477;9920.900790992286;9960.701178964642;10118.392896426238;10137.797244055226;10140.645077422254;10074.798504029732;10219.065659720913;10267.794644107225;10289.588416463257;10320.071193592612;7070.292970702889;7263.455240857063;7415.740449084256;7688.308052275322;7866.213378662317;8485.703000394957;8491.532965686947;8512.574371281535;8541.402101853058;8559.400841941004;7512.248775122444;7648.196939321291;7692.9615351922885;7699.846003079795;7782.299593036654;7484.326410622853;7501.962490187514;7574.242575742382;7673.424493162924;7740.3420709240345;7060.858782824212;7063.258357872555;7079.292070793085;7095.290470952863;7157.892631610634;5219.19102539107;5266;5311.442298558596;5437.238786569963;5465.945340546544;5250.396204436539;5329.920051199158;5393.325834270716;5457.754401051883;5532.059549876451 19:27:09 INFO - PROCESS | 19284 | |4;prototype.html;291.84823891576383;303.16931607395736;305.7538681361506;307;312.57801967344074;5254.500822421868;5275.472452754728;5288.365396152467;5321.361436627601;5326.2543243945875;4994.250862370646;5036.960031187375;5208.244804503344;5236.554892834104;5274.4461831507615;4006.859759908389;4063.2889244382263;4077.3476243800997;4091.3658382950616;4108.239975604522;4070.3283958147017;4080.8979775505554;4097.303458412077;4099.651529619986;4114.485689288839;3809.2381523695235;3865.188310454808;3958.4656071430277;4016.5180178378637;4092.283850326196;4035.950652830256;4050.9594904050878;4078.286299897521;4081.285774989365;4089.7137200395982;3536.328097661436;3558.323918455511;3561.5726112866364;3577.8032208228537;3577.8354095771942;4845.927311090337;5041.798328066873;5076.334924164806;5094.1594636884865;5117.795288188468;4558.361829343895;4592.586667199935;4594.954050459486;4596.069650746695;4633.4439867215815;5528.226048353234;5530.225768392428;5531.944680553183;5553.861153471195;5573.247611572427;3578.928421431583;3768.5100936878302;3772.6793222576116;3841.058940559553;3847.903802404934;5648.54811615074;5650.231386620568;5658.151277308396;5703.65778053314;5723.656580605136;3900.570937196906;3912.7847968361443;3924.50943632046;3933.62630550103;3947.8420863165725;3859.7491163074874;3909.7879657306325;3972.2651309507833;3973.960260397359;3989.2221016901426;4532;4543.636509079266;4545.613622842029;4550.431196100488;4552.704074235164;5491.780328786884;5505.697186654692;5513.669179849222;5530.198121272393;5537.815755940351;1251.0867067040929;1270.574357590199;1332.6135420728074;1352.2157148853642;1359.1437394441637;836.602613758472;852.1180578101635;858.047567200407;858.772425307294;866.7908267966152;4746.715197088186;4767.332573439721;4842.539958703917;4850.296706977469;4881.341018962395;5121.155009423478;5121.257417674491;5132.538071573502;5141.948580514147;5157.329547158845;4642.469853929549;4832.371791667131;4854.781534830941;4868.71170549841;4901.387326584177;2666.5733482643072;2667.933301667435;2673.31830383251;2694.811363204557;2723.5506141486435;5181.481851814864;5209.895802083937;5214.817481388133;5245.527902488794;5246.239295302236;4927.384076990376;5074.391073071255;5089.287499750038;5096.51583099605;5128.897422051613;4982.551570358685;5125.794968201305;5219.686818790885;5240.589328908669;5279.656822306538;4887.437944636412;5057.342545469065;5098;5119.029173768052;5132.692038477703;5035.194368900959;5039.052154489518;5046;5048.596112310933;5057.7724002419245;5183.989122121301;5199.948000519947;5212.374515058217;5216.634835561475;5230.476952304739;3527.8236088194976;3572.7141828653125;3589.3898037333192;3604.8197590120913;3620.2216523447587;4674.088552732321;4973.751312434436;5372.516473517246;5570.749316280858;5629;5523.696196709219;5533.253010843646;5545.528630066489;5545.667259964415;5585.385607583244;5556.16657501378;5560.91658625129;5567.972160139173;5570.2201691762375;5570.721463926707;5218.347706536683;5495.587830912617;5497.615166938276;5500.972495137498;5506.807261745819;5552.7778888843995;5557.72211389437;5611.747471363717;5630.943690563042;5654.717264136859;5225.608079393985;5468.890622187613;5515;5526.198701188225;5536.7819079802375 19:27:09 INFO - PROCESS | 19284 | |5;yui.html;844.8352571248607;851.9616617252223;868.2836659755699;873.8907636545432;886.7251152142832;16144.83855161448;16607.66784664306;16615.584610384747;16617.501474955756;16630.41793537225;15830.208489575532;15940.362385504566;15962.201889905487;15997.520074397758;15999.440019599317;803.7428023032631;817.2522142239843;817.497239197892;817.8159914019358;818.443458448255;679.2053297641771;797.314309693663;817.5666896544841;818.0265484073963;823.3948048184579;856.1780690537092;856.8757530158123;859.2696208223023;859.8968123825118;859.9140085991382;704.6723273677765;853.8335024670192;854.3080105114815;854.6709516836;856.0113069404847;608.0605464557269;617.0589850478012;618.4619381138439;624.4692011789988;625.6121204852975;13788.448462061506;13838.723225535534;13839;13863.653408664763;13866.653333666638;13188.340582970908;13583.592492225249;13638.659707021321;13662.248576328298;13766.793498097537;11093.282145874313;11369.31784092957;11524.827127593093;11677.182597218198;11719.824202636968;4365.2142614329405;4376.956230437719;4381.9342709859375;4507.03098833749;4600.240960241556;62605;63624.045639315445;63722.044169337496;63847.6807615959;64024.35975640231;10660.680179594625;10800;10837.458127093614;11198.720031999264;11211.271267367594;18686.53283667919;18691.626167476574;18707.251709931723;18718.15768290403;18766.624667506847;8098.878516822252;8148.51108933454;8150.75547733569;8264.21489958453;8387.412881098386;4562.5665561771575;4589.242774942164;4671.85984420468;4701.506341834127;4731.503192164842;3405.9829700851337;3409.437442821956;3507.9298414032087;3521.683048525645;3577.105723569108;663.134609334813;673.9427148692416;686.3102581905154;686.993130068693;695.3741632530763;666.6000399760202;708.7625645408742;725.9310365515267;730.4521608793405;739.8483310921248;8804.141484098194;9045.412048216976;9105.362624616346;9323.860142097874;9349.107138424582;569.6126633888995;614.3549273263056;627.7426255235423;674.2684187656349;723.735836419703;4421.7789110544345;4449.665100469911;4457.375967364572;4511.481179664315;4517.376056113469;62970.685146573975;75521.6223918877;77347.22652773513;77546;77570.6121469389;63533;64395.03407448892;64557;64614;64890;59268.11097833536;59838;59925.400745992854;60051.39948600545;60440.697796510736;9174.202760590364;9337.486438245962;9357.85963210566;9382.296327775308;9557.808843822946;38549.61450385572;38598.17235373122;38923;38997.6100238994;39947.40078898761;47350.28974565453;49987.250191246436;50335.496645034546;50526.494735053646;51880.221796672326;12016.098792590765;12159.45282462309;12308.323042232763;12622.621321360373;12989.4154763034;13988.790168147283;14320;14419.927900360432;14638.707225855636;15151.090934543521;12354.382280886099;12645.178063425848;12804.61586152417;12988.935055324662;13005.479780808662;13680.179189248676;14058.297085145497;14061.578152655436;14075.507357242448;14080.507182248572;11861.703457413634;12367.505299788269;12513.749725005631;12770.2337859725;12782.936085319514;9928.900710992797;10046.799064018825;10315.742106447398;10413.114885234538;10538.420386878795;10260.692179234635;10436.165106791286;10541.20940929418;10616.681499555025;10622.84065738999 19:27:09 INFO - PROCESS | 19284 | __end_tp_report 19:27:09 INFO - PROCESS | 19284 | __start_cc_report 19:27:09 INFO - PROCESS | 19284 | _x_x_mozilla_cycle_collect,871 19:27:09 INFO - PROCESS | 19284 | __end_cc_report 19:27:09 INFO - PROCESS | 19284 | __startTimestamp1464229629987__endTimestamp 19:27:09 INFO - PROCESS | 19284 | 19:27:09 INFO - PROCESS | 19284 | ------- Summary: start ------- 19:27:09 INFO - PROCESS | 19284 | Number of tests: 6 19:27:09 INFO - PROCESS | 19284 | 19:27:09 INFO - PROCESS | 19284 | [#0] dojo.html Cycles:165 Average:5380.86 Median:5601.55 stddev:627.67 (11.2%) stddev-sans-first:603.66 19:27:09 INFO - PROCESS | 19284 | Values: 3104.8 3114.0 3143.2 3148.4 3172.8 5304.3 5342.6 5374.3 5470.4 5505.9 5358.8 5398.6 5431.2 5436.5 5499.4 4782.7 4866.1 4870.6 4881.8 5055.9 4924.7 5003.4 5024.4 5032.4 5036.2 4764.8 4846.9 4864.8 4891.3 4928.7 4856.9 4873.2 4874.2 4935.4 4981.4 4913.9 4925.8 4927.7 4930.4 4936.8 5226.3 5229.1 5317.0 5335.0 5377.2 5792.6 5805.8 5814.6 5815.9 5826.1 5605.2 5833.8 5847.1 5847.8 5852.7 5346.0 5396.7 5408.6 5468.8 5488.5 5973.2 5991.9 5996.0 6002.5 6015.0 5498.7 5623.4 5746.9 5759.8 5763.7 5767.3 5800.6 5816.5 5819.5 5873.4 5732.9 5770.7 5779.6 5786.6 5786.9 5643.1 5650.6 5705.2 5777.2 5791.6 4355.4 4365.0 4366.0 4399.3 4405.9 3874.1 3894.9 3903.1 3919.5 3925.9 5357.3 5399.1 5400.2 5413.4 5480.3 5772.9 5796.7 5798.3 5826.0 5853.2 5453.2 5454.1 5455.2 5460.1 5464.4 4825.0 4959.5 4963.0 5022.5 5024.6 6077.0 6079.3 6081.4 6083.8 6089.2 5872.4 5892.6 5896.9 5901.6 5902.3 5857.6 6003.3 6046.9 6054.6 6081.7 5726.3 5760.3 5764.9 5770.4 5775.5 5648.1 5866.9 5878.2 5891.0 5898.2 5603.8 5647.2 5670.4 5678.9 5712.0 5601.6 5629.7 5633.7 5638.5 5647.1 5432.8 5576.7 5588.0 5588.5 5593.4 5667.0 5707.9 5730.0 5808.6 5809.5 5585.7 5623.0 5629.7 5631.1 5675.4 19:27:09 INFO - PROCESS | 19284 | 19:27:09 INFO - PROCESS | 19284 | [#1] ext.html Cycles:180 Average:51293.91 Median:23723.69 stddev:90884.47 (383.1%) stddev-sans-first:91059.81 19:27:09 INFO - PROCESS | 19284 | Values: 627.7 640.2 644.8 647.6 661.4 42722.6 45171.8 45416.0 49068.8 49089.0 43836.8 44457.1 44507.0 44523.0 44559.3 8577.0 8741.5 8749.8 8753.5 8756.1 8578.0 8667.6 8676.9 8679.3 8681.9 8751.3 8753.9 8803.6 8804.8 8808.1 8743.2 8745.3 8762.3 8798.5 8802.4 8671.4 8817.6 8820.8 8823.2 8827.2 40953.6 41355.0 41422.0 41449.8 41472.6 3406.4 3559.3 3596.1 4008.5 4172.5 31976.4 32033.2 32301.5 32813.0 33040.8 4238.6 4316.8 4400.2 4410.6 4479.1 202072.0 206598.0 206823.0 206943.0 207324.0 57836.4 58261.7 58408.4 58426.0 58436.4 56433.7 62259.4 63857.0 64016.4 68480.3 15323.2 15414.9 15483.1 15488.0 15497.1 11597.8 11694.3 11694.7 11709.2 11713.1 16440.9 18054.2 18314.5 18369.5 18686.7 6579.9 6612.3 6685.7 6778.3 6918.4 999.7 1035.5 1062.8 1179.3 1198.2 33390.0 33427.7 33567.5 33715.7 34319.7 1119.5 1124.1 1150.9 1161.5 1208.8 17768.6 17779.0 17784.9 17787.9 17802.0 468307.0 470860.0 471527.0 471963.0 472841.0 60171.0 60223.0 60335.0 60375.7 60481.0 1251.8 1346.9 1371.6 1375.3 1383.3 32948.8 34041.5 34241.5 34267.3 34509.1 50917.5 51533.2 51553.7 51559.0 51581.2 295132.0 301253.0 301494.0 301693.0 303073.0 35746.3 45780.8 46439.0 47611.3 51386.7 46205.0 46455.1 46748.0 51357.0 52480.2 30026.8 30201.2 30443.2 30668.4 30693.3 42991.6 43130.6 43199.6 43524.1 44317.6 42332.4 42780.4 43362.8 43554.6 43665.0 34813.5 38153.0 38188.6 39018.4 39185.6 28975.1 29097.9 29338.1 29463.4 29570.7 19:27:10 INFO - PROCESS | 19284 | 19:27:10 INFO - PROCESS | 19284 | [#2] jquery.html Cycles:180 Average:27968.58 Median:38062.12 stddev:77893.84 (204.6%) stddev-sans-first:78084.79 19:27:10 INFO - PROCESS | 19284 | Values: 374.6 375.9 386.8 398.4 399.3 18383.9 20012.4 20754.5 20762.9 20781.0 18538.9 18703.9 19333.1 19353.8 19474.3 5199.8 5507.3 5508.3 5664.5 5694.4 5518.2 5531.8 5537.3 5556.6 5558.9 5488.4 5527.6 5531.4 5585.1 5591.0 5447.2 5514.1 5515.7 5535.3 5575.1 5207.8 5384.6 5407.1 5411.3 5414.8 12789.0 12900.2 12910.8 12953.0 12988.2 2134.6 2158.4 2255.2 2308.7 2835.4 9572.6 9629.9 9651.2 10016.9 10071.5 1881.0 1900.6 1926.5 1961.5 1989.4 67392.3 71306.3 81186.6 81593.0 82450.6 10552.5 10561.5 10731.4 10751.2 10824.2 14428.6 14466.9 14486.4 14501.3 14519.4 7883.4 8142.4 8160.4 8270.8 8309.4 7903.8 8035.6 8052.2 8092.2 8131.6 4513.6 4521.6 4559.7 4559.8 4606.9 1814.6 1941.6 1948.1 1990.7 2019.2 932.6 975.5 992.9 1060.7 1120.1 18755.2 19596.7 19631.4 19683.9 20015.8 979.6 994.4 1034.1 1049.0 1064.2 10557.2 11070.9 11124.5 11145.6 11166.8 459826.0 469927.0 470292.0 476932.0 484028.0 87557.6 88477.0 89262.0 89889.0 90780.0 947.9 965.0 976.2 993.8 1003.9 17281.5 17473.1 17570.5 17624.8 17801.1 37982.2 38142.0 39185.2 40894.0 42601.4 58357.4 58377.7 59593.1 59785.4 60257.4 8296.0 8332.1 8441.8 8445.5 8707.7 12420.2 13063.0 13408.8 13418.5 13443.0 11399.8 11848.1 12002.9 12035.5 12041.5 11087.8 11171.9 11223.6 11317.7 11561.8 11613.6 11621.4 12005.2 12039.9 12303.6 8120.8 8133.9 8322.5 8500.3 8672.7 10091.3 11794.7 11935.9 12024.3 12269.6 19:27:10 INFO - PROCESS | 19284 | 19:27:10 INFO - PROCESS | 19284 | [#3] mootools.html Cycles:180 Average:5655.40 Median:4505.26 stddev:3235.82 (71.8%) stddev-sans-first:3228.44 19:27:10 INFO - PROCESS | 19284 | Values: 1313.3 1437.0 1479.0 1613.2 1807.8 8080.3 8319.8 8337.0 8593.6 8598.7 8397.7 8556.1 8562.6 8563.3 8583.2 1956.3 2011.0 2212.2 2259.5 2283.3 2277.7 2297.2 2299.1 2300.7 2304.2 2207.3 2226.6 2229.0 2230.0 2230.9 1855.8 2135.0 2159.2 2183.4 2187.3 2232.8 2235.1 2246.5 2256.6 2258.5 8477.9 8530.7 8532.1 8538.9 8540.3 5008.5 5113.7 5148.1 5151.0 5157.8 3152.3 3166.1 3224.1 3272.5 3321.6 987.5 1016.4 1017.8 1024.1 1042.1 11215.1 11561.4 11570.8 11903.5 11924.3 4178.1 4181.4 4237.3 4246.9 4279.3 9449.2 9464.1 9467.6 9472.1 9478.2 4924.7 4945.5 4981.1 4983.2 4983.8 3995.1 4610.6 4657.4 4702.2 4742.4 3634.4 3650.1 3725.9 3735.1 3803.7 1101.8 1118.4 1120.4 1134.5 1150.5 933.3 942.5 1015.3 1031.2 1033.3 5964.8 6026.9 6146.1 6161.4 6201.9 408.6 410.9 411.9 412.0 412.8 4147.7 4271.3 4310.0 4344.9 4399.9 10308.2 10582.6 10660.9 10679.6 10703.6 10524.3 10608.1 10629.1 10634.9 10649.5 7632.2 7971.6 8025.1 8096.5 8120.0 6097.1 6208.5 6255.7 6333.2 6419.6 9920.9 9960.7 10118.4 10137.8 10140.6 10074.8 10219.1 10267.8 10289.6 10320.1 7070.3 7263.5 7415.7 7688.3 7866.2 8485.7 8491.5 8512.6 8541.4 8559.4 7512.2 7648.2 7693.0 7699.8 7782.3 7484.3 7502.0 7574.2 7673.4 7740.3 7060.9 7063.3 7079.3 7095.3 7157.9 5219.2 5266.0 5311.4 5437.2 5465.9 5250.4 5329.9 5393.3 5457.8 5532.1 19:27:10 INFO - PROCESS | 19284 | 19:27:10 INFO - PROCESS | 19284 | [#4] prototype.html Cycles:180 Average:4440.41 Median:5043.90 stddev:1314.70 (26.1%) stddev-sans-first:1280.98 19:27:10 INFO - PROCESS | 19284 | Values: 291.8 303.2 305.8 307.0 312.6 5254.5 5275.5 5288.4 5321.4 5326.3 4994.3 5037.0 5208.2 5236.6 5274.4 4006.9 4063.3 4077.3 4091.4 4108.2 4070.3 4080.9 4097.3 4099.7 4114.5 3809.2 3865.2 3958.5 4016.5 4092.3 4036.0 4051.0 4078.3 4081.3 4089.7 3536.3 3558.3 3561.6 3577.8 3577.8 4845.9 5041.8 5076.3 5094.2 5117.8 4558.4 4592.6 4595.0 4596.1 4633.4 5528.2 5530.2 5531.9 5553.9 5573.2 3578.9 3768.5 3772.7 3841.1 3847.9 5648.5 5650.2 5658.2 5703.7 5723.7 3900.6 3912.8 3924.5 3933.6 3947.8 3859.7 3909.8 3972.3 3974.0 3989.2 4532.0 4543.6 4545.6 4550.4 4552.7 5491.8 5505.7 5513.7 5530.2 5537.8 1251.1 1270.6 1332.6 1352.2 1359.1 836.6 852.1 858.0 858.8 866.8 4746.7 4767.3 4842.5 4850.3 4881.3 5121.2 5121.3 5132.5 5141.9 5157.3 4642.5 4832.4 4854.8 4868.7 4901.4 2666.6 2667.9 2673.3 2694.8 2723.6 5181.5 5209.9 5214.8 5245.5 5246.2 4927.4 5074.4 5089.3 5096.5 5128.9 4982.6 5125.8 5219.7 5240.6 5279.7 4887.4 5057.3 5098.0 5119.0 5132.7 5035.2 5039.1 5046.0 5048.6 5057.8 5184.0 5199.9 5212.4 5216.6 5230.5 3527.8 3572.7 3589.4 3604.8 3620.2 4674.1 4973.8 5372.5 5570.7 5629.0 5523.7 5533.3 5545.5 5545.7 5585.4 5556.2 5560.9 5568.0 5570.2 5570.7 5218.3 5495.6 5497.6 5501.0 5506.8 5552.8 5557.7 5611.7 5630.9 5654.7 5225.6 5468.9 5515.0 5526.2 5536.8 19:27:10 INFO - PROCESS | 19284 | 19:27:10 INFO - PROCESS | 19284 | [#5] yui.html Cycles:180 Average:16375.59 Median:4636.05 stddev:20195.06 (435.6%) stddev-sans-first:20218.04 19:27:10 INFO - PROCESS | 19284 | Values: 844.8 852.0 868.3 873.9 886.7 16144.8 16607.7 16615.6 16617.5 16630.4 15830.2 15940.4 15962.2 15997.5 15999.4 803.7 817.3 817.5 817.8 818.4 679.2 797.3 817.6 818.0 823.4 856.2 856.9 859.3 859.9 859.9 704.7 853.8 854.3 854.7 856.0 608.1 617.1 618.5 624.5 625.6 13788.4 13838.7 13839.0 13863.7 13866.7 13188.3 13583.6 13638.7 13662.2 13766.8 11093.3 11369.3 11524.8 11677.2 11719.8 4365.2 4377.0 4381.9 4507.0 4600.2 62605.0 63624.0 63722.0 63847.7 64024.4 10660.7 10800.0 10837.5 11198.7 11211.3 18686.5 18691.6 18707.3 18718.2 18766.6 8098.9 8148.5 8150.8 8264.2 8387.4 4562.6 4589.2 4671.9 4701.5 4731.5 3406.0 3409.4 3507.9 3521.7 3577.1 663.1 673.9 686.3 687.0 695.4 666.6 708.8 725.9 730.5 739.8 8804.1 9045.4 9105.4 9323.9 9349.1 569.6 614.4 627.7 674.3 723.7 4421.8 4449.7 4457.4 4511.5 4517.4 62970.7 75521.6 77347.2 77546.0 77570.6 63533.0 64395.0 64557.0 64614.0 64890.0 59268.1 59838.0 59925.4 60051.4 60440.7 9174.2 9337.5 9357.9 9382.3 9557.8 38549.6 38598.2 38923.0 38997.6 39947.4 47350.3 49987.3 50335.5 50526.5 51880.2 12016.1 12159.5 12308.3 12622.6 12989.4 13988.8 14320.0 14419.9 14638.7 15151.1 12354.4 12645.2 12804.6 12988.9 13005.5 13680.2 14058.3 14061.6 14075.5 14080.5 11861.7 12367.5 12513.7 12770.2 12782.9 9928.9 10046.8 10315.7 10413.1 10538.4 10260.7 10436.2 10541.2 10616.7 10622.8 19:27:10 INFO - PROCESS | 19284 | -------- Summary: end -------- 19:27:10 INFO - PROCESS | 19284 | 19:27:10 INFO - TEST-INFO | 19284: exit 0 19:27:10 INFO - TEST-OK | dromaeo_css | took 1113687ms 19:27:10 INFO - TEST-START | kraken 19:27:10 INFO - operating with platform_type : linux_ 19:27:10 INFO - Initialising browser for kraken test... 19:27:10 INFO - TEST-INFO | started process 19466 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpR3Pzko/profile http://localhost:47794/getInfo.html) 19:27:14 INFO - PROCESS | 19466 | __metrics Screen width/height:1600/1200 19:27:14 INFO - PROCESS | 19466 | colorDepth:24 19:27:14 INFO - PROCESS | 19466 | Browser inner width/height: 1024/697 19:27:14 INFO - PROCESS | 19466 | __metrics 19:27:15 ERROR - PROCESS | 19466 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 19:27:16 INFO - TEST-INFO | 19466: exit 0 19:27:16 INFO - Browser initialized. 19:27:16 INFO - Running cycle 1/1 for kraken test... 19:27:16 INFO - TEST-INFO | started process 19547 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpR3Pzko/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:27:28 INFO - PROCESS | 19547 | RSS: Main: 155291648 19:27:28 INFO - PROCESS | 19547 | 19:27:31 INFO - PROCESS | 19547 | Cycle 1(1): loaded http://localhost:47794/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47794/tests/kraken/driver.html?testName=audio-beat-detection) 19:27:32 INFO - PROCESS | 19547 | RSS: Main: 211693568 19:27:32 INFO - PROCESS | 19547 | 19:27:34 INFO - PROCESS | 19547 | Cycle 1(1): loaded http://localhost:47794/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47794/tests/kraken/driver.html?testName=audio-dft) 19:27:35 INFO - PROCESS | 19547 | RSS: Main: 199827456 19:27:35 INFO - PROCESS | 19547 | 19:27:38 INFO - PROCESS | 19547 | Cycle 1(1): loaded http://localhost:47794/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47794/tests/kraken/driver.html?testName=audio-fft) 19:27:39 INFO - PROCESS | 19547 | RSS: Main: 268173312 19:27:39 INFO - PROCESS | 19547 | 19:27:41 INFO - PROCESS | 19547 | Cycle 1(1): loaded http://localhost:47794/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47794/tests/kraken/driver.html?testName=audio-oscillator) 19:27:41 INFO - PROCESS | 19547 | RSS: Main: 177090560 19:27:41 INFO - PROCESS | 19547 | 19:27:43 INFO - PROCESS | 19547 | Cycle 1(1): loaded http://localhost:47794/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47794/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:27:44 INFO - PROCESS | 19547 | RSS: Main: 181432320 19:27:44 INFO - PROCESS | 19547 | 19:27:47 INFO - PROCESS | 19547 | Cycle 1(1): loaded http://localhost:47794/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47794/tests/kraken/driver.html?testName=imaging-darkroom) 19:27:48 INFO - PROCESS | 19547 | RSS: Main: 217415680 19:27:48 INFO - PROCESS | 19547 | 19:27:51 INFO - PROCESS | 19547 | Cycle 1(1): loaded http://localhost:47794/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47794/tests/kraken/driver.html?testName=imaging-desaturate) 19:27:52 INFO - PROCESS | 19547 | RSS: Main: 218267648 19:27:52 INFO - PROCESS | 19547 | 19:27:54 INFO - PROCESS | 19547 | Cycle 1(1): loaded http://localhost:47794/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47794/tests/kraken/driver.html?testName=json-parse-financial) 19:27:55 INFO - PROCESS | 19547 | RSS: Main: 218996736 19:27:55 INFO - PROCESS | 19547 | 19:27:56 INFO - PROCESS | 19547 | Cycle 1(1): loaded http://localhost:47794/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47794/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:27:57 INFO - PROCESS | 19547 | RSS: Main: 206344192 19:27:57 INFO - PROCESS | 19547 | 19:27:59 INFO - PROCESS | 19547 | Cycle 1(1): loaded http://localhost:47794/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47794/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:27:59 INFO - PROCESS | 19547 | RSS: Main: 209567744 19:27:59 INFO - PROCESS | 19547 | 19:28:01 INFO - PROCESS | 19547 | Cycle 1(1): loaded http://localhost:47794/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47794/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:28:02 INFO - PROCESS | 19547 | RSS: Main: 219770880 19:28:02 INFO - PROCESS | 19547 | 19:28:05 INFO - PROCESS | 19547 | Cycle 1(1): loaded http://localhost:47794/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47794/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:28:05 INFO - PROCESS | 19547 | RSS: Main: 226058240 19:28:05 INFO - PROCESS | 19547 | 19:28:08 INFO - PROCESS | 19547 | Cycle 1(1): loaded http://localhost:47794/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47794/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:28:09 INFO - PROCESS | 19547 | RSS: Main: 223174656 19:28:09 INFO - PROCESS | 19547 | 19:28:10 INFO - PROCESS | 19547 | Cycle 1(1): loaded http://localhost:47794/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47794/tests/kraken/driver.html?testName=ai-astar) 19:28:10 INFO - PROCESS | 19547 | RSS: Main: 268685312 19:28:10 INFO - PROCESS | 19547 | 19:28:10 INFO - PROCESS | 19547 | __start_tp_report 19:28:10 INFO - PROCESS | 19547 | _x_x_mozilla_page_load 19:28:10 INFO - PROCESS | 19547 | _x_x_mozilla_page_load_details 19:28:10 INFO - PROCESS | 19547 | |i|pagename|runs| 19:28:10 INFO - PROCESS | 19547 | |0;ai-astar;113;111;111;110;113;110;111;111;111;111 19:28:10 INFO - PROCESS | 19547 | |1;audio-beat-detection;153;124;125;183;125;124;158;124;166;127 19:28:10 INFO - PROCESS | 19547 | |2;audio-dft;161;161;161;161;160;160;161;161;160;159 19:28:10 INFO - PROCESS | 19547 | |3;audio-fft;74;75;73;114;75;76;76;74;99;74 19:28:10 INFO - PROCESS | 19547 | |4;audio-oscillator;82;82;126;82;83;82;114;82;83;119 19:28:10 INFO - PROCESS | 19547 | |5;imaging-gaussian-blur;117;117;117;116;117;117;117;117;116;117 19:28:10 INFO - PROCESS | 19547 | |6;imaging-darkroom;145;146;145;146;145;145;145;146;146;145 19:28:10 INFO - PROCESS | 19547 | |7;imaging-desaturate;94;95;95;94;94;94;95;95;94;94 19:28:10 INFO - PROCESS | 19547 | |8;json-parse-financial;53;52;53;53;53;55;52;67;51;50 19:28:10 INFO - PROCESS | 19547 | |9;json-stringify-tinderbox;62;62;62;62;63;63;64;63;63;63 19:28:10 INFO - PROCESS | 19547 | |10;stanford-crypto-aes;79;79;78;84;82;81;86;81;81;80 19:28:10 INFO - PROCESS | 19547 | |11;stanford-crypto-ccm;120;119;126;123;129;116;122;124;162;126 19:28:10 INFO - PROCESS | 19547 | |12;stanford-crypto-pbkdf2;159;161;158;159;168;156;159;159;158;159 19:28:10 INFO - PROCESS | 19547 | |13;stanford-crypto-sha256-iterative;62;61;62;61;65;61;61;61;61;62 19:28:10 INFO - PROCESS | 19547 | __end_tp_report 19:28:10 INFO - PROCESS | 19547 | __start_cc_report 19:28:10 INFO - PROCESS | 19547 | _x_x_mozilla_cycle_collect,1646 19:28:10 INFO - PROCESS | 19547 | __end_cc_report 19:28:10 INFO - PROCESS | 19547 | __startTimestamp1464229690988__endTimestamp 19:28:10 INFO - PROCESS | 19547 | 19:28:10 INFO - PROCESS | 19547 | ------- Summary: start ------- 19:28:10 INFO - PROCESS | 19547 | Number of tests: 14 19:28:10 INFO - PROCESS | 19547 | 19:28:10 INFO - PROCESS | 19547 | [#0] ai-astar Cycles:10 Average:111.20 Median:111.00 stddev:1.03 (0.9%) stddev-sans-first:0.87 19:28:10 INFO - PROCESS | 19547 | Values: 113.0 111.0 111.0 110.0 113.0 110.0 111.0 111.0 111.0 111.0 19:28:10 INFO - PROCESS | 19547 | 19:28:10 INFO - PROCESS | 19547 | [#1] audio-beat-detection Cycles:10 Average:140.90 Median:140.00 stddev:22.10 (15.8%) stddev-sans-first:23.01 19:28:11 INFO - PROCESS | 19547 | Values: 153.0 124.0 125.0 183.0 125.0 124.0 158.0 124.0 166.0 127.0 19:28:11 INFO - PROCESS | 19547 | 19:28:11 INFO - PROCESS | 19547 | [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:0.71 (0.4%) stddev-sans-first:0.73 19:28:11 INFO - PROCESS | 19547 | Values: 161.0 161.0 161.0 161.0 160.0 160.0 161.0 161.0 160.0 159.0 19:28:11 INFO - PROCESS | 19547 | 19:28:11 INFO - PROCESS | 19547 | [#3] audio-fft Cycles:10 Average:81.00 Median:75.00 stddev:13.93 (18.6%) stddev-sans-first:14.54 19:28:11 INFO - PROCESS | 19547 | Values: 74.0 75.0 73.0 114.0 75.0 76.0 76.0 74.0 99.0 74.0 19:28:11 INFO - PROCESS | 19547 | 19:28:11 INFO - PROCESS | 19547 | [#4] audio-oscillator Cycles:10 Average:93.50 Median:82.00 stddev:18.28 (22.3%) stddev-sans-first:18.91 19:28:11 INFO - PROCESS | 19547 | Values: 82.0 82.0 126.0 82.0 83.0 82.0 114.0 82.0 83.0 119.0 19:28:11 INFO - PROCESS | 19547 | 19:28:11 INFO - PROCESS | 19547 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 19:28:11 INFO - PROCESS | 19547 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 116.0 117.0 19:28:11 INFO - PROCESS | 19547 | 19:28:11 INFO - PROCESS | 19547 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 19:28:11 INFO - PROCESS | 19547 | Values: 145.0 146.0 145.0 146.0 145.0 145.0 145.0 146.0 146.0 145.0 19:28:11 INFO - PROCESS | 19547 | 19:28:11 INFO - PROCESS | 19547 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 19:28:11 INFO - PROCESS | 19547 | Values: 94.0 95.0 95.0 94.0 94.0 94.0 95.0 95.0 94.0 94.0 19:28:11 INFO - PROCESS | 19547 | 19:28:11 INFO - PROCESS | 19547 | [#8] json-parse-financial Cycles:10 Average:53.90 Median:53.00 stddev:4.79 (9.0%) stddev-sans-first:5.07 19:28:11 INFO - PROCESS | 19547 | Values: 53.0 52.0 53.0 53.0 53.0 55.0 52.0 67.0 51.0 50.0 19:28:11 INFO - PROCESS | 19547 | 19:28:11 INFO - PROCESS | 19547 | [#9] json-stringify-tinderbox Cycles:10 Average:62.70 Median:63.00 stddev:0.67 (1.1%) stddev-sans-first:0.67 19:28:11 INFO - PROCESS | 19547 | Values: 62.0 62.0 62.0 62.0 63.0 63.0 64.0 63.0 63.0 63.0 19:28:11 INFO - PROCESS | 19547 | 19:28:11 INFO - PROCESS | 19547 | [#10] stanford-crypto-aes Cycles:10 Average:81.10 Median:81.00 stddev:2.42 (3.0%) stddev-sans-first:2.45 19:28:11 INFO - PROCESS | 19547 | Values: 79.0 79.0 78.0 84.0 82.0 81.0 86.0 81.0 81.0 80.0 19:28:11 INFO - PROCESS | 19547 | 19:28:11 INFO - PROCESS | 19547 | [#11] stanford-crypto-ccm Cycles:10 Average:126.70 Median:125.00 stddev:12.97 (10.4%) stddev-sans-first:13.53 19:28:11 INFO - PROCESS | 19547 | Values: 120.0 119.0 126.0 123.0 129.0 116.0 122.0 124.0 162.0 126.0 19:28:11 INFO - PROCESS | 19547 | 19:28:11 INFO - PROCESS | 19547 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.60 Median:159.00 stddev:3.20 (2.0%) stddev-sans-first:3.39 19:28:11 INFO - PROCESS | 19547 | Values: 159.0 161.0 158.0 159.0 168.0 156.0 159.0 159.0 158.0 159.0 19:28:11 INFO - PROCESS | 19547 | 19:28:11 INFO - PROCESS | 19547 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.70 Median:61.50 stddev:1.25 (2.0%) stddev-sans-first:1.32 19:28:11 INFO - PROCESS | 19547 | Values: 62.0 61.0 62.0 61.0 65.0 61.0 61.0 61.0 61.0 62.0 19:28:11 INFO - PROCESS | 19547 | -------- Summary: end -------- 19:28:11 INFO - PROCESS | 19547 | 19:28:11 INFO - TEST-INFO | 19547: exit 0 19:28:11 INFO - TEST-OK | kraken | took 61146ms 19:28:11 INFO - SUITE-END | took 1174s 19:28:12 INFO - Completed test suite (00:19:35) 19:28:12 INFO - javascript benchmark 19:28:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3104.7516198704107, 3114.00351887396, 3143.1670607289066, 3148.4332820092372, 3172.8096314221148, 5304.257403963448, 5342.626016178869, 5374.274472946151, 5470.4256053114395, 5505.862353441161, 5358.839234822952, 5398.6220964532495, 5431.185322201672, 5436.456354364562, 5499.395066542677, 4782.66521343507, 4866.07544566533, 4870.6103511718975, 4881.780319885596, 5055.949440505585, 4924.704517728947, 5003.449620541755, 5024.371953505812, 5032.4212715537815, 5036.194208926572, 4764.785584648699, 4846.927296090579, 4864.781084851154, 4891.315215869781, 4928.654994150411, 4856.927146092811, 4873.171560834667, 4874.195757699975, 4935.35840340757, 4981.352424184869, 4913.852584422473, 4925.7783399747095, 4927.704337739747, 4930.408350997867, 4936.7531623419045, 5226.320578324831, 5229.137192363255, 5317.042932272189, 5335.0, 5377.193420986844, 5792.594518383715, 5805.82582522525, 5814.563907706896, 5815.88368232633, 5826.126081087828, 5605.215269862222, 5833.7958171464215, 5847.064469684872, 5847.7953271635715, 5852.67810270435, 5346.03771321162, 5396.730163491809, 5408.567314614861, 5468.808591699271, 5488.451154884479, 5973.163757074013, 5991.910121348184, 5995.970020149958, 6002.4897883679505, 6015.037593984942, 5498.725063746797, 5623.437656234426, 5746.913796293059, 5759.798407055817, 5763.740631671585, 5767.279090113736, 5800.564957628195, 5816.47651711348, 5819.505342045889, 5873.353931067579, 5732.885342293131, 5770.740316685759, 5779.624324418899, 5786.623869448473, 5786.913196302059, 5643.068893632505, 5650.632708873993, 5705.172749951317, 5777.162311464814, 5791.62354446968, 4355.3684715716045, 4365.039691267916, 4366.017646029618, 4399.252127138394, 4405.889852753707, 3874.050857539921, 3894.883153505399, 3903.0632648164237, 3919.529656441245, 3925.8822235332987, 5357.303550538405, 5399.082156033405, 5400.21696853954, 5413.404525502192, 5480.287562616914, 5772.884542309131, 5796.739146738407, 5798.304203495608, 5826.009578371687, 5853.180554722342, 5453.15476101205, 5454.072807622713, 5455.236266922634, 5460.126379779216, 5464.371597266286, 4824.975875120672, 4959.479254678206, 4963.0, 5022.547970682656, 5024.648274620815, 6076.969615151896, 6079.300880398722, 6081.361457046946, 6083.7870674526175, 6089.208402907594, 5872.383399743051, 5892.558058145571, 5896.852578685567, 5901.586888917906, 5902.291724992857, 5857.648541087548, 6003.279606447254, 6046.939530604637, 6054.606450580698, 6081.726322315418, 5726.341470730919, 5760.308762948473, 5764.855878603068, 5770.422957704196, 5775.5090817281, 5648.096304591246, 5866.853328666817, 5878.2064421302575, 5891.0, 5898.20374249488, 5603.831885043455, 5647.1529270609735, 5670.404607516316, 5678.943210568007, 5711.971440142773, 5601.551875849841, 5629.6903670298525, 5633.746481408429, 5638.520725738358, 5647.0964645656495, 5432.837014889559, 5576.693281869536, 5588.022096133242, 5588.497035266845, 5593.356763972195, 5667.0, 5707.914381284367, 5730.0, 5808.593398462067, 5809.477147056785, 5585.748641311232, 5622.971885140548, 5629.6903670298525, 5631.1271752878365, 5675.432456754292], "value": 5337.578916374625, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [627.7206643043844, 640.2349192714707, 644.7936660268713, 647.6437959122485, 661.3783043938697, 42722.572774272245, 45171.77414112929, 45416.0, 49068.75465622676, 49089.0, 43836.780816095874, 44457.11085778291, 44507.0, 44523.0, 44559.331610025794, 8576.95711521443, 8741.475511469333, 8749.781255468632, 8753.474791512497, 8756.080611535792, 8577.957110214471, 8667.566621668922, 8676.913230867705, 8679.262262707678, 8681.913180868205, 8751.299896008335, 8753.868691969594, 8803.559822008874, 8804.779880503007, 8808.075152109033, 8743.213110820025, 8745.300375969908, 8762.299016078698, 8798.51608161551, 8802.427842190236, 8671.4363566368, 8817.559122043873, 8820.823583528358, 8823.205911467998, 8827.249683776887, 40953.59046409527, 41355.0, 41422.0, 41449.79275103635, 41472.585274147474, 3406.352792969353, 3559.2881423715103, 3596.1189508570305, 4008.498937632796, 4172.457580514544, 31976.360472790413, 32033.199170020704, 32301.51547726786, 32813.01560953151, 33040.83479582611, 4238.590329468575, 4316.805743741539, 4400.207962566737, 4410.558944105596, 4479.059397526524, 202072.0, 206598.0, 206823.0, 206943.0, 207324.0, 57836.42163578395, 58261.70869145627, 58408.4159158403, 58426.0, 58436.41563584395, 56433.7178314114, 62259.44351391251, 63857.0, 64016.35983640104, 68480.31519684839, 15323.157226352434, 15414.922925385301, 15483.148426836633, 15488.0, 15497.07017578949, 11597.826032609517, 11694.2983420995, 11694.70763230909, 11709.238899471507, 11713.062954963583, 16440.917795411187, 18054.201598752214, 18314.542136446697, 18369.54076148107, 18686.71969920452, 6579.868402631921, 6612.338766123349, 6685.662867426534, 6778.288279730656, 6918.446524278146, 999.6801023672355, 1035.5236591167995, 1062.7608788022787, 1179.3087635700203, 1198.2271434924426, 33390.0, 33427.665723342456, 33567.49648755271, 33715.662843371254, 34319.656803431644, 1119.4794420594462, 1124.1344164992909, 1150.9079273658087, 1161.5005547614437, 1208.812634041725, 17768.55578610545, 17779.0, 17784.911075444797, 17787.911060444614, 17802.0, 468307.0, 470860.0, 471527.0, 471963.0, 472841.0, 60171.0, 60223.0, 60335.0, 60375.69812150999, 60481.0, 1251.7559075980278, 1346.8922486201081, 1371.5885234429832, 1375.3329635126956, 1383.3152589468077, 32948.83525582357, 34041.48937765886, 34241.48637770485, 34267.31465370728, 34509.13727156841, 50917.490825092755, 51533.227001594256, 51553.742231288605, 51559.0, 51581.22628160506, 295132.0, 301252.9874701225, 301494.0, 301693.0, 303073.0, 35746.28507429785, 45780.77109614431, 46439.0, 47611.28583071187, 51386.74306628443, 46205.0, 46455.07089858252, 46748.0, 51357.0, 52480.21279680884, 30026.84986575053, 30201.244968875955, 30443.2389190272, 30668.38663226678, 30693.316801983903, 42991.57008429876, 43130.56869431266, 43199.56800432081, 43524.12951741011, 44317.55682443134, 42332.36501452419, 42780.358294626225, 43362.78318608387, 43554.56445435632, 43665.0, 34813.477797832544, 38153.0, 38188.61811381962, 39018.414723778595, 39185.608143918194, 28975.13093579757, 29097.85451072731, 29338.11985640434, 29463.410731784814, 29570.704292957656], "value": 19846.569555509468, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.60292090384195, 375.94548790425387, 386.7756701113354, 398.3864848133874, 399.34507407851146, 18383.908080459594, 20012.399628011146, 20754.481137971557, 20762.89618551905, 20781.0, 18538.907305463454, 18703.90648046758, 19333.130009149587, 19353.806461935375, 19474.31839885601, 5199.792008319662, 5507.311586051744, 5508.3114610673665, 5664.461876121762, 5694.402087780785, 5518.172274158868, 5531.778728850841, 5537.307836520435, 5556.555475561945, 5558.944410555883, 5488.396276409591, 5527.55779537636, 5531.419200983899, 5585.078462053756, 5590.972045139769, 5447.1829225616075, 5514.117741161435, 5515.7242137893345, 5535.280413546254, 5575.1358539426255, 5207.765650545697, 5384.6499977501335, 5407.053765591006, 5411.2965314508865, 5414.756335964891, 12789.0, 12900.161489503153, 12910.806337904938, 12953.028522860728, 12988.155769874928, 2134.562414704997, 2158.3740715192575, 2255.1994042114975, 2308.746037935826, 2835.39039106591, 9572.61709531625, 9629.90370096297, 9651.179649729782, 10016.949915250378, 10071.5467803949, 1880.9905950470297, 1900.572371216479, 1926.4605910345126, 1961.548843765942, 1989.3932350633052, 67392.32607673909, 71306.28693713048, 81186.59406702929, 81593.0, 82450.58774706148, 10552.47237638115, 10561.524731387106, 10731.40977246259, 10751.247412681194, 10824.242303038869, 14428.567142985727, 14466.927665361605, 14486.420543178365, 14501.274936253145, 14519.419223231163, 7883.36933045355, 8142.389320800964, 8160.4287699861625, 8270.793230169294, 8309.37679674027, 7903.841923161504, 8035.55804430762, 8052.194780521901, 8092.150324215872, 8131.634076466573, 4513.593776560126, 4521.59305662492, 4559.703619264737, 4559.817607295671, 4606.884827879263, 1814.5936898903456, 1941.5922656242346, 1948.1330807790398, 1990.701394790793, 2019.1620477501965, 932.5756780664781, 975.4634950777045, 992.8808542974889, 1060.6552870317178, 1120.0703416164727, 18755.249790008245, 19596.726212796122, 19631.411057668294, 19683.901580492005, 20015.799842001685, 979.6228452045871, 994.4480813148627, 1034.110664828247, 1048.9580416783242, 1064.1912146768511, 10557.208209384327, 11070.889291106985, 11124.49939752713, 11145.609903653332, 11166.776664466828, 459826.0, 469927.0, 470292.0, 476932.0, 484028.0, 87557.56221218852, 88477.0, 89262.0, 89889.0, 90780.0, 947.9194268487256, 964.99035009649, 976.2092704909046, 993.7515621094726, 1003.8717918013857, 17281.481555553353, 17473.12634368302, 17570.472885813448, 17624.823751762317, 17801.109944502983, 37982.240355193295, 38142.0, 39185.21629567336, 40894.0, 42601.36097958471, 58357.416425835196, 58377.708111460866, 59593.10610340935, 59785.40214597798, 60257.39742602693, 8295.95852020736, 8332.083470818327, 8441.83116337682, 8445.535495547803, 8707.695230666895, 12420.192687475284, 13063.009103977258, 13408.798868017182, 13418.463261469431, 13443.0, 11399.772004559696, 11848.111391645489, 12002.879971200176, 12035.518579257083, 12041.45813438415, 11087.833682494607, 11171.888281117084, 11223.60717374888, 11317.71705707364, 11561.826572601585, 11613.593524226611, 11621.360825154698, 12005.159638825548, 12039.939800300943, 12303.56937507183, 8120.75637730869, 8133.918660813553, 8322.50064996102, 8500.31997440191, 8672.696455624275, 10091.344062635904, 11794.705132371759, 11935.940320298343, 12024.278543287432, 12269.631911042683], "value": 8961.761195223564, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1313.3498918035561, 1436.964075898102, 1479.0016738701377, 1613.2175894691072, 1807.764990551229, 8080.272775450208, 8319.792005199866, 8337.041240257364, 8593.613287402066, 8598.656053757857, 8397.748067557983, 8556.101609331025, 8562.571871406435, 8563.314934805216, 8583.227509524142, 1956.2859556261933, 2011.0347033423966, 2212.203606701586, 2259.491614386758, 2283.303592404316, 2277.703898493202, 2297.1959814065112, 2299.1148407862925, 2300.654901764732, 2304.158981971577, 2207.348832094536, 2226.599212141822, 2228.955420891581, 2230.0, 2230.9107635694554, 1855.8422534084552, 2134.9573008539896, 2159.2010955946243, 2183.377737344865, 2187.3109970359446, 2232.7767223277706, 2235.1394713035434, 2246.4720790614356, 2256.605094108541, 2258.4692597239637, 8477.915220847835, 8530.70142545008, 8532.14678532148, 8538.87191692125, 8540.274076703488, 5008.499150084999, 5113.69317840927, 5148.124818780779, 5151.021305951857, 5157.7936882524655, 3152.274976755336, 3166.0976621662944, 3224.0650211438656, 3272.4764037753844, 3321.601407831076, 987.4766373821886, 1016.4120654090997, 1017.7710015246511, 1024.0783295034455, 1042.135027926819, 11215.102791776639, 11561.421928903605, 11570.826437603442, 11903.523859045628, 11924.284542927453, 4178.12259425518, 4181.393697913846, 4237.322028475429, 4246.8725938221905, 4279.251131052116, 9449.196818270386, 9464.1009104135, 9467.621295148117, 9472.052794720474, 9478.194353479894, 4924.704517728947, 4945.455999840015, 4981.12830254704, 4983.227599722049, 4983.800647974041, 3995.081131339808, 4610.585047345688, 4657.417822772153, 4702.224133018082, 4742.359781429532, 3634.400323946519, 3650.105724097613, 3725.8695945642316, 3735.14091758897, 3803.676687481595, 1101.8126918423727, 1118.4463690473267, 1120.383788916093, 1134.5064896769932, 1150.5052827284348, 933.3186773655269, 942.5417773929353, 1015.294370412571, 1031.242037102729, 1033.26121822897, 5964.7912323068485, 6026.879462410815, 6146.108814221912, 6161.383861613893, 6201.875962480725, 408.5812042656301, 410.9034376921481, 411.9114390406077, 412.0337807840609, 412.83486605357496, 4147.730397524151, 4271.337942618899, 4309.978450107729, 4344.9348259776125, 4399.934000989988, 10308.226882983807, 10582.629607963685, 10660.94669526663, 10679.62621308266, 10703.571857125784, 10524.263301568817, 10608.098311643442, 10629.149668026539, 10634.893651063545, 10649.520771565298, 7632.236776322435, 7971.641276142472, 8025.117237103914, 8096.473729207582, 8119.959400203079, 6097.115918191748, 6208.4722798562625, 6255.687215639109, 6333.20834895638, 6419.646919419477, 9920.900790992286, 9960.701178964642, 10118.392896426238, 10137.797244055226, 10140.645077422254, 10074.798504029732, 10219.065659720913, 10267.794644107225, 10289.588416463257, 10320.071193592612, 7070.292970702889, 7263.455240857063, 7415.740449084256, 7688.308052275322, 7866.213378662317, 8485.703000394957, 8491.532965686947, 8512.574371281535, 8541.402101853058, 8559.400841941004, 7512.248775122444, 7648.196939321291, 7692.9615351922885, 7699.846003079795, 7782.299593036654, 7484.326410622853, 7501.962490187514, 7574.242575742382, 7673.424493162924, 7740.3420709240345, 7060.858782824212, 7063.258357872555, 7079.292070793085, 7095.290470952863, 7157.892631610634, 5219.19102539107, 5266.0, 5311.442298558596, 5437.238786569963, 5465.945340546544, 5250.396204436539, 5329.920051199158, 5393.325834270716, 5457.754401051883, 5532.059549876451], "value": 4415.809553532908, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.84823891576383, 303.16931607395736, 305.7538681361506, 307.0, 312.57801967344074, 5254.500822421868, 5275.472452754728, 5288.365396152467, 5321.361436627601, 5326.2543243945875, 4994.250862370646, 5036.960031187375, 5208.244804503344, 5236.554892834104, 5274.4461831507615, 4006.859759908389, 4063.2889244382263, 4077.3476243800997, 4091.3658382950616, 4108.239975604522, 4070.3283958147017, 4080.8979775505554, 4097.303458412077, 4099.651529619986, 4114.485689288839, 3809.2381523695235, 3865.188310454808, 3958.4656071430277, 4016.5180178378637, 4092.283850326196, 4035.950652830256, 4050.9594904050878, 4078.286299897521, 4081.285774989365, 4089.7137200395982, 3536.328097661436, 3558.323918455511, 3561.5726112866364, 3577.8032208228537, 3577.8354095771942, 4845.927311090337, 5041.798328066873, 5076.334924164806, 5094.1594636884865, 5117.795288188468, 4558.361829343895, 4592.586667199935, 4594.954050459486, 4596.069650746695, 4633.4439867215815, 5528.226048353234, 5530.225768392428, 5531.944680553183, 5553.861153471195, 5573.247611572427, 3578.928421431583, 3768.5100936878302, 3772.6793222576116, 3841.058940559553, 3847.903802404934, 5648.54811615074, 5650.231386620568, 5658.151277308396, 5703.65778053314, 5723.656580605136, 3900.570937196906, 3912.7847968361443, 3924.50943632046, 3933.62630550103, 3947.8420863165725, 3859.7491163074874, 3909.7879657306325, 3972.2651309507833, 3973.960260397359, 3989.2221016901426, 4532.0, 4543.636509079266, 4545.613622842029, 4550.431196100488, 4552.704074235164, 5491.780328786884, 5505.697186654692, 5513.669179849222, 5530.198121272393, 5537.815755940351, 1251.0867067040929, 1270.574357590199, 1332.6135420728074, 1352.2157148853642, 1359.1437394441637, 836.602613758472, 852.1180578101635, 858.047567200407, 858.772425307294, 866.7908267966152, 4746.715197088186, 4767.332573439721, 4842.539958703917, 4850.296706977469, 4881.341018962395, 5121.155009423478, 5121.257417674491, 5132.538071573502, 5141.948580514147, 5157.329547158845, 4642.469853929549, 4832.371791667131, 4854.781534830941, 4868.71170549841, 4901.387326584177, 2666.5733482643072, 2667.933301667435, 2673.31830383251, 2694.811363204557, 2723.5506141486435, 5181.481851814864, 5209.895802083937, 5214.817481388133, 5245.527902488794, 5246.239295302236, 4927.384076990376, 5074.391073071255, 5089.287499750038, 5096.51583099605, 5128.897422051613, 4982.551570358685, 5125.794968201305, 5219.686818790885, 5240.589328908669, 5279.656822306538, 4887.437944636412, 5057.342545469065, 5098.0, 5119.029173768052, 5132.692038477703, 5035.194368900959, 5039.052154489518, 5046.0, 5048.596112310933, 5057.7724002419245, 5183.989122121301, 5199.948000519947, 5212.374515058217, 5216.634835561475, 5230.476952304739, 3527.8236088194976, 3572.7141828653125, 3589.3898037333192, 3604.8197590120913, 3620.2216523447587, 4674.088552732321, 4973.751312434436, 5372.516473517246, 5570.749316280858, 5629.0, 5523.696196709219, 5533.253010843646, 5545.528630066489, 5545.667259964415, 5585.385607583244, 5556.16657501378, 5560.91658625129, 5567.972160139173, 5570.2201691762375, 5570.721463926707, 5218.347706536683, 5495.587830912617, 5497.615166938276, 5500.972495137498, 5506.807261745819, 5552.7778888843995, 5557.72211389437, 5611.747471363717, 5630.943690563042, 5654.717264136859, 5225.608079393985, 5468.890622187613, 5515.0, 5526.198701188225, 5536.7819079802375], "value": 4012.770112462841, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [844.8352571248607, 851.9616617252223, 868.2836659755699, 873.8907636545432, 886.7251152142832, 16144.83855161448, 16607.66784664306, 16615.584610384747, 16617.501474955756, 16630.41793537225, 15830.208489575532, 15940.362385504566, 15962.201889905487, 15997.520074397758, 15999.440019599317, 803.7428023032631, 817.2522142239843, 817.497239197892, 817.8159914019358, 818.443458448255, 679.2053297641771, 797.314309693663, 817.5666896544841, 818.0265484073963, 823.3948048184579, 856.1780690537092, 856.8757530158123, 859.2696208223023, 859.8968123825118, 859.9140085991382, 704.6723273677765, 853.8335024670192, 854.3080105114815, 854.6709516836, 856.0113069404847, 608.0605464557269, 617.0589850478012, 618.4619381138439, 624.4692011789988, 625.6121204852975, 13788.448462061506, 13838.723225535534, 13839.0, 13863.653408664763, 13866.653333666638, 13188.340582970908, 13583.592492225249, 13638.659707021321, 13662.248576328298, 13766.793498097537, 11093.282145874313, 11369.31784092957, 11524.827127593093, 11677.182597218198, 11719.824202636968, 4365.2142614329405, 4376.956230437719, 4381.9342709859375, 4507.03098833749, 4600.240960241556, 62605.0, 63624.045639315445, 63722.044169337496, 63847.6807615959, 64024.35975640231, 10660.680179594625, 10800.0, 10837.458127093614, 11198.720031999264, 11211.271267367594, 18686.53283667919, 18691.626167476574, 18707.251709931723, 18718.15768290403, 18766.624667506847, 8098.878516822252, 8148.51108933454, 8150.75547733569, 8264.21489958453, 8387.412881098386, 4562.5665561771575, 4589.242774942164, 4671.85984420468, 4701.506341834127, 4731.503192164842, 3405.9829700851337, 3409.437442821956, 3507.9298414032087, 3521.683048525645, 3577.105723569108, 663.134609334813, 673.9427148692416, 686.3102581905154, 686.993130068693, 695.3741632530763, 666.6000399760202, 708.7625645408742, 725.9310365515267, 730.4521608793405, 739.8483310921248, 8804.141484098194, 9045.412048216976, 9105.362624616346, 9323.860142097874, 9349.107138424582, 569.6126633888995, 614.3549273263056, 627.7426255235423, 674.2684187656349, 723.735836419703, 4421.7789110544345, 4449.665100469911, 4457.375967364572, 4511.481179664315, 4517.376056113469, 62970.685146573975, 75521.6223918877, 77347.22652773513, 77546.0, 77570.6121469389, 63533.0, 64395.03407448892, 64557.0, 64614.0, 64890.0, 59268.11097833536, 59838.0, 59925.400745992854, 60051.39948600545, 60440.697796510736, 9174.202760590364, 9337.486438245962, 9357.85963210566, 9382.296327775308, 9557.808843822946, 38549.61450385572, 38598.17235373122, 38923.0, 38997.6100238994, 39947.40078898761, 47350.28974565453, 49987.250191246436, 50335.496645034546, 50526.494735053646, 51880.221796672326, 12016.098792590765, 12159.45282462309, 12308.323042232763, 12622.621321360373, 12989.4154763034, 13988.790168147283, 14320.0, 14419.927900360432, 14638.707225855636, 15151.090934543521, 12354.382280886099, 12645.178063425848, 12804.61586152417, 12988.935055324662, 13005.479780808662, 13680.179189248676, 14058.297085145497, 14061.578152655436, 14075.507357242448, 14080.507182248572, 11861.703457413634, 12367.505299788269, 12513.749725005631, 12770.2337859725, 12782.936085319514, 9928.900710992797, 10046.799064018825, 10315.742106447398, 10413.114885234538, 10538.420386878795, 10260.692179234635, 10436.165106791286, 10541.20940929418, 10616.681499555025, 10622.84065738999], "value": 7029.185396110971, "unit": "score"}], "name": "dromaeo_css", "value": 7006.02706846796, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 111.0, 111.0, 110.0, 113.0, 110.0, 111.0, 111.0, 111.0, 111.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 124.0, 125.0, 183.0, 125.0, 124.0, 158.0, 124.0, 166.0, 127.0], "value": 140.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 161.0, 160.0, 160.0, 161.0, 161.0, 160.0, 159.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 73.0, 114.0, 75.0, 76.0, 76.0, 74.0, 99.0, 74.0], "value": 81.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 126.0, 82.0, 83.0, 82.0, 114.0, 82.0, 83.0, 119.0], "value": 93.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 146.0, 145.0, 145.0, 145.0, 146.0, 146.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 94.0, 94.0, 94.0, 95.0, 95.0, 94.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 53.0, 53.0, 53.0, 55.0, 52.0, 67.0, 51.0, 50.0], "value": 53.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 62.0, 63.0, 63.0, 64.0, 63.0, 63.0, 63.0], "value": 62.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 78.0, 84.0, 82.0, 81.0, 86.0, 81.0, 81.0, 80.0], "value": 81.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 119.0, 126.0, 123.0, 129.0, 116.0, 122.0, 124.0, 162.0, 126.0], "value": 126.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 161.0, 158.0, 159.0, 168.0, 156.0, 159.0, 159.0, 158.0, 159.0], "value": 159.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 62.0, 61.0, 65.0, 61.0, 61.0, 61.0, 61.0, 62.0], "value": 61.7, "unit": "score"}], "name": "kraken", "value": 1489.3999999999999, "alertThreshold": 2.0}]} 19:28:12 INFO - Return code: 0 19:28:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:28:12 ERROR - # TBPL SUCCESS # 19:28:12 INFO - Running post-action listener: _resource_record_post_action 19:28:12 INFO - ##### 19:28:12 INFO - ##### Finished run-tests step (success) 19:28:12 INFO - ##### 19:28:12 INFO - Running post-run listener: _resource_record_post_run 19:28:12 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 0; Write bytes: 537206784; Read time: 0; Write time: 369740 19:28:12 INFO - TinderboxPrint: CPU usage
13.2% 19:28:12 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 19:28:12 INFO - TinderboxPrint: I/O write bytes / time
537,206,784 / 369,740 19:28:12 INFO - TinderboxPrint: CPU idle
8,262.3 (86.8%) 19:28:12 INFO - TinderboxPrint: CPU user
1,215.5 (12.8%) 19:28:12 INFO - TinderboxPrint: Swap in / out
0 / 0 19:28:12 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 247095296; Read time: 0; Write time: 229632 19:28:12 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 290111488; Read time: 0; Write time: 140108 19:28:12 INFO - Running post-run listener: _upload_blobber_files 19:28:12 INFO - Blob upload gear active. 19:28:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:28:12 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:28:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:28:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:28:13 INFO - (blobuploader) - INFO - Open directory for files ... 19:28:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:28:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:28:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:28:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:28:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:28:17 INFO - (blobuploader) - INFO - Done attempting. 19:28:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:28:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:28:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:28:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:28:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:28:18 INFO - (blobuploader) - INFO - Done attempting. 19:28:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:28:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:28:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:28:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:28:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:28:19 INFO - (blobuploader) - INFO - Done attempting. 19:28:19 INFO - (blobuploader) - INFO - Iteration through files over. 19:28:19 INFO - Return code: 0 19:28:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:28:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:28:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/06f33922706928a75edc034f95cbe926c5fbd69b3cdbe93c8ac5107651b3a7791aa85a8c68b0410b1ecdd66e353cce5bac0a674e24df162ede5213c2ee991fa0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a0fcfe14e7ebb1f93762b7a634cbb338a047f0cbba4aad7a9cb24756c920ae3cfe0720790ef1bc3c87455be04c1f272ec23198347ea162cb98840e0c00dfe0d0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/860c975adc9239eb3e07974e419cea20883966ec5a8d46868e91b62e321293514fc41ab58bf7e86786909a5750f9b14ecadd8b29af3baef191093cdd1a2897b2"} 19:28:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:28:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:28:19 INFO - Contents: 19:28:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/06f33922706928a75edc034f95cbe926c5fbd69b3cdbe93c8ac5107651b3a7791aa85a8c68b0410b1ecdd66e353cce5bac0a674e24df162ede5213c2ee991fa0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a0fcfe14e7ebb1f93762b7a634cbb338a047f0cbba4aad7a9cb24756c920ae3cfe0720790ef1bc3c87455be04c1f272ec23198347ea162cb98840e0c00dfe0d0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/860c975adc9239eb3e07974e419cea20883966ec5a8d46868e91b62e321293514fc41ab58bf7e86786909a5750f9b14ecadd8b29af3baef191093cdd1a2897b2"} 19:28:19 INFO - Running post-run listener: copy_logs_to_upload_dir 19:28:19 INFO - Copying logs to upload dir... 19:28:19 INFO - mkdir: /builds/slave/test/build/upload/logs 19:28:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.671749 ========= master_lag: 0.77 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-05-25 19:28:19.471975) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-25 19:28:19.475907) ========= 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=aa08bb06ff6271ef470a76a4000001be-1464222731.922879-1876657530 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/06f33922706928a75edc034f95cbe926c5fbd69b3cdbe93c8ac5107651b3a7791aa85a8c68b0410b1ecdd66e353cce5bac0a674e24df162ede5213c2ee991fa0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a0fcfe14e7ebb1f93762b7a634cbb338a047f0cbba4aad7a9cb24756c920ae3cfe0720790ef1bc3c87455be04c1f272ec23198347ea162cb98840e0c00dfe0d0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/860c975adc9239eb3e07974e419cea20883966ec5a8d46868e91b62e321293514fc41ab58bf7e86786909a5750f9b14ecadd8b29af3baef191093cdd1a2897b2"} build_url:https://queue.taskcluster.net/v1/task/AOY275KNTLagf5znPokNsw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011213 build_url: 'https://queue.taskcluster.net/v1/task/AOY275KNTLagf5znPokNsw/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/Mozilla-Inbound/sha512/06f33922706928a75edc034f95cbe926c5fbd69b3cdbe93c8ac5107651b3a7791aa85a8c68b0410b1ecdd66e353cce5bac0a674e24df162ede5213c2ee991fa0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a0fcfe14e7ebb1f93762b7a634cbb338a047f0cbba4aad7a9cb24756c920ae3cfe0720790ef1bc3c87455be04c1f272ec23198347ea162cb98840e0c00dfe0d0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/860c975adc9239eb3e07974e419cea20883966ec5a8d46868e91b62e321293514fc41ab58bf7e86786909a5750f9b14ecadd8b29af3baef191093cdd1a2897b2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-25 19:28:19.502787) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 19:28:19.503496) ========= 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=aa08bb06ff6271ef470a76a4000001be-1464222731.922879-1876657530 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004347 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-25 19:28:19.556453) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-25 19:28:19.556807) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-25 19:28:19.557173) ========= ========= Total master_lag: 0.93 =========