builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-066 starttime: 1464390137.86 results: success (0) buildid: 20160527144251 builduid: d440f4d99614438c8efc54b121ae006a revision: ea15028498ed95677844fb7f30be5efcaf8b2621 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-27 16:02:17.856131) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-27 16:02:17.856687) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-27 16:02:17.856980) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-27 16:02:17.904463) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 16:02:17.904754) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1464389726.939893-1090278593 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-27 16:02:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.9M=0s 2016-05-27 16:02:18 (40.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.137593 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 16:02:18.059134) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 16:02:18.059441) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1464389726.939893-1090278593 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015881 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 16:02:18.110072) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-27 16:02:18.110645) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ea15028498ed95677844fb7f30be5efcaf8b2621 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev ea15028498ed95677844fb7f30be5efcaf8b2621 --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=82c74bd3bc9a11c5833d2010000001e6-1464389726.939893-1090278593 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-27 16:02:19,058 truncating revision to first 12 chars 2016-05-27 16:02:19,058 Setting DEBUG logging. 2016-05-27 16:02:19,058 attempt 1/10 2016-05-27 16:02:19,058 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ea15028498ed?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-27 16:02:19,859 unpacking tar archive at: mozilla-central-ea15028498ed/testing/mozharness/ program finished with exit code 0 elapsedTime=1.137643 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-27 16:02:19.265553) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-27 16:02:19.266062) ========= script_repo_revision: ea15028498ed95677844fb7f30be5efcaf8b2621 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-27 16:02:19.266747) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-27 16:02:19.267047) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-27 16:02:19.290504) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-05-27 16:02:19.291122) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82c74bd3bc9a11c5833d2010000001e6-1464389726.939893-1090278593 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:02:20 INFO - MultiFileLogger online at 20160527 16:02:20 in /builds/slave/test 16:02:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 16:02:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:02:20 INFO - {'append_to_log': False, 16:02:20 INFO - 'base_work_dir': '/builds/slave/test', 16:02:20 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 16:02:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:02:20 INFO - 'branch': 'Firefox-Non-PGO', 16:02:20 INFO - 'buildbot_json_path': 'buildprops.json', 16:02:20 INFO - 'config_files': ('talos/linux_config.py',), 16:02:20 INFO - 'default_actions': ('clobber', 16:02:20 INFO - 'read-buildbot-config', 16:02:20 INFO - 'download-and-extract', 16:02:20 INFO - 'populate-webroot', 16:02:20 INFO - 'create-virtualenv', 16:02:20 INFO - 'install', 16:02:20 INFO - 'run-tests'), 16:02:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:02:20 INFO - 'download_minidump_stackwalk': True, 16:02:20 INFO - 'download_symbols': 'ondemand', 16:02:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:02:20 INFO - 'tooltool.py': '/tools/tooltool.py', 16:02:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:02:20 INFO - '/tools/misc-python/virtualenv.py')}, 16:02:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:02:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:02:20 INFO - 'installer_path': 'installer.exe', 16:02:20 INFO - 'log_level': 'info', 16:02:20 INFO - 'log_name': 'talos', 16:02:20 INFO - 'log_to_console': True, 16:02:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:02:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:02:20 INFO - 'opt_config_files': (), 16:02:20 INFO - 'pip_index': False, 16:02:20 INFO - 'sps_profile': False, 16:02:20 INFO - 'sps_profile_interval': 0, 16:02:20 INFO - 'suite': 'dromaeojs-e10s', 16:02:20 INFO - 'system_bits': '32', 16:02:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:02:20 INFO - 'title': 'talos-linux64-ix-066', 16:02:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:02:20 INFO - 'use_talos_json': True, 16:02:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:02:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:02:20 INFO - 'work_dir': 'build'} 16:02:20 INFO - ##### 16:02:20 INFO - ##### Running clobber step. 16:02:20 INFO - ##### 16:02:20 INFO - Running pre-action listener: _resource_record_pre_action 16:02:20 INFO - Running main action method: clobber 16:02:20 INFO - rmtree: /builds/slave/test/build 16:02:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:02:20 INFO - Running post-action listener: _resource_record_post_action 16:02:20 INFO - ##### 16:02:20 INFO - ##### Finished clobber step (success) 16:02:20 INFO - ##### 16:02:20 INFO - ##### 16:02:20 INFO - ##### Running read-buildbot-config step. 16:02:20 INFO - ##### 16:02:20 INFO - Running pre-action listener: _resource_record_pre_action 16:02:20 INFO - Running main action method: read_buildbot_config 16:02:20 INFO - Using buildbot properties: 16:02:20 INFO - { 16:02:20 INFO - "project": "", 16:02:20 INFO - "product": "firefox", 16:02:20 INFO - "script_repo_revision": "production", 16:02:20 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 16:02:20 INFO - "repository": "", 16:02:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 16:02:20 INFO - "buildid": "20160527144251", 16:02:20 INFO - "pgo_build": "False", 16:02:20 INFO - "basedir": "/builds/slave/test", 16:02:20 INFO - "buildnumber": 331, 16:02:20 INFO - "slavename": "talos-linux64-ix-066", 16:02:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:02:20 INFO - "platform": "ubuntu64_hw", 16:02:20 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 16:02:20 INFO - "branch": "mozilla-central", 16:02:20 INFO - "repo_path": "mozilla-central", 16:02:20 INFO - "revision": "ea15028498ed95677844fb7f30be5efcaf8b2621", 16:02:20 INFO - "stage_platform": "linux64", 16:02:20 INFO - "builduid": "d440f4d99614438c8efc54b121ae006a", 16:02:20 INFO - "slavebuilddir": "test" 16:02:20 INFO - } 16:02:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/a35TCENJTbCWCF8aykz08g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 16:02:20 INFO - Running post-action listener: _resource_record_post_action 16:02:20 INFO - ##### 16:02:20 INFO - ##### Finished read-buildbot-config step (success) 16:02:20 INFO - ##### 16:02:20 INFO - ##### 16:02:20 INFO - ##### Running download-and-extract step. 16:02:20 INFO - ##### 16:02:20 INFO - Running pre-action listener: _resource_record_pre_action 16:02:20 INFO - Running main action method: download_and_extract 16:02:20 INFO - mkdir: /builds/slave/test/build/tests 16:02:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:02:20 INFO - https://queue.taskcluster.net/v1/task/a35TCENJTbCWCF8aykz08g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:02:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a35TCENJTbCWCF8aykz08g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 16:02:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a35TCENJTbCWCF8aykz08g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 16:02:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a35TCENJTbCWCF8aykz08g/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 16:02:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a35TCENJTbCWCF8aykz08g/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 16:02:23 INFO - Downloaded 1361 bytes. 16:02:24 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 16:02:24 INFO - Using the following test package requirements: 16:02:24 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 16:02:24 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:02:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:02:24 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:02:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:02:24 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:02:24 INFO - u'jsshell-linux-x86_64.zip'], 16:02:24 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:02:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:02:24 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 16:02:24 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:02:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:02:24 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:02:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:02:24 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:02:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:02:24 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 16:02:24 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:02:24 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:02:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:02:24 INFO - https://queue.taskcluster.net/v1/task/a35TCENJTbCWCF8aykz08g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:02:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a35TCENJTbCWCF8aykz08g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:02:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a35TCENJTbCWCF8aykz08g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:02:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a35TCENJTbCWCF8aykz08g/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 16:02:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a35TCENJTbCWCF8aykz08g/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 16:02:25 INFO - Downloaded 22837929 bytes. 16:02:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:02:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 16:02:26 INFO - Return code: 0 16:02:26 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 16:02:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:02:26 INFO - https://queue.taskcluster.net/v1/task/a35TCENJTbCWCF8aykz08g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:02:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a35TCENJTbCWCF8aykz08g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:02:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a35TCENJTbCWCF8aykz08g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 16:02:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a35TCENJTbCWCF8aykz08g/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 16:02:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a35TCENJTbCWCF8aykz08g/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 16:02:28 INFO - Downloaded 22837929 bytes. 16:02:28 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'] 16:02:28 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 16:02:29 INFO - Return code: 0 16:02:29 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')]} 16:02:29 INFO - https://queue.taskcluster.net/v1/task/a35TCENJTbCWCF8aykz08g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:02:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a35TCENJTbCWCF8aykz08g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 16:02:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a35TCENJTbCWCF8aykz08g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 16:02:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a35TCENJTbCWCF8aykz08g/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 16:02:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a35TCENJTbCWCF8aykz08g/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 16:02:30 INFO - Downloaded 10834034 bytes. 16:02:30 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'] 16:02:30 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 16:02:31 INFO - Return code: 0 16:02:31 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')]} 16:02:31 INFO - https://queue.taskcluster.net/v1/task/a35TCENJTbCWCF8aykz08g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:02:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a35TCENJTbCWCF8aykz08g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:02:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a35TCENJTbCWCF8aykz08g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:02:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a35TCENJTbCWCF8aykz08g/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 16:02:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a35TCENJTbCWCF8aykz08g/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 16:02:32 INFO - Downloaded 54831234 bytes. 16:02:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a35TCENJTbCWCF8aykz08g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:02:32 INFO - mkdir: /builds/slave/test/properties 16:02:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:02:32 INFO - Writing to file /builds/slave/test/properties/build_url 16:02:32 INFO - Contents: 16:02:32 INFO - build_url:https://queue.taskcluster.net/v1/task/a35TCENJTbCWCF8aykz08g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 16:02:33 INFO - Running post-action listener: _resource_record_post_action 16:02:33 INFO - Running post-action listener: set_extra_try_arguments 16:02:33 INFO - ##### 16:02:33 INFO - ##### Finished download-and-extract step (success) 16:02:33 INFO - ##### 16:02:33 INFO - ##### 16:02:33 INFO - ##### Running populate-webroot step. 16:02:33 INFO - ##### 16:02:33 INFO - Running pre-action listener: _resource_record_pre_action 16:02:33 INFO - Running main action method: populate_webroot 16:02:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:02:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:02:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:02:33 INFO - '--tppagecycles', 16:02:33 INFO - '7'], 16:02:33 INFO - 'tests': ['tsvgm']}}, 16:02:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:02:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:02:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:02:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:02:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:02:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:02:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:02:33 INFO - 'talos_options': ['--disable-e10s'], 16:02:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:02:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:02:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:02:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:02:33 INFO - 'talos_options': ['--disable-e10s'], 16:02:33 INFO - 'tests': ['damp', 'tps']}, 16:02:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:02:33 INFO - 'tests': ['damp', 'tps']}, 16:02:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:02:33 INFO - 'tests': ['dromaeo_dom']}, 16:02:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:02:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:02:33 INFO - 'tests': ['a11yr', 16:02:33 INFO - 'ts_paint', 16:02:33 INFO - 'tpaint', 16:02:33 INFO - 'sessionrestore', 16:02:33 INFO - 'sessionrestore_no_auto_restore', 16:02:33 INFO - 'tabpaint']}, 16:02:33 INFO - 'other-e10s': {'tests': ['a11yr', 16:02:33 INFO - 'ts_paint', 16:02:33 INFO - 'tpaint', 16:02:33 INFO - 'sessionrestore', 16:02:33 INFO - 'sessionrestore_no_auto_restore', 16:02:33 INFO - 'tabpaint']}, 16:02:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:02:33 INFO - 'ts_paint', 16:02:33 INFO - 'tpaint', 16:02:33 INFO - 'sessionrestore', 16:02:33 INFO - 'sessionrestore_no_auto_restore', 16:02:33 INFO - 'tabpaint']}, 16:02:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:02:33 INFO - 'ts_paint', 16:02:33 INFO - 'tpaint', 16:02:33 INFO - 'sessionrestore', 16:02:33 INFO - 'sessionrestore_no_auto_restore', 16:02:33 INFO - 'tabpaint']}, 16:02:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:02:33 INFO - 'tests': ['a11yr', 16:02:33 INFO - 'ts_paint', 16:02:33 INFO - 'tpaint', 16:02:33 INFO - 'sessionrestore', 16:02:33 INFO - 'sessionrestore_no_auto_restore', 16:02:33 INFO - 'tabpaint']}, 16:02:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:02:33 INFO - 'tests': ['a11yr', 16:02:33 INFO - 'ts_paint', 16:02:33 INFO - 'tpaint', 16:02:33 INFO - 'sessionrestore', 16:02:33 INFO - 'sessionrestore_no_auto_restore', 16:02:33 INFO - 'tabpaint']}, 16:02:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:02:33 INFO - 'tests': ['tsvgx', 16:02:33 INFO - 'tsvgr_opacity', 16:02:33 INFO - 'tart', 16:02:33 INFO - 'tscrollx', 16:02:33 INFO - 'cart']}, 16:02:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:02:33 INFO - 'tsvgr_opacity', 16:02:33 INFO - 'tart', 16:02:33 INFO - 'tscrollx', 16:02:33 INFO - 'cart']}, 16:02:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:02:33 INFO - 'talos_options': ['--disable-e10s'], 16:02:33 INFO - 'tests': ['tp5o']}, 16:02:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:02:33 INFO - 'tests': ['tp5o']}, 16:02:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:02:33 INFO - 'talos_options': ['--disable-e10s', 16:02:33 INFO - '--xperf_path', 16:02:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:02:33 INFO - 'tests': ['tp5n']}, 16:02:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:02:33 INFO - 'talos_options': ['--xperf_path', 16:02:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:02:33 INFO - 'tests': ['tp5n']}}, 16:02:33 INFO - 'talos.zip': {'path': '', 16:02:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:02:33 INFO - Running post-action listener: _resource_record_post_action 16:02:33 INFO - ##### 16:02:33 INFO - ##### Finished populate-webroot step (success) 16:02:33 INFO - ##### 16:02:33 INFO - ##### 16:02:33 INFO - ##### Running create-virtualenv step. 16:02:33 INFO - ##### 16:02:33 INFO - Running pre-action listener: _resource_record_pre_action 16:02:33 INFO - Running main action method: create_virtualenv 16:02:33 INFO - Creating virtualenv /builds/slave/test/build/venv 16:02:33 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 16:02:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:02:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:02:33 INFO - Using real prefix '/usr' 16:02:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:02:34 INFO - Installing distribute.............................................................................................................................................................................................done. 16:02:36 INFO - Installing pip.................done. 16:02:36 INFO - Return code: 0 16:02:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:02:36 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')]} 16:02:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:02:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:36 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')]} 16:02:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:02:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:36 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 0x7f4dd556cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf4e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfdd9c0>, '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 0xfde8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfded50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464389726.939893-1090278593', '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 16:02:36 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 16:02:36 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 16:02:36 INFO - Using env: {'DISPLAY': ':0', 16:02:36 INFO - 'HOME': '/home/cltbld', 16:02:36 INFO - 'LANG': 'en_US.UTF-8', 16:02:36 INFO - 'LANGUAGE': 'en_US:en', 16:02:36 INFO - 'LOGNAME': 'cltbld', 16:02:36 INFO - 'MAIL': '/var/mail/cltbld', 16:02:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:02:36 INFO - 'MOZ_NO_REMOTE': '1', 16:02:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:02:36 INFO - 'NO_EM_RESTART': '1', 16:02:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:02:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:02:36 INFO - 'PWD': '/builds/slave/test', 16:02:36 INFO - 'SHELL': '/bin/bash', 16:02:36 INFO - 'SHLVL': '1', 16:02:36 INFO - 'TERM': 'linux', 16:02:36 INFO - 'TMOUT': '86400', 16:02:36 INFO - 'USER': 'cltbld', 16:02:36 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464389726.939893-1090278593', 16:02:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:02:36 INFO - '_': '/tools/buildbot/bin/python'} 16:02:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:02:36 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 16:02:36 INFO - Cleaning up... 16:02:36 INFO - Return code: 0 16:02:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:02:36 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')]} 16:02:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:02:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:36 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')]} 16:02:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:02:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:36 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 0x7f4dd556cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf4e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfdd9c0>, '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 0xfde8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfded50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464389726.939893-1090278593', '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 16:02:36 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 16:02:36 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 16:02:36 INFO - Using env: {'DISPLAY': ':0', 16:02:36 INFO - 'HOME': '/home/cltbld', 16:02:36 INFO - 'LANG': 'en_US.UTF-8', 16:02:36 INFO - 'LANGUAGE': 'en_US:en', 16:02:36 INFO - 'LOGNAME': 'cltbld', 16:02:36 INFO - 'MAIL': '/var/mail/cltbld', 16:02:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:02:36 INFO - 'MOZ_NO_REMOTE': '1', 16:02:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:02:36 INFO - 'NO_EM_RESTART': '1', 16:02:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:02:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:02:36 INFO - 'PWD': '/builds/slave/test', 16:02:36 INFO - 'SHELL': '/bin/bash', 16:02:36 INFO - 'SHLVL': '1', 16:02:36 INFO - 'TERM': 'linux', 16:02:36 INFO - 'TMOUT': '86400', 16:02:36 INFO - 'USER': 'cltbld', 16:02:36 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464389726.939893-1090278593', 16:02:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:02:36 INFO - '_': '/tools/buildbot/bin/python'} 16:02:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:02:36 INFO - Downloading/unpacking psutil>=3.1.1 16:02:36 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 16:02:36 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 16:02:36 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 16:02:36 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 16:02:36 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 16:02:36 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 16:02:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:02:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:02:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:02:38 INFO - Installing collected packages: psutil 16:02:38 INFO - Running setup.py install for psutil 16:02:38 INFO - building 'psutil._psutil_linux' extension 16:02:38 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 16:02:39 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 16:02:39 INFO - building 'psutil._psutil_posix' extension 16:02:39 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 16:02:39 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 16:02:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:02:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:02:39 INFO - Successfully installed psutil 16:02:39 INFO - Cleaning up... 16:02:39 INFO - Return code: 0 16:02:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:02:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:02:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:02:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:02:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:02:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:39 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 0x7f4dd556cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf4e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfdd9c0>, '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 0xfde8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfded50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464389726.939893-1090278593', '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 16:02:39 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 16:02:39 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 16:02:39 INFO - Using env: {'DISPLAY': ':0', 16:02:39 INFO - 'HOME': '/home/cltbld', 16:02:39 INFO - 'LANG': 'en_US.UTF-8', 16:02:39 INFO - 'LANGUAGE': 'en_US:en', 16:02:39 INFO - 'LOGNAME': 'cltbld', 16:02:39 INFO - 'MAIL': '/var/mail/cltbld', 16:02:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:02:39 INFO - 'MOZ_NO_REMOTE': '1', 16:02:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:02:39 INFO - 'NO_EM_RESTART': '1', 16:02:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:02:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:02:39 INFO - 'PWD': '/builds/slave/test', 16:02:39 INFO - 'SHELL': '/bin/bash', 16:02:39 INFO - 'SHLVL': '1', 16:02:39 INFO - 'TERM': 'linux', 16:02:39 INFO - 'TMOUT': '86400', 16:02:39 INFO - 'USER': 'cltbld', 16:02:39 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464389726.939893-1090278593', 16:02:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:02:39 INFO - '_': '/tools/buildbot/bin/python'} 16:02:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:02:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:02:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:02:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:02:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:02:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:02:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:02:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:02:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:02:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:02:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:02:41 INFO - Installing collected packages: mozsystemmonitor 16:02:41 INFO - Running setup.py install for mozsystemmonitor 16:02:41 INFO - Successfully installed mozsystemmonitor 16:02:41 INFO - Cleaning up... 16:02:41 INFO - Return code: 0 16:02:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:02: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')]} 16:02:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:02:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02: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')]} 16:02:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:02:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f4dd556cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf4e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfdd9c0>, '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 0xfde8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfded50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464389726.939893-1090278593', '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 16:02:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:02:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:02:41 INFO - Using env: {'DISPLAY': ':0', 16:02:41 INFO - 'HOME': '/home/cltbld', 16:02:41 INFO - 'LANG': 'en_US.UTF-8', 16:02:41 INFO - 'LANGUAGE': 'en_US:en', 16:02:41 INFO - 'LOGNAME': 'cltbld', 16:02:41 INFO - 'MAIL': '/var/mail/cltbld', 16:02:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:02:41 INFO - 'MOZ_NO_REMOTE': '1', 16:02:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:02:41 INFO - 'NO_EM_RESTART': '1', 16:02:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:02:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:02:41 INFO - 'PWD': '/builds/slave/test', 16:02:41 INFO - 'SHELL': '/bin/bash', 16:02:41 INFO - 'SHLVL': '1', 16:02:41 INFO - 'TERM': 'linux', 16:02:41 INFO - 'TMOUT': '86400', 16:02:41 INFO - 'USER': 'cltbld', 16:02:41 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464389726.939893-1090278593', 16:02:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:02:41 INFO - '_': '/tools/buildbot/bin/python'} 16:02:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:02:41 INFO - Downloading/unpacking blobuploader==1.2.4 16:02:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:02:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:02:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:02:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:02:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:02:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:02:43 INFO - Downloading blobuploader-1.2.4.tar.gz 16:02:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:02:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:02:43 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 16:02:43 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 16:02:43 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 16:02:43 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 16:02:43 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 16:02:43 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 16:02:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:02:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:02:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:02:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:02:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:02:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:02:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:02:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:02:44 INFO - Downloading docopt-0.6.1.tar.gz 16:02:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:02:44 INFO - Installing collected packages: blobuploader, requests, docopt 16:02:44 INFO - Running setup.py install for blobuploader 16:02:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:02:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:02:44 INFO - Running setup.py install for requests 16:02:45 INFO - Running setup.py install for docopt 16:02:45 INFO - Successfully installed blobuploader requests docopt 16:02:45 INFO - Cleaning up... 16:02:45 INFO - Return code: 0 16:02:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:02:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:02:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:02:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:02:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:02:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:45 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 0x7f4dd556cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf4e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfdd9c0>, '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 0xfde8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfded50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464389726.939893-1090278593', '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 16:02:45 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 16:02:45 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 16:02:45 INFO - Using env: {'DISPLAY': ':0', 16:02:45 INFO - 'HOME': '/home/cltbld', 16:02:45 INFO - 'LANG': 'en_US.UTF-8', 16:02:45 INFO - 'LANGUAGE': 'en_US:en', 16:02:45 INFO - 'LOGNAME': 'cltbld', 16:02:45 INFO - 'MAIL': '/var/mail/cltbld', 16:02:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:02:45 INFO - 'MOZ_NO_REMOTE': '1', 16:02:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:02:45 INFO - 'NO_EM_RESTART': '1', 16:02:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:02:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:02:45 INFO - 'PWD': '/builds/slave/test', 16:02:45 INFO - 'SHELL': '/bin/bash', 16:02:45 INFO - 'SHLVL': '1', 16:02:45 INFO - 'TERM': 'linux', 16:02:45 INFO - 'TMOUT': '86400', 16:02:45 INFO - 'USER': 'cltbld', 16:02:45 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464389726.939893-1090278593', 16:02:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:02:45 INFO - '_': '/tools/buildbot/bin/python'} 16:02:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:02:45 INFO - Running setup.py (path:/tmp/pip-abkNq9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:02:45 INFO - Running setup.py (path:/tmp/pip-TTuemG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:02:45 INFO - Running setup.py (path:/tmp/pip-zUNKCR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:02:45 INFO - Running setup.py (path:/tmp/pip-U2bAfo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:02:45 INFO - Running setup.py (path:/tmp/pip-GSOOv7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:02:45 INFO - Running setup.py (path:/tmp/pip-tM4PYD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:02:45 INFO - Running setup.py (path:/tmp/pip-bZgPgC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:02:45 INFO - Running setup.py (path:/tmp/pip-QnRbW5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:02:45 INFO - Running setup.py (path:/tmp/pip-jXLsGX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:02:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:02:46 INFO - Running setup.py (path:/tmp/pip-QLRt6T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:02:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:02:46 INFO - Running setup.py (path:/tmp/pip-7SBzwg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:02:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:02:46 INFO - Running setup.py (path:/tmp/pip-9NFeH6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:02:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:02:46 INFO - Running setup.py (path:/tmp/pip-vkjPny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:02:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:02:46 INFO - Running setup.py (path:/tmp/pip-m7lHSW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:02:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:02:46 INFO - Running setup.py (path:/tmp/pip-hQwySc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:02:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:02:46 INFO - Running setup.py (path:/tmp/pip-KVhyXB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:02:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:02:46 INFO - Running setup.py (path:/tmp/pip-RYExN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:02:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:02:46 INFO - Running setup.py install for manifestparser 16:02:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:02:46 INFO - Running setup.py install for mozcrash 16:02:46 INFO - Running setup.py install for mozdebug 16:02:46 INFO - Running setup.py install for mozdevice 16:02:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:02:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:02:46 INFO - Running setup.py install for mozfile 16:02:47 INFO - Running setup.py install for mozhttpd 16:02:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:02:47 INFO - Running setup.py install for mozinfo 16:02:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:02:47 INFO - Running setup.py install for mozInstall 16:02:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:02:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:02:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:02:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:02:47 INFO - Running setup.py install for mozleak 16:02:47 INFO - Running setup.py install for mozlog 16:02:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:02:47 INFO - Running setup.py install for moznetwork 16:02:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:02:47 INFO - Running setup.py install for mozprocess 16:02:47 INFO - Running setup.py install for mozprofile 16:02:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:02:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:02:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:02:47 INFO - Running setup.py install for mozrunner 16:02:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:02:48 INFO - Running setup.py install for mozscreenshot 16:02:48 INFO - Running setup.py install for moztest 16:02:48 INFO - Running setup.py install for mozversion 16:02:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:02:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:02:48 INFO - Cleaning up... 16:02:48 INFO - Return code: 0 16:02:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:02:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:02:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:02:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:02:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:02:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:48 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 0x7f4dd556cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf4e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfdd9c0>, '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 0xfde8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfded50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464389726.939893-1090278593', '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 16:02:48 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 16:02:48 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 16:02:48 INFO - Using env: {'DISPLAY': ':0', 16:02:48 INFO - 'HOME': '/home/cltbld', 16:02:48 INFO - 'LANG': 'en_US.UTF-8', 16:02:48 INFO - 'LANGUAGE': 'en_US:en', 16:02:48 INFO - 'LOGNAME': 'cltbld', 16:02:48 INFO - 'MAIL': '/var/mail/cltbld', 16:02:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:02:48 INFO - 'MOZ_NO_REMOTE': '1', 16:02:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:02:48 INFO - 'NO_EM_RESTART': '1', 16:02:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:02:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:02:48 INFO - 'PWD': '/builds/slave/test', 16:02:48 INFO - 'SHELL': '/bin/bash', 16:02:48 INFO - 'SHLVL': '1', 16:02:48 INFO - 'TERM': 'linux', 16:02:48 INFO - 'TMOUT': '86400', 16:02:48 INFO - 'USER': 'cltbld', 16:02:48 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464389726.939893-1090278593', 16:02:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:02:48 INFO - '_': '/tools/buildbot/bin/python'} 16:02:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:02:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:02:48 INFO - Running setup.py (path:/tmp/pip-aAb_Pe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:02:48 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)) 16:02:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:02:48 INFO - Running setup.py (path:/tmp/pip-ZFkY0o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:02:48 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)) 16:02:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:02:48 INFO - Running setup.py (path:/tmp/pip-9ickya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:02:48 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)) 16:02:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:02:48 INFO - Running setup.py (path:/tmp/pip-Dsbqep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:02:48 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)) 16:02:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:02:48 INFO - Running setup.py (path:/tmp/pip-NfJjGt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:02:48 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)) 16:02:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:02:48 INFO - Running setup.py (path:/tmp/pip-EJw2bx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:02:49 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)) 16:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:02:49 INFO - Running setup.py (path:/tmp/pip-Z3o0Jw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:02:49 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)) 16:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:02:49 INFO - Running setup.py (path:/tmp/pip-2sk1uM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:02:49 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)) 16:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:02:49 INFO - Running setup.py (path:/tmp/pip-5sUF0M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:02:49 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)) 16:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:02:49 INFO - Running setup.py (path:/tmp/pip-r5zmo0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:02:49 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)) 16:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:02:49 INFO - Running setup.py (path:/tmp/pip-sc_sY6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:02:49 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)) 16:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:02:49 INFO - Running setup.py (path:/tmp/pip-X65hFL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:02:49 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)) 16:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:02:49 INFO - Running setup.py (path:/tmp/pip-2S3WsE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:02:49 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)) 16:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:02:49 INFO - Running setup.py (path:/tmp/pip-GxODKz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:02:49 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)) 16:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:02:49 INFO - Running setup.py (path:/tmp/pip-afh_74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:02:49 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)) 16:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:02:49 INFO - Running setup.py (path:/tmp/pip-ze1kAH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:02:49 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)) 16:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:02:49 INFO - Running setup.py (path:/tmp/pip-Jhjjia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:02:49 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)) 16:02:49 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)) 16:02:49 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)) 16:02:49 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)) 16:02:49 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)) 16:02:49 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)) 16:02:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:02:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:02:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:02:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:02:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:02:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:02:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:02:51 INFO - Downloading blessings-1.6.tar.gz 16:02:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:02:51 INFO - Installing collected packages: blessings 16:02:51 INFO - Running setup.py install for blessings 16:02:51 INFO - Successfully installed blessings 16:02:51 INFO - Cleaning up... 16:02:51 INFO - Return code: 0 16:02:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:02:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:02:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:02:52 INFO - Reading from file tmpfile_stdout 16:02:52 INFO - Current package versions: 16:02:52 INFO - argparse == 1.2.1 16:02:52 INFO - blessings == 1.6 16:02:52 INFO - blobuploader == 1.2.4 16:02:52 INFO - docopt == 0.6.1 16:02:52 INFO - manifestparser == 1.1 16:02:52 INFO - mozInstall == 1.12 16:02:52 INFO - mozcrash == 0.17 16:02:52 INFO - mozdebug == 0.1 16:02:52 INFO - mozdevice == 0.48 16:02:52 INFO - mozfile == 1.2 16:02:52 INFO - mozhttpd == 0.7 16:02:52 INFO - mozinfo == 0.9 16:02:52 INFO - mozleak == 0.1 16:02:52 INFO - mozlog == 3.2 16:02:52 INFO - moznetwork == 0.27 16:02:52 INFO - mozprocess == 0.22 16:02:52 INFO - mozprofile == 0.28 16:02:52 INFO - mozrunner == 6.11 16:02:52 INFO - mozscreenshot == 0.1 16:02:52 INFO - mozsystemmonitor == 0.3 16:02:52 INFO - moztest == 0.7 16:02:52 INFO - mozversion == 1.4 16:02:52 INFO - psutil == 3.1.1 16:02:52 INFO - requests == 1.2.3 16:02:52 INFO - wsgiref == 0.1.2 16:02:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:02:52 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')]} 16:02:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:02:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:52 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')]} 16:02:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:02:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:52 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 0x7f4dd556cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf4e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfdd9c0>, '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 0xfde8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfded50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464389726.939893-1090278593', '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 16:02:52 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 16:02:52 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 16:02:52 INFO - Using env: {'DISPLAY': ':0', 16:02:52 INFO - 'HOME': '/home/cltbld', 16:02:52 INFO - 'LANG': 'en_US.UTF-8', 16:02:52 INFO - 'LANGUAGE': 'en_US:en', 16:02:52 INFO - 'LOGNAME': 'cltbld', 16:02:52 INFO - 'MAIL': '/var/mail/cltbld', 16:02:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:02:52 INFO - 'MOZ_NO_REMOTE': '1', 16:02:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:02:52 INFO - 'NO_EM_RESTART': '1', 16:02:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:02:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:02:52 INFO - 'PWD': '/builds/slave/test', 16:02:52 INFO - 'SHELL': '/bin/bash', 16:02:52 INFO - 'SHLVL': '1', 16:02:52 INFO - 'TERM': 'linux', 16:02:52 INFO - 'TMOUT': '86400', 16:02:52 INFO - 'USER': 'cltbld', 16:02:52 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464389726.939893-1090278593', 16:02:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:02:52 INFO - '_': '/tools/buildbot/bin/python'} 16:02:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:02:52 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)) 16:02:52 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)) 16:02:52 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)) 16:02:52 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)) 16:02:52 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)) 16:02:52 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)) 16:02:52 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)) 16:02:52 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)) 16:02:52 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)) 16:02:52 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)) 16:02:52 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)) 16:02:52 INFO - Cleaning up... 16:02:52 INFO - Return code: 0 16:02:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:02:52 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')]} 16:02:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:02:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:52 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')]} 16:02:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:02:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:52 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 0x7f4dd556cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf4e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfdd9c0>, '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 0xfde8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfded50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464389726.939893-1090278593', '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 16:02:52 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 16:02:52 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 16:02:52 INFO - Using env: {'DISPLAY': ':0', 16:02:52 INFO - 'HOME': '/home/cltbld', 16:02:52 INFO - 'LANG': 'en_US.UTF-8', 16:02:52 INFO - 'LANGUAGE': 'en_US:en', 16:02:52 INFO - 'LOGNAME': 'cltbld', 16:02:52 INFO - 'MAIL': '/var/mail/cltbld', 16:02:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:02:52 INFO - 'MOZ_NO_REMOTE': '1', 16:02:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:02:52 INFO - 'NO_EM_RESTART': '1', 16:02:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:02:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:02:52 INFO - 'PWD': '/builds/slave/test', 16:02:52 INFO - 'SHELL': '/bin/bash', 16:02:52 INFO - 'SHLVL': '1', 16:02:52 INFO - 'TERM': 'linux', 16:02:52 INFO - 'TMOUT': '86400', 16:02:52 INFO - 'USER': 'cltbld', 16:02:52 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464389726.939893-1090278593', 16:02:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:02:52 INFO - '_': '/tools/buildbot/bin/python'} 16:02:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:02:52 INFO - Downloading/unpacking jsonschema 16:02:52 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 16:02:52 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 16:02:52 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 16:02:52 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 16:02:52 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 16:02:52 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 16:02:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:02:54 INFO - Downloading/unpacking functools32 (from jsonschema) 16:02:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:02:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:02:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:02:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:02:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:02:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:02:54 INFO - Downloading functools32-3.2.3-2.tar.gz 16:02:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:02:54 INFO - warning: no files found matching '*.txt' 16:02:54 INFO - no previously-included directories found matching 'build' 16:02:54 INFO - no previously-included directories found matching 'dist' 16:02:54 INFO - no previously-included directories found matching '.git*' 16:02:54 INFO - Installing collected packages: jsonschema, functools32 16:02:54 INFO - Running setup.py install for functools32 16:02:54 INFO - warning: no files found matching '*.txt' 16:02:54 INFO - no previously-included directories found matching 'build' 16:02:54 INFO - no previously-included directories found matching 'dist' 16:02:54 INFO - no previously-included directories found matching '.git*' 16:02:54 INFO - Successfully installed jsonschema functools32 16:02:54 INFO - Cleaning up... 16:02:54 INFO - Return code: 0 16:02:54 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:02:54 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')]} 16:02:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:02:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:54 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')]} 16:02:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:02:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:02:54 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 0x7f4dd556cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf4e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfdd9c0>, '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 0xfde8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfded50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464389726.939893-1090278593', '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 16:02:54 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 16:02:54 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 16:02:54 INFO - Using env: {'DISPLAY': ':0', 16:02:54 INFO - 'HOME': '/home/cltbld', 16:02:54 INFO - 'LANG': 'en_US.UTF-8', 16:02:54 INFO - 'LANGUAGE': 'en_US:en', 16:02:54 INFO - 'LOGNAME': 'cltbld', 16:02:54 INFO - 'MAIL': '/var/mail/cltbld', 16:02:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:02:54 INFO - 'MOZ_NO_REMOTE': '1', 16:02:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:02:54 INFO - 'NO_EM_RESTART': '1', 16:02:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:02:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:02:54 INFO - 'PWD': '/builds/slave/test', 16:02:54 INFO - 'SHELL': '/bin/bash', 16:02:54 INFO - 'SHLVL': '1', 16:02:54 INFO - 'TERM': 'linux', 16:02:54 INFO - 'TMOUT': '86400', 16:02:54 INFO - 'USER': 'cltbld', 16:02:54 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464389726.939893-1090278593', 16:02:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:02:54 INFO - '_': '/tools/buildbot/bin/python'} 16:02:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:02:55 INFO - Downloading/unpacking flake8 16:02:55 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 16:02:55 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 16:02:55 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 16:02:55 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 16:02:55 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 16:02:55 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 16:02:57 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:02:57 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:02: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 16:02: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 16:02: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 16:02: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 16:02: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 16:02: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 16:02:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:02:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:02: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 16:02: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 16:02: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 16:02: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 16:02: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 16:02: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 16:02:57 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:02: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 16:02: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 16:02: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 16:02: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 16:02: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 16:02: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 16:02:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:02:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:02:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:02:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:02:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:02:57 INFO - no previously-included directories found matching 'docs/_build' 16:02:57 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:02:57 INFO - Running setup.py install for pep8 16:02:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:02:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:02:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:02:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:02:57 INFO - no previously-included directories found matching 'docs/_build' 16:02:57 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:02:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:02:57 INFO - Cleaning up... 16:02:58 INFO - Return code: 0 16:02:58 INFO - Running post-action listener: _resource_record_post_action 16:02:58 INFO - Running post-action listener: _start_resource_monitoring 16:02:58 INFO - Starting resource monitoring. 16:02:58 INFO - ##### 16:02:58 INFO - ##### Finished create-virtualenv step (success) 16:02:58 INFO - ##### 16:02:58 INFO - ##### 16:02:58 INFO - ##### Running install step. 16:02:58 INFO - ##### 16:02:58 INFO - Running pre-action listener: _resource_record_pre_action 16:02:58 INFO - Running main action method: install 16:02:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:02:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:02:58 INFO - Reading from file tmpfile_stdout 16:02:58 INFO - Detecting whether we're running mozinstall >=1.0... 16:02:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:02:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:02:58 INFO - Reading from file tmpfile_stdout 16:02:58 INFO - Output received: 16:02:58 INFO - Usage: mozinstall [options] installer 16:02:58 INFO - Options: 16:02:58 INFO - -h, --help show this help message and exit 16:02:58 INFO - -d DEST, --destination=DEST 16:02:58 INFO - Directory to install application into. [default: 16:02:58 INFO - "/builds/slave/test"] 16:02:58 INFO - --app=APP Application being installed. [default: firefox] 16:02:58 INFO - mkdir: /builds/slave/test/build/application 16:02:58 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'] 16:02:58 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 16:03:14 INFO - Reading from file tmpfile_stdout 16:03:14 INFO - Output received: 16:03:14 INFO - /builds/slave/test/build/application/firefox/firefox 16:03:14 INFO - Running post-action listener: _resource_record_post_action 16:03:14 INFO - ##### 16:03:14 INFO - ##### Finished install step (success) 16:03:14 INFO - ##### 16:03:14 INFO - ##### 16:03:14 INFO - ##### Running run-tests step. 16:03:14 INFO - ##### 16:03:14 INFO - Running pre-action listener: _resource_record_pre_action 16:03:14 INFO - Running main action method: run_tests 16:03:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:03:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:03:14 INFO - Python 2.7.3 16:03:14 INFO - Return code: 0 16:03:14 INFO - grabbing minidump binary from tooltool 16:03:14 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')]} 16:03:14 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 0xfdd9c0>, '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 0xfde8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfded50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:03:14 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 16:03:14 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 16:03:14 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 16:03:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:03:14 INFO - Return code: 0 16:03:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:03:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:03:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:03:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:03:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:03:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:03:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:03:15 INFO - Return code: 0 16:03:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a35TCENJTbCWCF8aykz08g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 16:03:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/a35TCENJTbCWCF8aykz08g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:03:15 INFO - Using env: {'DISPLAY': ':0', 16:03:15 INFO - 'HOME': '/home/cltbld', 16:03:15 INFO - 'LANG': 'en_US.UTF-8', 16:03:15 INFO - 'LANGUAGE': 'en_US:en', 16:03:15 INFO - 'LOGNAME': 'cltbld', 16:03:15 INFO - 'MAIL': '/var/mail/cltbld', 16:03:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:03:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:03:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:03:15 INFO - 'MOZ_NO_REMOTE': '1', 16:03:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:03:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:03:15 INFO - 'NO_EM_RESTART': '1', 16:03:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:03:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:03:15 INFO - 'PWD': '/builds/slave/test', 16:03:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:03:15 INFO - 'SHELL': '/bin/bash', 16:03:15 INFO - 'SHLVL': '1', 16:03:15 INFO - 'TERM': 'linux', 16:03:15 INFO - 'TMOUT': '86400', 16:03:15 INFO - 'USER': 'cltbld', 16:03:15 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464389726.939893-1090278593', 16:03:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:03:15 INFO - '_': '/tools/buildbot/bin/python'} 16:03:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a35TCENJTbCWCF8aykz08g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:03:15 INFO - mozversion application_buildid: 20160527144251 16:03:15 INFO - mozversion application_changeset: ea15028498ed95677844fb7f30be5efcaf8b2621 16:03:15 INFO - mozversion application_display_name: Nightly 16:03:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:03:15 INFO - mozversion application_name: Firefox 16:03:15 INFO - mozversion application_remotingname: firefox 16:03:15 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:03:15 INFO - mozversion application_vendor: Mozilla 16:03:15 INFO - mozversion application_version: 49.0a1 16:03:15 INFO - mozversion platform_buildid: 20160527144251 16:03:15 INFO - mozversion platform_changeset: ea15028498ed95677844fb7f30be5efcaf8b2621 16:03:15 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:03:15 INFO - mozversion platform_version: 49.0a1 16:03:15 INFO - using testdate: 1464390195 16:03:15 INFO - actual date: 1464390195 16:03:15 INFO - starting webserver on 'localhost:51868' 16:03:15 INFO - SUITE-START | Running 2 tests 16:03:15 INFO - TEST-START | dromaeo_css 16:03:15 INFO - operating with platform_type : linux_ 16:03:15 INFO - Initialising browser for dromaeo_css test... 16:03:15 INFO - TEST-INFO | started process 11913 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgTPNuN/profile http://localhost:51868/getInfo.html) 16:03:19 INFO - PROCESS | 11913 | 16:03:19 INFO - PROCESS | 11913 | (process:11979): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:03:20 INFO - PROCESS | 11913 | __metrics Screen width/height:1600/1200 16:03:20 INFO - PROCESS | 11913 | colorDepth:24 16:03:20 INFO - PROCESS | 11913 | Browser inner width/height: 1024/697 16:03:20 INFO - PROCESS | 11913 | __metrics 16:03:21 ERROR - PROCESS | 11913 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 16:03:22 INFO - TEST-INFO | 11913: exit 0 16:03:22 INFO - Browser initialized. 16:03:22 INFO - Running cycle 1/1 for dromaeo_css test... 16:03:22 INFO - TEST-INFO | started process 12030 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgTPNuN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:03:24 INFO - PROCESS | 12030 | 16:03:24 INFO - PROCESS | 12030 | (process:12090): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:03:34 INFO - PROCESS | 12030 | RSS: Main: 167632896 16:03:34 INFO - PROCESS | 12030 | 16:04:23 INFO - PROCESS | 12030 | 1464390263988 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] 16:06:36 INFO - PROCESS | 12030 | Cycle 1(1): loaded http://localhost:51868/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51868/tests/dromaeo/cssquery-ext.html) 16:06:36 INFO - PROCESS | 12030 | RSS: Main: 170364928 16:06:36 INFO - PROCESS | 12030 | 16:09:38 INFO - PROCESS | 12030 | Cycle 1(1): loaded http://localhost:51868/tests/dromaeo/cssquery-ext.html (next: http://localhost:51868/tests/dromaeo/cssquery-jquery.html) 16:09:39 INFO - PROCESS | 12030 | RSS: Main: 169762816 16:09:39 INFO - PROCESS | 12030 | 16:12:41 INFO - PROCESS | 12030 | Cycle 1(1): loaded http://localhost:51868/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51868/tests/dromaeo/cssquery-mootools.html) 16:12:42 INFO - PROCESS | 12030 | RSS: Main: 170672128 16:12:42 INFO - PROCESS | 12030 | 16:15:44 INFO - PROCESS | 12030 | Cycle 1(1): loaded http://localhost:51868/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51868/tests/dromaeo/cssquery-prototype.html) 16:15:44 INFO - PROCESS | 12030 | RSS: Main: 168255488 16:15:44 INFO - PROCESS | 12030 | 16:18:47 INFO - PROCESS | 12030 | Cycle 1(1): loaded http://localhost:51868/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51868/tests/dromaeo/cssquery-yui.html) 16:18:48 INFO - PROCESS | 12030 | RSS: Main: 170401792 16:18:48 INFO - PROCESS | 12030 | 16:21:50 INFO - PROCESS | 12030 | Cycle 1(1): loaded http://localhost:51868/tests/dromaeo/cssquery-yui.html (next: http://localhost:51868/tests/dromaeo/cssquery-dojo.html) 16:21:50 INFO - PROCESS | 12030 | RSS: Main: 171446272 16:21:50 INFO - PROCESS | 12030 | 16:21:50 INFO - PROCESS | 12030 | __start_tp_report 16:21:50 INFO - PROCESS | 12030 | _x_x_mozilla_page_load 16:21:50 INFO - PROCESS | 12030 | _x_x_mozilla_page_load_details 16:21:50 INFO - PROCESS | 12030 | |i|pagename|runs| 16:21:50 INFO - PROCESS | 12030 | |0;dojo.html;2659.2687011071953;2709.39038716289;2719.6464459620247;2735.972640273598;2737.1241202815095;4710.90578188436;4774.37933068701;4838.371011768474;4852.85441436757;4875.902481950359;4725.456572494164;4757.952420475803;4787.234042553192;4832.468428472874;4838.056578967094;4409.669274804394;4477.059817438326;4494.1910456117885;4510.954890451103;4515.435570553681;4519.638428925678;4546.61353784927;4559.293309537027;4566.223741963858;4607.562281583244;4208;4527.388802511652;4551.13528429599;4566.589006989387;4594.081183763227;4484.349769283468;4501.122281155176;4504.842330518416;4508.932366014513;4551.249043907751;4409.669274804402;4440.955590444119;4468.151051300242;4491.595756381941;4507.098580283923;4717.339572459859;4801.399825021872;4802.807887684488;4809.23052311632;4847.345608342864;5230.293910322096;5250.490283472976;5269.789208431658;5270.341207349082;5305.071612467841;5198.870028249286;5238.319018527567;5267.341582302212;5274.947250527484;5296.09966305729;4876.292937524039;4903.803847846082;4918.778654960535;4920.3111564381015;4942.802287908444;5374.892502149935;5394.1099718546;5401.783928642889;5406.6215364924865;5409.134538473825;5049;5107.106256405114;5149.6910185389;5153.948460515422;5171.7672704728375;5228.137357336073;5255.527002569787;5264.447233040552;5267.920981185285;5308.362996440452;4943.1596628573225;5184.300119483897;5184.7407629618365;5185.688858668492;5186.40356359016;5136.717480538607;5137.5376216139975;5172.7155006475;5175.353080864892;5176.249443830623;4286.957130428718;4353.085851971058;4358.629516491071;4397.934030989538;4405.889852753643;3781.7541859779026;3861.131245469747;3897.142628621699;3898.8440462381186;3899.5515515715488;4430.246858034142;4449.3993310902615;4478.664100192434;4483.865484035419;4493.640508759291;5204.375474943031;5211.557017653542;5217.869553261123;5220.321358223407;5265.894682106336;4365.585269399402;4465.754383508938;4479.037007043501;4484.932726009112;4509.594136527729;4712.057588482317;4715.0805592909055;4717.551832575899;4717.599004084691;4732.124556956974;4955.157623204136;4957.6281778866005;4964.478729733398;4970.950290497049;4991.051700177028;5123.948760512496;5141.640085194001;5156.04613146569;5297.9139276449005;5325.866853328698;4864.61083113343;4873.610111191168;4895.020995800783;4902.583280421061;4932.7286999215385;5115.590752739847;5122.334096567572;5127.692338459704;5127.948720512747;5135.409427915688;5118.925025744636;5153.2270159476375;5160.572668629904;5168.53483186515;5185.688858668492;5007.39911210657;5009.148444764472;5055.16589762685;5068.163752980717;5108.080545501845;5028.120078986236;5033.496650334937;5058.721770302669;5068.214426763858;5090.847274581768;4870.05034018363;5008.549230569266;5012.649114562091;5034.395872495324;5105.081085404663;5057.31726216956;5081.949180508295;5132.923006154985;5142.485751424828;5152.845414637567;4868.926966095441;5036.899262014813;5043.697378157322;5054.393472783289;5097.643164978416 16:21:50 INFO - PROCESS | 12030 | |1;ext.html;557.3200695151913;598.787430462186;602.6866029664571;614.1064750787606;617.3486971245335;28357.291067723316;40741.79629101854;41454.17091658165;41683.58316416838;41785.7910710446;42392.152156956916;42914.78542607283;42938.355924661075;43062.78468607661;43173;7788.493747906382;8009.879851802228;8027.197280271956;8035.718749843757;8051.879221811678;7864;7981.561014144219;7990.840183196333;7998.12020677725;8012.359011279113;7984.880226796603;8059.556724380157;8062.395320350997;8075.3539716822515;8080.919190808105;7964.482308649919;8007.759767206964;8011.399145064114;8014.839703205961;8023.277904988579;7937.126916039231;8018.799530011738;8020.438569300151;8023.358131349478;8023.879641805378;39356.40965385522;39644.20711585781;39699.20601587952;39753.80123099395;39806.20387592232;3008.39832033592;3230.8869189578486;3414.556107706007;3424.400729872262;3593.443016332473;29261.414771704447;29478.11565653034;30328.393432131234;30642.23394415135;30677.23306917345;3077.4460597092516;3078.1073488688253;3099.4730895747775;3104.068779366181;3147.8111313321274;243308;244116;244382;246439;247107;28728.712712872602;29506.409871802873;54626.180607290924;55169;55349.446505535234;34470.31059378848;34549.309013819584;34564;34772;34778;12612.873871261354;12730.363481825872;12730.936345318214;12794.040446966515;12875.163114397534;10281.383117012854;10306.793864122676;10314.845277320695;10315.329503582243;10356.585736570603;7987.1613480584865;7990.720324788605;8010.3191228745045;8058.919410805817;8077.192280771993;3136.8588413521447;3175.984120079385;3185.426623207845;3209.3099983503657;3226.596675415573;858.5063588436674;874.4490970688425;921.3596550397409;1022.7647641042453;1030.196263305464;29338.100213420355;29341.119766407042;29449;29541.704582954324;29774.851125744233;960.500539719342;976.9853452198223;997.4264797741328;1023.8515415264745;1113.9944300278446;14917.403303867724;15025.474108406153;15202.163880986653;15337.923310383376;15510.379584816481;364941;366634;367106;367580;368548;50369;50746.23880641793;51130.233046504334;51138.744306278975;51258;1209.3832145605804;1214.423149004216;1242.5588915934713;1251.5494422008069;1262.8042653388738;26735;27639.447211055263;27711.58432623472;28226.2943426416;28392.432151356443;42860.14279714326;43052.56947430486;43153.7842310799;43268.35097473604;43277.783611083;319035;319652;320356;321038;321351;25171.622425663263;25436.491270174123;25828;25986.480270394863;26020.739792602588;42701;43125;43353;43581.12837743164;43750.12499749923;36663.45004824983;37398.8130059348;37637.24725505529;37706.245875082896;37848;34897.8255108733;35110.29779404448;35456.82271588729;35737.463938041474;36251.09372265609;33547.3290534183;36112.27775444529;36473.27053458863;36827.07932301714;37210;32661.836690816395;34006.82996585001;34011.82994085014;34138.31723365469;34284.65715342815;25562.36094097588;25991.870040649676;26000.219993400227;26129;26468.205953821416 16:21:50 INFO - PROCESS | 12030 | |2;jquery.html;361.8643008871673;362.77689221129003;368.3903140302799;373.1473582863158;395.9821808018639;15875.285612147452;16552.172391380427;17283.74074388885;17315.134243287815;17341.653166936685;14492.565223043299;16390.83609163908;16993.57516062096;17025.82974170258;17055.317787288495;5019.698818070919;5176.120059589879;5217.3217481727515;5219.739013049351;5223.6343455958095;3762.623737626243;5116.872078198037;5682.715864206773;6041.4562689357945;6057.42454466825;6067.059605761114;6070.2412198475195;6099.57302988791;6107.267127944653;6116.877662446748;4998.125328067592;5336.252924590561;5343.011542864563;5401.297831281908;5438.265834112383;5042.546170844642;5229.869253268661;5456.181572764117;5478.726063696799;5512.586556008316;12597.055220858472;12713.17364371313;15069.171195584238;20015.699764503544;20180.596388072303;1626.7641192027208;1746.2142036083812;1788.6959216933024;1798.2267624921278;1844.446666000208;9463.016124939708;9580.0898914603;11230.045446137088;11497.5975840846;13227.933860330733;1776.1740790532465;1808.3038030358275;1862.4971257760328;1891.6405882882345;1919.2323070771663;64353.356466435675;64934.02598961019;65006.67496662534;66043;70153.64923175403;9277.16505514507;9603.855942160873;9750.26872984529;9837.508124593742;10023.749406264757;13250.602481925558;13276.800847987288;13297.601071967856;13436.395362208725;13437.529686460926;6763.661816909135;6846.726130954706;6924.792256232321;6955.130608673916;7024.1571011478945;6557.475401967831;6595.538312318092;6613.603183808987;6691.330866913367;6692.531522793455;3948.072203032285;3988.3419235825763;4033.4554835096887;4057.715959882839;4093.4678491795876;1551.9689606207812;1759.9560010999828;1837.200817644329;1872.8314451699412;1898.4494496596108;768.7539987204041;883.8630012348096;909.4543274035658;922.2898368256405;990.3067852503276;15603.375864965274;16567.834321656628;16772.916135419488;16870.409535666193;16950.745738813683;848.1730312944952;859.8968123825181;860.414917855864;861.3841103610823;887.7026196224208;9297;9519.809603807886;9529.38059026175;9603.855942160873;9720;356179;378541;380983;381645;382310;73182.26817731754;74630.25369746341;74634.62682686551;75397.24602754012;76434.23565764271;901.454619954931;904.4934836491586;906.6509393883402;927.1146055516965;935.7941252924346;14622.853771462575;14843.554693359216;15098.245087745348;15235.466758663393;15296;34647.65352346444;34827.30345393129;35145.297094058486;35887.82056089703;36575.45136823003;49828.50171498238;49980.500194997585;50088.74955625198;50091.49908500868;50674.49325506845;5693.658380497183;7324.890126647998;7696.114946781192;7858.803529911798;7860.938773265536;10504.684859454228;11488.94255528717;11595.246308989888;11783.175177737476;11807.23252988553;9598.568064437257;9618.374805637612;9705.757356066155;9854.507274636382;9920.107190352903;5562.082256427644;7431.516951398142;9790.902090979;10165.695029148841;10403.895961040293;9206.711060451407;9542.904570954202;9823.165030972448;9942.254330925065;10192.643257485952;7722;7749.341305988829;7811.101723301893;7843.882341764992;7863.921360786548;7227.385672217921;8420.36847236472;9242.676506322246;9314.860277095713;9665.758356041155 16:21:50 INFO - PROCESS | 12030 | |3;mootools.html;1439.8992070555062;1459.5183589415494;1582.5727053695502;1775.5649865782884;1782.8484578810792;6950.79147625572;7588.468807183499;7713.305802477776;8130.390220733454;8143.226393492623;7740.458167928247;8003.359731221502;8020.157883422245;8033.317168040723;8036;2212.081985975822;2231.0518029837335;2244.8204143668468;2244.842860999731;2258.4128126687015;2214.1032881682945;2215.268961242786;2271.8864056797092;2278.601244782165;2284.6915666385075;2225.8219342452567;2236.6197746383073;2237.8881055947218;2244.8540844845033;2268.5576312619046;2043.417625976597;2044.1108117968656;2044.6217449771839;2048.8258498027685;2050.323393280229;2147.420196546939;2173.7500187478486;2181.4437318483842;2199.538096999632;2201.9889900550393;7935.285824275843;7979.800504987364;7995.160508146677;7996.200379961957;8012.759617211493;4750.216214324632;4866.7566621668775;4875.488073752241;4877.268409738532;4878.804847806084;2903.3757742085554;2956.911292661224;3075.0159948816386;3078.215055160942;3082.029160814336;941.2328951904176;974.6296407365227;976.0922342221731;982.1602529836958;990.6136606723384;10842.132629389629;10852.131829453625;10879.292845964987;10930.344179349186;10934.179936504794;4268.381084742695;4378.496472905593;4457.866264012085;4470.441194850644;4480.61914737251;9368.484733339732;9378.906210937803;9396.154346108746;9420.34057615974;9438.669646562337;4828.830990915301;4834.347363106006;4834.95165048345;4879.780409881564;4905.533974272438;3658.8719394821055;4300.4839419269265;4454.3986561813745;4468.419105516327;4484.2376795944765;3671.155634204148;3686;3707.2214834884435;3783.2622638585763;3789.8105094745706;1232.778099942001;1258.2010423381219;1258.5657948007922;1261.8296529968336;1265.829113069742;734.8126227811874;772.818387678895;773.5242825662177;844.7043534762784;906.1482206725657;5463.890722185534;5478.945210547843;5556.555475561945;5598.1322894951345;5639.689817060019;902.4134312696799;916.3081873185836;925.7779730755339;927.9257659387233;963.2631037256505;3843.673287770571;3869.903252418712;3891.3190191716903;3961.207758448264;4010.358342665218;9692;9882.25883058759;9964.551595178234;9971.501424928725;10007.199424046059;9622.182114520345;9678.370905891095;9755.804883902283;9766.365186263012;9888.456134912649;7077.646117694095;7271.963640181765;7367.81580460482;7461.1419686735635;7475.962620186864;5530.751116199861;5618.775248989995;5773.711314434177;5872.559558033079;5877.2947246329;8651.091635378447;8826.735197944072;9138.68014619485;9139.680111196076;9158.084191581054;9092.181703646704;9121.726348209564;9196.218321442751;9264.583093760662;9270.490123043297;6298.874022519615;6689.632070236184;6698.698558564779;6828.248892621907;6924;7703.807404814925;7750.806229844074;7762.990811194509;7785.688572457038;7799.688012479437;6727.697253623501;6882.346177113166;6913.3777959983845;6984.580925144508;7058.153021637437;6673.165854268216;6690.665466726547;6781.762638307833;6846.452283817183;6865.27914568963;6309.558330916791;6568.507361947969;6641.169853768279;6659.733610655713;6699.464042876656;4495.730256184639;4623.815047398201;4733.053389322218;4862.878428039327;4958.652894297365;4775.116603428377;4877.219644856806;4894.853154405374;4916.410030796327;4919.237518184687 16:21:50 INFO - PROCESS | 12030 | |4;prototype.html;293.9500284951558;298.0403102011523;307.649279821004;312.8529591092187;313.6236516180584;5054.924176137356;5063.240513922913;5065.822696205633;5070.746462676865;5082.720450375228;4990.975045124769;5001.499850014997;5009.774560144793;5025.522575355335;5060.190369540875;3674.540682414705;3741.2330472253257;3856.633619806114;3864.381698928172;3867.4778904847767;3860.4981352424147;3863.594322596115;3880.1287047584724;3890.7239265029993;3901.9804900975455;3865.226954609075;3882.7282090253693;3886.1061955750192;3898.298306304864;3898.688104951597;3806.6764325032127;3864.6908247340425;3873.341531939549;3892.2604705106082;3893.240818040469;3365.6297807241185;3390.779599326036;3403.0981789825714;3403.540522029544;3406.4670898095956;4803.759812009421;4816.590589799871;4818.879528011793;4827.565519103263;4862.586680132193;4425.402570652953;4471.597556219956;4503.842365517224;4506.662000349987;4512.278035514335;4885.7068575885205;5161.303224064778;5193.792248310063;5197.8440646780655;5218.208258581641;3556.3242983833247;3620.4388319810473;3641.2717456508803;3643.763155394891;3656.4698118772894;5508.614396992212;5510.972445137789;5548.77804887808;5562.527185189264;5579.0515612346;3662.304162209172;3769.359208934488;3771.30230907283;3772.245550889833;3785.564660064073;3818.0645741793437;3830.2531006453473;3831.3295173344554;3850.7497012694644;3851.6340947609933;4405.559444055633;4407.338899165151;4418.823247070081;4424.955750442518;4432.49026361966;5142.331496905378;5198;5201.1678131498775;5294.894102117936;5317.308749862493;1268.429206856918;1281.3080936294482;1282.4165004922738;1283.9679008024875;1289.9226046437243;821.9835603287901;822.2558584481054;828.1387357148618;828.5732847583499;835.8966164662587;4452.332150177499;4549.340345649928;4588.403507543998;4619.376384188159;4620.561046700558;5414.187871819258;5455.34535855692;5478.698671573102;5479.780808767684;5484.396716361197;4412.492563355191;4527.864164075083;4592.6555508337005;4605.861824145281;4613.815447382067;2877.856107194632;2882.207392966951;2888.306806366457;2900;2908.185708001763;5078.374920025556;5102.719350435762;5103.311053007871;5122.743862806845;5126.692988155345;5213.2701421800975;5533;5594.692291923902;5617.662940223599;5620.988222120058;5122.743862806919;5124.513171248651;5129.384473863161;5143.3570803649545;5149.562287205629;5453.890922181614;5475.534579560782;5480.013597552479;5502.174673798802;5515.669059856422;5233.319668443078;5343.599230057684;5344.438833922538;5362.552110929949;5366.651167674088;5119.97600479898;5121.641485096007;5121.8719532012;5139;5143.5113664201845;3749.1564398010228;3760.247950409874;3774.698024158116;3785.0537365658583;3795.7342985990717;5255.500727430888;5436.184572314184;5439.265699130567;5456.317960254968;5465.781368745205;5291.629585928948;5292.285541451854;5298.8940221196135;5306.328506520434;5328.813491527933;5278.2346559749385;5303.946960530499;5306.708131052675;5314.468553144655;5318.228856815817;5016.498350164954;5245.973770131125;5254.65844720092;5256.868578285574;5286.920696189483;5089.821856235014;5115;5276.762545685377;5295.708736019402;5342.6260161788305;5159.484051594811;5195.948040519697;5204.843854684365;5207.3230480038865;5207.713575753219 16:21:50 INFO - PROCESS | 12030 | |5;yui.html;609.3266940031266;636.742119441626;660.9834754131149;721.4877437019716;723.9058922340095;11608.767824643503;12048.277103373804;12167.209131406464;12219.327936963464;13250.801237981414;12539.874601253985;12711.42798574064;12735.745285094292;12745.107842451009;12758.106932514704;635.5074817016803;796.2555011064674;796.7490240574215;806.2703253555542;817.1215942861418;784.1022029775903;786.3669745854585;789.498668345599;789.889415481833;790.4664351562701;842.9072801991776;844.1305455380967;849.6771226933787;849.8725191221305;850.3877208409934;840.0171798995191;844.8605980013291;845.8308338332358;846.7459762071354;848.3043903998723;620.8851362497907;621.034291676443;621.4220774679546;621.872516134196;622.3309941812524;12484.063695222894;12508.49966001359;12518.561850335194;12548.309842958633;12565.811512827315;12410.379481025913;12658.303793291365;12767.808482872764;12779.872201277962;12905.749699169537;9345.859812102824;9429.622815087389;9445.386049906734;9475.66835160773;9523.761905952337;3179.8410079496166;3240.54632351471;3265.297960938386;3273.9672603273902;3276.4921437177277;41907.37138942918;43657.56342436567;45382.09235815265;45390.546094538964;45483;9717;9940.353876997971;9951.80096398068;9952;10056.396616203052;17076.573085672957;17130.057846818294;17185.398511052303;17219.827801722073;17353.2191051403;6329.651869147241;6335.746570137235;6547.345265473415;6705.6982435790505;6740.258571557125;3549.982250088733;3591.7844929304324;3654.926901461956;3673.7979411132646;3709.0912726382207;2918.1974956887025;3012.6836682148496;3013.5931649227514;3021.5165573508134;3021.9244518886762;532.4701921587967;534.3907944942769;535.0369335196631;540.7701726766109;551.0907003444349;588.4409810679871;595.5625142449409;604.3141034925303;608.6500262349167;630.6531407725824;7245.492815502969;7249.166345870187;7281.381082607932;7453.925460745323;7562.281583249583;575.3067553597905;575.7610591604521;577.8353169346716;578.3753546170126;596.8583278068711;3707.740458167956;3777;3806.238752249561;3842.3275926712713;3848;54629.45370546323;56381.43618563762;57447.71276143593;57782.13326800102;57805;50611;50709.492905070474;51009.23486147711;52028.21957670638;52093.218601721004;45528.772356138004;47078;47784.761076194394;48035.519644803804;48507.27239091487;8138.715144969898;8151.347892168731;8189.959050204711;8275.420720549744;8294.129116442688;31088.844555777076;31232;31422.842885785423;31501.684983149877;31835.20411989626;37259;41000.589994099675;41178.79410602928;41280.1743965125;41658.79170604127;10570.312929659547;10579.682609521727;10579.841302380317;10655.467226638792;10733.19501037441;11646.70883227926;12020.819687704867;12047.698807529532;12058.879411205775;12708.745825083632;10009.599616015277;10302.22733295021;10782.1913356497;11465.254758440675;11831.881681183078;10724.478594950542;10847.78304433891;11010.889891101308;11130.833037504282;11732.706682332668;10315.12321452685;10333.173346132442;10361.378317300987;10390.272680912263;10790.298630589301;8730.214280714767;8752.168543988311;8837.955810221165;9288.256939444964;9379.202767764544;9190.356675032683;9346.769106991345;9449;9602.471864047544;9609.711708648752 16:21:50 INFO - PROCESS | 12030 | __end_tp_report 16:21:50 INFO - PROCESS | 12030 | __start_cc_report 16:21:50 INFO - PROCESS | 12030 | _x_x_mozilla_cycle_collect,381 16:21:50 INFO - PROCESS | 12030 | __end_cc_report 16:21:50 INFO - PROCESS | 12030 | __startTimestamp1464391310804__endTimestamp 16:21:50 INFO - PROCESS | 12030 | 16:21:50 INFO - PROCESS | 12030 | ------- Summary: start ------- 16:21:50 INFO - PROCESS | 12030 | Number of tests: 6 16:21:50 INFO - PROCESS | 12030 | 16:21:50 INFO - PROCESS | 12030 | [#0] dojo.html Cycles:165 Average:4812.95 Median:4943.16 stddev:508.24 (10.3%) stddev-sans-first:480.90 16:21:50 INFO - PROCESS | 12030 | Values: 2659.3 2709.4 2719.6 2736.0 2737.1 4710.9 4774.4 4838.4 4852.9 4875.9 4725.5 4758.0 4787.2 4832.5 4838.1 4409.7 4477.1 4494.2 4511.0 4515.4 4519.6 4546.6 4559.3 4566.2 4607.6 4208.0 4527.4 4551.1 4566.6 4594.1 4484.3 4501.1 4504.8 4508.9 4551.2 4409.7 4441.0 4468.2 4491.6 4507.1 4717.3 4801.4 4802.8 4809.2 4847.3 5230.3 5250.5 5269.8 5270.3 5305.1 5198.9 5238.3 5267.3 5274.9 5296.1 4876.3 4903.8 4918.8 4920.3 4942.8 5374.9 5394.1 5401.8 5406.6 5409.1 5049.0 5107.1 5149.7 5153.9 5171.8 5228.1 5255.5 5264.4 5267.9 5308.4 4943.2 5184.3 5184.7 5185.7 5186.4 5136.7 5137.5 5172.7 5175.4 5176.2 4287.0 4353.1 4358.6 4397.9 4405.9 3781.8 3861.1 3897.1 3898.8 3899.6 4430.2 4449.4 4478.7 4483.9 4493.6 5204.4 5211.6 5217.9 5220.3 5265.9 4365.6 4465.8 4479.0 4484.9 4509.6 4712.1 4715.1 4717.6 4717.6 4732.1 4955.2 4957.6 4964.5 4971.0 4991.1 5123.9 5141.6 5156.0 5297.9 5325.9 4864.6 4873.6 4895.0 4902.6 4932.7 5115.6 5122.3 5127.7 5127.9 5135.4 5118.9 5153.2 5160.6 5168.5 5185.7 5007.4 5009.1 5055.2 5068.2 5108.1 5028.1 5033.5 5058.7 5068.2 5090.8 4870.1 5008.5 5012.6 5034.4 5105.1 5057.3 5081.9 5132.9 5142.5 5152.8 4868.9 5036.9 5043.7 5054.4 5097.6 16:21:50 INFO - PROCESS | 12030 | 16:21:50 INFO - PROCESS | 12030 | [#1] ext.html Cycles:180 Average:45885.09 Median:19665.45 stddev:82903.22 (421.6%) stddev-sans-first:83065.93 16:21:50 INFO - PROCESS | 12030 | Values: 557.3 598.8 602.7 614.1 617.3 28357.3 40741.8 41454.2 41683.6 41785.8 42392.2 42914.8 42938.4 43062.8 43173.0 7788.5 8009.9 8027.2 8035.7 8051.9 7864.0 7981.6 7990.8 7998.1 8012.4 7984.9 8059.6 8062.4 8075.4 8080.9 7964.5 8007.8 8011.4 8014.8 8023.3 7937.1 8018.8 8020.4 8023.4 8023.9 39356.4 39644.2 39699.2 39753.8 39806.2 3008.4 3230.9 3414.6 3424.4 3593.4 29261.4 29478.1 30328.4 30642.2 30677.2 3077.4 3078.1 3099.5 3104.1 3147.8 243308.0 244116.0 244382.0 246439.0 247107.0 28728.7 29506.4 54626.2 55169.0 55349.4 34470.3 34549.3 34564.0 34772.0 34778.0 12612.9 12730.4 12730.9 12794.0 12875.2 10281.4 10306.8 10314.8 10315.3 10356.6 7987.2 7990.7 8010.3 8058.9 8077.2 3136.9 3176.0 3185.4 3209.3 3226.6 858.5 874.4 921.4 1022.8 1030.2 29338.1 29341.1 29449.0 29541.7 29774.9 960.5 977.0 997.4 1023.9 1114.0 14917.4 15025.5 15202.2 15337.9 15510.4 364941.0 366634.0 367106.0 367580.0 368548.0 50369.0 50746.2 51130.2 51138.7 51258.0 1209.4 1214.4 1242.6 1251.5 1262.8 26735.0 27639.4 27711.6 28226.3 28392.4 42860.1 43052.6 43153.8 43268.4 43277.8 319035.0 319652.0 320356.0 321038.0 321351.0 25171.6 25436.5 25828.0 25986.5 26020.7 42701.0 43125.0 43353.0 43581.1 43750.1 36663.5 37398.8 37637.2 37706.2 37848.0 34897.8 35110.3 35456.8 35737.5 36251.1 33547.3 36112.3 36473.3 36827.1 37210.0 32661.8 34006.8 34011.8 34138.3 34284.7 25562.4 25991.9 26000.2 26129.0 26468.2 16:21:50 INFO - PROCESS | 12030 | 16:21:50 INFO - PROCESS | 12030 | [#2] jquery.html Cycles:180 Average:23434.70 Median:5226.75 stddev:62102.94 (1188.2%) stddev-sans-first:62252.99 16:21:50 INFO - PROCESS | 12030 | Values: 361.9 362.8 368.4 373.1 396.0 15875.3 16552.2 17283.7 17315.1 17341.7 14492.6 16390.8 16993.6 17025.8 17055.3 5019.7 5176.1 5217.3 5219.7 5223.6 3762.6 5116.9 5682.7 6041.5 6057.4 6067.1 6070.2 6099.6 6107.3 6116.9 4998.1 5336.3 5343.0 5401.3 5438.3 5042.5 5229.9 5456.2 5478.7 5512.6 12597.1 12713.2 15069.2 20015.7 20180.6 1626.8 1746.2 1788.7 1798.2 1844.4 9463.0 9580.1 11230.0 11497.6 13227.9 1776.2 1808.3 1862.5 1891.6 1919.2 64353.4 64934.0 65006.7 66043.0 70153.6 9277.2 9603.9 9750.3 9837.5 10023.7 13250.6 13276.8 13297.6 13436.4 13437.5 6763.7 6846.7 6924.8 6955.1 7024.2 6557.5 6595.5 6613.6 6691.3 6692.5 3948.1 3988.3 4033.5 4057.7 4093.5 1552.0 1760.0 1837.2 1872.8 1898.4 768.8 883.9 909.5 922.3 990.3 15603.4 16567.8 16772.9 16870.4 16950.7 848.2 859.9 860.4 861.4 887.7 9297.0 9519.8 9529.4 9603.9 9720.0 356179.0 378541.0 380983.0 381645.0 382310.0 73182.3 74630.3 74634.6 75397.2 76434.2 901.5 904.5 906.7 927.1 935.8 14622.9 14843.6 15098.2 15235.5 15296.0 34647.7 34827.3 35145.3 35887.8 36575.5 49828.5 49980.5 50088.7 50091.5 50674.5 5693.7 7324.9 7696.1 7858.8 7860.9 10504.7 11488.9 11595.2 11783.2 11807.2 9598.6 9618.4 9705.8 9854.5 9920.1 5562.1 7431.5 9790.9 10165.7 10403.9 9206.7 9542.9 9823.2 9942.3 10192.6 7722.0 7749.3 7811.1 7843.9 7863.9 7227.4 8420.4 9242.7 9314.9 9665.8 16:21:50 INFO - PROCESS | 12030 | 16:21:50 INFO - PROCESS | 12030 | [#3] mootools.html Cycles:180 Average:5285.51 Median:5608.45 stddev:2922.46 (52.1%) stddev-sans-first:2916.37 16:21:50 INFO - PROCESS | 12030 | Values: 1439.9 1459.5 1582.6 1775.6 1782.8 6950.8 7588.5 7713.3 8130.4 8143.2 7740.5 8003.4 8020.2 8033.3 8036.0 2212.1 2231.1 2244.8 2244.8 2258.4 2214.1 2215.3 2271.9 2278.6 2284.7 2225.8 2236.6 2237.9 2244.9 2268.6 2043.4 2044.1 2044.6 2048.8 2050.3 2147.4 2173.8 2181.4 2199.5 2202.0 7935.3 7979.8 7995.2 7996.2 8012.8 4750.2 4866.8 4875.5 4877.3 4878.8 2903.4 2956.9 3075.0 3078.2 3082.0 941.2 974.6 976.1 982.2 990.6 10842.1 10852.1 10879.3 10930.3 10934.2 4268.4 4378.5 4457.9 4470.4 4480.6 9368.5 9378.9 9396.2 9420.3 9438.7 4828.8 4834.3 4835.0 4879.8 4905.5 3658.9 4300.5 4454.4 4468.4 4484.2 3671.2 3686.0 3707.2 3783.3 3789.8 1232.8 1258.2 1258.6 1261.8 1265.8 734.8 772.8 773.5 844.7 906.1 5463.9 5478.9 5556.6 5598.1 5639.7 902.4 916.3 925.8 927.9 963.3 3843.7 3869.9 3891.3 3961.2 4010.4 9692.0 9882.3 9964.6 9971.5 10007.2 9622.2 9678.4 9755.8 9766.4 9888.5 7077.6 7272.0 7367.8 7461.1 7476.0 5530.8 5618.8 5773.7 5872.6 5877.3 8651.1 8826.7 9138.7 9139.7 9158.1 9092.2 9121.7 9196.2 9264.6 9270.5 6298.9 6689.6 6698.7 6828.2 6924.0 7703.8 7750.8 7763.0 7785.7 7799.7 6727.7 6882.3 6913.4 6984.6 7058.2 6673.2 6690.7 6781.8 6846.5 6865.3 6309.6 6568.5 6641.2 6659.7 6699.5 4495.7 4623.8 4733.1 4862.9 4958.7 4775.1 4877.2 4894.9 4916.4 4919.2 16:21:50 INFO - PROCESS | 12030 | 16:21:50 INFO - PROCESS | 12030 | [#4] prototype.html Cycles:180 Average:4354.55 Median:5040.22 stddev:1291.27 (25.6%) stddev-sans-first:1258.41 16:21:50 INFO - PROCESS | 12030 | Values: 294.0 298.0 307.6 312.9 313.6 5054.9 5063.2 5065.8 5070.7 5082.7 4991.0 5001.5 5009.8 5025.5 5060.2 3674.5 3741.2 3856.6 3864.4 3867.5 3860.5 3863.6 3880.1 3890.7 3902.0 3865.2 3882.7 3886.1 3898.3 3898.7 3806.7 3864.7 3873.3 3892.3 3893.2 3365.6 3390.8 3403.1 3403.5 3406.5 4803.8 4816.6 4818.9 4827.6 4862.6 4425.4 4471.6 4503.8 4506.7 4512.3 4885.7 5161.3 5193.8 5197.8 5218.2 3556.3 3620.4 3641.3 3643.8 3656.5 5508.6 5511.0 5548.8 5562.5 5579.1 3662.3 3769.4 3771.3 3772.2 3785.6 3818.1 3830.3 3831.3 3850.7 3851.6 4405.6 4407.3 4418.8 4425.0 4432.5 5142.3 5198.0 5201.2 5294.9 5317.3 1268.4 1281.3 1282.4 1284.0 1289.9 822.0 822.3 828.1 828.6 835.9 4452.3 4549.3 4588.4 4619.4 4620.6 5414.2 5455.3 5478.7 5479.8 5484.4 4412.5 4527.9 4592.7 4605.9 4613.8 2877.9 2882.2 2888.3 2900.0 2908.2 5078.4 5102.7 5103.3 5122.7 5126.7 5213.3 5533.0 5594.7 5617.7 5621.0 5122.7 5124.5 5129.4 5143.4 5149.6 5453.9 5475.5 5480.0 5502.2 5515.7 5233.3 5343.6 5344.4 5362.6 5366.7 5120.0 5121.6 5121.9 5139.0 5143.5 3749.2 3760.2 3774.7 3785.1 3795.7 5255.5 5436.2 5439.3 5456.3 5465.8 5291.6 5292.3 5298.9 5306.3 5328.8 5278.2 5303.9 5306.7 5314.5 5318.2 5016.5 5246.0 5254.7 5256.9 5286.9 5089.8 5115.0 5276.8 5295.7 5342.6 5159.5 5195.9 5204.8 5207.3 5207.7 16:21:50 INFO - PROCESS | 12030 | 16:21:50 INFO - PROCESS | 12030 | [#5] yui.html Cycles:180 Average:13169.37 Median:49559.14 stddev:15472.67 (31.2%) stddev-sans-first:15487.33 16:21:50 INFO - PROCESS | 12030 | Values: 609.3 636.7 661.0 721.5 723.9 11608.8 12048.3 12167.2 12219.3 13250.8 12539.9 12711.4 12735.7 12745.1 12758.1 635.5 796.3 796.7 806.3 817.1 784.1 786.4 789.5 789.9 790.5 842.9 844.1 849.7 849.9 850.4 840.0 844.9 845.8 846.7 848.3 620.9 621.0 621.4 621.9 622.3 12484.1 12508.5 12518.6 12548.3 12565.8 12410.4 12658.3 12767.8 12779.9 12905.7 9345.9 9429.6 9445.4 9475.7 9523.8 3179.8 3240.5 3265.3 3274.0 3276.5 41907.4 43657.6 45382.1 45390.5 45483.0 9717.0 9940.4 9951.8 9952.0 10056.4 17076.6 17130.1 17185.4 17219.8 17353.2 6329.7 6335.7 6547.3 6705.7 6740.3 3550.0 3591.8 3654.9 3673.8 3709.1 2918.2 3012.7 3013.6 3021.5 3021.9 532.5 534.4 535.0 540.8 551.1 588.4 595.6 604.3 608.7 630.7 7245.5 7249.2 7281.4 7453.9 7562.3 575.3 575.8 577.8 578.4 596.9 3707.7 3777.0 3806.2 3842.3 3848.0 54629.5 56381.4 57447.7 57782.1 57805.0 50611.0 50709.5 51009.2 52028.2 52093.2 45528.8 47078.0 47784.8 48035.5 48507.3 8138.7 8151.3 8190.0 8275.4 8294.1 31088.8 31232.0 31422.8 31501.7 31835.2 37259.0 41000.6 41178.8 41280.2 41658.8 10570.3 10579.7 10579.8 10655.5 10733.2 11646.7 12020.8 12047.7 12058.9 12708.7 10009.6 10302.2 10782.2 11465.3 11831.9 10724.5 10847.8 11010.9 11130.8 11732.7 10315.1 10333.2 10361.4 10390.3 10790.3 8730.2 8752.2 8838.0 9288.3 9379.2 9190.4 9346.8 9449.0 9602.5 9609.7 16:21:50 INFO - PROCESS | 12030 | -------- Summary: end -------- 16:21:50 INFO - PROCESS | 12030 | 16:21:51 INFO - TEST-INFO | 12030: exit 0 16:21:51 INFO - TEST-OK | dromaeo_css | took 1116211ms 16:21:51 INFO - TEST-START | kraken 16:21:51 INFO - operating with platform_type : linux_ 16:21:51 INFO - Initialising browser for kraken test... 16:21:51 INFO - TEST-INFO | started process 12266 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFbFgZA/profile http://localhost:51868/getInfo.html) 16:21:55 INFO - PROCESS | 12266 | 16:21:55 INFO - PROCESS | 12266 | (process:12334): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:21:56 INFO - PROCESS | 12266 | __metrics Screen width/height:1600/1200 16:21:56 INFO - PROCESS | 12266 | colorDepth:24 16:21:56 INFO - PROCESS | 12266 | Browser inner width/height: 1024/697 16:21:56 INFO - PROCESS | 12266 | __metrics 16:21:57 ERROR - PROCESS | 12266 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 16:21:58 INFO - TEST-INFO | 12266: exit 0 16:21:58 INFO - Browser initialized. 16:21:58 INFO - Running cycle 1/1 for kraken test... 16:21:58 INFO - TEST-INFO | started process 12385 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFbFgZA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:22:00 INFO - PROCESS | 12385 | 16:22:00 INFO - PROCESS | 12385 | (process:12445): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:22:10 INFO - PROCESS | 12385 | RSS: Main: 167583744 16:22:10 INFO - PROCESS | 12385 | 16:22:12 INFO - PROCESS | 12385 | Cycle 1(1): loaded http://localhost:51868/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51868/tests/kraken/driver.html?testName=audio-beat-detection) 16:22:13 INFO - PROCESS | 12385 | RSS: Main: 172654592 16:22:13 INFO - PROCESS | 12385 | 16:22:16 INFO - PROCESS | 12385 | Cycle 1(1): loaded http://localhost:51868/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51868/tests/kraken/driver.html?testName=audio-dft) 16:22:17 INFO - PROCESS | 12385 | RSS: Main: 172949504 16:22:17 INFO - PROCESS | 12385 | 16:22:20 INFO - PROCESS | 12385 | Cycle 1(1): loaded http://localhost:51868/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51868/tests/kraken/driver.html?testName=audio-fft) 16:22:20 INFO - PROCESS | 12385 | RSS: Main: 167677952 16:22:20 INFO - PROCESS | 12385 | 16:22:22 INFO - PROCESS | 12385 | Cycle 1(1): loaded http://localhost:51868/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51868/tests/kraken/driver.html?testName=audio-oscillator) 16:22:23 INFO - PROCESS | 12385 | RSS: Main: 168579072 16:22:23 INFO - PROCESS | 12385 | 16:22:25 INFO - PROCESS | 12385 | Cycle 1(1): loaded http://localhost:51868/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51868/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:22:26 INFO - PROCESS | 12385 | RSS: Main: 168554496 16:22:26 INFO - PROCESS | 12385 | 16:22:29 INFO - PROCESS | 12385 | Cycle 1(1): loaded http://localhost:51868/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51868/tests/kraken/driver.html?testName=imaging-darkroom) 16:22:30 INFO - PROCESS | 12385 | RSS: Main: 168910848 16:22:30 INFO - PROCESS | 12385 | 16:22:33 INFO - PROCESS | 12385 | Cycle 1(1): loaded http://localhost:51868/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51868/tests/kraken/driver.html?testName=imaging-desaturate) 16:22:34 INFO - PROCESS | 12385 | RSS: Main: 166469632 16:22:34 INFO - PROCESS | 12385 | 16:22:37 INFO - PROCESS | 12385 | Cycle 1(1): loaded http://localhost:51868/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51868/tests/kraken/driver.html?testName=json-parse-financial) 16:22:37 INFO - PROCESS | 12385 | RSS: Main: 167452672 16:22:37 INFO - PROCESS | 12385 | 16:22:39 INFO - PROCESS | 12385 | Cycle 1(1): loaded http://localhost:51868/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51868/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:22:40 INFO - PROCESS | 12385 | RSS: Main: 167903232 16:22:40 INFO - PROCESS | 12385 | 16:22:42 INFO - PROCESS | 12385 | Cycle 1(1): loaded http://localhost:51868/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51868/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:22:42 INFO - PROCESS | 12385 | RSS: Main: 168026112 16:22:42 INFO - PROCESS | 12385 | 16:22:44 INFO - PROCESS | 12385 | Cycle 1(1): loaded http://localhost:51868/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51868/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:22:45 INFO - PROCESS | 12385 | RSS: Main: 168202240 16:22:45 INFO - PROCESS | 12385 | 16:22:48 INFO - PROCESS | 12385 | Cycle 1(1): loaded http://localhost:51868/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51868/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:22:49 INFO - PROCESS | 12385 | RSS: Main: 168329216 16:22:49 INFO - PROCESS | 12385 | 16:22:51 INFO - PROCESS | 12385 | Cycle 1(1): loaded http://localhost:51868/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51868/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:22:52 INFO - PROCESS | 12385 | RSS: Main: 168931328 16:22:52 INFO - PROCESS | 12385 | 16:22:54 INFO - PROCESS | 12385 | Cycle 1(1): loaded http://localhost:51868/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51868/tests/kraken/driver.html?testName=ai-astar) 16:22:54 INFO - PROCESS | 12385 | RSS: Main: 169136128 16:22:54 INFO - PROCESS | 12385 | 16:22:54 INFO - PROCESS | 12385 | __start_tp_report 16:22:54 INFO - PROCESS | 12385 | _x_x_mozilla_page_load 16:22:54 INFO - PROCESS | 12385 | _x_x_mozilla_page_load_details 16:22:54 INFO - PROCESS | 12385 | |i|pagename|runs| 16:22:54 INFO - PROCESS | 12385 | |0;ai-astar;117;114;115;114;114;114;115;114;115;116 16:22:54 INFO - PROCESS | 12385 | |1;audio-beat-detection;155;128;155;183;137;154;159;132;182;134 16:22:54 INFO - PROCESS | 12385 | |2;audio-dft;165;162;163;167;170;163;164;163;165;163 16:22:54 INFO - PROCESS | 12385 | |3;audio-fft;75;77;75;158;78;77;76;77;161;76 16:22:54 INFO - PROCESS | 12385 | |4;audio-oscillator;86;84;145;85;88;86;140;85;85;136 16:22:54 INFO - PROCESS | 12385 | |5;imaging-gaussian-blur;117;118;117;118;117;118;118;118;118;118 16:22:54 INFO - PROCESS | 12385 | |6;imaging-darkroom;148;147;147;148;147;149;148;147;148;147 16:22:54 INFO - PROCESS | 12385 | |7;imaging-desaturate;95;95;96;95;95;95;96;95;95;95 16:22:54 INFO - PROCESS | 12385 | |8;json-parse-financial;63;64;64;64;64;64;64;63;64;64 16:22:54 INFO - PROCESS | 12385 | |9;json-stringify-tinderbox;65;66;65;65;65;65;66;66;65;66 16:22:54 INFO - PROCESS | 12385 | |10;stanford-crypto-aes;84;81;84;84;85;86;85;84;106;89 16:22:54 INFO - PROCESS | 12385 | |11;stanford-crypto-ccm;150;137;147;130;138;136;134;147;145;142 16:22:54 INFO - PROCESS | 12385 | |12;stanford-crypto-pbkdf2;169;173;168;174;168;174;168;173;172;170 16:22:54 INFO - PROCESS | 12385 | |13;stanford-crypto-sha256-iterative;67;71;68;66;68;66;69;67;70;67 16:22:54 INFO - PROCESS | 12385 | __end_tp_report 16:22:54 INFO - PROCESS | 12385 | __start_cc_report 16:22:54 INFO - PROCESS | 12385 | _x_x_mozilla_cycle_collect,949 16:22:54 INFO - PROCESS | 12385 | __end_cc_report 16:22:54 INFO - PROCESS | 12385 | __startTimestamp1464391374633__endTimestamp 16:22:54 INFO - PROCESS | 12385 | 16:22:54 INFO - PROCESS | 12385 | ------- Summary: start ------- 16:22:54 INFO - PROCESS | 12385 | Number of tests: 14 16:22:54 INFO - PROCESS | 12385 | 16:22:54 INFO - PROCESS | 12385 | [#0] ai-astar Cycles:10 Average:114.80 Median:115.00 stddev:1.03 (0.9%) stddev-sans-first:0.73 16:22:54 INFO - PROCESS | 12385 | Values: 117.0 114.0 115.0 114.0 114.0 114.0 115.0 114.0 115.0 116.0 16:22:54 INFO - PROCESS | 12385 | 16:22:54 INFO - PROCESS | 12385 | [#1] audio-beat-detection Cycles:10 Average:151.90 Median:155.00 stddev:19.60 (12.6%) stddev-sans-first:20.76 16:22:54 INFO - PROCESS | 12385 | Values: 155.0 128.0 155.0 183.0 137.0 154.0 159.0 132.0 182.0 134.0 16:22:54 INFO - PROCESS | 12385 | 16:22:54 INFO - PROCESS | 12385 | [#2] audio-dft Cycles:10 Average:164.50 Median:164.50 stddev:2.42 (1.5%) stddev-sans-first:2.55 16:22:54 INFO - PROCESS | 12385 | Values: 165.0 162.0 163.0 167.0 170.0 163.0 164.0 163.0 165.0 163.0 16:22:54 INFO - PROCESS | 12385 | 16:22:54 INFO - PROCESS | 12385 | [#3] audio-fft Cycles:10 Average:93.00 Median:76.50 stddev:35.07 (45.8%) stddev-sans-first:36.59 16:22:54 INFO - PROCESS | 12385 | Values: 75.0 77.0 75.0 158.0 78.0 77.0 76.0 77.0 161.0 76.0 16:22:54 INFO - PROCESS | 12385 | 16:22:54 INFO - PROCESS | 12385 | [#4] audio-oscillator Cycles:10 Average:102.00 Median:85.00 stddev:26.56 (31.2%) stddev-sans-first:27.53 16:22:54 INFO - PROCESS | 12385 | Values: 86.0 84.0 145.0 85.0 88.0 86.0 140.0 85.0 85.0 136.0 16:22:54 INFO - PROCESS | 12385 | 16:22:54 INFO - PROCESS | 12385 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 16:22:54 INFO - PROCESS | 12385 | Values: 117.0 118.0 117.0 118.0 117.0 118.0 118.0 118.0 118.0 118.0 16:22:54 INFO - PROCESS | 12385 | 16:22:54 INFO - PROCESS | 12385 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 16:22:54 INFO - PROCESS | 12385 | Values: 148.0 147.0 147.0 148.0 147.0 149.0 148.0 147.0 148.0 147.0 16:22:54 INFO - PROCESS | 12385 | 16:22:54 INFO - PROCESS | 12385 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 16:22:54 INFO - PROCESS | 12385 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 16:22:54 INFO - PROCESS | 12385 | 16:22:54 INFO - PROCESS | 12385 | [#8] json-parse-financial Cycles:10 Average:63.80 Median:64.00 stddev:0.42 (0.7%) stddev-sans-first:0.33 16:22:54 INFO - PROCESS | 12385 | Values: 63.0 64.0 64.0 64.0 64.0 64.0 64.0 63.0 64.0 64.0 16:22:54 INFO - PROCESS | 12385 | 16:22:54 INFO - PROCESS | 12385 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:65.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 16:22:54 INFO - PROCESS | 12385 | Values: 65.0 66.0 65.0 65.0 65.0 65.0 66.0 66.0 65.0 66.0 16:22:54 INFO - PROCESS | 12385 | 16:22:54 INFO - PROCESS | 12385 | [#10] stanford-crypto-aes Cycles:10 Average:86.80 Median:84.50 stddev:7.04 (8.3%) stddev-sans-first:7.39 16:22:54 INFO - PROCESS | 12385 | Values: 84.0 81.0 84.0 84.0 85.0 86.0 85.0 84.0 106.0 89.0 16:22:54 INFO - PROCESS | 12385 | 16:22:54 INFO - PROCESS | 12385 | [#11] stanford-crypto-ccm Cycles:10 Average:140.60 Median:143.50 stddev:6.57 (4.6%) stddev-sans-first:6.02 16:22:54 INFO - PROCESS | 12385 | Values: 150.0 137.0 147.0 130.0 138.0 136.0 134.0 147.0 145.0 142.0 16:22:54 INFO - PROCESS | 12385 | 16:22:54 INFO - PROCESS | 12385 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.90 Median:172.50 stddev:2.56 (1.5%) stddev-sans-first:2.62 16:22:54 INFO - PROCESS | 12385 | Values: 169.0 173.0 168.0 174.0 168.0 174.0 168.0 173.0 172.0 170.0 16:22:54 INFO - PROCESS | 12385 | 16:22:54 INFO - PROCESS | 12385 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:1.66 (2.4%) stddev-sans-first:1.73 16:22:54 INFO - PROCESS | 12385 | Values: 67.0 71.0 68.0 66.0 68.0 66.0 69.0 67.0 70.0 67.0 16:22:54 INFO - PROCESS | 12385 | -------- Summary: end -------- 16:22:54 INFO - PROCESS | 12385 | 16:22:55 INFO - TEST-INFO | 12385: exit 0 16:22:55 INFO - TEST-OK | kraken | took 64093ms 16:22:55 INFO - SUITE-END | took 1180s 16:22:55 INFO - Completed test suite (00:19:40) 16:22:55 INFO - javascript benchmark 16:22:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6319.118510918514, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2659.2687011071953, 2709.39038716289, 2719.6464459620247, 2735.972640273598, 2737.1241202815095, 4710.90578188436, 4774.37933068701, 4838.371011768474, 4852.85441436757, 4875.902481950359, 4725.456572494164, 4757.952420475803, 4787.234042553192, 4832.468428472874, 4838.056578967094, 4409.669274804394, 4477.059817438326, 4494.1910456117885, 4510.954890451103, 4515.435570553681, 4519.638428925678, 4546.61353784927, 4559.293309537027, 4566.223741963858, 4607.562281583244, 4208.0, 4527.388802511652, 4551.13528429599, 4566.589006989387, 4594.081183763227, 4484.349769283468, 4501.122281155176, 4504.842330518416, 4508.932366014513, 4551.249043907751, 4409.669274804402, 4440.955590444119, 4468.151051300242, 4491.595756381941, 4507.098580283923, 4717.339572459859, 4801.399825021872, 4802.807887684488, 4809.23052311632, 4847.345608342864, 5230.293910322096, 5250.490283472976, 5269.789208431658, 5270.341207349082, 5305.071612467841, 5198.870028249286, 5238.319018527567, 5267.341582302212, 5274.947250527484, 5296.09966305729, 4876.292937524039, 4903.803847846082, 4918.778654960535, 4920.3111564381015, 4942.802287908444, 5374.892502149935, 5394.1099718546, 5401.783928642889, 5406.6215364924865, 5409.134538473825, 5049.0, 5107.106256405114, 5149.6910185389, 5153.948460515422, 5171.7672704728375, 5228.137357336073, 5255.527002569787, 5264.447233040552, 5267.920981185285, 5308.362996440452, 4943.1596628573225, 5184.300119483897, 5184.7407629618365, 5185.688858668492, 5186.40356359016, 5136.717480538607, 5137.5376216139975, 5172.7155006475, 5175.353080864892, 5176.249443830623, 4286.957130428718, 4353.085851971058, 4358.629516491071, 4397.934030989538, 4405.889852753643, 3781.7541859779026, 3861.131245469747, 3897.142628621699, 3898.8440462381186, 3899.5515515715488, 4430.246858034142, 4449.3993310902615, 4478.664100192434, 4483.865484035419, 4493.640508759291, 5204.375474943031, 5211.557017653542, 5217.869553261123, 5220.321358223407, 5265.894682106336, 4365.585269399402, 4465.754383508938, 4479.037007043501, 4484.932726009112, 4509.594136527729, 4712.057588482317, 4715.0805592909055, 4717.551832575899, 4717.599004084691, 4732.124556956974, 4955.157623204136, 4957.6281778866005, 4964.478729733398, 4970.950290497049, 4991.051700177028, 5123.948760512496, 5141.640085194001, 5156.04613146569, 5297.9139276449005, 5325.866853328698, 4864.61083113343, 4873.610111191168, 4895.020995800783, 4902.583280421061, 4932.7286999215385, 5115.590752739847, 5122.334096567572, 5127.692338459704, 5127.948720512747, 5135.409427915688, 5118.925025744636, 5153.2270159476375, 5160.572668629904, 5168.53483186515, 5185.688858668492, 5007.39911210657, 5009.148444764472, 5055.16589762685, 5068.163752980717, 5108.080545501845, 5028.120078986236, 5033.496650334937, 5058.721770302669, 5068.214426763858, 5090.847274581768, 4870.05034018363, 5008.549230569266, 5012.649114562091, 5034.395872495324, 5105.081085404663, 5057.31726216956, 5081.949180508295, 5132.923006154985, 5142.485751424828, 5152.845414637567, 4868.926966095441, 5036.899262014813, 5043.697378157322, 5054.393472783289, 5097.643164978416], "value": 4780.305293700999, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.3200695151913, 598.787430462186, 602.6866029664571, 614.1064750787606, 617.3486971245335, 28357.291067723316, 40741.79629101854, 41454.17091658165, 41683.58316416838, 41785.7910710446, 42392.152156956916, 42914.78542607283, 42938.355924661075, 43062.78468607661, 43173.0, 7788.493747906382, 8009.879851802228, 8027.197280271956, 8035.718749843757, 8051.879221811678, 7864.0, 7981.561014144219, 7990.840183196333, 7998.12020677725, 8012.359011279113, 7984.880226796603, 8059.556724380157, 8062.395320350997, 8075.3539716822515, 8080.919190808105, 7964.482308649919, 8007.759767206964, 8011.399145064114, 8014.839703205961, 8023.277904988579, 7937.126916039231, 8018.799530011738, 8020.438569300151, 8023.358131349478, 8023.879641805378, 39356.40965385522, 39644.20711585781, 39699.20601587952, 39753.80123099395, 39806.20387592232, 3008.39832033592, 3230.8869189578486, 3414.556107706007, 3424.400729872262, 3593.443016332473, 29261.414771704447, 29478.11565653034, 30328.393432131234, 30642.23394415135, 30677.23306917345, 3077.4460597092516, 3078.1073488688253, 3099.4730895747775, 3104.068779366181, 3147.8111313321274, 243308.0, 244116.0, 244382.0, 246439.0, 247107.0, 28728.712712872602, 29506.409871802873, 54626.180607290924, 55169.0, 55349.446505535234, 34470.31059378848, 34549.309013819584, 34564.0, 34772.0, 34778.0, 12612.873871261354, 12730.363481825872, 12730.936345318214, 12794.040446966515, 12875.163114397534, 10281.383117012854, 10306.793864122676, 10314.845277320695, 10315.329503582243, 10356.585736570603, 7987.1613480584865, 7990.720324788605, 8010.3191228745045, 8058.919410805817, 8077.192280771993, 3136.8588413521447, 3175.984120079385, 3185.426623207845, 3209.3099983503657, 3226.596675415573, 858.5063588436674, 874.4490970688425, 921.3596550397409, 1022.7647641042453, 1030.196263305464, 29338.100213420355, 29341.119766407042, 29449.0, 29541.704582954324, 29774.851125744233, 960.500539719342, 976.9853452198223, 997.4264797741328, 1023.8515415264745, 1113.9944300278446, 14917.403303867724, 15025.474108406153, 15202.163880986653, 15337.923310383376, 15510.379584816481, 364941.0, 366634.0, 367106.0, 367580.0, 368548.0, 50369.0, 50746.23880641793, 51130.233046504334, 51138.744306278975, 51258.0, 1209.3832145605804, 1214.423149004216, 1242.5588915934713, 1251.5494422008069, 1262.8042653388738, 26735.0, 27639.447211055263, 27711.58432623472, 28226.2943426416, 28392.432151356443, 42860.14279714326, 43052.56947430486, 43153.7842310799, 43268.35097473604, 43277.783611083, 319035.0, 319652.0, 320356.0, 321038.0, 321351.0, 25171.622425663263, 25436.491270174123, 25828.0, 25986.480270394863, 26020.739792602588, 42701.0, 43125.0, 43353.0, 43581.12837743164, 43750.12499749923, 36663.45004824983, 37398.8130059348, 37637.24725505529, 37706.245875082896, 37848.0, 34897.8255108733, 35110.29779404448, 35456.82271588729, 35737.463938041474, 36251.09372265609, 33547.3290534183, 36112.27775444529, 36473.27053458863, 36827.07932301714, 37210.0, 32661.836690816395, 34006.82996585001, 34011.82994085014, 34138.31723365469, 34284.65715342815, 25562.36094097588, 25991.870040649676, 26000.219993400227, 26129.0, 26468.205953821416], "value": 16641.178669430898, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.8643008871673, 362.77689221129003, 368.3903140302799, 373.1473582863158, 395.9821808018639, 15875.285612147452, 16552.172391380427, 17283.74074388885, 17315.134243287815, 17341.653166936685, 14492.565223043299, 16390.83609163908, 16993.57516062096, 17025.82974170258, 17055.317787288495, 5019.698818070919, 5176.120059589879, 5217.3217481727515, 5219.739013049351, 5223.6343455958095, 3762.623737626243, 5116.872078198037, 5682.715864206773, 6041.4562689357945, 6057.42454466825, 6067.059605761114, 6070.2412198475195, 6099.57302988791, 6107.267127944653, 6116.877662446748, 4998.125328067592, 5336.252924590561, 5343.011542864563, 5401.297831281908, 5438.265834112383, 5042.546170844642, 5229.869253268661, 5456.181572764117, 5478.726063696799, 5512.586556008316, 12597.055220858472, 12713.17364371313, 15069.171195584238, 20015.699764503544, 20180.596388072303, 1626.7641192027208, 1746.2142036083812, 1788.6959216933024, 1798.2267624921278, 1844.446666000208, 9463.016124939708, 9580.0898914603, 11230.045446137088, 11497.5975840846, 13227.933860330733, 1776.1740790532465, 1808.3038030358275, 1862.4971257760328, 1891.6405882882345, 1919.2323070771663, 64353.356466435675, 64934.02598961019, 65006.67496662534, 66043.0, 70153.64923175403, 9277.16505514507, 9603.855942160873, 9750.26872984529, 9837.508124593742, 10023.749406264757, 13250.602481925558, 13276.800847987288, 13297.601071967856, 13436.395362208725, 13437.529686460926, 6763.661816909135, 6846.726130954706, 6924.792256232321, 6955.130608673916, 7024.1571011478945, 6557.475401967831, 6595.538312318092, 6613.603183808987, 6691.330866913367, 6692.531522793455, 3948.072203032285, 3988.3419235825763, 4033.4554835096887, 4057.715959882839, 4093.4678491795876, 1551.9689606207812, 1759.9560010999828, 1837.200817644329, 1872.8314451699412, 1898.4494496596108, 768.7539987204041, 883.8630012348096, 909.4543274035658, 922.2898368256405, 990.3067852503276, 15603.375864965274, 16567.834321656628, 16772.916135419488, 16870.409535666193, 16950.745738813683, 848.1730312944952, 859.8968123825181, 860.414917855864, 861.3841103610823, 887.7026196224208, 9297.0, 9519.809603807886, 9529.38059026175, 9603.855942160873, 9720.0, 356179.0, 378541.0, 380983.0, 381645.0, 382310.0, 73182.26817731754, 74630.25369746341, 74634.62682686551, 75397.24602754012, 76434.23565764271, 901.454619954931, 904.4934836491586, 906.6509393883402, 927.1146055516965, 935.7941252924346, 14622.853771462575, 14843.554693359216, 15098.245087745348, 15235.466758663393, 15296.0, 34647.65352346444, 34827.30345393129, 35145.297094058486, 35887.82056089703, 36575.45136823003, 49828.50171498238, 49980.500194997585, 50088.74955625198, 50091.49908500868, 50674.49325506845, 5693.658380497183, 7324.890126647998, 7696.114946781192, 7858.803529911798, 7860.938773265536, 10504.684859454228, 11488.94255528717, 11595.246308989888, 11783.175177737476, 11807.23252988553, 9598.568064437257, 9618.374805637612, 9705.757356066155, 9854.507274636382, 9920.107190352903, 5562.082256427644, 7431.516951398142, 9790.902090979, 10165.695029148841, 10403.895961040293, 9206.711060451407, 9542.904570954202, 9823.165030972448, 9942.254330925065, 10192.643257485952, 7722.0, 7749.341305988829, 7811.101723301893, 7843.882341764992, 7863.921360786548, 7227.385672217921, 8420.36847236472, 9242.676506322246, 9314.860277095713, 9665.758356041155], "value": 7993.26753876843, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1439.8992070555062, 1459.5183589415494, 1582.5727053695502, 1775.5649865782884, 1782.8484578810792, 6950.79147625572, 7588.468807183499, 7713.305802477776, 8130.390220733454, 8143.226393492623, 7740.458167928247, 8003.359731221502, 8020.157883422245, 8033.317168040723, 8036.0, 2212.081985975822, 2231.0518029837335, 2244.8204143668468, 2244.842860999731, 2258.4128126687015, 2214.1032881682945, 2215.268961242786, 2271.8864056797092, 2278.601244782165, 2284.6915666385075, 2225.8219342452567, 2236.6197746383073, 2237.8881055947218, 2244.8540844845033, 2268.5576312619046, 2043.417625976597, 2044.1108117968656, 2044.6217449771839, 2048.8258498027685, 2050.323393280229, 2147.420196546939, 2173.7500187478486, 2181.4437318483842, 2199.538096999632, 2201.9889900550393, 7935.285824275843, 7979.800504987364, 7995.160508146677, 7996.200379961957, 8012.759617211493, 4750.216214324632, 4866.7566621668775, 4875.488073752241, 4877.268409738532, 4878.804847806084, 2903.3757742085554, 2956.911292661224, 3075.0159948816386, 3078.215055160942, 3082.029160814336, 941.2328951904176, 974.6296407365227, 976.0922342221731, 982.1602529836958, 990.6136606723384, 10842.132629389629, 10852.131829453625, 10879.292845964987, 10930.344179349186, 10934.179936504794, 4268.381084742695, 4378.496472905593, 4457.866264012085, 4470.441194850644, 4480.61914737251, 9368.484733339732, 9378.906210937803, 9396.154346108746, 9420.34057615974, 9438.669646562337, 4828.830990915301, 4834.347363106006, 4834.95165048345, 4879.780409881564, 4905.533974272438, 3658.8719394821055, 4300.4839419269265, 4454.3986561813745, 4468.419105516327, 4484.2376795944765, 3671.155634204148, 3686.0, 3707.2214834884435, 3783.2622638585763, 3789.8105094745706, 1232.778099942001, 1258.2010423381219, 1258.5657948007922, 1261.8296529968336, 1265.829113069742, 734.8126227811874, 772.818387678895, 773.5242825662177, 844.7043534762784, 906.1482206725657, 5463.890722185534, 5478.945210547843, 5556.555475561945, 5598.1322894951345, 5639.689817060019, 902.4134312696799, 916.3081873185836, 925.7779730755339, 927.9257659387233, 963.2631037256505, 3843.673287770571, 3869.903252418712, 3891.3190191716903, 3961.207758448264, 4010.358342665218, 9692.0, 9882.25883058759, 9964.551595178234, 9971.501424928725, 10007.199424046059, 9622.182114520345, 9678.370905891095, 9755.804883902283, 9766.365186263012, 9888.456134912649, 7077.646117694095, 7271.963640181765, 7367.81580460482, 7461.1419686735635, 7475.962620186864, 5530.751116199861, 5618.775248989995, 5773.711314434177, 5872.559558033079, 5877.2947246329, 8651.091635378447, 8826.735197944072, 9138.68014619485, 9139.680111196076, 9158.084191581054, 9092.181703646704, 9121.726348209564, 9196.218321442751, 9264.583093760662, 9270.490123043297, 6298.874022519615, 6689.632070236184, 6698.698558564779, 6828.248892621907, 6924.0, 7703.807404814925, 7750.806229844074, 7762.990811194509, 7785.688572457038, 7799.688012479437, 6727.697253623501, 6882.346177113166, 6913.3777959983845, 6984.580925144508, 7058.153021637437, 6673.165854268216, 6690.665466726547, 6781.762638307833, 6846.452283817183, 6865.27914568963, 6309.558330916791, 6568.507361947969, 6641.169853768279, 6659.733610655713, 6699.464042876656, 4495.730256184639, 4623.815047398201, 4733.053389322218, 4862.878428039327, 4958.652894297365, 4775.116603428377, 4877.219644856806, 4894.853154405374, 4916.410030796327, 4919.237518184687], "value": 4270.92159520648, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.9500284951558, 298.0403102011523, 307.649279821004, 312.8529591092187, 313.6236516180584, 5054.924176137356, 5063.240513922913, 5065.822696205633, 5070.746462676865, 5082.720450375228, 4990.975045124769, 5001.499850014997, 5009.774560144793, 5025.522575355335, 5060.190369540875, 3674.540682414705, 3741.2330472253257, 3856.633619806114, 3864.381698928172, 3867.4778904847767, 3860.4981352424147, 3863.594322596115, 3880.1287047584724, 3890.7239265029993, 3901.9804900975455, 3865.226954609075, 3882.7282090253693, 3886.1061955750192, 3898.298306304864, 3898.688104951597, 3806.6764325032127, 3864.6908247340425, 3873.341531939549, 3892.2604705106082, 3893.240818040469, 3365.6297807241185, 3390.779599326036, 3403.0981789825714, 3403.540522029544, 3406.4670898095956, 4803.759812009421, 4816.590589799871, 4818.879528011793, 4827.565519103263, 4862.586680132193, 4425.402570652953, 4471.597556219956, 4503.842365517224, 4506.662000349987, 4512.278035514335, 4885.7068575885205, 5161.303224064778, 5193.792248310063, 5197.8440646780655, 5218.208258581641, 3556.3242983833247, 3620.4388319810473, 3641.2717456508803, 3643.763155394891, 3656.4698118772894, 5508.614396992212, 5510.972445137789, 5548.77804887808, 5562.527185189264, 5579.0515612346, 3662.304162209172, 3769.359208934488, 3771.30230907283, 3772.245550889833, 3785.564660064073, 3818.0645741793437, 3830.2531006453473, 3831.3295173344554, 3850.7497012694644, 3851.6340947609933, 4405.559444055633, 4407.338899165151, 4418.823247070081, 4424.955750442518, 4432.49026361966, 5142.331496905378, 5198.0, 5201.1678131498775, 5294.894102117936, 5317.308749862493, 1268.429206856918, 1281.3080936294482, 1282.4165004922738, 1283.9679008024875, 1289.9226046437243, 821.9835603287901, 822.2558584481054, 828.1387357148618, 828.5732847583499, 835.8966164662587, 4452.332150177499, 4549.340345649928, 4588.403507543998, 4619.376384188159, 4620.561046700558, 5414.187871819258, 5455.34535855692, 5478.698671573102, 5479.780808767684, 5484.396716361197, 4412.492563355191, 4527.864164075083, 4592.6555508337005, 4605.861824145281, 4613.815447382067, 2877.856107194632, 2882.207392966951, 2888.306806366457, 2900.0, 2908.185708001763, 5078.374920025556, 5102.719350435762, 5103.311053007871, 5122.743862806845, 5126.692988155345, 5213.2701421800975, 5533.0, 5594.692291923902, 5617.662940223599, 5620.988222120058, 5122.743862806919, 5124.513171248651, 5129.384473863161, 5143.3570803649545, 5149.562287205629, 5453.890922181614, 5475.534579560782, 5480.013597552479, 5502.174673798802, 5515.669059856422, 5233.319668443078, 5343.599230057684, 5344.438833922538, 5362.552110929949, 5366.651167674088, 5119.97600479898, 5121.641485096007, 5121.8719532012, 5139.0, 5143.5113664201845, 3749.1564398010228, 3760.247950409874, 3774.698024158116, 3785.0537365658583, 3795.7342985990717, 5255.500727430888, 5436.184572314184, 5439.265699130567, 5456.317960254968, 5465.781368745205, 5291.629585928948, 5292.285541451854, 5298.8940221196135, 5306.328506520434, 5328.813491527933, 5278.2346559749385, 5303.946960530499, 5306.708131052675, 5314.468553144655, 5318.228856815817, 5016.498350164954, 5245.973770131125, 5254.65844720092, 5256.868578285574, 5286.920696189483, 5089.821856235014, 5115.0, 5276.762545685377, 5295.708736019402, 5342.6260161788305, 5159.484051594811, 5195.948040519697, 5204.843854684365, 5207.3230480038865, 5207.713575753219], "value": 3936.7914923125268, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [609.3266940031266, 636.742119441626, 660.9834754131149, 721.4877437019716, 723.9058922340095, 11608.767824643503, 12048.277103373804, 12167.209131406464, 12219.327936963464, 13250.801237981414, 12539.874601253985, 12711.42798574064, 12735.745285094292, 12745.107842451009, 12758.106932514704, 635.5074817016803, 796.2555011064674, 796.7490240574215, 806.2703253555542, 817.1215942861418, 784.1022029775903, 786.3669745854585, 789.498668345599, 789.889415481833, 790.4664351562701, 842.9072801991776, 844.1305455380967, 849.6771226933787, 849.8725191221305, 850.3877208409934, 840.0171798995191, 844.8605980013291, 845.8308338332358, 846.7459762071354, 848.3043903998723, 620.8851362497907, 621.034291676443, 621.4220774679546, 621.872516134196, 622.3309941812524, 12484.063695222894, 12508.49966001359, 12518.561850335194, 12548.309842958633, 12565.811512827315, 12410.379481025913, 12658.303793291365, 12767.808482872764, 12779.872201277962, 12905.749699169537, 9345.859812102824, 9429.622815087389, 9445.386049906734, 9475.66835160773, 9523.761905952337, 3179.8410079496166, 3240.54632351471, 3265.297960938386, 3273.9672603273902, 3276.4921437177277, 41907.37138942918, 43657.56342436567, 45382.09235815265, 45390.546094538964, 45483.0, 9717.0, 9940.353876997971, 9951.80096398068, 9952.0, 10056.396616203052, 17076.573085672957, 17130.057846818294, 17185.398511052303, 17219.827801722073, 17353.2191051403, 6329.651869147241, 6335.746570137235, 6547.345265473415, 6705.6982435790505, 6740.258571557125, 3549.982250088733, 3591.7844929304324, 3654.926901461956, 3673.7979411132646, 3709.0912726382207, 2918.1974956887025, 3012.6836682148496, 3013.5931649227514, 3021.5165573508134, 3021.9244518886762, 532.4701921587967, 534.3907944942769, 535.0369335196631, 540.7701726766109, 551.0907003444349, 588.4409810679871, 595.5625142449409, 604.3141034925303, 608.6500262349167, 630.6531407725824, 7245.492815502969, 7249.166345870187, 7281.381082607932, 7453.925460745323, 7562.281583249583, 575.3067553597905, 575.7610591604521, 577.8353169346716, 578.3753546170126, 596.8583278068711, 3707.740458167956, 3777.0, 3806.238752249561, 3842.3275926712713, 3848.0, 54629.45370546323, 56381.43618563762, 57447.71276143593, 57782.13326800102, 57805.0, 50611.0, 50709.492905070474, 51009.23486147711, 52028.21957670638, 52093.218601721004, 45528.772356138004, 47078.0, 47784.761076194394, 48035.519644803804, 48507.27239091487, 8138.715144969898, 8151.347892168731, 8189.959050204711, 8275.420720549744, 8294.129116442688, 31088.844555777076, 31232.0, 31422.842885785423, 31501.684983149877, 31835.20411989626, 37259.0, 41000.589994099675, 41178.79410602928, 41280.1743965125, 41658.79170604127, 10570.312929659547, 10579.682609521727, 10579.841302380317, 10655.467226638792, 10733.19501037441, 11646.70883227926, 12020.819687704867, 12047.698807529532, 12058.879411205775, 12708.745825083632, 10009.599616015277, 10302.22733295021, 10782.1913356497, 11465.254758440675, 11831.881681183078, 10724.478594950542, 10847.78304433891, 11010.889891101308, 11130.833037504282, 11732.706682332668, 10315.12321452685, 10333.173346132442, 10361.378317300987, 10390.272680912263, 10790.298630589301, 8730.214280714767, 8752.168543988311, 8837.955810221165, 9288.256939444964, 9379.202767764544, 9190.356675032683, 9346.769106991345, 9449.0, 9602.471864047544, 9609.711708648752], "value": 5954.7986730670555, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1582.1000000000004, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 114.0, 115.0, 114.0, 114.0, 114.0, 115.0, 114.0, 115.0, 116.0], "value": 114.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 128.0, 155.0, 183.0, 137.0, 154.0, 159.0, 132.0, 182.0, 134.0], "value": 151.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 162.0, 163.0, 167.0, 170.0, 163.0, 164.0, 163.0, 165.0, 163.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 75.0, 158.0, 78.0, 77.0, 76.0, 77.0, 161.0, 76.0], "value": 93.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 145.0, 85.0, 88.0, 86.0, 140.0, 85.0, 85.0, 136.0], "value": 102.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 148.0, 147.0, 149.0, 148.0, 147.0, 148.0, 147.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 63.0, 64.0, 64.0], "value": 63.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 65.0, 65.0, 65.0, 66.0, 66.0, 65.0, 66.0], "value": 65.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 81.0, 84.0, 84.0, 85.0, 86.0, 85.0, 84.0, 106.0, 89.0], "value": 86.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 137.0, 147.0, 130.0, 138.0, 136.0, 134.0, 147.0, 145.0, 142.0], "value": 140.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 173.0, 168.0, 174.0, 168.0, 174.0, 168.0, 173.0, 172.0, 170.0], "value": 170.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 71.0, 68.0, 66.0, 68.0, 66.0, 69.0, 67.0, 70.0, 67.0], "value": 67.9, "unit": "score"}]}]} 16:22:55 INFO - Return code: 0 16:22:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:22:55 ERROR - # TBPL SUCCESS # 16:22:55 INFO - Running post-action listener: _resource_record_post_action 16:22:55 INFO - ##### 16:22:55 INFO - ##### Finished run-tests step (success) 16:22:55 INFO - ##### 16:22:55 INFO - Running post-run listener: _resource_record_post_run 16:22:56 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 530448384; Read time: 128; Write time: 583248 16:22:56 INFO - TinderboxPrint: CPU usage
13.4% 16:22:56 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 128 16:22:56 INFO - TinderboxPrint: I/O write bytes / time
530,448,384 / 583,248 16:22:56 INFO - TinderboxPrint: CPU idle
8,267.6 (86.6%) 16:22:56 INFO - TinderboxPrint: CPU user
1,226.5 (12.8%) 16:22:56 INFO - TinderboxPrint: Swap in / out
0 / 0 16:22:56 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 211681280; Read time: 0; Write time: 328396 16:22:56 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 4096; Write bytes: 284348416; Read time: 128; Write time: 242216 16:22:56 INFO - Running post-run listener: _upload_blobber_files 16:22:56 INFO - Blob upload gear active. 16:22:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:22:56 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:22:56 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:22:56 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:22:57 INFO - (blobuploader) - INFO - Open directory for files ... 16:22:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:22:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:22:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:22:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:22:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:22:58 INFO - (blobuploader) - INFO - Done attempting. 16:22:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:22:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:22:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:23:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:23:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:23:02 INFO - (blobuploader) - INFO - Done attempting. 16:23:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:23:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:23:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:23:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:23:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:23:02 INFO - (blobuploader) - INFO - Done attempting. 16:23:02 INFO - (blobuploader) - INFO - Iteration through files over. 16:23:02 INFO - Return code: 0 16:23:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:23:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:23:02 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/df2068f503e1dc6ab9e05347f8fb3bfddf6e4de6088030c7b4222aabd5025fd3a89244b62abe4f4a4bfa457bce028bf435d9c63c2c4cb90ce87dc9feee8f209b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8c32e39190675fb9c9332f944875c25e9577bff807a7f2aaa7c4e4a3c7b634bfe8df015be50db9869de063d4a8d1be2d104c21202694d22477bc986d580bd64e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fae33c2f5c8383ce425104adbe021735798a8de2aaadd5ca4d58e83b8e4c45b707fc17e0f541ae00170dfeb8dfca14df123d357e46bae52728915da37f5081bc"} 16:23:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:23:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:23:02 INFO - Contents: 16:23:02 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/df2068f503e1dc6ab9e05347f8fb3bfddf6e4de6088030c7b4222aabd5025fd3a89244b62abe4f4a4bfa457bce028bf435d9c63c2c4cb90ce87dc9feee8f209b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8c32e39190675fb9c9332f944875c25e9577bff807a7f2aaa7c4e4a3c7b634bfe8df015be50db9869de063d4a8d1be2d104c21202694d22477bc986d580bd64e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fae33c2f5c8383ce425104adbe021735798a8de2aaadd5ca4d58e83b8e4c45b707fc17e0f541ae00170dfeb8dfca14df123d357e46bae52728915da37f5081bc"} 16:23:02 INFO - Running post-run listener: copy_logs_to_upload_dir 16:23:02 INFO - Copying logs to upload dir... 16:23:02 INFO - mkdir: /builds/slave/test/build/upload/logs 16:23:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.724545 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-05-27 16:23:02.011685) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-27 16:23:02.014922) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1464389726.939893-1090278593 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/df2068f503e1dc6ab9e05347f8fb3bfddf6e4de6088030c7b4222aabd5025fd3a89244b62abe4f4a4bfa457bce028bf435d9c63c2c4cb90ce87dc9feee8f209b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8c32e39190675fb9c9332f944875c25e9577bff807a7f2aaa7c4e4a3c7b634bfe8df015be50db9869de063d4a8d1be2d104c21202694d22477bc986d580bd64e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fae33c2f5c8383ce425104adbe021735798a8de2aaadd5ca4d58e83b8e4c45b707fc17e0f541ae00170dfeb8dfca14df123d357e46bae52728915da37f5081bc"} build_url:https://queue.taskcluster.net/v1/task/a35TCENJTbCWCF8aykz08g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011249 build_url: 'https://queue.taskcluster.net/v1/task/a35TCENJTbCWCF8aykz08g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/df2068f503e1dc6ab9e05347f8fb3bfddf6e4de6088030c7b4222aabd5025fd3a89244b62abe4f4a4bfa457bce028bf435d9c63c2c4cb90ce87dc9feee8f209b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8c32e39190675fb9c9332f944875c25e9577bff807a7f2aaa7c4e4a3c7b634bfe8df015be50db9869de063d4a8d1be2d104c21202694d22477bc986d580bd64e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fae33c2f5c8383ce425104adbe021735798a8de2aaadd5ca4d58e83b8e4c45b707fc17e0f541ae00170dfeb8dfca14df123d357e46bae52728915da37f5081bc"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-27 16:23:02.039880) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 16:23:02.040199) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1464389726.939893-1090278593 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004591 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 16:23:02.123482) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-27 16:23:02.123807) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-27 16:23:02.124086) ========= ========= Total master_lag: 0.16 =========