builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-063 starttime: 1470242321.63 results: success (0) buildid: 20160803080525 builduid: 57810839133a4137bdae12b663ef776e revision: 7f1b2e71efdcf31b521a3002719941252a8c517f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-03 09:38:41.625953) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-03 09:38:41.626536) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-03 09:38:41.626855) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-03 09:38:41.644116) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 09:38:41.644479) ========= 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=33d5923976266a1c518c4bf7000001ab-1470242321.760672-1966884339 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-03 09:38:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 89.3M=0s 2016-08-03 09:38:42 (89.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.085108 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 09:38:41.742252) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 09:38:41.742672) ========= 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=33d5923976266a1c518c4bf7000001ab-1470242321.760672-1966884339 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014886 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 09:38:41.793863) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-08-03 09:38:41.794329) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7f1b2e71efdcf31b521a3002719941252a8c517f --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 7f1b2e71efdcf31b521a3002719941252a8c517f --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=33d5923976266a1c518c4bf7000001ab-1470242321.760672-1966884339 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-03 09:38:42,765 truncating revision to first 12 chars 2016-08-03 09:38:42,766 Setting DEBUG logging. 2016-08-03 09:38:42,766 attempt 1/10 2016-08-03 09:38:42,766 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7f1b2e71efdc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-03 09:38:43,783 unpacking tar archive at: mozilla-central-7f1b2e71efdc/testing/mozharness/ program finished with exit code 0 elapsedTime=1.371213 ========= master_lag: 0.80 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-08-03 09:38:43.966692) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-03 09:38:43.967056) ========= script_repo_revision: 7f1b2e71efdcf31b521a3002719941252a8c517f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-03 09:38:43.967507) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-03 09:38:43.967802) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-03 09:38:43.979819) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-08-03 09:38:43.980506) ========= /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=33d5923976266a1c518c4bf7000001ab-1470242321.760672-1966884339 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:38:45 INFO - MultiFileLogger online at 20160803 09:38:45 in /builds/slave/test 09:38:45 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 09:38:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:38:45 INFO - {'append_to_log': False, 09:38:45 INFO - 'base_work_dir': '/builds/slave/test', 09:38:45 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 09:38:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:38:45 INFO - 'branch': 'Firefox-Non-PGO', 09:38:45 INFO - 'buildbot_json_path': 'buildprops.json', 09:38:45 INFO - 'config_files': ('talos/linux_config.py',), 09:38:45 INFO - 'default_actions': ('clobber', 09:38:45 INFO - 'read-buildbot-config', 09:38:45 INFO - 'download-and-extract', 09:38:45 INFO - 'populate-webroot', 09:38:45 INFO - 'create-virtualenv', 09:38:45 INFO - 'install', 09:38:45 INFO - 'run-tests'), 09:38:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:38:45 INFO - 'download_minidump_stackwalk': True, 09:38:45 INFO - 'download_symbols': 'ondemand', 09:38:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:38:45 INFO - 'tooltool.py': '/tools/tooltool.py', 09:38:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:38:45 INFO - '/tools/misc-python/virtualenv.py')}, 09:38:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:38:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:38:45 INFO - 'installer_path': 'installer.exe', 09:38:45 INFO - 'log_level': 'info', 09:38:45 INFO - 'log_name': 'talos', 09:38:45 INFO - 'log_to_console': True, 09:38:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:38:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:38:45 INFO - 'opt_config_files': (), 09:38:45 INFO - 'pip_index': False, 09:38:45 INFO - 'sps_profile': False, 09:38:45 INFO - 'sps_profile_interval': 0, 09:38:45 INFO - 'suite': 'dromaeojs-e10s', 09:38:45 INFO - 'system_bits': '32', 09:38:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:38:45 INFO - 'title': 'talos-linux64-ix-063', 09:38:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:38:45 INFO - 'use_talos_json': True, 09:38:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:38:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:38:45 INFO - 'work_dir': 'build'} 09:38:45 INFO - [mozharness: 2016-08-03 16:38:45.039655Z] Running clobber step. 09:38:45 INFO - Running pre-action listener: _resource_record_pre_action 09:38:45 INFO - Running main action method: clobber 09:38:45 INFO - rmtree: /builds/slave/test/build 09:38:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:38:45 INFO - Running post-action listener: _resource_record_post_action 09:38:45 INFO - [mozharness: 2016-08-03 16:38:45.504544Z] Finished clobber step (success) 09:38:45 INFO - [mozharness: 2016-08-03 16:38:45.504644Z] Running read-buildbot-config step. 09:38:45 INFO - Running pre-action listener: _resource_record_pre_action 09:38:45 INFO - Running main action method: read_buildbot_config 09:38:45 INFO - Using buildbot properties: 09:38:45 INFO - { 09:38:45 INFO - "project": "", 09:38:45 INFO - "product": "firefox", 09:38:45 INFO - "script_repo_revision": "production", 09:38:45 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 09:38:45 INFO - "repository": "", 09:38:45 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 09:38:45 INFO - "buildid": "20160803080525", 09:38:45 INFO - "pgo_build": "False", 09:38:45 INFO - "basedir": "/builds/slave/test", 09:38:45 INFO - "buildnumber": 147, 09:38:45 INFO - "slavename": "talos-linux64-ix-063", 09:38:45 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:38:45 INFO - "platform": "ubuntu64_hw", 09:38:45 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 09:38:45 INFO - "branch": "mozilla-central", 09:38:45 INFO - "repo_path": "mozilla-central", 09:38:45 INFO - "revision": "7f1b2e71efdcf31b521a3002719941252a8c517f", 09:38:45 INFO - "stage_platform": "linux64", 09:38:45 INFO - "builduid": "57810839133a4137bdae12b663ef776e", 09:38:45 INFO - "slavebuilddir": "test" 09:38:45 INFO - } 09:38:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/VPxh4njPRQeb2ZZqP85bMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 09:38:45 INFO - Running post-action listener: _resource_record_post_action 09:38:45 INFO - [mozharness: 2016-08-03 16:38:45.507273Z] Finished read-buildbot-config step (success) 09:38:45 INFO - [mozharness: 2016-08-03 16:38:45.507361Z] Running download-and-extract step. 09:38:45 INFO - Running pre-action listener: _resource_record_pre_action 09:38:45 INFO - Running main action method: download_and_extract 09:38:45 INFO - mkdir: /builds/slave/test/build/tests 09:38: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')]} 09:38:45 INFO - https://queue.taskcluster.net/v1/task/VPxh4njPRQeb2ZZqP85bMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:38:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPxh4njPRQeb2ZZqP85bMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 09:38:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPxh4njPRQeb2ZZqP85bMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 09:38:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPxh4njPRQeb2ZZqP85bMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 09:38:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPxh4njPRQeb2ZZqP85bMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:38:46 INFO - Downloaded 1361 bytes. 09:38:46 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 09:38:46 INFO - Using the following test package requirements: 09:38:46 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 09:38:46 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:38:46 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:38:46 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:38:46 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:38:46 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:38:46 INFO - u'jsshell-linux-x86_64.zip'], 09:38:46 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:38:46 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:38:46 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 09:38:46 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:38:46 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:38:46 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:38:46 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:38:46 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:38:46 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:38:46 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 09:38:46 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:38:46 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:38:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:38:46 INFO - https://queue.taskcluster.net/v1/task/VPxh4njPRQeb2ZZqP85bMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:38:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPxh4njPRQeb2ZZqP85bMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 09:38:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPxh4njPRQeb2ZZqP85bMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 09:38:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPxh4njPRQeb2ZZqP85bMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 09:38:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPxh4njPRQeb2ZZqP85bMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:38:47 INFO - Downloaded 20240814 bytes. 09:38:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:38:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:38:48 INFO - Return code: 0 09:38:48 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:38: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')]} 09:38:48 INFO - https://queue.taskcluster.net/v1/task/VPxh4njPRQeb2ZZqP85bMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:38:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPxh4njPRQeb2ZZqP85bMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 09:38:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPxh4njPRQeb2ZZqP85bMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 09:38:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPxh4njPRQeb2ZZqP85bMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 09:38:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPxh4njPRQeb2ZZqP85bMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:38:49 INFO - Downloaded 20240814 bytes. 09:38:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:38:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:38:50 INFO - Return code: 0 09:38:50 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')]} 09:38:50 INFO - https://queue.taskcluster.net/v1/task/VPxh4njPRQeb2ZZqP85bMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:38:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPxh4njPRQeb2ZZqP85bMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 09:38:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPxh4njPRQeb2ZZqP85bMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 09:38:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPxh4njPRQeb2ZZqP85bMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 09:38:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPxh4njPRQeb2ZZqP85bMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:38:53 INFO - Downloaded 14413723 bytes. 09:38:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:38:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 09:38:53 INFO - Return code: 0 09:38:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:38:53 INFO - https://queue.taskcluster.net/v1/task/VPxh4njPRQeb2ZZqP85bMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:38:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPxh4njPRQeb2ZZqP85bMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 09:38:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPxh4njPRQeb2ZZqP85bMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 09:38:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPxh4njPRQeb2ZZqP85bMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 09:38:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPxh4njPRQeb2ZZqP85bMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:38:55 INFO - Downloaded 55575114 bytes. 09:38:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VPxh4njPRQeb2ZZqP85bMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 09:38:55 INFO - mkdir: /builds/slave/test/properties 09:38:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:38:55 INFO - Writing to file /builds/slave/test/properties/build_url 09:38:55 INFO - Contents: 09:38:55 INFO - build_url:https://queue.taskcluster.net/v1/task/VPxh4njPRQeb2ZZqP85bMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 09:38:55 INFO - Running post-action listener: _resource_record_post_action 09:38:55 INFO - Running post-action listener: set_extra_try_arguments 09:38:55 INFO - [mozharness: 2016-08-03 16:38:55.718802Z] Finished download-and-extract step (success) 09:38:55 INFO - [mozharness: 2016-08-03 16:38:55.719032Z] Running populate-webroot step. 09:38:55 INFO - Running pre-action listener: _resource_record_pre_action 09:38:55 INFO - Running main action method: populate_webroot 09:38:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:38:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:38:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:38:55 INFO - '--tppagecycles', 09:38:55 INFO - '7'], 09:38:55 INFO - 'tests': ['tsvgm']}}, 09:38:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:38:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:38:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:38:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:38:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:38:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:38:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:38:55 INFO - 'talos_options': ['--disable-e10s'], 09:38:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:38:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:38:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:38:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:38:55 INFO - 'talos_options': ['--disable-e10s'], 09:38:55 INFO - 'tests': ['damp', 'tps']}, 09:38:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:38:55 INFO - 'tests': ['damp', 'tps']}, 09:38:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:38:55 INFO - 'tests': ['dromaeo_dom']}, 09:38:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:38:55 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:38:55 INFO - 'tests': ['basic_compositor_video']}, 09:38:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:38:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:38:55 INFO - 'tests': ['a11yr', 09:38:55 INFO - 'ts_paint', 09:38:55 INFO - 'tpaint', 09:38:55 INFO - 'sessionrestore', 09:38:55 INFO - 'sessionrestore_no_auto_restore', 09:38:55 INFO - 'tabpaint']}, 09:38:55 INFO - 'other-e10s': {'tests': ['a11yr', 09:38:55 INFO - 'ts_paint', 09:38:55 INFO - 'tpaint', 09:38:55 INFO - 'sessionrestore', 09:38:55 INFO - 'sessionrestore_no_auto_restore', 09:38:55 INFO - 'tabpaint']}, 09:38:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:38:55 INFO - 'ts_paint', 09:38:55 INFO - 'tpaint', 09:38:55 INFO - 'sessionrestore', 09:38:55 INFO - 'sessionrestore_no_auto_restore', 09:38:55 INFO - 'tabpaint']}, 09:38:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:38:55 INFO - 'ts_paint', 09:38:55 INFO - 'tpaint', 09:38:55 INFO - 'sessionrestore', 09:38:55 INFO - 'sessionrestore_no_auto_restore', 09:38:55 INFO - 'tabpaint']}, 09:38:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:38:55 INFO - 'tests': ['a11yr', 09:38:55 INFO - 'ts_paint', 09:38:55 INFO - 'tpaint', 09:38:55 INFO - 'sessionrestore', 09:38:55 INFO - 'sessionrestore_no_auto_restore', 09:38:55 INFO - 'tabpaint']}, 09:38:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:38:55 INFO - 'tests': ['a11yr', 09:38:55 INFO - 'ts_paint', 09:38:55 INFO - 'tpaint', 09:38:55 INFO - 'sessionrestore', 09:38:55 INFO - 'sessionrestore_no_auto_restore', 09:38:55 INFO - 'tabpaint']}, 09:38:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:38:55 INFO - 'tests': ['tsvgx', 09:38:55 INFO - 'tsvgr_opacity', 09:38:55 INFO - 'tart', 09:38:55 INFO - 'tscrollx', 09:38:55 INFO - 'cart']}, 09:38:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:38:55 INFO - 'tsvgr_opacity', 09:38:55 INFO - 'tart', 09:38:55 INFO - 'tscrollx', 09:38:55 INFO - 'cart']}, 09:38:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:38:55 INFO - 'talos_options': ['--disable-e10s'], 09:38:55 INFO - 'tests': ['tp5o']}, 09:38:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:38:55 INFO - 'tests': ['tp5o']}, 09:38:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:38:55 INFO - 'talos_options': ['--disable-e10s', 09:38:55 INFO - '--xperf_path', 09:38:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:38:55 INFO - 'tests': ['tp5n']}, 09:38:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:38:55 INFO - 'talos_options': ['--xperf_path', 09:38:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:38:55 INFO - 'tests': ['tp5n']}}, 09:38:55 INFO - 'talos.zip': {'path': '', 09:38:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:38:55 INFO - Running post-action listener: _resource_record_post_action 09:38:55 INFO - [mozharness: 2016-08-03 16:38:55.740290Z] Finished populate-webroot step (success) 09:38:55 INFO - [mozharness: 2016-08-03 16:38:55.740379Z] Running create-virtualenv step. 09:38:55 INFO - Running pre-action listener: _resource_record_pre_action 09:38:55 INFO - Running main action method: create_virtualenv 09:38:55 INFO - Creating virtualenv /builds/slave/test/build/venv 09:38:55 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 09:38:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:38:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:38:55 INFO - Using real prefix '/usr' 09:38:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:38:56 INFO - Installing distribute.............................................................................................................................................................................................done. 09:38:58 INFO - Installing pip.................done. 09:38:58 INFO - Return code: 0 09:38:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:38:58 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')]} 09:38:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:38:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:58 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')]} 09:38:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:38:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:58 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 0xfec030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12aa570>, '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 0x12ab470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ab900>, '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': '33d5923976266a1c518c4bf7000001ab-1470242321.760672-1966884339', '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 09:38:58 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 09:38:58 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 09:38:58 INFO - Using env: {'DISPLAY': ':0', 09:38:58 INFO - 'HOME': '/home/cltbld', 09:38:58 INFO - 'LANG': 'en_US.UTF-8', 09:38:58 INFO - 'LANGUAGE': 'en_US:en', 09:38:58 INFO - 'LOGNAME': 'cltbld', 09:38:58 INFO - 'MAIL': '/var/mail/cltbld', 09:38:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:58 INFO - 'MOZ_NO_REMOTE': '1', 09:38:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:38:58 INFO - 'NO_EM_RESTART': '1', 09:38:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:38:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:58 INFO - 'PWD': '/builds/slave/test', 09:38:58 INFO - 'SHELL': '/bin/bash', 09:38:58 INFO - 'SHLVL': '1', 09:38:58 INFO - 'TERM': 'linux', 09:38:58 INFO - 'TMOUT': '86400', 09:38:58 INFO - 'USER': 'cltbld', 09:38:58 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1470242321.760672-1966884339', 09:38:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:58 INFO - '_': '/tools/buildbot/bin/python'} 09:38:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:38:58 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 09:38:58 INFO - Cleaning up... 09:38:58 INFO - Return code: 0 09:38:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:38:58 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')]} 09:38:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:38:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:58 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')]} 09:38:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:38:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:38:58 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 0xfec030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12aa570>, '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 0x12ab470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ab900>, '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': '33d5923976266a1c518c4bf7000001ab-1470242321.760672-1966884339', '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 09:38:58 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 09:38:58 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 09:38:58 INFO - Using env: {'DISPLAY': ':0', 09:38:58 INFO - 'HOME': '/home/cltbld', 09:38:58 INFO - 'LANG': 'en_US.UTF-8', 09:38:58 INFO - 'LANGUAGE': 'en_US:en', 09:38:58 INFO - 'LOGNAME': 'cltbld', 09:38:58 INFO - 'MAIL': '/var/mail/cltbld', 09:38:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:38:58 INFO - 'MOZ_NO_REMOTE': '1', 09:38:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:38:58 INFO - 'NO_EM_RESTART': '1', 09:38:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:38:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:38:58 INFO - 'PWD': '/builds/slave/test', 09:38:58 INFO - 'SHELL': '/bin/bash', 09:38:58 INFO - 'SHLVL': '1', 09:38:58 INFO - 'TERM': 'linux', 09:38:58 INFO - 'TMOUT': '86400', 09:38:58 INFO - 'USER': 'cltbld', 09:38:58 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1470242321.760672-1966884339', 09:38:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:38:58 INFO - '_': '/tools/buildbot/bin/python'} 09:38:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:38:58 INFO - Downloading/unpacking psutil>=3.1.1 09:38:58 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 09:38:58 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 09:38:58 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 09:38:58 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 09:38:58 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 09:38:58 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 09:39:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:39:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:39:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:39:00 INFO - Installing collected packages: psutil 09:39:00 INFO - Running setup.py install for psutil 09:39:00 INFO - building 'psutil._psutil_linux' extension 09:39:00 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 09:39:00 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 09:39:00 INFO - building 'psutil._psutil_posix' extension 09:39:00 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 09:39:01 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 09:39:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:39:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:39:01 INFO - Successfully installed psutil 09:39:01 INFO - Cleaning up... 09:39:01 INFO - Return code: 0 09:39:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:39:01 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')]} 09:39:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:01 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')]} 09:39:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:01 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 0xfec030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12aa570>, '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 0x12ab470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ab900>, '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': '33d5923976266a1c518c4bf7000001ab-1470242321.760672-1966884339', '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 09:39:01 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 09:39:01 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 09:39:01 INFO - Using env: {'DISPLAY': ':0', 09:39:01 INFO - 'HOME': '/home/cltbld', 09:39:01 INFO - 'LANG': 'en_US.UTF-8', 09:39:01 INFO - 'LANGUAGE': 'en_US:en', 09:39:01 INFO - 'LOGNAME': 'cltbld', 09:39:01 INFO - 'MAIL': '/var/mail/cltbld', 09:39:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:01 INFO - 'MOZ_NO_REMOTE': '1', 09:39:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:01 INFO - 'NO_EM_RESTART': '1', 09:39:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:01 INFO - 'PWD': '/builds/slave/test', 09:39:01 INFO - 'SHELL': '/bin/bash', 09:39:01 INFO - 'SHLVL': '1', 09:39:01 INFO - 'TERM': 'linux', 09:39:01 INFO - 'TMOUT': '86400', 09:39:01 INFO - 'USER': 'cltbld', 09:39:01 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1470242321.760672-1966884339', 09:39:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:01 INFO - '_': '/tools/buildbot/bin/python'} 09:39:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:39:01 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 09:39:01 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 09:39:01 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 09:39:01 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 09:39:01 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 09:39:01 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 09:39:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:39:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:39:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:39:03 INFO - Installing collected packages: mozsystemmonitor 09:39:03 INFO - Running setup.py install for mozsystemmonitor 09:39:03 INFO - Successfully installed mozsystemmonitor 09:39:03 INFO - Cleaning up... 09:39:03 INFO - Return code: 0 09:39:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:39:03 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')]} 09:39:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:03 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')]} 09:39:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfec030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12aa570>, '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 0x12ab470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ab900>, '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': '33d5923976266a1c518c4bf7000001ab-1470242321.760672-1966884339', '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 09:39:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:39:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:39:03 INFO - Using env: {'DISPLAY': ':0', 09:39:03 INFO - 'HOME': '/home/cltbld', 09:39:03 INFO - 'LANG': 'en_US.UTF-8', 09:39:03 INFO - 'LANGUAGE': 'en_US:en', 09:39:03 INFO - 'LOGNAME': 'cltbld', 09:39:03 INFO - 'MAIL': '/var/mail/cltbld', 09:39:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:03 INFO - 'MOZ_NO_REMOTE': '1', 09:39:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:03 INFO - 'NO_EM_RESTART': '1', 09:39:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:03 INFO - 'PWD': '/builds/slave/test', 09:39:03 INFO - 'SHELL': '/bin/bash', 09:39:03 INFO - 'SHLVL': '1', 09:39:03 INFO - 'TERM': 'linux', 09:39:03 INFO - 'TMOUT': '86400', 09:39:03 INFO - 'USER': 'cltbld', 09:39:03 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1470242321.760672-1966884339', 09:39:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:03 INFO - '_': '/tools/buildbot/bin/python'} 09:39:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:03 INFO - Downloading/unpacking jsonschema==2.5.1 09:39:03 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 09:39:03 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 09:39:03 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 09:39:03 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 09:39:03 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 09:39:03 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 09:39:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:39:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:39:05 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 09:39:05 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 09:39:05 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 09:39:05 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 09:39:05 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 09:39:05 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 09:39:05 INFO - Downloading functools32-3.2.3-2.tar.gz 09:39:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:39:05 INFO - warning: no files found matching '*.txt' 09:39:05 INFO - no previously-included directories found matching 'build' 09:39:05 INFO - no previously-included directories found matching 'dist' 09:39:05 INFO - no previously-included directories found matching '.git*' 09:39:05 INFO - Installing collected packages: jsonschema, functools32 09:39:05 INFO - Running setup.py install for functools32 09:39:06 INFO - warning: no files found matching '*.txt' 09:39:06 INFO - no previously-included directories found matching 'build' 09:39:06 INFO - no previously-included directories found matching 'dist' 09:39:06 INFO - no previously-included directories found matching '.git*' 09:39:06 INFO - Successfully installed jsonschema functools32 09:39:06 INFO - Cleaning up... 09:39:06 INFO - Return code: 0 09:39:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:39:06 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')]} 09:39:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:06 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')]} 09:39:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:06 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfec030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12aa570>, '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 0x12ab470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ab900>, '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': '33d5923976266a1c518c4bf7000001ab-1470242321.760672-1966884339', '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 09:39:06 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:39:06 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 functools32==3.2.3-2 09:39:06 INFO - Using env: {'DISPLAY': ':0', 09:39:06 INFO - 'HOME': '/home/cltbld', 09:39:06 INFO - 'LANG': 'en_US.UTF-8', 09:39:06 INFO - 'LANGUAGE': 'en_US:en', 09:39:06 INFO - 'LOGNAME': 'cltbld', 09:39:06 INFO - 'MAIL': '/var/mail/cltbld', 09:39:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:06 INFO - 'MOZ_NO_REMOTE': '1', 09:39:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:06 INFO - 'NO_EM_RESTART': '1', 09:39:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:06 INFO - 'PWD': '/builds/slave/test', 09:39:06 INFO - 'SHELL': '/bin/bash', 09:39:06 INFO - 'SHLVL': '1', 09:39:06 INFO - 'TERM': 'linux', 09:39:06 INFO - 'TMOUT': '86400', 09:39:06 INFO - 'USER': 'cltbld', 09:39:06 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1470242321.760672-1966884339', 09:39:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:06 INFO - '_': '/tools/buildbot/bin/python'} 09:39:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:39:06 INFO - Cleaning up... 09:39:06 INFO - Return code: 0 09:39:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:39:06 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')]} 09:39:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:06 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')]} 09:39:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:06 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 0xfec030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12aa570>, '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 0x12ab470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ab900>, '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': '33d5923976266a1c518c4bf7000001ab-1470242321.760672-1966884339', '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 09:39:06 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 09:39:06 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 09:39:06 INFO - Using env: {'DISPLAY': ':0', 09:39:06 INFO - 'HOME': '/home/cltbld', 09:39:06 INFO - 'LANG': 'en_US.UTF-8', 09:39:06 INFO - 'LANGUAGE': 'en_US:en', 09:39:06 INFO - 'LOGNAME': 'cltbld', 09:39:06 INFO - 'MAIL': '/var/mail/cltbld', 09:39:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:06 INFO - 'MOZ_NO_REMOTE': '1', 09:39:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:06 INFO - 'NO_EM_RESTART': '1', 09:39:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:06 INFO - 'PWD': '/builds/slave/test', 09:39:06 INFO - 'SHELL': '/bin/bash', 09:39:06 INFO - 'SHLVL': '1', 09:39:06 INFO - 'TERM': 'linux', 09:39:06 INFO - 'TMOUT': '86400', 09:39:06 INFO - 'USER': 'cltbld', 09:39:06 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1470242321.760672-1966884339', 09:39:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:06 INFO - '_': '/tools/buildbot/bin/python'} 09:39:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:06 INFO - Downloading/unpacking blobuploader==1.2.4 09:39:06 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 09:39:06 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 09:39:06 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 09:39:06 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 09:39:06 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 09:39:06 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 09:39:08 INFO - Downloading blobuploader-1.2.4.tar.gz 09:39:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:39:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:39:08 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 09:39:08 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 09:39:08 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 09:39:08 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 09:39:08 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 09:39:08 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 09:39:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:39:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:39:08 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 09:39:08 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 09:39:08 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 09:39:08 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 09:39:08 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 09:39:08 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 09:39:09 INFO - Downloading docopt-0.6.1.tar.gz 09:39:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:39:09 INFO - Installing collected packages: blobuploader, requests, docopt 09:39:09 INFO - Running setup.py install for blobuploader 09:39:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:39:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:39:09 INFO - Running setup.py install for requests 09:39:09 INFO - Running setup.py install for docopt 09:39:09 INFO - Successfully installed blobuploader requests docopt 09:39:09 INFO - Cleaning up... 09:39:09 INFO - Return code: 0 09:39:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:39:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:39:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:39:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:09 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 0xfec030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12aa570>, '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 0x12ab470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ab900>, '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': '33d5923976266a1c518c4bf7000001ab-1470242321.760672-1966884339', '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 09:39:09 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 09:39:09 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 09:39:09 INFO - Using env: {'DISPLAY': ':0', 09:39:09 INFO - 'HOME': '/home/cltbld', 09:39:09 INFO - 'LANG': 'en_US.UTF-8', 09:39:09 INFO - 'LANGUAGE': 'en_US:en', 09:39:09 INFO - 'LOGNAME': 'cltbld', 09:39:09 INFO - 'MAIL': '/var/mail/cltbld', 09:39:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:09 INFO - 'MOZ_NO_REMOTE': '1', 09:39:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:09 INFO - 'NO_EM_RESTART': '1', 09:39:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:09 INFO - 'PWD': '/builds/slave/test', 09:39:09 INFO - 'SHELL': '/bin/bash', 09:39:09 INFO - 'SHLVL': '1', 09:39:09 INFO - 'TERM': 'linux', 09:39:09 INFO - 'TMOUT': '86400', 09:39:09 INFO - 'USER': 'cltbld', 09:39:09 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1470242321.760672-1966884339', 09:39:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:09 INFO - '_': '/tools/buildbot/bin/python'} 09:39:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:39:09 INFO - Running setup.py (path:/tmp/pip-ujXoag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:39:10 INFO - Running setup.py (path:/tmp/pip-UuE35p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:39:10 INFO - Running setup.py (path:/tmp/pip-J_zPir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:39:10 INFO - Running setup.py (path:/tmp/pip-H_NLd7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:39:10 INFO - Running setup.py (path:/tmp/pip-WPkHRh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:39:10 INFO - Running setup.py (path:/tmp/pip-2zFaeE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:39:10 INFO - Running setup.py (path:/tmp/pip-6BF43A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:39:10 INFO - Running setup.py (path:/tmp/pip-gPKPIR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:39:10 INFO - Running setup.py (path:/tmp/pip-m1lRle-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:39:10 INFO - Running setup.py (path:/tmp/pip-46H4bu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:39:10 INFO - Running setup.py (path:/tmp/pip-ATKLYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:39:10 INFO - Running setup.py (path:/tmp/pip-ejO_tG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:39:10 INFO - Running setup.py (path:/tmp/pip-vuSQ9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:39:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:39:10 INFO - Running setup.py (path:/tmp/pip-EQbUwz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:39:11 INFO - Running setup.py (path:/tmp/pip-T9sMma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:39:11 INFO - Running setup.py (path:/tmp/pip-Z4PKyE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:39:11 INFO - Running setup.py (path:/tmp/pip-r1pG8Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:39:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:39:11 INFO - Running setup.py install for manifestparser 09:39:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:39:11 INFO - Running setup.py install for mozcrash 09:39:11 INFO - Running setup.py install for mozdebug 09:39:11 INFO - Running setup.py install for mozdevice 09:39:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:39:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:39:11 INFO - Running setup.py install for mozfile 09:39:11 INFO - Running setup.py install for mozhttpd 09:39:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:39:11 INFO - Running setup.py install for mozinfo 09:39:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:39:11 INFO - Running setup.py install for mozInstall 09:39:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:39:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:39:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:39:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:39:12 INFO - Running setup.py install for mozleak 09:39:12 INFO - Running setup.py install for mozlog 09:39:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:39:12 INFO - Running setup.py install for moznetwork 09:39:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:39:12 INFO - Running setup.py install for mozprocess 09:39:12 INFO - Running setup.py install for mozprofile 09:39:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:39:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:39:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:39:12 INFO - Running setup.py install for mozrunner 09:39:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:39:12 INFO - Running setup.py install for mozscreenshot 09:39:12 INFO - Running setup.py install for moztest 09:39:12 INFO - Running setup.py install for mozversion 09:39:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:39:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:39:13 INFO - Cleaning up... 09:39:13 INFO - Return code: 0 09:39:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:39:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:39:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:39:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:13 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 0xfec030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12aa570>, '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 0x12ab470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ab900>, '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': '33d5923976266a1c518c4bf7000001ab-1470242321.760672-1966884339', '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 09:39:13 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 09:39:13 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 09:39:13 INFO - Using env: {'DISPLAY': ':0', 09:39:13 INFO - 'HOME': '/home/cltbld', 09:39:13 INFO - 'LANG': 'en_US.UTF-8', 09:39:13 INFO - 'LANGUAGE': 'en_US:en', 09:39:13 INFO - 'LOGNAME': 'cltbld', 09:39:13 INFO - 'MAIL': '/var/mail/cltbld', 09:39:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:13 INFO - 'MOZ_NO_REMOTE': '1', 09:39:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:13 INFO - 'NO_EM_RESTART': '1', 09:39:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:13 INFO - 'PWD': '/builds/slave/test', 09:39:13 INFO - 'SHELL': '/bin/bash', 09:39:13 INFO - 'SHLVL': '1', 09:39:13 INFO - 'TERM': 'linux', 09:39:13 INFO - 'TMOUT': '86400', 09:39:13 INFO - 'USER': 'cltbld', 09:39:13 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1470242321.760672-1966884339', 09:39:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:13 INFO - '_': '/tools/buildbot/bin/python'} 09:39:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:39:13 INFO - Running setup.py (path:/tmp/pip-WdZ6rm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:39:13 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)) 09:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:39:13 INFO - Running setup.py (path:/tmp/pip-AX1VK8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:39:13 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)) 09:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:39:13 INFO - Running setup.py (path:/tmp/pip-FSU2TI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:39:13 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)) 09:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:39:13 INFO - Running setup.py (path:/tmp/pip-DkkME4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:39:13 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)) 09:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:39:13 INFO - Running setup.py (path:/tmp/pip-661e6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:39:13 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)) 09:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:39:13 INFO - Running setup.py (path:/tmp/pip-4Ynyvg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:39:13 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)) 09:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:39:13 INFO - Running setup.py (path:/tmp/pip-cUULz5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:39:13 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)) 09:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:39:13 INFO - Running setup.py (path:/tmp/pip-0kH3Ug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:39:13 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)) 09:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:39:13 INFO - Running setup.py (path:/tmp/pip-uZtJaR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:39:13 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)) 09:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:39:13 INFO - Running setup.py (path:/tmp/pip-xkU7nb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:39:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 09:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:39:13 INFO - Running setup.py (path:/tmp/pip-3wnZOe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:39:14 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)) 09:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:39:14 INFO - Running setup.py (path:/tmp/pip-IJ4eN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:39:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 09:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:39:14 INFO - Running setup.py (path:/tmp/pip-ajAEPO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:39:14 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)) 09:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:39:14 INFO - Running setup.py (path:/tmp/pip-0lksFk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:39:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 09:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:39:14 INFO - Running setup.py (path:/tmp/pip-NTBXsR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:39:14 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)) 09:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:39:14 INFO - Running setup.py (path:/tmp/pip-H7uE1o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:39:14 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)) 09:39:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:39:14 INFO - Running setup.py (path:/tmp/pip-i9RVGT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:39:14 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)) 09:39:14 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)) 09:39:14 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)) 09:39:14 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)) 09:39:14 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)) 09:39:14 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)) 09:39:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:39:14 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 09:39:14 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 09:39:14 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 09:39:14 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 09:39:14 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 09:39:14 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 09:39:16 INFO - Downloading blessings-1.6.tar.gz 09:39:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:39:16 INFO - Installing collected packages: blessings 09:39:16 INFO - Running setup.py install for blessings 09:39:16 INFO - Successfully installed blessings 09:39:16 INFO - Cleaning up... 09:39:16 INFO - Return code: 0 09:39:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:39:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:39:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:39:16 INFO - Reading from file tmpfile_stdout 09:39:16 INFO - Current package versions: 09:39:16 INFO - argparse == 1.2.1 09:39:16 INFO - blessings == 1.6 09:39:16 INFO - blobuploader == 1.2.4 09:39:16 INFO - docopt == 0.6.1 09:39:16 INFO - functools32 == 3.2.3-2 09:39:16 INFO - jsonschema == 2.5.1 09:39:16 INFO - manifestparser == 1.1 09:39:16 INFO - mozInstall == 1.12 09:39:16 INFO - mozcrash == 0.17 09:39:16 INFO - mozdebug == 0.1 09:39:16 INFO - mozdevice == 0.48 09:39:16 INFO - mozfile == 1.2 09:39:16 INFO - mozhttpd == 0.7 09:39:16 INFO - mozinfo == 0.9 09:39:16 INFO - mozleak == 0.1 09:39:16 INFO - mozlog == 3.3 09:39:16 INFO - moznetwork == 0.27 09:39:16 INFO - mozprocess == 0.23 09:39:16 INFO - mozprofile == 0.28 09:39:16 INFO - mozrunner == 6.12 09:39:16 INFO - mozscreenshot == 0.1 09:39:16 INFO - mozsystemmonitor == 0.3 09:39:16 INFO - moztest == 0.7 09:39:16 INFO - mozversion == 1.4 09:39:16 INFO - psutil == 3.1.1 09:39:16 INFO - requests == 1.2.3 09:39:16 INFO - wsgiref == 0.1.2 09:39:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:39:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:39:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:39:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:16 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 0xfec030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12aa570>, '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 0x12ab470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ab900>, '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': '33d5923976266a1c518c4bf7000001ab-1470242321.760672-1966884339', '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 09:39:16 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 09:39:16 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 09:39:16 INFO - Using env: {'DISPLAY': ':0', 09:39:16 INFO - 'HOME': '/home/cltbld', 09:39:16 INFO - 'LANG': 'en_US.UTF-8', 09:39:16 INFO - 'LANGUAGE': 'en_US:en', 09:39:16 INFO - 'LOGNAME': 'cltbld', 09:39:16 INFO - 'MAIL': '/var/mail/cltbld', 09:39:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:16 INFO - 'MOZ_NO_REMOTE': '1', 09:39:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:16 INFO - 'NO_EM_RESTART': '1', 09:39:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:16 INFO - 'PWD': '/builds/slave/test', 09:39:16 INFO - 'SHELL': '/bin/bash', 09:39:16 INFO - 'SHLVL': '1', 09:39:16 INFO - 'TERM': 'linux', 09:39:16 INFO - 'TMOUT': '86400', 09:39:16 INFO - 'USER': 'cltbld', 09:39:16 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1470242321.760672-1966884339', 09:39:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:16 INFO - '_': '/tools/buildbot/bin/python'} 09:39:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:17 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)) 09:39:17 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)) 09:39:17 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)) 09:39:17 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)) 09:39:17 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)) 09:39:17 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)) 09:39:17 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)) 09:39:17 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)) 09:39:17 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)) 09:39:17 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)) 09:39:17 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)) 09:39:17 INFO - Cleaning up... 09:39:17 INFO - Return code: 0 09:39:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:39:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:39:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:39:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:39:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:39:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:39:17 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 0xfec030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12aa570>, '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 0x12ab470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ab900>, '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': '33d5923976266a1c518c4bf7000001ab-1470242321.760672-1966884339', '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 09:39:17 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 09:39:17 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 09:39:17 INFO - Using env: {'DISPLAY': ':0', 09:39:17 INFO - 'HOME': '/home/cltbld', 09:39:17 INFO - 'LANG': 'en_US.UTF-8', 09:39:17 INFO - 'LANGUAGE': 'en_US:en', 09:39:17 INFO - 'LOGNAME': 'cltbld', 09:39:17 INFO - 'MAIL': '/var/mail/cltbld', 09:39:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:17 INFO - 'MOZ_NO_REMOTE': '1', 09:39:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:17 INFO - 'NO_EM_RESTART': '1', 09:39:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:17 INFO - 'PWD': '/builds/slave/test', 09:39:17 INFO - 'SHELL': '/bin/bash', 09:39:17 INFO - 'SHLVL': '1', 09:39:17 INFO - 'TERM': 'linux', 09:39:17 INFO - 'TMOUT': '86400', 09:39:17 INFO - 'USER': 'cltbld', 09:39:17 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1470242321.760672-1966884339', 09:39:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:17 INFO - '_': '/tools/buildbot/bin/python'} 09:39:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:39:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:39:17 INFO - Cleaning up... 09:39:17 INFO - Return code: 0 09:39:17 INFO - Running post-action listener: _resource_record_post_action 09:39:17 INFO - Running post-action listener: _start_resource_monitoring 09:39:17 INFO - Starting resource monitoring. 09:39:17 INFO - [mozharness: 2016-08-03 16:39:17.335469Z] Finished create-virtualenv step (success) 09:39:17 INFO - [mozharness: 2016-08-03 16:39:17.336022Z] Running install step. 09:39:17 INFO - Running pre-action listener: _resource_record_pre_action 09:39:17 INFO - Running main action method: install 09:39:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:39:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:39:17 INFO - Reading from file tmpfile_stdout 09:39:17 INFO - Detecting whether we're running mozinstall >=1.0... 09:39:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:39:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:39:17 INFO - Reading from file tmpfile_stdout 09:39:17 INFO - Output received: 09:39:17 INFO - Usage: mozinstall [options] installer 09:39:17 INFO - Options: 09:39:17 INFO - -h, --help show this help message and exit 09:39:17 INFO - -d DEST, --destination=DEST 09:39:17 INFO - Directory to install application into. [default: 09:39:17 INFO - "/builds/slave/test"] 09:39:17 INFO - --app=APP Application being installed. [default: firefox] 09:39:17 INFO - mkdir: /builds/slave/test/build/application 09:39:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:39:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:39:36 INFO - Reading from file tmpfile_stdout 09:39:36 INFO - Output received: 09:39:36 INFO - /builds/slave/test/build/application/firefox/firefox 09:39:36 INFO - Running post-action listener: _resource_record_post_action 09:39:36 INFO - [mozharness: 2016-08-03 16:39:36.167074Z] Finished install step (success) 09:39:36 INFO - [mozharness: 2016-08-03 16:39:36.167355Z] Running run-tests step. 09:39:36 INFO - Running pre-action listener: _resource_record_pre_action 09:39:36 INFO - Running main action method: run_tests 09:39:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:39:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:39:36 INFO - Python 2.7.3 09:39:36 INFO - Return code: 0 09:39:36 INFO - grabbing minidump binary from tooltool 09:39: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')]} 09:39:36 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 0x12aa570>, '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 0x12ab470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12ab900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:39:36 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 09:39:36 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 09:39:36 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 09:39:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:39:43 INFO - Return code: 0 09:39:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:39:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:39:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:39:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:39:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:39:43 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/VPxh4njPRQeb2ZZqP85bMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 09:39:43 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/VPxh4njPRQeb2ZZqP85bMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-063 --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 09:39:43 INFO - Using env: {'DISPLAY': ':0', 09:39:43 INFO - 'HOME': '/home/cltbld', 09:39:43 INFO - 'LANG': 'en_US.UTF-8', 09:39:43 INFO - 'LANGUAGE': 'en_US:en', 09:39:43 INFO - 'LOGNAME': 'cltbld', 09:39:43 INFO - 'MAIL': '/var/mail/cltbld', 09:39:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:39:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:39:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:39:43 INFO - 'MOZ_NO_REMOTE': '1', 09:39:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:39:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:39:43 INFO - 'NO_EM_RESTART': '1', 09:39:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:39:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:39:43 INFO - 'PWD': '/builds/slave/test', 09:39:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:39:43 INFO - 'SHELL': '/bin/bash', 09:39:43 INFO - 'SHLVL': '1', 09:39:43 INFO - 'TERM': 'linux', 09:39:43 INFO - 'TMOUT': '86400', 09:39:43 INFO - 'USER': 'cltbld', 09:39:43 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1470242321.760672-1966884339', 09:39:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:39:43 INFO - '_': '/tools/buildbot/bin/python'} 09:39:43 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/VPxh4njPRQeb2ZZqP85bMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 09:39:43 INFO - mozversion application_buildid: 20160803080525 09:39:43 INFO - mozversion application_changeset: 7f1b2e71efdcf31b521a3002719941252a8c517f 09:39:43 INFO - mozversion application_display_name: Nightly 09:39:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:39:43 INFO - mozversion application_name: Firefox 09:39:43 INFO - mozversion application_remotingname: firefox 09:39:43 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:39:43 INFO - mozversion application_vendor: Mozilla 09:39:43 INFO - mozversion application_version: 51.0a1 09:39:43 INFO - mozversion platform_buildid: 20160803080525 09:39:43 INFO - mozversion platform_changeset: 7f1b2e71efdcf31b521a3002719941252a8c517f 09:39:43 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:39:43 INFO - mozversion platform_version: 51.0a1 09:39:43 INFO - using testdate: 1470242383 09:39:43 INFO - actual date: 1470242383 09:39:43 INFO - starting webserver on 'localhost:37296' 09:39:43 INFO - SUITE-START | Running 2 tests 09:39:43 INFO - TEST-START | dromaeo_css 09:39:43 INFO - operating with platform_type : linux_ 09:39:43 INFO - Initialising browser for dromaeo_css test... 09:39:43 INFO - TEST-INFO | started process 18810 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHKQb6M/profile http://localhost:37296/getInfo.html) 09:39:52 INFO - PROCESS | 18810 | __metrics Screen width/height:1600/1200 09:39:52 INFO - PROCESS | 18810 | colorDepth:24 09:39:52 INFO - PROCESS | 18810 | Browser inner width/height: 1024/697 09:39:52 INFO - PROCESS | 18810 | __metrics 09:39:54 ERROR - PROCESS | 18810 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 09:39:55 INFO - TEST-INFO | 18810: exit 0 09:39:55 INFO - Browser initialized. 09:39:55 INFO - Running cycle 1/1 for dromaeo_css test... 09:39:55 INFO - TEST-INFO | started process 18930 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHKQb6M/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:40:07 INFO - PROCESS | 18930 | RSS: Main: 164450304 09:40:07 INFO - PROCESS | 18930 | 09:40:56 INFO - PROCESS | 18930 | 1470242456717 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] 09:43:13 INFO - PROCESS | 18930 | Cycle 1(1): loaded http://localhost:37296/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37296/tests/dromaeo/cssquery-ext.html) 09:43:14 INFO - PROCESS | 18930 | RSS: Main: 165412864 09:43:14 INFO - PROCESS | 18930 | 09:46:17 INFO - PROCESS | 18930 | Cycle 1(1): loaded http://localhost:37296/tests/dromaeo/cssquery-ext.html (next: http://localhost:37296/tests/dromaeo/cssquery-jquery.html) 09:46:17 INFO - PROCESS | 18930 | RSS: Main: 166326272 09:46:17 INFO - PROCESS | 18930 | 09:49:19 INFO - PROCESS | 18930 | Cycle 1(1): loaded http://localhost:37296/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37296/tests/dromaeo/cssquery-mootools.html) 09:49:20 INFO - PROCESS | 18930 | RSS: Main: 170332160 09:49:20 INFO - PROCESS | 18930 | 09:52:22 INFO - PROCESS | 18930 | Cycle 1(1): loaded http://localhost:37296/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37296/tests/dromaeo/cssquery-prototype.html) 09:52:22 INFO - PROCESS | 18930 | RSS: Main: 164225024 09:52:22 INFO - PROCESS | 18930 | 09:55:25 INFO - PROCESS | 18930 | Cycle 1(1): loaded http://localhost:37296/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37296/tests/dromaeo/cssquery-yui.html) 09:55:26 INFO - PROCESS | 18930 | RSS: Main: 166531072 09:55:26 INFO - PROCESS | 18930 | 09:58:28 INFO - PROCESS | 18930 | Cycle 1(1): loaded http://localhost:37296/tests/dromaeo/cssquery-yui.html (next: http://localhost:37296/tests/dromaeo/cssquery-dojo.html) 09:58:29 INFO - PROCESS | 18930 | RSS: Main: 169754624 09:58:29 INFO - PROCESS | 18930 | 09:58:29 INFO - PROCESS | 18930 | __start_tp_report 09:58:29 INFO - PROCESS | 18930 | _x_x_mozilla_page_load 09:58:29 INFO - PROCESS | 18930 | _x_x_mozilla_page_load_details 09:58:29 INFO - PROCESS | 18930 | |i|pagename|runs| 09:58:29 INFO - PROCESS | 18930 | |0;dojo.html;2707.2284398946304;2713;2757.6415066041413;2764.640596722426;2767.681716602594;4722.150012997659;4883.926741098886;4896.632752543555;4905.166121759301;4988.276699878525;4756.00123973965;4924.827631032915;5113.181890897457;5129.435762066169;5138.229265610151;4578.1301552705045;4621.353010578522;4665.253559430492;4674.579287864091;4718.386609740729;4333.9133217335475;4464.129494748526;4524.09518096382;4527.501974782755;4553.658475614326;4453.755043472608;4455.46534415869;4470.955290447119;4558.726476411426;4574.4739354973935;4501.774911254457;4509.842155524574;4527.275635898273;4550.658700597469;4552.135094332067;4464.129494748526;4479.7984090716;4531.501534831166;4579.450465944108;4583.633309335279;4870.683405578626;4954.752262386866;4963.205887058053;4970;4979.751012449363;5362.168863826113;5372.140457526777;5405.783768649249;5408.783648654049;5426.972865135649;5139.691618502864;5190.169572868323;5330.4936031076595;5392.514673679388;5395.838124856261;4979.228219625964;4992.101421744121;5013.699178049329;5014.89970200594;5052.141136006888;5537.7784888604;5539.473749993744;5552.7778888843995;5557.77768889248;5595.160725891149;5106.106431374495;5214.45248248936;5227.215917612312;5245.790168393298;5320;5348.171033489815;5355.410904800468;5363.383210930793;5370.597205209625;5374.140137577969;5292.7353632319;5299.205119232069;5305.708186049727;5317.973410133002;5365.597580181502;5073.746312684351;5261.631685782035;5322.148456246982;5323.22813192085;5395.595330350239;4584.358189853423;4590.563896429834;4596.586307232298;4608.170529304691;4659.4175728034;3949.0917089069676;3955.7428767130045;3973.0464688475136;3975.4633124528395;4040.595940405936;4464.129494748558;4623.676342656049;4630.791614377361;4635.3742244797195;4697.013627138271;5384.219288203189;5401.7299135043095;5415.241866138744;5417.972910135503;5420.159875219348;4650.4186976627925;4655.51117132703;4657.86026419208;4661.673682842236;4695.5539223773685;4613.100445413179;4758.666893317434;4799.976000120117;4820.325154478306;4862.781174847211;5006.524380183877;5039.445660977363;5040.344755181803;5040.395152581714;5087.618428617942;5373.838784836461;5384.138537833927;5386.542143917811;5401.081816091352;5403.891922161456;4858.368412106403;5018.197088465828;5026.070177017264;5061.974690126526;5126.615503837153;5363.490468405495;5370.650907690988;5375.6774593524515;5382.865428364322;5390.407055224001;5404.594655400782;5440;5445.074337362737;5459.781608735606;5482.2873026506295;5090.872728181825;5091.541761241506;5174.353205849269;5179.766910489112;5264.947350526599;5155.968806238692;5191.974040129775;5194.246834208943;5203.713795741271;5204.869878253074;5074.873128171826;5114.258432527337;5119.488051195;5129.512696293846;5143.71709555978;5028.723420211923;5189.818356357509;5194.792208311776;5215.348081489814;5292;5083.313752643494;5120.231965205249;5125.692458452505;5136.948630513647;5141.922871156861 09:58:29 INFO - PROCESS | 18930 | |1;ext.html;548.747576114987;560.918666793315;567.8182981445937;570.5635189080355;589.9262592175978;35084.824575877115;38551.614483855155;38667;38845;38905;38960.41559376605;39345;39492;39492.80253598728;39687.206255874866;7621.771346859603;7686.884696729554;7747.883781743279;7769.0677118745825;7785.727499537517;7735.651895664709;7740.225977402243;7785.532868027908;7786.688532458723;7810.375169986388;7800.414968877329;7825.295723384894;7842.529448233125;7844.882326765103;7846.254605812467;7764.18476060014;7814.179511151333;7816.218378162195;7823.726169584065;7843.843123137505;7666.693332266758;7763.301302882767;7778.844423111506;7780.338671212954;7781.494202876852;36973.44539831905;37399.4390084149;37406.625933740586;37447;37541;3043.6195475565555;3129.217695576106;3280.6391296957318;3327.4177019021577;3412.0787387405508;28908;29177;29419.264518386997;29824;30246.54630180549;3285.3100848821778;3490.249596336774;3500.929981400383;3510.912227194315;3565.982170089159;205583;244376;247150;248289;249038;53778.73110634422;53913;54011;54111.72944135254;54524.72737636286;32079;32567.674323256466;32733.508997365057;35051.29897402089;35064.29871402609;13953.930230348784;14075.57773266783;14080.929595351958;14084.85915140856;14147.575572732834;10426.530806113591;10455.424951627581;10518.211134164969;10534.894651053544;10574.89425105739;18012.819871801377;18055.548611284823;18120;18129;18134.183961721756;6806.693698783567;6820.727170913108;6826.624535650587;6909.585424874524;6941.271166527442;806.5120602035802;898.4654130792168;950.083169741203;956.2875657635107;978.3347323819728;28107.43785124286;28274.71725282762;28780.136595902157;28792.136235912956;29162.41675166527;832.309183377795;883.7083762358407;929.9116583924516;1038.6157121864808;1070.4166229404993;14921.925390372979;15050.473233436776;15085.698286034218;15236;15373.231338433257;392478;396890;397934;398277;398433;49695.25457118146;49764;49779.50220497821;49855;49905.50094499008;1146.3981409759776;1149.741308205647;1186.851643544557;1187.9406029698307;1207.9214851034656;26357.34106647349;27442.313942151606;27642.44715105727;28003.43993120167;28304;41686.791566041975;41852.581474184866;42148.1570368597;42148.789256053526;42149.789251053546;327932;328379;328477;330833;330838;25315;25443.6183457252;25749.3562660935;25768.355791105372;25830.741692582833;41948.37077443902;42282;42457.5754242466;42768;43183.568164317956;36196;36268.637313626525;36413.817930910176;36651.633483664824;37561.81219093887;36113.27773444569;36324.818375907955;36462.63537364592;37029.25941481209;37296.25407491889;34972;35441.1139721509;35616.64383356237;36093.819530902176;36237.0940726484;30417.39165216639;33366.83316583402;33519.497207542394;33634;33742;25206.74793252044;25522.361940951625;25663.615045773953;25705.357366065997;26249.73750262473 09:58:29 INFO - PROCESS | 18930 | |2;jquery.html;352.12321319913406;363.398575357783;368.26898606266565;371.92189640175565;373.2590807247613;15933.920330398361;16369.754453683205;17347.306107755692;17382;17475.912620436913;15635.687286254297;16447.671046579093;16939.661206775858;17029.233684484196;17042.65914681709;5106.719130447833;5322.574194064485;5340.67955922644;5341.385740639818;5351.2240725095035;5059.924101138486;5250.31745873036;5287.2862163608;5290.55030322423;5292.788288468457;5244.973775131119;5366.221897824813;5367.838964831042;5368.677879327233;5375.623706340558;5330.200469929503;5702.429757024306;5855.560832937546;5890.175375447441;5965.3736357682255;4553.886152846172;5377.623566350357;5379.112446446332;5383.4616538346245;5393.83818485446;11223.775524489465;11859.347735874524;11875.40622968848;11898.10764192689;11919.165658403916;1915.0999030455664;2147.915302772106;2286.8451432026886;2334.4047267946567;2363.1256435118944;8940;9029.232515236214;9060.456372617664;9153.08469153086;9248.815023699555;1682.856957158643;1700.4388551777884;1706.3174730107933;1744;1769.5310742653207;65861.67069164671;71579.64210178968;72298;72664.27335726628;73491;9446.527673616292;9592.184664303473;9678.70963871085;9689.854652180224;9833.262505311986;12582.937085314516;12597.181183223061;12630.368481575884;12636.873631263754;12657.114002019955;6751.156105486814;6857.2114206866845;6943.583384996917;6945.062416573698;7022.157341119098;6320.62076275425;6413.134226879405;6457.224263327623;6635.834104147339;6640.667966601651;3949.3878448840474;3956.5756327721997;3968.1071758854027;4104.179164167179;4118.19695159441;1671.147714665505;1714.502794189696;1736.8436840684399;1780.1811166863129;1805.5486128467883;847.8304339132198;877.9778824715797;888.9511076890833;920.7559996600907;938.0010289042149;17098.316067357166;17355.13224338778;17588.296468141387;17793.7330940036;17814.287428502714;841.8105926166686;865.35098675993;867.3754896474528;894.4409743910056;902.1925376787739;9403.247740180768;9972.50137493137;10024.749381265527;10062.496875156214;10097.293189476813;367734;368893.6221275613;390074;401347;403784;79681.60159199283;82071.5896420514;82857;83169;83605;880.3881302494833;888.2938064238946;905.4250550900226;909;916.2807196350833;15478.690426191639;15618.375264989727;16088.678226435171;16278.43025494102;16356.182190890646;37228.6277137236;37854.43218351782;38585.80707096559;38953.80523097367;39356.80321598374;51111;52321.7383913078;53684.73157634187;54467;55098.72450637721;6494.4804415645685;7344.449166312441;7372.225916278713;7452.850942981218;7671.232876712284;11051.502682379472;11435.828462572901;11484.483198255932;11485.138614603771;11591.710207244887;9750.268729845147;10023.44871032071;10175.89824101779;10221.795564088825;10255.897441025792;10218.693439196835;10330.948345258226;10463.895361046596;10477.68566942993;10714.785704285714;10079.496025198858;10268.58925642966;10305.175585952957;10550.314229575053;10770.73073173177;6658.300878407697;6991.755288564876;6992.685329160302;6998.370146686822;7023.754168604074;9985.301028927905;10118.241131914989;10213;10219.831966095755;10228.693139205836 09:58:29 INFO - PROCESS | 18930 | |3;mootools.html;1369.7192075624498;1422.5732280315906;1459.8321193062795;1583.8812089093321;1631.4453085950774;6714.899276510844;7120.8931866021985;7345.15530713968;7652.502587331826;7662.233776622335;7402.296781805733;7666.386689064875;7676.117246516652;7677.270659287373;7702.691892324315;2176.629972904606;2219.079082180893;2219.079082180901;2223.488597622548;2230.1413955627118;2142.368001439579;2201.1635578480236;2216.2907869481774;2224.944376390595;2226.0984301357976;2182.530755887484;2200.141944641591;2210.1601391471218;2219.5449932763745;2229.0972156276734;2165.8267338612873;2169.2516081951703;2172.576347612216;2176.4994051368194;2178.237616834111;2126.0857831132607;2156.644153714635;2161.4056134562966;2162.1459523488134;2164.199246278871;7778.961105194495;7812.609369531558;7836.294733473957;7866.410019248522;7897.921020789776;4331.675124365654;4451.332300154971;4484.304932735431;4486.102779444124;4490.797914093873;2863.9427211455863;2873.41095075509;2887.3359127400604;2956.305268261957;2999.2052106191877;859.3683642522741;891.9866202006975;898.9685361012398;899.8380291547519;928.6007016982695;10178.541965611565;10218.540165692562;10218.642347517876;10232.641857535025;10273.178145748398;3839.481669974518;3987.8205480752854;4119.464469618931;4126.216018956388;4143.523494798076;8874.334424918157;8880.822383552293;8881.156290152554;8890.511021893857;8913.24237439812;4445.777711114496;4448.755318457451;4457.175422546839;4474.105178964155;4479.955200448019;3547.911302217465;3931.941020884689;4034.1931613677384;4074.30736774749;4089.1003979124544;3700.740948133605;3711.16498787776;3773.735838491334;3787.0721673190246;3822.1782316802023;1223.8103094020441;1224.400043978444;1225.681322856046;1230.1880758699215;1235.6725467751053;790.2571582712233;802.0415603353936;811.922867327603;819.1562690428868;841.7011960753845;4896.387951506062;5048.53592458183;5057.620678449131;5091.2363145527725;5098.413682426569;371.2426649634769;378.23973812636797;387.96896248300067;405.07642574929207;407.19172442701216;3452.3267962747022;3452.4648679454726;3494.336076145524;3508.7193024558483;3572.624874388204;9046.954765226132;9477.526123693788;9481.810363792685;9488.430694158373;9519.143277105093;9407.106324899123;9407.388519746195;9431;9439.575219115157;9440.10319019692;7161.961515580316;7183.3534981850835;7194.568325900463;7314.012608297918;7330.633468326669;5005.7997680092385;5060.291559181644;5102.387713474407;5115.820946266863;5132.486751324837;8617.87073193915;8621.439606425562;8643.135686431558;8681.262092722189;8692.174243446863;8703.521306327959;8802.779930501789;8810.471371717718;8833.602487887933;8856.690015849414;5881.882362352814;6448.161738973903;6615.6030638161865;6703.095082163845;6784.525083244125;7446.14369347532;7507.211742766931;7508.587027713528;7510.624468776648;7524.924750752422;6614.669266536558;6710.765123220664;6726.932730672826;6767.526273161028;6823.522353435212;6580.473562115115;6604.471642268511;6657.267700553032;6735.4274886635185;6834.45324374039;6256.655883926245;6321.49428045746;6338.619682819046;6341.270753863365;6354.3963323484195;4521.547845215452;4536.432945881765;4582.747948862844;4584.289435137559;4631.907361852676;4332.696711230184;4353.847615333448;4462.219111655512;4513.413256276663;4551.954480455153 09:58:29 INFO - PROCESS | 18930 | |4;prototype.html;282.9844358560279;287.76115823866195;291.45643375105436;292.5407110835987;295.30750390334657;5109.233614957759;5144.4598317176715;5192.104881718174;5194.168932970725;5196.298499702544;5022.447530771621;5067.695938243708;5073.695578265307;5079.64442489025;5092.414372347182;3745.8127093645344;3813.7033408641055;3909.3745000799877;3916.4321173429835;3926.7840268785208;3907.1599606084687;3911.3546264866263;3913.31516984528;3913.6086391360923;3920.3335432976464;3891.8443262269616;3904.824282907262;3912.784796836173;3937.2519221347998;3951.70362222833;3841.116543195053;3909.4526766252748;3921;3921.607839216084;3928.1947200823906;3419.6409377015552;3424.8116353600544;3429.9485507717404;3436.9312613747584;3445.2248244145117;4908.288298196777;4925.827596034122;4956.330895329121;4959.7024178549045;4961.237212276219;4345.544242678707;4524.547545245482;4539.568740969603;4540;4541.977290113528;5283.418823929364;5310.495502927216;5325.760340784635;5330.866728331784;5346.545543628797;3781.1870447853566;3784.678302344304;3792.658660720521;3793.2413517296377;3797.829097690583;5359.892802143935;5598.1322894951345;5600.803971861006;5606.635568688022;5630.521405680522;3841.519810023747;3845.038740314921;3845.596212397658;3846.4230365445405;3861.1505468796818;3917.4123881417445;3926.939726273947;3935.763854168702;3936.724429289922;3939.625735555118;4480.372747815309;4494.348319493655;4509.278515437514;4515.209838278288;4545.477270113913;5230.7384630769075;5296.443873393316;5306.204069389545;5349.598780091509;5362.168863826113;1332.1540821578367;1347.5014244729514;1352.5333759852836;1355.2275203134118;1355.8440779310308;819.3076850061689;846.1622993236651;863.7236084453041;865.3601425299023;868.4355169140109;4513.300438432048;4538.364628951949;4729.456112547033;4740.312654665055;4789.832355867528;5528.530074943675;5537.4495141360485;5582.637128586629;5589.456797157283;5618.719064046863;4647.09381670571;4763.73799441034;4765.451973023078;4777.355057067251;4785;2931.4316840490237;2931.7540045480587;2945.617069780915;2970.885917780832;2977.2408035950693;5183.248428977777;5202.479752024843;5203.401608814959;5208.817691380784;5218.660787048906;5504.697241651667;5635.549156067505;5651.576131790132;5657.915131273035;5716.657000579979;5107.514786095315;5124.641275110706;5125.359330083665;5144.76848541824;5151.845444636667;5473.890522189614;5505.862353441196;5528.640638358494;5535.986409852985;5557.72211389437;5102.387713474258;5378.542823860016;5391.919121213106;5435.918461223006;5440;5205.869853253547;5223.791048358175;5234.869128271824;5252.741321231907;5261.973690131525;3880.1075752576503;3898.863539776094;3916.5300163980505;3924.7645141291614;3925.548561915302;5388.757505912165;5429.429909859408;5462.132629055423;5471.151971444432;5478.671279723229;5316.9468305318;5362.865928351823;5365;5371.62398632092;5373.543248823894;5097.311862898461;5304;5326.041312563776;5328.813491527778;5404.972975135099;5255.921161182662;5263.815766448156;5267.657602255841;5281.920771188512;5310.867228319168;5052.368453943257;5242.633015688865;5348.197770334481;5409.539424355481;5413.267754318737;5244.033487442209;5260.658057226268;5296.232046353334;5296.894062118813;5299.682019078868 09:58:29 INFO - PROCESS | 18930 | |5;yui.html;624.8250489862837;635.1837888313518;657.3131078023465;720.7225218290959;727.7380143148463;12423.31671758053;13704.862951370484;13801.861981380183;13809.171449713025;13878.791818122723;12760.106792524526;12789.168704034231;12821.42303596338;12853.22880627163;12873.742525149491;633.3002032753786;764.2815753191995;782.104490358542;783.5572901310769;784.7998760316111;769.3537428560008;793.0325003495755;801.4229754576695;802.3861745764466;802.6909639788665;829.1832544943226;832.5379414424991;832.9833403331929;836.3058661311128;836.8117173635944;824.785555755502;826.3182874128838;826.3926014379426;827.1728271728272;830.8504469195542;602.28027507129;602.7528713227599;604.6764980735286;605.5942518512608;608.2761513798565;12891.548795792101;12891.935540322238;12923.353832308441;12947.546835860794;12954.222746635232;13672.453101875913;13680.31598420085;14189.155459709962;14361.281935903164;14497.130172189702;10524.47377631123;10529.84205236922;10692;10700.357978521235;10775.137988960865;3330.2340461693702;3345.9498107528407;3364.9831750841336;3376.0547046826928;3399.5920489541168;69867.30132698659;71650.28349716488;72349.6382518084;72472;73993.26006739917;10512.264141510173;10691.281887786754;10707.464626768631;10810.783784324269;10846.837297440545;20996.370108896757;21077.26229581957;21208;21312.680309795367;21326.14695412166;6940.548864323803;7009.1589009319205;7024.964875175591;7106.467014973898;7139.500234983501;3752.962470375261;3819.6180381962135;3849.8075096245075;3904.6876249899938;3918.5101862267215;2829.872655730497;2913.839738814343;2919.5766613840874;2919.8102123361914;2925.546540286259;475.1945452458119;488.08727679239337;491.76395330241684;499.81007217257934;503.2978994302927;556.1435389500206;589.1016200294499;589.1310317281975;601.8435206846251;609.7439075588263;7837.216278372117;7971.880421793678;8151.592420378957;8305.46014509055;8431;468.8593421973463;507.5160952980386;580.5935844908581;581.2913611160767;596.6300893446091;3893.182431689377;3930.606939306104;3989.4215338776294;4055.7363771354767;4109.547949725527;98355.50822245843;101984.49007755062;103897;104531.4773426128;106926;90319;91517;91726;93702.53148734348;93781.96635252383;77430.61284693654;77586.22413775903;77668;78136.60931695305;79221.99999999885;7427.517211381243;7719.845603088019;7804.102528209101;7951.244631759973;8050.476719013245;47441.99481078259;47670;48288.758556206994;48982.75508622576;50279.49720502748;61424;66874;68183;68235.65882170557;70320;10555.208359372924;10644.84032739494;10716.464176790972;10901.236913415985;10996.945015275192;11222.494987725735;11552.191346605658;11788;11793.70515737079;12055.51777928873;10808;11054.285232870543;11242.325460472397;11252.831207532057;11558.653240402802;10063.446510441996;10143.949280253551;10222.948885255526;10318.896811031793;10520.684379468628;10718.678439646823;11108.854086672964;11161.274517156358;11511.884881151416;11762.58830940913;8773.210411063035;9078.909210907806;9179.449233046038;9281.814363712552;9633.32566720351;8274.544900030556;8669.60986755585;8724.520151391735;8827.504269696092;9004 09:58:29 INFO - PROCESS | 18930 | __end_tp_report 09:58:29 INFO - PROCESS | 18930 | __start_cc_report 09:58:29 INFO - PROCESS | 18930 | _x_x_mozilla_cycle_collect,375 09:58:29 INFO - PROCESS | 18930 | __end_cc_report 09:58:29 INFO - PROCESS | 18930 | __startTimestamp1470243509130__endTimestamp 09:58:29 INFO - PROCESS | 18930 | 09:58:29 INFO - PROCESS | 18930 | ------- Summary: start ------- 09:58:29 INFO - PROCESS | 18930 | Number of tests: 6 09:58:29 INFO - PROCESS | 18930 | 09:58:29 INFO - PROCESS | 18930 | [#0] dojo.html Cycles:165 Average:4932.94 Median:5074.87 stddev:534.55 (10.5%) stddev-sans-first:506.87 09:58:29 INFO - PROCESS | 18930 | Values: 2707.2 2713.0 2757.6 2764.6 2767.7 4722.2 4883.9 4896.6 4905.2 4988.3 4756.0 4924.8 5113.2 5129.4 5138.2 4578.1 4621.4 4665.3 4674.6 4718.4 4333.9 4464.1 4524.1 4527.5 4553.7 4453.8 4455.5 4471.0 4558.7 4574.5 4501.8 4509.8 4527.3 4550.7 4552.1 4464.1 4479.8 4531.5 4579.5 4583.6 4870.7 4954.8 4963.2 4970.0 4979.8 5362.2 5372.1 5405.8 5408.8 5427.0 5139.7 5190.2 5330.5 5392.5 5395.8 4979.2 4992.1 5013.7 5014.9 5052.1 5537.8 5539.5 5552.8 5557.8 5595.2 5106.1 5214.5 5227.2 5245.8 5320.0 5348.2 5355.4 5363.4 5370.6 5374.1 5292.7 5299.2 5305.7 5318.0 5365.6 5073.7 5261.6 5322.1 5323.2 5395.6 4584.4 4590.6 4596.6 4608.2 4659.4 3949.1 3955.7 3973.0 3975.5 4040.6 4464.1 4623.7 4630.8 4635.4 4697.0 5384.2 5401.7 5415.2 5418.0 5420.2 4650.4 4655.5 4657.9 4661.7 4695.6 4613.1 4758.7 4800.0 4820.3 4862.8 5006.5 5039.4 5040.3 5040.4 5087.6 5373.8 5384.1 5386.5 5401.1 5403.9 4858.4 5018.2 5026.1 5062.0 5126.6 5363.5 5370.7 5375.7 5382.9 5390.4 5404.6 5440.0 5445.1 5459.8 5482.3 5090.9 5091.5 5174.4 5179.8 5264.9 5156.0 5192.0 5194.2 5203.7 5204.9 5074.9 5114.3 5119.5 5129.5 5143.7 5028.7 5189.8 5194.8 5215.3 5292.0 5083.3 5120.2 5125.7 5136.9 5141.9 09:58:29 INFO - PROCESS | 18930 | 09:58:29 INFO - PROCESS | 18930 | [#1] ext.html Cycles:180 Average:47065.37 Median:36296.73 stddev:86527.82 (238.4%) stddev-sans-first:86700.07 09:58:29 INFO - PROCESS | 18930 | Values: 548.7 560.9 567.8 570.6 589.9 35084.8 38551.6 38667.0 38845.0 38905.0 38960.4 39345.0 39492.0 39492.8 39687.2 7621.8 7686.9 7747.9 7769.1 7785.7 7735.7 7740.2 7785.5 7786.7 7810.4 7800.4 7825.3 7842.5 7844.9 7846.3 7764.2 7814.2 7816.2 7823.7 7843.8 7666.7 7763.3 7778.8 7780.3 7781.5 36973.4 37399.4 37406.6 37447.0 37541.0 3043.6 3129.2 3280.6 3327.4 3412.1 28908.0 29177.0 29419.3 29824.0 30246.5 3285.3 3490.2 3500.9 3510.9 3566.0 205583.0 244376.0 247150.0 248289.0 249038.0 53778.7 53913.0 54011.0 54111.7 54524.7 32079.0 32567.7 32733.5 35051.3 35064.3 13953.9 14075.6 14080.9 14084.9 14147.6 10426.5 10455.4 10518.2 10534.9 10574.9 18012.8 18055.5 18120.0 18129.0 18134.2 6806.7 6820.7 6826.6 6909.6 6941.3 806.5 898.5 950.1 956.3 978.3 28107.4 28274.7 28780.1 28792.1 29162.4 832.3 883.7 929.9 1038.6 1070.4 14921.9 15050.5 15085.7 15236.0 15373.2 392478.0 396890.0 397934.0 398277.0 398433.0 49695.3 49764.0 49779.5 49855.0 49905.5 1146.4 1149.7 1186.9 1187.9 1207.9 26357.3 27442.3 27642.4 28003.4 28304.0 41686.8 41852.6 42148.2 42148.8 42149.8 327932.0 328379.0 328477.0 330833.0 330838.0 25315.0 25443.6 25749.4 25768.4 25830.7 41948.4 42282.0 42457.6 42768.0 43183.6 36196.0 36268.6 36413.8 36651.6 37561.8 36113.3 36324.8 36462.6 37029.3 37296.3 34972.0 35441.1 35616.6 36093.8 36237.1 30417.4 33366.8 33519.5 33634.0 33742.0 25206.7 25522.4 25663.6 25705.4 26249.7 09:58:29 INFO - PROCESS | 18930 | 09:58:29 INFO - PROCESS | 18930 | [#2] jquery.html Cycles:180 Average:24201.09 Median:4336.04 stddev:64125.74 (1478.9%) stddev-sans-first:64280.63 09:58:29 INFO - PROCESS | 18930 | Values: 352.1 363.4 368.3 371.9 373.3 15933.9 16369.8 17347.3 17382.0 17475.9 15635.7 16447.7 16939.7 17029.2 17042.7 5106.7 5322.6 5340.7 5341.4 5351.2 5059.9 5250.3 5287.3 5290.6 5292.8 5245.0 5366.2 5367.8 5368.7 5375.6 5330.2 5702.4 5855.6 5890.2 5965.4 4553.9 5377.6 5379.1 5383.5 5393.8 11223.8 11859.3 11875.4 11898.1 11919.2 1915.1 2147.9 2286.8 2334.4 2363.1 8940.0 9029.2 9060.5 9153.1 9248.8 1682.9 1700.4 1706.3 1744.0 1769.5 65861.7 71579.6 72298.0 72664.3 73491.0 9446.5 9592.2 9678.7 9689.9 9833.3 12582.9 12597.2 12630.4 12636.9 12657.1 6751.2 6857.2 6943.6 6945.1 7022.2 6320.6 6413.1 6457.2 6635.8 6640.7 3949.4 3956.6 3968.1 4104.2 4118.2 1671.1 1714.5 1736.8 1780.2 1805.5 847.8 878.0 889.0 920.8 938.0 17098.3 17355.1 17588.3 17793.7 17814.3 841.8 865.4 867.4 894.4 902.2 9403.2 9972.5 10024.7 10062.5 10097.3 367734.0 368893.6 390074.0 401347.0 403784.0 79681.6 82071.6 82857.0 83169.0 83605.0 880.4 888.3 905.4 909.0 916.3 15478.7 15618.4 16088.7 16278.4 16356.2 37228.6 37854.4 38585.8 38953.8 39356.8 51111.0 52321.7 53684.7 54467.0 55098.7 6494.5 7344.4 7372.2 7452.9 7671.2 11051.5 11435.8 11484.5 11485.1 11591.7 9750.3 10023.4 10175.9 10221.8 10255.9 10218.7 10330.9 10463.9 10477.7 10714.8 10079.5 10268.6 10305.2 10550.3 10770.7 6658.3 6991.8 6992.7 6998.4 7023.8 9985.3 10118.2 10213.0 10219.8 10228.7 09:58:29 INFO - PROCESS | 18930 | 09:58:29 INFO - PROCESS | 18930 | [#3] mootools.html Cycles:180 Average:5029.96 Median:4951.09 stddev:2815.08 (56.9%) stddev-sans-first:2809.54 09:58:29 INFO - PROCESS | 18930 | Values: 1369.7 1422.6 1459.8 1583.9 1631.4 6714.9 7120.9 7345.2 7652.5 7662.2 7402.3 7666.4 7676.1 7677.3 7702.7 2176.6 2219.1 2219.1 2223.5 2230.1 2142.4 2201.2 2216.3 2224.9 2226.1 2182.5 2200.1 2210.2 2219.5 2229.1 2165.8 2169.3 2172.6 2176.5 2178.2 2126.1 2156.6 2161.4 2162.1 2164.2 7779.0 7812.6 7836.3 7866.4 7897.9 4331.7 4451.3 4484.3 4486.1 4490.8 2863.9 2873.4 2887.3 2956.3 2999.2 859.4 892.0 899.0 899.8 928.6 10178.5 10218.5 10218.6 10232.6 10273.2 3839.5 3987.8 4119.5 4126.2 4143.5 8874.3 8880.8 8881.2 8890.5 8913.2 4445.8 4448.8 4457.2 4474.1 4480.0 3547.9 3931.9 4034.2 4074.3 4089.1 3700.7 3711.2 3773.7 3787.1 3822.2 1223.8 1224.4 1225.7 1230.2 1235.7 790.3 802.0 811.9 819.2 841.7 4896.4 5048.5 5057.6 5091.2 5098.4 371.2 378.2 388.0 405.1 407.2 3452.3 3452.5 3494.3 3508.7 3572.6 9047.0 9477.5 9481.8 9488.4 9519.1 9407.1 9407.4 9431.0 9439.6 9440.1 7162.0 7183.4 7194.6 7314.0 7330.6 5005.8 5060.3 5102.4 5115.8 5132.5 8617.9 8621.4 8643.1 8681.3 8692.2 8703.5 8802.8 8810.5 8833.6 8856.7 5881.9 6448.2 6615.6 6703.1 6784.5 7446.1 7507.2 7508.6 7510.6 7524.9 6614.7 6710.8 6726.9 6767.5 6823.5 6580.5 6604.5 6657.3 6735.4 6834.5 6256.7 6321.5 6338.6 6341.3 6354.4 4521.5 4536.4 4582.7 4584.3 4631.9 4332.7 4353.8 4462.2 4513.4 4552.0 09:58:29 INFO - PROCESS | 18930 | 09:58:29 INFO - PROCESS | 18930 | [#4] prototype.html Cycles:180 Average:4425.64 Median:5094.86 stddev:1301.80 (25.6%) stddev-sans-first:1267.77 09:58:29 INFO - PROCESS | 18930 | Values: 283.0 287.8 291.5 292.5 295.3 5109.2 5144.5 5192.1 5194.2 5196.3 5022.4 5067.7 5073.7 5079.6 5092.4 3745.8 3813.7 3909.4 3916.4 3926.8 3907.2 3911.4 3913.3 3913.6 3920.3 3891.8 3904.8 3912.8 3937.3 3951.7 3841.1 3909.5 3921.0 3921.6 3928.2 3419.6 3424.8 3429.9 3436.9 3445.2 4908.3 4925.8 4956.3 4959.7 4961.2 4345.5 4524.5 4539.6 4540.0 4542.0 5283.4 5310.5 5325.8 5330.9 5346.5 3781.2 3784.7 3792.7 3793.2 3797.8 5359.9 5598.1 5600.8 5606.6 5630.5 3841.5 3845.0 3845.6 3846.4 3861.2 3917.4 3926.9 3935.8 3936.7 3939.6 4480.4 4494.3 4509.3 4515.2 4545.5 5230.7 5296.4 5306.2 5349.6 5362.2 1332.2 1347.5 1352.5 1355.2 1355.8 819.3 846.2 863.7 865.4 868.4 4513.3 4538.4 4729.5 4740.3 4789.8 5528.5 5537.4 5582.6 5589.5 5618.7 4647.1 4763.7 4765.5 4777.4 4785.0 2931.4 2931.8 2945.6 2970.9 2977.2 5183.2 5202.5 5203.4 5208.8 5218.7 5504.7 5635.5 5651.6 5657.9 5716.7 5107.5 5124.6 5125.4 5144.8 5151.8 5473.9 5505.9 5528.6 5536.0 5557.7 5102.4 5378.5 5391.9 5435.9 5440.0 5205.9 5223.8 5234.9 5252.7 5262.0 3880.1 3898.9 3916.5 3924.8 3925.5 5388.8 5429.4 5462.1 5471.2 5478.7 5316.9 5362.9 5365.0 5371.6 5373.5 5097.3 5304.0 5326.0 5328.8 5405.0 5255.9 5263.8 5267.7 5281.9 5310.9 5052.4 5242.6 5348.2 5409.5 5413.3 5244.0 5260.7 5296.2 5296.9 5299.7 09:58:29 INFO - PROCESS | 18930 | 09:58:29 INFO - PROCESS | 18930 | [#5] yui.html Cycles:180 Average:18696.36 Median:24737.26 stddev:27510.21 (111.2%) stddev-sans-first:27553.92 09:58:29 INFO - PROCESS | 18930 | Values: 624.8 635.2 657.3 720.7 727.7 12423.3 13704.9 13801.9 13809.2 13878.8 12760.1 12789.2 12821.4 12853.2 12873.7 633.3 764.3 782.1 783.6 784.8 769.4 793.0 801.4 802.4 802.7 829.2 832.5 833.0 836.3 836.8 824.8 826.3 826.4 827.2 830.9 602.3 602.8 604.7 605.6 608.3 12891.5 12891.9 12923.4 12947.5 12954.2 13672.5 13680.3 14189.2 14361.3 14497.1 10524.5 10529.8 10692.0 10700.4 10775.1 3330.2 3345.9 3365.0 3376.1 3399.6 69867.3 71650.3 72349.6 72472.0 73993.3 10512.3 10691.3 10707.5 10810.8 10846.8 20996.4 21077.3 21208.0 21312.7 21326.1 6940.5 7009.2 7025.0 7106.5 7139.5 3753.0 3819.6 3849.8 3904.7 3918.5 2829.9 2913.8 2919.6 2919.8 2925.5 475.2 488.1 491.8 499.8 503.3 556.1 589.1 589.1 601.8 609.7 7837.2 7971.9 8151.6 8305.5 8431.0 468.9 507.5 580.6 581.3 596.6 3893.2 3930.6 3989.4 4055.7 4109.5 98355.5 101984.5 103897.0 104531.5 106926.0 90319.0 91517.0 91726.0 93702.5 93782.0 77430.6 77586.2 77668.0 78136.6 79222.0 7427.5 7719.8 7804.1 7951.2 8050.5 47442.0 47670.0 48288.8 48982.8 50279.5 61424.0 66874.0 68183.0 68235.7 70320.0 10555.2 10644.8 10716.5 10901.2 10996.9 11222.5 11552.2 11788.0 11793.7 12055.5 10808.0 11054.3 11242.3 11252.8 11558.7 10063.4 10143.9 10222.9 10318.9 10520.7 10718.7 11108.9 11161.3 11511.9 11762.6 8773.2 9078.9 9179.4 9281.8 9633.3 8274.5 8669.6 8724.5 8827.5 9004.0 09:58:29 INFO - PROCESS | 18930 | -------- Summary: end -------- 09:58:29 INFO - PROCESS | 18930 | 09:58:30 INFO - TEST-INFO | 18930: exit 0 09:58:30 INFO - TEST-OK | dromaeo_css | took 1126190ms 09:58:30 INFO - TEST-START | kraken 09:58:30 INFO - operating with platform_type : linux_ 09:58:30 INFO - Initialising browser for kraken test... 09:58:30 INFO - TEST-INFO | started process 19176 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm3qXbH/profile http://localhost:37296/getInfo.html) 09:58:37 INFO - PROCESS | 19176 | __metrics Screen width/height:1600/1200 09:58:37 INFO - PROCESS | 19176 | colorDepth:24 09:58:37 INFO - PROCESS | 19176 | Browser inner width/height: 1024/697 09:58:37 INFO - PROCESS | 19176 | __metrics 09:58:38 ERROR - PROCESS | 19176 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 09:58:40 INFO - TEST-INFO | 19176: exit 0 09:58:40 INFO - Browser initialized. 09:58:40 INFO - Running cycle 1/1 for kraken test... 09:58:40 INFO - TEST-INFO | started process 19297 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm3qXbH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:58:51 INFO - PROCESS | 19297 | RSS: Main: 165117952 09:58:51 INFO - PROCESS | 19297 | 09:58:54 INFO - PROCESS | 19297 | Cycle 1(1): loaded http://localhost:37296/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37296/tests/kraken/driver.html?testName=audio-beat-detection) 09:58:55 INFO - PROCESS | 19297 | RSS: Main: 170373120 09:58:55 INFO - PROCESS | 19297 | 09:58:58 INFO - PROCESS | 19297 | Cycle 1(1): loaded http://localhost:37296/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37296/tests/kraken/driver.html?testName=audio-dft) 09:58:59 INFO - PROCESS | 19297 | RSS: Main: 168960000 09:58:59 INFO - PROCESS | 19297 | 09:59:02 INFO - PROCESS | 19297 | Cycle 1(1): loaded http://localhost:37296/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37296/tests/kraken/driver.html?testName=audio-fft) 09:59:02 INFO - PROCESS | 19297 | RSS: Main: 164880384 09:59:02 INFO - PROCESS | 19297 | 09:59:04 INFO - PROCESS | 19297 | Cycle 1(1): loaded http://localhost:37296/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37296/tests/kraken/driver.html?testName=audio-oscillator) 09:59:05 INFO - PROCESS | 19297 | RSS: Main: 165871616 09:59:05 INFO - PROCESS | 19297 | 09:59:07 INFO - PROCESS | 19297 | Cycle 1(1): loaded http://localhost:37296/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37296/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:59:08 INFO - PROCESS | 19297 | RSS: Main: 166371328 09:59:08 INFO - PROCESS | 19297 | 09:59:11 INFO - PROCESS | 19297 | Cycle 1(1): loaded http://localhost:37296/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37296/tests/kraken/driver.html?testName=imaging-darkroom) 09:59:12 INFO - PROCESS | 19297 | RSS: Main: 166445056 09:59:12 INFO - PROCESS | 19297 | 09:59:15 INFO - PROCESS | 19297 | Cycle 1(1): loaded http://localhost:37296/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37296/tests/kraken/driver.html?testName=imaging-desaturate) 09:59:16 INFO - PROCESS | 19297 | RSS: Main: 163766272 09:59:16 INFO - PROCESS | 19297 | 09:59:19 INFO - PROCESS | 19297 | Cycle 1(1): loaded http://localhost:37296/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37296/tests/kraken/driver.html?testName=json-parse-financial) 09:59:20 INFO - PROCESS | 19297 | RSS: Main: 166072320 09:59:20 INFO - PROCESS | 19297 | 09:59:21 INFO - PROCESS | 19297 | Cycle 1(1): loaded http://localhost:37296/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37296/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:59:22 INFO - PROCESS | 19297 | RSS: Main: 165896192 09:59:22 INFO - PROCESS | 19297 | 09:59:24 INFO - PROCESS | 19297 | Cycle 1(1): loaded http://localhost:37296/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37296/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:59:25 INFO - PROCESS | 19297 | RSS: Main: 166342656 09:59:25 INFO - PROCESS | 19297 | 09:59:27 INFO - PROCESS | 19297 | Cycle 1(1): loaded http://localhost:37296/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37296/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:59:28 INFO - PROCESS | 19297 | RSS: Main: 166834176 09:59:28 INFO - PROCESS | 19297 | 09:59:30 INFO - PROCESS | 19297 | Cycle 1(1): loaded http://localhost:37296/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37296/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:59:31 INFO - PROCESS | 19297 | RSS: Main: 167215104 09:59:31 INFO - PROCESS | 19297 | 09:59:34 INFO - PROCESS | 19297 | Cycle 1(1): loaded http://localhost:37296/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37296/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:59:35 INFO - PROCESS | 19297 | RSS: Main: 167174144 09:59:35 INFO - PROCESS | 19297 | 09:59:36 INFO - PROCESS | 19297 | Cycle 1(1): loaded http://localhost:37296/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37296/tests/kraken/driver.html?testName=ai-astar) 09:59:37 INFO - PROCESS | 19297 | RSS: Main: 168210432 09:59:37 INFO - PROCESS | 19297 | 09:59:37 INFO - PROCESS | 19297 | __start_tp_report 09:59:37 INFO - PROCESS | 19297 | _x_x_mozilla_page_load 09:59:37 INFO - PROCESS | 19297 | _x_x_mozilla_page_load_details 09:59:37 INFO - PROCESS | 19297 | |i|pagename|runs| 09:59:37 INFO - PROCESS | 19297 | |0;ai-astar;106;116;112;116;117;117;115;116;114;115 09:59:37 INFO - PROCESS | 19297 | |1;audio-beat-detection;151;122;153;185;122;155;157;124;199;123 09:59:37 INFO - PROCESS | 19297 | |2;audio-dft;164;164;165;170;165;165;165;162;163;161 09:59:37 INFO - PROCESS | 19297 | |3;audio-fft;75;77;76;173;77;77;78;78;160;77 09:59:37 INFO - PROCESS | 19297 | |4;audio-oscillator;86;85;149;86;86;86;143;85;86;137 09:59:37 INFO - PROCESS | 19297 | |5;imaging-gaussian-blur;118;118;118;118;118;117;117;119;118;118 09:59:37 INFO - PROCESS | 19297 | |6;imaging-darkroom;149;148;148;147;148;150;149;150;149;148 09:59:37 INFO - PROCESS | 19297 | |7;imaging-desaturate;96;96;96;96;95;96;95;95;96;95 09:59:37 INFO - PROCESS | 19297 | |8;json-parse-financial;65;64;65;64;66;63;64;67;64;64 09:59:37 INFO - PROCESS | 19297 | |9;json-stringify-tinderbox;67;67;69;66;67;66;68;67;68;67 09:59:37 INFO - PROCESS | 19297 | |10;stanford-crypto-aes;79;81;80;81;85;80;80;80;83;79 09:59:37 INFO - PROCESS | 19297 | |11;stanford-crypto-ccm;137;142;141;132;133;134;135;137;185;141 09:59:37 INFO - PROCESS | 19297 | |12;stanford-crypto-pbkdf2;171;169;171;169;170;165;168;168;170;167 09:59:37 INFO - PROCESS | 19297 | |13;stanford-crypto-sha256-iterative;69;68;69;68;71;69;68;69;69;77 09:59:37 INFO - PROCESS | 19297 | __end_tp_report 09:59:37 INFO - PROCESS | 19297 | __start_cc_report 09:59:37 INFO - PROCESS | 19297 | _x_x_mozilla_cycle_collect,972 09:59:37 INFO - PROCESS | 19297 | __end_cc_report 09:59:37 INFO - PROCESS | 19297 | __startTimestamp1470243577058__endTimestamp 09:59:37 INFO - PROCESS | 19297 | 09:59:37 INFO - PROCESS | 19297 | ------- Summary: start ------- 09:59:37 INFO - PROCESS | 19297 | Number of tests: 14 09:59:37 INFO - PROCESS | 19297 | 09:59:37 INFO - PROCESS | 19297 | [#0] ai-astar Cycles:10 Average:114.40 Median:116.00 stddev:3.31 (2.9%) stddev-sans-first:1.58 09:59:37 INFO - PROCESS | 19297 | Values: 106.0 116.0 112.0 116.0 117.0 117.0 115.0 116.0 114.0 115.0 09:59:37 INFO - PROCESS | 19297 | 09:59:37 INFO - PROCESS | 19297 | [#1] audio-beat-detection Cycles:10 Average:149.10 Median:154.00 stddev:27.23 (17.7%) stddev-sans-first:28.88 09:59:37 INFO - PROCESS | 19297 | Values: 151.0 122.0 153.0 185.0 122.0 155.0 157.0 124.0 199.0 123.0 09:59:37 INFO - PROCESS | 19297 | 09:59:37 INFO - PROCESS | 19297 | [#2] audio-dft Cycles:10 Average:164.40 Median:165.00 stddev:2.41 (1.5%) stddev-sans-first:2.55 09:59:37 INFO - PROCESS | 19297 | Values: 164.0 164.0 165.0 170.0 165.0 165.0 165.0 162.0 163.0 161.0 09:59:37 INFO - PROCESS | 19297 | 09:59:37 INFO - PROCESS | 19297 | [#3] audio-fft Cycles:10 Average:94.80 Median:77.00 stddev:37.92 (49.3%) stddev-sans-first:39.54 09:59:37 INFO - PROCESS | 19297 | Values: 75.0 77.0 76.0 173.0 77.0 77.0 78.0 78.0 160.0 77.0 09:59:37 INFO - PROCESS | 19297 | 09:59:37 INFO - PROCESS | 19297 | [#4] audio-oscillator Cycles:10 Average:102.90 Median:86.00 stddev:27.82 (32.3%) stddev-sans-first:28.83 09:59:37 INFO - PROCESS | 19297 | Values: 86.0 85.0 149.0 86.0 86.0 86.0 143.0 85.0 86.0 137.0 09:59:37 INFO - PROCESS | 19297 | 09:59:37 INFO - PROCESS | 19297 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 09:59:37 INFO - PROCESS | 19297 | Values: 118.0 118.0 118.0 118.0 118.0 117.0 117.0 119.0 118.0 118.0 09:59:37 INFO - PROCESS | 19297 | 09:59:37 INFO - PROCESS | 19297 | [#6] imaging-darkroom Cycles:10 Average:148.60 Median:149.00 stddev:0.97 (0.6%) stddev-sans-first:1.01 09:59:37 INFO - PROCESS | 19297 | Values: 149.0 148.0 148.0 147.0 148.0 150.0 149.0 150.0 149.0 148.0 09:59:37 INFO - PROCESS | 19297 | 09:59:37 INFO - PROCESS | 19297 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 09:59:37 INFO - PROCESS | 19297 | Values: 96.0 96.0 96.0 96.0 95.0 96.0 95.0 95.0 96.0 95.0 09:59:37 INFO - PROCESS | 19297 | 09:59:37 INFO - PROCESS | 19297 | [#8] json-parse-financial Cycles:10 Average:64.60 Median:64.50 stddev:1.17 (1.8%) stddev-sans-first:1.24 09:59:37 INFO - PROCESS | 19297 | Values: 65.0 64.0 65.0 64.0 66.0 63.0 64.0 67.0 64.0 64.0 09:59:37 INFO - PROCESS | 19297 | 09:59:37 INFO - PROCESS | 19297 | [#9] json-stringify-tinderbox Cycles:10 Average:67.20 Median:67.00 stddev:0.92 (1.4%) stddev-sans-first:0.97 09:59:37 INFO - PROCESS | 19297 | Values: 67.0 67.0 69.0 66.0 67.0 66.0 68.0 67.0 68.0 67.0 09:59:37 INFO - PROCESS | 19297 | 09:59:37 INFO - PROCESS | 19297 | [#10] stanford-crypto-aes Cycles:10 Average:80.80 Median:80.50 stddev:1.87 (2.3%) stddev-sans-first:1.87 09:59:37 INFO - PROCESS | 19297 | Values: 79.0 81.0 80.0 81.0 85.0 80.0 80.0 80.0 83.0 79.0 09:59:37 INFO - PROCESS | 19297 | 09:59:37 INFO - PROCESS | 19297 | [#11] stanford-crypto-ccm Cycles:10 Average:141.70 Median:139.00 stddev:15.61 (11.2%) stddev-sans-first:16.47 09:59:37 INFO - PROCESS | 19297 | Values: 137.0 142.0 141.0 132.0 133.0 134.0 135.0 137.0 185.0 141.0 09:59:37 INFO - PROCESS | 19297 | 09:59:37 INFO - PROCESS | 19297 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.80 Median:169.50 stddev:1.87 (1.1%) stddev-sans-first:1.81 09:59:37 INFO - PROCESS | 19297 | Values: 171.0 169.0 171.0 169.0 170.0 165.0 168.0 168.0 170.0 167.0 09:59:37 INFO - PROCESS | 19297 | 09:59:37 INFO - PROCESS | 19297 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:69.00 stddev:2.71 (3.9%) stddev-sans-first:2.86 09:59:37 INFO - PROCESS | 19297 | Values: 69.0 68.0 69.0 68.0 71.0 69.0 68.0 69.0 69.0 77.0 09:59:37 INFO - PROCESS | 19297 | -------- Summary: end -------- 09:59:37 INFO - PROCESS | 19297 | 09:59:38 INFO - TEST-INFO | 19297: exit 0 09:59:38 INFO - TEST-OK | kraken | took 68109ms 09:59:38 INFO - SUITE-END | took 1194s 09:59:38 INFO - Completed test suite (00:19:54) 09:59:38 INFO - javascript benchmark 09:59:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6446.5924309802, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2707.2284398946304, 2713.0, 2757.6415066041413, 2764.640596722426, 2767.681716602594, 4722.150012997659, 4883.926741098886, 4896.632752543555, 4905.166121759301, 4988.276699878525, 4756.00123973965, 4924.827631032915, 5113.181890897457, 5129.435762066169, 5138.229265610151, 4578.1301552705045, 4621.353010578522, 4665.253559430492, 4674.579287864091, 4718.386609740729, 4333.9133217335475, 4464.129494748526, 4524.09518096382, 4527.501974782755, 4553.658475614326, 4453.755043472608, 4455.46534415869, 4470.955290447119, 4558.726476411426, 4574.4739354973935, 4501.774911254457, 4509.842155524574, 4527.275635898273, 4550.658700597469, 4552.135094332067, 4464.129494748526, 4479.7984090716, 4531.501534831166, 4579.450465944108, 4583.633309335279, 4870.683405578626, 4954.752262386866, 4963.205887058053, 4970.0, 4979.751012449363, 5362.168863826113, 5372.140457526777, 5405.783768649249, 5408.783648654049, 5426.972865135649, 5139.691618502864, 5190.169572868323, 5330.4936031076595, 5392.514673679388, 5395.838124856261, 4979.228219625964, 4992.101421744121, 5013.699178049329, 5014.89970200594, 5052.141136006888, 5537.7784888604, 5539.473749993744, 5552.7778888843995, 5557.77768889248, 5595.160725891149, 5106.106431374495, 5214.45248248936, 5227.215917612312, 5245.790168393298, 5320.0, 5348.171033489815, 5355.410904800468, 5363.383210930793, 5370.597205209625, 5374.140137577969, 5292.7353632319, 5299.205119232069, 5305.708186049727, 5317.973410133002, 5365.597580181502, 5073.746312684351, 5261.631685782035, 5322.148456246982, 5323.22813192085, 5395.595330350239, 4584.358189853423, 4590.563896429834, 4596.586307232298, 4608.170529304691, 4659.4175728034, 3949.0917089069676, 3955.7428767130045, 3973.0464688475136, 3975.4633124528395, 4040.595940405936, 4464.129494748558, 4623.676342656049, 4630.791614377361, 4635.3742244797195, 4697.013627138271, 5384.219288203189, 5401.7299135043095, 5415.241866138744, 5417.972910135503, 5420.159875219348, 4650.4186976627925, 4655.51117132703, 4657.86026419208, 4661.673682842236, 4695.5539223773685, 4613.100445413179, 4758.666893317434, 4799.976000120117, 4820.325154478306, 4862.781174847211, 5006.524380183877, 5039.445660977363, 5040.344755181803, 5040.395152581714, 5087.618428617942, 5373.838784836461, 5384.138537833927, 5386.542143917811, 5401.081816091352, 5403.891922161456, 4858.368412106403, 5018.197088465828, 5026.070177017264, 5061.974690126526, 5126.615503837153, 5363.490468405495, 5370.650907690988, 5375.6774593524515, 5382.865428364322, 5390.407055224001, 5404.594655400782, 5440.0, 5445.074337362737, 5459.781608735606, 5482.2873026506295, 5090.872728181825, 5091.541761241506, 5174.353205849269, 5179.766910489112, 5264.947350526599, 5155.968806238692, 5191.974040129775, 5194.246834208943, 5203.713795741271, 5204.869878253074, 5074.873128171826, 5114.258432527337, 5119.488051195, 5129.512696293846, 5143.71709555978, 5028.723420211923, 5189.818356357509, 5194.792208311776, 5215.348081489814, 5292.0, 5083.313752643494, 5120.231965205249, 5125.692458452505, 5136.948630513647, 5141.922871156861], "value": 4897.802674510807, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [548.747576114987, 560.918666793315, 567.8182981445937, 570.5635189080355, 589.9262592175978, 35084.824575877115, 38551.614483855155, 38667.0, 38845.0, 38905.0, 38960.41559376605, 39345.0, 39492.0, 39492.80253598728, 39687.206255874866, 7621.771346859603, 7686.884696729554, 7747.883781743279, 7769.0677118745825, 7785.727499537517, 7735.651895664709, 7740.225977402243, 7785.532868027908, 7786.688532458723, 7810.375169986388, 7800.414968877329, 7825.295723384894, 7842.529448233125, 7844.882326765103, 7846.254605812467, 7764.18476060014, 7814.179511151333, 7816.218378162195, 7823.726169584065, 7843.843123137505, 7666.693332266758, 7763.301302882767, 7778.844423111506, 7780.338671212954, 7781.494202876852, 36973.44539831905, 37399.4390084149, 37406.625933740586, 37447.0, 37541.0, 3043.6195475565555, 3129.217695576106, 3280.6391296957318, 3327.4177019021577, 3412.0787387405508, 28908.0, 29177.0, 29419.264518386997, 29824.0, 30246.54630180549, 3285.3100848821778, 3490.249596336774, 3500.929981400383, 3510.912227194315, 3565.982170089159, 205583.0, 244376.0, 247150.0, 248289.0, 249038.0, 53778.73110634422, 53913.0, 54011.0, 54111.72944135254, 54524.72737636286, 32079.0, 32567.674323256466, 32733.508997365057, 35051.29897402089, 35064.29871402609, 13953.930230348784, 14075.57773266783, 14080.929595351958, 14084.85915140856, 14147.575572732834, 10426.530806113591, 10455.424951627581, 10518.211134164969, 10534.894651053544, 10574.89425105739, 18012.819871801377, 18055.548611284823, 18120.0, 18129.0, 18134.183961721756, 6806.693698783567, 6820.727170913108, 6826.624535650587, 6909.585424874524, 6941.271166527442, 806.5120602035802, 898.4654130792168, 950.083169741203, 956.2875657635107, 978.3347323819728, 28107.43785124286, 28274.71725282762, 28780.136595902157, 28792.136235912956, 29162.41675166527, 832.309183377795, 883.7083762358407, 929.9116583924516, 1038.6157121864808, 1070.4166229404993, 14921.925390372979, 15050.473233436776, 15085.698286034218, 15236.0, 15373.231338433257, 392478.0, 396890.0, 397934.0, 398277.0, 398433.0, 49695.25457118146, 49764.0, 49779.50220497821, 49855.0, 49905.50094499008, 1146.3981409759776, 1149.741308205647, 1186.851643544557, 1187.9406029698307, 1207.9214851034656, 26357.34106647349, 27442.313942151606, 27642.44715105727, 28003.43993120167, 28304.0, 41686.791566041975, 41852.581474184866, 42148.1570368597, 42148.789256053526, 42149.789251053546, 327932.0, 328379.0, 328477.0, 330833.0, 330838.0, 25315.0, 25443.6183457252, 25749.3562660935, 25768.355791105372, 25830.741692582833, 41948.37077443902, 42282.0, 42457.5754242466, 42768.0, 43183.568164317956, 36196.0, 36268.637313626525, 36413.817930910176, 36651.633483664824, 37561.81219093887, 36113.27773444569, 36324.818375907955, 36462.63537364592, 37029.25941481209, 37296.25407491889, 34972.0, 35441.1139721509, 35616.64383356237, 36093.819530902176, 36237.0940726484, 30417.39165216639, 33366.83316583402, 33519.497207542394, 33634.0, 33742.0, 25206.74793252044, 25522.361940951625, 25663.615045773953, 25705.357366065997, 26249.73750262473], "value": 17275.728343067574, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.12321319913406, 363.398575357783, 368.26898606266565, 371.92189640175565, 373.2590807247613, 15933.920330398361, 16369.754453683205, 17347.306107755692, 17382.0, 17475.912620436913, 15635.687286254297, 16447.671046579093, 16939.661206775858, 17029.233684484196, 17042.65914681709, 5106.719130447833, 5322.574194064485, 5340.67955922644, 5341.385740639818, 5351.2240725095035, 5059.924101138486, 5250.31745873036, 5287.2862163608, 5290.55030322423, 5292.788288468457, 5244.973775131119, 5366.221897824813, 5367.838964831042, 5368.677879327233, 5375.623706340558, 5330.200469929503, 5702.429757024306, 5855.560832937546, 5890.175375447441, 5965.3736357682255, 4553.886152846172, 5377.623566350357, 5379.112446446332, 5383.4616538346245, 5393.83818485446, 11223.775524489465, 11859.347735874524, 11875.40622968848, 11898.10764192689, 11919.165658403916, 1915.0999030455664, 2147.915302772106, 2286.8451432026886, 2334.4047267946567, 2363.1256435118944, 8940.0, 9029.232515236214, 9060.456372617664, 9153.08469153086, 9248.815023699555, 1682.856957158643, 1700.4388551777884, 1706.3174730107933, 1744.0, 1769.5310742653207, 65861.67069164671, 71579.64210178968, 72298.0, 72664.27335726628, 73491.0, 9446.527673616292, 9592.184664303473, 9678.70963871085, 9689.854652180224, 9833.262505311986, 12582.937085314516, 12597.181183223061, 12630.368481575884, 12636.873631263754, 12657.114002019955, 6751.156105486814, 6857.2114206866845, 6943.583384996917, 6945.062416573698, 7022.157341119098, 6320.62076275425, 6413.134226879405, 6457.224263327623, 6635.834104147339, 6640.667966601651, 3949.3878448840474, 3956.5756327721997, 3968.1071758854027, 4104.179164167179, 4118.19695159441, 1671.147714665505, 1714.502794189696, 1736.8436840684399, 1780.1811166863129, 1805.5486128467883, 847.8304339132198, 877.9778824715797, 888.9511076890833, 920.7559996600907, 938.0010289042149, 17098.316067357166, 17355.13224338778, 17588.296468141387, 17793.7330940036, 17814.287428502714, 841.8105926166686, 865.35098675993, 867.3754896474528, 894.4409743910056, 902.1925376787739, 9403.247740180768, 9972.50137493137, 10024.749381265527, 10062.496875156214, 10097.293189476813, 367734.0, 368893.6221275613, 390074.0, 401347.0, 403784.0, 79681.60159199283, 82071.5896420514, 82857.0, 83169.0, 83605.0, 880.3881302494833, 888.2938064238946, 905.4250550900226, 909.0, 916.2807196350833, 15478.690426191639, 15618.375264989727, 16088.678226435171, 16278.43025494102, 16356.182190890646, 37228.6277137236, 37854.43218351782, 38585.80707096559, 38953.80523097367, 39356.80321598374, 51111.0, 52321.7383913078, 53684.73157634187, 54467.0, 55098.72450637721, 6494.4804415645685, 7344.449166312441, 7372.225916278713, 7452.850942981218, 7671.232876712284, 11051.502682379472, 11435.828462572901, 11484.483198255932, 11485.138614603771, 11591.710207244887, 9750.268729845147, 10023.44871032071, 10175.89824101779, 10221.795564088825, 10255.897441025792, 10218.693439196835, 10330.948345258226, 10463.895361046596, 10477.68566942993, 10714.785704285714, 10079.496025198858, 10268.58925642966, 10305.175585952957, 10550.314229575053, 10770.73073173177, 6658.300878407697, 6991.755288564876, 6992.685329160302, 6998.370146686822, 7023.754168604074, 9985.301028927905, 10118.241131914989, 10213.0, 10219.831966095755, 10228.693139205836], "value": 8053.202302668447, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1369.7192075624498, 1422.5732280315906, 1459.8321193062795, 1583.8812089093321, 1631.4453085950774, 6714.899276510844, 7120.8931866021985, 7345.15530713968, 7652.502587331826, 7662.233776622335, 7402.296781805733, 7666.386689064875, 7676.117246516652, 7677.270659287373, 7702.691892324315, 2176.629972904606, 2219.079082180893, 2219.079082180901, 2223.488597622548, 2230.1413955627118, 2142.368001439579, 2201.1635578480236, 2216.2907869481774, 2224.944376390595, 2226.0984301357976, 2182.530755887484, 2200.141944641591, 2210.1601391471218, 2219.5449932763745, 2229.0972156276734, 2165.8267338612873, 2169.2516081951703, 2172.576347612216, 2176.4994051368194, 2178.237616834111, 2126.0857831132607, 2156.644153714635, 2161.4056134562966, 2162.1459523488134, 2164.199246278871, 7778.961105194495, 7812.609369531558, 7836.294733473957, 7866.410019248522, 7897.921020789776, 4331.675124365654, 4451.332300154971, 4484.304932735431, 4486.102779444124, 4490.797914093873, 2863.9427211455863, 2873.41095075509, 2887.3359127400604, 2956.305268261957, 2999.2052106191877, 859.3683642522741, 891.9866202006975, 898.9685361012398, 899.8380291547519, 928.6007016982695, 10178.541965611565, 10218.540165692562, 10218.642347517876, 10232.641857535025, 10273.178145748398, 3839.481669974518, 3987.8205480752854, 4119.464469618931, 4126.216018956388, 4143.523494798076, 8874.334424918157, 8880.822383552293, 8881.156290152554, 8890.511021893857, 8913.24237439812, 4445.777711114496, 4448.755318457451, 4457.175422546839, 4474.105178964155, 4479.955200448019, 3547.911302217465, 3931.941020884689, 4034.1931613677384, 4074.30736774749, 4089.1003979124544, 3700.740948133605, 3711.16498787776, 3773.735838491334, 3787.0721673190246, 3822.1782316802023, 1223.8103094020441, 1224.400043978444, 1225.681322856046, 1230.1880758699215, 1235.6725467751053, 790.2571582712233, 802.0415603353936, 811.922867327603, 819.1562690428868, 841.7011960753845, 4896.387951506062, 5048.53592458183, 5057.620678449131, 5091.2363145527725, 5098.413682426569, 371.2426649634769, 378.23973812636797, 387.96896248300067, 405.07642574929207, 407.19172442701216, 3452.3267962747022, 3452.4648679454726, 3494.336076145524, 3508.7193024558483, 3572.624874388204, 9046.954765226132, 9477.526123693788, 9481.810363792685, 9488.430694158373, 9519.143277105093, 9407.106324899123, 9407.388519746195, 9431.0, 9439.575219115157, 9440.10319019692, 7161.961515580316, 7183.3534981850835, 7194.568325900463, 7314.012608297918, 7330.633468326669, 5005.7997680092385, 5060.291559181644, 5102.387713474407, 5115.820946266863, 5132.486751324837, 8617.87073193915, 8621.439606425562, 8643.135686431558, 8681.262092722189, 8692.174243446863, 8703.521306327959, 8802.779930501789, 8810.471371717718, 8833.602487887933, 8856.690015849414, 5881.882362352814, 6448.161738973903, 6615.6030638161865, 6703.095082163845, 6784.525083244125, 7446.14369347532, 7507.211742766931, 7508.587027713528, 7510.624468776648, 7524.924750752422, 6614.669266536558, 6710.765123220664, 6726.932730672826, 6767.526273161028, 6823.522353435212, 6580.473562115115, 6604.471642268511, 6657.267700553032, 6735.4274886635185, 6834.45324374039, 6256.655883926245, 6321.49428045746, 6338.619682819046, 6341.270753863365, 6354.3963323484195, 4521.547845215452, 4536.432945881765, 4582.747948862844, 4584.289435137559, 4631.907361852676, 4332.696711230184, 4353.847615333448, 4462.219111655512, 4513.413256276663, 4551.954480455153], "value": 3993.1857864048443, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [282.9844358560279, 287.76115823866195, 291.45643375105436, 292.5407110835987, 295.30750390334657, 5109.233614957759, 5144.4598317176715, 5192.104881718174, 5194.168932970725, 5196.298499702544, 5022.447530771621, 5067.695938243708, 5073.695578265307, 5079.64442489025, 5092.414372347182, 3745.8127093645344, 3813.7033408641055, 3909.3745000799877, 3916.4321173429835, 3926.7840268785208, 3907.1599606084687, 3911.3546264866263, 3913.31516984528, 3913.6086391360923, 3920.3335432976464, 3891.8443262269616, 3904.824282907262, 3912.784796836173, 3937.2519221347998, 3951.70362222833, 3841.116543195053, 3909.4526766252748, 3921.0, 3921.607839216084, 3928.1947200823906, 3419.6409377015552, 3424.8116353600544, 3429.9485507717404, 3436.9312613747584, 3445.2248244145117, 4908.288298196777, 4925.827596034122, 4956.330895329121, 4959.7024178549045, 4961.237212276219, 4345.544242678707, 4524.547545245482, 4539.568740969603, 4540.0, 4541.977290113528, 5283.418823929364, 5310.495502927216, 5325.760340784635, 5330.866728331784, 5346.545543628797, 3781.1870447853566, 3784.678302344304, 3792.658660720521, 3793.2413517296377, 3797.829097690583, 5359.892802143935, 5598.1322894951345, 5600.803971861006, 5606.635568688022, 5630.521405680522, 3841.519810023747, 3845.038740314921, 3845.596212397658, 3846.4230365445405, 3861.1505468796818, 3917.4123881417445, 3926.939726273947, 3935.763854168702, 3936.724429289922, 3939.625735555118, 4480.372747815309, 4494.348319493655, 4509.278515437514, 4515.209838278288, 4545.477270113913, 5230.7384630769075, 5296.443873393316, 5306.204069389545, 5349.598780091509, 5362.168863826113, 1332.1540821578367, 1347.5014244729514, 1352.5333759852836, 1355.2275203134118, 1355.8440779310308, 819.3076850061689, 846.1622993236651, 863.7236084453041, 865.3601425299023, 868.4355169140109, 4513.300438432048, 4538.364628951949, 4729.456112547033, 4740.312654665055, 4789.832355867528, 5528.530074943675, 5537.4495141360485, 5582.637128586629, 5589.456797157283, 5618.719064046863, 4647.09381670571, 4763.73799441034, 4765.451973023078, 4777.355057067251, 4785.0, 2931.4316840490237, 2931.7540045480587, 2945.617069780915, 2970.885917780832, 2977.2408035950693, 5183.248428977777, 5202.479752024843, 5203.401608814959, 5208.817691380784, 5218.660787048906, 5504.697241651667, 5635.549156067505, 5651.576131790132, 5657.915131273035, 5716.657000579979, 5107.514786095315, 5124.641275110706, 5125.359330083665, 5144.76848541824, 5151.845444636667, 5473.890522189614, 5505.862353441196, 5528.640638358494, 5535.986409852985, 5557.72211389437, 5102.387713474258, 5378.542823860016, 5391.919121213106, 5435.918461223006, 5440.0, 5205.869853253547, 5223.791048358175, 5234.869128271824, 5252.741321231907, 5261.973690131525, 3880.1075752576503, 3898.863539776094, 3916.5300163980505, 3924.7645141291614, 3925.548561915302, 5388.757505912165, 5429.429909859408, 5462.132629055423, 5471.151971444432, 5478.671279723229, 5316.9468305318, 5362.865928351823, 5365.0, 5371.62398632092, 5373.543248823894, 5097.311862898461, 5304.0, 5326.041312563776, 5328.813491527778, 5404.972975135099, 5255.921161182662, 5263.815766448156, 5267.657602255841, 5281.920771188512, 5310.867228319168, 5052.368453943257, 5242.633015688865, 5348.197770334481, 5409.539424355481, 5413.267754318737, 5244.033487442209, 5260.658057226268, 5296.232046353334, 5296.894062118813, 5299.682019078868], "value": 4000.1105250985324, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [624.8250489862837, 635.1837888313518, 657.3131078023465, 720.7225218290959, 727.7380143148463, 12423.31671758053, 13704.862951370484, 13801.861981380183, 13809.171449713025, 13878.791818122723, 12760.106792524526, 12789.168704034231, 12821.42303596338, 12853.22880627163, 12873.742525149491, 633.3002032753786, 764.2815753191995, 782.104490358542, 783.5572901310769, 784.7998760316111, 769.3537428560008, 793.0325003495755, 801.4229754576695, 802.3861745764466, 802.6909639788665, 829.1832544943226, 832.5379414424991, 832.9833403331929, 836.3058661311128, 836.8117173635944, 824.785555755502, 826.3182874128838, 826.3926014379426, 827.1728271728272, 830.8504469195542, 602.28027507129, 602.7528713227599, 604.6764980735286, 605.5942518512608, 608.2761513798565, 12891.548795792101, 12891.935540322238, 12923.353832308441, 12947.546835860794, 12954.222746635232, 13672.453101875913, 13680.31598420085, 14189.155459709962, 14361.281935903164, 14497.130172189702, 10524.47377631123, 10529.84205236922, 10692.0, 10700.357978521235, 10775.137988960865, 3330.2340461693702, 3345.9498107528407, 3364.9831750841336, 3376.0547046826928, 3399.5920489541168, 69867.30132698659, 71650.28349716488, 72349.6382518084, 72472.0, 73993.26006739917, 10512.264141510173, 10691.281887786754, 10707.464626768631, 10810.783784324269, 10846.837297440545, 20996.370108896757, 21077.26229581957, 21208.0, 21312.680309795367, 21326.14695412166, 6940.548864323803, 7009.1589009319205, 7024.964875175591, 7106.467014973898, 7139.500234983501, 3752.962470375261, 3819.6180381962135, 3849.8075096245075, 3904.6876249899938, 3918.5101862267215, 2829.872655730497, 2913.839738814343, 2919.5766613840874, 2919.8102123361914, 2925.546540286259, 475.1945452458119, 488.08727679239337, 491.76395330241684, 499.81007217257934, 503.2978994302927, 556.1435389500206, 589.1016200294499, 589.1310317281975, 601.8435206846251, 609.7439075588263, 7837.216278372117, 7971.880421793678, 8151.592420378957, 8305.46014509055, 8431.0, 468.8593421973463, 507.5160952980386, 580.5935844908581, 581.2913611160767, 596.6300893446091, 3893.182431689377, 3930.606939306104, 3989.4215338776294, 4055.7363771354767, 4109.547949725527, 98355.50822245843, 101984.49007755062, 103897.0, 104531.4773426128, 106926.0, 90319.0, 91517.0, 91726.0, 93702.53148734348, 93781.96635252383, 77430.61284693654, 77586.22413775903, 77668.0, 78136.60931695305, 79221.99999999885, 7427.517211381243, 7719.845603088019, 7804.102528209101, 7951.244631759973, 8050.476719013245, 47441.99481078259, 47670.0, 48288.758556206994, 48982.75508622576, 50279.49720502748, 61424.0, 66874.0, 68183.0, 68235.65882170557, 70320.0, 10555.208359372924, 10644.84032739494, 10716.464176790972, 10901.236913415985, 10996.945015275192, 11222.494987725735, 11552.191346605658, 11788.0, 11793.70515737079, 12055.51777928873, 10808.0, 11054.285232870543, 11242.325460472397, 11252.831207532057, 11558.653240402802, 10063.446510441996, 10143.949280253551, 10222.948885255526, 10318.896811031793, 10520.684379468628, 10718.678439646823, 11108.854086672964, 11161.274517156358, 11511.884881151416, 11762.58830940913, 8773.210411063035, 9078.909210907806, 9179.449233046038, 9281.814363712552, 9633.32566720351, 8274.544900030556, 8669.60986755585, 8724.520151391735, 8827.504269696092, 9004.0], "value": 6593.815740802033, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1580.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 116.0, 112.0, 116.0, 117.0, 117.0, 115.0, 116.0, 114.0, 115.0], "value": 114.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 122.0, 153.0, 185.0, 122.0, 155.0, 157.0, 124.0, 199.0, 123.0], "value": 149.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 165.0, 170.0, 165.0, 165.0, 165.0, 162.0, 163.0, 161.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 173.0, 77.0, 77.0, 78.0, 78.0, 160.0, 77.0], "value": 94.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 149.0, 86.0, 86.0, 86.0, 143.0, 85.0, 86.0, 137.0], "value": 102.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 118.0, 117.0, 117.0, 119.0, 118.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 148.0, 147.0, 148.0, 150.0, 149.0, 150.0, 149.0, 148.0], "value": 148.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 65.0, 64.0, 66.0, 63.0, 64.0, 67.0, 64.0, 64.0], "value": 64.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 69.0, 66.0, 67.0, 66.0, 68.0, 67.0, 68.0, 67.0], "value": 67.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 81.0, 80.0, 81.0, 85.0, 80.0, 80.0, 80.0, 83.0, 79.0], "value": 80.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 142.0, 141.0, 132.0, 133.0, 134.0, 135.0, 137.0, 185.0, 141.0], "value": 141.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 169.0, 171.0, 169.0, 170.0, 165.0, 168.0, 168.0, 170.0, 167.0], "value": 168.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 69.0, 68.0, 71.0, 69.0, 68.0, 69.0, 69.0, 77.0], "value": 69.7, "unit": "score"}]}]} 09:59:38 INFO - Return code: 0 09:59:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:59:38 ERROR - # TBPL SUCCESS # 09:59:38 INFO - Running post-action listener: _resource_record_post_action 09:59:38 INFO - [mozharness: 2016-08-03 16:59:38.864176Z] Finished run-tests step (success) 09:59:38 INFO - Running post-run listener: _resource_record_post_run 09:59:38 INFO - Total resource usage - Wall time: 1221s; CPU: 14.0%; Read bytes: 4096; Write bytes: 526004224; Read time: 1568; Write time: 3558480 09:59:38 INFO - TinderboxPrint: CPU usage
13.7% 09:59:38 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 1,568 09:59:38 INFO - TinderboxPrint: I/O write bytes / time
526,004,224 / 3,558,480 09:59:38 INFO - TinderboxPrint: CPU idle
8,408.8 (86.3%) 09:59:38 INFO - TinderboxPrint: CPU user
1,220.2 (12.5%) 09:59:38 INFO - TinderboxPrint: Swap in / out
0 / 0 09:59:38 INFO - install - Wall time: 19s; CPU: 20.0%; Read bytes: 0; Write bytes: 185831424; Read time: 0; Write time: 1080984 09:59:38 INFO - run-tests - Wall time: 1203s; CPU: 14.0%; Read bytes: 4096; Write bytes: 331784192; Read time: 1568; Write time: 2381384 09:59:39 INFO - Running post-run listener: _upload_blobber_files 09:59:39 INFO - Blob upload gear active. 09:59:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:59:39 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:59:39 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'] 09:59:39 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 09:59:39 INFO - (blobuploader) - INFO - Open directory for files ... 09:59:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:59:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:59:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:59:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:59:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:59:43 INFO - (blobuploader) - INFO - Done attempting. 09:59:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:59:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:59:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:59:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:59:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:59:44 INFO - (blobuploader) - INFO - Done attempting. 09:59:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:59:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:59:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:59:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:59:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:59:45 INFO - (blobuploader) - INFO - Done attempting. 09:59:45 INFO - (blobuploader) - INFO - Iteration through files over. 09:59:45 INFO - Return code: 0 09:59:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:59:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:59:45 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/539abd38f19c76c4d169437c2824f6aaee39d7fd6c7c0e5c35b10597ec09890a8a3ea5539dcf3c62a6531ee5ac4e6a9e7fc891dd39aff3c431f68b27c6ab32e0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/83a535eacf5cda83fd10e3ebb203a0d8bf0b7e993c8c61556126b9c72aaad2ce4665f0bf3f6362edc7531746c4424a8176d111ebcde5eba0633257b823877ae5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/be3b07cfc593f4db2f225c2e4ed4d9267018287df55c809880408942589c3786a82c0b8a45a11f485c55b07f7c7e68a54195696794e5398f27d6497f4308b11d"} 09:59:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:59:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:59:45 INFO - Contents: 09:59:45 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/539abd38f19c76c4d169437c2824f6aaee39d7fd6c7c0e5c35b10597ec09890a8a3ea5539dcf3c62a6531ee5ac4e6a9e7fc891dd39aff3c431f68b27c6ab32e0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/83a535eacf5cda83fd10e3ebb203a0d8bf0b7e993c8c61556126b9c72aaad2ce4665f0bf3f6362edc7531746c4424a8176d111ebcde5eba0633257b823877ae5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/be3b07cfc593f4db2f225c2e4ed4d9267018287df55c809880408942589c3786a82c0b8a45a11f485c55b07f7c7e68a54195696794e5398f27d6497f4308b11d"} 09:59:45 INFO - Running post-run listener: copy_logs_to_upload_dir 09:59:45 INFO - Copying logs to upload dir... 09:59:45 INFO - mkdir: /builds/slave/test/build/upload/logs 09:59:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.280027 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-08-03 09:59:44.281243) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-03 09:59:44.286124) ========= 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=33d5923976266a1c518c4bf7000001ab-1470242321.760672-1966884339 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/539abd38f19c76c4d169437c2824f6aaee39d7fd6c7c0e5c35b10597ec09890a8a3ea5539dcf3c62a6531ee5ac4e6a9e7fc891dd39aff3c431f68b27c6ab32e0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/83a535eacf5cda83fd10e3ebb203a0d8bf0b7e993c8c61556126b9c72aaad2ce4665f0bf3f6362edc7531746c4424a8176d111ebcde5eba0633257b823877ae5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/be3b07cfc593f4db2f225c2e4ed4d9267018287df55c809880408942589c3786a82c0b8a45a11f485c55b07f7c7e68a54195696794e5398f27d6497f4308b11d"} build_url:https://queue.taskcluster.net/v1/task/VPxh4njPRQeb2ZZqP85bMA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011363 build_url: 'https://queue.taskcluster.net/v1/task/VPxh4njPRQeb2ZZqP85bMA/artifacts/public/build/firefox-51.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/539abd38f19c76c4d169437c2824f6aaee39d7fd6c7c0e5c35b10597ec09890a8a3ea5539dcf3c62a6531ee5ac4e6a9e7fc891dd39aff3c431f68b27c6ab32e0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/83a535eacf5cda83fd10e3ebb203a0d8bf0b7e993c8c61556126b9c72aaad2ce4665f0bf3f6362edc7531746c4424a8176d111ebcde5eba0633257b823877ae5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/be3b07cfc593f4db2f225c2e4ed4d9267018287df55c809880408942589c3786a82c0b8a45a11f485c55b07f7c7e68a54195696794e5398f27d6497f4308b11d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-03 09:59:44.320983) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 09:59:44.321672) ========= 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=33d5923976266a1c518c4bf7000001ab-1470242321.760672-1966884339 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004552 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-03 09:59:44.402334) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-03 09:59:44.402697) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-03 09:59:44.403070) ========= ========= Total master_lag: 0.97 =========