builder: larch_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-033 starttime: 1464948163.14 results: success (0) buildid: 20160603003002 builduid: a613981a497341ed88438eccbc3257ca revision: 426f42ae29ff33b8fbc233268879837a67c36858 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-03 03:02:43.137165) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-03 03:02:43.137542) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-03 03:02:43.137810) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-03 03:02:43.160000) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 03:02:43.160265) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1464948135.900727-2127116052 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-03 03:02:43-- 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% 42.9M=0s 2016-06-03 03:02:43 (42.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124377 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 03:02:43.298818) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 03:02:43.299095) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1464948135.900727-2127116052 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016620 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 03:02:43.348276) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-03 03:02:43.348637) ========= bash -c 'python archiver_client.py mozharness --repo projects/larch --rev 426f42ae29ff33b8fbc233268879837a67c36858 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/larch --rev 426f42ae29ff33b8fbc233268879837a67c36858 --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=edae0fb5fee9fb758e8af6d3000002a4-1464948135.900727-2127116052 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-03 03:02:43,559 truncating revision to first 12 chars 2016-06-03 03:02:43,559 Setting DEBUG logging. 2016-06-03 03:02:43,559 attempt 1/10 2016-06-03 03:02:43,559 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/larch/426f42ae29ff?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-03 03:02:44,443 unpacking tar archive at: larch-426f42ae29ff/testing/mozharness/ program finished with exit code 0 elapsedTime=1.268806 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-03 03:02:44.630860) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-03 03:02:44.631178) ========= script_repo_revision: 426f42ae29ff33b8fbc233268879837a67c36858 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-03 03:02:44.631574) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-03 03:02:44.631844) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-03 03:02:44.642391) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-03 03:02:44.642683) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Larch --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch 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', 'Larch', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Larch'] 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=edae0fb5fee9fb758e8af6d3000002a4-1464948135.900727-2127116052 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:02:44 INFO - MultiFileLogger online at 20160603 03:02:44 in /builds/slave/test 03:02:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Larch --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch 03:02:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:02:44 INFO - {'append_to_log': False, 03:02:44 INFO - 'base_work_dir': '/builds/slave/test', 03:02:44 INFO - 'blob_upload_branch': 'Larch', 03:02:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:02:44 INFO - 'branch': 'Larch', 03:02:44 INFO - 'buildbot_json_path': 'buildprops.json', 03:02:44 INFO - 'config_files': ('talos/linux_config.py',), 03:02:44 INFO - 'default_actions': ('clobber', 03:02:44 INFO - 'read-buildbot-config', 03:02:44 INFO - 'download-and-extract', 03:02:44 INFO - 'populate-webroot', 03:02:44 INFO - 'create-virtualenv', 03:02:44 INFO - 'install', 03:02:44 INFO - 'run-tests'), 03:02:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:02:44 INFO - 'download_minidump_stackwalk': True, 03:02:44 INFO - 'download_symbols': 'ondemand', 03:02:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:02:44 INFO - 'tooltool.py': '/tools/tooltool.py', 03:02:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:02:44 INFO - '/tools/misc-python/virtualenv.py')}, 03:02:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:02:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:02:44 INFO - 'installer_path': 'installer.exe', 03:02:44 INFO - 'log_level': 'info', 03:02:44 INFO - 'log_name': 'talos', 03:02:44 INFO - 'log_to_console': True, 03:02:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:02:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:02:44 INFO - 'opt_config_files': (), 03:02:44 INFO - 'pip_index': False, 03:02:44 INFO - 'sps_profile': False, 03:02:44 INFO - 'sps_profile_interval': 0, 03:02:44 INFO - 'suite': 'dromaeojs-e10s', 03:02:44 INFO - 'system_bits': '32', 03:02:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:02:44 INFO - 'title': 'talos-linux64-ix-033', 03:02:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:02:44 INFO - 'use_talos_json': True, 03:02:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:02:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:02:44 INFO - 'work_dir': 'build'} 03:02:44 INFO - ##### 03:02:44 INFO - ##### Running clobber step. 03:02:44 INFO - ##### 03:02:44 INFO - Running pre-action listener: _resource_record_pre_action 03:02:44 INFO - Running main action method: clobber 03:02:44 INFO - rmtree: /builds/slave/test/build 03:02:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:02:45 INFO - Running post-action listener: _resource_record_post_action 03:02:45 INFO - ##### 03:02:45 INFO - ##### Finished clobber step (success) 03:02:45 INFO - ##### 03:02:45 INFO - ##### 03:02:45 INFO - ##### Running read-buildbot-config step. 03:02:45 INFO - ##### 03:02:45 INFO - Running pre-action listener: _resource_record_pre_action 03:02:45 INFO - Running main action method: read_buildbot_config 03:02:45 INFO - Using buildbot properties: 03:02:45 INFO - { 03:02:45 INFO - "project": "", 03:02:45 INFO - "product": "firefox", 03:02:45 INFO - "script_repo_revision": "production", 03:02:45 INFO - "builddir": "larch_ubuntu64_hw_test-dromaeojs-e10s", 03:02:45 INFO - "repository": "", 03:02:45 INFO - "buildername": "Ubuntu HW 12.04 x64 larch pgo talos dromaeojs-e10s", 03:02:45 INFO - "buildid": "20160603003002", 03:02:45 INFO - "pgo_build": "True", 03:02:45 INFO - "basedir": "/builds/slave/test", 03:02:45 INFO - "buildnumber": 3, 03:02:45 INFO - "slavename": "talos-linux64-ix-033", 03:02:45 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:02:45 INFO - "platform": "ubuntu64_hw", 03:02:45 INFO - "scheduler": "tests-larch-linux64-pgo-talos", 03:02:45 INFO - "branch": "larch", 03:02:45 INFO - "repo_path": "projects/larch", 03:02:45 INFO - "revision": "426f42ae29ff33b8fbc233268879837a67c36858", 03:02:45 INFO - "stage_platform": "linux64-pgo", 03:02:45 INFO - "builduid": "a613981a497341ed88438eccbc3257ca", 03:02:45 INFO - "slavebuilddir": "test" 03:02:45 INFO - } 03:02:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/BeKAicNpTFmvCBq6slNXQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 03:02:45 INFO - Running post-action listener: _resource_record_post_action 03:02:45 INFO - ##### 03:02:45 INFO - ##### Finished read-buildbot-config step (success) 03:02:45 INFO - ##### 03:02:45 INFO - ##### 03:02:45 INFO - ##### Running download-and-extract step. 03:02:45 INFO - ##### 03:02:45 INFO - Running pre-action listener: _resource_record_pre_action 03:02:45 INFO - Running main action method: download_and_extract 03:02:45 INFO - mkdir: /builds/slave/test/build/tests 03:02:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:02:45 INFO - https://queue.taskcluster.net/v1/task/BeKAicNpTFmvCBq6slNXQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:02:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BeKAicNpTFmvCBq6slNXQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 03:02:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BeKAicNpTFmvCBq6slNXQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 03:02:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BeKAicNpTFmvCBq6slNXQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 03:02:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BeKAicNpTFmvCBq6slNXQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:02:54 INFO - Downloaded 1361 bytes. 03:02:54 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 03:02:54 INFO - Using the following test package requirements: 03:02:54 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 03:02:54 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:02:54 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:02:54 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:02:54 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:02:54 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:02:54 INFO - u'jsshell-linux-x86_64.zip'], 03:02:54 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:02:54 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:02:54 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 03:02:54 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:02:54 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:02:54 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:02:54 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:02:54 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:02:54 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:02:54 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:02:54 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:02:54 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:02:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:02:54 INFO - https://queue.taskcluster.net/v1/task/BeKAicNpTFmvCBq6slNXQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:02:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BeKAicNpTFmvCBq6slNXQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:02:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BeKAicNpTFmvCBq6slNXQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:02:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BeKAicNpTFmvCBq6slNXQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:02:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BeKAicNpTFmvCBq6slNXQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:02:55 INFO - Downloaded 24423028 bytes. 03:02:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:02:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:02:56 INFO - Return code: 0 03:02:56 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:02:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:02:56 INFO - https://queue.taskcluster.net/v1/task/BeKAicNpTFmvCBq6slNXQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:02:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BeKAicNpTFmvCBq6slNXQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:02:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BeKAicNpTFmvCBq6slNXQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:02:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BeKAicNpTFmvCBq6slNXQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:02:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BeKAicNpTFmvCBq6slNXQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:02:58 INFO - Downloaded 24423028 bytes. 03:02:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:02:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:02:59 INFO - Return code: 0 03:02:59 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')]} 03:02:59 INFO - https://queue.taskcluster.net/v1/task/BeKAicNpTFmvCBq6slNXQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:02:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BeKAicNpTFmvCBq6slNXQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 03:02:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BeKAicNpTFmvCBq6slNXQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 03:02:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BeKAicNpTFmvCBq6slNXQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 03:02:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BeKAicNpTFmvCBq6slNXQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:03:01 INFO - Downloaded 10834063 bytes. 03:03:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:03:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:03:01 INFO - Return code: 0 03:03: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')]} 03:03:01 INFO - https://queue.taskcluster.net/v1/task/BeKAicNpTFmvCBq6slNXQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:03:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BeKAicNpTFmvCBq6slNXQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 03:03:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BeKAicNpTFmvCBq6slNXQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 03:03:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BeKAicNpTFmvCBq6slNXQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 03:03:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BeKAicNpTFmvCBq6slNXQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:03:03 INFO - Downloaded 59104394 bytes. 03:03:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BeKAicNpTFmvCBq6slNXQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 03:03:03 INFO - mkdir: /builds/slave/test/properties 03:03:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:03:03 INFO - Writing to file /builds/slave/test/properties/build_url 03:03:03 INFO - Contents: 03:03:03 INFO - build_url:https://queue.taskcluster.net/v1/task/BeKAicNpTFmvCBq6slNXQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 03:03:04 INFO - Running post-action listener: _resource_record_post_action 03:03:04 INFO - Running post-action listener: set_extra_try_arguments 03:03:04 INFO - ##### 03:03:04 INFO - ##### Finished download-and-extract step (success) 03:03:04 INFO - ##### 03:03:04 INFO - ##### 03:03:04 INFO - ##### Running populate-webroot step. 03:03:04 INFO - ##### 03:03:04 INFO - Running pre-action listener: _resource_record_pre_action 03:03:04 INFO - Running main action method: populate_webroot 03:03:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:03:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:03:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:03:04 INFO - '--tppagecycles', 03:03:04 INFO - '7'], 03:03:04 INFO - 'tests': ['tsvgm']}}, 03:03:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:03:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:03:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:03:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:03:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:03:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:03:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:03:04 INFO - 'talos_options': ['--disable-e10s'], 03:03:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:03:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:03:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:03:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:03:04 INFO - 'talos_options': ['--disable-e10s'], 03:03:04 INFO - 'tests': ['damp', 'tps']}, 03:03:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:03:04 INFO - 'tests': ['damp', 'tps']}, 03:03:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:03:04 INFO - 'tests': ['dromaeo_dom']}, 03:03:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:03:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:03:04 INFO - 'tests': ['a11yr', 03:03:04 INFO - 'ts_paint', 03:03:04 INFO - 'tpaint', 03:03:04 INFO - 'sessionrestore', 03:03:04 INFO - 'sessionrestore_no_auto_restore', 03:03:04 INFO - 'tabpaint']}, 03:03:04 INFO - 'other-e10s': {'tests': ['a11yr', 03:03:04 INFO - 'ts_paint', 03:03:04 INFO - 'tpaint', 03:03:04 INFO - 'sessionrestore', 03:03:04 INFO - 'sessionrestore_no_auto_restore', 03:03:04 INFO - 'tabpaint']}, 03:03:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:03:04 INFO - 'ts_paint', 03:03:04 INFO - 'tpaint', 03:03:04 INFO - 'sessionrestore', 03:03:04 INFO - 'sessionrestore_no_auto_restore', 03:03:04 INFO - 'tabpaint']}, 03:03:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:03:04 INFO - 'ts_paint', 03:03:04 INFO - 'tpaint', 03:03:04 INFO - 'sessionrestore', 03:03:04 INFO - 'sessionrestore_no_auto_restore', 03:03:04 INFO - 'tabpaint']}, 03:03:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:03:04 INFO - 'tests': ['a11yr', 03:03:04 INFO - 'ts_paint', 03:03:04 INFO - 'tpaint', 03:03:04 INFO - 'sessionrestore', 03:03:04 INFO - 'sessionrestore_no_auto_restore', 03:03:04 INFO - 'tabpaint']}, 03:03:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:03:04 INFO - 'tests': ['a11yr', 03:03:04 INFO - 'ts_paint', 03:03:04 INFO - 'tpaint', 03:03:04 INFO - 'sessionrestore', 03:03:04 INFO - 'sessionrestore_no_auto_restore', 03:03:04 INFO - 'tabpaint']}, 03:03:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:03:04 INFO - 'tests': ['tsvgx', 03:03:04 INFO - 'tsvgr_opacity', 03:03:04 INFO - 'tart', 03:03:04 INFO - 'tscrollx', 03:03:04 INFO - 'cart']}, 03:03:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:03:04 INFO - 'tsvgr_opacity', 03:03:04 INFO - 'tart', 03:03:04 INFO - 'tscrollx', 03:03:04 INFO - 'cart']}, 03:03:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:03:04 INFO - 'talos_options': ['--disable-e10s'], 03:03:04 INFO - 'tests': ['tp5o']}, 03:03:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:03:04 INFO - 'tests': ['tp5o']}, 03:03:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:03:04 INFO - 'talos_options': ['--disable-e10s', 03:03:04 INFO - '--xperf_path', 03:03:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:03:04 INFO - 'tests': ['tp5n']}, 03:03:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:03:04 INFO - 'talos_options': ['--xperf_path', 03:03:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:03:04 INFO - 'tests': ['tp5n']}}, 03:03:04 INFO - 'talos.zip': {'path': '', 03:03:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:03:04 INFO - Running post-action listener: _resource_record_post_action 03:03:04 INFO - ##### 03:03:04 INFO - ##### Finished populate-webroot step (success) 03:03:04 INFO - ##### 03:03:04 INFO - ##### 03:03:04 INFO - ##### Running create-virtualenv step. 03:03:04 INFO - ##### 03:03:04 INFO - Running pre-action listener: _resource_record_pre_action 03:03:04 INFO - Running main action method: create_virtualenv 03:03:04 INFO - Creating virtualenv /builds/slave/test/build/venv 03:03:04 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 03:03:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:03:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:03:04 INFO - Using real prefix '/usr' 03:03:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:03:04 INFO - Installing distribute.............................................................................................................................................................................................done. 03:03:06 INFO - Installing pip.................done. 03:03:06 INFO - Return code: 0 03:03:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:03: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')]} 03:03:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:03:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03: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')]} 03:03:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:03:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4b358eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b79770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c089c0>, '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 0x1c098c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c09d50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1464948135.900727-2127116052', '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 03:03: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', 'pip>=1.5'] in /builds/slave/test/build 03:03: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 pip>=1.5 03:03:06 INFO - Using env: {'DISPLAY': ':0', 03:03:06 INFO - 'HOME': '/home/cltbld', 03:03:06 INFO - 'LANG': 'en_US.UTF-8', 03:03:06 INFO - 'LANGUAGE': 'en_US:en', 03:03:06 INFO - 'LOGNAME': 'cltbld', 03:03:06 INFO - 'MAIL': '/var/mail/cltbld', 03:03:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:03:06 INFO - 'MOZ_NO_REMOTE': '1', 03:03:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:03:06 INFO - 'NO_EM_RESTART': '1', 03:03:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:03:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:03:06 INFO - 'PWD': '/builds/slave/test', 03:03:06 INFO - 'SHELL': '/bin/bash', 03:03:06 INFO - 'SHLVL': '1', 03:03:06 INFO - 'TERM': 'linux', 03:03:06 INFO - 'TMOUT': '86400', 03:03:06 INFO - 'USER': 'cltbld', 03:03:06 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1464948135.900727-2127116052', 03:03:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:03:06 INFO - '_': '/tools/buildbot/bin/python'} 03:03:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:03:07 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 03:03:07 INFO - Cleaning up... 03:03:07 INFO - Return code: 0 03:03:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:03:07 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')]} 03:03:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:03:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:07 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')]} 03:03:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:03:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:07 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 0x7f4b358eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b79770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c089c0>, '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 0x1c098c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c09d50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1464948135.900727-2127116052', '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 03:03:07 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 03:03:07 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 03:03:07 INFO - Using env: {'DISPLAY': ':0', 03:03:07 INFO - 'HOME': '/home/cltbld', 03:03:07 INFO - 'LANG': 'en_US.UTF-8', 03:03:07 INFO - 'LANGUAGE': 'en_US:en', 03:03:07 INFO - 'LOGNAME': 'cltbld', 03:03:07 INFO - 'MAIL': '/var/mail/cltbld', 03:03:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:03:07 INFO - 'MOZ_NO_REMOTE': '1', 03:03:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:03:07 INFO - 'NO_EM_RESTART': '1', 03:03:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:03:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:03:07 INFO - 'PWD': '/builds/slave/test', 03:03:07 INFO - 'SHELL': '/bin/bash', 03:03:07 INFO - 'SHLVL': '1', 03:03:07 INFO - 'TERM': 'linux', 03:03:07 INFO - 'TMOUT': '86400', 03:03:07 INFO - 'USER': 'cltbld', 03:03:07 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1464948135.900727-2127116052', 03:03:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:03:07 INFO - '_': '/tools/buildbot/bin/python'} 03:03:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:03:07 INFO - Downloading/unpacking psutil>=3.1.1 03:03:07 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 03:03:07 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 03:03:07 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 03:03:07 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 03:03:07 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 03:03:07 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 03:03:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:03:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:03:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:03:09 INFO - Installing collected packages: psutil 03:03:09 INFO - Running setup.py install for psutil 03:03:09 INFO - building 'psutil._psutil_linux' extension 03:03:09 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 03:03:09 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 03:03:09 INFO - building 'psutil._psutil_posix' extension 03:03:09 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 03:03:09 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 03:03:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:03:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:03:09 INFO - Successfully installed psutil 03:03:09 INFO - Cleaning up... 03:03:09 INFO - Return code: 0 03:03:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:03: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')]} 03:03:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:03:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03: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')]} 03:03:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:03:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:09 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 0x7f4b358eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b79770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c089c0>, '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 0x1c098c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c09d50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1464948135.900727-2127116052', '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 03:03:09 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 03:03:09 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 03:03:09 INFO - Using env: {'DISPLAY': ':0', 03:03:09 INFO - 'HOME': '/home/cltbld', 03:03:09 INFO - 'LANG': 'en_US.UTF-8', 03:03:09 INFO - 'LANGUAGE': 'en_US:en', 03:03:09 INFO - 'LOGNAME': 'cltbld', 03:03:09 INFO - 'MAIL': '/var/mail/cltbld', 03:03:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:03:09 INFO - 'MOZ_NO_REMOTE': '1', 03:03:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:03:09 INFO - 'NO_EM_RESTART': '1', 03:03:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:03:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:03:09 INFO - 'PWD': '/builds/slave/test', 03:03:09 INFO - 'SHELL': '/bin/bash', 03:03:09 INFO - 'SHLVL': '1', 03:03:09 INFO - 'TERM': 'linux', 03:03:09 INFO - 'TMOUT': '86400', 03:03:09 INFO - 'USER': 'cltbld', 03:03:09 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1464948135.900727-2127116052', 03:03:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:03:09 INFO - '_': '/tools/buildbot/bin/python'} 03:03:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:03:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:03:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:03:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:03:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:03:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:03:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:03:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:03:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:03:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:03:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:03:12 INFO - Installing collected packages: mozsystemmonitor 03:03:12 INFO - Running setup.py install for mozsystemmonitor 03:03:12 INFO - Successfully installed mozsystemmonitor 03:03:12 INFO - Cleaning up... 03:03:12 INFO - Return code: 0 03:03:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:03:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:03:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:03:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:03:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:03:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:12 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 0x7f4b358eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b79770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c089c0>, '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 0x1c098c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c09d50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1464948135.900727-2127116052', '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 03:03:12 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 03:03:12 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 03:03:12 INFO - Using env: {'DISPLAY': ':0', 03:03:12 INFO - 'HOME': '/home/cltbld', 03:03:12 INFO - 'LANG': 'en_US.UTF-8', 03:03:12 INFO - 'LANGUAGE': 'en_US:en', 03:03:12 INFO - 'LOGNAME': 'cltbld', 03:03:12 INFO - 'MAIL': '/var/mail/cltbld', 03:03:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:03:12 INFO - 'MOZ_NO_REMOTE': '1', 03:03:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:03:12 INFO - 'NO_EM_RESTART': '1', 03:03:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:03:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:03:12 INFO - 'PWD': '/builds/slave/test', 03:03:12 INFO - 'SHELL': '/bin/bash', 03:03:12 INFO - 'SHLVL': '1', 03:03:12 INFO - 'TERM': 'linux', 03:03:12 INFO - 'TMOUT': '86400', 03:03:12 INFO - 'USER': 'cltbld', 03:03:12 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1464948135.900727-2127116052', 03:03:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:03:12 INFO - '_': '/tools/buildbot/bin/python'} 03:03:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:03:12 INFO - Downloading/unpacking blobuploader==1.2.4 03:03:12 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 03:03:12 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 03:03:12 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 03:03:12 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 03:03:12 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 03:03:12 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 03:03:14 INFO - Downloading blobuploader-1.2.4.tar.gz 03:03:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:03:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:03: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 03:03: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 03:03: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 03:03: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 03:03: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 03:03: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 03:03:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:03:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:03: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 03:03: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 03:03: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 03:03: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 03:03: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 03:03: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 03:03:14 INFO - Downloading docopt-0.6.1.tar.gz 03:03:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:03:15 INFO - Installing collected packages: blobuploader, requests, docopt 03:03:15 INFO - Running setup.py install for blobuploader 03:03:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:03:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:03:15 INFO - Running setup.py install for requests 03:03:15 INFO - Running setup.py install for docopt 03:03:15 INFO - Successfully installed blobuploader requests docopt 03:03:15 INFO - Cleaning up... 03:03:15 INFO - Return code: 0 03:03:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:03:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:03:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:03:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:03:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:03:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:15 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 0x7f4b358eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b79770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c089c0>, '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 0x1c098c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c09d50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1464948135.900727-2127116052', '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 03:03:15 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 03:03:15 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 03:03:15 INFO - Using env: {'DISPLAY': ':0', 03:03:15 INFO - 'HOME': '/home/cltbld', 03:03:15 INFO - 'LANG': 'en_US.UTF-8', 03:03:15 INFO - 'LANGUAGE': 'en_US:en', 03:03:15 INFO - 'LOGNAME': 'cltbld', 03:03:15 INFO - 'MAIL': '/var/mail/cltbld', 03:03:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:03:15 INFO - 'MOZ_NO_REMOTE': '1', 03:03:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:03:15 INFO - 'NO_EM_RESTART': '1', 03:03:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:03:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:03:15 INFO - 'PWD': '/builds/slave/test', 03:03:15 INFO - 'SHELL': '/bin/bash', 03:03:15 INFO - 'SHLVL': '1', 03:03:15 INFO - 'TERM': 'linux', 03:03:15 INFO - 'TMOUT': '86400', 03:03:15 INFO - 'USER': 'cltbld', 03:03:15 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1464948135.900727-2127116052', 03:03:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:03:15 INFO - '_': '/tools/buildbot/bin/python'} 03:03:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:03:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:03:15 INFO - Running setup.py (path:/tmp/pip-F8UUgj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:03:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:03:15 INFO - Running setup.py (path:/tmp/pip-q3dMV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:03:16 INFO - Running setup.py (path:/tmp/pip-xb8ZaY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:03:16 INFO - Running setup.py (path:/tmp/pip-VuAcPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:03:16 INFO - Running setup.py (path:/tmp/pip-YbmklB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:03:16 INFO - Running setup.py (path:/tmp/pip-dqajkr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:03:16 INFO - Running setup.py (path:/tmp/pip-ZS4e1s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:03:16 INFO - Running setup.py (path:/tmp/pip-om62gE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:03:16 INFO - Running setup.py (path:/tmp/pip-5TpZ8N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:03:16 INFO - Running setup.py (path:/tmp/pip-W5EDJX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:03:16 INFO - Running setup.py (path:/tmp/pip-NXqbwD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:03:16 INFO - Running setup.py (path:/tmp/pip-dmoMfC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:03:16 INFO - Running setup.py (path:/tmp/pip-ciRir5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:03:16 INFO - Running setup.py (path:/tmp/pip-2qmLLO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:03:16 INFO - Running setup.py (path:/tmp/pip-P_Degt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:03:16 INFO - Running setup.py (path:/tmp/pip-0qdBCo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:03:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:03:17 INFO - Running setup.py (path:/tmp/pip-TxE3K1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:03:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:03:17 INFO - Running setup.py install for manifestparser 03:03:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:03:17 INFO - Running setup.py install for mozcrash 03:03:17 INFO - Running setup.py install for mozdebug 03:03:17 INFO - Running setup.py install for mozdevice 03:03:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:03:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:03:17 INFO - Running setup.py install for mozfile 03:03:17 INFO - Running setup.py install for mozhttpd 03:03:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:03:17 INFO - Running setup.py install for mozinfo 03:03:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:03:17 INFO - Running setup.py install for mozInstall 03:03:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:03:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:03:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:03:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:03:17 INFO - Running setup.py install for mozleak 03:03:18 INFO - Running setup.py install for mozlog 03:03:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:03:18 INFO - Running setup.py install for moznetwork 03:03:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:03:18 INFO - Running setup.py install for mozprocess 03:03:18 INFO - Running setup.py install for mozprofile 03:03:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:03:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:03:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:03:18 INFO - Running setup.py install for mozrunner 03:03:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:03:18 INFO - Running setup.py install for mozscreenshot 03:03:18 INFO - Running setup.py install for moztest 03:03:18 INFO - Running setup.py install for mozversion 03:03:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:03:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:03:18 INFO - Cleaning up... 03:03:18 INFO - Return code: 0 03:03:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:03:18 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')]} 03:03:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:03:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:18 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')]} 03:03:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:03:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:18 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 0x7f4b358eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b79770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c089c0>, '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 0x1c098c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c09d50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1464948135.900727-2127116052', '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 03:03:18 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 03:03:18 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 03:03:18 INFO - Using env: {'DISPLAY': ':0', 03:03:18 INFO - 'HOME': '/home/cltbld', 03:03:18 INFO - 'LANG': 'en_US.UTF-8', 03:03:18 INFO - 'LANGUAGE': 'en_US:en', 03:03:18 INFO - 'LOGNAME': 'cltbld', 03:03:18 INFO - 'MAIL': '/var/mail/cltbld', 03:03:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:03:18 INFO - 'MOZ_NO_REMOTE': '1', 03:03:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:03:18 INFO - 'NO_EM_RESTART': '1', 03:03:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:03:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:03:18 INFO - 'PWD': '/builds/slave/test', 03:03:18 INFO - 'SHELL': '/bin/bash', 03:03:18 INFO - 'SHLVL': '1', 03:03:18 INFO - 'TERM': 'linux', 03:03:18 INFO - 'TMOUT': '86400', 03:03:18 INFO - 'USER': 'cltbld', 03:03:18 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1464948135.900727-2127116052', 03:03:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:03:18 INFO - '_': '/tools/buildbot/bin/python'} 03:03:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:03:19 INFO - Running setup.py (path:/tmp/pip-MCx907-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:03:19 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)) 03:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:03:19 INFO - Running setup.py (path:/tmp/pip-FTACav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:03:19 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)) 03:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:03:19 INFO - Running setup.py (path:/tmp/pip-FCrQnr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:03:19 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)) 03:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:03:19 INFO - Running setup.py (path:/tmp/pip-Ja3Kfv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:03:19 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)) 03:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:03:19 INFO - Running setup.py (path:/tmp/pip-dtoSiv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:03:19 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)) 03:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:03:19 INFO - Running setup.py (path:/tmp/pip-yEAtMb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:03:19 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)) 03:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:03:19 INFO - Running setup.py (path:/tmp/pip-Au8upD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:03:19 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)) 03:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:03:19 INFO - Running setup.py (path:/tmp/pip-JozDIx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:03:19 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)) 03:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:03:19 INFO - Running setup.py (path:/tmp/pip-Ijw0Kp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:03:19 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)) 03:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:03:19 INFO - Running setup.py (path:/tmp/pip-vk7ZMz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:03:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:03:19 INFO - Running setup.py (path:/tmp/pip-N9RrFM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:03:19 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)) 03:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:03:19 INFO - Running setup.py (path:/tmp/pip-xqsMKr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:03:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:03:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:03:19 INFO - Running setup.py (path:/tmp/pip-9OWhr6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:03:20 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)) 03:03:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:03:20 INFO - Running setup.py (path:/tmp/pip-RncATj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:03:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:03:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:03:20 INFO - Running setup.py (path:/tmp/pip-HvOtj2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:03:20 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)) 03:03:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:03:20 INFO - Running setup.py (path:/tmp/pip-5NXjTU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:03:20 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)) 03:03:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:03:20 INFO - Running setup.py (path:/tmp/pip-mNxRJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:03:20 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)) 03:03:20 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)) 03:03:20 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)) 03:03:20 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)) 03:03:20 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)) 03:03:20 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)) 03:03:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:03:20 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 03:03:20 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 03:03:20 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 03:03:20 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 03:03:20 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 03:03:20 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 03:03:22 INFO - Downloading blessings-1.6.tar.gz 03:03:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:03:22 INFO - Installing collected packages: blessings 03:03:22 INFO - Running setup.py install for blessings 03:03:22 INFO - Successfully installed blessings 03:03:22 INFO - Cleaning up... 03:03:22 INFO - Return code: 0 03:03:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:03:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:03:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:03:22 INFO - Reading from file tmpfile_stdout 03:03:22 INFO - Current package versions: 03:03:22 INFO - argparse == 1.2.1 03:03:22 INFO - blessings == 1.6 03:03:22 INFO - blobuploader == 1.2.4 03:03:22 INFO - docopt == 0.6.1 03:03:22 INFO - manifestparser == 1.1 03:03:22 INFO - mozInstall == 1.12 03:03:22 INFO - mozcrash == 0.17 03:03:22 INFO - mozdebug == 0.1 03:03:22 INFO - mozdevice == 0.48 03:03:22 INFO - mozfile == 1.2 03:03:22 INFO - mozhttpd == 0.7 03:03:22 INFO - mozinfo == 0.9 03:03:22 INFO - mozleak == 0.1 03:03:22 INFO - mozlog == 3.2 03:03:22 INFO - moznetwork == 0.27 03:03:22 INFO - mozprocess == 0.22 03:03:22 INFO - mozprofile == 0.28 03:03:22 INFO - mozrunner == 6.11 03:03:22 INFO - mozscreenshot == 0.1 03:03:22 INFO - mozsystemmonitor == 0.3 03:03:22 INFO - moztest == 0.7 03:03:22 INFO - mozversion == 1.4 03:03:22 INFO - psutil == 3.1.1 03:03:22 INFO - requests == 1.2.3 03:03:22 INFO - wsgiref == 0.1.2 03:03:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:03:22 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')]} 03:03:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:03:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:22 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')]} 03:03:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:03:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:22 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 0x7f4b358eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b79770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c089c0>, '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 0x1c098c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c09d50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1464948135.900727-2127116052', '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 03:03:22 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 03:03:22 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 03:03:22 INFO - Using env: {'DISPLAY': ':0', 03:03:22 INFO - 'HOME': '/home/cltbld', 03:03:22 INFO - 'LANG': 'en_US.UTF-8', 03:03:22 INFO - 'LANGUAGE': 'en_US:en', 03:03:22 INFO - 'LOGNAME': 'cltbld', 03:03:22 INFO - 'MAIL': '/var/mail/cltbld', 03:03:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:03:22 INFO - 'MOZ_NO_REMOTE': '1', 03:03:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:03:22 INFO - 'NO_EM_RESTART': '1', 03:03:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:03:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:03:22 INFO - 'PWD': '/builds/slave/test', 03:03:22 INFO - 'SHELL': '/bin/bash', 03:03:22 INFO - 'SHLVL': '1', 03:03:22 INFO - 'TERM': 'linux', 03:03:22 INFO - 'TMOUT': '86400', 03:03:22 INFO - 'USER': 'cltbld', 03:03:22 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1464948135.900727-2127116052', 03:03:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:03:22 INFO - '_': '/tools/buildbot/bin/python'} 03:03:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:03:22 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)) 03:03:22 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)) 03:03:22 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)) 03:03:22 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)) 03:03:22 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)) 03:03:22 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)) 03:03:22 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)) 03:03:22 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)) 03:03:22 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)) 03:03:22 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)) 03:03:22 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)) 03:03:22 INFO - Cleaning up... 03:03:22 INFO - Return code: 0 03:03:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:03:22 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')]} 03:03:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:03:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:22 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')]} 03:03:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:03:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:22 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 0x7f4b358eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b79770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c089c0>, '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 0x1c098c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c09d50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1464948135.900727-2127116052', '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 03:03:22 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 03:03:22 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 03:03:22 INFO - Using env: {'DISPLAY': ':0', 03:03:22 INFO - 'HOME': '/home/cltbld', 03:03:22 INFO - 'LANG': 'en_US.UTF-8', 03:03:22 INFO - 'LANGUAGE': 'en_US:en', 03:03:22 INFO - 'LOGNAME': 'cltbld', 03:03:22 INFO - 'MAIL': '/var/mail/cltbld', 03:03:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:03:22 INFO - 'MOZ_NO_REMOTE': '1', 03:03:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:03:22 INFO - 'NO_EM_RESTART': '1', 03:03:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:03:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:03:22 INFO - 'PWD': '/builds/slave/test', 03:03:22 INFO - 'SHELL': '/bin/bash', 03:03:22 INFO - 'SHLVL': '1', 03:03:22 INFO - 'TERM': 'linux', 03:03:22 INFO - 'TMOUT': '86400', 03:03:22 INFO - 'USER': 'cltbld', 03:03:22 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1464948135.900727-2127116052', 03:03:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:03:22 INFO - '_': '/tools/buildbot/bin/python'} 03:03:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:03:23 INFO - Downloading/unpacking jsonschema 03:03:23 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 03:03:23 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 03:03:23 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 03:03:23 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 03:03:23 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 03:03:23 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 03:03:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:03:25 INFO - Downloading/unpacking functools32 (from jsonschema) 03:03:25 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 03:03:25 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 03:03:25 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 03:03:25 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 03:03:25 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 03:03:25 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 03:03:25 INFO - Downloading functools32-3.2.3-2.tar.gz 03:03:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:03:25 INFO - warning: no files found matching '*.txt' 03:03:25 INFO - no previously-included directories found matching 'build' 03:03:25 INFO - no previously-included directories found matching 'dist' 03:03:25 INFO - no previously-included directories found matching '.git*' 03:03:25 INFO - Installing collected packages: jsonschema, functools32 03:03:25 INFO - Running setup.py install for functools32 03:03:25 INFO - warning: no files found matching '*.txt' 03:03:25 INFO - no previously-included directories found matching 'build' 03:03:25 INFO - no previously-included directories found matching 'dist' 03:03:25 INFO - no previously-included directories found matching '.git*' 03:03:25 INFO - Successfully installed jsonschema functools32 03:03:25 INFO - Cleaning up... 03:03:25 INFO - Return code: 0 03:03:25 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:03:25 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')]} 03:03:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:03:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:25 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')]} 03:03:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:03:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:03:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4b358eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b79770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c089c0>, '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 0x1c098c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c09d50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1464948135.900727-2127116052', '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 03:03:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:03:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:03:25 INFO - Using env: {'DISPLAY': ':0', 03:03:25 INFO - 'HOME': '/home/cltbld', 03:03:25 INFO - 'LANG': 'en_US.UTF-8', 03:03:25 INFO - 'LANGUAGE': 'en_US:en', 03:03:25 INFO - 'LOGNAME': 'cltbld', 03:03:25 INFO - 'MAIL': '/var/mail/cltbld', 03:03:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:03:25 INFO - 'MOZ_NO_REMOTE': '1', 03:03:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:03:25 INFO - 'NO_EM_RESTART': '1', 03:03:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:03:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:03:25 INFO - 'PWD': '/builds/slave/test', 03:03:25 INFO - 'SHELL': '/bin/bash', 03:03:25 INFO - 'SHLVL': '1', 03:03:25 INFO - 'TERM': 'linux', 03:03:25 INFO - 'TMOUT': '86400', 03:03:25 INFO - 'USER': 'cltbld', 03:03:25 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1464948135.900727-2127116052', 03:03:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:03:25 INFO - '_': '/tools/buildbot/bin/python'} 03:03:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:03:25 INFO - Downloading/unpacking flake8 03:03:25 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 03:03:25 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 03:03:25 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 03:03:25 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 03:03:25 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 03:03:25 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 03:03:27 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:03:27 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:03:27 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 03:03:27 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 03:03:27 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 03:03:27 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 03:03:27 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 03:03:27 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 03:03:27 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:03:27 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:03:27 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 03:03:27 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 03:03:27 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 03:03:27 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 03:03:27 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 03:03:27 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 03:03:28 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:03:28 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 03:03:28 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 03:03:28 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 03:03:28 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 03:03:28 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 03:03:28 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 03:03:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:03:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:03:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:03:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:03:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:03:28 INFO - no previously-included directories found matching 'docs/_build' 03:03:28 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:03:28 INFO - Running setup.py install for pep8 03:03:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:03:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:03:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:03:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:03:28 INFO - no previously-included directories found matching 'docs/_build' 03:03:28 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:03:28 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:03:28 INFO - Cleaning up... 03:03:28 INFO - Return code: 0 03:03:28 INFO - Running post-action listener: _resource_record_post_action 03:03:28 INFO - Running post-action listener: _start_resource_monitoring 03:03:28 INFO - Starting resource monitoring. 03:03:28 INFO - ##### 03:03:28 INFO - ##### Finished create-virtualenv step (success) 03:03:28 INFO - ##### 03:03:28 INFO - ##### 03:03:28 INFO - ##### Running install step. 03:03:28 INFO - ##### 03:03:28 INFO - Running pre-action listener: _resource_record_pre_action 03:03:28 INFO - Running main action method: install 03:03:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:03:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:03:29 INFO - Reading from file tmpfile_stdout 03:03:29 INFO - Detecting whether we're running mozinstall >=1.0... 03:03:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:03:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:03:29 INFO - Reading from file tmpfile_stdout 03:03:29 INFO - Output received: 03:03:29 INFO - Usage: mozinstall [options] installer 03:03:29 INFO - Options: 03:03:29 INFO - -h, --help show this help message and exit 03:03:29 INFO - -d DEST, --destination=DEST 03:03:29 INFO - Directory to install application into. [default: 03:03:29 INFO - "/builds/slave/test"] 03:03:29 INFO - --app=APP Application being installed. [default: firefox] 03:03:29 INFO - mkdir: /builds/slave/test/build/application 03:03:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:03:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:03:46 INFO - Reading from file tmpfile_stdout 03:03:46 INFO - Output received: 03:03:46 INFO - /builds/slave/test/build/application/firefox/firefox 03:03:46 INFO - Running post-action listener: _resource_record_post_action 03:03:46 INFO - ##### 03:03:46 INFO - ##### Finished install step (success) 03:03:46 INFO - ##### 03:03:46 INFO - ##### 03:03:46 INFO - ##### Running run-tests step. 03:03:46 INFO - ##### 03:03:46 INFO - Running pre-action listener: _resource_record_pre_action 03:03:46 INFO - Running main action method: run_tests 03:03:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:03:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:03:46 INFO - Python 2.7.3 03:03:46 INFO - Return code: 0 03:03:46 INFO - grabbing minidump binary from tooltool 03:03: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')]} 03:03:46 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 0x1c089c0>, '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 0x1c098c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c09d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:03:46 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 03:03:46 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 03:03:46 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 03:03:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:03:46 INFO - Return code: 0 03:03:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:03:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:03:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:03:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:03:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:03:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:03:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:03:47 INFO - Return code: 0 03:03:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BeKAicNpTFmvCBq6slNXQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 03:03:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Larch --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BeKAicNpTFmvCBq6slNXQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --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 03:03:47 INFO - Using env: {'DISPLAY': ':0', 03:03:47 INFO - 'HOME': '/home/cltbld', 03:03:47 INFO - 'LANG': 'en_US.UTF-8', 03:03:47 INFO - 'LANGUAGE': 'en_US:en', 03:03:47 INFO - 'LOGNAME': 'cltbld', 03:03:47 INFO - 'MAIL': '/var/mail/cltbld', 03:03:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:03:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:03:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:03:47 INFO - 'MOZ_NO_REMOTE': '1', 03:03:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:03:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:03:47 INFO - 'NO_EM_RESTART': '1', 03:03:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:03:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:03:47 INFO - 'PWD': '/builds/slave/test', 03:03:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:03:47 INFO - 'SHELL': '/bin/bash', 03:03:47 INFO - 'SHLVL': '1', 03:03:47 INFO - 'TERM': 'linux', 03:03:47 INFO - 'TMOUT': '86400', 03:03:47 INFO - 'USER': 'cltbld', 03:03:47 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1464948135.900727-2127116052', 03:03:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:03:47 INFO - '_': '/tools/buildbot/bin/python'} 03:03:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BeKAicNpTFmvCBq6slNXQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 03:03:47 INFO - mozversion application_buildid: 20160603003002 03:03:47 INFO - mozversion application_changeset: 426f42ae29ff33b8fbc233268879837a67c36858 03:03:47 INFO - mozversion application_display_name: Nightly 03:03:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:03:47 INFO - mozversion application_name: Firefox 03:03:47 INFO - mozversion application_remotingname: firefox 03:03:47 INFO - mozversion application_repository: https://hg.mozilla.org/projects/larch 03:03:47 INFO - mozversion application_vendor: Mozilla 03:03:47 INFO - mozversion application_version: 49.0a1 03:03:47 INFO - mozversion platform_buildid: 20160603003002 03:03:47 INFO - mozversion platform_changeset: 426f42ae29ff33b8fbc233268879837a67c36858 03:03:47 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/larch 03:03:47 INFO - mozversion platform_version: 49.0a1 03:03:47 INFO - using testdate: 1464948227 03:03:47 INFO - actual date: 1464948227 03:03:47 INFO - starting webserver on 'localhost:54651' 03:03:47 INFO - SUITE-START | Running 2 tests 03:03:47 INFO - TEST-START | dromaeo_css 03:03:47 INFO - operating with platform_type : linux_ 03:03:47 INFO - Initialising browser for dromaeo_css test... 03:03:47 INFO - TEST-INFO | started process 9936 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5jQNlX/profile http://localhost:54651/getInfo.html) 03:03:53 INFO - PROCESS | 9936 | __metrics Screen width/height:1600/1200 03:03:53 INFO - PROCESS | 9936 | colorDepth:24 03:03:53 INFO - PROCESS | 9936 | Browser inner width/height: 1024/697 03:03:53 INFO - PROCESS | 9936 | __metrics 03:03:54 ERROR - PROCESS | 9936 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 03:03:54 INFO - TEST-INFO | 9936: exit 0 03:03:54 INFO - Browser initialized. 03:03:54 INFO - Running cycle 1/1 for dromaeo_css test... 03:03:54 INFO - TEST-INFO | started process 10058 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5jQNlX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:04:06 INFO - PROCESS | 10058 | RSS: Main: 167833600 03:04:06 INFO - PROCESS | 10058 | 03:04:56 INFO - PROCESS | 10058 | 1464948296443 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] 03:07:03 INFO - PROCESS | 10058 | Cycle 1(1): loaded http://localhost:54651/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54651/tests/dromaeo/cssquery-ext.html) 03:07:04 INFO - PROCESS | 10058 | RSS: Main: 171225088 03:07:04 INFO - PROCESS | 10058 | 03:10:07 INFO - PROCESS | 10058 | Cycle 1(1): loaded http://localhost:54651/tests/dromaeo/cssquery-ext.html (next: http://localhost:54651/tests/dromaeo/cssquery-jquery.html) 03:10:07 INFO - PROCESS | 10058 | RSS: Main: 170426368 03:10:07 INFO - PROCESS | 10058 | 03:13:09 INFO - PROCESS | 10058 | Cycle 1(1): loaded http://localhost:54651/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54651/tests/dromaeo/cssquery-mootools.html) 03:13:10 INFO - PROCESS | 10058 | RSS: Main: 171331584 03:13:10 INFO - PROCESS | 10058 | 03:16:11 INFO - PROCESS | 10058 | Cycle 1(1): loaded http://localhost:54651/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54651/tests/dromaeo/cssquery-prototype.html) 03:16:12 INFO - PROCESS | 10058 | RSS: Main: 168906752 03:16:12 INFO - PROCESS | 10058 | 03:19:15 INFO - PROCESS | 10058 | Cycle 1(1): loaded http://localhost:54651/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54651/tests/dromaeo/cssquery-yui.html) 03:19:15 INFO - PROCESS | 10058 | RSS: Main: 171003904 03:19:15 INFO - PROCESS | 10058 | 03:22:18 INFO - PROCESS | 10058 | Cycle 1(1): loaded http://localhost:54651/tests/dromaeo/cssquery-yui.html (next: http://localhost:54651/tests/dromaeo/cssquery-dojo.html) 03:22:18 INFO - PROCESS | 10058 | RSS: Main: 172335104 03:22:18 INFO - PROCESS | 10058 | 03:22:18 INFO - PROCESS | 10058 | __start_tp_report 03:22:18 INFO - PROCESS | 10058 | _x_x_mozilla_page_load 03:22:18 INFO - PROCESS | 10058 | _x_x_mozilla_page_load_details 03:22:18 INFO - PROCESS | 10058 | |i|pagename|runs| 03:22:18 INFO - PROCESS | 10058 | |0;dojo.html;3127.5152351385536;3163.5254711793214;3188.5376620390043;3211.181148807054;3220.7906486078405;5489.807856725015;5562.916556251655;5592.692401917893;5593.804216852401;5594.916076258859;5420.945790542093;5542.889142217154;5550.888982220353;5582.748776305066;5608.383077861432;5000.449950505451;5051.242313652945;5134.512221338986;5177.637565370425;5230.372355317368;822.302790541682;5008.048470790556;5032.597392208614;5133.1786914093755;5136.126858434057;5051.848444546669;5054.570361519275;5077.390713114413;5078.949210507884;5083.288339632454;5075.264086707443;5083.6441449098575;5087.440381558025;5088.109580823379;5111.463296353903;5019.071471777696;5063.088644044071;5069.163588007974;5110.054639891632;5114.616403769732;5511.807086751985;5522.088855338904;5523.364813046511;5573.721313934287;5593.664380137164;5808.2449281593545;5985.132155837423;6037.30570984338;6052.334243233241;6056.788012419544;5888.116782482619;5941.940580594225;5959.851003724898;5997.970010149921;6001.789937352171;5568;5569.359523654791;5587.357453892813;5588.692621905793;5594.748236329334;5981.132735753292;5992.31088424828;6073.757049717962;6112.388761123852;6132.141500189977;5784.855378615568;5842.970785146047;5857.853553661107;5863.355030946593;5897.64614123154;5907.232059832194;5910.8817823643285;5922.082077278029;5927.3776253493625;5927.73325200367;5671.886562268732;5748.798792042258;5769.740361683735;5846.093855452412;5870.706464676749;5833.4749872511675;5844.707764611752;5845.620034697731;5850.210221620112;5893.526618345413;4415.845445409395;4428.070105277863;4450.955490445119;4454.888627784267;4473.888152796206;3958;3986.6013398660484;4036.535798383165;4037.6164264394833;4062.756234625932;5622.971885140548;5643.887122257532;5687.374388817227;5745.597808153389;5766.538676905838;6055.939440605625;6087.969560152171;6096.055111457731;6100.72546735398;6110.297315808739;5586.13414920688;5725.3988331225455;5754.0505816540635;5776.855578610568;5812.476877081083;5145.279660847485;5156.948430515722;5168.302279192336;5176.8964620707375;5185.896282074337;6011.27864656244;6171.722272497748;6200.348963358782;6207.34822843604;6211.2857021443115;5944.6730429826775;6022.879542409215;6037.27552693662;6039.305479869871;6050.9394906050375;6184.907226391518;6185.969070154621;6190.597611155261;6200.0699895016105;6218.906716399167;5735.655860648374;5815.82552523425;5931.1992880960515;5935.970320148372;5978.222831031938;5946.494547963472;6012.038073908154;6026.457618814327;6032.939670603238;6089.756409743738;5826.621269617462;5868.3251426086545;5878;5888.3228428731245;5914.378990205966;5591.4688104629995;5696.373398926197;5747.971260143672;5858.560607954335;5876.471117599436;5667.943320566742;5703.08750599902;5716.771329146787;5726.284214473191;5755.971220143872;5807.477327040587;5828.679422631626;5831.533477321889;5840.824775256579;5858.765649373977;5599.412061733459;5646.322441306905;5700.657960522382;5735.512481438957;5757.424257574209 03:22:18 INFO - PROCESS | 10058 | |1;ext.html;573.7160105747655;625.5246013030096;629.483823264923;639;648.1185587600864;39531.80234098829;44507.109857802825;44541.55458445415;44573.33140002903;44573.77713111438;43993.560064399346;44440.55559444405;44521.55478445214;44557.77721111398;44565.777171114096;8538.573071346438;8639.913600864005;8650.697225597105;8697.7825554361;8719.346049046315;8595.140485951417;8602.526861022672;8631.6978905738;8643.524606146659;8655;8687.913120868805;8728.389012769108;8772;8775.605097770616;8793.340499462534;8661.003984541763;8687.869681954775;8725.258353039999;8736.039035706068;8740.562971851446;8478.06741258461;8537.317014638815;8582.055973842873;8583.570821458901;8588.742337729878;40322.395164072565;40890.795546022375;40968.38547421791;40986.79506602478;41157.79421102905;3354.3962086824363;3546.1666508370513;3559.60844307126;3608.0979755061235;3682.171511409938;32916.518756655765;32948.67051329504;33408.83295583507;33425;34112;4226.682998775104;4374.58441448062;4386.978065109654;4456.5766252205985;4568.588827005586;351006;351095;351660;351832;352612;31930.521042184388;57374;57602.71198644064;57765;57784;33963.15092122717;35436.64563354333;35492.46761298583;35507.82246088753;35813.567457301935;15618.609534761494;15735.68528629421;15807.68384632324;15829.841701583067;15830.050196988217;12610.873891261153;12615.684607884692;12658.303793291274;12674.176178548365;12684.619461416172;8364.790880227922;8415.831683366298;8481.321494280442;8526.78683032929;8529.616167272488;3188.5970173124215;3199.5360672702795;3245.9675403245665;3269.525918741769;3277.5903012123485;1063.611781699674;1069.5294070608907;1078.9568417263222;1121.8541589593465;1159.7796418680423;32449.513257301158;32918.506222406686;32993.34013319768;33429;33537.16157096092;1083.4366129612558;1085.4138765066934;1122.315387613555;1149.2874417860812;1189.191349882071;17311.3941012064;17330.220140093727;17339.47981560555;17444.47666570005;17489.7376539352;598301;606894;608059;608468;610854;59594.404055959756;59972.700136499036;60004.099938500956;60286.095708564404;60514.39485605087;1330.8269924909894;1359.789232668938;1384.9376778045012;1394.1495687630538;1395.5603984744773;31302.217444564067;32021.35957280888;32337.191570210933;32553.348933020734;32859.34281314408;51027;51081.489185107675;51401;51414.22878656748;51434.228486571985;450996;453502;453725;454179;457620;27915.581266280617;28193.43613127767;28432;28434.289142771595;28450.85774571114;44406.77796610996;45471.31793023174;45620.315695265264;45949.770251149865;49126.50873491362;40079.79960100181;40787.38818917659;42158.578414215466;42283.3657495144;42477.362839556816;40852;41012.179756405305;41023.97440063903;41392;42246;41917.37123943205;41921.37117943172;42487.362689559064;42700;44504.55495445004;32979;37430.812845935594;38022.23955520819;39985;40312.19375612413;28556.57165142566;29162.125136245948;29298.707012929597;29382.412351752417;29465 03:22:18 INFO - PROCESS | 10058 | |2;jquery.html;383.19146600672593;388.3398223020864;389.88108626868814;390.1132492940114;402.3220872829283;13819.585412437618;18137.909310453444;18761.7185742214;19993.400197994066;20004.399868003966;18272.817271827276;18870.716939245922;18928.053597320115;19023.429297121074;19153.233870645192;5483.259759932418;5485.725713714318;5603.60774745768;5643.266375371217;5748.511376533;5368;5627.465390787868;5658.886822263552;5685.033544297458;5711.171880077386;5686.147077938322;5698.8290351289525;5709.4290570942985;5709.514691251248;5738;5415.675059496423;5708.200851880719;5756.366799652035;5764.106563482667;5765.855853603673;5458.6724796512335;5502.779888804443;5677.489025987681;5732.0542110551705;5735.541156707453;13365.799513007312;13542.322883855768;13631.727365452734;19733.21067157312;22471;2172.3700126963163;2191.3973657244387;2269.773022697717;2359.988200059006;2367.3726462487452;9877.703668889873;10125.949370253174;10180.338278011906;11215;14310.069845460011;1883.7551118354663;1915.5019694879293;1921.7693876734882;1962.3328068456792;2004.2183548416128;53742.462575374135;57671;81678.59160704158;82314.17685823125;82636.58681706613;10829.512671929624;11062.446877656084;11138;11155.665330040112;11247.493862776195;15264.3894244229;15346.309416076303;15402.229888505753;15410;15414.537563873102;8188.7952801180445;8262;8328.08391076981;8360.163983601713;8428.199321064489;7906.52560846351;7955.880661790078;7989.8402031960195;8063.19368063189;8168.7957801055445;4750.477447480775;4808.807647694053;4814.470408255089;4818.807247710052;4836.347093142451;1929.9903500482408;1957.7748558915907;1959.3436198873537;1983.7917018713115;1993.7707163676073;926.124383788341;990.2276224544867;1056.4717641179411;1062.5112448273726;1072.0244577434653;15593.844061559466;18717.625647486973;19083.141258643394;19516;19655.705164422547;949.1837020162654;955.1165172215673;1006.200070943587;1009.6163457885956;1016.1667432705111;10430.895691042992;10859.83710244347;10924.890751092546;10934.56261749521;10982;472878;479277;480417;487246;488851;90727;91286;92869.53565232265;93165;93734.53132734292;965.478641533564;984.4044353166231;997.1773287038078;997.850322451638;1003.9849402258972;17227.3970411035;17257.70788303406;17278.740818887978;17606.91196544009;17808.91095544566;41489.792551037055;41533;42141.57858421376;42188.78905605575;43695.78152109219;56421.43578564326;57860.79144555032;58492;58548.414515856;58876.41123588709;7609.733659321897;7974.920250797418;8417.579121044046;8645.308375329832;8749.781255468664;12907.870921290667;13228.867711322764;13462.326883655582;13560.11859229147;13751.312434378042;10725.302855314692;11575.76848463043;11725.472353743931;11824.467898944396;12055.336956467478;10926.125909927347;11491;11579.478923448296;11874.981253186806;11879.76240475203;11514.596989105341;11693.356865372487;11863.822042669539;12085.516579336729;12200.572979945659;7533.359664428585;7953.204679532;8713.562262226662;8728.127187281221;8884.911150888667;11278.492467838803;11723.120765942758;11729;11759.76480470403;12172.208806427554 03:22:18 INFO - PROCESS | 10058 | |3;mootools.html;1471.919044452555;1501.7672260799577;1638.598543356877;1759.472158352494;1775.9644807103866;8057.516549007064;8547.529885856284;8572.399932004762;9171;9178.311626627996;8625.439346442477;8860.158284962934;8883.777905552364;8892.333075019384;8930.732078037652;2362.11420717231;2413.046846495633;2420.576399130154;2424.284835973392;2428.5871401861727;2388.8088952883813;2403.591389463795;2443.926682199537;2447.1801946347996;2448.1431498975307;2360.6104992676187;2395.532871090138;2416.2751174647624;2421.806255499556;2435;2328.75548067453;2333.9183128590416;2347.5774360615083;2348.823838212124;2390.5099454611764;2325.03511042917;2327.0459111764267;2336.2290444153386;2336.2991102669303;2362.9291121266388;8779.604917778652;8817.647294108228;8873.112688731075;8934.28525717941;8951.283897288202;5344.412114667383;5452.781888724447;5457.972710136463;5461.972690136564;5470.343558772973;3429.725621950238;3437.2438063625964;3497.0557949353533;3507.57909050913;3557.3418917500344;1165.8659254185793;1174.4597485156837;1182.6097387861985;1196.9281843089354;2034.5625690476618;12209.511619535208;12550.372481375894;12571.874281257253;12587.559435419807;12670.936645316715;4603.95396046042;4690.155771961012;4745.549172828576;4780.904381912343;4792.496787837296;9807.852882206773;9858.852117218248;9874.259430542737;9885.357451765756;9912;5397.649152805055;5430.809921652803;5434.994526012701;5452.318460192476;5454.59090568209;4476.4180656514445;4878.829240976549;5002.249662550574;5021.096202683552;5033.320501732219;3894.221155768801;3914.0606254498716;3969.4442778011103;3991.5808840071954;4041.373587094005;1174.7767924094394;1188.5780547905542;1188.8216767484773;1193.7254431480808;1199.3283761093815;862.4092496639822;898.5552151684958;964.4165280005636;976.8166860479473;989.5497548615363;5959.135925290809;5963.880722385528;6015.488683461867;6076.665783381868;6132.6627035513475;475.1352538380115;480.4258910601797;482.3753239554785;488.9779959901813;492.6576029659424;4079.673626109904;4108.383742438658;4127.587241275908;4149.37759336102;4202.285611446062;10382.377057376581;10735.624253151258;10838.891611083945;10843.240973131962;10857.131429485622;10527.315724477885;10537.789244215226;10604.416757078281;10627.681169564925;10643.787124257471;8081.878771818428;8094.190580941859;8196.221358970888;8198.1391953844;8199.754007379668;5952.375000624872;5963.373845746308;5994.730237139252;6024.0662697282;6104.908426373697;10042.246831487522;10096.79806403853;10130.493475326351;10169;10177.847332289874;9880.752981175528;10501.89498105009;10582.417967011581;10727.034566889017;10860.185486088418;7260.128784545888;7577.886331704918;7790.143084260613;7978.242067003625;8172.632231549475;8718.694845680371;8757.168069033687;8819.647214111365;8888.0667529911;8951.73144805657;7897.881531777143;7944.6424910880305;7955.801104972422;7956.2441568050945;8025.719099831478;7343.265673432614;7654.846903062019;7737.0715514138665;7773.1449540549365;7788.571628560257;7040.260772618802;7174.556582251301;7238.819029524304;7245.529040612343;7298.160711518243;5281.973590132025;5317.973410132925;5336.626436149432;5387.407385187705;5423.105187643994;5300.867478313073;5305.31030965972;5345.091334473072;5442.23808666779;5470.699111548903 03:22:18 INFO - PROCESS | 10058 | |4;prototype.html;317.5950662904796;321.55143574713276;336.34748587739784;339.8555613864107;345.87721358917565;5568.610197286192;5630.887382252353;5651.434856514352;5662.5186859116975;5668.206451096849;5546.446994841441;5554.666719996803;5562.471565201299;5570.415106413829;5583.972080139593;4170.666346692257;4253.298205796055;4374.147041326943;4374.343848422746;4379.540148284432;4354.1944740223;4359.171757366106;4360.21516127097;4368.563143685637;4370.519242883281;4308.913821723564;4329.935050974238;4332.393464914899;4349.1301739652035;4376.124775045004;4288.442502474674;4314.201872653569;4322.157179350028;4334.371516130175;4351.216001439427;3830;3844.6347596978244;3852.248811481762;3864.613538646141;3875.399313106473;5379.246905433242;5383.035192154835;5426.403095659474;5430.864228394283;5475.479829416199;4830;4960.975195124001;4981.800727970877;4982.202847544412;5065.316182315377;5762.740676669518;5763.538916886639;5795.130730390433;5796.304443466769;5803.303603567599;4199.5091742431305;4229.36559516072;4241.618254357092;4248.638865696419;4251.107267473834;5654.9717251413895;5993.160957465958;6085.4523092921845;6087.878242435127;6104.725287362079;4205.3481710334945;4226.281532139544;4231.259529582311;4246.63903568194;4264.466941632296;4249.830006799755;4253.8723838284905;4260.957390426118;4265.786710664454;4267.210566045292;4730.2431610942085;4840.491748366441;4897.461279259279;4919.557239848431;4944.159492886218;5780.942190578125;5809.9419005809405;5828.388019258002;5853.7365818538265;5879.882402351929;1449.3043339197034;1474.7198032373815;1475.7048590281986;1483.4437086092714;1489.0321291160833;890.8485557455118;913.5295322908707;916.6470908700198;932.2029664636774;954.5418199264392;4948.802047918043;4949.9110195756875;5080.720560369141;5093.414257360377;5154.5103215194495;5280.841574752763;5305.577902253025;5310.522053015247;5324.733763311819;5401.838604700009;4786;4950.4059512858685;5051.6716413433005;5116.539511443913;5118.667286626357;2873.858975063549;2886.7257610526967;2900.4344152890408;2915.492676298382;2921.2258751430886;5299.576033917355;5372.7313634318125;5512.4211957744665;5535.750891209906;5567.916481252784;5266.3943646480375;5304.681719096867;5409.675419474844;5436.266104075899;5459.161236157176;5464.316960379952;5479.863003424866;5502.724863756796;5519.751611177507;5580.9162862557905;5125.359330083739;5235.65968212065;5298.860744939857;5325.4940780625775;5407.863893762021;5211.983663185642;5244.895102098013;5350.892982140257;5369.69103285591;5396.163594642837;5369.469701135158;5449.891002180014;5542;5566.666000040011;5591.630050637457;3855.4795102660783;3887;3899.5905429930585;4015.6586690131667;4216.367544868294;5732.3121225453215;5950.910736338872;5979.970100149471;5990.161377407079;6117.724702388314;5864.149698293638;5881.264841894763;5959.493443057216;5973.731182096729;5977.760889564543;5919.378465261086;5945.970270148621;5955.255593050869;5966.568023674374;5997.640141591519;5503.532199763065;5713.885722285614;5715.342735585295;5779.768809247583;5880.147378629989;5986.2463266895975;6011.87976240464;6039.849003774941;6055.666938318434;6055.878882422415;5708.771649133988;5845.298564172326;5879.764809407747;5894.587378883437;5909.763609455574 03:22:18 INFO - PROCESS | 10058 | |5;yui.html;713.9393151582116;715.1204019056562;764.4839733180102;784.9387389182189;853.5007020892778;14487.637809054779;16176.352945882165;16612.750808737877;16614.252358643877;16639.41762038329;15722.292496837641;16407.507774766775;16450.42423515177;16861.241244144014;16891.662166756658;828.7389472316231;830.9335253179731;832.9791755206138;834.9540775257359;836.1387770596265;686.8042607856762;805.7059173401725;817.7669364231195;818.3126174013827;826.3389288569151;854.7563944275882;855.6662901468433;855.84166929118;856.4261944497171;856.5331894117721;847.0682249525535;853.3258725606763;854.9444286121413;855.2174760094537;855.8331125430512;621.8631900981777;621.878733646939;622.2657264427974;622.3776223776224;622.9283632382288;14102.858971410256;14142.717145657132;14157.787633185408;14159.292035398188;14180.716385672229;14468.421263149461;14740.926295368561;14872.107673539515;15145.469908553148;15175.468858590008;11096.389698566576;11155.163362747746;11293.491792869258;11349.319040857576;11414.885851141466;3752.3245815753153;3767.3407153747985;3796.6772824309965;3837.558297537698;3862.246861861938;71419.28580714179;75984.24015759827;76442.61778691127;76567;77074;11446.313221206754;11566.833580551773;11747.88252117485;11759.706007349885;11913.642590722293;20366;21041.263555775473;21188;21221.78778212229;21265.149394024374;8877.866831997526;8929.553522323858;8951.910480895107;8955.238804701543;8998;4523.592876641118;4656.767161641905;4661.627069834405;4719.528047195322;4862.124817532878;3703.8333275002688;3811.485449464287;3811.561670407883;3821.063839359319;3824.808759562011;568.4741614007027;659.5613916745407;667.9599224046475;672.1698702102899;673.3737624009718;636.7548493829817;664.7972368427676;755.1391413788285;774.767569729079;799.4723482501521;9645.228381729445;9887.80224395508;9908.306418550776;9946.825773273202;10141.949290253502;683.5147045597681;716.9390601798801;777.3081957058223;777.9533228006338;800.7077416742846;4581.931271030937;4900.2894580286375;4948.901021979612;4956.343346448525;5002.074616196015;104361.47819260856;110937;112796.43601782103;114003;114597;62184;81510.18489815026;92756;95402.7988180766;96384;85639;86064.56967715122;86496;87582.56208718916;87767.12232877589;9919.702408927744;10062.496875156066;10101.343412678152;10498.475076246004;10522.421266830397;37308.81345593255;44102;47974;50328.245076324616;51369.229461557356;74438.62780686062;75869;76116;76153.61923190349;77753.2224677746;12699.619011429671;12838.325738900998;12867;12985.350732463528;13338.3330833456;14133.6466588332;14230.501932432315;14267.043675738953;14305.284735763378;14588.927055364655;13862;13937.233452160228;14471.348789304297;14818.851811481747;14974.326155323255;13254.204747715168;13320.467181313026;13380.531681391105;13586.252756098114;13827.101238419471;12423.69909755108;13018.739625207632;13180.077394582288;13438.865611344152;13468.989825763303;11054.99018300083;11234.3259404436;11266.66200014001;11286;11512.30926144434;10467.900870408497;10605.946970265099;10688.571542225252;11187.944060279646;11341.432928353714 03:22:18 INFO - PROCESS | 10058 | __end_tp_report 03:22:18 INFO - PROCESS | 10058 | __start_cc_report 03:22:18 INFO - PROCESS | 10058 | _x_x_mozilla_cycle_collect,374 03:22:18 INFO - PROCESS | 10058 | __end_cc_report 03:22:18 INFO - PROCESS | 10058 | __startTimestamp1464949338359__endTimestamp 03:22:18 INFO - PROCESS | 10058 | 03:22:18 INFO - PROCESS | 10058 | ------- Summary: start ------- 03:22:18 INFO - PROCESS | 10058 | Number of tests: 6 03:22:18 INFO - PROCESS | 10058 | 03:22:18 INFO - PROCESS | 10058 | [#0] dojo.html Cycles:165 Average:5505.65 Median:5747.97 stddev:736.68 (12.8%) stddev-sans-first:714.93 03:22:18 INFO - PROCESS | 10058 | Values: 3127.5 3163.5 3188.5 3211.2 3220.8 5489.8 5562.9 5592.7 5593.8 5594.9 5420.9 5542.9 5550.9 5582.7 5608.4 5000.4 5051.2 5134.5 5177.6 5230.4 822.3 5008.0 5032.6 5133.2 5136.1 5051.8 5054.6 5077.4 5078.9 5083.3 5075.3 5083.6 5087.4 5088.1 5111.5 5019.1 5063.1 5069.2 5110.1 5114.6 5511.8 5522.1 5523.4 5573.7 5593.7 5808.2 5985.1 6037.3 6052.3 6056.8 5888.1 5941.9 5959.9 5998.0 6001.8 5568.0 5569.4 5587.4 5588.7 5594.7 5981.1 5992.3 6073.8 6112.4 6132.1 5784.9 5843.0 5857.9 5863.4 5897.6 5907.2 5910.9 5922.1 5927.4 5927.7 5671.9 5748.8 5769.7 5846.1 5870.7 5833.5 5844.7 5845.6 5850.2 5893.5 4415.8 4428.1 4451.0 4454.9 4473.9 3958.0 3986.6 4036.5 4037.6 4062.8 5623.0 5643.9 5687.4 5745.6 5766.5 6055.9 6088.0 6096.1 6100.7 6110.3 5586.1 5725.4 5754.1 5776.9 5812.5 5145.3 5156.9 5168.3 5176.9 5185.9 6011.3 6171.7 6200.3 6207.3 6211.3 5944.7 6022.9 6037.3 6039.3 6050.9 6184.9 6186.0 6190.6 6200.1 6218.9 5735.7 5815.8 5931.2 5936.0 5978.2 5946.5 6012.0 6026.5 6032.9 6089.8 5826.6 5868.3 5878.0 5888.3 5914.4 5591.5 5696.4 5748.0 5858.6 5876.5 5667.9 5703.1 5716.8 5726.3 5756.0 5807.5 5828.7 5831.5 5840.8 5858.8 5599.4 5646.3 5700.7 5735.5 5757.4 03:22:18 INFO - PROCESS | 10058 | 03:22:18 INFO - PROCESS | 10058 | [#1] ext.html Cycles:180 Average:61626.59 Median:41090.88 stddev:128565.14 (312.9%) stddev-sans-first:128844.08 03:22:18 INFO - PROCESS | 10058 | Values: 573.7 625.5 629.5 639.0 648.1 39531.8 44507.1 44541.6 44573.3 44573.8 43993.6 44440.6 44521.6 44557.8 44565.8 8538.6 8639.9 8650.7 8697.8 8719.3 8595.1 8602.5 8631.7 8643.5 8655.0 8687.9 8728.4 8772.0 8775.6 8793.3 8661.0 8687.9 8725.3 8736.0 8740.6 8478.1 8537.3 8582.1 8583.6 8588.7 40322.4 40890.8 40968.4 40986.8 41157.8 3354.4 3546.2 3559.6 3608.1 3682.2 32916.5 32948.7 33408.8 33425.0 34112.0 4226.7 4374.6 4387.0 4456.6 4568.6 351006.0 351095.0 351660.0 351832.0 352612.0 31930.5 57374.0 57602.7 57765.0 57784.0 33963.2 35436.6 35492.5 35507.8 35813.6 15618.6 15735.7 15807.7 15829.8 15830.1 12610.9 12615.7 12658.3 12674.2 12684.6 8364.8 8415.8 8481.3 8526.8 8529.6 3188.6 3199.5 3246.0 3269.5 3277.6 1063.6 1069.5 1079.0 1121.9 1159.8 32449.5 32918.5 32993.3 33429.0 33537.2 1083.4 1085.4 1122.3 1149.3 1189.2 17311.4 17330.2 17339.5 17444.5 17489.7 598301.0 606894.0 608059.0 608468.0 610854.0 59594.4 59972.7 60004.1 60286.1 60514.4 1330.8 1359.8 1384.9 1394.1 1395.6 31302.2 32021.4 32337.2 32553.3 32859.3 51027.0 51081.5 51401.0 51414.2 51434.2 450996.0 453502.0 453725.0 454179.0 457620.0 27915.6 28193.4 28432.0 28434.3 28450.9 44406.8 45471.3 45620.3 45949.8 49126.5 40079.8 40787.4 42158.6 42283.4 42477.4 40852.0 41012.2 41024.0 41392.0 42246.0 41917.4 41921.4 42487.4 42700.0 44504.6 32979.0 37430.8 38022.2 39985.0 40312.2 28556.6 29162.1 29298.7 29382.4 29465.0 03:22:18 INFO - PROCESS | 10058 | 03:22:18 INFO - PROCESS | 10058 | [#2] jquery.html Cycles:180 Average:28320.45 Median:1375.28 stddev:79389.22 (5772.6%) stddev-sans-first:79584.21 03:22:18 INFO - PROCESS | 10058 | Values: 383.2 388.3 389.9 390.1 402.3 13819.6 18137.9 18761.7 19993.4 20004.4 18272.8 18870.7 18928.1 19023.4 19153.2 5483.3 5485.7 5603.6 5643.3 5748.5 5368.0 5627.5 5658.9 5685.0 5711.2 5686.1 5698.8 5709.4 5709.5 5738.0 5415.7 5708.2 5756.4 5764.1 5765.9 5458.7 5502.8 5677.5 5732.1 5735.5 13365.8 13542.3 13631.7 19733.2 22471.0 2172.4 2191.4 2269.8 2360.0 2367.4 9877.7 10125.9 10180.3 11215.0 14310.1 1883.8 1915.5 1921.8 1962.3 2004.2 53742.5 57671.0 81678.6 82314.2 82636.6 10829.5 11062.4 11138.0 11155.7 11247.5 15264.4 15346.3 15402.2 15410.0 15414.5 8188.8 8262.0 8328.1 8360.2 8428.2 7906.5 7955.9 7989.8 8063.2 8168.8 4750.5 4808.8 4814.5 4818.8 4836.3 1930.0 1957.8 1959.3 1983.8 1993.8 926.1 990.2 1056.5 1062.5 1072.0 15593.8 18717.6 19083.1 19516.0 19655.7 949.2 955.1 1006.2 1009.6 1016.2 10430.9 10859.8 10924.9 10934.6 10982.0 472878.0 479277.0 480417.0 487246.0 488851.0 90727.0 91286.0 92869.5 93165.0 93734.5 965.5 984.4 997.2 997.9 1004.0 17227.4 17257.7 17278.7 17606.9 17808.9 41489.8 41533.0 42141.6 42188.8 43695.8 56421.4 57860.8 58492.0 58548.4 58876.4 7609.7 7974.9 8417.6 8645.3 8749.8 12907.9 13228.9 13462.3 13560.1 13751.3 10725.3 11575.8 11725.5 11824.5 12055.3 10926.1 11491.0 11579.5 11875.0 11879.8 11514.6 11693.4 11863.8 12085.5 12200.6 7533.4 7953.2 8713.6 8728.1 8884.9 11278.5 11723.1 11729.0 11759.8 12172.2 03:22:18 INFO - PROCESS | 10058 | 03:22:18 INFO - PROCESS | 10058 | [#3] mootools.html Cycles:180 Average:5851.24 Median:2747.45 stddev:3296.50 (120.0%) stddev-sans-first:3289.31 03:22:18 INFO - PROCESS | 10058 | Values: 1471.9 1501.8 1638.6 1759.5 1776.0 8057.5 8547.5 8572.4 9171.0 9178.3 8625.4 8860.2 8883.8 8892.3 8930.7 2362.1 2413.0 2420.6 2424.3 2428.6 2388.8 2403.6 2443.9 2447.2 2448.1 2360.6 2395.5 2416.3 2421.8 2435.0 2328.8 2333.9 2347.6 2348.8 2390.5 2325.0 2327.0 2336.2 2336.3 2362.9 8779.6 8817.6 8873.1 8934.3 8951.3 5344.4 5452.8 5458.0 5462.0 5470.3 3429.7 3437.2 3497.1 3507.6 3557.3 1165.9 1174.5 1182.6 1196.9 2034.6 12209.5 12550.4 12571.9 12587.6 12670.9 4604.0 4690.2 4745.5 4780.9 4792.5 9807.9 9858.9 9874.3 9885.4 9912.0 5397.6 5430.8 5435.0 5452.3 5454.6 4476.4 4878.8 5002.2 5021.1 5033.3 3894.2 3914.1 3969.4 3991.6 4041.4 1174.8 1188.6 1188.8 1193.7 1199.3 862.4 898.6 964.4 976.8 989.5 5959.1 5963.9 6015.5 6076.7 6132.7 475.1 480.4 482.4 489.0 492.7 4079.7 4108.4 4127.6 4149.4 4202.3 10382.4 10735.6 10838.9 10843.2 10857.1 10527.3 10537.8 10604.4 10627.7 10643.8 8081.9 8094.2 8196.2 8198.1 8199.8 5952.4 5963.4 5994.7 6024.1 6104.9 10042.2 10096.8 10130.5 10169.0 10177.8 9880.8 10501.9 10582.4 10727.0 10860.2 7260.1 7577.9 7790.1 7978.2 8172.6 8718.7 8757.2 8819.6 8888.1 8951.7 7897.9 7944.6 7955.8 7956.2 8025.7 7343.3 7654.8 7737.1 7773.1 7788.6 7040.3 7174.6 7238.8 7245.5 7298.2 5282.0 5318.0 5336.6 5387.4 5423.1 5300.9 5305.3 5345.1 5442.2 5470.7 03:22:18 INFO - PROCESS | 10058 | 03:22:18 INFO - PROCESS | 10058 | [#4] prototype.html Cycles:180 Average:4745.03 Median:5317.63 stddev:1381.16 (26.0%) stddev-sans-first:1344.47 03:22:18 INFO - PROCESS | 10058 | Values: 317.6 321.6 336.3 339.9 345.9 5568.6 5630.9 5651.4 5662.5 5668.2 5546.4 5554.7 5562.5 5570.4 5584.0 4170.7 4253.3 4374.1 4374.3 4379.5 4354.2 4359.2 4360.2 4368.6 4370.5 4308.9 4329.9 4332.4 4349.1 4376.1 4288.4 4314.2 4322.2 4334.4 4351.2 3830.0 3844.6 3852.2 3864.6 3875.4 5379.2 5383.0 5426.4 5430.9 5475.5 4830.0 4961.0 4981.8 4982.2 5065.3 5762.7 5763.5 5795.1 5796.3 5803.3 4199.5 4229.4 4241.6 4248.6 4251.1 5655.0 5993.2 6085.5 6087.9 6104.7 4205.3 4226.3 4231.3 4246.6 4264.5 4249.8 4253.9 4261.0 4265.8 4267.2 4730.2 4840.5 4897.5 4919.6 4944.2 5780.9 5809.9 5828.4 5853.7 5879.9 1449.3 1474.7 1475.7 1483.4 1489.0 890.8 913.5 916.6 932.2 954.5 4948.8 4949.9 5080.7 5093.4 5154.5 5280.8 5305.6 5310.5 5324.7 5401.8 4786.0 4950.4 5051.7 5116.5 5118.7 2873.9 2886.7 2900.4 2915.5 2921.2 5299.6 5372.7 5512.4 5535.8 5567.9 5266.4 5304.7 5409.7 5436.3 5459.2 5464.3 5479.9 5502.7 5519.8 5580.9 5125.4 5235.7 5298.9 5325.5 5407.9 5212.0 5244.9 5350.9 5369.7 5396.2 5369.5 5449.9 5542.0 5566.7 5591.6 3855.5 3887.0 3899.6 4015.7 4216.4 5732.3 5950.9 5980.0 5990.2 6117.7 5864.1 5881.3 5959.5 5973.7 5977.8 5919.4 5946.0 5955.3 5966.6 5997.6 5503.5 5713.9 5715.3 5779.8 5880.1 5986.2 6011.9 6039.8 6055.7 6055.9 5708.8 5845.3 5879.8 5894.6 5909.8 03:22:18 INFO - PROCESS | 10058 | 03:22:18 INFO - PROCESS | 10058 | [#5] yui.html Cycles:180 Average:20291.47 Median:23982.12 stddev:28686.76 (119.6%) stddev-sans-first:28729.56 03:22:18 INFO - PROCESS | 10058 | Values: 713.9 715.1 764.5 784.9 853.5 14487.6 16176.4 16612.8 16614.3 16639.4 15722.3 16407.5 16450.4 16861.2 16891.7 828.7 830.9 833.0 835.0 836.1 686.8 805.7 817.8 818.3 826.3 854.8 855.7 855.8 856.4 856.5 847.1 853.3 854.9 855.2 855.8 621.9 621.9 622.3 622.4 622.9 14102.9 14142.7 14157.8 14159.3 14180.7 14468.4 14740.9 14872.1 15145.5 15175.5 11096.4 11155.2 11293.5 11349.3 11414.9 3752.3 3767.3 3796.7 3837.6 3862.2 71419.3 75984.2 76442.6 76567.0 77074.0 11446.3 11566.8 11747.9 11759.7 11913.6 20366.0 21041.3 21188.0 21221.8 21265.1 8877.9 8929.6 8951.9 8955.2 8998.0 4523.6 4656.8 4661.6 4719.5 4862.1 3703.8 3811.5 3811.6 3821.1 3824.8 568.5 659.6 668.0 672.2 673.4 636.8 664.8 755.1 774.8 799.5 9645.2 9887.8 9908.3 9946.8 10141.9 683.5 716.9 777.3 778.0 800.7 4581.9 4900.3 4948.9 4956.3 5002.1 104361.5 110937.0 112796.4 114003.0 114597.0 62184.0 81510.2 92756.0 95402.8 96384.0 85639.0 86064.6 86496.0 87582.6 87767.1 9919.7 10062.5 10101.3 10498.5 10522.4 37308.8 44102.0 47974.0 50328.2 51369.2 74438.6 75869.0 76116.0 76153.6 77753.2 12699.6 12838.3 12867.0 12985.4 13338.3 14133.6 14230.5 14267.0 14305.3 14588.9 13862.0 13937.2 14471.3 14818.9 14974.3 13254.2 13320.5 13380.5 13586.3 13827.1 12423.7 13018.7 13180.1 13438.9 13469.0 11055.0 11234.3 11266.7 11286.0 11512.3 10467.9 10605.9 10688.6 11187.9 11341.4 03:22:18 INFO - PROCESS | 10058 | -------- Summary: end -------- 03:22:18 INFO - PROCESS | 10058 | 03:22:19 INFO - TEST-INFO | 10058: exit 0 03:22:19 INFO - TEST-OK | dromaeo_css | took 1111186ms 03:22:19 INFO - TEST-START | kraken 03:22:19 INFO - operating with platform_type : linux_ 03:22:19 INFO - Initialising browser for kraken test... 03:22:19 INFO - TEST-INFO | started process 10295 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDEkUHz/profile http://localhost:54651/getInfo.html) 03:22:24 INFO - PROCESS | 10295 | __metrics Screen width/height:1600/1200 03:22:24 INFO - PROCESS | 10295 | colorDepth:24 03:22:24 INFO - PROCESS | 10295 | Browser inner width/height: 1024/697 03:22:24 INFO - PROCESS | 10295 | __metrics 03:22:25 ERROR - PROCESS | 10295 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 03:22:26 INFO - TEST-INFO | 10295: exit 0 03:22:26 INFO - Browser initialized. 03:22:26 INFO - Running cycle 1/1 for kraken test... 03:22:26 INFO - TEST-INFO | started process 10416 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDEkUHz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:22:38 INFO - PROCESS | 10416 | RSS: Main: 167522304 03:22:38 INFO - PROCESS | 10416 | 03:22:40 INFO - PROCESS | 10416 | Cycle 1(1): loaded http://localhost:54651/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54651/tests/kraken/driver.html?testName=audio-beat-detection) 03:22:41 INFO - PROCESS | 10416 | RSS: Main: 172355584 03:22:41 INFO - PROCESS | 10416 | 03:22:44 INFO - PROCESS | 10416 | Cycle 1(1): loaded http://localhost:54651/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54651/tests/kraken/driver.html?testName=audio-dft) 03:22:44 INFO - PROCESS | 10416 | RSS: Main: 171454464 03:22:44 INFO - PROCESS | 10416 | 03:22:47 INFO - PROCESS | 10416 | Cycle 1(1): loaded http://localhost:54651/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54651/tests/kraken/driver.html?testName=audio-fft) 03:22:48 INFO - PROCESS | 10416 | RSS: Main: 166592512 03:22:48 INFO - PROCESS | 10416 | 03:22:50 INFO - PROCESS | 10416 | Cycle 1(1): loaded http://localhost:54651/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54651/tests/kraken/driver.html?testName=audio-oscillator) 03:22:51 INFO - PROCESS | 10416 | RSS: Main: 167292928 03:22:51 INFO - PROCESS | 10416 | 03:22:53 INFO - PROCESS | 10416 | Cycle 1(1): loaded http://localhost:54651/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54651/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:22:54 INFO - PROCESS | 10416 | RSS: Main: 167739392 03:22:54 INFO - PROCESS | 10416 | 03:22:57 INFO - PROCESS | 10416 | Cycle 1(1): loaded http://localhost:54651/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54651/tests/kraken/driver.html?testName=imaging-darkroom) 03:22:57 INFO - PROCESS | 10416 | RSS: Main: 167997440 03:22:57 INFO - PROCESS | 10416 | 03:23:01 INFO - PROCESS | 10416 | Cycle 1(1): loaded http://localhost:54651/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54651/tests/kraken/driver.html?testName=imaging-desaturate) 03:23:01 INFO - PROCESS | 10416 | RSS: Main: 165527552 03:23:01 INFO - PROCESS | 10416 | 03:23:04 INFO - PROCESS | 10416 | Cycle 1(1): loaded http://localhost:54651/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54651/tests/kraken/driver.html?testName=json-parse-financial) 03:23:05 INFO - PROCESS | 10416 | RSS: Main: 166903808 03:23:05 INFO - PROCESS | 10416 | 03:23:06 INFO - PROCESS | 10416 | Cycle 1(1): loaded http://localhost:54651/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54651/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:23:07 INFO - PROCESS | 10416 | RSS: Main: 167276544 03:23:07 INFO - PROCESS | 10416 | 03:23:09 INFO - PROCESS | 10416 | Cycle 1(1): loaded http://localhost:54651/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54651/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:23:09 INFO - PROCESS | 10416 | RSS: Main: 167157760 03:23:09 INFO - PROCESS | 10416 | 03:23:12 INFO - PROCESS | 10416 | Cycle 1(1): loaded http://localhost:54651/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54651/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:23:12 INFO - PROCESS | 10416 | RSS: Main: 167976960 03:23:12 INFO - PROCESS | 10416 | 03:23:15 INFO - PROCESS | 10416 | Cycle 1(1): loaded http://localhost:54651/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54651/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:23:15 INFO - PROCESS | 10416 | RSS: Main: 167841792 03:23:15 INFO - PROCESS | 10416 | 03:23:18 INFO - PROCESS | 10416 | Cycle 1(1): loaded http://localhost:54651/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54651/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:23:19 INFO - PROCESS | 10416 | RSS: Main: 167923712 03:23:19 INFO - PROCESS | 10416 | 03:23:21 INFO - PROCESS | 10416 | Cycle 1(1): loaded http://localhost:54651/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54651/tests/kraken/driver.html?testName=ai-astar) 03:23:21 INFO - PROCESS | 10416 | RSS: Main: 168431616 03:23:21 INFO - PROCESS | 10416 | 03:23:21 INFO - PROCESS | 10416 | __start_tp_report 03:23:21 INFO - PROCESS | 10416 | _x_x_mozilla_page_load 03:23:21 INFO - PROCESS | 10416 | _x_x_mozilla_page_load_details 03:23:21 INFO - PROCESS | 10416 | |i|pagename|runs| 03:23:21 INFO - PROCESS | 10416 | |0;ai-astar;110;108;112;110;112;113;110;111;111;110 03:23:21 INFO - PROCESS | 10416 | |1;audio-beat-detection;157;129;156;182;141;156;164;132;182;127 03:23:21 INFO - PROCESS | 10416 | |2;audio-dft;160;162;163;173;165;169;176;163;163;163 03:23:21 INFO - PROCESS | 10416 | |3;audio-fft;75;77;76;159;76;76;76;76;155;76 03:23:21 INFO - PROCESS | 10416 | |4;audio-oscillator;83;84;139;85;85;83;138;86;84;166 03:23:21 INFO - PROCESS | 10416 | |5;imaging-gaussian-blur;117;118;118;118;117;118;117;117;118;117 03:23:21 INFO - PROCESS | 10416 | |6;imaging-darkroom;147;147;147;148;150;147;148;148;147;146 03:23:21 INFO - PROCESS | 10416 | |7;imaging-desaturate;96;95;95;96;95;95;96;97;96;96 03:23:21 INFO - PROCESS | 10416 | |8;json-parse-financial;56;55;53;57;54;52;58;53;54;54 03:23:21 INFO - PROCESS | 10416 | |9;json-stringify-tinderbox;61;62;60;60;61;60;62;64;60;61 03:23:21 INFO - PROCESS | 10416 | |10;stanford-crypto-aes;80;80;80;80;83;80;82;86;109;80 03:23:21 INFO - PROCESS | 10416 | |11;stanford-crypto-ccm;127;129;130;121;119;125;130;124;126;127 03:23:21 INFO - PROCESS | 10416 | |12;stanford-crypto-pbkdf2;162;162;163;168;168;168;164;166;162;164 03:23:21 INFO - PROCESS | 10416 | |13;stanford-crypto-sha256-iterative;64;64;64;67;63;62;64;61;64;62 03:23:21 INFO - PROCESS | 10416 | __end_tp_report 03:23:21 INFO - PROCESS | 10416 | __start_cc_report 03:23:21 INFO - PROCESS | 10416 | _x_x_mozilla_cycle_collect,879 03:23:21 INFO - PROCESS | 10416 | __end_cc_report 03:23:21 INFO - PROCESS | 10416 | __startTimestamp1464949401268__endTimestamp 03:23:21 INFO - PROCESS | 10416 | 03:23:21 INFO - PROCESS | 10416 | ------- Summary: start ------- 03:23:21 INFO - PROCESS | 10416 | Number of tests: 14 03:23:21 INFO - PROCESS | 10416 | 03:23:21 INFO - PROCESS | 10416 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.00 stddev:1.42 (1.3%) stddev-sans-first:1.48 03:23:21 INFO - PROCESS | 10416 | Values: 110.0 108.0 112.0 110.0 112.0 113.0 110.0 111.0 111.0 110.0 03:23:21 INFO - PROCESS | 10416 | 03:23:21 INFO - PROCESS | 10416 | [#1] audio-beat-detection Cycles:10 Average:152.60 Median:156.50 stddev:20.20 (12.9%) stddev-sans-first:21.36 03:23:21 INFO - PROCESS | 10416 | Values: 157.0 129.0 156.0 182.0 141.0 156.0 164.0 132.0 182.0 127.0 03:23:21 INFO - PROCESS | 10416 | 03:23:21 INFO - PROCESS | 10416 | [#2] audio-dft Cycles:10 Average:165.70 Median:164.00 stddev:5.23 (3.2%) stddev-sans-first:5.12 03:23:21 INFO - PROCESS | 10416 | Values: 160.0 162.0 163.0 173.0 165.0 169.0 176.0 163.0 163.0 163.0 03:23:21 INFO - PROCESS | 10416 | 03:23:21 INFO - PROCESS | 10416 | [#3] audio-fft Cycles:10 Average:92.20 Median:76.00 stddev:34.17 (45.0%) stddev-sans-first:35.67 03:23:21 INFO - PROCESS | 10416 | Values: 75.0 77.0 76.0 159.0 76.0 76.0 76.0 76.0 155.0 76.0 03:23:21 INFO - PROCESS | 10416 | 03:23:21 INFO - PROCESS | 10416 | [#4] audio-oscillator Cycles:10 Average:103.30 Median:84.00 stddev:31.53 (37.5%) stddev-sans-first:32.58 03:23:21 INFO - PROCESS | 10416 | Values: 83.0 84.0 139.0 85.0 85.0 83.0 138.0 86.0 84.0 166.0 03:23:21 INFO - PROCESS | 10416 | 03:23:21 INFO - PROCESS | 10416 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 03:23:21 INFO - PROCESS | 10416 | Values: 117.0 118.0 118.0 118.0 117.0 118.0 117.0 117.0 118.0 117.0 03:23:21 INFO - PROCESS | 10416 | 03:23:21 INFO - PROCESS | 10416 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.50 stddev:1.08 (0.7%) stddev-sans-first:1.13 03:23:21 INFO - PROCESS | 10416 | Values: 147.0 147.0 147.0 148.0 150.0 147.0 148.0 148.0 147.0 146.0 03:23:21 INFO - PROCESS | 10416 | 03:23:21 INFO - PROCESS | 10416 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 03:23:21 INFO - PROCESS | 10416 | Values: 96.0 95.0 95.0 96.0 95.0 95.0 96.0 97.0 96.0 96.0 03:23:21 INFO - PROCESS | 10416 | 03:23:21 INFO - PROCESS | 10416 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:54.50 stddev:1.90 (3.5%) stddev-sans-first:1.94 03:23:21 INFO - PROCESS | 10416 | Values: 56.0 55.0 53.0 57.0 54.0 52.0 58.0 53.0 54.0 54.0 03:23:21 INFO - PROCESS | 10416 | 03:23:21 INFO - PROCESS | 10416 | [#9] json-stringify-tinderbox Cycles:10 Average:61.10 Median:61.00 stddev:1.29 (2.1%) stddev-sans-first:1.36 03:23:21 INFO - PROCESS | 10416 | Values: 61.0 62.0 60.0 60.0 61.0 60.0 62.0 64.0 60.0 61.0 03:23:21 INFO - PROCESS | 10416 | 03:23:21 INFO - PROCESS | 10416 | [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:80.00 stddev:9.01 (11.3%) stddev-sans-first:9.44 03:23:21 INFO - PROCESS | 10416 | Values: 80.0 80.0 80.0 80.0 83.0 80.0 82.0 86.0 109.0 80.0 03:23:21 INFO - PROCESS | 10416 | 03:23:21 INFO - PROCESS | 10416 | [#11] stanford-crypto-ccm Cycles:10 Average:125.80 Median:127.00 stddev:3.68 (2.9%) stddev-sans-first:3.87 03:23:21 INFO - PROCESS | 10416 | Values: 127.0 129.0 130.0 121.0 119.0 125.0 130.0 124.0 126.0 127.0 03:23:21 INFO - PROCESS | 10416 | 03:23:21 INFO - PROCESS | 10416 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.70 Median:165.00 stddev:2.58 (1.6%) stddev-sans-first:2.55 03:23:21 INFO - PROCESS | 10416 | Values: 162.0 162.0 163.0 168.0 168.0 168.0 164.0 166.0 162.0 164.0 03:23:21 INFO - PROCESS | 10416 | 03:23:21 INFO - PROCESS | 10416 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.50 Median:64.00 stddev:1.65 (2.6%) stddev-sans-first:1.74 03:23:21 INFO - PROCESS | 10416 | Values: 64.0 64.0 64.0 67.0 63.0 62.0 64.0 61.0 64.0 62.0 03:23:21 INFO - PROCESS | 10416 | -------- Summary: end -------- 03:23:21 INFO - PROCESS | 10416 | 03:23:22 INFO - TEST-INFO | 10416: exit 0 03:23:22 INFO - TEST-OK | kraken | took 63138ms 03:23:22 INFO - SUITE-END | took 1174s 03:23:22 INFO - Completed test suite (00:19:34) 03:23:22 INFO - javascript benchmark 03:23:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7230.52237103084, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3127.5152351385536, 3163.5254711793214, 3188.5376620390043, 3211.181148807054, 3220.7906486078405, 5489.807856725015, 5562.916556251655, 5592.692401917893, 5593.804216852401, 5594.916076258859, 5420.945790542093, 5542.889142217154, 5550.888982220353, 5582.748776305066, 5608.383077861432, 5000.449950505451, 5051.242313652945, 5134.512221338986, 5177.637565370425, 5230.372355317368, 822.302790541682, 5008.048470790556, 5032.597392208614, 5133.1786914093755, 5136.126858434057, 5051.848444546669, 5054.570361519275, 5077.390713114413, 5078.949210507884, 5083.288339632454, 5075.264086707443, 5083.6441449098575, 5087.440381558025, 5088.109580823379, 5111.463296353903, 5019.071471777696, 5063.088644044071, 5069.163588007974, 5110.054639891632, 5114.616403769732, 5511.807086751985, 5522.088855338904, 5523.364813046511, 5573.721313934287, 5593.664380137164, 5808.2449281593545, 5985.132155837423, 6037.30570984338, 6052.334243233241, 6056.788012419544, 5888.116782482619, 5941.940580594225, 5959.851003724898, 5997.970010149921, 6001.789937352171, 5568.0, 5569.359523654791, 5587.357453892813, 5588.692621905793, 5594.748236329334, 5981.132735753292, 5992.31088424828, 6073.757049717962, 6112.388761123852, 6132.141500189977, 5784.855378615568, 5842.970785146047, 5857.853553661107, 5863.355030946593, 5897.64614123154, 5907.232059832194, 5910.8817823643285, 5922.082077278029, 5927.3776253493625, 5927.73325200367, 5671.886562268732, 5748.798792042258, 5769.740361683735, 5846.093855452412, 5870.706464676749, 5833.4749872511675, 5844.707764611752, 5845.620034697731, 5850.210221620112, 5893.526618345413, 4415.845445409395, 4428.070105277863, 4450.955490445119, 4454.888627784267, 4473.888152796206, 3958.0, 3986.6013398660484, 4036.535798383165, 4037.6164264394833, 4062.756234625932, 5622.971885140548, 5643.887122257532, 5687.374388817227, 5745.597808153389, 5766.538676905838, 6055.939440605625, 6087.969560152171, 6096.055111457731, 6100.72546735398, 6110.297315808739, 5586.13414920688, 5725.3988331225455, 5754.0505816540635, 5776.855578610568, 5812.476877081083, 5145.279660847485, 5156.948430515722, 5168.302279192336, 5176.8964620707375, 5185.896282074337, 6011.27864656244, 6171.722272497748, 6200.348963358782, 6207.34822843604, 6211.2857021443115, 5944.6730429826775, 6022.879542409215, 6037.27552693662, 6039.305479869871, 6050.9394906050375, 6184.907226391518, 6185.969070154621, 6190.597611155261, 6200.0699895016105, 6218.906716399167, 5735.655860648374, 5815.82552523425, 5931.1992880960515, 5935.970320148372, 5978.222831031938, 5946.494547963472, 6012.038073908154, 6026.457618814327, 6032.939670603238, 6089.756409743738, 5826.621269617462, 5868.3251426086545, 5878.0, 5888.3228428731245, 5914.378990205966, 5591.4688104629995, 5696.373398926197, 5747.971260143672, 5858.560607954335, 5876.471117599436, 5667.943320566742, 5703.08750599902, 5716.771329146787, 5726.284214473191, 5755.971220143872, 5807.477327040587, 5828.679422631626, 5831.533477321889, 5840.824775256579, 5858.765649373977, 5599.412061733459, 5646.322441306905, 5700.657960522382, 5735.512481438957, 5757.424257574209], "value": 5456.656819515495, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.7160105747655, 625.5246013030096, 629.483823264923, 639.0, 648.1185587600864, 39531.80234098829, 44507.109857802825, 44541.55458445415, 44573.33140002903, 44573.77713111438, 43993.560064399346, 44440.55559444405, 44521.55478445214, 44557.77721111398, 44565.777171114096, 8538.573071346438, 8639.913600864005, 8650.697225597105, 8697.7825554361, 8719.346049046315, 8595.140485951417, 8602.526861022672, 8631.6978905738, 8643.524606146659, 8655.0, 8687.913120868805, 8728.389012769108, 8772.0, 8775.605097770616, 8793.340499462534, 8661.003984541763, 8687.869681954775, 8725.258353039999, 8736.039035706068, 8740.562971851446, 8478.06741258461, 8537.317014638815, 8582.055973842873, 8583.570821458901, 8588.742337729878, 40322.395164072565, 40890.795546022375, 40968.38547421791, 40986.79506602478, 41157.79421102905, 3354.3962086824363, 3546.1666508370513, 3559.60844307126, 3608.0979755061235, 3682.171511409938, 32916.518756655765, 32948.67051329504, 33408.83295583507, 33425.0, 34112.0, 4226.682998775104, 4374.58441448062, 4386.978065109654, 4456.5766252205985, 4568.588827005586, 351006.0, 351095.0, 351660.0, 351832.0, 352612.0, 31930.521042184388, 57374.0, 57602.71198644064, 57765.0, 57784.0, 33963.15092122717, 35436.64563354333, 35492.46761298583, 35507.82246088753, 35813.567457301935, 15618.609534761494, 15735.68528629421, 15807.68384632324, 15829.841701583067, 15830.050196988217, 12610.873891261153, 12615.684607884692, 12658.303793291274, 12674.176178548365, 12684.619461416172, 8364.790880227922, 8415.831683366298, 8481.321494280442, 8526.78683032929, 8529.616167272488, 3188.5970173124215, 3199.5360672702795, 3245.9675403245665, 3269.525918741769, 3277.5903012123485, 1063.611781699674, 1069.5294070608907, 1078.9568417263222, 1121.8541589593465, 1159.7796418680423, 32449.513257301158, 32918.506222406686, 32993.34013319768, 33429.0, 33537.16157096092, 1083.4366129612558, 1085.4138765066934, 1122.315387613555, 1149.2874417860812, 1189.191349882071, 17311.3941012064, 17330.220140093727, 17339.47981560555, 17444.47666570005, 17489.7376539352, 598301.0, 606894.0, 608059.0, 608468.0, 610854.0, 59594.404055959756, 59972.700136499036, 60004.099938500956, 60286.095708564404, 60514.39485605087, 1330.8269924909894, 1359.789232668938, 1384.9376778045012, 1394.1495687630538, 1395.5603984744773, 31302.217444564067, 32021.35957280888, 32337.191570210933, 32553.348933020734, 32859.34281314408, 51027.0, 51081.489185107675, 51401.0, 51414.22878656748, 51434.228486571985, 450996.0, 453502.0, 453725.0, 454179.0, 457620.0, 27915.581266280617, 28193.43613127767, 28432.0, 28434.289142771595, 28450.85774571114, 44406.77796610996, 45471.31793023174, 45620.315695265264, 45949.770251149865, 49126.50873491362, 40079.79960100181, 40787.38818917659, 42158.578414215466, 42283.3657495144, 42477.362839556816, 40852.0, 41012.179756405305, 41023.97440063903, 41392.0, 42246.0, 41917.37123943205, 41921.37117943172, 42487.362689559064, 42700.0, 44504.55495445004, 32979.0, 37430.812845935594, 38022.23955520819, 39985.0, 40312.19375612413, 28556.57165142566, 29162.125136245948, 29298.707012929597, 29382.412351752417, 29465.0], "value": 19076.182278154563, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.19146600672593, 388.3398223020864, 389.88108626868814, 390.1132492940114, 402.3220872829283, 13819.585412437618, 18137.909310453444, 18761.7185742214, 19993.400197994066, 20004.399868003966, 18272.817271827276, 18870.716939245922, 18928.053597320115, 19023.429297121074, 19153.233870645192, 5483.259759932418, 5485.725713714318, 5603.60774745768, 5643.266375371217, 5748.511376533, 5368.0, 5627.465390787868, 5658.886822263552, 5685.033544297458, 5711.171880077386, 5686.147077938322, 5698.8290351289525, 5709.4290570942985, 5709.514691251248, 5738.0, 5415.675059496423, 5708.200851880719, 5756.366799652035, 5764.106563482667, 5765.855853603673, 5458.6724796512335, 5502.779888804443, 5677.489025987681, 5732.0542110551705, 5735.541156707453, 13365.799513007312, 13542.322883855768, 13631.727365452734, 19733.21067157312, 22471.0, 2172.3700126963163, 2191.3973657244387, 2269.773022697717, 2359.988200059006, 2367.3726462487452, 9877.703668889873, 10125.949370253174, 10180.338278011906, 11215.0, 14310.069845460011, 1883.7551118354663, 1915.5019694879293, 1921.7693876734882, 1962.3328068456792, 2004.2183548416128, 53742.462575374135, 57671.0, 81678.59160704158, 82314.17685823125, 82636.58681706613, 10829.512671929624, 11062.446877656084, 11138.0, 11155.665330040112, 11247.493862776195, 15264.3894244229, 15346.309416076303, 15402.229888505753, 15410.0, 15414.537563873102, 8188.7952801180445, 8262.0, 8328.08391076981, 8360.163983601713, 8428.199321064489, 7906.52560846351, 7955.880661790078, 7989.8402031960195, 8063.19368063189, 8168.7957801055445, 4750.477447480775, 4808.807647694053, 4814.470408255089, 4818.807247710052, 4836.347093142451, 1929.9903500482408, 1957.7748558915907, 1959.3436198873537, 1983.7917018713115, 1993.7707163676073, 926.124383788341, 990.2276224544867, 1056.4717641179411, 1062.5112448273726, 1072.0244577434653, 15593.844061559466, 18717.625647486973, 19083.141258643394, 19516.0, 19655.705164422547, 949.1837020162654, 955.1165172215673, 1006.200070943587, 1009.6163457885956, 1016.1667432705111, 10430.895691042992, 10859.83710244347, 10924.890751092546, 10934.56261749521, 10982.0, 472878.0, 479277.0, 480417.0, 487246.0, 488851.0, 90727.0, 91286.0, 92869.53565232265, 93165.0, 93734.53132734292, 965.478641533564, 984.4044353166231, 997.1773287038078, 997.850322451638, 1003.9849402258972, 17227.3970411035, 17257.70788303406, 17278.740818887978, 17606.91196544009, 17808.91095544566, 41489.792551037055, 41533.0, 42141.57858421376, 42188.78905605575, 43695.78152109219, 56421.43578564326, 57860.79144555032, 58492.0, 58548.414515856, 58876.41123588709, 7609.733659321897, 7974.920250797418, 8417.579121044046, 8645.308375329832, 8749.781255468664, 12907.870921290667, 13228.867711322764, 13462.326883655582, 13560.11859229147, 13751.312434378042, 10725.302855314692, 11575.76848463043, 11725.472353743931, 11824.467898944396, 12055.336956467478, 10926.125909927347, 11491.0, 11579.478923448296, 11874.981253186806, 11879.76240475203, 11514.596989105341, 11693.356865372487, 11863.822042669539, 12085.516579336729, 12200.572979945659, 7533.359664428585, 7953.204679532, 8713.562262226662, 8728.127187281221, 8884.911150888667, 11278.492467838803, 11723.120765942758, 11729.0, 11759.76480470403, 12172.208806427554], "value": 9083.84578043945, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1471.919044452555, 1501.7672260799577, 1638.598543356877, 1759.472158352494, 1775.9644807103866, 8057.516549007064, 8547.529885856284, 8572.399932004762, 9171.0, 9178.311626627996, 8625.439346442477, 8860.158284962934, 8883.777905552364, 8892.333075019384, 8930.732078037652, 2362.11420717231, 2413.046846495633, 2420.576399130154, 2424.284835973392, 2428.5871401861727, 2388.8088952883813, 2403.591389463795, 2443.926682199537, 2447.1801946347996, 2448.1431498975307, 2360.6104992676187, 2395.532871090138, 2416.2751174647624, 2421.806255499556, 2435.0, 2328.75548067453, 2333.9183128590416, 2347.5774360615083, 2348.823838212124, 2390.5099454611764, 2325.03511042917, 2327.0459111764267, 2336.2290444153386, 2336.2991102669303, 2362.9291121266388, 8779.604917778652, 8817.647294108228, 8873.112688731075, 8934.28525717941, 8951.283897288202, 5344.412114667383, 5452.781888724447, 5457.972710136463, 5461.972690136564, 5470.343558772973, 3429.725621950238, 3437.2438063625964, 3497.0557949353533, 3507.57909050913, 3557.3418917500344, 1165.8659254185793, 1174.4597485156837, 1182.6097387861985, 1196.9281843089354, 2034.5625690476618, 12209.511619535208, 12550.372481375894, 12571.874281257253, 12587.559435419807, 12670.936645316715, 4603.95396046042, 4690.155771961012, 4745.549172828576, 4780.904381912343, 4792.496787837296, 9807.852882206773, 9858.852117218248, 9874.259430542737, 9885.357451765756, 9912.0, 5397.649152805055, 5430.809921652803, 5434.994526012701, 5452.318460192476, 5454.59090568209, 4476.4180656514445, 4878.829240976549, 5002.249662550574, 5021.096202683552, 5033.320501732219, 3894.221155768801, 3914.0606254498716, 3969.4442778011103, 3991.5808840071954, 4041.373587094005, 1174.7767924094394, 1188.5780547905542, 1188.8216767484773, 1193.7254431480808, 1199.3283761093815, 862.4092496639822, 898.5552151684958, 964.4165280005636, 976.8166860479473, 989.5497548615363, 5959.135925290809, 5963.880722385528, 6015.488683461867, 6076.665783381868, 6132.6627035513475, 475.1352538380115, 480.4258910601797, 482.3753239554785, 488.9779959901813, 492.6576029659424, 4079.673626109904, 4108.383742438658, 4127.587241275908, 4149.37759336102, 4202.285611446062, 10382.377057376581, 10735.624253151258, 10838.891611083945, 10843.240973131962, 10857.131429485622, 10527.315724477885, 10537.789244215226, 10604.416757078281, 10627.681169564925, 10643.787124257471, 8081.878771818428, 8094.190580941859, 8196.221358970888, 8198.1391953844, 8199.754007379668, 5952.375000624872, 5963.373845746308, 5994.730237139252, 6024.0662697282, 6104.908426373697, 10042.246831487522, 10096.79806403853, 10130.493475326351, 10169.0, 10177.847332289874, 9880.752981175528, 10501.89498105009, 10582.417967011581, 10727.034566889017, 10860.185486088418, 7260.128784545888, 7577.886331704918, 7790.143084260613, 7978.242067003625, 8172.632231549475, 8718.694845680371, 8757.168069033687, 8819.647214111365, 8888.0667529911, 8951.73144805657, 7897.881531777143, 7944.6424910880305, 7955.801104972422, 7956.2441568050945, 8025.719099831478, 7343.265673432614, 7654.846903062019, 7737.0715514138665, 7773.1449540549365, 7788.571628560257, 7040.260772618802, 7174.556582251301, 7238.819029524304, 7245.529040612343, 7298.160711518243, 5281.973590132025, 5317.973410132925, 5336.626436149432, 5387.407385187705, 5423.105187643994, 5300.867478313073, 5305.31030965972, 5345.091334473072, 5442.23808666779, 5470.699111548903], "value": 4632.4812702686195, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.5950662904796, 321.55143574713276, 336.34748587739784, 339.8555613864107, 345.87721358917565, 5568.610197286192, 5630.887382252353, 5651.434856514352, 5662.5186859116975, 5668.206451096849, 5546.446994841441, 5554.666719996803, 5562.471565201299, 5570.415106413829, 5583.972080139593, 4170.666346692257, 4253.298205796055, 4374.147041326943, 4374.343848422746, 4379.540148284432, 4354.1944740223, 4359.171757366106, 4360.21516127097, 4368.563143685637, 4370.519242883281, 4308.913821723564, 4329.935050974238, 4332.393464914899, 4349.1301739652035, 4376.124775045004, 4288.442502474674, 4314.201872653569, 4322.157179350028, 4334.371516130175, 4351.216001439427, 3830.0, 3844.6347596978244, 3852.248811481762, 3864.613538646141, 3875.399313106473, 5379.246905433242, 5383.035192154835, 5426.403095659474, 5430.864228394283, 5475.479829416199, 4830.0, 4960.975195124001, 4981.800727970877, 4982.202847544412, 5065.316182315377, 5762.740676669518, 5763.538916886639, 5795.130730390433, 5796.304443466769, 5803.303603567599, 4199.5091742431305, 4229.36559516072, 4241.618254357092, 4248.638865696419, 4251.107267473834, 5654.9717251413895, 5993.160957465958, 6085.4523092921845, 6087.878242435127, 6104.725287362079, 4205.3481710334945, 4226.281532139544, 4231.259529582311, 4246.63903568194, 4264.466941632296, 4249.830006799755, 4253.8723838284905, 4260.957390426118, 4265.786710664454, 4267.210566045292, 4730.2431610942085, 4840.491748366441, 4897.461279259279, 4919.557239848431, 4944.159492886218, 5780.942190578125, 5809.9419005809405, 5828.388019258002, 5853.7365818538265, 5879.882402351929, 1449.3043339197034, 1474.7198032373815, 1475.7048590281986, 1483.4437086092714, 1489.0321291160833, 890.8485557455118, 913.5295322908707, 916.6470908700198, 932.2029664636774, 954.5418199264392, 4948.802047918043, 4949.9110195756875, 5080.720560369141, 5093.414257360377, 5154.5103215194495, 5280.841574752763, 5305.577902253025, 5310.522053015247, 5324.733763311819, 5401.838604700009, 4786.0, 4950.4059512858685, 5051.6716413433005, 5116.539511443913, 5118.667286626357, 2873.858975063549, 2886.7257610526967, 2900.4344152890408, 2915.492676298382, 2921.2258751430886, 5299.576033917355, 5372.7313634318125, 5512.4211957744665, 5535.750891209906, 5567.916481252784, 5266.3943646480375, 5304.681719096867, 5409.675419474844, 5436.266104075899, 5459.161236157176, 5464.316960379952, 5479.863003424866, 5502.724863756796, 5519.751611177507, 5580.9162862557905, 5125.359330083739, 5235.65968212065, 5298.860744939857, 5325.4940780625775, 5407.863893762021, 5211.983663185642, 5244.895102098013, 5350.892982140257, 5369.69103285591, 5396.163594642837, 5369.469701135158, 5449.891002180014, 5542.0, 5566.666000040011, 5591.630050637457, 3855.4795102660783, 3887.0, 3899.5905429930585, 4015.6586690131667, 4216.367544868294, 5732.3121225453215, 5950.910736338872, 5979.970100149471, 5990.161377407079, 6117.724702388314, 5864.149698293638, 5881.264841894763, 5959.493443057216, 5973.731182096729, 5977.760889564543, 5919.378465261086, 5945.970270148621, 5955.255593050869, 5966.568023674374, 5997.640141591519, 5503.532199763065, 5713.885722285614, 5715.342735585295, 5779.768809247583, 5880.147378629989, 5986.2463266895975, 6011.87976240464, 6039.849003774941, 6055.666938318434, 6055.878882422415, 5708.771649133988, 5845.298564172326, 5879.764809407747, 5894.587378883437, 5909.763609455574], "value": 4300.156531596334, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [713.9393151582116, 715.1204019056562, 764.4839733180102, 784.9387389182189, 853.5007020892778, 14487.637809054779, 16176.352945882165, 16612.750808737877, 16614.252358643877, 16639.41762038329, 15722.292496837641, 16407.507774766775, 16450.42423515177, 16861.241244144014, 16891.662166756658, 828.7389472316231, 830.9335253179731, 832.9791755206138, 834.9540775257359, 836.1387770596265, 686.8042607856762, 805.7059173401725, 817.7669364231195, 818.3126174013827, 826.3389288569151, 854.7563944275882, 855.6662901468433, 855.84166929118, 856.4261944497171, 856.5331894117721, 847.0682249525535, 853.3258725606763, 854.9444286121413, 855.2174760094537, 855.8331125430512, 621.8631900981777, 621.878733646939, 622.2657264427974, 622.3776223776224, 622.9283632382288, 14102.858971410256, 14142.717145657132, 14157.787633185408, 14159.292035398188, 14180.716385672229, 14468.421263149461, 14740.926295368561, 14872.107673539515, 15145.469908553148, 15175.468858590008, 11096.389698566576, 11155.163362747746, 11293.491792869258, 11349.319040857576, 11414.885851141466, 3752.3245815753153, 3767.3407153747985, 3796.6772824309965, 3837.558297537698, 3862.246861861938, 71419.28580714179, 75984.24015759827, 76442.61778691127, 76567.0, 77074.0, 11446.313221206754, 11566.833580551773, 11747.88252117485, 11759.706007349885, 11913.642590722293, 20366.0, 21041.263555775473, 21188.0, 21221.78778212229, 21265.149394024374, 8877.866831997526, 8929.553522323858, 8951.910480895107, 8955.238804701543, 8998.0, 4523.592876641118, 4656.767161641905, 4661.627069834405, 4719.528047195322, 4862.124817532878, 3703.8333275002688, 3811.485449464287, 3811.561670407883, 3821.063839359319, 3824.808759562011, 568.4741614007027, 659.5613916745407, 667.9599224046475, 672.1698702102899, 673.3737624009718, 636.7548493829817, 664.7972368427676, 755.1391413788285, 774.767569729079, 799.4723482501521, 9645.228381729445, 9887.80224395508, 9908.306418550776, 9946.825773273202, 10141.949290253502, 683.5147045597681, 716.9390601798801, 777.3081957058223, 777.9533228006338, 800.7077416742846, 4581.931271030937, 4900.2894580286375, 4948.901021979612, 4956.343346448525, 5002.074616196015, 104361.47819260856, 110937.0, 112796.43601782103, 114003.0, 114597.0, 62184.0, 81510.18489815026, 92756.0, 95402.7988180766, 96384.0, 85639.0, 86064.56967715122, 86496.0, 87582.56208718916, 87767.12232877589, 9919.702408927744, 10062.496875156066, 10101.343412678152, 10498.475076246004, 10522.421266830397, 37308.81345593255, 44102.0, 47974.0, 50328.245076324616, 51369.229461557356, 74438.62780686062, 75869.0, 76116.0, 76153.61923190349, 77753.2224677746, 12699.619011429671, 12838.325738900998, 12867.0, 12985.350732463528, 13338.3330833456, 14133.6466588332, 14230.501932432315, 14267.043675738953, 14305.284735763378, 14588.927055364655, 13862.0, 13937.233452160228, 14471.348789304297, 14818.851811481747, 14974.326155323255, 13254.204747715168, 13320.467181313026, 13380.531681391105, 13586.252756098114, 13827.101238419471, 12423.69909755108, 13018.739625207632, 13180.077394582288, 13438.865611344152, 13468.989825763303, 11054.99018300083, 11234.3259404436, 11266.66200014001, 11286.0, 11512.30926144434, 10467.900870408497, 10605.946970265099, 10688.571542225252, 11187.944060279646, 11341.432928353714], "value": 7585.609529608218, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1538.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 108.0, 112.0, 110.0, 112.0, 113.0, 110.0, 111.0, 111.0, 110.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 129.0, 156.0, 182.0, 141.0, 156.0, 164.0, 132.0, 182.0, 127.0], "value": 152.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 163.0, 173.0, 165.0, 169.0, 176.0, 163.0, 163.0, 163.0], "value": 165.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 159.0, 76.0, 76.0, 76.0, 76.0, 155.0, 76.0], "value": 92.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 139.0, 85.0, 85.0, 83.0, 138.0, 86.0, 84.0, 166.0], "value": 103.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 118.0, 117.0, 118.0, 117.0, 117.0, 118.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 148.0, 150.0, 147.0, 148.0, 148.0, 147.0, 146.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 97.0, 96.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 53.0, 57.0, 54.0, 52.0, 58.0, 53.0, 54.0, 54.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 60.0, 60.0, 61.0, 60.0, 62.0, 64.0, 60.0, 61.0], "value": 61.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 80.0, 80.0, 83.0, 80.0, 82.0, 86.0, 109.0, 80.0], "value": 84.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 129.0, 130.0, 121.0, 119.0, 125.0, 130.0, 124.0, 126.0, 127.0], "value": 125.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 168.0, 168.0, 168.0, 164.0, 166.0, 162.0, 164.0], "value": 164.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 67.0, 63.0, 62.0, 64.0, 61.0, 64.0, 62.0], "value": 63.5, "unit": "score"}]}]} 03:23:22 INFO - Return code: 0 03:23:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:23:22 ERROR - # TBPL SUCCESS # 03:23:22 INFO - Running post-action listener: _resource_record_post_action 03:23:22 INFO - ##### 03:23:22 INFO - ##### Finished run-tests step (success) 03:23:22 INFO - ##### 03:23:22 INFO - Running post-run listener: _resource_record_post_run 03:23:22 INFO - Total resource usage - Wall time: 1193s; CPU: 14.0%; Read bytes: 4096; Write bytes: 540876800; Read time: 8; Write time: 1310532 03:23:22 INFO - TinderboxPrint: CPU usage
13.6% 03:23:22 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 03:23:22 INFO - TinderboxPrint: I/O write bytes / time
540,876,800 / 1,310,532 03:23:22 INFO - TinderboxPrint: CPU idle
8,226.8 (86.4%) 03:23:22 INFO - TinderboxPrint: CPU user
1,225.7 (12.9%) 03:23:22 INFO - TinderboxPrint: Swap in / out
0 / 0 03:23:22 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 221278208; Read time: 0; Write time: 549256 03:23:22 INFO - run-tests - Wall time: 1176s; CPU: 14.0%; Read bytes: 4096; Write bytes: 286912512; Read time: 8; Write time: 751492 03:23:23 INFO - Running post-run listener: _upload_blobber_files 03:23:23 INFO - Blob upload gear active. 03:23:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:23:23 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 03:23:23 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', 'Larch', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:23:23 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 Larch -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:23:23 INFO - (blobuploader) - INFO - Open directory for files ... 03:23:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:23:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:23:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:23:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:23:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:23:24 INFO - (blobuploader) - INFO - Done attempting. 03:23:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:23:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:23:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:23:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:23:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:23:27 INFO - (blobuploader) - INFO - Done attempting. 03:23:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:23:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:23:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:23:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:23:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:23:28 INFO - (blobuploader) - INFO - Done attempting. 03:23:28 INFO - (blobuploader) - INFO - Iteration through files over. 03:23:28 INFO - Return code: 0 03:23:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:23:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:23:28 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/9412f87e18290c3bfbe1a99cd8e3d814423a39bf5da03425c25e9189a899e662e73c875abe475d0803793fed9dc531493e948b66d7f95468fee18891ddbf9462", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/dfaeecf0615fbd2c4e0e532690b2f7d5affac4e00d04edff375f28cdcbe0c03d4f11f44fc7bdb13d1c70be343324cd76db5873bbb3c3908d721d3673501a0211", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/b27715ebe7f9fe0b54ca59763025815aec4e0676427466eb77318c960ef2a0580dacc8fd9def41fad9deaa03f6b0e4162570edd9891129d6f3110d5c698f1ffd"} 03:23:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:23:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:23:28 INFO - Contents: 03:23:28 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/9412f87e18290c3bfbe1a99cd8e3d814423a39bf5da03425c25e9189a899e662e73c875abe475d0803793fed9dc531493e948b66d7f95468fee18891ddbf9462", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/dfaeecf0615fbd2c4e0e532690b2f7d5affac4e00d04edff375f28cdcbe0c03d4f11f44fc7bdb13d1c70be343324cd76db5873bbb3c3908d721d3673501a0211", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/b27715ebe7f9fe0b54ca59763025815aec4e0676427466eb77318c960ef2a0580dacc8fd9def41fad9deaa03f6b0e4162570edd9891129d6f3110d5c698f1ffd"} 03:23:28 INFO - Running post-run listener: copy_logs_to_upload_dir 03:23:28 INFO - Copying logs to upload dir... 03:23:28 INFO - mkdir: /builds/slave/test/build/upload/logs 03:23:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.698702 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-03 03:23:28.397698) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-03 03:23:28.403862) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1464948135.900727-2127116052 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/Larch/sha512/9412f87e18290c3bfbe1a99cd8e3d814423a39bf5da03425c25e9189a899e662e73c875abe475d0803793fed9dc531493e948b66d7f95468fee18891ddbf9462", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/dfaeecf0615fbd2c4e0e532690b2f7d5affac4e00d04edff375f28cdcbe0c03d4f11f44fc7bdb13d1c70be343324cd76db5873bbb3c3908d721d3673501a0211", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/b27715ebe7f9fe0b54ca59763025815aec4e0676427466eb77318c960ef2a0580dacc8fd9def41fad9deaa03f6b0e4162570edd9891129d6f3110d5c698f1ffd"} build_url:https://queue.taskcluster.net/v1/task/BeKAicNpTFmvCBq6slNXQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011225 build_url: 'https://queue.taskcluster.net/v1/task/BeKAicNpTFmvCBq6slNXQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/9412f87e18290c3bfbe1a99cd8e3d814423a39bf5da03425c25e9189a899e662e73c875abe475d0803793fed9dc531493e948b66d7f95468fee18891ddbf9462", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/dfaeecf0615fbd2c4e0e532690b2f7d5affac4e00d04edff375f28cdcbe0c03d4f11f44fc7bdb13d1c70be343324cd76db5873bbb3c3908d721d3673501a0211", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/b27715ebe7f9fe0b54ca59763025815aec4e0676427466eb77318c960ef2a0580dacc8fd9def41fad9deaa03f6b0e4162570edd9891129d6f3110d5c698f1ffd"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-03 03:23:28.429848) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 03:23:28.430292) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1464948135.900727-2127116052 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004528 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 03:23:28.513551) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-03 03:23:28.513865) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-03 03:23:28.514184) ========= ========= Total master_lag: 0.21 =========