builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-066 starttime: 1464526157.98 results: success (0) buildid: 20160529030212 builduid: ed0a41aa180144609c4243d614c30271 revision: 2c7440e46d8786b2c82a1d2004e2b6d9d13f4046 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-29 05:49:17.983322) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-29 05:49:17.983816) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-29 05:49:17.984158) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-29 05:49:18.018184) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-29 05:49:18.018481) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1464520836.593079-651912951 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-29 05:49:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 217M=0s 2016-05-29 05:49:19 (217 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.359575 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-29 05:49:18.395202) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-29 05:49:18.395641) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1464520836.593079-651912951 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016913 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-29 05:49:18.446283) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-29 05:49:18.446930) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2c7440e46d8786b2c82a1d2004e2b6d9d13f4046 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 2c7440e46d8786b2c82a1d2004e2b6d9d13f4046 --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=82c74bd3bc9a11c5833d2010000001e6-1464520836.593079-651912951 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-29 05:49:19,787 truncating revision to first 12 chars 2016-05-29 05:49:19,787 Setting DEBUG logging. 2016-05-29 05:49:19,787 attempt 1/10 2016-05-29 05:49:19,787 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2c7440e46d87?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-29 05:49:20,091 unpacking tar archive at: mozilla-central-2c7440e46d87/testing/mozharness/ program finished with exit code 0 elapsedTime=1.052869 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-29 05:49:19.514018) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-29 05:49:19.514355) ========= script_repo_revision: 2c7440e46d8786b2c82a1d2004e2b6d9d13f4046 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-29 05:49:19.514808) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-29 05:49:19.515099) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-29 05:49:19.525653) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-05-29 05:49:19.525966) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=82c74bd3bc9a11c5833d2010000001e6-1464520836.593079-651912951 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:49:20 INFO - MultiFileLogger online at 20160529 05:49:20 in /builds/slave/test 05:49:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:49:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:49:20 INFO - {'append_to_log': False, 05:49:20 INFO - 'base_work_dir': '/builds/slave/test', 05:49:20 INFO - 'blob_upload_branch': 'Firefox', 05:49:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:49:20 INFO - 'branch': 'Firefox', 05:49:20 INFO - 'buildbot_json_path': 'buildprops.json', 05:49:20 INFO - 'config_files': ('talos/linux_config.py',), 05:49:20 INFO - 'default_actions': ('clobber', 05:49:20 INFO - 'read-buildbot-config', 05:49:20 INFO - 'download-and-extract', 05:49:20 INFO - 'populate-webroot', 05:49:20 INFO - 'create-virtualenv', 05:49:20 INFO - 'install', 05:49:20 INFO - 'run-tests'), 05:49:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:49:20 INFO - 'download_minidump_stackwalk': True, 05:49:20 INFO - 'download_symbols': 'ondemand', 05:49:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:49:20 INFO - 'tooltool.py': '/tools/tooltool.py', 05:49:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:49:20 INFO - '/tools/misc-python/virtualenv.py')}, 05:49:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:49:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:49:20 INFO - 'installer_path': 'installer.exe', 05:49:20 INFO - 'log_level': 'info', 05:49:20 INFO - 'log_name': 'talos', 05:49:20 INFO - 'log_to_console': True, 05:49:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:49:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:49:20 INFO - 'opt_config_files': (), 05:49:20 INFO - 'pip_index': False, 05:49:20 INFO - 'sps_profile': False, 05:49:20 INFO - 'sps_profile_interval': 0, 05:49:20 INFO - 'suite': 'dromaeojs', 05:49:20 INFO - 'system_bits': '32', 05:49:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:49:20 INFO - 'title': 'talos-linux64-ix-066', 05:49:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:49:20 INFO - 'use_talos_json': True, 05:49:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:49:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:49:20 INFO - 'work_dir': 'build'} 05:49:20 INFO - ##### 05:49:20 INFO - ##### Running clobber step. 05:49:20 INFO - ##### 05:49:20 INFO - Running pre-action listener: _resource_record_pre_action 05:49:20 INFO - Running main action method: clobber 05:49:20 INFO - rmtree: /builds/slave/test/build 05:49:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:49:21 INFO - Running post-action listener: _resource_record_post_action 05:49:21 INFO - ##### 05:49:21 INFO - ##### Finished clobber step (success) 05:49:21 INFO - ##### 05:49:21 INFO - ##### 05:49:21 INFO - ##### Running read-buildbot-config step. 05:49:21 INFO - ##### 05:49:21 INFO - Running pre-action listener: _resource_record_pre_action 05:49:21 INFO - Running main action method: read_buildbot_config 05:49:21 INFO - Using buildbot properties: 05:49:21 INFO - { 05:49:21 INFO - "project": "", 05:49:21 INFO - "product": "firefox", 05:49:21 INFO - "script_repo_revision": "production", 05:49:21 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:49:21 INFO - "repository": "", 05:49:21 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:49:21 INFO - "buildid": "20160529030212", 05:49:21 INFO - "stage_platform": "linux64-pgo", 05:49:21 INFO - "basedir": "/builds/slave/test", 05:49:21 INFO - "nightly_build": "True", 05:49:21 INFO - "buildnumber": 309, 05:49:21 INFO - "slavename": "talos-linux64-ix-066", 05:49:21 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:49:21 INFO - "platform": "ubuntu64_hw", 05:49:21 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:49:21 INFO - "branch": "mozilla-central", 05:49:21 INFO - "repo_path": "mozilla-central", 05:49:21 INFO - "revision": "2c7440e46d8786b2c82a1d2004e2b6d9d13f4046", 05:49:21 INFO - "pgo_build": "True", 05:49:21 INFO - "builduid": "ed0a41aa180144609c4243d614c30271", 05:49:21 INFO - "slavebuilddir": "test" 05:49:21 INFO - } 05:49:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/JuBLYmqoQq6Aag8Ekb85ag/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 05:49:21 INFO - Running post-action listener: _resource_record_post_action 05:49:21 INFO - ##### 05:49:21 INFO - ##### Finished read-buildbot-config step (success) 05:49:21 INFO - ##### 05:49:21 INFO - ##### 05:49:21 INFO - ##### Running download-and-extract step. 05:49:21 INFO - ##### 05:49:21 INFO - Running pre-action listener: _resource_record_pre_action 05:49:21 INFO - Running main action method: download_and_extract 05:49:21 INFO - mkdir: /builds/slave/test/build/tests 05:49: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')]} 05:49:21 INFO - https://queue.taskcluster.net/v1/task/JuBLYmqoQq6Aag8Ekb85ag/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:49:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuBLYmqoQq6Aag8Ekb85ag/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:49:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuBLYmqoQq6Aag8Ekb85ag/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:49:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuBLYmqoQq6Aag8Ekb85ag/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:49:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuBLYmqoQq6Aag8Ekb85ag/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:49:22 INFO - Downloaded 1361 bytes. 05:49:22 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:49:22 INFO - Using the following test package requirements: 05:49:22 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:49:22 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:49:22 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:49:22 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:22 INFO - u'jsshell-linux-x86_64.zip'], 05:49:22 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:49:22 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:49:22 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:49:22 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:49:22 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:49:22 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:22 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:49:22 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:49:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:22 INFO - https://queue.taskcluster.net/v1/task/JuBLYmqoQq6Aag8Ekb85ag/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:49:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuBLYmqoQq6Aag8Ekb85ag/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:49:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuBLYmqoQq6Aag8Ekb85ag/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:49:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuBLYmqoQq6Aag8Ekb85ag/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:49:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuBLYmqoQq6Aag8Ekb85ag/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:49:24 INFO - Downloaded 24410380 bytes. 05:49:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:49:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:49:25 INFO - Return code: 0 05:49:25 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:49:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:25 INFO - https://queue.taskcluster.net/v1/task/JuBLYmqoQq6Aag8Ekb85ag/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:49:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuBLYmqoQq6Aag8Ekb85ag/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:49:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuBLYmqoQq6Aag8Ekb85ag/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:49:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuBLYmqoQq6Aag8Ekb85ag/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:49:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuBLYmqoQq6Aag8Ekb85ag/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:49:28 INFO - Downloaded 24410380 bytes. 05:49:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:49:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:49:30 INFO - Return code: 0 05:49: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')]} 05:49:30 INFO - https://queue.taskcluster.net/v1/task/JuBLYmqoQq6Aag8Ekb85ag/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:49:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuBLYmqoQq6Aag8Ekb85ag/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:49:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuBLYmqoQq6Aag8Ekb85ag/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:49:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuBLYmqoQq6Aag8Ekb85ag/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:49:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuBLYmqoQq6Aag8Ekb85ag/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:49:31 INFO - Downloaded 10834034 bytes. 05:49:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:49:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:49:31 INFO - Return code: 0 05:49:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:31 INFO - https://queue.taskcluster.net/v1/task/JuBLYmqoQq6Aag8Ekb85ag/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:49:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuBLYmqoQq6Aag8Ekb85ag/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:49:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuBLYmqoQq6Aag8Ekb85ag/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:49:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuBLYmqoQq6Aag8Ekb85ag/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:49:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuBLYmqoQq6Aag8Ekb85ag/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:49:35 INFO - Downloaded 58733796 bytes. 05:49:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JuBLYmqoQq6Aag8Ekb85ag/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:49:35 INFO - mkdir: /builds/slave/test/properties 05:49:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:49:35 INFO - Writing to file /builds/slave/test/properties/build_url 05:49:35 INFO - Contents: 05:49:35 INFO - build_url:https://queue.taskcluster.net/v1/task/JuBLYmqoQq6Aag8Ekb85ag/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:49:35 INFO - Running post-action listener: _resource_record_post_action 05:49:35 INFO - Running post-action listener: set_extra_try_arguments 05:49:35 INFO - ##### 05:49:35 INFO - ##### Finished download-and-extract step (success) 05:49:35 INFO - ##### 05:49:35 INFO - ##### 05:49:35 INFO - ##### Running populate-webroot step. 05:49:35 INFO - ##### 05:49:35 INFO - Running pre-action listener: _resource_record_pre_action 05:49:35 INFO - Running main action method: populate_webroot 05:49:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:49:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:49:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:49:35 INFO - '--tppagecycles', 05:49:35 INFO - '7'], 05:49:35 INFO - 'tests': ['tsvgm']}}, 05:49:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:49:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:49:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:49:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:49:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:49:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:49:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:35 INFO - 'talos_options': ['--disable-e10s'], 05:49:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:49:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:49:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:35 INFO - 'talos_options': ['--disable-e10s'], 05:49:35 INFO - 'tests': ['damp', 'tps']}, 05:49:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:35 INFO - 'tests': ['damp', 'tps']}, 05:49:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:49:35 INFO - 'tests': ['dromaeo_dom']}, 05:49:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:49:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:49:35 INFO - 'tests': ['a11yr', 05:49:35 INFO - 'ts_paint', 05:49:35 INFO - 'tpaint', 05:49:35 INFO - 'sessionrestore', 05:49:35 INFO - 'sessionrestore_no_auto_restore', 05:49:35 INFO - 'tabpaint']}, 05:49:35 INFO - 'other-e10s': {'tests': ['a11yr', 05:49:35 INFO - 'ts_paint', 05:49:35 INFO - 'tpaint', 05:49:35 INFO - 'sessionrestore', 05:49:35 INFO - 'sessionrestore_no_auto_restore', 05:49:35 INFO - 'tabpaint']}, 05:49:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:49:35 INFO - 'ts_paint', 05:49:35 INFO - 'tpaint', 05:49:35 INFO - 'sessionrestore', 05:49:35 INFO - 'sessionrestore_no_auto_restore', 05:49:35 INFO - 'tabpaint']}, 05:49:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:49:35 INFO - 'ts_paint', 05:49:35 INFO - 'tpaint', 05:49:35 INFO - 'sessionrestore', 05:49:35 INFO - 'sessionrestore_no_auto_restore', 05:49:35 INFO - 'tabpaint']}, 05:49:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:49:35 INFO - 'tests': ['a11yr', 05:49:35 INFO - 'ts_paint', 05:49:35 INFO - 'tpaint', 05:49:35 INFO - 'sessionrestore', 05:49:35 INFO - 'sessionrestore_no_auto_restore', 05:49:35 INFO - 'tabpaint']}, 05:49:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:49:35 INFO - 'tests': ['a11yr', 05:49:35 INFO - 'ts_paint', 05:49:35 INFO - 'tpaint', 05:49:35 INFO - 'sessionrestore', 05:49:35 INFO - 'sessionrestore_no_auto_restore', 05:49:35 INFO - 'tabpaint']}, 05:49:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:49:35 INFO - 'tests': ['tsvgx', 05:49:35 INFO - 'tsvgr_opacity', 05:49:35 INFO - 'tart', 05:49:35 INFO - 'tscrollx', 05:49:35 INFO - 'cart']}, 05:49:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:49:35 INFO - 'tsvgr_opacity', 05:49:35 INFO - 'tart', 05:49:35 INFO - 'tscrollx', 05:49:35 INFO - 'cart']}, 05:49:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:35 INFO - 'talos_options': ['--disable-e10s'], 05:49:35 INFO - 'tests': ['tp5o']}, 05:49:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:35 INFO - 'tests': ['tp5o']}, 05:49:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:35 INFO - 'talos_options': ['--disable-e10s', 05:49:35 INFO - '--xperf_path', 05:49:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:49:35 INFO - 'tests': ['tp5n']}, 05:49:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:35 INFO - 'talos_options': ['--xperf_path', 05:49:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:49:35 INFO - 'tests': ['tp5n']}}, 05:49:35 INFO - 'talos.zip': {'path': '', 05:49:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:49:35 INFO - Running post-action listener: _resource_record_post_action 05:49:35 INFO - ##### 05:49:35 INFO - ##### Finished populate-webroot step (success) 05:49:35 INFO - ##### 05:49:35 INFO - ##### 05:49:35 INFO - ##### Running create-virtualenv step. 05:49:35 INFO - ##### 05:49:35 INFO - Running pre-action listener: _resource_record_pre_action 05:49:35 INFO - Running main action method: create_virtualenv 05:49:35 INFO - Creating virtualenv /builds/slave/test/build/venv 05:49:35 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:49:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:49:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:49:35 INFO - Using real prefix '/usr' 05:49:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:49:36 INFO - Installing distribute.............................................................................................................................................................................................done. 05:49:38 INFO - Installing pip.................done. 05:49:38 INFO - Return code: 0 05:49:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:49:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:38 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 0x7f72c1d67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2079770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21089c0>, '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 0x21098c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2109d50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464520836.593079-651912951', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:49:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:49:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:49:38 INFO - Using env: {'DISPLAY': ':0', 05:49:38 INFO - 'HOME': '/home/cltbld', 05:49:38 INFO - 'LANG': 'en_US.UTF-8', 05:49:38 INFO - 'LANGUAGE': 'en_US:en', 05:49:38 INFO - 'LOGNAME': 'cltbld', 05:49:38 INFO - 'MAIL': '/var/mail/cltbld', 05:49:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:38 INFO - 'MOZ_NO_REMOTE': '1', 05:49:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:38 INFO - 'NO_EM_RESTART': '1', 05:49:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:38 INFO - 'PWD': '/builds/slave/test', 05:49:38 INFO - 'SHELL': '/bin/bash', 05:49:38 INFO - 'SHLVL': '1', 05:49:38 INFO - 'TERM': 'linux', 05:49:38 INFO - 'TMOUT': '86400', 05:49:38 INFO - 'USER': 'cltbld', 05:49:38 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464520836.593079-651912951', 05:49:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:38 INFO - '_': '/tools/buildbot/bin/python'} 05:49:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:38 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:49:38 INFO - Cleaning up... 05:49:38 INFO - Return code: 0 05:49:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:49:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:38 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 0x7f72c1d67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2079770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21089c0>, '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 0x21098c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2109d50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464520836.593079-651912951', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:49:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:49:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:49:38 INFO - Using env: {'DISPLAY': ':0', 05:49:38 INFO - 'HOME': '/home/cltbld', 05:49:38 INFO - 'LANG': 'en_US.UTF-8', 05:49:38 INFO - 'LANGUAGE': 'en_US:en', 05:49:38 INFO - 'LOGNAME': 'cltbld', 05:49:38 INFO - 'MAIL': '/var/mail/cltbld', 05:49:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:38 INFO - 'MOZ_NO_REMOTE': '1', 05:49:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:38 INFO - 'NO_EM_RESTART': '1', 05:49:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:38 INFO - 'PWD': '/builds/slave/test', 05:49:38 INFO - 'SHELL': '/bin/bash', 05:49:38 INFO - 'SHLVL': '1', 05:49:38 INFO - 'TERM': 'linux', 05:49:38 INFO - 'TMOUT': '86400', 05:49:38 INFO - 'USER': 'cltbld', 05:49:38 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464520836.593079-651912951', 05:49:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:38 INFO - '_': '/tools/buildbot/bin/python'} 05:49:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:38 INFO - Downloading/unpacking psutil>=3.1.1 05:49:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:49:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:49:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:49:40 INFO - Installing collected packages: psutil 05:49:40 INFO - Running setup.py install for psutil 05:49:40 INFO - building 'psutil._psutil_linux' extension 05:49:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:49:41 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:49:41 INFO - building 'psutil._psutil_posix' extension 05:49:41 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:49:41 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:49:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:49:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:49:41 INFO - Successfully installed psutil 05:49:41 INFO - Cleaning up... 05:49:41 INFO - Return code: 0 05:49:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:49:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:41 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 0x7f72c1d67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2079770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21089c0>, '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 0x21098c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2109d50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464520836.593079-651912951', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:49:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:49:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:49:41 INFO - Using env: {'DISPLAY': ':0', 05:49:41 INFO - 'HOME': '/home/cltbld', 05:49:41 INFO - 'LANG': 'en_US.UTF-8', 05:49:41 INFO - 'LANGUAGE': 'en_US:en', 05:49:41 INFO - 'LOGNAME': 'cltbld', 05:49:41 INFO - 'MAIL': '/var/mail/cltbld', 05:49:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:41 INFO - 'MOZ_NO_REMOTE': '1', 05:49:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:41 INFO - 'NO_EM_RESTART': '1', 05:49:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:41 INFO - 'PWD': '/builds/slave/test', 05:49:41 INFO - 'SHELL': '/bin/bash', 05:49:41 INFO - 'SHLVL': '1', 05:49:41 INFO - 'TERM': 'linux', 05:49:41 INFO - 'TMOUT': '86400', 05:49:41 INFO - 'USER': 'cltbld', 05:49:41 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464520836.593079-651912951', 05:49:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:41 INFO - '_': '/tools/buildbot/bin/python'} 05:49:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:49:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:49:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:49:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:49:43 INFO - Installing collected packages: mozsystemmonitor 05:49:43 INFO - Running setup.py install for mozsystemmonitor 05:49:43 INFO - Successfully installed mozsystemmonitor 05:49:43 INFO - Cleaning up... 05:49:43 INFO - Return code: 0 05:49:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:49:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f72c1d67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2079770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21089c0>, '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 0x21098c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2109d50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464520836.593079-651912951', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:49:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:49:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:49:43 INFO - Using env: {'DISPLAY': ':0', 05:49:43 INFO - 'HOME': '/home/cltbld', 05:49:43 INFO - 'LANG': 'en_US.UTF-8', 05:49:43 INFO - 'LANGUAGE': 'en_US:en', 05:49:43 INFO - 'LOGNAME': 'cltbld', 05:49:43 INFO - 'MAIL': '/var/mail/cltbld', 05:49:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:43 INFO - 'MOZ_NO_REMOTE': '1', 05:49:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:43 INFO - 'NO_EM_RESTART': '1', 05:49:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:43 INFO - 'PWD': '/builds/slave/test', 05:49:43 INFO - 'SHELL': '/bin/bash', 05:49:43 INFO - 'SHLVL': '1', 05:49:43 INFO - 'TERM': 'linux', 05:49:43 INFO - 'TMOUT': '86400', 05:49:43 INFO - 'USER': 'cltbld', 05:49:43 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464520836.593079-651912951', 05:49:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:43 INFO - '_': '/tools/buildbot/bin/python'} 05:49:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:43 INFO - Downloading/unpacking blobuploader==1.2.4 05:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:45 INFO - Downloading blobuploader-1.2.4.tar.gz 05:49:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:49:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:49:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:49:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:49:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:46 INFO - Downloading docopt-0.6.1.tar.gz 05:49:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:49:46 INFO - Installing collected packages: blobuploader, requests, docopt 05:49:46 INFO - Running setup.py install for blobuploader 05:49:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:49:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:49:46 INFO - Running setup.py install for requests 05:49:47 INFO - Running setup.py install for docopt 05:49:47 INFO - Successfully installed blobuploader requests docopt 05:49:47 INFO - Cleaning up... 05:49:47 INFO - Return code: 0 05:49:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:49:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:47 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 0x7f72c1d67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2079770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21089c0>, '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 0x21098c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2109d50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464520836.593079-651912951', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:49:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:49:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:49:47 INFO - Using env: {'DISPLAY': ':0', 05:49:47 INFO - 'HOME': '/home/cltbld', 05:49:47 INFO - 'LANG': 'en_US.UTF-8', 05:49:47 INFO - 'LANGUAGE': 'en_US:en', 05:49:47 INFO - 'LOGNAME': 'cltbld', 05:49:47 INFO - 'MAIL': '/var/mail/cltbld', 05:49:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:47 INFO - 'MOZ_NO_REMOTE': '1', 05:49:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:47 INFO - 'NO_EM_RESTART': '1', 05:49:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:47 INFO - 'PWD': '/builds/slave/test', 05:49:47 INFO - 'SHELL': '/bin/bash', 05:49:47 INFO - 'SHLVL': '1', 05:49:47 INFO - 'TERM': 'linux', 05:49:47 INFO - 'TMOUT': '86400', 05:49:47 INFO - 'USER': 'cltbld', 05:49:47 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464520836.593079-651912951', 05:49:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:47 INFO - '_': '/tools/buildbot/bin/python'} 05:49:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:49:47 INFO - Running setup.py (path:/tmp/pip-N6rZy2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:49:47 INFO - Running setup.py (path:/tmp/pip-xZLN21-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:49:47 INFO - Running setup.py (path:/tmp/pip-DaE9ay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:49:47 INFO - Running setup.py (path:/tmp/pip-G2xWtZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:49:47 INFO - Running setup.py (path:/tmp/pip-sRjrMS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:49:47 INFO - Running setup.py (path:/tmp/pip-Vw_BKk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:49:47 INFO - Running setup.py (path:/tmp/pip-2RgF1U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:49:47 INFO - Running setup.py (path:/tmp/pip-1vxf_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:49:47 INFO - Running setup.py (path:/tmp/pip-2TiXJI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:49:48 INFO - Running setup.py (path:/tmp/pip-olAZFl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:49:48 INFO - Running setup.py (path:/tmp/pip-P0_Snn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:49:48 INFO - Running setup.py (path:/tmp/pip-kU9TG1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:49:48 INFO - Running setup.py (path:/tmp/pip-h0JhgC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:49:48 INFO - Running setup.py (path:/tmp/pip-axvJIy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:49:48 INFO - Running setup.py (path:/tmp/pip-CnMCPT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:49:48 INFO - Running setup.py (path:/tmp/pip-VtQibi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:49:48 INFO - Running setup.py (path:/tmp/pip-YZpx6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:49:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:49:48 INFO - Running setup.py install for manifestparser 05:49:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:49:48 INFO - Running setup.py install for mozcrash 05:49:48 INFO - Running setup.py install for mozdebug 05:49:48 INFO - Running setup.py install for mozdevice 05:49:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:49:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:49:49 INFO - Running setup.py install for mozfile 05:49:49 INFO - Running setup.py install for mozhttpd 05:49:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:49:49 INFO - Running setup.py install for mozinfo 05:49:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:49:49 INFO - Running setup.py install for mozInstall 05:49:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:49:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:49:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:49:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:49:49 INFO - Running setup.py install for mozleak 05:49:49 INFO - Running setup.py install for mozlog 05:49:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:49:49 INFO - Running setup.py install for moznetwork 05:49:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:49:49 INFO - Running setup.py install for mozprocess 05:49:49 INFO - Running setup.py install for mozprofile 05:49:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:49:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:49:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:49:49 INFO - Running setup.py install for mozrunner 05:49:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:49:50 INFO - Running setup.py install for mozscreenshot 05:49:50 INFO - Running setup.py install for moztest 05:49:50 INFO - Running setup.py install for mozversion 05:49:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:49:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:49:50 INFO - Cleaning up... 05:49:50 INFO - Return code: 0 05:49:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:49:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:50 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 0x7f72c1d67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2079770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21089c0>, '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 0x21098c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2109d50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464520836.593079-651912951', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:49:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:49:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:49:50 INFO - Using env: {'DISPLAY': ':0', 05:49:50 INFO - 'HOME': '/home/cltbld', 05:49:50 INFO - 'LANG': 'en_US.UTF-8', 05:49:50 INFO - 'LANGUAGE': 'en_US:en', 05:49:50 INFO - 'LOGNAME': 'cltbld', 05:49:50 INFO - 'MAIL': '/var/mail/cltbld', 05:49:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:50 INFO - 'MOZ_NO_REMOTE': '1', 05:49:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:50 INFO - 'NO_EM_RESTART': '1', 05:49:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:50 INFO - 'PWD': '/builds/slave/test', 05:49:50 INFO - 'SHELL': '/bin/bash', 05:49:50 INFO - 'SHLVL': '1', 05:49:50 INFO - 'TERM': 'linux', 05:49:50 INFO - 'TMOUT': '86400', 05:49:50 INFO - 'USER': 'cltbld', 05:49:50 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464520836.593079-651912951', 05:49:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:50 INFO - '_': '/tools/buildbot/bin/python'} 05:49:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:49:50 INFO - Running setup.py (path:/tmp/pip-2E8l2P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:49:50 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:49:50 INFO - Running setup.py (path:/tmp/pip-sOnRSE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:49:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:49:50 INFO - Running setup.py (path:/tmp/pip-lGpWyK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:49:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:49:50 INFO - Running setup.py (path:/tmp/pip-LgDIdX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:49:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:49:50 INFO - Running setup.py (path:/tmp/pip-wOdldi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:49:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:49:50 INFO - Running setup.py (path:/tmp/pip-Pf8teq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:49:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:49:50 INFO - Running setup.py (path:/tmp/pip-2yod2h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:49:51 INFO - Running setup.py (path:/tmp/pip-YjnvFZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:49:51 INFO - Running setup.py (path:/tmp/pip-LgeonM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:49:51 INFO - Running setup.py (path:/tmp/pip-aiZraj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:49:51 INFO - Running setup.py (path:/tmp/pip-4SYxrO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:49:51 INFO - Running setup.py (path:/tmp/pip-MVJ2nB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:49:51 INFO - Running setup.py (path:/tmp/pip-iOqexI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:49:51 INFO - Running setup.py (path:/tmp/pip-lJ7Kl5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:49:51 INFO - Running setup.py (path:/tmp/pip-1zoRAJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:49:51 INFO - Running setup.py (path:/tmp/pip-wSab9s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:49:51 INFO - Running setup.py (path:/tmp/pip-60u89m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:49:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:49:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:49:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:53 INFO - Downloading blessings-1.6.tar.gz 05:49:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:49:53 INFO - Installing collected packages: blessings 05:49:53 INFO - Running setup.py install for blessings 05:49:53 INFO - Successfully installed blessings 05:49:53 INFO - Cleaning up... 05:49:53 INFO - Return code: 0 05:49:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:49:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:49:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:49:54 INFO - Reading from file tmpfile_stdout 05:49:54 INFO - Current package versions: 05:49:54 INFO - argparse == 1.2.1 05:49:54 INFO - blessings == 1.6 05:49:54 INFO - blobuploader == 1.2.4 05:49:54 INFO - docopt == 0.6.1 05:49:54 INFO - manifestparser == 1.1 05:49:54 INFO - mozInstall == 1.12 05:49:54 INFO - mozcrash == 0.17 05:49:54 INFO - mozdebug == 0.1 05:49:54 INFO - mozdevice == 0.48 05:49:54 INFO - mozfile == 1.2 05:49:54 INFO - mozhttpd == 0.7 05:49:54 INFO - mozinfo == 0.9 05:49:54 INFO - mozleak == 0.1 05:49:54 INFO - mozlog == 3.2 05:49:54 INFO - moznetwork == 0.27 05:49:54 INFO - mozprocess == 0.22 05:49:54 INFO - mozprofile == 0.28 05:49:54 INFO - mozrunner == 6.11 05:49:54 INFO - mozscreenshot == 0.1 05:49:54 INFO - mozsystemmonitor == 0.3 05:49:54 INFO - moztest == 0.7 05:49:54 INFO - mozversion == 1.4 05:49:54 INFO - psutil == 3.1.1 05:49:54 INFO - requests == 1.2.3 05:49:54 INFO - wsgiref == 0.1.2 05:49:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:49:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:54 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 0x7f72c1d67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2079770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21089c0>, '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 0x21098c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2109d50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464520836.593079-651912951', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:49:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:49:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:49:54 INFO - Using env: {'DISPLAY': ':0', 05:49:54 INFO - 'HOME': '/home/cltbld', 05:49:54 INFO - 'LANG': 'en_US.UTF-8', 05:49:54 INFO - 'LANGUAGE': 'en_US:en', 05:49:54 INFO - 'LOGNAME': 'cltbld', 05:49:54 INFO - 'MAIL': '/var/mail/cltbld', 05:49:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:54 INFO - 'MOZ_NO_REMOTE': '1', 05:49:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:54 INFO - 'NO_EM_RESTART': '1', 05:49:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:54 INFO - 'PWD': '/builds/slave/test', 05:49:54 INFO - 'SHELL': '/bin/bash', 05:49:54 INFO - 'SHLVL': '1', 05:49:54 INFO - 'TERM': 'linux', 05:49:54 INFO - 'TMOUT': '86400', 05:49:54 INFO - 'USER': 'cltbld', 05:49:54 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464520836.593079-651912951', 05:49:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:54 INFO - '_': '/tools/buildbot/bin/python'} 05:49:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:49:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:49:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:49:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:49:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:49:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:49:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:49:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:49:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:49:54 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:49:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:49:54 INFO - Cleaning up... 05:49:54 INFO - Return code: 0 05:49:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:49:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:54 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 0x7f72c1d67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2079770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21089c0>, '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 0x21098c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2109d50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464520836.593079-651912951', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:49:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:49:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:49:54 INFO - Using env: {'DISPLAY': ':0', 05:49:54 INFO - 'HOME': '/home/cltbld', 05:49:54 INFO - 'LANG': 'en_US.UTF-8', 05:49:54 INFO - 'LANGUAGE': 'en_US:en', 05:49:54 INFO - 'LOGNAME': 'cltbld', 05:49:54 INFO - 'MAIL': '/var/mail/cltbld', 05:49:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:54 INFO - 'MOZ_NO_REMOTE': '1', 05:49:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:54 INFO - 'NO_EM_RESTART': '1', 05:49:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:54 INFO - 'PWD': '/builds/slave/test', 05:49:54 INFO - 'SHELL': '/bin/bash', 05:49:54 INFO - 'SHLVL': '1', 05:49:54 INFO - 'TERM': 'linux', 05:49:54 INFO - 'TMOUT': '86400', 05:49:54 INFO - 'USER': 'cltbld', 05:49:54 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464520836.593079-651912951', 05:49:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:54 INFO - '_': '/tools/buildbot/bin/python'} 05:49:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:54 INFO - Downloading/unpacking jsonschema 05:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:49:56 INFO - Downloading/unpacking functools32 (from jsonschema) 05:49:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:56 INFO - Downloading functools32-3.2.3-2.tar.gz 05:49:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:49:56 INFO - warning: no files found matching '*.txt' 05:49:56 INFO - no previously-included directories found matching 'build' 05:49:56 INFO - no previously-included directories found matching 'dist' 05:49:56 INFO - no previously-included directories found matching '.git*' 05:49:56 INFO - Installing collected packages: jsonschema, functools32 05:49:56 INFO - Running setup.py install for functools32 05:49:56 INFO - warning: no files found matching '*.txt' 05:49:56 INFO - no previously-included directories found matching 'build' 05:49:56 INFO - no previously-included directories found matching 'dist' 05:49:56 INFO - no previously-included directories found matching '.git*' 05:49:56 INFO - Successfully installed jsonschema functools32 05:49:56 INFO - Cleaning up... 05:49:56 INFO - Return code: 0 05:49:56 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:49:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:49:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f72c1d67f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2079770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21089c0>, '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 0x21098c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2109d50>, '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': '82c74bd3bc9a11c5833d2010000001e6-1464520836.593079-651912951', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:49:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:49:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:49:56 INFO - Using env: {'DISPLAY': ':0', 05:49:56 INFO - 'HOME': '/home/cltbld', 05:49:56 INFO - 'LANG': 'en_US.UTF-8', 05:49:56 INFO - 'LANGUAGE': 'en_US:en', 05:49:56 INFO - 'LOGNAME': 'cltbld', 05:49:56 INFO - 'MAIL': '/var/mail/cltbld', 05:49:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:56 INFO - 'MOZ_NO_REMOTE': '1', 05:49:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:56 INFO - 'NO_EM_RESTART': '1', 05:49:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:56 INFO - 'PWD': '/builds/slave/test', 05:49:56 INFO - 'SHELL': '/bin/bash', 05:49:56 INFO - 'SHLVL': '1', 05:49:56 INFO - 'TERM': 'linux', 05:49:56 INFO - 'TMOUT': '86400', 05:49:56 INFO - 'USER': 'cltbld', 05:49:56 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464520836.593079-651912951', 05:49:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:56 INFO - '_': '/tools/buildbot/bin/python'} 05:49:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:57 INFO - Downloading/unpacking flake8 05:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:49:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:49:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:49:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:49:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:49:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:49:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:49:59 INFO - no previously-included directories found matching 'docs/_build' 05:49:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:49:59 INFO - Running setup.py install for pep8 05:49:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:49:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:49:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:49:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:49:59 INFO - no previously-included directories found matching 'docs/_build' 05:49:59 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:49:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:49:59 INFO - Cleaning up... 05:49:59 INFO - Return code: 0 05:49:59 INFO - Running post-action listener: _resource_record_post_action 05:49:59 INFO - Running post-action listener: _start_resource_monitoring 05:50:00 INFO - Starting resource monitoring. 05:50:00 INFO - ##### 05:50:00 INFO - ##### Finished create-virtualenv step (success) 05:50:00 INFO - ##### 05:50:00 INFO - ##### 05:50:00 INFO - ##### Running install step. 05:50:00 INFO - ##### 05:50:00 INFO - Running pre-action listener: _resource_record_pre_action 05:50:00 INFO - Running main action method: install 05:50:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:50:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:50:00 INFO - Reading from file tmpfile_stdout 05:50:00 INFO - Detecting whether we're running mozinstall >=1.0... 05:50:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:50:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:50:00 INFO - Reading from file tmpfile_stdout 05:50:00 INFO - Output received: 05:50:00 INFO - Usage: mozinstall [options] installer 05:50:00 INFO - Options: 05:50:00 INFO - -h, --help show this help message and exit 05:50:00 INFO - -d DEST, --destination=DEST 05:50:00 INFO - Directory to install application into. [default: 05:50:00 INFO - "/builds/slave/test"] 05:50:00 INFO - --app=APP Application being installed. [default: firefox] 05:50:00 INFO - mkdir: /builds/slave/test/build/application 05:50:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:50:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:50:16 INFO - Reading from file tmpfile_stdout 05:50:16 INFO - Output received: 05:50:16 INFO - /builds/slave/test/build/application/firefox/firefox 05:50:16 INFO - Running post-action listener: _resource_record_post_action 05:50:16 INFO - ##### 05:50:16 INFO - ##### Finished install step (success) 05:50:16 INFO - ##### 05:50:16 INFO - ##### 05:50:16 INFO - ##### Running run-tests step. 05:50:16 INFO - ##### 05:50:16 INFO - Running pre-action listener: _resource_record_pre_action 05:50:16 INFO - Running main action method: run_tests 05:50:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:50:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:50:16 INFO - Python 2.7.3 05:50:16 INFO - Return code: 0 05:50:16 INFO - grabbing minidump binary from tooltool 05:50:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:16 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 0x21089c0>, '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 0x21098c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2109d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:50:16 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:50:16 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:50:16 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:50:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:50:17 INFO - Return code: 0 05:50:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:50:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:50:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:50:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:50:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:50:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:50:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:50:17 INFO - Return code: 0 05:50:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JuBLYmqoQq6Aag8Ekb85ag/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 05:50:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JuBLYmqoQq6Aag8Ekb85ag/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --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 05:50:17 INFO - Using env: {'DISPLAY': ':0', 05:50:17 INFO - 'HOME': '/home/cltbld', 05:50:17 INFO - 'LANG': 'en_US.UTF-8', 05:50:17 INFO - 'LANGUAGE': 'en_US:en', 05:50:17 INFO - 'LOGNAME': 'cltbld', 05:50:17 INFO - 'MAIL': '/var/mail/cltbld', 05:50:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:50:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:50:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:17 INFO - 'MOZ_NO_REMOTE': '1', 05:50:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:50:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:17 INFO - 'NO_EM_RESTART': '1', 05:50:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:17 INFO - 'PWD': '/builds/slave/test', 05:50:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:50:17 INFO - 'SHELL': '/bin/bash', 05:50:17 INFO - 'SHLVL': '1', 05:50:17 INFO - 'TERM': 'linux', 05:50:17 INFO - 'TMOUT': '86400', 05:50:17 INFO - 'USER': 'cltbld', 05:50:17 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1464520836.593079-651912951', 05:50:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:17 INFO - '_': '/tools/buildbot/bin/python'} 05:50:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JuBLYmqoQq6Aag8Ekb85ag/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 05:50:18 INFO - mozversion application_buildid: 20160529030212 05:50:18 INFO - mozversion application_changeset: 2c7440e46d8786b2c82a1d2004e2b6d9d13f4046 05:50:18 INFO - mozversion application_display_name: Nightly 05:50:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:50:18 INFO - mozversion application_name: Firefox 05:50:18 INFO - mozversion application_remotingname: firefox 05:50:18 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:50:18 INFO - mozversion application_vendor: Mozilla 05:50:18 INFO - mozversion application_version: 49.0a1 05:50:18 INFO - mozversion platform_buildid: 20160529030212 05:50:18 INFO - mozversion platform_changeset: 2c7440e46d8786b2c82a1d2004e2b6d9d13f4046 05:50:18 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:50:18 INFO - mozversion platform_version: 49.0a1 05:50:18 INFO - using testdate: 1464526218 05:50:18 INFO - actual date: 1464526218 05:50:18 INFO - starting webserver on 'localhost:47479' 05:50:18 INFO - SUITE-START | Running 2 tests 05:50:18 INFO - TEST-START | dromaeo_css 05:50:18 INFO - operating with platform_type : linux_ 05:50:18 INFO - Initialising browser for dromaeo_css test... 05:50:18 INFO - TEST-INFO | started process 24457 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqVDniF/profile http://localhost:47479/getInfo.html) 05:50:22 INFO - PROCESS | 24457 | __metrics Screen width/height:1600/1200 05:50:22 INFO - PROCESS | 24457 | colorDepth:24 05:50:22 INFO - PROCESS | 24457 | Browser inner width/height: 1024/697 05:50:22 INFO - PROCESS | 24457 | __metrics 05:50:23 ERROR - PROCESS | 24457 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:50:24 INFO - TEST-INFO | 24457: exit 0 05:50:24 INFO - Browser initialized. 05:50:24 INFO - Running cycle 1/1 for dromaeo_css test... 05:50:24 INFO - TEST-INFO | started process 24538 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqVDniF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:50:36 INFO - PROCESS | 24538 | RSS: Main: 155693056 05:50:36 INFO - PROCESS | 24538 | 05:51:27 INFO - PROCESS | 24538 | 1464526287609 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:53:35 INFO - PROCESS | 24538 | Cycle 1(1): loaded http://localhost:47479/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47479/tests/dromaeo/cssquery-ext.html) 05:53:36 INFO - PROCESS | 24538 | RSS: Main: 247869440 05:53:36 INFO - PROCESS | 24538 | 05:56:39 INFO - PROCESS | 24538 | Cycle 1(1): loaded http://localhost:47479/tests/dromaeo/cssquery-ext.html (next: http://localhost:47479/tests/dromaeo/cssquery-jquery.html) 05:56:39 INFO - PROCESS | 24538 | RSS: Main: 240361472 05:56:39 INFO - PROCESS | 24538 | 05:59:41 INFO - PROCESS | 24538 | Cycle 1(1): loaded http://localhost:47479/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47479/tests/dromaeo/cssquery-mootools.html) 05:59:42 INFO - PROCESS | 24538 | RSS: Main: 246792192 05:59:42 INFO - PROCESS | 24538 | 06:02:44 INFO - PROCESS | 24538 | Cycle 1(1): loaded http://localhost:47479/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47479/tests/dromaeo/cssquery-prototype.html) 06:02:44 INFO - PROCESS | 24538 | RSS: Main: 240336896 06:02:44 INFO - PROCESS | 24538 | 06:05:47 INFO - PROCESS | 24538 | Cycle 1(1): loaded http://localhost:47479/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47479/tests/dromaeo/cssquery-yui.html) 06:05:48 INFO - PROCESS | 24538 | RSS: Main: 229949440 06:05:48 INFO - PROCESS | 24538 | 06:08:50 INFO - PROCESS | 24538 | Cycle 1(1): loaded http://localhost:47479/tests/dromaeo/cssquery-yui.html (next: http://localhost:47479/tests/dromaeo/cssquery-dojo.html) 06:08:51 INFO - PROCESS | 24538 | RSS: Main: 326651904 06:08:51 INFO - PROCESS | 24538 | 06:08:51 INFO - PROCESS | 24538 | __start_tp_report 06:08:51 INFO - PROCESS | 24538 | _x_x_mozilla_page_load 06:08:51 INFO - PROCESS | 24538 | _x_x_mozilla_page_load_details 06:08:51 INFO - PROCESS | 24538 | |i|pagename|runs| 06:08:51 INFO - PROCESS | 24538 | |0;dojo.html;3185.761067919906;3188.7608429367788;3216.7426605871533;3217.967820321796;3253.8861139860096;5380.408155102936;5464.754086066127;5554.777808887645;5671.06427439472;5671.347795003576;5433.4566543345645;5497.175423686449;5514.6139770216105;5541.307336582927;5542.5565954723625;4966.354373931393;5000.674956127858;5023.799048038074;5043.722595257259;5261.684298942076;5111.488851114896;5156.974215128919;5196.948030519684;5206.114960456713;5211.583073354142;4872.8050877965015;4909.631777616675;4927.260910863363;4941.950580494203;4964.230544265609;4891.364122664067;4900.558949694509;4977.104121258172;4979.278004689299;5010.574101201366;4793.616510679138;4925.21196608541;4936.308916751657;4936.8765780855765;4968.826091086831;5400.432954539795;5457.672539647594;5481.985832620978;5541.612087153861;5547.750351234205;5954.732037058343;5970.850728731773;5985.850353741148;5990.430909063632;5995.640261584319;5611.915821262684;5979.9402005980255;6037.788677396314;6041.879162416727;6044.395560443964;5446.1558458439;5497.257870187514;5497.670139791585;5569.888602228014;5578.0517312057045;6085.450403728091;6106.145139680449;6107.5157562764025;6120.548409105651;6122.295935967331;5706.201131841545;5749.712514374264;5874.265716785402;5882.176495290662;5882.3529411764675;5905.645661260252;5961.850953726105;6017.608855424383;6019.247594050744;6022.789202377983;5881.088431293071;5938.554608404387;5954.3152537458745;5959.016762234182;5968.612040217372;5762;5876.853078673067;5916.881662366729;5928.584999050111;5973.970130149321;4519.892626306576;4528.864134075983;4531.252343363308;4566.383538222364;4566.703164294377;4011.498562679665;4013.3779264214095;4032.9798351008058;4056.14820887611;4056.817443215062;5486.341639003265;5553.527950124204;5596.776128954878;5657.745401456944;5681.602287839894;6026;6033.849153771191;6040.305364883006;6042.848928776728;6106.175666285084;5676.943230567642;5681.857953551112;5687.943120568824;5690.146478028329;5699.287589051369;4994.375703037121;5031.195008798648;5040.974795126001;5092.28707980883;5176.6635168714665;6097.706167156046;6104.762330457818;6117.614269788186;6118.527810132562;6119.868162944292;5905.704714764159;5957.91063134062;5958.582899197015;5961.970190149022;5992.700364981646;5957.7319020645045;6097.817065488042;6111.205543279345;6114.145302971568;6132.324915438508;5918;5953.255843019622;5958.791442299499;5968.641881487125;6013.067974463965;6035.275766907999;6058.606190597597;6066.241719785027;6077.24034495688;6078;5490.80782172622;5666.15007748841;5732.16883551891;5743.052396354555;5785.739641716217;5727.656340619576;5731.684757338387;5733.283339582552;5734.3692193857805;5745.3105627324985;5486.423925487926;5556;5565.415631358811;5569.8607534810335;5575.219469274224;5840.8247752567495;5897.705114744332;5898.911516327173;5997.820065398045;6005.279366476051;5769.68266745333;5812.099124635688;5814.7964821232745;5816.76732930678;5818.738156782871 06:08:51 INFO - PROCESS | 24538 | |1;ext.html;615.9445649891509;628.5945565110504;634.6921742954668;643.8036398898337;652.7323797243131;43577.56422435779;45087;45141.322880156826;48140.759296203556;48151.51848481514;45398.77300613492;45972;45987.540124598745;46040.539594604044;46053.30920036202;8746.300295976322;8916.331275154356;8931.24084452819;8931.95534022329;8937.50843703596;8704.99892512363;8785.648574057062;8794.6921857735;8803.823923521526;8809.911900881005;8805.823883522326;8868.15752503511;8871.512066836322;8877.201051905327;8879;8772.298216142757;8814.955925220396;8818.33862460318;8857.335699822539;8872.334574906909;8643.913560864437;8726.08376120511;8744.693935712283;8746.300295976307;8753.43102698329;42487.787561061996;42866.571334286884;42884;42911.141777164594;42930.14139717188;3389.2882494676146;3599.0282623691455;3629.292288003814;4034.3545032794905;4212.241796476633;30693.386132277454;31279.37441251185;31565.84217078923;32360.19099522507;32791.344173116646;4081.938770918409;4099.938500922489;4113.239050775616;4149.2738770715305;4240.766757828318;363565.18217409006;366710;367257;368116;368351;50961.745191274546;57418.42581574214;57588.71205644029;58061.4193858056;58197;54118.18822717662;58052.67789288381;58954.41045589575;59056.40943590595;64977.35022649713;16722.916385418237;16830.410935617194;16843.494695159166;16867.156642167844;16891.23989420479;11353.943230283796;12626.747465050648;12685.746285074247;12690.555830545887;12690.555830545887;15919.283632236577;15972;16206.270717817726;16578.17109144538;16610.6677866442;6132;6148.354422785633;6247.937520624827;6249.78125765596;6285.622862628257;965.9951700241454;1037.3205550364523;1092.7268182954263;1099.543689368903;1203.1577895473029;31544.526832097537;31801;32449.35101297961;32478.35043299168;32610;1123.971900702489;1124.668222874254;1132.252713209278;1137.9943100284445;1161.233585833363;16590.17049147538;16851.578710532336;17011.404600838912;17101.914490427716;17327.2202750874;538455;541092;543794;543795;544122;57550.7122464385;57567.712161438925;57651.13523297154;57755.42244577585;57764;1261.7602655495427;1357.6130802721177;1384.7992041154178;1402.8316602007824;1406.4866323791741;31922.36155276835;33164.50253246252;33243;33796.662033379354;34031;49607;50098.49901500938;50141;50143.498565013884;50164.247536287716;444258;446390;446827;448260;448346;34335.65664343325;35023.824880875436;35253.471197932566;35263;35343.29313413666;47219.29171062368;47276.527234728586;48055.519444805104;48518;48571;39678.40482392824;39979;40556.39165412462;40576.79711601423;41533.79233103815;39866.80066599648;40013.1997360057;40813.59186408217;41191.1761764769;41387.79306103571;40218.39672404858;40794;41599.58400415957;41622.58377416308;41640.16719665529;34579.65420345865;35269.29461410809;35770.463443047855;36552.268954620224;36880.262394751415;27842.44315113646;28322.433551328446;28462.85768571144;28492;28611.570826437204 06:08:51 INFO - PROCESS | 24538 | |2;jquery.html;391.89418856908634;398.9062570295982;401.2756973662542;402.097291580402;419.62024367947;14198.432062717504;17522.474325770214;17667.11664416779;19241.807581924193;19285.517862053457;18130.637387252245;18160.909195454038;18565.071746412694;18997.715034274497;19015;5510.504054635072;5581.944180558204;5705.572082093839;5724.971375143118;5728;4067.9186416271655;5489.917651235235;5609.467100625434;5633.380328163898;6030.306514750794;6242.1261023456755;6328.303886572473;6344.587601805868;6345.714442850082;6361.9363806362035;6239.157713708682;6280.120783090349;6320.5891617044745;6398.328175541547;6415.87168256637;5586.078297080977;5596.440355964371;5601.243832082658;5608.887822243573;5618.634788738719;21881.452963675878;22079;22897;23100.53798924012;23104.65343019856;2316.9652455213186;2404.4349577849193;2519.3197836584204;2523.9495210095697;2546.108861898321;13528.391222395016;13794.310284485837;14012.71974560503;14189;14539.054961427473;1882.3129557711475;1939.534511717192;1943.426689126711;1955.354732938127;2002.91988320467;72659.63670181615;75593;77069.22930770733;78971;80822;10375.584976600852;10824.458777061272;10846.620368287073;11082.889171108347;11261;12350.567730129402;13007.284599347127;14750.336234869457;14951.925240373728;15236.847631523764;7263.527870688388;7416.25837416254;7424.591647459441;7778.64996075178;8283.37874659403;8025.438219324591;8049.315808156255;8094.31198348147;8104.797380065427;8151.551664658501;4670.486246512881;4683.320918466803;4701.529847015271;4715.151272770934;4750.358701575312;1902.1345287893976;1917.8273955344087;1923.7306777051224;1997.9400617981485;2003.3989803059314;982.6266018912768;987.8666380038746;1059.8092343378266;1071.9303245289032;1104.4974536585835;18365.265389384276;19407.223711051683;19450.610987780165;19453.90273048654;19616.411507654793;973.4159504297365;985.6156099121348;991.3110388280076;999.5751805482786;1007.4106647611083;8246.670133194724;10435.791284174275;10790.136789056856;10812.459377031117;10824.891751082389;471009;478834;479726;482693;485236;94206.41149180887;94605;94764.52617736867;96132.51933740286;97785.51107244418;950.8336041192902;972.6887396033343;987.2694206287296;987.7086259553449;991.9652812151685;14357.64105897361;17427.204483240377;17699.292028318723;17813.643727125644;18025.909870450563;40727.59272407238;40869.38695919504;41386.172276554906;42246;43272.783636081615;55031.17453238124;57436.42563574478;58344;58442;58678.413215867295;7444.553326800409;7745;8400.201980811813;8697.08680588529;8755.824883502168;12396.318202498589;12874.613761587167;12904.41930113166;13050.804237936249;13055.281959492318;10630.574777008833;11149.386783726648;11159.27464714791;11264.718382040515;11447.828282575601;9950.701478955643;11027.724306892393;11080.778384432428;11430.942845285721;11502.194846360675;10520.842187367043;11006.834897476705;11042.503087360927;11190.496427660937;11212.943935280271;8273.379496537664;8584.399092063495;8642.35182361338;8682.175193356621;8712.259457946146;8184.386171037077;10734.83897741519;10937.781244375226;11008.789033206502;11110.055645270242 06:08:51 INFO - PROCESS | 24538 | |3;mootools.html;1397.1267957526545;1490.5081323163356;1535.777312289718;1701.9829801701987;1838.3290099113829;8528.189821966911;8785.60464779085;8806.515641639715;9093.681721139761;9115.088491150882;8896.688615898445;9092.136247056536;9096.408733432323;9102.772430689236;9114.225290850269;2089.9582008359826;2139.743230812305;2310.6765052892524;2368.478934634382;2395.0539536883007;2395.161693407311;2425.320910145162;2430.6232533957264;2434.415740222352;2436.6223235398543;2397.436602398435;2399.2922087983998;2420.721617014048;2425.3209101451534;2426.3691440225493;2031.6749320108786;2266.5013696986634;2303.4817166137655;2307.573098976678;2318.258157389636;2290.4273931517123;2315.560043591712;2318.9420264493356;2321.454458202321;2321.558903808271;8761.34289928258;8801.779955501099;8814.030456649827;8815.250703690193;8815.51514666693;5261.473852614746;5404.945950540523;5430.158325459521;5431.945680543223;5433.6196466247375;3260.951085733716;3334.4498157803932;3395.3718562066097;3398.677125673057;3471.444568868969;1106.441247170182;1118.6084870295413;1125.2348403085898;1126.774645070989;1176.4176732517374;12590.559330423392;12853.293068881208;12952.287624180666;12977.935110324483;12981.610551683465;4810.206315957827;4885;4908.852734417973;4925.655204135676;4943.728094954812;10789.352638841694;10815;10816.67549973502;10824.13406927444;10825;5495.450454954473;5501.944980550224;5504.779808807602;5505.421930697299;5505.779768809283;4328.2425575524785;4856.538628830255;4966.950330496721;4978.153713868651;5060.114479965991;4126.09225970286;4145.191687620945;4157.438745769343;4201.579842015774;4202.2646036943415;1288.8968882489378;1298.2794549025382;1304.7716649586475;1305.8824705776335;1317.157019507516;899.8110396816611;947.6872632031551;967.9516024198903;968.8498282766183;1006.3760468509571;5802.912956305659;6139.416755408229;6201.937980620226;6267.749290028439;6305.14880491137;472.24912389301176;474.0731869195714;474.1820359879181;480.47628085386395;481.70134516599234;4167.958320416757;4191.11986482842;4203.91592168155;4252.192083504125;4318.330658747899;10862.45687715611;11310.377929213972;11319;11321.60374386909;11323;10556.155507559377;11047.613333533449;11054.889451105546;11218.607348742755;11397.202195846377;7996.9200307997335;8082.555459449669;8097.919020809716;8101.351891848638;8117.0665373481625;6191.938080619136;6372.598028433737;6375.458086062737;6407.647579382992;6509.1863517060365;10204.489775511343;10475.580976760844;10547.156227501935;10549.841752373566;10704.09015233714;10681.89318106809;10736.946315268373;10762;10796;10804.24370294072;7168.677409516688;7216.989621452895;7355.632218389166;7391.556506609621;7508.887366689613;8653.913460865562;8864.20222180007;8945.15021072997;8952.373333866566;8963.103689630985;7503.88744168827;7686.3082322589;7829.295363417092;7897.447178697436;7918.168592297956;7637.312641862259;7667;7722.884156737766;7844.64699088531;7849.882251766114;7205.387542058774;7258;7289.125304963438;7292.744753933799;7298.416126709744;5059.5952323814745;5154.484551544965;5331.840044798507;5335.386430560535;5385.434529374359;5332.760025798926;5396.622236443412;5410.567154627699;5558.694271815089;5565.081761509306 06:08:51 INFO - PROCESS | 24538 | |4;prototype.html;317.67438375664955;325.13514052620036;326.41897422587795;327.98488677542997;333.7430178762354;5192.610554208435;5228.607854410925;5236.7119808410525;5249.343832020997;5307.283516725241;5157.252198431225;5186.922196167051;5209.218617207412;5222.216667499867;5253.395859476162;3926.4110383442426;3937.921241575174;4096.262672718909;4104.363823607346;4108.26051310764;4080.1839632073556;4086.7126855040565;4091.468109145807;4106.404571337154;4108.609682080198;3910;4057.797110144481;4070;4080.2655522006025;4089.734167279132;3790.8294126764363;3986.3023970805284;4011.1376054148354;4055.3916912463073;4061.228366610364;3593.964060359389;3603.765755225902;3614.8734794282336;3624.800635965021;3631.2737452509605;4937.7777999990085;4977.552020318189;4997.001199520185;4999.275105109738;5015.84952451427;4516.774161291923;4648.047150334173;4659.58063774262;4663.114008338405;4687.507811679793;5358.758855851496;5361.2226227197225;5383.488568585978;5402.35171779389;5444.754986025639;3934.2492590797106;3939;3942.980285098585;3960.405939109157;3964.980175099135;5363.785448582052;5579.776808927638;5584.581156413245;5604.971975140139;5615.213870058195;3988.4216788565495;4015.8393664253103;4021.597840215955;4047.494063242095;4052.6626213349523;4090.202410529918;4090.447789548373;4090.959090409058;4092.8772136835346;4098.5286692030795;4509.7970591323465;4557.384753058294;4583.983047459107;4628.699134556243;4643.117807616542;5376.623636345496;5432.809851655252;5441.891162176814;5455.18172274162;5456.372517160577;1398.3847107272768;1412.660961369264;1413.6324555615408;1415.688548519324;1418.8368337641098;875.0024198075774;914.3051281026335;914.7027216154777;924.1867156901883;928.6981730937472;5185.766640501187;5264.736763161826;5268.710220937885;5363.704996225167;5365.436629153961;5618.494335509824;5621.915671264935;5627.127795191752;5630.239917611152;5654.236678048493;5154.201098829687;5262.868428289246;5289.841304760786;5305.204219367049;5359.3386050324525;2918.3725499017814;2933.897313594014;2983.1647138801172;3000.6849280825636;3006.1432491739747;5728.971355143198;5747.3677895431465;5780.4508571686465;5812.198218552262;5835.912461313083;5597.496225339739;5657.43425657431;5777.711114444261;5779.653220806765;5779.971100144472;5675.438070690746;5738.196652468658;5743.885122297531;5748.6430563468775;5750.137479378043;5417.593680473901;5593.972030139986;5598.1322894951345;5636.351819540805;5651.92613403452;5504.091824848855;5505.807296744595;5510.9448905510435;5610.18652295423;5630.60585758993;5687.20379146928;5691.459311365414;5710.743016564182;5735.799247026334;5740.655560666373;3961.980190099031;3975;3986.1828325192687;3995.5205375355144;4041.575634558329;5541.2796336476;5551.9722401387735;5580.154121398035;5586.664800112007;5609.691466969356;5512.6968016759465;5517.503424691797;5520.613557050968;5520.806771763129;5545.223668686468;5344.305240318734;5472.753726082416;5511;5511.338639363302;5514.779408823602;5057.848264552069;5303.0908872804985;5342.171963345688;5352.330958630171;5364.168553874156;5115.746642072716;5354.732263386893;5368.597355198453;5372.758225879923;5374.838754837361;5332.413434522277;5353.223782551586;5363.839084827461;5364.96879263215;5394.136938089887 06:08:51 INFO - PROCESS | 24538 | |5;yui.html;751.282525188445;771.4561234329798;795.705588932095;798.6725442568544;808.0989696488417;13593.11644743091;14230.501932432368;14372.209528475956;14393.496227632035;14441;13171;13198.406071726771;13308.401121949511;13330.40013199406;13382.598522044329;645.8708258348325;786.6774622404815;804.6057431858391;810.7648781853255;817.0807841178674;809.8056466448069;812.378530424223;812.4353574265888;812.4434762187891;812.9024517057932;853.0531110467376;853.6926706385697;853.9188777066169;854.2439940652505;854.2567965869702;670.6076944987188;821.6015232612178;847.6058632735808;850.5492089192737;851.1148405658108;610.5176910240905;613.7759717703051;614.9815505534841;615.2801222569605;616.2820314333795;13239.13945593543;13240.404181811842;13258.071934964557;13264.73470530584;13270.73458530824;11966.521339146424;12304.200226985307;12392.938035309857;12737.617871463779;12789.552365667158;10820.67537973862;10907.618233361874;10979.780404391868;11027.393493357862;11216.66350009501;4140.3168477201225;4241.172971270604;4302.548232435612;4305.160493703729;4306.806193721259;57511.71244143794;57544.71227643877;57551.424485755444;58050.41949580535;58650.70674646599;9596.184324332371;9769.316147869724;9996.250281228791;10131.949340253399;10222.744431389126;18374.632507350045;18455.630887382176;18549.90725046366;18563.72154417685;18584.163712632693;7367.852642947111;7406.555606663617;7446.10646722386;7506.774796756106;7634.312911837961;4203.957960420418;4297.226499230169;4332.144391491575;4478.776061196927;4562.977185114053;3307.7353811695007;3377.3751855906735;3385.9492107618407;3390.881319153867;3390.9321813563593;531.8909623527168;602.8040886711836;606.4420732925719;609.6311731402437;609.8871708733899;607.51095368229;651.2510612795229;702.7961891051538;712.5760172697237;773.5358784729118;8883.42257753244;9118.498482583389;9335;9371.062893710574;9599.520023998772;656.6519744535403;754.2985023927799;767.5931756169239;773.5513402226695;821.338822248096;4366.825326986948;4454.1982443159895;4511.526289739596;4563.726176429424;4629.1436084324505;72738.63630681812;72833.63583182156;73759.26240737631;75573.62213188899;75691.62154189304;60881.391186088455;62860;63739;64530.67734661297;64812.351876481574;59877;59953.00234988233;59970;60949.69525152435;61220.38779612236;9535.666251681158;9654.377078435069;9716.75708107303;9725.278838236509;9765.560549775419;38069.4289585662;38418.231635367694;38930.221395572495;39226.411603826535;40349.39475907922;46944;47651.285230720874;48867.75566122147;50324;54038;11422.82865757031;11858.76282474363;12090.939545302217;12105;12218.144729868824;13102.148360356547;13313.467461301827;13366.331683415596;13479;13766.793498097737;12609.292687189694;12797.296148711537;12827.615171544869;12996.285204313854;13068.346582670638;11318.60384886525;11441.599544015919;12120.939395302967;12615.747685046432;12618.49526018949;12337.753244935231;12701.93649031749;12753.426095825896;12949.611511654666;13114.278714670785;10089.798204035731;10143.188544916242;10224.284300098921;10350.120239779702;10373.118284945562;9293.62825487;9345.338772261683;9629.566669499749;10288.691339259834;10442.738931526772 06:08:51 INFO - PROCESS | 24538 | __end_tp_report 06:08:51 INFO - PROCESS | 24538 | __start_cc_report 06:08:51 INFO - PROCESS | 24538 | _x_x_mozilla_cycle_collect,862 06:08:51 INFO - PROCESS | 24538 | __end_cc_report 06:08:51 INFO - PROCESS | 24538 | __startTimestamp1464527331188__endTimestamp 06:08:51 INFO - PROCESS | 24538 | 06:08:51 INFO - PROCESS | 24538 | ------- Summary: start ------- 06:08:51 INFO - PROCESS | 24538 | Number of tests: 6 06:08:51 INFO - PROCESS | 24538 | 06:08:51 INFO - PROCESS | 24538 | [#0] dojo.html Cycles:165 Average:5509.56 Median:5699.29 stddev:642.15 (11.3%) stddev-sans-first:617.70 06:08:51 INFO - PROCESS | 24538 | Values: 3185.8 3188.8 3216.7 3218.0 3253.9 5380.4 5464.8 5554.8 5671.1 5671.3 5433.5 5497.2 5514.6 5541.3 5542.6 4966.4 5000.7 5023.8 5043.7 5261.7 5111.5 5157.0 5196.9 5206.1 5211.6 4872.8 4909.6 4927.3 4942.0 4964.2 4891.4 4900.6 4977.1 4979.3 5010.6 4793.6 4925.2 4936.3 4936.9 4968.8 5400.4 5457.7 5482.0 5541.6 5547.8 5954.7 5970.9 5985.9 5990.4 5995.6 5611.9 5979.9 6037.8 6041.9 6044.4 5446.2 5497.3 5497.7 5569.9 5578.1 6085.5 6106.1 6107.5 6120.5 6122.3 5706.2 5749.7 5874.3 5882.2 5882.4 5905.6 5961.9 6017.6 6019.2 6022.8 5881.1 5938.6 5954.3 5959.0 5968.6 5762.0 5876.9 5916.9 5928.6 5974.0 4519.9 4528.9 4531.3 4566.4 4566.7 4011.5 4013.4 4033.0 4056.1 4056.8 5486.3 5553.5 5596.8 5657.7 5681.6 6026.0 6033.8 6040.3 6042.8 6106.2 5676.9 5681.9 5687.9 5690.1 5699.3 4994.4 5031.2 5041.0 5092.3 5176.7 6097.7 6104.8 6117.6 6118.5 6119.9 5905.7 5957.9 5958.6 5962.0 5992.7 5957.7 6097.8 6111.2 6114.1 6132.3 5918.0 5953.3 5958.8 5968.6 6013.1 6035.3 6058.6 6066.2 6077.2 6078.0 5490.8 5666.2 5732.2 5743.1 5785.7 5727.7 5731.7 5733.3 5734.4 5745.3 5486.4 5556.0 5565.4 5569.9 5575.2 5840.8 5897.7 5898.9 5997.8 6005.3 5769.7 5812.1 5814.8 5816.8 5818.7 06:08:51 INFO - PROCESS | 24538 | 06:08:51 INFO - PROCESS | 24538 | [#1] ext.html Cycles:180 Average:61256.16 Median:41631.38 stddev:121320.66 (291.4%) stddev-sans-first:121575.57 06:08:51 INFO - PROCESS | 24538 | Values: 615.9 628.6 634.7 643.8 652.7 43577.6 45087.0 45141.3 48140.8 48151.5 45398.8 45972.0 45987.5 46040.5 46053.3 8746.3 8916.3 8931.2 8932.0 8937.5 8705.0 8785.6 8794.7 8803.8 8809.9 8805.8 8868.2 8871.5 8877.2 8879.0 8772.3 8815.0 8818.3 8857.3 8872.3 8643.9 8726.1 8744.7 8746.3 8753.4 42487.8 42866.6 42884.0 42911.1 42930.1 3389.3 3599.0 3629.3 4034.4 4212.2 30693.4 31279.4 31565.8 32360.2 32791.3 4081.9 4099.9 4113.2 4149.3 4240.8 363565.2 366710.0 367257.0 368116.0 368351.0 50961.7 57418.4 57588.7 58061.4 58197.0 54118.2 58052.7 58954.4 59056.4 64977.4 16722.9 16830.4 16843.5 16867.2 16891.2 11353.9 12626.7 12685.7 12690.6 12690.6 15919.3 15972.0 16206.3 16578.2 16610.7 6132.0 6148.4 6247.9 6249.8 6285.6 966.0 1037.3 1092.7 1099.5 1203.2 31544.5 31801.0 32449.4 32478.4 32610.0 1124.0 1124.7 1132.3 1138.0 1161.2 16590.2 16851.6 17011.4 17101.9 17327.2 538455.0 541092.0 543794.0 543795.0 544122.0 57550.7 57567.7 57651.1 57755.4 57764.0 1261.8 1357.6 1384.8 1402.8 1406.5 31922.4 33164.5 33243.0 33796.7 34031.0 49607.0 50098.5 50141.0 50143.5 50164.2 444258.0 446390.0 446827.0 448260.0 448346.0 34335.7 35023.8 35253.5 35263.0 35343.3 47219.3 47276.5 48055.5 48518.0 48571.0 39678.4 39979.0 40556.4 40576.8 41533.8 39866.8 40013.2 40813.6 41191.2 41387.8 40218.4 40794.0 41599.6 41622.6 41640.2 34579.7 35269.3 35770.5 36552.3 36880.3 27842.4 28322.4 28462.9 28492.0 28611.6 06:08:51 INFO - PROCESS | 24538 | 06:08:51 INFO - PROCESS | 24538 | [#2] jquery.html Cycles:180 Average:28561.16 Median:22397.76 stddev:79148.18 (353.4%) stddev-sans-first:79341.95 06:08:51 INFO - PROCESS | 24538 | Values: 391.9 398.9 401.3 402.1 419.6 14198.4 17522.5 17667.1 19241.8 19285.5 18130.6 18160.9 18565.1 18997.7 19015.0 5510.5 5581.9 5705.6 5725.0 5728.0 4067.9 5489.9 5609.5 5633.4 6030.3 6242.1 6328.3 6344.6 6345.7 6361.9 6239.2 6280.1 6320.6 6398.3 6415.9 5586.1 5596.4 5601.2 5608.9 5618.6 21881.5 22079.0 22897.0 23100.5 23104.7 2317.0 2404.4 2519.3 2523.9 2546.1 13528.4 13794.3 14012.7 14189.0 14539.1 1882.3 1939.5 1943.4 1955.4 2002.9 72659.6 75593.0 77069.2 78971.0 80822.0 10375.6 10824.5 10846.6 11082.9 11261.0 12350.6 13007.3 14750.3 14951.9 15236.8 7263.5 7416.3 7424.6 7778.6 8283.4 8025.4 8049.3 8094.3 8104.8 8151.6 4670.5 4683.3 4701.5 4715.2 4750.4 1902.1 1917.8 1923.7 1997.9 2003.4 982.6 987.9 1059.8 1071.9 1104.5 18365.3 19407.2 19450.6 19453.9 19616.4 973.4 985.6 991.3 999.6 1007.4 8246.7 10435.8 10790.1 10812.5 10824.9 471009.0 478834.0 479726.0 482693.0 485236.0 94206.4 94605.0 94764.5 96132.5 97785.5 950.8 972.7 987.3 987.7 992.0 14357.6 17427.2 17699.3 17813.6 18025.9 40727.6 40869.4 41386.2 42246.0 43272.8 55031.2 57436.4 58344.0 58442.0 58678.4 7444.6 7745.0 8400.2 8697.1 8755.8 12396.3 12874.6 12904.4 13050.8 13055.3 10630.6 11149.4 11159.3 11264.7 11447.8 9950.7 11027.7 11080.8 11430.9 11502.2 10520.8 11006.8 11042.5 11190.5 11212.9 8273.4 8584.4 8642.4 8682.2 8712.3 8184.4 10734.8 10937.8 11008.8 11110.1 06:08:51 INFO - PROCESS | 24538 | 06:08:51 INFO - PROCESS | 24538 | [#3] mootools.html Cycles:180 Average:5937.34 Median:481.09 stddev:3425.42 (712.0%) stddev-sans-first:3418.04 06:08:51 INFO - PROCESS | 24538 | Values: 1397.1 1490.5 1535.8 1702.0 1838.3 8528.2 8785.6 8806.5 9093.7 9115.1 8896.7 9092.1 9096.4 9102.8 9114.2 2090.0 2139.7 2310.7 2368.5 2395.1 2395.2 2425.3 2430.6 2434.4 2436.6 2397.4 2399.3 2420.7 2425.3 2426.4 2031.7 2266.5 2303.5 2307.6 2318.3 2290.4 2315.6 2318.9 2321.5 2321.6 8761.3 8801.8 8814.0 8815.3 8815.5 5261.5 5404.9 5430.2 5431.9 5433.6 3261.0 3334.4 3395.4 3398.7 3471.4 1106.4 1118.6 1125.2 1126.8 1176.4 12590.6 12853.3 12952.3 12977.9 12981.6 4810.2 4885.0 4908.9 4925.7 4943.7 10789.4 10815.0 10816.7 10824.1 10825.0 5495.5 5501.9 5504.8 5505.4 5505.8 4328.2 4856.5 4967.0 4978.2 5060.1 4126.1 4145.2 4157.4 4201.6 4202.3 1288.9 1298.3 1304.8 1305.9 1317.2 899.8 947.7 968.0 968.8 1006.4 5802.9 6139.4 6201.9 6267.7 6305.1 472.2 474.1 474.2 480.5 481.7 4168.0 4191.1 4203.9 4252.2 4318.3 10862.5 11310.4 11319.0 11321.6 11323.0 10556.2 11047.6 11054.9 11218.6 11397.2 7996.9 8082.6 8097.9 8101.4 8117.1 6191.9 6372.6 6375.5 6407.6 6509.2 10204.5 10475.6 10547.2 10549.8 10704.1 10681.9 10736.9 10762.0 10796.0 10804.2 7168.7 7217.0 7355.6 7391.6 7508.9 8653.9 8864.2 8945.2 8952.4 8963.1 7503.9 7686.3 7829.3 7897.4 7918.2 7637.3 7667.0 7722.9 7844.6 7849.9 7205.4 7258.0 7289.1 7292.7 7298.4 5059.6 5154.5 5331.8 5335.4 5385.4 5332.8 5396.6 5410.6 5558.7 5565.1 06:08:51 INFO - PROCESS | 24538 | 06:08:51 INFO - PROCESS | 24538 | [#4] prototype.html Cycles:180 Average:4590.81 Median:5279.28 stddev:1344.51 (25.5%) stddev-sans-first:1309.47 06:08:51 INFO - PROCESS | 24538 | Values: 317.7 325.1 326.4 328.0 333.7 5192.6 5228.6 5236.7 5249.3 5307.3 5157.3 5186.9 5209.2 5222.2 5253.4 3926.4 3937.9 4096.3 4104.4 4108.3 4080.2 4086.7 4091.5 4106.4 4108.6 3910.0 4057.8 4070.0 4080.3 4089.7 3790.8 3986.3 4011.1 4055.4 4061.2 3594.0 3603.8 3614.9 3624.8 3631.3 4937.8 4977.6 4997.0 4999.3 5015.8 4516.8 4648.0 4659.6 4663.1 4687.5 5358.8 5361.2 5383.5 5402.4 5444.8 3934.2 3939.0 3943.0 3960.4 3965.0 5363.8 5579.8 5584.6 5605.0 5615.2 3988.4 4015.8 4021.6 4047.5 4052.7 4090.2 4090.4 4091.0 4092.9 4098.5 4509.8 4557.4 4584.0 4628.7 4643.1 5376.6 5432.8 5441.9 5455.2 5456.4 1398.4 1412.7 1413.6 1415.7 1418.8 875.0 914.3 914.7 924.2 928.7 5185.8 5264.7 5268.7 5363.7 5365.4 5618.5 5621.9 5627.1 5630.2 5654.2 5154.2 5262.9 5289.8 5305.2 5359.3 2918.4 2933.9 2983.2 3000.7 3006.1 5729.0 5747.4 5780.5 5812.2 5835.9 5597.5 5657.4 5777.7 5779.7 5780.0 5675.4 5738.2 5743.9 5748.6 5750.1 5417.6 5594.0 5598.1 5636.4 5651.9 5504.1 5505.8 5510.9 5610.2 5630.6 5687.2 5691.5 5710.7 5735.8 5740.7 3962.0 3975.0 3986.2 3995.5 4041.6 5541.3 5552.0 5580.2 5586.7 5609.7 5512.7 5517.5 5520.6 5520.8 5545.2 5344.3 5472.8 5511.0 5511.3 5514.8 5057.8 5303.1 5342.2 5352.3 5364.2 5115.7 5354.7 5368.6 5372.8 5374.8 5332.4 5353.2 5363.8 5365.0 5394.1 06:08:51 INFO - PROCESS | 24538 | 06:08:51 INFO - PROCESS | 24538 | [#5] yui.html Cycles:180 Average:15821.14 Median:48259.52 stddev:19816.88 (41.1%) stddev-sans-first:19840.16 06:08:51 INFO - PROCESS | 24538 | Values: 751.3 771.5 795.7 798.7 808.1 13593.1 14230.5 14372.2 14393.5 14441.0 13171.0 13198.4 13308.4 13330.4 13382.6 645.9 786.7 804.6 810.8 817.1 809.8 812.4 812.4 812.4 812.9 853.1 853.7 853.9 854.2 854.3 670.6 821.6 847.6 850.5 851.1 610.5 613.8 615.0 615.3 616.3 13239.1 13240.4 13258.1 13264.7 13270.7 11966.5 12304.2 12392.9 12737.6 12789.6 10820.7 10907.6 10979.8 11027.4 11216.7 4140.3 4241.2 4302.5 4305.2 4306.8 57511.7 57544.7 57551.4 58050.4 58650.7 9596.2 9769.3 9996.3 10131.9 10222.7 18374.6 18455.6 18549.9 18563.7 18584.2 7367.9 7406.6 7446.1 7506.8 7634.3 4204.0 4297.2 4332.1 4478.8 4563.0 3307.7 3377.4 3385.9 3390.9 3390.9 531.9 602.8 606.4 609.6 609.9 607.5 651.3 702.8 712.6 773.5 8883.4 9118.5 9335.0 9371.1 9599.5 656.7 754.3 767.6 773.6 821.3 4366.8 4454.2 4511.5 4563.7 4629.1 72738.6 72833.6 73759.3 75573.6 75691.6 60881.4 62860.0 63739.0 64530.7 64812.4 59877.0 59953.0 59970.0 60949.7 61220.4 9535.7 9654.4 9716.8 9725.3 9765.6 38069.4 38418.2 38930.2 39226.4 40349.4 46944.0 47651.3 48867.8 50324.0 54038.0 11422.8 11858.8 12090.9 12105.0 12218.1 13102.1 13313.5 13366.3 13479.0 13766.8 12609.3 12797.3 12827.6 12996.3 13068.3 11318.6 11441.6 12120.9 12615.7 12618.5 12337.8 12701.9 12753.4 12949.6 13114.3 10089.8 10143.2 10224.3 10350.1 10373.1 9293.6 9345.3 9629.6 10288.7 10442.7 06:08:51 INFO - PROCESS | 24538 | -------- Summary: end -------- 06:08:51 INFO - PROCESS | 24538 | 06:08:51 INFO - TEST-INFO | 24538: exit 0 06:08:51 INFO - TEST-OK | dromaeo_css | took 1113742ms 06:08:51 INFO - TEST-START | kraken 06:08:51 INFO - operating with platform_type : linux_ 06:08:51 INFO - Initialising browser for kraken test... 06:08:51 INFO - TEST-INFO | started process 24717 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppFTK4a/profile http://localhost:47479/getInfo.html) 06:08:56 INFO - PROCESS | 24717 | __metrics Screen width/height:1600/1200 06:08:56 INFO - PROCESS | 24717 | colorDepth:24 06:08:56 INFO - PROCESS | 24717 | Browser inner width/height: 1024/697 06:08:56 INFO - PROCESS | 24717 | __metrics 06:08:57 ERROR - PROCESS | 24717 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:08:57 INFO - TEST-INFO | 24717: exit 0 06:08:57 INFO - Browser initialized. 06:08:57 INFO - Running cycle 1/1 for kraken test... 06:08:57 INFO - TEST-INFO | started process 24797 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppFTK4a/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:09:09 INFO - PROCESS | 24797 | RSS: Main: 155893760 06:09:09 INFO - PROCESS | 24797 | 06:09:12 INFO - PROCESS | 24797 | Cycle 1(1): loaded http://localhost:47479/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47479/tests/kraken/driver.html?testName=audio-beat-detection) 06:09:13 INFO - PROCESS | 24797 | RSS: Main: 214495232 06:09:13 INFO - PROCESS | 24797 | 06:09:15 INFO - PROCESS | 24797 | Cycle 1(1): loaded http://localhost:47479/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47479/tests/kraken/driver.html?testName=audio-dft) 06:09:16 INFO - PROCESS | 24797 | RSS: Main: 197562368 06:09:16 INFO - PROCESS | 24797 | 06:09:19 INFO - PROCESS | 24797 | Cycle 1(1): loaded http://localhost:47479/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47479/tests/kraken/driver.html?testName=audio-fft) 06:09:20 INFO - PROCESS | 24797 | RSS: Main: 268353536 06:09:20 INFO - PROCESS | 24797 | 06:09:22 INFO - PROCESS | 24797 | Cycle 1(1): loaded http://localhost:47479/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47479/tests/kraken/driver.html?testName=audio-oscillator) 06:09:22 INFO - PROCESS | 24797 | RSS: Main: 178601984 06:09:22 INFO - PROCESS | 24797 | 06:09:24 INFO - PROCESS | 24797 | Cycle 1(1): loaded http://localhost:47479/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47479/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:09:25 INFO - PROCESS | 24797 | RSS: Main: 183386112 06:09:25 INFO - PROCESS | 24797 | 06:09:28 INFO - PROCESS | 24797 | Cycle 1(1): loaded http://localhost:47479/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47479/tests/kraken/driver.html?testName=imaging-darkroom) 06:09:29 INFO - PROCESS | 24797 | RSS: Main: 218009600 06:09:29 INFO - PROCESS | 24797 | 06:09:32 INFO - PROCESS | 24797 | Cycle 1(1): loaded http://localhost:47479/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47479/tests/kraken/driver.html?testName=imaging-desaturate) 06:09:33 INFO - PROCESS | 24797 | RSS: Main: 220033024 06:09:33 INFO - PROCESS | 24797 | 06:09:35 INFO - PROCESS | 24797 | Cycle 1(1): loaded http://localhost:47479/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47479/tests/kraken/driver.html?testName=json-parse-financial) 06:09:36 INFO - PROCESS | 24797 | RSS: Main: 220229632 06:09:36 INFO - PROCESS | 24797 | 06:09:38 INFO - PROCESS | 24797 | Cycle 1(1): loaded http://localhost:47479/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47479/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:09:38 INFO - PROCESS | 24797 | RSS: Main: 206188544 06:09:38 INFO - PROCESS | 24797 | 06:09:40 INFO - PROCESS | 24797 | Cycle 1(1): loaded http://localhost:47479/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47479/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:09:41 INFO - PROCESS | 24797 | RSS: Main: 210534400 06:09:41 INFO - PROCESS | 24797 | 06:09:43 INFO - PROCESS | 24797 | Cycle 1(1): loaded http://localhost:47479/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47479/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:09:43 INFO - PROCESS | 24797 | RSS: Main: 217026560 06:09:43 INFO - PROCESS | 24797 | 06:09:46 INFO - PROCESS | 24797 | Cycle 1(1): loaded http://localhost:47479/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47479/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:09:46 INFO - PROCESS | 24797 | RSS: Main: 221483008 06:09:46 INFO - PROCESS | 24797 | 06:09:49 INFO - PROCESS | 24797 | Cycle 1(1): loaded http://localhost:47479/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47479/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:09:50 INFO - PROCESS | 24797 | RSS: Main: 221675520 06:09:50 INFO - PROCESS | 24797 | 06:09:51 INFO - PROCESS | 24797 | Cycle 1(1): loaded http://localhost:47479/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47479/tests/kraken/driver.html?testName=ai-astar) 06:09:52 INFO - PROCESS | 24797 | RSS: Main: 264663040 06:09:52 INFO - PROCESS | 24797 | 06:09:52 INFO - PROCESS | 24797 | __start_tp_report 06:09:52 INFO - PROCESS | 24797 | _x_x_mozilla_page_load 06:09:52 INFO - PROCESS | 24797 | _x_x_mozilla_page_load_details 06:09:52 INFO - PROCESS | 24797 | |i|pagename|runs| 06:09:52 INFO - PROCESS | 24797 | |0;ai-astar;115;107;109;111;109;111;111;112;111;111 06:09:52 INFO - PROCESS | 24797 | |1;audio-beat-detection;156;130;132;192;124;137;154;124;182;133 06:09:52 INFO - PROCESS | 24797 | |2;audio-dft;160;161;161;160;161;162;160;161;160;161 06:09:52 INFO - PROCESS | 24797 | |3;audio-fft;75;76;77;126;75;75;75;74;97;74 06:09:52 INFO - PROCESS | 24797 | |4;audio-oscillator;83;84;125;84;84;85;129;83;83;128 06:09:52 INFO - PROCESS | 24797 | |5;imaging-gaussian-blur;117;117;116;117;117;116;117;117;116;117 06:09:52 INFO - PROCESS | 24797 | |6;imaging-darkroom;149;148;148;149;149;148;148;148;148;145 06:09:52 INFO - PROCESS | 24797 | |7;imaging-desaturate;95;95;95;95;95;94;94;94;95;95 06:09:52 INFO - PROCESS | 24797 | |8;json-parse-financial;54;52;55;53;51;54;52;52;53;52 06:09:52 INFO - PROCESS | 24797 | |9;json-stringify-tinderbox;64;62;62;64;63;63;63;63;63;62 06:09:52 INFO - PROCESS | 24797 | |10;stanford-crypto-aes;80;79;84;81;86;84;82;80;109;83 06:09:52 INFO - PROCESS | 24797 | |11;stanford-crypto-ccm;128;134;127;117;121;126;125;132;122;119 06:09:52 INFO - PROCESS | 24797 | |12;stanford-crypto-pbkdf2;162;164;159;158;157;163;160;162;157;161 06:09:52 INFO - PROCESS | 24797 | |13;stanford-crypto-sha256-iterative;65;63;69;61;61;65;62;65;65;66 06:09:52 INFO - PROCESS | 24797 | __end_tp_report 06:09:52 INFO - PROCESS | 24797 | __start_cc_report 06:09:52 INFO - PROCESS | 24797 | _x_x_mozilla_cycle_collect,1597 06:09:52 INFO - PROCESS | 24797 | __end_cc_report 06:09:52 INFO - PROCESS | 24797 | __startTimestamp1464527392234__endTimestamp 06:09:52 INFO - PROCESS | 24797 | 06:09:52 INFO - PROCESS | 24797 | ------- Summary: start ------- 06:09:52 INFO - PROCESS | 24797 | Number of tests: 14 06:09:52 INFO - PROCESS | 24797 | 06:09:52 INFO - PROCESS | 24797 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.00 stddev:2.11 (1.9%) stddev-sans-first:1.56 06:09:52 INFO - PROCESS | 24797 | Values: 115.0 107.0 109.0 111.0 109.0 111.0 111.0 112.0 111.0 111.0 06:09:52 INFO - PROCESS | 24797 | 06:09:52 INFO - PROCESS | 24797 | [#1] audio-beat-detection Cycles:10 Average:146.40 Median:145.50 stddev:24.14 (16.6%) stddev-sans-first:25.35 06:09:52 INFO - PROCESS | 24797 | Values: 156.0 130.0 132.0 192.0 124.0 137.0 154.0 124.0 182.0 133.0 06:09:52 INFO - PROCESS | 24797 | 06:09:52 INFO - PROCESS | 24797 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.67 (0.4%) stddev-sans-first:0.67 06:09:52 INFO - PROCESS | 24797 | Values: 160.0 161.0 161.0 160.0 161.0 162.0 160.0 161.0 160.0 161.0 06:09:52 INFO - PROCESS | 24797 | 06:09:52 INFO - PROCESS | 24797 | [#3] audio-fft Cycles:10 Average:82.40 Median:75.00 stddev:16.81 (22.4%) stddev-sans-first:17.62 06:09:52 INFO - PROCESS | 24797 | Values: 75.0 76.0 77.0 126.0 75.0 75.0 75.0 74.0 97.0 74.0 06:09:52 INFO - PROCESS | 24797 | 06:09:52 INFO - PROCESS | 24797 | [#4] audio-oscillator Cycles:10 Average:96.80 Median:83.50 stddev:21.10 (25.3%) stddev-sans-first:21.78 06:09:52 INFO - PROCESS | 24797 | Values: 83.0 84.0 125.0 84.0 84.0 85.0 129.0 83.0 83.0 128.0 06:09:52 INFO - PROCESS | 24797 | 06:09:52 INFO - PROCESS | 24797 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 06:09:52 INFO - PROCESS | 24797 | Values: 117.0 117.0 116.0 117.0 117.0 116.0 117.0 117.0 116.0 117.0 06:09:52 INFO - PROCESS | 24797 | 06:09:52 INFO - PROCESS | 24797 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:1.15 (0.8%) stddev-sans-first:1.17 06:09:52 INFO - PROCESS | 24797 | Values: 149.0 148.0 148.0 149.0 149.0 148.0 148.0 148.0 148.0 145.0 06:09:52 INFO - PROCESS | 24797 | 06:09:52 INFO - PROCESS | 24797 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 06:09:52 INFO - PROCESS | 24797 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 94.0 94.0 95.0 95.0 06:09:52 INFO - PROCESS | 24797 | 06:09:52 INFO - PROCESS | 24797 | [#8] json-parse-financial Cycles:10 Average:52.80 Median:53.00 stddev:1.23 (2.3%) stddev-sans-first:1.22 06:09:52 INFO - PROCESS | 24797 | Values: 54.0 52.0 55.0 53.0 51.0 54.0 52.0 52.0 53.0 52.0 06:09:52 INFO - PROCESS | 24797 | 06:09:52 INFO - PROCESS | 24797 | [#9] json-stringify-tinderbox Cycles:10 Average:62.90 Median:63.00 stddev:0.74 (1.2%) stddev-sans-first:0.67 06:09:52 INFO - PROCESS | 24797 | Values: 64.0 62.0 62.0 64.0 63.0 63.0 63.0 63.0 63.0 62.0 06:09:52 INFO - PROCESS | 24797 | 06:09:52 INFO - PROCESS | 24797 | [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:82.50 stddev:8.78 (10.6%) stddev-sans-first:9.14 06:09:52 INFO - PROCESS | 24797 | Values: 80.0 79.0 84.0 81.0 86.0 84.0 82.0 80.0 109.0 83.0 06:09:52 INFO - PROCESS | 24797 | 06:09:52 INFO - PROCESS | 24797 | [#11] stanford-crypto-ccm Cycles:10 Average:125.10 Median:126.50 stddev:5.47 (4.3%) stddev-sans-first:5.70 06:09:52 INFO - PROCESS | 24797 | Values: 128.0 134.0 127.0 117.0 121.0 126.0 125.0 132.0 122.0 119.0 06:09:52 INFO - PROCESS | 24797 | 06:09:52 INFO - PROCESS | 24797 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.30 Median:161.50 stddev:2.50 (1.5%) stddev-sans-first:2.57 06:09:52 INFO - PROCESS | 24797 | Values: 162.0 164.0 159.0 158.0 157.0 163.0 160.0 162.0 157.0 161.0 06:09:52 INFO - PROCESS | 24797 | 06:09:52 INFO - PROCESS | 24797 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.20 Median:65.00 stddev:2.49 (3.8%) stddev-sans-first:2.62 06:09:52 INFO - PROCESS | 24797 | Values: 65.0 63.0 69.0 61.0 61.0 65.0 62.0 65.0 65.0 66.0 06:09:52 INFO - PROCESS | 24797 | -------- Summary: end -------- 06:09:52 INFO - PROCESS | 24797 | 06:09:53 INFO - TEST-INFO | 24797: exit 0 06:09:53 INFO - TEST-OK | kraken | took 61309ms 06:09:53 INFO - SUITE-END | took 1175s 06:09:53 INFO - Completed test suite (00:19:35) 06:09:53 INFO - javascript benchmark 06:09:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3185.761067919906, 3188.7608429367788, 3216.7426605871533, 3217.967820321796, 3253.8861139860096, 5380.408155102936, 5464.754086066127, 5554.777808887645, 5671.06427439472, 5671.347795003576, 5433.4566543345645, 5497.175423686449, 5514.6139770216105, 5541.307336582927, 5542.5565954723625, 4966.354373931393, 5000.674956127858, 5023.799048038074, 5043.722595257259, 5261.684298942076, 5111.488851114896, 5156.974215128919, 5196.948030519684, 5206.114960456713, 5211.583073354142, 4872.8050877965015, 4909.631777616675, 4927.260910863363, 4941.950580494203, 4964.230544265609, 4891.364122664067, 4900.558949694509, 4977.104121258172, 4979.278004689299, 5010.574101201366, 4793.616510679138, 4925.21196608541, 4936.308916751657, 4936.8765780855765, 4968.826091086831, 5400.432954539795, 5457.672539647594, 5481.985832620978, 5541.612087153861, 5547.750351234205, 5954.732037058343, 5970.850728731773, 5985.850353741148, 5990.430909063632, 5995.640261584319, 5611.915821262684, 5979.9402005980255, 6037.788677396314, 6041.879162416727, 6044.395560443964, 5446.1558458439, 5497.257870187514, 5497.670139791585, 5569.888602228014, 5578.0517312057045, 6085.450403728091, 6106.145139680449, 6107.5157562764025, 6120.548409105651, 6122.295935967331, 5706.201131841545, 5749.712514374264, 5874.265716785402, 5882.176495290662, 5882.3529411764675, 5905.645661260252, 5961.850953726105, 6017.608855424383, 6019.247594050744, 6022.789202377983, 5881.088431293071, 5938.554608404387, 5954.3152537458745, 5959.016762234182, 5968.612040217372, 5762.0, 5876.853078673067, 5916.881662366729, 5928.584999050111, 5973.970130149321, 4519.892626306576, 4528.864134075983, 4531.252343363308, 4566.383538222364, 4566.703164294377, 4011.498562679665, 4013.3779264214095, 4032.9798351008058, 4056.14820887611, 4056.817443215062, 5486.341639003265, 5553.527950124204, 5596.776128954878, 5657.745401456944, 5681.602287839894, 6026.0, 6033.849153771191, 6040.305364883006, 6042.848928776728, 6106.175666285084, 5676.943230567642, 5681.857953551112, 5687.943120568824, 5690.146478028329, 5699.287589051369, 4994.375703037121, 5031.195008798648, 5040.974795126001, 5092.28707980883, 5176.6635168714665, 6097.706167156046, 6104.762330457818, 6117.614269788186, 6118.527810132562, 6119.868162944292, 5905.704714764159, 5957.91063134062, 5958.582899197015, 5961.970190149022, 5992.700364981646, 5957.7319020645045, 6097.817065488042, 6111.205543279345, 6114.145302971568, 6132.324915438508, 5918.0, 5953.255843019622, 5958.791442299499, 5968.641881487125, 6013.067974463965, 6035.275766907999, 6058.606190597597, 6066.241719785027, 6077.24034495688, 6078.0, 5490.80782172622, 5666.15007748841, 5732.16883551891, 5743.052396354555, 5785.739641716217, 5727.656340619576, 5731.684757338387, 5733.283339582552, 5734.3692193857805, 5745.3105627324985, 5486.423925487926, 5556.0, 5565.415631358811, 5569.8607534810335, 5575.219469274224, 5840.8247752567495, 5897.705114744332, 5898.911516327173, 5997.820065398045, 6005.279366476051, 5769.68266745333, 5812.099124635688, 5814.7964821232745, 5816.76732930678, 5818.738156782871], "value": 5465.480300045057, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [615.9445649891509, 628.5945565110504, 634.6921742954668, 643.8036398898337, 652.7323797243131, 43577.56422435779, 45087.0, 45141.322880156826, 48140.759296203556, 48151.51848481514, 45398.77300613492, 45972.0, 45987.540124598745, 46040.539594604044, 46053.30920036202, 8746.300295976322, 8916.331275154356, 8931.24084452819, 8931.95534022329, 8937.50843703596, 8704.99892512363, 8785.648574057062, 8794.6921857735, 8803.823923521526, 8809.911900881005, 8805.823883522326, 8868.15752503511, 8871.512066836322, 8877.201051905327, 8879.0, 8772.298216142757, 8814.955925220396, 8818.33862460318, 8857.335699822539, 8872.334574906909, 8643.913560864437, 8726.08376120511, 8744.693935712283, 8746.300295976307, 8753.43102698329, 42487.787561061996, 42866.571334286884, 42884.0, 42911.141777164594, 42930.14139717188, 3389.2882494676146, 3599.0282623691455, 3629.292288003814, 4034.3545032794905, 4212.241796476633, 30693.386132277454, 31279.37441251185, 31565.84217078923, 32360.19099522507, 32791.344173116646, 4081.938770918409, 4099.938500922489, 4113.239050775616, 4149.2738770715305, 4240.766757828318, 363565.18217409006, 366710.0, 367257.0, 368116.0, 368351.0, 50961.745191274546, 57418.42581574214, 57588.71205644029, 58061.4193858056, 58197.0, 54118.18822717662, 58052.67789288381, 58954.41045589575, 59056.40943590595, 64977.35022649713, 16722.916385418237, 16830.410935617194, 16843.494695159166, 16867.156642167844, 16891.23989420479, 11353.943230283796, 12626.747465050648, 12685.746285074247, 12690.555830545887, 12690.555830545887, 15919.283632236577, 15972.0, 16206.270717817726, 16578.17109144538, 16610.6677866442, 6132.0, 6148.354422785633, 6247.937520624827, 6249.78125765596, 6285.622862628257, 965.9951700241454, 1037.3205550364523, 1092.7268182954263, 1099.543689368903, 1203.1577895473029, 31544.526832097537, 31801.0, 32449.35101297961, 32478.35043299168, 32610.0, 1123.971900702489, 1124.668222874254, 1132.252713209278, 1137.9943100284445, 1161.233585833363, 16590.17049147538, 16851.578710532336, 17011.404600838912, 17101.914490427716, 17327.2202750874, 538455.0, 541092.0, 543794.0, 543795.0, 544122.0, 57550.7122464385, 57567.712161438925, 57651.13523297154, 57755.42244577585, 57764.0, 1261.7602655495427, 1357.6130802721177, 1384.7992041154178, 1402.8316602007824, 1406.4866323791741, 31922.36155276835, 33164.50253246252, 33243.0, 33796.662033379354, 34031.0, 49607.0, 50098.49901500938, 50141.0, 50143.498565013884, 50164.247536287716, 444258.0, 446390.0, 446827.0, 448260.0, 448346.0, 34335.65664343325, 35023.824880875436, 35253.471197932566, 35263.0, 35343.29313413666, 47219.29171062368, 47276.527234728586, 48055.519444805104, 48518.0, 48571.0, 39678.40482392824, 39979.0, 40556.39165412462, 40576.79711601423, 41533.79233103815, 39866.80066599648, 40013.1997360057, 40813.59186408217, 41191.1761764769, 41387.79306103571, 40218.39672404858, 40794.0, 41599.58400415957, 41622.58377416308, 41640.16719665529, 34579.65420345865, 35269.29461410809, 35770.463443047855, 36552.268954620224, 36880.262394751415, 27842.44315113646, 28322.433551328446, 28462.85768571144, 28492.0, 28611.570826437204], "value": 20187.1706201984, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.89418856908634, 398.9062570295982, 401.2756973662542, 402.097291580402, 419.62024367947, 14198.432062717504, 17522.474325770214, 17667.11664416779, 19241.807581924193, 19285.517862053457, 18130.637387252245, 18160.909195454038, 18565.071746412694, 18997.715034274497, 19015.0, 5510.504054635072, 5581.944180558204, 5705.572082093839, 5724.971375143118, 5728.0, 4067.9186416271655, 5489.917651235235, 5609.467100625434, 5633.380328163898, 6030.306514750794, 6242.1261023456755, 6328.303886572473, 6344.587601805868, 6345.714442850082, 6361.9363806362035, 6239.157713708682, 6280.120783090349, 6320.5891617044745, 6398.328175541547, 6415.87168256637, 5586.078297080977, 5596.440355964371, 5601.243832082658, 5608.887822243573, 5618.634788738719, 21881.452963675878, 22079.0, 22897.0, 23100.53798924012, 23104.65343019856, 2316.9652455213186, 2404.4349577849193, 2519.3197836584204, 2523.9495210095697, 2546.108861898321, 13528.391222395016, 13794.310284485837, 14012.71974560503, 14189.0, 14539.054961427473, 1882.3129557711475, 1939.534511717192, 1943.426689126711, 1955.354732938127, 2002.91988320467, 72659.63670181615, 75593.0, 77069.22930770733, 78971.0, 80822.0, 10375.584976600852, 10824.458777061272, 10846.620368287073, 11082.889171108347, 11261.0, 12350.567730129402, 13007.284599347127, 14750.336234869457, 14951.925240373728, 15236.847631523764, 7263.527870688388, 7416.25837416254, 7424.591647459441, 7778.64996075178, 8283.37874659403, 8025.438219324591, 8049.315808156255, 8094.31198348147, 8104.797380065427, 8151.551664658501, 4670.486246512881, 4683.320918466803, 4701.529847015271, 4715.151272770934, 4750.358701575312, 1902.1345287893976, 1917.8273955344087, 1923.7306777051224, 1997.9400617981485, 2003.3989803059314, 982.6266018912768, 987.8666380038746, 1059.8092343378266, 1071.9303245289032, 1104.4974536585835, 18365.265389384276, 19407.223711051683, 19450.610987780165, 19453.90273048654, 19616.411507654793, 973.4159504297365, 985.6156099121348, 991.3110388280076, 999.5751805482786, 1007.4106647611083, 8246.670133194724, 10435.791284174275, 10790.136789056856, 10812.459377031117, 10824.891751082389, 471009.0, 478834.0, 479726.0, 482693.0, 485236.0, 94206.41149180887, 94605.0, 94764.52617736867, 96132.51933740286, 97785.51107244418, 950.8336041192902, 972.6887396033343, 987.2694206287296, 987.7086259553449, 991.9652812151685, 14357.64105897361, 17427.204483240377, 17699.292028318723, 17813.643727125644, 18025.909870450563, 40727.59272407238, 40869.38695919504, 41386.172276554906, 42246.0, 43272.783636081615, 55031.17453238124, 57436.42563574478, 58344.0, 58442.0, 58678.413215867295, 7444.553326800409, 7745.0, 8400.201980811813, 8697.08680588529, 8755.824883502168, 12396.318202498589, 12874.613761587167, 12904.41930113166, 13050.804237936249, 13055.281959492318, 10630.574777008833, 11149.386783726648, 11159.27464714791, 11264.718382040515, 11447.828282575601, 9950.701478955643, 11027.724306892393, 11080.778384432428, 11430.942845285721, 11502.194846360675, 10520.842187367043, 11006.834897476705, 11042.503087360927, 11190.496427660937, 11212.943935280271, 8273.379496537664, 8584.399092063495, 8642.35182361338, 8682.175193356621, 8712.259457946146, 8184.386171037077, 10734.83897741519, 10937.781244375226, 11008.789033206502, 11110.055645270242], "value": 9163.01425775396, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1397.1267957526545, 1490.5081323163356, 1535.777312289718, 1701.9829801701987, 1838.3290099113829, 8528.189821966911, 8785.60464779085, 8806.515641639715, 9093.681721139761, 9115.088491150882, 8896.688615898445, 9092.136247056536, 9096.408733432323, 9102.772430689236, 9114.225290850269, 2089.9582008359826, 2139.743230812305, 2310.6765052892524, 2368.478934634382, 2395.0539536883007, 2395.161693407311, 2425.320910145162, 2430.6232533957264, 2434.415740222352, 2436.6223235398543, 2397.436602398435, 2399.2922087983998, 2420.721617014048, 2425.3209101451534, 2426.3691440225493, 2031.6749320108786, 2266.5013696986634, 2303.4817166137655, 2307.573098976678, 2318.258157389636, 2290.4273931517123, 2315.560043591712, 2318.9420264493356, 2321.454458202321, 2321.558903808271, 8761.34289928258, 8801.779955501099, 8814.030456649827, 8815.250703690193, 8815.51514666693, 5261.473852614746, 5404.945950540523, 5430.158325459521, 5431.945680543223, 5433.6196466247375, 3260.951085733716, 3334.4498157803932, 3395.3718562066097, 3398.677125673057, 3471.444568868969, 1106.441247170182, 1118.6084870295413, 1125.2348403085898, 1126.774645070989, 1176.4176732517374, 12590.559330423392, 12853.293068881208, 12952.287624180666, 12977.935110324483, 12981.610551683465, 4810.206315957827, 4885.0, 4908.852734417973, 4925.655204135676, 4943.728094954812, 10789.352638841694, 10815.0, 10816.67549973502, 10824.13406927444, 10825.0, 5495.450454954473, 5501.944980550224, 5504.779808807602, 5505.421930697299, 5505.779768809283, 4328.2425575524785, 4856.538628830255, 4966.950330496721, 4978.153713868651, 5060.114479965991, 4126.09225970286, 4145.191687620945, 4157.438745769343, 4201.579842015774, 4202.2646036943415, 1288.8968882489378, 1298.2794549025382, 1304.7716649586475, 1305.8824705776335, 1317.157019507516, 899.8110396816611, 947.6872632031551, 967.9516024198903, 968.8498282766183, 1006.3760468509571, 5802.912956305659, 6139.416755408229, 6201.937980620226, 6267.749290028439, 6305.14880491137, 472.24912389301176, 474.0731869195714, 474.1820359879181, 480.47628085386395, 481.70134516599234, 4167.958320416757, 4191.11986482842, 4203.91592168155, 4252.192083504125, 4318.330658747899, 10862.45687715611, 11310.377929213972, 11319.0, 11321.60374386909, 11323.0, 10556.155507559377, 11047.613333533449, 11054.889451105546, 11218.607348742755, 11397.202195846377, 7996.9200307997335, 8082.555459449669, 8097.919020809716, 8101.351891848638, 8117.0665373481625, 6191.938080619136, 6372.598028433737, 6375.458086062737, 6407.647579382992, 6509.1863517060365, 10204.489775511343, 10475.580976760844, 10547.156227501935, 10549.841752373566, 10704.09015233714, 10681.89318106809, 10736.946315268373, 10762.0, 10796.0, 10804.24370294072, 7168.677409516688, 7216.989621452895, 7355.632218389166, 7391.556506609621, 7508.887366689613, 8653.913460865562, 8864.20222180007, 8945.15021072997, 8952.373333866566, 8963.103689630985, 7503.88744168827, 7686.3082322589, 7829.295363417092, 7897.447178697436, 7918.168592297956, 7637.312641862259, 7667.0, 7722.884156737766, 7844.64699088531, 7849.882251766114, 7205.387542058774, 7258.0, 7289.125304963438, 7292.744753933799, 7298.416126709744, 5059.5952323814745, 5154.484551544965, 5331.840044798507, 5335.386430560535, 5385.434529374359, 5332.760025798926, 5396.622236443412, 5410.567154627699, 5558.694271815089, 5565.081761509306], "value": 4653.3918753370535, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.67438375664955, 325.13514052620036, 326.41897422587795, 327.98488677542997, 333.7430178762354, 5192.610554208435, 5228.607854410925, 5236.7119808410525, 5249.343832020997, 5307.283516725241, 5157.252198431225, 5186.922196167051, 5209.218617207412, 5222.216667499867, 5253.395859476162, 3926.4110383442426, 3937.921241575174, 4096.262672718909, 4104.363823607346, 4108.26051310764, 4080.1839632073556, 4086.7126855040565, 4091.468109145807, 4106.404571337154, 4108.609682080198, 3910.0, 4057.797110144481, 4070.0, 4080.2655522006025, 4089.734167279132, 3790.8294126764363, 3986.3023970805284, 4011.1376054148354, 4055.3916912463073, 4061.228366610364, 3593.964060359389, 3603.765755225902, 3614.8734794282336, 3624.800635965021, 3631.2737452509605, 4937.7777999990085, 4977.552020318189, 4997.001199520185, 4999.275105109738, 5015.84952451427, 4516.774161291923, 4648.047150334173, 4659.58063774262, 4663.114008338405, 4687.507811679793, 5358.758855851496, 5361.2226227197225, 5383.488568585978, 5402.35171779389, 5444.754986025639, 3934.2492590797106, 3939.0, 3942.980285098585, 3960.405939109157, 3964.980175099135, 5363.785448582052, 5579.776808927638, 5584.581156413245, 5604.971975140139, 5615.213870058195, 3988.4216788565495, 4015.8393664253103, 4021.597840215955, 4047.494063242095, 4052.6626213349523, 4090.202410529918, 4090.447789548373, 4090.959090409058, 4092.8772136835346, 4098.5286692030795, 4509.7970591323465, 4557.384753058294, 4583.983047459107, 4628.699134556243, 4643.117807616542, 5376.623636345496, 5432.809851655252, 5441.891162176814, 5455.18172274162, 5456.372517160577, 1398.3847107272768, 1412.660961369264, 1413.6324555615408, 1415.688548519324, 1418.8368337641098, 875.0024198075774, 914.3051281026335, 914.7027216154777, 924.1867156901883, 928.6981730937472, 5185.766640501187, 5264.736763161826, 5268.710220937885, 5363.704996225167, 5365.436629153961, 5618.494335509824, 5621.915671264935, 5627.127795191752, 5630.239917611152, 5654.236678048493, 5154.201098829687, 5262.868428289246, 5289.841304760786, 5305.204219367049, 5359.3386050324525, 2918.3725499017814, 2933.897313594014, 2983.1647138801172, 3000.6849280825636, 3006.1432491739747, 5728.971355143198, 5747.3677895431465, 5780.4508571686465, 5812.198218552262, 5835.912461313083, 5597.496225339739, 5657.43425657431, 5777.711114444261, 5779.653220806765, 5779.971100144472, 5675.438070690746, 5738.196652468658, 5743.885122297531, 5748.6430563468775, 5750.137479378043, 5417.593680473901, 5593.972030139986, 5598.1322894951345, 5636.351819540805, 5651.92613403452, 5504.091824848855, 5505.807296744595, 5510.9448905510435, 5610.18652295423, 5630.60585758993, 5687.20379146928, 5691.459311365414, 5710.743016564182, 5735.799247026334, 5740.655560666373, 3961.980190099031, 3975.0, 3986.1828325192687, 3995.5205375355144, 4041.575634558329, 5541.2796336476, 5551.9722401387735, 5580.154121398035, 5586.664800112007, 5609.691466969356, 5512.6968016759465, 5517.503424691797, 5520.613557050968, 5520.806771763129, 5545.223668686468, 5344.305240318734, 5472.753726082416, 5511.0, 5511.338639363302, 5514.779408823602, 5057.848264552069, 5303.0908872804985, 5342.171963345688, 5352.330958630171, 5364.168553874156, 5115.746642072716, 5354.732263386893, 5368.597355198453, 5372.758225879923, 5374.838754837361, 5332.413434522277, 5353.223782551586, 5363.839084827461, 5364.96879263215, 5394.136938089887], "value": 4161.163830215144, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [751.282525188445, 771.4561234329798, 795.705588932095, 798.6725442568544, 808.0989696488417, 13593.11644743091, 14230.501932432368, 14372.209528475956, 14393.496227632035, 14441.0, 13171.0, 13198.406071726771, 13308.401121949511, 13330.40013199406, 13382.598522044329, 645.8708258348325, 786.6774622404815, 804.6057431858391, 810.7648781853255, 817.0807841178674, 809.8056466448069, 812.378530424223, 812.4353574265888, 812.4434762187891, 812.9024517057932, 853.0531110467376, 853.6926706385697, 853.9188777066169, 854.2439940652505, 854.2567965869702, 670.6076944987188, 821.6015232612178, 847.6058632735808, 850.5492089192737, 851.1148405658108, 610.5176910240905, 613.7759717703051, 614.9815505534841, 615.2801222569605, 616.2820314333795, 13239.13945593543, 13240.404181811842, 13258.071934964557, 13264.73470530584, 13270.73458530824, 11966.521339146424, 12304.200226985307, 12392.938035309857, 12737.617871463779, 12789.552365667158, 10820.67537973862, 10907.618233361874, 10979.780404391868, 11027.393493357862, 11216.66350009501, 4140.3168477201225, 4241.172971270604, 4302.548232435612, 4305.160493703729, 4306.806193721259, 57511.71244143794, 57544.71227643877, 57551.424485755444, 58050.41949580535, 58650.70674646599, 9596.184324332371, 9769.316147869724, 9996.250281228791, 10131.949340253399, 10222.744431389126, 18374.632507350045, 18455.630887382176, 18549.90725046366, 18563.72154417685, 18584.163712632693, 7367.852642947111, 7406.555606663617, 7446.10646722386, 7506.774796756106, 7634.312911837961, 4203.957960420418, 4297.226499230169, 4332.144391491575, 4478.776061196927, 4562.977185114053, 3307.7353811695007, 3377.3751855906735, 3385.9492107618407, 3390.881319153867, 3390.9321813563593, 531.8909623527168, 602.8040886711836, 606.4420732925719, 609.6311731402437, 609.8871708733899, 607.51095368229, 651.2510612795229, 702.7961891051538, 712.5760172697237, 773.5358784729118, 8883.42257753244, 9118.498482583389, 9335.0, 9371.062893710574, 9599.520023998772, 656.6519744535403, 754.2985023927799, 767.5931756169239, 773.5513402226695, 821.338822248096, 4366.825326986948, 4454.1982443159895, 4511.526289739596, 4563.726176429424, 4629.1436084324505, 72738.63630681812, 72833.63583182156, 73759.26240737631, 75573.62213188899, 75691.62154189304, 60881.391186088455, 62860.0, 63739.0, 64530.67734661297, 64812.351876481574, 59877.0, 59953.00234988233, 59970.0, 60949.69525152435, 61220.38779612236, 9535.666251681158, 9654.377078435069, 9716.75708107303, 9725.278838236509, 9765.560549775419, 38069.4289585662, 38418.231635367694, 38930.221395572495, 39226.411603826535, 40349.39475907922, 46944.0, 47651.285230720874, 48867.75566122147, 50324.0, 54038.0, 11422.82865757031, 11858.76282474363, 12090.939545302217, 12105.0, 12218.144729868824, 13102.148360356547, 13313.467461301827, 13366.331683415596, 13479.0, 13766.793498097737, 12609.292687189694, 12797.296148711537, 12827.615171544869, 12996.285204313854, 13068.346582670638, 11318.60384886525, 11441.599544015919, 12120.939395302967, 12615.747685046432, 12618.49526018949, 12337.753244935231, 12701.93649031749, 12753.426095825896, 12949.611511654666, 13114.278714670785, 10089.798204035731, 10143.188544916242, 10224.284300098921, 10350.120239779702, 10373.118284945562, 9293.62825487, 9345.338772261683, 9629.566669499749, 10288.691339259834, 10442.738931526772], "value": 6765.816721832766, "unit": "score"}], "name": "dromaeo_css", "value": 7139.733747594901, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 107.0, 109.0, 111.0, 109.0, 111.0, 111.0, 112.0, 111.0, 111.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 130.0, 132.0, 192.0, 124.0, 137.0, 154.0, 124.0, 182.0, 133.0], "value": 146.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 160.0, 161.0, 162.0, 160.0, 161.0, 160.0, 161.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 126.0, 75.0, 75.0, 75.0, 74.0, 97.0, 74.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 125.0, 84.0, 84.0, 85.0, 129.0, 83.0, 83.0, 128.0], "value": 96.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 148.0, 149.0, 149.0, 148.0, 148.0, 148.0, 148.0, 145.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 94.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 55.0, 53.0, 51.0, 54.0, 52.0, 52.0, 53.0, 52.0], "value": 52.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 62.0, 64.0, 63.0, 63.0, 63.0, 63.0, 63.0, 62.0], "value": 62.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 84.0, 81.0, 86.0, 84.0, 82.0, 80.0, 109.0, 83.0], "value": 84.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 134.0, 127.0, 117.0, 121.0, 126.0, 125.0, 132.0, 122.0, 119.0], "value": 125.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 159.0, 158.0, 157.0, 163.0, 160.0, 162.0, 157.0, 161.0], "value": 160.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 69.0, 61.0, 61.0, 65.0, 62.0, 65.0, 65.0, 66.0], "value": 64.2, "unit": "score"}], "name": "kraken", "value": 1506.5, "alertThreshold": 2.0}]} 06:09:53 INFO - Return code: 0 06:09:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:09:53 ERROR - # TBPL SUCCESS # 06:09:53 INFO - Running post-action listener: _resource_record_post_action 06:09:53 INFO - ##### 06:09:53 INFO - ##### Finished run-tests step (success) 06:09:53 INFO - ##### 06:09:53 INFO - Running post-run listener: _resource_record_post_run 06:09:53 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 510021632; Read time: 12; Write time: 515172 06:09:53 INFO - TinderboxPrint: CPU usage
13.1% 06:09:53 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 06:09:53 INFO - TinderboxPrint: I/O write bytes / time
510,021,632 / 515,172 06:09:53 INFO - TinderboxPrint: CPU idle
8,274.5 (86.9%) 06:09:53 INFO - TinderboxPrint: CPU user
1,199.3 (12.6%) 06:09:53 INFO - TinderboxPrint: Swap in / out
0 / 0 06:09:53 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 219541504; Read time: 0; Write time: 331988 06:09:53 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290402304; Read time: 12; Write time: 183184 06:09:54 INFO - Running post-run listener: _upload_blobber_files 06:09:54 INFO - Blob upload gear active. 06:09:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:09:54 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 06:09:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:09:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:09:54 INFO - (blobuploader) - INFO - Open directory for files ... 06:09:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:09:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:09:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:09:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:09:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:09:58 INFO - (blobuploader) - INFO - Done attempting. 06:09:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:09:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:09:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:09:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:09:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:09:59 INFO - (blobuploader) - INFO - Done attempting. 06:09:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:09:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:09:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:10:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:10:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:10:00 INFO - (blobuploader) - INFO - Done attempting. 06:10:00 INFO - (blobuploader) - INFO - Iteration through files over. 06:10:00 INFO - Return code: 0 06:10:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:10:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:10:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1268a9a40f8c43aa6dbe125c83adf39a22056ba5989632f6eedb01c878e714bd6f972e37f73a412ff2921594e438eebffcd5a4ef8c1e7d4fd8ad24d4648ec72f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/67fdc9a20fbfbc9ceb908febbfd8ed34c5c278bf84091792daf44d57a6afdca864d78a34b1e8085fee58145cb60540a482b8e2b3634f4bc80c9b9737f0a75756", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8ab9dce5207ddc610b8f1e56afb4c3ed528beb89059004f780c1e3900c15744141428b629565fb3b43e619226dac9af54868b4ec15c67c5aaa034b50b53503b0"} 06:10:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:10:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:10:00 INFO - Contents: 06:10:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1268a9a40f8c43aa6dbe125c83adf39a22056ba5989632f6eedb01c878e714bd6f972e37f73a412ff2921594e438eebffcd5a4ef8c1e7d4fd8ad24d4648ec72f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/67fdc9a20fbfbc9ceb908febbfd8ed34c5c278bf84091792daf44d57a6afdca864d78a34b1e8085fee58145cb60540a482b8e2b3634f4bc80c9b9737f0a75756", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8ab9dce5207ddc610b8f1e56afb4c3ed528beb89059004f780c1e3900c15744141428b629565fb3b43e619226dac9af54868b4ec15c67c5aaa034b50b53503b0"} 06:10:00 INFO - Running post-run listener: copy_logs_to_upload_dir 06:10:00 INFO - Copying logs to upload dir... 06:10:00 INFO - mkdir: /builds/slave/test/build/upload/logs 06:10:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.504253 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-05-29 06:09:59.033236) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-29 06:09:59.042990) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1464520836.593079-651912951 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1268a9a40f8c43aa6dbe125c83adf39a22056ba5989632f6eedb01c878e714bd6f972e37f73a412ff2921594e438eebffcd5a4ef8c1e7d4fd8ad24d4648ec72f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/67fdc9a20fbfbc9ceb908febbfd8ed34c5c278bf84091792daf44d57a6afdca864d78a34b1e8085fee58145cb60540a482b8e2b3634f4bc80c9b9737f0a75756", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8ab9dce5207ddc610b8f1e56afb4c3ed528beb89059004f780c1e3900c15744141428b629565fb3b43e619226dac9af54868b4ec15c67c5aaa034b50b53503b0"} build_url:https://queue.taskcluster.net/v1/task/JuBLYmqoQq6Aag8Ekb85ag/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011237 build_url: 'https://queue.taskcluster.net/v1/task/JuBLYmqoQq6Aag8Ekb85ag/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1268a9a40f8c43aa6dbe125c83adf39a22056ba5989632f6eedb01c878e714bd6f972e37f73a412ff2921594e438eebffcd5a4ef8c1e7d4fd8ad24d4648ec72f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/67fdc9a20fbfbc9ceb908febbfd8ed34c5c278bf84091792daf44d57a6afdca864d78a34b1e8085fee58145cb60540a482b8e2b3634f4bc80c9b9737f0a75756", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8ab9dce5207ddc610b8f1e56afb4c3ed528beb89059004f780c1e3900c15744141428b629565fb3b43e619226dac9af54868b4ec15c67c5aaa034b50b53503b0"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-29 06:09:59.068540) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-29 06:09:59.068860) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1464520836.593079-651912951 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004447 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-29 06:09:59.153378) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-29 06:09:59.153736) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-29 06:09:59.154023) ========= ========= Total master_lag: 0.16 =========