builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-054 starttime: 1464653584.33 results: success (0) buildid: 20160530143013 builduid: fb7497e5fcc64d66a1c9362bca3babe1 revision: 8682f94befeb413bafc9e434d3cb387b1ce567d5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 17:13:04.329189) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 17:13:04.329982) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 17:13:04.330497) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 17:13:04.343261) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 17:13:04.343646) ========= 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=cbe409c6de289db6ac707de3000001d4-1464653583.725438-1791022660 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-30 17:13:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 103M=0s 2016-05-30 17:13:04 (103 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.084316 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 17:13:04.439649) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 17:13:04.440163) ========= 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=cbe409c6de289db6ac707de3000001d4-1464653583.725438-1791022660 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019121 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 17:13:04.492058) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 17:13:04.492661) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8682f94befeb413bafc9e434d3cb387b1ce567d5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 8682f94befeb413bafc9e434d3cb387b1ce567d5 --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=cbe409c6de289db6ac707de3000001d4-1464653583.725438-1791022660 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-30 17:13:04,584 truncating revision to first 12 chars 2016-05-30 17:13:04,584 Setting DEBUG logging. 2016-05-30 17:13:04,584 attempt 1/10 2016-05-30 17:13:04,584 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8682f94befeb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-30 17:13:04,895 unpacking tar archive at: fx-team-8682f94befeb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.650830 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 17:13:05.157434) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 17:13:05.157822) ========= script_repo_revision: 8682f94befeb413bafc9e434d3cb387b1ce567d5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 17:13:05.158211) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 17:13:05.158541) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 17:13:05.166882) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-05-30 17:13:05.167167) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=cbe409c6de289db6ac707de3000001d4-1464653583.725438-1791022660 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:13:05 INFO - MultiFileLogger online at 20160530 17:13:05 in /builds/slave/test 17:13:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:13:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:13:05 INFO - {'append_to_log': False, 17:13:05 INFO - 'base_work_dir': '/builds/slave/test', 17:13:05 INFO - 'blob_upload_branch': 'Fx-Team', 17:13:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:13:05 INFO - 'branch': 'Fx-Team', 17:13:05 INFO - 'buildbot_json_path': 'buildprops.json', 17:13:05 INFO - 'config_files': ('talos/linux_config.py',), 17:13:05 INFO - 'default_actions': ('clobber', 17:13:05 INFO - 'read-buildbot-config', 17:13:05 INFO - 'download-and-extract', 17:13:05 INFO - 'populate-webroot', 17:13:05 INFO - 'create-virtualenv', 17:13:05 INFO - 'install', 17:13:05 INFO - 'run-tests'), 17:13:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:13:05 INFO - 'download_minidump_stackwalk': True, 17:13:05 INFO - 'download_symbols': 'ondemand', 17:13:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:13:05 INFO - 'tooltool.py': '/tools/tooltool.py', 17:13:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:13:05 INFO - '/tools/misc-python/virtualenv.py')}, 17:13:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:13:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:13:05 INFO - 'installer_path': 'installer.exe', 17:13:05 INFO - 'log_level': 'info', 17:13:05 INFO - 'log_name': 'talos', 17:13:05 INFO - 'log_to_console': True, 17:13:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:13:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:13:05 INFO - 'opt_config_files': (), 17:13:05 INFO - 'pip_index': False, 17:13:05 INFO - 'sps_profile': False, 17:13:05 INFO - 'sps_profile_interval': 0, 17:13:05 INFO - 'suite': 'dromaeojs', 17:13:05 INFO - 'system_bits': '32', 17:13:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:13:05 INFO - 'title': 'talos-linux64-ix-054', 17:13:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:13:05 INFO - 'use_talos_json': True, 17:13:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:13:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:13:05 INFO - 'work_dir': 'build'} 17:13:05 INFO - ##### 17:13:05 INFO - ##### Running clobber step. 17:13:05 INFO - ##### 17:13:05 INFO - Running pre-action listener: _resource_record_pre_action 17:13:05 INFO - Running main action method: clobber 17:13:05 INFO - rmtree: /builds/slave/test/build 17:13:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:13:05 INFO - Running post-action listener: _resource_record_post_action 17:13:05 INFO - ##### 17:13:05 INFO - ##### Finished clobber step (success) 17:13:05 INFO - ##### 17:13:05 INFO - ##### 17:13:05 INFO - ##### Running read-buildbot-config step. 17:13:05 INFO - ##### 17:13:05 INFO - Running pre-action listener: _resource_record_pre_action 17:13:05 INFO - Running main action method: read_buildbot_config 17:13:05 INFO - Using buildbot properties: 17:13:05 INFO - { 17:13:05 INFO - "project": "", 17:13:05 INFO - "product": "firefox", 17:13:05 INFO - "script_repo_revision": "production", 17:13:05 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:13:05 INFO - "repository": "", 17:13:05 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 17:13:05 INFO - "buildid": "20160530143013", 17:13:05 INFO - "pgo_build": "True", 17:13:05 INFO - "basedir": "/builds/slave/test", 17:13:05 INFO - "buildnumber": 739, 17:13:05 INFO - "slavename": "talos-linux64-ix-054", 17:13:05 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:13:05 INFO - "platform": "ubuntu64_hw", 17:13:05 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:13:05 INFO - "branch": "fx-team", 17:13:05 INFO - "repo_path": "integration/fx-team", 17:13:05 INFO - "revision": "8682f94befeb413bafc9e434d3cb387b1ce567d5", 17:13:05 INFO - "stage_platform": "linux64-pgo", 17:13:05 INFO - "builduid": "fb7497e5fcc64d66a1c9362bca3babe1", 17:13:05 INFO - "slavebuilddir": "test" 17:13:05 INFO - } 17:13:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/Sqdf8GYHR3ikYm3qs3cN9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 17:13:05 INFO - Running post-action listener: _resource_record_post_action 17:13:05 INFO - ##### 17:13:05 INFO - ##### Finished read-buildbot-config step (success) 17:13:05 INFO - ##### 17:13:05 INFO - ##### 17:13:05 INFO - ##### Running download-and-extract step. 17:13:05 INFO - ##### 17:13:05 INFO - Running pre-action listener: _resource_record_pre_action 17:13:05 INFO - Running main action method: download_and_extract 17:13:05 INFO - mkdir: /builds/slave/test/build/tests 17:13:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:05 INFO - https://queue.taskcluster.net/v1/task/Sqdf8GYHR3ikYm3qs3cN9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:13:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sqdf8GYHR3ikYm3qs3cN9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:13:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sqdf8GYHR3ikYm3qs3cN9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:13:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sqdf8GYHR3ikYm3qs3cN9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:13:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sqdf8GYHR3ikYm3qs3cN9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:13:06 INFO - Downloaded 1361 bytes. 17:13:06 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 17:13:06 INFO - Using the following test package requirements: 17:13:06 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:13:06 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:13:06 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:13:06 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:13:06 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:13:06 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:13:06 INFO - u'jsshell-linux-x86_64.zip'], 17:13:06 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:13:06 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:13:06 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 17:13:06 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:13:06 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:13:06 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:13:06 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:13:06 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:13:06 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:13:06 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 17:13:06 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:13:06 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:13:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:06 INFO - https://queue.taskcluster.net/v1/task/Sqdf8GYHR3ikYm3qs3cN9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:13:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sqdf8GYHR3ikYm3qs3cN9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:13:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sqdf8GYHR3ikYm3qs3cN9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:13:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sqdf8GYHR3ikYm3qs3cN9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:13:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sqdf8GYHR3ikYm3qs3cN9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:13:08 INFO - Downloaded 24410718 bytes. 17:13:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:13:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:13:09 INFO - Return code: 0 17:13:09 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:13:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:09 INFO - https://queue.taskcluster.net/v1/task/Sqdf8GYHR3ikYm3qs3cN9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:13:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sqdf8GYHR3ikYm3qs3cN9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:13:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sqdf8GYHR3ikYm3qs3cN9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:13:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sqdf8GYHR3ikYm3qs3cN9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 17:13:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sqdf8GYHR3ikYm3qs3cN9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:13:10 INFO - Downloaded 24410718 bytes. 17:13:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:13:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:13:12 INFO - Return code: 0 17:13:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:12 INFO - https://queue.taskcluster.net/v1/task/Sqdf8GYHR3ikYm3qs3cN9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:13:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sqdf8GYHR3ikYm3qs3cN9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:13:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sqdf8GYHR3ikYm3qs3cN9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:13:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sqdf8GYHR3ikYm3qs3cN9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 17:13:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sqdf8GYHR3ikYm3qs3cN9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:13:13 INFO - Downloaded 10834055 bytes. 17:13:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:13:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 17:13:13 INFO - Return code: 0 17:13:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:13 INFO - https://queue.taskcluster.net/v1/task/Sqdf8GYHR3ikYm3qs3cN9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:13:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sqdf8GYHR3ikYm3qs3cN9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:13:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sqdf8GYHR3ikYm3qs3cN9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:13:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sqdf8GYHR3ikYm3qs3cN9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:13:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sqdf8GYHR3ikYm3qs3cN9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:13:15 INFO - Downloaded 58936093 bytes. 17:13:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Sqdf8GYHR3ikYm3qs3cN9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:13:15 INFO - mkdir: /builds/slave/test/properties 17:13:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:13:15 INFO - Writing to file /builds/slave/test/properties/build_url 17:13:15 INFO - Contents: 17:13:15 INFO - build_url:https://queue.taskcluster.net/v1/task/Sqdf8GYHR3ikYm3qs3cN9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 17:13:16 INFO - Running post-action listener: _resource_record_post_action 17:13:16 INFO - Running post-action listener: set_extra_try_arguments 17:13:16 INFO - ##### 17:13:16 INFO - ##### Finished download-and-extract step (success) 17:13:16 INFO - ##### 17:13:16 INFO - ##### 17:13:16 INFO - ##### Running populate-webroot step. 17:13:16 INFO - ##### 17:13:16 INFO - Running pre-action listener: _resource_record_pre_action 17:13:16 INFO - Running main action method: populate_webroot 17:13:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:13:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:13:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:13:16 INFO - '--tppagecycles', 17:13:16 INFO - '7'], 17:13:16 INFO - 'tests': ['tsvgm']}}, 17:13:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:13:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:13:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:13:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:13:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:13:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:13:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:13:16 INFO - 'talos_options': ['--disable-e10s'], 17:13:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:13:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:13:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:13:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:13:16 INFO - 'talos_options': ['--disable-e10s'], 17:13:16 INFO - 'tests': ['damp', 'tps']}, 17:13:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:13:16 INFO - 'tests': ['damp', 'tps']}, 17:13:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:13:16 INFO - 'tests': ['dromaeo_dom']}, 17:13:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:13:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:13:16 INFO - 'tests': ['a11yr', 17:13:16 INFO - 'ts_paint', 17:13:16 INFO - 'tpaint', 17:13:16 INFO - 'sessionrestore', 17:13:16 INFO - 'sessionrestore_no_auto_restore', 17:13:16 INFO - 'tabpaint']}, 17:13:16 INFO - 'other-e10s': {'tests': ['a11yr', 17:13:16 INFO - 'ts_paint', 17:13:16 INFO - 'tpaint', 17:13:16 INFO - 'sessionrestore', 17:13:16 INFO - 'sessionrestore_no_auto_restore', 17:13:16 INFO - 'tabpaint']}, 17:13:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:13:16 INFO - 'ts_paint', 17:13:16 INFO - 'tpaint', 17:13:16 INFO - 'sessionrestore', 17:13:16 INFO - 'sessionrestore_no_auto_restore', 17:13:16 INFO - 'tabpaint']}, 17:13:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:13:16 INFO - 'ts_paint', 17:13:16 INFO - 'tpaint', 17:13:16 INFO - 'sessionrestore', 17:13:16 INFO - 'sessionrestore_no_auto_restore', 17:13:16 INFO - 'tabpaint']}, 17:13:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:13:16 INFO - 'tests': ['a11yr', 17:13:16 INFO - 'ts_paint', 17:13:16 INFO - 'tpaint', 17:13:16 INFO - 'sessionrestore', 17:13:16 INFO - 'sessionrestore_no_auto_restore', 17:13:16 INFO - 'tabpaint']}, 17:13:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:13:16 INFO - 'tests': ['a11yr', 17:13:16 INFO - 'ts_paint', 17:13:16 INFO - 'tpaint', 17:13:16 INFO - 'sessionrestore', 17:13:16 INFO - 'sessionrestore_no_auto_restore', 17:13:16 INFO - 'tabpaint']}, 17:13:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:13:16 INFO - 'tests': ['tsvgx', 17:13:16 INFO - 'tsvgr_opacity', 17:13:16 INFO - 'tart', 17:13:16 INFO - 'tscrollx', 17:13:16 INFO - 'cart']}, 17:13:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:13:16 INFO - 'tsvgr_opacity', 17:13:16 INFO - 'tart', 17:13:16 INFO - 'tscrollx', 17:13:16 INFO - 'cart']}, 17:13:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:13:16 INFO - 'talos_options': ['--disable-e10s'], 17:13:16 INFO - 'tests': ['tp5o']}, 17:13:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:13:16 INFO - 'tests': ['tp5o']}, 17:13:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:13:16 INFO - 'talos_options': ['--disable-e10s', 17:13:16 INFO - '--xperf_path', 17:13:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:13:16 INFO - 'tests': ['tp5n']}, 17:13:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:13:16 INFO - 'talos_options': ['--xperf_path', 17:13:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:13:16 INFO - 'tests': ['tp5n']}}, 17:13:16 INFO - 'talos.zip': {'path': '', 17:13:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:13:16 INFO - Running post-action listener: _resource_record_post_action 17:13:16 INFO - ##### 17:13:16 INFO - ##### Finished populate-webroot step (success) 17:13:16 INFO - ##### 17:13:16 INFO - ##### 17:13:16 INFO - ##### Running create-virtualenv step. 17:13:16 INFO - ##### 17:13:16 INFO - Running pre-action listener: _resource_record_pre_action 17:13:16 INFO - Running main action method: create_virtualenv 17:13:16 INFO - Creating virtualenv /builds/slave/test/build/venv 17:13:16 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:13:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:13:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:13:16 INFO - Using real prefix '/usr' 17:13:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:13:16 INFO - Installing distribute.............................................................................................................................................................................................done. 17:13:18 INFO - Installing pip.................done. 17:13:18 INFO - Return code: 0 17:13:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:13:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:18 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 0x7f1cd6e79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe47770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed69c0>, '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 0xed78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed7d50>, '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': 'cbe409c6de289db6ac707de3000001d4-1464653583.725438-1791022660', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:13:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:13:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:13:18 INFO - Using env: {'DISPLAY': ':0', 17:13:18 INFO - 'HOME': '/home/cltbld', 17:13:18 INFO - 'LANG': 'en_US.UTF-8', 17:13:18 INFO - 'LANGUAGE': 'en_US:en', 17:13:18 INFO - 'LOGNAME': 'cltbld', 17:13:18 INFO - 'MAIL': '/var/mail/cltbld', 17:13:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:18 INFO - 'MOZ_NO_REMOTE': '1', 17:13:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:18 INFO - 'NO_EM_RESTART': '1', 17:13:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:18 INFO - 'PWD': '/builds/slave/test', 17:13:18 INFO - 'SHELL': '/bin/bash', 17:13:18 INFO - 'SHLVL': '1', 17:13:18 INFO - 'TERM': 'linux', 17:13:18 INFO - 'TMOUT': '86400', 17:13:18 INFO - 'USER': 'cltbld', 17:13:18 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464653583.725438-1791022660', 17:13:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:18 INFO - '_': '/tools/buildbot/bin/python'} 17:13:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:18 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:13:18 INFO - Cleaning up... 17:13:18 INFO - Return code: 0 17:13:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:13:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:18 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 0x7f1cd6e79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe47770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed69c0>, '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 0xed78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed7d50>, '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': 'cbe409c6de289db6ac707de3000001d4-1464653583.725438-1791022660', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:13:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:13:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:13:18 INFO - Using env: {'DISPLAY': ':0', 17:13:18 INFO - 'HOME': '/home/cltbld', 17:13:18 INFO - 'LANG': 'en_US.UTF-8', 17:13:18 INFO - 'LANGUAGE': 'en_US:en', 17:13:18 INFO - 'LOGNAME': 'cltbld', 17:13:18 INFO - 'MAIL': '/var/mail/cltbld', 17:13:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:18 INFO - 'MOZ_NO_REMOTE': '1', 17:13:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:18 INFO - 'NO_EM_RESTART': '1', 17:13:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:18 INFO - 'PWD': '/builds/slave/test', 17:13:18 INFO - 'SHELL': '/bin/bash', 17:13:18 INFO - 'SHLVL': '1', 17:13:18 INFO - 'TERM': 'linux', 17:13:18 INFO - 'TMOUT': '86400', 17:13:18 INFO - 'USER': 'cltbld', 17:13:18 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464653583.725438-1791022660', 17:13:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:18 INFO - '_': '/tools/buildbot/bin/python'} 17:13:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:19 INFO - Downloading/unpacking psutil>=3.1.1 17:13:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:13:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:13:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:13:21 INFO - Installing collected packages: psutil 17:13:21 INFO - Running setup.py install for psutil 17:13:21 INFO - building 'psutil._psutil_linux' extension 17:13:21 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 17:13:21 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 17:13:21 INFO - building 'psutil._psutil_posix' extension 17:13:21 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 17:13:21 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 17:13:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:13:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:13:21 INFO - Successfully installed psutil 17:13:21 INFO - Cleaning up... 17:13:21 INFO - Return code: 0 17:13:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:13:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:21 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 0x7f1cd6e79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe47770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed69c0>, '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 0xed78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed7d50>, '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': 'cbe409c6de289db6ac707de3000001d4-1464653583.725438-1791022660', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:13:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:13:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:13:21 INFO - Using env: {'DISPLAY': ':0', 17:13:21 INFO - 'HOME': '/home/cltbld', 17:13:21 INFO - 'LANG': 'en_US.UTF-8', 17:13:21 INFO - 'LANGUAGE': 'en_US:en', 17:13:21 INFO - 'LOGNAME': 'cltbld', 17:13:21 INFO - 'MAIL': '/var/mail/cltbld', 17:13:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:21 INFO - 'MOZ_NO_REMOTE': '1', 17:13:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:21 INFO - 'NO_EM_RESTART': '1', 17:13:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:21 INFO - 'PWD': '/builds/slave/test', 17:13:21 INFO - 'SHELL': '/bin/bash', 17:13:21 INFO - 'SHLVL': '1', 17:13:21 INFO - 'TERM': 'linux', 17:13:21 INFO - 'TMOUT': '86400', 17:13:21 INFO - 'USER': 'cltbld', 17:13:21 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464653583.725438-1791022660', 17:13:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:21 INFO - '_': '/tools/buildbot/bin/python'} 17:13:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:13:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:13:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:13:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:13:23 INFO - Installing collected packages: mozsystemmonitor 17:13:23 INFO - Running setup.py install for mozsystemmonitor 17:13:23 INFO - Successfully installed mozsystemmonitor 17:13:23 INFO - Cleaning up... 17:13:24 INFO - Return code: 0 17:13:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:13:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:24 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 0x7f1cd6e79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe47770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed69c0>, '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 0xed78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed7d50>, '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': 'cbe409c6de289db6ac707de3000001d4-1464653583.725438-1791022660', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:13:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:13:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:13:24 INFO - Using env: {'DISPLAY': ':0', 17:13:24 INFO - 'HOME': '/home/cltbld', 17:13:24 INFO - 'LANG': 'en_US.UTF-8', 17:13:24 INFO - 'LANGUAGE': 'en_US:en', 17:13:24 INFO - 'LOGNAME': 'cltbld', 17:13:24 INFO - 'MAIL': '/var/mail/cltbld', 17:13:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:24 INFO - 'MOZ_NO_REMOTE': '1', 17:13:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:24 INFO - 'NO_EM_RESTART': '1', 17:13:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:24 INFO - 'PWD': '/builds/slave/test', 17:13:24 INFO - 'SHELL': '/bin/bash', 17:13:24 INFO - 'SHLVL': '1', 17:13:24 INFO - 'TERM': 'linux', 17:13:24 INFO - 'TMOUT': '86400', 17:13:24 INFO - 'USER': 'cltbld', 17:13:24 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464653583.725438-1791022660', 17:13:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:24 INFO - '_': '/tools/buildbot/bin/python'} 17:13:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:24 INFO - Downloading/unpacking blobuploader==1.2.4 17:13:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:26 INFO - Downloading blobuploader-1.2.4.tar.gz 17:13:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:13:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:13:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:13:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:13:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:26 INFO - Downloading docopt-0.6.1.tar.gz 17:13:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:13:26 INFO - Installing collected packages: blobuploader, requests, docopt 17:13:26 INFO - Running setup.py install for blobuploader 17:13:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:13:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:13:26 INFO - Running setup.py install for requests 17:13:27 INFO - Running setup.py install for docopt 17:13:27 INFO - Successfully installed blobuploader requests docopt 17:13:27 INFO - Cleaning up... 17:13:27 INFO - Return code: 0 17:13:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:13:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:27 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 0x7f1cd6e79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe47770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed69c0>, '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 0xed78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed7d50>, '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': 'cbe409c6de289db6ac707de3000001d4-1464653583.725438-1791022660', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:13:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:13:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:13:27 INFO - Using env: {'DISPLAY': ':0', 17:13:27 INFO - 'HOME': '/home/cltbld', 17:13:27 INFO - 'LANG': 'en_US.UTF-8', 17:13:27 INFO - 'LANGUAGE': 'en_US:en', 17:13:27 INFO - 'LOGNAME': 'cltbld', 17:13:27 INFO - 'MAIL': '/var/mail/cltbld', 17:13:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:27 INFO - 'MOZ_NO_REMOTE': '1', 17:13:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:27 INFO - 'NO_EM_RESTART': '1', 17:13:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:27 INFO - 'PWD': '/builds/slave/test', 17:13:27 INFO - 'SHELL': '/bin/bash', 17:13:27 INFO - 'SHLVL': '1', 17:13:27 INFO - 'TERM': 'linux', 17:13:27 INFO - 'TMOUT': '86400', 17:13:27 INFO - 'USER': 'cltbld', 17:13:27 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464653583.725438-1791022660', 17:13:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:27 INFO - '_': '/tools/buildbot/bin/python'} 17:13:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:13:27 INFO - Running setup.py (path:/tmp/pip-3ZyFjk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:13:27 INFO - Running setup.py (path:/tmp/pip-01tccT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:13:27 INFO - Running setup.py (path:/tmp/pip-d2apT7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:13:27 INFO - Running setup.py (path:/tmp/pip-bpGF1_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:13:28 INFO - Running setup.py (path:/tmp/pip-GnFq0o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:13:28 INFO - Running setup.py (path:/tmp/pip-NTeM7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:13:28 INFO - Running setup.py (path:/tmp/pip-OffiCz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:13:28 INFO - Running setup.py (path:/tmp/pip-X32Tm1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:13:28 INFO - Running setup.py (path:/tmp/pip-x2N4Jp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:13:28 INFO - Running setup.py (path:/tmp/pip-0lq_Y9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:13:28 INFO - Running setup.py (path:/tmp/pip-_VF7qb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:13:28 INFO - Running setup.py (path:/tmp/pip-7ufMm_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:13:28 INFO - Running setup.py (path:/tmp/pip-UUii9v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:13:28 INFO - Running setup.py (path:/tmp/pip-mXk3cs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:13:28 INFO - Running setup.py (path:/tmp/pip-D_C8ec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:13:28 INFO - Running setup.py (path:/tmp/pip-4_MBFL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:13:28 INFO - Running setup.py (path:/tmp/pip-AeWBEN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:13:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:13:28 INFO - Running setup.py install for manifestparser 17:13:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:13:29 INFO - Running setup.py install for mozcrash 17:13:29 INFO - Running setup.py install for mozdebug 17:13:29 INFO - Running setup.py install for mozdevice 17:13:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:13:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:13:29 INFO - Running setup.py install for mozfile 17:13:29 INFO - Running setup.py install for mozhttpd 17:13:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:13:29 INFO - Running setup.py install for mozinfo 17:13:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:13:29 INFO - Running setup.py install for mozInstall 17:13:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:13:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:13:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:13:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:13:29 INFO - Running setup.py install for mozleak 17:13:29 INFO - Running setup.py install for mozlog 17:13:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:13:29 INFO - Running setup.py install for moznetwork 17:13:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:13:30 INFO - Running setup.py install for mozprocess 17:13:30 INFO - Running setup.py install for mozprofile 17:13:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:13:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:13:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:13:30 INFO - Running setup.py install for mozrunner 17:13:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:13:30 INFO - Running setup.py install for mozscreenshot 17:13:30 INFO - Running setup.py install for moztest 17:13:30 INFO - Running setup.py install for mozversion 17:13:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:13:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:13:30 INFO - Cleaning up... 17:13:30 INFO - Return code: 0 17:13:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:13:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:30 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 0x7f1cd6e79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe47770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed69c0>, '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 0xed78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed7d50>, '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': 'cbe409c6de289db6ac707de3000001d4-1464653583.725438-1791022660', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:13:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:13:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:13:30 INFO - Using env: {'DISPLAY': ':0', 17:13:30 INFO - 'HOME': '/home/cltbld', 17:13:30 INFO - 'LANG': 'en_US.UTF-8', 17:13:30 INFO - 'LANGUAGE': 'en_US:en', 17:13:30 INFO - 'LOGNAME': 'cltbld', 17:13:30 INFO - 'MAIL': '/var/mail/cltbld', 17:13:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:30 INFO - 'MOZ_NO_REMOTE': '1', 17:13:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:30 INFO - 'NO_EM_RESTART': '1', 17:13:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:30 INFO - 'PWD': '/builds/slave/test', 17:13:30 INFO - 'SHELL': '/bin/bash', 17:13:30 INFO - 'SHLVL': '1', 17:13:30 INFO - 'TERM': 'linux', 17:13:30 INFO - 'TMOUT': '86400', 17:13:30 INFO - 'USER': 'cltbld', 17:13:30 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464653583.725438-1791022660', 17:13:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:30 INFO - '_': '/tools/buildbot/bin/python'} 17:13:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:13:30 INFO - Running setup.py (path:/tmp/pip-tMZPR3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:13:30 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:13:30 INFO - Running setup.py (path:/tmp/pip-rtyWyb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:13:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:13:31 INFO - Running setup.py (path:/tmp/pip-XTHK2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:13:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:13:31 INFO - Running setup.py (path:/tmp/pip-Srp25u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:13:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:13:31 INFO - Running setup.py (path:/tmp/pip-is7_Gq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:13:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:13:31 INFO - Running setup.py (path:/tmp/pip-AA3crz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:13:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:13:31 INFO - Running setup.py (path:/tmp/pip-3rkkUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:13:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:13:31 INFO - Running setup.py (path:/tmp/pip-8WtyaT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:13:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:13:31 INFO - Running setup.py (path:/tmp/pip-myHPH1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:13:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:13:31 INFO - Running setup.py (path:/tmp/pip-sjfhXH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:13:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:13:31 INFO - Running setup.py (path:/tmp/pip-amS_Ed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:13:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:13:31 INFO - Running setup.py (path:/tmp/pip-Dp4xxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:13:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:13:31 INFO - Running setup.py (path:/tmp/pip-h_bH8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:13:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:13:31 INFO - Running setup.py (path:/tmp/pip-lhyoBW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:13:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:13:31 INFO - Running setup.py (path:/tmp/pip-urQ4rZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:13:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:13:32 INFO - Running setup.py (path:/tmp/pip-GYKRNb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:13:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:13:32 INFO - Running setup.py (path:/tmp/pip-HKiHke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:13:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:13:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:13:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:13:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:13:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:13:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:13:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:13:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:33 INFO - Downloading blessings-1.6.tar.gz 17:13:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:13:34 INFO - Installing collected packages: blessings 17:13:34 INFO - Running setup.py install for blessings 17:13:34 INFO - Successfully installed blessings 17:13:34 INFO - Cleaning up... 17:13:34 INFO - Return code: 0 17:13:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:13:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:13:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:13:34 INFO - Reading from file tmpfile_stdout 17:13:34 INFO - Current package versions: 17:13:34 INFO - argparse == 1.2.1 17:13:34 INFO - blessings == 1.6 17:13:34 INFO - blobuploader == 1.2.4 17:13:34 INFO - docopt == 0.6.1 17:13:34 INFO - manifestparser == 1.1 17:13:34 INFO - mozInstall == 1.12 17:13:34 INFO - mozcrash == 0.17 17:13:34 INFO - mozdebug == 0.1 17:13:34 INFO - mozdevice == 0.48 17:13:34 INFO - mozfile == 1.2 17:13:34 INFO - mozhttpd == 0.7 17:13:34 INFO - mozinfo == 0.9 17:13:34 INFO - mozleak == 0.1 17:13:34 INFO - mozlog == 3.2 17:13:34 INFO - moznetwork == 0.27 17:13:34 INFO - mozprocess == 0.22 17:13:34 INFO - mozprofile == 0.28 17:13:34 INFO - mozrunner == 6.11 17:13:34 INFO - mozscreenshot == 0.1 17:13:34 INFO - mozsystemmonitor == 0.3 17:13:34 INFO - moztest == 0.7 17:13:34 INFO - mozversion == 1.4 17:13:34 INFO - psutil == 3.1.1 17:13:34 INFO - requests == 1.2.3 17:13:34 INFO - wsgiref == 0.1.2 17:13:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:13:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:34 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 0x7f1cd6e79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe47770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed69c0>, '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 0xed78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed7d50>, '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': 'cbe409c6de289db6ac707de3000001d4-1464653583.725438-1791022660', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:13:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:13:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:13:34 INFO - Using env: {'DISPLAY': ':0', 17:13:34 INFO - 'HOME': '/home/cltbld', 17:13:34 INFO - 'LANG': 'en_US.UTF-8', 17:13:34 INFO - 'LANGUAGE': 'en_US:en', 17:13:34 INFO - 'LOGNAME': 'cltbld', 17:13:34 INFO - 'MAIL': '/var/mail/cltbld', 17:13:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:34 INFO - 'MOZ_NO_REMOTE': '1', 17:13:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:34 INFO - 'NO_EM_RESTART': '1', 17:13:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:34 INFO - 'PWD': '/builds/slave/test', 17:13:34 INFO - 'SHELL': '/bin/bash', 17:13:34 INFO - 'SHLVL': '1', 17:13:34 INFO - 'TERM': 'linux', 17:13:34 INFO - 'TMOUT': '86400', 17:13:34 INFO - 'USER': 'cltbld', 17:13:34 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464653583.725438-1791022660', 17:13:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:34 INFO - '_': '/tools/buildbot/bin/python'} 17:13:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:13:34 INFO - Cleaning up... 17:13:34 INFO - Return code: 0 17:13:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:13:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1cd6e79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe47770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed69c0>, '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 0xed78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed7d50>, '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': 'cbe409c6de289db6ac707de3000001d4-1464653583.725438-1791022660', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:13:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:13:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:13:34 INFO - Using env: {'DISPLAY': ':0', 17:13:34 INFO - 'HOME': '/home/cltbld', 17:13:34 INFO - 'LANG': 'en_US.UTF-8', 17:13:34 INFO - 'LANGUAGE': 'en_US:en', 17:13:34 INFO - 'LOGNAME': 'cltbld', 17:13:34 INFO - 'MAIL': '/var/mail/cltbld', 17:13:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:34 INFO - 'MOZ_NO_REMOTE': '1', 17:13:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:34 INFO - 'NO_EM_RESTART': '1', 17:13:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:34 INFO - 'PWD': '/builds/slave/test', 17:13:34 INFO - 'SHELL': '/bin/bash', 17:13:34 INFO - 'SHLVL': '1', 17:13:34 INFO - 'TERM': 'linux', 17:13:34 INFO - 'TMOUT': '86400', 17:13:34 INFO - 'USER': 'cltbld', 17:13:34 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464653583.725438-1791022660', 17:13:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:34 INFO - '_': '/tools/buildbot/bin/python'} 17:13:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:34 INFO - Downloading/unpacking jsonschema 17:13:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:13:36 INFO - Downloading/unpacking functools32 (from jsonschema) 17:13:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:36 INFO - Downloading functools32-3.2.3-2.tar.gz 17:13:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:13:37 INFO - warning: no files found matching '*.txt' 17:13:37 INFO - no previously-included directories found matching 'build' 17:13:37 INFO - no previously-included directories found matching 'dist' 17:13:37 INFO - no previously-included directories found matching '.git*' 17:13:37 INFO - Installing collected packages: jsonschema, functools32 17:13:37 INFO - Running setup.py install for functools32 17:13:37 INFO - warning: no files found matching '*.txt' 17:13:37 INFO - no previously-included directories found matching 'build' 17:13:37 INFO - no previously-included directories found matching 'dist' 17:13:37 INFO - no previously-included directories found matching '.git*' 17:13:37 INFO - Successfully installed jsonschema functools32 17:13:37 INFO - Cleaning up... 17:13:37 INFO - Return code: 0 17:13:37 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:13:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1cd6e79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe47770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed69c0>, '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 0xed78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed7d50>, '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': 'cbe409c6de289db6ac707de3000001d4-1464653583.725438-1791022660', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:13:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 17:13:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 17:13:37 INFO - Using env: {'DISPLAY': ':0', 17:13:37 INFO - 'HOME': '/home/cltbld', 17:13:37 INFO - 'LANG': 'en_US.UTF-8', 17:13:37 INFO - 'LANGUAGE': 'en_US:en', 17:13:37 INFO - 'LOGNAME': 'cltbld', 17:13:37 INFO - 'MAIL': '/var/mail/cltbld', 17:13:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:37 INFO - 'MOZ_NO_REMOTE': '1', 17:13:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:37 INFO - 'NO_EM_RESTART': '1', 17:13:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:37 INFO - 'PWD': '/builds/slave/test', 17:13:37 INFO - 'SHELL': '/bin/bash', 17:13:37 INFO - 'SHLVL': '1', 17:13:37 INFO - 'TERM': 'linux', 17:13:37 INFO - 'TMOUT': '86400', 17:13:37 INFO - 'USER': 'cltbld', 17:13:37 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464653583.725438-1791022660', 17:13:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:37 INFO - '_': '/tools/buildbot/bin/python'} 17:13:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:37 INFO - Downloading/unpacking flake8 17:13:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:39 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:13:39 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:13:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:39 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:13:39 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:13:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:39 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:13:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:13:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:13:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:13:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:13:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:13:40 INFO - no previously-included directories found matching 'docs/_build' 17:13:40 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:13:40 INFO - Running setup.py install for pep8 17:13:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:13:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:13:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:13:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:13:40 INFO - no previously-included directories found matching 'docs/_build' 17:13:40 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:13:40 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:13:40 INFO - Cleaning up... 17:13:40 INFO - Return code: 0 17:13:40 INFO - Running post-action listener: _resource_record_post_action 17:13:40 INFO - Running post-action listener: _start_resource_monitoring 17:13:40 INFO - Starting resource monitoring. 17:13:40 INFO - ##### 17:13:40 INFO - ##### Finished create-virtualenv step (success) 17:13:40 INFO - ##### 17:13:40 INFO - ##### 17:13:40 INFO - ##### Running install step. 17:13:40 INFO - ##### 17:13:40 INFO - Running pre-action listener: _resource_record_pre_action 17:13:40 INFO - Running main action method: install 17:13:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:13:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:13:40 INFO - Reading from file tmpfile_stdout 17:13:40 INFO - Detecting whether we're running mozinstall >=1.0... 17:13:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:13:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:13:40 INFO - Reading from file tmpfile_stdout 17:13:40 INFO - Output received: 17:13:40 INFO - Usage: mozinstall [options] installer 17:13:40 INFO - Options: 17:13:40 INFO - -h, --help show this help message and exit 17:13:40 INFO - -d DEST, --destination=DEST 17:13:40 INFO - Directory to install application into. [default: 17:13:40 INFO - "/builds/slave/test"] 17:13:40 INFO - --app=APP Application being installed. [default: firefox] 17:13:40 INFO - mkdir: /builds/slave/test/build/application 17:13:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:13:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:13:57 INFO - Reading from file tmpfile_stdout 17:13:57 INFO - Output received: 17:13:57 INFO - /builds/slave/test/build/application/firefox/firefox 17:13:57 INFO - Running post-action listener: _resource_record_post_action 17:13:57 INFO - ##### 17:13:57 INFO - ##### Finished install step (success) 17:13:57 INFO - ##### 17:13:57 INFO - ##### 17:13:57 INFO - ##### Running run-tests step. 17:13:57 INFO - ##### 17:13:57 INFO - Running pre-action listener: _resource_record_pre_action 17:13:57 INFO - Running main action method: run_tests 17:13:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:13:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:13:57 INFO - Python 2.7.3 17:13:57 INFO - Return code: 0 17:13:57 INFO - grabbing minidump binary from tooltool 17:13:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:57 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 0xed69c0>, '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 0xed78c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed7d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:13:57 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 17:13:57 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 17:13:57 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 17:13:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:13:57 INFO - Return code: 0 17:13:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:13:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:13:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:13:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:13:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:13:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:13:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:13:58 INFO - Return code: 0 17:13:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Sqdf8GYHR3ikYm3qs3cN9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 17:13:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Sqdf8GYHR3ikYm3qs3cN9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 17:13:58 INFO - Using env: {'DISPLAY': ':0', 17:13:58 INFO - 'HOME': '/home/cltbld', 17:13:58 INFO - 'LANG': 'en_US.UTF-8', 17:13:58 INFO - 'LANGUAGE': 'en_US:en', 17:13:58 INFO - 'LOGNAME': 'cltbld', 17:13:58 INFO - 'MAIL': '/var/mail/cltbld', 17:13:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:13:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:13:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:58 INFO - 'MOZ_NO_REMOTE': '1', 17:13:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:13:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:58 INFO - 'NO_EM_RESTART': '1', 17:13:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:58 INFO - 'PWD': '/builds/slave/test', 17:13:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:13:58 INFO - 'SHELL': '/bin/bash', 17:13:58 INFO - 'SHLVL': '1', 17:13:58 INFO - 'TERM': 'linux', 17:13:58 INFO - 'TMOUT': '86400', 17:13:58 INFO - 'USER': 'cltbld', 17:13:58 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1464653583.725438-1791022660', 17:13:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:58 INFO - '_': '/tools/buildbot/bin/python'} 17:13:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Sqdf8GYHR3ikYm3qs3cN9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 17:13:58 INFO - mozversion application_buildid: 20160530143013 17:13:58 INFO - mozversion application_changeset: 8682f94befeb413bafc9e434d3cb387b1ce567d5 17:13:58 INFO - mozversion application_display_name: Nightly 17:13:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:13:58 INFO - mozversion application_name: Firefox 17:13:58 INFO - mozversion application_remotingname: firefox 17:13:58 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:13:58 INFO - mozversion application_vendor: Mozilla 17:13:58 INFO - mozversion application_version: 49.0a1 17:13:58 INFO - mozversion platform_buildid: 20160530143013 17:13:58 INFO - mozversion platform_changeset: 8682f94befeb413bafc9e434d3cb387b1ce567d5 17:13:58 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:13:58 INFO - mozversion platform_version: 49.0a1 17:13:58 INFO - using testdate: 1464653638 17:13:58 INFO - actual date: 1464653638 17:13:58 INFO - starting webserver on 'localhost:54047' 17:13:58 INFO - SUITE-START | Running 2 tests 17:13:58 INFO - TEST-START | dromaeo_css 17:13:58 INFO - operating with platform_type : linux_ 17:13:58 INFO - Initialising browser for dromaeo_css test... 17:13:58 INFO - TEST-INFO | started process 14941 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLr13_4/profile http://localhost:54047/getInfo.html) 17:14:02 INFO - PROCESS | 14941 | __metrics Screen width/height:1600/1200 17:14:02 INFO - PROCESS | 14941 | colorDepth:24 17:14:02 INFO - PROCESS | 14941 | Browser inner width/height: 1024/697 17:14:02 INFO - PROCESS | 14941 | __metrics 17:14:03 ERROR - PROCESS | 14941 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:14:04 INFO - TEST-INFO | 14941: exit 0 17:14:04 INFO - Browser initialized. 17:14:04 INFO - Running cycle 1/1 for dromaeo_css test... 17:14:04 INFO - TEST-INFO | started process 15023 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLr13_4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:14:16 INFO - PROCESS | 15023 | RSS: Main: 155578368 17:14:16 INFO - PROCESS | 15023 | 17:15:07 INFO - PROCESS | 15023 | 1464653707821 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 17:17:15 INFO - PROCESS | 15023 | Cycle 1(1): loaded http://localhost:54047/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54047/tests/dromaeo/cssquery-ext.html) 17:17:16 INFO - PROCESS | 15023 | RSS: Main: 243273728 17:17:16 INFO - PROCESS | 15023 | 17:20:19 INFO - PROCESS | 15023 | Cycle 1(1): loaded http://localhost:54047/tests/dromaeo/cssquery-ext.html (next: http://localhost:54047/tests/dromaeo/cssquery-jquery.html) 17:20:19 INFO - PROCESS | 15023 | RSS: Main: 245469184 17:20:19 INFO - PROCESS | 15023 | 17:23:21 INFO - PROCESS | 15023 | Cycle 1(1): loaded http://localhost:54047/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54047/tests/dromaeo/cssquery-mootools.html) 17:23:22 INFO - PROCESS | 15023 | RSS: Main: 244056064 17:23:22 INFO - PROCESS | 15023 | 17:26:24 INFO - PROCESS | 15023 | Cycle 1(1): loaded http://localhost:54047/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54047/tests/dromaeo/cssquery-prototype.html) 17:26:25 INFO - PROCESS | 15023 | RSS: Main: 244047872 17:26:25 INFO - PROCESS | 15023 | 17:29:27 INFO - PROCESS | 15023 | Cycle 1(1): loaded http://localhost:54047/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54047/tests/dromaeo/cssquery-yui.html) 17:29:28 INFO - PROCESS | 15023 | RSS: Main: 228392960 17:29:28 INFO - PROCESS | 15023 | 17:32:30 INFO - PROCESS | 15023 | Cycle 1(1): loaded http://localhost:54047/tests/dromaeo/cssquery-yui.html (next: http://localhost:54047/tests/dromaeo/cssquery-dojo.html) 17:32:30 INFO - PROCESS | 15023 | RSS: Main: 324825088 17:32:30 INFO - PROCESS | 15023 | 17:32:30 INFO - PROCESS | 15023 | __start_tp_report 17:32:30 INFO - PROCESS | 15023 | _x_x_mozilla_page_load 17:32:30 INFO - PROCESS | 15023 | _x_x_mozilla_page_load_details 17:32:30 INFO - PROCESS | 15023 | |i|pagename|runs| 17:32:30 INFO - PROCESS | 15023 | |0;dojo.html;3099.318150006998;3112.5331200319947;3113.1750086227153;3150.747940164787;3185.155933677576;5223.608229382802;5312;5397.541208997235;5477.78088876445;5517.641353312032;5343.385510666275;5384.488473595012;5395.568354531638;5398.190271459283;5422.701751403672;4847.854564363075;4896.43690975537;4929.876753081166;4945.381827271591;5075.416327122372;4974.0797952378925;5008.474110218429;5037.773300201481;5044.445111037783;5045.545900868921;4783.952160478403;4864.100141473838;4877.3903262092235;4907.11671899058;4972.751362431882;4841.975790121062;4859.975700121477;4862.78117484714;4884.340614017097;4943.332650092228;4887.926681099786;4893.730844803535;4905.607551395879;4907.705537667715;4917.40991081069;5175;5285.471452854684;5342.839714808562;5393;5419.214213938957;5857.560682948796;5863.442972917566;5865.824025279248;5877.4122587740885;5879;5672.035753921843;5851.23933888596;5903.0555111182;5911.497522710575;5917.526597872203;5357.303550538444;5394.271773310592;5397.8380648580605;5452.727363631802;5464.1257398816;5935.940640593625;5939.495142912814;5945.464908158287;5947.434993675594;5949.672767997802;5585.162225666182;5714.399988001283;5726.341470730836;5726.599138060379;5729.971350143306;5825.359210486843;5879.3826648202175;5933.940660593339;5934.05055191176;5934.940650593525;5782.855428614318;5840.503557197686;5845.298564172326;5854.882902342015;5855.560832937546;5648.068068768689;5684.54523638108;5736.340320863154;5832.037713777179;5843.357230704619;4367.650587952956;4375.956240437618;4379.146066516999;4414.050979039522;4414.1171765647;3861.420786881934;3884.533855937306;3887.5723670396233;3914.4911161548816;3923.156521347924;5267.446918073547;5375.113106337489;5390.4879036491475;5400.540954018874;5415.10650742631;5836.387179346192;5851.063829787214;5862.384449632812;5866.178734977107;5904.261967254093;5448.210009548593;5453.427390123979;5454.236406903036;5457.045017121988;5460.126379779295;4932.975335123301;5016.147254966664;5021.698698078127;5072.82245121419;5084.923726144111;6056.878862422727;6071.362506936708;6074.3925607438905;6075.635461872302;6079.240094988127;5913.142594323799;5925.970370148121;5928.703564821655;5930.05119180929;5933.881322373615;5741.052726300114;5971.581989260884;6010.759569617167;6030.03519436888;6053.909191362045;5723.456271654186;5778.451047150514;5782.161586570008;5786.652800831964;5788.044972579477;5821.505172060422;5879.235699359056;5880.735366908414;5882.088276317178;5900.852478687895;5536.390996990408;5590.860228494157;5620.718964051699;5657.943420565742;5674.801381951612;5653.095504719226;5661.631993920382;5662.377138514677;5662.801801936913;5664.773409063591;5573.972130139324;5574.386817450159;5574.9442505574425;5576.079946808731;5580.9441905580425;5560.749766260447;5656.123300888369;5713.085906254979;5718.79984200551;5820.679862607597;5621.7189140542;5624.6625202487985;5632.1551767233605;5638.069718496567;5652.236948011966 17:32:30 INFO - PROCESS | 15023 | |1;ext.html;581.255992329818;619.0899377914465;621.2296752027486;630.5869655375727;635.7043974551832;31795.68204317956;43018;44618.10763784722;44750.10499790006;44821.327680084825;47574.28638570424;47979;48066.27900581485;48075.759621201934;48098;8651.48091114532;8866.335024873128;8894.644214231423;8895.599698013604;8906.287497000258;8556;8770.824583508325;8771.95614021929;8774.341924355667;8778;8825.073367296438;8875.289976801872;8877.51173685447;8881.644734210624;8882.022977472472;8781.517016564087;8823.338249631302;8823.955880220621;8832.735017949472;8833.60248788806;8535.82928341436;8645.95677021611;8646.524441155734;8649.178328058824;8653.307735381217;43001.35497967533;43115.13769724588;43389.34915976263;43499.34750978706;43551.56448435538;3472.6353732858192;3573.3746594345885;3593.2274560969254;3739.607341229159;3984.4871164608426;32819.6718032819;33266.33467330664;33539;33614.159646008804;34988.47517287243;4324.848630297956;4506.278995360759;4534.614557762594;4606.9078618427775;4674.32222327764;351025;351475;352295;355042;355110;56061.43938560562;61421.38578614246;61505;61983.380166198665;62016.379836201966;64026.6798666013;64858.67570662211;65174.34825651778;70524.64737676381;70632.64683676549;14928.626784330261;15060.397584096514;15084.170370629501;15093.943423960218;15113.622159445882;11333.546658133582;11649;11699.06407487399;11704.590339338083;12095.939520302341;19447.905445989258;19494.31769888047;19505.414837554898;19529;19635.41093767189;6884.347756538395;7012.368886800213;7058.470614703815;7136.892946605805;7276.454265930077;972.3242346569067;1066.9786604267872;1077.4989629822014;1152.4007516091754;1170.7658468306372;31955;32315.51526727101;32397.19007024796;32410.245129163814;32893.17767055843;1096.555894862582;1116.3469370418234;1151.6890439581266;1159.9942000289946;1249.7500499899875;16044.598885027734;16208.351665933467;16546.917265413595;16611.920225185324;16712.331506739592;569306;570989;575231;577014.4940578849;578277;59874.40125598775;60305.39694603086;60379.09431358445;60456.39543604507;60487.39512604818;1377.8966577506726;1383.8721442024719;1384.1487485196733;1395.4627468424526;1417.978730319046;29631.407371852012;30352.46457773058;30475.238119046313;31057.844710776302;31122.53316200304;49985.75007124941;50653.49346506635;50860.74569627128;50865.745671271405;50905.74547127241;524746;524976;526903;527852.9680867589;529967;25123.623145652466;27449.725502744717;28025.859870700515;28211.858940705166;29477;46793.53206467892;48035.279470808666;48138;49023.26465103098;49043.264351035476;39955;40125;40726.38910416287;40846.59153408428;41116.1776764469;39666.60333396629;40100.3984940232;40564.39153412642;40684.79657601693;40903.1819363617;36631.633683662825;36846.44730329101;37152.81423592865;40984.18031639291;41124;33660.49509257314;35559.82220088883;36015.81992090023;36129.02580716171;36338;27261.318467038484;27518.449631006868;27592.448151036464;27686.446271074063;27709.722902770714 17:32:30 INFO - PROCESS | 15023 | |2;jquery.html;381.6946044527715;386.28729993162625;393;402.1113339519661;413.7166041261734;18887.15007824648;19013.239470421202;19200.231990720353;19485.610287794254;19493.415197544095;17736;18525.629487410242;18617.348392806256;18814.34149804757;19330.51673708158;5465.508104270615;5552.250446189773;5576.275084239043;5582.665040097607;5653.123765816305;5377.596680248997;5552.805651802188;5574.1917421973785;5575.0522411190195;5597.468240517144;5487.890242195153;5541.251930989305;5546.389897111315;5547.833564993037;5558.305211848519;5334.946650533503;5412.837614871541;5436.483534064297;5444.754986025639;5471.425500322469;4731.858044258678;4890.364252647133;4919.557239848431;4926.655134140611;4928.482509336504;22196.22313219046;22259.109635614557;22345.441363965867;22574;22747.658785118238;2313.34069790109;2344.6834677318516;2414.6015907375263;2522.4702812409414;2824.8163869348427;13973.161610303414;14094.01341906067;14147.504837330644;14242.430302787876;14762.557123286319;1898.9145488452914;1979.1588574855773;2002.1090614676475;2011.7787043425212;2018.0918586636074;53765.73117134428;65577.34422655808;65934.67032664854;74190.62904685442;76663;10087.546060427298;10411.895881041093;10681.946590267155;10720.303180293256;10926.071283940953;13160.736785264242;13662;14453.710925781636;14460.566183014527;14920.403183872524;7324.230955749569;7635.198304178092;7816.765497035098;7881.802954926058;8125.268725814705;7654.885176722353;7664.616769161631;7664.6934122635585;7852.489588176751;7888.7633370998965;6446.387593178641;6643.60138391698;6673.766418175341;6761.594304341756;6772.356626120511;1850.6298740252003;1890.3383815664408;1908.1985566062287;1908.6278175755594;1909.1408866010352;446.7297285142507;453.7640426977953;456.8149899290793;470.2660872671049;890.8797312362877;11915;11960.521579136912;12106.576269830513;12175.904168624866;12184.268943863219;464.54706661005923;469.96710230284236;478.6123240175469;484.5154845154845;488.2261615339655;6432.6462044588;6491.545591808528;6495.6752162391695;6519.576227545194;6566.606003639797;469957;480065;481392;481474;484651;79262;96466;96538;97236;98526;430.03457238499766;439.5275079289776;442.3497458735653;445.52106485528185;927.8051609162152;16435.342586296894;17057;17269.22288497046;17492.300307988047;17849.553761156076;39210.2157956845;39487.2102557953;40384.79807600943;40709.389359159046;42455.36316955186;55641.443585563626;56067;57873.71063144657;58074;58723.825523488435;8368.832623347376;8497.2777313929;8719.956400217958;8756.78108047304;8896.421732587361;9711.368761030793;12993.48026078984;13307.80038299407;13404.994625402938;13523.59429217125;11517.136214783757;11601.883981160081;11817.468213930566;11902.702432439259;12027.338496382783;11487.36819474937;11519.30884146954;11548.307101573933;11703;11766.470508826953;11742.236754610924;11786.46960886745;11954;11972;12100.394980251129;8562.52906090171;8582.09887961755;8635.438696484709;8647.82704345897;8667.566621668766;8784.165504277084;11052.226344155832;11610.477528511068;11666.76666466649;11782.528698852293 17:32:30 INFO - PROCESS | 15023 | |3;mootools.html;1329.282187618686;1502.1587910769965;1541.7841502189694;1668.424393584213;1819.7634307540009;8645.827083458327;9022.639094436223;9033.638654453822;9232.44605323681;9241.399309044908;8949.731508054752;9044.186023257906;9044.412113212653;9054.275657947364;9170.220531254834;2091.8744875307452;2357.222116701493;2407.386116540284;2420.044082587377;2434.6226334918115;2443.2548072837776;2447.7185123710824;2454.3741345956755;2454.582720937436;2456.8894399752053;2362.7400985891536;2402.7116745990506;2402.95194096118;2407.0853075831246;2408.217329367954;2080.583883223354;2346.6949296591333;2418.6492958521094;2428.562858685436;2442.6091825307867;2275.374272075176;2287.965680514794;2291.7593652666565;2293.598620241451;2303.9424014399606;8960.05919378469;8967.820643587156;8971.865422018675;9006.05436429172;9009.504477253748;5199.090159222159;5358.223057656618;5396.028714831329;5404.216388623628;5407.026735187704;3360.9831950840335;3453.6546345365264;3462.151772815651;3484.8780292689635;3551.094470909927;1096.0792933935531;1109.938953357565;1133.926294790836;1139.8632164140274;1190.2263528706324;12457.937710311391;12479.188852724634;12488.562900298446;12505.49978000879;12505.687357816036;4595.517470665532;4721.362616046858;4837.443693975168;4838.782254798542;4854.077725232195;10459.163266938627;10475.476226188812;10475.685729428129;10477.68566942993;10484.685459436228;4752.52474752522;5214.504622060898;5237.711925844115;5270.92093618596;5271.762770675329;4867.294242334841;5007.774650140753;5019.598432125421;5035.471275516018;5043.546080852668;4131.29767939451;4153.210889930903;4171.478565179353;4190.476190476191;4207.810648520824;1302.6547964789338;1306.79744639581;1317.9341032948314;1322.9784383296567;1328.634625477982;854.8589482735279;936.5317341329335;949.3307218411004;950.9429434233969;963.9518024098767;6137.447629713258;6153.138560601519;6193.907091393633;6213.596116252429;6268.404501572434;974.3812678948776;1006.7936073104996;1019.8827134879435;1025.738436698637;1044.5299615173203;4113.794310284474;4278.764667943231;4318.481782186158;4335.089631177425;4359.585839345257;11193.776124477465;11372.48823802931;11477.827832582518;11563.306201627762;11574.305541667527;10686.946565267124;11115.555377784798;11117.499712512956;11446.255993360404;11475.311481311148;8318.584070796436;8455.66177352899;8483.236508714246;8488.98132224137;8578.699745508877;6123.908141377794;6270.498360131087;6342.39747224013;6350.142730731292;6426.325235850169;10394.324368915995;10529.157667386438;10580.629677961235;10650.520726567478;10663.253572249869;9591.376560523544;9928.851067233853;9963.850542241727;10100.696979090639;10199.235057370579;7202.747903823341;7423.331900129015;7440.3675687567165;8016.238457346542;8173.141820108803;8088.029436467662;8411.369147313853;8671.696490622799;8673.956630216808;8919.55402229899;7732;7746.186650401852;7816.335611473089;8032.437729358889;8060.798480038046;7563.130240022468;7706.499077559941;7760.805979850549;7788.688452461838;8049.074356449083;6998.370146686822;7054.682539285642;7194.676239569337;7196.388306993755;7210.134783825974;5274.340707411574;5297.099493086262;5307.230451584576;5326.493983071602;5511.862203444946;4858.95141048585;4913.3121363008495;4941.925871112008;4985.601151907911;5007.874803129951 17:32:30 INFO - PROCESS | 15023 | |4;prototype.html;304.08470503783604;317.5126181311686;318.3267389471266;320.2793714143178;326.3831358731996;5177.611679124071;5283.547024568241;5288.101022826119;5316.670832291932;5353.143497040474;5212.817551385702;5214.530692237698;5222.712750798704;5224.582033437326;5226.477352264781;4009.518857737061;4019.9397009044887;4023.8994025149314;4023.9396409053743;4063.918721625573;3953.98023009886;4017.1363156921257;4030.6976976726714;4036.555978842325;4048.1903619276113;4006.258842114218;4011.8194681239415;4034.7780872052026;4040.151568170688;4046.5751096134923;3964.940525892114;4003.6396724294955;4005.6967243834765;4010.1779135277197;4010.739301945379;3522.295540891832;3524.859005639771;3534.734894882894;3535.840887160084;3559.697425718817;4832.540908613676;5024.698518088926;5046.26829109777;5082.542571168576;5125.38495380553;4612.815487380501;4626.8149274029;4628.421447319085;4629.907401851944;4663.207254766698;5389.461053894579;5426.62013659044;5433.266509021271;5453.836384908459;5457.317835270591;3598.46023096535;3761.736678432511;3786.8106594670157;3964.603539646041;3970.344893092636;5423.349198096214;5468.91796623051;5707;5710.971445142748;5747.798827041075;3812.8856134316015;3813.790241536742;3825.84696612138;3828.9617103829164;3838.596947320547;3776;3896.7467114638025;3926;3942.2706799242233;3970.7021973351534;4554.493040358905;4566.657500687462;4576.565226303496;4586.793594288265;4593.701409408378;5496.725163741877;5508.705454218256;5510.925369552979;5520.972395138079;5528.778848846082;1355.6814148675053;1358.565259117073;1378.3246209357342;1380.8135901653147;1383.4397069186793;840.2018082821344;847.4406891451613;853.2534032721369;856.9485830850169;860;4638.420197475316;4723.567362808157;4791.760411979457;4844.806207751721;4865.245886887538;4961.454240033666;4968.503149685002;5041.369828771403;5041.924371134436;5081.8729531762;4541.069080838421;4665.650076244296;4667.95332046682;4725.448257940742;4735.195016847144;2689.713743318203;2695.528282550585;2707.9303675048245;2733.3986522964915;2740.7670348020642;5203.635745497779;5207.7916883325;5213.218017297359;5222.764975576109;5240.2969035063;4871.0910695029625;5043.193089105799;5157.948420515821;5172.8965420691375;5185.248139019821;5169.983706354449;5179.81870634526;5189.4032186299055;5190.870228244248;5216.243644671501;5044.470330615232;5069.264956581349;5081.85658226896;5083.440821509705;5117.488251174853;5334.813281535127;5411.675299482044;5543.450012994068;5553.194786755817;5572.969000734877;5803.767849285981;5823.505002074701;5834.299884013945;5851.180834683063;5889.764409423575;3789.829457674356;3985.003749062734;3996.2806694794053;4015.257177422186;4015.819288131983;5656.773729050792;5673.659580425187;5678.375378708256;5695.092144131597;5705.885882282248;5547.1679248113105;5557.694326811902;5558.861028474321;5600.327960644749;5608.85977850557;5271.604629652868;5495.774211444372;5503.449655034465;5515.145152501369;5534.778608855761;5335.786568537215;5366.973165134149;5391.838244852661;5398.568114550905;5400.729963501731;5471.644343117685;5504.724763761716;5506.5870059744875;5523;5550.888982220414;5268.57851371897;5439.809606663748;5454.781808727606;5457.735039958373;5464.644798088111 17:32:30 INFO - PROCESS | 15023 | |5;yui.html;824.5629816197415;835.9749207523777;850.51520633239;857.1300130367678;891.1578558262437;14668.119912805227;15407.306671199794;15449.613759656015;15469.458568950075;15493.612659683513;14127.22300273487;14696;14698.779518307234;15056.849431505681;15074.246287685626;688.9483288753338;705.7424040225333;810.6959890041235;822.8313195794863;823.6046697585163;825.5211977053325;828.5981299069977;828.6519661742053;830.2652152844746;831.40969911363;856.0497847389393;858.6307887608326;858.995705021474;863.1282404771164;863.3740538109882;702.3819039245457;721.163450397539;848.6350869126273;854.3677678517884;872.2498651159997;623.8190924631851;628.2178687534004;628.2774808969675;628.5882746800853;628.9213848268967;14656.853431465763;14661;14677.045992010591;14677.633059173499;14695.191764452951;13914.860851391457;13919.791203131961;13948.860511394858;14009.71980560383;14304.427822887175;10564.841527377095;10944.945275273652;11168.106551475863;11181.273217240854;11214.66356009321;3784.3188226119287;3821.426785982097;3844.2888065707934;3851.84592616295;3941.881743547698;58503;58615;58660.41339586592;58698;58927.705361472916;10548.894511054945;10854.403007834644;10937.45312734376;10953.290639321294;11010.339379637087;19670.40988770339;19684.60630787376;19725.11236994339;19729.40811775649;19741.605167896563;8177.836443271221;8341.165883411732;8461.069282378934;8511.191436813493;8793.38446308765;4329.372241025034;4344.348347747863;4357.716748411343;4394.538573449806;4415.448068991376;3314.6022477302877;3336.9165770855925;3383.983080084584;3389.9491507627404;3398.6261511233743;652.0349882174409;654.630133974303;654.7577396363281;655.8950567909208;673.7170388436869;572.7737543670227;695.6486974078058;703.0824773670307;722.9421646268286;741.4439170622034;8817.559122043873;8834.779130521789;8868.113188681209;8898.154675305836;9086.182243598108;641.4611726150056;675.6891829758268;691.9240580896653;726.8509955459118;728.7376544443996;4337.1976184405985;4363.345498175236;4455.977720111444;4475.26158183896;4492.528284530143;66800.6659966697;70330.64834675896;70446.29553704499;71293.2870671297;71766.64116679384;55442;56108.43891561032;60822.39177608256;61071;63317.36682633115;56626.43373566294;57480.71259643675;57559.42440575541;57636;59074.11388829171;9393.389429687048;9487.193588544775;9520.428774273565;9543.066706313863;9689.27330450205;37475;37609;38188;38295.617043830316;39345;51048.744756275984;51135.232971504716;51657.7417112912;51761.22358164555;52665.36673166403;11321.377324247245;11411.60059397917;11419.37193454368;11775.823362649397;12141;13208.207507549578;13284.734305314032;13587.116837405538;13770.862291376958;13799;12188.939055305022;12370.13409061357;12493.93753031229;12788.552400665933;12864.356782161041;12348;12459.127861050001;12481.375931203585;12560.434780435085;12685.746285074063;12544.498220071095;12813.679658008625;12932.870671293544;13094.279814609907;13274.402651880495;11021.283616564897;11113.333200008025;11297.604583839526;11325.660230193107;11398.943005285253;10224.969245404456;11063.336199828036;11253.66239012831;11293.548258069584;11438.256513326607 17:32:30 INFO - PROCESS | 15023 | __end_tp_report 17:32:30 INFO - PROCESS | 15023 | __start_cc_report 17:32:30 INFO - PROCESS | 15023 | _x_x_mozilla_cycle_collect,1020 17:32:30 INFO - PROCESS | 15023 | __end_cc_report 17:32:30 INFO - PROCESS | 15023 | __startTimestamp1464654750979__endTimestamp 17:32:30 INFO - PROCESS | 15023 | 17:32:30 INFO - PROCESS | 15023 | ------- Summary: start ------- 17:32:30 INFO - PROCESS | 15023 | Number of tests: 6 17:32:30 INFO - PROCESS | 15023 | 17:32:30 INFO - PROCESS | 15023 | [#0] dojo.html Cycles:165 Average:5390.77 Median:5585.16 stddev:631.60 (11.3%) stddev-sans-first:607.41 17:32:30 INFO - PROCESS | 15023 | Values: 3099.3 3112.5 3113.2 3150.7 3185.2 5223.6 5312.0 5397.5 5477.8 5517.6 5343.4 5384.5 5395.6 5398.2 5422.7 4847.9 4896.4 4929.9 4945.4 5075.4 4974.1 5008.5 5037.8 5044.4 5045.5 4784.0 4864.1 4877.4 4907.1 4972.8 4842.0 4860.0 4862.8 4884.3 4943.3 4887.9 4893.7 4905.6 4907.7 4917.4 5175.0 5285.5 5342.8 5393.0 5419.2 5857.6 5863.4 5865.8 5877.4 5879.0 5672.0 5851.2 5903.1 5911.5 5917.5 5357.3 5394.3 5397.8 5452.7 5464.1 5935.9 5939.5 5945.5 5947.4 5949.7 5585.2 5714.4 5726.3 5726.6 5730.0 5825.4 5879.4 5933.9 5934.1 5934.9 5782.9 5840.5 5845.3 5854.9 5855.6 5648.1 5684.5 5736.3 5832.0 5843.4 4367.7 4376.0 4379.1 4414.1 4414.1 3861.4 3884.5 3887.6 3914.5 3923.2 5267.4 5375.1 5390.5 5400.5 5415.1 5836.4 5851.1 5862.4 5866.2 5904.3 5448.2 5453.4 5454.2 5457.0 5460.1 4933.0 5016.1 5021.7 5072.8 5084.9 6056.9 6071.4 6074.4 6075.6 6079.2 5913.1 5926.0 5928.7 5930.1 5933.9 5741.1 5971.6 6010.8 6030.0 6053.9 5723.5 5778.5 5782.2 5786.7 5788.0 5821.5 5879.2 5880.7 5882.1 5900.9 5536.4 5590.9 5620.7 5657.9 5674.8 5653.1 5661.6 5662.4 5662.8 5664.8 5574.0 5574.4 5574.9 5576.1 5580.9 5560.7 5656.1 5713.1 5718.8 5820.7 5621.7 5624.7 5632.2 5638.1 5652.2 17:32:30 INFO - PROCESS | 15023 | 17:32:30 INFO - PROCESS | 15023 | [#1] ext.html Cycles:180 Average:64078.74 Median:43009.68 stddev:131481.92 (305.7%) stddev-sans-first:131764.33 17:32:30 INFO - PROCESS | 15023 | Values: 581.3 619.1 621.2 630.6 635.7 31795.7 43018.0 44618.1 44750.1 44821.3 47574.3 47979.0 48066.3 48075.8 48098.0 8651.5 8866.3 8894.6 8895.6 8906.3 8556.0 8770.8 8772.0 8774.3 8778.0 8825.1 8875.3 8877.5 8881.6 8882.0 8781.5 8823.3 8824.0 8832.7 8833.6 8535.8 8646.0 8646.5 8649.2 8653.3 43001.4 43115.1 43389.3 43499.3 43551.6 3472.6 3573.4 3593.2 3739.6 3984.5 32819.7 33266.3 33539.0 33614.2 34988.5 4324.8 4506.3 4534.6 4606.9 4674.3 351025.0 351475.0 352295.0 355042.0 355110.0 56061.4 61421.4 61505.0 61983.4 62016.4 64026.7 64858.7 65174.3 70524.6 70632.6 14928.6 15060.4 15084.2 15093.9 15113.6 11333.5 11649.0 11699.1 11704.6 12095.9 19447.9 19494.3 19505.4 19529.0 19635.4 6884.3 7012.4 7058.5 7136.9 7276.5 972.3 1067.0 1077.5 1152.4 1170.8 31955.0 32315.5 32397.2 32410.2 32893.2 1096.6 1116.3 1151.7 1160.0 1249.8 16044.6 16208.4 16546.9 16611.9 16712.3 569306.0 570989.0 575231.0 577014.5 578277.0 59874.4 60305.4 60379.1 60456.4 60487.4 1377.9 1383.9 1384.1 1395.5 1418.0 29631.4 30352.5 30475.2 31057.8 31122.5 49985.8 50653.5 50860.7 50865.7 50905.7 524746.0 524976.0 526903.0 527853.0 529967.0 25123.6 27449.7 28025.9 28211.9 29477.0 46793.5 48035.3 48138.0 49023.3 49043.3 39955.0 40125.0 40726.4 40846.6 41116.2 39666.6 40100.4 40564.4 40684.8 40903.2 36631.6 36846.4 37152.8 40984.2 41124.0 33660.5 35559.8 36015.8 36129.0 36338.0 27261.3 27518.4 27592.4 27686.4 27709.7 17:32:30 INFO - PROCESS | 15023 | 17:32:30 INFO - PROCESS | 15023 | [#2] jquery.html Cycles:180 Average:27960.45 Median:443.94 stddev:79015.51 (17798.9%) stddev-sans-first:79210.04 17:32:30 INFO - PROCESS | 15023 | Values: 381.7 386.3 393.0 402.1 413.7 18887.2 19013.2 19200.2 19485.6 19493.4 17736.0 18525.6 18617.3 18814.3 19330.5 5465.5 5552.3 5576.3 5582.7 5653.1 5377.6 5552.8 5574.2 5575.1 5597.5 5487.9 5541.3 5546.4 5547.8 5558.3 5334.9 5412.8 5436.5 5444.8 5471.4 4731.9 4890.4 4919.6 4926.7 4928.5 22196.2 22259.1 22345.4 22574.0 22747.7 2313.3 2344.7 2414.6 2522.5 2824.8 13973.2 14094.0 14147.5 14242.4 14762.6 1898.9 1979.2 2002.1 2011.8 2018.1 53765.7 65577.3 65934.7 74190.6 76663.0 10087.5 10411.9 10681.9 10720.3 10926.1 13160.7 13662.0 14453.7 14460.6 14920.4 7324.2 7635.2 7816.8 7881.8 8125.3 7654.9 7664.6 7664.7 7852.5 7888.8 6446.4 6643.6 6673.8 6761.6 6772.4 1850.6 1890.3 1908.2 1908.6 1909.1 446.7 453.8 456.8 470.3 890.9 11915.0 11960.5 12106.6 12175.9 12184.3 464.5 470.0 478.6 484.5 488.2 6432.6 6491.5 6495.7 6519.6 6566.6 469957.0 480065.0 481392.0 481474.0 484651.0 79262.0 96466.0 96538.0 97236.0 98526.0 430.0 439.5 442.3 445.5 927.8 16435.3 17057.0 17269.2 17492.3 17849.6 39210.2 39487.2 40384.8 40709.4 42455.4 55641.4 56067.0 57873.7 58074.0 58723.8 8368.8 8497.3 8720.0 8756.8 8896.4 9711.4 12993.5 13307.8 13405.0 13523.6 11517.1 11601.9 11817.5 11902.7 12027.3 11487.4 11519.3 11548.3 11703.0 11766.5 11742.2 11786.5 11954.0 11972.0 12100.4 8562.5 8582.1 8635.4 8647.8 8667.6 8784.2 11052.2 11610.5 11666.8 11782.5 17:32:30 INFO - PROCESS | 15023 | 17:32:30 INFO - PROCESS | 15023 | [#3] mootools.html Cycles:180 Average:5926.74 Median:4846.43 stddev:3367.43 (69.5%) stddev-sans-first:3359.14 17:32:30 INFO - PROCESS | 15023 | Values: 1329.3 1502.2 1541.8 1668.4 1819.8 8645.8 9022.6 9033.6 9232.4 9241.4 8949.7 9044.2 9044.4 9054.3 9170.2 2091.9 2357.2 2407.4 2420.0 2434.6 2443.3 2447.7 2454.4 2454.6 2456.9 2362.7 2402.7 2403.0 2407.1 2408.2 2080.6 2346.7 2418.6 2428.6 2442.6 2275.4 2288.0 2291.8 2293.6 2303.9 8960.1 8967.8 8971.9 9006.1 9009.5 5199.1 5358.2 5396.0 5404.2 5407.0 3361.0 3453.7 3462.2 3484.9 3551.1 1096.1 1109.9 1133.9 1139.9 1190.2 12457.9 12479.2 12488.6 12505.5 12505.7 4595.5 4721.4 4837.4 4838.8 4854.1 10459.2 10475.5 10475.7 10477.7 10484.7 4752.5 5214.5 5237.7 5270.9 5271.8 4867.3 5007.8 5019.6 5035.5 5043.5 4131.3 4153.2 4171.5 4190.5 4207.8 1302.7 1306.8 1317.9 1323.0 1328.6 854.9 936.5 949.3 950.9 964.0 6137.4 6153.1 6193.9 6213.6 6268.4 974.4 1006.8 1019.9 1025.7 1044.5 4113.8 4278.8 4318.5 4335.1 4359.6 11193.8 11372.5 11477.8 11563.3 11574.3 10686.9 11115.6 11117.5 11446.3 11475.3 8318.6 8455.7 8483.2 8489.0 8578.7 6123.9 6270.5 6342.4 6350.1 6426.3 10394.3 10529.2 10580.6 10650.5 10663.3 9591.4 9928.9 9963.9 10100.7 10199.2 7202.7 7423.3 7440.4 8016.2 8173.1 8088.0 8411.4 8671.7 8674.0 8919.6 7732.0 7746.2 7816.3 8032.4 8060.8 7563.1 7706.5 7760.8 7788.7 8049.1 6998.4 7054.7 7194.7 7196.4 7210.1 5274.3 5297.1 5307.2 5326.5 5511.9 4859.0 4913.3 4941.9 4985.6 5007.9 17:32:30 INFO - PROCESS | 15023 | 17:32:30 INFO - PROCESS | 15023 | [#4] prototype.html Cycles:180 Average:4473.30 Median:5075.56 stddev:1324.44 (26.1%) stddev-sans-first:1290.66 17:32:30 INFO - PROCESS | 15023 | Values: 304.1 317.5 318.3 320.3 326.4 5177.6 5283.5 5288.1 5316.7 5353.1 5212.8 5214.5 5222.7 5224.6 5226.5 4009.5 4019.9 4023.9 4023.9 4063.9 3954.0 4017.1 4030.7 4036.6 4048.2 4006.3 4011.8 4034.8 4040.2 4046.6 3964.9 4003.6 4005.7 4010.2 4010.7 3522.3 3524.9 3534.7 3535.8 3559.7 4832.5 5024.7 5046.3 5082.5 5125.4 4612.8 4626.8 4628.4 4629.9 4663.2 5389.5 5426.6 5433.3 5453.8 5457.3 3598.5 3761.7 3786.8 3964.6 3970.3 5423.3 5468.9 5707.0 5711.0 5747.8 3812.9 3813.8 3825.8 3829.0 3838.6 3776.0 3896.7 3926.0 3942.3 3970.7 4554.5 4566.7 4576.6 4586.8 4593.7 5496.7 5508.7 5510.9 5521.0 5528.8 1355.7 1358.6 1378.3 1380.8 1383.4 840.2 847.4 853.3 856.9 860.0 4638.4 4723.6 4791.8 4844.8 4865.2 4961.5 4968.5 5041.4 5041.9 5081.9 4541.1 4665.7 4668.0 4725.4 4735.2 2689.7 2695.5 2707.9 2733.4 2740.8 5203.6 5207.8 5213.2 5222.8 5240.3 4871.1 5043.2 5157.9 5172.9 5185.2 5170.0 5179.8 5189.4 5190.9 5216.2 5044.5 5069.3 5081.9 5083.4 5117.5 5334.8 5411.7 5543.5 5553.2 5573.0 5803.8 5823.5 5834.3 5851.2 5889.8 3789.8 3985.0 3996.3 4015.3 4015.8 5656.8 5673.7 5678.4 5695.1 5705.9 5547.2 5557.7 5558.9 5600.3 5608.9 5271.6 5495.8 5503.4 5515.1 5534.8 5335.8 5367.0 5391.8 5398.6 5400.7 5471.6 5504.7 5506.6 5523.0 5550.9 5268.6 5439.8 5454.8 5457.7 5464.6 17:32:30 INFO - PROCESS | 15023 | 17:32:31 INFO - PROCESS | 15023 | [#5] yui.html Cycles:180 Average:15862.70 Median:4404.99 stddev:19159.71 (435.0%) stddev-sans-first:19180.17 17:32:31 INFO - PROCESS | 15023 | Values: 824.6 836.0 850.5 857.1 891.2 14668.1 15407.3 15449.6 15469.5 15493.6 14127.2 14696.0 14698.8 15056.8 15074.2 688.9 705.7 810.7 822.8 823.6 825.5 828.6 828.7 830.3 831.4 856.0 858.6 859.0 863.1 863.4 702.4 721.2 848.6 854.4 872.2 623.8 628.2 628.3 628.6 628.9 14656.9 14661.0 14677.0 14677.6 14695.2 13914.9 13919.8 13948.9 14009.7 14304.4 10564.8 10944.9 11168.1 11181.3 11214.7 3784.3 3821.4 3844.3 3851.8 3941.9 58503.0 58615.0 58660.4 58698.0 58927.7 10548.9 10854.4 10937.5 10953.3 11010.3 19670.4 19684.6 19725.1 19729.4 19741.6 8177.8 8341.2 8461.1 8511.2 8793.4 4329.4 4344.3 4357.7 4394.5 4415.4 3314.6 3336.9 3384.0 3389.9 3398.6 652.0 654.6 654.8 655.9 673.7 572.8 695.6 703.1 722.9 741.4 8817.6 8834.8 8868.1 8898.2 9086.2 641.5 675.7 691.9 726.9 728.7 4337.2 4363.3 4456.0 4475.3 4492.5 66800.7 70330.6 70446.3 71293.3 71766.6 55442.0 56108.4 60822.4 61071.0 63317.4 56626.4 57480.7 57559.4 57636.0 59074.1 9393.4 9487.2 9520.4 9543.1 9689.3 37475.0 37609.0 38188.0 38295.6 39345.0 51048.7 51135.2 51657.7 51761.2 52665.4 11321.4 11411.6 11419.4 11775.8 12141.0 13208.2 13284.7 13587.1 13770.9 13799.0 12188.9 12370.1 12493.9 12788.6 12864.4 12348.0 12459.1 12481.4 12560.4 12685.7 12544.5 12813.7 12932.9 13094.3 13274.4 11021.3 11113.3 11297.6 11325.7 11398.9 10225.0 11063.3 11253.7 11293.5 11438.3 17:32:31 INFO - PROCESS | 15023 | -------- Summary: end -------- 17:32:31 INFO - PROCESS | 15023 | 17:32:31 INFO - TEST-INFO | 15023: exit 0 17:32:31 INFO - TEST-OK | dromaeo_css | took 1113231ms 17:32:31 INFO - TEST-START | kraken 17:32:31 INFO - operating with platform_type : linux_ 17:32:31 INFO - Initialising browser for kraken test... 17:32:31 INFO - TEST-INFO | started process 15201 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3qgpBX/profile http://localhost:54047/getInfo.html) 17:32:36 INFO - PROCESS | 15201 | __metrics Screen width/height:1600/1200 17:32:36 INFO - PROCESS | 15201 | colorDepth:24 17:32:36 INFO - PROCESS | 15201 | Browser inner width/height: 1024/697 17:32:36 INFO - PROCESS | 15201 | __metrics 17:32:37 ERROR - PROCESS | 15201 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:32:37 INFO - TEST-INFO | 15201: exit 0 17:32:37 INFO - Browser initialized. 17:32:37 INFO - Running cycle 1/1 for kraken test... 17:32:37 INFO - TEST-INFO | started process 15282 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3qgpBX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:32:49 INFO - PROCESS | 15282 | RSS: Main: 155566080 17:32:49 INFO - PROCESS | 15282 | 17:32:52 INFO - PROCESS | 15282 | Cycle 1(1): loaded http://localhost:54047/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54047/tests/kraken/driver.html?testName=audio-beat-detection) 17:32:53 INFO - PROCESS | 15282 | RSS: Main: 213618688 17:32:53 INFO - PROCESS | 15282 | 17:32:55 INFO - PROCESS | 15282 | Cycle 1(1): loaded http://localhost:54047/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54047/tests/kraken/driver.html?testName=audio-dft) 17:32:56 INFO - PROCESS | 15282 | RSS: Main: 197554176 17:32:56 INFO - PROCESS | 15282 | 17:32:59 INFO - PROCESS | 15282 | Cycle 1(1): loaded http://localhost:54047/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54047/tests/kraken/driver.html?testName=audio-fft) 17:33:00 INFO - PROCESS | 15282 | RSS: Main: 268574720 17:33:00 INFO - PROCESS | 15282 | 17:33:02 INFO - PROCESS | 15282 | Cycle 1(1): loaded http://localhost:54047/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54047/tests/kraken/driver.html?testName=audio-oscillator) 17:33:02 INFO - PROCESS | 15282 | RSS: Main: 179769344 17:33:02 INFO - PROCESS | 15282 | 17:33:04 INFO - PROCESS | 15282 | Cycle 1(1): loaded http://localhost:54047/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54047/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:33:05 INFO - PROCESS | 15282 | RSS: Main: 183615488 17:33:05 INFO - PROCESS | 15282 | 17:33:08 INFO - PROCESS | 15282 | Cycle 1(1): loaded http://localhost:54047/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54047/tests/kraken/driver.html?testName=imaging-darkroom) 17:33:09 INFO - PROCESS | 15282 | RSS: Main: 217337856 17:33:09 INFO - PROCESS | 15282 | 17:33:12 INFO - PROCESS | 15282 | Cycle 1(1): loaded http://localhost:54047/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54047/tests/kraken/driver.html?testName=imaging-desaturate) 17:33:13 INFO - PROCESS | 15282 | RSS: Main: 220082176 17:33:13 INFO - PROCESS | 15282 | 17:33:16 INFO - PROCESS | 15282 | Cycle 1(1): loaded http://localhost:54047/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54047/tests/kraken/driver.html?testName=json-parse-financial) 17:33:16 INFO - PROCESS | 15282 | RSS: Main: 220131328 17:33:16 INFO - PROCESS | 15282 | 17:33:18 INFO - PROCESS | 15282 | Cycle 1(1): loaded http://localhost:54047/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54047/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:33:18 INFO - PROCESS | 15282 | RSS: Main: 208900096 17:33:18 INFO - PROCESS | 15282 | 17:33:20 INFO - PROCESS | 15282 | Cycle 1(1): loaded http://localhost:54047/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54047/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:33:21 INFO - PROCESS | 15282 | RSS: Main: 211329024 17:33:21 INFO - PROCESS | 15282 | 17:33:23 INFO - PROCESS | 15282 | Cycle 1(1): loaded http://localhost:54047/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54047/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:33:23 INFO - PROCESS | 15282 | RSS: Main: 215822336 17:33:23 INFO - PROCESS | 15282 | 17:33:26 INFO - PROCESS | 15282 | Cycle 1(1): loaded http://localhost:54047/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54047/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:33:26 INFO - PROCESS | 15282 | RSS: Main: 222535680 17:33:26 INFO - PROCESS | 15282 | 17:33:29 INFO - PROCESS | 15282 | Cycle 1(1): loaded http://localhost:54047/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54047/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:33:30 INFO - PROCESS | 15282 | RSS: Main: 220008448 17:33:30 INFO - PROCESS | 15282 | 17:33:32 INFO - PROCESS | 15282 | Cycle 1(1): loaded http://localhost:54047/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54047/tests/kraken/driver.html?testName=ai-astar) 17:33:32 INFO - PROCESS | 15282 | RSS: Main: 262287360 17:33:32 INFO - PROCESS | 15282 | 17:33:32 INFO - PROCESS | 15282 | __start_tp_report 17:33:32 INFO - PROCESS | 15282 | _x_x_mozilla_page_load 17:33:32 INFO - PROCESS | 15282 | _x_x_mozilla_page_load_details 17:33:32 INFO - PROCESS | 15282 | |i|pagename|runs| 17:33:32 INFO - PROCESS | 15282 | |0;ai-astar;110;106;109;110;111;110;110;110;108;110 17:33:32 INFO - PROCESS | 15282 | |1;audio-beat-detection;152;125;127;178;125;126;156;126;164;123 17:33:32 INFO - PROCESS | 15282 | |2;audio-dft;163;160;160;160;159;160;160;160;161;161 17:33:32 INFO - PROCESS | 15282 | |3;audio-fft;74;74;74;119;74;74;72;74;105;75 17:33:32 INFO - PROCESS | 15282 | |4;audio-oscillator;83;82;114;83;83;83;113;83;83;134 17:33:32 INFO - PROCESS | 15282 | |5;imaging-gaussian-blur;117;117;117;118;116;117;116;116;117;116 17:33:32 INFO - PROCESS | 15282 | |6;imaging-darkroom;146;145;145;145;146;146;145;145;146;145 17:33:32 INFO - PROCESS | 15282 | |7;imaging-desaturate;95;95;96;95;95;95;95;94;95;94 17:33:32 INFO - PROCESS | 15282 | |8;json-parse-financial;53;54;54;53;54;57;54;53;54;54 17:33:32 INFO - PROCESS | 15282 | |9;json-stringify-tinderbox;62;62;63;62;63;62;62;62;65;62 17:33:32 INFO - PROCESS | 15282 | |10;stanford-crypto-aes;78;83;81;79;79;79;80;79;108;84 17:33:32 INFO - PROCESS | 15282 | |11;stanford-crypto-ccm;117;119;118;117;117;117;119;119;126;124 17:33:32 INFO - PROCESS | 15282 | |12;stanford-crypto-pbkdf2;172;161;163;157;159;163;165;161;160;159 17:33:32 INFO - PROCESS | 15282 | |13;stanford-crypto-sha256-iterative;61;63;64;63;62;63;64;71;61;60 17:33:32 INFO - PROCESS | 15282 | __end_tp_report 17:33:32 INFO - PROCESS | 15282 | __start_cc_report 17:33:32 INFO - PROCESS | 15282 | _x_x_mozilla_cycle_collect,1602 17:33:32 INFO - PROCESS | 15282 | __end_cc_report 17:33:32 INFO - PROCESS | 15282 | __startTimestamp1464654812254__endTimestamp 17:33:32 INFO - PROCESS | 15282 | 17:33:32 INFO - PROCESS | 15282 | ------- Summary: start ------- 17:33:32 INFO - PROCESS | 15282 | Number of tests: 14 17:33:32 INFO - PROCESS | 15282 | 17:33:32 INFO - PROCESS | 15282 | [#0] ai-astar Cycles:10 Average:109.40 Median:110.00 stddev:1.43 (1.3%) stddev-sans-first:1.50 17:33:32 INFO - PROCESS | 15282 | Values: 110.0 106.0 109.0 110.0 111.0 110.0 110.0 110.0 108.0 110.0 17:33:32 INFO - PROCESS | 15282 | 17:33:32 INFO - PROCESS | 15282 | [#1] audio-beat-detection Cycles:10 Average:140.20 Median:139.50 stddev:20.33 (14.6%) stddev-sans-first:21.11 17:33:32 INFO - PROCESS | 15282 | Values: 152.0 125.0 127.0 178.0 125.0 126.0 156.0 126.0 164.0 123.0 17:33:32 INFO - PROCESS | 15282 | 17:33:32 INFO - PROCESS | 15282 | [#2] audio-dft Cycles:10 Average:160.40 Median:160.00 stddev:1.07 (0.7%) stddev-sans-first:0.60 17:33:32 INFO - PROCESS | 15282 | Values: 163.0 160.0 160.0 160.0 159.0 160.0 160.0 160.0 161.0 161.0 17:33:32 INFO - PROCESS | 15282 | 17:33:32 INFO - PROCESS | 15282 | [#3] audio-fft Cycles:10 Average:81.50 Median:74.00 stddev:16.43 (22.2%) stddev-sans-first:17.20 17:33:32 INFO - PROCESS | 15282 | Values: 74.0 74.0 74.0 119.0 74.0 74.0 72.0 74.0 105.0 75.0 17:33:32 INFO - PROCESS | 15282 | 17:33:32 INFO - PROCESS | 15282 | [#4] audio-oscillator Cycles:10 Average:94.10 Median:83.00 stddev:18.95 (22.8%) stddev-sans-first:19.67 17:33:32 INFO - PROCESS | 15282 | Values: 83.0 82.0 114.0 83.0 83.0 83.0 113.0 83.0 83.0 134.0 17:33:32 INFO - PROCESS | 15282 | 17:33:32 INFO - PROCESS | 15282 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 17:33:32 INFO - PROCESS | 15282 | Values: 117.0 117.0 117.0 118.0 116.0 117.0 116.0 116.0 117.0 116.0 17:33:32 INFO - PROCESS | 15282 | 17:33:32 INFO - PROCESS | 15282 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 17:33:32 INFO - PROCESS | 15282 | Values: 146.0 145.0 145.0 145.0 146.0 146.0 145.0 145.0 146.0 145.0 17:33:32 INFO - PROCESS | 15282 | 17:33:32 INFO - PROCESS | 15282 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 17:33:32 INFO - PROCESS | 15282 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 95.0 94.0 95.0 94.0 17:33:32 INFO - PROCESS | 15282 | 17:33:32 INFO - PROCESS | 15282 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:54.00 stddev:1.15 (2.1%) stddev-sans-first:1.17 17:33:32 INFO - PROCESS | 15282 | Values: 53.0 54.0 54.0 53.0 54.0 57.0 54.0 53.0 54.0 54.0 17:33:32 INFO - PROCESS | 15282 | 17:33:32 INFO - PROCESS | 15282 | [#9] json-stringify-tinderbox Cycles:10 Average:62.50 Median:62.00 stddev:0.97 (1.6%) stddev-sans-first:1.01 17:33:32 INFO - PROCESS | 15282 | Values: 62.0 62.0 63.0 62.0 63.0 62.0 62.0 62.0 65.0 62.0 17:33:32 INFO - PROCESS | 15282 | 17:33:32 INFO - PROCESS | 15282 | [#10] stanford-crypto-aes Cycles:10 Average:83.00 Median:79.50 stddev:8.99 (11.3%) stddev-sans-first:9.36 17:33:32 INFO - PROCESS | 15282 | Values: 78.0 83.0 81.0 79.0 79.0 79.0 80.0 79.0 108.0 84.0 17:33:32 INFO - PROCESS | 15282 | 17:33:32 INFO - PROCESS | 15282 | [#11] stanford-crypto-ccm Cycles:10 Average:119.30 Median:119.00 stddev:3.16 (2.7%) stddev-sans-first:3.24 17:33:32 INFO - PROCESS | 15282 | Values: 117.0 119.0 118.0 117.0 117.0 117.0 119.0 119.0 126.0 124.0 17:33:32 INFO - PROCESS | 15282 | 17:33:32 INFO - PROCESS | 15282 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.00 Median:162.00 stddev:4.22 (2.6%) stddev-sans-first:2.47 17:33:32 INFO - PROCESS | 15282 | Values: 172.0 161.0 163.0 157.0 159.0 163.0 165.0 161.0 160.0 159.0 17:33:32 INFO - PROCESS | 15282 | 17:33:32 INFO - PROCESS | 15282 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:63.00 stddev:3.05 (4.8%) stddev-sans-first:3.13 17:33:32 INFO - PROCESS | 15282 | Values: 61.0 63.0 64.0 63.0 62.0 63.0 64.0 71.0 61.0 60.0 17:33:32 INFO - PROCESS | 15282 | -------- Summary: end -------- 17:33:32 INFO - PROCESS | 15282 | 17:33:33 INFO - TEST-INFO | 15282: exit 0 17:33:33 INFO - TEST-OK | kraken | took 61439ms 17:33:33 INFO - SUITE-END | took 1174s 17:33:33 INFO - Completed test suite (00:19:34) 17:33:33 INFO - javascript benchmark 17:33:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3099.318150006998, 3112.5331200319947, 3113.1750086227153, 3150.747940164787, 3185.155933677576, 5223.608229382802, 5312.0, 5397.541208997235, 5477.78088876445, 5517.641353312032, 5343.385510666275, 5384.488473595012, 5395.568354531638, 5398.190271459283, 5422.701751403672, 4847.854564363075, 4896.43690975537, 4929.876753081166, 4945.381827271591, 5075.416327122372, 4974.0797952378925, 5008.474110218429, 5037.773300201481, 5044.445111037783, 5045.545900868921, 4783.952160478403, 4864.100141473838, 4877.3903262092235, 4907.11671899058, 4972.751362431882, 4841.975790121062, 4859.975700121477, 4862.78117484714, 4884.340614017097, 4943.332650092228, 4887.926681099786, 4893.730844803535, 4905.607551395879, 4907.705537667715, 4917.40991081069, 5175.0, 5285.471452854684, 5342.839714808562, 5393.0, 5419.214213938957, 5857.560682948796, 5863.442972917566, 5865.824025279248, 5877.4122587740885, 5879.0, 5672.035753921843, 5851.23933888596, 5903.0555111182, 5911.497522710575, 5917.526597872203, 5357.303550538444, 5394.271773310592, 5397.8380648580605, 5452.727363631802, 5464.1257398816, 5935.940640593625, 5939.495142912814, 5945.464908158287, 5947.434993675594, 5949.672767997802, 5585.162225666182, 5714.399988001283, 5726.341470730836, 5726.599138060379, 5729.971350143306, 5825.359210486843, 5879.3826648202175, 5933.940660593339, 5934.05055191176, 5934.940650593525, 5782.855428614318, 5840.503557197686, 5845.298564172326, 5854.882902342015, 5855.560832937546, 5648.068068768689, 5684.54523638108, 5736.340320863154, 5832.037713777179, 5843.357230704619, 4367.650587952956, 4375.956240437618, 4379.146066516999, 4414.050979039522, 4414.1171765647, 3861.420786881934, 3884.533855937306, 3887.5723670396233, 3914.4911161548816, 3923.156521347924, 5267.446918073547, 5375.113106337489, 5390.4879036491475, 5400.540954018874, 5415.10650742631, 5836.387179346192, 5851.063829787214, 5862.384449632812, 5866.178734977107, 5904.261967254093, 5448.210009548593, 5453.427390123979, 5454.236406903036, 5457.045017121988, 5460.126379779295, 4932.975335123301, 5016.147254966664, 5021.698698078127, 5072.82245121419, 5084.923726144111, 6056.878862422727, 6071.362506936708, 6074.3925607438905, 6075.635461872302, 6079.240094988127, 5913.142594323799, 5925.970370148121, 5928.703564821655, 5930.05119180929, 5933.881322373615, 5741.052726300114, 5971.581989260884, 6010.759569617167, 6030.03519436888, 6053.909191362045, 5723.456271654186, 5778.451047150514, 5782.161586570008, 5786.652800831964, 5788.044972579477, 5821.505172060422, 5879.235699359056, 5880.735366908414, 5882.088276317178, 5900.852478687895, 5536.390996990408, 5590.860228494157, 5620.718964051699, 5657.943420565742, 5674.801381951612, 5653.095504719226, 5661.631993920382, 5662.377138514677, 5662.801801936913, 5664.773409063591, 5573.972130139324, 5574.386817450159, 5574.9442505574425, 5576.079946808731, 5580.9441905580425, 5560.749766260447, 5656.123300888369, 5713.085906254979, 5718.79984200551, 5820.679862607597, 5621.7189140542, 5624.6625202487985, 5632.1551767233605, 5638.069718496567, 5652.236948011966], "value": 5346.960194786731, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [581.255992329818, 619.0899377914465, 621.2296752027486, 630.5869655375727, 635.7043974551832, 31795.68204317956, 43018.0, 44618.10763784722, 44750.10499790006, 44821.327680084825, 47574.28638570424, 47979.0, 48066.27900581485, 48075.759621201934, 48098.0, 8651.48091114532, 8866.335024873128, 8894.644214231423, 8895.599698013604, 8906.287497000258, 8556.0, 8770.824583508325, 8771.95614021929, 8774.341924355667, 8778.0, 8825.073367296438, 8875.289976801872, 8877.51173685447, 8881.644734210624, 8882.022977472472, 8781.517016564087, 8823.338249631302, 8823.955880220621, 8832.735017949472, 8833.60248788806, 8535.82928341436, 8645.95677021611, 8646.524441155734, 8649.178328058824, 8653.307735381217, 43001.35497967533, 43115.13769724588, 43389.34915976263, 43499.34750978706, 43551.56448435538, 3472.6353732858192, 3573.3746594345885, 3593.2274560969254, 3739.607341229159, 3984.4871164608426, 32819.6718032819, 33266.33467330664, 33539.0, 33614.159646008804, 34988.47517287243, 4324.848630297956, 4506.278995360759, 4534.614557762594, 4606.9078618427775, 4674.32222327764, 351025.0, 351475.0, 352295.0, 355042.0, 355110.0, 56061.43938560562, 61421.38578614246, 61505.0, 61983.380166198665, 62016.379836201966, 64026.6798666013, 64858.67570662211, 65174.34825651778, 70524.64737676381, 70632.64683676549, 14928.626784330261, 15060.397584096514, 15084.170370629501, 15093.943423960218, 15113.622159445882, 11333.546658133582, 11649.0, 11699.06407487399, 11704.590339338083, 12095.939520302341, 19447.905445989258, 19494.31769888047, 19505.414837554898, 19529.0, 19635.41093767189, 6884.347756538395, 7012.368886800213, 7058.470614703815, 7136.892946605805, 7276.454265930077, 972.3242346569067, 1066.9786604267872, 1077.4989629822014, 1152.4007516091754, 1170.7658468306372, 31955.0, 32315.51526727101, 32397.19007024796, 32410.245129163814, 32893.17767055843, 1096.555894862582, 1116.3469370418234, 1151.6890439581266, 1159.9942000289946, 1249.7500499899875, 16044.598885027734, 16208.351665933467, 16546.917265413595, 16611.920225185324, 16712.331506739592, 569306.0, 570989.0, 575231.0, 577014.4940578849, 578277.0, 59874.40125598775, 60305.39694603086, 60379.09431358445, 60456.39543604507, 60487.39512604818, 1377.8966577506726, 1383.8721442024719, 1384.1487485196733, 1395.4627468424526, 1417.978730319046, 29631.407371852012, 30352.46457773058, 30475.238119046313, 31057.844710776302, 31122.53316200304, 49985.75007124941, 50653.49346506635, 50860.74569627128, 50865.745671271405, 50905.74547127241, 524746.0, 524976.0, 526903.0, 527852.9680867589, 529967.0, 25123.623145652466, 27449.725502744717, 28025.859870700515, 28211.858940705166, 29477.0, 46793.53206467892, 48035.279470808666, 48138.0, 49023.26465103098, 49043.264351035476, 39955.0, 40125.0, 40726.38910416287, 40846.59153408428, 41116.1776764469, 39666.60333396629, 40100.3984940232, 40564.39153412642, 40684.79657601693, 40903.1819363617, 36631.633683662825, 36846.44730329101, 37152.81423592865, 40984.18031639291, 41124.0, 33660.49509257314, 35559.82220088883, 36015.81992090023, 36129.02580716171, 36338.0, 27261.318467038484, 27518.449631006868, 27592.448151036464, 27686.446271074063, 27709.722902770714], "value": 20304.77333173655, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.6946044527715, 386.28729993162625, 393.0, 402.1113339519661, 413.7166041261734, 18887.15007824648, 19013.239470421202, 19200.231990720353, 19485.610287794254, 19493.415197544095, 17736.0, 18525.629487410242, 18617.348392806256, 18814.34149804757, 19330.51673708158, 5465.508104270615, 5552.250446189773, 5576.275084239043, 5582.665040097607, 5653.123765816305, 5377.596680248997, 5552.805651802188, 5574.1917421973785, 5575.0522411190195, 5597.468240517144, 5487.890242195153, 5541.251930989305, 5546.389897111315, 5547.833564993037, 5558.305211848519, 5334.946650533503, 5412.837614871541, 5436.483534064297, 5444.754986025639, 5471.425500322469, 4731.858044258678, 4890.364252647133, 4919.557239848431, 4926.655134140611, 4928.482509336504, 22196.22313219046, 22259.109635614557, 22345.441363965867, 22574.0, 22747.658785118238, 2313.34069790109, 2344.6834677318516, 2414.6015907375263, 2522.4702812409414, 2824.8163869348427, 13973.161610303414, 14094.01341906067, 14147.504837330644, 14242.430302787876, 14762.557123286319, 1898.9145488452914, 1979.1588574855773, 2002.1090614676475, 2011.7787043425212, 2018.0918586636074, 53765.73117134428, 65577.34422655808, 65934.67032664854, 74190.62904685442, 76663.0, 10087.546060427298, 10411.895881041093, 10681.946590267155, 10720.303180293256, 10926.071283940953, 13160.736785264242, 13662.0, 14453.710925781636, 14460.566183014527, 14920.403183872524, 7324.230955749569, 7635.198304178092, 7816.765497035098, 7881.802954926058, 8125.268725814705, 7654.885176722353, 7664.616769161631, 7664.6934122635585, 7852.489588176751, 7888.7633370998965, 6446.387593178641, 6643.60138391698, 6673.766418175341, 6761.594304341756, 6772.356626120511, 1850.6298740252003, 1890.3383815664408, 1908.1985566062287, 1908.6278175755594, 1909.1408866010352, 446.7297285142507, 453.7640426977953, 456.8149899290793, 470.2660872671049, 890.8797312362877, 11915.0, 11960.521579136912, 12106.576269830513, 12175.904168624866, 12184.268943863219, 464.54706661005923, 469.96710230284236, 478.6123240175469, 484.5154845154845, 488.2261615339655, 6432.6462044588, 6491.545591808528, 6495.6752162391695, 6519.576227545194, 6566.606003639797, 469957.0, 480065.0, 481392.0, 481474.0, 484651.0, 79262.0, 96466.0, 96538.0, 97236.0, 98526.0, 430.03457238499766, 439.5275079289776, 442.3497458735653, 445.52106485528185, 927.8051609162152, 16435.342586296894, 17057.0, 17269.22288497046, 17492.300307988047, 17849.553761156076, 39210.2157956845, 39487.2102557953, 40384.79807600943, 40709.389359159046, 42455.36316955186, 55641.443585563626, 56067.0, 57873.71063144657, 58074.0, 58723.825523488435, 8368.832623347376, 8497.2777313929, 8719.956400217958, 8756.78108047304, 8896.421732587361, 9711.368761030793, 12993.48026078984, 13307.80038299407, 13404.994625402938, 13523.59429217125, 11517.136214783757, 11601.883981160081, 11817.468213930566, 11902.702432439259, 12027.338496382783, 11487.36819474937, 11519.30884146954, 11548.307101573933, 11703.0, 11766.470508826953, 11742.236754610924, 11786.46960886745, 11954.0, 11972.0, 12100.394980251129, 8562.52906090171, 8582.09887961755, 8635.438696484709, 8647.82704345897, 8667.566621668766, 8784.165504277084, 11052.226344155832, 11610.477528511068, 11666.76666466649, 11782.528698852293], "value": 8468.954837708796, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1329.282187618686, 1502.1587910769965, 1541.7841502189694, 1668.424393584213, 1819.7634307540009, 8645.827083458327, 9022.639094436223, 9033.638654453822, 9232.44605323681, 9241.399309044908, 8949.731508054752, 9044.186023257906, 9044.412113212653, 9054.275657947364, 9170.220531254834, 2091.8744875307452, 2357.222116701493, 2407.386116540284, 2420.044082587377, 2434.6226334918115, 2443.2548072837776, 2447.7185123710824, 2454.3741345956755, 2454.582720937436, 2456.8894399752053, 2362.7400985891536, 2402.7116745990506, 2402.95194096118, 2407.0853075831246, 2408.217329367954, 2080.583883223354, 2346.6949296591333, 2418.6492958521094, 2428.562858685436, 2442.6091825307867, 2275.374272075176, 2287.965680514794, 2291.7593652666565, 2293.598620241451, 2303.9424014399606, 8960.05919378469, 8967.820643587156, 8971.865422018675, 9006.05436429172, 9009.504477253748, 5199.090159222159, 5358.223057656618, 5396.028714831329, 5404.216388623628, 5407.026735187704, 3360.9831950840335, 3453.6546345365264, 3462.151772815651, 3484.8780292689635, 3551.094470909927, 1096.0792933935531, 1109.938953357565, 1133.926294790836, 1139.8632164140274, 1190.2263528706324, 12457.937710311391, 12479.188852724634, 12488.562900298446, 12505.49978000879, 12505.687357816036, 4595.517470665532, 4721.362616046858, 4837.443693975168, 4838.782254798542, 4854.077725232195, 10459.163266938627, 10475.476226188812, 10475.685729428129, 10477.68566942993, 10484.685459436228, 4752.52474752522, 5214.504622060898, 5237.711925844115, 5270.92093618596, 5271.762770675329, 4867.294242334841, 5007.774650140753, 5019.598432125421, 5035.471275516018, 5043.546080852668, 4131.29767939451, 4153.210889930903, 4171.478565179353, 4190.476190476191, 4207.810648520824, 1302.6547964789338, 1306.79744639581, 1317.9341032948314, 1322.9784383296567, 1328.634625477982, 854.8589482735279, 936.5317341329335, 949.3307218411004, 950.9429434233969, 963.9518024098767, 6137.447629713258, 6153.138560601519, 6193.907091393633, 6213.596116252429, 6268.404501572434, 974.3812678948776, 1006.7936073104996, 1019.8827134879435, 1025.738436698637, 1044.5299615173203, 4113.794310284474, 4278.764667943231, 4318.481782186158, 4335.089631177425, 4359.585839345257, 11193.776124477465, 11372.48823802931, 11477.827832582518, 11563.306201627762, 11574.305541667527, 10686.946565267124, 11115.555377784798, 11117.499712512956, 11446.255993360404, 11475.311481311148, 8318.584070796436, 8455.66177352899, 8483.236508714246, 8488.98132224137, 8578.699745508877, 6123.908141377794, 6270.498360131087, 6342.39747224013, 6350.142730731292, 6426.325235850169, 10394.324368915995, 10529.157667386438, 10580.629677961235, 10650.520726567478, 10663.253572249869, 9591.376560523544, 9928.851067233853, 9963.850542241727, 10100.696979090639, 10199.235057370579, 7202.747903823341, 7423.331900129015, 7440.3675687567165, 8016.238457346542, 8173.141820108803, 8088.029436467662, 8411.369147313853, 8671.696490622799, 8673.956630216808, 8919.55402229899, 7732.0, 7746.186650401852, 7816.335611473089, 8032.437729358889, 8060.798480038046, 7563.130240022468, 7706.499077559941, 7760.805979850549, 7788.688452461838, 8049.074356449083, 6998.370146686822, 7054.682539285642, 7194.676239569337, 7196.388306993755, 7210.134783825974, 5274.340707411574, 5297.099493086262, 5307.230451584576, 5326.493983071602, 5511.862203444946, 4858.95141048585, 4913.3121363008495, 4941.925871112008, 4985.601151907911, 5007.874803129951], "value": 4741.0101555460105, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.08470503783604, 317.5126181311686, 318.3267389471266, 320.2793714143178, 326.3831358731996, 5177.611679124071, 5283.547024568241, 5288.101022826119, 5316.670832291932, 5353.143497040474, 5212.817551385702, 5214.530692237698, 5222.712750798704, 5224.582033437326, 5226.477352264781, 4009.518857737061, 4019.9397009044887, 4023.8994025149314, 4023.9396409053743, 4063.918721625573, 3953.98023009886, 4017.1363156921257, 4030.6976976726714, 4036.555978842325, 4048.1903619276113, 4006.258842114218, 4011.8194681239415, 4034.7780872052026, 4040.151568170688, 4046.5751096134923, 3964.940525892114, 4003.6396724294955, 4005.6967243834765, 4010.1779135277197, 4010.739301945379, 3522.295540891832, 3524.859005639771, 3534.734894882894, 3535.840887160084, 3559.697425718817, 4832.540908613676, 5024.698518088926, 5046.26829109777, 5082.542571168576, 5125.38495380553, 4612.815487380501, 4626.8149274029, 4628.421447319085, 4629.907401851944, 4663.207254766698, 5389.461053894579, 5426.62013659044, 5433.266509021271, 5453.836384908459, 5457.317835270591, 3598.46023096535, 3761.736678432511, 3786.8106594670157, 3964.603539646041, 3970.344893092636, 5423.349198096214, 5468.91796623051, 5707.0, 5710.971445142748, 5747.798827041075, 3812.8856134316015, 3813.790241536742, 3825.84696612138, 3828.9617103829164, 3838.596947320547, 3776.0, 3896.7467114638025, 3926.0, 3942.2706799242233, 3970.7021973351534, 4554.493040358905, 4566.657500687462, 4576.565226303496, 4586.793594288265, 4593.701409408378, 5496.725163741877, 5508.705454218256, 5510.925369552979, 5520.972395138079, 5528.778848846082, 1355.6814148675053, 1358.565259117073, 1378.3246209357342, 1380.8135901653147, 1383.4397069186793, 840.2018082821344, 847.4406891451613, 853.2534032721369, 856.9485830850169, 860.0, 4638.420197475316, 4723.567362808157, 4791.760411979457, 4844.806207751721, 4865.245886887538, 4961.454240033666, 4968.503149685002, 5041.369828771403, 5041.924371134436, 5081.8729531762, 4541.069080838421, 4665.650076244296, 4667.95332046682, 4725.448257940742, 4735.195016847144, 2689.713743318203, 2695.528282550585, 2707.9303675048245, 2733.3986522964915, 2740.7670348020642, 5203.635745497779, 5207.7916883325, 5213.218017297359, 5222.764975576109, 5240.2969035063, 4871.0910695029625, 5043.193089105799, 5157.948420515821, 5172.8965420691375, 5185.248139019821, 5169.983706354449, 5179.81870634526, 5189.4032186299055, 5190.870228244248, 5216.243644671501, 5044.470330615232, 5069.264956581349, 5081.85658226896, 5083.440821509705, 5117.488251174853, 5334.813281535127, 5411.675299482044, 5543.450012994068, 5553.194786755817, 5572.969000734877, 5803.767849285981, 5823.505002074701, 5834.299884013945, 5851.180834683063, 5889.764409423575, 3789.829457674356, 3985.003749062734, 3996.2806694794053, 4015.257177422186, 4015.819288131983, 5656.773729050792, 5673.659580425187, 5678.375378708256, 5695.092144131597, 5705.885882282248, 5547.1679248113105, 5557.694326811902, 5558.861028474321, 5600.327960644749, 5608.85977850557, 5271.604629652868, 5495.774211444372, 5503.449655034465, 5515.145152501369, 5534.778608855761, 5335.786568537215, 5366.973165134149, 5391.838244852661, 5398.568114550905, 5400.729963501731, 5471.644343117685, 5504.724763761716, 5506.5870059744875, 5523.0, 5550.888982220414, 5268.57851371897, 5439.809606663748, 5454.781808727606, 5457.735039958373, 5464.644798088111], "value": 4047.1660664019496, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [824.5629816197415, 835.9749207523777, 850.51520633239, 857.1300130367678, 891.1578558262437, 14668.119912805227, 15407.306671199794, 15449.613759656015, 15469.458568950075, 15493.612659683513, 14127.22300273487, 14696.0, 14698.779518307234, 15056.849431505681, 15074.246287685626, 688.9483288753338, 705.7424040225333, 810.6959890041235, 822.8313195794863, 823.6046697585163, 825.5211977053325, 828.5981299069977, 828.6519661742053, 830.2652152844746, 831.40969911363, 856.0497847389393, 858.6307887608326, 858.995705021474, 863.1282404771164, 863.3740538109882, 702.3819039245457, 721.163450397539, 848.6350869126273, 854.3677678517884, 872.2498651159997, 623.8190924631851, 628.2178687534004, 628.2774808969675, 628.5882746800853, 628.9213848268967, 14656.853431465763, 14661.0, 14677.045992010591, 14677.633059173499, 14695.191764452951, 13914.860851391457, 13919.791203131961, 13948.860511394858, 14009.71980560383, 14304.427822887175, 10564.841527377095, 10944.945275273652, 11168.106551475863, 11181.273217240854, 11214.66356009321, 3784.3188226119287, 3821.426785982097, 3844.2888065707934, 3851.84592616295, 3941.881743547698, 58503.0, 58615.0, 58660.41339586592, 58698.0, 58927.705361472916, 10548.894511054945, 10854.403007834644, 10937.45312734376, 10953.290639321294, 11010.339379637087, 19670.40988770339, 19684.60630787376, 19725.11236994339, 19729.40811775649, 19741.605167896563, 8177.836443271221, 8341.165883411732, 8461.069282378934, 8511.191436813493, 8793.38446308765, 4329.372241025034, 4344.348347747863, 4357.716748411343, 4394.538573449806, 4415.448068991376, 3314.6022477302877, 3336.9165770855925, 3383.983080084584, 3389.9491507627404, 3398.6261511233743, 652.0349882174409, 654.630133974303, 654.7577396363281, 655.8950567909208, 673.7170388436869, 572.7737543670227, 695.6486974078058, 703.0824773670307, 722.9421646268286, 741.4439170622034, 8817.559122043873, 8834.779130521789, 8868.113188681209, 8898.154675305836, 9086.182243598108, 641.4611726150056, 675.6891829758268, 691.9240580896653, 726.8509955459118, 728.7376544443996, 4337.1976184405985, 4363.345498175236, 4455.977720111444, 4475.26158183896, 4492.528284530143, 66800.6659966697, 70330.64834675896, 70446.29553704499, 71293.2870671297, 71766.64116679384, 55442.0, 56108.43891561032, 60822.39177608256, 61071.0, 63317.36682633115, 56626.43373566294, 57480.71259643675, 57559.42440575541, 57636.0, 59074.11388829171, 9393.389429687048, 9487.193588544775, 9520.428774273565, 9543.066706313863, 9689.27330450205, 37475.0, 37609.0, 38188.0, 38295.617043830316, 39345.0, 51048.744756275984, 51135.232971504716, 51657.7417112912, 51761.22358164555, 52665.36673166403, 11321.377324247245, 11411.60059397917, 11419.37193454368, 11775.823362649397, 12141.0, 13208.207507549578, 13284.734305314032, 13587.116837405538, 13770.862291376958, 13799.0, 12188.939055305022, 12370.13409061357, 12493.93753031229, 12788.552400665933, 12864.356782161041, 12348.0, 12459.127861050001, 12481.375931203585, 12560.434780435085, 12685.746285074063, 12544.498220071095, 12813.679658008625, 12932.870671293544, 13094.279814609907, 13274.402651880495, 11021.283616564897, 11113.333200008025, 11297.604583839526, 11325.660230193107, 11398.943005285253, 10224.969245404456, 11063.336199828036, 11253.66239012831, 11293.548258069584, 11438.256513326607], "value": 6902.76329353928, "unit": "score"}], "name": "dromaeo_css", "value": 7040.5118503540625, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 106.0, 109.0, 110.0, 111.0, 110.0, 110.0, 110.0, 108.0, 110.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 125.0, 127.0, 178.0, 125.0, 126.0, 156.0, 126.0, 164.0, 123.0], "value": 140.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 160.0, 160.0, 159.0, 160.0, 160.0, 160.0, 161.0, 161.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 119.0, 74.0, 74.0, 72.0, 74.0, 105.0, 75.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 114.0, 83.0, 83.0, 83.0, 113.0, 83.0, 83.0, 134.0], "value": 94.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 116.0, 117.0, 116.0, 116.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 145.0, 146.0, 146.0, 145.0, 145.0, 146.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 54.0, 53.0, 54.0, 57.0, 54.0, 53.0, 54.0, 54.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 63.0, 62.0, 63.0, 62.0, 62.0, 62.0, 65.0, 62.0], "value": 62.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 83.0, 81.0, 79.0, 79.0, 79.0, 80.0, 79.0, 108.0, 84.0], "value": 83.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 118.0, 117.0, 117.0, 117.0, 119.0, 119.0, 126.0, 124.0], "value": 119.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 161.0, 163.0, 157.0, 159.0, 163.0, 165.0, 161.0, 160.0, 159.0], "value": 162.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 64.0, 63.0, 62.0, 63.0, 64.0, 71.0, 61.0, 60.0], "value": 63.2, "unit": "score"}], "name": "kraken", "value": 1486.6, "alertThreshold": 2.0}]} 17:33:33 INFO - Return code: 0 17:33:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:33:33 ERROR - # TBPL SUCCESS # 17:33:33 INFO - Running post-action listener: _resource_record_post_action 17:33:33 INFO - ##### 17:33:33 INFO - ##### Finished run-tests step (success) 17:33:33 INFO - ##### 17:33:33 INFO - Running post-run listener: _resource_record_post_run 17:33:33 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 217088; Write bytes: 543596544; Read time: 648; Write time: 674660 17:33:33 INFO - TinderboxPrint: CPU usage
13.2% 17:33:33 INFO - TinderboxPrint: I/O read bytes / time
217,088 / 648 17:33:33 INFO - TinderboxPrint: I/O write bytes / time
543,596,544 / 674,660 17:33:33 INFO - TinderboxPrint: CPU idle
8,266.4 (86.8%) 17:33:33 INFO - TinderboxPrint: CPU user
1,207.0 (12.7%) 17:33:33 INFO - TinderboxPrint: Swap in / out
0 / 0 17:33:33 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 32768; Write bytes: 257499136; Read time: 320; Write time: 346564 17:33:33 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 184320; Write bytes: 286097408; Read time: 328; Write time: 328096 17:33:34 INFO - Running post-run listener: _upload_blobber_files 17:33:34 INFO - Blob upload gear active. 17:33:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:33:34 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:33:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:33:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:33:34 INFO - (blobuploader) - INFO - Open directory for files ... 17:33:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:33:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:33:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:33:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:33:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:33:35 INFO - (blobuploader) - INFO - Done attempting. 17:33:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:33:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:33:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:33:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:33:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:33:39 INFO - (blobuploader) - INFO - Done attempting. 17:33:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:33:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:33:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:33:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:33:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:33:40 INFO - (blobuploader) - INFO - Done attempting. 17:33:40 INFO - (blobuploader) - INFO - Iteration through files over. 17:33:40 INFO - Return code: 0 17:33:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:33:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:33:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1a019b3cf7596554dda71ba8eeef7f4870b446914b8865cc0d0082114dc2467da4d2d1b0396d7058071c945a1f16b5994881ed024f4964798381c022ecb2eca0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/447566f07dbc1f334e32a98a8f7fe8b9ce0871f08077a7ddfdb91aec073a8068a0be9eba5987d14455486fdfc0a1e833fad6ed830e891cc22cabfb17c5f4116a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2b98092ed379e74a62f4cfacba74dad1b19995a6a47022030dd89e63d6d7631ae1edc5f636e0f410d70614543321cd2552604cd5e6cfcab3714b49c6c4b063fb"} 17:33:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:33:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:33:40 INFO - Contents: 17:33:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1a019b3cf7596554dda71ba8eeef7f4870b446914b8865cc0d0082114dc2467da4d2d1b0396d7058071c945a1f16b5994881ed024f4964798381c022ecb2eca0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/447566f07dbc1f334e32a98a8f7fe8b9ce0871f08077a7ddfdb91aec073a8068a0be9eba5987d14455486fdfc0a1e833fad6ed830e891cc22cabfb17c5f4116a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2b98092ed379e74a62f4cfacba74dad1b19995a6a47022030dd89e63d6d7631ae1edc5f636e0f410d70614543321cd2552604cd5e6cfcab3714b49c6c4b063fb"} 17:33:40 INFO - Running post-run listener: copy_logs_to_upload_dir 17:33:40 INFO - Copying logs to upload dir... 17:33:40 INFO - mkdir: /builds/slave/test/build/upload/logs 17:33:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.147079 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-05-30 17:33:40.324492) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 17:33:40.328032) ========= 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=cbe409c6de289db6ac707de3000001d4-1464653583.725438-1791022660 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1a019b3cf7596554dda71ba8eeef7f4870b446914b8865cc0d0082114dc2467da4d2d1b0396d7058071c945a1f16b5994881ed024f4964798381c022ecb2eca0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/447566f07dbc1f334e32a98a8f7fe8b9ce0871f08077a7ddfdb91aec073a8068a0be9eba5987d14455486fdfc0a1e833fad6ed830e891cc22cabfb17c5f4116a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2b98092ed379e74a62f4cfacba74dad1b19995a6a47022030dd89e63d6d7631ae1edc5f636e0f410d70614543321cd2552604cd5e6cfcab3714b49c6c4b063fb"} build_url:https://queue.taskcluster.net/v1/task/Sqdf8GYHR3ikYm3qs3cN9A/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011706 build_url: 'https://queue.taskcluster.net/v1/task/Sqdf8GYHR3ikYm3qs3cN9A/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/Fx-Team/sha512/1a019b3cf7596554dda71ba8eeef7f4870b446914b8865cc0d0082114dc2467da4d2d1b0396d7058071c945a1f16b5994881ed024f4964798381c022ecb2eca0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/447566f07dbc1f334e32a98a8f7fe8b9ce0871f08077a7ddfdb91aec073a8068a0be9eba5987d14455486fdfc0a1e833fad6ed830e891cc22cabfb17c5f4116a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2b98092ed379e74a62f4cfacba74dad1b19995a6a47022030dd89e63d6d7631ae1edc5f636e0f410d70614543321cd2552604cd5e6cfcab3714b49c6c4b063fb"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 17:33:40.354603) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 17:33:40.354944) ========= 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=cbe409c6de289db6ac707de3000001d4-1464653583.725438-1791022660 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004468 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 17:33:40.438495) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 17:33:40.438845) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 17:33:40.439161) ========= ========= Total master_lag: 0.16 =========