builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-062 starttime: 1463818172.78 results: success (0) buildid: 20160520223041 builduid: b460f755aaa9451c8467c34e21ab3c7f revision: 4bbdb484d7b89b4ebafbfa4a2ecc28a93ee21157 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-21 01:09:32.775540) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-21 01:09:32.776014) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-21 01:09:32.776337) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-21 01:09:32.812930) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 01:09:32.813572) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1463810468.905643-433997857 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-21 01:09:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 16.2M=0.001s 2016-05-21 01:09:33 (16.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.126137 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 01:09:32.953590) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 01:09:32.953920) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1463810468.905643-433997857 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017147 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 01:09:33.006368) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 01:09:33.007042) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 4bbdb484d7b89b4ebafbfa4a2ecc28a93ee21157 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 4bbdb484d7b89b4ebafbfa4a2ecc28a93ee21157 --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=a4ce256d2ec601f24a60a71e000001bc-1463810468.905643-433997857 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-21 01:09:33,203 truncating revision to first 12 chars 2016-05-21 01:09:33,203 Setting DEBUG logging. 2016-05-21 01:09:33,204 attempt 1/10 2016-05-21 01:09:33,204 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/4bbdb484d7b8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-21 01:09:33,760 unpacking tar archive at: mozilla-inbound-4bbdb484d7b8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.872994 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 01:09:33.897846) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-21 01:09:33.898298) ========= script_repo_revision: 4bbdb484d7b89b4ebafbfa4a2ecc28a93ee21157 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-21 01:09:33.898855) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-21 01:09:33.899235) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-21 01:09:33.909346) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-05-21 01:09:33.909759) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=a4ce256d2ec601f24a60a71e000001bc-1463810468.905643-433997857 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:09:34 INFO - MultiFileLogger online at 20160521 01:09:34 in /builds/slave/test 01:09:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 01:09:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:09:34 INFO - {'append_to_log': False, 01:09:34 INFO - 'base_work_dir': '/builds/slave/test', 01:09:34 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 01:09:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:09:34 INFO - 'branch': 'Mozilla-Inbound', 01:09:34 INFO - 'buildbot_json_path': 'buildprops.json', 01:09:34 INFO - 'config_files': ('talos/linux_config.py',), 01:09:34 INFO - 'default_actions': ('clobber', 01:09:34 INFO - 'read-buildbot-config', 01:09:34 INFO - 'download-and-extract', 01:09:34 INFO - 'populate-webroot', 01:09:34 INFO - 'create-virtualenv', 01:09:34 INFO - 'install', 01:09:34 INFO - 'run-tests'), 01:09:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:09:34 INFO - 'download_minidump_stackwalk': True, 01:09:34 INFO - 'download_symbols': 'ondemand', 01:09:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:09:34 INFO - 'tooltool.py': '/tools/tooltool.py', 01:09:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:09:34 INFO - '/tools/misc-python/virtualenv.py')}, 01:09:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:09:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:09:34 INFO - 'installer_path': 'installer.exe', 01:09:34 INFO - 'log_level': 'info', 01:09:34 INFO - 'log_name': 'talos', 01:09:34 INFO - 'log_to_console': True, 01:09:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:09:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:09:34 INFO - 'opt_config_files': (), 01:09:34 INFO - 'pip_index': False, 01:09:34 INFO - 'sps_profile': False, 01:09:34 INFO - 'sps_profile_interval': 0, 01:09:34 INFO - 'suite': 'dromaeojs', 01:09:34 INFO - 'system_bits': '32', 01:09:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:09:34 INFO - 'title': 'talos-linux64-ix-062', 01:09:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:09:34 INFO - 'use_talos_json': True, 01:09:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:09:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:09:34 INFO - 'work_dir': 'build'} 01:09:34 INFO - ##### 01:09:34 INFO - ##### Running clobber step. 01:09:34 INFO - ##### 01:09:34 INFO - Running pre-action listener: _resource_record_pre_action 01:09:34 INFO - Running main action method: clobber 01:09:34 INFO - rmtree: /builds/slave/test/build 01:09:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:09:34 INFO - Running post-action listener: _resource_record_post_action 01:09:34 INFO - ##### 01:09:34 INFO - ##### Finished clobber step (success) 01:09:34 INFO - ##### 01:09:34 INFO - ##### 01:09:34 INFO - ##### Running read-buildbot-config step. 01:09:34 INFO - ##### 01:09:34 INFO - Running pre-action listener: _resource_record_pre_action 01:09:34 INFO - Running main action method: read_buildbot_config 01:09:34 INFO - Using buildbot properties: 01:09:34 INFO - { 01:09:34 INFO - "project": "", 01:09:34 INFO - "product": "firefox", 01:09:34 INFO - "script_repo_revision": "production", 01:09:34 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 01:09:34 INFO - "repository": "", 01:09:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 01:09:34 INFO - "buildid": "20160520223041", 01:09:34 INFO - "pgo_build": "True", 01:09:34 INFO - "basedir": "/builds/slave/test", 01:09:34 INFO - "buildnumber": 1037, 01:09:34 INFO - "slavename": "talos-linux64-ix-062", 01:09:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 01:09:34 INFO - "platform": "ubuntu64_hw", 01:09:34 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 01:09:34 INFO - "branch": "mozilla-inbound", 01:09:34 INFO - "repo_path": "integration/mozilla-inbound", 01:09:34 INFO - "revision": "4bbdb484d7b89b4ebafbfa4a2ecc28a93ee21157", 01:09:34 INFO - "stage_platform": "linux64-pgo", 01:09:34 INFO - "builduid": "b460f755aaa9451c8467c34e21ab3c7f", 01:09:34 INFO - "slavebuilddir": "test" 01:09:34 INFO - } 01:09:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/LfxMTmTHRdGNf7cI-QM9qw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 01:09:34 INFO - Running post-action listener: _resource_record_post_action 01:09:34 INFO - ##### 01:09:34 INFO - ##### Finished read-buildbot-config step (success) 01:09:34 INFO - ##### 01:09:34 INFO - ##### 01:09:34 INFO - ##### Running download-and-extract step. 01:09:34 INFO - ##### 01:09:34 INFO - Running pre-action listener: _resource_record_pre_action 01:09:34 INFO - Running main action method: download_and_extract 01:09:34 INFO - mkdir: /builds/slave/test/build/tests 01: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')]} 01:09:34 INFO - https://queue.taskcluster.net/v1/task/LfxMTmTHRdGNf7cI-QM9qw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:09:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LfxMTmTHRdGNf7cI-QM9qw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:09:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LfxMTmTHRdGNf7cI-QM9qw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:09:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LfxMTmTHRdGNf7cI-QM9qw/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 01:09:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LfxMTmTHRdGNf7cI-QM9qw/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 01:09:35 INFO - Downloaded 1361 bytes. 01:09:35 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 01:09:35 INFO - Using the following test package requirements: 01:09:35 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 01:09:35 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:09:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:09:35 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:09:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:09:35 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:09:35 INFO - u'jsshell-linux-x86_64.zip'], 01:09:35 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:09:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:09:35 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 01:09:35 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:09:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:09:35 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:09:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:09:35 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:09:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:09:35 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 01:09:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:09:35 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01: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')]} 01:09:35 INFO - https://queue.taskcluster.net/v1/task/LfxMTmTHRdGNf7cI-QM9qw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:09:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LfxMTmTHRdGNf7cI-QM9qw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:09:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LfxMTmTHRdGNf7cI-QM9qw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:09:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LfxMTmTHRdGNf7cI-QM9qw/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 01:09:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LfxMTmTHRdGNf7cI-QM9qw/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 01:09:36 INFO - Downloaded 24388474 bytes. 01:09:36 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'] 01:09:36 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 01:09:37 INFO - Return code: 0 01:09:37 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 01:09:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:09:37 INFO - https://queue.taskcluster.net/v1/task/LfxMTmTHRdGNf7cI-QM9qw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:09:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LfxMTmTHRdGNf7cI-QM9qw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:09:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LfxMTmTHRdGNf7cI-QM9qw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 01:09:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LfxMTmTHRdGNf7cI-QM9qw/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 01:09:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LfxMTmTHRdGNf7cI-QM9qw/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 01:09:40 INFO - Downloaded 24388474 bytes. 01:09:40 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'] 01:09:40 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 01:09:41 INFO - Return code: 0 01:09:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:09:41 INFO - https://queue.taskcluster.net/v1/task/LfxMTmTHRdGNf7cI-QM9qw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:09:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LfxMTmTHRdGNf7cI-QM9qw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 01:09:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LfxMTmTHRdGNf7cI-QM9qw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 01:09:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LfxMTmTHRdGNf7cI-QM9qw/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 01:09:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LfxMTmTHRdGNf7cI-QM9qw/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 01:09:43 INFO - Downloaded 10840359 bytes. 01:09:43 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'] 01:09:43 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 01:09:43 INFO - Return code: 0 01:09:43 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')]} 01:09:43 INFO - https://queue.taskcluster.net/v1/task/LfxMTmTHRdGNf7cI-QM9qw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:09:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LfxMTmTHRdGNf7cI-QM9qw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:09:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LfxMTmTHRdGNf7cI-QM9qw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:09:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LfxMTmTHRdGNf7cI-QM9qw/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 01:09:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LfxMTmTHRdGNf7cI-QM9qw/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 01:09:44 INFO - Downloaded 58577836 bytes. 01:09:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LfxMTmTHRdGNf7cI-QM9qw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:09:44 INFO - mkdir: /builds/slave/test/properties 01:09:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:09:44 INFO - Writing to file /builds/slave/test/properties/build_url 01:09:44 INFO - Contents: 01:09:44 INFO - build_url:https://queue.taskcluster.net/v1/task/LfxMTmTHRdGNf7cI-QM9qw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 01:09:45 INFO - Running post-action listener: _resource_record_post_action 01:09:45 INFO - Running post-action listener: set_extra_try_arguments 01:09:45 INFO - ##### 01:09:45 INFO - ##### Finished download-and-extract step (success) 01:09:45 INFO - ##### 01:09:45 INFO - ##### 01:09:45 INFO - ##### Running populate-webroot step. 01:09:45 INFO - ##### 01:09:45 INFO - Running pre-action listener: _resource_record_pre_action 01:09:45 INFO - Running main action method: populate_webroot 01:09:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:09:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:09:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:09:45 INFO - '--tppagecycles', 01:09:45 INFO - '7'], 01:09:45 INFO - 'tests': ['tsvgm']}}, 01:09:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:09:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:09:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:09:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:09:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:09:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:09:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:09:45 INFO - 'talos_options': ['--disable-e10s'], 01:09:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:09:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:09:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:09:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:09:45 INFO - 'talos_options': ['--disable-e10s'], 01:09:45 INFO - 'tests': ['damp', 'tps']}, 01:09:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:09:45 INFO - 'tests': ['damp', 'tps']}, 01:09:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:09:45 INFO - 'tests': ['dromaeo_dom']}, 01:09:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:09:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:09:45 INFO - 'tests': ['a11yr', 01:09:45 INFO - 'ts_paint', 01:09:45 INFO - 'tpaint', 01:09:45 INFO - 'sessionrestore', 01:09:45 INFO - 'sessionrestore_no_auto_restore', 01:09:45 INFO - 'tabpaint']}, 01:09:45 INFO - 'other-e10s': {'tests': ['a11yr', 01:09:45 INFO - 'ts_paint', 01:09:45 INFO - 'tpaint', 01:09:45 INFO - 'sessionrestore', 01:09:45 INFO - 'sessionrestore_no_auto_restore', 01:09:45 INFO - 'tabpaint']}, 01:09:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:09:45 INFO - 'ts_paint', 01:09:45 INFO - 'tpaint', 01:09:45 INFO - 'sessionrestore', 01:09:45 INFO - 'sessionrestore_no_auto_restore', 01:09:45 INFO - 'tabpaint']}, 01:09:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:09:45 INFO - 'ts_paint', 01:09:45 INFO - 'tpaint', 01:09:45 INFO - 'sessionrestore', 01:09:45 INFO - 'sessionrestore_no_auto_restore', 01:09:45 INFO - 'tabpaint']}, 01:09:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:09:45 INFO - 'tests': ['a11yr', 01:09:45 INFO - 'ts_paint', 01:09:45 INFO - 'tpaint', 01:09:45 INFO - 'sessionrestore', 01:09:45 INFO - 'sessionrestore_no_auto_restore', 01:09:45 INFO - 'tabpaint']}, 01:09:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:09:45 INFO - 'tests': ['a11yr', 01:09:45 INFO - 'ts_paint', 01:09:45 INFO - 'tpaint', 01:09:45 INFO - 'sessionrestore', 01:09:45 INFO - 'sessionrestore_no_auto_restore', 01:09:45 INFO - 'tabpaint']}, 01:09:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:09:45 INFO - 'tests': ['tsvgx', 01:09:45 INFO - 'tsvgr_opacity', 01:09:45 INFO - 'tart', 01:09:45 INFO - 'tscrollx', 01:09:45 INFO - 'cart']}, 01:09:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:09:45 INFO - 'tsvgr_opacity', 01:09:45 INFO - 'tart', 01:09:45 INFO - 'tscrollx', 01:09:45 INFO - 'cart']}, 01:09:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:09:45 INFO - 'talos_options': ['--disable-e10s'], 01:09:45 INFO - 'tests': ['tp5o']}, 01:09:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:09:45 INFO - 'tests': ['tp5o']}, 01:09:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:09:45 INFO - 'talos_options': ['--disable-e10s', 01:09:45 INFO - '--xperf_path', 01:09:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:09:45 INFO - 'tests': ['tp5n']}, 01:09:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:09:45 INFO - 'talos_options': ['--xperf_path', 01:09:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:09:45 INFO - 'tests': ['tp5n']}}, 01:09:45 INFO - 'talos.zip': {'path': '', 01:09:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:09:45 INFO - Running post-action listener: _resource_record_post_action 01:09:45 INFO - ##### 01:09:45 INFO - ##### Finished populate-webroot step (success) 01:09:45 INFO - ##### 01:09:45 INFO - ##### 01:09:45 INFO - ##### Running create-virtualenv step. 01:09:45 INFO - ##### 01:09:45 INFO - Running pre-action listener: _resource_record_pre_action 01:09:45 INFO - Running main action method: create_virtualenv 01:09:45 INFO - Creating virtualenv /builds/slave/test/build/venv 01:09:45 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 01:09:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:09:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:09:45 INFO - Using real prefix '/usr' 01:09:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:09:46 INFO - Installing distribute.............................................................................................................................................................................................done. 01:09:48 INFO - Installing pip.................done. 01:09:48 INFO - Return code: 0 01:09:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01: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')]} 01:09:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:09:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01: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')]} 01:09:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:09:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:09:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f049fa0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27dd9c0>, '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 0x27de8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ded50>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1463810468.905643-433997857', '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 01:09:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:09:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:09:48 INFO - Using env: {'DISPLAY': ':0', 01:09:48 INFO - 'HOME': '/home/cltbld', 01:09:48 INFO - 'LANG': 'en_US.UTF-8', 01:09:48 INFO - 'LANGUAGE': 'en_US:en', 01:09:48 INFO - 'LOGNAME': 'cltbld', 01:09:48 INFO - 'MAIL': '/var/mail/cltbld', 01:09:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:09:48 INFO - 'MOZ_NO_REMOTE': '1', 01:09:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:09:48 INFO - 'NO_EM_RESTART': '1', 01:09:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:09:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:09:48 INFO - 'PWD': '/builds/slave/test', 01:09:48 INFO - 'SHELL': '/bin/bash', 01:09:48 INFO - 'SHLVL': '1', 01:09:48 INFO - 'TERM': 'linux', 01:09:48 INFO - 'TMOUT': '86400', 01:09:48 INFO - 'USER': 'cltbld', 01:09:48 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1463810468.905643-433997857', 01:09:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:09:48 INFO - '_': '/tools/buildbot/bin/python'} 01:09:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:09:48 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 01:09:48 INFO - Cleaning up... 01:09:48 INFO - Return code: 0 01:09:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01: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')]} 01:09:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:09:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01: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')]} 01:09:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:09:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:09:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f049fa0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27dd9c0>, '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 0x27de8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ded50>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1463810468.905643-433997857', '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 01:09:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 01:09:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 01:09:48 INFO - Using env: {'DISPLAY': ':0', 01:09:48 INFO - 'HOME': '/home/cltbld', 01:09:48 INFO - 'LANG': 'en_US.UTF-8', 01:09:48 INFO - 'LANGUAGE': 'en_US:en', 01:09:48 INFO - 'LOGNAME': 'cltbld', 01:09:48 INFO - 'MAIL': '/var/mail/cltbld', 01:09:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:09:48 INFO - 'MOZ_NO_REMOTE': '1', 01:09:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:09:48 INFO - 'NO_EM_RESTART': '1', 01:09:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:09:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:09:48 INFO - 'PWD': '/builds/slave/test', 01:09:48 INFO - 'SHELL': '/bin/bash', 01:09:48 INFO - 'SHLVL': '1', 01:09:48 INFO - 'TERM': 'linux', 01:09:48 INFO - 'TMOUT': '86400', 01:09:48 INFO - 'USER': 'cltbld', 01:09:48 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1463810468.905643-433997857', 01:09:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:09:48 INFO - '_': '/tools/buildbot/bin/python'} 01:09:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:09:48 INFO - Downloading/unpacking psutil>=3.1.1 01:09:48 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 01:09:48 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 01:09:48 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 01:09:48 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 01:09:48 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 01:09:48 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 01:09:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:09:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:09:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:09:50 INFO - Installing collected packages: psutil 01:09:50 INFO - Running setup.py install for psutil 01:09:50 INFO - building 'psutil._psutil_linux' extension 01:09:50 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 01:09:50 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 01:09:50 INFO - building 'psutil._psutil_posix' extension 01:09:50 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 01:09:51 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 01:09:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:09:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:09:51 INFO - Successfully installed psutil 01:09:51 INFO - Cleaning up... 01:09:51 INFO - Return code: 0 01:09:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01: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')]} 01:09:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:09:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01: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')]} 01:09:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:09:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:09:51 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 0x7f049fa0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27dd9c0>, '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 0x27de8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ded50>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1463810468.905643-433997857', '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 01:09:51 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 01:09:51 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 01:09:51 INFO - Using env: {'DISPLAY': ':0', 01:09:51 INFO - 'HOME': '/home/cltbld', 01:09:51 INFO - 'LANG': 'en_US.UTF-8', 01:09:51 INFO - 'LANGUAGE': 'en_US:en', 01:09:51 INFO - 'LOGNAME': 'cltbld', 01:09:51 INFO - 'MAIL': '/var/mail/cltbld', 01:09:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:09:51 INFO - 'MOZ_NO_REMOTE': '1', 01:09:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:09:51 INFO - 'NO_EM_RESTART': '1', 01:09:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:09:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:09:51 INFO - 'PWD': '/builds/slave/test', 01:09:51 INFO - 'SHELL': '/bin/bash', 01:09:51 INFO - 'SHLVL': '1', 01:09:51 INFO - 'TERM': 'linux', 01:09:51 INFO - 'TMOUT': '86400', 01:09:51 INFO - 'USER': 'cltbld', 01:09:51 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1463810468.905643-433997857', 01:09:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:09:51 INFO - '_': '/tools/buildbot/bin/python'} 01:09:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:09:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:09:51 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 01:09:51 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 01:09:51 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 01:09:51 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 01:09:51 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 01:09:51 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 01:09:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:09:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:09:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:09:53 INFO - Installing collected packages: mozsystemmonitor 01:09:53 INFO - Running setup.py install for mozsystemmonitor 01:09:53 INFO - Successfully installed mozsystemmonitor 01:09:53 INFO - Cleaning up... 01:09:53 INFO - Return code: 0 01:09:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:09:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:09:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:09:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:09:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:09:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:09:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:09:53 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 0x7f049fa0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27dd9c0>, '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 0x27de8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ded50>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1463810468.905643-433997857', '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 01:09:53 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 01:09:53 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 01:09:53 INFO - Using env: {'DISPLAY': ':0', 01:09:53 INFO - 'HOME': '/home/cltbld', 01:09:53 INFO - 'LANG': 'en_US.UTF-8', 01:09:53 INFO - 'LANGUAGE': 'en_US:en', 01:09:53 INFO - 'LOGNAME': 'cltbld', 01:09:53 INFO - 'MAIL': '/var/mail/cltbld', 01:09:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:09:53 INFO - 'MOZ_NO_REMOTE': '1', 01:09:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:09:53 INFO - 'NO_EM_RESTART': '1', 01:09:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:09:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:09:53 INFO - 'PWD': '/builds/slave/test', 01:09:53 INFO - 'SHELL': '/bin/bash', 01:09:53 INFO - 'SHLVL': '1', 01:09:53 INFO - 'TERM': 'linux', 01:09:53 INFO - 'TMOUT': '86400', 01:09:53 INFO - 'USER': 'cltbld', 01:09:53 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1463810468.905643-433997857', 01:09:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:09:53 INFO - '_': '/tools/buildbot/bin/python'} 01:09:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:09:53 INFO - Downloading/unpacking blobuploader==1.2.4 01: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 01: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 01: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 01: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 01: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 01: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 01:09:55 INFO - Downloading blobuploader-1.2.4.tar.gz 01:09:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:09:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:09:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:09:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:09:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:09:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:09:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:09:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:09:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:09:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01: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 01: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 01: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 01: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 01: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 01: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 01:09:56 INFO - Downloading docopt-0.6.1.tar.gz 01:09:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:09:56 INFO - Installing collected packages: blobuploader, requests, docopt 01:09:56 INFO - Running setup.py install for blobuploader 01:09:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:09:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:09:56 INFO - Running setup.py install for requests 01:09:56 INFO - Running setup.py install for docopt 01:09:56 INFO - Successfully installed blobuploader requests docopt 01:09:56 INFO - Cleaning up... 01:09:57 INFO - Return code: 0 01:09:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:09:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:09:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:09:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:09:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:09:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:09:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:09:57 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 0x7f049fa0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27dd9c0>, '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 0x27de8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ded50>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1463810468.905643-433997857', '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 01:09:57 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 01:09:57 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 01:09:57 INFO - Using env: {'DISPLAY': ':0', 01:09:57 INFO - 'HOME': '/home/cltbld', 01:09:57 INFO - 'LANG': 'en_US.UTF-8', 01:09:57 INFO - 'LANGUAGE': 'en_US:en', 01:09:57 INFO - 'LOGNAME': 'cltbld', 01:09:57 INFO - 'MAIL': '/var/mail/cltbld', 01:09:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:09:57 INFO - 'MOZ_NO_REMOTE': '1', 01:09:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:09:57 INFO - 'NO_EM_RESTART': '1', 01:09:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:09:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:09:57 INFO - 'PWD': '/builds/slave/test', 01:09:57 INFO - 'SHELL': '/bin/bash', 01:09:57 INFO - 'SHLVL': '1', 01:09:57 INFO - 'TERM': 'linux', 01:09:57 INFO - 'TMOUT': '86400', 01:09:57 INFO - 'USER': 'cltbld', 01:09:57 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1463810468.905643-433997857', 01:09:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:09:57 INFO - '_': '/tools/buildbot/bin/python'} 01:09:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:09:57 INFO - Running setup.py (path:/tmp/pip-cV14WG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:09:57 INFO - Running setup.py (path:/tmp/pip-5yNeK8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:09:57 INFO - Running setup.py (path:/tmp/pip-kvpgin-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:09:57 INFO - Running setup.py (path:/tmp/pip-yYIVrq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:09:57 INFO - Running setup.py (path:/tmp/pip-TWz_KC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:09:57 INFO - Running setup.py (path:/tmp/pip-KtWDkj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:09:57 INFO - Running setup.py (path:/tmp/pip-Sjo5of-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:09:57 INFO - Running setup.py (path:/tmp/pip-JTLsix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:09:57 INFO - Running setup.py (path:/tmp/pip-tpD_xh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:09:57 INFO - Running setup.py (path:/tmp/pip-zpn4_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:09:57 INFO - Running setup.py (path:/tmp/pip-cFmbUh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:09:58 INFO - Running setup.py (path:/tmp/pip-bFEbUF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:09:58 INFO - Running setup.py (path:/tmp/pip-GJcAee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:09:58 INFO - Running setup.py (path:/tmp/pip-AmZYFo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:09:58 INFO - Running setup.py (path:/tmp/pip-KJ1IaQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:09:58 INFO - Running setup.py (path:/tmp/pip-rwUBFD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:09:58 INFO - Running setup.py (path:/tmp/pip-GTt2GY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:09:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:09:58 INFO - Running setup.py install for manifestparser 01:09:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:09:58 INFO - Running setup.py install for mozcrash 01:09:58 INFO - Running setup.py install for mozdebug 01:09:58 INFO - Running setup.py install for mozdevice 01:09:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:09:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:09:58 INFO - Running setup.py install for mozfile 01:09:59 INFO - Running setup.py install for mozhttpd 01:09:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:09:59 INFO - Running setup.py install for mozinfo 01:09:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:09:59 INFO - Running setup.py install for mozInstall 01:09:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:09:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:09:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:09:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:09:59 INFO - Running setup.py install for mozleak 01:09:59 INFO - Running setup.py install for mozlog 01:09:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:09:59 INFO - Running setup.py install for moznetwork 01:09:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:09:59 INFO - Running setup.py install for mozprocess 01:09:59 INFO - Running setup.py install for mozprofile 01:09:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:09:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:09:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:09:59 INFO - Running setup.py install for mozrunner 01:09:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:09:59 INFO - Running setup.py install for mozscreenshot 01:10:00 INFO - Running setup.py install for moztest 01:10:00 INFO - Running setup.py install for mozversion 01:10:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:10:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:10:00 INFO - Cleaning up... 01:10:00 INFO - Return code: 0 01:10:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:10:00 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')]} 01:10:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:10:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:00 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')]} 01:10:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:10:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:00 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 0x7f049fa0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27dd9c0>, '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 0x27de8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ded50>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1463810468.905643-433997857', '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 01:10:00 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 01:10:00 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 01:10:00 INFO - Using env: {'DISPLAY': ':0', 01:10:00 INFO - 'HOME': '/home/cltbld', 01:10:00 INFO - 'LANG': 'en_US.UTF-8', 01:10:00 INFO - 'LANGUAGE': 'en_US:en', 01:10:00 INFO - 'LOGNAME': 'cltbld', 01:10:00 INFO - 'MAIL': '/var/mail/cltbld', 01:10:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:10:00 INFO - 'MOZ_NO_REMOTE': '1', 01:10:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:10:00 INFO - 'NO_EM_RESTART': '1', 01:10:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:10:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:10:00 INFO - 'PWD': '/builds/slave/test', 01:10:00 INFO - 'SHELL': '/bin/bash', 01:10:00 INFO - 'SHLVL': '1', 01:10:00 INFO - 'TERM': 'linux', 01:10:00 INFO - 'TMOUT': '86400', 01:10:00 INFO - 'USER': 'cltbld', 01:10:00 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1463810468.905643-433997857', 01:10:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:10:00 INFO - '_': '/tools/buildbot/bin/python'} 01:10:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:10:00 INFO - Running setup.py (path:/tmp/pip-kdo8EX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:10:00 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)) 01:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:10:00 INFO - Running setup.py (path:/tmp/pip-jwBhGy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:10:00 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)) 01:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:10:00 INFO - Running setup.py (path:/tmp/pip-1wOSSn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:10:00 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)) 01:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:10:00 INFO - Running setup.py (path:/tmp/pip-M6zgwF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:10:00 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)) 01:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:10:00 INFO - Running setup.py (path:/tmp/pip-0yW0os-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:10:00 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)) 01:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:10:00 INFO - Running setup.py (path:/tmp/pip-jOir6V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:10:00 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)) 01:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:10:00 INFO - Running setup.py (path:/tmp/pip-RIaGWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:10:01 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)) 01:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:10:01 INFO - Running setup.py (path:/tmp/pip-sMZDnD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:10:01 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)) 01:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:10:01 INFO - Running setup.py (path:/tmp/pip-RTrOAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:10:01 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)) 01:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:10:01 INFO - Running setup.py (path:/tmp/pip-2G8E2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:10:01 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)) 01:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:10:01 INFO - Running setup.py (path:/tmp/pip-h6Skk9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:10:01 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)) 01:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:10:01 INFO - Running setup.py (path:/tmp/pip-fwwPGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:10:01 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)) 01:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:10:01 INFO - Running setup.py (path:/tmp/pip-QdYLg9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:10:01 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)) 01:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:10:01 INFO - Running setup.py (path:/tmp/pip-bOMXeF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:10:01 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)) 01:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:10:01 INFO - Running setup.py (path:/tmp/pip-MVB9nO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:10:01 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)) 01:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:10:01 INFO - Running setup.py (path:/tmp/pip-6usMoE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:10:01 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)) 01:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:10:01 INFO - Running setup.py (path:/tmp/pip-yiNOYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:10:01 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)) 01:10:01 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)) 01:10:01 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)) 01:10:01 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)) 01:10:01 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)) 01:10:01 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)) 01:10:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01: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 01: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 01: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 01: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 01: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 01: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 01:10:03 INFO - Downloading blessings-1.6.tar.gz 01:10:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:10:03 INFO - Installing collected packages: blessings 01:10:03 INFO - Running setup.py install for blessings 01:10:03 INFO - Successfully installed blessings 01:10:03 INFO - Cleaning up... 01:10:03 INFO - Return code: 0 01:10:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:10:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:10:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:10:04 INFO - Reading from file tmpfile_stdout 01:10:04 INFO - Current package versions: 01:10:04 INFO - argparse == 1.2.1 01:10:04 INFO - blessings == 1.6 01:10:04 INFO - blobuploader == 1.2.4 01:10:04 INFO - docopt == 0.6.1 01:10:04 INFO - manifestparser == 1.1 01:10:04 INFO - mozInstall == 1.12 01:10:04 INFO - mozcrash == 0.17 01:10:04 INFO - mozdebug == 0.1 01:10:04 INFO - mozdevice == 0.48 01:10:04 INFO - mozfile == 1.2 01:10:04 INFO - mozhttpd == 0.7 01:10:04 INFO - mozinfo == 0.9 01:10:04 INFO - mozleak == 0.1 01:10:04 INFO - mozlog == 3.2 01:10:04 INFO - moznetwork == 0.27 01:10:04 INFO - mozprocess == 0.22 01:10:04 INFO - mozprofile == 0.28 01:10:04 INFO - mozrunner == 6.11 01:10:04 INFO - mozscreenshot == 0.1 01:10:04 INFO - mozsystemmonitor == 0.3 01:10:04 INFO - moztest == 0.7 01:10:04 INFO - mozversion == 1.4 01:10:04 INFO - psutil == 3.1.1 01:10:04 INFO - requests == 1.2.3 01:10:04 INFO - wsgiref == 0.1.2 01:10:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:10:04 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')]} 01:10:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:10:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:04 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')]} 01:10:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:10:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:04 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 0x7f049fa0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27dd9c0>, '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 0x27de8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ded50>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1463810468.905643-433997857', '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 01:10:04 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 01:10:04 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 01:10:04 INFO - Using env: {'DISPLAY': ':0', 01:10:04 INFO - 'HOME': '/home/cltbld', 01:10:04 INFO - 'LANG': 'en_US.UTF-8', 01:10:04 INFO - 'LANGUAGE': 'en_US:en', 01:10:04 INFO - 'LOGNAME': 'cltbld', 01:10:04 INFO - 'MAIL': '/var/mail/cltbld', 01:10:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:10:04 INFO - 'MOZ_NO_REMOTE': '1', 01:10:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:10:04 INFO - 'NO_EM_RESTART': '1', 01:10:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:10:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:10:04 INFO - 'PWD': '/builds/slave/test', 01:10:04 INFO - 'SHELL': '/bin/bash', 01:10:04 INFO - 'SHLVL': '1', 01:10:04 INFO - 'TERM': 'linux', 01:10:04 INFO - 'TMOUT': '86400', 01:10:04 INFO - 'USER': 'cltbld', 01:10:04 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1463810468.905643-433997857', 01:10:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:10:04 INFO - '_': '/tools/buildbot/bin/python'} 01:10:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:10:04 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)) 01:10:04 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)) 01:10:04 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)) 01:10:04 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)) 01:10:04 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)) 01:10:04 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)) 01:10:04 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)) 01:10:04 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)) 01:10:04 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)) 01:10:04 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)) 01:10:04 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)) 01:10:04 INFO - Cleaning up... 01:10:04 INFO - Return code: 0 01:10:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:10:04 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')]} 01:10:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:10:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:04 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')]} 01:10:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:10:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:04 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 0x7f049fa0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27dd9c0>, '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 0x27de8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ded50>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1463810468.905643-433997857', '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 01:10:04 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 01:10:04 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 01:10:04 INFO - Using env: {'DISPLAY': ':0', 01:10:04 INFO - 'HOME': '/home/cltbld', 01:10:04 INFO - 'LANG': 'en_US.UTF-8', 01:10:04 INFO - 'LANGUAGE': 'en_US:en', 01:10:04 INFO - 'LOGNAME': 'cltbld', 01:10:04 INFO - 'MAIL': '/var/mail/cltbld', 01:10:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:10:04 INFO - 'MOZ_NO_REMOTE': '1', 01:10:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:10:04 INFO - 'NO_EM_RESTART': '1', 01:10:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:10:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:10:04 INFO - 'PWD': '/builds/slave/test', 01:10:04 INFO - 'SHELL': '/bin/bash', 01:10:04 INFO - 'SHLVL': '1', 01:10:04 INFO - 'TERM': 'linux', 01:10:04 INFO - 'TMOUT': '86400', 01:10:04 INFO - 'USER': 'cltbld', 01:10:04 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1463810468.905643-433997857', 01:10:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:10:04 INFO - '_': '/tools/buildbot/bin/python'} 01:10:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:10:04 INFO - Downloading/unpacking jsonschema 01:10:04 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 01:10:04 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 01:10:04 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 01:10:04 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 01:10:04 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 01:10:04 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 01:10:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:10:06 INFO - Downloading/unpacking functools32 (from jsonschema) 01:10:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:10:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:10:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:10:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:10:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:10:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:10:06 INFO - Downloading functools32-3.2.3-2.tar.gz 01:10:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:10:06 INFO - warning: no files found matching '*.txt' 01:10:06 INFO - no previously-included directories found matching 'build' 01:10:06 INFO - no previously-included directories found matching 'dist' 01:10:06 INFO - no previously-included directories found matching '.git*' 01:10:06 INFO - Installing collected packages: jsonschema, functools32 01:10:06 INFO - Running setup.py install for functools32 01:10:06 INFO - warning: no files found matching '*.txt' 01:10:06 INFO - no previously-included directories found matching 'build' 01:10:06 INFO - no previously-included directories found matching 'dist' 01:10:06 INFO - no previously-included directories found matching '.git*' 01:10:06 INFO - Successfully installed jsonschema functools32 01:10:06 INFO - Cleaning up... 01:10:06 INFO - Return code: 0 01:10:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:10:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:10:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:10:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:10:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:10:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f049fa0af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26838a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274e770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27dd9c0>, '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 0x27de8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ded50>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1463810468.905643-433997857', '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 01:10:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 01:10:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 01:10:06 INFO - Using env: {'DISPLAY': ':0', 01:10:06 INFO - 'HOME': '/home/cltbld', 01:10:06 INFO - 'LANG': 'en_US.UTF-8', 01:10:06 INFO - 'LANGUAGE': 'en_US:en', 01:10:06 INFO - 'LOGNAME': 'cltbld', 01:10:06 INFO - 'MAIL': '/var/mail/cltbld', 01:10:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:10:06 INFO - 'MOZ_NO_REMOTE': '1', 01:10:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:10:06 INFO - 'NO_EM_RESTART': '1', 01:10:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:10:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:10:06 INFO - 'PWD': '/builds/slave/test', 01:10:06 INFO - 'SHELL': '/bin/bash', 01:10:06 INFO - 'SHLVL': '1', 01:10:06 INFO - 'TERM': 'linux', 01:10:06 INFO - 'TMOUT': '86400', 01:10:06 INFO - 'USER': 'cltbld', 01:10:06 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1463810468.905643-433997857', 01:10:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:10:06 INFO - '_': '/tools/buildbot/bin/python'} 01:10:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:10:07 INFO - Downloading/unpacking flake8 01:10:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:10:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:10:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:10:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:10:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:10:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:10:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:10:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:10:09 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 01:10:09 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 01:10:09 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 01:10:09 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 01:10:09 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 01:10:09 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 01:10:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:10:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:10:09 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 01:10:09 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 01:10:09 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 01:10:09 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 01:10:09 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 01:10:09 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 01:10:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:10:09 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 01:10:09 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 01:10:09 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 01:10:09 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 01:10:09 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 01:10:09 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 01:10:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:10:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:10:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:10:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:10:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:10:09 INFO - no previously-included directories found matching 'docs/_build' 01:10:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:10:09 INFO - Running setup.py install for pep8 01:10:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:10:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:10:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:10:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:10:09 INFO - no previously-included directories found matching 'docs/_build' 01:10:09 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:10:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:10:09 INFO - Cleaning up... 01:10:10 INFO - Return code: 0 01:10:10 INFO - Running post-action listener: _resource_record_post_action 01:10:10 INFO - Running post-action listener: _start_resource_monitoring 01:10:10 INFO - Starting resource monitoring. 01:10:10 INFO - ##### 01:10:10 INFO - ##### Finished create-virtualenv step (success) 01:10:10 INFO - ##### 01:10:10 INFO - ##### 01:10:10 INFO - ##### Running install step. 01:10:10 INFO - ##### 01:10:10 INFO - Running pre-action listener: _resource_record_pre_action 01:10:10 INFO - Running main action method: install 01:10:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:10:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:10:10 INFO - Reading from file tmpfile_stdout 01:10:10 INFO - Detecting whether we're running mozinstall >=1.0... 01:10:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:10:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:10:10 INFO - Reading from file tmpfile_stdout 01:10:10 INFO - Output received: 01:10:10 INFO - Usage: mozinstall [options] installer 01:10:10 INFO - Options: 01:10:10 INFO - -h, --help show this help message and exit 01:10:10 INFO - -d DEST, --destination=DEST 01:10:10 INFO - Directory to install application into. [default: 01:10:10 INFO - "/builds/slave/test"] 01:10:10 INFO - --app=APP Application being installed. [default: firefox] 01:10:10 INFO - mkdir: /builds/slave/test/build/application 01:10:10 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'] 01:10:10 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 01:10:27 INFO - Reading from file tmpfile_stdout 01:10:27 INFO - Output received: 01:10:27 INFO - /builds/slave/test/build/application/firefox/firefox 01:10:27 INFO - Running post-action listener: _resource_record_post_action 01:10:27 INFO - ##### 01:10:27 INFO - ##### Finished install step (success) 01:10:27 INFO - ##### 01:10:27 INFO - ##### 01:10:27 INFO - ##### Running run-tests step. 01:10:27 INFO - ##### 01:10:27 INFO - Running pre-action listener: _resource_record_pre_action 01:10:27 INFO - Running main action method: run_tests 01:10:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:10:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:10:27 INFO - Python 2.7.3 01:10:27 INFO - Return code: 0 01:10:27 INFO - grabbing minidump binary from tooltool 01:10:27 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')]} 01:10:27 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 0x27dd9c0>, '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 0x27de8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ded50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:10:27 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 01:10:27 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 01:10:27 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 01:10:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:10:27 INFO - Return code: 0 01:10:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:10:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:10:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:10:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:10:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:10:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:10:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:10:28 INFO - Return code: 0 01:10:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LfxMTmTHRdGNf7cI-QM9qw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 01:10:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LfxMTmTHRdGNf7cI-QM9qw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 01:10:28 INFO - Using env: {'DISPLAY': ':0', 01:10:28 INFO - 'HOME': '/home/cltbld', 01:10:28 INFO - 'LANG': 'en_US.UTF-8', 01:10:28 INFO - 'LANGUAGE': 'en_US:en', 01:10:28 INFO - 'LOGNAME': 'cltbld', 01:10:28 INFO - 'MAIL': '/var/mail/cltbld', 01:10:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:10:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:10:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:10:28 INFO - 'MOZ_NO_REMOTE': '1', 01:10:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:10:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:10:28 INFO - 'NO_EM_RESTART': '1', 01:10:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:10:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:10:28 INFO - 'PWD': '/builds/slave/test', 01:10:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:10:28 INFO - 'SHELL': '/bin/bash', 01:10:28 INFO - 'SHLVL': '1', 01:10:28 INFO - 'TERM': 'linux', 01:10:28 INFO - 'TMOUT': '86400', 01:10:28 INFO - 'USER': 'cltbld', 01:10:28 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1463810468.905643-433997857', 01:10:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:10:28 INFO - '_': '/tools/buildbot/bin/python'} 01:10:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LfxMTmTHRdGNf7cI-QM9qw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 01:10:28 INFO - mozversion application_buildid: 20160520223041 01:10:28 INFO - mozversion application_changeset: 4bbdb484d7b89b4ebafbfa4a2ecc28a93ee21157 01:10:28 INFO - mozversion application_display_name: Nightly 01:10:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:10:28 INFO - mozversion application_name: Firefox 01:10:28 INFO - mozversion application_remotingname: firefox 01:10:28 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 01:10:28 INFO - mozversion application_vendor: Mozilla 01:10:28 INFO - mozversion application_version: 49.0a1 01:10:28 INFO - mozversion platform_buildid: 20160520223041 01:10:28 INFO - mozversion platform_changeset: 4bbdb484d7b89b4ebafbfa4a2ecc28a93ee21157 01:10:28 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 01:10:28 INFO - mozversion platform_version: 49.0a1 01:10:28 INFO - using testdate: 1463818228 01:10:28 INFO - actual date: 1463818228 01:10:28 INFO - starting webserver on 'localhost:50577' 01:10:28 INFO - SUITE-START | Running 2 tests 01:10:28 INFO - TEST-START | dromaeo_css 01:10:28 INFO - operating with platform_type : linux_ 01:10:28 INFO - Initialising browser for dromaeo_css test... 01:10:28 INFO - TEST-INFO | started process 18098 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXo_COC/profile http://localhost:50577/getInfo.html) 01:10:32 INFO - PROCESS | 18098 | __metrics Screen width/height:1600/1200 01:10:32 INFO - PROCESS | 18098 | colorDepth:24 01:10:32 INFO - PROCESS | 18098 | Browser inner width/height: 1024/697 01:10:32 INFO - PROCESS | 18098 | __metrics 01:10:33 ERROR - PROCESS | 18098 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:10:34 INFO - TEST-INFO | 18098: exit 0 01:10:34 INFO - Browser initialized. 01:10:34 INFO - Running cycle 1/1 for dromaeo_css test... 01:10:34 INFO - TEST-INFO | started process 18181 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXo_COC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:10:46 INFO - PROCESS | 18181 | RSS: Main: 153280512 01:10:46 INFO - PROCESS | 18181 | 01:11:37 INFO - PROCESS | 18181 | 1463818297211 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] 01:13:45 INFO - PROCESS | 18181 | Cycle 1(1): loaded http://localhost:50577/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50577/tests/dromaeo/cssquery-ext.html) 01:13:46 INFO - PROCESS | 18181 | RSS: Main: 255873024 01:13:46 INFO - PROCESS | 18181 | 01:16:48 INFO - PROCESS | 18181 | Cycle 1(1): loaded http://localhost:50577/tests/dromaeo/cssquery-ext.html (next: http://localhost:50577/tests/dromaeo/cssquery-jquery.html) 01:16:48 INFO - PROCESS | 18181 | RSS: Main: 238305280 01:16:48 INFO - PROCESS | 18181 | 01:19:50 INFO - PROCESS | 18181 | Cycle 1(1): loaded http://localhost:50577/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50577/tests/dromaeo/cssquery-mootools.html) 01:19:51 INFO - PROCESS | 18181 | RSS: Main: 240795648 01:19:51 INFO - PROCESS | 18181 | 01:22:53 INFO - PROCESS | 18181 | Cycle 1(1): loaded http://localhost:50577/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50577/tests/dromaeo/cssquery-prototype.html) 01:22:54 INFO - PROCESS | 18181 | RSS: Main: 230191104 01:22:54 INFO - PROCESS | 18181 | 01:25:56 INFO - PROCESS | 18181 | Cycle 1(1): loaded http://localhost:50577/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50577/tests/dromaeo/cssquery-yui.html) 01:25:57 INFO - PROCESS | 18181 | RSS: Main: 198017024 01:25:57 INFO - PROCESS | 18181 | 01:29:00 INFO - PROCESS | 18181 | Cycle 1(1): loaded http://localhost:50577/tests/dromaeo/cssquery-yui.html (next: http://localhost:50577/tests/dromaeo/cssquery-dojo.html) 01:29:00 INFO - PROCESS | 18181 | RSS: Main: 268460032 01:29:00 INFO - PROCESS | 18181 | 01:29:00 INFO - PROCESS | 18181 | __start_tp_report 01:29:00 INFO - PROCESS | 18181 | _x_x_mozilla_page_load 01:29:00 INFO - PROCESS | 18181 | _x_x_mozilla_page_load_details 01:29:00 INFO - PROCESS | 18181 | |i|pagename|runs| 01:29:00 INFO - PROCESS | 18181 | |0;dojo.html;3140.371925614877;3144.7955882867595;3157.9368412631743;3176.428242916277;3187.155403817989;5319.122344813101;5321.600879934001;5403.432639572842;5498.862528436791;5545.500904918562;5316.016536940669;5334.333208348957;5463.071277882759;5520.420355862637;5550.7224638768;4774.522547745232;4859.101066302727;4867.878303042435;4870.366852309195;5058.190689489682;4988.4762099979525;4989.750512474362;4997.275395067713;5033.823816166435;5046.142155833499;4850.611951043926;4895.828645997391;4901.926471102936;4907.754612269372;4909.68087074339;4898.706077635354;4926.4827193144565;5013.573846223076;5015.272785446126;5043.571296439807;4836.903261934742;4949.183384741514;4961.578265847407;4982.327385802906;4984.476629953839;5358;5442.210879422461;5455.18172274158;5522.171674248854;5522.723863806834;5911.201987731687;5942.554308426886;5943.167956486052;5965.761369545213;5968.46283834457;5617.045102332572;5805.129230615399;5805.36141024487;5853.795117170878;5858.736356863951;5455.208994695747;5546.69493177875;5553.750081246354;5555.138953462219;5571.164325351229;6050.696632776427;6054.246526292735;6068.949006463994;6071.058985857199;6110.938890611126;5606.859828504238;5624.71876406178;5635.943640563624;5795.333536643256;5852.092925596539;5795.971020144957;5848.064309710426;5864.149698293723;5873.060310350324;5879.2944846618675;5679.460451257124;5715.571332150105;5775.249217601685;5777.19119323295;5785.450382213683;5637.154426836008;5787.884242315215;5805.448482394166;5823.912641310384;5848.444397782204;4447.599716025573;4449.621782148553;4450.755208463501;4461.420015397977;4491.191585514639;3947.703922205846;3949.3681011038097;3973.960260397359;4013.7993100344866;4033.878983630496;5329.360476742816;5354.036273470812;5398.433164517748;5514.5864060194845;5518.530924871431;5906.822795316148;5947.167396564484;5953.613015154001;5954;6015.909761353583;5533.667979921218;5543.835794483204;5548.389677135512;5550.222968784374;5551.084071128219;4788.760561971888;4859.465458799529;4899.897523057355;4913.041956818386;4955.628327875424;6087.239095113111;6127.601705889103;6139.969300153471;6145.139680444741;6152.046432802923;5765.250517432707;5933.999999999914;5943.64338139713;5946.791862284799;5951.732172052181;5826.533877289722;5857.619254748428;5877.177195192762;5887.764489420375;5896.7936122235515;5599.664020158803;5601.719914004365;5605.103183490622;5646.237757902631;5649.971750141387;5664.461876121762;5767.307923049261;5778.913316300175;5784.884302313846;5831.79588714393;5706.714664266687;5791.47876691083;5795.1017592273265;5799.8110387371335;5840.883182336414;5704.80033198836;5744.770209191753;5747.453991870766;5761.798337058183;5771.249737534094;5389.919151212656;5597.384287728265;5637.8590535236945;5650.35020972577;5670.914936276042;5851.063829787214;5868.471837534642;5873.588848780544;5879.235699359056;5885.087811389241;5663.801766938137;5707.429257074259;5711.143328500592;5712.7714891403875;5748.741306641295 01:29:00 INFO - PROCESS | 18181 | |1;ext.html;599.4604855629932;629.4523764325037;630.1146888621488;650.5186162239944;653.7319698923441;32188;42348;42921.35617965729;43021.56978430215;43040.784796075975;43834.12331753363;44423;44768.3284750729;44922.101557968825;44925.32612010823;8601.483910965331;8808.603612837405;8815.60329785158;8815.823683526325;8825.646974121028;8601.827963440728;8699.478031318109;8720.825583488326;8743.12568743127;8749.256313213384;8621.698240561582;8671.219590236877;8762.12378762125;8796.8680469793;8821.735347939572;8692.956535217316;8776.254018408412;8781.209691127766;8785.472871627659;8788.121187881192;8579.356548258906;8707.477551346876;8715.825683486295;8717.389782715212;8723.956380218122;41333.1733365331;41729.58270417287;41732.40943496213;41815.7909210452;41848.37227441591;3554.7156227501737;3599.5860476045327;3665.065408320888;3687.9078023049638;3872.3417019106537;29956.850215749;32412.786337776175;33065.834670826494;33110.33779324424;33208.833955830305;4151.377293405983;4186.204621122008;4209.284421648327;4332.805023773938;4341.522432532419;341905;351331;351403;352200.23899880593;352430;62142.37857621456;64510.67744661341;64768;64882.675586621765;64996.07517661622;67886.32113678899;68393;68395.31604683989;68498.3150168492;68665;16765.497035088967;16935.407260745815;16974.660506789794;16980.32078716862;17005;13235;13277.800832987514;13343.599692009255;13347.799783003262;13383.53157639478;17491.23877357;20156.89921550383;20158.798412015985;20214.292499762436;20349.287774927805;6325;7249.347558719741;7650.349720273839;7747.496412733154;7768.10666773317;980.2060331131806;1057.4659796802566;1068.5779117248644;1087.526925787285;1129.390129330169;32220.19449513781;32508.512372314435;32712.512653273316;32767.50848737271;33083.17292067718;1091.165258577189;1092.6831218946575;1104.5747387255965;1159.9246049006788;1198.6284251881943;17009.659806803793;17272.395466158625;17350;17377.65244695099;17387.82612173862;554673;556702;558686;559848;560113;59315.406845930986;60576.39423605796;60643.39356606466;60749;60778.088328675105;1299.603620895636;1394.7907813828008;1411.0334420921497;1416;1422.5945605502588;30014.58862087575;34535.65464345324;34910.301793963474;34915.47626785651;34924.30151397009;52697.73651131873;53448.73275633597;53698.73150634222;53718.73140634272;53868.46131538635;468036;470565;474878;475973;476871;38512;43498.34752478652;43517.56482435135;43790.56209437865;47345.15929044269;48729.75635121802;49098.26352604642;49136;50151.74924125356;50665.493345066076;41147.38278925879;41976;42098.15803683848;42614;43288.567114328456;41138.588614113476;41241.58758412497;41507.792461037505;41781.164376712906;42413.363799542414;41731;41817.581824182584;41877;42045;42548.36177457403;35592.46611300884;37454.43818342782;38471.615283847925;38474.230515390096;39026.414603780395;28181.57727634046;28790.856045720477;28888.855555722086;29073.273168170967;29127.708722913347 01:29:00 INFO - PROCESS | 18181 | |2;jquery.html;382.47982743468884;392;395.5542492191039;396.2847061054796;410.0855093142293;14309.060655283054;17286.394976175838;18770.155343009563;19272.132754026068;19277.421677349685;15692.136932468738;18201.635967280647;18956.5260868478;18966.431007069776;19775.901120494378;5584.888302233963;5759.078547432412;5759.251297331341;5762.53899688026;5791.07342825148;4151.335786274197;5657.717114144297;5674.205611214434;5961.314448838374;6301.873962520747;6387.744490220385;6390.872182556346;6403.551751377406;6403.647799371032;6446.871062578745;6101.664408457533;6273.027680709497;6281.214848143982;6346.048092786073;6357.982722764358;5407.134858422673;5411.431799661058;5419.403865574784;5429.375621803464;6476.8704625907685;25403;25742.87128564364;25899.611505827426;26266.73733262662;26523;2332.918347857817;2454.9263522094366;2457.5084983003294;2779.916602501928;3027.3188532579993;14956.40174393023;15494.690106197813;15505.379784808594;15520.76718849207;16181.919090404472;2009.2364901337544;2012.23535056679;2119.0782009825775;2158.2841640895526;2229.921952731647;98927;99606.5019674897;100165;101383.49308253486;102875.48562257216;18173.818261817476;18175.272989080288;18179.63640727178;18266.725999110025;18526.536836579195;33385.66614333874;33598.16004599856;33712.157196069806;33794.32411351759;33872;10109.191264698806;10293.74265643365;10367.222458315657;10422.843657345145;10641.095506881848;7272.309130632581;8640;8760.95619521911;8792.208701216921;8988.146126118008;8056.516609003478;8982.191602755784;9049.954750226207;9087.318451116193;9179.58691858868;3230.660780618048;3269.836508174582;3414.573178352706;3552.3605750964557;3634.818259087035;918.169057003413;971.7084874537752;989.9158571521501;1004.5680357446369;1086.7391825961713;19054.523636909187;19229.711554326695;19272.1327540261;19274.903625482064;19875.701864472045;938.9154976052188;940.6754669638964;968.6464440479174;1019.6838979916249;1036.4247842447514;10790.622328218475;10913.945430272957;10917.454127293762;10976.780464390667;11055.944720276348;360044;482111;493577;496387;498883;99785;101835;103517;106534.46732766442;106984;1041.3439533094102;1054.678323111443;1085.2457542008228;1086.1853609792656;1087.4617064553097;17527.737083943495;17562.473125806246;17633.735493967342;17809.643807124045;18095.185716643045;38496.230075397776;42643.36034959416;42651.146977060904;43505.56494435142;44492.55507444884;58471.4152858466;59152;59272.407275926686;60923;61304.38695612987;8473.618687159216;8571.142885711379;8641.438306510057;8662;8772.210501054935;9566.426014439156;13125.01562382806;13251.469941202244;13400.396982136022;13520.323983800574;11466.713332166762;11709.648710538697;11775.587854425054;11852.762944740884;11963.940180299043;11197.328160310408;11375.26060806078;11488.368139752394;11565.595204167814;11693.415329233674;6579.342065793574;11478.540858365572;11633.243839150427;11866.821997670215;11972.820407693718;8510.574471276288;8604.913950860411;8647.510935325836;8680;8776.210141087333;11034.393108379116;11559.36423496682;11679.883201167879;11692.064634829023;11734.061275098142 01:29:00 INFO - PROCESS | 18181 | |3;mootools.html;1348.1035111650754;1532.6168457885533;1575.3226112771508;1756.8067512573614;1852.1665250637209;8772.42979206352;9157;9186.724398268047;9409.858852117224;9417.71746847594;9047.185753282203;9280.489573073479;9290.256779457644;9298.535073246327;9298.674546390877;2130.968035479469;2352.2825538210923;2405.338531903723;2439.4023464251195;2445.2297526279167;2475.344033831036;2478.913238036669;2484.3416494628937;2489.141246270043;2489.4398760278973;2374.133441293924;2386.713594368678;2395.185636883459;2404.987975060131;2408.6989126359204;2054.6609809381507;2277.453411181321;2309.0994512140196;2335.9065637374483;2359.8112151027876;2349.729781075181;2352.682387877649;2372.157883951207;2373.3591930178927;2381.9523609527887;9084;9092.909070909338;9100.089991000914;9163.129502697233;9170.81658366829;5353.57171426285;5515.751791169407;5527.447255274481;5528.06022976095;5540.86147846303;3269.623993240784;3273.6562660920736;3397.677220664033;3400.268942177419;3420.675035871588;1064.4571268652965;1133.7619099989013;1135.250734515216;1140.7889540435046;1148.5291030677465;13307.401166947413;13420.5302814402;13445.66385840352;13454.596362109152;13491.190528568219;4473.932891006638;4579.793909274091;4630.536946305342;4746.359241502422;4749.4063242094735;10313.071823535767;10333.741656458498;10341.74145646365;10352.327098738559;10359.482025898675;5180.870478237999;5222.4255331913455;5225.320708307896;5232.136697444955;5238.685678859204;4372.081862808782;4758.8572342829075;4967.875803104951;4973.452920178777;4980.228064649985;4043.9191216175514;4086.346184610448;4128.793560321972;4139.151473947833;4208.957910420918;1304.3478260869565;1314.4742103158812;1317.5849607373646;1331.2079312808862;1331.4873773597235;933.6545478173119;940.9012053734397;944.2115833279152;972.3339512434005;987.9950600247097;5791.276090488689;5825.417458254141;5904.261967254093;5988.011978023665;6037.939620603738;446.08775055012575;450.2975358440843;453.46491140454583;457.1382943152182;474.9715017098985;3952.2885880541203;4102.917941641151;4106.917861642751;4110.362893751473;4111.671066314688;11365.715857103638;11571.594994175164;11587.304761714155;11720.413979301002;11733.178677492493;11208.439578021067;11549.249298795552;11566.595169169206;11568.479418426192;11604.477798499087;8295.709650162215;8515.40392172542;8612.698555550525;8637.611307491177;8692.217700406994;5717.085266357363;5801.274840644919;5852.122181672613;5991.101334799815;6019.217501724747;10379;10664.413457259925;10711.25021248505;10773.192010599394;10777.784444311226;10617.522211500347;10676;10756.46217689128;10916.617918373136;10935.83596246073;7424.925750742424;7841.686332546634;8029.156938521604;8063.233992770677;8179.754607361789;8952.731418057469;8954.462732236087;8990.86513702308;9029.051949545203;9048.230900373543;7848.686052557834;8101.929101894301;8139.1453897339925;8204.097549269694;8287.419880608299;7901.407394445325;7972.123066462568;7976.401769867399;8095.5142691438705;8101.675932962616;7143.892841607276;7146.535475194096;7187.676554554953;7205.927940720526;7415.777526674208;5267.2889159962915;5275.973620131875;5302.469753024667;5303.575713942798;5323.787048518016;5228.163493840967;5253.343332083489;5269.525742683177;5332.706701131475;5617.101263797773 01:29:00 INFO - PROCESS | 18181 | |4;prototype.html;322.8305139801604;326.2349789743052;330.86103836388713;332.7404624392973;332.8735080669345;5280.260763493109;5291;5306.230596563496;5368.597355198356;5406.459354064592;5172.172452407615;5216.061109000379;5274.841754747355;5278.970600732859;5302.814401495948;3988.3219852625125;4005.479287692596;4110.486189226347;4118.238125946695;4136.255474014676;4091.468109145807;4094.815733291994;4118.238125946709;4122.628963393294;4124.401961715549;3898.083950271684;4061.208064427438;4068.4304197412384;4081.2857749893797;4084.83660653575;3945.4279129526344;4052.392141178832;4059.8173082211074;4068.877933661995;4081.9591804081874;3563.768355056939;3583.6416358364218;3590.174259920233;3602.3335682898746;3610.097475631092;4991.850244492671;5060.114479966028;5064.82273120439;5073.34046573943;5085.466026067246;4522.394549934758;4631.629469642454;4660.580547750718;4674.649401294916;4679.766011699401;5399.028174928511;5413.458654134594;5420;5443.863903402407;5447.727613619303;3931.2923673738715;3934.4098385242155;3936.1734035852505;3937.645611894943;3947.921041579181;5574.850209631545;5583.972080139614;5616.747246373923;5620.747066381981;5627.943720562783;3985.740926839746;4008.5590585035625;4022.6580740637373;4034.757914525138;4048.866317431065;4065.0894079782456;4106.2198182345255;4112.09533902541;4116.876493705194;4128.277551428488;4399.406080179199;4637.5130611286;4639.884002899887;4688.906221875543;4694.671373003857;5475.917861232085;5476.972615136899;5492.434656122986;5500.972495137578;5516.696581688046;1377.5191668955913;1397.8043073969652;1401.3203596255807;1410.7108042851396;1411.9833719721785;878.1438097854668;895.9562110141612;900.4687234531658;910.8952470465849;925.7407925780792;5121.103806833789;5125.513076257749;5131.538161565477;5138.794448222029;5279.868003299872;5657.632253903483;5662.405447427961;5675.120356344773;5696.686682232434;5699.857503562444;5126.820561280338;5291;5298.788048478094;5343.839684809462;5382.1119515280325;2928.5021546337175;2991.9551206731917;3000.7899447038935;3001.5347621118326;3013.9547906781418;5845.503132233808;5865.149553314831;5866.8533286667325;5883.0293001654245;5892.970535147297;5592.468715472024;5739.196512488255;5768.163616275617;5821.563382746311;5840.883182336414;5755.36690964002;5769.740361683735;5776.133579963123;5803.419658034163;5804.767809287666;5383.300170977748;5589.77640894376;5606;5622.887542249214;5669.433056694297;5558.610897237155;5567.387587365306;5582.409013431153;5585.720713964367;5591.552675785846;5827.59206855533;5868.302969129421;5918.987544234981;5923.555733319932;5936.139259807217;3570.767900086486;3658.46952191936;3677.3564626189773;3688.63113688629;3695.279420512974;4908.858330668304;4976.576990955665;4984.37695288089;5056.6207534434325;5077.7461126944245;4926.064047830901;4945.368028550498;4945.7527123644395;4950.653454258311;4965.1311020571975;4896.681715688469;4962.801487940586;5290.550303224269;5405.91881623669;5519.3652729936575;5325.627206095536;5420.83737487876;5426.457354264542;5473.28847249855;5496.5053145217125;5435.483629055233;5462.481064298885;5478.506934375925;5498.505134537911;5535.916961245504;5132.460261921334;5429.805442802577;5433.505785908907;5442.0748472760515;5476.753546090516 01:29:00 INFO - PROCESS | 18181 | |5;yui.html;796.1043825696092;823.4400607586839;825.9545724985127;826.3760860550284;835.8746188071784;14405.711885762279;14523.70952580949;14610.926945365285;14658.120512769241;14775.852241477569;13779.517716879911;13779.65550861229;13782.724345513083;13785.931070344659;13812.309384530783;674.4301065599585;781.3241546062671;785.787837283933;787.0240901282398;815.5799763121997;786.3984052200043;792.3502727763237;792.5482474989259;794.3327604811957;794.5034353529045;709.8793205155137;839.9202075802789;840.5839109640737;841.7011960753936;843.1484200957046;809.4981111710719;814.5845618734429;819.3035919468464;840.2899549880341;840.9159084091604;616.626940700874;617.1421723803916;617.9351168127326;618.6226401894841;620.3455354600894;13532.729345413036;13601.659958501017;13613.727725445435;13629.25039122848;13640.522581709693;13199.14205576644;13267.668308292274;13300;13458.596242112751;13727.862721372758;11931.284122952651;12239.20445171061;12308.734797187892;12460.190087644274;12529.373531323488;4410.713303635285;4447.110577884404;4463.709858859196;4509.413776209105;4652.534746525354;53724.462755372726;53903;54974;55328.723356383365;58413.41586584165;11010.50452729629;11021.83467247992;11055.170862185369;11493.942530287295;11567.42162891852;19615.11731972036;19658;19667.803321966883;19677.409677709693;19696.113674884666;7729.884051739228;7770.53376797394;7772.689092436352;7862.72480463181;8131.5527645978855;4601.631869450436;4630.53694630541;4689.718616882998;4712.222483290218;4786.880327991828;3301.3727391795483;3382.2389962258294;3384.2554637979606;3390.1524618845287;3391.6099648540735;471.9197736384823;622.4335854372499;646.6540400885598;658.7595527632476;677.9525433219627;706.8374273917028;732.4726197138052;741.9035525381665;747.5701471653712;765.2882818978293;9605.567749451291;9883.30816842814;9933.15568176713;9991.700248992396;10163;627.4885967936117;649.876523460541;720.3840716187689;727.1468144044301;732.2531018361242;4663.137319595886;4681;4758.484467588444;4766.571008609242;4814.9518504815205;66919.66540167268;69781.65109174422;72603.63698181475;72700.27299727041;72762;62519.6874015627;62667.686661566404;63797.36202638007;63933;64209.39476513125;55455;57329.14006289909;57702.42297577055;58220.7088964561;58342;8821.161989610977;8882.644694212158;8939.955300223457;8960.283177345927;9013.459192448474;32988.67011329952;35806.283874322886;36113.91658250257;37608.247835042595;38939.80530097331;44993.775031124635;45671.086578268914;48453.27320090272;48664.51335486741;49683.751581243305;12531.12282140278;12672.112952093265;12723;12990.675233119247;13173.287472628881;13402.597922062354;13646.24945628;14110.365033573718;14193.580641935723;14245.074070185405;9374.531273436165;10442.269041167045;12739.61781146567;13080.542181023618;13463.798043029557;12831.743365132832;12910.354482276036;12913.741725165257;12940.288284144086;13882.236476993863;13291.80062299047;13572.660683482596;13580.117292375964;13970.231637260049;14065.156090634595;11094.556217751522;11503.309801411942;11505.137114716263;11703.473343699725;11784.528618855493;11220.158488113588;11438.942805286253;11494.252873563191;11541.653750387502;11574.71063223426 01:29:00 INFO - PROCESS | 18181 | __end_tp_report 01:29:00 INFO - PROCESS | 18181 | __start_cc_report 01:29:00 INFO - PROCESS | 18181 | _x_x_mozilla_cycle_collect,900 01:29:00 INFO - PROCESS | 18181 | __end_cc_report 01:29:00 INFO - PROCESS | 18181 | __startTimestamp1463819340586__endTimestamp 01:29:00 INFO - PROCESS | 18181 | 01:29:00 INFO - PROCESS | 18181 | ------- Summary: start ------- 01:29:00 INFO - PROCESS | 18181 | Number of tests: 6 01:29:00 INFO - PROCESS | 18181 | 01:29:00 INFO - PROCESS | 18181 | [#0] dojo.html Cycles:165 Average:5420.00 Median:5624.72 stddev:628.26 (11.2%) stddev-sans-first:604.20 01:29:00 INFO - PROCESS | 18181 | Values: 3140.4 3144.8 3157.9 3176.4 3187.2 5319.1 5321.6 5403.4 5498.9 5545.5 5316.0 5334.3 5463.1 5520.4 5550.7 4774.5 4859.1 4867.9 4870.4 5058.2 4988.5 4989.8 4997.3 5033.8 5046.1 4850.6 4895.8 4901.9 4907.8 4909.7 4898.7 4926.5 5013.6 5015.3 5043.6 4836.9 4949.2 4961.6 4982.3 4984.5 5358.0 5442.2 5455.2 5522.2 5522.7 5911.2 5942.6 5943.2 5965.8 5968.5 5617.0 5805.1 5805.4 5853.8 5858.7 5455.2 5546.7 5553.8 5555.1 5571.2 6050.7 6054.2 6068.9 6071.1 6110.9 5606.9 5624.7 5635.9 5795.3 5852.1 5796.0 5848.1 5864.1 5873.1 5879.3 5679.5 5715.6 5775.2 5777.2 5785.5 5637.2 5787.9 5805.4 5823.9 5848.4 4447.6 4449.6 4450.8 4461.4 4491.2 3947.7 3949.4 3974.0 4013.8 4033.9 5329.4 5354.0 5398.4 5514.6 5518.5 5906.8 5947.2 5953.6 5954.0 6015.9 5533.7 5543.8 5548.4 5550.2 5551.1 4788.8 4859.5 4899.9 4913.0 4955.6 6087.2 6127.6 6140.0 6145.1 6152.0 5765.3 5934.0 5943.6 5946.8 5951.7 5826.5 5857.6 5877.2 5887.8 5896.8 5599.7 5601.7 5605.1 5646.2 5650.0 5664.5 5767.3 5778.9 5784.9 5831.8 5706.7 5791.5 5795.1 5799.8 5840.9 5704.8 5744.8 5747.5 5761.8 5771.2 5389.9 5597.4 5637.9 5650.4 5670.9 5851.1 5868.5 5873.6 5879.2 5885.1 5663.8 5707.4 5711.1 5712.8 5748.7 01:29:00 INFO - PROCESS | 18181 | 01:29:00 INFO - PROCESS | 18181 | [#1] ext.html Cycles:180 Average:63033.09 Median:42380.68 stddev:124199.14 (293.1%) stddev-sans-first:124459.09 01:29:00 INFO - PROCESS | 18181 | Values: 599.5 629.5 630.1 650.5 653.7 32188.0 42348.0 42921.4 43021.6 43040.8 43834.1 44423.0 44768.3 44922.1 44925.3 8601.5 8808.6 8815.6 8815.8 8825.6 8601.8 8699.5 8720.8 8743.1 8749.3 8621.7 8671.2 8762.1 8796.9 8821.7 8693.0 8776.3 8781.2 8785.5 8788.1 8579.4 8707.5 8715.8 8717.4 8724.0 41333.2 41729.6 41732.4 41815.8 41848.4 3554.7 3599.6 3665.1 3687.9 3872.3 29956.9 32412.8 33065.8 33110.3 33208.8 4151.4 4186.2 4209.3 4332.8 4341.5 341905.0 351331.0 351403.0 352200.2 352430.0 62142.4 64510.7 64768.0 64882.7 64996.1 67886.3 68393.0 68395.3 68498.3 68665.0 16765.5 16935.4 16974.7 16980.3 17005.0 13235.0 13277.8 13343.6 13347.8 13383.5 17491.2 20156.9 20158.8 20214.3 20349.3 6325.0 7249.3 7650.3 7747.5 7768.1 980.2 1057.5 1068.6 1087.5 1129.4 32220.2 32508.5 32712.5 32767.5 33083.2 1091.2 1092.7 1104.6 1159.9 1198.6 17009.7 17272.4 17350.0 17377.7 17387.8 554673.0 556702.0 558686.0 559848.0 560113.0 59315.4 60576.4 60643.4 60749.0 60778.1 1299.6 1394.8 1411.0 1416.0 1422.6 30014.6 34535.7 34910.3 34915.5 34924.3 52697.7 53448.7 53698.7 53718.7 53868.5 468036.0 470565.0 474878.0 475973.0 476871.0 38512.0 43498.3 43517.6 43790.6 47345.2 48729.8 49098.3 49136.0 50151.7 50665.5 41147.4 41976.0 42098.2 42614.0 43288.6 41138.6 41241.6 41507.8 41781.2 42413.4 41731.0 41817.6 41877.0 42045.0 42548.4 35592.5 37454.4 38471.6 38474.2 39026.4 28181.6 28790.9 28888.9 29073.3 29127.7 01:29:00 INFO - PROCESS | 18181 | 01:29:00 INFO - PROCESS | 18181 | [#2] jquery.html Cycles:180 Average:30401.11 Median:26394.87 stddev:78093.39 (295.9%) stddev-sans-first:78279.93 01:29:00 INFO - PROCESS | 18181 | Values: 382.5 392.0 395.6 396.3 410.1 14309.1 17286.4 18770.2 19272.1 19277.4 15692.1 18201.6 18956.5 18966.4 19775.9 5584.9 5759.1 5759.3 5762.5 5791.1 4151.3 5657.7 5674.2 5961.3 6301.9 6387.7 6390.9 6403.6 6403.6 6446.9 6101.7 6273.0 6281.2 6346.0 6358.0 5407.1 5411.4 5419.4 5429.4 6476.9 25403.0 25742.9 25899.6 26266.7 26523.0 2332.9 2454.9 2457.5 2779.9 3027.3 14956.4 15494.7 15505.4 15520.8 16181.9 2009.2 2012.2 2119.1 2158.3 2229.9 98927.0 99606.5 100165.0 101383.5 102875.5 18173.8 18175.3 18179.6 18266.7 18526.5 33385.7 33598.2 33712.2 33794.3 33872.0 10109.2 10293.7 10367.2 10422.8 10641.1 7272.3 8640.0 8761.0 8792.2 8988.1 8056.5 8982.2 9050.0 9087.3 9179.6 3230.7 3269.8 3414.6 3552.4 3634.8 918.2 971.7 989.9 1004.6 1086.7 19054.5 19229.7 19272.1 19274.9 19875.7 938.9 940.7 968.6 1019.7 1036.4 10790.6 10913.9 10917.5 10976.8 11055.9 360044.0 482111.0 493577.0 496387.0 498883.0 99785.0 101835.0 103517.0 106534.5 106984.0 1041.3 1054.7 1085.2 1086.2 1087.5 17527.7 17562.5 17633.7 17809.6 18095.2 38496.2 42643.4 42651.1 43505.6 44492.6 58471.4 59152.0 59272.4 60923.0 61304.4 8473.6 8571.1 8641.4 8662.0 8772.2 9566.4 13125.0 13251.5 13400.4 13520.3 11466.7 11709.6 11775.6 11852.8 11963.9 11197.3 11375.3 11488.4 11565.6 11693.4 6579.3 11478.5 11633.2 11866.8 11972.8 8510.6 8604.9 8647.5 8680.0 8776.2 11034.4 11559.4 11679.9 11692.1 11734.1 01:29:00 INFO - PROCESS | 18181 | 01:29:00 INFO - PROCESS | 18181 | [#3] mootools.html Cycles:180 Average:6003.31 Median:2518.47 stddev:3530.89 (140.2%) stddev-sans-first:3523.47 01:29:00 INFO - PROCESS | 18181 | Values: 1348.1 1532.6 1575.3 1756.8 1852.2 8772.4 9157.0 9186.7 9409.9 9417.7 9047.2 9280.5 9290.3 9298.5 9298.7 2131.0 2352.3 2405.3 2439.4 2445.2 2475.3 2478.9 2484.3 2489.1 2489.4 2374.1 2386.7 2395.2 2405.0 2408.7 2054.7 2277.5 2309.1 2335.9 2359.8 2349.7 2352.7 2372.2 2373.4 2382.0 9084.0 9092.9 9100.1 9163.1 9170.8 5353.6 5515.8 5527.4 5528.1 5540.9 3269.6 3273.7 3397.7 3400.3 3420.7 1064.5 1133.8 1135.3 1140.8 1148.5 13307.4 13420.5 13445.7 13454.6 13491.2 4473.9 4579.8 4630.5 4746.4 4749.4 10313.1 10333.7 10341.7 10352.3 10359.5 5180.9 5222.4 5225.3 5232.1 5238.7 4372.1 4758.9 4967.9 4973.5 4980.2 4043.9 4086.3 4128.8 4139.2 4209.0 1304.3 1314.5 1317.6 1331.2 1331.5 933.7 940.9 944.2 972.3 988.0 5791.3 5825.4 5904.3 5988.0 6037.9 446.1 450.3 453.5 457.1 475.0 3952.3 4102.9 4106.9 4110.4 4111.7 11365.7 11571.6 11587.3 11720.4 11733.2 11208.4 11549.2 11566.6 11568.5 11604.5 8295.7 8515.4 8612.7 8637.6 8692.2 5717.1 5801.3 5852.1 5991.1 6019.2 10379.0 10664.4 10711.3 10773.2 10777.8 10617.5 10676.0 10756.5 10916.6 10935.8 7424.9 7841.7 8029.2 8063.2 8179.8 8952.7 8954.5 8990.9 9029.1 9048.2 7848.7 8101.9 8139.1 8204.1 8287.4 7901.4 7972.1 7976.4 8095.5 8101.7 7143.9 7146.5 7187.7 7205.9 7415.8 5267.3 5276.0 5302.5 5303.6 5323.8 5228.2 5253.3 5269.5 5332.7 5617.1 01:29:00 INFO - PROCESS | 18181 | 01:29:00 INFO - PROCESS | 18181 | [#4] prototype.html Cycles:180 Average:4573.03 Median:5132.00 stddev:1349.66 (26.3%) stddev-sans-first:1315.21 01:29:00 INFO - PROCESS | 18181 | Values: 322.8 326.2 330.9 332.7 332.9 5280.3 5291.0 5306.2 5368.6 5406.5 5172.2 5216.1 5274.8 5279.0 5302.8 3988.3 4005.5 4110.5 4118.2 4136.3 4091.5 4094.8 4118.2 4122.6 4124.4 3898.1 4061.2 4068.4 4081.3 4084.8 3945.4 4052.4 4059.8 4068.9 4082.0 3563.8 3583.6 3590.2 3602.3 3610.1 4991.9 5060.1 5064.8 5073.3 5085.5 4522.4 4631.6 4660.6 4674.6 4679.8 5399.0 5413.5 5420.0 5443.9 5447.7 3931.3 3934.4 3936.2 3937.6 3947.9 5574.9 5584.0 5616.7 5620.7 5627.9 3985.7 4008.6 4022.7 4034.8 4048.9 4065.1 4106.2 4112.1 4116.9 4128.3 4399.4 4637.5 4639.9 4688.9 4694.7 5475.9 5477.0 5492.4 5501.0 5516.7 1377.5 1397.8 1401.3 1410.7 1412.0 878.1 896.0 900.5 910.9 925.7 5121.1 5125.5 5131.5 5138.8 5279.9 5657.6 5662.4 5675.1 5696.7 5699.9 5126.8 5291.0 5298.8 5343.8 5382.1 2928.5 2992.0 3000.8 3001.5 3014.0 5845.5 5865.1 5866.9 5883.0 5893.0 5592.5 5739.2 5768.2 5821.6 5840.9 5755.4 5769.7 5776.1 5803.4 5804.8 5383.3 5589.8 5606.0 5622.9 5669.4 5558.6 5567.4 5582.4 5585.7 5591.6 5827.6 5868.3 5919.0 5923.6 5936.1 3570.8 3658.5 3677.4 3688.6 3695.3 4908.9 4976.6 4984.4 5056.6 5077.7 4926.1 4945.4 4945.8 4950.7 4965.1 4896.7 4962.8 5290.6 5405.9 5519.4 5325.6 5420.8 5426.5 5473.3 5496.5 5435.5 5462.5 5478.5 5498.5 5535.9 5132.5 5429.8 5433.5 5442.1 5476.8 01:29:00 INFO - PROCESS | 18181 | 01:29:00 INFO - PROCESS | 18181 | [#5] yui.html Cycles:180 Average:15788.71 Median:4685.36 stddev:18981.94 (405.1%) stddev-sans-first:19001.80 01:29:00 INFO - PROCESS | 18181 | Values: 796.1 823.4 826.0 826.4 835.9 14405.7 14523.7 14610.9 14658.1 14775.9 13779.5 13779.7 13782.7 13785.9 13812.3 674.4 781.3 785.8 787.0 815.6 786.4 792.4 792.5 794.3 794.5 709.9 839.9 840.6 841.7 843.1 809.5 814.6 819.3 840.3 840.9 616.6 617.1 617.9 618.6 620.3 13532.7 13601.7 13613.7 13629.3 13640.5 13199.1 13267.7 13300.0 13458.6 13727.9 11931.3 12239.2 12308.7 12460.2 12529.4 4410.7 4447.1 4463.7 4509.4 4652.5 53724.5 53903.0 54974.0 55328.7 58413.4 11010.5 11021.8 11055.2 11493.9 11567.4 19615.1 19658.0 19667.8 19677.4 19696.1 7729.9 7770.5 7772.7 7862.7 8131.6 4601.6 4630.5 4689.7 4712.2 4786.9 3301.4 3382.2 3384.3 3390.2 3391.6 471.9 622.4 646.7 658.8 678.0 706.8 732.5 741.9 747.6 765.3 9605.6 9883.3 9933.2 9991.7 10163.0 627.5 649.9 720.4 727.1 732.3 4663.1 4681.0 4758.5 4766.6 4815.0 66919.7 69781.7 72603.6 72700.3 72762.0 62519.7 62667.7 63797.4 63933.0 64209.4 55455.0 57329.1 57702.4 58220.7 58342.0 8821.2 8882.6 8940.0 8960.3 9013.5 32988.7 35806.3 36113.9 37608.2 38939.8 44993.8 45671.1 48453.3 48664.5 49683.8 12531.1 12672.1 12723.0 12990.7 13173.3 13402.6 13646.2 14110.4 14193.6 14245.1 9374.5 10442.3 12739.6 13080.5 13463.8 12831.7 12910.4 12913.7 12940.3 13882.2 13291.8 13572.7 13580.1 13970.2 14065.2 11094.6 11503.3 11505.1 11703.5 11784.5 11220.2 11438.9 11494.3 11541.7 11574.7 01:29:00 INFO - PROCESS | 18181 | -------- Summary: end -------- 01:29:00 INFO - PROCESS | 18181 | 01:29:01 INFO - TEST-INFO | 18181: exit 0 01:29:01 INFO - TEST-OK | dromaeo_css | took 1113061ms 01:29:01 INFO - TEST-START | kraken 01:29:01 INFO - operating with platform_type : linux_ 01:29:01 INFO - Initialising browser for kraken test... 01:29:01 INFO - TEST-INFO | started process 18363 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz2oOnW/profile http://localhost:50577/getInfo.html) 01:29:04 INFO - PROCESS | 18363 | __metrics Screen width/height:1600/1200 01:29:04 INFO - PROCESS | 18363 | colorDepth:24 01:29:04 INFO - PROCESS | 18363 | Browser inner width/height: 1024/697 01:29:04 INFO - PROCESS | 18363 | __metrics 01:29:05 ERROR - PROCESS | 18363 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:29:06 INFO - TEST-INFO | 18363: exit 0 01:29:06 INFO - Browser initialized. 01:29:06 INFO - Running cycle 1/1 for kraken test... 01:29:06 INFO - TEST-INFO | started process 18444 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz2oOnW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:29:18 INFO - PROCESS | 18444 | RSS: Main: 152985600 01:29:18 INFO - PROCESS | 18444 | 01:29:21 INFO - PROCESS | 18444 | Cycle 1(1): loaded http://localhost:50577/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50577/tests/kraken/driver.html?testName=audio-beat-detection) 01:29:22 INFO - PROCESS | 18444 | RSS: Main: 209534976 01:29:22 INFO - PROCESS | 18444 | 01:29:24 INFO - PROCESS | 18444 | Cycle 1(1): loaded http://localhost:50577/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50577/tests/kraken/driver.html?testName=audio-dft) 01:29:25 INFO - PROCESS | 18444 | RSS: Main: 196960256 01:29:25 INFO - PROCESS | 18444 | 01:29:28 INFO - PROCESS | 18444 | Cycle 1(1): loaded http://localhost:50577/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50577/tests/kraken/driver.html?testName=audio-fft) 01:29:29 INFO - PROCESS | 18444 | RSS: Main: 265764864 01:29:29 INFO - PROCESS | 18444 | 01:29:31 INFO - PROCESS | 18444 | Cycle 1(1): loaded http://localhost:50577/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50577/tests/kraken/driver.html?testName=audio-oscillator) 01:29:32 INFO - PROCESS | 18444 | RSS: Main: 174641152 01:29:32 INFO - PROCESS | 18444 | 01:29:34 INFO - PROCESS | 18444 | Cycle 1(1): loaded http://localhost:50577/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50577/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:29:34 INFO - PROCESS | 18444 | RSS: Main: 179630080 01:29:34 INFO - PROCESS | 18444 | 01:29:38 INFO - PROCESS | 18444 | Cycle 1(1): loaded http://localhost:50577/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50577/tests/kraken/driver.html?testName=imaging-darkroom) 01:29:38 INFO - PROCESS | 18444 | RSS: Main: 215072768 01:29:38 INFO - PROCESS | 18444 | 01:29:42 INFO - PROCESS | 18444 | Cycle 1(1): loaded http://localhost:50577/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50577/tests/kraken/driver.html?testName=imaging-desaturate) 01:29:43 INFO - PROCESS | 18444 | RSS: Main: 213938176 01:29:43 INFO - PROCESS | 18444 | 01:29:45 INFO - PROCESS | 18444 | Cycle 1(1): loaded http://localhost:50577/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50577/tests/kraken/driver.html?testName=json-parse-financial) 01:29:46 INFO - PROCESS | 18444 | RSS: Main: 214269952 01:29:46 INFO - PROCESS | 18444 | 01:29:48 INFO - PROCESS | 18444 | Cycle 1(1): loaded http://localhost:50577/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50577/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:29:48 INFO - PROCESS | 18444 | RSS: Main: 202973184 01:29:48 INFO - PROCESS | 18444 | 01:29:50 INFO - PROCESS | 18444 | Cycle 1(1): loaded http://localhost:50577/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50577/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:29:51 INFO - PROCESS | 18444 | RSS: Main: 206983168 01:29:51 INFO - PROCESS | 18444 | 01:29:53 INFO - PROCESS | 18444 | Cycle 1(1): loaded http://localhost:50577/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50577/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:29:54 INFO - PROCESS | 18444 | RSS: Main: 217124864 01:29:54 INFO - PROCESS | 18444 | 01:29:56 INFO - PROCESS | 18444 | Cycle 1(1): loaded http://localhost:50577/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50577/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:29:57 INFO - PROCESS | 18444 | RSS: Main: 223862784 01:29:57 INFO - PROCESS | 18444 | 01:30:00 INFO - PROCESS | 18444 | Cycle 1(1): loaded http://localhost:50577/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50577/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:30:00 INFO - PROCESS | 18444 | RSS: Main: 220336128 01:30:00 INFO - PROCESS | 18444 | 01:30:02 INFO - PROCESS | 18444 | Cycle 1(1): loaded http://localhost:50577/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50577/tests/kraken/driver.html?testName=ai-astar) 01:30:02 INFO - PROCESS | 18444 | RSS: Main: 266125312 01:30:02 INFO - PROCESS | 18444 | 01:30:02 INFO - PROCESS | 18444 | __start_tp_report 01:30:02 INFO - PROCESS | 18444 | _x_x_mozilla_page_load 01:30:02 INFO - PROCESS | 18444 | _x_x_mozilla_page_load_details 01:30:02 INFO - PROCESS | 18444 | |i|pagename|runs| 01:30:02 INFO - PROCESS | 18444 | |0;ai-astar;113;106;112;110;109;112;109;110;110;109 01:30:02 INFO - PROCESS | 18444 | |1;audio-beat-detection;163;128;126;215;126;135;156;125;185;125 01:30:02 INFO - PROCESS | 18444 | |2;audio-dft;165;163;161;161;163;163;162;162;163;161 01:30:02 INFO - PROCESS | 18444 | |3;audio-fft;75;77;74;139;74;78;76;76;115;75 01:30:02 INFO - PROCESS | 18444 | |4;audio-oscillator;93;92;160;92;93;95;133;92;92;136 01:30:02 INFO - PROCESS | 18444 | |5;imaging-gaussian-blur;117;117;118;117;117;117;117;117;116;117 01:30:02 INFO - PROCESS | 18444 | |6;imaging-darkroom;147;146;147;145;146;145;146;146;146;145 01:30:02 INFO - PROCESS | 18444 | |7;imaging-desaturate;95;94;96;97;95;95;95;94;94;95 01:30:02 INFO - PROCESS | 18444 | |8;json-parse-financial;56;54;55;56;56;54;57;109;52;53 01:30:02 INFO - PROCESS | 18444 | |9;json-stringify-tinderbox;62;62;61;62;62;62;70;63;62;63 01:30:02 INFO - PROCESS | 18444 | |10;stanford-crypto-aes;79;80;78;79;79;80;79;80;80;80 01:30:02 INFO - PROCESS | 18444 | |11;stanford-crypto-ccm;123;126;132;118;120;129;134;120;192;135 01:30:02 INFO - PROCESS | 18444 | |12;stanford-crypto-pbkdf2;163;162;159;163;159;161;162;160;162;160 01:30:02 INFO - PROCESS | 18444 | |13;stanford-crypto-sha256-iterative;67;64;64;63;62;62;64;62;61;63 01:30:02 INFO - PROCESS | 18444 | __end_tp_report 01:30:02 INFO - PROCESS | 18444 | __start_cc_report 01:30:02 INFO - PROCESS | 18444 | _x_x_mozilla_cycle_collect,1893 01:30:02 INFO - PROCESS | 18444 | __end_cc_report 01:30:02 INFO - PROCESS | 18444 | __startTimestamp1463819402688__endTimestamp 01:30:02 INFO - PROCESS | 18444 | 01:30:02 INFO - PROCESS | 18444 | ------- Summary: start ------- 01:30:02 INFO - PROCESS | 18444 | Number of tests: 14 01:30:02 INFO - PROCESS | 18444 | 01:30:02 INFO - PROCESS | 18444 | [#0] ai-astar Cycles:10 Average:110.00 Median:110.00 stddev:2.00 (1.8%) stddev-sans-first:1.80 01:30:02 INFO - PROCESS | 18444 | Values: 113.0 106.0 112.0 110.0 109.0 112.0 109.0 110.0 110.0 109.0 01:30:02 INFO - PROCESS | 18444 | 01:30:02 INFO - PROCESS | 18444 | [#1] audio-beat-detection Cycles:10 Average:148.40 Median:145.50 stddev:31.16 (21.4%) stddev-sans-first:32.60 01:30:02 INFO - PROCESS | 18444 | Values: 163.0 128.0 126.0 215.0 126.0 135.0 156.0 125.0 185.0 125.0 01:30:02 INFO - PROCESS | 18444 | 01:30:02 INFO - PROCESS | 18444 | [#2] audio-dft Cycles:10 Average:162.40 Median:163.00 stddev:1.26 (0.8%) stddev-sans-first:0.93 01:30:02 INFO - PROCESS | 18444 | Values: 165.0 163.0 161.0 161.0 163.0 163.0 162.0 162.0 163.0 161.0 01:30:02 INFO - PROCESS | 18444 | 01:30:02 INFO - PROCESS | 18444 | [#3] audio-fft Cycles:10 Average:85.90 Median:75.50 stddev:22.42 (29.7%) stddev-sans-first:23.43 01:30:02 INFO - PROCESS | 18444 | Values: 75.0 77.0 74.0 139.0 74.0 78.0 76.0 76.0 115.0 75.0 01:30:02 INFO - PROCESS | 18444 | 01:30:02 INFO - PROCESS | 18444 | [#4] audio-oscillator Cycles:10 Average:107.80 Median:92.00 stddev:25.29 (27.5%) stddev-sans-first:26.25 01:30:02 INFO - PROCESS | 18444 | Values: 93.0 92.0 160.0 92.0 93.0 95.0 133.0 92.0 92.0 136.0 01:30:02 INFO - PROCESS | 18444 | 01:30:02 INFO - PROCESS | 18444 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 01:30:02 INFO - PROCESS | 18444 | Values: 117.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 01:30:02 INFO - PROCESS | 18444 | 01:30:02 INFO - PROCESS | 18444 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 01:30:02 INFO - PROCESS | 18444 | Values: 147.0 146.0 147.0 145.0 146.0 145.0 146.0 146.0 146.0 145.0 01:30:02 INFO - PROCESS | 18444 | 01:30:02 INFO - PROCESS | 18444 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.94 (1.0%) stddev-sans-first:1.00 01:30:02 INFO - PROCESS | 18444 | Values: 95.0 94.0 96.0 97.0 95.0 95.0 95.0 94.0 94.0 95.0 01:30:02 INFO - PROCESS | 18444 | 01:30:02 INFO - PROCESS | 18444 | [#8] json-parse-financial Cycles:10 Average:60.20 Median:55.50 stddev:17.22 (31.0%) stddev-sans-first:18.19 01:30:02 INFO - PROCESS | 18444 | Values: 56.0 54.0 55.0 56.0 56.0 54.0 57.0 109.0 52.0 53.0 01:30:02 INFO - PROCESS | 18444 | 01:30:02 INFO - PROCESS | 18444 | [#9] json-stringify-tinderbox Cycles:10 Average:62.90 Median:62.00 stddev:2.56 (4.1%) stddev-sans-first:2.69 01:30:02 INFO - PROCESS | 18444 | Values: 62.0 62.0 61.0 62.0 62.0 62.0 70.0 63.0 62.0 63.0 01:30:02 INFO - PROCESS | 18444 | 01:30:02 INFO - PROCESS | 18444 | [#10] stanford-crypto-aes Cycles:10 Average:79.40 Median:80.00 stddev:0.70 (0.9%) stddev-sans-first:0.73 01:30:02 INFO - PROCESS | 18444 | Values: 79.0 80.0 78.0 79.0 79.0 80.0 79.0 80.0 80.0 80.0 01:30:02 INFO - PROCESS | 18444 | 01:30:02 INFO - PROCESS | 18444 | [#11] stanford-crypto-ccm Cycles:10 Average:132.90 Median:130.50 stddev:21.64 (16.6%) stddev-sans-first:22.66 01:30:02 INFO - PROCESS | 18444 | Values: 123.0 126.0 132.0 118.0 120.0 129.0 134.0 120.0 192.0 135.0 01:30:02 INFO - PROCESS | 18444 | 01:30:02 INFO - PROCESS | 18444 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.10 Median:162.00 stddev:1.52 (0.9%) stddev-sans-first:1.45 01:30:02 INFO - PROCESS | 18444 | Values: 163.0 162.0 159.0 163.0 159.0 161.0 162.0 160.0 162.0 160.0 01:30:02 INFO - PROCESS | 18444 | 01:30:02 INFO - PROCESS | 18444 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:63.50 stddev:1.69 (2.7%) stddev-sans-first:1.09 01:30:02 INFO - PROCESS | 18444 | Values: 67.0 64.0 64.0 63.0 62.0 62.0 64.0 62.0 61.0 63.0 01:30:02 INFO - PROCESS | 18444 | -------- Summary: end -------- 01:30:02 INFO - PROCESS | 18444 | 01:30:03 INFO - TEST-INFO | 18444: exit 0 01:30:03 INFO - TEST-OK | kraken | took 62410ms 01:30:03 INFO - SUITE-END | took 1175s 01:30:03 INFO - Completed test suite (00:19:35) 01:30:03 INFO - javascript benchmark 01:30:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3140.371925614877, 3144.7955882867595, 3157.9368412631743, 3176.428242916277, 3187.155403817989, 5319.122344813101, 5321.600879934001, 5403.432639572842, 5498.862528436791, 5545.500904918562, 5316.016536940669, 5334.333208348957, 5463.071277882759, 5520.420355862637, 5550.7224638768, 4774.522547745232, 4859.101066302727, 4867.878303042435, 4870.366852309195, 5058.190689489682, 4988.4762099979525, 4989.750512474362, 4997.275395067713, 5033.823816166435, 5046.142155833499, 4850.611951043926, 4895.828645997391, 4901.926471102936, 4907.754612269372, 4909.68087074339, 4898.706077635354, 4926.4827193144565, 5013.573846223076, 5015.272785446126, 5043.571296439807, 4836.903261934742, 4949.183384741514, 4961.578265847407, 4982.327385802906, 4984.476629953839, 5358.0, 5442.210879422461, 5455.18172274158, 5522.171674248854, 5522.723863806834, 5911.201987731687, 5942.554308426886, 5943.167956486052, 5965.761369545213, 5968.46283834457, 5617.045102332572, 5805.129230615399, 5805.36141024487, 5853.795117170878, 5858.736356863951, 5455.208994695747, 5546.69493177875, 5553.750081246354, 5555.138953462219, 5571.164325351229, 6050.696632776427, 6054.246526292735, 6068.949006463994, 6071.058985857199, 6110.938890611126, 5606.859828504238, 5624.71876406178, 5635.943640563624, 5795.333536643256, 5852.092925596539, 5795.971020144957, 5848.064309710426, 5864.149698293723, 5873.060310350324, 5879.2944846618675, 5679.460451257124, 5715.571332150105, 5775.249217601685, 5777.19119323295, 5785.450382213683, 5637.154426836008, 5787.884242315215, 5805.448482394166, 5823.912641310384, 5848.444397782204, 4447.599716025573, 4449.621782148553, 4450.755208463501, 4461.420015397977, 4491.191585514639, 3947.703922205846, 3949.3681011038097, 3973.960260397359, 4013.7993100344866, 4033.878983630496, 5329.360476742816, 5354.036273470812, 5398.433164517748, 5514.5864060194845, 5518.530924871431, 5906.822795316148, 5947.167396564484, 5953.613015154001, 5954.0, 6015.909761353583, 5533.667979921218, 5543.835794483204, 5548.389677135512, 5550.222968784374, 5551.084071128219, 4788.760561971888, 4859.465458799529, 4899.897523057355, 4913.041956818386, 4955.628327875424, 6087.239095113111, 6127.601705889103, 6139.969300153471, 6145.139680444741, 6152.046432802923, 5765.250517432707, 5933.999999999914, 5943.64338139713, 5946.791862284799, 5951.732172052181, 5826.533877289722, 5857.619254748428, 5877.177195192762, 5887.764489420375, 5896.7936122235515, 5599.664020158803, 5601.719914004365, 5605.103183490622, 5646.237757902631, 5649.971750141387, 5664.461876121762, 5767.307923049261, 5778.913316300175, 5784.884302313846, 5831.79588714393, 5706.714664266687, 5791.47876691083, 5795.1017592273265, 5799.8110387371335, 5840.883182336414, 5704.80033198836, 5744.770209191753, 5747.453991870766, 5761.798337058183, 5771.249737534094, 5389.919151212656, 5597.384287728265, 5637.8590535236945, 5650.35020972577, 5670.914936276042, 5851.063829787214, 5868.471837534642, 5873.588848780544, 5879.235699359056, 5885.087811389241, 5663.801766938137, 5707.429257074259, 5711.143328500592, 5712.7714891403875, 5748.741306641295], "value": 5377.073007645157, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.4604855629932, 629.4523764325037, 630.1146888621488, 650.5186162239944, 653.7319698923441, 32188.0, 42348.0, 42921.35617965729, 43021.56978430215, 43040.784796075975, 43834.12331753363, 44423.0, 44768.3284750729, 44922.101557968825, 44925.32612010823, 8601.483910965331, 8808.603612837405, 8815.60329785158, 8815.823683526325, 8825.646974121028, 8601.827963440728, 8699.478031318109, 8720.825583488326, 8743.12568743127, 8749.256313213384, 8621.698240561582, 8671.219590236877, 8762.12378762125, 8796.8680469793, 8821.735347939572, 8692.956535217316, 8776.254018408412, 8781.209691127766, 8785.472871627659, 8788.121187881192, 8579.356548258906, 8707.477551346876, 8715.825683486295, 8717.389782715212, 8723.956380218122, 41333.1733365331, 41729.58270417287, 41732.40943496213, 41815.7909210452, 41848.37227441591, 3554.7156227501737, 3599.5860476045327, 3665.065408320888, 3687.9078023049638, 3872.3417019106537, 29956.850215749, 32412.786337776175, 33065.834670826494, 33110.33779324424, 33208.833955830305, 4151.377293405983, 4186.204621122008, 4209.284421648327, 4332.805023773938, 4341.522432532419, 341905.0, 351331.0, 351403.0, 352200.23899880593, 352430.0, 62142.37857621456, 64510.67744661341, 64768.0, 64882.675586621765, 64996.07517661622, 67886.32113678899, 68393.0, 68395.31604683989, 68498.3150168492, 68665.0, 16765.497035088967, 16935.407260745815, 16974.660506789794, 16980.32078716862, 17005.0, 13235.0, 13277.800832987514, 13343.599692009255, 13347.799783003262, 13383.53157639478, 17491.23877357, 20156.89921550383, 20158.798412015985, 20214.292499762436, 20349.287774927805, 6325.0, 7249.347558719741, 7650.349720273839, 7747.496412733154, 7768.10666773317, 980.2060331131806, 1057.4659796802566, 1068.5779117248644, 1087.526925787285, 1129.390129330169, 32220.19449513781, 32508.512372314435, 32712.512653273316, 32767.50848737271, 33083.17292067718, 1091.165258577189, 1092.6831218946575, 1104.5747387255965, 1159.9246049006788, 1198.6284251881943, 17009.659806803793, 17272.395466158625, 17350.0, 17377.65244695099, 17387.82612173862, 554673.0, 556702.0, 558686.0, 559848.0, 560113.0, 59315.406845930986, 60576.39423605796, 60643.39356606466, 60749.0, 60778.088328675105, 1299.603620895636, 1394.7907813828008, 1411.0334420921497, 1416.0, 1422.5945605502588, 30014.58862087575, 34535.65464345324, 34910.301793963474, 34915.47626785651, 34924.30151397009, 52697.73651131873, 53448.73275633597, 53698.73150634222, 53718.73140634272, 53868.46131538635, 468036.0, 470565.0, 474878.0, 475973.0, 476871.0, 38512.0, 43498.34752478652, 43517.56482435135, 43790.56209437865, 47345.15929044269, 48729.75635121802, 49098.26352604642, 49136.0, 50151.74924125356, 50665.493345066076, 41147.38278925879, 41976.0, 42098.15803683848, 42614.0, 43288.567114328456, 41138.588614113476, 41241.58758412497, 41507.792461037505, 41781.164376712906, 42413.363799542414, 41731.0, 41817.581824182584, 41877.0, 42045.0, 42548.36177457403, 35592.46611300884, 37454.43818342782, 38471.615283847925, 38474.230515390096, 39026.414603780395, 28181.57727634046, 28790.856045720477, 28888.855555722086, 29073.273168170967, 29127.708722913347], "value": 20816.502376897864, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.47982743468884, 392.0, 395.5542492191039, 396.2847061054796, 410.0855093142293, 14309.060655283054, 17286.394976175838, 18770.155343009563, 19272.132754026068, 19277.421677349685, 15692.136932468738, 18201.635967280647, 18956.5260868478, 18966.431007069776, 19775.901120494378, 5584.888302233963, 5759.078547432412, 5759.251297331341, 5762.53899688026, 5791.07342825148, 4151.335786274197, 5657.717114144297, 5674.205611214434, 5961.314448838374, 6301.873962520747, 6387.744490220385, 6390.872182556346, 6403.551751377406, 6403.647799371032, 6446.871062578745, 6101.664408457533, 6273.027680709497, 6281.214848143982, 6346.048092786073, 6357.982722764358, 5407.134858422673, 5411.431799661058, 5419.403865574784, 5429.375621803464, 6476.8704625907685, 25403.0, 25742.87128564364, 25899.611505827426, 26266.73733262662, 26523.0, 2332.918347857817, 2454.9263522094366, 2457.5084983003294, 2779.916602501928, 3027.3188532579993, 14956.40174393023, 15494.690106197813, 15505.379784808594, 15520.76718849207, 16181.919090404472, 2009.2364901337544, 2012.23535056679, 2119.0782009825775, 2158.2841640895526, 2229.921952731647, 98927.0, 99606.5019674897, 100165.0, 101383.49308253486, 102875.48562257216, 18173.818261817476, 18175.272989080288, 18179.63640727178, 18266.725999110025, 18526.536836579195, 33385.66614333874, 33598.16004599856, 33712.157196069806, 33794.32411351759, 33872.0, 10109.191264698806, 10293.74265643365, 10367.222458315657, 10422.843657345145, 10641.095506881848, 7272.309130632581, 8640.0, 8760.95619521911, 8792.208701216921, 8988.146126118008, 8056.516609003478, 8982.191602755784, 9049.954750226207, 9087.318451116193, 9179.58691858868, 3230.660780618048, 3269.836508174582, 3414.573178352706, 3552.3605750964557, 3634.818259087035, 918.169057003413, 971.7084874537752, 989.9158571521501, 1004.5680357446369, 1086.7391825961713, 19054.523636909187, 19229.711554326695, 19272.1327540261, 19274.903625482064, 19875.701864472045, 938.9154976052188, 940.6754669638964, 968.6464440479174, 1019.6838979916249, 1036.4247842447514, 10790.622328218475, 10913.945430272957, 10917.454127293762, 10976.780464390667, 11055.944720276348, 360044.0, 482111.0, 493577.0, 496387.0, 498883.0, 99785.0, 101835.0, 103517.0, 106534.46732766442, 106984.0, 1041.3439533094102, 1054.678323111443, 1085.2457542008228, 1086.1853609792656, 1087.4617064553097, 17527.737083943495, 17562.473125806246, 17633.735493967342, 17809.643807124045, 18095.185716643045, 38496.230075397776, 42643.36034959416, 42651.146977060904, 43505.56494435142, 44492.55507444884, 58471.4152858466, 59152.0, 59272.407275926686, 60923.0, 61304.38695612987, 8473.618687159216, 8571.142885711379, 8641.438306510057, 8662.0, 8772.210501054935, 9566.426014439156, 13125.01562382806, 13251.469941202244, 13400.396982136022, 13520.323983800574, 11466.713332166762, 11709.648710538697, 11775.587854425054, 11852.762944740884, 11963.940180299043, 11197.328160310408, 11375.26060806078, 11488.368139752394, 11565.595204167814, 11693.415329233674, 6579.342065793574, 11478.540858365572, 11633.243839150427, 11866.821997670215, 11972.820407693718, 8510.574471276288, 8604.913950860411, 8647.510935325836, 8680.0, 8776.210141087333, 11034.393108379116, 11559.36423496682, 11679.883201167879, 11692.064634829023, 11734.061275098142], "value": 10263.827725442363, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1348.1035111650754, 1532.6168457885533, 1575.3226112771508, 1756.8067512573614, 1852.1665250637209, 8772.42979206352, 9157.0, 9186.724398268047, 9409.858852117224, 9417.71746847594, 9047.185753282203, 9280.489573073479, 9290.256779457644, 9298.535073246327, 9298.674546390877, 2130.968035479469, 2352.2825538210923, 2405.338531903723, 2439.4023464251195, 2445.2297526279167, 2475.344033831036, 2478.913238036669, 2484.3416494628937, 2489.141246270043, 2489.4398760278973, 2374.133441293924, 2386.713594368678, 2395.185636883459, 2404.987975060131, 2408.6989126359204, 2054.6609809381507, 2277.453411181321, 2309.0994512140196, 2335.9065637374483, 2359.8112151027876, 2349.729781075181, 2352.682387877649, 2372.157883951207, 2373.3591930178927, 2381.9523609527887, 9084.0, 9092.909070909338, 9100.089991000914, 9163.129502697233, 9170.81658366829, 5353.57171426285, 5515.751791169407, 5527.447255274481, 5528.06022976095, 5540.86147846303, 3269.623993240784, 3273.6562660920736, 3397.677220664033, 3400.268942177419, 3420.675035871588, 1064.4571268652965, 1133.7619099989013, 1135.250734515216, 1140.7889540435046, 1148.5291030677465, 13307.401166947413, 13420.5302814402, 13445.66385840352, 13454.596362109152, 13491.190528568219, 4473.932891006638, 4579.793909274091, 4630.536946305342, 4746.359241502422, 4749.4063242094735, 10313.071823535767, 10333.741656458498, 10341.74145646365, 10352.327098738559, 10359.482025898675, 5180.870478237999, 5222.4255331913455, 5225.320708307896, 5232.136697444955, 5238.685678859204, 4372.081862808782, 4758.8572342829075, 4967.875803104951, 4973.452920178777, 4980.228064649985, 4043.9191216175514, 4086.346184610448, 4128.793560321972, 4139.151473947833, 4208.957910420918, 1304.3478260869565, 1314.4742103158812, 1317.5849607373646, 1331.2079312808862, 1331.4873773597235, 933.6545478173119, 940.9012053734397, 944.2115833279152, 972.3339512434005, 987.9950600247097, 5791.276090488689, 5825.417458254141, 5904.261967254093, 5988.011978023665, 6037.939620603738, 446.08775055012575, 450.2975358440843, 453.46491140454583, 457.1382943152182, 474.9715017098985, 3952.2885880541203, 4102.917941641151, 4106.917861642751, 4110.362893751473, 4111.671066314688, 11365.715857103638, 11571.594994175164, 11587.304761714155, 11720.413979301002, 11733.178677492493, 11208.439578021067, 11549.249298795552, 11566.595169169206, 11568.479418426192, 11604.477798499087, 8295.709650162215, 8515.40392172542, 8612.698555550525, 8637.611307491177, 8692.217700406994, 5717.085266357363, 5801.274840644919, 5852.122181672613, 5991.101334799815, 6019.217501724747, 10379.0, 10664.413457259925, 10711.25021248505, 10773.192010599394, 10777.784444311226, 10617.522211500347, 10676.0, 10756.46217689128, 10916.617918373136, 10935.83596246073, 7424.925750742424, 7841.686332546634, 8029.156938521604, 8063.233992770677, 8179.754607361789, 8952.731418057469, 8954.462732236087, 8990.86513702308, 9029.051949545203, 9048.230900373543, 7848.686052557834, 8101.929101894301, 8139.1453897339925, 8204.097549269694, 8287.419880608299, 7901.407394445325, 7972.123066462568, 7976.401769867399, 8095.5142691438705, 8101.675932962616, 7143.892841607276, 7146.535475194096, 7187.676554554953, 7205.927940720526, 7415.777526674208, 5267.2889159962915, 5275.973620131875, 5302.469753024667, 5303.575713942798, 5323.787048518016, 5228.163493840967, 5253.343332083489, 5269.525742683177, 5332.706701131475, 5617.101263797773], "value": 4676.522935296367, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.8305139801604, 326.2349789743052, 330.86103836388713, 332.7404624392973, 332.8735080669345, 5280.260763493109, 5291.0, 5306.230596563496, 5368.597355198356, 5406.459354064592, 5172.172452407615, 5216.061109000379, 5274.841754747355, 5278.970600732859, 5302.814401495948, 3988.3219852625125, 4005.479287692596, 4110.486189226347, 4118.238125946695, 4136.255474014676, 4091.468109145807, 4094.815733291994, 4118.238125946709, 4122.628963393294, 4124.401961715549, 3898.083950271684, 4061.208064427438, 4068.4304197412384, 4081.2857749893797, 4084.83660653575, 3945.4279129526344, 4052.392141178832, 4059.8173082211074, 4068.877933661995, 4081.9591804081874, 3563.768355056939, 3583.6416358364218, 3590.174259920233, 3602.3335682898746, 3610.097475631092, 4991.850244492671, 5060.114479966028, 5064.82273120439, 5073.34046573943, 5085.466026067246, 4522.394549934758, 4631.629469642454, 4660.580547750718, 4674.649401294916, 4679.766011699401, 5399.028174928511, 5413.458654134594, 5420.0, 5443.863903402407, 5447.727613619303, 3931.2923673738715, 3934.4098385242155, 3936.1734035852505, 3937.645611894943, 3947.921041579181, 5574.850209631545, 5583.972080139614, 5616.747246373923, 5620.747066381981, 5627.943720562783, 3985.740926839746, 4008.5590585035625, 4022.6580740637373, 4034.757914525138, 4048.866317431065, 4065.0894079782456, 4106.2198182345255, 4112.09533902541, 4116.876493705194, 4128.277551428488, 4399.406080179199, 4637.5130611286, 4639.884002899887, 4688.906221875543, 4694.671373003857, 5475.917861232085, 5476.972615136899, 5492.434656122986, 5500.972495137578, 5516.696581688046, 1377.5191668955913, 1397.8043073969652, 1401.3203596255807, 1410.7108042851396, 1411.9833719721785, 878.1438097854668, 895.9562110141612, 900.4687234531658, 910.8952470465849, 925.7407925780792, 5121.103806833789, 5125.513076257749, 5131.538161565477, 5138.794448222029, 5279.868003299872, 5657.632253903483, 5662.405447427961, 5675.120356344773, 5696.686682232434, 5699.857503562444, 5126.820561280338, 5291.0, 5298.788048478094, 5343.839684809462, 5382.1119515280325, 2928.5021546337175, 2991.9551206731917, 3000.7899447038935, 3001.5347621118326, 3013.9547906781418, 5845.503132233808, 5865.149553314831, 5866.8533286667325, 5883.0293001654245, 5892.970535147297, 5592.468715472024, 5739.196512488255, 5768.163616275617, 5821.563382746311, 5840.883182336414, 5755.36690964002, 5769.740361683735, 5776.133579963123, 5803.419658034163, 5804.767809287666, 5383.300170977748, 5589.77640894376, 5606.0, 5622.887542249214, 5669.433056694297, 5558.610897237155, 5567.387587365306, 5582.409013431153, 5585.720713964367, 5591.552675785846, 5827.59206855533, 5868.302969129421, 5918.987544234981, 5923.555733319932, 5936.139259807217, 3570.767900086486, 3658.46952191936, 3677.3564626189773, 3688.63113688629, 3695.279420512974, 4908.858330668304, 4976.576990955665, 4984.37695288089, 5056.6207534434325, 5077.7461126944245, 4926.064047830901, 4945.368028550498, 4945.7527123644395, 4950.653454258311, 4965.1311020571975, 4896.681715688469, 4962.801487940586, 5290.550303224269, 5405.91881623669, 5519.3652729936575, 5325.627206095536, 5420.83737487876, 5426.457354264542, 5473.28847249855, 5496.5053145217125, 5435.483629055233, 5462.481064298885, 5478.506934375925, 5498.505134537911, 5535.916961245504, 5132.460261921334, 5429.805442802577, 5433.505785908907, 5442.0748472760515, 5476.753546090516], "value": 4143.514945114182, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [796.1043825696092, 823.4400607586839, 825.9545724985127, 826.3760860550284, 835.8746188071784, 14405.711885762279, 14523.70952580949, 14610.926945365285, 14658.120512769241, 14775.852241477569, 13779.517716879911, 13779.65550861229, 13782.724345513083, 13785.931070344659, 13812.309384530783, 674.4301065599585, 781.3241546062671, 785.787837283933, 787.0240901282398, 815.5799763121997, 786.3984052200043, 792.3502727763237, 792.5482474989259, 794.3327604811957, 794.5034353529045, 709.8793205155137, 839.9202075802789, 840.5839109640737, 841.7011960753936, 843.1484200957046, 809.4981111710719, 814.5845618734429, 819.3035919468464, 840.2899549880341, 840.9159084091604, 616.626940700874, 617.1421723803916, 617.9351168127326, 618.6226401894841, 620.3455354600894, 13532.729345413036, 13601.659958501017, 13613.727725445435, 13629.25039122848, 13640.522581709693, 13199.14205576644, 13267.668308292274, 13300.0, 13458.596242112751, 13727.862721372758, 11931.284122952651, 12239.20445171061, 12308.734797187892, 12460.190087644274, 12529.373531323488, 4410.713303635285, 4447.110577884404, 4463.709858859196, 4509.413776209105, 4652.534746525354, 53724.462755372726, 53903.0, 54974.0, 55328.723356383365, 58413.41586584165, 11010.50452729629, 11021.83467247992, 11055.170862185369, 11493.942530287295, 11567.42162891852, 19615.11731972036, 19658.0, 19667.803321966883, 19677.409677709693, 19696.113674884666, 7729.884051739228, 7770.53376797394, 7772.689092436352, 7862.72480463181, 8131.5527645978855, 4601.631869450436, 4630.53694630541, 4689.718616882998, 4712.222483290218, 4786.880327991828, 3301.3727391795483, 3382.2389962258294, 3384.2554637979606, 3390.1524618845287, 3391.6099648540735, 471.9197736384823, 622.4335854372499, 646.6540400885598, 658.7595527632476, 677.9525433219627, 706.8374273917028, 732.4726197138052, 741.9035525381665, 747.5701471653712, 765.2882818978293, 9605.567749451291, 9883.30816842814, 9933.15568176713, 9991.700248992396, 10163.0, 627.4885967936117, 649.876523460541, 720.3840716187689, 727.1468144044301, 732.2531018361242, 4663.137319595886, 4681.0, 4758.484467588444, 4766.571008609242, 4814.9518504815205, 66919.66540167268, 69781.65109174422, 72603.63698181475, 72700.27299727041, 72762.0, 62519.6874015627, 62667.686661566404, 63797.36202638007, 63933.0, 64209.39476513125, 55455.0, 57329.14006289909, 57702.42297577055, 58220.7088964561, 58342.0, 8821.161989610977, 8882.644694212158, 8939.955300223457, 8960.283177345927, 9013.459192448474, 32988.67011329952, 35806.283874322886, 36113.91658250257, 37608.247835042595, 38939.80530097331, 44993.775031124635, 45671.086578268914, 48453.27320090272, 48664.51335486741, 49683.751581243305, 12531.12282140278, 12672.112952093265, 12723.0, 12990.675233119247, 13173.287472628881, 13402.597922062354, 13646.24945628, 14110.365033573718, 14193.580641935723, 14245.074070185405, 9374.531273436165, 10442.269041167045, 12739.61781146567, 13080.542181023618, 13463.798043029557, 12831.743365132832, 12910.354482276036, 12913.741725165257, 12940.288284144086, 13882.236476993863, 13291.80062299047, 13572.660683482596, 13580.117292375964, 13970.231637260049, 14065.156090634595, 11094.556217751522, 11503.309801411942, 11505.137114716263, 11703.473343699725, 11784.528618855493, 11220.158488113588, 11438.942805286253, 11494.252873563191, 11541.653750387502, 11574.71063223426], "value": 6933.917786283204, "unit": "score"}], "name": "dromaeo_css", "value": 7324.259072531174, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 106.0, 112.0, 110.0, 109.0, 112.0, 109.0, 110.0, 110.0, 109.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 128.0, 126.0, 215.0, 126.0, 135.0, 156.0, 125.0, 185.0, 125.0], "value": 148.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 161.0, 161.0, 163.0, 163.0, 162.0, 162.0, 163.0, 161.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 74.0, 139.0, 74.0, 78.0, 76.0, 76.0, 115.0, 75.0], "value": 85.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 160.0, 92.0, 93.0, 95.0, 133.0, 92.0, 92.0, 136.0], "value": 107.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 145.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 96.0, 97.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 55.0, 56.0, 56.0, 54.0, 57.0, 109.0, 52.0, 53.0], "value": 60.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 62.0, 62.0, 62.0, 70.0, 63.0, 62.0, 63.0], "value": 62.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 78.0, 79.0, 79.0, 80.0, 79.0, 80.0, 80.0, 80.0], "value": 79.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 126.0, 132.0, 118.0, 120.0, 129.0, 134.0, 120.0, 192.0, 135.0], "value": 132.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 159.0, 163.0, 159.0, 161.0, 162.0, 160.0, 162.0, 160.0], "value": 161.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 64.0, 64.0, 63.0, 62.0, 62.0, 64.0, 62.0, 61.0, 63.0], "value": 63.2, "unit": "score"}], "name": "kraken", "value": 1532.1000000000001, "alertThreshold": 2.0}]} 01:30:03 INFO - Return code: 0 01:30:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 01:30:03 ERROR - # TBPL SUCCESS # 01:30:03 INFO - Running post-action listener: _resource_record_post_action 01:30:03 INFO - ##### 01:30:03 INFO - ##### Finished run-tests step (success) 01:30:03 INFO - ##### 01:30:04 INFO - Running post-run listener: _resource_record_post_run 01:30:04 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 548646912; Read time: 16; Write time: 470524 01:30:04 INFO - TinderboxPrint: CPU usage
13.2% 01:30:04 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 01:30:04 INFO - TinderboxPrint: I/O write bytes / time
548,646,912 / 470,524 01:30:04 INFO - TinderboxPrint: CPU idle
8,264.2 (86.8%) 01:30:04 INFO - TinderboxPrint: CPU user
1,209.1 (12.7%) 01:30:04 INFO - TinderboxPrint: Swap in / out
0 / 0 01:30:04 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 257241088; Read time: 0; Write time: 297980 01:30:04 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291405824; Read time: 16; Write time: 172544 01:30:04 INFO - Running post-run listener: _upload_blobber_files 01:30:04 INFO - Blob upload gear active. 01:30:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:30:04 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 01:30:04 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', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:30:04 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 Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:30:05 INFO - (blobuploader) - INFO - Open directory for files ... 01:30:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:30:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:30:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:30:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:30:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:30:08 INFO - (blobuploader) - INFO - Done attempting. 01:30:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:30:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:30:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:30:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:30:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:30:09 INFO - (blobuploader) - INFO - Done attempting. 01:30:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:30:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:30:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:30:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:30:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:30:10 INFO - (blobuploader) - INFO - Done attempting. 01:30:10 INFO - (blobuploader) - INFO - Iteration through files over. 01:30:10 INFO - Return code: 0 01:30:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:30:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:30:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/89e897ff73fb37acc63439e966c643f254dffa117c43c41d11a0b3f370ae8d7d6e2ea5a5df4f893445d52c0fd04184ed69a7b6db8c75e4453a3b5b2373cc64e5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/04f00853c833ad9d9554c7b77d2d36afeff7bc4307715eedd0825e37157c2483037a6ec2c507364368ddba870c1ebf9d8343e33b03cb731201c98ff23c0f6361", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0389b803833fe3c0f28850c46437047b0b8d06030e0267e4536f9e1c3a270ece80cada976b4264e1b25c3b7d142d0294b67d7109619261ef635c691e3f0998ec"} 01:30:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:30:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:30:10 INFO - Contents: 01:30:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/89e897ff73fb37acc63439e966c643f254dffa117c43c41d11a0b3f370ae8d7d6e2ea5a5df4f893445d52c0fd04184ed69a7b6db8c75e4453a3b5b2373cc64e5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/04f00853c833ad9d9554c7b77d2d36afeff7bc4307715eedd0825e37157c2483037a6ec2c507364368ddba870c1ebf9d8343e33b03cb731201c98ff23c0f6361", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0389b803833fe3c0f28850c46437047b0b8d06030e0267e4536f9e1c3a270ece80cada976b4264e1b25c3b7d142d0294b67d7109619261ef635c691e3f0998ec"} 01:30:10 INFO - Running post-run listener: copy_logs_to_upload_dir 01:30:10 INFO - Copying logs to upload dir... 01:30:10 INFO - mkdir: /builds/slave/test/build/upload/logs 01:30:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.621762 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-05-21 01:30:10.554539) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-21 01:30:10.557942) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1463810468.905643-433997857 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/89e897ff73fb37acc63439e966c643f254dffa117c43c41d11a0b3f370ae8d7d6e2ea5a5df4f893445d52c0fd04184ed69a7b6db8c75e4453a3b5b2373cc64e5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/04f00853c833ad9d9554c7b77d2d36afeff7bc4307715eedd0825e37157c2483037a6ec2c507364368ddba870c1ebf9d8343e33b03cb731201c98ff23c0f6361", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0389b803833fe3c0f28850c46437047b0b8d06030e0267e4536f9e1c3a270ece80cada976b4264e1b25c3b7d142d0294b67d7109619261ef635c691e3f0998ec"} build_url:https://queue.taskcluster.net/v1/task/LfxMTmTHRdGNf7cI-QM9qw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011177 build_url: 'https://queue.taskcluster.net/v1/task/LfxMTmTHRdGNf7cI-QM9qw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/89e897ff73fb37acc63439e966c643f254dffa117c43c41d11a0b3f370ae8d7d6e2ea5a5df4f893445d52c0fd04184ed69a7b6db8c75e4453a3b5b2373cc64e5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/04f00853c833ad9d9554c7b77d2d36afeff7bc4307715eedd0825e37157c2483037a6ec2c507364368ddba870c1ebf9d8343e33b03cb731201c98ff23c0f6361", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0389b803833fe3c0f28850c46437047b0b8d06030e0267e4536f9e1c3a270ece80cada976b4264e1b25c3b7d142d0294b67d7109619261ef635c691e3f0998ec"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-21 01:30:10.587574) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 01:30:10.587912) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1463810468.905643-433997857 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004483 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 01:30:10.671229) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-21 01:30:10.671595) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-21 01:30:10.671900) ========= ========= Total master_lag: 0.19 =========