builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-051 starttime: 1463789837.72 results: success (0) buildid: 20160520160630 builduid: 77ce1d51c5184298ba7687e7b6564ef5 revision: 45709b7b6466abcd984d5736c0e64eb12b0044cc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-20 17:17:17.721606) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-20 17:17:17.722043) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-20 17:17:17.722356) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-20 17:17:17.732985) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 17:17:17.733410) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1463786537.67319-2130219653 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-20 17:17:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 424M=0s 2016-05-20 17:17:18 (424 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.161263 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 17:17:17.906851) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 17:17:17.907195) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1463786537.67319-2130219653 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.009658 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 17:17:17.958425) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 17:17:17.958873) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 45709b7b6466abcd984d5736c0e64eb12b0044cc --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 45709b7b6466abcd984d5736c0e64eb12b0044cc --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=5ac5dba3e01a12f1ff77ab15000001b1-1463786537.67319-2130219653 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-20 17:17:18,390 truncating revision to first 12 chars 2016-05-20 17:17:18,390 Setting DEBUG logging. 2016-05-20 17:17:18,390 attempt 1/10 2016-05-20 17:17:18,391 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/45709b7b6466?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-20 17:17:18,612 unpacking tar archive at: mozilla-central-45709b7b6466/testing/mozharness/ program finished with exit code 0 elapsedTime=0.458067 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 17:17:18.426420) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-20 17:17:18.426791) ========= script_repo_revision: 45709b7b6466abcd984d5736c0e64eb12b0044cc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-20 17:17:18.427255) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-20 17:17:18.427582) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-20 17:17:18.433708) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-05-20 17:17:18.434019) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1463786537.67319-2130219653 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:17:18 INFO - MultiFileLogger online at 20160520 17:17:18 in /builds/slave/test 17:17:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 17:17:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:17:18 INFO - {'append_to_log': False, 17:17:18 INFO - 'base_work_dir': '/builds/slave/test', 17:17:18 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 17:17:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:17:18 INFO - 'branch': 'Firefox-Non-PGO', 17:17:18 INFO - 'buildbot_json_path': 'buildprops.json', 17:17:18 INFO - 'config_files': ('talos/linux_config.py',), 17:17:18 INFO - 'default_actions': ('clobber', 17:17:18 INFO - 'read-buildbot-config', 17:17:18 INFO - 'download-and-extract', 17:17:18 INFO - 'populate-webroot', 17:17:18 INFO - 'create-virtualenv', 17:17:18 INFO - 'install', 17:17:18 INFO - 'run-tests'), 17:17:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:17:18 INFO - 'download_minidump_stackwalk': True, 17:17:18 INFO - 'download_symbols': 'ondemand', 17:17:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:17:18 INFO - 'tooltool.py': '/tools/tooltool.py', 17:17:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:17:18 INFO - '/tools/misc-python/virtualenv.py')}, 17:17:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:17:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:17:18 INFO - 'installer_path': 'installer.exe', 17:17:18 INFO - 'log_level': 'info', 17:17:18 INFO - 'log_name': 'talos', 17:17:18 INFO - 'log_to_console': True, 17:17:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:17:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:17:18 INFO - 'opt_config_files': (), 17:17:18 INFO - 'pip_index': False, 17:17:18 INFO - 'sps_profile': False, 17:17:18 INFO - 'sps_profile_interval': 0, 17:17:18 INFO - 'suite': 'dromaeojs', 17:17:18 INFO - 'system_bits': '32', 17:17:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:17:18 INFO - 'title': 'talos-linux64-ix-051', 17:17:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:17:18 INFO - 'use_talos_json': True, 17:17:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:17:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:17:18 INFO - 'work_dir': 'build'} 17:17:18 INFO - ##### 17:17:18 INFO - ##### Running clobber step. 17:17:18 INFO - ##### 17:17:18 INFO - Running pre-action listener: _resource_record_pre_action 17:17:18 INFO - Running main action method: clobber 17:17:18 INFO - rmtree: /builds/slave/test/build 17:17:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:17:19 INFO - Running post-action listener: _resource_record_post_action 17:17:19 INFO - ##### 17:17:19 INFO - ##### Finished clobber step (success) 17:17:19 INFO - ##### 17:17:19 INFO - ##### 17:17:19 INFO - ##### Running read-buildbot-config step. 17:17:19 INFO - ##### 17:17:19 INFO - Running pre-action listener: _resource_record_pre_action 17:17:19 INFO - Running main action method: read_buildbot_config 17:17:19 INFO - Using buildbot properties: 17:17:19 INFO - { 17:17:19 INFO - "project": "", 17:17:19 INFO - "product": "firefox", 17:17:19 INFO - "script_repo_revision": "production", 17:17:19 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 17:17:19 INFO - "repository": "", 17:17:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 17:17:19 INFO - "buildid": "20160520160630", 17:17:19 INFO - "pgo_build": "False", 17:17:19 INFO - "basedir": "/builds/slave/test", 17:17:19 INFO - "buildnumber": 92, 17:17:19 INFO - "slavename": "talos-linux64-ix-051", 17:17:19 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:17:19 INFO - "platform": "ubuntu64_hw", 17:17:19 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 17:17:19 INFO - "branch": "mozilla-central", 17:17:19 INFO - "repo_path": "mozilla-central", 17:17:19 INFO - "revision": "45709b7b6466abcd984d5736c0e64eb12b0044cc", 17:17:19 INFO - "stage_platform": "linux64", 17:17:19 INFO - "builduid": "77ce1d51c5184298ba7687e7b6564ef5", 17:17:19 INFO - "slavebuilddir": "test" 17:17:19 INFO - } 17:17:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ch5NgTVRT2WBN9LIlSPIQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 17:17:19 INFO - Running post-action listener: _resource_record_post_action 17:17:19 INFO - ##### 17:17:19 INFO - ##### Finished read-buildbot-config step (success) 17:17:19 INFO - ##### 17:17:19 INFO - ##### 17:17:19 INFO - ##### Running download-and-extract step. 17:17:19 INFO - ##### 17:17:19 INFO - Running pre-action listener: _resource_record_pre_action 17:17:19 INFO - Running main action method: download_and_extract 17:17:19 INFO - mkdir: /builds/slave/test/build/tests 17:17:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:19 INFO - https://queue.taskcluster.net/v1/task/Ch5NgTVRT2WBN9LIlSPIQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:17:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ch5NgTVRT2WBN9LIlSPIQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:17:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ch5NgTVRT2WBN9LIlSPIQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:17:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ch5NgTVRT2WBN9LIlSPIQA/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 17:17:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ch5NgTVRT2WBN9LIlSPIQA/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 17:17:20 INFO - Downloaded 1361 bytes. 17:17:20 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:17:20 INFO - Using the following test package requirements: 17:17:20 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:17:20 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:17:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:17:20 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:17:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:17:20 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:17:20 INFO - u'jsshell-linux-x86_64.zip'], 17:17:20 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:17:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:17:20 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:17:20 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:17:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:17:20 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:17:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:17:20 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:17:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:17:20 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:17:20 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:17:20 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:17:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:20 INFO - https://queue.taskcluster.net/v1/task/Ch5NgTVRT2WBN9LIlSPIQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:17:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ch5NgTVRT2WBN9LIlSPIQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:17:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ch5NgTVRT2WBN9LIlSPIQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:17:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ch5NgTVRT2WBN9LIlSPIQA/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 17:17:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ch5NgTVRT2WBN9LIlSPIQA/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 17:17:21 INFO - Downloaded 22814329 bytes. 17:17:21 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'] 17:17:21 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 17:17:22 INFO - Return code: 0 17:17:22 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 17:17:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:22 INFO - https://queue.taskcluster.net/v1/task/Ch5NgTVRT2WBN9LIlSPIQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:17:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ch5NgTVRT2WBN9LIlSPIQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:17:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ch5NgTVRT2WBN9LIlSPIQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:17:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ch5NgTVRT2WBN9LIlSPIQA/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 17:17:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ch5NgTVRT2WBN9LIlSPIQA/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 17:17:25 INFO - Downloaded 22814329 bytes. 17:17:25 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'] 17:17:25 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 17:17:26 INFO - Return code: 0 17:17:26 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')]} 17:17:26 INFO - https://queue.taskcluster.net/v1/task/Ch5NgTVRT2WBN9LIlSPIQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:17:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ch5NgTVRT2WBN9LIlSPIQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:17:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ch5NgTVRT2WBN9LIlSPIQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:17:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ch5NgTVRT2WBN9LIlSPIQA/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 17:17:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ch5NgTVRT2WBN9LIlSPIQA/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 17:17:28 INFO - Downloaded 10840359 bytes. 17:17:28 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'] 17:17:28 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 17:17:28 INFO - Return code: 0 17:17:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:28 INFO - https://queue.taskcluster.net/v1/task/Ch5NgTVRT2WBN9LIlSPIQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:17:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ch5NgTVRT2WBN9LIlSPIQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:17:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ch5NgTVRT2WBN9LIlSPIQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:17:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ch5NgTVRT2WBN9LIlSPIQA/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 17:17:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ch5NgTVRT2WBN9LIlSPIQA/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 17:17:30 INFO - Downloaded 54820439 bytes. 17:17:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ch5NgTVRT2WBN9LIlSPIQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:17:30 INFO - mkdir: /builds/slave/test/properties 17:17:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:17:30 INFO - Writing to file /builds/slave/test/properties/build_url 17:17:30 INFO - Contents: 17:17:30 INFO - build_url:https://queue.taskcluster.net/v1/task/Ch5NgTVRT2WBN9LIlSPIQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:17:31 INFO - Running post-action listener: _resource_record_post_action 17:17:31 INFO - Running post-action listener: set_extra_try_arguments 17:17:31 INFO - ##### 17:17:31 INFO - ##### Finished download-and-extract step (success) 17:17:31 INFO - ##### 17:17:31 INFO - ##### 17:17:31 INFO - ##### Running populate-webroot step. 17:17:31 INFO - ##### 17:17:31 INFO - Running pre-action listener: _resource_record_pre_action 17:17:31 INFO - Running main action method: populate_webroot 17:17:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:17:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:17:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:17:31 INFO - '--tppagecycles', 17:17:31 INFO - '7'], 17:17:31 INFO - 'tests': ['tsvgm']}}, 17:17:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:17:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:17:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:17:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:17:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:17:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:17:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:31 INFO - 'talos_options': ['--disable-e10s'], 17:17:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:17:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:17:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:31 INFO - 'talos_options': ['--disable-e10s'], 17:17:31 INFO - 'tests': ['damp', 'tps']}, 17:17:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:31 INFO - 'tests': ['damp', 'tps']}, 17:17:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:17:31 INFO - 'tests': ['dromaeo_dom']}, 17:17:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:17:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:17:31 INFO - 'tests': ['a11yr', 17:17:31 INFO - 'ts_paint', 17:17:31 INFO - 'tpaint', 17:17:31 INFO - 'sessionrestore', 17:17:31 INFO - 'sessionrestore_no_auto_restore', 17:17:31 INFO - 'tabpaint']}, 17:17:31 INFO - 'other-e10s': {'tests': ['a11yr', 17:17:31 INFO - 'ts_paint', 17:17:31 INFO - 'tpaint', 17:17:31 INFO - 'sessionrestore', 17:17:31 INFO - 'sessionrestore_no_auto_restore', 17:17:31 INFO - 'tabpaint']}, 17:17:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:17:31 INFO - 'ts_paint', 17:17:31 INFO - 'tpaint', 17:17:31 INFO - 'sessionrestore', 17:17:31 INFO - 'sessionrestore_no_auto_restore', 17:17:31 INFO - 'tabpaint']}, 17:17:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:17:31 INFO - 'ts_paint', 17:17:31 INFO - 'tpaint', 17:17:31 INFO - 'sessionrestore', 17:17:31 INFO - 'sessionrestore_no_auto_restore', 17:17:31 INFO - 'tabpaint']}, 17:17:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:17:31 INFO - 'tests': ['a11yr', 17:17:31 INFO - 'ts_paint', 17:17:31 INFO - 'tpaint', 17:17:31 INFO - 'sessionrestore', 17:17:31 INFO - 'sessionrestore_no_auto_restore', 17:17:31 INFO - 'tabpaint']}, 17:17:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:17:31 INFO - 'tests': ['a11yr', 17:17:31 INFO - 'ts_paint', 17:17:31 INFO - 'tpaint', 17:17:31 INFO - 'sessionrestore', 17:17:31 INFO - 'sessionrestore_no_auto_restore', 17:17:31 INFO - 'tabpaint']}, 17:17:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:17:31 INFO - 'tests': ['tsvgx', 17:17:31 INFO - 'tsvgr_opacity', 17:17:31 INFO - 'tart', 17:17:31 INFO - 'tscrollx', 17:17:31 INFO - 'cart']}, 17:17:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:17:31 INFO - 'tsvgr_opacity', 17:17:31 INFO - 'tart', 17:17:31 INFO - 'tscrollx', 17:17:31 INFO - 'cart']}, 17:17:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:31 INFO - 'talos_options': ['--disable-e10s'], 17:17:31 INFO - 'tests': ['tp5o']}, 17:17:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:31 INFO - 'tests': ['tp5o']}, 17:17:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:31 INFO - 'talos_options': ['--disable-e10s', 17:17:31 INFO - '--xperf_path', 17:17:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:17:31 INFO - 'tests': ['tp5n']}, 17:17:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:31 INFO - 'talos_options': ['--xperf_path', 17:17:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:17:31 INFO - 'tests': ['tp5n']}}, 17:17:31 INFO - 'talos.zip': {'path': '', 17:17:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:17:31 INFO - Running post-action listener: _resource_record_post_action 17:17:31 INFO - ##### 17:17:31 INFO - ##### Finished populate-webroot step (success) 17:17:31 INFO - ##### 17:17:31 INFO - ##### 17:17:31 INFO - ##### Running create-virtualenv step. 17:17:31 INFO - ##### 17:17:31 INFO - Running pre-action listener: _resource_record_pre_action 17:17:31 INFO - Running main action method: create_virtualenv 17:17:31 INFO - Creating virtualenv /builds/slave/test/build/venv 17:17:31 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 17:17:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:17:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:17:32 INFO - Using real prefix '/usr' 17:17:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:17:32 INFO - Installing distribute.............................................................................................................................................................................................done. 17:17:34 INFO - Installing pip.................done. 17:17:34 INFO - Return code: 0 17:17:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:17: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')]} 17:17:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17: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')]} 17:17:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:34 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 0x7f77b04b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d749c0>, '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 0x1d758c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d75d50>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1463786537.67319-2130219653', '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 17:17:34 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 17:17:34 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 17:17:34 INFO - Using env: {'DISPLAY': ':0', 17:17:34 INFO - 'HOME': '/home/cltbld', 17:17:34 INFO - 'LANG': 'en_US.UTF-8', 17:17:34 INFO - 'LANGUAGE': 'en_US:en', 17:17:34 INFO - 'LOGNAME': 'cltbld', 17:17:34 INFO - 'MAIL': '/var/mail/cltbld', 17:17:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:34 INFO - 'MOZ_NO_REMOTE': '1', 17:17:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:34 INFO - 'NO_EM_RESTART': '1', 17:17:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:34 INFO - 'PWD': '/builds/slave/test', 17:17:34 INFO - 'SHELL': '/bin/bash', 17:17:34 INFO - 'SHLVL': '1', 17:17:34 INFO - 'TERM': 'linux', 17:17:34 INFO - 'TMOUT': '86400', 17:17:34 INFO - 'USER': 'cltbld', 17:17:34 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1463786537.67319-2130219653', 17:17:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:34 INFO - '_': '/tools/buildbot/bin/python'} 17:17:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:34 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 17:17:34 INFO - Cleaning up... 17:17:34 INFO - Return code: 0 17:17:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:17: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')]} 17:17:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17: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')]} 17:17:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:34 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 0x7f77b04b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d749c0>, '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 0x1d758c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d75d50>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1463786537.67319-2130219653', '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 17:17:34 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 17:17:34 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 17:17:34 INFO - Using env: {'DISPLAY': ':0', 17:17:34 INFO - 'HOME': '/home/cltbld', 17:17:34 INFO - 'LANG': 'en_US.UTF-8', 17:17:34 INFO - 'LANGUAGE': 'en_US:en', 17:17:34 INFO - 'LOGNAME': 'cltbld', 17:17:34 INFO - 'MAIL': '/var/mail/cltbld', 17:17:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:34 INFO - 'MOZ_NO_REMOTE': '1', 17:17:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:34 INFO - 'NO_EM_RESTART': '1', 17:17:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:34 INFO - 'PWD': '/builds/slave/test', 17:17:34 INFO - 'SHELL': '/bin/bash', 17:17:34 INFO - 'SHLVL': '1', 17:17:34 INFO - 'TERM': 'linux', 17:17:34 INFO - 'TMOUT': '86400', 17:17:34 INFO - 'USER': 'cltbld', 17:17:34 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1463786537.67319-2130219653', 17:17:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:34 INFO - '_': '/tools/buildbot/bin/python'} 17:17:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:34 INFO - Downloading/unpacking psutil>=3.1.1 17:17:34 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 17:17:34 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 17:17:34 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 17:17:34 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 17:17:34 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 17:17:34 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 17:17:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:17:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:17:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:17:36 INFO - Installing collected packages: psutil 17:17:36 INFO - Running setup.py install for psutil 17:17:36 INFO - building 'psutil._psutil_linux' extension 17:17:36 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 17:17:37 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 17:17:37 INFO - building 'psutil._psutil_posix' extension 17:17:37 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 17:17:37 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 17:17:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:17:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:17:37 INFO - Successfully installed psutil 17:17:37 INFO - Cleaning up... 17:17:37 INFO - Return code: 0 17:17:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:17:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f77b04b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d749c0>, '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 0x1d758c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d75d50>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1463786537.67319-2130219653', '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 17:17:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:17:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:17:37 INFO - Using env: {'DISPLAY': ':0', 17:17:37 INFO - 'HOME': '/home/cltbld', 17:17:37 INFO - 'LANG': 'en_US.UTF-8', 17:17:37 INFO - 'LANGUAGE': 'en_US:en', 17:17:37 INFO - 'LOGNAME': 'cltbld', 17:17:37 INFO - 'MAIL': '/var/mail/cltbld', 17:17:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:37 INFO - 'MOZ_NO_REMOTE': '1', 17:17:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:37 INFO - 'NO_EM_RESTART': '1', 17:17:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:37 INFO - 'PWD': '/builds/slave/test', 17:17:37 INFO - 'SHELL': '/bin/bash', 17:17:37 INFO - 'SHLVL': '1', 17:17:37 INFO - 'TERM': 'linux', 17:17:37 INFO - 'TMOUT': '86400', 17:17:37 INFO - 'USER': 'cltbld', 17:17:37 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1463786537.67319-2130219653', 17:17:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:37 INFO - '_': '/tools/buildbot/bin/python'} 17:17:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:17:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:17:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:17:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:17:39 INFO - Installing collected packages: mozsystemmonitor 17:17:39 INFO - Running setup.py install for mozsystemmonitor 17:17:39 INFO - Successfully installed mozsystemmonitor 17:17:39 INFO - Cleaning up... 17:17:39 INFO - Return code: 0 17:17:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:17:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f77b04b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d749c0>, '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 0x1d758c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d75d50>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1463786537.67319-2130219653', '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 17:17:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:17:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:17:39 INFO - Using env: {'DISPLAY': ':0', 17:17:39 INFO - 'HOME': '/home/cltbld', 17:17:39 INFO - 'LANG': 'en_US.UTF-8', 17:17:39 INFO - 'LANGUAGE': 'en_US:en', 17:17:39 INFO - 'LOGNAME': 'cltbld', 17:17:39 INFO - 'MAIL': '/var/mail/cltbld', 17:17:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:39 INFO - 'MOZ_NO_REMOTE': '1', 17:17:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:39 INFO - 'NO_EM_RESTART': '1', 17:17:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:39 INFO - 'PWD': '/builds/slave/test', 17:17:39 INFO - 'SHELL': '/bin/bash', 17:17:39 INFO - 'SHLVL': '1', 17:17:39 INFO - 'TERM': 'linux', 17:17:39 INFO - 'TMOUT': '86400', 17:17:39 INFO - 'USER': 'cltbld', 17:17:39 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1463786537.67319-2130219653', 17:17:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:39 INFO - '_': '/tools/buildbot/bin/python'} 17:17:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:39 INFO - Downloading/unpacking blobuploader==1.2.4 17:17:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:41 INFO - Downloading blobuploader-1.2.4.tar.gz 17:17:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:17:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:17:41 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 17:17:41 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 17:17:41 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 17:17:41 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 17:17:41 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 17:17:41 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 17:17:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:17:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:17:41 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 17:17:41 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 17:17:41 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 17:17:41 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 17:17:41 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 17:17:41 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 17:17:42 INFO - Downloading docopt-0.6.1.tar.gz 17:17:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:17:42 INFO - Installing collected packages: blobuploader, requests, docopt 17:17:42 INFO - Running setup.py install for blobuploader 17:17:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:17:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:17:42 INFO - Running setup.py install for requests 17:17:42 INFO - Running setup.py install for docopt 17:17:42 INFO - Successfully installed blobuploader requests docopt 17:17:42 INFO - Cleaning up... 17:17:42 INFO - Return code: 0 17:17:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:17:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:42 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 0x7f77b04b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d749c0>, '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 0x1d758c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d75d50>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1463786537.67319-2130219653', '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 17:17:42 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 17:17:42 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 17:17:42 INFO - Using env: {'DISPLAY': ':0', 17:17:42 INFO - 'HOME': '/home/cltbld', 17:17:42 INFO - 'LANG': 'en_US.UTF-8', 17:17:42 INFO - 'LANGUAGE': 'en_US:en', 17:17:42 INFO - 'LOGNAME': 'cltbld', 17:17:42 INFO - 'MAIL': '/var/mail/cltbld', 17:17:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:42 INFO - 'MOZ_NO_REMOTE': '1', 17:17:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:42 INFO - 'NO_EM_RESTART': '1', 17:17:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:42 INFO - 'PWD': '/builds/slave/test', 17:17:42 INFO - 'SHELL': '/bin/bash', 17:17:42 INFO - 'SHLVL': '1', 17:17:42 INFO - 'TERM': 'linux', 17:17:42 INFO - 'TMOUT': '86400', 17:17:42 INFO - 'USER': 'cltbld', 17:17:42 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1463786537.67319-2130219653', 17:17:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:42 INFO - '_': '/tools/buildbot/bin/python'} 17:17:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:17:42 INFO - Running setup.py (path:/tmp/pip-iW_7y0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:17:43 INFO - Running setup.py (path:/tmp/pip-Gzcovb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:17:43 INFO - Running setup.py (path:/tmp/pip-Dm3LPf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:17:43 INFO - Running setup.py (path:/tmp/pip-tIs7H7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:17:43 INFO - Running setup.py (path:/tmp/pip-BHEmqH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:17:43 INFO - Running setup.py (path:/tmp/pip-oVPl0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:17:43 INFO - Running setup.py (path:/tmp/pip-VyaGgV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:17:43 INFO - Running setup.py (path:/tmp/pip-UUEoR4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:17:43 INFO - Running setup.py (path:/tmp/pip-FUpFV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:17:43 INFO - Running setup.py (path:/tmp/pip-fGrFtI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:17:43 INFO - Running setup.py (path:/tmp/pip-oab9my-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:17:43 INFO - Running setup.py (path:/tmp/pip-skQypn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:17:43 INFO - Running setup.py (path:/tmp/pip-m3Ee0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:17:43 INFO - Running setup.py (path:/tmp/pip-tWnZuG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:17:43 INFO - Running setup.py (path:/tmp/pip-8TDUtP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:17:43 INFO - Running setup.py (path:/tmp/pip-K2ha3Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:17:43 INFO - Running setup.py (path:/tmp/pip-YCIKfc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:17:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:17:43 INFO - Running setup.py install for manifestparser 17:17:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:17:44 INFO - Running setup.py install for mozcrash 17:17:44 INFO - Running setup.py install for mozdebug 17:17:44 INFO - Running setup.py install for mozdevice 17:17:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:17:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:17:44 INFO - Running setup.py install for mozfile 17:17:44 INFO - Running setup.py install for mozhttpd 17:17:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:17:44 INFO - Running setup.py install for mozinfo 17:17:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:17:44 INFO - Running setup.py install for mozInstall 17:17:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:17:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:17:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:17:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:17:44 INFO - Running setup.py install for mozleak 17:17:44 INFO - Running setup.py install for mozlog 17:17:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:17:44 INFO - Running setup.py install for moznetwork 17:17:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:17:44 INFO - Running setup.py install for mozprocess 17:17:45 INFO - Running setup.py install for mozprofile 17:17:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:17:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:17:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:17:45 INFO - Running setup.py install for mozrunner 17:17:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:17:45 INFO - Running setup.py install for mozscreenshot 17:17:45 INFO - Running setup.py install for moztest 17:17:45 INFO - Running setup.py install for mozversion 17:17:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:17:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:17:45 INFO - Cleaning up... 17:17:45 INFO - Return code: 0 17:17:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:17:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:45 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 0x7f77b04b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d749c0>, '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 0x1d758c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d75d50>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1463786537.67319-2130219653', '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 17:17:45 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 17:17:45 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 17:17:45 INFO - Using env: {'DISPLAY': ':0', 17:17:45 INFO - 'HOME': '/home/cltbld', 17:17:45 INFO - 'LANG': 'en_US.UTF-8', 17:17:45 INFO - 'LANGUAGE': 'en_US:en', 17:17:45 INFO - 'LOGNAME': 'cltbld', 17:17:45 INFO - 'MAIL': '/var/mail/cltbld', 17:17:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:45 INFO - 'MOZ_NO_REMOTE': '1', 17:17:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:45 INFO - 'NO_EM_RESTART': '1', 17:17:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:45 INFO - 'PWD': '/builds/slave/test', 17:17:45 INFO - 'SHELL': '/bin/bash', 17:17:45 INFO - 'SHLVL': '1', 17:17:45 INFO - 'TERM': 'linux', 17:17:45 INFO - 'TMOUT': '86400', 17:17:45 INFO - 'USER': 'cltbld', 17:17:45 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1463786537.67319-2130219653', 17:17:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:45 INFO - '_': '/tools/buildbot/bin/python'} 17:17:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:17:45 INFO - Running setup.py (path:/tmp/pip-YBHZ9_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:17:45 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:17:45 INFO - Running setup.py (path:/tmp/pip-pKpc4Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:17:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:17:45 INFO - Running setup.py (path:/tmp/pip-jKiFbv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:17:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:17:45 INFO - Running setup.py (path:/tmp/pip-nZ_brV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:17:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:17:45 INFO - Running setup.py (path:/tmp/pip-8glYTp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:17:46 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)) 17:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:17:46 INFO - Running setup.py (path:/tmp/pip-6_e70O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:17:46 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)) 17:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:17:46 INFO - Running setup.py (path:/tmp/pip-YMctBw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:17:46 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)) 17:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:17:46 INFO - Running setup.py (path:/tmp/pip-Pqabjh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:17:46 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)) 17:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:17:46 INFO - Running setup.py (path:/tmp/pip-Br55ri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:17:46 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)) 17:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:17:46 INFO - Running setup.py (path:/tmp/pip-nqT2Im-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:17:46 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)) 17:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:17:46 INFO - Running setup.py (path:/tmp/pip-sa4o_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:17:46 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)) 17:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:17:46 INFO - Running setup.py (path:/tmp/pip-fy18vB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:17:46 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)) 17:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:17:46 INFO - Running setup.py (path:/tmp/pip-FFzCvg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:17:46 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)) 17:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:17:46 INFO - Running setup.py (path:/tmp/pip-SVFMyM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:17:46 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)) 17:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:17:46 INFO - Running setup.py (path:/tmp/pip-H90jbV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:17:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:17:46 INFO - Running setup.py (path:/tmp/pip-ZBCxHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:17:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:17:46 INFO - Running setup.py (path:/tmp/pip-kmN4nI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:17:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:17:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:17:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:17:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:17:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:17:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:17:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:48 INFO - Downloading blessings-1.6.tar.gz 17:17:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:17:48 INFO - Installing collected packages: blessings 17:17:48 INFO - Running setup.py install for blessings 17:17:48 INFO - Successfully installed blessings 17:17:48 INFO - Cleaning up... 17:17:48 INFO - Return code: 0 17:17:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:17:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:17:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:17:49 INFO - Reading from file tmpfile_stdout 17:17:49 INFO - Current package versions: 17:17:49 INFO - argparse == 1.2.1 17:17:49 INFO - blessings == 1.6 17:17:49 INFO - blobuploader == 1.2.4 17:17:49 INFO - docopt == 0.6.1 17:17:49 INFO - manifestparser == 1.1 17:17:49 INFO - mozInstall == 1.12 17:17:49 INFO - mozcrash == 0.17 17:17:49 INFO - mozdebug == 0.1 17:17:49 INFO - mozdevice == 0.48 17:17:49 INFO - mozfile == 1.2 17:17:49 INFO - mozhttpd == 0.7 17:17:49 INFO - mozinfo == 0.9 17:17:49 INFO - mozleak == 0.1 17:17:49 INFO - mozlog == 3.2 17:17:49 INFO - moznetwork == 0.27 17:17:49 INFO - mozprocess == 0.22 17:17:49 INFO - mozprofile == 0.28 17:17:49 INFO - mozrunner == 6.11 17:17:49 INFO - mozscreenshot == 0.1 17:17:49 INFO - mozsystemmonitor == 0.3 17:17:49 INFO - moztest == 0.7 17:17:49 INFO - mozversion == 1.4 17:17:49 INFO - psutil == 3.1.1 17:17:49 INFO - requests == 1.2.3 17:17:49 INFO - wsgiref == 0.1.2 17:17:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:17:49 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')]} 17:17:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:49 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')]} 17:17:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:49 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 0x7f77b04b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d749c0>, '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 0x1d758c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d75d50>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1463786537.67319-2130219653', '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 17:17:49 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 17:17:49 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 17:17:49 INFO - Using env: {'DISPLAY': ':0', 17:17:49 INFO - 'HOME': '/home/cltbld', 17:17:49 INFO - 'LANG': 'en_US.UTF-8', 17:17:49 INFO - 'LANGUAGE': 'en_US:en', 17:17:49 INFO - 'LOGNAME': 'cltbld', 17:17:49 INFO - 'MAIL': '/var/mail/cltbld', 17:17:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:49 INFO - 'MOZ_NO_REMOTE': '1', 17:17:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:49 INFO - 'NO_EM_RESTART': '1', 17:17:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:49 INFO - 'PWD': '/builds/slave/test', 17:17:49 INFO - 'SHELL': '/bin/bash', 17:17:49 INFO - 'SHLVL': '1', 17:17:49 INFO - 'TERM': 'linux', 17:17:49 INFO - 'TMOUT': '86400', 17:17:49 INFO - 'USER': 'cltbld', 17:17:49 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1463786537.67319-2130219653', 17:17:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:49 INFO - '_': '/tools/buildbot/bin/python'} 17:17:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:49 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)) 17:17:49 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)) 17:17:49 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)) 17:17:49 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)) 17:17:49 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)) 17:17:49 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)) 17:17:49 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)) 17:17:49 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)) 17:17:49 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)) 17:17:49 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)) 17:17:49 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)) 17:17:49 INFO - Cleaning up... 17:17:49 INFO - Return code: 0 17:17:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:17:49 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')]} 17:17:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:49 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')]} 17:17:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:49 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 0x7f77b04b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d749c0>, '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 0x1d758c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d75d50>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1463786537.67319-2130219653', '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 17:17:49 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 17:17:49 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 17:17:49 INFO - Using env: {'DISPLAY': ':0', 17:17:49 INFO - 'HOME': '/home/cltbld', 17:17:49 INFO - 'LANG': 'en_US.UTF-8', 17:17:49 INFO - 'LANGUAGE': 'en_US:en', 17:17:49 INFO - 'LOGNAME': 'cltbld', 17:17:49 INFO - 'MAIL': '/var/mail/cltbld', 17:17:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:49 INFO - 'MOZ_NO_REMOTE': '1', 17:17:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:49 INFO - 'NO_EM_RESTART': '1', 17:17:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:49 INFO - 'PWD': '/builds/slave/test', 17:17:49 INFO - 'SHELL': '/bin/bash', 17:17:49 INFO - 'SHLVL': '1', 17:17:49 INFO - 'TERM': 'linux', 17:17:49 INFO - 'TMOUT': '86400', 17:17:49 INFO - 'USER': 'cltbld', 17:17:49 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1463786537.67319-2130219653', 17:17:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:49 INFO - '_': '/tools/buildbot/bin/python'} 17:17:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:49 INFO - Downloading/unpacking jsonschema 17:17:49 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 17:17:49 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 17:17:49 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 17:17:49 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 17:17:49 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 17:17:49 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 17:17:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:17:51 INFO - Downloading/unpacking functools32 (from jsonschema) 17:17: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 17:17: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 17:17: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 17:17: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 17:17: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 17:17: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 17:17:51 INFO - Downloading functools32-3.2.3-2.tar.gz 17:17:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:17:51 INFO - warning: no files found matching '*.txt' 17:17:51 INFO - no previously-included directories found matching 'build' 17:17:51 INFO - no previously-included directories found matching 'dist' 17:17:51 INFO - no previously-included directories found matching '.git*' 17:17:51 INFO - Installing collected packages: jsonschema, functools32 17:17:51 INFO - Running setup.py install for functools32 17:17:51 INFO - warning: no files found matching '*.txt' 17:17:51 INFO - no previously-included directories found matching 'build' 17:17:51 INFO - no previously-included directories found matching 'dist' 17:17:51 INFO - no previously-included directories found matching '.git*' 17:17:51 INFO - Successfully installed jsonschema functools32 17:17:51 INFO - Cleaning up... 17:17:51 INFO - Return code: 0 17:17:51 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:17: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')]} 17:17:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17: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')]} 17:17:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f77b04b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c1a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce5770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d749c0>, '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 0x1d758c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d75d50>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1463786537.67319-2130219653', '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 17:17: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', 'flake8'] in /builds/slave/test/build 17:17: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 flake8 17:17:51 INFO - Using env: {'DISPLAY': ':0', 17:17:51 INFO - 'HOME': '/home/cltbld', 17:17:51 INFO - 'LANG': 'en_US.UTF-8', 17:17:51 INFO - 'LANGUAGE': 'en_US:en', 17:17:51 INFO - 'LOGNAME': 'cltbld', 17:17:51 INFO - 'MAIL': '/var/mail/cltbld', 17:17:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:51 INFO - 'MOZ_NO_REMOTE': '1', 17:17:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:51 INFO - 'NO_EM_RESTART': '1', 17:17:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:51 INFO - 'PWD': '/builds/slave/test', 17:17:51 INFO - 'SHELL': '/bin/bash', 17:17:51 INFO - 'SHLVL': '1', 17:17:51 INFO - 'TERM': 'linux', 17:17:51 INFO - 'TMOUT': '86400', 17:17:51 INFO - 'USER': 'cltbld', 17:17:51 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1463786537.67319-2130219653', 17:17:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:51 INFO - '_': '/tools/buildbot/bin/python'} 17:17:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:51 INFO - Downloading/unpacking flake8 17:17: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 17:17: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 17:17: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 17:17: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 17:17: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 17:17: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 17:17:53 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:17:53 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:17: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 17:17: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 17:17: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 17:17: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 17:17: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 17:17: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 17:17:53 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:17:53 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:17: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 17:17: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 17:17: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 17:17: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 17:17: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 17:17: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 17:17:54 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:17:54 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 17:17:54 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 17:17:54 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 17:17:54 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 17:17:54 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 17:17:54 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 17:17:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:17:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:17:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:17:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:17:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:17:54 INFO - no previously-included directories found matching 'docs/_build' 17:17:54 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:17:54 INFO - Running setup.py install for pep8 17:17:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:17:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:17:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:17:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:17:54 INFO - no previously-included directories found matching 'docs/_build' 17:17:54 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:17:54 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:17:54 INFO - Cleaning up... 17:17:54 INFO - Return code: 0 17:17:54 INFO - Running post-action listener: _resource_record_post_action 17:17:54 INFO - Running post-action listener: _start_resource_monitoring 17:17:54 INFO - Starting resource monitoring. 17:17:54 INFO - ##### 17:17:54 INFO - ##### Finished create-virtualenv step (success) 17:17:54 INFO - ##### 17:17:54 INFO - ##### 17:17:54 INFO - ##### Running install step. 17:17:54 INFO - ##### 17:17:54 INFO - Running pre-action listener: _resource_record_pre_action 17:17:54 INFO - Running main action method: install 17:17:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:17:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:17:54 INFO - Reading from file tmpfile_stdout 17:17:54 INFO - Detecting whether we're running mozinstall >=1.0... 17:17:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:17:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:17:54 INFO - Reading from file tmpfile_stdout 17:17:54 INFO - Output received: 17:17:54 INFO - Usage: mozinstall [options] installer 17:17:54 INFO - Options: 17:17:54 INFO - -h, --help show this help message and exit 17:17:54 INFO - -d DEST, --destination=DEST 17:17:54 INFO - Directory to install application into. [default: 17:17:54 INFO - "/builds/slave/test"] 17:17:54 INFO - --app=APP Application being installed. [default: firefox] 17:17:54 INFO - mkdir: /builds/slave/test/build/application 17:17:54 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'] 17:17:54 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 17:18:10 INFO - Reading from file tmpfile_stdout 17:18:10 INFO - Output received: 17:18:10 INFO - /builds/slave/test/build/application/firefox/firefox 17:18:10 INFO - Running post-action listener: _resource_record_post_action 17:18:10 INFO - ##### 17:18:10 INFO - ##### Finished install step (success) 17:18:10 INFO - ##### 17:18:10 INFO - ##### 17:18:10 INFO - ##### Running run-tests step. 17:18:10 INFO - ##### 17:18:10 INFO - Running pre-action listener: _resource_record_pre_action 17:18:10 INFO - Running main action method: run_tests 17:18:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:18:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:18:10 INFO - Python 2.7.3 17:18:10 INFO - Return code: 0 17:18:10 INFO - grabbing minidump binary from tooltool 17:18:10 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')]} 17:18:10 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 0x1d749c0>, '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 0x1d758c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d75d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:18:10 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 17:18:10 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 17:18:10 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 17:18:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:18:10 INFO - Return code: 0 17:18:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:18:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:18:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:18:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:18:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:18:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:18:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:18:11 INFO - Return code: 0 17:18:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ch5NgTVRT2WBN9LIlSPIQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 17:18:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ch5NgTVRT2WBN9LIlSPIQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --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 17:18:11 INFO - Using env: {'DISPLAY': ':0', 17:18:11 INFO - 'HOME': '/home/cltbld', 17:18:11 INFO - 'LANG': 'en_US.UTF-8', 17:18:11 INFO - 'LANGUAGE': 'en_US:en', 17:18:11 INFO - 'LOGNAME': 'cltbld', 17:18:11 INFO - 'MAIL': '/var/mail/cltbld', 17:18:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:18:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:18:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:11 INFO - 'MOZ_NO_REMOTE': '1', 17:18:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:18:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:18:11 INFO - 'NO_EM_RESTART': '1', 17:18:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:18:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:11 INFO - 'PWD': '/builds/slave/test', 17:18:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:18:11 INFO - 'SHELL': '/bin/bash', 17:18:11 INFO - 'SHLVL': '1', 17:18:11 INFO - 'TERM': 'linux', 17:18:11 INFO - 'TMOUT': '86400', 17:18:11 INFO - 'USER': 'cltbld', 17:18:11 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1463786537.67319-2130219653', 17:18:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:11 INFO - '_': '/tools/buildbot/bin/python'} 17:18:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ch5NgTVRT2WBN9LIlSPIQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 17:18:11 INFO - mozversion application_buildid: 20160520160630 17:18:11 INFO - mozversion application_changeset: 45709b7b6466abcd984d5736c0e64eb12b0044cc 17:18:11 INFO - mozversion application_display_name: Nightly 17:18:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:18:11 INFO - mozversion application_name: Firefox 17:18:11 INFO - mozversion application_remotingname: firefox 17:18:11 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:18:11 INFO - mozversion application_vendor: Mozilla 17:18:11 INFO - mozversion application_version: 49.0a1 17:18:11 INFO - mozversion platform_buildid: 20160520160630 17:18:11 INFO - mozversion platform_changeset: 45709b7b6466abcd984d5736c0e64eb12b0044cc 17:18:11 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:18:11 INFO - mozversion platform_version: 49.0a1 17:18:11 INFO - using testdate: 1463789891 17:18:11 INFO - actual date: 1463789891 17:18:11 INFO - starting webserver on 'localhost:41681' 17:18:11 INFO - SUITE-START | Running 2 tests 17:18:11 INFO - TEST-START | dromaeo_css 17:18:11 INFO - operating with platform_type : linux_ 17:18:11 INFO - Initialising browser for dromaeo_css test... 17:18:11 INFO - TEST-INFO | started process 11296 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptrcRnY/profile http://localhost:41681/getInfo.html) 17:18:15 INFO - PROCESS | 11296 | __metrics Screen width/height:1600/1200 17:18:15 INFO - PROCESS | 11296 | colorDepth:24 17:18:15 INFO - PROCESS | 11296 | Browser inner width/height: 1024/697 17:18:15 INFO - PROCESS | 11296 | __metrics 17:18:16 ERROR - PROCESS | 11296 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:18:17 INFO - TEST-INFO | 11296: exit 0 17:18:17 INFO - Browser initialized. 17:18:17 INFO - Running cycle 1/1 for dromaeo_css test... 17:18:17 INFO - TEST-INFO | started process 11375 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptrcRnY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:18:29 INFO - PROCESS | 11375 | RSS: Main: 153845760 17:18:29 INFO - PROCESS | 11375 | 17:19:21 INFO - PROCESS | 11375 | 1463789961036 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] 17:21:32 INFO - PROCESS | 11375 | Cycle 1(1): loaded http://localhost:41681/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41681/tests/dromaeo/cssquery-ext.html) 17:21:33 INFO - PROCESS | 11375 | RSS: Main: 271568896 17:21:33 INFO - PROCESS | 11375 | 17:24:36 INFO - PROCESS | 11375 | Cycle 1(1): loaded http://localhost:41681/tests/dromaeo/cssquery-ext.html (next: http://localhost:41681/tests/dromaeo/cssquery-jquery.html) 17:24:37 INFO - PROCESS | 11375 | RSS: Main: 241549312 17:24:37 INFO - PROCESS | 11375 | 17:27:39 INFO - PROCESS | 11375 | Cycle 1(1): loaded http://localhost:41681/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41681/tests/dromaeo/cssquery-mootools.html) 17:27:39 INFO - PROCESS | 11375 | RSS: Main: 243785728 17:27:39 INFO - PROCESS | 11375 | 17:30:41 INFO - PROCESS | 11375 | Cycle 1(1): loaded http://localhost:41681/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41681/tests/dromaeo/cssquery-prototype.html) 17:30:42 INFO - PROCESS | 11375 | RSS: Main: 235307008 17:30:42 INFO - PROCESS | 11375 | 17:33:45 INFO - PROCESS | 11375 | Cycle 1(1): loaded http://localhost:41681/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41681/tests/dromaeo/cssquery-yui.html) 17:33:45 INFO - PROCESS | 11375 | RSS: Main: 210763776 17:33:45 INFO - PROCESS | 11375 | 17:36:48 INFO - PROCESS | 11375 | Cycle 1(1): loaded http://localhost:41681/tests/dromaeo/cssquery-yui.html (next: http://localhost:41681/tests/dromaeo/cssquery-dojo.html) 17:36:48 INFO - PROCESS | 11375 | RSS: Main: 272801792 17:36:48 INFO - PROCESS | 11375 | 17:36:48 INFO - PROCESS | 11375 | __start_tp_report 17:36:48 INFO - PROCESS | 11375 | _x_x_mozilla_page_load 17:36:48 INFO - PROCESS | 11375 | _x_x_mozilla_page_load_details 17:36:48 INFO - PROCESS | 11375 | |i|pagename|runs| 17:36:48 INFO - PROCESS | 11375 | |0;dojo.html;2650.5096557136917;2659.6675415573054;2692.7845772338214;2704.2968828104695;2714.172177485866;4607.239805432104;4614.054118905625;4673.158831410345;4722.480527142012;4775.426948766149;4662.766861656912;4666.253399456088;4708.43498780146;4726.291056341551;4756.500567440421;4285.057287396783;4334.739915605058;4341.848035318764;4351.651867850573;4509.368688383629;4387.670924680646;4409.735415875041;4465.218586747323;4469.910601787962;4519.864404067883;4199.9790001050105;4433.556644335573;4436.334549817521;4483.6188923941345;4493.393391892102;4237.555056719062;4256.702030857841;4287.206866729665;4294.119705460374;4295.978520107411;4233.23801715691;4293.463317085364;4349.80425880833;4358.542353052915;4413;4450.1767173073085;4593.44878614565;4609.815607375701;4611.584957353854;4636.675432719711;5037;5066.088104141253;5077.060743762416;5166.250893620441;5171.818986335498;5144.794208231666;5147.202183661501;5152.896942061137;5235.267062611238;5244.265802787613;4605.240135377692;4677.3919390479705;4731.716097034155;4770.212914869077;4770.809167633325;5115.97442012795;5124.128898087334;5168.870778230575;5191.5846732261325;5229.450907654717;4969.006198760262;4995.500449955048;5012;5021.72380519075;5023.924641130386;4886.755662216875;4961.875953101201;4973.651844370859;5028.270900719375;5054.166062599704;4928.359313289321;4961.82633607822;4971.353724015855;4978.079055374767;4982.302477653131;4990.4011518618;4992.326035985168;4995.650304478651;5005.424376196784;5029.220470827027;4194.664426845845;4224.936625950613;4251.80866860992;4311.9784401077795;4322.589354011364;3745.6254374562327;3766.548014238309;3769.0577355661085;3798.582155962842;3815.923681526354;4295.398644189816;4312.37470566766;4325.502567204749;4333.783310834446;4342.848000319974;4875.926861097087;5003.524665156804;5057.721825299644;5070.340855688811;5082.847514574569;4288.463942007249;4291.485021797404;4314.395984562164;4321.848735294249;4372.715773474714;4570.154521413549;4572.428446444194;4585.908281834345;4588.977055114769;4637.652176086807;4561.064981678748;4676.485586585541;4733.692309999839;4741.83403580873;4746.833860814855;5059.367579052619;5069.391672999116;5083.237514372874;5088.542031217208;5110.284560161655;4578.359029735773;4726.9600687848615;4763.0235801661265;4769.449928773093;4813.638977076804;4927.630427718007;4950.133726597759;4975.626827987843;4997.325361076353;5000.2499625056535;5020.096382651158;5024.974875125601;5028.622853285945;5067.189249720027;5119.820806271762;4728.905421891612;4823.734694591691;4892.996935628116;4912.042151780369;4937.23472861707;4843.07981483517;4884.951150488591;4905.4358748742925;4908.312836202863;4950.876228094183;4787.808487660454;4814.085323788469;4851.34506841586;4867.269909513601;4867.464578896389;4846.612271018381;4905.705657660552;4936.185529387611;4996.800127994985;5009.824656137018;4707.78814953321;4731.621470282438;4746.406699162605;4784.449788274393;4795.376601041842 17:36:48 INFO - PROCESS | 11375 | |1;ext.html;568.2073507457097;572.507643426653;573.3463851209619;578.8581797459623;586.8767558812649;27179.320516987085;40250.194996100094;41215;41428.37857432134;44585.33122003164;41600.37599436003;42098;42139.57860421395;42284.57715422845;42337.7883110584;7292.8906066409045;7548.811279718024;7732.149463559004;7735.8066048348965;7737.690492380298;9574.377665451759;9896.703098907044;9908.554115064839;10270.897291027106;10280.12618927392;9835.508224588777;9842.753931151707;9968.601255949754;9971.601135954554;9978.950105249463;7289.125304963385;9544.809103817954;9805.1665608423;9835.508224588777;9860.704178874645;9809.313348065638;9815.852762208573;9836.3606365586;9839.065288797552;9862.112409883144;38658.42012369817;39133;39157;39272.80363598192;39310;2921.7224363685414;3032.2116249774995;3099.9535006974916;3100.6589275179713;3532.929341413183;29023.274418139503;29163.41673166546;29242.561361579592;29475.41049179026;30018.24954376136;3410.0963244740165;3483.028460349918;3509.5788505379264;3527.753057285991;3535.3636345457808;262722;264705;266115.9999999981;266463;266476;54681.72659136679;54688.726556366964;54701.179482307794;54913.450865490835;54981.72509137429;34736.131596709776;35708;35762.46356304658;35797.1050723734;35849.28301433957;12307.630771076882;12560.246385216917;12591.496340146476;12606.306653133983;12613.180143290656;7973.44185906981;8562.52906090171;8599.742007739778;8852.734417967471;8852.955735221283;17978.730319045226;18025.7296140558;18085.457436276934;18092.095395230186;18149.183286752126;6803.752487444305;6915.827104322432;6952.826179345456;6961.23426423093;6983.615901125385;804.9074356449083;884.2660591708994;941.1905761045496;943.5140902435114;974.055166488505;25742.48515029689;26381.20856374312;26690.466190676467;26910.5963410549;27012.594811077848;962.8074385123003;984.2322988069318;993.7714325704984;1023.2223510132353;1032.9896701033044;13814.309284535733;14198.580141985925;14465.78301325481;14536.127832330094;14616.48842290536;299394;302084;302197;302806;303740;46179;46698.299525507144;46709.29936050962;46744.2988355175;46823.76588117106;1080.6055789636882;1182.2669944634554;1188.6909403555137;1203.356204430643;1207.6014915078179;27564.586531201647;28897.711022889504;29001;29282;29375.85312073426;40852.387214191214;46424.30363544482;48518.757406212746;48814.511854881;53564.73217633887;336447;337615;343241;343264;344899;31411.52882706807;36121.63878361183;37863.81068094642;38405.6159438402;41456.3781543271;41738.58261417347;42073.579264206965;42238.366424503045;42718.359224611035;42897.785511072245;35708.46437303391;36085;36388;36594;36829.44755828611;35444;35456.46815297824;35479.64520354763;35492;35990.46014309735;34574.30851383009;34823;34865.30269394547;35514.28971420506;35614.28771424505;31206.687933120378;32008.839955801002;32020.63100789085;32110.67889321077;32131.714731411415;24289.75710242875;24761.504769904863;24925.501489970462;24952.500949981262;24978.42559198676 17:36:48 INFO - PROCESS | 11375 | |2;jquery.html;347.1512152786438;354.6719284661688;364.59165734377484;372.60689972079444;381.6965512417628;15209.163496007715;16192.190390480459;16371;16606.584835379123;16614.83385166148;14534.127952322868;15712.214389280547;15893.125878076702;15918.840811591881;15973.121478318688;4807.783649735761;4944.283078953549;5069.011542749147;5090.872728181806;5113.539781419671;3626.3653860574427;3815;4962.230854217602;5511.944880551183;5788.42115788422;5878.235829342201;5899.203607512974;5920.111983202511;5933.19901813254;5937.435943585352;5689.11818668105;5878.823635290948;5891.086881533369;5894.528437724993;5897.734601942923;3343.4483310254022;4815.855524334275;5174.715390653512;5184.248283998799;5184.870378240575;19313.51716207092;20108;20228.49428764278;20235.79764202354;20245;1883.4726276642562;1925.9794436829084;1958.9608207835906;1975.7530308711412;2024.7570291565107;6199.132121502993;6209.410106039964;6250.43746062852;11890.940545297304;12441.305173137222;1731;1762.4095927864053;1764.1003088424868;1771.158699617684;1796.8023517413073;62962.68518657378;64763;64908;65021.67489162571;65100.674496627216;9442.480663563432;9490.193333566724;9775.217982561378;9809.21526277896;9874.308798384187;13381.397837097355;13457.596272111852;13478.39347229377;13489.325533723471;13496.797548036788;6641.900371494431;6651.66741662915;6684.933150668431;6816;6822.0108084328485;6073.058675905153;6115.4801841843055;6137.60105593135;6142.170806941006;6198.938010619926;6104.725287362079;6209.161763162006;6217.533684973645;6217.751289948442;6315.273743519554;1620.198001989023;1708.5045336852174;1764.6911790436623;1801.1174524482908;1805.954851128706;838.6100463284602;846.8941382327209;880.4585180114184;888.2316795971439;1008.6822650864954;15834.841651583567;16489;17930.282788688306;18039.72940405895;18095.909520452315;867.1068799136899;875.4922145155795;896.4352457951449;902.0798785239019;915.1077699243318;8088.514689118554;9850.408975461496;10192.694219173436;10231.820883693195;10286.691399258034;382602;394633;403873;405012;407884;45786.77106614512;74645.25354746492;77045.6147719269;77395;80482.5975870117;919.2783664823215;939.2063706168277;951.6669165791917;971.6550624528332;975.7219192530094;15384.461543845911;15402.15288159162;15701.450449234222;15766.605834854221;16067.598310041874;30898.53652195174;30988.22529436782;31689.366212675155;33062.33875322528;33396.66603334033;46095.3085703708;48152.27771583359;48165.27752083651;48523.5147648519;48573.5142648569;7643.847123057397;7718.228177182237;7759.379249660126;7786.649600767866;7832.412569057229;7383.114026316876;10318.845217321596;11136.164787640797;11158.832617510581;11457.19799614019;6963.442924565921;7423.183449820407;8000.759977200693;9529.809403812023;9717.12545870875;9238.95380523093;9249.588990440667;9461.810763784548;9483.336166468282;9615.086566776425;9544.33189676716;9875.901240987498;10132.44271565071;10225.079742823182;10424.426656533964;7584.54492730438;7665.156832748282;7821.335186508983;7866.842663146819;8015.078265999485;9898.604055837686;10314.896851031393;10362.585496580052;10510.527026283682;10524.105451036748 17:36:48 INFO - PROCESS | 11375 | |3;mootools.html;1257.4467234416861;1409.1052181864513;1450.4923276853103;1545.6599548099414;1756.7628370170023;6576.210854697431;7294.562326260428;7557.168711441737;7564.583947882864;7686.385089192865;7483.73806916758;7606.125295591009;7628.771136865889;7678.385729141669;7687.2312768723095;2155.622766015949;2176.9455763605956;2180.6292930201903;2183.792539708725;2197.252934002439;2143.839212059094;2157.805797478227;2177.7277840269967;2186.868787872733;2187.0486338442747;2153.353993801861;2153.7846215378413;2159.384575396012;2171.294329342962;2188.5075857931915;2104.926327578535;2109.4620871677703;2110.345792804228;2113.608982338257;2132.3070002249174;2076.6158260721813;2103.842211834103;2104.400245929918;2116.7883211678864;2124.3945475539554;7576.583287919162;7607.695692172307;7633.618319084024;7673.424493163036;7707.499012564165;4156.418101465797;4263.275243208662;4382.649388048949;4385.166818304512;4389.780510974439;2736;2849.700781417963;2876.453473839964;2876.467853447098;2911.3595009098176;852.3224036890687;852.3735054734765;863.96976105836;883.3595643158723;884.2042162054138;10250;10355.326903751233;10363.32638378503;10364.63723769672;10367.896321036844;3878.7090968176935;3931.3906344516645;4003.739756915791;4039.3537034074407;4041.6766658667234;8193.09875913649;8268.338532917352;8290.08809031006;8294.253517183482;8322.29260512851;4277.230098582223;4278.251306021434;4296.742195468282;4298.183345164409;4317.784110794448;3424.7260219182403;3848.0572259796527;3885;3964.464797252334;3972.3842804365368;3368.764186506921;3387.9322413552086;3398;3432.1076520104953;3443.8794642187404;971.533663841346;975.687779910436;976.038601977052;983.2134292565919;990.881094268678;838.6393850644281;845.8688903220011;847.2374862623565;855.5850412549909;866.3718803867146;5134.365855968585;5299.682019078868;5301.443348448434;5431.4840090191365;5504.4770746778995;414.75114931041134;421.55736476699343;428.59069588542866;430.60384446309473;432.4615853262708;3673.81630918453;3745.5692595351884;3751.3247615429486;3767.9434808477895;3794;9186.724398267928;9673.564689588986;9695.90304096964;9751.756206094762;9840.409575425354;9673.177779888647;9694;9706.563204655808;9710.805783884283;9714.319997600242;6944.826379340557;7231.819204519824;7301.488895777351;7360.411167106726;7388.630568471555;5363.03465376236;5430.647007944471;5446.373667028184;5575.553955683617;5633.239512665901;8725.563721813756;8769.254613357682;8971.685990990283;8972.327075469235;9052.502112383881;8685.218330350299;9028.458292502472;9184.58669359867;9309.906900931175;9360.906390936003;6527.11883895668;6562.967185164043;6658.866822663616;6692.130023097161;6710;7341.045664063638;7380.18817930038;7415.666295016629;7423.703051877865;7452.813679658052;6518.902216466851;6700.631465269457;6710.563813352116;6711.597304161766;6821.454283657395;6654.802135615636;6718.731250750111;6720.697568609522;6794.660266986532;6807.591544507147;5743.1385292206505;5962.970185149046;5998.560345517132;6308.14839996613;6429.7749578764515;4649.116667833101;4674;4681.695689780154;4748.3352330674425;4815.422149342101;4577.656675749266;4765.904681906273;4789.61683065347;4846.95153048465;4945.035718034948 17:36:48 INFO - PROCESS | 11375 | |4;prototype.html;292.2489202748935;294.42146182750906;294.7052947052947;300.50866832728497;301.08920515440803;4751.38232029836;4801.3195381616415;4806.927896081562;4811.326414302001;4828.396450443694;4725.929111063337;4733;4738.123447162268;4765.928511072337;4769.785359658815;3565.447355659877;3604.6395360463875;3695.778253304797;3696.907577310562;3702.833372498244;3674.50394196784;3689.3912504436735;3692.335379631665;3697.907552311187;3700.1859590889962;3554.92890142197;3706.4996225509617;3719.4420836874415;3720.7395482316247;3724.6461586149408;3642.417213245881;3730.4963829883027;3731.477593136963;3740.3828368319196;3757.3236817372863;3317.6018877734587;3330.2673411849355;3332.866825279417;3339;3347.029361485166;4512.187806194884;4527.388802511652;4530.026044400437;4536.682432229745;4538.251188553884;3944.5266568011734;4181.435506206653;4251.617354438115;4252.447181866369;4267.765272909989;4940.34498443022;4962.305277261186;4966.404031516205;4991.725455099968;5018.121828679967;3521.8591256349714;3547.130952916552;3552.378333791576;3568.3220188164423;3569.9107522311892;5048.570871475929;5219.815912293498;5226.087477770883;5239.449857764918;5256.842294731164;3566.268914872445;3598.758428342218;3601.873934412283;3613.9819300903855;3632;3661.8169091545315;3666.358387282215;3669.486271921933;3673.5959044505084;3692.9076773080888;4203.684723645739;4204.309242085068;4205.726627769246;4213.4522512073845;4234.809433575497;4806.711597304173;4941.382327209099;4961.627877909171;4966.776495057731;4979.701217926936;1251.7934540800666;1264.3488603369271;1277.3421687830776;1278.7889998150388;1278.9872101278868;792.6631181747734;804.3404408385185;812.070179644304;812.9309008734206;841.1126261793867;4286.592773686495;4294.806733696991;4302.064071167924;4319.956800431955;4340.956590434055;5048.368953880765;5054.393472783289;5081.5426611605135;5083.415407228142;5084.3644544431945;4202.348635961431;4310.943818764423;4314.050908800059;4333.8699839004885;4343;2682.9731702682725;2699.932501687434;2715.8777854996574;2717.1033558925506;2720.931976700598;4679.485256621769;4713.387259656222;4731.716097034189;4736.881577960509;4773.451053128865;5003.74981250936;5065.7720402581235;5119.718415487184;5168.198929165986;5202.791888324425;4669.252919532859;4691.319758634979;4709.458412282563;4749.928751068736;4761.309610106585;5001.874953126201;5011.624128190328;5014.247862820606;5060.595152387727;5108.79564817418;4797.880052998703;4966.826161084345;4984.632299657634;4990.925136122888;5015.019067468403;4714.467797965606;4720.858374248778;4730.385049943486;4751.956658636819;4767.380240568704;3578.946315805317;3585.6952159065727;3599.604043555259;3606.1886075632774;3619.4570814378053;4943.382077240345;5061.848144555669;5062.417821950523;5080.796768129233;5084.745762711776;4925.285833554043;4926.605871530197;4936.456989731055;4938.703677779345;4956.603471722182;4933.309336692794;4938.802447902043;4945.208766597471;4976.427710813303;4990.180547990519;4611.400517932647;4762.4285085789925;4784.354112194809;4799.616030717604;4804.927926081182;4795.352627395397;4887.3890763654545;4999.900002000012;5011.924821127613;5039.974800125976;4897.583705385082;4918.778654960607;4922.950770492249;4951.356323678043;4952.4057113146655 17:36:48 INFO - PROCESS | 11375 | |5;yui.html;600.5285850607273;707.6108140522712;747.6224506624154;754.9660265288062;759.1535437986646;10960.177986651002;11534.365609891453;11539.192256542035;11566.190366674336;11586.304821710703;11896.524139034429;12133.453994570244;12199.14605977582;12253.448594813233;12271.263724176555;612.0879888965454;751.0949306086153;759.4873460414212;783.0877028262096;785.1873311122961;788.5978151142901;790.4111436979458;792.2315354106507;794.9085855126648;795.220683729945;824.389951435936;825.5046971816892;830.8546004449228;831.7712629027036;834.0408530190269;651.5601968671152;796.9760907172736;821.0229826506497;826.0294154368623;831.3723139030024;601.0533409879414;601.3685630088389;602.169006770658;603.3483837455537;605.0410099991519;10919.890801092046;11018.724531886766;11036.448177591168;11039.503222355013;11048.447577621087;11604.071674266122;11771.234869733526;11775.762605105003;12239.877601223963;12624.495020199181;11024.50389732464;11031.117510599133;11213.775724485464;11277.830832537518;11327.546898124065;4183.748975061506;4197.097624010822;4209.663226941837;4261.147770445892;4333.588309110661;43417.56582434167;43705.56294437079;43778;44060;44136.558634413566;10093.646722364681;10141.340812847142;10290.485475726333;10313.74215644615;10417.427041512638;17286.913565432093;17635.206415711324;17675.73486397705;17722.822771772117;17818.287268509113;6714.764983225564;6869.896951545731;6980.371766541036;7092.751753688596;7205.747798827016;3741.7754934704003;3785.299719551892;3832.1186127190904;3849.4995650565247;3905.6680182184264;2732.207659778682;2793.678726946427;2804.5092108880863;2815.704351043111;2816.8309901405983;468.26248658362533;473.27588789151963;473.34678144160836;477.4032459425718;479.6690283704233;501.4534157767977;522.7203446156288;593.8337265565649;624.4192900602393;633.9683015849189;7378.704851805867;7677.884831727529;7706.537607743553;7894.289513943772;7904.960475197588;599.7511032921376;600.9819705408845;623.8440389902524;630.7729217481703;632.6804963493406;3639.47227651989;3732.458793474931;3756.6806821419937;3790.3556395412847;3806.2197249563774;52925.2061219082;53016;54255.72872135614;54403.72798135984;54411.18383224255;47017.52982470131;47318;47800.521994780305;48442.757786210845;48770;44327.335089973676;44719.55280447154;45162.774186129514;45323.77338113288;45607.31589026167;7127.465440092117;7448.255174482509;7465.477416580788;7476.289752473506;7567.281108294703;30067;30160;30223;30981;31399.84300078485;36062;37944;39237.80381098076;39815.203695926495;40377;10307.072363487323;10380.792384152426;10567.313124646873;10596.89403105959;10636.946815265874;10784.568617255536;10905.836412453978;10994;11146.331220126818;11279.548818047186;9427.481488518197;9880.802383952425;9931.205503559553;10147.949260253652;10500.212484063573;9716.368436051634;9799.510024498604;9824.705258842247;10038.849417258893;10179.083882450615;9866.260030497599;10141.391516509033;10159.54282057324;10177.592896284066;10301.227407944583;8503.532305723245;8508.829823403621;8762.780930476789;8778.297736181217;8959.686410975584;8457.323414126731;8760.824783504422;8813.42712723671;8896.911030889609;8923.724450265141 17:36:48 INFO - PROCESS | 11375 | __end_tp_report 17:36:48 INFO - PROCESS | 11375 | __start_cc_report 17:36:48 INFO - PROCESS | 11375 | _x_x_mozilla_cycle_collect,1033 17:36:48 INFO - PROCESS | 11375 | __end_cc_report 17:36:48 INFO - PROCESS | 11375 | __startTimestamp1463791008464__endTimestamp 17:36:48 INFO - PROCESS | 11375 | 17:36:48 INFO - PROCESS | 11375 | ------- Summary: start ------- 17:36:48 INFO - PROCESS | 11375 | Number of tests: 6 17:36:48 INFO - PROCESS | 11375 | 17:36:48 INFO - PROCESS | 11375 | [#0] dojo.html Cycles:165 Average:4657.47 Median:4756.50 stddev:480.12 (10.1%) stddev-sans-first:455.05 17:36:48 INFO - PROCESS | 11375 | Values: 2650.5 2659.7 2692.8 2704.3 2714.2 4607.2 4614.1 4673.2 4722.5 4775.4 4662.8 4666.3 4708.4 4726.3 4756.5 4285.1 4334.7 4341.8 4351.7 4509.4 4387.7 4409.7 4465.2 4469.9 4519.9 4200.0 4433.6 4436.3 4483.6 4493.4 4237.6 4256.7 4287.2 4294.1 4296.0 4233.2 4293.5 4349.8 4358.5 4413.0 4450.2 4593.4 4609.8 4611.6 4636.7 5037.0 5066.1 5077.1 5166.3 5171.8 5144.8 5147.2 5152.9 5235.3 5244.3 4605.2 4677.4 4731.7 4770.2 4770.8 5116.0 5124.1 5168.9 5191.6 5229.5 4969.0 4995.5 5012.0 5021.7 5023.9 4886.8 4961.9 4973.7 5028.3 5054.2 4928.4 4961.8 4971.4 4978.1 4982.3 4990.4 4992.3 4995.7 5005.4 5029.2 4194.7 4224.9 4251.8 4312.0 4322.6 3745.6 3766.5 3769.1 3798.6 3815.9 4295.4 4312.4 4325.5 4333.8 4342.8 4875.9 5003.5 5057.7 5070.3 5082.8 4288.5 4291.5 4314.4 4321.8 4372.7 4570.2 4572.4 4585.9 4589.0 4637.7 4561.1 4676.5 4733.7 4741.8 4746.8 5059.4 5069.4 5083.2 5088.5 5110.3 4578.4 4727.0 4763.0 4769.4 4813.6 4927.6 4950.1 4975.6 4997.3 5000.2 5020.1 5025.0 5028.6 5067.2 5119.8 4728.9 4823.7 4893.0 4912.0 4937.2 4843.1 4885.0 4905.4 4908.3 4950.9 4787.8 4814.1 4851.3 4867.3 4867.5 4846.6 4905.7 4936.2 4996.8 5009.8 4707.8 4731.6 4746.4 4784.4 4795.4 17:36:48 INFO - PROCESS | 11375 | 17:36:48 INFO - PROCESS | 11375 | [#1] ext.html Cycles:180 Average:46064.08 Median:35919.87 stddev:79710.58 (221.9%) stddev-sans-first:79860.99 17:36:48 INFO - PROCESS | 11375 | Values: 568.2 572.5 573.3 578.9 586.9 27179.3 40250.2 41215.0 41428.4 44585.3 41600.4 42098.0 42139.6 42284.6 42337.8 7292.9 7548.8 7732.1 7735.8 7737.7 9574.4 9896.7 9908.6 10270.9 10280.1 9835.5 9842.8 9968.6 9971.6 9979.0 7289.1 9544.8 9805.2 9835.5 9860.7 9809.3 9815.9 9836.4 9839.1 9862.1 38658.4 39133.0 39157.0 39272.8 39310.0 2921.7 3032.2 3100.0 3100.7 3532.9 29023.3 29163.4 29242.6 29475.4 30018.2 3410.1 3483.0 3509.6 3527.8 3535.4 262722.0 264705.0 266116.0 266463.0 266476.0 54681.7 54688.7 54701.2 54913.5 54981.7 34736.1 35708.0 35762.5 35797.1 35849.3 12307.6 12560.2 12591.5 12606.3 12613.2 7973.4 8562.5 8599.7 8852.7 8853.0 17978.7 18025.7 18085.5 18092.1 18149.2 6803.8 6915.8 6952.8 6961.2 6983.6 804.9 884.3 941.2 943.5 974.1 25742.5 26381.2 26690.5 26910.6 27012.6 962.8 984.2 993.8 1023.2 1033.0 13814.3 14198.6 14465.8 14536.1 14616.5 299394.0 302084.0 302197.0 302806.0 303740.0 46179.0 46698.3 46709.3 46744.3 46823.8 1080.6 1182.3 1188.7 1203.4 1207.6 27564.6 28897.7 29001.0 29282.0 29375.9 40852.4 46424.3 48518.8 48814.5 53564.7 336447.0 337615.0 343241.0 343264.0 344899.0 31411.5 36121.6 37863.8 38405.6 41456.4 41738.6 42073.6 42238.4 42718.4 42897.8 35708.5 36085.0 36388.0 36594.0 36829.4 35444.0 35456.5 35479.6 35492.0 35990.5 34574.3 34823.0 34865.3 35514.3 35614.3 31206.7 32008.8 32020.6 32110.7 32131.7 24289.8 24761.5 24925.5 24952.5 24978.4 17:36:48 INFO - PROCESS | 11375 | 17:36:48 INFO - PROCESS | 11375 | [#2] jquery.html Cycles:180 Average:23843.89 Median:5079.94 stddev:65616.64 (1291.7%) stddev-sans-first:65776.99 17:36:48 INFO - PROCESS | 11375 | Values: 347.2 354.7 364.6 372.6 381.7 15209.2 16192.2 16371.0 16606.6 16614.8 14534.1 15712.2 15893.1 15918.8 15973.1 4807.8 4944.3 5069.0 5090.9 5113.5 3626.4 3815.0 4962.2 5511.9 5788.4 5878.2 5899.2 5920.1 5933.2 5937.4 5689.1 5878.8 5891.1 5894.5 5897.7 3343.4 4815.9 5174.7 5184.2 5184.9 19313.5 20108.0 20228.5 20235.8 20245.0 1883.5 1926.0 1959.0 1975.8 2024.8 6199.1 6209.4 6250.4 11890.9 12441.3 1731.0 1762.4 1764.1 1771.2 1796.8 62962.7 64763.0 64908.0 65021.7 65100.7 9442.5 9490.2 9775.2 9809.2 9874.3 13381.4 13457.6 13478.4 13489.3 13496.8 6641.9 6651.7 6684.9 6816.0 6822.0 6073.1 6115.5 6137.6 6142.2 6198.9 6104.7 6209.2 6217.5 6217.8 6315.3 1620.2 1708.5 1764.7 1801.1 1806.0 838.6 846.9 880.5 888.2 1008.7 15834.8 16489.0 17930.3 18039.7 18095.9 867.1 875.5 896.4 902.1 915.1 8088.5 9850.4 10192.7 10231.8 10286.7 382602.0 394633.0 403873.0 405012.0 407884.0 45786.8 74645.3 77045.6 77395.0 80482.6 919.3 939.2 951.7 971.7 975.7 15384.5 15402.2 15701.5 15766.6 16067.6 30898.5 30988.2 31689.4 33062.3 33396.7 46095.3 48152.3 48165.3 48523.5 48573.5 7643.8 7718.2 7759.4 7786.6 7832.4 7383.1 10318.8 11136.2 11158.8 11457.2 6963.4 7423.2 8000.8 9529.8 9717.1 9239.0 9249.6 9461.8 9483.3 9615.1 9544.3 9875.9 10132.4 10225.1 10424.4 7584.5 7665.2 7821.3 7866.8 8015.1 9898.6 10314.9 10362.6 10510.5 10524.1 17:36:48 INFO - PROCESS | 11375 | 17:36:48 INFO - PROCESS | 11375 | [#3] mootools.html Cycles:180 Average:5039.45 Median:5438.93 stddev:2857.19 (52.5%) stddev-sans-first:2851.07 17:36:48 INFO - PROCESS | 11375 | Values: 1257.4 1409.1 1450.5 1545.7 1756.8 6576.2 7294.6 7557.2 7564.6 7686.4 7483.7 7606.1 7628.8 7678.4 7687.2 2155.6 2176.9 2180.6 2183.8 2197.3 2143.8 2157.8 2177.7 2186.9 2187.0 2153.4 2153.8 2159.4 2171.3 2188.5 2104.9 2109.5 2110.3 2113.6 2132.3 2076.6 2103.8 2104.4 2116.8 2124.4 7576.6 7607.7 7633.6 7673.4 7707.5 4156.4 4263.3 4382.6 4385.2 4389.8 2736.0 2849.7 2876.5 2876.5 2911.4 852.3 852.4 864.0 883.4 884.2 10250.0 10355.3 10363.3 10364.6 10367.9 3878.7 3931.4 4003.7 4039.4 4041.7 8193.1 8268.3 8290.1 8294.3 8322.3 4277.2 4278.3 4296.7 4298.2 4317.8 3424.7 3848.1 3885.0 3964.5 3972.4 3368.8 3387.9 3398.0 3432.1 3443.9 971.5 975.7 976.0 983.2 990.9 838.6 845.9 847.2 855.6 866.4 5134.4 5299.7 5301.4 5431.5 5504.5 414.8 421.6 428.6 430.6 432.5 3673.8 3745.6 3751.3 3767.9 3794.0 9186.7 9673.6 9695.9 9751.8 9840.4 9673.2 9694.0 9706.6 9710.8 9714.3 6944.8 7231.8 7301.5 7360.4 7388.6 5363.0 5430.6 5446.4 5575.6 5633.2 8725.6 8769.3 8971.7 8972.3 9052.5 8685.2 9028.5 9184.6 9309.9 9360.9 6527.1 6563.0 6658.9 6692.1 6710.0 7341.0 7380.2 7415.7 7423.7 7452.8 6518.9 6700.6 6710.6 6711.6 6821.5 6654.8 6718.7 6720.7 6794.7 6807.6 5743.1 5963.0 5998.6 6308.1 6429.8 4649.1 4674.0 4681.7 4748.3 4815.4 4577.7 4765.9 4789.6 4847.0 4945.0 17:36:48 INFO - PROCESS | 11375 | 17:36:48 INFO - PROCESS | 11375 | [#4] prototype.html Cycles:180 Average:4102.74 Median:4713.93 stddev:1185.53 (25.1%) stddev-sans-first:1153.84 17:36:48 INFO - PROCESS | 11375 | Values: 292.2 294.4 294.7 300.5 301.1 4751.4 4801.3 4806.9 4811.3 4828.4 4725.9 4733.0 4738.1 4765.9 4769.8 3565.4 3604.6 3695.8 3696.9 3702.8 3674.5 3689.4 3692.3 3697.9 3700.2 3554.9 3706.5 3719.4 3720.7 3724.6 3642.4 3730.5 3731.5 3740.4 3757.3 3317.6 3330.3 3332.9 3339.0 3347.0 4512.2 4527.4 4530.0 4536.7 4538.3 3944.5 4181.4 4251.6 4252.4 4267.8 4940.3 4962.3 4966.4 4991.7 5018.1 3521.9 3547.1 3552.4 3568.3 3569.9 5048.6 5219.8 5226.1 5239.4 5256.8 3566.3 3598.8 3601.9 3614.0 3632.0 3661.8 3666.4 3669.5 3673.6 3692.9 4203.7 4204.3 4205.7 4213.5 4234.8 4806.7 4941.4 4961.6 4966.8 4979.7 1251.8 1264.3 1277.3 1278.8 1279.0 792.7 804.3 812.1 812.9 841.1 4286.6 4294.8 4302.1 4320.0 4341.0 5048.4 5054.4 5081.5 5083.4 5084.4 4202.3 4310.9 4314.1 4333.9 4343.0 2683.0 2699.9 2715.9 2717.1 2720.9 4679.5 4713.4 4731.7 4736.9 4773.5 5003.7 5065.8 5119.7 5168.2 5202.8 4669.3 4691.3 4709.5 4749.9 4761.3 5001.9 5011.6 5014.2 5060.6 5108.8 4797.9 4966.8 4984.6 4990.9 5015.0 4714.5 4720.9 4730.4 4752.0 4767.4 3578.9 3585.7 3599.6 3606.2 3619.5 4943.4 5061.8 5062.4 5080.8 5084.7 4925.3 4926.6 4936.5 4938.7 4956.6 4933.3 4938.8 4945.2 4976.4 4990.2 4611.4 4762.4 4784.4 4799.6 4804.9 4795.4 4887.4 4999.9 5011.9 5040.0 4897.6 4918.8 4923.0 4951.4 4952.4 17:36:48 INFO - PROCESS | 11375 | 17:36:48 INFO - PROCESS | 11375 | [#5] yui.html Cycles:180 Average:12701.97 Median:45243.27 stddev:14715.35 (32.5%) stddev-sans-first:14728.57 17:36:48 INFO - PROCESS | 11375 | Values: 600.5 707.6 747.6 755.0 759.2 10960.2 11534.4 11539.2 11566.2 11586.3 11896.5 12133.5 12199.1 12253.4 12271.3 612.1 751.1 759.5 783.1 785.2 788.6 790.4 792.2 794.9 795.2 824.4 825.5 830.9 831.8 834.0 651.6 797.0 821.0 826.0 831.4 601.1 601.4 602.2 603.3 605.0 10919.9 11018.7 11036.4 11039.5 11048.4 11604.1 11771.2 11775.8 12239.9 12624.5 11024.5 11031.1 11213.8 11277.8 11327.5 4183.7 4197.1 4209.7 4261.1 4333.6 43417.6 43705.6 43778.0 44060.0 44136.6 10093.6 10141.3 10290.5 10313.7 10417.4 17286.9 17635.2 17675.7 17722.8 17818.3 6714.8 6869.9 6980.4 7092.8 7205.7 3741.8 3785.3 3832.1 3849.5 3905.7 2732.2 2793.7 2804.5 2815.7 2816.8 468.3 473.3 473.3 477.4 479.7 501.5 522.7 593.8 624.4 634.0 7378.7 7677.9 7706.5 7894.3 7905.0 599.8 601.0 623.8 630.8 632.7 3639.5 3732.5 3756.7 3790.4 3806.2 52925.2 53016.0 54255.7 54403.7 54411.2 47017.5 47318.0 47800.5 48442.8 48770.0 44327.3 44719.6 45162.8 45323.8 45607.3 7127.5 7448.3 7465.5 7476.3 7567.3 30067.0 30160.0 30223.0 30981.0 31399.8 36062.0 37944.0 39237.8 39815.2 40377.0 10307.1 10380.8 10567.3 10596.9 10636.9 10784.6 10905.8 10994.0 11146.3 11279.5 9427.5 9880.8 9931.2 10147.9 10500.2 9716.4 9799.5 9824.7 10038.8 10179.1 9866.3 10141.4 10159.5 10177.6 10301.2 8503.5 8508.8 8762.8 8778.3 8959.7 8457.3 8760.8 8813.4 8896.9 8923.7 17:36:48 INFO - PROCESS | 11375 | -------- Summary: end -------- 17:36:48 INFO - PROCESS | 11375 | 17:36:49 INFO - TEST-INFO | 11375: exit 0 17:36:49 INFO - TEST-OK | dromaeo_css | took 1117111ms 17:36:49 INFO - TEST-START | kraken 17:36:49 INFO - operating with platform_type : linux_ 17:36:49 INFO - Initialising browser for kraken test... 17:36:49 INFO - TEST-INFO | started process 11552 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9CbOlA/profile http://localhost:41681/getInfo.html) 17:36:52 INFO - PROCESS | 11552 | __metrics Screen width/height:1600/1200 17:36:52 INFO - PROCESS | 11552 | colorDepth:24 17:36:52 INFO - PROCESS | 11552 | Browser inner width/height: 1024/697 17:36:52 INFO - PROCESS | 11552 | __metrics 17:36:53 ERROR - PROCESS | 11552 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:36:54 INFO - TEST-INFO | 11552: exit 0 17:36:54 INFO - Browser initialized. 17:36:54 INFO - Running cycle 1/1 for kraken test... 17:36:54 INFO - TEST-INFO | started process 11632 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9CbOlA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:37:06 INFO - PROCESS | 11632 | RSS: Main: 153812992 17:37:06 INFO - PROCESS | 11632 | 17:37:08 INFO - PROCESS | 11632 | Cycle 1(1): loaded http://localhost:41681/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41681/tests/kraken/driver.html?testName=audio-beat-detection) 17:37:09 INFO - PROCESS | 11632 | RSS: Main: 209186816 17:37:09 INFO - PROCESS | 11632 | 17:37:12 INFO - PROCESS | 11632 | Cycle 1(1): loaded http://localhost:41681/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41681/tests/kraken/driver.html?testName=audio-dft) 17:37:13 INFO - PROCESS | 11632 | RSS: Main: 197226496 17:37:13 INFO - PROCESS | 11632 | 17:37:16 INFO - PROCESS | 11632 | Cycle 1(1): loaded http://localhost:41681/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41681/tests/kraken/driver.html?testName=audio-fft) 17:37:17 INFO - PROCESS | 11632 | RSS: Main: 266989568 17:37:17 INFO - PROCESS | 11632 | 17:37:19 INFO - PROCESS | 11632 | Cycle 1(1): loaded http://localhost:41681/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41681/tests/kraken/driver.html?testName=audio-oscillator) 17:37:19 INFO - PROCESS | 11632 | RSS: Main: 176627712 17:37:19 INFO - PROCESS | 11632 | 17:37:22 INFO - PROCESS | 11632 | Cycle 1(1): loaded http://localhost:41681/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41681/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:37:22 INFO - PROCESS | 11632 | RSS: Main: 179372032 17:37:22 INFO - PROCESS | 11632 | 17:37:26 INFO - PROCESS | 11632 | Cycle 1(1): loaded http://localhost:41681/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41681/tests/kraken/driver.html?testName=imaging-darkroom) 17:37:26 INFO - PROCESS | 11632 | RSS: Main: 215416832 17:37:26 INFO - PROCESS | 11632 | 17:37:30 INFO - PROCESS | 11632 | Cycle 1(1): loaded http://localhost:41681/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41681/tests/kraken/driver.html?testName=imaging-desaturate) 17:37:31 INFO - PROCESS | 11632 | RSS: Main: 214462464 17:37:31 INFO - PROCESS | 11632 | 17:37:34 INFO - PROCESS | 11632 | Cycle 1(1): loaded http://localhost:41681/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41681/tests/kraken/driver.html?testName=json-parse-financial) 17:37:34 INFO - PROCESS | 11632 | RSS: Main: 214990848 17:37:34 INFO - PROCESS | 11632 | 17:37:36 INFO - PROCESS | 11632 | Cycle 1(1): loaded http://localhost:41681/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41681/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:37:37 INFO - PROCESS | 11632 | RSS: Main: 207425536 17:37:37 INFO - PROCESS | 11632 | 17:37:39 INFO - PROCESS | 11632 | Cycle 1(1): loaded http://localhost:41681/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41681/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:37:39 INFO - PROCESS | 11632 | RSS: Main: 208674816 17:37:39 INFO - PROCESS | 11632 | 17:37:42 INFO - PROCESS | 11632 | Cycle 1(1): loaded http://localhost:41681/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41681/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:37:42 INFO - PROCESS | 11632 | RSS: Main: 215453696 17:37:42 INFO - PROCESS | 11632 | 17:37:45 INFO - PROCESS | 11632 | Cycle 1(1): loaded http://localhost:41681/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41681/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:37:46 INFO - PROCESS | 11632 | RSS: Main: 219836416 17:37:46 INFO - PROCESS | 11632 | 17:37:49 INFO - PROCESS | 11632 | Cycle 1(1): loaded http://localhost:41681/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41681/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:37:49 INFO - PROCESS | 11632 | RSS: Main: 220475392 17:37:49 INFO - PROCESS | 11632 | 17:37:51 INFO - PROCESS | 11632 | Cycle 1(1): loaded http://localhost:41681/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41681/tests/kraken/driver.html?testName=ai-astar) 17:37:51 INFO - PROCESS | 11632 | RSS: Main: 265912320 17:37:51 INFO - PROCESS | 11632 | 17:37:51 INFO - PROCESS | 11632 | __start_tp_report 17:37:51 INFO - PROCESS | 11632 | _x_x_mozilla_page_load 17:37:51 INFO - PROCESS | 11632 | _x_x_mozilla_page_load_details 17:37:51 INFO - PROCESS | 11632 | |i|pagename|runs| 17:37:51 INFO - PROCESS | 11632 | |0;ai-astar;117;111;116;116;117;115;115;117;117;115 17:37:51 INFO - PROCESS | 11632 | |1;audio-beat-detection;159;135;144;209;150;173;155;135;166;142 17:37:51 INFO - PROCESS | 11632 | |2;audio-dft;164;161;164;161;165;162;170;162;162;162 17:37:51 INFO - PROCESS | 11632 | |3;audio-fft;77;78;77;134;83;78;77;79;122;77 17:37:51 INFO - PROCESS | 11632 | |4;audio-oscillator;95;95;156;95;95;98;119;94;94;126 17:37:51 INFO - PROCESS | 11632 | |5;imaging-gaussian-blur;118;118;118;118;119;119;119;119;119;118 17:37:51 INFO - PROCESS | 11632 | |6;imaging-darkroom;148;149;149;150;149;148;147;148;148;150 17:37:51 INFO - PROCESS | 11632 | |7;imaging-desaturate;96;97;96;96;96;96;96;96;97;95 17:37:51 INFO - PROCESS | 11632 | |8;json-parse-financial;65;65;64;65;65;65;65;65;66;65 17:37:51 INFO - PROCESS | 11632 | |9;json-stringify-tinderbox;66;65;67;65;66;66;65;66;65;65 17:37:51 INFO - PROCESS | 11632 | |10;stanford-crypto-aes;90;88;91;85;86;93;87;86;168;88 17:37:51 INFO - PROCESS | 11632 | |11;stanford-crypto-ccm;140;147;150;145;147;140;139;145;175;152 17:37:51 INFO - PROCESS | 11632 | |12;stanford-crypto-pbkdf2;179;176;185;179;177;175;174;177;172;172 17:37:51 INFO - PROCESS | 11632 | |13;stanford-crypto-sha256-iterative;71;72;69;70;69;72;69;68;68;69 17:37:51 INFO - PROCESS | 11632 | __end_tp_report 17:37:51 INFO - PROCESS | 11632 | __start_cc_report 17:37:51 INFO - PROCESS | 11632 | _x_x_mozilla_cycle_collect,1968 17:37:51 INFO - PROCESS | 11632 | __end_cc_report 17:37:51 INFO - PROCESS | 11632 | __startTimestamp1463791071841__endTimestamp 17:37:51 INFO - PROCESS | 11632 | 17:37:51 INFO - PROCESS | 11632 | ------- Summary: start ------- 17:37:51 INFO - PROCESS | 11632 | Number of tests: 14 17:37:51 INFO - PROCESS | 11632 | 17:37:51 INFO - PROCESS | 11632 | [#0] ai-astar Cycles:10 Average:115.60 Median:116.50 stddev:1.84 (1.6%) stddev-sans-first:1.88 17:37:51 INFO - PROCESS | 11632 | Values: 117.0 111.0 116.0 116.0 117.0 115.0 115.0 117.0 117.0 115.0 17:37:51 INFO - PROCESS | 11632 | 17:37:51 INFO - PROCESS | 11632 | [#1] audio-beat-detection Cycles:10 Average:156.80 Median:157.00 stddev:22.26 (14.2%) stddev-sans-first:23.60 17:37:51 INFO - PROCESS | 11632 | Values: 159.0 135.0 144.0 209.0 150.0 173.0 155.0 135.0 166.0 142.0 17:37:51 INFO - PROCESS | 11632 | 17:37:51 INFO - PROCESS | 11632 | [#2] audio-dft Cycles:10 Average:163.30 Median:163.00 stddev:2.71 (1.7%) stddev-sans-first:2.86 17:37:51 INFO - PROCESS | 11632 | Values: 164.0 161.0 164.0 161.0 165.0 162.0 170.0 162.0 162.0 162.0 17:37:51 INFO - PROCESS | 11632 | 17:37:51 INFO - PROCESS | 11632 | [#3] audio-fft Cycles:10 Average:88.20 Median:77.50 stddev:21.24 (27.4%) stddev-sans-first:22.14 17:37:51 INFO - PROCESS | 11632 | Values: 77.0 78.0 77.0 134.0 83.0 78.0 77.0 79.0 122.0 77.0 17:37:51 INFO - PROCESS | 11632 | 17:37:51 INFO - PROCESS | 11632 | [#4] audio-oscillator Cycles:10 Average:106.70 Median:95.00 stddev:20.82 (21.9%) stddev-sans-first:21.64 17:37:51 INFO - PROCESS | 11632 | Values: 95.0 95.0 156.0 95.0 95.0 98.0 119.0 94.0 94.0 126.0 17:37:51 INFO - PROCESS | 11632 | 17:37:51 INFO - PROCESS | 11632 | [#5] imaging-gaussian-blur Cycles:10 Average:118.50 Median:119.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 17:37:51 INFO - PROCESS | 11632 | Values: 118.0 118.0 118.0 118.0 119.0 119.0 119.0 119.0 119.0 118.0 17:37:51 INFO - PROCESS | 11632 | 17:37:51 INFO - PROCESS | 11632 | [#6] imaging-darkroom Cycles:10 Average:148.60 Median:149.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 17:37:51 INFO - PROCESS | 11632 | Values: 148.0 149.0 149.0 150.0 149.0 148.0 147.0 148.0 148.0 150.0 17:37:51 INFO - PROCESS | 11632 | 17:37:51 INFO - PROCESS | 11632 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 17:37:51 INFO - PROCESS | 11632 | Values: 96.0 97.0 96.0 96.0 96.0 96.0 96.0 96.0 97.0 95.0 17:37:51 INFO - PROCESS | 11632 | 17:37:51 INFO - PROCESS | 11632 | [#8] json-parse-financial Cycles:10 Average:65.00 Median:65.00 stddev:0.47 (0.7%) stddev-sans-first:0.50 17:37:51 INFO - PROCESS | 11632 | Values: 65.0 65.0 64.0 65.0 65.0 65.0 65.0 65.0 66.0 65.0 17:37:51 INFO - PROCESS | 11632 | 17:37:51 INFO - PROCESS | 11632 | [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:66.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 17:37:51 INFO - PROCESS | 11632 | Values: 66.0 65.0 67.0 65.0 66.0 66.0 65.0 66.0 65.0 65.0 17:37:51 INFO - PROCESS | 11632 | 17:37:51 INFO - PROCESS | 11632 | [#10] stanford-crypto-aes Cycles:10 Average:96.20 Median:88.00 stddev:25.35 (28.8%) stddev-sans-first:26.79 17:37:51 INFO - PROCESS | 11632 | Values: 90.0 88.0 91.0 85.0 86.0 93.0 87.0 86.0 168.0 88.0 17:37:51 INFO - PROCESS | 11632 | 17:37:51 INFO - PROCESS | 11632 | [#11] stanford-crypto-ccm Cycles:10 Average:148.00 Median:147.00 stddev:10.42 (7.1%) stddev-sans-first:10.65 17:37:51 INFO - PROCESS | 11632 | Values: 140.0 147.0 150.0 145.0 147.0 140.0 139.0 145.0 175.0 152.0 17:37:51 INFO - PROCESS | 11632 | 17:37:51 INFO - PROCESS | 11632 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.60 Median:177.00 stddev:3.86 (2.2%) stddev-sans-first:4.00 17:37:51 INFO - PROCESS | 11632 | Values: 179.0 176.0 185.0 179.0 177.0 175.0 174.0 177.0 172.0 172.0 17:37:51 INFO - PROCESS | 11632 | 17:37:51 INFO - PROCESS | 11632 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:69.50 stddev:1.49 (2.2%) stddev-sans-first:1.51 17:37:51 INFO - PROCESS | 11632 | Values: 71.0 72.0 69.0 70.0 69.0 72.0 69.0 68.0 68.0 69.0 17:37:51 INFO - PROCESS | 11632 | -------- Summary: end -------- 17:37:51 INFO - PROCESS | 11632 | 17:37:52 INFO - TEST-INFO | 11632: exit 0 17:37:52 INFO - TEST-OK | kraken | took 63733ms 17:37:52 INFO - SUITE-END | took 1180s 17:37:52 INFO - Completed test suite (00:19:41) 17:37:52 INFO - javascript benchmark 17:37:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2650.5096557136917, 2659.6675415573054, 2692.7845772338214, 2704.2968828104695, 2714.172177485866, 4607.239805432104, 4614.054118905625, 4673.158831410345, 4722.480527142012, 4775.426948766149, 4662.766861656912, 4666.253399456088, 4708.43498780146, 4726.291056341551, 4756.500567440421, 4285.057287396783, 4334.739915605058, 4341.848035318764, 4351.651867850573, 4509.368688383629, 4387.670924680646, 4409.735415875041, 4465.218586747323, 4469.910601787962, 4519.864404067883, 4199.9790001050105, 4433.556644335573, 4436.334549817521, 4483.6188923941345, 4493.393391892102, 4237.555056719062, 4256.702030857841, 4287.206866729665, 4294.119705460374, 4295.978520107411, 4233.23801715691, 4293.463317085364, 4349.80425880833, 4358.542353052915, 4413.0, 4450.1767173073085, 4593.44878614565, 4609.815607375701, 4611.584957353854, 4636.675432719711, 5037.0, 5066.088104141253, 5077.060743762416, 5166.250893620441, 5171.818986335498, 5144.794208231666, 5147.202183661501, 5152.896942061137, 5235.267062611238, 5244.265802787613, 4605.240135377692, 4677.3919390479705, 4731.716097034155, 4770.212914869077, 4770.809167633325, 5115.97442012795, 5124.128898087334, 5168.870778230575, 5191.5846732261325, 5229.450907654717, 4969.006198760262, 4995.500449955048, 5012.0, 5021.72380519075, 5023.924641130386, 4886.755662216875, 4961.875953101201, 4973.651844370859, 5028.270900719375, 5054.166062599704, 4928.359313289321, 4961.82633607822, 4971.353724015855, 4978.079055374767, 4982.302477653131, 4990.4011518618, 4992.326035985168, 4995.650304478651, 5005.424376196784, 5029.220470827027, 4194.664426845845, 4224.936625950613, 4251.80866860992, 4311.9784401077795, 4322.589354011364, 3745.6254374562327, 3766.548014238309, 3769.0577355661085, 3798.582155962842, 3815.923681526354, 4295.398644189816, 4312.37470566766, 4325.502567204749, 4333.783310834446, 4342.848000319974, 4875.926861097087, 5003.524665156804, 5057.721825299644, 5070.340855688811, 5082.847514574569, 4288.463942007249, 4291.485021797404, 4314.395984562164, 4321.848735294249, 4372.715773474714, 4570.154521413549, 4572.428446444194, 4585.908281834345, 4588.977055114769, 4637.652176086807, 4561.064981678748, 4676.485586585541, 4733.692309999839, 4741.83403580873, 4746.833860814855, 5059.367579052619, 5069.391672999116, 5083.237514372874, 5088.542031217208, 5110.284560161655, 4578.359029735773, 4726.9600687848615, 4763.0235801661265, 4769.449928773093, 4813.638977076804, 4927.630427718007, 4950.133726597759, 4975.626827987843, 4997.325361076353, 5000.2499625056535, 5020.096382651158, 5024.974875125601, 5028.622853285945, 5067.189249720027, 5119.820806271762, 4728.905421891612, 4823.734694591691, 4892.996935628116, 4912.042151780369, 4937.23472861707, 4843.07981483517, 4884.951150488591, 4905.4358748742925, 4908.312836202863, 4950.876228094183, 4787.808487660454, 4814.085323788469, 4851.34506841586, 4867.269909513601, 4867.464578896389, 4846.612271018381, 4905.705657660552, 4936.185529387611, 4996.800127994985, 5009.824656137018, 4707.78814953321, 4731.621470282438, 4746.406699162605, 4784.449788274393, 4795.376601041842], "value": 4627.781679899855, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.2073507457097, 572.507643426653, 573.3463851209619, 578.8581797459623, 586.8767558812649, 27179.320516987085, 40250.194996100094, 41215.0, 41428.37857432134, 44585.33122003164, 41600.37599436003, 42098.0, 42139.57860421395, 42284.57715422845, 42337.7883110584, 7292.8906066409045, 7548.811279718024, 7732.149463559004, 7735.8066048348965, 7737.690492380298, 9574.377665451759, 9896.703098907044, 9908.554115064839, 10270.897291027106, 10280.12618927392, 9835.508224588777, 9842.753931151707, 9968.601255949754, 9971.601135954554, 9978.950105249463, 7289.125304963385, 9544.809103817954, 9805.1665608423, 9835.508224588777, 9860.704178874645, 9809.313348065638, 9815.852762208573, 9836.3606365586, 9839.065288797552, 9862.112409883144, 38658.42012369817, 39133.0, 39157.0, 39272.80363598192, 39310.0, 2921.7224363685414, 3032.2116249774995, 3099.9535006974916, 3100.6589275179713, 3532.929341413183, 29023.274418139503, 29163.41673166546, 29242.561361579592, 29475.41049179026, 30018.24954376136, 3410.0963244740165, 3483.028460349918, 3509.5788505379264, 3527.753057285991, 3535.3636345457808, 262722.0, 264705.0, 266115.9999999981, 266463.0, 266476.0, 54681.72659136679, 54688.726556366964, 54701.179482307794, 54913.450865490835, 54981.72509137429, 34736.131596709776, 35708.0, 35762.46356304658, 35797.1050723734, 35849.28301433957, 12307.630771076882, 12560.246385216917, 12591.496340146476, 12606.306653133983, 12613.180143290656, 7973.44185906981, 8562.52906090171, 8599.742007739778, 8852.734417967471, 8852.955735221283, 17978.730319045226, 18025.7296140558, 18085.457436276934, 18092.095395230186, 18149.183286752126, 6803.752487444305, 6915.827104322432, 6952.826179345456, 6961.23426423093, 6983.615901125385, 804.9074356449083, 884.2660591708994, 941.1905761045496, 943.5140902435114, 974.055166488505, 25742.48515029689, 26381.20856374312, 26690.466190676467, 26910.5963410549, 27012.594811077848, 962.8074385123003, 984.2322988069318, 993.7714325704984, 1023.2223510132353, 1032.9896701033044, 13814.309284535733, 14198.580141985925, 14465.78301325481, 14536.127832330094, 14616.48842290536, 299394.0, 302084.0, 302197.0, 302806.0, 303740.0, 46179.0, 46698.299525507144, 46709.29936050962, 46744.2988355175, 46823.76588117106, 1080.6055789636882, 1182.2669944634554, 1188.6909403555137, 1203.356204430643, 1207.6014915078179, 27564.586531201647, 28897.711022889504, 29001.0, 29282.0, 29375.85312073426, 40852.387214191214, 46424.30363544482, 48518.757406212746, 48814.511854881, 53564.73217633887, 336447.0, 337615.0, 343241.0, 343264.0, 344899.0, 31411.52882706807, 36121.63878361183, 37863.81068094642, 38405.6159438402, 41456.3781543271, 41738.58261417347, 42073.579264206965, 42238.366424503045, 42718.359224611035, 42897.785511072245, 35708.46437303391, 36085.0, 36388.0, 36594.0, 36829.44755828611, 35444.0, 35456.46815297824, 35479.64520354763, 35492.0, 35990.46014309735, 34574.30851383009, 34823.0, 34865.30269394547, 35514.28971420506, 35614.28771424505, 31206.687933120378, 32008.839955801002, 32020.63100789085, 32110.67889321077, 32131.714731411415, 24289.75710242875, 24761.504769904863, 24925.501489970462, 24952.500949981262, 24978.42559198676], "value": 17706.275235868427, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.1512152786438, 354.6719284661688, 364.59165734377484, 372.60689972079444, 381.6965512417628, 15209.163496007715, 16192.190390480459, 16371.0, 16606.584835379123, 16614.83385166148, 14534.127952322868, 15712.214389280547, 15893.125878076702, 15918.840811591881, 15973.121478318688, 4807.783649735761, 4944.283078953549, 5069.011542749147, 5090.872728181806, 5113.539781419671, 3626.3653860574427, 3815.0, 4962.230854217602, 5511.944880551183, 5788.42115788422, 5878.235829342201, 5899.203607512974, 5920.111983202511, 5933.19901813254, 5937.435943585352, 5689.11818668105, 5878.823635290948, 5891.086881533369, 5894.528437724993, 5897.734601942923, 3343.4483310254022, 4815.855524334275, 5174.715390653512, 5184.248283998799, 5184.870378240575, 19313.51716207092, 20108.0, 20228.49428764278, 20235.79764202354, 20245.0, 1883.4726276642562, 1925.9794436829084, 1958.9608207835906, 1975.7530308711412, 2024.7570291565107, 6199.132121502993, 6209.410106039964, 6250.43746062852, 11890.940545297304, 12441.305173137222, 1731.0, 1762.4095927864053, 1764.1003088424868, 1771.158699617684, 1796.8023517413073, 62962.68518657378, 64763.0, 64908.0, 65021.67489162571, 65100.674496627216, 9442.480663563432, 9490.193333566724, 9775.217982561378, 9809.21526277896, 9874.308798384187, 13381.397837097355, 13457.596272111852, 13478.39347229377, 13489.325533723471, 13496.797548036788, 6641.900371494431, 6651.66741662915, 6684.933150668431, 6816.0, 6822.0108084328485, 6073.058675905153, 6115.4801841843055, 6137.60105593135, 6142.170806941006, 6198.938010619926, 6104.725287362079, 6209.161763162006, 6217.533684973645, 6217.751289948442, 6315.273743519554, 1620.198001989023, 1708.5045336852174, 1764.6911790436623, 1801.1174524482908, 1805.954851128706, 838.6100463284602, 846.8941382327209, 880.4585180114184, 888.2316795971439, 1008.6822650864954, 15834.841651583567, 16489.0, 17930.282788688306, 18039.72940405895, 18095.909520452315, 867.1068799136899, 875.4922145155795, 896.4352457951449, 902.0798785239019, 915.1077699243318, 8088.514689118554, 9850.408975461496, 10192.694219173436, 10231.820883693195, 10286.691399258034, 382602.0, 394633.0, 403873.0, 405012.0, 407884.0, 45786.77106614512, 74645.25354746492, 77045.6147719269, 77395.0, 80482.5975870117, 919.2783664823215, 939.2063706168277, 951.6669165791917, 971.6550624528332, 975.7219192530094, 15384.461543845911, 15402.15288159162, 15701.450449234222, 15766.605834854221, 16067.598310041874, 30898.53652195174, 30988.22529436782, 31689.366212675155, 33062.33875322528, 33396.66603334033, 46095.3085703708, 48152.27771583359, 48165.27752083651, 48523.5147648519, 48573.5142648569, 7643.847123057397, 7718.228177182237, 7759.379249660126, 7786.649600767866, 7832.412569057229, 7383.114026316876, 10318.845217321596, 11136.164787640797, 11158.832617510581, 11457.19799614019, 6963.442924565921, 7423.183449820407, 8000.759977200693, 9529.809403812023, 9717.12545870875, 9238.95380523093, 9249.588990440667, 9461.810763784548, 9483.336166468282, 9615.086566776425, 9544.33189676716, 9875.901240987498, 10132.44271565071, 10225.079742823182, 10424.426656533964, 7584.54492730438, 7665.156832748282, 7821.335186508983, 7866.842663146819, 8015.078265999485, 9898.604055837686, 10314.896851031393, 10362.585496580052, 10510.527026283682, 10524.105451036748], "value": 8017.225020564791, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1257.4467234416861, 1409.1052181864513, 1450.4923276853103, 1545.6599548099414, 1756.7628370170023, 6576.210854697431, 7294.562326260428, 7557.168711441737, 7564.583947882864, 7686.385089192865, 7483.73806916758, 7606.125295591009, 7628.771136865889, 7678.385729141669, 7687.2312768723095, 2155.622766015949, 2176.9455763605956, 2180.6292930201903, 2183.792539708725, 2197.252934002439, 2143.839212059094, 2157.805797478227, 2177.7277840269967, 2186.868787872733, 2187.0486338442747, 2153.353993801861, 2153.7846215378413, 2159.384575396012, 2171.294329342962, 2188.5075857931915, 2104.926327578535, 2109.4620871677703, 2110.345792804228, 2113.608982338257, 2132.3070002249174, 2076.6158260721813, 2103.842211834103, 2104.400245929918, 2116.7883211678864, 2124.3945475539554, 7576.583287919162, 7607.695692172307, 7633.618319084024, 7673.424493163036, 7707.499012564165, 4156.418101465797, 4263.275243208662, 4382.649388048949, 4385.166818304512, 4389.780510974439, 2736.0, 2849.700781417963, 2876.453473839964, 2876.467853447098, 2911.3595009098176, 852.3224036890687, 852.3735054734765, 863.96976105836, 883.3595643158723, 884.2042162054138, 10250.0, 10355.326903751233, 10363.32638378503, 10364.63723769672, 10367.896321036844, 3878.7090968176935, 3931.3906344516645, 4003.739756915791, 4039.3537034074407, 4041.6766658667234, 8193.09875913649, 8268.338532917352, 8290.08809031006, 8294.253517183482, 8322.29260512851, 4277.230098582223, 4278.251306021434, 4296.742195468282, 4298.183345164409, 4317.784110794448, 3424.7260219182403, 3848.0572259796527, 3885.0, 3964.464797252334, 3972.3842804365368, 3368.764186506921, 3387.9322413552086, 3398.0, 3432.1076520104953, 3443.8794642187404, 971.533663841346, 975.687779910436, 976.038601977052, 983.2134292565919, 990.881094268678, 838.6393850644281, 845.8688903220011, 847.2374862623565, 855.5850412549909, 866.3718803867146, 5134.365855968585, 5299.682019078868, 5301.443348448434, 5431.4840090191365, 5504.4770746778995, 414.75114931041134, 421.55736476699343, 428.59069588542866, 430.60384446309473, 432.4615853262708, 3673.81630918453, 3745.5692595351884, 3751.3247615429486, 3767.9434808477895, 3794.0, 9186.724398267928, 9673.564689588986, 9695.90304096964, 9751.756206094762, 9840.409575425354, 9673.177779888647, 9694.0, 9706.563204655808, 9710.805783884283, 9714.319997600242, 6944.826379340557, 7231.819204519824, 7301.488895777351, 7360.411167106726, 7388.630568471555, 5363.03465376236, 5430.647007944471, 5446.373667028184, 5575.553955683617, 5633.239512665901, 8725.563721813756, 8769.254613357682, 8971.685990990283, 8972.327075469235, 9052.502112383881, 8685.218330350299, 9028.458292502472, 9184.58669359867, 9309.906900931175, 9360.906390936003, 6527.11883895668, 6562.967185164043, 6658.866822663616, 6692.130023097161, 6710.0, 7341.045664063638, 7380.18817930038, 7415.666295016629, 7423.703051877865, 7452.813679658052, 6518.902216466851, 6700.631465269457, 6710.563813352116, 6711.597304161766, 6821.454283657395, 6654.802135615636, 6718.731250750111, 6720.697568609522, 6794.660266986532, 6807.591544507147, 5743.1385292206505, 5962.970185149046, 5998.560345517132, 6308.14839996613, 6429.7749578764515, 4649.116667833101, 4674.0, 4681.695689780154, 4748.3352330674425, 4815.422149342101, 4577.656675749266, 4765.904681906273, 4789.61683065347, 4846.95153048465, 4945.035718034948], "value": 3976.420380693808, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.2489202748935, 294.42146182750906, 294.7052947052947, 300.50866832728497, 301.08920515440803, 4751.38232029836, 4801.3195381616415, 4806.927896081562, 4811.326414302001, 4828.396450443694, 4725.929111063337, 4733.0, 4738.123447162268, 4765.928511072337, 4769.785359658815, 3565.447355659877, 3604.6395360463875, 3695.778253304797, 3696.907577310562, 3702.833372498244, 3674.50394196784, 3689.3912504436735, 3692.335379631665, 3697.907552311187, 3700.1859590889962, 3554.92890142197, 3706.4996225509617, 3719.4420836874415, 3720.7395482316247, 3724.6461586149408, 3642.417213245881, 3730.4963829883027, 3731.477593136963, 3740.3828368319196, 3757.3236817372863, 3317.6018877734587, 3330.2673411849355, 3332.866825279417, 3339.0, 3347.029361485166, 4512.187806194884, 4527.388802511652, 4530.026044400437, 4536.682432229745, 4538.251188553884, 3944.5266568011734, 4181.435506206653, 4251.617354438115, 4252.447181866369, 4267.765272909989, 4940.34498443022, 4962.305277261186, 4966.404031516205, 4991.725455099968, 5018.121828679967, 3521.8591256349714, 3547.130952916552, 3552.378333791576, 3568.3220188164423, 3569.9107522311892, 5048.570871475929, 5219.815912293498, 5226.087477770883, 5239.449857764918, 5256.842294731164, 3566.268914872445, 3598.758428342218, 3601.873934412283, 3613.9819300903855, 3632.0, 3661.8169091545315, 3666.358387282215, 3669.486271921933, 3673.5959044505084, 3692.9076773080888, 4203.684723645739, 4204.309242085068, 4205.726627769246, 4213.4522512073845, 4234.809433575497, 4806.711597304173, 4941.382327209099, 4961.627877909171, 4966.776495057731, 4979.701217926936, 1251.7934540800666, 1264.3488603369271, 1277.3421687830776, 1278.7889998150388, 1278.9872101278868, 792.6631181747734, 804.3404408385185, 812.070179644304, 812.9309008734206, 841.1126261793867, 4286.592773686495, 4294.806733696991, 4302.064071167924, 4319.956800431955, 4340.956590434055, 5048.368953880765, 5054.393472783289, 5081.5426611605135, 5083.415407228142, 5084.3644544431945, 4202.348635961431, 4310.943818764423, 4314.050908800059, 4333.8699839004885, 4343.0, 2682.9731702682725, 2699.932501687434, 2715.8777854996574, 2717.1033558925506, 2720.931976700598, 4679.485256621769, 4713.387259656222, 4731.716097034189, 4736.881577960509, 4773.451053128865, 5003.74981250936, 5065.7720402581235, 5119.718415487184, 5168.198929165986, 5202.791888324425, 4669.252919532859, 4691.319758634979, 4709.458412282563, 4749.928751068736, 4761.309610106585, 5001.874953126201, 5011.624128190328, 5014.247862820606, 5060.595152387727, 5108.79564817418, 4797.880052998703, 4966.826161084345, 4984.632299657634, 4990.925136122888, 5015.019067468403, 4714.467797965606, 4720.858374248778, 4730.385049943486, 4751.956658636819, 4767.380240568704, 3578.946315805317, 3585.6952159065727, 3599.604043555259, 3606.1886075632774, 3619.4570814378053, 4943.382077240345, 5061.848144555669, 5062.417821950523, 5080.796768129233, 5084.745762711776, 4925.285833554043, 4926.605871530197, 4936.456989731055, 4938.703677779345, 4956.603471722182, 4933.309336692794, 4938.802447902043, 4945.208766597471, 4976.427710813303, 4990.180547990519, 4611.400517932647, 4762.4285085789925, 4784.354112194809, 4799.616030717604, 4804.927926081182, 4795.352627395397, 4887.3890763654545, 4999.900002000012, 5011.924821127613, 5039.974800125976, 4897.583705385082, 4918.778654960607, 4922.950770492249, 4951.356323678043, 4952.4057113146655], "value": 3725.039490537138, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [600.5285850607273, 707.6108140522712, 747.6224506624154, 754.9660265288062, 759.1535437986646, 10960.177986651002, 11534.365609891453, 11539.192256542035, 11566.190366674336, 11586.304821710703, 11896.524139034429, 12133.453994570244, 12199.14605977582, 12253.448594813233, 12271.263724176555, 612.0879888965454, 751.0949306086153, 759.4873460414212, 783.0877028262096, 785.1873311122961, 788.5978151142901, 790.4111436979458, 792.2315354106507, 794.9085855126648, 795.220683729945, 824.389951435936, 825.5046971816892, 830.8546004449228, 831.7712629027036, 834.0408530190269, 651.5601968671152, 796.9760907172736, 821.0229826506497, 826.0294154368623, 831.3723139030024, 601.0533409879414, 601.3685630088389, 602.169006770658, 603.3483837455537, 605.0410099991519, 10919.890801092046, 11018.724531886766, 11036.448177591168, 11039.503222355013, 11048.447577621087, 11604.071674266122, 11771.234869733526, 11775.762605105003, 12239.877601223963, 12624.495020199181, 11024.50389732464, 11031.117510599133, 11213.775724485464, 11277.830832537518, 11327.546898124065, 4183.748975061506, 4197.097624010822, 4209.663226941837, 4261.147770445892, 4333.588309110661, 43417.56582434167, 43705.56294437079, 43778.0, 44060.0, 44136.558634413566, 10093.646722364681, 10141.340812847142, 10290.485475726333, 10313.74215644615, 10417.427041512638, 17286.913565432093, 17635.206415711324, 17675.73486397705, 17722.822771772117, 17818.287268509113, 6714.764983225564, 6869.896951545731, 6980.371766541036, 7092.751753688596, 7205.747798827016, 3741.7754934704003, 3785.299719551892, 3832.1186127190904, 3849.4995650565247, 3905.6680182184264, 2732.207659778682, 2793.678726946427, 2804.5092108880863, 2815.704351043111, 2816.8309901405983, 468.26248658362533, 473.27588789151963, 473.34678144160836, 477.4032459425718, 479.6690283704233, 501.4534157767977, 522.7203446156288, 593.8337265565649, 624.4192900602393, 633.9683015849189, 7378.704851805867, 7677.884831727529, 7706.537607743553, 7894.289513943772, 7904.960475197588, 599.7511032921376, 600.9819705408845, 623.8440389902524, 630.7729217481703, 632.6804963493406, 3639.47227651989, 3732.458793474931, 3756.6806821419937, 3790.3556395412847, 3806.2197249563774, 52925.2061219082, 53016.0, 54255.72872135614, 54403.72798135984, 54411.18383224255, 47017.52982470131, 47318.0, 47800.521994780305, 48442.757786210845, 48770.0, 44327.335089973676, 44719.55280447154, 45162.774186129514, 45323.77338113288, 45607.31589026167, 7127.465440092117, 7448.255174482509, 7465.477416580788, 7476.289752473506, 7567.281108294703, 30067.0, 30160.0, 30223.0, 30981.0, 31399.84300078485, 36062.0, 37944.0, 39237.80381098076, 39815.203695926495, 40377.0, 10307.072363487323, 10380.792384152426, 10567.313124646873, 10596.89403105959, 10636.946815265874, 10784.568617255536, 10905.836412453978, 10994.0, 11146.331220126818, 11279.548818047186, 9427.481488518197, 9880.802383952425, 9931.205503559553, 10147.949260253652, 10500.212484063573, 9716.368436051634, 9799.510024498604, 9824.705258842247, 10038.849417258893, 10179.083882450615, 9866.260030497599, 10141.391516509033, 10159.54282057324, 10177.592896284066, 10301.227407944583, 8503.532305723245, 8508.829823403621, 8762.780930476789, 8778.297736181217, 8959.686410975584, 8457.323414126731, 8760.824783504422, 8813.42712723671, 8896.911030889609, 8923.724450265141], "value": 5832.391100554694, "unit": "score"}], "name": "dromaeo_css", "value": 6199.277392413198, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 111.0, 116.0, 116.0, 117.0, 115.0, 115.0, 117.0, 117.0, 115.0], "value": 115.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 135.0, 144.0, 209.0, 150.0, 173.0, 155.0, 135.0, 166.0, 142.0], "value": 156.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 161.0, 164.0, 161.0, 165.0, 162.0, 170.0, 162.0, 162.0, 162.0], "value": 163.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 77.0, 134.0, 83.0, 78.0, 77.0, 79.0, 122.0, 77.0], "value": 88.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 156.0, 95.0, 95.0, 98.0, 119.0, 94.0, 94.0, 126.0], "value": 106.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 119.0, 119.0, 119.0, 119.0, 119.0, 118.0], "value": 118.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 149.0, 150.0, 149.0, 148.0, 147.0, 148.0, 148.0, 150.0], "value": 148.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 95.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 65.0, 65.0, 65.0, 65.0, 65.0, 66.0, 65.0], "value": 65.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 67.0, 65.0, 66.0, 66.0, 65.0, 66.0, 65.0, 65.0], "value": 65.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 88.0, 91.0, 85.0, 86.0, 93.0, 87.0, 86.0, 168.0, 88.0], "value": 96.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 147.0, 150.0, 145.0, 147.0, 140.0, 139.0, 145.0, 175.0, 152.0], "value": 148.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 176.0, 185.0, 179.0, 177.0, 175.0, 174.0, 177.0, 172.0, 172.0], "value": 176.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 72.0, 69.0, 70.0, 69.0, 72.0, 69.0, 68.0, 68.0, 69.0], "value": 69.7, "unit": "score"}], "name": "kraken", "value": 1614.9, "alertThreshold": 2.0}]} 17:37:53 INFO - Return code: 0 17:37:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:37:53 ERROR - # TBPL SUCCESS # 17:37:53 INFO - Running post-action listener: _resource_record_post_action 17:37:53 INFO - ##### 17:37:53 INFO - ##### Finished run-tests step (success) 17:37:53 INFO - ##### 17:37:53 INFO - Running post-run listener: _resource_record_post_run 17:37:53 INFO - Total resource usage - Wall time: 1198s; CPU: 26.0%; Read bytes: 8192; Write bytes: 522690560; Read time: 148; Write time: 347252 17:37:53 INFO - TinderboxPrint: CPU usage
25.5% 17:37:53 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 148 17:37:53 INFO - TinderboxPrint: I/O write bytes / time
522,690,560 / 347,252 17:37:53 INFO - TinderboxPrint: CPU idle
7,120.1 (74.4%) 17:37:53 INFO - TinderboxPrint: CPU user
2,408.8 (25.2%) 17:37:53 INFO - TinderboxPrint: Swap in / out
0 / 0 17:37:53 INFO - install - Wall time: 16s; CPU: 26.0%; Read bytes: 0; Write bytes: 236572672; Read time: 0; Write time: 169304 17:37:53 INFO - run-tests - Wall time: 1182s; CPU: 26.0%; Read bytes: 8192; Write bytes: 286117888; Read time: 148; Write time: 177948 17:37:53 INFO - Running post-run listener: _upload_blobber_files 17:37:53 INFO - Blob upload gear active. 17:37:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:37:53 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 17:37:53 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:37:53 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:37:54 INFO - (blobuploader) - INFO - Open directory for files ... 17:37:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:37:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:37:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:37:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:37:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:37:54 INFO - (blobuploader) - INFO - Done attempting. 17:37:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:37:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:37:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:37:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:37:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:37:55 INFO - (blobuploader) - INFO - Done attempting. 17:37:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:37:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:37:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:37:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:37:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:37:59 INFO - (blobuploader) - INFO - Done attempting. 17:37:59 INFO - (blobuploader) - INFO - Iteration through files over. 17:37:59 INFO - Return code: 0 17:37:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:37:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:37:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/83ca02f81f74137be0c72ce132afba812dcb08aa58aae2ca731d87a175ef0baf8f585cb3128e2072f65d5f962797c4db524a9bc8ba65c60b694fe0586e169a81", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/812ce4bc4554f9d46a5aeeb4c66b1125efebcee4b7ec966f0b5abf394ab2d293ee0e3bab835d66652eac0fdaee6fa3c0bc4ad7355d50933bae7e2213dc576626", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4d2a292645c2cb772aee2fb0f68212680411c6b2376650dac5437cb3cfa327e77fe13e1ef9794f33e3ef4555e465738df77ee285b89d8cca3684f9a46684d113"} 17:37:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:37:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:37:59 INFO - Contents: 17:37:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/83ca02f81f74137be0c72ce132afba812dcb08aa58aae2ca731d87a175ef0baf8f585cb3128e2072f65d5f962797c4db524a9bc8ba65c60b694fe0586e169a81", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/812ce4bc4554f9d46a5aeeb4c66b1125efebcee4b7ec966f0b5abf394ab2d293ee0e3bab835d66652eac0fdaee6fa3c0bc4ad7355d50933bae7e2213dc576626", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4d2a292645c2cb772aee2fb0f68212680411c6b2376650dac5437cb3cfa327e77fe13e1ef9794f33e3ef4555e465738df77ee285b89d8cca3684f9a46684d113"} 17:37:59 INFO - Running post-run listener: copy_logs_to_upload_dir 17:37:59 INFO - Copying logs to upload dir... 17:37:59 INFO - mkdir: /builds/slave/test/build/upload/logs 17:37:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.939154 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-05-20 17:37:59.375365) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-20 17:37:59.381001) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1463786537.67319-2130219653 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/83ca02f81f74137be0c72ce132afba812dcb08aa58aae2ca731d87a175ef0baf8f585cb3128e2072f65d5f962797c4db524a9bc8ba65c60b694fe0586e169a81", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/812ce4bc4554f9d46a5aeeb4c66b1125efebcee4b7ec966f0b5abf394ab2d293ee0e3bab835d66652eac0fdaee6fa3c0bc4ad7355d50933bae7e2213dc576626", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4d2a292645c2cb772aee2fb0f68212680411c6b2376650dac5437cb3cfa327e77fe13e1ef9794f33e3ef4555e465738df77ee285b89d8cca3684f9a46684d113"} build_url:https://queue.taskcluster.net/v1/task/Ch5NgTVRT2WBN9LIlSPIQA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.005462 build_url: 'https://queue.taskcluster.net/v1/task/Ch5NgTVRT2WBN9LIlSPIQA/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/Firefox-Non-PGO/sha512/83ca02f81f74137be0c72ce132afba812dcb08aa58aae2ca731d87a175ef0baf8f585cb3128e2072f65d5f962797c4db524a9bc8ba65c60b694fe0586e169a81", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/812ce4bc4554f9d46a5aeeb4c66b1125efebcee4b7ec966f0b5abf394ab2d293ee0e3bab835d66652eac0fdaee6fa3c0bc4ad7355d50933bae7e2213dc576626", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4d2a292645c2cb772aee2fb0f68212680411c6b2376650dac5437cb3cfa327e77fe13e1ef9794f33e3ef4555e465738df77ee285b89d8cca3684f9a46684d113"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-20 17:37:59.395075) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 17:37:59.395401) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1463786537.67319-2130219653 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.002138 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-20 17:37:59.475308) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-20 17:37:59.475642) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-20 17:37:59.475925) ========= ========= Total master_lag: 0.15 =========