builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-030 starttime: 1469582168.7 results: success (0) buildid: 20160726165613 builduid: 50e4d7f4c73b4b239195c9a8b9dbb6c5 revision: d9290a592a0d6ab421c9a109d42bcb140ceb8db9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-26 18:16:08.697282) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-26 18:16:08.697802) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-26 18:16:08.698134) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-26 18:16:08.743301) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 18:16:08.743640) ========= 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=4ac8d263c7293b36a1be1aed000001be-1469580271.823302-767683654 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-26 18:16:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 70.8M=0s 2016-07-26 18:16:08 (70.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.167967 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 18:16:08.952820) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 18:16:08.953111) ========= 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=4ac8d263c7293b36a1be1aed000001be-1469580271.823302-767683654 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.075574 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 18:16:09.041073) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 18:16:09.041387) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d9290a592a0d6ab421c9a109d42bcb140ceb8db9 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev d9290a592a0d6ab421c9a109d42bcb140ceb8db9 --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=4ac8d263c7293b36a1be1aed000001be-1469580271.823302-767683654 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-26 18:16:09,109 truncating revision to first 12 chars 2016-07-26 18:16:09,109 Setting DEBUG logging. 2016-07-26 18:16:09,109 attempt 1/10 2016-07-26 18:16:09,109 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d9290a592a0d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-26 18:16:09,411 unpacking tar archive at: fx-team-d9290a592a0d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.631590 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 18:16:09.687701) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-26 18:16:09.687994) ========= script_repo_revision: d9290a592a0d6ab421c9a109d42bcb140ceb8db9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-26 18:16:09.688413) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-26 18:16:09.688679) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-26 18:16:09.697682) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 48 secs) (at 2016-07-26 18:16:09.698050) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4ac8d263c7293b36a1be1aed000001be-1469580271.823302-767683654 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:16:09 INFO - MultiFileLogger online at 20160726 18:16:09 in /builds/slave/test 18:16:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 18:16:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:16:09 INFO - {'append_to_log': False, 18:16:09 INFO - 'base_work_dir': '/builds/slave/test', 18:16:09 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 18:16:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:16:09 INFO - 'branch': 'Fx-Team-Non-PGO', 18:16:09 INFO - 'buildbot_json_path': 'buildprops.json', 18:16:09 INFO - 'config_files': ('talos/linux_config.py',), 18:16:09 INFO - 'default_actions': ('clobber', 18:16:09 INFO - 'read-buildbot-config', 18:16:09 INFO - 'download-and-extract', 18:16:09 INFO - 'populate-webroot', 18:16:09 INFO - 'create-virtualenv', 18:16:09 INFO - 'install', 18:16:09 INFO - 'run-tests'), 18:16:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:16:09 INFO - 'download_minidump_stackwalk': True, 18:16:09 INFO - 'download_symbols': 'ondemand', 18:16:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:16:09 INFO - 'tooltool.py': '/tools/tooltool.py', 18:16:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:16:09 INFO - '/tools/misc-python/virtualenv.py')}, 18:16:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:16:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:16:09 INFO - 'installer_path': 'installer.exe', 18:16:09 INFO - 'log_level': 'info', 18:16:09 INFO - 'log_name': 'talos', 18:16:09 INFO - 'log_to_console': True, 18:16:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:16:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:16:09 INFO - 'opt_config_files': (), 18:16:09 INFO - 'pip_index': False, 18:16:09 INFO - 'sps_profile': False, 18:16:09 INFO - 'sps_profile_interval': 0, 18:16:09 INFO - 'suite': 'dromaeojs-e10s', 18:16:09 INFO - 'system_bits': '32', 18:16:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:16:09 INFO - 'title': 'talos-linux64-ix-030', 18:16:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:16:09 INFO - 'use_talos_json': True, 18:16:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:16:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:16:09 INFO - 'work_dir': 'build'} 18:16:09 INFO - [mozharness: 2016-07-27 01:16:09.964088Z] Running clobber step. 18:16:09 INFO - Running pre-action listener: _resource_record_pre_action 18:16:09 INFO - Running main action method: clobber 18:16:09 INFO - rmtree: /builds/slave/test/build 18:16:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:16:11 INFO - Running post-action listener: _resource_record_post_action 18:16:11 INFO - [mozharness: 2016-07-27 01:16:11.084033Z] Finished clobber step (success) 18:16:11 INFO - [mozharness: 2016-07-27 01:16:11.084155Z] Running read-buildbot-config step. 18:16:11 INFO - Running pre-action listener: _resource_record_pre_action 18:16:11 INFO - Running main action method: read_buildbot_config 18:16:11 INFO - Using buildbot properties: 18:16:11 INFO - { 18:16:11 INFO - "project": "", 18:16:11 INFO - "product": "firefox", 18:16:11 INFO - "script_repo_revision": "production", 18:16:11 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 18:16:11 INFO - "repository": "", 18:16:11 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 18:16:11 INFO - "buildid": "20160726165613", 18:16:11 INFO - "pgo_build": "False", 18:16:11 INFO - "basedir": "/builds/slave/test", 18:16:11 INFO - "buildnumber": 1508, 18:16:11 INFO - "slavename": "talos-linux64-ix-030", 18:16:11 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:16:11 INFO - "platform": "ubuntu64_hw", 18:16:11 INFO - "scheduler": "tests-fx-team-linux64-talos", 18:16:11 INFO - "branch": "fx-team", 18:16:11 INFO - "repo_path": "integration/fx-team", 18:16:11 INFO - "revision": "d9290a592a0d6ab421c9a109d42bcb140ceb8db9", 18:16:11 INFO - "stage_platform": "linux64", 18:16:11 INFO - "builduid": "50e4d7f4c73b4b239195c9a8b9dbb6c5", 18:16:11 INFO - "slavebuilddir": "test" 18:16:11 INFO - } 18:16:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/LgZmFkCLQpatqjhnXMNwVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 18:16:11 INFO - Running post-action listener: _resource_record_post_action 18:16:11 INFO - [mozharness: 2016-07-27 01:16:11.087475Z] Finished read-buildbot-config step (success) 18:16:11 INFO - [mozharness: 2016-07-27 01:16:11.087690Z] Running download-and-extract step. 18:16:11 INFO - Running pre-action listener: _resource_record_pre_action 18:16:11 INFO - Running main action method: download_and_extract 18:16:11 INFO - mkdir: /builds/slave/test/build/tests 18:16:11 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')]} 18:16:11 INFO - https://queue.taskcluster.net/v1/task/LgZmFkCLQpatqjhnXMNwVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:16:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LgZmFkCLQpatqjhnXMNwVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:16:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LgZmFkCLQpatqjhnXMNwVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:16:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LgZmFkCLQpatqjhnXMNwVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:16:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LgZmFkCLQpatqjhnXMNwVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 18:16:13 INFO - Downloaded 1361 bytes. 18:16:13 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:16:13 INFO - Using the following test package requirements: 18:16:13 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 18:16:13 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:16:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:16:13 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:16:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:16:13 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:16:13 INFO - u'jsshell-linux-x86_64.zip'], 18:16:13 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:16:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:16:13 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 18:16:13 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:16:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:16:13 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:16:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:16:13 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:16:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:16:13 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:16:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:16:13 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:16:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:16:13 INFO - https://queue.taskcluster.net/v1/task/LgZmFkCLQpatqjhnXMNwVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:16:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LgZmFkCLQpatqjhnXMNwVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:16:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LgZmFkCLQpatqjhnXMNwVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:16:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LgZmFkCLQpatqjhnXMNwVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:16:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LgZmFkCLQpatqjhnXMNwVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:16:14 INFO - Downloaded 22744359 bytes. 18:16:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:16:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 18:16:15 INFO - Return code: 0 18:16:15 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:16: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')]} 18:16:15 INFO - https://queue.taskcluster.net/v1/task/LgZmFkCLQpatqjhnXMNwVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:16:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LgZmFkCLQpatqjhnXMNwVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:16:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LgZmFkCLQpatqjhnXMNwVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:16:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LgZmFkCLQpatqjhnXMNwVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:16:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LgZmFkCLQpatqjhnXMNwVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:16:16 INFO - Downloaded 22744359 bytes. 18:16:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:16:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 18:16:18 INFO - Return code: 0 18:16: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')]} 18:16:18 INFO - https://queue.taskcluster.net/v1/task/LgZmFkCLQpatqjhnXMNwVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:16:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LgZmFkCLQpatqjhnXMNwVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 18:16:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LgZmFkCLQpatqjhnXMNwVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 18:16:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LgZmFkCLQpatqjhnXMNwVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 18:16:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LgZmFkCLQpatqjhnXMNwVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:16:49 WARNING - Socket error when accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LgZmFkCLQpatqjhnXMNwVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip: The read operation timed out 18:16:49 INFO - retry: attempt #1 caught exception: The read operation timed out 18:16:49 INFO - retry: Failed, sleeping 30 seconds before retrying 18:17:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LgZmFkCLQpatqjhnXMNwVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #2 18:17:23 INFO - Downloaded 14413725 bytes. 18:17:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:17:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 18:17:23 INFO - Return code: 0 18:17:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:17:23 INFO - https://queue.taskcluster.net/v1/task/LgZmFkCLQpatqjhnXMNwVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:17:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LgZmFkCLQpatqjhnXMNwVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:17:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LgZmFkCLQpatqjhnXMNwVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:17:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LgZmFkCLQpatqjhnXMNwVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:17:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LgZmFkCLQpatqjhnXMNwVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:17:25 INFO - Downloaded 57176149 bytes. 18:17:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LgZmFkCLQpatqjhnXMNwVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:17:25 INFO - mkdir: /builds/slave/test/properties 18:17:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:17:25 INFO - Writing to file /builds/slave/test/properties/build_url 18:17:25 INFO - Contents: 18:17:25 INFO - build_url:https://queue.taskcluster.net/v1/task/LgZmFkCLQpatqjhnXMNwVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:17:25 INFO - Running post-action listener: _resource_record_post_action 18:17:25 INFO - Running post-action listener: set_extra_try_arguments 18:17:25 INFO - [mozharness: 2016-07-27 01:17:25.897750Z] Finished download-and-extract step (success) 18:17:25 INFO - [mozharness: 2016-07-27 01:17:25.898018Z] Running populate-webroot step. 18:17:25 INFO - Running pre-action listener: _resource_record_pre_action 18:17:25 INFO - Running main action method: populate_webroot 18:17:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:17:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:17:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:17:25 INFO - '--tppagecycles', 18:17:25 INFO - '7'], 18:17:25 INFO - 'tests': ['tsvgm']}}, 18:17:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:17:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:17:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:17:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:17:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:17:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:17:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:17:25 INFO - 'talos_options': ['--disable-e10s'], 18:17:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:17:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:17:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:17:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:17:25 INFO - 'talos_options': ['--disable-e10s'], 18:17:25 INFO - 'tests': ['damp', 'tps']}, 18:17:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:17:25 INFO - 'tests': ['damp', 'tps']}, 18:17:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:17:25 INFO - 'tests': ['dromaeo_dom']}, 18:17:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:17:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:17:25 INFO - 'tests': ['basic_compositor_video']}, 18:17:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:17:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:17:25 INFO - 'tests': ['a11yr', 18:17:25 INFO - 'ts_paint', 18:17:25 INFO - 'tpaint', 18:17:25 INFO - 'sessionrestore', 18:17:25 INFO - 'sessionrestore_no_auto_restore', 18:17:25 INFO - 'tabpaint']}, 18:17:25 INFO - 'other-e10s': {'tests': ['a11yr', 18:17:25 INFO - 'ts_paint', 18:17:25 INFO - 'tpaint', 18:17:25 INFO - 'sessionrestore', 18:17:25 INFO - 'sessionrestore_no_auto_restore', 18:17:25 INFO - 'tabpaint']}, 18:17:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:17:25 INFO - 'ts_paint', 18:17:25 INFO - 'tpaint', 18:17:25 INFO - 'sessionrestore', 18:17:25 INFO - 'sessionrestore_no_auto_restore', 18:17:25 INFO - 'tabpaint']}, 18:17:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:17:25 INFO - 'ts_paint', 18:17:25 INFO - 'tpaint', 18:17:25 INFO - 'sessionrestore', 18:17:25 INFO - 'sessionrestore_no_auto_restore', 18:17:25 INFO - 'tabpaint']}, 18:17:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:17:25 INFO - 'tests': ['a11yr', 18:17:25 INFO - 'ts_paint', 18:17:25 INFO - 'tpaint', 18:17:25 INFO - 'sessionrestore', 18:17:25 INFO - 'sessionrestore_no_auto_restore', 18:17:25 INFO - 'tabpaint']}, 18:17:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:17:25 INFO - 'tests': ['a11yr', 18:17:25 INFO - 'ts_paint', 18:17:25 INFO - 'tpaint', 18:17:25 INFO - 'sessionrestore', 18:17:25 INFO - 'sessionrestore_no_auto_restore', 18:17:25 INFO - 'tabpaint']}, 18:17:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:17:25 INFO - 'tests': ['tsvgx', 18:17:25 INFO - 'tsvgr_opacity', 18:17:25 INFO - 'tart', 18:17:25 INFO - 'tscrollx', 18:17:25 INFO - 'cart']}, 18:17:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:17:25 INFO - 'tsvgr_opacity', 18:17:25 INFO - 'tart', 18:17:25 INFO - 'tscrollx', 18:17:25 INFO - 'cart']}, 18:17:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:17:25 INFO - 'talos_options': ['--disable-e10s'], 18:17:25 INFO - 'tests': ['tp5o']}, 18:17:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:17:25 INFO - 'tests': ['tp5o']}, 18:17:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:17:25 INFO - 'talos_options': ['--disable-e10s', 18:17:25 INFO - '--xperf_path', 18:17:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:17:25 INFO - 'tests': ['tp5n']}, 18:17:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:17:25 INFO - 'talos_options': ['--xperf_path', 18:17:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:17:25 INFO - 'tests': ['tp5n']}}, 18:17:25 INFO - 'talos.zip': {'path': '', 18:17:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:17:25 INFO - Running post-action listener: _resource_record_post_action 18:17:25 INFO - [mozharness: 2016-07-27 01:17:25.919043Z] Finished populate-webroot step (success) 18:17:25 INFO - [mozharness: 2016-07-27 01:17:25.919132Z] Running create-virtualenv step. 18:17:25 INFO - Running pre-action listener: _resource_record_pre_action 18:17:25 INFO - Running main action method: create_virtualenv 18:17:25 INFO - Creating virtualenv /builds/slave/test/build/venv 18:17:25 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 18:17:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:17:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:17:26 INFO - Using real prefix '/usr' 18:17:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:17:26 INFO - Installing distribute.............................................................................................................................................................................................done. 18:17:28 INFO - Installing pip.................done. 18:17:28 INFO - Return code: 0 18:17:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:17:28 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')]} 18:17:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:17:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:17:28 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')]} 18:17:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:17:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:17:28 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 0xd2e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfec570>, '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 0xfed470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfed900>, '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': '4ac8d263c7293b36a1be1aed000001be-1469580271.823302-767683654', '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 18:17:28 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 18:17:28 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 18:17:28 INFO - Using env: {'DISPLAY': ':0', 18:17:28 INFO - 'HOME': '/home/cltbld', 18:17:28 INFO - 'LANG': 'en_US.UTF-8', 18:17:28 INFO - 'LANGUAGE': 'en_US:en', 18:17:28 INFO - 'LOGNAME': 'cltbld', 18:17:28 INFO - 'MAIL': '/var/mail/cltbld', 18:17:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:17:28 INFO - 'MOZ_NO_REMOTE': '1', 18:17:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:17:28 INFO - 'NO_EM_RESTART': '1', 18:17:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:17:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:17:28 INFO - 'PWD': '/builds/slave/test', 18:17:28 INFO - 'SHELL': '/bin/bash', 18:17:28 INFO - 'SHLVL': '1', 18:17:28 INFO - 'TERM': 'linux', 18:17:28 INFO - 'TMOUT': '86400', 18:17:28 INFO - 'USER': 'cltbld', 18:17:28 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1469580271.823302-767683654', 18:17:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:17:28 INFO - '_': '/tools/buildbot/bin/python'} 18:17:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:17:28 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 18:17:28 INFO - Cleaning up... 18:17:28 INFO - Return code: 0 18:17:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:17:28 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')]} 18:17:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:17:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:17:28 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')]} 18:17:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:17:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:17:28 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 0xd2e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfec570>, '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 0xfed470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfed900>, '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': '4ac8d263c7293b36a1be1aed000001be-1469580271.823302-767683654', '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 18:17:28 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 18:17:28 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 18:17:29 INFO - Using env: {'DISPLAY': ':0', 18:17:29 INFO - 'HOME': '/home/cltbld', 18:17:29 INFO - 'LANG': 'en_US.UTF-8', 18:17:29 INFO - 'LANGUAGE': 'en_US:en', 18:17:29 INFO - 'LOGNAME': 'cltbld', 18:17:29 INFO - 'MAIL': '/var/mail/cltbld', 18:17:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:17:29 INFO - 'MOZ_NO_REMOTE': '1', 18:17:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:17:29 INFO - 'NO_EM_RESTART': '1', 18:17:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:17:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:17:29 INFO - 'PWD': '/builds/slave/test', 18:17:29 INFO - 'SHELL': '/bin/bash', 18:17:29 INFO - 'SHLVL': '1', 18:17:29 INFO - 'TERM': 'linux', 18:17:29 INFO - 'TMOUT': '86400', 18:17:29 INFO - 'USER': 'cltbld', 18:17:29 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1469580271.823302-767683654', 18:17:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:17:29 INFO - '_': '/tools/buildbot/bin/python'} 18:17:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:17:29 INFO - Downloading/unpacking psutil>=3.1.1 18:17:29 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 18:17:29 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 18:17:29 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 18:17:29 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 18:17:29 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 18:17:29 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 18:17:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:17:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:17:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:17:31 INFO - Installing collected packages: psutil 18:17:31 INFO - Running setup.py install for psutil 18:17:31 INFO - building 'psutil._psutil_linux' extension 18:17:31 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 18:17:32 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 18:17:32 INFO - building 'psutil._psutil_posix' extension 18:17:32 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 18:17:32 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 18:17:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:17:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:17:32 INFO - Successfully installed psutil 18:17:32 INFO - Cleaning up... 18:17:32 INFO - Return code: 0 18:17:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:17:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:17:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:17:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:17:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:17:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:17:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:17:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd2e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfec570>, '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 0xfed470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfed900>, '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': '4ac8d263c7293b36a1be1aed000001be-1469580271.823302-767683654', '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 18:17:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:17:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:17:32 INFO - Using env: {'DISPLAY': ':0', 18:17:32 INFO - 'HOME': '/home/cltbld', 18:17:32 INFO - 'LANG': 'en_US.UTF-8', 18:17:32 INFO - 'LANGUAGE': 'en_US:en', 18:17:32 INFO - 'LOGNAME': 'cltbld', 18:17:32 INFO - 'MAIL': '/var/mail/cltbld', 18:17:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:17:32 INFO - 'MOZ_NO_REMOTE': '1', 18:17:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:17:32 INFO - 'NO_EM_RESTART': '1', 18:17:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:17:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:17:32 INFO - 'PWD': '/builds/slave/test', 18:17:32 INFO - 'SHELL': '/bin/bash', 18:17:32 INFO - 'SHLVL': '1', 18:17:32 INFO - 'TERM': 'linux', 18:17:32 INFO - 'TMOUT': '86400', 18:17:32 INFO - 'USER': 'cltbld', 18:17:32 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1469580271.823302-767683654', 18:17:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:17:32 INFO - '_': '/tools/buildbot/bin/python'} 18:17:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:17:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:17:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:17:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:17:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:17:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:17:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:17:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:17:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:17:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:17:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:17:34 INFO - Installing collected packages: mozsystemmonitor 18:17:34 INFO - Running setup.py install for mozsystemmonitor 18:17:34 INFO - Successfully installed mozsystemmonitor 18:17:34 INFO - Cleaning up... 18:17:35 INFO - Return code: 0 18:17:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:17:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:17:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:17:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:17:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:17:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:17:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:17:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd2e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfec570>, '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 0xfed470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfed900>, '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': '4ac8d263c7293b36a1be1aed000001be-1469580271.823302-767683654', '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 18:17:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:17:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:17:35 INFO - Using env: {'DISPLAY': ':0', 18:17:35 INFO - 'HOME': '/home/cltbld', 18:17:35 INFO - 'LANG': 'en_US.UTF-8', 18:17:35 INFO - 'LANGUAGE': 'en_US:en', 18:17:35 INFO - 'LOGNAME': 'cltbld', 18:17:35 INFO - 'MAIL': '/var/mail/cltbld', 18:17:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:17:35 INFO - 'MOZ_NO_REMOTE': '1', 18:17:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:17:35 INFO - 'NO_EM_RESTART': '1', 18:17:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:17:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:17:35 INFO - 'PWD': '/builds/slave/test', 18:17:35 INFO - 'SHELL': '/bin/bash', 18:17:35 INFO - 'SHLVL': '1', 18:17:35 INFO - 'TERM': 'linux', 18:17:35 INFO - 'TMOUT': '86400', 18:17:35 INFO - 'USER': 'cltbld', 18:17:35 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1469580271.823302-767683654', 18:17:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:17:35 INFO - '_': '/tools/buildbot/bin/python'} 18:17:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:17:35 INFO - Downloading/unpacking jsonschema==2.5.1 18:17:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:17:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:17:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:17:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:17:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:17:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:17:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:17:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:17:37 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 18:17:37 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 18:17:37 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 18:17:37 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 18:17:37 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 18:17:37 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 18:17:37 INFO - Downloading functools32-3.2.3-2.tar.gz 18:17:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:17:37 INFO - warning: no files found matching '*.txt' 18:17:37 INFO - no previously-included directories found matching 'build' 18:17:37 INFO - no previously-included directories found matching 'dist' 18:17:37 INFO - no previously-included directories found matching '.git*' 18:17:37 INFO - Installing collected packages: jsonschema, functools32 18:17:37 INFO - Running setup.py install for functools32 18:17:37 INFO - warning: no files found matching '*.txt' 18:17:37 INFO - no previously-included directories found matching 'build' 18:17:37 INFO - no previously-included directories found matching 'dist' 18:17:37 INFO - no previously-included directories found matching '.git*' 18:17:37 INFO - Successfully installed jsonschema functools32 18:17:37 INFO - Cleaning up... 18:17:37 INFO - Return code: 0 18:17:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:17:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:17:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:17:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:17:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:17:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:17:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:17:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd2e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfec570>, '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 0xfed470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfed900>, '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': '4ac8d263c7293b36a1be1aed000001be-1469580271.823302-767683654', '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 18:17:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:17:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 18:17:37 INFO - Using env: {'DISPLAY': ':0', 18:17:37 INFO - 'HOME': '/home/cltbld', 18:17:37 INFO - 'LANG': 'en_US.UTF-8', 18:17:37 INFO - 'LANGUAGE': 'en_US:en', 18:17:37 INFO - 'LOGNAME': 'cltbld', 18:17:37 INFO - 'MAIL': '/var/mail/cltbld', 18:17:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:17:37 INFO - 'MOZ_NO_REMOTE': '1', 18:17:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:17:37 INFO - 'NO_EM_RESTART': '1', 18:17:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:17:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:17:37 INFO - 'PWD': '/builds/slave/test', 18:17:37 INFO - 'SHELL': '/bin/bash', 18:17:37 INFO - 'SHLVL': '1', 18:17:37 INFO - 'TERM': 'linux', 18:17:37 INFO - 'TMOUT': '86400', 18:17:37 INFO - 'USER': 'cltbld', 18:17:37 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1469580271.823302-767683654', 18:17:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:17:37 INFO - '_': '/tools/buildbot/bin/python'} 18:17:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:17:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:17:37 INFO - Cleaning up... 18:17:37 INFO - Return code: 0 18:17:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:17:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:17:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:17:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:17:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:17:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:17:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:17:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd2e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfec570>, '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 0xfed470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfed900>, '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': '4ac8d263c7293b36a1be1aed000001be-1469580271.823302-767683654', '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 18:17:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:17:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:17:37 INFO - Using env: {'DISPLAY': ':0', 18:17:37 INFO - 'HOME': '/home/cltbld', 18:17:37 INFO - 'LANG': 'en_US.UTF-8', 18:17:37 INFO - 'LANGUAGE': 'en_US:en', 18:17:37 INFO - 'LOGNAME': 'cltbld', 18:17:37 INFO - 'MAIL': '/var/mail/cltbld', 18:17:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:17:37 INFO - 'MOZ_NO_REMOTE': '1', 18:17:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:17:37 INFO - 'NO_EM_RESTART': '1', 18:17:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:17:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:17:37 INFO - 'PWD': '/builds/slave/test', 18:17:37 INFO - 'SHELL': '/bin/bash', 18:17:37 INFO - 'SHLVL': '1', 18:17:37 INFO - 'TERM': 'linux', 18:17:37 INFO - 'TMOUT': '86400', 18:17:37 INFO - 'USER': 'cltbld', 18:17:37 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1469580271.823302-767683654', 18:17:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:17:37 INFO - '_': '/tools/buildbot/bin/python'} 18:17:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:17:38 INFO - Downloading/unpacking blobuploader==1.2.4 18:17:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:17:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:17:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:17:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:17:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:17:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:17:39 INFO - Downloading blobuploader-1.2.4.tar.gz 18:17:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:17:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:17:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:17:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:17:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:17:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:17:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:17:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:17:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:17:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:17:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:17:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:17:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:17:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:17:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:17:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:17:40 INFO - Downloading docopt-0.6.1.tar.gz 18:17:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:17:40 INFO - Installing collected packages: blobuploader, requests, docopt 18:17:40 INFO - Running setup.py install for blobuploader 18:17:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:17:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:17:41 INFO - Running setup.py install for requests 18:17:41 INFO - Running setup.py install for docopt 18:17:41 INFO - Successfully installed blobuploader requests docopt 18:17:41 INFO - Cleaning up... 18:17:41 INFO - Return code: 0 18:17:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:17:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:17:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:17:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:17:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:17:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:17:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd2e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfec570>, '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 0xfed470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfed900>, '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': '4ac8d263c7293b36a1be1aed000001be-1469580271.823302-767683654', '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 18:17:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:17:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:17:41 INFO - Using env: {'DISPLAY': ':0', 18:17:41 INFO - 'HOME': '/home/cltbld', 18:17:41 INFO - 'LANG': 'en_US.UTF-8', 18:17:41 INFO - 'LANGUAGE': 'en_US:en', 18:17:41 INFO - 'LOGNAME': 'cltbld', 18:17:41 INFO - 'MAIL': '/var/mail/cltbld', 18:17:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:17:41 INFO - 'MOZ_NO_REMOTE': '1', 18:17:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:17:41 INFO - 'NO_EM_RESTART': '1', 18:17:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:17:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:17:41 INFO - 'PWD': '/builds/slave/test', 18:17:41 INFO - 'SHELL': '/bin/bash', 18:17:41 INFO - 'SHLVL': '1', 18:17:41 INFO - 'TERM': 'linux', 18:17:41 INFO - 'TMOUT': '86400', 18:17:41 INFO - 'USER': 'cltbld', 18:17:41 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1469580271.823302-767683654', 18:17:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:17:41 INFO - '_': '/tools/buildbot/bin/python'} 18:17:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:17:41 INFO - Running setup.py (path:/tmp/pip-GJSMQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:17:41 INFO - Running setup.py (path:/tmp/pip-6AcKQI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:17:41 INFO - Running setup.py (path:/tmp/pip-eQ5ZqU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:17:41 INFO - Running setup.py (path:/tmp/pip-BBB6iX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:17:42 INFO - Running setup.py (path:/tmp/pip-fuq3_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:17:42 INFO - Running setup.py (path:/tmp/pip-6ZUKkN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:17:42 INFO - Running setup.py (path:/tmp/pip-qQZiQr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:17:42 INFO - Running setup.py (path:/tmp/pip-L5TSlH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:17:42 INFO - Running setup.py (path:/tmp/pip-A8Bc3B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:17:42 INFO - Running setup.py (path:/tmp/pip-nb30Fa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:17:42 INFO - Running setup.py (path:/tmp/pip-GibNam-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:17:42 INFO - Running setup.py (path:/tmp/pip-_Xv8Bl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:17:42 INFO - Running setup.py (path:/tmp/pip-jpGm_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:17:42 INFO - Running setup.py (path:/tmp/pip-MKEmTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:17:42 INFO - Running setup.py (path:/tmp/pip-IE95HB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:17:42 INFO - Running setup.py (path:/tmp/pip-afJu6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:17:42 INFO - Running setup.py (path:/tmp/pip-AS3_pJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:17:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:17:42 INFO - Running setup.py install for manifestparser 18:17:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:17:43 INFO - Running setup.py install for mozcrash 18:17:43 INFO - Running setup.py install for mozdebug 18:17:43 INFO - Running setup.py install for mozdevice 18:17:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:17:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:17:43 INFO - Running setup.py install for mozfile 18:17:43 INFO - Running setup.py install for mozhttpd 18:17:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:17:43 INFO - Running setup.py install for mozinfo 18:17:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:17:43 INFO - Running setup.py install for mozInstall 18:17:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:17:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:17:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:17:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:17:43 INFO - Running setup.py install for mozleak 18:17:43 INFO - Running setup.py install for mozlog 18:17:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:17:43 INFO - Running setup.py install for moznetwork 18:17:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:17:44 INFO - Running setup.py install for mozprocess 18:17:44 INFO - Running setup.py install for mozprofile 18:17:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:17:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:17:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:17:44 INFO - Running setup.py install for mozrunner 18:17:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:17:44 INFO - Running setup.py install for mozscreenshot 18:17:44 INFO - Running setup.py install for moztest 18:17:44 INFO - Running setup.py install for mozversion 18:17:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:17:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:17:44 INFO - Cleaning up... 18:17:44 INFO - Return code: 0 18:17:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:17:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:17:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:17:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:17:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:17:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:17:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:17:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd2e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfec570>, '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 0xfed470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfed900>, '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': '4ac8d263c7293b36a1be1aed000001be-1469580271.823302-767683654', '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 18:17:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:17:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:17:44 INFO - Using env: {'DISPLAY': ':0', 18:17:44 INFO - 'HOME': '/home/cltbld', 18:17:44 INFO - 'LANG': 'en_US.UTF-8', 18:17:44 INFO - 'LANGUAGE': 'en_US:en', 18:17:44 INFO - 'LOGNAME': 'cltbld', 18:17:44 INFO - 'MAIL': '/var/mail/cltbld', 18:17:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:17:44 INFO - 'MOZ_NO_REMOTE': '1', 18:17:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:17:44 INFO - 'NO_EM_RESTART': '1', 18:17:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:17:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:17:44 INFO - 'PWD': '/builds/slave/test', 18:17:44 INFO - 'SHELL': '/bin/bash', 18:17:44 INFO - 'SHLVL': '1', 18:17:44 INFO - 'TERM': 'linux', 18:17:44 INFO - 'TMOUT': '86400', 18:17:44 INFO - 'USER': 'cltbld', 18:17:44 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1469580271.823302-767683654', 18:17:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:17:44 INFO - '_': '/tools/buildbot/bin/python'} 18:17:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:17:44 INFO - Running setup.py (path:/tmp/pip-N9mO4C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:17:45 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)) 18:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:17:45 INFO - Running setup.py (path:/tmp/pip-Jg2myT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:17:45 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)) 18:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:17:45 INFO - Running setup.py (path:/tmp/pip-bjYLLr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:17:45 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)) 18:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:17:45 INFO - Running setup.py (path:/tmp/pip-XPIMsA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:17:45 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)) 18:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:17:45 INFO - Running setup.py (path:/tmp/pip-Swovgb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:17:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 18:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:17:45 INFO - Running setup.py (path:/tmp/pip-qImpMB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:17:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 18:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:17:45 INFO - Running setup.py (path:/tmp/pip-gzhUbb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:17:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 18:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:17:45 INFO - Running setup.py (path:/tmp/pip-5WdNAM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:17:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:17:45 INFO - Running setup.py (path:/tmp/pip-9EC1za-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:17:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 18:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:17:45 INFO - Running setup.py (path:/tmp/pip-SNw83L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:17:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:17:45 INFO - Running setup.py (path:/tmp/pip-ZJfkNl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:17:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 18:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:17:45 INFO - Running setup.py (path:/tmp/pip-Q83dI_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:17:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:17:45 INFO - Running setup.py (path:/tmp/pip-yLbMhJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:17:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 18:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:17:45 INFO - Running setup.py (path:/tmp/pip-PzciOi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:17:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:17:45 INFO - Running setup.py (path:/tmp/pip-n6T3I0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:17:46 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)) 18:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:17:46 INFO - Running setup.py (path:/tmp/pip-7g5u5A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:17:46 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)) 18:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:17:46 INFO - Running setup.py (path:/tmp/pip-tCcy0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:17:46 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)) 18:17:46 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)) 18:17:46 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)) 18:17:46 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)) 18:17:46 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)) 18:17:46 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)) 18:17:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:17:46 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 18:17:46 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 18:17:46 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 18:17:46 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 18:17:46 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 18:17:46 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 18:17:48 INFO - Downloading blessings-1.6.tar.gz 18:17:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:17:48 INFO - Installing collected packages: blessings 18:17:48 INFO - Running setup.py install for blessings 18:17:48 INFO - Successfully installed blessings 18:17:48 INFO - Cleaning up... 18:17:48 INFO - Return code: 0 18:17:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:17:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:17:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:17:48 INFO - Reading from file tmpfile_stdout 18:17:48 INFO - Current package versions: 18:17:48 INFO - argparse == 1.2.1 18:17:48 INFO - blessings == 1.6 18:17:48 INFO - blobuploader == 1.2.4 18:17:48 INFO - docopt == 0.6.1 18:17:48 INFO - functools32 == 3.2.3-2 18:17:48 INFO - jsonschema == 2.5.1 18:17:48 INFO - manifestparser == 1.1 18:17:48 INFO - mozInstall == 1.12 18:17:48 INFO - mozcrash == 0.17 18:17:48 INFO - mozdebug == 0.1 18:17:48 INFO - mozdevice == 0.48 18:17:48 INFO - mozfile == 1.2 18:17:48 INFO - mozhttpd == 0.7 18:17:48 INFO - mozinfo == 0.9 18:17:48 INFO - mozleak == 0.1 18:17:48 INFO - mozlog == 3.3 18:17:48 INFO - moznetwork == 0.27 18:17:48 INFO - mozprocess == 0.23 18:17:48 INFO - mozprofile == 0.28 18:17:48 INFO - mozrunner == 6.12 18:17:48 INFO - mozscreenshot == 0.1 18:17:48 INFO - mozsystemmonitor == 0.3 18:17:48 INFO - moztest == 0.7 18:17:48 INFO - mozversion == 1.4 18:17:48 INFO - psutil == 3.1.1 18:17:48 INFO - requests == 1.2.3 18:17:48 INFO - wsgiref == 0.1.2 18:17:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:17:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:17:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:17:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:17:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:17:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:17:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd2e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfec570>, '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 0xfed470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfed900>, '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': '4ac8d263c7293b36a1be1aed000001be-1469580271.823302-767683654', '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 18:17:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 18:17:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:17:48 INFO - Using env: {'DISPLAY': ':0', 18:17:48 INFO - 'HOME': '/home/cltbld', 18:17:48 INFO - 'LANG': 'en_US.UTF-8', 18:17:48 INFO - 'LANGUAGE': 'en_US:en', 18:17:48 INFO - 'LOGNAME': 'cltbld', 18:17:48 INFO - 'MAIL': '/var/mail/cltbld', 18:17:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:17:48 INFO - 'MOZ_NO_REMOTE': '1', 18:17:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:17:48 INFO - 'NO_EM_RESTART': '1', 18:17:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:17:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:17:48 INFO - 'PWD': '/builds/slave/test', 18:17:48 INFO - 'SHELL': '/bin/bash', 18:17:48 INFO - 'SHLVL': '1', 18:17:48 INFO - 'TERM': 'linux', 18:17:48 INFO - 'TMOUT': '86400', 18:17:48 INFO - 'USER': 'cltbld', 18:17:48 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1469580271.823302-767683654', 18:17:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:17:48 INFO - '_': '/tools/buildbot/bin/python'} 18:17:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:17:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:17:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 18:17:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 18:17:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:17:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 18:17:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 18:17:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 18:17:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 18:17:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 18:17:48 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:17:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:17:48 INFO - Cleaning up... 18:17:48 INFO - Return code: 0 18:17:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:17:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:17:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:17:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:17:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:17:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:17:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd2e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfec570>, '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 0xfed470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfed900>, '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': '4ac8d263c7293b36a1be1aed000001be-1469580271.823302-767683654', '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 18:17:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:17:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:17:48 INFO - Using env: {'DISPLAY': ':0', 18:17:48 INFO - 'HOME': '/home/cltbld', 18:17:48 INFO - 'LANG': 'en_US.UTF-8', 18:17:48 INFO - 'LANGUAGE': 'en_US:en', 18:17:48 INFO - 'LOGNAME': 'cltbld', 18:17:48 INFO - 'MAIL': '/var/mail/cltbld', 18:17:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:17:48 INFO - 'MOZ_NO_REMOTE': '1', 18:17:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:17:48 INFO - 'NO_EM_RESTART': '1', 18:17:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:17:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:17:48 INFO - 'PWD': '/builds/slave/test', 18:17:48 INFO - 'SHELL': '/bin/bash', 18:17:48 INFO - 'SHLVL': '1', 18:17:48 INFO - 'TERM': 'linux', 18:17:48 INFO - 'TMOUT': '86400', 18:17:48 INFO - 'USER': 'cltbld', 18:17:48 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1469580271.823302-767683654', 18:17:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:17:48 INFO - '_': '/tools/buildbot/bin/python'} 18:17:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:17:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:17:49 INFO - Cleaning up... 18:17:49 INFO - Return code: 0 18:17:49 INFO - Running post-action listener: _resource_record_post_action 18:17:49 INFO - Running post-action listener: _start_resource_monitoring 18:17:49 INFO - Starting resource monitoring. 18:17:49 INFO - [mozharness: 2016-07-27 01:17:49.064597Z] Finished create-virtualenv step (success) 18:17:49 INFO - [mozharness: 2016-07-27 01:17:49.065543Z] Running install step. 18:17:49 INFO - Running pre-action listener: _resource_record_pre_action 18:17:49 INFO - Running main action method: install 18:17:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:17:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:17:49 INFO - Reading from file tmpfile_stdout 18:17:49 INFO - Detecting whether we're running mozinstall >=1.0... 18:17:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:17:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:17:49 INFO - Reading from file tmpfile_stdout 18:17:49 INFO - Output received: 18:17:49 INFO - Usage: mozinstall [options] installer 18:17:49 INFO - Options: 18:17:49 INFO - -h, --help show this help message and exit 18:17:49 INFO - -d DEST, --destination=DEST 18:17:49 INFO - Directory to install application into. [default: 18:17:49 INFO - "/builds/slave/test"] 18:17:49 INFO - --app=APP Application being installed. [default: firefox] 18:17:49 INFO - mkdir: /builds/slave/test/build/application 18:17:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:17:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 18:18:05 INFO - Reading from file tmpfile_stdout 18:18:05 INFO - Output received: 18:18:05 INFO - /builds/slave/test/build/application/firefox/firefox 18:18:05 INFO - Running post-action listener: _resource_record_post_action 18:18:05 INFO - [mozharness: 2016-07-27 01:18:05.727241Z] Finished install step (success) 18:18:05 INFO - [mozharness: 2016-07-27 01:18:05.727535Z] Running run-tests step. 18:18:05 INFO - Running pre-action listener: _resource_record_pre_action 18:18:05 INFO - Running main action method: run_tests 18:18:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:18:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:18:05 INFO - Python 2.7.3 18:18:05 INFO - Return code: 0 18:18:05 INFO - grabbing minidump binary from tooltool 18:18:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:18:05 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 0xfec570>, '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 0xfed470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfed900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:18:05 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 18:18:05 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 18:18:05 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 18:18:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:18:05 INFO - Return code: 0 18:18:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:18:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:18:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:18:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:18:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:18:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LgZmFkCLQpatqjhnXMNwVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 18:18:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LgZmFkCLQpatqjhnXMNwVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-030 --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 18:18:05 INFO - Using env: {'DISPLAY': ':0', 18:18:05 INFO - 'HOME': '/home/cltbld', 18:18:05 INFO - 'LANG': 'en_US.UTF-8', 18:18:05 INFO - 'LANGUAGE': 'en_US:en', 18:18:05 INFO - 'LOGNAME': 'cltbld', 18:18:05 INFO - 'MAIL': '/var/mail/cltbld', 18:18:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:18:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:18:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:05 INFO - 'MOZ_NO_REMOTE': '1', 18:18:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:18:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:05 INFO - 'NO_EM_RESTART': '1', 18:18:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:05 INFO - 'PWD': '/builds/slave/test', 18:18:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:18:05 INFO - 'SHELL': '/bin/bash', 18:18:05 INFO - 'SHLVL': '1', 18:18:05 INFO - 'TERM': 'linux', 18:18:05 INFO - 'TMOUT': '86400', 18:18:05 INFO - 'USER': 'cltbld', 18:18:05 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1469580271.823302-767683654', 18:18:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:05 INFO - '_': '/tools/buildbot/bin/python'} 18:18:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LgZmFkCLQpatqjhnXMNwVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 18:18:06 INFO - mozversion application_buildid: 20160726165613 18:18:06 INFO - mozversion application_changeset: d9290a592a0d6ab421c9a109d42bcb140ceb8db9 18:18:06 INFO - mozversion application_display_name: Nightly 18:18:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:18:06 INFO - mozversion application_name: Firefox 18:18:06 INFO - mozversion application_remotingname: firefox 18:18:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:18:06 INFO - mozversion application_vendor: Mozilla 18:18:06 INFO - mozversion application_version: 50.0a1 18:18:06 INFO - mozversion platform_buildid: 20160726165613 18:18:06 INFO - mozversion platform_changeset: d9290a592a0d6ab421c9a109d42bcb140ceb8db9 18:18:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:18:06 INFO - mozversion platform_version: 50.0a1 18:18:06 INFO - using testdate: 1469582286 18:18:06 INFO - actual date: 1469582286 18:18:06 INFO - starting webserver on 'localhost:48410' 18:18:06 INFO - SUITE-START | Running 2 tests 18:18:06 INFO - TEST-START | dromaeo_css 18:18:06 INFO - operating with platform_type : linux_ 18:18:06 INFO - Initialising browser for dromaeo_css test... 18:18:06 INFO - TEST-INFO | started process 3297 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpodt148/profile http://localhost:48410/getInfo.html) 18:18:10 INFO - PROCESS | 3297 | JavaScript error: , line 0: uncaught exception: undefined 18:18:12 INFO - PROCESS | 3297 | __metrics Screen width/height:1600/1200 18:18:12 INFO - PROCESS | 3297 | colorDepth:24 18:18:12 INFO - PROCESS | 3297 | Browser inner width/height: 1024/697 18:18:12 INFO - PROCESS | 3297 | __metrics 18:18:13 ERROR - PROCESS | 3297 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 18:18:14 INFO - TEST-INFO | 3297: exit 0 18:18:14 INFO - Browser initialized. 18:18:14 INFO - Running cycle 1/1 for dromaeo_css test... 18:18:14 INFO - TEST-INFO | started process 3415 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpodt148/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:18:26 INFO - PROCESS | 3415 | RSS: Main: 165470208 18:18:26 INFO - PROCESS | 3415 | 18:19:16 INFO - PROCESS | 3415 | 1469582356016 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] 18:21:28 INFO - PROCESS | 3415 | Cycle 1(1): loaded http://localhost:48410/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48410/tests/dromaeo/cssquery-ext.html) 18:21:29 INFO - PROCESS | 3415 | RSS: Main: 168284160 18:21:29 INFO - PROCESS | 3415 | 18:24:32 INFO - PROCESS | 3415 | Cycle 1(1): loaded http://localhost:48410/tests/dromaeo/cssquery-ext.html (next: http://localhost:48410/tests/dromaeo/cssquery-jquery.html) 18:24:32 INFO - PROCESS | 3415 | RSS: Main: 166309888 18:24:32 INFO - PROCESS | 3415 | 18:27:34 INFO - PROCESS | 3415 | Cycle 1(1): loaded http://localhost:48410/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48410/tests/dromaeo/cssquery-mootools.html) 18:27:35 INFO - PROCESS | 3415 | RSS: Main: 170905600 18:27:35 INFO - PROCESS | 3415 | 18:30:37 INFO - PROCESS | 3415 | Cycle 1(1): loaded http://localhost:48410/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48410/tests/dromaeo/cssquery-prototype.html) 18:30:37 INFO - PROCESS | 3415 | RSS: Main: 165396480 18:30:37 INFO - PROCESS | 3415 | 18:33:40 INFO - PROCESS | 3415 | Cycle 1(1): loaded http://localhost:48410/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48410/tests/dromaeo/cssquery-yui.html) 18:33:41 INFO - PROCESS | 3415 | RSS: Main: 167251968 18:33:41 INFO - PROCESS | 3415 | 18:36:43 INFO - PROCESS | 3415 | Cycle 1(1): loaded http://localhost:48410/tests/dromaeo/cssquery-yui.html (next: http://localhost:48410/tests/dromaeo/cssquery-dojo.html) 18:36:44 INFO - PROCESS | 3415 | RSS: Main: 170704896 18:36:44 INFO - PROCESS | 3415 | 18:36:44 INFO - PROCESS | 3415 | __start_tp_report 18:36:44 INFO - PROCESS | 3415 | _x_x_mozilla_page_load 18:36:44 INFO - PROCESS | 3415 | _x_x_mozilla_page_load_details 18:36:44 INFO - PROCESS | 3415 | |i|pagename|runs| 18:36:44 INFO - PROCESS | 3415 | |0;dojo.html;2635.499255141523;2641.0360218520223;2670.706222315545;2671.719469455708;2687.7984151188666;4669.556392142749;4780.976095119524;4787.904241915164;4824.782884770185;4834.371531700883;4722.102800467908;4752.215884379073;4762.476127625967;4782.952170478294;4783.282507623858;4354.216241076605;4404.559544045602;4407.162639098561;4427.380166776654;4455.665825063117;4336.414584031147;4442.666799989997;4452.755098469583;4473.060657261979;4532.410786597754;4455.242608756519;4490.9550904491025;4518.661100417466;4528.728276303415;4532.864014079583;4230.090530535949;4322.891927701801;4347.174036933005;4375.25620644488;4389.582989615981;4315.762633055181;4316.482022157361;4340.978295108504;4349.630281426083;4391.736495810262;4712.458067322234;4780.354652121954;4782.593479554242;4791.640626952958;4845.152098382769;4991.051700176955;5026.29631851541;5033.270175824521;5054.444011158769;5077.213031980049;5100.974495127501;5104.923426148611;5108.080545501808;5124.538791508745;5156.226566015091;4641.837535686234;4745.027269409763;4758.666893317469;4771.117343291502;4808.495108013678;5162.3030890830005;5184.403793563789;5206.088934436459;5258.290130832289;5303.893922121536;4999.47505511916;5027.597792176617;5034.322672803737;5054.393472783289;5058.924116138261;4907.312976183337;5141.691498510101;5142.434332223453;5144.742762861842;5152.124138896396;4896.975515122473;4972.627052971042;4972.8756781080765;4974.626902982291;4979.825706100269;5026.52248036436;5030.346055012898;5032.119379108642;5036.899262014813;5037.79848806051;4275.722078064916;4282.357646353072;4283.721558098776;4319.222539942778;4332.263515202423;3695.3533131702384;3729.6083911189476;3736.9439458408146;3754.0239537719845;3772.962270377316;4414.161309351213;4414.249577571821;4430.424044874146;4436.534163912743;4486.528914463999;5062.746862656926;5105.106606343875;5114.3862736471865;5144.125498665236;5150.922736158961;4300.397944287803;4396.450443694538;4418.403515525427;4431.933520997188;4437.445319335083;4566.74882881438;4590.2426099693175;4601.562851529099;4611.16998940194;4628.190066738307;4815.3499277597775;4821.734804585712;4827.61379089672;4855.781489833037;4874.488178741181;4933.531314525115;5044.394672639307;5100.311457953128;5101.8724531887;5139.177731562932;4780.498047704941;4802.351682522814;4809.302651115639;4830;4867.829625963074;4983.651144419856;5037.445880953165;5038.345015148007;5038.571721403721;5041.495850414929;4961.7271050092595;5060.240963855451;5111.846644600668;5116.232565115262;5171.482851714949;4962;4969.875753106056;4970.229614409773;4971.527704868032;4973.5523802857915;4959.677620954626;4963.329950456787;4966.106100901872;4972.5027497249985;4985.925211121764;4713.67004309695;4826.131296366547;4904.6566740327835;4914.189158788903;4955.628327875352;4996.7001979881325;5004.524570165829;5031.74841257943;5037.395512538519;5045.924311135409;4832.8791780205775;4899.093667671492;4922.212446008622;4923.606111511142;4963.602911766978 18:36:44 INFO - PROCESS | 3415 | |1;ext.html;566.0688167963697;566.7364675425928;582.2605291280074;596.6449962272447;607.0105727663913;34877.128071798215;38354.61645383545;38400;38413.887236202034;38599.61400385999;39049.41425878607;39572.40641390382;39627.80186099066;39865.40201896974;39899.202015959665;7373.262673732624;7548.547087174759;7551.358134558542;7556.622168891534;7558.924410755877;7618.123915749677;7707;7708.38332933364;7711.190325015877;7711.383089352838;7700.345470634975;7744.806379840521;7752.030996125484;7754.263344982218;7763.767086987399;7633.274838890296;7653.043369578802;7657.11943126542;7659.119201291867;7702.114256860421;7629.54222746637;7631.35133513652;7647.311741943252;7680.155182929873;7691.115521714963;36195.819020904724;36333;36496.63503364959;36609.45085823715;36668.81665591682;2945.9263518412;2991.7307442330075;2995.1613548206537;3075.3080556874525;3195.872165113393;28280.434391312057;28981.42037159266;29186.562201566994;29690;30047.399052019056;3366.6969972702327;3382.509536117274;3399.7280217582534;3407.8466469008954;3529.94705079424;267158.3062931538;267772;267997;269120;269558;51370.486295137314;52074.47925520772;52107.47892521102;52129.739351303004;52208.73895630497;29218.561721574195;29614.555781663294;29722;29739.405211895642;54470;14477.49328773509;14516;14628.926855365655;14714.852851471349;14752;10897.237193396544;11048.889511104946;11092.778144437067;11124.054455371223;11154.609588664358;18202.362917298095;18216;18276.54308642268;18290.63418731618;18296.725549116774;6541.121906361186;6766.898496522556;6807.829804254933;6974.197967233732;7121.611285799323;731.5574077683032;817;913.9862902056475;926.7173512078881;983.3902980152209;24913.5017299653;26395.47209055808;26489.47021059568;26875.193744187705;27506.449871002467;865.7272959017889;931.3201363004908;936.3913456253354;946.252460556153;952.3048174832411;13577.163247100882;13583.117097388638;13843.792343114861;13926.51257205993;14074.044450665475;432574;435393;436149;438919;440308;49557.50442495529;50138.49861501411;50167.49832501701;50170.749146254035;50211.49788502141;1201.2192075151047;1213.7068219372084;1225.9710179652689;1239.7582471418168;1244.0172263911409;24709.505809883343;24753.50492990166;25392;25642;25965.22104336873;42954.570454295055;43276.35085473784;43364.56635433605;43488.34767478427;43752;374834;376973;377438;377525;378613;25238.74761252364;25549.616755748306;25721.228363149134;25750.484990300465;25813.483730325665;40769.388459172544;41275.38086928758;41381.58618413777;41952.370714439916;42130.789346053076;36820.44769328516;39545.406818898315;40618.59381406148;41332;41641.58358416377;36744.448833266986;36749.81625091964;37151;37426.625733742316;37708.62291377161;31468.685313146576;33198.5020224692;33601.66398336083;34907;35611.64388356187;31412.05763827089;33671.66328336783;33819;34079.318413632085;34136.31727365489;25155.49689006173;25598.360040998377;25659.10193143231;25853.870730646227;25886.010568556318 18:36:44 INFO - PROCESS | 3415 | |2;jquery.html;372.89745320037;379.3210153824653;380.09916497899974;392.46232661254066;396.7143656567274;15936.68126637468;17491.30034798608;17640.558986025357;17724.645507089852;17919.372821951234;16698.916505417455;16855.241514131863;17432.128393580333;17459.650806983853;17524.56188595286;4995.375578052744;5144.331236939192;5152.278680984665;5152.793888244466;5157;3853.730238883279;5081.085404627165;5733.283339582552;5984.132300816379;6034.064719968412;6030.155778191057;6041.909371359433;6065.363136870631;6072.696365181745;6081.391860813927;5877.588568800185;6013.128096426038;6038.3357830638815;6071.210742603455;6082.726277317509;5142.202958541432;5236.8690782730355;5346.331708536433;5346.331708536433;5348.465153484659;21339.146434142614;21380.251691190733;21393.465163370885;21483.78516214849;21539.46151346213;1782.8484578810817;1798.5413719501573;1892.7255547945472;2124.6812978053263;2443.706755189371;13326.466941322335;13487.66280842977;13538.255395953218;13662.52181173664;13886.375113119933;1709.7435384692271;1709.803372612153;1721.9913900430543;1724.2758041622424;1728.4123398044599;71650.64174679146;73022.63488682576;73397.6330118346;74811.62594186995;75137;9652.855207171899;9707.417554946725;9773.9022609773;9809.019098090277;9970.102690757867;13685.657858553417;13740.381682824296;13818.101823381448;13850.584482465541;13852.861471385359;7475;7518.774436766906;7652.885206721904;7740.109887363025;7819.648115834687;7206.171290301578;7297.379722723522;7412.740554080581;7491.475596708178;7610.657520411595;6050.54620903434;6186.536009799283;6226.377362263737;6226.813195604139;6315.210598675166;1533.3789815124892;1595.3538816779223;1637.7461493468531;1790.7492950986873;1853.0642025777165;760.7983884270673;797.0873350014201;824.9587520623945;863.9913600863911;888.8933328000682;16120.355185792672;16425.83574164267;16576.17119144038;16759.162041897856;16778.496645100666;838.6813011055882;854.5129276312566;885.3846576629181;898.4160295807646;917.1104029091771;8705.521196334135;9216.447013179097;9258.72223833286;9331.991269944157;9345.15893569582;311539;313848;317139;405128;414750;58408;70805.64597176982;87189;88814;90576;921.9953900230456;953.952302384878;957.9233661307079;961.2886464016577;963.633819148719;14745.410183592536;15403.07581545111;15493.225338733244;15619.84380156184;16262.024278543326;38356.232875342896;38572;38708.6129138705;39067.41398878962;39830.20339593134;50408.74795626145;55446.72276638591;55957.720211398686;57019.42980570141;57325.713371432874;7266.091738532684;7393.186749457448;7437.181909990005;7462.403007759474;7664.961675191588;9532.809343813224;11697.122715796178;11834.526618935146;11943.283402995849;12147.574834880737;9436.197923176333;9776.902230977883;9873.40759554429;9999.850002250118;10127.240456965905;9436.622535098519;9873.358231714916;10185.388876667424;10268.332558383681;10600.681979540626;9532.475713835805;9542.236621070437;9744.561494732612;9943.154831839374;10108.191344692259;6697.531172817856;6792.184937807495;6804.727810887707;6939.548929319578;7063.328983746535;7327.890081648886;9123.908760912305;9973.850392244267;10201.74495637615;10358.741031474274 18:36:44 INFO - PROCESS | 3415 | |3;mootools.html;1338.0700413212815;1380.5927251460819;1421.225432139484;1629.0470075006122;1646.4237516869098;6331.651759153245;6938.479614028949;7190.6404679766065;7427.2201418851055;7478.06524184477;7255.963720181405;7505.061867266591;7514.81212969676;7520.135184453789;7559.39524838013;2120.660694288914;2152.278986539511;2152.698622192894;2161.373201771484;2162.1783722185546;2110.6939493773393;2169.034779523113;2181.2474696229856;2194.4513871532117;2213.6900833883187;2153.3324669352473;2160.168335190947;2164.3723320237114;2175.619266628342;2177.6951226828255;2126.372720047582;2148.817350525207;2156.7735387784214;2158.6330323844904;2158.751743549496;2074.9273775417787;2122.8301735861096;2123.246247582117;2137.754158271803;2145.678148277755;7514.39884809214;7529.134149572815;7553.8866916996285;7596.9240307596765;7603.961980190119;4348;4376.7811609419405;4379.64962802975;4387.978060109711;4503.954960450419;2709.498742732601;2740.8081434299606;2816.8732407041734;2844.573314002916;2880.2367372646268;882.7528292078229;916.7753900294471;922.2345453273766;925.1026504290827;947.9431234125974;9835.508224588813;9883.604655813759;9924.95037524815;9951.601935922554;9998.400095994191;4011.1376054147913;4140.668746500272;4225.704200705983;4295.6778241632;4305.418768466279;8438.620262088221;8614.827703445895;8622.439541429787;8628.654853805903;8642.3950323478;4453.354263631755;4455.77721113943;4457.77711114443;4462.241418958784;4478.2386994211065;3560.4659301104525;3897.4738410314812;3977.244323578511;4062;4062.878113656595;3520.8239588020497;3523.647635236507;3544.0608238816735;3606.891793246207;3762.7930463824205;1186.6618013866007;1187.619961612293;1199.3463562358536;1222.3399364343154;1230.0528592983353;791.3155120820448;794.4280118314804;805.6414895371621;819.72948926854;831.9542425166674;4922.507749225048;5073.923891141636;5092.9236061459105;5116.948830511722;5127.717975511308;410.9239790638741;411.13045907905166;415.02676224254077;415.5117736659413;416.17389481878445;3390.881319153818;3406.710429613461;3477.23500829817;3479.0606536235073;3520.5951315598522;8587.184217499327;9009.819803603892;9071.954640226888;9080.182783549511;9081.954590227007;8944.01615822259;8956.8656470153;8957.686480973134;8969.775755606031;8977.640894364284;6688.398044176048;6851.965740171367;7055.753048643272;7112.0754301940415;7117.857642847114;5266.420693723764;5270.156774915995;5285.656432331886;5307.310049693515;5351.411344752152;8195.180481951757;8387.706430275155;8445.746627601182;8478.533680647624;8542.871856922027;8086.959565202136;8247.422680412314;8513.106123857153;8522.616482258438;8556.914430855611;5771.278590176228;6245.8757423662355;6379.585326953733;6496.285408604956;6626.304238054935;6885.793426197222;6985;6999;6999.230084690782;7016.789496315118;6334.429346749586;6357.936420635734;6494.7077381517;6568.507361947777;6578.638174900235;6350.4919606432295;6351.968240158954;6368.840778980562;6445.548811583331;6479.287278399278;5962.344142144448;6071.666058366655;6074.544409169242;6076;6085.1480792689945;4445.333200020023;4514.367988481681;4526.072155208109;4542.909141817211;4591.449026116888;4446.333050042519;4553.4763502197675;4556.544345565417;4590;4725.432948046257 18:36:44 INFO - PROCESS | 3415 | |4;prototype.html;308.9397567474342;312.3440774373814;314.4952351475882;319.8752486530254;320.37207074134693;5086.898262034757;5103.183490641498;5104.795808167673;5107.310513080733;5145.7101589792555;5029.47190544993;5047.116754567955;5057.659720174157;5064.721440320781;5067.163917953533;3710.9980305317617;3885.669718073953;3974.403839424095;3980.7412518186225;3986.2426139033637;3967.8375285469488;3969.4045893115976;3973.185496973128;3989.16227592206;3994.3209654358684;3933.15437181006;3944.6844252459878;3946.9210615787665;3955.32759430896;3975.1652153047894;3667.5965643779164;3860.3823388258024;3909.5565271705186;3961.7028722845903;3969.8610548630804;3416.436288012475;3416.7095796857298;3427.657234276577;3428.639992800745;3431.9485207721905;4964.15609346412;4969.478204788517;4979.203327467624;4981.178105612569;4983.551480366748;4174.519930208035;4467.419235499397;4481.574250446202;4486.237339652267;4502.347159661864;5194.584433245332;5240.973795131038;5242.0826355388035;5242.397124330674;5260.500252476008;3727.850885964558;3731.7014638828828;3735.8505659773577;3742.101895545077;3744.2324323513612;5324.7071411072375;5506.834794956158;5509.815389691195;5512.33851937766;5547.25112109868;3785.545734511876;3795.6204379562373;3804.4673745675072;3810.6189381062227;3823.7896915669903;3858.401947698111;3883.2427676603356;3891.7664940103687;3900.531936167678;3903.6291552302487;4467.419235499429;4473.709208901411;4477.238869392211;4477.283634618446;4478.14915166124;5096.261042148868;5279.683219006872;5294.364676238876;5330.866728331745;5339.11904535755;1324.8940084793194;1333.193417982107;1338.6385675867461;1339.6985678222322;1341.155072304442;800.4636893281515;854.1202561361807;859.6217664227845;871.5511511571545;881.3213825354442;4443.733375997386;4604.815807367735;4638.930416043762;4653.7207767534055;4681.953180468152;5406.162044883049;5438.428964958623;5496.532794712414;5498.615096943176;5505.724713764296;4475.888102797456;4634.745089020069;4660.300954856731;4664.790084446208;4694.577488026094;2855.4146399987953;2868.5983962245305;2890.942181156365;2891.797574169788;2901.7678585713093;5135.435102138762;5144;5148.124818780816;5154.5103215194495;5155.896882062338;5403.351597808288;5437.510624043855;5574.693391863405;5601.747921343549;5609.411011843779;5084.8220312288895;5093.159628661229;5120.743962801845;5151.6136289778415;5152.3044389007;5470.671759694431;5481.616286859881;5513.704279494395;5513.9448605513435;5520.53075488588;5132.5124113209185;5321.350381381784;5386.676799392049;5400.810971615974;5416.566674665938;5054.898902022012;5084.63564442536;5100.464451232716;5119.180931051014;5133.435322114639;3806.8477260909253;3817.8472861085247;3824.456736270349;3837.1558257183374;3847;5299.894002120013;5442.292501974718;5445.564354851682;5448.237246785532;5477.972610136924;5259.15853463444;5280.841574752763;5296.867578310573;5303.549198318186;5307.41618421981;5250.212468129811;5282.6038047147385;5315.3621565412395;5322.920156197738;5354.518093371616;4934.901301973869;5161.612879034163;5162.148245539444;5184.300119483973;5215.426303106731;5089.3638295213095;5172.948270517247;5300.542350853546;5301.363836339664;5330.9733451332495;5153.742312884266;5197.21948757413;5213.765380557808;5225.973870130625;5253.527182553588 18:36:44 INFO - PROCESS | 3415 | |5;yui.html;631.8041407163779;737.8819388897778;744.9553026818389;748.0985412577844;753.2091304130659;12570.497180112796;13288.667783305422;13332.800007999876;13357.398917048731;13376.331183440814;12093.093018023661;12275.263484190955;12284.140110192267;12321.260724356545;12405.193662411937;784.8116452051495;792.7740593930731;793.0641842625699;793.738066438074;798.4131663227523;633.395107672172;765.5636287316232;793.6111305460312;796.9043714754238;799.6401619271322;809.7894547417684;813.1502579804119;817.5626040068564;817.6238930092164;818.6029775558849;804.7505273365275;806.2219957740779;806.592670701295;807.1484583764097;808.1393316118374;587.0607028754002;591.136940067502;591.7011908985935;593.3828818029244;594.8810237952426;11845.585404510886;11941.582044628396;11969.64091077269;12000.339981301026;12048.939755301168;12802.80795788064;12873.806892896613;12978.351082445934;13012.154209976416;13397.263150526716;9271.211946984515;9691.12779849817;9843.950780246052;9858.211343092535;9947.651832185911;3122.172624254574;3151.086185006345;3172.825494597796;3185.633652129988;3187.21913131282;64572;65733;65800.67099664471;65884.67057664729;67151.32848671499;10107.797844043078;10301.175905927508;10332.173426125892;10427.426491542887;10486.37081775096;20047;20091.899540502203;20160.092795824225;20223.79776202219;20520.692189617166;5766.798162064391;5822.621529600562;5865.794697185578;5879.941200588025;5930.436608522184;3527.876524321636;3561.4479755637917;3574.982125089358;3638.6179451157777;3656;2683.6645419322585;2756.627855239557;2772.209920172741;2774.5283301838735;2781.8748156333013;449.7121842021109;451.5236425571054;451.94576650802117;459.7632219407008;460.23141353939;443.35270505062323;479.96880202786707;487.20342240436435;494.31290506196416;554.8446434998207;8054.436189466681;8156.67373305073;8190;8258.628361723737;8325.333973282122;568.7440651706748;593.946544810969;607.3167686352853;610.6275172144988;611.1566038866425;3588.6411358864425;3858.2669292834835;3918.8236529356245;3970.5830887756947;4061.810595246456;54971.450285497434;96700.51649741706;99534.5023274879;100529.9841004771;101205.49397252967;78411.60794195993;79634.60182699165;80459.32249931304;81897;83159;72678.63660681662;73016.63491682614;75619.62190189124;76070.23929760742;76178;8416.789580260542;8909;8939.329550283885;9134.5432728362;9344.579493922925;45839;46081.76959115183;47075.76462117668;47434.52565474301;47935.44613261735;62426.68786656038;65642.67178664076;66442.33557664555;66518;69644;11269.830952535882;11519.94240028828;11567.942160289145;11587.188896777145;12089.75820483603;12256.816147757969;12283.938580307042;12546.435410406371;12562.646174406964;13326.067175297636;11920.761584768083;12102.394880256128;12176.75646487083;12238.510459581874;12384.318862462651;12104.334261615344;12259.264444133381;12674.429650665927;12792.552260670831;13084.28036458004;12219.144659873724;12266.877331226573;12502.187357821713;12771.87228127744;12788.808167877676;9829.262805289489;10011.34926229822;10099.646512372032;10225.437600931722;10542.57829686804;9430.387024843363;9909.950450247703;10889;10893.78212435731;10900.890991090304 18:36:44 INFO - PROCESS | 3415 | __end_tp_report 18:36:44 INFO - PROCESS | 3415 | __start_cc_report 18:36:44 INFO - PROCESS | 3415 | _x_x_mozilla_cycle_collect,383 18:36:44 INFO - PROCESS | 3415 | __end_cc_report 18:36:44 INFO - PROCESS | 3415 | __startTimestamp1469583404186__endTimestamp 18:36:44 INFO - PROCESS | 3415 | 18:36:44 INFO - PROCESS | 3415 | ------- Summary: start ------- 18:36:44 INFO - PROCESS | 3415 | Number of tests: 6 18:36:44 INFO - PROCESS | 3415 | 18:36:44 INFO - PROCESS | 3415 | [#0] dojo.html Cycles:165 Average:4709.75 Median:4832.88 stddev:489.62 (10.1%) stddev-sans-first:463.29 18:36:44 INFO - PROCESS | 3415 | Values: 2635.5 2641.0 2670.7 2671.7 2687.8 4669.6 4781.0 4787.9 4824.8 4834.4 4722.1 4752.2 4762.5 4783.0 4783.3 4354.2 4404.6 4407.2 4427.4 4455.7 4336.4 4442.7 4452.8 4473.1 4532.4 4455.2 4491.0 4518.7 4528.7 4532.9 4230.1 4322.9 4347.2 4375.3 4389.6 4315.8 4316.5 4341.0 4349.6 4391.7 4712.5 4780.4 4782.6 4791.6 4845.2 4991.1 5026.3 5033.3 5054.4 5077.2 5101.0 5104.9 5108.1 5124.5 5156.2 4641.8 4745.0 4758.7 4771.1 4808.5 5162.3 5184.4 5206.1 5258.3 5303.9 4999.5 5027.6 5034.3 5054.4 5058.9 4907.3 5141.7 5142.4 5144.7 5152.1 4897.0 4972.6 4972.9 4974.6 4979.8 5026.5 5030.3 5032.1 5036.9 5037.8 4275.7 4282.4 4283.7 4319.2 4332.3 3695.4 3729.6 3736.9 3754.0 3773.0 4414.2 4414.2 4430.4 4436.5 4486.5 5062.7 5105.1 5114.4 5144.1 5150.9 4300.4 4396.5 4418.4 4431.9 4437.4 4566.7 4590.2 4601.6 4611.2 4628.2 4815.3 4821.7 4827.6 4855.8 4874.5 4933.5 5044.4 5100.3 5101.9 5139.2 4780.5 4802.4 4809.3 4830.0 4867.8 4983.7 5037.4 5038.3 5038.6 5041.5 4961.7 5060.2 5111.8 5116.2 5171.5 4962.0 4969.9 4970.2 4971.5 4973.6 4959.7 4963.3 4966.1 4972.5 4985.9 4713.7 4826.1 4904.7 4914.2 4955.6 4996.7 5004.5 5031.7 5037.4 5045.9 4832.9 4899.1 4922.2 4923.6 4963.6 18:36:44 INFO - PROCESS | 3415 | 18:36:44 INFO - PROCESS | 3415 | [#1] ext.html Cycles:180 Average:50187.94 Median:375903.50 stddev:97252.19 (25.9%) stddev-sans-first:97453.64 18:36:44 INFO - PROCESS | 3415 | Values: 566.1 566.7 582.3 596.6 607.0 34877.1 38354.6 38400.0 38413.9 38599.6 39049.4 39572.4 39627.8 39865.4 39899.2 7373.3 7548.5 7551.4 7556.6 7558.9 7618.1 7707.0 7708.4 7711.2 7711.4 7700.3 7744.8 7752.0 7754.3 7763.8 7633.3 7653.0 7657.1 7659.1 7702.1 7629.5 7631.4 7647.3 7680.2 7691.1 36195.8 36333.0 36496.6 36609.5 36668.8 2945.9 2991.7 2995.2 3075.3 3195.9 28280.4 28981.4 29186.6 29690.0 30047.4 3366.7 3382.5 3399.7 3407.8 3529.9 267158.3 267772.0 267997.0 269120.0 269558.0 51370.5 52074.5 52107.5 52129.7 52208.7 29218.6 29614.6 29722.0 29739.4 54470.0 14477.5 14516.0 14628.9 14714.9 14752.0 10897.2 11048.9 11092.8 11124.1 11154.6 18202.4 18216.0 18276.5 18290.6 18296.7 6541.1 6766.9 6807.8 6974.2 7121.6 731.6 817.0 914.0 926.7 983.4 24913.5 26395.5 26489.5 26875.2 27506.4 865.7 931.3 936.4 946.3 952.3 13577.2 13583.1 13843.8 13926.5 14074.0 432574.0 435393.0 436149.0 438919.0 440308.0 49557.5 50138.5 50167.5 50170.7 50211.5 1201.2 1213.7 1226.0 1239.8 1244.0 24709.5 24753.5 25392.0 25642.0 25965.2 42954.6 43276.4 43364.6 43488.3 43752.0 374834.0 376973.0 377438.0 377525.0 378613.0 25238.7 25549.6 25721.2 25750.5 25813.5 40769.4 41275.4 41381.6 41952.4 42130.8 36820.4 39545.4 40618.6 41332.0 41641.6 36744.4 36749.8 37151.0 37426.6 37708.6 31468.7 33198.5 33601.7 34907.0 35611.6 31412.1 33671.7 33819.0 34079.3 34136.3 25155.5 25598.4 25659.1 25853.9 25886.0 18:36:44 INFO - PROCESS | 3415 | 18:36:44 INFO - PROCESS | 3415 | [#2] jquery.html Cycles:180 Average:23778.96 Median:56488.58 stddev:59226.11 (104.8%) stddev-sans-first:59366.18 18:36:44 INFO - PROCESS | 3415 | Values: 372.9 379.3 380.1 392.5 396.7 15936.7 17491.3 17640.6 17724.6 17919.4 16698.9 16855.2 17432.1 17459.7 17524.6 4995.4 5144.3 5152.3 5152.8 5157.0 3853.7 5081.1 5733.3 5984.1 6034.1 6030.2 6041.9 6065.4 6072.7 6081.4 5877.6 6013.1 6038.3 6071.2 6082.7 5142.2 5236.9 5346.3 5346.3 5348.5 21339.1 21380.3 21393.5 21483.8 21539.5 1782.8 1798.5 1892.7 2124.7 2443.7 13326.5 13487.7 13538.3 13662.5 13886.4 1709.7 1709.8 1722.0 1724.3 1728.4 71650.6 73022.6 73397.6 74811.6 75137.0 9652.9 9707.4 9773.9 9809.0 9970.1 13685.7 13740.4 13818.1 13850.6 13852.9 7475.0 7518.8 7652.9 7740.1 7819.6 7206.2 7297.4 7412.7 7491.5 7610.7 6050.5 6186.5 6226.4 6226.8 6315.2 1533.4 1595.4 1637.7 1790.7 1853.1 760.8 797.1 825.0 864.0 888.9 16120.4 16425.8 16576.2 16759.2 16778.5 838.7 854.5 885.4 898.4 917.1 8705.5 9216.4 9258.7 9332.0 9345.2 311539.0 313848.0 317139.0 405128.0 414750.0 58408.0 70805.6 87189.0 88814.0 90576.0 922.0 954.0 957.9 961.3 963.6 14745.4 15403.1 15493.2 15619.8 16262.0 38356.2 38572.0 38708.6 39067.4 39830.2 50408.7 55446.7 55957.7 57019.4 57325.7 7266.1 7393.2 7437.2 7462.4 7665.0 9532.8 11697.1 11834.5 11943.3 12147.6 9436.2 9776.9 9873.4 9999.9 10127.2 9436.6 9873.4 10185.4 10268.3 10600.7 9532.5 9542.2 9744.6 9943.2 10108.2 6697.5 6792.2 6804.7 6939.5 7063.3 7327.9 9123.9 9973.9 10201.7 10358.7 18:36:44 INFO - PROCESS | 3415 | 18:36:44 INFO - PROCESS | 3415 | [#3] mootools.html Cycles:180 Average:4899.06 Median:5268.29 stddev:2685.39 (51.0%) stddev-sans-first:2679.58 18:36:44 INFO - PROCESS | 3415 | Values: 1338.1 1380.6 1421.2 1629.0 1646.4 6331.7 6938.5 7190.6 7427.2 7478.1 7256.0 7505.1 7514.8 7520.1 7559.4 2120.7 2152.3 2152.7 2161.4 2162.2 2110.7 2169.0 2181.2 2194.5 2213.7 2153.3 2160.2 2164.4 2175.6 2177.7 2126.4 2148.8 2156.8 2158.6 2158.8 2074.9 2122.8 2123.2 2137.8 2145.7 7514.4 7529.1 7553.9 7596.9 7604.0 4348.0 4376.8 4379.6 4388.0 4504.0 2709.5 2740.8 2816.9 2844.6 2880.2 882.8 916.8 922.2 925.1 947.9 9835.5 9883.6 9925.0 9951.6 9998.4 4011.1 4140.7 4225.7 4295.7 4305.4 8438.6 8614.8 8622.4 8628.7 8642.4 4453.4 4455.8 4457.8 4462.2 4478.2 3560.5 3897.5 3977.2 4062.0 4062.9 3520.8 3523.6 3544.1 3606.9 3762.8 1186.7 1187.6 1199.3 1222.3 1230.1 791.3 794.4 805.6 819.7 832.0 4922.5 5073.9 5092.9 5116.9 5127.7 410.9 411.1 415.0 415.5 416.2 3390.9 3406.7 3477.2 3479.1 3520.6 8587.2 9009.8 9072.0 9080.2 9082.0 8944.0 8956.9 8957.7 8969.8 8977.6 6688.4 6852.0 7055.8 7112.1 7117.9 5266.4 5270.2 5285.7 5307.3 5351.4 8195.2 8387.7 8445.7 8478.5 8542.9 8087.0 8247.4 8513.1 8522.6 8556.9 5771.3 6245.9 6379.6 6496.3 6626.3 6885.8 6985.0 6999.0 6999.2 7016.8 6334.4 6357.9 6494.7 6568.5 6578.6 6350.5 6352.0 6368.8 6445.5 6479.3 5962.3 6071.7 6074.5 6076.0 6085.1 4445.3 4514.4 4526.1 4542.9 4591.4 4446.3 4553.5 4556.5 4590.0 4725.4 18:36:44 INFO - PROCESS | 3415 | 18:36:44 INFO - PROCESS | 3415 | [#4] prototype.html Cycles:180 Average:4383.79 Median:5065.94 stddev:1282.54 (25.3%) stddev-sans-first:1249.14 18:36:44 INFO - PROCESS | 3415 | Values: 308.9 312.3 314.5 319.9 320.4 5086.9 5103.2 5104.8 5107.3 5145.7 5029.5 5047.1 5057.7 5064.7 5067.2 3711.0 3885.7 3974.4 3980.7 3986.2 3967.8 3969.4 3973.2 3989.2 3994.3 3933.2 3944.7 3946.9 3955.3 3975.2 3667.6 3860.4 3909.6 3961.7 3969.9 3416.4 3416.7 3427.7 3428.6 3431.9 4964.2 4969.5 4979.2 4981.2 4983.6 4174.5 4467.4 4481.6 4486.2 4502.3 5194.6 5241.0 5242.1 5242.4 5260.5 3727.9 3731.7 3735.9 3742.1 3744.2 5324.7 5506.8 5509.8 5512.3 5547.3 3785.5 3795.6 3804.5 3810.6 3823.8 3858.4 3883.2 3891.8 3900.5 3903.6 4467.4 4473.7 4477.2 4477.3 4478.1 5096.3 5279.7 5294.4 5330.9 5339.1 1324.9 1333.2 1338.6 1339.7 1341.2 800.5 854.1 859.6 871.6 881.3 4443.7 4604.8 4638.9 4653.7 4682.0 5406.2 5438.4 5496.5 5498.6 5505.7 4475.9 4634.7 4660.3 4664.8 4694.6 2855.4 2868.6 2890.9 2891.8 2901.8 5135.4 5144.0 5148.1 5154.5 5155.9 5403.4 5437.5 5574.7 5601.7 5609.4 5084.8 5093.2 5120.7 5151.6 5152.3 5470.7 5481.6 5513.7 5513.9 5520.5 5132.5 5321.4 5386.7 5400.8 5416.6 5054.9 5084.6 5100.5 5119.2 5133.4 3806.8 3817.8 3824.5 3837.2 3847.0 5299.9 5442.3 5445.6 5448.2 5478.0 5259.2 5280.8 5296.9 5303.5 5307.4 5250.2 5282.6 5315.4 5322.9 5354.5 4934.9 5161.6 5162.1 5184.3 5215.4 5089.4 5172.9 5300.5 5301.4 5331.0 5153.7 5197.2 5213.8 5226.0 5253.5 18:36:44 INFO - PROCESS | 3415 | 18:36:44 INFO - PROCESS | 3415 | [#5] yui.html Cycles:180 Average:17777.02 Median:23271.00 stddev:25129.75 (108.0%) stddev-sans-first:25167.27 18:36:44 INFO - PROCESS | 3415 | Values: 631.8 737.9 745.0 748.1 753.2 12570.5 13288.7 13332.8 13357.4 13376.3 12093.1 12275.3 12284.1 12321.3 12405.2 784.8 792.8 793.1 793.7 798.4 633.4 765.6 793.6 796.9 799.6 809.8 813.2 817.6 817.6 818.6 804.8 806.2 806.6 807.1 808.1 587.1 591.1 591.7 593.4 594.9 11845.6 11941.6 11969.6 12000.3 12048.9 12802.8 12873.8 12978.4 13012.2 13397.3 9271.2 9691.1 9844.0 9858.2 9947.7 3122.2 3151.1 3172.8 3185.6 3187.2 64572.0 65733.0 65800.7 65884.7 67151.3 10107.8 10301.2 10332.2 10427.4 10486.4 20047.0 20091.9 20160.1 20223.8 20520.7 5766.8 5822.6 5865.8 5879.9 5930.4 3527.9 3561.4 3575.0 3638.6 3656.0 2683.7 2756.6 2772.2 2774.5 2781.9 449.7 451.5 451.9 459.8 460.2 443.4 480.0 487.2 494.3 554.8 8054.4 8156.7 8190.0 8258.6 8325.3 568.7 593.9 607.3 610.6 611.2 3588.6 3858.3 3918.8 3970.6 4061.8 54971.5 96700.5 99534.5 100530.0 101205.5 78411.6 79634.6 80459.3 81897.0 83159.0 72678.6 73016.6 75619.6 76070.2 76178.0 8416.8 8909.0 8939.3 9134.5 9344.6 45839.0 46081.8 47075.8 47434.5 47935.4 62426.7 65642.7 66442.3 66518.0 69644.0 11269.8 11519.9 11567.9 11587.2 12089.8 12256.8 12283.9 12546.4 12562.6 13326.1 11920.8 12102.4 12176.8 12238.5 12384.3 12104.3 12259.3 12674.4 12792.6 13084.3 12219.1 12266.9 12502.2 12771.9 12788.8 9829.3 10011.3 10099.6 10225.4 10542.6 9430.4 9910.0 10889.0 10893.8 10900.9 18:36:44 INFO - PROCESS | 3415 | -------- Summary: end -------- 18:36:44 INFO - PROCESS | 3415 | 18:36:44 INFO - TEST-INFO | 3415: exit 0 18:36:44 INFO - TEST-OK | dromaeo_css | took 1118767ms 18:36:44 INFO - TEST-START | kraken 18:36:44 INFO - operating with platform_type : linux_ 18:36:44 INFO - Initialising browser for kraken test... 18:36:45 INFO - TEST-INFO | started process 3656 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo_y8p6/profile http://localhost:48410/getInfo.html) 18:36:48 INFO - PROCESS | 3656 | JavaScript error: , line 0: uncaught exception: undefined 18:36:50 INFO - PROCESS | 3656 | __metrics Screen width/height:1600/1200 18:36:50 INFO - PROCESS | 3656 | colorDepth:24 18:36:50 INFO - PROCESS | 3656 | Browser inner width/height: 1024/697 18:36:50 INFO - PROCESS | 3656 | __metrics 18:36:50 ERROR - PROCESS | 3656 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 18:36:51 INFO - TEST-INFO | 3656: exit 0 18:36:51 INFO - Browser initialized. 18:36:51 INFO - Running cycle 1/1 for kraken test... 18:36:51 INFO - TEST-INFO | started process 3772 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo_y8p6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:37:03 INFO - PROCESS | 3772 | RSS: Main: 165609472 18:37:03 INFO - PROCESS | 3772 | 18:37:06 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:48410/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48410/tests/kraken/driver.html?testName=audio-beat-detection) 18:37:07 INFO - PROCESS | 3772 | RSS: Main: 170606592 18:37:07 INFO - PROCESS | 3772 | 18:37:10 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:48410/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48410/tests/kraken/driver.html?testName=audio-dft) 18:37:10 INFO - PROCESS | 3772 | RSS: Main: 170008576 18:37:10 INFO - PROCESS | 3772 | 18:37:13 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:48410/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48410/tests/kraken/driver.html?testName=audio-fft) 18:37:14 INFO - PROCESS | 3772 | RSS: Main: 166064128 18:37:14 INFO - PROCESS | 3772 | 18:37:16 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:48410/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48410/tests/kraken/driver.html?testName=audio-oscillator) 18:37:17 INFO - PROCESS | 3772 | RSS: Main: 166637568 18:37:17 INFO - PROCESS | 3772 | 18:37:19 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:48410/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48410/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:37:19 INFO - PROCESS | 3772 | RSS: Main: 167219200 18:37:19 INFO - PROCESS | 3772 | 18:37:23 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:48410/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48410/tests/kraken/driver.html?testName=imaging-darkroom) 18:37:23 INFO - PROCESS | 3772 | RSS: Main: 167206912 18:37:23 INFO - PROCESS | 3772 | 18:37:27 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:48410/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48410/tests/kraken/driver.html?testName=imaging-desaturate) 18:37:27 INFO - PROCESS | 3772 | RSS: Main: 164290560 18:37:27 INFO - PROCESS | 3772 | 18:37:30 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:48410/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48410/tests/kraken/driver.html?testName=json-parse-financial) 18:37:31 INFO - PROCESS | 3772 | RSS: Main: 166834176 18:37:31 INFO - PROCESS | 3772 | 18:37:33 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:48410/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48410/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:37:33 INFO - PROCESS | 3772 | RSS: Main: 166592512 18:37:33 INFO - PROCESS | 3772 | 18:37:35 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:48410/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48410/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:37:36 INFO - PROCESS | 3772 | RSS: Main: 166719488 18:37:36 INFO - PROCESS | 3772 | 18:37:38 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:48410/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48410/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:37:39 INFO - PROCESS | 3772 | RSS: Main: 167546880 18:37:39 INFO - PROCESS | 3772 | 18:37:43 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:48410/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48410/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:37:43 INFO - PROCESS | 3772 | RSS: Main: 165318656 18:37:43 INFO - PROCESS | 3772 | 18:37:46 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:48410/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48410/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:37:47 INFO - PROCESS | 3772 | RSS: Main: 166772736 18:37:47 INFO - PROCESS | 3772 | 18:37:49 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:48410/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48410/tests/kraken/driver.html?testName=ai-astar) 18:37:49 INFO - PROCESS | 3772 | RSS: Main: 168464384 18:37:49 INFO - PROCESS | 3772 | 18:37:49 INFO - PROCESS | 3772 | __start_tp_report 18:37:49 INFO - PROCESS | 3772 | _x_x_mozilla_page_load 18:37:49 INFO - PROCESS | 3772 | _x_x_mozilla_page_load_details 18:37:49 INFO - PROCESS | 3772 | |i|pagename|runs| 18:37:49 INFO - PROCESS | 3772 | |0;ai-astar;103;117;107;114;115;114;114;113;114;113 18:37:49 INFO - PROCESS | 3772 | |1;audio-beat-detection;153;124;144;177;125;146;149;125;173;125 18:37:49 INFO - PROCESS | 3772 | |2;audio-dft;163;164;165;167;168;163;163;162;162;162 18:37:49 INFO - PROCESS | 3772 | |3;audio-fft;75;79;77;173;77;76;76;76;163;77 18:37:49 INFO - PROCESS | 3772 | |4;audio-oscillator;84;85;145;85;85;86;138;86;85;132 18:37:49 INFO - PROCESS | 3772 | |5;imaging-gaussian-blur;118;118;119;119;118;117;118;118;117;118 18:37:49 INFO - PROCESS | 3772 | |6;imaging-darkroom;147;148;148;148;148;148;148;148;149;150 18:37:49 INFO - PROCESS | 3772 | |7;imaging-desaturate;95;95;96;96;95;96;95;96;95;95 18:37:49 INFO - PROCESS | 3772 | |8;json-parse-financial;62;66;64;63;65;63;65;65;62;63 18:37:49 INFO - PROCESS | 3772 | |9;json-stringify-tinderbox;66;67;66;67;65;66;66;66;67;66 18:37:49 INFO - PROCESS | 3772 | |10;stanford-crypto-aes;84;86;80;80;86;79;79;80;83;82 18:37:49 INFO - PROCESS | 3772 | |11;stanford-crypto-ccm;139;131;145;132;132;142;140;146;177;133 18:37:49 INFO - PROCESS | 3772 | |12;stanford-crypto-pbkdf2;169;175;174;167;168;167;172;165;168;169 18:37:49 INFO - PROCESS | 3772 | |13;stanford-crypto-sha256-iterative;70;69;67;68;70;66;67;66;66;70 18:37:49 INFO - PROCESS | 3772 | __end_tp_report 18:37:49 INFO - PROCESS | 3772 | __start_cc_report 18:37:49 INFO - PROCESS | 3772 | _x_x_mozilla_cycle_collect,984 18:37:49 INFO - PROCESS | 3772 | __end_cc_report 18:37:49 INFO - PROCESS | 3772 | __startTimestamp1469583469336__endTimestamp 18:37:49 INFO - PROCESS | 3772 | 18:37:49 INFO - PROCESS | 3772 | ------- Summary: start ------- 18:37:49 INFO - PROCESS | 3772 | Number of tests: 14 18:37:49 INFO - PROCESS | 3772 | 18:37:49 INFO - PROCESS | 3772 | [#0] ai-astar Cycles:10 Average:112.40 Median:114.00 stddev:4.17 (3.7%) stddev-sans-first:2.70 18:37:49 INFO - PROCESS | 3772 | Values: 103.0 117.0 107.0 114.0 115.0 114.0 114.0 113.0 114.0 113.0 18:37:49 INFO - PROCESS | 3772 | 18:37:49 INFO - PROCESS | 3772 | [#1] audio-beat-detection Cycles:10 Average:144.10 Median:147.50 stddev:19.78 (13.4%) stddev-sans-first:20.72 18:37:49 INFO - PROCESS | 3772 | Values: 153.0 124.0 144.0 177.0 125.0 146.0 149.0 125.0 173.0 125.0 18:37:49 INFO - PROCESS | 3772 | 18:37:49 INFO - PROCESS | 3772 | [#2] audio-dft Cycles:10 Average:163.90 Median:163.50 stddev:2.13 (1.3%) stddev-sans-first:2.24 18:37:49 INFO - PROCESS | 3772 | Values: 163.0 164.0 165.0 167.0 168.0 163.0 163.0 162.0 162.0 162.0 18:37:49 INFO - PROCESS | 3772 | 18:37:49 INFO - PROCESS | 3772 | [#3] audio-fft Cycles:10 Average:94.90 Median:76.50 stddev:38.61 (50.5%) stddev-sans-first:40.28 18:37:49 INFO - PROCESS | 3772 | Values: 75.0 79.0 77.0 173.0 77.0 76.0 76.0 76.0 163.0 77.0 18:37:49 INFO - PROCESS | 3772 | 18:37:49 INFO - PROCESS | 3772 | [#4] audio-oscillator Cycles:10 Average:101.10 Median:85.00 stddev:25.88 (30.4%) stddev-sans-first:26.70 18:37:49 INFO - PROCESS | 3772 | Values: 84.0 85.0 145.0 85.0 85.0 86.0 138.0 86.0 85.0 132.0 18:37:49 INFO - PROCESS | 3772 | 18:37:49 INFO - PROCESS | 3772 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 18:37:49 INFO - PROCESS | 3772 | Values: 118.0 118.0 119.0 119.0 118.0 117.0 118.0 118.0 117.0 118.0 18:37:49 INFO - PROCESS | 3772 | 18:37:49 INFO - PROCESS | 3772 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:0.79 (0.5%) stddev-sans-first:0.71 18:37:49 INFO - PROCESS | 3772 | Values: 147.0 148.0 148.0 148.0 148.0 148.0 148.0 148.0 149.0 150.0 18:37:49 INFO - PROCESS | 3772 | 18:37:49 INFO - PROCESS | 3772 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 18:37:49 INFO - PROCESS | 3772 | Values: 95.0 95.0 96.0 96.0 95.0 96.0 95.0 96.0 95.0 95.0 18:37:49 INFO - PROCESS | 3772 | 18:37:49 INFO - PROCESS | 3772 | [#8] json-parse-financial Cycles:10 Average:63.80 Median:64.50 stddev:1.40 (2.2%) stddev-sans-first:1.32 18:37:49 INFO - PROCESS | 3772 | Values: 62.0 66.0 64.0 63.0 65.0 63.0 65.0 65.0 62.0 63.0 18:37:49 INFO - PROCESS | 3772 | 18:37:49 INFO - PROCESS | 3772 | [#9] json-stringify-tinderbox Cycles:10 Average:66.20 Median:66.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 18:37:49 INFO - PROCESS | 3772 | Values: 66.0 67.0 66.0 67.0 65.0 66.0 66.0 66.0 67.0 66.0 18:37:49 INFO - PROCESS | 3772 | 18:37:49 INFO - PROCESS | 3772 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:82.50 stddev:2.73 (3.3%) stddev-sans-first:2.78 18:37:49 INFO - PROCESS | 3772 | Values: 84.0 86.0 80.0 80.0 86.0 79.0 79.0 80.0 83.0 82.0 18:37:49 INFO - PROCESS | 3772 | 18:37:49 INFO - PROCESS | 3772 | [#11] stanford-crypto-ccm Cycles:10 Average:141.70 Median:141.00 stddev:13.60 (9.6%) stddev-sans-first:14.39 18:37:49 INFO - PROCESS | 3772 | Values: 139.0 131.0 145.0 132.0 132.0 142.0 140.0 146.0 177.0 133.0 18:37:49 INFO - PROCESS | 3772 | 18:37:49 INFO - PROCESS | 3772 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.40 Median:169.00 stddev:3.24 (1.9%) stddev-sans-first:3.43 18:37:49 INFO - PROCESS | 3772 | Values: 169.0 175.0 174.0 167.0 168.0 167.0 172.0 165.0 168.0 169.0 18:37:49 INFO - PROCESS | 3772 | 18:37:49 INFO - PROCESS | 3772 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.50 stddev:1.73 (2.5%) stddev-sans-first:1.66 18:37:49 INFO - PROCESS | 3772 | Values: 70.0 69.0 67.0 68.0 70.0 66.0 67.0 66.0 66.0 70.0 18:37:49 INFO - PROCESS | 3772 | -------- Summary: end -------- 18:37:49 INFO - PROCESS | 3772 | 18:37:50 INFO - TEST-INFO | 3772: exit 0 18:37:50 INFO - TEST-OK | kraken | took 65481ms 18:37:50 INFO - SUITE-END | took 1184s 18:37:50 INFO - Completed test suite (00:19:44) 18:37:50 INFO - javascript benchmark 18:37:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6404.810059834257, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2635.499255141523, 2641.0360218520223, 2670.706222315545, 2671.719469455708, 2687.7984151188666, 4669.556392142749, 4780.976095119524, 4787.904241915164, 4824.782884770185, 4834.371531700883, 4722.102800467908, 4752.215884379073, 4762.476127625967, 4782.952170478294, 4783.282507623858, 4354.216241076605, 4404.559544045602, 4407.162639098561, 4427.380166776654, 4455.665825063117, 4336.414584031147, 4442.666799989997, 4452.755098469583, 4473.060657261979, 4532.410786597754, 4455.242608756519, 4490.9550904491025, 4518.661100417466, 4528.728276303415, 4532.864014079583, 4230.090530535949, 4322.891927701801, 4347.174036933005, 4375.25620644488, 4389.582989615981, 4315.762633055181, 4316.482022157361, 4340.978295108504, 4349.630281426083, 4391.736495810262, 4712.458067322234, 4780.354652121954, 4782.593479554242, 4791.640626952958, 4845.152098382769, 4991.051700176955, 5026.29631851541, 5033.270175824521, 5054.444011158769, 5077.213031980049, 5100.974495127501, 5104.923426148611, 5108.080545501808, 5124.538791508745, 5156.226566015091, 4641.837535686234, 4745.027269409763, 4758.666893317469, 4771.117343291502, 4808.495108013678, 5162.3030890830005, 5184.403793563789, 5206.088934436459, 5258.290130832289, 5303.893922121536, 4999.47505511916, 5027.597792176617, 5034.322672803737, 5054.393472783289, 5058.924116138261, 4907.312976183337, 5141.691498510101, 5142.434332223453, 5144.742762861842, 5152.124138896396, 4896.975515122473, 4972.627052971042, 4972.8756781080765, 4974.626902982291, 4979.825706100269, 5026.52248036436, 5030.346055012898, 5032.119379108642, 5036.899262014813, 5037.79848806051, 4275.722078064916, 4282.357646353072, 4283.721558098776, 4319.222539942778, 4332.263515202423, 3695.3533131702384, 3729.6083911189476, 3736.9439458408146, 3754.0239537719845, 3772.962270377316, 4414.161309351213, 4414.249577571821, 4430.424044874146, 4436.534163912743, 4486.528914463999, 5062.746862656926, 5105.106606343875, 5114.3862736471865, 5144.125498665236, 5150.922736158961, 4300.397944287803, 4396.450443694538, 4418.403515525427, 4431.933520997188, 4437.445319335083, 4566.74882881438, 4590.2426099693175, 4601.562851529099, 4611.16998940194, 4628.190066738307, 4815.3499277597775, 4821.734804585712, 4827.61379089672, 4855.781489833037, 4874.488178741181, 4933.531314525115, 5044.394672639307, 5100.311457953128, 5101.8724531887, 5139.177731562932, 4780.498047704941, 4802.351682522814, 4809.302651115639, 4830.0, 4867.829625963074, 4983.651144419856, 5037.445880953165, 5038.345015148007, 5038.571721403721, 5041.495850414929, 4961.7271050092595, 5060.240963855451, 5111.846644600668, 5116.232565115262, 5171.482851714949, 4962.0, 4969.875753106056, 4970.229614409773, 4971.527704868032, 4973.5523802857915, 4959.677620954626, 4963.329950456787, 4966.106100901872, 4972.5027497249985, 4985.925211121764, 4713.67004309695, 4826.131296366547, 4904.6566740327835, 4914.189158788903, 4955.628327875352, 4996.7001979881325, 5004.524570165829, 5031.74841257943, 5037.395512538519, 5045.924311135409, 4832.8791780205775, 4899.093667671492, 4922.212446008622, 4923.606111511142, 4963.602911766978], "value": 4678.5217628203745, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.0688167963697, 566.7364675425928, 582.2605291280074, 596.6449962272447, 607.0105727663913, 34877.128071798215, 38354.61645383545, 38400.0, 38413.887236202034, 38599.61400385999, 39049.41425878607, 39572.40641390382, 39627.80186099066, 39865.40201896974, 39899.202015959665, 7373.262673732624, 7548.547087174759, 7551.358134558542, 7556.622168891534, 7558.924410755877, 7618.123915749677, 7707.0, 7708.38332933364, 7711.190325015877, 7711.383089352838, 7700.345470634975, 7744.806379840521, 7752.030996125484, 7754.263344982218, 7763.767086987399, 7633.274838890296, 7653.043369578802, 7657.11943126542, 7659.119201291867, 7702.114256860421, 7629.54222746637, 7631.35133513652, 7647.311741943252, 7680.155182929873, 7691.115521714963, 36195.819020904724, 36333.0, 36496.63503364959, 36609.45085823715, 36668.81665591682, 2945.9263518412, 2991.7307442330075, 2995.1613548206537, 3075.3080556874525, 3195.872165113393, 28280.434391312057, 28981.42037159266, 29186.562201566994, 29690.0, 30047.399052019056, 3366.6969972702327, 3382.509536117274, 3399.7280217582534, 3407.8466469008954, 3529.94705079424, 267158.3062931538, 267772.0, 267997.0, 269120.0, 269558.0, 51370.486295137314, 52074.47925520772, 52107.47892521102, 52129.739351303004, 52208.73895630497, 29218.561721574195, 29614.555781663294, 29722.0, 29739.405211895642, 54470.0, 14477.49328773509, 14516.0, 14628.926855365655, 14714.852851471349, 14752.0, 10897.237193396544, 11048.889511104946, 11092.778144437067, 11124.054455371223, 11154.609588664358, 18202.362917298095, 18216.0, 18276.54308642268, 18290.63418731618, 18296.725549116774, 6541.121906361186, 6766.898496522556, 6807.829804254933, 6974.197967233732, 7121.611285799323, 731.5574077683032, 817.0, 913.9862902056475, 926.7173512078881, 983.3902980152209, 24913.5017299653, 26395.47209055808, 26489.47021059568, 26875.193744187705, 27506.449871002467, 865.7272959017889, 931.3201363004908, 936.3913456253354, 946.252460556153, 952.3048174832411, 13577.163247100882, 13583.117097388638, 13843.792343114861, 13926.51257205993, 14074.044450665475, 432574.0, 435393.0, 436149.0, 438919.0, 440308.0, 49557.50442495529, 50138.49861501411, 50167.49832501701, 50170.749146254035, 50211.49788502141, 1201.2192075151047, 1213.7068219372084, 1225.9710179652689, 1239.7582471418168, 1244.0172263911409, 24709.505809883343, 24753.50492990166, 25392.0, 25642.0, 25965.22104336873, 42954.570454295055, 43276.35085473784, 43364.56635433605, 43488.34767478427, 43752.0, 374834.0, 376973.0, 377438.0, 377525.0, 378613.0, 25238.74761252364, 25549.616755748306, 25721.228363149134, 25750.484990300465, 25813.483730325665, 40769.388459172544, 41275.38086928758, 41381.58618413777, 41952.370714439916, 42130.789346053076, 36820.44769328516, 39545.406818898315, 40618.59381406148, 41332.0, 41641.58358416377, 36744.448833266986, 36749.81625091964, 37151.0, 37426.625733742316, 37708.62291377161, 31468.685313146576, 33198.5020224692, 33601.66398336083, 34907.0, 35611.64388356187, 31412.05763827089, 33671.66328336783, 33819.0, 34079.318413632085, 34136.31727365489, 25155.49689006173, 25598.360040998377, 25659.10193143231, 25853.870730646227, 25886.010568556318], "value": 17299.790634565874, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.89745320037, 379.3210153824653, 380.09916497899974, 392.46232661254066, 396.7143656567274, 15936.68126637468, 17491.30034798608, 17640.558986025357, 17724.645507089852, 17919.372821951234, 16698.916505417455, 16855.241514131863, 17432.128393580333, 17459.650806983853, 17524.56188595286, 4995.375578052744, 5144.331236939192, 5152.278680984665, 5152.793888244466, 5157.0, 3853.730238883279, 5081.085404627165, 5733.283339582552, 5984.132300816379, 6034.064719968412, 6030.155778191057, 6041.909371359433, 6065.363136870631, 6072.696365181745, 6081.391860813927, 5877.588568800185, 6013.128096426038, 6038.3357830638815, 6071.210742603455, 6082.726277317509, 5142.202958541432, 5236.8690782730355, 5346.331708536433, 5346.331708536433, 5348.465153484659, 21339.146434142614, 21380.251691190733, 21393.465163370885, 21483.78516214849, 21539.46151346213, 1782.8484578810817, 1798.5413719501573, 1892.7255547945472, 2124.6812978053263, 2443.706755189371, 13326.466941322335, 13487.66280842977, 13538.255395953218, 13662.52181173664, 13886.375113119933, 1709.7435384692271, 1709.803372612153, 1721.9913900430543, 1724.2758041622424, 1728.4123398044599, 71650.64174679146, 73022.63488682576, 73397.6330118346, 74811.62594186995, 75137.0, 9652.855207171899, 9707.417554946725, 9773.9022609773, 9809.019098090277, 9970.102690757867, 13685.657858553417, 13740.381682824296, 13818.101823381448, 13850.584482465541, 13852.861471385359, 7475.0, 7518.774436766906, 7652.885206721904, 7740.109887363025, 7819.648115834687, 7206.171290301578, 7297.379722723522, 7412.740554080581, 7491.475596708178, 7610.657520411595, 6050.54620903434, 6186.536009799283, 6226.377362263737, 6226.813195604139, 6315.210598675166, 1533.3789815124892, 1595.3538816779223, 1637.7461493468531, 1790.7492950986873, 1853.0642025777165, 760.7983884270673, 797.0873350014201, 824.9587520623945, 863.9913600863911, 888.8933328000682, 16120.355185792672, 16425.83574164267, 16576.17119144038, 16759.162041897856, 16778.496645100666, 838.6813011055882, 854.5129276312566, 885.3846576629181, 898.4160295807646, 917.1104029091771, 8705.521196334135, 9216.447013179097, 9258.72223833286, 9331.991269944157, 9345.15893569582, 311539.0, 313848.0, 317139.0, 405128.0, 414750.0, 58408.0, 70805.64597176982, 87189.0, 88814.0, 90576.0, 921.9953900230456, 953.952302384878, 957.9233661307079, 961.2886464016577, 963.633819148719, 14745.410183592536, 15403.07581545111, 15493.225338733244, 15619.84380156184, 16262.024278543326, 38356.232875342896, 38572.0, 38708.6129138705, 39067.41398878962, 39830.20339593134, 50408.74795626145, 55446.72276638591, 55957.720211398686, 57019.42980570141, 57325.713371432874, 7266.091738532684, 7393.186749457448, 7437.181909990005, 7462.403007759474, 7664.961675191588, 9532.809343813224, 11697.122715796178, 11834.526618935146, 11943.283402995849, 12147.574834880737, 9436.197923176333, 9776.902230977883, 9873.40759554429, 9999.850002250118, 10127.240456965905, 9436.622535098519, 9873.358231714916, 10185.388876667424, 10268.332558383681, 10600.681979540626, 9532.475713835805, 9542.236621070437, 9744.561494732612, 9943.154831839374, 10108.191344692259, 6697.531172817856, 6792.184937807495, 6804.727810887707, 6939.548929319578, 7063.328983746535, 7327.890081648886, 9123.908760912305, 9973.850392244267, 10201.74495637615, 10358.741031474274], "value": 8396.54369042546, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1338.0700413212815, 1380.5927251460819, 1421.225432139484, 1629.0470075006122, 1646.4237516869098, 6331.651759153245, 6938.479614028949, 7190.6404679766065, 7427.2201418851055, 7478.06524184477, 7255.963720181405, 7505.061867266591, 7514.81212969676, 7520.135184453789, 7559.39524838013, 2120.660694288914, 2152.278986539511, 2152.698622192894, 2161.373201771484, 2162.1783722185546, 2110.6939493773393, 2169.034779523113, 2181.2474696229856, 2194.4513871532117, 2213.6900833883187, 2153.3324669352473, 2160.168335190947, 2164.3723320237114, 2175.619266628342, 2177.6951226828255, 2126.372720047582, 2148.817350525207, 2156.7735387784214, 2158.6330323844904, 2158.751743549496, 2074.9273775417787, 2122.8301735861096, 2123.246247582117, 2137.754158271803, 2145.678148277755, 7514.39884809214, 7529.134149572815, 7553.8866916996285, 7596.9240307596765, 7603.961980190119, 4348.0, 4376.7811609419405, 4379.64962802975, 4387.978060109711, 4503.954960450419, 2709.498742732601, 2740.8081434299606, 2816.8732407041734, 2844.573314002916, 2880.2367372646268, 882.7528292078229, 916.7753900294471, 922.2345453273766, 925.1026504290827, 947.9431234125974, 9835.508224588813, 9883.604655813759, 9924.95037524815, 9951.601935922554, 9998.400095994191, 4011.1376054147913, 4140.668746500272, 4225.704200705983, 4295.6778241632, 4305.418768466279, 8438.620262088221, 8614.827703445895, 8622.439541429787, 8628.654853805903, 8642.3950323478, 4453.354263631755, 4455.77721113943, 4457.77711114443, 4462.241418958784, 4478.2386994211065, 3560.4659301104525, 3897.4738410314812, 3977.244323578511, 4062.0, 4062.878113656595, 3520.8239588020497, 3523.647635236507, 3544.0608238816735, 3606.891793246207, 3762.7930463824205, 1186.6618013866007, 1187.619961612293, 1199.3463562358536, 1222.3399364343154, 1230.0528592983353, 791.3155120820448, 794.4280118314804, 805.6414895371621, 819.72948926854, 831.9542425166674, 4922.507749225048, 5073.923891141636, 5092.9236061459105, 5116.948830511722, 5127.717975511308, 410.9239790638741, 411.13045907905166, 415.02676224254077, 415.5117736659413, 416.17389481878445, 3390.881319153818, 3406.710429613461, 3477.23500829817, 3479.0606536235073, 3520.5951315598522, 8587.184217499327, 9009.819803603892, 9071.954640226888, 9080.182783549511, 9081.954590227007, 8944.01615822259, 8956.8656470153, 8957.686480973134, 8969.775755606031, 8977.640894364284, 6688.398044176048, 6851.965740171367, 7055.753048643272, 7112.0754301940415, 7117.857642847114, 5266.420693723764, 5270.156774915995, 5285.656432331886, 5307.310049693515, 5351.411344752152, 8195.180481951757, 8387.706430275155, 8445.746627601182, 8478.533680647624, 8542.871856922027, 8086.959565202136, 8247.422680412314, 8513.106123857153, 8522.616482258438, 8556.914430855611, 5771.278590176228, 6245.8757423662355, 6379.585326953733, 6496.285408604956, 6626.304238054935, 6885.793426197222, 6985.0, 6999.0, 6999.230084690782, 7016.789496315118, 6334.429346749586, 6357.936420635734, 6494.7077381517, 6568.507361947777, 6578.638174900235, 6350.4919606432295, 6351.968240158954, 6368.840778980562, 6445.548811583331, 6479.287278399278, 5962.344142144448, 6071.666058366655, 6074.544409169242, 6076.0, 6085.1480792689945, 4445.333200020023, 4514.367988481681, 4526.072155208109, 4542.909141817211, 4591.449026116888, 4446.333050042519, 4553.4763502197675, 4556.544345565417, 4590.0, 4725.432948046257], "value": 3922.8347790470875, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [308.9397567474342, 312.3440774373814, 314.4952351475882, 319.8752486530254, 320.37207074134693, 5086.898262034757, 5103.183490641498, 5104.795808167673, 5107.310513080733, 5145.7101589792555, 5029.47190544993, 5047.116754567955, 5057.659720174157, 5064.721440320781, 5067.163917953533, 3710.9980305317617, 3885.669718073953, 3974.403839424095, 3980.7412518186225, 3986.2426139033637, 3967.8375285469488, 3969.4045893115976, 3973.185496973128, 3989.16227592206, 3994.3209654358684, 3933.15437181006, 3944.6844252459878, 3946.9210615787665, 3955.32759430896, 3975.1652153047894, 3667.5965643779164, 3860.3823388258024, 3909.5565271705186, 3961.7028722845903, 3969.8610548630804, 3416.436288012475, 3416.7095796857298, 3427.657234276577, 3428.639992800745, 3431.9485207721905, 4964.15609346412, 4969.478204788517, 4979.203327467624, 4981.178105612569, 4983.551480366748, 4174.519930208035, 4467.419235499397, 4481.574250446202, 4486.237339652267, 4502.347159661864, 5194.584433245332, 5240.973795131038, 5242.0826355388035, 5242.397124330674, 5260.500252476008, 3727.850885964558, 3731.7014638828828, 3735.8505659773577, 3742.101895545077, 3744.2324323513612, 5324.7071411072375, 5506.834794956158, 5509.815389691195, 5512.33851937766, 5547.25112109868, 3785.545734511876, 3795.6204379562373, 3804.4673745675072, 3810.6189381062227, 3823.7896915669903, 3858.401947698111, 3883.2427676603356, 3891.7664940103687, 3900.531936167678, 3903.6291552302487, 4467.419235499429, 4473.709208901411, 4477.238869392211, 4477.283634618446, 4478.14915166124, 5096.261042148868, 5279.683219006872, 5294.364676238876, 5330.866728331745, 5339.11904535755, 1324.8940084793194, 1333.193417982107, 1338.6385675867461, 1339.6985678222322, 1341.155072304442, 800.4636893281515, 854.1202561361807, 859.6217664227845, 871.5511511571545, 881.3213825354442, 4443.733375997386, 4604.815807367735, 4638.930416043762, 4653.7207767534055, 4681.953180468152, 5406.162044883049, 5438.428964958623, 5496.532794712414, 5498.615096943176, 5505.724713764296, 4475.888102797456, 4634.745089020069, 4660.300954856731, 4664.790084446208, 4694.577488026094, 2855.4146399987953, 2868.5983962245305, 2890.942181156365, 2891.797574169788, 2901.7678585713093, 5135.435102138762, 5144.0, 5148.124818780816, 5154.5103215194495, 5155.896882062338, 5403.351597808288, 5437.510624043855, 5574.693391863405, 5601.747921343549, 5609.411011843779, 5084.8220312288895, 5093.159628661229, 5120.743962801845, 5151.6136289778415, 5152.3044389007, 5470.671759694431, 5481.616286859881, 5513.704279494395, 5513.9448605513435, 5520.53075488588, 5132.5124113209185, 5321.350381381784, 5386.676799392049, 5400.810971615974, 5416.566674665938, 5054.898902022012, 5084.63564442536, 5100.464451232716, 5119.180931051014, 5133.435322114639, 3806.8477260909253, 3817.8472861085247, 3824.456736270349, 3837.1558257183374, 3847.0, 5299.894002120013, 5442.292501974718, 5445.564354851682, 5448.237246785532, 5477.972610136924, 5259.15853463444, 5280.841574752763, 5296.867578310573, 5303.549198318186, 5307.41618421981, 5250.212468129811, 5282.6038047147385, 5315.3621565412395, 5322.920156197738, 5354.518093371616, 4934.901301973869, 5161.612879034163, 5162.148245539444, 5184.300119483973, 5215.426303106731, 5089.3638295213095, 5172.948270517247, 5300.542350853546, 5301.363836339664, 5330.9733451332495, 5153.742312884266, 5197.21948757413, 5213.765380557808, 5225.973870130625, 5253.527182553588], "value": 3973.505580115781, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [631.8041407163779, 737.8819388897778, 744.9553026818389, 748.0985412577844, 753.2091304130659, 12570.497180112796, 13288.667783305422, 13332.800007999876, 13357.398917048731, 13376.331183440814, 12093.093018023661, 12275.263484190955, 12284.140110192267, 12321.260724356545, 12405.193662411937, 784.8116452051495, 792.7740593930731, 793.0641842625699, 793.738066438074, 798.4131663227523, 633.395107672172, 765.5636287316232, 793.6111305460312, 796.9043714754238, 799.6401619271322, 809.7894547417684, 813.1502579804119, 817.5626040068564, 817.6238930092164, 818.6029775558849, 804.7505273365275, 806.2219957740779, 806.592670701295, 807.1484583764097, 808.1393316118374, 587.0607028754002, 591.136940067502, 591.7011908985935, 593.3828818029244, 594.8810237952426, 11845.585404510886, 11941.582044628396, 11969.64091077269, 12000.339981301026, 12048.939755301168, 12802.80795788064, 12873.806892896613, 12978.351082445934, 13012.154209976416, 13397.263150526716, 9271.211946984515, 9691.12779849817, 9843.950780246052, 9858.211343092535, 9947.651832185911, 3122.172624254574, 3151.086185006345, 3172.825494597796, 3185.633652129988, 3187.21913131282, 64572.0, 65733.0, 65800.67099664471, 65884.67057664729, 67151.32848671499, 10107.797844043078, 10301.175905927508, 10332.173426125892, 10427.426491542887, 10486.37081775096, 20047.0, 20091.899540502203, 20160.092795824225, 20223.79776202219, 20520.692189617166, 5766.798162064391, 5822.621529600562, 5865.794697185578, 5879.941200588025, 5930.436608522184, 3527.876524321636, 3561.4479755637917, 3574.982125089358, 3638.6179451157777, 3656.0, 2683.6645419322585, 2756.627855239557, 2772.209920172741, 2774.5283301838735, 2781.8748156333013, 449.7121842021109, 451.5236425571054, 451.94576650802117, 459.7632219407008, 460.23141353939, 443.35270505062323, 479.96880202786707, 487.20342240436435, 494.31290506196416, 554.8446434998207, 8054.436189466681, 8156.67373305073, 8190.0, 8258.628361723737, 8325.333973282122, 568.7440651706748, 593.946544810969, 607.3167686352853, 610.6275172144988, 611.1566038866425, 3588.6411358864425, 3858.2669292834835, 3918.8236529356245, 3970.5830887756947, 4061.810595246456, 54971.450285497434, 96700.51649741706, 99534.5023274879, 100529.9841004771, 101205.49397252967, 78411.60794195993, 79634.60182699165, 80459.32249931304, 81897.0, 83159.0, 72678.63660681662, 73016.63491682614, 75619.62190189124, 76070.23929760742, 76178.0, 8416.789580260542, 8909.0, 8939.329550283885, 9134.5432728362, 9344.579493922925, 45839.0, 46081.76959115183, 47075.76462117668, 47434.52565474301, 47935.44613261735, 62426.68786656038, 65642.67178664076, 66442.33557664555, 66518.0, 69644.0, 11269.830952535882, 11519.94240028828, 11567.942160289145, 11587.188896777145, 12089.75820483603, 12256.816147757969, 12283.938580307042, 12546.435410406371, 12562.646174406964, 13326.067175297636, 11920.761584768083, 12102.394880256128, 12176.75646487083, 12238.510459581874, 12384.318862462651, 12104.334261615344, 12259.264444133381, 12674.429650665927, 12792.552260670831, 13084.28036458004, 12219.144659873724, 12266.877331226573, 12502.187357821713, 12771.87228127744, 12788.808167877676, 9829.262805289489, 10011.34926229822, 10099.646512372032, 10225.437600931722, 10542.57829686804, 9430.387024843363, 9909.950450247703, 10889.0, 10893.78212435731, 10900.890991090304], "value": 6515.746473997909, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1568.9000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 117.0, 107.0, 114.0, 115.0, 114.0, 114.0, 113.0, 114.0, 113.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 124.0, 144.0, 177.0, 125.0, 146.0, 149.0, 125.0, 173.0, 125.0], "value": 144.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 165.0, 167.0, 168.0, 163.0, 163.0, 162.0, 162.0, 162.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 79.0, 77.0, 173.0, 77.0, 76.0, 76.0, 76.0, 163.0, 77.0], "value": 94.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 145.0, 85.0, 85.0, 86.0, 138.0, 86.0, 85.0, 132.0], "value": 101.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 119.0, 119.0, 118.0, 117.0, 118.0, 118.0, 117.0, 118.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 148.0, 148.0, 148.0, 148.0, 148.0, 148.0, 149.0, 150.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 66.0, 64.0, 63.0, 65.0, 63.0, 65.0, 65.0, 62.0, 63.0], "value": 63.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 67.0, 65.0, 66.0, 66.0, 66.0, 67.0, 66.0], "value": 66.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 80.0, 80.0, 86.0, 79.0, 79.0, 80.0, 83.0, 82.0], "value": 81.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 131.0, 145.0, 132.0, 132.0, 142.0, 140.0, 146.0, 177.0, 133.0], "value": 141.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 175.0, 174.0, 167.0, 168.0, 167.0, 172.0, 165.0, 168.0, 169.0], "value": 169.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 67.0, 68.0, 70.0, 66.0, 67.0, 66.0, 66.0, 70.0], "value": 67.9, "unit": "score"}]}]} 18:37:50 INFO - Return code: 0 18:37:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:37:50 ERROR - # TBPL SUCCESS # 18:37:50 INFO - Running post-action listener: _resource_record_post_action 18:37:50 INFO - [mozharness: 2016-07-27 01:37:50.654597Z] Finished run-tests step (success) 18:37:50 INFO - Running post-run listener: _resource_record_post_run 18:37:50 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 7774208; Write bytes: 417169408; Read time: 1880; Write time: 411284 18:37:50 INFO - TinderboxPrint: CPU usage
13.3% 18:37:50 INFO - TinderboxPrint: I/O read bytes / time
7,774,208 / 1,880 18:37:50 INFO - TinderboxPrint: I/O write bytes / time
417,169,408 / 411,284 18:37:50 INFO - TinderboxPrint: CPU idle
8,305.8 (86.7%) 18:37:50 INFO - TinderboxPrint: CPU user
1,218.6 (12.7%) 18:37:50 INFO - TinderboxPrint: Swap in / out
0 / 0 18:37:50 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 44650496; Read time: 0; Write time: 16796 18:37:50 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 5718016; Write bytes: 323121152; Read time: 1728; Write time: 322684 18:37:51 INFO - Running post-run listener: _upload_blobber_files 18:37:51 INFO - Blob upload gear active. 18:37:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:37:51 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 18:37:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:37:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:37:51 INFO - (blobuploader) - INFO - Open directory for files ... 18:37:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:37:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:37:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:37:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:37:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:37:52 INFO - (blobuploader) - INFO - Done attempting. 18:37:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:37:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:37:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:37:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:37:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:37:53 INFO - (blobuploader) - INFO - Done attempting. 18:37:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:37:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:37:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:37:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:37:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:37:58 INFO - (blobuploader) - INFO - Done attempting. 18:37:58 INFO - (blobuploader) - INFO - Iteration through files over. 18:37:58 INFO - Return code: 0 18:37:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:37:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:37:58 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/891bcda5e49d9063ff4246d400af5157f302fb52686581b008df4500a54f041648f7ab0085fdc7866bc4da4c960e86222fad43ac702bcce99682aa620cd4c682", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1bc73e0aacee1bad78e60022d3d785144a64c8752cd3923b86022c3efff90d73fee02e5c60ac27fa8e180206117b253bb4fef63acc1dfd8419988af39bee868b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/685c42cb7f2944d3cb5da8cff618faf4bb457638051e7686203c099d6ca7d7a599f19785b9523e1539b9c5310383133e18ac09fd16b93fcf6f60dad0f87a8832"} 18:37:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:37:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:37:58 INFO - Contents: 18:37:58 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/891bcda5e49d9063ff4246d400af5157f302fb52686581b008df4500a54f041648f7ab0085fdc7866bc4da4c960e86222fad43ac702bcce99682aa620cd4c682", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1bc73e0aacee1bad78e60022d3d785144a64c8752cd3923b86022c3efff90d73fee02e5c60ac27fa8e180206117b253bb4fef63acc1dfd8419988af39bee868b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/685c42cb7f2944d3cb5da8cff618faf4bb457638051e7686203c099d6ca7d7a599f19785b9523e1539b9c5310383133e18ac09fd16b93fcf6f60dad0f87a8832"} 18:37:58 INFO - Running post-run listener: copy_logs_to_upload_dir 18:37:58 INFO - Copying logs to upload dir... 18:37:58 INFO - mkdir: /builds/slave/test/build/upload/logs 18:37:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1308.371959 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 48 secs) (at 2016-07-26 18:37:58.090889) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-26 18:37:58.094331) ========= 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=4ac8d263c7293b36a1be1aed000001be-1469580271.823302-767683654 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/Fx-Team-Non-PGO/sha512/891bcda5e49d9063ff4246d400af5157f302fb52686581b008df4500a54f041648f7ab0085fdc7866bc4da4c960e86222fad43ac702bcce99682aa620cd4c682", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1bc73e0aacee1bad78e60022d3d785144a64c8752cd3923b86022c3efff90d73fee02e5c60ac27fa8e180206117b253bb4fef63acc1dfd8419988af39bee868b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/685c42cb7f2944d3cb5da8cff618faf4bb457638051e7686203c099d6ca7d7a599f19785b9523e1539b9c5310383133e18ac09fd16b93fcf6f60dad0f87a8832"} build_url:https://queue.taskcluster.net/v1/task/LgZmFkCLQpatqjhnXMNwVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011309 build_url: 'https://queue.taskcluster.net/v1/task/LgZmFkCLQpatqjhnXMNwVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/891bcda5e49d9063ff4246d400af5157f302fb52686581b008df4500a54f041648f7ab0085fdc7866bc4da4c960e86222fad43ac702bcce99682aa620cd4c682", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1bc73e0aacee1bad78e60022d3d785144a64c8752cd3923b86022c3efff90d73fee02e5c60ac27fa8e180206117b253bb4fef63acc1dfd8419988af39bee868b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/685c42cb7f2944d3cb5da8cff618faf4bb457638051e7686203c099d6ca7d7a599f19785b9523e1539b9c5310383133e18ac09fd16b93fcf6f60dad0f87a8832"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-26 18:37:58.119018) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 18:37:58.119328) ========= 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=4ac8d263c7293b36a1be1aed000001be-1469580271.823302-767683654 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004459 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 18:37:58.204762) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-26 18:37:58.205101) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-26 18:37:58.205455) ========= ========= Total master_lag: 0.18 =========