builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-045 starttime: 1463540713.61 results: success (0) buildid: 20160517173008 builduid: 3c4665b7dfdc46799ff880124e08efe0 revision: 878623e95803fae913434e1d4bcd34e16645580d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-17 20:05:13.605613) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-17 20:05:13.606122) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-17 20:05:13.606504) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-17 20:05:13.626277) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 20:05:13.626571) ========= 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=4300f881736b422476174874000001bc-1463538527.996764-621895711 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-17 20:05:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-05-17 20:05:13 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.096977 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 20:05:13.742849) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 20:05:13.743579) ========= 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=4300f881736b422476174874000001bc-1463538527.996764-621895711 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022875 ========= master_lag: 0.09 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 20:05:13.858230) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 20:05:13.858583) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 878623e95803fae913434e1d4bcd34e16645580d --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 878623e95803fae913434e1d4bcd34e16645580d --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=4300f881736b422476174874000001bc-1463538527.996764-621895711 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-17 20:05:14,134 truncating revision to first 12 chars 2016-05-17 20:05:14,134 Setting DEBUG logging. 2016-05-17 20:05:14,134 attempt 1/10 2016-05-17 20:05:14,134 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/878623e95803?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-17 20:05:14,409 unpacking tar archive at: fx-team-878623e95803/testing/mozharness/ program finished with exit code 0 elapsedTime=0.558095 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 20:05:14.439238) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-17 20:05:14.440079) ========= script_repo_revision: 878623e95803fae913434e1d4bcd34e16645580d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-17 20:05:14.440664) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-17 20:05:14.440999) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-17 20:05:14.455765) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-05-17 20:05:14.456072) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=4300f881736b422476174874000001bc-1463538527.996764-621895711 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:05:14 INFO - MultiFileLogger online at 20160517 20:05:14 in /builds/slave/test 20:05:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 20:05:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:05:14 INFO - {'append_to_log': False, 20:05:14 INFO - 'base_work_dir': '/builds/slave/test', 20:05:14 INFO - 'blob_upload_branch': 'Fx-Team', 20:05:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:05:14 INFO - 'branch': 'Fx-Team', 20:05:14 INFO - 'buildbot_json_path': 'buildprops.json', 20:05:14 INFO - 'config_files': ('talos/linux_config.py',), 20:05:14 INFO - 'default_actions': ('clobber', 20:05:14 INFO - 'read-buildbot-config', 20:05:14 INFO - 'download-and-extract', 20:05:14 INFO - 'populate-webroot', 20:05:14 INFO - 'create-virtualenv', 20:05:14 INFO - 'install', 20:05:14 INFO - 'run-tests'), 20:05:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:05:14 INFO - 'download_minidump_stackwalk': True, 20:05:14 INFO - 'download_symbols': 'ondemand', 20:05:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:05:14 INFO - 'tooltool.py': '/tools/tooltool.py', 20:05:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:05:14 INFO - '/tools/misc-python/virtualenv.py')}, 20:05:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:05:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:05:14 INFO - 'installer_path': 'installer.exe', 20:05:14 INFO - 'log_level': 'info', 20:05:14 INFO - 'log_name': 'talos', 20:05:14 INFO - 'log_to_console': True, 20:05:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:05:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:05:14 INFO - 'opt_config_files': (), 20:05:14 INFO - 'pip_index': False, 20:05:14 INFO - 'sps_profile': False, 20:05:14 INFO - 'sps_profile_interval': 0, 20:05:14 INFO - 'suite': 'dromaeojs-e10s', 20:05:14 INFO - 'system_bits': '32', 20:05:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:05:14 INFO - 'title': 'talos-linux64-ix-045', 20:05:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:05:14 INFO - 'use_talos_json': True, 20:05:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:05:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:05:14 INFO - 'work_dir': 'build'} 20:05:14 INFO - ##### 20:05:14 INFO - ##### Running clobber step. 20:05:14 INFO - ##### 20:05:14 INFO - Running pre-action listener: _resource_record_pre_action 20:05:14 INFO - Running main action method: clobber 20:05:14 INFO - rmtree: /builds/slave/test/build 20:05:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:05:15 INFO - Running post-action listener: _resource_record_post_action 20:05:15 INFO - ##### 20:05:15 INFO - ##### Finished clobber step (success) 20:05:15 INFO - ##### 20:05:15 INFO - ##### 20:05:15 INFO - ##### Running read-buildbot-config step. 20:05:15 INFO - ##### 20:05:15 INFO - Running pre-action listener: _resource_record_pre_action 20:05:15 INFO - Running main action method: read_buildbot_config 20:05:15 INFO - Using buildbot properties: 20:05:15 INFO - { 20:05:15 INFO - "project": "", 20:05:15 INFO - "product": "firefox", 20:05:15 INFO - "script_repo_revision": "production", 20:05:15 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 20:05:15 INFO - "repository": "", 20:05:15 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 20:05:15 INFO - "buildid": "20160517173008", 20:05:15 INFO - "pgo_build": "True", 20:05:15 INFO - "basedir": "/builds/slave/test", 20:05:15 INFO - "buildnumber": 755, 20:05:15 INFO - "slavename": "talos-linux64-ix-045", 20:05:15 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 20:05:15 INFO - "platform": "ubuntu64_hw", 20:05:15 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:05:15 INFO - "branch": "fx-team", 20:05:15 INFO - "repo_path": "integration/fx-team", 20:05:15 INFO - "revision": "878623e95803fae913434e1d4bcd34e16645580d", 20:05:15 INFO - "stage_platform": "linux64-pgo", 20:05:15 INFO - "builduid": "3c4665b7dfdc46799ff880124e08efe0", 20:05:15 INFO - "slavebuilddir": "test" 20:05:15 INFO - } 20:05:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/bCVoaSvIQHOj6ZXBmhfFQg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 20:05:15 INFO - Running post-action listener: _resource_record_post_action 20:05:15 INFO - ##### 20:05:15 INFO - ##### Finished read-buildbot-config step (success) 20:05:15 INFO - ##### 20:05:15 INFO - ##### 20:05:15 INFO - ##### Running download-and-extract step. 20:05:15 INFO - ##### 20:05:15 INFO - Running pre-action listener: _resource_record_pre_action 20:05:15 INFO - Running main action method: download_and_extract 20:05:15 INFO - mkdir: /builds/slave/test/build/tests 20:05: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')]} 20:05:15 INFO - https://queue.taskcluster.net/v1/task/bCVoaSvIQHOj6ZXBmhfFQg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:05:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bCVoaSvIQHOj6ZXBmhfFQg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:05:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bCVoaSvIQHOj6ZXBmhfFQg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:05:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bCVoaSvIQHOj6ZXBmhfFQg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:05:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bCVoaSvIQHOj6ZXBmhfFQg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 20:05:19 INFO - Downloaded 1361 bytes. 20:05:19 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 20:05:19 INFO - Using the following test package requirements: 20:05:19 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 20:05:19 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:05:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:05:19 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:05:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:05:19 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:05:19 INFO - u'jsshell-linux-x86_64.zip'], 20:05:19 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:05:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:05:19 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 20:05:19 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:05:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:05:19 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:05:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:05:19 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:05:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:05:19 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 20:05:19 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:05:19 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:05:19 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')]} 20:05:19 INFO - https://queue.taskcluster.net/v1/task/bCVoaSvIQHOj6ZXBmhfFQg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:05:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bCVoaSvIQHOj6ZXBmhfFQg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:05:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bCVoaSvIQHOj6ZXBmhfFQg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:05:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bCVoaSvIQHOj6ZXBmhfFQg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:05:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bCVoaSvIQHOj6ZXBmhfFQg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:05:20 INFO - Downloaded 24062848 bytes. 20:05:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:05:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:05:21 INFO - Return code: 0 20:05:21 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:05:21 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')]} 20:05:21 INFO - https://queue.taskcluster.net/v1/task/bCVoaSvIQHOj6ZXBmhfFQg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:05:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bCVoaSvIQHOj6ZXBmhfFQg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:05:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bCVoaSvIQHOj6ZXBmhfFQg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:05:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bCVoaSvIQHOj6ZXBmhfFQg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 20:05:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bCVoaSvIQHOj6ZXBmhfFQg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:05:31 INFO - Downloaded 24062848 bytes. 20:05:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:05:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:05:32 INFO - Return code: 0 20:05: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')]} 20:05:32 INFO - https://queue.taskcluster.net/v1/task/bCVoaSvIQHOj6ZXBmhfFQg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:05:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bCVoaSvIQHOj6ZXBmhfFQg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 20:05:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bCVoaSvIQHOj6ZXBmhfFQg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 20:05:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bCVoaSvIQHOj6ZXBmhfFQg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 20:05:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bCVoaSvIQHOj6ZXBmhfFQg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:05:34 INFO - Downloaded 10840194 bytes. 20:05:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:05:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 20:05:34 INFO - Return code: 0 20:05:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:05:34 INFO - https://queue.taskcluster.net/v1/task/bCVoaSvIQHOj6ZXBmhfFQg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:05:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bCVoaSvIQHOj6ZXBmhfFQg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:05:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bCVoaSvIQHOj6ZXBmhfFQg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:05:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bCVoaSvIQHOj6ZXBmhfFQg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:05:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bCVoaSvIQHOj6ZXBmhfFQg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:05:35 INFO - Downloaded 58395862 bytes. 20:05:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bCVoaSvIQHOj6ZXBmhfFQg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:05:35 INFO - mkdir: /builds/slave/test/properties 20:05:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:05:35 INFO - Writing to file /builds/slave/test/properties/build_url 20:05:35 INFO - Contents: 20:05:35 INFO - build_url:https://queue.taskcluster.net/v1/task/bCVoaSvIQHOj6ZXBmhfFQg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 20:05:36 INFO - Running post-action listener: _resource_record_post_action 20:05:36 INFO - Running post-action listener: set_extra_try_arguments 20:05:36 INFO - ##### 20:05:36 INFO - ##### Finished download-and-extract step (success) 20:05:36 INFO - ##### 20:05:36 INFO - ##### 20:05:36 INFO - ##### Running populate-webroot step. 20:05:36 INFO - ##### 20:05:36 INFO - Running pre-action listener: _resource_record_pre_action 20:05:36 INFO - Running main action method: populate_webroot 20:05:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:05:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:05:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:05:36 INFO - '--tppagecycles', 20:05:36 INFO - '7'], 20:05:36 INFO - 'tests': ['tsvgm']}}, 20:05:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:05:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:05:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:05:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:05:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:05:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:05:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:36 INFO - 'talos_options': ['--disable-e10s'], 20:05:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:05:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:05:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:36 INFO - 'talos_options': ['--disable-e10s'], 20:05:36 INFO - 'tests': ['damp', 'tps']}, 20:05:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:36 INFO - 'tests': ['damp', 'tps']}, 20:05:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:05:36 INFO - 'tests': ['dromaeo_dom']}, 20:05:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:05:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:05:36 INFO - 'tests': ['a11yr', 20:05:36 INFO - 'ts_paint', 20:05:36 INFO - 'tpaint', 20:05:36 INFO - 'sessionrestore', 20:05:36 INFO - 'sessionrestore_no_auto_restore', 20:05:36 INFO - 'tabpaint']}, 20:05:36 INFO - 'other-e10s': {'tests': ['a11yr', 20:05:36 INFO - 'ts_paint', 20:05:36 INFO - 'tpaint', 20:05:36 INFO - 'sessionrestore', 20:05:36 INFO - 'sessionrestore_no_auto_restore', 20:05:36 INFO - 'tabpaint']}, 20:05:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:05:36 INFO - 'ts_paint', 20:05:36 INFO - 'tpaint', 20:05:36 INFO - 'sessionrestore', 20:05:36 INFO - 'sessionrestore_no_auto_restore', 20:05:36 INFO - 'tabpaint']}, 20:05:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:05:36 INFO - 'ts_paint', 20:05:36 INFO - 'tpaint', 20:05:36 INFO - 'sessionrestore', 20:05:36 INFO - 'sessionrestore_no_auto_restore', 20:05:36 INFO - 'tabpaint']}, 20:05:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:05:36 INFO - 'tests': ['a11yr', 20:05:36 INFO - 'ts_paint', 20:05:36 INFO - 'tpaint', 20:05:36 INFO - 'sessionrestore', 20:05:36 INFO - 'sessionrestore_no_auto_restore', 20:05:36 INFO - 'tabpaint']}, 20:05:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:05:36 INFO - 'tests': ['a11yr', 20:05:36 INFO - 'ts_paint', 20:05:36 INFO - 'tpaint', 20:05:36 INFO - 'sessionrestore', 20:05:36 INFO - 'sessionrestore_no_auto_restore', 20:05:36 INFO - 'tabpaint']}, 20:05:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:05:36 INFO - 'tests': ['tsvgx', 20:05:36 INFO - 'tsvgr_opacity', 20:05:36 INFO - 'tart', 20:05:36 INFO - 'tscrollx', 20:05:36 INFO - 'cart']}, 20:05:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:05:36 INFO - 'tsvgr_opacity', 20:05:36 INFO - 'tart', 20:05:36 INFO - 'tscrollx', 20:05:36 INFO - 'cart']}, 20:05:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:36 INFO - 'talos_options': ['--disable-e10s'], 20:05:36 INFO - 'tests': ['tp5o']}, 20:05:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:36 INFO - 'tests': ['tp5o']}, 20:05:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:36 INFO - 'talos_options': ['--disable-e10s', 20:05:36 INFO - '--xperf_path', 20:05:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:05:36 INFO - 'tests': ['tp5n']}, 20:05:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:36 INFO - 'talos_options': ['--xperf_path', 20:05:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:05:36 INFO - 'tests': ['tp5n']}}, 20:05:36 INFO - 'talos.zip': {'path': '', 20:05:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:05:36 INFO - Running post-action listener: _resource_record_post_action 20:05:36 INFO - ##### 20:05:36 INFO - ##### Finished populate-webroot step (success) 20:05:36 INFO - ##### 20:05:36 INFO - ##### 20:05:36 INFO - ##### Running create-virtualenv step. 20:05:36 INFO - ##### 20:05:36 INFO - Running pre-action listener: _resource_record_pre_action 20:05:36 INFO - Running main action method: create_virtualenv 20:05:36 INFO - Creating virtualenv /builds/slave/test/build/venv 20:05:36 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 20:05:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:05:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:05:36 INFO - Using real prefix '/usr' 20:05:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:05:37 INFO - Installing distribute.............................................................................................................................................................................................done. 20:05:39 INFO - Installing pip.................done. 20:05:39 INFO - Return code: 0 20:05:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:05:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:05:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:05:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:05:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:05:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3c55be6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c20770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1caf9c0>, '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 0x1cb08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cb0d50>, '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': '4300f881736b422476174874000001bc-1463538527.996764-621895711', '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 20:05:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:05:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:05:39 INFO - Using env: {'DISPLAY': ':0', 20:05:39 INFO - 'HOME': '/home/cltbld', 20:05:39 INFO - 'LANG': 'en_US.UTF-8', 20:05:39 INFO - 'LANGUAGE': 'en_US:en', 20:05:39 INFO - 'LOGNAME': 'cltbld', 20:05:39 INFO - 'MAIL': '/var/mail/cltbld', 20:05:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:05:39 INFO - 'MOZ_NO_REMOTE': '1', 20:05:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:05:39 INFO - 'NO_EM_RESTART': '1', 20:05:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:05:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:05:39 INFO - 'PWD': '/builds/slave/test', 20:05:39 INFO - 'SHELL': '/bin/bash', 20:05:39 INFO - 'SHLVL': '1', 20:05:39 INFO - 'TERM': 'linux', 20:05:39 INFO - 'TMOUT': '86400', 20:05:39 INFO - 'USER': 'cltbld', 20:05:39 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1463538527.996764-621895711', 20:05:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:05:39 INFO - '_': '/tools/buildbot/bin/python'} 20:05:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:05:39 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 20:05:39 INFO - Cleaning up... 20:05:39 INFO - Return code: 0 20:05:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:05:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:05:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:05:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:05:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:05:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3c55be6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c20770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1caf9c0>, '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 0x1cb08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cb0d50>, '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': '4300f881736b422476174874000001bc-1463538527.996764-621895711', '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 20:05:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:05:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:05:39 INFO - Using env: {'DISPLAY': ':0', 20:05:39 INFO - 'HOME': '/home/cltbld', 20:05:39 INFO - 'LANG': 'en_US.UTF-8', 20:05:39 INFO - 'LANGUAGE': 'en_US:en', 20:05:39 INFO - 'LOGNAME': 'cltbld', 20:05:39 INFO - 'MAIL': '/var/mail/cltbld', 20:05:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:05:39 INFO - 'MOZ_NO_REMOTE': '1', 20:05:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:05:39 INFO - 'NO_EM_RESTART': '1', 20:05:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:05:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:05:39 INFO - 'PWD': '/builds/slave/test', 20:05:39 INFO - 'SHELL': '/bin/bash', 20:05:39 INFO - 'SHLVL': '1', 20:05:39 INFO - 'TERM': 'linux', 20:05:39 INFO - 'TMOUT': '86400', 20:05:39 INFO - 'USER': 'cltbld', 20:05:39 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1463538527.996764-621895711', 20:05:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:05:39 INFO - '_': '/tools/buildbot/bin/python'} 20:05:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:05:39 INFO - Downloading/unpacking psutil>=3.1.1 20:05:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:05:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:05:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:05:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:05:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:05:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:05:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:05:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:05:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:05:41 INFO - Installing collected packages: psutil 20:05:41 INFO - Running setup.py install for psutil 20:05:41 INFO - building 'psutil._psutil_linux' extension 20:05:41 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 20:05:42 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 20:05:42 INFO - building 'psutil._psutil_posix' extension 20:05:42 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 20:05:42 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 20:05:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:05:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:05:42 INFO - Successfully installed psutil 20:05:42 INFO - Cleaning up... 20:05:42 INFO - Return code: 0 20:05:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:05:42 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')]} 20:05:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:05:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:42 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')]} 20:05:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:05:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:42 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 0x7f3c55be6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c20770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1caf9c0>, '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 0x1cb08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cb0d50>, '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': '4300f881736b422476174874000001bc-1463538527.996764-621895711', '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 20:05:42 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 20:05:42 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 20:05:42 INFO - Using env: {'DISPLAY': ':0', 20:05:42 INFO - 'HOME': '/home/cltbld', 20:05:42 INFO - 'LANG': 'en_US.UTF-8', 20:05:42 INFO - 'LANGUAGE': 'en_US:en', 20:05:42 INFO - 'LOGNAME': 'cltbld', 20:05:42 INFO - 'MAIL': '/var/mail/cltbld', 20:05:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:05:42 INFO - 'MOZ_NO_REMOTE': '1', 20:05:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:05:42 INFO - 'NO_EM_RESTART': '1', 20:05:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:05:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:05:42 INFO - 'PWD': '/builds/slave/test', 20:05:42 INFO - 'SHELL': '/bin/bash', 20:05:42 INFO - 'SHLVL': '1', 20:05:42 INFO - 'TERM': 'linux', 20:05:42 INFO - 'TMOUT': '86400', 20:05:42 INFO - 'USER': 'cltbld', 20:05:42 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1463538527.996764-621895711', 20:05:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:05:42 INFO - '_': '/tools/buildbot/bin/python'} 20:05:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:05:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:05:42 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 20:05:42 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 20:05:42 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 20:05:42 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 20:05:42 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 20:05:42 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 20:05:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:05:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:05:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:05:44 INFO - Installing collected packages: mozsystemmonitor 20:05:44 INFO - Running setup.py install for mozsystemmonitor 20:05:44 INFO - Successfully installed mozsystemmonitor 20:05:44 INFO - Cleaning up... 20:05:44 INFO - Return code: 0 20:05:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:05: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')]} 20:05:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:05:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05: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')]} 20:05:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:05:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:44 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 0x7f3c55be6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c20770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1caf9c0>, '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 0x1cb08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cb0d50>, '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': '4300f881736b422476174874000001bc-1463538527.996764-621895711', '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 20:05:44 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 20:05:44 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 20:05:44 INFO - Using env: {'DISPLAY': ':0', 20:05:44 INFO - 'HOME': '/home/cltbld', 20:05:44 INFO - 'LANG': 'en_US.UTF-8', 20:05:44 INFO - 'LANGUAGE': 'en_US:en', 20:05:44 INFO - 'LOGNAME': 'cltbld', 20:05:44 INFO - 'MAIL': '/var/mail/cltbld', 20:05:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:05:44 INFO - 'MOZ_NO_REMOTE': '1', 20:05:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:05:44 INFO - 'NO_EM_RESTART': '1', 20:05:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:05:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:05:44 INFO - 'PWD': '/builds/slave/test', 20:05:44 INFO - 'SHELL': '/bin/bash', 20:05:44 INFO - 'SHLVL': '1', 20:05:44 INFO - 'TERM': 'linux', 20:05:44 INFO - 'TMOUT': '86400', 20:05:44 INFO - 'USER': 'cltbld', 20:05:44 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1463538527.996764-621895711', 20:05:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:05:44 INFO - '_': '/tools/buildbot/bin/python'} 20:05:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:05:44 INFO - Downloading/unpacking blobuploader==1.2.4 20:05:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:05:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:05:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:05:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:05:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:05:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:05:46 INFO - Downloading blobuploader-1.2.4.tar.gz 20:05:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:05:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:05: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 20:05: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 20:05: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 20:05: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 20:05: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 20:05: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 20:05:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:05:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:05:47 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 20:05:47 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 20:05:47 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 20:05:47 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 20:05:47 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 20:05:47 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 20:05:47 INFO - Downloading docopt-0.6.1.tar.gz 20:05:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:05:47 INFO - Installing collected packages: blobuploader, requests, docopt 20:05:47 INFO - Running setup.py install for blobuploader 20:05:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:05:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:05:47 INFO - Running setup.py install for requests 20:05:47 INFO - Running setup.py install for docopt 20:05:48 INFO - Successfully installed blobuploader requests docopt 20:05:48 INFO - Cleaning up... 20:05:48 INFO - Return code: 0 20:05:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:05: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')]} 20:05:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:05:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05: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')]} 20:05:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:05:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:48 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 0x7f3c55be6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c20770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1caf9c0>, '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 0x1cb08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cb0d50>, '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': '4300f881736b422476174874000001bc-1463538527.996764-621895711', '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 20:05:48 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 20:05:48 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 20:05:48 INFO - Using env: {'DISPLAY': ':0', 20:05:48 INFO - 'HOME': '/home/cltbld', 20:05:48 INFO - 'LANG': 'en_US.UTF-8', 20:05:48 INFO - 'LANGUAGE': 'en_US:en', 20:05:48 INFO - 'LOGNAME': 'cltbld', 20:05:48 INFO - 'MAIL': '/var/mail/cltbld', 20:05:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:05:48 INFO - 'MOZ_NO_REMOTE': '1', 20:05:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:05:48 INFO - 'NO_EM_RESTART': '1', 20:05:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:05:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:05:48 INFO - 'PWD': '/builds/slave/test', 20:05:48 INFO - 'SHELL': '/bin/bash', 20:05:48 INFO - 'SHLVL': '1', 20:05:48 INFO - 'TERM': 'linux', 20:05:48 INFO - 'TMOUT': '86400', 20:05:48 INFO - 'USER': 'cltbld', 20:05:48 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1463538527.996764-621895711', 20:05:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:05:48 INFO - '_': '/tools/buildbot/bin/python'} 20:05:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:05:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:05:48 INFO - Running setup.py (path:/tmp/pip-sIxuZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:05:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:05:48 INFO - Running setup.py (path:/tmp/pip-iyqDpw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:05:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:05:48 INFO - Running setup.py (path:/tmp/pip-cLUuI3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:05:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:05:48 INFO - Running setup.py (path:/tmp/pip-3qeCYH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:05:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:05:48 INFO - Running setup.py (path:/tmp/pip-KKsmuJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:05:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:05:48 INFO - Running setup.py (path:/tmp/pip-_3aFVp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:05:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:05:48 INFO - Running setup.py (path:/tmp/pip-KK0jqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:05:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:05:48 INFO - Running setup.py (path:/tmp/pip-0rrpkL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:05:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:05:48 INFO - Running setup.py (path:/tmp/pip-EIpgVh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:05:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:05:48 INFO - Running setup.py (path:/tmp/pip-yE6FfU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:05:49 INFO - Running setup.py (path:/tmp/pip-cU8Lwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:05:49 INFO - Running setup.py (path:/tmp/pip-8sknYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:05:49 INFO - Running setup.py (path:/tmp/pip-XHMH66-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:05:49 INFO - Running setup.py (path:/tmp/pip-74XWDg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:05:49 INFO - Running setup.py (path:/tmp/pip-roJIcQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:05:49 INFO - Running setup.py (path:/tmp/pip-x2KWzX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:05:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:05:49 INFO - Running setup.py (path:/tmp/pip-3PKKBj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:05:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:05:49 INFO - Running setup.py install for manifestparser 20:05:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:05:49 INFO - Running setup.py install for mozcrash 20:05:49 INFO - Running setup.py install for mozdebug 20:05:49 INFO - Running setup.py install for mozdevice 20:05:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:05:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:05:49 INFO - Running setup.py install for mozfile 20:05:50 INFO - Running setup.py install for mozhttpd 20:05:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:05:50 INFO - Running setup.py install for mozinfo 20:05:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:05:50 INFO - Running setup.py install for mozInstall 20:05:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:05:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:05:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:05:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:05:50 INFO - Running setup.py install for mozleak 20:05:50 INFO - Running setup.py install for mozlog 20:05:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:05:50 INFO - Running setup.py install for moznetwork 20:05:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:05:50 INFO - Running setup.py install for mozprocess 20:05:50 INFO - Running setup.py install for mozprofile 20:05:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:05:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:05:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:05:50 INFO - Running setup.py install for mozrunner 20:05:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:05:50 INFO - Running setup.py install for mozscreenshot 20:05:51 INFO - Running setup.py install for moztest 20:05:51 INFO - Running setup.py install for mozversion 20:05:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:05:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:05:51 INFO - Cleaning up... 20:05:51 INFO - Return code: 0 20:05:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:05:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:05:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:05:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:05:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:05:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:51 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 0x7f3c55be6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c20770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1caf9c0>, '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 0x1cb08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cb0d50>, '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': '4300f881736b422476174874000001bc-1463538527.996764-621895711', '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 20:05:51 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 20:05:51 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 20:05:51 INFO - Using env: {'DISPLAY': ':0', 20:05:51 INFO - 'HOME': '/home/cltbld', 20:05:51 INFO - 'LANG': 'en_US.UTF-8', 20:05:51 INFO - 'LANGUAGE': 'en_US:en', 20:05:51 INFO - 'LOGNAME': 'cltbld', 20:05:51 INFO - 'MAIL': '/var/mail/cltbld', 20:05:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:05:51 INFO - 'MOZ_NO_REMOTE': '1', 20:05:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:05:51 INFO - 'NO_EM_RESTART': '1', 20:05:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:05:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:05:51 INFO - 'PWD': '/builds/slave/test', 20:05:51 INFO - 'SHELL': '/bin/bash', 20:05:51 INFO - 'SHLVL': '1', 20:05:51 INFO - 'TERM': 'linux', 20:05:51 INFO - 'TMOUT': '86400', 20:05:51 INFO - 'USER': 'cltbld', 20:05:51 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1463538527.996764-621895711', 20:05:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:05:51 INFO - '_': '/tools/buildbot/bin/python'} 20:05:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:05:51 INFO - Running setup.py (path:/tmp/pip-WSZ4OD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:05:51 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)) 20:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:05:51 INFO - Running setup.py (path:/tmp/pip-r7F44i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:05:51 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)) 20:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:05:51 INFO - Running setup.py (path:/tmp/pip-N_5nfA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:05:51 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)) 20:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:05:51 INFO - Running setup.py (path:/tmp/pip-DDSoNH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:05:51 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)) 20:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:05:51 INFO - Running setup.py (path:/tmp/pip-AvQlhJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:05:51 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)) 20:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:05:51 INFO - Running setup.py (path:/tmp/pip-2IZ6HG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:05:51 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)) 20:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:05:51 INFO - Running setup.py (path:/tmp/pip-KeWarH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:05:52 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)) 20:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:05:52 INFO - Running setup.py (path:/tmp/pip-6zm2DR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:05:52 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)) 20:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:05:52 INFO - Running setup.py (path:/tmp/pip-fmItGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:05:52 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)) 20:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:05:52 INFO - Running setup.py (path:/tmp/pip-Cdg1xN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:05:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:05:52 INFO - Running setup.py (path:/tmp/pip-tRTpct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:05:52 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)) 20:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:05:52 INFO - Running setup.py (path:/tmp/pip-6eNM04-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:05:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 20:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:05:52 INFO - Running setup.py (path:/tmp/pip-vNAJkY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:05:52 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)) 20:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:05:52 INFO - Running setup.py (path:/tmp/pip-luDqDG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:05:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 20:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:05:52 INFO - Running setup.py (path:/tmp/pip-UHdYGC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:05:52 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)) 20:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:05:52 INFO - Running setup.py (path:/tmp/pip-SQ8foh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:05:52 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)) 20:05:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:05:52 INFO - Running setup.py (path:/tmp/pip-ye6b95-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:05:52 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)) 20:05:52 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)) 20:05:52 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)) 20:05:52 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)) 20:05:52 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)) 20:05:52 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)) 20:05:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:05:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:05:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:05:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:05:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:05:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:05:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:05:54 INFO - Downloading blessings-1.6.tar.gz 20:05:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:05:54 INFO - Installing collected packages: blessings 20:05:54 INFO - Running setup.py install for blessings 20:05:54 INFO - Successfully installed blessings 20:05:54 INFO - Cleaning up... 20:05:54 INFO - Return code: 0 20:05:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:05:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:05:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:05:55 INFO - Reading from file tmpfile_stdout 20:05:55 INFO - Current package versions: 20:05:55 INFO - argparse == 1.2.1 20:05:55 INFO - blessings == 1.6 20:05:55 INFO - blobuploader == 1.2.4 20:05:55 INFO - docopt == 0.6.1 20:05:55 INFO - manifestparser == 1.1 20:05:55 INFO - mozInstall == 1.12 20:05:55 INFO - mozcrash == 0.17 20:05:55 INFO - mozdebug == 0.1 20:05:55 INFO - mozdevice == 0.48 20:05:55 INFO - mozfile == 1.2 20:05:55 INFO - mozhttpd == 0.7 20:05:55 INFO - mozinfo == 0.9 20:05:55 INFO - mozleak == 0.1 20:05:55 INFO - mozlog == 3.2 20:05:55 INFO - moznetwork == 0.27 20:05:55 INFO - mozprocess == 0.22 20:05:55 INFO - mozprofile == 0.28 20:05:55 INFO - mozrunner == 6.11 20:05:55 INFO - mozscreenshot == 0.1 20:05:55 INFO - mozsystemmonitor == 0.3 20:05:55 INFO - moztest == 0.7 20:05:55 INFO - mozversion == 1.4 20:05:55 INFO - psutil == 3.1.1 20:05:55 INFO - requests == 1.2.3 20:05:55 INFO - wsgiref == 0.1.2 20:05:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:05:55 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')]} 20:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:05:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:55 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')]} 20:05:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:05:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:55 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 0x7f3c55be6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c20770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1caf9c0>, '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 0x1cb08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cb0d50>, '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': '4300f881736b422476174874000001bc-1463538527.996764-621895711', '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 20:05:55 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 20:05:55 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 20:05:55 INFO - Using env: {'DISPLAY': ':0', 20:05:55 INFO - 'HOME': '/home/cltbld', 20:05:55 INFO - 'LANG': 'en_US.UTF-8', 20:05:55 INFO - 'LANGUAGE': 'en_US:en', 20:05:55 INFO - 'LOGNAME': 'cltbld', 20:05:55 INFO - 'MAIL': '/var/mail/cltbld', 20:05:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:05:55 INFO - 'MOZ_NO_REMOTE': '1', 20:05:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:05:55 INFO - 'NO_EM_RESTART': '1', 20:05:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:05:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:05:55 INFO - 'PWD': '/builds/slave/test', 20:05:55 INFO - 'SHELL': '/bin/bash', 20:05:55 INFO - 'SHLVL': '1', 20:05:55 INFO - 'TERM': 'linux', 20:05:55 INFO - 'TMOUT': '86400', 20:05:55 INFO - 'USER': 'cltbld', 20:05:55 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1463538527.996764-621895711', 20:05:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:05:55 INFO - '_': '/tools/buildbot/bin/python'} 20:05:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:05:55 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)) 20:05:55 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)) 20:05:55 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)) 20:05:55 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)) 20:05:55 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)) 20:05:55 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)) 20:05:55 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)) 20:05:55 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)) 20:05:55 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)) 20:05:55 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)) 20:05:55 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)) 20:05:55 INFO - Cleaning up... 20:05:55 INFO - Return code: 0 20:05:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:05:55 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')]} 20:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:05:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:55 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')]} 20:05:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:05:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:55 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 0x7f3c55be6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c20770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1caf9c0>, '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 0x1cb08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cb0d50>, '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': '4300f881736b422476174874000001bc-1463538527.996764-621895711', '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 20:05:55 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 20:05:55 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 20:05:55 INFO - Using env: {'DISPLAY': ':0', 20:05:55 INFO - 'HOME': '/home/cltbld', 20:05:55 INFO - 'LANG': 'en_US.UTF-8', 20:05:55 INFO - 'LANGUAGE': 'en_US:en', 20:05:55 INFO - 'LOGNAME': 'cltbld', 20:05:55 INFO - 'MAIL': '/var/mail/cltbld', 20:05:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:05:55 INFO - 'MOZ_NO_REMOTE': '1', 20:05:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:05:55 INFO - 'NO_EM_RESTART': '1', 20:05:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:05:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:05:55 INFO - 'PWD': '/builds/slave/test', 20:05:55 INFO - 'SHELL': '/bin/bash', 20:05:55 INFO - 'SHLVL': '1', 20:05:55 INFO - 'TERM': 'linux', 20:05:55 INFO - 'TMOUT': '86400', 20:05:55 INFO - 'USER': 'cltbld', 20:05:55 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1463538527.996764-621895711', 20:05:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:05:55 INFO - '_': '/tools/buildbot/bin/python'} 20:05:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:05:55 INFO - Downloading/unpacking jsonschema 20:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:05:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:05:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:05:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:05:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:05:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:05:57 INFO - Downloading/unpacking functools32 (from jsonschema) 20:05:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:05:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:05:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:05:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:05:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:05:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:05:57 INFO - Downloading functools32-3.2.3-2.tar.gz 20:05:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:05:57 INFO - warning: no files found matching '*.txt' 20:05:57 INFO - no previously-included directories found matching 'build' 20:05:57 INFO - no previously-included directories found matching 'dist' 20:05:57 INFO - no previously-included directories found matching '.git*' 20:05:57 INFO - Installing collected packages: jsonschema, functools32 20:05:57 INFO - Running setup.py install for functools32 20:05:57 INFO - warning: no files found matching '*.txt' 20:05:57 INFO - no previously-included directories found matching 'build' 20:05:57 INFO - no previously-included directories found matching 'dist' 20:05:57 INFO - no previously-included directories found matching '.git*' 20:05:57 INFO - Successfully installed jsonschema functools32 20:05:57 INFO - Cleaning up... 20:05:57 INFO - Return code: 0 20:05:57 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:05:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:05:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:05:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:05:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:05:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3c55be6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c20770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1caf9c0>, '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 0x1cb08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cb0d50>, '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': '4300f881736b422476174874000001bc-1463538527.996764-621895711', '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 20:05:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 20:05:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 20:05:57 INFO - Using env: {'DISPLAY': ':0', 20:05:57 INFO - 'HOME': '/home/cltbld', 20:05:57 INFO - 'LANG': 'en_US.UTF-8', 20:05:57 INFO - 'LANGUAGE': 'en_US:en', 20:05:57 INFO - 'LOGNAME': 'cltbld', 20:05:57 INFO - 'MAIL': '/var/mail/cltbld', 20:05:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:05:57 INFO - 'MOZ_NO_REMOTE': '1', 20:05:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:05:57 INFO - 'NO_EM_RESTART': '1', 20:05:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:05:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:05:57 INFO - 'PWD': '/builds/slave/test', 20:05:57 INFO - 'SHELL': '/bin/bash', 20:05:57 INFO - 'SHLVL': '1', 20:05:57 INFO - 'TERM': 'linux', 20:05:57 INFO - 'TMOUT': '86400', 20:05:57 INFO - 'USER': 'cltbld', 20:05:57 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1463538527.996764-621895711', 20:05:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:05:57 INFO - '_': '/tools/buildbot/bin/python'} 20:05:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:05:58 INFO - Downloading/unpacking flake8 20:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:05:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:05:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:05:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:05:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:05:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:05:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:05:59 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 20:05:59 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 20:05:59 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 20:05:59 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 20:05:59 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 20:05:59 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 20:06:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:06:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:06:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:06:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:06:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:06:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:06:00 INFO - no previously-included directories found matching 'docs/_build' 20:06:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:06:00 INFO - Running setup.py install for pep8 20:06:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:06:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:06:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:06:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:06:00 INFO - no previously-included directories found matching 'docs/_build' 20:06:00 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:06:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:06:00 INFO - Cleaning up... 20:06:00 INFO - Return code: 0 20:06:00 INFO - Running post-action listener: _resource_record_post_action 20:06:00 INFO - Running post-action listener: _start_resource_monitoring 20:06:00 INFO - Starting resource monitoring. 20:06:00 INFO - ##### 20:06:00 INFO - ##### Finished create-virtualenv step (success) 20:06:00 INFO - ##### 20:06:00 INFO - ##### 20:06:00 INFO - ##### Running install step. 20:06:00 INFO - ##### 20:06:00 INFO - Running pre-action listener: _resource_record_pre_action 20:06:00 INFO - Running main action method: install 20:06:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:06:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:06:01 INFO - Reading from file tmpfile_stdout 20:06:01 INFO - Detecting whether we're running mozinstall >=1.0... 20:06:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:06:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:06:01 INFO - Reading from file tmpfile_stdout 20:06:01 INFO - Output received: 20:06:01 INFO - Usage: mozinstall [options] installer 20:06:01 INFO - Options: 20:06:01 INFO - -h, --help show this help message and exit 20:06:01 INFO - -d DEST, --destination=DEST 20:06:01 INFO - Directory to install application into. [default: 20:06:01 INFO - "/builds/slave/test"] 20:06:01 INFO - --app=APP Application being installed. [default: firefox] 20:06:01 INFO - mkdir: /builds/slave/test/build/application 20:06:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:06:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:06:17 INFO - Reading from file tmpfile_stdout 20:06:17 INFO - Output received: 20:06:17 INFO - /builds/slave/test/build/application/firefox/firefox 20:06:17 INFO - Running post-action listener: _resource_record_post_action 20:06:17 INFO - ##### 20:06:17 INFO - ##### Finished install step (success) 20:06:17 INFO - ##### 20:06:17 INFO - ##### 20:06:17 INFO - ##### Running run-tests step. 20:06:17 INFO - ##### 20:06:17 INFO - Running pre-action listener: _resource_record_pre_action 20:06:17 INFO - Running main action method: run_tests 20:06:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:06:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:06:17 INFO - Python 2.7.3 20:06:17 INFO - Return code: 0 20:06:17 INFO - grabbing minidump binary from tooltool 20:06:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:17 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 0x1caf9c0>, '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 0x1cb08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cb0d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:06:17 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 20:06:17 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 20:06:17 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 20:06:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:06:17 INFO - Return code: 0 20:06:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:06:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:06:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:06:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:06:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:06:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:06:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:06:18 INFO - Return code: 0 20:06:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bCVoaSvIQHOj6ZXBmhfFQg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 20:06:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bCVoaSvIQHOj6ZXBmhfFQg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --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 20:06:18 INFO - Using env: {'DISPLAY': ':0', 20:06:18 INFO - 'HOME': '/home/cltbld', 20:06:18 INFO - 'LANG': 'en_US.UTF-8', 20:06:18 INFO - 'LANGUAGE': 'en_US:en', 20:06:18 INFO - 'LOGNAME': 'cltbld', 20:06:18 INFO - 'MAIL': '/var/mail/cltbld', 20:06:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:06:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:06:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:18 INFO - 'MOZ_NO_REMOTE': '1', 20:06:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:06:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:18 INFO - 'NO_EM_RESTART': '1', 20:06:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:18 INFO - 'PWD': '/builds/slave/test', 20:06:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:06:18 INFO - 'SHELL': '/bin/bash', 20:06:18 INFO - 'SHLVL': '1', 20:06:18 INFO - 'TERM': 'linux', 20:06:18 INFO - 'TMOUT': '86400', 20:06:18 INFO - 'USER': 'cltbld', 20:06:18 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1463538527.996764-621895711', 20:06:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:18 INFO - '_': '/tools/buildbot/bin/python'} 20:06:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bCVoaSvIQHOj6ZXBmhfFQg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 20:06:19 INFO - mozversion application_buildid: 20160517173008 20:06:19 INFO - mozversion application_changeset: 878623e95803fae913434e1d4bcd34e16645580d 20:06:19 INFO - mozversion application_display_name: Nightly 20:06:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:06:19 INFO - mozversion application_name: Firefox 20:06:19 INFO - mozversion application_remotingname: firefox 20:06:19 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:06:19 INFO - mozversion application_vendor: Mozilla 20:06:19 INFO - mozversion application_version: 49.0a1 20:06:19 INFO - mozversion platform_buildid: 20160517173008 20:06:19 INFO - mozversion platform_changeset: 878623e95803fae913434e1d4bcd34e16645580d 20:06:19 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:06:19 INFO - mozversion platform_version: 49.0a1 20:06:19 INFO - using testdate: 1463540779 20:06:19 INFO - actual date: 1463540779 20:06:19 INFO - starting webserver on 'localhost:42620' 20:06:19 INFO - SUITE-START | Running 2 tests 20:06:19 INFO - TEST-START | dromaeo_css 20:06:19 INFO - operating with platform_type : linux_ 20:06:19 INFO - Initialising browser for dromaeo_css test... 20:06:19 INFO - TEST-INFO | started process 5191 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZUnMVn/profile http://localhost:42620/getInfo.html) 20:06:22 INFO - PROCESS | 5191 | 20:06:22 INFO - PROCESS | 5191 | (process:5260): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:06:23 INFO - PROCESS | 5191 | __metrics Screen width/height:1600/1200 20:06:23 INFO - PROCESS | 5191 | colorDepth:24 20:06:23 INFO - PROCESS | 5191 | Browser inner width/height: 1024/697 20:06:23 INFO - PROCESS | 5191 | __metrics 20:06:24 ERROR - PROCESS | 5191 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 20:06:25 INFO - TEST-INFO | 5191: exit 0 20:06:25 INFO - Browser initialized. 20:06:25 INFO - Running cycle 1/1 for dromaeo_css test... 20:06:25 INFO - TEST-INFO | started process 5311 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZUnMVn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:06:27 INFO - PROCESS | 5311 | 20:06:27 INFO - PROCESS | 5311 | (process:5374): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:06:37 INFO - PROCESS | 5311 | RSS: Main: 163737600 20:06:37 INFO - PROCESS | 5311 | 20:07:26 INFO - PROCESS | 5311 | 1463540846801 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] 20:09:34 INFO - PROCESS | 5311 | Cycle 1(1): loaded http://localhost:42620/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42620/tests/dromaeo/cssquery-ext.html) 20:09:35 INFO - PROCESS | 5311 | RSS: Main: 166375424 20:09:35 INFO - PROCESS | 5311 | 20:12:37 INFO - PROCESS | 5311 | Cycle 1(1): loaded http://localhost:42620/tests/dromaeo/cssquery-ext.html (next: http://localhost:42620/tests/dromaeo/cssquery-jquery.html) 20:12:37 INFO - PROCESS | 5311 | RSS: Main: 166035456 20:12:37 INFO - PROCESS | 5311 | 20:15:39 INFO - PROCESS | 5311 | Cycle 1(1): loaded http://localhost:42620/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42620/tests/dromaeo/cssquery-mootools.html) 20:15:40 INFO - PROCESS | 5311 | RSS: Main: 167923712 20:15:40 INFO - PROCESS | 5311 | 20:18:42 INFO - PROCESS | 5311 | Cycle 1(1): loaded http://localhost:42620/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42620/tests/dromaeo/cssquery-prototype.html) 20:18:42 INFO - PROCESS | 5311 | RSS: Main: 165572608 20:18:42 INFO - PROCESS | 5311 | 20:21:45 INFO - PROCESS | 5311 | Cycle 1(1): loaded http://localhost:42620/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42620/tests/dromaeo/cssquery-yui.html) 20:21:45 INFO - PROCESS | 5311 | RSS: Main: 166293504 20:21:45 INFO - PROCESS | 5311 | 20:24:48 INFO - PROCESS | 5311 | Cycle 1(1): loaded http://localhost:42620/tests/dromaeo/cssquery-yui.html (next: http://localhost:42620/tests/dromaeo/cssquery-dojo.html) 20:24:48 INFO - PROCESS | 5311 | RSS: Main: 168431616 20:24:48 INFO - PROCESS | 5311 | 20:24:48 INFO - PROCESS | 5311 | __start_tp_report 20:24:48 INFO - PROCESS | 5311 | _x_x_mozilla_page_load 20:24:48 INFO - PROCESS | 5311 | _x_x_mozilla_page_load_details 20:24:48 INFO - PROCESS | 5311 | |i|pagename|runs| 20:24:48 INFO - PROCESS | 5311 | |0;dojo.html;3103.1931697758578;3107.456195165846;3152.1174071260043;3155.0377134973824;3157.084445510802;5439.537639300659;5446.972765136169;5464.207689884969;5508.807191748289;5521.861953451165;5256.658317209379;5444.7822087116465;5447.645903016301;5454.945450545493;5536.2249285100115;4935.259711043345;4972.403311602613;5104.132297509433;5120.23196520523;5175.456577059411;574.3304124159084;4978.452370239271;5078;5084.034033533617;5132.230165475171;4889.291052797343;4921.384826896638;4942.456329803718;4960.454350021495;4980.526849949267;4882.852529655528;4907.484714105003;4971.080350135237;4971.229459433757;5013.749312534359;4878.463369029404;4901.852944411673;4913.8771530711665;4921.990991846698;4924.704517728947;5355.973220133875;5366.812161574326;5387.488188622075;5397.866448045876;5410.91883621746;5789.971050144764;5796.362400135981;5824.563157763185;5846.415358464162;5852.76588936442;5900.940990590082;5957.374475680078;5963.642181469082;5971.134185543116;6005;5526.696031718254;5545;5547.972260138714;5549.556035517189;5552.11166213408;5814.970925145347;5985.16207730918;6017.638941663514;6034.969825150934;6043.184170137063;5863.501602363847;5864.472197502245;5878.353381128072;5878.559108066912;5886.705664716747;5932;5948.345681974979;5966.492848107872;5968.761249550056;5974;5690.971545142248;5714.200011998323;5750.827475175752;5765.596408251382;5804.158397032406;5683.658980461186;5740.39725828782;5768.336641286306;5791.5656325775735;5798;4397.538258482813;4419.580139886705;4420.734755914656;4446.73319600825;4459.397981272552;3899.7660140391667;3948.230095131422;3969.285528604879;3974.960250397459;4021.8994525137105;5707.229524014288;5725.2843394575675;5735.741891614887;5743.282089738783;5750.539956803445;5919.911201331984;6033.9698301508215;6041.697915104315;6050.2437195350585;6055.303640081447;5438.809641662523;5574.136008918624;5624.97187514068;5628.915566266509;5633.239512665819;5039.748012599355;5042.571381432619;5044.873878153002;5044.924326135111;5088.1350170471105;5892.410758924159;6124.846878828065;6126.846828829315;6132.6933653317155;6134.6625935573975;5785.768569257267;5821.53427725781;5827.038538641246;5886.705664716661;5891.05743081105;6038.6678732670125;6039.245094363205;6043;6057.545684073801;6074.878502429839;5665;5742.626729262584;5762.4525670061275;5776.335721392094;5778.85552861165;5824.097264923944;5913.438223368773;5938.792142275;5950.613210141327;6006.639601623917;5732.254806875079;5738.96698594257;5757.913631295618;5760.366359700346;5783.8554036149435;5579.107342825128;5697.230873832145;5744.023516002206;5780.537556995514;5787.189793428839;5524.668519888659;5557;5585.441455854382;5613.438656134517;5650.491455769001;5757.568182386254;5759.337676167294;5779.942200577941;5781;5790.4209579043445;5492.945070549403;5597.3003374578175;5597.384287728265;5606.6916319602815;5611.3266408031295 20:24:48 INFO - PROCESS | 5311 | |1;ext.html;590.9822705318842;632.2823595219426;643.2249139786558;643.8680070585531;661.1141070964906;43861.34207986879;44529.33206001913;44579.10841783162;44678.553214467844;49114.50885491144;46526.76736616321;47154.29268560974;47191.292130617985;47210.763946180225;47229.52770472303;8889.955550222256;8951.776205594879;8993.775155621097;9012.774680633003;9014;8785.95607021964;8813.338999575026;8878.911210887905;8889.866652000224;8894.688685895995;8859.822803543926;8925.642974281021;8936.821263574724;8986.505742184178;8987.685431009915;8857;8911.15344042315;8932.285417166611;8939.95530022349;8966.282697384193;8830.161134692195;8842.646294148226;8849.203571678516;8918.955405222932;8935.64257429702;41953;42192.57807421948;42379.152416951794;42442.57557424417;42529.78735106336;3442.7934323940644;3541.8229088545468;3551.733619978512;3553.8933831984823;3651.8904432867057;32382;32758.836205819058;33085.338293234;33190.502142467885;33211.6678833211;4426.083804624694;4433.578810013044;4465.151621191963;4496.820127194908;4521.253993091169;231066;344420;345989;347405;347938.9999999975;37207.44188837169;60665.393346066856;61428.385716142264;61468.38531614716;61510.38489615046;37997.62002379996;38024;38086.428703569465;38139.23721525554;38154.42768358421;14198.077124987049;14330.140191588538;14501.274936253145;14506.057106288057;14517.709645807025;11674.357910315015;11692.181547291779;11696.70758231051;11727;11732.354720490284;8590.613422396007;8614.956925215334;8688.218060374471;8704.912950870537;8739.43193692408;3269.75476839238;3325.401427742981;3361.058903507022;3383.763136580465;3399.6940275375337;1050.805600963809;1139.5840518210794;1162.267771304073;1190.732085280805;1204.9878102394032;33709.15727106842;33752.83123584367;34158.316833663186;34410.82794586011;34466.138346541535;1198.6404078776332;1224.7305592769576;1231.5443285984243;1267.5436842736608;1269.1306455078302;17789.7331540027;17803.46589602314;17860.91069544644;17949.641007180046;17965.281388744304;522809;525057;527077;527281;529717;61163.69418152881;61171;61351.6932415344;61575;61694;1382.7372799168127;1387.5143699705225;1402.747505449029;1409.9647508812157;1422.879055280292;31760.523592145673;31999.36001280008;32078;32560.18599534936;32902.10349516147;53468.46531534635;53839;53942.99999999843;54266;54364.72817635886;452763;454650;455338;455584;456459.8708025887;29042;29176.416471670873;29317.706822931497;29392.706072938996;29445;51437;51470.485295148064;51472.74263628658;52351.214731778295;53294.73352633212;43298;43923.78038109789;44212.55787442213;44953.1009379804;45158.32262515999;41712.3743143847;42218.78890605527;42559.787201063795;42750.572494275904;43562.34656480092;43045;43966;44231.33652995272;44339.11321773611;46991.76504117458;38077.809610951765;38087.42868856914;38228.6177138225;38317.616823831406;38529;29217;29384.26539336534;29491.85254073716;29509;29740.405191896472 20:24:48 INFO - PROCESS | 5311 | |2;jquery.html;399.2354640862746;403.513765912076;404.1633817996747;404.35303514377;421.8692205416321;14000.929995350009;18200.90899545502;19305.13126909289;19962.201511939522;19989.900050499764;18265.817341826576;18284.177212025457;18721.06394680264;18903.33838315659;19079.236830526796;5602.467765562265;5675.5459563234845;5865;5929.970350148244;5945.910811337833;5467.99999999998;5777.1623114648355;5822.592418530705;5836.416358364151;5891.145783861338;5685.744141513642;5818.389069147721;5842.47417732404;5860.619059761123;5866.941330586704;5917.852053698649;5939.851503712399;5975.820725378246;5987.191729116579;5987.850303742398;4933.210686290176;5262.210668399733;5779.682117483537;5792.652440853562;5797.739101740432;13755.656108597364;14033.1580105194;14053.5081272156;15396.846031539653;22924.083036678512;2207.646776515766;2322.059565875823;2353.5645905507536;2471.542764588557;2541.3646588352913;9873.851892221623;10235.130013948823;10346.482675866177;14596.051256668283;14627;1959.5688948431323;1983.1373352591525;2003.3188715836686;2006.9698954515547;2056.1980827477296;78530.21469785286;82027;82700.58649706712;82794.75807862887;83319;11165;11208.66374008781;11301.208915375844;11353.829692554618;11484.655460336204;15565.688686226438;15573.688526229413;15639;15733.292001859943;15891.523254302389;7663.770086897291;7908.169642187602;7937.285644292041;8057.35541156706;8086.43394962347;7262.600556969312;7339.412846972229;7347.265273472717;7443.925560744432;7455.142658594223;4747.976260118747;4769.260764581495;4775.307580400822;4797.352357431702;4981.103401387712;1974.634692581877;1985.7319261899459;2022.7572691277142;2048.6261830990943;2077.958440831175;988.5699720621552;999.8750156230471;1024.3444195714749;1041.9687409377732;1064.9680509584725;19266;19276.518087047654;19697.310594129136;20025;20130.597388052156;952.2429668413628;1049.454283772434;1049.9370037797758;1063.1654151491043;1097.5829184909683;9057.275417966546;11038.448077596087;11221.438928053565;11232.831507527393;11282.887171128348;464847;467533;472243;478538;485863;100379;104323;104470;104532.47733761283;105536;1038.2732087538602;1044.6448207609449;1096.4736926275432;1104.6520346090956;1111.4609414433994;16711.91644041772;17781.46655600334;17854.642907141526;18015.189316480526;18023.279068837623;39811.60188398079;41636.58363416327;42690.359644605975;43393.56606433895;44552.55447445484;57065;58550.41449585449;58790;59007.40992590019;59444.405555943886;5359.490848369399;6275.843103922439;8313.459625124347;8739.422089766555;9250.95374523123;12671;13202.471901123847;13213.075084743976;13352.732945341233;13356.532521361705;12099;12548.372581370711;12676;12686.746265074462;12788;11799.17405781587;12052.819207712068;12132.878671213175;12267.754644906874;12300.753984920073;12190.08574356909;12269.141160118706;12344.197627154206;12466.376681165724;12980.870191297967;8847.955760221157;8941.46351218929;9021.639134434548;9045.321600879828;9077.409968352036;9120;11772.587959421378;12282.631521054383;12514.43685034194;12580.811287830507 20:24:48 INFO - PROCESS | 5311 | |3;mootools.html;1523.8704710099644;1542.9614259643508;1702.4892532240324;1828.9176987035582;1835.6420498002885;7962.3232025277775;8562.272206862424;8668.956655216723;9253.676121335755;9263.675771348013;8607.784805379868;8822;8882.911170888288;8901.109889011095;8985.730428087152;2322.198841399714;2333.708286464192;2336.2056900653774;2343.367290831483;2370.075670488502;2329.301209637111;2340.2979106268135;2352.623580227164;2365.9171928982487;2367.92896213113;2347.295811256625;2355.470019245673;2367.3489790307717;2378.0368950575044;2380.1312520929823;2275.6927814744963;2280.361498780344;2282.7603101674335;2288.5766133265397;2344.0858065354523;2266.3087758233733;2270.546850015991;2319.9188028418926;2335.871527066011;2344.0623750499767;8854.734357969272;8910.955445222797;8958.507282099481;8971.955140224258;8978.326625503114;5053.292539044537;5168.8449346519665;5315.73421328932;5315.867103322409;5318.574514038867;3424.332255210235;3457.8789742358895;3498.737594680409;3503.4219353806593;3509.929801403983;1200.147894994555;1203.6148432501602;1204.5723768062387;2166.24181536461;2210.602091623507;11746.823797643043;11957.521699132025;12005.279683218947;12016.63950081499;12062.155649104567;4693.389859318267;4696.8590942271785;4807.302941073524;4807.735574543433;4848.660593758403;10584.676915385577;10592.735181620366;10651.627193048362;10658.467076646137;10664.946675266574;5182.222666600041;5246.16061430177;5250.842474725764;5259.8422047338645;5320.76056577455;4242.17277630859;4735.2423612222565;4815.3499277597775;4824.8793780155775;4862.051899879561;4074.898127546776;4090.284200264942;4125.090419048931;4155.148194620096;4160.251154792106;1307.2744626732256;1310;1330.6606815262046;1335.125492802216;1346.8720471555187;1005.1355833982769;1032.2516175772505;1038.8753349598096;1052.5211028981794;1054.915606751458;6016.157737916607;6115.3578874217565;6170.6914654268;6186.907196392058;6186.907196392058;425.3980617426369;429.10103333516236;438.7696459358862;445.0786871176633;447.63965008168736;4166.250074986531;4229.344451610005;4289.1421715657;4289.721168124062;4296.419983302214;10637.255392122477;10890;10957.83563246552;11020.724481888017;11026.944865275622;10273.383596984206;10870.728231794268;10939.726506837234;10956.780864382668;10971.83542246867;7960.920390796134;8177.75466735987;8296.128906464855;8306.875396869053;8333.499990000619;6208.844778880564;6212.596181248205;6370.713317900798;6386.616802991835;6501.9674901625185;10156.746081348025;10343.84484232722;10346.586136554453;10445.11216546602;10613.628523001658;10318.48407579633;10467.110295624958;10498.895011050097;10500.212484063573;10558.630447934285;7374.373178279906;7654.770356889302;7921.603919803872;8107.878381824159;8218.383621228311;8652.78368040804;8663.95668021681;8680.826383472422;8781.385303028726;8817;6954.478414119062;7202.207757146814;7204.063471748848;7231.2768723129375;7329.450291228072;7721.729739459092;7797.454178207471;7799.45403821727;7836.647350869111;7933.286004259644;6932.306769323229;6935.930640693528;6939.097917270722;6964.373206411447;6985.720571177096;5128.307678463509;5172.327597412313;5272.815451459181;5294.814681486129;5301.363836339664;5249.7375131242525;5263.052650522943;5281.207818827206;5305.549028332635;5328.200769884548 20:24:48 INFO - PROCESS | 5311 | |4;prototype.html;297.7350158359061;305.1988530108465;308.434023566755;311.59648255509114;314.7104663709387;5428.565714742821;5567.610267281292;5569.3316801983765;5627.184058311547;5666.32004159501;5563.582731295159;5573.526250268732;5589.74846131924;5594.49649531542;5606.327240731118;4269.893252668677;4274.893127671818;4278.315469524877;4285.485741710983;4287.892802679927;4007.9799601001955;4297.871063868089;4322.891927701801;4322.978385108086;4331.660903112315;4263.914721705564;4275.764832934187;4277.567015049946;4282.379055037018;4286.785660716967;4283.186194623012;4288.313869780835;4291.377750226231;4302.225599392108;4331.805068771912;3480.5301284326547;3740.2706472237924;3740.9438858417147;3746.138388170736;3750.7186960977765;5348.545373643245;5367.892642147174;5399.298091248152;5412.431694672042;5413.783448662049;4825.2629053540695;4843.854684359475;4845.370101886732;4845.757712114416;4877.268409738532;5610.821727437243;5818.912716309259;5826.359100498942;5828.1549175369755;5834.824955251349;4003.8798836034966;4022.5374081980654;4043.5754245804355;4058.5129784425762;4064.5732198119067;6067.848303792441;6083.9391606084255;6117.755289788403;6191.969040154815;6193.535484838655;3859;4101.384792281182;4113.136241389282;4122.814473348706;4123.628873401408;4164.292070348048;4172.457580514514;4193.832246710159;4194.622483976456;4201.936970945439;4873.707577545359;4873.853784386474;4897.240927656219;4906.307323973224;4927.187014142698;5377.4084850666395;5869.853253668607;5983.6708981005595;6005.057521814367;6008;1410.3512384303335;1425.8075159853495;1434.9139051656934;1446.2045874768835;1447.5729659750398;879.683314006957;904.2946501728662;908.6415808366403;920.3833431600843;922.8787023766022;5079.771410286546;5107.471801458228;5113.488651134931;5137.6660517066275;5177.844664660066;5399.460053994648;5409.56723462122;5421.701806400686;5429.959222835225;5458.781648734006;5057.8735531612;5083.872903177376;5101.387833459934;5332.9466705333225;5799.884002320015;3221.7744757866726;3236.336551007038;3254.153919980822;3259.2014956335374;3270.9345813083605;6150.261968563801;6227.723316720152;6275.96862015687;6285.654289014056;6292.678537507175;6157.568970172135;6166.4758495527485;6172.629642221481;6174.44430001302;6184.464369608529;6169.198004259418;6191.349908259568;6196.938030619726;6197.4732147767945;6213.502919766408;5811.506021988178;6025.427584379477;6069.575129740876;6080.695965201634;6083.93531132059;5999.40005999414;6014.398560144125;6040.728167232397;6062.514998799998;6105.473631592102;6097.451229389376;6307.842303942254;6351.9047214290895;6378.6810659467765;6415.935840641534;4067.3288907331143;4091.1998720562856;4100.835966561304;4106.137711080706;4128.442660240949;5888.3228428731245;6009.579329446897;6133.080037994337;6139.969300153471;6170.660613666291;5859.414058594107;5896.528277737685;5913.905927403444;5921.467067963904;5954.702264886651;5857;5859.44335288147;5867.559933004956;5892.616979896293;5984.431479009487;5687.260656114679;5851.531877449709;5861.238039054895;5877.911831322619;5891.7643294269465;5865.384134665969;5940.435658612425;5980.491658208927;6003.729832157476;6012.188354572077;5652.63257888236;5832.941670583409;5837.737301821343;5856.092305692625;5888.4700376966275 20:24:48 INFO - PROCESS | 5311 | |5;yui.html;779.6920216514477;810.9959450202748;852.1946760311506;859.9742007739766;902.7607683963747;16107.275172617232;16677.91661041693;16717;16730.16349182542;16764.32942682293;15587;16040.679186416264;16059.116748578823;16103.677926441464;16171.919140404281;690.5649440852281;824.3034635732796;847.1274587175219;847.966081356745;848.5799529233038;829.6266679994027;847.8007668197969;851.3402113362163;852.0797538658265;856.3620103023256;865.6796985115485;867.0592407238123;867.2411639815161;868.8609822428413;871.2724874729608;865.9393842431001;866.4541338956417;866.7269810009826;868.7871471489462;871.895372555291;631.782035197856;631.8136149835809;631.9526035547307;633.1009965848506;634.8317695810614;15138.848611513855;15207.31567079484;15226.695466090616;15232.162231077285;15284.617884552865;13466.461341546326;13522.93238533801;13538.255395953218;13567.864321356858;13601.523946661819;11601.303921764722;11818.349990750505;11906.523739050428;11913;12182.390880455941;3876.631719986625;3904.531456225243;3912.100216950089;3917.843286268546;3941.527016757979;61420;61840.381596183914;62198.68900655513;62283.065754013725;62360.68819655872;10559.894401056044;10674.573017079385;10709.78580428387;10814.134869210444;10864.565417383374;20253.29113481021;20490.487737806674;20765.169393224405;20846.166153353697;20901;8516.829663406697;8638.395312328203;8698.34762392823;8792.648294068165;8838.602262898185;4846.466888642247;4924.138275801721;4976.950230497721;4978.477259887732;4997.875053123628;3414.829258537063;3527.5766907971206;3548.929021419609;3549.94675079874;3550.0769799852224;646.2890820097855;646.4537465841356;657.8947368421029;667.7195577857311;673.7843889955266;658.0524045374646;674.7435974329724;736.1387177002813;745.8694728422504;783.115079959642;9761.65834195814;9936.354136981217;10071.899281007243;10328.586856525804;10370.637027703995;642.4539141729492;697.435077587156;729.4456213277947;782.4874707066766;790.7983464216588;4733.343329834599;4809.669241671147;4902.558769710743;4912.336595613399;4971.328870602495;67165;70815.6459217711;71119;71264.64367678128;71402.28597713956;63068.68465657642;63112.368876311564;63704.36295636984;63914;64548.354516455176;56455.71772141195;56970.145447817486;57054.71472642693;57471.71264143736;57600.13599796007;9474.099960503741;9544.570494327632;9582.520873956413;9586.568604412678;9634.277429192698;37801;38920.221595568495;38974.41538376983;39820.20359592734;39908.80045599753;47825.521744782105;51595.2260716082;51666.741666291426;51937;52538;11621.477033533341;11678.70803229926;11904.226225295675;11930.701732456759;12111.818322725343;13730;14586.708265834835;14851.851481485046;15106.622334441727;15332;13683;14097.577072687836;14125.929370353082;14419.639509012359;14462.638434039232;12741.55404560836;13720.86279137196;13739.381727822072;13914.373853176834;14340.139591624536;12174.75650487003;12426.37868106573;13160.60518184456;13179.802302965654;13303.733925321632;10240.180785537288;10445.791084178121;10653.89346106529;11165.72085697864;11196.94401527987;11411;11618.593349232737;11778.587749428729;11790.94104529472;11876.168668193144 20:24:48 INFO - PROCESS | 5311 | __end_tp_report 20:24:48 INFO - PROCESS | 5311 | __start_cc_report 20:24:48 INFO - PROCESS | 5311 | _x_x_mozilla_cycle_collect,332 20:24:48 INFO - PROCESS | 5311 | __end_cc_report 20:24:48 INFO - PROCESS | 5311 | __startTimestamp1463541888572__endTimestamp 20:24:48 INFO - PROCESS | 5311 | 20:24:48 INFO - PROCESS | 5311 | ------- Summary: start ------- 20:24:48 INFO - PROCESS | 5311 | Number of tests: 6 20:24:48 INFO - PROCESS | 5311 | 20:24:48 INFO - PROCESS | 5311 | [#0] dojo.html Cycles:165 Average:5422.00 Median:5690.97 stddev:739.06 (13.0%) stddev-sans-first:718.59 20:24:48 INFO - PROCESS | 5311 | Values: 3103.2 3107.5 3152.1 3155.0 3157.1 5439.5 5447.0 5464.2 5508.8 5521.9 5256.7 5444.8 5447.6 5454.9 5536.2 4935.3 4972.4 5104.1 5120.2 5175.5 574.3 4978.5 5078.0 5084.0 5132.2 4889.3 4921.4 4942.5 4960.5 4980.5 4882.9 4907.5 4971.1 4971.2 5013.7 4878.5 4901.9 4913.9 4922.0 4924.7 5356.0 5366.8 5387.5 5397.9 5410.9 5790.0 5796.4 5824.6 5846.4 5852.8 5900.9 5957.4 5963.6 5971.1 6005.0 5526.7 5545.0 5548.0 5549.6 5552.1 5815.0 5985.2 6017.6 6035.0 6043.2 5863.5 5864.5 5878.4 5878.6 5886.7 5932.0 5948.3 5966.5 5968.8 5974.0 5691.0 5714.2 5750.8 5765.6 5804.2 5683.7 5740.4 5768.3 5791.6 5798.0 4397.5 4419.6 4420.7 4446.7 4459.4 3899.8 3948.2 3969.3 3975.0 4021.9 5707.2 5725.3 5735.7 5743.3 5750.5 5919.9 6034.0 6041.7 6050.2 6055.3 5438.8 5574.1 5625.0 5628.9 5633.2 5039.7 5042.6 5044.9 5044.9 5088.1 5892.4 6124.8 6126.8 6132.7 6134.7 5785.8 5821.5 5827.0 5886.7 5891.1 6038.7 6039.2 6043.0 6057.5 6074.9 5665.0 5742.6 5762.5 5776.3 5778.9 5824.1 5913.4 5938.8 5950.6 6006.6 5732.3 5739.0 5757.9 5760.4 5783.9 5579.1 5697.2 5744.0 5780.5 5787.2 5524.7 5557.0 5585.4 5613.4 5650.5 5757.6 5759.3 5779.9 5781.0 5790.4 5492.9 5597.3 5597.4 5606.7 5611.3 20:24:48 INFO - PROCESS | 5311 | 20:24:48 INFO - PROCESS | 5311 | [#1] ext.html Cycles:180 Average:59500.04 Median:43171.50 stddev:117816.30 (272.9%) stddev-sans-first:118063.78 20:24:48 INFO - PROCESS | 5311 | Values: 591.0 632.3 643.2 643.9 661.1 43861.3 44529.3 44579.1 44678.6 49114.5 46526.8 47154.3 47191.3 47210.8 47229.5 8890.0 8951.8 8993.8 9012.8 9014.0 8786.0 8813.3 8878.9 8889.9 8894.7 8859.8 8925.6 8936.8 8986.5 8987.7 8857.0 8911.2 8932.3 8940.0 8966.3 8830.2 8842.6 8849.2 8919.0 8935.6 41953.0 42192.6 42379.2 42442.6 42529.8 3442.8 3541.8 3551.7 3553.9 3651.9 32382.0 32758.8 33085.3 33190.5 33211.7 4426.1 4433.6 4465.2 4496.8 4521.3 231066.0 344420.0 345989.0 347405.0 347939.0 37207.4 60665.4 61428.4 61468.4 61510.4 37997.6 38024.0 38086.4 38139.2 38154.4 14198.1 14330.1 14501.3 14506.1 14517.7 11674.4 11692.2 11696.7 11727.0 11732.4 8590.6 8615.0 8688.2 8704.9 8739.4 3269.8 3325.4 3361.1 3383.8 3399.7 1050.8 1139.6 1162.3 1190.7 1205.0 33709.2 33752.8 34158.3 34410.8 34466.1 1198.6 1224.7 1231.5 1267.5 1269.1 17789.7 17803.5 17860.9 17949.6 17965.3 522809.0 525057.0 527077.0 527281.0 529717.0 61163.7 61171.0 61351.7 61575.0 61694.0 1382.7 1387.5 1402.7 1410.0 1422.9 31760.5 31999.4 32078.0 32560.2 32902.1 53468.5 53839.0 53943.0 54266.0 54364.7 452763.0 454650.0 455338.0 455584.0 456459.9 29042.0 29176.4 29317.7 29392.7 29445.0 51437.0 51470.5 51472.7 52351.2 53294.7 43298.0 43923.8 44212.6 44953.1 45158.3 41712.4 42218.8 42559.8 42750.6 43562.3 43045.0 43966.0 44231.3 44339.1 46991.8 38077.8 38087.4 38228.6 38317.6 38529.0 29217.0 29384.3 29491.9 29509.0 29740.4 20:24:48 INFO - PROCESS | 5311 | 20:24:48 INFO - PROCESS | 5311 | [#2] jquery.html Cycles:180 Average:28832.31 Median:2052.41 stddev:78548.10 (3827.1%) stddev-sans-first:78739.44 20:24:48 INFO - PROCESS | 5311 | Values: 399.2 403.5 404.2 404.4 421.9 14000.9 18200.9 19305.1 19962.2 19989.9 18265.8 18284.2 18721.1 18903.3 19079.2 5602.5 5675.5 5865.0 5930.0 5945.9 5468.0 5777.2 5822.6 5836.4 5891.1 5685.7 5818.4 5842.5 5860.6 5866.9 5917.9 5939.9 5975.8 5987.2 5987.9 4933.2 5262.2 5779.7 5792.7 5797.7 13755.7 14033.2 14053.5 15396.8 22924.1 2207.6 2322.1 2353.6 2471.5 2541.4 9873.9 10235.1 10346.5 14596.1 14627.0 1959.6 1983.1 2003.3 2007.0 2056.2 78530.2 82027.0 82700.6 82794.8 83319.0 11165.0 11208.7 11301.2 11353.8 11484.7 15565.7 15573.7 15639.0 15733.3 15891.5 7663.8 7908.2 7937.3 8057.4 8086.4 7262.6 7339.4 7347.3 7443.9 7455.1 4748.0 4769.3 4775.3 4797.4 4981.1 1974.6 1985.7 2022.8 2048.6 2078.0 988.6 999.9 1024.3 1042.0 1065.0 19266.0 19276.5 19697.3 20025.0 20130.6 952.2 1049.5 1049.9 1063.2 1097.6 9057.3 11038.4 11221.4 11232.8 11282.9 464847.0 467533.0 472243.0 478538.0 485863.0 100379.0 104323.0 104470.0 104532.5 105536.0 1038.3 1044.6 1096.5 1104.7 1111.5 16711.9 17781.5 17854.6 18015.2 18023.3 39811.6 41636.6 42690.4 43393.6 44552.6 57065.0 58550.4 58790.0 59007.4 59444.4 5359.5 6275.8 8313.5 8739.4 9251.0 12671.0 13202.5 13213.1 13352.7 13356.5 12099.0 12548.4 12676.0 12686.7 12788.0 11799.2 12052.8 12132.9 12267.8 12300.8 12190.1 12269.1 12344.2 12466.4 12980.9 8848.0 8941.5 9021.6 9045.3 9077.4 9120.0 11772.6 12282.6 12514.4 12580.8 20:24:48 INFO - PROCESS | 5311 | 20:24:48 INFO - PROCESS | 5311 | [#3] mootools.html Cycles:180 Average:5859.69 Median:2359.41 stddev:3301.32 (139.9%) stddev-sans-first:3294.50 20:24:48 INFO - PROCESS | 5311 | Values: 1523.9 1543.0 1702.5 1828.9 1835.6 7962.3 8562.3 8669.0 9253.7 9263.7 8607.8 8822.0 8882.9 8901.1 8985.7 2322.2 2333.7 2336.2 2343.4 2370.1 2329.3 2340.3 2352.6 2365.9 2367.9 2347.3 2355.5 2367.3 2378.0 2380.1 2275.7 2280.4 2282.8 2288.6 2344.1 2266.3 2270.5 2319.9 2335.9 2344.1 8854.7 8911.0 8958.5 8972.0 8978.3 5053.3 5168.8 5315.7 5315.9 5318.6 3424.3 3457.9 3498.7 3503.4 3509.9 1200.1 1203.6 1204.6 2166.2 2210.6 11746.8 11957.5 12005.3 12016.6 12062.2 4693.4 4696.9 4807.3 4807.7 4848.7 10584.7 10592.7 10651.6 10658.5 10664.9 5182.2 5246.2 5250.8 5259.8 5320.8 4242.2 4735.2 4815.3 4824.9 4862.1 4074.9 4090.3 4125.1 4155.1 4160.3 1307.3 1310.0 1330.7 1335.1 1346.9 1005.1 1032.3 1038.9 1052.5 1054.9 6016.2 6115.4 6170.7 6186.9 6186.9 425.4 429.1 438.8 445.1 447.6 4166.3 4229.3 4289.1 4289.7 4296.4 10637.3 10890.0 10957.8 11020.7 11026.9 10273.4 10870.7 10939.7 10956.8 10971.8 7960.9 8177.8 8296.1 8306.9 8333.5 6208.8 6212.6 6370.7 6386.6 6502.0 10156.7 10343.8 10346.6 10445.1 10613.6 10318.5 10467.1 10498.9 10500.2 10558.6 7374.4 7654.8 7921.6 8107.9 8218.4 8652.8 8664.0 8680.8 8781.4 8817.0 6954.5 7202.2 7204.1 7231.3 7329.5 7721.7 7797.5 7799.5 7836.6 7933.3 6932.3 6935.9 6939.1 6964.4 6985.7 5128.3 5172.3 5272.8 5294.8 5301.4 5249.7 5263.1 5281.2 5305.5 5328.2 20:24:48 INFO - PROCESS | 5311 | 20:24:48 INFO - PROCESS | 5311 | [#4] prototype.html Cycles:180 Average:4872.78 Median:5511.18 stddev:1478.67 (26.8%) stddev-sans-first:1442.40 20:24:48 INFO - PROCESS | 5311 | Values: 297.7 305.2 308.4 311.6 314.7 5428.6 5567.6 5569.3 5627.2 5666.3 5563.6 5573.5 5589.7 5594.5 5606.3 4269.9 4274.9 4278.3 4285.5 4287.9 4008.0 4297.9 4322.9 4323.0 4331.7 4263.9 4275.8 4277.6 4282.4 4286.8 4283.2 4288.3 4291.4 4302.2 4331.8 3480.5 3740.3 3740.9 3746.1 3750.7 5348.5 5367.9 5399.3 5412.4 5413.8 4825.3 4843.9 4845.4 4845.8 4877.3 5610.8 5818.9 5826.4 5828.2 5834.8 4003.9 4022.5 4043.6 4058.5 4064.6 6067.8 6083.9 6117.8 6192.0 6193.5 3859.0 4101.4 4113.1 4122.8 4123.6 4164.3 4172.5 4193.8 4194.6 4201.9 4873.7 4873.9 4897.2 4906.3 4927.2 5377.4 5869.9 5983.7 6005.1 6008.0 1410.4 1425.8 1434.9 1446.2 1447.6 879.7 904.3 908.6 920.4 922.9 5079.8 5107.5 5113.5 5137.7 5177.8 5399.5 5409.6 5421.7 5430.0 5458.8 5057.9 5083.9 5101.4 5332.9 5799.9 3221.8 3236.3 3254.2 3259.2 3270.9 6150.3 6227.7 6276.0 6285.7 6292.7 6157.6 6166.5 6172.6 6174.4 6184.5 6169.2 6191.3 6196.9 6197.5 6213.5 5811.5 6025.4 6069.6 6080.7 6083.9 5999.4 6014.4 6040.7 6062.5 6105.5 6097.5 6307.8 6351.9 6378.7 6415.9 4067.3 4091.2 4100.8 4106.1 4128.4 5888.3 6009.6 6133.1 6140.0 6170.7 5859.4 5896.5 5913.9 5921.5 5954.7 5857.0 5859.4 5867.6 5892.6 5984.4 5687.3 5851.5 5861.2 5877.9 5891.8 5865.4 5940.4 5980.5 6003.7 6012.2 5652.6 5832.9 5837.7 5856.1 5888.5 20:24:48 INFO - PROCESS | 5311 | 20:24:48 INFO - PROCESS | 5311 | [#5] yui.html Cycles:180 Average:16395.42 Median:4828.07 stddev:19579.32 (405.5%) stddev-sans-first:19599.12 20:24:48 INFO - PROCESS | 5311 | Values: 779.7 811.0 852.2 860.0 902.8 16107.3 16677.9 16717.0 16730.2 16764.3 15587.0 16040.7 16059.1 16103.7 16171.9 690.6 824.3 847.1 848.0 848.6 829.6 847.8 851.3 852.1 856.4 865.7 867.1 867.2 868.9 871.3 865.9 866.5 866.7 868.8 871.9 631.8 631.8 632.0 633.1 634.8 15138.8 15207.3 15226.7 15232.2 15284.6 13466.5 13522.9 13538.3 13567.9 13601.5 11601.3 11818.3 11906.5 11913.0 12182.4 3876.6 3904.5 3912.1 3917.8 3941.5 61420.0 61840.4 62198.7 62283.1 62360.7 10559.9 10674.6 10709.8 10814.1 10864.6 20253.3 20490.5 20765.2 20846.2 20901.0 8516.8 8638.4 8698.3 8792.6 8838.6 4846.5 4924.1 4977.0 4978.5 4997.9 3414.8 3527.6 3548.9 3549.9 3550.1 646.3 646.5 657.9 667.7 673.8 658.1 674.7 736.1 745.9 783.1 9761.7 9936.4 10071.9 10328.6 10370.6 642.5 697.4 729.4 782.5 790.8 4733.3 4809.7 4902.6 4912.3 4971.3 67165.0 70815.6 71119.0 71264.6 71402.3 63068.7 63112.4 63704.4 63914.0 64548.4 56455.7 56970.1 57054.7 57471.7 57600.1 9474.1 9544.6 9582.5 9586.6 9634.3 37801.0 38920.2 38974.4 39820.2 39908.8 47825.5 51595.2 51666.7 51937.0 52538.0 11621.5 11678.7 11904.2 11930.7 12111.8 13730.0 14586.7 14851.9 15106.6 15332.0 13683.0 14097.6 14125.9 14419.6 14462.6 12741.6 13720.9 13739.4 13914.4 14340.1 12174.8 12426.4 13160.6 13179.8 13303.7 10240.2 10445.8 10653.9 11165.7 11196.9 11411.0 11618.6 11778.6 11790.9 11876.2 20:24:48 INFO - PROCESS | 5311 | -------- Summary: end -------- 20:24:48 INFO - PROCESS | 5311 | 20:24:49 INFO - TEST-INFO | 5311: exit 0 20:24:49 INFO - TEST-OK | dromaeo_css | took 1110161ms 20:24:49 INFO - TEST-START | kraken 20:24:49 INFO - operating with platform_type : linux_ 20:24:49 INFO - Initialising browser for kraken test... 20:24:49 INFO - TEST-INFO | started process 5545 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeSaYK9/profile http://localhost:42620/getInfo.html) 20:24:52 INFO - PROCESS | 5545 | 20:24:52 INFO - PROCESS | 5545 | (process:5613): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:24:53 INFO - PROCESS | 5545 | __metrics Screen width/height:1600/1200 20:24:53 INFO - PROCESS | 5545 | colorDepth:24 20:24:53 INFO - PROCESS | 5545 | Browser inner width/height: 1024/697 20:24:53 INFO - PROCESS | 5545 | __metrics 20:24:54 ERROR - PROCESS | 5545 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 20:24:55 INFO - TEST-INFO | 5545: exit 0 20:24:55 INFO - Browser initialized. 20:24:55 INFO - Running cycle 1/1 for kraken test... 20:24:55 INFO - TEST-INFO | started process 5664 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeSaYK9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:24:57 INFO - PROCESS | 5664 | 20:24:57 INFO - PROCESS | 5664 | (process:5727): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:25:07 INFO - PROCESS | 5664 | RSS: Main: 164024320 20:25:07 INFO - PROCESS | 5664 | 20:25:09 INFO - PROCESS | 5664 | Cycle 1(1): loaded http://localhost:42620/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42620/tests/kraken/driver.html?testName=audio-beat-detection) 20:25:10 INFO - PROCESS | 5664 | RSS: Main: 168206336 20:25:10 INFO - PROCESS | 5664 | 20:25:13 INFO - PROCESS | 5664 | Cycle 1(1): loaded http://localhost:42620/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42620/tests/kraken/driver.html?testName=audio-dft) 20:25:14 INFO - PROCESS | 5664 | RSS: Main: 168837120 20:25:14 INFO - PROCESS | 5664 | 20:25:16 INFO - PROCESS | 5664 | Cycle 1(1): loaded http://localhost:42620/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42620/tests/kraken/driver.html?testName=audio-fft) 20:25:17 INFO - PROCESS | 5664 | RSS: Main: 163844096 20:25:17 INFO - PROCESS | 5664 | 20:25:19 INFO - PROCESS | 5664 | Cycle 1(1): loaded http://localhost:42620/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42620/tests/kraken/driver.html?testName=audio-oscillator) 20:25:20 INFO - PROCESS | 5664 | RSS: Main: 162918400 20:25:20 INFO - PROCESS | 5664 | 20:25:22 INFO - PROCESS | 5664 | Cycle 1(1): loaded http://localhost:42620/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42620/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:25:23 INFO - PROCESS | 5664 | RSS: Main: 163246080 20:25:23 INFO - PROCESS | 5664 | 20:25:26 INFO - PROCESS | 5664 | Cycle 1(1): loaded http://localhost:42620/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42620/tests/kraken/driver.html?testName=imaging-darkroom) 20:25:27 INFO - PROCESS | 5664 | RSS: Main: 163639296 20:25:27 INFO - PROCESS | 5664 | 20:25:30 INFO - PROCESS | 5664 | Cycle 1(1): loaded http://localhost:42620/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42620/tests/kraken/driver.html?testName=imaging-desaturate) 20:25:31 INFO - PROCESS | 5664 | RSS: Main: 162361344 20:25:31 INFO - PROCESS | 5664 | 20:25:34 INFO - PROCESS | 5664 | Cycle 1(1): loaded http://localhost:42620/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42620/tests/kraken/driver.html?testName=json-parse-financial) 20:25:34 INFO - PROCESS | 5664 | RSS: Main: 163454976 20:25:34 INFO - PROCESS | 5664 | 20:25:36 INFO - PROCESS | 5664 | Cycle 1(1): loaded http://localhost:42620/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42620/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:25:36 INFO - PROCESS | 5664 | RSS: Main: 163737600 20:25:36 INFO - PROCESS | 5664 | 20:25:38 INFO - PROCESS | 5664 | Cycle 1(1): loaded http://localhost:42620/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42620/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:25:39 INFO - PROCESS | 5664 | RSS: Main: 163508224 20:25:39 INFO - PROCESS | 5664 | 20:25:41 INFO - PROCESS | 5664 | Cycle 1(1): loaded http://localhost:42620/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42620/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:25:42 INFO - PROCESS | 5664 | RSS: Main: 164491264 20:25:42 INFO - PROCESS | 5664 | 20:25:44 INFO - PROCESS | 5664 | Cycle 1(1): loaded http://localhost:42620/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42620/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:25:45 INFO - PROCESS | 5664 | RSS: Main: 164155392 20:25:45 INFO - PROCESS | 5664 | 20:25:48 INFO - PROCESS | 5664 | Cycle 1(1): loaded http://localhost:42620/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42620/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:25:48 INFO - PROCESS | 5664 | RSS: Main: 164446208 20:25:48 INFO - PROCESS | 5664 | 20:25:50 INFO - PROCESS | 5664 | Cycle 1(1): loaded http://localhost:42620/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42620/tests/kraken/driver.html?testName=ai-astar) 20:25:50 INFO - PROCESS | 5664 | RSS: Main: 166494208 20:25:50 INFO - PROCESS | 5664 | 20:25:50 INFO - PROCESS | 5664 | __start_tp_report 20:25:50 INFO - PROCESS | 5664 | _x_x_mozilla_page_load 20:25:50 INFO - PROCESS | 5664 | _x_x_mozilla_page_load_details 20:25:50 INFO - PROCESS | 5664 | |i|pagename|runs| 20:25:50 INFO - PROCESS | 5664 | |0;ai-astar;113;112;103;112;112;114;106;111;112;111 20:25:50 INFO - PROCESS | 5664 | |1;audio-beat-detection;157;130;156;219;130;157;157;125;200;129 20:25:50 INFO - PROCESS | 5664 | |2;audio-dft;162;162;162;162;165;175;163;162;162;164 20:25:50 INFO - PROCESS | 5664 | |3;audio-fft;75;75;75;165;77;76;74;75;174;75 20:25:50 INFO - PROCESS | 5664 | |4;audio-oscillator;92;92;184;92;92;92;156;92;92;140 20:25:50 INFO - PROCESS | 5664 | |5;imaging-gaussian-blur;117;118;117;117;117;118;117;117;117;117 20:25:50 INFO - PROCESS | 5664 | |6;imaging-darkroom;147;146;146;146;147;146;147;146;146;146 20:25:50 INFO - PROCESS | 5664 | |7;imaging-desaturate;95;95;95;95;95;95;96;96;95;95 20:25:50 INFO - PROCESS | 5664 | |8;json-parse-financial;54;56;54;57;58;54;58;112;53;53 20:25:50 INFO - PROCESS | 5664 | |9;json-stringify-tinderbox;57;58;58;57;59;58;57;58;58;58 20:25:50 INFO - PROCESS | 5664 | |10;stanford-crypto-aes;79;78;80;80;79;83;80;86;84;79 20:25:50 INFO - PROCESS | 5664 | |11;stanford-crypto-ccm;123;125;123;121;119;121;131;117;195;151 20:25:50 INFO - PROCESS | 5664 | |12;stanford-crypto-pbkdf2;168;165;160;163;160;164;164;158;164;165 20:25:50 INFO - PROCESS | 5664 | |13;stanford-crypto-sha256-iterative;65;65;64;63;63;62;67;65;64;65 20:25:50 INFO - PROCESS | 5664 | __end_tp_report 20:25:50 INFO - PROCESS | 5664 | __start_cc_report 20:25:50 INFO - PROCESS | 5664 | _x_x_mozilla_cycle_collect,875 20:25:50 INFO - PROCESS | 5664 | __end_cc_report 20:25:50 INFO - PROCESS | 5664 | __startTimestamp1463541950881__endTimestamp 20:25:50 INFO - PROCESS | 5664 | 20:25:50 INFO - PROCESS | 5664 | ------- Summary: start ------- 20:25:50 INFO - PROCESS | 5664 | Number of tests: 14 20:25:50 INFO - PROCESS | 5664 | 20:25:50 INFO - PROCESS | 5664 | [#0] ai-astar Cycles:10 Average:110.60 Median:112.00 stddev:3.41 (3.0%) stddev-sans-first:3.50 20:25:50 INFO - PROCESS | 5664 | Values: 113.0 112.0 103.0 112.0 112.0 114.0 106.0 111.0 112.0 111.0 20:25:50 INFO - PROCESS | 5664 | 20:25:50 INFO - PROCESS | 5664 | [#1] audio-beat-detection Cycles:10 Average:156.00 Median:157.00 stddev:31.53 (20.1%) stddev-sans-first:33.45 20:25:50 INFO - PROCESS | 5664 | Values: 157.0 130.0 156.0 219.0 130.0 157.0 157.0 125.0 200.0 129.0 20:25:50 INFO - PROCESS | 5664 | 20:25:50 INFO - PROCESS | 5664 | [#2] audio-dft Cycles:10 Average:163.90 Median:162.50 stddev:4.04 (2.5%) stddev-sans-first:4.23 20:25:50 INFO - PROCESS | 5664 | Values: 162.0 162.0 162.0 162.0 165.0 175.0 163.0 162.0 162.0 164.0 20:25:50 INFO - PROCESS | 5664 | 20:25:50 INFO - PROCESS | 5664 | [#3] audio-fft Cycles:10 Average:94.10 Median:75.00 stddev:39.80 (53.1%) stddev-sans-first:41.61 20:25:50 INFO - PROCESS | 5664 | Values: 75.0 75.0 75.0 165.0 77.0 76.0 74.0 75.0 174.0 75.0 20:25:50 INFO - PROCESS | 5664 | 20:25:50 INFO - PROCESS | 5664 | [#4] audio-oscillator Cycles:10 Average:112.40 Median:92.00 stddev:34.48 (37.5%) stddev-sans-first:35.78 20:25:50 INFO - PROCESS | 5664 | Values: 92.0 92.0 184.0 92.0 92.0 92.0 156.0 92.0 92.0 140.0 20:25:50 INFO - PROCESS | 5664 | 20:25:50 INFO - PROCESS | 5664 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 20:25:50 INFO - PROCESS | 5664 | Values: 117.0 118.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 20:25:50 INFO - PROCESS | 5664 | 20:25:50 INFO - PROCESS | 5664 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 20:25:50 INFO - PROCESS | 5664 | Values: 147.0 146.0 146.0 146.0 147.0 146.0 147.0 146.0 146.0 146.0 20:25:50 INFO - PROCESS | 5664 | 20:25:50 INFO - PROCESS | 5664 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 20:25:50 INFO - PROCESS | 5664 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 96.0 96.0 95.0 95.0 20:25:50 INFO - PROCESS | 5664 | 20:25:50 INFO - PROCESS | 5664 | [#8] json-parse-financial Cycles:10 Average:60.90 Median:55.00 stddev:18.06 (32.8%) stddev-sans-first:18.98 20:25:50 INFO - PROCESS | 5664 | Values: 54.0 56.0 54.0 57.0 58.0 54.0 58.0 112.0 53.0 53.0 20:25:50 INFO - PROCESS | 5664 | 20:25:50 INFO - PROCESS | 5664 | [#9] json-stringify-tinderbox Cycles:10 Average:57.80 Median:58.00 stddev:0.63 (1.1%) stddev-sans-first:0.60 20:25:50 INFO - PROCESS | 5664 | Values: 57.0 58.0 58.0 57.0 59.0 58.0 57.0 58.0 58.0 58.0 20:25:50 INFO - PROCESS | 5664 | 20:25:50 INFO - PROCESS | 5664 | [#10] stanford-crypto-aes Cycles:10 Average:80.80 Median:80.00 stddev:2.62 (3.3%) stddev-sans-first:2.69 20:25:50 INFO - PROCESS | 5664 | Values: 79.0 78.0 80.0 80.0 79.0 83.0 80.0 86.0 84.0 79.0 20:25:50 INFO - PROCESS | 5664 | 20:25:50 INFO - PROCESS | 5664 | [#11] stanford-crypto-ccm Cycles:10 Average:132.60 Median:124.00 stddev:23.98 (19.3%) stddev-sans-first:25.18 20:25:50 INFO - PROCESS | 5664 | Values: 123.0 125.0 123.0 121.0 119.0 121.0 131.0 117.0 195.0 151.0 20:25:50 INFO - PROCESS | 5664 | 20:25:50 INFO - PROCESS | 5664 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.10 Median:164.00 stddev:2.96 (1.8%) stddev-sans-first:2.55 20:25:50 INFO - PROCESS | 5664 | Values: 168.0 165.0 160.0 163.0 160.0 164.0 164.0 158.0 164.0 165.0 20:25:50 INFO - PROCESS | 5664 | 20:25:50 INFO - PROCESS | 5664 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.30 Median:65.00 stddev:1.42 (2.2%) stddev-sans-first:1.48 20:25:50 INFO - PROCESS | 5664 | Values: 65.0 65.0 64.0 63.0 63.0 62.0 67.0 65.0 64.0 65.0 20:25:50 INFO - PROCESS | 5664 | -------- Summary: end -------- 20:25:50 INFO - PROCESS | 5664 | 20:25:51 INFO - TEST-INFO | 5664: exit 0 20:25:51 INFO - TEST-OK | kraken | took 62581ms 20:25:51 INFO - SUITE-END | took 1172s 20:25:52 INFO - Completed test suite (00:19:32) 20:25:52 INFO - javascript benchmark 20:25:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7226.269628565924, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3103.1931697758578, 3107.456195165846, 3152.1174071260043, 3155.0377134973824, 3157.084445510802, 5439.537639300659, 5446.972765136169, 5464.207689884969, 5508.807191748289, 5521.861953451165, 5256.658317209379, 5444.7822087116465, 5447.645903016301, 5454.945450545493, 5536.2249285100115, 4935.259711043345, 4972.403311602613, 5104.132297509433, 5120.23196520523, 5175.456577059411, 574.3304124159084, 4978.452370239271, 5078.0, 5084.034033533617, 5132.230165475171, 4889.291052797343, 4921.384826896638, 4942.456329803718, 4960.454350021495, 4980.526849949267, 4882.852529655528, 4907.484714105003, 4971.080350135237, 4971.229459433757, 5013.749312534359, 4878.463369029404, 4901.852944411673, 4913.8771530711665, 4921.990991846698, 4924.704517728947, 5355.973220133875, 5366.812161574326, 5387.488188622075, 5397.866448045876, 5410.91883621746, 5789.971050144764, 5796.362400135981, 5824.563157763185, 5846.415358464162, 5852.76588936442, 5900.940990590082, 5957.374475680078, 5963.642181469082, 5971.134185543116, 6005.0, 5526.696031718254, 5545.0, 5547.972260138714, 5549.556035517189, 5552.11166213408, 5814.970925145347, 5985.16207730918, 6017.638941663514, 6034.969825150934, 6043.184170137063, 5863.501602363847, 5864.472197502245, 5878.353381128072, 5878.559108066912, 5886.705664716747, 5932.0, 5948.345681974979, 5966.492848107872, 5968.761249550056, 5974.0, 5690.971545142248, 5714.200011998323, 5750.827475175752, 5765.596408251382, 5804.158397032406, 5683.658980461186, 5740.39725828782, 5768.336641286306, 5791.5656325775735, 5798.0, 4397.538258482813, 4419.580139886705, 4420.734755914656, 4446.73319600825, 4459.397981272552, 3899.7660140391667, 3948.230095131422, 3969.285528604879, 3974.960250397459, 4021.8994525137105, 5707.229524014288, 5725.2843394575675, 5735.741891614887, 5743.282089738783, 5750.539956803445, 5919.911201331984, 6033.9698301508215, 6041.697915104315, 6050.2437195350585, 6055.303640081447, 5438.809641662523, 5574.136008918624, 5624.97187514068, 5628.915566266509, 5633.239512665819, 5039.748012599355, 5042.571381432619, 5044.873878153002, 5044.924326135111, 5088.1350170471105, 5892.410758924159, 6124.846878828065, 6126.846828829315, 6132.6933653317155, 6134.6625935573975, 5785.768569257267, 5821.53427725781, 5827.038538641246, 5886.705664716661, 5891.05743081105, 6038.6678732670125, 6039.245094363205, 6043.0, 6057.545684073801, 6074.878502429839, 5665.0, 5742.626729262584, 5762.4525670061275, 5776.335721392094, 5778.85552861165, 5824.097264923944, 5913.438223368773, 5938.792142275, 5950.613210141327, 6006.639601623917, 5732.254806875079, 5738.96698594257, 5757.913631295618, 5760.366359700346, 5783.8554036149435, 5579.107342825128, 5697.230873832145, 5744.023516002206, 5780.537556995514, 5787.189793428839, 5524.668519888659, 5557.0, 5585.441455854382, 5613.438656134517, 5650.491455769001, 5757.568182386254, 5759.337676167294, 5779.942200577941, 5781.0, 5790.4209579043445, 5492.945070549403, 5597.3003374578175, 5597.384287728265, 5606.6916319602815, 5611.3266408031295], "value": 5373.183834700657, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.9822705318842, 632.2823595219426, 643.2249139786558, 643.8680070585531, 661.1141070964906, 43861.34207986879, 44529.33206001913, 44579.10841783162, 44678.553214467844, 49114.50885491144, 46526.76736616321, 47154.29268560974, 47191.292130617985, 47210.763946180225, 47229.52770472303, 8889.955550222256, 8951.776205594879, 8993.775155621097, 9012.774680633003, 9014.0, 8785.95607021964, 8813.338999575026, 8878.911210887905, 8889.866652000224, 8894.688685895995, 8859.822803543926, 8925.642974281021, 8936.821263574724, 8986.505742184178, 8987.685431009915, 8857.0, 8911.15344042315, 8932.285417166611, 8939.95530022349, 8966.282697384193, 8830.161134692195, 8842.646294148226, 8849.203571678516, 8918.955405222932, 8935.64257429702, 41953.0, 42192.57807421948, 42379.152416951794, 42442.57557424417, 42529.78735106336, 3442.7934323940644, 3541.8229088545468, 3551.733619978512, 3553.8933831984823, 3651.8904432867057, 32382.0, 32758.836205819058, 33085.338293234, 33190.502142467885, 33211.6678833211, 4426.083804624694, 4433.578810013044, 4465.151621191963, 4496.820127194908, 4521.253993091169, 231066.0, 344420.0, 345989.0, 347405.0, 347938.9999999975, 37207.44188837169, 60665.393346066856, 61428.385716142264, 61468.38531614716, 61510.38489615046, 37997.62002379996, 38024.0, 38086.428703569465, 38139.23721525554, 38154.42768358421, 14198.077124987049, 14330.140191588538, 14501.274936253145, 14506.057106288057, 14517.709645807025, 11674.357910315015, 11692.181547291779, 11696.70758231051, 11727.0, 11732.354720490284, 8590.613422396007, 8614.956925215334, 8688.218060374471, 8704.912950870537, 8739.43193692408, 3269.75476839238, 3325.401427742981, 3361.058903507022, 3383.763136580465, 3399.6940275375337, 1050.805600963809, 1139.5840518210794, 1162.267771304073, 1190.732085280805, 1204.9878102394032, 33709.15727106842, 33752.83123584367, 34158.316833663186, 34410.82794586011, 34466.138346541535, 1198.6404078776332, 1224.7305592769576, 1231.5443285984243, 1267.5436842736608, 1269.1306455078302, 17789.7331540027, 17803.46589602314, 17860.91069544644, 17949.641007180046, 17965.281388744304, 522809.0, 525057.0, 527077.0, 527281.0, 529717.0, 61163.69418152881, 61171.0, 61351.6932415344, 61575.0, 61694.0, 1382.7372799168127, 1387.5143699705225, 1402.747505449029, 1409.9647508812157, 1422.879055280292, 31760.523592145673, 31999.36001280008, 32078.0, 32560.18599534936, 32902.10349516147, 53468.46531534635, 53839.0, 53942.99999999843, 54266.0, 54364.72817635886, 452763.0, 454650.0, 455338.0, 455584.0, 456459.8708025887, 29042.0, 29176.416471670873, 29317.706822931497, 29392.706072938996, 29445.0, 51437.0, 51470.485295148064, 51472.74263628658, 52351.214731778295, 53294.73352633212, 43298.0, 43923.78038109789, 44212.55787442213, 44953.1009379804, 45158.32262515999, 41712.3743143847, 42218.78890605527, 42559.787201063795, 42750.572494275904, 43562.34656480092, 43045.0, 43966.0, 44231.33652995272, 44339.11321773611, 46991.76504117458, 38077.809610951765, 38087.42868856914, 38228.6177138225, 38317.616823831406, 38529.0, 29217.0, 29384.26539336534, 29491.85254073716, 29509.0, 29740.405191896472], "value": 19462.090852902056, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [399.2354640862746, 403.513765912076, 404.1633817996747, 404.35303514377, 421.8692205416321, 14000.929995350009, 18200.90899545502, 19305.13126909289, 19962.201511939522, 19989.900050499764, 18265.817341826576, 18284.177212025457, 18721.06394680264, 18903.33838315659, 19079.236830526796, 5602.467765562265, 5675.5459563234845, 5865.0, 5929.970350148244, 5945.910811337833, 5467.99999999998, 5777.1623114648355, 5822.592418530705, 5836.416358364151, 5891.145783861338, 5685.744141513642, 5818.389069147721, 5842.47417732404, 5860.619059761123, 5866.941330586704, 5917.852053698649, 5939.851503712399, 5975.820725378246, 5987.191729116579, 5987.850303742398, 4933.210686290176, 5262.210668399733, 5779.682117483537, 5792.652440853562, 5797.739101740432, 13755.656108597364, 14033.1580105194, 14053.5081272156, 15396.846031539653, 22924.083036678512, 2207.646776515766, 2322.059565875823, 2353.5645905507536, 2471.542764588557, 2541.3646588352913, 9873.851892221623, 10235.130013948823, 10346.482675866177, 14596.051256668283, 14627.0, 1959.5688948431323, 1983.1373352591525, 2003.3188715836686, 2006.9698954515547, 2056.1980827477296, 78530.21469785286, 82027.0, 82700.58649706712, 82794.75807862887, 83319.0, 11165.0, 11208.66374008781, 11301.208915375844, 11353.829692554618, 11484.655460336204, 15565.688686226438, 15573.688526229413, 15639.0, 15733.292001859943, 15891.523254302389, 7663.770086897291, 7908.169642187602, 7937.285644292041, 8057.35541156706, 8086.43394962347, 7262.600556969312, 7339.412846972229, 7347.265273472717, 7443.925560744432, 7455.142658594223, 4747.976260118747, 4769.260764581495, 4775.307580400822, 4797.352357431702, 4981.103401387712, 1974.634692581877, 1985.7319261899459, 2022.7572691277142, 2048.6261830990943, 2077.958440831175, 988.5699720621552, 999.8750156230471, 1024.3444195714749, 1041.9687409377732, 1064.9680509584725, 19266.0, 19276.518087047654, 19697.310594129136, 20025.0, 20130.597388052156, 952.2429668413628, 1049.454283772434, 1049.9370037797758, 1063.1654151491043, 1097.5829184909683, 9057.275417966546, 11038.448077596087, 11221.438928053565, 11232.831507527393, 11282.887171128348, 464847.0, 467533.0, 472243.0, 478538.0, 485863.0, 100379.0, 104323.0, 104470.0, 104532.47733761283, 105536.0, 1038.2732087538602, 1044.6448207609449, 1096.4736926275432, 1104.6520346090956, 1111.4609414433994, 16711.91644041772, 17781.46655600334, 17854.642907141526, 18015.189316480526, 18023.279068837623, 39811.60188398079, 41636.58363416327, 42690.359644605975, 43393.56606433895, 44552.55447445484, 57065.0, 58550.41449585449, 58790.0, 59007.40992590019, 59444.405555943886, 5359.490848369399, 6275.843103922439, 8313.459625124347, 8739.422089766555, 9250.95374523123, 12671.0, 13202.471901123847, 13213.075084743976, 13352.732945341233, 13356.532521361705, 12099.0, 12548.372581370711, 12676.0, 12686.746265074462, 12788.0, 11799.17405781587, 12052.819207712068, 12132.878671213175, 12267.754644906874, 12300.753984920073, 12190.08574356909, 12269.141160118706, 12344.197627154206, 12466.376681165724, 12980.870191297967, 8847.955760221157, 8941.46351218929, 9021.639134434548, 9045.321600879828, 9077.409968352036, 9120.0, 11772.587959421378, 12282.631521054383, 12514.43685034194, 12580.811287830507], "value": 9288.025145780151, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1523.8704710099644, 1542.9614259643508, 1702.4892532240324, 1828.9176987035582, 1835.6420498002885, 7962.3232025277775, 8562.272206862424, 8668.956655216723, 9253.676121335755, 9263.675771348013, 8607.784805379868, 8822.0, 8882.911170888288, 8901.109889011095, 8985.730428087152, 2322.198841399714, 2333.708286464192, 2336.2056900653774, 2343.367290831483, 2370.075670488502, 2329.301209637111, 2340.2979106268135, 2352.623580227164, 2365.9171928982487, 2367.92896213113, 2347.295811256625, 2355.470019245673, 2367.3489790307717, 2378.0368950575044, 2380.1312520929823, 2275.6927814744963, 2280.361498780344, 2282.7603101674335, 2288.5766133265397, 2344.0858065354523, 2266.3087758233733, 2270.546850015991, 2319.9188028418926, 2335.871527066011, 2344.0623750499767, 8854.734357969272, 8910.955445222797, 8958.507282099481, 8971.955140224258, 8978.326625503114, 5053.292539044537, 5168.8449346519665, 5315.73421328932, 5315.867103322409, 5318.574514038867, 3424.332255210235, 3457.8789742358895, 3498.737594680409, 3503.4219353806593, 3509.929801403983, 1200.147894994555, 1203.6148432501602, 1204.5723768062387, 2166.24181536461, 2210.602091623507, 11746.823797643043, 11957.521699132025, 12005.279683218947, 12016.63950081499, 12062.155649104567, 4693.389859318267, 4696.8590942271785, 4807.302941073524, 4807.735574543433, 4848.660593758403, 10584.676915385577, 10592.735181620366, 10651.627193048362, 10658.467076646137, 10664.946675266574, 5182.222666600041, 5246.16061430177, 5250.842474725764, 5259.8422047338645, 5320.76056577455, 4242.17277630859, 4735.2423612222565, 4815.3499277597775, 4824.8793780155775, 4862.051899879561, 4074.898127546776, 4090.284200264942, 4125.090419048931, 4155.148194620096, 4160.251154792106, 1307.2744626732256, 1310.0, 1330.6606815262046, 1335.125492802216, 1346.8720471555187, 1005.1355833982769, 1032.2516175772505, 1038.8753349598096, 1052.5211028981794, 1054.915606751458, 6016.157737916607, 6115.3578874217565, 6170.6914654268, 6186.907196392058, 6186.907196392058, 425.3980617426369, 429.10103333516236, 438.7696459358862, 445.0786871176633, 447.63965008168736, 4166.250074986531, 4229.344451610005, 4289.1421715657, 4289.721168124062, 4296.419983302214, 10637.255392122477, 10890.0, 10957.83563246552, 11020.724481888017, 11026.944865275622, 10273.383596984206, 10870.728231794268, 10939.726506837234, 10956.780864382668, 10971.83542246867, 7960.920390796134, 8177.75466735987, 8296.128906464855, 8306.875396869053, 8333.499990000619, 6208.844778880564, 6212.596181248205, 6370.713317900798, 6386.616802991835, 6501.9674901625185, 10156.746081348025, 10343.84484232722, 10346.586136554453, 10445.11216546602, 10613.628523001658, 10318.48407579633, 10467.110295624958, 10498.895011050097, 10500.212484063573, 10558.630447934285, 7374.373178279906, 7654.770356889302, 7921.603919803872, 8107.878381824159, 8218.383621228311, 8652.78368040804, 8663.95668021681, 8680.826383472422, 8781.385303028726, 8817.0, 6954.478414119062, 7202.207757146814, 7204.063471748848, 7231.2768723129375, 7329.450291228072, 7721.729739459092, 7797.454178207471, 7799.45403821727, 7836.647350869111, 7933.286004259644, 6932.306769323229, 6935.930640693528, 6939.097917270722, 6964.373206411447, 6985.720571177096, 5128.307678463509, 5172.327597412313, 5272.815451459181, 5294.814681486129, 5301.363836339664, 5249.7375131242525, 5263.052650522943, 5281.207818827206, 5305.549028332635, 5328.200769884548], "value": 4655.8869786038085, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.7350158359061, 305.1988530108465, 308.434023566755, 311.59648255509114, 314.7104663709387, 5428.565714742821, 5567.610267281292, 5569.3316801983765, 5627.184058311547, 5666.32004159501, 5563.582731295159, 5573.526250268732, 5589.74846131924, 5594.49649531542, 5606.327240731118, 4269.893252668677, 4274.893127671818, 4278.315469524877, 4285.485741710983, 4287.892802679927, 4007.9799601001955, 4297.871063868089, 4322.891927701801, 4322.978385108086, 4331.660903112315, 4263.914721705564, 4275.764832934187, 4277.567015049946, 4282.379055037018, 4286.785660716967, 4283.186194623012, 4288.313869780835, 4291.377750226231, 4302.225599392108, 4331.805068771912, 3480.5301284326547, 3740.2706472237924, 3740.9438858417147, 3746.138388170736, 3750.7186960977765, 5348.545373643245, 5367.892642147174, 5399.298091248152, 5412.431694672042, 5413.783448662049, 4825.2629053540695, 4843.854684359475, 4845.370101886732, 4845.757712114416, 4877.268409738532, 5610.821727437243, 5818.912716309259, 5826.359100498942, 5828.1549175369755, 5834.824955251349, 4003.8798836034966, 4022.5374081980654, 4043.5754245804355, 4058.5129784425762, 4064.5732198119067, 6067.848303792441, 6083.9391606084255, 6117.755289788403, 6191.969040154815, 6193.535484838655, 3859.0, 4101.384792281182, 4113.136241389282, 4122.814473348706, 4123.628873401408, 4164.292070348048, 4172.457580514514, 4193.832246710159, 4194.622483976456, 4201.936970945439, 4873.707577545359, 4873.853784386474, 4897.240927656219, 4906.307323973224, 4927.187014142698, 5377.4084850666395, 5869.853253668607, 5983.6708981005595, 6005.057521814367, 6008.0, 1410.3512384303335, 1425.8075159853495, 1434.9139051656934, 1446.2045874768835, 1447.5729659750398, 879.683314006957, 904.2946501728662, 908.6415808366403, 920.3833431600843, 922.8787023766022, 5079.771410286546, 5107.471801458228, 5113.488651134931, 5137.6660517066275, 5177.844664660066, 5399.460053994648, 5409.56723462122, 5421.701806400686, 5429.959222835225, 5458.781648734006, 5057.8735531612, 5083.872903177376, 5101.387833459934, 5332.9466705333225, 5799.884002320015, 3221.7744757866726, 3236.336551007038, 3254.153919980822, 3259.2014956335374, 3270.9345813083605, 6150.261968563801, 6227.723316720152, 6275.96862015687, 6285.654289014056, 6292.678537507175, 6157.568970172135, 6166.4758495527485, 6172.629642221481, 6174.44430001302, 6184.464369608529, 6169.198004259418, 6191.349908259568, 6196.938030619726, 6197.4732147767945, 6213.502919766408, 5811.506021988178, 6025.427584379477, 6069.575129740876, 6080.695965201634, 6083.93531132059, 5999.40005999414, 6014.398560144125, 6040.728167232397, 6062.514998799998, 6105.473631592102, 6097.451229389376, 6307.842303942254, 6351.9047214290895, 6378.6810659467765, 6415.935840641534, 4067.3288907331143, 4091.1998720562856, 4100.835966561304, 4106.137711080706, 4128.442660240949, 5888.3228428731245, 6009.579329446897, 6133.080037994337, 6139.969300153471, 6170.660613666291, 5859.414058594107, 5896.528277737685, 5913.905927403444, 5921.467067963904, 5954.702264886651, 5857.0, 5859.44335288147, 5867.559933004956, 5892.616979896293, 5984.431479009487, 5687.260656114679, 5851.531877449709, 5861.238039054895, 5877.911831322619, 5891.7643294269465, 5865.384134665969, 5940.435658612425, 5980.491658208927, 6003.729832157476, 6012.188354572077, 5652.63257888236, 5832.941670583409, 5837.737301821343, 5856.092305692625, 5888.4700376966275], "value": 4384.365062339077, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [779.6920216514477, 810.9959450202748, 852.1946760311506, 859.9742007739766, 902.7607683963747, 16107.275172617232, 16677.91661041693, 16717.0, 16730.16349182542, 16764.32942682293, 15587.0, 16040.679186416264, 16059.116748578823, 16103.677926441464, 16171.919140404281, 690.5649440852281, 824.3034635732796, 847.1274587175219, 847.966081356745, 848.5799529233038, 829.6266679994027, 847.8007668197969, 851.3402113362163, 852.0797538658265, 856.3620103023256, 865.6796985115485, 867.0592407238123, 867.2411639815161, 868.8609822428413, 871.2724874729608, 865.9393842431001, 866.4541338956417, 866.7269810009826, 868.7871471489462, 871.895372555291, 631.782035197856, 631.8136149835809, 631.9526035547307, 633.1009965848506, 634.8317695810614, 15138.848611513855, 15207.31567079484, 15226.695466090616, 15232.162231077285, 15284.617884552865, 13466.461341546326, 13522.93238533801, 13538.255395953218, 13567.864321356858, 13601.523946661819, 11601.303921764722, 11818.349990750505, 11906.523739050428, 11913.0, 12182.390880455941, 3876.631719986625, 3904.531456225243, 3912.100216950089, 3917.843286268546, 3941.527016757979, 61420.0, 61840.381596183914, 62198.68900655513, 62283.065754013725, 62360.68819655872, 10559.894401056044, 10674.573017079385, 10709.78580428387, 10814.134869210444, 10864.565417383374, 20253.29113481021, 20490.487737806674, 20765.169393224405, 20846.166153353697, 20901.0, 8516.829663406697, 8638.395312328203, 8698.34762392823, 8792.648294068165, 8838.602262898185, 4846.466888642247, 4924.138275801721, 4976.950230497721, 4978.477259887732, 4997.875053123628, 3414.829258537063, 3527.5766907971206, 3548.929021419609, 3549.94675079874, 3550.0769799852224, 646.2890820097855, 646.4537465841356, 657.8947368421029, 667.7195577857311, 673.7843889955266, 658.0524045374646, 674.7435974329724, 736.1387177002813, 745.8694728422504, 783.115079959642, 9761.65834195814, 9936.354136981217, 10071.899281007243, 10328.586856525804, 10370.637027703995, 642.4539141729492, 697.435077587156, 729.4456213277947, 782.4874707066766, 790.7983464216588, 4733.343329834599, 4809.669241671147, 4902.558769710743, 4912.336595613399, 4971.328870602495, 67165.0, 70815.6459217711, 71119.0, 71264.64367678128, 71402.28597713956, 63068.68465657642, 63112.368876311564, 63704.36295636984, 63914.0, 64548.354516455176, 56455.71772141195, 56970.145447817486, 57054.71472642693, 57471.71264143736, 57600.13599796007, 9474.099960503741, 9544.570494327632, 9582.520873956413, 9586.568604412678, 9634.277429192698, 37801.0, 38920.221595568495, 38974.41538376983, 39820.20359592734, 39908.80045599753, 47825.521744782105, 51595.2260716082, 51666.741666291426, 51937.0, 52538.0, 11621.477033533341, 11678.70803229926, 11904.226225295675, 11930.701732456759, 12111.818322725343, 13730.0, 14586.708265834835, 14851.851481485046, 15106.622334441727, 15332.0, 13683.0, 14097.577072687836, 14125.929370353082, 14419.639509012359, 14462.638434039232, 12741.55404560836, 13720.86279137196, 13739.381727822072, 13914.373853176834, 14340.139591624536, 12174.75650487003, 12426.37868106573, 13160.60518184456, 13179.802302965654, 13303.733925321632, 10240.180785537288, 10445.791084178121, 10653.89346106529, 11165.72085697864, 11196.94401527987, 11411.0, 11618.593349232737, 11778.587749428729, 11790.94104529472, 11876.168668193144], "value": 7181.069887998108, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1555.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 112.0, 103.0, 112.0, 112.0, 114.0, 106.0, 111.0, 112.0, 111.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 130.0, 156.0, 219.0, 130.0, 157.0, 157.0, 125.0, 200.0, 129.0], "value": 156.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 162.0, 165.0, 175.0, 163.0, 162.0, 162.0, 164.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 165.0, 77.0, 76.0, 74.0, 75.0, 174.0, 75.0], "value": 94.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 184.0, 92.0, 92.0, 92.0, 156.0, 92.0, 92.0, 140.0], "value": 112.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 56.0, 54.0, 57.0, 58.0, 54.0, 58.0, 112.0, 53.0, 53.0], "value": 60.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 58.0, 57.0, 59.0, 58.0, 57.0, 58.0, 58.0, 58.0], "value": 57.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 80.0, 80.0, 79.0, 83.0, 80.0, 86.0, 84.0, 79.0], "value": 80.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 125.0, 123.0, 121.0, 119.0, 121.0, 131.0, 117.0, 195.0, 151.0], "value": 132.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 165.0, 160.0, 163.0, 160.0, 164.0, 164.0, 158.0, 164.0, 165.0], "value": 163.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 63.0, 63.0, 62.0, 67.0, 65.0, 64.0, 65.0], "value": 64.3, "unit": "score"}]}]} 20:25:52 INFO - Return code: 0 20:25:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:25:52 ERROR - # TBPL SUCCESS # 20:25:52 INFO - Running post-action listener: _resource_record_post_action 20:25:52 INFO - ##### 20:25:52 INFO - ##### Finished run-tests step (success) 20:25:52 INFO - ##### 20:25:52 INFO - Running post-run listener: _resource_record_post_run 20:25:52 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 536899584; Read time: 0; Write time: 380076 20:25:52 INFO - TinderboxPrint: CPU usage
13.4% 20:25:52 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 20:25:52 INFO - TinderboxPrint: I/O write bytes / time
536,899,584 / 380,076 20:25:52 INFO - TinderboxPrint: CPU idle
8,228.4 (86.6%) 20:25:52 INFO - TinderboxPrint: CPU user
1,218.1 (12.8%) 20:25:52 INFO - TinderboxPrint: Swap in / out
0 / 0 20:25:52 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 246460416; Read time: 0; Write time: 185008 20:25:52 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 290439168; Read time: 0; Write time: 195068 20:25:52 INFO - Running post-run listener: _upload_blobber_files 20:25:52 INFO - Blob upload gear active. 20:25:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:25:52 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 20:25:52 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:25:52 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:25:53 INFO - (blobuploader) - INFO - Open directory for files ... 20:25:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:25:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:25:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:25:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:25:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:25:53 INFO - (blobuploader) - INFO - Done attempting. 20:25:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:25:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:25:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:25:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:25:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:25:59 INFO - (blobuploader) - INFO - Done attempting. 20:25:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:25:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:25:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:25:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:25:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:25:59 INFO - (blobuploader) - INFO - Done attempting. 20:25:59 INFO - (blobuploader) - INFO - Iteration through files over. 20:25:59 INFO - Return code: 0 20:25:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:25:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:25:59 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f58a52aa804625a4cc477a3141f5eea404faccf13f2e3bbee002db81d64a3bd13e0dded57d647fa606f88f54e9b655e7057961dccbe79c5fa9fcc5f5152158fa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4a1e87e5c39d5e3b303cac9a67b2ee52b1426fc329327787d8a8a25a2ed626053fcd8419f32bc7be1743a32e069667bf21974500217050cc5cc42059532d73e9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f775f1a2de8ea3d0db2a4088f594b2483b2837d4fb42dedcf2fd78377964cbe6b82fa902554b977c0fdc0369ed517f43a57e923ae0f5e9c342993077d7624ac3"} 20:25:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:25:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:25:59 INFO - Contents: 20:25:59 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f58a52aa804625a4cc477a3141f5eea404faccf13f2e3bbee002db81d64a3bd13e0dded57d647fa606f88f54e9b655e7057961dccbe79c5fa9fcc5f5152158fa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4a1e87e5c39d5e3b303cac9a67b2ee52b1426fc329327787d8a8a25a2ed626053fcd8419f32bc7be1743a32e069667bf21974500217050cc5cc42059532d73e9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f775f1a2de8ea3d0db2a4088f594b2483b2837d4fb42dedcf2fd78377964cbe6b82fa902554b977c0fdc0369ed517f43a57e923ae0f5e9c342993077d7624ac3"} 20:25:59 INFO - Running post-run listener: copy_logs_to_upload_dir 20:25:59 INFO - Copying logs to upload dir... 20:25:59 INFO - mkdir: /builds/slave/test/build/upload/logs 20:25:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.168191 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-05-17 20:25:59.652532) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-17 20:25:59.656137) ========= 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=4300f881736b422476174874000001bc-1463538527.996764-621895711 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/sha512/f58a52aa804625a4cc477a3141f5eea404faccf13f2e3bbee002db81d64a3bd13e0dded57d647fa606f88f54e9b655e7057961dccbe79c5fa9fcc5f5152158fa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4a1e87e5c39d5e3b303cac9a67b2ee52b1426fc329327787d8a8a25a2ed626053fcd8419f32bc7be1743a32e069667bf21974500217050cc5cc42059532d73e9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f775f1a2de8ea3d0db2a4088f594b2483b2837d4fb42dedcf2fd78377964cbe6b82fa902554b977c0fdc0369ed517f43a57e923ae0f5e9c342993077d7624ac3"} build_url:https://queue.taskcluster.net/v1/task/bCVoaSvIQHOj6ZXBmhfFQg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011190 build_url: 'https://queue.taskcluster.net/v1/task/bCVoaSvIQHOj6ZXBmhfFQg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f58a52aa804625a4cc477a3141f5eea404faccf13f2e3bbee002db81d64a3bd13e0dded57d647fa606f88f54e9b655e7057961dccbe79c5fa9fcc5f5152158fa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4a1e87e5c39d5e3b303cac9a67b2ee52b1426fc329327787d8a8a25a2ed626053fcd8419f32bc7be1743a32e069667bf21974500217050cc5cc42059532d73e9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f775f1a2de8ea3d0db2a4088f594b2483b2837d4fb42dedcf2fd78377964cbe6b82fa902554b977c0fdc0369ed517f43a57e923ae0f5e9c342993077d7624ac3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-17 20:25:59.680646) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 20:25:59.680997) ========= 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=4300f881736b422476174874000001bc-1463538527.996764-621895711 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004718 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 20:25:59.764611) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-17 20:25:59.765025) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-17 20:25:59.765390) ========= ========= Total master_lag: 0.25 =========