builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-052 starttime: 1466771200.41 results: success (0) buildid: 20160624023758 builduid: c93e4c60148e44dd80e347d7cffee231 revision: cc7b9052413aea1efe4f89e13b941ca2f5cc2915 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 05:26:40.411616) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 05:26:40.412168) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 05:26:40.412485) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 05:26:40.429942) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 05:26:40.430586) ========= 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=826874ccc97bd7bf541b4875000001d5-1466771199.893664-1481594588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-24 05:26:40-- 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% 113M=0s 2016-06-24 05:26:40 (113 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.077738 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 05:26:40.525232) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 05:26:40.525594) ========= 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=826874ccc97bd7bf541b4875000001d5-1466771199.893664-1481594588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021236 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 05:26:40.575052) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 05:26:40.575443) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev cc7b9052413aea1efe4f89e13b941ca2f5cc2915 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev cc7b9052413aea1efe4f89e13b941ca2f5cc2915 --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=826874ccc97bd7bf541b4875000001d5-1466771199.893664-1481594588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-24 05:26:40,879 truncating revision to first 12 chars 2016-06-24 05:26:40,879 Setting DEBUG logging. 2016-06-24 05:26:40,880 attempt 1/10 2016-06-24 05:26:40,880 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/cc7b9052413a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-24 05:26:41,222 unpacking tar archive at: mozilla-beta-cc7b9052413a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.966290 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 05:26:41.556705) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 05:26:41.557110) ========= script_repo_revision: cc7b9052413aea1efe4f89e13b941ca2f5cc2915 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 05:26:41.557593) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 05:26:41.558015) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 05:26:41.568446) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-06-24 05:26:41.568776) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=826874ccc97bd7bf541b4875000001d5-1466771199.893664-1481594588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:26:41 INFO - MultiFileLogger online at 20160624 05:26:41 in /builds/slave/test 05:26:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 05:26:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:26:41 INFO - {'append_to_log': False, 05:26:41 INFO - 'base_work_dir': '/builds/slave/test', 05:26:41 INFO - 'blob_upload_branch': 'Mozilla-Beta', 05:26:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:26:41 INFO - 'branch': 'Mozilla-Beta', 05:26:41 INFO - 'buildbot_json_path': 'buildprops.json', 05:26:41 INFO - 'config_files': ('talos/linux_config.py',), 05:26:41 INFO - 'default_actions': ('clobber', 05:26:41 INFO - 'read-buildbot-config', 05:26:41 INFO - 'download-and-extract', 05:26:41 INFO - 'populate-webroot', 05:26:41 INFO - 'create-virtualenv', 05:26:41 INFO - 'install', 05:26:41 INFO - 'run-tests'), 05:26:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:26:41 INFO - 'download_minidump_stackwalk': True, 05:26:41 INFO - 'download_symbols': 'ondemand', 05:26:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:26:41 INFO - 'tooltool.py': '/tools/tooltool.py', 05:26:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:26:41 INFO - '/tools/misc-python/virtualenv.py')}, 05:26:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:26:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:26:41 INFO - 'installer_path': 'installer.exe', 05:26:41 INFO - 'log_level': 'info', 05:26:41 INFO - 'log_name': 'talos', 05:26:41 INFO - 'log_to_console': True, 05:26:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:26:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:26:41 INFO - 'opt_config_files': (), 05:26:41 INFO - 'pip_index': False, 05:26:41 INFO - 'sps_profile': False, 05:26:41 INFO - 'sps_profile_interval': 0, 05:26:41 INFO - 'suite': 'dromaeojs', 05:26:41 INFO - 'system_bits': '32', 05:26:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:26:41 INFO - 'title': 'talos-linux64-ix-052', 05:26:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:26:41 INFO - 'use_talos_json': True, 05:26:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:26:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:26:41 INFO - 'work_dir': 'build'} 05:26:41 INFO - ##### 05:26:41 INFO - ##### Running clobber step. 05:26:41 INFO - ##### 05:26:41 INFO - Running pre-action listener: _resource_record_pre_action 05:26:41 INFO - Running main action method: clobber 05:26:41 INFO - rmtree: /builds/slave/test/build 05:26:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:26:42 INFO - Running post-action listener: _resource_record_post_action 05:26:42 INFO - ##### 05:26:42 INFO - ##### Running read-buildbot-config step. 05:26:42 INFO - ##### 05:26:42 INFO - Running pre-action listener: _resource_record_pre_action 05:26:42 INFO - Running main action method: read_buildbot_config 05:26:42 INFO - Using buildbot properties: 05:26:42 INFO - { 05:26:42 INFO - "project": "", 05:26:42 INFO - "product": "firefox", 05:26:42 INFO - "script_repo_revision": "production", 05:26:42 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 05:26:42 INFO - "repository": "", 05:26:42 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 05:26:42 INFO - "buildid": "20160624023758", 05:26:42 INFO - "pgo_build": "True", 05:26:42 INFO - "basedir": "/builds/slave/test", 05:26:42 INFO - "buildnumber": 272, 05:26:42 INFO - "slavename": "talos-linux64-ix-052", 05:26:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:26:42 INFO - "platform": "ubuntu64_hw", 05:26:42 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 05:26:42 INFO - "branch": "mozilla-beta", 05:26:42 INFO - "repo_path": "releases/mozilla-beta", 05:26:42 INFO - "revision": "cc7b9052413aea1efe4f89e13b941ca2f5cc2915", 05:26:42 INFO - "stage_platform": "linux64-pgo", 05:26:42 INFO - "builduid": "c93e4c60148e44dd80e347d7cffee231", 05:26:42 INFO - "slavebuilddir": "test" 05:26:42 INFO - } 05:26:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/BMqUJOgkSLurfbV1jmhogg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 05:26:42 INFO - Running post-action listener: _resource_record_post_action 05:26:42 INFO - ##### 05:26:42 INFO - ##### Running download-and-extract step. 05:26:42 INFO - ##### 05:26:42 INFO - Running pre-action listener: _resource_record_pre_action 05:26:42 INFO - Running main action method: download_and_extract 05:26:42 INFO - mkdir: /builds/slave/test/build/tests 05:26:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:26:42 INFO - https://queue.taskcluster.net/v1/task/BMqUJOgkSLurfbV1jmhogg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:26:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMqUJOgkSLurfbV1jmhogg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 05:26:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMqUJOgkSLurfbV1jmhogg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 05:26:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMqUJOgkSLurfbV1jmhogg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 05:26:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMqUJOgkSLurfbV1jmhogg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:26:43 INFO - Downloaded 1327 bytes. 05:26:43 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 05:26:43 INFO - Using the following test package requirements: 05:26:43 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 05:26:43 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:26:43 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 05:26:43 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:26:43 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 05:26:43 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:26:43 INFO - u'jsshell-linux-x86_64.zip'], 05:26:43 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:26:43 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 05:26:43 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 05:26:43 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:26:43 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 05:26:43 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:26:43 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 05:26:43 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:26:43 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 05:26:43 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 05:26:43 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 05:26:43 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:26: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:26:43 INFO - https://queue.taskcluster.net/v1/task/BMqUJOgkSLurfbV1jmhogg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:26:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMqUJOgkSLurfbV1jmhogg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 05:26:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMqUJOgkSLurfbV1jmhogg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 05:26:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMqUJOgkSLurfbV1jmhogg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 05:26:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMqUJOgkSLurfbV1jmhogg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:26:44 INFO - Downloaded 24229886 bytes. 05:26:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:26:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:26:45 INFO - Return code: 0 05:26:45 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:26:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:26:45 INFO - https://queue.taskcluster.net/v1/task/BMqUJOgkSLurfbV1jmhogg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:26:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMqUJOgkSLurfbV1jmhogg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 05:26:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMqUJOgkSLurfbV1jmhogg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 05:26:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMqUJOgkSLurfbV1jmhogg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 05:26:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMqUJOgkSLurfbV1jmhogg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:26:46 INFO - Downloaded 24229886 bytes. 05:26:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:26:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:26:47 INFO - Return code: 0 05:26: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:26:47 INFO - https://queue.taskcluster.net/v1/task/BMqUJOgkSLurfbV1jmhogg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:26:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMqUJOgkSLurfbV1jmhogg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 05:26:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMqUJOgkSLurfbV1jmhogg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 05:26:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMqUJOgkSLurfbV1jmhogg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 05:26:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMqUJOgkSLurfbV1jmhogg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:26:48 INFO - Downloaded 10840145 bytes. 05:26:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:26:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:26:49 INFO - Return code: 0 05:26:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:26:49 INFO - https://queue.taskcluster.net/v1/task/BMqUJOgkSLurfbV1jmhogg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:26:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMqUJOgkSLurfbV1jmhogg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 05:26:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMqUJOgkSLurfbV1jmhogg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 05:26:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMqUJOgkSLurfbV1jmhogg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 05:26:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BMqUJOgkSLurfbV1jmhogg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:26:55 INFO - Downloaded 56019180 bytes. 05:26:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BMqUJOgkSLurfbV1jmhogg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 05:26:55 INFO - mkdir: /builds/slave/test/properties 05:26:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:26:55 INFO - Writing to file /builds/slave/test/properties/build_url 05:26:55 INFO - Contents: 05:26:55 INFO - build_url:https://queue.taskcluster.net/v1/task/BMqUJOgkSLurfbV1jmhogg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 05:26:56 INFO - Running post-action listener: _resource_record_post_action 05:26:56 INFO - Running post-action listener: set_extra_try_arguments 05:26:56 INFO - ##### 05:26:56 INFO - ##### Running populate-webroot step. 05:26:56 INFO - ##### 05:26:56 INFO - Running pre-action listener: _resource_record_pre_action 05:26:56 INFO - Running main action method: populate_webroot 05:26:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:26:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:26:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:26:56 INFO - '--tppagecycles', 05:26:56 INFO - '7'], 05:26:56 INFO - 'tests': ['tsvgm']}}, 05:26:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:26:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:26:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:26:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:26:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:26:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:26:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:26:56 INFO - 'talos_options': ['--disable-e10s'], 05:26:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:26:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:26:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:26:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:26:56 INFO - 'talos_options': ['--disable-e10s'], 05:26:56 INFO - 'tests': ['damp', 'tps']}, 05:26:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:26:56 INFO - 'tests': ['damp', 'tps']}, 05:26:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:26:56 INFO - 'tests': ['dromaeo_dom']}, 05:26:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:26:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:26:56 INFO - 'tests': ['a11yr', 05:26:56 INFO - 'ts_paint', 05:26:56 INFO - 'tpaint', 05:26:56 INFO - 'sessionrestore', 05:26:56 INFO - 'sessionrestore_no_auto_restore', 05:26:56 INFO - 'tabpaint']}, 05:26:56 INFO - 'other-e10s': {'tests': ['a11yr', 05:26:56 INFO - 'ts_paint', 05:26:56 INFO - 'tpaint', 05:26:56 INFO - 'sessionrestore', 05:26:56 INFO - 'sessionrestore_no_auto_restore', 05:26:56 INFO - 'tabpaint']}, 05:26:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:26:56 INFO - 'ts_paint', 05:26:56 INFO - 'tpaint', 05:26:56 INFO - 'sessionrestore', 05:26:56 INFO - 'sessionrestore_no_auto_restore', 05:26:56 INFO - 'tabpaint']}, 05:26:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:26:56 INFO - 'ts_paint', 05:26:56 INFO - 'tpaint', 05:26:56 INFO - 'sessionrestore', 05:26:56 INFO - 'sessionrestore_no_auto_restore', 05:26:56 INFO - 'tabpaint']}, 05:26:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:26:56 INFO - 'tests': ['a11yr', 05:26:56 INFO - 'ts_paint', 05:26:56 INFO - 'tpaint', 05:26:56 INFO - 'sessionrestore', 05:26:56 INFO - 'sessionrestore_no_auto_restore', 05:26:56 INFO - 'tabpaint']}, 05:26:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:26:56 INFO - 'tests': ['a11yr', 05:26:56 INFO - 'ts_paint', 05:26:56 INFO - 'tpaint', 05:26:56 INFO - 'sessionrestore', 05:26:56 INFO - 'sessionrestore_no_auto_restore', 05:26:56 INFO - 'tabpaint']}, 05:26:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:26:56 INFO - 'tests': ['tsvgx', 05:26:56 INFO - 'tsvgr_opacity', 05:26:56 INFO - 'tart', 05:26:56 INFO - 'tscrollx', 05:26:56 INFO - 'cart']}, 05:26:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:26:56 INFO - 'tsvgr_opacity', 05:26:56 INFO - 'tart', 05:26:56 INFO - 'tscrollx', 05:26:56 INFO - 'cart']}, 05:26:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:26:56 INFO - 'talos_options': ['--disable-e10s'], 05:26:56 INFO - 'tests': ['tp5o']}, 05:26:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:26:56 INFO - 'tests': ['tp5o']}, 05:26:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:26:56 INFO - 'talos_options': ['--disable-e10s', 05:26:56 INFO - '--xperf_path', 05:26:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:26:56 INFO - 'tests': ['tp5n']}, 05:26:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:26:56 INFO - 'talos_options': ['--xperf_path', 05:26:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:26:56 INFO - 'tests': ['tp5n']}}, 05:26:56 INFO - 'talos.zip': {'path': '', 05:26:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:26:56 INFO - Running post-action listener: _resource_record_post_action 05:26:56 INFO - ##### 05:26:56 INFO - ##### Running create-virtualenv step. 05:26:56 INFO - ##### 05:26:56 INFO - Running pre-action listener: _resource_record_pre_action 05:26:56 INFO - Running main action method: create_virtualenv 05:26:56 INFO - Creating virtualenv /builds/slave/test/build/venv 05:26:56 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:26:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:26:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:26:56 INFO - Using real prefix '/usr' 05:26:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:26:57 INFO - Installing distribute.............................................................................................................................................................................................done. 05:26:59 INFO - Installing pip.................done. 05:26:59 INFO - Return code: 0 05:26:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:26:59 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:26:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:59 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:26:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:59 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 0x7f26876a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241a410>, '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 0x241b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x241b7a0>, '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': '826874ccc97bd7bf541b4875000001d5-1466771199.893664-1481594588', '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:26:59 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:26:59 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:26:59 INFO - Using env: {'DISPLAY': ':0', 05:26:59 INFO - 'HOME': '/home/cltbld', 05:26:59 INFO - 'LANG': 'en_US.UTF-8', 05:26:59 INFO - 'LANGUAGE': 'en_US:en', 05:26:59 INFO - 'LOGNAME': 'cltbld', 05:26:59 INFO - 'MAIL': '/var/mail/cltbld', 05:26:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:59 INFO - 'MOZ_NO_REMOTE': '1', 05:26:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:59 INFO - 'NO_EM_RESTART': '1', 05:26:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:59 INFO - 'PWD': '/builds/slave/test', 05:26:59 INFO - 'SHELL': '/bin/bash', 05:26:59 INFO - 'SHLVL': '1', 05:26:59 INFO - 'TERM': 'linux', 05:26:59 INFO - 'TMOUT': '86400', 05:26:59 INFO - 'USER': 'cltbld', 05:26:59 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466771199.893664-1481594588', 05:26:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:59 INFO - '_': '/tools/buildbot/bin/python'} 05:26:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:59 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:26:59 INFO - Cleaning up... 05:26:59 INFO - Return code: 0 05:26:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:26:59 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:26:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:59 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:26:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:59 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f26876a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241a410>, '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 0x241b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x241b7a0>, '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': '826874ccc97bd7bf541b4875000001d5-1466771199.893664-1481594588', '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:26:59 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>=0.7.1'] in /builds/slave/test/build 05:26:59 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>=0.7.1 05:26:59 INFO - Using env: {'DISPLAY': ':0', 05:26:59 INFO - 'HOME': '/home/cltbld', 05:26:59 INFO - 'LANG': 'en_US.UTF-8', 05:26:59 INFO - 'LANGUAGE': 'en_US:en', 05:26:59 INFO - 'LOGNAME': 'cltbld', 05:26:59 INFO - 'MAIL': '/var/mail/cltbld', 05:26:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:59 INFO - 'MOZ_NO_REMOTE': '1', 05:26:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:26:59 INFO - 'NO_EM_RESTART': '1', 05:26:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:26:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:59 INFO - 'PWD': '/builds/slave/test', 05:26:59 INFO - 'SHELL': '/bin/bash', 05:26:59 INFO - 'SHLVL': '1', 05:26:59 INFO - 'TERM': 'linux', 05:26:59 INFO - 'TMOUT': '86400', 05:26:59 INFO - 'USER': 'cltbld', 05:26:59 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466771199.893664-1481594588', 05:26:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:59 INFO - '_': '/tools/buildbot/bin/python'} 05:26:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:59 INFO - Downloading/unpacking psutil>=0.7.1 05:26: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:26: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:26: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:26: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:26: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:26: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:27:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:27:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:27:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:27:01 INFO - Installing collected packages: psutil 05:27:01 INFO - Running setup.py install for psutil 05:27:01 INFO - building 'psutil._psutil_linux' extension 05:27:01 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:27:01 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:27:01 INFO - building 'psutil._psutil_posix' extension 05:27:01 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:27:02 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:27:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:27:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:27:02 INFO - Successfully installed psutil 05:27:02 INFO - Cleaning up... 05:27:02 INFO - Return code: 0 05:27:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:27:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:27:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:27:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f26876a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241a410>, '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 0x241b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x241b7a0>, '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': '826874ccc97bd7bf541b4875000001d5-1466771199.893664-1481594588', '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:27:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:27:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:27:02 INFO - Using env: {'DISPLAY': ':0', 05:27:02 INFO - 'HOME': '/home/cltbld', 05:27:02 INFO - 'LANG': 'en_US.UTF-8', 05:27:02 INFO - 'LANGUAGE': 'en_US:en', 05:27:02 INFO - 'LOGNAME': 'cltbld', 05:27:02 INFO - 'MAIL': '/var/mail/cltbld', 05:27:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:02 INFO - 'MOZ_NO_REMOTE': '1', 05:27:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:27:02 INFO - 'NO_EM_RESTART': '1', 05:27:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:27:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:02 INFO - 'PWD': '/builds/slave/test', 05:27:02 INFO - 'SHELL': '/bin/bash', 05:27:02 INFO - 'SHLVL': '1', 05:27:02 INFO - 'TERM': 'linux', 05:27:02 INFO - 'TMOUT': '86400', 05:27:02 INFO - 'USER': 'cltbld', 05:27:02 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466771199.893664-1481594588', 05:27:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:02 INFO - '_': '/tools/buildbot/bin/python'} 05:27:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:27:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:27:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:27:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:27:04 INFO - Installing collected packages: mozsystemmonitor 05:27:04 INFO - Running setup.py install for mozsystemmonitor 05:27:04 INFO - Successfully installed mozsystemmonitor 05:27:04 INFO - Cleaning up... 05:27:04 INFO - Return code: 0 05:27:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:27:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:27:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:27:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f26876a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241a410>, '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 0x241b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x241b7a0>, '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': '826874ccc97bd7bf541b4875000001d5-1466771199.893664-1481594588', '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:27:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:27:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:27:04 INFO - Using env: {'DISPLAY': ':0', 05:27:04 INFO - 'HOME': '/home/cltbld', 05:27:04 INFO - 'LANG': 'en_US.UTF-8', 05:27:04 INFO - 'LANGUAGE': 'en_US:en', 05:27:04 INFO - 'LOGNAME': 'cltbld', 05:27:04 INFO - 'MAIL': '/var/mail/cltbld', 05:27:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:04 INFO - 'MOZ_NO_REMOTE': '1', 05:27:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:27:04 INFO - 'NO_EM_RESTART': '1', 05:27:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:27:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:04 INFO - 'PWD': '/builds/slave/test', 05:27:04 INFO - 'SHELL': '/bin/bash', 05:27:04 INFO - 'SHLVL': '1', 05:27:04 INFO - 'TERM': 'linux', 05:27:04 INFO - 'TMOUT': '86400', 05:27:04 INFO - 'USER': 'cltbld', 05:27:04 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466771199.893664-1481594588', 05:27:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:04 INFO - '_': '/tools/buildbot/bin/python'} 05:27:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:04 INFO - Downloading/unpacking blobuploader==1.2.4 05:27:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:06 INFO - Downloading blobuploader-1.2.4.tar.gz 05:27:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:27:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:27:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:27:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:27:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:07 INFO - Downloading docopt-0.6.1.tar.gz 05:27:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:27:07 INFO - Installing collected packages: blobuploader, requests, docopt 05:27:07 INFO - Running setup.py install for blobuploader 05:27:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:27:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:27:07 INFO - Running setup.py install for requests 05:27:07 INFO - Running setup.py install for docopt 05:27:07 INFO - Successfully installed blobuploader requests docopt 05:27:07 INFO - Cleaning up... 05:27:07 INFO - Return code: 0 05:27:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:27:07 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:27:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:07 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:27:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:07 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 0x7f26876a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241a410>, '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 0x241b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x241b7a0>, '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': '826874ccc97bd7bf541b4875000001d5-1466771199.893664-1481594588', '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:27:07 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:27:07 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:27:07 INFO - Using env: {'DISPLAY': ':0', 05:27:07 INFO - 'HOME': '/home/cltbld', 05:27:07 INFO - 'LANG': 'en_US.UTF-8', 05:27:07 INFO - 'LANGUAGE': 'en_US:en', 05:27:07 INFO - 'LOGNAME': 'cltbld', 05:27:07 INFO - 'MAIL': '/var/mail/cltbld', 05:27:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:07 INFO - 'MOZ_NO_REMOTE': '1', 05:27:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:27:07 INFO - 'NO_EM_RESTART': '1', 05:27:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:27:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:07 INFO - 'PWD': '/builds/slave/test', 05:27:07 INFO - 'SHELL': '/bin/bash', 05:27:07 INFO - 'SHLVL': '1', 05:27:07 INFO - 'TERM': 'linux', 05:27:07 INFO - 'TMOUT': '86400', 05:27:07 INFO - 'USER': 'cltbld', 05:27:07 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466771199.893664-1481594588', 05:27:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:07 INFO - '_': '/tools/buildbot/bin/python'} 05:27:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:27:08 INFO - Running setup.py (path:/tmp/pip-BpLql5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:27:08 INFO - Running setup.py (path:/tmp/pip-vNvzBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:27:08 INFO - Running setup.py (path:/tmp/pip-8sqekq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:27:08 INFO - Running setup.py (path:/tmp/pip-wXEhC2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:27:08 INFO - Running setup.py (path:/tmp/pip-2WuIIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:27:08 INFO - Running setup.py (path:/tmp/pip-Z_eHvU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:27:08 INFO - Running setup.py (path:/tmp/pip-PGRv9X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:27:08 INFO - Running setup.py (path:/tmp/pip-Ou7DnO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:27:08 INFO - Running setup.py (path:/tmp/pip-DYE2lc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:27:08 INFO - Running setup.py (path:/tmp/pip-c0SuhO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:27:08 INFO - Running setup.py (path:/tmp/pip-wAFIEg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:27:08 INFO - Running setup.py (path:/tmp/pip-Eehmnx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:27:09 INFO - Running setup.py (path:/tmp/pip-za8BO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:27:09 INFO - Running setup.py (path:/tmp/pip-9mjxDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:27:09 INFO - Running setup.py (path:/tmp/pip-6IYE30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:27:09 INFO - Running setup.py (path:/tmp/pip-jtJmSr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:27:09 INFO - Running setup.py (path:/tmp/pip-BiHSfi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:27:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:27:09 INFO - Running setup.py install for manifestparser 05:27:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:27:09 INFO - Running setup.py install for mozcrash 05:27:09 INFO - Running setup.py install for mozdebug 05:27:09 INFO - Running setup.py install for mozdevice 05:27:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:27:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:27:09 INFO - Running setup.py install for mozfile 05:27:09 INFO - Running setup.py install for mozhttpd 05:27:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:27:10 INFO - Running setup.py install for mozinfo 05:27:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:27:10 INFO - Running setup.py install for mozInstall 05:27:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:27:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:27:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:27:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:27:10 INFO - Running setup.py install for mozleak 05:27:10 INFO - Running setup.py install for mozlog 05:27:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:27:10 INFO - Running setup.py install for moznetwork 05:27:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:27:10 INFO - Running setup.py install for mozprocess 05:27:10 INFO - Running setup.py install for mozprofile 05:27:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:27:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:27:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:27:10 INFO - Running setup.py install for mozrunner 05:27:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:27:10 INFO - Running setup.py install for mozscreenshot 05:27:10 INFO - Running setup.py install for moztest 05:27:11 INFO - Running setup.py install for mozversion 05:27:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:27:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:27:11 INFO - Cleaning up... 05:27:11 INFO - Return code: 0 05:27:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:27:11 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:27:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:11 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:27:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:11 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 0x7f26876a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241a410>, '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 0x241b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x241b7a0>, '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': '826874ccc97bd7bf541b4875000001d5-1466771199.893664-1481594588', '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:27:11 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:27:11 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:27:11 INFO - Using env: {'DISPLAY': ':0', 05:27:11 INFO - 'HOME': '/home/cltbld', 05:27:11 INFO - 'LANG': 'en_US.UTF-8', 05:27:11 INFO - 'LANGUAGE': 'en_US:en', 05:27:11 INFO - 'LOGNAME': 'cltbld', 05:27:11 INFO - 'MAIL': '/var/mail/cltbld', 05:27:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:11 INFO - 'MOZ_NO_REMOTE': '1', 05:27:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:27:11 INFO - 'NO_EM_RESTART': '1', 05:27:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:27:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:11 INFO - 'PWD': '/builds/slave/test', 05:27:11 INFO - 'SHELL': '/bin/bash', 05:27:11 INFO - 'SHLVL': '1', 05:27:11 INFO - 'TERM': 'linux', 05:27:11 INFO - 'TMOUT': '86400', 05:27:11 INFO - 'USER': 'cltbld', 05:27:11 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466771199.893664-1481594588', 05:27:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:11 INFO - '_': '/tools/buildbot/bin/python'} 05:27:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:27:11 INFO - Running setup.py (path:/tmp/pip-R2LZGO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:27:11 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:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:27:11 INFO - Running setup.py (path:/tmp/pip-QdsriU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:27:11 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:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:27:11 INFO - Running setup.py (path:/tmp/pip-s4qXYf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:27:11 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:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:27:11 INFO - Running setup.py (path:/tmp/pip-GlUAEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:27:11 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:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:27:11 INFO - Running setup.py (path:/tmp/pip-Uie1ps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:27:11 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:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:27:11 INFO - Running setup.py (path:/tmp/pip-iOMLbY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:27:11 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:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:27:11 INFO - Running setup.py (path:/tmp/pip-wNH3hd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:27:11 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:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:27:11 INFO - Running setup.py (path:/tmp/pip-FejYxu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:27:12 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:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:27:12 INFO - Running setup.py (path:/tmp/pip-_cmLSo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:27:12 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:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:27:12 INFO - Running setup.py (path:/tmp/pip-wlS3jE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:27:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:27:12 INFO - Running setup.py (path:/tmp/pip-FF9d8n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:27:12 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:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:27:12 INFO - Running setup.py (path:/tmp/pip-j1w1lI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:27:12 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:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:27:12 INFO - Running setup.py (path:/tmp/pip-X5N6Jo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:27:12 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:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:27:12 INFO - Running setup.py (path:/tmp/pip-vHvb6B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:27:12 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:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:27:12 INFO - Running setup.py (path:/tmp/pip-Xo27ha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:27:12 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:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:27:12 INFO - Running setup.py (path:/tmp/pip-YicdIj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:27:12 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:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:27:12 INFO - Running setup.py (path:/tmp/pip-VMFjUZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:27:12 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:27:12 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:27:12 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:27:12 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:27:12 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:27:12 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:27:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:27:12 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:27:12 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:27:12 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:27:12 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:27:12 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:27:12 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:27:14 INFO - Downloading blessings-1.6.tar.gz 05:27:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:27:14 INFO - Installing collected packages: blessings 05:27:14 INFO - Running setup.py install for blessings 05:27:14 INFO - Successfully installed blessings 05:27:14 INFO - Cleaning up... 05:27:14 INFO - Return code: 0 05:27:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:27:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:27:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:27:15 INFO - Reading from file tmpfile_stdout 05:27:15 INFO - Current package versions: 05:27:15 INFO - argparse == 1.2.1 05:27:15 INFO - blessings == 1.6 05:27:15 INFO - blobuploader == 1.2.4 05:27:15 INFO - docopt == 0.6.1 05:27:15 INFO - manifestparser == 1.1 05:27:15 INFO - mozInstall == 1.12 05:27:15 INFO - mozcrash == 0.17 05:27:15 INFO - mozdebug == 0.1 05:27:15 INFO - mozdevice == 0.48 05:27:15 INFO - mozfile == 1.2 05:27:15 INFO - mozhttpd == 0.7 05:27:15 INFO - mozinfo == 0.9 05:27:15 INFO - mozleak == 0.1 05:27:15 INFO - mozlog == 3.1 05:27:15 INFO - moznetwork == 0.27 05:27:15 INFO - mozprocess == 0.22 05:27:15 INFO - mozprofile == 0.28 05:27:15 INFO - mozrunner == 6.11 05:27:15 INFO - mozscreenshot == 0.1 05:27:15 INFO - mozsystemmonitor == 0.0 05:27:15 INFO - moztest == 0.7 05:27:15 INFO - mozversion == 1.4 05:27:15 INFO - psutil == 3.1.1 05:27:15 INFO - requests == 1.2.3 05:27:15 INFO - wsgiref == 0.1.2 05:27:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:27:15 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:27:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:15 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:27:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:15 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 0x7f26876a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241a410>, '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 0x241b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x241b7a0>, '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': '826874ccc97bd7bf541b4875000001d5-1466771199.893664-1481594588', '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:27:15 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:27:15 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:27:15 INFO - Using env: {'DISPLAY': ':0', 05:27:15 INFO - 'HOME': '/home/cltbld', 05:27:15 INFO - 'LANG': 'en_US.UTF-8', 05:27:15 INFO - 'LANGUAGE': 'en_US:en', 05:27:15 INFO - 'LOGNAME': 'cltbld', 05:27:15 INFO - 'MAIL': '/var/mail/cltbld', 05:27:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:15 INFO - 'MOZ_NO_REMOTE': '1', 05:27:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:27:15 INFO - 'NO_EM_RESTART': '1', 05:27:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:27:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:15 INFO - 'PWD': '/builds/slave/test', 05:27:15 INFO - 'SHELL': '/bin/bash', 05:27:15 INFO - 'SHLVL': '1', 05:27:15 INFO - 'TERM': 'linux', 05:27:15 INFO - 'TMOUT': '86400', 05:27:15 INFO - 'USER': 'cltbld', 05:27:15 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466771199.893664-1481594588', 05:27:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:15 INFO - '_': '/tools/buildbot/bin/python'} 05:27:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:15 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:27:15 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:27:15 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:27:15 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:27:15 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:27:15 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:27:15 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:27:15 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:27:15 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:27:15 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:27:15 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:27:15 INFO - Cleaning up... 05:27:15 INFO - Return code: 0 05:27:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:27:15 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:27:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:15 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:27:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:15 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 0x7f26876a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241a410>, '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 0x241b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x241b7a0>, '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': '826874ccc97bd7bf541b4875000001d5-1466771199.893664-1481594588', '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:27:15 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:27:15 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:27:15 INFO - Using env: {'DISPLAY': ':0', 05:27:15 INFO - 'HOME': '/home/cltbld', 05:27:15 INFO - 'LANG': 'en_US.UTF-8', 05:27:15 INFO - 'LANGUAGE': 'en_US:en', 05:27:15 INFO - 'LOGNAME': 'cltbld', 05:27:15 INFO - 'MAIL': '/var/mail/cltbld', 05:27:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:15 INFO - 'MOZ_NO_REMOTE': '1', 05:27:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:27:15 INFO - 'NO_EM_RESTART': '1', 05:27:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:27:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:15 INFO - 'PWD': '/builds/slave/test', 05:27:15 INFO - 'SHELL': '/bin/bash', 05:27:15 INFO - 'SHLVL': '1', 05:27:15 INFO - 'TERM': 'linux', 05:27:15 INFO - 'TMOUT': '86400', 05:27:15 INFO - 'USER': 'cltbld', 05:27:15 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466771199.893664-1481594588', 05:27:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:15 INFO - '_': '/tools/buildbot/bin/python'} 05:27:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:15 INFO - Downloading/unpacking jsonschema 05:27:15 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:27:15 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:27:15 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:27:15 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:27:15 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:27:15 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:27:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:27:17 INFO - Downloading/unpacking functools32 (from jsonschema) 05:27:17 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:27:17 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:27:17 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:27:17 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:27:17 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:27:17 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:27:17 INFO - Downloading functools32-3.2.3-2.tar.gz 05:27:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:27:17 INFO - warning: no files found matching '*.txt' 05:27:17 INFO - no previously-included directories found matching 'build' 05:27:17 INFO - no previously-included directories found matching 'dist' 05:27:17 INFO - no previously-included directories found matching '.git*' 05:27:17 INFO - Installing collected packages: jsonschema, functools32 05:27:17 INFO - Running setup.py install for functools32 05:27:17 INFO - warning: no files found matching '*.txt' 05:27:17 INFO - no previously-included directories found matching 'build' 05:27:17 INFO - no previously-included directories found matching 'dist' 05:27:17 INFO - no previously-included directories found matching '.git*' 05:27:17 INFO - Successfully installed jsonschema functools32 05:27:17 INFO - Cleaning up... 05:27:17 INFO - Return code: 0 05:27:17 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:27:17 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:27:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:17 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:27:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:17 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 0x7f26876a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241a410>, '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 0x241b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x241b7a0>, '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': '826874ccc97bd7bf541b4875000001d5-1466771199.893664-1481594588', '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:27:17 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:27:17 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:27:17 INFO - Using env: {'DISPLAY': ':0', 05:27:17 INFO - 'HOME': '/home/cltbld', 05:27:17 INFO - 'LANG': 'en_US.UTF-8', 05:27:17 INFO - 'LANGUAGE': 'en_US:en', 05:27:17 INFO - 'LOGNAME': 'cltbld', 05:27:17 INFO - 'MAIL': '/var/mail/cltbld', 05:27:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:17 INFO - 'MOZ_NO_REMOTE': '1', 05:27:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:27:17 INFO - 'NO_EM_RESTART': '1', 05:27:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:27:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:17 INFO - 'PWD': '/builds/slave/test', 05:27:17 INFO - 'SHELL': '/bin/bash', 05:27:17 INFO - 'SHLVL': '1', 05:27:17 INFO - 'TERM': 'linux', 05:27:17 INFO - 'TMOUT': '86400', 05:27:17 INFO - 'USER': 'cltbld', 05:27:17 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466771199.893664-1481594588', 05:27:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:17 INFO - '_': '/tools/buildbot/bin/python'} 05:27:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:18 INFO - Downloading/unpacking flake8 05:27:18 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:27:18 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:27:18 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:27:18 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:27:18 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:27:18 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:27:19 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:27:19 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:27:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:27:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:27:20 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:27:20 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:27:20 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:27:20 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:27:20 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:27:20 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:27:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:27:20 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:27:20 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:27:20 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:27:20 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:27:20 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:27:20 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:27:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:27:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:27:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:27:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:27:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:27:20 INFO - no previously-included directories found matching 'docs/_build' 05:27:20 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:27:20 INFO - Running setup.py install for pep8 05:27:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:27:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:27:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:27:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:27:20 INFO - no previously-included directories found matching 'docs/_build' 05:27:20 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:27:20 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:27:20 INFO - Cleaning up... 05:27:20 INFO - Return code: 0 05:27:20 INFO - Running post-action listener: _resource_record_post_action 05:27:20 INFO - Running post-action listener: _start_resource_monitoring 05:27:20 INFO - Starting resource monitoring. 05:27:20 INFO - ##### 05:27:20 INFO - ##### Running install step. 05:27:20 INFO - ##### 05:27:20 INFO - Running pre-action listener: _resource_record_pre_action 05:27:20 INFO - Running main action method: install 05:27:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:27:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:27:21 INFO - Reading from file tmpfile_stdout 05:27:21 INFO - Detecting whether we're running mozinstall >=1.0... 05:27:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:27:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:27:21 INFO - Reading from file tmpfile_stdout 05:27:21 INFO - Output received: 05:27:21 INFO - Usage: mozinstall [options] installer 05:27:21 INFO - Options: 05:27:21 INFO - -h, --help show this help message and exit 05:27:21 INFO - -d DEST, --destination=DEST 05:27:21 INFO - Directory to install application into. [default: 05:27:21 INFO - "/builds/slave/test"] 05:27:21 INFO - --app=APP Application being installed. [default: firefox] 05:27:21 INFO - mkdir: /builds/slave/test/build/application 05:27:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:27:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:27:34 INFO - Reading from file tmpfile_stdout 05:27:34 INFO - Output received: 05:27:34 INFO - /builds/slave/test/build/application/firefox/firefox 05:27:34 INFO - Running post-action listener: _resource_record_post_action 05:27:34 INFO - ##### 05:27:34 INFO - ##### Running run-tests step. 05:27:34 INFO - ##### 05:27:34 INFO - Running pre-action listener: _resource_record_pre_action 05:27:34 INFO - Running main action method: run_tests 05:27:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:27:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:27:34 INFO - Python 2.7.3 05:27:34 INFO - Return code: 0 05:27:34 INFO - grabbing minidump binary from tooltool 05:27:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:27:34 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241a410>, '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 0x241b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x241b7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:27:34 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:27:34 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:27:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:27:34 INFO - Return code: 0 05:27:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:27:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:27:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:27:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:27:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:27:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:27:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:27:35 INFO - Return code: 0 05:27:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BMqUJOgkSLurfbV1jmhogg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--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:27:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BMqUJOgkSLurfbV1jmhogg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-052 --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:27:35 INFO - Using env: {'DISPLAY': ':0', 05:27:35 INFO - 'HOME': '/home/cltbld', 05:27:35 INFO - 'LANG': 'en_US.UTF-8', 05:27:35 INFO - 'LANGUAGE': 'en_US:en', 05:27:35 INFO - 'LOGNAME': 'cltbld', 05:27:35 INFO - 'MAIL': '/var/mail/cltbld', 05:27:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:27:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:27:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:35 INFO - 'MOZ_NO_REMOTE': '1', 05:27:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:27:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:27:35 INFO - 'NO_EM_RESTART': '1', 05:27:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:27:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:35 INFO - 'PWD': '/builds/slave/test', 05:27:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:27:35 INFO - 'SHELL': '/bin/bash', 05:27:35 INFO - 'SHLVL': '1', 05:27:35 INFO - 'TERM': 'linux', 05:27:35 INFO - 'TMOUT': '86400', 05:27:35 INFO - 'USER': 'cltbld', 05:27:35 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1466771199.893664-1481594588', 05:27:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:35 INFO - '_': '/tools/buildbot/bin/python'} 05:27:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BMqUJOgkSLurfbV1jmhogg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--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:27:35 INFO - mozversion application_buildid: 20160624023758 05:27:35 INFO - mozversion application_changeset: cc7b9052413aea1efe4f89e13b941ca2f5cc2915 05:27:35 INFO - mozversion application_display_name: Firefox 05:27:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:27:35 INFO - mozversion application_name: Firefox 05:27:35 INFO - mozversion application_remotingname: firefox 05:27:35 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 05:27:35 INFO - mozversion application_vendor: Mozilla 05:27:35 INFO - mozversion application_version: 48.0 05:27:35 INFO - mozversion platform_buildid: 20160624023758 05:27:35 INFO - mozversion platform_changeset: cc7b9052413aea1efe4f89e13b941ca2f5cc2915 05:27:35 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 05:27:35 INFO - mozversion platform_version: 48.0 05:27:35 INFO - using testdate: 1466771255 05:27:35 INFO - actual date: 1466771255 05:27:35 INFO - starting webserver on 'localhost:41517' 05:27:35 INFO - SUITE-START | Running 2 tests 05:27:35 INFO - TEST-START | dromaeo_css 05:27:35 INFO - operating with platform_type : linux_ 05:27:35 INFO - Initialising browser for dromaeo_css test... 05:27:35 INFO - TEST-INFO | started process 345 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEvRWzO/profile http://localhost:41517/getInfo.html) 05:27:39 INFO - PROCESS | 345 | __metrics Screen width/height:1600/1200 05:27:39 INFO - PROCESS | 345 | colorDepth:24 05:27:39 INFO - PROCESS | 345 | Browser inner width/height: 1024/697 05:27:39 INFO - PROCESS | 345 | __metrics 05:27:39 ERROR - PROCESS | 345 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:27:40 INFO - TEST-INFO | 345: exit 0 05:27:40 INFO - Browser initialized. 05:27:40 INFO - Running cycle 1/1 for dromaeo_css test... 05:27:40 INFO - TEST-INFO | started process 434 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEvRWzO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:27:52 INFO - PROCESS | 434 | RSS: Main: 139112448 05:27:52 INFO - PROCESS | 434 | 05:28:43 INFO - PROCESS | 434 | 1466771323548 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:30:51 INFO - PROCESS | 434 | Cycle 1(1): loaded http://localhost:41517/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41517/tests/dromaeo/cssquery-ext.html) 05:30:52 INFO - PROCESS | 434 | RSS: Main: 252596224 05:30:52 INFO - PROCESS | 434 | 05:33:54 INFO - PROCESS | 434 | Cycle 1(1): loaded http://localhost:41517/tests/dromaeo/cssquery-ext.html (next: http://localhost:41517/tests/dromaeo/cssquery-jquery.html) 05:33:54 INFO - PROCESS | 434 | RSS: Main: 225116160 05:33:54 INFO - PROCESS | 434 | 05:36:56 INFO - PROCESS | 434 | Cycle 1(1): loaded http://localhost:41517/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41517/tests/dromaeo/cssquery-mootools.html) 05:36:57 INFO - PROCESS | 434 | RSS: Main: 216440832 05:36:57 INFO - PROCESS | 434 | 05:39:58 INFO - PROCESS | 434 | Cycle 1(1): loaded http://localhost:41517/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41517/tests/dromaeo/cssquery-prototype.html) 05:39:59 INFO - PROCESS | 434 | RSS: Main: 211914752 05:39:59 INFO - PROCESS | 434 | 05:43:02 INFO - PROCESS | 434 | Cycle 1(1): loaded http://localhost:41517/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41517/tests/dromaeo/cssquery-yui.html) 05:43:02 INFO - PROCESS | 434 | RSS: Main: 183488512 05:43:02 INFO - PROCESS | 434 | 05:46:04 INFO - PROCESS | 434 | Cycle 1(1): loaded http://localhost:41517/tests/dromaeo/cssquery-yui.html (next: http://localhost:41517/tests/dromaeo/cssquery-dojo.html) 05:46:05 INFO - PROCESS | 434 | RSS: Main: 258097152 05:46:05 INFO - PROCESS | 434 | 05:46:05 INFO - PROCESS | 434 | __start_tp_report 05:46:05 INFO - PROCESS | 434 | _x_x_mozilla_page_load 05:46:05 INFO - PROCESS | 434 | _x_x_mozilla_page_load_details 05:46:05 INFO - PROCESS | 434 | |i|pagename|runs| 05:46:05 INFO - PROCESS | 434 | |0;dojo.html;3353.9770370037136;3357.3117510910265;3369.663033696629;3394.7623666343366;3400.268942177431;5635.549156067515;5637.436256374371;5638.548916086714;5650.237217975572;5658.603897727161;5636;5650.378458369586;5655.1517272409155;5661.179129026289;5661.801836935698;5043;5121.5646670033;5171.870703232412;5217.504337087989;5240.135377662681;5171.120909445384;5229.8169564065265;5248.0815857225025;5258.211268309765;5259.684418934857;5192.740362981855;5244.056069907415;5251.973740131313;5269.973650131744;5273.920891186635;5201.817936372227;5212.843614691566;5220.216967454912;5220.817271395502;5250.369955605352;4995.5753760930365;5049.798008079672;5116.616253780981;5140.228965655144;5144.768485418128;5618.185363122325;5631.324241091054;5685.260916080883;5693.77224911003;5697.31632204134;6149.016157414837;6199.132121502993;6200.348963358828;6202.348753380875;6215.223097112861;6127.953177891112;6192.040233763774;6225.159603453566;6226.564140510166;6256.468200202943;5801.854953626151;5802.477777000048;5811.27359080115;5817.505512031483;5819.621724587931;6066.090086487062;6300.21247344082;6304.022876454157;6311.810645680637;6313.936860631335;5942.762289508458;5988.341282458926;5993.041113421831;6008.759649614054;6015.368386319461;6054.7880824171825;6075.149479072933;6077.4226448487325;6078.7264573093435;6078.969605151946;5937.940620593825;5998.790042348497;6052.515798736091;6053.636781793019;6060.909086363708;6109.14471973924;6147.84630384244;6159.23009623797;6165.537584681167;6171.197744293213;4618.145643056046;4650.209464391061;4651.2557990722;4666.043461090469;4681.297805329228;4063.4514340563646;4068.0846809467635;4089.9386509202386;4128.958710412858;4148.357004664282;5722.456366645162;5728.742206600713;5732.34078081026;5733.684647344353;5769.913451298234;6072.817815465543;6074.665893375906;6079.878402431927;6082.2093127893095;6083.756649733961;5668.433156684381;5743.971280143573;5796.82609521715;5865.090910908816;5893.587448878623;5235.952809438128;5252.317198764136;5255.737213139404;5256.868578285497;5257.369115706063;6360.681965901686;6368.64972426521;6370.77702280418;6377.426031657174;6381.936180638227;5991.760329586855;6116.42707509198;6177.320494745664;6187.907181392193;6199.318075011835;6403.231612206565;6412.807615771534;6428.646424446701;6433.710483028181;6437.291897891322;5822.097574875901;6052.66710330936;6058.787942421994;6071.150038994632;6078.939210607838;6142.907856382247;6174.536909731698;6181.907271391023;6186.257649082139;6192.473639740672;6012.549058820518;6014.879702405839;6017.548683848641;6018.699065046818;6028.547858910687;5799.9130013049;5899.233099697012;6006.699665016819;6007.8197654070445;6010.669413182317;5905;5916.230889984275;5918.556108291981;5923.141144533933;5966.791162309299;6000.849978750566;6021.337652858095;6021.849453763691;6028.065649824284;6036.396360363929;5816.21481100063;5921.082232254007;5934.406559344031;5973.462388385066;5999 05:46:05 INFO - PROCESS | 434 | |1;ext.html;652.9804105876823;660.3495556876476;668.231533736203;674.7739507265065;746.4588173574158;32276.67723322766;32832.179195520155;33133.171670708216;39689.404658930136;40132.59867401325;42658.78670606643;43159.35260971088;43197.35203971943;43235.56764432355;43254.35118473225;8674.653013879437;8838.381313308071;8858.601362938683;8858.689945851896;8860.468371897674;8192.262696357328;10745.83881241782;11044.668659940215;11051.557937682483;11052.668419947415;10547.578096876154;10639.680809575726;10643.04212620864;10644.201684873628;10645.414502202375;10615.57537698491;10701.090407315387;10705.892941070606;10708.785824283548;10715.035646791826;10461.110805581535;10495.42275174865;10547;10562.207834412373;10950.233483656148;43345;43631.56368436307;43689.78155109204;43786;43822.561774382164;3788.5264341957254;3845.8461661533506;3858.164249276779;3890.8443662253476;3918.7060970427333;30580.694193058007;30741.848070635064;31065.84467077673;31080.22299442532;32150.35699286001;3795.7153213508823;4289.463817022872;4361.476622805252;4444.888877778049;4583.518730533279;289338;291254.9999999979;291880;292524;293092;39389;40030.39954400686;40119.59880401217;60675.08987365193;62343.37656623466;37825.43261851074;37839.810800945816;37909;37937.81031094827;38055;17140.485785426456;17398.739018914726;17404.303827846998;17417.39039133624;17434.04112773784;13458.663533411744;14503.419863205354;14536.636584085483;14655.340509676877;14894.478693245685;9227.90772092284;9275.860862087075;9294.90705092954;9325.720228393158;9357.344985850925;3543.6810687037773;3584.5340105786604;3626.1841085755495;3628.1836586767768;3651.726120540917;1074.484247561175;1132.0377678972807;1202.4588934979295;1206.3968015992004;1224.7244370016854;33958.32083358368;34334.82832585821;34746;34835.65164348375;34936.30127397489;1271.9236845789283;1294.8316718826682;1328.3992788689607;1372.7254549090221;1381.9170849749048;17748;17758.46724598264;17893.93266057151;18085.547861303574;18212.36256731008;571549;577988;579248;581391;582542;62079.068813967824;63673;63717.68141159357;63892.36107638864;63939;838.8364268967615;1343.9462421503226;1368.9247091410068;1561.5861796623676;1644.2189959769253;30063.278584464293;33261;33515.16212094717;33668.66331336655;33886;49848;49898;50251.49748502468;50368.74815625898;50447.74776126096;311487;312183;313266;313364;314183;26303.605445917943;29761.25596860096;30728.69271307258;30748.538771917993;30751.53872691956;44132.779336103114;44786.55213447954;45179.54820451885;46046.309305361116;46313.305300419845;40684.59315406808;41473;42228.155436890476;42320.1535969285;43128;40607.1878562433;40914.795426022676;41504.79247603743;41807.790961045;42162.156756864075;41832.0458509843;42437;43102.568974309856;43369.13261734811;43474.56525434705;36349.27301454009;36893.26213475769;37345.65123928884;37590.62409375871;37810.243795124494;28766.280842979093;28936;29047;29153.56269655999;29217.85391073031 05:46:05 INFO - PROCESS | 434 | |2;jquery.html;416.502279775668;423.82199476219984;429.3302448180838;430.37165738022486;437.19992413882596;19211.903940480297;19466.221351145938;19691.901540492294;19770.505737356554;20482.590348193025;11913.7617247655;11946.641600751991;11984;17540.930337190974;18931.242750290006;5250.501202385786;5397.919031214535;5409.702466364349;5417.566594672437;5419.051665958461;5666.320041595014;5909.320428150775;6051.2133422655;6054.364291749347;6071.210742603455;6018.007028840258;6030.276366835964;6030.487408570255;6032.306284777263;6033.818985430444;5637.520810731093;5909.674967876765;5913.526917846583;5919.467247947684;5922.763089476416;5625.38120806711;5817.360090390053;5838.883222335572;5843.415658434165;5848.853778655525;13213.273269970148;13304.600861974157;13415.060945733803;13417.798733019012;13420.060595758301;2428.6357046443;2555.3611597100726;2573.4981678572685;2653.8805753741126;3010.1872494426384;9822.066903644143;9909;9929.702108936743;10165.440900750456;10368.118709909591;1969.1272511379407;1987.8111579399933;2082.6980087887323;2136.2950226425396;2170.945726356838;85543.57228213882;87384.12615873823;89550;89642;90199.54900225523;11815.940920295343;11893.81061893821;11901.702457438634;11922;11978.981786548067;17152.571185720455;17288.22203000868;17289.48131556055;17298.048607326717;17327.306907723803;8805.295576353876;8931.910680893237;9003.504807235666;9012.909870901338;9147.313951453667;8821.750453634282;8879.023307436177;8920.910790892009;8923.776905577413;9028.683996060106;4591.471980722193;4591.8392856249875;5008.273800298936;5168.715720635401;5190.091733946544;2065.473304307392;2066.958660826805;2070.244360808294;2075.3151460018157;2088.4152437317575;1004.8794144702682;1061.5382308695741;1066.3814987307344;1076.424113099488;1086.4839201379282;19669.704954425695;19695.704564431544;19913.701294480594;20042.699359509617;20263.392098237076;1047.5233768635253;1052.6421016854306;1063.5958335832333;1099.8955099265556;1124.6401151631399;10946;11089.390083545482;11187.105031597453;11256;11357.886421135849;468650;481105;499225;505836;507259;81433.59283203665;89463.55268223617;89804.5509772447;92927;96801.515992421;1078.223678951154;1121.0415095093579;1135.65362564417;1137.2323681514945;1144.3820337018083;18173.727394089365;18347.35784247545;18349.449516514527;18457.723134153268;18725.719114213025;40750;41488.1702365957;41737.37393939154;42480;44013.33979990367;57408.42591574031;60239.192824215344;60445;60644.39355606387;61098.77802444015;8712.823768791131;8746.781330466789;8822.470651760916;8927.10728927128;9119.908800912172;9469;12751.936240318739;14111.22388268655;14325;14341.426342946166;12531.93734031324;12627.494900203888;12954.41042104583;13041.217526948414;13258.933705331412;12243.142979991315;12560.623181304576;12610.369481525704;12672.556460523838;12720.173188742701;12908.677283067998;13066.738665226452;13142.868571314548;13365.859023129362;13517.256550889795;8411.621477033426;8770.210681038738;8871.290296776113;8963.775905602151;9070.81858362816;11251.268667536584;12078.75842483163;12102.45538950767;12200.633980980585;12225.266484010988 05:46:05 INFO - PROCESS | 434 | |3;mootools.html;1392.8816050635696;1587.1984647752884;1605.0851014921493;1789.5436663650767;1881.3415304643368;8314.542700151489;8484.278836298907;8512.319014478842;8514.701985430504;8524.8721269181;8388.874166887486;8557.358198135134;8557.700480483169;8573.142685731424;8575;2400.7719266669637;2425.3694039549755;2426.2236084452984;2430.040134147011;2430.44099857033;2458.766417190364;2474.307193985687;2503.812214083942;2507.6489291499206;2511.510255500178;2412.2039726890084;2424.648425978232;2458.1150785717127;2464.7658472445178;2473.925782226527;2435.6833611630464;2446.657467954488;2451.5832308507597;2453.472503411775;2469.790067844235;2417.6131818909066;2452.3256104571205;2468.062136388179;2475.0223661653727;2497.1759319424546;8332.33341332692;8551.700690475865;8730.694425695134;8793.12068793122;8809.163129502687;5197.064528384889;5266.15741481365;5292.470752924715;5300.390455097636;5321.414644389114;3369.848356823949;3388.7458440616806;3428.9541689784605;3493.266414053052;3524.4184709522897;1135.5571327182406;1144.2619510415818;1155.439611788282;1167.532986805276;1198.2031948754068;12393.876061239453;12498.250104993638;12504.49982000728;12510.18683785551;12540.310282934435;4489.371487991683;4554.977225113853;4626.750777290113;4640.65195110368;4642.094791515622;9941.850872236922;9952.452615106238;9957;9959.850602240973;9973.451460169616;5303.28405665238;5342.3856256531;5353.518183363516;5356.517913387814;5357.08929481989;4372.80322385487;4692.9530704692515;4796.640251981045;4824.56578907893;4995.800167993312;3947.8945895149404;3953.7825419601622;4027.979860100739;4037.959620403817;4102.610252026053;1229.9385030748426;1281.1288323939625;1285.4858056777364;1292.9676758080934;1304.5564508067303;1077.6874706335075;1078.940658263803;1090.3022065877844;1093.2565855218527;1103.564092183583;6261.092141639437;6312.242530896322;6339.049142628551;6351.301356850743;6396.040593910858;447.8141571247896;450.7160488891977;460.7442869207555;460.9769511524477;467.7357293129371;4202.516710578323;4211.1998720243055;4224.8732538023905;4228.534861165269;4229.217594744982;10529.36823790575;10895.07391871684;10991.340519568852;11040.392778397105;11050.336979781077;10768.946155269174;10842.457877106113;10844.728881778019;10850.240483166102;10875.945620271848;7954.647709889217;8310.459820111673;8406.033306169746;8411.495310281403;8417.326613870875;6016.639001659914;6054.031354983182;6063.090536419572;6181.227346581677;6188.659623720739;9200.907990920005;9397.342186046912;9633.421994680342;9635.13283804461;9642.56442036671;9594.376365536218;9651.662191823252;9704.272179586418;9770.120689138012;9801.215902727621;7008.5094043416475;7549.282818132268;7758.4181186410115;7890.48711833729;8016.0380754307525;8396.454230475;8408.789780255542;8411.285040771603;8450.915490845258;8452.366072544706;7517.135529414188;7624.199459056941;7628.504147230412;7754.263344982218;7766.106897706836;7455.627218639155;7500.36246919018;7548.886766698394;7594.658240379306;7709.498882572615;7057.752978645723;7082.893756593552;7112.146542414944;7161.677724502306;7179.138503379628;5054.368203974504;5213.1137706590725;5285.312909321764;5403.972980135074;5468.6171967963455;5293.258943747801;5335.519803217729;5340.118880384848;5401.081816091195;5451.781928722965 05:46:05 INFO - PROCESS | 434 | |4;prototype.html;356.3549974546072;368.6958259435965;369.0865108855581;369.2025225512892;369.9611540788217;6320.810375688725;6327.050942358648;6329.588576742509;6330.905036424458;6385.840353991152;5996.88006239876;6116;6209.937900620993;6239.376062393759;6348.936510634892;4843.66094373394;4875.463698993108;4876.731779752112;4883.706977581356;4886.853394398174;4861.197902346109;4866.853994380174;4875.804967801284;4882.121218180726;4883.072216278913;4598.057398233371;4630.120277147348;4749.52504749524;4784.617230621542;4785.353977213083;4769.499202583714;4774.832880849189;4785.473597904228;4786.2581299898575;4802.711837289774;4238;4245.660347172219;4246.299360605496;4249.447571815645;4262.360645903108;5949.137375080632;5967.283925928873;5971.462568368825;5974.462298393166;5990.9101363479585;5591.245181900432;5596.972015139898;5605.355384130837;5605.915911261334;5606.6636001839615;6461.870762584769;6594.109795177637;6597.835054123685;6603.174603174603;6603.966980165116;4739.454962679301;4745.83389581363;4746.833860814855;4763.595094416979;4765.642576806753;6855.314468553105;6867.622280774555;6869.072675188835;6872.828179295508;6886.173659160882;4857.271409288564;4858.46556878743;4860.684055536379;4863.2461968394955;4865.416150062015;4938.25926111079;4938.9012219755405;4939.382577177853;4946.035523073038;4947.529984651453;5495.148252020943;5565.9721701392045;5592.720363981866;5596.496315331639;5614.466625670555;6598.670066496656;6600.306967768412;6604.207495100619;6635.402813746786;6653.068570400148;1643.9178041097898;1680.5126513311247;1718.828117188271;1745.1884873533868;1745.4414587331933;1108.2187058124002;1111.5109351885144;1115.938623375706;1147.260017288844;1152.815549512074;6445.097686323825;6462.289148193695;6470.352964703586;6478.319776423502;6486.513511486657;6860.211075726255;6868.862622747617;6874.9656251718425;6884.621345826027;6895.931040689529;6453.515986301046;6453.774117905851;6456.063870738717;6457.321981192001;6466.805995820133;3681.4477828325967;3721.4975978243133;3722.3485889969147;3722.571904230994;3730.757500762442;7041.873300271932;7099.929000709927;7180.246074162138;7184.389326907167;7184.784456466315;6939.444844412435;6978.79063628092;6987.441004719611;6990.196127445409;6990.650467476606;7166.8208294792;7178.820529486805;7180.497365184387;7181.964090179516;7187.9936808846805;6815.761448349284;6820.761273355409;6831.316868313129;6855.828604284933;6867.622280774605;6678.532502724763;6759.966200168968;6788.49086318538;6881.552699074544;6905.413039891666;7175.067241258603;7234.710611575478;7238;7251.311125443285;7255.129384473686;4925.1381008324115;4963.726995015309;4969.130402179677;4973.129702302011;4978.8257410990445;6676.065350850788;6928.792136235719;6928.861422771415;6932.584044957319;6935.375816176568;6588.868222635616;6757.831054223684;6760.898586521108;6773.085633439423;6774.051632771515;6714.3957043866285;6751.966240168767;6756.29058948823;6762.594244345355;6774.525783195326;6650.600963941985;6651.567648102858;6651.900221496585;6655.633940133339;6664.166979127609;6562.606243625398;6744.898826517508;6799.6600169990315;6806.727730890709;6816.693248803915;6609.834754131185;6629.2044954603825;6639.336066393322;6645.169353830771;6652 05:46:05 INFO - PROCESS | 434 | |5;yui.html;852.4203541591716;891.9866202006971;906.7143849687349;929.9209567186791;944.7401964459777;15323.616909577266;15366.615834604154;15430.151341676203;15569.92215038926;15659.295331710073;14066.296685165726;14219.644508887282;14273.928630356859;14281.78577321341;14336.283185840692;726.426123362543;874.3835595904887;877.7322916510461;892.0945240580816;897.0312062971975;885.6147575804514;888.1473785166248;889.915458031486;891.777055736066;891.857302831547;937.1144268666113;938.0431959401407;939.1876027236425;939.4832841936908;940.5344354544476;757.0839284465776;765.8238605120825;928.9163975242261;931.7065124485799;942.9905700942971;688.5249178067118;689.1110467496923;690.3579670906055;691.1567887177636;692.1417442371473;14251.928740356232;14277.071990320595;14382.856171438256;14437.205953672545;14440.783388249185;14422;15157.166355850424;15613.531594052196;15645.295961681752;15678.608034799106;12274.938625306817;12471.501139954391;12545.811812822814;12565.308908010056;12663.746725065539;4077.4699289092523;4122.711410201287;4146.502419709624;4150.730202536825;4174.457320548309;59147.704261478415;59168.70415647937;59395.703021485046;60771.392286077455;61534.69232653808;12300.507979680713;12325.445354959049;12390.380480975915;12410.255384676948;12467.812982805266;21695.674564881538;21744.89127554352;21770.455738606346;21785.782142178374;21794;8491.787705307417;8598.742037738877;8686.73939781795;8691.652333906573;8779.385443018928;4879.609631229493;5123.231515272739;5170.71561064145;5185.662931909414;5270.578353731692;3671.761335513183;3753.943690844585;3759.4924685167152;3762.059485128718;3768.0391500167284;654.1006116589689;662.3343539742624;685.4893104637077;688.2463702246033;689.8585789913055;697.8046147078826;722.9481104992224;767.244264399566;836.3309352517962;841.0748177005245;9577.425354478753;9579.473128977974;9816.852747208797;10169.745756356151;10262;698.3261152987392;701.5825583777644;737.7344156103799;771.5756334016269;833.7207035643006;4399.912001760011;4413.933790993137;4469.173202957463;4576.542345765397;4583.9083218335445;68251.3174868245;68475.3152468479;68540.6572967142;68578;68718.65640671765;59542.404575954555;60023;60400.697996509734;62290;62467;23547.529049418914;23613.409664758517;23748.52502949966;41511.7924410376;53949.1907621386;8915.910840891767;8991.91008089937;9116.954415227881;9179.541022948959;9228.215601673934;40378.59621403748;40425.170238083054;41001.58998409977;42194.94512637086;42417;50737.492625073275;52257;52854.47145528649;53008.20487692611;53249.73375133255;12491.87508124907;12653.493860245855;12736.872631273569;12972.09195356316;12992.740145197233;12532.624021279376;12556.37218139071;13015.088943773844;13296.667583310495;13681;12729.490820367082;12848.678783030498;13050.282234477196;13162.736745265232;13173.341332933507;11334.659960201207;11580.710482237675;12296.342756447504;12404.441800119197;12419.565315213924;12052.698682532657;12198.939005304917;12405.069619778373;12411.565595204125;12603.684907877376;10363.430011349448;10373.688789336333;10551.94724026375;10804.135669146606;11327.32036077838;10439.478026098514;10649.094826939487;10653.307535010199;10659.25385223058;10798.352098874093 05:46:05 INFO - PROCESS | 434 | __end_tp_report 05:46:05 INFO - PROCESS | 434 | __start_cc_report 05:46:05 INFO - PROCESS | 434 | _x_x_mozilla_cycle_collect,854 05:46:05 INFO - PROCESS | 434 | __end_cc_report 05:46:05 INFO - PROCESS | 434 | __startTimestamp1466772365047__endTimestamp 05:46:05 INFO - PROCESS | 434 | 05:46:05 INFO - PROCESS | 434 | ------- Summary: start ------- 05:46:05 INFO - PROCESS | 434 | Number of tests: 6 05:46:05 INFO - PROCESS | 434 | 05:46:05 INFO - PROCESS | 434 | [#0] dojo.html Cycles:165 Average:5683.80 Median:5921.08 stddev:653.46 (11.0%) stddev-sans-first:629.39 05:46:05 INFO - PROCESS | 434 | Values: 3354.0 3357.3 3369.7 3394.8 3400.3 5635.5 5637.4 5638.5 5650.2 5658.6 5636.0 5650.4 5655.2 5661.2 5661.8 5043.0 5121.6 5171.9 5217.5 5240.1 5171.1 5229.8 5248.1 5258.2 5259.7 5192.7 5244.1 5252.0 5270.0 5273.9 5201.8 5212.8 5220.2 5220.8 5250.4 4995.6 5049.8 5116.6 5140.2 5144.8 5618.2 5631.3 5685.3 5693.8 5697.3 6149.0 6199.1 6200.3 6202.3 6215.2 6128.0 6192.0 6225.2 6226.6 6256.5 5801.9 5802.5 5811.3 5817.5 5819.6 6066.1 6300.2 6304.0 6311.8 6313.9 5942.8 5988.3 5993.0 6008.8 6015.4 6054.8 6075.1 6077.4 6078.7 6079.0 5937.9 5998.8 6052.5 6053.6 6060.9 6109.1 6147.8 6159.2 6165.5 6171.2 4618.1 4650.2 4651.3 4666.0 4681.3 4063.5 4068.1 4089.9 4129.0 4148.4 5722.5 5728.7 5732.3 5733.7 5769.9 6072.8 6074.7 6079.9 6082.2 6083.8 5668.4 5744.0 5796.8 5865.1 5893.6 5236.0 5252.3 5255.7 5256.9 5257.4 6360.7 6368.6 6370.8 6377.4 6381.9 5991.8 6116.4 6177.3 6187.9 6199.3 6403.2 6412.8 6428.6 6433.7 6437.3 5822.1 6052.7 6058.8 6071.2 6078.9 6142.9 6174.5 6181.9 6186.3 6192.5 6012.5 6014.9 6017.5 6018.7 6028.5 5799.9 5899.2 6006.7 6007.8 6010.7 5905.0 5916.2 5918.6 5923.1 5966.8 6000.8 6021.3 6021.8 6028.1 6036.4 5816.2 5921.1 5934.4 5973.5 5999.0 05:46:05 INFO - PROCESS | 434 | 05:46:05 INFO - PROCESS | 434 | [#1] ext.html Cycles:180 Average:55496.40 Median:20000.50 stddev:110548.28 (552.7%) stddev-sans-first:110781.71 05:46:05 INFO - PROCESS | 434 | Values: 653.0 660.3 668.2 674.8 746.5 32276.7 32832.2 33133.2 39689.4 40132.6 42658.8 43159.4 43197.4 43235.6 43254.4 8674.7 8838.4 8858.6 8858.7 8860.5 8192.3 10745.8 11044.7 11051.6 11052.7 10547.6 10639.7 10643.0 10644.2 10645.4 10615.6 10701.1 10705.9 10708.8 10715.0 10461.1 10495.4 10547.0 10562.2 10950.2 43345.0 43631.6 43689.8 43786.0 43822.6 3788.5 3845.8 3858.2 3890.8 3918.7 30580.7 30741.8 31065.8 31080.2 32150.4 3795.7 4289.5 4361.5 4444.9 4583.5 289338.0 291255.0 291880.0 292524.0 293092.0 39389.0 40030.4 40119.6 60675.1 62343.4 37825.4 37839.8 37909.0 37937.8 38055.0 17140.5 17398.7 17404.3 17417.4 17434.0 13458.7 14503.4 14536.6 14655.3 14894.5 9227.9 9275.9 9294.9 9325.7 9357.3 3543.7 3584.5 3626.2 3628.2 3651.7 1074.5 1132.0 1202.5 1206.4 1224.7 33958.3 34334.8 34746.0 34835.7 34936.3 1271.9 1294.8 1328.4 1372.7 1381.9 17748.0 17758.5 17893.9 18085.5 18212.4 571549.0 577988.0 579248.0 581391.0 582542.0 62079.1 63673.0 63717.7 63892.4 63939.0 838.8 1343.9 1368.9 1561.6 1644.2 30063.3 33261.0 33515.2 33668.7 33886.0 49848.0 49898.0 50251.5 50368.7 50447.7 311487.0 312183.0 313266.0 313364.0 314183.0 26303.6 29761.3 30728.7 30748.5 30751.5 44132.8 44786.6 45179.5 46046.3 46313.3 40684.6 41473.0 42228.2 42320.2 43128.0 40607.2 40914.8 41504.8 41807.8 42162.2 41832.0 42437.0 43102.6 43369.1 43474.6 36349.3 36893.3 37345.7 37590.6 37810.2 28766.3 28936.0 29047.0 29153.6 29217.9 05:46:05 INFO - PROCESS | 434 | 05:46:05 INFO - PROCESS | 434 | [#2] jquery.html Cycles:180 Average:29246.34 Median:2299.79 stddev:81326.19 (3536.2%) stddev-sans-first:81525.53 05:46:05 INFO - PROCESS | 434 | Values: 416.5 423.8 429.3 430.4 437.2 19211.9 19466.2 19691.9 19770.5 20482.6 11913.8 11946.6 11984.0 17540.9 18931.2 5250.5 5397.9 5409.7 5417.6 5419.1 5666.3 5909.3 6051.2 6054.4 6071.2 6018.0 6030.3 6030.5 6032.3 6033.8 5637.5 5909.7 5913.5 5919.5 5922.8 5625.4 5817.4 5838.9 5843.4 5848.9 13213.3 13304.6 13415.1 13417.8 13420.1 2428.6 2555.4 2573.5 2653.9 3010.2 9822.1 9909.0 9929.7 10165.4 10368.1 1969.1 1987.8 2082.7 2136.3 2170.9 85543.6 87384.1 89550.0 89642.0 90199.5 11815.9 11893.8 11901.7 11922.0 11979.0 17152.6 17288.2 17289.5 17298.0 17327.3 8805.3 8931.9 9003.5 9012.9 9147.3 8821.8 8879.0 8920.9 8923.8 9028.7 4591.5 4591.8 5008.3 5168.7 5190.1 2065.5 2067.0 2070.2 2075.3 2088.4 1004.9 1061.5 1066.4 1076.4 1086.5 19669.7 19695.7 19913.7 20042.7 20263.4 1047.5 1052.6 1063.6 1099.9 1124.6 10946.0 11089.4 11187.1 11256.0 11357.9 468650.0 481105.0 499225.0 505836.0 507259.0 81433.6 89463.6 89804.6 92927.0 96801.5 1078.2 1121.0 1135.7 1137.2 1144.4 18173.7 18347.4 18349.4 18457.7 18725.7 40750.0 41488.2 41737.4 42480.0 44013.3 57408.4 60239.2 60445.0 60644.4 61098.8 8712.8 8746.8 8822.5 8927.1 9119.9 9469.0 12751.9 14111.2 14325.0 14341.4 12531.9 12627.5 12954.4 13041.2 13258.9 12243.1 12560.6 12610.4 12672.6 12720.2 12908.7 13066.7 13142.9 13365.9 13517.3 8411.6 8770.2 8871.3 8963.8 9070.8 11251.3 12078.8 12102.5 12200.6 12225.3 05:46:05 INFO - PROCESS | 434 | 05:46:05 INFO - PROCESS | 434 | [#3] mootools.html Cycles:180 Average:5787.60 Median:5125.72 stddev:3220.53 (62.8%) stddev-sans-first:3212.63 05:46:05 INFO - PROCESS | 434 | Values: 1392.9 1587.2 1605.1 1789.5 1881.3 8314.5 8484.3 8512.3 8514.7 8524.9 8388.9 8557.4 8557.7 8573.1 8575.0 2400.8 2425.4 2426.2 2430.0 2430.4 2458.8 2474.3 2503.8 2507.6 2511.5 2412.2 2424.6 2458.1 2464.8 2473.9 2435.7 2446.7 2451.6 2453.5 2469.8 2417.6 2452.3 2468.1 2475.0 2497.2 8332.3 8551.7 8730.7 8793.1 8809.2 5197.1 5266.2 5292.5 5300.4 5321.4 3369.8 3388.7 3429.0 3493.3 3524.4 1135.6 1144.3 1155.4 1167.5 1198.2 12393.9 12498.3 12504.5 12510.2 12540.3 4489.4 4555.0 4626.8 4640.7 4642.1 9941.9 9952.5 9957.0 9959.9 9973.5 5303.3 5342.4 5353.5 5356.5 5357.1 4372.8 4693.0 4796.6 4824.6 4995.8 3947.9 3953.8 4028.0 4038.0 4102.6 1229.9 1281.1 1285.5 1293.0 1304.6 1077.7 1078.9 1090.3 1093.3 1103.6 6261.1 6312.2 6339.0 6351.3 6396.0 447.8 450.7 460.7 461.0 467.7 4202.5 4211.2 4224.9 4228.5 4229.2 10529.4 10895.1 10991.3 11040.4 11050.3 10768.9 10842.5 10844.7 10850.2 10875.9 7954.6 8310.5 8406.0 8411.5 8417.3 6016.6 6054.0 6063.1 6181.2 6188.7 9200.9 9397.3 9633.4 9635.1 9642.6 9594.4 9651.7 9704.3 9770.1 9801.2 7008.5 7549.3 7758.4 7890.5 8016.0 8396.5 8408.8 8411.3 8450.9 8452.4 7517.1 7624.2 7628.5 7754.3 7766.1 7455.6 7500.4 7548.9 7594.7 7709.5 7057.8 7082.9 7112.1 7161.7 7179.1 5054.4 5213.1 5285.3 5404.0 5468.6 5293.3 5335.5 5340.1 5401.1 5451.8 05:46:05 INFO - PROCESS | 434 | 05:46:05 INFO - PROCESS | 434 | [#4] prototype.html Cycles:180 Average:5611.61 Median:6449.31 stddev:1675.40 (26.0%) stddev-sans-first:1633.00 05:46:05 INFO - PROCESS | 434 | Values: 356.4 368.7 369.1 369.2 370.0 6320.8 6327.1 6329.6 6330.9 6385.8 5996.9 6116.0 6209.9 6239.4 6348.9 4843.7 4875.5 4876.7 4883.7 4886.9 4861.2 4866.9 4875.8 4882.1 4883.1 4598.1 4630.1 4749.5 4784.6 4785.4 4769.5 4774.8 4785.5 4786.3 4802.7 4238.0 4245.7 4246.3 4249.4 4262.4 5949.1 5967.3 5971.5 5974.5 5990.9 5591.2 5597.0 5605.4 5605.9 5606.7 6461.9 6594.1 6597.8 6603.2 6604.0 4739.5 4745.8 4746.8 4763.6 4765.6 6855.3 6867.6 6869.1 6872.8 6886.2 4857.3 4858.5 4860.7 4863.2 4865.4 4938.3 4938.9 4939.4 4946.0 4947.5 5495.1 5566.0 5592.7 5596.5 5614.5 6598.7 6600.3 6604.2 6635.4 6653.1 1643.9 1680.5 1718.8 1745.2 1745.4 1108.2 1111.5 1115.9 1147.3 1152.8 6445.1 6462.3 6470.4 6478.3 6486.5 6860.2 6868.9 6875.0 6884.6 6895.9 6453.5 6453.8 6456.1 6457.3 6466.8 3681.4 3721.5 3722.3 3722.6 3730.8 7041.9 7099.9 7180.2 7184.4 7184.8 6939.4 6978.8 6987.4 6990.2 6990.7 7166.8 7178.8 7180.5 7182.0 7188.0 6815.8 6820.8 6831.3 6855.8 6867.6 6678.5 6760.0 6788.5 6881.6 6905.4 7175.1 7234.7 7238.0 7251.3 7255.1 4925.1 4963.7 4969.1 4973.1 4978.8 6676.1 6928.8 6928.9 6932.6 6935.4 6588.9 6757.8 6760.9 6773.1 6774.1 6714.4 6752.0 6756.3 6762.6 6774.5 6650.6 6651.6 6651.9 6655.6 6664.2 6562.6 6744.9 6799.7 6806.7 6816.7 6609.8 6629.2 6639.3 6645.2 6652.0 05:46:05 INFO - PROCESS | 434 | 05:46:05 INFO - PROCESS | 434 | [#5] yui.html Cycles:180 Average:15537.28 Median:23408.46 stddev:18358.84 (78.4%) stddev-sans-first:18377.22 05:46:05 INFO - PROCESS | 434 | Values: 852.4 892.0 906.7 929.9 944.7 15323.6 15366.6 15430.2 15569.9 15659.3 14066.3 14219.6 14273.9 14281.8 14336.3 726.4 874.4 877.7 892.1 897.0 885.6 888.1 889.9 891.8 891.9 937.1 938.0 939.2 939.5 940.5 757.1 765.8 928.9 931.7 943.0 688.5 689.1 690.4 691.2 692.1 14251.9 14277.1 14382.9 14437.2 14440.8 14422.0 15157.2 15613.5 15645.3 15678.6 12274.9 12471.5 12545.8 12565.3 12663.7 4077.5 4122.7 4146.5 4150.7 4174.5 59147.7 59168.7 59395.7 60771.4 61534.7 12300.5 12325.4 12390.4 12410.3 12467.8 21695.7 21744.9 21770.5 21785.8 21794.0 8491.8 8598.7 8686.7 8691.7 8779.4 4879.6 5123.2 5170.7 5185.7 5270.6 3671.8 3753.9 3759.5 3762.1 3768.0 654.1 662.3 685.5 688.2 689.9 697.8 722.9 767.2 836.3 841.1 9577.4 9579.5 9816.9 10169.7 10262.0 698.3 701.6 737.7 771.6 833.7 4399.9 4413.9 4469.2 4576.5 4583.9 68251.3 68475.3 68540.7 68578.0 68718.7 59542.4 60023.0 60400.7 62290.0 62467.0 23547.5 23613.4 23748.5 41511.8 53949.2 8915.9 8991.9 9117.0 9179.5 9228.2 40378.6 40425.2 41001.6 42194.9 42417.0 50737.5 52257.0 52854.5 53008.2 53249.7 12491.9 12653.5 12736.9 12972.1 12992.7 12532.6 12556.4 13015.1 13296.7 13681.0 12729.5 12848.7 13050.3 13162.7 13173.3 11334.7 11580.7 12296.3 12404.4 12419.6 12052.7 12198.9 12405.1 12411.6 12603.7 10363.4 10373.7 10551.9 10804.1 11327.3 10439.5 10649.1 10653.3 10659.3 10798.4 05:46:05 INFO - PROCESS | 434 | -------- Summary: end -------- 05:46:05 INFO - PROCESS | 434 | 05:46:05 INFO - TEST-INFO | 434: exit 0 05:46:05 INFO - TEST-OK | dromaeo_css | took 1110055ms 05:46:05 INFO - TEST-START | kraken 05:46:05 INFO - operating with platform_type : linux_ 05:46:05 INFO - Initialising browser for kraken test... 05:46:05 INFO - TEST-INFO | started process 626 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4f2baT/profile http://localhost:41517/getInfo.html) 05:46:09 INFO - PROCESS | 626 | __metrics Screen width/height:1600/1200 05:46:09 INFO - PROCESS | 626 | colorDepth:24 05:46:09 INFO - PROCESS | 626 | Browser inner width/height: 1024/697 05:46:09 INFO - PROCESS | 626 | __metrics 05:46:10 ERROR - PROCESS | 626 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:46:10 INFO - TEST-INFO | 626: exit 0 05:46:10 INFO - Browser initialized. 05:46:10 INFO - Running cycle 1/1 for kraken test... 05:46:10 INFO - TEST-INFO | started process 715 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4f2baT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:46:22 INFO - PROCESS | 715 | RSS: Main: 139812864 05:46:22 INFO - PROCESS | 715 | 05:46:24 INFO - PROCESS | 715 | Cycle 1(1): loaded http://localhost:41517/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41517/tests/kraken/driver.html?testName=audio-beat-detection) 05:46:25 INFO - PROCESS | 715 | RSS: Main: 197980160 05:46:25 INFO - PROCESS | 715 | 05:46:28 INFO - PROCESS | 715 | Cycle 1(1): loaded http://localhost:41517/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41517/tests/kraken/driver.html?testName=audio-dft) 05:46:28 INFO - PROCESS | 715 | RSS: Main: 185540608 05:46:28 INFO - PROCESS | 715 | 05:46:31 INFO - PROCESS | 715 | Cycle 1(1): loaded http://localhost:41517/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41517/tests/kraken/driver.html?testName=audio-fft) 05:46:32 INFO - PROCESS | 715 | RSS: Main: 274575360 05:46:32 INFO - PROCESS | 715 | 05:46:34 INFO - PROCESS | 715 | Cycle 1(1): loaded http://localhost:41517/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41517/tests/kraken/driver.html?testName=audio-oscillator) 05:46:35 INFO - PROCESS | 715 | RSS: Main: 180989952 05:46:35 INFO - PROCESS | 715 | 05:46:37 INFO - PROCESS | 715 | Cycle 1(1): loaded http://localhost:41517/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41517/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:46:37 INFO - PROCESS | 715 | RSS: Main: 178933760 05:46:37 INFO - PROCESS | 715 | 05:46:40 INFO - PROCESS | 715 | Cycle 1(1): loaded http://localhost:41517/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41517/tests/kraken/driver.html?testName=imaging-darkroom) 05:46:41 INFO - PROCESS | 715 | RSS: Main: 213561344 05:46:41 INFO - PROCESS | 715 | 05:46:44 INFO - PROCESS | 715 | Cycle 1(1): loaded http://localhost:41517/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41517/tests/kraken/driver.html?testName=imaging-desaturate) 05:46:45 INFO - PROCESS | 715 | RSS: Main: 213745664 05:46:45 INFO - PROCESS | 715 | 05:46:48 INFO - PROCESS | 715 | Cycle 1(1): loaded http://localhost:41517/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41517/tests/kraken/driver.html?testName=json-parse-financial) 05:46:48 INFO - PROCESS | 715 | RSS: Main: 212422656 05:46:48 INFO - PROCESS | 715 | 05:46:50 INFO - PROCESS | 715 | Cycle 1(1): loaded http://localhost:41517/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41517/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:46:50 INFO - PROCESS | 715 | RSS: Main: 194789376 05:46:50 INFO - PROCESS | 715 | 05:46:52 INFO - PROCESS | 715 | Cycle 1(1): loaded http://localhost:41517/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41517/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:46:53 INFO - PROCESS | 715 | RSS: Main: 199262208 05:46:53 INFO - PROCESS | 715 | 05:46:54 INFO - PROCESS | 715 | Cycle 1(1): loaded http://localhost:41517/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41517/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:46:55 INFO - PROCESS | 715 | RSS: Main: 209682432 05:46:55 INFO - PROCESS | 715 | 05:46:57 INFO - PROCESS | 715 | Cycle 1(1): loaded http://localhost:41517/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41517/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:46:58 INFO - PROCESS | 715 | RSS: Main: 214528000 05:46:58 INFO - PROCESS | 715 | 05:47:01 INFO - PROCESS | 715 | Cycle 1(1): loaded http://localhost:41517/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41517/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:47:01 INFO - PROCESS | 715 | RSS: Main: 211689472 05:47:01 INFO - PROCESS | 715 | 05:47:03 INFO - PROCESS | 715 | Cycle 1(1): loaded http://localhost:41517/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41517/tests/kraken/driver.html?testName=ai-astar) 05:47:03 INFO - PROCESS | 715 | RSS: Main: 272891904 05:47:03 INFO - PROCESS | 715 | 05:47:03 INFO - PROCESS | 715 | __start_tp_report 05:47:03 INFO - PROCESS | 715 | _x_x_mozilla_page_load 05:47:03 INFO - PROCESS | 715 | _x_x_mozilla_page_load_details 05:47:03 INFO - PROCESS | 715 | |i|pagename|runs| 05:47:03 INFO - PROCESS | 715 | |0;ai-astar;110;109;110;110;109;109;105;110;110;109 05:47:03 INFO - PROCESS | 715 | |1;audio-beat-detection;155;125;151;171;126;157;160;130;183;126 05:47:03 INFO - PROCESS | 715 | |2;audio-dft;161;162;162;161;163;161;162;162;159;162 05:47:03 INFO - PROCESS | 715 | |3;audio-fft;73;76;75;173;77;76;76;76;167;75 05:47:03 INFO - PROCESS | 715 | |4;audio-oscillator;92;91;161;92;92;93;152;91;92;154 05:47:03 INFO - PROCESS | 715 | |5;imaging-gaussian-blur;116;116;117;117;117;117;116;117;116;117 05:47:03 INFO - PROCESS | 715 | |6;imaging-darkroom;145;144;146;145;145;145;146;146;145;146 05:47:03 INFO - PROCESS | 715 | |7;imaging-desaturate;94;94;95;95;94;94;94;94;94;94 05:47:03 INFO - PROCESS | 715 | |8;json-parse-financial;54;52;54;53;54;55;57;71;53;52 05:47:03 INFO - PROCESS | 715 | |9;json-stringify-tinderbox;57;59;60;58;58;57;58;58;58;60 05:47:03 INFO - PROCESS | 715 | |10;stanford-crypto-aes;71;73;70;72;73;74;72;73;73;73 05:47:03 INFO - PROCESS | 715 | |11;stanford-crypto-ccm;113;111;112;113;115;116;112;110;126;124 05:47:03 INFO - PROCESS | 715 | |12;stanford-crypto-pbkdf2;158;161;159;164;159;159;158;164;157;158 05:47:03 INFO - PROCESS | 715 | |13;stanford-crypto-sha256-iterative;63;67;66;68;66;66;66;66;67;65 05:47:03 INFO - PROCESS | 715 | __end_tp_report 05:47:03 INFO - PROCESS | 715 | __start_cc_report 05:47:03 INFO - PROCESS | 715 | _x_x_mozilla_cycle_collect,1573 05:47:03 INFO - PROCESS | 715 | __end_cc_report 05:47:03 INFO - PROCESS | 715 | __startTimestamp1466772423814__endTimestamp 05:47:03 INFO - PROCESS | 715 | 05:47:03 INFO - PROCESS | 715 | ------- Summary: start ------- 05:47:03 INFO - PROCESS | 715 | Number of tests: 14 05:47:03 INFO - PROCESS | 715 | 05:47:03 INFO - PROCESS | 715 | [#0] ai-astar Cycles:10 Average:109.10 Median:110.00 stddev:1.52 (1.4%) stddev-sans-first:1.58 05:47:03 INFO - PROCESS | 715 | Values: 110.0 109.0 110.0 110.0 109.0 109.0 105.0 110.0 110.0 109.0 05:47:03 INFO - PROCESS | 715 | 05:47:03 INFO - PROCESS | 715 | [#1] audio-beat-detection Cycles:10 Average:148.40 Median:156.00 stddev:20.70 (13.3%) stddev-sans-first:21.82 05:47:03 INFO - PROCESS | 715 | Values: 155.0 125.0 151.0 171.0 126.0 157.0 160.0 130.0 183.0 126.0 05:47:03 INFO - PROCESS | 715 | 05:47:03 INFO - PROCESS | 715 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:1.08 (0.7%) stddev-sans-first:1.13 05:47:03 INFO - PROCESS | 715 | Values: 161.0 162.0 162.0 161.0 163.0 161.0 162.0 162.0 159.0 162.0 05:47:03 INFO - PROCESS | 715 | 05:47:03 INFO - PROCESS | 715 | [#3] audio-fft Cycles:10 Average:94.40 Median:76.00 stddev:39.88 (52.5%) stddev-sans-first:41.54 05:47:03 INFO - PROCESS | 715 | Values: 73.0 76.0 75.0 173.0 77.0 76.0 76.0 76.0 167.0 75.0 05:47:03 INFO - PROCESS | 715 | 05:47:03 INFO - PROCESS | 715 | [#4] audio-oscillator Cycles:10 Average:111.00 Median:92.00 stddev:30.91 (33.6%) stddev-sans-first:32.01 05:47:03 INFO - PROCESS | 715 | Values: 92.0 91.0 161.0 92.0 92.0 93.0 152.0 91.0 92.0 154.0 05:47:03 INFO - PROCESS | 715 | 05:47:03 INFO - PROCESS | 715 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 05:47:03 INFO - PROCESS | 715 | Values: 116.0 116.0 117.0 117.0 117.0 117.0 116.0 117.0 116.0 117.0 05:47:03 INFO - PROCESS | 715 | 05:47:03 INFO - PROCESS | 715 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.50 stddev:0.67 (0.5%) stddev-sans-first:0.71 05:47:03 INFO - PROCESS | 715 | Values: 145.0 144.0 146.0 145.0 145.0 145.0 146.0 146.0 145.0 146.0 05:47:03 INFO - PROCESS | 715 | 05:47:03 INFO - PROCESS | 715 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:47:03 INFO - PROCESS | 715 | Values: 94.0 94.0 95.0 95.0 94.0 94.0 94.0 94.0 94.0 94.0 05:47:03 INFO - PROCESS | 715 | 05:47:03 INFO - PROCESS | 715 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:54.00 stddev:5.64 (10.4%) stddev-sans-first:5.96 05:47:03 INFO - PROCESS | 715 | Values: 54.0 52.0 54.0 53.0 54.0 55.0 57.0 71.0 53.0 52.0 05:47:03 INFO - PROCESS | 715 | 05:47:03 INFO - PROCESS | 715 | [#9] json-stringify-tinderbox Cycles:10 Average:58.30 Median:58.00 stddev:1.06 (1.8%) stddev-sans-first:1.01 05:47:03 INFO - PROCESS | 715 | Values: 57.0 59.0 60.0 58.0 58.0 57.0 58.0 58.0 58.0 60.0 05:47:03 INFO - PROCESS | 715 | 05:47:03 INFO - PROCESS | 715 | [#10] stanford-crypto-aes Cycles:10 Average:72.40 Median:73.00 stddev:1.17 (1.6%) stddev-sans-first:1.13 05:47:03 INFO - PROCESS | 715 | Values: 71.0 73.0 70.0 72.0 73.0 74.0 72.0 73.0 73.0 73.0 05:47:03 INFO - PROCESS | 715 | 05:47:03 INFO - PROCESS | 715 | [#11] stanford-crypto-ccm Cycles:10 Average:115.20 Median:114.00 stddev:5.47 (4.8%) stddev-sans-first:5.75 05:47:03 INFO - PROCESS | 715 | Values: 113.0 111.0 112.0 113.0 115.0 116.0 112.0 110.0 126.0 124.0 05:47:03 INFO - PROCESS | 715 | 05:47:03 INFO - PROCESS | 715 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.70 Median:159.00 stddev:2.50 (1.6%) stddev-sans-first:2.57 05:47:03 INFO - PROCESS | 715 | Values: 158.0 161.0 159.0 164.0 159.0 159.0 158.0 164.0 157.0 158.0 05:47:03 INFO - PROCESS | 715 | 05:47:03 INFO - PROCESS | 715 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.00 stddev:1.33 (2.0%) stddev-sans-first:0.87 05:47:03 INFO - PROCESS | 715 | Values: 63.0 67.0 66.0 68.0 66.0 66.0 66.0 66.0 67.0 65.0 05:47:03 INFO - PROCESS | 715 | -------- Summary: end -------- 05:47:03 INFO - PROCESS | 715 | 05:47:04 INFO - TEST-INFO | 715: exit 0 05:47:04 INFO - TEST-OK | kraken | took 58991ms 05:47:04 INFO - SUITE-END | took 1169s 05:47:04 INFO - Completed test suite (00:19:29) 05:47:04 INFO - javascript benchmark 05:47:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3353.9770370037136, 3357.3117510910265, 3369.663033696629, 3394.7623666343366, 3400.268942177431, 5635.549156067515, 5637.436256374371, 5638.548916086714, 5650.237217975572, 5658.603897727161, 5636.0, 5650.378458369586, 5655.1517272409155, 5661.179129026289, 5661.801836935698, 5043.0, 5121.5646670033, 5171.870703232412, 5217.504337087989, 5240.135377662681, 5171.120909445384, 5229.8169564065265, 5248.0815857225025, 5258.211268309765, 5259.684418934857, 5192.740362981855, 5244.056069907415, 5251.973740131313, 5269.973650131744, 5273.920891186635, 5201.817936372227, 5212.843614691566, 5220.216967454912, 5220.817271395502, 5250.369955605352, 4995.5753760930365, 5049.798008079672, 5116.616253780981, 5140.228965655144, 5144.768485418128, 5618.185363122325, 5631.324241091054, 5685.260916080883, 5693.77224911003, 5697.31632204134, 6149.016157414837, 6199.132121502993, 6200.348963358828, 6202.348753380875, 6215.223097112861, 6127.953177891112, 6192.040233763774, 6225.159603453566, 6226.564140510166, 6256.468200202943, 5801.854953626151, 5802.477777000048, 5811.27359080115, 5817.505512031483, 5819.621724587931, 6066.090086487062, 6300.21247344082, 6304.022876454157, 6311.810645680637, 6313.936860631335, 5942.762289508458, 5988.341282458926, 5993.041113421831, 6008.759649614054, 6015.368386319461, 6054.7880824171825, 6075.149479072933, 6077.4226448487325, 6078.7264573093435, 6078.969605151946, 5937.940620593825, 5998.790042348497, 6052.515798736091, 6053.636781793019, 6060.909086363708, 6109.14471973924, 6147.84630384244, 6159.23009623797, 6165.537584681167, 6171.197744293213, 4618.145643056046, 4650.209464391061, 4651.2557990722, 4666.043461090469, 4681.297805329228, 4063.4514340563646, 4068.0846809467635, 4089.9386509202386, 4128.958710412858, 4148.357004664282, 5722.456366645162, 5728.742206600713, 5732.34078081026, 5733.684647344353, 5769.913451298234, 6072.817815465543, 6074.665893375906, 6079.878402431927, 6082.2093127893095, 6083.756649733961, 5668.433156684381, 5743.971280143573, 5796.82609521715, 5865.090910908816, 5893.587448878623, 5235.952809438128, 5252.317198764136, 5255.737213139404, 5256.868578285497, 5257.369115706063, 6360.681965901686, 6368.64972426521, 6370.77702280418, 6377.426031657174, 6381.936180638227, 5991.760329586855, 6116.42707509198, 6177.320494745664, 6187.907181392193, 6199.318075011835, 6403.231612206565, 6412.807615771534, 6428.646424446701, 6433.710483028181, 6437.291897891322, 5822.097574875901, 6052.66710330936, 6058.787942421994, 6071.150038994632, 6078.939210607838, 6142.907856382247, 6174.536909731698, 6181.907271391023, 6186.257649082139, 6192.473639740672, 6012.549058820518, 6014.879702405839, 6017.548683848641, 6018.699065046818, 6028.547858910687, 5799.9130013049, 5899.233099697012, 6006.699665016819, 6007.8197654070445, 6010.669413182317, 5905.0, 5916.230889984275, 5918.556108291981, 5923.141144533933, 5966.791162309299, 6000.849978750566, 6021.337652858095, 6021.849453763691, 6028.065649824284, 6036.396360363929, 5816.21481100063, 5921.082232254007, 5934.406559344031, 5973.462388385066, 5999.0], "value": 5639.548815957652, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [652.9804105876823, 660.3495556876476, 668.231533736203, 674.7739507265065, 746.4588173574158, 32276.67723322766, 32832.179195520155, 33133.171670708216, 39689.404658930136, 40132.59867401325, 42658.78670606643, 43159.35260971088, 43197.35203971943, 43235.56764432355, 43254.35118473225, 8674.653013879437, 8838.381313308071, 8858.601362938683, 8858.689945851896, 8860.468371897674, 8192.262696357328, 10745.83881241782, 11044.668659940215, 11051.557937682483, 11052.668419947415, 10547.578096876154, 10639.680809575726, 10643.04212620864, 10644.201684873628, 10645.414502202375, 10615.57537698491, 10701.090407315387, 10705.892941070606, 10708.785824283548, 10715.035646791826, 10461.110805581535, 10495.42275174865, 10547.0, 10562.207834412373, 10950.233483656148, 43345.0, 43631.56368436307, 43689.78155109204, 43786.0, 43822.561774382164, 3788.5264341957254, 3845.8461661533506, 3858.164249276779, 3890.8443662253476, 3918.7060970427333, 30580.694193058007, 30741.848070635064, 31065.84467077673, 31080.22299442532, 32150.35699286001, 3795.7153213508823, 4289.463817022872, 4361.476622805252, 4444.888877778049, 4583.518730533279, 289338.0, 291254.9999999979, 291880.0, 292524.0, 293092.0, 39389.0, 40030.39954400686, 40119.59880401217, 60675.08987365193, 62343.37656623466, 37825.43261851074, 37839.810800945816, 37909.0, 37937.81031094827, 38055.0, 17140.485785426456, 17398.739018914726, 17404.303827846998, 17417.39039133624, 17434.04112773784, 13458.663533411744, 14503.419863205354, 14536.636584085483, 14655.340509676877, 14894.478693245685, 9227.90772092284, 9275.860862087075, 9294.90705092954, 9325.720228393158, 9357.344985850925, 3543.6810687037773, 3584.5340105786604, 3626.1841085755495, 3628.1836586767768, 3651.726120540917, 1074.484247561175, 1132.0377678972807, 1202.4588934979295, 1206.3968015992004, 1224.7244370016854, 33958.32083358368, 34334.82832585821, 34746.0, 34835.65164348375, 34936.30127397489, 1271.9236845789283, 1294.8316718826682, 1328.3992788689607, 1372.7254549090221, 1381.9170849749048, 17748.0, 17758.46724598264, 17893.93266057151, 18085.547861303574, 18212.36256731008, 571549.0, 577988.0, 579248.0, 581391.0, 582542.0, 62079.068813967824, 63673.0, 63717.68141159357, 63892.36107638864, 63939.0, 838.8364268967615, 1343.9462421503226, 1368.9247091410068, 1561.5861796623676, 1644.2189959769253, 30063.278584464293, 33261.0, 33515.16212094717, 33668.66331336655, 33886.0, 49848.0, 49898.0, 50251.49748502468, 50368.74815625898, 50447.74776126096, 311487.0, 312183.0, 313266.0, 313364.0, 314183.0, 26303.605445917943, 29761.25596860096, 30728.69271307258, 30748.538771917993, 30751.53872691956, 44132.779336103114, 44786.55213447954, 45179.54820451885, 46046.309305361116, 46313.305300419845, 40684.59315406808, 41473.0, 42228.155436890476, 42320.1535969285, 43128.0, 40607.1878562433, 40914.795426022676, 41504.79247603743, 41807.790961045, 42162.156756864075, 41832.0458509843, 42437.0, 43102.568974309856, 43369.13261734811, 43474.56525434705, 36349.27301454009, 36893.26213475769, 37345.65123928884, 37590.62409375871, 37810.243795124494, 28766.280842979093, 28936.0, 29047.0, 29153.56269655999, 29217.85391073031], "value": 19567.882834965625, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [416.502279775668, 423.82199476219984, 429.3302448180838, 430.37165738022486, 437.19992413882596, 19211.903940480297, 19466.221351145938, 19691.901540492294, 19770.505737356554, 20482.590348193025, 11913.7617247655, 11946.641600751991, 11984.0, 17540.930337190974, 18931.242750290006, 5250.501202385786, 5397.919031214535, 5409.702466364349, 5417.566594672437, 5419.051665958461, 5666.320041595014, 5909.320428150775, 6051.2133422655, 6054.364291749347, 6071.210742603455, 6018.007028840258, 6030.276366835964, 6030.487408570255, 6032.306284777263, 6033.818985430444, 5637.520810731093, 5909.674967876765, 5913.526917846583, 5919.467247947684, 5922.763089476416, 5625.38120806711, 5817.360090390053, 5838.883222335572, 5843.415658434165, 5848.853778655525, 13213.273269970148, 13304.600861974157, 13415.060945733803, 13417.798733019012, 13420.060595758301, 2428.6357046443, 2555.3611597100726, 2573.4981678572685, 2653.8805753741126, 3010.1872494426384, 9822.066903644143, 9909.0, 9929.702108936743, 10165.440900750456, 10368.118709909591, 1969.1272511379407, 1987.8111579399933, 2082.6980087887323, 2136.2950226425396, 2170.945726356838, 85543.57228213882, 87384.12615873823, 89550.0, 89642.0, 90199.54900225523, 11815.940920295343, 11893.81061893821, 11901.702457438634, 11922.0, 11978.981786548067, 17152.571185720455, 17288.22203000868, 17289.48131556055, 17298.048607326717, 17327.306907723803, 8805.295576353876, 8931.910680893237, 9003.504807235666, 9012.909870901338, 9147.313951453667, 8821.750453634282, 8879.023307436177, 8920.910790892009, 8923.776905577413, 9028.683996060106, 4591.471980722193, 4591.8392856249875, 5008.273800298936, 5168.715720635401, 5190.091733946544, 2065.473304307392, 2066.958660826805, 2070.244360808294, 2075.3151460018157, 2088.4152437317575, 1004.8794144702682, 1061.5382308695741, 1066.3814987307344, 1076.424113099488, 1086.4839201379282, 19669.704954425695, 19695.704564431544, 19913.701294480594, 20042.699359509617, 20263.392098237076, 1047.5233768635253, 1052.6421016854306, 1063.5958335832333, 1099.8955099265556, 1124.6401151631399, 10946.0, 11089.390083545482, 11187.105031597453, 11256.0, 11357.886421135849, 468650.0, 481105.0, 499225.0, 505836.0, 507259.0, 81433.59283203665, 89463.55268223617, 89804.5509772447, 92927.0, 96801.515992421, 1078.223678951154, 1121.0415095093579, 1135.65362564417, 1137.2323681514945, 1144.3820337018083, 18173.727394089365, 18347.35784247545, 18349.449516514527, 18457.723134153268, 18725.719114213025, 40750.0, 41488.1702365957, 41737.37393939154, 42480.0, 44013.33979990367, 57408.42591574031, 60239.192824215344, 60445.0, 60644.39355606387, 61098.77802444015, 8712.823768791131, 8746.781330466789, 8822.470651760916, 8927.10728927128, 9119.908800912172, 9469.0, 12751.936240318739, 14111.22388268655, 14325.0, 14341.426342946166, 12531.93734031324, 12627.494900203888, 12954.41042104583, 13041.217526948414, 13258.933705331412, 12243.142979991315, 12560.623181304576, 12610.369481525704, 12672.556460523838, 12720.173188742701, 12908.677283067998, 13066.738665226452, 13142.868571314548, 13365.859023129362, 13517.256550889795, 8411.621477033426, 8770.210681038738, 8871.290296776113, 8963.775905602151, 9070.81858362816, 11251.268667536584, 12078.75842483163, 12102.45538950767, 12200.633980980585, 12225.266484010988], "value": 9455.904715867438, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1392.8816050635696, 1587.1984647752884, 1605.0851014921493, 1789.5436663650767, 1881.3415304643368, 8314.542700151489, 8484.278836298907, 8512.319014478842, 8514.701985430504, 8524.8721269181, 8388.874166887486, 8557.358198135134, 8557.700480483169, 8573.142685731424, 8575.0, 2400.7719266669637, 2425.3694039549755, 2426.2236084452984, 2430.040134147011, 2430.44099857033, 2458.766417190364, 2474.307193985687, 2503.812214083942, 2507.6489291499206, 2511.510255500178, 2412.2039726890084, 2424.648425978232, 2458.1150785717127, 2464.7658472445178, 2473.925782226527, 2435.6833611630464, 2446.657467954488, 2451.5832308507597, 2453.472503411775, 2469.790067844235, 2417.6131818909066, 2452.3256104571205, 2468.062136388179, 2475.0223661653727, 2497.1759319424546, 8332.33341332692, 8551.700690475865, 8730.694425695134, 8793.12068793122, 8809.163129502687, 5197.064528384889, 5266.15741481365, 5292.470752924715, 5300.390455097636, 5321.414644389114, 3369.848356823949, 3388.7458440616806, 3428.9541689784605, 3493.266414053052, 3524.4184709522897, 1135.5571327182406, 1144.2619510415818, 1155.439611788282, 1167.532986805276, 1198.2031948754068, 12393.876061239453, 12498.250104993638, 12504.49982000728, 12510.18683785551, 12540.310282934435, 4489.371487991683, 4554.977225113853, 4626.750777290113, 4640.65195110368, 4642.094791515622, 9941.850872236922, 9952.452615106238, 9957.0, 9959.850602240973, 9973.451460169616, 5303.28405665238, 5342.3856256531, 5353.518183363516, 5356.517913387814, 5357.08929481989, 4372.80322385487, 4692.9530704692515, 4796.640251981045, 4824.56578907893, 4995.800167993312, 3947.8945895149404, 3953.7825419601622, 4027.979860100739, 4037.959620403817, 4102.610252026053, 1229.9385030748426, 1281.1288323939625, 1285.4858056777364, 1292.9676758080934, 1304.5564508067303, 1077.6874706335075, 1078.940658263803, 1090.3022065877844, 1093.2565855218527, 1103.564092183583, 6261.092141639437, 6312.242530896322, 6339.049142628551, 6351.301356850743, 6396.040593910858, 447.8141571247896, 450.7160488891977, 460.7442869207555, 460.9769511524477, 467.7357293129371, 4202.516710578323, 4211.1998720243055, 4224.8732538023905, 4228.534861165269, 4229.217594744982, 10529.36823790575, 10895.07391871684, 10991.340519568852, 11040.392778397105, 11050.336979781077, 10768.946155269174, 10842.457877106113, 10844.728881778019, 10850.240483166102, 10875.945620271848, 7954.647709889217, 8310.459820111673, 8406.033306169746, 8411.495310281403, 8417.326613870875, 6016.639001659914, 6054.031354983182, 6063.090536419572, 6181.227346581677, 6188.659623720739, 9200.907990920005, 9397.342186046912, 9633.421994680342, 9635.13283804461, 9642.56442036671, 9594.376365536218, 9651.662191823252, 9704.272179586418, 9770.120689138012, 9801.215902727621, 7008.5094043416475, 7549.282818132268, 7758.4181186410115, 7890.48711833729, 8016.0380754307525, 8396.454230475, 8408.789780255542, 8411.285040771603, 8450.915490845258, 8452.366072544706, 7517.135529414188, 7624.199459056941, 7628.504147230412, 7754.263344982218, 7766.106897706836, 7455.627218639155, 7500.36246919018, 7548.886766698394, 7594.658240379306, 7709.498882572615, 7057.752978645723, 7082.893756593552, 7112.146542414944, 7161.677724502306, 7179.138503379628, 5054.368203974504, 5213.1137706590725, 5285.312909321764, 5403.972980135074, 5468.6171967963455, 5293.258943747801, 5335.519803217729, 5340.118880384848, 5401.081816091195, 5451.781928722965], "value": 4612.2587556272965, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.3549974546072, 368.6958259435965, 369.0865108855581, 369.2025225512892, 369.9611540788217, 6320.810375688725, 6327.050942358648, 6329.588576742509, 6330.905036424458, 6385.840353991152, 5996.88006239876, 6116.0, 6209.937900620993, 6239.376062393759, 6348.936510634892, 4843.66094373394, 4875.463698993108, 4876.731779752112, 4883.706977581356, 4886.853394398174, 4861.197902346109, 4866.853994380174, 4875.804967801284, 4882.121218180726, 4883.072216278913, 4598.057398233371, 4630.120277147348, 4749.52504749524, 4784.617230621542, 4785.353977213083, 4769.499202583714, 4774.832880849189, 4785.473597904228, 4786.2581299898575, 4802.711837289774, 4238.0, 4245.660347172219, 4246.299360605496, 4249.447571815645, 4262.360645903108, 5949.137375080632, 5967.283925928873, 5971.462568368825, 5974.462298393166, 5990.9101363479585, 5591.245181900432, 5596.972015139898, 5605.355384130837, 5605.915911261334, 5606.6636001839615, 6461.870762584769, 6594.109795177637, 6597.835054123685, 6603.174603174603, 6603.966980165116, 4739.454962679301, 4745.83389581363, 4746.833860814855, 4763.595094416979, 4765.642576806753, 6855.314468553105, 6867.622280774555, 6869.072675188835, 6872.828179295508, 6886.173659160882, 4857.271409288564, 4858.46556878743, 4860.684055536379, 4863.2461968394955, 4865.416150062015, 4938.25926111079, 4938.9012219755405, 4939.382577177853, 4946.035523073038, 4947.529984651453, 5495.148252020943, 5565.9721701392045, 5592.720363981866, 5596.496315331639, 5614.466625670555, 6598.670066496656, 6600.306967768412, 6604.207495100619, 6635.402813746786, 6653.068570400148, 1643.9178041097898, 1680.5126513311247, 1718.828117188271, 1745.1884873533868, 1745.4414587331933, 1108.2187058124002, 1111.5109351885144, 1115.938623375706, 1147.260017288844, 1152.815549512074, 6445.097686323825, 6462.289148193695, 6470.352964703586, 6478.319776423502, 6486.513511486657, 6860.211075726255, 6868.862622747617, 6874.9656251718425, 6884.621345826027, 6895.931040689529, 6453.515986301046, 6453.774117905851, 6456.063870738717, 6457.321981192001, 6466.805995820133, 3681.4477828325967, 3721.4975978243133, 3722.3485889969147, 3722.571904230994, 3730.757500762442, 7041.873300271932, 7099.929000709927, 7180.246074162138, 7184.389326907167, 7184.784456466315, 6939.444844412435, 6978.79063628092, 6987.441004719611, 6990.196127445409, 6990.650467476606, 7166.8208294792, 7178.820529486805, 7180.497365184387, 7181.964090179516, 7187.9936808846805, 6815.761448349284, 6820.761273355409, 6831.316868313129, 6855.828604284933, 6867.622280774605, 6678.532502724763, 6759.966200168968, 6788.49086318538, 6881.552699074544, 6905.413039891666, 7175.067241258603, 7234.710611575478, 7238.0, 7251.311125443285, 7255.129384473686, 4925.1381008324115, 4963.726995015309, 4969.130402179677, 4973.129702302011, 4978.8257410990445, 6676.065350850788, 6928.792136235719, 6928.861422771415, 6932.584044957319, 6935.375816176568, 6588.868222635616, 6757.831054223684, 6760.898586521108, 6773.085633439423, 6774.051632771515, 6714.3957043866285, 6751.966240168767, 6756.29058948823, 6762.594244345355, 6774.525783195326, 6650.600963941985, 6651.567648102858, 6651.900221496585, 6655.633940133339, 6664.166979127609, 6562.606243625398, 6744.898826517508, 6799.6600169990315, 6806.727730890709, 6816.693248803915, 6609.834754131185, 6629.2044954603825, 6639.336066393322, 6645.169353830771, 6652.0], "value": 5068.632573167933, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [852.4203541591716, 891.9866202006971, 906.7143849687349, 929.9209567186791, 944.7401964459777, 15323.616909577266, 15366.615834604154, 15430.151341676203, 15569.92215038926, 15659.295331710073, 14066.296685165726, 14219.644508887282, 14273.928630356859, 14281.78577321341, 14336.283185840692, 726.426123362543, 874.3835595904887, 877.7322916510461, 892.0945240580816, 897.0312062971975, 885.6147575804514, 888.1473785166248, 889.915458031486, 891.777055736066, 891.857302831547, 937.1144268666113, 938.0431959401407, 939.1876027236425, 939.4832841936908, 940.5344354544476, 757.0839284465776, 765.8238605120825, 928.9163975242261, 931.7065124485799, 942.9905700942971, 688.5249178067118, 689.1110467496923, 690.3579670906055, 691.1567887177636, 692.1417442371473, 14251.928740356232, 14277.071990320595, 14382.856171438256, 14437.205953672545, 14440.783388249185, 14422.0, 15157.166355850424, 15613.531594052196, 15645.295961681752, 15678.608034799106, 12274.938625306817, 12471.501139954391, 12545.811812822814, 12565.308908010056, 12663.746725065539, 4077.4699289092523, 4122.711410201287, 4146.502419709624, 4150.730202536825, 4174.457320548309, 59147.704261478415, 59168.70415647937, 59395.703021485046, 60771.392286077455, 61534.69232653808, 12300.507979680713, 12325.445354959049, 12390.380480975915, 12410.255384676948, 12467.812982805266, 21695.674564881538, 21744.89127554352, 21770.455738606346, 21785.782142178374, 21794.0, 8491.787705307417, 8598.742037738877, 8686.73939781795, 8691.652333906573, 8779.385443018928, 4879.609631229493, 5123.231515272739, 5170.71561064145, 5185.662931909414, 5270.578353731692, 3671.761335513183, 3753.943690844585, 3759.4924685167152, 3762.059485128718, 3768.0391500167284, 654.1006116589689, 662.3343539742624, 685.4893104637077, 688.2463702246033, 689.8585789913055, 697.8046147078826, 722.9481104992224, 767.244264399566, 836.3309352517962, 841.0748177005245, 9577.425354478753, 9579.473128977974, 9816.852747208797, 10169.745756356151, 10262.0, 698.3261152987392, 701.5825583777644, 737.7344156103799, 771.5756334016269, 833.7207035643006, 4399.912001760011, 4413.933790993137, 4469.173202957463, 4576.542345765397, 4583.9083218335445, 68251.3174868245, 68475.3152468479, 68540.6572967142, 68578.0, 68718.65640671765, 59542.404575954555, 60023.0, 60400.697996509734, 62290.0, 62467.0, 23547.529049418914, 23613.409664758517, 23748.52502949966, 41511.7924410376, 53949.1907621386, 8915.910840891767, 8991.91008089937, 9116.954415227881, 9179.541022948959, 9228.215601673934, 40378.59621403748, 40425.170238083054, 41001.58998409977, 42194.94512637086, 42417.0, 50737.492625073275, 52257.0, 52854.47145528649, 53008.20487692611, 53249.73375133255, 12491.87508124907, 12653.493860245855, 12736.872631273569, 12972.09195356316, 12992.740145197233, 12532.624021279376, 12556.37218139071, 13015.088943773844, 13296.667583310495, 13681.0, 12729.490820367082, 12848.678783030498, 13050.282234477196, 13162.736745265232, 13173.341332933507, 11334.659960201207, 11580.710482237675, 12296.342756447504, 12404.441800119197, 12419.565315213924, 12052.698682532657, 12198.939005304917, 12405.069619778373, 12411.565595204125, 12603.684907877376, 10363.430011349448, 10373.688789336333, 10551.94724026375, 10804.135669146606, 11327.32036077838, 10439.478026098514, 10649.094826939487, 10653.307535010199, 10659.25385223058, 10798.352098874093], "value": 7103.359822436679, "unit": "score"}], "name": "dromaeo_css", "value": 7466.770158587028, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 109.0, 110.0, 110.0, 109.0, 109.0, 105.0, 110.0, 110.0, 109.0], "value": 109.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 125.0, 151.0, 171.0, 126.0, 157.0, 160.0, 130.0, 183.0, 126.0], "value": 148.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 161.0, 163.0, 161.0, 162.0, 162.0, 159.0, 162.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 76.0, 75.0, 173.0, 77.0, 76.0, 76.0, 76.0, 167.0, 75.0], "value": 94.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 161.0, 92.0, 92.0, 93.0, 152.0, 91.0, 92.0, 154.0], "value": 111.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 144.0, 146.0, 145.0, 145.0, 145.0, 146.0, 146.0, 145.0, 146.0], "value": 145.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 54.0, 53.0, 54.0, 55.0, 57.0, 71.0, 53.0, 52.0], "value": 55.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 59.0, 60.0, 58.0, 58.0, 57.0, 58.0, 58.0, 58.0, 60.0], "value": 58.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 73.0, 70.0, 72.0, 73.0, 74.0, 72.0, 73.0, 73.0, 73.0], "value": 72.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 111.0, 112.0, 113.0, 115.0, 116.0, 112.0, 110.0, 126.0, 124.0], "value": 115.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 161.0, 159.0, 164.0, 159.0, 159.0, 158.0, 164.0, 157.0, 158.0], "value": 159.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 67.0, 66.0, 68.0, 66.0, 66.0, 66.0, 66.0, 67.0, 65.0], "value": 66.0, "unit": "score"}], "name": "kraken", "value": 1507.6000000000001, "alertThreshold": 2.0}]} 05:47:05 INFO - Return code: 0 05:47:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:47:05 ERROR - # TBPL SUCCESS # 05:47:05 INFO - Running post-action listener: _resource_record_post_action 05:47:05 INFO - Running post-run listener: _resource_record_post_run 05:47:06 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 424497152; Read time: 0; Write time: 355364 05:47:06 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 205340672; Read time: 0; Write time: 224028 05:47:06 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 0; Write bytes: 210178048; Read time: 0; Write time: 129248 05:47:06 INFO - Running post-run listener: _upload_blobber_files 05:47:06 INFO - Blob upload gear active. 05:47:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:47:06 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 05:47:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:47:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:47:06 INFO - (blobuploader) - INFO - Open directory for files ... 05:47:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:47:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:47:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:47:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:47:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:47:07 INFO - (blobuploader) - INFO - Done attempting. 05:47:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:47:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:47:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:47:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:47:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:47:08 INFO - (blobuploader) - INFO - Done attempting. 05:47:08 INFO - (blobuploader) - INFO - Iteration through files over. 05:47:08 INFO - Return code: 0 05:47:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:47:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:47:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3f84cab05c69cbd755652f2e8c03f57deeaedf1bc752a4f56dab0d44f441aaec9df4fcf2bc5d762ebabc953531665508ee3b860fb8e83c28e35acecfee59131e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1b0ff8eb4da12321c89d7bf8134d304d90d73fade2c0c2fbcd8394a3d75a4200db1a1b98d893b1bde6781d5fdb22f7d61845e24e450c8ea103509d48ad68aef2"} 05:47:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:47:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:47:08 INFO - Contents: 05:47:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3f84cab05c69cbd755652f2e8c03f57deeaedf1bc752a4f56dab0d44f441aaec9df4fcf2bc5d762ebabc953531665508ee3b860fb8e83c28e35acecfee59131e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1b0ff8eb4da12321c89d7bf8134d304d90d73fade2c0c2fbcd8394a3d75a4200db1a1b98d893b1bde6781d5fdb22f7d61845e24e450c8ea103509d48ad68aef2"} 05:47:08 INFO - Running post-run listener: copy_logs_to_upload_dir 05:47:08 INFO - Copying logs to upload dir... 05:47:08 INFO - mkdir: /builds/slave/test/build/upload/logs 05:47:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1226.286944 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-06-24 05:47:07.871523) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 05:47:07.875468) ========= 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=826874ccc97bd7bf541b4875000001d5-1466771199.893664-1481594588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3f84cab05c69cbd755652f2e8c03f57deeaedf1bc752a4f56dab0d44f441aaec9df4fcf2bc5d762ebabc953531665508ee3b860fb8e83c28e35acecfee59131e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1b0ff8eb4da12321c89d7bf8134d304d90d73fade2c0c2fbcd8394a3d75a4200db1a1b98d893b1bde6781d5fdb22f7d61845e24e450c8ea103509d48ad68aef2"} build_url:https://queue.taskcluster.net/v1/task/BMqUJOgkSLurfbV1jmhogg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011452 build_url: 'https://queue.taskcluster.net/v1/task/BMqUJOgkSLurfbV1jmhogg/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3f84cab05c69cbd755652f2e8c03f57deeaedf1bc752a4f56dab0d44f441aaec9df4fcf2bc5d762ebabc953531665508ee3b860fb8e83c28e35acecfee59131e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1b0ff8eb4da12321c89d7bf8134d304d90d73fade2c0c2fbcd8394a3d75a4200db1a1b98d893b1bde6781d5fdb22f7d61845e24e450c8ea103509d48ad68aef2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 05:47:07.902895) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 05:47:07.903513) ========= 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=826874ccc97bd7bf541b4875000001d5-1466771199.893664-1481594588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004519 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 05:47:07.956133) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 05:47:07.956714) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 05:47:07.957314) ========= ========= Total master_lag: 0.14 =========