builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-045 starttime: 1464264547.31 results: success (0) buildid: 20160526023003 builduid: ef97d721cf714cae9c4890c89d04cde6 revision: ebf96465a8de20345f7b8d176d827ec538ecbd09 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-26 05:09:07.310273) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-26 05:09:07.310697) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-26 05:09:07.311010) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-26 05:09:07.383990) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 05:09:07.384275) ========= 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-1464263334.719241-15083901 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-26 05:09:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 71.7M=0s 2016-05-26 05:09:08 (71.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.093891 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 05:09:07.514603) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 05:09:07.517916) ========= 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-1464263334.719241-15083901 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015279 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 05:09:07.583945) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 05:09:07.584285) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ebf96465a8de20345f7b8d176d827ec538ecbd09 --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 ebf96465a8de20345f7b8d176d827ec538ecbd09 --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-1464263334.719241-15083901 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-26 05:09:08,164 truncating revision to first 12 chars 2016-05-26 05:09:08,164 Setting DEBUG logging. 2016-05-26 05:09:08,164 attempt 1/10 2016-05-26 05:09:08,164 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ebf96465a8de?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-26 05:09:08,490 unpacking tar archive at: fx-team-ebf96465a8de/testing/mozharness/ program finished with exit code 0 elapsedTime=0.720677 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 05:09:08.318402) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-26 05:09:08.318707) ========= script_repo_revision: ebf96465a8de20345f7b8d176d827ec538ecbd09 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-26 05:09:08.319093) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-26 05:09:08.319356) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-26 05:09:08.329557) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-05-26 05:09:08.329837) ========= /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-1464263334.719241-15083901 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:09:08 INFO - MultiFileLogger online at 20160526 05:09:08 in /builds/slave/test 05:09:08 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 05:09:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:09:08 INFO - {'append_to_log': False, 05:09:08 INFO - 'base_work_dir': '/builds/slave/test', 05:09:08 INFO - 'blob_upload_branch': 'Fx-Team', 05:09:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:09:08 INFO - 'branch': 'Fx-Team', 05:09:08 INFO - 'buildbot_json_path': 'buildprops.json', 05:09:08 INFO - 'config_files': ('talos/linux_config.py',), 05:09:08 INFO - 'default_actions': ('clobber', 05:09:08 INFO - 'read-buildbot-config', 05:09:08 INFO - 'download-and-extract', 05:09:08 INFO - 'populate-webroot', 05:09:08 INFO - 'create-virtualenv', 05:09:08 INFO - 'install', 05:09:08 INFO - 'run-tests'), 05:09:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:09:09 INFO - 'download_minidump_stackwalk': True, 05:09:09 INFO - 'download_symbols': 'ondemand', 05:09:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:09:09 INFO - 'tooltool.py': '/tools/tooltool.py', 05:09:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:09:09 INFO - '/tools/misc-python/virtualenv.py')}, 05:09:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:09:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:09:09 INFO - 'installer_path': 'installer.exe', 05:09:09 INFO - 'log_level': 'info', 05:09:09 INFO - 'log_name': 'talos', 05:09:09 INFO - 'log_to_console': True, 05:09:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:09:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:09:09 INFO - 'opt_config_files': (), 05:09:09 INFO - 'pip_index': False, 05:09:09 INFO - 'sps_profile': False, 05:09:09 INFO - 'sps_profile_interval': 0, 05:09:09 INFO - 'suite': 'dromaeojs-e10s', 05:09:09 INFO - 'system_bits': '32', 05:09:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:09:09 INFO - 'title': 'talos-linux64-ix-045', 05:09:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:09:09 INFO - 'use_talos_json': True, 05:09:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:09:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:09:09 INFO - 'work_dir': 'build'} 05:09:09 INFO - ##### 05:09:09 INFO - ##### Running clobber step. 05:09:09 INFO - ##### 05:09:09 INFO - Running pre-action listener: _resource_record_pre_action 05:09:09 INFO - Running main action method: clobber 05:09:09 INFO - rmtree: /builds/slave/test/build 05:09:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:09:09 INFO - Running post-action listener: _resource_record_post_action 05:09:09 INFO - ##### 05:09:09 INFO - ##### Finished clobber step (success) 05:09:09 INFO - ##### 05:09:09 INFO - ##### 05:09:09 INFO - ##### Running read-buildbot-config step. 05:09:09 INFO - ##### 05:09:09 INFO - Running pre-action listener: _resource_record_pre_action 05:09:09 INFO - Running main action method: read_buildbot_config 05:09:09 INFO - Using buildbot properties: 05:09:09 INFO - { 05:09:09 INFO - "project": "", 05:09:09 INFO - "product": "firefox", 05:09:09 INFO - "script_repo_revision": "production", 05:09:09 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 05:09:09 INFO - "repository": "", 05:09:09 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 05:09:09 INFO - "buildid": "20160526023003", 05:09:09 INFO - "pgo_build": "True", 05:09:09 INFO - "basedir": "/builds/slave/test", 05:09:09 INFO - "buildnumber": 780, 05:09:09 INFO - "slavename": "talos-linux64-ix-045", 05:09:09 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:09:09 INFO - "platform": "ubuntu64_hw", 05:09:09 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:09:09 INFO - "branch": "fx-team", 05:09:09 INFO - "repo_path": "integration/fx-team", 05:09:09 INFO - "revision": "ebf96465a8de20345f7b8d176d827ec538ecbd09", 05:09:09 INFO - "stage_platform": "linux64-pgo", 05:09:09 INFO - "builduid": "ef97d721cf714cae9c4890c89d04cde6", 05:09:09 INFO - "slavebuilddir": "test" 05:09:09 INFO - } 05:09:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/fqWwQTqFQvego26DbFXU3A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 05:09:09 INFO - Running post-action listener: _resource_record_post_action 05:09:09 INFO - ##### 05:09:09 INFO - ##### Finished read-buildbot-config step (success) 05:09:09 INFO - ##### 05:09:09 INFO - ##### 05:09:09 INFO - ##### Running download-and-extract step. 05:09:09 INFO - ##### 05:09:09 INFO - Running pre-action listener: _resource_record_pre_action 05:09:09 INFO - Running main action method: download_and_extract 05:09:09 INFO - mkdir: /builds/slave/test/build/tests 05:09:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:09 INFO - https://queue.taskcluster.net/v1/task/fqWwQTqFQvego26DbFXU3A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:09:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqWwQTqFQvego26DbFXU3A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:09:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqWwQTqFQvego26DbFXU3A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:09:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqWwQTqFQvego26DbFXU3A/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 05:09:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqWwQTqFQvego26DbFXU3A/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 05:09:20 INFO - Downloaded 1361 bytes. 05:09:20 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:09:20 INFO - Using the following test package requirements: 05:09:20 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:09:20 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:09:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:09:20 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:09:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:09:20 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:09:20 INFO - u'jsshell-linux-x86_64.zip'], 05:09:20 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:09:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:09:20 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:09:20 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:09:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:09:20 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:09:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:09:20 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:09:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:09:20 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:09:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:09:20 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:09:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:20 INFO - https://queue.taskcluster.net/v1/task/fqWwQTqFQvego26DbFXU3A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:09:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqWwQTqFQvego26DbFXU3A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:09:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqWwQTqFQvego26DbFXU3A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:09:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqWwQTqFQvego26DbFXU3A/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 05:09:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqWwQTqFQvego26DbFXU3A/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 05:09:29 INFO - Downloaded 24408666 bytes. 05:09:29 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'] 05:09:29 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 05:09:31 INFO - Return code: 0 05:09:31 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 05:09:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:31 INFO - https://queue.taskcluster.net/v1/task/fqWwQTqFQvego26DbFXU3A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:09:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqWwQTqFQvego26DbFXU3A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:09:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqWwQTqFQvego26DbFXU3A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:09:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqWwQTqFQvego26DbFXU3A/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 05:09:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqWwQTqFQvego26DbFXU3A/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 05:09:32 INFO - Downloaded 24408666 bytes. 05:09:32 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'] 05:09:32 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 05:09:34 INFO - Return code: 0 05:09: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')]} 05:09:34 INFO - https://queue.taskcluster.net/v1/task/fqWwQTqFQvego26DbFXU3A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:09:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqWwQTqFQvego26DbFXU3A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:09:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqWwQTqFQvego26DbFXU3A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:09:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqWwQTqFQvego26DbFXU3A/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 05:09:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqWwQTqFQvego26DbFXU3A/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 05:09:35 INFO - Downloaded 10834034 bytes. 05:09:35 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'] 05:09:35 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 05:09:35 INFO - Return code: 0 05:09:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:35 INFO - https://queue.taskcluster.net/v1/task/fqWwQTqFQvego26DbFXU3A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:09:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqWwQTqFQvego26DbFXU3A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:09:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqWwQTqFQvego26DbFXU3A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:09:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqWwQTqFQvego26DbFXU3A/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 05:09:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fqWwQTqFQvego26DbFXU3A/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 05:09:36 INFO - Downloaded 58668691 bytes. 05:09:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fqWwQTqFQvego26DbFXU3A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:09:36 INFO - mkdir: /builds/slave/test/properties 05:09:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:09:36 INFO - Writing to file /builds/slave/test/properties/build_url 05:09:36 INFO - Contents: 05:09:36 INFO - build_url:https://queue.taskcluster.net/v1/task/fqWwQTqFQvego26DbFXU3A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:09:37 INFO - Running post-action listener: _resource_record_post_action 05:09:37 INFO - Running post-action listener: set_extra_try_arguments 05:09:37 INFO - ##### 05:09:37 INFO - ##### Finished download-and-extract step (success) 05:09:37 INFO - ##### 05:09:37 INFO - ##### 05:09:37 INFO - ##### Running populate-webroot step. 05:09:37 INFO - ##### 05:09:37 INFO - Running pre-action listener: _resource_record_pre_action 05:09:37 INFO - Running main action method: populate_webroot 05:09:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:09:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:09:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:09:37 INFO - '--tppagecycles', 05:09:37 INFO - '7'], 05:09:37 INFO - 'tests': ['tsvgm']}}, 05:09:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:09:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:09:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:09:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:09:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:09:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:09:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:37 INFO - 'talos_options': ['--disable-e10s'], 05:09:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:09:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:09:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:37 INFO - 'talos_options': ['--disable-e10s'], 05:09:37 INFO - 'tests': ['damp', 'tps']}, 05:09:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:37 INFO - 'tests': ['damp', 'tps']}, 05:09:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:09:37 INFO - 'tests': ['dromaeo_dom']}, 05:09:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:09:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:09:37 INFO - 'tests': ['a11yr', 05:09:37 INFO - 'ts_paint', 05:09:37 INFO - 'tpaint', 05:09:37 INFO - 'sessionrestore', 05:09:37 INFO - 'sessionrestore_no_auto_restore', 05:09:37 INFO - 'tabpaint']}, 05:09:37 INFO - 'other-e10s': {'tests': ['a11yr', 05:09:37 INFO - 'ts_paint', 05:09:37 INFO - 'tpaint', 05:09:37 INFO - 'sessionrestore', 05:09:37 INFO - 'sessionrestore_no_auto_restore', 05:09:37 INFO - 'tabpaint']}, 05:09:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:09:37 INFO - 'ts_paint', 05:09:37 INFO - 'tpaint', 05:09:37 INFO - 'sessionrestore', 05:09:37 INFO - 'sessionrestore_no_auto_restore', 05:09:37 INFO - 'tabpaint']}, 05:09:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:09:37 INFO - 'ts_paint', 05:09:37 INFO - 'tpaint', 05:09:37 INFO - 'sessionrestore', 05:09:37 INFO - 'sessionrestore_no_auto_restore', 05:09:37 INFO - 'tabpaint']}, 05:09:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:09:37 INFO - 'tests': ['a11yr', 05:09:37 INFO - 'ts_paint', 05:09:37 INFO - 'tpaint', 05:09:37 INFO - 'sessionrestore', 05:09:37 INFO - 'sessionrestore_no_auto_restore', 05:09:37 INFO - 'tabpaint']}, 05:09:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:09:37 INFO - 'tests': ['a11yr', 05:09:37 INFO - 'ts_paint', 05:09:37 INFO - 'tpaint', 05:09:37 INFO - 'sessionrestore', 05:09:37 INFO - 'sessionrestore_no_auto_restore', 05:09:37 INFO - 'tabpaint']}, 05:09:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:09:37 INFO - 'tests': ['tsvgx', 05:09:37 INFO - 'tsvgr_opacity', 05:09:37 INFO - 'tart', 05:09:37 INFO - 'tscrollx', 05:09:37 INFO - 'cart']}, 05:09:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:09:37 INFO - 'tsvgr_opacity', 05:09:37 INFO - 'tart', 05:09:37 INFO - 'tscrollx', 05:09:37 INFO - 'cart']}, 05:09:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:37 INFO - 'talos_options': ['--disable-e10s'], 05:09:37 INFO - 'tests': ['tp5o']}, 05:09:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:37 INFO - 'tests': ['tp5o']}, 05:09:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:37 INFO - 'talos_options': ['--disable-e10s', 05:09:37 INFO - '--xperf_path', 05:09:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:09:37 INFO - 'tests': ['tp5n']}, 05:09:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:37 INFO - 'talos_options': ['--xperf_path', 05:09:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:09:37 INFO - 'tests': ['tp5n']}}, 05:09:37 INFO - 'talos.zip': {'path': '', 05:09:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:09:37 INFO - Running post-action listener: _resource_record_post_action 05:09:37 INFO - ##### 05:09:37 INFO - ##### Finished populate-webroot step (success) 05:09:37 INFO - ##### 05:09:37 INFO - ##### 05:09:37 INFO - ##### Running create-virtualenv step. 05:09:37 INFO - ##### 05:09:37 INFO - Running pre-action listener: _resource_record_pre_action 05:09:37 INFO - Running main action method: create_virtualenv 05:09:37 INFO - Creating virtualenv /builds/slave/test/build/venv 05:09:37 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 05:09:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:09:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:09:37 INFO - Using real prefix '/usr' 05:09:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:09:38 INFO - Installing distribute.............................................................................................................................................................................................done. 05:09:40 INFO - Installing pip.................done. 05:09:40 INFO - Return code: 0 05:09:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:09:40 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')]} 05:09:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:40 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')]} 05:09:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:40 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 0x7f853f81df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x288c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29588e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e7b20>, '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 0x29e8a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29e8eb0>, '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-1464263334.719241-15083901', '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 05:09:40 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 05:09:40 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 05:09:40 INFO - Using env: {'DISPLAY': ':0', 05:09:40 INFO - 'HOME': '/home/cltbld', 05:09:40 INFO - 'LANG': 'en_US.UTF-8', 05:09:40 INFO - 'LANGUAGE': 'en_US:en', 05:09:40 INFO - 'LOGNAME': 'cltbld', 05:09:40 INFO - 'MAIL': '/var/mail/cltbld', 05:09:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:40 INFO - 'MOZ_NO_REMOTE': '1', 05:09:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:40 INFO - 'NO_EM_RESTART': '1', 05:09:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:40 INFO - 'PWD': '/builds/slave/test', 05:09:40 INFO - 'SHELL': '/bin/bash', 05:09:40 INFO - 'SHLVL': '1', 05:09:40 INFO - 'TERM': 'linux', 05:09:40 INFO - 'TMOUT': '86400', 05:09:40 INFO - 'USER': 'cltbld', 05:09:40 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1464263334.719241-15083901', 05:09:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:40 INFO - '_': '/tools/buildbot/bin/python'} 05:09:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:40 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 05:09:40 INFO - Cleaning up... 05:09:40 INFO - Return code: 0 05:09:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:09:40 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')]} 05:09:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:40 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')]} 05:09:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:40 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 0x7f853f81df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x288c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29588e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e7b20>, '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 0x29e8a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29e8eb0>, '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-1464263334.719241-15083901', '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 05:09:40 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 05:09:40 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 05:09:40 INFO - Using env: {'DISPLAY': ':0', 05:09:40 INFO - 'HOME': '/home/cltbld', 05:09:40 INFO - 'LANG': 'en_US.UTF-8', 05:09:40 INFO - 'LANGUAGE': 'en_US:en', 05:09:40 INFO - 'LOGNAME': 'cltbld', 05:09:40 INFO - 'MAIL': '/var/mail/cltbld', 05:09:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:40 INFO - 'MOZ_NO_REMOTE': '1', 05:09:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:40 INFO - 'NO_EM_RESTART': '1', 05:09:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:40 INFO - 'PWD': '/builds/slave/test', 05:09:40 INFO - 'SHELL': '/bin/bash', 05:09:40 INFO - 'SHLVL': '1', 05:09:40 INFO - 'TERM': 'linux', 05:09:40 INFO - 'TMOUT': '86400', 05:09:40 INFO - 'USER': 'cltbld', 05:09:40 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1464263334.719241-15083901', 05:09:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:40 INFO - '_': '/tools/buildbot/bin/python'} 05:09:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:40 INFO - Downloading/unpacking psutil>=3.1.1 05:09:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:09:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:09:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:09:42 INFO - Installing collected packages: psutil 05:09:42 INFO - Running setup.py install for psutil 05:09:42 INFO - building 'psutil._psutil_linux' extension 05:09:42 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 05:09: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 05:09:42 INFO - building 'psutil._psutil_posix' extension 05:09: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 05:09: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 05:09:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:09:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:09:42 INFO - Successfully installed psutil 05:09:42 INFO - Cleaning up... 05:09:42 INFO - Return code: 0 05:09:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:09: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')]} 05:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09: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')]} 05:09:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:43 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 0x7f853f81df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x288c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29588e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e7b20>, '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 0x29e8a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29e8eb0>, '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-1464263334.719241-15083901', '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 05:09:43 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 05:09:43 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 05:09:43 INFO - Using env: {'DISPLAY': ':0', 05:09:43 INFO - 'HOME': '/home/cltbld', 05:09:43 INFO - 'LANG': 'en_US.UTF-8', 05:09:43 INFO - 'LANGUAGE': 'en_US:en', 05:09:43 INFO - 'LOGNAME': 'cltbld', 05:09:43 INFO - 'MAIL': '/var/mail/cltbld', 05:09:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:43 INFO - 'MOZ_NO_REMOTE': '1', 05:09:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:43 INFO - 'NO_EM_RESTART': '1', 05:09:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:43 INFO - 'PWD': '/builds/slave/test', 05:09:43 INFO - 'SHELL': '/bin/bash', 05:09:43 INFO - 'SHLVL': '1', 05:09:43 INFO - 'TERM': 'linux', 05:09:43 INFO - 'TMOUT': '86400', 05:09:43 INFO - 'USER': 'cltbld', 05:09:43 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1464263334.719241-15083901', 05:09:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:43 INFO - '_': '/tools/buildbot/bin/python'} 05:09:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:09:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:09:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:09:45 INFO - Installing collected packages: mozsystemmonitor 05:09:45 INFO - Running setup.py install for mozsystemmonitor 05:09:45 INFO - Successfully installed mozsystemmonitor 05:09:45 INFO - Cleaning up... 05:09:45 INFO - Return code: 0 05:09:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:09:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:45 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 0x7f853f81df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x288c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29588e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e7b20>, '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 0x29e8a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29e8eb0>, '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-1464263334.719241-15083901', '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 05:09:45 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 05:09:45 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 05:09:45 INFO - Using env: {'DISPLAY': ':0', 05:09:45 INFO - 'HOME': '/home/cltbld', 05:09:45 INFO - 'LANG': 'en_US.UTF-8', 05:09:45 INFO - 'LANGUAGE': 'en_US:en', 05:09:45 INFO - 'LOGNAME': 'cltbld', 05:09:45 INFO - 'MAIL': '/var/mail/cltbld', 05:09:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:45 INFO - 'MOZ_NO_REMOTE': '1', 05:09:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:45 INFO - 'NO_EM_RESTART': '1', 05:09:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:45 INFO - 'PWD': '/builds/slave/test', 05:09:45 INFO - 'SHELL': '/bin/bash', 05:09:45 INFO - 'SHLVL': '1', 05:09:45 INFO - 'TERM': 'linux', 05:09:45 INFO - 'TMOUT': '86400', 05:09:45 INFO - 'USER': 'cltbld', 05:09:45 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1464263334.719241-15083901', 05:09:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:45 INFO - '_': '/tools/buildbot/bin/python'} 05:09:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:45 INFO - Downloading/unpacking blobuploader==1.2.4 05:09:45 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 05:09:45 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 05:09:45 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 05:09:45 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 05:09:45 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 05:09:45 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 05:09:47 INFO - Downloading blobuploader-1.2.4.tar.gz 05:09:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:09:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:09: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 05:09: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 05:09: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 05:09: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 05:09: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 05:09: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 05:09:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:09:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:09: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 05:09: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 05:09: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 05:09: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 05:09: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 05:09: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 05:09:48 INFO - Downloading docopt-0.6.1.tar.gz 05:09:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:09:48 INFO - Installing collected packages: blobuploader, requests, docopt 05:09:48 INFO - Running setup.py install for blobuploader 05:09:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:09:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:09:48 INFO - Running setup.py install for requests 05:09:48 INFO - Running setup.py install for docopt 05:09:48 INFO - Successfully installed blobuploader requests docopt 05:09:48 INFO - Cleaning up... 05:09:48 INFO - Return code: 0 05:09:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:09: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')]} 05:09:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09: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')]} 05:09:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09: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 0x7f853f81df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x288c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29588e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e7b20>, '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 0x29e8a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29e8eb0>, '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-1464263334.719241-15083901', '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 05:09: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 05:09: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 05:09:48 INFO - Using env: {'DISPLAY': ':0', 05:09:48 INFO - 'HOME': '/home/cltbld', 05:09:48 INFO - 'LANG': 'en_US.UTF-8', 05:09:48 INFO - 'LANGUAGE': 'en_US:en', 05:09:48 INFO - 'LOGNAME': 'cltbld', 05:09:48 INFO - 'MAIL': '/var/mail/cltbld', 05:09:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:48 INFO - 'MOZ_NO_REMOTE': '1', 05:09:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:48 INFO - 'NO_EM_RESTART': '1', 05:09:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:48 INFO - 'PWD': '/builds/slave/test', 05:09:48 INFO - 'SHELL': '/bin/bash', 05:09:48 INFO - 'SHLVL': '1', 05:09:48 INFO - 'TERM': 'linux', 05:09:48 INFO - 'TMOUT': '86400', 05:09:48 INFO - 'USER': 'cltbld', 05:09:48 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1464263334.719241-15083901', 05:09:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:48 INFO - '_': '/tools/buildbot/bin/python'} 05:09:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:09:48 INFO - Running setup.py (path:/tmp/pip-b5uI9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:09:49 INFO - Running setup.py (path:/tmp/pip-uZ8Qr4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:09:49 INFO - Running setup.py (path:/tmp/pip-ChMBn8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:09:49 INFO - Running setup.py (path:/tmp/pip-jBg9vv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:09:49 INFO - Running setup.py (path:/tmp/pip-WOJK3q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:09:49 INFO - Running setup.py (path:/tmp/pip-P3eWkq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:09:49 INFO - Running setup.py (path:/tmp/pip-Sx_5yg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:09:49 INFO - Running setup.py (path:/tmp/pip-UyrIHM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:09:49 INFO - Running setup.py (path:/tmp/pip-6Ppk3k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:09:49 INFO - Running setup.py (path:/tmp/pip-6agsPm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:09:49 INFO - Running setup.py (path:/tmp/pip-zKcsia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:09:49 INFO - Running setup.py (path:/tmp/pip-K4wQKr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:09:49 INFO - Running setup.py (path:/tmp/pip-tQW5oS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:09:49 INFO - Running setup.py (path:/tmp/pip-oRbuCg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:09:49 INFO - Running setup.py (path:/tmp/pip-AZeIE8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:09:50 INFO - Running setup.py (path:/tmp/pip-Lt70vH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:09:50 INFO - Running setup.py (path:/tmp/pip-FIb_xU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:09:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:09:50 INFO - Running setup.py install for manifestparser 05:09:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:09:50 INFO - Running setup.py install for mozcrash 05:09:50 INFO - Running setup.py install for mozdebug 05:09:50 INFO - Running setup.py install for mozdevice 05:09:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:09:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:09:50 INFO - Running setup.py install for mozfile 05:09:50 INFO - Running setup.py install for mozhttpd 05:09:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:09:50 INFO - Running setup.py install for mozinfo 05:09:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:09:50 INFO - Running setup.py install for mozInstall 05:09:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:09:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:09:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:09:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:09:50 INFO - Running setup.py install for mozleak 05:09:51 INFO - Running setup.py install for mozlog 05:09:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:09:51 INFO - Running setup.py install for moznetwork 05:09:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:09:51 INFO - Running setup.py install for mozprocess 05:09:51 INFO - Running setup.py install for mozprofile 05:09:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:09:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:09:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:09:51 INFO - Running setup.py install for mozrunner 05:09:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:09:51 INFO - Running setup.py install for mozscreenshot 05:09:51 INFO - Running setup.py install for moztest 05:09:51 INFO - Running setup.py install for mozversion 05:09:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:09:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:09:51 INFO - Cleaning up... 05:09:51 INFO - Return code: 0 05:09:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:09: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')]} 05:09:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09: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')]} 05:09:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09: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 0x7f853f81df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x288c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29588e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e7b20>, '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 0x29e8a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29e8eb0>, '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-1464263334.719241-15083901', '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 05:09: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 05:09: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 05:09:51 INFO - Using env: {'DISPLAY': ':0', 05:09:51 INFO - 'HOME': '/home/cltbld', 05:09:51 INFO - 'LANG': 'en_US.UTF-8', 05:09:51 INFO - 'LANGUAGE': 'en_US:en', 05:09:51 INFO - 'LOGNAME': 'cltbld', 05:09:51 INFO - 'MAIL': '/var/mail/cltbld', 05:09:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:51 INFO - 'MOZ_NO_REMOTE': '1', 05:09:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:51 INFO - 'NO_EM_RESTART': '1', 05:09:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:51 INFO - 'PWD': '/builds/slave/test', 05:09:51 INFO - 'SHELL': '/bin/bash', 05:09:51 INFO - 'SHLVL': '1', 05:09:51 INFO - 'TERM': 'linux', 05:09:51 INFO - 'TMOUT': '86400', 05:09:51 INFO - 'USER': 'cltbld', 05:09:51 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1464263334.719241-15083901', 05:09:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:51 INFO - '_': '/tools/buildbot/bin/python'} 05:09:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:09:52 INFO - Running setup.py (path:/tmp/pip-Cgq04e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:09:52 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)) 05:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:09:52 INFO - Running setup.py (path:/tmp/pip-e4WE8N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:09:52 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)) 05:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:09:52 INFO - Running setup.py (path:/tmp/pip-gAUitV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:09:52 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)) 05:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:09:52 INFO - Running setup.py (path:/tmp/pip-ZIGHiy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:09:52 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)) 05:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:09:52 INFO - Running setup.py (path:/tmp/pip-fB7Vlu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:09:52 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)) 05:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:09:52 INFO - Running setup.py (path:/tmp/pip-PiO5wj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:09:52 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)) 05:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:09:52 INFO - Running setup.py (path:/tmp/pip-rXyGJv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:09: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)) 05:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:09:52 INFO - Running setup.py (path:/tmp/pip-ZBGBHW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:09: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)) 05:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:09:52 INFO - Running setup.py (path:/tmp/pip-LKbFF5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:09: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)) 05:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:09:52 INFO - Running setup.py (path:/tmp/pip-SR5dwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:09: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)) 05:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:09:52 INFO - Running setup.py (path:/tmp/pip-TH4GSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:09: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)) 05:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:09:53 INFO - Running setup.py (path:/tmp/pip-KqUX6S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:09:53 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)) 05:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:09:53 INFO - Running setup.py (path:/tmp/pip-Zdbxlf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:09:53 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)) 05:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:09:53 INFO - Running setup.py (path:/tmp/pip-WB7N91-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:09:53 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)) 05:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:09:53 INFO - Running setup.py (path:/tmp/pip-FRrghq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:09:53 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)) 05:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:09:53 INFO - Running setup.py (path:/tmp/pip-JXgjDY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:09:53 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)) 05:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:09:53 INFO - Running setup.py (path:/tmp/pip-GGZ_Lv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:09:53 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)) 05:09:53 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)) 05:09:53 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)) 05:09:53 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)) 05:09:53 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)) 05:09:53 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)) 05:09:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:09:53 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 05:09:53 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 05:09:53 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 05:09:53 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 05:09:53 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 05:09:53 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 05:09:55 INFO - Downloading blessings-1.6.tar.gz 05:09:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:09:55 INFO - Installing collected packages: blessings 05:09:55 INFO - Running setup.py install for blessings 05:09:55 INFO - Successfully installed blessings 05:09:55 INFO - Cleaning up... 05:09:55 INFO - Return code: 0 05:09:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:09:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:09:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:09:55 INFO - Reading from file tmpfile_stdout 05:09:55 INFO - Current package versions: 05:09:55 INFO - argparse == 1.2.1 05:09:55 INFO - blessings == 1.6 05:09:55 INFO - blobuploader == 1.2.4 05:09:55 INFO - docopt == 0.6.1 05:09:55 INFO - manifestparser == 1.1 05:09:55 INFO - mozInstall == 1.12 05:09:55 INFO - mozcrash == 0.17 05:09:55 INFO - mozdebug == 0.1 05:09:55 INFO - mozdevice == 0.48 05:09:55 INFO - mozfile == 1.2 05:09:55 INFO - mozhttpd == 0.7 05:09:55 INFO - mozinfo == 0.9 05:09:55 INFO - mozleak == 0.1 05:09:55 INFO - mozlog == 3.2 05:09:55 INFO - moznetwork == 0.27 05:09:55 INFO - mozprocess == 0.22 05:09:55 INFO - mozprofile == 0.28 05:09:55 INFO - mozrunner == 6.11 05:09:55 INFO - mozscreenshot == 0.1 05:09:55 INFO - mozsystemmonitor == 0.3 05:09:55 INFO - moztest == 0.7 05:09:55 INFO - mozversion == 1.4 05:09:55 INFO - psutil == 3.1.1 05:09:55 INFO - requests == 1.2.3 05:09:55 INFO - wsgiref == 0.1.2 05:09:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:09: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')]} 05:09:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09: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')]} 05:09:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09: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 0x7f853f81df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x288c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29588e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e7b20>, '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 0x29e8a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29e8eb0>, '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-1464263334.719241-15083901', '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 05:09: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 05:09: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 05:09:55 INFO - Using env: {'DISPLAY': ':0', 05:09:55 INFO - 'HOME': '/home/cltbld', 05:09:55 INFO - 'LANG': 'en_US.UTF-8', 05:09:55 INFO - 'LANGUAGE': 'en_US:en', 05:09:55 INFO - 'LOGNAME': 'cltbld', 05:09:55 INFO - 'MAIL': '/var/mail/cltbld', 05:09:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:55 INFO - 'MOZ_NO_REMOTE': '1', 05:09:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:55 INFO - 'NO_EM_RESTART': '1', 05:09:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:55 INFO - 'PWD': '/builds/slave/test', 05:09:55 INFO - 'SHELL': '/bin/bash', 05:09:55 INFO - 'SHLVL': '1', 05:09:55 INFO - 'TERM': 'linux', 05:09:55 INFO - 'TMOUT': '86400', 05:09:55 INFO - 'USER': 'cltbld', 05:09:55 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1464263334.719241-15083901', 05:09:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:55 INFO - '_': '/tools/buildbot/bin/python'} 05:09:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:56 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)) 05:09:56 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)) 05:09:56 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)) 05:09:56 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)) 05:09:56 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)) 05:09:56 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)) 05:09:56 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)) 05:09:56 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)) 05:09:56 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)) 05:09:56 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)) 05:09:56 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)) 05:09:56 INFO - Cleaning up... 05:09:56 INFO - Return code: 0 05:09:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:09:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:56 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 0x7f853f81df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x288c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29588e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e7b20>, '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 0x29e8a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29e8eb0>, '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-1464263334.719241-15083901', '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 05:09:56 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 05:09:56 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 05:09:56 INFO - Using env: {'DISPLAY': ':0', 05:09:56 INFO - 'HOME': '/home/cltbld', 05:09:56 INFO - 'LANG': 'en_US.UTF-8', 05:09:56 INFO - 'LANGUAGE': 'en_US:en', 05:09:56 INFO - 'LOGNAME': 'cltbld', 05:09:56 INFO - 'MAIL': '/var/mail/cltbld', 05:09:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:56 INFO - 'MOZ_NO_REMOTE': '1', 05:09:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:56 INFO - 'NO_EM_RESTART': '1', 05:09:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:56 INFO - 'PWD': '/builds/slave/test', 05:09:56 INFO - 'SHELL': '/bin/bash', 05:09:56 INFO - 'SHLVL': '1', 05:09:56 INFO - 'TERM': 'linux', 05:09:56 INFO - 'TMOUT': '86400', 05:09:56 INFO - 'USER': 'cltbld', 05:09:56 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1464263334.719241-15083901', 05:09:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:56 INFO - '_': '/tools/buildbot/bin/python'} 05:09:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:56 INFO - Downloading/unpacking jsonschema 05:09:56 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 05:09:56 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 05:09:56 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 05:09:56 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 05:09:56 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 05:09:56 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 05:09:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:09:58 INFO - Downloading/unpacking functools32 (from jsonschema) 05:09: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 05:09: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 05:09: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 05:09: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 05:09: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 05:09: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 05:09:58 INFO - Downloading functools32-3.2.3-2.tar.gz 05:09:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:09:58 INFO - warning: no files found matching '*.txt' 05:09:58 INFO - no previously-included directories found matching 'build' 05:09:58 INFO - no previously-included directories found matching 'dist' 05:09:58 INFO - no previously-included directories found matching '.git*' 05:09:58 INFO - Installing collected packages: jsonschema, functools32 05:09:58 INFO - Running setup.py install for functools32 05:09:58 INFO - warning: no files found matching '*.txt' 05:09:58 INFO - no previously-included directories found matching 'build' 05:09:58 INFO - no previously-included directories found matching 'dist' 05:09:58 INFO - no previously-included directories found matching '.git*' 05:09:58 INFO - Successfully installed jsonschema functools32 05:09:58 INFO - Cleaning up... 05:09:58 INFO - Return code: 0 05:09:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:09:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f853f81df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x288c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29588e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e7b20>, '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 0x29e8a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29e8eb0>, '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-1464263334.719241-15083901', '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 05:09:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:09:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:09:58 INFO - Using env: {'DISPLAY': ':0', 05:09:58 INFO - 'HOME': '/home/cltbld', 05:09:58 INFO - 'LANG': 'en_US.UTF-8', 05:09:58 INFO - 'LANGUAGE': 'en_US:en', 05:09:58 INFO - 'LOGNAME': 'cltbld', 05:09:58 INFO - 'MAIL': '/var/mail/cltbld', 05:09:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:58 INFO - 'MOZ_NO_REMOTE': '1', 05:09:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:58 INFO - 'NO_EM_RESTART': '1', 05:09:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:58 INFO - 'PWD': '/builds/slave/test', 05:09:58 INFO - 'SHELL': '/bin/bash', 05:09:58 INFO - 'SHLVL': '1', 05:09:58 INFO - 'TERM': 'linux', 05:09:58 INFO - 'TMOUT': '86400', 05:09:58 INFO - 'USER': 'cltbld', 05:09:58 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1464263334.719241-15083901', 05:09:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:58 INFO - '_': '/tools/buildbot/bin/python'} 05:09:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:58 INFO - Downloading/unpacking flake8 05:09: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 05:09: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 05:09: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 05:09: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 05:09: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 05:09: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 05:10:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:10:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:10: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 05:10: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 05:10: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 05:10: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 05:10: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 05:10: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 05:10:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:10:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:10: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 05:10: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 05:10: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 05:10: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 05:10: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 05:10: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 05:10:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:10:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:10:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:10:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:10:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:10:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:10:01 INFO - no previously-included directories found matching 'docs/_build' 05:10:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:10:01 INFO - Running setup.py install for pep8 05:10:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:10:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:10:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:10:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:10:01 INFO - no previously-included directories found matching 'docs/_build' 05:10:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:10:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:10:01 INFO - Cleaning up... 05:10:01 INFO - Return code: 0 05:10:01 INFO - Running post-action listener: _resource_record_post_action 05:10:01 INFO - Running post-action listener: _start_resource_monitoring 05:10:01 INFO - Starting resource monitoring. 05:10:01 INFO - ##### 05:10:01 INFO - ##### Finished create-virtualenv step (success) 05:10:01 INFO - ##### 05:10:01 INFO - ##### 05:10:01 INFO - ##### Running install step. 05:10:01 INFO - ##### 05:10:01 INFO - Running pre-action listener: _resource_record_pre_action 05:10:01 INFO - Running main action method: install 05:10:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:10:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:10:01 INFO - Reading from file tmpfile_stdout 05:10:01 INFO - Detecting whether we're running mozinstall >=1.0... 05:10:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:10:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:10:01 INFO - Reading from file tmpfile_stdout 05:10:01 INFO - Output received: 05:10:01 INFO - Usage: mozinstall [options] installer 05:10:01 INFO - Options: 05:10:01 INFO - -h, --help show this help message and exit 05:10:01 INFO - -d DEST, --destination=DEST 05:10:01 INFO - Directory to install application into. [default: 05:10:01 INFO - "/builds/slave/test"] 05:10:01 INFO - --app=APP Application being installed. [default: firefox] 05:10:01 INFO - mkdir: /builds/slave/test/build/application 05:10: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'] 05:10: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 05:10:18 INFO - Reading from file tmpfile_stdout 05:10:18 INFO - Output received: 05:10:18 INFO - /builds/slave/test/build/application/firefox/firefox 05:10:18 INFO - Running post-action listener: _resource_record_post_action 05:10:18 INFO - ##### 05:10:18 INFO - ##### Finished install step (success) 05:10:18 INFO - ##### 05:10:18 INFO - ##### 05:10:18 INFO - ##### Running run-tests step. 05:10:18 INFO - ##### 05:10:18 INFO - Running pre-action listener: _resource_record_pre_action 05:10:18 INFO - Running main action method: run_tests 05:10:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:10:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:10:18 INFO - Python 2.7.3 05:10:18 INFO - Return code: 0 05:10:18 INFO - grabbing minidump binary from tooltool 05:10:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:18 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 0x29e7b20>, '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 0x29e8a20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29e8eb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:10:18 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 05:10:18 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 05:10:18 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 05:10:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:10:18 INFO - Return code: 0 05:10:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:10:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:10:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:10:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:10:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:10:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:10:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:10:19 INFO - Return code: 0 05:10:19 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/fqWwQTqFQvego26DbFXU3A/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 05:10:19 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/fqWwQTqFQvego26DbFXU3A/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 05:10:19 INFO - Using env: {'DISPLAY': ':0', 05:10:19 INFO - 'HOME': '/home/cltbld', 05:10:19 INFO - 'LANG': 'en_US.UTF-8', 05:10:19 INFO - 'LANGUAGE': 'en_US:en', 05:10:19 INFO - 'LOGNAME': 'cltbld', 05:10:19 INFO - 'MAIL': '/var/mail/cltbld', 05:10:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:10:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:10:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:19 INFO - 'MOZ_NO_REMOTE': '1', 05:10:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:10:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:19 INFO - 'NO_EM_RESTART': '1', 05:10:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:19 INFO - 'PWD': '/builds/slave/test', 05:10:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:10:19 INFO - 'SHELL': '/bin/bash', 05:10:19 INFO - 'SHLVL': '1', 05:10:19 INFO - 'TERM': 'linux', 05:10:19 INFO - 'TMOUT': '86400', 05:10:19 INFO - 'USER': 'cltbld', 05:10:19 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1464263334.719241-15083901', 05:10:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:19 INFO - '_': '/tools/buildbot/bin/python'} 05:10:19 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/fqWwQTqFQvego26DbFXU3A/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 05:10:19 INFO - mozversion application_buildid: 20160526023003 05:10:19 INFO - mozversion application_changeset: ebf96465a8de20345f7b8d176d827ec538ecbd09 05:10:19 INFO - mozversion application_display_name: Nightly 05:10:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:10:19 INFO - mozversion application_name: Firefox 05:10:19 INFO - mozversion application_remotingname: firefox 05:10:19 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:10:19 INFO - mozversion application_vendor: Mozilla 05:10:19 INFO - mozversion application_version: 49.0a1 05:10:19 INFO - mozversion platform_buildid: 20160526023003 05:10:19 INFO - mozversion platform_changeset: ebf96465a8de20345f7b8d176d827ec538ecbd09 05:10:19 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:10:19 INFO - mozversion platform_version: 49.0a1 05:10:19 INFO - using testdate: 1464264619 05:10:19 INFO - actual date: 1464264619 05:10:19 INFO - starting webserver on 'localhost:60998' 05:10:19 INFO - SUITE-START | Running 2 tests 05:10:19 INFO - TEST-START | dromaeo_css 05:10:19 INFO - operating with platform_type : linux_ 05:10:19 INFO - Initialising browser for dromaeo_css test... 05:10:19 INFO - TEST-INFO | started process 8532 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprXfyjC/profile http://localhost:60998/getInfo.html) 05:10:23 INFO - PROCESS | 8532 | 05:10:23 INFO - PROCESS | 8532 | (process:8599): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:10:24 INFO - PROCESS | 8532 | __metrics Screen width/height:1600/1200 05:10:24 INFO - PROCESS | 8532 | colorDepth:24 05:10:24 INFO - PROCESS | 8532 | Browser inner width/height: 1024/697 05:10:24 INFO - PROCESS | 8532 | __metrics 05:10:25 ERROR - PROCESS | 8532 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 05:10:26 INFO - TEST-INFO | 8532: exit 0 05:10:26 INFO - Browser initialized. 05:10:26 INFO - Running cycle 1/1 for dromaeo_css test... 05:10:26 INFO - TEST-INFO | started process 8650 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprXfyjC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:10:28 INFO - PROCESS | 8650 | 05:10:28 INFO - PROCESS | 8650 | (process:8713): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:10:38 INFO - PROCESS | 8650 | RSS: Main: 165945344 05:10:38 INFO - PROCESS | 8650 | 05:11:27 INFO - PROCESS | 8650 | 1464264687721 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] 05:13:35 INFO - PROCESS | 8650 | Cycle 1(1): loaded http://localhost:60998/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60998/tests/dromaeo/cssquery-ext.html) 05:13:36 INFO - PROCESS | 8650 | RSS: Main: 169517056 05:13:36 INFO - PROCESS | 8650 | 05:16:38 INFO - PROCESS | 8650 | Cycle 1(1): loaded http://localhost:60998/tests/dromaeo/cssquery-ext.html (next: http://localhost:60998/tests/dromaeo/cssquery-jquery.html) 05:16:39 INFO - PROCESS | 8650 | RSS: Main: 168914944 05:16:39 INFO - PROCESS | 8650 | 05:19:40 INFO - PROCESS | 8650 | Cycle 1(1): loaded http://localhost:60998/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60998/tests/dromaeo/cssquery-mootools.html) 05:19:41 INFO - PROCESS | 8650 | RSS: Main: 170217472 05:19:41 INFO - PROCESS | 8650 | 05:22:43 INFO - PROCESS | 8650 | Cycle 1(1): loaded http://localhost:60998/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60998/tests/dromaeo/cssquery-prototype.html) 05:22:43 INFO - PROCESS | 8650 | RSS: Main: 168128512 05:22:43 INFO - PROCESS | 8650 | 05:25:46 INFO - PROCESS | 8650 | Cycle 1(1): loaded http://localhost:60998/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60998/tests/dromaeo/cssquery-yui.html) 05:25:46 INFO - PROCESS | 8650 | RSS: Main: 168865792 05:25:46 INFO - PROCESS | 8650 | 05:28:49 INFO - PROCESS | 8650 | Cycle 1(1): loaded http://localhost:60998/tests/dromaeo/cssquery-yui.html (next: http://localhost:60998/tests/dromaeo/cssquery-dojo.html) 05:28:49 INFO - PROCESS | 8650 | RSS: Main: 171646976 05:28:49 INFO - PROCESS | 8650 | 05:28:49 INFO - PROCESS | 8650 | __start_tp_report 05:28:49 INFO - PROCESS | 8650 | _x_x_mozilla_page_load 05:28:49 INFO - PROCESS | 8650 | _x_x_mozilla_page_load_details 05:28:49 INFO - PROCESS | 8650 | |i|pagename|runs| 05:28:49 INFO - PROCESS | 8650 | |0;dojo.html;3095.938081238374;3097.473429516982;3151.7636177286695;3174.825384603846;3186.3786561620477;5500.092484740013;5538.141588053853;5540.418256083114;5559.972200138994;5584.86037849053;5459.3994660587305;5481;5482.0406428874885;5488.945110548893;5557.916631250524;4910.1898186799135;4940.604751619861;5068.695878247298;5069.493050694938;5116.744162791864;925.4545411088717;4907.656464047518;4937.506249375052;5008.373953255843;5059.569936555397;4972.080165169437;4973.776180071905;5002.924956125661;5020.497950204986;5027.698338099707;5014;5016.372953380827;5021.497850214986;5025.472325405853;5044.672096313765;4919.385076865392;4968.503149685039;4974.87562810929;4988.8752781180765;4997.450280469146;5396.244525766357;5426.728663566845;5441.727913604304;5443.2107344434835;5477.534409575191;5724.8282551523525;5824.330202026778;5887.293524777011;5923.259592550931;5926.377730338296;5870.148828419855;5922.318933322636;5935.762569497215;5957.374475680078;5997.070454079625;5492.80775172867;5501.889962200774;5520.089185284463;5521.4478552144865;5531.115021596565;5897.970510147422;6058.1215723719815;6060.121282414026;6071.6660583667435;6095.542834287447;5761.337446193657;5781.913271300934;5784.21913041734;5839.0949402842625;5848.64908105515;5868.853278667982;5885.264341957255;5897.675627840425;5902.763889444374;5917.142014407973;5823.242978412779;5887.411258874078;5890.528757699374;5897.823065308047;5907.232059832194;5815.79644712433;5861.443162899518;5888.234529511222;5900.970495147497;5941.940580594225;4379.934300985487;4499.347594598765;4499.662525310615;4509.098180363875;4577.06170235101;3902.2195560887935;3953.6046395360236;3970.086880017612;3987.960120398759;4006.4390985262085;5575.832725018256;5590;5644.096944488862;5645.802396916089;5648.604597678123;5798.536117110621;5978.940210597925;5999.940000600025;6008.218931538872;6021.7591296347655;5638.379778224392;5698.401667824902;5707.629004114802;5730.1404789281105;5735.799247026417;5076.466970967996;5087.03346364197;5128.435872054071;5133.6919784813035;5137.51193636604;5962.880742385128;6024.608400453956;6164.660943648142;6186.845328866814;6211.006239001828;6015.218021657157;6016.368281330398;6033.939660603338;6042.274927008787;6078.57449978515;6167.814965551041;6177.456411684596;6236.501079913505;6236.719347629459;6252.280987686474;5677.063284558167;5837.708114594168;5914.083317085859;5915.615484993462;5950.3454619992635;5961.672108033927;6008.909866352095;6072.605280656743;6086.969565152146;6118.938810612015;5828.795992140254;5877.970610146922;5883.470487656132;5892.292924849045;5907.586468947133;5701.800436984686;5729.598928074995;5745.023346031268;5757.91363129545;5829.883402332014;5686.34607020198;5689.1750696148;5700.629459085146;5707.229524014371;5730.541556675539;5832.358440571449;5833.0375488044;5849.94150058511;5854.356020837789;5861.208736820475;5530.253415788817;5631.408702086222;5679.801206957736;5692.6299790513485;5731.140328950691 05:28:49 INFO - PROCESS | 8650 | |1;ext.html;589.125149153507;637;643.9291677915428;654.0614218596314;662.2781168526305;39355.212895742065;40425.19149617006;43472.565274347246;43751;43880.3417948731;45544.12874905629;46289.537104628944;46403.303950440684;46540;46603.76698116505;8852.336074794384;9038.954805225965;9044.638214471413;9054.502002389865;9059.456432614032;8857.42426742263;8872.20150186483;8928.508932008737;8931;8958.059403762576;8924.598393072294;8941.061188575204;8965.148310910487;8969.730908072768;9007.369484136114;8892.599833007498;8949.239314658229;8965.058668839743;8973.865392019125;8986.101389861027;8893;8925.330600204945;8964.551772411418;9006.639734410615;9012.504312262823;43133.568664313585;43523.347149792775;43670.781646091884;43910;43944.56055439469;3461.2212252243294;3513.7013353864954;3521.5950165730756;3568.2506673598577;3875.457435958968;32103.83948080268;33268.6673133268;33649.6635033649;33750.662493375;34184.48723269153;4313.935290970638;4374.321980093091;4378.080603073358;4455.910881782379;4513.52607976161;345024;347722;348765;349618.25190874137;349626;34103.488447673306;62568;63438.682806585675;63516.682416587624;63572.364276356646;34629.82685086558;36369.636303636624;36507.452388214195;36559.4516082259;36822.63177368192;12987.220766754024;12991.220526768424;13031.869681303255;13049.739005219843;13088.607341779762;13182.60452186436;13202.669933251746;13212.801807972888;13257.535986240435;13288.800667989988;8306.501609903426;8369;8399;8447.788805279917;8449.66201351939;3284.868605255811;3284.917877053093;3302.85137168828;3360.24394511233;3382.289719158955;1045.4929359260752;1051.9000694933968;1058.962936297226;1166.3293606176483;1219.2806244315896;32765.836170818995;32803.67196328054;32809;33190.8340458301;33322.3335533288;1094.7044298039484;1123.07346439188;1123.6966019174777;1152.072581571826;1212.4180393411036;17012.972104236032;17584.736228956575;17600.823991760175;17684.381046663304;17732.645347092985;532881;537299;540524;541681;544325;58938.705306473195;59527.702361487914;59576.10635840466;59819;59846.10230846541;1298.8181654568368;1344.5428554291393;1365.8907287417182;1394.35859504629;1398.5804258722342;31439;32557.837210813796;33169.83415082909;33253.667463326026;33353.66646333506;52118;52226.477735222164;52322.73838630782;52474.47525524696;52737.7363113182;436894;442415;443540;446540;449343;28443;28628.28429289201;28773.28066798347;29007.129786106452;29058.418831622825;49934.250986235966;50200.24699629581;50373.24440133474;51035.74482127566;51475.742621288155;42184;42311.576884230766;42401.36397953972;42407.78796106;43882.780586096866;41327.58672413358;41507.584924150375;41908.16183676248;42258.36612450877;42690.78654606707;43199.56800431955;44328.55671443373;44503;45453;45503.544964551256;36463;36827;37633.81183094067;37699.62300377071;37964.430533542574;28870.7112928868;29171.833126674694;30037.69962300349;30078.248043798205;30190.84904575551 05:28:49 INFO - PROCESS | 8650 | |2;jquery.html;394.3591663546737;398.1956447975092;400.8476778824047;403.92325458162964;411.65832359141916;13945.372458239379;17922.731159032624;18902.527436814053;19023.52441188971;19133.33033343833;18283.72574411385;18289.359872404468;18744.250229990783;19416.41750747476;19418.805811941875;5631;5703.800366987156;5803.892574534404;5891.911621325662;5900.822975310747;5736.397678243787;5743.712814359286;5780.248567686195;5784.074548072309;5794.101914203284;5402.91895621564;5635.436456354352;5684.459976302265;5741.397153298906;5781.39295373986;5682.886342273152;5700.629459085146;5744.22452968848;5943.613665111797;6323.114763933053;5756.136579513065;5771.942280577183;5780.682062486561;5785.62393444429;5792.420757924216;13471.730565388736;13582;14002;14016.71966560663;14127;2278.28234106256;2280.213326402405;2281.4866655002656;2337.0418128567376;2414.5050264695697;10233.641822536176;10659.626913058006;10715.46422678863;13061.21632702041;13958.720825583532;1939.7284380186786;1993.6710442777069;2031.7765045844944;2046.5906818636333;2052.271443637517;80039.5998020012;83669;83685.58157209175;83769.58115209384;83890;10805.783884322269;10949.124070074375;10949.302858057014;11179.66461006171;11213.159013074051;15571.454999074978;15643.530694079196;15650.765238521431;15689.68620627581;15751.606209844616;8061.395395345373;8091.19088091198;8115.83768324642;8244.340452763765;8356.665733370719;7786.649600767979;7806.921930780733;7831.569263690438;7992.84014319722;8009.839803203903;4745.905081898342;4796.009655992793;4817.9518204818205;4914.582260507826;4938.555530002317;1905.3140869287045;1925.9792310075682;1960.9901950490157;2004.188303736989;2062.26789489732;871.3682580129356;939.4175611121149;940.5062342270226;976.7606936300651;1079.93626278116;18940.24239030451;19677.409677709693;19717.901410492857;19866.404007879788;19928.3025094121;954.6801821389773;978.6232300564334;1000.7698229407132;1026.3636545341787;1031.5564307347913;10953.507092180871;11105.611303604497;11204.719882002852;11211.439428028565;11230.887691123147;497109;500194;507048;509427;510621;57783.4221657778;67793.66103169453;79154.20845791469;85154;86861.82845428915;1014.4217795856291;1031.6698656429871;1043.5095505112586;1078.4769386847372;1085.4626959655022;17596.73604895902;17681.734773978656;17898.55253618618;17903.641927161643;18144;40954.38568421416;41620.375694364004;42153;42324.36513452239;42764.93087672833;58341.70829145827;58873;59698;59907;60394;5788.507976822018;7518.924810751822;7840.411969102454;8589.65641374338;8862.335324850534;13135.671608209872;13634.454621815017;13642.590722278348;13730.244836534086;13816.447342106605;11970.281783093042;12037.638870833889;12103.81844272319;12123.333216673167;12200.51197952072;11265.71835704114;11799.528018879491;11811.291322520676;11865.881341186823;12070.879291206975;11499.425028748696;12037.638870833889;12251.632451026484;12566.183198092094;12610.873891261337;7983.1617680142745;8066.193380661887;8149.79625509367;8176.67293308261;8221.753347399588;11889.28664280146;12107.818382724443;12116.757664846476;12200.206986545845;12269.815952760895 05:28:49 INFO - PROCESS | 8650 | |3;mootools.html;1553.8679212266957;1572.8033995750532;1747.2923465996269;1842.4933143385576;1869.2616416515468;7972.481788683732;8745.300375969922;8772.780680482983;9369.859452108216;9399.154076133147;8816.691415800447;9068.954655226731;9105.63577456901;9123.042080581543;9148.90851091489;2317.629179331303;2321.0367697405554;2331.2423462374713;2332.183735692511;2337.55586438577;2294.162630639821;2319.9304020879317;2358.3043002314357;2372.9169479068237;2382.5592265430864;2349.729781075181;2356.5051339218785;2365.053978408633;2371.1700904683394;2374.881255937205;2284.1548627007946;2284.520250747345;2298.264810068396;2299.7470278269375;2301.7122859642545;2271.500269940627;2276.089564174327;2276.2488378834946;2276.9886150569305;2283.9543209135722;8986.326025548111;9053.049429809907;9123.224525915306;9140.451572905647;9198.908010919871;5293.7353132343615;5402.567794576425;5406.54044406226;5415.593830462731;5416.295881535415;3261.266215101607;3378.2905589826164;3459.135216195951;3518.3842827505086;3518.8064656443885;1092.0280949954547;1108.312846035455;1112.554978008795;1150.6030419505257;1163.9825402618967;13224.14043087206;13243.536476223286;13245.271510066943;13254.138480998705;13273.734525309535;4688.859334219979;4706.10583989041;4714.363560919232;4718.598919091847;4734.053189362141;11157.721056973478;11199.832002519968;11202.103831693445;11206.495707693173;11235.325880447199;5425.701586412785;5427.3758517770175;5434.2935418395355;5446.618736688473;5447.237386765856;4426.380306757057;4765.356676848651;4850.029994001144;4924.876878078005;4925.679830811057;4100.979495102505;4101.958980410217;4137.234611596864;4146.66826653867;4167.270727622654;1286.3761075878192;1310.5020092364841;1335.7128217433299;1340.8793208611078;1342.9127106738226;1011.5346940407495;1013.8631284776608;1016.2479764973866;1027.0397178637998;1035.4770840725384;6122.234720659918;6331.68341582919;6334.556581039283;6403.007533832263;6432.6462044588;443.21329639889456;443.70715327884085;451.7447642082279;453.8615722204759;459.3706621927913;4348.173846969129;4360.803763830635;4411.404460397805;4419.381286619876;4430.867073987785;11314.943425282821;11449.828252576219;11652.94173529127;11681.299122052704;11704.765904682028;11443.084553235887;11576.536938522533;11587.826182607268;11609.709757256136;11629.709257268467;8061.596920153969;8347.749567512985;8426.441108394967;8433.578321084044;8553.315734741205;6240;6285.371462853861;6337.176167098248;6468.126802881551;6494.220693516808;10209.234307426825;10400.27198096126;10527.263091583516;10536.209784266057;10609.098226650822;10654.135526283024;10671.413072281099;10769.407682577534;10805.135589152691;10875.293105948089;7913.881291780513;8215.835683286421;8303.709370172257;8307.252347288773;8308.5430301334;8799.34004949644;8803.735887923373;8805.383623146574;8837.293016558531;8882.911170888208;7945.245201705829;8004.399670024655;8049.356051515748;8097.595120243846;8098.19018098209;7991.200879911962;7996.920030799618;8013.118556958846;8032.357411406956;8078.515289082674;7038.718451261892;7056.576605403692;7104.715811367488;7117.43060555144;7129.3583577478275;5309.973450132725;5327;5375.784968601212;5458.727063646881;5530.723463826873;5346.144616861284;5392.325959255093;5429.077056900415;5465.453454654662;5506.284183056177 05:28:49 INFO - PROCESS | 8650 | |4;prototype.html;324.30598519168996;334.3930765660327;335.65930580460827;341.055276883034;345.7562418494961;5503.422140675221;5612.859678508039;5634.859128521789;5700.857478563038;5712.200291959129;5627.324721033471;5636.859078523039;5650.7174641267975;5674.971625141879;5686.829395118143;4365.432493775813;4373.234683930315;4375.4311939447825;4382.9342559861625;4408.493023302329;4113.56807535209;4313;4360.454943132108;4396;4401.515833258339;4262.295081967207;4264.701470897038;4277.230098582254;4292.270314046604;4305.720128191673;4299.806508707115;4300.827966881321;4308.375285583573;4326.178026175033;4337.587929146726;3619.69232615228;3809.2381523695094;3820.9301395609273;3826.2347530493735;3837.76973381598;5389.272448219479;5407.215953686733;5435.646682965595;5440.972795136038;5448;4949.7772600233075;4956.430010548797;4963.602911767086;4963.989584218397;4973.990735604979;5558.610897237195;5824.417558244184;5833.270841144857;5865.325487568942;5909.970450147722;4089.3661482469965;4110.506739191286;4112.897177570555;4150.128473020669;4175.812088456027;5963.671998040106;6029;6079.4131462436935;6102.938970610326;6112.816615501542;4132.710710250314;4189.392538081961;4191.8532851350055;4195.517515485758;4218.0720241546815;4203.453551038407;4256.531781504032;4260.616544511009;4271.060366719316;4271.530131685512;4888.364512613338;4892.363992680928;4918;4920.188168952154;4951.3810773653295;5820.621659592113;5885.293764748258;5925.555583331181;5956.940430595725;5988.940110598838;1520.6958608278167;1530.188999830092;1534.34023369952;1536.6235272358344;1543.1975372806078;968.9031096890395;984.8818141822884;1000.1998401278947;1002.4236064262932;1009.9799202805219;5040.722760248222;5166.354205724285;5179.456157103526;5192.4547922468355;5192.870178245574;5483.616146869681;5499.560035197174;5511.779528818883;5528.281323427928;5533.944660553343;4931.274054081043;5164.483551644806;5180.145276029489;5180.48195180479;5196.843310026372;2896.2614533293877;2915.4460652475964;2922.810017348908;2931.267183204199;2955.1134659602035;5463.672179669233;5486.780528778804;5577.191307260506;5691;5724.8282551523525;5095.923561146586;5456.417638884679;5470.8085217017215;5514.724263786795;5544.306961629796;5491.203775452617;5539.9169012464845;5589.55283577321;5589.916151257735;5597.1324444711945;5291;5399.596105012646;5403.891922161613;5419.317437868281;5527.143292789624;5245.291885595396;5288.709120998382;5354.866128346666;5362.463753624606;5406.459354064562;5484.478974497416;5489;5539.833804985857;5549.889002220014;6009.429104235091;4191.287481128276;4364.6944713869725;4373.475182978063;4374.387585738063;4390.3414487827085;6006.429389208019;6034.275886893601;6052.969735151472;6126.6017708848785;6180;5667.319921609434;5880.617759845596;5891.528677705859;5891.558133139946;5920.911186332295;5825.79609713658;5878.794242201502;5890.587658863838;5896.262967129109;5898.764049438146;5573.637713548606;5600.103983362643;5782.508486778671;5795.043817770021;5801.274840644919;5808.36108028125;5873.177755114373;5987.640741555347;5995.310539288038;6012.6392416455155;5806.709664516842;5872.588918775816;5894.793682221273;5902.439268269508;5908.704564771659 05:28:49 INFO - PROCESS | 8650 | |5;yui.html;750.0324581290135;791.004188253042;819.0130892274808;858.0561382479274;865.1607940297911;13155.605331840048;14280.143191408522;14585;14594.854051459482;14686.926565367185;13784.655383615414;13948.651283717887;13957.371918263703;13965.720685586282;13995.790063149061;647.5078940005594;743.0414764953231;770.6455030685892;774.8760198368262;787.4960025583631;786.4887822915093;790.3084800799301;793.833295008049;795.0697683710044;795.9283664470197;832.0847068224934;834.1075049696827;835.5822088955522;837.7109897085526;839.0686338164633;829.9045609754895;834.6744769539885;834.7537476444434;836.4981011393177;837.2464781696491;606.560243823229;606.7967230977628;610.1183789424284;610.2250142319274;612.7977767336769;13560.321983900765;13601.795973060312;13607.931960340235;13608.659783505393;13672.453101876012;14288;14442.277886105652;14803.925980370137;14806.851931480654;14811.48159814412;12033.879661203364;12051.698707532294;12101.455434505468;12173.452194651261;12343.629691109281;3897.7661340319673;3915.6280153385383;3929.0766669832565;3932.8623498177426;4033.9193216135513;57816;57821.71089144569;58215;58267.70866145685;58647.41352586462;11053.226274160892;11175.888241117647;11178.944105279585;11356.886431135583;11431.771364572829;21078.57842843165;21082.578348432944;21103.261385851423;21119.155233790785;21140.894295528426;7938.24586664266;7960.840783184304;7978.521288722695;8201.13888041759;8230.876536851953;4480.32795080734;4552.931706024412;4667.323238130452;4679.508651591602;4700.177468942921;3420.1449637590604;3506.403911335079;3516.6834984851484;3531.399662057405;3539.699125574355;599.6821684507219;612.7127958502601;614.443928244939;618.7494064903722;631.3717850738544;710.4848984486309;804.352496240532;808.7088648086684;808.7331180710352;834.0908409833311;9775.266854985763;9840.507974601242;10018.799624007625;10040.196784257389;10194.490275486196;692.4114502672688;698.6192525073847;725.2964624314407;777.3936329662872;806.4314658165979;4568.794404251817;4598.494165641777;4627.213373726475;4719.221328480831;4723.7874295656775;67371;68271;69252.653736732;69980.3001969984;70071.29928700648;60864.69567652222;61233.69383153056;61785;62569;63339.04991425132;55732.885342292924;56629.43370566324;56691.71654141703;56784.716076419354;57012.85974280491;8851.20339169452;9109.590068447069;9333;9404.38871473352;9436.480993545421;36631.633683662825;37337.066573335884;37638.623613764605;38331.23337533289;38450.807745961094;45374.31938520859;48789.268160976906;49013.50986490232;49260.26109608287;50393.49606503888;11607.22727295354;11790.174687771774;12120.75758484843;12209.450574723982;12316.13787034899;12431.31627760482;12487.625371238877;12911.67589833839;13144.671383215496;13590.728185436434;11626.476808543805;11939.76120477603;12219.633410997685;12226.816597750863;12710.745785084431;11936.70158246016;12045.819312710491;12080.879191208327;12403.875961240272;12416.689582760504;12178.817317740064;12183.451744671334;12288.078394120656;12486.188397754117;12634.368281585701;9972.152367048882;10037;10145.89854101479;10242.743931401774;10319.690409287734;10275;10487.790244195226;10522.789544209227;10538.367697938149;10544.472776361305 05:28:49 INFO - PROCESS | 8650 | __end_tp_report 05:28:49 INFO - PROCESS | 8650 | __start_cc_report 05:28:49 INFO - PROCESS | 8650 | _x_x_mozilla_cycle_collect,340 05:28:49 INFO - PROCESS | 8650 | __end_cc_report 05:28:49 INFO - PROCESS | 8650 | __startTimestamp1464265729401__endTimestamp 05:28:49 INFO - PROCESS | 8650 | 05:28:49 INFO - PROCESS | 8650 | ------- Summary: start ------- 05:28:49 INFO - PROCESS | 8650 | Number of tests: 6 05:28:49 INFO - PROCESS | 8650 | 05:28:49 INFO - PROCESS | 8650 | [#0] dojo.html Cycles:165 Average:5471.54 Median:5724.83 stddev:739.58 (12.9%) stddev-sans-first:717.99 05:28:49 INFO - PROCESS | 8650 | Values: 3095.9 3097.5 3151.8 3174.8 3186.4 5500.1 5538.1 5540.4 5560.0 5584.9 5459.4 5481.0 5482.0 5488.9 5557.9 4910.2 4940.6 5068.7 5069.5 5116.7 925.5 4907.7 4937.5 5008.4 5059.6 4972.1 4973.8 5002.9 5020.5 5027.7 5014.0 5016.4 5021.5 5025.5 5044.7 4919.4 4968.5 4974.9 4988.9 4997.5 5396.2 5426.7 5441.7 5443.2 5477.5 5724.8 5824.3 5887.3 5923.3 5926.4 5870.1 5922.3 5935.8 5957.4 5997.1 5492.8 5501.9 5520.1 5521.4 5531.1 5898.0 6058.1 6060.1 6071.7 6095.5 5761.3 5781.9 5784.2 5839.1 5848.6 5868.9 5885.3 5897.7 5902.8 5917.1 5823.2 5887.4 5890.5 5897.8 5907.2 5815.8 5861.4 5888.2 5901.0 5941.9 4379.9 4499.3 4499.7 4509.1 4577.1 3902.2 3953.6 3970.1 3988.0 4006.4 5575.8 5590.0 5644.1 5645.8 5648.6 5798.5 5978.9 5999.9 6008.2 6021.8 5638.4 5698.4 5707.6 5730.1 5735.8 5076.5 5087.0 5128.4 5133.7 5137.5 5962.9 6024.6 6164.7 6186.8 6211.0 6015.2 6016.4 6033.9 6042.3 6078.6 6167.8 6177.5 6236.5 6236.7 6252.3 5677.1 5837.7 5914.1 5915.6 5950.3 5961.7 6008.9 6072.6 6087.0 6118.9 5828.8 5878.0 5883.5 5892.3 5907.6 5701.8 5729.6 5745.0 5757.9 5829.9 5686.3 5689.2 5700.6 5707.2 5730.5 5832.4 5833.0 5849.9 5854.4 5861.2 5530.3 5631.4 5679.8 5692.6 5731.1 05:28:49 INFO - PROCESS | 8650 | 05:28:49 INFO - PROCESS | 8650 | [#1] ext.html Cycles:180 Average:59890.88 Median:42549.29 stddev:119643.01 (281.2%) stddev-sans-first:119895.79 05:28:49 INFO - PROCESS | 8650 | Values: 589.1 637.0 643.9 654.1 662.3 39355.2 40425.2 43472.6 43751.0 43880.3 45544.1 46289.5 46403.3 46540.0 46603.8 8852.3 9039.0 9044.6 9054.5 9059.5 8857.4 8872.2 8928.5 8931.0 8958.1 8924.6 8941.1 8965.1 8969.7 9007.4 8892.6 8949.2 8965.1 8973.9 8986.1 8893.0 8925.3 8964.6 9006.6 9012.5 43133.6 43523.3 43670.8 43910.0 43944.6 3461.2 3513.7 3521.6 3568.3 3875.5 32103.8 33268.7 33649.7 33750.7 34184.5 4313.9 4374.3 4378.1 4455.9 4513.5 345024.0 347722.0 348765.0 349618.3 349626.0 34103.5 62568.0 63438.7 63516.7 63572.4 34629.8 36369.6 36507.5 36559.5 36822.6 12987.2 12991.2 13031.9 13049.7 13088.6 13182.6 13202.7 13212.8 13257.5 13288.8 8306.5 8369.0 8399.0 8447.8 8449.7 3284.9 3284.9 3302.9 3360.2 3382.3 1045.5 1051.9 1059.0 1166.3 1219.3 32765.8 32803.7 32809.0 33190.8 33322.3 1094.7 1123.1 1123.7 1152.1 1212.4 17013.0 17584.7 17600.8 17684.4 17732.6 532881.0 537299.0 540524.0 541681.0 544325.0 58938.7 59527.7 59576.1 59819.0 59846.1 1298.8 1344.5 1365.9 1394.4 1398.6 31439.0 32557.8 33169.8 33253.7 33353.7 52118.0 52226.5 52322.7 52474.5 52737.7 436894.0 442415.0 443540.0 446540.0 449343.0 28443.0 28628.3 28773.3 29007.1 29058.4 49934.3 50200.2 50373.2 51035.7 51475.7 42184.0 42311.6 42401.4 42407.8 43882.8 41327.6 41507.6 41908.2 42258.4 42690.8 43199.6 44328.6 44503.0 45453.0 45503.5 36463.0 36827.0 37633.8 37699.6 37964.4 28870.7 29171.8 30037.7 30078.2 30190.8 05:28:49 INFO - PROCESS | 8650 | 05:28:49 INFO - PROCESS | 8650 | [#2] jquery.html Cycles:180 Average:28866.35 Median:2280.85 stddev:82953.54 (3637.0%) stddev-sans-first:83158.70 05:28:49 INFO - PROCESS | 8650 | Values: 394.4 398.2 400.8 403.9 411.7 13945.4 17922.7 18902.5 19023.5 19133.3 18283.7 18289.4 18744.3 19416.4 19418.8 5631.0 5703.8 5803.9 5891.9 5900.8 5736.4 5743.7 5780.2 5784.1 5794.1 5402.9 5635.4 5684.5 5741.4 5781.4 5682.9 5700.6 5744.2 5943.6 6323.1 5756.1 5771.9 5780.7 5785.6 5792.4 13471.7 13582.0 14002.0 14016.7 14127.0 2278.3 2280.2 2281.5 2337.0 2414.5 10233.6 10659.6 10715.5 13061.2 13958.7 1939.7 1993.7 2031.8 2046.6 2052.3 80039.6 83669.0 83685.6 83769.6 83890.0 10805.8 10949.1 10949.3 11179.7 11213.2 15571.5 15643.5 15650.8 15689.7 15751.6 8061.4 8091.2 8115.8 8244.3 8356.7 7786.6 7806.9 7831.6 7992.8 8009.8 4745.9 4796.0 4818.0 4914.6 4938.6 1905.3 1926.0 1961.0 2004.2 2062.3 871.4 939.4 940.5 976.8 1079.9 18940.2 19677.4 19717.9 19866.4 19928.3 954.7 978.6 1000.8 1026.4 1031.6 10953.5 11105.6 11204.7 11211.4 11230.9 497109.0 500194.0 507048.0 509427.0 510621.0 57783.4 67793.7 79154.2 85154.0 86861.8 1014.4 1031.7 1043.5 1078.5 1085.5 17596.7 17681.7 17898.6 17903.6 18144.0 40954.4 41620.4 42153.0 42324.4 42764.9 58341.7 58873.0 59698.0 59907.0 60394.0 5788.5 7518.9 7840.4 8589.7 8862.3 13135.7 13634.5 13642.6 13730.2 13816.4 11970.3 12037.6 12103.8 12123.3 12200.5 11265.7 11799.5 11811.3 11865.9 12070.9 11499.4 12037.6 12251.6 12566.2 12610.9 7983.2 8066.2 8149.8 8176.7 8221.8 11889.3 12107.8 12116.8 12200.2 12269.8 05:28:49 INFO - PROCESS | 8650 | 05:28:49 INFO - PROCESS | 8650 | [#3] mootools.html Cycles:180 Average:6038.19 Median:443.46 stddev:3522.03 (794.2%) stddev-sans-first:3515.79 05:28:49 INFO - PROCESS | 8650 | Values: 1553.9 1572.8 1747.3 1842.5 1869.3 7972.5 8745.3 8772.8 9369.9 9399.2 8816.7 9069.0 9105.6 9123.0 9148.9 2317.6 2321.0 2331.2 2332.2 2337.6 2294.2 2319.9 2358.3 2372.9 2382.6 2349.7 2356.5 2365.1 2371.2 2374.9 2284.2 2284.5 2298.3 2299.7 2301.7 2271.5 2276.1 2276.2 2277.0 2284.0 8986.3 9053.0 9123.2 9140.5 9198.9 5293.7 5402.6 5406.5 5415.6 5416.3 3261.3 3378.3 3459.1 3518.4 3518.8 1092.0 1108.3 1112.6 1150.6 1164.0 13224.1 13243.5 13245.3 13254.1 13273.7 4688.9 4706.1 4714.4 4718.6 4734.1 11157.7 11199.8 11202.1 11206.5 11235.3 5425.7 5427.4 5434.3 5446.6 5447.2 4426.4 4765.4 4850.0 4924.9 4925.7 4101.0 4102.0 4137.2 4146.7 4167.3 1286.4 1310.5 1335.7 1340.9 1342.9 1011.5 1013.9 1016.2 1027.0 1035.5 6122.2 6331.7 6334.6 6403.0 6432.6 443.2 443.7 451.7 453.9 459.4 4348.2 4360.8 4411.4 4419.4 4430.9 11314.9 11449.8 11652.9 11681.3 11704.8 11443.1 11576.5 11587.8 11609.7 11629.7 8061.6 8347.7 8426.4 8433.6 8553.3 6240.0 6285.4 6337.2 6468.1 6494.2 10209.2 10400.3 10527.3 10536.2 10609.1 10654.1 10671.4 10769.4 10805.1 10875.3 7913.9 8215.8 8303.7 8307.3 8308.5 8799.3 8803.7 8805.4 8837.3 8882.9 7945.2 8004.4 8049.4 8097.6 8098.2 7991.2 7996.9 8013.1 8032.4 8078.5 7038.7 7056.6 7104.7 7117.4 7129.4 5310.0 5327.0 5375.8 5458.7 5530.7 5346.1 5392.3 5429.1 5465.5 5506.3 05:28:49 INFO - PROCESS | 8650 | 05:28:49 INFO - PROCESS | 8650 | [#4] prototype.html Cycles:180 Average:4782.65 Median:5401.74 stddev:1384.02 (25.6%) stddev-sans-first:1346.84 05:28:49 INFO - PROCESS | 8650 | Values: 324.3 334.4 335.7 341.1 345.8 5503.4 5612.9 5634.9 5700.9 5712.2 5627.3 5636.9 5650.7 5675.0 5686.8 4365.4 4373.2 4375.4 4382.9 4408.5 4113.6 4313.0 4360.5 4396.0 4401.5 4262.3 4264.7 4277.2 4292.3 4305.7 4299.8 4300.8 4308.4 4326.2 4337.6 3619.7 3809.2 3820.9 3826.2 3837.8 5389.3 5407.2 5435.6 5441.0 5448.0 4949.8 4956.4 4963.6 4964.0 4974.0 5558.6 5824.4 5833.3 5865.3 5910.0 4089.4 4110.5 4112.9 4150.1 4175.8 5963.7 6029.0 6079.4 6102.9 6112.8 4132.7 4189.4 4191.9 4195.5 4218.1 4203.5 4256.5 4260.6 4271.1 4271.5 4888.4 4892.4 4918.0 4920.2 4951.4 5820.6 5885.3 5925.6 5956.9 5988.9 1520.7 1530.2 1534.3 1536.6 1543.2 968.9 984.9 1000.2 1002.4 1010.0 5040.7 5166.4 5179.5 5192.5 5192.9 5483.6 5499.6 5511.8 5528.3 5533.9 4931.3 5164.5 5180.1 5180.5 5196.8 2896.3 2915.4 2922.8 2931.3 2955.1 5463.7 5486.8 5577.2 5691.0 5724.8 5095.9 5456.4 5470.8 5514.7 5544.3 5491.2 5539.9 5589.6 5589.9 5597.1 5291.0 5399.6 5403.9 5419.3 5527.1 5245.3 5288.7 5354.9 5362.5 5406.5 5484.5 5489.0 5539.8 5549.9 6009.4 4191.3 4364.7 4373.5 4374.4 4390.3 6006.4 6034.3 6053.0 6126.6 6180.0 5667.3 5880.6 5891.5 5891.6 5920.9 5825.8 5878.8 5890.6 5896.3 5898.8 5573.6 5600.1 5782.5 5795.0 5801.3 5808.4 5873.2 5987.6 5995.3 6012.6 5806.7 5872.6 5894.8 5902.4 5908.7 05:28:49 INFO - PROCESS | 8650 | 05:28:49 INFO - PROCESS | 8650 | [#5] yui.html Cycles:180 Average:15716.67 Median:4583.64 stddev:18972.15 (413.9%) stddev-sans-first:18992.09 05:28:49 INFO - PROCESS | 8650 | Values: 750.0 791.0 819.0 858.1 865.2 13155.6 14280.1 14585.0 14594.9 14686.9 13784.7 13948.7 13957.4 13965.7 13995.8 647.5 743.0 770.6 774.9 787.5 786.5 790.3 793.8 795.1 795.9 832.1 834.1 835.6 837.7 839.1 829.9 834.7 834.8 836.5 837.2 606.6 606.8 610.1 610.2 612.8 13560.3 13601.8 13607.9 13608.7 13672.5 14288.0 14442.3 14803.9 14806.9 14811.5 12033.9 12051.7 12101.5 12173.5 12343.6 3897.8 3915.6 3929.1 3932.9 4033.9 57816.0 57821.7 58215.0 58267.7 58647.4 11053.2 11175.9 11178.9 11356.9 11431.8 21078.6 21082.6 21103.3 21119.2 21140.9 7938.2 7960.8 7978.5 8201.1 8230.9 4480.3 4552.9 4667.3 4679.5 4700.2 3420.1 3506.4 3516.7 3531.4 3539.7 599.7 612.7 614.4 618.7 631.4 710.5 804.4 808.7 808.7 834.1 9775.3 9840.5 10018.8 10040.2 10194.5 692.4 698.6 725.3 777.4 806.4 4568.8 4598.5 4627.2 4719.2 4723.8 67371.0 68271.0 69252.7 69980.3 70071.3 60864.7 61233.7 61785.0 62569.0 63339.0 55732.9 56629.4 56691.7 56784.7 57012.9 8851.2 9109.6 9333.0 9404.4 9436.5 36631.6 37337.1 37638.6 38331.2 38450.8 45374.3 48789.3 49013.5 49260.3 50393.5 11607.2 11790.2 12120.8 12209.5 12316.1 12431.3 12487.6 12911.7 13144.7 13590.7 11626.5 11939.8 12219.6 12226.8 12710.7 11936.7 12045.8 12080.9 12403.9 12416.7 12178.8 12183.5 12288.1 12486.2 12634.4 9972.2 10037.0 10145.9 10242.7 10319.7 10275.0 10487.8 10522.8 10538.4 10544.5 05:28:49 INFO - PROCESS | 8650 | -------- Summary: end -------- 05:28:49 INFO - PROCESS | 8650 | 05:28:50 INFO - TEST-INFO | 8650: exit 0 05:28:50 INFO - TEST-OK | dromaeo_css | took 1110348ms 05:28:50 INFO - TEST-START | kraken 05:28:50 INFO - operating with platform_type : linux_ 05:28:50 INFO - Initialising browser for kraken test... 05:28:50 INFO - TEST-INFO | started process 8893 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp68p8Rq/profile http://localhost:60998/getInfo.html) 05:28:53 INFO - PROCESS | 8893 | 05:28:53 INFO - PROCESS | 8893 | (process:8961): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:28:54 INFO - PROCESS | 8893 | __metrics Screen width/height:1600/1200 05:28:54 INFO - PROCESS | 8893 | colorDepth:24 05:28:54 INFO - PROCESS | 8893 | Browser inner width/height: 1024/697 05:28:54 INFO - PROCESS | 8893 | __metrics 05:28:55 ERROR - PROCESS | 8893 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 05:28:56 INFO - TEST-INFO | 8893: exit 0 05:28:56 INFO - Browser initialized. 05:28:56 INFO - Running cycle 1/1 for kraken test... 05:28:56 INFO - TEST-INFO | started process 9012 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp68p8Rq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:28:58 INFO - PROCESS | 9012 | 05:28:58 INFO - PROCESS | 9012 | (process:9073): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:29:08 INFO - PROCESS | 9012 | RSS: Main: 166600704 05:29:08 INFO - PROCESS | 9012 | 05:29:10 INFO - PROCESS | 9012 | Cycle 1(1): loaded http://localhost:60998/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60998/tests/kraken/driver.html?testName=audio-beat-detection) 05:29:11 INFO - PROCESS | 9012 | RSS: Main: 171376640 05:29:11 INFO - PROCESS | 9012 | 05:29:14 INFO - PROCESS | 9012 | Cycle 1(1): loaded http://localhost:60998/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60998/tests/kraken/driver.html?testName=audio-dft) 05:29:14 INFO - PROCESS | 9012 | RSS: Main: 171864064 05:29:14 INFO - PROCESS | 9012 | 05:29:17 INFO - PROCESS | 9012 | Cycle 1(1): loaded http://localhost:60998/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60998/tests/kraken/driver.html?testName=audio-fft) 05:29:18 INFO - PROCESS | 9012 | RSS: Main: 166019072 05:29:18 INFO - PROCESS | 9012 | 05:29:20 INFO - PROCESS | 9012 | Cycle 1(1): loaded http://localhost:60998/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60998/tests/kraken/driver.html?testName=audio-oscillator) 05:29:20 INFO - PROCESS | 9012 | RSS: Main: 166285312 05:29:20 INFO - PROCESS | 9012 | 05:29:23 INFO - PROCESS | 9012 | Cycle 1(1): loaded http://localhost:60998/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60998/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:29:23 INFO - PROCESS | 9012 | RSS: Main: 166522880 05:29:23 INFO - PROCESS | 9012 | 05:29:26 INFO - PROCESS | 9012 | Cycle 1(1): loaded http://localhost:60998/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60998/tests/kraken/driver.html?testName=imaging-darkroom) 05:29:27 INFO - PROCESS | 9012 | RSS: Main: 166727680 05:29:27 INFO - PROCESS | 9012 | 05:29:30 INFO - PROCESS | 9012 | Cycle 1(1): loaded http://localhost:60998/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60998/tests/kraken/driver.html?testName=imaging-desaturate) 05:29:31 INFO - PROCESS | 9012 | RSS: Main: 165240832 05:29:31 INFO - PROCESS | 9012 | 05:29:34 INFO - PROCESS | 9012 | Cycle 1(1): loaded http://localhost:60998/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60998/tests/kraken/driver.html?testName=json-parse-financial) 05:29:34 INFO - PROCESS | 9012 | RSS: Main: 166481920 05:29:34 INFO - PROCESS | 9012 | 05:29:36 INFO - PROCESS | 9012 | Cycle 1(1): loaded http://localhost:60998/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60998/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:29:37 INFO - PROCESS | 9012 | RSS: Main: 166592512 05:29:37 INFO - PROCESS | 9012 | 05:29:38 INFO - PROCESS | 9012 | Cycle 1(1): loaded http://localhost:60998/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60998/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:29:39 INFO - PROCESS | 9012 | RSS: Main: 166670336 05:29:39 INFO - PROCESS | 9012 | 05:29:41 INFO - PROCESS | 9012 | Cycle 1(1): loaded http://localhost:60998/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60998/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:29:42 INFO - PROCESS | 9012 | RSS: Main: 166981632 05:29:42 INFO - PROCESS | 9012 | 05:29:44 INFO - PROCESS | 9012 | Cycle 1(1): loaded http://localhost:60998/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60998/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:29:45 INFO - PROCESS | 9012 | RSS: Main: 166813696 05:29:45 INFO - PROCESS | 9012 | 05:29:48 INFO - PROCESS | 9012 | Cycle 1(1): loaded http://localhost:60998/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60998/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:29:48 INFO - PROCESS | 9012 | RSS: Main: 166842368 05:29:48 INFO - PROCESS | 9012 | 05:29:50 INFO - PROCESS | 9012 | Cycle 1(1): loaded http://localhost:60998/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60998/tests/kraken/driver.html?testName=ai-astar) 05:29:50 INFO - PROCESS | 9012 | RSS: Main: 168296448 05:29:50 INFO - PROCESS | 9012 | 05:29:50 INFO - PROCESS | 9012 | __start_tp_report 05:29:50 INFO - PROCESS | 9012 | _x_x_mozilla_page_load 05:29:50 INFO - PROCESS | 9012 | _x_x_mozilla_page_load_details 05:29:50 INFO - PROCESS | 9012 | |i|pagename|runs| 05:29:50 INFO - PROCESS | 9012 | |0;ai-astar;110;106;112;112;112;113;111;112;111;111 05:29:50 INFO - PROCESS | 9012 | |1;audio-beat-detection;156;126;156;195;139;152;150;126;189;135 05:29:50 INFO - PROCESS | 9012 | |2;audio-dft;164;163;162;161;164;167;167;164;163;162 05:29:50 INFO - PROCESS | 9012 | |3;audio-fft;83;75;77;165;76;75;77;77;166;75 05:29:50 INFO - PROCESS | 9012 | |4;audio-oscillator;83;83;141;84;83;82;139;82;85;135 05:29:50 INFO - PROCESS | 9012 | |5;imaging-gaussian-blur;119;118;117;117;118;119;118;118;117;118 05:29:50 INFO - PROCESS | 9012 | |6;imaging-darkroom;148;149;147;147;148;150;147;147;146;147 05:29:50 INFO - PROCESS | 9012 | |7;imaging-desaturate;96;97;95;95;96;95;97;96;95;96 05:29:50 INFO - PROCESS | 9012 | |8;json-parse-financial;55;54;58;53;54;55;56;67;52;52 05:29:50 INFO - PROCESS | 9012 | |9;json-stringify-tinderbox;61;62;61;62;61;61;61;62;63;62 05:29:50 INFO - PROCESS | 9012 | |10;stanford-crypto-aes;79;79;80;80;80;81;81;82;81;81 05:29:50 INFO - PROCESS | 9012 | |11;stanford-crypto-ccm;139;123;133;138;122;122;132;123;169;123 05:29:50 INFO - PROCESS | 9012 | |12;stanford-crypto-pbkdf2;158;166;164;158;161;158;159;167;160;167 05:29:50 INFO - PROCESS | 9012 | |13;stanford-crypto-sha256-iterative;72;61;66;63;62;68;62;63;61;63 05:29:50 INFO - PROCESS | 9012 | __end_tp_report 05:29:50 INFO - PROCESS | 9012 | __start_cc_report 05:29:50 INFO - PROCESS | 9012 | _x_x_mozilla_cycle_collect,851 05:29:50 INFO - PROCESS | 9012 | __end_cc_report 05:29:50 INFO - PROCESS | 9012 | __startTimestamp1464265790790__endTimestamp 05:29:50 INFO - PROCESS | 9012 | 05:29:50 INFO - PROCESS | 9012 | ------- Summary: start ------- 05:29:50 INFO - PROCESS | 9012 | Number of tests: 14 05:29:50 INFO - PROCESS | 9012 | 05:29:50 INFO - PROCESS | 9012 | [#0] ai-astar Cycles:10 Average:111.00 Median:112.00 stddev:1.94 (1.7%) stddev-sans-first:2.03 05:29:50 INFO - PROCESS | 9012 | Values: 110.0 106.0 112.0 112.0 112.0 113.0 111.0 112.0 111.0 111.0 05:29:50 INFO - PROCESS | 9012 | 05:29:50 INFO - PROCESS | 9012 | [#1] audio-beat-detection Cycles:10 Average:152.40 Median:154.00 stddev:23.72 (15.4%) stddev-sans-first:25.12 05:29:50 INFO - PROCESS | 9012 | Values: 156.0 126.0 156.0 195.0 139.0 152.0 150.0 126.0 189.0 135.0 05:29:50 INFO - PROCESS | 9012 | 05:29:50 INFO - PROCESS | 9012 | [#2] audio-dft Cycles:10 Average:163.70 Median:164.00 stddev:2.00 (1.2%) stddev-sans-first:2.12 05:29:50 INFO - PROCESS | 9012 | Values: 164.0 163.0 162.0 161.0 164.0 167.0 167.0 164.0 163.0 162.0 05:29:50 INFO - PROCESS | 9012 | 05:29:50 INFO - PROCESS | 9012 | [#3] audio-fft Cycles:10 Average:94.60 Median:76.50 stddev:37.44 (48.9%) stddev-sans-first:39.48 05:29:50 INFO - PROCESS | 9012 | Values: 83.0 75.0 77.0 165.0 76.0 75.0 77.0 77.0 166.0 75.0 05:29:50 INFO - PROCESS | 9012 | 05:29:50 INFO - PROCESS | 9012 | [#4] audio-oscillator Cycles:10 Average:99.70 Median:83.00 stddev:26.71 (32.2%) stddev-sans-first:27.64 05:29:50 INFO - PROCESS | 9012 | Values: 83.0 83.0 141.0 84.0 83.0 82.0 139.0 82.0 85.0 135.0 05:29:50 INFO - PROCESS | 9012 | 05:29:50 INFO - PROCESS | 9012 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.74 (0.6%) stddev-sans-first:0.67 05:29:50 INFO - PROCESS | 9012 | Values: 119.0 118.0 117.0 117.0 118.0 119.0 118.0 118.0 117.0 118.0 05:29:50 INFO - PROCESS | 9012 | 05:29:50 INFO - PROCESS | 9012 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:147.50 stddev:1.17 (0.8%) stddev-sans-first:1.24 05:29:50 INFO - PROCESS | 9012 | Values: 148.0 149.0 147.0 147.0 148.0 150.0 147.0 147.0 146.0 147.0 05:29:50 INFO - PROCESS | 9012 | 05:29:50 INFO - PROCESS | 9012 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 05:29:50 INFO - PROCESS | 9012 | Values: 96.0 97.0 95.0 95.0 96.0 95.0 97.0 96.0 95.0 96.0 05:29:50 INFO - PROCESS | 9012 | 05:29:50 INFO - PROCESS | 9012 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:55.00 stddev:4.40 (8.0%) stddev-sans-first:4.66 05:29:50 INFO - PROCESS | 9012 | Values: 55.0 54.0 58.0 53.0 54.0 55.0 56.0 67.0 52.0 52.0 05:29:50 INFO - PROCESS | 9012 | 05:29:50 INFO - PROCESS | 9012 | [#9] json-stringify-tinderbox Cycles:10 Average:61.60 Median:62.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 05:29:50 INFO - PROCESS | 9012 | Values: 61.0 62.0 61.0 62.0 61.0 61.0 61.0 62.0 63.0 62.0 05:29:50 INFO - PROCESS | 9012 | 05:29:50 INFO - PROCESS | 9012 | [#10] stanford-crypto-aes Cycles:10 Average:80.40 Median:81.00 stddev:0.97 (1.2%) stddev-sans-first:0.88 05:29:50 INFO - PROCESS | 9012 | Values: 79.0 79.0 80.0 80.0 80.0 81.0 81.0 82.0 81.0 81.0 05:29:50 INFO - PROCESS | 9012 | 05:29:50 INFO - PROCESS | 9012 | [#11] stanford-crypto-ccm Cycles:10 Average:132.40 Median:132.50 stddev:14.52 (11.0%) stddev-sans-first:15.20 05:29:50 INFO - PROCESS | 9012 | Values: 139.0 123.0 133.0 138.0 122.0 122.0 132.0 123.0 169.0 123.0 05:29:50 INFO - PROCESS | 9012 | 05:29:50 INFO - PROCESS | 9012 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.80 Median:162.50 stddev:3.82 (2.4%) stddev-sans-first:3.80 05:29:50 INFO - PROCESS | 9012 | Values: 158.0 166.0 164.0 158.0 161.0 158.0 159.0 167.0 160.0 167.0 05:29:50 INFO - PROCESS | 9012 | 05:29:50 INFO - PROCESS | 9012 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.10 Median:63.00 stddev:3.54 (5.6%) stddev-sans-first:2.33 05:29:50 INFO - PROCESS | 9012 | Values: 72.0 61.0 66.0 63.0 62.0 68.0 62.0 63.0 61.0 63.0 05:29:50 INFO - PROCESS | 9012 | -------- Summary: end -------- 05:29:50 INFO - PROCESS | 9012 | 05:29:51 INFO - TEST-INFO | 9012: exit 0 05:29:51 INFO - TEST-OK | kraken | took 61630ms 05:29:51 INFO - SUITE-END | took 1171s 05:29:51 INFO - Completed test suite (00:19:32) 05:29:51 INFO - javascript benchmark 05:29:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7157.991865024606, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3095.938081238374, 3097.473429516982, 3151.7636177286695, 3174.825384603846, 3186.3786561620477, 5500.092484740013, 5538.141588053853, 5540.418256083114, 5559.972200138994, 5584.86037849053, 5459.3994660587305, 5481.0, 5482.0406428874885, 5488.945110548893, 5557.916631250524, 4910.1898186799135, 4940.604751619861, 5068.695878247298, 5069.493050694938, 5116.744162791864, 925.4545411088717, 4907.656464047518, 4937.506249375052, 5008.373953255843, 5059.569936555397, 4972.080165169437, 4973.776180071905, 5002.924956125661, 5020.497950204986, 5027.698338099707, 5014.0, 5016.372953380827, 5021.497850214986, 5025.472325405853, 5044.672096313765, 4919.385076865392, 4968.503149685039, 4974.87562810929, 4988.8752781180765, 4997.450280469146, 5396.244525766357, 5426.728663566845, 5441.727913604304, 5443.2107344434835, 5477.534409575191, 5724.8282551523525, 5824.330202026778, 5887.293524777011, 5923.259592550931, 5926.377730338296, 5870.148828419855, 5922.318933322636, 5935.762569497215, 5957.374475680078, 5997.070454079625, 5492.80775172867, 5501.889962200774, 5520.089185284463, 5521.4478552144865, 5531.115021596565, 5897.970510147422, 6058.1215723719815, 6060.121282414026, 6071.6660583667435, 6095.542834287447, 5761.337446193657, 5781.913271300934, 5784.21913041734, 5839.0949402842625, 5848.64908105515, 5868.853278667982, 5885.264341957255, 5897.675627840425, 5902.763889444374, 5917.142014407973, 5823.242978412779, 5887.411258874078, 5890.528757699374, 5897.823065308047, 5907.232059832194, 5815.79644712433, 5861.443162899518, 5888.234529511222, 5900.970495147497, 5941.940580594225, 4379.934300985487, 4499.347594598765, 4499.662525310615, 4509.098180363875, 4577.06170235101, 3902.2195560887935, 3953.6046395360236, 3970.086880017612, 3987.960120398759, 4006.4390985262085, 5575.832725018256, 5590.0, 5644.096944488862, 5645.802396916089, 5648.604597678123, 5798.536117110621, 5978.940210597925, 5999.940000600025, 6008.218931538872, 6021.7591296347655, 5638.379778224392, 5698.401667824902, 5707.629004114802, 5730.1404789281105, 5735.799247026417, 5076.466970967996, 5087.03346364197, 5128.435872054071, 5133.6919784813035, 5137.51193636604, 5962.880742385128, 6024.608400453956, 6164.660943648142, 6186.845328866814, 6211.006239001828, 6015.218021657157, 6016.368281330398, 6033.939660603338, 6042.274927008787, 6078.57449978515, 6167.814965551041, 6177.456411684596, 6236.501079913505, 6236.719347629459, 6252.280987686474, 5677.063284558167, 5837.708114594168, 5914.083317085859, 5915.615484993462, 5950.3454619992635, 5961.672108033927, 6008.909866352095, 6072.605280656743, 6086.969565152146, 6118.938810612015, 5828.795992140254, 5877.970610146922, 5883.470487656132, 5892.292924849045, 5907.586468947133, 5701.800436984686, 5729.598928074995, 5745.023346031268, 5757.91363129545, 5829.883402332014, 5686.34607020198, 5689.1750696148, 5700.629459085146, 5707.229524014371, 5730.541556675539, 5832.358440571449, 5833.0375488044, 5849.94150058511, 5854.356020837789, 5861.208736820475, 5530.253415788817, 5631.408702086222, 5679.801206957736, 5692.6299790513485, 5731.140328950691], "value": 5420.956969366118, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [589.125149153507, 637.0, 643.9291677915428, 654.0614218596314, 662.2781168526305, 39355.212895742065, 40425.19149617006, 43472.565274347246, 43751.0, 43880.3417948731, 45544.12874905629, 46289.537104628944, 46403.303950440684, 46540.0, 46603.76698116505, 8852.336074794384, 9038.954805225965, 9044.638214471413, 9054.502002389865, 9059.456432614032, 8857.42426742263, 8872.20150186483, 8928.508932008737, 8931.0, 8958.059403762576, 8924.598393072294, 8941.061188575204, 8965.148310910487, 8969.730908072768, 9007.369484136114, 8892.599833007498, 8949.239314658229, 8965.058668839743, 8973.865392019125, 8986.101389861027, 8893.0, 8925.330600204945, 8964.551772411418, 9006.639734410615, 9012.504312262823, 43133.568664313585, 43523.347149792775, 43670.781646091884, 43910.0, 43944.56055439469, 3461.2212252243294, 3513.7013353864954, 3521.5950165730756, 3568.2506673598577, 3875.457435958968, 32103.83948080268, 33268.6673133268, 33649.6635033649, 33750.662493375, 34184.48723269153, 4313.935290970638, 4374.321980093091, 4378.080603073358, 4455.910881782379, 4513.52607976161, 345024.0, 347722.0, 348765.0, 349618.25190874137, 349626.0, 34103.488447673306, 62568.0, 63438.682806585675, 63516.682416587624, 63572.364276356646, 34629.82685086558, 36369.636303636624, 36507.452388214195, 36559.4516082259, 36822.63177368192, 12987.220766754024, 12991.220526768424, 13031.869681303255, 13049.739005219843, 13088.607341779762, 13182.60452186436, 13202.669933251746, 13212.801807972888, 13257.535986240435, 13288.800667989988, 8306.501609903426, 8369.0, 8399.0, 8447.788805279917, 8449.66201351939, 3284.868605255811, 3284.917877053093, 3302.85137168828, 3360.24394511233, 3382.289719158955, 1045.4929359260752, 1051.9000694933968, 1058.962936297226, 1166.3293606176483, 1219.2806244315896, 32765.836170818995, 32803.67196328054, 32809.0, 33190.8340458301, 33322.3335533288, 1094.7044298039484, 1123.07346439188, 1123.6966019174777, 1152.072581571826, 1212.4180393411036, 17012.972104236032, 17584.736228956575, 17600.823991760175, 17684.381046663304, 17732.645347092985, 532881.0, 537299.0, 540524.0, 541681.0, 544325.0, 58938.705306473195, 59527.702361487914, 59576.10635840466, 59819.0, 59846.10230846541, 1298.8181654568368, 1344.5428554291393, 1365.8907287417182, 1394.35859504629, 1398.5804258722342, 31439.0, 32557.837210813796, 33169.83415082909, 33253.667463326026, 33353.66646333506, 52118.0, 52226.477735222164, 52322.73838630782, 52474.47525524696, 52737.7363113182, 436894.0, 442415.0, 443540.0, 446540.0, 449343.0, 28443.0, 28628.28429289201, 28773.28066798347, 29007.129786106452, 29058.418831622825, 49934.250986235966, 50200.24699629581, 50373.24440133474, 51035.74482127566, 51475.742621288155, 42184.0, 42311.576884230766, 42401.36397953972, 42407.78796106, 43882.780586096866, 41327.58672413358, 41507.584924150375, 41908.16183676248, 42258.36612450877, 42690.78654606707, 43199.56800431955, 44328.55671443373, 44503.0, 45453.0, 45503.544964551256, 36463.0, 36827.0, 37633.81183094067, 37699.62300377071, 37964.430533542574, 28870.7112928868, 29171.833126674694, 30037.69962300349, 30078.248043798205, 30190.84904575551], "value": 19271.391632527568, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.3591663546737, 398.1956447975092, 400.8476778824047, 403.92325458162964, 411.65832359141916, 13945.372458239379, 17922.731159032624, 18902.527436814053, 19023.52441188971, 19133.33033343833, 18283.72574411385, 18289.359872404468, 18744.250229990783, 19416.41750747476, 19418.805811941875, 5631.0, 5703.800366987156, 5803.892574534404, 5891.911621325662, 5900.822975310747, 5736.397678243787, 5743.712814359286, 5780.248567686195, 5784.074548072309, 5794.101914203284, 5402.91895621564, 5635.436456354352, 5684.459976302265, 5741.397153298906, 5781.39295373986, 5682.886342273152, 5700.629459085146, 5744.22452968848, 5943.613665111797, 6323.114763933053, 5756.136579513065, 5771.942280577183, 5780.682062486561, 5785.62393444429, 5792.420757924216, 13471.730565388736, 13582.0, 14002.0, 14016.71966560663, 14127.0, 2278.28234106256, 2280.213326402405, 2281.4866655002656, 2337.0418128567376, 2414.5050264695697, 10233.641822536176, 10659.626913058006, 10715.46422678863, 13061.21632702041, 13958.720825583532, 1939.7284380186786, 1993.6710442777069, 2031.7765045844944, 2046.5906818636333, 2052.271443637517, 80039.5998020012, 83669.0, 83685.58157209175, 83769.58115209384, 83890.0, 10805.783884322269, 10949.124070074375, 10949.302858057014, 11179.66461006171, 11213.159013074051, 15571.454999074978, 15643.530694079196, 15650.765238521431, 15689.68620627581, 15751.606209844616, 8061.395395345373, 8091.19088091198, 8115.83768324642, 8244.340452763765, 8356.665733370719, 7786.649600767979, 7806.921930780733, 7831.569263690438, 7992.84014319722, 8009.839803203903, 4745.905081898342, 4796.009655992793, 4817.9518204818205, 4914.582260507826, 4938.555530002317, 1905.3140869287045, 1925.9792310075682, 1960.9901950490157, 2004.188303736989, 2062.26789489732, 871.3682580129356, 939.4175611121149, 940.5062342270226, 976.7606936300651, 1079.93626278116, 18940.24239030451, 19677.409677709693, 19717.901410492857, 19866.404007879788, 19928.3025094121, 954.6801821389773, 978.6232300564334, 1000.7698229407132, 1026.3636545341787, 1031.5564307347913, 10953.507092180871, 11105.611303604497, 11204.719882002852, 11211.439428028565, 11230.887691123147, 497109.0, 500194.0, 507048.0, 509427.0, 510621.0, 57783.4221657778, 67793.66103169453, 79154.20845791469, 85154.0, 86861.82845428915, 1014.4217795856291, 1031.6698656429871, 1043.5095505112586, 1078.4769386847372, 1085.4626959655022, 17596.73604895902, 17681.734773978656, 17898.55253618618, 17903.641927161643, 18144.0, 40954.38568421416, 41620.375694364004, 42153.0, 42324.36513452239, 42764.93087672833, 58341.70829145827, 58873.0, 59698.0, 59907.0, 60394.0, 5788.507976822018, 7518.924810751822, 7840.411969102454, 8589.65641374338, 8862.335324850534, 13135.671608209872, 13634.454621815017, 13642.590722278348, 13730.244836534086, 13816.447342106605, 11970.281783093042, 12037.638870833889, 12103.81844272319, 12123.333216673167, 12200.51197952072, 11265.71835704114, 11799.528018879491, 11811.291322520676, 11865.881341186823, 12070.879291206975, 11499.425028748696, 12037.638870833889, 12251.632451026484, 12566.183198092094, 12610.873891261337, 7983.1617680142745, 8066.193380661887, 8149.79625509367, 8176.67293308261, 8221.753347399588, 11889.28664280146, 12107.818382724443, 12116.757664846476, 12200.206986545845, 12269.815952760895], "value": 9136.110198155777, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1553.8679212266957, 1572.8033995750532, 1747.2923465996269, 1842.4933143385576, 1869.2616416515468, 7972.481788683732, 8745.300375969922, 8772.780680482983, 9369.859452108216, 9399.154076133147, 8816.691415800447, 9068.954655226731, 9105.63577456901, 9123.042080581543, 9148.90851091489, 2317.629179331303, 2321.0367697405554, 2331.2423462374713, 2332.183735692511, 2337.55586438577, 2294.162630639821, 2319.9304020879317, 2358.3043002314357, 2372.9169479068237, 2382.5592265430864, 2349.729781075181, 2356.5051339218785, 2365.053978408633, 2371.1700904683394, 2374.881255937205, 2284.1548627007946, 2284.520250747345, 2298.264810068396, 2299.7470278269375, 2301.7122859642545, 2271.500269940627, 2276.089564174327, 2276.2488378834946, 2276.9886150569305, 2283.9543209135722, 8986.326025548111, 9053.049429809907, 9123.224525915306, 9140.451572905647, 9198.908010919871, 5293.7353132343615, 5402.567794576425, 5406.54044406226, 5415.593830462731, 5416.295881535415, 3261.266215101607, 3378.2905589826164, 3459.135216195951, 3518.3842827505086, 3518.8064656443885, 1092.0280949954547, 1108.312846035455, 1112.554978008795, 1150.6030419505257, 1163.9825402618967, 13224.14043087206, 13243.536476223286, 13245.271510066943, 13254.138480998705, 13273.734525309535, 4688.859334219979, 4706.10583989041, 4714.363560919232, 4718.598919091847, 4734.053189362141, 11157.721056973478, 11199.832002519968, 11202.103831693445, 11206.495707693173, 11235.325880447199, 5425.701586412785, 5427.3758517770175, 5434.2935418395355, 5446.618736688473, 5447.237386765856, 4426.380306757057, 4765.356676848651, 4850.029994001144, 4924.876878078005, 4925.679830811057, 4100.979495102505, 4101.958980410217, 4137.234611596864, 4146.66826653867, 4167.270727622654, 1286.3761075878192, 1310.5020092364841, 1335.7128217433299, 1340.8793208611078, 1342.9127106738226, 1011.5346940407495, 1013.8631284776608, 1016.2479764973866, 1027.0397178637998, 1035.4770840725384, 6122.234720659918, 6331.68341582919, 6334.556581039283, 6403.007533832263, 6432.6462044588, 443.21329639889456, 443.70715327884085, 451.7447642082279, 453.8615722204759, 459.3706621927913, 4348.173846969129, 4360.803763830635, 4411.404460397805, 4419.381286619876, 4430.867073987785, 11314.943425282821, 11449.828252576219, 11652.94173529127, 11681.299122052704, 11704.765904682028, 11443.084553235887, 11576.536938522533, 11587.826182607268, 11609.709757256136, 11629.709257268467, 8061.596920153969, 8347.749567512985, 8426.441108394967, 8433.578321084044, 8553.315734741205, 6240.0, 6285.371462853861, 6337.176167098248, 6468.126802881551, 6494.220693516808, 10209.234307426825, 10400.27198096126, 10527.263091583516, 10536.209784266057, 10609.098226650822, 10654.135526283024, 10671.413072281099, 10769.407682577534, 10805.135589152691, 10875.293105948089, 7913.881291780513, 8215.835683286421, 8303.709370172257, 8307.252347288773, 8308.5430301334, 8799.34004949644, 8803.735887923373, 8805.383623146574, 8837.293016558531, 8882.911170888208, 7945.245201705829, 8004.399670024655, 8049.356051515748, 8097.595120243846, 8098.19018098209, 7991.200879911962, 7996.920030799618, 8013.118556958846, 8032.357411406956, 8078.515289082674, 7038.718451261892, 7056.576605403692, 7104.715811367488, 7117.43060555144, 7129.3583577478275, 5309.973450132725, 5327.0, 5375.784968601212, 5458.727063646881, 5530.723463826873, 5346.144616861284, 5392.325959255093, 5429.077056900415, 5465.453454654662, 5506.284183056177], "value": 4713.312254206473, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.30598519168996, 334.3930765660327, 335.65930580460827, 341.055276883034, 345.7562418494961, 5503.422140675221, 5612.859678508039, 5634.859128521789, 5700.857478563038, 5712.200291959129, 5627.324721033471, 5636.859078523039, 5650.7174641267975, 5674.971625141879, 5686.829395118143, 4365.432493775813, 4373.234683930315, 4375.4311939447825, 4382.9342559861625, 4408.493023302329, 4113.56807535209, 4313.0, 4360.454943132108, 4396.0, 4401.515833258339, 4262.295081967207, 4264.701470897038, 4277.230098582254, 4292.270314046604, 4305.720128191673, 4299.806508707115, 4300.827966881321, 4308.375285583573, 4326.178026175033, 4337.587929146726, 3619.69232615228, 3809.2381523695094, 3820.9301395609273, 3826.2347530493735, 3837.76973381598, 5389.272448219479, 5407.215953686733, 5435.646682965595, 5440.972795136038, 5448.0, 4949.7772600233075, 4956.430010548797, 4963.602911767086, 4963.989584218397, 4973.990735604979, 5558.610897237195, 5824.417558244184, 5833.270841144857, 5865.325487568942, 5909.970450147722, 4089.3661482469965, 4110.506739191286, 4112.897177570555, 4150.128473020669, 4175.812088456027, 5963.671998040106, 6029.0, 6079.4131462436935, 6102.938970610326, 6112.816615501542, 4132.710710250314, 4189.392538081961, 4191.8532851350055, 4195.517515485758, 4218.0720241546815, 4203.453551038407, 4256.531781504032, 4260.616544511009, 4271.060366719316, 4271.530131685512, 4888.364512613338, 4892.363992680928, 4918.0, 4920.188168952154, 4951.3810773653295, 5820.621659592113, 5885.293764748258, 5925.555583331181, 5956.940430595725, 5988.940110598838, 1520.6958608278167, 1530.188999830092, 1534.34023369952, 1536.6235272358344, 1543.1975372806078, 968.9031096890395, 984.8818141822884, 1000.1998401278947, 1002.4236064262932, 1009.9799202805219, 5040.722760248222, 5166.354205724285, 5179.456157103526, 5192.4547922468355, 5192.870178245574, 5483.616146869681, 5499.560035197174, 5511.779528818883, 5528.281323427928, 5533.944660553343, 4931.274054081043, 5164.483551644806, 5180.145276029489, 5180.48195180479, 5196.843310026372, 2896.2614533293877, 2915.4460652475964, 2922.810017348908, 2931.267183204199, 2955.1134659602035, 5463.672179669233, 5486.780528778804, 5577.191307260506, 5691.0, 5724.8282551523525, 5095.923561146586, 5456.417638884679, 5470.8085217017215, 5514.724263786795, 5544.306961629796, 5491.203775452617, 5539.9169012464845, 5589.55283577321, 5589.916151257735, 5597.1324444711945, 5291.0, 5399.596105012646, 5403.891922161613, 5419.317437868281, 5527.143292789624, 5245.291885595396, 5288.709120998382, 5354.866128346666, 5362.463753624606, 5406.459354064562, 5484.478974497416, 5489.0, 5539.833804985857, 5549.889002220014, 6009.429104235091, 4191.287481128276, 4364.6944713869725, 4373.475182978063, 4374.387585738063, 4390.3414487827085, 6006.429389208019, 6034.275886893601, 6052.969735151472, 6126.6017708848785, 6180.0, 5667.319921609434, 5880.617759845596, 5891.528677705859, 5891.558133139946, 5920.911186332295, 5825.79609713658, 5878.794242201502, 5890.587658863838, 5896.262967129109, 5898.764049438146, 5573.637713548606, 5600.103983362643, 5782.508486778671, 5795.043817770021, 5801.274840644919, 5808.36108028125, 5873.177755114373, 5987.640741555347, 5995.310539288038, 6012.6392416455155, 5806.709664516842, 5872.588918775816, 5894.793682221273, 5902.439268269508, 5908.704564771659], "value": 4343.3965382873885, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [750.0324581290135, 791.004188253042, 819.0130892274808, 858.0561382479274, 865.1607940297911, 13155.605331840048, 14280.143191408522, 14585.0, 14594.854051459482, 14686.926565367185, 13784.655383615414, 13948.651283717887, 13957.371918263703, 13965.720685586282, 13995.790063149061, 647.5078940005594, 743.0414764953231, 770.6455030685892, 774.8760198368262, 787.4960025583631, 786.4887822915093, 790.3084800799301, 793.833295008049, 795.0697683710044, 795.9283664470197, 832.0847068224934, 834.1075049696827, 835.5822088955522, 837.7109897085526, 839.0686338164633, 829.9045609754895, 834.6744769539885, 834.7537476444434, 836.4981011393177, 837.2464781696491, 606.560243823229, 606.7967230977628, 610.1183789424284, 610.2250142319274, 612.7977767336769, 13560.321983900765, 13601.795973060312, 13607.931960340235, 13608.659783505393, 13672.453101876012, 14288.0, 14442.277886105652, 14803.925980370137, 14806.851931480654, 14811.48159814412, 12033.879661203364, 12051.698707532294, 12101.455434505468, 12173.452194651261, 12343.629691109281, 3897.7661340319673, 3915.6280153385383, 3929.0766669832565, 3932.8623498177426, 4033.9193216135513, 57816.0, 57821.71089144569, 58215.0, 58267.70866145685, 58647.41352586462, 11053.226274160892, 11175.888241117647, 11178.944105279585, 11356.886431135583, 11431.771364572829, 21078.57842843165, 21082.578348432944, 21103.261385851423, 21119.155233790785, 21140.894295528426, 7938.24586664266, 7960.840783184304, 7978.521288722695, 8201.13888041759, 8230.876536851953, 4480.32795080734, 4552.931706024412, 4667.323238130452, 4679.508651591602, 4700.177468942921, 3420.1449637590604, 3506.403911335079, 3516.6834984851484, 3531.399662057405, 3539.699125574355, 599.6821684507219, 612.7127958502601, 614.443928244939, 618.7494064903722, 631.3717850738544, 710.4848984486309, 804.352496240532, 808.7088648086684, 808.7331180710352, 834.0908409833311, 9775.266854985763, 9840.507974601242, 10018.799624007625, 10040.196784257389, 10194.490275486196, 692.4114502672688, 698.6192525073847, 725.2964624314407, 777.3936329662872, 806.4314658165979, 4568.794404251817, 4598.494165641777, 4627.213373726475, 4719.221328480831, 4723.7874295656775, 67371.0, 68271.0, 69252.653736732, 69980.3001969984, 70071.29928700648, 60864.69567652222, 61233.69383153056, 61785.0, 62569.0, 63339.04991425132, 55732.885342292924, 56629.43370566324, 56691.71654141703, 56784.716076419354, 57012.85974280491, 8851.20339169452, 9109.590068447069, 9333.0, 9404.38871473352, 9436.480993545421, 36631.633683662825, 37337.066573335884, 37638.623613764605, 38331.23337533289, 38450.807745961094, 45374.31938520859, 48789.268160976906, 49013.50986490232, 49260.26109608287, 50393.49606503888, 11607.22727295354, 11790.174687771774, 12120.75758484843, 12209.450574723982, 12316.13787034899, 12431.31627760482, 12487.625371238877, 12911.67589833839, 13144.671383215496, 13590.728185436434, 11626.476808543805, 11939.76120477603, 12219.633410997685, 12226.816597750863, 12710.745785084431, 11936.70158246016, 12045.819312710491, 12080.879191208327, 12403.875961240272, 12416.689582760504, 12178.817317740064, 12183.451744671334, 12288.078394120656, 12486.188397754117, 12634.368281585701, 9972.152367048882, 10037.0, 10145.89854101479, 10242.743931401774, 10319.690409287734, 10275.0, 10487.790244195226, 10522.789544209227, 10538.367697938149, 10544.472776361305], "value": 6883.348832952345, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1538.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 106.0, 112.0, 112.0, 112.0, 113.0, 111.0, 112.0, 111.0, 111.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 126.0, 156.0, 195.0, 139.0, 152.0, 150.0, 126.0, 189.0, 135.0], "value": 152.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 162.0, 161.0, 164.0, 167.0, 167.0, 164.0, 163.0, 162.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 75.0, 77.0, 165.0, 76.0, 75.0, 77.0, 77.0, 166.0, 75.0], "value": 94.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 141.0, 84.0, 83.0, 82.0, 139.0, 82.0, 85.0, 135.0], "value": 99.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 117.0, 117.0, 118.0, 119.0, 118.0, 118.0, 117.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 147.0, 147.0, 148.0, 150.0, 147.0, 147.0, 146.0, 147.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 95.0, 95.0, 96.0, 95.0, 97.0, 96.0, 95.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 58.0, 53.0, 54.0, 55.0, 56.0, 67.0, 52.0, 52.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 62.0, 61.0, 61.0, 61.0, 62.0, 63.0, 62.0], "value": 61.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 80.0, 80.0, 80.0, 81.0, 81.0, 82.0, 81.0, 81.0], "value": 80.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 123.0, 133.0, 138.0, 122.0, 122.0, 132.0, 123.0, 169.0, 123.0], "value": 132.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 166.0, 164.0, 158.0, 161.0, 158.0, 159.0, 167.0, 160.0, 167.0], "value": 161.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 61.0, 66.0, 63.0, 62.0, 68.0, 62.0, 63.0, 61.0, 63.0], "value": 64.1, "unit": "score"}]}]} 05:29:52 INFO - Return code: 0 05:29:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:29:52 ERROR - # TBPL SUCCESS # 05:29:52 INFO - Running post-action listener: _resource_record_post_action 05:29:52 INFO - ##### 05:29:52 INFO - ##### Finished run-tests step (success) 05:29:52 INFO - ##### 05:29:52 INFO - Running post-run listener: _resource_record_post_run 05:29:52 INFO - Total resource usage - Wall time: 1190s; CPU: 14.0%; Read bytes: 0; Write bytes: 539381760; Read time: 0; Write time: 479284 05:29:52 INFO - TinderboxPrint: CPU usage
13.5% 05:29:52 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 05:29:52 INFO - TinderboxPrint: I/O write bytes / time
539,381,760 / 479,284 05:29:52 INFO - TinderboxPrint: CPU idle
8,211.7 (86.5%) 05:29:52 INFO - TinderboxPrint: CPU user
1,226.1 (12.9%) 05:29:52 INFO - TinderboxPrint: Swap in / out
0 / 0 05:29:52 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 247046144; Read time: 0; Write time: 241068 05:29:52 INFO - run-tests - Wall time: 1173s; CPU: 14.0%; Read bytes: 0; Write bytes: 292147200; Read time: 0; Write time: 238196 05:29:52 INFO - Running post-run listener: _upload_blobber_files 05:29:52 INFO - Blob upload gear active. 05:29:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:29: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 05:29: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'] 05:29: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 05:29:53 INFO - (blobuploader) - INFO - Open directory for files ... 05:29:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:29:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:29:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:29:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:29:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:29:54 INFO - (blobuploader) - INFO - Done attempting. 05:29:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:29:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:29:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:29:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:29:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:29:57 INFO - (blobuploader) - INFO - Done attempting. 05:29:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:29:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:29:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:29:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:29:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:29:58 INFO - (blobuploader) - INFO - Done attempting. 05:29:58 INFO - (blobuploader) - INFO - Iteration through files over. 05:29:58 INFO - Return code: 0 05:29:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:29:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:29:58 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b7e9611b40a5c00b7d4644c71758cb31f1fcabd1bafa931203ed7ed4a9bac33255190c850bdffda1e143e0ccf50c136f375e233f4916dd3044c32f702157fac7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3842203d55669677240e721c8f2c924320297ef65ead231a4c5ed04d9de80fc165fac1aa0a09fcffc2efd9d2f924f9c1335388ba32316695f73cf67e04d6a600", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/424bad09b6e3d5306b18f49fa9df585c62b8df0e748624f760781d3e930a69828312cd5c354e405974b9977fe4033fd8887cd74a91259cd96095644b1323f157"} 05:29:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:29:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:29:58 INFO - Contents: 05:29:58 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b7e9611b40a5c00b7d4644c71758cb31f1fcabd1bafa931203ed7ed4a9bac33255190c850bdffda1e143e0ccf50c136f375e233f4916dd3044c32f702157fac7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3842203d55669677240e721c8f2c924320297ef65ead231a4c5ed04d9de80fc165fac1aa0a09fcffc2efd9d2f924f9c1335388ba32316695f73cf67e04d6a600", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/424bad09b6e3d5306b18f49fa9df585c62b8df0e748624f760781d3e930a69828312cd5c354e405974b9977fe4033fd8887cd74a91259cd96095644b1323f157"} 05:29:58 INFO - Running post-run listener: copy_logs_to_upload_dir 05:29:58 INFO - Copying logs to upload dir... 05:29:58 INFO - mkdir: /builds/slave/test/build/upload/logs 05:29:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.707808 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-05-26 05:29:58.053236) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-26 05:29:58.057140) ========= 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-1464263334.719241-15083901 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/b7e9611b40a5c00b7d4644c71758cb31f1fcabd1bafa931203ed7ed4a9bac33255190c850bdffda1e143e0ccf50c136f375e233f4916dd3044c32f702157fac7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3842203d55669677240e721c8f2c924320297ef65ead231a4c5ed04d9de80fc165fac1aa0a09fcffc2efd9d2f924f9c1335388ba32316695f73cf67e04d6a600", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/424bad09b6e3d5306b18f49fa9df585c62b8df0e748624f760781d3e930a69828312cd5c354e405974b9977fe4033fd8887cd74a91259cd96095644b1323f157"} build_url:https://queue.taskcluster.net/v1/task/fqWwQTqFQvego26DbFXU3A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011343 build_url: 'https://queue.taskcluster.net/v1/task/fqWwQTqFQvego26DbFXU3A/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/b7e9611b40a5c00b7d4644c71758cb31f1fcabd1bafa931203ed7ed4a9bac33255190c850bdffda1e143e0ccf50c136f375e233f4916dd3044c32f702157fac7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3842203d55669677240e721c8f2c924320297ef65ead231a4c5ed04d9de80fc165fac1aa0a09fcffc2efd9d2f924f9c1335388ba32316695f73cf67e04d6a600", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/424bad09b6e3d5306b18f49fa9df585c62b8df0e748624f760781d3e930a69828312cd5c354e405974b9977fe4033fd8887cd74a91259cd96095644b1323f157"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-26 05:29:58.082632) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 05:29:58.082977) ========= 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-1464263334.719241-15083901 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004511 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 05:29:58.165843) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-26 05:29:58.166165) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-26 05:29:58.166466) ========= ========= Total master_lag: 0.21 =========