builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-037 starttime: 1464076592.86 results: success (0) buildid: 20160523223126 builduid: 8c5b4a72d305404cab364d3aa16dff3a revision: feb13c8b708aade4acf07e520682c2a9f9328544 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-24 00:56:32.858782) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-24 00:56:32.859242) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-24 00:56:32.859766) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-24 00:56:32.873773) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 00:56:32.874077) ========= 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=aa08bb06ff6271ef470a76a4000001be-1464076539.93700-138900510 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-24 00:56:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.2M=0s 2016-05-24 00:56:33 (43.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120833 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 00:56:33.013206) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 00:56:33.013501) ========= 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=aa08bb06ff6271ef470a76a4000001be-1464076539.93700-138900510 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015652 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 00:56:33.063513) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-24 00:56:33.063898) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev feb13c8b708aade4acf07e520682c2a9f9328544 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev feb13c8b708aade4acf07e520682c2a9f9328544 --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=aa08bb06ff6271ef470a76a4000001be-1464076539.93700-138900510 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-24 00:56:33,126 truncating revision to first 12 chars 2016-05-24 00:56:33,127 Setting DEBUG logging. 2016-05-24 00:56:33,127 attempt 1/10 2016-05-24 00:56:33,127 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/feb13c8b708a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-24 00:56:33,877 unpacking tar archive at: mozilla-inbound-feb13c8b708a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.040879 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-24 00:56:34.117946) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-24 00:56:34.118251) ========= script_repo_revision: feb13c8b708aade4acf07e520682c2a9f9328544 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-24 00:56:34.118669) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-24 00:56:34.118944) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-24 00:56:34.127722) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-05-24 00:56:34.128082) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=aa08bb06ff6271ef470a76a4000001be-1464076539.93700-138900510 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:56:34 INFO - MultiFileLogger online at 20160524 00:56:34 in /builds/slave/test 00:56:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 00:56:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:56:34 INFO - {'append_to_log': False, 00:56:34 INFO - 'base_work_dir': '/builds/slave/test', 00:56:34 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 00:56:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:56:34 INFO - 'branch': 'Mozilla-Inbound', 00:56:34 INFO - 'buildbot_json_path': 'buildprops.json', 00:56:34 INFO - 'config_files': ('talos/linux_config.py',), 00:56:34 INFO - 'default_actions': ('clobber', 00:56:34 INFO - 'read-buildbot-config', 00:56:34 INFO - 'download-and-extract', 00:56:34 INFO - 'populate-webroot', 00:56:34 INFO - 'create-virtualenv', 00:56:34 INFO - 'install', 00:56:34 INFO - 'run-tests'), 00:56:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:56:34 INFO - 'download_minidump_stackwalk': True, 00:56:34 INFO - 'download_symbols': 'ondemand', 00:56:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:56:34 INFO - 'tooltool.py': '/tools/tooltool.py', 00:56:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:56:34 INFO - '/tools/misc-python/virtualenv.py')}, 00:56:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:56:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:56:34 INFO - 'installer_path': 'installer.exe', 00:56:34 INFO - 'log_level': 'info', 00:56:34 INFO - 'log_name': 'talos', 00:56:34 INFO - 'log_to_console': True, 00:56:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:56:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:56:34 INFO - 'opt_config_files': (), 00:56:34 INFO - 'pip_index': False, 00:56:34 INFO - 'sps_profile': False, 00:56:34 INFO - 'sps_profile_interval': 0, 00:56:34 INFO - 'suite': 'dromaeojs', 00:56:34 INFO - 'system_bits': '32', 00:56:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:56:34 INFO - 'title': 'talos-linux64-ix-037', 00:56:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:56:34 INFO - 'use_talos_json': True, 00:56:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:56:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:56:34 INFO - 'work_dir': 'build'} 00:56:34 INFO - ##### 00:56:34 INFO - ##### Running clobber step. 00:56:34 INFO - ##### 00:56:34 INFO - Running pre-action listener: _resource_record_pre_action 00:56:34 INFO - Running main action method: clobber 00:56:34 INFO - rmtree: /builds/slave/test/build 00:56:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:56:34 INFO - Running post-action listener: _resource_record_post_action 00:56:34 INFO - ##### 00:56:34 INFO - ##### Finished clobber step (success) 00:56:34 INFO - ##### 00:56:34 INFO - ##### 00:56:34 INFO - ##### Running read-buildbot-config step. 00:56:34 INFO - ##### 00:56:34 INFO - Running pre-action listener: _resource_record_pre_action 00:56:34 INFO - Running main action method: read_buildbot_config 00:56:34 INFO - Using buildbot properties: 00:56:34 INFO - { 00:56:34 INFO - "project": "", 00:56:34 INFO - "product": "firefox", 00:56:34 INFO - "script_repo_revision": "production", 00:56:34 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 00:56:34 INFO - "repository": "", 00:56:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 00:56:34 INFO - "buildid": "20160523223126", 00:56:34 INFO - "pgo_build": "True", 00:56:34 INFO - "basedir": "/builds/slave/test", 00:56:34 INFO - "buildnumber": 1048, 00:56:34 INFO - "slavename": "talos-linux64-ix-037", 00:56:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 00:56:34 INFO - "platform": "ubuntu64_hw", 00:56:34 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 00:56:34 INFO - "branch": "mozilla-inbound", 00:56:34 INFO - "repo_path": "integration/mozilla-inbound", 00:56:34 INFO - "revision": "feb13c8b708aade4acf07e520682c2a9f9328544", 00:56:34 INFO - "stage_platform": "linux64-pgo", 00:56:34 INFO - "builduid": "8c5b4a72d305404cab364d3aa16dff3a", 00:56:34 INFO - "slavebuilddir": "test" 00:56:34 INFO - } 00:56:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/aeqtGFHtSX681ak9BRJN-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 00:56:34 INFO - Running post-action listener: _resource_record_post_action 00:56:34 INFO - ##### 00:56:34 INFO - ##### Finished read-buildbot-config step (success) 00:56:34 INFO - ##### 00:56:34 INFO - ##### 00:56:34 INFO - ##### Running download-and-extract step. 00:56:34 INFO - ##### 00:56:34 INFO - Running pre-action listener: _resource_record_pre_action 00:56:34 INFO - Running main action method: download_and_extract 00:56:34 INFO - mkdir: /builds/slave/test/build/tests 00:56: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')]} 00:56:34 INFO - https://queue.taskcluster.net/v1/task/aeqtGFHtSX681ak9BRJN-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 00:56:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeqtGFHtSX681ak9BRJN-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 00:56:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeqtGFHtSX681ak9BRJN-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 00:56:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeqtGFHtSX681ak9BRJN-w/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 00:56:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeqtGFHtSX681ak9BRJN-w/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 00:56:35 INFO - Downloaded 1361 bytes. 00:56:35 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 00:56:35 INFO - Using the following test package requirements: 00:56:35 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 00:56:35 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 00:56:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:56:35 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 00:56:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 00:56:35 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 00:56:35 INFO - u'jsshell-linux-x86_64.zip'], 00:56:35 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 00:56:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:56:35 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 00:56:35 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 00:56:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:56:35 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 00:56:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:56:35 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 00:56:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:56:35 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 00:56:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:56:35 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:56:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:56:35 INFO - https://queue.taskcluster.net/v1/task/aeqtGFHtSX681ak9BRJN-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:56:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeqtGFHtSX681ak9BRJN-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 00:56:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeqtGFHtSX681ak9BRJN-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 00:56:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeqtGFHtSX681ak9BRJN-w/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 00:56:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeqtGFHtSX681ak9BRJN-w/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 00:56:36 INFO - Downloaded 24417402 bytes. 00:56:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 00:56:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 00:56:37 INFO - Return code: 0 00:56:37 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 00:56: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')]} 00:56:37 INFO - https://queue.taskcluster.net/v1/task/aeqtGFHtSX681ak9BRJN-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:56:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeqtGFHtSX681ak9BRJN-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 00:56:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeqtGFHtSX681ak9BRJN-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 00:56:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeqtGFHtSX681ak9BRJN-w/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 00:56:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeqtGFHtSX681ak9BRJN-w/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 00:56:38 INFO - Downloaded 24417402 bytes. 00:56:38 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'] 00:56:38 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 00:56:40 INFO - Return code: 0 00:56:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:56:40 INFO - https://queue.taskcluster.net/v1/task/aeqtGFHtSX681ak9BRJN-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 00:56:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeqtGFHtSX681ak9BRJN-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 00:56:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeqtGFHtSX681ak9BRJN-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 00:56:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeqtGFHtSX681ak9BRJN-w/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 00:56:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeqtGFHtSX681ak9BRJN-w/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 00:56:41 INFO - Downloaded 10840359 bytes. 00:56:41 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'] 00:56:41 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 00:56:41 INFO - Return code: 0 00:56:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:56:41 INFO - https://queue.taskcluster.net/v1/task/aeqtGFHtSX681ak9BRJN-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 00:56:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeqtGFHtSX681ak9BRJN-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 00:56:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeqtGFHtSX681ak9BRJN-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 00:56:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeqtGFHtSX681ak9BRJN-w/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 00:56:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aeqtGFHtSX681ak9BRJN-w/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 00:56:42 INFO - Downloaded 58602475 bytes. 00:56:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aeqtGFHtSX681ak9BRJN-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 00:56:42 INFO - mkdir: /builds/slave/test/properties 00:56:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:56:42 INFO - Writing to file /builds/slave/test/properties/build_url 00:56:42 INFO - Contents: 00:56:42 INFO - build_url:https://queue.taskcluster.net/v1/task/aeqtGFHtSX681ak9BRJN-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 00:56:43 INFO - Running post-action listener: _resource_record_post_action 00:56:43 INFO - Running post-action listener: set_extra_try_arguments 00:56:43 INFO - ##### 00:56:43 INFO - ##### Finished download-and-extract step (success) 00:56:43 INFO - ##### 00:56:43 INFO - ##### 00:56:43 INFO - ##### Running populate-webroot step. 00:56:43 INFO - ##### 00:56:43 INFO - Running pre-action listener: _resource_record_pre_action 00:56:43 INFO - Running main action method: populate_webroot 00:56:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:56:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:56:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:56:43 INFO - '--tppagecycles', 00:56:43 INFO - '7'], 00:56:43 INFO - 'tests': ['tsvgm']}}, 00:56:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:56:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:56:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:56:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:56:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:56:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:56:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:56:43 INFO - 'talos_options': ['--disable-e10s'], 00:56:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:56:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:56:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:56:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:56:43 INFO - 'talos_options': ['--disable-e10s'], 00:56:43 INFO - 'tests': ['damp', 'tps']}, 00:56:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:56:43 INFO - 'tests': ['damp', 'tps']}, 00:56:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:56:43 INFO - 'tests': ['dromaeo_dom']}, 00:56:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:56:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:56:43 INFO - 'tests': ['a11yr', 00:56:43 INFO - 'ts_paint', 00:56:43 INFO - 'tpaint', 00:56:43 INFO - 'sessionrestore', 00:56:43 INFO - 'sessionrestore_no_auto_restore', 00:56:43 INFO - 'tabpaint']}, 00:56:43 INFO - 'other-e10s': {'tests': ['a11yr', 00:56:43 INFO - 'ts_paint', 00:56:43 INFO - 'tpaint', 00:56:43 INFO - 'sessionrestore', 00:56:43 INFO - 'sessionrestore_no_auto_restore', 00:56:43 INFO - 'tabpaint']}, 00:56:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:56:43 INFO - 'ts_paint', 00:56:43 INFO - 'tpaint', 00:56:43 INFO - 'sessionrestore', 00:56:43 INFO - 'sessionrestore_no_auto_restore', 00:56:43 INFO - 'tabpaint']}, 00:56:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:56:43 INFO - 'ts_paint', 00:56:43 INFO - 'tpaint', 00:56:43 INFO - 'sessionrestore', 00:56:43 INFO - 'sessionrestore_no_auto_restore', 00:56:43 INFO - 'tabpaint']}, 00:56:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:56:43 INFO - 'tests': ['a11yr', 00:56:43 INFO - 'ts_paint', 00:56:43 INFO - 'tpaint', 00:56:43 INFO - 'sessionrestore', 00:56:43 INFO - 'sessionrestore_no_auto_restore', 00:56:43 INFO - 'tabpaint']}, 00:56:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:56:43 INFO - 'tests': ['a11yr', 00:56:43 INFO - 'ts_paint', 00:56:43 INFO - 'tpaint', 00:56:43 INFO - 'sessionrestore', 00:56:43 INFO - 'sessionrestore_no_auto_restore', 00:56:43 INFO - 'tabpaint']}, 00:56:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:56:43 INFO - 'tests': ['tsvgx', 00:56:43 INFO - 'tsvgr_opacity', 00:56:43 INFO - 'tart', 00:56:43 INFO - 'tscrollx', 00:56:43 INFO - 'cart']}, 00:56:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:56:43 INFO - 'tsvgr_opacity', 00:56:43 INFO - 'tart', 00:56:43 INFO - 'tscrollx', 00:56:43 INFO - 'cart']}, 00:56:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:56:43 INFO - 'talos_options': ['--disable-e10s'], 00:56:43 INFO - 'tests': ['tp5o']}, 00:56:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:56:43 INFO - 'tests': ['tp5o']}, 00:56:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:56:43 INFO - 'talos_options': ['--disable-e10s', 00:56:43 INFO - '--xperf_path', 00:56:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:56:43 INFO - 'tests': ['tp5n']}, 00:56:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:56:43 INFO - 'talos_options': ['--xperf_path', 00:56:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:56:43 INFO - 'tests': ['tp5n']}}, 00:56:43 INFO - 'talos.zip': {'path': '', 00:56:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:56:43 INFO - Running post-action listener: _resource_record_post_action 00:56:43 INFO - ##### 00:56:43 INFO - ##### Finished populate-webroot step (success) 00:56:43 INFO - ##### 00:56:43 INFO - ##### 00:56:43 INFO - ##### Running create-virtualenv step. 00:56:43 INFO - ##### 00:56:43 INFO - Running pre-action listener: _resource_record_pre_action 00:56:43 INFO - Running main action method: create_virtualenv 00:56:43 INFO - Creating virtualenv /builds/slave/test/build/venv 00:56:43 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 00:56:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:56:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:56:43 INFO - Using real prefix '/usr' 00:56:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:56:44 INFO - Installing distribute.............................................................................................................................................................................................done. 00:56:46 INFO - Installing pip.................done. 00:56:46 INFO - Return code: 0 00:56:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:56:46 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')]} 00:56:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:56:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:46 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')]} 00:56:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:56:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:46 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 0x7fda8cf42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x150a8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1599b20>, '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 0x159aa20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x159aeb0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1464076539.93700-138900510', '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 00:56:46 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 00:56:46 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 00:56:46 INFO - Using env: {'DISPLAY': ':0', 00:56:46 INFO - 'HOME': '/home/cltbld', 00:56:46 INFO - 'LANG': 'en_US.UTF-8', 00:56:46 INFO - 'LANGUAGE': 'en_US:en', 00:56:46 INFO - 'LOGNAME': 'cltbld', 00:56:46 INFO - 'MAIL': '/var/mail/cltbld', 00:56:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:56:46 INFO - 'MOZ_NO_REMOTE': '1', 00:56:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:56:46 INFO - 'NO_EM_RESTART': '1', 00:56:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:56:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:56:46 INFO - 'PWD': '/builds/slave/test', 00:56:46 INFO - 'SHELL': '/bin/bash', 00:56:46 INFO - 'SHLVL': '1', 00:56:46 INFO - 'TERM': 'linux', 00:56:46 INFO - 'TMOUT': '86400', 00:56:46 INFO - 'USER': 'cltbld', 00:56:46 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1464076539.93700-138900510', 00:56:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:56:46 INFO - '_': '/tools/buildbot/bin/python'} 00:56:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:56:46 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 00:56:46 INFO - Cleaning up... 00:56:46 INFO - Return code: 0 00:56:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:56:46 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')]} 00:56:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:56:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:46 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')]} 00:56:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:56:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:46 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 0x7fda8cf42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x150a8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1599b20>, '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 0x159aa20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x159aeb0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1464076539.93700-138900510', '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 00:56:46 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 00:56:46 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 00:56:46 INFO - Using env: {'DISPLAY': ':0', 00:56:46 INFO - 'HOME': '/home/cltbld', 00:56:46 INFO - 'LANG': 'en_US.UTF-8', 00:56:46 INFO - 'LANGUAGE': 'en_US:en', 00:56:46 INFO - 'LOGNAME': 'cltbld', 00:56:46 INFO - 'MAIL': '/var/mail/cltbld', 00:56:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:56:46 INFO - 'MOZ_NO_REMOTE': '1', 00:56:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:56:46 INFO - 'NO_EM_RESTART': '1', 00:56:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:56:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:56:46 INFO - 'PWD': '/builds/slave/test', 00:56:46 INFO - 'SHELL': '/bin/bash', 00:56:46 INFO - 'SHLVL': '1', 00:56:46 INFO - 'TERM': 'linux', 00:56:46 INFO - 'TMOUT': '86400', 00:56:46 INFO - 'USER': 'cltbld', 00:56:46 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1464076539.93700-138900510', 00:56:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:56:46 INFO - '_': '/tools/buildbot/bin/python'} 00:56:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:56:46 INFO - Downloading/unpacking psutil>=3.1.1 00:56: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 00:56: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 00:56: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 00:56: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 00:56: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 00:56: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 00:56:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:56:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:56:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:56:48 INFO - Installing collected packages: psutil 00:56:48 INFO - Running setup.py install for psutil 00:56:48 INFO - building 'psutil._psutil_linux' extension 00:56:48 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 00:56:48 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 00:56:48 INFO - building 'psutil._psutil_posix' extension 00:56:48 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 00:56:49 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 00:56:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:56:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:56:49 INFO - Successfully installed psutil 00:56:49 INFO - Cleaning up... 00:56:49 INFO - Return code: 0 00:56:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:56: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')]} 00:56:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:56:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56: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')]} 00:56:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:56:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda8cf42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x150a8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1599b20>, '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 0x159aa20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x159aeb0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1464076539.93700-138900510', '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 00:56: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 00:56: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 mozsystemmonitor==0.3 00:56:49 INFO - Using env: {'DISPLAY': ':0', 00:56:49 INFO - 'HOME': '/home/cltbld', 00:56:49 INFO - 'LANG': 'en_US.UTF-8', 00:56:49 INFO - 'LANGUAGE': 'en_US:en', 00:56:49 INFO - 'LOGNAME': 'cltbld', 00:56:49 INFO - 'MAIL': '/var/mail/cltbld', 00:56:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:56:49 INFO - 'MOZ_NO_REMOTE': '1', 00:56:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:56:49 INFO - 'NO_EM_RESTART': '1', 00:56:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:56:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:56:49 INFO - 'PWD': '/builds/slave/test', 00:56:49 INFO - 'SHELL': '/bin/bash', 00:56:49 INFO - 'SHLVL': '1', 00:56:49 INFO - 'TERM': 'linux', 00:56:49 INFO - 'TMOUT': '86400', 00:56:49 INFO - 'USER': 'cltbld', 00:56:49 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1464076539.93700-138900510', 00:56:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:56:49 INFO - '_': '/tools/buildbot/bin/python'} 00:56:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:56:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:56: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 00:56: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 00:56: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 00:56: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 00:56: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 00:56: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 00:56:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:56:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:56:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:56:51 INFO - Installing collected packages: mozsystemmonitor 00:56:51 INFO - Running setup.py install for mozsystemmonitor 00:56:51 INFO - Successfully installed mozsystemmonitor 00:56:51 INFO - Cleaning up... 00:56:51 INFO - Return code: 0 00:56:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:56: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')]} 00:56:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:56:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56: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')]} 00:56:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:56:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56: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', '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 0x7fda8cf42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x150a8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1599b20>, '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 0x159aa20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x159aeb0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1464076539.93700-138900510', '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 00:56: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 00:56: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 blobuploader==1.2.4 00:56:51 INFO - Using env: {'DISPLAY': ':0', 00:56:51 INFO - 'HOME': '/home/cltbld', 00:56:51 INFO - 'LANG': 'en_US.UTF-8', 00:56:51 INFO - 'LANGUAGE': 'en_US:en', 00:56:51 INFO - 'LOGNAME': 'cltbld', 00:56:51 INFO - 'MAIL': '/var/mail/cltbld', 00:56:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:56:51 INFO - 'MOZ_NO_REMOTE': '1', 00:56:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:56:51 INFO - 'NO_EM_RESTART': '1', 00:56:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:56:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:56:51 INFO - 'PWD': '/builds/slave/test', 00:56:51 INFO - 'SHELL': '/bin/bash', 00:56:51 INFO - 'SHLVL': '1', 00:56:51 INFO - 'TERM': 'linux', 00:56:51 INFO - 'TMOUT': '86400', 00:56:51 INFO - 'USER': 'cltbld', 00:56:51 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1464076539.93700-138900510', 00:56:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:56:51 INFO - '_': '/tools/buildbot/bin/python'} 00:56:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:56:51 INFO - Downloading/unpacking blobuploader==1.2.4 00:56: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 00:56: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 00:56: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 00:56: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 00:56: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 00:56: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 00:56:53 INFO - Downloading blobuploader-1.2.4.tar.gz 00:56:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:56:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:56: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 00:56: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 00:56: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 00:56: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 00:56: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 00:56: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 00:56:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:56:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:56: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 00:56: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 00:56: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 00:56: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 00:56: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 00:56: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 00:56:54 INFO - Downloading docopt-0.6.1.tar.gz 00:56:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:56:54 INFO - Installing collected packages: blobuploader, requests, docopt 00:56:54 INFO - Running setup.py install for blobuploader 00:56:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:56:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:56:54 INFO - Running setup.py install for requests 00:56:55 INFO - Running setup.py install for docopt 00:56:55 INFO - Successfully installed blobuploader requests docopt 00:56:55 INFO - Cleaning up... 00:56:55 INFO - Return code: 0 00:56:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:56:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:56:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:56:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:56:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:56:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:55 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 0x7fda8cf42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x150a8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1599b20>, '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 0x159aa20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x159aeb0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1464076539.93700-138900510', '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 00:56:55 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 00:56:55 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 00:56:55 INFO - Using env: {'DISPLAY': ':0', 00:56:55 INFO - 'HOME': '/home/cltbld', 00:56:55 INFO - 'LANG': 'en_US.UTF-8', 00:56:55 INFO - 'LANGUAGE': 'en_US:en', 00:56:55 INFO - 'LOGNAME': 'cltbld', 00:56:55 INFO - 'MAIL': '/var/mail/cltbld', 00:56:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:56:55 INFO - 'MOZ_NO_REMOTE': '1', 00:56:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:56:55 INFO - 'NO_EM_RESTART': '1', 00:56:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:56:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:56:55 INFO - 'PWD': '/builds/slave/test', 00:56:55 INFO - 'SHELL': '/bin/bash', 00:56:55 INFO - 'SHLVL': '1', 00:56:55 INFO - 'TERM': 'linux', 00:56:55 INFO - 'TMOUT': '86400', 00:56:55 INFO - 'USER': 'cltbld', 00:56:55 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1464076539.93700-138900510', 00:56:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:56:55 INFO - '_': '/tools/buildbot/bin/python'} 00:56:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:56:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:56:55 INFO - Running setup.py (path:/tmp/pip-Tbv65v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:56:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:56:55 INFO - Running setup.py (path:/tmp/pip-cpoJJf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:56:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:56:55 INFO - Running setup.py (path:/tmp/pip-rVyWUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:56:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:56:55 INFO - Running setup.py (path:/tmp/pip-7PDBy1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:56:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:56:55 INFO - Running setup.py (path:/tmp/pip-dKWYy0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:56:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:56:55 INFO - Running setup.py (path:/tmp/pip-l6wANR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:56:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:56:55 INFO - Running setup.py (path:/tmp/pip-4gP1iK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:56:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:56:55 INFO - Running setup.py (path:/tmp/pip-48yicW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:56:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:56:55 INFO - Running setup.py (path:/tmp/pip-sBydOJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:56:56 INFO - Running setup.py (path:/tmp/pip-0sPgtF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:56:56 INFO - Running setup.py (path:/tmp/pip-LZBImv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:56:56 INFO - Running setup.py (path:/tmp/pip-SkyFOY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:56:56 INFO - Running setup.py (path:/tmp/pip-NlZigD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:56:56 INFO - Running setup.py (path:/tmp/pip-nayrQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:56:56 INFO - Running setup.py (path:/tmp/pip-lUDyuz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:56:56 INFO - Running setup.py (path:/tmp/pip-vJYGVJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:56:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:56:56 INFO - Running setup.py (path:/tmp/pip-rMwnVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:56:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:56:56 INFO - Running setup.py install for manifestparser 00:56:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:56:56 INFO - Running setup.py install for mozcrash 00:56:56 INFO - Running setup.py install for mozdebug 00:56:56 INFO - Running setup.py install for mozdevice 00:56:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:56:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:56:57 INFO - Running setup.py install for mozfile 00:56:57 INFO - Running setup.py install for mozhttpd 00:56:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:56:57 INFO - Running setup.py install for mozinfo 00:56:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:56:57 INFO - Running setup.py install for mozInstall 00:56:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:56:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:56:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:56:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:56:57 INFO - Running setup.py install for mozleak 00:56:57 INFO - Running setup.py install for mozlog 00:56:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:56:57 INFO - Running setup.py install for moznetwork 00:56:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:56:57 INFO - Running setup.py install for mozprocess 00:56:57 INFO - Running setup.py install for mozprofile 00:56:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:56:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:56:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:56:57 INFO - Running setup.py install for mozrunner 00:56:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:56:58 INFO - Running setup.py install for mozscreenshot 00:56:58 INFO - Running setup.py install for moztest 00:56:58 INFO - Running setup.py install for mozversion 00:56:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:56:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:56:58 INFO - Cleaning up... 00:56:58 INFO - Return code: 0 00:56:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:56:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:56:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:56:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:56:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:56:58 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 0x7fda8cf42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x150a8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1599b20>, '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 0x159aa20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x159aeb0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1464076539.93700-138900510', '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 00:56:58 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 00:56:58 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 00:56:58 INFO - Using env: {'DISPLAY': ':0', 00:56:58 INFO - 'HOME': '/home/cltbld', 00:56:58 INFO - 'LANG': 'en_US.UTF-8', 00:56:58 INFO - 'LANGUAGE': 'en_US:en', 00:56:58 INFO - 'LOGNAME': 'cltbld', 00:56:58 INFO - 'MAIL': '/var/mail/cltbld', 00:56:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:56:58 INFO - 'MOZ_NO_REMOTE': '1', 00:56:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:56:58 INFO - 'NO_EM_RESTART': '1', 00:56:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:56:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:56:58 INFO - 'PWD': '/builds/slave/test', 00:56:58 INFO - 'SHELL': '/bin/bash', 00:56:58 INFO - 'SHLVL': '1', 00:56:58 INFO - 'TERM': 'linux', 00:56:58 INFO - 'TMOUT': '86400', 00:56:58 INFO - 'USER': 'cltbld', 00:56:58 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1464076539.93700-138900510', 00:56:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:56:58 INFO - '_': '/tools/buildbot/bin/python'} 00:56:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:56:58 INFO - Running setup.py (path:/tmp/pip-iwUZqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:56:58 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)) 00:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:56:58 INFO - Running setup.py (path:/tmp/pip-v3QIMM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:56:58 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)) 00:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:56:58 INFO - Running setup.py (path:/tmp/pip-TeDdE0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:56:58 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)) 00:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:56:58 INFO - Running setup.py (path:/tmp/pip-UNDmSl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:56:58 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)) 00:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:56:58 INFO - Running setup.py (path:/tmp/pip-fcUZwZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:56:58 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)) 00:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:56:58 INFO - Running setup.py (path:/tmp/pip-M25xIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:56:59 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)) 00:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:56:59 INFO - Running setup.py (path:/tmp/pip-jrC7k5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:56:59 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)) 00:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:56:59 INFO - Running setup.py (path:/tmp/pip-h_sVgZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:56:59 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)) 00:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:56:59 INFO - Running setup.py (path:/tmp/pip-QoQxXh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:56:59 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)) 00:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:56:59 INFO - Running setup.py (path:/tmp/pip-99OQQz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:56:59 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)) 00:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:56:59 INFO - Running setup.py (path:/tmp/pip-1WS3PZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:56:59 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)) 00:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:56:59 INFO - Running setup.py (path:/tmp/pip-Bl1y91-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:56:59 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)) 00:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:56:59 INFO - Running setup.py (path:/tmp/pip-Hfvv9E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:56:59 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)) 00:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:56:59 INFO - Running setup.py (path:/tmp/pip-cDJpTU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:56:59 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)) 00:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:56:59 INFO - Running setup.py (path:/tmp/pip-Fevo7d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:56:59 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)) 00:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:56:59 INFO - Running setup.py (path:/tmp/pip-jx6eFE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:56:59 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)) 00:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:56:59 INFO - Running setup.py (path:/tmp/pip-U1x7g0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:56:59 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)) 00:56:59 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)) 00:56:59 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)) 00:56:59 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)) 00:56:59 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)) 00:56:59 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)) 00:56:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:56:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:56:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:56:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:56:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:57:01 INFO - Downloading blessings-1.6.tar.gz 00:57:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:57:01 INFO - Installing collected packages: blessings 00:57:01 INFO - Running setup.py install for blessings 00:57:01 INFO - Successfully installed blessings 00:57:01 INFO - Cleaning up... 00:57:01 INFO - Return code: 0 00:57:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:57:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:57:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:57:02 INFO - Reading from file tmpfile_stdout 00:57:02 INFO - Current package versions: 00:57:02 INFO - argparse == 1.2.1 00:57:02 INFO - blessings == 1.6 00:57:02 INFO - blobuploader == 1.2.4 00:57:02 INFO - docopt == 0.6.1 00:57:02 INFO - manifestparser == 1.1 00:57:02 INFO - mozInstall == 1.12 00:57:02 INFO - mozcrash == 0.17 00:57:02 INFO - mozdebug == 0.1 00:57:02 INFO - mozdevice == 0.48 00:57:02 INFO - mozfile == 1.2 00:57:02 INFO - mozhttpd == 0.7 00:57:02 INFO - mozinfo == 0.9 00:57:02 INFO - mozleak == 0.1 00:57:02 INFO - mozlog == 3.2 00:57:02 INFO - moznetwork == 0.27 00:57:02 INFO - mozprocess == 0.22 00:57:02 INFO - mozprofile == 0.28 00:57:02 INFO - mozrunner == 6.11 00:57:02 INFO - mozscreenshot == 0.1 00:57:02 INFO - mozsystemmonitor == 0.3 00:57:02 INFO - moztest == 0.7 00:57:02 INFO - mozversion == 1.4 00:57:02 INFO - psutil == 3.1.1 00:57:02 INFO - requests == 1.2.3 00:57:02 INFO - wsgiref == 0.1.2 00:57:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:57:02 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')]} 00:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:57:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:57:02 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')]} 00:57:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:57:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:57:02 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 0x7fda8cf42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x150a8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1599b20>, '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 0x159aa20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x159aeb0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1464076539.93700-138900510', '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 00:57:02 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 00:57:02 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 00:57:02 INFO - Using env: {'DISPLAY': ':0', 00:57:02 INFO - 'HOME': '/home/cltbld', 00:57:02 INFO - 'LANG': 'en_US.UTF-8', 00:57:02 INFO - 'LANGUAGE': 'en_US:en', 00:57:02 INFO - 'LOGNAME': 'cltbld', 00:57:02 INFO - 'MAIL': '/var/mail/cltbld', 00:57:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:57:02 INFO - 'MOZ_NO_REMOTE': '1', 00:57:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:57:02 INFO - 'NO_EM_RESTART': '1', 00:57:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:57:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:57:02 INFO - 'PWD': '/builds/slave/test', 00:57:02 INFO - 'SHELL': '/bin/bash', 00:57:02 INFO - 'SHLVL': '1', 00:57:02 INFO - 'TERM': 'linux', 00:57:02 INFO - 'TMOUT': '86400', 00:57:02 INFO - 'USER': 'cltbld', 00:57:02 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1464076539.93700-138900510', 00:57:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:57:02 INFO - '_': '/tools/buildbot/bin/python'} 00:57:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:57:02 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)) 00:57:02 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)) 00:57:02 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)) 00:57:02 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)) 00:57:02 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)) 00:57:02 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)) 00:57:02 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)) 00:57:02 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)) 00:57:02 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)) 00:57:02 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)) 00:57:02 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)) 00:57:02 INFO - Cleaning up... 00:57:02 INFO - Return code: 0 00:57:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:57:02 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')]} 00:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:57:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:57:02 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')]} 00:57:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:57:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:57:02 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 0x7fda8cf42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x150a8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1599b20>, '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 0x159aa20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x159aeb0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1464076539.93700-138900510', '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 00:57:02 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 00:57:02 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 00:57:02 INFO - Using env: {'DISPLAY': ':0', 00:57:02 INFO - 'HOME': '/home/cltbld', 00:57:02 INFO - 'LANG': 'en_US.UTF-8', 00:57:02 INFO - 'LANGUAGE': 'en_US:en', 00:57:02 INFO - 'LOGNAME': 'cltbld', 00:57:02 INFO - 'MAIL': '/var/mail/cltbld', 00:57:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:57:02 INFO - 'MOZ_NO_REMOTE': '1', 00:57:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:57:02 INFO - 'NO_EM_RESTART': '1', 00:57:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:57:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:57:02 INFO - 'PWD': '/builds/slave/test', 00:57:02 INFO - 'SHELL': '/bin/bash', 00:57:02 INFO - 'SHLVL': '1', 00:57:02 INFO - 'TERM': 'linux', 00:57:02 INFO - 'TMOUT': '86400', 00:57:02 INFO - 'USER': 'cltbld', 00:57:02 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1464076539.93700-138900510', 00:57:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:57:02 INFO - '_': '/tools/buildbot/bin/python'} 00:57:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:57:02 INFO - Downloading/unpacking jsonschema 00:57:02 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 00:57:02 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 00:57:02 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 00:57:02 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 00:57:02 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 00:57:02 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 00:57:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:57:04 INFO - Downloading/unpacking functools32 (from jsonschema) 00:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:57:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:57:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:57:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:57:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:57:04 INFO - Downloading functools32-3.2.3-2.tar.gz 00:57:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:57:04 INFO - warning: no files found matching '*.txt' 00:57:04 INFO - no previously-included directories found matching 'build' 00:57:04 INFO - no previously-included directories found matching 'dist' 00:57:04 INFO - no previously-included directories found matching '.git*' 00:57:04 INFO - Installing collected packages: jsonschema, functools32 00:57:04 INFO - Running setup.py install for functools32 00:57:04 INFO - warning: no files found matching '*.txt' 00:57:04 INFO - no previously-included directories found matching 'build' 00:57:04 INFO - no previously-included directories found matching 'dist' 00:57:04 INFO - no previously-included directories found matching '.git*' 00:57:04 INFO - Successfully installed jsonschema functools32 00:57:04 INFO - Cleaning up... 00:57:04 INFO - Return code: 0 00:57:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 00:57:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:57:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:57:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:57:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:57:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:57:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda8cf42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x143e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x150a8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1599b20>, '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 0x159aa20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x159aeb0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1464076539.93700-138900510', '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 00:57:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 00:57:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 00:57:04 INFO - Using env: {'DISPLAY': ':0', 00:57:04 INFO - 'HOME': '/home/cltbld', 00:57:04 INFO - 'LANG': 'en_US.UTF-8', 00:57:04 INFO - 'LANGUAGE': 'en_US:en', 00:57:04 INFO - 'LOGNAME': 'cltbld', 00:57:04 INFO - 'MAIL': '/var/mail/cltbld', 00:57:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:57:04 INFO - 'MOZ_NO_REMOTE': '1', 00:57:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:57:04 INFO - 'NO_EM_RESTART': '1', 00:57:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:57:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:57:04 INFO - 'PWD': '/builds/slave/test', 00:57:04 INFO - 'SHELL': '/bin/bash', 00:57:04 INFO - 'SHLVL': '1', 00:57:04 INFO - 'TERM': 'linux', 00:57:04 INFO - 'TMOUT': '86400', 00:57:04 INFO - 'USER': 'cltbld', 00:57:04 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1464076539.93700-138900510', 00:57:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:57:04 INFO - '_': '/tools/buildbot/bin/python'} 00:57:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:57:05 INFO - Downloading/unpacking flake8 00:57:05 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 00:57:05 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 00:57:05 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 00:57:05 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 00:57:05 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 00:57:05 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 00:57:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 00:57:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 00:57:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:57:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:57:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:57:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:57:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:57:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:57:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 00:57:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 00:57:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:57:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:57:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:57:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:57:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:57:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:57:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 00:57:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:57:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:57:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:57:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:57:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:57:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:57:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 00:57:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:57:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:57:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:57:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:57:07 INFO - no previously-included directories found matching 'docs/_build' 00:57:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 00:57:07 INFO - Running setup.py install for pep8 00:57:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:57:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:57:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:57:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:57:07 INFO - no previously-included directories found matching 'docs/_build' 00:57:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 00:57:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 00:57:07 INFO - Cleaning up... 00:57:08 INFO - Return code: 0 00:57:08 INFO - Running post-action listener: _resource_record_post_action 00:57:08 INFO - Running post-action listener: _start_resource_monitoring 00:57:08 INFO - Starting resource monitoring. 00:57:08 INFO - ##### 00:57:08 INFO - ##### Finished create-virtualenv step (success) 00:57:08 INFO - ##### 00:57:08 INFO - ##### 00:57:08 INFO - ##### Running install step. 00:57:08 INFO - ##### 00:57:08 INFO - Running pre-action listener: _resource_record_pre_action 00:57:08 INFO - Running main action method: install 00:57:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:57:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:57:08 INFO - Reading from file tmpfile_stdout 00:57:08 INFO - Detecting whether we're running mozinstall >=1.0... 00:57:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:57:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:57:08 INFO - Reading from file tmpfile_stdout 00:57:08 INFO - Output received: 00:57:08 INFO - Usage: mozinstall [options] installer 00:57:08 INFO - Options: 00:57:08 INFO - -h, --help show this help message and exit 00:57:08 INFO - -d DEST, --destination=DEST 00:57:08 INFO - Directory to install application into. [default: 00:57:08 INFO - "/builds/slave/test"] 00:57:08 INFO - --app=APP Application being installed. [default: firefox] 00:57:08 INFO - mkdir: /builds/slave/test/build/application 00:57:08 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'] 00:57:08 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 00:57:25 INFO - Reading from file tmpfile_stdout 00:57:25 INFO - Output received: 00:57:25 INFO - /builds/slave/test/build/application/firefox/firefox 00:57:25 INFO - Running post-action listener: _resource_record_post_action 00:57:25 INFO - ##### 00:57:25 INFO - ##### Finished install step (success) 00:57:25 INFO - ##### 00:57:25 INFO - ##### 00:57:25 INFO - ##### Running run-tests step. 00:57:25 INFO - ##### 00:57:25 INFO - Running pre-action listener: _resource_record_pre_action 00:57:25 INFO - Running main action method: run_tests 00:57:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:57:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:57:25 INFO - Python 2.7.3 00:57:25 INFO - Return code: 0 00:57:25 INFO - grabbing minidump binary from tooltool 00:57:25 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')]} 00:57:25 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 0x1599b20>, '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 0x159aa20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x159aeb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:57:25 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 00:57:25 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 00:57:25 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 00:57:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:57:25 INFO - Return code: 0 00:57:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:57:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:57:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:57:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:57:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:57:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 00:57:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 00:57:26 INFO - Return code: 0 00:57:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aeqtGFHtSX681ak9BRJN-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 00:57:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aeqtGFHtSX681ak9BRJN-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --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 00:57:26 INFO - Using env: {'DISPLAY': ':0', 00:57:26 INFO - 'HOME': '/home/cltbld', 00:57:26 INFO - 'LANG': 'en_US.UTF-8', 00:57:26 INFO - 'LANGUAGE': 'en_US:en', 00:57:26 INFO - 'LOGNAME': 'cltbld', 00:57:26 INFO - 'MAIL': '/var/mail/cltbld', 00:57:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:57:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:57:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:57:26 INFO - 'MOZ_NO_REMOTE': '1', 00:57:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:57:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:57:26 INFO - 'NO_EM_RESTART': '1', 00:57:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:57:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:57:26 INFO - 'PWD': '/builds/slave/test', 00:57:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:57:26 INFO - 'SHELL': '/bin/bash', 00:57:26 INFO - 'SHLVL': '1', 00:57:26 INFO - 'TERM': 'linux', 00:57:26 INFO - 'TMOUT': '86400', 00:57:26 INFO - 'USER': 'cltbld', 00:57:26 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1464076539.93700-138900510', 00:57:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:57:26 INFO - '_': '/tools/buildbot/bin/python'} 00:57:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aeqtGFHtSX681ak9BRJN-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 00:57:26 INFO - mozversion application_buildid: 20160523223126 00:57:26 INFO - mozversion application_changeset: feb13c8b708aade4acf07e520682c2a9f9328544 00:57:26 INFO - mozversion application_display_name: Nightly 00:57:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:57:26 INFO - mozversion application_name: Firefox 00:57:26 INFO - mozversion application_remotingname: firefox 00:57:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 00:57:26 INFO - mozversion application_vendor: Mozilla 00:57:26 INFO - mozversion application_version: 49.0a1 00:57:26 INFO - mozversion platform_buildid: 20160523223126 00:57:26 INFO - mozversion platform_changeset: feb13c8b708aade4acf07e520682c2a9f9328544 00:57:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 00:57:26 INFO - mozversion platform_version: 49.0a1 00:57:26 INFO - using testdate: 1464076646 00:57:26 INFO - actual date: 1464076646 00:57:26 INFO - starting webserver on 'localhost:46362' 00:57:26 INFO - SUITE-START | Running 2 tests 00:57:26 INFO - TEST-START | dromaeo_css 00:57:26 INFO - operating with platform_type : linux_ 00:57:26 INFO - Initialising browser for dromaeo_css test... 00:57:26 INFO - TEST-INFO | started process 29444 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsUbW2x/profile http://localhost:46362/getInfo.html) 00:57:30 INFO - PROCESS | 29444 | __metrics Screen width/height:1600/1200 00:57:30 INFO - PROCESS | 29444 | colorDepth:24 00:57:30 INFO - PROCESS | 29444 | Browser inner width/height: 1024/697 00:57:30 INFO - PROCESS | 29444 | __metrics 00:57:31 ERROR - PROCESS | 29444 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 00:57:32 INFO - TEST-INFO | 29444: exit 0 00:57:32 INFO - Browser initialized. 00:57:32 INFO - Running cycle 1/1 for dromaeo_css test... 00:57:32 INFO - TEST-INFO | started process 29526 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsUbW2x/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:57:44 INFO - PROCESS | 29526 | RSS: Main: 153518080 00:57:44 INFO - PROCESS | 29526 | 00:58:35 INFO - PROCESS | 29526 | 1464076715338 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 01:00:43 INFO - PROCESS | 29526 | Cycle 1(1): loaded http://localhost:46362/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46362/tests/dromaeo/cssquery-ext.html) 01:00:44 INFO - PROCESS | 29526 | RSS: Main: 254963712 01:00:44 INFO - PROCESS | 29526 | 01:03:46 INFO - PROCESS | 29526 | Cycle 1(1): loaded http://localhost:46362/tests/dromaeo/cssquery-ext.html (next: http://localhost:46362/tests/dromaeo/cssquery-jquery.html) 01:03:47 INFO - PROCESS | 29526 | RSS: Main: 239177728 01:03:47 INFO - PROCESS | 29526 | 01:06:49 INFO - PROCESS | 29526 | Cycle 1(1): loaded http://localhost:46362/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46362/tests/dromaeo/cssquery-mootools.html) 01:06:49 INFO - PROCESS | 29526 | RSS: Main: 242884608 01:06:49 INFO - PROCESS | 29526 | 01:09:51 INFO - PROCESS | 29526 | Cycle 1(1): loaded http://localhost:46362/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46362/tests/dromaeo/cssquery-prototype.html) 01:09:52 INFO - PROCESS | 29526 | RSS: Main: 235372544 01:09:52 INFO - PROCESS | 29526 | 01:12:54 INFO - PROCESS | 29526 | Cycle 1(1): loaded http://localhost:46362/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46362/tests/dromaeo/cssquery-yui.html) 01:12:55 INFO - PROCESS | 29526 | RSS: Main: 216580096 01:12:55 INFO - PROCESS | 29526 | 01:15:58 INFO - PROCESS | 29526 | Cycle 1(1): loaded http://localhost:46362/tests/dromaeo/cssquery-yui.html (next: http://localhost:46362/tests/dromaeo/cssquery-dojo.html) 01:15:58 INFO - PROCESS | 29526 | RSS: Main: 257441792 01:15:58 INFO - PROCESS | 29526 | 01:15:58 INFO - PROCESS | 29526 | __start_tp_report 01:15:58 INFO - PROCESS | 29526 | _x_x_mozilla_page_load 01:15:58 INFO - PROCESS | 29526 | _x_x_mozilla_page_load_details 01:15:58 INFO - PROCESS | 29526 | |i|pagename|runs| 01:15:58 INFO - PROCESS | 29526 | |0;dojo.html;3132.483140281853;3155.5108958111487;3155.8106513609173;3169.714725674689;3216.4371235033864;5232.1366974449265;5286.154215325549;5395.811146609864;5475.425080366564;5506.146547285167;5451.04606693829;5452.700101494416;5481.232627432163;5502.0371434998915;5511.200875873006;4914.827981020665;4935.3090567320605;4989.9750501247445;5024.422191447976;5134.229865520165;4967.726775027372;4997.9754150399085;5000.574951129141;5033.2450132480235;5038.571721403667;4813.157697402958;4882.951170488321;4893.535114164149;4896.853094407174;4958.925616115743;4866.9513304867205;4880.438749543812;4942.975285123587;4950.232713929311;4986.152354099811;4826.975865120652;4907.190313598252;4926.778294976734;4929.112759703252;4936.950630493721;5350.973245133789;5429.077056900297;5431.619786614939;5494.615376923617;5503.3395992480755;5921.200637913869;5941.197938278364;5958.374370691058;5963.165156878041;5963.761449542013;5588.692621905793;5830;5976.97011514944;5998;5998.460138587505;5486.670799751988;5571.637843540157;5575.275214222166;5584.888302233932;5588.748506317225;6045.472859040126;6077.027675571887;6081.148639190517;6083.026715725463;6089.391060893875;5558.055130627803;5724.570657200727;5769.480746732815;5843.941560584425;5851.473367396955;5879.088741245114;5887.293524777054;5890.263717035371;5912.349641539513;5951.464368206882;5820.679862607512;5855.970720146372;5871.647701137946;5874.1776151338845;5878.265216847894;5653.180288858092;5761.8559536011935;5839.445252700986;5847.619904706181;5890.52875769946;4422.71252368595;4423.712458690175;4425.601695847325;4426.026274219666;4454.487733910577;3915.4322623219473;3936.8031598419966;3963.147923196527;3994.9201015980098;4015.598440155961;5248.265242866002;5296.655717378435;5414.160805075219;5480.095784195642;5500.367457742331;5913.994561157102;5940.732667029994;5943.465088142088;5958.970205149033;6001.969990150109;5521.861953451115;5522.337319521603;5527.44725527444;5530.834074977757;5532.17017447378;4644.953550464452;4810.903781924342;4851.296561998491;4862.781174847069;4864.854054378375;6037.154798328237;6049.516038716892;6053.909191362133;6054.606450580698;6087.69561521931;5551.916721249104;5851.444112809361;5862.472377486047;5865.973454645506;5866.090755932837;6006.219191505076;6044.576879618385;6074.848128796815;6100.420460056288;6117.96941015292;5751.166080918327;5792.160136780228;5799.565032622486;5802.5357971361345;5806.303243610793;5639.6334238274385;5761.91357129635;5855.063189889597;5869.383714710065;5870.53035757147;5653.434656534479;5699.059655156852;5702.572307077069;5704.458076482728;5757.136429535603;5644.435556444323;5682.3465301489205;5695.658260504383;5697.601167918206;5705;5345.492178243061;5583.330000399978;5618.2415373924;5621.184928185472;5632.633878797865;5782.826515204551;5815.04051831443;5819.185314056121;5825.825225243249;5834.766609335579;5606.523445507178;5652.689102099424;5660.830175094754;5674.120511320752;5699.458551437607 01:15:58 INFO - PROCESS | 29526 | |1;ext.html;600.6816387314725;630.949524038077;648.3840351665918;650.07039932896;668.4986260304771;32401.51397729033;35828.283434331366;35866.8206658967;35868.820655896714;35874.282514349696;43998.340024899655;45209.54790452094;45269.54730452695;49403;49546.25680614794;8644.913550864489;8772.69295574655;8805.911940880573;8852.690155844515;8886.511241881693;8716.607752651145;8851.468911865277;8853.95573022134;8856;8856.114388561125;8857.247133993586;8913.821723565525;8918.420302680304;8921.866172007425;8927.508987005713;8830.514321712304;8924;8930.598123084477;8939.597718102701;8945.910540894572;8770.517621530813;8885.378023538355;8895.066018068139;8895.4662720237;8896.644134234622;39075.60924390776;39330.213395732215;39392;39516;39579.80210098931;3680.0799800049986;3835.5013848199833;3897.3569361055393;4123.711340206187;4355.695101342907;32202;32563.348733025443;32928;33005.50491742602;34160.65839341599;4194.601512856274;4316.136772645484;4320.049589090427;4412.955870441287;4443;348340;349243.99999999744;350330;351455;351896;58408;58870.17343872634;58877.41122588805;58913.41086589079;59292;62576.374236257965;62592.37407625865;62603.68698156571;62761;62934;16335.754963675554;16666.916665416597;16697.582560436087;16699.499015029567;16764.245608947625;12147.271163730204;12313.938430307791;12334.691632709255;12351.19717218378;12564.937175314066;15285.465008724641;17368.47894563165;17379.913100434416;17395.130243487776;17415.303387864344;6349.619022858643;6471.482281417475;6502.512311576651;6578.6052836828985;6625.86748265032;849.3078141314809;1014.7412409835592;1029.9639512617023;1069.2087854987253;1137.8748337682848;33017;33305.50041749376;33388;33513.3297334052;33578;1125.5047778977223;1141.0928311991986;1183.2013390961067;1237.1463690054013;1247.6631309546372;17110.401135960183;17370.565735856453;17505.912470437823;17525;17708.557286067953;485358;787848;809063;812223;813024;57547.71226143843;57953.4204657948;58371;58399.70800146057;58482;1271.4723389793317;1420.1975883625719;1432.684809341964;1457.9562613121623;1471.124680814892;30638.387232254783;32807.67192328046;35215.47176792401;35311.29377412489;35467.82266088756;55605.60985975383;58267;58348.12477812921;64440.67779661072;64875;408480;415046;415778;417952;418072;38094.809525952194;43900;43951;44516.777416114004;45318.32022519599;50058.49941500538;50091.49908500868;50533;51237.23144152766;52186.47813521816;41249.587504124574;42340.576594233666;42861.785691071345;43608;44239.778801105786;42049.579504204565;42793.47389607997;42875.26469295602;42978;43024.56975430206;42736.78631606822;43501;43532;44130.338044929995;44182.55817441913;36688;37331.440028399054;38814.80592597019;39110.82667519979;39240;28556.143315700563;28660.283492912844;28965.40801124561;29047.273818154714;29097.418051639273 01:15:58 INFO - PROCESS | 29526 | |2;jquery.html;392.86838908965507;394.84798352634226;397.370168283271;409.72343668024075;413.4645633904094;13962.383498552084;17241.827581724177;18168;19447.902760486195;19462;18529;18606.16272267748;19238.32665856695;19249.80750192501;19403.514912127204;5590.776368945238;5780.53755699543;5785.508231800302;5791.362950075489;5795.420457954213;4098.7130900836955;5670.8015219467325;5728.198052272685;6030.517558595302;6433.839154021163;6406.039094135894;6500.772472963447;6531.412172904437;6546.345365463463;6552.803415897531;6353.174087368659;6436.066770318301;6513;6514.250861150981;6538.574992625464;5461.344638643388;5717.056685646863;5736.340320863071;5757.625754325955;5760.049591817345;22903.88548057249;23220.76779232203;23758.76241237583;23832.880835595883;23874.283771486884;2384.678068460753;2448.951020979588;2463.0886571968485;2540.453802432486;2553.323369307135;13922.582322530341;14384.35270412834;14430;14503.274836258144;14798.926005369904;1856.9535761605932;1953.8143876331726;1970.6157299326637;1982.098145343865;2047.06858379437;80802.59598702028;83266;83527.5823620878;83752.58123709404;84744;10513.421761803022;10591.669832636808;10595.788084238273;10774.46800001999;10887.292325998786;15265.694686106215;15307.15810630426;15372.923135384475;15381;15381.846181538265;8138.389620778347;8426;8554.315654747605;8637.26583240419;8643.956780216058;8261.8347633047;8279.8344033119;8311;8424.241818236389;8442.577871106543;6744.22441419243;6794.490413219029;6852.937794641838;6892.694303364434;6912.101426814482;1912.254220853868;1956.6184594004317;1969.8522610803961;1981.5739615982634;2049.477383267287;941.8634298026748;1022.4223313827664;1025.3847691385258;1052.7841792432532;1091.9071878890225;19809.900950495154;20460.69308960337;20576.27983020617;20767;20915.37253882386;1030.8762948446235;1066.157735389034;1099.571167244775;1117.2681893359863;1144.416347662698;10869.782604347869;11436;11449.59926402572;11504.367259800623;11507.67661718913;457396;477558;479182;481470;488634;96520.51739741396;103077;103426.48286758669;103745.48127259316;104116.47941760243;1042.1714736784274;1058.1059005140644;1069.8555694981233;1077.7251800790905;1078.2344535379968;17279.3952211672;17306.567335816704;17446.563835904202;17448.91275543614;17765.111744412985;37916;42444;42969.35545966875;43822.12355752803;44559.77720111508;53654.46345536651;56495;57958.4204157953;58107;59507.404925950184;7975.361971042186;8363.121872203332;8424.578771061544;8431.53626550521;8499.74500764978;12451.750964980469;12892.097553171188;12911.5480958166;12986.935065324613;13082.934585327394;11288.774224515628;11371.886281137082;11699.824502632297;11711.1802173847;11816.468258928197;5457.072297709478;8353.874691879748;9904.405735655884;11504.712382190512;11749.76500470003;11761.176717629683;11851.822222666839;11915.106367022334;11956.880431195925;11960.162788604714;8004.199580041949;8313.376496762647;8364.581770911553;8436.11420800807;8466.492010479391;10889.564417423531;11453.626102362949;11521.423928803359;11536.480858361227;11828.053755699351 01:15:58 INFO - PROCESS | 29526 | |3;mootools.html;1390.714903444794;1459.6934643724821;1540.1298266479441;1672.2725614357755;1831.459719382781;8136.918630813698;8502.957485212573;8512.957435212824;8723.738287851358;8755;8456.06983231844;8617.310615150789;8627.784305392368;8646.394752367321;8655.783605409868;2036.786137455568;2311.399036250579;2311.861288322706;2335.544568809083;2384.5946189147885;2413.6379543068592;2416.4683769570665;2419.758024197584;2420.9031638734427;2421.503591763693;2337.6960995070617;2366.2782851230368;2397.592409290416;2398.9160379386726;2401.315625046862;1967.911443985017;2208.7459942106702;2281.9201327953606;2282.292489328297;2288.4507718147606;2335.871527066011;2354.7292061412986;2356.045801450415;2356.375560476475;2357.7524359942304;8681.56592170389;8730.301575873978;8740;8747.300215982707;8752.649894004233;5182.559482443997;5334.51989320963;5343.171808369709;5369.087255166631;5369.382521010095;3377.155711072232;3415.077928959167;3417.4532074868152;3534.222471056389;3544.27342394811;1098.077614803561;1099.5381939585393;1104.6244276945877;1117.709395557161;1148.2937993134246;11918;11921.642350729406;11941.522339106512;11945.880541194563;11973.580924667594;4601.792919318638;4616.6306695464955;4694.835680751157;4706.788194531255;4770.976145119253;10013.24900632441;10073.395596264247;10081.19350451962;10119.13987311072;10140.645077422254;5189.221616757441;5224.660397074178;5239.030779305841;5241.16141417379;5245.055889939771;4232.873013809591;4723.338732577442;4839.975800120977;4873.537013983666;4917.877053073702;3867.149227170018;3919.8824035278985;4024.939625905614;4044.8179831907637;4079.6940229482907;1258.8473709955895;1259.1941157659105;1260.0990291941307;1260.3887114749339;1277.2911034376011;971.2424309038961;993.5429702336861;1003.1673710820002;1005.4419797012728;1008.3093081239374;5669.036263835158;5682.176084467729;5891.646501209942;5944.405559444021;5967.224260846062;979.4074584876047;989.747614358334;996.2478328861663;1008.3748076192661;1041.5417216424748;4096.426500289962;4191.7484950903045;4199.181159673895;4220.282551966173;4222.683298752544;10495.26533142688;10785.191110666732;10849.78300433987;10859.348439093521;10870.945645271722;10019.599216031276;10711.517981690842;10766.676999690022;10783.892161078445;10804.459777011118;8098.919010809816;8168.632411541376;8221.876671849926;8226.917730822735;8246.711365102192;5597.888042239214;5810.82567522975;5843.2403787507355;5902.439268269508;6069.726862291119;9894.505274736379;9914.40513569188;10028.197744180303;10033.799324013626;10041;9802.215822734306;9976.102150806462;10171.745706357104;10185.287029907835;10330.741731456774;7056.717731290896;7297.635118244173;7409.184989651242;7744.57404842739;7911.683532658629;8174.100848906734;8180.222878826502;8218.096009439076;8252.381071419548;8253.504789712637;7279.636018198963;7419.666115024945;7491.587962661888;7547.547147171187;7607.695692172472;7449.106107267163;7600.201978792147;7633.084029916446;7723.34351580122;7728.884066739116;6222;6245.437910588069;6287.339829317856;6288.5598008138995;6292.4651404629285;5093.23601459784;5139.383274007143;5231.607629427732;5259.868503287295;5291.391489978701;5120.641555091108;5197.22041693749;5227.3465816772905;5301.867453313698;5337.852361742244 01:15:58 INFO - PROCESS | 29526 | |4;prototype.html;333.7096725848512;341.4093618040789;342.0491034922915;344.25812374333304;348.2390975718057;5245.318108645875;5252.71110088945;5276.261323414725;5300.761465734042;5374.167004114363;5207;5215.947840521593;5216.921746173811;5223.764930578123;5236.450172731866;3822.3310920588924;3950;3996.5204175498834;4078.2047500737367;4079.77561234132;4088.7751173685438;4090.202410529948;4123.773192474413;4127.525334586531;4140.8964775880695;4076.5515793262716;4079.714419990602;4087.264292427362;4089.672826173914;4092.4475195848477;3883.417487376902;3905.2384784966944;4005.759654420715;4097.520999795111;4102.794860257005;3642.1805093853936;3642.7450078494517;3643.927121457556;3649.6897763690117;3657.0674478008204;5009.849704508871;5045.596352291808;5053.5957123430035;5061.797528098871;5083.3391659084455;4552.317152427129;4669.603083737887;4681.789319480631;4735.384400027974;4740.312654665088;5385.892282154335;5421.26812880264;5461.808836690697;5462.6995515246645;5472.20653005312;3997.200559888005;4016.6343443229443;4020.9195816083516;4022.4770779798437;4033.173199494126;5429.701366424845;5626.9437305626825;5636.887262254773;5707.258056452676;5738.655680659173;4061.2283666103344;4108.1783643271465;4115.279826030433;4123.8969025774595;4130.6282434581035;4181.916361672749;4181.97909010453;4186.204621121977;4189.120284740177;4198.160367926427;4577.176108300471;4643.930341044819;4692.686047906592;4703.553162449562;4717.858464246078;5509.669419834822;5510.834674959678;5524.972375138099;5534.446555344433;5535.201059655628;1403.3544569497942;1417.170954991321;1418.9645258868404;1420.5241244183314;1421.2396367943102;888.3330603818303;925.5788616179622;938.3431597881511;944.9574769135405;950.6862735297335;5200.817971370984;5201.647571631327;5223.738813059408;5294.655847369909;5295.126304159848;5597.552195824324;5598.748056337393;5612.242347283146;5636.605437619327;5655.1799989001365;4981.601471882241;5240.982221844617;5242.7640756166065;5248.711320877388;5311.415744268127;2972.925676858096;2991.9102426927225;2992.8054676445963;2997.905764396023;3021.169178475937;5774.595778295563;5822.737976791054;5849.7952571660635;5854;5895.174675545341;5576.33084029919;5729.0260655688635;5731.885362292731;5739.192154471328;5780.16187652788;5818.4763371296785;5827.708614569339;5832;5847.853803654858;5849.94150058494;5426.348838139448;5620.325560932714;5643.830685079454;5666.291713535808;5670;5548.805791797267;5564.443555644403;5566.721663916869;5573.749181286771;5669.574781891457;5892.970535147297;5892.998190307744;5896.941030589639;5899.174115623902;5903.870948397356;3711.5175027246287;3814.016711310159;4045.130296986162;4065.4918135233097;4113.8971525712095;5686.232358631697;5706.915686019643;5712.400197979152;5715.342735585461;5726.79956201531;5408.621396502207;5425.240466334637;5537.889242215053;5557.582816381797;5570.2480165177185;5263.578833714952;5450.427705090909;5485.75314110858;5538.390777014606;5543.77824887;5189.948100518946;5391.676499410048;5434.864128396822;5456.699881506555;5459.344878614433;5388.676679399248;5501.752421141138;5530.695811730394;5538.667679939216;5544.17042376023;5431.185322201543;5433.5924805640525;5435.45089649448;5448.182772584144;5452.2094296327605 01:15:58 INFO - PROCESS | 29526 | |5;yui.html;740.4372676765663;779.9610019499023;783.0798811396611;830.2610676497916;846.187659846547;14503.782443263346;15375.308111134998;15607.219639018047;15616.843831561695;15637.218139093056;14708.485203017897;14799;14802.925985370059;14814.185219812905;14849.1090534568;674.8582797612507;785.0500893918365;807.9192080791918;825.6532256452274;836.4981011393177;821.1747194069951;822.942394032418;823.086374124721;825.162460102996;825.4840724547158;855.1363123245536;860.6815478273048;861.0958493581714;861.5175501719058;863.9870401943975;700.6496751624188;814.3892080939296;855.5807654249435;862.9266512346458;863.1886027134536;627.9403456671608;628.9559730818844;629.2574761781096;629.3769168523174;629.408356145222;14514.129152250898;14539.709205815825;14594.41622335116;14616.853831461656;14630.487932922297;14067.2966351682;14072.22602756848;14081.577552673436;14136.434542618283;14587.781183282259;11821.586244481488;12038.81941770874;12123.151379403445;12404.81392779109;12520.186187897758;4434.911301773946;4453.665975051884;4495.213337665896;4533.727976321398;4551.453825540956;57605;57770;57775;57845.421545784426;60706.696466517824;11159.776804464027;11256.774864502664;11420.37187954654;11494;11687.766244675058;20439.284625038053;20456.181752729724;20479.897600511904;20500.89749551243;20524.89737551303;8104.554249516334;8120.796980075427;8190.959045204855;8211.876821847676;8476.579447361817;4276.187524370422;4311.353297005474;4325.545817689097;4376.3654270130655;4438.023634800339;3411.9317613647586;3466.168119651316;3497.0557949353533;3508.947365789515;3510.9648903511147;636.1761518833122;637.3403527349171;656.0421784195129;657.1719633262124;662.2053535757015;644.8613548087184;668.0513670587777;672.630053470599;726.2991213479019;742.0909386002104;8906.530422480218;9369.531523423802;9642.228621710246;9929.156021738234;10030.64892728751;668.7224801707334;761.5392687424139;787.7676085554775;799.8280369720538;813.4062134641745;4727.527247275245;4759.809607615726;4902.877428064256;4925.285833554115;4972.477889821589;67485.6625716878;69051;69589.65205173942;70487;70722.2927770726;61031.6948415264;61197;61637.69181154066;61932;62238.37761622416;55461.44538554563;55702.72148639231;56561;57275.42724572701;57292.71353643205;9149.313801464783;9264.44413335202;9360.391574547633;9398.436093834393;9563.952180239054;36937.07657308589;37033.62966370302;37197.628023719415;37270.6272937278;37995.81002094972;44468.332975004756;50120.498795013045;50159;50543.49456505388;51213.7439312816;12501.812472813097;12502.312372819582;12569.93715031419;12689.428975695932;12701.618951431472;14346.641333966734;14481.92759036198;14887.181205033394;14936.178510182044;15219.315130819361;13566.186028838301;13628.727425451634;14151.575452736435;14170.929145354206;14177.503787367392;13595.184288942695;13735.381907813973;13757.182834891833;14017.929910350384;14309.35607897668;12549.247045177319;12637.93681031589;13670.52153174634;13835.699199616278;14403.78394324065;11296.661100167008;11386.94306528462;11481.942590286995;11510.136739744385;11889.881101188877;11397.430128493708;11707.648770536898;11873.076769372026;11894.80568382225;12012.879871201176 01:15:58 INFO - PROCESS | 29526 | __end_tp_report 01:15:58 INFO - PROCESS | 29526 | __start_cc_report 01:15:58 INFO - PROCESS | 29526 | _x_x_mozilla_cycle_collect,873 01:15:58 INFO - PROCESS | 29526 | __end_cc_report 01:15:58 INFO - PROCESS | 29526 | __startTimestamp1464077758431__endTimestamp 01:15:58 INFO - PROCESS | 29526 | 01:15:58 INFO - PROCESS | 29526 | ------- Summary: start ------- 01:15:58 INFO - PROCESS | 29526 | Number of tests: 6 01:15:58 INFO - PROCESS | 29526 | 01:15:58 INFO - PROCESS | 29526 | [#0] dojo.html Cycles:165 Average:5423.56 Median:5621.18 stddev:638.67 (11.4%) stddev-sans-first:614.82 01:15:58 INFO - PROCESS | 29526 | Values: 3132.5 3155.5 3155.8 3169.7 3216.4 5232.1 5286.2 5395.8 5475.4 5506.1 5451.0 5452.7 5481.2 5502.0 5511.2 4914.8 4935.3 4990.0 5024.4 5134.2 4967.7 4998.0 5000.6 5033.2 5038.6 4813.2 4883.0 4893.5 4896.9 4958.9 4867.0 4880.4 4943.0 4950.2 4986.2 4827.0 4907.2 4926.8 4929.1 4937.0 5351.0 5429.1 5431.6 5494.6 5503.3 5921.2 5941.2 5958.4 5963.2 5963.8 5588.7 5830.0 5977.0 5998.0 5998.5 5486.7 5571.6 5575.3 5584.9 5588.7 6045.5 6077.0 6081.1 6083.0 6089.4 5558.1 5724.6 5769.5 5843.9 5851.5 5879.1 5887.3 5890.3 5912.3 5951.5 5820.7 5856.0 5871.6 5874.2 5878.3 5653.2 5761.9 5839.4 5847.6 5890.5 4422.7 4423.7 4425.6 4426.0 4454.5 3915.4 3936.8 3963.1 3994.9 4015.6 5248.3 5296.7 5414.2 5480.1 5500.4 5914.0 5940.7 5943.5 5959.0 6002.0 5521.9 5522.3 5527.4 5530.8 5532.2 4645.0 4810.9 4851.3 4862.8 4864.9 6037.2 6049.5 6053.9 6054.6 6087.7 5551.9 5851.4 5862.5 5866.0 5866.1 6006.2 6044.6 6074.8 6100.4 6118.0 5751.2 5792.2 5799.6 5802.5 5806.3 5639.6 5761.9 5855.1 5869.4 5870.5 5653.4 5699.1 5702.6 5704.5 5757.1 5644.4 5682.3 5695.7 5697.6 5705.0 5345.5 5583.3 5618.2 5621.2 5632.6 5782.8 5815.0 5819.2 5825.8 5834.8 5606.5 5652.7 5660.8 5674.1 5699.5 01:15:58 INFO - PROCESS | 29526 | 01:15:58 INFO - PROCESS | 29526 | [#1] ext.html Cycles:180 Average:66260.43 Median:42868.53 stddev:143752.44 (335.3%) stddev-sans-first:144071.17 01:15:58 INFO - PROCESS | 29526 | Values: 600.7 630.9 648.4 650.1 668.5 32401.5 35828.3 35866.8 35868.8 35874.3 43998.3 45209.5 45269.5 49403.0 49546.3 8644.9 8772.7 8805.9 8852.7 8886.5 8716.6 8851.5 8854.0 8856.0 8856.1 8857.2 8913.8 8918.4 8921.9 8927.5 8830.5 8924.0 8930.6 8939.6 8945.9 8770.5 8885.4 8895.1 8895.5 8896.6 39075.6 39330.2 39392.0 39516.0 39579.8 3680.1 3835.5 3897.4 4123.7 4355.7 32202.0 32563.3 32928.0 33005.5 34160.7 4194.6 4316.1 4320.0 4413.0 4443.0 348340.0 349244.0 350330.0 351455.0 351896.0 58408.0 58870.2 58877.4 58913.4 59292.0 62576.4 62592.4 62603.7 62761.0 62934.0 16335.8 16666.9 16697.6 16699.5 16764.2 12147.3 12313.9 12334.7 12351.2 12564.9 15285.5 17368.5 17379.9 17395.1 17415.3 6349.6 6471.5 6502.5 6578.6 6625.9 849.3 1014.7 1030.0 1069.2 1137.9 33017.0 33305.5 33388.0 33513.3 33578.0 1125.5 1141.1 1183.2 1237.1 1247.7 17110.4 17370.6 17505.9 17525.0 17708.6 485358.0 787848.0 809063.0 812223.0 813024.0 57547.7 57953.4 58371.0 58399.7 58482.0 1271.5 1420.2 1432.7 1458.0 1471.1 30638.4 32807.7 35215.5 35311.3 35467.8 55605.6 58267.0 58348.1 64440.7 64875.0 408480.0 415046.0 415778.0 417952.0 418072.0 38094.8 43900.0 43951.0 44516.8 45318.3 50058.5 50091.5 50533.0 51237.2 52186.5 41249.6 42340.6 42861.8 43608.0 44239.8 42049.6 42793.5 42875.3 42978.0 43024.6 42736.8 43501.0 43532.0 44130.3 44182.6 36688.0 37331.4 38814.8 39110.8 39240.0 28556.1 28660.3 28965.4 29047.3 29097.4 01:15:58 INFO - PROCESS | 29526 | 01:15:58 INFO - PROCESS | 29526 | [#2] jquery.html Cycles:180 Average:29142.70 Median:23062.33 stddev:78958.77 (342.4%) stddev-sans-first:79150.76 01:15:58 INFO - PROCESS | 29526 | Values: 392.9 394.8 397.4 409.7 413.5 13962.4 17241.8 18168.0 19447.9 19462.0 18529.0 18606.2 19238.3 19249.8 19403.5 5590.8 5780.5 5785.5 5791.4 5795.4 4098.7 5670.8 5728.2 6030.5 6433.8 6406.0 6500.8 6531.4 6546.3 6552.8 6353.2 6436.1 6513.0 6514.3 6538.6 5461.3 5717.1 5736.3 5757.6 5760.0 22903.9 23220.8 23758.8 23832.9 23874.3 2384.7 2449.0 2463.1 2540.5 2553.3 13922.6 14384.4 14430.0 14503.3 14798.9 1857.0 1953.8 1970.6 1982.1 2047.1 80802.6 83266.0 83527.6 83752.6 84744.0 10513.4 10591.7 10595.8 10774.5 10887.3 15265.7 15307.2 15372.9 15381.0 15381.8 8138.4 8426.0 8554.3 8637.3 8644.0 8261.8 8279.8 8311.0 8424.2 8442.6 6744.2 6794.5 6852.9 6892.7 6912.1 1912.3 1956.6 1969.9 1981.6 2049.5 941.9 1022.4 1025.4 1052.8 1091.9 19809.9 20460.7 20576.3 20767.0 20915.4 1030.9 1066.2 1099.6 1117.3 1144.4 10869.8 11436.0 11449.6 11504.4 11507.7 457396.0 477558.0 479182.0 481470.0 488634.0 96520.5 103077.0 103426.5 103745.5 104116.5 1042.2 1058.1 1069.9 1077.7 1078.2 17279.4 17306.6 17446.6 17448.9 17765.1 37916.0 42444.0 42969.4 43822.1 44559.8 53654.5 56495.0 57958.4 58107.0 59507.4 7975.4 8363.1 8424.6 8431.5 8499.7 12451.8 12892.1 12911.5 12986.9 13082.9 11288.8 11371.9 11699.8 11711.2 11816.5 5457.1 8353.9 9904.4 11504.7 11749.8 11761.2 11851.8 11915.1 11956.9 11960.2 8004.2 8313.4 8364.6 8436.1 8466.5 10889.6 11453.6 11521.4 11536.5 11828.1 01:15:58 INFO - PROCESS | 29526 | 01:15:58 INFO - PROCESS | 29526 | [#3] mootools.html Cycles:180 Average:5718.93 Median:4715.06 stddev:3200.24 (67.9%) stddev-sans-first:3192.69 01:15:58 INFO - PROCESS | 29526 | Values: 1390.7 1459.7 1540.1 1672.3 1831.5 8136.9 8503.0 8513.0 8723.7 8755.0 8456.1 8617.3 8627.8 8646.4 8655.8 2036.8 2311.4 2311.9 2335.5 2384.6 2413.6 2416.5 2419.8 2420.9 2421.5 2337.7 2366.3 2397.6 2398.9 2401.3 1967.9 2208.7 2281.9 2282.3 2288.5 2335.9 2354.7 2356.0 2356.4 2357.8 8681.6 8730.3 8740.0 8747.3 8752.6 5182.6 5334.5 5343.2 5369.1 5369.4 3377.2 3415.1 3417.5 3534.2 3544.3 1098.1 1099.5 1104.6 1117.7 1148.3 11918.0 11921.6 11941.5 11945.9 11973.6 4601.8 4616.6 4694.8 4706.8 4771.0 10013.2 10073.4 10081.2 10119.1 10140.6 5189.2 5224.7 5239.0 5241.2 5245.1 4232.9 4723.3 4840.0 4873.5 4917.9 3867.1 3919.9 4024.9 4044.8 4079.7 1258.8 1259.2 1260.1 1260.4 1277.3 971.2 993.5 1003.2 1005.4 1008.3 5669.0 5682.2 5891.6 5944.4 5967.2 979.4 989.7 996.2 1008.4 1041.5 4096.4 4191.7 4199.2 4220.3 4222.7 10495.3 10785.2 10849.8 10859.3 10870.9 10019.6 10711.5 10766.7 10783.9 10804.5 8098.9 8168.6 8221.9 8226.9 8246.7 5597.9 5810.8 5843.2 5902.4 6069.7 9894.5 9914.4 10028.2 10033.8 10041.0 9802.2 9976.1 10171.7 10185.3 10330.7 7056.7 7297.6 7409.2 7744.6 7911.7 8174.1 8180.2 8218.1 8252.4 8253.5 7279.6 7419.7 7491.6 7547.5 7607.7 7449.1 7600.2 7633.1 7723.3 7728.9 6222.0 6245.4 6287.3 6288.6 6292.5 5093.2 5139.4 5231.6 5259.9 5291.4 5120.6 5197.2 5227.3 5301.9 5337.9 01:15:58 INFO - PROCESS | 29526 | 01:15:58 INFO - PROCESS | 29526 | [#4] prototype.html Cycles:180 Average:4633.53 Median:5269.92 stddev:1358.85 (25.8%) stddev-sans-first:1323.78 01:15:58 INFO - PROCESS | 29526 | Values: 333.7 341.4 342.0 344.3 348.2 5245.3 5252.7 5276.3 5300.8 5374.2 5207.0 5215.9 5216.9 5223.8 5236.5 3822.3 3950.0 3996.5 4078.2 4079.8 4088.8 4090.2 4123.8 4127.5 4140.9 4076.6 4079.7 4087.3 4089.7 4092.4 3883.4 3905.2 4005.8 4097.5 4102.8 3642.2 3642.7 3643.9 3649.7 3657.1 5009.8 5045.6 5053.6 5061.8 5083.3 4552.3 4669.6 4681.8 4735.4 4740.3 5385.9 5421.3 5461.8 5462.7 5472.2 3997.2 4016.6 4020.9 4022.5 4033.2 5429.7 5626.9 5636.9 5707.3 5738.7 4061.2 4108.2 4115.3 4123.9 4130.6 4181.9 4182.0 4186.2 4189.1 4198.2 4577.2 4643.9 4692.7 4703.6 4717.9 5509.7 5510.8 5525.0 5534.4 5535.2 1403.4 1417.2 1419.0 1420.5 1421.2 888.3 925.6 938.3 945.0 950.7 5200.8 5201.6 5223.7 5294.7 5295.1 5597.6 5598.7 5612.2 5636.6 5655.2 4981.6 5241.0 5242.8 5248.7 5311.4 2972.9 2991.9 2992.8 2997.9 3021.2 5774.6 5822.7 5849.8 5854.0 5895.2 5576.3 5729.0 5731.9 5739.2 5780.2 5818.5 5827.7 5832.0 5847.9 5849.9 5426.3 5620.3 5643.8 5666.3 5670.0 5548.8 5564.4 5566.7 5573.7 5669.6 5893.0 5893.0 5896.9 5899.2 5903.9 3711.5 3814.0 4045.1 4065.5 4113.9 5686.2 5706.9 5712.4 5715.3 5726.8 5408.6 5425.2 5537.9 5557.6 5570.2 5263.6 5450.4 5485.8 5538.4 5543.8 5189.9 5391.7 5434.9 5456.7 5459.3 5388.7 5501.8 5530.7 5538.7 5544.2 5431.2 5433.6 5435.5 5448.2 5452.2 01:15:58 INFO - PROCESS | 29526 | 01:15:58 INFO - PROCESS | 29526 | [#5] yui.html Cycles:180 Average:16068.84 Median:4542.59 stddev:18950.79 (417.2%) stddev-sans-first:18968.99 01:15:58 INFO - PROCESS | 29526 | Values: 740.4 780.0 783.1 830.3 846.2 14503.8 15375.3 15607.2 15616.8 15637.2 14708.5 14799.0 14802.9 14814.2 14849.1 674.9 785.1 807.9 825.7 836.5 821.2 822.9 823.1 825.2 825.5 855.1 860.7 861.1 861.5 864.0 700.6 814.4 855.6 862.9 863.2 627.9 629.0 629.3 629.4 629.4 14514.1 14539.7 14594.4 14616.9 14630.5 14067.3 14072.2 14081.6 14136.4 14587.8 11821.6 12038.8 12123.2 12404.8 12520.2 4434.9 4453.7 4495.2 4533.7 4551.5 57605.0 57770.0 57775.0 57845.4 60706.7 11159.8 11256.8 11420.4 11494.0 11687.8 20439.3 20456.2 20479.9 20500.9 20524.9 8104.6 8120.8 8191.0 8211.9 8476.6 4276.2 4311.4 4325.5 4376.4 4438.0 3411.9 3466.2 3497.1 3508.9 3511.0 636.2 637.3 656.0 657.2 662.2 644.9 668.1 672.6 726.3 742.1 8906.5 9369.5 9642.2 9929.2 10030.6 668.7 761.5 787.8 799.8 813.4 4727.5 4759.8 4902.9 4925.3 4972.5 67485.7 69051.0 69589.7 70487.0 70722.3 61031.7 61197.0 61637.7 61932.0 62238.4 55461.4 55702.7 56561.0 57275.4 57292.7 9149.3 9264.4 9360.4 9398.4 9564.0 36937.1 37033.6 37197.6 37270.6 37995.8 44468.3 50120.5 50159.0 50543.5 51213.7 12501.8 12502.3 12569.9 12689.4 12701.6 14346.6 14481.9 14887.2 14936.2 15219.3 13566.2 13628.7 14151.6 14170.9 14177.5 13595.2 13735.4 13757.2 14017.9 14309.4 12549.2 12637.9 13670.5 13835.7 14403.8 11296.7 11386.9 11481.9 11510.1 11889.9 11397.4 11707.6 11873.1 11894.8 12012.9 01:15:58 INFO - PROCESS | 29526 | -------- Summary: end -------- 01:15:58 INFO - PROCESS | 29526 | 01:15:59 INFO - TEST-INFO | 29526: exit 0 01:15:59 INFO - TEST-OK | dromaeo_css | took 1112870ms 01:15:59 INFO - TEST-START | kraken 01:15:59 INFO - operating with platform_type : linux_ 01:15:59 INFO - Initialising browser for kraken test... 01:15:59 INFO - TEST-INFO | started process 29709 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGsqb0h/profile http://localhost:46362/getInfo.html) 01:16:03 INFO - PROCESS | 29709 | __metrics Screen width/height:1600/1200 01:16:03 INFO - PROCESS | 29709 | colorDepth:24 01:16:03 INFO - PROCESS | 29709 | Browser inner width/height: 1024/697 01:16:03 INFO - PROCESS | 29709 | __metrics 01:16:04 ERROR - PROCESS | 29709 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:16:05 INFO - TEST-INFO | 29709: exit 0 01:16:05 INFO - Browser initialized. 01:16:05 INFO - Running cycle 1/1 for kraken test... 01:16:05 INFO - TEST-INFO | started process 29790 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGsqb0h/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:16:16 INFO - PROCESS | 29790 | RSS: Main: 152973312 01:16:16 INFO - PROCESS | 29790 | 01:16:19 INFO - PROCESS | 29790 | Cycle 1(1): loaded http://localhost:46362/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46362/tests/kraken/driver.html?testName=audio-beat-detection) 01:16:20 INFO - PROCESS | 29790 | RSS: Main: 208785408 01:16:20 INFO - PROCESS | 29790 | 01:16:22 INFO - PROCESS | 29790 | Cycle 1(1): loaded http://localhost:46362/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46362/tests/kraken/driver.html?testName=audio-dft) 01:16:23 INFO - PROCESS | 29790 | RSS: Main: 196505600 01:16:23 INFO - PROCESS | 29790 | 01:16:26 INFO - PROCESS | 29790 | Cycle 1(1): loaded http://localhost:46362/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46362/tests/kraken/driver.html?testName=audio-fft) 01:16:27 INFO - PROCESS | 29790 | RSS: Main: 265637888 01:16:27 INFO - PROCESS | 29790 | 01:16:29 INFO - PROCESS | 29790 | Cycle 1(1): loaded http://localhost:46362/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46362/tests/kraken/driver.html?testName=audio-oscillator) 01:16:29 INFO - PROCESS | 29790 | RSS: Main: 174813184 01:16:29 INFO - PROCESS | 29790 | 01:16:32 INFO - PROCESS | 29790 | Cycle 1(1): loaded http://localhost:46362/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46362/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:16:32 INFO - PROCESS | 29790 | RSS: Main: 178896896 01:16:32 INFO - PROCESS | 29790 | 01:16:35 INFO - PROCESS | 29790 | Cycle 1(1): loaded http://localhost:46362/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46362/tests/kraken/driver.html?testName=imaging-darkroom) 01:16:36 INFO - PROCESS | 29790 | RSS: Main: 215035904 01:16:36 INFO - PROCESS | 29790 | 01:16:39 INFO - PROCESS | 29790 | Cycle 1(1): loaded http://localhost:46362/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46362/tests/kraken/driver.html?testName=imaging-desaturate) 01:16:40 INFO - PROCESS | 29790 | RSS: Main: 215674880 01:16:40 INFO - PROCESS | 29790 | 01:16:43 INFO - PROCESS | 29790 | Cycle 1(1): loaded http://localhost:46362/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46362/tests/kraken/driver.html?testName=json-parse-financial) 01:16:43 INFO - PROCESS | 29790 | RSS: Main: 216129536 01:16:43 INFO - PROCESS | 29790 | 01:16:45 INFO - PROCESS | 29790 | Cycle 1(1): loaded http://localhost:46362/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46362/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:16:45 INFO - PROCESS | 29790 | RSS: Main: 202420224 01:16:45 INFO - PROCESS | 29790 | 01:16:47 INFO - PROCESS | 29790 | Cycle 1(1): loaded http://localhost:46362/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46362/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:16:48 INFO - PROCESS | 29790 | RSS: Main: 207245312 01:16:48 INFO - PROCESS | 29790 | 01:16:50 INFO - PROCESS | 29790 | Cycle 1(1): loaded http://localhost:46362/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46362/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:16:50 INFO - PROCESS | 29790 | RSS: Main: 216719360 01:16:50 INFO - PROCESS | 29790 | 01:16:53 INFO - PROCESS | 29790 | Cycle 1(1): loaded http://localhost:46362/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46362/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:16:54 INFO - PROCESS | 29790 | RSS: Main: 224436224 01:16:54 INFO - PROCESS | 29790 | 01:16:56 INFO - PROCESS | 29790 | Cycle 1(1): loaded http://localhost:46362/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46362/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:16:57 INFO - PROCESS | 29790 | RSS: Main: 222179328 01:16:57 INFO - PROCESS | 29790 | 01:16:59 INFO - PROCESS | 29790 | Cycle 1(1): loaded http://localhost:46362/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46362/tests/kraken/driver.html?testName=ai-astar) 01:16:59 INFO - PROCESS | 29790 | RSS: Main: 267767808 01:16:59 INFO - PROCESS | 29790 | 01:16:59 INFO - PROCESS | 29790 | __start_tp_report 01:16:59 INFO - PROCESS | 29790 | _x_x_mozilla_page_load 01:16:59 INFO - PROCESS | 29790 | _x_x_mozilla_page_load_details 01:16:59 INFO - PROCESS | 29790 | |i|pagename|runs| 01:16:59 INFO - PROCESS | 29790 | |0;ai-astar;110;104;110;109;109;109;109;110;110;110 01:16:59 INFO - PROCESS | 29790 | |1;audio-beat-detection;155;130;126;182;125;126;149;132;190;127 01:16:59 INFO - PROCESS | 29790 | |2;audio-dft;160;159;160;159;161;161;161;161;161;160 01:16:59 INFO - PROCESS | 29790 | |3;audio-fft;74;73;75;113;73;74;73;74;96;74 01:16:59 INFO - PROCESS | 29790 | |4;audio-oscillator;93;91;141;92;92;92;121;93;93;142 01:16:59 INFO - PROCESS | 29790 | |5;imaging-gaussian-blur;116;117;116;116;117;117;117;117;118;117 01:16:59 INFO - PROCESS | 29790 | |6;imaging-darkroom;145;146;145;145;145;146;145;145;144;145 01:16:59 INFO - PROCESS | 29790 | |7;imaging-desaturate;95;94;95;94;94;95;94;94;95;95 01:16:59 INFO - PROCESS | 29790 | |8;json-parse-financial;56;53;54;54;53;62;56;69;53;52 01:16:59 INFO - PROCESS | 29790 | |9;json-stringify-tinderbox;63;63;63;63;62;63;63;62;62;63 01:16:59 INFO - PROCESS | 29790 | |10;stanford-crypto-aes;79;77;83;77;81;80;78;79;79;79 01:16:59 INFO - PROCESS | 29790 | |11;stanford-crypto-ccm;119;119;126;120;116;117;119;120;171;127 01:16:59 INFO - PROCESS | 29790 | |12;stanford-crypto-pbkdf2;159;159;164;163;162;161;161;166;164;162 01:16:59 INFO - PROCESS | 29790 | |13;stanford-crypto-sha256-iterative;62;62;62;65;62;63;63;63;63;62 01:16:59 INFO - PROCESS | 29790 | __end_tp_report 01:16:59 INFO - PROCESS | 29790 | __start_cc_report 01:16:59 INFO - PROCESS | 29790 | _x_x_mozilla_cycle_collect,1635 01:16:59 INFO - PROCESS | 29790 | __end_cc_report 01:16:59 INFO - PROCESS | 29790 | __startTimestamp1464077819274__endTimestamp 01:16:59 INFO - PROCESS | 29790 | 01:16:59 INFO - PROCESS | 29790 | ------- Summary: start ------- 01:16:59 INFO - PROCESS | 29790 | Number of tests: 14 01:16:59 INFO - PROCESS | 29790 | 01:16:59 INFO - PROCESS | 29790 | [#0] ai-astar Cycles:10 Average:109.00 Median:110.00 stddev:1.83 (1.7%) stddev-sans-first:1.90 01:16:59 INFO - PROCESS | 29790 | Values: 110.0 104.0 110.0 109.0 109.0 109.0 109.0 110.0 110.0 110.0 01:16:59 INFO - PROCESS | 29790 | 01:16:59 INFO - PROCESS | 29790 | [#1] audio-beat-detection Cycles:10 Average:144.20 Median:140.50 stddev:24.37 (17.3%) stddev-sans-first:25.53 01:16:59 INFO - PROCESS | 29790 | Values: 155.0 130.0 126.0 182.0 125.0 126.0 149.0 132.0 190.0 127.0 01:16:59 INFO - PROCESS | 29790 | 01:16:59 INFO - PROCESS | 29790 | [#2] audio-dft Cycles:10 Average:160.30 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 01:16:59 INFO - PROCESS | 29790 | Values: 160.0 159.0 160.0 159.0 161.0 161.0 161.0 161.0 161.0 160.0 01:16:59 INFO - PROCESS | 29790 | 01:16:59 INFO - PROCESS | 29790 | [#3] audio-fft Cycles:10 Average:79.90 Median:74.00 stddev:13.58 (18.4%) stddev-sans-first:14.24 01:16:59 INFO - PROCESS | 29790 | Values: 74.0 73.0 75.0 113.0 73.0 74.0 73.0 74.0 96.0 74.0 01:16:59 INFO - PROCESS | 29790 | 01:16:59 INFO - PROCESS | 29790 | [#4] audio-oscillator Cycles:10 Average:105.00 Median:92.00 stddev:21.23 (23.1%) stddev-sans-first:22.07 01:16:59 INFO - PROCESS | 29790 | Values: 93.0 91.0 141.0 92.0 92.0 92.0 121.0 93.0 93.0 142.0 01:16:59 INFO - PROCESS | 29790 | 01:16:59 INFO - PROCESS | 29790 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 01:16:59 INFO - PROCESS | 29790 | Values: 116.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 118.0 117.0 01:16:59 INFO - PROCESS | 29790 | 01:16:59 INFO - PROCESS | 29790 | [#6] imaging-darkroom Cycles:10 Average:145.10 Median:145.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 01:16:59 INFO - PROCESS | 29790 | Values: 145.0 146.0 145.0 145.0 145.0 146.0 145.0 145.0 144.0 145.0 01:16:59 INFO - PROCESS | 29790 | 01:16:59 INFO - PROCESS | 29790 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 01:16:59 INFO - PROCESS | 29790 | Values: 95.0 94.0 95.0 94.0 94.0 95.0 94.0 94.0 95.0 95.0 01:16:59 INFO - PROCESS | 29790 | 01:16:59 INFO - PROCESS | 29790 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:55.00 stddev:5.33 (9.7%) stddev-sans-first:5.65 01:16:59 INFO - PROCESS | 29790 | Values: 56.0 53.0 54.0 54.0 53.0 62.0 56.0 69.0 53.0 52.0 01:16:59 INFO - PROCESS | 29790 | 01:16:59 INFO - PROCESS | 29790 | [#9] json-stringify-tinderbox Cycles:10 Average:62.70 Median:63.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 01:16:59 INFO - PROCESS | 29790 | Values: 63.0 63.0 63.0 63.0 62.0 63.0 63.0 62.0 62.0 63.0 01:16:59 INFO - PROCESS | 29790 | 01:16:59 INFO - PROCESS | 29790 | [#10] stanford-crypto-aes Cycles:10 Average:79.20 Median:79.00 stddev:1.81 (2.3%) stddev-sans-first:1.92 01:16:59 INFO - PROCESS | 29790 | Values: 79.0 77.0 83.0 77.0 81.0 80.0 78.0 79.0 79.0 79.0 01:16:59 INFO - PROCESS | 29790 | 01:16:59 INFO - PROCESS | 29790 | [#11] stanford-crypto-ccm Cycles:10 Average:125.40 Median:120.00 stddev:16.41 (13.7%) stddev-sans-first:17.24 01:16:59 INFO - PROCESS | 29790 | Values: 119.0 119.0 126.0 120.0 116.0 117.0 119.0 120.0 171.0 127.0 01:16:59 INFO - PROCESS | 29790 | 01:16:59 INFO - PROCESS | 29790 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.10 Median:162.50 stddev:2.23 (1.4%) stddev-sans-first:2.07 01:16:59 INFO - PROCESS | 29790 | Values: 159.0 159.0 164.0 163.0 162.0 161.0 161.0 166.0 164.0 162.0 01:16:59 INFO - PROCESS | 29790 | 01:16:59 INFO - PROCESS | 29790 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:63.00 stddev:0.95 (1.5%) stddev-sans-first:0.97 01:16:59 INFO - PROCESS | 29790 | Values: 62.0 62.0 62.0 65.0 62.0 63.0 63.0 63.0 63.0 62.0 01:16:59 INFO - PROCESS | 29790 | -------- Summary: end -------- 01:16:59 INFO - PROCESS | 29790 | 01:17:00 INFO - TEST-INFO | 29790: exit 0 01:17:00 INFO - TEST-OK | kraken | took 61150ms 01:17:00 INFO - SUITE-END | took 1174s 01:17:00 INFO - Completed test suite (00:19:34) 01:17:00 INFO - javascript benchmark 01:17:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3132.483140281853, 3155.5108958111487, 3155.8106513609173, 3169.714725674689, 3216.4371235033864, 5232.1366974449265, 5286.154215325549, 5395.811146609864, 5475.425080366564, 5506.146547285167, 5451.04606693829, 5452.700101494416, 5481.232627432163, 5502.0371434998915, 5511.200875873006, 4914.827981020665, 4935.3090567320605, 4989.9750501247445, 5024.422191447976, 5134.229865520165, 4967.726775027372, 4997.9754150399085, 5000.574951129141, 5033.2450132480235, 5038.571721403667, 4813.157697402958, 4882.951170488321, 4893.535114164149, 4896.853094407174, 4958.925616115743, 4866.9513304867205, 4880.438749543812, 4942.975285123587, 4950.232713929311, 4986.152354099811, 4826.975865120652, 4907.190313598252, 4926.778294976734, 4929.112759703252, 4936.950630493721, 5350.973245133789, 5429.077056900297, 5431.619786614939, 5494.615376923617, 5503.3395992480755, 5921.200637913869, 5941.197938278364, 5958.374370691058, 5963.165156878041, 5963.761449542013, 5588.692621905793, 5830.0, 5976.97011514944, 5998.0, 5998.460138587505, 5486.670799751988, 5571.637843540157, 5575.275214222166, 5584.888302233932, 5588.748506317225, 6045.472859040126, 6077.027675571887, 6081.148639190517, 6083.026715725463, 6089.391060893875, 5558.055130627803, 5724.570657200727, 5769.480746732815, 5843.941560584425, 5851.473367396955, 5879.088741245114, 5887.293524777054, 5890.263717035371, 5912.349641539513, 5951.464368206882, 5820.679862607512, 5855.970720146372, 5871.647701137946, 5874.1776151338845, 5878.265216847894, 5653.180288858092, 5761.8559536011935, 5839.445252700986, 5847.619904706181, 5890.52875769946, 4422.71252368595, 4423.712458690175, 4425.601695847325, 4426.026274219666, 4454.487733910577, 3915.4322623219473, 3936.8031598419966, 3963.147923196527, 3994.9201015980098, 4015.598440155961, 5248.265242866002, 5296.655717378435, 5414.160805075219, 5480.095784195642, 5500.367457742331, 5913.994561157102, 5940.732667029994, 5943.465088142088, 5958.970205149033, 6001.969990150109, 5521.861953451115, 5522.337319521603, 5527.44725527444, 5530.834074977757, 5532.17017447378, 4644.953550464452, 4810.903781924342, 4851.296561998491, 4862.781174847069, 4864.854054378375, 6037.154798328237, 6049.516038716892, 6053.909191362133, 6054.606450580698, 6087.69561521931, 5551.916721249104, 5851.444112809361, 5862.472377486047, 5865.973454645506, 5866.090755932837, 6006.219191505076, 6044.576879618385, 6074.848128796815, 6100.420460056288, 6117.96941015292, 5751.166080918327, 5792.160136780228, 5799.565032622486, 5802.5357971361345, 5806.303243610793, 5639.6334238274385, 5761.91357129635, 5855.063189889597, 5869.383714710065, 5870.53035757147, 5653.434656534479, 5699.059655156852, 5702.572307077069, 5704.458076482728, 5757.136429535603, 5644.435556444323, 5682.3465301489205, 5695.658260504383, 5697.601167918206, 5705.0, 5345.492178243061, 5583.330000399978, 5618.2415373924, 5621.184928185472, 5632.633878797865, 5782.826515204551, 5815.04051831443, 5819.185314056121, 5825.825225243249, 5834.766609335579, 5606.523445507178, 5652.689102099424, 5660.830175094754, 5674.120511320752, 5699.458551437607], "value": 5379.461569704857, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [600.6816387314725, 630.949524038077, 648.3840351665918, 650.07039932896, 668.4986260304771, 32401.51397729033, 35828.283434331366, 35866.8206658967, 35868.820655896714, 35874.282514349696, 43998.340024899655, 45209.54790452094, 45269.54730452695, 49403.0, 49546.25680614794, 8644.913550864489, 8772.69295574655, 8805.911940880573, 8852.690155844515, 8886.511241881693, 8716.607752651145, 8851.468911865277, 8853.95573022134, 8856.0, 8856.114388561125, 8857.247133993586, 8913.821723565525, 8918.420302680304, 8921.866172007425, 8927.508987005713, 8830.514321712304, 8924.0, 8930.598123084477, 8939.597718102701, 8945.910540894572, 8770.517621530813, 8885.378023538355, 8895.066018068139, 8895.4662720237, 8896.644134234622, 39075.60924390776, 39330.213395732215, 39392.0, 39516.0, 39579.80210098931, 3680.0799800049986, 3835.5013848199833, 3897.3569361055393, 4123.711340206187, 4355.695101342907, 32202.0, 32563.348733025443, 32928.0, 33005.50491742602, 34160.65839341599, 4194.601512856274, 4316.136772645484, 4320.049589090427, 4412.955870441287, 4443.0, 348340.0, 349243.99999999744, 350330.0, 351455.0, 351896.0, 58408.0, 58870.17343872634, 58877.41122588805, 58913.41086589079, 59292.0, 62576.374236257965, 62592.37407625865, 62603.68698156571, 62761.0, 62934.0, 16335.754963675554, 16666.916665416597, 16697.582560436087, 16699.499015029567, 16764.245608947625, 12147.271163730204, 12313.938430307791, 12334.691632709255, 12351.19717218378, 12564.937175314066, 15285.465008724641, 17368.47894563165, 17379.913100434416, 17395.130243487776, 17415.303387864344, 6349.619022858643, 6471.482281417475, 6502.512311576651, 6578.6052836828985, 6625.86748265032, 849.3078141314809, 1014.7412409835592, 1029.9639512617023, 1069.2087854987253, 1137.8748337682848, 33017.0, 33305.50041749376, 33388.0, 33513.3297334052, 33578.0, 1125.5047778977223, 1141.0928311991986, 1183.2013390961067, 1237.1463690054013, 1247.6631309546372, 17110.401135960183, 17370.565735856453, 17505.912470437823, 17525.0, 17708.557286067953, 485358.0, 787848.0, 809063.0, 812223.0, 813024.0, 57547.71226143843, 57953.4204657948, 58371.0, 58399.70800146057, 58482.0, 1271.4723389793317, 1420.1975883625719, 1432.684809341964, 1457.9562613121623, 1471.124680814892, 30638.387232254783, 32807.67192328046, 35215.47176792401, 35311.29377412489, 35467.82266088756, 55605.60985975383, 58267.0, 58348.12477812921, 64440.67779661072, 64875.0, 408480.0, 415046.0, 415778.0, 417952.0, 418072.0, 38094.809525952194, 43900.0, 43951.0, 44516.777416114004, 45318.32022519599, 50058.49941500538, 50091.49908500868, 50533.0, 51237.23144152766, 52186.47813521816, 41249.587504124574, 42340.576594233666, 42861.785691071345, 43608.0, 44239.778801105786, 42049.579504204565, 42793.47389607997, 42875.26469295602, 42978.0, 43024.56975430206, 42736.78631606822, 43501.0, 43532.0, 44130.338044929995, 44182.55817441913, 36688.0, 37331.440028399054, 38814.80592597019, 39110.82667519979, 39240.0, 28556.143315700563, 28660.283492912844, 28965.40801124561, 29047.273818154714, 29097.418051639273], "value": 20766.52532999881, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.86838908965507, 394.84798352634226, 397.370168283271, 409.72343668024075, 413.4645633904094, 13962.383498552084, 17241.827581724177, 18168.0, 19447.902760486195, 19462.0, 18529.0, 18606.16272267748, 19238.32665856695, 19249.80750192501, 19403.514912127204, 5590.776368945238, 5780.53755699543, 5785.508231800302, 5791.362950075489, 5795.420457954213, 4098.7130900836955, 5670.8015219467325, 5728.198052272685, 6030.517558595302, 6433.839154021163, 6406.039094135894, 6500.772472963447, 6531.412172904437, 6546.345365463463, 6552.803415897531, 6353.174087368659, 6436.066770318301, 6513.0, 6514.250861150981, 6538.574992625464, 5461.344638643388, 5717.056685646863, 5736.340320863071, 5757.625754325955, 5760.049591817345, 22903.88548057249, 23220.76779232203, 23758.76241237583, 23832.880835595883, 23874.283771486884, 2384.678068460753, 2448.951020979588, 2463.0886571968485, 2540.453802432486, 2553.323369307135, 13922.582322530341, 14384.35270412834, 14430.0, 14503.274836258144, 14798.926005369904, 1856.9535761605932, 1953.8143876331726, 1970.6157299326637, 1982.098145343865, 2047.06858379437, 80802.59598702028, 83266.0, 83527.5823620878, 83752.58123709404, 84744.0, 10513.421761803022, 10591.669832636808, 10595.788084238273, 10774.46800001999, 10887.292325998786, 15265.694686106215, 15307.15810630426, 15372.923135384475, 15381.0, 15381.846181538265, 8138.389620778347, 8426.0, 8554.315654747605, 8637.26583240419, 8643.956780216058, 8261.8347633047, 8279.8344033119, 8311.0, 8424.241818236389, 8442.577871106543, 6744.22441419243, 6794.490413219029, 6852.937794641838, 6892.694303364434, 6912.101426814482, 1912.254220853868, 1956.6184594004317, 1969.8522610803961, 1981.5739615982634, 2049.477383267287, 941.8634298026748, 1022.4223313827664, 1025.3847691385258, 1052.7841792432532, 1091.9071878890225, 19809.900950495154, 20460.69308960337, 20576.27983020617, 20767.0, 20915.37253882386, 1030.8762948446235, 1066.157735389034, 1099.571167244775, 1117.2681893359863, 1144.416347662698, 10869.782604347869, 11436.0, 11449.59926402572, 11504.367259800623, 11507.67661718913, 457396.0, 477558.0, 479182.0, 481470.0, 488634.0, 96520.51739741396, 103077.0, 103426.48286758669, 103745.48127259316, 104116.47941760243, 1042.1714736784274, 1058.1059005140644, 1069.8555694981233, 1077.7251800790905, 1078.2344535379968, 17279.3952211672, 17306.567335816704, 17446.563835904202, 17448.91275543614, 17765.111744412985, 37916.0, 42444.0, 42969.35545966875, 43822.12355752803, 44559.77720111508, 53654.46345536651, 56495.0, 57958.4204157953, 58107.0, 59507.404925950184, 7975.361971042186, 8363.121872203332, 8424.578771061544, 8431.53626550521, 8499.74500764978, 12451.750964980469, 12892.097553171188, 12911.5480958166, 12986.935065324613, 13082.934585327394, 11288.774224515628, 11371.886281137082, 11699.824502632297, 11711.1802173847, 11816.468258928197, 5457.072297709478, 8353.874691879748, 9904.405735655884, 11504.712382190512, 11749.76500470003, 11761.176717629683, 11851.822222666839, 11915.106367022334, 11956.880431195925, 11960.162788604714, 8004.199580041949, 8313.376496762647, 8364.581770911553, 8436.11420800807, 8466.492010479391, 10889.564417423531, 11453.626102362949, 11521.423928803359, 11536.480858361227, 11828.053755699351], "value": 9518.086929195322, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1390.714903444794, 1459.6934643724821, 1540.1298266479441, 1672.2725614357755, 1831.459719382781, 8136.918630813698, 8502.957485212573, 8512.957435212824, 8723.738287851358, 8755.0, 8456.06983231844, 8617.310615150789, 8627.784305392368, 8646.394752367321, 8655.783605409868, 2036.786137455568, 2311.399036250579, 2311.861288322706, 2335.544568809083, 2384.5946189147885, 2413.6379543068592, 2416.4683769570665, 2419.758024197584, 2420.9031638734427, 2421.503591763693, 2337.6960995070617, 2366.2782851230368, 2397.592409290416, 2398.9160379386726, 2401.315625046862, 1967.911443985017, 2208.7459942106702, 2281.9201327953606, 2282.292489328297, 2288.4507718147606, 2335.871527066011, 2354.7292061412986, 2356.045801450415, 2356.375560476475, 2357.7524359942304, 8681.56592170389, 8730.301575873978, 8740.0, 8747.300215982707, 8752.649894004233, 5182.559482443997, 5334.51989320963, 5343.171808369709, 5369.087255166631, 5369.382521010095, 3377.155711072232, 3415.077928959167, 3417.4532074868152, 3534.222471056389, 3544.27342394811, 1098.077614803561, 1099.5381939585393, 1104.6244276945877, 1117.709395557161, 1148.2937993134246, 11918.0, 11921.642350729406, 11941.522339106512, 11945.880541194563, 11973.580924667594, 4601.792919318638, 4616.6306695464955, 4694.835680751157, 4706.788194531255, 4770.976145119253, 10013.24900632441, 10073.395596264247, 10081.19350451962, 10119.13987311072, 10140.645077422254, 5189.221616757441, 5224.660397074178, 5239.030779305841, 5241.16141417379, 5245.055889939771, 4232.873013809591, 4723.338732577442, 4839.975800120977, 4873.537013983666, 4917.877053073702, 3867.149227170018, 3919.8824035278985, 4024.939625905614, 4044.8179831907637, 4079.6940229482907, 1258.8473709955895, 1259.1941157659105, 1260.0990291941307, 1260.3887114749339, 1277.2911034376011, 971.2424309038961, 993.5429702336861, 1003.1673710820002, 1005.4419797012728, 1008.3093081239374, 5669.036263835158, 5682.176084467729, 5891.646501209942, 5944.405559444021, 5967.224260846062, 979.4074584876047, 989.747614358334, 996.2478328861663, 1008.3748076192661, 1041.5417216424748, 4096.426500289962, 4191.7484950903045, 4199.181159673895, 4220.282551966173, 4222.683298752544, 10495.26533142688, 10785.191110666732, 10849.78300433987, 10859.348439093521, 10870.945645271722, 10019.599216031276, 10711.517981690842, 10766.676999690022, 10783.892161078445, 10804.459777011118, 8098.919010809816, 8168.632411541376, 8221.876671849926, 8226.917730822735, 8246.711365102192, 5597.888042239214, 5810.82567522975, 5843.2403787507355, 5902.439268269508, 6069.726862291119, 9894.505274736379, 9914.40513569188, 10028.197744180303, 10033.799324013626, 10041.0, 9802.215822734306, 9976.102150806462, 10171.745706357104, 10185.287029907835, 10330.741731456774, 7056.717731290896, 7297.635118244173, 7409.184989651242, 7744.57404842739, 7911.683532658629, 8174.100848906734, 8180.222878826502, 8218.096009439076, 8252.381071419548, 8253.504789712637, 7279.636018198963, 7419.666115024945, 7491.587962661888, 7547.547147171187, 7607.695692172472, 7449.106107267163, 7600.201978792147, 7633.084029916446, 7723.34351580122, 7728.884066739116, 6222.0, 6245.437910588069, 6287.339829317856, 6288.5598008138995, 6292.4651404629285, 5093.23601459784, 5139.383274007143, 5231.607629427732, 5259.868503287295, 5291.391489978701, 5120.641555091108, 5197.22041693749, 5227.3465816772905, 5301.867453313698, 5337.852361742244], "value": 4612.137839634393, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.7096725848512, 341.4093618040789, 342.0491034922915, 344.25812374333304, 348.2390975718057, 5245.318108645875, 5252.71110088945, 5276.261323414725, 5300.761465734042, 5374.167004114363, 5207.0, 5215.947840521593, 5216.921746173811, 5223.764930578123, 5236.450172731866, 3822.3310920588924, 3950.0, 3996.5204175498834, 4078.2047500737367, 4079.77561234132, 4088.7751173685438, 4090.202410529948, 4123.773192474413, 4127.525334586531, 4140.8964775880695, 4076.5515793262716, 4079.714419990602, 4087.264292427362, 4089.672826173914, 4092.4475195848477, 3883.417487376902, 3905.2384784966944, 4005.759654420715, 4097.520999795111, 4102.794860257005, 3642.1805093853936, 3642.7450078494517, 3643.927121457556, 3649.6897763690117, 3657.0674478008204, 5009.849704508871, 5045.596352291808, 5053.5957123430035, 5061.797528098871, 5083.3391659084455, 4552.317152427129, 4669.603083737887, 4681.789319480631, 4735.384400027974, 4740.312654665088, 5385.892282154335, 5421.26812880264, 5461.808836690697, 5462.6995515246645, 5472.20653005312, 3997.200559888005, 4016.6343443229443, 4020.9195816083516, 4022.4770779798437, 4033.173199494126, 5429.701366424845, 5626.9437305626825, 5636.887262254773, 5707.258056452676, 5738.655680659173, 4061.2283666103344, 4108.1783643271465, 4115.279826030433, 4123.8969025774595, 4130.6282434581035, 4181.916361672749, 4181.97909010453, 4186.204621121977, 4189.120284740177, 4198.160367926427, 4577.176108300471, 4643.930341044819, 4692.686047906592, 4703.553162449562, 4717.858464246078, 5509.669419834822, 5510.834674959678, 5524.972375138099, 5534.446555344433, 5535.201059655628, 1403.3544569497942, 1417.170954991321, 1418.9645258868404, 1420.5241244183314, 1421.2396367943102, 888.3330603818303, 925.5788616179622, 938.3431597881511, 944.9574769135405, 950.6862735297335, 5200.817971370984, 5201.647571631327, 5223.738813059408, 5294.655847369909, 5295.126304159848, 5597.552195824324, 5598.748056337393, 5612.242347283146, 5636.605437619327, 5655.1799989001365, 4981.601471882241, 5240.982221844617, 5242.7640756166065, 5248.711320877388, 5311.415744268127, 2972.925676858096, 2991.9102426927225, 2992.8054676445963, 2997.905764396023, 3021.169178475937, 5774.595778295563, 5822.737976791054, 5849.7952571660635, 5854.0, 5895.174675545341, 5576.33084029919, 5729.0260655688635, 5731.885362292731, 5739.192154471328, 5780.16187652788, 5818.4763371296785, 5827.708614569339, 5832.0, 5847.853803654858, 5849.94150058494, 5426.348838139448, 5620.325560932714, 5643.830685079454, 5666.291713535808, 5670.0, 5548.805791797267, 5564.443555644403, 5566.721663916869, 5573.749181286771, 5669.574781891457, 5892.970535147297, 5892.998190307744, 5896.941030589639, 5899.174115623902, 5903.870948397356, 3711.5175027246287, 3814.016711310159, 4045.130296986162, 4065.4918135233097, 4113.8971525712095, 5686.232358631697, 5706.915686019643, 5712.400197979152, 5715.342735585461, 5726.79956201531, 5408.621396502207, 5425.240466334637, 5537.889242215053, 5557.582816381797, 5570.2480165177185, 5263.578833714952, 5450.427705090909, 5485.75314110858, 5538.390777014606, 5543.77824887, 5189.948100518946, 5391.676499410048, 5434.864128396822, 5456.699881506555, 5459.344878614433, 5388.676679399248, 5501.752421141138, 5530.695811730394, 5538.667679939216, 5544.17042376023, 5431.185322201543, 5433.5924805640525, 5435.45089649448, 5448.182772584144, 5452.2094296327605], "value": 4203.789765255125, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [740.4372676765663, 779.9610019499023, 783.0798811396611, 830.2610676497916, 846.187659846547, 14503.782443263346, 15375.308111134998, 15607.219639018047, 15616.843831561695, 15637.218139093056, 14708.485203017897, 14799.0, 14802.925985370059, 14814.185219812905, 14849.1090534568, 674.8582797612507, 785.0500893918365, 807.9192080791918, 825.6532256452274, 836.4981011393177, 821.1747194069951, 822.942394032418, 823.086374124721, 825.162460102996, 825.4840724547158, 855.1363123245536, 860.6815478273048, 861.0958493581714, 861.5175501719058, 863.9870401943975, 700.6496751624188, 814.3892080939296, 855.5807654249435, 862.9266512346458, 863.1886027134536, 627.9403456671608, 628.9559730818844, 629.2574761781096, 629.3769168523174, 629.408356145222, 14514.129152250898, 14539.709205815825, 14594.41622335116, 14616.853831461656, 14630.487932922297, 14067.2966351682, 14072.22602756848, 14081.577552673436, 14136.434542618283, 14587.781183282259, 11821.586244481488, 12038.81941770874, 12123.151379403445, 12404.81392779109, 12520.186187897758, 4434.911301773946, 4453.665975051884, 4495.213337665896, 4533.727976321398, 4551.453825540956, 57605.0, 57770.0, 57775.0, 57845.421545784426, 60706.696466517824, 11159.776804464027, 11256.774864502664, 11420.37187954654, 11494.0, 11687.766244675058, 20439.284625038053, 20456.181752729724, 20479.897600511904, 20500.89749551243, 20524.89737551303, 8104.554249516334, 8120.796980075427, 8190.959045204855, 8211.876821847676, 8476.579447361817, 4276.187524370422, 4311.353297005474, 4325.545817689097, 4376.3654270130655, 4438.023634800339, 3411.9317613647586, 3466.168119651316, 3497.0557949353533, 3508.947365789515, 3510.9648903511147, 636.1761518833122, 637.3403527349171, 656.0421784195129, 657.1719633262124, 662.2053535757015, 644.8613548087184, 668.0513670587777, 672.630053470599, 726.2991213479019, 742.0909386002104, 8906.530422480218, 9369.531523423802, 9642.228621710246, 9929.156021738234, 10030.64892728751, 668.7224801707334, 761.5392687424139, 787.7676085554775, 799.8280369720538, 813.4062134641745, 4727.527247275245, 4759.809607615726, 4902.877428064256, 4925.285833554115, 4972.477889821589, 67485.6625716878, 69051.0, 69589.65205173942, 70487.0, 70722.2927770726, 61031.6948415264, 61197.0, 61637.69181154066, 61932.0, 62238.37761622416, 55461.44538554563, 55702.72148639231, 56561.0, 57275.42724572701, 57292.71353643205, 9149.313801464783, 9264.44413335202, 9360.391574547633, 9398.436093834393, 9563.952180239054, 36937.07657308589, 37033.62966370302, 37197.628023719415, 37270.6272937278, 37995.81002094972, 44468.332975004756, 50120.498795013045, 50159.0, 50543.49456505388, 51213.7439312816, 12501.812472813097, 12502.312372819582, 12569.93715031419, 12689.428975695932, 12701.618951431472, 14346.641333966734, 14481.92759036198, 14887.181205033394, 14936.178510182044, 15219.315130819361, 13566.186028838301, 13628.727425451634, 14151.575452736435, 14170.929145354206, 14177.503787367392, 13595.184288942695, 13735.381907813973, 13757.182834891833, 14017.929910350384, 14309.35607897668, 12549.247045177319, 12637.93681031589, 13670.52153174634, 13835.699199616278, 14403.78394324065, 11296.661100167008, 11386.94306528462, 11481.942590286995, 11510.136739744385, 11889.881101188877, 11397.430128493708, 11707.648770536898, 11873.076769372026, 11894.80568382225, 12012.879871201176], "value": 7097.8246608797745, "unit": "score"}], "name": "dromaeo_css", "value": 7259.298173325233, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 104.0, 110.0, 109.0, 109.0, 109.0, 109.0, 110.0, 110.0, 110.0], "value": 109.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 130.0, 126.0, 182.0, 125.0, 126.0, 149.0, 132.0, 190.0, 127.0], "value": 144.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 159.0, 160.0, 159.0, 161.0, 161.0, 161.0, 161.0, 161.0, 160.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 75.0, 113.0, 73.0, 74.0, 73.0, 74.0, 96.0, 74.0], "value": 79.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 91.0, 141.0, 92.0, 92.0, 92.0, 121.0, 93.0, 93.0, 142.0], "value": 105.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 144.0, 145.0], "value": 145.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 94.0, 94.0, 95.0, 94.0, 94.0, 95.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 54.0, 54.0, 53.0, 62.0, 56.0, 69.0, 53.0, 52.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 63.0, 62.0, 63.0, 63.0, 62.0, 62.0, 63.0], "value": 62.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 77.0, 83.0, 77.0, 81.0, 80.0, 78.0, 79.0, 79.0, 79.0], "value": 79.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 119.0, 126.0, 120.0, 116.0, 117.0, 119.0, 120.0, 171.0, 127.0], "value": 125.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 159.0, 164.0, 163.0, 162.0, 161.0, 161.0, 166.0, 164.0, 162.0], "value": 162.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 65.0, 62.0, 63.0, 63.0, 63.0, 63.0, 62.0], "value": 62.7, "unit": "score"}], "name": "kraken", "value": 1503.1000000000001, "alertThreshold": 2.0}]} 01:17:00 INFO - Return code: 0 01:17:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 01:17:00 ERROR - # TBPL SUCCESS # 01:17:00 INFO - Running post-action listener: _resource_record_post_action 01:17:00 INFO - ##### 01:17:00 INFO - ##### Finished run-tests step (success) 01:17:00 INFO - ##### 01:17:00 INFO - Running post-run listener: _resource_record_post_run 01:17:00 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 548229120; Read time: 156; Write time: 396524 01:17:00 INFO - TinderboxPrint: CPU usage
13.1% 01:17:00 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 156 01:17:00 INFO - TinderboxPrint: I/O write bytes / time
548,229,120 / 396,524 01:17:00 INFO - TinderboxPrint: CPU idle
8,265.2 (86.9%) 01:17:00 INFO - TinderboxPrint: CPU user
1,204.4 (12.7%) 01:17:00 INFO - TinderboxPrint: Swap in / out
0 / 0 01:17:00 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 257085440; Read time: 0; Write time: 216104 01:17:00 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291065856; Read time: 156; Write time: 180420 01:17:01 INFO - Running post-run listener: _upload_blobber_files 01:17:01 INFO - Blob upload gear active. 01:17:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:17:01 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 01:17:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:17:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:17:01 INFO - (blobuploader) - INFO - Open directory for files ... 01:17:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:17:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:17:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:17:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:17:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:17:05 INFO - (blobuploader) - INFO - Done attempting. 01:17:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:17:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:17:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:17:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:17:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:17:06 INFO - (blobuploader) - INFO - Done attempting. 01:17:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:17:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:17:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:17:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:17:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:17:07 INFO - (blobuploader) - INFO - Done attempting. 01:17:07 INFO - (blobuploader) - INFO - Iteration through files over. 01:17:07 INFO - Return code: 0 01:17:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:17:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:17:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/62ac21d418e152328e52d6f1f659a57419bfa527091600024fc6b22da859d0b6160866d47ad7ce4bb03b85ac8151ef04fa7c6b9a35c917b394e6ed056533e482", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b1cc8aaa171bce58515d274a60a7fd4fa9bc29a339d5917be5b5f389032006d0225ce2813f9a783d666805fc7577c6d624e19382fff91fb3530d487cf5fdabce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/55aef55294aed51262143a01dc8d6d75df5ab3aebf9f8d79a37d714cc7d5141b7287729a8c3a8db2b6b903fef90949401052b36fdb08f6b8ca12a8aa5557ec97"} 01:17:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:17:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:17:07 INFO - Contents: 01:17:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/62ac21d418e152328e52d6f1f659a57419bfa527091600024fc6b22da859d0b6160866d47ad7ce4bb03b85ac8151ef04fa7c6b9a35c917b394e6ed056533e482", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b1cc8aaa171bce58515d274a60a7fd4fa9bc29a339d5917be5b5f389032006d0225ce2813f9a783d666805fc7577c6d624e19382fff91fb3530d487cf5fdabce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/55aef55294aed51262143a01dc8d6d75df5ab3aebf9f8d79a37d714cc7d5141b7287729a8c3a8db2b6b903fef90949401052b36fdb08f6b8ca12a8aa5557ec97"} 01:17:07 INFO - Running post-run listener: copy_logs_to_upload_dir 01:17:07 INFO - Copying logs to upload dir... 01:17:07 INFO - mkdir: /builds/slave/test/build/upload/logs 01:17:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.434675 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-05-24 01:17:07.593859) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-24 01:17:07.598278) ========= 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=aa08bb06ff6271ef470a76a4000001be-1464076539.93700-138900510 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/62ac21d418e152328e52d6f1f659a57419bfa527091600024fc6b22da859d0b6160866d47ad7ce4bb03b85ac8151ef04fa7c6b9a35c917b394e6ed056533e482", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b1cc8aaa171bce58515d274a60a7fd4fa9bc29a339d5917be5b5f389032006d0225ce2813f9a783d666805fc7577c6d624e19382fff91fb3530d487cf5fdabce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/55aef55294aed51262143a01dc8d6d75df5ab3aebf9f8d79a37d714cc7d5141b7287729a8c3a8db2b6b903fef90949401052b36fdb08f6b8ca12a8aa5557ec97"} build_url:https://queue.taskcluster.net/v1/task/aeqtGFHtSX681ak9BRJN-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011336 build_url: 'https://queue.taskcluster.net/v1/task/aeqtGFHtSX681ak9BRJN-w/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/62ac21d418e152328e52d6f1f659a57419bfa527091600024fc6b22da859d0b6160866d47ad7ce4bb03b85ac8151ef04fa7c6b9a35c917b394e6ed056533e482", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b1cc8aaa171bce58515d274a60a7fd4fa9bc29a339d5917be5b5f389032006d0225ce2813f9a783d666805fc7577c6d624e19382fff91fb3530d487cf5fdabce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/55aef55294aed51262143a01dc8d6d75df5ab3aebf9f8d79a37d714cc7d5141b7287729a8c3a8db2b6b903fef90949401052b36fdb08f6b8ca12a8aa5557ec97"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-24 01:17:07.627312) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 01:17:07.628028) ========= 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=aa08bb06ff6271ef470a76a4000001be-1464076539.93700-138900510 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004560 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-24 01:17:07.710899) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-24 01:17:07.711541) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-24 01:17:07.712134) ========= ========= Total master_lag: 0.19 =========